[87.424232] Initializing watchdogs
[87.424472]   /dev/watchdog0
[87.463318] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3184 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 605]
[87.477029] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[87.483884] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[87.489386] [001/133] (960s left) sysfs_preempt_timeout (timeout)
[87.615452] Starting subtest: timeout
[87.616570] Starting dynamic subtest: vecs0
[88.505678] Dynamic subtest vecs0: SUCCESS (0.889s)
[88.522748] Starting dynamic subtest: vcs0
[89.423074] Dynamic subtest vcs0: SUCCESS (0.913s)
[89.438701] Starting dynamic subtest: bcs0
[90.317087] Dynamic subtest bcs0: SUCCESS (0.893s)
[90.334607] Starting dynamic subtest: rcs0
[91.210780] Dynamic subtest rcs0: SUCCESS (0.895s)
[91.211796] Subtest timeout: SUCCESS (3.596s)
[91.364123] [002/133] (956s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[91.553388] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[91.555231] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[91.698339] [003/133] (956s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[91.865671] Starting subtest: cursor-vs-flip-varying-size
[136.960368] Subtest cursor-vs-flip-varying-size: SUCCESS (45.091s)
[137.238379] [004/133] (910s left) kms_chamelium_audio (dp-audio-edid)
[137.769520] Subtest dp-audio-edid: SKIP (0.000s)
[137.987107] [005/133] (910s left) kms_cursor_crc (cursor-alpha-opaque)
[138.152746] Starting subtest: cursor-alpha-opaque
[138.153753] Starting dynamic subtest: pipe-A-HDMI-A-1
[139.056353] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.895s)
[139.077065] Starting dynamic subtest: pipe-C-HDMI-A-1
[139.617117] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.564s)
[139.617948] Subtest cursor-alpha-opaque: SUCCESS (1.465s)
[139.924239] [006/133] (908s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[140.091214] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[140.313887] Starting dynamic subtest: pipe-A-plane-0
[140.616492] Dynamic subtest pipe-A-plane-0: SUCCESS (0.302s)
[140.632689] Starting dynamic subtest: pipe-A-plane-1
[140.882328] Dynamic subtest pipe-A-plane-1: SUCCESS (0.265s)
[140.898628] Starting dynamic subtest: pipe-A-plane-2
[141.147815] Dynamic subtest pipe-A-plane-2: SUCCESS (0.265s)
[141.163567] Starting dynamic subtest: pipe-A-plane-3
[141.414091] Dynamic subtest pipe-A-plane-3: SUCCESS (0.265s)
[141.800308] Starting dynamic subtest: pipe-B-plane-0
[142.053971] Dynamic subtest pipe-B-plane-0: SUCCESS (0.267s)
[142.069857] Starting dynamic subtest: pipe-B-plane-1
[142.321365] Dynamic subtest pipe-B-plane-1: SUCCESS (0.265s)
[142.337056] Starting dynamic subtest: pipe-B-plane-2
[142.587173] Dynamic subtest pipe-B-plane-2: SUCCESS (0.265s)
[142.602828] Starting dynamic subtest: pipe-B-plane-3
[142.852988] Dynamic subtest pipe-B-plane-3: SUCCESS (0.265s)
[143.082856] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SUCCESS (2.991s)
[143.366789] [007/133] (905s left) gem_exec_flush (basic-uc-ro-default)
[143.485352] Starting subtest: basic-uc-ro-default
[148.935612] Subtest basic-uc-ro-default: SUCCESS (5.451s)
[149.168268] [008/133] (899s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[149.350239] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[149.352290] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[149.501989] [009/133] (899s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[149.671560] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[149.672509] Starting dynamic subtest: pipe-A-HDMI-A-1
[149.676312] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[149.694316] Starting dynamic subtest: pipe-A-HDMI-A-2
[149.706551] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[149.726531] Starting dynamic subtest: pipe-B-HDMI-A-1
[149.738819] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[149.758787] Starting dynamic subtest: pipe-B-HDMI-A-2
[149.771536] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[149.788466] Starting dynamic subtest: pipe-C-HDMI-A-1
[149.791895] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[149.808134] Starting dynamic subtest: pipe-C-HDMI-A-2
[149.811889] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[149.813751] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.019s)
[150.547720] [010/133] (898s left) gem_busy (parallel)
[150.793571] Starting subtest: parallel
[150.794828] Starting dynamic subtest: rcs0
[150.843334] Dynamic subtest rcs0: SUCCESS (0.047s)
[150.862257] Starting dynamic subtest: bcs0
[150.878154] Dynamic subtest bcs0: SUCCESS (0.036s)
[150.896179] Starting dynamic subtest: vcs0
[150.917636] Dynamic subtest vcs0: SUCCESS (0.038s)
[150.935691] Starting dynamic subtest: vecs0
[150.954618] Dynamic subtest vecs0: SUCCESS (0.036s)
[150.956305] Subtest parallel: SUCCESS (0.161s)
[151.249549] [011/133] (897s left) gem_exec_schedule (pi-common)
[151.495980] Starting subtest: pi-common
[151.497033] Starting dynamic subtest: rcs0
[151.604617] Dynamic subtest rcs0: SUCCESS (0.102s)
[151.634202] Starting dynamic subtest: bcs0
[151.654765] Dynamic subtest bcs0: SUCCESS (0.050s)
[151.681665] Starting dynamic subtest: vcs0
[151.702605] Dynamic subtest vcs0: SUCCESS (0.047s)
[151.730845] Starting dynamic subtest: vecs0
[151.746593] Dynamic subtest vecs0: SUCCESS (0.048s)
[151.747748] Subtest pi-common: SUCCESS (0.251s)
[151.995916] [FACT gem_exec_schedule (pi-common)] new: kernel.kmod_is_loaded.vgem: true
[151.999465] [012/133] (896s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[152.165475] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[152.169783] Starting dynamic subtest: pipe-A-HDMI-A-1
[152.178649] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.002s)
[152.198766] Starting dynamic subtest: pipe-A-HDMI-A-2
[152.229067] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.002s)
[152.245963] Starting dynamic subtest: pipe-B-HDMI-A-1
[152.253850] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.002s)
[152.272106] Starting dynamic subtest: pipe-B-HDMI-A-2
[152.279720] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.003s)
[152.296609] Starting dynamic subtest: pipe-C-HDMI-A-1
[152.304908] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[152.320743] Starting dynamic subtest: pipe-C-HDMI-A-2
[152.329309] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[152.330131] Subtest ccs-on-another-bo-yf-tiled-ccs: SUCCESS (0.028s)
[153.069529] [013/133] (895s left) i915_hangman (engine-engine-hang)
[153.185481] Starting subtest: engine-engine-hang
[153.186459] Starting dynamic subtest: rcs0
[153.776887] Dynamic subtest rcs0: SUCCESS (0.590s)
[153.794829] Starting dynamic subtest: bcs0
[154.372239] Dynamic subtest bcs0: SUCCESS (0.594s)
[154.390986] Starting dynamic subtest: vcs0
[154.954341] Dynamic subtest vcs0: SUCCESS (0.582s)
[154.973070] Starting dynamic subtest: vecs0
[155.546776] Dynamic subtest vecs0: SUCCESS (0.591s)
[155.548051] Subtest engine-engine-hang: SUCCESS (2.361s)
[155.721680] [014/133] (893s left) gem_readwrite (new-obj)
[155.820666] Starting subtest: new-obj
[155.822597] Subtest new-obj: SUCCESS (0.001s)
[155.968636] [015/133] (893s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[156.147823] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[156.149648] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[156.303538] [016/133] (892s left) kms_pm_rpm (cursor-dpms)
[158.179530] Starting subtest: cursor-dpms
[160.072324] Subtest cursor-dpms: SUCCESS (1.894s)
[160.409797] [017/133] (888s left) gem_exec_schedule (fifo)
[160.531335] Starting subtest: fifo
[160.532526] Starting dynamic subtest: rcs0
[160.654409] Dynamic subtest rcs0: SUCCESS (0.124s)
[160.674361] Starting dynamic subtest: bcs0
[160.777265] Dynamic subtest bcs0: SUCCESS (0.121s)
[160.798709] Starting dynamic subtest: vcs0
[160.888302] Dynamic subtest vcs0: SUCCESS (0.108s)
[160.910196] Starting dynamic subtest: vecs0
[161.000118] Dynamic subtest vecs0: SUCCESS (0.111s)
[161.001697] Subtest fifo: SUCCESS (0.471s)
[161.412672] [018/133] (887s left) gem_mmap_offset (bad-flags)
[161.507543] Starting subtest: bad-flags
[161.508854] Subtest bad-flags: SUCCESS (0.000s)
[161.672462] [019/133] (887s left) kms_plane (pixel-format-y-tiled-modifier)
[161.835692] Starting subtest: pixel-format-y-tiled-modifier
[162.058707] Starting dynamic subtest: pipe-A-plane-0
[162.875484] Dynamic subtest pipe-A-plane-0: SUCCESS (0.817s)
[162.892980] Starting dynamic subtest: pipe-A-plane-1
[163.592231] Dynamic subtest pipe-A-plane-1: SUCCESS (0.715s)
[163.609023] Starting dynamic subtest: pipe-A-plane-2
[164.125678] Dynamic subtest pipe-A-plane-2: SUCCESS (0.532s)
[164.142594] Starting dynamic subtest: pipe-A-plane-3
[164.659446] Dynamic subtest pipe-A-plane-3: SUCCESS (0.532s)
[164.675984] Starting dynamic subtest: pipe-A-plane-4
[164.678341] Dynamic subtest pipe-A-plane-4: SKIP (0.000s)
[165.024096] Starting dynamic subtest: pipe-B-plane-0
[165.725850] Dynamic subtest pipe-B-plane-0: SUCCESS (0.717s)
[165.743363] Starting dynamic subtest: pipe-B-plane-1
[166.492259] Dynamic subtest pipe-B-plane-1: SUCCESS (0.765s)
[166.509348] Starting dynamic subtest: pipe-B-plane-2
[167.059616] Dynamic subtest pipe-B-plane-2: SUCCESS (0.566s)
[167.076574] Starting dynamic subtest: pipe-B-plane-3
[167.610359] Dynamic subtest pipe-B-plane-3: SUCCESS (0.548s)
[167.627760] Starting dynamic subtest: pipe-B-plane-4
[167.633805] Dynamic subtest pipe-B-plane-4: SKIP (0.000s)
[167.812823] Subtest pixel-format-y-tiled-modifier: SUCCESS (5.971s)
[168.109955] [020/133] (881s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[168.294608] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[168.296544] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[168.443865] [021/133] (881s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[168.539688] Starting subtest: etime-multi-wait-all-available-unsubmitted
[168.648103] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.108s)
[168.779361] [022/133] (880s left) gem_exec_schedule (smoketest)
[169.029590] Starting subtest: smoketest
[169.030509] Starting dynamic subtest: rcs0
[174.469284] Dynamic subtest rcs0: SUCCESS (5.436s)
[174.486201] Starting dynamic subtest: bcs0
[179.907408] Dynamic subtest bcs0: SUCCESS (5.436s)
[179.924334] Starting dynamic subtest: vcs0
[185.356451] Dynamic subtest vcs0: SUCCESS (5.445s)
[185.374472] Starting dynamic subtest: vecs0
[190.791141] Dynamic subtest vecs0: SUCCESS (5.433s)
[190.792370] Subtest smoketest: SUCCESS (21.757s)
[191.027752] [023/133] (858s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[191.192165] Starting subtest: plane-upscale-factor-0-25-with-rotation
[191.193178] Starting dynamic subtest: pipe-A
[194.696085] Dynamic subtest pipe-A: SKIP (3.500s)
[194.715815] Starting dynamic subtest: pipe-B
[198.343912] Dynamic subtest pipe-B: SKIP (3.649s)
[198.361296] Starting dynamic subtest: pipe-C
[201.908184] Dynamic subtest pipe-C: SKIP (3.559s)
[201.909850] Subtest plane-upscale-factor-0-25-with-rotation: SKIP (10.715s)
[202.384649] [024/133] (847s left) gem_mmap (pf-nonblock)
[202.525828] Starting subtest: pf-nonblock
[202.529241] Subtest pf-nonblock: SUCCESS (0.005s)
[202.683785] [025/133] (847s left) kms_psr (fbc-psr2-primary-blt)
[202.852399] Subtest fbc-psr2-primary-blt: SKIP (0.000s)
[202.956064] [026/133] (847s left) gen3_mixed_blits
[203.154383] [027/133] (847s left) gem_userptr_blits (usage-restrictions)
[203.257821] Starting subtest: usage-restrictions
[203.258929] Subtest usage-restrictions: SUCCESS (0.000s)
[203.452084] [028/133] (846s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[203.631426] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[206.232899] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SUCCESS (2.600s)
[206.432989] [029/133] (843s left) gen7_exec_parse (basic-allocation)
[206.534386] Subtest basic-allocation: SKIP (0.000s)
[206.642550] [030/133] (843s left) gem_exec_fence (syncobj-signal)
[207.158736] Starting subtest: syncobj-signal
[207.163238] Subtest syncobj-signal: SUCCESS (0.006s)
[207.534562] [031/133] (842s left) gem_flink_basic (flink-lifetime)
[207.628375] Starting subtest: flink-lifetime
[207.632137] Subtest flink-lifetime: SUCCESS (0.003s)
[207.782688] [032/133] (842s left) syncobj_timeline (invalid-query-one-illegal-handle)
[207.878093] Starting subtest: invalid-query-one-illegal-handle
[207.879181] Subtest invalid-query-one-illegal-handle: SUCCESS (0.001s)
[208.016599] [033/133] (842s left) kms_psr (fbc-psr-no-drrs)
[208.182935] Subtest fbc-psr-no-drrs: SKIP (0.000s)
[208.276700] [034/133] (842s left) kms_psr (psr2-cursor-mmap-gtt)
[208.444538] Subtest psr2-cursor-mmap-gtt: SKIP (0.000s)
[208.542806] [035/133] (842s left) gem_ctx_persistence (many-contexts)
[208.645241] Starting subtest: many-contexts
[241.431813] Subtest many-contexts: SUCCESS (32.786s)
[241.567673] [036/133] (809s left) kms_flip (2x-flip-vs-panning)
[241.741446] Starting subtest: 2x-flip-vs-panning
[241.744990] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[252.534304] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (10.788s)
[252.557231] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[263.280146] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (10.742s)
[263.301686] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[273.986561] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.699s)
[273.987580] Subtest 2x-flip-vs-panning: SUCCESS (32.246s)
[274.550363] [037/133] (776s left) kms_dsc (dsc-with-bpc-formats)
[274.718588] Subtest dsc-with-bpc-formats: SKIP (0.000s)
[274.822800] [038/133] (776s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[275.012242] Starting subtest: yf-tiled-8bpp-rotate-180
[275.014355] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[275.146497] [039/133] (776s left) gem_mmap_gtt (close-race)
[275.241016] Starting subtest: close-race
[295.316165] Subtest close-race: SUCCESS (20.077s)
[295.499682] [040/133] (755s left) kms_chamelium_hpd (hdmi-hpd)
[296.026841] Subtest hdmi-hpd: SKIP (0.000s)
[296.275711] [041/133] (755s left) gem_exec_whisper (basic-normal-all)
[296.396290] Starting subtest: basic-normal-all
[300.525356] Subtest basic-normal-all: SUCCESS (4.129s)
[300.813598] [042/133] (750s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[300.984824] Subtest psr2-overlay-plane-update-continuous-sf: SKIP (0.000s)
[301.090239] [043/133] (750s left) kms_content_protection (lic-type-1)
[301.292595] Starting subtest: lic-type-1
[301.318816] Subtest lic-type-1: SKIP (0.027s)
[301.480727] [044/133] (750s left) perf (global-sseu-config)
[301.687802] Starting subtest: global-sseu-config
[301.691348] Starting dynamic subtest: 0-rcs0
[301.785628] Dynamic subtest 0-rcs0: SUCCESS (0.096s)
[301.789786] Subtest global-sseu-config: SUCCESS (0.099s)
[301.918593] [045/133] (749s left) gem_ctx_param (invalid-get-no-zeromap)
[302.013069] Starting subtest: invalid-get-no-zeromap
[302.014174] Subtest invalid-get-no-zeromap: SUCCESS (0.000s)
[302.152591] [046/133] (749s left) gem_softpin (evict-active-interruptible)
[302.265210] Starting subtest: evict-active-interruptible
[302.273565] Subtest evict-active-interruptible: SUCCESS (0.012s)
[302.445364] [047/133] (749s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[302.634063] Starting subtest: cursor-rapid-movement-512x170
[302.638339] Subtest cursor-rapid-movement-512x170: SKIP (0.003s)
[302.794452] [048/133] (749s left) gem_exec_reloc (basic-wc-read-active)
[302.901425] Starting subtest: basic-wc-read-active
[303.038707] Subtest basic-wc-read-active: SUCCESS (0.139s)
[303.247788] [049/133] (748s left) syncobj_timeline (single-wait-available-signaled)
[303.345484] Starting subtest: single-wait-available-signaled
[303.346460] Subtest single-wait-available-signaled: SUCCESS (0.001s)
[303.482627] [050/133] (748s left) gem_eio (create)
[303.601367] Starting subtest: create
[303.637449] Subtest create: SUCCESS (0.038s)
[303.865763] [051/133] (748s left) gem_compute (compute-square)
[303.959887] Starting subtest: compute-square
[303.961703] Subtest compute-square: SKIP (0.000s)
[304.095313] [052/133] (748s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[304.262956] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[315.591214] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SUCCESS (11.314s)
[315.903226] [053/133] (736s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[316.101942] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (0.000s)
[316.210656] [054/133] (736s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[316.389852] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[316.391901] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[316.539815] [055/133] (736s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[316.650756] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[316.652585] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[316.891602] [056/133] (735s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[317.073632] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[317.075416] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[317.238679] [057/133] (735s left) gem_eio (in-flight-immediate)
[317.352507] Starting subtest: in-flight-immediate
[318.204297] Subtest in-flight-immediate: SUCCESS (0.850s)
[318.439945] [058/133] (734s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[318.608915] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[318.714808] [059/133] (734s left) api_intel_bb (offset-control)
[318.808915] Starting subtest: offset-control
[318.821401] Subtest offset-control: SUCCESS (0.013s)
[318.988606] [060/133] (734s left) kms_vblank (ts-continuation-suspend)
[319.157264] Starting subtest: ts-continuation-suspend
[319.158280] Starting dynamic subtest: pipe-A-HDMI-A-1
[338.333578] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.241s)
[338.356751] Starting dynamic subtest: pipe-A-HDMI-A-2