[40.836214] Initializing watchdogs
[40.836244]   /dev/watchdog0
[40.841812] [001/130] (960s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[40.940517] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[40.942368] Starting dynamic subtest: pipe-A-default-mode
[42.159615] Dynamic subtest pipe-A-default-mode: SKIP (1.216s)
[42.162192] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.217s)
[42.299588] [002/130] (959s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[42.381041] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[42.382828] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[42.445109] [003/130] (958s left) kms_flip (wf_vblank-ts-check)
[42.527235] Starting subtest: wf_vblank-ts-check
[42.529164] Starting dynamic subtest: A-eDP1
[51.532102] Dynamic subtest A-eDP1: SUCCESS (9.002s)
[51.535836] Starting dynamic subtest: B-eDP1
[60.556460] Dynamic subtest B-eDP1: SUCCESS (9.024s)
[60.560571] Starting dynamic subtest: C-eDP1
[69.568998] Dynamic subtest C-eDP1: SUCCESS (9.012s)
[69.575026] Starting dynamic subtest: D-eDP1
[78.525974] Dynamic subtest D-eDP1: SUCCESS (8.957s)
[78.528275] Subtest wf_vblank-ts-check: SUCCESS (36.002s)
[79.755545] [004/130] (921s left) prime_mmap (test_userptr)
[79.789180] Starting subtest: test_userptr
[79.790311] Starting dynamic subtest: test_userptr-smem
[79.791479] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[79.792609] Subtest test_userptr: SUCCESS (0.000s)
[79.853627] [005/130] (921s left) drm_fdinfo (most-busy-check-all)
[79.882212] Starting subtest: most-busy-check-all
[79.883263] Starting dynamic subtest: rcs0
[79.888532] Dynamic subtest rcs0: SKIP (0.005s)
[79.896187] Starting dynamic subtest: bcs0
[79.898483] Dynamic subtest bcs0: SKIP (0.001s)
[79.903044] Starting dynamic subtest: vcs0
[79.904848] Dynamic subtest vcs0: SKIP (0.001s)
[79.908435] Starting dynamic subtest: vcs1
[79.910188] Dynamic subtest vcs1: SKIP (0.000s)
[79.913713] Starting dynamic subtest: vecs0
[79.915440] Dynamic subtest vecs0: SKIP (0.000s)
[79.919073] Starting dynamic subtest: ccs0
[79.920877] Dynamic subtest ccs0: SKIP (0.000s)
[79.922684] Subtest most-busy-check-all: SKIP (0.007s)
[79.929234] [006/130] (921s left) kms_display_modes (extended-mode-basic)
[80.006531] Starting subtest: extended-mode-basic
[80.008653] Subtest extended-mode-basic: SKIP (0.000s)
[80.026858] [007/130] (921s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[80.117890] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[80.119804] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[80.170144] [008/130] (921s left) syncobj_timeline (single-wait-all-signaled)
[80.225031] Starting subtest: single-wait-all-signaled
[80.226259] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[80.282332] [009/130] (921s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[80.400681] Starting subtest: basic-flip-after-cursor-varying-size
[81.316616] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.916s)
[82.185685] [010/130] (919s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[82.231679] Subtest enable-vfs-bind-unbind-each-numvfs-all: SKIP (0.000s)
[82.273929] [011/130] (919s left) gem_close_race (multigpu-basic-threads)
[82.331419] Starting subtest: multigpu-basic-threads
[82.333642] Subtest multigpu-basic-threads: SKIP (0.000s)
[82.521284] [012/130] (918s left) kms_cursor_edge_walk (128x128-top-edge)
[82.604355] Starting subtest: 128x128-top-edge
[82.605183] Starting dynamic subtest: pipe-A-eDP-1
[86.127217] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.519s)
[86.132707] Starting dynamic subtest: pipe-D-eDP-1
[89.315066] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.187s)
[89.316610] Subtest 128x128-top-edge: SUCCESS (6.708s)
[90.185012] [013/130] (911s left) gem_lmem_swapping (verify-ccs)
[90.214831] Subtest verify-ccs: SKIP (0.000s)
[90.235336] [014/130] (911s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[90.317763] Starting subtest: fbc-indfb-scaledprimary
[94.319073] Subtest fbc-indfb-scaledprimary: SUCCESS (4.002s)
[94.439137] [015/130] (907s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[94.544473] Starting subtest: cursorA-vs-flipA-atomic-transitions
[105.699997] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.153s)
[106.574417] [016/130] (894s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-25)
[106.671930] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-25
[106.673165] Starting dynamic subtest: pipe-A
[106.683768] Dynamic subtest pipe-A: SKIP (0.010s)
[106.687874] Starting dynamic subtest: pipe-B
[106.703373] Dynamic subtest pipe-B: SKIP (0.019s)
[106.707384] Starting dynamic subtest: pipe-C
[106.723130] Dynamic subtest pipe-C: SKIP (0.019s)
[106.727050] Starting dynamic subtest: pipe-D
[106.741774] Dynamic subtest pipe-D: SKIP (0.018s)
[106.743386] Subtest planes-upscale-factor-0-25-downscale-factor-0-25: SKIP (0.068s)
[106.806105] [017/130] (894s left) gem_softpin (allocator-fork)
[106.859097] Starting subtest: allocator-fork
[109.047306] Subtest allocator-fork: SUCCESS (2.186s)
[109.149372] [018/130] (892s left) gem_pxp (display-protected-crc)
[111.717585] Subtest display-protected-crc: SKIP (0.000s)
[111.758729] [019/130] (889s left) drm_fdinfo (busy-check-all)
[111.787958] Starting subtest: busy-check-all
[111.788925] Starting dynamic subtest: rcs0
[111.791980] Dynamic subtest rcs0: SKIP (0.003s)
[111.796539] Starting dynamic subtest: bcs0
[111.798256] Dynamic subtest bcs0: SKIP (0.000s)
[111.801928] Starting dynamic subtest: vcs0
[111.803669] Dynamic subtest vcs0: SKIP (0.000s)
[111.807455] Starting dynamic subtest: vcs1
[111.809119] Dynamic subtest vcs1: SKIP (0.000s)
[111.812870] Starting dynamic subtest: vecs0
[111.814612] Dynamic subtest vecs0: SKIP (0.000s)
[111.818383] Starting dynamic subtest: ccs0
[111.820034] Dynamic subtest ccs0: SKIP (0.000s)
[111.821728] Subtest busy-check-all: SKIP (0.004s)
[111.832811] [020/130] (889s left) syncobj_timeline (etime-multi-wait-submitted)
[111.903423] Starting subtest: etime-multi-wait-submitted
[112.007645] Subtest etime-multi-wait-submitted: SUCCESS (0.101s)
[112.060133] [021/130] (889s left) kms_vblank (wait-busy-hang)
[112.139509] Starting subtest: wait-busy-hang
[112.141755] Starting dynamic subtest: pipe-A-eDP-1
[138.143981] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.003s)
[138.150570] Starting dynamic subtest: pipe-D-eDP-1
[162.140648] Dynamic subtest pipe-D-eDP-1: SUCCESS (23.992s)
[162.141672] Subtest wait-busy-hang: SUCCESS (49.999s)
[163.018151] [022/130] (838s left) gem_exec_whisper (basic-normal-all)
[163.063599] Starting subtest: basic-normal-all
[165.234999] Subtest basic-normal-all: SUCCESS (2.170s)
[165.387585] [023/130] (836s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[165.422299] Starting subtest: invalid-single-wait-all-unsubmitted
[165.423246] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[165.478942] [024/130] (836s left) kms_pm_dc (dc5-dpms)
[165.571805] Starting subtest: dc5-dpms
[166.684336] Subtest dc5-dpms: SUCCESS (1.112s)
[166.727895] [025/130] (834s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-gtt)
[166.817423] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-gtt
[166.819371] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[166.888877] [026/130] (834s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[167.257270] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[168.117342] [027/130] (833s left) kms_draw_crc (draw-method-mmap-gtt)
[168.205167] Starting subtest: draw-method-mmap-gtt
[168.206945] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[168.273689] [028/130] (833s left) kms_vblank (query-busy-hang)
[168.359438] Starting subtest: query-busy-hang
[168.361762] Starting dynamic subtest: pipe-A-eDP-1
[195.096546] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.734s)
[195.105465] Starting dynamic subtest: pipe-D-eDP-1
[220.133333] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.035s)
[220.134542] Subtest query-busy-hang: SUCCESS (51.772s)
[221.003678] [029/130] (780s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[221.376572] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[222.259726] [030/130] (779s left) kms_atomic_interruptible (legacy-cursor)
[222.342913] Starting subtest: legacy-cursor
[222.343765] Starting dynamic subtest: pipe-A-eDP-1
[229.800768] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.456s)
[229.801732] Subtest legacy-cursor: SUCCESS (7.457s)
[230.671419] [031/130] (770s left) kms_plane_scaling (planes-downscale-factor-0-25-upscale-20x20)
[230.741518] Starting subtest: planes-downscale-factor-0-25-upscale-20x20
[230.742456] Starting dynamic subtest: pipe-A
[230.753349] Dynamic subtest pipe-A: SKIP (0.010s)
[230.758088] Starting dynamic subtest: pipe-B
[230.772478] Dynamic subtest pipe-B: SKIP (0.018s)
[230.776832] Starting dynamic subtest: pipe-C
[230.791522] Dynamic subtest pipe-C: SKIP (0.018s)
[230.795986] Starting dynamic subtest: pipe-D
[230.810052] Dynamic subtest pipe-D: SKIP (0.019s)
[230.811996] Subtest planes-downscale-factor-0-25-upscale-20x20: SKIP (0.066s)
[230.862250] [032/130] (770s left) kms_pipe_crc_basic (bad-source)
[230.946247] Starting subtest: bad-source
[230.947816] Subtest bad-source: SUCCESS (0.000s)
[230.991906] [033/130] (770s left) gem_exec_whisper (basic-contexts-priority)
[231.053063] Starting subtest: basic-contexts-priority
[253.865827] Subtest basic-contexts-priority: SUCCESS (22.809s)
[254.018884] [034/130] (747s left) kms_plane_scaling (intel-max-src-size)
[254.110103] Starting subtest: intel-max-src-size
[254.112752] Subtest intel-max-src-size: SKIP (0.000s)
[254.175815] [035/130] (747s left) gem_madvise (dontneed-before-pwrite)
[254.200044] Starting subtest: dontneed-before-pwrite
[254.212200] Subtest dontneed-before-pwrite: SKIP (0.011s)
[254.248910] [036/130] (747s left) gem_mmap (pf-nonblock)
[254.295426] Subtest pf-nonblock: SKIP (0.000s)
[254.325679] [037/130] (747s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[254.415441] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[254.417210] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[254.482217] [038/130] (747s left) kms_flip (2x-flip-vs-wf_vblank)
[254.563386] Starting subtest: 2x-flip-vs-wf_vblank
[254.577716] Subtest 2x-flip-vs-wf_vblank: SKIP (0.014s)
[254.625075] [039/130] (747s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[254.715695] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[254.716804] Starting dynamic subtest: pipe-A-eDP-1
[254.726061] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[254.730832] Starting dynamic subtest: pipe-B-eDP-1
[254.743138] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[254.750813] Starting dynamic subtest: pipe-C-eDP-1
[254.759825] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[254.766610] Starting dynamic subtest: pipe-D-eDP-1
[254.775963] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[254.777833] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[257.033326] [040/130] (744s left) kms_flip (flip-vs-panning-interruptible)
[257.121476] Starting subtest: flip-vs-panning-interruptible
[257.124162] Starting dynamic subtest: A-eDP1
[265.888645] Dynamic subtest A-eDP1: SUCCESS (8.764s)
[265.898431] Starting dynamic subtest: B-eDP1
[274.657578] Dynamic subtest B-eDP1: SUCCESS (8.769s)
[274.662618] Starting dynamic subtest: C-eDP1
[283.414090] Dynamic subtest C-eDP1: SUCCESS (8.755s)
[283.421044] Starting dynamic subtest: D-eDP1
[292.184795] Dynamic subtest D-eDP1: SUCCESS (8.767s)
[292.189036] Subtest flip-vs-panning-interruptible: SUCCESS (35.065s)
[293.453929] [041/130] (708s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[293.497380] Starting subtest: single-wait-all-for-submit-unsubmitted
[293.607420] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.107s)
[293.654741] [042/130] (708s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[293.741655] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[293.743711] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[293.813094] [043/130] (707s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[293.892376] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[293.894175] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[293.959457] [044/130] (707s left) kms_psr (psr-sprite-plane-onoff)
[294.042498] Starting subtest: psr-sprite-plane-onoff
[294.043537] Starting dynamic subtest: eDP-1
[295.834840] Dynamic subtest eDP-1: SUCCESS (1.790s)
[295.836242] Subtest psr-sprite-plane-onoff: SUCCESS (1.790s)
[296.716991] [045/130] (705s left) kms_addfb_basic (bad-pitch-999)
[296.760429] Starting subtest: bad-pitch-999
[296.761583] Subtest bad-pitch-999: SUCCESS (0.000s)
[296.863937] [046/130] (704s left) api_intel_allocator (two-level-inception-interruptible)
[296.895579] Starting subtest: two-level-inception-interruptible
[302.289749] Subtest two-level-inception-interruptible: SUCCESS (5.393s)
[302.382990] [047/130] (699s left) i915_hangman (engine-engine-error)
[302.440749] Starting subtest: engine-engine-error
[302.441689] Starting dynamic subtest: rcs0
[304.517509] Dynamic subtest rcs0: SUCCESS (2.076s)
[304.525889] Starting dynamic subtest: bcs0
[306.313542] Dynamic subtest bcs0: SUCCESS (1.793s)
[306.322417] Starting dynamic subtest: vcs0
[308.360950] Dynamic subtest vcs0: SUCCESS (2.046s)
[308.368643] Starting dynamic subtest: vcs1
[310.346057] Dynamic subtest vcs1: SUCCESS (1.983s)
[310.353598] Starting dynamic subtest: vecs0
[312.328105] Dynamic subtest vecs0: SUCCESS (1.983s)
[312.335038] Starting dynamic subtest: ccs0
[314.314149] Dynamic subtest ccs0: SUCCESS (1.983s)
[314.315910] Subtest engine-engine-error: SUCCESS (11.871s)
[314.365788] [048/130] (687s left) gem_ctx_persistence (processes)
[314.413302] Starting subtest: processes
[316.410429] Subtest processes: SUCCESS (1.997s)
[316.464690] [049/130] (685s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[316.558642] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[316.559693] Starting dynamic subtest: pipe-A-eDP-1
[316.568680] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[316.573861] Starting dynamic subtest: pipe-B-eDP-1
[316.582750] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[316.587865] Starting dynamic subtest: pipe-C-eDP-1
[316.596312] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[316.601492] Starting dynamic subtest: pipe-D-eDP-1
[316.610856] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[316.612532] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[318.922370] [050/130] (682s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[319.001571] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[319.003184] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[319.085589] [051/130] (682s left) gem_exec_params (invalid-flag)
[319.133880] Starting subtest: invalid-flag
[319.134983] Subtest invalid-flag: SUCCESS (0.000s)
[319.208226] [052/130] (682s left) gem_vm_create (invalid-create)
[319.254425] Starting subtest: invalid-create
[319.257097] Subtest invalid-create: SUCCESS (0.002s)
[319.328992] [053/130] (682s left) kms_rmfb (close-fd)
[319.413482] Starting subtest: close-fd
[319.414300] Starting dynamic subtest: pipe-A-eDP-1
[319.528401] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.112s)
[319.535820] Starting dynamic subtest: pipe-B-eDP-1
[320.775051] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.246s)
[320.781987] Starting dynamic subtest: pipe-C-eDP-1
[322.039949] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.264s)
[322.046370] Starting dynamic subtest: pipe-D-eDP-1
[323.256419] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.216s)
[323.257425] Subtest close-fd: SUCCESS (3.842s)
[324.490924] [054/130] (677s left) gem_ctx_engines (none)
[324.540294] Starting subtest: none
[324.542427] Subtest none: SUCCESS (0.001s)
[324.697718] [055/130] (677s left) gem_partial_pwrite_pread (write-display)
[324.746267] Subtest write-display: SKIP (0.000s)
[324.787248] [056/130] (677s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[324.868471] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[329.562902] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (4.695s)
[329.650773] [057/130] (672s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[329.736733] Starting subtest: fbc-psr2-sprite-mmap-gtt
[329.737887] Starting dynamic subtest: eDP-1
[329.739935] Dynamic subtest eDP-1: SKIP (0.000s)
[329.741818] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[329.786088] [058/130] (672s left) gem_wait (invalid-buf)
[329.828213] Starting subtest: invalid-buf
[329.829622] Subtest invalid-buf: SUCCESS (0.000s)
[330.015118] [059/130] (671s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[330.103599] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[330.105599] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[330.177820] [060/130] (671s left) kms_cursor_crc (cursor-offscreen-64x21)
[330.327169] Starting subtest: cursor-offscreen-64x21
[330.359639] Subtest cursor-offscreen-64x21: SKIP (0.030s)
[330.536258] [061/130] (671s left) gem_exec_balancer (semaphore)
[330.587920] Starting subtest: semaphore
[332.404904] Subtest semaphore: SUCCESS (1.815s)
[332.634566] [062/130] (669s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[332.712661] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[332.713715] Starting dynamic subtest: pipe-A-eDP-1
[332.736671] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[332.742268] Starting dynamic subtest: pipe-B-eDP-1
[332.763474] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[332.768337] Starting dynamic subtest: pipe-C-eDP-1
[332.790584] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[332.795594] Starting dynamic subtest: pipe-D-eDP-1
[332.816670] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[332.818283] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[335.053632] [063/130] (666s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[340.193678] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[340.194938] Starting dynamic subtest: pipe-A-eDP-1
[341.038067] Dynamic subtest pipe-A-eDP-1: SKIP (0.844s)
[341.043240] Starting dynamic subtest: pipe-B-eDP-1
[342.252780] Dynamic subtest pipe-B-eDP-1: SKIP (1.213s)
[342.254651] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (2.060s)
[343.502256] [064/130] (658s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[348.627844] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[348.630183] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[349.514036] [065/130] (652s left) gem_softpin (evict-active)
[349.576435] Starting subtest: evict-active
[349.582559] Subtest evict-active: SUCCESS (0.006s)
[349.668180] [066/130] (652s left) kms_psr (pr-primary-mmap-gtt)
[349.738544] Starting subtest: pr-primary-mmap-gtt
[349.740373] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[349.788402] [067/130] (652s left) gem_exec_balancer (parallel)
[349.994702] Starting subtest: parallel
[350.524554] Subtest parallel: SUCCESS (0.529s)
[351.418347] [068/130] (650s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[351.510536] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[351.511452] Starting dynamic subtest: pipe-A-eDP-1
[351.519781] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[351.525068] Starting dynamic subtest: pipe-B-eDP-1
[351.533150] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[351.538176] Starting dynamic subtest: pipe-C-eDP-1
[351.546160] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[351.550967] Starting dynamic subtest: pipe-D-eDP-1
[351.559602] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[351.561197] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[353.866464] [069/130] (648s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[353.907951] Starting subtest: multi-wait-all-for-submit-signaled
[353.909513] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[353.954633] [070/130] (648s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[354.042929] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[354.044686] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[354.118152] [071/130] (647s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[354.212576] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[354.213607] Starting dynamic subtest: pipe-A-default-mode
[357.055817] Dynamic subtest pipe-A-default-mode: SUCCESS (2.841s)
[357.057596] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.842s)
[357.965188] [072/130] (644s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[358.054635] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[358.056361] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[358.142622] [073/130] (643s left) kms_atomic_interruptible (legacy-pageflip)
[358.226372] Starting subtest: legacy-pageflip
[358.227748] Starting dynamic subtest: pipe-A-eDP-1
[365.678673] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.453s)
[365.679861] Subtest legacy-pageflip: SUCCESS (7.454s)
[366.539406] [074/130] (635s left) kms_psr (psr-cursor-plane-onoff)
[366.623741] Starting subtest: psr-cursor-plane-onoff
[366.624906] Starting dynamic subtest: eDP-1
[368.371248] Dynamic subtest eDP-1: SUCCESS (1.746s)
[368.372302] Subtest psr-cursor-plane-onoff: SUCCESS (1.746s)
[369.290934] [075/130] (632s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[369.375455] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[369.377240] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[369.445360] [076/130] (632s left) gem_mmap (short-mmap)
[369.484434] Subtest short-mmap: SKIP (0.000s)
[369.516804] [077/130] (632s left) perf (gen12-group-concurrent-oa-buffer-read)
[369.649994] Starting subtest: gen12-group-concurrent-oa-buffer-read
[379.675384] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.023s)
[379.696223] [078/130] (622s left) kms_joiner (basic-ultra-joiner)
[379.792835] Starting subtest: basic-ultra-joiner
[379.794590] Subtest basic-ultra-joiner: SKIP (0.000s)
[379.838104] [079/130] (622s left) gem_eio (unwedge-stress)
[380.049721] Starting subtest: unwedge-stress
[424.841363] Subtest unwedge-stress: SUCCESS (44.790s)
[426.360218] [080/130] (575s left) kms_pm_rpm (system-suspend-modeset)
[428.564970] Starting subtest: system-suspend-modeset
[450.475545] Subtest system-suspend-modeset: SUCCESS (7.066s)
[457.825004] [081/130] (566s left) kms_atomic_transition (modeset-transition-nonblocking)
[457.917962] Starting subtest: modeset-transition-nonblocking
[457.918858] Starting dynamic subtest: 1x-outputs
[469.471079] Dynamic subtest 1x-outputs: SUCCESS (11.541s)
[469.745933] Subtest modeset-transition-nonblocking: SUCCESS (11.816s)
[470.665363] [082/130] (553s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[470.751722] Starting subtest: plane-all-transition-nonblocking-fencing
[470.752581] Starting dynamic subtest: pipe-A-eDP-1
[473.244613] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.488s)
[473.542096] Starting dynamic subtest: pipe-B-eDP-1
[476.872240] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.334s)
[477.145909] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.391s)
[478.025552] [083/130] (546s left) syncobj_eventfd (invalid-bad-pad)
[478.067597] Starting subtest: invalid-bad-pad
[478.068607] Subtest invalid-bad-pad: SUCCESS (0.000s)
[478.126447] [084/130] (545s left) gem_exec_schedule (implicit-boths)
[478.177693] Starting subtest: implicit-boths
[478.178639] Starting dynamic subtest: rcs0
[478.276822] Dynamic subtest rcs0: SUCCESS (0.101s)
[478.290722] Starting dynamic subtest: vcs0
[478.363147] Dynamic subtest vcs0: SUCCESS (0.086s)
[478.372041] Starting dynamic subtest: vcs1
[478.439610] Dynamic subtest vcs1: SUCCESS (0.076s)
[478.446748] Starting dynamic subtest: vecs0
[478.518593] Dynamic subtest vecs0: SUCCESS (0.079s)
[478.527375] Starting dynamic subtest: ccs0
[478.595036] Dynamic subtest ccs0: SUCCESS (0.075s)
[478.596585] Subtest implicit-boths: SUCCESS (0.419s)
[480.319792] [085/130] (543s left) gem_exec_balancer (bonded-sync)
[480.370833] Starting subtest: bonded-sync
[480.372685] Subtest bonded-sync: SKIP (0.000s)
[480.604435] [086/130] (543s left) core_setmaster (master-drop-set-user)
[481.113563] Starting subtest: master-drop-set-user
[481.127951] Subtest master-drop-set-user: SUCCESS (0.014s)
[481.139855] [087/130] (543s left) kms_big_fb (x-tiled-addfb)
[481.231289] Starting subtest: x-tiled-addfb
[481.232240] Subtest x-tiled-addfb: SUCCESS (0.000s)
[481.317022] [088/130] (542s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[481.515163] Starting subtest: cursor-rapid-movement-256x85
[481.550545] Subtest cursor-rapid-movement-256x85: SKIP (0.033s)
[481.671590] [089/130] (542s left) kms_chamelium_edid (hdmi-edid-stress-resolution-4k)
[482.032981] Subtest hdmi-edid-stress-resolution-4k: SKIP (0.000s)
[482.865974] [090/130] (541s left) gem_exec_params (dr1-dirt)
[482.915233] Starting subtest: DR1-dirt
[482.916244] Subtest DR1-dirt: SUCCESS (0.000s)
[482.969122] [091/130] (541s left) gem_ctx_persistence (engines-cleanup)
[483.015074] Starting subtest: engines-cleanup
[483.016087] Starting dynamic subtest: rcs0
[483.086003] Dynamic subtest rcs0: SUCCESS (0.070s)
[483.094335] Starting dynamic subtest: bcs0
[483.141160] Dynamic subtest bcs0: SUCCESS (0.054s)
[483.150110] Starting dynamic subtest: vcs0
[483.166839] Dynamic subtest vcs0: SUCCESS (0.025s)
[483.173005] Starting dynamic subtest: vcs1
[483.239903] Dynamic subtest vcs1: SUCCESS (0.072s)
[483.248768] Starting dynamic subtest: vecs0
[483.292056] Dynamic subtest vecs0: SUCCESS (0.051s)
[483.301356] Starting dynamic subtest: ccs0
[483.344820] Dynamic subtest ccs0: SUCCESS (0.052s)
[483.346344] Subtest engines-cleanup: SUCCESS (0.330s)
[483.401224] [092/130] (540s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[483.480699] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[485.999608] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (2.520s)
[486.115896] [093/130] (538s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[486.209682] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[486.211434] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[486.278671] [094/130] (537s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[486.367899] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[487.037433] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.670s)
[487.185121] [095/130] (537s left) kms_psr (fbc-psr-primary-blt)
[487.266880] Starting subtest: fbc-psr-primary-blt
[487.267797] Starting dynamic subtest: eDP-1
[487.269524] Dynamic subtest eDP-1: SKIP (0.000s)
[487.271138] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[487.317398] [096/130] (536s left) perf_pmu (init-sema)
[487.347937] Starting subtest: init-sema
[487.348874] Starting dynamic subtest: rcs0
[487.350767] Dynamic subtest rcs0: SUCCESS (0.002s)
[487.357364] Starting dynamic subtest: bcs0
[487.358211] Dynamic subtest bcs0: SUCCESS (0.000s)
[487.363826] Starting dynamic subtest: vcs0
[487.364729] Dynamic subtest vcs0: SUCCESS (0.001s)
[487.370494] Starting dynamic subtest: vcs1
[487.371309] Dynamic subtest vcs1: SUCCESS (0.000s)
[487.376830] Starting dynamic subtest: vecs0
[487.377679] Dynamic subtest vecs0: SUCCESS (0.000s)
[487.383231] Starting dynamic subtest: ccs0
[487.384098] Dynamic subtest ccs0: SUCCESS (0.000s)
[487.384991] Subtest init-sema: SUCCESS (0.006s)
[487.435934] [097/130] (536s left) i915_pm_rps (thresholds)
[487.481252] Starting subtest: thresholds
[487.483226] Subtest thresholds: SKIP (0.000s)
[487.509264] [098/130] (536s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[487.587529] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[487.589256] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[487.653284] [099/130] (536s left) kms_hdr (bpc-switch)
[487.733738] Starting subtest: bpc-switch
[488.871663] Starting dynamic subtest: pipe-A-eDP-1
[492.455009] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.583s)
[492.456054] Subtest bpc-switch: SUCCESS (4.722s)
[492.530891] [100/130] (531s left) gem_readwrite (read-write)
[492.580712] Subtest read-write: SKIP (0.000s)
[492.619298] [101/130] (531s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[492.705104] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[497.623388] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.920s)
[497.691005] [102/130] (526s left) gem_exec_fence (basic-busy)
[497.864767] Starting subtest: basic-busy
[497.866767] Starting dynamic subtest: rcs0
[497.951071] Dynamic subtest rcs0: SUCCESS (0.086s)
[497.960398] Starting dynamic subtest: bcs0
[498.009240] Dynamic subtest bcs0: SUCCESS (0.057s)
[498.017790] Starting dynamic subtest: vcs0
[498.068859] Dynamic subtest vcs0: SUCCESS (0.059s)
[498.077806] Starting dynamic subtest: vcs1
[498.128519] Dynamic subtest vcs1: SUCCESS (0.059s)
[498.137130] Starting dynamic subtest: vecs0
[498.187751] Dynamic subtest vecs0: SUCCESS (0.058s)
[498.196494] Starting dynamic subtest: ccs0
[498.248090] Dynamic subtest ccs0: SUCCESS (0.059s)
[498.249718] Subtest basic-busy: SUCCESS (0.384s)
[500.237881] [103/130] (524s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-render)
[500.328219] Starting subtest: psr-1p-offscren-pri-shrfb-draw-render
[504.849594] Subtest psr-1p-offscren-pri-shrfb-draw-render: SUCCESS (4.520s)
[504.962547] [104/130] (519s left) gem_mmap_gtt (zero-extend)
[504.998484] Subtest zero-extend: SKIP (0.000s)
[505.035548] [105/130] (519s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[505.116854] Starting subtest: addfb25-yf-tiled-legacy
[505.117951] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[505.181317] [106/130] (519s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[505.234528] Starting subtest: multi-wait-all-for-submit-unsubmitted
[505.339487] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.103s)
[505.389131] [107/130] (519s left) kms_chamelium_audio (dp-audio)
[505.764159] Subtest dp-audio: SKIP (0.000s)
[506.610429] [108/130] (517s left) gem_exec_schedule (preemptive-hang)
[506.772953] Starting subtest: preemptive-hang
[506.774287] Starting dynamic subtest: rcs0
[516.363846] Dynamic subtest rcs0: SUCCESS (9.591s)
[516.373329] Starting dynamic subtest: bcs0
[525.325148] Dynamic subtest bcs0: SUCCESS (8.961s)
[525.338128] Starting dynamic subtest: vcs0
[534.347179] Dynamic subtest vcs0: SUCCESS (9.019s)
[534.354651] Starting dynamic subtest: vcs1
[543.373469] Dynamic subtest vcs1: SUCCESS (9.023s)
[543.381047] Starting dynamic subtest: vecs0
[552.327084] Dynamic subtest vecs0: SUCCESS (8.954s)
[552.336068] Starting dynamic subtest: ccs0
[561.353144] Dynamic subtest ccs0: SUCCESS (9.024s)
[561.354733] Subtest preemptive-hang: SUCCESS (54.576s)
[561.575223] [109/130] (462s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[561.626299] Starting subtest: yf-tiled-to-vebox-x-tiled
[561.628183] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[561.783614] [110/130] (462s left) gem_workarounds (basic-read-context)
[561.833451] Starting subtest: basic-read-context
[561.842154] Subtest basic-read-context: SUCCESS (0.009s)
[561.954884] [111/130] (462s left) sw_sync (sync_busy)
[561.975903] Starting subtest: sync_busy
[561.977298] Subtest sync_busy: SUCCESS (0.001s)
[562.006334] [112/130] (462s left) i915_pm_freq_api (freq-basic-api)
[562.053383] Starting subtest: freq-basic-api
[562.054552] Starting dynamic subtest: gt0
[562.056653] Dynamic subtest gt0: SUCCESS (0.003s)
[562.065841] Starting dynamic subtest: gt1
[562.066890] Dynamic subtest gt1: SUCCESS (0.003s)
[562.067967] Subtest freq-basic-api: SUCCESS (0.006s)
[562.149074] [113/130] (462s left) gen9_exec_parse (bb-oversize)
[562.193312] Subtest bb-oversize: SKIP (0.000s)
[562.232968] [114/130] (462s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[562.337723] Starting subtest: cursor-vs-flip-legacy
[591.033088] Subtest cursor-vs-flip-legacy: SUCCESS (28.694s)
[591.946492] [115/130] (432s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[592.030721] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[592.885946] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.855s)
[592.985616] [116/130] (431s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[593.086459] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[597.346042] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (4.260s)
[597.437559] [117/130] (427s left) kms_lease (possible-crtcs-filtering)
[597.522902] Starting subtest: possible-crtcs-filtering
[597.530147] Subtest possible-crtcs-filtering: SUCCESS (0.007s)
[597.620465] [118/130] (426s left) sw_sync (sync_random_merge)
[597.643406] Starting subtest: sync_random_merge
[597.665811] Subtest sync_random_merge: SUCCESS (0.022s)
[597.702077] [119/130] (426s left) kms_psr2_su (frontbuffer-xrgb8888)
[597.749079] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[597.776968] [120/130] (426s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[597.859620] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[597.861360] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[597.934293] [121/130] (426s left) gem_exec_reloc (basic-wc-gtt)
[597.978320] Subtest basic-wc-gtt: SKIP (0.000s)
[598.018620] [122/130] (426s left) api_intel_allocator (default-alignment)
[598.063888] Starting subtest: default-alignment
[598.066906] Subtest default-alignment: SUCCESS (0.004s)
[598.161099] [123/130] (426s left) kms_fbcon_fbt (psr)
[598.202466] Starting subtest: psr
[603.705509] Subtest psr: SUCCESS (5.501s)
[603.751966] [124/130] (420s left) syncobj_timeline (wait-for-submit-delayed-submit)
[603.796436] Starting subtest: wait-for-submit-delayed-submit
[603.900644] Subtest wait-for-submit-delayed-submit: SUCCESS (0.101s)
[603.956052] [125/130] (420s left) gem_exec_reloc (basic-cpu-gtt-active)
[604.000786] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[604.051048] [126/130] (420s left) kms_big_fb (linear-8bpp-rotate-90)
[604.147829] Starting subtest: linear-8bpp-rotate-90
[604.166821] Subtest linear-8bpp-rotate-90: SKIP (0.019s)
[604.258677] [127/130] (420s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[604.343503] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[604.345377] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[604.416676] [128/130] (420s left) gem_exec_params (rs-invalid)
[604.466489] Starting subtest: rs-invalid
[604.469405] Subtest rs-invalid: SUCCESS (0.003s)
[604.567453] [129/130] (420s left) gem_exec_create (madvise)
[604.619266] Starting subtest: madvise
[604.620817] Starting dynamic subtest: smem
[626.273568] Dynamic subtest smem: SUCCESS (21.650s)
[626.275024] Subtest madvise: SUCCESS (21.650s)
[627.004085] [130/130] (397s left) vgem_basic (mmap)
[627.039738] Starting subtest: mmap
[627.053943] Subtest mmap: SUCCESS (0.015s)
[627.084965] Closing watchdogs
Done.