[68.592707] Initializing watchdogs
[68.592770]   /dev/watchdog0
[68.608297] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[68.614345] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[68.617149] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[68.619104] [001/133] (960s left) kms_flip (wf_vblank-ts-check)
[68.711043] Starting subtest: wf_vblank-ts-check
[68.712589] Starting dynamic subtest: A-HDMI-A1
[76.577297] Dynamic subtest A-HDMI-A1: SUCCESS (7.839s)
[76.582556] Starting dynamic subtest: B-HDMI-A1
[84.361210] Dynamic subtest B-HDMI-A1: SUCCESS (7.794s)
[84.368017] Starting dynamic subtest: C-HDMI-A1
[92.188884] Dynamic subtest C-HDMI-A1: SUCCESS (7.799s)
[92.194132] Starting dynamic subtest: D-HDMI-A1
[99.966258] Dynamic subtest D-HDMI-A1: SUCCESS (7.799s)
[99.966948] Subtest wf_vblank-ts-check: SUCCESS (31.239s)
[100.116608] [002/133] (929s left) kms_cursor_crc (cursor-onscreen-256x256)
[100.213780] Starting subtest: cursor-onscreen-256x256
[100.228222] Starting dynamic subtest: pipe-A-HDMI-A-1
[101.406167] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.178s)
[101.436233] Starting dynamic subtest: pipe-D-HDMI-A-1
[102.579249] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.147s)
[102.579980] Subtest cursor-onscreen-256x256: SUCCESS (2.365s)
[102.727704] [003/133] (926s left) gem_mmap_gtt (big-copy-odd)
[102.764993] Starting subtest: big-copy-odd
[109.908310] Subtest big-copy-odd: SUCCESS (7.142s)
[109.989544] [004/133] (919s left) i915_pm_rpm (sysfs-read)
[111.449232] Starting subtest: sysfs-read
[112.647890] Subtest sysfs-read: SUCCESS (1.198s)
[112.830758] [005/133] (916s left) kms_universal_plane (disable-primary-vs-flip)
[112.918591] Starting subtest: disable-primary-vs-flip
[112.919319] Starting dynamic subtest: pipe-A-HDMI-A-1
[113.233708] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.314s)
[113.240976] Starting dynamic subtest: pipe-B-HDMI-A-1
[113.557957] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.322s)
[113.565652] Starting dynamic subtest: pipe-C-HDMI-A-1
[113.847491] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.289s)
[113.854302] Starting dynamic subtest: pipe-D-HDMI-A-1
[114.123853] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.274s)
[114.124558] Subtest disable-primary-vs-flip: SUCCESS (1.205s)
[114.263350] [006/133] (915s left) perf (gen12-group-exclusive-stream-ctx-handle)
[114.361380] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[114.371783] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.010s)
[114.408523] [007/133] (914s left) kms_flip_event_leak (basic)
[114.495873] Starting subtest: basic
[114.496665] Starting dynamic subtest: pipe-A-HDMI-A-1
[114.678956] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.182s)
[114.686525] Starting dynamic subtest: pipe-B-HDMI-A-1
[114.826117] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.146s)
[114.832249] Starting dynamic subtest: pipe-C-HDMI-A-1
[114.987425] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.160s)
[114.996144] Starting dynamic subtest: pipe-D-HDMI-A-1
[115.145773] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.157s)
[115.146668] Subtest basic: SUCCESS (0.650s)
[115.284716] [008/133] (914s left) gem_exec_fence (syncobj-wait)
[115.642736] Starting subtest: syncobj-wait
[115.693324] Subtest syncobj-wait: SUCCESS (0.050s)
[116.037630] [FACT gem_exec_fence (syncobj-wait)] new: kernel.kmod_is_loaded.vgem: true
[116.039448] [009/133] (913s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[116.125298] Starting subtest: primary-y-tiled-reflect-x-90
[120.822362] Subtest primary-y-tiled-reflect-x-90: SUCCESS (4.696s)
[121.014908] [010/133] (908s left) kms_psr (fbc-psr-no-drrs)
[121.103379] Subtest fbc-psr-no-drrs: SKIP (0.000s)
[121.141847] [011/133] (908s left) kms_chamelium_edid (hdmi-mode-timings)
[121.282858] Subtest hdmi-mode-timings: SKIP (0.000s)
[121.388043] [012/133] (908s left) gem_exec_flush (basic-wb-ro-before-default)
[121.432464] Starting subtest: basic-wb-ro-before-default
[126.862769] Subtest basic-wb-ro-before-default: SUCCESS (5.430s)
[127.062351] [013/133] (902s left) gem_ccs (block-multicopy-inplace)
[127.100754] Starting subtest: block-multicopy-inplace
[127.102218] Subtest block-multicopy-inplace: SKIP (0.000s)
[127.164558] [014/133] (902s left) kms_invalid_mode (clock-too-high)
[127.251318] Starting subtest: clock-too-high
[127.252031] Starting dynamic subtest: pipe-A-HDMI-A-1
[127.308983] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.057s)
[127.318303] Starting dynamic subtest: pipe-B-HDMI-A-1
[127.319102] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.008s)
[127.327279] Starting dynamic subtest: pipe-C-HDMI-A-1
[127.330265] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.009s)
[127.338750] Starting dynamic subtest: pipe-D-HDMI-A-1
[127.341149] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.009s)
[127.341888] Subtest clock-too-high: SUCCESS (0.090s)
[127.472097] [015/133] (902s left) perf (invalid-remove-userspace-config)
[127.547442] Starting subtest: invalid-remove-userspace-config
[127.557447] Subtest invalid-remove-userspace-config: SUCCESS (0.010s)
[127.598250] [016/133] (902s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[127.686167] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[127.687597] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[127.786842] [017/133] (901s left) gem_pxp (hw-rejects-pxp-buffer)
[127.887018] Starting subtest: hw-rejects-pxp-buffer
[127.889251] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[127.961443] [018/133] (901s left) vgem_basic (dmabuf-fence)
[127.998892] Starting subtest: dmabuf-fence
[127.999587] Subtest dmabuf-fence: SUCCESS (0.001s)
[128.051097] [019/133] (901s left) core_getclient (basic)
[128.083863] Starting subtest: basic
[128.084590] Subtest basic: SUCCESS (0.000s)
[128.143384] [020/133] (901s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[128.239322] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[128.874275] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (0.635s)
[128.994388] [021/133] (900s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[129.078535] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[129.079895] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SKIP (0.000s)
[129.131766] [022/133] (900s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[129.165434] Starting subtest: invalid-signal-one-illegal-handle
[129.166141] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[129.232556] [023/133] (900s left) kms_getfb (getfb-handle-not-fb)
[129.316597] Starting subtest: getfb-handle-not-fb
[129.317301] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[129.410988] [024/133] (900s left) kms_color (invalid-ctm-matrix-sizes)
[129.496537] Starting subtest: invalid-ctm-matrix-sizes
[129.497242] Starting dynamic subtest: pipe-A
[129.500092] Dynamic subtest pipe-A: SUCCESS (0.004s)
[129.506434] Starting dynamic subtest: pipe-B
[129.507125] Dynamic subtest pipe-B: SUCCESS (0.006s)
[129.513296] Starting dynamic subtest: pipe-C
[129.513987] Dynamic subtest pipe-C: SUCCESS (0.006s)
[129.520073] Starting dynamic subtest: pipe-D
[129.520791] Dynamic subtest pipe-D: SUCCESS (0.007s)
[129.521473] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.025s)
[129.574114] [025/133] (900s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[129.658702] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[129.659380] Starting dynamic subtest: pipe-A-HDMI-A-1
[129.665984] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[129.672369] Starting dynamic subtest: pipe-B-HDMI-A-1
[129.678951] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[129.685206] Starting dynamic subtest: pipe-C-HDMI-A-1
[129.691734] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[129.698068] Starting dynamic subtest: pipe-D-HDMI-A-1
[129.704733] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[129.706050] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[129.886864] [026/133] (900s left) i915_drm_fdinfo (memory-info-resident)
[129.925587] Starting subtest: memory-info-resident
[129.926322] Starting dynamic subtest: smem0
[131.175424] Dynamic subtest smem0: SUCCESS (1.250s)
[131.176508] Subtest memory-info-resident: SUCCESS (1.251s)
[131.245086] [027/133] (898s left) gem_pipe_control_store_loop (reused-buffer)
[131.281323] Starting subtest: reused-buffer
[133.440905] Subtest reused-buffer: SUCCESS (2.151s)
[133.546055] [028/133] (896s left) device_reset (unbind-reset-rebind)
[133.594743] Starting subtest: unbind-reset-rebind
[135.393668] Subtest unbind-reset-rebind: SUCCESS (1.800s)
[135.436685] [029/133] (894s left) kms_content_protection (lic-type-1)
[135.526682] Starting subtest: lic-type-1
[135.539754] Subtest lic-type-1: SKIP (0.011s)
[135.605209] [030/133] (894s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[135.698858] Starting subtest: 4-tiled-8bpp-rotate-90
[135.700224] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.000s)
[135.789891] [031/133] (894s left) kms_rotation_crc (primary-rotation-270)
[135.875044] Starting subtest: primary-rotation-270
[140.665660] Subtest primary-rotation-270: SUCCESS (4.790s)
[140.855591] [032/133] (889s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[142.255288] Starting subtest: modeset-non-lpsp-stress-no-wait
[142.346440] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.091s)
[142.447420] [033/133] (887s left) kms_async_flips (async-flip-hang)
[142.535776] Starting subtest: async-flip-hang
[142.664892] Starting dynamic subtest: pipe-A-HDMI-A-1
[157.819583] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (15.122s)
[157.921284] Starting dynamic subtest: pipe-B-HDMI-A-1
[172.667097] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (14.718s)
[172.761797] Starting dynamic subtest: pipe-C-HDMI-A-1
[187.515482] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (14.727s)
[187.612629] Starting dynamic subtest: pipe-D-HDMI-A-1
[202.875232] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (15.237s)
[202.876042] Subtest async-flip-hang: SUCCESS (60.307s)
[203.067728] [034/133] (827s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[203.158669] Starting subtest: cursorB-vs-flipB-legacy
[203.159998] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[203.222056] [035/133] (827s left) kms_lease (master-vs-lease)
[203.305844] Starting subtest: master-vs-lease
[203.307624] Subtest master-vs-lease: SUCCESS (0.001s)
[203.363721] [036/133] (827s left) kms_plane_multiple (tiling-y)
[203.448094] Starting subtest: tiling-y
[203.449824] Starting dynamic subtest: pipe-A-HDMI-A-1
[204.097874] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.648s)
[204.106520] Starting dynamic subtest: pipe-B-HDMI-A-1
[204.788348] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.689s)
[204.797420] Starting dynamic subtest: pipe-C-HDMI-A-1
[205.389226] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.598s)
[205.399344] Starting dynamic subtest: pipe-D-HDMI-A-1
[206.019839] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.628s)
[206.020837] Subtest tiling-y: SUCCESS (2.572s)
[206.195269] [037/133] (824s left) i915_hangman (engine-engine-hang)
[206.244389] Starting subtest: engine-engine-hang
[206.245143] Starting dynamic subtest: rcs0
[206.823729] Dynamic subtest rcs0: SUCCESS (0.580s)
[206.840520] Starting dynamic subtest: bcs0
[207.397919] Dynamic subtest bcs0: SUCCESS (0.572s)
[207.408824] Starting dynamic subtest: vcs0
[207.969748] Dynamic subtest vcs0: SUCCESS (0.569s)
[207.982367] Starting dynamic subtest: vcs1
[208.545944] Dynamic subtest vcs1: SUCCESS (0.574s)
[208.557407] Starting dynamic subtest: vecs0
[209.116771] Dynamic subtest vecs0: SUCCESS (0.569s)
[209.117865] Subtest engine-engine-hang: SUCCESS (2.874s)
[209.195823] [038/133] (821s left) gem_media_fill (media-fill)
[209.234576] Starting subtest: media-fill
[209.235519] Starting dynamic subtest: smem
[209.239553] Dynamic subtest smem: SUCCESS (0.005s)
[209.240241] Subtest media-fill: SUCCESS (0.006s)
[209.456144] [039/133] (821s left) kms_flip (2x-busy-flip)
[209.543607] Starting subtest: 2x-busy-flip
[209.551999] Subtest 2x-busy-flip: SKIP (0.009s)
[209.621625] [040/133] (820s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[209.715933] Starting subtest: yf-tiled-16bpp-rotate-90
[209.717300] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[209.812147] [041/133] (820s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[209.952711] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[210.045262] [042/133] (820s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[210.507933] Starting subtest: syncobj-timeline-invalid-wait
[210.508954] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.003s)
[210.678870] [043/133] (820s left) gem_workarounds (basic-read)
[210.727050] Starting subtest: basic-read
[210.734157] Subtest basic-read: SUCCESS (0.008s)
[210.855519] [044/133] (819s left) syncobj_eventfd (invalid-illegal-eventfd)
[210.890138] Starting subtest: invalid-illegal-eventfd
[210.890876] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[210.954829] [045/133] (819s left) kms_plane_alpha_blend (alpha-7efc)
[211.044495] Starting subtest: alpha-7efc
[211.112091] Starting dynamic subtest: pipe-A-HDMI-A-1
[211.424046] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.311s)
[211.455941] Starting dynamic subtest: pipe-D-HDMI-A-1
[211.909160] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.459s)
[211.909957] Subtest alpha-7efc: SUCCESS (0.864s)
[212.042874] [046/133] (818s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[212.139862] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[212.141255] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[212.242167] [047/133] (818s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[212.327008] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[212.328805] Starting dynamic subtest: pipe-A-HDMI-A-1
[212.993607] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.662s)
[213.002217] Starting dynamic subtest: pipe-B-HDMI-A-1
[213.492306] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.496s)
[213.505647] Starting dynamic subtest: pipe-C-HDMI-A-1
[213.995129] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.498s)
[214.008671] Starting dynamic subtest: pipe-D-HDMI-A-1
[214.488227] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.488s)
[214.489134] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SUCCESS (2.159s)
[214.665397] [048/133] (816s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[214.760768] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[214.762492] Starting dynamic subtest: A-HDMI-A1
[215.496494] Dynamic subtest A-HDMI-A1: SUCCESS (0.733s)
[215.503809] Starting dynamic subtest: B-HDMI-A1
[216.114826] Dynamic subtest B-HDMI-A1: SUCCESS (0.617s)
[216.121903] Starting dynamic subtest: C-HDMI-A1
[216.699568] Dynamic subtest C-HDMI-A1: SUCCESS (0.583s)
[216.707838] Starting dynamic subtest: D-HDMI-A1
[217.339522] Dynamic subtest D-HDMI-A1: SUCCESS (0.638s)
[217.341290] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (2.581s)
[217.494226] [049/133] (813s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[217.590763] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[217.592119] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[217.686646] [050/133] (813s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[217.771980] Starting subtest: fb-8bpc-vs-panel-8bpc
[217.772710] Starting dynamic subtest: pipe-A-HDMI-A-1
[217.999167] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.226s)
[217.999917] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (0.228s)
[218.123550] [051/133] (812s left) gem_pxp (fail-invalid-protected-context)
[218.218356] Starting subtest: fail-invalid-protected-context
[218.219353] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[218.289325] [052/133] (812s left) kms_force_connector_basic (prune-stale-modes)
[218.413585] Starting subtest: prune-stale-modes
[218.562626] Subtest prune-stale-modes: SUCCESS (0.149s)
[218.712331] [053/133] (812s left) gem_render_copy_redux (interruptible)
[218.750108] Starting subtest: interruptible
[219.080310] Subtest interruptible: SUCCESS (0.323s)
[219.216403] [054/133] (812s left) perf_pmu (faulting-read)
[219.270276] Starting subtest: faulting-read
[219.271046] Starting dynamic subtest: gtt
[219.272973] Dynamic subtest gtt: SUCCESS (0.001s)
[219.281677] Starting dynamic subtest: wb
[219.282356] Dynamic subtest wb: SUCCESS (0.001s)
[219.289494] Starting dynamic subtest: wc
[219.290161] Dynamic subtest wc: SUCCESS (0.000s)
[219.297357] Starting dynamic subtest: uc
[219.298029] Dynamic subtest uc: SUCCESS (0.000s)
[219.298683] Subtest faulting-read: SUCCESS (0.008s)
[219.348928] [055/133] (811s left) gem_ctx_isolation (clean)
[219.390670] Starting subtest: clean
[219.391385] Starting dynamic subtest: rcs0
[219.414862] Dynamic subtest rcs0: SUCCESS (0.024s)
[219.423663] Starting dynamic subtest: bcs0
[219.482217] Dynamic subtest bcs0: SUCCESS (0.066s)
[219.490460] Starting dynamic subtest: vcs0
[219.540575] Dynamic subtest vcs0: SUCCESS (0.057s)
[219.549020] Starting dynamic subtest: vcs1
[219.604708] Dynamic subtest vcs1: SUCCESS (0.063s)
[219.613078] Starting dynamic subtest: vecs0
[219.664628] Dynamic subtest vecs0: SUCCESS (0.059s)
[219.665342] Subtest clean: SUCCESS (0.274s)
[219.861480] [056/133] (811s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[219.953026] Starting subtest: flip-vs-cursor-busy-crc-atomic
[220.344524] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.392s)
[220.506737] [057/133] (810s left) gem_mmap_gtt (isolation)
[220.543209] Starting subtest: isolation
[220.546759] Subtest isolation: SUCCESS (0.001s)
[220.637523] [058/133] (810s left) prime_busy (hang)
[220.674601] Starting subtest: hang
[220.675388] Starting dynamic subtest: rcs0
[234.618414] Dynamic subtest rcs0: SUCCESS (13.908s)
[234.626823] Starting dynamic subtest: bcs0
[241.594656] Dynamic subtest bcs0: SUCCESS (6.974s)
[241.601837] Starting dynamic subtest: vcs0
[248.570330] Dynamic subtest vcs0: SUCCESS (6.974s)
[248.578831] Starting dynamic subtest: vcs1
[255.548266] Dynamic subtest vcs1: SUCCESS (6.975s)
[255.555359] Starting dynamic subtest: vecs0
[262.587177] Dynamic subtest vecs0: SUCCESS (7.038s)
[262.588216] Subtest hang: SUCCESS (41.876s)
[262.657655] [059/133] (768s left) kms_cursor_crc (cursor-sliding-512x512)
[262.756981] Starting subtest: cursor-sliding-512x512
[262.759898] Subtest cursor-sliding-512x512: SKIP (0.001s)
[262.854877] [060/133] (768s left) gem_exec_balancer (sequential)
[262.897852] Starting subtest: sequential
[266.350956] Subtest sequential: SUCCESS (3.454s)
[266.534564] [061/133] (764s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[266.626616] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[266.627986] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[266.731212] [062/133] (764s left) gem_softpin (full)
[266.769777] Starting subtest: full
[266.775093] Subtest full: SUCCESS (0.006s)
[266.879719] [063/133] (764s left) kms_psr (pr-sprite-plane-move)
[266.965678] Subtest pr-sprite-plane-move: SKIP (0.000s)
[267.006853] [064/133] (764s left) gem_ctx_shared (q-in-order)
[267.048286] Starting subtest: Q-in-order
[267.049038] Starting dynamic subtest: rcs0
[267.099280] Dynamic subtest rcs0: SUCCESS (0.050s)
[267.111258] Starting dynamic subtest: bcs0
[267.154694] Dynamic subtest bcs0: SUCCESS (0.052s)
[267.167201] Starting dynamic subtest: vcs0
[267.207502] Dynamic subtest vcs0: SUCCESS (0.051s)
[267.220713] Starting dynamic subtest: vcs1
[267.260466] Dynamic subtest vcs1: SUCCESS (0.051s)
[267.273593] Starting dynamic subtest: vecs0
[267.315254] Dynamic subtest vecs0: SUCCESS (0.051s)
[267.316870] Subtest Q-in-order: SUCCESS (0.268s)
[267.515861] [065/133] (764s left) kms_chamelium_audio (hdmi-audio)
[267.658831] Subtest hdmi-audio: SKIP (0.000s)
[267.750530] [066/133] (763s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[267.785734] Starting subtest: single-wait-all-for-submit-available-submitted
[267.786454] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[267.859600] [067/133] (763s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[267.950414] Starting subtest: cursor-rapid-movement-512x170
[267.951904] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[268.035316] [068/133] (763s left) kms_big_fb (linear-64bpp-rotate-270)
[268.129158] Starting subtest: linear-64bpp-rotate-270
[268.170672] Subtest linear-64bpp-rotate-270: SKIP (0.041s)
[268.274565] [069/133] (763s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[268.360145] Starting subtest: flip-vs-cursor-atomic
[274.773126] Subtest flip-vs-cursor-atomic: SUCCESS (6.414s)
[274.916122] [070/133] (756s left) gem_exec_schedule (semaphore-power)
[275.086907] Starting subtest: semaphore-power
[276.146436] Subtest semaphore-power: SUCCESS (1.051s)
[276.312126] [071/133] (755s left) gem_ctx_persistence (legacy-engines-hang)
[276.350080] Starting subtest: legacy-engines-hang
[276.350819] Starting dynamic subtest: render
[276.389401] Dynamic subtest render: SUCCESS (0.038s)
[276.406176] Starting dynamic subtest: bsd1
[276.431667] Dynamic subtest bsd1: SUCCESS (0.039s)
[276.449963] Starting dynamic subtest: bsd2
[276.475653] Dynamic subtest bsd2: SUCCESS (0.041s)
[276.492915] Starting dynamic subtest: blt
[276.527515] Dynamic subtest blt: SUCCESS (0.049s)
[276.545839] Starting dynamic subtest: vebox
[276.569479] Dynamic subtest vebox: SUCCESS (0.039s)
[276.570484] Subtest legacy-engines-hang: SUCCESS (0.220s)
[276.648119] [072/133] (755s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[276.738085] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[276.738773] Starting dynamic subtest: pipe-A
[276.868859] Dynamic subtest pipe-A: SUCCESS (0.131s)
[276.877982] Starting dynamic subtest: pipe-B
[277.006465] Dynamic subtest pipe-B: SUCCESS (0.137s)
[277.015382] Starting dynamic subtest: pipe-C
[277.143167] Dynamic subtest pipe-C: SUCCESS (0.136s)
[277.151821] Starting dynamic subtest: pipe-D
[277.269150] Dynamic subtest pipe-D: SUCCESS (0.125s)
[277.269844] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (0.533s)
[277.430014] [073/133] (754s left) syncobj_timeline (multi-wait-for-submit-signaled)
[277.471620] Starting subtest: multi-wait-for-submit-signaled
[277.472310] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[277.547287] [074/133] (754s left) kms_atomic_interruptible (legacy-dpms)
[277.634419] Starting subtest: legacy-dpms
[277.636152] Starting dynamic subtest: pipe-A-HDMI-A-1
[283.861738] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.225s)
[283.862482] Subtest legacy-dpms: SUCCESS (6.227s)
[284.013180] [075/133] (748s left) syncobj_basic (bad-pad-handle-to-fd)
[284.049518] Starting subtest: bad-pad-handle-to-fd
[284.050223] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[284.110237] [076/133] (748s left) drm_read (short-buffer-nonblock)
[284.223747] Starting subtest: short-buffer-nonblock
[284.224536] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[284.337898] [077/133] (747s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[284.428097] Starting subtest: cursorB-vs-flipB-varying-size
[284.429436] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[284.493212] [078/133] (747s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[284.581730] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[284.583103] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[284.676804] [079/133] (747s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[284.775019] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[285.448614] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (0.674s)
[285.576217] [080/133] (746s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[285.666832] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[286.998701] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (1.332s)
[287.128515] [081/133] (745s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[287.220354] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[287.263879] [082/133] (745s left) kms_atomic (crtc-invalid-params)
[287.351068] Starting subtest: crtc-invalid-params
[287.351790] Starting dynamic subtest: pipe-A-HDMI-A-1
[287.489505] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.138s)
[287.490267] Subtest crtc-invalid-params: SUCCESS (0.140s)
[287.626420] [083/133] (744s left) kms_flip (busy-flip)
[287.715586] Starting subtest: busy-flip
[287.717216] Starting dynamic subtest: A-HDMI-A1
[288.388637] Dynamic subtest A-HDMI-A1: SUCCESS (0.671s)
[288.403867] Starting dynamic subtest: B-HDMI-A1
[289.067913] Dynamic subtest B-HDMI-A1: SUCCESS (0.673s)
[289.082146] Starting dynamic subtest: C-HDMI-A1
[289.741513] Dynamic subtest C-HDMI-A1: SUCCESS (0.669s)
[289.750944] Starting dynamic subtest: D-HDMI-A1
[290.416171] Dynamic subtest D-HDMI-A1: SUCCESS (0.673s)
[290.417141] Subtest busy-flip: SUCCESS (2.702s)
[290.575200] [084/133] (741s left) gem_exec_params (cliprects-invalid)
[290.614480] Starting subtest: cliprects-invalid
[290.615170] Subtest cliprects-invalid: SUCCESS (0.000s)
[290.707998] [085/133] (741s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[290.799762] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[291.882583] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (1.083s)
[291.991897] [086/133] (740s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[292.028098] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[292.028873] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[292.095975] [087/133] (740s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[292.189515] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[292.190876] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[292.259637] [088/133] (740s left) syncobj_timeline (wait-zero-handles)
[292.293642] Starting subtest: wait-zero-handles
[292.294401] Subtest wait-zero-handles: SUCCESS (0.000s)
[292.360639] [089/133] (740s left) kms_psr (fbc-pr-sprite-plane-onoff)
[292.448031] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[292.494986] [090/133] (740s left) gen9_exec_parse (batch-without-end)
[292.532634] Subtest batch-without-end: SKIP (0.000s)
[292.578920] [091/133] (740s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[292.684556] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[292.685969] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[292.755949] [092/133] (739s left) syncobj_wait (wait-for-submit-snapshot)
[292.789950] Starting subtest: wait-for-submit-snapshot
[292.872181] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[292.943832] [093/133] (739s left) gem_exec_suspend (basic-s0)
[292.987009] Starting subtest: basic-S0
[292.987719] Starting dynamic subtest: smem
[310.927997] Dynamic subtest smem: SUCCESS (2.712s)
[310.928761] Subtest basic-S0: SUCCESS (2.713s)
[318.137407] [094/133] (721s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[318.236934] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[318.238378] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[318.328871] [095/133] (721s left) perf (invalid-open-flags)
[318.411106] Starting subtest: invalid-open-flags
[318.411805] Subtest invalid-open-flags: SUCCESS (0.000s)
[318.451897] [096/133] (721s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[318.541528] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[318.542921] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[318.639176] [097/133] (721s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[318.728351] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[318.729748] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[318.826543] [098/133] (721s left) kms_addfb_basic (unused-modifier)
[318.862673] Starting subtest: unused-modifier
[318.863466] Subtest unused-modifier: SUCCESS (0.000s)
[319.006343] [099/133] (721s left) perf (enable-disable)
[319.085675] Starting subtest: enable-disable
[319.086516] Starting dynamic subtest: 0-rcs0
[321.353957] Dynamic subtest 0-rcs0: SUCCESS (2.201s)
[321.354817] Subtest enable-disable: SUCCESS (2.202s)
[321.394311] [100/133] (718s left) gem_exec_whisper (basic-queues-forked-all)
[321.454435] Starting subtest: basic-queues-forked-all
[324.264823] Subtest basic-queues-forked-all: SUCCESS (2.759s)
[324.471923] [101/133] (715s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[324.513595] Starting subtest: y-tiled-to-vebox-yf-tiled
[324.514289] Starting dynamic subtest: smem
[324.580901] Dynamic subtest smem: SUCCESS (0.067s)
[324.581634] Subtest y-tiled-to-vebox-yf-tiled: SUCCESS (0.068s)
[324.761748] [102/133] (715s left) kms_addfb_basic (bad-pitch-0)
[324.796389] Starting subtest: bad-pitch-0
[324.797089] Subtest bad-pitch-0: SUCCESS (0.000s)
[324.947758] [103/133] (715s left) gem_ctx_engines (execute-one)
[324.990605] Starting subtest: execute-one
[326.262679] Subtest execute-one: SUCCESS (1.248s)
[326.440687] [104/133] (713s left) gem_wait (invalid-buf)
[326.477887] Starting subtest: invalid-buf
[326.478645] Subtest invalid-buf: SUCCESS (0.000s)
[326.686321] [105/133] (713s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[326.774936] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (0.000s)
[326.817845] [106/133] (713s left) kms_pm_dc (dc3co-vpb-simulation)
[327.910084] Starting subtest: dc3co-vpb-simulation
[327.911448] Subtest dc3co-vpb-simulation: SKIP (0.000s)
[327.974220] [107/133] (712s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[328.062798] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[329.275601] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (1.202s)
[329.418866] [108/133] (711s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[329.510439] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[329.511828] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[329.624019] [109/133] (710s left) kms_plane_scaling (invalid-parameters)
[329.718243] Starting subtest: invalid-parameters
[329.718964] Starting dynamic subtest: less-than-1-height-src
[329.734040] Dynamic subtest less-than-1-height-src: SUCCESS (0.015s)
[329.742885] Starting dynamic subtest: less-than-1-width-src
[329.750258] Dynamic subtest less-than-1-width-src: SUCCESS (0.015s)
[329.751002] Subtest invalid-parameters: SUCCESS (0.032s)
[329.835871] [110/133] (710s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[329.932223] Starting subtest: yf-tiled-8bpp-rotate-0
[329.933644] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[330.028417] [111/133] (710s left) kms_psr (psr-cursor-plane-move)
[330.114359] Subtest psr-cursor-plane-move: SKIP (0.000s)
[330.157194] [112/133] (710s left) i915_suspend (basic-s3-without-i915)
[330.189988] Starting subtest: basic-s3-without-i915