[131.808514] Initializing watchdogs
[131.808740]   /dev/watchdog0
[131.846966] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3184 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 605]
[131.860965] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[131.867491] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[131.872556] [001/131] (960s left) gem_exec_nop (basic-sequential)
[132.007896] Starting subtest: basic-sequential
[135.119760] Subtest basic-sequential: SUCCESS (3.111s)
[135.434718] [002/131] (957s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[135.603901] Starting subtest: 2x-long-cursor-vs-flip-atomic
[186.662297] Subtest 2x-long-cursor-vs-flip-atomic: SUCCESS (51.053s)
[186.964205] [003/131] (905s left) gem_mmap_wc (write-read-distinct)
[187.053313] Starting subtest: write-read-distinct
[187.081314] Subtest write-read-distinct: SUCCESS (0.028s)
[187.254925] [004/131] (905s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[187.420171] Starting subtest: nonblocking-crc-frame-sequence
[187.421211] Starting dynamic subtest: pipe-A-HDMI-A-1
[188.427725] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.006s)
[188.443985] Starting dynamic subtest: pipe-B-HDMI-A-2
[189.140520] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.709s)
[189.155969] Starting dynamic subtest: pipe-C-HDMI-A-1
[189.865839] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.722s)
[189.866942] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.448s)
[190.149600] [005/131] (902s left) i915_drm_fdinfo (virtual-busy)
[190.248190] Starting subtest: virtual-busy
[192.506705] Subtest virtual-busy: SUCCESS (2.258s)
[192.657387] [006/131] (900s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[192.836417] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[192.838119] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[193.000392] [007/131] (899s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[193.176271] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[193.178858] Subtest fbcpsr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[193.350365] [008/131] (899s left) sysfs_defaults (readonly)
[193.449882] Starting subtest: readonly
[193.450854] Starting dynamic subtest: vecs0
[193.451963] Dynamic subtest vecs0: SUCCESS (0.001s)
[193.466105] Starting dynamic subtest: vcs0
[193.467126] Dynamic subtest vcs0: SUCCESS (0.001s)
[193.481107] Starting dynamic subtest: bcs0
[193.482229] Dynamic subtest bcs0: SUCCESS (0.001s)
[193.496225] Starting dynamic subtest: rcs0
[193.499361] Dynamic subtest rcs0: SUCCESS (0.001s)
[193.500807] Subtest readonly: SUCCESS (0.011s)
[193.638391] [009/131] (899s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[193.731695] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[193.836263] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.103s)
[193.994745] [010/131] (899s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[194.169862] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[194.171543] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[194.333824] [011/131] (898s left) syncobj_timeline (reset-signaled)
[194.426703] Starting subtest: reset-signaled
[194.427814] Subtest reset-signaled: SUCCESS (0.001s)
[194.595474] [012/131] (898s left) gem_exec_reloc (basic-wc-gtt)
[194.698248] Starting subtest: basic-wc-gtt
[194.717236] Subtest basic-wc-gtt: SUCCESS (0.019s)
[194.934073] [013/131] (898s left) gen9_exec_parse (batch-zero-length)
[195.046338] Starting subtest: batch-zero-length
[195.048438] Subtest batch-zero-length: SUCCESS (0.002s)
[195.352476] [014/131] (898s left) gem_ctx_shared (detached-shared-gtt)
[195.461926] Starting subtest: detached-shared-gtt
[197.641027] Subtest detached-shared-gtt: SUCCESS (2.152s)
[198.160909] [015/131] (895s left) perf_pmu (rc6-all-gts)
[198.257445] Starting subtest: rc6-all-gts
[198.259215] Subtest rc6-all-gts: SKIP (0.000s)
[198.432911] [016/131] (895s left) kms_plane (plane-position-covered)
[198.593914] Starting subtest: plane-position-covered
[199.335572] Starting dynamic subtest: pipe-A-plane-1
[199.868226] Dynamic subtest pipe-A-plane-1: SUCCESS (0.537s)
[199.883452] Starting dynamic subtest: pipe-A-plane-2
[200.420075] Dynamic subtest pipe-A-plane-2: SUCCESS (0.549s)
[200.434802] Starting dynamic subtest: pipe-A-plane-3
[200.974084] Dynamic subtest pipe-A-plane-3: SUCCESS (0.552s)
[200.989165] Starting dynamic subtest: pipe-A-plane-4
[200.990838] Dynamic subtest pipe-A-plane-4: SUCCESS (0.019s)
[201.448816] Starting dynamic subtest: pipe-B-plane-1
[201.957210] Dynamic subtest pipe-B-plane-1: SUCCESS (0.522s)
[201.971940] Starting dynamic subtest: pipe-B-plane-2
[202.499819] Dynamic subtest pipe-B-plane-2: SUCCESS (0.541s)
[202.519191] Starting dynamic subtest: pipe-B-plane-3
[203.036220] Dynamic subtest pipe-B-plane-3: SUCCESS (0.535s)
[203.055670] Starting dynamic subtest: pipe-B-plane-4
[203.057439] Dynamic subtest pipe-B-plane-4: SUCCESS (0.019s)
[203.058263] Subtest plane-position-covered: SUCCESS (4.460s)
[203.363458] [017/131] (890s left) gem_mmap_gtt (fault-concurrent)
[203.453234] Starting subtest: fault-concurrent
[206.953868] Subtest fault-concurrent: SUCCESS (3.500s)
[207.208790] [018/131] (886s left) kms_psr (psr-sprite-render)
[207.372718] Subtest psr-sprite-render: SKIP (0.000s)
[207.460501] [019/131] (886s left) gem_mmap_gtt (hang-user)
[207.550386] Starting subtest: hang-user
[223.129572] Subtest hang-user: SUCCESS (15.578s)
[223.300212] [020/131] (870s left) template (a)
[223.389228] Starting subtest: A
[223.390134] Subtest A: SUCCESS (0.000s)
[223.536379] [021/131] (870s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[223.697671] Starting subtest: cursorA-vs-flipB-atomic
[235.048658] Subtest cursorA-vs-flipB-atomic: SUCCESS (11.344s)
[235.350022] [022/131] (858s left) kms_rotation_crc (primary-rotation-90)
[235.513108] Starting subtest: primary-rotation-90
[251.118100] Subtest primary-rotation-90: SUCCESS (15.606s)
[251.423399] [023/131] (842s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[251.600300] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[254.652923] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (3.051s)
[254.938778] [024/131] (839s left) kms_universal_plane (universal-plane-sanity)
[255.101859] Starting subtest: universal-plane-sanity
[255.104769] Starting dynamic subtest: pipe-A-HDMI-A-1
[255.914703] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.810s)
[255.932763] Starting dynamic subtest: pipe-B-HDMI-A-2
[256.441722] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.524s)
[256.461684] Starting dynamic subtest: pipe-C-HDMI-A-1
[256.978347] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.531s)
[256.979316] Subtest universal-plane-sanity: SUCCESS (1.878s)
[257.265915] [025/131] (836s left) gem_exec_schedule (u-fairslice-all)
[257.382249] Starting subtest: u-fairslice-all
[259.469978] Subtest u-fairslice-all: SUCCESS (2.088s)
[259.910314] [026/131] (834s left) gem_exec_fence (nb-await)
[260.148249] Starting subtest: nb-await
[260.149094] Starting dynamic subtest: rcs0
[260.220925] Dynamic subtest rcs0: SUCCESS (0.073s)
[260.239709] Starting dynamic subtest: bcs0
[260.289993] Dynamic subtest bcs0: SUCCESS (0.068s)
[260.309129] Starting dynamic subtest: vcs0
[260.359242] Dynamic subtest vcs0: SUCCESS (0.067s)
[260.378548] Starting dynamic subtest: vecs0
[260.427316] Dynamic subtest vecs0: SUCCESS (0.066s)
[260.429256] Subtest nb-await: SUCCESS (0.282s)
[261.196057] [FACT gem_exec_fence (nb-await)] new: kernel.kmod_is_loaded.vgem: true
[261.200399] [027/131] (833s left) kms_hdr (invalid-hdr)
[261.364858] Starting subtest: invalid-hdr
[261.368459] Subtest invalid-hdr: SKIP (0.001s)
[261.526958] [028/131] (832s left) kms_debugfs (display-on-read-all)
[261.692168] Starting subtest: display-on-read-all
[261.861791] Subtest display-on-read-all: SUCCESS (0.172s)
[262.096401] [029/131] (832s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[262.258743] Starting subtest: plane-primary-overlay-mutable-zpos
[263.179604] Subtest plane-primary-overlay-mutable-zpos: SKIP (0.920s)
[263.677474] [030/131] (830s left) i915_pm_rps (engine-order)
[263.785519] Starting subtest: engine-order
[275.635043] Subtest engine-order: SUCCESS (11.845s)
[275.913095] [031/131] (818s left) i915_drm_fdinfo (virtual-busy-hang-all)
[276.006813] Starting subtest: virtual-busy-hang-all
[276.009091] Subtest virtual-busy-hang-all: SUCCESS (0.001s)
[276.167311] [032/131] (818s left) kms_psr (fbc-psr-primary-mmap-cpu)
[276.333260] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.000s)
[276.425297] [033/131] (818s left) gem_exec_schedule (out-order)
[276.542781] Starting subtest: out-order
[276.543740] Starting dynamic subtest: rcs0
[276.660342] Dynamic subtest rcs0: SUCCESS (0.118s)
[276.684981] Starting dynamic subtest: bcs0
[276.782122] Dynamic subtest bcs0: SUCCESS (0.119s)
[276.801342] Starting dynamic subtest: vcs0
[276.892197] Dynamic subtest vcs0: SUCCESS (0.109s)
[276.912799] Starting dynamic subtest: vecs0
[277.004287] Dynamic subtest vecs0: SUCCESS (0.110s)
[277.006076] Subtest out-order: SUCCESS (0.464s)
[277.454312] [034/131] (817s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[277.615367] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[277.616342] Starting dynamic subtest: pipe-A-valid-mode
[277.984655] Dynamic subtest pipe-A-valid-mode: SKIP (0.366s)
[277.986547] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.370s)
[278.280976] [035/131] (816s left) core_getclient (basic)
[278.369400] Starting subtest: basic
[278.370375] Subtest basic: SUCCESS (0.000s)
[278.537107] [036/131] (816s left) prime_busy (after-wait)
[278.634817] Starting subtest: after-wait
[278.647200] Starting dynamic subtest: rcs0
[278.664512] Dynamic subtest rcs0: SUCCESS (0.017s)
[278.684288] Starting dynamic subtest: bcs0
[278.687923] Dynamic subtest bcs0: SUCCESS (0.020s)
[278.706027] Starting dynamic subtest: vcs0
[278.707381] Dynamic subtest vcs0: SUCCESS (0.019s)
[278.726728] Starting dynamic subtest: vecs0
[278.728055] Dynamic subtest vecs0: SUCCESS (0.016s)
[278.834166] Subtest after-wait: SUCCESS (0.199s)
[279.000314] [037/131] (816s left) gem_exec_schedule (u-submit-golden-slice)
[279.120675] Starting subtest: u-submit-golden-slice
[279.121772] Starting dynamic subtest: rcs0
[279.169762] Dynamic subtest rcs0: SUCCESS (0.048s)
[279.190373] Starting dynamic subtest: bcs0
[279.211257] Dynamic subtest bcs0: SUCCESS (0.040s)
[279.231793] Starting dynamic subtest: vcs0
[279.256321] Dynamic subtest vcs0: SUCCESS (0.042s)
[279.278707] Starting dynamic subtest: vecs0
[279.299267] Dynamic subtest vecs0: SUCCESS (0.042s)
[279.300859] Subtest u-submit-golden-slice: SUCCESS (0.180s)
[279.739073] [038/131] (815s left) gem_eio (in-flight-contexts-immediate)
[279.849640] Starting subtest: in-flight-contexts-immediate
[291.003492] Subtest in-flight-contexts-immediate: SUCCESS (11.153s)
[291.282729] [039/131] (804s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[293.909766] Starting subtest: verify-pxp-key-change-after-suspend-resume
[293.911723] Subtest verify-pxp-key-change-after-suspend-resume: SKIP (0.000s)
[294.067767] [040/131] (801s left) gem_softpin (evict-active-interruptible)
[294.173417] Starting subtest: evict-active-interruptible
[294.184655] Subtest evict-active-interruptible: SUCCESS (0.012s)
[294.373624] [041/131] (801s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[294.561010] Starting subtest: 4-tiled-8bpp-rotate-180
[294.563173] Subtest 4-tiled-8bpp-rotate-180: SKIP (0.000s)
[294.751215] [042/131] (800s left) gem_userptr_blits (relocations)
[294.852278] Starting subtest: relocations
[294.856644] Subtest relocations: SKIP (0.004s)
[295.095470] [043/131] (800s left) kms_busy (extended-pageflip-hang-newfb)
[295.269709] Starting subtest: extended-pageflip-hang-newfb
[295.270932] Starting dynamic subtest: pipe-A
[299.934700] Dynamic subtest pipe-A: SUCCESS (4.662s)
[299.962396] Starting dynamic subtest: pipe-C
[303.949453] Dynamic subtest pipe-C: SUCCESS (4.002s)
[303.950324] Subtest extended-pageflip-hang-newfb: SUCCESS (8.682s)
[304.297871] [044/131] (791s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[304.388439] Starting subtest: single-wait-for-submit-unsubmitted
[304.491855] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[304.649569] [045/131] (791s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[304.824260] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[308.115807] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (3.292s)
[308.467351] [046/131] (787s left) kms_plane_cursor (primary)
[308.631727] Starting subtest: primary
[308.633738] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64
[311.264965] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (2.633s)
[311.333822] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128
[313.765981] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (2.449s)
[313.833728] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256
[316.265666] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (2.449s)
[316.512726] Starting dynamic subtest: pipe-B-HDMI-A-2-size-64
[319.021317] Dynamic subtest pipe-B-HDMI-A-2-size-64: SUCCESS (2.525s)
[319.070860] Starting dynamic subtest: pipe-B-HDMI-A-2-size-128
[321.504655] Dynamic subtest pipe-B-HDMI-A-2-size-128: SUCCESS (2.450s)
[321.554270] Starting dynamic subtest: pipe-B-HDMI-A-2-size-256
[323.987325] Dynamic subtest pipe-B-HDMI-A-2-size-256: SUCCESS (2.449s)
[324.223587] Starting dynamic subtest: pipe-C-HDMI-A-1-size-64
[326.733329] Dynamic subtest pipe-C-HDMI-A-1-size-64: SUCCESS (2.526s)
[326.786652] Starting dynamic subtest: pipe-C-HDMI-A-1-size-128
[329.216808] Dynamic subtest pipe-C-HDMI-A-1-size-128: SUCCESS (2.449s)
[329.266894] Starting dynamic subtest: pipe-C-HDMI-A-1-size-256
[331.700145] Dynamic subtest pipe-C-HDMI-A-1-size-256: SUCCESS (2.449s)
[331.918226] Subtest primary: SUCCESS (23.289s)
[332.218011] [047/131] (763s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[332.402653] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[332.404435] Subtest psr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[332.568200] [048/131] (763s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[332.746428] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[332.748186] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[332.918814] [049/131] (763s left) gem_exec_balancer (bonded-true-hang)
[333.144526] Starting subtest: bonded-true-hang
[337.038421] Subtest bonded-true-hang: SUCCESS (3.895s)
[337.222878] [050/131] (759s left) gem_exec_fence (syncobj-timeline-repeat)
[337.851990] Starting subtest: syncobj-timeline-repeat
[339.080747] Subtest syncobj-timeline-repeat: SUCCESS (1.230s)
[339.360485] [051/131] (757s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[339.452711] Starting subtest: etime-multi-wait-for-submit-submitted
[339.564380] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.110s)
[339.739808] [052/131] (756s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[339.829138] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[339.932783] [053/131] (756s left) syncobj_wait (multi-wait-submitted)
[340.025049] Starting subtest: multi-wait-submitted
[340.131988] Subtest multi-wait-submitted: SUCCESS (0.106s)
[340.310845] [054/131] (756s left) gem_ppgtt (blt-vs-render-ctx0)
[340.414878] Starting subtest: blt-vs-render-ctx0
[373.441653] Subtest blt-vs-render-ctx0: SUCCESS (33.027s)
[373.663043] [055/131] (723s left) kms_cdclk (mode-transition)
[373.856954] Subtest mode-transition: SKIP (0.000s)
[373.965219] [056/131] (722s left) kms_vrr (max-min)
[374.134253] Starting subtest: max-min
[374.137867] Subtest max-min: SKIP (0.000s)
[374.302505] [057/131] (722s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[374.481141] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[374.484109] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[374.670223] [058/131] (722s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[374.833830] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[374.834915] Starting dynamic subtest: pipe-A-valid-mode
[375.768355] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.934s)
[375.770684] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SUCCESS (0.937s)
[376.096412] [059/131] (721s left) kms_psr (fbc-pr-no-drrs)
[376.264048] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[376.359384] [060/131] (720s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[376.530971] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[376.535480] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[387.550375] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (11.014s)
[387.574913] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[398.504876] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (10.950s)
[398.527488] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[409.453243] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.944s)
[409.458770] Subtest 2x-plain-flip-fb-recreate-interruptible: SUCCESS (32.923s)
[410.092390] [061/131] (687s left) drm_read (short-buffer-nonblock)
[410.506108] Starting subtest: short-buffer-nonblock
[410.507021] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[410.806821] [062/131] (686s left) syncobj_wait (multi-wait-submitted-signaled)
[410.909693] Starting subtest: multi-wait-submitted-signaled
[410.910921] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[411.076344] [063/131] (686s left) kms_flip (2x-flip-vs-suspend)
[411.243132] Starting subtest: 2x-flip-vs-suspend
[411.247435] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2