[91.659562] Initializing watchdogs
[91.659733]   /dev/watchdog0
[91.699212] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3184 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 605]
[91.713485] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[91.721911] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[91.729237] [001/155] (960s left) kms_plane (pixel-format-yf-tiled-modifier)
[91.928280] Starting subtest: pixel-format-yf-tiled-modifier
[92.368178] Starting dynamic subtest: pipe-A-plane-0
[92.801338] Dynamic subtest pipe-A-plane-0: SUCCESS (0.435s)
[92.820493] Starting dynamic subtest: pipe-A-plane-1
[93.182615] Dynamic subtest pipe-A-plane-1: SUCCESS (0.364s)
[93.201670] Starting dynamic subtest: pipe-A-plane-2
[93.533625] Dynamic subtest pipe-A-plane-2: SUCCESS (0.367s)
[93.552559] Starting dynamic subtest: pipe-A-plane-3
[93.882154] Dynamic subtest pipe-A-plane-3: SUCCESS (0.348s)
[93.901808] Starting dynamic subtest: pipe-A-plane-4
[93.905645] Dynamic subtest pipe-A-plane-4: SKIP (0.000s)
[94.266126] Starting dynamic subtest: pipe-B-plane-0
[94.601115] Dynamic subtest pipe-B-plane-0: SUCCESS (0.350s)
[94.620486] Starting dynamic subtest: pipe-B-plane-1
[94.952508] Dynamic subtest pipe-B-plane-1: SUCCESS (0.349s)
[94.970692] Starting dynamic subtest: pipe-B-plane-2
[95.284829] Dynamic subtest pipe-B-plane-2: SUCCESS (0.333s)
[95.303491] Starting dynamic subtest: pipe-B-plane-3
[95.633122] Dynamic subtest pipe-B-plane-3: SUCCESS (0.348s)
[95.654052] Starting dynamic subtest: pipe-B-plane-4
[95.662137] Dynamic subtest pipe-B-plane-4: SKIP (0.000s)
[95.844561] Subtest pixel-format-yf-tiled-modifier: SUCCESS (3.919s)
[96.184668] [002/155] (956s left) gem_exec_schedule (preempt-queue-contexts-chain)
[96.330992] Starting subtest: preempt-queue-contexts-chain
[96.333271] Starting dynamic subtest: rcs0
[97.268363] Dynamic subtest rcs0: SUCCESS (0.936s)
[97.293672] Starting dynamic subtest: bcs0
[98.148641] Dynamic subtest bcs0: SUCCESS (0.878s)
[98.175938] Starting dynamic subtest: vcs0
[99.008891] Dynamic subtest vcs0: SUCCESS (0.860s)
[99.036726] Starting dynamic subtest: vecs0
[99.858611] Dynamic subtest vecs0: SUCCESS (0.849s)
[99.860609] Subtest preempt-queue-contexts-chain: SUCCESS (3.527s)
[100.254368] [003/155] (952s left) gem_mmap_gtt (bad-object)
[100.354593] Starting subtest: bad-object
[100.357038] Subtest bad-object: SUCCESS (0.000s)
[100.537409] [004/155] (951s left) kms_getfb (getfb-handle-not-fb)
[100.713068] Starting subtest: getfb-handle-not-fb
[100.715114] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[100.870427] [005/155] (951s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[100.989428] Starting subtest: y-tiled-ccs-to-yf-tiled
[100.991785] Starting dynamic subtest: smem
[101.311243] Dynamic subtest smem: SUCCESS (0.322s)
[101.313249] Subtest y-tiled-ccs-to-yf-tiled: SUCCESS (0.323s)
[101.554325] [006/155] (951s left) i915_pm_rpm (debugfs-read)
[103.468693] Starting subtest: debugfs-read
[103.673073] Subtest debugfs-read: SUCCESS (0.206s)
[104.081113] [007/155] (948s left) prime_vgem (fence-wait)
[104.323130] Starting subtest: fence-wait
[104.324926] Starting dynamic subtest: rcs0
[105.364137] Dynamic subtest rcs0: SUCCESS (1.042s)
[105.384403] Starting dynamic subtest: vcs0
[106.397669] Dynamic subtest vcs0: SUCCESS (1.032s)
[106.417317] Starting dynamic subtest: vecs0
[107.428683] Dynamic subtest vecs0: SUCCESS (1.028s)
[107.430867] Subtest fence-wait: SUCCESS (3.106s)
[107.585298] [FACT prime_vgem (fence-wait)] new: kernel.kmod_is_loaded.vgem: true
[107.592435] [008/155] (945s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[107.780572] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[107.784547] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[107.943427] [009/155] (944s left) kms_cursor_crc (cursor-random-max-size)
[108.133202] Starting subtest: cursor-random-max-size
[108.138823] Subtest cursor-random-max-size: SKIP (0.000s)
[108.277279] [010/155] (944s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[108.382507] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[108.486253] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.101s)
[108.623282] [011/155] (944s left) gem_wait (wait)
[108.754617] Starting subtest: wait
[108.756767] Starting dynamic subtest: all-engines
[109.792970] Dynamic subtest all-engines: SUCCESS (1.038s)
[109.818448] Starting dynamic subtest: rcs0
[110.825151] Dynamic subtest rcs0: SUCCESS (1.031s)
[110.845346] Starting dynamic subtest: bcs0
[111.859841] Dynamic subtest bcs0: SUCCESS (1.033s)
[111.880186] Starting dynamic subtest: vcs0
[112.889222] Dynamic subtest vcs0: SUCCESS (1.029s)
[112.909620] Starting dynamic subtest: vecs0
[113.919264] Dynamic subtest vecs0: SUCCESS (1.029s)
[113.921233] Subtest wait: SUCCESS (5.165s)
[114.192792] [012/155] (938s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[114.363059] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[114.366828] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[115.043610] [013/155] (938s left) gem_softpin (overlap)
[115.158983] Starting subtest: overlap
[117.572529] Subtest overlap: SUCCESS (2.411s)
[117.745329] [014/155] (935s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[117.917531] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[117.919279] Starting dynamic subtest: pipe-A
[121.793922] Dynamic subtest pipe-A: SKIP (3.870s)
[121.814997] Starting dynamic subtest: pipe-B
[125.688917] Dynamic subtest pipe-B: SKIP (3.893s)
[125.709134] Starting dynamic subtest: pipe-C
[129.702820] Dynamic subtest pipe-C: SKIP (3.999s)
[129.707653] Subtest plane-scaler-with-clipping-clamping-rotation: SKIP (11.768s)
[130.231839] [015/155] (923s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[130.488501] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[130.492537] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[130.646987] [016/155] (922s left) kms_joiner (basic-big-joiner)
[130.826056] Starting subtest: basic-big-joiner
[130.829754] Subtest basic-big-joiner: SKIP (0.000s)
[130.963560] [017/155] (922s left) i915_drm_fdinfo (idle)
[131.074809] Starting subtest: idle
[131.077088] Starting dynamic subtest: rcs0
[131.583266] Dynamic subtest rcs0: SUCCESS (0.505s)
[131.602982] Starting dynamic subtest: bcs0
[132.090472] Dynamic subtest bcs0: SUCCESS (0.504s)
[132.110291] Starting dynamic subtest: vcs0
[132.597522] Dynamic subtest vcs0: SUCCESS (0.505s)
[132.617591] Starting dynamic subtest: vecs0
[133.105228] Dynamic subtest vecs0: SUCCESS (0.505s)
[133.107201] Subtest idle: SUCCESS (2.031s)
[133.246353] [018/155] (920s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[133.437160] Starting subtest: psr-rgb101010-draw-mmap-gtt
[133.441014] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[133.596052] [019/155] (920s left) kms_psr (fbc-psr-suspend)
[133.771827] Subtest fbc-psr-suspend: SKIP (0.000s)
[133.873204] [020/155] (920s left) gen9_exec_parse (cmd-crossing-page)
[133.998652] Starting subtest: cmd-crossing-page
[134.002344] Subtest cmd-crossing-page: SUCCESS (0.007s)
[134.264370] [021/155] (919s left) gem_mmap_wc (bad-offset)
[134.364490] Starting subtest: bad-offset
[134.366511] Subtest bad-offset: SUCCESS (0.001s)
[134.530276] [022/155] (919s left) gem_ctx_bad_destroy (invalid-ctx)
[134.633383] Starting subtest: invalid-ctx
[134.635339] Subtest invalid-ctx: SUCCESS (0.000s)
[134.780824] [023/155] (919s left) vgem_basic (unload)
[134.877803] Starting subtest: unload
[163.939398] Subtest unload: SUCCESS (29.058s)
[164.130499] [024/155] (890s left) gem_ctx_param (invalid-set-ringsize)
[164.235053] Starting subtest: invalid-set-ringsize
[164.237063] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[164.380362] [025/155] (890s left) kms_frontbuffer_tracking (hdr-rgb565-draw-pwrite)
[164.573280] Starting subtest: hdr-rgb565-draw-pwrite
[165.579538] Subtest hdr-rgb565-draw-pwrite: SUCCESS (1.009s)
[165.862412] [026/155] (888s left) kms_prop_blob (basic)
[165.968199] Starting subtest: basic
[165.970253] Subtest basic: SUCCESS (0.000s)
[166.110342] [027/155] (888s left) kms_psr (psr2-primary-mmap-cpu)
[166.288953] Subtest psr2-primary-mmap-cpu: SKIP (0.000s)
[166.388738] [028/155] (888s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[166.579527] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[169.395420] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SUCCESS (2.815s)
[169.603272] [029/155] (885s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[169.782826] Starting subtest: plane-all-transition-nonblocking-fencing
[169.784898] Starting dynamic subtest: pipe-A-HDMI-A-1
[174.342523] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.558s)
[174.581439] Starting dynamic subtest: pipe-A-HDMI-A-2
[178.903433] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (4.343s)
[179.140877] Starting dynamic subtest: pipe-B-HDMI-A-1
[183.438565] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (4.318s)
[183.658114] Starting dynamic subtest: pipe-B-HDMI-A-2
[187.823365] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (4.185s)
[188.019208] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (18.235s)
[188.338937] [030/155] (866s left) gem_exec_balancer (bonded-dual)
[188.496525] Starting subtest: bonded-dual
[192.712908] Subtest bonded-dual: SUCCESS (4.218s)
[192.972753] [031/155] (862s left) kms_pm_rpm (dpms-lpsp)
[194.837580] Starting subtest: dpms-lpsp
[194.841337] Subtest dpms-lpsp: SKIP (0.000s)
[195.276179] [032/155] (859s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[195.475344] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[195.479114] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[195.594830] [033/155] (859s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[195.775081] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[195.887894] [034/155] (859s left) gem_exec_nop (basic-sequential)
[196.010896] Starting subtest: basic-sequential
[199.115465] Subtest basic-sequential: SUCCESS (3.103s)
[199.390258] [035/155] (855s left) perf_pmu (invalid-init)
[199.503543] Starting subtest: invalid-init
[199.505581] Subtest invalid-init: SUCCESS (0.001s)
[199.659809] [036/155] (855s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[199.846387] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[199.850124] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[200.041164] [037/155] (855s left) kms_cursor_crc (cursor-suspend)
[200.221722] Starting subtest: cursor-suspend
[200.223794] Starting dynamic subtest: pipe-A-HDMI-A-1