[99.266406] Initializing watchdogs [99.266486] /dev/watchdog0 [99.290690] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [99.303708] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [99.307141] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [99.309502] [001/131] (960s left) gem_exec_balancer (nop) [99.405115] Starting subtest: nop [149.048234] Subtest nop: SUCCESS (49.643s) [149.424614] [002/131] (910s left) syncobj_timeline (wait-all-interrupted) [149.494241] Starting subtest: wait-all-interrupted [149.597162] Subtest wait-all-interrupted: SUCCESS (0.103s) [149.722117] [003/131] (910s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset) [149.912014] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset [149.926865] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.014s) [150.028787] [004/131] (909s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu) [150.222927] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu [150.224550] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [150.341681] [005/131] (909s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc) [150.531924] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc [150.533678] Subtest fbcpsr-rgb101010-draw-mmap-wc: SKIP (0.000s) [150.665489] [006/131] (909s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-wc) [150.856845] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-wc [150.858525] Subtest psr-1p-offscren-pri-indfb-draw-mmap-wc: SKIP (0.000s) [150.981035] [007/131] (909s left) gem_pxp (display-protected-crc) [153.579524] Starting subtest: display-protected-crc [153.582820] Subtest display-protected-crc: SKIP (0.000s) [153.678924] [008/131] (906s left) kms_dirtyfb (psr-dirtyfb-ioctl) [153.864304] Starting subtest: psr-dirtyfb-ioctl [153.869389] Subtest psr-dirtyfb-ioctl: SKIP (0.000s) [153.997927] [009/131] (906s left) gem_exec_schedule (preempt-queue-chain) [154.082602] Subtest preempt-queue-chain: SKIP (0.000s) [154.427469] [010/131] (905s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75) [154.621153] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75 [154.622191] Starting dynamic subtest: pipe-A [154.728845] Dynamic subtest pipe-A: SUCCESS (0.108s) [154.737732] Starting dynamic subtest: pipe-B [154.927312] Dynamic subtest pipe-B: SUCCESS (0.198s) [154.940293] Starting dynamic subtest: pipe-C [155.142221] Dynamic subtest pipe-C: SUCCESS (0.215s) [155.155555] Starting dynamic subtest: pipe-D [155.357030] Dynamic subtest pipe-D: SUCCESS (0.214s) [155.358054] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SUCCESS (0.736s) [155.661987] [011/131] (904s left) gem_mmap_gtt (big-bo-tiledy) [155.738997] Subtest big-bo-tiledY: SKIP (0.000s) [155.828160] [012/131] (904s left) gem_ctx_param (basic) [155.896366] Starting subtest: basic [155.898260] Subtest basic: SUCCESS (0.001s) [156.029420] [013/131] (904s left) prime_vgem (basic-fence-mmap) [156.159957] Starting subtest: basic-fence-mmap [156.162083] Subtest basic-fence-mmap: SKIP (0.000s) [156.334343] [FACT prime_vgem (basic-fence-mmap)] new: kernel.kmod_is_loaded.vgem: true [156.336074] [014/131] (904s left) kms_flip (2x-flip-vs-rmfb) [156.533062] Starting subtest: 2x-flip-vs-rmfb [156.547596] Subtest 2x-flip-vs-rmfb: SKIP (0.014s) [156.666480] [015/131] (903s left) perf (invalid-oa-format-id) [157.001386] Starting subtest: invalid-oa-format-id [157.019323] Subtest invalid-oa-format-id: SUCCESS (0.018s) [157.081470] [016/131] (903s left) kms_panel_fitting (atomic-fastset) [157.283194] Starting subtest: atomic-fastset [157.284988] Subtest atomic-fastset: SKIP (0.000s) [157.369608] [017/131] (903s left) kms_atomic_transition (plane-all-transition-nonblocking) [157.590370] Starting subtest: plane-all-transition-nonblocking [157.592466] Starting dynamic subtest: pipe-A-DP-3 [161.306518] Dynamic subtest pipe-A-DP-3: SUCCESS (3.714s) [161.395330] Starting dynamic subtest: pipe-B-DP-3 [165.155115] Dynamic subtest pipe-B-DP-3: SUCCESS (3.771s) [165.209244] Subtest plane-all-transition-nonblocking: SUCCESS (7.617s) [165.442913] [018/131] (895s left) gem_exec_alignment (many) [165.529047] Starting subtest: many [194.372584] Subtest many: SUCCESS (28.843s) [195.276405] [019/131] (865s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant) [195.515179] Starting subtest: coverage-vs-premult-vs-constant [195.779992] Starting dynamic subtest: pipe-A-DP-3 [196.231378] Dynamic subtest pipe-A-DP-3: SUCCESS (0.451s) [196.241130] Starting dynamic subtest: pipe-D-DP-3 [196.737362] Dynamic subtest pipe-D-DP-3: SUCCESS (0.504s) [196.738284] Subtest coverage-vs-premult-vs-constant: SUCCESS (1.222s) [196.995378] [020/131] (863s left) gem_spin_batch (spin-all-new) [197.084380] Starting subtest: spin-all-new [197.143117] Subtest spin-all-new: SUCCESS (0.059s) [197.401837] [021/131] (863s left) gem_ctx_persistence (legacy-engines-queued) [197.486612] Starting subtest: legacy-engines-queued [197.487465] Starting dynamic subtest: render [197.597310] Dynamic subtest render: SUCCESS (0.110s) [197.606402] Starting dynamic subtest: bsd1 [197.646514] Dynamic subtest bsd1: SUCCESS (0.049s) [197.657654] Starting dynamic subtest: bsd2 [197.701438] Dynamic subtest bsd2: SUCCESS (0.054s) [197.716661] Starting dynamic subtest: blt [197.751993] Dynamic subtest blt: SUCCESS (0.050s) [197.760592] Starting dynamic subtest: vebox [197.812551] Dynamic subtest vebox: SUCCESS (0.060s) [197.813601] Subtest legacy-engines-queued: SUCCESS (0.326s) [197.960170] [022/131] (863s left) gem_exec_params (secure-non-root) [198.043393] Starting subtest: secure-non-root [198.045545] Subtest secure-non-root: SKIP (0.000s) [198.207565] [023/131] (862s left) syncobj_wait (single-wait-for-submit-submitted) [198.294284] Starting subtest: single-wait-for-submit-submitted [198.396463] Subtest single-wait-for-submit-submitted: SUCCESS (0.101s) [198.504748] [024/131] (862s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted) [198.583885] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted [198.693735] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.107s) [198.836814] [025/131] (862s left) kms_hdr (static-toggle-dpms) [199.034164] Starting subtest: static-toggle-dpms [202.298564] Starting dynamic subtest: pipe-A-DP-3 [203.624646] Dynamic subtest pipe-A-DP-3: SUCCESS (1.326s) [203.626028] Subtest static-toggle-dpms: SUCCESS (4.590s) [203.953403] [026/131] (857s left) i915_query (query-regions-sanity-check) [204.033041] Starting subtest: query-regions-sanity-check [204.055398] Subtest query-regions-sanity-check: SUCCESS (0.022s) [204.208941] [027/131] (857s left) kms_big_fb (4-tiled-8bpp-rotate-90) [204.421184] Starting subtest: 4-tiled-8bpp-rotate-90 [204.473258] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.051s) [204.651321] [028/131] (856s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu) [204.852966] Starting subtest: fbc-rgb565-draw-mmap-cpu [207.256520] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (2.404s) [207.450589] [029/131] (854s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs) [207.654480] Starting subtest: crc-primary-suspend-yf-tiled-ccs [207.656870] Starting dynamic subtest: pipe-A-DP-3 [207.660464] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [207.670516] Starting dynamic subtest: pipe-B-DP-3 [207.674132] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [207.682425] Starting dynamic subtest: pipe-C-DP-3 [207.685976] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [207.694240] Starting dynamic subtest: pipe-D-DP-3 [207.697694] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [207.699374] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.006s) [208.106587] [030/131] (853s left) gem_userptr_blits (usage-restrictions) [208.195240] Starting subtest: usage-restrictions [208.196152] Subtest usage-restrictions: SUCCESS (0.000s) [208.375674] [031/131] (853s left) gem_exec_reloc (basic-cpu-read-active) [208.456065] Subtest basic-cpu-read-active: SKIP (0.000s) [208.535638] [032/131] (853s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines) [209.224676] Starting subtest: syncobj-stationary-timeline-chain-engines [209.397099] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.173s) [209.766706] [033/131] (852s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode) [210.039395] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s) [210.187873] [034/131] (851s left) kms_flip (dpms-off-confusion) [210.383131] Starting subtest: dpms-off-confusion [210.386892] Starting dynamic subtest: A-DP3 [218.226404] Dynamic subtest A-DP3: SUCCESS (7.839s) [218.237363] Starting dynamic subtest: B-DP3 [225.974554] Dynamic subtest B-DP3: SUCCESS (7.747s) [225.984505] Starting dynamic subtest: C-DP3 [233.743583] Dynamic subtest C-DP3: SUCCESS (7.768s) [233.753219] Starting dynamic subtest: D-DP3 [241.512423] Dynamic subtest D-DP3: SUCCESS (7.768s) [241.514398] Subtest dpms-off-confusion: SUCCESS (31.131s) [241.808896] [035/131] (820s left) kms_psr (fbc-psr-cursor-blt) [242.004421] Subtest fbc-psr-cursor-blt: SKIP (0.000s) [242.070999] [036/131] (820s left) i915_pm_rpm (reg-read-ioctl) [244.107278] Starting subtest: reg-read-ioctl [244.852113] Subtest reg-read-ioctl: SUCCESS (0.745s) [245.248017] [037/131] (816s left) i915_drm_fdinfo (virtual-busy-hang) [245.319682] Starting subtest: virtual-busy-hang [245.321455] Subtest virtual-busy-hang: SKIP (0.000s) [245.420192] [038/131] (816s left) kms_big_fb (linear-32bpp-rotate-90) [245.626158] Starting subtest: linear-32bpp-rotate-90 [245.693297] Subtest linear-32bpp-rotate-90: SKIP (0.067s) [245.875358] [039/131] (816s left) gem_basic (multigpu-create-close) [245.953051] Starting subtest: multigpu-create-close [245.954919] Subtest multigpu-create-close: SKIP (0.000s) [246.080370] [040/131] (816s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt) [246.283982] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt [246.285700] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [246.409763] [041/131] (816s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs) [246.607217] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs [246.608152] Starting dynamic subtest: pipe-A-DP-3 [246.615943] Dynamic subtest pipe-A-DP-3: SUCCESS (0.002s) [246.625279] Starting dynamic subtest: pipe-B-DP-3 [246.633163] Dynamic subtest pipe-B-DP-3: SUCCESS (0.002s) [246.642147] Starting dynamic subtest: pipe-C-DP-3 [246.649924] Dynamic subtest pipe-C-DP-3: SUCCESS (0.002s) [246.658683] Starting dynamic subtest: pipe-D-DP-3 [246.666230] Dynamic subtest pipe-D-DP-3: SUCCESS (0.002s) [246.667122] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SUCCESS (0.012s) [247.059831] [042/131] (815s left) syncobj_timeline (multi-wait-all-available-signaled) [247.140128] Starting subtest: multi-wait-all-available-signaled [247.141034] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s) [247.270961] [043/131] (815s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen) [247.470868] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen [247.472476] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [247.640274] [044/131] (815s left) vgem_slow (nohang) [247.692484] Starting subtest: nohang [258.133657] Subtest nohang: SUCCESS (10.441s) [258.208657] [045/131] (804s left) kms_atomic_transition (plane-use-after-nonblocking-unbind) [258.409490] Starting subtest: plane-use-after-nonblocking-unbind [258.411778] Starting dynamic subtest: pipe-A-DP-3 [258.475270] Dynamic subtest pipe-A-DP-3: SUCCESS (0.064s) [258.584362] Starting dynamic subtest: pipe-B-DP-3 [258.689904] Dynamic subtest pipe-B-DP-3: SUCCESS (0.139s) [258.744257] Subtest plane-use-after-nonblocking-unbind: SUCCESS (0.334s) [259.010836] [046/131] (803s left) kms_psr (pr-sprite-plane-move) [259.206204] Subtest pr-sprite-plane-move: SKIP (0.000s) [259.271962] [047/131] (803s left) gem_lmem_swapping (parallel-random-engines) [261.958858] Starting subtest: parallel-random-engines [261.959743] Starting dynamic subtest: lmem0 [296.111148] Dynamic subtest lmem0: SUCCESS (34.151s) [296.113302] Subtest parallel-random-engines: SUCCESS (34.152s) [297.305415] [FACT gem_lmem_swapping (parallel-random-engines)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [297.306446] [FACT gem_lmem_swapping (parallel-random-engines)] deleted: kernel.kmod_is_loaded.i915: true [297.308223] [048/131] (765s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite) [298.893058] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite [301.972174] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (3.080s) [302.132447] [FACT kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [302.135416] [FACT kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)] new: kernel.kmod_is_loaded.i915: true [302.138166] [049/131] (760s left) i915_query (query-garbage) [302.221441] Starting subtest: query-garbage [302.222398] Subtest query-garbage: SUCCESS (0.000s) [302.350209] [050/131] (760s left) kms_pm_rpm (modeset-lpsp-stress-no-wait) [303.974968] Starting subtest: modeset-lpsp-stress-no-wait [304.181227] Subtest modeset-lpsp-stress-no-wait: SKIP (0.207s) [304.380880] [051/131] (758s left) kms_plane (pixel-format-source-clamping) [304.575341] Starting subtest: pixel-format-source-clamping [304.611479] Starting dynamic subtest: pipe-A-plane-0 [312.961472] Dynamic subtest pipe-A-plane-0: SUCCESS (8.350s) [312.972131] Starting dynamic subtest: pipe-A-plane-3 [317.012204] Dynamic subtest pipe-A-plane-3: SUCCESS (4.050s) [317.024422] Starting dynamic subtest: pipe-A-plane-5 [317.025565] Dynamic subtest pipe-A-plane-5: SUCCESS (0.000s) [317.240613] Starting dynamic subtest: pipe-B-plane-0 [324.859435] Dynamic subtest pipe-B-plane-0: SUCCESS (7.634s) [324.901123] Starting dynamic subtest: pipe-B-plane-3 [329.175154] Dynamic subtest pipe-B-plane-3: SUCCESS (4.314s) [329.187750] Starting dynamic subtest: pipe-B-plane-5 [329.189014] Dynamic subtest pipe-B-plane-5: SUCCESS (0.000s) [329.265366] Subtest pixel-format-source-clamping: SUCCESS (24.689s) [329.542809] [052/131] (733s left) gem_render_copy_redux (flink-interruptible) [329.637445] Starting subtest: flink-interruptible [332.866663] Subtest flink-interruptible: SUCCESS (3.229s) [333.058654] [053/131] (730s left) kms_psr (psr-sprite-plane-onoff) [333.251246] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [333.303530] [054/131] (729s left) kms_cursor_crc (cursor-onscreen-32x10) [333.615768] Starting subtest: cursor-onscreen-32x10 [333.659382] Subtest cursor-onscreen-32x10: SKIP (0.042s) [334.069149] [055/131] (729s left) kms_flip (basic-flip-vs-wf_vblank) [334.264989] Starting subtest: basic-flip-vs-wf_vblank [334.269196] Starting dynamic subtest: A-DP3 [335.384925] Dynamic subtest A-DP3: SUCCESS (1.115s) [335.397680] Starting dynamic subtest: B-DP3 [336.605372] Dynamic subtest B-DP3: SUCCESS (1.219s) [336.617861] Starting dynamic subtest: C-DP3 [337.825236] Dynamic subtest C-DP3: SUCCESS (1.219s) [337.836208] Starting dynamic subtest: D-DP3 [339.014272] Dynamic subtest D-DP3: SUCCESS (1.188s) [339.016492] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.751s) [339.329643] [056/131] (724s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [339.542078] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip [339.543991] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s) [339.661769] [057/131] (723s left) kms_psr (fbc-pr-basic) [339.860260] Subtest fbc-pr-basic: SKIP (0.000s) [339.922315] [058/131] (723s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc) [340.121023] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc [340.122742] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [340.279280] [059/131] (723s left) api_intel_allocator (reopen-fork) [340.356404] Starting subtest: reopen-fork [343.877845] Subtest reopen-fork: SUCCESS (3.520s) [344.038548] [060/131] (719s left) perf_pmu (rc6) [344.110473] Starting subtest: rc6 [344.111402] Starting dynamic subtest: gt0 [350.464601] Dynamic subtest gt0: SUCCESS (6.352s) [350.477514] Starting dynamic subtest: runtime-pm-gt0 [358.163372] Dynamic subtest runtime-pm-gt0: SUCCESS (7.696s) [358.174120] Starting dynamic subtest: runtime-pm-long-gt0 [370.784622] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.619s) [370.797136] Starting dynamic subtest: other-idle-gt0 [370.799045] Dynamic subtest other-idle-gt0: SKIP (0.000s) [370.799986] Subtest rc6: SUCCESS (26.675s) [370.982044] [061/131] (692s left) kms_psr (psr-basic) [371.181088] Subtest psr-basic: SKIP (0.000s) [371.231864] [062/131] (692s left) gem_madvise (dontneed-before-mmap) [371.282875] Starting subtest: dontneed-before-mmap [371.332389] Subtest dontneed-before-mmap: SUCCESS (0.050s) [371.401421] [063/131] (692s left) syncobj_timeline (etime-single-wait-submitted) [371.481508] Starting subtest: etime-single-wait-submitted [371.589070] Subtest etime-single-wait-submitted: SUCCESS (0.106s) [371.663667] [064/131] (692s left) kms_chamelium_frames (dp-frame-dump) [371.951120] Subtest dp-frame-dump: SKIP (0.000s) [372.106450] [065/131] (691s left) gem_flink_race (flink_close) [372.154535] Starting subtest: flink_close [377.238103] Subtest flink_close: SUCCESS (5.083s) [377.296860] [066/131] (686s left) gem_gpgpu_fill (offset-16x16) [377.379065] Starting subtest: offset-16x16 [377.411095] Subtest offset-16x16: SUCCESS (0.032s) [377.529705] [067/131] (686s left) gem_exec_capture (capture) [377.626297] Starting subtest: capture [377.627231] Starting dynamic subtest: rcs0-smem [378.598292] Dynamic subtest rcs0-smem: SUCCESS (0.972s) [378.609196] Starting dynamic subtest: rcs0-lmem0 [380.030521] Dynamic subtest rcs0-lmem0: SUCCESS (1.431s) [380.041285] Starting dynamic subtest: bcs0-smem [380.949379] Dynamic subtest bcs0-smem: SUCCESS (0.918s) [380.960166] Starting dynamic subtest: bcs0-lmem0 [381.865306] Dynamic subtest bcs0-lmem0: SUCCESS (0.915s) [381.876500] Starting dynamic subtest: vcs0-smem [382.765365] Dynamic subtest vcs0-smem: SUCCESS (0.899s) [382.776302] Starting dynamic subtest: vcs0-lmem0 [384.178169] Dynamic subtest vcs0-lmem0: SUCCESS (1.408s) [384.189061] Starting dynamic subtest: vcs1-smem [385.242383] Dynamic subtest vcs1-smem: SUCCESS (1.066s) [385.253279] Starting dynamic subtest: vcs1-lmem0 [386.141277] Dynamic subtest vcs1-lmem0: SUCCESS (0.899s) [386.152062] Starting dynamic subtest: vecs0-smem [387.265880] Dynamic subtest vecs0-smem: FAIL (1.103s) [387.276448] Starting dynamic subtest: vecs0-lmem0 [388.586549] Dynamic subtest vecs0-lmem0: FAIL (1.318s) [388.597068] Starting dynamic subtest: vecs1-smem [390.005721] Dynamic subtest vecs1-smem: FAIL (1.418s) [390.016189] Starting dynamic subtest: vecs1-lmem0 [391.014133] Dynamic subtest vecs1-lmem0: FAIL (1.007s) [391.024734] Starting dynamic subtest: ccs0-smem [392.409390] Dynamic subtest ccs0-smem: SUCCESS (1.417s) [392.420190] Starting dynamic subtest: ccs0-lmem0 [393.839939] Dynamic subtest ccs0-lmem0: SUCCESS (1.430s) [393.840993] Subtest capture: FAIL (16.214s) [393.932390] [068/131] (670s left) kms_universal_plane (universal-plane-functional) [394.135448] Starting subtest: universal-plane-functional [394.137803] Starting dynamic subtest: pipe-A-DP-3 [396.504709] Dynamic subtest pipe-A-DP-3: SUCCESS (2.368s) [396.518609] Starting dynamic subtest: pipe-B-DP-3 [398.684453] Dynamic subtest pipe-B-DP-3: SUCCESS (2.177s) [398.698982] Starting dynamic subtest: pipe-C-DP-3 [400.848244] Dynamic subtest pipe-C-DP-3: SUCCESS (2.161s) [400.861309] Starting dynamic subtest: pipe-D-DP-3 [403.017465] Dynamic subtest pipe-D-DP-3: SUCCESS (2.167s) [403.018391] Subtest universal-plane-functional: SUCCESS (8.881s) [403.210809] [069/131] (660s left) perf_pmu (event-wait) [403.281993] Starting subtest: event-wait [403.282985] Starting dynamic subtest: rcs0 [403.284863] Dynamic subtest rcs0: SKIP (0.000s) [403.286552] Subtest event-wait: SKIP (0.001s) [403.387613] [070/131] (660s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt) [403.594787] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt [403.597011] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [403.668048] [071/131] (660s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions) [403.869957] Starting subtest: cursorB-vs-flipA-atomic-transitions [403.873321] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.002s) [403.933705] [072/131] (660s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf) [404.133780] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [404.180977] [073/131] (660s left) kms_chamelium_edid (vga-edid-read) [404.464416] Subtest vga-edid-read: SKIP (0.000s) [404.613029] [074/131] (659s left) gen9_exec_parse (unaligned-jump) [404.703446] Subtest unaligned-jump: SKIP (0.000s) [404.790086] [075/131] (659s left) kms_cursor_legacy (forked-bo) [404.988816] Starting subtest: forked-bo [404.989755] Starting dynamic subtest: pipe-A [410.418466] Dynamic subtest pipe-A: SUCCESS (5.427s) [410.441030] Starting dynamic subtest: pipe-B [415.854275] Dynamic subtest pipe-B: SUCCESS (5.434s) [415.879275] Starting dynamic subtest: pipe-C [421.284408] Dynamic subtest pipe-C: SUCCESS (5.428s) [421.309761] Starting dynamic subtest: pipe-D [426.710976] Dynamic subtest pipe-D: SUCCESS (5.423s) [426.733594] Starting dynamic subtest: all-pipes [432.129189] Dynamic subtest all-pipes: SUCCESS (5.417s) [432.130448] Subtest forked-bo: SUCCESS (27.139s) [432.190164] [076/131] (632s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move) [432.395288] Starting subtest: fbc-2p-scndscrn-spr-indfb-move [432.397053] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [432.472252] [077/131] (632s left) kms_cursor_crc (cursor-rapid-movement-64x64) [432.810097] Starting subtest: cursor-rapid-movement-64x64 [432.814562] Starting dynamic subtest: pipe-A-DP-3 [433.252605] Dynamic subtest pipe-A-DP-3: SUCCESS (0.437s) [433.294158] Starting dynamic subtest: pipe-D-DP-3 [433.705552] Dynamic subtest pipe-D-DP-3: SUCCESS (0.421s) [433.706537] Subtest cursor-rapid-movement-64x64: SUCCESS (0.895s) [434.132668] [078/131] (630s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling) [434.329679] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling [434.332166] Starting dynamic subtest: pipe-A-valid-mode [434.402498] Dynamic subtest pipe-A-valid-mode: SKIP (0.070s) [434.404376] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.072s) [434.542131] [079/131] (630s left) sw_sync (alloc_fence) [434.591475] Starting subtest: alloc_fence [434.592400] Subtest alloc_fence: SUCCESS (0.000s) [434.639742] [080/131] (630s left) kms_feature_discovery (psr2) [434.840373] Starting subtest: psr2 [434.842164] Subtest psr2: SKIP (0.000s) [434.902141] [081/131] (629s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-blt) [435.104237] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-blt [435.105994] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-blt: SKIP (0.000s) [435.186560] [082/131] (629s left) syncobj_timeline (multi-wait-all-signaled) [435.265286] Starting subtest: multi-wait-all-signaled [435.266228] Subtest multi-wait-all-signaled: SUCCESS (0.001s) [435.336850] [083/131] (629s left) vgem_basic (second-client) [435.404346] Starting subtest: second-client [435.437958] Subtest second-client: SUCCESS (0.033s) [435.489458] [084/131] (629s left) kms_psr (fbc-pr-sprite-mmap-gtt) [435.689174] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s) [435.749333] [085/131] (629s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc) [435.949130] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc [435.950913] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [436.039216] [086/131] (629s left) gem_mmap_gtt (basic-write-read) [436.118412] Subtest basic-write-read: SKIP (0.000s) [436.180652] [087/131] (628s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs) [436.378580] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs [436.381159] Starting dynamic subtest: pipe-A-DP-3 [436.389903] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [436.400821] Starting dynamic subtest: pipe-B-DP-3 [436.409550] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [436.420118] Starting dynamic subtest: pipe-C-DP-3 [436.428582] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [436.439178] Starting dynamic subtest: pipe-D-DP-3 [436.454449] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [436.456599] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.007s) [436.772291] [088/131] (628s left) api_intel_allocator (default-alignment) [436.852321] Starting subtest: default-alignment [436.858025] Subtest default-alignment: SUCCESS (0.006s) [436.993148] [089/131] (628s left) gem_userptr_blits (dmabuf-sync) [437.084265] Starting subtest: dmabuf-sync [437.103336] Subtest dmabuf-sync: SKIP (0.018s) [437.201373] [090/131] (628s left) intel_sysfs_debugfs (i915-sysfs-read-all-entries) [437.294430] Starting subtest: i915-sysfs-read-all-entries [437.496935] Subtest i915-sysfs-read-all-entries: SUCCESS (0.204s) [437.720046] [091/131] (627s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt) [437.919996] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt [437.921972] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [438.010551] [092/131] (627s left) gem_exec_schedule (fairslice) [438.103115] Starting subtest: fairslice [438.104071] Starting dynamic subtest: rcs0 [440.154266] Dynamic subtest rcs0: SUCCESS (2.049s) [440.165582] Starting dynamic subtest: bcs0 [442.175283] Dynamic subtest bcs0: SUCCESS (2.020s) [442.186586] Starting dynamic subtest: vcs0 [444.194159] Dynamic subtest vcs0: SUCCESS (2.018s) [444.205402] Starting dynamic subtest: vcs1 [446.215227] Dynamic subtest vcs1: SUCCESS (2.020s) [446.226555] Starting dynamic subtest: vecs0 [448.234163] Dynamic subtest vecs0: SUCCESS (2.018s) [448.245585] Starting dynamic subtest: vecs1 [450.256187] Dynamic subtest vecs1: SUCCESS (2.021s) [450.267630] Starting dynamic subtest: ccs0 [452.272901] Dynamic subtest ccs0: SUCCESS (2.015s) [452.273818] Subtest fairslice: SUCCESS (14.169s) [452.586914] [093/131] (612s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf) [452.786917] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (0.000s) [452.833404] [094/131] (612s left) kms_pm_rpm (dpms-lpsp) [455.067207] Starting subtest: dpms-lpsp [455.069932] Subtest dpms-lpsp: SKIP (0.001s) [455.307985] [095/131] (610s left) perf_pmu (render-node-busy-idle) [455.427031] Starting subtest: render-node-busy-idle [455.427970] Starting dynamic subtest: rcs0 [456.117860] Dynamic subtest rcs0: SUCCESS (0.689s) [456.134957] Starting dynamic subtest: bcs0 [456.784955] Dynamic subtest bcs0: SUCCESS (0.663s) [456.804757] Starting dynamic subtest: vcs0 [457.449985] Dynamic subtest vcs0: SUCCESS (0.661s) [457.469813] Starting dynamic subtest: vcs1 [458.115848] Dynamic subtest vcs1: SUCCESS (0.662s) [458.135700] Starting dynamic subtest: vecs0 [458.783094] Dynamic subtest vecs0: SUCCESS (0.663s) [458.802326] Starting dynamic subtest: vecs1 [459.447718] Dynamic subtest vecs1: SUCCESS (0.660s) [459.467678] Starting dynamic subtest: ccs0 [460.117864] Dynamic subtest ccs0: SUCCESS (0.666s) [460.120107] Subtest render-node-busy-idle: SUCCESS (4.692s) [460.183021] [096/131] (605s left) kms_vrr (negative-basic) [460.377541] Starting subtest: negative-basic [460.380194] Starting dynamic subtest: pipe-A-DP-3 [465.814272] Dynamic subtest pipe-A-DP-3: SUCCESS (5.432s) [465.892511] Subtest negative-basic: SUCCESS (5.513s) [466.102720] [097/131] (599s left) sysfs_heartbeat_interval (nopreempt) [466.190834] Starting subtest: nopreempt [466.191741] Starting dynamic subtest: vecs0 [470.519117] Dynamic subtest vecs0: SUCCESS (4.327s) [470.531044] Starting dynamic subtest: ccs0 [474.757379] Dynamic subtest ccs0: SUCCESS (4.237s) [474.770406] Starting dynamic subtest: vcs0 [478.967133] Dynamic subtest vcs0: SUCCESS (4.208s) [478.979047] Starting dynamic subtest: bcs0 [483.118165] Dynamic subtest bcs0: SUCCESS (4.150s) [483.130265] Starting dynamic subtest: vecs1 [487.316430] Dynamic subtest vecs1: SUCCESS (4.197s) [487.330267] Starting dynamic subtest: rcs0 [491.627338] Dynamic subtest rcs0: SUCCESS (4.310s) [491.641289] Starting dynamic subtest: vcs1 [495.832148] Dynamic subtest vcs1: SUCCESS (4.204s) [495.833084] Subtest nopreempt: SUCCESS (29.641s) [495.959932] [098/131] (569s left) kms_atomic (atomic-invalid-params) [496.155545] Starting subtest: atomic-invalid-params [496.158021] Starting dynamic subtest: pipe-A-DP-3 [496.782165] Dynamic subtest pipe-A-DP-3: SUCCESS (0.625s) [496.783167] Subtest atomic-invalid-params: SUCCESS (0.627s) [496.982825] [099/131] (568s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs) [497.177495] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs [497.179983] Starting dynamic subtest: pipe-A-DP-3 [497.188527] Dynamic subtest pipe-A-DP-3: SKIP (0.001s) [497.200119] Starting dynamic subtest: pipe-B-DP-3 [497.208768] Dynamic subtest pipe-B-DP-3: SKIP (0.001s) [497.220163] Starting dynamic subtest: pipe-C-DP-3 [497.228502] Dynamic subtest pipe-C-DP-3: SKIP (0.001s) [497.240226] Starting dynamic subtest: pipe-D-DP-3 [497.251074] Dynamic subtest pipe-D-DP-3: SKIP (0.001s) [497.253384] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.009s) [497.579740] [100/131] (568s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move) [497.779127] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move [497.780948] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SKIP (0.000s) [497.859544] [101/131] (568s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs) [497.947296] Starting subtest: mixed-tiled-to-yf-tiled-ccs [497.949424] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s) [498.116125] [102/131] (567s left) gem_mmap (bad-object) [498.192309] Subtest bad-object: SKIP (0.000s) [498.256062] [103/131] (567s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [498.464935] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [499.193181] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.728s) [499.335870] [104/131] (566s left) gem_mmap_gtt (coherency) [499.414292] Subtest coherency: SKIP (0.000s) [499.473554] [105/131] (566s left) kms_content_protection (atomic-dpms) [499.735238] Starting subtest: atomic-dpms [499.761105] Starting dynamic subtest: pipe-A-DP-3 [623.121859] Dynamic subtest pipe-A-DP-3: FAIL (123.194s) [623.123050] Subtest atomic-dpms: FAIL (123.316s) [623.254116] [106/131] (442s left) kms_writeback (writeback-fb-id-xrgb2101010) [623.447966] Subtest writeback-fb-id-XRGB2101010: SKIP (0.000s) [623.510343] [107/131] (442s left) gem_create (create-size-update) [623.592543] Starting subtest: create-size-update [623.593472] Subtest create-size-update: SUCCESS (0.000s) [623.804611] [108/131] (442s left) kms_big_fb (y-tiled-64bpp-rotate-0) [624.017163] Starting subtest: y-tiled-64bpp-rotate-0 [624.018922] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s) [624.095746] [109/131] (442s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move) [624.295156] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move [624.296978] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [624.384222] [110/131] (442s left) gem_softpin (noreloc-interruptible) [624.471695] Starting subtest: noreloc-interruptible [629.941590] Subtest noreloc-interruptible: SUCCESS (5.470s) [630.029022] [111/131] (436s left) gem_exec_schedule (u-semaphore-user) [630.123067] Starting subtest: u-semaphore-user [630.209240] Subtest u-semaphore-user: SUCCESS (0.086s) [630.605155] [112/131] (435s left) kms_getfb (getfb2-accept-nv12) [630.800950] Starting subtest: getfb2-accept-nv12 [630.803404] Subtest getfb2-accept-nv12: SUCCESS (0.002s) [630.896790] [113/131] (435s left) kms_busy (basic-hang) [631.109503] Starting subtest: basic-hang [631.111806] Starting dynamic subtest: flip-pipe-A [631.728637] Dynamic subtest flip-pipe-A: SUCCESS (0.616s) [631.755380] Starting dynamic subtest: modeset-pipe-A [632.678492] Dynamic subtest modeset-pipe-A: SUCCESS (0.947s) [632.705715] Starting dynamic subtest: flip-pipe-D [633.212122] Dynamic subtest flip-pipe-D: SUCCESS (0.527s) [633.224943] Starting dynamic subtest: modeset-pipe-D [634.057086] Dynamic subtest modeset-pipe-D: SUCCESS (0.843s) [634.058057] Subtest basic-hang: SUCCESS (2.947s) [634.271972] [114/131] (432s left) prime_self_import (basic-llseek-size) [634.320972] Starting subtest: basic-llseek-size [634.352728] Subtest basic-llseek-size: SUCCESS (0.032s) [634.426931] [115/131] (432s left) gem_softpin (allocator-basic) [634.511469] Starting subtest: allocator-basic [634.750646] Subtest allocator-basic: SUCCESS (0.239s) [634.922881] [116/131] (431s left) gem_exec_params (rel-constants-invalid-ring) [635.009122] Starting subtest: rel-constants-invalid-ring [635.010057] Subtest rel-constants-invalid-ring: SUCCESS (0.000s) [635.112543] [117/131] (431s left) gem_busy (semaphore) [635.355507] Subtest semaphore: SKIP (0.000s) [635.611395] [118/131] (431s left) kms_plane_scaling (planes-downscale-factor-0-25-upscale-20x20) [635.805523] Starting subtest: planes-downscale-factor-0-25-upscale-20x20 [635.806471] Starting dynamic subtest: pipe-A [636.498052] Dynamic subtest pipe-A: SKIP (0.690s) [636.510279] Starting dynamic subtest: pipe-B [637.539046] Dynamic subtest pipe-B: SKIP (1.040s) [637.551297] Starting dynamic subtest: pipe-C [638.582459] Dynamic subtest pipe-C: SKIP (1.042s) [638.594509] Starting dynamic subtest: pipe-D [639.623795] Dynamic subtest pipe-D: SKIP (1.041s) [639.625239] Subtest planes-downscale-factor-0-25-upscale-20x20: SKIP (3.817s) [639.696770] [119/131] (427s left) dmabuf_sync_file (export-multiwait) [639.763190] Starting subtest: export-multiwait [639.764085] Subtest export-multiwait: SUCCESS (0.001s) [639.813989] [120/131] (427s left) kms_flip (blocking-absolute-wf_vblank-interruptible) [640.014973] Starting subtest: blocking-absolute-wf_vblank-interruptible [640.019760] Starting dynamic subtest: A-DP3 [647.815306] Dynamic subtest A-DP3: SUCCESS (7.795s) [647.831379] Starting dynamic subtest: B-DP3 [655.562359] Dynamic subtest B-DP3: SUCCESS (7.745s) [655.576567] Starting dynamic subtest: C-DP3 [663.312119] Dynamic subtest C-DP3: SUCCESS (7.747s) [663.328654] Starting dynamic subtest: D-DP3 [671.053342] Dynamic subtest D-DP3: SUCCESS (7.736s) [671.055596] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (31.039s) [671.300494] [121/131] (395s left) gem_ppgtt (shrink-vs-evict-pinned) [671.383972] Starting subtest: shrink-vs-evict-pinned [676.902543] Subtest shrink-vs-evict-pinned: SUCCESS (5.516s) [677.020742] [122/131] (390s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move) [677.227254] Starting subtest: psr-2p-primscrn-spr-indfb-move [677.228976] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [677.319415] [123/131] (389s left) kms_rotation_crc (sprite-rotation-90-pos-100-0) [677.518532] Starting subtest: sprite-rotation-90-pos-100-0 [677.520295] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s) [677.584393] [124/131] (389s left) gem_mmap_gtt (cpuset-big-copy-xy) [677.673274] Subtest cpuset-big-copy-XY: SKIP (0.000s) [677.751136] [125/131] (389s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling) [677.946615] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling [677.949133] Starting dynamic subtest: pipe-A-valid-mode [680.424799] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.473s) [680.426812] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SUCCESS (2.477s) [680.632365] [126/131] (386s left) gem_ctx_persistence (engines-cleanup) [680.721561] Starting subtest: engines-cleanup [680.722501] Starting dynamic subtest: rcs0 [680.828437] Dynamic subtest rcs0: SUCCESS (0.106s) [680.843040] Starting dynamic subtest: bcs0 [680.872351] Dynamic subtest bcs0: SUCCESS (0.043s) [680.890443] Starting dynamic subtest: vcs0 [680.891636] Dynamic subtest vcs0: SUCCESS (0.013s) [680.907607] Starting dynamic subtest: vcs1 [680.945394] Dynamic subtest vcs1: SUCCESS (0.058s) [680.966195] Starting dynamic subtest: vecs0 [680.969024] Dynamic subtest vecs0: SUCCESS (0.022s) [680.987812] Starting dynamic subtest: vecs1 [681.011317] Dynamic subtest vecs1: SUCCESS (0.042s) [681.030194] Starting dynamic subtest: ccs0 [681.073629] Dynamic subtest ccs0: SUCCESS (0.061s) [681.074862] Subtest engines-cleanup: SUCCESS (0.353s) [681.228580] [127/131] (386s left) gem_readwrite (write-bad-handle) [681.310285] Subtest write-bad-handle: SKIP (0.000s) [681.380832] [128/131] (386s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [681.587047] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip [682.310669] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.724s) [682.482587] [129/131] (385s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs) [682.675521] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs [682.678021] Starting dynamic subtest: pipe-A-DP-3 [682.686549] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [682.698899] Starting dynamic subtest: pipe-B-DP-3 [682.707511] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [682.719636] Starting dynamic subtest: pipe-C-DP-3 [682.728271] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [682.740347] Starting dynamic subtest: pipe-D-DP-3 [682.749571] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [682.751581] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.007s) [683.059933] [130/131] (384s left) gem_wait (write-wait) [683.154430] Starting subtest: write-wait [683.155398] Starting dynamic subtest: all-engines [684.276124] Dynamic subtest all-engines: SUCCESS (1.120s) [684.297720] Starting dynamic subtest: rcs0 [685.347475] Dynamic subtest rcs0: SUCCESS (1.068s) [685.372147] Starting dynamic subtest: bcs0 [686.413558] Dynamic subtest bcs0: SUCCESS (1.065s) [686.429485] Starting dynamic subtest: vcs0 [687.472759] Dynamic subtest vcs0: SUCCESS (1.057s) [687.521652] Starting dynamic subtest: vcs1 [688.550881] Dynamic subtest vcs1: SUCCESS (1.074s) [688.573614] Starting dynamic subtest: vecs0 [689.614957] Dynamic subtest vecs0: SUCCESS (1.059s) [689.662407] Starting dynamic subtest: vecs1 [690.693033] Dynamic subtest vecs1: SUCCESS (1.073s) [690.741604] Starting dynamic subtest: ccs0 [691.769896] Dynamic subtest ccs0: SUCCESS (1.072s) [691.772117] Subtest write-wait: SUCCESS (8.617s) [692.006995] [131/131] (375s left) kms_lease (lease-invalid-crtc) [692.204463] Starting subtest: lease-invalid-crtc [692.206978] Starting dynamic subtest: pipe-A-DP-3 [692.207860] Dynamic subtest pipe-A-DP-3: SUCCESS (0.000s) [692.220508] Starting dynamic subtest: pipe-B-DP-3 [692.221593] Dynamic subtest pipe-B-DP-3: SUCCESS (0.000s) [692.234009] Starting dynamic subtest: pipe-C-DP-3 [692.235178] Dynamic subtest pipe-C-DP-3: SUCCESS (0.000s) [692.247157] Starting dynamic subtest: pipe-D-DP-3 [692.248385] Dynamic subtest pipe-D-DP-3: SUCCESS (0.000s) [692.249612] Subtest lease-invalid-crtc: SUCCESS (0.006s) [692.296379] 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.