[87.721315] Initializing watchdogs
[87.721527]   /dev/watchdog0
[87.761570] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[87.776328] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[87.782632] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[87.788250] [001/132] (960s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[88.015516] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[88.021201] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.002s)
[88.152442] [002/132] (960s left) gem_exec_schedule (implicit-boths)
[88.295779] Starting subtest: implicit-boths
[88.296855] Starting dynamic subtest: rcs0
[88.433098] Dynamic subtest rcs0: SUCCESS (0.134s)
[88.452742] Starting dynamic subtest: bcs0
[88.578067] Dynamic subtest bcs0: SUCCESS (0.143s)
[88.601971] Starting dynamic subtest: vcs0
[88.701152] Dynamic subtest vcs0: SUCCESS (0.122s)
[88.718987] Starting dynamic subtest: vecs0
[88.819805] Dynamic subtest vecs0: SUCCESS (0.122s)
[88.823718] Subtest implicit-boths: SUCCESS (0.526s)
[89.223213] [003/132] (959s left) perf (global-sseu-config)
[89.421283] Starting subtest: global-sseu-config
[89.425059] Starting dynamic subtest: 0-rcs0
[89.480053] Dynamic subtest 0-rcs0: SUCCESS (0.056s)
[89.481297] Subtest global-sseu-config: SUCCESS (0.057s)
[89.576643] [004/132] (958s left) gem_flink_basic (basic)
[89.681299] Starting subtest: basic
[89.683618] Subtest basic: SUCCESS (0.001s)
[89.825431] [005/132] (958s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[90.019286] Starting subtest: yf-tiled-16bpp-rotate-90
[90.399232] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.377s)
[90.664079] [006/132] (958s left) kms_joiner (invalid-modeset-big-joiner)
[90.862881] Starting subtest: invalid-modeset-big-joiner
[90.868191] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[90.990448] [007/132] (957s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[91.206090] Starting subtest: cursorB-vs-flipA-legacy
[102.603175] Subtest cursorB-vs-flipA-legacy: SUCCESS (11.400s)
[102.910079] [008/132] (945s left) dmabuf_sync_file (export-multiwait)
[103.106349] Starting subtest: export-multiwait
[103.107652] Subtest export-multiwait: SUCCESS (0.003s)
[103.215247] [FACT dmabuf_sync_file (export-multiwait)] new: kernel.kmod_is_loaded.vgem: true
[103.218818] [009/132] (945s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[103.390511] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[103.633374] Starting dynamic subtest: pipe-A-plane-0
[104.332871] Dynamic subtest pipe-A-plane-0: SUCCESS (0.700s)
[104.351778] Starting dynamic subtest: pipe-A-plane-1
[104.998988] Dynamic subtest pipe-A-plane-1: SUCCESS (0.666s)
[105.016237] Starting dynamic subtest: pipe-A-plane-2
[105.481852] Dynamic subtest pipe-A-plane-2: SUCCESS (0.482s)
[105.498525] Starting dynamic subtest: pipe-A-plane-3
[105.964373] Dynamic subtest pipe-A-plane-3: SUCCESS (0.483s)
[106.380781] Starting dynamic subtest: pipe-B-plane-0
[107.016571] Dynamic subtest pipe-B-plane-0: SUCCESS (0.650s)
[107.036834] Starting dynamic subtest: pipe-B-plane-1
[107.666495] Dynamic subtest pipe-B-plane-1: SUCCESS (0.647s)
[107.683731] Starting dynamic subtest: pipe-B-plane-2
[108.149215] Dynamic subtest pipe-B-plane-2: SUCCESS (0.483s)
[108.166286] Starting dynamic subtest: pipe-B-plane-3
[108.648135] Dynamic subtest pipe-B-plane-3: SUCCESS (0.499s)
[108.868616] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (5.476s)
[109.223585] [010/132] (939s left) gen7_exec_parse (batch-without-end)
[109.340501] Subtest batch-without-end: SKIP (0.000s)
[109.450593] [011/132] (939s left) gem_eio (in-flight-internal-10ms)
[109.587122] Starting subtest: in-flight-internal-10ms
[109.725601] Subtest in-flight-internal-10ms: SUCCESS (0.147s)
[109.969899] [012/132] (939s left) gem_exec_balancer (hog)
[110.100970] Starting subtest: hog
[114.449525] Subtest hog: SUCCESS (4.351s)
[114.726148] [013/132] (934s left) syncobj_timeline (wait-any-snapshot)
[114.828870] Starting subtest: wait-any-snapshot
[114.918379] Subtest wait-any-snapshot: SUCCESS (0.087s)
[115.090335] [014/132] (934s left) gem_pxp (reject-modify-context-protection-on)
[117.735028] Starting subtest: reject-modify-context-protection-on
[117.737087] Subtest reject-modify-context-protection-on: SKIP (0.000s)
[117.875203] [015/132] (931s left) kms_psr (fbc-psr-basic)
[118.058233] Subtest fbc-psr-basic: SKIP (0.000s)
[118.164576] [016/132] (931s left) perf_pmu (busy-idle-check-all)
[118.277552] Starting subtest: busy-idle-check-all
[118.281173] Starting dynamic subtest: rcs0
[118.917069] Dynamic subtest rcs0: SUCCESS (0.638s)
[118.937772] Starting dynamic subtest: bcs0
[119.553181] Dynamic subtest bcs0: SUCCESS (0.635s)
[119.573738] Starting dynamic subtest: vcs0
[120.183674] Dynamic subtest vcs0: SUCCESS (0.627s)
[120.206716] Starting dynamic subtest: vecs0
[120.810529] Dynamic subtest vecs0: SUCCESS (0.625s)
[120.811625] Subtest busy-idle-check-all: SUCCESS (2.531s)
[120.960662] [017/132] (928s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[121.161696] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[121.182774] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[121.335492] [018/132] (928s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[121.516280] Starting subtest: flip-vs-cursor-atomic
[139.940461] Subtest flip-vs-cursor-atomic: SUCCESS (18.424s)
[140.241202] [019/132] (909s left) gem_unfence_active_buffers
[140.592517] [020/132] (909s left) gem_exec_reloc (basic-write-wc-active)
[140.704900] Starting subtest: basic-write-wc-active
[140.845359] Subtest basic-write-wc-active: SUCCESS (0.139s)
[141.073198] [021/132] (908s left) gem_exec_schedule (submit-late-slice)
[141.209823] Starting subtest: submit-late-slice
[141.211147] Starting dynamic subtest: rcs0
[141.261530] Dynamic subtest rcs0: SUCCESS (0.053s)
[141.281152] Starting dynamic subtest: bcs0
[141.319514] Dynamic subtest bcs0: SUCCESS (0.057s)
[141.343507] Starting dynamic subtest: vcs0
[141.370146] Dynamic subtest vcs0: SUCCESS (0.049s)
[141.395091] Starting dynamic subtest: vecs0
[141.416269] Dynamic subtest vecs0: SUCCESS (0.048s)
[141.417922] Subtest submit-late-slice: SUCCESS (0.211s)
[141.839332] [022/132] (908s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[142.023327] Starting subtest: plane-scaler-unity-scaling-with-rotation
[142.024939] Starting dynamic subtest: pipe-A
[147.314391] Dynamic subtest pipe-A: SKIP (5.285s)
[147.336111] Starting dynamic subtest: pipe-B
[151.822174] Dynamic subtest pipe-B: SKIP (4.504s)
[151.843398] Starting dynamic subtest: pipe-C
[156.605419] Dynamic subtest pipe-C: SKIP (4.776s)
[156.614040] Subtest plane-scaler-unity-scaling-with-rotation: SKIP (14.571s)
[157.186567] [023/132] (893s left) kms_cursor_edge_walk (128x128-top-edge)
[157.437216] Starting subtest: 128x128-top-edge
[157.439099] Starting dynamic subtest: pipe-A-HDMI-A-1
[161.429086] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.987s)
[161.481083] Starting dynamic subtest: pipe-C-HDMI-A-1
[164.945233] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.506s)
[164.947368] Subtest 128x128-top-edge: SUCCESS (7.514s)
[165.280128] [024/132] (885s left) syncobj_wait (invalid-signal-zero-handles)
[165.396108] Starting subtest: invalid-signal-zero-handles
[165.398748] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[165.535238] [025/132] (884s left) gem_userptr_blits (dmabuf-sync)
[165.676278] Starting subtest: dmabuf-sync
[165.695061] Subtest dmabuf-sync: SKIP (0.010s)
[165.886490] [026/132] (884s left) gem_partial_pwrite_pread (writes-after-reads)
[166.012244] Starting subtest: writes-after-reads
[187.666276] Subtest writes-after-reads: SUCCESS (21.660s)
[187.836591] [027/132] (862s left) gem_lmem_swapping (heavy-verify-random-ccs)
[187.947939] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[188.063319] [028/132] (862s left) syncobj_wait (wait-all-interrupted)
[188.172142] Starting subtest: wait-all-interrupted
[188.283146] Subtest wait-all-interrupted: SUCCESS (0.111s)
[188.447380] [029/132] (862s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[188.650092] Starting subtest: x-tiled-32bpp-rotate-0
[192.758965] Subtest x-tiled-32bpp-rotate-0: SUCCESS (4.109s)
[193.165854] [030/132] (857s left) kms_busy (extended-modeset-hang-newfb)
[193.360147] Starting subtest: extended-modeset-hang-newfb
[193.362076] Starting dynamic subtest: pipe-A
[201.946322] Dynamic subtest pipe-A: SUCCESS (8.581s)
[201.969584] Starting dynamic subtest: pipe-C
[209.924907] Dynamic subtest pipe-C: SUCCESS (7.966s)
[209.926649] Subtest extended-modeset-hang-newfb: SUCCESS (16.572s)
[210.255563] [031/132] (840s left) api_intel_bb (blit-noreloc-keep-cache)
[210.364063] Starting subtest: blit-noreloc-keep-cache
[210.382775] Subtest blit-noreloc-keep-cache: SUCCESS (0.020s)
[210.538419] [032/132] (840s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[210.637277] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[210.746319] [033/132] (840s left) kms_psr (psr2-dpms)
[210.924521] Subtest psr2-dpms: SKIP (0.000s)
[211.042589] [034/132] (840s left) kms_properties (colorop-properties-legacy)
[211.267970] Starting subtest: colorop-properties-legacy
[211.275109] Starting dynamic subtest: pipe-A-HDMI-A-1
[211.740657] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.463s)
[211.785058] Starting dynamic subtest: pipe-A-HDMI-A-2
[212.074094] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.324s)
[212.116495] Starting dynamic subtest: pipe-B-HDMI-A-1
[212.468140] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.387s)
[212.496054] Starting dynamic subtest: pipe-B-HDMI-A-2
[212.829981] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.356s)
[212.856338] Starting dynamic subtest: pipe-C-HDMI-A-1
[213.161252] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.321s)
[213.203572] Starting dynamic subtest: pipe-C-HDMI-A-2
[213.578228] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.412s)
[213.581086] Subtest colorop-properties-legacy: SUCCESS (2.313s)
[213.906865] [035/132] (837s left) gem_softpin (reverse)
[214.030781] Starting subtest: reverse
[214.048914] Subtest reverse: SUCCESS (0.019s)
[214.203055] [036/132] (837s left) gem_busy (semaphore)
[214.464721] Starting subtest: semaphore
[214.466758] Starting dynamic subtest: rcs0
[214.497917] Dynamic subtest rcs0: SUCCESS (0.032s)
[214.536371] Starting dynamic subtest: bcs0
[214.539434] Dynamic subtest bcs0: SUCCESS (0.023s)
[214.567871] Starting dynamic subtest: vcs0
[214.569626] Dynamic subtest vcs0: SUCCESS (0.018s)
[214.589364] Starting dynamic subtest: vecs0
[214.590455] Dynamic subtest vecs0: SUCCESS (0.021s)
[214.591636] Subtest semaphore: SUCCESS (0.108s)
[214.859470] [037/132] (836s left) kms_vblank (query-forked)
[215.052501] Starting subtest: query-forked
[215.054123] Starting dynamic subtest: pipe-A-HDMI-A-1
[217.789774] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.730s)
[217.813115] Starting dynamic subtest: pipe-A-HDMI-A-2
[220.277108] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.483s)
[220.318098] Starting dynamic subtest: pipe-C-HDMI-A-1
[222.737223] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.448s)
[222.784640] Starting dynamic subtest: pipe-C-HDMI-A-2
[225.197642] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.455s)
[225.199888] Subtest query-forked: SUCCESS (10.152s)
[225.552254] [038/132] (826s left) kms_pm_dc (dc5-dpms)
[226.766229] Starting subtest: dc5-dpms
[228.642636] Subtest dc5-dpms: SUCCESS (1.882s)
[228.789658] [039/132] (822s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[229.408111] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[229.714808] [040/132] (822s left) syncobj_timeline (wait-delayed-signal)
[229.826811] Starting subtest: wait-delayed-signal
[229.930530] Subtest wait-delayed-signal: SUCCESS (0.104s)
[230.094869] [041/132] (821s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[230.291470] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[230.294645] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[230.432080] [042/132] (821s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[230.623939] Starting subtest: plane-all-modeset-transition-internal-panels
[230.630390] Subtest plane-all-modeset-transition-internal-panels: SKIP (0.000s)
[230.793261] [043/132] (821s left) syncobj_eventfd (invalid-bad-pad)
[230.909670] Starting subtest: invalid-bad-pad
[230.910781] Subtest invalid-bad-pad: SUCCESS (0.000s)
[231.051507] [044/132] (821s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[231.156104] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[231.157667] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.001s)
[231.299209] [045/132] (820s left) perf_pmu (all-busy-check-all)
[231.415282] Starting subtest: all-busy-check-all
[231.941598] Subtest all-busy-check-all: SUCCESS (0.530s)
[232.111365] [046/132] (820s left) gem_ppgtt (blt-vs-render-ctx0)
[232.228376] Starting subtest: blt-vs-render-ctx0
[265.536477] Subtest blt-vs-render-ctx0: SUCCESS (33.309s)
[265.690575] [047/132] (786s left) kms_psr (fbc-pr-no-drrs)
[266.000094] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[266.108494] [048/132] (786s left) gem_mmap_offset (mmap-unmap)
[266.217088] Starting subtest: mmap-unmap
[266.220093] Starting dynamic subtest: smem0
[354.174275] Dynamic subtest smem0: SUCCESS (87.952s)
[354.178344] Subtest mmap-unmap: SUCCESS (87.955s)
[354.336519] [049/132] (698s left) kms_color (deep-color)
[354.530152] Starting subtest: deep-color
[354.535071] Subtest deep-color: SKIP (0.000s)
[354.684241] [050/132] (698s left) kms_rotation_crc (sprite-rotation-90)
[354.872201] Starting subtest: sprite-rotation-90
[369.988806] Subtest sprite-rotation-90: SUCCESS (15.122s)
[370.297347] [051/132] (682s left) kms_async_flips (async-flip-hang)
[370.500083] Starting subtest: async-flip-hang
[371.146331] Starting dynamic subtest: pipe-A-HDMI-A-1
[378.670610] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.522s)
[379.031936] Starting dynamic subtest: pipe-A-HDMI-A-2
[386.672986] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (7.660s)
[387.061929] Starting dynamic subtest: pipe-B-HDMI-A-1
[394.671348] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (7.640s)
[395.049931] Starting dynamic subtest: pipe-B-HDMI-A-2
[402.670955] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (7.643s)
[403.034109] Starting dynamic subtest: pipe-C-HDMI-A-1
[410.671832] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (7.663s)
[411.035898] Starting dynamic subtest: pipe-C-HDMI-A-2
[418.672202] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (7.669s)
[418.673957] Subtest async-flip-hang: SUCCESS (48.174s)
[419.303525] [052/132] (633s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[419.507731] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[419.526131] Starting dynamic subtest: pipe-A-valid-mode
[420.396164] Dynamic subtest pipe-A-valid-mode: SKIP (0.878s)
[420.397925] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (0.885s)
[420.934476] [053/132] (632s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[421.129907] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[421.136331] Subtest fbcpsr-rgb101010-draw-pwrite: SKIP (0.000s)
[421.321327] [054/132] (631s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[421.520930] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[421.526312] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[421.666439] [055/132] (631s left) kms_prime (basic-modeset-hybrid)
[421.901519] Subtest basic-modeset-hybrid: SKIP (0.000s)
[422.078673] [056/132] (631s left) gem_exec_capture (pi)
[422.201123] Starting subtest: pi
[422.202035] Starting dynamic subtest: rcs0
[441.486916] Dynamic subtest rcs0: SUCCESS (19.286s)
[441.520212] Starting dynamic subtest: bcs0
[460.632468] Dynamic subtest bcs0: SUCCESS (19.143s)
[460.658892] Starting dynamic subtest: vcs0
[479.787031] Dynamic subtest vcs0: SUCCESS (19.149s)
[479.820209] Starting dynamic subtest: vecs0
[498.949501] Dynamic subtest vecs0: SUCCESS (19.157s)
[498.955283] Subtest pi: SUCCESS (76.755s)
[499.119968] [057/132] (554s left) kms_plane_scaling (planes-downscale-factor-0-75)
[499.423098] Starting subtest: planes-downscale-factor-0-75
[499.427127] Starting dynamic subtest: pipe-A
[499.774396] Dynamic subtest pipe-A: SUCCESS (0.352s)
[499.799043] Starting dynamic subtest: pipe-B
[500.238374] Dynamic subtest pipe-B: SUCCESS (0.460s)
[500.281282] Starting dynamic subtest: pipe-C
[500.329234] Dynamic subtest pipe-C: SUCCESS (0.089s)
[500.332555] Subtest planes-downscale-factor-0-75: SUCCESS (0.913s)
[500.874721] [058/132] (552s left) kms_feature_discovery (display)
[501.060715] Starting subtest: display
[501.063077] Subtest display: SUCCESS (0.000s)
[501.205655] [059/132] (552s left) gem_tiling_max_stride
[501.508337] [060/132] (552s left) kms_hdr (bpc-switch)
[501.701086] Starting subtest: bpc-switch
[531.046499] Subtest bpc-switch: SKIP (29.337s)
[531.541182] [061/132] (522s left) kms_vblank (ts-continuation-suspend)
[531.761373] Starting subtest: ts-continuation-suspend
[531.763071] Starting dynamic subtest: pipe-A-HDMI-A-1
[550.194283] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.415s)
[550.277514] Starting dynamic subtest: pipe-A-HDMI-A-2