[38.102574] Initializing watchdogs
[38.102604]   /dev/watchdog0
[38.108994] [001/130] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[38.207543] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[43.255259] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (5.051s)
[43.380007] [002/130] (955s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[43.467843] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[43.470261] Starting dynamic subtest: pipe-A-eDP-1
[43.494361] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[43.500216] Starting dynamic subtest: pipe-B-eDP-1
[43.524169] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.023s)
[43.533184] Starting dynamic subtest: pipe-C-eDP-1
[43.555751] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.021s)
[43.564134] Starting dynamic subtest: pipe-D-eDP-1
[43.584300] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.023s)
[43.586206] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.091s)
[45.922947] [003/130] (952s left) gem_exec_schedule (u-semaphore-resolve)
[45.983359] Starting subtest: u-semaphore-resolve
[46.008665] Subtest u-semaphore-resolve: SUCCESS (0.032s)
[46.330767] [004/130] (952s left) prime_mmap (test_forked_cpu_write)
[46.379831] Starting subtest: test_forked_cpu_write
[46.382457] Starting dynamic subtest: test_forked_cpu_write-smem
[46.388553] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.008s)
[46.391602] Subtest test_forked_cpu_write: SUCCESS (0.008s)
[46.456206] [005/130] (952s left) kms_lease (lease-again)
[46.532059] Starting subtest: lease-again
[46.534613] Starting dynamic subtest: pipe-A-eDP-1
[46.537026] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[46.543960] Starting dynamic subtest: pipe-B-eDP-1
[46.546270] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[46.551530] Starting dynamic subtest: pipe-C-eDP-1
[46.553996] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[46.559155] Starting dynamic subtest: pipe-D-eDP-1
[46.561505] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[46.563858] Subtest lease-again: SUCCESS (0.008s)
[46.620664] [006/130] (952s left) kms_big_fb (linear-64bpp-rotate-270)
[46.713930] Starting subtest: linear-64bpp-rotate-270
[46.731955] Subtest linear-64bpp-rotate-270: SKIP (0.018s)
[46.808233] [007/130] (951s left) gem_create (create-ext-cpu-access-big)
[46.965261] Starting subtest: create-ext-cpu-access-big
[46.970966] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[47.015606] [008/130] (951s left) kms_chamelium_color (ctm-negative)
[47.109678] Subtest ctm-negative: SKIP (0.000s)
[47.132327] [009/130] (951s left) perf_pmu (most-busy-check-all)
[47.167798] Starting subtest: most-busy-check-all
[47.170393] Starting dynamic subtest: rcs0
[48.390188] Dynamic subtest rcs0: SUCCESS (1.223s)
[48.399684] Starting dynamic subtest: bcs0
[50.372308] Dynamic subtest bcs0: SUCCESS (1.982s)
[50.379642] Starting dynamic subtest: vcs0
[52.419553] Dynamic subtest vcs0: SUCCESS (2.047s)
[52.427689] Starting dynamic subtest: vcs1
[54.403750] Dynamic subtest vcs1: SUCCESS (1.984s)
[54.411693] Starting dynamic subtest: vecs0
[56.388090] Dynamic subtest vecs0: SUCCESS (1.983s)
[56.399028] Starting dynamic subtest: ccs0
[58.373372] Dynamic subtest ccs0: SUCCESS (1.985s)
[58.375730] Subtest most-busy-check-all: SUCCESS (11.207s)
[58.442678] [010/130] (940s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[58.542377] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[58.546897] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[58.607282] [011/130] (940s left) kms_feature_discovery (display-4x)
[58.694049] Starting subtest: display-4x
[58.698156] Subtest display-4x: SKIP (0.000s)
[58.741606] [012/130] (940s left) gem_exec_schedule (in-order)
[58.807906] Starting subtest: in-order
[58.810069] Starting dynamic subtest: rcs0
[58.886439] Dynamic subtest rcs0: SUCCESS (0.087s)
[58.892787] Starting dynamic subtest: vcs0
[58.952433] Dynamic subtest vcs0: SUCCESS (0.067s)
[58.958411] Starting dynamic subtest: vcs1
[59.028799] Dynamic subtest vcs1: SUCCESS (0.076s)
[59.035851] Starting dynamic subtest: vecs0
[59.098341] Dynamic subtest vecs0: SUCCESS (0.070s)
[59.105952] Starting dynamic subtest: ccs0
[59.171253] Dynamic subtest ccs0: SUCCESS (0.073s)
[59.173713] Subtest in-order: SUCCESS (0.373s)
[60.472542] [013/130] (938s left) kms_properties (crtc-properties-legacy)
[60.563749] Starting subtest: crtc-properties-legacy
[60.566042] Starting dynamic subtest: pipe-A-eDP-1
[61.006067] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.440s)
[61.013610] Starting dynamic subtest: pipe-B-eDP-1
[62.270284] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.264s)
[62.279075] Starting dynamic subtest: pipe-C-eDP-1
[63.480123] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.209s)
[63.487306] Starting dynamic subtest: pipe-D-eDP-1
[64.704077] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.222s)
[64.706746] Subtest crtc-properties-legacy: SUCCESS (4.138s)
[65.570316] [014/130] (933s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[65.662738] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[65.664976] Starting dynamic subtest: pipe-A
[66.016574] Dynamic subtest pipe-A: SUCCESS (0.353s)
[66.021800] Starting dynamic subtest: pipe-B
[67.459033] Dynamic subtest pipe-B: SUCCESS (1.442s)
[67.466859] Starting dynamic subtest: pipe-C
[68.930392] Dynamic subtest pipe-C: SUCCESS (1.471s)
[68.937029] Starting dynamic subtest: pipe-D
[70.402291] Dynamic subtest pipe-D: SUCCESS (1.471s)
[70.404551] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.739s)
[71.654255] [015/130] (927s left) gem_exec_balancer (noheartbeat)
[71.872208] Starting subtest: noheartbeat
[71.877651] Subtest noheartbeat: SKIP (0.000s)
[71.929363] [016/130] (926s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[72.037064] Starting subtest: cursor-vs-flip-legacy
[100.649560] Subtest cursor-vs-flip-legacy: SUCCESS (28.613s)
[101.541644] [017/130] (897s left) gem_exec_params (invalid-fence-in-submit)
[101.590813] Starting subtest: invalid-fence-in-submit
[101.595572] Subtest invalid-fence-in-submit: SUCCESS (0.003s)
[101.685533] [018/130] (897s left) gem_fence_thrash (bo-write-verify-threaded-x)
[101.712431] Starting subtest: bo-write-verify-threaded-x
[101.737709] Subtest bo-write-verify-threaded-x: SKIP (0.024s)
[101.774779] [019/130] (897s left) gem_mmap_offset (mmap-boundaries)
[101.813116] Starting subtest: mmap-boundaries
[101.815480] Starting dynamic subtest: smem0
[102.033794] Dynamic subtest smem0: SUCCESS (0.221s)
[102.036940] Subtest mmap-boundaries: SUCCESS (0.222s)
[102.159151] [020/130] (896s left) kms_vblank (query-idle)
[102.246739] Starting subtest: query-idle
[102.249075] Starting dynamic subtest: pipe-A-eDP-1
[104.000754] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.753s)
[104.012311] Starting dynamic subtest: pipe-D-eDP-1
[106.497367] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.492s)
[106.499533] Subtest query-idle: SUCCESS (4.248s)
[107.370490] [021/130] (891s left) gem_exec_schedule (semaphore-user)
[107.426904] Starting subtest: semaphore-user
[107.472456] Subtest semaphore-user: SUCCESS (0.055s)
[109.393859] [022/130] (889s left) gem_sync (basic-store-each)
[109.458740] Starting subtest: basic-store-each
[111.976615] Subtest basic-store-each: SUCCESS (2.531s)
[112.136223] [023/130] (886s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[112.237647] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[116.761178] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (4.529s)
[116.861245] [024/130] (882s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[116.957574] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[116.962152] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[117.025209] [025/130] (881s left) gem_exec_reloc (basic-write-wc-noreloc)
[117.068023] Subtest basic-write-wc-noreloc: SKIP (0.000s)
[117.108699] [026/130] (881s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[117.206644] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[117.210830] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[117.263510] [027/130] (881s left) gem_wait (wait)
[117.304980] Starting subtest: wait
[117.307229] Starting dynamic subtest: all-engines
[118.402141] Dynamic subtest all-engines: SUCCESS (1.097s)
[118.410084] Starting dynamic subtest: rcs0
[119.451876] Dynamic subtest rcs0: SUCCESS (1.049s)
[119.461244] Starting dynamic subtest: bcs0
[120.498779] Dynamic subtest bcs0: SUCCESS (1.047s)
[120.506290] Starting dynamic subtest: vcs0
[121.543555] Dynamic subtest vcs0: SUCCESS (1.044s)
[121.550087] Starting dynamic subtest: vcs1
[122.588454] Dynamic subtest vcs1: SUCCESS (1.044s)
[122.595520] Starting dynamic subtest: vecs0
[123.632213] Dynamic subtest vecs0: SUCCESS (1.043s)
[123.639642] Starting dynamic subtest: ccs0
[124.683209] Dynamic subtest ccs0: SUCCESS (1.051s)
[124.685766] Subtest wait: SUCCESS (7.378s)
[124.853795] [028/130] (874s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[126.567594] Starting subtest: dpms-mode-unset-non-lpsp
[127.725136] Subtest dpms-mode-unset-non-lpsp: SKIP (1.156s)
[128.046479] [029/130] (870s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[128.130828] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[128.133222] Starting dynamic subtest: pipe-A-eDP-1
[128.155824] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[128.161062] Starting dynamic subtest: pipe-B-eDP-1
[128.182664] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[128.187735] Starting dynamic subtest: pipe-C-eDP-1
[128.209769] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[128.215408] Starting dynamic subtest: pipe-D-eDP-1
[128.237999] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[128.242457] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.002s)
[130.472817] [030/130] (868s left) gem_eio (in-flight-immediate)
[130.643075] Starting subtest: in-flight-immediate
[138.551167] Subtest in-flight-immediate: SUCCESS (7.909s)
[138.706361] [031/130] (860s left) gem_close_race (basic-process)
[138.757871] Starting subtest: basic-process
[138.813228] Subtest basic-process: SUCCESS (0.055s)
[138.969306] [032/130] (860s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[139.051963] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[139.054390] Starting dynamic subtest: pipe-A-eDP-1
[139.076369] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[139.083598] Starting dynamic subtest: pipe-B-eDP-1
[139.103414] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[139.109858] Starting dynamic subtest: pipe-C-eDP-1
[139.131303] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[139.137439] Starting dynamic subtest: pipe-D-eDP-1
[139.159340] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[139.161529] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.004s)
[141.411724] [033/130] (857s left) i915_selftest (live)
[143.161963] Starting subtest: live
[143.164269] Starting dynamic subtest: sanitycheck
[145.495779] Dynamic subtest sanitycheck: SUCCESS (2.333s)
[145.503286] Starting dynamic subtest: uncore
[147.749879] Dynamic subtest uncore: SUCCESS (2.253s)
[147.757239] Starting dynamic subtest: workarounds
[153.147055] Warning: kernel log ringbuffer underflow, some records lost.
[170.544818] Dynamic subtest workarounds: FAIL (22.585s)
[170.548459] Subtest live: FAIL (27.174s)
[170.552507] Killing the test because the kernel is tainted.
[170.556248] Aborting: Kernel badly tainted (0x240, 0x200) (check dmesg for details):
	TAINT_WARN: WARN_ON has happened.

[170.558554] Closing watchdogs