[90.609427] Initializing watchdogs
[90.609604]   /dev/watchdog0
[90.650454] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[90.664915] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[90.671770] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[90.680270] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[90.909495] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[90.916178] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[91.066828] [002/133] (960s left) kms_draw_crc (fill-fb)
[91.262164] Starting subtest: fill-fb
[91.883867] Subtest fill-fb: SUCCESS (0.628s)
[92.151055] [003/133] (959s left) kms_psr (fbc-psr-cursor-blt)
[92.345078] Subtest fbc-psr-cursor-blt: SKIP (0.000s)
[92.447733] [004/133] (959s left) syncobj_eventfd (timeline-wait-before-signal)
[92.561621] Starting subtest: timeline-wait-before-signal
[92.594498] Subtest timeline-wait-before-signal: SUCCESS (0.035s)
[92.733831] [005/133] (958s left) gem_exec_balancer (fairslice)
[92.868139] Starting subtest: fairslice
[92.876841] Subtest fairslice: SKIP (0.000s)
[93.137160] [006/133] (958s left) kms_invalid_mode (bad-hsync-start)
[93.326499] Starting subtest: bad-hsync-start
[93.332593] Starting dynamic subtest: pipe-A-HDMI-A-1
[93.741256] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.412s)
[93.772581] Starting dynamic subtest: pipe-A-HDMI-A-2
[93.778675] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.002s)
[93.805099] Starting dynamic subtest: pipe-B-HDMI-A-1
[93.808482] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.004s)
[93.836399] Starting dynamic subtest: pipe-B-HDMI-A-2
[93.843272] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.002s)
[93.883266] Starting dynamic subtest: pipe-C-HDMI-A-1
[93.889567] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.003s)
[93.929260] Starting dynamic subtest: pipe-C-HDMI-A-2
[93.936431] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.004s)
[93.943450] Subtest bad-hsync-start: SUCCESS (0.450s)
[94.141598] [007/133] (957s left) gem_ctx_isolation (clean)
[94.277947] Starting subtest: clean
[94.282501] Starting dynamic subtest: rcs0
[94.359362] Dynamic subtest rcs0: SUCCESS (0.083s)
[94.381776] Starting dynamic subtest: bcs0
[94.503583] Dynamic subtest bcs0: SUCCESS (0.142s)
[94.531794] Starting dynamic subtest: vcs0
[94.595389] Dynamic subtest vcs0: SUCCESS (0.093s)
[94.615719] Starting dynamic subtest: vecs0
[94.690468] Dynamic subtest vecs0: SUCCESS (0.094s)
[94.694473] Subtest clean: SUCCESS (0.416s)
[94.942916] [008/133] (956s left) gem_ppgtt (shrink-vs-evict-pinned)
[95.059212] Starting subtest: shrink-vs-evict-pinned
[100.129309] Subtest shrink-vs-evict-pinned: SUCCESS (5.064s)
[100.250304] [009/133] (951s left) sysfs_timeslice_duration (timeout)
[100.373779] Starting subtest: timeout
[100.377192] Starting dynamic subtest: vecs0
[101.223096] Dynamic subtest vecs0: SUCCESS (0.844s)
[101.250214] Starting dynamic subtest: vcs0
[102.053221] Dynamic subtest vcs0: SUCCESS (0.831s)
[102.077256] Starting dynamic subtest: bcs0
[102.900914] Dynamic subtest bcs0: SUCCESS (0.845s)
[102.928710] Starting dynamic subtest: rcs0
[103.739568] Dynamic subtest rcs0: SUCCESS (0.840s)
[103.743672] Subtest timeout: SUCCESS (3.367s)
[103.884613] [010/133] (948s left) gem_mmap_offset (clear)
[103.994432] Starting subtest: clear
[103.998146] Starting dynamic subtest: smem0
[125.899630] Dynamic subtest smem0: SUCCESS (21.890s)
[125.903940] Subtest clear: SUCCESS (21.891s)
[126.082228] [011/133] (926s left) kms_psr (fbc-pr-cursor-plane-onoff)
[126.454786] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[126.554029] [012/133] (925s left) gem_ctx_shared (exec-shared-gtt)
[126.691908] Starting subtest: exec-shared-gtt
[126.696371] Starting dynamic subtest: rcs0
[126.707583] Dynamic subtest rcs0: SUCCESS (0.013s)
[126.741111] Starting dynamic subtest: bcs0
[126.745343] Dynamic subtest bcs0: SUCCESS (0.014s)
[126.767853] Starting dynamic subtest: vcs0
[126.772571] Dynamic subtest vcs0: SUCCESS (0.009s)
[126.795992] Starting dynamic subtest: vecs0
[126.800526] Dynamic subtest vecs0: SUCCESS (0.008s)
[126.804936] Subtest exec-shared-gtt: SUCCESS (0.046s)
[127.043186] [013/133] (925s left) gem_mmap_gtt (cpuset-medium-copy)
[127.154715] Starting subtest: cpuset-medium-copy
[134.822203] Subtest cpuset-medium-copy: SUCCESS (7.667s)
[134.964553] [014/133] (917s left) perf (blocking-parameterized)
[135.360437] Starting subtest: blocking-parameterized
[155.403225] Subtest blocking-parameterized: SUCCESS (20.036s)
[155.499226] [015/133] (896s left) kms_psr (fbc-pr-sprite-blt)
[155.698633] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[155.810301] [016/133] (896s left) gem_exec_store (cachelines)
[155.943175] Starting subtest: cachelines
[155.947226] Starting dynamic subtest: rcs0
[155.968728] Dynamic subtest rcs0: SUCCESS (0.028s)
[155.991656] Starting dynamic subtest: bcs0
[155.995489] Dynamic subtest bcs0: SUCCESS (0.021s)
[156.021061] Starting dynamic subtest: vcs0
[156.025014] Dynamic subtest vcs0: SUCCESS (0.025s)
[156.048168] Starting dynamic subtest: vecs0
[156.052478] Dynamic subtest vecs0: SUCCESS (0.025s)
[156.056712] Subtest cachelines: SUCCESS (0.102s)
[156.300265] [017/133] (896s left) gem_ctx_engines (execute-oneforall)
[156.427113] Starting subtest: execute-oneforall
[157.020076] Subtest execute-oneforall: SUCCESS (0.593s)
[157.285783] [018/133] (895s left) prime_self_import (export-vs-gem_close-race)
[157.391450] Starting subtest: export-vs-gem_close-race
[162.407670] Subtest export-vs-gem_close-race: SUCCESS (5.016s)
[162.577063] [019/133] (890s left) gem_create (create-invalid-size)
[162.686219] Starting subtest: create-invalid-size
[162.689763] Subtest create-invalid-size: SUCCESS (0.000s)
[162.951155] [020/133] (889s left) syncobj_timeline (host-signal-ordered)
[163.063540] Starting subtest: host-signal-ordered
[163.067108] Subtest host-signal-ordered: SUCCESS (0.002s)
[163.216198] [021/133] (889s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[163.418943] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[165.939826] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SUCCESS (2.526s)
[166.180250] [022/133] (886s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[166.389340] Starting subtest: 4-tiled-64bpp-rotate-180
[166.395703] Subtest 4-tiled-64bpp-rotate-180: SKIP (0.000s)
[166.531135] [023/133] (886s left) kms_fence_pin_leak
[170.530831] [024/133] (882s left) gem_eio (wait-wedge-10ms)
[170.674520] Starting subtest: wait-wedge-10ms
[170.778240] Subtest wait-wedge-10ms: SUCCESS (0.097s)
[171.028943] [025/133] (882s left) kms_legacy_colorkey (basic)
[171.210390] Starting subtest: basic
[171.213945] Starting dynamic subtest: pipe-A
[171.251408] Dynamic subtest pipe-A: SUCCESS (0.040s)
[171.274645] Starting dynamic subtest: pipe-B
[171.288116] Dynamic subtest pipe-B: SUCCESS (0.036s)
[171.318419] Starting dynamic subtest: pipe-C
[171.321627] Dynamic subtest pipe-C: SUCCESS (0.001s)
[171.324684] Subtest basic: SUCCESS (0.079s)
[171.427755] [026/133] (882s left) perf_pmu (most-busy-check-all)
[171.544356] Starting subtest: most-busy-check-all
[171.547822] Starting dynamic subtest: rcs0
[172.069955] Dynamic subtest rcs0: SUCCESS (0.525s)
[172.094980] Starting dynamic subtest: bcs0
[172.593125] Dynamic subtest bcs0: SUCCESS (0.526s)
[172.618416] Starting dynamic subtest: vcs0
[173.119559] Dynamic subtest vcs0: SUCCESS (0.525s)
[173.145337] Starting dynamic subtest: vecs0
[173.643094] Dynamic subtest vecs0: SUCCESS (0.520s)
[173.646655] Subtest most-busy-check-all: SUCCESS (2.099s)
[173.777926] [027/133] (879s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[173.958209] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[173.961270] Starting dynamic subtest: pipe-A-HDMI-A-1
[174.001054] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[174.055407] Starting dynamic subtest: pipe-A-HDMI-A-2
[174.093890] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.001s)
[174.123795] Starting dynamic subtest: pipe-B-HDMI-A-1
[174.157880] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[174.182456] Starting dynamic subtest: pipe-B-HDMI-A-2
[174.209052] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.001s)
[174.233307] Starting dynamic subtest: pipe-C-HDMI-A-1
[174.267594] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[174.292408] Starting dynamic subtest: pipe-C-HDMI-A-2
[174.324736] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[174.328026] Subtest missing-ccs-buffer-y-tiled-ccs: SUCCESS (0.020s)
[174.931945] [028/133] (878s left) prime_vgem (basic-blt)
[175.171286] Starting subtest: basic-blt
[175.230919] Subtest basic-blt: SUCCESS (0.058s)
[175.400827] [FACT prime_vgem (basic-blt)] new: kernel.kmod_is_loaded.vgem: true
[175.407625] [029/133] (878s left) core_auth (basic-auth)
[175.512506] Starting subtest: basic-auth
[175.516477] Subtest basic-auth: SUCCESS (0.001s)
[175.686211] [030/133] (878s left) gem_softpin (evict-active)
[175.817366] Starting subtest: evict-active
[175.823997] Subtest evict-active: SUCCESS (0.012s)
[175.990779] [031/133] (878s left) syncobj_wait (multi-wait-submitted-signaled)
[176.100409] Starting subtest: multi-wait-submitted-signaled
[176.103934] Subtest multi-wait-submitted-signaled: SUCCESS (0.003s)
[176.256265] [032/133] (877s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier)
[176.438223] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier
[176.444619] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier: SKIP (0.000s)
[176.592450] [033/133] (877s left) gem_exec_parallel (userptr)
[176.726265] Starting subtest: userptr
[176.729460] Starting dynamic subtest: rcs0
[179.883084] Dynamic subtest rcs0: SUCCESS (3.155s)
[179.909985] Starting dynamic subtest: bcs0
[183.144185] Dynamic subtest bcs0: SUCCESS (3.267s)
[183.171941] Starting dynamic subtest: vcs0
[186.598204] Dynamic subtest vcs0: SUCCESS (3.449s)
[186.625400] Starting dynamic subtest: vecs0
[189.684363] Dynamic subtest vecs0: SUCCESS (3.091s)
[189.688378] Subtest userptr: SUCCESS (12.965s)
[189.941428] [034/133] (864s left) drm_read (short-buffer-wakeup)
[190.425304] Starting subtest: short-buffer-wakeup
[222.641239] Subtest short-buffer-wakeup: SUCCESS (32.214s)
[222.924841] [035/133] (831s left) gem_linear_blits (interruptible)
[223.208266] Starting subtest: interruptible
[238.324908] Subtest interruptible: SUCCESS (15.120s)
[238.485738] [036/133] (816s left) kms_cursor_crc (cursor-random-512x512)
[238.868181] Starting subtest: cursor-random-512x512
[238.875630] Subtest cursor-random-512x512: SKIP (0.003s)
[239.028306] [037/133] (815s left) kms_pm_rpm (package-g7)
[240.968124] Starting subtest: package-g7
[240.979501] Subtest package-g7: SKIP (0.000s)
[241.360267] [038/133] (813s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[241.485541] Starting subtest: legacy-engines-hostile-preempt
[241.488853] Starting dynamic subtest: render
[241.575181] Dynamic subtest render: SUCCESS (0.086s)
[241.605307] Starting dynamic subtest: bsd
[241.654112] Dynamic subtest bsd: SUCCESS (0.077s)
[241.683423] Starting dynamic subtest: blt
[241.735153] Dynamic subtest blt: SUCCESS (0.079s)
[241.764146] Starting dynamic subtest: vebox
[241.817087] Dynamic subtest vebox: SUCCESS (0.081s)
[241.823356] Subtest legacy-engines-hostile-preempt: SUCCESS (0.332s)
[242.006045] [039/133] (812s left) gem_softpin (reverse)
[242.134447] Starting subtest: reverse
[242.139149] Subtest reverse: SUCCESS (0.011s)
[242.311261] [040/133] (812s left) kms_flip (flip-vs-suspend)
[242.495520] Starting subtest: flip-vs-suspend
[242.500163] Starting dynamic subtest: A-HDMI-A1