[53.561557] Initializing watchdogs
[53.561607]   /dev/watchdog0
[53.577705] [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]
[53.582463] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[53.584755] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[53.587190] [001/133] (960s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[53.644576] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[53.750011] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.103s)
[53.851710] [002/133] (960s left) gem_exec_whisper (basic-queues-forked)
[53.917554] Starting subtest: basic-queues-forked
[78.479928] Subtest basic-queues-forked: SUCCESS (24.420s)
[78.610096] [003/133] (935s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[78.704585] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[85.289673] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.583s)
[85.391869] [004/133] (928s left) api_intel_bb (bb-with-allocator)
[85.437293] Starting subtest: bb-with-allocator
[85.442012] Subtest bb-with-allocator: SUCCESS (0.006s)
[85.568615] [005/133] (928s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[85.653057] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[85.654821] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[85.746597] [006/133] (928s left) i915_drm_fdinfo (virtual-idle)
[85.778408] Starting subtest: virtual-idle
[88.845274] Subtest virtual-idle: SUCCESS (3.057s)
[88.904132] [007/133] (925s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[89.283651] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[90.050796] [008/133] (924s left) kms_chamelium_color (ctm-blue-to-red)
[90.145361] Subtest ctm-blue-to-red: SKIP (0.000s)
[90.182682] [009/133] (924s left) gem_exec_whisper (basic-normal)
[90.236572] Starting subtest: basic-normal
[93.749072] Subtest basic-normal: SUCCESS (3.510s)
[93.948829] [010/133] (920s left) gem_exec_reloc (basic-range-active)
[93.998779] Subtest basic-range-active: SKIP (0.000s)
[94.064751] [011/133] (920s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[94.154577] Starting subtest: fbcpsr-rgb565-draw-blt
[101.326815] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.172s)
[101.456343] [012/133] (913s left) kms_psr (psr-suspend)
[101.551801] Starting subtest: psr-suspend
[101.552611] Starting dynamic subtest: eDP-1
[119.456229] Dynamic subtest eDP-1: SUCCESS (4.170s)
[119.457089] Subtest psr-suspend: SUCCESS (4.171s)
[126.327157] [013/133] (894s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[126.412086] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[126.413916] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[126.502246] [014/133] (894s left) gem_userptr_blits (set-cache-level)
[126.547847] Starting subtest: set-cache-level
[126.549440] Subtest set-cache-level: SKIP (0.000s)
[126.654654] [015/133] (893s left) gem_mmap_offset (perf)
[126.703182] Starting subtest: perf
[126.704100] Starting dynamic subtest: smem0
[127.057720] Dynamic subtest smem0: SUCCESS (0.353s)
[127.058871] Subtest perf: SUCCESS (0.353s)
[127.157621] [016/133] (893s left) gem_flink_basic (bad-open)
[127.205084] Starting subtest: bad-open
[127.205913] Subtest bad-open: SUCCESS (0.000s)
[127.309183] [017/133] (893s left) syncobj_basic (bad-destroy)
[127.351663] Starting subtest: bad-destroy
[127.352610] Subtest bad-destroy: SUCCESS (0.000s)
[127.437883] [018/133] (893s left) kms_flip_event_leak (basic)
[127.526276] Starting subtest: basic
[127.527323] Starting dynamic subtest: pipe-A-eDP-1
[127.967934] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.433s)
[127.978208] Starting dynamic subtest: pipe-B-eDP-1
[129.075879] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.090s)
[129.084169] Starting dynamic subtest: pipe-C-eDP-1
[130.195781] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.104s)
[130.205277] Starting dynamic subtest: pipe-D-eDP-1
[131.345754] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.135s)
[131.346702] Subtest basic: SUCCESS (3.767s)
[132.205999] [019/133] (888s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[132.307331] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[132.309307] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[132.374862] [020/133] (888s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[132.468733] Starting subtest: fbc-rgb565-draw-pwrite
[137.155292] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.654s)
[138.354079] [021/133] (882s left) kms_flip (absolute-wf_vblank-interruptible)
[138.452889] Starting subtest: absolute-wf_vblank-interruptible
[138.455412] Starting dynamic subtest: A-eDP1
[147.251732] Dynamic subtest A-eDP1: SUCCESS (8.745s)
[147.259901] Starting dynamic subtest: B-eDP1
[155.998818] Dynamic subtest B-eDP1: SUCCESS (8.732s)
[156.016041] Starting dynamic subtest: C-eDP1
[164.738227] Dynamic subtest C-eDP1: SUCCESS (8.725s)
[164.747776] Starting dynamic subtest: D-eDP1
[173.464304] Dynamic subtest D-eDP1: SUCCESS (8.723s)
[173.465409] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.935s)
[174.625570] [022/133] (846s left) gem_mmap_wc (fault-concurrent)
[174.670751] Subtest fault-concurrent: SKIP (0.000s)
[174.735964] [023/133] (846s left) gen9_exec_parse (batch-invalid-length)
[174.807111] Subtest batch-invalid-length: SKIP (0.000s)
[174.871614] [024/133] (845s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[174.975164] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[181.769228] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.792s)
[181.875096] [025/133] (839s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[181.976672] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[181.977680] Starting dynamic subtest: pipe-A-eDP-1
[181.985718] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[181.994541] Starting dynamic subtest: pipe-B-eDP-1
[182.002222] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[182.010024] Starting dynamic subtest: pipe-C-eDP-1
[182.017431] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[182.025098] Starting dynamic subtest: pipe-D-eDP-1
[182.038645] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[182.039525] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[184.223434] [026/133] (836s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[184.273409] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[184.274190] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.001s)
[184.360319] [027/133] (836s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[184.453424] Starting subtest: x-tiled-64bpp-rotate-0
[186.045420] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.592s)
[186.193860] [028/133] (834s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[186.286410] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[186.288087] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[186.373764] [029/133] (834s left) kms_psr (pr-primary-mmap-cpu)
[186.474382] Starting subtest: pr-primary-mmap-cpu
[186.476050] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[186.559343] [030/133] (834s left) gem_render_copy (linear-to-vebox-y-tiled)
[186.618353] Starting subtest: linear-to-vebox-y-tiled
[186.619989] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[186.799507] [031/133] (834s left) gem_exec_reloc (basic-wc-cpu)
[186.864362] Subtest basic-wc-cpu: SKIP (0.000s)
[186.935802] [032/133] (834s left) perf_pmu (busy-hang)
[186.968134] Starting subtest: busy-hang
[186.968955] Starting dynamic subtest: rcs0
[188.258791] Dynamic subtest rcs0: SUCCESS (1.289s)
[188.269011] Starting dynamic subtest: bcs0
[189.495560] Dynamic subtest bcs0: SUCCESS (1.235s)
[189.505881] Starting dynamic subtest: vcs0
[191.564606] Dynamic subtest vcs0: SUCCESS (2.068s)
[191.575636] Starting dynamic subtest: vcs1
[193.544725] Dynamic subtest vcs1: SUCCESS (1.978s)
[193.555485] Starting dynamic subtest: vecs0
[195.592257] Dynamic subtest vecs0: SUCCESS (2.045s)
[195.603251] Starting dynamic subtest: ccs0
[196.836838] Dynamic subtest ccs0: SUCCESS (1.240s)
[196.838511] Subtest busy-hang: SUCCESS (9.863s)
[196.926477] [033/133] (824s left) kms_psr (psr2-primary-render)
[197.021172] Starting subtest: psr2-primary-render
[197.022033] Starting dynamic subtest: eDP-1
[198.718175] Dynamic subtest eDP-1: SUCCESS (1.696s)
[198.719127] Subtest psr2-primary-render: SUCCESS (1.697s)
[199.579839] [034/133] (821s left) kms_pm_rpm (system-suspend-modeset)
[201.200467] Starting subtest: system-suspend-modeset
[221.600201] Subtest system-suspend-modeset: SUCCESS (5.064s)
[225.029072] [035/133] (799s left) kms_rotation_crc (sprite-rotation-180)
[225.119837] Starting subtest: sprite-rotation-180
[231.999164] Subtest sprite-rotation-180: SUCCESS (6.847s)
[233.166182] [036/133] (791s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[233.282824] Starting subtest: cursorB-vs-flipA-legacy
[233.284631] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[233.419156] [037/133] (790s left) gem_lmem_swapping (smem-oom)
[233.462623] Subtest smem-oom: SKIP (0.000s)
[233.495938] [038/133] (790s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[233.592714] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[233.593596] Starting dynamic subtest: pipe-A-eDP-1
[234.468368] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.863s)
[234.477413] Starting dynamic subtest: pipe-B-eDP-1
[236.088408] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.603s)
[236.097005] Starting dynamic subtest: pipe-C-eDP-1
[237.631589] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.530s)
[237.643074] Starting dynamic subtest: pipe-D-eDP-1
[239.203134] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.560s)
[239.204086] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.560s)
[240.351735] [039/133] (784s left) gem_exec_reloc (basic-scanout)
[240.407953] Subtest basic-scanout: SKIP (0.000s)
[240.475579] [040/133] (783s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[240.591565] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[241.572786] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.975s)
[242.389194] [041/133] (782s left) core_setmaster (master-drop-set-root)
[242.464340] Starting subtest: master-drop-set-root
[242.478977] Subtest master-drop-set-root: SUCCESS (0.015s)
[242.519276] [042/133] (781s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[242.615434] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[249.708770] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.075s)
[249.862329] [043/133] (774s left) gem_ctx_persistence (engines-mixed-process)
[249.911342] Starting subtest: engines-mixed-process
[249.912302] Starting dynamic subtest: rcs0
[251.386770] Dynamic subtest rcs0: SUCCESS (1.471s)
[251.397467] Starting dynamic subtest: bcs0
[253.361321] Dynamic subtest bcs0: SUCCESS (1.971s)
[253.370867] Starting dynamic subtest: vcs0
[255.340990] Dynamic subtest vcs0: SUCCESS (1.976s)
[255.352999] Starting dynamic subtest: vcs1
[257.394564] Dynamic subtest vcs1: SUCCESS (2.050s)
[257.403891] Starting dynamic subtest: vecs0
[259.395235] Dynamic subtest vecs0: SUCCESS (1.998s)
[259.407280] Starting dynamic subtest: ccs0
[261.425384] Dynamic subtest ccs0: SUCCESS (2.026s)
[261.426573] Subtest engines-mixed-process: SUCCESS (11.501s)
[261.498299] [044/133] (763s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[261.591363] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[261.592252] Starting dynamic subtest: pipe-A-eDP-1
[272.289672] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.696s)
[272.298301] Starting dynamic subtest: pipe-B-eDP-1
[283.690024] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.396s)
[283.691030] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.095s)
[284.534766] [045/133] (740s left) kms_cursor_crc (cursor-offscreen-256x256)
[284.793594] Starting subtest: cursor-offscreen-256x256
[284.797049] Starting dynamic subtest: pipe-A-eDP-1
[286.760864] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.964s)
[286.790411] Starting dynamic subtest: pipe-D-eDP-1
[289.353844] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.569s)
[289.354732] Subtest cursor-offscreen-256x256: SUCCESS (4.559s)
[290.198249] [046/133] (734s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[290.300973] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[290.302557] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[290.404537] [047/133] (734s left) core_debugfs (read-all-entries)
[290.449500] Starting subtest: read-all-entries
[290.531422] Subtest read-all-entries: SUCCESS (0.083s)
[290.590788] [048/133] (734s left) gem_exec_fence (expired-history)
[291.088288] Starting subtest: expired-history
[298.129445] Subtest expired-history: SUCCESS (7.029s)
[298.712417] [FACT gem_exec_fence (expired-history)] new: kernel.kmod_is_loaded.vgem: true
[298.714180] [049/133] (726s left) gem_mmap_gtt (basic-write)
[298.770344] Subtest basic-write: SKIP (0.000s)
[298.829995] [050/133] (725s left) kms_hdr (bpc-switch)
[298.917731] Starting subtest: bpc-switch
[299.985765] Starting dynamic subtest: pipe-A-eDP-1
[303.483013] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.497s)
[303.484006] Subtest bpc-switch: SUCCESS (4.565s)
[303.579376] [051/133] (721s left) syncobj_timeline (invalid-wait-illegal-handle)
[303.635724] Starting subtest: invalid-wait-illegal-handle
[303.636845] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[303.736928] [052/133] (721s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[303.833978] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[310.489102] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.652s)
[310.625515] [053/133] (714s left) gem_ctx_persistence (process)
[310.675662] Starting subtest: process
[310.850877] Subtest process: SUCCESS (0.176s)
[310.952516] [054/133] (713s left) kms_addfb_basic (too-wide)
[311.042891] Starting subtest: too-wide
[311.043901] Subtest too-wide: SUCCESS (0.000s)
[311.153964] [055/133] (713s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[311.252039] Starting subtest: fbc-psr2-sprite-mmap-gtt
[311.253060] Starting dynamic subtest: eDP-1
[311.254786] Dynamic subtest eDP-1: SKIP (0.000s)
[311.256472] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[311.320920] [056/133] (713s left) gem_sync (basic-store-all)
[311.390853] Starting subtest: basic-store-all
[315.648179] Subtest basic-store-all: SUCCESS (4.257s)
[315.841030] [057/133] (709s left) kms_dp_linktrain_fallback (dsc-fallback)
[315.934786] Starting subtest: dsc-fallback
[315.937603] Subtest dsc-fallback: SKIP (0.000s)
[316.004157] [058/133] (709s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[316.093249] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[316.094144] Starting dynamic subtest: pipe-A-eDP-1
[321.964429] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.868s)
[321.973144] Starting dynamic subtest: pipe-B-eDP-1
[328.600450] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.634s)
[328.601449] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.505s)
[329.476764] [059/133] (695s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[329.586512] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[329.588667] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[329.676502] [060/133] (695s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[329.772541] Starting subtest: fbc-indfb-scaledprimary
[332.740592] Subtest fbc-indfb-scaledprimary: SUCCESS (2.970s)
[333.888485] [061/133] (691s left) kms_psr (fbc-psr2-primary-render)
[333.981779] Starting subtest: fbc-psr2-primary-render
[333.982553] Starting dynamic subtest: eDP-1
[333.984247] Dynamic subtest eDP-1: SKIP (0.000s)
[333.985988] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[334.071705] [062/133] (691s left) prime_vgem (wait)
[334.142807] Starting subtest: wait
[334.143652] Starting dynamic subtest: rcs0
[334.199487] Dynamic subtest rcs0: SUCCESS (0.055s)
[334.207940] Starting dynamic subtest: bcs0
[334.238493] Dynamic subtest bcs0: SUCCESS (0.039s)
[334.247569] Starting dynamic subtest: vcs0
[334.282878] Dynamic subtest vcs0: SUCCESS (0.044s)
[334.291791] Starting dynamic subtest: vcs1
[334.327504] Dynamic subtest vcs1: SUCCESS (0.044s)
[334.336759] Starting dynamic subtest: vecs0
[334.374918] Dynamic subtest vecs0: SUCCESS (0.047s)
[334.383201] Starting dynamic subtest: ccs0
[334.424357] Dynamic subtest ccs0: SUCCESS (0.048s)
[334.425186] Subtest wait: SUCCESS (0.283s)
[334.541322] [063/133] (690s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[334.933521] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[335.791718] [064/133] (689s left) kms_big_fb (4-tiled-addfb)
[335.894597] Starting subtest: 4-tiled-addfb
[335.895592] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[336.002819] [065/133] (689s left) kms_invalid_mode (bad-vsync-end)
[336.099591] Starting subtest: bad-vsync-end
[336.100475] Starting dynamic subtest: pipe-A-eDP-1
[336.385712] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[336.394527] Starting dynamic subtest: pipe-B-eDP-1
[336.395688] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[336.404321] Starting dynamic subtest: pipe-C-eDP-1
[336.405256] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[336.413537] Starting dynamic subtest: pipe-D-eDP-1
[336.414553] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[336.415507] Subtest bad-vsync-end: SUCCESS (0.291s)
[337.242454] [066/133] (688s left) fbdev (info)
[337.271227] Starting subtest: info
[337.272133] Subtest info: SUCCESS (0.000s)
[337.346843] [067/133] (688s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[337.405402] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[337.469437] [068/133] (687s left) gem_create (create-ext-cpu-access-sanity-check)
[337.633074] Starting subtest: create-ext-cpu-access-sanity-check
[337.635823] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[337.702001] [069/133] (687s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[337.791808] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[337.793572] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[337.888318] [070/133] (687s left) gem_userptr_blits (sync-unmap-after-close)
[337.949591] Starting subtest: sync-unmap-after-close
[337.958886] Subtest sync-unmap-after-close: SUCCESS (0.011s)
[338.097418] [071/133] (687s left) gem_ctx_shared (exec-single-timeline)
[338.149044] Starting subtest: exec-single-timeline
[338.149966] Starting dynamic subtest: rcs0
[339.215088] Dynamic subtest rcs0: SUCCESS (1.056s)
[339.231142] Starting dynamic subtest: bcs0
[340.303695] Dynamic subtest bcs0: SUCCESS (1.085s)
[340.312592] Starting dynamic subtest: vcs0
[341.392726] Dynamic subtest vcs0: SUCCESS (1.086s)
[341.404886] Starting dynamic subtest: vcs1
[342.480461] Dynamic subtest vcs1: SUCCESS (1.085s)
[342.492668] Starting dynamic subtest: vecs0
[343.568266] Dynamic subtest vecs0: SUCCESS (1.085s)
[343.580079] Starting dynamic subtest: ccs0
[344.656137] Dynamic subtest ccs0: SUCCESS (1.085s)
[344.657407] Subtest exec-single-timeline: SUCCESS (6.501s)
[345.444082] [072/133] (680s left) kms_plane (plane-panning-top-left)
[345.545022] Starting subtest: plane-panning-top-left
[345.546029] Starting dynamic subtest: pipe-A
[347.258378] Dynamic subtest pipe-A: SUCCESS (1.714s)
[347.268272] Starting dynamic subtest: pipe-B
[349.694765] Dynamic subtest pipe-B: SUCCESS (2.434s)
[349.695596] Subtest plane-panning-top-left: SUCCESS (4.151s)
[350.485666] [073/133] (675s left) gem_mmap_wc (write-cpu-read-wc)
[350.539663] Subtest write-cpu-read-wc: SKIP (0.000s)
[350.594743] [074/133] (675s left) perf (invalid-remove-userspace-config)
[350.705388] Starting subtest: invalid-remove-userspace-config
[350.715094] Subtest invalid-remove-userspace-config: SUCCESS (0.009s)
[350.750986] [075/133] (674s left) gem_basic (bad-close)
[350.799386] Starting subtest: bad-close
[350.801109] Subtest bad-close: SUCCESS (0.000s)
[350.894581] [076/133] (674s left) gem_exec_params (no-bsd)
[350.941192] Starting subtest: no-bsd
[350.943802] Subtest no-bsd: SUCCESS (0.002s)
[352.429025] [077/133] (673s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[352.521033] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[352.521885] Starting dynamic subtest: pipe-A-eDP-1
[352.529225] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[352.542460] Starting dynamic subtest: pipe-B-eDP-1
[352.550089] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[352.561600] Starting dynamic subtest: pipe-C-eDP-1
[352.568971] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[352.577333] Starting dynamic subtest: pipe-D-eDP-1
[352.584435] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[352.585279] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[354.765598] [078/133] (671s left) syncobj_timeline (wait-all-interrupted)
[354.820239] Starting subtest: wait-all-interrupted
[354.926667] Subtest wait-all-interrupted: SUCCESS (0.105s)
[354.999427] [079/133] (670s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[355.047977] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[355.150398] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.101s)
[355.230548] [080/133] (670s left) kms_pipe_crc_basic (hang-read-crc)
[355.315168] Starting subtest: hang-read-crc
[355.316105] Starting dynamic subtest: pipe-A-eDP-1
[357.437967] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.122s)
[357.447011] Starting dynamic subtest: pipe-B-eDP-1
[360.215990] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.778s)
[360.226342] Starting dynamic subtest: pipe-C-eDP-1
[362.851475] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.633s)
[362.860189] Starting dynamic subtest: pipe-D-eDP-1
[365.521968] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.669s)
[365.522752] Subtest hang-read-crc: SUCCESS (10.208s)
[366.350402] [081/133] (659s left) perf (blocking-parameterized)
[366.434721] Starting subtest: blocking-parameterized
[386.505205] Subtest blocking-parameterized: SUCCESS (20.021s)
[386.539126] [082/133] (639s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[386.662832] Starting subtest: 2x-cursor-vs-flip-atomic
[386.664562] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[386.801581] [083/133] (639s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[386.886632] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[386.888479] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[386.979277] [084/133] (639s left) kms_async_flips (async-flip-hang)
[387.065263] Starting subtest: async-flip-hang
[387.451500] Starting dynamic subtest: pipe-A-eDP-1
[413.902978] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.443s)
[414.287332] Starting dynamic subtest: pipe-B-eDP-1
[429.834619] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.548s)
[430.206984] Starting dynamic subtest: pipe-C-eDP-1
[445.894518] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.687s)
[446.269297] Starting dynamic subtest: pipe-D-eDP-1
[461.893857] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.629s)
[461.895080] Subtest async-flip-hang: SUCCESS (74.812s)
[463.124371] [085/133] (562s left) kms_cursor_crc (cursor-sliding-64x64)
[463.299025] Starting subtest: cursor-sliding-64x64
[463.302565] Starting dynamic subtest: pipe-A-eDP-1
[466.546234] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.243s)
[466.574910] Starting dynamic subtest: pipe-D-eDP-1
[470.444466] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.878s)
[470.445339] Subtest cursor-sliding-64x64: SUCCESS (7.147s)
[471.312340] [086/133] (554s left) i915_pm_rps (min-max-config-loaded)
[471.366184] Starting subtest: min-max-config-loaded
[471.368220] Subtest min-max-config-loaded: SKIP (0.000s)
[471.454262] [087/133] (554s left) prime_self_import (export-vs-gem_close-race)
[471.488045] Starting subtest: export-vs-gem_close-race
[476.592939] Subtest export-vs-gem_close-race: SUCCESS (5.106s)
[476.667902] [088/133] (549s left) kms_async_flips (test-cursor-atomic)
[476.782570] Starting subtest: test-cursor-atomic
[477.156207] Starting dynamic subtest: pipe-A-eDP-1
[477.998396] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.842s)
[478.390109] Starting dynamic subtest: pipe-B-eDP-1
[479.135102] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.754s)
[479.515882] Starting dynamic subtest: pipe-C-eDP-1
[480.269206] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.762s)
[480.640368] Starting dynamic subtest: pipe-D-eDP-1
[481.406003] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.773s)
[481.406897] Subtest test-cursor-atomic: SUCCESS (4.624s)
[482.567916] [089/133] (543s left) sysfs_timeslice_duration (duration)
[482.624901] Starting subtest: duration
[482.626015] Starting dynamic subtest: vecs0
[496.338288] Dynamic subtest vecs0: SUCCESS (13.702s)
[496.349010] Starting dynamic subtest: ccs0
[509.470183] Dynamic subtest ccs0: SUCCESS (13.139s)
[509.483052] Starting dynamic subtest: vcs0
[523.346922] Dynamic subtest vcs0: SUCCESS (13.863s)
[523.357720] Starting dynamic subtest: bcs0
[536.489866] Dynamic subtest bcs0: SUCCESS (13.143s)
[536.499763] Starting dynamic subtest: rcs0
[549.637453] Dynamic subtest rcs0: SUCCESS (13.149s)
[549.650526] Starting dynamic subtest: vcs1
[564.305715] Dynamic subtest vcs1: SUCCESS (14.653s)
[564.306844] Subtest duration: SUCCESS (81.667s)
[564.369932] [090/133] (461s left) gem_exec_schedule (pi-ringfull)
[564.550777] Starting subtest: pi-ringfull
[564.551767] Starting dynamic subtest: rcs0
[564.583620] Dynamic subtest rcs0: SUCCESS (0.042s)
[564.598481] Starting dynamic subtest: bcs0
[564.625166] Dynamic subtest bcs0: SUCCESS (0.040s)
[564.634463] Starting dynamic subtest: vcs0
[564.662429] Dynamic subtest vcs0: SUCCESS (0.036s)
[564.672857] Starting dynamic subtest: vcs1
[564.696138] Dynamic subtest vcs1: SUCCESS (0.033s)
[564.704870] Starting dynamic subtest: vecs0
[564.729625] Dynamic subtest vecs0: SUCCESS (0.032s)
[564.738578] Starting dynamic subtest: ccs0
[564.762183] Dynamic subtest ccs0: SUCCESS (0.032s)
[564.763162] Subtest pi-ringfull: SUCCESS (0.221s)
[564.987319] [091/133] (461s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[565.079752] Starting subtest: primary-yf-tiled-reflect-x-90
[565.081488] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[565.146885] [092/133] (461s left) gem_exec_params (dr4-dirt)
[565.206852] Starting subtest: DR4-dirt
[565.207730] Subtest DR4-dirt: SUCCESS (0.000s)
[565.306792] [093/133] (461s left) kms_vrr (flip-dpms)
[565.402125] Starting subtest: flip-dpms
[565.404863] Subtest flip-dpms: SKIP (0.000s)
[565.473079] [094/133] (460s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[565.564206] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[565.565313] Starting dynamic subtest: pipe-A
[565.901073] Dynamic subtest pipe-A: SUCCESS (0.338s)
[565.911580] Starting dynamic subtest: pipe-B
[567.268321] Dynamic subtest pipe-B: SUCCESS (1.366s)
[567.278433] Starting dynamic subtest: pipe-C
[568.714378] Dynamic subtest pipe-C: SUCCESS (1.445s)
[568.724519] Starting dynamic subtest: pipe-D
[570.131239] Dynamic subtest pipe-D: SUCCESS (1.415s)
[570.132103] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.568s)
[571.294953] [095/133] (455s left) kms_flip (2x-flip-vs-dpms)
[571.396270] Starting subtest: 2x-flip-vs-dpms
[571.407588] Subtest 2x-flip-vs-dpms: SKIP (0.011s)
[571.487551] [096/133] (454s left) gem_userptr_blits (readonly-unsync)
[571.548067] Subtest readonly-unsync: SKIP (0.000s)
[571.671823] [097/133] (454s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[571.721360] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[571.722221] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[571.799946] [098/133] (454s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[571.892860] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[572.927549] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.035s)
[573.062347] [099/133] (453s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[573.170210] Starting subtest: flip-vs-cursor-toggle
[582.373886] Subtest flip-vs-cursor-toggle: SUCCESS (9.200s)
[583.228882] [100/133] (443s left) kms_concurrent (multi-plane-atomic-lowres)
[583.310471] Starting subtest: multi-plane-atomic-lowres
[583.311527] Starting dynamic subtest: pipe-A-eDP-1
[583.790527] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.478s)
[583.799886] Starting dynamic subtest: pipe-B-eDP-1
[585.075091] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.282s)
[585.084381] Starting dynamic subtest: pipe-C-eDP-1
[586.300182] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.223s)
[586.309085] Starting dynamic subtest: pipe-D-eDP-1
[587.508591] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.208s)
[587.509529] Subtest multi-plane-atomic-lowres: SUCCESS (4.197s)
[588.344173] [101/133] (438s left) gem_exec_balancer (bonded-sync)
[588.408626] Starting subtest: bonded-sync
[588.410573] Subtest bonded-sync: SKIP (0.000s)
[588.718082] [102/133] (437s left) gem_ppgtt (flink-and-close-vma-leak)
[588.763100] Starting subtest: flink-and-close-vma-leak
[588.803888] Subtest flink-and-close-vma-leak: SUCCESS (0.041s)
[588.925205] [103/133] (437s left) kms_lease (cursor-implicit-plane)
[589.019130] Starting subtest: cursor-implicit-plane
[589.020046] Starting dynamic subtest: pipe-A-eDP-1
[589.480807] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.461s)
[589.489973] Starting dynamic subtest: pipe-B-eDP-1
[590.575671] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.092s)
[590.585187] Starting dynamic subtest: pipe-C-eDP-1
[591.705116] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.128s)
[591.714049] Starting dynamic subtest: pipe-D-eDP-1
[592.817006] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.110s)
[592.818186] Subtest cursor-implicit-plane: SUCCESS (3.798s)
[593.675413] [104/133] (433s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[593.766838] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[593.768461] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[593.859937] [105/133] (432s left) kms_sequence (get-forked)
[593.953004] Starting subtest: get-forked
[593.953882] Starting dynamic subtest: pipe-A-eDP-1
[595.855726] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.901s)
[595.864927] Starting dynamic subtest: pipe-B-eDP-1
[598.464229] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.607s)
[598.473145] Starting dynamic subtest: pipe-C-eDP-1
[600.950273] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.484s)
[600.959661] Starting dynamic subtest: pipe-D-eDP-1
[603.486597] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.534s)
[603.487511] Subtest get-forked: SUCCESS (9.532s)
[604.336934] [106/133] (422s left) perf (rc6-disable)
[604.410104] Starting subtest: rc6-disable
[604.592067] Subtest rc6-disable: SUCCESS (0.181s)
[604.629682] [107/133] (422s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[604.708897] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[604.709740] Starting dynamic subtest: pipe-A-eDP-1
[604.717598] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[604.727224] Starting dynamic subtest: pipe-B-eDP-1
[604.735121] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[604.744443] Starting dynamic subtest: pipe-C-eDP-1
[604.751906] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[604.760502] Starting dynamic subtest: pipe-D-eDP-1
[604.767890] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[604.768729] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[606.984226] [108/133] (419s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[607.100589] Starting subtest: yf-tiled-64bpp-rotate-180
[607.102237] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[607.194226] [109/133] (419s left) syncobj_wait (signal)
[607.250140] Starting subtest: signal
[607.251200] Subtest signal: SUCCESS (0.000s)
[607.365765] [110/133] (419s left) kms_pm_dc (dc5-retention-flops)
[608.468871] Starting subtest: dc5-retention-flops
[608.470701] Subtest dc5-retention-flops: SKIP (0.000s)
[608.538271] [111/133] (418s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[608.625294] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[616.030607] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.405s)
[616.143265] [112/133] (410s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[616.231123] Starting subtest: fbc-rgb101010-draw-render
[620.840743] Subtest fbc-rgb101010-draw-render: SUCCESS (4.608s)
[622.029363] [113/133] (405s left) gem_softpin (evict-prime-sanity-check)
[622.096148] Starting subtest: evict-prime-sanity-check
[622.097028] Starting dynamic subtest: rcs0
[623.216945] Dynamic subtest rcs0: SUCCESS (1.120s)
[623.228461] Starting dynamic subtest: bcs0
[624.355984] Dynamic subtest bcs0: SUCCESS (1.138s)
[624.367506] Starting dynamic subtest: vcs0
[626.417039] Dynamic subtest vcs0: SUCCESS (2.050s)
[626.428624] Starting dynamic subtest: vcs1
[628.377136] Dynamic subtest vcs1: SUCCESS (1.957s)
[628.388980] Starting dynamic subtest: vecs0
[630.388543] Dynamic subtest vecs0: SUCCESS (2.009s)
[630.400318] Starting dynamic subtest: ccs0
[631.505290] Dynamic subtest ccs0: SUCCESS (1.123s)
[631.518391] Starting dynamic subtest: all
[632.628037] Dynamic subtest all: SUCCESS (1.121s)
[632.629301] Subtest evict-prime-sanity-check: SUCCESS (10.530s)
[632.708338] [114/133] (394s left) kms_big_fb (linear-8bpp-rotate-180)
[632.812872] Starting subtest: linear-8bpp-rotate-180
[634.071484] Subtest linear-8bpp-rotate-180: SUCCESS (1.258s)
[634.179927] [115/133] (392s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[634.273879] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[634.275570] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[634.342516] [116/133] (392s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[634.439330] Starting subtest: psr-rgb101010-draw-mmap-wc
[641.603714] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.164s)
[641.723730] [117/133] (385s left) gem_pwrite (basic-random)
[641.788153] Subtest basic-random: SKIP (0.000s)
[641.846830] [118/133] (385s left) perf (unprivileged-single-ctx-counters)
[641.930413] Starting subtest: unprivileged-single-ctx-counters
[641.932220] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[641.972019] [119/133] (385s left) gem_tiling_max_stride
[642.092626] [120/133] (385s left) i915_pm_rps (thresholds-park)
[642.157212] Starting subtest: thresholds-park
[642.159078] Subtest thresholds-park: SKIP (0.000s)
[642.256839] [121/133] (385s left) gem_render_copy (yf-tiled-to-vebox-linear)
[642.310998] Starting subtest: yf-tiled-to-vebox-linear
[642.312722] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[642.498259] [122/133] (384s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[642.581694] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[642.583546] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[642.679606] [123/133] (384s left) gem_exec_schedule (reorder-wide)
[642.852516] Subtest reorder-wide: SKIP (0.000s)
[643.035075] [124/133] (384s left) i915_drm_fdinfo (all-busy-check-all)
[643.077973] Starting subtest: all-busy-check-all
[643.082409] Subtest all-busy-check-all: SKIP (0.004s)
[643.144568] [125/133] (384s left) kms_dsc (dsc-with-formats)
[643.246049] Starting subtest: dsc-with-formats
[643.260301] Subtest dsc-with-formats: SKIP (0.001s)
[643.316562] [126/133] (384s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[643.396799] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[643.398557] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s)
[643.467125] [127/133] (384s left) gem_exec_fence (syncobj-invalid-flags)
[643.960233] Starting subtest: syncobj-invalid-flags
[643.961094] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[645.513397] [128/133] (382s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[645.821241] Starting subtest: cursor-rapid-movement-512x170
[645.823058] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[645.970801] [129/133] (381s left) kms_rotation_crc (primary-rotation-270)
[646.058202] Starting subtest: primary-rotation-270
[646.060084] Subtest primary-rotation-270: SKIP (0.001s)
[646.128617] [130/133] (381s left) kms_properties (plane-properties-legacy)
[646.211806] Starting subtest: plane-properties-legacy
[646.212674] Starting dynamic subtest: pipe-A-eDP-1
[646.770956] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.557s)
[646.781118] Starting dynamic subtest: pipe-B-eDP-1
[648.031677] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.259s)
[648.041161] Starting dynamic subtest: pipe-C-eDP-1
[649.264176] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.232s)
[649.275298] Starting dynamic subtest: pipe-D-eDP-1
[650.499819] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.233s)
[650.500660] Subtest plane-properties-legacy: SUCCESS (4.287s)
[651.306590] [131/133] (376s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[651.396045] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[651.396986] Starting dynamic subtest: pipe-A-eDP-1
[651.404758] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[651.414262] Starting dynamic subtest: pipe-B-eDP-1
[651.421972] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[651.431003] Starting dynamic subtest: pipe-C-eDP-1
[651.438452] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[651.447168] Starting dynamic subtest: pipe-D-eDP-1
[651.454377] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[651.455198] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[653.656730] [132/133] (374s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[653.740766] Starting subtest: plane-ctm3x4-lut1d
[653.888266] Starting dynamic subtest: pipe-A-plane-0
[654.054579] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[654.066859] Starting dynamic subtest: pipe-A-plane-1
[654.187875] Dynamic subtest pipe-A-plane-1: SUCCESS (0.132s)
[654.196978] Starting dynamic subtest: pipe-A-plane-2
[654.332473] Dynamic subtest pipe-A-plane-2: SUCCESS (0.144s)
[655.549547] Starting dynamic subtest: pipe-B-plane-0
[655.695837] Dynamic subtest pipe-B-plane-0: SUCCESS (0.155s)
[655.705256] Starting dynamic subtest: pipe-B-plane-1
[655.862539] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[655.871981] Starting dynamic subtest: pipe-B-plane-2
[656.029205] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[657.181500] Starting dynamic subtest: pipe-C-plane-0
[657.316867] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[657.325863] Starting dynamic subtest: pipe-C-plane-1
[657.461607] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[657.471138] Starting dynamic subtest: pipe-C-plane-2
[657.605743] Dynamic subtest pipe-C-plane-2: SUCCESS (0.143s)
[658.830865] Starting dynamic subtest: pipe-D-plane-0
[658.984077] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s)
[658.993057] Starting dynamic subtest: pipe-D-plane-1
[659.128790] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[659.138153] Starting dynamic subtest: pipe-D-plane-2
[659.284025] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[659.570075] Subtest plane-ctm3x4-lut1d: SUCCESS (5.827s)
[660.379126] [133/133] (367s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[660.423286] Starting subtest: etime-multi-wait-for-submit-submitted
[660.526193] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.102s)
[660.613918] Closing watchdogs
results: parsing output: 0/ for test: syncobj_wait
results: parsing output: 1/ for test: gem_exec_whisper
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: api_intel_bb
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: i915_drm_fdinfo
results: parsing output: 6/ for test: kms_chamelium_hpd
results: parsing output: 7/ for test: kms_chamelium_color
results: parsing output: 8/ for test: gem_exec_whisper
results: parsing output: 9/ for test: gem_exec_reloc
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: gem_userptr_blits
results: parsing output: 14/ for test: gem_mmap_offset
results: parsing output: 15/ for test: gem_flink_basic
results: parsing output: 16/ for test: syncobj_basic
results: parsing output: 17/ for test: kms_flip_event_leak
results: parsing output: 18/ for test: kms_plane
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: gem_mmap_wc
results: parsing output: 22/ for test: gen9_exec_parse
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: gem_render_copy
results: parsing output: 30/ for test: gem_exec_reloc
results: parsing output: 31/ for test: perf_pmu
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: kms_pm_rpm
results: parsing output: 34/ for test: kms_rotation_crc
results: parsing output: 35/ for test: kms_cursor_legacy
results: parsing output: 36/ for test: gem_lmem_swapping
results: parsing output: 37/ for test: kms_ccs
results: parsing output: 38/ for test: gem_exec_reloc
results: parsing output: 39/ for test: kms_cursor_legacy
results: parsing output: 40/ for test: core_setmaster
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_ctx_persistence
results: parsing output: 43/ for test: kms_psr2_sf
results: parsing output: 44/ for test: kms_cursor_crc
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: core_debugfs
results: parsing output: 47/ for test: gem_exec_fence
results: parsing output: 48/ for test: gem_mmap_gtt
results: parsing output: 49/ for test: kms_hdr
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_ctx_persistence
results: parsing output: 53/ for test: kms_addfb_basic
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: gem_sync
results: parsing output: 56/ for test: kms_dp_linktrain_fallback
results: parsing output: 57/ for test: kms_psr2_sf
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: prime_vgem
results: parsing output: 62/ for test: kms_chamelium_frames
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: kms_invalid_mode
results: parsing output: 65/ for test: fbdev
results: parsing output: 66/ for test: gem_fenced_exec_thrash
results: parsing output: 67/ for test: gem_create
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_userptr_blits
results: parsing output: 70/ for test: gem_ctx_shared
results: parsing output: 71/ for test: kms_plane
results: parsing output: 72/ for test: gem_mmap_wc
results: parsing output: 73/ for test: perf
results: parsing output: 74/ for test: gem_basic
results: parsing output: 75/ for test: gem_exec_params
results: parsing output: 76/ for test: kms_ccs
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: kms_pipe_crc_basic
results: parsing output: 80/ for test: perf
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_async_flips
results: parsing output: 84/ for test: kms_cursor_crc
results: parsing output: 85/ for test: i915_pm_rps
results: parsing output: 86/ for test: prime_self_import
results: parsing output: 87/ for test: kms_async_flips
results: parsing output: 88/ for test: sysfs_timeslice_duration
results: parsing output: 89/ for test: gem_exec_schedule
results: parsing output: 90/ for test: kms_rotation_crc
results: parsing output: 91/ for test: gem_exec_params
results: parsing output: 92/ for test: kms_vrr
results: parsing output: 93/ for test: kms_plane_scaling
results: parsing output: 94/ for test: kms_flip
results: parsing output: 95/ for test: gem_userptr_blits
results: parsing output: 96/ for test: syncobj_wait
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_cursor_legacy
results: parsing output: 99/ for test: kms_concurrent
results: parsing output: 100/ for test: gem_exec_balancer
results: parsing output: 101/ for test: gem_ppgtt
results: parsing output: 102/ for test: kms_lease
results: parsing output: 103/ for test: kms_flip_scaled_crc
results: parsing output: 104/ for test: kms_sequence
results: parsing output: 105/ for test: perf
results: parsing output: 106/ for test: kms_ccs
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: syncobj_wait
results: parsing output: 109/ for test: kms_pm_dc
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gem_softpin
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: kms_psr2_sf
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: gem_pwrite
results: parsing output: 117/ for test: perf
results: parsing output: 118/ for test: gem_tiling_max_stride
results: parsing output: 119/ for test: i915_pm_rps
results: parsing output: 120/ for test: gem_render_copy
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_exec_schedule
results: parsing output: 123/ for test: i915_drm_fdinfo
results: parsing output: 124/ for test: kms_dsc
results: parsing output: 125/ for test: kms_plane
results: parsing output: 126/ for test: gem_exec_fence
results: parsing output: 127/ for test: kms_cursor_crc
results: parsing output: 128/ for test: kms_rotation_crc
results: parsing output: 129/ for test: kms_properties
results: parsing output: 130/ for test: kms_ccs
results: parsing output: 131/ for test: kms_color_pipeline
results: parsing output: 132/ for test: syncobj_timeline
Done.