[62.235282] Initializing watchdogs
[62.235359]   /dev/watchdog0
[62.249685] [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]
[62.254628] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.256876] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.260328] [001/133] (960s left) syncobj_timeline (wait-all-delayed-signal)
[62.337846] Starting subtest: wait-all-delayed-signal
[62.440716] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[62.527670] [002/133] (960s left) gem_create (busy-create)
[62.583241] Starting subtest: busy-create
[62.585504] Starting dynamic subtest: smem0
[95.894493] Dynamic subtest smem0: SUCCESS (33.306s)
[95.896919] Subtest busy-create: SUCCESS (33.307s)
[96.097741] [003/133] (926s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[96.225868] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[118.804614] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.581s)
[118.979906] [004/133] (903s left) gem_lmem_swapping (heavy-verify-random)
[119.029564] Subtest heavy-verify-random: SKIP (0.000s)
[119.066289] [005/133] (903s left) gem_exec_balancer (persistence)
[119.322861] Starting subtest: persistence
[120.203105] Subtest persistence: SUCCESS (0.879s)
[120.334710] [006/133] (902s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[120.445430] Starting subtest: yf-tiled-32bpp-rotate-90
[120.449674] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[120.553177] [007/133] (902s left) gem_exec_fence (syncobj-timeline-unused-fence)
[121.131042] Starting subtest: syncobj-timeline-unused-fence
[121.133186] Subtest syncobj-timeline-unused-fence: SUCCESS (0.007s)
[122.971973] [FACT gem_exec_fence (syncobj-timeline-unused-fence)] new: kernel.kmod_is_loaded.vgem: true
[122.975267] [008/133] (900s left) gem_mmap_wc (write-read)
[123.037287] Subtest write-read: SKIP (0.000s)
[123.107530] [009/133] (899s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[123.210305] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[130.144844] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.938s)
[130.292630] [010/133] (892s left) kms_hdmi_inject (inject-4k)
[130.634970] Starting subtest: inject-4k
[130.949823] Subtest inject-4k: SUCCESS (0.318s)
[131.490519] [011/133] (891s left) gem_mmap_gtt (basic-short)
[131.552568] Subtest basic-short: SKIP (0.000s)
[131.624290] [012/133] (891s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[131.725357] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[131.729816] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[131.848887] [013/133] (891s left) gem_render_linear_blits (basic)
[131.910703] Starting subtest: basic
[131.931757] Subtest basic: SUCCESS (0.021s)
[132.033358] [014/133] (891s left) gem_pxp (verify-pxp-stale-buf-execution)
[132.167677] Starting subtest: verify-pxp-stale-buf-execution
[133.227512] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.062s)
[133.387292] [015/133] (889s left) sysfs_timeslice_duration (idempotent)
[133.460780] Starting subtest: idempotent
[133.463206] Starting dynamic subtest: vecs0
[133.465602] Dynamic subtest vecs0: SUCCESS (0.000s)
[133.474157] Starting dynamic subtest: ccs0
[133.476066] Dynamic subtest ccs0: SUCCESS (0.000s)
[133.483068] Starting dynamic subtest: vcs0
[133.485297] Dynamic subtest vcs0: SUCCESS (0.000s)
[133.492219] Starting dynamic subtest: bcs0
[133.494111] Dynamic subtest bcs0: SUCCESS (0.000s)
[133.500641] Starting dynamic subtest: rcs0
[133.502601] Dynamic subtest rcs0: SUCCESS (0.000s)
[133.509237] Starting dynamic subtest: vcs1
[133.511097] Dynamic subtest vcs1: SUCCESS (0.000s)
[133.512988] Subtest idempotent: SUCCESS (0.005s)
[133.560011] [016/133] (889s left) i915_query (query-topology-kernel-writes)
[133.604361] Starting subtest: query-topology-kernel-writes
[133.606654] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[133.730965] [017/133] (889s left) gem_exec_balancer (bonded-false-hang)
[133.992795] Starting subtest: bonded-false-hang
[133.997981] Subtest bonded-false-hang: SKIP (0.000s)
[134.100308] [018/133] (889s left) i915_pm_rpm (gem-pread)
[136.063593] Starting subtest: gem-pread
[138.123837] Subtest gem-pread: SUCCESS (2.063s)
[138.233816] [019/133] (885s left) gem_exec_params (invalid-fence-in)
[138.302164] Starting subtest: invalid-fence-in
[138.304481] Subtest invalid-fence-in: SUCCESS (0.000s)
[138.421906] [020/133] (885s left) kms_chamelium_color (ctm-0-25)
[138.528456] Subtest ctm-0-25: SKIP (0.000s)
[138.574224] [021/133] (884s left) kms_chamelium_hpd (dp-hpd-storm)
[138.962559] Subtest dp-hpd-storm: SKIP (0.000s)
[139.793057] [022/133] (883s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[139.863187] Starting subtest: etime-single-wait-for-submit-submitted
[139.968928] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.106s)
[140.071829] [023/133] (883s left) gem_tiled_blits (interruptible)
[140.137820] Subtest interruptible: SKIP (0.000s)
[140.222582] [024/133] (883s left) perf (create-destroy-userspace-config)
[140.344385] Starting subtest: create-destroy-userspace-config
[140.363058] Subtest create-destroy-userspace-config: SUCCESS (0.018s)
[140.399339] [025/133] (883s left) kms_async_flips (async-flip-dpms)
[140.483066] Starting subtest: async-flip-dpms
[140.867499] Starting dynamic subtest: pipe-A-eDP-1
[144.768384] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.900s)
[145.147941] Starting dynamic subtest: pipe-B-eDP-1
[147.967315] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.824s)
[148.342872] Starting dynamic subtest: pipe-C-eDP-1
[151.175891] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.838s)
[151.550343] Starting dynamic subtest: pipe-D-eDP-1
[154.472915] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.928s)
[154.475091] Subtest async-flip-dpms: SUCCESS (13.991s)
[155.736147] [026/133] (867s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[155.877760] Starting subtest: cursorA-vs-flipA-atomic-transitions
[167.059617] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.180s)
[167.931526] [027/133] (855s left) kms_getfb (getfb2-handle-not-fb)
[168.036283] Starting subtest: getfb2-handle-not-fb
[168.038532] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[168.159255] [028/133] (855s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[168.257657] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[172.262700] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.007s)
[173.457681] [029/133] (850s left) prime_busy (after-wait)
[173.529069] Starting subtest: after-wait
[173.534403] Starting dynamic subtest: rcs0
[173.576836] Dynamic subtest rcs0: SUCCESS (0.044s)
[173.586404] Starting dynamic subtest: bcs0
[173.635412] Dynamic subtest bcs0: SUCCESS (0.057s)
[173.644848] Starting dynamic subtest: vcs0
[173.675906] Dynamic subtest vcs0: SUCCESS (0.041s)
[173.683993] Starting dynamic subtest: vcs1
[173.715988] Dynamic subtest vcs1: SUCCESS (0.039s)
[173.723802] Starting dynamic subtest: vecs0
[173.756387] Dynamic subtest vecs0: SUCCESS (0.040s)
[173.764061] Starting dynamic subtest: ccs0
[173.797939] Dynamic subtest ccs0: SUCCESS (0.041s)
[173.906488] Subtest after-wait: SUCCESS (0.376s)
[173.994501] [030/133] (849s left) kms_flip (2x-flip-vs-dpms)
[174.102629] Starting subtest: 2x-flip-vs-dpms
[174.110869] Subtest 2x-flip-vs-dpms: SKIP (0.010s)
[174.249022] [031/133] (849s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[174.337190] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[174.339404] Starting dynamic subtest: pipe-A-default-mode
[175.459241] Dynamic subtest pipe-A-default-mode: SKIP (1.120s)
[175.463855] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.122s)
[175.661983] [032/133] (848s left) perf (blocking-parameterized)
[175.762509] Starting subtest: blocking-parameterized
[195.780126] Subtest blocking-parameterized: SUCCESS (20.016s)
[195.834682] [033/133] (828s left) gem_spin_batch (spin-all)
[195.925427] Starting subtest: spin-all
[195.938135] Subtest spin-all: SUCCESS (0.013s)
[197.963957] [034/133] (826s left) kms_psr (psr2-sprite-mmap-cpu)
[198.060077] Starting subtest: psr2-sprite-mmap-cpu
[198.062255] Starting dynamic subtest: eDP-1
[199.787675] Dynamic subtest eDP-1: SUCCESS (1.729s)
[199.789933] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.730s)
[200.638920] [035/133] (823s left) kms_color (ctm-signed)
[200.738613] Starting subtest: ctm-signed
[200.740741] Starting dynamic subtest: pipe-A-eDP-1
[202.863787] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.125s)
[202.873299] Starting dynamic subtest: pipe-B-eDP-1
[205.653238] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.788s)
[205.661241] Starting dynamic subtest: pipe-C-eDP-1
[208.419257] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.766s)
[208.427202] Starting dynamic subtest: pipe-D-eDP-1
[211.122931] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.702s)
[211.125259] Subtest ctm-signed: SUCCESS (10.385s)
[211.947883] [036/133] (812s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[212.068191] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[212.072436] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[212.161068] [037/133] (812s left) gem_exec_schedule (u-submit-late-slice)
[212.238110] Starting subtest: u-submit-late-slice
[212.239997] Starting dynamic subtest: rcs0
[212.265132] Dynamic subtest rcs0: SUCCESS (0.035s)
[212.274854] Starting dynamic subtest: bcs0
[212.294034] Dynamic subtest bcs0: SUCCESS (0.028s)
[212.309915] Starting dynamic subtest: vcs0
[212.326466] Dynamic subtest vcs0: SUCCESS (0.030s)
[212.335225] Starting dynamic subtest: vcs1
[212.355323] Dynamic subtest vcs1: SUCCESS (0.028s)
[212.362839] Starting dynamic subtest: vecs0
[212.382519] Dynamic subtest vecs0: SUCCESS (0.026s)
[212.390229] Starting dynamic subtest: ccs0
[212.416263] Dynamic subtest ccs0: SUCCESS (0.033s)
[212.418440] Subtest u-submit-late-slice: SUCCESS (0.187s)
[214.014515] [038/133] (810s left) gem_eio (in-flight-external)
[214.244655] Starting subtest: in-flight-external
[215.977363] Subtest in-flight-external: SUCCESS (1.730s)
[216.163114] [039/133] (808s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[216.269605] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[216.274049] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[216.395454] [040/133] (807s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[216.492402] Starting subtest: x-tiled-32bpp-rotate-0
[217.848736] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.356s)
[218.026497] [041/133] (806s left) i915_hangman (engine-engine-error)
[218.095258] Starting subtest: engine-engine-error
[218.097030] Starting dynamic subtest: rcs0
[219.891077] Dynamic subtest rcs0: SUCCESS (1.795s)
[219.902854] Starting dynamic subtest: bcs0
[221.874794] Dynamic subtest bcs0: SUCCESS (1.981s)
[221.886047] Starting dynamic subtest: vcs0
[223.859443] Dynamic subtest vcs0: SUCCESS (1.981s)
[223.871371] Starting dynamic subtest: vcs1
[225.906106] Dynamic subtest vcs1: SUCCESS (2.044s)
[225.917430] Starting dynamic subtest: vecs0
[227.889940] Dynamic subtest vecs0: SUCCESS (1.982s)
[227.903605] Starting dynamic subtest: ccs0
[229.874596] Dynamic subtest ccs0: SUCCESS (1.982s)
[229.877501] Subtest engine-engine-error: SUCCESS (11.780s)
[229.969188] [042/133] (794s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[230.083760] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[230.092193] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[230.219837] [043/133] (794s left) gem_mmap_gtt (isolation)
[230.271069] Subtest isolation: SKIP (0.000s)
[230.339193] [044/133] (794s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[230.417914] Starting subtest: primary-yf-tiled-reflect-x-180
[230.477608] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s)
[230.591519] [045/133] (793s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[230.689580] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[230.693917] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[230.775250] [046/133] (793s left) kms_flip (wf_vblank-ts-check-interruptible)
[230.870114] Starting subtest: wf_vblank-ts-check-interruptible
[230.872448] Starting dynamic subtest: A-eDP1
[239.741340] Dynamic subtest A-eDP1: SUCCESS (8.870s)
[239.754868] Starting dynamic subtest: B-eDP1
[248.630261] Dynamic subtest B-eDP1: SUCCESS (8.886s)
[248.639373] Starting dynamic subtest: C-eDP1
[257.524661] Dynamic subtest C-eDP1: SUCCESS (8.893s)
[257.533969] Starting dynamic subtest: D-eDP1
[266.413335] Dynamic subtest D-eDP1: SUCCESS (8.887s)
[266.415677] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.546s)
[267.630062] [047/133] (756s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[267.755495] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[267.757714] Starting dynamic subtest: pipe-A
[267.797959] Dynamic subtest pipe-A: SKIP (0.037s)
[267.806070] Starting dynamic subtest: pipe-B
[267.864885] Dynamic subtest pipe-B: SKIP (0.064s)
[267.872789] Starting dynamic subtest: pipe-C
[267.917205] Dynamic subtest pipe-C: SKIP (0.050s)
[267.924911] Starting dynamic subtest: pipe-D
[267.947613] Dynamic subtest pipe-D: SKIP (0.031s)
[267.951669] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.189s)
[268.055950] [048/133] (756s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[268.149283] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[268.151404] Starting dynamic subtest: pipe-A-eDP-1
[268.173490] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[268.183063] Starting dynamic subtest: pipe-B-eDP-1
[268.204703] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[268.215027] Starting dynamic subtest: pipe-C-eDP-1
[268.236580] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[268.244752] Starting dynamic subtest: pipe-D-eDP-1
[268.266422] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[268.270439] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[270.425594] [049/133] (754s left) perf_pmu (busy-idle-check-all)
[270.472108] Starting subtest: busy-idle-check-all
[270.474415] Starting dynamic subtest: rcs0
[271.144029] Dynamic subtest rcs0: SUCCESS (0.673s)
[271.155878] Starting dynamic subtest: bcs0
[271.795558] Dynamic subtest bcs0: SUCCESS (0.649s)
[271.807254] Starting dynamic subtest: vcs0
[272.914441] Dynamic subtest vcs0: SUCCESS (1.116s)
[272.925701] Starting dynamic subtest: vcs1
[274.900964] Dynamic subtest vcs1: SUCCESS (1.982s)
[274.912505] Starting dynamic subtest: vecs0
[276.885059] Dynamic subtest vecs0: SUCCESS (1.981s)
[276.896532] Starting dynamic subtest: ccs0
[277.542624] Dynamic subtest ccs0: SUCCESS (0.656s)
[277.545254] Subtest busy-idle-check-all: SUCCESS (7.073s)
[277.658635] [050/133] (747s left) gem_softpin (overlap)
[277.725949] Starting subtest: overlap
[278.612939] Subtest overlap: SUCCESS (0.888s)
[278.760874] [051/133] (746s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[278.857170] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[278.861191] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[278.963246] [052/133] (745s left) gem_mmap_gtt (basic-small-copy-odd)
[279.019985] Subtest basic-small-copy-odd: SKIP (0.000s)
[279.079304] [053/133] (745s left) kms_pipe_crc_basic (read-crc)
[279.176249] Starting subtest: read-crc
[279.178401] Starting dynamic subtest: pipe-A-eDP-1
[279.895153] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.718s)
[279.903946] Starting dynamic subtest: pipe-B-eDP-1
[281.257252] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.360s)
[281.266249] Starting dynamic subtest: pipe-C-eDP-1
[282.606126] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.347s)
[282.615443] Starting dynamic subtest: pipe-D-eDP-1
[283.891102] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.284s)
[283.893578] Subtest read-crc: SUCCESS (4.715s)
[284.720329] [054/133] (740s left) kms_big_fb (linear-16bpp-rotate-90)
[284.841659] Starting subtest: linear-16bpp-rotate-90
[284.860774] Subtest linear-16bpp-rotate-90: SKIP (0.018s)
[284.985497] [055/133] (739s left) kms_cursor_edge_walk (128x128-top-bottom)
[285.080920] Starting subtest: 128x128-top-bottom
[285.083248] Starting dynamic subtest: pipe-A-eDP-1
[288.542247] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.461s)
[288.550734] Starting dynamic subtest: pipe-D-eDP-1
[291.733038] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.187s)
[291.734963] Subtest 128x128-top-bottom: SUCCESS (6.651s)
[292.620568] [056/133] (732s left) kms_setmode (invalid-clone-exclusive-crtc)
[292.683618] Starting subtest: invalid-clone-exclusive-crtc
[292.689844] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[292.803879] [057/133] (732s left) kms_psr (psr-primary-mmap-gtt)
[292.910725] Starting subtest: psr-primary-mmap-gtt
[292.913030] Starting dynamic subtest: eDP-1
[294.379670] Dynamic subtest eDP-1: SKIP (1.464s)
[294.384607] Subtest psr-primary-mmap-gtt: SKIP (1.466s)
[294.585462] [058/133] (730s left) kms_fb_coherency (memset-crc)
[294.676362] Starting subtest: memset-crc
[294.678297] Starting dynamic subtest: mmap-offset-wc
[295.038311] Dynamic subtest mmap-offset-wc: SUCCESS (0.362s)
[295.338829] Starting dynamic subtest: mmap-offset-uc
[301.474078] Dynamic subtest mmap-offset-uc: SUCCESS (6.143s)
[301.757068] Subtest memset-crc: SUCCESS (7.081s)
[302.616680] [059/133] (722s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[302.718447] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[306.730059] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.015s)
[307.930251] [060/133] (717s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[308.036673] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[314.653772] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.619s)
[314.814709] [061/133] (710s left) kms_pm_rpm (modeset-stress-extra-wait)
[317.049085] Starting subtest: modeset-stress-extra-wait
[371.327340] Subtest modeset-stress-extra-wait: SUCCESS (54.278s)
[371.438816] [062/133] (653s left) kms_frontbuffer_tracking (fbc-2p-rte)
[371.545190] Starting subtest: fbc-2p-rte
[371.549184] Subtest fbc-2p-rte: SKIP (0.000s)
[371.669854] [063/133] (653s left) api_intel_bb (reset-flags)
[371.731446] Starting subtest: reset-flags
[371.736784] Subtest reset-flags: SUCCESS (0.006s)
[371.904341] [064/133] (653s left) gem_ctx_persistence (legacy-engines-mixed-process)
[371.975323] Starting subtest: legacy-engines-mixed-process
[371.977501] Starting dynamic subtest: render
[373.928071] Dynamic subtest render: SUCCESS (1.955s)
[373.939625] Starting dynamic subtest: bsd1
[375.907786] Dynamic subtest bsd1: SUCCESS (1.978s)
[375.920795] Starting dynamic subtest: bsd2
[377.864886] Dynamic subtest bsd2: SUCCESS (1.953s)
[377.874077] Starting dynamic subtest: blt
[379.948082] Dynamic subtest blt: SUCCESS (2.081s)
[379.959127] Starting dynamic subtest: vebox
[381.943101] Dynamic subtest vebox: SUCCESS (1.993s)
[381.945750] Subtest legacy-engines-mixed-process: SUCCESS (9.971s)
[382.036521] [065/133] (643s left) gem_mmap (bad-offset)
[382.110804] Subtest bad-offset: SKIP (0.000s)
[382.182443] [066/133] (643s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[382.287189] Starting subtest: fbc-1p-pri-indfb-multidraw
[395.346594] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (13.062s)
[396.730682] [067/133] (628s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[396.840157] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[396.844525] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[396.935613] [068/133] (628s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[397.041854] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[397.069110] Starting dynamic subtest: pipe-A-plane-0
[397.073741] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[397.084219] Starting dynamic subtest: pipe-A-plane-3
[397.088760] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[397.096899] Starting dynamic subtest: pipe-A-plane-5
[397.101470] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[398.143946] Starting dynamic subtest: pipe-B-plane-0
[398.148307] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[398.156519] Starting dynamic subtest: pipe-B-plane-3
[398.161070] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[398.168963] Starting dynamic subtest: pipe-B-plane-5
[398.173471] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[398.450605] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (1.406s)
[399.323936] [069/133] (626s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[399.425089] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[399.427168] Starting dynamic subtest: pipe-A-eDP-1
[399.486462] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[399.501272] Starting dynamic subtest: pipe-B-eDP-1
[399.561903] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[399.572132] Starting dynamic subtest: pipe-C-eDP-1
[399.629239] Dynamic subtest pipe-C-eDP-1: SKIP (0.003s)
[399.639460] Starting dynamic subtest: pipe-D-eDP-1
[399.696467] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[399.700649] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.012s)
[401.706990] [070/133] (623s left) gem_exec_schedule (pi-userfault)
[401.882114] Starting subtest: pi-userfault
[401.884124] Starting dynamic subtest: rcs0
[401.889712] Dynamic subtest rcs0: SUCCESS (0.010s)
[401.900185] Starting dynamic subtest: bcs0
[401.902334] Dynamic subtest bcs0: SUCCESS (0.011s)
[401.911078] Starting dynamic subtest: vcs0
[401.913245] Dynamic subtest vcs0: SUCCESS (0.008s)
[401.921340] Starting dynamic subtest: vcs1
[401.923593] Dynamic subtest vcs1: SUCCESS (0.010s)
[401.931962] Starting dynamic subtest: vecs0
[401.934214] Dynamic subtest vecs0: SUCCESS (0.009s)
[401.942794] Starting dynamic subtest: ccs0
[401.944934] Dynamic subtest ccs0: SUCCESS (0.008s)
[401.947213] Subtest pi-userfault: SUCCESS (0.062s)
[402.134562] [071/133] (623s left) gen7_exec_parse (load-register-reg)
[402.189706] Subtest load-register-reg: SKIP (0.000s)
[402.256628] [072/133] (623s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[402.353196] Starting subtest: 4-tiled-64bpp-rotate-0
[403.865885] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.512s)
[404.066194] [073/133] (621s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[404.169644] Starting subtest: fbcpsr-modesetfrombusy
[410.313682] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.149s)
[410.493589] [074/133] (615s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[410.605326] Starting subtest: psr-rgb101010-draw-mmap-wc
[417.530421] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (6.925s)
[417.640992] [075/133] (608s left) kms_plane_multiple (tiling-yf)
[417.737057] Starting subtest: tiling-yf
[417.741271] Subtest tiling-yf: SKIP (0.000s)
[417.820233] [076/133] (607s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[417.926533] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[417.930887] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[418.042351] [077/133] (607s left) perf (oa-exponents)
[418.147874] Starting subtest: oa-exponents
[418.150140] Starting dynamic subtest: 0-rcs0
[419.928823] Dynamic subtest 0-rcs0: SUCCESS (1.779s)
[419.938057] Starting dynamic subtest: 1-vecs0
[421.726890] Dynamic subtest 1-vecs0: SUCCESS (1.797s)
[421.729855] Subtest oa-exponents: SUCCESS (3.578s)
[421.774307] [078/133] (604s left) gem_exec_fence (parallel)
[421.951377] Starting subtest: parallel
[421.953945] Starting dynamic subtest: rcs0
[424.099013] Dynamic subtest rcs0: SUCCESS (2.148s)
[424.108989] Starting dynamic subtest: bcs0
[426.254752] Dynamic subtest bcs0: SUCCESS (2.155s)
[426.265161] Starting dynamic subtest: vcs0
[428.406808] Dynamic subtest vcs0: SUCCESS (2.151s)
[428.415493] Starting dynamic subtest: vcs1
[430.558352] Dynamic subtest vcs1: SUCCESS (2.151s)
[430.567885] Starting dynamic subtest: vecs0
[432.713370] Dynamic subtest vecs0: SUCCESS (2.154s)
[432.723390] Starting dynamic subtest: ccs0
[434.868216] Dynamic subtest ccs0: SUCCESS (2.154s)
[434.870187] Subtest parallel: SUCCESS (12.918s)
[436.058082] [079/133] (589s left) gem_exec_schedule (u-lateslice)
[436.151141] Starting subtest: u-lateslice
[436.153063] Starting dynamic subtest: rcs0
[436.175832] Dynamic subtest rcs0: SUCCESS (0.031s)
[436.187913] Starting dynamic subtest: bcs0
[436.197651] Dynamic subtest bcs0: SUCCESS (0.022s)
[436.205971] Starting dynamic subtest: vcs0
[436.221331] Dynamic subtest vcs0: SUCCESS (0.023s)
[436.229603] Starting dynamic subtest: vcs1
[436.248376] Dynamic subtest vcs1: SUCCESS (0.026s)
[436.256912] Starting dynamic subtest: vecs0
[436.284787] Dynamic subtest vecs0: SUCCESS (0.035s)
[436.293380] Starting dynamic subtest: ccs0
[436.308803] Dynamic subtest ccs0: SUCCESS (0.023s)
[436.311131] Subtest u-lateslice: SUCCESS (0.166s)
[438.029065] [080/133] (587s left) kms_universal_plane (cursor-fb-leak)
[438.130715] Starting subtest: cursor-fb-leak
[438.132817] Starting dynamic subtest: pipe-A-eDP-1
[438.473506] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.344s)
[438.488233] Starting dynamic subtest: pipe-B-eDP-1
[439.897326] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.421s)
[439.909080] Starting dynamic subtest: pipe-C-eDP-1
[441.269192] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.370s)
[441.281088] Starting dynamic subtest: pipe-D-eDP-1
[442.655975] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.385s)
[442.658691] Subtest cursor-fb-leak: SUCCESS (4.528s)
[443.900328] [081/133] (582s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[443.962545] Starting subtest: multi-wait-all-for-submit-available-submitted
[443.965086] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[444.100166] [082/133] (581s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[444.154887] Subtest untiled-to-tiled: SKIP (0.000s)
[444.234775] [083/133] (581s left) gem_exec_alignment (pi)
[444.296121] Starting subtest: pi
[493.512496] Subtest pi: SUCCESS (49.212s)
[494.536539] [084/133] (531s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[494.684144] Starting subtest: y-tiled-16bpp-rotate-90
[494.688710] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[494.801690] [085/133] (531s left) syncobj_eventfd (binary-wait-signaled)
[494.869429] Starting subtest: binary-wait-signaled
[494.871664] Subtest binary-wait-signaled: SUCCESS (0.000s)
[494.989318] [086/133] (531s left) kms_flip (2x-flip-vs-fences-interruptible)
[495.076242] Starting subtest: 2x-flip-vs-fences-interruptible
[495.080643] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[495.183818] [087/133] (531s left) syncobj_wait (multi-wait-all-signaled)
[495.237608] Starting subtest: multi-wait-all-signaled
[495.240109] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[495.346579] [088/133] (530s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[495.447137] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[495.451441] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[495.581462] [089/133] (530s left) i915_drm_fdinfo (memory-info-resident)
[495.617491] Starting subtest: memory-info-resident
[495.619336] Starting dynamic subtest: smem0
[498.224768] Dynamic subtest smem0: SUCCESS (2.607s)
[498.226880] Subtest memory-info-resident: SUCCESS (2.608s)
[498.311593] [090/133] (528s left) kms_psr (fbc-pr-suspend)
[498.421155] Starting subtest: fbc-pr-suspend
[498.425041] Subtest fbc-pr-suspend: SKIP (0.000s)
[498.522795] [091/133] (527s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[498.665694] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[499.515668] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.852s)
[499.710712] [092/133] (526s left) gem_mmap_wc (write-gtt-read-wc)
[499.779891] Subtest write-gtt-read-wc: SKIP (0.000s)
[499.850963] [093/133] (526s left) gem_userptr_blits (stress-purge)
[499.931694] Starting subtest: stress-purge
[505.336994] Subtest stress-purge: SUCCESS (5.406s)
[505.502108] [094/133] (521s left) gem_fenced_exec_thrash (2-spare-fences)
[505.601497] Subtest 2-spare-fences: SKIP (0.000s)
[505.704963] [095/133] (520s left) kms_content_protection (legacy-hdcp14)
[505.866435] Starting subtest: legacy-hdcp14
[505.870026] Subtest legacy-hdcp14: SKIP (0.000s)
[506.031065] [096/133] (520s left) gem_exec_params (rel-constants-invalid)
[506.101061] Starting subtest: rel-constants-invalid
[506.103039] Subtest rel-constants-invalid: SUCCESS (0.000s)
[506.225266] [097/133] (520s left) kms_vrr (flipline)
[506.315435] Starting subtest: flipline
[506.320816] Subtest flipline: SKIP (0.000s)
[506.399078] [098/133] (520s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[506.509525] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[506.511490] Starting dynamic subtest: pipe-A-eDP-1
[506.528335] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[506.538227] Starting dynamic subtest: pipe-B-eDP-1
[506.554150] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[506.562190] Starting dynamic subtest: pipe-C-eDP-1
[506.577940] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[506.585922] Starting dynamic subtest: pipe-D-eDP-1
[506.602231] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[506.604081] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.011s)
[508.818407] [099/133] (517s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[508.924686] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[508.929048] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[509.042422] [100/133] (517s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[509.112380] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[509.114724] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[509.220520] [101/133] (517s left) kms_flip (bo-too-big-interruptible)
[509.320525] Starting subtest: bo-too-big-interruptible
[509.322728] Starting dynamic subtest: A-eDP1
[510.601943] Dynamic subtest A-eDP1: SUCCESS (1.280s)
[510.615292] Starting dynamic subtest: B-eDP1
[511.902216] Dynamic subtest B-eDP1: SUCCESS (1.300s)
[511.915399] Starting dynamic subtest: C-eDP1
[513.211248] Dynamic subtest C-eDP1: SUCCESS (1.306s)
[513.222955] Starting dynamic subtest: D-eDP1
[514.502573] Dynamic subtest D-eDP1: SUCCESS (1.291s)
[514.504955] Subtest bo-too-big-interruptible: SUCCESS (5.185s)
[515.701373] [102/133] (511s left) gem_mmap_offset (ptrace)
[515.758981] Starting subtest: ptrace
[515.763880] Starting dynamic subtest: smem0-wb
[515.783141] Dynamic subtest smem0-wb: SUCCESS (0.022s)
[515.794575] Starting dynamic subtest: smem0-wc
[515.805159] Dynamic subtest smem0-wc: SUCCESS (0.020s)
[515.814204] Starting dynamic subtest: smem0-uc
[515.821869] Dynamic subtest smem0-uc: SUCCESS (0.016s)
[515.824681] Subtest ptrace: SUCCESS (0.064s)
[515.989434] [103/133] (510s left) gem_exec_flush (basic-batch-kernel-default-uc)
[516.040778] Starting subtest: basic-batch-kernel-default-uc
[523.198269] Subtest basic-batch-kernel-default-uc: SUCCESS (7.158s)
[523.398463] [104/133] (503s left) kms_plane (plane-panning-bottom-right)
[523.508072] Starting subtest: plane-panning-bottom-right
[523.509939] Starting dynamic subtest: pipe-A
[525.224578] Dynamic subtest pipe-A: SUCCESS (1.716s)
[525.234942] Starting dynamic subtest: pipe-B
[527.610706] Dynamic subtest pipe-B: SUCCESS (2.383s)
[527.612669] Subtest plane-panning-bottom-right: SUCCESS (4.102s)
[528.506537] [105/133] (498s left) kms_cursor_legacy (forked-move)
[528.628896] Starting subtest: forked-move
[528.631249] Starting dynamic subtest: pipe-A
[534.092330] Dynamic subtest pipe-A: SUCCESS (5.459s)
[534.104181] Starting dynamic subtest: pipe-B
[539.570518] Dynamic subtest pipe-B: SUCCESS (5.475s)
[539.582450] Starting dynamic subtest: pipe-C
[545.078988] Dynamic subtest pipe-C: SUCCESS (5.476s)
[545.091636] Starting dynamic subtest: pipe-D
[550.523855] Dynamic subtest pipe-D: SUCCESS (5.472s)
[550.534470] Starting dynamic subtest: all-pipes
[556.037930] Dynamic subtest all-pipes: SUCCESS (5.512s)
[556.040412] Subtest forked-move: SUCCESS (27.405s)
[556.190459] [106/133] (470s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[556.307083] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[556.311634] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[556.406037] [107/133] (470s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[556.505183] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[556.507479] Starting dynamic subtest: pipe-A-eDP-1
[572.547414] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.549s)
[572.557429] Starting dynamic subtest: pipe-B-eDP-1
[589.511258] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.395s)
[589.522952] Starting dynamic subtest: pipe-C-eDP-1
[606.501046] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.404s)
[606.512169] Starting dynamic subtest: pipe-D-eDP-1
[623.501192] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.416s)
[623.503839] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.769s)
[624.677394] [108/133] (402s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[624.786545] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[624.797307] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.010s)
[624.885143] [109/133] (402s left) kms_invalid_mode (zero-clock)
[624.993299] Starting subtest: zero-clock
[624.995809] Starting dynamic subtest: pipe-A-eDP-1
[625.278631] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[625.295707] Starting dynamic subtest: pipe-B-eDP-1
[625.298384] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[625.309961] Starting dynamic subtest: pipe-C-eDP-1
[625.312490] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[625.321947] Starting dynamic subtest: pipe-D-eDP-1
[625.324057] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[625.326368] Subtest zero-clock: SUCCESS (0.292s)
[626.087465] [110/133] (401s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[626.205686] Starting subtest: 2x-flip-vs-cursor-atomic
[626.211350] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[626.359177] [111/133] (400s left) gem_mmap_gtt (basic-copy)
[626.423849] Subtest basic-copy: SKIP (0.000s)
[626.495434] [112/133] (400s left) i915_pm_rps (thresholds-idle-park)
[626.565292] Starting subtest: thresholds-idle-park
[626.570645] Subtest thresholds-idle-park: SKIP (0.001s)
[626.687628] [113/133] (400s left) gen3_render_tiledy_blits
[626.828618] [114/133] (400s left) gem_reg_read (timestamp-monotonic)
[626.899578] Starting subtest: timestamp-monotonic
[631.774856] Subtest timestamp-monotonic: SUCCESS (4.871s)
[631.863627] [115/133] (395s left) dmabuf_sync_file (export-wait-after-attach)
[631.901819] Starting subtest: export-wait-after-attach
[631.904193] Subtest export-wait-after-attach: SUCCESS (0.001s)
[631.969357] [116/133] (395s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[632.069122] Starting subtest: crc-primary-basic-y-tiled-ccs
[632.071454] Starting dynamic subtest: pipe-A-eDP-1
[632.094858] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[632.106715] Starting dynamic subtest: pipe-B-eDP-1
[632.134008] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[632.143721] Starting dynamic subtest: pipe-C-eDP-1
[632.169975] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[632.179697] Starting dynamic subtest: pipe-D-eDP-1
[632.206011] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[632.211218] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s)
[634.305206] [117/133] (393s left) kms_atomic (plane-primary-legacy)
[634.407615] Starting subtest: plane-primary-legacy
[634.410323] Starting dynamic subtest: pipe-A-eDP-1
[634.853957] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.444s)
[634.856804] Subtest plane-primary-legacy: SUCCESS (0.446s)
[635.706188] [118/133] (391s left) syncobj_wait (invalid-signal-one-illegal-handle)
[635.780375] Starting subtest: invalid-signal-one-illegal-handle
[635.782680] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[635.893439] [119/133] (391s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[635.990986] Starting subtest: fbc-psr2-sprite-plane-onoff
[635.993642] Starting dynamic subtest: eDP-1
[635.998693] Dynamic subtest eDP-1: SKIP (0.000s)
[636.003683] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[636.075868] [120/133] (391s left) kms_cursor_crc (cursor-random-128x42)
[636.284558] Starting subtest: cursor-random-128x42
[636.340659] Subtest cursor-random-128x42: SKIP (0.051s)
[636.591603] [121/133] (391s left) prime_mmap (test_errors)
[636.649554] Starting subtest: test_errors
[636.651541] Starting dynamic subtest: test_errors-smem
[636.736469] Dynamic subtest test_errors-smem: SUCCESS (0.089s)
[636.738830] Subtest test_errors: SUCCESS (0.090s)
[636.840472] [122/133] (390s left) kms_psr (fbc-pr-dpms)
[636.932143] Starting subtest: fbc-pr-dpms
[636.936133] Subtest fbc-pr-dpms: SKIP (0.000s)
[637.015697] [123/133] (390s left) kms_cursor_crc (cursor-onscreen-512x512)
[637.282087] Starting subtest: cursor-onscreen-512x512
[637.286360] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[637.481469] [124/133] (390s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[637.573819] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[637.585330] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.010s)
[637.716729] [125/133] (390s left) kms_psr (pr-primary-mmap-cpu)
[637.805038] Starting subtest: pr-primary-mmap-cpu
[637.809646] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[637.888151] [126/133] (390s left) gem_ctx_param (invalid-get-engines)
[637.945514] Starting subtest: invalid-get-engines
[637.947842] Subtest invalid-get-engines: SUCCESS (0.001s)
[638.074880] [127/133] (389s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[638.143568] Starting subtest: y-tiled-to-vebox-yf-tiled
[638.148311] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[638.354195] [128/133] (389s left) api_intel_allocator (reserve-simple)
[638.417003] Starting subtest: reserve-simple
[638.419821] Subtest reserve-simple: SUCCESS (0.003s)
[638.544149] [129/133] (389s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[638.591638] Starting subtest: wait-all-for-submit-delayed-submit
[638.691704] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[638.774152] [130/133] (389s left) gem_basic (create-close)
[638.842647] Starting subtest: create-close
[638.847699] Subtest create-close: SUCCESS (0.000s)
[638.983887] [131/133] (389s left) gem_busy (extended)
[639.167874] Starting subtest: extended
[639.171059] Starting dynamic subtest: rcs0
[639.286562] Dynamic subtest rcs0: SUCCESS (0.119s)
[639.299647] Starting dynamic subtest: bcs0
[639.330670] Dynamic subtest bcs0: SUCCESS (0.042s)
[639.340814] Starting dynamic subtest: vcs0
[641.082003] Dynamic subtest vcs0: SUCCESS (1.746s)
[641.097720] Starting dynamic subtest: vcs1
[643.129161] Dynamic subtest vcs1: SUCCESS (2.043s)
[643.142722] Starting dynamic subtest: vecs0
[645.113659] Dynamic subtest vecs0: SUCCESS (1.981s)
[645.127885] Starting dynamic subtest: ccs0
[645.160557] Dynamic subtest ccs0: SUCCESS (0.045s)
[645.163300] Subtest extended: SUCCESS (5.990s)
[645.408357] [132/133] (382s left) kms_pm_dc (dc5-retention-flops)
[646.521894] Starting subtest: dc5-retention-flops
[646.526889] Subtest dc5-retention-flops: SKIP (0.000s)
[646.609771] [133/133] (381s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[646.999992] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[647.773948] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: gem_create
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_lmem_swapping
results: parsing output: 4/ for test: gem_exec_balancer
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: gem_exec_fence
results: parsing output: 7/ for test: gem_mmap_wc
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_hdmi_inject
results: parsing output: 10/ for test: gem_mmap_gtt
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_render_linear_blits
results: parsing output: 13/ for test: gem_pxp
results: parsing output: 14/ for test: sysfs_timeslice_duration
results: parsing output: 15/ for test: i915_query
results: parsing output: 16/ for test: gem_exec_balancer
results: parsing output: 17/ for test: i915_pm_rpm
results: parsing output: 18/ for test: gem_exec_params
results: parsing output: 19/ for test: kms_chamelium_color
results: parsing output: 20/ for test: kms_chamelium_hpd
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: gem_tiled_blits
results: parsing output: 23/ for test: perf
results: parsing output: 24/ for test: kms_async_flips
results: parsing output: 25/ for test: kms_cursor_legacy
results: parsing output: 26/ for test: kms_getfb
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: prime_busy
results: parsing output: 29/ for test: kms_flip
results: parsing output: 30/ for test: kms_flip_scaled_crc
results: parsing output: 31/ for test: perf
results: parsing output: 32/ for test: gem_spin_batch
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: kms_color
results: parsing output: 35/ for test: kms_psr2_sf
results: parsing output: 36/ for test: gem_exec_schedule
results: parsing output: 37/ for test: gem_eio
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: i915_hangman
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_mmap_gtt
results: parsing output: 43/ for test: kms_rotation_crc
results: parsing output: 44/ for test: kms_joiner
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: kms_plane_scaling
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: perf_pmu
results: parsing output: 49/ for test: gem_softpin
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_mmap_gtt
results: parsing output: 52/ for test: kms_pipe_crc_basic
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: kms_cursor_edge_walk
results: parsing output: 55/ for test: kms_setmode
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: kms_fb_coherency
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_pm_rpm
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: api_intel_bb
results: parsing output: 63/ for test: gem_ctx_persistence
results: parsing output: 64/ for test: gem_mmap
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_psr2_sf
results: parsing output: 67/ for test: kms_plane
results: parsing output: 68/ for test: kms_ccs
results: parsing output: 69/ for test: gem_exec_schedule
results: parsing output: 70/ for test: gen7_exec_parse
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_plane_multiple
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: perf
results: parsing output: 77/ for test: gem_exec_fence
results: parsing output: 78/ for test: gem_exec_schedule
results: parsing output: 79/ for test: kms_universal_plane
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: gem_set_tiling_vs_blt
results: parsing output: 82/ for test: gem_exec_alignment
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: syncobj_eventfd
results: parsing output: 85/ for test: kms_flip
results: parsing output: 86/ for test: syncobj_wait
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: i915_drm_fdinfo
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: gem_mmap_wc
results: parsing output: 92/ for test: gem_userptr_blits
results: parsing output: 93/ for test: gem_fenced_exec_thrash
results: parsing output: 94/ for test: kms_content_protection
results: parsing output: 95/ for test: gem_exec_params
results: parsing output: 96/ for test: kms_vrr
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: kms_flip
results: parsing output: 101/ for test: gem_mmap_offset
results: parsing output: 102/ for test: gem_exec_flush
results: parsing output: 103/ for test: kms_plane
results: parsing output: 104/ for test: kms_cursor_legacy
results: parsing output: 105/ for test: kms_flip_scaled_crc
results: parsing output: 106/ for test: kms_ccs
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: kms_invalid_mode
results: parsing output: 109/ for test: kms_cursor_legacy
results: parsing output: 110/ for test: gem_mmap_gtt
results: parsing output: 111/ for test: i915_pm_rps
results: parsing output: 112/ for test: gen3_render_tiledy_blits
results: parsing output: 113/ for test: gem_reg_read
results: parsing output: 114/ for test: dmabuf_sync_file
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: kms_atomic
results: parsing output: 117/ for test: syncobj_wait
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: kms_cursor_crc
results: parsing output: 120/ for test: prime_mmap
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: kms_cursor_crc
results: parsing output: 123/ for test: kms_flip
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: gem_ctx_param
results: parsing output: 126/ for test: gem_render_copy
results: parsing output: 127/ for test: api_intel_allocator
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: gem_basic
results: parsing output: 130/ for test: gem_busy
results: parsing output: 131/ for test: kms_pm_dc
results: parsing output: 132/ for test: kms_chamelium_edid
Done.