[60.300953] Initializing watchdogs
[60.301667]   /dev/watchdog0
[60.317516] [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]
[60.322696] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.325276] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.327183] [001/156] (960s left) gem_render_linear_blits (basic)
[60.391672] Starting subtest: basic
[60.429135] Subtest basic: SUCCESS (0.037s)
[60.515273] [002/156] (960s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[60.573492] Starting subtest: stress-mm-invalidate-close-overlap
[62.794835] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[62.882943] [003/156] (958s left) gem_exec_params (sol-reset-invalid)
[62.944149] Starting subtest: sol-reset-invalid
[62.947491] Subtest sol-reset-invalid: SUCCESS (0.003s)
[64.410131] [004/156] (956s left) gem_exec_endless (dispatch)
[64.477589] Starting subtest: dispatch
[64.478729] Starting dynamic subtest: rcs0
[64.483158] Dynamic subtest rcs0: SUCCESS (0.006s)
[64.491241] Starting dynamic subtest: bcs0
[64.493039] Dynamic subtest bcs0: SUCCESS (0.007s)
[64.500555] Starting dynamic subtest: vcs0
[64.502791] Dynamic subtest vcs0: SUCCESS (0.009s)
[64.510735] Starting dynamic subtest: vcs1
[64.512775] Dynamic subtest vcs1: SUCCESS (0.006s)
[64.520145] Starting dynamic subtest: vecs0
[64.522034] Dynamic subtest vecs0: SUCCESS (0.006s)
[64.529566] Starting dynamic subtest: ccs0
[64.531321] Dynamic subtest ccs0: SUCCESS (0.004s)
[64.532222] Subtest dispatch: SUCCESS (0.043s)
[66.389894] [005/156] (954s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[66.480841] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[66.481712] Starting dynamic subtest: pipe-A-eDP-1
[66.485323] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[66.491978] Starting dynamic subtest: pipe-B-eDP-1
[66.495403] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[66.501863] Starting dynamic subtest: pipe-C-eDP-1
[66.505372] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[66.511077] Starting dynamic subtest: pipe-D-eDP-1
[66.514423] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[66.516072] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[68.975641] [006/156] (952s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[69.026803] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[69.028765] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[69.213463] [007/156] (951s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[69.310456] Starting subtest: nonblocking-crc-frame-sequence
[69.311507] Starting dynamic subtest: pipe-A-eDP-1
[70.053685] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.739s)
[70.060549] Starting dynamic subtest: pipe-B-eDP-1
[71.525495] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.466s)
[71.532891] Starting dynamic subtest: pipe-C-eDP-1
[72.945923] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.415s)
[72.955252] Starting dynamic subtest: pipe-D-eDP-1
[74.340891] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.390s)
[74.341983] Subtest nonblocking-crc-frame-sequence: SUCCESS (5.015s)
[75.144377] [008/156] (945s left) perf_pmu (most-busy-check-all)
[75.178680] Starting subtest: most-busy-check-all
[75.180118] Starting dynamic subtest: rcs0
[76.328520] Dynamic subtest rcs0: SUCCESS (1.137s)
[76.336291] Starting dynamic subtest: bcs0
[78.311353] Dynamic subtest bcs0: SUCCESS (1.978s)
[78.320301] Starting dynamic subtest: vcs0
[80.359174] Dynamic subtest vcs0: SUCCESS (2.044s)
[80.368770] Starting dynamic subtest: vcs1
[82.343895] Dynamic subtest vcs1: SUCCESS (1.982s)
[82.352812] Starting dynamic subtest: vecs0
[84.327077] Dynamic subtest vecs0: SUCCESS (1.980s)
[84.335770] Starting dynamic subtest: ccs0
[86.312809] Dynamic subtest ccs0: SUCCESS (1.981s)
[86.314137] Subtest most-busy-check-all: SUCCESS (11.110s)
[86.394527] [009/156] (934s left) sysfs_timeslice_duration (duration)
[86.451570] Starting subtest: duration
[86.452639] Starting dynamic subtest: vecs0
[100.229173] Dynamic subtest vecs0: SUCCESS (13.757s)
[100.237849] Starting dynamic subtest: ccs0
[113.380894] Dynamic subtest ccs0: SUCCESS (13.142s)
[113.390528] Starting dynamic subtest: vcs0
[128.261786] Dynamic subtest vcs0: SUCCESS (14.880s)
[128.269363] Starting dynamic subtest: bcs0
[141.396610] Dynamic subtest bcs0: SUCCESS (13.141s)
[141.406388] Starting dynamic subtest: rcs0
[154.532636] Dynamic subtest rcs0: SUCCESS (13.134s)
[154.543363] Starting dynamic subtest: vcs1
[168.260458] Dynamic subtest vcs1: SUCCESS (13.716s)
[168.261823] Subtest duration: SUCCESS (81.778s)
[168.321210] [010/156] (852s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-move)
[168.428486] Starting subtest: hdr-2p-scndscrn-spr-indfb-move
[168.430329] Subtest hdr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[168.514761] [011/156] (852s left) kms_chamelium_color (ctm-green-to-red)
[168.600772] Subtest ctm-green-to-red: SKIP (0.000s)
[168.637735] [012/156] (852s left) kms_vblank (ts-continuation-dpms-rpm)
[168.730462] Starting subtest: ts-continuation-dpms-rpm
[168.731385] Starting dynamic subtest: pipe-A-eDP-1
[171.283791] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.553s)
[171.293514] Starting dynamic subtest: pipe-D-eDP-1
[173.542558] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.257s)
[173.543765] Subtest ts-continuation-dpms-rpm: SUCCESS (4.813s)
[174.408473] [013/156] (846s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-render)
[174.500976] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-render
[174.502977] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[174.576986] [014/156] (846s left) kms_plane_scaling (planes-downscale-factor-0-75)
[174.666724] Starting subtest: planes-downscale-factor-0-75
[174.667676] Starting dynamic subtest: pipe-A
[174.687075] Dynamic subtest pipe-A: SKIP (0.019s)
[174.694220] Starting dynamic subtest: pipe-B
[174.720932] Dynamic subtest pipe-B: SKIP (0.033s)
[174.727816] Starting dynamic subtest: pipe-C
[174.754701] Dynamic subtest pipe-C: SKIP (0.034s)
[174.762366] Starting dynamic subtest: pipe-D
[174.789124] Dynamic subtest pipe-D: SKIP (0.033s)
[174.791026] Subtest planes-downscale-factor-0-75: SKIP (0.121s)
[174.877564] [015/156] (846s left) kms_draw_crc (draw-method-render)
[174.966330] Starting subtest: draw-method-render
[174.967255] Starting dynamic subtest: xrgb8888-untiled
[175.232345] Dynamic subtest xrgb8888-untiled: SUCCESS (0.267s)
[175.240220] Starting dynamic subtest: rgb565-untiled
[175.465792] Dynamic subtest rgb565-untiled: SUCCESS (0.233s)
[175.473543] Starting dynamic subtest: xrgb2101010-untiled
[175.688275] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[175.697111] Starting dynamic subtest: xbgr16161616f-untiled
[175.932627] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.244s)
[175.940653] Starting dynamic subtest: xrgb8888-xtiled
[176.066212] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s)
[176.074739] Starting dynamic subtest: rgb565-xtiled
[176.188350] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[176.197145] Starting dynamic subtest: xrgb2101010-xtiled
[176.310240] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[176.319078] Starting dynamic subtest: xbgr16161616f-xtiled
[176.443932] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[176.452684] Starting dynamic subtest: xrgb8888-4tiled
[176.577386] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s)
[176.589387] Starting dynamic subtest: rgb565-4tiled
[176.699355] Dynamic subtest rgb565-4tiled: SUCCESS (0.122s)
[176.707250] Starting dynamic subtest: xrgb2101010-4tiled
[176.821433] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.122s)
[176.831298] Starting dynamic subtest: xbgr16161616f-4tiled
[176.954838] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[176.956283] Subtest draw-method-render: SUCCESS (1.990s)
[177.054342] [016/156] (844s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-pwrite)
[177.143791] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-pwrite
[177.145459] Subtest fbchdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[177.231348] [017/156] (844s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[177.320149] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[177.321777] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[177.410165] [018/156] (843s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[177.470516] Starting subtest: multi-wait-available-submitted-signaled
[177.471612] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s)
[177.583184] [019/156] (843s left) sw_sync (sync_multi_producer_single_consumer)
[177.612604] Starting subtest: sync_multi_producer_single_consumer
[178.695610] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[178.739569] [020/156] (842s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[178.839156] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[178.840974] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[178.917385] [021/156] (842s left) gem_vm_create (invalid-create)
[178.976123] Starting subtest: invalid-create
[178.977284] Subtest invalid-create: SUCCESS (0.002s)
[179.064354] [022/156] (842s left) kms_frontbuffer_tracking (fbcpsrhdr-suspend)
[179.151152] Starting subtest: fbcpsrhdr-suspend
[179.153064] Subtest fbcpsrhdr-suspend: SKIP (0.000s)
[179.239746] [023/156] (842s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[179.329611] Starting subtest: 4-tiled-16bpp-rotate-270
[179.348511] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.019s)
[179.467385] [024/156] (842s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-pwrite)
[179.562492] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-pwrite
[179.564099] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[179.656740] [025/156] (841s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[179.769992] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[180.758286] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.988s)
[181.636216] [026/156] (839s left) gem_pxp (protected-raw-src-copy-not-readible)
[181.745595] Starting subtest: protected-raw-src-copy-not-readible
[181.805423] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.061s)
[181.914991] [027/156] (839s left) kms_cursor_crc (cursor-offscreen-128x42)
[182.116245] Starting subtest: cursor-offscreen-128x42
[182.160403] Subtest cursor-offscreen-128x42: SKIP (0.044s)
[182.338368] [028/156] (839s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[182.430733] Starting subtest: yf-tiled-64bpp-rotate-180
[182.432424] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[182.508283] [029/156] (839s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[182.593517] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[182.595385] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[182.656104] [030/156] (839s left) i915_suspend (debugfs-reader)
[182.703701] Starting subtest: debugfs-reader
[200.841043] Subtest debugfs-reader: SUCCESS (4.418s)
[207.959795] [031/156] (820s left) gem_mmap_wc (write-read-distinct)
[208.008350] Subtest write-read-distinct: SKIP (0.000s)
[208.078417] [032/156] (820s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[208.174041] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[208.175825] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[208.285146] [033/156] (820s left) kms_properties (invalid-properties-legacy)
[208.380950] Starting subtest: invalid-properties-legacy
[208.493649] Subtest invalid-properties-legacy: SUCCESS (0.108s)
[208.577361] [034/156] (820s left) kms_pm_rpm (pc8-residency)
[210.214606] Starting subtest: pc8-residency
[210.218083] Subtest pc8-residency: SKIP (0.000s)
[210.879215] [035/156] (818s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-onoff)
[210.989267] Starting subtest: psrhdr-1p-primscrn-spr-indfb-onoff
[210.991092] Subtest psrhdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[211.088419] [036/156] (817s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[211.474093] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[212.323629] [037/156] (816s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[212.419017] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[213.220706] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.781s)
[213.365582] [038/156] (815s left) kms_addfb_basic (bad-pitch-999)
[213.427265] Starting subtest: bad-pitch-999
[213.428142] Subtest bad-pitch-999: SUCCESS (0.000s)
[213.575592] [039/156] (815s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-blt)
[213.672922] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-blt
[213.674685] Subtest psrhdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[213.777413] [040/156] (815s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[213.837580] Subtest untiled-to-tiled: SKIP (0.000s)
[213.897154] [041/156] (815s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[214.004491] Starting subtest: flip-vs-cursor-toggle
[223.297710] Subtest flip-vs-cursor-toggle: SUCCESS (9.173s)
[224.153770] [042/156] (805s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[224.249114] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[224.251139] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[224.312564] [043/156] (804s left) kms_async_flips (async-flip-hang)
[224.405514] Starting subtest: async-flip-hang
[224.780446] Starting dynamic subtest: pipe-A-eDP-1
[240.541861] Dynamic subtest pipe-A-eDP-1: SUCCESS (15.724s)
[240.919397] Starting dynamic subtest: pipe-B-eDP-1
[256.533674] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.608s)
[256.917021] Starting dynamic subtest: pipe-C-eDP-1
[272.535831] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.615s)
[272.911267] Starting dynamic subtest: pipe-D-eDP-1
[288.534402] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.620s)
[288.535982] Subtest async-flip-hang: SUCCESS (64.059s)
[289.780112] [044/156] (739s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[289.869026] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[289.870730] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[289.955101] [045/156] (739s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[290.073101] Starting subtest: cursorA-vs-flipB-varying-size
[290.075368] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[290.221782] [046/156] (739s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[290.325531] Starting subtest: yf-tiled-16bpp-rotate-0
[290.327410] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[290.412816] [047/156] (738s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[290.499160] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[290.500775] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[290.576235] [048/156] (738s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen)
[290.659844] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen
[290.661456] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[290.744253] [049/156] (738s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-pgflip-blt)
[290.829276] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-pgflip-blt
[290.830969] Subtest fbcpsrhdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[290.948132] [050/156] (738s left) syncobj_timeline (multi-wait-all-signaled)
[290.992811] Starting subtest: multi-wait-all-signaled
[290.993795] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[291.080587] [051/156] (738s left) gem_ctx_persistence (heartbeat-many)
[291.130416] Starting subtest: heartbeat-many
[291.132550] Subtest heartbeat-many: SKIP (0.000s)
[291.226731] [052/156] (738s left) gen7_exec_parse (basic-rejected)
[291.268624] Subtest basic-rejected: SKIP (0.000s)
[291.331034] [053/156] (738s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-pwrite)
[291.414140] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-pwrite
[291.415844] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[291.533120] [054/156] (738s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[291.627754] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[291.628750] Starting dynamic subtest: pipe-A-eDP-1
[291.637022] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[291.645166] Starting dynamic subtest: pipe-B-eDP-1
[291.653749] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[291.662153] Starting dynamic subtest: pipe-C-eDP-1
[291.669675] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[291.677212] Starting dynamic subtest: pipe-D-eDP-1
[291.685199] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[291.686834] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[293.949760] [055/156] (735s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[294.034147] Starting subtest: plane-all-modeset-transition-internal-panels
[294.035163] Starting dynamic subtest: pipe-A-eDP-1
[294.539482] Dynamic subtest pipe-A-eDP-1: FAIL (0.296s)
[294.547918] Starting dynamic subtest: pipe-B-eDP-1
[295.417428] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.075s)
[295.678893] Subtest plane-all-modeset-transition-internal-panels: FAIL (1.644s)
[296.513338] [056/156] (733s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[296.600752] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[306.269143] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.662s)
[306.377078] [057/156] (723s left) gem_softpin (evict-prime)
[306.442828] Starting subtest: evict-prime
[306.443868] Starting dynamic subtest: rcs0
[307.599331] Dynamic subtest rcs0: SUCCESS (1.158s)
[307.613760] Starting dynamic subtest: bcs0
[308.739323] Dynamic subtest bcs0: SUCCESS (1.138s)
[308.750960] Starting dynamic subtest: vcs0
[310.027037] Dynamic subtest vcs0: SUCCESS (1.277s)
[310.038988] Starting dynamic subtest: vcs1
[312.052826] Dynamic subtest vcs1: SUCCESS (2.025s)
[312.064690] Starting dynamic subtest: vecs0
[313.998112] Dynamic subtest vecs0: SUCCESS (1.944s)
[314.009649] Starting dynamic subtest: ccs0
[315.112984] Dynamic subtest ccs0: SUCCESS (1.122s)
[315.123182] Starting dynamic subtest: all
[317.052622] Dynamic subtest all: SUCCESS (1.929s)
[317.053928] Subtest evict-prime: SUCCESS (10.605s)
[317.119236] [058/156] (712s left) gem_ctx_param (invalid-ctx-set)
[317.175987] Starting subtest: invalid-ctx-set
[317.177045] Subtest invalid-ctx-set: SUCCESS (0.001s)
[317.272745] [059/156] (712s left) kms_chamelium_frames (vga-frame-dump)
[317.652581] Subtest vga-frame-dump: SKIP (0.000s)
[318.430576] [060/156] (711s left) gem_exec_flush (basic-wb-ro-default)
[318.486154] Starting subtest: basic-wb-ro-default
[323.944725] Subtest basic-wb-ro-default: SUCCESS (5.459s)
[324.137909] [061/156] (705s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[324.237633] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[324.239354] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[324.329307] [062/156] (705s left) kms_hdr (static-swap)
[324.410214] Starting subtest: static-swap
[324.411248] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[324.412957] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s)
[324.421281] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[324.422761] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s)
[324.424303] Subtest static-swap: SKIP (0.002s)
[324.490864] [063/156] (705s left) kms_plane_lowres (tiling-y)
[324.570602] Starting subtest: tiling-y
[324.572387] Subtest tiling-y: SKIP (0.000s)
[324.636793] [064/156] (705s left) kms_addfb_basic (invalid-get-prop)
[324.682681] Starting subtest: invalid-get-prop
[324.683798] Subtest invalid-get-prop: SUCCESS (0.000s)
[324.797840] [065/156] (705s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-indfb-msflip-blt)
[324.886734] Starting subtest: fbchdr-2p-scndscrn-indfb-msflip-blt
[324.888350] Subtest fbchdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[324.972507] [066/156] (705s left) kms_content_protection (lic-type-0)
[325.103717] Starting subtest: lic-type-0
[325.105653] Subtest lic-type-0: SKIP (0.000s)
[325.213577] [067/156] (704s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[325.302865] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[325.304870] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[326.392184] [068/156] (703s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[326.483341] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[326.485366] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[326.617775] [069/156] (703s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[326.729620] Starting subtest: flip-vs-cursor-atomic
[334.390409] Subtest flip-vs-cursor-atomic: SUCCESS (7.659s)
[335.230232] [070/156] (694s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[335.334697] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[335.336582] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[335.433471] [071/156] (694s left) gem_exec_balancer (hang)
[335.716272] Starting subtest: hang
[337.463796] Subtest hang: SUCCESS (1.754s)
[337.571652] [072/156] (692s left) kms_pm_dc (dc5-dpms-negative)
[338.669290] Starting subtest: dc5-dpms-negative
[338.671209] Subtest dc5-dpms-negative: SKIP (0.000s)
[338.733560] [073/156] (691s left) gem_huc_copy (huc-copy)
[338.790085] Starting subtest: huc-copy
[338.792520] Subtest huc-copy: SUCCESS (0.002s)
[338.910344] [074/156] (691s left) kms_selftest (drm_plane_helper)
[338.940714] Starting subtest: drm_plane_helper
[338.990653] Starting dynamic subtest: drm_test_check_plane_state
[339.092700] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.103s)
[339.101354] Starting dynamic subtest: drm_test_check_invalid_plane_state
[339.190612] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.096s)
[339.191672] Subtest drm_plane_helper: SUCCESS (0.249s)
[339.346577] [075/156] (690s left) gem_eio (create)
[339.580261] Starting subtest: create
[339.912457] Subtest create: SUCCESS (0.332s)
[340.063118] [076/156] (690s left) gem_exec_fence (syncobj-wait)
[340.485000] Starting subtest: syncobj-wait
[342.098398] Subtest syncobj-wait: SUCCESS (1.604s)
[342.419307] [FACT gem_exec_fence (syncobj-wait)] new: kernel.kmod_is_loaded.vgem: true
[342.421336] [077/156] (687s left) gem_mmap_wc (write)
[342.473397] Subtest write: SKIP (0.000s)
[342.525516] [078/156] (687s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[342.613899] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[352.393005] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.778s)
[352.550754] [079/156] (677s left) kms_psr (fbc-pr-primary-blt)
[352.635751] Starting subtest: fbc-pr-primary-blt
[352.637339] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[352.704304] [080/156] (677s left) api_intel_allocator (execbuf-with-allocator)
[352.762050] Starting subtest: execbuf-with-allocator
[352.769033] Subtest execbuf-with-allocator: SUCCESS (0.008s)
[352.891821] [081/156] (677s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[352.981289] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[352.982966] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[353.080854] [082/156] (677s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[353.183787] Starting subtest: x-tiled-16bpp-rotate-0
[354.564216] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.381s)
[354.686437] [083/156] (675s left) kms_lease (lessee-list)
[354.770652] Starting subtest: lessee-list
[354.771476] Starting dynamic subtest: pipe-A-eDP-1
[354.773308] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[354.782166] Starting dynamic subtest: pipe-B-eDP-1
[354.783128] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[354.791208] Starting dynamic subtest: pipe-C-eDP-1
[354.792147] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[354.800284] Starting dynamic subtest: pipe-D-eDP-1
[354.801091] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[354.801920] Subtest lessee-list: SUCCESS (0.009s)
[354.887892] [084/156] (675s left) kms_properties (plane-properties-legacy)
[354.968742] Starting subtest: plane-properties-legacy
[354.969710] Starting dynamic subtest: pipe-A-eDP-1
[355.523973] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.555s)
[355.533839] Starting dynamic subtest: pipe-B-eDP-1
[356.845007] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.320s)
[356.854643] Starting dynamic subtest: pipe-C-eDP-1
[358.175496] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.329s)
[358.188430] Starting dynamic subtest: pipe-D-eDP-1
[359.416519] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.239s)
[359.417808] Subtest plane-properties-legacy: SUCCESS (4.448s)
[360.232540] [085/156] (670s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-render)
[360.334729] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-render
[360.336414] Subtest hdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[360.422517] [086/156] (670s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[360.509166] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[365.249565] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (4.740s)
[365.357834] [087/156] (665s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[365.478032] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[365.479646] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[365.576884] [088/156] (665s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-pwrite)
[365.666228] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-pwrite
[365.667874] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[365.775348] [089/156] (665s left) kms_psr (fbc-psr2-cursor-blt)
[365.866219] Starting subtest: fbc-psr2-cursor-blt
[365.867104] Starting dynamic subtest: eDP-1
[365.868878] Dynamic subtest eDP-1: SKIP (0.000s)
[365.870605] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[365.934295] [090/156] (664s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt)
[366.022417] Starting subtest: fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt
[366.024215] Subtest fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[366.124513] [091/156] (664s left) gen9_exec_parse (valid-registers)
[366.176539] Subtest valid-registers: SKIP (0.000s)
[366.241250] [092/156] (664s left) kms_psr (fbc-psr-basic)
[366.319658] Starting subtest: fbc-psr-basic
[366.320472] Starting dynamic subtest: eDP-1
[366.322194] Dynamic subtest eDP-1: SKIP (0.000s)
[366.324042] Subtest fbc-psr-basic: SKIP (0.001s)
[366.400813] [093/156] (664s left) gem_ppgtt (shrink-vs-evict-any)
[366.450224] Starting subtest: shrink-vs-evict-any
[372.089359] Subtest shrink-vs-evict-any: SUCCESS (5.592s)
[372.120359] [094/156] (658s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[372.394535] Starting subtest: cursor-rapid-movement-512x512
[372.396580] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[372.537967] [095/156] (658s left) perf_pmu (busy-double-start)
[372.576796] Starting subtest: busy-double-start
[372.577655] Starting dynamic subtest: rcs0
[376.176635] Dynamic subtest rcs0: FAIL (3.573s)
[376.186816] Starting dynamic subtest: bcs0
[379.738756] Dynamic subtest bcs0: SUCCESS (3.587s)
[379.751915] Starting dynamic subtest: vcs0
[383.572734] Dynamic subtest vcs0: SUCCESS (3.831s)
[383.584727] Starting dynamic subtest: vcs1
[387.589754] Dynamic subtest vcs1: SUCCESS (4.013s)
[387.603346] Starting dynamic subtest: vecs0
[391.545879] Dynamic subtest vecs0: SUCCESS (3.953s)
[391.558334] Starting dynamic subtest: ccs0
[395.144264] Dynamic subtest ccs0: FAIL (3.564s)
[395.145118] Subtest busy-double-start: FAIL (22.531s)
[395.233405] [096/156] (635s left) kms_psr (pr-primary-page-flip)
[395.329953] Starting subtest: pr-primary-page-flip
[395.331836] Subtest pr-primary-page-flip: SKIP (0.000s)
[395.402663] [097/156] (635s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[395.497306] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[395.499297] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[395.608020] [098/156] (635s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[395.696671] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[395.699260] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[395.795070] [099/156] (635s left) prime_udl
[395.864451] [100/156] (635s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-onoff)
[395.956306] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-onoff
[395.958019] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[396.039847] [101/156] (635s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-pwrite)
[396.133431] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-pwrite
[396.135216] Subtest hdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[396.222638] [102/156] (635s left) gem_mmap_wc (write-cpu-read-wc)
[396.281099] Subtest write-cpu-read-wc: SKIP (0.000s)
[396.336079] [103/156] (634s left) i915_pm_rps (thresholds)
[396.397582] Starting subtest: thresholds
[396.399689] Subtest thresholds: SKIP (0.001s)
[396.512107] [104/156] (634s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[396.611197] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[396.613174] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[396.710583] [105/156] (634s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[396.802424] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[396.804319] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[396.926225] [106/156] (634s left) syncobj_timeline (wait-for-submit-delayed-submit)
[396.980806] Starting subtest: wait-for-submit-delayed-submit
[397.082770] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[397.157686] [107/156] (634s left) gem_userptr_blits (coherency-sync)
[397.209035] Starting subtest: coherency-sync
[397.512761] Subtest coherency-sync: SKIP (0.287s)
[397.624241] [108/156] (633s left) prime_mmap (test_forked)
[397.711101] Starting subtest: test_forked
[397.712061] Starting dynamic subtest: test_forked-smem
[397.757205] Dynamic subtest test_forked-smem: SUCCESS (0.045s)
[397.758447] Subtest test_forked: SUCCESS (0.047s)
[397.847871] [109/156] (633s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-blt)
[397.941486] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-blt
[397.943302] Subtest hdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[398.039991] [110/156] (633s left) core_setmaster (master-drop-set-user)
[398.127908] Starting subtest: master-drop-set-user
[398.139854] Subtest master-drop-set-user: SUCCESS (0.013s)
[398.172566] [111/156] (633s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[398.221148] Starting subtest: framebuffer-vs-set-tiling
[398.223900] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[398.339294] [112/156] (633s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[398.434557] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[398.436323] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[398.533009] [113/156] (633s left) kms_flip (busy-flip)
[398.635422] Starting subtest: busy-flip
[398.636266] Starting dynamic subtest: A-eDP1
[400.369085] Dynamic subtest A-eDP1: SUCCESS (1.732s)
[400.380796] Starting dynamic subtest: B-eDP1
[402.099912] Dynamic subtest B-eDP1: SUCCESS (1.729s)
[402.110667] Starting dynamic subtest: C-eDP1
[403.828993] Dynamic subtest C-eDP1: SUCCESS (1.724s)
[403.840829] Starting dynamic subtest: D-eDP1
[405.472682] Dynamic subtest D-eDP1: SUCCESS (1.641s)
[405.473638] Subtest busy-flip: SUCCESS (6.837s)
[406.720696] [114/156] (624s left) syncobj_timeline (host-signal-points)
[406.774935] Starting subtest: host-signal-points
[406.779066] Subtest host-signal-points: SUCCESS (0.004s)
[406.872207] [115/156] (624s left) prime_busy (after)
[406.925452] Starting subtest: after
[406.928675] Starting dynamic subtest: rcs0
[406.953960] Dynamic subtest rcs0: SUCCESS (0.025s)
[406.964177] Starting dynamic subtest: bcs0
[407.007195] Dynamic subtest bcs0: SUCCESS (0.052s)
[407.017602] Starting dynamic subtest: vcs0
[407.048337] Dynamic subtest vcs0: SUCCESS (0.040s)
[407.057519] Starting dynamic subtest: vcs1
[407.088733] Dynamic subtest vcs1: SUCCESS (0.039s)
[407.102354] Starting dynamic subtest: vecs0
[407.130168] Dynamic subtest vecs0: SUCCESS (0.041s)
[407.139765] Starting dynamic subtest: ccs0
[407.170697] Dynamic subtest ccs0: SUCCESS (0.040s)
[407.289838] Subtest after: SUCCESS (0.352s)
[407.351649] [116/156] (624s left) gem_exec_schedule (pi-distinct-iova)
[407.542036] Starting subtest: pi-distinct-iova
[407.542934] Starting dynamic subtest: rcs0
[407.616320] Dynamic subtest rcs0: SUCCESS (0.079s)
[407.628462] Starting dynamic subtest: vcs0
[407.678410] Dynamic subtest vcs0: SUCCESS (0.061s)
[407.692182] Starting dynamic subtest: vcs1
[407.740528] Dynamic subtest vcs1: SUCCESS (0.062s)
[407.754131] Starting dynamic subtest: vecs0
[407.794833] Dynamic subtest vecs0: SUCCESS (0.054s)
[407.804548] Starting dynamic subtest: ccs0
[407.866777] Dynamic subtest ccs0: SUCCESS (0.070s)
[407.868610] Subtest pi-distinct-iova: SUCCESS (0.331s)
[409.148210] [117/156] (622s left) kms_psr (psr2-primary-mmap-cpu)
[409.244794] Starting subtest: psr2-primary-mmap-cpu
[409.245706] Starting dynamic subtest: eDP-1
[411.029619] Dynamic subtest eDP-1: SUCCESS (1.783s)
[411.030714] Subtest psr2-primary-mmap-cpu: SUCCESS (1.784s)
[411.883989] [118/156] (619s left) gem_exec_flush (basic-wb-pro-default)
[411.931503] Starting subtest: basic-wb-pro-default
[417.394691] Subtest basic-wb-pro-default: SUCCESS (5.461s)
[417.580706] [119/156] (614s left) fbdev (info)
[417.613746] Starting subtest: info
[417.614806] Subtest info: SUCCESS (0.000s)
[417.674270] [120/156] (614s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-pwrite)
[417.769898] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-pwrite
[417.771603] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[417.861365] [121/156] (614s left) gem_softpin (softpin)
[417.906283] Starting subtest: softpin
[450.172299] Subtest softpin: SUCCESS (32.258s)
[450.286259] [122/156] (581s left) i915_module_load (reload)
[450.315898] Starting subtest: reload
[453.668556] Subtest reload: SUCCESS (3.355s)
[453.707381] [123/156] (578s left) kms_frontbuffer_tracking (fbchdr-2p-shrfb-fliptrack-mmap-gtt)
[455.047970] Starting subtest: fbchdr-2p-shrfb-fliptrack-mmap-gtt
[455.049957] Subtest fbchdr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[455.149329] [124/156] (576s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[455.240179] Starting subtest: 4-tiled-32bpp-rotate-270
[455.274438] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.034s)
[455.380820] [125/156] (576s left) gem_ctx_isolation (clean)
[455.442611] Starting subtest: clean
[455.443791] Starting dynamic subtest: rcs0
[455.508074] Dynamic subtest rcs0: SUCCESS (0.065s)
[455.518994] Starting dynamic subtest: bcs0
[455.568470] Dynamic subtest bcs0: SUCCESS (0.060s)
[455.581643] Starting dynamic subtest: vcs0
[455.642513] Dynamic subtest vcs0: SUCCESS (0.073s)
[455.652696] Starting dynamic subtest: vcs1
[457.076676] Dynamic subtest vcs1: SUCCESS (1.433s)
[457.085748] Starting dynamic subtest: vecs0
[459.083240] Dynamic subtest vecs0: SUCCESS (2.005s)
[459.091606] Starting dynamic subtest: ccs0
[461.055283] Dynamic subtest ccs0: SUCCESS (1.971s)
[461.056464] Subtest clean: SUCCESS (5.614s)
[461.273059] [126/156] (570s left) kms_invalid_mode (int-max-clock)
[461.373246] Starting subtest: int-max-clock
[461.374130] Starting dynamic subtest: pipe-A-eDP-1
[461.668032] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.294s)
[461.676792] Starting dynamic subtest: pipe-B-eDP-1
[461.677719] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[461.685805] Starting dynamic subtest: pipe-C-eDP-1
[461.686839] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[461.695071] Starting dynamic subtest: pipe-D-eDP-1
[461.696105] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[461.697023] Subtest int-max-clock: SUCCESS (0.300s)
[462.546629] [127/156] (569s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[462.593009] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[462.697326] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.104s)
[462.769852] [128/156] (569s left) gem_create (create-ext-placement-each)
[462.937835] Starting subtest: create-ext-placement-each
[462.938742] Subtest create-ext-placement-each: SUCCESS (0.000s)
[463.018231] [129/156] (569s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[463.100751] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[463.101750] Starting dynamic subtest: pipe-A
[463.166708] Dynamic subtest pipe-A: SUCCESS (0.067s)
[463.176640] Starting dynamic subtest: pipe-B
[464.291753] Dynamic subtest pipe-B: SUCCESS (1.124s)
[464.301949] Starting dynamic subtest: pipe-C
[465.409602] Dynamic subtest pipe-C: SUCCESS (1.117s)
[465.418043] Starting dynamic subtest: pipe-D
[466.535369] Dynamic subtest pipe-D: SUCCESS (1.125s)
[466.536445] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.437s)
[467.681770] [130/156] (564s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[467.783713] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[467.795456] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[467.875128] [131/156] (564s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[467.968951] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[474.822039] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.853s)
[474.945332] [132/156] (557s left) gem_fence_thrash (bo-copy)
[474.977742] Starting subtest: bo-copy
[475.001737] Subtest bo-copy: SKIP (0.022s)
[475.057631] [133/156] (557s left) gem_userptr_blits (access-control)
[475.136971] Starting subtest: access-control
[475.138842] Subtest access-control: SKIP (0.000s)
[475.255082] [134/156] (557s left) kms_flip (2x-flip-vs-suspend)
[475.338586] Starting subtest: 2x-flip-vs-suspend
[475.340258] Subtest 2x-flip-vs-suspend: SKIP (0.002s)
[475.447807] [135/156] (556s left) drm_read (empty-nonblock)
[475.598807] Starting subtest: empty-nonblock
[475.600713] Subtest empty-nonblock: SUCCESS (0.000s)
[475.718062] [136/156] (556s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[475.839527] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[507.887589] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (32.046s)
[508.774274] [137/156] (523s left) kms_cursor_legacy (single-bo)
[508.890335] Starting subtest: single-bo
[508.891257] Starting dynamic subtest: pipe-A
[514.316667] Dynamic subtest pipe-A: SUCCESS (5.379s)
[514.327589] Starting dynamic subtest: pipe-B
[519.699660] Dynamic subtest pipe-B: SUCCESS (5.379s)
[519.713198] Starting dynamic subtest: pipe-C
[525.082621] Dynamic subtest pipe-C: SUCCESS (5.379s)
[525.094247] Starting dynamic subtest: pipe-D
[530.428957] Dynamic subtest pipe-D: SUCCESS (5.379s)
[530.441191] Starting dynamic subtest: all-pipes
[535.856023] Dynamic subtest all-pipes: SUCCESS (5.387s)
[535.857212] Subtest single-bo: SUCCESS (26.917s)
[535.952114] [138/156] (496s left) kms_color (legacy-gamma)
[536.048701] Starting subtest: legacy-gamma
[536.049811] Starting dynamic subtest: pipe-A-eDP-1
[536.784846] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.736s)
[536.796839] Starting dynamic subtest: pipe-B-eDP-1
[538.204662] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.418s)
[538.213736] Starting dynamic subtest: pipe-C-eDP-1
[539.582675] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.377s)
[539.592233] Starting dynamic subtest: pipe-D-eDP-1
[541.014141] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.430s)
[541.015238] Subtest legacy-gamma: SUCCESS (4.964s)
[541.887870] [139/156] (490s left) api_intel_bb (destroy-bb)
[541.932865] Starting subtest: destroy-bb
[541.942766] Subtest destroy-bb: SUCCESS (0.009s)
[542.059170] [140/156] (490s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[542.148496] Starting subtest: pr-cursor-plane-move-continuous-sf
[542.150232] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[542.217175] [141/156] (490s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[542.305027] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[542.307004] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[542.407195] [142/156] (490s left) gem_exec_store (pages)
[542.454755] Starting subtest: pages
[542.455789] Starting dynamic subtest: rcs0
[542.537400] Dynamic subtest rcs0: SUCCESS (0.082s)
[542.555137] Starting dynamic subtest: bcs0
[542.602907] Dynamic subtest bcs0: SUCCESS (0.065s)
[542.613682] Starting dynamic subtest: vcs0
[542.670750] Dynamic subtest vcs0: SUCCESS (0.066s)
[542.680122] Starting dynamic subtest: vcs1
[542.738753] Dynamic subtest vcs1: SUCCESS (0.067s)
[542.747505] Starting dynamic subtest: vecs0
[542.801759] Dynamic subtest vecs0: SUCCESS (0.062s)
[542.810318] Starting dynamic subtest: ccs0
[542.865307] Dynamic subtest ccs0: SUCCESS (0.063s)
[542.867718] Subtest pages: SUCCESS (0.412s)
[543.045749] [143/156] (489s left) gem_exec_schedule (semaphore-power)
[543.241220] Subtest semaphore-power: SKIP (0.000s)
[543.404383] [144/156] (489s left) prime_vgem (basic-fence-flip)
[543.452727] Starting subtest: basic-fence-flip
[543.753785] Subtest basic-fence-flip: SUCCESS (0.301s)
[543.861996] [145/156] (488s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[543.948636] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[543.950213] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[544.053635] [146/156] (488s left) gem_mmap_offset (bad-extensions)
[544.105762] Starting subtest: bad-extensions
[544.106538] Subtest bad-extensions: SUCCESS (0.000s)
[544.208390] [147/156] (488s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[544.303270] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[544.305462] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[544.416816] [148/156] (488s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[544.513403] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[549.095817] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.582s)
[550.326818] [149/156] (482s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[550.432749] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[557.841815] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.408s)
[557.974315] [150/156] (474s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[558.081681] Starting subtest: cursor-tearing-framebuffer-change
[558.082679] Starting dynamic subtest: pipe-A-eDP-1
[558.657354] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.575s)
[558.666490] Starting dynamic subtest: pipe-D-eDP-1
[559.859906] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.201s)
[559.862455] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.780s)
[560.694858] [151/156] (472s left) perf (invalid-remove-userspace-config)
[560.831615] Starting subtest: invalid-remove-userspace-config
[560.839048] Subtest invalid-remove-userspace-config: SUCCESS (0.007s)
[560.882598] [152/156] (472s left) kms_psr (psr-sprite-blt)
[560.968229] Starting subtest: psr-sprite-blt
[560.969169] Starting dynamic subtest: eDP-1
[562.717448] Dynamic subtest eDP-1: SUCCESS (1.748s)
[562.718346] Subtest psr-sprite-blt: SUCCESS (1.749s)
[563.557403] [153/156] (469s left) gem_exec_fence (submit-chain)
[563.741243] Starting subtest: submit-chain
[563.753510] Subtest submit-chain: SUCCESS (0.020s)
[565.107980] [154/156] (467s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-render)
[565.201085] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-render
[565.202791] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[565.288113] [155/156] (467s left) gem_lmem_swapping (random-engines)
[565.328933] Subtest random-engines: SKIP (0.000s)
[565.364209] [156/156] (467s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[565.454841] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[565.455719] Starting dynamic subtest: pipe-A-eDP-1
[565.463721] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[565.474168] Starting dynamic subtest: pipe-B-eDP-1
[565.482490] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[565.491782] Starting dynamic subtest: pipe-C-eDP-1
[565.499345] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[565.507873] Starting dynamic subtest: pipe-D-eDP-1
[565.515713] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[565.517258] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[567.723153] Closing watchdogs
results: parsing output: 0/ for test: gem_render_linear_blits
results: parsing output: 1/ for test: gem_userptr_blits
results: parsing output: 2/ for test: gem_exec_params
results: parsing output: 3/ for test: gem_exec_endless
results: parsing output: 4/ for test: kms_ccs
results: parsing output: 5/ for test: gem_render_copy
results: parsing output: 6/ for test: kms_pipe_crc_basic
results: parsing output: 7/ for test: perf_pmu
results: parsing output: 8/ for test: sysfs_timeslice_duration
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_chamelium_color
results: parsing output: 11/ for test: kms_vblank
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_plane_scaling
results: parsing output: 14/ for test: kms_draw_crc
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: sw_sync
results: parsing output: 19/ for test: kms_psr2_sf
results: parsing output: 20/ for test: gem_vm_create
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_cursor_legacy
results: parsing output: 25/ for test: gem_pxp
results: parsing output: 26/ for test: kms_cursor_crc
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: kms_plane
results: parsing output: 29/ for test: i915_suspend
results: parsing output: 30/ for test: gem_mmap_wc
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_properties
results: parsing output: 33/ for test: kms_pm_rpm
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_chamelium_hpd
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: kms_addfb_basic
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_set_tiling_vs_blt
results: parsing output: 40/ for test: kms_cursor_legacy
results: parsing output: 41/ for test: kms_flip_scaled_crc
results: parsing output: 42/ for test: kms_async_flips
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: kms_flip_scaled_crc
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: gem_ctx_persistence
results: parsing output: 51/ for test: gen7_exec_parse
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: kms_atomic_transition
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_softpin
results: parsing output: 57/ for test: gem_ctx_param
results: parsing output: 58/ for test: kms_chamelium_frames
results: parsing output: 59/ for test: gem_exec_flush
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_hdr
results: parsing output: 62/ for test: kms_plane_lowres
results: parsing output: 63/ for test: kms_addfb_basic
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_content_protection
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: kms_cursor_legacy
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_exec_balancer
results: parsing output: 71/ for test: kms_pm_dc
results: parsing output: 72/ for test: gem_huc_copy
results: parsing output: 73/ for test: kms_selftest
results: parsing output: 74/ for test: gem_eio
results: parsing output: 75/ for test: gem_exec_fence
results: parsing output: 76/ for test: gem_mmap_wc
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: api_intel_allocator
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: kms_lease
results: parsing output: 83/ for test: kms_properties
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gen9_exec_parse
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: gem_ppgtt
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: perf_pmu
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: prime_udl
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_mmap_wc
results: parsing output: 102/ for test: i915_pm_rps
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: gem_userptr_blits
results: parsing output: 107/ for test: prime_mmap
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: core_setmaster
results: parsing output: 110/ for test: kms_addfb_basic
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: prime_busy
results: parsing output: 115/ for test: gem_exec_schedule
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: gem_exec_flush
results: parsing output: 118/ for test: fbdev
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: gem_softpin
results: parsing output: 121/ for test: i915_module_load
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: gem_ctx_isolation
results: parsing output: 125/ for test: kms_invalid_mode
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: gem_create
results: parsing output: 128/ for test: kms_plane_scaling
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_fence_thrash
results: parsing output: 132/ for test: gem_userptr_blits
results: parsing output: 133/ for test: kms_flip
results: parsing output: 134/ for test: drm_read
results: parsing output: 135/ for test: kms_cursor_legacy
results: parsing output: 136/ for test: kms_cursor_legacy
results: parsing output: 137/ for test: kms_color
results: parsing output: 138/ for test: api_intel_bb
results: parsing output: 139/ for test: kms_psr2_sf
results: parsing output: 140/ for test: kms_big_fb
results: parsing output: 141/ for test: gem_exec_store
results: parsing output: 142/ for test: gem_exec_schedule
results: parsing output: 143/ for test: prime_vgem
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: gem_mmap_offset
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: kms_cursor_crc
results: parsing output: 150/ for test: perf
results: parsing output: 151/ for test: kms_psr
results: parsing output: 152/ for test: gem_exec_fence
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: gem_lmem_swapping
results: parsing output: 155/ for test: kms_ccs
Done.