[57.495671] Initializing watchdogs
[57.495818]   /dev/watchdog0
[57.512287] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[57.516376] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.518563] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.521918] [001/154] (960s left) i915_drm_fdinfo (virtual-idle)
[57.593248] Starting subtest: virtual-idle
[60.682055] Subtest virtual-idle: SUCCESS (3.043s)
[60.763944] [002/154] (957s left) gem_softpin (allocator-basic)
[60.826062] Starting subtest: allocator-basic
[60.904403] Subtest allocator-basic: SUCCESS (0.077s)
[61.011440] [003/154] (957s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[61.110425] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc
[61.114637] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[61.197422] [004/154] (956s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[61.279585] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[65.476912] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.169s)
[66.669950] [005/154] (951s left) kms_atomic (plane-invalid-params-fence)
[66.746989] Starting subtest: plane-invalid-params-fence
[66.749458] Starting dynamic subtest: pipe-A-eDP-1
[67.145653] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.395s)
[67.147796] Subtest plane-invalid-params-fence: SUCCESS (0.396s)
[67.998168] [006/154] (950s left) gem_exec_reloc (basic-concurrent16)
[68.065190] Subtest basic-concurrent16: SKIP (0.000s)
[68.136906] [007/154] (950s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[68.220533] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[68.224810] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[68.280988] [008/154] (949s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[68.361601] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[68.365768] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[68.460650] [009/154] (949s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[68.560747] Starting subtest: x-tiled-32bpp-rotate-90
[68.579712] Subtest x-tiled-32bpp-rotate-90: SKIP (0.018s)
[68.690320] [010/154] (949s left) sysfs_preempt_timeout (timeout)
[68.744864] Starting subtest: timeout
[68.747376] Starting dynamic subtest: vecs0
[78.201759] Dynamic subtest vecs0: SUCCESS (9.433s)
[78.211658] Starting dynamic subtest: ccs0
[79.348087] Dynamic subtest ccs0: SUCCESS (1.144s)
[79.360757] Starting dynamic subtest: vcs0
[89.209700] Dynamic subtest vcs0: SUCCESS (9.854s)
[89.218785] Starting dynamic subtest: bcs0
[90.366398] Dynamic subtest bcs0: SUCCESS (1.155s)
[90.374821] Starting dynamic subtest: rcs0
[91.577136] Dynamic subtest rcs0: SUCCESS (1.210s)
[91.585142] Starting dynamic subtest: vcs1
[101.242195] Dynamic subtest vcs1: SUCCESS (9.657s)
[101.244878] Subtest timeout: SUCCESS (32.460s)
[101.315769] [011/154] (917s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[101.408362] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[102.043053] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.637s)
[102.213296] [012/154] (916s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[102.291154] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[102.295149] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[102.409811] [013/154] (916s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[102.469138] Starting subtest: etime-multi-wait-for-submit-submitted
[102.578081] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.108s)
[102.649730] [014/154] (915s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[102.731343] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[102.735654] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[102.835231] [015/154] (915s left) gem_wait (busy)
[102.896531] Starting subtest: busy
[102.899037] Starting dynamic subtest: all-engines
[104.253856] Dynamic subtest all-engines: SUCCESS (1.355s)
[104.265476] Starting dynamic subtest: rcs0
[104.794143] Dynamic subtest rcs0: SUCCESS (0.541s)
[104.804358] Starting dynamic subtest: bcs0
[105.332326] Dynamic subtest bcs0: SUCCESS (0.538s)
[105.342250] Starting dynamic subtest: vcs0
[107.262701] Dynamic subtest vcs0: SUCCESS (1.928s)
[107.274104] Starting dynamic subtest: vcs1
[109.246399] Dynamic subtest vcs1: SUCCESS (1.981s)
[109.257817] Starting dynamic subtest: vecs0
[111.229752] Dynamic subtest vecs0: SUCCESS (1.982s)
[111.241120] Starting dynamic subtest: ccs0
[111.771217] Dynamic subtest ccs0: SUCCESS (0.542s)
[111.773697] Subtest busy: SUCCESS (8.873s)
[111.963282] [016/154] (906s left) kms_async_flips (async-flip-hang)
[112.050818] Starting subtest: async-flip-hang
[112.440042] Starting dynamic subtest: pipe-A-eDP-1
[127.771798] Dynamic subtest pipe-A-eDP-1: SUCCESS (15.329s)
[128.163628] Starting dynamic subtest: pipe-B-eDP-1
[143.705797] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.545s)
[144.087187] Starting dynamic subtest: pipe-C-eDP-1
[159.703822] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.622s)
[160.088286] Starting dynamic subtest: pipe-D-eDP-1
[175.703576] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.621s)
[175.706128] Subtest async-flip-hang: SUCCESS (63.647s)
[176.895190] [017/154] (841s left) gem_exec_suspend (basic-s3)
[176.952653] Starting subtest: basic-S3
[176.955068] Starting dynamic subtest: smem
[197.135121] Dynamic subtest smem: SUCCESS (6.234s)
[197.138455] Subtest basic-S3: SUCCESS (6.235s)
[197.317901] [018/154] (821s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[197.405578] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[197.409973] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[197.479087] [019/154] (821s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[197.555433] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu
[197.559974] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[197.652924] [020/154] (821s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[197.721336] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[197.725562] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[197.798990] [021/154] (820s left) gem_create (create-ext-cpu-access-big)
[197.958607] Starting subtest: create-ext-cpu-access-big
[197.963333] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[198.042926] [022/154] (820s left) syncobj_wait (reset-multiple-signaled)
[198.093746] Starting subtest: reset-multiple-signaled
[198.096176] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[198.197658] [023/154] (820s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[198.241554] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[198.347160] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.102s)
[198.421986] [024/154] (820s left) device_reset (cold-reset-bound)
[198.469312] Starting subtest: cold-reset-bound
[198.474135] Subtest cold-reset-bound: SKIP (0.000s)
[198.545252] [025/154] (820s left) kms_flip (2x-flip-vs-dpms)
[198.620555] Starting subtest: 2x-flip-vs-dpms
[198.627519] Subtest 2x-flip-vs-dpms: SKIP (0.008s)
[198.743674] [026/154] (820s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[198.824911] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[205.853418] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.936s)
[205.967033] [027/154] (813s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[206.042821] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[206.047337] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[207.152237] [028/154] (811s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[207.237247] Starting subtest: fbc-rgb565-draw-mmap-wc
[211.257281] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (4.004s)
[212.385596] [029/154] (806s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[212.492222] Starting subtest: basic-flip-after-cursor-atomic
[213.409400] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.917s)
[214.211174] [030/154] (804s left) gem_exec_params (invalid-flag)
[214.264187] Starting subtest: invalid-flag
[214.266460] Subtest invalid-flag: SUCCESS (0.000s)
[214.358322] [031/154] (804s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[214.607066] Starting subtest: cursor-rapid-movement-512x512
[214.611293] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[214.743790] [032/154] (804s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[214.829398] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-cpu
[214.833443] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[214.933646] [033/154] (804s left) kms_frontbuffer_tracking (hdr-rgb565-draw-mmap-cpu)
[215.019736] Starting subtest: hdr-rgb565-draw-mmap-cpu
[215.024066] Subtest hdr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[215.133368] [034/154] (804s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[215.203563] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[215.205539] Starting dynamic subtest: pipe-A-eDP-1
[215.715526] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.485s)
[215.726241] Starting dynamic subtest: pipe-B-eDP-1
[217.215961] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.488s)
[217.226886] Starting dynamic subtest: pipe-C-eDP-1
[218.659467] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.441s)
[218.670020] Starting dynamic subtest: pipe-D-eDP-1
[220.058646] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.399s)
[220.060740] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.817s)
[221.219394] [035/154] (798s left) gem_exec_reloc (basic-cpu-wc)
[221.279118] Subtest basic-cpu-wc: SKIP (0.000s)
[221.343585] [036/154] (798s left) syncobj_timeline (wait-all-interrupted)
[221.395645] Starting subtest: wait-all-interrupted
[221.497376] Subtest wait-all-interrupted: SUCCESS (0.102s)
[221.582034] [037/154] (797s left) gem_mmap_gtt (cpuset-medium-copy)
[221.639364] Subtest cpuset-medium-copy: SKIP (0.000s)
[221.699749] [038/154] (797s left) gem_mmap_gtt (hang-busy)
[221.751673] Subtest hang-busy: SKIP (0.000s)
[221.812387] [039/154] (797s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-blt)
[221.897579] Starting subtest: fbcpsrhdr-rgb565-draw-blt
[221.901692] Subtest fbcpsrhdr-rgb565-draw-blt: SKIP (0.000s)
[221.990458] [040/154] (797s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[222.065944] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[222.070083] Subtest psrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[222.162828] [041/154] (797s left) gem_exec_balancer (bonded-sync)
[222.221598] Starting subtest: bonded-sync
[222.226155] Subtest bonded-sync: SKIP (0.000s)
[222.530424] [042/154] (797s left) i915_pm_rps (thresholds)
[222.577893] Starting subtest: thresholds
[222.582321] Subtest thresholds: SKIP (0.001s)
[222.679354] [043/154] (796s left) i915_query (query-topology-known-pci-ids)
[222.730089] Starting subtest: query-topology-known-pci-ids
[222.734395] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[222.836739] [044/154] (796s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[222.911241] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[229.732603] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.824s)
[229.841649] [045/154] (789s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[229.922691] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-mmap-wc
[229.926665] Subtest hdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[230.027107] [046/154] (789s left) kms_cursor_crc (cursor-suspend)
[230.138190] Starting subtest: cursor-suspend
[230.140562] Starting dynamic subtest: pipe-A-eDP-1
[262.780016] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.203s)
[262.789830] Starting dynamic subtest: pipe-D-eDP-1
[296.749773] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.745s)
[296.752692] Subtest cursor-suspend: SUCCESS (6.951s)
[297.642082] [047/154] (722s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt)
[297.732406] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt
[297.737399] Subtest fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[297.842550] [048/154] (721s left) vgem_basic (sysfs)
[297.951531] Starting subtest: sysfs
[297.954043] Subtest sysfs: SUCCESS (0.000s)
[298.005404] [FACT vgem_basic (sysfs)] new: kernel.kmod_is_loaded.vgem: true
[298.009206] [049/154] (721s left) kms_flip (flip-vs-blocking-wf-vblank)
[298.089651] Starting subtest: flip-vs-blocking-wf-vblank
[298.092426] Starting dynamic subtest: A-eDP1
[318.929393] Dynamic subtest A-eDP1: SUCCESS (20.656s)
[318.937957] Starting dynamic subtest: B-eDP1
[327.871191] Dynamic subtest B-eDP1: SUCCESS (8.928s)
[327.881007] Starting dynamic subtest: C-eDP1
[336.791317] Dynamic subtest C-eDP1: SUCCESS (8.917s)
[336.800732] Starting dynamic subtest: D-eDP1
[345.723606] Dynamic subtest D-eDP1: SUCCESS (8.931s)
[345.726683] Subtest flip-vs-blocking-wf-vblank: SUCCESS (47.442s)
[346.949858] [050/154] (672s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[347.055882] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc
[347.061160] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[347.155845] [051/154] (672s left) kms_chamelium_hpd (vga-hpd)
[347.518519] Subtest vga-hpd: SKIP (0.000s)
[348.367407] [052/154] (671s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[348.457587] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[352.874417] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.425s)
[354.076935] [053/154] (665s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[354.167523] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[354.174261] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[354.246402] [054/154] (665s left) kms_dsc (dsc-basic)
[354.323073] Starting subtest: dsc-basic
[354.338456] Subtest dsc-basic: SKIP (0.000s)
[354.398300] [055/154] (665s left) syncobj_wait (invalid-wait-illegal-handle)
[354.452467] Starting subtest: invalid-wait-illegal-handle
[354.455441] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[354.542614] [056/154] (665s left) gem_exec_balancer (sliced)
[354.606969] Starting subtest: sliced
[354.612549] Subtest sliced: SKIP (0.000s)
[354.908524] [057/154] (665s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[354.984069] Starting subtest: y-tiled-addfb-size-offset-overflow
[354.988164] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[355.088863] [058/154] (665s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-move)
[355.181490] Starting subtest: psrhdr-1p-primscrn-spr-indfb-move
[355.187272] Subtest psrhdr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[355.275454] [059/154] (665s left) kms_psr (psr-sprite-plane-onoff)
[355.344618] Starting subtest: psr-sprite-plane-onoff
[355.347158] Starting dynamic subtest: eDP-1
[357.084502] Dynamic subtest eDP-1: SUCCESS (1.737s)
[357.086978] Subtest psr-sprite-plane-onoff: SUCCESS (1.738s)
[357.915243] [060/154] (662s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[358.016319] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[359.050305] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.034s)
[359.170522] [061/154] (661s left) gem_userptr_blits (unsync-unmap-cycles)
[359.233394] Subtest unsync-unmap-cycles: SKIP (0.000s)
[359.347069] [062/154] (661s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[359.419065] Starting subtest: plane-downscale-factor-0-75-with-rotation
[359.420930] Starting dynamic subtest: pipe-A
[359.648554] Dynamic subtest pipe-A: SUCCESS (0.230s)
[359.658337] Starting dynamic subtest: pipe-B
[361.019452] Dynamic subtest pipe-B: SUCCESS (1.369s)
[361.028396] Starting dynamic subtest: pipe-C
[362.335443] Dynamic subtest pipe-C: SUCCESS (1.315s)
[362.347548] Starting dynamic subtest: pipe-D
[363.688930] Dynamic subtest pipe-D: SUCCESS (1.352s)
[363.691562] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.270s)
[364.850436] [063/154] (655s left) kms_cursor_crc (cursor-offscreen-64x64)
[365.015581] Starting subtest: cursor-offscreen-64x64
[365.018017] Starting dynamic subtest: pipe-A-eDP-1
[366.970090] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.952s)
[367.000550] Starting dynamic subtest: pipe-D-eDP-1
[369.582488] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.586s)
[369.585268] Subtest cursor-offscreen-64x64: SUCCESS (4.564s)
[370.434867] [064/154] (650s left) gem_close (basic)
[370.497283] Starting subtest: basic
[370.499947] Subtest basic: SUCCESS (0.000s)
[370.582268] [065/154] (649s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[370.654067] Starting subtest: stress-xrgb8888-xtiled
[376.515156] Subtest stress-xrgb8888-xtiled: SUCCESS (5.860s)
[376.566721] [066/154] (644s left) gem_exec_schedule (preempt-other)
[376.641787] Starting subtest: preempt-other
[376.643799] Starting dynamic subtest: rcs0
[376.709477] Dynamic subtest rcs0: SUCCESS (0.073s)
[376.720315] Starting dynamic subtest: bcs0
[376.777616] Dynamic subtest bcs0: SUCCESS (0.067s)
[376.789125] Starting dynamic subtest: vcs0
[376.845239] Dynamic subtest vcs0: SUCCESS (0.067s)
[376.857863] Starting dynamic subtest: vcs1
[376.910277] Dynamic subtest vcs1: SUCCESS (0.064s)
[376.922353] Starting dynamic subtest: vecs0
[376.976770] Dynamic subtest vecs0: SUCCESS (0.066s)
[376.985394] Starting dynamic subtest: ccs0
[377.042959] Dynamic subtest ccs0: SUCCESS (0.065s)
[377.045513] Subtest preempt-other: SUCCESS (0.407s)
[378.762416] [067/154] (641s left) gem_busy (parallel)
[378.943658] Starting subtest: parallel
[378.946930] Starting dynamic subtest: rcs0
[380.659239] Dynamic subtest rcs0: SUCCESS (1.714s)
[380.672058] Starting dynamic subtest: bcs0
[382.705983] Dynamic subtest bcs0: SUCCESS (2.043s)
[382.721660] Starting dynamic subtest: vcs0
[384.691057] Dynamic subtest vcs0: SUCCESS (1.981s)
[384.705274] Starting dynamic subtest: vcs1
[386.674460] Dynamic subtest vcs1: SUCCESS (1.980s)
[386.687540] Starting dynamic subtest: vecs0
[388.722681] Dynamic subtest vecs0: SUCCESS (2.045s)
[388.734695] Starting dynamic subtest: ccs0
[390.707361] Dynamic subtest ccs0: SUCCESS (1.981s)
[390.710835] Subtest parallel: SUCCESS (11.760s)
[390.933954] [068/154] (629s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[391.031069] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[395.495576] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.474s)
[396.639711] [069/154] (624s left) gem_softpin (evict-active-interruptible)
[396.702208] Starting subtest: evict-active-interruptible
[396.707810] Subtest evict-active-interruptible: SUCCESS (0.006s)
[396.828116] [070/154] (623s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-msflip-blt)
[396.905674] Starting subtest: fbchdr-1p-primscrn-indfb-msflip-blt
[396.910517] Subtest fbchdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[396.992969] [071/154] (623s left) kms_chamelium_audio (hdmi-audio-edid)
[397.355441] Subtest hdmi-audio-edid: SKIP (0.000s)
[398.138047] [072/154] (622s left) i915_drm_fdinfo (virtual-busy-hang-all)
[398.177552] Starting subtest: virtual-busy-hang-all
[398.183185] Subtest virtual-busy-hang-all: SKIP (0.000s)
[398.244168] [073/154] (622s left) gem_exec_reloc (basic-cpu-read)
[398.294230] Subtest basic-cpu-read: SKIP (0.000s)
[398.362832] [074/154] (622s left) syncobj_wait (invalid-reset-bad-pad)
[398.410101] Starting subtest: invalid-reset-bad-pad
[398.412463] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[398.517377] [075/154] (622s left) kms_frontbuffer_tracking (fbchdr-2p-pri-indfb-multidraw)
[398.601448] Starting subtest: fbchdr-2p-pri-indfb-multidraw
[398.606463] Subtest fbchdr-2p-pri-indfb-multidraw: SKIP (0.000s)
[398.703295] [076/154] (622s left) kms_lease (invalid-create-leases)
[398.778459] Starting subtest: invalid-create-leases
[398.784441] Subtest invalid-create-leases: SUCCESS (0.005s)
[398.883935] [077/154] (622s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[398.965511] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[398.967951] Starting dynamic subtest: pipe-A-eDP-1
[398.991120] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[399.002378] Starting dynamic subtest: pipe-B-eDP-1
[399.026266] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[399.035397] Starting dynamic subtest: pipe-C-eDP-1
[399.061072] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[399.070438] Starting dynamic subtest: pipe-D-eDP-1
[399.094461] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[399.098390] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.008s)
[401.225421] [078/154] (619s left) perf (polling-small-buf)
[401.356637] Starting subtest: polling-small-buf
[401.448584] Subtest polling-small-buf: SUCCESS (0.091s)
[401.496884] [079/154] (619s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-blt)
[401.575469] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-blt
[401.580304] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[401.669390] [080/154] (619s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[401.717644] Starting subtest: multi-wait-for-submit-unsubmitted
[401.822656] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.104s)
[401.897660] [081/154] (619s left) gem_mmap_wc (invalid-flags)
[401.960516] Subtest invalid-flags: SKIP (0.000s)
[402.021567] [082/154] (619s left) kms_psr (fbc-pr-primary-blt)
[402.088353] Starting subtest: fbc-pr-primary-blt
[402.093659] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[402.170672] [083/154] (619s left) gem_exec_flush (basic-wb-prw-default)
[402.228555] Starting subtest: basic-wb-prw-default
[407.688690] Subtest basic-wb-prw-default: SUCCESS (5.462s)
[407.877722] [084/154] (613s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-render)
[407.971087] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-render
[407.976173] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[408.063909] [085/154] (613s left) gen9_exec_parse (batch-zero-length)
[408.120442] Subtest batch-zero-length: SKIP (0.000s)
[408.196255] [086/154] (613s left) kms_flip (2x-flip-vs-dpms-on-nop)
[408.263348] Starting subtest: 2x-flip-vs-dpms-on-nop
[408.271421] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.009s)
[408.350109] [087/154] (613s left) kms_getfb (getfb-handle-not-fb)
[408.426864] Starting subtest: getfb-handle-not-fb
[408.429663] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[408.524375] [088/154] (613s left) kms_content_protection (lic-type-1)
[408.645454] Starting subtest: lic-type-1
[408.651182] Subtest lic-type-1: SKIP (0.000s)
[408.770431] [089/154] (612s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[408.846116] Starting subtest: psr-modesetfrombusy
[414.983032] Subtest psr-modesetfrombusy: SUCCESS (6.144s)
[415.109652] [090/154] (606s left) syncobj_timeline (invalid-query-one-illegal-handle)
[415.158233] Starting subtest: invalid-query-one-illegal-handle
[415.160587] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[415.253163] [091/154] (606s left) kms_psr (fbc-psr2-sprite-blt)
[415.320648] Starting subtest: fbc-psr2-sprite-blt
[415.323418] Starting dynamic subtest: eDP-1
[415.328004] Dynamic subtest eDP-1: SKIP (0.000s)
[415.332656] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[415.394975] [092/154] (606s left) gem_softpin (noreloc-interruptible)
[415.445973] Starting subtest: noreloc-interruptible
[420.856447] Subtest noreloc-interruptible: SUCCESS (5.408s)
[420.968032] [093/154] (600s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-onoff)
[421.052366] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-onoff
[421.057267] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[421.144884] [094/154] (600s left) kms_psr (fbc-psr-no-drrs)
[421.223383] Starting subtest: fbc-psr-no-drrs
[421.225657] Starting dynamic subtest: eDP-1
[421.230649] Dynamic subtest eDP-1: SKIP (0.000s)
[421.235681] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[421.295363] [095/154] (600s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[421.377220] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt
[421.382072] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[421.472073] [096/154] (600s left) kms_lease (implicit-plane-lease)
[421.546051] Starting subtest: implicit-plane-lease
[421.548933] Subtest implicit-plane-lease: SUCCESS (0.002s)
[421.654770] [097/154] (600s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[421.738554] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[421.744446] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[421.845471] [098/154] (600s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[421.921099] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[421.922962] Starting dynamic subtest: pipe-A
[422.258330] Dynamic subtest pipe-A: SUCCESS (0.338s)
[422.267238] Starting dynamic subtest: pipe-B
[423.685050] Dynamic subtest pipe-B: SUCCESS (1.425s)
[423.695573] Starting dynamic subtest: pipe-C
[425.108010] Dynamic subtest pipe-C: SUCCESS (1.422s)
[425.117660] Starting dynamic subtest: pipe-D
[426.548518] Dynamic subtest pipe-D: SUCCESS (1.440s)
[426.551147] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.629s)
[427.704433] [099/154] (594s left) kms_invalid_mode (bad-hsync-end)
[427.778474] Starting subtest: bad-hsync-end
[427.781408] Starting dynamic subtest: pipe-A-eDP-1
[428.067872] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s)
[428.077662] Starting dynamic subtest: pipe-B-eDP-1
[428.080109] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[428.091638] Starting dynamic subtest: pipe-C-eDP-1
[428.094136] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[428.103084] Starting dynamic subtest: pipe-D-eDP-1
[428.105394] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[428.107849] Subtest bad-hsync-end: SUCCESS (0.297s)
[428.942128] [100/154] (593s left) kms_flip (2x-plain-flip-ts-check)
[429.016403] Starting subtest: 2x-plain-flip-ts-check
[429.025208] Subtest 2x-plain-flip-ts-check: SKIP (0.007s)
[429.101073] [101/154] (592s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[429.188445] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[435.863495] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.682s)
[435.991173] [102/154] (586s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[436.085432] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[436.087868] Starting dynamic subtest: pipe-A-eDP-1
[447.420377] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.337s)
[447.430483] Starting dynamic subtest: pipe-B-eDP-1
[459.514210] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.091s)
[459.516916] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.431s)
[460.332879] [103/154] (561s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[460.419025] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc
[460.424045] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[460.545312] [104/154] (561s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-render)
[460.637296] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-render
[460.642196] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[460.724092] [105/154] (561s left) kms_big_fb (linear-8bpp-rotate-90)
[460.802337] Starting subtest: linear-8bpp-rotate-90
[460.822991] Subtest linear-8bpp-rotate-90: SKIP (0.020s)
[460.923694] [106/154] (561s left) api_intel_allocator (execbuf-with-allocator)
[460.973264] Starting subtest: execbuf-with-allocator
[460.978674] Subtest execbuf-with-allocator: SUCCESS (0.007s)
[461.096665] [107/154] (561s left) gem_lmem_swapping (parallel-random-engines)
[461.135647] Subtest parallel-random-engines: SKIP (0.000s)
[461.184519] [108/154] (561s left) i915_query (query-topology-garbage-items)
[461.233552] Starting subtest: query-topology-garbage-items
[461.236455] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[461.323479] [109/154] (561s left) gem_ctx_persistence (idempotent)
[461.371943] Starting subtest: idempotent
[461.374182] Subtest idempotent: SUCCESS (0.000s)
[461.477419] [110/154] (560s left) kms_frontbuffer_tracking (fbchdr-2p-shrfb-fliptrack-mmap-gtt)
[461.551293] Starting subtest: fbchdr-2p-shrfb-fliptrack-mmap-gtt
[461.556239] Subtest fbchdr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[461.667143] [111/154] (560s left) api_intel_bb (purge-bb)
[461.724181] Starting subtest: purge-bb
[461.726210] Subtest purge-bb: SUCCESS (0.004s)
[461.867441] [112/154] (560s left) kms_busy (basic)
[461.941669] Starting subtest: basic
[461.944181] Starting dynamic subtest: flip
[462.529180] Dynamic subtest flip: SUCCESS (0.584s)
[462.540010] Starting dynamic subtest: modeset
[465.938648] Dynamic subtest modeset: SUCCESS (3.406s)
[465.941310] Subtest basic: SUCCESS (3.993s)
[466.746939] [113/154] (555s left) gem_ctx_freq (sysfs)
[466.803000] Starting subtest: sysfs
[466.805587] Starting dynamic subtest: gt0
[472.288363] Dynamic subtest gt0: SUCCESS (5.484s)
[472.300647] Starting dynamic subtest: gt1
[513.714081] Dynamic subtest gt1: SUCCESS (41.413s)
[513.717063] Subtest sysfs: SUCCESS (46.900s)
[513.834942] [114/154] (508s left) kms_plane_multiple (tiling-y)
[513.906582] Starting subtest: tiling-y
[513.912007] Subtest tiling-y: SKIP (0.000s)
[513.986111] [115/154] (508s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[514.063784] Starting subtest: yf-tiled-addfb-size-overflow
[514.069392] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[514.157356] [116/154] (508s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[514.253426] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[515.194430] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.942s)
[516.092375] [117/154] (506s left) gem_exec_params (invalid-bsd2-flag-on-render)
[516.158544] Starting subtest: invalid-bsd2-flag-on-render
[516.161497] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[516.269393] [118/154] (506s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[516.362137] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[516.367379] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[516.449535] [119/154] (506s left) kms_psr (pr-no-drrs)
[516.524877] Starting subtest: pr-no-drrs
[516.529579] Subtest pr-no-drrs: SKIP (0.000s)
[516.596146] [120/154] (506s left) gem_ctx_param (invalid-param-get)
[516.652304] Starting subtest: invalid-param-get
[516.655171] Subtest invalid-param-get: SUCCESS (0.001s)
[516.743885] [121/154] (506s left) kms_prop_blob (blob-multiple)
[516.797639] Starting subtest: blob-multiple
[516.800688] Subtest blob-multiple: SUCCESS (0.001s)
[516.893031] [122/154] (506s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[516.971196] Starting subtest: fbc-2p-pri-indfb-multidraw
[516.976472] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[517.073304] [123/154] (505s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[517.147448] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[517.149907] Starting dynamic subtest: pipe-A-eDP-1
[517.171886] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[517.195139] Starting dynamic subtest: pipe-B-eDP-1
[517.220939] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[517.243640] Starting dynamic subtest: pipe-C-eDP-1
[517.269917] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[517.292538] Starting dynamic subtest: pipe-D-eDP-1
[517.319807] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[517.324754] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[519.438431] [124/154] (503s left) kms_frontbuffer_tracking (hdr-1p-primscrn-shrfb-msflip-blt)
[519.520030] Starting subtest: hdr-1p-primscrn-shrfb-msflip-blt
[519.524552] Subtest hdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[519.609481] [125/154] (503s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[519.686443] Starting subtest: primary-y-tiled-reflect-x-90
[519.691392] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[519.771157] [126/154] (503s left) gem_sync (basic-store-each)
[519.846465] Starting subtest: basic-store-each
[522.312508] Subtest basic-store-each: SUCCESS (2.480s)
[522.497401] [127/154] (500s left) syncobj_wait (wait-all-complex)
[522.553787] Starting subtest: wait-all-complex
[522.769656] Subtest wait-all-complex: SUCCESS (0.216s)
[522.847540] [128/154] (500s left) gem_exec_whisper (basic-normal-all)
[522.912644] Starting subtest: basic-normal-all
[525.922647] Subtest basic-normal-all: SUCCESS (3.007s)
[526.109676] [129/154] (497s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[526.200398] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc
[526.204848] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[526.294832] [130/154] (497s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[526.383627] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[526.388146] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[526.471412] [131/154] (496s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-onoff)
[526.557559] Starting subtest: hdr-2p-primscrn-spr-indfb-onoff
[526.562314] Subtest hdr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[526.638121] [132/154] (496s left) gem_pread (exhaustion)
[526.690769] Subtest exhaustion: SKIP (0.000s)
[526.754861] [133/154] (496s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[526.834585] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[526.839464] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[526.932034] [134/154] (496s left) kms_psr (psr2-primary-mmap-cpu)
[527.007260] Starting subtest: psr2-primary-mmap-cpu
[527.009674] Starting dynamic subtest: eDP-1
[528.720309] Dynamic subtest eDP-1: SUCCESS (1.712s)
[528.722578] Subtest psr2-primary-mmap-cpu: SUCCESS (1.713s)
[529.593087] [135/154] (493s left) gem_eio (in-flight-contexts-10ms)
[529.832679] Starting subtest: in-flight-contexts-10ms
[541.705375] Subtest in-flight-contexts-10ms: SUCCESS (11.873s)
[541.865985] [136/154] (481s left) perf_pmu (busy-check-all)
[541.904864] Starting subtest: busy-check-all
[541.907435] Starting dynamic subtest: rcs0
[542.456433] Dynamic subtest rcs0: SUCCESS (0.552s)
[542.469674] Starting dynamic subtest: bcs0
[543.008044] Dynamic subtest bcs0: SUCCESS (0.549s)
[543.021403] Starting dynamic subtest: vcs0
[544.689906] Dynamic subtest vcs0: SUCCESS (1.679s)
[544.706225] Starting dynamic subtest: vcs1
[546.674394] Dynamic subtest vcs1: SUCCESS (1.982s)
[546.687669] Starting dynamic subtest: vecs0
[548.722640] Dynamic subtest vecs0: SUCCESS (2.046s)
[548.735934] Starting dynamic subtest: ccs0
[549.276895] Dynamic subtest ccs0: SUCCESS (0.552s)
[549.280250] Subtest busy-check-all: SUCCESS (7.376s)
[549.374840] [137/154] (474s left) perf (i915-ref-count)
[549.433762] Starting subtest: i915-ref-count
[549.473883] Subtest i915-ref-count: SUCCESS (0.039s)
[549.530816] [138/154] (474s left) gem_tiled_wb
[549.647143] [139/154] (474s left) kms_display_modes (extended-mode-basic)
[549.731417] Starting subtest: extended-mode-basic
[549.736635] Subtest extended-mode-basic: SKIP (0.000s)
[549.781677] [140/154] (473s left) kms_vblank (ts-continuation-dpms-suspend)
[549.850111] Starting subtest: ts-continuation-dpms-suspend
[549.852678] Starting dynamic subtest: pipe-A-eDP-1
[566.833400] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.855s)
[566.850925] Starting dynamic subtest: pipe-D-eDP-1
[584.860271] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.461s)
[584.863270] Subtest ts-continuation-dpms-suspend: SUCCESS (4.320s)
[585.699249] [141/154] (438s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[586.275002] Starting subtest: syncobj-backward-timeline-chain-engines
[586.365843] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.090s)
[587.427694] [142/154] (436s left) gem_exec_schedule (timeslicing)
[587.499295] Starting subtest: timeslicing
[587.501770] Starting dynamic subtest: rcs0
[587.509207] Dynamic subtest rcs0: SUCCESS (0.021s)
[587.520198] Starting dynamic subtest: bcs0
[587.531843] Dynamic subtest bcs0: SUCCESS (0.021s)
[587.543087] Starting dynamic subtest: vcs0
[587.554509] Dynamic subtest vcs0: SUCCESS (0.021s)
[587.566287] Starting dynamic subtest: vcs1
[587.574900] Dynamic subtest vcs1: SUCCESS (0.020s)
[587.586009] Starting dynamic subtest: vecs0
[587.596987] Dynamic subtest vecs0: SUCCESS (0.020s)
[587.609197] Starting dynamic subtest: ccs0
[587.617836] Dynamic subtest ccs0: SUCCESS (0.020s)
[587.620542] Subtest timeslicing: SUCCESS (0.129s)
[589.365132] [143/154] (434s left) kms_universal_plane (universal-plane-pageflip-windowed)
[589.444449] Starting subtest: universal-plane-pageflip-windowed
[589.446870] Starting dynamic subtest: pipe-A-eDP-1
[590.007084] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.554s)
[590.018896] Starting dynamic subtest: pipe-B-eDP-1
[591.186094] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.160s)
[591.197138] Starting dynamic subtest: pipe-C-eDP-1
[592.417177] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.215s)
[592.429312] Starting dynamic subtest: pipe-D-eDP-1
[593.663257] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.230s)
[593.666126] Subtest universal-plane-pageflip-windowed: SUCCESS (4.164s)
[594.575992] [144/154] (429s left) prime_busy (hang)
[594.642182] Starting subtest: hang
[594.645099] Starting dynamic subtest: rcs0
[620.829628] Dynamic subtest rcs0: SUCCESS (26.119s)
[620.840498] Starting dynamic subtest: bcs0
[627.985122] Dynamic subtest bcs0: SUCCESS (7.155s)
[627.997083] Starting dynamic subtest: vcs0
[634.960980] Dynamic subtest vcs0: SUCCESS (6.976s)
[634.975819] Starting dynamic subtest: vcs1
[641.938291] Dynamic subtest vcs1: SUCCESS (6.972s)
[641.951019] Starting dynamic subtest: vecs0
[648.975284] Dynamic subtest vecs0: SUCCESS (7.035s)
[648.987218] Starting dynamic subtest: ccs0
[662.815463] Dynamic subtest ccs0: SUCCESS (13.838s)
[662.818446] Subtest hang: SUCCESS (68.103s)
[662.921293] [145/154] (361s left) syncobj_timeline (single-wait-all-available-signaled)
[662.967879] Starting subtest: single-wait-all-available-signaled
[662.970386] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[663.065588] [146/154] (360s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[663.119202] Starting subtest: mixed-tiled-to-y-tiled-ccs
[663.124464] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[663.323780] [147/154] (360s left) gem_exec_params (batch-first)
[663.379496] Starting subtest: batch-first
[663.388537] Subtest batch-first: SUCCESS (0.009s)
[663.500811] [148/154] (360s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[663.864261] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[664.649881] [149/154] (359s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[664.727949] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[664.732934] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[664.825597] [150/154] (359s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[664.919788] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-mmap-wc
[664.925023] Subtest hdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[665.024010] [151/154] (359s left) gem_spin_batch (legacy)
[665.081282] Starting subtest: legacy
[665.083885] Starting dynamic subtest: default
[668.317256] Dynamic subtest default: SUCCESS (3.233s)
[668.328980] Starting dynamic subtest: render
[671.546743] Dynamic subtest render: SUCCESS (3.226s)
[671.559330] Starting dynamic subtest: bsd
[674.781902] Dynamic subtest bsd: SUCCESS (3.231s)
[674.795308] Starting dynamic subtest: bsd1
[678.012632] Dynamic subtest bsd1: SUCCESS (3.227s)
[678.025829] Starting dynamic subtest: bsd2
[681.247622] Dynamic subtest bsd2: SUCCESS (3.232s)
[681.260646] Starting dynamic subtest: blt
[684.482615] Dynamic subtest blt: SUCCESS (3.233s)
[684.495932] Starting dynamic subtest: vebox
[687.717557] Dynamic subtest vebox: SUCCESS (3.233s)
[687.720474] Subtest legacy: SUCCESS (22.635s)
[688.342560] [152/154] (335s left) gem_mmap_gtt (fault-concurrent)
[688.403631] Subtest fault-concurrent: SKIP (0.000s)
[688.464895] [153/154] (335s left) kms_concurrent (multi-plane-atomic-lowres)
[688.538114] Starting subtest: multi-plane-atomic-lowres
[688.540880] Starting dynamic subtest: pipe-A-eDP-1
[689.034246] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.496s)
[689.047634] Starting dynamic subtest: pipe-B-eDP-1
[690.311440] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.276s)
[690.324105] Starting dynamic subtest: pipe-C-eDP-1
[691.477293] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.164s)
[691.489273] Starting dynamic subtest: pipe-D-eDP-1
[692.757908] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.280s)
[692.760608] Subtest multi-plane-atomic-lowres: SUCCESS (4.222s)
[693.572397] [154/154] (330s left) perf (buffer-fill)
[693.656134] Starting subtest: buffer-fill
[693.659006] Starting dynamic subtest: 0-rcs0
[695.900738] Dynamic subtest 0-rcs0: SUCCESS (2.243s)
[695.912909] Starting dynamic subtest: 1-vecs0
[700.322341] Dynamic subtest 1-vecs0: SUCCESS (4.421s)
[700.325302] Subtest buffer-fill: SUCCESS (6.667s)
[700.367985] Closing watchdogs
results: parsing output: 0/ for test: i915_drm_fdinfo
results: parsing output: 1/ for test: gem_softpin
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_atomic
results: parsing output: 5/ for test: gem_exec_reloc
results: parsing output: 6/ for test: kms_psr2_sf
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: sysfs_preempt_timeout
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_wait
results: parsing output: 15/ for test: kms_async_flips
results: parsing output: 16/ for test: gem_exec_suspend
results: parsing output: 17/ for test: kms_flip_scaled_crc
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_plane
results: parsing output: 20/ for test: gem_create
results: parsing output: 21/ for test: syncobj_wait
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: device_reset
results: parsing output: 24/ for test: kms_flip
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: gem_exec_params
results: parsing output: 30/ for test: kms_cursor_crc
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: gem_exec_reloc
results: parsing output: 35/ for test: syncobj_timeline
results: parsing output: 36/ for test: gem_mmap_gtt
results: parsing output: 37/ for test: gem_mmap_gtt
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_exec_balancer
results: parsing output: 41/ for test: i915_pm_rps
results: parsing output: 42/ for test: i915_query
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_cursor_crc
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: vgem_basic
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_chamelium_hpd
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_dsc
results: parsing output: 54/ for test: syncobj_wait
results: parsing output: 55/ for test: gem_exec_balancer
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: gem_userptr_blits
results: parsing output: 61/ for test: kms_plane_scaling
results: parsing output: 62/ for test: kms_cursor_crc
results: parsing output: 63/ for test: gem_close
results: parsing output: 64/ for test: kms_pipe_stress
results: parsing output: 65/ for test: gem_exec_schedule
results: parsing output: 66/ for test: gem_busy
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_softpin
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_chamelium_audio
results: parsing output: 71/ for test: i915_drm_fdinfo
results: parsing output: 72/ for test: gem_exec_reloc
results: parsing output: 73/ for test: syncobj_wait
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_lease
results: parsing output: 76/ for test: kms_ccs
results: parsing output: 77/ for test: perf
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: syncobj_wait
results: parsing output: 80/ for test: gem_mmap_wc
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: gem_exec_flush
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gen9_exec_parse
results: parsing output: 85/ for test: kms_flip
results: parsing output: 86/ for test: kms_getfb
results: parsing output: 87/ for test: kms_content_protection
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: gem_softpin
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_lease
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_plane_scaling
results: parsing output: 98/ for test: kms_invalid_mode
results: parsing output: 99/ for test: kms_flip
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_psr2_sf
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: api_intel_allocator
results: parsing output: 106/ for test: gem_lmem_swapping
results: parsing output: 107/ for test: i915_query
results: parsing output: 108/ for test: gem_ctx_persistence
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: api_intel_bb
results: parsing output: 111/ for test: kms_busy
results: parsing output: 112/ for test: gem_ctx_freq
results: parsing output: 113/ for test: kms_plane_multiple
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: kms_cursor_legacy
results: parsing output: 116/ for test: gem_exec_params
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: gem_ctx_param
results: parsing output: 120/ for test: kms_prop_blob
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_ccs
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_rotation_crc
results: parsing output: 125/ for test: gem_sync
results: parsing output: 126/ for test: syncobj_wait
results: parsing output: 127/ for test: gem_exec_whisper
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_pread
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: kms_psr
results: parsing output: 134/ for test: gem_eio
results: parsing output: 135/ for test: perf_pmu
results: parsing output: 136/ for test: perf
results: parsing output: 137/ for test: gem_tiled_wb
results: parsing output: 138/ for test: kms_display_modes
results: parsing output: 139/ for test: kms_vblank
results: parsing output: 140/ for test: gem_exec_fence
results: parsing output: 141/ for test: gem_exec_schedule
results: parsing output: 142/ for test: kms_universal_plane
results: parsing output: 143/ for test: prime_busy
results: parsing output: 144/ for test: syncobj_timeline
results: parsing output: 145/ for test: gem_render_copy
results: parsing output: 146/ for test: gem_exec_params
results: parsing output: 147/ for test: kms_chamelium_edid
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: gem_spin_batch
results: parsing output: 151/ for test: gem_mmap_gtt
results: parsing output: 152/ for test: kms_concurrent
results: parsing output: 153/ for test: perf
Done.