[58.593288] Initializing watchdogs
[58.593421]   /dev/watchdog0
[58.610324] [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.614726] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.617060] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.620262] [001/133] (960s left) gem_pxp (create-regular-buffer)
[58.782449] Starting subtest: create-regular-buffer
[58.784904] Subtest create-regular-buffer: SUCCESS (0.000s)
[58.909516] [002/133] (960s left) kms_pm_rpm (basic-pci-d3-state)
[60.463036] Starting subtest: basic-pci-d3-state
[61.943701] Subtest basic-pci-d3-state: SUCCESS (1.486s)
[62.032777] [003/133] (957s left) gem_wait (wait)
[62.095652] Starting subtest: wait
[62.098208] Starting dynamic subtest: all-engines
[63.329346] Dynamic subtest all-engines: SUCCESS (1.236s)
[63.339796] Starting dynamic subtest: rcs0
[64.374669] Dynamic subtest rcs0: SUCCESS (1.048s)
[64.384844] Starting dynamic subtest: bcs0
[65.421938] Dynamic subtest bcs0: SUCCESS (1.048s)
[65.431732] Starting dynamic subtest: vcs0
[66.467072] Dynamic subtest vcs0: SUCCESS (1.046s)
[66.475675] Starting dynamic subtest: vcs1
[67.511759] Dynamic subtest vcs1: SUCCESS (1.045s)
[67.521436] Starting dynamic subtest: vecs0
[68.553985] Dynamic subtest vecs0: SUCCESS (1.043s)
[68.563761] Starting dynamic subtest: ccs0
[69.601690] Dynamic subtest ccs0: SUCCESS (1.047s)
[69.604276] Subtest wait: SUCCESS (7.520s)
[69.797696] [004/133] (949s left) gem_exec_gttfill (engines)
[69.853871] Starting subtest: engines
[69.856324] Starting dynamic subtest: rcs0
[93.234482] Dynamic subtest rcs0: SUCCESS (23.386s)
[93.245297] Starting dynamic subtest: bcs0
[116.549769] Dynamic subtest bcs0: SUCCESS (23.313s)
[116.558726] Starting dynamic subtest: vcs0
[139.845400] Dynamic subtest vcs0: SUCCESS (23.295s)
[139.855850] Starting dynamic subtest: vcs1
[163.206361] Dynamic subtest vcs1: SUCCESS (23.357s)
[163.217066] Starting dynamic subtest: vecs0
[186.514383] Dynamic subtest vecs0: SUCCESS (23.305s)
[186.525698] Starting dynamic subtest: ccs0
[209.870449] Dynamic subtest ccs0: SUCCESS (23.353s)
[209.872937] Subtest engines: SUCCESS (140.017s)
[210.062424] [005/133] (809s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[210.208308] Starting subtest: fbcpsr-2p-rte
[210.212459] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[210.300599] [006/133] (809s left) kms_psr (fbc-pr-no-drrs)
[210.402201] Starting subtest: fbc-pr-no-drrs
[210.406223] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[210.470998] [007/133] (808s left) perf (gen12-group-concurrent-oa-buffer-read)
[210.608920] Starting subtest: gen12-group-concurrent-oa-buffer-read
[220.649809] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.040s)
[220.695172] [008/133] (798s left) gem_softpin (full)
[220.751136] Starting subtest: full
[220.759022] Subtest full: SUCCESS (0.007s)
[220.872641] [009/133] (798s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[220.970842] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[220.975124] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[221.055730] [010/133] (798s left) gem_mmap_gtt (basic-read)
[221.115322] Subtest basic-read: SKIP (0.000s)
[221.172080] [011/133] (798s left) kms_big_fb (linear-32bpp-rotate-180)
[221.268070] Starting subtest: linear-32bpp-rotate-180
[222.912467] Subtest linear-32bpp-rotate-180: SUCCESS (1.645s)
[223.042890] [012/133] (796s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[223.157274] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[223.160718] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[223.233806] [013/133] (796s left) gem_ctx_bad_destroy (invalid-ctx)
[223.287791] Starting subtest: invalid-ctx
[223.290059] Subtest invalid-ctx: SUCCESS (0.000s)
[223.359873] [014/133] (796s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[223.456040] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[223.482950] Starting dynamic subtest: pipe-A-plane-0
[223.772541] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[223.782102] Starting dynamic subtest: pipe-A-plane-3
[224.006138] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[224.013866] Starting dynamic subtest: pipe-A-plane-5
[224.017540] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[225.145256] Starting dynamic subtest: pipe-B-plane-0
[225.437259] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[225.446657] Starting dynamic subtest: pipe-B-plane-3
[225.704747] Dynamic subtest pipe-B-plane-3: SUCCESS (0.266s)
[225.713401] Starting dynamic subtest: pipe-B-plane-5
[225.717534] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[226.026514] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.570s)
[226.827221] [015/133] (792s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[226.885684] Starting subtest: single-wait-for-submit-available-signaled
[226.888082] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.001s)
[227.008523] [016/133] (792s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[227.100666] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[227.103067] Starting dynamic subtest: pipe-A-default-mode
[228.294686] Dynamic subtest pipe-A-default-mode: SKIP (1.190s)
[228.299193] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.192s)
[228.438350] [017/133] (791s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[228.492969] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[228.495395] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[228.603877] [018/133] (791s left) i915_drm_fdinfo (virtual-busy-all)
[228.651838] Starting subtest: virtual-busy-all
[228.656340] Subtest virtual-busy-all: SKIP (0.000s)
[228.726786] [019/133] (791s left) gem_exec_reloc (basic-gtt-read-noreloc)
[228.804326] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[228.887455] [020/133] (790s left) kms_lease (lease-invalid-connector)
[228.997134] Starting subtest: lease-invalid-connector
[228.999417] Starting dynamic subtest: pipe-A-eDP-1
[229.001562] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[229.009949] Starting dynamic subtest: pipe-B-eDP-1
[229.012115] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[229.019792] Starting dynamic subtest: pipe-C-eDP-1
[229.021637] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[229.029796] Starting dynamic subtest: pipe-D-eDP-1
[229.031971] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[229.034250] Subtest lease-invalid-connector: SUCCESS (0.003s)
[229.069033] [021/133] (790s left) gem_pxp (reject-modify-context-protection-off-3)
[229.182525] Starting subtest: reject-modify-context-protection-off-3
[229.184457] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[229.284790] [022/133] (790s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[229.381523] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[229.383474] Starting dynamic subtest: pipe-A-eDP-1
[229.432476] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[229.442321] Starting dynamic subtest: pipe-B-eDP-1
[229.488645] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[229.497931] Starting dynamic subtest: pipe-C-eDP-1
[229.547628] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[229.556457] Starting dynamic subtest: pipe-D-eDP-1
[229.600284] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[229.603723] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[231.614834] [023/133] (788s left) gem_mmap_gtt (fault-concurrent)
[231.683869] Subtest fault-concurrent: SKIP (0.000s)
[231.745188] [024/133] (788s left) kms_addfb_basic (addfb25-4-tiled)
[231.842046] Starting subtest: addfb25-4-tiled
[231.844054] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[231.949193] [025/133] (788s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[232.052141] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[232.054507] Starting dynamic subtest: A-eDP1
[235.658273] Dynamic subtest A-eDP1: SUCCESS (3.604s)
[235.668296] Starting dynamic subtest: B-eDP1
[238.865809] Dynamic subtest B-eDP1: SUCCESS (3.205s)
[238.876025] Starting dynamic subtest: C-eDP1
[241.996069] Dynamic subtest C-eDP1: SUCCESS (3.129s)
[242.008992] Starting dynamic subtest: D-eDP1
[245.110415] Dynamic subtest D-eDP1: SUCCESS (3.115s)
[245.112741] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.059s)
[245.942242] [026/133] (774s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[246.066074] Starting subtest: flip-vs-cursor-busy-crc-legacy
[246.895860] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.828s)
[247.741219] [027/133] (772s left) syncobj_eventfd (timeline-wait-signaled)
[247.801872] Starting subtest: timeline-wait-signaled
[247.804973] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[247.905929] [028/133] (772s left) gem_exec_schedule (u-fairslice)
[247.974690] Starting subtest: u-fairslice
[247.976640] Starting dynamic subtest: rcs0
[249.988671] Dynamic subtest rcs0: SUCCESS (2.021s)
[249.997045] Starting dynamic subtest: bcs0
[252.008776] Dynamic subtest bcs0: SUCCESS (2.019s)
[252.017295] Starting dynamic subtest: vcs0
[254.029078] Dynamic subtest vcs0: SUCCESS (2.021s)
[254.039517] Starting dynamic subtest: vcs1
[256.048718] Dynamic subtest vcs1: SUCCESS (2.018s)
[256.057951] Starting dynamic subtest: vecs0
[258.065097] Dynamic subtest vecs0: SUCCESS (2.017s)
[258.073598] Starting dynamic subtest: ccs0
[260.087501] Dynamic subtest ccs0: SUCCESS (2.023s)
[260.089376] Subtest u-fairslice: SUCCESS (12.120s)
[260.382664] [029/133] (759s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[260.477686] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[260.480108] Starting dynamic subtest: pipe-A-default-mode
[263.160289] Dynamic subtest pipe-A-default-mode: SUCCESS (2.681s)
[263.162178] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.683s)
[264.029123] [030/133] (756s left) gem_exec_whisper (basic-sync-all)
[264.091972] Starting subtest: basic-sync-all
[270.696808] Subtest basic-sync-all: SUCCESS (6.601s)
[270.876402] [031/133] (749s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[270.929605] Starting subtest: etime-multi-wait-available-unsubmitted
[271.038108] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.108s)
[271.114499] [032/133] (749s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[271.202065] Starting subtest: random-ccs-data-y-tiled-ccs
[271.204325] Starting dynamic subtest: pipe-A-eDP-1
[271.228334] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[271.242802] Starting dynamic subtest: pipe-B-eDP-1
[271.266039] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[271.275497] Starting dynamic subtest: pipe-C-eDP-1
[271.297766] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[271.306108] Starting dynamic subtest: pipe-D-eDP-1
[271.328650] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[271.332414] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.003s)
[273.480147] [033/133] (746s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[273.584062] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[273.586306] Starting dynamic subtest: pipe-A-eDP-1
[273.606847] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[273.617935] Starting dynamic subtest: pipe-B-eDP-1
[273.636970] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[273.645757] Starting dynamic subtest: pipe-C-eDP-1
[273.665181] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[273.672892] Starting dynamic subtest: pipe-D-eDP-1
[273.691887] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[273.693795] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[275.852213] [034/133] (744s left) kms_addfb_basic (basic)
[275.910643] Starting subtest: basic
[275.912764] Subtest basic: SUCCESS (0.000s)
[276.044831] [035/133] (744s left) kms_color_pipeline (plane-lut1d-lut1d)
[276.148078] Starting subtest: plane-lut1d-lut1d
[276.293694] Starting dynamic subtest: pipe-A-plane-0
[276.438462] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[276.448686] Starting dynamic subtest: pipe-A-plane-1
[276.571804] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[276.580821] Starting dynamic subtest: pipe-A-plane-2
[276.748835] Dynamic subtest pipe-A-plane-2: SUCCESS (0.177s)
[277.954712] Starting dynamic subtest: pipe-B-plane-0
[278.125796] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s)
[278.135747] Starting dynamic subtest: pipe-B-plane-1
[278.293091] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[278.309743] Starting dynamic subtest: pipe-B-plane-2
[278.447527] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s)
[279.670205] Starting dynamic subtest: pipe-C-plane-0
[279.806764] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[279.816446] Starting dynamic subtest: pipe-C-plane-1
[279.951265] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[279.961103] Starting dynamic subtest: pipe-C-plane-2
[280.109586] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[281.308467] Starting dynamic subtest: pipe-D-plane-0
[281.456363] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[281.466104] Starting dynamic subtest: pipe-D-plane-1
[281.611861] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[281.621205] Starting dynamic subtest: pipe-D-plane-2
[281.767575] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[282.056412] Subtest plane-lut1d-lut1d: SUCCESS (5.907s)
[282.875131] [036/133] (737s left) api_intel_allocator (standalone)
[282.927826] Starting subtest: standalone
[282.942409] Subtest standalone: SUCCESS (0.017s)
[283.073334] [037/133] (737s left) prime_self_import (basic-llseek-bad)
[283.111022] Starting subtest: basic-llseek-bad
[283.127955] Subtest basic-llseek-bad: SUCCESS (0.017s)
[283.215862] [038/133] (737s left) kms_vblank (query-forked)
[283.317391] Starting subtest: query-forked
[283.319580] Starting dynamic subtest: pipe-A-eDP-1
[285.129786] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.813s)
[285.145083] Starting dynamic subtest: pipe-D-eDP-1
[287.694324] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.563s)
[287.696783] Subtest query-forked: SUCCESS (4.380s)
[288.546576] [039/133] (732s left) gem_exec_flush (basic-uc-ro-default)
[288.616588] Starting subtest: basic-uc-ro-default
[294.071129] Subtest basic-uc-ro-default: SUCCESS (5.455s)
[294.256696] [040/133] (726s left) perf (per-context-mode-unprivileged)
[294.347040] Starting subtest: per-context-mode-unprivileged
[294.351418] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[294.389307] [041/133] (726s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[294.491092] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[294.495271] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[294.592306] [042/133] (726s left) i915_pm_rps (min-max-config-idle)
[294.641783] Starting subtest: min-max-config-idle
[294.646499] Subtest min-max-config-idle: SKIP (0.001s)
[294.736551] [043/133] (726s left) gem_exec_balancer (busy)
[294.792476] Starting subtest: busy
[296.368082] Subtest busy: SUCCESS (1.574s)
[296.699627] [044/133] (724s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[296.793519] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[296.797594] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[296.906662] [045/133] (723s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[297.002666] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[297.006812] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[297.087345] [046/133] (723s left) gem_mmap_gtt (big-bo-tiledy)
[297.142229] Subtest big-bo-tiledY: SKIP (0.000s)
[297.195053] [047/133] (723s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[297.290929] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[304.637140] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.349s)
[304.757673] [048/133] (716s left) kms_chamelium_edid (vga-edid-read)
[305.146795] Subtest vga-edid-read: SKIP (0.000s)
[305.992925] [049/133] (715s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[306.104519] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[313.042524] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.938s)
[313.164356] [050/133] (707s left) gem_create (hog-create)
[313.217068] Starting subtest: hog-create
[313.219273] Starting dynamic subtest: smem0
[346.343043] Dynamic subtest smem0: SUCCESS (33.123s)
[346.345699] Subtest hog-create: SUCCESS (33.124s)
[346.530889] [051/133] (674s left) kms_getfb (getfb-repeated-different-handles)
[346.640060] Starting subtest: getfb-repeated-different-handles
[346.642212] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[346.733833] [052/133] (674s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[346.854833] Starting subtest: y-tiled-64bpp-rotate-0
[346.859540] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[346.962712] [053/133] (674s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[347.061648] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[347.066097] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[347.160299] [054/133] (674s left) api_intel_bb (simple-bb)
[347.217418] Starting subtest: simple-bb
[347.221648] Subtest simple-bb: SUCCESS (0.006s)
[347.341725] [055/133] (673s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[347.440961] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[347.445063] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[347.510075] [056/133] (673s left) kms_flip (blocking-wf_vblank)
[347.602949] Starting subtest: blocking-wf_vblank
[347.604754] Starting dynamic subtest: A-eDP1
[356.504733] Dynamic subtest A-eDP1: SUCCESS (8.902s)
[356.514372] Starting dynamic subtest: B-eDP1
[365.440847] Dynamic subtest B-eDP1: SUCCESS (8.934s)
[365.454796] Starting dynamic subtest: C-eDP1
[374.355047] Dynamic subtest C-eDP1: SUCCESS (8.911s)
[374.367804] Starting dynamic subtest: D-eDP1
[383.294848] Dynamic subtest D-eDP1: SUCCESS (8.938s)
[383.299428] Subtest blocking-wf_vblank: SUCCESS (35.696s)
[384.522028] [057/133] (636s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[384.647445] Starting subtest: cursorA-vs-flipB-atomic-transitions
[384.651851] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[384.794726] [058/133] (636s left) gem_mmap_offset (bad-flags)
[384.847107] Starting subtest: bad-flags
[384.849072] Subtest bad-flags: SUCCESS (0.000s)
[384.932344] [059/133] (636s left) vgem_basic (create)
[385.040118] Starting subtest: create
[385.042349] Subtest create: SUCCESS (0.000s)
[385.096443] [FACT vgem_basic (create)] new: kernel.kmod_is_loaded.vgem: true
[385.099687] [060/133] (636s left) kms_atomic (plane-primary-legacy)
[385.189189] Starting subtest: plane-primary-legacy
[385.191438] Starting dynamic subtest: pipe-A-eDP-1
[385.632227] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.442s)
[385.634463] Subtest plane-primary-legacy: SUCCESS (0.443s)
[386.461531] [061/133] (635s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[386.578593] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[386.583128] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[386.685950] [062/133] (634s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[386.743502] Starting subtest: invalid-single-wait-unsubmitted
[386.745807] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[386.855206] [063/133] (634s left) kms_psr (psr-cursor-render)
[386.943409] Starting subtest: psr-cursor-render
[386.945736] Starting dynamic subtest: eDP-1
[388.659670] Dynamic subtest eDP-1: SUCCESS (1.715s)
[388.662217] Subtest psr-cursor-render: SUCCESS (1.716s)
[389.529686] [064/133] (632s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[389.624298] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[389.626561] Starting dynamic subtest: pipe-A-eDP-1
[389.648603] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[389.660762] Starting dynamic subtest: pipe-B-eDP-1
[389.682406] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[389.690753] Starting dynamic subtest: pipe-C-eDP-1
[389.711278] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[389.719518] Starting dynamic subtest: pipe-D-eDP-1
[389.741457] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[389.745830] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[391.900548] [065/133] (629s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[392.428486] Starting subtest: syncobj-timeline-invalid-flags
[392.431042] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[393.381072] [066/133] (628s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[393.485873] Starting subtest: stress-xrgb8888-ytiled
[393.489939] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[393.561032] [067/133] (628s left) gem_sync (basic-each)
[393.633342] Starting subtest: basic-each
[396.025054] Subtest basic-each: SUCCESS (2.403s)
[396.215969] [068/133] (625s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[396.329169] Starting subtest: x-tiled-8bpp-rotate-0
[397.532593] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.204s)
[397.630400] [069/133] (624s left) sw_sync (sync_expired_merge)
[397.671528] Starting subtest: sync_expired_merge
[398.745639] Subtest sync_expired_merge: SUCCESS (1.074s)
[398.807914] [070/133] (623s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[398.899721] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[403.532542] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.636s)
[404.696876] [071/133] (617s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[404.806729] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[404.811131] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[404.914856] [072/133] (617s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[405.011671] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[405.016084] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[405.110461] [073/133] (616s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[405.197327] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[405.199517] Starting dynamic subtest: pipe-A
[406.390296] Dynamic subtest pipe-A: SUCCESS (1.196s)
[406.399826] Starting dynamic subtest: pipe-B
[408.632167] Dynamic subtest pipe-B: SUCCESS (2.241s)
[408.641108] Starting dynamic subtest: pipe-C
[409.885361] Dynamic subtest pipe-C: SUCCESS (1.252s)
[409.895173] Starting dynamic subtest: pipe-D
[411.123445] Dynamic subtest pipe-D: SUCCESS (1.237s)
[411.125729] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.929s)
[412.311904] [074/133] (609s left) kms_cursor_edge_walk (64x64-top-bottom)
[412.413210] Starting subtest: 64x64-top-bottom
[412.415447] Starting dynamic subtest: pipe-A-eDP-1
[415.859514] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.443s)
[415.870943] Starting dynamic subtest: pipe-D-eDP-1
[418.987306] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.129s)
[418.989532] Subtest 64x64-top-bottom: SUCCESS (6.577s)
[419.791451] [075/133] (602s left) kms_joiner (basic-ultra-joiner)
[419.894085] Starting subtest: basic-ultra-joiner
[419.897950] Subtest basic-ultra-joiner: SKIP (0.000s)
[419.962712] [076/133] (602s left) gen9_exec_parse (bb-start-param)
[420.028393] Subtest bb-start-param: SKIP (0.000s)
[420.107747] [077/133] (602s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[420.202793] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[427.074333] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.874s)
[427.213495] [078/133] (594s left) sw_sync (sync_multi_consumer)
[427.252773] Starting subtest: sync_multi_consumer
[427.664444] Subtest sync_multi_consumer: SUCCESS (0.410s)
[427.723974] [079/133] (594s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[427.778123] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[427.782516] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[427.970008] [080/133] (594s left) gem_exec_schedule (pi-common)
[428.168996] Starting subtest: pi-common
[428.171101] Starting dynamic subtest: rcs0
[428.193454] Dynamic subtest rcs0: SUCCESS (0.028s)
[428.207021] Starting dynamic subtest: bcs0
[428.222724] Dynamic subtest bcs0: SUCCESS (0.028s)
[428.235664] Starting dynamic subtest: vcs0
[428.250694] Dynamic subtest vcs0: SUCCESS (0.027s)
[428.264635] Starting dynamic subtest: vcs1
[428.278668] Dynamic subtest vcs1: SUCCESS (0.027s)
[428.292365] Starting dynamic subtest: vecs0
[428.306580] Dynamic subtest vecs0: SUCCESS (0.027s)
[428.320633] Starting dynamic subtest: ccs0
[428.332341] Dynamic subtest ccs0: SUCCESS (0.025s)
[428.334524] Subtest pi-common: SUCCESS (0.168s)
[428.561542] [081/133] (593s left) gem_exec_whisper (basic-contexts-all)
[428.619061] Starting subtest: basic-contexts-all
[439.963699] Subtest basic-contexts-all: SUCCESS (11.341s)
[440.149897] [082/133] (582s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[440.254998] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[440.256917] Starting dynamic subtest: pipe-A-eDP-1
[440.276810] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s)
[440.286593] Starting dynamic subtest: pipe-B-eDP-1
[440.307700] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[440.317493] Starting dynamic subtest: pipe-C-eDP-1
[440.337467] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.021s)
[440.347112] Starting dynamic subtest: pipe-D-eDP-1
[440.367288] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[440.369466] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.094s)
[442.665268] [083/133] (579s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[442.753455] Starting subtest: psr-rgb101010-draw-blt
[450.088779] Subtest psr-rgb101010-draw-blt: SUCCESS (7.338s)
[450.203095] [084/133] (572s left) core_setmaster (master-drop-set-shared-fd)
[450.312850] Starting subtest: master-drop-set-shared-fd
[450.332916] Subtest master-drop-set-shared-fd: SUCCESS (0.023s)
[450.381693] [085/133] (572s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[450.477652] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[457.273313] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.800s)
[457.406959] [086/133] (565s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[457.512346] Starting subtest: psr-rgb565-draw-render
[464.518655] Subtest psr-rgb565-draw-render: SUCCESS (7.010s)
[464.646476] [087/133] (557s left) kms_sequence (get-forked-busy)
[464.747036] Starting subtest: get-forked-busy
[464.749298] Starting dynamic subtest: pipe-A-eDP-1
[466.690314] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.940s)
[466.701803] Starting dynamic subtest: pipe-B-eDP-1
[469.350035] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.659s)
[469.360319] Starting dynamic subtest: pipe-C-eDP-1
[471.958788] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.608s)
[471.968210] Starting dynamic subtest: pipe-D-eDP-1
[474.594213] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.634s)
[474.596492] Subtest get-forked-busy: SUCCESS (9.848s)
[475.402733] [088/133] (547s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[475.507042] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[475.510977] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[475.591128] [089/133] (547s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[475.646059] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[475.648431] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[475.739555] [090/133] (546s left) syncobj_wait (single-wait-for-submit-signaled)
[475.794337] Starting subtest: single-wait-for-submit-signaled
[475.796244] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[475.886026] [091/133] (546s left) kms_dsc (dsc-fractional-bpp)
[475.981432] Starting subtest: dsc-fractional-bpp
[475.994305] Subtest dsc-fractional-bpp: SKIP (0.000s)
[476.055094] [092/133] (546s left) syncobj_wait (wait-all-snapshot)
[476.106043] Starting subtest: wait-all-snapshot
[476.186276] Subtest wait-all-snapshot: SUCCESS (0.081s)
[476.278881] [093/133] (546s left) kms_content_protection (legacy-hdcp14)
[476.407581] Starting subtest: legacy-hdcp14
[476.411347] Subtest legacy-hdcp14: SKIP (0.000s)
[476.548530] [094/133] (546s left) gem_exec_balancer (waits)
[476.613378] Starting subtest: waits
[483.128262] Subtest waits: SUCCESS (6.513s)
[483.439136] [095/133] (539s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[483.529251] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[483.531607] Starting dynamic subtest: pipe-A-eDP-1
[483.540757] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[483.555163] Starting dynamic subtest: pipe-B-eDP-1
[483.563715] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[483.577802] Starting dynamic subtest: pipe-C-eDP-1
[483.587102] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[483.602532] Starting dynamic subtest: pipe-D-eDP-1
[483.611204] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[483.615247] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[485.761233] [096/133] (537s left) i915_hangman (engine-error-state-capture)
[485.828432] Starting subtest: engine-error-state-capture
[485.830381] Starting dynamic subtest: rcs0
[489.279570] Dynamic subtest rcs0: SUCCESS (3.450s)
[489.291933] Starting dynamic subtest: bcs0
[495.296350] Dynamic subtest bcs0: SUCCESS (6.014s)
[495.311185] Starting dynamic subtest: vcs0
[501.248502] Dynamic subtest vcs0: SUCCESS (5.949s)
[501.261045] Starting dynamic subtest: vcs1
[506.304227] Dynamic subtest vcs1: SUCCESS (5.053s)
[506.317304] Starting dynamic subtest: vecs0
[512.255587] Dynamic subtest vecs0: SUCCESS (5.948s)
[512.268803] Starting dynamic subtest: ccs0
[518.272433] Dynamic subtest ccs0: SUCCESS (6.015s)
[518.275373] Subtest engine-error-state-capture: SUCCESS (32.445s)
[518.355224] [097/133] (504s left) perf_pmu (rc6-suspend)
[518.407398] Starting subtest: rc6-suspend
[541.015936] Subtest rc6-suspend: SUCCESS (8.059s)
[542.917726] [098/133] (481s left) gem_exec_parallel (basic)
[542.998549] Starting subtest: basic
[543.000915] Starting dynamic subtest: rcs0
[544.400353] Dynamic subtest rcs0: SUCCESS (1.412s)
[544.412337] Starting dynamic subtest: bcs0
[545.880071] Dynamic subtest bcs0: SUCCESS (1.486s)
[545.894936] Starting dynamic subtest: vcs0
[547.894950] Dynamic subtest vcs0: SUCCESS (2.020s)
[547.908489] Starting dynamic subtest: vcs1
[549.879752] Dynamic subtest vcs1: SUCCESS (1.990s)
[549.891422] Starting dynamic subtest: vecs0
[551.863946] Dynamic subtest vecs0: SUCCESS (1.986s)
[551.875431] Starting dynamic subtest: ccs0
[553.338447] Dynamic subtest ccs0: SUCCESS (1.477s)
[553.340744] Subtest basic: SUCCESS (10.387s)
[553.540892] [099/133] (470s left) kms_psr (psr-primary-blt)
[553.641884] Starting subtest: psr-primary-blt
[553.644194] Starting dynamic subtest: eDP-1
[555.376240] Dynamic subtest eDP-1: SUCCESS (1.737s)
[555.378480] Subtest psr-primary-blt: SUCCESS (1.738s)
[556.243210] [100/133] (467s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[556.295884] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[556.375368] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.025s)
[556.416475] [101/133] (467s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[556.512584] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[560.125518] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.622s)
[561.263843] [102/133] (462s left) kms_prop_blob (blob-prop-lifetime)
[561.320540] Starting subtest: blob-prop-lifetime
[561.322704] Subtest blob-prop-lifetime: SUCCESS (0.002s)
[561.418473] [103/133] (462s left) gem_userptr_blits (readonly-unsync)
[561.482224] Subtest readonly-unsync: SKIP (0.000s)
[561.598208] [104/133] (462s left) perf (polling)
[561.682385] Starting subtest: polling
[561.684619] Starting dynamic subtest: 0-rcs0
[571.714330] Dynamic subtest 0-rcs0: SUCCESS (10.041s)
[571.726226] Starting dynamic subtest: 1-vecs0
[581.734655] Dynamic subtest 1-vecs0: SUCCESS (10.021s)
[581.736904] Subtest polling: SUCCESS (20.065s)
[581.785057] [105/133] (442s left) i915_query (query-topology-kernel-writes)
[581.838763] Starting subtest: query-topology-kernel-writes
[581.840596] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[581.931542] [106/133] (442s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[582.024818] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[583.061726] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.037s)
[583.199940] [107/133] (441s left) kms_psr (fbc-pr-sprite-blt)
[583.293414] Starting subtest: fbc-pr-sprite-blt
[583.296893] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[583.366480] [108/133] (441s left) prime_self_import (basic-with_two_bos)
[583.402292] Starting subtest: basic-with_two_bos
[583.410632] Subtest basic-with_two_bos: SUCCESS (0.014s)
[583.503084] [109/133] (441s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[583.610353] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[584.712268] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.103s)
[584.836392] [110/133] (439s left) gem_exec_reloc (basic-cpu-read)
[584.885896] Subtest basic-cpu-read: SKIP (0.000s)
[584.953318] [111/133] (439s left) gem_ctx_shared (exec-shared-gtt)
[585.010198] Starting subtest: exec-shared-gtt
[585.011834] Starting dynamic subtest: rcs0
[585.015511] Dynamic subtest rcs0: SUCCESS (0.008s)
[585.027495] Starting dynamic subtest: bcs0
[585.029289] Dynamic subtest bcs0: SUCCESS (0.006s)
[585.039343] Starting dynamic subtest: vcs0
[585.040918] Dynamic subtest vcs0: SUCCESS (0.006s)
[585.050875] Starting dynamic subtest: vcs1
[585.052757] Dynamic subtest vcs1: SUCCESS (0.008s)
[585.062760] Starting dynamic subtest: vecs0
[585.064362] Dynamic subtest vecs0: SUCCESS (0.008s)
[585.074052] Starting dynamic subtest: ccs0
[585.075666] Dynamic subtest ccs0: SUCCESS (0.006s)
[585.077330] Subtest exec-shared-gtt: SUCCESS (0.047s)
[585.240726] [112/133] (439s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[585.329106] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[585.330964] Starting dynamic subtest: pipe-A
[585.349903] Dynamic subtest pipe-A: SKIP (0.017s)
[585.360528] Starting dynamic subtest: pipe-B
[585.382292] Dynamic subtest pipe-B: SKIP (0.032s)
[585.392545] Starting dynamic subtest: pipe-C
[585.414046] Dynamic subtest pipe-C: SKIP (0.031s)
[585.424293] Starting dynamic subtest: pipe-D
[585.445128] Dynamic subtest pipe-D: SKIP (0.031s)
[585.448693] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.113s)
[585.550105] [113/133] (439s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[585.641494] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[592.962772] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.326s)
[593.105588] [114/133] (431s left) kms_getfb (getfb-handle-protection)
[593.214024] Starting subtest: getfb-handle-protection
[593.231456] Subtest getfb-handle-protection: SUCCESS (0.018s)
[593.359338] [115/133] (431s left) gem_ctx_persistence (process)
[593.434840] Starting subtest: process
[593.592758] Subtest process: SUCCESS (0.160s)
[593.673461] [116/133] (431s left) i915_selftest (mock)
[596.261844] Starting subtest: mock
[596.264334] Starting dynamic subtest: sanitycheck
[596.971141] Dynamic subtest sanitycheck: SUCCESS (0.709s)
[596.982454] Starting dynamic subtest: shmem
[597.652874] Dynamic subtest shmem: SUCCESS (0.680s)
[597.663747] Starting dynamic subtest: fence
[604.975823] Dynamic subtest fence: SUCCESS (7.323s)
[604.986858] Starting dynamic subtest: scatterlist
[606.656883] Dynamic subtest scatterlist: SUCCESS (1.680s)
[606.668174] Starting dynamic subtest: syncmap
[609.784933] Dynamic subtest syncmap: SUCCESS (3.127s)
[609.796345] Starting dynamic subtest: uncore
[610.447884] Dynamic subtest uncore: SUCCESS (0.662s)
[610.458353] Starting dynamic subtest: ring
[611.117925] Dynamic subtest ring: SUCCESS (0.668s)
[611.129173] Starting dynamic subtest: engine
[611.793830] Dynamic subtest engine: SUCCESS (0.674s)
[611.810929] Starting dynamic subtest: timelines
[615.699576] Dynamic subtest timelines: SUCCESS (3.905s)
[615.709389] Starting dynamic subtest: requests
[619.227523] Dynamic subtest requests: SUCCESS (3.527s)
[619.238415] Starting dynamic subtest: objects
[619.981981] Dynamic subtest objects: SUCCESS (0.754s)
[619.990649] Starting dynamic subtest: phys
[620.736765] Dynamic subtest phys: SUCCESS (0.753s)
[620.750471] Starting dynamic subtest: dmabuf
[621.522794] Dynamic subtest dmabuf: SUCCESS (0.785s)
[621.533304] Starting dynamic subtest: vma
[627.270813] Dynamic subtest vma: SUCCESS (5.748s)
[627.280206] Starting dynamic subtest: evict
[628.774695] Dynamic subtest evict: SUCCESS (1.503s)
[628.785543] Starting dynamic subtest: gtt
[632.064239] Dynamic subtest gtt: SUCCESS (3.289s)
[632.074805] Starting dynamic subtest: hugepages
[632.929037] Dynamic subtest hugepages: SUCCESS (0.864s)
[632.940983] Starting dynamic subtest: memory_region
[635.412615] Dynamic subtest memory_region: SUCCESS (2.480s)
[635.415522] Subtest mock: SUCCESS (39.168s)
[635.445297] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[635.445990] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[635.449200] [117/133] (389s left) kms_pm_rpm (legacy-planes-dpms)
[639.095122] Starting subtest: legacy-planes-dpms
[639.097251] Starting dynamic subtest: plane-65
[650.404090] Dynamic subtest plane-65: SUCCESS (11.307s)
[650.416891] Starting dynamic subtest: plane-95
[658.715904] Dynamic subtest plane-95: SUCCESS (8.307s)
[658.729131] Starting dynamic subtest: plane-125
[666.991491] Dynamic subtest plane-125: SUCCESS (8.273s)
[667.003206] Starting dynamic subtest: plane-135
[675.723371] Dynamic subtest plane-135: SUCCESS (8.729s)
[675.726318] Subtest legacy-planes-dpms: SUCCESS (36.626s)
[676.175532] [FACT kms_pm_rpm (legacy-planes-dpms)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[676.176759] [FACT kms_pm_rpm (legacy-planes-dpms)] new: kernel.kmod_is_loaded.i915: true
[676.181176] [118/133] (348s left) kms_cursor_crc (cursor-random-32x10)
[676.335844] Starting subtest: cursor-random-32x10
[676.389088] Subtest cursor-random-32x10: SKIP (0.048s)
[676.661632] [119/133] (348s left) kms_cursor_crc (cursor-offscreen-32x32)
[676.833535] Starting subtest: cursor-offscreen-32x32
[676.928663] Subtest cursor-offscreen-32x32: SKIP (0.092s)
[677.196571] [120/133] (347s left) syncobj_wait (single-wait-all-for-submit-submitted)
[677.258451] Starting subtest: single-wait-all-for-submit-submitted
[677.363891] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.104s)
[677.441483] [121/133] (347s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[677.508618] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[677.573240] [122/133] (347s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[677.634349] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[677.636571] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[677.761281] [123/133] (347s left) kms_chamelium_hpd (hdmi-hpd)
[678.147304] Subtest hdmi-hpd: SKIP (0.000s)
[678.944409] [124/133] (346s left) gem_exec_reloc (basic-gtt-noreloc)
[679.016288] Subtest basic-gtt-noreloc: SKIP (0.000s)
[679.081202] [125/133] (346s left) kms_flip (2x-wf_vblank-ts-check)
[679.177722] Starting subtest: 2x-wf_vblank-ts-check
[679.190111] Subtest 2x-wf_vblank-ts-check: SKIP (0.013s)
[679.286079] [126/133] (345s left) kms_psr (pr-primary-mmap-cpu)
[679.375921] Starting subtest: pr-primary-mmap-cpu
[679.379915] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[679.451267] [127/133] (345s left) gem_readwrite (read-write)
[679.521897] Subtest read-write: SKIP (0.000s)
[679.578118] [128/133] (345s left) fbdev (write)
[679.620256] Starting subtest: write
[679.981360] Subtest write: SUCCESS (0.360s)
[680.058695] [129/133] (345s left) kms_dp_aux_dev (basic)
[680.131369] Starting subtest: basic
[680.351582] Subtest basic: SUCCESS (0.219s)
[680.422612] [130/133] (344s left) kms_psr (fbc-psr2-sprite-render)
[680.527158] Starting subtest: fbc-psr2-sprite-render
[680.529319] Starting dynamic subtest: eDP-1
[680.533162] Dynamic subtest eDP-1: SKIP (0.000s)
[680.537044] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[680.613642] [131/133] (344s left) gem_ctx_persistence (engines-cleanup)
[680.669324] Starting subtest: engines-cleanup
[680.671792] Starting dynamic subtest: rcs0
[680.735612] Dynamic subtest rcs0: SUCCESS (0.066s)
[680.749446] Starting dynamic subtest: bcs0
[680.774401] Dynamic subtest bcs0: SUCCESS (0.037s)
[680.786908] Starting dynamic subtest: vcs0
[680.814387] Dynamic subtest vcs0: SUCCESS (0.039s)
[680.824377] Starting dynamic subtest: vcs1
[680.847221] Dynamic subtest vcs1: SUCCESS (0.031s)
[680.856964] Starting dynamic subtest: vecs0
[680.884376] Dynamic subtest vecs0: SUCCESS (0.035s)
[680.894791] Starting dynamic subtest: ccs0
[680.924317] Dynamic subtest ccs0: SUCCESS (0.038s)
[680.926539] Subtest engines-cleanup: SUCCESS (0.256s)
[681.004758] [132/133] (344s left) sysfs_heartbeat_interval (idempotent)
[681.064437] Starting subtest: idempotent
[681.066740] Starting dynamic subtest: vecs0
[681.069045] Dynamic subtest vecs0: SUCCESS (0.001s)
[681.079369] Starting dynamic subtest: ccs0
[681.081168] Dynamic subtest ccs0: SUCCESS (0.001s)
[681.090474] Starting dynamic subtest: vcs0
[681.092328] Dynamic subtest vcs0: SUCCESS (0.000s)
[681.101408] Starting dynamic subtest: bcs0
[681.103263] Dynamic subtest bcs0: SUCCESS (0.001s)
[681.112721] Starting dynamic subtest: rcs0
[681.114967] Dynamic subtest rcs0: SUCCESS (0.000s)
[681.124304] Starting dynamic subtest: vcs1
[681.126465] Dynamic subtest vcs1: SUCCESS (0.000s)
[681.128326] Subtest idempotent: SUCCESS (0.008s)
[681.173325] [133/133] (344s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[681.266654] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[688.404751] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.144s)
[688.516499] 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.