[59.040451] Initializing watchdogs
[59.040496]   /dev/watchdog0
[59.054210] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.058492] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.060761] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.064137] [001/133] (960s left) syncobj_timeline (wait-all-delayed-signal)
[59.145735] Starting subtest: wait-all-delayed-signal
[59.250215] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[59.336564] [002/133] (960s left) gem_create (busy-create)
[59.393463] Starting subtest: busy-create
[59.395779] Starting dynamic subtest: smem0
[92.899856] Dynamic subtest smem0: SUCCESS (33.503s)
[92.902961] Subtest busy-create: SUCCESS (33.504s)
[93.109250] [003/133] (926s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[93.209238] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[116.232198] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (23.025s)
[116.409471] [004/133] (903s left) gem_lmem_swapping (heavy-verify-random)
[116.463323] Subtest heavy-verify-random: SKIP (0.000s)
[116.504580] [005/133] (903s left) gem_exec_balancer (persistence)
[116.776209] Starting subtest: persistence
[117.683026] Subtest persistence: SUCCESS (0.906s)
[117.864028] [006/133] (901s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[117.963839] Starting subtest: yf-tiled-32bpp-rotate-90
[117.967833] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[118.088824] [007/133] (901s left) gem_exec_fence (syncobj-timeline-unused-fence)
[118.686271] Starting subtest: syncobj-timeline-unused-fence
[118.691625] Subtest syncobj-timeline-unused-fence: SUCCESS (0.007s)
[120.022505] [FACT gem_exec_fence (syncobj-timeline-unused-fence)] new: kernel.kmod_is_loaded.vgem: true
[120.025694] [008/133] (899s left) gem_mmap_wc (write-read)
[120.090440] Subtest write-read: SKIP (0.000s)
[120.156078] [009/133] (899s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[120.264746] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[127.304937] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.045s)
[127.465603] [010/133] (892s left) kms_hdmi_inject (inject-4k)
[127.825379] Starting subtest: inject-4k
[128.140630] Subtest inject-4k: SUCCESS (0.317s)
[128.723731] [011/133] (891s left) gem_mmap_gtt (basic-short)
[128.783083] Subtest basic-short: SKIP (0.000s)
[128.848257] [012/133] (891s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[128.955091] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[128.959191] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[129.052213] [013/133] (891s left) gem_render_linear_blits (basic)
[129.111587] Starting subtest: basic
[129.134613] Subtest basic: SUCCESS (0.021s)
[129.236136] [014/133] (890s left) gem_pxp (verify-pxp-stale-buf-execution)
[129.364758] Starting subtest: verify-pxp-stale-buf-execution
[130.426653] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.063s)
[130.564286] [015/133] (889s left) sysfs_timeslice_duration (idempotent)
[130.635826] Starting subtest: idempotent
[130.638087] Starting dynamic subtest: vecs0
[130.640361] Dynamic subtest vecs0: SUCCESS (0.000s)
[130.649500] Starting dynamic subtest: ccs0
[130.651312] Dynamic subtest ccs0: SUCCESS (0.000s)
[130.658465] Starting dynamic subtest: vcs0
[130.660300] Dynamic subtest vcs0: SUCCESS (0.000s)
[130.667288] Starting dynamic subtest: bcs0
[130.669121] Dynamic subtest bcs0: SUCCESS (0.000s)
[130.676185] Starting dynamic subtest: rcs0
[130.678174] Dynamic subtest rcs0: SUCCESS (0.000s)
[130.685084] Starting dynamic subtest: vcs1
[130.686943] Dynamic subtest vcs1: SUCCESS (0.000s)
[130.688788] Subtest idempotent: SUCCESS (0.005s)
[130.763245] [016/133] (889s left) i915_query (query-topology-kernel-writes)
[130.829462] Starting subtest: query-topology-kernel-writes
[130.831385] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[130.951303] [017/133] (889s left) gem_exec_balancer (bonded-false-hang)
[131.221059] Starting subtest: bonded-false-hang
[131.226082] Subtest bonded-false-hang: SKIP (0.000s)
[131.328466] [018/133] (888s left) i915_pm_rpm (gem-pread)
[132.990144] Starting subtest: gem-pread
[135.277896] Subtest gem-pread: SUCCESS (2.287s)
[135.390380] [019/133] (884s left) gem_exec_params (invalid-fence-in)
[135.462296] Starting subtest: invalid-fence-in
[135.464706] Subtest invalid-fence-in: SUCCESS (0.000s)
[135.585031] [020/133] (884s left) kms_chamelium_color (ctm-0-25)
[135.674175] Subtest ctm-0-25: SKIP (0.000s)
[135.716955] [021/133] (884s left) kms_chamelium_hpd (dp-hpd-storm)
[136.110333] Subtest dp-hpd-storm: SKIP (0.000s)
[136.960962] [022/133] (883s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[137.022369] Starting subtest: etime-single-wait-for-submit-submitted
[137.128833] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.106s)
[137.215379] [023/133] (883s left) gem_tiled_blits (interruptible)
[137.291427] Subtest interruptible: SKIP (0.000s)
[137.374982] [024/133] (883s left) perf (create-destroy-userspace-config)
[137.503534] Starting subtest: create-destroy-userspace-config
[137.524177] Subtest create-destroy-userspace-config: SUCCESS (0.019s)
[137.585110] [025/133] (882s left) kms_async_flips (async-flip-dpms)
[137.693157] Starting subtest: async-flip-dpms
[138.057077] Starting dynamic subtest: pipe-A-eDP-1
[141.929743] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.871s)
[142.314754] Starting dynamic subtest: pipe-B-eDP-1
[145.129314] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.823s)
[145.507482] Starting dynamic subtest: pipe-C-eDP-1
[148.425625] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.924s)
[148.808038] Starting dynamic subtest: pipe-D-eDP-1
[151.631956] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.828s)
[151.634331] Subtest async-flip-dpms: SUCCESS (13.937s)
[153.178881] [026/133] (867s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[153.298577] Starting subtest: cursorA-vs-flipA-atomic-transitions
[164.476215] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.174s)
[165.293146] [027/133] (855s left) kms_getfb (getfb2-handle-not-fb)
[165.393285] Starting subtest: getfb2-handle-not-fb
[165.395526] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[165.543359] [028/133] (855s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[165.641978] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[169.617986] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (3.979s)
[170.802094] [029/133] (849s left) prime_busy (after-wait)
[170.865139] Starting subtest: after-wait
[170.867512] Starting dynamic subtest: rcs0
[170.918121] Dynamic subtest rcs0: SUCCESS (0.052s)
[170.925902] Starting dynamic subtest: bcs0
[170.983183] Dynamic subtest bcs0: SUCCESS (0.064s)
[170.992770] Starting dynamic subtest: vcs0
[171.023661] Dynamic subtest vcs0: SUCCESS (0.039s)
[171.032410] Starting dynamic subtest: vcs1
[171.063610] Dynamic subtest vcs1: SUCCESS (0.040s)
[171.071513] Starting dynamic subtest: vecs0
[171.105021] Dynamic subtest vecs0: SUCCESS (0.040s)
[171.112789] Starting dynamic subtest: ccs0
[171.144838] Dynamic subtest ccs0: SUCCESS (0.039s)
[171.253606] Subtest after-wait: SUCCESS (0.389s)
[171.357258] [030/133] (849s left) kms_flip (2x-flip-vs-dpms)
[171.456151] Starting subtest: 2x-flip-vs-dpms
[171.465315] Subtest 2x-flip-vs-dpms: SKIP (0.011s)
[171.614478] [031/133] (849s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[171.709305] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[171.711448] Starting dynamic subtest: pipe-A-default-mode
[172.904484] Dynamic subtest pipe-A-default-mode: SKIP (1.194s)
[172.908927] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.196s)
[173.105508] [032/133] (847s left) perf (blocking-parameterized)
[173.216740] Starting subtest: blocking-parameterized
[193.237913] Subtest blocking-parameterized: SUCCESS (20.018s)
[193.288648] [033/133] (827s left) gem_spin_batch (spin-all)
[193.351710] Starting subtest: spin-all
[193.365814] Subtest spin-all: SUCCESS (0.014s)
[194.952422] [034/133] (825s left) kms_psr (psr2-sprite-mmap-cpu)
[195.052961] Starting subtest: psr2-sprite-mmap-cpu
[195.055257] Starting dynamic subtest: eDP-1
[196.739825] Dynamic subtest eDP-1: SUCCESS (1.686s)
[196.742135] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.687s)
[197.575864] [035/133] (823s left) kms_color (ctm-signed)
[197.684040] Starting subtest: ctm-signed
[197.685999] Starting dynamic subtest: pipe-A-eDP-1
[199.830366] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.148s)
[199.838598] Starting dynamic subtest: pipe-B-eDP-1
[202.713164] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.880s)
[202.721931] Starting dynamic subtest: pipe-C-eDP-1
[205.472701] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.760s)
[205.481274] Starting dynamic subtest: pipe-D-eDP-1
[208.171093] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.697s)
[208.173423] Subtest ctm-signed: SUCCESS (10.489s)
[208.981784] [036/133] (811s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[209.090178] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[209.094094] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[209.171562] [037/133] (811s left) gem_exec_schedule (u-submit-late-slice)
[209.244632] Starting subtest: u-submit-late-slice
[209.246868] Starting dynamic subtest: rcs0
[209.273040] Dynamic subtest rcs0: SUCCESS (0.037s)
[209.284422] Starting dynamic subtest: bcs0
[209.299756] Dynamic subtest bcs0: SUCCESS (0.026s)
[209.309734] Starting dynamic subtest: vcs0
[209.328571] Dynamic subtest vcs0: SUCCESS (0.028s)
[209.336669] Starting dynamic subtest: vcs1
[209.358510] Dynamic subtest vcs1: SUCCESS (0.029s)
[209.367315] Starting dynamic subtest: vecs0
[209.387981] Dynamic subtest vecs0: SUCCESS (0.029s)
[209.397756] Starting dynamic subtest: ccs0
[209.422009] Dynamic subtest ccs0: SUCCESS (0.033s)
[209.424493] Subtest u-submit-late-slice: SUCCESS (0.187s)
[211.021982] [038/133] (810s left) gem_eio (in-flight-external)
[211.272027] Starting subtest: in-flight-external
[212.977868] Subtest in-flight-external: SUCCESS (1.706s)
[213.140845] [039/133] (807s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[213.242279] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[213.246305] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[213.347461] [040/133] (807s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[213.452704] Starting subtest: x-tiled-32bpp-rotate-0
[214.797723] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.344s)
[214.957931] [041/133] (806s left) i915_hangman (engine-engine-error)
[215.045536] Starting subtest: engine-engine-error
[215.047699] Starting dynamic subtest: rcs0
[216.883995] Dynamic subtest rcs0: SUCCESS (1.838s)
[216.895796] Starting dynamic subtest: bcs0
[218.865955] Dynamic subtest bcs0: SUCCESS (1.979s)
[218.877023] Starting dynamic subtest: vcs0
[220.851442] Dynamic subtest vcs0: SUCCESS (1.982s)
[220.862557] Starting dynamic subtest: vcs1
[222.899058] Dynamic subtest vcs1: SUCCESS (2.045s)
[222.910080] Starting dynamic subtest: vecs0
[224.883376] Dynamic subtest vecs0: SUCCESS (1.981s)
[224.894718] Starting dynamic subtest: ccs0
[226.866658] Dynamic subtest ccs0: SUCCESS (1.980s)
[226.869593] Subtest engine-engine-error: SUCCESS (11.823s)
[226.964257] [042/133] (794s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[227.077413] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[227.081792] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[227.200110] [043/133] (794s left) gem_mmap_gtt (isolation)
[227.272871] Subtest isolation: SKIP (0.000s)
[227.336179] [044/133] (793s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[227.443587] Starting subtest: primary-yf-tiled-reflect-x-180
[227.502967] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s)
[227.617392] [045/133] (793s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[227.731628] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[227.735792] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[227.818810] [046/133] (793s left) kms_flip (wf_vblank-ts-check-interruptible)
[227.918792] Starting subtest: wf_vblank-ts-check-interruptible
[227.920643] Starting dynamic subtest: A-eDP1
[236.799080] Dynamic subtest A-eDP1: SUCCESS (8.878s)
[236.807347] Starting dynamic subtest: B-eDP1
[245.685840] Dynamic subtest B-eDP1: SUCCESS (8.885s)
[245.695142] Starting dynamic subtest: C-eDP1
[254.578806] Dynamic subtest C-eDP1: SUCCESS (8.891s)
[254.587284] Starting dynamic subtest: D-eDP1
[263.463886] Dynamic subtest D-eDP1: SUCCESS (8.883s)
[263.466263] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.546s)
[264.676433] [047/133] (756s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[264.776092] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[264.778301] Starting dynamic subtest: pipe-A
[264.798916] Dynamic subtest pipe-A: SKIP (0.018s)
[264.807292] Starting dynamic subtest: pipe-B
[264.829153] Dynamic subtest pipe-B: SKIP (0.032s)
[264.839957] Starting dynamic subtest: pipe-C
[264.869886] Dynamic subtest pipe-C: SKIP (0.037s)
[264.877910] Starting dynamic subtest: pipe-D
[264.903772] Dynamic subtest pipe-D: SKIP (0.033s)
[264.907526] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.124s)
[265.035506] [048/133] (756s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[265.141380] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[265.143601] Starting dynamic subtest: pipe-A-eDP-1
[265.165824] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[265.176977] Starting dynamic subtest: pipe-B-eDP-1
[265.197832] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[265.207917] Starting dynamic subtest: pipe-C-eDP-1
[265.228466] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[265.237061] Starting dynamic subtest: pipe-D-eDP-1
[265.260441] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[265.264614] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[267.368075] [049/133] (754s left) perf_pmu (busy-idle-check-all)
[267.403941] Starting subtest: busy-idle-check-all
[267.406177] Starting dynamic subtest: rcs0
[268.084269] Dynamic subtest rcs0: SUCCESS (0.680s)
[268.095275] Starting dynamic subtest: bcs0
[268.736811] Dynamic subtest bcs0: SUCCESS (0.651s)
[268.748961] Starting dynamic subtest: vcs0
[269.907670] Dynamic subtest vcs0: SUCCESS (1.168s)
[269.919769] Starting dynamic subtest: vcs1
[271.893207] Dynamic subtest vcs1: SUCCESS (1.982s)
[271.903922] Starting dynamic subtest: vecs0
[273.940059] Dynamic subtest vecs0: SUCCESS (2.044s)
[273.950981] Starting dynamic subtest: ccs0
[274.596393] Dynamic subtest ccs0: SUCCESS (0.655s)
[274.598982] Subtest busy-idle-check-all: SUCCESS (7.193s)
[274.733611] [050/133] (746s left) gem_softpin (overlap)
[274.799434] Starting subtest: overlap
[275.700702] Subtest overlap: SUCCESS (0.900s)
[275.863621] [051/133] (745s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[275.980621] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[275.984682] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[276.118314] [052/133] (745s left) gem_mmap_gtt (basic-small-copy-odd)
[276.173674] Subtest basic-small-copy-odd: SKIP (0.000s)
[276.243498] [053/133] (745s left) kms_pipe_crc_basic (read-crc)
[276.331021] Starting subtest: read-crc
[276.333275] Starting dynamic subtest: pipe-A-eDP-1
[277.041580] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s)
[277.051984] Starting dynamic subtest: pipe-B-eDP-1
[278.413308] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.370s)
[278.422325] Starting dynamic subtest: pipe-C-eDP-1
[279.773988] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.360s)
[279.783262] Starting dynamic subtest: pipe-D-eDP-1
[281.085956] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.310s)
[281.088344] Subtest read-crc: SUCCESS (4.756s)
[281.897550] [054/133] (739s left) kms_big_fb (linear-16bpp-rotate-90)
[282.005886] Starting subtest: linear-16bpp-rotate-90
[282.028344] Subtest linear-16bpp-rotate-90: SKIP (0.019s)
[282.163046] [055/133] (739s left) kms_cursor_edge_walk (128x128-top-bottom)
[282.263234] Starting subtest: 128x128-top-bottom
[282.265519] Starting dynamic subtest: pipe-A-eDP-1
[285.700075] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.435s)
[285.708902] Starting dynamic subtest: pipe-D-eDP-1
[288.885605] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.182s)
[288.887895] Subtest 128x128-top-bottom: SUCCESS (6.623s)
[289.776335] [056/133] (732s left) kms_setmode (invalid-clone-exclusive-crtc)
[289.846555] Starting subtest: invalid-clone-exclusive-crtc
[289.853321] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[289.970426] [057/133] (731s left) kms_psr (psr-primary-mmap-gtt)
[290.065950] Starting subtest: psr-primary-mmap-gtt
[290.068108] Starting dynamic subtest: eDP-1
[291.531842] Dynamic subtest eDP-1: SKIP (1.463s)
[291.537062] Subtest psr-primary-mmap-gtt: SKIP (1.466s)
[291.738972] [058/133] (730s left) kms_fb_coherency (memset-crc)
[291.839278] Starting subtest: memset-crc
[291.841404] Starting dynamic subtest: mmap-offset-wc
[292.249265] Dynamic subtest mmap-offset-wc: SUCCESS (0.408s)
[292.533514] Starting dynamic subtest: mmap-offset-uc
[298.663200] Dynamic subtest mmap-offset-uc: SUCCESS (6.137s)
[298.955865] Subtest memset-crc: SUCCESS (7.116s)
[299.766770] [059/133] (722s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[299.876575] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[303.914268] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.040s)
[305.079210] [060/133] (716s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[305.208520] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[311.851565] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.643s)
[312.014440] [061/133] (709s left) kms_pm_rpm (modeset-stress-extra-wait)
[314.046370] Starting subtest: modeset-stress-extra-wait
[368.334216] Subtest modeset-stress-extra-wait: SUCCESS (54.284s)
[368.449560] [062/133] (653s left) kms_frontbuffer_tracking (fbc-2p-rte)
[368.549335] Starting subtest: fbc-2p-rte
[368.553649] Subtest fbc-2p-rte: SKIP (0.000s)
[368.671192] [063/133] (653s left) api_intel_bb (reset-flags)
[368.730058] Starting subtest: reset-flags
[368.735579] Subtest reset-flags: SUCCESS (0.007s)
[368.891262] [064/133] (653s left) gem_ctx_persistence (legacy-engines-mixed-process)
[368.958059] Starting subtest: legacy-engines-mixed-process
[368.960282] Starting dynamic subtest: render
[370.924973] Dynamic subtest render: SUCCESS (1.966s)
[370.936049] Starting dynamic subtest: bsd1
[372.930323] Dynamic subtest bsd1: SUCCESS (2.002s)
[372.941660] Starting dynamic subtest: bsd2
[374.955055] Dynamic subtest bsd2: SUCCESS (2.022s)
[374.966352] Starting dynamic subtest: blt
[376.918942] Dynamic subtest blt: SUCCESS (1.962s)
[376.928597] Starting dynamic subtest: vebox
[378.882773] Dynamic subtest vebox: SUCCESS (1.962s)
[378.885663] Subtest legacy-engines-mixed-process: SUCCESS (9.925s)
[378.986497] [065/133] (643s left) gem_mmap (bad-offset)
[379.046103] Subtest bad-offset: SKIP (0.000s)
[379.114257] [066/133] (643s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[379.220160] Starting subtest: fbc-1p-pri-indfb-multidraw
[392.292251] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (13.075s)
[393.701133] [067/133] (628s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[393.814095] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[393.818577] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[393.893634] [068/133] (628s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[393.976475] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[394.002024] Starting dynamic subtest: pipe-A-plane-0
[394.006752] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[394.017188] Starting dynamic subtest: pipe-A-plane-3
[394.021854] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[394.030518] Starting dynamic subtest: pipe-A-plane-5
[394.035136] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[395.112599] Starting dynamic subtest: pipe-B-plane-0
[395.116877] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[395.125400] Starting dynamic subtest: pipe-B-plane-3
[395.130145] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[395.138635] Starting dynamic subtest: pipe-B-plane-5
[395.142986] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[395.415104] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (1.438s)
[396.279870] [069/133] (626s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[396.384244] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[396.386561] Starting dynamic subtest: pipe-A-eDP-1
[396.446239] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[396.454689] Starting dynamic subtest: pipe-B-eDP-1
[396.512519] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[396.522536] Starting dynamic subtest: pipe-C-eDP-1
[396.582677] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[396.592620] Starting dynamic subtest: pipe-D-eDP-1
[396.651374] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[396.655951] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s)
[398.674670] [070/133] (623s left) gem_exec_schedule (pi-userfault)
[398.865196] Starting subtest: pi-userfault
[398.867118] Starting dynamic subtest: rcs0
[398.874953] Dynamic subtest rcs0: SUCCESS (0.012s)
[398.886097] Starting dynamic subtest: bcs0
[398.888363] Dynamic subtest bcs0: SUCCESS (0.007s)
[398.896881] Starting dynamic subtest: vcs0
[398.898841] Dynamic subtest vcs0: SUCCESS (0.009s)
[398.908107] Starting dynamic subtest: vcs1
[398.910374] Dynamic subtest vcs1: SUCCESS (0.009s)
[398.918872] Starting dynamic subtest: vecs0
[398.920866] Dynamic subtest vecs0: SUCCESS (0.010s)
[398.929472] Starting dynamic subtest: ccs0
[398.931781] Dynamic subtest ccs0: SUCCESS (0.009s)
[398.934056] Subtest pi-userfault: SUCCESS (0.061s)
[399.119992] [071/133] (623s left) gen7_exec_parse (load-register-reg)
[399.193228] Subtest load-register-reg: SKIP (0.000s)
[399.273940] [072/133] (623s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[399.378521] Starting subtest: 4-tiled-64bpp-rotate-0
[400.857263] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.479s)
[401.053512] [073/133] (621s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[401.152594] Starting subtest: fbcpsr-modesetfrombusy
[407.274795] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.125s)
[407.448860] [074/133] (615s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[407.550332] Starting subtest: psr-rgb101010-draw-mmap-wc
[414.492909] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (6.944s)
[414.616068] [075/133] (607s left) kms_plane_multiple (tiling-yf)
[414.733054] Starting subtest: tiling-yf
[414.737403] Subtest tiling-yf: SKIP (0.000s)
[414.817115] [076/133] (607s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[414.929634] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[414.933966] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[415.073583] [077/133] (607s left) perf (oa-exponents)
[415.173823] Starting subtest: oa-exponents
[415.176182] Starting dynamic subtest: 0-rcs0
[416.958430] Dynamic subtest 0-rcs0: SUCCESS (1.783s)
[416.967203] Starting dynamic subtest: 1-vcs0
[418.756868] Dynamic subtest 1-vcs0: SUCCESS (1.797s)
[418.759772] Subtest oa-exponents: SUCCESS (3.582s)
[418.805393] [078/133] (603s left) gem_exec_fence (parallel)
[418.991756] Starting subtest: parallel
[418.994241] Starting dynamic subtest: rcs0
[421.145353] Dynamic subtest rcs0: SUCCESS (2.153s)
[421.156788] Starting dynamic subtest: bcs0
[423.300883] Dynamic subtest bcs0: SUCCESS (2.155s)
[423.311111] Starting dynamic subtest: vcs0
[425.457190] Dynamic subtest vcs0: SUCCESS (2.154s)
[425.467179] Starting dynamic subtest: vcs1
[427.606055] Dynamic subtest vcs1: SUCCESS (2.148s)
[427.615592] Starting dynamic subtest: vecs0
[429.754533] Dynamic subtest vecs0: SUCCESS (2.148s)
[429.764482] Starting dynamic subtest: ccs0
[431.904193] Dynamic subtest ccs0: SUCCESS (2.149s)
[431.906151] Subtest parallel: SUCCESS (12.913s)
[433.040782] [079/133] (589s left) gem_exec_schedule (u-lateslice)
[433.112812] Starting subtest: u-lateslice
[433.114855] Starting dynamic subtest: rcs0
[433.133037] Dynamic subtest rcs0: SUCCESS (0.030s)
[433.143428] Starting dynamic subtest: bcs0
[433.156259] Dynamic subtest bcs0: SUCCESS (0.023s)
[433.164723] Starting dynamic subtest: vcs0
[433.177968] Dynamic subtest vcs0: SUCCESS (0.021s)
[433.186497] Starting dynamic subtest: vcs1
[433.201660] Dynamic subtest vcs1: SUCCESS (0.023s)
[433.209895] Starting dynamic subtest: vecs0
[433.223633] Dynamic subtest vecs0: SUCCESS (0.022s)
[433.231997] Starting dynamic subtest: ccs0
[433.247495] Dynamic subtest ccs0: SUCCESS (0.023s)
[433.249641] Subtest u-lateslice: SUCCESS (0.145s)
[435.034452] [080/133] (587s left) kms_universal_plane (cursor-fb-leak)
[435.129924] Starting subtest: cursor-fb-leak
[435.132246] Starting dynamic subtest: pipe-A-eDP-1
[435.467763] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.339s)
[435.481041] Starting dynamic subtest: pipe-B-eDP-1
[436.844332] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.373s)
[436.856219] Starting dynamic subtest: pipe-C-eDP-1
[438.212326] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.365s)
[438.223011] Starting dynamic subtest: pipe-D-eDP-1
[439.544278] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.331s)
[439.546733] Subtest cursor-fb-leak: SUCCESS (4.417s)
[440.763034] [081/133] (582s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[440.821637] Starting subtest: multi-wait-all-for-submit-available-submitted
[440.823935] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[440.964658] [082/133] (581s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[441.020867] Subtest untiled-to-tiled: SKIP (0.000s)
[441.107254] [083/133] (581s left) gem_exec_alignment (pi)
[441.174705] Starting subtest: pi
[490.880935] Subtest pi: SUCCESS (49.703s)
[492.025038] [084/133] (530s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[492.178235] Starting subtest: y-tiled-16bpp-rotate-90
[492.182768] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[492.311206] [085/133] (530s left) syncobj_eventfd (binary-wait-signaled)
[492.382795] Starting subtest: binary-wait-signaled
[492.385211] Subtest binary-wait-signaled: SUCCESS (0.000s)
[492.525387] [086/133] (530s left) kms_flip (2x-flip-vs-fences-interruptible)
[492.621361] Starting subtest: 2x-flip-vs-fences-interruptible
[492.625739] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[492.768916] [087/133] (530s left) syncobj_wait (multi-wait-all-signaled)
[492.836599] Starting subtest: multi-wait-all-signaled
[492.838825] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[492.951239] [088/133] (530s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[493.047186] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[493.050470] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[493.174412] [089/133] (529s left) i915_drm_fdinfo (memory-info-resident)
[493.217559] Starting subtest: memory-info-resident
[493.219446] Starting dynamic subtest: smem0
[496.134781] Dynamic subtest smem0: SUCCESS (2.918s)
[496.136939] Subtest memory-info-resident: SUCCESS (2.919s)
[496.221718] [090/133] (526s left) kms_psr (fbc-pr-suspend)
[496.332146] Starting subtest: fbc-pr-suspend
[496.335691] Subtest fbc-pr-suspend: SKIP (0.000s)
[496.430182] [091/133] (526s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[496.531784] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[497.267820] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.737s)
[497.476774] [092/133] (525s left) gem_mmap_wc (write-gtt-read-wc)
[497.532315] Subtest write-gtt-read-wc: SKIP (0.000s)
[497.589676] [093/133] (525s left) gem_userptr_blits (stress-purge)
[497.664099] Starting subtest: stress-purge
[503.066879] Subtest stress-purge: SUCCESS (5.405s)
[503.216413] [094/133] (520s left) gem_fenced_exec_thrash (2-spare-fences)
[503.314064] Subtest 2-spare-fences: SKIP (0.000s)
[503.409362] [095/133] (520s left) kms_content_protection (legacy-hdcp14)
[503.574934] Starting subtest: legacy-hdcp14
[503.578848] Subtest legacy-hdcp14: SKIP (0.000s)
[503.727341] [096/133] (519s left) gem_exec_params (rel-constants-invalid)
[503.794826] Starting subtest: rel-constants-invalid
[503.796855] Subtest rel-constants-invalid: SUCCESS (0.000s)
[503.919102] [097/133] (519s left) kms_vrr (flipline)
[504.028924] Starting subtest: flipline
[504.034320] Subtest flipline: SKIP (0.000s)
[504.116607] [098/133] (519s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[504.223459] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[504.225293] Starting dynamic subtest: pipe-A-eDP-1
[504.241929] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[504.253619] Starting dynamic subtest: pipe-B-eDP-1
[504.271582] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[504.282281] Starting dynamic subtest: pipe-C-eDP-1
[504.298776] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[504.309277] Starting dynamic subtest: pipe-D-eDP-1
[504.325071] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[504.326842] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.014s)
[506.445400] [099/133] (517s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[506.550664] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[506.554956] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[506.681547] [100/133] (516s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[506.749727] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[506.751584] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[506.887918] [101/133] (516s left) kms_flip (bo-too-big-interruptible)
[506.991128] Starting subtest: bo-too-big-interruptible
[506.993307] Starting dynamic subtest: A-eDP1
[508.368414] Dynamic subtest A-eDP1: SUCCESS (1.376s)
[508.379381] Starting dynamic subtest: B-eDP1
[509.675221] Dynamic subtest B-eDP1: SUCCESS (1.306s)
[509.686228] Starting dynamic subtest: C-eDP1
[510.971948] Dynamic subtest C-eDP1: SUCCESS (1.296s)
[510.981148] Starting dynamic subtest: D-eDP1
[512.268699] Dynamic subtest D-eDP1: SUCCESS (1.296s)
[512.274427] Subtest bo-too-big-interruptible: SUCCESS (5.283s)
[513.462991] [102/133] (510s left) gem_mmap_offset (ptrace)
[513.531086] Starting subtest: ptrace
[513.533439] Starting dynamic subtest: smem0-wb
[513.552358] Dynamic subtest smem0-wb: SUCCESS (0.019s)
[513.564546] Starting dynamic subtest: smem0-wc
[513.572520] Dynamic subtest smem0-wc: SUCCESS (0.019s)
[513.582968] Starting dynamic subtest: smem0-uc
[513.593039] Dynamic subtest smem0-uc: SUCCESS (0.020s)
[513.595659] Subtest ptrace: SUCCESS (0.064s)
[513.730772] [103/133] (510s left) gem_exec_flush (basic-batch-kernel-default-uc)
[513.797061] Starting subtest: basic-batch-kernel-default-uc
[520.937676] Subtest basic-batch-kernel-default-uc: SUCCESS (7.142s)
[521.180612] [104/133] (502s left) kms_plane (plane-panning-bottom-right)
[521.284009] Starting subtest: plane-panning-bottom-right
[521.286274] Starting dynamic subtest: pipe-A
[522.963705] Dynamic subtest pipe-A: SUCCESS (1.679s)
[522.973328] Starting dynamic subtest: pipe-B
[525.380836] Dynamic subtest pipe-B: SUCCESS (2.414s)
[525.383197] Subtest plane-panning-bottom-right: SUCCESS (4.096s)
[526.259157] [105/133] (497s left) kms_cursor_legacy (forked-move)
[526.382468] Starting subtest: forked-move
[526.384830] Starting dynamic subtest: pipe-A
[531.832825] Dynamic subtest pipe-A: SUCCESS (5.447s)
[531.847037] Starting dynamic subtest: pipe-B
[537.294699] Dynamic subtest pipe-B: SUCCESS (5.459s)
[537.307629] Starting dynamic subtest: pipe-C
[542.767633] Dynamic subtest pipe-C: SUCCESS (5.470s)
[542.779295] Starting dynamic subtest: pipe-D
[548.231076] Dynamic subtest pipe-D: SUCCESS (5.461s)
[548.241115] Starting dynamic subtest: all-pipes
[553.730253] Dynamic subtest all-pipes: SUCCESS (5.496s)
[553.732628] Subtest forked-move: SUCCESS (27.344s)
[553.899511] [106/133] (470s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[554.003260] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[554.007343] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[554.086114] [107/133] (469s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[554.185167] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[554.187258] Starting dynamic subtest: pipe-A-eDP-1
[570.930493] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.281s)
[570.940620] Starting dynamic subtest: pipe-B-eDP-1
[587.900008] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.368s)
[587.910552] Starting dynamic subtest: pipe-C-eDP-1
[604.882994] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.357s)
[604.893316] Starting dynamic subtest: pipe-D-eDP-1
[621.870703] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.359s)
[621.872559] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (9.370s)
[623.048340] [108/133] (400s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[623.154960] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[623.167339] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.010s)
[623.251884] [109/133] (400s left) kms_invalid_mode (zero-clock)
[623.347576] Starting subtest: zero-clock
[623.349727] Starting dynamic subtest: pipe-A-eDP-1
[623.634336] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[623.644927] Starting dynamic subtest: pipe-B-eDP-1
[623.647162] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[623.658433] Starting dynamic subtest: pipe-C-eDP-1
[623.660308] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[623.669469] Starting dynamic subtest: pipe-D-eDP-1
[623.671970] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[623.674563] Subtest zero-clock: SUCCESS (0.294s)
[624.447006] [110/133] (399s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[624.566481] Starting subtest: 2x-flip-vs-cursor-atomic
[624.571084] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.002s)
[624.744390] [111/133] (399s left) gem_mmap_gtt (basic-copy)
[624.807097] Subtest basic-copy: SKIP (0.000s)
[624.874507] [112/133] (399s left) i915_pm_rps (thresholds-idle-park)
[624.940992] Starting subtest: thresholds-idle-park
[624.945467] Subtest thresholds-idle-park: SKIP (0.001s)
[625.047783] [113/133] (399s left) gen3_render_tiledy_blits
[625.177859] [114/133] (399s left) gem_reg_read (timestamp-monotonic)
[625.233471] Starting subtest: timestamp-monotonic
[630.165223] Subtest timestamp-monotonic: SUCCESS (4.925s)
[630.251217] [115/133] (394s left) dmabuf_sync_file (export-wait-after-attach)
[630.291897] Starting subtest: export-wait-after-attach
[630.294045] Subtest export-wait-after-attach: SUCCESS (0.001s)
[630.360009] [116/133] (393s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[630.468434] Starting subtest: crc-primary-basic-y-tiled-ccs
[630.471007] Starting dynamic subtest: pipe-A-eDP-1
[630.492690] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[630.502904] Starting dynamic subtest: pipe-B-eDP-1
[630.525458] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[630.534932] Starting dynamic subtest: pipe-C-eDP-1
[630.554991] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[630.564145] Starting dynamic subtest: pipe-D-eDP-1
[630.586237] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[630.590587] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s)
[632.754471] [117/133] (391s left) kms_atomic (plane-primary-legacy)
[632.852958] Starting subtest: plane-primary-legacy
[632.855340] Starting dynamic subtest: pipe-A-eDP-1
[633.312355] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.460s)
[633.314715] Subtest plane-primary-legacy: SUCCESS (0.462s)
[634.153255] [118/133] (390s left) syncobj_wait (invalid-signal-one-illegal-handle)
[634.204724] Starting subtest: invalid-signal-one-illegal-handle
[634.206931] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[634.324916] [119/133] (390s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[634.420558] Starting subtest: fbc-psr2-sprite-plane-onoff
[634.422844] Starting dynamic subtest: eDP-1
[634.427125] Dynamic subtest eDP-1: SKIP (0.000s)
[634.431408] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[634.520051] [120/133] (389s left) kms_cursor_crc (cursor-random-128x42)
[634.749373] Starting subtest: cursor-random-128x42
[634.796813] Subtest cursor-random-128x42: SKIP (0.042s)
[635.038352] [121/133] (389s left) prime_mmap (test_errors)
[635.105630] Starting subtest: test_errors
[635.107226] Starting dynamic subtest: test_errors-smem
[635.200722] Dynamic subtest test_errors-smem: SUCCESS (0.096s)
[635.203016] Subtest test_errors: SUCCESS (0.097s)
[635.323322] [122/133] (389s left) kms_psr (fbc-pr-dpms)
[635.419201] Starting subtest: fbc-pr-dpms
[635.422840] Subtest fbc-pr-dpms: SKIP (0.000s)
[635.520043] [123/133] (389s left) kms_cursor_crc (cursor-onscreen-512x512)
[635.787761] Starting subtest: cursor-onscreen-512x512
[635.791431] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[635.950574] [124/133] (388s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[636.047014] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[636.059445] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s)
[636.145860] [125/133] (388s left) kms_psr (pr-primary-mmap-cpu)
[636.248365] Starting subtest: pr-primary-mmap-cpu
[636.252163] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[636.330021] [126/133] (388s left) gem_ctx_param (invalid-get-engines)
[636.389171] Starting subtest: invalid-get-engines
[636.391577] Subtest invalid-get-engines: SUCCESS (0.001s)
[636.526827] [127/133] (388s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[636.584675] Starting subtest: y-tiled-to-vebox-yf-tiled
[636.588579] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[636.784328] [128/133] (388s left) api_intel_allocator (reserve-simple)
[636.847902] Starting subtest: reserve-simple
[636.850315] Subtest reserve-simple: SUCCESS (0.004s)
[636.973560] [129/133] (387s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[637.022727] Starting subtest: wait-all-for-submit-delayed-submit
[637.124143] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[637.210848] [130/133] (387s left) gem_basic (create-close)
[637.270802] Starting subtest: create-close
[637.275318] Subtest create-close: SUCCESS (0.000s)
[637.382783] [131/133] (387s left) gem_busy (extended)
[637.571635] Starting subtest: extended
[637.574437] Starting dynamic subtest: rcs0
[637.679181] Dynamic subtest rcs0: SUCCESS (0.107s)
[637.692059] Starting dynamic subtest: bcs0
[637.721367] Dynamic subtest bcs0: SUCCESS (0.040s)
[637.732401] Starting dynamic subtest: vcs0
[639.191305] Dynamic subtest vcs0: SUCCESS (1.465s)
[639.205256] Starting dynamic subtest: vcs1
[641.175064] Dynamic subtest vcs1: SUCCESS (1.980s)
[641.187724] Starting dynamic subtest: vecs0
[643.221722] Dynamic subtest vecs0: SUCCESS (2.043s)
[643.234690] Starting dynamic subtest: ccs0
[643.270419] Dynamic subtest ccs0: SUCCESS (0.048s)
[643.272967] Subtest extended: SUCCESS (5.697s)
[643.565034] [132/133] (381s left) kms_pm_dc (dc5-retention-flops)
[644.677715] Starting subtest: dc5-retention-flops
[644.682250] Subtest dc5-retention-flops: SKIP (0.000s)
[644.776823] [133/133] (380s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[645.170738] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[646.030555] 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.