[45.239533] Initializing watchdogs
[45.239595]   /dev/watchdog0
[45.255244] [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]
[45.261543] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[45.264144] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[45.266198] [001/156] (960s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[45.366781] Starting subtest: fbc-tiling-linear
[46.503431] Subtest fbc-tiling-linear: SUCCESS (1.138s)
[46.627648] [002/156] (959s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[46.663114] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[46.705719] [003/156] (959s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[46.799122] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[46.800468] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[46.886059] [004/156] (958s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[46.980370] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[46.981836] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[47.072803] [005/156] (958s left) kms_force_connector_basic (prune-stale-modes)
[47.198581] Starting subtest: prune-stale-modes
[47.349559] Subtest prune-stale-modes: SUCCESS (0.151s)
[47.500442] [006/156] (958s left) perf_pmu (most-busy-check-all)
[47.542514] Starting subtest: most-busy-check-all
[47.543246] Starting dynamic subtest: rcs0
[48.063361] Dynamic subtest rcs0: SUCCESS (0.520s)
[48.073227] Starting dynamic subtest: bcs0
[48.584428] Dynamic subtest bcs0: SUCCESS (0.520s)
[48.594705] Starting dynamic subtest: vcs0
[49.104173] Dynamic subtest vcs0: SUCCESS (0.518s)
[49.113478] Starting dynamic subtest: vcs1
[49.624090] Dynamic subtest vcs1: SUCCESS (0.519s)
[49.633803] Starting dynamic subtest: vecs0
[50.148264] Dynamic subtest vecs0: SUCCESS (0.523s)
[50.149354] Subtest most-busy-check-all: SUCCESS (2.602s)
[50.212321] [007/156] (955s left) gem_ccs (large-ctrl-surf-copy)
[50.250552] Starting subtest: large-ctrl-surf-copy
[50.252090] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[50.308576] [008/156] (955s left) kms_plane_alpha_blend (coverage-7efc)
[50.397640] Starting subtest: coverage-7efc
[50.468702] Starting dynamic subtest: pipe-A-HDMI-A-1
[50.783071] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.313s)
[50.819013] Starting dynamic subtest: pipe-D-HDMI-A-1
[51.274921] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.463s)
[51.275626] Subtest coverage-7efc: SUCCESS (0.876s)
[51.461051] [009/156] (954s left) gem_mmap_gtt (fault-concurrent)
[51.498401] Starting subtest: fault-concurrent
[54.061863] Subtest fault-concurrent: SUCCESS (2.552s)
[54.177364] [010/156] (951s left) api_intel_allocator (gem-pool)
[54.211551] Starting subtest: gem-pool
[54.217785] Subtest gem-pool: SUCCESS (0.007s)
[54.335708] [011/156] (951s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-fullscreen)
[54.429541] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-fullscreen
[54.430980] Subtest fbchdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[54.516764] [012/156] (951s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[54.604577] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[54.605971] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[54.664664] [013/156] (951s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[54.751698] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[54.752392] Starting dynamic subtest: pipe-A-HDMI-A-1
[54.759062] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[54.765980] Starting dynamic subtest: pipe-B-HDMI-A-1
[54.773084] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[54.779899] Starting dynamic subtest: pipe-C-HDMI-A-1
[54.787114] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[54.793731] Starting dynamic subtest: pipe-D-HDMI-A-1
[54.800840] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[54.802262] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.006s)
[55.002070] [014/156] (951s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[55.095879] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[55.096617] Starting dynamic subtest: pipe-A-HDMI-A-1
[55.103436] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[55.110308] Starting dynamic subtest: pipe-B-HDMI-A-1
[55.117100] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[55.123907] Starting dynamic subtest: pipe-C-HDMI-A-1
[55.130697] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[55.138089] Starting dynamic subtest: pipe-D-HDMI-A-1
[55.145861] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[55.147491] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[55.363624] [015/156] (950s left) kms_frontbuffer_tracking (hdr-rgb565-draw-blt)
[55.457106] Starting subtest: hdr-rgb565-draw-blt
[55.458453] Subtest hdr-rgb565-draw-blt: SKIP (0.000s)
[55.547265] [016/156] (950s left) kms_pm_rpm (legacy-planes-dpms)
[56.963537] Starting subtest: legacy-planes-dpms
[56.964750] Starting dynamic subtest: plane-65
[65.281572] Dynamic subtest plane-65: SUCCESS (8.311s)
[65.292617] Starting dynamic subtest: plane-95
[73.800447] Dynamic subtest plane-95: SUCCESS (8.514s)
[73.810529] Starting dynamic subtest: plane-125
[82.118231] Dynamic subtest plane-125: SUCCESS (8.315s)
[82.134742] Starting dynamic subtest: plane-135
[90.431405] Dynamic subtest plane-135: SUCCESS (8.311s)
[90.440337] Starting dynamic subtest: plane-145
[98.744203] Dynamic subtest plane-145: SUCCESS (8.311s)
[98.753305] Starting dynamic subtest: plane-155
[107.242418] Dynamic subtest plane-155: SUCCESS (8.497s)
[107.243629] Subtest legacy-planes-dpms: SUCCESS (50.265s)
[107.436912] [017/156] (898s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[107.479548] Starting subtest: x-tiled-to-vebox-y-tiled
[107.480312] Starting dynamic subtest: smem
[107.577979] Dynamic subtest smem: SUCCESS (0.098s)
[107.578729] Subtest x-tiled-to-vebox-y-tiled: SUCCESS (0.099s)
[107.779604] [018/156] (898s left) sysfs_heartbeat_interval (invalid)
[107.817282] Starting subtest: invalid
[107.818084] Starting dynamic subtest: vecs0
[107.818839] Dynamic subtest vecs0: SUCCESS (0.000s)
[107.825724] Starting dynamic subtest: vcs0
[107.826434] Dynamic subtest vcs0: SUCCESS (0.000s)
[107.833113] Starting dynamic subtest: bcs0
[107.833820] Dynamic subtest bcs0: SUCCESS (0.000s)
[107.840567] Starting dynamic subtest: rcs0
[107.841280] Dynamic subtest rcs0: SUCCESS (0.000s)
[107.847951] Starting dynamic subtest: vcs1
[107.848736] Dynamic subtest vcs1: SUCCESS (0.000s)
[107.849459] Subtest invalid: SUCCESS (0.004s)
[107.877238] [019/156] (898s left) kms_frontbuffer_tracking (fbc-stridechange)
[107.971305] Starting subtest: fbc-stridechange
[108.937273] Subtest fbc-stridechange: SUCCESS (0.967s)
[109.060640] [020/156] (897s left) gem_ctx_param (basic-default)
[109.094123] Starting subtest: basic-default
[109.094839] Subtest basic-default: SUCCESS (0.000s)
[109.156564] [021/156] (897s left) kms_psr (fbc-pr-primary-mmap-gtt)
[109.247313] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[109.289638] [022/156] (897s left) i915_pm_freq_mult (media-freq)
[109.324131] Starting subtest: media-freq
[109.324902] Starting dynamic subtest: gt0
[109.326345] Dynamic subtest gt0: SKIP (0.000s)
[109.327738] Subtest media-freq: SKIP (0.001s)
[109.378735] [023/156] (897s left) prime_busy (before-wait)
[109.415665] Starting subtest: before-wait
[109.420171] Starting dynamic subtest: rcs0
[109.449320] Dynamic subtest rcs0: SUCCESS (0.029s)
[109.460294] Starting dynamic subtest: bcs0
[109.466981] Dynamic subtest bcs0: SUCCESS (0.017s)
[109.478049] Starting dynamic subtest: vcs0
[109.482066] Dynamic subtest vcs0: SUCCESS (0.014s)
[109.490031] Starting dynamic subtest: vcs1
[109.499454] Dynamic subtest vcs1: SUCCESS (0.017s)
[109.507410] Starting dynamic subtest: vecs0
[109.517427] Dynamic subtest vecs0: SUCCESS (0.017s)
[109.627088] Subtest before-wait: SUCCESS (0.211s)
[109.696624] [024/156] (896s left) gem_exec_gttfill (engines)
[109.740387] Starting subtest: engines
[109.741199] Starting dynamic subtest: rcs0
[133.281350] Dynamic subtest rcs0: SUCCESS (23.540s)
[133.290687] Starting dynamic subtest: bcs0
[156.481737] Dynamic subtest bcs0: SUCCESS (23.200s)
[156.492905] Starting dynamic subtest: vcs0
[179.645874] Dynamic subtest vcs0: SUCCESS (23.163s)
[179.657756] Starting dynamic subtest: vcs1
[202.764703] Dynamic subtest vcs1: SUCCESS (23.118s)
[202.773762] Starting dynamic subtest: vecs0
[226.100787] Dynamic subtest vecs0: SUCCESS (23.335s)
[226.101695] Subtest engines: SUCCESS (116.360s)
[226.297702] [025/156] (780s left) syncobj_timeline (etime-multi-wait-all-submitted)
[226.397994] Starting subtest: etime-multi-wait-all-submitted
[226.501877] Subtest etime-multi-wait-all-submitted: SUCCESS (0.103s)
[226.585841] [026/156] (780s left) gem_ctx_param (get-priority-new-ctx)
[226.620219] Starting subtest: get-priority-new-ctx
[226.620998] Subtest get-priority-new-ctx: SUCCESS (0.000s)
[226.686669] [027/156] (780s left) kms_big_fb (linear-32bpp-rotate-90)
[226.793295] Starting subtest: linear-32bpp-rotate-90
[226.876339] Subtest linear-32bpp-rotate-90: SKIP (0.082s)
[226.976131] [028/156] (779s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[227.016168] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[227.058299] [029/156] (779s left) gem_ctx_shared (disjoint-timelines)
[227.100203] Starting subtest: disjoint-timelines
[227.132329] Subtest disjoint-timelines: SUCCESS (0.032s)
[227.344402] [FACT gem_ctx_shared (disjoint-timelines)] new: kernel.kmod_is_loaded.vgem: true
[227.346129] [030/156] (779s left) kms_psr (fbc-psr2-cursor-plane-move)
[227.436338] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[227.478058] [031/156] (779s left) gem_bad_reloc (negative-reloc-bltcopy)
[227.517544] Starting subtest: negative-reloc-bltcopy
[228.624562] Subtest negative-reloc-bltcopy: SUCCESS (1.099s)
[228.746859] [032/156] (778s left) kms_chamelium_hpd (hdmi-hpd)
[228.888449] Subtest hdmi-hpd: SKIP (0.000s)
[228.985647] [033/156] (777s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[229.078131] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[229.122334] [034/156] (777s left) gem_eio (wait-10ms)
[229.167797] Starting subtest: wait-10ms
[229.333224] Subtest wait-10ms: SUCCESS (0.166s)
[229.452155] [035/156] (777s left) kms_content_protection (legacy-hdcp14)
[229.550741] Starting subtest: legacy-hdcp14
[229.555712] Subtest legacy-hdcp14: SKIP (0.004s)
[229.668420] [036/156] (777s left) syncobj_wait (reset-signaled)
[229.704418] Starting subtest: reset-signaled
[229.705207] Subtest reset-signaled: SUCCESS (0.000s)
[229.776924] [037/156] (777s left) gem_ctx_isolation (dirty-switch)
[229.818627] Starting subtest: dirty-switch
[229.819381] Starting dynamic subtest: rcs0
[230.004377] Dynamic subtest rcs0: SUCCESS (0.177s)
[230.012374] Starting dynamic subtest: bcs0
[230.226802] Dynamic subtest bcs0: SUCCESS (0.222s)
[230.235024] Starting dynamic subtest: vcs0
[230.453096] Dynamic subtest vcs0: SUCCESS (0.226s)
[230.460902] Starting dynamic subtest: vcs1
[230.678709] Dynamic subtest vcs1: SUCCESS (0.224s)
[230.686586] Starting dynamic subtest: vecs0
[230.888723] Dynamic subtest vecs0: SUCCESS (0.209s)
[230.889462] Subtest dirty-switch: SUCCESS (1.062s)
[231.060628] [038/156] (776s left) gem_flink_basic (bad-open)
[231.094773] Starting subtest: bad-open
[231.095528] Subtest bad-open: SUCCESS (0.000s)
[231.166650] [039/156] (776s left) gem_caching (writes)
[231.204605] Starting subtest: writes
[240.489411] Subtest writes: SUCCESS (9.285s)
[240.604278] [040/156] (766s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[240.696624] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[240.697659] Starting dynamic subtest: pipe-A
[241.084264] Dynamic subtest pipe-A: SUCCESS (0.388s)
[241.098723] Starting dynamic subtest: pipe-B
[241.527925] Dynamic subtest pipe-B: SUCCESS (0.443s)
[241.536627] Starting dynamic subtest: pipe-C
[241.987559] Dynamic subtest pipe-C: SUCCESS (0.459s)
[241.998338] Starting dynamic subtest: pipe-D
[242.430043] Dynamic subtest pipe-D: SUCCESS (0.442s)
[242.430820] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (1.734s)
[242.628153] [041/156] (764s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[242.664039] Starting subtest: single-wait-all-for-submit-available-submitted
[242.664761] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[242.728616] [042/156] (764s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-render)
[242.824111] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-render
[242.825459] Subtest fbchdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[242.920114] [043/156] (764s left) kms_pm_rpm (system-suspend-idle)
[244.336364] Starting subtest: system-suspend-idle
[264.042965] Subtest system-suspend-idle: SUCCESS (4.965s)
[270.305230] [044/156] (743s left) kms_atomic_transition (modeset-transition)
[270.416858] Starting subtest: modeset-transition
[270.417638] Starting dynamic subtest: 1x-outputs
[271.699204] Dynamic subtest 1x-outputs: SUCCESS (1.277s)
[271.699980] Subtest modeset-transition: SUCCESS (1.278s)
[271.854557] [045/156] (741s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[271.952720] Starting subtest: pipe-fbc-rte
[271.956981] Subtest pipe-fbc-rte: SKIP (0.000s)
[272.056901] [046/156] (741s left) gem_spin_batch (resubmit-all)
[272.100690] Starting subtest: resubmit-all
[272.101428] Starting dynamic subtest: rcs0
[272.105102] Dynamic subtest rcs0: SUCCESS (0.004s)
[272.116176] Starting dynamic subtest: bcs0
[272.116890] Dynamic subtest bcs0: SUCCESS (0.002s)
[272.125703] Starting dynamic subtest: vcs0
[272.126414] Dynamic subtest vcs0: SUCCESS (0.002s)
[272.134518] Starting dynamic subtest: vcs1
[272.135236] Dynamic subtest vcs1: SUCCESS (0.002s)
[272.143210] Starting dynamic subtest: vecs0
[272.143898] Dynamic subtest vecs0: SUCCESS (0.002s)
[272.144622] Subtest resubmit-all: SUCCESS (0.015s)
[272.297763] [047/156] (741s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[272.390663] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[272.392123] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[272.480172] [048/156] (741s left) syncobj_basic (illegal-fd-to-handle)
[272.515251] Starting subtest: illegal-fd-to-handle
[272.515978] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[272.586946] [049/156] (741s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[272.679242] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[272.680716] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[272.772661] [050/156] (740s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[272.870351] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[273.556216] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (0.683s)
[273.698802] [051/156] (740s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[273.734279] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[273.835560] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.100s)
[273.934861] [052/156] (739s left) api_intel_bb (misplaced-blitter)
[273.969719] Starting subtest: misplaced-blitter
[273.974057] Subtest misplaced-blitter: SUCCESS (0.005s)
[274.089082] [053/156] (739s left) kms_atomic_interruptible (universal-setplane-cursor)
[274.180166] Starting subtest: universal-setplane-cursor
[274.182194] Starting dynamic subtest: pipe-A-HDMI-A-1
[280.412251] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.216s)
[280.413008] Subtest universal-setplane-cursor: SUCCESS (6.218s)
[280.576236] [054/156] (733s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[280.681358] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[280.682834] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[280.776103] [055/156] (733s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[280.868759] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[280.870247] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[280.969885] [056/156] (733s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[281.058933] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[281.059653] Starting dynamic subtest: pipe-A-valid-mode
[282.107802] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.046s)
[282.108587] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SUCCESS (1.048s)
[282.270825] [057/156] (731s left) gem_pxp (create-protected-buffer)
[282.378300] Starting subtest: create-protected-buffer
[282.379330] Subtest create-protected-buffer: SUCCESS (0.000s)
[282.481489] [058/156] (731s left) gem_fence_thrash (bo-write-verify-threaded-x)
[282.514766] Starting subtest: bo-write-verify-threaded-x
[287.580550] Subtest bo-write-verify-threaded-x: SUCCESS (5.025s)
[287.676100] [059/156] (726s left) gen9_exec_parse (allowed-single)
[287.714720] Subtest allowed-single: SKIP (0.000s)
[287.766229] [060/156] (726s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[287.860173] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[287.861611] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[287.973675] [061/156] (726s left) gem_exec_balancer (bonded-semaphore)
[288.016189] Starting subtest: bonded-semaphore
[292.360972] Subtest bonded-semaphore: SUCCESS (4.307s)
[292.539144] [062/156] (721s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[292.632224] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[292.651872] Starting dynamic subtest: pipe-A-plane-0
[292.876801] Dynamic subtest pipe-A-plane-0: SUCCESS (0.224s)
[292.895144] Starting dynamic subtest: pipe-A-plane-3
[293.043472] Dynamic subtest pipe-A-plane-3: SUCCESS (0.164s)
[293.058105] Starting dynamic subtest: pipe-A-plane-5
[293.210416] Dynamic subtest pipe-A-plane-5: SUCCESS (0.165s)
[293.379301] Starting dynamic subtest: pipe-B-plane-0
[293.562806] Dynamic subtest pipe-B-plane-0: SUCCESS (0.191s)
[293.579401] Starting dynamic subtest: pipe-B-plane-3
[293.737832] Dynamic subtest pipe-B-plane-3: SUCCESS (0.173s)
[293.756517] Starting dynamic subtest: pipe-B-plane-5
[293.905097] Dynamic subtest pipe-B-plane-5: SUCCESS (0.165s)
[293.978877] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SUCCESS (1.345s)
[294.167098] [063/156] (720s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[294.265588] Starting subtest: fbc-rgb565-draw-mmap-wc
[295.508591] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (1.242s)
[295.622938] [064/156] (718s left) kms_pwrite_crc (basic)
[295.714834] Starting subtest: basic
[296.023781] Subtest basic: SUCCESS (0.309s)
[296.178165] [065/156] (718s left) gem_flink_basic (bad-flink)
[296.214613] Starting subtest: bad-flink
[296.215304] Subtest bad-flink: SUCCESS (0.000s)
[296.275899] [066/156] (718s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-move)
[296.368953] Starting subtest: hdr-2p-primscrn-spr-indfb-move
[296.370428] Subtest hdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[296.479447] [067/156] (717s left) gem_ctx_persistence (legacy-engines-persistence)
[296.517993] Starting subtest: legacy-engines-persistence
[296.518863] Starting dynamic subtest: render
[297.300575] Dynamic subtest render: SUCCESS (0.781s)
[297.313414] Starting dynamic subtest: bsd1
[298.060650] Dynamic subtest bsd1: SUCCESS (0.756s)
[298.073111] Starting dynamic subtest: bsd2
[298.825659] Dynamic subtest bsd2: SUCCESS (0.761s)
[298.839010] Starting dynamic subtest: blt
[299.596617] Dynamic subtest blt: SUCCESS (0.767s)
[299.609115] Starting dynamic subtest: vebox
[300.370599] Dynamic subtest vebox: SUCCESS (0.770s)
[300.371717] Subtest legacy-engines-persistence: SUCCESS (3.851s)
[300.458724] [068/156] (714s left) gen7_exec_parse (basic-allowed)
[300.498051] Subtest basic-allowed: SKIP (0.000s)
[300.547950] [069/156] (713s left) gem_exec_schedule (reorder-wide)
[300.713970] Starting subtest: reorder-wide
[300.714891] Starting dynamic subtest: rcs0
[300.790975] Dynamic subtest rcs0: SUCCESS (0.077s)
[300.804399] Starting dynamic subtest: bcs0
[300.868990] Dynamic subtest bcs0: SUCCESS (0.076s)
[300.884308] Starting dynamic subtest: vcs0
[300.946068] Dynamic subtest vcs0: SUCCESS (0.075s)
[300.963259] Starting dynamic subtest: vcs1
[301.027897] Dynamic subtest vcs1: SUCCESS (0.079s)
[301.044892] Starting dynamic subtest: vecs0
[301.106787] Dynamic subtest vecs0: SUCCESS (0.077s)
[301.109563] Subtest reorder-wide: SUCCESS (0.395s)
[301.288641] [070/156] (713s left) kms_frontbuffer_tracking (psrhdr-slowdraw)
[301.383374] Starting subtest: psrhdr-slowdraw
[301.384765] Subtest psrhdr-slowdraw: SKIP (0.000s)
[301.480732] [071/156] (713s left) perf (non-zero-reason)
[301.582419] Starting subtest: non-zero-reason
[301.583126] Starting dynamic subtest: 0-rcs0
[309.301462] Dynamic subtest 0-rcs0: SUCCESS (7.681s)
[309.302324] Subtest non-zero-reason: SUCCESS (7.681s)
[309.340942] [072/156] (705s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-pwrite)
[309.435689] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-pwrite
[309.437125] Subtest fbchdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[309.526371] [073/156] (705s left) i915_drm_fdinfo (all-busy-check-all)
[309.564101] Starting subtest: all-busy-check-all
[310.081234] Subtest all-busy-check-all: SUCCESS (0.516s)
[310.149361] [074/156] (704s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[310.241321] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt
[310.242700] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[310.335297] [075/156] (704s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[310.423961] Starting subtest: compare-crc-sanitycheck-nv12
[310.424664] Starting dynamic subtest: pipe-A-HDMI-A-1
[310.781758] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.356s)
[310.793999] Starting dynamic subtest: pipe-B-HDMI-A-1
[311.120544] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.336s)
[311.133798] Starting dynamic subtest: pipe-C-HDMI-A-1
[311.441663] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.318s)
[311.453485] Starting dynamic subtest: pipe-D-HDMI-A-1
[311.761620] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.318s)
[311.762367] Subtest compare-crc-sanitycheck-nv12: SUCCESS (1.337s)
[311.926068] [076/156] (702s left) gem_exec_reloc (basic-write-gtt)
[311.969840] Starting subtest: basic-write-gtt
[311.976052] Subtest basic-write-gtt: SUCCESS (0.006s)
[312.119914] [077/156] (702s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[312.216075] Starting subtest: cursor-rapid-movement-max-size
[312.218169] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[312.320021] [078/156] (702s left) kms_color_pipeline (plane-lut1d)
[312.409437] Starting subtest: plane-lut1d
[312.494949] Starting dynamic subtest: pipe-A-plane-0
[312.596402] Dynamic subtest pipe-A-plane-0: SUCCESS (0.099s)
[312.612058] Starting dynamic subtest: pipe-A-plane-1
[312.693836] Dynamic subtest pipe-A-plane-1: SUCCESS (0.097s)
[312.710500] Starting dynamic subtest: pipe-A-plane-2
[312.794033] Dynamic subtest pipe-A-plane-2: SUCCESS (0.098s)
[312.993873] Starting dynamic subtest: pipe-B-plane-0
[313.077351] Dynamic subtest pipe-B-plane-0: SUCCESS (0.092s)
[313.091624] Starting dynamic subtest: pipe-B-plane-1
[313.168998] Dynamic subtest pipe-B-plane-1: SUCCESS (0.089s)
[313.183215] Starting dynamic subtest: pipe-B-plane-2
[313.266602] Dynamic subtest pipe-B-plane-2: SUCCESS (0.097s)
[313.467716] Starting dynamic subtest: pipe-C-plane-0
[313.542836] Dynamic subtest pipe-C-plane-0: SUCCESS (0.083s)
[313.558178] Starting dynamic subtest: pipe-C-plane-1
[313.642606] Dynamic subtest pipe-C-plane-1: SUCCESS (0.098s)
[313.657442] Starting dynamic subtest: pipe-C-plane-2
[313.735129] Dynamic subtest pipe-C-plane-2: SUCCESS (0.089s)
[313.953141] Starting dynamic subtest: pipe-D-plane-0
[314.035888] Dynamic subtest pipe-D-plane-0: SUCCESS (0.092s)
[314.049992] Starting dynamic subtest: pipe-D-plane-1
[314.138461] Dynamic subtest pipe-D-plane-1: SUCCESS (0.098s)
[314.152328] Starting dynamic subtest: pipe-D-plane-2
[314.236174] Dynamic subtest pipe-D-plane-2: SUCCESS (0.097s)
[314.285590] Subtest plane-lut1d: SUCCESS (1.875s)
[314.415295] [079/156] (700s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[314.520275] Starting subtest: yf-tiled-16bpp-rotate-180
[314.521657] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[314.588350] [080/156] (700s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[314.685273] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[314.686691] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[314.778736] [081/156] (700s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[314.870286] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt
[314.871710] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[314.973797] [082/156] (700s left) gem_exec_reloc (basic-wc-read)
[315.012994] Starting subtest: basic-wc-read
[315.019021] Subtest basic-wc-read: SUCCESS (0.006s)
[315.136322] [083/156] (700s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[315.226145] Starting subtest: short-busy-flip-before-cursor-toggle
[315.227613] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[315.286159] [084/156] (699s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[315.379890] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[315.389480] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.009s)
[315.469802] [085/156] (699s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[315.563599] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[315.565085] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[315.650892] [086/156] (699s left) kms_draw_crc (draw-method-render)
[315.740351] Starting subtest: draw-method-render
[315.741119] Starting dynamic subtest: xrgb8888-untiled
[315.908362] Dynamic subtest xrgb8888-untiled: SUCCESS (0.168s)
[315.930109] Starting dynamic subtest: rgb565-untiled
[316.083215] Dynamic subtest rgb565-untiled: SUCCESS (0.171s)
[316.102255] Starting dynamic subtest: xrgb2101010-untiled
[316.250033] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.164s)
[316.270441] Starting dynamic subtest: xbgr16161616f-untiled
[316.416856] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.164s)
[316.437304] Starting dynamic subtest: xrgb8888-xtiled
[316.508763] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.089s)
[316.529291] Starting dynamic subtest: rgb565-xtiled
[316.600385] Dynamic subtest rgb565-xtiled: SUCCESS (0.089s)
[316.620582] Starting dynamic subtest: xrgb2101010-xtiled
[316.683631] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.081s)
[316.703595] Starting dynamic subtest: xbgr16161616f-xtiled
[316.767182] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.081s)
[316.786871] Starting dynamic subtest: xrgb8888-ytiled
[316.858774] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.089s)
[316.879556] Starting dynamic subtest: rgb565-ytiled
[316.950626] Dynamic subtest rgb565-ytiled: SUCCESS (0.089s)
[316.971006] Starting dynamic subtest: xrgb2101010-ytiled
[317.033804] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.081s)
[317.053502] Starting dynamic subtest: xbgr16161616f-ytiled
[317.117398] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.081s)
[317.121037] Subtest draw-method-render: SUCCESS (1.378s)
[317.231793] [087/156] (698s left) kms_cursor_crc (cursor-sliding-256x85)
[317.327316] Starting subtest: cursor-sliding-256x85
[317.331879] Starting dynamic subtest: pipe-A-HDMI-A-1
[318.512185] Dynamic subtest pipe-A-HDMI-A-1: FAIL (1.004s)
[318.523848] Starting dynamic subtest: pipe-D-HDMI-A-1
[320.290175] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.913s)
[320.290980] Subtest cursor-sliding-256x85: FAIL (2.961s)
[320.451031] [088/156] (694s left) kms_cursor_crc (cursor-onscreen-256x256)
[320.549629] Starting subtest: cursor-onscreen-256x256
[320.553723] Starting dynamic subtest: pipe-A-HDMI-A-1
[321.720086] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.164s)
[321.757457] Starting dynamic subtest: pipe-D-HDMI-A-1
[322.893556] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.147s)
[322.894324] Subtest cursor-onscreen-256x256: SUCCESS (2.344s)
[323.045205] [089/156] (692s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render)
[323.146491] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render
[323.147912] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[323.242017] [090/156] (692s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[323.334042] Starting subtest: fbcpsr-slowdraw
[323.335462] Subtest fbcpsr-slowdraw: SKIP (0.000s)
[323.433303] [091/156] (692s left) kms_lease (cursor-implicit-plane)
[323.522040] Starting subtest: cursor-implicit-plane
[323.522754] Starting dynamic subtest: pipe-A-HDMI-A-1
[323.693750] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.170s)
[323.707232] Starting dynamic subtest: pipe-B-HDMI-A-1
[323.850357] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.153s)
[323.860153] Starting dynamic subtest: pipe-C-HDMI-A-1
[324.017163] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.165s)
[324.031065] Starting dynamic subtest: pipe-D-HDMI-A-1
[324.189027] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.169s)
[324.189856] Subtest cursor-implicit-plane: SUCCESS (0.667s)
[324.306336] [092/156] (691s left) syncobj_wait (invalid-reset-zero-handles)
[324.342682] Starting subtest: invalid-reset-zero-handles
[324.343462] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[324.426060] [093/156] (691s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[324.525120] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[324.526471] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[324.634175] [094/156] (690s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[324.733066] Starting subtest: yf-tiled-64bpp-rotate-90
[324.734469] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[324.835951] [095/156] (690s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[324.928660] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc
[324.930177] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[325.031899] [096/156] (690s left) gem_exec_fence (long-history)
[325.358494] Starting subtest: long-history
[331.078754] Subtest long-history: SUCCESS (5.709s)
[331.541718] [097/156] (684s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[331.636649] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[331.638107] Subtest psr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[331.749793] [098/156] (684s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[331.839219] Starting subtest: bad-rotation-90-yf-tiled-ccs
[331.839954] Starting dynamic subtest: pipe-A-HDMI-A-1
[331.846933] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[331.856544] Starting dynamic subtest: pipe-B-HDMI-A-1
[331.863681] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[331.876231] Starting dynamic subtest: pipe-C-HDMI-A-1
[331.883165] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[331.892193] Starting dynamic subtest: pipe-D-HDMI-A-1
[331.899197] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[331.900581] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.007s)
[332.107757] [099/156] (683s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[332.199196] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[334.586528] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (2.386s)
[334.740009] [100/156] (681s left) kms_chamelium_audio (dp-audio-edid)
[334.893138] Subtest dp-audio-edid: SKIP (0.000s)
[335.012375] [101/156] (680s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[335.105874] Starting subtest: addfb25-yf-tiled-legacy
[335.106636] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[335.205370] [102/156] (680s left) kms_frontbuffer_tracking (hdr-1p-primscrn-indfb-pgflip-blt)
[335.298600] Starting subtest: hdr-1p-primscrn-indfb-pgflip-blt
[335.300037] Subtest hdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[335.408579] [103/156] (680s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[335.501073] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[335.502582] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[335.609066] [104/156] (680s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[335.700805] Starting subtest: fbc-2p-pri-indfb-multidraw
[335.702265] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[335.808668] [105/156] (680s left) kms_sequence (queue-busy)
[335.898013] Starting subtest: queue-busy
[335.898772] Starting dynamic subtest: pipe-A-HDMI-A-1
[337.190563] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.291s)
[337.203111] Starting dynamic subtest: pipe-B-HDMI-A-1
[338.471844] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.279s)
[338.482737] Starting dynamic subtest: pipe-C-HDMI-A-1
[339.751934] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.277s)
[339.763208] Starting dynamic subtest: pipe-D-HDMI-A-1
[341.028865] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.275s)
[341.030708] Subtest queue-busy: SUCCESS (5.130s)
[341.159244] [106/156] (674s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[341.253881] Starting subtest: plane-upscale-20x20-with-rotation
[341.254590] Starting dynamic subtest: pipe-A
[342.436056] Dynamic subtest pipe-A: SKIP (1.180s)
[342.445535] Starting dynamic subtest: pipe-B
[343.605554] Dynamic subtest pipe-B: SKIP (1.167s)
[343.614983] Starting dynamic subtest: pipe-C
[344.769170] Dynamic subtest pipe-C: SKIP (1.163s)
[344.778773] Starting dynamic subtest: pipe-D
[345.974066] Dynamic subtest pipe-D: SKIP (1.202s)
[345.976281] Subtest plane-upscale-20x20-with-rotation: SKIP (4.717s)
[346.162487] [107/156] (670s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-pwrite)
[346.272464] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-pwrite
[346.273880] Subtest psrhdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[346.374651] [108/156] (669s left) gem_exec_reloc (basic-write-wc)
[346.414502] Starting subtest: basic-write-wc
[346.420186] Subtest basic-write-wc: SUCCESS (0.006s)
[346.542644] [109/156] (669s left) syncobj_timeline (reset-signaled)
[346.578829] Starting subtest: reset-signaled
[346.579572] Subtest reset-signaled: SUCCESS (0.000s)
[346.642810] [110/156] (669s left) kms_psr (pr-cursor-plane-move)
[346.731778] Subtest pr-cursor-plane-move: SKIP (0.000s)
[346.780635] [111/156] (669s left) syncobj_wait (invalid-wait-illegal-handle)
[346.816768] Starting subtest: invalid-wait-illegal-handle
[346.817478] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[346.875647] [112/156] (669s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[346.969918] Starting subtest: extended-pageflip-modeset-hang-oldfb
[346.971701] Starting dynamic subtest: pipe-A
[366.623136] Dynamic subtest pipe-A: SUCCESS (19.644s)
[366.636397] Starting dynamic subtest: pipe-D
[386.579292] Dynamic subtest pipe-D: SUCCESS (19.967s)
[386.581191] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (39.617s)
[386.717307] [113/156] (629s left) kms_psr (psr2-primary-blt)
[386.815593] Subtest psr2-primary-blt: SKIP (0.000s)
[386.859340] [114/156] (629s left) gem_softpin (evict-snoop-interruptible)
[386.899845] Starting subtest: evict-snoop-interruptible
[386.901388] Subtest evict-snoop-interruptible: SKIP (0.000s)
[386.996675] [115/156] (629s left) kms_force_connector_basic (force-load-detect)
[387.121033] Starting subtest: force-load-detect
[387.126535] Subtest force-load-detect: SKIP (0.000s)
[387.280158] [116/156] (629s left) kms_chamelium_edid (hdmi-mode-timings)
[387.429993] Subtest hdmi-mode-timings: SKIP (0.000s)
[387.540301] [117/156] (629s left) syncobj_timeline (invalid-signal-zero-handles)
[387.577478] Starting subtest: invalid-signal-zero-handles
[387.578273] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[387.641515] [118/156] (628s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt)
[387.733026] Starting subtest: fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt
[387.734401] Subtest fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[387.838952] [119/156] (628s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[387.931744] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[387.933181] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[388.024990] [120/156] (628s left) gem_mmap_gtt (fault-concurrent-x)
[388.059229] Starting subtest: fault-concurrent-X
[390.782060] Subtest fault-concurrent-X: SUCCESS (2.715s)
[390.901790] [121/156] (625s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[390.943731] Starting subtest: y-tiled-to-vebox-y-tiled
[390.944440] Starting dynamic subtest: smem
[391.040620] Dynamic subtest smem: SUCCESS (0.097s)
[391.041335] Subtest y-tiled-to-vebox-y-tiled: SUCCESS (0.098s)
[391.237700] [122/156] (625s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-plflip-blt)
[391.331699] Starting subtest: psrhdr-2p-scndscrn-shrfb-plflip-blt
[391.333095] Subtest psrhdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[391.424022] [123/156] (625s left) vgem_basic (debugfs)
[391.461123] Starting subtest: debugfs
[391.461832] Subtest debugfs: SUCCESS (0.000s)
[391.522531] [124/156] (625s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[391.609888] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[391.611736] Starting dynamic subtest: pipe-A-valid-mode
[392.854975] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.243s)
[392.855838] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (1.245s)
[393.010308] [125/156] (623s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[393.105652] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[393.107116] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[393.198548] [126/156] (623s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[393.293977] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[393.295378] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[393.399292] [127/156] (623s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[393.492418] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[393.493827] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[393.590973] [128/156] (623s left) kms_vblank (wait-forked-hang)
[393.678962] Starting subtest: wait-forked-hang
[393.680755] Starting dynamic subtest: pipe-A-HDMI-A-1
[407.582442] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (13.903s)
[407.595094] Starting dynamic subtest: pipe-D-HDMI-A-1
[421.401141] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (13.816s)
[421.401875] Subtest wait-forked-hang: SUCCESS (27.725s)
[421.578694] [129/156] (595s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[421.673952] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[421.674660] Starting dynamic subtest: pipe-A-valid-mode
[423.565020] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.891s)
[423.566847] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SUCCESS (1.893s)
[423.703212] [130/156] (593s left) gem_ctx_exec (basic-invalid-context)
[423.741647] Starting subtest: basic-invalid-context
[423.743431] Subtest basic-invalid-context: SUCCESS (0.002s)
[423.856797] [131/156] (593s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-msflip-blt)
[423.952384] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-msflip-blt
[423.953774] Subtest fbcpsrhdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[424.040895] [132/156] (593s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[424.130573] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (0.000s)
[424.178636] [133/156] (593s left) gem_ppgtt (blt-vs-render-ctxn)
[424.217948] Starting subtest: blt-vs-render-ctxN
[456.903377] Subtest blt-vs-render-ctxN: SUCCESS (32.667s)
[457.035665] [134/156] (560s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[457.131505] Starting subtest: basic-gtt-cpu-noreloc
[457.136055] Subtest basic-gtt-cpu-noreloc: SUCCESS (0.004s)
[457.261143] [135/156] (560s left) gem_softpin (invalid)
[457.300613] Starting subtest: invalid
[457.304831] Subtest invalid: SUCCESS (0.004s)
[457.404063] [136/156] (560s left) gem_exec_capture (capture)
[457.444852] Starting subtest: capture
[457.445571] Starting dynamic subtest: rcs0-smem
[458.725979] Dynamic subtest rcs0-smem: SUCCESS (1.273s)
[458.735604] Starting dynamic subtest: bcs0-smem
[459.997952] Dynamic subtest bcs0-smem: SUCCESS (1.270s)
[460.007640] Starting dynamic subtest: vcs0-smem
[461.269759] Dynamic subtest vcs0-smem: SUCCESS (1.269s)
[461.279144] Starting dynamic subtest: vcs1-smem
[462.541937] Dynamic subtest vcs1-smem: SUCCESS (1.270s)
[462.551392] Starting dynamic subtest: vecs0-smem
[463.813552] Dynamic subtest vecs0-smem: SUCCESS (1.271s)
[463.814224] Subtest capture: SUCCESS (6.359s)
[463.933584] [137/156] (553s left) gem_tiled_blits (basic)
[464.013269] Starting subtest: basic
[464.025614] Subtest basic: SUCCESS (0.014s)
[464.154887] [138/156] (553s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[464.311729] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[464.313229] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[464.414284] [139/156] (553s left) gem_mmap_offset (partial-remap)
[464.449123] Starting subtest: partial-remap
[464.449883] Starting dynamic subtest: smem0
[464.454694] Dynamic subtest smem0: SUCCESS (0.003s)
[464.455387] Subtest partial-remap: SUCCESS (0.004s)
[464.560459] [140/156] (553s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-blt)
[464.653362] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-blt
[464.654825] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[464.751088] [141/156] (552s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-blt)
[464.843342] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-blt
[464.844824] Subtest hdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[464.931924] [142/156] (552s left) i915_power (sanity)
[464.966048] Starting subtest: sanity
[468.987831] Subtest sanity: SUCCESS (4.011s)
[469.108853] [143/156] (548s left) gem_exec_schedule (preempt-queue)
[469.165820] Starting subtest: preempt-queue
[469.166532] Starting dynamic subtest: rcs0
[469.272805] Dynamic subtest rcs0: SUCCESS (0.107s)
[469.285032] Starting dynamic subtest: bcs0
[469.380118] Dynamic subtest bcs0: SUCCESS (0.106s)
[469.392401] Starting dynamic subtest: vcs0
[469.487615] Dynamic subtest vcs0: SUCCESS (0.106s)
[469.500001] Starting dynamic subtest: vcs1
[469.604290] Dynamic subtest vcs1: SUCCESS (0.115s)
[469.616414] Starting dynamic subtest: vecs0
[469.712158] Dynamic subtest vecs0: SUCCESS (0.107s)
[469.713001] Subtest preempt-queue: SUCCESS (0.548s)
[470.032661] [144/156] (547s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[470.128249] Starting subtest: cursorB-vs-flipA-legacy
[470.130835] Subtest cursorB-vs-flipA-legacy: SKIP (0.002s)
[470.190356] [145/156] (547s left) i915_pm_rps (reset)
[470.230454] Starting subtest: reset
[474.794373] Subtest reset: SUCCESS (4.531s)
[474.893781] [146/156] (543s left) kms_psr (fbc-psr-cursor-plane-onoff)
[474.984487] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[475.031517] [147/156] (542s left) kms_setmode (clone-exclusive-crtc)
[475.065854] Starting subtest: clone-exclusive-crtc
[475.067971] Subtest clone-exclusive-crtc: SKIP (0.000s)
[475.137602] [148/156] (542s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[475.229467] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[475.230980] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[475.329027] [149/156] (542s left) kms_flip (flip-vs-rmfb)
[475.418675] Starting subtest: flip-vs-rmfb
[475.421143] Starting dynamic subtest: A-HDMI-A1
[483.119326] Dynamic subtest A-HDMI-A1: SUCCESS (7.696s)
[483.139011] Starting dynamic subtest: B-HDMI-A1
[490.776434] Dynamic subtest B-HDMI-A1: SUCCESS (7.651s)
[490.794190] Starting dynamic subtest: C-HDMI-A1
[498.458529] Dynamic subtest C-HDMI-A1: SUCCESS (7.681s)
[498.476760] Starting dynamic subtest: D-HDMI-A1
[506.150802] Dynamic subtest D-HDMI-A1: SUCCESS (7.692s)
[506.156578] Subtest flip-vs-rmfb: SUCCESS (30.738s)
[506.325035] [150/156] (511s left) gem_exec_whisper (basic-contexts-all)
[506.369817] Starting subtest: basic-contexts-all
[508.106093] Subtest basic-contexts-all: SUCCESS (1.736s)
[508.283601] [151/156] (509s left) dmabuf_sync_file (export-basic)
[508.325831] Starting subtest: export-basic
[508.327847] Subtest export-basic: SUCCESS (0.001s)
[508.391255] [152/156] (509s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[508.487250] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[508.488690] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[508.582054] [153/156] (509s left) gem_sync (basic-each)
[508.632982] Starting subtest: basic-each
[510.730932] Subtest basic-each: SUCCESS (2.105s)
[510.925659] [154/156] (507s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[511.019700] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[511.021937] Starting dynamic subtest: pipe-A-HDMI-A-1
[511.030672] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[511.042657] Starting dynamic subtest: pipe-B-HDMI-A-1
[511.050059] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[511.059699] Starting dynamic subtest: pipe-C-HDMI-A-1
[511.067027] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[511.077087] Starting dynamic subtest: pipe-D-HDMI-A-1
[511.084663] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[511.086303] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s)
[511.296899] [155/156] (506s left) syncobj_wait (multi-wait-for-submit-submitted)
[511.333381] Starting subtest: multi-wait-for-submit-submitted
[511.435503] Subtest multi-wait-for-submit-submitted: SUCCESS (0.101s)
[511.523298] [156/156] (506s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[511.615280] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt
[511.616736] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[511.733234] 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.