[58.219539] Initializing watchdogs
[58.219587]   /dev/watchdog0
[58.235326] [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]
[58.240184] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.242850] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.246443] [001/133] (960s left) gem_pxp (create-regular-buffer)
[58.413670] Starting subtest: create-regular-buffer
[58.416274] Subtest create-regular-buffer: SUCCESS (0.000s)
[58.532721] [002/133] (960s left) kms_pm_rpm (basic-pci-d3-state)
[60.411436] Starting subtest: basic-pci-d3-state
[61.895922] Subtest basic-pci-d3-state: SUCCESS (1.482s)
[62.013208] [003/133] (956s left) gem_wait (wait)
[62.080952] Starting subtest: wait
[62.083508] Starting dynamic subtest: all-engines
[63.293828] Dynamic subtest all-engines: SUCCESS (1.209s)
[63.304681] Starting dynamic subtest: rcs0
[64.337352] Dynamic subtest rcs0: SUCCESS (1.043s)
[64.347031] Starting dynamic subtest: bcs0
[65.384714] Dynamic subtest bcs0: SUCCESS (1.046s)
[65.393921] Starting dynamic subtest: vcs0
[66.429954] Dynamic subtest vcs0: SUCCESS (1.043s)
[66.441727] Starting dynamic subtest: vcs1
[67.473998] Dynamic subtest vcs1: SUCCESS (1.043s)
[67.483687] Starting dynamic subtest: vecs0
[68.517984] Dynamic subtest vecs0: SUCCESS (1.042s)
[68.527715] Starting dynamic subtest: ccs0
[69.563961] Dynamic subtest ccs0: SUCCESS (1.043s)
[69.568498] Subtest wait: SUCCESS (7.476s)
[69.778997] [004/133] (949s left) gem_exec_gttfill (engines)
[69.860154] Starting subtest: engines
[69.862540] Starting dynamic subtest: rcs0
[93.318048] Dynamic subtest rcs0: SUCCESS (23.450s)
[93.329137] Starting dynamic subtest: bcs0
[116.643058] Dynamic subtest bcs0: SUCCESS (23.322s)
[116.654465] Starting dynamic subtest: vcs0
[139.943367] Dynamic subtest vcs0: SUCCESS (23.299s)
[139.953960] Starting dynamic subtest: vcs1
[163.244396] Dynamic subtest vcs1: SUCCESS (23.301s)
[163.254108] Starting dynamic subtest: vecs0
[186.572545] Dynamic subtest vecs0: SUCCESS (23.327s)
[186.581091] Starting dynamic subtest: ccs0
[209.891241] Dynamic subtest ccs0: SUCCESS (23.317s)
[209.894031] Subtest engines: SUCCESS (140.020s)
[210.075364] [005/133] (808s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[210.226411] Starting subtest: fbcpsr-2p-rte
[210.230779] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[210.330226] [006/133] (808s left) kms_psr (fbc-pr-no-drrs)
[210.431724] Starting subtest: fbc-pr-no-drrs
[210.436356] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[210.502148] [007/133] (808s left) perf (gen12-group-concurrent-oa-buffer-read)
[210.661846] Starting subtest: gen12-group-concurrent-oa-buffer-read
[220.697972] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.037s)
[220.744261] [008/133] (798s left) gem_softpin (full)
[220.806065] Starting subtest: full
[220.814154] Subtest full: SUCCESS (0.008s)
[220.966145] [009/133] (798s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[221.057762] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[221.062392] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[221.131304] [010/133] (797s left) gem_mmap_gtt (basic-read)
[221.189997] Subtest basic-read: SKIP (0.000s)
[221.250531] [011/133] (797s left) kms_big_fb (linear-32bpp-rotate-180)
[221.353218] Starting subtest: linear-32bpp-rotate-180
[222.976566] Subtest linear-32bpp-rotate-180: SUCCESS (1.624s)
[223.110589] [012/133] (796s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[223.217844] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[223.221486] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[223.307909] [013/133] (795s left) gem_ctx_bad_destroy (invalid-ctx)
[223.363229] Starting subtest: invalid-ctx
[223.365188] Subtest invalid-ctx: SUCCESS (0.000s)
[223.431795] [014/133] (795s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[223.525054] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[223.551939] Starting dynamic subtest: pipe-A-plane-0
[223.842173] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[223.853444] Starting dynamic subtest: pipe-A-plane-3
[224.073916] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[224.082402] Starting dynamic subtest: pipe-A-plane-5
[224.085913] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[225.143593] Starting dynamic subtest: pipe-B-plane-0
[225.421894] Dynamic subtest pipe-B-plane-0: SUCCESS (0.289s)
[225.431968] Starting dynamic subtest: pipe-B-plane-3
[225.666317] Dynamic subtest pipe-B-plane-3: SUCCESS (0.244s)
[225.676812] Starting dynamic subtest: pipe-B-plane-5
[225.681373] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[225.997080] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.472s)
[226.821667] [015/133] (792s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[226.873201] Starting subtest: single-wait-for-submit-available-signaled
[226.875489] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[226.963286] [016/133] (792s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[227.052417] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[227.054618] Starting dynamic subtest: pipe-A-default-mode
[228.195193] Dynamic subtest pipe-A-default-mode: SKIP (1.140s)
[228.199479] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.141s)
[228.341265] [017/133] (791s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[228.408899] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[228.411410] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[228.523988] [018/133] (790s left) i915_drm_fdinfo (virtual-busy-all)
[228.575172] Starting subtest: virtual-busy-all
[228.579202] Subtest virtual-busy-all: SKIP (0.000s)
[228.645376] [019/133] (790s left) gem_exec_reloc (basic-gtt-read-noreloc)
[228.695682] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[228.763069] [020/133] (790s left) kms_lease (lease-invalid-connector)
[228.854853] Starting subtest: lease-invalid-connector
[228.857129] Starting dynamic subtest: pipe-A-eDP-1
[228.859208] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[228.867854] Starting dynamic subtest: pipe-B-eDP-1
[228.870063] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[228.878144] Starting dynamic subtest: pipe-C-eDP-1
[228.880421] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[228.889689] Starting dynamic subtest: pipe-D-eDP-1
[228.891811] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[228.893950] Subtest lease-invalid-connector: SUCCESS (0.003s)
[228.927996] [021/133] (790s left) gem_pxp (reject-modify-context-protection-off-3)
[229.031786] Starting subtest: reject-modify-context-protection-off-3
[229.034156] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[229.136711] [022/133] (790s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[229.234086] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[229.236076] Starting dynamic subtest: pipe-A-eDP-1
[229.284986] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[229.293043] Starting dynamic subtest: pipe-B-eDP-1
[229.340553] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[229.349063] Starting dynamic subtest: pipe-C-eDP-1
[229.393898] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[229.401822] Starting dynamic subtest: pipe-D-eDP-1
[229.446447] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[229.449856] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.008s)
[231.522752] [023/133] (788s left) gem_mmap_gtt (fault-concurrent)
[231.576332] Subtest fault-concurrent: SKIP (0.000s)
[231.644541] [024/133] (788s left) kms_addfb_basic (addfb25-4-tiled)
[231.740075] Starting subtest: addfb25-4-tiled
[231.742287] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[231.830426] [025/133] (787s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[231.923165] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[231.925612] Starting dynamic subtest: A-eDP1
[235.560256] Dynamic subtest A-eDP1: SUCCESS (3.633s)
[235.569718] Starting dynamic subtest: B-eDP1
[238.755821] Dynamic subtest B-eDP1: SUCCESS (3.194s)
[238.766136] Starting dynamic subtest: C-eDP1
[241.951229] Dynamic subtest C-eDP1: SUCCESS (3.195s)
[241.961681] Starting dynamic subtest: D-eDP1
[245.062966] Dynamic subtest D-eDP1: SUCCESS (3.112s)
[245.065320] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.141s)
[245.860235] [026/133] (773s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[245.985198] Starting subtest: flip-vs-cursor-busy-crc-legacy
[246.801165] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.813s)
[247.595942] [027/133] (772s left) syncobj_eventfd (timeline-wait-signaled)
[247.652728] Starting subtest: timeline-wait-signaled
[247.655091] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[247.758174] [028/133] (772s left) gem_exec_schedule (u-fairslice)
[247.835830] Starting subtest: u-fairslice
[247.838726] Starting dynamic subtest: rcs0
[249.848442] Dynamic subtest rcs0: SUCCESS (2.018s)
[249.858849] Starting dynamic subtest: bcs0
[251.865707] Dynamic subtest bcs0: SUCCESS (2.017s)
[251.877149] Starting dynamic subtest: vcs0
[253.889089] Dynamic subtest vcs0: SUCCESS (2.024s)
[253.901580] Starting dynamic subtest: vcs1
[255.910328] Dynamic subtest vcs1: SUCCESS (2.019s)
[255.920858] Starting dynamic subtest: vecs0
[257.929317] Dynamic subtest vecs0: SUCCESS (2.018s)
[257.940038] Starting dynamic subtest: ccs0
[259.948069] Dynamic subtest ccs0: SUCCESS (2.019s)
[259.950774] Subtest u-fairslice: SUCCESS (12.118s)
[260.262785] [029/133] (759s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[260.360234] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[260.362423] Starting dynamic subtest: pipe-A-default-mode
[263.134448] Dynamic subtest pipe-A-default-mode: SUCCESS (2.773s)
[263.136787] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.774s)
[264.003654] [030/133] (755s left) gem_exec_whisper (basic-sync-all)
[264.077408] Starting subtest: basic-sync-all
[270.532144] Subtest basic-sync-all: SUCCESS (6.454s)
[270.715690] [031/133] (749s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[270.772666] Starting subtest: etime-multi-wait-available-unsubmitted
[270.881791] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.108s)
[270.958653] [032/133] (748s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[271.058404] Starting subtest: random-ccs-data-y-tiled-ccs
[271.060737] Starting dynamic subtest: pipe-A-eDP-1
[271.085780] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[271.097091] Starting dynamic subtest: pipe-B-eDP-1
[271.120816] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[271.129509] Starting dynamic subtest: pipe-C-eDP-1
[271.153298] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[271.161952] Starting dynamic subtest: pipe-D-eDP-1
[271.187404] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[271.191944] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.003s)
[273.359514] [033/133] (746s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[273.446164] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[273.448476] Starting dynamic subtest: pipe-A-eDP-1
[273.469256] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[273.480202] Starting dynamic subtest: pipe-B-eDP-1
[273.500021] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[273.508766] Starting dynamic subtest: pipe-C-eDP-1
[273.528576] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[273.537313] Starting dynamic subtest: pipe-D-eDP-1
[273.557210] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[273.559491] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[275.715023] [034/133] (744s left) kms_addfb_basic (basic)
[275.768588] Starting subtest: basic
[275.770695] Subtest basic: SUCCESS (0.000s)
[275.907398] [035/133] (744s left) kms_color_pipeline (plane-lut1d-lut1d)
[276.003736] Starting subtest: plane-lut1d-lut1d
[276.172146] Starting dynamic subtest: pipe-A-plane-0
[276.373849] Dynamic subtest pipe-A-plane-0: SUCCESS (0.200s)
[276.385497] Starting dynamic subtest: pipe-A-plane-1
[276.538701] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[276.548849] Starting dynamic subtest: pipe-A-plane-2
[276.705348] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[277.949365] Starting dynamic subtest: pipe-B-plane-0
[278.143687] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s)
[278.152801] Starting dynamic subtest: pipe-B-plane-1
[278.331998] Dynamic subtest pipe-B-plane-1: SUCCESS (0.189s)
[278.342322] Starting dynamic subtest: pipe-B-plane-2
[278.519657] Dynamic subtest pipe-B-plane-2: SUCCESS (0.188s)
[279.779901] Starting dynamic subtest: pipe-C-plane-0
[279.927839] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[279.937207] Starting dynamic subtest: pipe-C-plane-1
[280.094130] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[280.103632] Starting dynamic subtest: pipe-C-plane-2
[280.261273] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[281.509980] Starting dynamic subtest: pipe-D-plane-0
[281.668425] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s)
[281.677454] Starting dynamic subtest: pipe-D-plane-1
[281.834842] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[281.844816] Starting dynamic subtest: pipe-D-plane-2
[282.001564] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[282.292540] Subtest plane-lut1d-lut1d: SUCCESS (6.290s)
[283.161564] [036/133] (736s left) api_intel_allocator (standalone)
[283.217793] Starting subtest: standalone
[283.230826] Subtest standalone: SUCCESS (0.015s)
[283.350158] [037/133] (736s left) prime_self_import (basic-llseek-bad)
[283.385317] Starting subtest: basic-llseek-bad
[283.396390] Subtest basic-llseek-bad: SUCCESS (0.016s)
[283.509982] [038/133] (736s left) kms_vblank (query-forked)
[283.607539] Starting subtest: query-forked
[283.609631] Starting dynamic subtest: pipe-A-eDP-1
[285.428029] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.818s)
[285.443753] Starting dynamic subtest: pipe-D-eDP-1
[287.969426] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.537s)
[287.971474] Subtest query-forked: SUCCESS (4.361s)
[288.819422] [039/133] (731s left) gem_exec_flush (basic-uc-ro-default)
[288.882263] Starting subtest: basic-uc-ro-default
[294.340449] Subtest basic-uc-ro-default: SUCCESS (5.459s)
[294.522937] [040/133] (725s left) perf (per-context-mode-unprivileged)
[294.614164] Starting subtest: per-context-mode-unprivileged
[294.619029] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[294.660463] [041/133] (725s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[294.754593] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[294.758743] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[294.846421] [042/133] (725s left) i915_pm_rps (min-max-config-idle)
[294.912275] Starting subtest: min-max-config-idle
[294.916740] Subtest min-max-config-idle: SKIP (0.000s)
[295.012300] [043/133] (725s left) gem_exec_balancer (busy)
[295.085854] Starting subtest: busy
[296.315507] Subtest busy: SUCCESS (1.230s)
[296.641362] [044/133] (723s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[296.737868] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[296.742079] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[296.831642] [045/133] (723s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[296.938118] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[296.942110] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[297.045381] [046/133] (723s left) gem_mmap_gtt (big-bo-tiledy)
[297.103204] Subtest big-bo-tiledY: SKIP (0.000s)
[297.155275] [047/133] (723s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[297.253604] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[304.643216] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.392s)
[304.777328] [048/133] (715s left) kms_chamelium_edid (vga-edid-read)
[305.172970] Subtest vga-edid-read: SKIP (0.000s)
[305.977157] [049/133] (714s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[306.077341] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[313.056829] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.981s)
[313.204267] [050/133] (707s left) gem_create (hog-create)
[313.274793] Starting subtest: hog-create
[313.276594] Starting dynamic subtest: smem0
[347.267398] Dynamic subtest smem0: SUCCESS (33.992s)
[347.269921] Subtest hog-create: SUCCESS (33.993s)
[347.448385] [051/133] (673s left) kms_getfb (getfb-repeated-different-handles)
[347.545735] Starting subtest: getfb-repeated-different-handles
[347.547879] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[347.649615] [052/133] (673s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[347.746562] Starting subtest: y-tiled-64bpp-rotate-0
[347.750804] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[347.839427] [053/133] (672s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[347.940667] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[347.945247] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[348.032341] [054/133] (672s left) api_intel_bb (simple-bb)
[348.092283] Starting subtest: simple-bb
[348.098067] Subtest simple-bb: SUCCESS (0.006s)
[348.228702] [055/133] (672s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[348.328330] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[348.332765] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[348.396458] [056/133] (672s left) kms_flip (blocking-wf_vblank)
[348.500625] Starting subtest: blocking-wf_vblank
[348.502621] Starting dynamic subtest: A-eDP1
[357.466083] Dynamic subtest A-eDP1: SUCCESS (8.964s)
[357.475725] Starting dynamic subtest: B-eDP1
[366.392015] Dynamic subtest B-eDP1: SUCCESS (8.925s)
[366.409732] Starting dynamic subtest: C-eDP1
[375.314353] Dynamic subtest C-eDP1: SUCCESS (8.917s)
[375.327052] Starting dynamic subtest: D-eDP1
[384.242043] Dynamic subtest D-eDP1: SUCCESS (8.927s)
[384.244529] Subtest blocking-wf_vblank: SUCCESS (35.744s)
[385.463548] [057/133] (635s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[385.582486] Starting subtest: cursorA-vs-flipB-atomic-transitions
[385.587078] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[385.730238] [058/133] (635s left) gem_mmap_offset (bad-flags)
[385.790891] Starting subtest: bad-flags
[385.792932] Subtest bad-flags: SUCCESS (0.000s)
[385.884364] [059/133] (635s left) vgem_basic (create)
[386.003234] Starting subtest: create
[386.005463] Subtest create: SUCCESS (0.000s)
[386.057914] [FACT vgem_basic (create)] new: kernel.kmod_is_loaded.vgem: true
[386.061259] [060/133] (635s left) kms_atomic (plane-primary-legacy)
[386.146786] Starting subtest: plane-primary-legacy
[386.149121] Starting dynamic subtest: pipe-A-eDP-1
[386.593409] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.444s)
[386.595309] Subtest plane-primary-legacy: SUCCESS (0.446s)
[387.400343] [061/133] (633s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[387.494448] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[387.499082] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[387.619766] [062/133] (633s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[387.668077] Starting subtest: invalid-single-wait-unsubmitted
[387.670475] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[387.765297] [063/133] (633s left) kms_psr (psr-cursor-render)
[387.848872] Starting subtest: psr-cursor-render
[387.851152] Starting dynamic subtest: eDP-1
[389.601564] Dynamic subtest eDP-1: SUCCESS (1.752s)
[389.603713] Subtest psr-cursor-render: SUCCESS (1.753s)
[390.487501] [064/133] (630s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[390.576034] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[390.578335] Starting dynamic subtest: pipe-A-eDP-1
[390.600771] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[390.612076] Starting dynamic subtest: pipe-B-eDP-1
[390.633478] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[390.642247] Starting dynamic subtest: pipe-C-eDP-1
[390.663480] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[390.672193] Starting dynamic subtest: pipe-D-eDP-1
[390.694208] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[390.698232] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[392.848764] [065/133] (628s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[393.392665] Starting subtest: syncobj-timeline-invalid-flags
[393.395066] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[394.383458] [066/133] (626s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[394.477745] Starting subtest: stress-xrgb8888-ytiled
[394.482229] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[394.558104] [067/133] (626s left) gem_sync (basic-each)
[394.639174] Starting subtest: basic-each
[396.853734] Subtest basic-each: SUCCESS (2.225s)
[397.044442] [068/133] (624s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[397.141338] Starting subtest: x-tiled-8bpp-rotate-0
[398.355546] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.215s)
[398.491634] [069/133] (623s left) sw_sync (sync_expired_merge)
[398.533926] Starting subtest: sync_expired_merge
[399.608638] Subtest sync_expired_merge: SUCCESS (1.074s)
[399.683633] [070/133] (621s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[399.783352] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[404.380034] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.601s)
[405.531925] [071/133] (616s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[405.625795] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[405.629972] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[405.738416] [072/133] (615s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[405.845905] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[405.850168] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[405.954385] [073/133] (615s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[406.042871] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[406.045183] Starting dynamic subtest: pipe-A
[407.215318] Dynamic subtest pipe-A: SUCCESS (1.174s)
[407.225885] Starting dynamic subtest: pipe-B
[409.459299] Dynamic subtest pipe-B: SUCCESS (2.242s)
[409.475147] Starting dynamic subtest: pipe-C
[410.627389] Dynamic subtest pipe-C: SUCCESS (1.167s)
[410.636921] Starting dynamic subtest: pipe-D
[411.868677] Dynamic subtest pipe-D: SUCCESS (1.239s)
[411.870868] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.827s)
[413.060362] [074/133] (608s left) kms_cursor_edge_walk (64x64-top-bottom)
[413.157247] Starting subtest: 64x64-top-bottom
[413.159622] Starting dynamic subtest: pipe-A-eDP-1
[416.632187] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.474s)
[416.644371] Starting dynamic subtest: pipe-D-eDP-1
[419.764050] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.131s)
[419.766414] Subtest 64x64-top-bottom: SUCCESS (6.608s)
[420.585129] [075/133] (601s left) kms_joiner (basic-ultra-joiner)
[420.676274] Starting subtest: basic-ultra-joiner
[420.680146] Subtest basic-ultra-joiner: SKIP (0.000s)
[420.742179] [076/133] (601s left) gen9_exec_parse (bb-start-param)
[420.801370] Subtest bb-start-param: SKIP (0.000s)
[420.884875] [077/133] (600s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[420.984452] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[427.893617] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.911s)
[428.033533] [078/133] (593s left) sw_sync (sync_multi_consumer)
[428.076060] Starting subtest: sync_multi_consumer
[428.506154] Subtest sync_multi_consumer: SUCCESS (0.429s)
[428.581025] [079/133] (593s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[428.633099] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[428.637539] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[428.817346] [080/133] (593s left) gem_exec_schedule (pi-common)
[428.996830] Starting subtest: pi-common
[428.998802] Starting dynamic subtest: rcs0
[429.022701] Dynamic subtest rcs0: SUCCESS (0.028s)
[429.035467] Starting dynamic subtest: bcs0
[429.054285] Dynamic subtest bcs0: SUCCESS (0.031s)
[429.068230] Starting dynamic subtest: vcs0
[429.082932] Dynamic subtest vcs0: SUCCESS (0.027s)
[429.097345] Starting dynamic subtest: vcs1
[429.108282] Dynamic subtest vcs1: SUCCESS (0.025s)
[429.122122] Starting dynamic subtest: vecs0
[429.135174] Dynamic subtest vecs0: SUCCESS (0.026s)
[429.148863] Starting dynamic subtest: ccs0
[429.162296] Dynamic subtest ccs0: SUCCESS (0.026s)
[429.164523] Subtest pi-common: SUCCESS (0.168s)
[429.406291] [081/133] (592s left) gem_exec_whisper (basic-contexts-all)
[429.460564] Starting subtest: basic-contexts-all
[441.029889] Subtest basic-contexts-all: SUCCESS (11.567s)
[441.217991] [082/133] (580s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[441.304335] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[441.306236] Starting dynamic subtest: pipe-A-eDP-1
[441.327100] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.023s)
[441.338747] Starting dynamic subtest: pipe-B-eDP-1
[441.358499] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.023s)
[441.369230] Starting dynamic subtest: pipe-C-eDP-1
[441.388545] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.023s)
[441.398414] Starting dynamic subtest: pipe-D-eDP-1
[441.418830] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[441.421076] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.096s)
[443.653199] [083/133] (578s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[443.756605] Starting subtest: psr-rgb101010-draw-blt
[451.153035] Subtest psr-rgb101010-draw-blt: SUCCESS (7.401s)
[451.271830] [084/133] (570s left) core_setmaster (master-drop-set-shared-fd)
[451.349937] Starting subtest: master-drop-set-shared-fd
[451.371335] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[451.410458] [085/133] (570s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[451.506029] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[458.324238] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.821s)
[458.463603] [086/133] (563s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[458.569915] Starting subtest: psr-rgb565-draw-render
[465.595351] Subtest psr-rgb565-draw-render: SUCCESS (7.030s)
[465.746874] [087/133] (556s left) kms_sequence (get-forked-busy)
[465.840117] Starting subtest: get-forked-busy
[465.841930] Starting dynamic subtest: pipe-A-eDP-1
[467.781535] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.941s)
[467.791667] Starting dynamic subtest: pipe-B-eDP-1
[470.355715] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.571s)
[470.365682] Starting dynamic subtest: pipe-C-eDP-1
[472.967900] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.611s)
[472.978766] Starting dynamic subtest: pipe-D-eDP-1
[475.528987] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.561s)
[475.531332] Subtest get-forked-busy: SUCCESS (9.690s)
[476.399510] [088/133] (545s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[476.502129] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[476.506154] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[476.594476] [089/133] (545s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[476.649088] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[476.651313] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[476.743679] [090/133] (545s left) syncobj_wait (single-wait-for-submit-signaled)
[476.801203] Starting subtest: single-wait-for-submit-signaled
[476.803311] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[476.897630] [091/133] (545s left) kms_dsc (dsc-fractional-bpp)
[476.979629] Starting subtest: dsc-fractional-bpp
[476.992376] Subtest dsc-fractional-bpp: SKIP (0.000s)
[477.055409] [092/133] (545s left) syncobj_wait (wait-all-snapshot)
[477.113488] Starting subtest: wait-all-snapshot
[477.193807] Subtest wait-all-snapshot: SUCCESS (0.081s)
[477.285182] [093/133] (545s left) kms_content_protection (legacy-hdcp14)
[477.419263] Starting subtest: legacy-hdcp14
[477.422577] Subtest legacy-hdcp14: SKIP (0.000s)
[477.544264] [094/133] (544s left) gem_exec_balancer (waits)
[477.594056] Starting subtest: waits
[484.129942] Subtest waits: SUCCESS (6.533s)
[484.443928] [095/133] (538s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[484.546437] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[484.548643] Starting dynamic subtest: pipe-A-eDP-1
[484.557769] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[484.569891] Starting dynamic subtest: pipe-B-eDP-1
[484.579242] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[484.589242] Starting dynamic subtest: pipe-C-eDP-1
[484.597608] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[484.606654] Starting dynamic subtest: pipe-D-eDP-1
[484.615216] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[484.619301] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[486.880867] [096/133] (535s left) i915_hangman (engine-error-state-capture)
[486.948992] Starting subtest: engine-error-state-capture
[486.951278] Starting dynamic subtest: rcs0
[490.268595] Dynamic subtest rcs0: SUCCESS (3.318s)
[490.281465] Starting dynamic subtest: bcs0
[496.285082] Dynamic subtest bcs0: SUCCESS (6.013s)
[496.299170] Starting dynamic subtest: vcs0
[502.236586] Dynamic subtest vcs0: SUCCESS (5.948s)
[502.248639] Starting dynamic subtest: vcs1
[508.252396] Dynamic subtest vcs1: SUCCESS (6.013s)
[508.264781] Starting dynamic subtest: vecs0
[514.203707] Dynamic subtest vecs0: SUCCESS (5.949s)
[514.216361] Starting dynamic subtest: ccs0
[519.261753] Dynamic subtest ccs0: SUCCESS (5.055s)
[519.264914] Subtest engine-error-state-capture: SUCCESS (32.313s)
[519.343795] [097/133] (503s left) perf_pmu (rc6-suspend)
[519.388120] Starting subtest: rc6-suspend
[542.002479] Subtest rc6-suspend: SUCCESS (7.672s)
[542.897824] [098/133] (479s left) gem_exec_parallel (basic)
[542.986460] Starting subtest: basic
[542.988792] Starting dynamic subtest: rcs0
[544.443355] Dynamic subtest rcs0: SUCCESS (1.452s)
[544.455556] Starting dynamic subtest: bcs0
[545.865112] Dynamic subtest bcs0: SUCCESS (1.414s)
[545.876496] Starting dynamic subtest: vcs0
[549.213083] Dynamic subtest vcs0: SUCCESS (3.330s)
[549.226614] Starting dynamic subtest: vcs1
[551.195268] Dynamic subtest vcs1: SUCCESS (1.974s)
[551.211081] Starting dynamic subtest: vecs0
[553.243959] Dynamic subtest vecs0: SUCCESS (2.041s)
[553.266480] Starting dynamic subtest: ccs0
[554.759408] Dynamic subtest ccs0: SUCCESS (1.510s)
[554.761842] Subtest basic: SUCCESS (11.736s)
[554.975656] [099/133] (467s left) kms_psr (psr-primary-blt)
[555.070984] Starting subtest: psr-primary-blt
[555.073233] Starting dynamic subtest: eDP-1
[556.842020] Dynamic subtest eDP-1: SUCCESS (1.769s)
[556.844030] Subtest psr-primary-blt: SUCCESS (1.770s)
[557.708041] [100/133] (465s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[557.762002] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[557.842627] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.026s)
[557.883130] [101/133] (464s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[557.978893] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[561.617766] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.638s)
[562.823859] [102/133] (460s left) kms_prop_blob (blob-prop-lifetime)
[562.875370] Starting subtest: blob-prop-lifetime
[562.877529] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[562.990140] [103/133] (459s left) gem_userptr_blits (readonly-unsync)
[563.062482] Subtest readonly-unsync: SKIP (0.000s)
[563.199022] [104/133] (459s left) perf (polling)
[563.289340] Starting subtest: polling
[563.292117] Starting dynamic subtest: 0-rcs0
[573.310333] Dynamic subtest 0-rcs0: SUCCESS (10.012s)
[573.329460] Starting dynamic subtest: 1-vecs0
[583.331605] Dynamic subtest 1-vecs0: SUCCESS (10.021s)
[583.334740] Subtest polling: SUCCESS (20.036s)
[583.384355] [105/133] (439s left) i915_query (query-topology-kernel-writes)
[583.436176] Starting subtest: query-topology-kernel-writes
[583.438607] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[583.522890] [106/133] (439s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[583.624859] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[584.682095] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.058s)
[584.818273] [107/133] (438s left) kms_psr (fbc-pr-sprite-blt)
[584.906711] Starting subtest: fbc-pr-sprite-blt
[584.910359] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[584.981760] [108/133] (438s left) prime_self_import (basic-with_two_bos)
[585.017719] Starting subtest: basic-with_two_bos
[585.029939] Subtest basic-with_two_bos: SUCCESS (0.015s)
[585.141866] [109/133] (438s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[585.236048] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[586.350010] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.113s)
[586.463454] [110/133] (436s left) gem_exec_reloc (basic-cpu-read)
[586.518849] Subtest basic-cpu-read: SKIP (0.000s)
[586.589758] [111/133] (436s left) gem_ctx_shared (exec-shared-gtt)
[586.651024] Starting subtest: exec-shared-gtt
[586.653018] Starting dynamic subtest: rcs0
[586.660213] Dynamic subtest rcs0: SUCCESS (0.009s)
[586.671125] Starting dynamic subtest: bcs0
[586.673013] Dynamic subtest bcs0: SUCCESS (0.006s)
[586.683576] Starting dynamic subtest: vcs0
[586.685136] Dynamic subtest vcs0: SUCCESS (0.006s)
[586.698106] Starting dynamic subtest: vcs1
[586.700032] Dynamic subtest vcs1: SUCCESS (0.007s)
[586.710487] Starting dynamic subtest: vecs0
[586.712032] Dynamic subtest vecs0: SUCCESS (0.007s)
[586.721939] Starting dynamic subtest: ccs0
[586.723540] Dynamic subtest ccs0: SUCCESS (0.009s)
[586.725111] Subtest exec-shared-gtt: SUCCESS (0.047s)
[586.885567] [112/133] (436s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[586.967542] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[586.969381] Starting dynamic subtest: pipe-A
[586.988830] Dynamic subtest pipe-A: SKIP (0.019s)
[587.000286] Starting dynamic subtest: pipe-B
[587.024115] Dynamic subtest pipe-B: SKIP (0.034s)
[587.034875] Starting dynamic subtest: pipe-C
[587.060355] Dynamic subtest pipe-C: SKIP (0.034s)
[587.071053] Starting dynamic subtest: pipe-D
[587.095145] Dynamic subtest pipe-D: SKIP (0.035s)
[587.098410] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.124s)
[587.204745] [113/133] (436s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[587.289470] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[594.662783] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.376s)
[594.812092] [114/133] (428s left) kms_getfb (getfb-handle-protection)
[594.904125] Starting subtest: getfb-handle-protection
[594.939923] Subtest getfb-handle-protection: SUCCESS (0.036s)
[595.087021] [115/133] (428s left) gem_ctx_persistence (process)
[595.150509] Starting subtest: process
[595.337219] Subtest process: SUCCESS (0.186s)
[595.433853] [116/133] (428s left) i915_selftest (mock)
[600.064947] Starting subtest: mock
[600.067737] Starting dynamic subtest: sanitycheck
[600.802138] Dynamic subtest sanitycheck: SUCCESS (0.741s)
[600.813615] Starting dynamic subtest: shmem
[601.510378] Dynamic subtest shmem: SUCCESS (0.706s)
[601.521881] Starting dynamic subtest: fence
[609.343039] Dynamic subtest fence: SUCCESS (7.827s)
[609.353957] Starting dynamic subtest: scatterlist
[611.040813] Dynamic subtest scatterlist: SUCCESS (1.696s)
[611.051268] Starting dynamic subtest: syncmap
[614.183750] Dynamic subtest syncmap: SUCCESS (3.140s)
[614.194511] Starting dynamic subtest: uncore
[614.854684] Dynamic subtest uncore: SUCCESS (0.669s)
[614.866260] Starting dynamic subtest: ring
[615.568623] Dynamic subtest ring: SUCCESS (0.712s)
[615.579499] Starting dynamic subtest: engine
[616.265702] Dynamic subtest engine: SUCCESS (0.695s)
[616.276870] Starting dynamic subtest: timelines
[620.167644] Dynamic subtest timelines: SUCCESS (3.898s)
[620.179152] Starting dynamic subtest: requests
[624.276844] Dynamic subtest requests: SUCCESS (4.106s)
[624.288395] Starting dynamic subtest: objects
[625.081933] Dynamic subtest objects: SUCCESS (0.803s)
[625.098812] Starting dynamic subtest: phys
[625.890926] Dynamic subtest phys: SUCCESS (0.806s)
[625.902023] Starting dynamic subtest: dmabuf
[626.674826] Dynamic subtest dmabuf: SUCCESS (0.782s)
[626.686171] Starting dynamic subtest: vma
[632.474885] Dynamic subtest vma: SUCCESS (5.796s)
[632.486802] Starting dynamic subtest: evict
[633.922068] Dynamic subtest evict: SUCCESS (1.445s)
[633.933058] Starting dynamic subtest: gtt
[637.271461] Dynamic subtest gtt: SUCCESS (3.346s)
[637.282900] Starting dynamic subtest: hugepages
[638.226474] Dynamic subtest hugepages: SUCCESS (0.954s)
[638.237097] Starting dynamic subtest: memory_region
[640.850730] Dynamic subtest memory_region: SUCCESS (2.624s)
[640.853339] Subtest mock: SUCCESS (40.779s)
[640.881148] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[640.881869] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[640.884998] [117/133] (382s left) kms_pm_rpm (legacy-planes-dpms)
[650.477625] Starting subtest: legacy-planes-dpms
[650.480682] Starting dynamic subtest: plane-65
[658.786338] Dynamic subtest plane-65: SUCCESS (8.309s)
[658.800266] Starting dynamic subtest: plane-95
[667.102067] Dynamic subtest plane-95: SUCCESS (8.313s)
[667.115403] Starting dynamic subtest: plane-125
[675.535226] Dynamic subtest plane-125: SUCCESS (8.430s)
[675.548596] Starting dynamic subtest: plane-135
[683.851783] Dynamic subtest plane-135: SUCCESS (8.313s)
[683.854648] Subtest legacy-planes-dpms: SUCCESS (33.376s)
[684.256205] [FACT kms_pm_rpm (legacy-planes-dpms)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[684.257544] [FACT kms_pm_rpm (legacy-planes-dpms)] new: kernel.kmod_is_loaded.i915: true
[684.261621] [118/133] (339s left) kms_cursor_crc (cursor-random-32x10)
[684.428767] Starting subtest: cursor-random-32x10
[684.487865] Subtest cursor-random-32x10: SKIP (0.054s)
[684.760663] [119/133] (338s left) kms_cursor_crc (cursor-offscreen-32x32)
[684.901506] Starting subtest: cursor-offscreen-32x32
[684.954473] Subtest cursor-offscreen-32x32: SKIP (0.052s)
[685.238595] [120/133] (338s left) syncobj_wait (single-wait-all-for-submit-submitted)
[685.300269] Starting subtest: single-wait-all-for-submit-submitted
[685.408743] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.107s)
[685.488481] [121/133] (338s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[685.550771] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[685.613168] [122/133] (338s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[685.656914] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[685.659141] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[685.754977] [123/133] (338s left) kms_chamelium_hpd (hdmi-hpd)
[686.139940] Subtest hdmi-hpd: SKIP (0.000s)
[686.935062] [124/133] (336s left) gem_exec_reloc (basic-gtt-noreloc)
[686.996623] Subtest basic-gtt-noreloc: SKIP (0.000s)
[687.070902] [125/133] (336s left) kms_flip (2x-wf_vblank-ts-check)
[687.160788] Starting subtest: 2x-wf_vblank-ts-check
[687.170858] Subtest 2x-wf_vblank-ts-check: SKIP (0.011s)
[687.252229] [126/133] (336s left) kms_psr (pr-primary-mmap-cpu)
[687.340563] Starting subtest: pr-primary-mmap-cpu
[687.345028] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[687.417730] [127/133] (336s left) gem_readwrite (read-write)
[687.471590] Subtest read-write: SKIP (0.000s)
[687.531381] [128/133] (336s left) fbdev (write)
[687.572777] Starting subtest: write
[687.935262] Subtest write: SUCCESS (0.363s)
[688.002230] [129/133] (336s left) kms_dp_aux_dev (basic)
[688.058175] Starting subtest: basic
[688.281470] Subtest basic: SUCCESS (0.224s)
[688.354446] [130/133] (335s left) kms_psr (fbc-psr2-sprite-render)
[688.458326] Starting subtest: fbc-psr2-sprite-render
[688.460706] Starting dynamic subtest: eDP-1
[688.465038] Dynamic subtest eDP-1: SKIP (0.000s)
[688.469404] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[688.536857] [131/133] (335s left) gem_ctx_persistence (engines-cleanup)
[688.593868] Starting subtest: engines-cleanup
[688.596181] Starting dynamic subtest: rcs0
[688.675355] Dynamic subtest rcs0: SUCCESS (0.081s)
[688.689325] Starting dynamic subtest: bcs0
[688.719836] Dynamic subtest bcs0: SUCCESS (0.043s)
[688.730737] Starting dynamic subtest: vcs0
[688.766396] Dynamic subtest vcs0: SUCCESS (0.044s)
[688.778692] Starting dynamic subtest: vcs1
[688.817186] Dynamic subtest vcs1: SUCCESS (0.049s)
[688.832257] Starting dynamic subtest: vecs0
[688.855816] Dynamic subtest vecs0: SUCCESS (0.036s)
[688.870140] Starting dynamic subtest: ccs0
[688.897878] Dynamic subtest ccs0: SUCCESS (0.040s)
[688.900195] Subtest engines-cleanup: SUCCESS (0.306s)
[688.981827] [132/133] (335s left) sysfs_heartbeat_interval (idempotent)
[689.042848] Starting subtest: idempotent
[689.045178] Starting dynamic subtest: vecs0
[689.047455] Dynamic subtest vecs0: SUCCESS (0.001s)
[689.059647] Starting dynamic subtest: ccs0
[689.061891] Dynamic subtest ccs0: SUCCESS (0.002s)
[689.071779] Starting dynamic subtest: vcs0
[689.074028] Dynamic subtest vcs0: SUCCESS (0.001s)
[689.083748] Starting dynamic subtest: bcs0
[689.086004] Dynamic subtest bcs0: SUCCESS (0.001s)
[689.096222] Starting dynamic subtest: rcs0
[689.098159] Dynamic subtest rcs0: SUCCESS (0.000s)
[689.108390] Starting dynamic subtest: vcs1
[689.110590] Dynamic subtest vcs1: SUCCESS (0.001s)
[689.112844] Subtest idempotent: SUCCESS (0.009s)
[689.154944] [133/133] (335s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[689.251199] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[696.371008] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.120s)
[696.468998] 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.