[57.768794] Initializing watchdogs
[57.768836]   /dev/watchdog0
[57.783317] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.787693] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.790097] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.792161] [001/133] (960s left) syncobj_timeline (wait-all-delayed-signal)
[57.852332] Starting subtest: wait-all-delayed-signal
[57.957579] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[58.040531] [002/133] (960s left) gem_create (busy-create)
[58.092744] Starting subtest: busy-create
[58.093582] Starting dynamic subtest: smem0
[91.962091] Dynamic subtest smem0: SUCCESS (33.936s)
[91.963591] Subtest busy-create: SUCCESS (33.937s)
[92.144743] [003/133] (926s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[92.255925] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[114.692721] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.438s)
[114.841412] [004/133] (903s left) gem_lmem_swapping (heavy-verify-random)
[114.891257] Subtest heavy-verify-random: SKIP (0.000s)
[114.926566] [005/133] (903s left) gem_exec_balancer (persistence)
[115.188585] Starting subtest: persistence
[116.084436] Subtest persistence: SUCCESS (0.895s)
[116.207432] [006/133] (902s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[116.313048] Starting subtest: yf-tiled-32bpp-rotate-90
[116.314848] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[116.406807] [007/133] (902s left) gem_exec_fence (syncobj-timeline-unused-fence)
[116.988358] Starting subtest: syncobj-timeline-unused-fence
[116.991424] Subtest syncobj-timeline-unused-fence: SUCCESS (0.007s)
[118.026593] [FACT gem_exec_fence (syncobj-timeline-unused-fence)] new: kernel.kmod_is_loaded.vgem: true
[118.028958] [008/133] (900s left) gem_mmap_wc (write-read)
[118.079484] Subtest write-read: SKIP (0.000s)
[118.132882] [009/133] (900s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[118.224518] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[125.185103] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.962s)
[125.312907] [010/133] (893s left) kms_hdmi_inject (inject-4k)
[125.654945] Starting subtest: inject-4k
[125.965518] Subtest inject-4k: SUCCESS (0.311s)
[126.566800] [011/133] (892s left) gem_mmap_gtt (basic-short)
[126.627146] Subtest basic-short: SKIP (0.000s)
[126.695249] [012/133] (891s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[126.784212] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[126.785905] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[126.906764] [013/133] (891s left) gem_render_linear_blits (basic)
[126.972241] Starting subtest: basic
[126.995064] Subtest basic: SUCCESS (0.023s)
[127.106311] [014/133] (891s left) gem_pxp (verify-pxp-stale-buf-execution)
[127.226459] Starting subtest: verify-pxp-stale-buf-execution
[128.288103] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.062s)
[128.430709] [015/133] (890s left) sysfs_timeslice_duration (idempotent)
[128.482694] Starting subtest: idempotent
[128.483743] Starting dynamic subtest: vecs0
[128.484747] Dynamic subtest vecs0: SUCCESS (0.000s)
[128.491349] Starting dynamic subtest: ccs0
[128.492151] Dynamic subtest ccs0: SUCCESS (0.000s)
[128.497854] Starting dynamic subtest: vcs0
[128.498680] Dynamic subtest vcs0: SUCCESS (0.000s)
[128.504597] Starting dynamic subtest: bcs0
[128.505479] Dynamic subtest bcs0: SUCCESS (0.000s)
[128.511481] Starting dynamic subtest: rcs0
[128.512277] Dynamic subtest rcs0: SUCCESS (0.000s)
[128.517886] Starting dynamic subtest: vcs1
[128.518718] Dynamic subtest vcs1: SUCCESS (0.000s)
[128.519543] Subtest idempotent: SUCCESS (0.005s)
[128.611283] [016/133] (890s left) i915_query (query-topology-kernel-writes)
[128.666713] Starting subtest: query-topology-kernel-writes
[128.667701] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[128.779403] [017/133] (889s left) gem_exec_balancer (bonded-false-hang)
[129.039798] Starting subtest: bonded-false-hang
[129.042218] Subtest bonded-false-hang: SKIP (0.000s)
[129.154200] [018/133] (889s left) i915_pm_rpm (gem-pread)
[131.094325] Starting subtest: gem-pread
[133.146096] Subtest gem-pread: SUCCESS (2.054s)
[133.255168] [019/133] (885s left) gem_exec_params (invalid-fence-in)
[133.315848] Starting subtest: invalid-fence-in
[133.316756] Subtest invalid-fence-in: SUCCESS (0.000s)
[133.449794] [020/133] (885s left) kms_chamelium_color (ctm-0-25)
[133.541301] Subtest ctm-0-25: SKIP (0.000s)
[133.579175] [021/133] (885s left) kms_chamelium_hpd (dp-hpd-storm)
[133.960522] Subtest dp-hpd-storm: SKIP (0.000s)
[134.799100] [022/133] (884s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[134.849504] Starting subtest: etime-single-wait-for-submit-submitted
[134.956752] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.106s)
[135.037780] [023/133] (883s left) gem_tiled_blits (interruptible)
[135.093628] Subtest interruptible: SKIP (0.000s)
[135.171272] [024/133] (883s left) perf (create-destroy-userspace-config)
[135.289353] Starting subtest: create-destroy-userspace-config
[135.305066] Subtest create-destroy-userspace-config: SUCCESS (0.016s)
[135.336183] [025/133] (883s left) kms_async_flips (async-flip-dpms)
[135.433061] Starting subtest: async-flip-dpms
[135.804922] Starting dynamic subtest: pipe-A-eDP-1
[139.631083] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.825s)
[139.996677] Starting dynamic subtest: pipe-B-eDP-1
[142.804073] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.813s)
[143.185414] Starting dynamic subtest: pipe-C-eDP-1
[145.975523] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.796s)
[146.349821] Starting dynamic subtest: pipe-D-eDP-1
[149.132719] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.788s)
[149.133652] Subtest async-flip-dpms: SUCCESS (13.701s)
[150.339958] [026/133] (868s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[150.451721] Starting subtest: cursorA-vs-flipA-atomic-transitions
[161.619763] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.165s)
[162.449962] [027/133] (856s left) kms_getfb (getfb2-handle-not-fb)
[162.557633] Starting subtest: getfb2-handle-not-fb
[162.558555] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[162.690127] [028/133] (856s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[162.797178] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[166.797235] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.002s)
[167.973499] [029/133] (851s left) prime_busy (after-wait)
[168.049232] Starting subtest: after-wait
[168.056523] Starting dynamic subtest: rcs0
[168.113477] Dynamic subtest rcs0: SUCCESS (0.057s)
[168.121893] Starting dynamic subtest: bcs0
[168.188717] Dynamic subtest bcs0: SUCCESS (0.074s)
[168.196416] Starting dynamic subtest: vcs0
[168.228759] Dynamic subtest vcs0: SUCCESS (0.039s)
[168.235798] Starting dynamic subtest: vcs1
[168.268457] Dynamic subtest vcs1: SUCCESS (0.039s)
[168.275310] Starting dynamic subtest: vecs0
[168.309050] Dynamic subtest vecs0: SUCCESS (0.040s)
[168.316168] Starting dynamic subtest: ccs0
[168.349812] Dynamic subtest ccs0: SUCCESS (0.040s)
[168.459275] Subtest after-wait: SUCCESS (0.408s)
[168.536790] [030/133] (850s left) kms_flip (2x-flip-vs-dpms)
[168.631615] Starting subtest: 2x-flip-vs-dpms
[168.643134] Subtest 2x-flip-vs-dpms: SKIP (0.011s)
[168.782343] [031/133] (850s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[168.874040] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[168.876064] Starting dynamic subtest: pipe-A-default-mode
[170.018689] Dynamic subtest pipe-A-default-mode: SKIP (1.142s)
[170.020505] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.143s)
[170.204859] [032/133] (849s left) perf (blocking-parameterized)
[170.291462] Starting subtest: blocking-parameterized
[190.314349] Subtest blocking-parameterized: SUCCESS (20.019s)
[190.357224] [033/133] (828s left) gem_spin_batch (spin-all)
[190.418495] Starting subtest: spin-all
[190.442347] Subtest spin-all: SUCCESS (0.023s)
[191.941180] [034/133] (827s left) kms_psr (psr2-sprite-mmap-cpu)
[192.034100] Starting subtest: psr2-sprite-mmap-cpu
[192.034950] Starting dynamic subtest: eDP-1
[193.780702] Dynamic subtest eDP-1: SUCCESS (1.746s)
[193.781614] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.747s)
[194.649295] [035/133] (824s left) kms_color (ctm-signed)
[194.743728] Starting subtest: ctm-signed
[194.744777] Starting dynamic subtest: pipe-A-eDP-1
[196.805183] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.061s)
[196.813370] Starting dynamic subtest: pipe-B-eDP-1
[199.563573] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.757s)
[199.569964] Starting dynamic subtest: pipe-C-eDP-1
[202.188764] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.625s)
[202.195060] Starting dynamic subtest: pipe-D-eDP-1
[204.811671] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.621s)
[204.812631] Subtest ctm-signed: SUCCESS (10.068s)
[205.684199] [036/133] (813s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[205.764912] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[205.766733] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[205.842643] [037/133] (813s left) gem_exec_schedule (u-submit-late-slice)
[205.897285] Starting subtest: u-submit-late-slice
[205.898333] Starting dynamic subtest: rcs0
[205.935780] Dynamic subtest rcs0: SUCCESS (0.038s)
[205.944608] Starting dynamic subtest: bcs0
[205.963397] Dynamic subtest bcs0: SUCCESS (0.027s)
[205.971512] Starting dynamic subtest: vcs0
[205.993547] Dynamic subtest vcs0: SUCCESS (0.029s)
[206.000093] Starting dynamic subtest: vcs1
[206.024463] Dynamic subtest vcs1: SUCCESS (0.030s)
[206.030934] Starting dynamic subtest: vecs0
[206.053166] Dynamic subtest vecs0: SUCCESS (0.028s)
[206.060222] Starting dynamic subtest: ccs0
[206.085632] Dynamic subtest ccs0: SUCCESS (0.032s)
[206.086508] Subtest u-submit-late-slice: SUCCESS (0.189s)
[208.007502] [038/133] (811s left) gem_eio (in-flight-external)
[208.245257] Starting subtest: in-flight-external
[209.967064] Subtest in-flight-external: SUCCESS (1.721s)
[210.089740] [039/133] (809s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[210.180618] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[210.182379] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[210.300259] [040/133] (809s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[210.390670] Starting subtest: x-tiled-32bpp-rotate-0
[211.735391] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.345s)
[211.908167] [041/133] (807s left) i915_hangman (engine-engine-error)
[211.977533] Starting subtest: engine-engine-error
[211.978557] Starting dynamic subtest: rcs0
[213.879683] Dynamic subtest rcs0: SUCCESS (1.899s)
[213.889881] Starting dynamic subtest: bcs0
[215.863390] Dynamic subtest bcs0: SUCCESS (1.981s)
[215.873489] Starting dynamic subtest: vcs0
[217.848226] Dynamic subtest vcs0: SUCCESS (1.982s)
[217.857749] Starting dynamic subtest: vcs1
[219.895762] Dynamic subtest vcs1: SUCCESS (2.045s)
[219.904823] Starting dynamic subtest: vecs0
[221.879488] Dynamic subtest vecs0: SUCCESS (1.981s)
[221.889264] Starting dynamic subtest: ccs0
[223.862966] Dynamic subtest ccs0: SUCCESS (1.981s)
[223.864364] Subtest engine-engine-error: SUCCESS (11.884s)
[223.951490] [042/133] (795s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[224.036609] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[224.038348] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[224.172365] [043/133] (795s left) gem_mmap_gtt (isolation)
[224.228840] Subtest isolation: SKIP (0.000s)
[224.279520] [044/133] (795s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[224.368496] Starting subtest: primary-yf-tiled-reflect-x-180
[224.441221] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.072s)
[224.547460] [045/133] (795s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[224.640900] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[224.642620] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[224.716015] [046/133] (794s left) kms_flip (wf_vblank-ts-check-interruptible)
[224.816811] Starting subtest: wf_vblank-ts-check-interruptible
[224.818915] Starting dynamic subtest: A-eDP1
[233.719983] Dynamic subtest A-eDP1: SUCCESS (8.901s)
[233.729668] Starting dynamic subtest: B-eDP1
[242.663228] Dynamic subtest B-eDP1: SUCCESS (8.942s)
[242.671171] Starting dynamic subtest: C-eDP1
[251.583310] Dynamic subtest C-eDP1: SUCCESS (8.918s)
[251.590989] Starting dynamic subtest: D-eDP1
[260.433558] Dynamic subtest D-eDP1: SUCCESS (8.849s)
[260.437949] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.620s)
[261.670094] [047/133] (758s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[261.765496] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[261.766394] Starting dynamic subtest: pipe-A
[261.784063] Dynamic subtest pipe-A: SKIP (0.016s)
[261.791088] Starting dynamic subtest: pipe-B
[261.811528] Dynamic subtest pipe-B: SKIP (0.027s)
[261.818533] Starting dynamic subtest: pipe-C
[261.838866] Dynamic subtest pipe-C: SKIP (0.027s)
[261.845512] Starting dynamic subtest: pipe-D
[261.865942] Dynamic subtest pipe-D: SKIP (0.027s)
[261.867620] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.100s)
[262.004433] [048/133] (757s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[262.101634] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[262.102530] Starting dynamic subtest: pipe-A-eDP-1
[262.111198] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[262.120587] Starting dynamic subtest: pipe-B-eDP-1
[262.129141] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[262.135771] Starting dynamic subtest: pipe-C-eDP-1
[262.143776] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[262.150304] Starting dynamic subtest: pipe-D-eDP-1
[262.158624] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[262.160285] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[264.367205] [049/133] (755s left) perf_pmu (busy-idle-check-all)
[264.408666] Starting subtest: busy-idle-check-all
[264.409553] Starting dynamic subtest: rcs0
[265.082706] Dynamic subtest rcs0: SUCCESS (0.673s)
[265.093592] Starting dynamic subtest: bcs0
[265.735385] Dynamic subtest bcs0: SUCCESS (0.651s)
[265.745965] Starting dynamic subtest: vcs0
[266.902461] Dynamic subtest vcs0: SUCCESS (1.164s)
[266.914609] Starting dynamic subtest: vcs1
[268.889506] Dynamic subtest vcs1: SUCCESS (1.982s)
[268.899806] Starting dynamic subtest: vecs0
[270.935954] Dynamic subtest vecs0: SUCCESS (2.045s)
[270.945645] Starting dynamic subtest: ccs0
[271.589728] Dynamic subtest ccs0: SUCCESS (0.654s)
[271.593727] Subtest busy-idle-check-all: SUCCESS (7.182s)
[271.723090] [050/133] (748s left) gem_softpin (overlap)
[271.790551] Starting subtest: overlap
[272.747756] Subtest overlap: SUCCESS (0.954s)
[272.902455] [051/133] (746s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[273.000887] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[273.002571] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[273.123083] [052/133] (746s left) gem_mmap_gtt (basic-small-copy-odd)
[273.185075] Subtest basic-small-copy-odd: SKIP (0.000s)
[273.250013] [053/133] (746s left) kms_pipe_crc_basic (read-crc)
[273.339238] Starting subtest: read-crc
[273.340047] Starting dynamic subtest: pipe-A-eDP-1
[274.040493] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.700s)
[274.047543] Starting dynamic subtest: pipe-B-eDP-1
[275.439373] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.398s)
[275.446628] Starting dynamic subtest: pipe-C-eDP-1
[276.784965] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.345s)
[276.793432] Starting dynamic subtest: pipe-D-eDP-1
[278.153647] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.366s)
[278.154611] Subtest read-crc: SUCCESS (4.815s)
[278.997106] [054/133] (740s left) kms_big_fb (linear-16bpp-rotate-90)
[279.107340] Starting subtest: linear-16bpp-rotate-90
[279.126062] Subtest linear-16bpp-rotate-90: SKIP (0.018s)
[279.235880] [055/133] (740s left) kms_cursor_edge_walk (128x128-top-bottom)
[279.328568] Starting subtest: 128x128-top-bottom
[279.329478] Starting dynamic subtest: pipe-A-eDP-1
[282.757864] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.429s)
[282.766150] Starting dynamic subtest: pipe-D-eDP-1
[285.873651] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.113s)
[285.874579] Subtest 128x128-top-bottom: SUCCESS (6.545s)
[286.699137] [056/133] (733s left) kms_setmode (invalid-clone-exclusive-crtc)
[286.754519] Starting subtest: invalid-clone-exclusive-crtc
[286.757376] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[286.878497] [057/133] (733s left) kms_psr (psr-primary-mmap-gtt)
[286.972291] Starting subtest: psr-primary-mmap-gtt
[286.973101] Starting dynamic subtest: eDP-1
[288.397939] Dynamic subtest eDP-1: SKIP (1.421s)
[288.400637] Subtest psr-primary-mmap-gtt: SKIP (1.423s)
[288.584854] [058/133] (731s left) kms_fb_coherency (memset-crc)
[288.681371] Starting subtest: memset-crc
[288.682333] Starting dynamic subtest: mmap-offset-wc
[289.057114] Dynamic subtest mmap-offset-wc: SUCCESS (0.376s)
[289.357077] Starting dynamic subtest: mmap-offset-uc
[295.474429] Dynamic subtest mmap-offset-uc: SUCCESS (6.124s)
[295.754186] Subtest memset-crc: SUCCESS (7.072s)
[296.590786] [059/133] (723s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[296.680189] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[300.814039] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.134s)
[301.993426] [060/133] (718s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[302.073044] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[308.721462] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.645s)
[308.873267] [061/133] (711s left) kms_pm_rpm (modeset-stress-extra-wait)
[311.106677] Starting subtest: modeset-stress-extra-wait
[365.369076] Subtest modeset-stress-extra-wait: SUCCESS (54.262s)
[365.461404] [062/133] (654s left) kms_frontbuffer_tracking (fbc-2p-rte)
[365.555180] Starting subtest: fbc-2p-rte
[365.556882] Subtest fbc-2p-rte: SKIP (0.000s)
[365.679896] [063/133] (654s left) api_intel_bb (reset-flags)
[365.742672] Starting subtest: reset-flags
[365.750332] Subtest reset-flags: SUCCESS (0.008s)
[365.911073] [064/133] (654s left) gem_ctx_persistence (legacy-engines-mixed-process)
[365.962880] Starting subtest: legacy-engines-mixed-process
[365.963790] Starting dynamic subtest: render
[367.922798] Dynamic subtest render: SUCCESS (1.961s)
[367.934726] Starting dynamic subtest: bsd1
[369.924839] Dynamic subtest bsd1: SUCCESS (1.999s)
[369.933256] Starting dynamic subtest: bsd2
[371.912189] Dynamic subtest bsd2: SUCCESS (1.983s)
[371.921766] Starting dynamic subtest: blt
[373.894582] Dynamic subtest blt: SUCCESS (1.983s)
[373.902845] Starting dynamic subtest: vebox
[375.915510] Dynamic subtest vebox: SUCCESS (2.020s)
[375.918081] Subtest legacy-engines-mixed-process: SUCCESS (9.955s)
[376.001060] [065/133] (644s left) gem_mmap (bad-offset)
[376.054062] Subtest bad-offset: SKIP (0.000s)
[376.103430] [066/133] (644s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[376.191536] Starting subtest: fbc-1p-pri-indfb-multidraw
[389.303619] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (13.112s)
[390.730370] [067/133] (629s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[390.823885] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[390.825558] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[390.910461] [068/133] (629s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[390.995498] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[391.022971] Starting dynamic subtest: pipe-A-plane-0
[391.025023] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[391.033740] Starting dynamic subtest: pipe-A-plane-3
[391.035356] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[391.042450] Starting dynamic subtest: pipe-A-plane-5
[391.044059] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[392.099815] Starting dynamic subtest: pipe-B-plane-0
[392.101624] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[392.108790] Starting dynamic subtest: pipe-B-plane-3
[392.110623] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[392.117661] Starting dynamic subtest: pipe-B-plane-5
[392.119403] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[392.400372] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (1.404s)
[393.278097] [069/133] (627s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[393.376326] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[393.377220] Starting dynamic subtest: pipe-A-eDP-1
[393.398547] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[393.410765] Starting dynamic subtest: pipe-B-eDP-1
[393.432536] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[393.443194] Starting dynamic subtest: pipe-C-eDP-1
[393.463864] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[393.471194] Starting dynamic subtest: pipe-D-eDP-1
[393.493326] Dynamic subtest pipe-D-eDP-1: SKIP (0.002s)
[393.495041] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.011s)
[395.549697] [070/133] (624s left) gem_exec_schedule (pi-userfault)
[395.731200] Starting subtest: pi-userfault
[395.732185] Starting dynamic subtest: rcs0
[395.742737] Dynamic subtest rcs0: SUCCESS (0.012s)
[395.751992] Starting dynamic subtest: bcs0
[395.753277] Dynamic subtest bcs0: SUCCESS (0.008s)
[395.760839] Starting dynamic subtest: vcs0
[395.761999] Dynamic subtest vcs0: SUCCESS (0.007s)
[395.769340] Starting dynamic subtest: vcs1
[395.770461] Dynamic subtest vcs1: SUCCESS (0.008s)
[395.777937] Starting dynamic subtest: vecs0
[395.779085] Dynamic subtest vecs0: SUCCESS (0.008s)
[395.786508] Starting dynamic subtest: ccs0
[395.787596] Dynamic subtest ccs0: SUCCESS (0.007s)
[395.788561] Subtest pi-userfault: SUCCESS (0.054s)
[395.972652] [071/133] (624s left) gen7_exec_parse (load-register-reg)
[396.036780] Subtest load-register-reg: SKIP (0.000s)
[396.113410] [072/133] (624s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[396.217122] Starting subtest: 4-tiled-64bpp-rotate-0
[397.673804] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.457s)
[397.847766] [073/133] (622s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[397.931473] Starting subtest: fbcpsr-modesetfrombusy
[404.088961] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.158s)
[404.243828] [074/133] (616s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[404.338691] Starting subtest: psr-rgb101010-draw-mmap-wc
[411.270772] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (6.933s)
[411.392645] [075/133] (609s left) kms_plane_multiple (tiling-yf)
[411.492512] Starting subtest: tiling-yf
[411.494258] Subtest tiling-yf: SKIP (0.000s)
[411.572582] [076/133] (609s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[411.661778] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[411.663750] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[411.787864] [077/133] (608s left) perf (oa-exponents)
[411.880541] Starting subtest: oa-exponents
[411.881609] Starting dynamic subtest: 0-rcs0
[413.649437] Dynamic subtest 0-rcs0: SUCCESS (1.766s)
[413.657126] Starting dynamic subtest: 1-vcs1
[415.478812] Dynamic subtest 1-vcs1: SUCCESS (1.828s)
[415.479784] Subtest oa-exponents: SUCCESS (3.596s)
[415.518770] [078/133] (605s left) gem_exec_fence (parallel)
[415.704480] Starting subtest: parallel
[415.705586] Starting dynamic subtest: rcs0
[417.856689] Dynamic subtest rcs0: SUCCESS (2.152s)
[417.864771] Starting dynamic subtest: bcs0
[420.005881] Dynamic subtest bcs0: SUCCESS (2.148s)
[420.015682] Starting dynamic subtest: vcs0
[422.159832] Dynamic subtest vcs0: SUCCESS (2.153s)
[422.168229] Starting dynamic subtest: vcs1
[424.312486] Dynamic subtest vcs1: SUCCESS (2.152s)
[424.320966] Starting dynamic subtest: vecs0
[426.467389] Dynamic subtest vecs0: SUCCESS (2.154s)
[426.476502] Starting dynamic subtest: ccs0
[428.617113] Dynamic subtest ccs0: SUCCESS (2.148s)
[428.618041] Subtest parallel: SUCCESS (12.913s)
[431.035696] [079/133] (589s left) gem_exec_schedule (u-lateslice)
[431.094125] Starting subtest: u-lateslice
[431.095006] Starting dynamic subtest: rcs0
[431.126141] Dynamic subtest rcs0: SUCCESS (0.032s)
[431.133951] Starting dynamic subtest: bcs0
[431.147902] Dynamic subtest bcs0: SUCCESS (0.021s)
[431.155252] Starting dynamic subtest: vcs0
[431.170870] Dynamic subtest vcs0: SUCCESS (0.022s)
[431.178040] Starting dynamic subtest: vcs1
[431.192764] Dynamic subtest vcs1: SUCCESS (0.021s)
[431.199996] Starting dynamic subtest: vecs0
[431.217859] Dynamic subtest vecs0: SUCCESS (0.024s)
[431.225816] Starting dynamic subtest: ccs0
[431.242263] Dynamic subtest ccs0: SUCCESS (0.024s)
[431.243119] Subtest u-lateslice: SUCCESS (0.149s)
[433.028251] [080/133] (587s left) kms_universal_plane (cursor-fb-leak)
[433.129330] Starting subtest: cursor-fb-leak
[433.130220] Starting dynamic subtest: pipe-A-eDP-1
[433.475994] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.346s)
[433.487065] Starting dynamic subtest: pipe-B-eDP-1
[434.841289] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.361s)
[434.852621] Starting dynamic subtest: pipe-C-eDP-1
[436.179019] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.335s)
[436.189493] Starting dynamic subtest: pipe-D-eDP-1
[437.505958] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.325s)
[437.506977] Subtest cursor-fb-leak: SUCCESS (4.378s)
[438.675456] [081/133] (582s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[438.731591] Starting subtest: multi-wait-all-for-submit-available-submitted
[438.732541] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[438.856186] [082/133] (581s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[438.915196] Subtest untiled-to-tiled: SKIP (0.000s)
[438.998378] [083/133] (581s left) gem_exec_alignment (pi)
[439.068359] Starting subtest: pi
[489.904973] Subtest pi: SUCCESS (50.835s)
[490.940666] [084/133] (529s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[491.080765] Starting subtest: y-tiled-16bpp-rotate-90
[491.082398] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[491.209883] [085/133] (529s left) syncobj_eventfd (binary-wait-signaled)
[491.269992] Starting subtest: binary-wait-signaled
[491.271277] Subtest binary-wait-signaled: SUCCESS (0.000s)
[491.397626] [086/133] (529s left) kms_flip (2x-flip-vs-fences-interruptible)
[491.496960] Starting subtest: 2x-flip-vs-fences-interruptible
[491.498781] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[491.628771] [087/133] (529s left) syncobj_wait (multi-wait-all-signaled)
[491.691777] Starting subtest: multi-wait-all-signaled
[491.692800] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[491.805448] [088/133] (529s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[491.909947] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[491.911768] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[492.049536] [089/133] (529s left) i915_drm_fdinfo (memory-info-resident)
[492.084121] Starting subtest: memory-info-resident
[492.085086] Starting dynamic subtest: smem0
[494.540860] Dynamic subtest smem0: SUCCESS (2.456s)
[494.542531] Subtest memory-info-resident: SUCCESS (2.457s)
[494.634440] [090/133] (526s left) kms_psr (fbc-pr-suspend)
[494.731972] Starting subtest: fbc-pr-suspend
[494.733722] Subtest fbc-pr-suspend: SKIP (0.000s)
[494.847072] [091/133] (526s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[494.942997] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[495.657275] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.714s)
[495.827185] [092/133] (525s left) gem_mmap_wc (write-gtt-read-wc)
[495.876058] Subtest write-gtt-read-wc: SKIP (0.000s)
[495.950694] [093/133] (525s left) gem_userptr_blits (stress-purge)
[496.012799] Starting subtest: stress-purge
[501.416470] Subtest stress-purge: SUCCESS (5.403s)
[501.582432] [094/133] (519s left) gem_fenced_exec_thrash (2-spare-fences)
[501.684824] Subtest 2-spare-fences: SKIP (0.000s)
[501.769901] [095/133] (519s left) kms_content_protection (legacy-hdcp14)
[501.930274] Starting subtest: legacy-hdcp14
[501.932065] Subtest legacy-hdcp14: SKIP (0.000s)
[502.065034] [096/133] (519s left) gem_exec_params (rel-constants-invalid)
[502.129972] Starting subtest: rel-constants-invalid
[502.131111] Subtest rel-constants-invalid: SUCCESS (0.000s)
[502.245533] [097/133] (519s left) kms_vrr (flipline)
[502.341235] Starting subtest: flipline
[502.343736] Subtest flipline: SKIP (0.000s)
[502.432755] [098/133] (518s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[502.535224] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[502.536031] Starting dynamic subtest: pipe-A-eDP-1
[502.543521] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[502.553288] Starting dynamic subtest: pipe-B-eDP-1
[502.560458] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[502.568135] Starting dynamic subtest: pipe-C-eDP-1
[502.575159] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[502.582356] Starting dynamic subtest: pipe-D-eDP-1
[502.589385] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[502.590236] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[504.831147] [099/133] (516s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[504.916252] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[504.917811] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[505.033194] [100/133] (516s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[505.088665] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[505.089502] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[505.218796] [101/133] (516s left) kms_flip (bo-too-big-interruptible)
[505.302616] Starting subtest: bo-too-big-interruptible
[505.305861] Starting dynamic subtest: A-eDP1
[506.575979] Dynamic subtest A-eDP1: SUCCESS (1.271s)
[506.585468] Starting dynamic subtest: B-eDP1
[507.905373] Dynamic subtest B-eDP1: SUCCESS (1.327s)
[507.912972] Starting dynamic subtest: C-eDP1
[509.139611] Dynamic subtest C-eDP1: SUCCESS (1.233s)
[509.148507] Starting dynamic subtest: D-eDP1
[510.387868] Dynamic subtest D-eDP1: SUCCESS (1.247s)
[510.391969] Subtest bo-too-big-interruptible: SUCCESS (5.089s)
[511.584254] [102/133] (509s left) gem_mmap_offset (ptrace)
[511.644438] Starting subtest: ptrace
[511.646869] Starting dynamic subtest: smem0-wb
[511.665640] Dynamic subtest smem0-wb: SUCCESS (0.019s)
[511.675070] Starting dynamic subtest: smem0-wc
[511.685486] Dynamic subtest smem0-wc: SUCCESS (0.019s)
[511.692972] Starting dynamic subtest: smem0-uc
[511.705435] Dynamic subtest smem0-uc: SUCCESS (0.019s)
[511.706261] Subtest ptrace: SUCCESS (0.062s)
[511.850481] [103/133] (509s left) gem_exec_flush (basic-batch-kernel-default-uc)
[511.909876] Starting subtest: basic-batch-kernel-default-uc
[519.422287] Subtest basic-batch-kernel-default-uc: SUCCESS (7.512s)
[519.621439] [104/133] (502s left) kms_plane (plane-panning-bottom-right)
[519.709075] Starting subtest: plane-panning-bottom-right
[519.709945] Starting dynamic subtest: pipe-A
[521.339572] Dynamic subtest pipe-A: SUCCESS (1.630s)
[521.349236] Starting dynamic subtest: pipe-B
[523.615052] Dynamic subtest pipe-B: SUCCESS (2.274s)
[523.615889] Subtest plane-panning-bottom-right: SUCCESS (3.907s)
[524.415503] [105/133] (497s left) kms_cursor_legacy (forked-move)
[524.546548] Starting subtest: forked-move
[524.547463] Starting dynamic subtest: pipe-A
[530.002938] Dynamic subtest pipe-A: SUCCESS (5.453s)
[530.014869] Starting dynamic subtest: pipe-B
[535.469909] Dynamic subtest pipe-B: SUCCESS (5.465s)
[535.480029] Starting dynamic subtest: pipe-C
[540.945738] Dynamic subtest pipe-C: SUCCESS (5.473s)
[540.956118] Starting dynamic subtest: pipe-D
[546.462083] Dynamic subtest pipe-D: SUCCESS (5.513s)
[546.471780] Starting dynamic subtest: all-pipes
[551.943248] Dynamic subtest all-pipes: SUCCESS (5.479s)
[551.944335] Subtest forked-move: SUCCESS (27.393s)
[552.089864] [106/133] (469s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[552.186374] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[552.188061] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[552.268287] [107/133] (469s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[552.368486] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[552.369345] Starting dynamic subtest: pipe-A-eDP-1
[568.993435] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.992s)
[569.008796] Starting dynamic subtest: pipe-B-eDP-1
[586.956867] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.823s)
[586.967330] Starting dynamic subtest: pipe-C-eDP-1
[604.942775] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.733s)
[604.952247] Starting dynamic subtest: pipe-D-eDP-1
[622.950579] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.743s)
[622.951606] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (10.297s)
[630.195994] [108/133] (397s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[630.290744] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[630.301594] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.011s)
[630.382124] [109/133] (397s left) kms_invalid_mode (zero-clock)
[630.483017] Starting subtest: zero-clock
[630.484029] Starting dynamic subtest: pipe-A-eDP-1
[630.764182] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s)
[630.773135] Starting dynamic subtest: pipe-B-eDP-1
[630.774018] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[630.782169] Starting dynamic subtest: pipe-C-eDP-1
[630.783068] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[630.791288] Starting dynamic subtest: pipe-D-eDP-1
[630.792223] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[630.793155] Subtest zero-clock: SUCCESS (0.288s)
[631.606269] [110/133] (396s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[631.722941] Starting subtest: 2x-flip-vs-cursor-atomic
[631.725747] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[631.886353] [111/133] (395s left) gem_mmap_gtt (basic-copy)
[631.948437] Subtest basic-copy: SKIP (0.000s)
[632.016760] [112/133] (395s left) i915_pm_rps (thresholds-idle-park)
[632.073712] Starting subtest: thresholds-idle-park
[632.075593] Subtest thresholds-idle-park: SKIP (0.001s)
[632.190424] [113/133] (395s left) gen3_render_tiledy_blits
[632.318228] [114/133] (395s left) gem_reg_read (timestamp-monotonic)
[632.370714] Starting subtest: timestamp-monotonic
[636.845532] Subtest timestamp-monotonic: SUCCESS (4.504s)
[636.926794] [115/133] (391s left) dmabuf_sync_file (export-wait-after-attach)
[636.958506] Starting subtest: export-wait-after-attach
[636.959476] Subtest export-wait-after-attach: SUCCESS (0.001s)
[637.023008] [116/133] (391s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[637.120976] Starting subtest: crc-primary-basic-y-tiled-ccs
[637.121886] Starting dynamic subtest: pipe-A-eDP-1
[637.130406] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[637.139454] Starting dynamic subtest: pipe-B-eDP-1
[637.147901] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[637.156719] Starting dynamic subtest: pipe-C-eDP-1
[637.164779] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[637.173289] Starting dynamic subtest: pipe-D-eDP-1
[637.181606] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[637.183192] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s)
[639.355747] [117/133] (388s left) kms_atomic (plane-primary-legacy)
[639.439369] Starting subtest: plane-primary-legacy
[639.440194] Starting dynamic subtest: pipe-A-eDP-1
[639.895625] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.457s)
[639.896637] Subtest plane-primary-legacy: SUCCESS (0.458s)
[640.772182] [118/133] (387s left) syncobj_wait (invalid-signal-one-illegal-handle)
[640.827409] Starting subtest: invalid-signal-one-illegal-handle
[640.828440] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[640.945479] [119/133] (387s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[641.054067] Starting subtest: fbc-psr2-sprite-plane-onoff
[641.054984] Starting dynamic subtest: eDP-1
[641.056696] Dynamic subtest eDP-1: SKIP (0.000s)
[641.058388] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[641.150139] [120/133] (387s left) kms_cursor_crc (cursor-random-128x42)
[641.371480] Starting subtest: cursor-random-128x42
[641.408936] Subtest cursor-random-128x42: SKIP (0.036s)
[641.646122] [121/133] (386s left) prime_mmap (test_errors)
[641.696769] Starting subtest: test_errors
[641.697729] Starting dynamic subtest: test_errors-smem
[641.790644] Dynamic subtest test_errors-smem: SUCCESS (0.094s)
[641.792196] Subtest test_errors: SUCCESS (0.095s)
[641.900613] [122/133] (386s left) kms_psr (fbc-pr-dpms)
[641.998262] Starting subtest: fbc-pr-dpms
[642.000134] Subtest fbc-pr-dpms: SKIP (0.000s)
[642.100445] [123/133] (386s left) kms_cursor_crc (cursor-onscreen-512x512)
[642.369549] Starting subtest: cursor-onscreen-512x512
[642.371317] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[642.550736] [124/133] (385s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[642.645023] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[642.656632] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s)
[642.743963] [125/133] (385s left) kms_psr (pr-primary-mmap-cpu)
[642.825784] Starting subtest: pr-primary-mmap-cpu
[642.827558] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[642.919821] [126/133] (385s left) gem_ctx_param (invalid-get-engines)
[642.970275] Starting subtest: invalid-get-engines
[642.973141] Subtest invalid-get-engines: SUCCESS (0.001s)
[643.092383] [127/133] (385s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[643.148887] Starting subtest: y-tiled-to-vebox-yf-tiled
[643.150866] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[643.341790] [128/133] (385s left) api_intel_allocator (reserve-simple)
[643.389621] Starting subtest: reserve-simple
[643.391652] Subtest reserve-simple: SUCCESS (0.004s)
[643.521544] [129/133] (385s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[643.575737] Starting subtest: wait-all-for-submit-delayed-submit
[643.681212] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[643.763625] [130/133] (384s left) gem_basic (create-close)
[643.820897] Starting subtest: create-close
[643.822858] Subtest create-close: SUCCESS (0.000s)
[643.928783] [131/133] (384s left) gem_busy (extended)
[644.111555] Starting subtest: extended
[644.112462] Starting dynamic subtest: rcs0
[644.204376] Dynamic subtest rcs0: SUCCESS (0.092s)
[644.216452] Starting dynamic subtest: bcs0
[644.246947] Dynamic subtest bcs0: SUCCESS (0.041s)
[644.257105] Starting dynamic subtest: vcs0
[646.165265] Dynamic subtest vcs0: SUCCESS (1.917s)
[646.176636] Starting dynamic subtest: vcs1
[648.213018] Dynamic subtest vcs1: SUCCESS (2.048s)
[648.223890] Starting dynamic subtest: vecs0
[650.197716] Dynamic subtest vecs0: SUCCESS (1.985s)
[650.209274] Starting dynamic subtest: ccs0
[650.242272] Dynamic subtest ccs0: SUCCESS (0.044s)
[650.244805] Subtest extended: SUCCESS (6.142s)
[650.508261] [132/133] (378s left) kms_pm_dc (dc5-retention-flops)
[651.609161] Starting subtest: dc5-retention-flops
[651.611057] Subtest dc5-retention-flops: SKIP (0.000s)
[651.687538] [133/133] (376s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[652.090870] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[652.865000] 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.