[83.871706] Initializing watchdogs
[83.871898]   /dev/watchdog0
[83.916356] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[83.930835] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[83.938563] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[83.946287] [001/131] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[84.163227] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[87.138998] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SUCCESS (2.977s)
[87.366333] [002/131] (957s left) kms_setmode (clone-exclusive-crtc)
[87.490521] Starting subtest: clone-exclusive-crtc
[88.034282] Starting dynamic subtest: pipe-A-HDMI-A-1-pipe-B-HDMI-A-2
[88.302904] Dynamic subtest pipe-A-HDMI-A-1-pipe-B-HDMI-A-2: SUCCESS (0.263s)
[88.759950] Starting dynamic subtest: pipe-B-HDMI-A-1-pipe-A-HDMI-A-2
[89.014195] Dynamic subtest pipe-B-HDMI-A-1-pipe-A-HDMI-A-2: SUCCESS (0.267s)
[89.421667] Subtest clone-exclusive-crtc: SUCCESS (1.951s)
[89.716409] [003/131] (954s left) kms_cursor_crc (cursor-dpms)
[89.937804] Starting subtest: cursor-dpms
[89.941413] Starting dynamic subtest: pipe-A-HDMI-A-1
[91.582989] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.667s)
[91.621368] Starting dynamic subtest: pipe-C-HDMI-A-1
[92.968109] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.375s)
[92.972860] Subtest cursor-dpms: SUCCESS (3.055s)
[93.292936] [004/131] (951s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[93.483806] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[93.486964] Starting dynamic subtest: pipe-A-valid-mode
[94.432457] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.947s)
[94.436422] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SUCCESS (0.949s)
[94.762565] [005/131] (950s left) kms_addfb_basic (basic-x-tiled-legacy)
[94.873299] Starting subtest: basic-x-tiled-legacy
[94.876631] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[95.126380] [006/131] (949s left) api_intel_bb (lot-of-buffers)
[95.228512] Starting subtest: lot-of-buffers
[100.928448] Subtest lot-of-buffers: SUCCESS (5.690s)
[101.366936] [007/131] (943s left) kms_tiled_display (basic-test-pattern)
[101.654707] Starting subtest: basic-test-pattern
[103.417867] Subtest basic-test-pattern: FAIL (0.964s)
[103.502838] [008/131] (941s left) gem_wait (busy)
[103.646208] Starting subtest: busy
[103.649408] Starting dynamic subtest: all-engines
[104.171839] Dynamic subtest all-engines: SUCCESS (0.520s)
[104.189533] Starting dynamic subtest: rcs0
[104.682716] Dynamic subtest rcs0: SUCCESS (0.514s)
[104.702705] Starting dynamic subtest: bcs0
[105.203374] Dynamic subtest bcs0: SUCCESS (0.519s)
[105.224142] Starting dynamic subtest: vcs0
[105.723780] Dynamic subtest vcs0: SUCCESS (0.514s)
[105.741271] Starting dynamic subtest: vecs0
[106.231503] Dynamic subtest vecs0: SUCCESS (0.512s)
[106.234730] Subtest busy: SUCCESS (2.586s)
[106.545071] [009/131] (938s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[106.679924] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[106.727310] Starting dynamic subtest: pipe-A-valid-mode
[107.632957] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.946s)
[107.636786] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (0.950s)
[107.951119] [010/131] (937s left) gem_madvise (dontneed-before-exec)
[108.062989] Starting subtest: dontneed-before-exec
[108.070834] Subtest dontneed-before-exec: SUCCESS (0.008s)
[108.233145] [011/131] (937s left) gem_gpgpu_fill (offset-16x16)
[108.337801] Starting subtest: offset-16x16
[108.346926] Subtest offset-16x16: SUCCESS (0.011s)
[108.523248] [012/131] (936s left) gem_exec_fence (nb-await)
[108.775133] Starting subtest: nb-await
[108.778582] Starting dynamic subtest: rcs0
[108.849096] Dynamic subtest rcs0: SUCCESS (0.074s)
[108.867946] Starting dynamic subtest: bcs0
[108.918709] Dynamic subtest bcs0: SUCCESS (0.069s)
[108.937775] Starting dynamic subtest: vcs0
[108.992168] Dynamic subtest vcs0: SUCCESS (0.072s)
[109.011274] Starting dynamic subtest: vecs0
[109.067230] Dynamic subtest vecs0: SUCCESS (0.071s)
[109.071457] Subtest nb-await: SUCCESS (0.294s)
[109.850831] [FACT gem_exec_fence (nb-await)] new: kernel.kmod_is_loaded.vgem: true
[109.857390] [013/131] (935s left) gem_exec_schedule (lateslice)
[109.996128] Starting subtest: lateslice
[109.999426] Starting dynamic subtest: rcs0
[110.028567] Dynamic subtest rcs0: SUCCESS (0.030s)
[110.048966] Starting dynamic subtest: bcs0
[110.052771] Dynamic subtest bcs0: SUCCESS (0.029s)
[110.072888] Starting dynamic subtest: vcs0
[110.087655] Dynamic subtest vcs0: SUCCESS (0.031s)
[110.107302] Starting dynamic subtest: vecs0
[110.115258] Dynamic subtest vecs0: SUCCESS (0.027s)
[110.118877] Subtest lateslice: SUCCESS (0.123s)
[110.545875] [014/131] (935s left) perf (gen12-unprivileged-single-ctx-counters)
[110.805929] Starting subtest: gen12-unprivileged-single-ctx-counters
[110.814028] Subtest gen12-unprivileged-single-ctx-counters: SKIP (0.000s)
[110.914787] [015/131] (934s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[111.422943] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[111.692628] [016/131] (934s left) api_intel_allocator (reloc-allocator)
[111.804622] Starting subtest: reloc-allocator
[111.809098] Starting dynamic subtest: basic
[111.812528] Dynamic subtest basic: SUCCESS (0.008s)
[111.831556] Starting dynamic subtest: parallel-one
[111.840571] Dynamic subtest parallel-one: SUCCESS (0.027s)
[111.860926] Starting dynamic subtest: print
[111.866078] Dynamic subtest print: SUCCESS (0.000s)
[111.889251] Starting dynamic subtest: reuse
[111.892621] Dynamic subtest reuse: SUCCESS (0.000s)
[111.911025] Starting dynamic subtest: fork-reopen-allocator
[111.915245] Dynamic subtest fork-reopen-allocator: SUCCESS (0.045s)
[111.918506] Subtest reloc-allocator: SUCCESS (0.086s)
[112.103898] [017/131] (933s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[112.259467] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[112.266249] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[112.439781] [018/131] (933s left) kms_flip (flip-vs-rmfb-interruptible)
[112.592833] Starting subtest: flip-vs-rmfb-interruptible
[112.601574] Starting dynamic subtest: A-HDMI-A1
[118.179264] Dynamic subtest A-HDMI-A1: SUCCESS (5.580s)
[118.200397] Starting dynamic subtest: B-HDMI-A1
[123.519517] Dynamic subtest B-HDMI-A1: SUCCESS (5.334s)
[123.539382] Starting dynamic subtest: C-HDMI-A1
[128.848210] Dynamic subtest C-HDMI-A1: SUCCESS (5.324s)
[128.867910] Starting dynamic subtest: A-HDMI-A2
[134.177300] Dynamic subtest A-HDMI-A2: SUCCESS (5.325s)
[134.197518] Starting dynamic subtest: B-HDMI-A2
[139.512745] Dynamic subtest B-HDMI-A2: SUCCESS (5.330s)
[139.532934] Starting dynamic subtest: C-HDMI-A2
[144.840860] Dynamic subtest C-HDMI-A2: SUCCESS (5.323s)
[144.844879] Subtest flip-vs-rmfb-interruptible: SUCCESS (32.246s)
[145.327602] [019/131] (900s left) gem_ccs (block-copy-uncompressed)
[145.447252] Subtest block-copy-uncompressed: SKIP (0.000s)
[145.558722] [020/131] (900s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[145.725290] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[145.728380] Starting dynamic subtest: pipe-A-HDMI-A-1
[145.959647] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.011s)
[145.978263] Starting dynamic subtest: pipe-A-HDMI-A-2
[146.117433] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.011s)
[146.136149] Starting dynamic subtest: pipe-B-HDMI-A-1
[146.372289] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.013s)
[146.391218] Starting dynamic subtest: pipe-B-HDMI-A-2
[146.512108] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.013s)
[146.540245] Starting dynamic subtest: pipe-C-HDMI-A-1
[146.668875] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.013s)
[146.687225] Starting dynamic subtest: pipe-C-HDMI-A-2
[146.820877] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.013s)
[146.829258] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.104s)
[146.948307] [021/131] (899s left) kms_psr (fbc-pr-sprite-plane-move)
[147.084957] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[147.195688] [022/131] (899s left) kms_debugfs (display-on-read-all)
[147.348604] Starting subtest: display-on-read-all
[147.504983] Subtest display-on-read-all: SUCCESS (0.163s)
[147.754475] [023/131] (898s left) gem_userptr_blits (dmabuf-sync)
[147.899237] Starting subtest: dmabuf-sync
[147.905497] Subtest dmabuf-sync: SKIP (0.007s)
[148.219214] [024/131] (898s left) gen9_exec_parse (bb-chained)
[148.542403] Starting subtest: bb-chained
[148.609178] Subtest bb-chained: SUCCESS (0.011s)
[149.066584] [025/131] (898s left) kms_cursor_edge_walk (128x128-right-edge)
[149.616913] Starting subtest: 128x128-right-edge
[149.621152] Starting dynamic subtest: pipe-A-HDMI-A-1
[153.081345] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.845s)
[153.107059] Starting dynamic subtest: pipe-C-HDMI-A-1
[156.552748] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.462s)
[156.557425] Subtest 128x128-right-edge: SUCCESS (7.318s)
[156.867786] [026/131] (890s left) kms_chamelium_color (ctm-0-75)
[157.046591] Subtest ctm-0-75: SKIP (0.000s)
[157.163082] [027/131] (890s left) gem_exec_params (secure-non-master)
[157.282671] Starting subtest: secure-non-master
[157.291198] Subtest secure-non-master: SKIP (0.000s)
[157.463486] [028/131] (890s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[157.633402] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[157.640665] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[157.817693] [029/131] (889s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[157.965829] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[157.973702] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[158.147782] [030/131] (889s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[158.309595] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[161.270037] Subtest fbc-rgb101010-draw-mmap-gtt: SUCCESS (2.960s)
[161.545913] [031/131] (886s left) kms_big_fb (yf-tiled-addfb)
[161.711964] Starting subtest: yf-tiled-addfb
[161.716074] Subtest yf-tiled-addfb: SUCCESS (0.000s)
[161.897831] [032/131] (885s left) gem_exec_schedule (u-semaphore-user)
[162.039481] Starting subtest: u-semaphore-user
[162.055480] Subtest u-semaphore-user: SUCCESS (0.017s)
[162.482217] [033/131] (885s left) kms_psr (psr-primary-blt)
[162.627943] Subtest psr-primary-blt: SKIP (0.000s)
[162.743582] [034/131] (885s left) gem_exec_whisper (basic-contexts-all)
[162.876608] Starting subtest: basic-contexts-all
[173.676614] Subtest basic-contexts-all: SUCCESS (10.795s)
[173.980996] [035/131] (874s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[174.144315] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[174.152048] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[174.334394] [036/131] (873s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[174.490781] Starting subtest: psr-shrfb-scaledprimary
[174.497956] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[174.667716] [037/131] (873s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[174.834134] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[174.935091] [038/131] (873s left) gem_exec_reloc (basic-wc-read-noreloc)
[175.058188] Starting subtest: basic-wc-read-noreloc
[175.067699] Subtest basic-wc-read-noreloc: SUCCESS (0.009s)
[175.299320] [039/131] (873s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[175.462020] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[175.469534] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[175.650408] [040/131] (873s left) syncobj_timeline (single-wait-all-available-signaled)
[175.758483] Starting subtest: single-wait-all-available-signaled
[175.762464] Subtest single-wait-all-available-signaled: SUCCESS (0.001s)
[175.943245] [041/131] (872s left) gem_mmap_gtt (basic-write-read)
[176.056054] Starting subtest: basic-write-read
[176.059703] Subtest basic-write-read: SUCCESS (0.010s)
[176.249055] [042/131] (872s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[176.402551] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[176.409440] Subtest psr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[176.582441] [043/131] (872s left) gem_exec_capture (pi)
[176.705948] Starting subtest: pi
[176.711162] Starting dynamic subtest: rcs0
[195.714959] Dynamic subtest rcs0: SUCCESS (19.014s)
[195.737430] Starting dynamic subtest: bcs0
[214.223080] Dynamic subtest bcs0: SUCCESS (18.503s)
[214.245924] Starting dynamic subtest: vcs0
[232.757054] Dynamic subtest vcs0: SUCCESS (18.530s)
[232.783186] Starting dynamic subtest: vecs0
[251.303892] Dynamic subtest vecs0: SUCCESS (18.541s)
[251.308050] Subtest pi: SUCCESS (74.602s)
[251.484902] [044/131] (797s left) kms_psr (pr-primary-page-flip)
[251.774061] Subtest pr-primary-page-flip: SKIP (0.000s)
[251.901369] [045/131] (797s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[252.033209] Starting subtest: saturated-hostile-nopreempt
[252.037228] Starting dynamic subtest: rcs0
[252.773687] Dynamic subtest rcs0: SUCCESS (0.739s)
[252.796518] Starting dynamic subtest: bcs0
[253.517588] Dynamic subtest bcs0: SUCCESS (0.741s)
[253.540178] Starting dynamic subtest: vcs0
[254.273518] Dynamic subtest vcs0: SUCCESS (0.746s)
[254.300364] Starting dynamic subtest: vecs0
[255.020592] Dynamic subtest vecs0: SUCCESS (0.752s)
[255.025529] Subtest saturated-hostile-nopreempt: SUCCESS (2.989s)
[255.244735] [046/131] (794s left) kms_addfb_basic (clobberred-modifier)
[255.357798] Starting subtest: clobberred-modifier
[255.361910] Subtest clobberred-modifier: SUCCESS (0.000s)
[255.585181] [047/131] (793s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[255.736037] Starting subtest: basic-flip-before-cursor-varying-size
[257.122237] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.388s)
[257.444493] [048/131] (792s left) gem_pxp (reject-modify-context-protection-off-1)
[260.094190] Starting subtest: reject-modify-context-protection-off-1
[260.101240] Subtest reject-modify-context-protection-off-1: SKIP (0.000s)
[260.271875] [049/131] (789s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[260.420308] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[260.424705] Starting dynamic subtest: pipe-A-HDMI-A-1
[260.548708] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[260.572856] Starting dynamic subtest: pipe-A-HDMI-A-2
[260.605715] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[260.628531] Starting dynamic subtest: pipe-B-HDMI-A-1
[260.661172] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[260.683619] Starting dynamic subtest: pipe-B-HDMI-A-2
[260.716538] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[260.738599] Starting dynamic subtest: pipe-C-HDMI-A-1
[260.772720] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[260.794847] Starting dynamic subtest: pipe-C-HDMI-A-2
[260.825427] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[260.831378] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.036s)
[261.426763] [050/131] (788s left) gem_ctx_persistence (engines-cleanup)
[261.548935] Starting subtest: engines-cleanup
[261.554156] Starting dynamic subtest: rcs0
[261.580197] Dynamic subtest rcs0: SUCCESS (0.029s)
[261.605460] Starting dynamic subtest: bcs0
[261.618039] Dynamic subtest bcs0: SUCCESS (0.035s)
[261.641859] Starting dynamic subtest: vcs0
[261.655441] Dynamic subtest vcs0: SUCCESS (0.034s)
[261.683490] Starting dynamic subtest: vecs0
[261.687598] Dynamic subtest vecs0: SUCCESS (0.022s)
[261.692153] Subtest engines-cleanup: SUCCESS (0.137s)
[261.901294] [051/131] (787s left) kms_setmode (invalid-clone-single-crtc)
[262.055519] Starting subtest: invalid-clone-single-crtc
[262.533656] Starting dynamic subtest: pipe-A-HDMI-A-1-HDMI-A-2
[262.729327] Dynamic subtest pipe-A-HDMI-A-1-HDMI-A-2: SUCCESS (0.034s)
[262.795208] Starting dynamic subtest: pipe-B-HDMI-A-1-HDMI-A-2
[262.992106] Dynamic subtest pipe-B-HDMI-A-1-HDMI-A-2: SUCCESS (0.030s)
[263.058144] Subtest invalid-clone-single-crtc: SUCCESS (0.534s)
[263.547122] [052/131] (786s left) gem_exec_reloc (basic-concurrent0)
[263.764663] Starting subtest: basic-concurrent0
[269.209669] Subtest basic-concurrent0: SUCCESS (5.447s)
[269.421747] [053/131] (780s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[269.587650] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[269.594555] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[269.788174] [054/131] (780s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[269.955150] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[272.474306] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SUCCESS (2.521s)
[272.718942] [055/131] (777s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[272.884381] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[272.891161] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[273.071220] [056/131] (777s left) gem_exec_reloc (basic-write-gtt)
[273.199501] Starting subtest: basic-write-gtt
[273.215748] Subtest basic-write-gtt: SUCCESS (0.019s)
[273.436414] [057/131] (777s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[273.605622] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[273.612201] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[273.788651] [058/131] (777s left) kms_flip (2x-flip-vs-suspend)
[273.923410] Starting subtest: 2x-flip-vs-suspend
[273.927118] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2