[58.511359] Initializing watchdogs
[58.511494]   /dev/watchdog0
[58.528539] [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.533016] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.535313] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.539089] [001/133] (960s left) gem_pxp (create-regular-buffer)
[58.682565] Starting subtest: create-regular-buffer
[58.685443] Subtest create-regular-buffer: SUCCESS (0.000s)
[58.813036] [002/133] (960s left) kms_pm_rpm (basic-pci-d3-state)
[60.392455] Starting subtest: basic-pci-d3-state
[61.865455] Subtest basic-pci-d3-state: SUCCESS (1.476s)
[61.966475] [003/133] (957s left) gem_wait (wait)
[62.032075] Starting subtest: wait
[62.034508] Starting dynamic subtest: all-engines
[63.330064] Dynamic subtest all-engines: SUCCESS (1.296s)
[63.343287] Starting dynamic subtest: rcs0
[64.376822] Dynamic subtest rcs0: SUCCESS (1.046s)
[64.386592] Starting dynamic subtest: bcs0
[65.423959] Dynamic subtest bcs0: SUCCESS (1.044s)
[65.437589] Starting dynamic subtest: vcs0
[66.467886] Dynamic subtest vcs0: SUCCESS (1.044s)
[66.476816] Starting dynamic subtest: vcs1
[67.511779] Dynamic subtest vcs1: SUCCESS (1.043s)
[67.522540] Starting dynamic subtest: vecs0
[68.556434] Dynamic subtest vecs0: SUCCESS (1.044s)
[68.567077] Starting dynamic subtest: ccs0
[69.603059] Dynamic subtest ccs0: SUCCESS (1.045s)
[69.605439] Subtest wait: SUCCESS (7.572s)
[69.797808] [004/133] (949s left) gem_exec_gttfill (engines)
[69.865613] Starting subtest: engines
[69.867925] Starting dynamic subtest: rcs0
[93.340214] Dynamic subtest rcs0: SUCCESS (23.468s)
[93.351149] Starting dynamic subtest: bcs0
[116.624752] Dynamic subtest bcs0: SUCCESS (23.277s)
[116.635413] Starting dynamic subtest: vcs0
[139.959043] Dynamic subtest vcs0: SUCCESS (23.334s)
[139.966891] Starting dynamic subtest: vcs1
[163.222353] Dynamic subtest vcs1: SUCCESS (23.261s)
[163.232633] Starting dynamic subtest: vecs0
[186.555100] Dynamic subtest vecs0: SUCCESS (23.329s)
[186.564718] Starting dynamic subtest: ccs0
[209.844951] Dynamic subtest ccs0: SUCCESS (23.289s)
[209.847872] Subtest engines: SUCCESS (139.965s)
[210.103216] [005/133] (809s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[210.254346] Starting subtest: fbcpsr-2p-rte
[210.258482] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[210.369358] [006/133] (808s left) kms_psr (fbc-pr-no-drrs)
[210.470130] Starting subtest: fbc-pr-no-drrs
[210.474248] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[210.540569] [007/133] (808s left) perf (gen12-group-concurrent-oa-buffer-read)
[210.689941] Starting subtest: gen12-group-concurrent-oa-buffer-read
[220.729825] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.038s)
[220.776830] [008/133] (798s left) gem_softpin (full)
[220.840694] Starting subtest: full
[220.847958] Subtest full: SUCCESS (0.009s)
[220.957884] [009/133] (798s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[221.050645] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[221.055022] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[221.133632] [010/133] (798s left) gem_mmap_gtt (basic-read)
[221.198123] Subtest basic-read: SKIP (0.000s)
[221.253118] [011/133] (798s left) kms_big_fb (linear-32bpp-rotate-180)
[221.360025] Starting subtest: linear-32bpp-rotate-180
[222.881736] Subtest linear-32bpp-rotate-180: SUCCESS (1.522s)
[223.021511] [012/133] (796s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[223.134301] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[223.137872] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[223.238283] [013/133] (796s left) gem_ctx_bad_destroy (invalid-ctx)
[223.291233] Starting subtest: invalid-ctx
[223.293158] Subtest invalid-ctx: SUCCESS (0.000s)
[223.363091] [014/133] (796s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[223.454940] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[223.489232] Starting dynamic subtest: pipe-A-plane-0
[223.788955] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[223.798063] Starting dynamic subtest: pipe-A-plane-3
[224.022408] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[224.032685] Starting dynamic subtest: pipe-A-plane-5
[224.036609] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[225.103872] Starting dynamic subtest: pipe-B-plane-0
[225.397051] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[225.405963] Starting dynamic subtest: pipe-B-plane-3
[225.630607] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[225.639697] Starting dynamic subtest: pipe-B-plane-5
[225.643674] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[225.951872] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.497s)
[226.785144] [015/133] (792s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[226.840900] Starting subtest: single-wait-for-submit-available-signaled
[226.843310] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[226.924269] [016/133] (792s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[227.018909] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[227.021143] Starting dynamic subtest: pipe-A-default-mode
[228.143220] Dynamic subtest pipe-A-default-mode: SKIP (1.123s)
[228.147680] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.124s)
[228.291035] [017/133] (791s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[228.344765] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[228.346734] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[228.443208] [018/133] (791s left) i915_drm_fdinfo (virtual-busy-all)
[228.488806] Starting subtest: virtual-busy-all
[228.493130] Subtest virtual-busy-all: SKIP (0.000s)
[228.552467] [019/133] (791s left) gem_exec_reloc (basic-gtt-read-noreloc)
[228.610989] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[228.672771] [020/133] (791s left) kms_lease (lease-invalid-connector)
[228.760776] Starting subtest: lease-invalid-connector
[228.763080] Starting dynamic subtest: pipe-A-eDP-1
[228.765351] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[228.775912] Starting dynamic subtest: pipe-B-eDP-1
[228.777795] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[228.788369] Starting dynamic subtest: pipe-C-eDP-1
[228.792520] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[228.800871] Starting dynamic subtest: pipe-D-eDP-1
[228.803027] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[228.805155] Subtest lease-invalid-connector: SUCCESS (0.003s)
[228.842434] [021/133] (790s left) gem_pxp (reject-modify-context-protection-off-3)
[228.950501] Starting subtest: reject-modify-context-protection-off-3
[228.952914] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[229.055529] [022/133] (790s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[229.158953] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[229.160971] Starting dynamic subtest: pipe-A-eDP-1
[229.209516] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[229.218991] Starting dynamic subtest: pipe-B-eDP-1
[229.263932] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[229.272675] Starting dynamic subtest: pipe-C-eDP-1
[229.318655] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[229.326640] Starting dynamic subtest: pipe-D-eDP-1
[229.372415] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[229.376063] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[231.454994] [023/133] (788s left) gem_mmap_gtt (fault-concurrent)
[231.502919] Subtest fault-concurrent: SKIP (0.000s)
[231.559401] [024/133] (788s left) kms_addfb_basic (addfb25-4-tiled)
[231.655616] Starting subtest: addfb25-4-tiled
[231.657482] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[231.748573] [025/133] (788s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[231.837723] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[231.839626] Starting dynamic subtest: A-eDP1
[235.383043] Dynamic subtest A-eDP1: SUCCESS (3.543s)
[235.394242] Starting dynamic subtest: B-eDP1
[238.583075] Dynamic subtest B-eDP1: SUCCESS (3.200s)
[238.593077] Starting dynamic subtest: C-eDP1
[241.683687] Dynamic subtest C-eDP1: SUCCESS (3.098s)
[241.693041] Starting dynamic subtest: D-eDP1
[244.890417] Dynamic subtest D-eDP1: SUCCESS (3.207s)
[244.892672] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.054s)
[245.690622] [026/133] (774s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[245.823738] Starting subtest: flip-vs-cursor-busy-crc-legacy
[246.648009] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.826s)
[247.524230] [027/133] (772s left) syncobj_eventfd (timeline-wait-signaled)
[247.576983] Starting subtest: timeline-wait-signaled
[247.579270] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[247.669407] [028/133] (772s left) gem_exec_schedule (u-fairslice)
[247.750141] Starting subtest: u-fairslice
[247.752553] Starting dynamic subtest: rcs0
[249.764157] Dynamic subtest rcs0: SUCCESS (2.020s)
[249.774209] Starting dynamic subtest: bcs0
[251.781054] Dynamic subtest bcs0: SUCCESS (2.018s)
[251.791436] Starting dynamic subtest: vcs0
[253.801502] Dynamic subtest vcs0: SUCCESS (2.019s)
[253.809835] Starting dynamic subtest: vcs1
[255.819011] Dynamic subtest vcs1: SUCCESS (2.017s)
[255.828565] Starting dynamic subtest: vecs0
[257.836798] Dynamic subtest vecs0: SUCCESS (2.018s)
[257.847189] Starting dynamic subtest: ccs0
[259.860163] Dynamic subtest ccs0: SUCCESS (2.021s)
[259.862376] Subtest u-fairslice: SUCCESS (12.116s)
[260.169836] [029/133] (759s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[260.261714] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[260.263868] Starting dynamic subtest: pipe-A-default-mode
[262.938657] Dynamic subtest pipe-A-default-mode: SUCCESS (2.677s)
[262.940959] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.678s)
[263.807446] [030/133] (756s left) gem_exec_whisper (basic-sync-all)
[263.868678] Starting subtest: basic-sync-all
[270.530844] Subtest basic-sync-all: SUCCESS (6.660s)
[270.723943] [031/133] (749s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[270.770661] Starting subtest: etime-multi-wait-available-unsubmitted
[270.881898] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.107s)
[270.969071] [032/133] (749s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[271.066597] Starting subtest: random-ccs-data-y-tiled-ccs
[271.068754] Starting dynamic subtest: pipe-A-eDP-1
[271.093228] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[271.104229] Starting dynamic subtest: pipe-B-eDP-1
[271.128217] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[271.136200] Starting dynamic subtest: pipe-C-eDP-1
[271.160044] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[271.168641] Starting dynamic subtest: pipe-D-eDP-1
[271.192567] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[271.196966] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.003s)
[273.391010] [033/133] (746s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[273.489107] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[273.491420] Starting dynamic subtest: pipe-A-eDP-1
[273.512390] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[273.526925] Starting dynamic subtest: pipe-B-eDP-1
[273.546626] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[273.556484] Starting dynamic subtest: pipe-C-eDP-1
[273.576303] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[273.584531] Starting dynamic subtest: pipe-D-eDP-1
[273.603348] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[273.605243] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[275.758610] [034/133] (744s left) kms_addfb_basic (basic)
[275.812935] Starting subtest: basic
[275.814907] Subtest basic: SUCCESS (0.000s)
[275.948303] [035/133] (744s left) kms_color_pipeline (plane-lut1d-lut1d)
[276.055345] Starting subtest: plane-lut1d-lut1d
[276.215072] Starting dynamic subtest: pipe-A-plane-0
[276.412659] Dynamic subtest pipe-A-plane-0: SUCCESS (0.199s)
[276.422566] Starting dynamic subtest: pipe-A-plane-1
[276.600454] Dynamic subtest pipe-A-plane-1: SUCCESS (0.188s)
[276.611241] Starting dynamic subtest: pipe-A-plane-2
[276.766646] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[277.959129] Starting dynamic subtest: pipe-B-plane-0
[278.118233] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[278.127904] Starting dynamic subtest: pipe-B-plane-1
[278.284959] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[278.294588] Starting dynamic subtest: pipe-B-plane-2
[278.451509] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[279.627397] Starting dynamic subtest: pipe-C-plane-0
[279.763433] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[279.772900] Starting dynamic subtest: pipe-C-plane-1
[279.930181] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[279.939173] Starting dynamic subtest: pipe-C-plane-2
[280.063477] Dynamic subtest pipe-C-plane-2: SUCCESS (0.133s)
[281.252839] Starting dynamic subtest: pipe-D-plane-0
[281.387747] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[281.397400] Starting dynamic subtest: pipe-D-plane-1
[281.532270] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[281.541705] Starting dynamic subtest: pipe-D-plane-2
[281.676453] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[281.963214] Subtest plane-lut1d-lut1d: SUCCESS (5.910s)
[282.814145] [036/133] (737s left) api_intel_allocator (standalone)
[282.873112] Starting subtest: standalone
[282.885265] Subtest standalone: SUCCESS (0.015s)
[283.007503] [037/133] (737s left) prime_self_import (basic-llseek-bad)
[283.041285] Starting subtest: basic-llseek-bad
[283.059015] Subtest basic-llseek-bad: SUCCESS (0.018s)
[283.180299] [038/133] (737s left) kms_vblank (query-forked)
[283.272231] Starting subtest: query-forked
[283.274417] Starting dynamic subtest: pipe-A-eDP-1
[285.080742] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.808s)
[285.095032] Starting dynamic subtest: pipe-D-eDP-1
[287.624635] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.542s)
[287.626929] Subtest query-forked: SUCCESS (4.354s)
[288.483896] [039/133] (732s left) gem_exec_flush (basic-uc-ro-default)
[288.543294] Starting subtest: basic-uc-ro-default
[293.999940] Subtest basic-uc-ro-default: SUCCESS (5.458s)
[294.182144] [040/133] (726s left) perf (per-context-mode-unprivileged)
[294.276647] Starting subtest: per-context-mode-unprivileged
[294.281237] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[294.318558] [041/133] (726s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[294.416184] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[294.420352] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[294.513292] [042/133] (726s left) i915_pm_rps (min-max-config-idle)
[294.572653] Starting subtest: min-max-config-idle
[294.577258] Subtest min-max-config-idle: SKIP (0.000s)
[294.668323] [043/133] (726s left) gem_exec_balancer (busy)
[294.738263] Starting subtest: busy
[296.352257] Subtest busy: SUCCESS (1.612s)
[296.688360] [044/133] (724s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[296.787414] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[296.791418] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[296.879267] [045/133] (723s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[296.987820] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[296.991955] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[297.094491] [046/133] (723s left) gem_mmap_gtt (big-bo-tiledy)
[297.155194] Subtest big-bo-tiledY: SKIP (0.000s)
[297.225879] [047/133] (723s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[297.324513] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[304.652536] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.331s)
[304.775533] [048/133] (716s left) kms_chamelium_edid (vga-edid-read)
[305.161141] Subtest vga-edid-read: SKIP (0.000s)
[305.937700] [049/133] (714s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[306.032629] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[312.981690] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.950s)
[313.134707] [050/133] (707s left) gem_create (hog-create)
[313.194683] Starting subtest: hog-create
[313.197202] Starting dynamic subtest: smem0
[346.346214] Dynamic subtest smem0: SUCCESS (33.153s)
[346.348582] Subtest hog-create: SUCCESS (33.154s)
[346.528951] [051/133] (674s left) kms_getfb (getfb-repeated-different-handles)
[346.644223] Starting subtest: getfb-repeated-different-handles
[346.646063] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[346.761319] [052/133] (674s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[346.870624] Starting subtest: y-tiled-64bpp-rotate-0
[346.874750] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[346.964519] [053/133] (674s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[347.063718] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[347.067809] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[347.166522] [054/133] (673s left) api_intel_bb (simple-bb)
[347.231407] Starting subtest: simple-bb
[347.235051] Subtest simple-bb: SUCCESS (0.006s)
[347.343218] [055/133] (673s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[347.444740] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[347.449045] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[347.511476] [056/133] (673s left) kms_flip (blocking-wf_vblank)
[347.599838] Starting subtest: blocking-wf_vblank
[347.601823] Starting dynamic subtest: A-eDP1
[356.520553] Dynamic subtest A-eDP1: SUCCESS (8.921s)
[356.531450] Starting dynamic subtest: B-eDP1
[365.455429] Dynamic subtest B-eDP1: SUCCESS (8.934s)
[365.466394] Starting dynamic subtest: C-eDP1
[374.374490] Dynamic subtest C-eDP1: SUCCESS (8.915s)
[374.384776] Starting dynamic subtest: D-eDP1
[383.296609] Dynamic subtest D-eDP1: SUCCESS (8.921s)
[383.301578] Subtest blocking-wf_vblank: SUCCESS (35.704s)
[384.547637] [057/133] (636s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[384.672455] Starting subtest: cursorA-vs-flipB-atomic-transitions
[384.677078] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[384.845927] [058/133] (636s left) gem_mmap_offset (bad-flags)
[384.909035] Starting subtest: bad-flags
[384.911286] Subtest bad-flags: SUCCESS (0.000s)
[385.021117] [059/133] (636s left) vgem_basic (create)
[385.136887] Starting subtest: create
[385.138851] Subtest create: SUCCESS (0.000s)
[385.191426] [FACT vgem_basic (create)] new: kernel.kmod_is_loaded.vgem: true
[385.195550] [060/133] (636s left) kms_atomic (plane-primary-legacy)
[385.288210] Starting subtest: plane-primary-legacy
[385.290409] Starting dynamic subtest: pipe-A-eDP-1
[385.736381] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.447s)
[385.738248] Subtest plane-primary-legacy: SUCCESS (0.448s)
[386.554239] [061/133] (634s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[386.663765] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[386.667943] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[386.754928] [062/133] (634s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[386.815858] Starting subtest: invalid-single-wait-unsubmitted
[386.818579] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[386.919540] [063/133] (634s left) kms_psr (psr-cursor-render)
[386.999278] Starting subtest: psr-cursor-render
[387.001509] Starting dynamic subtest: eDP-1
[388.748201] Dynamic subtest eDP-1: SUCCESS (1.749s)
[388.750062] Subtest psr-cursor-render: SUCCESS (1.750s)
[389.622529] [064/133] (631s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[389.717782] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[389.720080] Starting dynamic subtest: pipe-A-eDP-1
[389.741401] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[389.750945] Starting dynamic subtest: pipe-B-eDP-1
[389.771160] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[389.779679] Starting dynamic subtest: pipe-C-eDP-1
[389.800652] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[389.809046] Starting dynamic subtest: pipe-D-eDP-1
[389.829960] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[389.833888] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[391.968895] [065/133] (629s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[392.490538] Starting subtest: syncobj-timeline-invalid-flags
[392.492951] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[394.416574] [066/133] (627s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[394.523978] Starting subtest: stress-xrgb8888-ytiled
[394.528348] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[394.600469] [067/133] (627s left) gem_sync (basic-each)
[394.670996] Starting subtest: basic-each
[396.935022] Subtest basic-each: SUCCESS (2.274s)
[397.131748] [068/133] (624s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[397.236586] Starting subtest: x-tiled-8bpp-rotate-0
[398.406215] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.171s)
[398.530320] [069/133] (623s left) sw_sync (sync_expired_merge)
[398.570190] Starting subtest: sync_expired_merge
[399.644318] Subtest sync_expired_merge: SUCCESS (1.074s)
[399.721584] [070/133] (622s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[399.809748] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[404.449213] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.644s)
[405.596047] [071/133] (616s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[405.697803] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[405.702056] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[405.796645] [072/133] (616s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[405.897914] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[405.902256] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[405.985241] [073/133] (615s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[406.082021] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[406.084185] Starting dynamic subtest: pipe-A
[407.219677] Dynamic subtest pipe-A: SUCCESS (1.140s)
[407.230080] Starting dynamic subtest: pipe-B
[409.565088] Dynamic subtest pipe-B: SUCCESS (2.340s)
[409.585844] Starting dynamic subtest: pipe-C
[410.776522] Dynamic subtest pipe-C: SUCCESS (1.213s)
[410.786058] Starting dynamic subtest: pipe-D
[411.929803] Dynamic subtest pipe-D: SUCCESS (1.152s)
[411.932200] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.851s)
[413.137404] [074/133] (608s left) kms_cursor_edge_walk (64x64-top-bottom)
[413.236300] Starting subtest: 64x64-top-bottom
[413.238623] Starting dynamic subtest: pipe-A-eDP-1
[416.701673] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.464s)
[416.711279] Starting dynamic subtest: pipe-D-eDP-1
[419.827196] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.124s)
[419.829500] Subtest 64x64-top-bottom: SUCCESS (6.592s)
[420.635680] [075/133] (601s left) kms_joiner (basic-ultra-joiner)
[420.728621] Starting subtest: basic-ultra-joiner
[420.732726] Subtest basic-ultra-joiner: SKIP (0.000s)
[420.797865] [076/133] (601s left) gen9_exec_parse (bb-start-param)
[420.869649] Subtest bb-start-param: SKIP (0.000s)
[420.945314] [077/133] (601s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[421.043655] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[427.943321] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.903s)
[428.081967] [078/133] (594s left) sw_sync (sync_multi_consumer)
[428.120605] Starting subtest: sync_multi_consumer
[428.543247] Subtest sync_multi_consumer: SUCCESS (0.422s)
[428.608142] [079/133] (593s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[428.657719] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[428.662330] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[428.857274] [080/133] (593s left) gem_exec_schedule (pi-common)
[429.036543] Starting subtest: pi-common
[429.038666] Starting dynamic subtest: rcs0
[429.061091] Dynamic subtest rcs0: SUCCESS (0.029s)
[429.074261] Starting dynamic subtest: bcs0
[429.091186] Dynamic subtest bcs0: SUCCESS (0.029s)
[429.105397] Starting dynamic subtest: vcs0
[429.120111] Dynamic subtest vcs0: SUCCESS (0.028s)
[429.134600] Starting dynamic subtest: vcs1
[429.148040] Dynamic subtest vcs1: SUCCESS (0.027s)
[429.162029] Starting dynamic subtest: vecs0
[429.175703] Dynamic subtest vecs0: SUCCESS (0.027s)
[429.190102] Starting dynamic subtest: ccs0
[429.201695] Dynamic subtest ccs0: SUCCESS (0.025s)
[429.203982] Subtest pi-common: SUCCESS (0.170s)
[429.429824] [081/133] (592s left) gem_exec_whisper (basic-contexts-all)
[429.512158] Starting subtest: basic-contexts-all
[440.870505] Subtest basic-contexts-all: SUCCESS (11.356s)
[441.069558] [082/133] (581s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[441.168838] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[441.170828] Starting dynamic subtest: pipe-A-eDP-1
[441.191379] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.023s)
[441.207282] Starting dynamic subtest: pipe-B-eDP-1
[441.227261] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.023s)
[441.236899] Starting dynamic subtest: pipe-C-eDP-1
[441.256983] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[441.266551] Starting dynamic subtest: pipe-D-eDP-1
[441.286676] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[441.288884] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.094s)
[443.541432] [083/133] (578s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[443.652823] Starting subtest: psr-rgb101010-draw-blt
[450.934541] Subtest psr-rgb101010-draw-blt: SUCCESS (7.284s)
[451.049720] [084/133] (571s left) core_setmaster (master-drop-set-shared-fd)
[451.144585] Starting subtest: master-drop-set-shared-fd
[451.163352] Subtest master-drop-set-shared-fd: SUCCESS (0.021s)
[451.203106] [085/133] (571s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[451.292507] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[458.031042] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.742s)
[458.167886] [086/133] (564s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[458.270719] Starting subtest: psr-rgb565-draw-render
[465.324959] Subtest psr-rgb565-draw-render: SUCCESS (7.057s)
[465.424435] [087/133] (557s left) kms_sequence (get-forked-busy)
[465.519883] Starting subtest: get-forked-busy
[465.521728] Starting dynamic subtest: pipe-A-eDP-1
[467.453979] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.934s)
[467.464355] Starting dynamic subtest: pipe-B-eDP-1
[470.031218] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.577s)
[470.041499] Starting dynamic subtest: pipe-C-eDP-1
[472.635812] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.602s)
[472.645690] Starting dynamic subtest: pipe-D-eDP-1
[475.194017] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.555s)
[475.195974] Subtest get-forked-busy: SUCCESS (9.673s)
[476.071122] [088/133] (546s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[476.163612] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[476.168574] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[476.262321] [089/133] (546s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[476.328059] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[476.330448] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[476.440989] [090/133] (546s left) syncobj_wait (single-wait-for-submit-signaled)
[476.487510] Starting subtest: single-wait-for-submit-signaled
[476.489925] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[476.567735] [091/133] (546s left) kms_dsc (dsc-fractional-bpp)
[476.654153] Starting subtest: dsc-fractional-bpp
[476.667442] Subtest dsc-fractional-bpp: SKIP (0.000s)
[476.726089] [092/133] (546s left) syncobj_wait (wait-all-snapshot)
[476.787056] Starting subtest: wait-all-snapshot
[476.869596] Subtest wait-all-snapshot: SUCCESS (0.082s)
[476.959579] [093/133] (545s left) kms_content_protection (legacy-hdcp14)
[477.105680] Starting subtest: legacy-hdcp14
[477.109561] Subtest legacy-hdcp14: SKIP (0.000s)
[477.234315] [094/133] (545s left) gem_exec_balancer (waits)
[477.280051] Starting subtest: waits
[483.817031] Subtest waits: SUCCESS (6.533s)
[484.120399] [095/133] (538s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[484.225769] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[484.228070] Starting dynamic subtest: pipe-A-eDP-1
[484.236924] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[484.246785] Starting dynamic subtest: pipe-B-eDP-1
[484.255582] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[484.264427] Starting dynamic subtest: pipe-C-eDP-1
[484.272842] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[484.281591] Starting dynamic subtest: pipe-D-eDP-1
[484.290162] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[484.294324] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[486.540211] [096/133] (536s left) i915_hangman (engine-error-state-capture)
[486.603999] Starting subtest: engine-error-state-capture
[486.606125] Starting dynamic subtest: rcs0
[490.303442] Dynamic subtest rcs0: SUCCESS (3.699s)
[490.316186] Starting dynamic subtest: bcs0
[496.319100] Dynamic subtest bcs0: SUCCESS (6.012s)
[496.330048] Starting dynamic subtest: vcs0
[501.310989] Dynamic subtest vcs0: SUCCESS (4.990s)
[501.320816] Starting dynamic subtest: vcs1
[507.263784] Dynamic subtest vcs1: SUCCESS (5.950s)
[507.276212] Starting dynamic subtest: vecs0
[513.279802] Dynamic subtest vecs0: SUCCESS (6.013s)
[513.299327] Starting dynamic subtest: ccs0
[519.296995] Dynamic subtest ccs0: SUCCESS (6.014s)
[519.299998] Subtest engine-error-state-capture: SUCCESS (32.694s)
[519.392171] [097/133] (503s left) perf_pmu (rc6-suspend)
[519.442943] Starting subtest: rc6-suspend
[542.276995] Subtest rc6-suspend: SUCCESS (8.840s)
[546.171660] [098/133] (479s left) gem_exec_parallel (basic)
[546.250380] Starting subtest: basic
[546.252839] Starting dynamic subtest: rcs0
[547.779043] Dynamic subtest rcs0: SUCCESS (1.523s)
[547.792513] Starting dynamic subtest: bcs0
[549.282055] Dynamic subtest bcs0: SUCCESS (1.496s)
[549.293541] Starting dynamic subtest: vcs0
[551.306855] Dynamic subtest vcs0: SUCCESS (2.016s)
[551.319188] Starting dynamic subtest: vcs1
[553.355199] Dynamic subtest vcs1: SUCCESS (2.042s)
[553.368067] Starting dynamic subtest: vecs0
[555.338245] Dynamic subtest vecs0: SUCCESS (1.977s)
[555.351167] Starting dynamic subtest: ccs0
[556.825825] Dynamic subtest ccs0: SUCCESS (1.484s)
[556.828297] Subtest basic: SUCCESS (10.555s)
[557.043575] [099/133] (469s left) kms_psr (psr-primary-blt)
[557.151033] Starting subtest: psr-primary-blt
[557.153256] Starting dynamic subtest: eDP-1
[558.875255] Dynamic subtest eDP-1: SUCCESS (1.720s)
[558.877529] Subtest psr-primary-blt: SUCCESS (1.721s)
[559.740348] [100/133] (466s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[559.796494] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[559.878681] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.026s)
[559.924043] [101/133] (466s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[560.020238] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[563.627467] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.607s)
[564.852826] [102/133] (461s left) kms_prop_blob (blob-prop-lifetime)
[564.913446] Starting subtest: blob-prop-lifetime
[564.915356] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[565.031390] [103/133] (461s left) gem_userptr_blits (readonly-unsync)
[565.108204] Subtest readonly-unsync: SKIP (0.000s)
[565.230297] [104/133] (461s left) perf (polling)
[565.324799] Starting subtest: polling
[565.327207] Starting dynamic subtest: 0-rcs0
[575.334625] Dynamic subtest 0-rcs0: SUCCESS (10.002s)
[575.346285] Starting dynamic subtest: 1-vcs1
[585.358828] Dynamic subtest 1-vcs1: SUCCESS (10.019s)
[585.361627] Subtest polling: SUCCESS (20.023s)
[585.409677] [105/133] (440s left) i915_query (query-topology-kernel-writes)
[585.481517] Starting subtest: query-topology-kernel-writes
[585.483863] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[585.594335] [106/133] (440s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[585.686079] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[586.733411] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.047s)
[586.860822] [107/133] (439s left) kms_psr (fbc-pr-sprite-blt)
[586.951600] Starting subtest: fbc-pr-sprite-blt
[586.955374] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[587.026706] [108/133] (439s left) prime_self_import (basic-with_two_bos)
[587.066379] Starting subtest: basic-with_two_bos
[587.081816] Subtest basic-with_two_bos: SUCCESS (0.016s)
[587.187971] [109/133] (439s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[587.291773] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[588.431792] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.136s)
[588.542041] [110/133] (437s left) gem_exec_reloc (basic-cpu-read)
[588.606206] Subtest basic-cpu-read: SKIP (0.000s)
[588.689604] [111/133] (437s left) gem_ctx_shared (exec-shared-gtt)
[588.747036] Starting subtest: exec-shared-gtt
[588.748967] Starting dynamic subtest: rcs0
[588.757526] Dynamic subtest rcs0: SUCCESS (0.010s)
[588.768190] Starting dynamic subtest: bcs0
[588.769715] Dynamic subtest bcs0: SUCCESS (0.006s)
[588.779770] Starting dynamic subtest: vcs0
[588.781822] Dynamic subtest vcs0: SUCCESS (0.007s)
[588.792695] Starting dynamic subtest: vcs1
[588.794473] Dynamic subtest vcs1: SUCCESS (0.008s)
[588.804465] Starting dynamic subtest: vecs0
[588.806206] Dynamic subtest vecs0: SUCCESS (0.006s)
[588.816171] Starting dynamic subtest: ccs0
[588.818030] Dynamic subtest ccs0: SUCCESS (0.006s)
[588.819973] Subtest exec-shared-gtt: SUCCESS (0.047s)
[588.989222] [112/133] (437s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[589.086799] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[589.088753] Starting dynamic subtest: pipe-A
[589.113425] Dynamic subtest pipe-A: SKIP (0.023s)
[589.124053] Starting dynamic subtest: pipe-B
[589.144195] Dynamic subtest pipe-B: SKIP (0.030s)
[589.154432] Starting dynamic subtest: pipe-C
[589.176299] Dynamic subtest pipe-C: SKIP (0.031s)
[589.186224] Starting dynamic subtest: pipe-D
[589.206136] Dynamic subtest pipe-D: SKIP (0.030s)
[589.209313] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.118s)
[589.324840] [113/133] (437s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[589.419293] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[596.787546] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.369s)
[596.916023] [114/133] (429s left) kms_getfb (getfb-handle-protection)
[597.013853] Starting subtest: getfb-handle-protection
[597.030807] Subtest getfb-handle-protection: SUCCESS (0.019s)
[597.168645] [115/133] (429s left) gem_ctx_persistence (process)
[597.238331] Starting subtest: process
[597.413276] Subtest process: SUCCESS (0.174s)
[597.498988] [116/133] (429s left) i915_selftest (mock)
[600.835980] Starting subtest: mock
[600.845438] Starting dynamic subtest: sanitycheck
[601.534298] Dynamic subtest sanitycheck: SUCCESS (0.698s)
[601.544700] Starting dynamic subtest: shmem
[602.199270] Dynamic subtest shmem: SUCCESS (0.663s)
[602.209691] Starting dynamic subtest: fence
[610.437807] Dynamic subtest fence: SUCCESS (8.233s)
[610.448634] Starting dynamic subtest: scatterlist
[612.124589] Dynamic subtest scatterlist: SUCCESS (1.684s)
[612.135572] Starting dynamic subtest: syncmap
[615.273585] Dynamic subtest syncmap: SUCCESS (3.146s)
[615.284526] Starting dynamic subtest: uncore
[615.952291] Dynamic subtest uncore: SUCCESS (0.677s)
[615.963243] Starting dynamic subtest: ring
[616.653674] Dynamic subtest ring: SUCCESS (0.699s)
[616.664384] Starting dynamic subtest: engine
[617.322066] Dynamic subtest engine: SUCCESS (0.666s)
[617.332807] Starting dynamic subtest: timelines
[621.222745] Dynamic subtest timelines: SUCCESS (3.897s)
[621.231321] Starting dynamic subtest: requests
[624.699205] Dynamic subtest requests: SUCCESS (3.472s)
[624.709987] Starting dynamic subtest: objects
[625.476030] Dynamic subtest objects: SUCCESS (0.776s)
[625.486506] Starting dynamic subtest: phys
[626.273148] Dynamic subtest phys: SUCCESS (0.795s)
[626.284119] Starting dynamic subtest: dmabuf
[627.005497] Dynamic subtest dmabuf: SUCCESS (0.730s)
[627.015455] Starting dynamic subtest: vma
[632.716479] Dynamic subtest vma: SUCCESS (5.708s)
[632.727010] Starting dynamic subtest: evict
[634.111585] Dynamic subtest evict: SUCCESS (1.393s)
[634.122481] Starting dynamic subtest: gtt
[637.451825] Dynamic subtest gtt: SUCCESS (3.338s)
[637.467956] Starting dynamic subtest: hugepages
[638.353976] Dynamic subtest hugepages: SUCCESS (0.900s)
[638.364185] Starting dynamic subtest: memory_region
[640.906299] Dynamic subtest memory_region: SUCCESS (2.549s)
[640.909018] Subtest mock: SUCCESS (40.057s)
[640.938056] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[640.938753] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[640.941900] [117/133] (385s left) kms_pm_rpm (legacy-planes-dpms)
[644.446051] Starting subtest: legacy-planes-dpms
[644.448456] Starting dynamic subtest: plane-65
[652.728579] Dynamic subtest plane-65: SUCCESS (8.289s)
[652.741869] Starting dynamic subtest: plane-95
[661.337452] Dynamic subtest plane-95: SUCCESS (8.609s)
[661.349930] Starting dynamic subtest: plane-125
[669.683442] Dynamic subtest plane-125: SUCCESS (8.345s)
[669.696735] Starting dynamic subtest: plane-135
[678.008819] Dynamic subtest plane-135: SUCCESS (8.325s)
[678.011795] Subtest legacy-planes-dpms: SUCCESS (33.579s)
[678.440443] [FACT kms_pm_rpm (legacy-planes-dpms)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[678.441656] [FACT kms_pm_rpm (legacy-planes-dpms)] new: kernel.kmod_is_loaded.i915: true
[678.445632] [118/133] (348s left) kms_cursor_crc (cursor-random-32x10)
[678.613381] Starting subtest: cursor-random-32x10
[678.668578] Subtest cursor-random-32x10: SKIP (0.050s)
[678.935872] [119/133] (347s left) kms_cursor_crc (cursor-offscreen-32x32)
[679.084888] Starting subtest: cursor-offscreen-32x32
[679.139079] Subtest cursor-offscreen-32x32: SKIP (0.049s)
[679.422295] [120/133] (347s left) syncobj_wait (single-wait-all-for-submit-submitted)
[679.477547] Starting subtest: single-wait-all-for-submit-submitted
[679.582542] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.104s)
[679.659749] [121/133] (347s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[679.724536] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[679.786958] [122/133] (347s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[679.842051] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[679.844143] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[679.945838] [123/133] (347s left) kms_chamelium_hpd (hdmi-hpd)
[680.333297] Subtest hdmi-hpd: SKIP (0.000s)
[681.112571] [124/133] (346s left) gem_exec_reloc (basic-gtt-noreloc)
[681.171059] Subtest basic-gtt-noreloc: SKIP (0.000s)
[681.247439] [125/133] (345s left) kms_flip (2x-wf_vblank-ts-check)
[681.347579] Starting subtest: 2x-wf_vblank-ts-check
[681.356312] Subtest 2x-wf_vblank-ts-check: SKIP (0.011s)
[681.447603] [126/133] (345s left) kms_psr (pr-primary-mmap-cpu)
[681.537700] Starting subtest: pr-primary-mmap-cpu
[681.542074] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[681.611508] [127/133] (345s left) gem_readwrite (read-write)
[681.669018] Subtest read-write: SKIP (0.000s)
[681.729657] [128/133] (345s left) fbdev (write)
[681.776524] Starting subtest: write
[682.138693] Subtest write: SUCCESS (0.360s)
[682.206553] [129/133] (345s left) kms_dp_aux_dev (basic)
[682.262290] Starting subtest: basic
[682.485037] Subtest basic: SUCCESS (0.221s)
[682.570154] [130/133] (344s left) kms_psr (fbc-psr2-sprite-render)
[682.660556] Starting subtest: fbc-psr2-sprite-render
[682.662907] Starting dynamic subtest: eDP-1
[682.667261] Dynamic subtest eDP-1: SKIP (0.000s)
[682.671550] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[682.733893] [131/133] (344s left) gem_ctx_persistence (engines-cleanup)
[682.789918] Starting subtest: engines-cleanup
[682.792282] Starting dynamic subtest: rcs0
[682.826659] Dynamic subtest rcs0: SUCCESS (0.037s)
[682.838488] Starting dynamic subtest: bcs0
[682.887821] Dynamic subtest bcs0: SUCCESS (0.060s)
[682.900394] Starting dynamic subtest: vcs0
[682.928818] Dynamic subtest vcs0: SUCCESS (0.040s)
[682.938964] Starting dynamic subtest: vcs1
[682.965990] Dynamic subtest vcs1: SUCCESS (0.035s)
[682.975641] Starting dynamic subtest: vecs0
[683.001649] Dynamic subtest vecs0: SUCCESS (0.034s)
[683.011546] Starting dynamic subtest: ccs0
[683.022585] Dynamic subtest ccs0: SUCCESS (0.019s)
[683.024827] Subtest engines-cleanup: SUCCESS (0.233s)
[683.137858] [132/133] (344s left) sysfs_heartbeat_interval (idempotent)
[683.186335] Starting subtest: idempotent
[683.188649] Starting dynamic subtest: vecs0
[683.191041] Dynamic subtest vecs0: SUCCESS (0.001s)
[683.202763] Starting dynamic subtest: ccs0
[683.204625] Dynamic subtest ccs0: SUCCESS (0.001s)
[683.213960] Starting dynamic subtest: vcs0
[683.216161] Dynamic subtest vcs0: SUCCESS (0.000s)
[683.227200] Starting dynamic subtest: bcs0
[683.229431] Dynamic subtest bcs0: SUCCESS (0.001s)
[683.238312] Starting dynamic subtest: rcs0
[683.240161] Dynamic subtest rcs0: SUCCESS (0.001s)
[683.249755] Starting dynamic subtest: vcs1
[683.251983] Dynamic subtest vcs1: SUCCESS (0.000s)
[683.254186] Subtest idempotent: SUCCESS (0.009s)
[683.293534] [133/133] (344s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[683.401001] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[690.492064] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.093s)
[690.596065] 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.