[51.800942] Initializing watchdogs
[51.801014]   /dev/watchdog0
[51.817075] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[51.822949] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[51.825850] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[51.827803] [001/156] (960s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[51.927880] Starting subtest: fbc-tiling-linear
[53.055552] Subtest fbc-tiling-linear: SUCCESS (1.135s)
[53.187771] [002/156] (959s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[53.223446] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[53.267572] [003/156] (959s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[53.361294] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[53.362736] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[53.444764] [004/156] (958s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[53.537172] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[53.538583] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[53.638955] [005/156] (958s left) kms_force_connector_basic (prune-stale-modes)
[53.763898] Starting subtest: prune-stale-modes
[53.911837] Subtest prune-stale-modes: SUCCESS (0.149s)
[54.079426] [006/156] (958s left) perf_pmu (most-busy-check-all)
[54.120260] Starting subtest: most-busy-check-all
[54.121095] Starting dynamic subtest: rcs0
[54.640178] Dynamic subtest rcs0: SUCCESS (0.522s)
[54.654490] Starting dynamic subtest: bcs0
[55.161581] Dynamic subtest bcs0: SUCCESS (0.523s)
[55.170967] Starting dynamic subtest: vcs0
[55.680089] Dynamic subtest vcs0: SUCCESS (0.520s)
[55.689421] Starting dynamic subtest: vcs1
[56.200019] Dynamic subtest vcs1: SUCCESS (0.521s)
[56.209629] Starting dynamic subtest: vecs0
[56.720042] Dynamic subtest vecs0: SUCCESS (0.522s)
[56.720974] Subtest most-busy-check-all: SUCCESS (2.611s)
[56.795563] [007/156] (955s left) gem_ccs (large-ctrl-surf-copy)
[56.833271] Starting subtest: large-ctrl-surf-copy
[56.834788] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[56.903941] [008/156] (955s left) kms_plane_alpha_blend (coverage-7efc)
[56.995202] Starting subtest: coverage-7efc
[57.065498] Starting dynamic subtest: pipe-A-HDMI-A-1
[57.370409] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.305s)
[57.406182] Starting dynamic subtest: pipe-D-HDMI-A-1
[57.898442] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.503s)
[57.899157] Subtest coverage-7efc: SUCCESS (0.907s)
[58.074254] [009/156] (954s left) gem_mmap_gtt (fault-concurrent)
[58.113515] Starting subtest: fault-concurrent
[60.638310] Subtest fault-concurrent: SUCCESS (2.497s)
[60.717676] [010/156] (951s left) api_intel_allocator (gem-pool)
[60.752512] Starting subtest: gem-pool
[60.758703] Subtest gem-pool: SUCCESS (0.006s)
[60.852739] [011/156] (951s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-fullscreen)
[60.947446] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-fullscreen
[60.948849] Subtest fbchdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[61.042601] [012/156] (951s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[61.130585] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[61.132049] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[61.202661] [013/156] (951s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[61.290790] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[61.291517] Starting dynamic subtest: pipe-A-HDMI-A-1
[61.298744] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[61.305351] Starting dynamic subtest: pipe-B-HDMI-A-1
[61.312620] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[61.319236] Starting dynamic subtest: pipe-C-HDMI-A-1
[61.326410] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[61.332838] Starting dynamic subtest: pipe-D-HDMI-A-1
[61.339790] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[61.341152] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.007s)
[61.558818] [014/156] (951s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[61.647414] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[61.648125] Starting dynamic subtest: pipe-A-HDMI-A-1
[61.654771] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[61.661502] Starting dynamic subtest: pipe-B-HDMI-A-1
[61.668243] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[61.674806] Starting dynamic subtest: pipe-C-HDMI-A-1
[61.681446] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[61.687870] Starting dynamic subtest: pipe-D-HDMI-A-1
[61.694693] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[61.696054] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[61.893874] [015/156] (950s left) kms_frontbuffer_tracking (hdr-rgb565-draw-blt)
[61.986119] Starting subtest: hdr-rgb565-draw-blt
[61.987469] Subtest hdr-rgb565-draw-blt: SKIP (0.000s)
[62.086529] [016/156] (950s left) kms_pm_rpm (legacy-planes-dpms)
[63.500939] Starting subtest: legacy-planes-dpms
[63.502227] Starting dynamic subtest: plane-65
[71.792227] Dynamic subtest plane-65: SUCCESS (8.298s)
[71.802069] Starting dynamic subtest: plane-95
[79.984864] Dynamic subtest plane-95: SUCCESS (8.194s)
[79.995635] Starting dynamic subtest: plane-125
[88.584123] Dynamic subtest plane-125: SUCCESS (8.598s)
[88.594133] Starting dynamic subtest: plane-135
[96.908798] Dynamic subtest plane-135: SUCCESS (8.324s)
[96.918225] Starting dynamic subtest: plane-145
[105.212216] Dynamic subtest plane-145: SUCCESS (8.302s)
[105.224061] Starting dynamic subtest: plane-155
[113.538948] Dynamic subtest plane-155: SUCCESS (8.326s)
[113.540047] Subtest legacy-planes-dpms: SUCCESS (50.048s)
[113.730768] [017/156] (899s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[113.775783] Starting subtest: x-tiled-to-vebox-y-tiled
[113.776532] Starting dynamic subtest: smem
[113.871976] Dynamic subtest smem: SUCCESS (0.097s)
[113.872737] Subtest x-tiled-to-vebox-y-tiled: SUCCESS (0.097s)
[114.059505] [018/156] (898s left) sysfs_heartbeat_interval (invalid)
[114.096776] Starting subtest: invalid
[114.097472] Starting dynamic subtest: vecs0
[114.098181] Dynamic subtest vecs0: SUCCESS (0.000s)
[114.104942] Starting dynamic subtest: vcs0
[114.105664] Dynamic subtest vcs0: SUCCESS (0.000s)
[114.112278] Starting dynamic subtest: bcs0
[114.113005] Dynamic subtest bcs0: SUCCESS (0.000s)
[114.119366] Starting dynamic subtest: rcs0
[114.120077] Dynamic subtest rcs0: SUCCESS (0.000s)
[114.126238] Starting dynamic subtest: vcs1
[114.126952] Dynamic subtest vcs1: SUCCESS (0.000s)
[114.127678] Subtest invalid: SUCCESS (0.004s)
[114.160102] [019/156] (898s left) kms_frontbuffer_tracking (fbc-stridechange)
[114.251761] Starting subtest: fbc-stridechange
[115.263183] Subtest fbc-stridechange: SUCCESS (1.012s)
[115.373898] [020/156] (897s left) gem_ctx_param (basic-default)
[115.408695] Starting subtest: basic-default
[115.409423] Subtest basic-default: SUCCESS (0.000s)
[115.477637] [021/156] (897s left) kms_psr (fbc-pr-primary-mmap-gtt)
[115.568231] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[115.606903] [022/156] (897s left) i915_pm_freq_mult (media-freq)
[115.640774] Starting subtest: media-freq
[115.641465] Starting dynamic subtest: gt0
[115.642843] Dynamic subtest gt0: SKIP (0.000s)
[115.644189] Subtest media-freq: SKIP (0.001s)
[115.712507] [023/156] (897s left) prime_busy (before-wait)
[115.749467] Starting subtest: before-wait
[115.754461] Starting dynamic subtest: rcs0
[115.774300] Dynamic subtest rcs0: SUCCESS (0.019s)
[115.781042] Starting dynamic subtest: bcs0
[115.795343] Dynamic subtest bcs0: SUCCESS (0.021s)
[115.805934] Starting dynamic subtest: vcs0
[115.811233] Dynamic subtest vcs0: SUCCESS (0.015s)
[115.818160] Starting dynamic subtest: vcs1
[115.838882] Dynamic subtest vcs1: SUCCESS (0.027s)
[115.852014] Starting dynamic subtest: vecs0
[115.853907] Dynamic subtest vecs0: SUCCESS (0.013s)
[115.961124] Subtest before-wait: SUCCESS (0.211s)
[116.028958] [024/156] (897s left) gem_exec_gttfill (engines)
[116.071855] Starting subtest: engines
[116.072579] Starting dynamic subtest: rcs0
[139.258506] Dynamic subtest rcs0: SUCCESS (23.186s)
[139.275752] Starting dynamic subtest: bcs0
[162.257039] Dynamic subtest bcs0: SUCCESS (22.998s)
[162.265435] Starting dynamic subtest: vcs0
[185.287430] Dynamic subtest vcs0: SUCCESS (23.030s)
[185.295600] Starting dynamic subtest: vcs1
[208.440386] Dynamic subtest vcs1: SUCCESS (23.152s)
[208.448043] Starting dynamic subtest: vecs0
[231.516123] Dynamic subtest vecs0: SUCCESS (23.075s)
[231.516873] Subtest engines: SUCCESS (115.444s)
[231.714720] [025/156] (781s left) syncobj_timeline (etime-multi-wait-all-submitted)
[231.796728] Starting subtest: etime-multi-wait-all-submitted
[231.901762] Subtest etime-multi-wait-all-submitted: SUCCESS (0.104s)
[231.977237] [026/156] (781s left) gem_ctx_param (get-priority-new-ctx)
[232.010853] Starting subtest: get-priority-new-ctx
[232.011550] Subtest get-priority-new-ctx: SUCCESS (0.000s)
[232.082619] [027/156] (781s left) kms_big_fb (linear-32bpp-rotate-90)
[232.189449] Starting subtest: linear-32bpp-rotate-90
[232.263796] Subtest linear-32bpp-rotate-90: SKIP (0.074s)
[232.372579] [028/156] (780s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[232.413509] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[232.450701] [029/156] (780s left) gem_ctx_shared (disjoint-timelines)
[232.492573] Starting subtest: disjoint-timelines
[232.527361] Subtest disjoint-timelines: SUCCESS (0.035s)
[232.743766] [FACT gem_ctx_shared (disjoint-timelines)] new: kernel.kmod_is_loaded.vgem: true
[232.745518] [030/156] (780s left) kms_psr (fbc-psr2-cursor-plane-move)
[232.835673] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[232.878524] [031/156] (780s left) gem_bad_reloc (negative-reloc-bltcopy)
[232.918169] Starting subtest: negative-reloc-bltcopy
[234.030637] Subtest negative-reloc-bltcopy: SUCCESS (1.104s)
[234.137476] [032/156] (779s left) kms_chamelium_hpd (hdmi-hpd)
[234.283824] Subtest hdmi-hpd: SKIP (0.000s)
[234.384477] [033/156] (779s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[234.478668] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[234.521691] [034/156] (779s left) gem_eio (wait-10ms)
[234.568088] Starting subtest: wait-10ms
[234.726850] Subtest wait-10ms: SUCCESS (0.158s)
[234.853975] [035/156] (778s left) kms_content_protection (legacy-hdcp14)
[234.952786] Starting subtest: legacy-hdcp14
[234.958240] Subtest legacy-hdcp14: SKIP (0.004s)
[235.038091] [036/156] (778s left) syncobj_wait (reset-signaled)
[235.073545] Starting subtest: reset-signaled
[235.074324] Subtest reset-signaled: SUCCESS (0.000s)
[235.137082] [037/156] (778s left) gem_ctx_isolation (dirty-switch)
[235.179142] Starting subtest: dirty-switch
[235.179962] Starting dynamic subtest: rcs0
[235.365809] Dynamic subtest rcs0: SUCCESS (0.178s)
[235.373358] Starting dynamic subtest: bcs0
[235.588917] Dynamic subtest bcs0: SUCCESS (0.222s)
[235.596786] Starting dynamic subtest: vcs0
[235.804247] Dynamic subtest vcs0: SUCCESS (0.215s)
[235.811842] Starting dynamic subtest: vcs1
[236.008154] Dynamic subtest vcs1: SUCCESS (0.212s)
[236.016228] Starting dynamic subtest: vecs0
[236.229794] Dynamic subtest vecs0: SUCCESS (0.212s)
[236.230599] Subtest dirty-switch: SUCCESS (1.042s)
[236.395270] [038/156] (777s left) gem_flink_basic (bad-open)
[236.429561] Starting subtest: bad-open
[236.430284] Subtest bad-open: SUCCESS (0.000s)
[236.484702] [039/156] (777s left) gem_caching (writes)
[236.522980] Starting subtest: writes
[245.786324] Subtest writes: SUCCESS (9.263s)
[245.902153] [040/156] (767s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[245.995054] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[245.995805] Starting dynamic subtest: pipe-A
[246.383405] Dynamic subtest pipe-A: SUCCESS (0.389s)
[246.400317] Starting dynamic subtest: pipe-B
[246.835067] Dynamic subtest pipe-B: SUCCESS (0.451s)
[246.843010] Starting dynamic subtest: pipe-C
[247.287018] Dynamic subtest pipe-C: SUCCESS (0.451s)
[247.296775] Starting dynamic subtest: pipe-D
[247.731441] Dynamic subtest pipe-D: SUCCESS (0.444s)
[247.732186] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (1.738s)
[247.928190] [041/156] (765s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[247.965197] Starting subtest: single-wait-all-for-submit-available-submitted
[247.966042] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[248.038756] [042/156] (765s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-render)
[248.136476] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-render
[248.137960] Subtest fbchdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[248.238604] [043/156] (765s left) kms_pm_rpm (system-suspend-idle)
[249.652898] Starting subtest: system-suspend-idle
[269.766989] Subtest system-suspend-idle: SUCCESS (4.796s)
[281.056469] [044/156] (743s left) kms_atomic_transition (modeset-transition)
[281.160656] Starting subtest: modeset-transition
[281.161409] Starting dynamic subtest: 1x-outputs
[282.406946] Dynamic subtest 1x-outputs: SUCCESS (1.257s)
[282.407714] Subtest modeset-transition: SUCCESS (1.258s)
[282.549316] [045/156] (742s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[282.648569] Starting subtest: pipe-fbc-rte
[282.652781] Subtest pipe-fbc-rte: SKIP (0.000s)
[282.757537] [046/156] (742s left) gem_spin_batch (resubmit-all)
[282.800509] Starting subtest: resubmit-all
[282.801387] Starting dynamic subtest: rcs0
[282.805049] Dynamic subtest rcs0: SUCCESS (0.004s)
[282.815140] Starting dynamic subtest: bcs0
[282.815851] Dynamic subtest bcs0: SUCCESS (0.002s)
[282.824813] Starting dynamic subtest: vcs0
[282.825529] Dynamic subtest vcs0: SUCCESS (0.002s)
[282.834377] Starting dynamic subtest: vcs1
[282.835106] Dynamic subtest vcs1: SUCCESS (0.002s)
[282.843716] Starting dynamic subtest: vecs0
[282.844433] Dynamic subtest vecs0: SUCCESS (0.002s)
[282.845123] Subtest resubmit-all: SUCCESS (0.016s)
[282.999088] [047/156] (742s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[283.090134] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[283.091531] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[283.177999] [048/156] (742s left) syncobj_basic (illegal-fd-to-handle)
[283.212073] Starting subtest: illegal-fd-to-handle
[283.212797] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[283.281126] [049/156] (741s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[283.372607] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[283.374067] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[283.467919] [050/156] (741s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[283.568922] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[284.233039] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (0.668s)
[284.361310] [051/156] (740s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[284.395870] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[284.501505] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.106s)
[284.579955] [052/156] (740s left) api_intel_bb (misplaced-blitter)
[284.615246] Starting subtest: misplaced-blitter
[284.619514] Subtest misplaced-blitter: SUCCESS (0.005s)
[284.738457] [053/156] (740s left) kms_atomic_interruptible (universal-setplane-cursor)
[284.827728] Starting subtest: universal-setplane-cursor
[284.829480] Starting dynamic subtest: pipe-A-HDMI-A-1
[291.057288] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.253s)
[291.057985] Subtest universal-setplane-cursor: SUCCESS (6.255s)
[291.188326] [054/156] (734s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[291.291184] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[291.292563] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[291.389499] [055/156] (734s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[291.482144] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[291.483516] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[291.592485] [056/156] (733s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[291.680640] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[291.681353] Starting dynamic subtest: pipe-A-valid-mode
[292.773486] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.095s)
[292.774215] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SUCCESS (1.096s)
[292.933443] [057/156] (732s left) gem_pxp (create-protected-buffer)
[293.040907] Starting subtest: create-protected-buffer
[293.042083] Subtest create-protected-buffer: SUCCESS (0.000s)
[293.131383] [058/156] (732s left) gem_fence_thrash (bo-write-verify-threaded-x)
[293.163907] Starting subtest: bo-write-verify-threaded-x
[297.988660] Subtest bo-write-verify-threaded-x: SUCCESS (4.825s)
[298.099717] [059/156] (727s left) gen9_exec_parse (allowed-single)
[298.138354] Subtest allowed-single: SKIP (0.000s)
[298.181970] [060/156] (727s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[298.277593] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[298.279084] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[298.381082] [061/156] (727s left) gem_exec_balancer (bonded-semaphore)
[298.424646] Starting subtest: bonded-semaphore
[302.750700] Subtest bonded-semaphore: SUCCESS (4.298s)
[302.905149] [062/156] (722s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[302.995696] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[303.010915] Starting dynamic subtest: pipe-A-plane-0
[303.218999] Dynamic subtest pipe-A-plane-0: SUCCESS (0.208s)
[303.236738] Starting dynamic subtest: pipe-A-plane-3
[303.394081] Dynamic subtest pipe-A-plane-3: SUCCESS (0.173s)
[303.413591] Starting dynamic subtest: pipe-A-plane-5
[303.560482] Dynamic subtest pipe-A-plane-5: SUCCESS (0.165s)
[303.729180] Starting dynamic subtest: pipe-B-plane-0
[303.903918] Dynamic subtest pipe-B-plane-0: SUCCESS (0.183s)
[303.922599] Starting dynamic subtest: pipe-B-plane-3
[304.070386] Dynamic subtest pipe-B-plane-3: SUCCESS (0.164s)
[304.084053] Starting dynamic subtest: pipe-B-plane-5
[304.237027] Dynamic subtest pipe-B-plane-5: SUCCESS (0.165s)
[304.310286] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SUCCESS (1.315s)
[304.490883] [063/156] (721s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[304.591817] Starting subtest: fbc-rgb565-draw-mmap-wc
[305.859440] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (1.269s)
[305.983102] [064/156] (719s left) kms_pwrite_crc (basic)
[306.074726] Starting subtest: basic
[306.366008] Subtest basic: SUCCESS (0.292s)
[306.529968] [065/156] (719s left) gem_flink_basic (bad-flink)
[306.567100] Starting subtest: bad-flink
[306.567879] Subtest bad-flink: SUCCESS (0.000s)
[306.642556] [066/156] (719s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-move)
[306.735858] Starting subtest: hdr-2p-primscrn-spr-indfb-move
[306.737322] Subtest hdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[306.847080] [067/156] (719s left) gem_ctx_persistence (legacy-engines-persistence)
[306.885252] Starting subtest: legacy-engines-persistence
[306.885987] Starting dynamic subtest: render
[307.673359] Dynamic subtest render: SUCCESS (0.787s)
[307.685330] Starting dynamic subtest: bsd1
[308.430480] Dynamic subtest bsd1: SUCCESS (0.754s)
[308.442592] Starting dynamic subtest: bsd2
[309.196223] Dynamic subtest bsd2: SUCCESS (0.764s)
[309.208110] Starting dynamic subtest: blt
[309.965270] Dynamic subtest blt: SUCCESS (0.766s)
[309.977711] Starting dynamic subtest: vebox
[310.734172] Dynamic subtest vebox: SUCCESS (0.767s)
[310.735198] Subtest legacy-engines-persistence: SUCCESS (3.852s)
[310.804374] [068/156] (715s left) gen7_exec_parse (basic-allowed)
[310.844533] Subtest basic-allowed: SKIP (0.000s)
[310.886226] [069/156] (715s left) gem_exec_schedule (reorder-wide)
[311.054482] Starting subtest: reorder-wide
[311.055599] Starting dynamic subtest: rcs0
[311.134094] Dynamic subtest rcs0: SUCCESS (0.079s)
[311.153529] Starting dynamic subtest: bcs0
[311.216430] Dynamic subtest bcs0: SUCCESS (0.080s)
[311.231716] Starting dynamic subtest: vcs0
[311.298320] Dynamic subtest vcs0: SUCCESS (0.080s)
[311.312885] Starting dynamic subtest: vcs1
[311.374005] Dynamic subtest vcs1: SUCCESS (0.074s)
[311.387170] Starting dynamic subtest: vecs0
[311.447760] Dynamic subtest vecs0: SUCCESS (0.072s)
[311.451018] Subtest reorder-wide: SUCCESS (0.396s)
[311.632029] [070/156] (714s left) kms_frontbuffer_tracking (psrhdr-slowdraw)
[311.725181] Starting subtest: psrhdr-slowdraw
[311.726680] Subtest psrhdr-slowdraw: SKIP (0.000s)
[311.835591] [071/156] (714s left) perf (non-zero-reason)
[311.926150] Starting subtest: non-zero-reason
[311.926900] Starting dynamic subtest: 0-rcs0
[319.643330] Dynamic subtest 0-rcs0: SUCCESS (7.688s)
[319.644222] Subtest non-zero-reason: SUCCESS (7.688s)
[319.681609] [072/156] (706s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-pwrite)
[319.775112] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-pwrite
[319.776497] Subtest fbchdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[319.871255] [073/156] (706s left) i915_drm_fdinfo (all-busy-check-all)
[319.908042] Starting subtest: all-busy-check-all
[320.425037] Subtest all-busy-check-all: SUCCESS (0.517s)
[320.496783] [074/156] (705s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[320.590284] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt
[320.591751] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[320.692223] [075/156] (705s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[320.780867] Starting subtest: compare-crc-sanitycheck-nv12
[320.782795] Starting dynamic subtest: pipe-A-HDMI-A-1
[321.130996] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.349s)
[321.144434] Starting dynamic subtest: pipe-B-HDMI-A-1
[321.463852] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.331s)
[321.476494] Starting dynamic subtest: pipe-C-HDMI-A-1
[321.804805] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.338s)
[321.817822] Starting dynamic subtest: pipe-D-HDMI-A-1
[322.127320] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.320s)
[322.128101] Subtest compare-crc-sanitycheck-nv12: SUCCESS (1.346s)
[322.294704] [076/156] (704s left) gem_exec_reloc (basic-write-gtt)
[322.336574] Starting subtest: basic-write-gtt
[322.342688] Subtest basic-write-gtt: SUCCESS (0.006s)
[322.466880] [077/156] (704s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[322.561504] Starting subtest: cursor-rapid-movement-max-size
[322.563567] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[322.670854] [078/156] (703s left) kms_color_pipeline (plane-lut1d)
[322.762501] Starting subtest: plane-lut1d
[322.854888] Starting dynamic subtest: pipe-A-plane-0
[322.946264] Dynamic subtest pipe-A-plane-0: SUCCESS (0.091s)
[322.964704] Starting dynamic subtest: pipe-A-plane-1
[323.037934] Dynamic subtest pipe-A-plane-1: SUCCESS (0.088s)
[323.055149] Starting dynamic subtest: pipe-A-plane-2
[323.129547] Dynamic subtest pipe-A-plane-2: SUCCESS (0.088s)
[323.318953] Starting dynamic subtest: pipe-B-plane-0
[323.400126] Dynamic subtest pipe-B-plane-0: SUCCESS (0.092s)
[323.415523] Starting dynamic subtest: pipe-B-plane-1
[323.490808] Dynamic subtest pipe-B-plane-1: SUCCESS (0.089s)
[323.506613] Starting dynamic subtest: pipe-B-plane-2
[323.584086] Dynamic subtest pipe-B-plane-2: SUCCESS (0.089s)
[323.787807] Starting dynamic subtest: pipe-C-plane-0
[323.863088] Dynamic subtest pipe-C-plane-0: SUCCESS (0.083s)
[323.878086] Starting dynamic subtest: pipe-C-plane-1
[323.962624] Dynamic subtest pipe-C-plane-1: SUCCESS (0.098s)
[323.978239] Starting dynamic subtest: pipe-C-plane-2
[324.062482] Dynamic subtest pipe-C-plane-2: SUCCESS (0.098s)
[324.297058] Starting dynamic subtest: pipe-D-plane-0
[324.379838] Dynamic subtest pipe-D-plane-0: SUCCESS (0.091s)
[324.394258] Starting dynamic subtest: pipe-D-plane-1
[324.479908] Dynamic subtest pipe-D-plane-1: SUCCESS (0.098s)
[324.493603] Starting dynamic subtest: pipe-D-plane-2
[324.580021] Dynamic subtest pipe-D-plane-2: SUCCESS (0.097s)
[324.629018] Subtest plane-lut1d: SUCCESS (1.867s)
[324.755685] [079/156] (701s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[324.858646] Starting subtest: yf-tiled-16bpp-rotate-180
[324.860063] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[324.954937] [080/156] (701s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[325.052096] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[325.053474] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[325.151712] [081/156] (701s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[325.244268] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt
[325.245685] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[325.353908] [082/156] (701s left) gem_exec_reloc (basic-wc-read)
[325.393627] Starting subtest: basic-wc-read
[325.398544] Subtest basic-wc-read: SUCCESS (0.005s)
[325.527834] [083/156] (701s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[325.615766] Starting subtest: short-busy-flip-before-cursor-toggle
[325.617181] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[325.680891] [084/156] (701s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[325.772791] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[325.782492] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.009s)
[325.864309] [085/156] (700s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[325.956542] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[325.957911] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[326.048989] [086/156] (700s left) kms_draw_crc (draw-method-render)
[326.137447] Starting subtest: draw-method-render
[326.138172] Starting dynamic subtest: xrgb8888-untiled
[326.302303] Dynamic subtest xrgb8888-untiled: SUCCESS (0.164s)
[326.320754] Starting dynamic subtest: rgb565-untiled
[326.485386] Dynamic subtest rgb565-untiled: SUCCESS (0.181s)
[326.504968] Starting dynamic subtest: xrgb2101010-untiled
[326.643753] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.156s)
[326.667501] Starting dynamic subtest: xbgr16161616f-untiled
[326.810239] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.162s)
[326.829749] Starting dynamic subtest: xrgb8888-xtiled
[326.901914] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.089s)
[326.921148] Starting dynamic subtest: rgb565-xtiled
[326.985126] Dynamic subtest rgb565-xtiled: SUCCESS (0.081s)
[327.004362] Starting dynamic subtest: xrgb2101010-xtiled
[327.068376] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.081s)
[327.087658] Starting dynamic subtest: xbgr16161616f-xtiled
[327.155289] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.081s)
[327.168666] Starting dynamic subtest: xrgb8888-ytiled
[327.243443] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.089s)
[327.259768] Starting dynamic subtest: rgb565-ytiled
[327.326872] Dynamic subtest rgb565-ytiled: SUCCESS (0.081s)
[327.343227] Starting dynamic subtest: xrgb2101010-ytiled
[327.410096] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.081s)
[327.426878] Starting dynamic subtest: xbgr16161616f-ytiled
[327.493419] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.081s)
[327.496578] Subtest draw-method-render: SUCCESS (1.358s)
[327.628488] [087/156] (699s left) kms_cursor_crc (cursor-sliding-256x85)
[327.723671] Starting subtest: cursor-sliding-256x85
[327.728882] Starting dynamic subtest: pipe-A-HDMI-A-1
[328.979083] Dynamic subtest pipe-A-HDMI-A-1: FAIL (1.072s)
[328.988376] Starting dynamic subtest: pipe-D-HDMI-A-1
[330.742449] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.904s)
[330.743167] Subtest cursor-sliding-256x85: FAIL (3.022s)
[330.906391] [088/156] (696s left) kms_cursor_crc (cursor-onscreen-256x256)
[331.002255] Starting subtest: cursor-onscreen-256x256
[331.007772] Starting dynamic subtest: pipe-A-HDMI-A-1
[332.182521] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.176s)
[332.232561] Starting dynamic subtest: pipe-D-HDMI-A-1
[333.379776] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.159s)
[333.380612] Subtest cursor-onscreen-256x256: SUCCESS (2.379s)
[333.551965] [089/156] (693s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render)
[333.649300] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render
[333.650726] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[333.750738] [090/156] (693s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[333.843265] Starting subtest: fbcpsr-slowdraw
[333.844693] Subtest fbcpsr-slowdraw: SKIP (0.000s)
[333.940630] [091/156] (693s left) kms_lease (cursor-implicit-plane)
[334.028834] Starting subtest: cursor-implicit-plane
[334.029544] Starting dynamic subtest: pipe-A-HDMI-A-1
[334.210403] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.180s)
[334.224419] Starting dynamic subtest: pipe-B-HDMI-A-1
[334.379387] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.167s)
[334.391062] Starting dynamic subtest: pipe-C-HDMI-A-1
[334.568285] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.186s)
[334.579739] Starting dynamic subtest: pipe-D-HDMI-A-1
[334.742400] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.171s)
[334.743130] Subtest cursor-implicit-plane: SUCCESS (0.714s)
[334.877797] [092/156] (692s left) syncobj_wait (invalid-reset-zero-handles)
[334.916253] Starting subtest: invalid-reset-zero-handles
[334.917011] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[334.978607] [093/156] (692s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[335.071261] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[335.072773] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[335.177473] [094/156] (692s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[335.283067] Starting subtest: yf-tiled-64bpp-rotate-90
[335.284530] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[335.385456] [095/156] (691s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[335.477606] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc
[335.479104] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[335.585909] [096/156] (691s left) gem_exec_fence (long-history)
[335.911092] Starting subtest: long-history
[341.609365] Subtest long-history: SUCCESS (5.692s)
[342.009405] [097/156] (685s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[342.103501] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[342.104956] Subtest psr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[342.207526] [098/156] (685s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[342.297289] Starting subtest: bad-rotation-90-yf-tiled-ccs
[342.298060] Starting dynamic subtest: pipe-A-HDMI-A-1
[342.305156] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[342.314654] Starting dynamic subtest: pipe-B-HDMI-A-1
[342.328612] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[342.338384] Starting dynamic subtest: pipe-C-HDMI-A-1
[342.345075] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[342.354843] Starting dynamic subtest: pipe-D-HDMI-A-1
[342.362032] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[342.363459] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.007s)
[342.557605] [099/156] (684s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[342.647859] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[345.033228] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (2.387s)
[345.178410] [100/156] (682s left) kms_chamelium_audio (dp-audio-edid)
[345.337138] Subtest dp-audio-edid: SKIP (0.000s)
[345.439167] [101/156] (682s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[345.532391] Starting subtest: addfb25-yf-tiled-legacy
[345.533207] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[345.634243] [102/156] (681s left) kms_frontbuffer_tracking (hdr-1p-primscrn-indfb-pgflip-blt)
[345.725185] Starting subtest: hdr-1p-primscrn-indfb-pgflip-blt
[345.726688] Subtest hdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[345.826592] [103/156] (681s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[345.921028] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[345.922491] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[346.013725] [104/156] (681s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[346.106258] Starting subtest: fbc-2p-pri-indfb-multidraw
[346.107679] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[346.210549] [105/156] (681s left) kms_sequence (queue-busy)
[346.301290] Starting subtest: queue-busy
[346.302051] Starting dynamic subtest: pipe-A-HDMI-A-1
[347.600689] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.299s)
[347.612942] Starting dynamic subtest: pipe-B-HDMI-A-1
[348.885627] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.283s)
[348.899578] Starting dynamic subtest: pipe-C-HDMI-A-1
[350.175927] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.289s)
[350.187291] Starting dynamic subtest: pipe-D-HDMI-A-1
[351.455666] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.279s)
[351.456406] Subtest queue-busy: SUCCESS (5.158s)
[351.585551] [106/156] (676s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[351.677908] Starting subtest: plane-upscale-20x20-with-rotation
[351.678647] Starting dynamic subtest: pipe-A
[352.824396] Dynamic subtest pipe-A: SKIP (1.145s)
[352.835757] Starting dynamic subtest: pipe-B
[354.019112] Dynamic subtest pipe-B: SKIP (1.195s)
[354.028483] Starting dynamic subtest: pipe-C
[355.185910] Dynamic subtest pipe-C: SKIP (1.167s)
[355.195481] Starting dynamic subtest: pipe-D
[356.401683] Dynamic subtest pipe-D: SKIP (1.214s)
[356.403071] Subtest plane-upscale-20x20-with-rotation: SKIP (4.725s)
[356.591204] [107/156] (671s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-pwrite)
[356.693504] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-pwrite
[356.694915] Subtest psrhdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[356.778280] [108/156] (671s left) gem_exec_reloc (basic-write-wc)
[356.818017] Starting subtest: basic-write-wc
[356.824132] Subtest basic-write-wc: SUCCESS (0.006s)
[356.945590] [109/156] (670s left) syncobj_timeline (reset-signaled)
[356.981167] Starting subtest: reset-signaled
[356.981916] Subtest reset-signaled: SUCCESS (0.000s)
[357.044227] [110/156] (670s left) kms_psr (pr-cursor-plane-move)
[357.134741] Subtest pr-cursor-plane-move: SKIP (0.000s)
[357.182201] [111/156] (670s left) syncobj_wait (invalid-wait-illegal-handle)
[357.217212] Starting subtest: invalid-wait-illegal-handle
[357.217912] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[357.277276] [112/156] (670s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[357.369801] Starting subtest: extended-pageflip-modeset-hang-oldfb
[357.371695] Starting dynamic subtest: pipe-A
[376.926609] Dynamic subtest pipe-A: SUCCESS (19.563s)
[376.939950] Starting dynamic subtest: pipe-D
[396.889844] Dynamic subtest pipe-D: SUCCESS (19.945s)
[396.890649] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (39.516s)
[397.030114] [113/156] (630s left) kms_psr (psr2-primary-blt)
[397.125394] Subtest psr2-primary-blt: SKIP (0.000s)
[397.167918] [114/156] (630s left) gem_softpin (evict-snoop-interruptible)
[397.208470] Starting subtest: evict-snoop-interruptible
[397.209970] Subtest evict-snoop-interruptible: SKIP (0.000s)
[397.294049] [115/156] (630s left) kms_force_connector_basic (force-load-detect)
[397.416597] Starting subtest: force-load-detect
[397.417999] Subtest force-load-detect: SKIP (0.000s)
[397.572282] [116/156] (630s left) kms_chamelium_edid (hdmi-mode-timings)
[397.717872] Subtest hdmi-mode-timings: SKIP (0.000s)
[397.819440] [117/156] (630s left) syncobj_timeline (invalid-signal-zero-handles)
[397.858487] Starting subtest: invalid-signal-zero-handles
[397.859317] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[397.923159] [118/156] (630s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt)
[398.015267] Starting subtest: fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt
[398.016657] Subtest fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[398.104774] [119/156] (630s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[398.204554] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[398.205879] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[398.316911] [120/156] (629s left) gem_mmap_gtt (fault-concurrent-x)
[398.350941] Starting subtest: fault-concurrent-X
[401.062017] Subtest fault-concurrent-X: SUCCESS (2.702s)
[401.186128] [121/156] (627s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[401.226846] Starting subtest: y-tiled-to-vebox-y-tiled
[401.227568] Starting dynamic subtest: smem
[401.323211] Dynamic subtest smem: SUCCESS (0.096s)
[401.323951] Subtest y-tiled-to-vebox-y-tiled: SUCCESS (0.097s)
[401.515623] [122/156] (626s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-plflip-blt)
[401.611267] Starting subtest: psrhdr-2p-scndscrn-shrfb-plflip-blt
[401.612666] Subtest psrhdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[401.708030] [123/156] (626s left) vgem_basic (debugfs)
[401.744005] Starting subtest: debugfs
[401.744712] Subtest debugfs: SUCCESS (0.000s)
[401.798217] [124/156] (626s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[401.887374] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[401.889617] Starting dynamic subtest: pipe-A-valid-mode
[403.126662] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.238s)
[403.127388] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (1.240s)
[403.277708] [125/156] (625s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[403.377937] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[403.379454] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[403.461621] [126/156] (625s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[403.554393] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[403.555832] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[403.658385] [127/156] (624s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[403.751380] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[403.752809] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[403.852986] [128/156] (624s left) kms_vblank (wait-forked-hang)
[403.942904] Starting subtest: wait-forked-hang
[403.944688] Starting dynamic subtest: pipe-A-HDMI-A-1
[417.891063] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (13.945s)
[417.904445] Starting dynamic subtest: pipe-D-HDMI-A-1
[432.216938] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (14.323s)
[432.218850] Subtest wait-forked-hang: SUCCESS (28.275s)
[432.415192] [129/156] (596s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[432.511721] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[432.512439] Starting dynamic subtest: pipe-A-valid-mode
[434.413259] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.900s)
[434.414053] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SUCCESS (1.902s)
[434.559221] [130/156] (594s left) gem_ctx_exec (basic-invalid-context)
[434.598252] Starting subtest: basic-invalid-context
[434.600870] Subtest basic-invalid-context: SUCCESS (0.003s)
[434.718822] [131/156] (594s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-msflip-blt)
[434.814841] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-msflip-blt
[434.816299] Subtest fbcpsrhdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[434.918610] [132/156] (593s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[435.009869] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (0.000s)
[435.054751] [133/156] (593s left) gem_ppgtt (blt-vs-render-ctxn)
[435.093168] Starting subtest: blt-vs-render-ctxN
[467.728031] Subtest blt-vs-render-ctxN: SUCCESS (32.632s)
[467.852687] [134/156] (561s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[467.938155] Starting subtest: basic-gtt-cpu-noreloc
[467.941759] Subtest basic-gtt-cpu-noreloc: SUCCESS (0.004s)
[468.075166] [135/156] (560s left) gem_softpin (invalid)
[468.113420] Starting subtest: invalid
[468.117671] Subtest invalid: SUCCESS (0.004s)
[468.225793] [136/156] (560s left) gem_exec_capture (capture)
[468.264313] Starting subtest: capture
[468.265086] Starting dynamic subtest: rcs0-smem
[469.543920] Dynamic subtest rcs0-smem: SUCCESS (1.278s)
[469.553400] Starting dynamic subtest: bcs0-smem
[470.823468] Dynamic subtest bcs0-smem: SUCCESS (1.275s)
[470.832918] Starting dynamic subtest: vcs0-smem
[472.095597] Dynamic subtest vcs0-smem: SUCCESS (1.269s)
[472.104934] Starting dynamic subtest: vcs1-smem
[473.367771] Dynamic subtest vcs1-smem: SUCCESS (1.273s)
[473.376979] Starting dynamic subtest: vecs0-smem
[474.639546] Dynamic subtest vecs0-smem: SUCCESS (1.270s)
[474.640221] Subtest capture: SUCCESS (6.369s)
[474.746351] [137/156] (554s left) gem_tiled_blits (basic)
[474.831724] Starting subtest: basic
[474.847830] Subtest basic: SUCCESS (0.016s)
[474.970512] [138/156] (554s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[475.112401] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[475.113875] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[475.202916] [139/156] (553s left) gem_mmap_offset (partial-remap)
[475.238372] Starting subtest: partial-remap
[475.239114] Starting dynamic subtest: smem0
[475.243679] Dynamic subtest smem0: SUCCESS (0.003s)
[475.244499] Subtest partial-remap: SUCCESS (0.004s)
[475.357336] [140/156] (553s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-blt)
[475.449320] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-blt
[475.450725] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[475.556626] [141/156] (553s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-blt)
[475.649386] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-blt
[475.650814] Subtest hdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[475.757159] [142/156] (553s left) i915_power (sanity)
[475.791128] Starting subtest: sanity
[479.812258] Subtest sanity: SUCCESS (4.012s)
[479.920727] [143/156] (549s left) gem_exec_schedule (preempt-queue)
[479.978863] Starting subtest: preempt-queue
[479.979661] Starting dynamic subtest: rcs0
[480.085675] Dynamic subtest rcs0: SUCCESS (0.106s)
[480.100324] Starting dynamic subtest: bcs0
[480.201164] Dynamic subtest bcs0: SUCCESS (0.114s)
[480.215323] Starting dynamic subtest: vcs0
[480.312586] Dynamic subtest vcs0: SUCCESS (0.110s)
[480.325272] Starting dynamic subtest: vcs1
[480.419870] Dynamic subtest vcs1: SUCCESS (0.106s)
[480.431371] Starting dynamic subtest: vecs0
[480.519903] Dynamic subtest vecs0: SUCCESS (0.099s)
[480.520718] Subtest preempt-queue: SUCCESS (0.541s)
[480.845197] [144/156] (548s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[480.937793] Starting subtest: cursorB-vs-flipA-legacy
[480.940192] Subtest cursorB-vs-flipA-legacy: SKIP (0.002s)
[481.004223] [145/156] (548s left) i915_pm_rps (reset)
[481.043734] Starting subtest: reset
[485.581610] Subtest reset: SUCCESS (4.534s)
[485.711844] [146/156] (543s left) kms_psr (fbc-psr-cursor-plane-onoff)
[485.802547] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[485.848474] [147/156] (543s left) kms_setmode (clone-exclusive-crtc)
[485.883904] Starting subtest: clone-exclusive-crtc
[485.885987] Subtest clone-exclusive-crtc: SKIP (0.001s)
[485.944973] [148/156] (543s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[486.037933] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[486.039409] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[486.124255] [149/156] (543s left) kms_flip (flip-vs-rmfb)
[486.212915] Starting subtest: flip-vs-rmfb
[486.215241] Starting dynamic subtest: A-HDMI-A1
[493.938757] Dynamic subtest A-HDMI-A1: SUCCESS (7.725s)
[493.958562] Starting dynamic subtest: B-HDMI-A1
[501.616740] Dynamic subtest B-HDMI-A1: SUCCESS (7.677s)
[501.636031] Starting dynamic subtest: C-HDMI-A1
[509.276568] Dynamic subtest C-HDMI-A1: SUCCESS (7.655s)
[509.297064] Starting dynamic subtest: D-HDMI-A1
[516.949723] Dynamic subtest D-HDMI-A1: SUCCESS (7.667s)
[516.954874] Subtest flip-vs-rmfb: SUCCESS (30.743s)
[517.117152] [150/156] (512s left) gem_exec_whisper (basic-contexts-all)
[517.168420] Starting subtest: basic-contexts-all
[518.920937] Subtest basic-contexts-all: SUCCESS (1.751s)
[519.109609] [151/156] (510s left) dmabuf_sync_file (export-basic)
[519.150932] Starting subtest: export-basic
[519.152888] Subtest export-basic: SUCCESS (0.001s)
[519.214514] [152/156] (510s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[519.310604] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[519.312057] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[519.417469] [153/156] (510s left) gem_sync (basic-each)
[519.461673] Starting subtest: basic-each
[521.529446] Subtest basic-each: SUCCESS (2.067s)
[521.729211] [154/156] (508s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[521.823649] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[521.825912] Starting dynamic subtest: pipe-A-HDMI-A-1
[521.833668] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[521.847544] Starting dynamic subtest: pipe-B-HDMI-A-1
[521.855248] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[521.868311] Starting dynamic subtest: pipe-C-HDMI-A-1
[521.875857] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[521.885943] Starting dynamic subtest: pipe-D-HDMI-A-1
[521.893376] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[521.894710] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s)
[522.099534] [155/156] (507s left) syncobj_wait (multi-wait-for-submit-submitted)
[522.138614] Starting subtest: multi-wait-for-submit-submitted
[522.245447] Subtest multi-wait-for-submit-submitted: SUCCESS (0.107s)
[522.319882] [156/156] (507s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[522.418578] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt
[522.419944] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[522.512565] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_pipe_b_c_ivb
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_force_connector_basic
results: parsing output: 5/ for test: perf_pmu
results: parsing output: 6/ for test: gem_ccs
results: parsing output: 7/ for test: kms_plane_alpha_blend
results: parsing output: 8/ for test: gem_mmap_gtt
results: parsing output: 9/ for test: api_intel_allocator
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_plane
results: parsing output: 12/ for test: kms_ccs
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_pm_rpm
results: parsing output: 16/ for test: gem_render_copy
results: parsing output: 17/ for test: sysfs_heartbeat_interval
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_ctx_param
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: i915_pm_freq_mult
results: parsing output: 22/ for test: prime_busy
results: parsing output: 23/ for test: gem_exec_gttfill
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: gem_ctx_param
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: gem_lmem_swapping
results: parsing output: 28/ for test: gem_ctx_shared
results: parsing output: 29/ for test: kms_psr
results: parsing output: 30/ for test: gem_bad_reloc
results: parsing output: 31/ for test: kms_chamelium_hpd
results: parsing output: 32/ for test: kms_psr2_sf
results: parsing output: 33/ for test: gem_eio
results: parsing output: 34/ for test: kms_content_protection
results: parsing output: 35/ for test: syncobj_wait
results: parsing output: 36/ for test: gem_ctx_isolation
results: parsing output: 37/ for test: gem_flink_basic
results: parsing output: 38/ for test: gem_caching
results: parsing output: 39/ for test: kms_plane_scaling
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_pm_rpm
results: parsing output: 43/ for test: kms_atomic_transition
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_spin_batch
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: syncobj_basic
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: api_intel_bb
results: parsing output: 52/ for test: kms_atomic_interruptible
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_flip_scaled_crc
results: parsing output: 56/ for test: gem_pxp
results: parsing output: 57/ for test: gem_fence_thrash
results: parsing output: 58/ for test: gen9_exec_parse
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_exec_balancer
results: parsing output: 61/ for test: kms_plane
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_pwrite_crc
results: parsing output: 64/ for test: gem_flink_basic
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_ctx_persistence
results: parsing output: 67/ for test: gen7_exec_parse
results: parsing output: 68/ for test: gem_exec_schedule
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: perf
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: i915_drm_fdinfo
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_pipe_crc_basic
results: parsing output: 75/ for test: gem_exec_reloc
results: parsing output: 76/ for test: kms_cursor_crc
results: parsing output: 77/ for test: kms_color_pipeline
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_exec_reloc
results: parsing output: 82/ for test: kms_cursor_legacy
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_draw_crc
results: parsing output: 86/ for test: kms_cursor_crc
results: parsing output: 87/ for test: kms_cursor_crc
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_lease
results: parsing output: 91/ for test: syncobj_wait
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_exec_fence
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: kms_cursor_legacy
results: parsing output: 99/ for test: kms_chamelium_audio
results: parsing output: 100/ for test: kms_addfb_basic
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_sequence
results: parsing output: 105/ for test: kms_plane_scaling
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_exec_reloc
results: parsing output: 108/ for test: syncobj_timeline
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: syncobj_wait
results: parsing output: 111/ for test: kms_busy
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: gem_softpin
results: parsing output: 114/ for test: kms_force_connector_basic
results: parsing output: 115/ for test: kms_chamelium_edid
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_mmap_gtt
results: parsing output: 120/ for test: gem_render_copy
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: vgem_basic
results: parsing output: 123/ for test: kms_flip_scaled_crc
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_vblank
results: parsing output: 128/ for test: kms_flip_scaled_crc
results: parsing output: 129/ for test: gem_ctx_exec
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_psr2_sf
results: parsing output: 132/ for test: gem_ppgtt
results: parsing output: 133/ for test: gem_exec_reloc
results: parsing output: 134/ for test: gem_softpin
results: parsing output: 135/ for test: gem_exec_capture
results: parsing output: 136/ for test: gem_tiled_blits
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: gem_mmap_offset
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: i915_power
results: parsing output: 142/ for test: gem_exec_schedule
results: parsing output: 143/ for test: kms_cursor_legacy
results: parsing output: 144/ for test: i915_pm_rps
results: parsing output: 145/ for test: kms_psr
results: parsing output: 146/ for test: kms_setmode
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: kms_flip
results: parsing output: 149/ for test: gem_exec_whisper
results: parsing output: 150/ for test: dmabuf_sync_file
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: gem_sync
results: parsing output: 153/ for test: kms_ccs
results: parsing output: 154/ for test: syncobj_wait
results: parsing output: 155/ for test: kms_frontbuffer_tracking
Done.