[57.855538] Initializing watchdogs
[57.855629]   /dev/watchdog0
[57.869838] [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]
[57.874369] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.876596] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.879996] [001/133] (960s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[58.007928] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[58.045829] Starting dynamic subtest: pipe-A-plane-0
[58.457648] Dynamic subtest pipe-A-plane-0: SUCCESS (0.411s)
[58.468658] Starting dynamic subtest: pipe-A-plane-3
[58.722993] Dynamic subtest pipe-A-plane-3: SUCCESS (0.265s)
[59.851662] Starting dynamic subtest: pipe-B-plane-0
[60.245470] Dynamic subtest pipe-B-plane-0: SUCCESS (0.400s)
[60.255870] Starting dynamic subtest: pipe-B-plane-3
[60.501593] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[60.807883] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.801s)
[61.631704] [002/133] (956s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[61.748443] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[61.752625] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[61.868070] [003/133] (956s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[61.974074] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[61.978479] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[62.109184] [004/133] (956s left) prime_mmap_coherency (ioctl-errors)
[62.173560] Starting subtest: ioctl-errors
[78.104706] Subtest ioctl-errors: SUCCESS (15.931s)
[78.309210] [005/133] (940s left) perf (non-sampling-read-error)
[78.477491] Starting subtest: non-sampling-read-error
[78.487268] Subtest non-sampling-read-error: SUCCESS (0.010s)
[78.521258] [006/133] (940s left) core_getversion (basic)
[78.557800] Starting subtest: basic
[78.561174] Subtest basic: SUCCESS (0.000s)
[78.647555] [007/133] (939s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[78.746653] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[78.755173] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.010s)
[78.897276] [008/133] (939s left) api_intel_allocator (execbuf-with-allocator)
[78.965217] Starting subtest: execbuf-with-allocator
[78.969499] Subtest execbuf-with-allocator: SUCCESS (0.006s)
[79.117114] [009/133] (939s left) tools_test (sysfs_l3_parity)
[79.163157] Starting subtest: sysfs_l3_parity
[79.242689] Subtest sysfs_l3_parity: SKIP (0.088s)
[79.306158] [010/133] (939s left) kms_invalid_mode (bad-htotal)
[79.405962] Starting subtest: bad-htotal
[79.408072] Starting dynamic subtest: pipe-A-eDP-1
[79.695573] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s)
[79.705042] Starting dynamic subtest: pipe-B-eDP-1
[79.707285] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[79.714727] Starting dynamic subtest: pipe-C-eDP-1
[79.716929] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[79.724421] Starting dynamic subtest: pipe-D-eDP-1
[79.726356] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[79.728328] Subtest bad-htotal: SUCCESS (0.296s)
[80.554159] [011/133] (938s left) kms_getfb (getfb2-handle-closed)
[80.653161] Starting subtest: getfb2-handle-closed
[80.655527] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[80.766863] [012/133] (938s left) gen3_mixed_blits
[80.882392] [013/133] (937s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[80.975823] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[88.224059] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.250s)
[88.370868] [014/133] (930s left) kms_cursor_crc (cursor-tearing-position-change)
[88.493375] Starting subtest: cursor-tearing-position-change
[88.495683] Starting dynamic subtest: pipe-A-eDP-1
[89.094464] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.598s)
[89.103391] Starting dynamic subtest: pipe-D-eDP-1
[90.287498] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.192s)
[90.289693] Subtest cursor-tearing-position-change: SUCCESS (1.793s)
[91.122791] [015/133] (927s left) kms_flip (absolute-wf_vblank)
[91.216551] Starting subtest: absolute-wf_vblank
[91.218757] Starting dynamic subtest: A-eDP1
[99.969857] Dynamic subtest A-eDP1: SUCCESS (8.754s)
[99.978500] Starting dynamic subtest: B-eDP1
[108.703496] Dynamic subtest B-eDP1: SUCCESS (8.732s)
[108.713652] Starting dynamic subtest: C-eDP1
[117.435061] Dynamic subtest C-eDP1: SUCCESS (8.730s)
[117.444534] Starting dynamic subtest: D-eDP1
[126.155762] Dynamic subtest D-eDP1: SUCCESS (8.721s)
[126.158061] Subtest absolute-wf_vblank: SUCCESS (34.944s)
[127.370210] [016/133] (891s left) kms_pm_backlight (basic-brightness)
[127.476393] Starting subtest: basic-brightness
[127.523815] Starting dynamic subtest: eDP-1
[128.019721] Dynamic subtest eDP-1: SUCCESS (0.495s)
[128.022122] Subtest basic-brightness: SUCCESS (0.544s)
[128.891927] [017/133] (890s left) kms_color (ctm-max)
[128.987218] Starting subtest: ctm-max
[128.989491] Starting dynamic subtest: pipe-A-eDP-1
[129.687066] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.698s)
[129.696055] Starting dynamic subtest: pipe-B-eDP-1
[131.048920] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.362s)
[131.057317] Starting dynamic subtest: pipe-C-eDP-1
[132.385471] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.336s)
[132.394306] Starting dynamic subtest: pipe-D-eDP-1
[133.713445] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.326s)
[133.715751] Subtest ctm-max: SUCCESS (4.725s)
[134.519555] [018/133] (884s left) gem_exec_params (rel-constants-invalid)
[134.596289] Starting subtest: rel-constants-invalid
[134.598197] Subtest rel-constants-invalid: SUCCESS (0.000s)
[134.727037] [019/133] (884s left) gem_exec_schedule (noreorder-corked)
[134.915344] Starting subtest: noreorder-corked
[134.917897] Starting dynamic subtest: rcs0
[136.083102] Dynamic subtest rcs0: SUCCESS (1.169s)
[136.092702] Starting dynamic subtest: vcs0
[137.898469] Dynamic subtest vcs0: SUCCESS (1.812s)
[137.909569] Starting dynamic subtest: vcs1
[139.954930] Dynamic subtest vcs1: SUCCESS (2.055s)
[139.964892] Starting dynamic subtest: vecs0
[141.922321] Dynamic subtest vecs0: SUCCESS (1.965s)
[141.934039] Starting dynamic subtest: ccs0
[143.093243] Dynamic subtest ccs0: SUCCESS (1.170s)
[143.095838] Subtest noreorder-corked: SUCCESS (8.180s)
[143.292100] [020/133] (875s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[143.356737] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[143.422545] [021/133] (875s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[143.824116] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[144.620373] [022/133] (874s left) gem_exec_whisper (basic-contexts-priority-all)
[144.688891] Starting subtest: basic-contexts-priority-all
[166.902865] Subtest basic-contexts-priority-all: SUCCESS (22.207s)
[167.097330] [023/133] (852s left) gen9_exec_parse (allowed-all)
[167.158220] Subtest allowed-all: SKIP (0.000s)
[167.257520] [024/133] (852s left) perf_pmu (busy-accuracy-98)
[167.300487] Starting subtest: busy-accuracy-98
[167.302459] Starting dynamic subtest: rcs0
[170.348061] Dynamic subtest rcs0: SUCCESS (3.045s)
[170.357705] Starting dynamic subtest: bcs0
[173.394646] Dynamic subtest bcs0: SUCCESS (3.045s)
[173.405767] Starting dynamic subtest: vcs0
[176.434726] Dynamic subtest vcs0: SUCCESS (3.038s)
[176.445048] Starting dynamic subtest: vcs1
[179.475216] Dynamic subtest vcs1: SUCCESS (3.039s)
[179.484502] Starting dynamic subtest: vecs0
[182.512383] Dynamic subtest vecs0: SUCCESS (3.035s)
[182.521930] Starting dynamic subtest: ccs0
[185.560625] Dynamic subtest ccs0: SUCCESS (3.047s)
[185.562954] Subtest busy-accuracy-98: SUCCESS (18.258s)
[185.701856] [025/133] (833s left) gem_workarounds (suspend-resume-fd)
[185.769236] Starting subtest: suspend-resume-fd
[202.410750] Subtest suspend-resume-fd: SUCCESS (2.062s)
[202.570614] [026/133] (816s left) kms_psr (fbc-pr-sprite-plane-move)
[202.686190] Starting subtest: fbc-pr-sprite-plane-move
[202.690623] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[202.780035] [027/133] (816s left) syncobj_wait (invalid-wait-bad-flags)
[202.835410] Starting subtest: invalid-wait-bad-flags
[202.837280] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[202.954761] [028/133] (816s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[203.051307] Starting subtest: fbc-rgb565-draw-mmap-wc
[207.019538] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (3.971s)
[208.235560] [029/133] (811s left) kms_addfb_basic (unused-offsets)
[208.290599] Starting subtest: unused-offsets
[208.292644] Subtest unused-offsets: SUCCESS (0.000s)
[208.456710] [030/133] (811s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[208.513570] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[208.515538] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[208.619814] [031/133] (810s left) kms_psr (fbc-pr-cursor-plane-move)
[208.713155] Starting subtest: fbc-pr-cursor-plane-move
[208.717653] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[208.815822] [032/133] (810s left) kms_psr (psr-cursor-render)
[208.898051] Starting subtest: psr-cursor-render
[208.900349] Starting dynamic subtest: eDP-1
[210.618315] Dynamic subtest eDP-1: SUCCESS (1.719s)
[210.620617] Subtest psr-cursor-render: SUCCESS (1.720s)
[211.488285] [033/133] (808s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[211.594081] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[211.605212] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.010s)
[211.687756] [034/133] (807s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[211.787647] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[211.792131] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[211.920432] [035/133] (807s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[212.013296] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[212.017710] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[212.099219] [036/133] (807s left) kms_addfb_basic (invalid-get-prop)
[212.160997] Starting subtest: invalid-get-prop
[212.163184] Subtest invalid-get-prop: SUCCESS (0.000s)
[212.313115] [037/133] (807s left) gem_softpin (evict-prime-sanity-check)
[212.378715] Starting subtest: evict-prime-sanity-check
[212.381027] Starting dynamic subtest: rcs0
[213.562598] Dynamic subtest rcs0: SUCCESS (1.183s)
[213.575667] Starting dynamic subtest: bcs0
[214.716153] Dynamic subtest bcs0: SUCCESS (1.152s)
[214.728138] Starting dynamic subtest: vcs0
[216.451902] Dynamic subtest vcs0: SUCCESS (1.732s)
[216.464083] Starting dynamic subtest: vcs1
[218.528538] Dynamic subtest vcs1: SUCCESS (2.075s)
[218.541027] Starting dynamic subtest: vecs0
[220.502083] Dynamic subtest vecs0: SUCCESS (1.971s)
[220.513831] Starting dynamic subtest: ccs0
[221.660577] Dynamic subtest ccs0: SUCCESS (1.158s)
[221.672489] Starting dynamic subtest: all
[222.804756] Dynamic subtest all: SUCCESS (1.142s)
[222.807382] Subtest evict-prime-sanity-check: SUCCESS (10.426s)
[222.896119] [038/133] (796s left) i915_suspend (fence-restore-untiled)
[222.954749] Starting subtest: fence-restore-untiled
[222.959141] Subtest fence-restore-untiled: SKIP (0.000s)
[223.064882] [039/133] (796s left) kms_psr (psr-sprite-mmap-gtt)
[223.176307] Starting subtest: psr-sprite-mmap-gtt
[223.178612] Starting dynamic subtest: eDP-1
[224.612122] Dynamic subtest eDP-1: SKIP (1.432s)
[224.616654] Subtest psr-sprite-mmap-gtt: SKIP (1.434s)
[224.801769] [040/133] (795s left) gem_userptr_blits (unsync-unmap)
[224.871596] Subtest unsync-unmap: SKIP (0.000s)
[225.019475] [041/133] (794s left) gem_exec_balancer (bonded-true-hang)
[225.288140] Starting subtest: bonded-true-hang
[225.293821] Subtest bonded-true-hang: SKIP (0.000s)
[225.406264] [042/133] (794s left) gem_lmem_swapping (parallel-random-engines)
[225.443050] Subtest parallel-random-engines: SKIP (0.000s)
[225.481103] [043/133] (794s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[225.548306] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[225.553090] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[225.746220] [044/133] (794s left) syncobj_timeline (etime-single-wait-all-submitted)
[225.808799] Starting subtest: etime-single-wait-all-submitted
[225.915945] Subtest etime-single-wait-all-submitted: SUCCESS (0.105s)
[226.036330] [045/133] (794s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[226.141624] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[226.146060] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[226.235883] [046/133] (793s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[226.338594] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[226.343018] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[226.468327] [047/133] (793s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[226.593615] Starting subtest: short-busy-flip-before-cursor-toggle
[226.598112] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[226.747192] [048/133] (793s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[226.846799] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[233.716268] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (6.871s)
[233.853665] [049/133] (786s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[233.944771] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[233.946863] Starting dynamic subtest: pipe-A-eDP-1
[233.968501] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[233.979026] Starting dynamic subtest: pipe-B-eDP-1
[233.999722] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[234.009036] Starting dynamic subtest: pipe-C-eDP-1
[234.030178] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[234.040693] Starting dynamic subtest: pipe-D-eDP-1
[234.062448] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[234.066495] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[236.124611] [050/133] (784s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[236.231853] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[236.234076] Starting dynamic subtest: pipe-A-eDP-1
[236.254262] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[236.265252] Starting dynamic subtest: pipe-B-eDP-1
[236.284332] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[236.293030] Starting dynamic subtest: pipe-C-eDP-1
[236.312149] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[236.320916] Starting dynamic subtest: pipe-D-eDP-1
[236.340072] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[236.342032] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.007s)
[239.418348] [051/133] (780s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[239.521866] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[239.526128] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[239.660581] [052/133] (780s left) gem_partial_pwrite_pread (reads-snoop)
[239.720138] Subtest reads-snoop: SKIP (0.000s)
[239.792341] [053/133] (780s left) syncobj_timeline (invalid-query-illegal-handle)
[239.853098] Starting subtest: invalid-query-illegal-handle
[239.855400] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[239.972769] [054/133] (780s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[240.082080] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[247.171040] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.091s)
[247.354033] [055/133] (773s left) kms_lease (lease-unleased-connector)
[247.455936] Starting subtest: lease-unleased-connector
[247.458302] Starting dynamic subtest: pipe-A-eDP-1
[247.460668] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[247.470157] Starting dynamic subtest: pipe-B-eDP-1
[247.472402] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[247.481639] Starting dynamic subtest: pipe-C-eDP-1
[247.483883] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s)
[247.493292] Starting dynamic subtest: pipe-D-eDP-1
[247.495296] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[247.497084] Subtest lease-unleased-connector: SUCCESS (0.032s)
[247.623695] [056/133] (772s left) syncobj_wait (invalid-single-wait-unsubmitted)
[247.684726] Starting subtest: invalid-single-wait-unsubmitted
[247.686710] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[247.809134] [057/133] (772s left) gem_mmap_gtt (ptrace)
[247.873115] Subtest ptrace: SKIP (0.000s)
[247.942390] [058/133] (772s left) syncobj_timeline (multi-wait-submitted-signaled)
[247.993454] Starting subtest: multi-wait-submitted-signaled
[247.995755] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[248.096854] [059/133] (772s left) gem_madvise (dontneed-before-exec)
[248.140485] Starting subtest: dontneed-before-exec
[248.162480] Subtest dontneed-before-exec: SKIP (0.020s)
[248.229604] [060/133] (772s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[248.337546] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[248.340939] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[248.465924] [061/133] (772s left) gem_ccs (ctrl-surf-copy-new-ctx)
[248.527385] Starting subtest: ctrl-surf-copy-new-ctx
[248.530869] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[248.645889] [062/133] (772s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[248.730673] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[253.157069] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.428s)
[254.346530] [063/133] (766s left) syncobj_wait (single-wait-all-for-submit-signaled)
[254.410244] Starting subtest: single-wait-all-for-submit-signaled
[254.412453] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[254.549846] [064/133] (766s left) gem_ctx_isolation (nonpriv-switch)
[254.630281] Starting subtest: nonpriv-switch
[254.632946] Starting dynamic subtest: rcs0
[254.923577] Dynamic subtest rcs0: SUCCESS (0.293s)
[254.935770] Starting dynamic subtest: bcs0
[255.205785] Dynamic subtest bcs0: SUCCESS (0.281s)
[255.216629] Starting dynamic subtest: vcs0
[255.510740] Dynamic subtest vcs0: SUCCESS (0.304s)
[255.523552] Starting dynamic subtest: vcs1
[256.723843] Dynamic subtest vcs1: SUCCESS (1.212s)
[256.735958] Starting dynamic subtest: vecs0
[258.818866] Dynamic subtest vecs0: SUCCESS (2.094s)
[258.830510] Starting dynamic subtest: ccs0
[260.830268] Dynamic subtest ccs0: SUCCESS (2.010s)
[260.832577] Subtest nonpriv-switch: SUCCESS (6.200s)
[261.092429] [065/133] (759s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[261.185651] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[261.190300] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[261.283657] [066/133] (759s left) i915_drm_fdinfo (most-busy-check-all)
[261.329155] Starting subtest: most-busy-check-all
[261.331500] Starting dynamic subtest: rcs0
[261.336001] Dynamic subtest rcs0: SKIP (0.003s)
[261.345684] Starting dynamic subtest: bcs0
[261.349834] Dynamic subtest bcs0: SKIP (0.000s)
[261.358551] Starting dynamic subtest: vcs0
[261.362918] Dynamic subtest vcs0: SKIP (0.000s)
[261.371825] Starting dynamic subtest: vcs1
[261.376219] Dynamic subtest vcs1: SKIP (0.000s)
[261.384757] Starting dynamic subtest: vecs0
[261.389152] Dynamic subtest vecs0: SKIP (0.000s)
[261.397620] Starting dynamic subtest: ccs0
[261.401971] Dynamic subtest ccs0: SKIP (0.000s)
[261.406373] Subtest most-busy-check-all: SKIP (0.008s)
[261.441896] [067/133] (759s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[261.582135] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[261.584360] Starting dynamic subtest: pipe-A-eDP-1
[261.665505] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[261.677279] Starting dynamic subtest: pipe-B-eDP-1
[262.801001] Dynamic subtest pipe-B-eDP-1: SKIP (1.134s)
[262.805496] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.225s)
[264.106499] [068/133] (756s left) gem_create (create-ext-placement-each)
[264.280752] Starting subtest: create-ext-placement-each
[264.283426] Subtest create-ext-placement-each: SUCCESS (0.000s)
[264.386609] [069/133] (756s left) gen7_exec_parse (basic-allocation)
[264.450932] Subtest basic-allocation: SKIP (0.000s)
[264.549472] [070/133] (756s left) api_intel_bb (intel-bb-blit-none)
[264.613576] Starting subtest: intel-bb-blit-none
[268.315637] Subtest intel-bb-blit-none: SUCCESS (3.702s)
[268.449357] [071/133] (752s left) kms_chamelium_hpd (vga-hpd)
[268.837815] Subtest vga-hpd: SKIP (0.000s)
[269.613756] [072/133] (751s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[269.679849] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[269.737306] [073/133] (751s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[269.800554] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[269.881303] [074/133] (751s left) i915_pm_rps (reset)
[269.936174] Starting subtest: reset
[278.383216] Subtest reset: SUCCESS (8.445s)
[278.528803] [075/133] (742s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[278.660257] Starting subtest: cursor-vs-flip-legacy
[307.886523] Subtest cursor-vs-flip-legacy: SUCCESS (29.224s)
[308.786518] [076/133] (712s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[308.892255] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[308.894572] Starting dynamic subtest: pipe-A-eDP-1
[308.903577] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[308.914387] Starting dynamic subtest: pipe-B-eDP-1
[308.923308] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[308.932260] Starting dynamic subtest: pipe-C-eDP-1
[308.940969] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[308.949973] Starting dynamic subtest: pipe-D-eDP-1
[308.958514] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[308.963057] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.004s)
[311.132770] [077/133] (710s left) gem_exec_balancer (parallel-keep-in-fence)
[311.393254] Starting subtest: parallel-keep-in-fence
[312.594832] Subtest parallel-keep-in-fence: SUCCESS (1.205s)
[312.729140] [078/133] (708s left) prime_busy (after-wait)
[312.801517] Starting subtest: after-wait
[312.807278] Starting dynamic subtest: rcs0
[312.864116] Dynamic subtest rcs0: SUCCESS (0.060s)
[312.876303] Starting dynamic subtest: bcs0
[312.940201] Dynamic subtest bcs0: SUCCESS (0.075s)
[312.951479] Starting dynamic subtest: vcs0
[312.981128] Dynamic subtest vcs0: SUCCESS (0.040s)
[312.991056] Starting dynamic subtest: vcs1
[313.022337] Dynamic subtest vcs1: SUCCESS (0.039s)
[313.032507] Starting dynamic subtest: vecs0
[313.061787] Dynamic subtest vecs0: SUCCESS (0.039s)
[313.071838] Starting dynamic subtest: ccs0
[313.102179] Dynamic subtest ccs0: SUCCESS (0.039s)
[313.209782] Subtest after-wait: SUCCESS (0.407s)
[313.299209] [079/133] (708s left) gem_exec_schedule (u-independent)
[313.381413] Starting subtest: u-independent
[313.383364] Starting dynamic subtest: rcs0
[315.463902] Dynamic subtest rcs0: SUCCESS (2.083s)
[315.474654] Starting dynamic subtest: vcs0
[317.489941] Dynamic subtest vcs0: SUCCESS (2.023s)
[317.502977] Starting dynamic subtest: vcs1
[319.539256] Dynamic subtest vcs1: SUCCESS (2.048s)
[319.550810] Starting dynamic subtest: vecs0
[321.523872] Dynamic subtest vecs0: SUCCESS (1.982s)
[321.536327] Starting dynamic subtest: ccs0
[323.463649] Dynamic subtest ccs0: SUCCESS (1.937s)
[323.466471] Subtest u-independent: SUCCESS (10.085s)
[323.793025] [080/133] (697s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[323.903796] Starting subtest: fbc-pr-cursor-plane-update-sf
[323.908063] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[323.987146] [081/133] (697s left) kms_sequence (queue-busy)
[324.084805] Starting subtest: queue-busy
[324.086968] Starting dynamic subtest: pipe-A-eDP-1
[326.011967] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.927s)
[326.021895] Starting dynamic subtest: pipe-B-eDP-1
[328.632926] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.620s)
[328.643119] Starting dynamic subtest: pipe-C-eDP-1
[331.229540] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.596s)
[331.240631] Starting dynamic subtest: pipe-D-eDP-1
[333.772100] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.541s)
[333.774496] Subtest queue-busy: SUCCESS (9.689s)
[334.596006] [082/133] (686s left) kms_chamelium_audio (hdmi-audio)
[334.977468] Subtest hdmi-audio: SKIP (0.000s)
[335.778948] [083/133] (685s left) gem_mmap_gtt (big-bo-tiledy)
[335.835821] Subtest big-bo-tiledY: SKIP (0.000s)
[335.916676] [084/133] (685s left) gem_mmap_wc (write-prefaulted)
[335.963506] Subtest write-prefaulted: SKIP (0.000s)
[336.034104] [085/133] (685s left) gem_exec_fence (syncobj-unused-fence)
[336.520425] Starting subtest: syncobj-unused-fence
[336.526288] Subtest syncobj-unused-fence: SUCCESS (0.006s)
[338.585639] [FACT gem_exec_fence (syncobj-unused-fence)] new: kernel.kmod_is_loaded.vgem: true
[338.589085] [086/133] (683s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[338.656666] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[338.764417] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.106s)
[338.868883] [087/133] (682s left) i915_hangman (engine-engine-hang)
[338.962538] Starting subtest: engine-engine-hang
[338.964855] Starting dynamic subtest: rcs0
[340.454685] Dynamic subtest rcs0: SUCCESS (1.491s)
[340.467090] Starting dynamic subtest: bcs0
[342.438845] Dynamic subtest bcs0: SUCCESS (1.981s)
[342.452129] Starting dynamic subtest: vcs0
[344.422712] Dynamic subtest vcs0: SUCCESS (1.981s)
[344.437990] Starting dynamic subtest: vcs1
[346.406802] Dynamic subtest vcs1: SUCCESS (1.981s)
[346.419310] Starting dynamic subtest: vecs0
[348.454261] Dynamic subtest vecs0: SUCCESS (2.044s)
[348.466598] Starting dynamic subtest: ccs0
[350.438085] Dynamic subtest ccs0: SUCCESS (1.981s)
[350.441137] Subtest engine-engine-hang: SUCCESS (11.477s)
[350.622557] [088/133] (671s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[350.731171] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[350.733446] Starting dynamic subtest: pipe-A-eDP-1
[350.792776] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[350.804499] Starting dynamic subtest: pipe-B-eDP-1
[350.862931] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[350.874186] Starting dynamic subtest: pipe-C-eDP-1
[350.932032] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[350.943293] Starting dynamic subtest: pipe-D-eDP-1
[351.001330] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[351.005524] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.009s)
[352.895997] [089/133] (669s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[353.002281] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[353.006906] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[353.132465] [090/133] (668s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier)
[353.243943] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier
[353.248448] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s)
[353.344808] [091/133] (668s left) prime_mmap (test_map_unmap)
[353.401456] Starting subtest: test_map_unmap
[353.403394] Starting dynamic subtest: test_map_unmap-smem
[353.428592] Dynamic subtest test_map_unmap-smem: SUCCESS (0.030s)
[353.430998] Subtest test_map_unmap: SUCCESS (0.030s)
[353.547780] [092/133] (668s left) prime_self_import (basic-with_two_bos)
[353.584616] Starting subtest: basic-with_two_bos
[353.613298] Subtest basic-with_two_bos: SUCCESS (0.028s)
[353.740638] [093/133] (668s left) sysfs_preempt_timeout (invalid)
[353.798296] Starting subtest: invalid
[353.800600] Starting dynamic subtest: vecs0
[353.802880] Dynamic subtest vecs0: SUCCESS (0.000s)
[353.813407] Starting dynamic subtest: ccs0
[353.815343] Dynamic subtest ccs0: SUCCESS (0.000s)
[353.830921] Starting dynamic subtest: vcs0
[353.832534] Dynamic subtest vcs0: SUCCESS (0.000s)
[353.841119] Starting dynamic subtest: bcs0
[353.842734] Dynamic subtest bcs0: SUCCESS (0.000s)
[353.851544] Starting dynamic subtest: rcs0
[353.853142] Dynamic subtest rcs0: SUCCESS (0.000s)
[353.861590] Starting dynamic subtest: vcs1
[353.863211] Dynamic subtest vcs1: SUCCESS (0.000s)
[353.864851] Subtest invalid: SUCCESS (0.005s)
[353.900184] [094/133] (668s left) kms_big_fb (linear-64bpp-rotate-180)
[354.008275] Starting subtest: linear-64bpp-rotate-180
[355.655698] Subtest linear-64bpp-rotate-180: SUCCESS (1.646s)
[355.834388] [095/133] (666s left) gem_tiled_pread_pwrite
[355.956166] [096/133] (666s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[356.056214] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[361.353766] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.299s)
[362.502440] [097/133] (659s left) gem_fence_thrash (bo-write-verify-y)
[362.551530] Starting subtest: bo-write-verify-y
[362.578612] Subtest bo-write-verify-y: SKIP (0.023s)
[362.655983] [098/133] (659s left) kms_big_fb (4-tiled-addfb)
[362.764067] Starting subtest: 4-tiled-addfb
[362.766431] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[362.912702] [099/133] (659s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[363.026095] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[367.461924] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.440s)
[368.614613] [100/133] (653s left) gem_exec_fence (syncobj-timeline-chain-engines)
[369.155823] Starting subtest: syncobj-timeline-chain-engines
[369.273454] Subtest syncobj-timeline-chain-engines: SUCCESS (0.117s)
[370.636735] [101/133] (651s left) kms_pm_rpm (modeset-non-lpsp)
[372.675130] Starting subtest: modeset-non-lpsp
[373.828462] Subtest modeset-non-lpsp: SKIP (1.154s)
[374.225297] [102/133] (648s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[374.323897] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[374.464498] [103/133] (648s left) kms_cursor_crc (cursor-size-hints)
[374.598877] Starting subtest: cursor-size-hints
[374.601174] Starting dynamic subtest: pipe-A-eDP-1
[375.216029] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.614s)
[375.226216] Starting dynamic subtest: pipe-D-eDP-1
[376.455027] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.239s)
[376.457466] Subtest cursor-size-hints: SUCCESS (1.856s)
[377.273925] [104/133] (645s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[377.384263] Starting subtest: yf-tiled-addfb-size-overflow
[377.388720] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[377.518267] [105/133] (645s left) gem_pxp (verify-pxp-stale-ctx-execution)
[377.644443] Starting subtest: verify-pxp-stale-ctx-execution
[378.704957] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.060s)
[378.870000] [106/133] (643s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[378.992746] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[380.027015] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.034s)
[380.205252] [107/133] (642s left) kms_psr (psr2-cursor-mmap-cpu)
[380.303478] Starting subtest: psr2-cursor-mmap-cpu
[380.305656] Starting dynamic subtest: eDP-1
[382.045019] Dynamic subtest eDP-1: SUCCESS (1.740s)
[382.047290] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.742s)
[382.850778] [108/133] (639s left) kms_psr (fbc-psr-sprite-plane-onoff)
[382.951035] Starting subtest: fbc-psr-sprite-plane-onoff
[382.953306] Starting dynamic subtest: eDP-1
[382.957408] Dynamic subtest eDP-1: SKIP (0.000s)
[382.961678] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[383.034333] [109/133] (639s left) kms_pm_rpm (fences-dpms)
[384.672334] Starting subtest: fences-dpms
[384.677255] Subtest fences-dpms: SKIP (0.000s)
[385.308814] [110/133] (637s left) prime_mmap_coherency (read)
[385.366750] Starting subtest: read
[390.741338] Subtest read: SUCCESS (5.373s)
[390.893641] [111/133] (631s left) gem_exec_fence (basic-busy-all)
[390.969537] Starting subtest: basic-busy-all
[391.091589] Subtest basic-busy-all: SUCCESS (0.122s)
[392.529169] [112/133] (630s left) prime_vgem (basic-fence-flip)
[392.633104] Starting subtest: basic-fence-flip
[392.932492] Subtest basic-fence-flip: SUCCESS (0.299s)
[393.076427] [113/133] (629s left) syncobj_wait (invalid-signal-bad-pad)
[393.137209] Starting subtest: invalid-signal-bad-pad
[393.139607] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[393.251508] [114/133] (629s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[393.345501] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[393.349865] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[393.455623] [115/133] (629s left) kms_big_fb (x-tiled-addfb)
[393.560856] Starting subtest: x-tiled-addfb
[393.563474] Subtest x-tiled-addfb: SUCCESS (0.000s)
[393.699721] [116/133] (629s left) gem_ctx_persistence (legacy-engines-hostile)
[393.774132] Starting subtest: legacy-engines-hostile
[393.776546] Starting dynamic subtest: render
[393.871261] Dynamic subtest render: SUCCESS (0.096s)
[393.884522] Starting dynamic subtest: bsd1
[393.983820] Dynamic subtest bsd1: SUCCESS (0.110s)
[393.997773] Starting dynamic subtest: bsd2
[394.062428] Dynamic subtest bsd2: SUCCESS (0.076s)
[394.075722] Starting dynamic subtest: blt
[394.232125] Dynamic subtest blt: SUCCESS (0.166s)
[394.246864] Starting dynamic subtest: vebox
[394.349904] Dynamic subtest vebox: SUCCESS (0.115s)
[394.352545] Subtest legacy-engines-hostile: SUCCESS (0.577s)
[394.441114] [117/133] (628s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[394.546472] Starting subtest: 4-tiled-16bpp-rotate-180
[395.896192] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.348s)
[396.051762] [118/133] (627s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[396.162588] Starting subtest: compare-crc-sanitycheck-nv12
[396.164554] Starting dynamic subtest: pipe-A-eDP-1
[396.870186] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.706s)
[396.881310] Starting dynamic subtest: pipe-B-eDP-1
[398.103697] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.230s)
[398.114723] Starting dynamic subtest: pipe-C-eDP-1
[399.289305] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.186s)
[399.300704] Starting dynamic subtest: pipe-D-eDP-1
[400.527042] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.233s)
[400.529356] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.362s)
[401.378595] [119/133] (621s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[401.484802] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[408.012350] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.529s)
[408.176213] [120/133] (615s left) kms_flip (wf_vblank-ts-check-interruptible)
[408.284985] Starting subtest: wf_vblank-ts-check-interruptible
[408.287256] Starting dynamic subtest: A-eDP1
[417.230253] Dynamic subtest A-eDP1: SUCCESS (8.943s)
[417.240999] Starting dynamic subtest: B-eDP1
[426.148144] Dynamic subtest B-eDP1: SUCCESS (8.917s)
[426.159970] Starting dynamic subtest: C-eDP1
[435.069339] Dynamic subtest C-eDP1: SUCCESS (8.919s)
[435.080016] Starting dynamic subtest: D-eDP1
[443.921881] Dynamic subtest D-eDP1: SUCCESS (8.851s)
[443.924049] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.638s)
[445.164348] [121/133] (578s left) gem_eio (create)
[445.386892] Starting subtest: create
[445.723558] Subtest create: SUCCESS (0.335s)
[445.890611] [122/133] (577s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[446.054034] Starting subtest: dp-mst-lic-type-0-hdcp14
[446.058571] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[446.203540] [123/133] (577s left) kms_vblank (query-idle)
[446.303465] Starting subtest: query-idle
[446.304989] Starting dynamic subtest: pipe-A-eDP-1
[448.045162] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.742s)
[448.066586] Starting dynamic subtest: pipe-D-eDP-1
[450.488915] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.439s)
[450.490830] Subtest query-idle: SUCCESS (4.184s)
[451.324794] [124/133] (572s left) kms_plane_scaling (invalid-num-scalers)
[451.434254] Starting subtest: invalid-num-scalers
[451.436539] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[451.451830] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.018s)
[451.461843] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[451.484057] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.031s)
[451.494332] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[451.517494] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.030s)
[451.527179] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[451.545488] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.029s)
[451.547544] Subtest invalid-num-scalers: SUCCESS (0.113s)
[451.660868] [125/133] (571s left) kms_cursor_crc (cursor-onscreen-512x170)
[451.966742] Starting subtest: cursor-onscreen-512x170
[451.971127] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[452.132365] [126/133] (571s left) kms_rotation_crc (primary-rotation-270)
[452.230955] Starting subtest: primary-rotation-270
[452.235291] Subtest primary-rotation-270: SKIP (0.001s)
[452.304881] [127/133] (571s left) perf (invalid-oa-metric-set-id)
[452.391597] Starting subtest: invalid-oa-metric-set-id
[452.401744] Subtest invalid-oa-metric-set-id: SUCCESS (0.008s)
[452.446057] [128/133] (571s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[452.505609] Starting subtest: single-wait-all-for-submit-available-submitted
[452.507258] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[452.622293] [129/133] (570s left) kms_draw_crc (draw-method-render)
[452.724706] Starting subtest: draw-method-render
[452.726699] Starting dynamic subtest: xrgb8888-untiled
[453.002736] Dynamic subtest xrgb8888-untiled: SUCCESS (0.279s)
[453.012749] Starting dynamic subtest: rgb565-untiled
[453.236652] Dynamic subtest rgb565-untiled: SUCCESS (0.233s)
[453.246113] Starting dynamic subtest: xrgb2101010-untiled
[453.458448] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[453.467960] Starting dynamic subtest: xbgr16161616f-untiled
[453.691871] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s)
[453.703685] Starting dynamic subtest: xrgb8888-xtiled
[453.825562] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.132s)
[453.841989] Starting dynamic subtest: rgb565-xtiled
[453.958615] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s)
[453.970280] Starting dynamic subtest: xrgb2101010-xtiled
[454.080343] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[454.090380] Starting dynamic subtest: xbgr16161616f-xtiled
[454.213950] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[454.225983] Starting dynamic subtest: xrgb8888-4tiled
[454.348856] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.131s)
[454.358369] Starting dynamic subtest: rgb565-4tiled
[454.469227] Dynamic subtest rgb565-4tiled: SUCCESS (0.121s)
[454.481539] Starting dynamic subtest: xrgb2101010-4tiled
[454.580718] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.109s)
[454.590382] Starting dynamic subtest: xbgr16161616f-4tiled
[454.713929] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.132s)
[454.715842] Subtest draw-method-render: SUCCESS (1.990s)
[454.861897] [130/133] (568s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[454.982710] Starting subtest: basic-flip-before-cursor-legacy
[455.907745] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.923s)
[456.753690] [131/133] (566s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[456.844937] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[456.848999] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[456.974625] [132/133] (566s left) perf_pmu (idle-no-semaphores)
[457.026079] Starting subtest: idle-no-semaphores
[457.028432] Starting dynamic subtest: rcs0
[457.604158] Dynamic subtest rcs0: SUCCESS (0.576s)
[457.621048] Starting dynamic subtest: bcs0
[458.128831] Dynamic subtest bcs0: SUCCESS (0.522s)
[458.142223] Starting dynamic subtest: vcs0
[458.656318] Dynamic subtest vcs0: SUCCESS (0.525s)
[458.669481] Starting dynamic subtest: vcs1
[459.187758] Dynamic subtest vcs1: SUCCESS (0.528s)
[459.200407] Starting dynamic subtest: vecs0
[459.710595] Dynamic subtest vecs0: SUCCESS (0.521s)
[459.723277] Starting dynamic subtest: ccs0
[460.243518] Dynamic subtest ccs0: SUCCESS (0.529s)
[460.246290] Subtest idle-no-semaphores: SUCCESS (3.218s)
[460.374111] [133/133] (563s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[460.441605] Starting subtest: multi-wait-all-for-submit-signaled
[460.443810] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[460.550588] Closing watchdogs
results: parsing output: 0/ for test: kms_plane
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: prime_mmap_coherency
results: parsing output: 4/ for test: perf
results: parsing output: 5/ for test: core_getversion
results: parsing output: 6/ for test: kms_flip
results: parsing output: 7/ for test: api_intel_allocator
results: parsing output: 8/ for test: tools_test
results: parsing output: 9/ for test: kms_invalid_mode
results: parsing output: 10/ for test: kms_getfb
results: parsing output: 11/ for test: gen3_mixed_blits
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_cursor_crc
results: parsing output: 14/ for test: kms_flip
results: parsing output: 15/ for test: kms_pm_backlight
results: parsing output: 16/ for test: kms_color
results: parsing output: 17/ for test: gem_exec_params
results: parsing output: 18/ for test: gem_exec_schedule
results: parsing output: 19/ for test: gem_mmap_gtt
results: parsing output: 20/ for test: kms_chamelium_frames
results: parsing output: 21/ for test: gem_exec_whisper
results: parsing output: 22/ for test: gen9_exec_parse
results: parsing output: 23/ for test: perf_pmu
results: parsing output: 24/ for test: gem_workarounds
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: syncobj_wait
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_addfb_basic
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: kms_psr
results: parsing output: 32/ for test: kms_flip
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_flip_scaled_crc
results: parsing output: 35/ for test: kms_addfb_basic
results: parsing output: 36/ for test: gem_softpin
results: parsing output: 37/ for test: i915_suspend
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: gem_userptr_blits
results: parsing output: 40/ for test: gem_exec_balancer
results: parsing output: 41/ for test: gem_lmem_swapping
results: parsing output: 42/ for test: gem_render_copy
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_cursor_legacy
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_partial_pwrite_pread
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_lease
results: parsing output: 55/ for test: syncobj_wait
results: parsing output: 56/ for test: gem_mmap_gtt
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: gem_madvise
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_ccs
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: gem_ctx_isolation
results: parsing output: 64/ for test: kms_flip_scaled_crc
results: parsing output: 65/ for test: i915_drm_fdinfo
results: parsing output: 66/ for test: kms_psr2_sf
results: parsing output: 67/ for test: gem_create
results: parsing output: 68/ for test: gen7_exec_parse
results: parsing output: 69/ for test: api_intel_bb
results: parsing output: 70/ for test: kms_chamelium_hpd
results: parsing output: 71/ for test: kms_pipe_b_c_ivb
results: parsing output: 72/ for test: gem_exec_reloc
results: parsing output: 73/ for test: i915_pm_rps
results: parsing output: 74/ for test: kms_cursor_legacy
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: gem_exec_balancer
results: parsing output: 77/ for test: prime_busy
results: parsing output: 78/ for test: gem_exec_schedule
results: parsing output: 79/ for test: kms_psr2_sf
results: parsing output: 80/ for test: kms_sequence
results: parsing output: 81/ for test: kms_chamelium_audio
results: parsing output: 82/ for test: gem_mmap_gtt
results: parsing output: 83/ for test: gem_mmap_wc
results: parsing output: 84/ for test: gem_exec_fence
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: i915_hangman
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_plane
results: parsing output: 90/ for test: prime_mmap
results: parsing output: 91/ for test: prime_self_import
results: parsing output: 92/ for test: sysfs_preempt_timeout
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: gem_tiled_pread_pwrite
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_fence_thrash
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_exec_fence
results: parsing output: 100/ for test: kms_pm_rpm
results: parsing output: 101/ for test: kms_addfb_basic
results: parsing output: 102/ for test: kms_cursor_crc
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: gem_pxp
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_psr
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: kms_pm_rpm
results: parsing output: 109/ for test: prime_mmap_coherency
results: parsing output: 110/ for test: gem_exec_fence
results: parsing output: 111/ for test: prime_vgem
results: parsing output: 112/ for test: syncobj_wait
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: gem_ctx_persistence
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_pipe_crc_basic
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_flip
results: parsing output: 120/ for test: gem_eio
results: parsing output: 121/ for test: kms_content_protection
results: parsing output: 122/ for test: kms_vblank
results: parsing output: 123/ for test: kms_plane_scaling
results: parsing output: 124/ for test: kms_cursor_crc
results: parsing output: 125/ for test: kms_rotation_crc
results: parsing output: 126/ for test: perf
results: parsing output: 127/ for test: syncobj_timeline
results: parsing output: 128/ for test: kms_draw_crc
results: parsing output: 129/ for test: kms_cursor_legacy
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: perf_pmu
results: parsing output: 132/ for test: syncobj_wait
Done.