[62.256181] Initializing watchdogs
[62.256244]   /dev/watchdog0
[62.271668] [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]
[62.276251] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.278636] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.280492] [001/155] (960s left) kms_plane_multiple (2x-tiling-4)
[62.370168] Starting subtest: 2x-tiling-4
[62.371978] Subtest 2x-tiling-4: SKIP (0.000s)
[62.426164] [002/155] (960s left) gem_mmap_wc (set-cache-level)
[62.479151] Subtest set-cache-level: SKIP (0.000s)
[62.534136] [003/155] (960s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[62.588890] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[62.693465] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.104s)
[62.760866] [004/155] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[62.854291] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[62.856128] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[62.961643] [005/155] (959s left) kms_flip (plain-flip-fb-recreate-interruptible)
[63.047794] Starting subtest: plain-flip-fb-recreate-interruptible
[63.050172] Starting dynamic subtest: A-eDP1
[71.945070] Dynamic subtest A-eDP1: SUCCESS (8.895s)
[71.953319] Starting dynamic subtest: B-eDP1
[80.775534] Dynamic subtest B-eDP1: SUCCESS (8.830s)
[80.784926] Starting dynamic subtest: C-eDP1
[89.602159] Dynamic subtest C-eDP1: SUCCESS (8.824s)
[89.609971] Starting dynamic subtest: D-eDP1
[98.432961] Dynamic subtest D-eDP1: SUCCESS (8.829s)
[98.435531] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.385s)
[99.614423] [006/155] (923s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[99.716165] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[100.552936] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.837s)
[100.744695] [007/155] (922s left) kms_vblank (wait-forked-busy-hang)
[100.825582] Starting subtest: wait-forked-busy-hang
[100.826550] Starting dynamic subtest: pipe-A-eDP-1
[128.096936] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.270s)
[128.108495] Starting dynamic subtest: pipe-D-eDP-1
[153.123334] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.024s)
[153.124343] Subtest wait-forked-busy-hang: SUCCESS (52.298s)
[153.985025] [008/155] (869s left) gem_softpin (zero)
[154.037324] Starting subtest: zero
[154.042719] Subtest zero: SUCCESS (0.005s)
[154.153549] [009/155] (868s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[154.202853] Starting subtest: yf-tiled-to-vebox-x-tiled
[154.204557] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[154.377868] [010/155] (868s left) gem_exec_reloc (basic-wc-read-active)
[154.424988] Subtest basic-wc-read-active: SKIP (0.000s)
[154.490251] [011/155] (868s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[154.867127] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[155.685045] [012/155] (867s left) gem_partial_pwrite_pread (reads-uncached)
[155.737770] Subtest reads-uncached: SKIP (0.000s)
[155.802016] [013/155] (867s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[155.915340] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[157.399031] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.484s)
[158.277674] [014/155] (864s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-blt)
[158.376454] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-blt
[158.378373] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[158.475548] [015/155] (864s left) syncobj_wait (signal)
[158.528107] Starting subtest: signal
[158.529170] Subtest signal: SUCCESS (0.000s)
[158.625864] [016/155] (864s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[158.709964] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[158.710975] Starting dynamic subtest: pipe-A-eDP-1
[158.731200] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[158.739514] Starting dynamic subtest: pipe-B-eDP-1
[158.751927] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[158.761144] Starting dynamic subtest: pipe-C-eDP-1
[158.772673] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[158.779503] Starting dynamic subtest: pipe-D-eDP-1
[158.793851] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s)
[158.794732] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.085s)
[161.039643] [017/155] (862s left) gem_sync (basic-all)
[161.101811] Starting subtest: basic-all
[164.329836] Subtest basic-all: SUCCESS (3.219s)
[164.504012] [018/155] (858s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[164.607752] Starting subtest: fbcpsr-stridechange
[170.909537] Subtest fbcpsr-stridechange: SUCCESS (6.304s)
[171.051586] [019/155] (852s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[171.136340] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[178.082794] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.948s)
[178.187686] [020/155] (845s left) kms_chamelium_color (gamma)
[178.284803] Subtest gamma: SKIP (0.000s)
[178.323298] [021/155] (845s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[178.407512] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[178.409167] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[178.501499] [022/155] (844s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[178.602403] Starting subtest: plane-lut1d-ctm3x4
[178.760531] Starting dynamic subtest: pipe-A-plane-0
[178.927219] Dynamic subtest pipe-A-plane-0: SUCCESS (0.167s)
[178.937682] Starting dynamic subtest: pipe-A-plane-1
[179.116062] Dynamic subtest pipe-A-plane-1: SUCCESS (0.188s)
[179.123579] Starting dynamic subtest: pipe-A-plane-2
[179.283063] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[180.525069] Starting dynamic subtest: pipe-B-plane-0
[180.719407] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s)
[180.730211] Starting dynamic subtest: pipe-B-plane-1
[180.885142] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[180.893766] Starting dynamic subtest: pipe-B-plane-2
[181.073921] Dynamic subtest pipe-B-plane-2: SUCCESS (0.188s)
[182.254419] Starting dynamic subtest: pipe-C-plane-0
[182.385991] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[182.393101] Starting dynamic subtest: pipe-C-plane-1
[182.552956] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[182.561828] Starting dynamic subtest: pipe-C-plane-2
[182.719277] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[183.879179] Starting dynamic subtest: pipe-D-plane-0
[184.038338] Dynamic subtest pipe-D-plane-0: SUCCESS (0.167s)
[184.046362] Starting dynamic subtest: pipe-D-plane-1
[184.204759] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[184.214690] Starting dynamic subtest: pipe-D-plane-2
[184.371184] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[184.666737] Subtest plane-lut1d-ctm3x4: SUCCESS (6.065s)
[185.555484] [023/155] (837s left) api_intel_bb (bb-with-allocator)
[185.603794] Starting subtest: bb-with-allocator
[185.608071] Subtest bb-with-allocator: SUCCESS (0.005s)
[185.715719] [024/155] (837s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[185.806527] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[195.645855] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.839s)
[195.762676] [025/155] (827s left) kms_psr (fbc-pr-sprite-plane-move)
[195.842533] Starting subtest: fbc-pr-sprite-plane-move
[195.844471] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[195.906664] [026/155] (827s left) kms_flip (absolute-wf_vblank-interruptible)
[195.996311] Starting subtest: absolute-wf_vblank-interruptible
[195.997444] Starting dynamic subtest: A-eDP1
[204.795040] Dynamic subtest A-eDP1: SUCCESS (8.773s)
[204.804650] Starting dynamic subtest: B-eDP1
[213.519832] Dynamic subtest B-eDP1: SUCCESS (8.723s)
[213.527996] Starting dynamic subtest: C-eDP1
[222.257377] Dynamic subtest C-eDP1: SUCCESS (8.724s)
[222.266474] Starting dynamic subtest: D-eDP1
[230.947946] Dynamic subtest D-eDP1: SUCCESS (8.726s)
[230.950533] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.956s)
[232.169717] [027/155] (791s left) gem_exec_balancer (individual)
[232.232801] Starting subtest: individual
[234.345966] Subtest individual: SUCCESS (2.104s)
[234.656719] [028/155] (788s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[234.744151] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-mmap-cpu
[234.745887] Subtest hdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[234.849198] [029/155] (788s left) kms_lease (lease-unleased-crtc)
[234.940071] Starting subtest: lease-unleased-crtc
[234.940867] Starting dynamic subtest: pipe-A-eDP-1
[235.234146] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s)
[235.243987] Starting dynamic subtest: pipe-B-eDP-1
[236.002485] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.766s)
[236.012102] Starting dynamic subtest: pipe-C-eDP-1
[236.013222] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.005s)
[236.022120] Starting dynamic subtest: pipe-D-eDP-1
[236.022954] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.006s)
[236.023748] Subtest lease-unleased-crtc: SUCCESS (1.078s)
[236.384642] [030/155] (787s left) kms_vblank (invalid)
[236.464366] Starting subtest: invalid
[236.465281] Starting dynamic subtest: pipe-A-eDP-1
[236.861451] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.396s)
[236.862437] Subtest invalid: SUCCESS (0.397s)
[237.716145] [031/155] (786s left) syncobj_timeline (invalid-query-one-illegal-handle)
[237.754854] Starting subtest: invalid-query-one-illegal-handle
[237.755757] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[237.839835] [032/155] (785s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[239.457531] Starting subtest: dpms-mode-unset-lpsp
[243.521112] Subtest dpms-mode-unset-lpsp: SUCCESS (4.065s)
[243.916339] [033/155] (779s left) gem_mmap (short-mmap)
[243.955166] Subtest short-mmap: SKIP (0.000s)
[244.013810] [034/155] (779s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[244.133589] Starting subtest: modeset-atomic-cursor-hotspot
[244.135476] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[244.273794] [035/155] (779s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[246.513438] Starting subtest: gem-execbuf-stress-pc8
[246.543678] Subtest gem-execbuf-stress-pc8: SKIP (0.042s)
[246.891591] [036/155] (777s left) kms_cursor_crc (cursor-tearing-position-change)
[247.001197] Starting subtest: cursor-tearing-position-change
[247.002191] Starting dynamic subtest: pipe-A-eDP-1
[247.578274] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.576s)
[247.586482] Starting dynamic subtest: pipe-D-eDP-1
[248.822522] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.242s)
[248.823707] Subtest cursor-tearing-position-change: SUCCESS (1.821s)
[249.655987] [037/155] (774s left) gem_ctx_exec (basic-norecovery)
[249.701250] Starting subtest: basic-norecovery
[250.062046] Subtest basic-norecovery: SUCCESS (0.361s)
[250.190777] [038/155] (773s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[250.254772] Starting subtest: multi-wait-all-for-submit-signaled
[250.255789] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[250.362108] [039/155] (773s left) kms_lease (atomic-implicit-crtc)
[250.456432] Starting subtest: atomic-implicit-crtc
[250.457388] Starting dynamic subtest: pipe-A-eDP-1
[250.461676] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[250.469590] Starting dynamic subtest: pipe-B-eDP-1
[250.482426] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[250.490988] Starting dynamic subtest: pipe-C-eDP-1
[250.496608] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[250.504465] Starting dynamic subtest: pipe-D-eDP-1
[250.509304] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[250.510261] Subtest atomic-implicit-crtc: SUCCESS (0.037s)
[250.590206] [040/155] (773s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-linear)
[250.687810] Starting subtest: fbcpsrhdr-tiling-linear
[250.689743] Subtest fbcpsrhdr-tiling-linear: SKIP (0.000s)
[250.784568] [041/155] (773s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-pri-indfb-multidraw)
[250.881554] Starting subtest: fbcpsrhdr-1p-pri-indfb-multidraw
[250.883348] Subtest fbcpsrhdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[250.974207] [042/155] (773s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[251.053077] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[251.054872] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[251.119236] [043/155] (773s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[251.232645] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[251.234844] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[251.386346] [044/155] (772s left) kms_flip (2x-flip-vs-modeset)
[251.468600] Starting subtest: 2x-flip-vs-modeset
[251.480737] Subtest 2x-flip-vs-modeset: SKIP (0.011s)
[251.552967] [045/155] (772s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[251.649355] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu
[251.651026] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[251.732598] [046/155] (772s left) gen7_exec_parse (chained-batch)
[251.782793] Subtest chained-batch: SKIP (0.000s)
[251.845027] [047/155] (772s left) syncobj_wait (invalid-signal-one-illegal-handle)
[251.891259] Starting subtest: invalid-signal-one-illegal-handle
[251.892210] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[252.010950] [048/155] (772s left) kms_cursor_crc (cursor-onscreen-32x32)
[252.147403] Starting subtest: cursor-onscreen-32x32
[252.191988] Subtest cursor-onscreen-32x32: SKIP (0.043s)
[252.492755] [049/155] (771s left) gem_ctx_persistence (many-contexts)
[252.541335] Starting subtest: many-contexts
[290.212380] Subtest many-contexts: SUCCESS (37.669s)
[290.285212] [050/155] (734s left) gem_exec_capture (userptr)
[290.332579] Starting subtest: userptr
[291.155473] Subtest userptr: SUCCESS (0.822s)
[291.286407] [051/155] (733s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[291.384908] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[291.386674] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[291.491216] [052/155] (732s left) kms_psr (psr-primary-render)
[291.593298] Starting subtest: psr-primary-render
[291.594347] Starting dynamic subtest: eDP-1
[293.363864] Dynamic subtest eDP-1: SUCCESS (1.769s)
[293.365661] Subtest psr-primary-render: SUCCESS (1.770s)
[294.219847] [053/155] (730s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[294.275370] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[294.276331] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[294.360263] [054/155] (730s left) gem_exec_reloc (basic-gtt-cpu-active)
[294.406957] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[294.472496] [055/155] (730s left) gem_exec_schedule (reorder-wide)
[294.638416] Subtest reorder-wide: SKIP (0.000s)
[294.829101] [056/155] (729s left) kms_prop_blob (blob-prop-lifetime)
[294.880709] Starting subtest: blob-prop-lifetime
[294.883512] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[294.983284] [057/155] (729s left) prime_mmap_coherency (ioctl-errors)
[295.045918] Starting subtest: ioctl-errors
[309.595831] Subtest ioctl-errors: SUCCESS (14.549s)
[309.757549] [058/155] (714s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[309.902201] Starting subtest: plane-downscale-factor-0-5-with-rotation
[309.903037] Starting dynamic subtest: pipe-A
[309.922429] Dynamic subtest pipe-A: SKIP (0.018s)
[309.933346] Starting dynamic subtest: pipe-B
[309.955165] Dynamic subtest pipe-B: SKIP (0.033s)
[309.963892] Starting dynamic subtest: pipe-C
[309.989337] Dynamic subtest pipe-C: SKIP (0.033s)
[309.998106] Starting dynamic subtest: pipe-D
[310.022428] Dynamic subtest pipe-D: SKIP (0.033s)
[310.024112] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.119s)
[310.117329] [059/155] (714s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[310.217085] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[310.218866] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[310.296931] [060/155] (714s left) gem_ctx_bad_destroy (invalid-pad)
[310.342581] Starting subtest: invalid-pad
[310.343442] Subtest invalid-pad: SUCCESS (0.000s)
[310.407286] [061/155] (714s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[310.494229] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[310.495982] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[310.578761] [062/155] (714s left) i915_drm_fdinfo (most-busy-idle-check-all)
[310.613054] Starting subtest: most-busy-idle-check-all
[310.614054] Starting dynamic subtest: rcs0
[310.618110] Dynamic subtest rcs0: SKIP (0.004s)
[310.628823] Starting dynamic subtest: bcs0
[310.630579] Dynamic subtest bcs0: SKIP (0.000s)
[310.639232] Starting dynamic subtest: vcs0
[310.640955] Dynamic subtest vcs0: SKIP (0.000s)
[310.649613] Starting dynamic subtest: vcs1
[310.651377] Dynamic subtest vcs1: SKIP (0.000s)
[310.659879] Starting dynamic subtest: vecs0
[310.661615] Dynamic subtest vecs0: SKIP (0.000s)
[310.670495] Starting dynamic subtest: ccs0
[310.672358] Dynamic subtest ccs0: SKIP (0.000s)
[310.674119] Subtest most-busy-idle-check-all: SKIP (0.009s)
[310.703882] [063/155] (714s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[310.813106] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[314.920287] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (4.109s)
[316.055591] [064/155] (708s left) i915_suspend (fence-restore-untiled)
[316.103653] Starting subtest: fence-restore-untiled
[316.105757] Subtest fence-restore-untiled: SKIP (0.000s)
[316.190988] [065/155] (708s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[316.244054] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[316.304722] [066/155] (708s left) kms_getfb (getfb2-into-addfb2)
[316.394653] Starting subtest: getfb2-into-addfb2
[316.395509] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[316.492775] [067/155] (708s left) gem_exec_params (no-bsd)
[316.551555] Starting subtest: no-bsd
[316.552539] Subtest no-bsd: SUCCESS (0.002s)
[318.359190] [068/155] (706s left) api_intel_bb (object-reloc-keep-cache)
[318.407158] Starting subtest: object-reloc-keep-cache
[318.410178] Subtest object-reloc-keep-cache: SKIP (0.002s)
[318.517912] [069/155] (706s left) kms_psr (pr-primary-render)
[318.608223] Starting subtest: pr-primary-render
[318.609889] Subtest pr-primary-render: SKIP (0.000s)
[318.688224] [070/155] (706s left) gem_pxp (create-valid-protected-context)
[318.794915] Starting subtest: create-valid-protected-context
[318.796389] Subtest create-valid-protected-context: SUCCESS (0.002s)
[318.897546] [071/155] (706s left) gem_mmap_gtt (basic-copy)
[318.941113] Subtest basic-copy: SKIP (0.000s)
[318.994137] [072/155] (706s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-render)
[319.089905] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-render
[319.091545] Subtest hdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[319.188712] [073/155] (705s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-onoff)
[319.274666] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-onoff
[319.276609] Subtest psrhdr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[319.377409] [074/155] (705s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[319.478461] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-mmap-wc
[319.480347] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[319.577093] [075/155] (705s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-indfb-plflip-blt)
[319.673410] Starting subtest: fbcpsrhdr-2p-scndscrn-indfb-plflip-blt
[319.675091] Subtest fbcpsrhdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[319.760959] [076/155] (705s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[319.846670] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[319.848615] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[319.913743] [077/155] (705s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[320.006529] Starting subtest: nonblocking-crc-frame-sequence
[320.007540] Starting dynamic subtest: pipe-A-eDP-1
[320.750786] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.745s)
[320.761535] Starting dynamic subtest: pipe-B-eDP-1
[322.165810] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.412s)
[322.175068] Starting dynamic subtest: pipe-C-eDP-1
[323.571382] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.405s)
[323.582292] Starting dynamic subtest: pipe-D-eDP-1
[325.005803] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.433s)
[325.006564] Subtest nonblocking-crc-frame-sequence: SUCCESS (5.000s)
[325.887810] [078/155] (699s left) kms_setmode (invalid-clone-exclusive-crtc)
[325.937382] Starting subtest: invalid-clone-exclusive-crtc
[325.940063] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[326.039022] [079/155] (699s left) kms_dsc (dsc-with-bpc-formats)
[326.119830] Starting subtest: dsc-with-bpc-formats
[326.161830] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[326.202028] [080/155] (699s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-onoff)
[326.295730] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-onoff
[326.297385] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[326.385924] [081/155] (698s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[326.479263] Starting subtest: fbc-shrfb-scaledprimary
[329.413787] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.935s)
[330.602600] [082/155] (694s left) gem_exec_fence (syncobj-wait)
[331.069367] Starting subtest: syncobj-wait
[332.359240] Subtest syncobj-wait: SUCCESS (1.280s)
[334.353580] [FACT gem_exec_fence (syncobj-wait)] new: kernel.kmod_is_loaded.vgem: true
[334.355868] [083/155] (691s left) perf_pmu (enable-race)
[334.389755] Starting subtest: enable-race
[334.390680] Starting dynamic subtest: rcs0
[347.177226] Dynamic subtest rcs0: SUCCESS (12.776s)
[347.187076] Starting dynamic subtest: bcs0
[359.923131] Dynamic subtest bcs0: SUCCESS (12.742s)
[359.932278] Starting dynamic subtest: vcs0
[375.273717] Dynamic subtest vcs0: SUCCESS (15.349s)
[375.285555] Starting dynamic subtest: vcs1
[391.337260] Dynamic subtest vcs1: SUCCESS (16.061s)
[391.347361] Starting dynamic subtest: vecs0
[407.336623] Dynamic subtest vecs0: SUCCESS (15.996s)
[407.348518] Starting dynamic subtest: ccs0
[420.084087] Dynamic subtest ccs0: SUCCESS (12.743s)
[420.084979] Subtest enable-race: SUCCESS (85.681s)
[420.181257] [084/155] (605s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-blt)
[420.269289] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-blt
[420.270885] Subtest hdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[420.359914] [085/155] (605s left) gem_huc_copy (huc-copy)
[420.406452] Starting subtest: huc-copy
[420.409748] Subtest huc-copy: SUCCESS (0.003s)
[420.520503] [086/155] (605s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[420.635097] Starting subtest: y-tiled-8bpp-rotate-90
[420.636854] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[420.723870] [087/155] (604s left) gem_exec_reloc (basic-wc-cpu-active)
[420.784348] Subtest basic-wc-cpu-active: SKIP (0.000s)
[420.859067] [088/155] (604s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[420.945424] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[420.947277] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[421.072343] [089/155] (604s left) gem_exec_reloc (basic-write-cpu-noreloc)
[421.130420] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[421.196642] [090/155] (604s left) dmabuf_sync_file (export-wait-after-attach)
[421.235562] Starting subtest: export-wait-after-attach
[421.236658] Subtest export-wait-after-attach: SUCCESS (0.001s)
[421.292347] [091/155] (604s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[421.389926] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[430.372988] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.985s)
[430.505088] [092/155] (595s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[430.598528] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[430.972486] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[433.743735] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.762s)
[433.753551] Starting dynamic subtest: pipe-A-eDP-1-4
[435.928816] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.184s)
[435.940478] Starting dynamic subtest: pipe-A-eDP-1-4
[437.940413] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[437.950999] Starting dynamic subtest: pipe-A-eDP-1-x
[440.129590] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.190s)
[440.499084] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[443.271293] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.772s)
[443.281352] Starting dynamic subtest: pipe-B-eDP-1-4
[445.458426] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[445.469182] Starting dynamic subtest: pipe-B-eDP-1-4
[447.467407] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.008s)
[447.479833] Starting dynamic subtest: pipe-B-eDP-1-x
[449.668782] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.201s)
[450.023887] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[452.794628] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.770s)
[452.804082] Starting dynamic subtest: pipe-C-eDP-1-4
[454.980026] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.184s)
[454.992486] Starting dynamic subtest: pipe-C-eDP-1-4
[456.990643] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[457.000141] Starting dynamic subtest: pipe-C-eDP-1-x
[459.169099] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[459.523377] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[462.324149] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.799s)
[462.336461] Starting dynamic subtest: pipe-D-eDP-1-4
[464.506294] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.181s)
[464.515437] Starting dynamic subtest: pipe-D-eDP-1-4
[466.515917] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[466.525666] Starting dynamic subtest: pipe-D-eDP-1-x
[468.694701] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s)
[468.695591] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.088s)
[469.924171] [093/155] (555s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[470.019416] Starting subtest: yf-tiled-8bpp-rotate-180
[470.020976] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[470.108187] [094/155] (555s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-indfb-plflip-blt)
[470.196572] Starting subtest: fbcpsrhdr-2p-primscrn-indfb-plflip-blt
[470.198223] Subtest fbcpsrhdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[470.291260] [095/155] (555s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[470.386387] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[470.387344] Starting dynamic subtest: pipe-A-eDP-1
[470.395133] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[470.404668] Starting dynamic subtest: pipe-B-eDP-1
[470.412425] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[470.421863] Starting dynamic subtest: pipe-C-eDP-1
[470.429583] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[470.438618] Starting dynamic subtest: pipe-D-eDP-1
[470.445427] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[470.446202] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[472.675435] [096/155] (553s left) gem_ccs (large-ctrl-surf-copy)
[472.737265] Starting subtest: large-ctrl-surf-copy
[472.739063] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[472.846085] [097/155] (553s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[472.947040] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[472.948644] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[473.047909] [098/155] (552s left) gem_exec_schedule (in-order)
[473.110512] Starting subtest: in-order
[473.111440] Starting dynamic subtest: rcs0
[473.214519] Dynamic subtest rcs0: SUCCESS (0.103s)
[473.231415] Starting dynamic subtest: vcs0
[473.306664] Dynamic subtest vcs0: SUCCESS (0.091s)
[473.316650] Starting dynamic subtest: vcs1
[473.394835] Dynamic subtest vcs1: SUCCESS (0.087s)
[473.406687] Starting dynamic subtest: vecs0
[473.474670] Dynamic subtest vecs0: SUCCESS (0.080s)
[473.487501] Starting dynamic subtest: ccs0
[473.571613] Dynamic subtest ccs0: SUCCESS (0.095s)
[473.572999] Subtest in-order: SUCCESS (0.461s)
[474.415833] [099/155] (551s left) sysfs_heartbeat_interval (invalid)
[474.464732] Starting subtest: invalid
[474.465830] Starting dynamic subtest: vecs0
[474.466835] Dynamic subtest vecs0: SUCCESS (0.000s)
[474.476501] Starting dynamic subtest: ccs0
[474.477418] Dynamic subtest ccs0: SUCCESS (0.000s)
[474.486380] Starting dynamic subtest: vcs0
[474.487307] Dynamic subtest vcs0: SUCCESS (0.000s)
[474.496189] Starting dynamic subtest: bcs0
[474.497069] Dynamic subtest bcs0: SUCCESS (0.000s)
[474.505971] Starting dynamic subtest: rcs0
[474.506939] Dynamic subtest rcs0: SUCCESS (0.000s)
[474.515970] Starting dynamic subtest: vcs1
[474.517162] Dynamic subtest vcs1: SUCCESS (0.000s)
[474.518710] Subtest invalid: SUCCESS (0.006s)
[474.562550] [100/155] (551s left) kms_rotation_crc (cursor-rotation-180)
[474.655586] Starting subtest: cursor-rotation-180
[476.162805] Subtest cursor-rotation-180: SUCCESS (1.508s)
[477.349608] [101/155] (548s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[477.407049] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[477.508547] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.101s)
[477.580155] [102/155] (548s left) kms_content_protection (lic-type-0)
[477.720107] Starting subtest: lic-type-0
[477.721742] Subtest lic-type-0: SKIP (0.000s)
[477.854811] [103/155] (548s left) kms_frontbuffer_tracking (hdr-farfromfence-mmap-gtt)
[477.951419] Starting subtest: hdr-farfromfence-mmap-gtt
[477.953385] Subtest hdr-farfromfence-mmap-gtt: SKIP (0.000s)
[478.060105] [104/155] (548s left) gem_mmap (bad-size)
[478.104172] Subtest bad-size: SKIP (0.000s)
[478.155950] [105/155] (548s left) kms_flip (nonblocking-read)
[478.248598] Starting subtest: nonblocking-read
[478.249562] Subtest nonblocking-read: SUCCESS (0.000s)
[478.371263] [106/155] (547s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-pgflip-blt)
[478.460274] Starting subtest: hdr-2p-scndscrn-indfb-pgflip-blt
[478.461991] Subtest hdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[478.558327] [107/155] (547s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[478.642367] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[478.644098] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[478.777295] [108/155] (547s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[478.870336] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[478.872097] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[478.966650] [109/155] (547s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[479.062137] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc
[479.063971] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[479.155929] [110/155] (547s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[479.252693] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[479.254360] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[479.341396] [111/155] (547s left) gem_mmap_offset (blt-coherency)
[479.388185] Starting subtest: blt-coherency
[479.393469] Subtest blt-coherency: SUCCESS (0.007s)
[479.511435] [112/155] (547s left) syncobj_timeline (single-wait-all-signaled)
[479.572104] Starting subtest: single-wait-all-signaled
[479.573037] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[479.676165] [113/155] (546s left) kms_async_flips (test-cursor)
[479.770244] Starting subtest: test-cursor
[480.141666] Starting dynamic subtest: pipe-A-eDP-1
[480.942796] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.801s)
[481.326185] Starting dynamic subtest: pipe-B-eDP-1
[482.076856] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.759s)
[482.456535] Starting dynamic subtest: pipe-C-eDP-1
[483.214837] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.766s)
[483.582936] Starting dynamic subtest: pipe-D-eDP-1
[484.341202] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.767s)
[484.342291] Subtest test-cursor: SUCCESS (4.572s)
[485.502311] [114/155] (541s left) gem_fence_thrash (bo-write-verify-y)
[485.533086] Starting subtest: bo-write-verify-y
[485.556452] Subtest bo-write-verify-y: SKIP (0.020s)
[485.612590] [115/155] (541s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[485.718083] Starting subtest: fbc-rgb565-draw-mmap-cpu
[489.810482] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.092s)
[491.012334] [116/155] (535s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[491.100268] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[491.101816] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[491.194886] [117/155] (535s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[491.282879] Starting subtest: pr-cursor-plane-move-continuous-sf
[491.285313] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[491.353596] [118/155] (535s left) gem_ctx_sseu (mmap-args)
[491.402996] Subtest mmap-args: SKIP (0.000s)
[491.467557] [119/155] (535s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[491.549684] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[491.551639] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[491.631920] [120/155] (535s left) gem_exec_reloc (basic-wc-read)
[491.686365] Subtest basic-wc-read: SKIP (0.000s)
[491.750861] [121/155] (535s left) gem_close_race (multigpu-basic-threads)
[491.813270] Starting subtest: multigpu-basic-threads
[491.815239] Subtest multigpu-basic-threads: SKIP (0.000s)
[492.025748] [122/155] (534s left) gem_exec_reloc (basic-write-gtt-active)
[492.076749] Subtest basic-write-gtt-active: SKIP (0.000s)
[492.146759] [123/155] (534s left) tools_test (sysfs_l3_parity)
[492.182068] Starting subtest: sysfs_l3_parity
[492.246253] Subtest sysfs_l3_parity: SKIP (0.069s)
[492.312121] [124/155] (534s left) gem_exec_fence (syncobj-timeline-chain-engines)
[492.868290] Starting subtest: syncobj-timeline-chain-engines
[493.000312] Subtest syncobj-timeline-chain-engines: SUCCESS (0.134s)
[494.394506] [125/155] (532s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[494.498189] Starting subtest: 4-tiled-64bpp-rotate-180
[496.099704] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.602s)
[496.285711] [126/155] (530s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[496.380766] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[496.382814] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[497.557768] [127/155] (529s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[497.656198] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[504.684300] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (7.029s)
[504.817259] [128/155] (522s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[504.921089] Starting subtest: yf-tiled-32bpp-rotate-0
[504.923087] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[505.012781] [129/155] (522s left) kms_flip (flip-vs-expired-vblank)
[505.103543] Starting subtest: flip-vs-expired-vblank
[505.104446] Starting dynamic subtest: A-eDP1
[513.792950] Dynamic subtest A-eDP1: SUCCESS (8.662s)
[513.808744] Starting dynamic subtest: B-eDP1
[522.528513] Dynamic subtest B-eDP1: SUCCESS (8.733s)
[522.538623] Starting dynamic subtest: C-eDP1
[531.267246] Dynamic subtest C-eDP1: SUCCESS (8.723s)
[531.277174] Starting dynamic subtest: D-eDP1
[539.900851] Dynamic subtest D-eDP1: SUCCESS (8.632s)
[539.902034] Subtest flip-vs-expired-vblank: SUCCESS (34.762s)
[541.024177] [130/155] (486s left) i915_pm_freq_api (freq-reset-multiple)
[541.075132] Starting subtest: freq-reset-multiple
[541.076012] Starting dynamic subtest: gt0
[551.082492] Dynamic subtest gt0: SUCCESS (10.005s)
[551.092970] Starting dynamic subtest: gt1
[559.617180] Dynamic subtest gt1: SUCCESS (8.523s)
[559.618104] Subtest freq-reset-multiple: SUCCESS (18.530s)
[559.685623] [131/155] (467s left) kms_psr (psr2-sprite-mmap-cpu)
[559.777468] Starting subtest: psr2-sprite-mmap-cpu
[559.778439] Starting dynamic subtest: eDP-1
[561.528360] Dynamic subtest eDP-1: SUCCESS (1.751s)
[561.529228] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.752s)
[562.388400] [132/155] (464s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[562.604630] Starting subtest: cursor-rapid-movement-128x128
[562.609327] Starting dynamic subtest: pipe-A-eDP-1
[563.178590] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.569s)
[563.209570] Starting dynamic subtest: pipe-D-eDP-1
[564.413870] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.213s)
[564.414922] Subtest cursor-rapid-movement-128x128: SUCCESS (1.809s)
[565.258888] [133/155] (462s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[565.306528] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[565.308279] Subtest enable-vfs-bind-unbind-each-numvfs-all: SKIP (0.001s)
[565.389815] [134/155] (461s left) gen7_exec_parse (basic-allowed)
[565.440558] Subtest basic-allowed: SKIP (0.000s)
[565.519999] [135/155] (461s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[565.630215] Starting subtest: cursorA-vs-flipA-atomic
[576.783181] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.151s)
[577.610527] [136/155] (449s left) kms_psr (fbc-pr-primary-page-flip)
[577.704578] Starting subtest: fbc-pr-primary-page-flip
[577.706261] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[577.774257] [137/155] (449s left) kms_plane_scaling (planes-downscale-factor-0-75)
[577.863492] Starting subtest: planes-downscale-factor-0-75
[577.864548] Starting dynamic subtest: pipe-A
[577.884616] Dynamic subtest pipe-A: SKIP (0.020s)
[577.895177] Starting dynamic subtest: pipe-B
[577.920096] Dynamic subtest pipe-B: SKIP (0.035s)
[577.929392] Starting dynamic subtest: pipe-C
[577.954547] Dynamic subtest pipe-C: SKIP (0.035s)
[577.963672] Starting dynamic subtest: pipe-D
[577.990312] Dynamic subtest pipe-D: SKIP (0.034s)
[577.991803] Subtest planes-downscale-factor-0-75: SKIP (0.126s)
[578.071923] [138/155] (449s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-move)
[578.159394] Starting subtest: psrhdr-2p-primscrn-spr-indfb-move
[578.161080] Subtest psrhdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[578.251058] [139/155] (449s left) perf_pmu (busy-accuracy-98)
[578.288577] Starting subtest: busy-accuracy-98
[578.289494] Starting dynamic subtest: rcs0
[581.333378] Dynamic subtest rcs0: SUCCESS (3.040s)
[581.343321] Starting dynamic subtest: bcs0
[584.391399] Dynamic subtest bcs0: SUCCESS (3.055s)
[584.403093] Starting dynamic subtest: vcs0
[587.439395] Dynamic subtest vcs0: SUCCESS (3.046s)
[587.449064] Starting dynamic subtest: vcs1
[590.482579] Dynamic subtest vcs1: SUCCESS (3.039s)
[590.494502] Starting dynamic subtest: vecs0
[593.519504] Dynamic subtest vecs0: SUCCESS (3.038s)
[593.529303] Starting dynamic subtest: ccs0
[596.578502] Dynamic subtest ccs0: SUCCESS (3.054s)
[596.579874] Subtest busy-accuracy-98: SUCCESS (18.285s)
[596.699388] [140/155] (430s left) gem_ppgtt (blt-vs-render-ctx0)
[596.765989] Starting subtest: blt-vs-render-ctx0
[629.560942] Subtest blt-vs-render-ctx0: SUCCESS (32.783s)
[629.662774] [141/155] (397s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-indfb-pgflip-blt)
[629.822491] Starting subtest: fbchdr-2p-scndscrn-indfb-pgflip-blt
[629.824068] Subtest fbchdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[629.920695] [142/155] (397s left) gem_exec_whisper (basic-queues-all)
[629.975637] Starting subtest: basic-queues-all
[640.409776] Subtest basic-queues-all: SUCCESS (10.433s)
[640.588362] [143/155] (387s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[640.678714] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[640.679683] Starting dynamic subtest: pipe-A-eDP-1
[640.689560] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[640.700230] Starting dynamic subtest: pipe-B-eDP-1
[640.709514] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[640.719708] Starting dynamic subtest: pipe-C-eDP-1
[640.728162] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[640.737495] Starting dynamic subtest: pipe-D-eDP-1
[640.746318] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[640.747797] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[642.955296] [144/155] (384s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[643.041268] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[643.042243] Starting dynamic subtest: pipe-A-eDP-1
[643.050419] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[643.060229] Starting dynamic subtest: pipe-B-eDP-1
[643.068504] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[643.078273] Starting dynamic subtest: pipe-C-eDP-1
[643.086883] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[643.097782] Starting dynamic subtest: pipe-D-eDP-1
[643.106153] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[643.107766] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[645.308434] [145/155] (382s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[645.401415] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[652.025072] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.625s)
[652.159170] [146/155] (375s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[652.258682] Starting subtest: extended-modeset-hang-oldfb-with-reset
[652.259672] Starting dynamic subtest: pipe-A
[663.937268] Dynamic subtest pipe-A: SUCCESS (11.676s)
[663.948619] Starting dynamic subtest: pipe-D
[676.720948] Dynamic subtest pipe-D: SUCCESS (12.781s)
[676.722754] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.462s)
[677.627794] [147/155] (350s left) kms_psr (fbc-psr-cursor-render)
[677.722060] Starting subtest: fbc-psr-cursor-render
[677.722863] Starting dynamic subtest: eDP-1
[677.724337] Dynamic subtest eDP-1: SKIP (0.000s)
[677.725809] Subtest fbc-psr-cursor-render: SKIP (0.001s)
[677.794275] [148/155] (350s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-wc)
[677.881229] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-wc
[677.883201] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[678.011384] [149/155] (349s left) gem_exec_fence (basic-await)
[678.181576] Starting subtest: basic-await
[678.182571] Starting dynamic subtest: rcs0
[678.253276] Dynamic subtest rcs0: SUCCESS (0.077s)
[678.267311] Starting dynamic subtest: bcs0
[678.326441] Dynamic subtest bcs0: SUCCESS (0.071s)
[678.342168] Starting dynamic subtest: vcs0
[678.400325] Dynamic subtest vcs0: SUCCESS (0.072s)
[678.413673] Starting dynamic subtest: vcs1
[678.475369] Dynamic subtest vcs1: SUCCESS (0.073s)
[678.488312] Starting dynamic subtest: vecs0
[678.549685] Dynamic subtest vecs0: SUCCESS (0.072s)
[678.562262] Starting dynamic subtest: ccs0
[678.622469] Dynamic subtest ccs0: SUCCESS (0.071s)
[678.624250] Subtest basic-await: SUCCESS (0.447s)
[680.455439] [150/155] (347s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[680.559665] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[680.561428] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[680.632895] [151/155] (347s left) vgem_basic (create)
[680.673385] Starting subtest: create
[680.704177] Subtest create: FAIL (0.017s)
[680.740876] [152/155] (347s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-mmap-wc)
[680.828762] Starting subtest: fbchdr-rgb101010-draw-mmap-wc
[680.830655] Subtest fbchdr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[680.946025] [153/155] (347s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[681.041859] Starting subtest: psr-rgb565-draw-pwrite
[688.186295] Subtest psr-rgb565-draw-pwrite: SUCCESS (7.145s)
[688.308044] [154/155] (339s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[688.357175] Starting subtest: yf-tiled-ccs-to-x-tiled
[688.358867] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[688.533284] [155/155] (339s left) perf (enable-disable)
[688.662327] Starting subtest: enable-disable
[688.663123] Starting dynamic subtest: 0-rcs0
[690.955020] Dynamic subtest 0-rcs0: SUCCESS (2.292s)
[690.965233] Starting dynamic subtest: 1-vcs1
[695.475931] Dynamic subtest 1-vcs1: SUCCESS (4.519s)
[695.477771] Subtest enable-disable: SUCCESS (6.813s)
[695.536997] Closing watchdogs
results: parsing output: 0/ for test: kms_plane_multiple
results: parsing output: 1/ for test: gem_mmap_wc
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: kms_vblank
results: parsing output: 7/ for test: gem_softpin
results: parsing output: 8/ for test: gem_render_copy
results: parsing output: 9/ for test: gem_exec_reloc
results: parsing output: 10/ for test: kms_chamelium_hpd
results: parsing output: 11/ for test: gem_partial_pwrite_pread
results: parsing output: 12/ for test: kms_cursor_legacy
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: syncobj_wait
results: parsing output: 15/ for test: kms_ccs
results: parsing output: 16/ for test: gem_sync
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_chamelium_color
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_color_pipeline
results: parsing output: 22/ for test: api_intel_bb
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: kms_flip
results: parsing output: 26/ for test: gem_exec_balancer
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_lease
results: parsing output: 29/ for test: kms_vblank
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: kms_pm_rpm
results: parsing output: 32/ for test: gem_mmap
results: parsing output: 33/ for test: kms_cursor_legacy
results: parsing output: 34/ for test: i915_pm_rpm
results: parsing output: 35/ for test: kms_cursor_crc
results: parsing output: 36/ for test: gem_ctx_exec
results: parsing output: 37/ for test: syncobj_wait
results: parsing output: 38/ for test: kms_lease
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_plane
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gen7_exec_parse
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: kms_cursor_crc
results: parsing output: 48/ for test: gem_ctx_persistence
results: parsing output: 49/ for test: gem_exec_capture
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: gem_exec_reloc
results: parsing output: 54/ for test: gem_exec_schedule
results: parsing output: 55/ for test: kms_prop_blob
results: parsing output: 56/ for test: prime_mmap_coherency
results: parsing output: 57/ for test: kms_plane_scaling
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_ctx_bad_destroy
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: i915_drm_fdinfo
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: i915_suspend
results: parsing output: 64/ for test: kms_pipe_b_c_ivb
results: parsing output: 65/ for test: kms_getfb
results: parsing output: 66/ for test: gem_exec_params
results: parsing output: 67/ for test: api_intel_bb
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: gem_pxp
results: parsing output: 70/ for test: gem_mmap_gtt
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_flip_scaled_crc
results: parsing output: 76/ for test: kms_pipe_crc_basic
results: parsing output: 77/ for test: kms_setmode
results: parsing output: 78/ for test: kms_dsc
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_exec_fence
results: parsing output: 82/ for test: perf_pmu
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_huc_copy
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: gem_exec_reloc
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_exec_reloc
results: parsing output: 89/ for test: dmabuf_sync_file
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_async_flips
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_ccs
results: parsing output: 95/ for test: gem_ccs
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: gem_exec_schedule
results: parsing output: 98/ for test: sysfs_heartbeat_interval
results: parsing output: 99/ for test: kms_rotation_crc
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_content_protection
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_mmap
results: parsing output: 104/ for test: kms_flip
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_mmap_offset
results: parsing output: 111/ for test: syncobj_timeline
results: parsing output: 112/ for test: kms_async_flips
results: parsing output: 113/ for test: gem_fence_thrash
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_psr2_sf
results: parsing output: 117/ for test: gem_ctx_sseu
results: parsing output: 118/ for test: kms_flip_scaled_crc
results: parsing output: 119/ for test: gem_exec_reloc
results: parsing output: 120/ for test: gem_close_race
results: parsing output: 121/ for test: gem_exec_reloc
results: parsing output: 122/ for test: tools_test
results: parsing output: 123/ for test: gem_exec_fence
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: kms_flip
results: parsing output: 129/ for test: i915_pm_freq_api
results: parsing output: 130/ for test: kms_psr
results: parsing output: 131/ for test: kms_cursor_crc
results: parsing output: 132/ for test: sriov_basic
results: parsing output: 133/ for test: gen7_exec_parse
results: parsing output: 134/ for test: kms_cursor_legacy
results: parsing output: 135/ for test: kms_psr
results: parsing output: 136/ for test: kms_plane_scaling
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: perf_pmu
results: parsing output: 139/ for test: gem_ppgtt
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: gem_exec_whisper
results: parsing output: 142/ for test: kms_ccs
results: parsing output: 143/ for test: kms_ccs
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: kms_busy
results: parsing output: 146/ for test: kms_psr
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: gem_exec_fence
results: parsing output: 149/ for test: kms_psr2_sf
results: parsing output: 150/ for test: vgem_basic
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: gem_render_copy
results: parsing output: 154/ for test: perf
Done.