[99.185521] Initializing watchdogs
[99.185690]   /dev/watchdog0
[99.240421] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[99.253877] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[99.262614] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[99.268524] [001/130] (960s left) gem_exec_schedule (submit-late-slice)
[99.727024] Starting subtest: submit-late-slice
[99.729158] Starting dynamic subtest: rcs0
[99.780441] Dynamic subtest rcs0: SUCCESS (0.053s)
[99.798449] Starting dynamic subtest: bcs0
[99.825811] Dynamic subtest bcs0: SUCCESS (0.046s)
[99.840672] Starting dynamic subtest: vcs0
[99.876967] Dynamic subtest vcs0: SUCCESS (0.049s)
[99.892932] Starting dynamic subtest: vecs0
[99.926685] Dynamic subtest vecs0: SUCCESS (0.049s)
[99.928730] Subtest submit-late-slice: SUCCESS (0.202s)
[100.325286] [002/130] (959s left) prime_vgem (wait)
[100.547448] Starting subtest: wait
[100.548844] Starting dynamic subtest: rcs0
[100.565973] Dynamic subtest rcs0: SUCCESS (0.020s)
[100.585056] Starting dynamic subtest: vcs0
[100.586178] Dynamic subtest vcs0: SUCCESS (0.015s)
[100.601544] Starting dynamic subtest: vecs0
[100.603698] Dynamic subtest vecs0: SUCCESS (0.011s)
[100.605208] Subtest wait: SUCCESS (0.049s)
[100.750436] [FACT prime_vgem (wait)] new: kernel.kmod_is_loaded.vgem: true
[100.756266] [003/130] (959s left) gem_pipe_control_store_loop (fresh-buffer)
[100.881627] Starting subtest: fresh-buffer
[103.037604] Subtest fresh-buffer: SUCCESS (2.154s)
[103.191485] [004/130] (956s left) prime_vgem (basic-write)
[103.331683] Starting subtest: basic-write
[103.410552] Subtest basic-write: SUCCESS (0.078s)
[103.552145] [005/130] (956s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[103.768920] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[103.773183] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.001s)
[103.911976] [006/130] (956s left) kms_psr (pr-cursor-render)
[104.110081] Subtest pr-cursor-render: SKIP (0.000s)
[104.216604] [007/130] (956s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[104.414181] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[104.415942] Starting dynamic subtest: pipe-A-HDMI-A-1
[104.427432] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[104.512701] Starting dynamic subtest: pipe-A-HDMI-A-2
[104.524908] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[104.542469] Starting dynamic subtest: pipe-B-HDMI-A-1
[104.553704] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[104.569372] Starting dynamic subtest: pipe-B-HDMI-A-2
[104.583029] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[104.599057] Starting dynamic subtest: pipe-C-HDMI-A-1
[104.610563] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[104.624556] Starting dynamic subtest: pipe-C-HDMI-A-2
[104.635883] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[104.638265] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SKIP (0.036s)
[105.344517] [008/130] (955s left) gem_mmap (bad-object)
[105.463419] Starting subtest: bad-object
[105.464810] Subtest bad-object: SUCCESS (0.001s)
[105.593704] [009/130] (954s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[105.808914] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[105.812288] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[105.946623] [010/130] (954s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[106.146245] Starting subtest: cursorB-vs-flipB-toggle
[117.405909] Subtest cursorB-vs-flipB-toggle: SUCCESS (11.259s)
[117.681654] [011/130] (942s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[117.902824] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[120.746822] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (2.840s)
[121.016570] [012/130] (939s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-25)
[121.213969] Starting subtest: planes-unity-scaling-downscale-factor-0-25
[121.216328] Starting dynamic subtest: pipe-A
[127.604766] Dynamic subtest pipe-A: SKIP (6.385s)
[127.632841] Starting dynamic subtest: pipe-B
[133.897523] Dynamic subtest pipe-B: SKIP (6.296s)
[133.925361] Starting dynamic subtest: pipe-C
[133.955890] Dynamic subtest pipe-C: SKIP (0.053s)
[133.960567] Subtest planes-unity-scaling-downscale-factor-0-25: SKIP (12.743s)
[134.128829] [013/130] (926s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[134.303592] Starting subtest: tiled-to-untiled
[134.425315] Subtest tiled-to-untiled: SUCCESS (0.117s)
[134.580334] [014/130] (926s left) gem_softpin (evict-snoop-interruptible)
[134.715641] Starting subtest: evict-snoop-interruptible
[134.719803] Subtest evict-snoop-interruptible: SKIP (0.000s)
[134.864469] [015/130] (926s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[135.072253] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[135.073872] Starting dynamic subtest: pipe-A-HDMI-A-1
[135.126322] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.016s)
[135.155300] Starting dynamic subtest: pipe-A-HDMI-A-2
[135.213934] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.015s)
[135.315981] Starting dynamic subtest: pipe-B-HDMI-A-1
[135.365026] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.027s)
[135.381606] Starting dynamic subtest: pipe-B-HDMI-A-2
[135.428929] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.014s)
[135.443443] Starting dynamic subtest: pipe-C-HDMI-A-1
[135.491672] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.016s)
[135.509651] Starting dynamic subtest: pipe-C-HDMI-A-2
[135.556955] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.015s)
[135.559278] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SKIP (0.141s)
[136.129550] [016/130] (924s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[136.354978] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[136.357840] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[136.499143] [017/130] (924s left) gem_ppgtt (shrink-vs-evict-pinned)
[136.632611] Starting subtest: shrink-vs-evict-pinned
[141.710205] Subtest shrink-vs-evict-pinned: SUCCESS (5.076s)
[141.839190] [018/130] (919s left) kms_flip (2x-modeset-vs-vblank-race)
[142.049936] Starting subtest: 2x-modeset-vs-vblank-race
[142.051851] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[146.903059] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (4.845s)
[146.927315] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[151.741919] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (4.814s)
[151.776931] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[156.523865] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (4.775s)
[156.525729] Subtest 2x-modeset-vs-vblank-race: SUCCESS (14.481s)
[157.146251] [019/130] (904s left) gem_ctx_param (invalid-get-ringsize)
[157.283246] Starting subtest: invalid-get-ringsize
[157.284675] Subtest invalid-get-ringsize: SUCCESS (0.000s)
[157.427481] [020/130] (904s left) kms_frontbuffer_tracking (psr-1p-rte)
[157.649339] Starting subtest: psr-1p-rte
[157.652815] Subtest psr-1p-rte: SKIP (0.000s)
[157.803746] [021/130] (903s left) gem_exec_balancer (bonded-pair)
[157.952871] Starting subtest: bonded-pair
[161.562945] Subtest bonded-pair: SUCCESS (3.607s)
[161.830269] [022/130] (899s left) gem_exec_whisper (basic-sync-all)
[161.972909] Starting subtest: basic-sync-all
[168.620835] Subtest basic-sync-all: SUCCESS (6.647s)
[168.898259] [023/130] (892s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[169.025194] Starting subtest: cpuset-basic-small-copy-XY
[176.084060] Subtest cpuset-basic-small-copy-XY: SUCCESS (7.059s)
[176.238138] [024/130] (885s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[177.061144] Starting subtest: syncobj-stationary-timeline-chain-engines
[177.167185] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.104s)
[177.433318] [025/130] (884s left) kms_psr2_su (page_flip-nv12)
[177.553222] Subtest page_flip-NV12: SKIP (0.000s)
[177.665284] [026/130] (884s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[177.896843] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[177.901936] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[178.047475] [027/130] (884s left) i915_pm_rps (thresholds-idle-park)
[178.179460] Starting subtest: thresholds-idle-park
[178.180566] Starting dynamic subtest: gt0
[193.495602] Dynamic subtest gt0: SUCCESS (15.309s)
[193.497260] Subtest thresholds-idle-park: SUCCESS (15.314s)
[193.650718] [028/130] (868s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[193.870965] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[193.874823] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[194.024595] [029/130] (868s left) kms_atomic (atomic-plane-damage)
[194.245538] Starting subtest: atomic-plane-damage
[195.226057] Subtest atomic-plane-damage: SKIP (0.978s)
[195.682773] [030/130] (866s left) syncobj_wait (multi-wait-all-submitted)
[195.818983] Starting subtest: multi-wait-all-submitted
[195.931300] Subtest multi-wait-all-submitted: SUCCESS (0.109s)
[196.072802] [031/130] (866s left) syncobj_wait (invalid-reset-illegal-handle)
[196.191549] Starting subtest: invalid-reset-illegal-handle
[196.193354] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[196.339969] [032/130] (866s left) gem_userptr_blits (dmabuf-unsync)
[196.466521] Subtest dmabuf-unsync: SKIP (0.000s)
[196.668832] [033/130] (866s left) gem_lmem_swapping (parallel-multi)
[196.797490] Subtest parallel-multi: SKIP (0.000s)
[196.909783] [034/130] (865s left) syncobj_timeline (host-signal-points)
[197.031364] Starting subtest: host-signal-points
[197.048410] Subtest host-signal-points: SUCCESS (0.020s)
[197.203389] [035/130] (865s left) gen9_exec_parse (bb-large)
[197.346057] Starting subtest: bb-large
[262.220300] Subtest bb-large: SUCCESS (64.875s)
[262.509149] [036/130] (800s left) gem_ccs (large-ctrl-surf-copy)
[262.733323] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[262.853064] [037/130] (800s left) perf_pmu (semaphore-busy)
[262.987253] Starting subtest: semaphore-busy
[262.988758] Starting dynamic subtest: rcs0
[264.539582] Dynamic subtest rcs0: SUCCESS (1.547s)
[264.560800] Starting dynamic subtest: bcs0
[266.101522] Dynamic subtest bcs0: SUCCESS (1.557s)
[266.120538] Starting dynamic subtest: vcs0
[267.647657] Dynamic subtest vcs0: SUCCESS (1.544s)
[267.666596] Starting dynamic subtest: vecs0
[269.197896] Dynamic subtest vecs0: SUCCESS (1.547s)
[269.199174] Subtest semaphore-busy: SUCCESS (6.212s)
[269.349893] [038/130] (793s left) kms_addfb_basic (invalid-get-prop)
[269.467577] Starting subtest: invalid-get-prop
[269.468763] Subtest invalid-get-prop: SUCCESS (0.000s)
[269.715470] [039/130] (793s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[269.945253] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[269.950269] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[270.097616] [040/130] (793s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-pwrite)
[270.319578] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-pwrite
[270.324314] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-pwrite: SKIP (0.000s)
[270.464209] [041/130] (792s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[270.673058] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[270.674183] Starting dynamic subtest: pipe-A-valid-mode
[271.214858] Dynamic subtest pipe-A-valid-mode: SKIP (0.533s)
[271.217428] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SKIP (0.539s)
[271.625513] [042/130] (791s left) gem_exec_reloc (basic-scanout)
[271.851041] Starting subtest: basic-scanout
[271.852075] Starting dynamic subtest: rcs0
[272.431599] Dynamic subtest rcs0: SUCCESS (0.581s)
[272.459513] Starting dynamic subtest: bcs0
[272.648044] Dynamic subtest bcs0: SUCCESS (0.212s)
[272.674966] Starting dynamic subtest: vcs0
[272.866336] Dynamic subtest vcs0: SUCCESS (0.212s)
[272.886250] Starting dynamic subtest: vecs0
[273.082149] Dynamic subtest vecs0: SUCCESS (0.212s)
[273.083487] Subtest basic-scanout: SUCCESS (1.236s)
[273.341184] [043/130] (790s left) kms_flip (2x-flip-vs-suspend)
[273.538599] Starting subtest: 2x-flip-vs-suspend
[273.551582] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2