[63.279860] Initializing watchdogs
[63.279906]   /dev/watchdog0
[63.294328] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[63.298834] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[63.301237] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.304166] [001/155] (960s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[63.440862] Starting subtest: fbc-1p-pri-indfb-multidraw
[76.751832] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (13.316s)
[78.213089] [002/155] (945s left) kms_content_protection (lic-type-0-hdcp14)
[78.360409] Starting subtest: lic-type-0-hdcp14
[78.364995] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[78.502170] [003/155] (945s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[78.599082] Starting subtest: flip-vs-dpms-on-nop-interruptible
[78.601438] Starting dynamic subtest: A-eDP1
[80.473898] Dynamic subtest A-eDP1: SUCCESS (1.874s)
[80.484600] Starting dynamic subtest: B-eDP1
[82.295805] Dynamic subtest B-eDP1: SUCCESS (1.820s)
[82.305619] Starting dynamic subtest: C-eDP1
[84.101966] Dynamic subtest C-eDP1: SUCCESS (1.804s)
[84.110628] Starting dynamic subtest: D-eDP1
[85.935325] Dynamic subtest D-eDP1: SUCCESS (1.833s)
[85.937720] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.339s)
[87.355985] [004/155] (936s left) i915_pm_rc6_residency (rc6-accuracy)
[87.410232] Starting subtest: rc6-accuracy
[87.412309] Starting dynamic subtest: gt0
[90.582075] Dynamic subtest gt0: SUCCESS (3.168s)
[90.590555] Starting dynamic subtest: gt1
[93.751279] Dynamic subtest gt1: SUCCESS (3.168s)
[93.753796] Subtest rc6-accuracy: SUCCESS (6.338s)
[93.848670] [005/155] (930s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[93.944856] Starting subtest: coverage-vs-premult-vs-constant
[94.232291] Starting dynamic subtest: pipe-A-eDP-1
[94.810444] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.576s)
[94.819854] Starting dynamic subtest: pipe-D-eDP-1
[96.160799] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.349s)
[96.163237] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.216s)
[97.002280] [006/155] (927s left) kms_big_fb (linear-32bpp-rotate-270)
[97.103756] Starting subtest: linear-32bpp-rotate-270
[97.122801] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[97.236455] [007/155] (926s left) kms_vblank (wait-idle-hang)
[97.329171] Starting subtest: wait-idle-hang
[97.331327] Starting dynamic subtest: pipe-A-eDP-1
[124.031106] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.701s)
[124.043776] Starting dynamic subtest: pipe-D-eDP-1
[149.057884] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.024s)
[149.060390] Subtest wait-idle-hang: SUCCESS (51.729s)
[149.870727] [008/155] (874s left) perf_pmu (interrupts)
[149.911672] Starting subtest: interrupts
[151.030305] Subtest interrupts: SUCCESS (1.116s)
[151.143771] [FACT perf_pmu (interrupts)] new: kernel.kmod_is_loaded.vgem: true
[151.147380] [009/155] (872s left) gem_exec_reloc (basic-write-cpu-noreloc)
[151.197476] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[151.260343] [010/155] (872s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[151.353227] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[151.357380] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[151.463073] [011/155] (872s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[151.568871] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[158.117910] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.554s)
[158.252379] [012/155] (865s left) kms_pm_backlight (fade)
[158.352184] Starting subtest: fade
[158.401751] Starting dynamic subtest: eDP-1
[161.410425] Dynamic subtest eDP-1: SUCCESS (3.006s)
[161.412785] Subtest fade: SUCCESS (3.058s)
[162.222609] [013/155] (862s left) gem_mmap_wc (write-cpu-read-wc)
[162.281027] Subtest write-cpu-read-wc: SKIP (0.000s)
[162.339285] [014/155] (861s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[162.436736] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[162.441279] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[162.542376] [015/155] (861s left) kms_flip (absolute-wf_vblank-interruptible)
[162.647870] Starting subtest: absolute-wf_vblank-interruptible
[162.650379] Starting dynamic subtest: A-eDP1
[171.398220] Dynamic subtest A-eDP1: SUCCESS (8.729s)
[171.415722] Starting dynamic subtest: B-eDP1
[180.119768] Dynamic subtest B-eDP1: SUCCESS (8.739s)
[180.131356] Starting dynamic subtest: C-eDP1
[188.834948] Dynamic subtest C-eDP1: SUCCESS (8.714s)
[188.845057] Starting dynamic subtest: D-eDP1
[197.563490] Dynamic subtest D-eDP1: SUCCESS (8.726s)
[197.565958] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.916s)
[198.774286] [016/155] (825s left) gem_vm_create (invalid-create)
[198.836696] Starting subtest: invalid-create
[198.838980] Subtest invalid-create: SUCCESS (0.003s)
[198.938133] [017/155] (825s left) syncobj_basic (bad-fd-to-handle)
[198.982479] Starting subtest: bad-fd-to-handle
[198.984732] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[199.089339] [018/155] (825s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-mmap-wc)
[199.189552] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-mmap-wc
[199.193716] Subtest hdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[199.285181] [019/155] (825s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[199.393126] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[199.397130] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[199.493527] [020/155] (825s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[199.585206] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[199.589412] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[199.714898] [021/155] (824s left) kms_frontbuffer_tracking (hdr-2p-pri-indfb-multidraw)
[199.818846] Starting subtest: hdr-2p-pri-indfb-multidraw
[199.822479] Subtest hdr-2p-pri-indfb-multidraw: SKIP (0.000s)
[199.912616] [022/155] (824s left) kms_cursor_crc (cursor-sliding-256x256)
[200.165375] Starting subtest: cursor-sliding-256x256
[200.169624] Starting dynamic subtest: pipe-A-eDP-1
[203.391402] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.221s)
[203.419884] Starting dynamic subtest: pipe-D-eDP-1
[207.257479] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.843s)
[207.260570] Subtest cursor-sliding-256x256: SUCCESS (7.090s)
[208.132705] [023/155] (816s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[208.233769] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[208.238073] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[208.304088] [024/155] (816s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[208.408149] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[208.412729] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[208.522958] [025/155] (816s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[208.615110] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[208.617713] Starting dynamic subtest: pipe-A-eDP-1
[208.640567] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[208.651658] Starting dynamic subtest: pipe-B-eDP-1
[208.672169] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[208.680491] Starting dynamic subtest: pipe-C-eDP-1
[208.701405] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[208.711954] Starting dynamic subtest: pipe-D-eDP-1
[208.733766] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[208.738183] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[210.882901] [026/155] (813s left) gem_exec_parallel (fds)
[210.940877] Starting subtest: fds
[210.943428] Starting dynamic subtest: rcs0
[213.410326] Dynamic subtest rcs0: SUCCESS (2.468s)
[213.420239] Starting dynamic subtest: bcs0
[216.598873] Dynamic subtest bcs0: SUCCESS (3.187s)
[216.607933] Starting dynamic subtest: vcs0
[220.587477] Dynamic subtest vcs0: SUCCESS (3.988s)
[220.598613] Starting dynamic subtest: vcs1
[224.630733] Dynamic subtest vcs1: SUCCESS (4.041s)
[224.643044] Starting dynamic subtest: vecs0
[228.520255] Dynamic subtest vecs0: SUCCESS (3.888s)
[228.531802] Starting dynamic subtest: ccs0
[232.245420] Dynamic subtest ccs0: SUCCESS (3.723s)
[232.248354] Subtest fds: SUCCESS (21.303s)
[232.459438] [027/155] (792s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[232.570639] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[232.574980] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[232.676748] [028/155] (792s left) kms_lease (lessee-list)
[232.770683] Starting subtest: lessee-list
[232.772925] Starting dynamic subtest: pipe-A-eDP-1
[232.775609] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[232.784639] Starting dynamic subtest: pipe-B-eDP-1
[232.786952] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[232.795639] Starting dynamic subtest: pipe-C-eDP-1
[232.797869] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[232.806266] Starting dynamic subtest: pipe-D-eDP-1
[232.808454] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[232.810733] Subtest lessee-list: SUCCESS (0.009s)
[232.910576] [029/155] (792s left) gem_exec_params (mmapped)
[232.969082] Starting subtest: mmapped
[232.974560] Subtest mmapped: SUCCESS (0.004s)
[233.095307] [030/155] (791s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[233.193824] Starting subtest: fbc-psr2-primary-mmap-cpu
[233.196600] Starting dynamic subtest: eDP-1
[233.201235] Dynamic subtest eDP-1: SKIP (0.000s)
[233.205516] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[233.262960] [031/155] (791s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[233.365927] Starting subtest: yf-tiled-addfb-size-overflow
[233.369500] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[233.460447] [032/155] (791s left) api_intel_bb (destroy-bb)
[233.518776] Starting subtest: destroy-bb
[233.530254] Subtest destroy-bb: SUCCESS (0.011s)
[233.661219] [033/155] (791s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[233.750836] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[233.754509] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[233.838692] [034/155] (791s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[233.945455] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[238.023455] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (4.084s)
[239.191417] [035/155] (785s left) kms_frontbuffer_tracking (fbchdr-2p-shrfb-fliptrack-mmap-gtt)
[239.288193] Starting subtest: fbchdr-2p-shrfb-fliptrack-mmap-gtt
[239.292474] Subtest fbchdr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[239.378791] [036/155] (785s left) gem_lmem_swapping (random)
[239.418506] Subtest random: SKIP (0.000s)
[239.463739] [037/155] (785s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-blt)
[239.556282] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-blt
[239.560628] Subtest fbchdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[239.655379] [038/155] (785s left) gem_pread (exhaustion)
[239.712350] Subtest exhaustion: SKIP (0.000s)
[239.774332] [039/155] (785s left) prime_mmap (test_forked_cpu_write)
[239.826406] Starting subtest: test_forked_cpu_write
[239.828422] Starting dynamic subtest: test_forked_cpu_write-smem
[239.833118] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.008s)
[239.835332] Subtest test_forked_cpu_write: SUCCESS (0.008s)
[239.946999] [040/155] (785s left) sw_sync (sync_busy_fork)
[239.981607] Starting subtest: sync_busy_fork
[240.991779] Subtest sync_busy_fork: SUCCESS (1.011s)
[241.064980] [041/155] (784s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[241.168176] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[241.170490] Starting dynamic subtest: pipe-A-default-mode
[242.342764] Dynamic subtest pipe-A-default-mode: SKIP (1.173s)
[242.347081] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.174s)
[242.487223] [042/155] (782s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[242.595808] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[242.600019] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[242.695690] [043/155] (782s left) prime_mmap (test_reprime)
[242.741082] Starting subtest: test_reprime
[242.743070] Starting dynamic subtest: test_reprime-smem
[242.770355] Dynamic subtest test_reprime-smem: SUCCESS (0.031s)
[242.772756] Subtest test_reprime: SUCCESS (0.032s)
[242.880720] [044/155] (782s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc)
[242.980065] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc
[242.984194] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[243.078199] [045/155] (782s left) i915_drm_fdinfo (virtual-busy-all)
[243.113625] Starting subtest: virtual-busy-all
[243.117911] Subtest virtual-busy-all: SKIP (0.000s)
[243.175457] [046/155] (782s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[243.271551] Starting subtest: primary-yf-tiled-reflect-x-180
[243.331034] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s)
[243.437403] [047/155] (782s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[243.541035] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[244.577035] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.037s)
[244.688414] [048/155] (781s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[244.782489] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[244.784332] Starting dynamic subtest: pipe-A-eDP-1
[244.802806] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[244.815373] Starting dynamic subtest: pipe-B-eDP-1
[244.832998] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[244.840982] Starting dynamic subtest: pipe-C-eDP-1
[244.858878] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[244.866758] Starting dynamic subtest: pipe-D-eDP-1
[244.885700] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[244.889066] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[247.073817] [049/155] (778s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-onoff)
[247.169449] Starting subtest: fbchdr-2p-primscrn-spr-indfb-onoff
[247.173580] Subtest fbchdr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[247.263967] [050/155] (778s left) gem_mmap_offset (basic-uaf)
[247.319288] Starting subtest: basic-uaf
[247.321667] Subtest basic-uaf: SUCCESS (0.001s)
[247.424907] [051/155] (778s left) kms_chamelium_color (ctm-0-50)
[247.509394] Subtest ctm-0-50: SKIP (0.000s)
[247.554905] [052/155] (778s left) syncobj_timeline (multi-wait-signaled)
[247.611670] Starting subtest: multi-wait-signaled
[247.614139] Subtest multi-wait-signaled: SUCCESS (0.001s)
[247.716857] [053/155] (778s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-pwrite)
[247.817945] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-pwrite
[247.822066] Subtest hdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[247.903404] [054/155] (778s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[248.004579] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[254.803639] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.803s)
[254.936319] [055/155] (771s left) kms_feature_discovery (dp-mst)
[255.031172] Starting subtest: dp-mst
[255.035700] Subtest dp-mst: SKIP (0.000s)
[255.119862] [056/155] (770s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[255.220080] Starting subtest: pipe-fbc-rte
[255.226775] Starting dynamic subtest: pipe-B-eDP-1
[260.648279] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.434s)
[260.655948] Subtest pipe-fbc-rte: SUCCESS (5.436s)
[262.930523] [057/155] (763s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[262.989965] Starting subtest: map-fixed-invalidate-overlap
[262.994217] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[263.126443] [058/155] (763s left) i915_fb_tiling (basic-x-tiling)
[263.173321] Subtest basic-x-tiling: SKIP (0.000s)
[263.234310] [059/155] (762s left) kms_psr (psr2-primary-mmap-cpu)
[263.327603] Starting subtest: psr2-primary-mmap-cpu
[263.329815] Starting dynamic subtest: eDP-1
[265.096761] Dynamic subtest eDP-1: SUCCESS (1.766s)
[265.099216] Subtest psr2-primary-mmap-cpu: SUCCESS (1.769s)
[265.984661] [060/155] (760s left) gem_exec_store (pages)
[266.047719] Starting subtest: pages
[266.049646] Starting dynamic subtest: rcs0
[266.129543] Dynamic subtest rcs0: SUCCESS (0.083s)
[266.138686] Starting dynamic subtest: bcs0
[266.209271] Dynamic subtest bcs0: SUCCESS (0.079s)
[266.217696] Starting dynamic subtest: vcs0
[266.287640] Dynamic subtest vcs0: SUCCESS (0.078s)
[266.296432] Starting dynamic subtest: vcs1
[266.362606] Dynamic subtest vcs1: SUCCESS (0.073s)
[266.371149] Starting dynamic subtest: vecs0
[266.429298] Dynamic subtest vecs0: SUCCESS (0.066s)
[266.437795] Starting dynamic subtest: ccs0
[266.502746] Dynamic subtest ccs0: SUCCESS (0.073s)
[266.505418] Subtest pages: SUCCESS (0.457s)
[266.684158] [061/155] (759s left) kms_cursor_crc (cursor-sliding-max-size)
[266.979561] Starting subtest: cursor-sliding-max-size
[266.986351] Subtest cursor-sliding-max-size: SKIP (0.000s)
[267.122849] [062/155] (759s left) api_intel_allocator (simple-allocator)
[267.176688] Starting subtest: simple-allocator
[267.179726] Starting dynamic subtest: basic
[267.182445] Dynamic subtest basic: SUCCESS (0.004s)
[267.200825] Starting dynamic subtest: parallel-one
[267.336713] Dynamic subtest parallel-one: SUCCESS (0.157s)
[267.345879] Starting dynamic subtest: print
[267.348251] Dynamic subtest print: SUCCESS (0.000s)
[267.356816] Starting dynamic subtest: reuse
[267.359301] Dynamic subtest reuse: SUCCESS (0.000s)
[267.367726] Starting dynamic subtest: reserve
[267.370075] Dynamic subtest reserve: SUCCESS (0.000s)
[267.378336] Starting dynamic subtest: fork-reopen-allocator
[267.380626] Dynamic subtest fork-reopen-allocator: SUCCESS (0.017s)
[267.382871] Subtest simple-allocator: SUCCESS (0.184s)
[267.493357] [063/155] (758s left) gem_ctx_engines (invalid-engines)
[267.555184] Starting subtest: invalid-engines
[267.562262] Subtest invalid-engines: SUCCESS (0.007s)
[267.807597] [064/155] (758s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[267.866473] Starting subtest: etime-single-wait-available-unsubmitted
[267.973549] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.106s)
[268.063423] [065/155] (758s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[268.169458] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[268.173727] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[268.275902] [066/155] (758s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[268.377410] Starting subtest: fbc-psr2-cursor-plane-update-sf
[268.379587] Starting dynamic subtest: pipe-A-eDP-1
[268.451314] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[268.460763] Starting dynamic subtest: pipe-B-eDP-1
[269.551153] Dynamic subtest pipe-B-eDP-1: SKIP (1.097s)
[269.555777] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.177s)
[270.745536] [067/155] (755s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[271.144510] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[271.964597] [068/155] (754s left) gem_lmem_swapping (parallel-random)
[272.002460] Subtest parallel-random: SKIP (0.000s)
[272.045701] [069/155] (754s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-pwrite)
[272.153730] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-pwrite
[272.157872] Subtest hdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[272.257351] [070/155] (754s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[272.350928] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[272.355046] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[272.464902] [071/155] (754s left) gem_exec_schedule (preempt-hang)
[272.627806] Starting subtest: preempt-hang
[272.630418] Starting dynamic subtest: rcs0
[272.868241] Dynamic subtest rcs0: SUCCESS (0.239s)
[272.880181] Starting dynamic subtest: bcs0
[273.099457] Dynamic subtest bcs0: SUCCESS (0.231s)
[273.109035] Starting dynamic subtest: vcs0
[273.324265] Dynamic subtest vcs0: SUCCESS (0.224s)
[273.333162] Starting dynamic subtest: vcs1
[273.549316] Dynamic subtest vcs1: SUCCESS (0.223s)
[273.560929] Starting dynamic subtest: vecs0
[273.778147] Dynamic subtest vecs0: SUCCESS (0.226s)
[273.788268] Starting dynamic subtest: ccs0
[274.005768] Dynamic subtest ccs0: SUCCESS (0.226s)
[274.008587] Subtest preempt-hang: SUCCESS (1.378s)
[274.379226] [072/155] (752s left) kms_psr (fbc-pr-primary-mmap-cpu)
[274.464157] Starting subtest: fbc-pr-primary-mmap-cpu
[274.468642] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[274.535741] [073/155] (752s left) kms_cursor_crc (cursor-offscreen-32x10)
[274.701924] Starting subtest: cursor-offscreen-32x10
[274.749330] Subtest cursor-offscreen-32x10: SKIP (0.044s)
[274.988722] [074/155] (751s left) gem_exec_balancer (parallel-bb-first)
[275.254697] Starting subtest: parallel-bb-first
[276.193621] Subtest parallel-bb-first: SUCCESS (0.942s)
[277.366378] [075/155] (749s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[277.455046] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[277.457329] Starting dynamic subtest: pipe-A-eDP-1
[277.480355] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[277.491796] Starting dynamic subtest: pipe-B-eDP-1
[277.513691] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[277.522802] Starting dynamic subtest: pipe-C-eDP-1
[277.545212] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[277.557695] Starting dynamic subtest: pipe-D-eDP-1
[277.579704] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[277.583748] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.004s)
[279.749782] [076/155] (747s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[279.799046] Starting subtest: single-wait-for-submit-available-signaled
[279.801307] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[279.900275] [077/155] (746s left) gem_softpin (noreloc-s3)
[279.961888] Starting subtest: noreloc-S3
[299.749914] Subtest noreloc-S3: SUCCESS (5.421s)
[299.883984] [078/155] (727s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[300.003075] Starting subtest: x-tiled-32bpp-rotate-0
[301.450554] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.446s)
[301.603206] [079/155] (725s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[301.696123] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[301.699442] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[301.766590] [080/155] (725s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[301.826994] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[301.830861] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[302.028534] [081/155] (725s left) gen9_exec_parse (allowed-single)
[302.082037] Subtest allowed-single: SKIP (0.000s)
[302.149468] [082/155] (724s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-move)
[302.251462] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-move
[302.255758] Subtest psrhdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[302.366085] [083/155] (724s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[302.487155] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[311.839589] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.347s)
[312.655446] [084/155] (714s left) gem_exec_balancer (sequential)
[312.707592] Starting subtest: sequential
[315.802378] Subtest sequential: SUCCESS (3.093s)
[316.130130] [085/155] (711s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[316.262969] Starting subtest: cursorB-vs-flipA-legacy
[316.267468] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[316.420070] [086/155] (710s left) gem_ctx_param (basic)
[316.474438] Starting subtest: basic
[316.476776] Subtest basic: SUCCESS (0.001s)
[316.570005] [087/155] (710s left) kms_frontbuffer_tracking (psrhdr-1p-rte)
[316.670352] Starting subtest: psrhdr-1p-rte
[316.674851] Subtest psrhdr-1p-rte: SKIP (0.000s)
[316.751972] [088/155] (710s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[316.852964] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[323.634938] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.785s)
[323.780494] [089/155] (703s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[323.891230] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-mmap-gtt
[323.895663] Subtest fbchdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[323.990482] [090/155] (703s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-pgflip-blt)
[324.078851] Starting subtest: psrhdr-2p-scndscrn-shrfb-pgflip-blt
[324.083242] Subtest psrhdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[324.182340] [091/155] (703s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[324.274964] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[324.278905] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[324.375506] [092/155] (703s left) kms_addfb_basic (clobberred-modifier)
[324.426736] Starting subtest: clobberred-modifier
[324.431139] Subtest clobberred-modifier: SKIP (0.000s)
[324.565127] [093/155] (702s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-pwrite)
[324.663756] Starting subtest: fbcpsrhdr-rgb565-draw-pwrite
[324.667100] Subtest fbcpsrhdr-rgb565-draw-pwrite: SKIP (0.000s)
[324.770394] [094/155] (702s left) perf (gen12-group-exclusive-stream-ctx-handle)
[324.890776] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[324.914705] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.028s)
[324.962904] [095/155] (702s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-mmap-wc)
[326.700224] Starting subtest: fbchdr-rgb565-draw-mmap-wc
[326.704270] Subtest fbchdr-rgb565-draw-mmap-wc: SKIP (0.000s)
[326.811452] [096/155] (700s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[326.863452] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[326.968280] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.105s)
[327.045311] [097/155] (700s left) gem_ctx_persistence (processes)
[327.106306] Starting subtest: processes
[328.677064] Subtest processes: SUCCESS (1.570s)
[328.755937] [098/155] (698s left) gem_softpin (overlap)
[328.810353] Starting subtest: overlap
[329.741889] Subtest overlap: SUCCESS (0.930s)
[329.887446] [099/155] (697s left) gem_exec_fence (nb-await)
[330.055124] Starting subtest: nb-await
[330.057426] Starting dynamic subtest: rcs0
[330.134360] Dynamic subtest rcs0: SUCCESS (0.078s)
[330.149868] Starting dynamic subtest: bcs0
[330.194594] Dynamic subtest bcs0: SUCCESS (0.057s)
[330.206492] Starting dynamic subtest: vcs0
[330.254399] Dynamic subtest vcs0: SUCCESS (0.058s)
[330.267277] Starting dynamic subtest: vcs1
[330.315306] Dynamic subtest vcs1: SUCCESS (0.058s)
[330.328296] Starting dynamic subtest: vecs0
[330.375643] Dynamic subtest vecs0: SUCCESS (0.058s)
[330.388447] Starting dynamic subtest: ccs0
[330.436864] Dynamic subtest ccs0: SUCCESS (0.059s)
[330.439387] Subtest nb-await: SUCCESS (0.382s)
[332.720771] [100/155] (695s left) kms_dp_link_training (non-uhbr-sst)
[332.820563] Starting subtest: non-uhbr-sst
[332.829214] Subtest non-uhbr-sst: SKIP (0.000s)
[332.893392] [101/155] (694s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[332.985401] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[333.087636] [102/155] (694s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[333.186038] Starting subtest: sprite-rotation-90-pos-100-0
[333.190280] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[333.257179] [103/155] (694s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[333.351796] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[333.356419] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[334.522983] [104/155] (693s left) kms_atomic_transition (modeset-transition-nonblocking)
[334.625316] Starting subtest: modeset-transition-nonblocking
[334.627475] Starting dynamic subtest: 1x-outputs
[346.205465] Dynamic subtest 1x-outputs: SUCCESS (11.578s)
[346.207916] Subtest modeset-transition-nonblocking: SUCCESS (11.580s)
[347.074800] [105/155] (680s left) prime_vgem (coherency-blt)
[347.132678] Starting subtest: coherency-blt
[348.293011] Subtest coherency-blt: SUCCESS (1.161s)
[348.423706] [106/155] (679s left) sw_sync (alloc_fence)
[348.462912] Starting subtest: alloc_fence
[348.465530] Subtest alloc_fence: SUCCESS (0.000s)
[348.532562] [107/155] (679s left) gem_eio (in-flight-internal-10ms)
[348.772323] Starting subtest: in-flight-internal-10ms
[350.774443] Subtest in-flight-internal-10ms: SUCCESS (2.001s)
[350.895106] [108/155] (677s left) kms_chamelium_edid (hdmi-mode-timings)
[351.275494] Subtest hdmi-mode-timings: SKIP (0.000s)
[352.088148] [109/155] (676s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[352.204464] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[352.208584] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[352.307282] [110/155] (675s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[352.373663] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[352.378013] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[352.559877] [111/155] (675s left) gem_ctx_param (vm)
[352.614207] Starting subtest: vm
[352.665147] Subtest vm: SUCCESS (0.050s)
[352.786031] [112/155] (675s left) kms_vblank (query-forked-hang)
[352.873982] Starting subtest: query-forked-hang
[352.876140] Starting dynamic subtest: pipe-A-eDP-1
[354.727754] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.851s)
[354.744596] Starting dynamic subtest: pipe-D-eDP-1
[357.226242] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.495s)
[357.228481] Subtest query-forked-hang: SUCCESS (4.353s)
[358.074909] [113/155] (670s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[358.167100] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[358.179319] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.010s)
[358.251753] [114/155] (670s left) kms_flip (nonblocking-read)
[358.340473] Starting subtest: nonblocking-read
[358.342685] Subtest nonblocking-read: SUCCESS (0.000s)
[358.455648] [115/155] (670s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[358.556271] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[366.019686] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.466s)
[366.164750] [116/155] (662s left) gem_sync (basic-all)
[366.235734] Starting subtest: basic-all
[369.631707] Subtest basic-all: SUCCESS (3.404s)
[369.820846] [117/155] (658s left) gem_busy (semaphore)
[370.006427] Subtest semaphore: SKIP (0.000s)
[370.229767] [118/155] (658s left) gem_spin_batch (legacy)
[370.288361] Starting subtest: legacy
[370.291053] Starting dynamic subtest: default
[373.532536] Dynamic subtest default: SUCCESS (3.238s)
[373.544699] Starting dynamic subtest: render
[376.766238] Dynamic subtest render: SUCCESS (3.231s)
[376.780007] Starting dynamic subtest: bsd
[380.008693] Dynamic subtest bsd: SUCCESS (3.236s)
[380.019477] Starting dynamic subtest: bsd1
[383.247675] Dynamic subtest bsd1: SUCCESS (3.234s)
[383.269958] Starting dynamic subtest: bsd2
[386.487229] Dynamic subtest bsd2: SUCCESS (3.235s)
[386.500229] Starting dynamic subtest: blt
[389.723889] Dynamic subtest blt: SUCCESS (3.233s)
[389.736591] Starting dynamic subtest: vebox
[392.961686] Dynamic subtest vebox: SUCCESS (3.235s)
[392.964190] Subtest legacy: SUCCESS (22.668s)
[393.713847] [119/155] (634s left) i915_selftest (mock)
[397.053238] Starting subtest: mock
[397.055343] Starting dynamic subtest: sanitycheck
[397.711535] Dynamic subtest sanitycheck: SUCCESS (0.659s)
[397.721765] Starting dynamic subtest: shmem
[398.410048] Dynamic subtest shmem: SUCCESS (0.696s)
[398.420735] Starting dynamic subtest: fence
[405.796407] Dynamic subtest fence: SUCCESS (7.385s)
[405.807120] Starting dynamic subtest: scatterlist
[407.477376] Dynamic subtest scatterlist: SUCCESS (1.681s)
[407.487277] Starting dynamic subtest: syncmap
[410.711642] Dynamic subtest syncmap: SUCCESS (3.232s)
[410.722552] Starting dynamic subtest: uncore
[411.404379] Dynamic subtest uncore: SUCCESS (0.688s)
[411.412672] Starting dynamic subtest: ring
[412.079995] Dynamic subtest ring: SUCCESS (0.677s)
[412.090864] Starting dynamic subtest: engine
[412.763395] Dynamic subtest engine: SUCCESS (0.681s)
[412.774275] Starting dynamic subtest: timelines
[416.554079] Dynamic subtest timelines: SUCCESS (3.789s)
[416.564088] Starting dynamic subtest: requests
[420.128422] Dynamic subtest requests: SUCCESS (3.573s)
[420.138529] Starting dynamic subtest: objects
[420.887601] Dynamic subtest objects: SUCCESS (0.757s)
[420.896502] Starting dynamic subtest: phys
[421.673605] Dynamic subtest phys: SUCCESS (0.784s)
[421.683761] Starting dynamic subtest: dmabuf
[422.458918] Dynamic subtest dmabuf: SUCCESS (0.784s)
[422.469054] Starting dynamic subtest: vma
[428.178977] Dynamic subtest vma: SUCCESS (5.718s)
[428.189089] Starting dynamic subtest: evict
[429.596174] Dynamic subtest evict: SUCCESS (1.417s)
[429.606775] Starting dynamic subtest: gtt
[432.936123] Dynamic subtest gtt: SUCCESS (3.338s)
[432.951285] Starting dynamic subtest: hugepages
[433.828006] Dynamic subtest hugepages: SUCCESS (0.890s)
[433.837176] Starting dynamic subtest: memory_region
[436.388454] Dynamic subtest memory_region: SUCCESS (2.559s)
[436.391560] Subtest mock: SUCCESS (39.339s)
[436.422075] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[436.422809] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[436.426522] [120/155] (592s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[438.009411] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[438.014050] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[438.105469] [FACT kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[438.106674] [FACT kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)] new: kernel.kmod_is_loaded.i915: true
[438.110299] [121/155] (590s left) gem_ctx_shared (exec-single-timeline)
[438.179874] Starting subtest: exec-single-timeline
[438.182303] Starting dynamic subtest: rcs0
[439.224694] Dynamic subtest rcs0: SUCCESS (1.043s)
[439.240603] Starting dynamic subtest: bcs0
[440.313295] Dynamic subtest bcs0: SUCCESS (1.084s)
[440.325328] Starting dynamic subtest: vcs0
[441.403410] Dynamic subtest vcs0: SUCCESS (1.085s)
[441.413950] Starting dynamic subtest: vcs1
[442.490724] Dynamic subtest vcs1: SUCCESS (1.086s)
[442.500882] Starting dynamic subtest: vecs0
[443.577601] Dynamic subtest vecs0: SUCCESS (1.085s)
[443.591786] Starting dynamic subtest: ccs0
[444.666670] Dynamic subtest ccs0: SUCCESS (1.084s)
[444.669666] Subtest exec-single-timeline: SUCCESS (6.486s)
[444.865055] [122/155] (583s left) kms_hdr (invalid-hdr)
[444.967568] Starting subtest: invalid-hdr
[444.969813] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[450.105958] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (5.133s)
[450.124125] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[454.207053] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (4.088s)
[454.216967] Subtest invalid-hdr: SUCCESS (9.251s)
[454.341546] [123/155] (574s left) core_sysfs (read-all-entries)
[454.387535] Starting subtest: read-all-entries
[454.390565] Subtest read-all-entries: SUCCESS (0.003s)
[454.511061] [124/155] (574s left) kms_big_fb (x-tiled-addfb-size-overflow)
[454.614033] Starting subtest: x-tiled-addfb-size-overflow
[454.616293] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[454.700151] [125/155] (574s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[454.788810] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[454.791076] Starting dynamic subtest: pipe-A
[456.016191] Dynamic subtest pipe-A: SKIP (1.225s)
[456.027230] Starting dynamic subtest: pipe-B
[457.261394] Dynamic subtest pipe-B: SKIP (1.242s)
[457.272328] Starting dynamic subtest: pipe-C
[458.476918] Dynamic subtest pipe-C: SUCCESS (1.221s)
[458.492138] Starting dynamic subtest: pipe-D
[459.704838] Dynamic subtest pipe-D: SUCCESS (1.226s)
[459.707211] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (4.919s)
[460.898538] [126/155] (568s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-move)
[461.004923] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-move
[461.009277] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[461.116791] [127/155] (567s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[461.209610] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[461.214008] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[461.305969] [128/155] (567s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[461.394689] Starting subtest: multiplane-rotation-cropping-bottom
[478.821164] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.427s)
[478.928523] [129/155] (550s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[479.021196] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[479.024540] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[479.128241] [130/155] (549s left) gem_exec_nop (basic-series)
[479.193500] Starting subtest: basic-series
[494.098438] Subtest basic-series: SUCCESS (14.910s)
[494.321971] [131/155] (534s left) kms_psr (pr-cursor-mmap-gtt)
[494.418559] Starting subtest: pr-cursor-mmap-gtt
[494.423046] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[494.489771] [132/155] (534s left) kms_psr (pr-dpms)
[494.576962] Starting subtest: pr-dpms
[494.581399] Subtest pr-dpms: SKIP (0.000s)
[494.649142] [133/155] (534s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[494.747980] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[494.774542] Starting dynamic subtest: pipe-A-plane-0
[495.040647] Dynamic subtest pipe-A-plane-0: SUCCESS (0.265s)
[495.053483] Starting dynamic subtest: pipe-A-plane-3
[495.250884] Dynamic subtest pipe-A-plane-3: SUCCESS (0.210s)
[495.260015] Starting dynamic subtest: pipe-A-plane-5
[495.263591] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[496.386132] Starting dynamic subtest: pipe-B-plane-0
[496.653861] Dynamic subtest pipe-B-plane-0: SUCCESS (0.278s)
[496.664001] Starting dynamic subtest: pipe-B-plane-3
[496.866270] Dynamic subtest pipe-B-plane-3: SUCCESS (0.210s)
[496.875861] Starting dynamic subtest: pipe-B-plane-5
[496.880510] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[497.173664] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.427s)
[498.052388] [134/155] (531s left) gem_exec_schedule (preempt-user)
[498.122978] Starting subtest: preempt-user
[498.124827] Starting dynamic subtest: rcs0
[498.140507] Dynamic subtest rcs0: SUCCESS (0.025s)
[498.150490] Starting dynamic subtest: bcs0
[498.166807] Dynamic subtest bcs0: SUCCESS (0.025s)
[498.176506] Starting dynamic subtest: vcs0
[498.188209] Dynamic subtest vcs0: SUCCESS (0.021s)
[498.197882] Starting dynamic subtest: vcs1
[498.211924] Dynamic subtest vcs1: SUCCESS (0.023s)
[498.222082] Starting dynamic subtest: vecs0
[498.232730] Dynamic subtest vecs0: SUCCESS (0.020s)
[498.242470] Starting dynamic subtest: ccs0
[498.253005] Dynamic subtest ccs0: SUCCESS (0.019s)
[498.255151] Subtest preempt-user: SUCCESS (0.138s)
[499.761839] [135/155] (529s left) prime_mmap (test_dup)
[499.825482] Starting subtest: test_dup
[499.827362] Starting dynamic subtest: test_dup-smem
[499.855442] Dynamic subtest test_dup-smem: SUCCESS (0.032s)
[499.858407] Subtest test_dup: SUCCESS (0.033s)
[499.929788] [136/155] (529s left) kms_pm_dc (dc6-dpms)
[501.026613] Starting subtest: dc6-dpms
[503.134942] Subtest dc6-dpms: SUCCESS (2.106s)
[503.226372] [137/155] (526s left) kms_plane (pixel-format-y-tiled-modifier)
[503.319404] Starting subtest: pixel-format-y-tiled-modifier
[503.323740] Subtest pixel-format-y-tiled-modifier: SKIP (0.000s)
[503.407162] [138/155] (526s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[503.507180] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[503.518267] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[503.629262] [139/155] (525s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt)
[503.727550] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt
[503.732226] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[503.832382] [140/155] (525s left) gem_softpin (evict-snoop)
[503.883411] Starting subtest: evict-snoop
[503.887779] Subtest evict-snoop: SKIP (0.000s)
[504.023871] [141/155] (525s left) kms_color (ctm-green-to-red)
[504.114599] Starting subtest: ctm-green-to-red
[504.116570] Starting dynamic subtest: pipe-A-eDP-1
[504.818093] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.702s)
[504.832178] Starting dynamic subtest: pipe-B-eDP-1
[506.183199] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.363s)
[506.195247] Starting dynamic subtest: pipe-C-eDP-1
[507.564611] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.380s)
[507.575411] Starting dynamic subtest: pipe-D-eDP-1
[508.861001] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.299s)
[508.863244] Subtest ctm-green-to-red: SUCCESS (4.748s)
[509.702531] [142/155] (519s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[509.800670] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[509.804676] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[509.906841] [143/155] (519s left) gem_exec_flush (basic-batch-kernel-default-wb)
[509.968271] Starting subtest: basic-batch-kernel-default-wb
[517.307944] Subtest basic-batch-kernel-default-wb: SUCCESS (7.339s)
[517.512691] [144/155] (512s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[517.612355] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[517.614425] Starting dynamic subtest: pipe-A-eDP-1
[517.672058] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.059s)
[517.682252] Starting dynamic subtest: pipe-B-eDP-1
[517.732134] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.060s)
[517.742384] Starting dynamic subtest: pipe-C-eDP-1
[517.793130] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.061s)
[517.803235] Starting dynamic subtest: pipe-D-eDP-1
[517.854515] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.058s)
[517.856828] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.242s)
[520.162297] [145/155] (509s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[520.230446] Starting subtest: invalid-single-wait-all-unsubmitted
[520.232480] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[520.344222] [146/155] (509s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[520.446519] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[520.450800] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[520.553306] [147/155] (509s left) syncobj_wait (wait-for-submit-delayed-submit)
[520.605394] Starting subtest: wait-for-submit-delayed-submit
[520.708672] Subtest wait-for-submit-delayed-submit: SUCCESS (0.104s)
[520.787344] [148/155] (509s left) drm_read (invalid-buffer)
[520.926370] Starting subtest: invalid-buffer
[520.929247] Subtest invalid-buffer: SUCCESS (0.000s)
[521.052875] [149/155] (508s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-linear)
[521.144209] Starting subtest: fbcpsrhdr-tiling-linear
[521.148637] Subtest fbcpsrhdr-tiling-linear: SKIP (0.000s)
[521.241496] [150/155] (508s left) kms_setmode (invalid-clone-single-crtc-stealing)
[521.302097] Starting subtest: invalid-clone-single-crtc-stealing
[521.308285] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[521.414706] [151/155] (508s left) sysfs_timeslice_duration (duration)
[521.472139] Starting subtest: duration
[521.474466] Starting dynamic subtest: vecs0
[534.617275] Dynamic subtest vecs0: SUCCESS (13.144s)
[534.630708] Starting dynamic subtest: ccs0
[547.756561] Dynamic subtest ccs0: SUCCESS (13.137s)
[547.769206] Starting dynamic subtest: vcs0
[561.594330] Dynamic subtest vcs0: SUCCESS (13.833s)
[561.606599] Starting dynamic subtest: bcs0
[574.733210] Dynamic subtest bcs0: SUCCESS (13.137s)
[574.751282] Starting dynamic subtest: rcs0
[587.878256] Dynamic subtest rcs0: SUCCESS (13.141s)
[587.891459] Starting dynamic subtest: vcs1
[601.599514] Dynamic subtest vcs1: SUCCESS (13.717s)
[601.602281] Subtest duration: SUCCESS (80.124s)
[601.679792] [152/155] (428s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[601.794267] Starting subtest: flip-vs-cursor-crc-atomic
[602.460736] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.665s)
[603.308508] [153/155] (426s left) perf_pmu (idle-no-semaphores)
[603.357968] Starting subtest: idle-no-semaphores
[603.360355] Starting dynamic subtest: rcs0
[603.907284] Dynamic subtest rcs0: SUCCESS (0.550s)
[603.921072] Starting dynamic subtest: bcs0
[604.431103] Dynamic subtest bcs0: SUCCESS (0.520s)
[604.444512] Starting dynamic subtest: vcs0
[604.946976] Dynamic subtest vcs0: SUCCESS (0.512s)
[604.959534] Starting dynamic subtest: vcs1
[605.464915] Dynamic subtest vcs1: SUCCESS (0.515s)
[605.477238] Starting dynamic subtest: vecs0
[605.983130] Dynamic subtest vecs0: SUCCESS (0.515s)
[605.997243] Starting dynamic subtest: ccs0
[606.522232] Dynamic subtest ccs0: SUCCESS (0.520s)
[606.524778] Subtest idle-no-semaphores: SUCCESS (3.150s)
[606.602866] [154/155] (423s left) kms_properties (plane-properties-atomic)
[606.709699] Starting subtest: plane-properties-atomic
[606.711901] Starting dynamic subtest: pipe-A-eDP-1
[607.263904] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.553s)
[607.274299] Starting dynamic subtest: pipe-B-eDP-1
[608.554175] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.288s)
[608.567385] Starting dynamic subtest: pipe-C-eDP-1
[609.795938] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.238s)
[609.807432] Starting dynamic subtest: pipe-D-eDP-1
[611.020797] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.224s)
[611.023004] Subtest plane-properties-atomic: SUCCESS (4.309s)
[611.837337] [155/155] (418s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-shrfb-msflip-blt)
[611.948638] Starting subtest: psrhdr-2p-primscrn-shrfb-msflip-blt
[611.953244] Subtest psrhdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[612.034425] 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.