[89.217903] Initializing watchdogs
[89.217968]   /dev/watchdog0
[89.233144] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[89.238797] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[89.241282] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[89.243035] [001/131] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[89.344201] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[89.345687] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[89.471611] [002/131] (960s left) gem_pxp (regular-baseline-src-copy-readible)
[89.573499] Starting subtest: regular-baseline-src-copy-readible
[89.621444] Subtest regular-baseline-src-copy-readible: SUCCESS (0.049s)
[89.739339] [003/131] (960s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[89.770384] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[89.771078] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[89.853026] [004/131] (960s left) gem_ctx_persistence (heartbeat-many)
[89.888428] Starting subtest: heartbeat-many
[90.388878] Subtest heartbeat-many: SUCCESS (0.500s)
[90.480189] [005/131] (959s left) prime_busy (after)
[90.514950] Starting subtest: after
[90.519454] Starting dynamic subtest: rcs0
[90.550429] Dynamic subtest rcs0: SUCCESS (0.031s)
[90.559638] Starting dynamic subtest: bcs0
[90.568777] Dynamic subtest bcs0: SUCCESS (0.018s)
[90.577324] Starting dynamic subtest: vcs0
[90.590253] Dynamic subtest vcs0: SUCCESS (0.021s)
[90.601730] Starting dynamic subtest: vcs1
[90.605215] Dynamic subtest vcs1: SUCCESS (0.015s)
[90.613603] Starting dynamic subtest: vecs0
[90.620090] Dynamic subtest vecs0: SUCCESS (0.014s)
[90.726030] Subtest after: SUCCESS (0.211s)
[90.813187] [006/131] (959s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[90.897523] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[90.898221] Starting dynamic subtest: pipe-A-valid-mode
[90.955141] Dynamic subtest pipe-A-valid-mode: SKIP (0.056s)
[90.956595] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.058s)
[91.068443] [007/131] (958s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[91.163225] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[91.496825] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.334s)
[91.634425] [008/131] (958s left) gem_ppgtt (blt-vs-render-ctxn)
[91.669375] Starting subtest: blt-vs-render-ctxN
[124.287389] Subtest blt-vs-render-ctxN: SUCCESS (32.606s)
[124.435429] [009/131] (925s left) kms_vblank (ts-continuation-modeset)
[124.574708] Starting subtest: ts-continuation-modeset
[124.576177] Starting dynamic subtest: pipe-A-HDMI-A-1
[124.883693] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.308s)
[124.896413] Starting dynamic subtest: pipe-D-HDMI-A-1
[125.162878] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.273s)
[125.163730] Subtest ts-continuation-modeset: SUCCESS (0.588s)
[125.305303] [010/131] (924s left) kms_cursor_crc (cursor-onscreen-64x21)
[125.396337] Starting subtest: cursor-onscreen-64x21
[125.401371] Starting dynamic subtest: pipe-A-HDMI-A-1
[126.597873] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.197s)
[126.632532] Starting dynamic subtest: pipe-D-HDMI-A-1
[127.769072] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.143s)
[127.769755] Subtest cursor-onscreen-64x21: SUCCESS (2.373s)
[127.935060] [011/131] (922s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[127.977280] Starting subtest: multi-wait-for-submit-submitted-signaled
[127.978711] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[128.063275] [012/131] (922s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[128.095783] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[128.198982] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.103s)
[128.293375] [013/131] (921s left) gem_exec_capture (userptr)
[128.330295] Starting subtest: userptr
[129.609022] Subtest userptr: SUCCESS (1.272s)
[129.737379] [014/131] (920s left) gem_basic (multigpu-create-close)
[129.769051] Starting subtest: multigpu-create-close
[129.770404] Subtest multigpu-create-close: SKIP (0.000s)
[129.855571] [015/131] (920s left) gem_create (create-ext-placement-all)
[130.008437] Starting subtest: create-ext-placement-all
[130.009443] Subtest create-ext-placement-all: SUCCESS (0.000s)
[130.113914] [016/131] (920s left) kms_content_protection (legacy)
[130.202872] Starting subtest: legacy
[130.215919] Subtest legacy: SKIP (0.011s)
[130.331460] [017/131] (920s left) syncobj_wait (multi-wait-for-submit-submitted)
[130.364284] Starting subtest: multi-wait-for-submit-submitted
[130.479721] Subtest multi-wait-for-submit-submitted: SUCCESS (0.106s)
[130.560640] [018/131] (919s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[130.595841] Starting subtest: basic-gtt-wc-noreloc
[130.599740] Subtest basic-gtt-wc-noreloc: SUCCESS (0.004s)
[130.738125] [019/131] (919s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[130.821489] Starting subtest: cursorB-vs-flipA-toggle
[130.824279] Subtest cursorB-vs-flipA-toggle: SKIP (0.002s)
[130.903064] [020/131] (919s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[130.990486] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[132.195152] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (1.205s)
[132.332358] [021/131] (918s left) gem_mmap_wc (write-read-distinct)
[132.365181] Starting subtest: write-read-distinct
[132.368075] Subtest write-read-distinct: SUCCESS (0.003s)
[132.490282] [022/131] (918s left) kms_pm_rpm (i2c)
[133.882331] Starting subtest: i2c
[136.539456] Subtest i2c: SUCCESS (2.656s)
[136.661523] [023/131] (913s left) kms_setmode (invalid-clone-single-crtc)
[136.694597] Starting subtest: invalid-clone-single-crtc
[136.696648] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[136.780120] [024/131] (913s left) gem_exec_schedule (semaphore-noskip)
[136.822277] Starting subtest: semaphore-noskip
[137.144218] Subtest semaphore-noskip: SUCCESS (0.313s)
[137.444628] [025/131] (913s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[137.530336] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[137.562519] [026/131] (913s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[137.644825] Starting subtest: 2x-cursor-vs-flip-atomic
[137.647646] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.002s)
[137.727557] [027/131] (913s left) gem_spin_batch (engines)
[137.767504] Starting subtest: engines
[137.768197] Starting dynamic subtest: rcs0
[141.118504] Dynamic subtest rcs0: SUCCESS (3.316s)
[141.127634] Starting dynamic subtest: bcs0
[144.438363] Dynamic subtest bcs0: SUCCESS (3.319s)
[144.447731] Starting dynamic subtest: vcs0
[147.757140] Dynamic subtest vcs0: SUCCESS (3.318s)
[147.766559] Starting dynamic subtest: vcs1
[151.075494] Dynamic subtest vcs1: SUCCESS (3.318s)
[151.084974] Starting dynamic subtest: vecs0
[154.393364] Dynamic subtest vecs0: SUCCESS (3.318s)
[154.394303] Subtest engines: SUCCESS (16.592s)
[154.541864] [028/131] (896s left) kms_big_fb (linear-8bpp-rotate-270)
[154.638015] Starting subtest: linear-8bpp-rotate-270
[154.712128] Subtest linear-8bpp-rotate-270: SKIP (0.073s)
[154.849747] [029/131] (895s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[154.933598] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[154.934926] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[155.098291] [030/131] (895s left) syncobj_wait (multi-wait-all-signaled)
[155.131429] Starting subtest: multi-wait-all-signaled
[155.132146] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[155.209344] [031/131] (895s left) kms_addfb_basic (bad-pitch-999)
[155.241169] Starting subtest: bad-pitch-999
[155.241871] Subtest bad-pitch-999: SUCCESS (0.000s)
[155.387180] [032/131] (895s left) i915_query (query-topology-unsupported)
[155.418345] Starting subtest: query-topology-unsupported
[155.419678] Subtest query-topology-unsupported: SKIP (0.000s)
[155.502429] [033/131] (895s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[155.585556] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[155.586656] Starting dynamic subtest: pipe-A
[155.720381] Dynamic subtest pipe-A: SUCCESS (0.135s)
[155.729690] Starting dynamic subtest: pipe-B
[155.846503] Dynamic subtest pipe-B: SUCCESS (0.126s)
[155.856138] Starting dynamic subtest: pipe-C
[155.973480] Dynamic subtest pipe-C: SUCCESS (0.127s)
[155.984566] Starting dynamic subtest: pipe-D
[156.109631] Dynamic subtest pipe-D: SUCCESS (0.134s)
[156.110443] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (0.524s)
[156.305425] [034/131] (894s left) gem_fence_thrash (bo-write-verify-threaded-x)
[156.336330] Starting subtest: bo-write-verify-threaded-x
[160.549313] Subtest bo-write-verify-threaded-x: SUCCESS (4.180s)
[160.649751] [035/131] (890s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[160.737585] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[160.738964] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[160.845125] [036/131] (890s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[160.931415] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[160.932742] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[161.046565] [037/131] (890s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[161.133736] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[161.135140] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[161.246679] [038/131] (889s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[161.333398] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[161.334726] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[161.445917] [039/131] (889s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[161.532306] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[162.742542] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SUCCESS (1.210s)
[162.879618] [040/131] (888s left) gem_userptr_blits (process-exit)
[162.923326] Starting subtest: process-exit
[162.932084] Subtest process-exit: SUCCESS (0.009s)
[163.082176] [041/131] (888s left) gem_ctx_persistence (engines-mixed)
[163.118592] Starting subtest: engines-mixed
[163.119288] Starting dynamic subtest: rcs0
[163.159464] Dynamic subtest rcs0: SUCCESS (0.041s)
[163.174189] Starting dynamic subtest: bcs0
[163.217571] Dynamic subtest bcs0: SUCCESS (0.057s)
[163.232775] Starting dynamic subtest: vcs0
[163.284549] Dynamic subtest vcs0: SUCCESS (0.066s)
[163.300656] Starting dynamic subtest: vcs1
[163.342544] Dynamic subtest vcs1: SUCCESS (0.057s)
[163.358552] Starting dynamic subtest: vecs0
[163.413521] Dynamic subtest vecs0: SUCCESS (0.070s)
[163.414815] Subtest engines-mixed: SUCCESS (0.296s)
[163.507381] [042/131] (887s left) kms_joiner (invalid-modeset-big-joiner)
[163.594657] Starting subtest: invalid-modeset-big-joiner
[163.596077] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[163.671661] [043/131] (887s left) core_hotunplug (unbind-rebind)
[163.742345] Starting subtest: unbind-rebind
[166.869172] Subtest unbind-rebind: SUCCESS (3.127s)
[166.901919] [044/131] (884s left) kms_busy (extended-modeset-hang-newfb)
[166.999713] Starting subtest: extended-modeset-hang-newfb
[167.001267] Starting dynamic subtest: pipe-A
[191.165034] Dynamic subtest pipe-A: SUCCESS (24.165s)
[191.174901] Starting dynamic subtest: pipe-D
[214.709652] Dynamic subtest pipe-D: SUCCESS (23.541s)
[214.710394] Subtest extended-modeset-hang-newfb: SUCCESS (47.712s)
[214.838524] [045/131] (836s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[214.928283] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[214.929664] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[215.054630] [046/131] (836s left) perf (buffer-fill)
[215.152676] Starting subtest: buffer-fill
[215.153363] Starting dynamic subtest: 0-rcs0
[217.410492] Dynamic subtest 0-rcs0: SUCCESS (2.249s)
[217.411263] Subtest buffer-fill: SUCCESS (2.250s)
[217.439422] [047/131] (834s left) api_intel_bb (simple-bb-ctx)
[217.489442] Starting subtest: simple-bb-ctx
[217.497072] Subtest simple-bb-ctx: SUCCESS (0.008s)
[217.620260] [048/131] (833s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[217.653032] Starting subtest: etime-single-wait-all-available-unsubmitted
[217.767737] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.106s)
[217.846639] [049/131] (833s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[217.884388] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[217.885109] Starting dynamic subtest: smem
[218.005882] Dynamic subtest smem: SUCCESS (0.113s)
[218.006659] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SUCCESS (0.113s)
[218.189897] [050/131] (833s left) i915_suspend (basic-s3-without-i915)
[218.221177] Starting subtest: basic-s3-without-i915