[69.992902] Initializing watchdogs
[69.992983]   /dev/watchdog0
[70.023931] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[70.039225] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[70.044400] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[70.048166] [001/155] (960s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[71.565248] Starting subtest: fbc-1p-pri-indfb-multidraw
[80.500577] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (8.941s)
[80.679222] [002/155] (949s left) kms_content_protection (lic-type-0-hdcp14)
[82.231860] Starting subtest: lic-type-0-hdcp14
[82.238076] Subtest lic-type-0-hdcp14: SKIP (0.002s)
[82.418310] [003/155] (948s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[83.917153] Starting subtest: flip-vs-dpms-on-nop-interruptible
[83.925301] Starting dynamic subtest: A-HDMI-A4
[84.978064] Dynamic subtest A-HDMI-A4: SUCCESS (1.053s)
[84.989773] Starting dynamic subtest: B-HDMI-A4
[85.959052] Dynamic subtest B-HDMI-A4: SUCCESS (0.980s)
[85.969283] Starting dynamic subtest: C-HDMI-A4
[86.958205] Dynamic subtest C-HDMI-A4: SUCCESS (0.997s)
[86.971726] Starting dynamic subtest: D-HDMI-A4
[87.940148] Dynamic subtest D-HDMI-A4: SUCCESS (0.979s)
[87.941664] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (4.024s)
[88.182251] [004/155] (942s left) i915_pm_rc6_residency (rc6-accuracy)
[88.231328] Starting subtest: rc6-accuracy
[88.233073] Starting dynamic subtest: gt0
[91.407222] Dynamic subtest gt0: SUCCESS (3.171s)
[91.409104] Subtest rc6-accuracy: SUCCESS (3.173s)
[91.519110] [005/155] (939s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[93.010727] Starting subtest: coverage-vs-premult-vs-constant
[93.281463] Starting dynamic subtest: pipe-A-HDMI-A-4
[93.738827] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.456s)
[93.748746] Starting dynamic subtest: pipe-D-HDMI-A-4
[94.190222] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.450s)
[94.191841] Subtest coverage-vs-premult-vs-constant: SUCCESS (1.180s)
[94.402788] [006/155] (936s left) kms_big_fb (linear-32bpp-rotate-270)
[95.930122] Starting subtest: linear-32bpp-rotate-270
[96.037035] Subtest linear-32bpp-rotate-270: SKIP (0.105s)
[96.172199] [007/155] (934s left) kms_vblank (wait-idle-hang)
[97.663993] Starting subtest: wait-idle-hang
[97.665518] Starting dynamic subtest: pipe-A-HDMI-A-4
[124.450932] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (26.786s)
[124.463766] Starting dynamic subtest: pipe-D-HDMI-A-4
[149.457384] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (25.002s)
[149.459274] Subtest wait-idle-hang: SUCCESS (51.795s)
[149.651785] [008/155] (881s left) perf_pmu (interrupts)
[149.711748] Starting subtest: interrupts
[150.892895] Subtest interrupts: SUCCESS (1.178s)
[151.090526] [FACT perf_pmu (interrupts)] new: kernel.kmod_is_loaded.vgem: true
[151.093076] [009/155] (880s left) gem_exec_reloc (basic-write-cpu-noreloc)
[151.146408] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[151.266718] [010/155] (879s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[152.764820] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[152.767648] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[152.920142] [011/155] (878s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[154.426364] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[154.429117] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[154.611695] [012/155] (876s left) kms_pm_backlight (fade)
[156.102830] Subtest fade: SKIP (0.000s)
[156.183673] [013/155] (875s left) gem_mmap_wc (write-cpu-read-wc)
[156.233166] Subtest write-cpu-read-wc: SKIP (0.000s)
[156.317785] [014/155] (875s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[157.817246] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[157.820886] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[157.970707] [015/155] (873s left) kms_flip (absolute-wf_vblank-interruptible)
[159.477148] Starting subtest: absolute-wf_vblank-interruptible
[159.485167] Starting dynamic subtest: A-HDMI-A4
[167.220446] Dynamic subtest A-HDMI-A4: SUCCESS (7.735s)
[167.234198] Starting dynamic subtest: B-HDMI-A4
[174.901779] Dynamic subtest B-HDMI-A4: SUCCESS (7.681s)
[174.913249] Starting dynamic subtest: C-HDMI-A4
[182.586490] Dynamic subtest C-HDMI-A4: SUCCESS (7.684s)
[182.598799] Starting dynamic subtest: D-HDMI-A4
[190.438582] Dynamic subtest D-HDMI-A4: SUCCESS (7.851s)
[190.439921] Subtest absolute-wf_vblank-interruptible: SUCCESS (30.962s)
[190.659523] [016/155] (841s left) gem_vm_create (invalid-create)
[190.713217] Starting subtest: invalid-create
[190.716128] Subtest invalid-create: SUCCESS (0.002s)
[190.861792] [017/155] (840s left) syncobj_basic (bad-fd-to-handle)
[190.908049] Starting subtest: bad-fd-to-handle
[190.909597] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[191.010663] [018/155] (840s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-mmap-wc)
[192.529952] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-mmap-wc
[192.532984] Subtest hdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[192.707441] [019/155] (839s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[194.206877] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[194.209812] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[194.469317] [020/155] (837s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[195.967723] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[195.970858] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[196.135709] [021/155] (836s left) kms_frontbuffer_tracking (hdr-2p-pri-indfb-multidraw)
[197.636981] Starting subtest: hdr-2p-pri-indfb-multidraw
[197.639999] Subtest hdr-2p-pri-indfb-multidraw: SKIP (0.000s)
[197.801590] [022/155] (834s left) kms_cursor_crc (cursor-sliding-256x256)
[199.525154] Starting subtest: cursor-sliding-256x256
[199.531829] Starting dynamic subtest: pipe-A-HDMI-A-4
[203.917250] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (4.386s)
[203.950472] Starting dynamic subtest: pipe-D-HDMI-A-4
[208.243544] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (4.303s)
[208.245169] Subtest cursor-sliding-256x256: SUCCESS (8.718s)
[208.652526] [023/155] (823s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[210.148134] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[210.151209] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[210.262504] [024/155] (822s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[211.771716] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[211.774842] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[211.952022] [025/155] (820s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[213.443384] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[213.444924] Starting dynamic subtest: pipe-A-HDMI-A-4
[213.460158] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s)
[213.471483] Starting dynamic subtest: pipe-B-HDMI-A-4
[213.486863] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s)
[213.497829] Starting dynamic subtest: pipe-C-HDMI-A-4
[213.513498] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s)
[213.524501] Starting dynamic subtest: pipe-D-HDMI-A-4
[213.541998] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s)
[213.545544] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[213.748491] [026/155] (819s left) gem_exec_parallel (fds)
[213.806404] Starting subtest: fds
[213.807767] Starting dynamic subtest: rcs0
[216.882366] Dynamic subtest rcs0: SUCCESS (3.072s)
[216.893571] Starting dynamic subtest: bcs0
[219.973798] Dynamic subtest bcs0: SUCCESS (3.091s)
[219.985863] Starting dynamic subtest: vcs0
[223.704646] Dynamic subtest vcs0: SUCCESS (3.730s)
[223.716924] Starting dynamic subtest: vcs1
[228.250572] Dynamic subtest vcs1: SUCCESS (4.546s)
[228.261874] Starting dynamic subtest: vecs0
[231.193047] Dynamic subtest vecs0: SUCCESS (2.942s)
[231.194766] Subtest fds: SUCCESS (17.384s)
[231.463767] [027/155] (801s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[232.962803] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[232.965426] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[233.165546] [028/155] (799s left) kms_lease (lessee-list)
[234.664680] Starting subtest: lessee-list
[234.666305] Starting dynamic subtest: pipe-A-HDMI-A-4
[234.668054] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.002s)
[234.680677] Starting dynamic subtest: pipe-B-HDMI-A-4
[234.682294] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.001s)
[234.694308] Starting dynamic subtest: pipe-C-HDMI-A-4
[234.696738] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.001s)
[234.708582] Starting dynamic subtest: pipe-D-HDMI-A-4
[234.710518] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.001s)
[234.712403] Subtest lessee-list: SUCCESS (0.011s)
[234.897042] [029/155] (798s left) gem_exec_params (mmapped)
[234.948979] Starting subtest: mmapped
[234.951856] Subtest mmapped: SUCCESS (0.003s)
[235.139555] [030/155] (798s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[236.632049] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s)
[236.716607] [031/155] (796s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[238.228707] Starting subtest: yf-tiled-addfb-size-overflow
[238.232252] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[238.385510] [032/155] (794s left) api_intel_bb (destroy-bb)
[238.436716] Starting subtest: destroy-bb
[238.464701] Subtest destroy-bb: SUCCESS (0.027s)
[238.665572] [033/155] (794s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[240.164882] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[240.168091] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[240.351597] [034/155] (793s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[241.858375] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[244.088058] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (2.234s)
[244.258130] [035/155] (789s left) kms_frontbuffer_tracking (fbchdr-2p-shrfb-fliptrack-mmap-gtt)
[245.756374] Starting subtest: fbchdr-2p-shrfb-fliptrack-mmap-gtt
[245.759590] Subtest fbchdr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[245.934639] [036/155] (787s left) gem_lmem_swapping (random)
[250.260920] Starting subtest: random
[250.262236] Starting dynamic subtest: lmem0
[251.464455] Dynamic subtest lmem0: SUCCESS (1.200s)
[251.465831] Subtest random: SUCCESS (1.201s)
[254.130396] [FACT gem_lmem_swapping (random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[254.131527] [FACT gem_lmem_swapping (random)] deleted: kernel.kmod_is_loaded.i915: true
[254.134220] [037/155] (779s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-blt)
[258.965939] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-blt
[258.968892] Subtest fbchdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[259.176089] [FACT kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-blt)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[259.179604] [FACT kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-blt)] new: kernel.kmod_is_loaded.i915: true
[259.186795] [038/155] (774s left) gem_pread (exhaustion)
[259.238861] Subtest exhaustion: SKIP (0.000s)
[259.332318] [039/155] (774s left) prime_mmap (test_forked_cpu_write)
[259.378949] Starting subtest: test_forked_cpu_write
[259.380564] Starting dynamic subtest: test_forked_cpu_write-smem
[259.389404] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.011s)
[259.400438] Starting dynamic subtest: test_forked_cpu_write-lmem0
[259.403986] Dynamic subtest test_forked_cpu_write-lmem0: SUCCESS (0.012s)
[259.405926] Subtest test_forked_cpu_write: SUCCESS (0.025s)
[259.534617] [040/155] (774s left) sw_sync (sync_busy_fork)
[259.581045] Starting subtest: sync_busy_fork
[260.599900] Subtest sync_busy_fork: SUCCESS (1.016s)
[260.685506] [041/155] (773s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[262.173721] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[262.175381] Starting dynamic subtest: pipe-A-valid-mode
[263.532611] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.356s)
[263.534503] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SUCCESS (1.358s)
[263.744372] [042/155] (770s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[265.245685] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[265.249158] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[265.432277] [043/155] (768s left) prime_mmap (test_reprime)
[265.491159] Starting subtest: test_reprime
[265.492834] Starting dynamic subtest: test_reprime-smem
[265.543312] Dynamic subtest test_reprime-smem: SUCCESS (0.063s)
[265.554099] Starting dynamic subtest: test_reprime-lmem0
[265.608208] Dynamic subtest test_reprime-lmem0: SUCCESS (0.064s)
[265.609659] Subtest test_reprime: SUCCESS (0.129s)
[265.758150] [044/155] (768s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc)
[267.256223] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc
[267.258809] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[267.451749] [045/155] (767s left) i915_drm_fdinfo (virtual-busy-all)
[267.507416] Starting subtest: virtual-busy-all
[267.510316] Subtest virtual-busy-all: SKIP (0.000s)
[267.654203] [046/155] (767s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[269.143900] Starting subtest: primary-yf-tiled-reflect-x-180
[269.244866] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.100s)
[269.457187] [047/155] (765s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[270.967107] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[270.969808] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[271.204680] [048/155] (763s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[272.695108] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[272.696952] Starting dynamic subtest: pipe-A-HDMI-A-4
[272.713189] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.002s)
[272.725110] Starting dynamic subtest: pipe-B-HDMI-A-4
[272.741790] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.002s)
[272.753110] Starting dynamic subtest: pipe-C-HDMI-A-4
[272.778336] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.002s)
[272.788998] Starting dynamic subtest: pipe-D-HDMI-A-4
[272.803846] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.002s)
[272.805506] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SUCCESS (0.015s)
[273.002472] [049/155] (762s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-onoff)
[274.501827] Starting subtest: fbchdr-2p-primscrn-spr-indfb-onoff
[274.504903] Subtest fbchdr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[274.658075] [050/155] (760s left) gem_mmap_offset (basic-uaf)
[274.709656] Starting subtest: basic-uaf
[274.711166] Subtest basic-uaf: SUCCESS (0.001s)
[274.862698] [051/155] (760s left) kms_chamelium_color (ctm-0-50)
[276.355132] Subtest ctm-0-50: SKIP (0.000s)
[276.436722] [052/155] (758s left) syncobj_timeline (multi-wait-signaled)
[276.487335] Starting subtest: multi-wait-signaled
[276.488979] Subtest multi-wait-signaled: SUCCESS (0.001s)
[276.595414] [053/155] (758s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-pwrite)
[278.093881] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-pwrite
[278.096768] Subtest hdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[278.273431] [054/155] (757s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[279.774224] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[279.777301] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[279.967896] [055/155] (755s left) kms_feature_discovery (dp-mst)
[281.459741] Starting subtest: dp-mst
[281.462477] Subtest dp-mst: SKIP (0.000s)
[281.589145] [056/155] (754s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[283.101324] Starting subtest: pipe-fbc-rte
[283.113227] Subtest pipe-fbc-rte: SKIP (0.000s)
[283.306747] [057/155] (752s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[283.375373] Starting subtest: map-fixed-invalidate-overlap
[283.377980] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[283.591824] [058/155] (752s left) i915_fb_tiling (basic-x-tiling)
[283.646444] Subtest basic-x-tiling: SKIP (0.000s)
[283.719906] [059/155] (752s left) kms_psr (psr2-primary-mmap-cpu)
[285.210350] Subtest psr2-primary-mmap-cpu: SKIP (0.000s)
[285.287340] [060/155] (750s left) gem_exec_store (pages)
[285.347229] Starting subtest: pages
[285.348609] Starting dynamic subtest: rcs0
[285.484411] Dynamic subtest rcs0: SUCCESS (0.137s)
[285.495902] Starting dynamic subtest: bcs0
[285.603558] Dynamic subtest bcs0: SUCCESS (0.118s)
[285.614859] Starting dynamic subtest: vcs0
[285.717630] Dynamic subtest vcs0: SUCCESS (0.113s)
[285.730011] Starting dynamic subtest: vcs1
[285.833688] Dynamic subtest vcs1: SUCCESS (0.115s)
[285.845125] Starting dynamic subtest: vecs0
[285.948650] Dynamic subtest vecs0: SUCCESS (0.114s)
[285.950315] Subtest pages: SUCCESS (0.602s)
[286.253387] [061/155] (749s left) kms_cursor_crc (cursor-sliding-max-size)
[288.063571] Starting subtest: cursor-sliding-max-size
[288.068208] Subtest cursor-sliding-max-size: SKIP (0.000s)
[288.283503] [062/155] (748s left) api_intel_allocator (simple-allocator)
[288.330730] Starting subtest: simple-allocator
[288.332342] Starting dynamic subtest: basic
[288.346823] Dynamic subtest basic: SUCCESS (0.017s)
[288.358771] Starting dynamic subtest: parallel-one
[288.547780] Dynamic subtest parallel-one: SUCCESS (0.197s)
[288.560033] Starting dynamic subtest: print
[288.561768] Dynamic subtest print: SUCCESS (0.000s)
[288.573967] Starting dynamic subtest: reuse
[288.575957] Dynamic subtest reuse: SUCCESS (0.000s)
[288.588021] Starting dynamic subtest: reserve
[288.589963] Dynamic subtest reserve: SUCCESS (0.000s)
[288.601277] Starting dynamic subtest: fork-reopen-allocator
[288.603219] Dynamic subtest fork-reopen-allocator: SUCCESS (0.016s)
[288.605067] Subtest simple-allocator: SUCCESS (0.236s)
[288.718418] [063/155] (747s left) gem_ctx_engines (invalid-engines)
[288.778711] Starting subtest: invalid-engines
[288.801642] Subtest invalid-engines: SUCCESS (0.023s)
[289.098303] [064/155] (747s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[289.147445] Starting subtest: etime-single-wait-available-unsubmitted
[289.256075] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.106s)
[289.433380] [065/155] (747s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[290.945288] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[291.524542] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.580s)
[291.771929] [066/155] (744s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[293.268118] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (0.000s)
[293.337499] [067/155] (743s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[294.885163] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[295.018431] [068/155] (741s left) gem_lmem_swapping (parallel-random)
[299.277720] Starting subtest: parallel-random
[299.279208] Starting dynamic subtest: lmem0
[329.002446] Dynamic subtest lmem0: SUCCESS (29.721s)
[329.004193] Subtest parallel-random: SUCCESS (29.722s)
[329.938975] [FACT gem_lmem_swapping (parallel-random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[329.940120] [FACT gem_lmem_swapping (parallel-random)] deleted: kernel.kmod_is_loaded.i915: true
[329.943244] [069/155] (706s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-pwrite)
[334.711834] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-pwrite
[334.715082] Subtest hdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[334.924334] [FACT kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-pwrite)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[334.927770] [FACT kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-pwrite)] new: kernel.kmod_is_loaded.i915: true
[334.935347] [070/155] (702s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[336.436716] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[336.439852] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[336.611974] [071/155] (700s left) gem_exec_schedule (preempt-hang)
[336.819953] Starting subtest: preempt-hang
[336.823038] Starting dynamic subtest: rcs0
[337.108392] Dynamic subtest rcs0: SUCCESS (0.289s)
[337.119710] Starting dynamic subtest: bcs0
[337.384439] Dynamic subtest bcs0: SUCCESS (0.275s)
[337.396236] Starting dynamic subtest: vcs0
[337.675104] Dynamic subtest vcs0: SUCCESS (0.290s)
[337.686925] Starting dynamic subtest: vcs1
[337.945620] Dynamic subtest vcs1: SUCCESS (0.270s)
[337.957571] Starting dynamic subtest: vecs0
[338.222257] Dynamic subtest vecs0: SUCCESS (0.275s)
[338.223886] Subtest preempt-hang: SUCCESS (1.406s)
[338.538772] [072/155] (698s left) kms_psr (fbc-pr-primary-mmap-cpu)
[340.030636] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[340.110446] [073/155] (697s left) kms_cursor_crc (cursor-offscreen-32x10)
[341.715052] Starting subtest: cursor-offscreen-32x10
[341.770941] Subtest cursor-offscreen-32x10: SKIP (0.052s)
[342.181849] [074/155] (695s left) gem_exec_balancer (parallel-bb-first)
[342.603461] Starting subtest: parallel-bb-first
[344.722349] Subtest parallel-bb-first: SUCCESS (2.119s)
[344.830208] [075/155] (692s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[346.320144] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[346.321911] Starting dynamic subtest: pipe-A-HDMI-A-4
[346.336333] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[346.348220] Starting dynamic subtest: pipe-B-HDMI-A-4
[346.361388] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[346.373433] Starting dynamic subtest: pipe-C-HDMI-A-4
[346.386797] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[346.398301] Starting dynamic subtest: pipe-D-HDMI-A-4
[346.413046] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[346.416216] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.009s)
[346.623744] [076/155] (690s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[346.674955] Starting subtest: single-wait-for-submit-available-signaled
[346.676600] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[346.790530] [077/155] (690s left) gem_softpin (noreloc-s3)
[346.869809] Starting subtest: noreloc-S3
[368.411656] Subtest noreloc-S3: SUCCESS (10.682s)
[375.633224] [078/155] (669s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[377.152103] Starting subtest: x-tiled-32bpp-rotate-0
[379.212055] Subtest x-tiled-32bpp-rotate-0: SUCCESS (2.056s)
[379.467950] [079/155] (665s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[380.964196] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[381.038457] [080/155] (663s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[381.095196] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[381.096902] Starting dynamic subtest: smem
[381.185808] Dynamic subtest smem: SUCCESS (0.092s)
[381.200457] Starting dynamic subtest: lmem0
[382.114165] Dynamic subtest lmem0: SUCCESS (0.924s)
[382.116248] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SUCCESS (1.019s)
[382.396443] [081/155] (662s left) gen9_exec_parse (allowed-single)
[382.454705] Subtest allowed-single: SKIP (0.000s)
[382.539930] [082/155] (662s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-move)
[384.039479] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-move
[384.042086] Subtest psrhdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[384.234588] [083/155] (660s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[385.746968] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[400.614114] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (14.867s)
[400.825365] [084/155] (644s left) gem_exec_balancer (sequential)
[400.886627] Starting subtest: sequential
[405.103128] Subtest sequential: SUCCESS (4.217s)
[405.576917] [085/155] (639s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[407.080068] Starting subtest: cursorB-vs-flipA-legacy
[407.083172] Subtest cursorB-vs-flipA-legacy: SKIP (0.002s)
[407.185678] [086/155] (638s left) gem_ctx_param (basic)
[407.242394] Starting subtest: basic
[407.244238] Subtest basic: SUCCESS (0.001s)
[407.371462] [087/155] (638s left) kms_frontbuffer_tracking (psrhdr-1p-rte)
[408.870700] Starting subtest: psrhdr-1p-rte
[408.873332] Subtest psrhdr-1p-rte: SKIP (0.000s)
[409.077745] [088/155] (636s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[410.621020] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[410.624625] Subtest psr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[410.779464] [089/155] (634s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[412.293292] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-mmap-gtt
[412.296745] Subtest fbchdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[412.473065] [090/155] (633s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-pgflip-blt)
[413.972431] Starting subtest: psrhdr-2p-scndscrn-shrfb-pgflip-blt
[413.975560] Subtest psrhdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[414.169314] [091/155] (631s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[415.670478] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[415.673678] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[415.868816] [092/155] (630s left) kms_addfb_basic (clobberred-modifier)
[415.918046] Starting subtest: clobberred-modifier
[415.921417] Subtest clobberred-modifier: SKIP (0.000s)
[417.540119] [093/155] (628s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-pwrite)
[419.040218] Starting subtest: fbcpsrhdr-rgb565-draw-pwrite
[419.043100] Subtest fbcpsrhdr-rgb565-draw-pwrite: SKIP (0.000s)
[419.223265] [094/155] (627s left) perf (gen12-group-exclusive-stream-ctx-handle)
[419.364276] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[419.396073] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.033s)
[419.560188] [095/155] (626s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-mmap-wc)
[421.061035] Starting subtest: fbchdr-rgb565-draw-mmap-wc
[421.063828] Subtest fbchdr-rgb565-draw-mmap-wc: SKIP (0.000s)
[421.240388] [096/155] (625s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[421.293149] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[421.397366] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.104s)
[421.617619] [097/155] (625s left) gem_ctx_persistence (processes)
[421.672686] Starting subtest: processes
[423.706355] Subtest processes: SUCCESS (2.034s)
[423.885046] [098/155] (622s left) gem_softpin (overlap)
[423.964056] Starting subtest: overlap
[427.720689] Subtest overlap: SUCCESS (3.754s)
[427.882082] [099/155] (618s left) gem_exec_fence (nb-await)
[428.057310] Starting subtest: nb-await
[428.058819] Starting dynamic subtest: rcs0
[428.141224] Dynamic subtest rcs0: SUCCESS (0.083s)
[428.159275] Starting dynamic subtest: bcs0
[428.207104] Dynamic subtest bcs0: SUCCESS (0.064s)
[428.249313] Starting dynamic subtest: vcs0
[428.288696] Dynamic subtest vcs0: SUCCESS (0.078s)
[428.324087] Starting dynamic subtest: vcs1
[428.364595] Dynamic subtest vcs1: SUCCESS (0.073s)
[428.399831] Starting dynamic subtest: vecs0
[428.441448] Dynamic subtest vecs0: SUCCESS (0.073s)
[428.443366] Subtest nb-await: SUCCESS (0.385s)
[429.198767] [100/155] (617s left) kms_dp_link_training (non-uhbr-sst)
[430.691024] Starting subtest: non-uhbr-sst
[430.697052] Subtest non-uhbr-sst: SKIP (0.000s)
[430.838621] [101/155] (616s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[432.345953] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[432.538752] [102/155] (614s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[434.028451] Starting subtest: sprite-rotation-90-pos-100-0
[444.489754] Subtest sprite-rotation-90-pos-100-0: SUCCESS (10.461s)
[444.807279] [103/155] (602s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[446.302982] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[446.306038] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[446.527597] [104/155] (600s left) kms_atomic_transition (modeset-transition-nonblocking)
[448.021893] Starting subtest: modeset-transition-nonblocking
[448.023381] Starting dynamic subtest: 1x-outputs
[450.154126] Dynamic subtest 1x-outputs: SUCCESS (2.129s)
[450.155689] Subtest modeset-transition-nonblocking: SUCCESS (2.134s)
[450.360907] [105/155] (597s left) prime_vgem (coherency-blt)
[450.423979] Starting subtest: coherency-blt
[453.111633] Subtest coherency-blt: SUCCESS (2.684s)
[453.276477] [106/155] (594s left) sw_sync (alloc_fence)
[453.327419] Starting subtest: alloc_fence
[453.329197] Subtest alloc_fence: SUCCESS (0.000s)
[453.427945] [107/155] (594s left) gem_eio (in-flight-internal-10ms)
[453.623837] Starting subtest: in-flight-internal-10ms
[454.737208] Subtest in-flight-internal-10ms: SUCCESS (1.115s)
[456.349173] [108/155] (591s left) kms_chamelium_edid (hdmi-mode-timings)
[457.892337] Subtest hdmi-mode-timings: SKIP (0.000s)
[458.027120] [109/155] (589s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[459.528050] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[459.531564] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[459.712541] [110/155] (588s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[459.768120] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[459.769580] Starting dynamic subtest: smem
[459.879485] Dynamic subtest smem: SUCCESS (0.108s)
[459.894510] Starting dynamic subtest: lmem0
[460.826871] Dynamic subtest lmem0: SUCCESS (0.945s)
[460.828557] Subtest mixed-tiled-to-yf-tiled-ccs: SUCCESS (1.056s)
[461.112246] [111/155] (586s left) gem_ctx_param (vm)
[461.160668] Starting subtest: vm
[461.226746] Subtest vm: SUCCESS (0.068s)
[461.454100] [112/155] (586s left) kms_vblank (query-forked-hang)
[462.951480] Starting subtest: query-forked-hang
[462.956007] Starting dynamic subtest: pipe-A-HDMI-A-4
[465.346634] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.391s)
[465.364335] Starting dynamic subtest: pipe-D-HDMI-A-4
[467.620644] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.271s)
[467.622202] Subtest query-forked-hang: SUCCESS (4.670s)
[467.854577] [113/155] (580s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[469.353243] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[469.372215] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.017s)
[469.518976] [114/155] (578s left) kms_flip (nonblocking-read)
[471.011479] Starting subtest: nonblocking-read
[471.013032] Subtest nonblocking-read: SUCCESS (0.000s)
[471.163146] [115/155] (577s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[472.672932] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[472.675713] Subtest psr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[472.856007] [116/155] (575s left) gem_sync (basic-all)
[472.919232] Starting subtest: basic-all
[475.403437] Subtest basic-all: SUCCESS (2.486s)
[475.627902] [117/155] (572s left) gem_busy (semaphore)
[475.882265] Subtest semaphore: SKIP (0.000s)
[476.289488] [118/155] (572s left) gem_spin_batch (legacy)
[476.347566] Starting subtest: legacy
[476.349260] Starting dynamic subtest: default
[479.602939] Dynamic subtest default: SUCCESS (3.247s)
[479.626073] Starting dynamic subtest: render
[482.844989] Dynamic subtest render: SUCCESS (3.234s)
[482.860572] Starting dynamic subtest: bsd
[486.079202] Dynamic subtest bsd: SUCCESS (3.227s)
[486.099232] Starting dynamic subtest: bsd1
[489.320351] Dynamic subtest bsd1: SUCCESS (3.233s)
[489.338492] Starting dynamic subtest: bsd2
[492.559705] Dynamic subtest bsd2: SUCCESS (3.232s)
[492.579902] Starting dynamic subtest: blt
[495.801423] Dynamic subtest blt: SUCCESS (3.233s)
[495.821270] Starting dynamic subtest: vebox
[499.040869] Dynamic subtest vebox: SUCCESS (3.232s)
[499.042811] Subtest legacy: SUCCESS (22.692s)
[499.276755] [119/155] (549s left) i915_selftest (mock)
[500.283897] Starting subtest: mock
[500.285478] Starting dynamic subtest: sanitycheck
[501.062582] Dynamic subtest sanitycheck: SUCCESS (0.777s)
[501.104250] Starting dynamic subtest: shmem
[501.907571] Dynamic subtest shmem: SUCCESS (0.837s)
[501.949851] Starting dynamic subtest: fence
[509.838451] Dynamic subtest fence: SUCCESS (7.924s)
[509.853423] Starting dynamic subtest: scatterlist
[511.626107] Dynamic subtest scatterlist: SUCCESS (1.784s)
[511.648838] Starting dynamic subtest: syncmap
[514.401175] Dynamic subtest syncmap: SUCCESS (2.767s)
[514.423786] Starting dynamic subtest: uncore
[515.191494] Dynamic subtest uncore: SUCCESS (0.783s)
[515.234413] Starting dynamic subtest: ring
[515.999348] Dynamic subtest ring: SUCCESS (0.800s)
[516.040338] Starting dynamic subtest: engine
[516.835987] Dynamic subtest engine: SUCCESS (0.829s)
[516.872089] Starting dynamic subtest: timelines
[522.118500] Dynamic subtest timelines: SUCCESS (5.276s)
[522.131582] Starting dynamic subtest: requests
[524.882574] Dynamic subtest requests: SUCCESS (2.762s)
[524.894139] Starting dynamic subtest: objects
[525.780567] Dynamic subtest objects: SUCCESS (0.896s)
[525.793483] Starting dynamic subtest: phys
[526.702761] Dynamic subtest phys: SUCCESS (0.921s)
[526.714533] Starting dynamic subtest: dmabuf
[527.630644] Dynamic subtest dmabuf: SUCCESS (0.926s)
[527.643760] Starting dynamic subtest: vma
[538.013859] Dynamic subtest vma: SUCCESS (10.382s)
[538.026023] Starting dynamic subtest: evict
[539.998748] Dynamic subtest evict: SUCCESS (1.983s)
[540.012529] Starting dynamic subtest: gtt
[543.847782] Dynamic subtest gtt: SUCCESS (3.847s)
[543.860335] Starting dynamic subtest: hugepages
[544.991792] Dynamic subtest hugepages: SUCCESS (1.142s)
[545.004448] Starting dynamic subtest: memory_region
[549.126796] Dynamic subtest memory_region: SUCCESS (4.134s)
[549.128447] Subtest mock: SUCCESS (48.844s)
[549.172848] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[549.173984] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[549.177505] [120/155] (499s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[553.974725] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[553.978034] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[554.206154] [FACT kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[554.209446] [FACT kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)] new: kernel.kmod_is_loaded.i915: true
[554.216919] [121/155] (494s left) gem_ctx_shared (exec-single-timeline)
[554.288596] Starting subtest: exec-single-timeline
[554.290297] Starting dynamic subtest: rcs0
[555.387504] Dynamic subtest rcs0: SUCCESS (1.097s)
[555.403531] Starting dynamic subtest: bcs0
[556.406907] Dynamic subtest bcs0: SUCCESS (1.017s)
[556.420821] Starting dynamic subtest: vcs0
[557.430562] Dynamic subtest vcs0: SUCCESS (1.019s)
[557.444406] Starting dynamic subtest: vcs1
[558.454511] Dynamic subtest vcs1: SUCCESS (1.019s)
[558.468855] Starting dynamic subtest: vecs0
[559.478554] Dynamic subtest vecs0: SUCCESS (1.019s)
[559.479960] Subtest exec-single-timeline: SUCCESS (5.193s)
[559.758447] [122/155] (489s left) kms_hdr (invalid-hdr)
[561.249496] Starting subtest: invalid-hdr
[561.254052] Starting dynamic subtest: pipe-A-HDMI-A-4-XRGB2101010
[561.257461] Dynamic subtest pipe-A-HDMI-A-4-XRGB2101010: SKIP (0.000s)
[561.271900] Starting dynamic subtest: pipe-A-HDMI-A-4-XRGB16161616F
[561.275927] Dynamic subtest pipe-A-HDMI-A-4-XRGB16161616F: SKIP (0.000s)
[561.279655] Subtest invalid-hdr: SKIP (0.006s)
[561.379279] [123/155] (487s left) core_sysfs (read-all-entries)
[561.444560] Starting subtest: read-all-entries
[561.446460] Subtest read-all-entries: SUCCESS (0.005s)
[561.560930] [124/155] (487s left) kms_big_fb (x-tiled-addfb-size-overflow)
[563.071777] Starting subtest: x-tiled-addfb-size-overflow
[563.073084] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.002s)
[563.268389] [125/155] (486s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[564.763471] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[564.765193] Starting dynamic subtest: pipe-A
[567.468517] Dynamic subtest pipe-A: SUCCESS (2.705s)
[567.491931] Starting dynamic subtest: pipe-B
[570.026589] Dynamic subtest pipe-B: SUCCESS (2.556s)
[570.048584] Starting dynamic subtest: pipe-C
[570.350972] Dynamic subtest pipe-C: SUCCESS (0.323s)
[570.364447] Starting dynamic subtest: pipe-D
[570.659116] Dynamic subtest pipe-D: SUCCESS (0.306s)
[570.660924] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (5.898s)
[570.897145] [126/155] (478s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-move)
[572.443231] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-move
[572.446660] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[572.605555] [127/155] (476s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[574.108580] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[574.112129] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[574.265099] [128/155] (475s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[575.759471] Starting subtest: multiplane-rotation-cropping-bottom
[623.884198] Subtest multiplane-rotation-cropping-bottom: SUCCESS (48.125s)
[624.058130] [129/155] (425s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[625.567552] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[625.570777] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[625.738013] [130/155] (424s left) gem_exec_nop (basic-series)
[625.806350] Starting subtest: basic-series
[629.492087] Subtest basic-series: SUCCESS (3.690s)
[629.757166] [131/155] (420s left) kms_psr (pr-cursor-mmap-gtt)
[631.248469] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[631.381907] [132/155] (418s left) kms_psr (pr-dpms)
[632.891021] Subtest pr-dpms: SKIP (0.000s)
[632.966426] [133/155] (417s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[634.459281] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[634.462299] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SKIP (0.000s)
[634.571936] [134/155] (415s left) gem_exec_schedule (preempt-user)
[634.639499] Starting subtest: preempt-user
[634.641127] Starting dynamic subtest: rcs0
[634.705499] Dynamic subtest rcs0: SUCCESS (0.065s)
[634.720109] Starting dynamic subtest: bcs0
[634.752843] Dynamic subtest bcs0: SUCCESS (0.046s)
[634.766944] Starting dynamic subtest: vcs0
[634.798927] Dynamic subtest vcs0: SUCCESS (0.044s)
[634.813084] Starting dynamic subtest: vcs1
[634.844890] Dynamic subtest vcs1: SUCCESS (0.044s)
[634.858804] Starting dynamic subtest: vecs0
[634.890573] Dynamic subtest vecs0: SUCCESS (0.044s)
[634.892360] Subtest preempt-user: SUCCESS (0.252s)
[635.380121] [135/155] (414s left) prime_mmap (test_dup)
[635.436611] Starting subtest: test_dup
[635.438287] Starting dynamic subtest: test_dup-smem
[635.501074] Dynamic subtest test_dup-smem: SUCCESS (0.065s)
[635.514973] Starting dynamic subtest: test_dup-lmem0
[635.568361] Dynamic subtest test_dup-lmem0: SUCCESS (0.066s)
[635.570163] Subtest test_dup: SUCCESS (0.134s)
[635.684354] [136/155] (414s left) kms_pm_dc (dc6-dpms)
[638.188324] Starting subtest: dc6-dpms
[638.193783] Subtest dc6-dpms: SKIP (0.000s)
[638.313100] [137/155] (412s left) kms_plane (pixel-format-y-tiled-modifier)
[639.813530] Starting subtest: pixel-format-y-tiled-modifier
[639.849548] Starting dynamic subtest: pipe-A-plane-0
[640.566400] Dynamic subtest pipe-A-plane-0: SUCCESS (0.716s)
[640.610626] Starting dynamic subtest: pipe-A-plane-3
[641.049852] Dynamic subtest pipe-A-plane-3: SUCCESS (0.478s)
[641.068881] Starting dynamic subtest: pipe-A-plane-5
[641.550503] Dynamic subtest pipe-A-plane-5: SUCCESS (0.495s)
[641.597420] Starting dynamic subtest: pipe-A-plane-7
[641.600771] Dynamic subtest pipe-A-plane-7: SKIP (0.000s)
[641.731828] Starting dynamic subtest: pipe-B-plane-0
[642.236241] Dynamic subtest pipe-B-plane-0: SUCCESS (0.516s)
[642.271461] Starting dynamic subtest: pipe-B-plane-3
[642.736275] Dynamic subtest pipe-B-plane-3: SUCCESS (0.496s)
[642.776752] Starting dynamic subtest: pipe-B-plane-5
[643.219238] Dynamic subtest pipe-B-plane-5: SUCCESS (0.479s)
[643.258513] Starting dynamic subtest: pipe-B-plane-7
[643.261918] Dynamic subtest pipe-B-plane-7: SKIP (0.000s)
[643.291657] Subtest pixel-format-y-tiled-modifier: SUCCESS (3.478s)
[643.556357] [138/155] (406s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[645.054959] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[645.073269] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.017s)
[645.198631] [139/155] (405s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt)
[646.703593] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt
[646.706935] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[646.891429] [140/155] (403s left) gem_softpin (evict-snoop)
[646.949583] Starting subtest: evict-snoop
[646.953268] Subtest evict-snoop: SKIP (0.000s)
[647.157570] [141/155] (403s left) kms_color (ctm-green-to-red)
[648.647214] Starting subtest: ctm-green-to-red
[648.648844] Starting dynamic subtest: pipe-A-HDMI-A-4
[649.325531] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.677s)
[649.339627] Starting dynamic subtest: pipe-B-HDMI-A-4
[649.834946] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.509s)
[649.848784] Starting dynamic subtest: pipe-C-HDMI-A-4
[650.357782] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.521s)
[650.371857] Starting dynamic subtest: pipe-D-HDMI-A-4
[650.868057] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.508s)
[650.869646] Subtest ctm-green-to-red: SUCCESS (2.221s)
[651.084557] [142/155] (399s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[652.586559] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[652.589688] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[652.772013] [143/155] (398s left) gem_exec_flush (basic-batch-kernel-default-wb)
[652.827054] Subtest basic-batch-kernel-default-wb: SKIP (0.000s)
[652.919981] [144/155] (398s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[654.409447] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[654.411071] Starting dynamic subtest: pipe-A-HDMI-A-4
[654.427126] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[654.441526] Starting dynamic subtest: pipe-B-HDMI-A-4
[654.458469] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[654.472348] Starting dynamic subtest: pipe-C-HDMI-A-4
[654.489104] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[654.502443] Starting dynamic subtest: pipe-D-HDMI-A-4
[654.516581] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[654.519170] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SKIP (0.010s)
[654.712678] [145/155] (396s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[654.762622] Starting subtest: invalid-single-wait-all-unsubmitted
[654.764085] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[654.913257] [146/155] (396s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[656.410494] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[656.413398] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[656.596578] [147/155] (394s left) syncobj_wait (wait-for-submit-delayed-submit)
[656.647259] Starting subtest: wait-for-submit-delayed-submit
[656.753812] Subtest wait-for-submit-delayed-submit: SUCCESS (0.104s)
[656.979277] [148/155] (394s left) drm_read (invalid-buffer)
[658.534935] Starting subtest: invalid-buffer
[658.536379] Subtest invalid-buffer: SUCCESS (0.000s)
[658.788115] [149/155] (392s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-linear)
[660.288462] Starting subtest: fbcpsrhdr-tiling-linear
[660.291237] Subtest fbcpsrhdr-tiling-linear: SKIP (0.000s)
[660.469912] [150/155] (391s left) kms_setmode (invalid-clone-single-crtc-stealing)
[660.518170] Starting subtest: invalid-clone-single-crtc-stealing
[660.523213] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[660.638619] [151/155] (391s left) sysfs_timeslice_duration (duration)
[660.693154] Starting subtest: duration
[660.694739] Starting dynamic subtest: vecs0
[673.826356] Dynamic subtest vecs0: SUCCESS (13.134s)
[673.843455] Starting dynamic subtest: vcs0
[686.959489] Dynamic subtest vcs0: SUCCESS (13.131s)
[686.979177] Starting dynamic subtest: bcs0
[700.104557] Dynamic subtest bcs0: SUCCESS (13.143s)
[700.123410] Starting dynamic subtest: rcs0
[713.243612] Dynamic subtest rcs0: SUCCESS (13.136s)
[713.261089] Starting dynamic subtest: vcs1
[726.386641] Dynamic subtest vcs1: SUCCESS (13.141s)
[726.388643] Subtest duration: SUCCESS (65.697s)
[726.511335] [152/155] (325s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[728.005273] Starting subtest: flip-vs-cursor-crc-atomic
[728.605846] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.601s)
[728.809318] [153/155] (323s left) perf_pmu (idle-no-semaphores)
[728.863972] Starting subtest: idle-no-semaphores
[728.865453] Starting dynamic subtest: rcs0
[729.417051] Dynamic subtest rcs0: SUCCESS (0.550s)
[729.433551] Starting dynamic subtest: bcs0
[729.938330] Dynamic subtest bcs0: SUCCESS (0.515s)
[729.952443] Starting dynamic subtest: vcs0
[730.453200] Dynamic subtest vcs0: SUCCESS (0.509s)
[730.467437] Starting dynamic subtest: vcs1
[730.969199] Dynamic subtest vcs1: SUCCESS (0.510s)
[730.983442] Starting dynamic subtest: vecs0
[731.490274] Dynamic subtest vecs0: SUCCESS (0.515s)
[731.491880] Subtest idle-no-semaphores: SUCCESS (2.628s)
[731.614426] [154/155] (320s left) kms_properties (plane-properties-atomic)
[733.106645] Starting subtest: plane-properties-atomic
[733.108106] Starting dynamic subtest: pipe-A-HDMI-A-4
[733.556770] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.451s)
[733.573419] Starting dynamic subtest: pipe-B-HDMI-A-4
[734.019111] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.459s)
[734.034044] Starting dynamic subtest: pipe-C-HDMI-A-4
[734.488162] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.467s)
[734.506742] Starting dynamic subtest: pipe-D-HDMI-A-4
[734.960084] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.469s)
[734.961655] Subtest plane-properties-atomic: SUCCESS (1.856s)
[735.172003] [155/155] (316s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-shrfb-msflip-blt)
[736.672795] Starting subtest: psrhdr-2p-primscrn-shrfb-msflip-blt
[736.675879] Subtest psrhdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[736.873216] 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.