[64.398493] Initializing watchdogs
[64.398557]   /dev/watchdog0
[64.418680] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[64.428828] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[64.432768] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[64.435082] [001/134] (960s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[64.631992] Starting subtest: y-tiled-64bpp-rotate-270
[64.633766] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[64.809268] [002/134] (960s left) gem_exec_reloc (basic-wc-gtt)
[64.892166] Subtest basic-wc-gtt: SKIP (0.000s)
[64.977949] [003/134] (960s left) gem_exec_reloc (basic-active)
[65.059445] Subtest basic-active: SKIP (0.000s)
[65.136784] [004/134] (959s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[65.322503] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[65.324148] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[65.509392] [005/134] (959s left) gem_mmap_wc (copy)
[65.577083] Subtest copy: SKIP (0.000s)
[65.637684] [006/134] (959s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[65.816015] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[65.848984] Starting dynamic subtest: pipe-A-plane-0
[65.851159] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[65.858788] Starting dynamic subtest: pipe-A-plane-3
[65.861191] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[65.868369] Starting dynamic subtest: pipe-A-plane-5
[65.870158] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[66.076795] Starting dynamic subtest: pipe-B-plane-0
[66.079059] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[66.094558] Starting dynamic subtest: pipe-B-plane-3
[66.096742] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[66.110668] Starting dynamic subtest: pipe-B-plane-5
[66.112576] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[66.157502] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SKIP (0.340s)
[66.454231] [007/134] (958s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[66.530442] Starting subtest: invalid-bsd1-flag-on-blt
[66.531379] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[66.685255] [008/134] (958s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[66.961021] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[68.408608] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.449s)
[68.665544] [009/134] (956s left) kms_lease (simple-lease)
[68.840644] Starting subtest: simple-lease
[68.841479] Starting dynamic subtest: pipe-A-DP-3
[69.316838] Dynamic subtest pipe-A-DP-3: SUCCESS (0.475s)
[69.329642] Starting dynamic subtest: pipe-B-DP-3
[69.703424] Dynamic subtest pipe-B-DP-3: SUCCESS (0.385s)
[69.712121] Starting dynamic subtest: pipe-C-DP-3
[70.081251] Dynamic subtest pipe-C-DP-3: SUCCESS (0.377s)
[70.089422] Starting dynamic subtest: pipe-D-DP-3
[70.475617] Dynamic subtest pipe-D-DP-3: SUCCESS (0.394s)
[70.476589] Subtest simple-lease: SUCCESS (1.637s)
[70.820964] [010/134] (954s left) gem_exec_schedule (pi-distinct-iova)
[71.021238] Starting subtest: pi-distinct-iova
[71.022200] Starting dynamic subtest: rcs0
[71.286498] Dynamic subtest rcs0: SUCCESS (0.266s)
[71.294662] Starting dynamic subtest: bcs0
[71.475839] Dynamic subtest bcs0: SUCCESS (0.189s)
[71.484011] Starting dynamic subtest: vcs0
[71.662524] Dynamic subtest vcs0: SUCCESS (0.187s)
[71.670579] Starting dynamic subtest: vcs1
[71.851209] Dynamic subtest vcs1: SUCCESS (0.188s)
[71.859279] Starting dynamic subtest: vecs0
[72.037274] Dynamic subtest vecs0: SUCCESS (0.186s)
[72.045439] Starting dynamic subtest: vecs1
[72.225438] Dynamic subtest vecs1: SUCCESS (0.188s)
[72.233553] Starting dynamic subtest: ccs0
[72.420298] Dynamic subtest ccs0: SUCCESS (0.195s)
[72.421466] Subtest pi-distinct-iova: SUCCESS (1.401s)
[72.869888] [011/134] (952s left) gem_create (create-massive)
[72.935195] Starting subtest: create-massive
[72.936148] Subtest create-massive: SUCCESS (0.000s)
[73.237168] [012/134] (952s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[73.314931] Starting subtest: multi-wait-for-submit-submitted-signaled
[73.315815] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[73.451840] [013/134] (952s left) gem_userptr_blits (dmabuf-sync)
[73.532947] Starting subtest: dmabuf-sync
[73.546898] Subtest dmabuf-sync: SKIP (0.014s)
[73.721096] [014/134] (952s left) kms_psr (psr-cursor-plane-move)
[73.903742] Subtest psr-cursor-plane-move: SKIP (0.000s)
[73.960304] [015/134] (951s left) gem_close_race (basic-process)
[74.068063] Starting subtest: basic-process
[74.135638] Subtest basic-process: SUCCESS (0.068s)
[74.414584] [016/134] (951s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[74.586915] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[74.587831] Starting dynamic subtest: pipe-A-valid-mode
[74.666291] Dynamic subtest pipe-A-valid-mode: SKIP (0.078s)
[74.668120] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.079s)
[74.897522] [017/134] (951s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[74.965229] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[75.070483] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.104s)
[75.195280] [018/134] (950s left) kms_properties (get_properties-sanity-non-atomic)
[75.374221] Starting subtest: get_properties-sanity-non-atomic
[75.376411] Subtest get_properties-sanity-non-atomic: SUCCESS (0.002s)
[75.500265] [019/134] (950s left) gem_ctx_param (invalid-param-set)
[75.566419] Starting subtest: invalid-param-set
[75.567411] Subtest invalid-param-set: SUCCESS (0.000s)
[75.686388] [020/134] (950s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[75.867049] Subtest psr2-cursor-plane-update-sf: SKIP (0.000s)
[75.922584] [021/134] (950s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[76.107385] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[76.109118] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[76.296487] [022/134] (949s left) drm_read (short-buffer-wakeup)
[76.551234] Starting subtest: short-buffer-wakeup
[108.767863] Subtest short-buffer-wakeup: SUCCESS (32.213s)
[108.998744] [023/134] (917s left) gem_exec_whisper (basic-contexts-priority)
[109.079295] Starting subtest: basic-contexts-priority
[131.580069] Subtest basic-contexts-priority: SUCCESS (22.498s)
[131.863839] [024/134] (894s left) kms_chamelium_frames (dp-crc-multiple)
[132.117543] Subtest dp-crc-multiple: SKIP (0.000s)
[132.261096] [025/134] (894s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[132.344455] Starting subtest: yf-tiled-to-vebox-x-tiled
[132.346589] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[132.615516] [026/134] (893s left) kms_pm_rpm (legacy-planes)
[135.020198] Starting subtest: legacy-planes
[135.021472] Starting dynamic subtest: plane-64
[137.881200] Dynamic subtest plane-64: SUCCESS (2.860s)
[137.918294] Starting dynamic subtest: plane-94
[140.720988] Dynamic subtest plane-94: SUCCESS (2.838s)
[140.758188] Starting dynamic subtest: plane-124
[143.543547] Dynamic subtest plane-124: SUCCESS (2.820s)
[143.580187] Starting dynamic subtest: plane-134
[146.775959] Dynamic subtest plane-134: SUCCESS (3.230s)
[146.777947] Subtest legacy-planes: SUCCESS (11.754s)
[147.192697] [027/134] (879s left) kms_pm_rpm (system-suspend-modeset)
[148.980663] Starting subtest: system-suspend-modeset
[169.772267] Subtest system-suspend-modeset: SUCCESS (5.576s)
[170.412784] [028/134] (856s left) gem_exec_reloc (basic-wc-cpu)
[170.496154] Subtest basic-wc-cpu: SKIP (0.000s)
[170.579130] [029/134] (856s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[170.761897] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[170.804878] [030/134] (856s left) kms_flip (absolute-wf_vblank-interruptible)
[170.997462] Starting subtest: absolute-wf_vblank-interruptible
[171.002046] Starting dynamic subtest: A-DP3
[178.829413] Dynamic subtest A-DP3: SUCCESS (7.826s)
[178.843746] Starting dynamic subtest: B-DP3
[186.580468] Dynamic subtest B-DP3: SUCCESS (7.749s)
[186.592154] Starting dynamic subtest: C-DP3
[194.329559] Dynamic subtest C-DP3: SUCCESS (7.748s)
[194.341615] Starting dynamic subtest: D-DP3
[202.079361] Dynamic subtest D-DP3: SUCCESS (7.749s)
[202.081312] Subtest absolute-wf_vblank-interruptible: SUCCESS (31.083s)
[202.424235] [031/134] (824s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[202.491180] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[202.565774] [032/134] (824s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[202.746759] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[202.748384] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[202.913661] [033/134] (824s left) i915_drm_fdinfo (virtual-busy-all)
[202.975274] Starting subtest: virtual-busy-all
[202.977178] Subtest virtual-busy-all: SKIP (0.000s)
[203.093883] [034/134] (823s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[203.275882] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[203.277511] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[203.445885] [035/134] (823s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[203.633278] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[204.910225] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.276s)
[205.140244] [036/134] (822s left) gem_exec_balancer (parallel)
[205.476554] Starting subtest: parallel
[207.076596] Subtest parallel: SUCCESS (1.600s)
[207.241275] [037/134] (820s left) gem_ctx_param (vm)
[207.310567] Starting subtest: vm
[207.394525] Subtest vm: SUCCESS (0.084s)
[207.639538] [038/134] (819s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[207.821817] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[207.823480] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[208.007742] [039/134] (819s left) gem_softpin (full)
[208.080719] Starting subtest: full
[208.099217] Subtest full: SUCCESS (0.018s)
[208.303839] [040/134] (819s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[208.483510] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[208.485137] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[208.674292] [041/134] (818s left) gem_pread (uncached)
[208.745112] Subtest uncached: SKIP (0.000s)
[208.816860] [042/134] (818s left) kms_psr (psr-sprite-mmap-gtt)
[208.991444] Subtest psr-sprite-mmap-gtt: SKIP (0.000s)
[209.050716] [043/134] (818s left) i915_pm_rpm (debugfs-forcewake-user)
[211.243740] Starting subtest: debugfs-forcewake-user
[221.913362] Subtest debugfs-forcewake-user: SUCCESS (10.672s)
[222.333816] [044/134] (805s left) gem_ccs (block-multicopy-inplace)
[222.410005] Starting subtest: block-multicopy-inplace
[222.410956] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0-multicopy
[222.456879] Dynamic subtest linear-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.046s)
[222.468405] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0-multicopy
[222.560930] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.103s)
[222.571783] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0-multicopy
[222.575575] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.014s)
[222.586502] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0-multicopy
[222.682504] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.106s)
[222.693292] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0-multicopy
[222.697174] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.014s)
[222.708111] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0-multicopy
[222.802051] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.104s)
[222.813179] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0-multicopy
[222.816856] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.014s)
[222.827876] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0-multicopy
[222.919869] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.102s)
[222.920702] Subtest block-multicopy-inplace: SUCCESS (0.510s)
[223.086375] [045/134] (804s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[223.155390] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[223.263188] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.105s)
[223.415897] [046/134] (804s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[223.598746] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[223.600395] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[223.789588] [047/134] (804s left) gem_ctx_shared (exec-single-timeline)
[223.869480] Starting subtest: exec-single-timeline
[223.870416] Starting dynamic subtest: rcs0
[224.969107] Dynamic subtest rcs0: SUCCESS (1.095s)
[224.981635] Starting dynamic subtest: bcs0
[225.990507] Dynamic subtest bcs0: SUCCESS (1.021s)
[226.004518] Starting dynamic subtest: vcs0
[227.017107] Dynamic subtest vcs0: SUCCESS (1.021s)
[227.029017] Starting dynamic subtest: vcs1
[228.038283] Dynamic subtest vcs1: SUCCESS (1.021s)
[228.052570] Starting dynamic subtest: vecs0
[229.062417] Dynamic subtest vecs0: SUCCESS (1.022s)
[229.076903] Starting dynamic subtest: vecs1
[230.087483] Dynamic subtest vecs1: SUCCESS (1.021s)
[230.100162] Starting dynamic subtest: ccs0
[231.112462] Dynamic subtest ccs0: SUCCESS (1.020s)
[231.113605] Subtest exec-single-timeline: SUCCESS (7.241s)
[231.403121] [048/134] (796s left) gem_mmap_wc (write-read)
[231.476245] Subtest write-read: SKIP (0.000s)
[231.561397] [049/134] (796s left) kms_psr (pr-suspend)
[231.736442] Subtest pr-suspend: SKIP (0.000s)
[231.796772] [050/134] (796s left) kms_debugfs (display-off-read-all)
[231.977988] Starting subtest: display-off-read-all
[232.071351] Subtest display-off-read-all: SUCCESS (0.093s)
[232.310869] [051/134] (795s left) gem_exec_params (invalid-flag)
[232.386596] Starting subtest: invalid-flag
[232.387691] Subtest invalid-flag: SUCCESS (0.000s)
[232.559883] [052/134] (795s left) kms_cursor_crc (cursor-sliding-128x42)
[232.949470] Starting subtest: cursor-sliding-128x42
[232.953535] Starting dynamic subtest: pipe-A-DP-3
[237.407178] Dynamic subtest pipe-A-DP-3: SUCCESS (4.452s)
[237.456752] Starting dynamic subtest: pipe-D-DP-3
[241.849614] Dynamic subtest pipe-D-DP-3: SUCCESS (4.404s)
[241.850550] Subtest cursor-sliding-128x42: SUCCESS (8.900s)
[242.315822] [053/134] (786s left) kms_frontbuffer_tracking (psr-abgr161616f-draw-mmap-gtt)
[242.496256] Starting subtest: psr-abgr161616f-draw-mmap-gtt
[242.498111] Subtest psr-abgr161616f-draw-mmap-gtt: SKIP (0.000s)
[242.703573] [054/134] (785s left) sysfs_defaults (readonly)
[242.786532] Starting subtest: readonly
[242.787468] Starting dynamic subtest: vecs0
[242.788368] Dynamic subtest vecs0: SUCCESS (0.000s)
[242.799769] Starting dynamic subtest: ccs0
[242.800636] Dynamic subtest ccs0: SUCCESS (0.000s)
[242.811573] Starting dynamic subtest: vcs0
[242.812585] Dynamic subtest vcs0: SUCCESS (0.000s)
[242.823348] Starting dynamic subtest: bcs0
[242.824299] Dynamic subtest bcs0: SUCCESS (0.000s)
[242.835342] Starting dynamic subtest: vecs1
[242.836630] Dynamic subtest vecs1: SUCCESS (0.000s)
[242.847500] Starting dynamic subtest: rcs0
[242.848439] Dynamic subtest rcs0: SUCCESS (0.000s)
[242.859300] Starting dynamic subtest: vcs1
[242.860417] Dynamic subtest vcs1: SUCCESS (0.000s)
[242.861516] Subtest readonly: SUCCESS (0.008s)
[242.920858] [055/134] (785s left) kms_plane_multiple (tiling-4)
[243.098158] Starting subtest: tiling-4
[243.099063] Starting dynamic subtest: pipe-A-DP-3
[244.199059] Dynamic subtest pipe-A-DP-3: SUCCESS (1.101s)
[244.214880] Starting dynamic subtest: pipe-B-DP-3
[245.244395] Dynamic subtest pipe-B-DP-3: SUCCESS (1.043s)
[245.256009] Starting dynamic subtest: pipe-C-DP-3
[246.307549] Dynamic subtest pipe-C-DP-3: SUCCESS (1.062s)
[246.318917] Starting dynamic subtest: pipe-D-DP-3
[247.366542] Dynamic subtest pipe-D-DP-3: SUCCESS (1.058s)
[247.367391] Subtest tiling-4: SUCCESS (4.269s)
[247.663800] [056/134] (781s left) kms_async_flips (invalid-async-flip-atomic)
[247.845301] Starting subtest: invalid-async-flip-atomic
[248.079748] Starting dynamic subtest: pipe-A-DP-3
[248.464652] Dynamic subtest pipe-A-DP-3: SUCCESS (0.385s)
[248.668061] Starting dynamic subtest: pipe-B-DP-3
[248.813594] Dynamic subtest pipe-B-DP-3: SUCCESS (0.156s)
[249.013778] Starting dynamic subtest: pipe-C-DP-3
[249.159817] Dynamic subtest pipe-C-DP-3: SUCCESS (0.157s)
[249.374332] Starting dynamic subtest: pipe-D-DP-3
[249.527580] Dynamic subtest pipe-D-DP-3: SUCCESS (0.165s)
[249.528590] Subtest invalid-async-flip-atomic: SUCCESS (1.684s)
[250.079113] [057/134] (778s left) gem_exec_reloc (basic-range-active)
[250.160381] Subtest basic-range-active: SKIP (0.000s)
[250.237361] [058/134] (778s left) i915_query (query-regions-garbage-items)
[250.308375] Starting subtest: query-regions-garbage-items
[250.309334] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[250.492317] [059/134] (778s left) gem_exec_fence (basic-busy)
[250.698672] Starting subtest: basic-busy
[250.699612] Starting dynamic subtest: rcs0
[250.814017] Dynamic subtest rcs0: SUCCESS (0.119s)
[250.830984] Starting dynamic subtest: bcs0
[250.871030] Dynamic subtest bcs0: SUCCESS (0.053s)
[250.896074] Starting dynamic subtest: vcs0
[250.928376] Dynamic subtest vcs0: SUCCESS (0.055s)
[250.968660] Starting dynamic subtest: vcs1
[250.993393] Dynamic subtest vcs1: SUCCESS (0.063s)
[251.010364] Starting dynamic subtest: vecs0
[251.045482] Dynamic subtest vecs0: SUCCESS (0.051s)
[251.068724] Starting dynamic subtest: vecs1
[251.100948] Dynamic subtest vecs1: SUCCESS (0.054s)
[251.137257] Starting dynamic subtest: ccs0
[251.158668] Dynamic subtest ccs0: SUCCESS (0.056s)
[251.159677] Subtest basic-busy: SUCCESS (0.466s)
[251.998963] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[252.000911] [060/134] (776s left) gem_partial_pwrite_pread (reads-display)
[252.084510] Subtest reads-display: SKIP (0.000s)
[252.181011] [061/134] (776s left) kms_pipe_crc_basic (suspend-read-crc)
[252.367295] Starting subtest: suspend-read-crc
[252.368246] Starting dynamic subtest: pipe-A-DP-3
[272.592856] Dynamic subtest pipe-A-DP-3: SUCCESS (5.320s)
[272.607844] Starting dynamic subtest: pipe-B-DP-3
[293.001969] Dynamic subtest pipe-B-DP-3: SUCCESS (4.520s)
[293.018231] Starting dynamic subtest: pipe-C-DP-3
[313.448852] Dynamic subtest pipe-C-DP-3: SUCCESS (4.646s)
[313.466331] Starting dynamic subtest: pipe-D-DP-3
[333.914134] Dynamic subtest pipe-D-DP-3: SUCCESS (4.608s)
[333.915112] Subtest suspend-read-crc: SUCCESS (19.105s)
[334.266698] [062/134] (694s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[334.454401] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[334.456854] Starting dynamic subtest: pipe-A-DP-3
[334.465305] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[334.476877] Starting dynamic subtest: pipe-B-DP-3
[334.485005] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[334.496249] Starting dynamic subtest: pipe-C-DP-3
[334.504563] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[334.516032] Starting dynamic subtest: pipe-D-DP-3
[334.524643] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[334.526375] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SKIP (0.007s)
[334.926794] [063/134] (694s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[335.118825] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[335.120642] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[335.326106] [064/134] (693s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[335.516436] Starting subtest: basic-flip-before-cursor-varying-size
[336.557989] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.040s)
[336.845113] [065/134] (692s left) kms_addfb_basic (bad-pitch-32)
[336.923531] Starting subtest: bad-pitch-32
[336.924494] Subtest bad-pitch-32: SUCCESS (0.000s)
[337.225005] [066/134] (692s left) kms_atomic_transition (plane-all-transition)
[337.409300] Starting subtest: plane-all-transition
[337.411592] Starting dynamic subtest: pipe-A-DP-3
[341.160291] Dynamic subtest pipe-A-DP-3: SUCCESS (3.748s)
[341.295834] Starting dynamic subtest: pipe-B-DP-3
[345.193721] Dynamic subtest pipe-B-DP-3: SUCCESS (3.908s)
[345.283962] Subtest plane-all-transition: SUCCESS (7.873s)
[345.560172] [067/134] (684s left) gem_ctx_persistence (legacy-engines-cleanup)
[345.657282] Starting subtest: legacy-engines-cleanup
[345.658220] Starting dynamic subtest: render
[345.769039] Dynamic subtest render: SUCCESS (0.111s)
[345.788092] Starting dynamic subtest: bsd1
[345.804867] Dynamic subtest bsd1: SUCCESS (0.034s)
[345.824770] Starting dynamic subtest: bsd2
[345.864230] Dynamic subtest bsd2: SUCCESS (0.057s)
[345.898537] Starting dynamic subtest: blt
[345.929001] Dynamic subtest blt: SUCCESS (0.062s)
[345.951752] Starting dynamic subtest: vebox
[345.977153] Dynamic subtest vebox: SUCCESS (0.046s)
[345.978298] Subtest legacy-engines-cleanup: SUCCESS (0.321s)
[346.139087] [068/134] (683s left) i915_drm_fdinfo (virtual-busy-idle)
[346.211585] Starting subtest: virtual-busy-idle
[346.213443] Subtest virtual-busy-idle: SKIP (0.000s)
[346.346123] [069/134] (683s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[346.537777] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[346.539431] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[346.743065] [070/134] (683s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[346.933791] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[346.949047] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.014s)
[347.071897] [071/134] (682s left) gen9_exec_parse (bb-start-out)
[347.158050] Subtest bb-start-out: SKIP (0.000s)
[347.238003] [072/134] (682s left) gem_sync (basic-store-each)
[347.332530] Starting subtest: basic-store-each
[350.347759] Subtest basic-store-each: SUCCESS (3.015s)
[350.642551] [073/134] (679s left) api_intel_bb (reset-flags)
[350.720129] Starting subtest: reset-flags
[350.754880] Subtest reset-flags: SUCCESS (0.035s)
[350.957729] [074/134] (679s left) kms_psr (fbc-psr2-primary-page-flip)
[351.146927] Subtest fbc-psr2-primary-page-flip: SKIP (0.000s)
[351.201219] [075/134] (678s left) kms_psr (fbc-pr-dpms)
[351.386178] Subtest fbc-pr-dpms: SKIP (0.000s)
[351.452543] [076/134] (678s left) kms_vrr (negative-basic)
[351.640912] Starting subtest: negative-basic
[351.643421] Starting dynamic subtest: pipe-A-DP-3
[357.076324] Dynamic subtest pipe-A-DP-3: SUCCESS (5.432s)
[357.154720] Subtest negative-basic: SUCCESS (5.513s)
[357.460307] [077/134] (672s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[357.648528] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[357.662723] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.015s)
[357.824251] [078/134] (672s left) kms_chamelium_hpd (dp-hpd)
[358.085855] Subtest dp-hpd: SKIP (0.000s)
[358.236842] [079/134] (672s left) gem_lmem_swapping (heavy-verify-random)
[360.986007] Starting subtest: heavy-verify-random
[360.986927] Starting dynamic subtest: lmem0
[376.190085] Dynamic subtest lmem0: SUCCESS (15.204s)
[376.191050] Subtest heavy-verify-random: SUCCESS (15.205s)
[378.013571] [FACT gem_lmem_swapping (heavy-verify-random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[378.015066] [FACT gem_lmem_swapping (heavy-verify-random)] deleted: kernel.kmod_is_loaded.i915: true
[378.017588] [080/134] (652s left) syncobj_basic (bad-pad-handle-to-fd)
[379.578100] Starting subtest: bad-pad-handle-to-fd
[379.579082] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[379.648804] [FACT syncobj_basic (bad-pad-handle-to-fd)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[379.651147] [FACT syncobj_basic (bad-pad-handle-to-fd)] new: kernel.kmod_is_loaded.i915: true
[379.654108] [081/134] (650s left) gem_mmap_gtt (fault-concurrent-y)
[379.730799] Subtest fault-concurrent-Y: SKIP (0.000s)
[379.801468] [082/134] (650s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[379.989613] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[379.991205] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[380.189280] [083/134] (650s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[380.274401] Starting subtest: x-tiled-to-vebox-y-tiled
[380.276589] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[380.550549] [084/134] (650s left) gem_userptr_blits (userfault)
[380.645537] Starting subtest: userfault
[380.649684] Subtest userfault: SUCCESS (0.006s)
[380.853674] [085/134] (649s left) gem_exec_schedule (promotion)
[380.945094] Starting subtest: promotion
[380.946042] Starting dynamic subtest: rcs0
[381.251193] Dynamic subtest rcs0: SUCCESS (0.305s)
[381.262086] Starting dynamic subtest: bcs0
[381.462579] Dynamic subtest bcs0: SUCCESS (0.210s)
[381.473794] Starting dynamic subtest: vcs0
[381.712891] Dynamic subtest vcs0: SUCCESS (0.249s)
[381.723885] Starting dynamic subtest: vcs1
[381.935523] Dynamic subtest vcs1: SUCCESS (0.221s)
[381.946231] Starting dynamic subtest: vecs0
[382.158806] Dynamic subtest vecs0: SUCCESS (0.222s)
[382.169534] Starting dynamic subtest: vecs1
[382.378487] Dynamic subtest vecs1: SUCCESS (0.218s)
[382.389730] Starting dynamic subtest: ccs0
[382.661525] Dynamic subtest ccs0: SUCCESS (0.281s)
[382.662514] Subtest promotion: SUCCESS (1.716s)
[383.099998] [086/134] (647s left) kms_chamelium_color (ctm-0-50)
[383.283781] Subtest ctm-0-50: SKIP (0.000s)
[383.417199] [087/134] (647s left) syncobj_timeline (invalid-transfer-illegal-handle)
[383.492035] Starting subtest: invalid-transfer-illegal-handle
[383.492943] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[383.694202] [088/134] (647s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[383.895209] Starting subtest: yf-tiled-64bpp-rotate-90
[383.896905] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[384.088105] [089/134] (647s left) api_intel_bb (blit-noreloc-purge-cache)
[384.164131] Starting subtest: blit-noreloc-purge-cache
[384.197820] Subtest blit-noreloc-purge-cache: SUCCESS (0.034s)
[384.409428] [090/134] (646s left) kms_feature_discovery (display-2x)
[384.597538] Starting subtest: display-2x
[384.599318] Subtest display-2x: SKIP (0.000s)
[384.729079] [091/134] (646s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[384.919021] Starting subtest: plane-lut1d-ctm3x4-lut1d
[384.960348] Starting dynamic subtest: pipe-A-DP-3
[385.340964] Dynamic subtest pipe-A-DP-3: SUCCESS (0.381s)
[385.540676] Starting dynamic subtest: pipe-B-DP-3
[385.877200] Dynamic subtest pipe-B-DP-3: SUCCESS (0.348s)
[386.054381] Starting dynamic subtest: pipe-C-DP-3
[386.390926] Dynamic subtest pipe-C-DP-3: SUCCESS (0.348s)
[386.582818] Starting dynamic subtest: pipe-D-DP-3
[386.919552] Dynamic subtest pipe-D-DP-3: SUCCESS (0.348s)
[386.994128] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (2.076s)
[387.323746] [092/134] (644s left) sriov_basic (bind-unbind-vf)
[387.398749] Subtest bind-unbind-vf: SKIP (0.000s)
[387.472294] [093/134] (644s left) gem_eio (wait-immediate)
[387.804230] Starting subtest: wait-immediate
[388.421399] Subtest wait-immediate: SUCCESS (0.617s)
[388.727133] [094/134] (642s left) gem_mmap_gtt (coherency)
[388.803790] Subtest coherency: SKIP (0.000s)
[388.871041] [095/134] (642s left) syncobj_timeline (wait-delayed-signal)
[388.946296] Starting subtest: wait-delayed-signal
[389.050587] Subtest wait-delayed-signal: SUCCESS (0.103s)
[389.218315] [096/134] (642s left) perf (i915-ref-count)
[389.352991] Starting subtest: i915-ref-count
[389.644006] Subtest i915-ref-count: SUCCESS (0.290s)
[389.806535] [097/134] (641s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[389.994896] Starting subtest: flip-vs-cursor-varying-size
[402.052848] Subtest flip-vs-cursor-varying-size: SUCCESS (12.058s)
[402.331517] [098/134] (629s left) kms_pm_backlight (bad-brightness)
[402.516791] Subtest bad-brightness: SKIP (0.000s)
[402.577485] [099/134] (629s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[402.764968] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[402.765748] Starting dynamic subtest: pipe-A
[404.866186] Dynamic subtest pipe-A: SUCCESS (2.102s)
[404.888488] Starting dynamic subtest: pipe-B
[407.045295] Dynamic subtest pipe-B: SUCCESS (2.177s)
[407.065678] Starting dynamic subtest: pipe-C
[407.343732] Dynamic subtest pipe-C: SUCCESS (0.297s)
[407.374297] Starting dynamic subtest: pipe-D
[407.656366] Dynamic subtest pipe-D: SUCCESS (0.310s)
[407.657283] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (4.893s)
[408.005627] [100/134] (624s left) gem_exec_reloc (basic-write-wc)
[408.086933] Subtest basic-write-wc: SKIP (0.000s)
[408.163796] [101/134] (623s left) gem_userptr_blits (unsync-unmap-after-close)
[408.249571] Subtest unsync-unmap-after-close: SKIP (0.000s)
[408.507261] [102/134] (623s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[408.703053] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[408.703946] Starting dynamic subtest: pipe-A-DP-3
[408.712529] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[408.724268] Starting dynamic subtest: pipe-B-DP-3
[408.732756] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[408.744188] Starting dynamic subtest: pipe-C-DP-3
[408.752464] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[408.763698] Starting dynamic subtest: pipe-D-DP-3
[408.773742] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[408.776111] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[409.186518] [103/134] (623s left) kms_force_connector_basic (prune-stale-modes)
[409.294560] Starting subtest: prune-stale-modes
[409.318198] Subtest prune-stale-modes: SUCCESS (0.024s)
[409.682228] [104/134] (622s left) kms_joiner (invalid-modeset-ultra-joiner)
[409.877637] Starting subtest: invalid-modeset-ultra-joiner
[409.879395] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[410.032704] [105/134] (622s left) kms_vblank (wait-forked-busy)
[410.226017] Starting subtest: wait-forked-busy
[410.226887] Starting dynamic subtest: pipe-A-DP-3
[412.748247] Dynamic subtest pipe-A-DP-3: SUCCESS (2.519s)
[412.780372] Starting dynamic subtest: pipe-D-DP-3
[415.227772] Dynamic subtest pipe-D-DP-3: SUCCESS (2.470s)
[415.228699] Subtest wait-forked-busy: SUCCESS (5.003s)
[415.514674] [106/134] (617s left) syncobj_wait (wait-all-interrupted)
[415.592050] Starting subtest: wait-all-interrupted
[415.694868] Subtest wait-all-interrupted: SUCCESS (0.102s)
[415.881400] [107/134] (616s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[416.065264] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[416.067769] Starting dynamic subtest: pipe-A-DP-3
[416.076417] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[416.088065] Starting dynamic subtest: pipe-B-DP-3
[416.096441] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[416.108033] Starting dynamic subtest: pipe-C-DP-3
[416.116337] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[416.128170] Starting dynamic subtest: pipe-D-DP-3
[416.139777] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[416.142137] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.007s)
[416.538026] [108/134] (616s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[416.725058] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[416.726001] Starting dynamic subtest: pipe-A-DP-3
[416.734395] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[416.746259] Starting dynamic subtest: pipe-B-DP-3
[416.754724] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[416.766464] Starting dynamic subtest: pipe-C-DP-3
[416.774660] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[416.786808] Starting dynamic subtest: pipe-D-DP-3
[416.796295] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[416.798267] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[417.213937] [109/134] (615s left) kms_content_protection (type1)
[417.462870] Starting subtest: type1
[417.469162] Subtest type1: SKIP (0.003s)
[417.710715] [110/134] (615s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[417.795799] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[417.876172] [111/134] (615s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[418.060886] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[418.061808] Starting dynamic subtest: pipe-A-DP-3
[418.070244] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[418.082036] Starting dynamic subtest: pipe-B-DP-3
[418.090489] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[418.102076] Starting dynamic subtest: pipe-C-DP-3
[418.110344] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[418.122126] Starting dynamic subtest: pipe-D-DP-3
[418.133125] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[418.135211] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s)
[418.560505] [112/134] (614s left) kms_frontbuffer_tracking (psr-1p-rte)
[418.761759] Starting subtest: psr-1p-rte
[418.763503] Subtest psr-1p-rte: SKIP (0.000s)
[418.961590] [113/134] (614s left) kms_vblank (query-forked-busy-hang)
[419.146013] Starting subtest: query-forked-busy-hang
[419.146891] Starting dynamic subtest: pipe-A-DP-3
[445.217973] Dynamic subtest pipe-A-DP-3: SUCCESS (26.070s)
[445.233100] Starting dynamic subtest: pipe-D-DP-3
[470.224647] Dynamic subtest pipe-D-DP-3: SUCCESS (25.002s)
[470.225593] Subtest query-forked-busy-hang: SUCCESS (51.079s)
[470.492758] [114/134] (562s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[470.684925] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[470.685827] Starting dynamic subtest: pipe-A-valid-mode
[470.766542] Dynamic subtest pipe-A-valid-mode: SKIP (0.079s)
[470.769487] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.081s)
[471.005353] [115/134] (562s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[471.191835] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[471.193523] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[471.360384] [116/134] (562s left) gem_ppgtt (shrink-vs-evict-any)
[471.443898] Starting subtest: shrink-vs-evict-any
[479.501804] Subtest shrink-vs-evict-any: SUCCESS (8.058s)
[479.600268] [117/134] (553s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[480.275878] Starting subtest: syncobj-timeline-invalid-wait
[480.280954] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.010s)
[480.641027] [118/134] (552s left) kms_async_flips (crc)
[480.822348] Starting subtest: crc
[481.058713] Starting dynamic subtest: pipe-A-DP-3
[483.459925] Dynamic subtest pipe-A-DP-3: SUCCESS (2.401s)
[483.681911] Starting dynamic subtest: pipe-B-DP-3
[485.894003] Dynamic subtest pipe-B-DP-3: SUCCESS (2.224s)
[486.087254] Starting dynamic subtest: pipe-C-DP-3
[488.299078] Dynamic subtest pipe-C-DP-3: SUCCESS (2.226s)
[488.482951] Starting dynamic subtest: pipe-D-DP-3
[490.696119] Dynamic subtest pipe-D-DP-3: SUCCESS (2.226s)
[490.697022] Subtest crc: SUCCESS (9.874s)
[491.171053] [119/134] (542s left) gem_lmem_swapping (parallel-random-verify-ccs)
[493.928581] Starting subtest: parallel-random-verify-ccs
[493.929355] Starting dynamic subtest: lmem0
[559.330753] Dynamic subtest lmem0: SUCCESS (65.401s)
[559.331805] Subtest parallel-random-verify-ccs: SUCCESS (65.402s)
[560.465857] [FACT gem_lmem_swapping (parallel-random-verify-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[560.466809] [FACT gem_lmem_swapping (parallel-random-verify-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[560.469198] [120/134] (473s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[562.138823] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[562.140513] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[562.346183] [FACT kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[562.348710] [FACT kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)] new: kernel.kmod_is_loaded.i915: true
[562.351449] [121/134] (471s left) perf_pmu (busy-start)
[562.429071] Starting subtest: busy-start
[562.430026] Starting dynamic subtest: rcs0
[565.021569] Dynamic subtest rcs0: SUCCESS (2.592s)
[565.038152] Starting dynamic subtest: bcs0
[567.571806] Dynamic subtest bcs0: SUCCESS (2.548s)
[567.587584] Starting dynamic subtest: vcs0
[570.123324] Dynamic subtest vcs0: SUCCESS (2.546s)
[570.138816] Starting dynamic subtest: vcs1
[572.673271] Dynamic subtest vcs1: SUCCESS (2.545s)
[572.694586] Starting dynamic subtest: vecs0
[575.225162] Dynamic subtest vecs0: SUCCESS (2.546s)
[575.241661] Starting dynamic subtest: vecs1
[577.777930] Dynamic subtest vecs1: SUCCESS (2.547s)
[577.794432] Starting dynamic subtest: ccs0
[580.329035] Dynamic subtest ccs0: SUCCESS (2.545s)
[580.334146] Subtest busy-start: SUCCESS (17.902s)
[580.487912] [122/134] (453s left) gem_exec_params (no-blt)
[580.570511] Starting subtest: no-blt
[580.572832] Subtest no-blt: SUCCESS (0.001s)
[580.785306] [123/134] (453s left) gem_exec_flush (basic-uc-rw-default)
[580.868324] Subtest basic-uc-rw-default: SKIP (0.000s)
[580.949978] [124/134] (452s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[581.154516] Starting subtest: x-tiled-8bpp-rotate-180
[582.738497] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.583s)
[582.973274] [125/134] (451s left) gem_userptr_blits (map-fixed-invalidate-busy)
[583.082076] Starting subtest: map-fixed-invalidate-busy
[583.083865] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[583.296482] [126/134] (450s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[583.505811] Starting subtest: flip-vs-dpms-on-nop-interruptible
[583.510770] Starting dynamic subtest: A-DP3
[584.608174] Dynamic subtest A-DP3: SUCCESS (1.097s)
[584.653818] Starting dynamic subtest: B-DP3
[585.686824] Dynamic subtest B-DP3: SUCCESS (1.073s)
[585.729945] Starting dynamic subtest: C-DP3
[586.727057] Dynamic subtest C-DP3: SUCCESS (1.035s)
[586.744125] Starting dynamic subtest: D-DP3
[587.755056] Dynamic subtest D-DP3: SUCCESS (1.027s)
[587.757511] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (4.251s)
[588.124580] [127/134] (446s left) kms_cursor_edge_walk (128x128-right-edge)
[588.317909] Starting subtest: 128x128-right-edge
[588.318812] Starting dynamic subtest: pipe-A-DP-3
[591.771797] Dynamic subtest pipe-A-DP-3: SUCCESS (3.452s)
[591.787290] Starting dynamic subtest: pipe-D-DP-3
[595.102739] Dynamic subtest pipe-D-DP-3: SUCCESS (3.328s)
[595.103803] Subtest 128x128-right-edge: SUCCESS (6.785s)
[595.427171] [128/134] (438s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[595.623850] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[595.625631] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[595.823523] [129/134] (438s left) kms_frontbuffer_tracking (fbc-suspend)
[596.018865] Starting subtest: fbc-suspend
[637.613414] Subtest fbc-suspend: SUCCESS (10.746s)
[637.865977] [130/134] (396s left) gem_softpin (noreloc)
[637.954302] Starting subtest: noreloc
[643.490137] Subtest noreloc: SUCCESS (5.535s)
[643.692096] [131/134] (390s left) kms_psr (fbc-psr-sprite-blt)
[643.877185] Subtest fbc-psr-sprite-blt: SKIP (0.000s)
[643.941272] [132/134] (390s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[644.139983] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[645.396134] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.256s)
[645.631630] [133/134] (389s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[645.821757] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[645.823456] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[646.014379] [134/134] (388s left) kms_cursor_crc (cursor-onscreen-128x42)
[646.407287] Starting subtest: cursor-onscreen-128x42
[646.412318] Starting dynamic subtest: pipe-A-DP-3
[649.207286] Dynamic subtest pipe-A-DP-3: SUCCESS (2.794s)
[649.243692] Starting dynamic subtest: pipe-D-DP-3
[651.986035] Dynamic subtest pipe-D-DP-3: SUCCESS (2.755s)
[651.986960] Subtest cursor-onscreen-128x42: SUCCESS (5.579s)
[652.412571] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: gem_exec_reloc
results: parsing output: 2/ for test: gem_exec_reloc
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_mmap_wc
results: parsing output: 5/ for test: kms_plane
results: parsing output: 6/ for test: gem_exec_params
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: kms_lease
results: parsing output: 9/ for test: gem_exec_schedule
results: parsing output: 10/ for test: gem_create
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: gem_userptr_blits
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: gem_close_race
results: parsing output: 15/ for test: kms_flip_scaled_crc
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: kms_properties
results: parsing output: 18/ for test: gem_ctx_param
results: parsing output: 19/ for test: kms_psr2_sf
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: drm_read
results: parsing output: 22/ for test: gem_exec_whisper
results: parsing output: 23/ for test: kms_chamelium_frames
results: parsing output: 24/ for test: gem_render_copy
results: parsing output: 25/ for test: kms_pm_rpm
results: parsing output: 26/ for test: kms_pm_rpm
results: parsing output: 27/ for test: gem_exec_reloc
results: parsing output: 28/ for test: kms_psr2_sf
results: parsing output: 29/ for test: kms_flip
results: parsing output: 30/ for test: kms_pipe_b_c_ivb
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: i915_drm_fdinfo
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: gem_exec_balancer
results: parsing output: 36/ for test: gem_ctx_param
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_softpin
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_pread
results: parsing output: 41/ for test: kms_psr
results: parsing output: 42/ for test: i915_pm_rpm
results: parsing output: 43/ for test: gem_ccs
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_ctx_shared
results: parsing output: 47/ for test: gem_mmap_wc
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_debugfs
results: parsing output: 50/ for test: gem_exec_params
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: sysfs_defaults
results: parsing output: 54/ for test: kms_plane_multiple
results: parsing output: 55/ for test: kms_async_flips
results: parsing output: 56/ for test: gem_exec_reloc
results: parsing output: 57/ for test: i915_query
results: parsing output: 58/ for test: gem_exec_fence
results: parsing output: 59/ for test: gem_partial_pwrite_pread
results: parsing output: 60/ for test: kms_pipe_crc_basic
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_cursor_legacy
results: parsing output: 64/ for test: kms_addfb_basic
results: parsing output: 65/ for test: kms_atomic_transition
results: parsing output: 66/ for test: gem_ctx_persistence
results: parsing output: 67/ for test: i915_drm_fdinfo
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: gen9_exec_parse
results: parsing output: 71/ for test: gem_sync
results: parsing output: 72/ for test: api_intel_bb
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: kms_vrr
results: parsing output: 76/ for test: kms_flip
results: parsing output: 77/ for test: kms_chamelium_hpd
results: parsing output: 78/ for test: gem_lmem_swapping
results: parsing output: 79/ for test: syncobj_basic
results: parsing output: 80/ for test: gem_mmap_gtt
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_render_copy
results: parsing output: 83/ for test: gem_userptr_blits
results: parsing output: 84/ for test: gem_exec_schedule
results: parsing output: 85/ for test: kms_chamelium_color
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: api_intel_bb
results: parsing output: 89/ for test: kms_feature_discovery
results: parsing output: 90/ for test: kms_color_pipeline
results: parsing output: 91/ for test: sriov_basic
results: parsing output: 92/ for test: gem_eio
results: parsing output: 93/ for test: gem_mmap_gtt
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: perf
results: parsing output: 96/ for test: kms_cursor_legacy
results: parsing output: 97/ for test: kms_pm_backlight
results: parsing output: 98/ for test: kms_plane_scaling
results: parsing output: 99/ for test: gem_exec_reloc
results: parsing output: 100/ for test: gem_userptr_blits
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: kms_force_connector_basic
results: parsing output: 103/ for test: kms_joiner
results: parsing output: 104/ for test: kms_vblank
results: parsing output: 105/ for test: syncobj_wait
results: parsing output: 106/ for test: kms_ccs
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: kms_content_protection
results: parsing output: 109/ for test: gem_exec_flush
results: parsing output: 110/ for test: kms_ccs
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_vblank
results: parsing output: 113/ for test: kms_flip_scaled_crc
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_ppgtt
results: parsing output: 116/ for test: gem_exec_fence
results: parsing output: 117/ for test: kms_async_flips
results: parsing output: 118/ for test: gem_lmem_swapping
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: perf_pmu
results: parsing output: 121/ for test: gem_exec_params
results: parsing output: 122/ for test: gem_exec_flush
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: gem_userptr_blits
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: kms_cursor_edge_walk
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_softpin
results: parsing output: 130/ for test: kms_psr
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: kms_cursor_crc
Done.