[50.540736] Initializing watchdogs
[50.540799]   /dev/watchdog0
[50.555959] [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]
[50.561890] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[50.564399] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[50.566386] [001/133] (960s left) kms_flip (flip-vs-panning-vs-hang)
[50.657008] Starting subtest: flip-vs-panning-vs-hang
[50.658442] Starting dynamic subtest: A-HDMI-A1
[89.722451] Dynamic subtest A-HDMI-A1: SUCCESS (39.046s)
[89.727755] Starting dynamic subtest: D-HDMI-A1
[128.634710] Dynamic subtest D-HDMI-A1: SUCCESS (38.900s)
[128.635408] Subtest flip-vs-panning-vs-hang: SUCCESS (77.950s)
[128.802600] [002/133] (882s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[128.889126] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[128.898337] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.009s)
[128.988601] [003/133] (882s left) gem_ctx_shared (q-smoketest-all)
[129.033660] Starting subtest: Q-smoketest-all
[161.319420] Subtest Q-smoketest-all: SUCCESS (32.272s)
[161.494395] [004/133] (849s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[161.528362] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[161.529054] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[161.600322] [005/133] (849s left) gem_basic (create-close)
[161.631953] Starting subtest: create-close
[161.633305] Subtest create-close: SUCCESS (0.000s)
[161.725375] [006/133] (849s left) kms_feature_discovery (dp-mst)
[161.811640] Starting subtest: dp-mst
[161.812964] Subtest dp-mst: SKIP (0.000s)
[161.888465] [007/133] (849s left) gem_lmem_swapping (basic)
[161.925009] Subtest basic: SKIP (0.000s)
[161.965924] [008/133] (849s left) sw_sync (sync_multi_consumer)
[161.997549] Starting subtest: sync_multi_consumer
[162.509810] Subtest sync_multi_consumer: SUCCESS (0.504s)
[162.571917] [009/133] (848s left) kms_addfb_basic (unused-offsets)
[162.604128] Starting subtest: unused-offsets
[162.604830] Subtest unused-offsets: SUCCESS (0.000s)
[162.774480] [010/133] (848s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[163.247405] Starting subtest: syncobj-timeline-invalid-wait
[163.248134] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.005s)
[163.423833] [FACT gem_exec_fence (syncobj-timeline-invalid-wait)] new: kernel.kmod_is_loaded.vgem: true
[163.427712] [011/133] (848s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[163.511169] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[163.551317] [012/133] (847s left) gem_exec_schedule (semaphore-resolve)
[163.595530] Starting subtest: semaphore-resolve
[163.612975] Subtest semaphore-resolve: SUCCESS (0.017s)
[163.932812] [013/133] (847s left) gem_mmap_gtt (cpuset-big-copy-xy)
[163.963464] Starting subtest: cpuset-big-copy-XY
[184.361439] Subtest cpuset-big-copy-XY: SUCCESS (20.399s)
[184.433937] [014/133] (827s left) perf (non-zero-reason)
[184.591208] Starting subtest: non-zero-reason
[184.591928] Starting dynamic subtest: 0-rcs0
[192.256063] Dynamic subtest 0-rcs0: SUCCESS (7.631s)
[192.257097] Subtest non-zero-reason: SUCCESS (7.631s)
[192.293751] [015/133] (819s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[192.326398] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[192.361999] [016/133] (819s left) syncobj_wait (wait-any-complex)
[192.396044] Starting subtest: wait-any-complex
[192.458797] Subtest wait-any-complex: SUCCESS (0.062s)
[192.549836] [017/133] (819s left) sysfs_defaults (readonly)
[192.584695] Starting subtest: readonly
[192.585377] Starting dynamic subtest: vecs0
[192.586053] Dynamic subtest vecs0: SUCCESS (0.000s)
[192.592180] Starting dynamic subtest: vcs0
[192.592871] Dynamic subtest vcs0: SUCCESS (0.000s)
[192.598863] Starting dynamic subtest: bcs0
[192.599554] Dynamic subtest bcs0: SUCCESS (0.000s)
[192.605324] Starting dynamic subtest: rcs0
[192.606003] Dynamic subtest rcs0: SUCCESS (0.000s)
[192.611688] Starting dynamic subtest: vcs1
[192.612360] Dynamic subtest vcs1: SUCCESS (0.000s)
[192.613084] Subtest readonly: SUCCESS (0.004s)
[192.650874] [018/133] (819s left) syncobj_wait (invalid-single-wait-unsubmitted)
[192.683882] Starting subtest: invalid-single-wait-unsubmitted
[192.684566] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[192.764820] [019/133] (818s left) gem_exec_schedule (u-submit-late-slice)
[192.809236] Starting subtest: u-submit-late-slice
[192.809960] Starting dynamic subtest: rcs0
[192.835169] Dynamic subtest rcs0: SUCCESS (0.026s)
[192.843612] Starting dynamic subtest: bcs0
[192.863444] Dynamic subtest bcs0: SUCCESS (0.028s)
[192.870971] Starting dynamic subtest: vcs0
[192.889461] Dynamic subtest vcs0: SUCCESS (0.026s)
[192.897211] Starting dynamic subtest: vcs1
[192.913184] Dynamic subtest vcs1: SUCCESS (0.024s)
[192.921212] Starting dynamic subtest: vecs0
[192.940136] Dynamic subtest vecs0: SUCCESS (0.027s)
[192.940859] Subtest u-submit-late-slice: SUCCESS (0.131s)
[193.244868] [020/133] (818s left) kms_plane (plane-panning-bottom-right-suspend)
[193.333472] Starting subtest: plane-panning-bottom-right-suspend
[193.334899] Starting dynamic subtest: pipe-A
[209.831822] Dynamic subtest pipe-A: SUCCESS (1.731s)
[209.842007] Starting dynamic subtest: pipe-B
[226.797616] Dynamic subtest pipe-B: SUCCESS (1.488s)
[226.798317] Subtest plane-panning-bottom-right-suspend: SUCCESS (3.223s)
[235.985360] [021/133] (784s left) kms_psr (psr-sprite-mmap-gtt)
[236.088430] Subtest psr-sprite-mmap-gtt: SKIP (0.000s)
[236.125989] [022/133] (784s left) gem_ctx_persistence (idempotent)
[236.163342] Starting subtest: idempotent
[236.164084] Subtest idempotent: SUCCESS (0.000s)
[236.236629] [023/133] (784s left) gem_mmap_offset (blt-coherency)
[236.268225] Starting subtest: blt-coherency
[236.274214] Subtest blt-coherency: SUCCESS (0.007s)
[236.396169] [024/133] (784s left) kms_pm_rpm (pm-tiling)
[237.802753] Starting subtest: pm-tiling
[241.701533] Subtest pm-tiling: SUCCESS (3.896s)
[241.791997] [025/133] (779s left) gem_exec_balancer (parallel-keep-in-fence)
[241.955720] Subtest parallel-keep-in-fence: SKIP (0.000s)
[242.039216] [026/133] (779s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[242.076715] Starting subtest: yf-tiled-ccs-to-yf-tiled
[242.077450] Starting dynamic subtest: smem
[242.148374] Dynamic subtest smem: SUCCESS (0.071s)
[242.149129] Subtest yf-tiled-ccs-to-yf-tiled: SUCCESS (0.072s)
[242.340881] [027/133] (778s left) kms_cursor_crc (cursor-random-256x85)
[242.428988] Starting subtest: cursor-random-256x85
[242.433796] Starting dynamic subtest: pipe-A-HDMI-A-1
[243.672433] Dynamic subtest pipe-A-HDMI-A-1: FAIL (1.065s)
[243.680981] Starting dynamic subtest: pipe-D-HDMI-A-1
[245.525424] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.989s)
[245.526174] Subtest cursor-random-256x85: FAIL (3.094s)
[245.695807] [028/133] (775s left) gem_mmap_gtt (basic-write-gtt)
[245.731182] Starting subtest: basic-write-gtt
[245.865806] Subtest basic-write-gtt: SUCCESS (0.129s)
[245.944263] [029/133] (775s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[245.981634] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[245.982372] Starting dynamic subtest: smem
[246.081289] Dynamic subtest smem: SUCCESS (0.099s)
[246.082026] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SUCCESS (0.100s)
[246.264790] [030/133] (774s left) syncobj_wait (multi-wait-all-signaled)
[246.297761] Starting subtest: multi-wait-all-signaled
[246.298459] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[246.376805] [031/133] (774s left) syncobj_eventfd (invalid-bad-flags)
[246.410205] Starting subtest: invalid-bad-flags
[246.410963] Subtest invalid-bad-flags: SUCCESS (0.000s)
[246.482587] [032/133] (774s left) gem_ctx_param (invalid-get-ringsize)
[246.514837] Starting subtest: invalid-get-ringsize
[246.515546] Subtest invalid-get-ringsize: SUCCESS (0.000s)
[246.598195] [033/133] (774s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[246.683818] Starting subtest: cursor-vs-flip-varying-size
[278.775097] Subtest cursor-vs-flip-varying-size: SUCCESS (32.086s)
[278.919415] [034/133] (742s left) gem_render_copy (y-tiled)
[278.961506] Starting subtest: y-tiled
[278.962228] Starting dynamic subtest: smem
[279.058674] Dynamic subtest smem: SUCCESS (0.097s)
[279.059383] Subtest y-tiled: SUCCESS (0.097s)
[279.249741] [035/133] (742s left) kms_psr (fbc-pr-cursor-render)
[279.336415] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[279.380901] [036/133] (742s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[279.474677] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[279.476036] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[279.599444] [037/133] (741s left) kms_frontbuffer_tracking (psr-2p-rte)
[279.686901] Starting subtest: psr-2p-rte
[279.688319] Subtest psr-2p-rte: SKIP (0.000s)
[279.806506] [038/133] (741s left) kms_flip (modeset-vs-vblank-race-interruptible)
[279.894383] Starting subtest: modeset-vs-vblank-race-interruptible
[279.896960] Starting dynamic subtest: A-HDMI-A1
[282.707100] Dynamic subtest A-HDMI-A1: SUCCESS (2.810s)
[282.717466] Starting dynamic subtest: B-HDMI-A1
[285.549793] Dynamic subtest B-HDMI-A1: SUCCESS (2.841s)
[285.559501] Starting dynamic subtest: C-HDMI-A1
[288.357239] Dynamic subtest C-HDMI-A1: SUCCESS (2.806s)
[288.365701] Starting dynamic subtest: D-HDMI-A1
[291.220623] Dynamic subtest D-HDMI-A1: SUCCESS (2.862s)
[291.222905] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (11.327s)
[291.407250] [039/133] (730s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[291.519464] Starting subtest: extended-modeset-hang-oldfb-with-reset
[291.520446] Starting dynamic subtest: pipe-A
[293.100790] Dynamic subtest pipe-A: SUCCESS (1.580s)
[293.111665] Starting dynamic subtest: pipe-D
[294.692064] Dynamic subtest pipe-D: SUCCESS (1.587s)
[294.693860] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (3.175s)
[294.825283] [040/133] (726s left) kms_flip (flip-vs-suspend)
[294.914194] Starting subtest: flip-vs-suspend
[294.916302] Starting dynamic subtest: A-HDMI-A1
[343.730421] Dynamic subtest A-HDMI-A1: SUCCESS (3.729s)
[343.739070] Starting dynamic subtest: B-HDMI-A1
[391.733163] Dynamic subtest B-HDMI-A1: SUCCESS (3.655s)
[391.741730] Starting dynamic subtest: C-HDMI-A1
[439.723556] Dynamic subtest C-HDMI-A1: SUCCESS (3.666s)
[439.733594] Starting dynamic subtest: D-HDMI-A1
[487.719953] Dynamic subtest D-HDMI-A1: SUCCESS (3.668s)
[487.722504] Subtest flip-vs-suspend: SUCCESS (14.728s)
[496.956852] [041/133] (533s left) perf (invalid-create-userspace-config)
[497.065610] Starting subtest: invalid-create-userspace-config
[497.067741] Subtest invalid-create-userspace-config: SUCCESS (0.002s)
[497.107811] [042/133] (533s left) gem_reg_read (timestamp-moving)
[497.141252] Starting subtest: timestamp-moving
[498.151345] Subtest timestamp-moving: SUCCESS (1.000s)
[498.226846] [043/133] (532s left) gem_userptr_blits (sync-overlap)
[498.271146] Starting subtest: sync-overlap
[498.271898] Subtest sync-overlap: SUCCESS (0.000s)
[498.417322] [044/133] (532s left) gem_mmap (basic-small-bo)
[498.450762] Starting subtest: basic-small-bo
[498.654865] Subtest basic-small-bo: SUCCESS (0.203s)
[498.779972] [045/133] (532s left) gem_softpin (full)
[498.868382] Starting subtest: full
[498.874322] Subtest full: SUCCESS (0.006s)
[499.017790] [046/133] (531s left) api_intel_bb (full-batch)
[499.051107] Starting subtest: full-batch
[499.053090] Subtest full-batch: SUCCESS (0.003s)
[499.184763] [047/133] (531s left) kms_content_protection (dp-mst-type-1)
[499.281686] Starting subtest: dp-mst-type-1
[499.283105] Subtest dp-mst-type-1: SKIP (0.000s)
[499.392075] [048/133] (531s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[499.488240] Starting subtest: y-tiled-16bpp-rotate-180
[500.612256] Subtest y-tiled-16bpp-rotate-180: SUCCESS (1.122s)
[500.762556] [049/133] (530s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[500.856849] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[500.858228] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[500.952121] [050/133] (530s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[500.994409] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[500.995072] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[501.086386] [051/133] (530s left) perf_pmu (event-wait)
[501.122579] Starting subtest: event-wait
[501.123296] Starting dynamic subtest: rcs0
[501.124666] Dynamic subtest rcs0: SKIP (0.000s)
[501.126100] Subtest event-wait: SKIP (0.001s)
[501.195495] [052/133] (529s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[501.283896] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[501.285273] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[501.385705] [053/133] (529s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[501.469728] Starting subtest: bad-rotation-90-yf-tiled-ccs
[501.471476] Starting dynamic subtest: pipe-A-HDMI-A-1
[501.477972] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[501.485637] Starting dynamic subtest: pipe-B-HDMI-A-1
[501.492125] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[501.499527] Starting dynamic subtest: pipe-C-HDMI-A-1
[501.506016] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[501.513349] Starting dynamic subtest: pipe-D-HDMI-A-1
[501.519828] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[501.521116] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.007s)
[501.710119] [054/133] (529s left) prime_mmap_kms (buffer-sharing)
[501.796785] Starting subtest: buffer-sharing
[501.981843] Subtest buffer-sharing: SUCCESS (0.185s)
[502.147159] [055/133] (529s left) gem_render_copy (x-tiled)
[502.187816] Starting subtest: x-tiled
[502.188515] Starting dynamic subtest: smem
[502.284616] Dynamic subtest smem: SUCCESS (0.096s)
[502.285395] Subtest x-tiled: SUCCESS (0.097s)
[502.475728] [056/133] (528s left) core_setmaster (master-drop-set-root)
[502.540005] Starting subtest: master-drop-set-root
[502.542764] Subtest master-drop-set-root: SUCCESS (0.003s)
[502.586428] [057/133] (528s left) i915_pm_rpm (reg-read-ioctl)
[503.983445] Starting subtest: reg-read-ioctl
[506.420049] Subtest reg-read-ioctl: SUCCESS (2.436s)
[506.595548] [058/133] (524s left) kms_cursor_legacy (single-move)
[506.682164] Starting subtest: single-move
[506.682877] Starting dynamic subtest: pipe-A
[512.099487] Dynamic subtest pipe-A: SUCCESS (5.379s)
[512.106891] Starting dynamic subtest: pipe-B
[517.481159] Dynamic subtest pipe-B: SUCCESS (5.378s)
[517.488633] Starting dynamic subtest: pipe-C
[522.863319] Dynamic subtest pipe-C: SUCCESS (5.378s)
[522.870253] Starting dynamic subtest: pipe-D
[528.242832] Dynamic subtest pipe-D: SUCCESS (5.378s)
[528.249804] Starting dynamic subtest: all-pipes
[533.621421] Dynamic subtest all-pipes: SUCCESS (5.379s)
[533.622321] Subtest single-move: SUCCESS (26.897s)
[533.677982] [059/133] (497s left) kms_chamelium_hpd (hdmi-hpd-fast)
[533.822052] Subtest hdmi-hpd-fast: SKIP (0.000s)
[533.911752] [060/133] (497s left) kms_chamelium_frames (hdmi-frame-dump)
[534.049800] Subtest hdmi-frame-dump: SKIP (0.000s)
[534.141489] [061/133] (497s left) gem_softpin (noreloc)
[534.184019] Starting subtest: noreloc
[539.621211] Subtest noreloc: SUCCESS (5.405s)
[539.728480] [062/133] (491s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[539.817461] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[539.818811] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[539.918868] [063/133] (491s left) syncobj_wait (single-wait-signaled)
[539.952851] Starting subtest: single-wait-signaled
[539.953589] Subtest single-wait-signaled: SUCCESS (0.000s)
[540.044105] [064/133] (491s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[540.077671] Starting subtest: etime-single-wait-for-submit-submitted
[540.184374] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.106s)
[540.269516] [065/133] (491s left) gem_ppgtt (shrink-vs-evict-pinned)
[540.305282] Starting subtest: shrink-vs-evict-pinned
[545.409391] Subtest shrink-vs-evict-pinned: SUCCESS (5.105s)
[545.505608] [066/133] (486s left) gem_exec_balancer (indices)
[545.546421] Starting subtest: indices
[546.879261] Subtest indices: SUCCESS (1.332s)
[547.077497] [067/133] (484s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[547.176525] Starting subtest: 4-tiled-64bpp-rotate-270
[547.177892] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.000s)
[547.288488] [068/133] (484s left) drm_read (invalid-buffer)
[547.396697] Starting subtest: invalid-buffer
[547.397488] Subtest invalid-buffer: SUCCESS (0.000s)
[547.537644] [069/133] (484s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[547.630124] Starting subtest: yf-tiled-addfb-size-overflow
[547.631561] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[547.734380] [070/133] (484s left) i915_suspend (basic-s3-without-i915)
[547.765452] Starting subtest: basic-s3-without-i915