[47.743640] Initializing watchdogs
[47.743702]   /dev/watchdog0
[47.758919] [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]
[47.764622] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[47.767304] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[47.769144] [001/133] (960s left) kms_flip (wf_vblank-ts-check)
[47.858905] Starting subtest: wf_vblank-ts-check
[47.860596] Starting dynamic subtest: A-HDMI-A1
[55.737988] Dynamic subtest A-HDMI-A1: SUCCESS (7.860s)
[55.742842] Starting dynamic subtest: B-HDMI-A1
[63.546835] Dynamic subtest B-HDMI-A1: SUCCESS (7.798s)
[63.551738] Starting dynamic subtest: C-HDMI-A1
[71.346235] Dynamic subtest C-HDMI-A1: SUCCESS (7.799s)
[71.351126] Starting dynamic subtest: D-HDMI-A1
[79.122422] Dynamic subtest D-HDMI-A1: SUCCESS (7.798s)
[79.123151] Subtest wf_vblank-ts-check: SUCCESS (31.263s)
[79.276658] [002/133] (929s left) kms_cursor_crc (cursor-onscreen-256x256)
[79.368662] Starting subtest: cursor-onscreen-256x256
[79.383819] Starting dynamic subtest: pipe-A-HDMI-A-1
[80.560168] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.176s)
[80.593813] Starting dynamic subtest: pipe-D-HDMI-A-1
[81.727078] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.140s)
[81.727795] Subtest cursor-onscreen-256x256: SUCCESS (2.359s)
[81.861395] [003/133] (926s left) gem_mmap_gtt (big-copy-odd)
[81.896549] Starting subtest: big-copy-odd
[89.000413] Subtest big-copy-odd: SUCCESS (7.101s)
[89.059885] [004/133] (919s left) i915_pm_rpm (sysfs-read)
[90.526534] Starting subtest: sysfs-read
[91.734144] Subtest sysfs-read: SUCCESS (1.207s)
[91.902957] [005/133] (916s left) kms_universal_plane (disable-primary-vs-flip)
[91.992734] Starting subtest: disable-primary-vs-flip
[91.993427] Starting dynamic subtest: pipe-A-HDMI-A-1
[92.299101] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.305s)
[92.305760] Starting dynamic subtest: pipe-B-HDMI-A-1
[92.618462] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.318s)
[92.625334] Starting dynamic subtest: pipe-C-HDMI-A-1
[92.905542] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.285s)
[92.912231] Starting dynamic subtest: pipe-D-HDMI-A-1
[93.201399] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.294s)
[93.202111] Subtest disable-primary-vs-flip: SUCCESS (1.209s)
[93.326482] [006/133] (915s left) perf (gen12-group-exclusive-stream-ctx-handle)
[93.441912] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[93.452643] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.010s)
[93.489250] [007/133] (914s left) kms_flip_event_leak (basic)
[93.577470] Starting subtest: basic
[93.578192] Starting dynamic subtest: pipe-A-HDMI-A-1
[93.759734] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.182s)
[93.768140] Starting dynamic subtest: pipe-B-HDMI-A-1
[93.924702] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.163s)
[93.933450] Starting dynamic subtest: pipe-C-HDMI-A-1
[94.083759] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.158s)
[94.090645] Starting dynamic subtest: pipe-D-HDMI-A-1
[94.233261] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.148s)
[94.233977] Subtest basic: SUCCESS (0.657s)
[94.349688] [008/133] (914s left) gem_exec_fence (syncobj-wait)
[94.766990] Starting subtest: syncobj-wait
[94.824358] Subtest syncobj-wait: SUCCESS (0.071s)
[95.153811] [FACT gem_exec_fence (syncobj-wait)] new: kernel.kmod_is_loaded.vgem: true
[95.155363] [009/133] (913s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[95.242741] Starting subtest: primary-y-tiled-reflect-x-90
[100.202365] Subtest primary-y-tiled-reflect-x-90: SUCCESS (4.960s)
[100.394336] [010/133] (908s left) kms_psr (fbc-psr-no-drrs)
[100.486542] Subtest fbc-psr-no-drrs: SKIP (0.000s)
[100.529913] [011/133] (908s left) kms_chamelium_edid (hdmi-mode-timings)
[100.668469] Subtest hdmi-mode-timings: SKIP (0.000s)
[100.757348] [012/133] (907s left) gem_exec_flush (basic-wb-ro-before-default)
[100.803532] Starting subtest: basic-wb-ro-before-default
[106.234787] Subtest basic-wb-ro-before-default: SUCCESS (5.432s)
[106.435578] [013/133] (902s left) gem_ccs (block-multicopy-inplace)
[106.473389] Starting subtest: block-multicopy-inplace
[106.474786] Subtest block-multicopy-inplace: SKIP (0.000s)
[106.535240] [014/133] (902s left) kms_invalid_mode (clock-too-high)
[106.622396] Starting subtest: clock-too-high
[106.623140] Starting dynamic subtest: pipe-A-HDMI-A-1
[106.681289] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.058s)
[106.691175] Starting dynamic subtest: pipe-B-HDMI-A-1
[106.694559] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.012s)
[106.702511] Starting dynamic subtest: pipe-C-HDMI-A-1
[106.705068] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.009s)
[106.713110] Starting dynamic subtest: pipe-D-HDMI-A-1
[106.715264] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.008s)
[106.716013] Subtest clock-too-high: SUCCESS (0.093s)
[106.846069] [015/133] (901s left) perf (invalid-remove-userspace-config)
[106.926413] Starting subtest: invalid-remove-userspace-config
[106.936488] Subtest invalid-remove-userspace-config: SUCCESS (0.010s)
[106.976257] [016/133] (901s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[107.063598] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[107.064986] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[107.172418] [017/133] (901s left) gem_pxp (hw-rejects-pxp-buffer)
[107.273904] Starting subtest: hw-rejects-pxp-buffer
[107.276138] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[107.347088] [018/133] (901s left) vgem_basic (dmabuf-fence)
[107.385338] Starting subtest: dmabuf-fence
[107.386040] Subtest dmabuf-fence: SUCCESS (0.001s)
[107.438027] [019/133] (901s left) core_getclient (basic)
[107.471370] Starting subtest: basic
[107.472106] Subtest basic: SUCCESS (0.000s)
[107.529738] [020/133] (901s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[107.625150] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[108.301859] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (0.677s)
[108.430500] [021/133] (900s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[108.513953] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[108.515420] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SKIP (0.000s)
[108.568546] [022/133] (900s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[108.603714] Starting subtest: invalid-signal-one-illegal-handle
[108.604451] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[108.668823] [023/133] (900s left) kms_getfb (getfb-handle-not-fb)
[108.758438] Starting subtest: getfb-handle-not-fb
[108.759161] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[108.848357] [024/133] (900s left) kms_color (invalid-ctm-matrix-sizes)
[108.932901] Starting subtest: invalid-ctm-matrix-sizes
[108.933632] Starting dynamic subtest: pipe-A
[108.936354] Dynamic subtest pipe-A: SUCCESS (0.004s)
[108.944664] Starting dynamic subtest: pipe-B
[108.945411] Dynamic subtest pipe-B: SUCCESS (0.006s)
[108.953381] Starting dynamic subtest: pipe-C
[108.954130] Dynamic subtest pipe-C: SUCCESS (0.006s)
[108.962330] Starting dynamic subtest: pipe-D
[108.963088] Dynamic subtest pipe-D: SUCCESS (0.007s)
[108.963823] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.025s)
[109.010386] [025/133] (900s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[109.094961] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[109.096799] Starting dynamic subtest: pipe-A-HDMI-A-1
[109.103868] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[109.112819] Starting dynamic subtest: pipe-B-HDMI-A-1
[109.119826] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[109.128648] Starting dynamic subtest: pipe-C-HDMI-A-1
[109.135620] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[109.143917] Starting dynamic subtest: pipe-D-HDMI-A-1
[109.150832] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[109.152201] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[109.339963] [026/133] (899s left) i915_drm_fdinfo (memory-info-resident)
[109.377497] Starting subtest: memory-info-resident
[109.378274] Starting dynamic subtest: smem0
[110.569757] Dynamic subtest smem0: SUCCESS (1.192s)
[110.570645] Subtest memory-info-resident: SUCCESS (1.193s)
[110.635209] [027/133] (898s left) gem_pipe_control_store_loop (reused-buffer)
[110.672010] Starting subtest: reused-buffer
[112.856729] Subtest reused-buffer: SUCCESS (2.151s)
[112.916874] [028/133] (896s left) device_reset (unbind-reset-rebind)
[112.963505] Starting subtest: unbind-reset-rebind
[114.771683] Subtest unbind-reset-rebind: SUCCESS (1.800s)
[114.804564] [029/133] (894s left) kms_content_protection (lic-type-1)
[114.895903] Starting subtest: lic-type-1
[114.909466] Subtest lic-type-1: SKIP (0.011s)
[115.026970] [030/133] (894s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[115.120794] Starting subtest: 4-tiled-8bpp-rotate-90
[115.122180] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.000s)
[115.215015] [031/133] (894s left) kms_rotation_crc (primary-rotation-270)
[115.299708] Starting subtest: primary-rotation-270
[120.127119] Subtest primary-rotation-270: SUCCESS (4.827s)
[120.321495] [032/133] (889s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[121.720789] Starting subtest: modeset-non-lpsp-stress-no-wait
[121.817371] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.096s)
[121.919550] [033/133] (887s left) kms_async_flips (async-flip-hang)
[122.007888] Starting subtest: async-flip-hang
[122.137119] Starting dynamic subtest: pipe-A-HDMI-A-1
[136.833289] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (14.663s)
[136.946638] Starting dynamic subtest: pipe-B-HDMI-A-1
[151.681455] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (14.710s)
[151.772802] Starting dynamic subtest: pipe-C-HDMI-A-1
[166.529641] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (14.730s)
[166.619830] Starting dynamic subtest: pipe-D-HDMI-A-1
[181.888477] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (15.241s)
[181.896254] Subtest async-flip-hang: SUCCESS (59.848s)
[182.082531] [034/133] (827s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[182.177789] Starting subtest: cursorB-vs-flipB-legacy
[182.179207] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[182.238629] [035/133] (827s left) kms_lease (master-vs-lease)
[182.322767] Starting subtest: master-vs-lease
[182.324571] Subtest master-vs-lease: SUCCESS (0.001s)
[182.381887] [036/133] (827s left) kms_plane_multiple (tiling-y)
[182.470932] Starting subtest: tiling-y
[182.472345] Starting dynamic subtest: pipe-A-HDMI-A-1
[183.122192] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.650s)
[183.132855] Starting dynamic subtest: pipe-B-HDMI-A-1
[183.756429] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.632s)
[183.766115] Starting dynamic subtest: pipe-C-HDMI-A-1
[184.424102] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.663s)
[184.433730] Starting dynamic subtest: pipe-D-HDMI-A-1
[185.084725] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.661s)
[185.086592] Subtest tiling-y: SUCCESS (2.615s)
[185.258826] [037/133] (824s left) i915_hangman (engine-engine-hang)
[185.307829] Starting subtest: engine-engine-hang
[185.308583] Starting dynamic subtest: rcs0
[185.883770] Dynamic subtest rcs0: SUCCESS (0.575s)
[185.893922] Starting dynamic subtest: bcs0
[186.470174] Dynamic subtest bcs0: SUCCESS (0.584s)
[186.480285] Starting dynamic subtest: vcs0
[187.047670] Dynamic subtest vcs0: SUCCESS (0.576s)
[187.057985] Starting dynamic subtest: vcs1
[187.631725] Dynamic subtest vcs1: SUCCESS (0.582s)
[187.644785] Starting dynamic subtest: vecs0
[188.203912] Dynamic subtest vecs0: SUCCESS (0.570s)
[188.205397] Subtest engine-engine-hang: SUCCESS (2.898s)
[188.311083] [038/133] (821s left) gem_media_fill (media-fill)
[188.350462] Starting subtest: media-fill
[188.351176] Starting dynamic subtest: smem
[188.355455] Dynamic subtest smem: SUCCESS (0.005s)
[188.356156] Subtest media-fill: SUCCESS (0.006s)
[188.581801] [039/133] (821s left) kms_flip (2x-busy-flip)
[188.668592] Starting subtest: 2x-busy-flip
[188.677502] Subtest 2x-busy-flip: SKIP (0.009s)
[188.742932] [040/133] (820s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[188.836499] Starting subtest: yf-tiled-16bpp-rotate-90
[188.837910] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[188.927104] [041/133] (820s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[189.069353] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[189.162791] [042/133] (820s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[189.620149] Starting subtest: syncobj-timeline-invalid-wait
[189.621156] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.003s)
[189.799928] [043/133] (820s left) gem_workarounds (basic-read)
[189.846851] Starting subtest: basic-read
[189.854794] Subtest basic-read: SUCCESS (0.007s)
[189.953988] [044/133] (819s left) syncobj_eventfd (invalid-illegal-eventfd)
[189.988010] Starting subtest: invalid-illegal-eventfd
[189.988745] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[190.045255] [045/133] (819s left) kms_plane_alpha_blend (alpha-7efc)
[190.131856] Starting subtest: alpha-7efc
[190.200704] Starting dynamic subtest: pipe-A-HDMI-A-1
[190.508613] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.308s)
[190.549353] Starting dynamic subtest: pipe-D-HDMI-A-1
[190.985031] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.443s)
[190.985831] Subtest alpha-7efc: SUCCESS (0.853s)
[191.152816] [046/133] (818s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[191.250856] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[191.252289] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[191.330104] [047/133] (818s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[191.416095] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[191.416799] Starting dynamic subtest: pipe-A-HDMI-A-1
[192.069416] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.649s)
[192.082649] Starting dynamic subtest: pipe-B-HDMI-A-1
[192.564316] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.491s)
[192.578179] Starting dynamic subtest: pipe-C-HDMI-A-1
[193.064851] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.496s)
[193.078219] Starting dynamic subtest: pipe-D-HDMI-A-1
[193.557357] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.488s)
[193.558283] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SUCCESS (2.140s)
[193.739263] [048/133] (816s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[193.838645] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[193.841455] Starting dynamic subtest: A-HDMI-A1
[194.514954] Dynamic subtest A-HDMI-A1: SUCCESS (0.673s)
[194.523198] Starting dynamic subtest: B-HDMI-A1
[195.174528] Dynamic subtest B-HDMI-A1: SUCCESS (0.657s)
[195.182302] Starting dynamic subtest: C-HDMI-A1
[195.778853] Dynamic subtest C-HDMI-A1: SUCCESS (0.604s)
[195.786984] Starting dynamic subtest: D-HDMI-A1
[196.391314] Dynamic subtest D-HDMI-A1: SUCCESS (0.610s)
[196.393982] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (2.555s)
[196.554057] [049/133] (813s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[196.654495] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[196.656040] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[196.724757] [050/133] (813s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[196.810034] Starting subtest: fb-8bpc-vs-panel-8bpc
[196.810729] Starting dynamic subtest: pipe-A-HDMI-A-1
[197.008852] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.198s)
[197.009581] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (0.200s)
[197.144032] [051/133] (813s left) gem_pxp (fail-invalid-protected-context)
[197.237829] Starting subtest: fail-invalid-protected-context
[197.238957] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[197.311896] [052/133] (812s left) kms_force_connector_basic (prune-stale-modes)
[197.435954] Starting subtest: prune-stale-modes
[197.586309] Subtest prune-stale-modes: SUCCESS (0.149s)
[197.746185] [053/133] (812s left) gem_render_copy_redux (interruptible)
[197.784518] Starting subtest: interruptible
[198.131213] Subtest interruptible: SUCCESS (0.338s)
[198.229219] [054/133] (812s left) perf_pmu (faulting-read)
[198.265265] Starting subtest: faulting-read
[198.266032] Starting dynamic subtest: gtt
[198.267847] Dynamic subtest gtt: SUCCESS (0.001s)
[198.275149] Starting dynamic subtest: wb
[198.275871] Dynamic subtest wb: SUCCESS (0.001s)
[198.282988] Starting dynamic subtest: wc
[198.283712] Dynamic subtest wc: SUCCESS (0.000s)
[198.290501] Starting dynamic subtest: uc
[198.291191] Dynamic subtest uc: SUCCESS (0.000s)
[198.291860] Subtest faulting-read: SUCCESS (0.007s)
[198.368103] [055/133] (811s left) gem_ctx_isolation (clean)
[198.410103] Starting subtest: clean
[198.410882] Starting dynamic subtest: rcs0
[198.433997] Dynamic subtest rcs0: SUCCESS (0.023s)
[198.442972] Starting dynamic subtest: bcs0
[198.504535] Dynamic subtest bcs0: SUCCESS (0.069s)
[198.513233] Starting dynamic subtest: vcs0
[198.572416] Dynamic subtest vcs0: SUCCESS (0.066s)
[198.580229] Starting dynamic subtest: vcs1
[198.636422] Dynamic subtest vcs1: SUCCESS (0.063s)
[198.645382] Starting dynamic subtest: vecs0
[198.704185] Dynamic subtest vecs0: SUCCESS (0.067s)
[198.704958] Subtest clean: SUCCESS (0.295s)
[198.896724] [056/133] (811s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[198.983906] Starting subtest: flip-vs-cursor-busy-crc-atomic
[199.349460] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.366s)
[199.516532] [057/133] (810s left) gem_mmap_gtt (isolation)
[199.554590] Starting subtest: isolation
[199.557804] Subtest isolation: SUCCESS (0.001s)
[199.652894] [058/133] (810s left) prime_busy (hang)
[199.690129] Starting subtest: hang
[199.692031] Starting dynamic subtest: rcs0
[213.634025] Dynamic subtest rcs0: SUCCESS (13.907s)
[213.641125] Starting dynamic subtest: bcs0
[220.608628] Dynamic subtest bcs0: SUCCESS (6.975s)
[220.615926] Starting dynamic subtest: vcs0
[227.583314] Dynamic subtest vcs0: SUCCESS (6.975s)
[227.590529] Starting dynamic subtest: vcs1
[234.625712] Dynamic subtest vcs1: SUCCESS (7.039s)
[234.632834] Starting dynamic subtest: vecs0
[241.575212] Dynamic subtest vecs0: SUCCESS (6.975s)
[241.575915] Subtest hang: SUCCESS (41.876s)
[241.662472] [059/133] (768s left) kms_cursor_crc (cursor-sliding-512x512)
[241.756986] Starting subtest: cursor-sliding-512x512
[241.758438] Subtest cursor-sliding-512x512: SKIP (0.001s)
[241.859631] [060/133] (768s left) gem_exec_balancer (sequential)
[241.901350] Starting subtest: sequential
[245.363967] Subtest sequential: SUCCESS (3.463s)
[245.544238] [061/133] (765s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[245.638058] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[245.639498] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[245.725717] [062/133] (764s left) gem_softpin (full)
[245.763769] Starting subtest: full
[245.770967] Subtest full: SUCCESS (0.007s)
[245.870092] [063/133] (764s left) kms_psr (pr-sprite-plane-move)
[245.956972] Subtest pr-sprite-plane-move: SKIP (0.000s)
[246.003856] [064/133] (764s left) gem_ctx_shared (q-in-order)
[246.046504] Starting subtest: Q-in-order
[246.047271] Starting dynamic subtest: rcs0
[246.097691] Dynamic subtest rcs0: SUCCESS (0.050s)
[246.109389] Starting dynamic subtest: bcs0
[246.150472] Dynamic subtest bcs0: SUCCESS (0.051s)
[246.163886] Starting dynamic subtest: vcs0
[246.203319] Dynamic subtest vcs0: SUCCESS (0.050s)
[246.216810] Starting dynamic subtest: vcs1
[246.256087] Dynamic subtest vcs1: SUCCESS (0.050s)
[246.269369] Starting dynamic subtest: vecs0
[246.308305] Dynamic subtest vecs0: SUCCESS (0.050s)
[246.309438] Subtest Q-in-order: SUCCESS (0.263s)
[246.494208] [065/133] (764s left) kms_chamelium_audio (hdmi-audio)
[246.633080] Subtest hdmi-audio: SKIP (0.000s)
[246.725604] [066/133] (764s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[246.761876] Starting subtest: single-wait-all-for-submit-available-submitted
[246.762616] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[246.826322] [067/133] (763s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[246.916704] Starting subtest: cursor-rapid-movement-512x170
[246.918132] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[247.011108] [068/133] (763s left) kms_big_fb (linear-64bpp-rotate-270)
[247.104806] Starting subtest: linear-64bpp-rotate-270
[247.146600] Subtest linear-64bpp-rotate-270: SKIP (0.040s)
[247.262727] [069/133] (763s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[247.348090] Starting subtest: flip-vs-cursor-atomic
[253.756774] Subtest flip-vs-cursor-atomic: SUCCESS (6.409s)
[253.928674] [070/133] (757s left) gem_exec_schedule (semaphore-power)
[254.096427] Starting subtest: semaphore-power
[255.163957] Subtest semaphore-power: SUCCESS (1.057s)
[255.327810] [071/133] (755s left) gem_ctx_persistence (legacy-engines-hang)
[255.364369] Starting subtest: legacy-engines-hang
[255.365141] Starting dynamic subtest: render
[255.409686] Dynamic subtest render: SUCCESS (0.044s)
[255.429980] Starting dynamic subtest: bsd1
[255.452405] Dynamic subtest bsd1: SUCCESS (0.040s)
[255.469849] Starting dynamic subtest: bsd2
[255.501370] Dynamic subtest bsd2: SUCCESS (0.046s)
[255.519802] Starting dynamic subtest: blt
[255.550501] Dynamic subtest blt: SUCCESS (0.046s)
[255.568769] Starting dynamic subtest: vebox
[255.596490] Dynamic subtest vebox: SUCCESS (0.043s)
[255.597672] Subtest legacy-engines-hang: SUCCESS (0.233s)
[255.670635] [072/133] (755s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[255.763935] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[255.764699] Starting dynamic subtest: pipe-A
[255.902989] Dynamic subtest pipe-A: SUCCESS (0.140s)
[255.919088] Starting dynamic subtest: pipe-B
[256.057139] Dynamic subtest pipe-B: SUCCESS (0.153s)
[256.073544] Starting dynamic subtest: pipe-C
[256.201899] Dynamic subtest pipe-C: SUCCESS (0.143s)
[256.218078] Starting dynamic subtest: pipe-D
[256.362168] Dynamic subtest pipe-D: SUCCESS (0.159s)
[256.362961] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (0.600s)
[256.550243] [073/133] (754s left) syncobj_timeline (multi-wait-for-submit-signaled)
[256.587732] Starting subtest: multi-wait-for-submit-signaled
[256.588481] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[256.657174] [074/133] (754s left) kms_atomic_interruptible (legacy-dpms)
[256.744293] Starting subtest: legacy-dpms
[256.746467] Starting dynamic subtest: pipe-A-HDMI-A-1
[263.011588] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.264s)
[263.012366] Subtest legacy-dpms: SUCCESS (6.267s)
[263.147667] [075/133] (747s left) syncobj_basic (bad-pad-handle-to-fd)
[263.184848] Starting subtest: bad-pad-handle-to-fd
[263.185563] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[263.253466] [076/133] (747s left) drm_read (short-buffer-nonblock)
[263.359467] Starting subtest: short-buffer-nonblock
[263.360201] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[263.481868] [077/133] (747s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[263.568146] Starting subtest: cursorB-vs-flipB-varying-size
[263.569499] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[263.628225] [078/133] (747s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[263.718084] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[263.719591] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[263.786111] [079/133] (747s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[263.881370] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[264.534178] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (0.653s)
[264.659964] [080/133] (746s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[264.752187] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[266.084604] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (1.332s)
[266.227697] [081/133] (745s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[266.317461] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[266.358298] [082/133] (745s left) kms_atomic (crtc-invalid-params)
[266.445899] Starting subtest: crtc-invalid-params
[266.448119] Starting dynamic subtest: pipe-A-HDMI-A-1
[266.566262] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.118s)
[266.567365] Subtest crtc-invalid-params: SUCCESS (0.120s)
[266.699763] [083/133] (744s left) kms_flip (busy-flip)
[266.788125] Starting subtest: busy-flip
[266.790314] Starting dynamic subtest: A-HDMI-A1
[267.461952] Dynamic subtest A-HDMI-A1: SUCCESS (0.672s)
[267.473019] Starting dynamic subtest: B-HDMI-A1
[268.123601] Dynamic subtest B-HDMI-A1: SUCCESS (0.656s)
[268.132094] Starting dynamic subtest: C-HDMI-A1
[268.782320] Dynamic subtest C-HDMI-A1: SUCCESS (0.654s)
[268.789821] Starting dynamic subtest: D-HDMI-A1
[269.436743] Dynamic subtest D-HDMI-A1: SUCCESS (0.654s)
[269.439329] Subtest busy-flip: SUCCESS (2.651s)
[269.614374] [084/133] (741s left) gem_exec_params (cliprects-invalid)
[269.653466] Starting subtest: cliprects-invalid
[269.654197] Subtest cliprects-invalid: SUCCESS (0.000s)
[269.760516] [085/133] (741s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[269.852701] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[270.961893] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (1.111s)
[271.079566] [086/133] (740s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[271.114396] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[271.115126] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[271.172908] [087/133] (740s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[271.265791] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[271.267150] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[271.353843] [088/133] (740s left) syncobj_timeline (wait-zero-handles)
[271.388104] Starting subtest: wait-zero-handles
[271.388821] Subtest wait-zero-handles: SUCCESS (0.000s)
[271.446412] [089/133] (740s left) kms_psr (fbc-pr-sprite-plane-onoff)
[271.533783] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[271.576111] [090/133] (740s left) gen9_exec_parse (batch-without-end)
[271.614067] Subtest batch-without-end: SKIP (0.000s)
[271.658264] [091/133] (740s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[271.748835] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[271.750290] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[271.847871] [092/133] (739s left) syncobj_wait (wait-for-submit-snapshot)
[271.883114] Starting subtest: wait-for-submit-snapshot
[271.965096] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[272.038959] [093/133] (739s left) gem_exec_suspend (basic-s0)
[272.080576] Starting subtest: basic-S0
[272.081373] Starting dynamic subtest: smem
[289.456032] Dynamic subtest smem: SUCCESS (2.809s)
[289.456802] Subtest basic-S0: SUCCESS (2.810s)
[296.656022] [094/133] (722s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[296.748431] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[296.749803] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[296.842497] [095/133] (722s left) perf (invalid-open-flags)
[296.923067] Starting subtest: invalid-open-flags
[296.923785] Subtest invalid-open-flags: SUCCESS (0.000s)
[296.962775] [096/133] (722s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[297.052438] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[297.053811] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[297.130204] [097/133] (721s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[297.219703] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[297.221122] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[297.317854] [098/133] (721s left) kms_addfb_basic (unused-modifier)
[297.351688] Starting subtest: unused-modifier
[297.352411] Subtest unused-modifier: SUCCESS (0.000s)
[297.491241] [099/133] (721s left) perf (enable-disable)
[297.569924] Starting subtest: enable-disable
[297.570726] Starting dynamic subtest: 0-rcs0
[299.832684] Dynamic subtest 0-rcs0: SUCCESS (2.253s)
[299.833425] Subtest enable-disable: SUCCESS (2.254s)
[299.870303] [100/133] (719s left) gem_exec_whisper (basic-queues-forked-all)
[299.939029] Starting subtest: basic-queues-forked-all
[302.693082] Subtest basic-queues-forked-all: SUCCESS (2.752s)
[302.894712] [101/133] (716s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[302.935894] Starting subtest: y-tiled-to-vebox-yf-tiled
[302.936662] Starting dynamic subtest: smem
[303.003604] Dynamic subtest smem: SUCCESS (0.068s)
[303.004396] Subtest y-tiled-to-vebox-yf-tiled: SUCCESS (0.070s)
[303.193196] [102/133] (716s left) kms_addfb_basic (bad-pitch-0)
[303.225479] Starting subtest: bad-pitch-0
[303.226217] Subtest bad-pitch-0: SUCCESS (0.000s)
[303.369268] [103/133] (715s left) gem_ctx_engines (execute-one)
[303.411766] Starting subtest: execute-one
[304.659486] Subtest execute-one: SUCCESS (1.239s)
[304.844305] [104/133] (714s left) gem_wait (invalid-buf)
[304.881113] Starting subtest: invalid-buf
[304.881837] Subtest invalid-buf: SUCCESS (0.000s)
[305.091490] [105/133] (714s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[305.180984] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (0.000s)
[305.271999] [106/133] (714s left) kms_pm_dc (dc3co-vpb-simulation)
[306.362914] Starting subtest: dc3co-vpb-simulation
[306.364339] Subtest dc3co-vpb-simulation: SKIP (0.000s)
[306.419544] [107/133] (713s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[306.509803] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[307.717585] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (1.208s)
[307.837878] [108/133] (711s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[307.928491] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[307.929962] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[308.032892] [109/133] (711s left) kms_plane_scaling (invalid-parameters)
[308.126472] Starting subtest: invalid-parameters
[308.127179] Starting dynamic subtest: less-than-1-height-src
[308.142806] Dynamic subtest less-than-1-height-src: SUCCESS (0.015s)
[308.151219] Starting dynamic subtest: less-than-1-width-src
[308.158133] Dynamic subtest less-than-1-width-src: SUCCESS (0.015s)
[308.158850] Subtest invalid-parameters: SUCCESS (0.032s)
[308.242239] [110/133] (711s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[308.337009] Starting subtest: yf-tiled-8bpp-rotate-0
[308.338536] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[308.423869] [111/133] (711s left) kms_psr (psr-cursor-plane-move)
[308.508294] Subtest psr-cursor-plane-move: SKIP (0.000s)
[308.550237] [112/133] (711s left) i915_suspend (basic-s3-without-i915)
[308.583190] Starting subtest: basic-s3-without-i915