[60.646229] Initializing watchdogs
[60.646301]   /dev/watchdog0
[60.666896] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[60.670818] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.672858] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.675974] [001/132] (960s left) kms_plane_lowres (tiling-y)
[60.772115] Starting subtest: tiling-y
[60.776412] Subtest tiling-y: SKIP (0.000s)
[60.848838] [002/132] (960s left) gem_huc_copy (huc-copy)
[60.917284] Starting subtest: huc-copy
[60.922066] Subtest huc-copy: SUCCESS (0.003s)
[61.040156] [003/132] (960s left) kms_getfb (getfb2-accept-nv12)
[61.111882] Starting subtest: getfb2-accept-nv12
[61.114330] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[61.214190] [004/132] (960s left) i915_pm_rpm (gem-evict-pwrite)
[63.344064] Starting subtest: gem-evict-pwrite
[63.349111] Subtest gem-evict-pwrite: SKIP (0.000s)
[63.716460] [005/132] (957s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[63.797611] Starting subtest: yf-tiled-64bpp-rotate-90
[63.802020] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[63.903063] [006/132] (957s left) perf_pmu (busy-check-all)
[63.955214] Starting subtest: busy-check-all
[63.957481] Starting dynamic subtest: rcs0
[64.507734] Dynamic subtest rcs0: SUCCESS (0.552s)
[64.518981] Starting dynamic subtest: bcs0
[65.056732] Dynamic subtest bcs0: SUCCESS (0.548s)
[65.067492] Starting dynamic subtest: vcs0
[66.239048] Dynamic subtest vcs0: SUCCESS (1.178s)
[66.250830] Starting dynamic subtest: vcs1
[68.223949] Dynamic subtest vcs1: SUCCESS (1.981s)
[68.234358] Starting dynamic subtest: vecs0
[70.207073] Dynamic subtest vecs0: SUCCESS (1.982s)
[70.218045] Starting dynamic subtest: ccs0
[70.759140] Dynamic subtest ccs0: SUCCESS (0.552s)
[70.761613] Subtest busy-check-all: SUCCESS (6.799s)
[70.868560] [007/132] (950s left) gem_fence_thrash (bo-copy)
[70.898943] Starting subtest: bo-copy
[70.926637] Subtest bo-copy: SKIP (0.025s)
[70.985496] [008/132] (950s left) syncobj_wait (invalid-reset-illegal-handle)
[71.037926] Starting subtest: invalid-reset-illegal-handle
[71.040271] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[71.119167] [009/132] (950s left) device_reset (unbind-cold-reset-rebind)
[71.165687] Starting subtest: unbind-cold-reset-rebind
[71.169961] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[71.230536] [010/132] (950s left) syncobj_timeline (etime-multi-wait-submitted)
[71.285605] Starting subtest: etime-multi-wait-submitted
[71.397453] Subtest etime-multi-wait-submitted: SUCCESS (0.109s)
[71.474822] [011/132] (950s left) kms_pipe_stress (stress-xrgb8888-untiled)
[71.565016] Starting subtest: stress-xrgb8888-untiled
[77.342491] Subtest stress-xrgb8888-untiled: SUCCESS (5.775s)
[77.386601] [012/132] (944s left) syncobj_timeline (multi-wait-for-submit-signaled)
[77.436986] Starting subtest: multi-wait-for-submit-signaled
[77.439036] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[77.553163] [013/132] (944s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[77.624046] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[77.626061] Starting dynamic subtest: pipe-A-eDP-1
[77.647768] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[77.657407] Starting dynamic subtest: pipe-B-eDP-1
[77.677040] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[77.684237] Starting dynamic subtest: pipe-C-eDP-1
[77.703853] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[77.710859] Starting dynamic subtest: pipe-D-eDP-1
[77.730838] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[77.734242] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[79.881568] [014/132] (941s left) kms_joiner (invalid-modeset-force-big-joiner)
[79.964132] Starting subtest: invalid-modeset-force-big-joiner
[79.968289] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[80.026244] [015/132] (941s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[80.082181] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[80.144645] [016/132] (941s left) gem_exec_schedule (preempt-other-chain)
[80.220633] Starting subtest: preempt-other-chain
[80.222662] Starting dynamic subtest: rcs0
[80.298505] Dynamic subtest rcs0: SUCCESS (0.084s)
[80.311571] Starting dynamic subtest: bcs0
[80.375659] Dynamic subtest bcs0: SUCCESS (0.077s)
[80.385053] Starting dynamic subtest: vcs0
[80.452429] Dynamic subtest vcs0: SUCCESS (0.076s)
[80.461821] Starting dynamic subtest: vcs1
[80.528961] Dynamic subtest vcs1: SUCCESS (0.077s)
[80.537954] Starting dynamic subtest: vecs0
[80.613968] Dynamic subtest vecs0: SUCCESS (0.085s)
[80.622732] Starting dynamic subtest: ccs0
[80.690427] Dynamic subtest ccs0: SUCCESS (0.076s)
[80.692894] Subtest preempt-other-chain: SUCCESS (0.477s)
[82.316167] [017/132] (939s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[82.382583] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[82.384740] Starting dynamic subtest: pipe-A-eDP-1
[82.407444] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[82.417082] Starting dynamic subtest: pipe-B-eDP-1
[82.439268] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[82.447675] Starting dynamic subtest: pipe-C-eDP-1
[82.468809] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[82.479180] Starting dynamic subtest: pipe-D-eDP-1
[82.501968] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[82.506290] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[84.547366] [018/132] (937s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[84.627988] Starting subtest: yf-tiled-32bpp-rotate-270
[84.632333] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[84.720835] [019/132] (937s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[84.799203] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[85.186837] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[87.929133] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.741s)
[87.940955] Starting dynamic subtest: pipe-A-eDP-1-4
[90.104083] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s)
[90.113887] Starting dynamic subtest: pipe-A-eDP-1-4
[92.113786] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[92.121884] Starting dynamic subtest: pipe-A-eDP-1-x
[94.294151] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.179s)
[94.664434] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[97.460214] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.803s)
[97.471397] Starting dynamic subtest: pipe-B-eDP-1-4
[99.635363] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.174s)
[99.646564] Starting dynamic subtest: pipe-B-eDP-1-4
[101.645296] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.010s)
[101.656307] Starting dynamic subtest: pipe-B-eDP-1-x
[103.835867] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.190s)
[104.209920] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[106.980049] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.776s)
[106.989340] Starting dynamic subtest: pipe-C-eDP-1-4
[109.143846] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.163s)
[109.155217] Starting dynamic subtest: pipe-C-eDP-1-4
[111.154214] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[111.165918] Starting dynamic subtest: pipe-C-eDP-1-x
[113.321780] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.167s)
[113.692250] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[116.426232] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.740s)
[116.438435] Starting dynamic subtest: pipe-D-eDP-1-4
[118.612175] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.185s)
[118.626039] Starting dynamic subtest: pipe-D-eDP-1-4
[120.622074] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s)
[120.630673] Starting dynamic subtest: pipe-D-eDP-1-x
[122.789811] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.167s)
[122.792531] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (37.987s)
[124.012756] [020/132] (897s left) prime_vgem (shrink)
[124.141044] Starting subtest: shrink
[124.153352] Subtest shrink: SUCCESS (0.012s)
[124.240858] [FACT prime_vgem (shrink)] new: kernel.kmod_is_loaded.vgem: true
[124.243887] [021/132] (897s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[124.305608] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[124.411036] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.103s)
[124.496565] [022/132] (897s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[124.567888] Starting subtest: fb-8bpc-vs-panel-6bpc
[124.570287] Starting dynamic subtest: pipe-A-eDP-1
[126.013367] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.445s)
[126.015196] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.446s)
[126.868937] [023/132] (895s left) gem_pxp (reject-modify-context-protection-off-1)
[126.994162] Starting subtest: reject-modify-context-protection-off-1
[126.996640] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[127.104274] [024/132] (894s left) perf_pmu (invalid-init)
[127.139487] Starting subtest: invalid-init
[127.141757] Subtest invalid-init: SUCCESS (0.000s)
[127.266615] [025/132] (894s left) gem_mmap_offset (close-race)
[127.320131] Starting subtest: close-race
[147.495804] Subtest close-race: SUCCESS (20.121s)
[147.573400] [026/132] (874s left) gem_ctx_bad_destroy (invalid-pad)
[147.631214] Starting subtest: invalid-pad
[147.633693] Subtest invalid-pad: SUCCESS (0.000s)
[147.706660] [027/132] (874s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[147.794801] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[147.798873] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[147.887476] [028/132] (874s left) kms_frontbuffer_tracking (psr-1p-rte)
[147.969045] Starting subtest: psr-1p-rte
[153.346400] Subtest psr-1p-rte: SUCCESS (5.382s)
[153.482592] [029/132] (868s left) gem_exec_whisper (basic-forked)
[153.544592] Starting subtest: basic-forked
[160.901021] Subtest basic-forked: SUCCESS (7.353s)
[161.092478] [030/132] (861s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[161.175077] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[167.978873] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.807s)
[168.114824] [031/132] (854s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[168.195270] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[168.199335] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[168.286398] [032/132] (854s left) kms_psr (psr2-sprite-mmap-gtt)
[168.359717] Starting subtest: psr2-sprite-mmap-gtt
[168.362064] Starting dynamic subtest: eDP-1
[169.829144] Dynamic subtest eDP-1: SKIP (1.464s)
[169.833566] Subtest psr2-sprite-mmap-gtt: SKIP (1.466s)
[169.991801] [033/132] (852s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[170.067419] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[170.071479] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[170.150402] [034/132] (852s left) kms_psr (fbc-pr-cursor-plane-onoff)
[170.232826] Starting subtest: fbc-pr-cursor-plane-onoff
[170.237362] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[170.309477] [035/132] (852s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[170.368275] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[170.475325] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.107s)
[170.562653] [036/132] (851s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[170.636196] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[170.640591] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[170.726961] [037/132] (851s left) vgem_basic (mmap)
[170.772070] Starting subtest: mmap
[170.789399] Subtest mmap: SUCCESS (0.022s)
[170.848117] [038/132] (851s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[170.926906] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[177.187781] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.265s)
[178.350786] [039/132] (844s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[178.459062] Starting subtest: basic-flip-after-cursor-atomic
[179.372628] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.913s)
[180.168077] [040/132] (842s left) i915_pm_sseu (full-enable)
[180.228226] Subtest full-enable: SKIP (0.000s)
[180.326614] [041/132] (842s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[180.685249] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[181.473284] [042/132] (841s left) gem_userptr_blits (unsync-unmap-cycles)
[181.548411] Subtest unsync-unmap-cycles: SKIP (0.000s)
[181.662074] [043/132] (841s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[181.740996] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[181.746475] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[182.843697] [044/132] (840s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[182.925546] Starting subtest: x-tiled-64bpp-rotate-0
[184.459315] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.534s)
[184.623418] [045/132] (838s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[184.717114] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[184.721424] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[184.808704] [046/132] (838s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[184.872691] Starting subtest: invalid-signal-one-illegal-handle
[184.874309] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[184.962151] [047/132] (838s left) syncobj_timeline (single-wait-for-submit-signaled)
[185.010571] Starting subtest: single-wait-for-submit-signaled
[185.012531] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[185.097814] [048/132] (837s left) gem_pxp (create-protected-buffer)
[185.148290] Starting subtest: create-protected-buffer
[185.150203] Subtest create-protected-buffer: SUCCESS (0.000s)
[185.253050] [049/132] (837s left) kms_psr (fbc-pr-sprite-render)
[185.327092] Starting subtest: fbc-pr-sprite-render
[185.330756] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[185.397447] [050/132] (837s left) i915_query (query-topology-coherent-slice-mask)
[185.450356] Starting subtest: query-topology-coherent-slice-mask
[185.453964] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[185.546215] [051/132] (837s left) kms_force_connector_basic (prune-stale-modes)
[185.600040] Subtest prune-stale-modes: SKIP (0.000s)
[185.656699] [052/132] (837s left) gem_exec_fence (invalid-timeline-fence-array)
[186.209110] Starting subtest: invalid-timeline-fence-array
[186.215041] Subtest invalid-timeline-fence-array: SUCCESS (0.005s)
[187.342903] [053/132] (835s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[187.433615] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[187.437861] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[187.529556] [054/132] (835s left) api_intel_allocator (simple-allocator)
[187.591504] Starting subtest: simple-allocator
[187.593903] Starting dynamic subtest: basic
[187.596556] Dynamic subtest basic: SUCCESS (0.003s)
[187.610749] Starting dynamic subtest: parallel-one
[187.798259] Dynamic subtest parallel-one: SUCCESS (0.204s)
[187.807365] Starting dynamic subtest: print
[187.809713] Dynamic subtest print: SUCCESS (0.000s)
[187.818563] Starting dynamic subtest: reuse
[187.820553] Dynamic subtest reuse: SUCCESS (0.000s)
[187.828880] Starting dynamic subtest: reserve
[187.830851] Dynamic subtest reserve: SUCCESS (0.000s)
[187.839252] Starting dynamic subtest: fork-reopen-allocator
[187.841166] Dynamic subtest fork-reopen-allocator: SUCCESS (0.014s)
[187.843058] Subtest simple-allocator: SUCCESS (0.226s)
[187.947887] [055/132] (835s left) kms_pm_dc (dc5-psr)
[189.033317] Starting subtest: dc5-psr
[191.918295] Subtest dc5-psr: SUCCESS (2.884s)
[192.764606] [056/132] (830s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[192.843436] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[192.847732] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[192.912445] [057/132] (830s left) gem_flink_basic (flink-lifetime)
[192.971046] Starting subtest: flink-lifetime
[192.973317] Subtest flink-lifetime: SUCCESS (0.002s)
[193.085811] [058/132] (830s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[193.172718] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[224.776427] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.603s)
[225.592589] [059/132] (797s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[225.685107] Starting subtest: plane-primary-toggle-with-vblank-wait
[225.687294] Starting dynamic subtest: pipe-A-eDP-1
[225.857154] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.173s)
[226.174553] Starting dynamic subtest: pipe-B-eDP-1
[227.104872] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.938s)
[227.425696] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.742s)
[228.285952] [060/132] (795s left) kms_flip_event_leak (basic)
[228.355448] Starting subtest: basic
[228.357647] Starting dynamic subtest: pipe-A-eDP-1
[228.780514] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.426s)
[228.789880] Starting dynamic subtest: pipe-B-eDP-1
[229.884507] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.102s)
[229.893779] Starting dynamic subtest: pipe-C-eDP-1
[231.013615] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.127s)
[231.023032] Starting dynamic subtest: pipe-D-eDP-1
[232.151675] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.137s)
[232.154056] Subtest basic: SUCCESS (3.798s)
[233.019820] [061/132] (790s left) kms_scaling_modes (scaling-mode-none)
[233.095940] Starting subtest: scaling-mode-none
[233.098176] Starting dynamic subtest: pipe-A-eDP-1
[233.192025] Dynamic subtest pipe-A-eDP-1: SKIP (0.094s)
[233.202398] Starting dynamic subtest: pipe-B-eDP-1
[233.226987] Dynamic subtest pipe-B-eDP-1: SKIP (0.033s)
[233.236281] Starting dynamic subtest: pipe-C-eDP-1
[233.260102] Dynamic subtest pipe-C-eDP-1: SKIP (0.032s)
[233.269258] Starting dynamic subtest: pipe-D-eDP-1
[233.294170] Dynamic subtest pipe-D-eDP-1: SKIP (0.033s)
[233.298581] Subtest scaling-mode-none: SKIP (0.198s)
[233.396333] [062/132] (790s left) vgem_basic (dmabuf-fence)
[233.438714] Starting subtest: dmabuf-fence
[233.440717] Subtest dmabuf-fence: SUCCESS (0.001s)
[233.493248] [063/132] (790s left) i915_drm_fdinfo (busy-idle-check-all)
[233.533319] Starting subtest: busy-idle-check-all
[233.535696] Starting dynamic subtest: rcs0
[233.540873] Dynamic subtest rcs0: SKIP (0.003s)
[233.551632] Starting dynamic subtest: bcs0
[233.556084] Dynamic subtest bcs0: SKIP (0.000s)
[233.564495] Starting dynamic subtest: vcs0
[233.568321] Dynamic subtest vcs0: SKIP (0.000s)
[233.576332] Starting dynamic subtest: vcs1
[233.580428] Dynamic subtest vcs1: SKIP (0.000s)
[233.588591] Starting dynamic subtest: vecs0
[233.592760] Dynamic subtest vecs0: SKIP (0.000s)
[233.600879] Starting dynamic subtest: ccs0
[233.605038] Dynamic subtest ccs0: SKIP (0.000s)
[233.609229] Subtest busy-idle-check-all: SKIP (0.008s)
[233.645386] [064/132] (790s left) kms_cursor_crc (cursor-random-128x128)
[233.860706] Starting subtest: cursor-random-128x128
[233.862818] Starting dynamic subtest: pipe-A-eDP-1
[237.219656] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.356s)
[237.248861] Starting dynamic subtest: pipe-D-eDP-1
[241.221411] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.980s)
[241.223635] Subtest cursor-random-128x128: SUCCESS (7.360s)
[242.070740] [065/132] (781s left) kms_chamelium_frames (hdmi-aspect-ratio)
[242.429764] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[243.287604] [066/132] (780s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[243.339183] Subtest tiled-to-tiled: SKIP (0.000s)
[243.408831] [067/132] (780s left) kms_color (ctm-blue-to-red)
[243.494578] Starting subtest: ctm-blue-to-red
[243.496690] Starting dynamic subtest: pipe-A-eDP-1
[244.171733] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.678s)
[244.180717] Starting dynamic subtest: pipe-B-eDP-1
[245.569633] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.398s)
[245.578649] Starting dynamic subtest: pipe-C-eDP-1
[246.849598] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.277s)
[246.859270] Starting dynamic subtest: pipe-D-eDP-1
[248.177130] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[248.179513] Subtest ctm-blue-to-red: SUCCESS (4.684s)
[249.036600] [068/132] (774s left) vgem_basic (bad-handle)
[249.080286] Starting subtest: bad-handle
[249.082233] Subtest bad-handle: SUCCESS (0.000s)
[249.135459] [069/132] (774s left) gem_exec_reloc (basic-write-wc)
[249.197407] Subtest basic-write-wc: SKIP (0.000s)
[249.276535] [070/132] (774s left) gem_mmap_gtt (cpuset-basic-small-copy)
[249.336478] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[249.396415] [071/132] (774s left) gen9_exec_parse (batch-zero-length)
[249.449121] Subtest batch-zero-length: SKIP (0.000s)
[249.518020] [072/132] (774s left) i915_hangman (gt-error-state-capture)
[249.585511] Starting subtest: gt-error-state-capture
[249.587432] Starting dynamic subtest: rcs0
[261.213286] Dynamic subtest rcs0: SUCCESS (11.626s)
[261.228283] Starting dynamic subtest: bcs0
[273.182278] Dynamic subtest bcs0: SUCCESS (11.965s)
[273.196167] Starting dynamic subtest: vcs0
[284.126035] Dynamic subtest vcs0: SUCCESS (10.941s)
[284.138388] Starting dynamic subtest: vcs1
[294.173032] Dynamic subtest vcs1: SUCCESS (10.044s)
[294.189483] Starting dynamic subtest: vecs0
[306.140612] Dynamic subtest vecs0: SUCCESS (11.964s)
[306.152991] Starting dynamic subtest: ccs0
[316.189951] Dynamic subtest ccs0: SUCCESS (10.045s)
[316.193461] Subtest gt-error-state-capture: SUCCESS (66.600s)
[316.272922] [073/132] (707s left) gem_exec_params (readonly)
[316.340442] Starting subtest: readonly
[316.345500] Subtest readonly: SUCCESS (0.003s)
[316.455537] [074/132] (707s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[316.563019] Starting subtest: cursorB-vs-flipB-varying-size
[316.567249] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[316.708927] [075/132] (707s left) gem_ctx_persistence (saturated-hostile)
[316.760741] Starting subtest: saturated-hostile
[316.763068] Starting dynamic subtest: rcs0
[317.569429] Dynamic subtest rcs0: SUCCESS (0.807s)
[317.581611] Starting dynamic subtest: bcs0
[318.350774] Dynamic subtest bcs0: SUCCESS (0.779s)
[318.369966] Starting dynamic subtest: vcs0
[319.128210] Dynamic subtest vcs0: SUCCESS (0.776s)
[319.141115] Starting dynamic subtest: vcs1
[319.919974] Dynamic subtest vcs1: SUCCESS (0.790s)
[319.932444] Starting dynamic subtest: vecs0
[320.718050] Dynamic subtest vecs0: SUCCESS (0.797s)
[320.730195] Starting dynamic subtest: ccs0
[321.547073] Dynamic subtest ccs0: SUCCESS (0.827s)
[321.549781] Subtest saturated-hostile: SUCCESS (4.787s)
[321.634950] [076/132] (702s left) gem_exec_balancer (invalid-bonds)
[321.716274] Starting subtest: invalid-bonds
[321.720633] Subtest invalid-bonds: SKIP (0.001s)
[322.025215] [077/132] (702s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[322.113061] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[322.117328] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[322.184192] [078/132] (702s left) syncobj_wait (reset-during-wait-for-submit)
[322.247535] Starting subtest: reset-during-wait-for-submit
[322.349946] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[322.424551] [079/132] (701s left) kms_properties (get_properties-sanity-non-atomic)
[322.499275] Starting subtest: get_properties-sanity-non-atomic
[322.501564] Subtest get_properties-sanity-non-atomic: SUCCESS (0.001s)
[322.570564] [080/132] (701s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[322.653197] Starting subtest: fbc-2p-pri-indfb-multidraw
[322.657209] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[322.766572] [081/132] (701s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[322.841082] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[322.844891] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[322.952461] [082/132] (701s left) gem_eio (create)
[323.131054] Starting subtest: create
[323.378665] Subtest create: SUCCESS (0.247s)
[323.523142] [083/132] (700s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[323.592463] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[323.595852] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[323.684534] [084/132] (700s left) kms_big_fb (linear-64bpp-rotate-0)
[323.765051] Starting subtest: linear-64bpp-rotate-0
[325.255072] Subtest linear-64bpp-rotate-0: SUCCESS (1.489s)
[325.457982] [085/132] (699s left) kms_content_protection (atomic-dpms)
[325.586996] Starting subtest: atomic-dpms
[325.591636] Subtest atomic-dpms: SKIP (0.000s)
[325.722531] [086/132] (698s left) kms_plane (planar-pixel-format-settings)
[325.802988] Starting subtest: planar-pixel-format-settings
[325.862691] Subtest planar-pixel-format-settings: SUCCESS (0.062s)
[325.980622] [087/132] (698s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[326.055233] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[326.057391] Starting dynamic subtest: pipe-A
[326.075166] Dynamic subtest pipe-A: SKIP (0.016s)
[326.086887] Starting dynamic subtest: pipe-B
[326.105142] Dynamic subtest pipe-B: SKIP (0.029s)
[326.116759] Starting dynamic subtest: pipe-C
[326.134385] Dynamic subtest pipe-C: SKIP (0.029s)
[326.143878] Starting dynamic subtest: pipe-D
[326.164043] Dynamic subtest pipe-D: SKIP (0.029s)
[326.167736] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.106s)
[326.300926] [088/132] (698s left) gem_exec_params (secure-non-master)
[326.356041] Starting subtest: secure-non-master
[326.360168] Subtest secure-non-master: SKIP (0.000s)
[326.449503] [089/132] (698s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[326.530502] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[326.557469] Starting dynamic subtest: pipe-A-plane-0
[327.002093] Dynamic subtest pipe-A-plane-0: SUCCESS (0.444s)
[327.011438] Starting dynamic subtest: pipe-A-plane-3
[327.257222] Dynamic subtest pipe-A-plane-3: SUCCESS (0.253s)
[327.266691] Starting dynamic subtest: pipe-A-plane-5
[327.270136] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[328.327467] Starting dynamic subtest: pipe-B-plane-0
[328.750730] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[328.760307] Starting dynamic subtest: pipe-B-plane-3
[329.006242] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[329.016710] Starting dynamic subtest: pipe-B-plane-5
[329.021111] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[329.334355] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.803s)
[330.222651] [090/132] (694s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[330.315403] Starting subtest: fbcpsr-stridechange
[336.488385] Subtest fbcpsr-stridechange: SUCCESS (6.177s)
[336.637441] [091/132] (688s left) kms_cursor_crc (cursor-onscreen-512x512)
[336.890850] Starting subtest: cursor-onscreen-512x512
[336.895726] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[337.044792] [092/132] (687s left) sw_sync (sync_multi_consumer_producer)
[337.086265] Starting subtest: sync_multi_consumer_producer
[337.395538] Subtest sync_multi_consumer_producer: SUCCESS (0.313s)
[337.471018] [093/132] (687s left) kms_hdmi_inject (inject-audio)
[337.521623] Subtest inject-audio: SKIP (0.000s)
[337.584649] [094/132] (687s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[337.660541] Starting subtest: fbc-rgb101010-draw-blt
[342.248557] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.584s)
[343.428731] [095/132] (681s left) gem_ctx_isolation (dirty-create)
[343.488374] Starting subtest: dirty-create
[343.490623] Starting dynamic subtest: rcs0
[343.676780] Dynamic subtest rcs0: SUCCESS (0.188s)
[343.687619] Starting dynamic subtest: bcs0
[343.882849] Dynamic subtest bcs0: SUCCESS (0.205s)
[343.892725] Starting dynamic subtest: vcs0
[344.075031] Dynamic subtest vcs0: SUCCESS (0.191s)
[344.085164] Starting dynamic subtest: vcs1
[345.378789] Dynamic subtest vcs1: SUCCESS (1.303s)
[345.389226] Starting dynamic subtest: vecs0
[347.401751] Dynamic subtest vecs0: SUCCESS (2.022s)
[347.413043] Starting dynamic subtest: ccs0
[349.458458] Dynamic subtest ccs0: SUCCESS (2.055s)
[349.460830] Subtest dirty-create: SUCCESS (5.970s)
[349.701422] [096/132] (675s left) gem_softpin (allocator-evict)
[349.769886] Starting subtest: allocator-evict
[349.772344] Starting dynamic subtest: rcs0
[373.731248] Dynamic subtest rcs0: SUCCESS (23.960s)
[373.743383] Starting dynamic subtest: bcs0
[397.768064] Dynamic subtest bcs0: SUCCESS (24.034s)
[397.778578] Starting dynamic subtest: vcs0
[421.273246] Dynamic subtest vcs0: SUCCESS (23.503s)
[421.285528] Starting dynamic subtest: vcs1
[445.046839] Dynamic subtest vcs1: SUCCESS (23.771s)
[445.056899] Starting dynamic subtest: vecs0
[468.902105] Dynamic subtest vecs0: SUCCESS (23.852s)
[468.912187] Starting dynamic subtest: ccs0
[492.825284] Dynamic subtest ccs0: SUCCESS (23.921s)
[492.827814] Subtest allocator-evict: SUCCESS (143.052s)
[492.921259] [097/132] (532s left) api_intel_bb (misplaced-blitter)
[493.015014] Starting subtest: misplaced-blitter
[493.025750] Subtest misplaced-blitter: SUCCESS (0.012s)
[493.160424] [098/132] (531s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[493.255764] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[493.258077] Starting dynamic subtest: A-eDP1
[496.821755] Dynamic subtest A-eDP1: SUCCESS (3.564s)
[496.832157] Starting dynamic subtest: B-eDP1
[500.011817] Dynamic subtest B-eDP1: SUCCESS (3.187s)
[500.022437] Starting dynamic subtest: C-eDP1
[503.110816] Dynamic subtest C-eDP1: SUCCESS (3.100s)
[503.121145] Starting dynamic subtest: D-eDP1
[506.221965] Dynamic subtest D-eDP1: SUCCESS (3.107s)
[506.224362] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.969s)
[507.025245] [099/132] (518s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[507.118518] Starting subtest: fbc-psr2-sprite-mmap-gtt
[507.120453] Starting dynamic subtest: eDP-1
[507.124478] Dynamic subtest eDP-1: SKIP (0.000s)
[507.128595] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[507.198400] [100/132] (518s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[507.291850] Starting subtest: extended-pageflip-modeset-hang-oldfb
[507.294157] Starting dynamic subtest: pipe-A
[515.183661] Dynamic subtest pipe-A: SUCCESS (7.889s)
[515.194391] Starting dynamic subtest: pipe-D
[523.847374] Dynamic subtest pipe-D: SUCCESS (8.661s)
[523.849749] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.555s)
[524.708486] [101/132] (500s left) gem_vm_create (create-ext)
[524.765409] Starting subtest: create-ext
[524.775292] Subtest create-ext: SUCCESS (0.009s)
[524.896667] [102/132] (500s left) sw_sync (alloc_merge_fence)
[524.937650] Starting subtest: alloc_merge_fence
[524.939974] Subtest alloc_merge_fence: SUCCESS (0.000s)
[524.995057] [103/132] (500s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[525.069854] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[525.072635] Starting dynamic subtest: pipe-A-default-mode
[527.845307] Dynamic subtest pipe-A-default-mode: SUCCESS (2.775s)
[527.847304] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.777s)
[528.677978] [104/132] (496s left) gem_partial_pwrite_pread (write-display)
[528.736745] Subtest write-display: SKIP (0.000s)
[528.808740] [105/132] (496s left) gem_exec_balancer (sliced)
[528.864750] Starting subtest: sliced
[528.869214] Subtest sliced: SKIP (0.000s)
[529.160553] [106/132] (496s left) kms_scaling_modes (scaling-mode-center)
[529.237080] Starting subtest: scaling-mode-center
[529.239649] Starting dynamic subtest: pipe-A-eDP-1
[529.329458] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s)
[529.343174] Starting dynamic subtest: pipe-B-eDP-1
[530.495904] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.162s)
[530.509889] Starting dynamic subtest: pipe-C-eDP-1
[531.612136] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.115s)
[531.628427] Starting dynamic subtest: pipe-D-eDP-1
[532.735449] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.120s)
[532.737802] Subtest scaling-mode-center: SUCCESS (3.502s)
[533.896754] [107/132] (491s left) kms_lease (lease-unleased-crtc)
[533.971200] Starting subtest: lease-unleased-crtc
[533.973427] Starting dynamic subtest: pipe-A-eDP-1
[534.277385] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.306s)
[534.287977] Starting dynamic subtest: pipe-B-eDP-1
[535.056074] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.776s)
[535.067212] Starting dynamic subtest: pipe-C-eDP-1
[535.069500] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[535.078222] Starting dynamic subtest: pipe-D-eDP-1
[535.080121] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[535.082062] Subtest lease-unleased-crtc: SUCCESS (1.097s)
[535.434140] [108/132] (490s left) kms_draw_crc (draw-method-render)
[535.509412] Starting subtest: draw-method-render
[535.511592] Starting dynamic subtest: xrgb8888-untiled
[535.741246] Dynamic subtest xrgb8888-untiled: SUCCESS (0.233s)
[535.751315] Starting dynamic subtest: rgb565-untiled
[535.963511] Dynamic subtest rgb565-untiled: SUCCESS (0.221s)
[535.973368] Starting dynamic subtest: xrgb2101010-untiled
[536.174452] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.209s)
[536.184502] Starting dynamic subtest: xbgr16161616f-untiled
[536.418662] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.244s)
[536.428538] Starting dynamic subtest: xrgb8888-xtiled
[536.540954] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[536.551309] Starting dynamic subtest: rgb565-xtiled
[536.652136] Dynamic subtest rgb565-xtiled: SUCCESS (0.110s)
[536.664038] Starting dynamic subtest: xrgb2101010-xtiled
[536.774387] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.120s)
[536.784097] Starting dynamic subtest: xbgr16161616f-xtiled
[536.896654] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.121s)
[536.906521] Starting dynamic subtest: xrgb8888-4tiled
[537.018687] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.121s)
[537.030828] Starting dynamic subtest: rgb565-4tiled
[537.130073] Dynamic subtest rgb565-4tiled: SUCCESS (0.111s)
[537.139678] Starting dynamic subtest: xrgb2101010-4tiled
[537.240961] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.110s)
[537.250527] Starting dynamic subtest: xbgr16161616f-4tiled
[537.363222] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.121s)
[537.365093] Subtest draw-method-render: SUCCESS (1.857s)
[537.483291] [109/132] (488s left) gem_exec_reloc (basic-gtt-cpu-active)
[537.552730] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[537.623047] [110/132] (487s left) sw_sync (sync_busy)
[537.662470] Starting subtest: sync_busy
[537.664484] Subtest sync_busy: SUCCESS (0.002s)
[537.734714] [111/132] (487s left) kms_atomic_transition (modeset-transition-fencing)
[537.803034] Starting subtest: modeset-transition-fencing
[537.804587] Starting dynamic subtest: 1x-outputs
[548.652960] Dynamic subtest 1x-outputs: SUCCESS (10.849s)
[548.655343] Subtest modeset-transition-fencing: SUCCESS (10.851s)
[549.508513] [112/132] (476s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[549.596290] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[549.600768] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[549.697412] [113/132] (476s left) kms_flip (absolute-wf_vblank-interruptible)
[549.763848] Starting subtest: absolute-wf_vblank-interruptible
[549.765774] Starting dynamic subtest: A-eDP1
[558.495683] Dynamic subtest A-eDP1: SUCCESS (8.695s)
[558.506037] Starting dynamic subtest: B-eDP1
[567.217092] Dynamic subtest B-eDP1: SUCCESS (8.717s)
[567.228331] Starting dynamic subtest: C-eDP1
[575.952242] Dynamic subtest C-eDP1: SUCCESS (8.722s)
[575.964633] Starting dynamic subtest: D-eDP1
[584.678493] Dynamic subtest D-eDP1: SUCCESS (8.722s)
[584.680771] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.867s)
[585.845847] [114/132] (439s left) kms_psr (pr-cursor-plane-move)
[585.921823] Starting subtest: pr-cursor-plane-move
[585.926218] Subtest pr-cursor-plane-move: SKIP (0.000s)
[585.996154] [115/132] (439s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[586.071060] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[586.073403] Starting dynamic subtest: pipe-A-eDP-1
[586.096469] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[586.107342] Starting dynamic subtest: pipe-B-eDP-1
[586.129355] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[586.138309] Starting dynamic subtest: pipe-C-eDP-1
[586.160183] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[586.171568] Starting dynamic subtest: pipe-D-eDP-1
[586.193309] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[586.197732] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.004s)
[588.243576] [116/132] (437s left) gem_ringfill (engines-basic)
[594.243201] Starting subtest: engines-basic
[594.245908] Starting dynamic subtest: rcs0
[594.291936] Dynamic subtest rcs0: SUCCESS (0.049s)
[594.304034] Starting dynamic subtest: bcs0
[594.334742] Dynamic subtest bcs0: SUCCESS (0.041s)
[594.346118] Starting dynamic subtest: vcs0
[594.378059] Dynamic subtest vcs0: SUCCESS (0.041s)
[594.388871] Starting dynamic subtest: vcs1
[594.421018] Dynamic subtest vcs1: SUCCESS (0.041s)
[594.431939] Starting dynamic subtest: vecs0
[594.464043] Dynamic subtest vecs0: SUCCESS (0.041s)
[594.474851] Starting dynamic subtest: ccs0
[594.507969] Dynamic subtest ccs0: SUCCESS (0.042s)
[594.510433] Subtest engines-basic: SUCCESS (0.267s)
[594.586166] [117/132] (431s left) gem_ctx_engines (invalid-engines)
[594.651504] Starting subtest: invalid-engines
[594.661602] Subtest invalid-engines: SUCCESS (0.010s)
[594.888769] [118/132] (431s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[594.981534] Starting subtest: 4-tiled-addfb-size-offset-overflow
[594.983778] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[595.071771] [119/132] (430s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[595.137045] Subtest no-spare-fences-busy: SKIP (0.000s)
[595.215896] [120/132] (430s left) gem_exec_schedule (u-semaphore-noskip)
[595.281164] Starting subtest: u-semaphore-noskip
[595.677572] Subtest u-semaphore-noskip: SUCCESS (0.403s)
[596.016732] [121/132] (430s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[596.091043] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[596.095065] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[596.181607] [122/132] (429s left) kms_atomic_transition (plane-all-transition-fencing)
[596.251895] Starting subtest: plane-all-transition-fencing
[596.254131] Starting dynamic subtest: pipe-A-eDP-1
[598.745877] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[599.054550] Starting dynamic subtest: pipe-B-eDP-1
[602.258702] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.216s)
[602.559746] Subtest plane-all-transition-fencing: SUCCESS (6.306s)
[603.383613] [123/132] (422s left) core_setmaster_vs_auth
[603.530488] [124/132] (422s left) gem_barrier_race (remote-request)
[603.606243] Starting subtest: remote-request
[603.608542] Starting dynamic subtest: rcs0
[608.779718] Dynamic subtest rcs0: SUCCESS (5.175s)
[608.781712] Subtest remote-request: SUCCESS (5.176s)
[608.919947] [125/132] (417s left) syncobj_wait (wait-all-interrupted)
[608.978751] Starting subtest: wait-all-interrupted
[609.080856] Subtest wait-all-interrupted: SUCCESS (0.102s)
[609.166931] [126/132] (417s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[609.253096] Starting subtest: psr-rgb565-draw-mmap-gtt
[609.256490] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[609.346505] [127/132] (416s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[609.432462] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[609.434455] Starting dynamic subtest: pipe-A-eDP-1
[609.569523] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.127s)
[609.581087] Starting dynamic subtest: pipe-B-eDP-1
[609.598039] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[609.607098] Starting dynamic subtest: pipe-C-eDP-1
[609.623171] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[609.632073] Starting dynamic subtest: pipe-D-eDP-1
[609.648551] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[609.650257] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.136s)
[611.838153] [128/132] (414s left) perf_pmu (idle)
[611.883610] Starting subtest: idle
[611.885801] Starting dynamic subtest: rcs0
[612.423824] Dynamic subtest rcs0: SUCCESS (0.539s)
[612.435204] Starting dynamic subtest: bcs0
[612.946433] Dynamic subtest bcs0: SUCCESS (0.517s)
[612.957053] Starting dynamic subtest: vcs0
[613.463028] Dynamic subtest vcs0: SUCCESS (0.516s)
[613.473733] Starting dynamic subtest: vcs1
[613.984203] Dynamic subtest vcs1: SUCCESS (0.518s)
[614.003420] Starting dynamic subtest: vecs0
[614.504717] Dynamic subtest vecs0: SUCCESS (0.517s)
[614.517556] Starting dynamic subtest: ccs0
[615.023098] Dynamic subtest ccs0: SUCCESS (0.518s)
[615.025269] Subtest idle: SUCCESS (3.142s)
[615.124958] [129/132] (411s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[615.213273] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[621.941974] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.732s)
[622.080749] [130/132] (404s left) perf_pmu (interrupts)
[622.130394] Starting subtest: interrupts
[623.200805] Subtest interrupts: SUCCESS (1.072s)
[623.308985] [131/132] (403s left) kms_vblank (wait-busy-hang)
[623.392920] Starting subtest: wait-busy-hang
[623.395221] Starting dynamic subtest: pipe-A-eDP-1
[650.041483] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.646s)
[650.056165] Starting dynamic subtest: pipe-D-eDP-1
[674.055259] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.009s)
[674.057183] Subtest wait-busy-hang: SUCCESS (50.659s)
[674.925869] [132/132] (351s left) kms_cursor_crc (cursor-sliding-64x64)
[675.086277] Starting subtest: cursor-sliding-64x64
[675.091147] Starting dynamic subtest: pipe-A-eDP-1
[678.336061] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.243s)
[678.363650] Starting dynamic subtest: pipe-D-eDP-1
[682.236899] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.883s)
[682.239276] Subtest cursor-sliding-64x64: SUCCESS (7.150s)
[683.084575] Closing watchdogs
results: parsing output: 0/ for test: kms_plane_lowres
results: parsing output: 1/ for test: gem_huc_copy
results: parsing output: 2/ for test: kms_getfb
results: parsing output: 3/ for test: i915_pm_rpm
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: perf_pmu
results: parsing output: 6/ for test: gem_fence_thrash
results: parsing output: 7/ for test: syncobj_wait
results: parsing output: 8/ for test: device_reset
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: kms_pipe_stress
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: kms_ccs
results: parsing output: 13/ for test: kms_joiner
results: parsing output: 14/ for test: kms_pipe_b_c_ivb
results: parsing output: 15/ for test: gem_exec_schedule
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: kms_async_flips
results: parsing output: 19/ for test: prime_vgem
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: kms_dither
results: parsing output: 22/ for test: gem_pxp
results: parsing output: 23/ for test: perf_pmu
results: parsing output: 24/ for test: gem_mmap_offset
results: parsing output: 25/ for test: gem_ctx_bad_destroy
results: parsing output: 26/ for test: kms_flip_scaled_crc
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_exec_whisper
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_psr
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: vgem_basic
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_cursor_legacy
results: parsing output: 39/ for test: i915_pm_sseu
results: parsing output: 40/ for test: kms_chamelium_hpd
results: parsing output: 41/ for test: gem_userptr_blits
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: syncobj_timeline
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: gem_pxp
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: i915_query
results: parsing output: 50/ for test: kms_force_connector_basic
results: parsing output: 51/ for test: gem_exec_fence
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: api_intel_allocator
results: parsing output: 54/ for test: kms_pm_dc
results: parsing output: 55/ for test: kms_psr2_sf
results: parsing output: 56/ for test: gem_flink_basic
results: parsing output: 57/ for test: kms_cursor_legacy
results: parsing output: 58/ for test: kms_atomic_transition
results: parsing output: 59/ for test: kms_flip_event_leak
results: parsing output: 60/ for test: kms_scaling_modes
results: parsing output: 61/ for test: vgem_basic
results: parsing output: 62/ for test: i915_drm_fdinfo
results: parsing output: 63/ for test: kms_cursor_crc
results: parsing output: 64/ for test: kms_chamelium_frames
results: parsing output: 65/ for test: gem_set_tiling_vs_blt
results: parsing output: 66/ for test: kms_color
results: parsing output: 67/ for test: vgem_basic
results: parsing output: 68/ for test: gem_exec_reloc
results: parsing output: 69/ for test: gem_mmap_gtt
results: parsing output: 70/ for test: gen9_exec_parse
results: parsing output: 71/ for test: i915_hangman
results: parsing output: 72/ for test: gem_exec_params
results: parsing output: 73/ for test: kms_cursor_legacy
results: parsing output: 74/ for test: gem_ctx_persistence
results: parsing output: 75/ for test: gem_exec_balancer
results: parsing output: 76/ for test: kms_psr2_sf
results: parsing output: 77/ for test: syncobj_wait
results: parsing output: 78/ for test: kms_properties
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_eio
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: kms_content_protection
results: parsing output: 85/ for test: kms_plane
results: parsing output: 86/ for test: kms_plane_scaling
results: parsing output: 87/ for test: gem_exec_params
results: parsing output: 88/ for test: kms_plane
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_cursor_crc
results: parsing output: 91/ for test: sw_sync
results: parsing output: 92/ for test: kms_hdmi_inject
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_ctx_isolation
results: parsing output: 95/ for test: gem_softpin
results: parsing output: 96/ for test: api_intel_bb
results: parsing output: 97/ for test: kms_flip
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: kms_busy
results: parsing output: 100/ for test: gem_vm_create
results: parsing output: 101/ for test: sw_sync
results: parsing output: 102/ for test: kms_flip_scaled_crc
results: parsing output: 103/ for test: gem_partial_pwrite_pread
results: parsing output: 104/ for test: gem_exec_balancer
results: parsing output: 105/ for test: kms_scaling_modes
results: parsing output: 106/ for test: kms_lease
results: parsing output: 107/ for test: kms_draw_crc
results: parsing output: 108/ for test: gem_exec_reloc
results: parsing output: 109/ for test: sw_sync
results: parsing output: 110/ for test: kms_atomic_transition
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: kms_ccs
results: parsing output: 115/ for test: gem_ringfill
results: parsing output: 116/ for test: gem_ctx_engines
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: gem_fenced_exec_thrash
results: parsing output: 119/ for test: gem_exec_schedule
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_atomic_transition
results: parsing output: 122/ for test: core_setmaster_vs_auth
results: parsing output: 123/ for test: gem_barrier_race
results: parsing output: 124/ for test: syncobj_wait
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_ccs
results: parsing output: 127/ for test: perf_pmu
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: perf_pmu
results: parsing output: 130/ for test: kms_vblank
results: parsing output: 131/ for test: kms_cursor_crc
Done.