[88.039979] Initializing watchdogs
[88.040250]   /dev/watchdog0
[88.085105] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[88.099212] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[88.105689] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[88.113496] [001/131] (960s left) gem_exec_nop (basic-sequential)
[88.270255] Starting subtest: basic-sequential
[91.346926] Subtest basic-sequential: SUCCESS (3.083s)
[91.629071] [002/131] (957s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[91.811374] Starting subtest: 2x-long-cursor-vs-flip-atomic
[143.469716] Subtest 2x-long-cursor-vs-flip-atomic: SUCCESS (51.661s)
[143.767435] [003/131] (905s left) gem_mmap_wc (write-read-distinct)
[143.879151] Starting subtest: write-read-distinct
[143.886561] Subtest write-read-distinct: SUCCESS (0.011s)
[144.046762] [004/131] (904s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[144.229222] Starting subtest: nonblocking-crc-frame-sequence
[144.238365] Starting dynamic subtest: pipe-A-HDMI-A-1
[145.216588] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.976s)
[145.234772] Starting dynamic subtest: pipe-B-HDMI-A-2
[145.909814] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.692s)
[145.930422] Starting dynamic subtest: pipe-C-HDMI-A-1
[146.656444] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.700s)
[146.691056] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.383s)
[146.910904] [005/131] (902s left) i915_drm_fdinfo (virtual-busy)
[147.026825] Starting subtest: virtual-busy
[149.184185] Subtest virtual-busy: SUCCESS (2.161s)
[149.343883] [006/131] (899s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[149.540331] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[149.547117] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[149.707929] [007/131] (899s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[149.904917] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[149.913560] Subtest fbcpsr-rgb101010-draw-mmap-wc: SKIP (0.001s)
[150.076104] [008/131] (899s left) sysfs_defaults (readonly)
[150.192818] Starting subtest: readonly
[150.197446] Starting dynamic subtest: vecs0
[150.200468] Dynamic subtest vecs0: SUCCESS (0.001s)
[150.218173] Starting dynamic subtest: vcs0
[150.221783] Dynamic subtest vcs0: SUCCESS (0.001s)
[150.239693] Starting dynamic subtest: bcs0
[150.243589] Dynamic subtest bcs0: SUCCESS (0.001s)
[150.261655] Starting dynamic subtest: rcs0
[150.265990] Dynamic subtest rcs0: SUCCESS (0.001s)
[150.270122] Subtest readonly: SUCCESS (0.011s)
[150.374538] [009/131] (898s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[150.480017] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[150.585300] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.104s)
[150.757111] [010/131] (898s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[150.951517] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[150.957885] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[151.124120] [011/131] (898s left) syncobj_timeline (reset-signaled)
[151.233465] Starting subtest: reset-signaled
[151.236792] Subtest reset-signaled: SUCCESS (0.001s)
[151.391680] [012/131] (898s left) gem_exec_reloc (basic-wc-gtt)
[151.506196] Starting subtest: basic-wc-gtt
[151.529629] Subtest basic-wc-gtt: SUCCESS (0.021s)
[151.778408] [013/131] (897s left) gen9_exec_parse (batch-zero-length)
[151.907847] Starting subtest: batch-zero-length
[151.911590] Subtest batch-zero-length: SUCCESS (0.002s)
[152.193436] [014/131] (897s left) gem_ctx_shared (detached-shared-gtt)
[152.316678] Starting subtest: detached-shared-gtt
[154.471430] Subtest detached-shared-gtt: SUCCESS (2.153s)
[154.757288] [015/131] (895s left) perf_pmu (rc6-all-gts)
[154.870135] Starting subtest: rc6-all-gts
[154.876894] Subtest rc6-all-gts: SKIP (0.001s)
[155.047915] [016/131] (894s left) kms_plane (plane-position-covered)
[155.228833] Starting subtest: plane-position-covered
[155.964450] Starting dynamic subtest: pipe-A-plane-1
[156.491112] Dynamic subtest pipe-A-plane-1: SUCCESS (0.528s)
[156.523725] Starting dynamic subtest: pipe-A-plane-2
[157.033247] Dynamic subtest pipe-A-plane-2: SUCCESS (0.544s)
[157.062155] Starting dynamic subtest: pipe-A-plane-3
[157.578175] Dynamic subtest pipe-A-plane-3: SUCCESS (0.542s)
[157.597516] Starting dynamic subtest: pipe-A-plane-4
[157.604856] Dynamic subtest pipe-A-plane-4: SUCCESS (0.012s)
[158.064443] Starting dynamic subtest: pipe-B-plane-1
[158.574795] Dynamic subtest pipe-B-plane-1: SUCCESS (0.538s)
[158.606243] Starting dynamic subtest: pipe-B-plane-2
[159.085364] Dynamic subtest pipe-B-plane-2: SUCCESS (0.506s)
[159.103912] Starting dynamic subtest: pipe-B-plane-3
[159.604999] Dynamic subtest pipe-B-plane-3: SUCCESS (0.518s)
[159.623983] Starting dynamic subtest: pipe-B-plane-4
[159.713905] Dynamic subtest pipe-B-plane-4: SUCCESS (0.008s)
[159.718224] Subtest plane-position-covered: SUCCESS (4.380s)
[159.928612] [017/131] (890s left) gem_mmap_gtt (fault-concurrent)
[160.047693] Starting subtest: fault-concurrent
[163.446785] Subtest fault-concurrent: SUCCESS (3.403s)
[163.643342] [018/131] (886s left) kms_psr (psr-sprite-render)
[163.827943] Subtest psr-sprite-render: SKIP (0.000s)
[163.923086] [019/131] (886s left) gem_mmap_gtt (hang-user)
[164.028173] Starting subtest: hang-user
[179.026054] Subtest hang-user: SUCCESS (14.988s)
[179.193558] [020/131] (871s left) template (a)
[179.296037] Starting subtest: A
[179.299300] Subtest A: SUCCESS (0.000s)
[179.457202] [021/131] (870s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[179.634916] Starting subtest: cursorA-vs-flipB-atomic
[190.948629] Subtest cursorA-vs-flipB-atomic: SUCCESS (11.307s)
[191.261859] [022/131] (859s left) kms_rotation_crc (primary-rotation-90)
[191.440964] Starting subtest: primary-rotation-90
[205.988999] Subtest primary-rotation-90: SUCCESS (14.546s)
[206.269531] [023/131] (844s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[206.467506] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[209.506579] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (3.040s)
[209.786682] [024/131] (840s left) kms_universal_plane (universal-plane-sanity)
[209.963995] Starting subtest: universal-plane-sanity
[209.968033] Starting dynamic subtest: pipe-A-HDMI-A-1
[210.754045] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.786s)
[210.809449] Starting dynamic subtest: pipe-B-HDMI-A-2
[211.270459] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.508s)
[211.292789] Starting dynamic subtest: pipe-C-HDMI-A-1
[211.818934] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.503s)
[211.852411] Subtest universal-plane-sanity: SUCCESS (1.809s)
[212.062663] [025/131] (838s left) gem_exec_schedule (u-fairslice-all)
[212.206879] Starting subtest: u-fairslice-all
[214.313259] Subtest u-fairslice-all: SUCCESS (2.108s)
[214.726365] [026/131] (836s left) gem_exec_fence (nb-await)
[214.971060] Starting subtest: nb-await
[214.974561] Starting dynamic subtest: rcs0
[215.045484] Dynamic subtest rcs0: SUCCESS (0.073s)
[215.064939] Starting dynamic subtest: bcs0
[215.113673] Dynamic subtest bcs0: SUCCESS (0.067s)
[215.133407] Starting dynamic subtest: vcs0
[215.184945] Dynamic subtest vcs0: SUCCESS (0.070s)
[215.205663] Starting dynamic subtest: vecs0
[215.258842] Dynamic subtest vecs0: SUCCESS (0.069s)
[215.263367] Subtest nb-await: SUCCESS (0.290s)
[216.071319] [FACT gem_exec_fence (nb-await)] new: kernel.kmod_is_loaded.vgem: true
[216.078157] [027/131] (834s left) kms_hdr (invalid-hdr)
[216.260928] Starting subtest: invalid-hdr
[243.773578] Subtest invalid-hdr: SKIP (27.468s)
[244.201823] [028/131] (806s left) kms_debugfs (display-on-read-all)
[244.403082] Starting subtest: display-on-read-all
[244.788419] Subtest display-on-read-all: SUCCESS (0.384s)
[245.014170] [029/131] (806s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[245.202295] Starting subtest: plane-primary-overlay-mutable-zpos
[246.135642] Subtest plane-primary-overlay-mutable-zpos: SKIP (0.923s)
[246.637721] [030/131] (804s left) i915_pm_rps (engine-order)
[246.756924] Starting subtest: engine-order
[257.990713] Subtest engine-order: SUCCESS (11.228s)
[258.203483] [031/131] (793s left) i915_drm_fdinfo (virtual-busy-hang-all)
[258.310187] Starting subtest: virtual-busy-hang-all
[258.313655] Subtest virtual-busy-hang-all: SUCCESS (0.002s)
[258.497218] [032/131] (792s left) kms_psr (fbc-psr-primary-mmap-cpu)
[258.681814] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.000s)
[258.806591] [033/131] (792s left) gem_exec_schedule (out-order)
[258.947617] Starting subtest: out-order
[258.950862] Starting dynamic subtest: rcs0
[259.063741] Dynamic subtest rcs0: SUCCESS (0.113s)
[259.085836] Starting dynamic subtest: bcs0
[259.193889] Dynamic subtest bcs0: SUCCESS (0.127s)
[259.215512] Starting dynamic subtest: vcs0
[259.312425] Dynamic subtest vcs0: SUCCESS (0.116s)
[259.335731] Starting dynamic subtest: vecs0
[259.440227] Dynamic subtest vecs0: SUCCESS (0.124s)
[259.444163] Subtest out-order: SUCCESS (0.497s)
[259.869730] [034/131] (791s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[260.050371] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[260.093209] Starting dynamic subtest: pipe-A-valid-mode
[260.619881] Dynamic subtest pipe-A-valid-mode: SKIP (0.375s)
[260.752066] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.380s)
[261.217370] [035/131] (790s left) core_getclient (basic)
[261.684882] Starting subtest: basic
[261.751747] Subtest basic: SUCCESS (0.000s)
[261.975232] [036/131] (790s left) prime_busy (after-wait)
[262.089986] Starting subtest: after-wait
[262.104112] Starting dynamic subtest: rcs0
[262.114204] Dynamic subtest rcs0: SUCCESS (0.014s)
[262.140125] Starting dynamic subtest: bcs0
[262.143490] Dynamic subtest bcs0: SUCCESS (0.011s)
[262.164586] Starting dynamic subtest: vcs0
[262.168980] Dynamic subtest vcs0: SUCCESS (0.015s)
[262.190285] Starting dynamic subtest: vecs0
[262.194534] Dynamic subtest vecs0: SUCCESS (0.014s)
[262.278990] Subtest after-wait: SUCCESS (0.192s)
[262.476106] [037/131] (789s left) gem_exec_schedule (u-submit-golden-slice)
[262.610234] Starting subtest: u-submit-golden-slice
[262.613503] Starting dynamic subtest: rcs0
[262.650063] Dynamic subtest rcs0: SUCCESS (0.043s)
[262.677687] Starting dynamic subtest: bcs0
[262.698834] Dynamic subtest bcs0: SUCCESS (0.044s)
[262.723839] Starting dynamic subtest: vcs0
[262.742166] Dynamic subtest vcs0: SUCCESS (0.042s)
[262.772479] Starting dynamic subtest: vecs0
[262.792620] Dynamic subtest vecs0: SUCCESS (0.044s)
[262.796582] Subtest u-submit-golden-slice: SUCCESS (0.188s)
[263.233778] [038/131] (789s left) gem_eio (in-flight-contexts-immediate)
[263.371059] Starting subtest: in-flight-contexts-immediate
[274.970625] Subtest in-flight-contexts-immediate: SUCCESS (11.603s)
[275.240434] [039/131] (777s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[277.894063] Starting subtest: verify-pxp-key-change-after-suspend-resume
[277.902539] Subtest verify-pxp-key-change-after-suspend-resume: SKIP (0.000s)
[278.057786] [040/131] (774s left) gem_softpin (evict-active-interruptible)
[278.175407] Starting subtest: evict-active-interruptible
[278.187416] Subtest evict-active-interruptible: SUCCESS (0.013s)
[278.374139] [041/131] (774s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[278.588635] Starting subtest: 4-tiled-8bpp-rotate-180
[278.596761] Subtest 4-tiled-8bpp-rotate-180: SKIP (0.000s)
[278.776538] [042/131] (774s left) gem_userptr_blits (relocations)
[278.899855] Starting subtest: relocations
[278.907045] Subtest relocations: SKIP (0.004s)
[279.132172] [043/131] (773s left) kms_busy (extended-pageflip-hang-newfb)
[279.326236] Starting subtest: extended-pageflip-hang-newfb
[279.338550] Starting dynamic subtest: pipe-A
[283.887588] Dynamic subtest pipe-A: SUCCESS (4.548s)
[283.918162] Starting dynamic subtest: pipe-C
[287.893286] Dynamic subtest pipe-C: SUCCESS (3.991s)
[287.898175] Subtest extended-pageflip-hang-newfb: SUCCESS (8.563s)
[288.263171] [044/131] (764s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[288.377495] Starting subtest: single-wait-for-submit-unsubmitted
[288.482571] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.104s)
[288.657627] [045/131] (764s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[288.855040] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[292.100513] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (3.242s)
[292.429279] [046/131] (760s left) kms_plane_cursor (primary)
[292.616060] Starting subtest: primary
[292.623364] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64
[295.245264] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (2.624s)
[295.318755] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128
[297.729283] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (2.428s)
[297.809213] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256
[300.214483] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (2.429s)
[300.494600] Starting dynamic subtest: pipe-B-HDMI-A-2-size-64
[302.957101] Dynamic subtest pipe-B-HDMI-A-2-size-64: SUCCESS (2.502s)
[303.008629] Starting dynamic subtest: pipe-B-HDMI-A-2-size-128
[305.424135] Dynamic subtest pipe-B-HDMI-A-2-size-128: SUCCESS (2.429s)
[305.476933] Starting dynamic subtest: pipe-B-HDMI-A-2-size-256
[307.891119] Dynamic subtest pipe-B-HDMI-A-2-size-256: SUCCESS (2.432s)
[308.172547] Starting dynamic subtest: pipe-C-HDMI-A-1-size-64
[310.629031] Dynamic subtest pipe-C-HDMI-A-1-size-64: SUCCESS (2.499s)
[310.683164] Starting dynamic subtest: pipe-C-HDMI-A-1-size-128
[313.079048] Dynamic subtest pipe-C-HDMI-A-1-size-128: SUCCESS (2.416s)
[313.131745] Starting dynamic subtest: pipe-C-HDMI-A-1-size-256
[315.545610] Dynamic subtest pipe-C-HDMI-A-1-size-256: SUCCESS (2.432s)
[315.776893] Subtest primary: SUCCESS (23.151s)
[316.125160] [047/131] (737s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[316.344783] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[316.351431] Subtest psr-1p-primscrn-spr-indfb-draw-render: SKIP (0.001s)
[316.526116] [048/131] (736s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[316.735622] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[316.742841] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[316.920544] [049/131] (736s left) gem_exec_balancer (bonded-true-hang)
[317.157385] Starting subtest: bonded-true-hang
[321.220284] Subtest bonded-true-hang: SUCCESS (4.064s)
[321.406660] [050/131] (732s left) gem_exec_fence (syncobj-timeline-repeat)
[322.091044] Starting subtest: syncobj-timeline-repeat
[323.257646] Subtest syncobj-timeline-repeat: SUCCESS (1.167s)
[323.555264] [051/131] (730s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[323.664450] Starting subtest: etime-multi-wait-for-submit-submitted
[323.770569] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.107s)
[323.973461] [052/131] (729s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[324.088352] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[324.215528] [053/131] (729s left) syncobj_wait (multi-wait-submitted)
[324.320670] Starting subtest: multi-wait-submitted
[324.426087] Subtest multi-wait-submitted: SUCCESS (0.105s)
[324.606406] [054/131] (729s left) gem_ppgtt (blt-vs-render-ctx0)
[324.722745] Starting subtest: blt-vs-render-ctx0
[357.734844] Subtest blt-vs-render-ctx0: SUCCESS (33.009s)
[357.928866] [055/131] (696s left) kms_cdclk (mode-transition)
[358.184202] Subtest mode-transition: SKIP (0.000s)
[358.311288] [056/131] (695s left) kms_vrr (max-min)
[358.516168] Starting subtest: max-min
[358.532694] Subtest max-min: SKIP (0.000s)
[358.694086] [057/131] (695s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[358.904185] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[358.910635] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[359.091043] [058/131] (695s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[359.279935] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[359.283087] Starting dynamic subtest: pipe-A-valid-mode
[361.026495] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.736s)
[361.031056] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SUCCESS (1.741s)
[361.360860] [059/131] (693s left) kms_psr (fbc-pr-no-drrs)
[361.571896] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[361.693272] [060/131] (693s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[361.897129] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[361.906402] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[373.011888] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (11.105s)
[373.041695] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[383.965379] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (10.945s)
[383.995599] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[394.880809] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.902s)
[394.886347] Subtest 2x-plain-flip-fb-recreate-interruptible: SUCCESS (32.977s)
[395.793420] [061/131] (659s left) drm_read (short-buffer-nonblock)
[396.423663] Starting subtest: short-buffer-nonblock
[396.490133] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[396.698774] [062/131] (658s left) syncobj_wait (multi-wait-submitted-signaled)
[396.839720] Starting subtest: multi-wait-submitted-signaled
[396.843931] Subtest multi-wait-submitted-signaled: SUCCESS (0.002s)
[397.010252] [063/131] (658s left) kms_flip (2x-flip-vs-suspend)
[397.193549] Starting subtest: 2x-flip-vs-suspend
[397.205237] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2