[44.735779] Initializing watchdogs
[44.735841]   /dev/watchdog0
[44.751398] [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]
[44.757103] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[44.760283] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[44.762411] [001/155] (960s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[44.862448] Starting subtest: fbc-1p-pri-indfb-multidraw
[53.633955] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (8.705s)
[53.759790] [002/155] (951s left) kms_content_protection (lic-type-0-hdcp14)
[53.859602] Starting subtest: lic-type-0-hdcp14
[53.865122] Subtest lic-type-0-hdcp14: SKIP (0.004s)
[53.955697] [003/155] (951s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[54.048451] Starting subtest: flip-vs-dpms-on-nop-interruptible
[54.050474] Starting dynamic subtest: A-HDMI-A1
[54.881121] Dynamic subtest A-HDMI-A1: SUCCESS (0.826s)
[54.891342] Starting dynamic subtest: B-HDMI-A1
[55.668904] Dynamic subtest B-HDMI-A1: SUCCESS (0.781s)
[55.681696] Starting dynamic subtest: C-HDMI-A1
[56.458563] Dynamic subtest C-HDMI-A1: SUCCESS (0.784s)
[56.468427] Starting dynamic subtest: D-HDMI-A1
[57.244137] Dynamic subtest D-HDMI-A1: SUCCESS (0.782s)
[57.248381] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (3.185s)
[57.420071] [004/155] (947s left) i915_pm_rc6_residency (rc6-accuracy)
[57.455821] Starting subtest: rc6-accuracy
[57.456503] Starting dynamic subtest: gt0
[60.659760] Dynamic subtest gt0: SUCCESS (3.159s)
[60.660751] Subtest rc6-accuracy: SUCCESS (3.160s)
[60.708877] [005/155] (944s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[60.799359] Starting subtest: coverage-vs-premult-vs-constant
[60.864934] Starting dynamic subtest: pipe-A-HDMI-A-1
[61.129853] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.264s)
[61.136763] Starting dynamic subtest: pipe-D-HDMI-A-1
[61.407119] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.275s)
[61.407944] Subtest coverage-vs-premult-vs-constant: SUCCESS (0.607s)
[61.576770] [006/155] (943s left) kms_big_fb (linear-32bpp-rotate-270)
[61.678370] Starting subtest: linear-32bpp-rotate-270
[61.762339] Subtest linear-32bpp-rotate-270: SKIP (0.083s)
[61.878449] [007/155] (943s left) kms_vblank (wait-idle-hang)
[61.965816] Starting subtest: wait-idle-hang
[61.967331] Starting dynamic subtest: pipe-A-HDMI-A-1
[75.914333] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (13.935s)
[75.924129] Starting dynamic subtest: pipe-D-HDMI-A-1
[89.731049] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (13.809s)
[89.731793] Subtest wait-idle-hang: SUCCESS (27.749s)
[89.918011] [008/155] (915s left) perf_pmu (interrupts)
[89.961248] Starting subtest: interrupts
[91.075146] Subtest interrupts: SUCCESS (1.105s)
[91.151151] [FACT perf_pmu (interrupts)] new: kernel.kmod_is_loaded.vgem: true
[91.154121] [009/155] (914s left) gem_exec_reloc (basic-write-cpu-noreloc)
[91.192150] Starting subtest: basic-write-cpu-noreloc
[91.194349] Subtest basic-write-cpu-noreloc: SUCCESS (0.002s)
[91.324683] [010/155] (914s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[91.417122] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[91.418466] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[91.515154] [011/155] (914s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[91.608430] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[91.609845] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[91.696469] [012/155] (913s left) kms_pm_backlight (fade)
[91.786356] Subtest fade: SKIP (0.000s)
[91.823438] [013/155] (913s left) gem_mmap_wc (write-cpu-read-wc)
[91.857499] Starting subtest: write-cpu-read-wc
[91.934993] Subtest write-cpu-read-wc: SUCCESS (0.078s)
[92.021094] [014/155] (913s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[92.113622] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[92.115119] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[92.205522] [015/155] (913s left) kms_flip (absolute-wf_vblank-interruptible)
[92.297902] Starting subtest: absolute-wf_vblank-interruptible
[92.300494] Starting dynamic subtest: A-HDMI-A1
[99.962993] Dynamic subtest A-HDMI-A1: SUCCESS (7.659s)
[99.978886] Starting dynamic subtest: B-HDMI-A1
[107.652641] Dynamic subtest B-HDMI-A1: SUCCESS (7.659s)
[107.659500] Starting dynamic subtest: C-HDMI-A1
[115.295589] Dynamic subtest C-HDMI-A1: SUCCESS (7.642s)
[115.304211] Starting dynamic subtest: D-HDMI-A1
[122.922422] Dynamic subtest D-HDMI-A1: SUCCESS (7.649s)
[122.923453] Subtest absolute-wf_vblank-interruptible: SUCCESS (30.617s)
[123.083943] [016/155] (882s left) gem_vm_create (invalid-create)
[123.123080] Starting subtest: invalid-create
[123.123896] Subtest invalid-create: SUCCESS (0.001s)
[123.221976] [017/155] (882s left) syncobj_basic (bad-fd-to-handle)
[123.255451] Starting subtest: bad-fd-to-handle
[123.256213] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[123.329662] [018/155] (882s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-mmap-wc)
[123.426366] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-mmap-wc
[123.427836] Subtest hdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[123.524300] [019/155] (882s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[123.617449] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[123.618844] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[123.723995] [020/155] (882s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[123.816040] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[123.817426] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[123.912552] [021/155] (882s left) kms_frontbuffer_tracking (hdr-2p-pri-indfb-multidraw)
[124.006496] Starting subtest: hdr-2p-pri-indfb-multidraw
[124.007910] Subtest hdr-2p-pri-indfb-multidraw: SKIP (0.000s)
[124.087022] [022/155] (882s left) kms_cursor_crc (cursor-sliding-256x256)
[124.180637] Starting subtest: cursor-sliding-256x256
[124.185738] Starting dynamic subtest: pipe-A-HDMI-A-1
[126.018188] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.832s)
[126.053200] Starting dynamic subtest: pipe-D-HDMI-A-1
[127.877439] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.832s)
[127.878297] Subtest cursor-sliding-256x256: SUCCESS (3.697s)
[128.034459] [023/155] (878s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[128.129046] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[128.130393] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[128.199473] [024/155] (877s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[128.291478] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[128.292957] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[128.381793] [025/155] (877s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[128.470725] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[128.471422] Starting dynamic subtest: pipe-A-HDMI-A-1
[128.491530] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[128.498469] Starting dynamic subtest: pipe-B-HDMI-A-1
[128.505293] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[128.512138] Starting dynamic subtest: pipe-C-HDMI-A-1
[128.518679] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[128.525633] Starting dynamic subtest: pipe-D-HDMI-A-1
[128.533190] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[128.534571] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.007s)
[128.728499] [026/155] (877s left) gem_exec_parallel (fds)
[128.777099] Starting subtest: fds
[128.777894] Starting dynamic subtest: rcs0
[131.116843] Dynamic subtest rcs0: SUCCESS (2.339s)
[131.134100] Starting dynamic subtest: bcs0
[133.047015] Dynamic subtest bcs0: SUCCESS (1.929s)
[133.059101] Starting dynamic subtest: vcs0
[135.151533] Dynamic subtest vcs0: SUCCESS (2.095s)
[135.158650] Starting dynamic subtest: vcs1
[137.085333] Dynamic subtest vcs1: SUCCESS (1.933s)
[137.099429] Starting dynamic subtest: vecs0
[138.943322] Dynamic subtest vecs0: SUCCESS (1.866s)
[138.944203] Subtest fds: SUCCESS (10.166s)
[139.135605] [027/155] (867s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[139.234312] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[139.235728] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[139.315617] [028/155] (867s left) kms_lease (lessee-list)
[139.403054] Starting subtest: lessee-list
[139.403855] Starting dynamic subtest: pipe-A-HDMI-A-1
[139.404706] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[139.414652] Starting dynamic subtest: pipe-B-HDMI-A-1
[139.415398] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[139.424835] Starting dynamic subtest: pipe-C-HDMI-A-1
[139.425591] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[139.434775] Starting dynamic subtest: pipe-D-HDMI-A-1
[139.435529] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[139.436321] Subtest lessee-list: SUCCESS (0.007s)
[139.479717] [029/155] (866s left) gem_exec_params (mmapped)
[139.519670] Starting subtest: mmapped
[139.520364] Subtest mmapped: SUCCESS (0.001s)
[139.609484] [030/155] (866s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[139.698395] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s)
[139.742607] [031/155] (866s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[139.840036] Starting subtest: yf-tiled-addfb-size-overflow
[139.841351] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[139.942752] [032/155] (866s left) api_intel_bb (destroy-bb)
[139.976783] Starting subtest: destroy-bb
[139.984439] Subtest destroy-bb: SUCCESS (0.008s)
[140.102890] [033/155] (866s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[140.193970] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[140.195348] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[140.310703] [034/155] (866s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[140.401292] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[141.454552] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (1.053s)
[141.564823] [035/155] (865s left) kms_frontbuffer_tracking (fbchdr-2p-shrfb-fliptrack-mmap-gtt)
[141.665641] Starting subtest: fbchdr-2p-shrfb-fliptrack-mmap-gtt
[141.667072] Subtest fbchdr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[141.735777] [036/155] (864s left) gem_lmem_swapping (random)
[141.774842] Subtest random: SKIP (0.000s)
[141.821818] [037/155] (864s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-blt)
[141.914551] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-blt
[141.916014] Subtest fbchdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[142.001487] [038/155] (864s left) gem_pread (exhaustion)
[142.036354] Starting subtest: exhaustion
[145.706622] Subtest exhaustion: SUCCESS (3.662s)
[146.060744] [039/155] (860s left) prime_mmap (test_forked_cpu_write)
[146.094398] Starting subtest: test_forked_cpu_write
[146.095109] Starting dynamic subtest: test_forked_cpu_write-smem
[146.103037] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.009s)
[146.103823] Subtest test_forked_cpu_write: SUCCESS (0.010s)
[146.200573] [040/155] (860s left) sw_sync (sync_busy_fork)
[146.234094] Starting subtest: sync_busy_fork
[147.254260] Subtest sync_busy_fork: SUCCESS (1.012s)
[147.309624] [041/155] (859s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[147.398610] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[147.399320] Starting dynamic subtest: pipe-A-valid-mode
[148.688088] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.289s)
[148.688880] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SUCCESS (1.290s)
[148.824977] [042/155] (858s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[148.927359] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[148.928739] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[149.024623] [043/155] (857s left) prime_mmap (test_reprime)
[149.058721] Starting subtest: test_reprime
[149.059407] Starting dynamic subtest: test_reprime-smem
[149.060093] Dynamic subtest test_reprime-smem: SUCCESS (0.002s)
[149.060821] Subtest test_reprime: SUCCESS (0.002s)
[149.165494] [044/155] (857s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc)
[149.258167] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc
[149.259622] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[149.363521] [045/155] (857s left) i915_drm_fdinfo (virtual-busy-all)
[149.400188] Starting subtest: virtual-busy-all
[149.917662] Subtest virtual-busy-all: SUCCESS (0.517s)
[149.985187] [046/155] (857s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[150.071741] Starting subtest: primary-yf-tiled-reflect-x-180
[150.127462] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.054s)
[150.216912] [047/155] (856s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[150.314805] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[150.316181] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[150.406487] [048/155] (856s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[150.493101] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[150.495089] Starting dynamic subtest: pipe-A-HDMI-A-1
[150.501508] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[150.511296] Starting dynamic subtest: pipe-B-HDMI-A-1
[150.517668] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[150.526969] Starting dynamic subtest: pipe-C-HDMI-A-1
[150.533330] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[150.542264] Starting dynamic subtest: pipe-D-HDMI-A-1
[150.548384] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[150.549113] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SUCCESS (0.011s)
[150.759266] [049/155] (856s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-onoff)
[150.852350] Starting subtest: fbchdr-2p-primscrn-spr-indfb-onoff
[150.853731] Subtest fbchdr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[150.958188] [050/155] (856s left) gem_mmap_offset (basic-uaf)
[150.992215] Starting subtest: basic-uaf
[150.993888] Subtest basic-uaf: SUCCESS (0.001s)
[151.082482] [051/155] (856s left) kms_chamelium_color (ctm-0-50)
[151.174491] Subtest ctm-0-50: SKIP (0.000s)
[151.221901] [052/155] (856s left) syncobj_timeline (multi-wait-signaled)
[151.256905] Starting subtest: multi-wait-signaled
[151.257611] Subtest multi-wait-signaled: SUCCESS (0.001s)
[151.329780] [053/155] (856s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-pwrite)
[151.420439] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-pwrite
[151.421840] Subtest hdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[151.528824] [054/155] (855s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[151.620554] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[151.622098] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[151.718682] [055/155] (855s left) kms_feature_discovery (dp-mst)
[151.807585] Starting subtest: dp-mst
[151.809083] Subtest dp-mst: SKIP (0.000s)
[151.894321] [056/155] (855s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[151.986462] Starting subtest: pipe-fbc-rte
[151.990513] Subtest pipe-fbc-rte: SKIP (0.000s)
[152.083838] [057/155] (855s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[152.128994] Starting subtest: map-fixed-invalidate-overlap
[152.129779] Starting dynamic subtest: gtt
[152.222749] Dynamic subtest gtt: SUCCESS (0.093s)
[152.231058] Starting dynamic subtest: wb
[152.284663] Dynamic subtest wb: SUCCESS (0.061s)
[152.292167] Starting dynamic subtest: wc
[152.342877] Dynamic subtest wc: SUCCESS (0.058s)
[152.351473] Starting dynamic subtest: uc
[152.402584] Dynamic subtest uc: SUCCESS (0.059s)
[152.403426] Subtest map-fixed-invalidate-overlap: SUCCESS (0.274s)
[152.528959] [058/155] (855s left) i915_fb_tiling (basic-x-tiling)
[152.562637] Starting subtest: basic-x-tiling
[152.563403] Subtest basic-x-tiling: SUCCESS (0.000s)
[152.648962] [059/155] (854s left) kms_psr (psr2-primary-mmap-cpu)
[152.740514] Subtest psr2-primary-mmap-cpu: SKIP (0.000s)
[152.786882] [060/155] (854s left) gem_exec_store (pages)
[152.828803] Starting subtest: pages
[152.829655] Starting dynamic subtest: rcs0
[152.908099] Dynamic subtest rcs0: SUCCESS (0.079s)
[152.925546] Starting dynamic subtest: bcs0
[152.958198] Dynamic subtest bcs0: SUCCESS (0.049s)
[152.966572] Starting dynamic subtest: vcs0
[153.015702] Dynamic subtest vcs0: SUCCESS (0.057s)
[153.024408] Starting dynamic subtest: vcs1
[153.069616] Dynamic subtest vcs1: SUCCESS (0.053s)
[153.081754] Starting dynamic subtest: vecs0
[153.121301] Dynamic subtest vecs0: SUCCESS (0.050s)
[153.122080] Subtest pages: SUCCESS (0.293s)
[153.296767] [061/155] (854s left) kms_cursor_crc (cursor-sliding-max-size)
[153.393147] Starting subtest: cursor-sliding-max-size
[153.395152] Subtest cursor-sliding-max-size: SKIP (0.000s)
[153.502593] [062/155] (854s left) api_intel_allocator (simple-allocator)
[153.537041] Starting subtest: simple-allocator
[153.537927] Starting dynamic subtest: basic
[153.539612] Dynamic subtest basic: SUCCESS (0.002s)
[153.548062] Starting dynamic subtest: parallel-one
[153.722299] Dynamic subtest parallel-one: SUCCESS (0.173s)
[153.730812] Starting dynamic subtest: print
[153.731519] Dynamic subtest print: SUCCESS (0.000s)
[153.739028] Starting dynamic subtest: reuse
[153.739723] Dynamic subtest reuse: SUCCESS (0.000s)
[153.747095] Starting dynamic subtest: reserve
[153.747786] Dynamic subtest reserve: SUCCESS (0.000s)
[153.754766] Starting dynamic subtest: fork-reopen-allocator
[153.755440] Dynamic subtest fork-reopen-allocator: SUCCESS (0.014s)
[153.756106] Subtest simple-allocator: SUCCESS (0.193s)
[153.797570] [063/155] (853s left) gem_ctx_engines (invalid-engines)
[153.839390] Starting subtest: invalid-engines
[153.844332] Subtest invalid-engines: SUCCESS (0.005s)
[154.027428] [064/155] (853s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[154.063243] Starting subtest: etime-single-wait-available-unsubmitted
[154.165830] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.102s)
[154.236268] [065/155] (853s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[154.335176] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[154.654396] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.319s)
[154.802747] [066/155] (853s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[154.892461] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (0.000s)
[154.934860] [067/155] (853s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[155.072847] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[155.172144] [068/155] (852s left) gem_lmem_swapping (parallel-random)
[155.222066] Subtest parallel-random: SKIP (0.000s)
[155.266974] [069/155] (852s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-pwrite)
[155.359078] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-pwrite
[155.360447] Subtest hdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[155.451517] [070/155] (852s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[155.543797] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[155.545189] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[155.649691] [071/155] (852s left) gem_exec_schedule (preempt-hang)
[155.806402] Starting subtest: preempt-hang
[155.812824] Starting dynamic subtest: rcs0
[156.007951] Dynamic subtest rcs0: SUCCESS (0.206s)
[156.016561] Starting dynamic subtest: bcs0
[156.207679] Dynamic subtest bcs0: SUCCESS (0.199s)
[156.215557] Starting dynamic subtest: vcs0
[156.408326] Dynamic subtest vcs0: SUCCESS (0.200s)
[156.416454] Starting dynamic subtest: vcs1
[156.603614] Dynamic subtest vcs1: SUCCESS (0.194s)
[156.611529] Starting dynamic subtest: vecs0
[156.809620] Dynamic subtest vecs0: SUCCESS (0.205s)
[156.810433] Subtest preempt-hang: SUCCESS (1.009s)
[157.002862] [072/155] (851s left) kms_psr (fbc-pr-primary-mmap-cpu)
[157.092539] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[157.135014] [073/155] (851s left) kms_cursor_crc (cursor-offscreen-32x10)
[157.225265] Starting subtest: cursor-offscreen-32x10
[157.290148] Subtest cursor-offscreen-32x10: SKIP (0.063s)
[157.362646] [074/155] (850s left) gem_exec_balancer (parallel-bb-first)
[157.524131] Subtest parallel-bb-first: SKIP (0.000s)
[157.610545] [075/155] (850s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[157.699434] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[157.700195] Starting dynamic subtest: pipe-A-HDMI-A-1
[157.707085] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[157.714585] Starting dynamic subtest: pipe-B-HDMI-A-1
[157.721292] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[157.728676] Starting dynamic subtest: pipe-C-HDMI-A-1
[157.735315] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[157.742530] Starting dynamic subtest: pipe-D-HDMI-A-1
[157.749223] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[157.750513] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.006s)
[157.960637] [076/155] (850s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[157.995931] Starting subtest: single-wait-for-submit-available-signaled
[157.996613] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[158.066310] [077/155] (850s left) gem_softpin (noreloc-s3)
[158.105790] Starting subtest: noreloc-S3
[178.540416] Subtest noreloc-S3: SUCCESS (5.421s)
[183.654201] [078/155] (829s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[183.776287] Starting subtest: x-tiled-32bpp-rotate-0
[185.049786] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.255s)
[185.172797] [079/155] (828s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[185.285516] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[185.327825] [080/155] (828s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[185.367449] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[185.368178] Starting dynamic subtest: smem
[185.475081] Dynamic subtest smem: SUCCESS (0.106s)
[185.475813] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SUCCESS (0.107s)
[185.666182] [081/155] (827s left) gen9_exec_parse (allowed-single)
[185.703322] Subtest allowed-single: SKIP (0.000s)
[185.749412] [082/155] (827s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-move)
[185.842709] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-move
[185.844088] Subtest psrhdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[185.941029] [083/155] (827s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[186.029295] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[194.986296] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (8.892s)
[195.146105] [084/155] (818s left) gem_exec_balancer (sequential)
[195.192301] Starting subtest: sequential
[198.677286] Subtest sequential: SUCCESS (3.475s)
[198.866078] [085/155] (814s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[198.957219] Starting subtest: cursorB-vs-flipA-legacy
[198.958990] Subtest cursorB-vs-flipA-legacy: SKIP (0.002s)
[199.042807] [086/155] (814s left) gem_ctx_param (basic)
[199.076493] Starting subtest: basic
[199.077204] Subtest basic: SUCCESS (0.000s)
[199.156233] [087/155] (814s left) kms_frontbuffer_tracking (psrhdr-1p-rte)
[199.249964] Starting subtest: psrhdr-1p-rte
[199.251367] Subtest psrhdr-1p-rte: SKIP (0.000s)
[199.342428] [088/155] (814s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[199.438552] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[199.440073] Subtest psr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[199.534265] [089/155] (814s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[199.628204] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-mmap-gtt
[199.629679] Subtest fbchdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[199.725819] [090/155] (814s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-pgflip-blt)
[199.818881] Starting subtest: psrhdr-2p-scndscrn-shrfb-pgflip-blt
[199.820314] Subtest psrhdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[199.928785] [091/155] (814s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[200.021481] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[200.022920] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[200.108145] [092/155] (813s left) kms_addfb_basic (clobberred-modifier)
[200.142599] Starting subtest: clobberred-modifier
[200.143356] Subtest clobberred-modifier: SUCCESS (0.000s)
[200.286407] [093/155] (813s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-pwrite)
[200.381658] Starting subtest: fbcpsrhdr-rgb565-draw-pwrite
[200.383157] Subtest fbcpsrhdr-rgb565-draw-pwrite: SKIP (0.000s)
[200.459331] [094/155] (813s left) perf (gen12-group-exclusive-stream-ctx-handle)
[200.547888] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[200.558423] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.011s)
[200.598786] [095/155] (813s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-mmap-wc)
[200.691721] Starting subtest: fbchdr-rgb565-draw-mmap-wc
[200.693242] Subtest fbchdr-rgb565-draw-mmap-wc: SKIP (0.000s)
[200.796533] [096/155] (813s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[200.831890] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[200.937040] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.104s)
[201.014491] [097/155] (813s left) gem_ctx_persistence (processes)
[201.052287] Starting subtest: processes
[201.485360] Subtest processes: SUCCESS (0.432s)
[201.564483] [098/155] (812s left) gem_softpin (overlap)
[201.604750] Starting subtest: overlap
[202.549137] Subtest overlap: SUCCESS (0.934s)
[202.667913] [099/155] (811s left) gem_exec_fence (nb-await)
[202.826215] Starting subtest: nb-await
[202.829066] Starting dynamic subtest: rcs0
[202.891176] Dynamic subtest rcs0: SUCCESS (0.063s)
[202.909156] Starting dynamic subtest: bcs0
[202.958020] Dynamic subtest bcs0: SUCCESS (0.064s)
[202.976057] Starting dynamic subtest: vcs0
[203.023803] Dynamic subtest vcs0: SUCCESS (0.063s)
[203.042247] Starting dynamic subtest: vcs1
[203.089979] Dynamic subtest vcs1: SUCCESS (0.063s)
[203.108346] Starting dynamic subtest: vecs0
[203.156013] Dynamic subtest vecs0: SUCCESS (0.063s)
[203.159421] Subtest nb-await: SUCCESS (0.331s)
[203.632633] [100/155] (810s left) kms_dp_link_training (non-uhbr-sst)
[203.726693] Starting subtest: non-uhbr-sst
[203.729598] Subtest non-uhbr-sst: SKIP (0.000s)
[203.801225] [101/155] (810s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[203.892291] Starting subtest: addfb25-x-tiled-mismatch-legacy
[203.893140] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[203.993207] [102/155] (810s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[204.081759] Starting subtest: sprite-rotation-90-pos-100-0
[208.814498] Subtest sprite-rotation-90-pos-100-0: SUCCESS (4.727s)
[209.035783] [103/155] (805s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[209.132243] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[209.133649] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[209.313940] [104/155] (805s left) kms_atomic_transition (modeset-transition-nonblocking)
[209.405724] Starting subtest: modeset-transition-nonblocking
[209.406417] Starting dynamic subtest: 1x-outputs
[210.676285] Dynamic subtest 1x-outputs: SUCCESS (1.269s)
[210.677060] Subtest modeset-transition-nonblocking: SUCCESS (1.270s)
[210.835660] [105/155] (803s left) prime_vgem (coherency-blt)
[210.911713] Starting subtest: coherency-blt
[211.910509] Subtest coherency-blt: SUCCESS (0.989s)
[212.022482] [106/155] (802s left) sw_sync (alloc_fence)
[212.055249] Starting subtest: alloc_fence
[212.056004] Subtest alloc_fence: SUCCESS (0.000s)
[212.109055] [107/155] (802s left) gem_eio (in-flight-internal-10ms)
[212.151280] Starting subtest: in-flight-internal-10ms
[212.418698] Subtest in-flight-internal-10ms: SUCCESS (0.267s)
[212.545115] [108/155] (802s left) kms_chamelium_edid (hdmi-mode-timings)
[212.691040] Subtest hdmi-mode-timings: SKIP (0.000s)
[212.790136] [109/155] (801s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[212.887090] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[212.888531] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[213.003327] [110/155] (801s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[213.042941] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[213.043646] Starting dynamic subtest: smem
[213.120160] Dynamic subtest smem: SUCCESS (0.076s)
[213.121028] Subtest mixed-tiled-to-yf-tiled-ccs: SUCCESS (0.078s)
[213.311882] [111/155] (801s left) gem_ctx_param (vm)
[213.345493] Starting subtest: vm
[213.365417] Subtest vm: SUCCESS (0.020s)
[213.488163] [112/155] (801s left) kms_vblank (query-forked-hang)
[213.576614] Starting subtest: query-forked-hang
[213.577373] Starting dynamic subtest: pipe-A-HDMI-A-1
[215.086079] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.508s)
[215.098734] Starting dynamic subtest: pipe-D-HDMI-A-1
[216.595079] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.506s)
[216.595877] Subtest query-forked-hang: SUCCESS (3.020s)
[216.763776] [113/155] (798s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[216.863701] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[216.873355] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.009s)
[216.939378] [114/155] (797s left) kms_flip (nonblocking-read)
[217.030174] Starting subtest: nonblocking-read
[217.030929] Subtest nonblocking-read: SUCCESS (0.000s)
[217.129377] [115/155] (797s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[217.224529] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[217.226373] Subtest psr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[217.337604] [116/155] (797s left) gem_sync (basic-all)
[217.382225] Starting subtest: basic-all
[219.528036] Subtest basic-all: SUCCESS (2.147s)
[219.718215] [117/155] (795s left) gem_busy (semaphore)
[219.893472] Starting subtest: semaphore
[219.894467] Starting dynamic subtest: rcs0
[219.928874] Dynamic subtest rcs0: SUCCESS (0.043s)
[219.948981] Starting dynamic subtest: bcs0
[219.955233] Dynamic subtest bcs0: SUCCESS (0.024s)
[219.967402] Starting dynamic subtest: vcs0
[219.981629] Dynamic subtest vcs0: SUCCESS (0.025s)
[219.995166] Starting dynamic subtest: vcs1
[220.002390] Dynamic subtest vcs1: SUCCESS (0.017s)
[220.011773] Starting dynamic subtest: vecs0
[220.013701] Dynamic subtest vecs0: SUCCESS (0.012s)
[220.014428] Subtest semaphore: SUCCESS (0.130s)
[220.243772] [118/155] (794s left) gem_spin_batch (legacy)
[220.286081] Starting subtest: legacy
[220.286799] Starting dynamic subtest: default
[223.637462] Dynamic subtest default: SUCCESS (3.315s)
[223.651881] Starting dynamic subtest: render
[226.956202] Dynamic subtest render: SUCCESS (3.316s)
[226.967498] Starting dynamic subtest: bsd
[230.277437] Dynamic subtest bsd: SUCCESS (3.317s)
[230.288813] Starting dynamic subtest: bsd1
[233.597906] Dynamic subtest bsd1: SUCCESS (3.317s)
[233.609292] Starting dynamic subtest: bsd2
[236.918230] Dynamic subtest bsd2: SUCCESS (3.317s)
[236.929327] Starting dynamic subtest: blt
[240.239675] Dynamic subtest blt: SUCCESS (3.317s)
[240.251088] Starting dynamic subtest: vebox
[243.560628] Dynamic subtest vebox: SUCCESS (3.316s)
[243.561640] Subtest legacy: SUCCESS (23.234s)
[243.705570] [119/155] (771s left) i915_selftest (mock)
[244.658245] Starting subtest: mock
[244.659103] Starting dynamic subtest: sanitycheck
[245.355906] Dynamic subtest sanitycheck: SUCCESS (0.697s)
[245.366188] Starting dynamic subtest: shmem
[246.027410] Dynamic subtest shmem: SUCCESS (0.678s)
[246.042712] Starting dynamic subtest: fence
[253.942947] Dynamic subtest fence: SUCCESS (7.902s)
[253.951783] Starting dynamic subtest: scatterlist
[255.650982] Dynamic subtest scatterlist: SUCCESS (1.705s)
[255.660792] Starting dynamic subtest: syncmap
[258.493870] Dynamic subtest syncmap: SUCCESS (2.840s)
[258.503531] Starting dynamic subtest: uncore
[259.190827] Dynamic subtest uncore: SUCCESS (0.695s)
[259.201297] Starting dynamic subtest: ring
[259.884044] Dynamic subtest ring: SUCCESS (0.691s)
[259.894819] Starting dynamic subtest: engine
[260.571673] Dynamic subtest engine: SUCCESS (0.684s)
[260.586118] Starting dynamic subtest: timelines
[265.020683] Dynamic subtest timelines: SUCCESS (4.446s)
[265.028864] Starting dynamic subtest: requests
[267.712802] Dynamic subtest requests: SUCCESS (2.689s)
[267.720511] Starting dynamic subtest: objects
[268.512925] Dynamic subtest objects: SUCCESS (0.797s)
[268.522545] Starting dynamic subtest: phys
[269.302971] Dynamic subtest phys: SUCCESS (0.787s)
[269.311003] Starting dynamic subtest: dmabuf
[270.074967] Dynamic subtest dmabuf: SUCCESS (0.769s)
[270.083228] Starting dynamic subtest: vma
[277.552924] Dynamic subtest vma: SUCCESS (7.473s)
[277.560980] Starting dynamic subtest: evict
[279.173884] Dynamic subtest evict: SUCCESS (1.618s)
[279.182186] Starting dynamic subtest: gtt
[282.881049] Dynamic subtest gtt: SUCCESS (3.707s)
[282.892845] Starting dynamic subtest: hugepages
[283.834954] Dynamic subtest hugepages: SUCCESS (0.952s)
[283.843591] Starting dynamic subtest: memory_region
[286.974944] Dynamic subtest memory_region: SUCCESS (3.139s)
[286.976071] Subtest mock: SUCCESS (42.308s)
[287.003989] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[287.004771] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[287.009231] [120/155] (728s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[288.089701] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[288.091225] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[288.176591] [FACT kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[288.178720] [FACT kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)] new: kernel.kmod_is_loaded.i915: true
[288.181158] [121/155] (727s left) gem_ctx_shared (exec-single-timeline)
[288.229342] Starting subtest: exec-single-timeline
[288.230086] Starting dynamic subtest: rcs0
[289.314530] Dynamic subtest rcs0: SUCCESS (1.077s)
[289.323744] Starting dynamic subtest: bcs0
[290.337151] Dynamic subtest bcs0: SUCCESS (1.021s)
[290.346050] Starting dynamic subtest: vcs0
[291.361290] Dynamic subtest vcs0: SUCCESS (1.022s)
[291.369484] Starting dynamic subtest: vcs1
[292.385288] Dynamic subtest vcs1: SUCCESS (1.022s)
[292.393919] Starting dynamic subtest: vecs0
[293.409441] Dynamic subtest vecs0: SUCCESS (1.022s)
[293.410409] Subtest exec-single-timeline: SUCCESS (5.175s)
[293.589693] [122/155] (721s left) kms_hdr (invalid-hdr)
[293.682470] Starting subtest: invalid-hdr
[293.683455] Starting dynamic subtest: pipe-A-HDMI-A-1-XRGB2101010
[293.684877] Dynamic subtest pipe-A-HDMI-A-1-XRGB2101010: SKIP (0.000s)
[293.693389] Starting dynamic subtest: pipe-A-HDMI-A-1-XRGB16161616F
[293.694774] Dynamic subtest pipe-A-HDMI-A-1-XRGB16161616F: SKIP (0.000s)
[293.698069] Subtest invalid-hdr: SKIP (0.005s)
[293.744791] [123/155] (721s left) core_sysfs (read-all-entries)
[293.778180] Starting subtest: read-all-entries
[293.780916] Subtest read-all-entries: SUCCESS (0.003s)
[293.852439] [124/155] (721s left) kms_big_fb (x-tiled-addfb-size-overflow)
[293.952346] Starting subtest: x-tiled-addfb-size-overflow
[293.953082] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[294.067348] [125/155] (721s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[294.156429] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[294.157148] Starting dynamic subtest: pipe-A
[295.440521] Dynamic subtest pipe-A: SUCCESS (1.284s)
[295.460520] Starting dynamic subtest: pipe-B
[296.751037] Dynamic subtest pipe-B: SUCCESS (1.309s)
[296.766000] Starting dynamic subtest: pipe-C
[296.969070] Dynamic subtest pipe-C: SUCCESS (0.217s)
[296.978400] Starting dynamic subtest: pipe-D
[297.178837] Dynamic subtest pipe-D: SUCCESS (0.209s)
[297.179553] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.024s)
[297.359464] [126/155] (718s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-move)
[297.457548] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-move
[297.458966] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[297.562643] [127/155] (717s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[297.655726] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[297.657113] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[297.737231] [128/155] (717s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[297.827133] Starting subtest: multiplane-rotation-cropping-bottom
[323.859693] Subtest multiplane-rotation-cropping-bottom: SUCCESS (26.033s)
[323.964633] [129/155] (691s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[324.074007] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[324.075447] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[324.170010] [130/155] (691s left) gem_exec_nop (basic-series)
[324.215098] Starting subtest: basic-series
[327.505530] Subtest basic-series: SUCCESS (3.281s)
[327.718161] [131/155] (687s left) kms_psr (pr-cursor-mmap-gtt)
[327.810075] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[327.851403] [132/155] (687s left) kms_psr (pr-dpms)
[327.941050] Subtest pr-dpms: SKIP (0.000s)
[327.985842] [133/155] (687s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[328.075507] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[328.076937] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SKIP (0.000s)
[328.154115] [134/155] (687s left) gem_exec_schedule (preempt-user)
[328.202339] Starting subtest: preempt-user
[328.203078] Starting dynamic subtest: rcs0
[328.221813] Dynamic subtest rcs0: SUCCESS (0.020s)
[328.232457] Starting dynamic subtest: bcs0
[328.241568] Dynamic subtest bcs0: SUCCESS (0.019s)
[328.252032] Starting dynamic subtest: vcs0
[328.261073] Dynamic subtest vcs0: SUCCESS (0.018s)
[328.272141] Starting dynamic subtest: vcs1
[328.281910] Dynamic subtest vcs1: SUCCESS (0.020s)
[328.292198] Starting dynamic subtest: vecs0
[328.303699] Dynamic subtest vecs0: SUCCESS (0.020s)
[328.305904] Subtest preempt-user: SUCCESS (0.103s)
[328.604907] [135/155] (687s left) prime_mmap (test_dup)
[328.638117] Starting subtest: test_dup
[328.638822] Starting dynamic subtest: test_dup-smem
[328.640664] Dynamic subtest test_dup-smem: SUCCESS (0.002s)
[328.641364] Subtest test_dup: SUCCESS (0.003s)
[328.730745] [136/155] (687s left) kms_pm_dc (dc6-dpms)
[329.828548] Starting subtest: dc6-dpms
[333.207736] Subtest dc6-dpms: FAIL (3.365s)
[333.313918] [137/155] (682s left) kms_plane (pixel-format-y-tiled-modifier)
[333.413679] Starting subtest: pixel-format-y-tiled-modifier
[333.431066] Starting dynamic subtest: pipe-A-plane-0
[333.706015] Dynamic subtest pipe-A-plane-0: SUCCESS (0.275s)
[333.721223] Starting dynamic subtest: pipe-A-plane-3
[333.947688] Dynamic subtest pipe-A-plane-3: SUCCESS (0.238s)
[333.963807] Starting dynamic subtest: pipe-A-plane-5
[334.181070] Dynamic subtest pipe-A-plane-5: SUCCESS (0.230s)
[334.198343] Starting dynamic subtest: pipe-A-plane-7
[334.199728] Dynamic subtest pipe-A-plane-7: SKIP (0.000s)
[334.347288] Starting dynamic subtest: pipe-B-plane-0
[334.589011] Dynamic subtest pipe-B-plane-0: SUCCESS (0.249s)
[334.602160] Starting dynamic subtest: pipe-B-plane-3
[334.839318] Dynamic subtest pipe-B-plane-3: SUCCESS (0.249s)
[334.853896] Starting dynamic subtest: pipe-B-plane-5
[335.072783] Dynamic subtest pipe-B-plane-5: SUCCESS (0.231s)
[335.089374] Starting dynamic subtest: pipe-B-plane-7
[335.090752] Dynamic subtest pipe-B-plane-7: SKIP (0.000s)
[335.145223] Subtest pixel-format-y-tiled-modifier: SUCCESS (1.732s)
[335.319491] [138/155] (680s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[335.418367] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[335.428011] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.009s)
[335.507140] [139/155] (680s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt)
[335.600772] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt
[335.602220] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[335.713161] [140/155] (680s left) gem_softpin (evict-snoop)
[335.753298] Starting subtest: evict-snoop
[335.754779] Subtest evict-snoop: SKIP (0.000s)
[335.839173] [141/155] (680s left) kms_color (ctm-green-to-red)
[335.929673] Starting subtest: ctm-green-to-red
[335.930392] Starting dynamic subtest: pipe-A-HDMI-A-1
[336.239270] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.309s)
[336.248352] Starting dynamic subtest: pipe-B-HDMI-A-1
[336.535514] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.296s)
[336.546693] Starting dynamic subtest: pipe-C-HDMI-A-1
[336.837649] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.300s)
[336.849122] Starting dynamic subtest: pipe-D-HDMI-A-1
[337.155179] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.314s)
[337.155912] Subtest ctm-green-to-red: SUCCESS (1.224s)
[337.318680] [142/155] (678s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[337.416850] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[337.418264] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[337.510154] [143/155] (678s left) gem_exec_flush (basic-batch-kernel-default-wb)
[337.552382] Starting subtest: basic-batch-kernel-default-wb
[343.144326] Subtest basic-batch-kernel-default-wb: SUCCESS (5.591s)
[343.329657] [144/155] (672s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[343.423525] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[343.424245] Starting dynamic subtest: pipe-A-HDMI-A-1
[343.431035] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[343.439765] Starting dynamic subtest: pipe-B-HDMI-A-1
[343.446604] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[343.455073] Starting dynamic subtest: pipe-C-HDMI-A-1
[343.461798] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[343.470158] Starting dynamic subtest: pipe-D-HDMI-A-1
[343.477167] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[343.478635] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[343.689352] [145/155] (672s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[343.729630] Starting subtest: invalid-single-wait-all-unsubmitted
[343.730371] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[343.804609] [146/155] (672s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[343.900716] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[343.902255] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[343.986943] [147/155] (672s left) syncobj_wait (wait-for-submit-delayed-submit)
[344.022519] Starting subtest: wait-for-submit-delayed-submit
[344.124454] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[344.203212] [148/155] (672s left) drm_read (invalid-buffer)
[344.319038] Starting subtest: invalid-buffer
[344.319829] Subtest invalid-buffer: SUCCESS (0.000s)
[344.429452] [149/155] (671s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-linear)
[344.524811] Starting subtest: fbcpsrhdr-tiling-linear
[344.526250] Subtest fbcpsrhdr-tiling-linear: SKIP (0.000s)
[344.625039] [150/155] (671s left) kms_setmode (invalid-clone-single-crtc-stealing)
[344.660886] Starting subtest: invalid-clone-single-crtc-stealing
[344.663016] Subtest invalid-clone-single-crtc-stealing: SKIP (0.001s)
[344.727727] [151/155] (671s left) sysfs_timeslice_duration (duration)
[344.765351] Starting subtest: duration
[344.767264] Starting dynamic subtest: vecs0
[344.830501] Dynamic subtest vecs0: SUCCESS (0.064s)
[344.850090] Starting dynamic subtest: vcs0
[344.901325] Dynamic subtest vcs0: SUCCESS (0.067s)
[344.919967] Starting dynamic subtest: bcs0
[344.977620] Dynamic subtest bcs0: SUCCESS (0.072s)
[344.998073] Starting dynamic subtest: rcs0
[345.062304] Dynamic subtest rcs0: SUCCESS (0.081s)
[345.083158] Starting dynamic subtest: vcs1
[345.132146] Dynamic subtest vcs1: SUCCESS (0.066s)
[345.136434] Subtest duration: SUCCESS (0.368s)
[345.227233] [152/155] (671s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[345.316674] Starting subtest: flip-vs-cursor-crc-atomic
[345.626021] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.309s)
[345.797034] [153/155] (670s left) perf_pmu (idle-no-semaphores)
[345.837380] Starting subtest: idle-no-semaphores
[345.838227] Starting dynamic subtest: rcs0
[346.359938] Dynamic subtest rcs0: SUCCESS (0.522s)
[346.373301] Starting dynamic subtest: bcs0
[346.884492] Dynamic subtest bcs0: SUCCESS (0.513s)
[346.896055] Starting dynamic subtest: vcs0
[347.400262] Dynamic subtest vcs0: SUCCESS (0.513s)
[347.411990] Starting dynamic subtest: vcs1
[347.916337] Dynamic subtest vcs1: SUCCESS (0.513s)
[347.935023] Starting dynamic subtest: vecs0
[348.433389] Dynamic subtest vecs0: SUCCESS (0.514s)
[348.434646] Subtest idle-no-semaphores: SUCCESS (2.589s)
[348.498084] [154/155] (668s left) kms_properties (plane-properties-atomic)
[348.591412] Starting subtest: plane-properties-atomic
[348.593430] Starting dynamic subtest: pipe-A-HDMI-A-1
[348.833448] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.240s)
[348.843205] Starting dynamic subtest: pipe-B-HDMI-A-1
[349.121681] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.286s)
[349.130567] Starting dynamic subtest: pipe-C-HDMI-A-1
[349.416342] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.294s)
[349.428764] Starting dynamic subtest: pipe-D-HDMI-A-1
[349.688894] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.270s)
[349.689750] Subtest plane-properties-atomic: SUCCESS (1.098s)
[349.861585] [155/155] (666s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-shrfb-msflip-blt)
[349.965760] Starting subtest: psrhdr-2p-primscrn-shrfb-msflip-blt
[349.967185] Subtest psrhdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[350.070805] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_content_protection
results: parsing output: 2/ for test: kms_flip
results: parsing output: 3/ for test: i915_pm_rc6_residency
results: parsing output: 4/ for test: kms_plane_alpha_blend
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: kms_vblank
results: parsing output: 7/ for test: perf_pmu
results: parsing output: 8/ for test: gem_exec_reloc
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_pm_backlight
results: parsing output: 12/ for test: gem_mmap_wc
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_flip
results: parsing output: 15/ for test: gem_vm_create
results: parsing output: 16/ for test: syncobj_basic
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_cursor_crc
results: parsing output: 22/ for test: kms_joiner
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: gem_exec_parallel
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_lease
results: parsing output: 28/ for test: gem_exec_params
results: parsing output: 29/ for test: kms_psr
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: api_intel_bb
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_lmem_swapping
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_pread
results: parsing output: 38/ for test: prime_mmap
results: parsing output: 39/ for test: sw_sync
results: parsing output: 40/ for test: kms_flip_scaled_crc
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: prime_mmap
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: i915_drm_fdinfo
results: parsing output: 45/ for test: kms_rotation_crc
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: gem_mmap_offset
results: parsing output: 50/ for test: kms_chamelium_color
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_feature_discovery
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_userptr_blits
results: parsing output: 57/ for test: i915_fb_tiling
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: gem_exec_store
results: parsing output: 60/ for test: kms_cursor_crc
results: parsing output: 61/ for test: api_intel_allocator
results: parsing output: 62/ for test: gem_ctx_engines
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: kms_psr2_sf
results: parsing output: 66/ for test: kms_chamelium_hpd
results: parsing output: 67/ for test: gem_lmem_swapping
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_exec_schedule
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: kms_cursor_crc
results: parsing output: 73/ for test: gem_exec_balancer
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: gem_softpin
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_psr2_sf
results: parsing output: 79/ for test: gem_render_copy
results: parsing output: 80/ for test: gen9_exec_parse
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_cursor_legacy
results: parsing output: 83/ for test: gem_exec_balancer
results: parsing output: 84/ for test: kms_cursor_legacy
results: parsing output: 85/ for test: gem_ctx_param
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_addfb_basic
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: perf
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: gem_ctx_persistence
results: parsing output: 97/ for test: gem_softpin
results: parsing output: 98/ for test: gem_exec_fence
results: parsing output: 99/ for test: kms_dp_link_training
results: parsing output: 100/ for test: kms_addfb_basic
results: parsing output: 101/ for test: kms_rotation_crc
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: kms_atomic_transition
results: parsing output: 104/ for test: prime_vgem
results: parsing output: 105/ for test: sw_sync
results: parsing output: 106/ for test: gem_eio
results: parsing output: 107/ for test: kms_chamelium_edid
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_render_copy
results: parsing output: 110/ for test: gem_ctx_param
results: parsing output: 111/ for test: kms_vblank
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: kms_flip
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_sync
results: parsing output: 116/ for test: gem_busy
results: parsing output: 117/ for test: gem_spin_batch
results: parsing output: 118/ for test: i915_selftest
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: gem_ctx_shared
results: parsing output: 121/ for test: kms_hdr
results: parsing output: 122/ for test: core_sysfs
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: kms_plane_scaling
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_rotation_crc
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_exec_nop
results: parsing output: 130/ for test: kms_psr
results: parsing output: 131/ for test: kms_psr
results: parsing output: 132/ for test: kms_plane
results: parsing output: 133/ for test: gem_exec_schedule
results: parsing output: 134/ for test: prime_mmap
results: parsing output: 135/ for test: kms_pm_dc
results: parsing output: 136/ for test: kms_plane
results: parsing output: 137/ for test: kms_flip
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: gem_softpin
results: parsing output: 140/ for test: kms_color
results: parsing output: 141/ for test: kms_frontbuffer_tracking
results: parsing output: 142/ for test: gem_exec_flush
results: parsing output: 143/ for test: kms_ccs
results: parsing output: 144/ for test: syncobj_timeline
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: syncobj_wait
results: parsing output: 147/ for test: drm_read
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: kms_setmode
results: parsing output: 150/ for test: sysfs_timeslice_duration
results: parsing output: 151/ for test: kms_cursor_legacy
results: parsing output: 152/ for test: perf_pmu
results: parsing output: 153/ for test: kms_properties
results: parsing output: 154/ for test: kms_frontbuffer_tracking
Done.