[59.051659] Initializing watchdogs
[59.051706]   /dev/watchdog0
[59.066876] [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]
[59.071447] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.073650] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.075526] [001/133] (960s left) perf_pmu (all-busy-check-all)
[59.121775] Starting subtest: all-busy-check-all
[60.895137] Subtest all-busy-check-all: SUCCESS (1.769s)
[60.969020] [002/133] (958s left) gem_exec_reloc (basic-wc-gtt)
[61.036041] Subtest basic-wc-gtt: SKIP (0.000s)
[61.101209] [003/133] (958s left) gem_lmem_swapping (parallel-random-verify)
[61.144570] Subtest parallel-random-verify: SKIP (0.000s)
[61.172831] [004/133] (958s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[61.260126] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[61.261856] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[61.342386] [005/133] (958s left) perf_pmu (busy-idle-check-all)
[61.382195] Starting subtest: busy-idle-check-all
[61.383091] Starting dynamic subtest: rcs0
[62.032949] Dynamic subtest rcs0: SUCCESS (0.653s)
[62.042458] Starting dynamic subtest: bcs0
[62.683450] Dynamic subtest bcs0: SUCCESS (0.651s)
[62.694649] Starting dynamic subtest: vcs0
[63.893745] Dynamic subtest vcs0: SUCCESS (1.211s)
[63.903432] Starting dynamic subtest: vcs1
[65.886621] Dynamic subtest vcs1: SUCCESS (1.986s)
[65.895430] Starting dynamic subtest: vecs0
[67.933748] Dynamic subtest vecs0: SUCCESS (2.049s)
[67.942909] Starting dynamic subtest: ccs0
[68.583903] Dynamic subtest ccs0: SUCCESS (0.659s)
[68.584990] Subtest busy-idle-check-all: SUCCESS (7.216s)
[68.685876] [006/133] (951s left) gem_userptr_blits (access-control)
[68.758843] Starting subtest: access-control
[68.760998] Subtest access-control: SKIP (0.000s)
[68.885643] [007/133] (950s left) gen9_exec_parse (shadow-peek)
[68.958314] Subtest shadow-peek: SKIP (0.000s)
[69.022346] [008/133] (950s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[69.070441] Starting subtest: single-wait-for-submit-available-signaled
[69.071714] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.001s)
[69.198848] [009/133] (950s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[69.295851] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[69.297741] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[69.386902] [010/133] (950s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[69.496893] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[80.710808] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.219s)
[81.590057] [011/133] (938s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[81.686080] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[81.687079] Starting dynamic subtest: pipe-A-eDP-1
[81.695989] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[81.702675] Starting dynamic subtest: pipe-B-eDP-1
[81.711355] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[81.717762] Starting dynamic subtest: pipe-C-eDP-1
[81.726219] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[81.732442] Starting dynamic subtest: pipe-D-eDP-1
[81.741187] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[81.742750] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[83.936285] [012/133] (936s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[83.994173] Subtest writes-after-reads-uncached: SKIP (0.000s)
[84.060952] [013/133] (935s left) kms_prop_blob (blob-multiple)
[84.121367] Starting subtest: blob-multiple
[84.124057] Subtest blob-multiple: SUCCESS (0.002s)
[84.217246] [014/133] (935s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[84.313361] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[84.315210] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[84.383548] [015/133] (935s left) gem_softpin (evict-active)
[84.442245] Starting subtest: evict-active
[84.446648] Subtest evict-active: SUCCESS (0.006s)
[84.557993] [016/133] (935s left) kms_cursor_crc (cursor-sliding-128x42)
[84.770188] Starting subtest: cursor-sliding-128x42
[84.814663] Subtest cursor-sliding-128x42: SKIP (0.043s)
[85.021837] [017/133] (935s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[85.104384] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[85.106291] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[85.189323] [018/133] (934s left) gem_exec_fence (invalid-fence-array)
[85.622794] Starting subtest: invalid-fence-array
[85.625440] Subtest invalid-fence-array: SUCCESS (0.002s)
[86.934624] [FACT gem_exec_fence (invalid-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[86.936699] [019/133] (933s left) api_intel_allocator (open-vm)
[86.981047] Starting subtest: open-vm
[86.983281] Subtest open-vm: SUCCESS (0.003s)
[87.087671] [020/133] (933s left) gem_ctx_param (invalid-set-no-zeromap)
[87.137030] Starting subtest: invalid-set-no-zeromap
[87.138061] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[87.198932] [021/133] (933s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[87.310763] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[87.312385] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[87.449199] [022/133] (932s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[87.535876] Starting subtest: y-tiled-16bpp-rotate-270
[87.537557] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[87.624689] [023/133] (932s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[87.719720] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[87.721314] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[87.830954] [024/133] (932s left) kms_psr (psr-cursor-mmap-cpu)
[87.930263] Starting subtest: psr-cursor-mmap-cpu
[87.931075] Starting dynamic subtest: eDP-1
[89.626967] Dynamic subtest eDP-1: SUCCESS (1.697s)
[89.627861] Subtest psr-cursor-mmap-cpu: SUCCESS (1.698s)
[90.494459] [025/133] (929s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[90.626888] Starting subtest: short-flip-after-cursor-toggle
[91.540354] Subtest short-flip-after-cursor-toggle: SUCCESS (0.913s)
[92.431897] [026/133] (927s left) gem_exec_reloc (basic-wc-read)
[92.481708] Subtest basic-wc-read: SKIP (0.000s)
[92.541661] [027/133] (927s left) fbdev (read)
[92.577364] Starting subtest: read
[93.183606] Subtest read: SUCCESS (0.597s)
[93.234971] [028/133] (927s left) kms_psr (pr-sprite-render)
[93.326913] Starting subtest: pr-sprite-render
[93.328452] Subtest pr-sprite-render: SKIP (0.000s)
[93.406829] [029/133] (927s left) gem_softpin (evict-prime)
[93.466998] Starting subtest: evict-prime
[93.468078] Starting dynamic subtest: rcs0
[94.628510] Dynamic subtest rcs0: SUCCESS (1.161s)
[94.639513] Starting dynamic subtest: bcs0
[95.754456] Dynamic subtest bcs0: SUCCESS (1.124s)
[95.765237] Starting dynamic subtest: vcs0
[98.843314] Dynamic subtest vcs0: SUCCESS (3.078s)
[98.854039] Starting dynamic subtest: vcs1
[100.897500] Dynamic subtest vcs1: SUCCESS (2.053s)
[100.908667] Starting dynamic subtest: vecs0
[102.873465] Dynamic subtest vecs0: SUCCESS (1.974s)
[102.885501] Starting dynamic subtest: ccs0
[103.999525] Dynamic subtest ccs0: SUCCESS (1.134s)
[104.015422] Starting dynamic subtest: all
[105.888376] Dynamic subtest all: SUCCESS (1.878s)
[105.889604] Subtest evict-prime: SUCCESS (12.414s)
[105.955076] [030/133] (914s left) gen7_exec_parse (chained-batch)
[106.005247] Subtest chained-batch: SKIP (0.000s)
[106.065624] [031/133] (914s left) tools_test (sysfs_l3_parity)
[106.109145] Starting subtest: sysfs_l3_parity
[106.181631] Subtest sysfs_l3_parity: SKIP (0.076s)
[106.231302] [032/133] (914s left) gem_pxp (create-protected-buffer)
[106.354670] Starting subtest: create-protected-buffer
[106.355635] Subtest create-protected-buffer: SUCCESS (0.000s)
[106.456117] [033/133] (914s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[106.551778] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[106.553227] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[107.650719] [034/133] (913s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[107.748890] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[107.750621] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[107.831273] [035/133] (912s left) syncobj_timeline (invalid-query-illegal-handle)
[107.882621] Starting subtest: invalid-query-illegal-handle
[107.883457] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[107.985121] [036/133] (912s left) kms_cursor_crc (cursor-sliding-max-size)
[108.255484] Starting subtest: cursor-sliding-max-size
[108.257741] Subtest cursor-sliding-max-size: SKIP (0.000s)
[108.372989] [037/133] (912s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[108.455591] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[108.457166] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[108.532481] [038/133] (912s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[108.907735] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[109.759170] [039/133] (911s left) kms_flip (2x-flip-vs-panning-vs-hang)
[109.851067] Starting subtest: 2x-flip-vs-panning-vs-hang
[109.861496] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.011s)
[109.938852] [040/133] (910s left) kms_atomic_interruptible (legacy-cursor)
[110.035399] Starting subtest: legacy-cursor
[110.037383] Starting dynamic subtest: pipe-A-eDP-1
[117.402343] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.364s)
[117.403233] Subtest legacy-cursor: SUCCESS (7.367s)
[118.252519] [041/133] (902s left) gem_render_linear_blits (basic)
[118.309255] Starting subtest: basic
[118.330487] Subtest basic: SUCCESS (0.021s)
[118.448104] [042/133] (902s left) gem_madvise (dontneed-before-mmap)
[118.476424] Starting subtest: dontneed-before-mmap
[118.498518] Subtest dontneed-before-mmap: SUCCESS (0.023s)
[118.616962] [043/133] (902s left) i915_query (query-topology-unsupported)
[118.676416] Starting subtest: query-topology-unsupported
[118.678097] Subtest query-topology-unsupported: SKIP (0.000s)
[118.775805] [044/133] (902s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[118.864260] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[118.865791] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[118.959728] [045/133] (902s left) gem_pxp (regular-baseline-src-copy-readible)
[119.020333] Starting subtest: regular-baseline-src-copy-readible
[119.080378] Subtest regular-baseline-src-copy-readible: SUCCESS (0.059s)
[119.190928] [046/133] (901s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[119.285339] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[119.286292] Starting dynamic subtest: pipe-A-eDP-1
[119.295166] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[119.302335] Starting dynamic subtest: pipe-B-eDP-1
[119.310100] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[119.317219] Starting dynamic subtest: pipe-C-eDP-1
[119.324761] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[119.331656] Starting dynamic subtest: pipe-D-eDP-1
[119.339362] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[119.340881] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[121.632949] [047/133] (899s left) i915_pm_rps (thresholds)
[121.695770] Starting subtest: thresholds
[121.697540] Subtest thresholds: SKIP (0.000s)
[121.789927] [048/133] (899s left) sysfs_heartbeat_interval (mixed)
[121.846040] Starting subtest: mixed
[121.846781] Starting dynamic subtest: vecs0
[127.103954] Dynamic subtest vecs0: SUCCESS (5.257s)
[127.113513] Starting dynamic subtest: ccs0
[132.290489] Dynamic subtest ccs0: SUCCESS (5.185s)
[132.298616] Starting dynamic subtest: vcs0
[137.477863] Dynamic subtest vcs0: SUCCESS (5.186s)
[137.488629] Starting dynamic subtest: bcs0
[142.656577] Dynamic subtest bcs0: SUCCESS (5.176s)
[142.665885] Starting dynamic subtest: rcs0
[147.820970] Dynamic subtest rcs0: SUCCESS (5.162s)
[147.831600] Starting dynamic subtest: vcs1
[153.036521] Dynamic subtest vcs1: SUCCESS (5.214s)
[153.038515] Subtest mixed: SUCCESS (31.190s)
[153.132336] [049/133] (868s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[153.246025] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[154.225400] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.980s)
[154.329838] [050/133] (866s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[154.428428] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[154.430038] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[154.523899] [051/133] (866s left) kms_psr (fbc-psr2-primary-page-flip)
[154.610415] Starting subtest: fbc-psr2-primary-page-flip
[154.611377] Starting dynamic subtest: eDP-1
[154.613182] Dynamic subtest eDP-1: SKIP (0.000s)
[154.614967] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[154.695164] [052/133] (866s left) gem_exec_reloc (basic-gtt-read-noreloc)
[154.755359] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[154.825522] [053/133] (866s left) gem_userptr_blits (userfault)
[154.877424] Starting subtest: userfault
[154.882247] Subtest userfault: SUCCESS (0.007s)
[155.017876] [054/133] (866s left) kms_rotation_crc (sprite-rotation-90)
[155.099266] Starting subtest: sprite-rotation-90
[155.100919] Subtest sprite-rotation-90: SKIP (0.001s)
[155.168753] [055/133] (866s left) gem_exercise_blt (fast-copy)
[155.217069] Starting subtest: fast-copy
[155.218028] Starting dynamic subtest: linear-smem-smem
[155.246285] Dynamic subtest linear-smem-smem: SUCCESS (0.029s)
[155.256264] Starting dynamic subtest: xmajor-smem-smem
[155.264520] Dynamic subtest xmajor-smem-smem: SUCCESS (0.018s)
[155.271778] Starting dynamic subtest: tile4-smem-smem
[155.282189] Dynamic subtest tile4-smem-smem: SUCCESS (0.017s)
[155.289528] Starting dynamic subtest: tile64-smem-smem
[155.300728] Dynamic subtest tile64-smem-smem: SUCCESS (0.018s)
[155.301849] Subtest fast-copy: SUCCESS (0.084s)
[155.439769] [056/133] (866s left) kms_chamelium_frames (dp-crc-fast)
[155.858552] Subtest dp-crc-fast: SKIP (0.000s)
[156.625876] [057/133] (864s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[156.720544] Starting subtest: extended-pageflip-modeset-hang-oldfb
[156.721543] Starting dynamic subtest: pipe-A
[164.611729] Dynamic subtest pipe-A: SUCCESS (7.890s)
[164.620513] Starting dynamic subtest: pipe-D
[173.256504] Dynamic subtest pipe-D: SUCCESS (8.642s)
[173.257518] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.537s)
[174.114417] [058/133] (847s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[174.169710] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[174.234161] [059/133] (847s left) kms_vrr (seamless-rr-switch-drrs)
[174.323461] Starting subtest: seamless-rr-switch-drrs
[174.325938] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[174.406504] [060/133] (847s left) kms_vblank (wait-forked-busy-hang)
[174.485253] Starting subtest: wait-forked-busy-hang
[174.486124] Starting dynamic subtest: pipe-A-eDP-1
[200.727461] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.239s)
[200.736347] Starting dynamic subtest: pipe-D-eDP-1
[215.706883] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.977s)
[215.707806] Subtest wait-forked-busy-hang: SUCCESS (41.221s)
[216.581744] [061/133] (805s left) kms_flip (flip-vs-rmfb-interruptible)
[216.685058] Starting subtest: flip-vs-rmfb-interruptible
[216.687333] Starting dynamic subtest: A-eDP1
[225.362060] Dynamic subtest A-eDP1: SUCCESS (8.674s)
[225.372340] Starting dynamic subtest: B-eDP1
[233.991368] Dynamic subtest B-eDP1: SUCCESS (8.626s)
[234.001362] Starting dynamic subtest: C-eDP1
[242.606590] Dynamic subtest C-eDP1: SUCCESS (8.612s)
[242.619847] Starting dynamic subtest: D-eDP1
[251.235067] Dynamic subtest D-eDP1: SUCCESS (8.627s)
[251.239184] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.553s)
[252.420257] [062/133] (769s left) kms_scaling_modes (scaling-mode-full)
[252.510358] Starting subtest: scaling-mode-full
[252.511247] Starting dynamic subtest: pipe-A-eDP-1
[252.610814] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.100s)
[252.631058] Starting dynamic subtest: pipe-B-eDP-1
[253.754125] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.140s)
[253.763478] Starting dynamic subtest: pipe-C-eDP-1
[254.974425] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.211s)
[254.982956] Starting dynamic subtest: pipe-D-eDP-1
[256.109201] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.139s)
[256.111977] Subtest scaling-mode-full: SUCCESS (3.601s)
[257.254567] [063/133] (764s left) core_setmaster (master-drop-set-shared-fd)
[257.342869] Starting subtest: master-drop-set-shared-fd
[257.351093] Subtest master-drop-set-shared-fd: SUCCESS (0.011s)
[257.382153] [064/133] (764s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[257.478015] Starting subtest: psr-rgb565-draw-mmap-cpu
[264.308527] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.833s)
[264.445090] [065/133] (757s left) gem_mmap_offset (partial-mmap)
[264.505892] Starting subtest: partial-mmap
[264.506832] Starting dynamic subtest: smem0
[264.512252] Dynamic subtest smem0: SUCCESS (0.006s)
[264.513104] Subtest partial-mmap: SUCCESS (0.007s)
[264.638815] [066/133] (757s left) gem_ccs (large-ctrl-surf-copy)
[264.685704] Starting subtest: large-ctrl-surf-copy
[264.687658] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[264.798248] [067/133] (757s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[264.897372] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[264.909381] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.011s)
[265.002978] [068/133] (756s left) gem_mmap_gtt (basic-small-bo)
[265.056973] Subtest basic-small-bo: SKIP (0.000s)
[265.114759] [069/133] (756s left) kms_pm_rpm (pm-caching)
[267.035500] Starting subtest: pm-caching
[267.037657] Subtest pm-caching: SKIP (0.000s)
[267.416152] [070/133] (754s left) gem_exec_balancer (full-late-pulse)
[267.472271] Starting subtest: full-late-pulse
[271.839420] Subtest full-late-pulse: SUCCESS (4.367s)
[272.160193] [071/133] (749s left) kms_plane_scaling (planes-downscale-factor-0-5)
[272.258333] Starting subtest: planes-downscale-factor-0-5
[272.259435] Starting dynamic subtest: pipe-A
[272.277218] Dynamic subtest pipe-A: SKIP (0.018s)
[272.285042] Starting dynamic subtest: pipe-B
[272.309135] Dynamic subtest pipe-B: SKIP (0.031s)
[272.318199] Starting dynamic subtest: pipe-C
[272.342500] Dynamic subtest pipe-C: SKIP (0.031s)
[272.353609] Starting dynamic subtest: pipe-D
[272.372802] Dynamic subtest pipe-D: SKIP (0.031s)
[272.374834] Subtest planes-downscale-factor-0-5: SKIP (0.114s)
[272.487391] [072/133] (749s left) kms_psr (fbc-psr-sprite-blt)
[272.583385] Starting subtest: fbc-psr-sprite-blt
[272.584225] Starting dynamic subtest: eDP-1
[272.585836] Dynamic subtest eDP-1: SKIP (0.000s)
[272.587397] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[272.668392] [073/133] (749s left) i915_pm_rc6_residency (rc6-idle)
[272.719671] Starting subtest: rc6-idle
[272.743570] Starting dynamic subtest: gt0-rcs0
[297.047288] Dynamic subtest gt0-rcs0: SUCCESS (24.302s)
[297.056041] Starting dynamic subtest: gt0-bcs0
[321.420259] Dynamic subtest gt0-bcs0: SUCCESS (24.370s)
[321.430939] Starting dynamic subtest: gt0-ccs0
[345.702638] Dynamic subtest gt0-ccs0: SUCCESS (24.279s)
[345.715019] Starting dynamic subtest: gt1-vcs0
[351.924077] Dynamic subtest gt1-vcs0: SUCCESS (6.170s)
[351.935287] Starting dynamic subtest: gt1-vecs0
[358.094981] Dynamic subtest gt1-vecs0: SUCCESS (6.170s)
[358.096148] Subtest rc6-idle: SUCCESS (85.328s)
[358.127346] [074/133] (664s left) kms_plane_alpha_blend (constant-alpha-max)
[358.221175] Starting subtest: constant-alpha-max
[358.528060] Starting dynamic subtest: pipe-A-eDP-1
[359.618053] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.090s)
[359.628341] Starting dynamic subtest: pipe-D-eDP-1
[361.279501] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.660s)
[361.280384] Subtest constant-alpha-max: SUCCESS (3.059s)
[362.085994] [075/133] (660s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[362.175488] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[362.177261] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[362.279719] [076/133] (659s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[362.370573] Starting subtest: plane-use-after-nonblocking-unbind
[362.371495] Starting dynamic subtest: pipe-A-eDP-1
[362.441082] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.070s)
[362.757283] Starting dynamic subtest: pipe-B-eDP-1
[363.593374] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.844s)
[363.879988] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.509s)
[364.751162] [077/133] (657s left) kms_pm_rpm (dpms-non-lpsp)
[367.087735] Starting subtest: dpms-non-lpsp
[367.089905] Subtest dpms-non-lpsp: SKIP (0.001s)
[367.490813] [078/133] (654s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[367.583340] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[374.369631] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.786s)
[374.502160] [079/133] (647s left) kms_plane_lowres (tiling-yf)
[374.592275] Starting subtest: tiling-yf
[374.594031] Subtest tiling-yf: SKIP (0.000s)
[374.678721] [080/133] (647s left) gem_exec_reloc (basic-gtt-read)
[374.735780] Subtest basic-gtt-read: SKIP (0.000s)
[374.811373] [081/133] (647s left) kms_universal_plane (universal-plane-pageflip-windowed)
[374.906333] Starting subtest: universal-plane-pageflip-windowed
[374.907299] Starting dynamic subtest: pipe-A-eDP-1
[375.511965] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.603s)
[375.520049] Starting dynamic subtest: pipe-B-eDP-1
[376.743694] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.231s)
[376.752784] Starting dynamic subtest: pipe-C-eDP-1
[377.960649] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.215s)
[377.968261] Starting dynamic subtest: pipe-D-eDP-1
[379.192749] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.230s)
[379.193712] Subtest universal-plane-pageflip-windowed: SUCCESS (4.286s)
[380.043357] [082/133] (642s left) kms_atomic_transition (modeset-transition-fencing)
[380.139408] Starting subtest: modeset-transition-fencing
[380.140261] Starting dynamic subtest: 1x-outputs
[391.038805] Dynamic subtest 1x-outputs: SUCCESS (10.898s)
[391.040061] Subtest modeset-transition-fencing: SUCCESS (10.899s)
[391.893402] [083/133] (630s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[391.993687] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[399.318084] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.325s)
[399.401089] [084/133] (623s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[399.502361] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[406.148563] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.646s)
[406.281507] [085/133] (616s left) gem_exec_reloc (basic-wc-gtt-active)
[406.329544] Subtest basic-wc-gtt-active: SKIP (0.000s)
[406.388950] [086/133] (616s left) gem_exec_flush (basic-wb-ro-before-default)
[406.438501] Starting subtest: basic-wb-ro-before-default
[411.891919] Subtest basic-wb-ro-before-default: SUCCESS (5.452s)
[412.083178] [087/133] (610s left) gem_ctx_shared (create-shared-gtt)
[412.151262] Starting subtest: create-shared-gtt
[414.350174] Subtest create-shared-gtt: SUCCESS (2.154s)
[414.588093] [088/133] (608s left) kms_big_fb (4-tiled-addfb-size-overflow)
[414.675608] Starting subtest: 4-tiled-addfb-size-overflow
[414.676706] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[414.765676] [089/133] (607s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[414.849349] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[414.850957] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[414.940964] [090/133] (607s left) gem_exec_schedule (in-order)
[415.004703] Starting subtest: in-order
[415.005853] Starting dynamic subtest: rcs0
[415.112206] Dynamic subtest rcs0: SUCCESS (0.107s)
[415.125152] Starting dynamic subtest: vcs0
[415.200650] Dynamic subtest vcs0: SUCCESS (0.086s)
[415.211515] Starting dynamic subtest: vcs1
[415.279777] Dynamic subtest vcs1: SUCCESS (0.078s)
[415.290182] Starting dynamic subtest: vecs0
[415.370891] Dynamic subtest vecs0: SUCCESS (0.090s)
[415.383756] Starting dynamic subtest: ccs0
[415.453572] Dynamic subtest ccs0: SUCCESS (0.080s)
[415.454976] Subtest in-order: SUCCESS (0.448s)
[416.999363] [091/133] (605s left) i915_module_load (reload)
[417.028883] Starting subtest: reload
[421.790862] Subtest reload: SUCCESS (4.762s)
[421.835243] [092/133] (600s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[422.944855] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[422.945631] Starting dynamic subtest: pipe-A-eDP-1
[425.155306] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.210s)
[425.163608] Starting dynamic subtest: pipe-B-eDP-1
[427.494971] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.338s)
[427.503271] Starting dynamic subtest: pipe-C-eDP-1
[429.649128] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.153s)
[429.657862] Starting dynamic subtest: pipe-D-eDP-1
[431.752509] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.102s)
[431.754311] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.809s)
[432.980552] [093/133] (589s left) kms_content_protection (dp-mst-type-0)
[433.123539] Starting subtest: dp-mst-type-0
[433.125646] Subtest dp-mst-type-0: SKIP (0.000s)
[433.240980] [094/133] (589s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[433.303597] Starting subtest: invalid-multi-wait-all-unsubmitted
[433.304828] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[433.399984] [095/133] (589s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[433.498675] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[440.037637] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.540s)
[440.154006] [096/133] (582s left) gem_ctx_sseu (engines)
[440.208117] Subtest engines: SKIP (0.000s)
[440.267362] [097/133] (582s left) gem_exec_reloc (basic-cpu-read)
[440.312928] Subtest basic-cpu-read: SKIP (0.000s)
[440.382419] [098/133] (582s left) gem_exec_params (mmapped)
[440.431823] Starting subtest: mmapped
[440.435021] Subtest mmapped: SUCCESS (0.003s)
[440.535300] [099/133] (582s left) syncobj_wait (wait-all-delayed-signal)
[440.590213] Starting subtest: wait-all-delayed-signal
[440.693751] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[440.782501] [100/133] (582s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[440.869821] Starting subtest: yf-tiled-addfb-size-overflow
[440.871621] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[440.972684] [101/133] (582s left) kms_cursor_crc (cursor-offscreen-256x256)
[441.219772] Starting subtest: cursor-offscreen-256x256
[441.220857] Starting dynamic subtest: pipe-A-eDP-1
[443.168891] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.948s)
[443.196874] Starting dynamic subtest: pipe-D-eDP-1
[445.811506] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.620s)
[445.812415] Subtest cursor-offscreen-256x256: SUCCESS (4.594s)
[446.655569] [102/133] (576s left) gem_exec_schedule (submit-golden-slice)
[446.715692] Starting subtest: submit-golden-slice
[446.717277] Starting dynamic subtest: rcs0
[446.752409] Dynamic subtest rcs0: SUCCESS (0.036s)
[446.763473] Starting dynamic subtest: bcs0
[446.786679] Dynamic subtest bcs0: SUCCESS (0.033s)
[446.793822] Starting dynamic subtest: vcs0
[446.819760] Dynamic subtest vcs0: SUCCESS (0.032s)
[446.826855] Starting dynamic subtest: vcs1
[446.857408] Dynamic subtest vcs1: SUCCESS (0.036s)
[446.865920] Starting dynamic subtest: vecs0
[446.888790] Dynamic subtest vecs0: SUCCESS (0.031s)
[446.896308] Starting dynamic subtest: ccs0
[446.925322] Dynamic subtest ccs0: SUCCESS (0.035s)
[446.926519] Subtest submit-golden-slice: SUCCESS (0.210s)
[447.982172] [103/133] (575s left) kms_lease (multimaster-lease)
[448.062307] Starting subtest: multimaster-lease
[448.065262] Subtest multimaster-lease: SUCCESS (0.004s)
[448.166839] [104/133] (575s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[448.252900] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[448.254638] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[448.343621] [105/133] (574s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[448.428996] Starting subtest: pr-primary-plane-update-sf-dmg-area
[448.430771] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[448.499333] [106/133] (574s left) kms_dp_aux_dev (basic)
[448.564042] Starting subtest: basic
[448.786107] Subtest basic: SUCCESS (0.222s)
[448.854507] [107/133] (574s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[448.945607] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[448.947422] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[449.040491] [108/133] (574s left) gem_exec_endless (dispatch)
[449.100695] Starting subtest: dispatch
[449.101632] Starting dynamic subtest: rcs0
[449.104490] Dynamic subtest rcs0: SUCCESS (0.005s)
[449.113156] Starting dynamic subtest: bcs0
[449.114916] Dynamic subtest bcs0: SUCCESS (0.004s)
[449.122329] Starting dynamic subtest: vcs0
[449.124086] Dynamic subtest vcs0: SUCCESS (0.005s)
[449.131303] Starting dynamic subtest: vcs1
[449.133241] Dynamic subtest vcs1: SUCCESS (0.005s)
[449.140638] Starting dynamic subtest: vecs0
[449.142409] Dynamic subtest vecs0: SUCCESS (0.005s)
[449.149501] Starting dynamic subtest: ccs0
[449.151120] Dynamic subtest ccs0: SUCCESS (0.004s)
[449.151940] Subtest dispatch: SUCCESS (0.032s)
[450.953224] [109/133] (572s left) gem_exec_whisper (basic-fds-all)
[451.014473] Starting subtest: basic-fds-all
[460.862962] Subtest basic-fds-all: SUCCESS (9.837s)
[461.038386] [110/133] (562s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[461.133199] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[467.728470] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.596s)
[467.857290] [111/133] (555s left) kms_color (ctm-max)
[467.953478] Starting subtest: ctm-max
[467.954768] Starting dynamic subtest: pipe-A-eDP-1
[468.662658] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s)
[468.670292] Starting dynamic subtest: pipe-B-eDP-1
[470.111393] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.448s)
[470.119207] Starting dynamic subtest: pipe-C-eDP-1
[471.486575] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.373s)
[471.494203] Starting dynamic subtest: pipe-D-eDP-1
[472.811144] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.325s)
[472.811950] Subtest ctm-max: SUCCESS (4.858s)
[473.626487] [112/133] (549s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[473.718614] Starting subtest: async-flip-with-page-flip-events-linear
[474.090537] Starting dynamic subtest: pipe-A-eDP-1
[476.902580] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.802s)
[477.271767] Starting dynamic subtest: pipe-B-eDP-1
[480.038792] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.764s)
[480.410645] Starting dynamic subtest: pipe-C-eDP-1
[483.171927] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.757s)
[483.542430] Starting dynamic subtest: pipe-D-eDP-1
[486.300192] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.754s)
[486.301743] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.572s)
[487.474662] [113/133] (536s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[487.530589] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[487.560551] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.009s)
[487.606267] [114/133] (535s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[487.701921] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[487.703677] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[487.803355] [115/133] (535s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[487.855466] Starting subtest: invalid-bsd2-flag-on-vebox
[487.856520] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[487.944269] [116/133] (535s left) kms_invalid_mode (bad-vsync-start)
[488.025353] Starting subtest: bad-vsync-start
[488.026297] Starting dynamic subtest: pipe-A-eDP-1
[488.311040] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[488.320219] Starting dynamic subtest: pipe-B-eDP-1
[488.321128] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[488.328414] Starting dynamic subtest: pipe-C-eDP-1
[488.329181] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[488.336368] Starting dynamic subtest: pipe-D-eDP-1
[488.337161] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[488.338020] Subtest bad-vsync-start: SUCCESS (0.292s)
[489.116719] [117/133] (534s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[489.211578] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[490.191549] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.980s)
[490.309856] [118/133] (533s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[490.400244] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[500.191188] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.791s)
[500.309818] [119/133] (523s left) kms_psr (fbc-pr-primary-mmap-cpu)
[500.406667] Starting subtest: fbc-pr-primary-mmap-cpu
[500.408501] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[500.488825] [120/133] (523s left) gem_caching (writes)
[500.536043] Subtest writes: SKIP (0.000s)
[500.591770] [121/133] (523s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[500.675448] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[500.676523] Starting dynamic subtest: pipe-A-eDP-1
[500.692780] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[500.705983] Starting dynamic subtest: pipe-B-eDP-1
[500.713979] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[500.721558] Starting dynamic subtest: pipe-C-eDP-1
[500.728827] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[500.736243] Starting dynamic subtest: pipe-D-eDP-1
[500.743429] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[500.744257] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[502.857387] [122/133] (520s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[502.945449] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[502.947261] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s)
[503.018916] [123/133] (520s left) gem_ctx_param (set-priority-invalid-size)
[503.086503] Starting subtest: set-priority-invalid-size
[503.087562] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[503.159068] [124/133] (520s left) kms_dsc (dsc-with-bpc)
[503.253871] Starting subtest: dsc-with-bpc
[503.265405] Subtest dsc-with-bpc: SKIP (0.001s)
[503.324828] [125/133] (520s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[503.378308] Starting subtest: yf-tiled-ccs-to-y-tiled
[503.380039] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[503.570897] [126/133] (520s left) kms_flip (2x-modeset-vs-vblank-race)
[503.663689] Starting subtest: 2x-modeset-vs-vblank-race
[503.680308] Subtest 2x-modeset-vs-vblank-race: SKIP (0.017s)
[503.761238] [127/133] (520s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[503.819473] Starting subtest: multi-wait-available-submitted-signaled
[503.820365] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s)
[503.913796] [128/133] (520s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[504.002633] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[508.227031] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.225s)
[509.375249] [129/133] (514s left) api_intel_bb (object-reloc-keep-cache)
[509.423778] Starting subtest: object-reloc-keep-cache
[509.426046] Subtest object-reloc-keep-cache: SKIP (0.003s)
[509.523438] [130/133] (514s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[509.608519] Starting subtest: plane-downscale-factor-0-5-with-rotation
[509.609422] Starting dynamic subtest: pipe-A
[509.628997] Dynamic subtest pipe-A: SKIP (0.019s)
[509.639815] Starting dynamic subtest: pipe-B
[509.667580] Dynamic subtest pipe-B: SKIP (0.037s)
[509.675123] Starting dynamic subtest: pipe-C
[509.700196] Dynamic subtest pipe-C: SKIP (0.031s)
[509.711823] Starting dynamic subtest: pipe-D
[509.731953] Dynamic subtest pipe-D: SKIP (0.031s)
[509.733577] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.121s)
[509.834593] [131/133] (514s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[509.928550] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[516.677764] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.750s)
[516.788823] [132/133] (507s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[516.831487] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[516.949026] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.105s)
[517.009674] [133/133] (507s left) kms_addfb_basic (unused-pitches)
[517.056390] Starting subtest: unused-pitches
[517.057239] Subtest unused-pitches: SUCCESS (0.000s)
[517.180618] Closing watchdogs
results: parsing output: 0/ for test: perf_pmu
results: parsing output: 1/ for test: gem_exec_reloc
results: parsing output: 2/ for test: gem_lmem_swapping
results: parsing output: 3/ for test: kms_flip_scaled_crc
results: parsing output: 4/ for test: perf_pmu
results: parsing output: 5/ for test: gem_userptr_blits
results: parsing output: 6/ for test: gen9_exec_parse
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_cursor_legacy
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: gem_partial_pwrite_pread
results: parsing output: 12/ for test: kms_prop_blob
results: parsing output: 13/ for test: kms_flip_scaled_crc
results: parsing output: 14/ for test: gem_softpin
results: parsing output: 15/ for test: kms_cursor_crc
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_exec_fence
results: parsing output: 18/ for test: api_intel_allocator
results: parsing output: 19/ for test: gem_ctx_param
results: parsing output: 20/ for test: kms_cursor_legacy
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: kms_cursor_legacy
results: parsing output: 25/ for test: gem_exec_reloc
results: parsing output: 26/ for test: fbdev
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: gem_softpin
results: parsing output: 29/ for test: gen7_exec_parse
results: parsing output: 30/ for test: tools_test
results: parsing output: 31/ for test: gem_pxp
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: kms_flip_scaled_crc
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: kms_cursor_crc
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_chamelium_hpd
results: parsing output: 38/ for test: kms_flip
results: parsing output: 39/ for test: kms_atomic_interruptible
results: parsing output: 40/ for test: gem_render_linear_blits
results: parsing output: 41/ for test: gem_madvise
results: parsing output: 42/ for test: i915_query
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_pxp
results: parsing output: 45/ for test: kms_ccs
results: parsing output: 46/ for test: i915_pm_rps
results: parsing output: 47/ for test: sysfs_heartbeat_interval
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: gem_exec_reloc
results: parsing output: 52/ for test: gem_userptr_blits
results: parsing output: 53/ for test: kms_rotation_crc
results: parsing output: 54/ for test: gem_exercise_blt
results: parsing output: 55/ for test: kms_chamelium_frames
results: parsing output: 56/ for test: kms_busy
results: parsing output: 57/ for test: kms_pipe_b_c_ivb
results: parsing output: 58/ for test: kms_vrr
results: parsing output: 59/ for test: kms_vblank
results: parsing output: 60/ for test: kms_flip
results: parsing output: 61/ for test: kms_scaling_modes
results: parsing output: 62/ for test: core_setmaster
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_mmap_offset
results: parsing output: 65/ for test: gem_ccs
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: gem_mmap_gtt
results: parsing output: 68/ for test: kms_pm_rpm
results: parsing output: 69/ for test: gem_exec_balancer
results: parsing output: 70/ for test: kms_plane_scaling
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: i915_pm_rc6_residency
results: parsing output: 73/ for test: kms_plane_alpha_blend
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_atomic_transition
results: parsing output: 76/ for test: kms_pm_rpm
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_plane_lowres
results: parsing output: 79/ for test: gem_exec_reloc
results: parsing output: 80/ for test: kms_universal_plane
results: parsing output: 81/ for test: kms_atomic_transition
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_exec_reloc
results: parsing output: 85/ for test: gem_exec_flush
results: parsing output: 86/ for test: gem_ctx_shared
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_exec_schedule
results: parsing output: 90/ for test: i915_module_load
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: kms_content_protection
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_ctx_sseu
results: parsing output: 96/ for test: gem_exec_reloc
results: parsing output: 97/ for test: gem_exec_params
results: parsing output: 98/ for test: syncobj_wait
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_cursor_crc
results: parsing output: 101/ for test: gem_exec_schedule
results: parsing output: 102/ for test: kms_lease
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_psr2_sf
results: parsing output: 105/ for test: kms_dp_aux_dev
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_exec_endless
results: parsing output: 108/ for test: gem_exec_whisper
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_color
results: parsing output: 111/ for test: kms_async_flips
results: parsing output: 112/ for test: sriov_basic
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_exec_params
results: parsing output: 115/ for test: kms_invalid_mode
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: gem_caching
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: kms_plane
results: parsing output: 122/ for test: gem_ctx_param
results: parsing output: 123/ for test: kms_dsc
results: parsing output: 124/ for test: gem_render_copy
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: api_intel_bb
results: parsing output: 129/ for test: kms_plane_scaling
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: syncobj_timeline
results: parsing output: 132/ for test: kms_addfb_basic
Done.