[128.752224] Initializing watchdogs
[128.752438]   /dev/watchdog0
[128.791079] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[128.805747] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[128.812739] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[128.820969] [001/131] (960s left) gem_exec_nop (basic-sequential)
[128.983465] Starting subtest: basic-sequential
[132.065771] Subtest basic-sequential: SUCCESS (3.090s)
[132.357315] [002/131] (957s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[132.539325] Starting subtest: 2x-long-cursor-vs-flip-atomic
[184.270617] Subtest 2x-long-cursor-vs-flip-atomic: SUCCESS (51.726s)
[184.585807] [003/131] (904s left) gem_mmap_wc (write-read-distinct)
[184.701962] Starting subtest: write-read-distinct
[184.712405] Subtest write-read-distinct: SUCCESS (0.013s)
[184.877867] [004/131] (904s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[185.057750] Starting subtest: nonblocking-crc-frame-sequence
[185.061239] Starting dynamic subtest: pipe-A-HDMI-A-1
[186.088800] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.023s)
[186.107447] Starting dynamic subtest: pipe-B-HDMI-A-2
[186.796576] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.705s)
[186.816028] Starting dynamic subtest: pipe-C-HDMI-A-1
[187.537952] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.696s)
[187.546075] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.436s)
[187.786956] [005/131] (901s left) i915_drm_fdinfo (virtual-busy)
[187.902096] Starting subtest: virtual-busy
[190.050464] Subtest virtual-busy: SUCCESS (2.149s)
[190.216954] [006/131] (899s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[190.425179] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[190.431767] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[190.585238] [007/131] (899s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[190.793788] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[190.799614] Subtest fbcpsr-rgb101010-draw-mmap-wc: SKIP (0.001s)
[190.969287] [008/131] (898s left) sysfs_defaults (readonly)
[191.084898] Starting subtest: readonly
[191.088323] Starting dynamic subtest: vecs0
[191.091389] Dynamic subtest vecs0: SUCCESS (0.003s)
[191.109729] Starting dynamic subtest: vcs0
[191.113761] Dynamic subtest vcs0: SUCCESS (0.001s)
[191.132039] Starting dynamic subtest: bcs0
[191.136257] Dynamic subtest bcs0: SUCCESS (0.002s)
[191.155998] Starting dynamic subtest: rcs0
[191.160097] Dynamic subtest rcs0: SUCCESS (0.001s)
[191.163950] Subtest readonly: SUCCESS (0.014s)
[191.267251] [009/131] (898s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[191.375588] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[191.480705] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.106s)
[191.651214] [010/131] (898s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[191.850401] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[191.857262] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[192.017790] [011/131] (898s left) syncobj_timeline (reset-signaled)
[192.125907] Starting subtest: reset-signaled
[192.129873] Subtest reset-signaled: SUCCESS (0.001s)
[192.292069] [012/131] (898s left) gem_exec_reloc (basic-wc-gtt)
[192.406653] Starting subtest: basic-wc-gtt
[192.430360] Subtest basic-wc-gtt: SUCCESS (0.023s)
[192.670826] [013/131] (897s left) gen9_exec_parse (batch-zero-length)
[192.802336] Starting subtest: batch-zero-length
[192.806243] Subtest batch-zero-length: SUCCESS (0.003s)
[193.083982] [014/131] (897s left) gem_ctx_shared (detached-shared-gtt)
[193.204785] Starting subtest: detached-shared-gtt
[195.371992] Subtest detached-shared-gtt: SUCCESS (2.153s)
[195.717309] [015/131] (894s left) perf_pmu (rc6-all-gts)
[195.827180] Starting subtest: rc6-all-gts
[195.834783] Subtest rc6-all-gts: SKIP (0.000s)
[196.000085] [016/131] (894s left) kms_plane (plane-position-covered)
[196.183287] Starting subtest: plane-position-covered
[197.016657] Starting dynamic subtest: pipe-A-plane-1
[197.547621] Dynamic subtest pipe-A-plane-1: SUCCESS (0.537s)
[197.614119] Starting dynamic subtest: pipe-A-plane-2
[197.944058] Dynamic subtest pipe-A-plane-2: SUCCESS (0.502s)
[197.974484] Starting dynamic subtest: pipe-A-plane-3
[198.472419] Dynamic subtest pipe-A-plane-3: SUCCESS (0.531s)
[198.497457] Starting dynamic subtest: pipe-A-plane-4
[198.504434] Dynamic subtest pipe-A-plane-4: SUCCESS (0.008s)
[198.973148] Starting dynamic subtest: pipe-B-plane-1
[199.436572] Dynamic subtest pipe-B-plane-1: SUCCESS (0.514s)
[199.488205] Starting dynamic subtest: pipe-B-plane-2
[199.961309] Dynamic subtest pipe-B-plane-2: SUCCESS (0.523s)
[200.009827] Starting dynamic subtest: pipe-B-plane-3
[200.471363] Dynamic subtest pipe-B-plane-3: SUCCESS (0.509s)
[200.490539] Starting dynamic subtest: pipe-B-plane-4
[200.542603] Dynamic subtest pipe-B-plane-4: SUCCESS (0.011s)
[200.579447] Subtest plane-position-covered: SUCCESS (4.302s)
[200.804191] [017/131] (889s left) gem_mmap_gtt (fault-concurrent)
[200.913373] Starting subtest: fault-concurrent
[204.315041] Subtest fault-concurrent: SUCCESS (3.400s)
[204.486715] [018/131] (886s left) kms_psr (psr-sprite-render)
[204.667019] Subtest psr-sprite-render: SKIP (0.000s)
[204.766153] [019/131] (886s left) gem_mmap_gtt (hang-user)
[204.873972] Starting subtest: hang-user
[220.036166] Subtest hang-user: SUCCESS (15.161s)
[220.222694] [020/131] (870s left) template (a)
[220.326869] Starting subtest: A
[220.329980] Subtest A: SUCCESS (0.000s)
[220.507215] [021/131] (870s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[220.683612] Starting subtest: cursorA-vs-flipB-atomic
[232.023518] Subtest cursorA-vs-flipB-atomic: SUCCESS (11.337s)
[232.326993] [022/131] (858s left) kms_rotation_crc (primary-rotation-90)
[232.522252] Starting subtest: primary-rotation-90
[247.584356] Subtest primary-rotation-90: SUCCESS (15.064s)
[247.850548] [023/131] (843s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[248.043316] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[251.084175] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (3.044s)
[251.366381] [024/131] (840s left) kms_universal_plane (universal-plane-sanity)
[251.554401] Starting subtest: universal-plane-sanity
[251.558626] Starting dynamic subtest: pipe-A-HDMI-A-1
[252.382339] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.821s)
[252.404368] Starting dynamic subtest: pipe-B-HDMI-A-2
[252.904637] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.521s)
[252.924999] Starting dynamic subtest: pipe-C-HDMI-A-1
[253.487309] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.533s)
[253.529779] Subtest universal-plane-sanity: SUCCESS (1.888s)
[253.752444] [025/131] (837s left) gem_exec_schedule (u-fairslice-all)
[253.891950] Starting subtest: u-fairslice-all
[255.999623] Subtest u-fairslice-all: SUCCESS (2.107s)
[256.415883] [026/131] (835s left) gem_exec_fence (nb-await)
[256.668152] Starting subtest: nb-await
[256.671367] Starting dynamic subtest: rcs0
[256.744115] Dynamic subtest rcs0: SUCCESS (0.077s)
[256.764092] Starting dynamic subtest: bcs0
[256.818085] Dynamic subtest bcs0: SUCCESS (0.070s)
[256.838389] Starting dynamic subtest: vcs0
[256.887498] Dynamic subtest vcs0: SUCCESS (0.068s)
[256.907357] Starting dynamic subtest: vecs0
[256.960023] Dynamic subtest vecs0: SUCCESS (0.070s)
[256.964259] Subtest nb-await: SUCCESS (0.295s)
[257.753316] [FACT gem_exec_fence (nb-await)] new: kernel.kmod_is_loaded.vgem: true
[257.759878] [027/131] (833s left) kms_hdr (invalid-hdr)
[257.975811] Starting subtest: invalid-hdr
[285.434655] Subtest invalid-hdr: SKIP (27.439s)
[285.838767] [028/131] (805s left) kms_debugfs (display-on-read-all)
[286.087304] Starting subtest: display-on-read-all
[286.479060] Subtest display-on-read-all: SUCCESS (0.392s)
[286.761867] [029/131] (805s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[286.941588] Starting subtest: plane-primary-overlay-mutable-zpos
[287.968352] Subtest plane-primary-overlay-mutable-zpos: SKIP (0.887s)
[288.707196] [030/131] (803s left) i915_pm_rps (engine-order)
[288.836125] Starting subtest: engine-order
[300.278870] Subtest engine-order: SUCCESS (11.433s)
[300.493575] [031/131] (791s left) i915_drm_fdinfo (virtual-busy-hang-all)
[300.603124] Starting subtest: virtual-busy-hang-all
[300.606858] Subtest virtual-busy-hang-all: SUCCESS (0.002s)
[300.786136] [032/131] (791s left) kms_psr (fbc-psr-primary-mmap-cpu)
[300.981954] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.000s)
[301.134316] [033/131] (791s left) gem_exec_schedule (out-order)
[301.284088] Starting subtest: out-order
[301.287525] Starting dynamic subtest: rcs0
[301.407574] Dynamic subtest rcs0: SUCCESS (0.120s)
[301.441711] Starting dynamic subtest: bcs0
[301.532055] Dynamic subtest bcs0: SUCCESS (0.127s)
[301.564395] Starting dynamic subtest: vcs0
[301.664343] Dynamic subtest vcs0: SUCCESS (0.116s)
[301.692032] Starting dynamic subtest: vecs0
[301.779713] Dynamic subtest vecs0: SUCCESS (0.115s)
[301.783580] Subtest out-order: SUCCESS (0.492s)
[302.213186] [034/131] (790s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[302.406239] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[302.449827] Starting dynamic subtest: pipe-A-valid-mode
[302.787969] Dynamic subtest pipe-A-valid-mode: SKIP (0.371s)
[302.838030] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.378s)
[303.111372] [035/131] (789s left) core_getclient (basic)
[303.224745] Starting subtest: basic
[303.228243] Subtest basic: SUCCESS (0.000s)
[303.407538] [036/131] (789s left) prime_busy (after-wait)
[303.521239] Starting subtest: after-wait
[303.535674] Starting dynamic subtest: rcs0
[303.545058] Dynamic subtest rcs0: SUCCESS (0.010s)
[303.566784] Starting dynamic subtest: bcs0
[303.571490] Dynamic subtest bcs0: SUCCESS (0.016s)
[303.595087] Starting dynamic subtest: vcs0
[303.599162] Dynamic subtest vcs0: SUCCESS (0.019s)
[303.621706] Starting dynamic subtest: vecs0
[303.626284] Dynamic subtest vecs0: SUCCESS (0.016s)
[303.719129] Subtest after-wait: SUCCESS (0.198s)
[303.906173] [037/131] (789s left) gem_exec_schedule (u-submit-golden-slice)
[304.044136] Starting subtest: u-submit-golden-slice
[304.047447] Starting dynamic subtest: rcs0
[304.092858] Dynamic subtest rcs0: SUCCESS (0.050s)
[304.114634] Starting dynamic subtest: bcs0
[304.146098] Dynamic subtest bcs0: SUCCESS (0.049s)
[304.167564] Starting dynamic subtest: vcs0
[304.201597] Dynamic subtest vcs0: SUCCESS (0.051s)
[304.223492] Starting dynamic subtest: vecs0
[304.252567] Dynamic subtest vecs0: SUCCESS (0.049s)
[304.255956] Subtest u-submit-golden-slice: SUCCESS (0.214s)
[304.690138] [038/131] (788s left) gem_eio (in-flight-contexts-immediate)
[304.823084] Starting subtest: in-flight-contexts-immediate
[316.004773] Subtest in-flight-contexts-immediate: SUCCESS (11.178s)
[316.325564] [039/131] (776s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[318.976217] Starting subtest: verify-pxp-key-change-after-suspend-resume
[318.984823] Subtest verify-pxp-key-change-after-suspend-resume: SKIP (0.001s)
[319.157265] [040/131] (774s left) gem_softpin (evict-active-interruptible)
[319.278089] Starting subtest: evict-active-interruptible
[319.295298] Subtest evict-active-interruptible: SUCCESS (0.018s)
[319.483101] [041/131] (774s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[319.690447] Starting subtest: 4-tiled-8bpp-rotate-180
[319.698531] Subtest 4-tiled-8bpp-rotate-180: SKIP (0.000s)
[319.878571] [042/131] (773s left) gem_userptr_blits (relocations)
[320.007263] Starting subtest: relocations
[320.014073] Subtest relocations: SKIP (0.003s)
[320.227897] [043/131] (773s left) kms_busy (extended-pageflip-hang-newfb)
[320.426209] Starting subtest: extended-pageflip-hang-newfb
[320.429735] Starting dynamic subtest: pipe-A
[324.894054] Dynamic subtest pipe-A: SUCCESS (4.463s)
[324.923728] Starting dynamic subtest: pipe-C
[328.852023] Dynamic subtest pipe-C: SUCCESS (3.941s)
[328.859063] Subtest extended-pageflip-hang-newfb: SUCCESS (8.429s)
[329.239603] [044/131] (764s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[329.348646] Starting subtest: single-wait-for-submit-unsubmitted
[329.457280] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[329.647531] [045/131] (764s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[329.846932] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[333.069503] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (3.229s)
[333.384238] [046/131] (760s left) kms_plane_cursor (primary)
[333.580664] Starting subtest: primary
[333.606801] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64
[336.187115] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (2.608s)
[336.256813] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128
[338.669031] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (2.431s)
[338.741644] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256
[341.239298] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (2.429s)
[341.440953] Starting dynamic subtest: pipe-B-HDMI-A-2-size-64
[343.886520] Dynamic subtest pipe-B-HDMI-A-2-size-64: SUCCESS (2.495s)
[343.939016] Starting dynamic subtest: pipe-B-HDMI-A-2-size-128
[346.354301] Dynamic subtest pipe-B-HDMI-A-2-size-128: SUCCESS (2.432s)
[346.406475] Starting dynamic subtest: pipe-B-HDMI-A-2-size-256
[348.819686] Dynamic subtest pipe-B-HDMI-A-2-size-256: SUCCESS (2.431s)
[349.099041] Starting dynamic subtest: pipe-C-HDMI-A-1-size-64
[351.565591] Dynamic subtest pipe-C-HDMI-A-1-size-64: SUCCESS (2.506s)
[351.619253] Starting dynamic subtest: pipe-C-HDMI-A-1-size-128
[354.032098] Dynamic subtest pipe-C-HDMI-A-1-size-128: SUCCESS (2.432s)
[354.085971] Starting dynamic subtest: pipe-C-HDMI-A-1-size-256
[356.498243] Dynamic subtest pipe-C-HDMI-A-1-size-256: SUCCESS (2.432s)
[356.731493] Subtest primary: SUCCESS (23.158s)
[357.052918] [047/131] (737s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[357.286209] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[357.293094] Subtest psr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[357.469368] [048/131] (736s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[357.685335] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[357.693041] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.001s)
[357.870828] [049/131] (736s left) gem_exec_balancer (bonded-true-hang)
[358.112353] Starting subtest: bonded-true-hang
[362.147064] Subtest bonded-true-hang: SUCCESS (4.035s)
[362.341304] [050/131] (732s left) gem_exec_fence (syncobj-timeline-repeat)
[362.999827] Starting subtest: syncobj-timeline-repeat
[364.185650] Subtest syncobj-timeline-repeat: SUCCESS (1.185s)
[364.484194] [051/131] (730s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[364.589405] Starting subtest: etime-multi-wait-for-submit-submitted
[364.696057] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.107s)
[364.887885] [052/131] (729s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[364.998385] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[365.115973] [053/131] (729s left) syncobj_wait (multi-wait-submitted)
[365.229298] Starting subtest: multi-wait-submitted
[365.329225] Subtest multi-wait-submitted: SUCCESS (0.105s)
[365.516795] [054/131] (729s left) gem_ppgtt (blt-vs-render-ctx0)
[365.635270] Starting subtest: blt-vs-render-ctx0
[398.638087] Subtest blt-vs-render-ctx0: SUCCESS (33.004s)
[398.845312] [055/131] (696s left) kms_cdclk (mode-transition)
[399.079150] Subtest mode-transition: SKIP (0.000s)
[399.199307] [056/131] (695s left) kms_vrr (max-min)
[399.404389] Starting subtest: max-min
[399.417567] Subtest max-min: SKIP (0.000s)
[399.586758] [057/131] (695s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[399.800495] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[399.806967] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[399.984084] [058/131] (695s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[400.215538] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[400.223386] Starting dynamic subtest: pipe-A-valid-mode
[401.136788] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.960s)
[401.140860] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SUCCESS (0.965s)
[401.469840] [059/131] (693s left) kms_psr (fbc-pr-no-drrs)
[401.670791] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[401.783114] [060/131] (693s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[401.971147] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[401.983132] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[413.015601] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (11.038s)
[413.046680] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[423.947540] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (10.927s)
[423.976829] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[434.859706] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.904s)
[434.863139] Subtest 2x-plain-flip-fb-recreate-interruptible: SUCCESS (32.889s)
[435.481315] [061/131] (660s left) drm_read (short-buffer-nonblock)
[435.909291] Starting subtest: short-buffer-nonblock
[435.912567] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[436.248592] [062/131] (659s left) syncobj_wait (multi-wait-submitted-signaled)
[436.376725] Starting subtest: multi-wait-submitted-signaled
[436.380444] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[436.589310] [063/131] (659s left) kms_flip (2x-flip-vs-suspend)
[436.784919] Starting subtest: 2x-flip-vs-suspend
[436.788488] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2