[55.052610] Initializing watchdogs
[55.052703]   /dev/watchdog0
[55.061147] [001/131] (960s left) perf_pmu (rc6-all-gts)
[55.107246] Starting subtest: rc6-all-gts
[61.488213] Subtest rc6-all-gts: SUCCESS (6.379s)
[62.374618] [002/131] (953s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[62.476181] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[62.480855] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[63.580089] [003/131] (952s left) kms_lease (lease-invalid-connector)
[63.682975] Starting subtest: lease-invalid-connector
[63.685342] Starting dynamic subtest: pipe-A-eDP-1
[63.687734] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[63.694791] Starting dynamic subtest: pipe-B-eDP-1
[63.697059] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[63.703378] Starting dynamic subtest: pipe-C-eDP-1
[63.705268] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[63.712285] Starting dynamic subtest: pipe-D-eDP-1
[63.714479] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[63.716737] Subtest lease-invalid-connector: SUCCESS (0.002s)
[63.734345] [004/131] (951s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[63.836131] Starting subtest: fbc-rgb565-draw-mmap-wc
[66.731665] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (2.900s)
[66.822360] [005/131] (948s left) gem_ppgtt (flink-and-close-vma-leak)
[66.885334] Starting subtest: flink-and-close-vma-leak
[66.930982] Subtest flink-and-close-vma-leak: SUCCESS (0.045s)
[67.022197] [006/131] (948s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[67.148050] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[67.151817] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[67.271087] [007/131] (948s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[67.362572] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[67.366122] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[67.443296] [008/131] (948s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[67.552054] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[67.555786] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[67.633047] [009/131] (948s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[67.701574] Starting subtest: yf-tiled-ccs-to-x-tiled
[67.705574] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[67.865237] [010/131] (947s left) vgem_basic (sysfs)
[67.938359] Starting subtest: sysfs
[67.940848] Subtest sysfs: SUCCESS (0.000s)
[67.974190] [011/131] (947s left) gem_exec_reloc (basic-write-read)
[68.042767] Subtest basic-write-read: SKIP (0.000s)
[68.098283] [012/131] (947s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[68.212975] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[68.217377] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[68.309988] [013/131] (947s left) api_intel_allocator (fork-simple-stress)
[68.370937] Starting subtest: fork-simple-stress
[73.783913] Subtest fork-simple-stress: SUCCESS (5.414s)
[74.043200] [014/131] (941s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[74.199372] Starting subtest: 2x-flip-vs-modeset-vs-hang
[74.210417] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.011s)
[74.371395] [015/131] (941s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[74.494438] Starting subtest: fbc-psr2-primary-mmap-cpu
[74.497057] Starting dynamic subtest: eDP-1
[74.501598] Dynamic subtest eDP-1: SKIP (0.000s)
[74.506128] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s)
[74.551011] [016/131] (941s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[74.737809] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[79.922695] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (5.187s)
[80.035513] [017/131] (935s left) vgem_basic (dmabuf-fence-before)
[80.077359] Starting subtest: dmabuf-fence-before
[80.079736] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[80.112758] [018/131] (935s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[80.219435] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[80.223979] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[80.306692] [019/131] (935s left) syncobj_wait (single-wait-all-for-submit-signaled)
[80.358651] Starting subtest: single-wait-all-for-submit-signaled
[80.360865] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[80.436596] [020/131] (935s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[80.538721] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[80.543261] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[80.602873] [021/131] (935s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[80.713633] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[80.717958] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[80.790983] [022/131] (935s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[80.892793] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[80.894782] Starting dynamic subtest: pipe-A-default-mode
[81.178944] Dynamic subtest pipe-A-default-mode: SKIP (0.282s)
[81.184306] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.283s)
[81.972955] [023/131] (933s left) gen9_exec_parse (basic-rejected)
[82.040050] Subtest basic-rejected: SKIP (0.000s)
[82.098441] [024/131] (933s left) gem_exec_fence (basic-await)
[82.277586] Starting subtest: basic-await
[82.280099] Starting dynamic subtest: rcs0
[82.356428] Dynamic subtest rcs0: SUCCESS (0.079s)
[82.365169] Starting dynamic subtest: bcs0
[82.434413] Dynamic subtest bcs0: SUCCESS (0.077s)
[82.442254] Starting dynamic subtest: vcs0
[82.512407] Dynamic subtest vcs0: SUCCESS (0.078s)
[82.521964] Starting dynamic subtest: vcs1
[82.591506] Dynamic subtest vcs1: SUCCESS (0.079s)
[82.600898] Starting dynamic subtest: vecs0
[82.667749] Dynamic subtest vecs0: SUCCESS (0.076s)
[82.677458] Starting dynamic subtest: ccs0
[82.745177] Dynamic subtest ccs0: SUCCESS (0.078s)
[82.747515] Subtest basic-await: SUCCESS (0.468s)
[84.979852] [025/131] (931s left) gem_ccs (block-multicopy-inplace)
[85.042928] Starting subtest: block-multicopy-inplace
[85.047411] Subtest block-multicopy-inplace: SKIP (0.000s)
[85.137848] [026/131] (930s left) kms_flip (dpms-off-confusion-interruptible)
[85.248651] Starting subtest: dpms-off-confusion-interruptible
[85.251285] Starting dynamic subtest: A-eDP1
[93.892670] Dynamic subtest A-eDP1: SUCCESS (8.643s)
[93.902474] Starting dynamic subtest: B-eDP1
[102.553630] Dynamic subtest B-eDP1: SUCCESS (8.626s)
[102.561491] Starting dynamic subtest: C-eDP1
[111.136119] Dynamic subtest C-eDP1: SUCCESS (8.617s)
[111.145932] Starting dynamic subtest: D-eDP1
[119.757188] Dynamic subtest D-eDP1: SUCCESS (8.620s)
[119.759698] Subtest dpms-off-confusion-interruptible: SUCCESS (34.510s)
[120.902298] [027/131] (895s left) gem_mmap_offset (clear-via-pagefault)
[120.953884] Starting subtest: clear-via-pagefault
[120.956119] Starting dynamic subtest: smem0
[154.213802] Dynamic subtest smem0: SUCCESS (33.257s)
[154.215948] Subtest clear-via-pagefault: SUCCESS (33.257s)
[154.306436] [028/131] (861s left) kms_joiner (invalid-modeset-force-big-joiner)
[154.412509] Starting subtest: invalid-modeset-force-big-joiner
[154.414859] Starting dynamic subtest: big_joiner_on_last_pipe
[154.737244] Dynamic subtest big_joiner_on_last_pipe: SUCCESS (0.333s)
[154.739590] Subtest invalid-modeset-force-big-joiner: SUCCESS (0.333s)
[155.521048] [029/131] (860s left) perf (invalid-oa-metric-set-id)
[155.646399] Starting subtest: invalid-oa-metric-set-id
[155.656697] Subtest invalid-oa-metric-set-id: SUCCESS (0.010s)
[155.673984] [030/131] (860s left) syncobj_wait (invalid-reset-zero-handles)
[155.726380] Starting subtest: invalid-reset-zero-handles
[155.728833] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[155.805177] [031/131] (860s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[155.902677] Starting subtest: multiplane-rotation-cropping-top
[163.096054] Subtest multiplane-rotation-cropping-top: SUCCESS (7.193s)
[163.205308] [032/131] (852s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[163.311022] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[168.308445] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.999s)
[168.412747] [033/131] (847s left) kms_busy (basic)
[168.503128] Starting subtest: basic
[168.505543] Starting dynamic subtest: flip
[169.102404] Dynamic subtest flip: SUCCESS (0.598s)
[169.112307] Starting dynamic subtest: modeset
[172.490843] Dynamic subtest modeset: SUCCESS (3.386s)
[172.493048] Subtest basic: SUCCESS (3.985s)
[173.267680] [034/131] (842s left) sysfs_preempt_timeout (idempotent)
[173.319437] Starting subtest: idempotent
[173.321893] Starting dynamic subtest: vecs0
[173.324381] Dynamic subtest vecs0: SUCCESS (0.000s)
[173.333441] Starting dynamic subtest: ccs0
[173.335705] Dynamic subtest ccs0: SUCCESS (0.000s)
[173.343062] Starting dynamic subtest: vcs0
[173.345311] Dynamic subtest vcs0: SUCCESS (0.000s)
[173.352675] Starting dynamic subtest: bcs0
[173.354996] Dynamic subtest bcs0: SUCCESS (0.000s)
[173.362276] Starting dynamic subtest: rcs0
[173.364476] Dynamic subtest rcs0: SUCCESS (0.000s)
[173.372176] Starting dynamic subtest: vcs1
[173.374234] Dynamic subtest vcs1: SUCCESS (0.000s)
[173.376249] Subtest idempotent: SUCCESS (0.004s)
[173.407395] [035/131] (842s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[173.509971] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[173.514492] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[173.592746] [036/131] (842s left) kms_dsc (dsc-with-bpc)
[173.696070] Starting subtest: dsc-with-bpc
[173.726613] Subtest dsc-with-bpc: SKIP (0.001s)
[173.747512] [037/131] (842s left) kms_content_protection (type1)
[173.901672] Starting subtest: type1
[177.325784] Subtest type1: SKIP (3.422s)
[178.478514] [038/131] (837s left) gen7_exec_parse (basic-offset)
[178.531311] Subtest basic-offset: SKIP (0.000s)
[178.592279] [039/131] (837s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[178.704999] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[179.462150] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.759s)
[179.577787] [040/131] (836s left) kms_big_fb (linear-16bpp-rotate-180)
[179.680415] Starting subtest: linear-16bpp-rotate-180
[181.022620] Subtest linear-16bpp-rotate-180: SUCCESS (1.344s)
[181.136888] [041/131] (835s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[181.199540] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[181.201594] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[181.267590] [042/131] (835s left) gem_lmem_evict (dontneed-evict-race)
[181.308668] Subtest dontneed-evict-race: SKIP (0.000s)
[181.327545] [043/131] (835s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[181.409612] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[181.411586] Starting dynamic subtest: pipe-A-eDP-1
[181.432854] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[181.441523] Starting dynamic subtest: pipe-B-eDP-1
[181.462973] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[181.472405] Starting dynamic subtest: pipe-C-eDP-1
[181.493416] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[181.501470] Starting dynamic subtest: pipe-D-eDP-1
[181.521663] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[181.525329] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[183.539774] [044/131] (832s left) gem_mmap_gtt (cpuset-basic-small-copy)
[183.608840] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[183.655500] [045/131] (832s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-pwrite)
[183.769670] Starting subtest: psr-1p-offscren-pri-shrfb-draw-pwrite
[190.668698] Subtest psr-1p-offscren-pri-shrfb-draw-pwrite: SUCCESS (6.901s)
[190.772793] [046/131] (825s left) prime_vgem (coherency-blt)
[190.861370] Starting subtest: coherency-blt
[191.887699] Subtest coherency-blt: SUCCESS (1.025s)
[192.000400] [047/131] (824s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[192.550622] Starting subtest: syncobj-backward-timeline-chain-engines
[192.640565] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.091s)
[194.056721] [048/131] (822s left) kms_cursor_legacy (single-move)
[194.175084] Starting subtest: single-move
[194.177357] Starting dynamic subtest: pipe-A
[199.559183] Dynamic subtest pipe-A: SUCCESS (5.382s)
[199.569968] Starting dynamic subtest: pipe-B
[204.941845] Dynamic subtest pipe-B: SUCCESS (5.382s)
[204.948883] Starting dynamic subtest: pipe-C
[210.328650] Dynamic subtest pipe-C: SUCCESS (5.384s)
[210.336746] Starting dynamic subtest: pipe-D
[215.712545] Dynamic subtest pipe-D: SUCCESS (5.383s)
[215.721878] Starting dynamic subtest: all-pipes
[221.104827] Dynamic subtest all-pipes: SUCCESS (5.389s)
[221.107138] Subtest single-move: SUCCESS (26.928s)
[221.226390] [049/131] (795s left) kms_cursor_crc (cursor-random-256x85)
[221.477679] Starting subtest: cursor-random-256x85
[221.519515] Subtest cursor-random-256x85: SKIP (0.040s)
[221.671735] [050/131] (794s left) kms_atomic_interruptible (atomic-setmode)
[221.780074] Starting subtest: atomic-setmode
[221.782304] Starting dynamic subtest: pipe-A-eDP-1
[228.663391] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.882s)
[228.665328] Subtest atomic-setmode: SUCCESS (6.883s)
[229.501655] [051/131] (786s left) gem_exec_schedule (u-semaphore-resolve)
[229.582182] Starting subtest: u-semaphore-resolve
[229.615861] Subtest u-semaphore-resolve: SUCCESS (0.036s)
[229.952167] [052/131] (786s left) drm_mm (drm_mm)
[229.989137] Starting subtest: drm_mm
[229.994704] Starting dynamic subtest: drm_test_mm_init
[230.112060] Dynamic subtest drm_test_mm_init: SUCCESS (0.116s)
[230.119061] Starting dynamic subtest: drm_test_mm_debug
[230.251567] Dynamic subtest drm_test_mm_debug: SUCCESS (0.138s)
[230.258887] Starting dynamic subtest: drm_test_mm_align32
[230.384741] Dynamic subtest drm_test_mm_align32: SUCCESS (0.134s)
[230.392269] Starting dynamic subtest: drm_test_mm_align64
[230.509953] Dynamic subtest drm_test_mm_align64: SUCCESS (0.123s)
[230.518820] Starting dynamic subtest: drm_test_mm_lowest
[230.626143] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.116s)
[230.634883] Starting dynamic subtest: drm_test_mm_highest
[230.716299] Dynamic subtest drm_test_mm_highest: SUCCESS (0.090s)
[230.718724] Subtest drm_mm: SUCCESS (0.729s)
[230.860838] [053/131] (785s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[230.964420] Starting subtest: extended-modeset-hang-oldfb-with-reset
[230.966752] Starting dynamic subtest: pipe-A
[242.607285] Dynamic subtest pipe-A: SUCCESS (11.640s)
[242.618405] Starting dynamic subtest: pipe-D
[254.953113] Dynamic subtest pipe-D: SUCCESS (12.343s)
[254.955603] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.988s)
[255.716943] [054/131] (760s left) gem_exec_fence (basic-busy-all)
[255.783363] Starting subtest: basic-busy-all
[255.881179] Subtest basic-busy-all: SUCCESS (0.098s)
[257.961701] [055/131] (758s left) kms_psr (pr-primary-page-flip)
[258.060812] Starting subtest: pr-primary-page-flip
[258.065237] Subtest pr-primary-page-flip: SKIP (0.000s)
[258.114746] [056/131] (758s left) syncobj_timeline (invalid-wait-illegal-handle)
[258.166301] Starting subtest: invalid-wait-illegal-handle
[258.168636] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[258.249477] [057/131] (758s left) kms_psr (psr-sprite-plane-onoff)
[258.343836] Starting subtest: psr-sprite-plane-onoff
[258.346196] Starting dynamic subtest: eDP-1
[260.074226] Dynamic subtest eDP-1: SUCCESS (1.727s)
[260.076377] Subtest psr-sprite-plane-onoff: SUCCESS (1.728s)
[260.870089] [058/131] (755s left) syncobj_timeline (wait-any-snapshot)
[260.932614] Starting subtest: wait-any-snapshot
[261.012262] Subtest wait-any-snapshot: SUCCESS (0.081s)
[261.066989] [059/131] (755s left) kms_frontbuffer_tracking (fbc-1p-rte)
[261.173225] Starting subtest: fbc-1p-rte
[265.632613] Subtest fbc-1p-rte: SUCCESS (4.464s)
[265.772544] [060/131] (750s left) gem_partial_pwrite_pread (write-display)
[265.836249] Subtest write-display: SKIP (0.000s)
[265.880582] [061/131] (750s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[265.982472] Starting subtest: psr-rgb565-draw-mmap-cpu
[270.561063] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (4.581s)
[270.661753] [062/131] (746s left) kms_chamelium_color (ctm-0-25)
[270.762128] Subtest ctm-0-25: SKIP (0.000s)
[270.787197] [063/131] (745s left) i915_suspend (fence-restore-tiled2untiled)
[270.849590] Starting subtest: fence-restore-tiled2untiled
[270.854067] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[270.941946] [064/131] (745s left) syncobj_timeline (multi-wait-signaled)
[270.998814] Starting subtest: multi-wait-signaled
[271.001168] Subtest multi-wait-signaled: SUCCESS (0.001s)
[271.092916] [065/131] (745s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[276.082106] Starting subtest: pr-cursor-plane-move-continuous-sf
[276.086773] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.002s)
[276.914857] [066/131] (739s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[277.023993] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[281.443950] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (4.420s)
[281.578055] [067/131] (735s left) gen3_render_tiledy_blits
[281.678380] [068/131] (735s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[281.785104] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[281.787691] Starting dynamic subtest: pipe-A
[281.899164] Dynamic subtest pipe-A: SKIP (0.106s)
[281.908089] Starting dynamic subtest: pipe-B
[283.056325] Dynamic subtest pipe-B: SKIP (1.157s)
[283.067113] Starting dynamic subtest: pipe-C
[284.268323] Dynamic subtest pipe-C: SUCCESS (1.219s)
[284.278881] Starting dynamic subtest: pipe-D
[285.388071] Dynamic subtest pipe-D: SUCCESS (1.119s)
[285.390453] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.603s)
[286.558029] [069/131] (730s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[286.666105] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[286.670380] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[286.758311] [070/131] (730s left) gem_mmap_gtt (big-bo-tiledy)
[286.816522] Subtest big-bo-tiledY: SKIP (0.000s)
[286.857230] [071/131] (730s left) kms_universal_plane (universal-plane-pageflip-windowed)
[286.946098] Starting subtest: universal-plane-pageflip-windowed
[286.948426] Starting dynamic subtest: pipe-A-eDP-1
[287.541807] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.593s)
[287.551575] Starting dynamic subtest: pipe-B-eDP-1
[288.811750] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.269s)
[288.819895] Starting dynamic subtest: pipe-C-eDP-1
[290.012542] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.200s)
[290.022661] Starting dynamic subtest: pipe-D-eDP-1
[291.239777] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.225s)
[291.242387] Subtest universal-plane-pageflip-windowed: SUCCESS (4.292s)
[292.058081] [072/131] (724s left) kms_feature_discovery (display-4x)
[292.156063] Starting subtest: display-4x
[292.160186] Subtest display-4x: SKIP (0.000s)
[292.206448] [073/131] (724s left) kms_psr (psr2-cursor-plane-onoff)
[292.304916] Starting subtest: psr2-cursor-plane-onoff
[292.307217] Starting dynamic subtest: eDP-1
[294.037042] Dynamic subtest eDP-1: SUCCESS (1.731s)
[294.039487] Subtest psr2-cursor-plane-onoff: SUCCESS (1.732s)
[294.804148] [074/131] (722s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[294.901328] Starting subtest: coverage-vs-premult-vs-constant
[295.195447] Starting dynamic subtest: pipe-A-eDP-1
[295.783018] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.586s)
[295.791894] Starting dynamic subtest: pipe-D-eDP-1
[297.124236] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.340s)
[297.126702] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.222s)
[297.954638] [075/131] (719s left) gem_exec_reloc (basic-cpu-read-noreloc)
[298.012713] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[298.070471] [076/131] (718s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[298.169615] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[302.803693] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (4.637s)
[302.899040] [077/131] (714s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[303.005526] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[303.009897] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[303.091314] [078/131] (713s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[303.197676] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[303.202067] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[303.295182] [079/131] (713s left) perf_pmu (invalid-init)
[303.333346] Starting subtest: invalid-init
[303.335714] Subtest invalid-init: SUCCESS (0.000s)
[303.432438] [080/131] (713s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[303.709940] Starting subtest: cursor-rapid-movement-512x170
[303.714667] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[303.856801] [081/131] (713s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[303.951614] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[303.955391] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[305.022907] [082/131] (712s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[305.133341] Starting subtest: 4-tiled-32bpp-rotate-180
[306.388912] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.256s)
[306.504227] [083/131] (710s left) gem_userptr_blits (unsync-unmap-cycles)
[306.581479] Subtest unsync-unmap-cycles: SKIP (0.000s)
[306.690832] [084/131] (710s left) prime_mmap (test_reprime)
[306.744233] Starting subtest: test_reprime
[306.746092] Starting dynamic subtest: test_reprime-smem
[306.774376] Dynamic subtest test_reprime-smem: SUCCESS (0.032s)
[306.776502] Subtest test_reprime: SUCCESS (0.033s)
[306.859753] [085/131] (710s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[306.964942] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[306.968293] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[307.047861] [086/131] (710s left) kms_getfb (getfb-handle-closed)
[307.102734] Starting subtest: getfb-handle-closed
[307.104789] Subtest getfb-handle-closed: SUCCESS (0.000s)
[307.181677] [087/131] (710s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[307.282561] Starting subtest: plane-downscale-factor-0-75-with-rotation
[307.284633] Starting dynamic subtest: pipe-A
[307.514463] Dynamic subtest pipe-A: SUCCESS (0.231s)
[307.522811] Starting dynamic subtest: pipe-B
[308.822753] Dynamic subtest pipe-B: SUCCESS (1.307s)
[308.830985] Starting dynamic subtest: pipe-C
[310.151776] Dynamic subtest pipe-C: SUCCESS (1.328s)
[310.160841] Starting dynamic subtest: pipe-D
[311.498750] Dynamic subtest pipe-D: SUCCESS (1.346s)
[311.501107] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.216s)
[312.634908] [088/131] (704s left) perf (gen8-unprivileged-single-ctx-counters)
[312.724803] Starting subtest: gen8-unprivileged-single-ctx-counters
[312.729402] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[312.745421] [089/131] (704s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[312.849466] Starting subtest: primary-x-tiled-reflect-x-0
[319.834777] Subtest primary-x-tiled-reflect-x-0: SUCCESS (6.986s)
[320.986063] [090/131] (696s left) kms_pm_rpm (system-suspend-modeset)
[323.028064] Starting subtest: system-suspend-modeset
[342.903170] Subtest system-suspend-modeset: SUCCESS (4.364s)
[343.249314] [091/131] (689s left) kms_big_fb (linear-8bpp-rotate-90)
[343.357258] Starting subtest: linear-8bpp-rotate-90
[343.378227] Subtest linear-8bpp-rotate-90: SKIP (0.020s)
[343.492657] [092/131] (689s left) gem_ctx_persistence (process)
[343.554973] Starting subtest: process
[343.745117] Subtest process: SUCCESS (0.190s)
[343.802834] [093/131] (689s left) gem_exec_balancer (parallel-ordering)
[344.041579] Starting subtest: parallel-ordering
[344.832177] Subtest parallel-ordering: SUCCESS (0.790s)
[344.940738] [094/131] (687s left) kms_histogram (algo-basic)
[345.044226] Starting subtest: algo-basic
[345.048693] Subtest algo-basic: SKIP (0.000s)
[345.101651] [095/131] (687s left) gem_mmap_gtt (big-copy-xy)
[345.164925] Subtest big-copy-XY: SKIP (0.000s)
[345.209050] [096/131] (687s left) gem_softpin (full)
[345.262965] Starting subtest: full
[345.269521] Subtest full: SUCCESS (0.006s)
[345.390160] [097/131] (687s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[345.493677] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[350.519966] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (5.026s)
[350.657084] [098/131] (682s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[350.716033] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[350.816681] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.102s)
[350.872164] [099/131] (682s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[352.609342] Starting subtest: modeset-non-lpsp-stress-no-wait
[352.674302] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.063s)
[353.116635] [100/131] (679s left) gem_exec_reloc (basic-gtt-read-noreloc)
[353.173559] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[353.216705] [101/131] (679s left) kms_psr (fbc-pr-primary-render)
[353.316688] Starting subtest: fbc-pr-primary-render
[353.321204] Subtest fbc-pr-primary-render: SKIP (0.000s)
[353.365268] [102/131] (679s left) perf_pmu (busy-double-start)
[353.404500] Starting subtest: busy-double-start
[353.406906] Starting dynamic subtest: rcs0
[357.045171] Dynamic subtest rcs0: FAIL (3.581s)
[357.055929] Starting dynamic subtest: bcs0
[360.589704] Dynamic subtest bcs0: SUCCESS (3.601s)
[360.601571] Starting dynamic subtest: vcs0
[364.957268] Dynamic subtest vcs0: SUCCESS (4.365s)
[364.968484] Starting dynamic subtest: vcs1
[368.990440] Dynamic subtest vcs1: SUCCESS (4.030s)
[369.001531] Starting dynamic subtest: vecs0
[372.953209] Dynamic subtest vecs0: SUCCESS (3.960s)
[372.965151] Starting dynamic subtest: ccs0
[376.589417] Dynamic subtest ccs0: FAIL (3.563s)
[376.591468] Subtest busy-double-start: FAIL (23.109s)
[376.612062] [103/131] (656s left) gem_exec_flush (basic-batch-kernel-default-wb)
[376.677239] Starting subtest: basic-batch-kernel-default-wb
[382.705541] Subtest basic-batch-kernel-default-wb: SUCCESS (6.027s)
[382.878790] [104/131] (650s left) gem_exec_whisper (basic-forked)
[382.947901] Starting subtest: basic-forked
[390.753930] Subtest basic-forked: SUCCESS (7.802s)
[390.919441] [105/131] (642s left) syncobj_wait (wait-all-complex)
[390.982377] Starting subtest: wait-all-complex
[391.194836] Subtest wait-all-complex: SUCCESS (0.213s)
[391.253406] [106/131] (641s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[391.357202] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[391.359534] Starting dynamic subtest: pipe-A-eDP-1
[391.384948] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.026s)
[391.394150] Starting dynamic subtest: pipe-B-eDP-1
[391.414629] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.025s)
[391.423560] Starting dynamic subtest: pipe-C-eDP-1
[391.443434] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.025s)
[391.452056] Starting dynamic subtest: pipe-D-eDP-1
[391.471225] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.025s)
[391.473470] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.105s)
[393.585282] [107/131] (639s left) gem_eio (wait-wedge-immediate)
[393.815438] Starting subtest: wait-wedge-immediate
[395.529202] Subtest wait-wedge-immediate: SUCCESS (1.714s)
[395.669181] [108/131] (637s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[396.050621] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[396.791190] [109/131] (636s left) i915_hangman (error-state-basic)
[396.857417] Starting subtest: error-state-basic
[397.014283] Subtest error-state-basic: SUCCESS (0.156s)
[397.069784] [110/131] (636s left) syncobj_timeline (invalid-signal-zero-handles)
[397.132302] Starting subtest: invalid-signal-zero-handles
[397.134531] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[397.230380] [111/131] (635s left) gem_exec_create (madvise)
[397.294836] Starting subtest: madvise
[397.297346] Starting dynamic subtest: smem
[418.486249] Dynamic subtest smem: SUCCESS (21.186s)
[418.489247] Subtest madvise: SUCCESS (21.186s)
[419.230192] [112/131] (614s left) gem_exec_balancer (bonded-pair)
[419.286525] Starting subtest: bonded-pair
[419.291069] Subtest bonded-pair: SKIP (0.000s)
[419.561598] [113/131] (613s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[419.694811] Starting subtest: cursorB-vs-flipB-atomic-transitions
[419.699330] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[419.820515] [114/131] (613s left) kms_chamelium_hpd (vga-hpd)
[420.203954] Subtest vga-hpd: SKIP (0.000s)
[421.013607] [115/131] (612s left) drm_fdinfo (memory-info-active)
[421.059679] Starting subtest: memory-info-active
[421.062143] Starting dynamic subtest: smem0
[423.698433] Dynamic subtest smem0: SUCCESS (2.641s)
[423.700949] Subtest memory-info-active: SUCCESS (2.641s)
[423.752414] [116/131] (609s left) gem_mmap_wc (invalid-flags)
[423.818036] Subtest invalid-flags: SKIP (0.000s)
[423.870226] [117/131] (609s left) kms_vrr (flip-suspend)
[423.976799] Starting subtest: flip-suspend
[423.982258] Subtest flip-suspend: SKIP (0.000s)
[424.028513] [118/131] (609s left) gem_ctx_param (invalid-get-engines)
[424.071758] Starting subtest: invalid-get-engines
[424.073834] Subtest invalid-get-engines: SUCCESS (0.001s)
[424.156241] [119/131] (609s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[424.257899] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[424.261547] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[424.342969] [120/131] (609s left) gem_pxp (create-regular-buffer)
[424.468707] Starting subtest: create-regular-buffer
[424.470785] Subtest create-regular-buffer: SUCCESS (0.000s)
[424.554287] [121/131] (608s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[424.654243] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[424.657620] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[424.755019] [122/131] (608s left) gem_exec_parallel (engines)
[424.806728] Starting subtest: engines
[424.808814] Starting dynamic subtest: basic
[426.453452] Dynamic subtest basic: SUCCESS (1.644s)
[426.465477] Starting dynamic subtest: contexts
[430.842005] Dynamic subtest contexts: SUCCESS (4.385s)
[430.855000] Starting dynamic subtest: fds
[434.767910] Dynamic subtest fds: SUCCESS (3.923s)
[434.783459] Starting dynamic subtest: userptr
[436.435854] Dynamic subtest userptr: SUCCESS (1.666s)
[436.438262] Subtest engines: SUCCESS (11.626s)
[436.608593] [123/131] (596s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-25)
[436.699413] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-25
[436.701624] Starting dynamic subtest: pipe-A
[436.716626] Dynamic subtest pipe-A: SKIP (0.012s)
[436.726426] Starting dynamic subtest: pipe-B
[436.744451] Dynamic subtest pipe-B: SKIP (0.026s)
[436.755421] Starting dynamic subtest: pipe-C
[436.771536] Dynamic subtest pipe-C: SKIP (0.027s)
[436.782329] Starting dynamic subtest: pipe-D
[436.798495] Dynamic subtest pipe-D: SKIP (0.026s)
[436.802967] Subtest planes-upscale-factor-0-25-downscale-factor-0-25: SKIP (0.094s)
[436.897773] [124/131] (596s left) gem_eio (execbuf)
[437.137153] Starting subtest: execbuf
[437.497837] Subtest execbuf: SUCCESS (0.360s)
[437.656871] [125/131] (595s left) gem_exec_schedule (preempt-user)
[437.733871] Starting subtest: preempt-user
[437.735621] Starting dynamic subtest: rcs0
[437.752874] Dynamic subtest rcs0: SUCCESS (0.021s)
[437.763273] Starting dynamic subtest: bcs0
[437.771978] Dynamic subtest bcs0: SUCCESS (0.018s)
[437.781049] Starting dynamic subtest: vcs0
[437.789412] Dynamic subtest vcs0: SUCCESS (0.018s)
[437.798634] Starting dynamic subtest: vcs1
[437.809839] Dynamic subtest vcs1: SUCCESS (0.020s)
[437.821848] Starting dynamic subtest: vecs0
[437.828890] Dynamic subtest vecs0: SUCCESS (0.019s)
[437.838545] Starting dynamic subtest: ccs0
[437.849514] Dynamic subtest ccs0: SUCCESS (0.020s)
[437.851534] Subtest preempt-user: SUCCESS (0.118s)
[439.496643] [126/131] (594s left) kms_psr (fbc-pr-basic)
[439.591675] Starting subtest: fbc-pr-basic
[439.596273] Subtest fbc-pr-basic: SKIP (0.000s)
[439.645765] [127/131] (593s left) kms_async_flips (async-flip-suspend-resume)
[439.737957] Starting subtest: async-flip-suspend-resume
[440.106680] Starting dynamic subtest: pipe-A-eDP-1
[457.655606] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.965s)
[458.019601] Starting dynamic subtest: pipe-B-eDP-1
[460.837249] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.767s)
[461.151514] Starting dynamic subtest: pipe-C-eDP-1
[463.916102] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.769s)
[464.278088] Starting dynamic subtest: pipe-D-eDP-1
[467.049134] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.778s)
[467.051980] Subtest async-flip-suspend-resume: SUCCESS (12.719s)
[468.213609] [128/131] (579s left) api_intel_bb (object-reloc-keep-cache)
[468.272104] Starting subtest: object-reloc-keep-cache
[468.276939] Subtest object-reloc-keep-cache: SKIP (0.003s)
[468.342337] [129/131] (579s left) i915_pm_rps (thresholds-idle)
[468.398686] Starting subtest: thresholds-idle
[468.403814] Subtest thresholds-idle: SKIP (0.000s)
[468.456390] [130/131] (579s left) gem_create (create-ext-cpu-access-big)
[468.628212] Starting subtest: create-ext-cpu-access-big
[468.632572] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[468.678066] [131/131] (579s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[468.745629] Starting subtest: y-tiled-to-vebox-x-tiled
[468.750067] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[468.905673] Closing watchdogs
Done.