[107.852138] Initializing watchdogs
[107.852314]   /dev/watchdog0
[107.892500] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[107.907225] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[107.914715] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[107.920469] [001/132] (960s left) kms_dp_link_training (uhbr-mst)
[108.111420] Starting subtest: uhbr-mst
[108.116153] Subtest uhbr-mst: SKIP (0.000s)
[108.251018] [002/132] (960s left) perf (invalid-oa-metric-set-id)
[108.490184] Starting subtest: invalid-oa-metric-set-id
[108.513216] Subtest invalid-oa-metric-set-id: SUCCESS (0.023s)
[108.606142] [003/132] (959s left) prime_vgem (wait)
[108.827657] Starting subtest: wait
[108.829292] Starting dynamic subtest: rcs0
[108.850067] Dynamic subtest rcs0: SUCCESS (0.024s)
[108.872906] Starting dynamic subtest: vcs0
[108.874813] Dynamic subtest vcs0: SUCCESS (0.022s)
[108.897425] Starting dynamic subtest: vecs0
[108.899634] Dynamic subtest vecs0: SUCCESS (0.020s)
[108.907346] Subtest wait: SUCCESS (0.070s)
[109.058742] [FACT prime_vgem (wait)] new: kernel.kmod_is_loaded.vgem: true
[109.064215] [004/132] (959s left) kms_psr (pr-sprite-blt)
[109.258055] Subtest pr-sprite-blt: SKIP (0.000s)
[109.365979] [005/132] (959s left) gem_softpin (evict-prime)
[109.485066] Starting subtest: evict-prime
[109.486921] Starting dynamic subtest: rcs0
[110.622148] Dynamic subtest rcs0: SUCCESS (1.134s)
[110.669964] Starting dynamic subtest: bcs0
[111.738325] Dynamic subtest bcs0: SUCCESS (1.113s)
[111.799049] Starting dynamic subtest: vcs0
[112.849045] Dynamic subtest vcs0: SUCCESS (1.111s)
[112.930139] Starting dynamic subtest: vecs0
[113.964116] Dynamic subtest vecs0: SUCCESS (1.115s)
[114.006615] Starting dynamic subtest: all
[115.071262] Dynamic subtest all: SUCCESS (1.107s)
[115.073517] Subtest evict-prime: SUCCESS (5.587s)
[115.228385] [006/132] (953s left) gem_exec_schedule (smoketest-all)
[115.362583] Starting subtest: smoketest-all
[147.635228] Subtest smoketest-all: SUCCESS (32.270s)
[148.032162] [007/132] (920s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[148.238807] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[148.242331] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[148.397062] [008/132] (920s left) perf_pmu (render-node-busy)
[148.519132] Starting subtest: render-node-busy
[148.521370] Starting dynamic subtest: rcs0
[149.047481] Dynamic subtest rcs0: SUCCESS (0.527s)
[149.066836] Starting dynamic subtest: bcs0
[149.578719] Dynamic subtest bcs0: SUCCESS (0.532s)
[149.599156] Starting dynamic subtest: vcs0
[150.108052] Dynamic subtest vcs0: SUCCESS (0.527s)
[150.131395] Starting dynamic subtest: vecs0
[150.635670] Dynamic subtest vecs0: SUCCESS (0.525s)
[150.637297] Subtest render-node-busy: SUCCESS (2.115s)
[150.783345] [009/132] (918s left) sw_sync (sync_expired_merge)
[150.884909] Starting subtest: sync_expired_merge
[151.960446] Subtest sync_expired_merge: SUCCESS (1.076s)
[152.099178] [010/132] (917s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[152.295178] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[155.153704] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (2.858s)
[155.450568] [011/132] (913s left) gem_linear_blits (basic)
[156.302774] Starting subtest: basic
[156.318983] Subtest basic: SUCCESS (0.016s)
[156.504977] [012/132] (912s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[156.843132] Starting subtest: basic-busy-flip-before-cursor-atomic
[156.847959] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[157.011368] [013/132] (912s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[157.138602] Starting subtest: single-wait-for-submit-available-submitted
[157.140239] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.002s)
[157.313702] [014/132] (912s left) gem_userptr_blits (map-fixed-invalidate-busy)
[157.459997] Starting subtest: map-fixed-invalidate-busy
[157.464163] Starting dynamic subtest: gtt
[160.896261] Dynamic subtest gtt: SUCCESS (3.438s)
[160.919235] Starting dynamic subtest: wb
[164.252348] Dynamic subtest wb: SUCCESS (3.355s)
[164.277343] Starting dynamic subtest: wc
[167.538254] Dynamic subtest wc: SUCCESS (3.284s)
[167.562288] Starting dynamic subtest: uc
[170.910377] Dynamic subtest uc: SUCCESS (3.368s)
[170.913107] Subtest map-fixed-invalidate-busy: SUCCESS (13.450s)
[171.086534] [015/132] (898s left) gem_media_vme
[171.306926] [016/132] (898s left) gem_pxp (protected-raw-src-copy-not-readible)
[173.949388] Starting subtest: protected-raw-src-copy-not-readible
[173.952864] Subtest protected-raw-src-copy-not-readible: SKIP (0.000s)
[174.101482] [017/132] (895s left) gem_userptr_blits (usage-restrictions)
[174.221114] Starting subtest: usage-restrictions
[174.224110] Subtest usage-restrictions: SUCCESS (0.000s)
[174.420997] [018/132] (895s left) gem_exec_fence (basic-busy-all)
[174.543913] Starting subtest: basic-busy-all
[174.561137] Subtest basic-busy-all: SUCCESS (0.017s)
[175.402619] [019/132] (894s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[175.592234] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[175.595545] Starting dynamic subtest: pipe-A
[180.858817] Dynamic subtest pipe-A: SKIP (5.270s)
[180.910902] Starting dynamic subtest: pipe-B
[186.152128] Dynamic subtest pipe-B: SKIP (5.290s)
[186.196232] Starting dynamic subtest: pipe-C
[192.236308] Dynamic subtest pipe-C: SKIP (6.071s)
[192.241291] Subtest plane-scaler-with-clipping-clamping-rotation: SKIP (16.639s)
[192.817912] [020/132] (877s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[193.059104] Starting subtest: cursorA-vs-flipA-atomic
[204.415267] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.350s)
[204.739796] [021/132] (865s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[204.963145] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[204.967254] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[205.111911] [022/132] (865s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[205.336083] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[205.343727] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.004s)
[205.495746] [023/132] (865s left) i915_drm_fdinfo (busy)
[205.613159] Starting subtest: busy
[205.618104] Starting dynamic subtest: rcs0
[206.153838] Dynamic subtest rcs0: SUCCESS (0.535s)
[206.183381] Starting dynamic subtest: bcs0
[206.685537] Dynamic subtest bcs0: SUCCESS (0.529s)
[206.711830] Starting dynamic subtest: vcs0
[207.218266] Dynamic subtest vcs0: SUCCESS (0.529s)
[207.245467] Starting dynamic subtest: vecs0
[207.749049] Dynamic subtest vecs0: SUCCESS (0.527s)
[207.751226] Subtest busy: SUCCESS (2.138s)
[207.897180] [024/132] (862s left) gem_basic (create-close)
[208.006099] Starting subtest: create-close
[208.010910] Subtest create-close: SUCCESS (0.002s)
[208.191291] [025/132] (862s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[208.412150] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[208.415779] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[208.560923] [026/132] (862s left) kms_chamelium_hpd (common-hpd-after-suspend)
[209.194210] Subtest common-hpd-after-suspend: SKIP (0.000s)
[209.539707] [027/132] (861s left) gem_flink_basic (basic)
[209.653097] Starting subtest: basic
[209.655433] Subtest basic: SUCCESS (0.001s)
[209.817958] [028/132] (861s left) gem_pread (exhaustion)
[209.920112] Starting subtest: exhaustion
[235.377766] Subtest exhaustion: SUCCESS (25.454s)
[235.565132] [029/132] (835s left) gem_userptr_blits (process-exit)
[235.704137] Starting subtest: process-exit
[235.724850] Subtest process-exit: SUCCESS (0.024s)
[235.947335] [030/132] (835s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[237.891416] Starting subtest: modeset-lpsp-stress-no-wait
[238.190746] Subtest modeset-lpsp-stress-no-wait: SKIP (0.288s)
[238.654503] [031/132] (832s left) i915_query (query-topology-unsupported)
[238.769704] Starting subtest: query-topology-unsupported
[238.774559] Subtest query-topology-unsupported: SKIP (0.000s)
[238.927652] [032/132] (832s left) gem_exec_fence (syncobj-channel)
[239.483148] Starting subtest: syncobj-channel
[240.556194] Subtest syncobj-channel: SUCCESS (1.072s)
[240.948337] [033/132] (830s left) perf_pmu (busy-accuracy-50)
[241.064209] Starting subtest: busy-accuracy-50
[241.067117] Starting dynamic subtest: rcs0
[242.619214] Dynamic subtest rcs0: SUCCESS (1.553s)
[242.641702] Starting dynamic subtest: bcs0
[244.175270] Dynamic subtest bcs0: SUCCESS (1.553s)
[244.199743] Starting dynamic subtest: vcs0
[245.730744] Dynamic subtest vcs0: SUCCESS (1.551s)
[245.752635] Starting dynamic subtest: vecs0
[247.296243] Dynamic subtest vecs0: SUCCESS (1.561s)
[247.298155] Subtest busy-accuracy-50: SUCCESS (6.233s)
[247.460986] [034/132] (824s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[247.660821] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[250.227480] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (2.571s)
[250.573632] [035/132] (821s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[250.782679] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[252.944827] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SUCCESS (2.163s)
[253.160594] [036/132] (818s left) kms_content_protection (dp-mst-type-0)
[253.371123] Starting subtest: dp-mst-type-0
[253.377711] Subtest dp-mst-type-0: SKIP (0.000s)
[253.527091] [037/132] (818s left) kms_pm_rpm (drm-resources-equal)
[255.450416] Starting subtest: drm-resources-equal
[256.776685] Subtest drm-resources-equal: SUCCESS (1.325s)
[257.110944] [038/132] (814s left) gem_mmap_gtt (basic-wc)
[257.217370] Starting subtest: basic-wc
[257.848863] Subtest basic-wc: SUCCESS (0.631s)
[258.027288] [039/132] (814s left) kms_cdclk (plane-scaling)
[258.145063] Subtest plane-scaling: SKIP (0.000s)
[258.255450] [040/132] (813s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[258.442053] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[277.872234] Subtest flip-vs-cursor-atomic-transitions-varying-size: FAIL (18.942s)
[277.967185] [041/132] (794s left) kms_cursor_crc (cursor-offscreen-max-size)
[278.195100] Starting subtest: cursor-offscreen-max-size
[278.201803] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[278.346619] [042/132] (794s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[278.476705] Starting subtest: basic-wc-cpu-noreloc
[278.483271] Subtest basic-wc-cpu-noreloc: SUCCESS (0.009s)
[278.712873] [043/132] (793s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[278.908269] Starting subtest: blocking-absolute-wf_vblank-interruptible
[278.909908] Starting dynamic subtest: A-HDMI-A1
[284.753159] Dynamic subtest A-HDMI-A1: SUCCESS (5.840s)
[284.781727] Starting dynamic subtest: B-HDMI-A1
[290.144701] Dynamic subtest B-HDMI-A1: SUCCESS (5.386s)
[290.167032] Starting dynamic subtest: C-HDMI-A1
[295.687654] Dynamic subtest C-HDMI-A1: SUCCESS (5.535s)
[295.716957] Starting dynamic subtest: A-HDMI-A2
[301.308111] Dynamic subtest A-HDMI-A2: SUCCESS (5.615s)
[301.334054] Starting dynamic subtest: B-HDMI-A2
[306.864106] Dynamic subtest B-HDMI-A2: SUCCESS (5.553s)
[306.892586] Starting dynamic subtest: C-HDMI-A2
[312.260030] Dynamic subtest C-HDMI-A2: SUCCESS (5.385s)
[312.261730] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (33.351s)
[312.754128] [044/132] (759s left) kms_atomic (crtc-invalid-params)
[312.952420] Starting subtest: crtc-invalid-params
[312.964050] Starting dynamic subtest: pipe-A-HDMI-A-1
[313.511328] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.549s)
[313.513494] Subtest crtc-invalid-params: SUCCESS (0.558s)
[313.877933] [045/132] (758s left) kms_async_flips (async-flip-suspend-resume)
[314.077116] Starting subtest: async-flip-suspend-resume
[314.729164] Starting dynamic subtest: pipe-A-HDMI-A-1
[333.767231] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.133s)
[334.216034] Starting dynamic subtest: pipe-A-HDMI-A-2