[57.101632] Initializing watchdogs
[57.101678]   /dev/watchdog0
[57.116231] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.120806] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.123304] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.126710] [001/133] (960s left) api_intel_bb (simple-bb-ctx)
[57.204069] Starting subtest: simple-bb-ctx
[57.214980] Subtest simple-bb-ctx: SUCCESS (0.013s)
[57.333225] [002/133] (960s left) gem_ctx_persistence (engines-mixed)
[57.388807] Starting subtest: engines-mixed
[57.390765] Starting dynamic subtest: rcs0
[57.462184] Dynamic subtest rcs0: SUCCESS (0.076s)
[57.471903] Starting dynamic subtest: bcs0
[57.516585] Dynamic subtest bcs0: SUCCESS (0.054s)
[57.526077] Starting dynamic subtest: vcs0
[57.567237] Dynamic subtest vcs0: SUCCESS (0.051s)
[57.576280] Starting dynamic subtest: vcs1
[57.634969] Dynamic subtest vcs1: SUCCESS (0.067s)
[57.644955] Starting dynamic subtest: vecs0
[57.696477] Dynamic subtest vecs0: SUCCESS (0.062s)
[57.705146] Starting dynamic subtest: ccs0
[57.753041] Dynamic subtest ccs0: SUCCESS (0.056s)
[57.756107] Subtest engines-mixed: SUCCESS (0.369s)
[57.840136] [003/133] (959s left) kms_psr (fbc-psr2-primary-page-flip)
[57.942076] Starting subtest: fbc-psr2-primary-page-flip
[57.943691] Starting dynamic subtest: eDP-1
[57.947050] Dynamic subtest eDP-1: SKIP (0.000s)
[57.950657] Subtest fbc-psr2-primary-page-flip: SKIP (0.000s)
[58.019742] [004/133] (959s left) gem_mmap_gtt (hang-busy)
[58.075882] Subtest hang-busy: SKIP (0.000s)
[58.135509] [005/133] (959s left) gem_exec_schedule (preempt-engines)
[58.203847] Starting subtest: preempt-engines
[58.205817] Starting dynamic subtest: rcs0
[60.512613] Dynamic subtest rcs0: SUCCESS (2.325s)
[60.526304] Starting dynamic subtest: bcs0
[62.808924] Dynamic subtest bcs0: SUCCESS (2.300s)
[62.816247] Starting dynamic subtest: vcs0
[65.079971] Dynamic subtest vcs0: SUCCESS (2.279s)
[65.088913] Starting dynamic subtest: vcs1
[67.373111] Dynamic subtest vcs1: SUCCESS (2.298s)
[67.385254] Starting dynamic subtest: vecs0
[69.699548] Dynamic subtest vecs0: SUCCESS (2.328s)
[69.708900] Starting dynamic subtest: ccs0
[71.980047] Dynamic subtest ccs0: SUCCESS (2.282s)
[71.982565] Subtest preempt-engines: SUCCESS (13.818s)
[72.273860] [006/133] (945s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[72.397442] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[72.402163] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.002s)
[72.494870] [007/133] (945s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[72.599068] Starting subtest: fbcpsr-rgb565-draw-blt
[79.597083] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.005s)
[79.749661] [008/133] (938s left) i915_hangman (engine-error-state-capture)
[79.810769] Starting subtest: engine-error-state-capture
[79.812628] Starting dynamic subtest: rcs0
[82.868441] Dynamic subtest rcs0: SUCCESS (3.055s)
[82.878823] Starting dynamic subtest: bcs0
[88.882505] Dynamic subtest bcs0: SUCCESS (6.011s)
[88.893403] Starting dynamic subtest: vcs0
[94.836310] Dynamic subtest vcs0: SUCCESS (5.951s)
[94.847374] Starting dynamic subtest: vcs1
[100.851588] Dynamic subtest vcs1: SUCCESS (6.013s)
[100.862034] Starting dynamic subtest: vecs0
[106.803688] Dynamic subtest vecs0: SUCCESS (5.950s)
[106.814240] Starting dynamic subtest: ccs0
[111.859229] Dynamic subtest ccs0: SUCCESS (5.054s)
[111.861807] Subtest engine-error-state-capture: SUCCESS (32.040s)
[112.004210] [009/133] (905s left) kms_atomic_interruptible (legacy-setmode)
[112.099939] Starting subtest: legacy-setmode
[112.102356] Starting dynamic subtest: pipe-A-eDP-1
[118.975957] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.873s)
[118.978398] Subtest legacy-setmode: SUCCESS (6.874s)
[119.776603] [010/133] (898s left) sysfs_heartbeat_interval (mixed)
[119.831070] Starting subtest: mixed
[119.833278] Starting dynamic subtest: vecs0
[125.051053] Dynamic subtest vecs0: SUCCESS (5.221s)
[125.060504] Starting dynamic subtest: ccs0
[130.239642] Dynamic subtest ccs0: SUCCESS (5.186s)
[130.249466] Starting dynamic subtest: vcs0
[135.445203] Dynamic subtest vcs0: SUCCESS (5.205s)
[135.454764] Starting dynamic subtest: bcs0
[140.641705] Dynamic subtest bcs0: SUCCESS (5.195s)
[140.651704] Starting dynamic subtest: rcs0
[145.819049] Dynamic subtest rcs0: SUCCESS (5.176s)
[145.829378] Starting dynamic subtest: vcs1
[151.031528] Dynamic subtest vcs1: SUCCESS (5.211s)
[151.034247] Subtest mixed: SUCCESS (31.201s)
[151.108978] [011/133] (866s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[151.168769] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[151.238198] [012/133] (866s left) gem_exec_capture (capture)
[151.295070] Starting subtest: capture
[151.297225] Starting dynamic subtest: rcs0-smem
[152.128477] Dynamic subtest rcs0-smem: SUCCESS (0.833s)
[152.135841] Starting dynamic subtest: bcs0-smem
[153.193999] Dynamic subtest bcs0-smem: SUCCESS (1.063s)
[153.204261] Starting dynamic subtest: vcs0-smem
[154.018598] Dynamic subtest vcs0-smem: SUCCESS (0.826s)
[154.028734] Starting dynamic subtest: vcs1-smem
[154.838062] Dynamic subtest vcs1-smem: SUCCESS (0.819s)
[154.847168] Starting dynamic subtest: vecs0-smem
[156.236772] Dynamic subtest vecs0-smem: FAIL (1.339s)
[156.245529] Starting dynamic subtest: ccs0-smem
[157.501072] Dynamic subtest ccs0-smem: SUCCESS (1.322s)
[157.503274] Subtest capture: FAIL (6.204s)
[157.642737] [013/133] (860s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[157.759618] Starting subtest: addfb25-yf-tiled-legacy
[157.761966] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[157.866734] [014/133] (860s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[157.915821] Starting subtest: yf-tiled-to-vebox-y-tiled
[157.920344] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[158.093719] [015/133] (860s left) i915_drm_fdinfo (isolation)
[158.134669] Starting subtest: isolation
[158.136547] Starting dynamic subtest: rcs0
[158.148563] Dynamic subtest rcs0: SKIP (0.014s)
[158.157210] Starting dynamic subtest: bcs0
[158.163982] Dynamic subtest bcs0: SKIP (0.014s)
[158.173757] Starting dynamic subtest: vcs0
[158.177951] Dynamic subtest vcs0: SKIP (0.000s)
[158.185093] Starting dynamic subtest: vcs1
[158.189362] Dynamic subtest vcs1: SKIP (0.000s)
[158.196201] Starting dynamic subtest: vecs0
[158.200247] Dynamic subtest vecs0: SKIP (0.000s)
[158.206874] Starting dynamic subtest: ccs0
[158.210871] Dynamic subtest ccs0: SKIP (0.000s)
[158.215076] Subtest isolation: SKIP (0.031s)
[158.246586] [016/133] (859s left) kms_lease (simple-lease)
[158.341793] Starting subtest: simple-lease
[158.344191] Starting dynamic subtest: pipe-A-eDP-1
[158.870701] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.529s)
[158.878479] Starting dynamic subtest: pipe-B-eDP-1
[160.320447] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.448s)
[160.329664] Starting dynamic subtest: pipe-C-eDP-1
[161.715875] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.395s)
[161.725490] Starting dynamic subtest: pipe-D-eDP-1
[163.132449] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.415s)
[163.134930] Subtest simple-lease: SUCCESS (4.791s)
[163.938852] [017/133] (854s left) kms_scaling_modes (scaling-mode-full)
[164.040824] Starting subtest: scaling-mode-full
[164.043207] Starting dynamic subtest: pipe-A-eDP-1
[164.135611] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.096s)
[164.143156] Starting dynamic subtest: pipe-B-eDP-1
[165.274836] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.137s)
[165.283277] Starting dynamic subtest: pipe-C-eDP-1
[166.387637] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.110s)
[166.396484] Starting dynamic subtest: pipe-D-eDP-1
[167.523760] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s)
[167.525986] Subtest scaling-mode-full: SUCCESS (3.485s)
[168.682101] [018/133] (849s left) syncobj_wait (multi-wait-for-submit-submitted)
[168.733620] Starting subtest: multi-wait-for-submit-submitted
[168.841239] Subtest multi-wait-for-submit-submitted: SUCCESS (0.107s)
[168.925323] [019/133] (849s left) kms_addfb_basic (invalid-set-prop-any)
[168.977762] Starting subtest: invalid-set-prop-any
[168.980044] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[169.096500] [020/133] (849s left) kms_psr2_su (page_flip-nv12)
[169.142657] Subtest page_flip-NV12: SKIP (0.000s)
[169.204406] [021/133] (849s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[169.269578] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[169.337433] [022/133] (849s left) perf_pmu (all-busy-check-all)
[169.379954] Starting subtest: all-busy-check-all
[170.901588] Subtest all-busy-check-all: SUCCESS (1.521s)
[171.000345] [023/133] (847s left) kms_frontbuffer_tracking (fbc-1p-rte)
[171.100857] Starting subtest: fbc-1p-rte
[176.555599] Subtest fbc-1p-rte: SUCCESS (5.458s)
[177.678825] [024/133] (840s left) gem_eio (in-flight-external)
[177.883668] Starting subtest: in-flight-external
[178.961951] Subtest in-flight-external: SUCCESS (1.078s)
[179.109507] [025/133] (839s left) kms_addfb_basic (small-bo)
[179.207133] Starting subtest: small-bo
[179.209067] Subtest small-bo: SUCCESS (0.000s)
[179.299321] [026/133] (839s left) gem_ctx_exec (basic-close-race)
[179.378940] Starting subtest: basic-close-race
[185.208370] Subtest basic-close-race: SUCCESS (5.828s)
[185.327904] [027/133] (833s left) kms_cursor_crc (cursor-onscreen-128x42)
[185.563629] Starting subtest: cursor-onscreen-128x42
[185.613372] Subtest cursor-onscreen-128x42: SKIP (0.045s)
[185.866643] [028/133] (832s left) kms_cursor_crc (cursor-tearing-position-change)
[185.989635] Starting subtest: cursor-tearing-position-change
[185.991836] Starting dynamic subtest: pipe-A-eDP-1
[186.569574] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.578s)
[186.578918] Starting dynamic subtest: pipe-D-eDP-1
[187.797294] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.226s)
[187.799550] Subtest cursor-tearing-position-change: SUCCESS (1.807s)
[188.629910] [029/133] (830s left) kms_color (invalid-gamma-lut-sizes)
[188.718544] Starting subtest: invalid-gamma-lut-sizes
[188.720658] Starting dynamic subtest: pipe-A
[189.007520] Dynamic subtest pipe-A: SUCCESS (0.288s)
[189.016434] Starting dynamic subtest: pipe-B
[189.018608] Dynamic subtest pipe-B: SUCCESS (0.000s)
[189.026509] Starting dynamic subtest: pipe-C
[189.028657] Dynamic subtest pipe-C: SUCCESS (0.000s)
[189.036714] Starting dynamic subtest: pipe-D
[189.038850] Dynamic subtest pipe-D: SUCCESS (0.000s)
[189.041149] Subtest invalid-gamma-lut-sizes: SUCCESS (0.291s)
[189.853802] [030/133] (828s left) gem_exec_balancer (parallel-bb-first)
[190.107679] Starting subtest: parallel-bb-first
[191.041590] Subtest parallel-bb-first: SUCCESS (0.934s)
[191.929937] [031/133] (826s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[192.037209] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[192.041127] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[192.128082] [032/133] (826s left) kms_getfb (getfb-reject-nv12)
[192.213612] Starting subtest: getfb-reject-nv12
[192.215760] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[192.307157] [033/133] (826s left) gem_fenced_exec_thrash (2-spare-fences)
[192.374427] Subtest 2-spare-fences: SKIP (0.000s)
[192.439465] [034/133] (826s left) gem_exec_schedule (thriceslice)
[192.511583] Starting subtest: thriceslice
[192.513494] Starting dynamic subtest: rcs0
[192.554571] Dynamic subtest rcs0: SUCCESS (0.053s)
[192.565868] Starting dynamic subtest: bcs0
[192.586745] Dynamic subtest bcs0: SUCCESS (0.031s)
[192.594720] Starting dynamic subtest: vcs0
[192.637057] Dynamic subtest vcs0: SUCCESS (0.049s)
[192.648926] Starting dynamic subtest: vcs1
[192.666851] Dynamic subtest vcs1: SUCCESS (0.030s)
[192.674644] Starting dynamic subtest: vecs0
[192.695837] Dynamic subtest vecs0: SUCCESS (0.028s)
[192.704613] Starting dynamic subtest: ccs0
[192.725316] Dynamic subtest ccs0: SUCCESS (0.029s)
[192.727494] Subtest thriceslice: SUCCESS (0.225s)
[193.912402] [035/133] (825s left) kms_draw_crc (draw-method-mmap-wc)
[194.003910] Starting subtest: draw-method-mmap-wc
[194.005751] Starting dynamic subtest: xrgb8888-untiled
[194.268401] Dynamic subtest xrgb8888-untiled: SUCCESS (0.266s)
[194.276548] Starting dynamic subtest: rgb565-untiled
[194.524038] Dynamic subtest rgb565-untiled: SUCCESS (0.255s)
[194.533433] Starting dynamic subtest: xrgb2101010-untiled
[194.746827] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[194.760582] Starting dynamic subtest: xbgr16161616f-untiled
[194.979155] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.232s)
[194.987575] Starting dynamic subtest: xrgb8888-xtiled
[195.101467] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[195.112229] Starting dynamic subtest: rgb565-xtiled
[195.268151] Dynamic subtest rgb565-xtiled: SUCCESS (0.164s)
[195.276687] Starting dynamic subtest: xrgb2101010-xtiled
[195.401440] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.133s)
[195.410070] Starting dynamic subtest: xbgr16161616f-xtiled
[195.534725] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[195.542781] Starting dynamic subtest: xrgb8888-4tiled
[195.701485] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.166s)
[195.710536] Starting dynamic subtest: rgb565-4tiled
[195.856930] Dynamic subtest rgb565-4tiled: SUCCESS (0.155s)
[195.864881] Starting dynamic subtest: xrgb2101010-4tiled
[196.023688] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.166s)
[196.032740] Starting dynamic subtest: xbgr16161616f-4tiled
[196.212761] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.188s)
[196.214682] Subtest draw-method-mmap-wc: SUCCESS (2.212s)
[196.304946] [036/133] (822s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[196.391288] Starting subtest: nonblocking-crc-frame-sequence
[196.392924] Starting dynamic subtest: pipe-A-eDP-1
[197.146186] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.754s)
[197.155665] Starting dynamic subtest: pipe-B-eDP-1
[198.627196] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.479s)
[198.636802] Starting dynamic subtest: pipe-C-eDP-1
[199.953242] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.324s)
[199.963254] Starting dynamic subtest: pipe-D-eDP-1
[201.296859] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.343s)
[201.299122] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.906s)
[202.092053] [037/133] (816s left) kms_pm_rpm (system-suspend-modeset)
[204.128038] Starting subtest: system-suspend-modeset
[223.653658] Subtest system-suspend-modeset: SUCCESS (4.756s)
[224.016221] [038/133] (795s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[224.074595] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[224.076899] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[224.169455] [039/133] (794s left) gem_watchdog (default-virtual)
[224.236993] Starting subtest: default-virtual
[230.506197] Subtest default-virtual: SUCCESS (6.377s)
[230.587086] [040/133] (788s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[230.681080] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[230.685351] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[230.769788] [041/133] (788s left) gem_eio (wait-10ms)
[230.953392] Starting subtest: wait-10ms
[231.227506] Subtest wait-10ms: SUCCESS (0.277s)
[231.382789] [042/133] (787s left) kms_rotation_crc (bad-pixel-format)
[231.474987] Starting subtest: bad-pixel-format
[231.479351] Subtest bad-pixel-format: SKIP (0.001s)
[231.545784] [043/133] (787s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[231.639258] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[231.642889] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[231.741349] [044/133] (787s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[231.833275] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[231.835164] Starting dynamic subtest: pipe-A-eDP-1
[231.932054] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[231.941459] Starting dynamic subtest: pipe-B-eDP-1
[233.060536] Dynamic subtest pipe-B-eDP-1: SKIP (1.134s)
[233.065170] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.236s)
[234.226401] [045/133] (785s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[234.331576] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[234.335872] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[234.430753] [046/133] (784s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[234.549283] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[234.553588] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[234.640602] [047/133] (784s left) gem_mmap_wc (close)
[234.700178] Subtest close: SKIP (0.000s)
[234.766826] [048/133] (784s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[234.874887] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[234.879089] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[234.968101] [049/133] (784s left) kms_vrr (lobf)
[235.057353] Starting subtest: lobf
[235.061744] Subtest lobf: SKIP (0.000s)
[235.141067] [050/133] (784s left) syncobj_wait (wait-all-delayed-signal)
[235.201359] Starting subtest: wait-all-delayed-signal
[235.305573] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[235.386612] [051/133] (784s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[235.500331] Starting subtest: short-flip-after-cursor-toggle
[236.421569] Subtest short-flip-after-cursor-toggle: SUCCESS (0.925s)
[237.246448] [052/133] (782s left) kms_flip (2x-flip-vs-expired-vblank)
[237.332081] Starting subtest: 2x-flip-vs-expired-vblank
[237.343189] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[237.420591] [053/133] (782s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[237.476931] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[237.542649] [054/133] (782s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[237.638058] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[244.962707] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.349s)
[245.086527] [055/133] (774s left) gem_render_copy (linear-to-vebox-y-tiled)
[245.146052] Starting subtest: linear-to-vebox-y-tiled
[245.150390] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[245.326308] [056/133] (774s left) prime_vgem (basic-write)
[245.458211] Starting subtest: basic-write
[245.472057] Subtest basic-write: SKIP (0.015s)
[245.583414] [FACT prime_vgem (basic-write)] new: kernel.kmod_is_loaded.vgem: true
[245.586978] [057/133] (774s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[245.681164] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[245.685549] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[245.780941] [058/133] (774s left) kms_pm_dc (dc5-psr)
[246.884801] Starting subtest: dc5-psr
[249.763526] Subtest dc5-psr: SUCCESS (2.883s)
[250.582281] [059/133] (769s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[250.687567] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[250.691893] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[250.767055] [060/133] (769s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[250.861027] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[250.863256] Starting dynamic subtest: pipe-A-eDP-1
[267.365114] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.456s)
[267.376524] Starting dynamic subtest: pipe-B-eDP-1
[284.309159] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.437s)
[284.319204] Starting dynamic subtest: pipe-C-eDP-1
[301.301534] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.466s)
[301.311140] Starting dynamic subtest: pipe-D-eDP-1
[318.295947] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.385s)
[318.298281] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.749s)
[319.494891] [061/133] (700s left) gem_ctx_shared (single-timeline)
[319.560857] Starting subtest: single-timeline
[319.582426] Subtest single-timeline: SUCCESS (0.015s)
[319.815271] [062/133] (700s left) kms_cursor_crc (cursor-size-hints)
[319.939974] Starting subtest: cursor-size-hints
[319.942182] Starting dynamic subtest: pipe-A-eDP-1
[320.550804] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.623s)
[320.561464] Starting dynamic subtest: pipe-D-eDP-1
[321.822067] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.297s)
[321.824720] Subtest cursor-size-hints: SUCCESS (1.923s)
[322.622995] [063/133] (697s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[322.721954] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[322.726236] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[322.816888] [064/133] (697s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[322.916375] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[322.920415] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[323.044611] [065/133] (697s left) gem_eio (in-flight-internal-immediate)
[323.236207] Starting subtest: in-flight-internal-immediate
[324.659320] Subtest in-flight-internal-immediate: SUCCESS (1.441s)
[324.776884] [066/133] (695s left) gem_exec_reloc (basic-write-read-noreloc)
[324.840423] Subtest basic-write-read-noreloc: SKIP (0.000s)
[324.903932] [067/133] (695s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[324.951945] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[325.052391] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.102s)
[325.125116] [068/133] (695s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[325.212729] Starting subtest: fbc-dirtyfb-ioctl
[325.214895] Starting dynamic subtest: A-eDP-1
[327.849427] Dynamic subtest A-eDP-1: SUCCESS (2.663s)
[327.851642] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.665s)
[328.704076] [069/133] (691s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[328.799724] Starting subtest: pr-overlay-plane-update-continuous-sf
[328.804185] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[328.868109] [070/133] (691s left) kms_invalid_mode (clock-too-high)
[328.966535] Starting subtest: clock-too-high
[328.968714] Starting dynamic subtest: pipe-A-eDP-1
[328.972856] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[328.982554] Starting dynamic subtest: pipe-B-eDP-1
[328.986798] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[328.996301] Starting dynamic subtest: pipe-C-eDP-1
[329.000213] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[329.010983] Starting dynamic subtest: pipe-D-eDP-1
[329.014881] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[329.018700] Subtest clock-too-high: SKIP (0.005s)
[329.055318] [071/133] (691s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[329.158818] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[329.161098] Starting dynamic subtest: pipe-A-eDP-1
[329.182632] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[329.194398] Starting dynamic subtest: pipe-B-eDP-1
[329.214099] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[329.222798] Starting dynamic subtest: pipe-C-eDP-1
[329.243408] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[329.252259] Starting dynamic subtest: pipe-D-eDP-1
[329.273772] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[329.278108] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[331.449477] [072/133] (688s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[331.504405] Subtest writes-after-reads-uncached: SKIP (0.000s)
[331.570659] [073/133] (688s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[331.664852] Starting subtest: primary-y-tiled-reflect-x-90
[331.669366] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[331.739002] [074/133] (688s left) prime_mmap (test_errors)
[331.793223] Starting subtest: test_errors
[331.795370] Starting dynamic subtest: test_errors-smem
[331.894364] Dynamic subtest test_errors-smem: SUCCESS (0.103s)
[331.897155] Subtest test_errors: SUCCESS (0.104s)
[331.994063] [075/133] (688s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[332.084083] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[338.840131] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.782s)
[338.998034] [076/133] (681s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[339.057045] Starting subtest: legacy-engines-hostile-preempt
[339.059336] Starting dynamic subtest: render
[339.144343] Dynamic subtest render: SUCCESS (0.087s)
[339.157122] Starting dynamic subtest: bsd1
[340.573682] Dynamic subtest bsd1: SUCCESS (1.428s)
[340.584672] Starting dynamic subtest: bsd2
[342.585080] Dynamic subtest bsd2: SUCCESS (2.012s)
[342.597370] Starting dynamic subtest: blt
[342.645071] Dynamic subtest blt: SUCCESS (0.058s)
[342.656081] Starting dynamic subtest: vebox
[344.622987] Dynamic subtest vebox: SUCCESS (1.978s)
[344.625626] Subtest legacy-engines-hostile-preempt: SUCCESS (5.575s)
[344.715386] [077/133] (675s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[344.813525] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[351.462390] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.654s)
[351.587505] [078/133] (669s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[351.689845] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[351.692014] Starting dynamic subtest: pipe-A-eDP-1
[351.712174] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[351.723760] Starting dynamic subtest: pipe-B-eDP-1
[351.741958] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[351.751563] Starting dynamic subtest: pipe-C-eDP-1
[351.770030] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[351.778843] Starting dynamic subtest: pipe-D-eDP-1
[351.797724] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[351.799940] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[353.916576] [079/133] (666s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[354.013867] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[354.017949] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[354.106153] [080/133] (666s left) kms_psr (psr2-sprite-mmap-gtt)
[354.201541] Starting subtest: psr2-sprite-mmap-gtt
[354.203964] Starting dynamic subtest: eDP-1
[355.626944] Dynamic subtest eDP-1: SKIP (1.422s)
[355.631623] Subtest psr2-sprite-mmap-gtt: SKIP (1.424s)
[355.762133] [081/133] (665s left) kms_psr (psr2-cursor-mmap-cpu)
[355.859554] Starting subtest: psr2-cursor-mmap-cpu
[355.861677] Starting dynamic subtest: eDP-1
[357.536923] Dynamic subtest eDP-1: SUCCESS (1.675s)
[357.539212] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.676s)
[358.420257] [082/133] (662s left) gem_mmap_wc (bad-size)
[358.476097] Subtest bad-size: SKIP (0.000s)
[358.539214] [083/133] (662s left) gem_exec_whisper (basic-fds-all)
[358.604540] Starting subtest: basic-fds-all
[370.585679] Subtest basic-fds-all: SUCCESS (11.976s)
[370.773215] [084/133] (650s left) gem_spin_batch (spin-all-new)
[370.846490] Starting subtest: spin-all-new
[370.870802] Subtest spin-all-new: SUCCESS (0.024s)
[372.657891] [085/133] (648s left) kms_plane_lowres (tiling-4)
[372.750729] Starting subtest: tiling-4
[372.752894] Starting dynamic subtest: pipe-A-eDP-1
[372.757076] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[373.064296] Starting dynamic subtest: pipe-B-eDP-1
[373.069054] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[373.078305] Starting dynamic subtest: pipe-C-eDP-1
[373.082661] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[373.091830] Starting dynamic subtest: pipe-D-eDP-1
[373.096149] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[373.100167] Subtest tiling-4: SKIP (0.309s)
[373.862954] [086/133] (647s left) gem_exec_await (wide-all)
[374.110668] Starting subtest: wide-all
[397.496496] Subtest wide-all: SUCCESS (23.390s)
[397.693612] [087/133] (623s left) gem_exec_gttfill (engines)
[397.793339] Starting subtest: engines
[397.795677] Starting dynamic subtest: rcs0
[421.091842] Dynamic subtest rcs0: SUCCESS (23.299s)
[421.103369] Starting dynamic subtest: bcs0
[444.471197] Dynamic subtest bcs0: SUCCESS (23.372s)
[444.481487] Starting dynamic subtest: vcs0
[467.815568] Dynamic subtest vcs0: SUCCESS (23.344s)
[467.829999] Starting dynamic subtest: vcs1
[491.226064] Dynamic subtest vcs1: SUCCESS (23.411s)
[491.236708] Starting dynamic subtest: vecs0
[514.621075] Dynamic subtest vecs0: SUCCESS (23.398s)
[514.634552] Starting dynamic subtest: ccs0
[538.059830] Dynamic subtest ccs0: SUCCESS (23.443s)
[538.062113] Subtest engines: SUCCESS (140.280s)
[538.252858] [088/133] (482s left) gem_pipe_control_store_loop (reused-buffer)
[538.350353] Starting subtest: reused-buffer
[540.506618] Subtest reused-buffer: SUCCESS (2.155s)
[540.652972] [089/133] (480s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[540.764456] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[540.768486] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[540.886590] [090/133] (480s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[540.948229] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[541.053414] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.103s)
[541.129293] [091/133] (480s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[541.219311] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[541.221589] Starting dynamic subtest: A-eDP1
[544.874111] Dynamic subtest A-eDP1: SUCCESS (3.649s)
[544.891277] Starting dynamic subtest: B-eDP1
[548.056961] Dynamic subtest B-eDP1: SUCCESS (3.182s)
[548.067762] Starting dynamic subtest: C-eDP1
[551.154489] Dynamic subtest C-eDP1: SUCCESS (3.093s)
[551.165179] Starting dynamic subtest: D-eDP1
[554.275872] Dynamic subtest D-eDP1: SUCCESS (3.121s)
[554.278154] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.053s)
[555.080337] [092/133] (466s left) gen9_exec_parse (bb-start-cmd)
[555.139460] Subtest bb-start-cmd: SKIP (0.000s)
[555.215049] [093/133] (466s left) kms_sequence (get-busy)
[555.306530] Starting subtest: get-busy
[555.308843] Starting dynamic subtest: pipe-A-eDP-1
[557.254294] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.947s)
[557.264635] Starting dynamic subtest: pipe-B-eDP-1
[559.891979] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.633s)
[559.908101] Starting dynamic subtest: pipe-C-eDP-1
[562.503762] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.611s)
[562.514892] Starting dynamic subtest: pipe-D-eDP-1
[565.161965] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.658s)
[565.164746] Subtest get-busy: SUCCESS (9.855s)
[566.003265] [094/133] (455s left) fbdev (info)
[566.045496] Starting subtest: info
[566.047837] Subtest info: SUCCESS (0.000s)
[566.132981] [095/133] (455s left) gem_tiled_fence_blits (basic)
[566.203288] Subtest basic: SKIP (0.000s)
[566.277492] [096/133] (455s left) gem_exec_reloc (basic-cpu-noreloc)
[566.338761] Subtest basic-cpu-noreloc: SKIP (0.000s)
[566.416117] [097/133] (455s left) kms_chamelium_color (ctm-limited-range)
[566.517310] Subtest ctm-limited-range: SKIP (0.000s)
[566.563104] [098/133] (454s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[566.672395] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[567.328846] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.659s)
[567.514109] [099/133] (454s left) kms_chamelium_hpd (vga-hpd-fast)
[567.895535] Subtest vga-hpd-fast: SKIP (0.000s)
[568.718229] [100/133] (452s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[568.832446] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[568.844811] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.011s)
[568.925228] [101/133] (452s left) kms_plane (plane-position-hole-dpms)
[569.022897] Starting subtest: plane-position-hole-dpms
[569.564877] Starting dynamic subtest: pipe-A-plane-1
[571.957441] Dynamic subtest pipe-A-plane-1: SUCCESS (2.391s)
[571.970088] Starting dynamic subtest: pipe-A-plane-2
[574.386136] Dynamic subtest pipe-A-plane-2: SUCCESS (2.428s)
[574.396998] Starting dynamic subtest: pipe-A-plane-3
[576.756152] Dynamic subtest pipe-A-plane-3: SUCCESS (2.366s)
[576.768850] Starting dynamic subtest: pipe-A-plane-4
[579.112904] Dynamic subtest pipe-A-plane-4: SUCCESS (2.358s)
[579.123562] Starting dynamic subtest: pipe-A-plane-5
[579.140834] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[580.288558] Starting dynamic subtest: pipe-B-plane-1
[582.732881] Dynamic subtest pipe-B-plane-1: SUCCESS (2.454s)
[582.743778] Starting dynamic subtest: pipe-B-plane-2
[585.089043] Dynamic subtest pipe-B-plane-2: SUCCESS (2.355s)
[585.100070] Starting dynamic subtest: pipe-B-plane-3
[587.445491] Dynamic subtest pipe-B-plane-3: SUCCESS (2.354s)
[587.456057] Starting dynamic subtest: pipe-B-plane-4
[589.791863] Dynamic subtest pipe-B-plane-4: SUCCESS (2.345s)
[589.804569] Starting dynamic subtest: pipe-B-plane-5
[589.818079] Dynamic subtest pipe-B-plane-5: SUCCESS (0.026s)
[589.820324] Subtest plane-position-hole-dpms: SUCCESS (20.792s)
[590.607214] [102/133] (431s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[590.710226] Starting subtest: fbcpsr-suspend
[631.696008] Subtest fbcpsr-suspend: SUCCESS (10.068s)
[631.846403] [103/133] (389s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[631.940143] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[631.944517] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[633.088320] [104/133] (388s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[633.149805] Starting subtest: single-wait-all-for-submit-signaled
[633.152683] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[633.251044] [105/133] (388s left) i915_pm_rpm (reg-read-ioctl)
[634.778811] Starting subtest: reg-read-ioctl
[637.053527] Subtest reg-read-ioctl: SUCCESS (2.305s)
[637.431538] [106/133] (384s left) api_intel_allocator (fork-simple-stress-signal)
[637.504853] Starting subtest: fork-simple-stress-signal
[642.867599] Subtest fork-simple-stress-signal: SUCCESS (5.403s)
[642.985619] [107/133] (378s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[643.079918] Starting subtest: plane-upscale-20x20-with-pixel-format
[643.082852] Starting dynamic subtest: pipe-A
[644.122349] Dynamic subtest pipe-A: SUCCESS (1.050s)
[644.132364] Starting dynamic subtest: pipe-B
[646.262294] Dynamic subtest pipe-B: SUCCESS (2.146s)
[646.272705] Starting dynamic subtest: pipe-C
[647.458976] Dynamic subtest pipe-C: SUCCESS (1.199s)
[647.469785] Starting dynamic subtest: pipe-D
[648.692735] Dynamic subtest pipe-D: SUCCESS (1.236s)
[648.695455] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.636s)
[649.879389] [108/133] (372s left) kms_flip (bo-too-big-interruptible)
[649.982985] Starting subtest: bo-too-big-interruptible
[649.985453] Starting dynamic subtest: A-eDP1
[651.236255] Dynamic subtest A-eDP1: SUCCESS (1.256s)
[651.248842] Starting dynamic subtest: B-eDP1
[652.473962] Dynamic subtest B-eDP1: SUCCESS (1.239s)
[652.485712] Starting dynamic subtest: C-eDP1
[653.718812] Dynamic subtest C-eDP1: SUCCESS (1.246s)
[653.730660] Starting dynamic subtest: D-eDP1
[655.054871] Dynamic subtest D-eDP1: SUCCESS (1.337s)
[655.061037] Subtest bo-too-big-interruptible: SUCCESS (5.087s)
[656.251815] [109/133] (365s left) perf_pmu (most-busy-check-all)
[656.307037] Starting subtest: most-busy-check-all
[656.309756] Starting dynamic subtest: rcs0
[657.630555] Dynamic subtest rcs0: SUCCESS (1.323s)
[657.643038] Starting dynamic subtest: bcs0
[659.614513] Dynamic subtest bcs0: SUCCESS (1.983s)
[659.628636] Starting dynamic subtest: vcs0
[661.600373] Dynamic subtest vcs0: SUCCESS (1.981s)
[661.614833] Starting dynamic subtest: vcs1
[663.647150] Dynamic subtest vcs1: SUCCESS (2.042s)
[663.661031] Starting dynamic subtest: vecs0
[665.630646] Dynamic subtest vecs0: SUCCESS (1.979s)
[665.644795] Starting dynamic subtest: ccs0
[667.614397] Dynamic subtest ccs0: SUCCESS (1.980s)
[667.617403] Subtest most-busy-check-all: SUCCESS (11.304s)
[667.719981] [110/133] (354s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[667.778535] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[667.781457] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[667.879259] [111/133] (354s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[667.991017] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[668.793792] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.804s)
[668.994695] [112/133] (353s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[669.116440] Starting subtest: flip-vs-cursor-atomic-transitions
[676.713966] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.595s)
[677.583381] [113/133] (344s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[677.679777] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[677.682358] Starting dynamic subtest: pipe-A-default-mode
[678.839647] Dynamic subtest pipe-A-default-mode: SKIP (1.158s)
[678.844803] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.160s)
[678.995636] [114/133] (343s left) gem_lmem_swapping (parallel-multi)
[679.042746] Subtest parallel-multi: SKIP (0.000s)
[679.082593] [115/133] (343s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[679.148397] Starting subtest: invalid-single-wait-all-unsubmitted
[679.150791] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[679.246433] [116/133] (343s left) kms_plane (pixel-format-y-tiled-ccs-modifier)
[679.337190] Starting subtest: pixel-format-y-tiled-ccs-modifier
[679.341472] Subtest pixel-format-y-tiled-ccs-modifier: SKIP (0.000s)
[679.421598] [117/133] (342s left) dmabuf_sync_file (export-basic)
[679.473449] Starting subtest: export-basic
[679.475888] Subtest export-basic: SUCCESS (0.001s)
[679.530571] [118/133] (342s left) gem_exec_create (basic)
[679.589444] Starting subtest: basic
[679.591857] Starting dynamic subtest: smem
[681.675327] Dynamic subtest smem: SUCCESS (2.088s)
[681.678288] Subtest basic: SUCCESS (2.089s)
[681.865961] [119/133] (340s left) kms_async_flips (test-cursor-atomic)
[681.959749] Starting subtest: test-cursor-atomic
[682.347459] Starting dynamic subtest: pipe-A-eDP-1
[683.094258] Dynamic subtest pipe-A-eDP-1: SKIP (0.745s)
[683.483563] Starting dynamic subtest: pipe-B-eDP-1
[684.234725] Dynamic subtest pipe-B-eDP-1: SKIP (0.753s)
[684.605173] Starting dynamic subtest: pipe-C-eDP-1
[685.355198] Dynamic subtest pipe-C-eDP-1: SKIP (0.753s)
[685.713449] Starting dynamic subtest: pipe-D-eDP-1
[686.482907] Dynamic subtest pipe-D-eDP-1: SKIP (0.773s)
[686.487973] Subtest test-cursor-atomic: SKIP (4.521s)
[687.668622] [120/133] (334s left) kms_vblank (wait-busy-hang)
[687.783608] Starting subtest: wait-busy-hang
[687.786167] Starting dynamic subtest: pipe-A-eDP-1
[714.409041] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.630s)
[714.426016] Starting dynamic subtest: pipe-D-eDP-1
[729.451003] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.041s)
[729.453718] Subtest wait-busy-hang: SUCCESS (41.675s)
[730.241878] [121/133] (292s left) prime_vgem (coherency-blt)
[730.316111] Starting subtest: coherency-blt
[731.438515] Subtest coherency-blt: SUCCESS (1.121s)
[731.568387] [122/133] (290s left) kms_chamelium_color (gamma)
[731.664659] Subtest gamma: SKIP (0.000s)
[731.710532] [123/133] (290s left) kms_flip (flip-vs-blocking-wf-vblank)
[731.812933] Starting subtest: flip-vs-blocking-wf-vblank
[731.815749] Starting dynamic subtest: A-eDP1
[740.706417] Dynamic subtest A-eDP1: SUCCESS (8.893s)
[740.717972] Starting dynamic subtest: B-eDP1
[749.639634] Dynamic subtest B-eDP1: SUCCESS (8.931s)
[749.650139] Starting dynamic subtest: C-eDP1
[758.548858] Dynamic subtest C-eDP1: SUCCESS (8.906s)
[758.560811] Starting dynamic subtest: D-eDP1
[767.478179] Dynamic subtest D-eDP1: SUCCESS (8.926s)
[767.480991] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.668s)
[768.713136] [124/133] (253s left) i915_pm_sseu (full-enable)
[768.766915] Subtest full-enable: SKIP (0.000s)
[768.857797] [125/133] (253s left) kms_content_protection (atomic)
[768.992937] Starting subtest: atomic
[768.997733] Subtest atomic: SKIP (0.000s)
[769.119604] [126/133] (253s left) kms_big_fb (x-tiled-addfb-size-overflow)
[769.212111] Starting subtest: x-tiled-addfb-size-overflow
[769.214896] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[769.308186] [127/133] (253s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[769.398985] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[769.403284] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[769.474112] [128/133] (253s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[769.562514] Starting subtest: fbc-psr-cursor-mmap-gtt
[769.564892] Starting dynamic subtest: eDP-1
[769.569995] Dynamic subtest eDP-1: SKIP (0.000s)
[769.574993] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[769.636072] [129/133] (253s left) gem_lmem_swapping (verify-ccs)
[769.678680] Subtest verify-ccs: SKIP (0.000s)
[769.727700] [130/133] (253s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[769.851415] Starting subtest: 2x-cursor-vs-flip-legacy
[769.855379] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[770.002798] [131/133] (252s left) gem_mmap_wc (write-read)
[770.052147] Subtest write-read: SKIP (0.000s)
[770.119315] [132/133] (252s left) gem_exec_fence (syncobj-invalid-flags)
[770.570491] Starting subtest: syncobj-invalid-flags
[770.573138] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[771.709854] [133/133] (251s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[771.806608] Starting subtest: psr-rgb101010-draw-pwrite
[779.489526] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.687s)
[779.588877] Closing watchdogs
results: parsing output: 0/ for test: api_intel_bb
results: parsing output: 1/ for test: gem_ctx_persistence
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: gem_mmap_gtt
results: parsing output: 4/ for test: gem_exec_schedule
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: i915_hangman
results: parsing output: 8/ for test: kms_atomic_interruptible
results: parsing output: 9/ for test: sysfs_heartbeat_interval
results: parsing output: 10/ for test: gem_exec_reloc
results: parsing output: 11/ for test: gem_exec_capture
results: parsing output: 12/ for test: kms_addfb_basic
results: parsing output: 13/ for test: gem_render_copy
results: parsing output: 14/ for test: i915_drm_fdinfo
results: parsing output: 15/ for test: kms_lease
results: parsing output: 16/ for test: kms_scaling_modes
results: parsing output: 17/ for test: syncobj_wait
results: parsing output: 18/ for test: kms_addfb_basic
results: parsing output: 19/ for test: kms_psr2_su
results: parsing output: 20/ for test: gem_exec_reloc
results: parsing output: 21/ for test: perf_pmu
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_eio
results: parsing output: 24/ for test: kms_addfb_basic
results: parsing output: 25/ for test: gem_ctx_exec
results: parsing output: 26/ for test: kms_cursor_crc
results: parsing output: 27/ for test: kms_cursor_crc
results: parsing output: 28/ for test: kms_color
results: parsing output: 29/ for test: gem_exec_balancer
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_getfb
results: parsing output: 32/ for test: gem_fenced_exec_thrash
results: parsing output: 33/ for test: gem_exec_schedule
results: parsing output: 34/ for test: kms_draw_crc
results: parsing output: 35/ for test: kms_pipe_crc_basic
results: parsing output: 36/ for test: kms_pm_rpm
results: parsing output: 37/ for test: syncobj_wait
results: parsing output: 38/ for test: gem_watchdog
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_eio
results: parsing output: 41/ for test: kms_rotation_crc
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: kms_psr2_sf
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_mmap_wc
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_vrr
results: parsing output: 49/ for test: syncobj_wait
results: parsing output: 50/ for test: kms_cursor_legacy
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: gem_exec_reloc
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_render_copy
results: parsing output: 55/ for test: prime_vgem
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_pm_dc
results: parsing output: 58/ for test: kms_flip_scaled_crc
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: gem_ctx_shared
results: parsing output: 61/ for test: kms_cursor_crc
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_eio
results: parsing output: 65/ for test: gem_exec_reloc
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: kms_dirtyfb
results: parsing output: 68/ for test: kms_psr2_sf
results: parsing output: 69/ for test: kms_invalid_mode
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: gem_partial_pwrite_pread
results: parsing output: 72/ for test: kms_rotation_crc
results: parsing output: 73/ for test: prime_mmap
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_ctx_persistence
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: gem_mmap_wc
results: parsing output: 82/ for test: gem_exec_whisper
results: parsing output: 83/ for test: gem_spin_batch
results: parsing output: 84/ for test: kms_plane_lowres
results: parsing output: 85/ for test: gem_exec_await
results: parsing output: 86/ for test: gem_exec_gttfill
results: parsing output: 87/ for test: gem_pipe_control_store_loop
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: kms_flip
results: parsing output: 91/ for test: gen9_exec_parse
results: parsing output: 92/ for test: kms_sequence
results: parsing output: 93/ for test: fbdev
results: parsing output: 94/ for test: gem_tiled_fence_blits
results: parsing output: 95/ for test: gem_exec_reloc
results: parsing output: 96/ for test: kms_chamelium_color
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_chamelium_hpd
results: parsing output: 99/ for test: kms_flip
results: parsing output: 100/ for test: kms_plane
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: i915_pm_rpm
results: parsing output: 105/ for test: api_intel_allocator
results: parsing output: 106/ for test: kms_plane_scaling
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: perf_pmu
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: kms_flip_scaled_crc
results: parsing output: 113/ for test: gem_lmem_swapping
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: kms_plane
results: parsing output: 116/ for test: dmabuf_sync_file
results: parsing output: 117/ for test: gem_exec_create
results: parsing output: 118/ for test: kms_async_flips
results: parsing output: 119/ for test: kms_vblank
results: parsing output: 120/ for test: prime_vgem
results: parsing output: 121/ for test: kms_chamelium_color
results: parsing output: 122/ for test: kms_flip
results: parsing output: 123/ for test: i915_pm_sseu
results: parsing output: 124/ for test: kms_content_protection
results: parsing output: 125/ for test: kms_big_fb
results: parsing output: 126/ for test: kms_flip_scaled_crc
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: gem_lmem_swapping
results: parsing output: 129/ for test: kms_cursor_legacy
results: parsing output: 130/ for test: gem_mmap_wc
results: parsing output: 131/ for test: gem_exec_fence
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.