[57.312081] Initializing watchdogs
[57.312128]   /dev/watchdog0
[57.326688] [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]
[57.331026] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.333220] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.336958] [001/133] (960s left) gem_pxp (create-regular-buffer)
[57.505945] Starting subtest: create-regular-buffer
[57.508184] Subtest create-regular-buffer: SUCCESS (0.000s)
[57.628958] [002/133] (960s left) kms_pm_rpm (basic-pci-d3-state)
[59.406839] Starting subtest: basic-pci-d3-state
[60.884583] Subtest basic-pci-d3-state: SUCCESS (1.467s)
[61.003645] [003/133] (956s left) gem_wait (wait)
[61.061089] Starting subtest: wait
[61.063454] Starting dynamic subtest: all-engines
[62.264763] Dynamic subtest all-engines: SUCCESS (1.192s)
[62.273815] Starting dynamic subtest: rcs0
[63.311316] Dynamic subtest rcs0: SUCCESS (1.040s)
[63.321323] Starting dynamic subtest: bcs0
[64.357705] Dynamic subtest bcs0: SUCCESS (1.039s)
[64.368079] Starting dynamic subtest: vcs0
[65.401240] Dynamic subtest vcs0: SUCCESS (1.038s)
[65.411255] Starting dynamic subtest: vcs1
[66.447061] Dynamic subtest vcs1: SUCCESS (1.039s)
[66.458755] Starting dynamic subtest: vecs0
[67.492076] Dynamic subtest vecs0: SUCCESS (1.040s)
[67.504420] Starting dynamic subtest: ccs0
[68.542157] Dynamic subtest ccs0: SUCCESS (1.043s)
[68.544676] Subtest wait: SUCCESS (7.437s)
[68.735828] [004/133] (949s left) gem_exec_gttfill (engines)
[68.802632] Starting subtest: engines
[68.805115] Starting dynamic subtest: rcs0
[92.251784] Dynamic subtest rcs0: SUCCESS (23.424s)
[92.260852] Starting dynamic subtest: bcs0
[115.471098] Dynamic subtest bcs0: SUCCESS (23.215s)
[115.481381] Starting dynamic subtest: vcs0
[138.706275] Dynamic subtest vcs0: SUCCESS (23.232s)
[138.714575] Starting dynamic subtest: vcs1
[161.919086] Dynamic subtest vcs1: SUCCESS (23.210s)
[161.930787] Starting dynamic subtest: vecs0
[185.161912] Dynamic subtest vecs0: SUCCESS (23.242s)
[185.169876] Starting dynamic subtest: ccs0
[208.438328] Dynamic subtest ccs0: SUCCESS (23.274s)
[208.440984] Subtest engines: SUCCESS (139.600s)
[208.624948] [005/133] (809s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[208.782187] Starting subtest: fbcpsr-2p-rte
[208.786716] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[208.879912] [006/133] (809s left) kms_psr (fbc-pr-no-drrs)
[208.981741] Starting subtest: fbc-pr-no-drrs
[208.985743] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[209.065116] [007/133] (809s left) perf (gen12-group-concurrent-oa-buffer-read)
[209.217314] Starting subtest: gen12-group-concurrent-oa-buffer-read
[219.269688] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.052s)
[219.314548] [008/133] (798s left) gem_softpin (full)
[219.378979] Starting subtest: full
[219.387773] Subtest full: SUCCESS (0.009s)
[219.510053] [009/133] (798s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[219.616800] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[219.621210] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[219.688024] [010/133] (798s left) gem_mmap_gtt (basic-read)
[219.741238] Subtest basic-read: SKIP (0.000s)
[219.792287] [011/133] (798s left) kms_big_fb (linear-32bpp-rotate-180)
[219.891699] Starting subtest: linear-32bpp-rotate-180
[221.448660] Subtest linear-32bpp-rotate-180: SUCCESS (1.558s)
[221.589178] [012/133] (796s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[221.690290] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[221.693822] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[221.802164] [013/133] (796s left) gem_ctx_bad_destroy (invalid-ctx)
[221.860269] Starting subtest: invalid-ctx
[221.862164] Subtest invalid-ctx: SUCCESS (0.000s)
[221.942751] [014/133] (796s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[222.028724] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[222.055161] Starting dynamic subtest: pipe-A-plane-0
[222.355335] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[222.364714] Starting dynamic subtest: pipe-A-plane-3
[222.588266] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[222.596017] Starting dynamic subtest: pipe-A-plane-5
[222.599472] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[223.693637] Starting dynamic subtest: pipe-B-plane-0
[223.997387] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[224.007432] Starting dynamic subtest: pipe-B-plane-3
[224.230783] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[224.240740] Starting dynamic subtest: pipe-B-plane-5
[224.245355] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[224.544813] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.516s)
[225.359759] [015/133] (793s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[225.417970] Starting subtest: single-wait-for-submit-available-signaled
[225.420662] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[225.520345] [016/133] (792s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[225.603203] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[225.605588] Starting dynamic subtest: pipe-A-default-mode
[226.721961] Dynamic subtest pipe-A-default-mode: SKIP (1.116s)
[226.726613] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.117s)
[226.875483] [017/133] (791s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[226.932334] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[226.934654] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[227.048379] [018/133] (791s left) i915_drm_fdinfo (virtual-busy-all)
[227.091102] Starting subtest: virtual-busy-all
[227.095178] Subtest virtual-busy-all: SKIP (0.000s)
[227.159023] [019/133] (791s left) gem_exec_reloc (basic-gtt-read-noreloc)
[227.213299] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[227.275186] [020/133] (791s left) kms_lease (lease-invalid-connector)
[227.373500] Starting subtest: lease-invalid-connector
[227.375773] Starting dynamic subtest: pipe-A-eDP-1
[227.377973] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[227.387615] Starting dynamic subtest: pipe-B-eDP-1
[227.389492] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[227.397528] Starting dynamic subtest: pipe-C-eDP-1
[227.399797] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[227.407949] Starting dynamic subtest: pipe-D-eDP-1
[227.410142] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[227.412228] Subtest lease-invalid-connector: SUCCESS (0.002s)
[227.445697] [021/133] (791s left) gem_pxp (reject-modify-context-protection-off-3)
[227.545356] Starting subtest: reject-modify-context-protection-off-3
[227.547799] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[227.650327] [022/133] (790s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[227.737048] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[227.738964] Starting dynamic subtest: pipe-A-eDP-1
[227.790656] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[227.798931] Starting dynamic subtest: pipe-B-eDP-1
[227.846366] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[227.855086] Starting dynamic subtest: pipe-C-eDP-1
[227.901964] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[227.910625] Starting dynamic subtest: pipe-D-eDP-1
[227.957468] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[227.961166] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[230.052988] [023/133] (788s left) gem_mmap_gtt (fault-concurrent)
[230.107380] Subtest fault-concurrent: SKIP (0.000s)
[230.172755] [024/133] (788s left) kms_addfb_basic (addfb25-4-tiled)
[230.263431] Starting subtest: addfb25-4-tiled
[230.265312] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[230.376691] [025/133] (788s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[230.468604] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[230.471073] Starting dynamic subtest: A-eDP1
[234.087379] Dynamic subtest A-eDP1: SUCCESS (3.616s)
[234.096318] Starting dynamic subtest: B-eDP1
[237.277762] Dynamic subtest B-eDP1: SUCCESS (3.191s)
[237.286597] Starting dynamic subtest: C-eDP1
[240.379726] Dynamic subtest C-eDP1: SUCCESS (3.100s)
[240.389902] Starting dynamic subtest: D-eDP1
[243.520425] Dynamic subtest D-eDP1: SUCCESS (3.138s)
[243.522844] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.052s)
[244.312675] [026/133] (774s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[244.444691] Starting subtest: flip-vs-cursor-busy-crc-legacy
[245.255193] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.808s)
[246.047543] [027/133] (772s left) syncobj_eventfd (timeline-wait-signaled)
[246.098821] Starting subtest: timeline-wait-signaled
[246.100816] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[246.181575] [028/133] (772s left) gem_exec_schedule (u-fairslice)
[246.248955] Starting subtest: u-fairslice
[246.251334] Starting dynamic subtest: rcs0
[248.263979] Dynamic subtest rcs0: SUCCESS (2.019s)
[248.275124] Starting dynamic subtest: bcs0
[250.284695] Dynamic subtest bcs0: SUCCESS (2.022s)
[250.295197] Starting dynamic subtest: vcs0
[252.303886] Dynamic subtest vcs0: SUCCESS (2.017s)
[252.314741] Starting dynamic subtest: vcs1
[254.322754] Dynamic subtest vcs1: SUCCESS (2.019s)
[254.332811] Starting dynamic subtest: vecs0
[256.340987] Dynamic subtest vecs0: SUCCESS (2.018s)
[256.350556] Starting dynamic subtest: ccs0
[258.360412] Dynamic subtest ccs0: SUCCESS (2.020s)
[258.362788] Subtest u-fairslice: SUCCESS (12.118s)
[258.662233] [029/133] (760s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[258.760088] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[258.762636] Starting dynamic subtest: pipe-A-default-mode
[261.484770] Dynamic subtest pipe-A-default-mode: SUCCESS (2.726s)
[261.487245] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.727s)
[262.345772] [030/133] (756s left) gem_exec_whisper (basic-sync-all)
[262.412038] Starting subtest: basic-sync-all
[268.837729] Subtest basic-sync-all: SUCCESS (6.423s)
[269.029757] [031/133] (749s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[269.091307] Starting subtest: etime-multi-wait-available-unsubmitted
[269.198436] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.107s)
[269.276147] [032/133] (749s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[269.378668] Starting subtest: random-ccs-data-y-tiled-ccs
[269.380799] Starting dynamic subtest: pipe-A-eDP-1
[269.405497] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[269.415665] Starting dynamic subtest: pipe-B-eDP-1
[269.438453] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[269.446673] Starting dynamic subtest: pipe-C-eDP-1
[269.470172] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[269.478457] Starting dynamic subtest: pipe-D-eDP-1
[269.503243] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[269.507632] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.003s)
[271.620859] [033/133] (747s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[271.722076] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[271.724509] Starting dynamic subtest: pipe-A-eDP-1
[271.745142] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[271.756688] Starting dynamic subtest: pipe-B-eDP-1
[271.776262] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[271.785076] Starting dynamic subtest: pipe-C-eDP-1
[271.805049] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[271.813585] Starting dynamic subtest: pipe-D-eDP-1
[271.833239] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[271.835256] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[273.972220] [034/133] (745s left) kms_addfb_basic (basic)
[274.033627] Starting subtest: basic
[274.035961] Subtest basic: SUCCESS (0.000s)
[274.172806] [035/133] (744s left) kms_color_pipeline (plane-lut1d-lut1d)
[274.267688] Starting subtest: plane-lut1d-lut1d
[274.414641] Starting dynamic subtest: pipe-A-plane-0
[274.581555] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[274.591359] Starting dynamic subtest: pipe-A-plane-1
[274.736417] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[274.745711] Starting dynamic subtest: pipe-A-plane-2
[274.913947] Dynamic subtest pipe-A-plane-2: SUCCESS (0.177s)
[276.084120] Starting dynamic subtest: pipe-B-plane-0
[276.242346] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[276.251926] Starting dynamic subtest: pipe-B-plane-1
[276.420638] Dynamic subtest pipe-B-plane-1: SUCCESS (0.177s)
[276.433431] Starting dynamic subtest: pipe-B-plane-2
[276.598177] Dynamic subtest pipe-B-plane-2: SUCCESS (0.177s)
[277.825429] Starting dynamic subtest: pipe-C-plane-0
[277.985710] Dynamic subtest pipe-C-plane-0: SUCCESS (0.166s)
[277.997466] Starting dynamic subtest: pipe-C-plane-1
[278.129816] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[278.140653] Starting dynamic subtest: pipe-C-plane-2
[278.285146] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[279.448640] Starting dynamic subtest: pipe-D-plane-0
[279.584801] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[279.594892] Starting dynamic subtest: pipe-D-plane-1
[279.730645] Dynamic subtest pipe-D-plane-1: SUCCESS (0.145s)
[279.747945] Starting dynamic subtest: pipe-D-plane-2
[279.884748] Dynamic subtest pipe-D-plane-2: SUCCESS (0.153s)
[280.178826] Subtest plane-lut1d-lut1d: SUCCESS (5.911s)
[281.034169] [036/133] (738s left) api_intel_allocator (standalone)
[281.094611] Starting subtest: standalone
[281.112974] Subtest standalone: SUCCESS (0.019s)
[281.236040] [037/133] (737s left) prime_self_import (basic-llseek-bad)
[281.271150] Starting subtest: basic-llseek-bad
[281.287285] Subtest basic-llseek-bad: SUCCESS (0.018s)
[281.386782] [038/133] (737s left) kms_vblank (query-forked)
[281.475974] Starting subtest: query-forked
[281.478239] Starting dynamic subtest: pipe-A-eDP-1
[283.293651] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.816s)
[283.310396] Starting dynamic subtest: pipe-D-eDP-1
[285.838188] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.544s)
[285.840621] Subtest query-forked: SUCCESS (4.363s)
[286.709406] [039/133] (732s left) gem_exec_flush (basic-uc-ro-default)
[286.767559] Starting subtest: basic-uc-ro-default
[292.216272] Subtest basic-uc-ro-default: SUCCESS (5.450s)
[292.400731] [040/133] (726s left) perf (per-context-mode-unprivileged)
[292.483101] Starting subtest: per-context-mode-unprivileged
[292.487621] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[292.522091] [041/133] (726s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[292.623215] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[292.627441] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[292.718311] [042/133] (726s left) i915_pm_rps (min-max-config-idle)
[292.776619] Starting subtest: min-max-config-idle
[292.780976] Subtest min-max-config-idle: SKIP (0.001s)
[292.875957] [043/133] (726s left) gem_exec_balancer (busy)
[292.933124] Starting subtest: busy
[294.271112] Subtest busy: SUCCESS (1.336s)
[294.587112] [044/133] (724s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[294.676745] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[294.681072] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[294.769859] [045/133] (724s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[294.862448] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[294.866786] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[294.965746] [046/133] (724s left) gem_mmap_gtt (big-bo-tiledy)
[295.014603] Subtest big-bo-tiledY: SKIP (0.000s)
[295.072576] [047/133] (724s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[295.159118] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[302.609091] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.453s)
[302.734368] [048/133] (716s left) kms_chamelium_edid (vga-edid-read)
[303.136626] Subtest vga-edid-read: SKIP (0.000s)
[303.928190] [049/133] (715s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[304.028814] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[310.990204] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.963s)
[311.147662] [050/133] (708s left) gem_create (hog-create)
[311.215623] Starting subtest: hog-create
[311.217634] Starting dynamic subtest: smem0
[344.314251] Dynamic subtest smem0: SUCCESS (33.098s)
[344.316808] Subtest hog-create: SUCCESS (33.100s)
[344.521054] [051/133] (675s left) kms_getfb (getfb-repeated-different-handles)
[344.615295] Starting subtest: getfb-repeated-different-handles
[344.617727] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[344.723297] [052/133] (675s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[344.825975] Starting subtest: y-tiled-64bpp-rotate-0
[344.830466] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[344.929878] [053/133] (674s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[345.020518] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[345.024582] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[345.100044] [054/133] (674s left) api_intel_bb (simple-bb)
[345.158879] Starting subtest: simple-bb
[345.161980] Subtest simple-bb: SUCCESS (0.006s)
[345.280272] [055/133] (674s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[345.381237] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[345.385579] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[345.462020] [056/133] (674s left) kms_flip (blocking-wf_vblank)
[345.550362] Starting subtest: blocking-wf_vblank
[345.552296] Starting dynamic subtest: A-eDP1
[354.497353] Dynamic subtest A-eDP1: SUCCESS (8.945s)
[354.509887] Starting dynamic subtest: B-eDP1
[363.432134] Dynamic subtest B-eDP1: SUCCESS (8.932s)
[363.444104] Starting dynamic subtest: C-eDP1
[372.360313] Dynamic subtest C-eDP1: SUCCESS (8.924s)
[372.373515] Starting dynamic subtest: D-eDP1
[381.294294] Dynamic subtest D-eDP1: SUCCESS (8.933s)
[381.300457] Subtest blocking-wf_vblank: SUCCESS (35.748s)
[382.528478] [057/133] (637s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[382.648547] Starting subtest: cursorA-vs-flipB-atomic-transitions
[382.653029] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[382.790429] [058/133] (637s left) gem_mmap_offset (bad-flags)
[382.840862] Starting subtest: bad-flags
[382.842763] Subtest bad-flags: SUCCESS (0.000s)
[382.951601] [059/133] (637s left) vgem_basic (create)
[383.073464] Starting subtest: create
[383.075617] Subtest create: SUCCESS (0.000s)
[383.125164] [FACT vgem_basic (create)] new: kernel.kmod_is_loaded.vgem: true
[383.128505] [060/133] (637s left) kms_atomic (plane-primary-legacy)
[383.215147] Starting subtest: plane-primary-legacy
[383.217596] Starting dynamic subtest: pipe-A-eDP-1
[383.655161] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.440s)
[383.657642] Subtest plane-primary-legacy: SUCCESS (0.442s)
[384.461474] [061/133] (635s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[384.558714] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[384.563030] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[384.660248] [062/133] (635s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[384.712654] Starting subtest: invalid-single-wait-unsubmitted
[384.714778] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[384.798472] [063/133] (635s left) kms_psr (psr-cursor-render)
[384.883197] Starting subtest: psr-cursor-render
[384.885455] Starting dynamic subtest: eDP-1
[386.654510] Dynamic subtest eDP-1: SUCCESS (1.772s)
[386.656776] Subtest psr-cursor-render: SUCCESS (1.773s)
[387.532303] [064/133] (632s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[387.616434] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[387.618600] Starting dynamic subtest: pipe-A-eDP-1
[387.640925] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[387.652126] Starting dynamic subtest: pipe-B-eDP-1
[387.673559] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[387.682885] Starting dynamic subtest: pipe-C-eDP-1
[387.704931] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[387.713986] Starting dynamic subtest: pipe-D-eDP-1
[387.736178] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[387.740198] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[389.831776] [065/133] (630s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[390.353819] Starting subtest: syncobj-timeline-invalid-flags
[390.355890] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[391.360820] [066/133] (629s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[391.463077] Starting subtest: stress-xrgb8888-ytiled
[391.467592] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[391.539720] [067/133] (628s left) gem_sync (basic-each)
[391.605281] Starting subtest: basic-each
[393.860367] Subtest basic-each: SUCCESS (2.265s)
[394.044288] [068/133] (626s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[394.138700] Starting subtest: x-tiled-8bpp-rotate-0
[395.342852] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.204s)
[395.455702] [069/133] (625s left) sw_sync (sync_expired_merge)
[395.496954] Starting subtest: sync_expired_merge
[396.570800] Subtest sync_expired_merge: SUCCESS (1.074s)
[396.631757] [070/133] (623s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[396.724968] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[401.301621] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.580s)
[402.435758] [071/133] (618s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[402.525753] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[402.530255] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[402.633865] [072/133] (618s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[402.727331] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[402.731749] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[402.842457] [073/133] (617s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[402.926059] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[402.928335] Starting dynamic subtest: pipe-A
[404.085750] Dynamic subtest pipe-A: SUCCESS (1.162s)
[404.095579] Starting dynamic subtest: pipe-B
[406.318639] Dynamic subtest pipe-B: SUCCESS (2.231s)
[406.331801] Starting dynamic subtest: pipe-C
[407.524557] Dynamic subtest pipe-C: SUCCESS (1.204s)
[407.533978] Starting dynamic subtest: pipe-D
[408.752524] Dynamic subtest pipe-D: SUCCESS (1.227s)
[408.755049] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.830s)
[409.985443] [074/133] (610s left) kms_cursor_edge_walk (64x64-top-bottom)
[410.086378] Starting subtest: 64x64-top-bottom
[410.088692] Starting dynamic subtest: pipe-A-eDP-1
[413.514771] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.428s)
[413.524863] Starting dynamic subtest: pipe-D-eDP-1
[416.640846] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s)
[416.643274] Subtest 64x64-top-bottom: SUCCESS (6.555s)
[417.473217] [075/133] (603s left) kms_joiner (basic-ultra-joiner)
[417.573105] Starting subtest: basic-ultra-joiner
[417.577165] Subtest basic-ultra-joiner: SKIP (0.000s)
[417.640191] [076/133] (603s left) gen9_exec_parse (bb-start-param)
[417.709519] Subtest bb-start-param: SKIP (0.000s)
[417.776848] [077/133] (603s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[417.866416] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[424.759974] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.896s)
[424.897855] [078/133] (595s left) sw_sync (sync_multi_consumer)
[424.938068] Starting subtest: sync_multi_consumer
[425.360580] Subtest sync_multi_consumer: SUCCESS (0.423s)
[425.423039] [079/133] (595s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[425.478482] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[425.482772] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[425.656677] [080/133] (595s left) gem_exec_schedule (pi-common)
[425.836532] Starting subtest: pi-common
[425.838990] Starting dynamic subtest: rcs0
[425.861587] Dynamic subtest rcs0: SUCCESS (0.028s)
[425.876470] Starting dynamic subtest: bcs0
[425.891080] Dynamic subtest bcs0: SUCCESS (0.029s)
[425.903578] Starting dynamic subtest: vcs0
[425.921136] Dynamic subtest vcs0: SUCCESS (0.029s)
[425.934708] Starting dynamic subtest: vcs1
[425.948194] Dynamic subtest vcs1: SUCCESS (0.026s)
[425.961806] Starting dynamic subtest: vecs0
[425.976198] Dynamic subtest vecs0: SUCCESS (0.027s)
[425.988148] Starting dynamic subtest: ccs0
[426.004232] Dynamic subtest ccs0: SUCCESS (0.027s)
[426.006332] Subtest pi-common: SUCCESS (0.172s)
[426.235909] [081/133] (594s left) gem_exec_whisper (basic-contexts-all)
[426.297698] Starting subtest: basic-contexts-all
[437.548089] Subtest basic-contexts-all: SUCCESS (11.245s)
[437.724910] [082/133] (583s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[437.816874] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[437.818705] Starting dynamic subtest: pipe-A-eDP-1
[437.838334] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[437.849529] Starting dynamic subtest: pipe-B-eDP-1
[437.869648] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[437.881202] Starting dynamic subtest: pipe-C-eDP-1
[437.901147] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[437.914188] Starting dynamic subtest: pipe-D-eDP-1
[437.933805] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s)
[437.936080] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.091s)
[440.202084] [083/133] (580s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[440.296572] Starting subtest: psr-rgb101010-draw-blt
[447.654158] Subtest psr-rgb101010-draw-blt: SUCCESS (7.360s)
[447.792844] [084/133] (573s left) core_setmaster (master-drop-set-shared-fd)
[447.876559] Starting subtest: master-drop-set-shared-fd
[447.894875] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[447.936696] [085/133] (573s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[448.023274] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[454.835874] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.815s)
[454.964574] [086/133] (566s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[455.069652] Starting subtest: psr-rgb565-draw-render
[462.119641] Subtest psr-rgb565-draw-render: SUCCESS (7.052s)
[462.241822] [087/133] (559s left) kms_sequence (get-forked-busy)
[462.341314] Starting subtest: get-forked-busy
[462.343651] Starting dynamic subtest: pipe-A-eDP-1
[464.278072] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.937s)
[464.288720] Starting dynamic subtest: pipe-B-eDP-1
[466.913094] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.634s)
[466.923433] Starting dynamic subtest: pipe-C-eDP-1
[469.536142] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.620s)
[469.546911] Starting dynamic subtest: pipe-D-eDP-1
[472.163172] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.626s)
[472.165474] Subtest get-forked-busy: SUCCESS (9.825s)
[473.054044] [088/133] (548s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[473.158415] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[473.162658] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[473.270969] [089/133] (548s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[473.335228] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[473.337417] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[473.441064] [090/133] (547s left) syncobj_wait (single-wait-for-submit-signaled)
[473.494411] Starting subtest: single-wait-for-submit-signaled
[473.496708] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[473.589136] [091/133] (547s left) kms_dsc (dsc-fractional-bpp)
[473.692488] Starting subtest: dsc-fractional-bpp
[473.705768] Subtest dsc-fractional-bpp: SKIP (0.000s)
[473.780259] [092/133] (547s left) syncobj_wait (wait-all-snapshot)
[473.831093] Starting subtest: wait-all-snapshot
[473.911909] Subtest wait-all-snapshot: SUCCESS (0.082s)
[473.989315] [093/133] (547s left) kms_content_protection (legacy-hdcp14)
[474.137713] Starting subtest: legacy-hdcp14
[474.141652] Subtest legacy-hdcp14: SKIP (0.000s)
[474.285967] [094/133] (547s left) gem_exec_balancer (waits)
[474.337181] Starting subtest: waits
[480.862771] Subtest waits: SUCCESS (6.520s)
[481.164987] [095/133] (540s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[481.266875] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[481.269321] Starting dynamic subtest: pipe-A-eDP-1
[481.278694] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[481.290661] Starting dynamic subtest: pipe-B-eDP-1
[481.299685] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[481.309822] Starting dynamic subtest: pipe-C-eDP-1
[481.318103] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[481.327157] Starting dynamic subtest: pipe-D-eDP-1
[481.335548] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[481.339846] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[483.426775] [096/133] (538s left) i915_hangman (engine-error-state-capture)
[483.494063] Starting subtest: engine-error-state-capture
[483.496632] Starting dynamic subtest: rcs0
[487.255065] Dynamic subtest rcs0: SUCCESS (3.760s)
[487.268429] Starting dynamic subtest: bcs0
[493.209346] Dynamic subtest bcs0: SUCCESS (5.951s)
[493.224090] Starting dynamic subtest: vcs0
[498.200588] Dynamic subtest vcs0: SUCCESS (4.988s)
[498.213751] Starting dynamic subtest: vcs1
[503.191032] Dynamic subtest vcs1: SUCCESS (4.987s)
[503.204187] Starting dynamic subtest: vecs0
[508.184274] Dynamic subtest vecs0: SUCCESS (4.991s)
[508.196846] Starting dynamic subtest: ccs0
[513.240806] Dynamic subtest ccs0: SUCCESS (5.053s)
[513.243977] Subtest engine-error-state-capture: SUCCESS (29.747s)
[513.376497] [097/133] (508s left) perf_pmu (rc6-suspend)
[513.420043] Starting subtest: rc6-suspend
[535.544492] Subtest rc6-suspend: SUCCESS (8.465s)
[536.594881] [098/133] (485s left) gem_exec_parallel (basic)
[536.669674] Starting subtest: basic
[536.672188] Starting dynamic subtest: rcs0
[538.681161] Dynamic subtest rcs0: SUCCESS (1.983s)
[538.692741] Starting dynamic subtest: bcs0
[540.313083] Dynamic subtest bcs0: SUCCESS (1.612s)
[540.325439] Starting dynamic subtest: vcs0
[543.868197] Dynamic subtest vcs0: SUCCESS (3.524s)
[543.882496] Starting dynamic subtest: vcs1
[545.851537] Dynamic subtest vcs1: SUCCESS (1.970s)
[545.863479] Starting dynamic subtest: vecs0
[547.837512] Dynamic subtest vecs0: SUCCESS (1.975s)
[547.849087] Starting dynamic subtest: ccs0
[549.718450] Dynamic subtest ccs0: SUCCESS (1.873s)
[549.721380] Subtest basic: SUCCESS (12.949s)
[549.909496] [099/133] (471s left) kms_psr (psr-primary-blt)
[550.006161] Starting subtest: psr-primary-blt
[550.008577] Starting dynamic subtest: eDP-1
[551.753421] Dynamic subtest eDP-1: SUCCESS (1.741s)
[551.755988] Subtest psr-primary-blt: SUCCESS (1.742s)
[552.626011] [100/133] (469s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[552.691980] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[552.784126] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.028s)
[552.823093] [101/133] (469s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[552.928920] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[556.511971] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.582s)
[557.735970] [102/133] (464s left) kms_prop_blob (blob-prop-lifetime)
[557.803083] Starting subtest: blob-prop-lifetime
[557.805945] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[557.897897] [103/133] (464s left) gem_userptr_blits (readonly-unsync)
[557.974984] Subtest readonly-unsync: SKIP (0.000s)
[558.086853] [104/133] (463s left) perf (polling)
[558.184593] Starting subtest: polling
[558.187930] Starting dynamic subtest: 0-rcs0
[568.206073] Dynamic subtest 0-rcs0: SUCCESS (10.014s)
[568.217621] Starting dynamic subtest: 1-vcs0
[578.232391] Dynamic subtest 1-vcs0: SUCCESS (10.022s)
[578.235145] Subtest polling: SUCCESS (20.039s)
[578.286712] [105/133] (443s left) i915_query (query-topology-kernel-writes)
[578.339276] Starting subtest: query-topology-kernel-writes
[578.341399] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[578.431768] [106/133] (443s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[578.540632] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[579.587035] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.046s)
[579.698553] [107/133] (442s left) kms_psr (fbc-pr-sprite-blt)
[579.790513] Starting subtest: fbc-pr-sprite-blt
[579.795019] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[579.864411] [108/133] (442s left) prime_self_import (basic-with_two_bos)
[579.903803] Starting subtest: basic-with_two_bos
[579.919911] Subtest basic-with_two_bos: SUCCESS (0.019s)
[580.009991] [109/133] (442s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[580.114534] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[581.162965] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.046s)
[581.281955] [110/133] (440s left) gem_exec_reloc (basic-cpu-read)
[581.338669] Subtest basic-cpu-read: SKIP (0.000s)
[581.405603] [111/133] (440s left) gem_ctx_shared (exec-shared-gtt)
[581.457366] Starting subtest: exec-shared-gtt
[581.459482] Starting dynamic subtest: rcs0
[581.465474] Dynamic subtest rcs0: SUCCESS (0.008s)
[581.477440] Starting dynamic subtest: bcs0
[581.479426] Dynamic subtest bcs0: SUCCESS (0.006s)
[581.489443] Starting dynamic subtest: vcs0
[581.491420] Dynamic subtest vcs0: SUCCESS (0.008s)
[581.502621] Starting dynamic subtest: vcs1
[581.504747] Dynamic subtest vcs1: SUCCESS (0.007s)
[581.514467] Starting dynamic subtest: vecs0
[581.516492] Dynamic subtest vecs0: SUCCESS (0.005s)
[581.526171] Starting dynamic subtest: ccs0
[581.528341] Dynamic subtest ccs0: SUCCESS (0.007s)
[581.530143] Subtest exec-shared-gtt: SUCCESS (0.045s)
[581.700879] [112/133] (440s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[581.790836] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[581.792969] Starting dynamic subtest: pipe-A
[581.811996] Dynamic subtest pipe-A: SKIP (0.017s)
[581.822652] Starting dynamic subtest: pipe-B
[581.841912] Dynamic subtest pipe-B: SKIP (0.031s)
[581.852564] Starting dynamic subtest: pipe-C
[581.876905] Dynamic subtest pipe-C: SKIP (0.032s)
[581.887431] Starting dynamic subtest: pipe-D
[581.906973] Dynamic subtest pipe-D: SKIP (0.031s)
[581.911712] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.114s)
[582.006683] [113/133] (440s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[582.105153] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[589.449920] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.345s)
[589.562968] [114/133] (432s left) kms_getfb (getfb-handle-protection)
[589.650391] Starting subtest: getfb-handle-protection
[589.671368] Subtest getfb-handle-protection: SUCCESS (0.021s)
[589.775889] [115/133] (432s left) gem_ctx_persistence (process)
[589.833909] Starting subtest: process
[589.985964] Subtest process: SUCCESS (0.156s)
[590.070532] [116/133] (432s left) i915_selftest (mock)
[591.885120] Starting subtest: mock
[591.888811] Starting dynamic subtest: sanitycheck
[593.466093] Dynamic subtest sanitycheck: SUCCESS (1.579s)
[593.476939] Starting dynamic subtest: shmem
[594.986661] Dynamic subtest shmem: SUCCESS (1.518s)
[595.003855] Starting dynamic subtest: fence
[603.947997] Dynamic subtest fence: SUCCESS (8.955s)
[603.959253] Starting dynamic subtest: scatterlist
[606.473745] Dynamic subtest scatterlist: SUCCESS (2.523s)
[606.484800] Starting dynamic subtest: syncmap
[610.429456] Dynamic subtest syncmap: SUCCESS (3.952s)
[610.440814] Starting dynamic subtest: uncore
[611.957961] Dynamic subtest uncore: SUCCESS (1.526s)
[611.968963] Starting dynamic subtest: ring
[613.477080] Dynamic subtest ring: SUCCESS (1.517s)
[613.488690] Starting dynamic subtest: engine
[614.991732] Dynamic subtest engine: SUCCESS (1.512s)
[615.006617] Starting dynamic subtest: timelines
[619.608135] Dynamic subtest timelines: SUCCESS (4.612s)
[619.618906] Starting dynamic subtest: requests
[623.805527] Dynamic subtest requests: SUCCESS (4.194s)
[623.815375] Starting dynamic subtest: objects
[625.417694] Dynamic subtest objects: SUCCESS (1.609s)
[625.430983] Starting dynamic subtest: phys
[627.027270] Dynamic subtest phys: SUCCESS (1.608s)
[627.039408] Starting dynamic subtest: dmabuf
[628.636141] Dynamic subtest dmabuf: SUCCESS (1.609s)
[628.646298] Starting dynamic subtest: vma
[635.034303] Dynamic subtest vma: SUCCESS (6.397s)
[635.045372] Starting dynamic subtest: evict
[637.267992] Dynamic subtest evict: SUCCESS (2.233s)
[637.279152] Starting dynamic subtest: gtt
[641.408777] Dynamic subtest gtt: SUCCESS (4.140s)
[641.420409] Starting dynamic subtest: hugepages
[643.180088] Dynamic subtest hugepages: SUCCESS (1.769s)
[643.191505] Starting dynamic subtest: memory_region
[646.457157] Dynamic subtest memory_region: SUCCESS (3.276s)
[646.460126] Subtest mock: SUCCESS (54.560s)
[646.490707] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[646.491416] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[646.495258] [117/133] (376s left) kms_pm_rpm (legacy-planes-dpms)
[651.064152] Starting subtest: legacy-planes-dpms
[651.066882] Starting dynamic subtest: plane-65
[662.379831] Dynamic subtest plane-65: SUCCESS (11.318s)
[662.392073] Starting dynamic subtest: plane-95
[671.128993] Dynamic subtest plane-95: SUCCESS (8.742s)
[671.141666] Starting dynamic subtest: plane-125
[679.546423] Dynamic subtest plane-125: SUCCESS (8.413s)
[679.561409] Starting dynamic subtest: plane-135
[688.248704] Dynamic subtest plane-135: SUCCESS (8.698s)
[688.251417] Subtest legacy-planes-dpms: SUCCESS (37.184s)
[688.654838] [FACT kms_pm_rpm (legacy-planes-dpms)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[688.656039] [FACT kms_pm_rpm (legacy-planes-dpms)] new: kernel.kmod_is_loaded.i915: true
[688.660254] [118/133] (333s left) kms_cursor_crc (cursor-random-32x10)
[688.822879] Starting subtest: cursor-random-32x10
[688.875963] Subtest cursor-random-32x10: SKIP (0.047s)
[689.125502] [119/133] (333s left) kms_cursor_crc (cursor-offscreen-32x32)
[689.285150] Starting subtest: cursor-offscreen-32x32
[689.339054] Subtest cursor-offscreen-32x32: SKIP (0.047s)
[689.613642] [120/133] (333s left) syncobj_wait (single-wait-all-for-submit-submitted)
[689.672441] Starting subtest: single-wait-all-for-submit-submitted
[689.776561] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.102s)
[689.858166] [121/133] (332s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[689.908177] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[689.974669] [122/133] (332s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[690.028127] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[690.030629] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[690.125540] [123/133] (332s left) kms_chamelium_hpd (hdmi-hpd)
[690.509078] Subtest hdmi-hpd: SKIP (0.000s)
[691.322643] [124/133] (331s left) gem_exec_reloc (basic-gtt-noreloc)
[691.385047] Subtest basic-gtt-noreloc: SKIP (0.000s)
[691.448973] [125/133] (331s left) kms_flip (2x-wf_vblank-ts-check)
[691.542063] Starting subtest: 2x-wf_vblank-ts-check
[691.550888] Subtest 2x-wf_vblank-ts-check: SKIP (0.011s)
[691.628338] [126/133] (331s left) kms_psr (pr-primary-mmap-cpu)
[691.717787] Starting subtest: pr-primary-mmap-cpu
[691.722646] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[691.793778] [127/133] (331s left) gem_readwrite (read-write)
[691.849637] Subtest read-write: SKIP (0.000s)
[691.907159] [128/133] (331s left) fbdev (write)
[691.945303] Starting subtest: write
[692.303705] Subtest write: SUCCESS (0.356s)
[692.371003] [129/133] (330s left) kms_dp_aux_dev (basic)
[692.429142] Starting subtest: basic
[692.654434] Subtest basic: SUCCESS (0.226s)
[692.726271] [130/133] (330s left) kms_psr (fbc-psr2-sprite-render)
[692.815155] Starting subtest: fbc-psr2-sprite-render
[692.817660] Starting dynamic subtest: eDP-1
[692.822714] Dynamic subtest eDP-1: SKIP (0.000s)
[692.827687] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[692.901948] [131/133] (330s left) gem_ctx_persistence (engines-cleanup)
[692.961311] Starting subtest: engines-cleanup
[692.964431] Starting dynamic subtest: rcs0
[693.025933] Dynamic subtest rcs0: SUCCESS (0.064s)
[693.040165] Starting dynamic subtest: bcs0
[693.063158] Dynamic subtest bcs0: SUCCESS (0.036s)
[693.073836] Starting dynamic subtest: vcs0
[693.111309] Dynamic subtest vcs0: SUCCESS (0.045s)
[693.121976] Starting dynamic subtest: vcs1
[693.132007] Dynamic subtest vcs1: SUCCESS (0.020s)
[693.142190] Starting dynamic subtest: vecs0
[693.200307] Dynamic subtest vecs0: SUCCESS (0.066s)
[693.212853] Starting dynamic subtest: ccs0
[693.230079] Dynamic subtest ccs0: SUCCESS (0.028s)
[693.232624] Subtest engines-cleanup: SUCCESS (0.269s)
[693.348432] [132/133] (329s left) sysfs_heartbeat_interval (idempotent)
[693.404141] Starting subtest: idempotent
[693.407004] Starting dynamic subtest: vecs0
[693.409942] Dynamic subtest vecs0: SUCCESS (0.001s)
[693.421920] Starting dynamic subtest: ccs0
[693.424086] Dynamic subtest ccs0: SUCCESS (0.001s)
[693.433923] Starting dynamic subtest: vcs0
[693.436141] Dynamic subtest vcs0: SUCCESS (0.000s)
[693.445862] Starting dynamic subtest: bcs0
[693.448149] Dynamic subtest bcs0: SUCCESS (0.001s)
[693.458434] Starting dynamic subtest: rcs0
[693.460887] Dynamic subtest rcs0: SUCCESS (0.000s)
[693.470830] Starting dynamic subtest: vcs1
[693.472936] Dynamic subtest vcs1: SUCCESS (0.001s)
[693.475015] Subtest idempotent: SUCCESS (0.009s)
[693.516258] [133/133] (329s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[693.601915] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[700.651967] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.050s)
[700.761003] 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.