[56.928253] Initializing watchdogs
[56.928304]   /dev/watchdog0
[56.942851] [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]
[56.947553] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.950381] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.953612] [001/133] (960s left) gem_pxp (create-regular-buffer)
[57.106222] Starting subtest: create-regular-buffer
[57.108321] Subtest create-regular-buffer: SUCCESS (0.000s)
[57.243075] [002/133] (960s left) kms_pm_rpm (basic-pci-d3-state)
[59.508960] Starting subtest: basic-pci-d3-state
[60.975283] Subtest basic-pci-d3-state: SUCCESS (1.470s)
[61.075145] [003/133] (956s left) gem_wait (wait)
[61.141884] Starting subtest: wait
[61.144417] Starting dynamic subtest: all-engines
[62.308320] Dynamic subtest all-engines: SUCCESS (1.164s)
[62.317103] Starting dynamic subtest: rcs0
[63.351873] Dynamic subtest rcs0: SUCCESS (1.044s)
[63.360883] Starting dynamic subtest: bcs0
[64.396482] Dynamic subtest bcs0: SUCCESS (1.044s)
[64.405801] Starting dynamic subtest: vcs0
[65.439529] Dynamic subtest vcs0: SUCCESS (1.042s)
[65.449680] Starting dynamic subtest: vcs1
[66.483477] Dynamic subtest vcs1: SUCCESS (1.043s)
[66.493391] Starting dynamic subtest: vecs0
[67.527229] Dynamic subtest vecs0: SUCCESS (1.043s)
[67.537281] Starting dynamic subtest: ccs0
[68.574553] Dynamic subtest ccs0: SUCCESS (1.046s)
[68.578065] Subtest wait: SUCCESS (7.433s)
[68.782889] [004/133] (948s left) gem_exec_gttfill (engines)
[68.855232] Starting subtest: engines
[68.857618] Starting dynamic subtest: rcs0
[92.343222] Dynamic subtest rcs0: SUCCESS (23.489s)
[92.353649] Starting dynamic subtest: bcs0
[115.731769] Dynamic subtest bcs0: SUCCESS (23.387s)
[115.740149] Starting dynamic subtest: vcs0
[139.082521] Dynamic subtest vcs0: SUCCESS (23.349s)
[139.091640] Starting dynamic subtest: vcs1
[162.384768] Dynamic subtest vcs1: SUCCESS (23.300s)
[162.395661] Starting dynamic subtest: vecs0
[185.732487] Dynamic subtest vecs0: SUCCESS (23.346s)
[185.741509] Starting dynamic subtest: ccs0
[209.043028] Dynamic subtest ccs0: SUCCESS (23.309s)
[209.046260] Subtest engines: SUCCESS (140.188s)
[209.244170] [005/133] (808s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[209.413118] Starting subtest: fbcpsr-2p-rte
[209.417192] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[209.528484] [006/133] (808s left) kms_psr (fbc-pr-no-drrs)
[209.622129] Starting subtest: fbc-pr-no-drrs
[209.626619] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[209.694596] [007/133] (808s left) perf (gen12-group-concurrent-oa-buffer-read)
[209.863539] Starting subtest: gen12-group-concurrent-oa-buffer-read
[219.962390] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.048s)
[220.003019] [008/133] (797s left) gem_softpin (full)
[220.056853] Starting subtest: full
[220.066629] Subtest full: SUCCESS (0.012s)
[220.183804] [009/133] (797s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[220.273868] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[220.278188] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[220.348847] [010/133] (797s left) gem_mmap_gtt (basic-read)
[220.415250] Subtest basic-read: SKIP (0.000s)
[220.480313] [011/133] (797s left) kms_big_fb (linear-32bpp-rotate-180)
[220.582174] Starting subtest: linear-32bpp-rotate-180
[222.058468] Subtest linear-32bpp-rotate-180: SUCCESS (1.478s)
[222.202764] [012/133] (795s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[222.297523] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[222.301099] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[222.392219] [013/133] (795s left) gem_ctx_bad_destroy (invalid-ctx)
[222.450126] Starting subtest: invalid-ctx
[222.452211] Subtest invalid-ctx: SUCCESS (0.000s)
[222.526864] [014/133] (795s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[222.621450] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[222.648477] Starting dynamic subtest: pipe-A-plane-0
[222.937190] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[222.945121] Starting dynamic subtest: pipe-A-plane-3
[223.170642] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[223.180277] Starting dynamic subtest: pipe-A-plane-5
[223.183849] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[224.305192] Starting dynamic subtest: pipe-B-plane-0
[224.597927] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[224.607526] Starting dynamic subtest: pipe-B-plane-3
[224.830708] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[224.841359] Starting dynamic subtest: pipe-B-plane-5
[224.845761] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[225.142636] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.521s)
[225.985786] [015/133] (792s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[226.048732] Starting subtest: single-wait-for-submit-available-signaled
[226.051221] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.001s)
[226.152558] [016/133] (791s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[226.242205] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[226.244560] Starting dynamic subtest: pipe-A-default-mode
[227.454337] Dynamic subtest pipe-A-default-mode: SKIP (1.209s)
[227.458751] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.210s)
[227.598521] [017/133] (790s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[227.662586] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[227.664497] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[227.773969] [018/133] (790s left) i915_drm_fdinfo (virtual-busy-all)
[227.817691] Starting subtest: virtual-busy-all
[227.821967] Subtest virtual-busy-all: SKIP (0.000s)
[227.891914] [019/133] (790s left) gem_exec_reloc (basic-gtt-read-noreloc)
[227.959102] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[228.025603] [020/133] (790s left) kms_lease (lease-invalid-connector)
[228.114340] Starting subtest: lease-invalid-connector
[228.116701] Starting dynamic subtest: pipe-A-eDP-1
[228.119152] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[228.130592] Starting dynamic subtest: pipe-B-eDP-1
[228.132778] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[228.140425] Starting dynamic subtest: pipe-C-eDP-1
[228.142651] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[228.149850] Starting dynamic subtest: pipe-D-eDP-1
[228.151774] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[228.153655] Subtest lease-invalid-connector: SUCCESS (0.002s)
[228.190287] [021/133] (790s left) gem_pxp (reject-modify-context-protection-off-3)
[228.297269] Starting subtest: reject-modify-context-protection-off-3
[228.299330] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[228.400469] [022/133] (789s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[228.497013] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[228.498989] Starting dynamic subtest: pipe-A-eDP-1
[228.546790] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[228.554494] Starting dynamic subtest: pipe-B-eDP-1
[228.600469] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[228.608773] Starting dynamic subtest: pipe-C-eDP-1
[228.655168] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[228.663550] Starting dynamic subtest: pipe-D-eDP-1
[228.709314] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[228.712924] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[230.776515] [023/133] (787s left) gem_mmap_gtt (fault-concurrent)
[230.835188] Subtest fault-concurrent: SKIP (0.000s)
[230.887080] [024/133] (787s left) kms_addfb_basic (addfb25-4-tiled)
[230.980216] Starting subtest: addfb25-4-tiled
[230.982091] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[231.071886] [025/133] (787s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[231.173914] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[231.176319] Starting dynamic subtest: A-eDP1
[234.720661] Dynamic subtest A-eDP1: SUCCESS (3.544s)
[234.730786] Starting dynamic subtest: B-eDP1
[237.932072] Dynamic subtest B-eDP1: SUCCESS (3.211s)
[237.941821] Starting dynamic subtest: C-eDP1
[241.041760] Dynamic subtest C-eDP1: SUCCESS (3.110s)
[241.051641] Starting dynamic subtest: D-eDP1
[244.141836] Dynamic subtest D-eDP1: SUCCESS (3.100s)
[244.144320] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.970s)
[244.951616] [026/133] (773s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[245.071234] Starting subtest: flip-vs-cursor-busy-crc-legacy
[245.875837] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.804s)
[246.673674] [027/133] (771s left) syncobj_eventfd (timeline-wait-signaled)
[246.723804] Starting subtest: timeline-wait-signaled
[246.726149] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[246.817778] [028/133] (771s left) gem_exec_schedule (u-fairslice)
[246.887642] Starting subtest: u-fairslice
[246.889612] Starting dynamic subtest: rcs0
[248.959472] Dynamic subtest rcs0: SUCCESS (2.020s)
[248.969669] Starting dynamic subtest: bcs0
[250.920072] Dynamic subtest bcs0: SUCCESS (2.018s)
[250.929425] Starting dynamic subtest: vcs0
[252.987321] Dynamic subtest vcs0: SUCCESS (2.018s)
[252.996624] Starting dynamic subtest: vcs1
[254.959154] Dynamic subtest vcs1: SUCCESS (2.020s)
[254.968131] Starting dynamic subtest: vecs0
[257.025669] Dynamic subtest vecs0: SUCCESS (2.018s)
[257.035157] Starting dynamic subtest: ccs0
[258.995642] Dynamic subtest ccs0: SUCCESS (2.019s)
[258.997601] Subtest u-fairslice: SUCCESS (12.115s)
[259.295211] [029/133] (759s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[259.386869] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[259.389249] Starting dynamic subtest: pipe-A-default-mode
[262.098319] Dynamic subtest pipe-A-default-mode: SUCCESS (2.711s)
[262.100528] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.712s)
[262.962652] [030/133] (755s left) gem_exec_whisper (basic-sync-all)
[263.034404] Starting subtest: basic-sync-all
[269.592143] Subtest basic-sync-all: SUCCESS (6.556s)
[269.773845] [031/133] (748s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[269.832074] Starting subtest: etime-multi-wait-available-unsubmitted
[269.935039] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.102s)
[270.009947] [032/133] (748s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[270.108730] Starting subtest: random-ccs-data-y-tiled-ccs
[270.110841] Starting dynamic subtest: pipe-A-eDP-1
[270.134856] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[270.145455] Starting dynamic subtest: pipe-B-eDP-1
[270.168142] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[270.176218] Starting dynamic subtest: pipe-C-eDP-1
[270.198818] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[270.207040] Starting dynamic subtest: pipe-D-eDP-1
[270.230284] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[270.234553] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.004s)
[272.357941] [033/133] (746s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[272.460247] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[272.462410] Starting dynamic subtest: pipe-A-eDP-1
[272.481959] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[272.492195] Starting dynamic subtest: pipe-B-eDP-1
[272.510906] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[272.519466] Starting dynamic subtest: pipe-C-eDP-1
[272.538493] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[272.548317] Starting dynamic subtest: pipe-D-eDP-1
[272.567524] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[272.569700] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[274.627268] [034/133] (744s left) kms_addfb_basic (basic)
[274.688086] Starting subtest: basic
[274.690037] Subtest basic: SUCCESS (0.000s)
[274.818888] [035/133] (743s left) kms_color_pipeline (plane-lut1d-lut1d)
[274.920880] Starting subtest: plane-lut1d-lut1d
[275.065736] Starting dynamic subtest: pipe-A-plane-0
[275.276701] Dynamic subtest pipe-A-plane-0: SUCCESS (0.211s)
[275.288466] Starting dynamic subtest: pipe-A-plane-1
[275.465715] Dynamic subtest pipe-A-plane-1: SUCCESS (0.189s)
[275.474627] Starting dynamic subtest: pipe-A-plane-2
[275.631710] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[276.865385] Starting dynamic subtest: pipe-B-plane-0
[277.035979] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s)
[277.045906] Starting dynamic subtest: pipe-B-plane-1
[277.258417] Dynamic subtest pipe-B-plane-1: SUCCESS (0.222s)
[277.270375] Starting dynamic subtest: pipe-B-plane-2
[277.402963] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s)
[278.549159] Starting dynamic subtest: pipe-C-plane-0
[278.675385] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[278.692918] Starting dynamic subtest: pipe-C-plane-1
[278.820146] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[278.837746] Starting dynamic subtest: pipe-C-plane-2
[278.976421] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[280.183858] Starting dynamic subtest: pipe-D-plane-0
[280.329950] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[280.339049] Starting dynamic subtest: pipe-D-plane-1
[280.478699] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[280.490435] Starting dynamic subtest: pipe-D-plane-2
[280.652309] Dynamic subtest pipe-D-plane-2: SUCCESS (0.174s)
[280.937090] Subtest plane-lut1d-lut1d: SUCCESS (6.019s)
[281.765115] [036/133] (737s left) api_intel_allocator (standalone)
[281.841351] Starting subtest: standalone
[281.860331] Subtest standalone: SUCCESS (0.021s)
[281.974084] [037/133] (736s left) prime_self_import (basic-llseek-bad)
[282.010279] Starting subtest: basic-llseek-bad
[282.035237] Subtest basic-llseek-bad: SUCCESS (0.025s)
[282.141672] [038/133] (736s left) kms_vblank (query-forked)
[282.229212] Starting subtest: query-forked
[282.231339] Starting dynamic subtest: pipe-A-eDP-1
[284.074770] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.846s)
[284.093761] Starting dynamic subtest: pipe-D-eDP-1
[286.575272] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.496s)
[286.577435] Subtest query-forked: SUCCESS (4.346s)
[287.435389] [039/133] (731s left) gem_exec_flush (basic-uc-ro-default)
[287.496686] Starting subtest: basic-uc-ro-default
[292.981348] Subtest basic-uc-ro-default: SUCCESS (5.457s)
[293.146266] [040/133] (725s left) perf (per-context-mode-unprivileged)
[293.224910] Starting subtest: per-context-mode-unprivileged
[293.229512] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[293.265960] [041/133] (725s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[293.366275] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[293.370692] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[293.450878] [042/133] (725s left) i915_pm_rps (min-max-config-idle)
[293.515911] Starting subtest: min-max-config-idle
[293.520481] Subtest min-max-config-idle: SKIP (0.001s)
[293.623646] [043/133] (725s left) gem_exec_balancer (busy)
[293.682461] Starting subtest: busy
[295.364125] Subtest busy: SUCCESS (1.668s)
[295.676742] [044/133] (723s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[295.769571] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[295.773829] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[295.865756] [045/133] (723s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[295.961716] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[295.966245] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[296.050303] [046/133] (723s left) gem_mmap_gtt (big-bo-tiledy)
[296.112495] Subtest big-bo-tiledY: SKIP (0.000s)
[296.179385] [047/133] (723s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[296.272490] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[303.644553] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.375s)
[303.781869] [048/133] (715s left) kms_chamelium_edid (vga-edid-read)
[304.182653] Subtest vga-edid-read: SKIP (0.000s)
[304.965316] [049/133] (714s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[305.059168] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[312.012116] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.954s)
[312.182462] [050/133] (707s left) gem_create (hog-create)
[312.244355] Starting subtest: hog-create
[312.246729] Starting dynamic subtest: smem0
[345.319267] Dynamic subtest smem0: SUCCESS (33.071s)
[345.321935] Subtest hog-create: SUCCESS (33.073s)
[345.500626] [051/133] (673s left) kms_getfb (getfb-repeated-different-handles)
[345.595874] Starting subtest: getfb-repeated-different-handles
[345.598062] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[345.699646] [052/133] (673s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[345.801805] Starting subtest: y-tiled-64bpp-rotate-0
[345.806154] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[345.891432] [053/133] (673s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[345.989432] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[345.993512] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[346.087128] [054/133] (673s left) api_intel_bb (simple-bb)
[346.137959] Starting subtest: simple-bb
[346.142769] Subtest simple-bb: SUCCESS (0.006s)
[346.270363] [055/133] (673s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[346.362572] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[346.366955] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[346.435192] [056/133] (673s left) kms_flip (blocking-wf_vblank)
[346.527221] Starting subtest: blocking-wf_vblank
[346.529081] Starting dynamic subtest: A-eDP1
[355.489825] Dynamic subtest A-eDP1: SUCCESS (8.931s)
[355.502258] Starting dynamic subtest: B-eDP1
[364.427252] Dynamic subtest B-eDP1: SUCCESS (8.933s)
[364.438232] Starting dynamic subtest: C-eDP1
[373.350958] Dynamic subtest C-eDP1: SUCCESS (8.911s)
[373.360561] Starting dynamic subtest: D-eDP1
[382.534605] Dynamic subtest D-eDP1: SUCCESS (9.172s)
[382.536966] Subtest blocking-wf_vblank: SUCCESS (35.964s)
[383.706882] [057/133] (635s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[383.830989] Starting subtest: cursorA-vs-flipB-atomic-transitions
[383.835224] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[383.971751] [058/133] (635s left) gem_mmap_offset (bad-flags)
[384.027618] Starting subtest: bad-flags
[384.029654] Subtest bad-flags: SUCCESS (0.000s)
[384.110468] [059/133] (635s left) vgem_basic (create)
[384.252654] Starting subtest: create
[384.254874] Subtest create: SUCCESS (0.000s)
[384.305829] [FACT vgem_basic (create)] new: kernel.kmod_is_loaded.vgem: true
[384.309070] [060/133] (635s left) kms_atomic (plane-primary-legacy)
[384.403230] Starting subtest: plane-primary-legacy
[384.405367] Starting dynamic subtest: pipe-A-eDP-1
[384.861563] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.456s)
[384.863533] Subtest plane-primary-legacy: SUCCESS (0.457s)
[385.665032] [061/133] (634s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[385.771486] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[385.775745] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[385.866288] [062/133] (634s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[385.928077] Starting subtest: invalid-single-wait-unsubmitted
[385.930258] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[386.040286] [063/133] (633s left) kms_psr (psr-cursor-render)
[386.127157] Starting subtest: psr-cursor-render
[386.129304] Starting dynamic subtest: eDP-1
[387.864058] Dynamic subtest eDP-1: SUCCESS (1.736s)
[387.866288] Subtest psr-cursor-render: SUCCESS (1.737s)
[388.741337] [064/133] (631s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[388.833246] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[388.835448] Starting dynamic subtest: pipe-A-eDP-1
[388.858694] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[388.869838] Starting dynamic subtest: pipe-B-eDP-1
[388.891138] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[388.905480] Starting dynamic subtest: pipe-C-eDP-1
[388.928527] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[388.938936] Starting dynamic subtest: pipe-D-eDP-1
[388.960419] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[388.964447] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[391.084321] [065/133] (628s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[391.621239] Starting subtest: syncobj-timeline-invalid-flags
[391.623899] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[393.399034] [066/133] (626s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[393.501255] Starting subtest: stress-xrgb8888-ytiled
[393.505686] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[393.580263] [067/133] (626s left) gem_sync (basic-each)
[393.658911] Starting subtest: basic-each
[395.839527] Subtest basic-each: SUCCESS (2.191s)
[396.028676] [068/133] (624s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[396.140230] Starting subtest: x-tiled-8bpp-rotate-0
[397.275683] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.137s)
[397.400348] [069/133] (622s left) sw_sync (sync_expired_merge)
[397.436891] Starting subtest: sync_expired_merge
[398.512925] Subtest sync_expired_merge: SUCCESS (1.074s)
[398.572786] [070/133] (621s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[398.678901] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[403.334030] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.659s)
[404.483590] [071/133] (615s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[404.579104] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[404.583321] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[404.679674] [072/133] (615s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[404.779606] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[404.784025] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[404.881064] [073/133] (615s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[404.985228] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[404.987600] Starting dynamic subtest: pipe-A
[406.212353] Dynamic subtest pipe-A: SUCCESS (1.230s)
[406.223894] Starting dynamic subtest: pipe-B
[408.525454] Dynamic subtest pipe-B: SUCCESS (2.310s)
[408.535868] Starting dynamic subtest: pipe-C
[409.667109] Dynamic subtest pipe-C: SUCCESS (1.141s)
[409.677079] Starting dynamic subtest: pipe-D
[410.901811] Dynamic subtest pipe-D: SUCCESS (1.233s)
[410.904191] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.920s)
[412.100359] [074/133] (608s left) kms_cursor_edge_walk (64x64-top-bottom)
[412.216545] Starting subtest: 64x64-top-bottom
[412.218924] Starting dynamic subtest: pipe-A-eDP-1
[415.657961] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.440s)
[415.668201] Starting dynamic subtest: pipe-D-eDP-1
[418.796049] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.137s)
[418.798436] Subtest 64x64-top-bottom: SUCCESS (6.580s)
[419.610211] [075/133] (600s left) kms_joiner (basic-ultra-joiner)
[419.710185] Starting subtest: basic-ultra-joiner
[419.714166] Subtest basic-ultra-joiner: SKIP (0.000s)
[419.777847] [076/133] (600s left) gen9_exec_parse (bb-start-param)
[419.833511] Subtest bb-start-param: SKIP (0.000s)
[419.928093] [077/133] (600s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[420.024612] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[426.882822] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.860s)
[427.039063] [078/133] (593s left) sw_sync (sync_multi_consumer)
[427.082692] Starting subtest: sync_multi_consumer
[427.499696] Subtest sync_multi_consumer: SUCCESS (0.419s)
[427.566896] [079/133] (593s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[427.633135] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[427.637322] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[427.828250] [080/133] (592s left) gem_exec_schedule (pi-common)
[428.012901] Starting subtest: pi-common
[428.014906] Starting dynamic subtest: rcs0
[428.038469] Dynamic subtest rcs0: SUCCESS (0.029s)
[428.047613] Starting dynamic subtest: bcs0
[428.069487] Dynamic subtest bcs0: SUCCESS (0.030s)
[428.081527] Starting dynamic subtest: vcs0
[428.099042] Dynamic subtest vcs0: SUCCESS (0.029s)
[428.112260] Starting dynamic subtest: vcs1
[428.126067] Dynamic subtest vcs1: SUCCESS (0.026s)
[428.139085] Starting dynamic subtest: vecs0
[428.153242] Dynamic subtest vecs0: SUCCESS (0.027s)
[428.166782] Starting dynamic subtest: ccs0
[428.179828] Dynamic subtest ccs0: SUCCESS (0.026s)
[428.182084] Subtest pi-common: SUCCESS (0.171s)
[428.403269] [081/133] (592s left) gem_exec_whisper (basic-contexts-all)
[428.465701] Starting subtest: basic-contexts-all
[440.260975] Subtest basic-contexts-all: SUCCESS (11.790s)
[440.446783] [082/133] (580s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[440.539872] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[440.542059] Starting dynamic subtest: pipe-A-eDP-1
[440.581589] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.043s)
[440.595241] Starting dynamic subtest: pipe-B-eDP-1
[440.630652] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.046s)
[440.643047] Starting dynamic subtest: pipe-C-eDP-1
[440.663083] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[440.673893] Starting dynamic subtest: pipe-D-eDP-1
[440.694927] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.024s)
[440.697209] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.142s)
[442.933266] [083/133] (577s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[443.040249] Starting subtest: psr-rgb101010-draw-blt
[450.325112] Subtest psr-rgb101010-draw-blt: SUCCESS (7.288s)
[450.449181] [084/133] (570s left) core_setmaster (master-drop-set-shared-fd)
[450.532970] Starting subtest: master-drop-set-shared-fd
[450.554996] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[450.596490] [085/133] (570s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[450.698413] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[457.515414] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.820s)
[457.655255] [086/133] (563s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[457.770828] Starting subtest: psr-rgb565-draw-render
[464.801358] Subtest psr-rgb565-draw-render: SUCCESS (7.034s)
[464.913372] [087/133] (556s left) kms_sequence (get-forked-busy)
[465.014074] Starting subtest: get-forked-busy
[465.015975] Starting dynamic subtest: pipe-A-eDP-1
[466.971656] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.957s)
[466.990300] Starting dynamic subtest: pipe-B-eDP-1
[469.616433] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.644s)
[469.626141] Starting dynamic subtest: pipe-C-eDP-1
[472.246268] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.628s)
[472.258858] Starting dynamic subtest: pipe-D-eDP-1
[474.865301] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.618s)
[474.867730] Subtest get-forked-busy: SUCCESS (9.852s)
[475.753802] [088/133] (545s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[475.848990] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[475.853179] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[475.944784] [089/133] (545s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[476.005785] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[476.008160] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[476.116292] [090/133] (544s left) syncobj_wait (single-wait-for-submit-signaled)
[476.172268] Starting subtest: single-wait-for-submit-signaled
[476.174989] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[476.294445] [091/133] (544s left) kms_dsc (dsc-fractional-bpp)
[476.390329] Starting subtest: dsc-fractional-bpp
[476.403387] Subtest dsc-fractional-bpp: SKIP (0.000s)
[476.464092] [092/133] (544s left) syncobj_wait (wait-all-snapshot)
[476.512834] Starting subtest: wait-all-snapshot
[476.597571] Subtest wait-all-snapshot: SUCCESS (0.083s)
[476.676076] [093/133] (544s left) kms_content_protection (legacy-hdcp14)
[476.818566] Starting subtest: legacy-hdcp14
[476.822367] Subtest legacy-hdcp14: SKIP (0.000s)
[476.930231] [094/133] (544s left) gem_exec_balancer (waits)
[476.986402] Starting subtest: waits
[483.573039] Subtest waits: SUCCESS (6.530s)
[483.861153] [095/133] (537s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[483.971785] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[483.974128] Starting dynamic subtest: pipe-A-eDP-1
[483.982864] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[483.994844] Starting dynamic subtest: pipe-B-eDP-1
[484.004047] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[484.012971] Starting dynamic subtest: pipe-C-eDP-1
[484.021447] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[484.030243] Starting dynamic subtest: pipe-D-eDP-1
[484.038658] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[484.042744] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[486.215016] [096/133] (535s left) i915_hangman (engine-error-state-capture)
[486.286839] Starting subtest: engine-error-state-capture
[486.289046] Starting dynamic subtest: rcs0
[490.303797] Dynamic subtest rcs0: SUCCESS (4.016s)
[490.335089] Starting dynamic subtest: bcs0
[496.257470] Dynamic subtest bcs0: SUCCESS (5.951s)
[496.270522] Starting dynamic subtest: vcs0
[502.273476] Dynamic subtest vcs0: SUCCESS (6.013s)
[502.286373] Starting dynamic subtest: vcs1
[508.288427] Dynamic subtest vcs1: SUCCESS (6.012s)
[508.300573] Starting dynamic subtest: vecs0
[514.241082] Dynamic subtest vecs0: SUCCESS (5.949s)
[514.254172] Starting dynamic subtest: ccs0
[519.297081] Dynamic subtest ccs0: SUCCESS (5.053s)
[519.300054] Subtest engine-error-state-capture: SUCCESS (33.011s)
[519.428411] [097/133] (501s left) perf_pmu (rc6-suspend)
[519.478072] Starting subtest: rc6-suspend
[542.816558] Subtest rc6-suspend: SUCCESS (8.119s)
[544.715580] [098/133] (477s left) gem_exec_parallel (basic)
[544.787119] Starting subtest: basic
[544.789590] Starting dynamic subtest: rcs0
[546.299718] Dynamic subtest rcs0: SUCCESS (1.511s)
[546.310269] Starting dynamic subtest: bcs0
[547.817217] Dynamic subtest bcs0: SUCCESS (1.513s)
[547.830235] Starting dynamic subtest: vcs0
[549.533421] Dynamic subtest vcs0: SUCCESS (1.711s)
[549.544286] Starting dynamic subtest: vcs1
[551.573411] Dynamic subtest vcs1: SUCCESS (2.035s)
[551.586309] Starting dynamic subtest: vecs0
[553.494339] Dynamic subtest vecs0: SUCCESS (1.916s)
[553.507446] Starting dynamic subtest: ccs0
[554.967240] Dynamic subtest ccs0: SUCCESS (1.471s)
[554.969584] Subtest basic: SUCCESS (10.171s)
[555.164442] [099/133] (467s left) kms_psr (psr-primary-blt)
[555.265112] Starting subtest: psr-primary-blt
[555.267376] Starting dynamic subtest: eDP-1
[557.014313] Dynamic subtest eDP-1: SUCCESS (1.749s)
[557.016661] Subtest psr-primary-blt: SUCCESS (1.750s)
[557.886307] [100/133] (464s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[557.947924] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[558.027871] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.026s)
[558.067581] [101/133] (464s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[558.160920] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[561.773215] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.615s)
[563.004588] [102/133] (459s left) kms_prop_blob (blob-prop-lifetime)
[563.056936] Starting subtest: blob-prop-lifetime
[563.059217] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[563.185383] [103/133] (459s left) gem_userptr_blits (readonly-unsync)
[563.246514] Subtest readonly-unsync: SKIP (0.000s)
[563.380183] [104/133] (459s left) perf (polling)
[563.471045] Starting subtest: polling
[563.473518] Starting dynamic subtest: 0-rcs0
[573.550639] Dynamic subtest 0-rcs0: SUCCESS (10.024s)
[573.563077] Starting dynamic subtest: 1-vecs0
[583.572289] Dynamic subtest 1-vecs0: SUCCESS (10.017s)
[583.575048] Subtest polling: SUCCESS (20.044s)
[583.618075] [105/133] (439s left) i915_query (query-topology-kernel-writes)
[583.675131] Starting subtest: query-topology-kernel-writes
[583.677490] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[583.768445] [106/133] (439s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[583.876717] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[584.911303] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.035s)
[585.047831] [107/133] (437s left) kms_psr (fbc-pr-sprite-blt)
[585.140050] Starting subtest: fbc-pr-sprite-blt
[585.143688] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[585.214929] [108/133] (437s left) prime_self_import (basic-with_two_bos)
[585.251384] Starting subtest: basic-with_two_bos
[585.273408] Subtest basic-with_two_bos: SUCCESS (0.024s)
[585.374446] [109/133] (437s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[585.467550] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[586.514281] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.045s)
[586.638315] [110/133] (436s left) gem_exec_reloc (basic-cpu-read)
[586.692724] Subtest basic-cpu-read: SKIP (0.000s)
[586.754820] [111/133] (436s left) gem_ctx_shared (exec-shared-gtt)
[586.820098] Starting subtest: exec-shared-gtt
[586.821887] Starting dynamic subtest: rcs0
[586.825816] Dynamic subtest rcs0: SUCCESS (0.008s)
[586.839963] Starting dynamic subtest: bcs0
[586.841815] Dynamic subtest bcs0: SUCCESS (0.006s)
[586.851605] Starting dynamic subtest: vcs0
[586.853505] Dynamic subtest vcs0: SUCCESS (0.006s)
[586.863213] Starting dynamic subtest: vcs1
[586.865035] Dynamic subtest vcs1: SUCCESS (0.006s)
[586.874407] Starting dynamic subtest: vecs0
[586.876241] Dynamic subtest vecs0: SUCCESS (0.006s)
[586.885551] Starting dynamic subtest: ccs0
[586.887355] Dynamic subtest ccs0: SUCCESS (0.005s)
[586.889137] Subtest exec-shared-gtt: SUCCESS (0.042s)
[587.056730] [112/133] (436s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[587.142959] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[587.144945] Starting dynamic subtest: pipe-A
[587.161970] Dynamic subtest pipe-A: SKIP (0.017s)
[587.172537] Starting dynamic subtest: pipe-B
[587.195262] Dynamic subtest pipe-B: SKIP (0.031s)
[587.205129] Starting dynamic subtest: pipe-C
[587.226839] Dynamic subtest pipe-C: SKIP (0.031s)
[587.236226] Starting dynamic subtest: pipe-D
[587.258256] Dynamic subtest pipe-D: SKIP (0.031s)
[587.261679] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.113s)
[587.353564] [113/133] (435s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[587.459432] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[594.845465] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.386s)
[594.975458] [114/133] (428s left) kms_getfb (getfb-handle-protection)
[595.093654] Starting subtest: getfb-handle-protection
[595.117025] Subtest getfb-handle-protection: SUCCESS (0.024s)
[595.251776] [115/133] (427s left) gem_ctx_persistence (process)
[595.311376] Starting subtest: process
[595.503353] Subtest process: SUCCESS (0.191s)
[595.602505] [116/133] (427s left) i915_selftest (mock)
[598.931902] Starting subtest: mock
[598.934544] Starting dynamic subtest: sanitycheck
[599.655944] Dynamic subtest sanitycheck: SUCCESS (0.722s)
[599.666525] Starting dynamic subtest: shmem
[600.326526] Dynamic subtest shmem: SUCCESS (0.668s)
[600.337073] Starting dynamic subtest: fence
[607.687747] Dynamic subtest fence: SUCCESS (7.358s)
[607.698415] Starting dynamic subtest: scatterlist
[609.352370] Dynamic subtest scatterlist: SUCCESS (1.662s)
[609.363051] Starting dynamic subtest: syncmap
[612.449440] Dynamic subtest syncmap: SUCCESS (3.094s)
[612.460314] Starting dynamic subtest: uncore
[613.109519] Dynamic subtest uncore: SUCCESS (0.658s)
[613.120158] Starting dynamic subtest: ring
[613.785520] Dynamic subtest ring: SUCCESS (0.674s)
[613.796133] Starting dynamic subtest: engine
[614.479520] Dynamic subtest engine: SUCCESS (0.692s)
[614.490235] Starting dynamic subtest: timelines
[618.491888] Dynamic subtest timelines: SUCCESS (4.009s)
[618.507886] Starting dynamic subtest: requests
[622.170163] Dynamic subtest requests: SUCCESS (3.675s)
[622.181099] Starting dynamic subtest: objects
[622.917337] Dynamic subtest objects: SUCCESS (0.747s)
[622.927711] Starting dynamic subtest: phys
[623.669491] Dynamic subtest phys: SUCCESS (0.751s)
[623.679561] Starting dynamic subtest: dmabuf
[624.471905] Dynamic subtest dmabuf: SUCCESS (0.801s)
[624.484627] Starting dynamic subtest: vma
[630.280000] Dynamic subtest vma: SUCCESS (5.805s)
[630.297317] Starting dynamic subtest: evict
[631.684518] Dynamic subtest evict: SUCCESS (1.403s)
[631.695255] Starting dynamic subtest: gtt
[635.028438] Dynamic subtest gtt: SUCCESS (3.341s)
[635.038340] Starting dynamic subtest: hugepages
[635.899416] Dynamic subtest hugepages: SUCCESS (0.871s)
[635.913332] Starting dynamic subtest: memory_region
[638.392931] Dynamic subtest memory_region: SUCCESS (2.491s)
[638.395378] Subtest mock: SUCCESS (39.453s)
[638.425664] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[638.426351] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[638.429460] [117/133] (384s left) kms_pm_rpm (legacy-planes-dpms)
[641.751554] Starting subtest: legacy-planes-dpms
[641.754227] Starting dynamic subtest: plane-65
[650.343097] Dynamic subtest plane-65: SUCCESS (8.596s)
[650.355369] Starting dynamic subtest: plane-95
[658.678086] Dynamic subtest plane-95: SUCCESS (8.334s)
[658.690519] Starting dynamic subtest: plane-125
[666.993544] Dynamic subtest plane-125: SUCCESS (8.314s)
[667.005857] Starting dynamic subtest: plane-135
[675.338505] Dynamic subtest plane-135: SUCCESS (8.343s)
[675.341437] Subtest legacy-planes-dpms: SUCCESS (33.598s)
[675.756782] [FACT kms_pm_rpm (legacy-planes-dpms)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[675.758077] [FACT kms_pm_rpm (legacy-planes-dpms)] new: kernel.kmod_is_loaded.i915: true
[675.762102] [118/133] (347s left) kms_cursor_crc (cursor-random-32x10)
[675.923296] Starting subtest: cursor-random-32x10
[675.981558] Subtest cursor-random-32x10: SKIP (0.052s)
[676.239773] [119/133] (347s left) kms_cursor_crc (cursor-offscreen-32x32)
[676.408923] Starting subtest: cursor-offscreen-32x32
[676.466881] Subtest cursor-offscreen-32x32: SKIP (0.054s)
[676.742218] [120/133] (346s left) syncobj_wait (single-wait-all-for-submit-submitted)
[676.800487] Starting subtest: single-wait-all-for-submit-submitted
[676.906781] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.105s)
[677.015783] [121/133] (346s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[677.070493] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[677.135370] [122/133] (346s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[677.194468] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[677.196900] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.001s)
[677.298372] [123/133] (346s left) kms_chamelium_hpd (hdmi-hpd)
[677.689924] Subtest hdmi-hpd: SKIP (0.000s)
[678.537460] [124/133] (345s left) gem_exec_reloc (basic-gtt-noreloc)
[678.603194] Subtest basic-gtt-noreloc: SKIP (0.000s)
[678.672248] [125/133] (344s left) kms_flip (2x-wf_vblank-ts-check)
[678.760650] Starting subtest: 2x-wf_vblank-ts-check
[678.769754] Subtest 2x-wf_vblank-ts-check: SKIP (0.011s)
[678.852678] [126/133] (344s left) kms_psr (pr-primary-mmap-cpu)
[678.936491] Starting subtest: pr-primary-mmap-cpu
[678.940873] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[679.008441] [127/133] (344s left) gem_readwrite (read-write)
[679.062626] Subtest read-write: SKIP (0.000s)
[679.145639] [128/133] (344s left) fbdev (write)
[679.198737] Starting subtest: write
[679.566521] Subtest write: SUCCESS (0.369s)
[679.630848] [129/133] (344s left) kms_dp_aux_dev (basic)
[679.692718] Starting subtest: basic
[679.914412] Subtest basic: SUCCESS (0.220s)
[680.021722] [130/133] (343s left) kms_psr (fbc-psr2-sprite-render)
[680.111612] Starting subtest: fbc-psr2-sprite-render
[680.113891] Starting dynamic subtest: eDP-1
[680.118366] Dynamic subtest eDP-1: SKIP (0.000s)
[680.122637] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[680.197193] [131/133] (343s left) gem_ctx_persistence (engines-cleanup)
[680.270777] Starting subtest: engines-cleanup
[680.272979] Starting dynamic subtest: rcs0
[680.352197] Dynamic subtest rcs0: SUCCESS (0.084s)
[680.365245] Starting dynamic subtest: bcs0
[680.384104] Dynamic subtest bcs0: SUCCESS (0.028s)
[680.393449] Starting dynamic subtest: vcs0
[680.457048] Dynamic subtest vcs0: SUCCESS (0.072s)
[680.468809] Starting dynamic subtest: vcs1
[680.474234] Dynamic subtest vcs1: SUCCESS (0.017s)
[680.483431] Starting dynamic subtest: vecs0
[680.558229] Dynamic subtest vecs0: SUCCESS (0.083s)
[680.570305] Starting dynamic subtest: ccs0
[680.593927] Dynamic subtest ccs0: SUCCESS (0.034s)
[680.596256] Subtest engines-cleanup: SUCCESS (0.327s)
[680.676425] [132/133] (343s left) sysfs_heartbeat_interval (idempotent)
[680.733018] Starting subtest: idempotent
[680.735348] Starting dynamic subtest: vecs0
[680.737735] Dynamic subtest vecs0: SUCCESS (0.001s)
[680.750065] Starting dynamic subtest: ccs0
[680.752047] Dynamic subtest ccs0: SUCCESS (0.001s)
[680.760871] Starting dynamic subtest: vcs0
[680.762751] Dynamic subtest vcs0: SUCCESS (0.000s)
[680.771571] Starting dynamic subtest: bcs0
[680.773436] Dynamic subtest bcs0: SUCCESS (0.001s)
[680.782614] Starting dynamic subtest: rcs0
[680.784801] Dynamic subtest rcs0: SUCCESS (0.000s)
[680.794167] Starting dynamic subtest: vcs1
[680.796072] Dynamic subtest vcs1: SUCCESS (0.000s)
[680.797980] Subtest idempotent: SUCCESS (0.009s)
[680.841227] [133/133] (343s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[680.946977] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[688.042891] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.100s)
[688.155442] Closing watchdogs
results: parsing output: 0/ for test: gem_pxp
results: parsing output: 1/ for test: kms_pm_rpm
results: parsing output: 2/ for test: gem_wait
results: parsing output: 3/ for test: gem_exec_gttfill
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_psr
results: parsing output: 6/ for test: perf
results: parsing output: 7/ for test: gem_softpin
results: parsing output: 8/ for test: kms_plane
results: parsing output: 9/ for test: gem_mmap_gtt
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_ctx_bad_destroy
results: parsing output: 13/ for test: kms_plane
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: kms_flip_scaled_crc
results: parsing output: 16/ for test: syncobj_wait
results: parsing output: 17/ for test: i915_drm_fdinfo
results: parsing output: 18/ for test: gem_exec_reloc
results: parsing output: 19/ for test: kms_lease
results: parsing output: 20/ for test: gem_pxp
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: gem_mmap_gtt
results: parsing output: 23/ for test: kms_addfb_basic
results: parsing output: 24/ for test: kms_flip
results: parsing output: 25/ for test: kms_cursor_legacy
results: parsing output: 26/ for test: syncobj_eventfd
results: parsing output: 27/ for test: gem_exec_schedule
results: parsing output: 28/ for test: kms_flip_scaled_crc
results: parsing output: 29/ for test: gem_exec_whisper
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: kms_addfb_basic
results: parsing output: 34/ for test: kms_color_pipeline
results: parsing output: 35/ for test: api_intel_allocator
results: parsing output: 36/ for test: prime_self_import
results: parsing output: 37/ for test: kms_vblank
results: parsing output: 38/ for test: gem_exec_flush
results: parsing output: 39/ for test: perf
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: i915_pm_rps
results: parsing output: 42/ for test: gem_exec_balancer
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_mmap_gtt
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_chamelium_edid
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: gem_create
results: parsing output: 50/ for test: kms_getfb
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: api_intel_bb
results: parsing output: 54/ for test: kms_psr2_sf
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: kms_cursor_legacy
results: parsing output: 57/ for test: gem_mmap_offset
results: parsing output: 58/ for test: vgem_basic
results: parsing output: 59/ for test: kms_atomic
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: kms_ccs
results: parsing output: 64/ for test: gem_exec_fence
results: parsing output: 65/ for test: kms_pipe_stress
results: parsing output: 66/ for test: gem_sync
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: sw_sync
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_plane_scaling
results: parsing output: 73/ for test: kms_cursor_edge_walk
results: parsing output: 74/ for test: kms_joiner
results: parsing output: 75/ for test: gen9_exec_parse
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: sw_sync
results: parsing output: 78/ for test: gem_render_copy
results: parsing output: 79/ for test: gem_exec_schedule
results: parsing output: 80/ for test: gem_exec_whisper
results: parsing output: 81/ for test: kms_ccs
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: core_setmaster
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_sequence
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: syncobj_wait
results: parsing output: 89/ for test: syncobj_wait
results: parsing output: 90/ for test: kms_dsc
results: parsing output: 91/ for test: syncobj_wait
results: parsing output: 92/ for test: kms_content_protection
results: parsing output: 93/ for test: gem_exec_balancer
results: parsing output: 94/ for test: kms_ccs
results: parsing output: 95/ for test: i915_hangman
results: parsing output: 96/ for test: perf_pmu
results: parsing output: 97/ for test: gem_exec_parallel
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: sriov_basic
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_prop_blob
results: parsing output: 102/ for test: gem_userptr_blits
results: parsing output: 103/ for test: perf
results: parsing output: 104/ for test: i915_query
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_psr
results: parsing output: 107/ for test: prime_self_import
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: gem_exec_reloc
results: parsing output: 110/ for test: gem_ctx_shared
results: parsing output: 111/ for test: kms_plane_scaling
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_getfb
results: parsing output: 114/ for test: gem_ctx_persistence
results: parsing output: 115/ for test: i915_selftest
results: parsing output: 116/ for test: kms_pm_rpm
results: parsing output: 117/ for test: kms_cursor_crc
results: parsing output: 118/ for test: kms_cursor_crc
results: parsing output: 119/ for test: syncobj_wait
results: parsing output: 120/ for test: gem_mmap_gtt
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: kms_chamelium_hpd
results: parsing output: 123/ for test: gem_exec_reloc
results: parsing output: 124/ for test: kms_flip
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: gem_readwrite
results: parsing output: 127/ for test: fbdev
results: parsing output: 128/ for test: kms_dp_aux_dev
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: gem_ctx_persistence
results: parsing output: 131/ for test: sysfs_heartbeat_interval
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.