[38.524412] Initializing watchdogs
[38.524608]   /dev/watchdog0
[38.556774] [001/139] (960s left) gem_pxp (display-protected-crc)
[41.413140] Subtest display-protected-crc: SKIP (0.000s)
[41.490300] [002/139] (957s left) kms_vblank (crtc-id)
[41.814244] Starting subtest: crtc-id
[41.835402] Starting dynamic subtest: pipe-A-DP-1
[42.149177] Dynamic subtest pipe-A-DP-1: SUCCESS (0.347s)
[42.188768] Starting dynamic subtest: pipe-C-DP-1
[42.654355] Dynamic subtest pipe-C-DP-1: SUCCESS (0.489s)
[42.675696] Subtest crtc-id: SUCCESS (0.854s)
[42.989773] [003/139] (956s left) gem_exec_parallel (fds)
[43.225119] Starting subtest: fds
[43.243891] Starting dynamic subtest: rcs0
[53.267908] Dynamic subtest rcs0: SUCCESS (10.051s)
[53.299109] Starting dynamic subtest: bcs0
[64.704322] Dynamic subtest bcs0: SUCCESS (11.437s)
[64.737346] Starting dynamic subtest: vcs0
[75.110760] Dynamic subtest vcs0: SUCCESS (10.404s)
[75.144882] Starting dynamic subtest: vecs0
[86.107103] Dynamic subtest vecs0: SUCCESS (10.996s)
[86.128270] Subtest fds: SUCCESS (42.890s)
[86.352121] [004/139] (912s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[86.656618] Starting subtest: map-fixed-invalidate-overlap
[86.677356] Starting dynamic subtest: gtt
[86.868303] Dynamic subtest gtt: SUCCESS (0.270s)
[86.901534] Starting dynamic subtest: wb
[87.052228] Dynamic subtest wb: SUCCESS (0.181s)
[87.087356] Starting dynamic subtest: wc
[87.233227] Dynamic subtest wc: SUCCESS (0.180s)
[87.266366] Starting dynamic subtest: uc
[87.421245] Dynamic subtest uc: SUCCESS (0.189s)
[87.442754] Subtest map-fixed-invalidate-overlap: SUCCESS (0.824s)
[87.602565] [005/139] (911s left) gem_exec_whisper (basic-fds-priority-all)
[87.881434] Starting subtest: basic-fds-priority-all
[111.935951] Subtest basic-fds-priority-all: SUCCESS (24.086s)
[112.146902] [006/139] (887s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[112.445032] Starting subtest: basic-flip-before-cursor-legacy
[113.799408] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.338s)
[114.139459] [007/139] (885s left) gem_exec_balancer (persistence)
[118.169052] Starting subtest: persistence
[121.648272] Subtest persistence: SUCCESS (3.493s)
[121.729243] [008/139] (877s left) kms_psr (psr2_suspend)
[121.982648] Subtest psr2_suspend: SKIP (0.000s)
[122.068758] [009/139] (877s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[122.364343] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[122.385629] Starting dynamic subtest: pipe-A-DP-1
[122.705890] Dynamic subtest pipe-A-DP-1: SUCCESS (0.320s)
[122.748326] Starting dynamic subtest: pipe-B-DP-1
[123.091212] Dynamic subtest pipe-B-DP-1: SUCCESS (0.379s)
[123.112447] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SUCCESS (0.726s)
[123.524203] [010/139] (876s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[123.817032] Starting subtest: cursor-vs-flip-atomic-transitions
[161.689646] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (37.868s)
[162.043717] [011/139] (837s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[162.369571] Starting subtest: y-tiled-8bpp-rotate-90
[162.471712] Subtest y-tiled-8bpp-rotate-90: SKIP (0.086s)
[162.577051] [012/139] (837s left) syncobj_wait (single-wait-all-for-submit-signaled)
[162.812669] Starting subtest: single-wait-all-for-submit-signaled
[162.831378] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.001s)
[162.913637] [013/139] (837s left) gem_mmap_gtt (hang)
[163.147864] Starting subtest: hang
[168.590957] Subtest hang: SUCCESS (5.471s)
[168.722375] [014/139] (831s left) kms_content_protection (mei-interface)
[169.067559] Starting subtest: mei-interface
[169.766745] Subtest mei-interface: SKIP (0.686s)
[170.171841] [015/139] (830s left) syncobj_wait (multi-wait-all-submitted)
[170.406520] Starting subtest: multi-wait-all-submitted
[170.482906] Subtest multi-wait-all-submitted: SUCCESS (0.103s)
[170.592540] [016/139] (829s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[170.887610] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[170.925750] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.004s)
[171.018813] [017/139] (829s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[171.322626] Starting subtest: addfb25-yf-tiled-legacy
[171.349272] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[171.436601] [018/139] (829s left) gem_exec_balancer (fairslice)
[171.669533] Starting subtest: fairslice
[171.707549] Subtest fairslice: SKIP (0.000s)
[175.733563] [019/139] (824s left) kms_ccs (pipe-c-missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[176.239673] Starting subtest: pipe-C-missing-ccs-buffer-y-tiled-gen12-rc-ccs
[176.278672] Subtest pipe-C-missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[176.603667] [020/139] (824s left) gem_softpin (noreloc-s3)
[176.837969] Starting subtest: noreloc-S3
[196.907895] Subtest noreloc-S3: SUCCESS (5.515s)
[202.185498] [021/139] (818s left) perf (global-sseu-config)
[202.583928] Starting subtest: global-sseu-config
[202.602963] Starting dynamic subtest: 0-rcs0
[202.708895] Dynamic subtest 0-rcs0: SUCCESS (0.123s)
[202.729894] Subtest global-sseu-config: SUCCESS (0.123s)
[202.817997] [022/139] (817s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[203.204372] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[203.243934] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[203.329974] [023/139] (817s left) prime_vgem (fence-wait)
[203.700715] Starting subtest: fence-wait
[203.721494] Starting dynamic subtest: rcs0
[204.704197] Dynamic subtest rcs0: SUCCESS (1.050s)
[204.742602] Starting dynamic subtest: vcs0
[205.745614] Dynamic subtest vcs0: SUCCESS (1.036s)
[205.786784] Starting dynamic subtest: vecs0
[206.776944] Dynamic subtest vecs0: SUCCESS (1.032s)
[206.795846] Subtest fence-wait: SUCCESS (3.122s)
[206.914948] [024/139] (813s left) gem_mmap_gtt (ptrace)
[207.118671] Starting subtest: ptrace
[207.376793] Subtest ptrace: SUCCESS (0.291s)
[207.516171] [025/139] (813s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[207.745286] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[207.766214] Starting dynamic subtest: smem
[208.064548] Dynamic subtest smem: SUCCESS (0.333s)
[208.083276] Subtest yf-tiled-ccs-to-y-tiled-ccs: SUCCESS (0.333s)
[208.301010] [026/139] (812s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[208.650102] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[210.791703] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (2.188s)
[210.984296] [027/139] (809s left) gem_mmap_wc (fault-concurrent)
[211.224813] Starting subtest: fault-concurrent
[212.892437] Subtest fault-concurrent: SUCCESS (1.698s)
[213.004698] [028/139] (807s left) vc4/vc4_wait_bo (used-bo)
[213.277946] Subtest used-bo: SKIP (0.000s)
[213.367751] [029/139] (807s left) kms_ccs (pipe-b-random-ccs-data-y-tiled-gen12-rc-ccs)
[213.809606] Starting subtest: pipe-B-random-ccs-data-y-tiled-gen12-rc-ccs
[213.871926] Subtest pipe-B-random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[214.235918] [030/139] (806s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[214.569554] Starting subtest: yf-tiled-16bpp-rotate-270
[214.648715] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.082s)
[214.769617] [031/139] (806s left) kms_flip (2x-blocking-absolute-wf_vblank)
[215.066617] Starting subtest: 2x-blocking-absolute-wf_vblank
[215.104488] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.003s)
[215.198517] [032/139] (806s left) kms_chamelium_audio (dp-audio)
[215.606132] Subtest dp-audio: SKIP (0.000s)
[215.929655] [033/139] (805s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[216.160473] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[216.181382] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s)
[216.271665] [034/139] (805s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[216.627016] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[216.668221] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[216.757686] [035/139] (804s left) gem_set_tiling_vs_gtt
[217.349299] [036/139] (804s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[217.576240] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[217.597645] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[217.685199] [037/139] (804s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[217.913994] Starting subtest: no-spare-fences-busy
[220.080038] Subtest no-spare-fences-busy: SUCCESS (2.169s)
[220.246427] [038/139] (801s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-render)
[220.582070] Starting subtest: fbc-1p-offscren-pri-indfb-draw-render
[222.434157] Subtest fbc-1p-offscren-pri-indfb-draw-render: SUCCESS (1.913s)
[222.599633] [039/139] (799s left) kms_psr2_sf (overlay-plane-update-continuous-sf)
[222.853572] Subtest overlay-plane-update-continuous-sf: SKIP (0.000s)
[222.948228] [040/139] (799s left) kms_vrr (flip-dpms)
[223.247026] Starting subtest: flip-dpms
[223.284864] Subtest flip-dpms: SKIP (0.000s)
[223.377292] [041/139] (798s left) gem_ctx_persistence (idempotent)
[223.613725] Starting subtest: idempotent
[223.632837] Subtest idempotent: SUCCESS (0.000s)
[223.728472] [042/139] (798s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[224.080965] Starting subtest: fbc-tiling-linear
[225.930686] Subtest fbc-tiling-linear: SUCCESS (1.912s)
[226.101050] [043/139] (796s left) kms_frontbuffer_tracking (psr-slowdraw)
[226.453635] Starting subtest: psr-slowdraw
[226.493648] Subtest psr-slowdraw: SKIP (0.000s)
[226.589852] [044/139] (795s left) gem_compute (compute-square)
[226.816779] Starting subtest: compute-square
[226.857986] Subtest compute-square: SKIP (0.000s)
[226.945792] [045/139] (795s left) kms_flip (modeset-vs-vblank-race-interruptible)
[227.258388] Starting subtest: modeset-vs-vblank-race-interruptible
[227.280490] Starting dynamic subtest: A-DP1
[231.657454] Dynamic subtest A-DP1: SUCCESS (4.409s)
[231.696348] Starting dynamic subtest: B-DP1
[236.056131] Dynamic subtest B-DP1: SUCCESS (4.397s)
[236.096833] Starting dynamic subtest: C-DP1
[240.442631] Dynamic subtest C-DP1: SUCCESS (4.383s)
[240.464714] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (13.201s)
[240.887972] [046/139] (781s left) kms_ccs (pipe-b-bad-rotation-90-4-tiled-mtl-mc-ccs)
[241.331085] Starting subtest: pipe-B-bad-rotation-90-4-tiled-mtl-mc-ccs
[241.368595] Subtest pipe-B-bad-rotation-90-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[241.770171] [047/139] (780s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[242.093076] Starting subtest: cursor-rapid-movement-512x170
[242.130805] Subtest cursor-rapid-movement-512x170: SKIP (0.003s)
[242.243742] [048/139] (780s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[242.555669] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[242.581286] Starting dynamic subtest: pipe-A-valid-mode
[242.999547] Dynamic subtest pipe-A-valid-mode: SKIP (0.382s)
[243.051465] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SKIP (0.385s)
[243.350618] [049/139] (779s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[243.735141] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[243.772465] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[243.868848] [050/139] (779s left) kms_big_fb (linear-64bpp-rotate-90)
[244.197636] Starting subtest: linear-64bpp-rotate-90
[244.304022] Subtest linear-64bpp-rotate-90: SKIP (0.087s)
[244.399665] [051/139] (778s left) i915_hangman (gt-engine-hang)
[244.634205] Starting subtest: gt-engine-hang
[244.653805] Starting dynamic subtest: rcs0
[245.226931] Dynamic subtest rcs0: SUCCESS (0.601s)
[245.274547] Starting dynamic subtest: bcs0
[245.827411] Dynamic subtest bcs0: SUCCESS (0.598s)
[245.874885] Starting dynamic subtest: vcs0
[246.431829] Dynamic subtest vcs0: SUCCESS (0.595s)
[246.476648] Starting dynamic subtest: vecs0
[247.026209] Dynamic subtest vecs0: SUCCESS (0.587s)
[247.045605] Subtest gt-engine-hang: SUCCESS (2.390s)
[247.170402] [052/139] (775s left) kms_ccs (pipe-d-crc-primary-basic-y-tiled-gen12-rc-ccs)
[247.707062] Subtest pipe-D-crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[248.034831] [053/139] (775s left) syncobj_wait (wait-delayed-signal)
[248.261858] Starting subtest: wait-delayed-signal
[248.330858] Subtest wait-delayed-signal: SUCCESS (0.102s)
[248.450433] [054/139] (774s left) kms_ccs (pipe-c-crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[248.936237] Starting subtest: pipe-C-crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[248.983239] Subtest pipe-C-crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SKIP (0.001s)
[249.319425] [055/139] (774s left) kms_atomic_interruptible (legacy-pageflip)
[249.615730] Starting subtest: legacy-pageflip
[249.637630] Starting dynamic subtest: pipe-A-DP-1
[256.177145] Dynamic subtest pipe-A-DP-1: SUCCESS (6.537s)
[256.199024] Subtest legacy-pageflip: SUCCESS (6.542s)
[256.508878] [056/139] (766s left) gem_eio (throttle)
[256.786617] Starting subtest: throttle
[256.808282] Subtest throttle: SUCCESS (0.035s)
[256.991497] [057/139] (766s left) kms_cursor_crc (cursor-random-256x85)
[257.307706] Starting subtest: cursor-random-256x85
[257.329064] Starting dynamic subtest: pipe-A-DP-1
[261.127352] Dynamic subtest pipe-A-DP-1: SUCCESS (3.803s)
[261.215349] Starting dynamic subtest: pipe-C-DP-1
[265.097197] Dynamic subtest pipe-C-DP-1: SUCCESS (3.901s)
[265.117461] Subtest cursor-random-256x85: SUCCESS (7.786s)
[265.462298] [058/139] (758s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[265.763099] Starting subtest: compare-crc-sanitycheck-xr24
[265.782055] Starting dynamic subtest: pipe-A-DP-1
[266.222050] Dynamic subtest pipe-A-DP-1: SUCCESS (0.446s)
[266.264280] Starting dynamic subtest: pipe-B-DP-1
[266.855037] Dynamic subtest pipe-B-DP-1: SUCCESS (0.626s)
[266.893400] Starting dynamic subtest: pipe-C-DP-1
[267.491501] Dynamic subtest pipe-C-DP-1: SUCCESS (0.623s)
[267.512963] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.710s)
[267.827146] [059/139] (755s left) kms_busy (extended-pageflip-hang-oldfb)
[268.151425] Starting subtest: extended-pageflip-hang-oldfb
[268.172186] Starting dynamic subtest: pipe-A
[268.465762] Dynamic subtest pipe-A: SUCCESS (0.320s)
[268.503928] Starting dynamic subtest: pipe-C
[269.008956] Dynamic subtest pipe-C: SUCCESS (0.515s)
[269.036302] Subtest extended-pageflip-hang-oldfb: SUCCESS (0.848s)
[269.377268] [060/139] (754s left) kms_ccs (pipe-b-crc-primary-basic-4-tiled-dg2-rc-ccs)
[269.817763] Starting subtest: pipe-B-crc-primary-basic-4-tiled-dg2-rc-ccs
[269.876623] Subtest pipe-B-crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.001s)
[270.257280] [061/139] (753s left) api_intel_bb (blit-noreloc-purge-cache)
[270.495805] Starting subtest: blit-noreloc-purge-cache
[270.517386] Subtest blit-noreloc-purge-cache: SUCCESS (0.017s)
[270.624413] [062/139] (753s left) gem_readwrite (read-bad-handle)
[270.829276] Starting subtest: read-bad-handle
[270.872402] Subtest read-bad-handle: SUCCESS (0.000s)
[270.964379] [063/139] (753s left) syncobj_timeline (wait-for-submit-delayed-submit)
[271.195087] Starting subtest: wait-for-submit-delayed-submit
[271.265112] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[271.392786] [064/139] (752s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[271.746557] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[271.783861] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[271.881991] [065/139] (752s left) kms_frontbuffer_tracking (basic)
[272.233732] Starting subtest: basic
[275.063171] Subtest basic: SUCCESS (2.880s)
[275.202950] [066/139] (749s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[275.591508] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[275.629246] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[275.723868] [067/139] (748s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[275.946548] Starting subtest: wait-all-for-submit-delayed-submit
[276.023988] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[276.140431] [068/139] (748s left) gem_exec_reloc (basic-wc-read-noreloc)
[276.373082] Starting subtest: basic-wc-read-noreloc
[276.393770] Subtest basic-wc-read-noreloc: SUCCESS (0.008s)
[276.574981] [069/139] (748s left) v3d/v3d_create_bo (create-bo-0)
[276.848368] Subtest create-bo-0: SKIP (0.000s)
[276.943392] [070/139] (747s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[277.276074] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[277.318783] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[277.414189] [071/139] (747s left) gem_exec_schedule (semaphore-power)
[277.813170] Starting subtest: semaphore-power
[278.682130] Subtest semaphore-power: SUCCESS (0.866s)
[278.892922] [072/139] (745s left) gem_exec_alignment (single)
[279.122239] Starting subtest: single
[279.144501] Subtest single: SUCCESS (0.009s)
[279.259902] [073/139] (745s left) kms_flip (2x-nonexisting-fb)
[279.551983] Starting subtest: 2x-nonexisting-fb
[279.590909] Subtest 2x-nonexisting-fb: SKIP (0.003s)
[279.689911] [074/139] (745s left) i915_selftest (mock)
[281.245580] Starting subtest: mock
[281.265746] Starting dynamic subtest: sanitycheck
[281.766568] Dynamic subtest sanitycheck: SUCCESS (0.519s)
[281.798904] Starting dynamic subtest: shmem
[282.204363] Dynamic subtest shmem: SUCCESS (0.433s)
[282.239698] Starting dynamic subtest: fence
[289.759211] Dynamic subtest fence: SUCCESS (7.548s)
[289.808251] Starting dynamic subtest: scatterlist
[291.209928] Dynamic subtest scatterlist: SUCCESS (1.450s)
[291.256821] Starting dynamic subtest: syncmap
[293.809950] Dynamic subtest syncmap: SUCCESS (2.596s)
[293.855574] Starting dynamic subtest: uncore
[294.269971] Dynamic subtest uncore: SUCCESS (0.450s)
[294.320627] Starting dynamic subtest: ring
[294.716532] Dynamic subtest ring: SUCCESS (0.453s)
[294.762368] Starting dynamic subtest: engine
[295.178141] Dynamic subtest engine: SUCCESS (0.453s)
[295.220576] Starting dynamic subtest: timelines
[305.754372] Dynamic subtest timelines: SUCCESS (10.573s)
[305.804623] Starting dynamic subtest: requests
[308.665716] Dynamic subtest requests: SUCCESS (2.907s)
[308.702162] Starting dynamic subtest: objects
[309.315107] Dynamic subtest objects: SUCCESS (0.644s)
[309.358732] Starting dynamic subtest: phys
[309.956080] Dynamic subtest phys: SUCCESS (0.635s)
[309.995848] Starting dynamic subtest: dmabuf
[310.599076] Dynamic subtest dmabuf: SUCCESS (0.641s)
[310.637897] Starting dynamic subtest: vma