[62.319819] Initializing watchdogs [62.319888] /dev/watchdog0 [62.341767] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [62.352735] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card1 [62.357113] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [62.359695] [001/131] (960s left) gem_exec_balancer (nop) [62.445664] Starting subtest: nop [111.977344] Subtest nop: SUCCESS (49.532s) [112.376378] [002/131] (910s left) syncobj_timeline (wait-all-interrupted) [112.444199] Starting subtest: wait-all-interrupted [112.547342] Subtest wait-all-interrupted: SUCCESS (0.102s) [112.688371] [003/131] (910s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset) [112.878011] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset [112.892498] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.014s) [113.003815] [004/131] (910s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu) [113.199963] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu [113.201674] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [113.345111] [005/131] (909s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc) [113.544863] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc [113.546491] Subtest fbcpsr-rgb101010-draw-mmap-wc: SKIP (0.000s) [113.693165] [006/131] (909s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-wc) [113.885811] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-wc [113.887493] Subtest psr-1p-offscren-pri-indfb-draw-mmap-wc: SKIP (0.000s) [114.022994] [007/131] (909s left) gem_pxp (display-protected-crc) [116.623555] Starting subtest: display-protected-crc [116.625351] Subtest display-protected-crc: SKIP (0.000s) [116.712941] [008/131] (906s left) kms_dirtyfb (psr-dirtyfb-ioctl) [116.903245] Starting subtest: psr-dirtyfb-ioctl [116.908213] Subtest psr-dirtyfb-ioctl: SKIP (0.000s) [117.034476] [009/131] (906s left) gem_exec_schedule (preempt-queue-chain) [117.124471] Subtest preempt-queue-chain: SKIP (0.000s) [117.449446] [010/131] (905s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75) [117.634165] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75 [117.635053] Starting dynamic subtest: pipe-A [117.748386] Dynamic subtest pipe-A: SUCCESS (0.114s) [117.757461] Starting dynamic subtest: pipe-B [117.948530] Dynamic subtest pipe-B: SUCCESS (0.200s) [117.961124] Starting dynamic subtest: pipe-C [118.167526] Dynamic subtest pipe-C: SUCCESS (0.219s) [118.181290] Starting dynamic subtest: pipe-D [118.398620] Dynamic subtest pipe-D: SUCCESS (0.231s) [118.399419] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SUCCESS (0.765s) [118.732279] [011/131] (904s left) gem_mmap_gtt (big-bo-tiledy) [118.802975] Subtest big-bo-tiledY: SKIP (0.000s) [118.893080] [012/131] (904s left) gem_ctx_param (basic) [118.959396] Starting subtest: basic [118.961411] Subtest basic: SUCCESS (0.001s) [119.082039] [013/131] (904s left) prime_vgem (basic-fence-mmap) [119.194603] Starting subtest: basic-fence-mmap [119.196491] Subtest basic-fence-mmap: SKIP (0.000s) [119.350749] [FACT prime_vgem (basic-fence-mmap)] new: kernel.kmod_is_loaded.vgem: true [119.352919] [014/131] (904s left) kms_flip (2x-flip-vs-rmfb) [119.549073] Starting subtest: 2x-flip-vs-rmfb [119.563881] Subtest 2x-flip-vs-rmfb: SKIP (0.014s) [119.677048] [015/131] (904s left) perf (invalid-oa-format-id) [120.032159] Starting subtest: invalid-oa-format-id [120.050065] Subtest invalid-oa-format-id: SUCCESS (0.018s) [120.111630] [016/131] (903s left) kms_panel_fitting (atomic-fastset) [120.313191] Starting subtest: atomic-fastset [120.315073] Subtest atomic-fastset: SKIP (0.000s) [120.398878] [017/131] (903s left) kms_atomic_transition (plane-all-transition-nonblocking) [120.597309] Starting subtest: plane-all-transition-nonblocking [120.599129] Starting dynamic subtest: pipe-A-DP-3 [124.318658] Dynamic subtest pipe-A-DP-3: SUCCESS (3.718s) [124.426443] Starting dynamic subtest: pipe-B-DP-3 [128.186237] Dynamic subtest pipe-B-DP-3: SUCCESS (3.790s) [128.240381] Subtest plane-all-transition-nonblocking: SUCCESS (7.642s) [128.495601] [018/131] (895s left) gem_exec_alignment (many) [128.578631] Starting subtest: many [157.321385] Subtest many: SUCCESS (28.742s) [158.022383] [019/131] (865s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant) [158.262166] Starting subtest: coverage-vs-premult-vs-constant [158.516502] Starting dynamic subtest: pipe-A-DP-3 [158.973253] Dynamic subtest pipe-A-DP-3: SUCCESS (0.456s) [158.986911] Starting dynamic subtest: pipe-D-DP-3 [159.524341] Dynamic subtest pipe-D-DP-3: SUCCESS (0.549s) [159.525257] Subtest coverage-vs-premult-vs-constant: SUCCESS (1.262s) [159.787762] [020/131] (864s left) gem_spin_batch (spin-all-new) [159.877342] Starting subtest: spin-all-new [159.934142] Subtest spin-all-new: SUCCESS (0.057s) [160.249370] [021/131] (863s left) gem_ctx_persistence (legacy-engines-queued) [160.337953] Starting subtest: legacy-engines-queued [160.338886] Starting dynamic subtest: render [160.432339] Dynamic subtest render: SUCCESS (0.094s) [160.441180] Starting dynamic subtest: bsd1 [160.478375] Dynamic subtest bsd1: SUCCESS (0.045s) [160.489486] Starting dynamic subtest: bsd2 [160.508286] Dynamic subtest bsd2: SUCCESS (0.029s) [160.519436] Starting dynamic subtest: blt [160.582437] Dynamic subtest blt: SUCCESS (0.074s) [160.601990] Starting dynamic subtest: vebox [160.626914] Dynamic subtest vebox: SUCCESS (0.043s) [160.628221] Subtest legacy-engines-queued: SUCCESS (0.289s) [160.795037] [022/131] (863s left) gem_exec_params (secure-non-root) [160.883521] Starting subtest: secure-non-root [160.885256] Subtest secure-non-root: SKIP (0.000s) [161.051164] [023/131] (863s left) syncobj_wait (single-wait-for-submit-submitted) [161.136671] Starting subtest: single-wait-for-submit-submitted [161.243430] Subtest single-wait-for-submit-submitted: SUCCESS (0.106s) [161.390385] [024/131] (863s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted) [161.470176] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted [161.580085] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.108s) [161.667964] [025/131] (862s left) kms_hdr (static-toggle-dpms) [161.867078] Starting subtest: static-toggle-dpms [165.192997] Starting dynamic subtest: pipe-A-DP-3 [166.517938] Dynamic subtest pipe-A-DP-3: SUCCESS (1.326s) [166.519362] Subtest static-toggle-dpms: SUCCESS (4.651s) [166.846055] [026/131] (857s left) i915_query (query-regions-sanity-check) [166.926058] Starting subtest: query-regions-sanity-check [166.948237] Subtest query-regions-sanity-check: SUCCESS (0.022s) [167.075084] [027/131] (857s left) kms_big_fb (4-tiled-8bpp-rotate-90) [167.286114] Starting subtest: 4-tiled-8bpp-rotate-90 [167.350462] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.064s) [167.532608] [028/131] (857s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu) [167.742765] Starting subtest: fbc-rgb565-draw-mmap-cpu [170.150731] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (2.408s) [170.343737] [029/131] (854s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs) [170.540249] Starting subtest: crc-primary-suspend-yf-tiled-ccs [170.541184] Starting dynamic subtest: pipe-A-DP-3 [170.544934] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [170.553614] Starting dynamic subtest: pipe-B-DP-3 [170.557148] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [170.565576] Starting dynamic subtest: pipe-C-DP-3 [170.569155] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [170.577700] Starting dynamic subtest: pipe-D-DP-3 [170.581146] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [170.582863] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.004s) [171.023061] [030/131] (853s left) gem_userptr_blits (usage-restrictions) [171.112573] Starting subtest: usage-restrictions [171.113441] Subtest usage-restrictions: SUCCESS (0.000s) [171.308872] [031/131] (853s left) gem_exec_reloc (basic-cpu-read-active) [171.395501] Subtest basic-cpu-read-active: SKIP (0.000s) [171.496595] [032/131] (853s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines) [172.144350] Starting subtest: syncobj-stationary-timeline-chain-engines [172.299205] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.155s) [172.605924] [033/131] (852s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode) [172.883583] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s) [173.039087] [034/131] (852s left) kms_flip (dpms-off-confusion) [173.232081] Starting subtest: dpms-off-confusion [173.235863] Starting dynamic subtest: A-DP3 [181.073712] Dynamic subtest A-DP3: SUCCESS (7.837s) [181.089926] Starting dynamic subtest: B-DP3 [188.843573] Dynamic subtest B-DP3: SUCCESS (7.768s) [188.853163] Starting dynamic subtest: C-DP3 [196.619560] Dynamic subtest C-DP3: SUCCESS (7.775s) [196.629194] Starting dynamic subtest: D-DP3 [204.392968] Dynamic subtest D-DP3: SUCCESS (7.772s) [204.400656] Subtest dpms-off-confusion: SUCCESS (31.168s) [204.744508] [035/131] (820s left) kms_psr (fbc-psr-cursor-blt) [204.954392] Subtest fbc-psr-cursor-blt: SKIP (0.000s) [205.015530] [036/131] (820s left) i915_pm_rpm (reg-read-ioctl) [207.049992] Starting subtest: reg-read-ioctl [207.789692] Subtest reg-read-ioctl: SUCCESS (0.741s) [208.146817] [037/131] (817s left) i915_drm_fdinfo (virtual-busy-hang) [208.220146] Starting subtest: virtual-busy-hang [208.222349] Subtest virtual-busy-hang: SKIP (0.000s) [208.316451] [038/131] (817s left) kms_big_fb (linear-32bpp-rotate-90) [208.530476] Starting subtest: linear-32bpp-rotate-90 [208.583188] Subtest linear-32bpp-rotate-90: SKIP (0.052s) [208.775550] [039/131] (816s left) gem_basic (multigpu-create-close) [208.854169] Starting subtest: multigpu-create-close [208.855977] Subtest multigpu-create-close: SKIP (0.000s) [208.967038] [040/131] (816s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt) [209.174122] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt [209.175774] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [209.302502] [041/131] (816s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs) [209.498318] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs [209.499274] Starting dynamic subtest: pipe-A-DP-3 [209.506995] Dynamic subtest pipe-A-DP-3: SUCCESS (0.002s) [209.516203] Starting dynamic subtest: pipe-B-DP-3 [209.523875] Dynamic subtest pipe-B-DP-3: SUCCESS (0.002s) [209.532892] Starting dynamic subtest: pipe-C-DP-3 [209.540509] Dynamic subtest pipe-C-DP-3: SUCCESS (0.002s) [209.549396] Starting dynamic subtest: pipe-D-DP-3 [209.556952] Dynamic subtest pipe-D-DP-3: SUCCESS (0.002s) [209.557845] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SUCCESS (0.013s) [209.948569] [042/131] (815s left) syncobj_timeline (multi-wait-all-available-signaled) [210.026227] Starting subtest: multi-wait-all-available-signaled [210.027184] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s) [210.173814] [043/131] (815s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen) [210.385331] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen [210.387315] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [210.510094] [044/131] (815s left) vgem_slow (nohang) [210.557713] Starting subtest: nohang [220.760136] Subtest nohang: SUCCESS (10.202s) [220.848220] [045/131] (805s left) kms_atomic_transition (plane-use-after-nonblocking-unbind) [221.045442] Starting subtest: plane-use-after-nonblocking-unbind [221.047495] Starting dynamic subtest: pipe-A-DP-3 [221.112221] Dynamic subtest pipe-A-DP-3: SUCCESS (0.065s) [221.223855] Starting dynamic subtest: pipe-B-DP-3 [221.330244] Dynamic subtest pipe-B-DP-3: SUCCESS (0.141s) [221.384382] Subtest plane-use-after-nonblocking-unbind: SUCCESS (0.338s) [221.656043] [046/131] (804s left) kms_psr (pr-sprite-plane-move) [221.853101] Subtest pr-sprite-plane-move: SKIP (0.000s) [221.908958] [047/131] (804s left) gem_lmem_swapping (parallel-random-engines) [224.813405] Starting subtest: parallel-random-engines [224.814248] Starting dynamic subtest: lmem0 [259.719720] Dynamic subtest lmem0: SUCCESS (34.906s) [259.720891] Subtest parallel-random-engines: SUCCESS (34.907s) [261.068155] [FACT gem_lmem_swapping (parallel-random-engines)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card1 [261.069143] [FACT gem_lmem_swapping (parallel-random-engines)] deleted: kernel.kmod_is_loaded.i915: true [261.070597] [048/131] (764s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite) [262.666999] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite [265.796989] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (3.130s) [265.958560] [FACT kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card1 [265.960860] [FACT kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)] new: kernel.kmod_is_loaded.i915: true [265.963542] [049/131] (760s left) i915_query (query-garbage) [266.042154] Starting subtest: query-garbage [266.042944] Subtest query-garbage: SUCCESS (0.000s) [266.170611] [050/131] (759s left) kms_pm_rpm (modeset-lpsp-stress-no-wait) [268.115354] Starting subtest: modeset-lpsp-stress-no-wait [268.320205] Subtest modeset-lpsp-stress-no-wait: SKIP (0.208s) [268.515847] [051/131] (757s left) kms_plane (pixel-format-source-clamping) [268.720536] Starting subtest: pixel-format-source-clamping [268.753174] Starting dynamic subtest: pipe-A-plane-0 [277.004040] Dynamic subtest pipe-A-plane-0: SUCCESS (8.250s) [277.016480] Starting dynamic subtest: pipe-A-plane-3 [281.371365] Dynamic subtest pipe-A-plane-3: SUCCESS (4.366s) [281.387820] Starting dynamic subtest: pipe-A-plane-5 [281.388743] Dynamic subtest pipe-A-plane-5: SUCCESS (0.000s) [281.630563] Starting dynamic subtest: pipe-B-plane-0 [289.505865] Dynamic subtest pipe-B-plane-0: SUCCESS (7.915s) [289.516663] Starting dynamic subtest: pipe-B-plane-3 [293.989223] Dynamic subtest pipe-B-plane-3: SUCCESS (4.482s) [293.999565] Starting dynamic subtest: pipe-B-plane-5 [294.000790] Dynamic subtest pipe-B-plane-5: SUCCESS (0.000s) [294.080773] Subtest pixel-format-source-clamping: SUCCESS (25.359s) [294.359538] [052/131] (731s left) gem_render_copy_redux (flink-interruptible) [294.450265] Starting subtest: flink-interruptible [297.619556] Subtest flink-interruptible: SUCCESS (3.169s) [297.805310] [053/131] (728s left) kms_psr (psr-sprite-plane-onoff) [298.002262] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [298.065944] [054/131] (728s left) kms_cursor_crc (cursor-onscreen-32x10) [298.372875] Starting subtest: cursor-onscreen-32x10 [298.419257] Subtest cursor-onscreen-32x10: SKIP (0.045s) [298.793485] [055/131] (727s left) kms_flip (basic-flip-vs-wf_vblank) [298.989954] Starting subtest: basic-flip-vs-wf_vblank [298.994190] Starting dynamic subtest: A-DP3 [300.116444] Dynamic subtest A-DP3: SUCCESS (1.122s) [300.129142] Starting dynamic subtest: B-DP3 [301.169394] Dynamic subtest B-DP3: SUCCESS (1.052s) [301.179766] Starting dynamic subtest: C-DP3 [302.221678] Dynamic subtest C-DP3: SUCCESS (1.051s) [302.231980] Starting dynamic subtest: D-DP3 [303.273452] Dynamic subtest D-DP3: SUCCESS (1.051s) [303.275595] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.285s) [303.591497] [056/131] (722s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [303.812446] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip [303.814252] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s) [303.942073] [057/131] (722s left) kms_psr (fbc-pr-basic) [304.136168] Subtest fbc-pr-basic: SKIP (0.000s) [304.233511] [058/131] (722s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc) [304.433956] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc [304.435686] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [304.560891] [059/131] (722s left) api_intel_allocator (reopen-fork) [304.636505] Starting subtest: reopen-fork [307.942127] Subtest reopen-fork: SUCCESS (3.304s) [308.121996] [060/131] (718s left) perf_pmu (rc6) [308.194668] Starting subtest: rc6 [308.195557] Starting dynamic subtest: gt0 [314.558671] Dynamic subtest gt0: SUCCESS (6.362s) [314.571848] Starting dynamic subtest: runtime-pm-gt0 [322.252431] Dynamic subtest runtime-pm-gt0: SUCCESS (7.690s) [322.262898] Starting dynamic subtest: runtime-pm-long-gt0 [334.879321] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.625s) [334.889591] Starting dynamic subtest: other-idle-gt0 [334.891395] Dynamic subtest other-idle-gt0: SKIP (0.000s) [334.892267] Subtest rc6: SUCCESS (26.685s) [336.095641] [061/131] (690s left) kms_psr (psr-basic) [336.290149] Subtest psr-basic: SKIP (0.000s) [336.350864] [062/131] (690s left) gem_madvise (dontneed-before-mmap) [336.400571] Starting subtest: dontneed-before-mmap [336.445874] Subtest dontneed-before-mmap: SUCCESS (0.046s) [336.534685] [063/131] (690s left) syncobj_timeline (etime-single-wait-submitted) [336.614409] Starting subtest: etime-single-wait-submitted [336.723929] Subtest etime-single-wait-submitted: SUCCESS (0.108s) [336.795785] [064/131] (690s left) kms_chamelium_frames (dp-frame-dump) [337.085146] Subtest dp-frame-dump: SKIP (0.000s) [337.242521] [065/131] (689s left) gem_flink_race (flink_close) [337.291923] Starting subtest: flink_close [342.383402] Subtest flink_close: SUCCESS (5.092s) [342.446978] [066/131] (684s left) gem_gpgpu_fill (offset-16x16) [342.531449] Starting subtest: offset-16x16 [342.564918] Subtest offset-16x16: SUCCESS (0.033s) [342.713929] [067/131] (684s left) gem_exec_capture (capture) [342.802041] Starting subtest: capture [342.802947] Starting dynamic subtest: rcs0-smem [343.773430] Dynamic subtest rcs0-smem: SUCCESS (0.970s) [343.784128] Starting dynamic subtest: rcs0-lmem0 [344.702393] Dynamic subtest rcs0-lmem0: SUCCESS (0.927s) [344.712865] Starting dynamic subtest: bcs0-smem [346.116383] Dynamic subtest bcs0-smem: SUCCESS (1.414s) [346.126948] Starting dynamic subtest: bcs0-lmem0 [347.234311] Dynamic subtest bcs0-lmem0: SUCCESS (1.117s) [347.245160] Starting dynamic subtest: vcs0-smem [348.126283] Dynamic subtest vcs0-smem: SUCCESS (0.891s) [348.136716] Starting dynamic subtest: vcs0-lmem0 [349.213384] Dynamic subtest vcs0-lmem0: SUCCESS (1.087s) [349.223707] Starting dynamic subtest: vcs1-smem [350.119424] Dynamic subtest vcs1-smem: SUCCESS (0.905s) [350.129947] Starting dynamic subtest: vcs1-lmem0 [351.273391] Dynamic subtest vcs1-lmem0: SUCCESS (1.153s) [351.283767] Starting dynamic subtest: vecs0-smem [352.212156] Dynamic subtest vecs0-smem: FAIL (0.917s) [352.222450] Starting dynamic subtest: vecs0-lmem0 [353.224515] Dynamic subtest vecs0-lmem0: FAIL (1.003s) [353.234563] Starting dynamic subtest: vecs1-smem [354.634123] Dynamic subtest vecs1-smem: FAIL (1.416s) [354.644354] Starting dynamic subtest: vecs1-lmem0 [355.652891] Dynamic subtest vecs1-lmem0: FAIL (1.018s) [355.663031] Starting dynamic subtest: ccs0-smem [357.057404] Dynamic subtest ccs0-smem: SUCCESS (1.426s) [357.068129] Starting dynamic subtest: ccs0-lmem0 [357.982436] Dynamic subtest ccs0-lmem0: SUCCESS (0.924s) [357.983496] Subtest capture: FAIL (15.180s) [358.082470] [068/131] (669s left) kms_universal_plane (universal-plane-functional) [358.275400] Starting subtest: universal-plane-functional [358.277970] Starting dynamic subtest: pipe-A-DP-3 [360.607656] Dynamic subtest pipe-A-DP-3: SUCCESS (2.330s) [360.623260] Starting dynamic subtest: pipe-B-DP-3 [362.810934] Dynamic subtest pipe-B-DP-3: SUCCESS (2.201s) [362.823326] Starting dynamic subtest: pipe-C-DP-3 [365.000400] Dynamic subtest pipe-C-DP-3: SUCCESS (2.187s) [365.013823] Starting dynamic subtest: pipe-D-DP-3 [367.170601] Dynamic subtest pipe-D-DP-3: SUCCESS (2.169s) [367.171483] Subtest universal-plane-functional: SUCCESS (8.895s) [367.359266] [069/131] (660s left) perf_pmu (event-wait) [367.432136] Starting subtest: event-wait [367.433077] Starting dynamic subtest: rcs0 [367.434996] Dynamic subtest rcs0: SKIP (0.000s) [367.436913] Subtest event-wait: SKIP (0.001s) [367.514946] [070/131] (659s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt) [367.716007] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt [367.717655] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [367.799783] [071/131] (659s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions) [367.996868] Starting subtest: cursorB-vs-flipA-atomic-transitions [368.000118] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.002s) [368.065412] [072/131] (659s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf) [368.268866] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [368.330437] [073/131] (659s left) kms_chamelium_edid (vga-edid-read) [368.611337] Subtest vga-edid-read: SKIP (0.000s) [368.766078] [074/131] (658s left) gen9_exec_parse (unaligned-jump) [368.854969] Subtest unaligned-jump: SKIP (0.000s) [368.935815] [075/131] (658s left) kms_cursor_legacy (forked-bo) [369.133642] Starting subtest: forked-bo [369.134481] Starting dynamic subtest: pipe-A [374.553127] Dynamic subtest pipe-A: SUCCESS (5.416s) [374.573101] Starting dynamic subtest: pipe-B [379.976986] Dynamic subtest pipe-B: SUCCESS (5.422s) [380.004275] Starting dynamic subtest: pipe-C [385.412448] Dynamic subtest pipe-C: SUCCESS (5.433s) [385.436399] Starting dynamic subtest: pipe-D [390.844459] Dynamic subtest pipe-D: SUCCESS (5.430s) [390.870784] Starting dynamic subtest: all-pipes [396.271146] Dynamic subtest all-pipes: SUCCESS (5.425s) [396.272128] Subtest forked-bo: SUCCESS (27.136s) [396.339368] [076/131] (631s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move) [396.542225] Starting subtest: fbc-2p-scndscrn-spr-indfb-move [396.544037] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [396.621971] [077/131] (631s left) kms_cursor_crc (cursor-rapid-movement-64x64) [396.965075] Starting subtest: cursor-rapid-movement-64x64 [396.970429] Starting dynamic subtest: pipe-A-DP-3 [397.403220] Dynamic subtest pipe-A-DP-3: SUCCESS (0.432s) [397.456036] Starting dynamic subtest: pipe-D-DP-3 [397.866592] Dynamic subtest pipe-D-DP-3: SUCCESS (0.421s) [397.867423] Subtest cursor-rapid-movement-64x64: SUCCESS (0.902s) [398.252315] [078/131] (629s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling) [398.446601] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling [398.449162] Starting dynamic subtest: pipe-A-valid-mode [398.537280] Dynamic subtest pipe-A-valid-mode: SKIP (0.088s) [398.539356] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.090s) [398.685414] [079/131] (629s left) sw_sync (alloc_fence) [398.734926] Starting subtest: alloc_fence [398.735855] Subtest alloc_fence: SUCCESS (0.000s) [398.785485] [080/131] (629s left) kms_feature_discovery (psr2) [398.981550] Starting subtest: psr2 [398.983270] Subtest psr2: SKIP (0.000s) [399.046764] [081/131] (628s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-blt) [399.253268] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-blt [399.254938] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-blt: SKIP (0.000s) [399.330471] [082/131] (628s left) syncobj_timeline (multi-wait-all-signaled) [399.409356] Starting subtest: multi-wait-all-signaled [399.410292] Subtest multi-wait-all-signaled: SUCCESS (0.001s) [399.519006] [083/131] (628s left) vgem_basic (second-client) [399.566608] Starting subtest: second-client [399.581994] Subtest second-client: SUCCESS (0.015s) [399.630666] [084/131] (628s left) kms_psr (fbc-pr-sprite-mmap-gtt) [399.824126] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s) [399.878391] [085/131] (628s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc) [400.079047] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc [400.080813] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [400.169114] [086/131] (628s left) gem_mmap_gtt (basic-write-read) [400.248170] Subtest basic-write-read: SKIP (0.000s) [400.310608] [087/131] (628s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs) [400.506498] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs [400.508887] Starting dynamic subtest: pipe-A-DP-3 [400.517284] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [400.527756] Starting dynamic subtest: pipe-B-DP-3 [400.536165] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [400.546506] Starting dynamic subtest: pipe-C-DP-3 [400.554898] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [400.565530] Starting dynamic subtest: pipe-D-DP-3 [400.577346] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [400.579602] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.006s) [400.910018] [088/131] (627s left) api_intel_allocator (default-alignment) [400.987392] Starting subtest: default-alignment [400.993378] Subtest default-alignment: SUCCESS (0.006s) [401.095514] [089/131] (627s left) gem_userptr_blits (dmabuf-sync) [401.190804] Starting subtest: dmabuf-sync [401.209264] Subtest dmabuf-sync: SKIP (0.018s) [401.323192] [090/131] (627s left) intel_sysfs_debugfs (i915-sysfs-read-all-entries) [401.407564] Starting subtest: i915-sysfs-read-all-entries [401.616869] Subtest i915-sysfs-read-all-entries: SUCCESS (0.208s) [401.839550] [091/131] (626s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt) [402.039169] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt [402.040997] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [402.178307] [092/131] (626s left) gem_exec_schedule (fairslice) [402.269865] Starting subtest: fairslice [402.270788] Starting dynamic subtest: rcs0 [404.321272] Dynamic subtest rcs0: SUCCESS (2.050s) [404.332460] Starting dynamic subtest: bcs0 [406.341407] Dynamic subtest bcs0: SUCCESS (2.018s) [406.352735] Starting dynamic subtest: vcs0 [408.362820] Dynamic subtest vcs0: SUCCESS (2.021s) [408.373873] Starting dynamic subtest: vcs1 [410.381245] Dynamic subtest vcs1: SUCCESS (2.018s) [410.392544] Starting dynamic subtest: vecs0 [412.402340] Dynamic subtest vecs0: SUCCESS (2.021s) [412.413237] Starting dynamic subtest: vecs1 [414.422249] Dynamic subtest vecs1: SUCCESS (2.019s) [414.433666] Starting dynamic subtest: ccs0 [416.443160] Dynamic subtest ccs0: SUCCESS (2.020s) [416.444183] Subtest fairslice: SUCCESS (14.173s) [416.835663] [093/131] (611s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf) [417.033813] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (0.000s) [417.094699] [094/131] (611s left) kms_pm_rpm (dpms-lpsp) [419.034823] Starting subtest: dpms-lpsp [419.037092] Subtest dpms-lpsp: SKIP (0.001s) [419.323484] [095/131] (609s left) perf_pmu (render-node-busy-idle) [419.429751] Starting subtest: render-node-busy-idle [419.430649] Starting dynamic subtest: rcs0 [420.150200] Dynamic subtest rcs0: SUCCESS (0.719s) [420.170160] Starting dynamic subtest: bcs0 [420.814204] Dynamic subtest bcs0: SUCCESS (0.659s) [420.834135] Starting dynamic subtest: vcs0 [421.477211] Dynamic subtest vcs0: SUCCESS (0.658s) [421.497298] Starting dynamic subtest: vcs1 [422.139112] Dynamic subtest vcs1: SUCCESS (0.657s) [422.159197] Starting dynamic subtest: vecs0 [422.801119] Dynamic subtest vecs0: SUCCESS (0.657s) [422.821153] Starting dynamic subtest: vecs1 [423.467061] Dynamic subtest vecs1: SUCCESS (0.661s) [423.487058] Starting dynamic subtest: ccs0 [424.132976] Dynamic subtest ccs0: SUCCESS (0.661s) [424.135398] Subtest render-node-busy-idle: SUCCESS (4.705s) [424.196777] [096/131] (604s left) kms_vrr (negative-basic) [424.404495] Starting subtest: negative-basic [424.407166] Starting dynamic subtest: pipe-A-DP-3 [429.849139] Dynamic subtest pipe-A-DP-3: SUCCESS (5.440s) [429.937562] Subtest negative-basic: SUCCESS (5.533s) [430.140943] [097/131] (598s left) sysfs_heartbeat_interval (nopreempt) [430.229048] Starting subtest: nopreempt [430.230049] Starting dynamic subtest: vecs0 [434.582111] Dynamic subtest vecs0: SUCCESS (4.352s) [434.594252] Starting dynamic subtest: ccs0 [438.828247] Dynamic subtest ccs0: SUCCESS (4.245s) [438.841262] Starting dynamic subtest: vcs0 [443.020578] Dynamic subtest vcs0: SUCCESS (4.191s) [443.032039] Starting dynamic subtest: bcs0 [447.220125] Dynamic subtest bcs0: SUCCESS (4.198s) [447.232151] Starting dynamic subtest: vecs1 [451.459191] Dynamic subtest vecs1: SUCCESS (4.238s) [451.470667] Starting dynamic subtest: rcs0 [455.766542] Dynamic subtest rcs0: SUCCESS (4.306s) [455.777834] Starting dynamic subtest: vcs1 [460.031374] Dynamic subtest vcs1: SUCCESS (4.263s) [460.032385] Subtest nopreempt: SUCCESS (29.802s) [460.153396] [098/131] (568s left) kms_atomic (atomic-invalid-params) [460.349521] Starting subtest: atomic-invalid-params [460.352152] Starting dynamic subtest: pipe-A-DP-3 [460.977078] Dynamic subtest pipe-A-DP-3: SUCCESS (0.624s) [460.978191] Subtest atomic-invalid-params: SUCCESS (0.626s) [461.206510] [099/131] (567s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs) [461.404562] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs [461.407054] Starting dynamic subtest: pipe-A-DP-3 [461.415775] Dynamic subtest pipe-A-DP-3: SKIP (0.001s) [461.426996] Starting dynamic subtest: pipe-B-DP-3 [461.435623] Dynamic subtest pipe-B-DP-3: SKIP (0.001s) [461.446587] Starting dynamic subtest: pipe-C-DP-3 [461.455044] Dynamic subtest pipe-C-DP-3: SKIP (0.001s) [461.466245] Starting dynamic subtest: pipe-D-DP-3 [461.476606] Dynamic subtest pipe-D-DP-3: SKIP (0.001s) [461.478525] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.009s) [461.838862] [100/131] (567s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move) [462.039200] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move [462.040952] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SKIP (0.000s) [462.120081] [101/131] (567s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs) [462.203987] Starting subtest: mixed-tiled-to-yf-tiled-ccs [462.206623] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s) [462.408465] [102/131] (566s left) gem_mmap (bad-object) [462.486252] Subtest bad-object: SKIP (0.000s) [462.550763] [103/131] (566s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [462.757868] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [463.522075] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.764s) [463.695647] [104/131] (565s left) gem_mmap_gtt (coherency) [463.774161] Subtest coherency: SKIP (0.000s) [463.870489] [105/131] (565s left) kms_content_protection (atomic-dpms) [464.136333] Starting subtest: atomic-dpms [464.156196] Starting dynamic subtest: pipe-A-DP-3 [589.267664] Dynamic subtest pipe-A-DP-3: FAIL (124.928s) [589.268877] Subtest atomic-dpms: FAIL (125.046s) [589.410106] [106/131] (440s left) kms_writeback (writeback-fb-id-xrgb2101010) [589.608038] Subtest writeback-fb-id-XRGB2101010: SKIP (0.000s) [589.676177] [107/131] (439s left) gem_create (create-size-update) [589.754522] Starting subtest: create-size-update [589.755441] Subtest create-size-update: SUCCESS (0.000s) [590.003056] [108/131] (439s left) kms_big_fb (y-tiled-64bpp-rotate-0) [590.209931] Starting subtest: y-tiled-64bpp-rotate-0 [590.211573] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s) [590.282774] [109/131] (439s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move) [590.486121] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move [590.487821] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [590.567475] [110/131] (439s left) gem_softpin (noreloc-interruptible) [590.653499] Starting subtest: noreloc-interruptible [596.126583] Subtest noreloc-interruptible: SUCCESS (5.472s) [596.216701] [111/131] (433s left) gem_exec_schedule (u-semaphore-user) [596.314978] Starting subtest: u-semaphore-user [596.402725] Subtest u-semaphore-user: SUCCESS (0.087s) [596.798328] [112/131] (433s left) kms_getfb (getfb2-accept-nv12) [596.996931] Starting subtest: getfb2-accept-nv12 [596.999415] Subtest getfb2-accept-nv12: SUCCESS (0.002s) [597.102087] [113/131] (432s left) kms_busy (basic-hang) [597.307496] Starting subtest: basic-hang [597.309981] Starting dynamic subtest: flip-pipe-A [597.962563] Dynamic subtest flip-pipe-A: SUCCESS (0.652s) [597.982406] Starting dynamic subtest: modeset-pipe-A [598.948561] Dynamic subtest modeset-pipe-A: SUCCESS (0.984s) [598.973831] Starting dynamic subtest: flip-pipe-D [599.492396] Dynamic subtest flip-pipe-D: SUCCESS (0.539s) [599.506066] Starting dynamic subtest: modeset-pipe-D [600.368541] Dynamic subtest modeset-pipe-D: SUCCESS (0.875s) [600.369464] Subtest basic-hang: SUCCESS (3.062s) [600.580812] [114/131] (429s left) prime_self_import (basic-llseek-size) [600.630285] Starting subtest: basic-llseek-size [600.664753] Subtest basic-llseek-size: SUCCESS (0.035s) [600.753978] [115/131] (429s left) gem_softpin (allocator-basic) [600.840379] Starting subtest: allocator-basic [601.074581] Subtest allocator-basic: SUCCESS (0.234s) [601.203979] [116/131] (428s left) gem_exec_params (rel-constants-invalid-ring) [601.288637] Starting subtest: rel-constants-invalid-ring [601.289538] Subtest rel-constants-invalid-ring: SUCCESS (0.000s) [601.368102] [117/131] (428s left) gem_busy (semaphore) [601.615306] Subtest semaphore: SKIP (0.000s) [601.873716] [118/131] (428s left) kms_plane_scaling (planes-downscale-factor-0-25-upscale-20x20) [602.069541] Starting subtest: planes-downscale-factor-0-25-upscale-20x20 [602.070468] Starting dynamic subtest: pipe-A [602.811977] Dynamic subtest pipe-A: SKIP (0.739s) [602.823632] Starting dynamic subtest: pipe-B [603.929156] Dynamic subtest pipe-B: SKIP (1.117s) [603.941056] Starting dynamic subtest: pipe-C [605.043621] Dynamic subtest pipe-C: SKIP (1.113s) [605.055341] Starting dynamic subtest: pipe-D [606.159261] Dynamic subtest pipe-D: SKIP (1.115s) [606.160768] Subtest planes-downscale-factor-0-25-upscale-20x20: SKIP (4.088s) [606.252522] [119/131] (424s left) dmabuf_sync_file (export-multiwait) [606.315422] Starting subtest: export-multiwait [606.316298] Subtest export-multiwait: SUCCESS (0.000s) [606.366407] [120/131] (424s left) kms_flip (blocking-absolute-wf_vblank-interruptible) [606.568409] Starting subtest: blocking-absolute-wf_vblank-interruptible [606.571794] Starting dynamic subtest: A-DP3 [614.376220] Dynamic subtest A-DP3: SUCCESS (7.803s) [614.417837] Starting dynamic subtest: B-DP3 [622.154668] Dynamic subtest B-DP3: SUCCESS (7.773s) [622.168840] Starting dynamic subtest: C-DP3 [629.902388] Dynamic subtest C-DP3: SUCCESS (7.746s) [629.915834] Starting dynamic subtest: D-DP3 [637.659035] Dynamic subtest D-DP3: SUCCESS (7.754s) [637.664093] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (31.096s) [637.927832] [121/131] (392s left) gem_ppgtt (shrink-vs-evict-pinned) [638.013170] Starting subtest: shrink-vs-evict-pinned [643.921666] Subtest shrink-vs-evict-pinned: SUCCESS (5.908s) [644.025652] [122/131] (386s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move) [644.225939] Starting subtest: psr-2p-primscrn-spr-indfb-move [644.227546] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [644.304873] [123/131] (386s left) kms_rotation_crc (sprite-rotation-90-pos-100-0) [644.498523] Starting subtest: sprite-rotation-90-pos-100-0 [644.500353] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s) [644.555575] [124/131] (386s left) gem_mmap_gtt (cpuset-big-copy-xy) [644.634252] Subtest cpuset-big-copy-XY: SKIP (0.000s) [644.725827] [125/131] (385s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling) [644.923608] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling [644.926154] Starting dynamic subtest: pipe-A-valid-mode [647.402352] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.477s) [647.403248] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SUCCESS (2.479s) [647.602454] [126/131] (383s left) gem_ctx_persistence (engines-cleanup) [647.688826] Starting subtest: engines-cleanup [647.689726] Starting dynamic subtest: rcs0 [647.786502] Dynamic subtest rcs0: SUCCESS (0.097s) [647.801170] Starting dynamic subtest: bcs0 [647.802175] Dynamic subtest bcs0: SUCCESS (0.013s) [647.816312] Starting dynamic subtest: vcs0 [647.849334] Dynamic subtest vcs0: SUCCESS (0.048s) [647.862837] Starting dynamic subtest: vcs1 [647.891523] Dynamic subtest vcs1: SUCCESS (0.041s) [647.906045] Starting dynamic subtest: vecs0 [647.949263] Dynamic subtest vecs0: SUCCESS (0.057s) [647.970093] Starting dynamic subtest: vecs1 [647.991536] Dynamic subtest vecs1: SUCCESS (0.041s) [648.012858] Starting dynamic subtest: ccs0 [648.013940] Dynamic subtest ccs0: SUCCESS (0.017s) [648.014993] Subtest engines-cleanup: SUCCESS (0.322s) [648.156557] [127/131] (382s left) gem_readwrite (write-bad-handle) [648.236253] Subtest write-bad-handle: SKIP (0.000s) [648.305891] [128/131] (382s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [648.512581] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip [649.259752] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.746s) [649.469567] [129/131] (381s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs) [649.663527] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs [649.665977] Starting dynamic subtest: pipe-A-DP-3 [649.674756] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [649.686987] Starting dynamic subtest: pipe-B-DP-3 [649.695496] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [649.707444] Starting dynamic subtest: pipe-C-DP-3 [649.716307] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [649.728484] Starting dynamic subtest: pipe-D-DP-3 [649.739012] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [649.741058] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.007s) [650.063586] [130/131] (380s left) gem_wait (write-wait) [650.156378] Starting subtest: write-wait [650.157359] Starting dynamic subtest: all-engines [651.286238] Dynamic subtest all-engines: SUCCESS (1.129s) [651.302357] Starting dynamic subtest: rcs0 [652.350582] Dynamic subtest rcs0: SUCCESS (1.063s) [652.367732] Starting dynamic subtest: bcs0 [653.411543] Dynamic subtest bcs0: SUCCESS (1.059s) [653.434120] Starting dynamic subtest: vcs0 [654.468440] Dynamic subtest vcs0: SUCCESS (1.055s) [654.484055] Starting dynamic subtest: vcs1 [655.526176] Dynamic subtest vcs1: SUCCESS (1.055s) [655.547997] Starting dynamic subtest: vecs0 [656.589125] Dynamic subtest vecs0: SUCCESS (1.058s) [656.638159] Starting dynamic subtest: vecs1 [657.659131] Dynamic subtest vecs1: SUCCESS (1.065s) [657.680855] Starting dynamic subtest: ccs0 [658.723062] Dynamic subtest ccs0: SUCCESS (1.059s) [658.729608] Subtest write-wait: SUCCESS (8.568s) [658.975629] [131/131] (372s left) kms_lease (lease-invalid-crtc) [659.169504] Starting subtest: lease-invalid-crtc [659.171916] Starting dynamic subtest: pipe-A-DP-3 [659.172800] Dynamic subtest pipe-A-DP-3: SUCCESS (0.000s) [659.185181] Starting dynamic subtest: pipe-B-DP-3 [659.186447] Dynamic subtest pipe-B-DP-3: SUCCESS (0.000s) [659.198649] Starting dynamic subtest: pipe-C-DP-3 [659.199867] Dynamic subtest pipe-C-DP-3: SUCCESS (0.000s) [659.211873] Starting dynamic subtest: pipe-D-DP-3 [659.212880] Dynamic subtest pipe-D-DP-3: SUCCESS (0.000s) [659.214109] Subtest lease-invalid-crtc: SUCCESS (0.006s) [659.261077] Closing watchdogs results: parsing output: 0/ for test: gem_exec_balancer results: parsing output: 1/ for test: syncobj_timeline results: parsing output: 2/ for test: kms_flip results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: kms_frontbuffer_tracking results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: gem_pxp results: parsing output: 7/ for test: kms_dirtyfb results: parsing output: 8/ for test: gem_exec_schedule results: parsing output: 9/ for test: kms_plane_scaling results: parsing output: 10/ for test: gem_mmap_gtt results: parsing output: 11/ for test: gem_ctx_param results: parsing output: 12/ for test: prime_vgem results: parsing output: 13/ for test: kms_flip results: parsing output: 14/ for test: perf results: parsing output: 15/ for test: kms_panel_fitting results: parsing output: 16/ for test: kms_atomic_transition results: parsing output: 17/ for test: gem_exec_alignment results: parsing output: 18/ for test: kms_plane_alpha_blend results: parsing output: 19/ for test: gem_spin_batch results: parsing output: 20/ for test: gem_ctx_persistence results: parsing output: 21/ for test: gem_exec_params results: parsing output: 22/ for test: syncobj_wait results: parsing output: 23/ for test: syncobj_timeline results: parsing output: 24/ for test: kms_hdr results: parsing output: 25/ for test: i915_query results: parsing output: 26/ for test: kms_big_fb results: parsing output: 27/ for test: kms_frontbuffer_tracking results: parsing output: 28/ for test: kms_ccs results: parsing output: 29/ for test: gem_userptr_blits results: parsing output: 30/ for test: gem_exec_reloc results: parsing output: 31/ for test: gem_exec_fence results: parsing output: 32/ for test: kms_chamelium_hpd results: parsing output: 33/ for test: kms_flip results: parsing output: 34/ for test: kms_psr results: parsing output: 35/ for test: i915_pm_rpm results: parsing output: 36/ for test: i915_drm_fdinfo results: parsing output: 37/ for test: kms_big_fb results: parsing output: 38/ for test: gem_basic results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: kms_ccs results: parsing output: 41/ for test: syncobj_timeline results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: vgem_slow results: parsing output: 44/ for test: kms_atomic_transition results: parsing output: 45/ for test: kms_psr results: parsing output: 46/ for test: gem_lmem_swapping results: parsing output: 47/ for test: kms_frontbuffer_tracking results: parsing output: 48/ for test: i915_query results: parsing output: 49/ for test: kms_pm_rpm results: parsing output: 50/ for test: kms_plane results: parsing output: 51/ for test: gem_render_copy_redux results: parsing output: 52/ for test: kms_psr results: parsing output: 53/ for test: kms_cursor_crc results: parsing output: 54/ for test: kms_flip results: parsing output: 55/ for test: kms_big_fb results: parsing output: 56/ for test: kms_psr results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: api_intel_allocator results: parsing output: 59/ for test: perf_pmu results: parsing output: 60/ for test: kms_psr results: parsing output: 61/ for test: gem_madvise results: parsing output: 62/ for test: syncobj_timeline results: parsing output: 63/ for test: kms_chamelium_frames results: parsing output: 64/ for test: gem_flink_race results: parsing output: 65/ for test: gem_gpgpu_fill results: parsing output: 66/ for test: gem_exec_capture results: parsing output: 67/ for test: kms_universal_plane results: parsing output: 68/ for test: perf_pmu results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: kms_cursor_legacy results: parsing output: 71/ for test: kms_psr2_sf results: parsing output: 72/ for test: kms_chamelium_edid results: parsing output: 73/ for test: gen9_exec_parse results: parsing output: 74/ for test: kms_cursor_legacy results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: kms_cursor_crc results: parsing output: 77/ for test: kms_flip_scaled_crc results: parsing output: 78/ for test: sw_sync results: parsing output: 79/ for test: kms_feature_discovery results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: syncobj_timeline results: parsing output: 82/ for test: vgem_basic results: parsing output: 83/ for test: kms_psr results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: gem_mmap_gtt results: parsing output: 86/ for test: kms_ccs results: parsing output: 87/ for test: api_intel_allocator results: parsing output: 88/ for test: gem_userptr_blits results: parsing output: 89/ for test: intel_sysfs_debugfs results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: gem_exec_schedule results: parsing output: 92/ for test: kms_psr2_sf results: parsing output: 93/ for test: kms_pm_rpm results: parsing output: 94/ for test: perf_pmu results: parsing output: 95/ for test: kms_vrr results: parsing output: 96/ for test: sysfs_heartbeat_interval results: parsing output: 97/ for test: kms_atomic results: parsing output: 98/ for test: kms_ccs results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: gem_render_copy results: parsing output: 101/ for test: gem_mmap results: parsing output: 102/ for test: kms_big_fb results: parsing output: 103/ for test: gem_mmap_gtt results: parsing output: 104/ for test: kms_content_protection results: parsing output: 105/ for test: kms_writeback results: parsing output: 106/ for test: gem_create results: parsing output: 107/ for test: kms_big_fb results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: gem_softpin results: parsing output: 110/ for test: gem_exec_schedule results: parsing output: 111/ for test: kms_getfb results: parsing output: 112/ for test: kms_busy results: parsing output: 113/ for test: prime_self_import results: parsing output: 114/ for test: gem_softpin results: parsing output: 115/ for test: gem_exec_params results: parsing output: 116/ for test: gem_busy results: parsing output: 117/ for test: kms_plane_scaling results: parsing output: 118/ for test: dmabuf_sync_file results: parsing output: 119/ for test: kms_flip results: parsing output: 120/ for test: gem_ppgtt results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: kms_rotation_crc results: parsing output: 123/ for test: gem_mmap_gtt results: parsing output: 124/ for test: kms_flip_scaled_crc results: parsing output: 125/ for test: gem_ctx_persistence results: parsing output: 126/ for test: gem_readwrite results: parsing output: 127/ for test: kms_big_fb results: parsing output: 128/ for test: kms_ccs results: parsing output: 129/ for test: gem_wait results: parsing output: 130/ for test: kms_lease Done.