[43.786027] Initializing watchdogs
[43.786095]   /dev/watchdog0
[43.802432] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[43.808389] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[43.810911] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[43.812765] [001/156] (960s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-pwrite)
[43.913251] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-pwrite
[43.921824] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[44.019404] [002/156] (960s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[44.120363] Starting subtest: yf-tiled-16bpp-rotate-270
[44.121757] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[44.205310] [003/156] (960s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[44.294072] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[44.294851] Starting dynamic subtest: pipe-A-HDMI-A-1
[44.301888] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[44.309671] Starting dynamic subtest: pipe-B-HDMI-A-1
[44.316806] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[44.324456] Starting dynamic subtest: pipe-C-HDMI-A-1
[44.331466] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[44.339401] Starting dynamic subtest: pipe-D-HDMI-A-1
[44.346591] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[44.348025] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[44.541612] [004/156] (959s left) kms_plane_multiple (tiling-yf)
[44.637641] Starting subtest: tiling-yf
[44.638997] Subtest tiling-yf: SKIP (0.000s)
[44.689525] [005/156] (959s left) sw_sync (sync_busy_fork_unixsocket)
[44.722591] Starting subtest: sync_busy_fork_unixsocket
[44.732036] Subtest sync_busy_fork_unixsocket: SUCCESS (0.009s)
[44.813791] [006/156] (959s left) kms_pm_backlight (fade-with-suspend)
[44.901277] Subtest fade-with-suspend: SKIP (0.000s)
[44.937543] [007/156] (959s left) perf (polling)
[45.023925] Starting subtest: polling
[45.024668] Starting dynamic subtest: 0-rcs0
[55.079092] Dynamic subtest 0-rcs0: SUCCESS (10.074s)
[55.080139] Subtest polling: SUCCESS (10.075s)
[55.167977] [008/156] (949s left) gem_exec_fence (basic-busy-all)
[55.221592] Starting subtest: basic-busy-all
[55.275687] Subtest basic-busy-all: SUCCESS (0.054s)
[55.875833] [FACT gem_exec_fence (basic-busy-all)] new: kernel.kmod_is_loaded.vgem: true
[55.878526] [009/156] (948s left) gem_userptr_blits (sync-unmap-after-close)
[55.923203] Starting subtest: sync-unmap-after-close
[55.941742] Subtest sync-unmap-after-close: SUCCESS (0.018s)
[56.060862] [010/156] (948s left) api_intel_bb (blit-noreloc-keep-cache)
[56.093595] Starting subtest: blit-noreloc-keep-cache
[56.100062] Subtest blit-noreloc-keep-cache: SUCCESS (0.007s)
[56.227921] [011/156] (948s left) fbdev (info)
[56.258373] Starting subtest: info
[56.259093] Subtest info: SUCCESS (0.000s)
[56.327018] [012/156] (948s left) kms_psr (pr-cursor-mmap-cpu)
[56.416396] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[56.459324] [013/156] (948s left) gem_partial_pwrite_pread (write-uncached)
[56.496917] Starting subtest: write-uncached
[67.026360] Subtest write-uncached: SUCCESS (10.545s)
[67.640209] [014/156] (937s left) kms_invalid_mode (clock-too-high)
[67.762302] Starting subtest: clock-too-high
[67.763220] Starting dynamic subtest: pipe-A-HDMI-A-1
[67.833556] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.072s)
[67.843056] Starting dynamic subtest: pipe-B-HDMI-A-1
[67.845986] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.010s)
[67.854936] Starting dynamic subtest: pipe-C-HDMI-A-1
[67.858152] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.010s)
[67.868046] Starting dynamic subtest: pipe-D-HDMI-A-1
[67.870796] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.012s)
[67.871659] Subtest clock-too-high: SUCCESS (0.110s)
[68.069124] [015/156] (936s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[68.174397] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[68.175807] Subtest hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[68.262939] [016/156] (936s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-blt)
[68.355905] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-blt
[68.357264] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[68.458697] [017/156] (936s left) i915_suspend (fence-restore-tiled2untiled)
[68.492089] Starting subtest: fence-restore-tiled2untiled
[88.479170] Subtest fence-restore-tiled2untiled: SUCCESS (5.296s)
[94.559941] [018/156] (916s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[94.611195] Starting subtest: stress-mm-invalidate-close-overlap
[96.751740] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[96.860148] [019/156] (914s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[96.961587] Starting subtest: protected-encrypted-src-copy-not-readible
[97.046810] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.087s)
[97.160597] [020/156] (914s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[97.258294] Starting subtest: cursor-rapid-movement-512x512
[97.259699] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[97.363361] [021/156] (913s left) kms_cursor_crc (cursor-alpha-transparent)
[97.451943] Starting subtest: cursor-alpha-transparent
[97.452742] Starting dynamic subtest: pipe-A-HDMI-A-1
[97.737341] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.287s)
[97.747316] Starting dynamic subtest: pipe-D-HDMI-A-1
[97.987378] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.250s)
[97.988930] Subtest cursor-alpha-transparent: SUCCESS (0.539s)
[98.150398] [022/156] (913s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[98.242743] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[98.243511] Starting dynamic subtest: pipe-A-HDMI-A-1
[98.251243] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[98.260775] Starting dynamic subtest: pipe-B-HDMI-A-1
[98.268720] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[98.278700] Starting dynamic subtest: pipe-C-HDMI-A-1
[98.286233] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[98.295136] Starting dynamic subtest: pipe-D-HDMI-A-1
[98.303475] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[98.305009] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SKIP (0.004s)
[98.497609] [023/156] (912s left) prime_busy (before)
[98.534001] Starting subtest: before
[98.538445] Starting dynamic subtest: rcs0
[98.570042] Dynamic subtest rcs0: SUCCESS (0.031s)
[98.585984] Starting dynamic subtest: bcs0
[98.586857] Dynamic subtest bcs0: SUCCESS (0.016s)
[98.595182] Starting dynamic subtest: vcs0
[98.600616] Dynamic subtest vcs0: SUCCESS (0.014s)
[98.607867] Starting dynamic subtest: vcs1
[98.617061] Dynamic subtest vcs1: SUCCESS (0.016s)
[98.625337] Starting dynamic subtest: vecs0
[98.631676] Dynamic subtest vecs0: SUCCESS (0.014s)
[98.748590] Subtest before: SUCCESS (0.206s)
[98.817382] [024/156] (912s left) gem_exec_balancer (hang)
[98.978897] Starting subtest: hang
[100.277991] Subtest hang: SUCCESS (1.314s)
[100.361264] [025/156] (911s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite)
[100.457059] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite
[100.458475] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[100.543353] [026/156] (910s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[100.636128] Starting subtest: pipe-fbc-rte
[100.640190] Subtest pipe-fbc-rte: SKIP (0.000s)
[100.740159] [027/156] (910s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[100.831817] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[100.833161] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[100.929700] [028/156] (910s left) gem_gpgpu_fill (basic)
[100.965110] Starting subtest: basic
[100.965820] Starting dynamic subtest: smem
[100.969560] Dynamic subtest smem: SUCCESS (0.005s)
[100.970281] Subtest basic: SUCCESS (0.005s)
[101.098599] [029/156] (910s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[101.185033] Starting subtest: psr-dirtyfb-ioctl
[101.188951] Subtest psr-dirtyfb-ioctl: SKIP (0.000s)
[101.286463] [030/156] (910s left) kms_plane_alpha_blend (alpha-opaque-fb)
[101.374160] Starting subtest: alpha-opaque-fb
[101.438740] Starting dynamic subtest: pipe-A-HDMI-A-1
[101.702042] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.264s)
[101.713719] Starting dynamic subtest: pipe-D-HDMI-A-1
[102.039309] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.337s)
[102.040055] Subtest alpha-opaque-fb: SUCCESS (0.668s)
[102.174458] [031/156] (909s left) gem_exec_schedule (wide)
[102.347234] Starting subtest: wide
[102.348401] Starting dynamic subtest: rcs0
[112.401163] Dynamic subtest rcs0: SUCCESS (10.042s)
[112.409789] Starting dynamic subtest: bcs0
[123.784521] Dynamic subtest bcs0: SUCCESS (11.393s)
[123.794857] Starting dynamic subtest: vcs0
[134.828425] Dynamic subtest vcs0: SUCCESS (11.064s)
[134.841859] Starting dynamic subtest: vcs1
[146.307432] Dynamic subtest vcs1: SUCCESS (11.456s)
[146.317863] Starting dynamic subtest: vecs0
[158.083874] Dynamic subtest vecs0: SUCCESS (11.778s)
[158.084741] Subtest wide: SUCCESS (55.736s)
[160.142005] [032/156] (851s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[160.234751] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[160.236084] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[160.343462] [033/156] (851s left) gem_mmap_offset (mmap-boundaries)
[160.375860] Starting subtest: mmap-boundaries
[160.376578] Starting dynamic subtest: smem0
[160.642971] Dynamic subtest smem0: SUCCESS (0.267s)
[160.643801] Subtest mmap-boundaries: SUCCESS (0.268s)
[160.762280] [034/156] (851s left) gem_exec_fence (submit-chain)
[160.923424] Starting subtest: submit-chain
[160.936427] Subtest submit-chain: SUCCESS (0.013s)
[161.412631] [035/156] (850s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[161.503306] Starting subtest: primary-y-tiled-reflect-x-0
[166.497402] Subtest primary-y-tiled-reflect-x-0: SUCCESS (4.996s)
[166.711367] [036/156] (845s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[166.810757] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-mmap-wc
[166.812098] Subtest psrhdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[166.909715] [037/156] (844s left) gem_exec_params (invalid-ring2)
[166.947862] Starting subtest: invalid-ring2
[166.948591] Subtest invalid-ring2: SUCCESS (0.000s)
[167.040231] [038/156] (844s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-onoff)
[167.132089] Starting subtest: hdr-1p-primscrn-cur-indfb-onoff
[167.133493] Subtest hdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[167.220616] [039/156] (844s left) gem_userptr_blits (sync-overlap)
[167.265235] Starting subtest: sync-overlap
[167.265964] Subtest sync-overlap: SUCCESS (0.000s)
[167.375292] [040/156] (844s left) kms_flip (flip-vs-panning-vs-hang)
[167.462082] Starting subtest: flip-vs-panning-vs-hang
[167.463696] Starting dynamic subtest: A-HDMI-A1
[206.291053] Dynamic subtest A-HDMI-A1: SUCCESS (38.813s)
[206.298677] Starting dynamic subtest: D-HDMI-A1
[245.203358] Dynamic subtest D-HDMI-A1: SUCCESS (38.901s)
[245.204146] Subtest flip-vs-panning-vs-hang: SUCCESS (77.719s)
[245.341270] [041/156] (766s left) i915_pm_freq_api (freq-reset-multiple)
[245.379919] Subtest freq-reset-multiple: SKIP (0.000s)
[245.426383] [042/156] (766s left) gem_exec_fence (syncobj-timeline-wait)
[245.873334] Starting subtest: syncobj-timeline-wait
[245.891207] Subtest syncobj-timeline-wait: SUCCESS (0.027s)
[246.086317] [043/156] (766s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[246.175431] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[246.176897] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[246.241872] [044/156] (765s left) syncobj_timeline (invalid-query-illegal-handle)
[246.283736] Starting subtest: invalid-query-illegal-handle
[246.284537] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[246.354890] [045/156] (765s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-render)
[246.446143] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-render
[246.447599] Subtest fbchdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[246.530097] [046/156] (765s left) vgem_basic (mmap)
[246.571259] Starting subtest: mmap
[246.577947] Subtest mmap: SUCCESS (0.008s)
[246.629793] [047/156] (765s left) kms_flip (bo-too-big-interruptible)
[246.722782] Starting subtest: bo-too-big-interruptible
[246.725398] Starting dynamic subtest: A-HDMI-A1
[247.054934] Dynamic subtest A-HDMI-A1: SUCCESS (0.329s)
[247.069840] Starting dynamic subtest: B-HDMI-A1
[247.363740] Dynamic subtest B-HDMI-A1: SUCCESS (0.304s)
[247.376342] Starting dynamic subtest: C-HDMI-A1
[247.667595] Dynamic subtest C-HDMI-A1: SUCCESS (0.303s)
[247.679224] Starting dynamic subtest: D-HDMI-A1
[247.983427] Dynamic subtest D-HDMI-A1: SUCCESS (0.312s)
[247.984177] Subtest bo-too-big-interruptible: SUCCESS (1.259s)
[248.177373] [048/156] (764s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[248.274996] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[248.276385] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[248.372500] [049/156] (764s left) gem_ctx_isolation (dirty-switch)
[248.413368] Starting subtest: dirty-switch
[248.414072] Starting dynamic subtest: rcs0
[248.598657] Dynamic subtest rcs0: SUCCESS (0.176s)
[248.606550] Starting dynamic subtest: bcs0
[248.809280] Dynamic subtest bcs0: SUCCESS (0.210s)
[248.817593] Starting dynamic subtest: vcs0
[249.027130] Dynamic subtest vcs0: SUCCESS (0.217s)
[249.035117] Starting dynamic subtest: vcs1
[249.252625] Dynamic subtest vcs1: SUCCESS (0.225s)
[249.260587] Starting dynamic subtest: vecs0
[249.460499] Dynamic subtest vecs0: SUCCESS (0.208s)
[249.461297] Subtest dirty-switch: SUCCESS (1.039s)
[249.629866] [050/156] (762s left) api_intel_bb (reset-bb)
[249.663103] Starting subtest: reset-bb
[249.665168] Subtest reset-bb: SUCCESS (0.003s)
[249.771604] [051/156] (762s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[249.863429] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[249.864132] Starting dynamic subtest: pipe-A-HDMI-A-1
[249.882117] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[249.890401] Starting dynamic subtest: pipe-B-HDMI-A-1
[249.908209] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[249.916499] Starting dynamic subtest: pipe-C-HDMI-A-1
[249.933674] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[249.941962] Starting dynamic subtest: pipe-D-HDMI-A-1
[249.960768] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.002s)
[249.962193] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.012s)
[250.125503] [052/156] (762s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[250.222142] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[250.223535] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[250.331255] [053/156] (762s left) kms_flip (busy-flip)
[250.419365] Starting subtest: busy-flip
[250.421406] Starting dynamic subtest: A-HDMI-A1
[251.101855] Dynamic subtest A-HDMI-A1: SUCCESS (0.680s)
[251.113087] Starting dynamic subtest: B-HDMI-A1
[251.766448] Dynamic subtest B-HDMI-A1: SUCCESS (0.661s)
[251.776376] Starting dynamic subtest: C-HDMI-A1
[252.440585] Dynamic subtest C-HDMI-A1: SUCCESS (0.669s)
[252.455355] Starting dynamic subtest: D-HDMI-A1
[253.102976] Dynamic subtest D-HDMI-A1: SUCCESS (0.664s)
[253.105363] Subtest busy-flip: SUCCESS (2.687s)
[253.269835] [054/156] (759s left) kms_lease (setcrtc-implicit-plane)
[253.363455] Starting subtest: setcrtc-implicit-plane
[253.364145] Starting dynamic subtest: pipe-A-HDMI-A-1
[253.559946] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.195s)
[253.568770] Starting dynamic subtest: pipe-B-HDMI-A-1
[253.743274] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.183s)
[253.753297] Starting dynamic subtest: pipe-C-HDMI-A-1
[253.917700] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.172s)
[253.930233] Starting dynamic subtest: pipe-D-HDMI-A-1
[254.093863] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.175s)
[254.095612] Subtest setcrtc-implicit-plane: SUCCESS (0.732s)
[254.244113] [055/156] (758s left) gem_ctx_engines (independent)
[254.289693] Starting subtest: independent
[254.290467] Starting dynamic subtest: rcs0
[254.363081] Dynamic subtest rcs0: SUCCESS (0.073s)
[254.371311] Starting dynamic subtest: bcs0
[254.433544] Dynamic subtest bcs0: SUCCESS (0.070s)
[254.441984] Starting dynamic subtest: vcs0
[254.504895] Dynamic subtest vcs0: SUCCESS (0.071s)
[254.513760] Starting dynamic subtest: vcs1
[254.576760] Dynamic subtest vcs1: SUCCESS (0.071s)
[254.586057] Starting dynamic subtest: vecs0
[254.648519] Dynamic subtest vecs0: SUCCESS (0.071s)
[254.659410] Starting dynamic subtest: all-engines
[254.840835] Dynamic subtest all-engines: SUCCESS (0.185s)
[254.841650] Subtest independent: SUCCESS (0.545s)
[255.018134] [056/156] (757s left) kms_flip (flip-vs-rmfb-interruptible)
[255.113766] Starting subtest: flip-vs-rmfb-interruptible
[255.116809] Starting dynamic subtest: A-HDMI-A1
[262.800453] Dynamic subtest A-HDMI-A1: SUCCESS (7.685s)
[262.818567] Starting dynamic subtest: B-HDMI-A1
[270.462655] Dynamic subtest B-HDMI-A1: SUCCESS (7.661s)
[270.480409] Starting dynamic subtest: C-HDMI-A1
[278.126560] Dynamic subtest C-HDMI-A1: SUCCESS (7.663s)
[278.143075] Starting dynamic subtest: D-HDMI-A1
[285.801037] Dynamic subtest D-HDMI-A1: SUCCESS (7.673s)
[285.806736] Subtest flip-vs-rmfb-interruptible: SUCCESS (30.700s)
[285.968938] [057/156] (726s left) gem_madvise (dontneed-before-pwrite)
[286.010360] Starting subtest: dontneed-before-pwrite
[286.013009] Subtest dontneed-before-pwrite: SUCCESS (0.002s)
[286.127225] [058/156] (726s left) gem_exec_schedule (preempt)
[286.172653] Starting subtest: preempt
[286.173446] Starting dynamic subtest: rcs0
[286.191192] Dynamic subtest rcs0: SUCCESS (0.018s)
[286.201791] Starting dynamic subtest: bcs0
[286.210487] Dynamic subtest bcs0: SUCCESS (0.018s)
[286.221441] Starting dynamic subtest: vcs0
[286.230171] Dynamic subtest vcs0: SUCCESS (0.018s)
[286.240632] Starting dynamic subtest: vcs1
[286.249181] Dynamic subtest vcs1: SUCCESS (0.018s)
[286.259535] Starting dynamic subtest: vecs0
[286.268020] Dynamic subtest vecs0: SUCCESS (0.018s)
[286.268781] Subtest preempt: SUCCESS (0.096s)
[286.571654] [059/156] (726s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[286.663725] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[286.664449] Starting dynamic subtest: pipe-A-valid-mode
[287.941452] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.277s)
[287.942230] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SUCCESS (1.279s)
[288.109630] [060/156] (724s left) i915_pm_rc6_residency (rc6-fence)
[288.145373] Starting subtest: rc6-fence
[288.149039] Starting dynamic subtest: gt0
[306.426412] Dynamic subtest gt0: SUCCESS (18.260s)
[306.427742] Subtest rc6-fence: SUCCESS (18.266s)
[306.477342] [061/156] (706s left) tools_test (tools_test)
[306.513784] Starting subtest: tools_test
[306.585664] Subtest tools_test: SUCCESS (0.075s)
[306.640744] [062/156] (706s left) kms_psr (pr-no-drrs)
[306.732897] Subtest pr-no-drrs: SKIP (0.000s)
[306.778736] [063/156] (706s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[306.867977] Subtest psr2-overlay-plane-update-continuous-sf: SKIP (0.000s)
[306.915192] [064/156] (706s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[306.950888] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[306.951652] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[307.020351] [065/156] (706s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[307.120960] Starting subtest: y-tiled-64bpp-rotate-270
[307.168377] Subtest y-tiled-64bpp-rotate-270: SKIP (0.048s)
[307.278543] [066/156] (705s left) kms_scaling_modes (scaling-mode-center)
[307.371072] Starting subtest: scaling-mode-center
[307.375252] Subtest scaling-mode-center: SKIP (0.001s)
[307.432261] [067/156] (705s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[307.522601] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[307.568845] [068/156] (705s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[307.667378] Starting subtest: x-tiled-8bpp-rotate-180
[308.644554] Subtest x-tiled-8bpp-rotate-180: SUCCESS (0.977s)
[308.774369] [069/156] (704s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-blt)
[308.871401] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-blt
[308.872860] Subtest psrhdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[308.975931] [070/156] (704s left) kms_frontbuffer_tracking (hdr-1p-primscrn-shrfb-plflip-blt)
[309.069058] Starting subtest: hdr-1p-primscrn-shrfb-plflip-blt
[309.070436] Subtest hdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[309.176787] [071/156] (704s left) gem_mmap_gtt (big-copy-odd)
[309.210855] Starting subtest: big-copy-odd
[316.453058] Subtest big-copy-odd: SUCCESS (7.245s)
[316.522852] [072/156] (696s left) kms_async_flips (alternate-sync-async-flip-atomic)
[316.666002] Starting subtest: alternate-sync-async-flip-atomic
[316.787970] Starting dynamic subtest: pipe-A-HDMI-A-1
[318.900357] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.103s)
[319.031331] Starting dynamic subtest: pipe-B-HDMI-A-1
[321.100028] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.068s)
[321.221246] Starting dynamic subtest: pipe-C-HDMI-A-1
[323.302732] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.081s)
[323.431070] Starting dynamic subtest: pipe-D-HDMI-A-1
[325.500456] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.071s)
[325.501243] Subtest alternate-sync-async-flip-atomic: SUCCESS (8.824s)
[325.762062] [073/156] (687s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[325.859665] Starting subtest: crc-primary-basic-yf-tiled-ccs
[325.860383] Starting dynamic subtest: pipe-A-HDMI-A-1
[325.867259] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[325.876718] Starting dynamic subtest: pipe-B-HDMI-A-1
[325.883606] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[325.892925] Starting dynamic subtest: pipe-C-HDMI-A-1
[325.899740] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[325.908774] Starting dynamic subtest: pipe-D-HDMI-A-1
[325.915685] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[325.917100] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.009s)
[326.134248] [074/156] (687s left) gem_softpin (allocator-evict)
[326.177626] Starting subtest: allocator-evict
[326.178555] Starting dynamic subtest: rcs0
[349.812413] Dynamic subtest rcs0: SUCCESS (23.629s)
[349.826965] Starting dynamic subtest: bcs0
[372.939945] Dynamic subtest bcs0: SUCCESS (23.124s)
[372.951518] Starting dynamic subtest: vcs0
[396.068952] Dynamic subtest vcs0: SUCCESS (23.128s)
[396.079975] Starting dynamic subtest: vcs1
[419.087323] Dynamic subtest vcs1: SUCCESS (23.019s)
[419.098050] Starting dynamic subtest: vecs0
[442.142724] Dynamic subtest vecs0: SUCCESS (23.057s)
[442.143468] Subtest allocator-evict: SUCCESS (115.963s)
[442.227158] [075/156] (571s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[442.371762] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[442.373235] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[442.466031] [076/156] (571s left) gem_mmap_wc (write-wc-read-gtt)
[442.499590] Starting subtest: write-wc-read-gtt
[442.811714] Subtest write-wc-read-gtt: SUCCESS (0.304s)
[442.896427] [077/156] (570s left) kms_chamelium_hpd (vga-hpd)
[443.042369] Subtest vga-hpd: SKIP (0.000s)
[443.144791] [078/156] (570s left) kms_fb_coherency (memset-crc)
[443.241830] Starting subtest: memset-crc
[443.242629] Starting dynamic subtest: mmap-gtt
[443.507989] Dynamic subtest mmap-gtt: SUCCESS (0.266s)
[443.585386] Starting dynamic subtest: mmap-offset-wc
[443.805188] Dynamic subtest mmap-offset-wc: SUCCESS (0.228s)
[443.885174] Starting dynamic subtest: mmap-offset-uc
[444.434878] Dynamic subtest mmap-offset-uc: SUCCESS (0.562s)
[444.503813] Starting dynamic subtest: mmap-legacy-wc
[444.701255] Dynamic subtest mmap-legacy-wc: SUCCESS (0.209s)
[444.769368] Subtest memset-crc: SUCCESS (1.527s)
[444.942349] [079/156] (568s left) kms_vblank (wait-busy)
[445.041287] Starting subtest: wait-busy
[445.043631] Starting dynamic subtest: pipe-A-HDMI-A-1
[446.316737] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.273s)
[446.328986] Starting dynamic subtest: pipe-D-HDMI-A-1
[447.580751] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.260s)
[447.581803] Subtest wait-busy: SUCCESS (2.540s)
[447.762849] [080/156] (565s left) sw_sync (sync_busy)
[447.807202] Starting subtest: sync_busy
[447.809969] Subtest sync_busy: SUCCESS (0.003s)
[447.866470] [081/156] (565s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[447.982197] Starting subtest: 4-tiled-32bpp-rotate-270
[447.983673] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.000s)
[448.078367] [082/156] (565s left) kms_getfb (getfb-handle-valid)
[448.168762] Starting subtest: getfb-handle-valid
[448.169503] Subtest getfb-handle-valid: SUCCESS (0.000s)
[448.261343] [083/156] (565s left) kms_psr (fbc-pr-sprite-render)
[448.350981] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[448.399093] [084/156] (565s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[448.434745] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[448.553023] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.109s)
[448.622682] [085/156] (565s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[448.723159] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[448.724578] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[448.820375] [086/156] (565s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-blt)
[448.913138] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-blt
[448.914563] Subtest fbchdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[449.001789] [087/156] (565s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[449.099456] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[449.764300] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.664s)
[449.887281] [088/156] (564s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[449.980537] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[451.155905] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (1.176s)
[451.285587] [089/156] (562s left) kms_flip (nonexisting-fb)
[451.386363] Starting subtest: nonexisting-fb
[451.388995] Starting dynamic subtest: A-HDMI-A1
[451.571022] Dynamic subtest A-HDMI-A1: SUCCESS (0.181s)
[451.582389] Starting dynamic subtest: B-HDMI-A1
[451.726195] Dynamic subtest B-HDMI-A1: SUCCESS (0.154s)
[451.738405] Starting dynamic subtest: C-HDMI-A1
[451.897990] Dynamic subtest C-HDMI-A1: SUCCESS (0.170s)
[451.909056] Starting dynamic subtest: D-HDMI-A1
[452.063811] Dynamic subtest D-HDMI-A1: SUCCESS (0.164s)
[452.068606] Subtest nonexisting-fb: SUCCESS (0.682s)
[452.314534] [090/156] (561s left) kms_big_fb (linear-32bpp-rotate-90)
[452.413781] Starting subtest: linear-32bpp-rotate-90
[452.490479] Subtest linear-32bpp-rotate-90: SKIP (0.076s)
[452.606600] [091/156] (561s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-blt)
[452.699382] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-blt
[452.700846] Subtest fbchdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[452.796703] [092/156] (561s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[452.889991] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[452.891444] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[453.000929] [093/156] (561s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-mmap-wc)
[453.094060] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-mmap-wc
[453.095553] Subtest fbchdr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[453.198739] [094/156] (561s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-pwrite)
[453.291754] Starting subtest: psrhdr-rgb101010-draw-pwrite
[453.293092] Subtest psrhdr-rgb101010-draw-pwrite: SKIP (0.000s)
[453.420109] [095/156] (560s left) kms_plane_scaling (planes-downscale-factor-0-75)
[453.508726] Starting subtest: planes-downscale-factor-0-75
[453.509534] Starting dynamic subtest: pipe-A
[453.642455] Dynamic subtest pipe-A: SUCCESS (0.133s)
[453.653020] Starting dynamic subtest: pipe-B
[453.794199] Dynamic subtest pipe-B: SUCCESS (0.151s)
[453.805214] Starting dynamic subtest: pipe-C
[453.928533] Dynamic subtest pipe-C: SUCCESS (0.133s)
[453.947964] Starting dynamic subtest: pipe-D
[454.069762] Dynamic subtest pipe-D: SUCCESS (0.140s)
[454.070454] Subtest planes-downscale-factor-0-75: SUCCESS (0.562s)
[454.268984] [096/156] (560s left) gem_softpin (evict-active-interruptible)
[454.312293] Starting subtest: evict-active-interruptible
[454.316830] Subtest evict-active-interruptible: SUCCESS (0.004s)
[454.439892] [097/156] (560s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[454.531190] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[454.532728] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[454.630525] [098/156] (559s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[454.718877] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[454.763774] [099/156] (559s left) kms_pm_rpm (package-g7)
[456.167804] Starting subtest: package-g7
[456.170053] Subtest package-g7: SKIP (0.000s)
[456.374467] [100/156] (558s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[456.470120] Starting subtest: cursor-tearing-framebuffer-change
[456.472018] Starting dynamic subtest: pipe-A-HDMI-A-1
[456.735745] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.264s)
[456.748213] Starting dynamic subtest: pipe-D-HDMI-A-1
[456.959959] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.222s)
[456.960742] Subtest cursor-tearing-framebuffer-change: SUCCESS (0.489s)
[457.107092] [101/156] (557s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[457.201545] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[458.383284] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (1.182s)
[458.499269] [102/156] (556s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-pwrite)
[458.615039] Starting subtest: fbchdr-rgb101010-draw-pwrite
[458.616401] Subtest fbchdr-rgb101010-draw-pwrite: SKIP (0.000s)
[458.713250] [103/156] (556s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[458.806176] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[458.815735] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.009s)
[458.880352] [104/156] (555s left) gem_exec_flush (basic-wb-prw-default)
[458.923954] Starting subtest: basic-wb-prw-default
[464.349895] Subtest basic-wb-prw-default: SUCCESS (5.428s)
[464.578665] [105/156] (550s left) gem_mmap_wc (read)
[464.613255] Starting subtest: read
[464.619858] Subtest read: SUCCESS (0.008s)
[464.723737] [106/156] (550s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[464.820138] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[464.821542] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[464.914482] [107/156] (550s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-blt)
[465.009069] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-blt
[465.010447] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[465.107633] [108/156] (549s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[465.203955] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[465.205424] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[465.282624] [109/156] (549s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-rte)
[465.375679] Starting subtest: fbcpsrhdr-2p-rte
[465.377026] Subtest fbcpsrhdr-2p-rte: SKIP (0.000s)
[465.449943] [110/156] (549s left) gem_exec_reloc (basic-cpu-wc)
[465.489495] Starting subtest: basic-cpu-wc
[465.494121] Subtest basic-cpu-wc: SUCCESS (0.005s)
[465.612324] [111/156] (549s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[465.647549] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[465.648254] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[465.715514] [112/156] (549s left) i915_drm_fdinfo (virtual-busy)
[465.752020] Starting subtest: virtual-busy
[468.409479] Subtest virtual-busy: SUCCESS (2.657s)
[468.476888] [113/156] (546s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[468.510934] Starting subtest: cpuset-medium-copy-XY
[478.695061] Subtest cpuset-medium-copy-XY: SUCCESS (10.185s)
[478.784075] [114/156] (536s left) kms_flip (nonblocking-read)
[478.928230] Starting subtest: nonblocking-read
[478.928940] Subtest nonblocking-read: SUCCESS (0.000s)
[479.036806] [115/156] (536s left) kms_color (invalid-ctm-matrix-sizes)
[479.125769] Starting subtest: invalid-ctm-matrix-sizes
[479.126517] Starting dynamic subtest: pipe-A
[479.129643] Dynamic subtest pipe-A: SUCCESS (0.004s)
[479.140536] Starting dynamic subtest: pipe-B
[479.141261] Dynamic subtest pipe-B: SUCCESS (0.005s)
[479.151009] Starting dynamic subtest: pipe-C
[479.151738] Dynamic subtest pipe-C: SUCCESS (0.006s)
[479.161350] Starting dynamic subtest: pipe-D
[479.162064] Dynamic subtest pipe-D: SUCCESS (0.007s)
[479.162760] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.026s)
[479.211187] [116/156] (536s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[479.306073] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[479.307564] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[479.396338] [117/156] (535s left) gem_workarounds (basic-read-fd)
[479.447085] Starting subtest: basic-read-fd
[479.455043] Subtest basic-read-fd: SUCCESS (0.008s)
[479.557434] [118/156] (535s left) kms_pm_dc (dc5-retention-flops)
[480.660908] Starting subtest: dc5-retention-flops
[480.662260] Subtest dc5-retention-flops: SKIP (0.000s)
[480.720032] [119/156] (534s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[480.813721] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[480.815203] Subtest fbcpsr-rgb101010-draw-pwrite: SKIP (0.000s)
[480.924623] [120/156] (534s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[481.023527] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[482.258232] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (1.235s)
[482.424240] [121/156] (533s left) sysfs_heartbeat_interval (invalid)
[482.463646] Starting subtest: invalid
[482.465906] Starting dynamic subtest: vecs0
[482.466664] Dynamic subtest vecs0: SUCCESS (0.000s)
[482.478627] Starting dynamic subtest: vcs0
[482.479402] Dynamic subtest vcs0: SUCCESS (0.000s)
[482.488695] Starting dynamic subtest: bcs0
[482.489424] Dynamic subtest bcs0: SUCCESS (0.000s)
[482.498615] Starting dynamic subtest: rcs0
[482.499335] Dynamic subtest rcs0: SUCCESS (0.000s)
[482.510312] Starting dynamic subtest: vcs1
[482.511028] Dynamic subtest vcs1: SUCCESS (0.000s)
[482.511730] Subtest invalid: SUCCESS (0.010s)
[482.561537] [122/156] (532s left) gem_render_copy (yf-tiled-to-vebox-linear)
[482.602502] Starting subtest: yf-tiled-to-vebox-linear
[482.603205] Starting dynamic subtest: smem
[482.669045] Dynamic subtest smem: SUCCESS (0.067s)
[482.669785] Subtest yf-tiled-to-vebox-linear: SUCCESS (0.068s)
[482.849773] [123/156] (532s left) gem_exec_balancer (bonded-chain)
[482.892156] Starting subtest: bonded-chain
[490.258521] Subtest bonded-chain: SUCCESS (7.359s)
[490.450131] [124/156] (525s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-blt)
[490.544952] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-blt
[490.546387] Subtest psrhdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[490.646949] [125/156] (525s left) drm_mm (drm_mm)
[490.682944] Starting subtest: drm_mm
[490.698341] Starting dynamic subtest: drm_test_mm_init
[490.775666] Dynamic subtest drm_test_mm_init: SUCCESS (0.076s)
[490.797433] Starting dynamic subtest: drm_test_mm_debug
[490.856838] Dynamic subtest drm_test_mm_debug: SUCCESS (0.078s)
[490.878292] Starting dynamic subtest: drm_test_mm_align32
[490.937757] Dynamic subtest drm_test_mm_align32: SUCCESS (0.078s)
[490.961389] Starting dynamic subtest: drm_test_mm_align64
[491.015665] Dynamic subtest drm_test_mm_align64: SUCCESS (0.073s)
[491.035906] Starting dynamic subtest: drm_test_mm_lowest
[491.091468] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.072s)
[491.115348] Starting dynamic subtest: drm_test_mm_highest
[491.162582] Dynamic subtest drm_test_mm_highest: SUCCESS (0.064s)
[491.165747] Subtest drm_mm: SUCCESS (0.481s)
[491.300733] [126/156] (524s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[491.336742] Starting subtest: wait-all-for-submit-delayed-submit
[491.439367] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[491.524551] [127/156] (524s left) kms_content_protection (content-type-change)
[491.622705] Starting subtest: content-type-change
[491.629134] Subtest content-type-change: SKIP (0.005s)
[491.723206] [128/156] (524s left) syncobj_wait (single-wait-submitted)
[491.758950] Starting subtest: single-wait-submitted
[491.865666] Subtest single-wait-submitted: SUCCESS (0.105s)
[491.940449] [129/156] (523s left) kms_atomic (plane-invalid-params)
[492.031778] Starting subtest: plane-invalid-params
[492.034040] Starting dynamic subtest: pipe-A-HDMI-A-1
[492.232470] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.199s)
[492.233198] Subtest plane-invalid-params: SUCCESS (0.201s)
[492.362456] [130/156] (523s left) gem_exec_schedule (smoketest)
[492.535663] Starting subtest: smoketest
[492.536631] Starting dynamic subtest: rcs0
[497.997517] Dynamic subtest rcs0: SUCCESS (5.422s)
[498.009158] Starting dynamic subtest: bcs0
[503.420253] Dynamic subtest bcs0: SUCCESS (5.423s)
[503.432626] Starting dynamic subtest: vcs0
[508.841595] Dynamic subtest vcs0: SUCCESS (5.421s)
[508.852558] Starting dynamic subtest: vcs1
[514.265189] Dynamic subtest vcs1: SUCCESS (5.423s)
[514.276315] Starting dynamic subtest: vecs0
[519.690536] Dynamic subtest vecs0: SUCCESS (5.424s)
[519.691544] Subtest smoketest: SUCCESS (27.120s)
[519.837741] [131/156] (496s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[519.935041] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[519.936417] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[520.024411] [132/156] (495s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[520.117759] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt
[520.119109] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[520.204972] [133/156] (495s left) gem_exec_balancer (parallel-ordering)
[520.367537] Subtest parallel-ordering: SKIP (0.000s)
[520.454490] [134/156] (495s left) syncobj_timeline (single-wait-all-available-submitted)
[520.488961] Starting subtest: single-wait-all-available-submitted
[520.489726] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[520.548913] [135/156] (495s left) kms_psr (psr-cursor-plane-onoff)
[520.639526] Subtest psr-cursor-plane-onoff: SKIP (0.000s)
[520.686774] [136/156] (495s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-pwrite)
[520.781258] Starting subtest: hdr-rgb101010-draw-pwrite
[520.782729] Subtest hdr-rgb101010-draw-pwrite: SKIP (0.000s)
[520.899497] [137/156] (495s left) kms_selftest (drm_plane_helper)
[520.936577] Starting subtest: drm_plane_helper
[520.940789] Starting dynamic subtest: drm_test_check_plane_state
[521.020744] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.079s)
[521.037488] Starting dynamic subtest: drm_test_check_invalid_plane_state
[521.095772] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.071s)
[521.096875] Subtest drm_plane_helper: SUCCESS (0.160s)
[521.229985] [138/156] (495s left) gem_ctx_persistence (legacy-engines-hang)
[521.268036] Starting subtest: legacy-engines-hang
[521.268810] Starting dynamic subtest: render
[521.309382] Dynamic subtest render: SUCCESS (0.040s)
[521.332077] Starting dynamic subtest: bsd1
[521.354209] Dynamic subtest bsd1: SUCCESS (0.042s)
[521.374323] Starting dynamic subtest: bsd2
[521.401413] Dynamic subtest bsd2: SUCCESS (0.044s)
[521.422301] Starting dynamic subtest: blt
[521.446348] Dynamic subtest blt: SUCCESS (0.042s)
[521.466151] Starting dynamic subtest: vebox
[521.494221] Dynamic subtest vebox: SUCCESS (0.045s)
[521.495540] Subtest legacy-engines-hang: SUCCESS (0.227s)
[521.575141] [139/156] (494s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[521.665099] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[521.667366] Starting dynamic subtest: pipe-A-HDMI-A-1
[521.674427] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[521.686223] Starting dynamic subtest: pipe-B-HDMI-A-1
[521.692794] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[521.702392] Starting dynamic subtest: pipe-C-HDMI-A-1
[521.708898] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[521.718101] Starting dynamic subtest: pipe-D-HDMI-A-1
[521.724952] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[521.726392] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SKIP (0.007s)
[521.926515] [140/156] (494s left) prime_mmap_coherency (read)
[521.964591] Starting subtest: read
[527.371934] Subtest read: SUCCESS (5.374s)
[527.450663] [141/156] (488s left) kms_frontbuffer_tracking (fbc-2p-rte)
[527.546211] Starting subtest: fbc-2p-rte
[527.547615] Subtest fbc-2p-rte: SKIP (0.000s)
[527.658975] [142/156] (488s left) perf_pmu (idle-no-semaphores)
[527.696042] Starting subtest: idle-no-semaphores
[527.696822] Starting dynamic subtest: rcs0
[528.229083] Dynamic subtest rcs0: SUCCESS (0.523s)
[528.241656] Starting dynamic subtest: bcs0
[528.744901] Dynamic subtest bcs0: SUCCESS (0.513s)
[528.764795] Starting dynamic subtest: vcs0
[529.265484] Dynamic subtest vcs0: SUCCESS (0.518s)
[529.285429] Starting dynamic subtest: vcs1
[529.791515] Dynamic subtest vcs1: SUCCESS (0.523s)
[529.811799] Starting dynamic subtest: vecs0
[530.319324] Dynamic subtest vecs0: SUCCESS (0.525s)
[530.320801] Subtest idle-no-semaphores: SUCCESS (2.616s)
[530.391576] [143/156] (486s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-pwrite)
[530.488140] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-pwrite
[530.489540] Subtest hdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[530.595943] [144/156] (485s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[530.689109] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[532.179360] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (1.491s)
[532.329563] [145/156] (484s left) perf_pmu (busy-double-start)
[532.367053] Starting subtest: busy-double-start
[532.367775] Starting dynamic subtest: rcs0
[535.915376] Dynamic subtest rcs0: SUCCESS (3.548s)
[535.929972] Starting dynamic subtest: bcs0
[539.461372] Dynamic subtest bcs0: SUCCESS (3.544s)
[539.474594] Starting dynamic subtest: vcs0
[543.005185] Dynamic subtest vcs0: SUCCESS (3.542s)
[543.019796] Starting dynamic subtest: vcs1
[546.552370] Dynamic subtest vcs1: SUCCESS (3.545s)
[546.566577] Starting dynamic subtest: vecs0
[550.094336] Dynamic subtest vecs0: SUCCESS (3.540s)
[550.095603] Subtest busy-double-start: SUCCESS (17.732s)
[550.169515] [146/156] (466s left) kms_chamelium_frames (hdmi-crc-fast)
[550.312691] Subtest hdmi-crc-fast: SKIP (0.000s)
[550.415406] [147/156] (466s left) gem_exec_reloc (basic-wc-read-active)
[550.453728] Starting subtest: basic-wc-read-active
[550.582078] Subtest basic-wc-read-active: SUCCESS (0.119s)
[550.709055] [148/156] (466s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[550.796766] Starting subtest: cursorA-vs-flipA-varying-size
[561.651252] Subtest cursorA-vs-flipA-varying-size: SUCCESS (10.856s)
[561.805399] [149/156] (454s left) gem_userptr_blits (mmap-offset-banned)
[561.856139] Starting subtest: mmap-offset-banned
[561.856932] Starting dynamic subtest: gtt
[561.857680] Dynamic subtest gtt: SUCCESS (0.000s)
[561.867747] Starting dynamic subtest: wb
[561.868459] Dynamic subtest wb: SUCCESS (0.000s)
[561.878190] Starting dynamic subtest: wc
[561.878901] Dynamic subtest wc: SUCCESS (0.000s)
[561.888167] Starting dynamic subtest: uc
[561.888877] Dynamic subtest uc: SUCCESS (0.000s)
[561.889563] Subtest mmap-offset-banned: SUCCESS (0.004s)
[561.981890] [150/156] (454s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-onoff)
[562.076479] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-onoff
[562.077916] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[562.179461] [151/156] (454s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[562.271082] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[562.272596] Subtest plane-all-modeset-transition-fencing-internal-panels: SKIP (0.000s)
[562.343425] [152/156] (454s left) gen9_exec_parse (batch-without-end)
[562.380653] Subtest batch-without-end: SKIP (0.000s)
[562.421956] [153/156] (454s left) kms_frontbuffer_tracking (fbcpsrhdr-suspend)
[562.516423] Starting subtest: fbcpsrhdr-suspend
[562.517849] Subtest fbcpsrhdr-suspend: SKIP (0.000s)
[562.622446] [154/156] (454s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[562.711991] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[562.713412] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.000s)
[562.786388] [155/156] (454s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[562.880300] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[562.881702] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[562.990754] [156/156] (454s left) kms_invalid_mode (bad-hsync-end)
[563.082259] Starting subtest: bad-hsync-end
[563.083025] Starting dynamic subtest: pipe-A-HDMI-A-1
[563.139663] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.055s)
[563.152570] Starting dynamic subtest: pipe-B-HDMI-A-1
[563.153289] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[563.162999] Starting dynamic subtest: pipe-C-HDMI-A-1
[563.163730] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[563.173933] Starting dynamic subtest: pipe-D-HDMI-A-1
[563.174703] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[563.175411] Subtest bad-hsync-end: SUCCESS (0.068s)
[563.314979] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: kms_plane_multiple
results: parsing output: 4/ for test: sw_sync
results: parsing output: 5/ for test: kms_pm_backlight
results: parsing output: 6/ for test: perf
results: parsing output: 7/ for test: gem_exec_fence
results: parsing output: 8/ for test: gem_userptr_blits
results: parsing output: 9/ for test: api_intel_bb
results: parsing output: 10/ for test: fbdev
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: gem_partial_pwrite_pread
results: parsing output: 13/ for test: kms_invalid_mode
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: i915_suspend
results: parsing output: 17/ for test: gem_userptr_blits
results: parsing output: 18/ for test: gem_pxp
results: parsing output: 19/ for test: kms_cursor_crc
results: parsing output: 20/ for test: kms_cursor_crc
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: prime_busy
results: parsing output: 23/ for test: gem_exec_balancer
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_gpgpu_fill
results: parsing output: 28/ for test: kms_dirtyfb
results: parsing output: 29/ for test: kms_plane_alpha_blend
results: parsing output: 30/ for test: gem_exec_schedule
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_mmap_offset
results: parsing output: 33/ for test: gem_exec_fence
results: parsing output: 34/ for test: kms_rotation_crc
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gem_exec_params
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_userptr_blits
results: parsing output: 39/ for test: kms_flip
results: parsing output: 40/ for test: i915_pm_freq_api
results: parsing output: 41/ for test: gem_exec_fence
results: parsing output: 42/ for test: kms_plane
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: vgem_basic
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_ctx_isolation
results: parsing output: 49/ for test: api_intel_bb
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: kms_lease
results: parsing output: 54/ for test: gem_ctx_engines
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: gem_madvise
results: parsing output: 57/ for test: gem_exec_schedule
results: parsing output: 58/ for test: kms_flip_scaled_crc
results: parsing output: 59/ for test: i915_pm_rc6_residency
results: parsing output: 60/ for test: tools_test
results: parsing output: 61/ for test: kms_psr
results: parsing output: 62/ for test: kms_psr2_sf
results: parsing output: 63/ for test: syncobj_wait
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: kms_scaling_modes
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_mmap_gtt
results: parsing output: 71/ for test: kms_async_flips
results: parsing output: 72/ for test: kms_ccs
results: parsing output: 73/ for test: gem_softpin
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_mmap_wc
results: parsing output: 76/ for test: kms_chamelium_hpd
results: parsing output: 77/ for test: kms_fb_coherency
results: parsing output: 78/ for test: kms_vblank
results: parsing output: 79/ for test: sw_sync
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: kms_getfb
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_flip
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_plane_scaling
results: parsing output: 95/ for test: gem_softpin
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_psr2_sf
results: parsing output: 98/ for test: kms_pm_rpm
results: parsing output: 99/ for test: kms_cursor_crc
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_flip
results: parsing output: 103/ for test: gem_exec_flush
results: parsing output: 104/ for test: gem_mmap_wc
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_exec_reloc
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: i915_drm_fdinfo
results: parsing output: 112/ for test: gem_mmap_gtt
results: parsing output: 113/ for test: kms_flip
results: parsing output: 114/ for test: kms_color
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: gem_workarounds
results: parsing output: 117/ for test: kms_pm_dc
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: sysfs_heartbeat_interval
results: parsing output: 121/ for test: gem_render_copy
results: parsing output: 122/ for test: gem_exec_balancer
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: drm_mm
results: parsing output: 125/ for test: syncobj_timeline
results: parsing output: 126/ for test: kms_content_protection
results: parsing output: 127/ for test: syncobj_wait
results: parsing output: 128/ for test: kms_atomic
results: parsing output: 129/ for test: gem_exec_schedule
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: gem_exec_balancer
results: parsing output: 133/ for test: syncobj_timeline
results: parsing output: 134/ for test: kms_psr
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: kms_selftest
results: parsing output: 137/ for test: gem_ctx_persistence
results: parsing output: 138/ for test: kms_ccs
results: parsing output: 139/ for test: prime_mmap_coherency
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: perf_pmu
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: perf_pmu
results: parsing output: 145/ for test: kms_chamelium_frames
results: parsing output: 146/ for test: gem_exec_reloc
results: parsing output: 147/ for test: kms_cursor_legacy
results: parsing output: 148/ for test: gem_userptr_blits
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: kms_atomic_transition
results: parsing output: 151/ for test: gen9_exec_parse
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: kms_flip_scaled_crc
results: parsing output: 154/ for test: kms_frontbuffer_tracking
results: parsing output: 155/ for test: kms_invalid_mode
Done.