[48.221468] Initializing watchdogs
[48.221533]   /dev/watchdog0
[48.238699] [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]
[48.244357] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[48.247015] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[48.248795] [001/133] (960s left) gem_exec_params (invalid-bsd2-flag-on-render)
[48.290757] Starting subtest: invalid-bsd2-flag-on-render
[48.291460] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[48.381898] [002/133] (960s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[48.479066] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[48.814983] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.348s)
[48.955223] [003/133] (959s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[49.044311] Starting subtest: fbcpsr-rgb565-draw-blt
[49.045636] Subtest fbcpsr-rgb565-draw-blt: SKIP (0.000s)
[49.137361] [004/133] (959s left) gem_userptr_blits (input-checking)
[49.174383] Starting subtest: input-checking
[49.175040] Subtest input-checking: SUCCESS (0.000s)
[49.284840] [005/133] (959s left) gem_tiling_max_stride
[49.439013] [006/133] (959s left) gen9_exec_parse (batch-zero-length)
[49.475158] Subtest batch-zero-length: SKIP (0.000s)
[49.510613] [007/133] (959s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[49.592189] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[49.593505] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s)
[49.657647] [008/133] (959s left) gem_lmem_swapping (massive-random)
[49.693580] Subtest massive-random: SKIP (0.000s)
[49.728698] [009/133] (959s left) gem_mmap_wc (write)
[49.760465] Starting subtest: write
[49.793251] Subtest write: SUCCESS (0.035s)
[49.871160] [010/133] (959s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[49.903096] Starting subtest: etime-multi-wait-available-unsubmitted
[50.007613] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.107s)
[50.077904] [011/133] (959s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[50.163261] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[51.360033] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (1.228s)
[51.472725] [012/133] (957s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[51.559601] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[51.561091] Starting dynamic subtest: pipe-A-HDMI-A-1
[51.567757] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[51.572994] Starting dynamic subtest: pipe-B-HDMI-A-1
[51.579688] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[51.584840] Starting dynamic subtest: pipe-C-HDMI-A-1
[51.591451] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[51.596517] Starting dynamic subtest: pipe-D-HDMI-A-1
[51.603164] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[51.604468] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[51.783821] [013/133] (957s left) gem_mmap_wc (fault-concurrent)
[51.818783] Starting subtest: fault-concurrent
[51.895534] Subtest fault-concurrent: SUCCESS (0.079s)
[51.987347] [014/133] (957s left) gem_softpin (evict-snoop)
[52.027599] Starting subtest: evict-snoop
[52.028981] Subtest evict-snoop: SKIP (0.000s)
[52.087395] [015/133] (957s left) intel_hwmon (hwmon-read)
[52.119144] Subtest hwmon-read: SKIP (0.000s)
[52.151523] [016/133] (957s left) kms_cursor_crc (cursor-onscreen-128x42)
[52.238382] Starting subtest: cursor-onscreen-128x42
[52.242491] Starting dynamic subtest: pipe-A-HDMI-A-1
[53.079221] Dynamic subtest pipe-A-HDMI-A-1: FAIL (0.677s)
[53.086725] Starting dynamic subtest: pipe-D-HDMI-A-1
[54.168401] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.246s)
[54.169178] Subtest cursor-onscreen-128x42: FAIL (1.966s)
[54.329595] [017/133] (954s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[54.367337] Starting subtest: rel-constants-invalid-rel-gen5
[54.368078] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[54.466812] [018/133] (954s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[54.554590] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (0.000s)
[54.594623] [019/133] (954s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[54.681349] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[54.682782] Subtest psr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[54.765938] [020/133] (954s left) kms_psr (psr-no-drrs)
[54.850490] Subtest psr-no-drrs: SKIP (0.000s)
[54.889662] [021/133] (954s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[54.974407] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[54.975096] Starting dynamic subtest: pipe-A-HDMI-A-1
[54.982270] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[54.987610] Starting dynamic subtest: pipe-B-HDMI-A-1
[54.994767] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[55.000107] Starting dynamic subtest: pipe-C-HDMI-A-1
[55.007246] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[55.012428] Starting dynamic subtest: pipe-D-HDMI-A-1
[55.019735] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[55.021063] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SKIP (0.004s)
[55.214065] [022/133] (954s left) kms_atomic (atomic-plane-damage)
[55.300795] Starting subtest: atomic-plane-damage
[55.356504] Starting dynamic subtest: pipe-A-HDMI-A-1
[55.560480] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.207s)
[55.561219] Subtest atomic-plane-damage: SUCCESS (0.264s)
[55.691052] [023/133] (953s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[55.781378] Starting subtest: psr-1p-pri-indfb-multidraw
[55.782796] Subtest psr-1p-pri-indfb-multidraw: SKIP (0.000s)
[55.858268] [024/133] (953s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[55.945407] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[55.946799] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[56.025018] [025/133] (953s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[56.062831] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[56.063497] Starting dynamic subtest: smem
[56.181832] Dynamic subtest smem: SUCCESS (0.114s)
[56.182682] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SUCCESS (0.115s)
[56.343849] [026/133] (953s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[56.430575] Starting subtest: 2x-plain-flip-ts-check-interruptible
[56.439983] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.009s)
[56.493689] [027/133] (953s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[56.578426] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.000s)
[56.618865] [028/133] (953s left) sw_sync (sync_random_merge)
[56.649618] Starting subtest: sync_random_merge
[56.712681] Subtest sync_random_merge: SUCCESS (0.064s)
[56.757544] [029/133] (952s left) kms_content_protection (content-type-change)
[56.844751] Starting subtest: content-type-change
[56.857825] Subtest content-type-change: SKIP (0.012s)
[56.923366] [030/133] (952s left) i915_hangman (gt-error-state-capture)
[56.966427] Starting subtest: gt-error-state-capture
[56.967107] Starting dynamic subtest: rcs0
[67.508958] Dynamic subtest rcs0: SUCCESS (10.597s)
[67.516540] Starting dynamic subtest: bcs0
[76.892715] Dynamic subtest bcs0: SUCCESS (9.406s)
[76.902016] Starting dynamic subtest: vcs0
[86.939653] Dynamic subtest vcs0: SUCCESS (10.046s)
[86.948325] Starting dynamic subtest: vcs1
[96.925642] Dynamic subtest vcs1: SUCCESS (9.985s)
[96.934875] Starting dynamic subtest: vecs0
[106.907532] Dynamic subtest vecs0: SUCCESS (9.981s)
[106.908613] Subtest gt-error-state-capture: SUCCESS (50.018s)
[106.978728] [031/133] (902s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[107.070623] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[107.072071] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[107.163618] [032/133] (902s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[107.257104] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[107.258441] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[107.353153] [033/133] (902s left) kms_cursor_edge_walk (64x64-right-edge)
[107.436946] Starting subtest: 64x64-right-edge
[107.438660] Starting dynamic subtest: pipe-A-HDMI-A-1
[109.190261] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.751s)
[109.198360] Starting dynamic subtest: pipe-D-HDMI-A-1
[110.861262] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.669s)
[110.862022] Subtest 64x64-right-edge: SUCCESS (3.423s)
[110.966901] [034/133] (898s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[111.064239] Starting subtest: plane-use-after-nonblocking-unbind
[111.065728] Starting dynamic subtest: pipe-A-HDMI-A-1
[111.121450] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.056s)
[111.182906] Starting dynamic subtest: pipe-B-HDMI-A-1
[111.341033] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.169s)
[111.397750] Subtest plane-use-after-nonblocking-unbind: SUCCESS (0.334s)
[111.526713] [035/133] (898s left) gem_fence_thrash (bo-copy)
[111.562893] Starting subtest: bo-copy
[112.778787] Subtest bo-copy: SUCCESS (1.207s)
[112.895264] [036/133] (897s left) kms_prop_blob (blob-prop-core)
[112.928442] Starting subtest: blob-prop-core
[112.929130] Subtest blob-prop-core: SUCCESS (0.000s)
[112.995701] [037/133] (897s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[113.081326] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[113.082031] Starting dynamic subtest: pipe-A
[114.219079] Dynamic subtest pipe-A: SUCCESS (1.138s)
[114.227568] Starting dynamic subtest: pipe-B
[115.411796] Dynamic subtest pipe-B: SUCCESS (1.192s)
[115.420127] Starting dynamic subtest: pipe-C
[115.616037] Dynamic subtest pipe-C: SUCCESS (0.204s)
[115.624809] Starting dynamic subtest: pipe-D
[115.819915] Dynamic subtest pipe-D: SUCCESS (0.203s)
[115.820985] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (2.739s)
[115.968881] [038/133] (894s left) api_intel_allocator (default-alignment)
[116.004845] Starting subtest: default-alignment
[116.006600] Subtest default-alignment: SUCCESS (0.001s)
[116.104784] [039/133] (893s left) i915_query (query-regions-unallocated)
[116.138613] Starting subtest: query-regions-unallocated
[116.139321] Subtest query-regions-unallocated: SUCCESS (0.000s)
[116.198348] [040/133] (893s left) perf (polling-small-buf)
[116.281777] Starting subtest: polling-small-buf
[116.371343] Subtest polling-small-buf: SUCCESS (0.090s)
[116.408124] [041/133] (893s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[116.498649] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[116.500082] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[116.583644] [042/133] (893s left) sysfs_heartbeat_interval (idempotent)
[116.619892] Starting subtest: idempotent
[116.620615] Starting dynamic subtest: vecs0
[116.622361] Dynamic subtest vecs0: SUCCESS (0.001s)
[116.628369] Starting dynamic subtest: vcs0
[116.629086] Dynamic subtest vcs0: SUCCESS (0.001s)
[116.634872] Starting dynamic subtest: bcs0
[116.635566] Dynamic subtest bcs0: SUCCESS (0.001s)
[116.641440] Starting dynamic subtest: rcs0
[116.642127] Dynamic subtest rcs0: SUCCESS (0.001s)
[116.647768] Starting dynamic subtest: vcs1
[116.648439] Dynamic subtest vcs1: SUCCESS (0.001s)
[116.649114] Subtest idempotent: SUCCESS (0.007s)
[116.684724] [043/133] (893s left) gem_ctx_persistence (heartbeat-hang)
[116.721881] Starting subtest: heartbeat-hang
[118.223536] Subtest heartbeat-hang: SUCCESS (1.501s)
[118.295743] [044/133] (891s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[118.336460] Starting subtest: yf-tiled-ccs-to-yf-tiled
[118.337163] Starting dynamic subtest: smem
[118.409282] Dynamic subtest smem: SUCCESS (0.072s)
[118.410045] Subtest yf-tiled-ccs-to-yf-tiled: SUCCESS (0.073s)
[118.591945] [045/133] (891s left) gem_ctx_isolation (dirty-create)
[118.634736] Starting subtest: dirty-create
[118.635441] Starting dynamic subtest: rcs0
[118.816095] Dynamic subtest rcs0: SUCCESS (0.172s)
[118.822019] Starting dynamic subtest: bcs0
[119.022224] Dynamic subtest bcs0: SUCCESS (0.205s)
[119.028228] Starting dynamic subtest: vcs0
[119.240250] Dynamic subtest vcs0: SUCCESS (0.217s)
[119.246380] Starting dynamic subtest: vcs1
[119.449017] Dynamic subtest vcs1: SUCCESS (0.208s)
[119.454804] Starting dynamic subtest: vecs0
[119.654595] Dynamic subtest vecs0: SUCCESS (0.205s)
[119.655313] Subtest dirty-create: SUCCESS (1.012s)
[119.823117] [046/133] (890s left) kms_vblank (accuracy-idle)
[119.909711] Starting subtest: accuracy-idle
[119.911276] Starting dynamic subtest: pipe-A-HDMI-A-1
[121.087825] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.177s)
[121.096967] Starting dynamic subtest: pipe-D-HDMI-A-1
[122.252689] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.160s)
[122.253392] Subtest accuracy-idle: SUCCESS (2.343s)
[122.382047] [047/133] (887s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[122.475775] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[122.477175] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[122.570700] [048/133] (887s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[122.655027] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[122.656877] Starting dynamic subtest: pipe-A-valid-mode
[123.475587] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.819s)
[123.476275] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (0.821s)
[123.620887] [049/133] (886s left) kms_psr2_su (page_flip-p010)
[123.655450] Subtest page_flip-P010: SKIP (0.000s)
[123.695416] [050/133] (886s left) dmabuf_sync_file (import-basic)
[123.768378] Starting subtest: import-basic
[123.769972] Subtest import-basic: SUCCESS (0.002s)
[123.816488] [FACT dmabuf_sync_file (import-basic)] new: kernel.kmod_is_loaded.vgem: true
[123.818155] [051/133] (886s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[123.903661] Starting subtest: basic-max-pipe-crc-check
[123.905092] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[123.947825] [052/133] (886s left) gem_create (create-clear)
[123.980538] Starting subtest: create-clear
[123.981423] Starting dynamic subtest: smem0
[156.682061] Dynamic subtest smem0: SUCCESS (32.700s)
[156.682755] Subtest create-clear: SUCCESS (32.701s)
[156.870109] [053/133] (853s left) kms_psr (pr-basic)
[156.956755] Subtest pr-basic: SKIP (0.000s)
[157.004710] [054/133] (853s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[157.089842] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[157.091447] Starting dynamic subtest: pipe-A-HDMI-A-1
[157.098039] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[157.104013] Starting dynamic subtest: pipe-B-HDMI-A-1
[157.110641] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[157.116496] Starting dynamic subtest: pipe-C-HDMI-A-1
[157.123046] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[157.128839] Starting dynamic subtest: pipe-D-HDMI-A-1
[157.135500] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[157.136829] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SKIP (0.006s)
[157.329667] [055/133] (853s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[157.416891] Starting subtest: cursorB-vs-flipB-toggle
[157.419239] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[157.474743] [056/133] (853s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[157.559103] Starting subtest: flip-vs-cursor-legacy
[163.989322] Subtest flip-vs-cursor-legacy: SUCCESS (6.424s)
[164.147076] [057/133] (846s left) kms_chamelium_frames (dp-crc-multiple)
[164.287159] Subtest dp-crc-multiple: SKIP (0.000s)
[164.374352] [058/133] (846s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[164.462217] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[164.463679] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[164.516105] [059/133] (846s left) tools_test (tools_test)
[164.552337] Starting subtest: tools_test
[164.621796] Subtest tools_test: SUCCESS (0.073s)
[164.685549] [060/133] (846s left) gem_exec_balancer (bonded-semaphore)
[164.726569] Starting subtest: bonded-semaphore
[169.050975] Subtest bonded-semaphore: SUCCESS (4.290s)
[169.211958] [061/133] (841s left) gem_exec_reloc (basic-write-cpu-noreloc)
[169.249747] Starting subtest: basic-write-cpu-noreloc
[169.250585] Subtest basic-write-cpu-noreloc: SUCCESS (0.002s)
[169.358926] [062/133] (841s left) gem_spin_batch (engines)
[169.401043] Starting subtest: engines
[169.401793] Starting dynamic subtest: rcs0
[172.752698] Dynamic subtest rcs0: SUCCESS (3.316s)
[172.761959] Starting dynamic subtest: bcs0
[176.072442] Dynamic subtest bcs0: SUCCESS (3.318s)
[176.081053] Starting dynamic subtest: vcs0
[179.391432] Dynamic subtest vcs0: SUCCESS (3.317s)
[179.400185] Starting dynamic subtest: vcs1
[182.710758] Dynamic subtest vcs1: SUCCESS (3.318s)
[182.719889] Starting dynamic subtest: vecs0
[186.030133] Dynamic subtest vecs0: SUCCESS (3.317s)
[186.031223] Subtest engines: SUCCESS (16.594s)
[186.173335] [063/133] (824s left) gem_exec_schedule (u-submit-late-slice)
[186.217577] Starting subtest: u-submit-late-slice
[186.218292] Starting dynamic subtest: rcs0
[186.247145] Dynamic subtest rcs0: SUCCESS (0.029s)
[186.253991] Starting dynamic subtest: bcs0
[186.275559] Dynamic subtest bcs0: SUCCESS (0.027s)
[186.281978] Starting dynamic subtest: vcs0
[186.300169] Dynamic subtest vcs0: SUCCESS (0.024s)
[186.306825] Starting dynamic subtest: vcs1
[186.325098] Dynamic subtest vcs1: SUCCESS (0.024s)
[186.332158] Starting dynamic subtest: vecs0
[186.351217] Dynamic subtest vecs0: SUCCESS (0.025s)
[186.351986] Subtest u-submit-late-slice: SUCCESS (0.134s)
[186.650279] [064/133] (824s left) kms_addfb_basic (clobberred-modifier)
[186.683530] Starting subtest: clobberred-modifier
[186.684226] Subtest clobberred-modifier: SUCCESS (0.000s)
[186.821791] [065/133] (824s left) gem_exec_capture (capture)
[186.859716] Starting subtest: capture
[186.860391] Starting dynamic subtest: rcs0-smem
[188.137459] Dynamic subtest rcs0-smem: SUCCESS (1.271s)
[188.143791] Starting dynamic subtest: bcs0-smem
[189.409707] Dynamic subtest bcs0-smem: SUCCESS (1.271s)
[189.415846] Starting dynamic subtest: vcs0-smem
[190.682640] Dynamic subtest vcs0-smem: SUCCESS (1.272s)
[190.688669] Starting dynamic subtest: vcs1-smem
[191.953389] Dynamic subtest vcs1-smem: SUCCESS (1.270s)
[191.959372] Starting dynamic subtest: vecs0-smem
[193.225916] Dynamic subtest vecs0-smem: SUCCESS (1.272s)
[193.226595] Subtest capture: SUCCESS (6.359s)
[193.312863] [066/133] (817s left) gem_exec_reloc (basic-gtt-read)
[193.352033] Starting subtest: basic-gtt-read
[193.357982] Subtest basic-gtt-read: SUCCESS (0.007s)
[193.484610] [067/133] (817s left) gem_readwrite (read-write)
[193.518336] Starting subtest: read-write
[193.521526] Subtest read-write: SUCCESS (0.000s)
[193.606276] [068/133] (817s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[193.694627] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[193.695994] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[193.781311] [069/133] (817s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[193.875700] Starting subtest: y-tiled-64bpp-rotate-180
[195.363334] Subtest y-tiled-64bpp-rotate-180: SUCCESS (1.487s)
[195.480753] [070/133] (815s left) i915_pm_rc6_residency (rc6-idle)
[195.515202] Starting subtest: rc6-idle
[195.519533] Subtest rc6-idle: SKIP (0.004s)
[195.583019] [071/133] (815s left) kms_invalid_mode (bad-vsync-end)
[195.670467] Starting subtest: bad-vsync-end
[195.671183] Starting dynamic subtest: pipe-A-HDMI-A-1
[195.721763] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.050s)
[195.731295] Starting dynamic subtest: pipe-B-HDMI-A-1
[195.732006] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[195.739432] Starting dynamic subtest: pipe-C-HDMI-A-1
[195.740172] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[195.746695] Starting dynamic subtest: pipe-D-HDMI-A-1
[195.747381] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[195.748067] Subtest bad-vsync-end: SUCCESS (0.059s)
[195.854492] [072/133] (815s left) kms_properties (crtc-properties-atomic)
[195.940945] Starting subtest: crtc-properties-atomic
[195.942749] Starting dynamic subtest: pipe-A-HDMI-A-1
[196.086486] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.144s)
[196.095957] Starting dynamic subtest: pipe-B-HDMI-A-1
[196.257486] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.170s)
[196.264938] Starting dynamic subtest: pipe-C-HDMI-A-1
[196.438368] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.179s)
[196.446452] Starting dynamic subtest: pipe-D-HDMI-A-1
[196.628089] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.187s)
[196.628837] Subtest crtc-properties-atomic: SUCCESS (0.687s)
[196.756495] [073/133] (814s left) kms_chamelium_hpd (hdmi-hpd-fast)
[196.896184] Subtest hdmi-hpd-fast: SKIP (0.000s)
[196.993866] [074/133] (814s left) gem_wait (write-busy)
[197.045406] Starting subtest: write-busy
[197.046195] Starting dynamic subtest: all-engines
[197.568897] Dynamic subtest all-engines: SUCCESS (0.523s)
[197.576807] Starting dynamic subtest: rcs0
[198.084327] Dynamic subtest rcs0: SUCCESS (0.514s)
[198.091050] Starting dynamic subtest: bcs0
[198.600962] Dynamic subtest bcs0: SUCCESS (0.516s)
[198.607668] Starting dynamic subtest: vcs0
[199.117150] Dynamic subtest vcs0: SUCCESS (0.515s)
[199.123897] Starting dynamic subtest: vcs1
[199.631819] Dynamic subtest vcs1: SUCCESS (0.514s)
[199.638494] Starting dynamic subtest: vecs0
[200.146861] Dynamic subtest vecs0: SUCCESS (0.514s)
[200.147541] Subtest write-busy: SUCCESS (3.102s)
[200.346431] [075/133] (811s left) fbdev (unaligned-read)
[200.385755] Starting subtest: unaligned-read
[200.393671] Subtest unaligned-read: SUCCESS (0.009s)
[200.444603] [076/133] (811s left) kms_lease (lessee-list)
[200.531852] Starting subtest: lessee-list
[200.532539] Starting dynamic subtest: pipe-A-HDMI-A-1
[200.534375] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[200.543479] Starting dynamic subtest: pipe-B-HDMI-A-1
[200.544216] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[200.550747] Starting dynamic subtest: pipe-C-HDMI-A-1
[200.551484] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[200.557911] Starting dynamic subtest: pipe-D-HDMI-A-1
[200.558607] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[200.559296] Subtest lessee-list: SUCCESS (0.009s)
[200.601165] [077/133] (810s left) gem_eio (kms)
[200.697395] Starting subtest: kms
[222.932197] Subtest kms: SUCCESS (22.234s)
[223.131839] [078/133] (788s left) i915_query (query-topology-known-pci-ids)
[223.167378] Starting subtest: query-topology-known-pci-ids
[223.168848] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[223.239603] [079/133] (788s left) perf (per-context-mode-unprivileged)
[223.318741] Starting subtest: per-context-mode-unprivileged
[223.320112] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[223.361727] [080/133] (788s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[224.756928] Starting subtest: dpms-mode-unset-lpsp
[228.476675] Subtest dpms-mode-unset-lpsp: SUCCESS (3.720s)
[228.670012] [081/133] (783s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[228.756638] Starting subtest: short-flip-after-cursor-toggle
[229.284368] Subtest short-flip-after-cursor-toggle: SUCCESS (0.528s)
[229.444876] [082/133] (782s left) kms_psr (fbc-psr2-no-drrs)
[229.534568] Subtest fbc-psr2-no-drrs: SKIP (0.000s)
[229.576205] [083/133] (782s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[229.666746] Starting subtest: fbcpsr-tiling-linear
[229.668102] Subtest fbcpsr-tiling-linear: SKIP (0.000s)
[229.756909] [084/133] (782s left) kms_plane (plane-position-hole)
[229.844250] Starting subtest: plane-position-hole
[230.046861] Starting dynamic subtest: pipe-A-plane-1
[230.288042] Dynamic subtest pipe-A-plane-1: SUCCESS (0.241s)
[230.294913] Starting dynamic subtest: pipe-A-plane-2
[230.513737] Dynamic subtest pipe-A-plane-2: SUCCESS (0.225s)
[230.521552] Starting dynamic subtest: pipe-A-plane-3
[230.760216] Dynamic subtest pipe-A-plane-3: SUCCESS (0.245s)
[230.768205] Starting dynamic subtest: pipe-A-plane-4
[231.011699] Dynamic subtest pipe-A-plane-4: SUCCESS (0.250s)
[231.018460] Starting dynamic subtest: pipe-A-plane-5
[231.254311] Dynamic subtest pipe-A-plane-5: SUCCESS (0.242s)
[231.263979] Starting dynamic subtest: pipe-A-plane-6
[231.510609] Dynamic subtest pipe-A-plane-6: SUCCESS (0.255s)
[231.520077] Starting dynamic subtest: pipe-A-plane-7
[231.521713] Dynamic subtest pipe-A-plane-7: SUCCESS (0.003s)
[231.709840] Starting dynamic subtest: pipe-B-plane-1
[231.954215] Dynamic subtest pipe-B-plane-1: SUCCESS (0.251s)
[231.963964] Starting dynamic subtest: pipe-B-plane-2
[232.183421] Dynamic subtest pipe-B-plane-2: SUCCESS (0.228s)
[232.191243] Starting dynamic subtest: pipe-B-plane-3
[232.421340] Dynamic subtest pipe-B-plane-3: SUCCESS (0.236s)
[232.432198] Starting dynamic subtest: pipe-B-plane-4
[232.645597] Dynamic subtest pipe-B-plane-4: SUCCESS (0.223s)
[232.655771] Starting dynamic subtest: pipe-B-plane-5
[232.865780] Dynamic subtest pipe-B-plane-5: SUCCESS (0.218s)
[232.873454] Starting dynamic subtest: pipe-B-plane-6
[233.093459] Dynamic subtest pipe-B-plane-6: SUCCESS (0.227s)
[233.100443] Starting dynamic subtest: pipe-B-plane-7
[233.101763] Dynamic subtest pipe-B-plane-7: SUCCESS (0.002s)
[233.102415] Subtest plane-position-hole: SUCCESS (3.253s)
[233.247528] [085/133] (778s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[233.287455] Starting subtest: multi-wait-available-submitted-signaled
[233.288145] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s)
[233.352686] [086/133] (778s left) gem_exec_reloc (basic-cpu-wc-active)
[233.390277] Starting subtest: basic-cpu-wc-active
[233.515986] Subtest basic-cpu-wc-active: SUCCESS (0.121s)
[233.637870] [087/133] (778s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[233.725066] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[233.726780] Starting dynamic subtest: pipe-A-HDMI-A-1
[233.729345] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[233.736102] Starting dynamic subtest: pipe-B-HDMI-A-1
[233.738801] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[233.745574] Starting dynamic subtest: pipe-C-HDMI-A-1
[233.748214] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[233.754770] Starting dynamic subtest: pipe-D-HDMI-A-1
[233.757452] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[233.758796] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.007s)
[233.958240] [088/133] (778s left) gem_mmap_wc (bad-offset)
[233.994082] Starting subtest: bad-offset
[233.994785] Subtest bad-offset: SUCCESS (0.000s)
[234.090037] [089/133] (777s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[234.181378] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[234.182785] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[234.290558] [090/133] (777s left) kms_dp_link_training (uhbr-mst)
[234.376141] Starting subtest: uhbr-mst
[234.377497] Subtest uhbr-mst: SKIP (0.000s)
[234.444649] [091/133] (777s left) gem_exec_params (mmapped)
[234.480941] Starting subtest: mmapped
[234.482743] Subtest mmapped: SUCCESS (0.001s)
[234.582342] [092/133] (777s left) kms_prime (basic-crc-vgem)
[234.681216] Starting subtest: basic-crc-vgem
[234.681913] Starting dynamic subtest: second-to-first
[235.386761] Dynamic subtest second-to-first: SUCCESS (0.705s)
[235.388127] Subtest basic-crc-vgem: SUCCESS (0.707s)
[235.493295] [093/133] (776s left) gem_exec_fence (invalid-timeline-fence-array)
[235.939384] Starting subtest: invalid-timeline-fence-array
[235.940184] Subtest invalid-timeline-fence-array: SUCCESS (0.007s)
[236.129194] [094/133] (776s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[236.222707] Starting subtest: fbc-2p-pri-indfb-multidraw
[236.224030] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[236.304411] [095/133] (775s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[236.399936] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[236.970671] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.570s)
[237.102282] [096/133] (775s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[237.190282] Starting subtest: flip-vs-cursor-varying-size
[246.156615] Subtest flip-vs-cursor-varying-size: SUCCESS (8.966s)
[246.314209] [097/133] (766s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[246.412869] Starting subtest: fbc-1p-pri-indfb-multidraw
[255.080434] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (8.667s)
[255.210220] [098/133] (757s left) syncobj_timeline (multi-wait-all-available-signaled)
[255.244747] Starting subtest: multi-wait-all-available-signaled
[255.245438] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s)
[255.317670] [099/133] (757s left) gem_tiled_pread_pwrite
[256.099468] [100/133] (756s left) kms_cursor_crc (cursor-random-128x128)
[256.237064] Starting subtest: cursor-random-128x128
[256.242009] Starting dynamic subtest: pipe-A-HDMI-A-1
[258.170687] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.929s)
[258.204675] Starting dynamic subtest: pipe-D-HDMI-A-1
[260.081785] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.884s)
[260.082512] Subtest cursor-random-128x128: SUCCESS (3.846s)
[260.215867] [101/133] (752s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[260.311657] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[260.313028] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[260.407228] [102/133] (752s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[260.497684] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[260.499050] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[260.579996] [103/133] (752s left) perf_pmu (rc6)
[260.618028] Starting subtest: rc6
[260.618784] Starting dynamic subtest: gt0
[266.989320] Dynamic subtest gt0: SUCCESS (6.336s)
[266.997059] Starting dynamic subtest: runtime-pm-gt0
[274.499063] Dynamic subtest runtime-pm-gt0: SUCCESS (7.533s)
[274.509626] Starting dynamic subtest: runtime-pm-long-gt0
[286.955391] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.455s)
[286.962962] Starting dynamic subtest: other-idle-gt0
[286.964390] Dynamic subtest other-idle-gt0: SKIP (0.000s)
[286.965108] Subtest rc6: SUCCESS (26.332s)
[287.264230] [104/133] (725s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[287.353992] Starting subtest: basic-flip-before-cursor-legacy
[287.861544] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.507s)
[287.993792] [105/133] (724s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[288.089851] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[289.539042] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (1.449s)
[289.651831] [106/133] (723s left) kms_color_pipeline (plane-lut1d-lut1d)
[289.743875] Starting subtest: plane-lut1d-lut1d
[289.831114] Starting dynamic subtest: pipe-A-plane-0
[289.930297] Dynamic subtest pipe-A-plane-0: SUCCESS (0.099s)
[289.947020] Starting dynamic subtest: pipe-A-plane-1
[290.030184] Dynamic subtest pipe-A-plane-1: SUCCESS (0.098s)
[290.043280] Starting dynamic subtest: pipe-A-plane-2
[290.129864] Dynamic subtest pipe-A-plane-2: SUCCESS (0.098s)
[290.353487] Starting dynamic subtest: pipe-B-plane-0
[290.429954] Dynamic subtest pipe-B-plane-0: SUCCESS (0.083s)
[290.445210] Starting dynamic subtest: pipe-B-plane-1
[290.521873] Dynamic subtest pipe-B-plane-1: SUCCESS (0.089s)
[290.536507] Starting dynamic subtest: pipe-B-plane-2
[290.621591] Dynamic subtest pipe-B-plane-2: SUCCESS (0.097s)
[290.824415] Starting dynamic subtest: pipe-C-plane-0
[290.900770] Dynamic subtest pipe-C-plane-0: SUCCESS (0.083s)
[290.915641] Starting dynamic subtest: pipe-C-plane-1
[291.000634] Dynamic subtest pipe-C-plane-1: SUCCESS (0.097s)
[291.012990] Starting dynamic subtest: pipe-C-plane-2
[291.100828] Dynamic subtest pipe-C-plane-2: SUCCESS (0.098s)
[291.309036] Starting dynamic subtest: pipe-D-plane-0
[291.400582] Dynamic subtest pipe-D-plane-0: SUCCESS (0.099s)
[291.413353] Starting dynamic subtest: pipe-D-plane-1
[291.500637] Dynamic subtest pipe-D-plane-1: SUCCESS (0.097s)
[291.515575] Starting dynamic subtest: pipe-D-plane-2
[291.600832] Dynamic subtest pipe-D-plane-2: SUCCESS (0.097s)
[291.656356] Subtest plane-lut1d-lut1d: SUCCESS (1.913s)
[291.758999] [107/133] (721s left) gem_reg_read (timestamp-monotonic)
[291.793865] Starting subtest: timestamp-monotonic
[295.833076] Subtest timestamp-monotonic: SUCCESS (4.005s)
[295.874643] [108/133] (716s left) perf_pmu (enable-race)
[295.911832] Starting subtest: enable-race
[295.912507] Starting dynamic subtest: rcs0
[308.508487] Dynamic subtest rcs0: SUCCESS (12.582s)
[308.522198] Starting dynamic subtest: bcs0
[321.089458] Dynamic subtest bcs0: SUCCESS (12.570s)
[321.102532] Starting dynamic subtest: vcs0
[333.656355] Dynamic subtest vcs0: SUCCESS (12.565s)
[333.666946] Starting dynamic subtest: vcs1
[346.226182] Dynamic subtest vcs1: SUCCESS (12.576s)
[346.241768] Starting dynamic subtest: vecs0
[358.780901] Dynamic subtest vecs0: SUCCESS (12.573s)
[358.781591] Subtest enable-race: SUCCESS (62.871s)
[358.823528] [109/133] (654s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[358.911427] Starting subtest: primary-x-tiled-reflect-x-180
[362.476693] Subtest primary-x-tiled-reflect-x-180: SUCCESS (3.565s)
[362.649381] [110/133] (650s left) kms_psr (psr2-no-drrs)
[362.741455] Subtest psr2-no-drrs: SKIP (0.000s)
[362.782285] [111/133] (650s left) gem_exec_schedule (out-order)
[362.835685] Starting subtest: out-order
[362.836373] Starting dynamic subtest: rcs0
[362.895035] Dynamic subtest rcs0: SUCCESS (0.058s)
[362.907695] Starting dynamic subtest: bcs0
[362.962666] Dynamic subtest bcs0: SUCCESS (0.064s)
[362.976806] Starting dynamic subtest: vcs0
[363.030227] Dynamic subtest vcs0: SUCCESS (0.064s)
[363.044391] Starting dynamic subtest: vcs1
[363.097265] Dynamic subtest vcs1: SUCCESS (0.063s)
[363.112029] Starting dynamic subtest: vecs0
[363.166209] Dynamic subtest vecs0: SUCCESS (0.065s)
[363.167191] Subtest out-order: SUCCESS (0.331s)
[363.451268] [112/133] (649s left) gem_exec_schedule (reorder-wide)
[363.618119] Starting subtest: reorder-wide
[363.618949] Starting dynamic subtest: rcs0
[363.691642] Dynamic subtest rcs0: SUCCESS (0.074s)
[363.703703] Starting dynamic subtest: bcs0
[363.767935] Dynamic subtest bcs0: SUCCESS (0.074s)
[363.779511] Starting dynamic subtest: vcs0
[363.852707] Dynamic subtest vcs0: SUCCESS (0.081s)
[363.864149] Starting dynamic subtest: vcs1
[363.929022] Dynamic subtest vcs1: SUCCESS (0.073s)
[363.941030] Starting dynamic subtest: vecs0
[364.003512] Dynamic subtest vecs0: SUCCESS (0.072s)
[364.006277] Subtest reorder-wide: SUCCESS (0.389s)
[364.167989] [113/133] (648s left) i915_drm_fdinfo (idle)
[364.205801] Starting subtest: idle
[364.206522] Starting dynamic subtest: rcs0
[364.718472] Dynamic subtest rcs0: SUCCESS (0.504s)
[364.729183] Starting dynamic subtest: bcs0
[365.225886] Dynamic subtest bcs0: SUCCESS (0.503s)
[365.236677] Starting dynamic subtest: vcs0
[365.737568] Dynamic subtest vcs0: SUCCESS (0.507s)
[365.748566] Starting dynamic subtest: vcs1
[366.245617] Dynamic subtest vcs1: SUCCESS (0.503s)
[366.256307] Starting dynamic subtest: vecs0
[366.752594] Dynamic subtest vecs0: SUCCESS (0.503s)
[366.753345] Subtest idle: SUCCESS (2.541s)
[366.790894] [114/133] (646s left) api_intel_bb (intel-bb-blit-y)
[366.824816] Starting subtest: intel-bb-blit-y
[369.981943] Subtest intel-bb-blit-y: SUCCESS (3.123s)
[370.026625] [115/133] (643s left) gem_exec_flush (basic-wb-set-default)
[370.068050] Starting subtest: basic-wb-set-default
[375.492136] Subtest basic-wb-set-default: SUCCESS (5.424s)
[375.683932] [116/133] (637s left) gem_mmap_gtt (ptrace)
[375.717860] Starting subtest: ptrace
[375.817069] Subtest ptrace: SUCCESS (0.099s)
[375.871163] [117/133] (637s left) syncobj_eventfd (timeline-wait-before-signal)
[375.905305] Starting subtest: timeline-wait-before-signal
[375.936802] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[375.985895] [118/133] (637s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[376.078723] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[376.080073] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[376.128765] [119/133] (637s left) syncobj_timeline (single-wait-all-available-signaled)
[376.163394] Starting subtest: single-wait-all-available-signaled
[376.164103] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[376.204472] [120/133] (637s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[376.293446] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[376.294822] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[376.355424] [121/133] (636s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[376.444802] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[376.446208] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[376.519993] [122/133] (636s left) kms_plane_multiple (2x-tiling-x)
[376.608053] Starting subtest: 2x-tiling-x
[376.609431] Subtest 2x-tiling-x: SKIP (0.000s)
[376.646438] [123/133] (636s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[376.743428] Starting subtest: x-tiled-8bpp-rotate-270
[376.821196] Subtest x-tiled-8bpp-rotate-270: SKIP (0.076s)
[376.895264] [124/133] (636s left) perf (global-sseu-config-invalid)
[376.966307] Starting subtest: global-sseu-config-invalid
[376.967077] Starting dynamic subtest: 0-rcs0
[376.977676] Dynamic subtest 0-rcs0: SUCCESS (0.011s)
[376.978408] Subtest global-sseu-config-invalid: SUCCESS (0.012s)
[377.021198] [125/133] (636s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[377.116860] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[377.118332] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[377.179436] [126/133] (636s left) gem_mmap_gtt (cpuset-big-copy-odd)
[377.212835] Starting subtest: cpuset-big-copy-odd
[391.191276] Subtest cpuset-big-copy-odd: SUCCESS (13.978s)
[391.236574] [127/133] (622s left) kms_addfb_basic (too-wide)
[391.366980] Starting subtest: too-wide
[391.367725] Subtest too-wide: SUCCESS (0.000s)
[391.422661] [128/133] (622s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[391.512814] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[391.514154] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[391.574437] [129/133] (622s left) kms_dp_link_training (uhbr-sst)
[391.661968] Starting subtest: uhbr-sst
[391.663434] Subtest uhbr-sst: SKIP (0.000s)
[391.707254] [130/133] (621s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[391.795304] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[391.796052] Starting dynamic subtest: pipe-A-HDMI-A-1
[391.802838] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[391.810615] Starting dynamic subtest: pipe-B-HDMI-A-1
[391.817409] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[391.824993] Starting dynamic subtest: pipe-C-HDMI-A-1
[391.831786] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[391.839238] Starting dynamic subtest: pipe-D-HDMI-A-1
[391.845852] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[391.847210] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SKIP (0.008s)
[392.016551] [131/133] (621s left) kms_vblank (query-forked-busy-hang)
[392.120414] Starting subtest: query-forked-busy-hang
[392.121344] Starting dynamic subtest: pipe-A-HDMI-A-1
[405.649640] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (13.527s)
[405.661546] Starting dynamic subtest: pipe-D-HDMI-A-1
[419.461312] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (13.808s)
[419.462123] Subtest query-forked-busy-hang: SUCCESS (27.342s)
[419.599811] [132/133] (594s left) kms_big_fb (linear-32bpp-rotate-180)
[419.703219] Starting subtest: linear-32bpp-rotate-180
[421.289702] Subtest linear-32bpp-rotate-180: SUCCESS (1.586s)
[421.393043] [133/133] (592s left) kms_flip (absolute-wf_vblank-interruptible)
[421.487958] Starting subtest: absolute-wf_vblank-interruptible
[421.490864] Starting dynamic subtest: A-HDMI-A1
[429.164492] Dynamic subtest A-HDMI-A1: SUCCESS (7.653s)
[429.173118] Starting dynamic subtest: B-HDMI-A1
[436.776578] Dynamic subtest B-HDMI-A1: SUCCESS (7.626s)
[436.784638] Starting dynamic subtest: C-HDMI-A1
[444.438039] Dynamic subtest C-HDMI-A1: SUCCESS (7.633s)
[444.445720] Starting dynamic subtest: D-HDMI-A1
[452.048240] Dynamic subtest D-HDMI-A1: SUCCESS (7.634s)
[452.050604] Subtest absolute-wf_vblank-interruptible: SUCCESS (30.562s)
[452.173755] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_params
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_userptr_blits
results: parsing output: 4/ for test: gem_tiling_max_stride
results: parsing output: 5/ for test: gen9_exec_parse
results: parsing output: 6/ for test: kms_plane
results: parsing output: 7/ for test: gem_lmem_swapping
results: parsing output: 8/ for test: gem_mmap_wc
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_ccs
results: parsing output: 12/ for test: gem_mmap_wc
results: parsing output: 13/ for test: gem_softpin
results: parsing output: 14/ for test: intel_hwmon
results: parsing output: 15/ for test: kms_cursor_crc
results: parsing output: 16/ for test: gem_exec_params
results: parsing output: 17/ for test: kms_psr2_sf
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: kms_atomic
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gem_render_copy
results: parsing output: 25/ for test: kms_flip
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: sw_sync
results: parsing output: 28/ for test: kms_content_protection
results: parsing output: 29/ for test: i915_hangman
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: kms_cursor_edge_walk
results: parsing output: 33/ for test: kms_atomic_transition
results: parsing output: 34/ for test: gem_fence_thrash
results: parsing output: 35/ for test: kms_prop_blob
results: parsing output: 36/ for test: kms_plane_scaling
results: parsing output: 37/ for test: api_intel_allocator
results: parsing output: 38/ for test: i915_query
results: parsing output: 39/ for test: perf
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: sysfs_heartbeat_interval
results: parsing output: 42/ for test: gem_ctx_persistence
results: parsing output: 43/ for test: gem_render_copy
results: parsing output: 44/ for test: gem_ctx_isolation
results: parsing output: 45/ for test: kms_vblank
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_flip_scaled_crc
results: parsing output: 48/ for test: kms_psr2_su
results: parsing output: 49/ for test: dmabuf_sync_file
results: parsing output: 50/ for test: kms_multipipe_modeset
results: parsing output: 51/ for test: gem_create
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: kms_cursor_legacy
results: parsing output: 55/ for test: kms_cursor_legacy
results: parsing output: 56/ for test: kms_chamelium_frames
results: parsing output: 57/ for test: kms_flip_scaled_crc
results: parsing output: 58/ for test: tools_test
results: parsing output: 59/ for test: gem_exec_balancer
results: parsing output: 60/ for test: gem_exec_reloc
results: parsing output: 61/ for test: gem_spin_batch
results: parsing output: 62/ for test: gem_exec_schedule
results: parsing output: 63/ for test: kms_addfb_basic
results: parsing output: 64/ for test: gem_exec_capture
results: parsing output: 65/ for test: gem_exec_reloc
results: parsing output: 66/ for test: gem_readwrite
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: i915_pm_rc6_residency
results: parsing output: 70/ for test: kms_invalid_mode
results: parsing output: 71/ for test: kms_properties
results: parsing output: 72/ for test: kms_chamelium_hpd
results: parsing output: 73/ for test: gem_wait
results: parsing output: 74/ for test: fbdev
results: parsing output: 75/ for test: kms_lease
results: parsing output: 76/ for test: gem_eio
results: parsing output: 77/ for test: i915_query
results: parsing output: 78/ for test: perf
results: parsing output: 79/ for test: kms_pm_rpm
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_plane
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: gem_exec_reloc
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: gem_mmap_wc
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_dp_link_training
results: parsing output: 90/ for test: gem_exec_params
results: parsing output: 91/ for test: kms_prime
results: parsing output: 92/ for test: gem_exec_fence
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_cursor_legacy
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: syncobj_timeline
results: parsing output: 98/ for test: gem_tiled_pread_pwrite
results: parsing output: 99/ for test: kms_cursor_crc
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: perf_pmu
results: parsing output: 103/ for test: kms_cursor_legacy
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_color_pipeline
results: parsing output: 106/ for test: gem_reg_read
results: parsing output: 107/ for test: perf_pmu
results: parsing output: 108/ for test: kms_rotation_crc
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: gem_exec_schedule
results: parsing output: 111/ for test: gem_exec_schedule
results: parsing output: 112/ for test: i915_drm_fdinfo
results: parsing output: 113/ for test: api_intel_bb
results: parsing output: 114/ for test: gem_exec_flush
results: parsing output: 115/ for test: gem_mmap_gtt
results: parsing output: 116/ for test: syncobj_eventfd
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_plane_multiple
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: perf
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: gem_mmap_gtt
results: parsing output: 126/ for test: kms_addfb_basic
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_dp_link_training
results: parsing output: 129/ for test: kms_ccs
results: parsing output: 130/ for test: kms_vblank
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: kms_flip
Done.