[58.820786] Initializing watchdogs
[58.820887]   /dev/watchdog0
[58.837976] [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.842374] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.844545] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.848175] [001/133] (960s left) gem_pxp (create-regular-buffer)
[59.001680] Starting subtest: create-regular-buffer
[59.003998] Subtest create-regular-buffer: SUCCESS (0.000s)
[59.101639] [002/133] (960s left) kms_pm_rpm (basic-pci-d3-state)
[63.961906] Starting subtest: basic-pci-d3-state
[65.444827] Subtest basic-pci-d3-state: SUCCESS (1.495s)
[65.556044] [003/133] (953s left) gem_wait (wait)
[65.621047] Starting subtest: wait
[65.623563] Starting dynamic subtest: all-engines
[67.337916] Dynamic subtest all-engines: SUCCESS (1.723s)
[67.348062] Starting dynamic subtest: rcs0
[68.381914] Dynamic subtest rcs0: SUCCESS (1.049s)
[68.391108] Starting dynamic subtest: bcs0
[69.427874] Dynamic subtest bcs0: SUCCESS (1.049s)
[69.438277] Starting dynamic subtest: vcs0
[70.471644] Dynamic subtest vcs0: SUCCESS (1.047s)
[70.482816] Starting dynamic subtest: vcs1
[71.517534] Dynamic subtest vcs1: SUCCESS (1.048s)
[71.527449] Starting dynamic subtest: vecs0
[72.699103] Dynamic subtest vecs0: SUCCESS (1.182s)
[72.709256] Starting dynamic subtest: ccs0
[73.747404] Dynamic subtest ccs0: SUCCESS (1.050s)
[73.750074] Subtest wait: SUCCESS (8.156s)
[73.955610] [004/133] (945s left) gem_exec_gttfill (engines)
[74.013525] Starting subtest: engines
[74.016063] Starting dynamic subtest: rcs0
[97.462028] Dynamic subtest rcs0: SUCCESS (23.456s)
[97.472055] Starting dynamic subtest: bcs0
[120.752658] Dynamic subtest bcs0: SUCCESS (23.287s)
[120.763882] Starting dynamic subtest: vcs0
[144.025221] Dynamic subtest vcs0: SUCCESS (23.271s)
[144.035578] Starting dynamic subtest: vcs1
[167.320282] Dynamic subtest vcs1: SUCCESS (23.293s)
[167.329891] Starting dynamic subtest: vecs0
[190.595102] Dynamic subtest vecs0: SUCCESS (23.272s)
[190.603925] Starting dynamic subtest: ccs0
[213.868551] Dynamic subtest ccs0: SUCCESS (23.272s)
[213.870978] Subtest engines: SUCCESS (139.856s)
[214.060946] [005/133] (805s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[214.215435] Starting subtest: fbcpsr-2p-rte
[214.219761] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[214.296814] [006/133] (805s left) kms_psr (fbc-pr-no-drrs)
[214.394064] Starting subtest: fbc-pr-no-drrs
[214.398319] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[214.462107] [007/133] (805s left) perf (gen12-group-concurrent-oa-buffer-read)
[214.622420] Starting subtest: gen12-group-concurrent-oa-buffer-read
[224.663697] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.039s)
[224.709527] [008/133] (794s left) gem_softpin (full)
[224.779234] Starting subtest: full
[224.785235] Subtest full: SUCCESS (0.008s)
[224.917852] [009/133] (794s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[225.012890] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[225.017294] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[225.081193] [010/133] (794s left) gem_mmap_gtt (basic-read)
[225.141097] Subtest basic-read: SKIP (0.000s)
[225.206236] [011/133] (794s left) kms_big_fb (linear-32bpp-rotate-180)
[225.309998] Starting subtest: linear-32bpp-rotate-180
[226.798859] Subtest linear-32bpp-rotate-180: SUCCESS (1.489s)
[226.941997] [012/133] (792s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[227.048298] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[227.051551] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[227.140709] [013/133] (792s left) gem_ctx_bad_destroy (invalid-ctx)
[227.187424] Starting subtest: invalid-ctx
[227.189355] Subtest invalid-ctx: SUCCESS (0.000s)
[227.255689] [014/133] (792s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[227.354585] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[227.381640] Starting dynamic subtest: pipe-A-plane-0
[227.670114] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[227.682371] Starting dynamic subtest: pipe-A-plane-3
[227.903500] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[227.912221] Starting dynamic subtest: pipe-A-plane-5
[227.915803] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[229.051184] Starting dynamic subtest: pipe-B-plane-0
[229.343832] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[229.355627] Starting dynamic subtest: pipe-B-plane-3
[229.588385] Dynamic subtest pipe-B-plane-3: SUCCESS (0.244s)
[229.597291] Starting dynamic subtest: pipe-B-plane-5
[229.601706] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[229.900512] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.546s)
[230.733070] [015/133] (789s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[230.794822] Starting subtest: single-wait-for-submit-available-signaled
[230.796867] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[230.884693] [016/133] (789s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[230.977918] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[230.980223] Starting dynamic subtest: pipe-A-default-mode
[232.090861] Dynamic subtest pipe-A-default-mode: SKIP (1.111s)
[232.095975] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.112s)
[232.243859] [017/133] (787s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[232.304206] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[232.306203] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[232.419539] [018/133] (787s left) i915_drm_fdinfo (virtual-busy-all)
[232.457804] Starting subtest: virtual-busy-all
[232.462374] Subtest virtual-busy-all: SKIP (0.000s)
[232.526183] [019/133] (787s left) gem_exec_reloc (basic-gtt-read-noreloc)
[232.597988] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[232.666052] [020/133] (787s left) kms_lease (lease-invalid-connector)
[232.757841] Starting subtest: lease-invalid-connector
[232.760261] Starting dynamic subtest: pipe-A-eDP-1
[232.762623] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[232.772668] Starting dynamic subtest: pipe-B-eDP-1
[232.775060] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[232.783608] Starting dynamic subtest: pipe-C-eDP-1
[232.785919] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[232.794086] Starting dynamic subtest: pipe-D-eDP-1
[232.796031] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[232.797938] Subtest lease-invalid-connector: SUCCESS (0.003s)
[232.835992] [021/133] (787s left) gem_pxp (reject-modify-context-protection-off-3)
[232.936998] Starting subtest: reject-modify-context-protection-off-3
[232.939436] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[233.052770] [022/133] (787s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[233.151213] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[233.153209] Starting dynamic subtest: pipe-A-eDP-1
[233.202315] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[233.211421] Starting dynamic subtest: pipe-B-eDP-1
[233.258598] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[233.267666] Starting dynamic subtest: pipe-C-eDP-1
[233.314043] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[233.322747] Starting dynamic subtest: pipe-D-eDP-1
[233.371292] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[233.375101] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[235.424721] [023/133] (784s left) gem_mmap_gtt (fault-concurrent)
[235.484311] Subtest fault-concurrent: SKIP (0.000s)
[235.550323] [024/133] (784s left) kms_addfb_basic (addfb25-4-tiled)
[235.656830] Starting subtest: addfb25-4-tiled
[235.658767] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[235.747033] [025/133] (784s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[235.845314] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[235.847713] Starting dynamic subtest: A-eDP1
[239.459994] Dynamic subtest A-eDP1: SUCCESS (3.613s)
[239.470953] Starting dynamic subtest: B-eDP1
[242.676670] Dynamic subtest B-eDP1: SUCCESS (3.216s)
[242.687128] Starting dynamic subtest: C-eDP1
[245.783279] Dynamic subtest C-eDP1: SUCCESS (3.106s)
[245.793080] Starting dynamic subtest: D-eDP1
[248.890458] Dynamic subtest D-eDP1: SUCCESS (3.105s)
[248.892863] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.046s)
[249.690279] [026/133] (770s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[249.815364] Starting subtest: flip-vs-cursor-busy-crc-legacy
[250.642624] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.828s)
[251.518585] [027/133] (768s left) syncobj_eventfd (timeline-wait-signaled)
[251.579157] Starting subtest: timeline-wait-signaled
[251.581485] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[251.697398] [028/133] (768s left) gem_exec_schedule (u-fairslice)
[251.770273] Starting subtest: u-fairslice
[251.772188] Starting dynamic subtest: rcs0
[253.789478] Dynamic subtest rcs0: SUCCESS (2.022s)
[253.799026] Starting dynamic subtest: bcs0
[255.808674] Dynamic subtest bcs0: SUCCESS (2.019s)
[255.819150] Starting dynamic subtest: vcs0
[257.830148] Dynamic subtest vcs0: SUCCESS (2.020s)
[257.838919] Starting dynamic subtest: vcs1
[259.848577] Dynamic subtest vcs1: SUCCESS (2.017s)
[259.858532] Starting dynamic subtest: vecs0
[261.867080] Dynamic subtest vecs0: SUCCESS (2.020s)
[261.876649] Starting dynamic subtest: ccs0
[263.891104] Dynamic subtest ccs0: SUCCESS (2.024s)
[263.893322] Subtest u-fairslice: SUCCESS (12.126s)
[264.202571] [029/133] (756s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[264.298070] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[264.300636] Starting dynamic subtest: pipe-A-default-mode
[267.096916] Dynamic subtest pipe-A-default-mode: SUCCESS (2.798s)
[267.099298] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.799s)
[267.932793] [030/133] (752s left) gem_exec_whisper (basic-sync-all)
[267.999709] Starting subtest: basic-sync-all
[274.434436] Subtest basic-sync-all: SUCCESS (6.432s)
[274.625345] [031/133] (745s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[274.680993] Starting subtest: etime-multi-wait-available-unsubmitted
[274.788304] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.107s)
[274.880126] [032/133] (745s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[274.971992] Starting subtest: random-ccs-data-y-tiled-ccs
[274.974317] Starting dynamic subtest: pipe-A-eDP-1
[274.999863] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[275.009640] Starting dynamic subtest: pipe-B-eDP-1
[275.032607] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[275.041248] Starting dynamic subtest: pipe-C-eDP-1
[275.064845] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[275.073851] Starting dynamic subtest: pipe-D-eDP-1
[275.097888] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[275.102254] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.003s)
[277.291555] [033/133] (743s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[277.392298] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[277.394597] Starting dynamic subtest: pipe-A-eDP-1
[277.415207] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[277.425663] Starting dynamic subtest: pipe-B-eDP-1
[277.444860] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[277.453982] Starting dynamic subtest: pipe-C-eDP-1
[277.473185] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[277.482125] Starting dynamic subtest: pipe-D-eDP-1
[277.501675] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[277.503906] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[279.661416] [034/133] (740s left) kms_addfb_basic (basic)
[279.711735] Starting subtest: basic
[279.713901] Subtest basic: SUCCESS (0.000s)
[279.843200] [035/133] (740s left) kms_color_pipeline (plane-lut1d-lut1d)
[279.937989] Starting subtest: plane-lut1d-lut1d
[280.106175] Starting dynamic subtest: pipe-A-plane-0
[280.274777] Dynamic subtest pipe-A-plane-0: SUCCESS (0.167s)
[280.287858] Starting dynamic subtest: pipe-A-plane-1
[280.450643] Dynamic subtest pipe-A-plane-1: SUCCESS (0.177s)
[280.460888] Starting dynamic subtest: pipe-A-plane-2
[280.616793] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[281.862993] Starting dynamic subtest: pipe-B-plane-0
[282.032454] Dynamic subtest pipe-B-plane-0: SUCCESS (0.177s)
[282.043244] Starting dynamic subtest: pipe-B-plane-1
[282.221668] Dynamic subtest pipe-B-plane-1: SUCCESS (0.188s)
[282.232366] Starting dynamic subtest: pipe-B-plane-2
[282.388768] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[283.605616] Starting dynamic subtest: pipe-C-plane-0
[283.741771] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[283.751099] Starting dynamic subtest: pipe-C-plane-1
[283.886189] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[283.896642] Starting dynamic subtest: pipe-C-plane-2
[284.041696] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[285.214240] Starting dynamic subtest: pipe-D-plane-0
[285.362341] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[285.374924] Starting dynamic subtest: pipe-D-plane-1
[285.518217] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[285.527819] Starting dynamic subtest: pipe-D-plane-2
[285.684748] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[285.972997] Subtest plane-lut1d-lut1d: SUCCESS (6.035s)
[286.791809] [036/133] (733s left) api_intel_allocator (standalone)
[286.852676] Starting subtest: standalone
[286.868227] Subtest standalone: SUCCESS (0.018s)
[287.009656] [037/133] (733s left) prime_self_import (basic-llseek-bad)
[287.042418] Starting subtest: basic-llseek-bad
[287.071691] Subtest basic-llseek-bad: SUCCESS (0.028s)
[287.184441] [038/133] (733s left) kms_vblank (query-forked)
[287.280092] Starting subtest: query-forked
[287.281970] Starting dynamic subtest: pipe-A-eDP-1
[289.105022] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.824s)
[289.119252] Starting dynamic subtest: pipe-D-eDP-1
[291.598712] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.491s)
[291.600903] Subtest query-forked: SUCCESS (4.318s)
[292.456567] [039/133] (728s left) gem_exec_flush (basic-uc-ro-default)
[292.518464] Starting subtest: basic-uc-ro-default
[297.973703] Subtest basic-uc-ro-default: SUCCESS (5.455s)
[298.160093] [040/133] (722s left) perf (per-context-mode-unprivileged)
[298.252452] Starting subtest: per-context-mode-unprivileged
[298.257550] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[298.294278] [041/133] (722s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[298.392542] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[298.396782] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[298.498242] [042/133] (722s left) i915_pm_rps (min-max-config-idle)
[298.568653] Starting subtest: min-max-config-idle
[298.573070] Subtest min-max-config-idle: SKIP (0.001s)
[298.668255] [043/133] (722s left) gem_exec_balancer (busy)
[298.734156] Starting subtest: busy
[300.294544] Subtest busy: SUCCESS (1.561s)
[300.577889] [044/133] (720s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[300.670653] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[300.674749] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[300.752052] [045/133] (720s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[300.849330] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[300.853593] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[300.953730] [046/133] (720s left) gem_mmap_gtt (big-bo-tiledy)
[301.017476] Subtest big-bo-tiledY: SKIP (0.000s)
[301.082629] [047/133] (720s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[301.170456] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[308.541511] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.373s)
[308.677379] [048/133] (712s left) kms_chamelium_edid (vga-edid-read)
[309.072949] Subtest vga-edid-read: SKIP (0.000s)
[309.890472] [049/133] (711s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[309.981839] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[316.940688] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.959s)
[317.090069] [050/133] (704s left) gem_create (hog-create)
[317.154532] Starting subtest: hog-create
[317.156865] Starting dynamic subtest: smem0
[350.294849] Dynamic subtest smem0: SUCCESS (33.139s)
[350.297925] Subtest hog-create: SUCCESS (33.141s)
[350.496402] [051/133] (670s left) kms_getfb (getfb-repeated-different-handles)
[350.604937] Starting subtest: getfb-repeated-different-handles
[350.607335] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[350.699558] [052/133] (670s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[350.799556] Starting subtest: y-tiled-64bpp-rotate-0
[350.803675] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[350.880995] [053/133] (670s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[350.973404] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[350.977403] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[351.082615] [054/133] (670s left) api_intel_bb (simple-bb)
[351.142567] Starting subtest: simple-bb
[351.147641] Subtest simple-bb: SUCCESS (0.006s)
[351.255130] [055/133] (670s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[351.358630] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[351.362676] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[351.425895] [056/133] (670s left) kms_flip (blocking-wf_vblank)
[351.521181] Starting subtest: blocking-wf_vblank
[351.523141] Starting dynamic subtest: A-eDP1
[360.464195] Dynamic subtest A-eDP1: SUCCESS (8.943s)
[360.476034] Starting dynamic subtest: B-eDP1
[369.401800] Dynamic subtest B-eDP1: SUCCESS (8.935s)
[369.416663] Starting dynamic subtest: C-eDP1
[378.315823] Dynamic subtest C-eDP1: SUCCESS (8.910s)
[378.326529] Starting dynamic subtest: D-eDP1
[387.242317] Dynamic subtest D-eDP1: SUCCESS (8.924s)
[387.244721] Subtest blocking-wf_vblank: SUCCESS (35.723s)
[388.469597] [057/133] (633s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[388.586362] Starting subtest: cursorA-vs-flipB-atomic-transitions
[388.590805] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[388.732583] [058/133] (632s left) gem_mmap_offset (bad-flags)
[388.788317] Starting subtest: bad-flags
[388.790529] Subtest bad-flags: SUCCESS (0.000s)
[388.891027] [059/133] (632s left) vgem_basic (create)
[389.002211] Starting subtest: create
[389.004500] Subtest create: SUCCESS (0.001s)
[389.056856] [FACT vgem_basic (create)] new: kernel.kmod_is_loaded.vgem: true
[389.060374] [060/133] (632s left) kms_atomic (plane-primary-legacy)
[389.160257] Starting subtest: plane-primary-legacy
[389.162443] Starting dynamic subtest: pipe-A-eDP-1
[389.616526] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.455s)
[389.618504] Subtest plane-primary-legacy: SUCCESS (0.456s)
[390.406605] [061/133] (631s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[390.498279] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[390.502227] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[390.582829] [062/133] (631s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[390.639801] Starting subtest: invalid-single-wait-unsubmitted
[390.642153] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[390.729560] [063/133] (631s left) kms_psr (psr-cursor-render)
[390.819077] Starting subtest: psr-cursor-render
[390.821364] Starting dynamic subtest: eDP-1
[392.498589] Dynamic subtest eDP-1: SUCCESS (1.677s)
[392.500915] Subtest psr-cursor-render: SUCCESS (1.678s)
[393.369304] [064/133] (628s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[393.462252] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[393.464583] Starting dynamic subtest: pipe-A-eDP-1
[393.488703] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[393.499582] Starting dynamic subtest: pipe-B-eDP-1
[393.520474] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[393.529428] Starting dynamic subtest: pipe-C-eDP-1
[393.550359] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[393.559087] Starting dynamic subtest: pipe-D-eDP-1
[393.581586] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[393.585993] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[395.724035] [065/133] (626s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[396.255526] Starting subtest: syncobj-timeline-invalid-flags
[396.257991] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[397.400375] [066/133] (624s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[397.494694] Starting subtest: stress-xrgb8888-ytiled
[397.498992] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[397.580674] [067/133] (624s left) gem_sync (basic-each)
[397.654659] Starting subtest: basic-each
[399.879358] Subtest basic-each: SUCCESS (2.235s)
[400.067842] [068/133] (621s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[400.170365] Starting subtest: x-tiled-8bpp-rotate-0
[401.384734] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.215s)
[401.510340] [069/133] (620s left) sw_sync (sync_expired_merge)
[401.547136] Starting subtest: sync_expired_merge
[402.620980] Subtest sync_expired_merge: SUCCESS (1.074s)
[402.685160] [070/133] (619s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[402.787899] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[407.455254] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.671s)
[408.633694] [071/133] (613s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[408.733304] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[408.737322] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[408.839630] [072/133] (613s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[408.925674] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[408.929815] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[409.020586] [073/133] (613s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[409.110115] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[409.112364] Starting dynamic subtest: pipe-A
[410.227495] Dynamic subtest pipe-A: SUCCESS (1.119s)
[410.236691] Starting dynamic subtest: pipe-B
[412.410342] Dynamic subtest pipe-B: SUCCESS (2.182s)
[412.419902] Starting dynamic subtest: pipe-C
[413.610501] Dynamic subtest pipe-C: SUCCESS (1.198s)
[413.620794] Starting dynamic subtest: pipe-D
[414.837484] Dynamic subtest pipe-D: SUCCESS (1.226s)
[414.839763] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.731s)
[416.028470] [074/133] (606s left) kms_cursor_edge_walk (64x64-top-bottom)
[416.131285] Starting subtest: 64x64-top-bottom
[416.133601] Starting dynamic subtest: pipe-A-eDP-1
[419.596283] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.462s)
[419.606478] Starting dynamic subtest: pipe-D-eDP-1
[422.702941] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.106s)
[422.705165] Subtest 64x64-top-bottom: SUCCESS (6.571s)
[423.531899] [075/133] (598s left) kms_joiner (basic-ultra-joiner)
[423.625911] Starting subtest: basic-ultra-joiner
[423.630153] Subtest basic-ultra-joiner: SKIP (0.000s)
[423.696241] [076/133] (598s left) gen9_exec_parse (bb-start-param)
[423.750710] Subtest bb-start-param: SKIP (0.000s)
[423.828350] [077/133] (598s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[423.923835] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[430.799760] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.877s)
[430.938456] [078/133] (591s left) sw_sync (sync_multi_consumer)
[430.978429] Starting subtest: sync_multi_consumer
[431.386955] Subtest sync_multi_consumer: SUCCESS (0.409s)
[431.449854] [079/133] (591s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[431.507261] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[431.512065] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[431.700481] [080/133] (590s left) gem_exec_schedule (pi-common)
[431.884640] Starting subtest: pi-common
[431.886939] Starting dynamic subtest: rcs0
[431.910050] Dynamic subtest rcs0: SUCCESS (0.029s)
[431.924452] Starting dynamic subtest: bcs0
[431.937722] Dynamic subtest bcs0: SUCCESS (0.027s)
[431.952651] Starting dynamic subtest: vcs0
[431.966215] Dynamic subtest vcs0: SUCCESS (0.027s)
[431.981162] Starting dynamic subtest: vcs1
[431.992413] Dynamic subtest vcs1: SUCCESS (0.026s)
[432.006334] Starting dynamic subtest: vecs0
[432.019429] Dynamic subtest vecs0: SUCCESS (0.026s)
[432.034032] Starting dynamic subtest: ccs0
[432.046385] Dynamic subtest ccs0: SUCCESS (0.026s)
[432.048548] Subtest pi-common: SUCCESS (0.167s)
[432.268461] [081/133] (590s left) gem_exec_whisper (basic-contexts-all)
[432.332519] Starting subtest: basic-contexts-all
[443.740742] Subtest basic-contexts-all: SUCCESS (11.404s)
[443.920150] [082/133] (578s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[444.022437] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[444.024680] Starting dynamic subtest: pipe-A-eDP-1
[444.045500] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s)
[444.055827] Starting dynamic subtest: pipe-B-eDP-1
[444.076794] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[444.089433] Starting dynamic subtest: pipe-C-eDP-1
[444.110087] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[444.119880] Starting dynamic subtest: pipe-D-eDP-1
[444.140484] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[444.142819] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.094s)
[446.403247] [083/133] (576s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[446.501784] Starting subtest: psr-rgb101010-draw-blt
[453.854626] Subtest psr-rgb101010-draw-blt: SUCCESS (7.355s)
[453.993476] [084/133] (568s left) core_setmaster (master-drop-set-shared-fd)
[454.084458] Starting subtest: master-drop-set-shared-fd
[454.094717] Subtest master-drop-set-shared-fd: SUCCESS (0.010s)
[454.133906] [085/133] (568s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[454.231395] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[461.040937] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.813s)
[461.172461] [086/133] (561s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[461.264639] Starting subtest: psr-rgb565-draw-render
[468.304369] Subtest psr-rgb565-draw-render: SUCCESS (7.043s)
[468.416889] [087/133] (554s left) kms_sequence (get-forked-busy)
[468.505291] Starting subtest: get-forked-busy
[468.507188] Starting dynamic subtest: pipe-A-eDP-1
[470.440350] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.934s)
[470.451561] Starting dynamic subtest: pipe-B-eDP-1
[473.092872] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.652s)
[473.104666] Starting dynamic subtest: pipe-C-eDP-1
[475.721992] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.626s)
[475.735995] Starting dynamic subtest: pipe-D-eDP-1
[478.343920] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.621s)
[478.346243] Subtest get-forked-busy: SUCCESS (9.839s)
[479.229791] [088/133] (543s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[479.321660] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[479.325944] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[479.412938] [089/133] (543s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[479.465469] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[479.467805] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[479.562580] [090/133] (543s left) syncobj_wait (single-wait-for-submit-signaled)
[479.608285] Starting subtest: single-wait-for-submit-signaled
[479.610604] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[479.717646] [091/133] (543s left) kms_dsc (dsc-fractional-bpp)
[479.798371] Starting subtest: dsc-fractional-bpp
[479.811480] Subtest dsc-fractional-bpp: SKIP (0.000s)
[479.882594] [092/133] (543s left) syncobj_wait (wait-all-snapshot)
[479.942078] Starting subtest: wait-all-snapshot
[480.023233] Subtest wait-all-snapshot: SUCCESS (0.081s)
[480.113316] [093/133] (542s left) kms_content_protection (legacy-hdcp14)
[480.244749] Starting subtest: legacy-hdcp14
[480.248836] Subtest legacy-hdcp14: SKIP (0.000s)
[480.377855] [094/133] (542s left) gem_exec_balancer (waits)
[480.443542] Starting subtest: waits
[486.967395] Subtest waits: SUCCESS (6.521s)
[487.283612] [095/133] (535s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[487.378139] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[487.380898] Starting dynamic subtest: pipe-A-eDP-1
[487.390890] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[487.403066] Starting dynamic subtest: pipe-B-eDP-1
[487.412355] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[487.422170] Starting dynamic subtest: pipe-C-eDP-1
[487.431405] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[487.440843] Starting dynamic subtest: pipe-D-eDP-1
[487.449822] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[487.454285] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[489.702429] [096/133] (533s left) i915_hangman (engine-error-state-capture)
[489.771291] Starting subtest: engine-error-state-capture
[489.773790] Starting dynamic subtest: rcs0
[493.287249] Dynamic subtest rcs0: SUCCESS (3.514s)
[493.300786] Starting dynamic subtest: bcs0
[499.302424] Dynamic subtest bcs0: SUCCESS (6.012s)
[499.315619] Starting dynamic subtest: vcs0
[505.192077] Dynamic subtest vcs0: SUCCESS (5.887s)
[505.205102] Starting dynamic subtest: vcs1
[510.247371] Dynamic subtest vcs1: SUCCESS (5.052s)
[510.260353] Starting dynamic subtest: vecs0
[516.262425] Dynamic subtest vecs0: SUCCESS (6.012s)
[516.275921] Starting dynamic subtest: ccs0
[522.278850] Dynamic subtest ccs0: SUCCESS (6.014s)
[522.281957] Subtest engine-error-state-capture: SUCCESS (32.506s)
[522.419345] [097/133] (500s left) perf_pmu (rc6-suspend)
[522.466598] Starting subtest: rc6-suspend
[544.852403] Subtest rc6-suspend: SUCCESS (8.598s)
[545.845462] [098/133] (477s left) gem_exec_parallel (basic)
[545.919409] Starting subtest: basic
[545.922137] Starting dynamic subtest: rcs0
[547.762369] Dynamic subtest rcs0: SUCCESS (1.879s)
[547.775373] Starting dynamic subtest: bcs0
[549.553519] Dynamic subtest bcs0: SUCCESS (1.818s)
[549.566362] Starting dynamic subtest: vcs0
[551.234568] Dynamic subtest vcs0: SUCCESS (1.700s)
[551.246915] Starting dynamic subtest: vcs1
[553.188067] Dynamic subtest vcs1: SUCCESS (1.970s)
[553.199275] Starting dynamic subtest: vecs0
[555.237113] Dynamic subtest vecs0: SUCCESS (2.062s)
[555.249992] Starting dynamic subtest: ccs0
[557.027246] Dynamic subtest ccs0: SUCCESS (1.799s)
[557.030369] Subtest basic: SUCCESS (11.241s)
[557.213785] [099/133] (466s left) kms_psr (psr-primary-blt)
[557.319106] Starting subtest: psr-primary-blt
[557.321738] Starting dynamic subtest: eDP-1
[559.035643] Dynamic subtest eDP-1: SUCCESS (1.723s)
[559.038221] Subtest psr-primary-blt: SUCCESS (1.724s)
[559.890999] [100/133] (463s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[559.946360] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[560.036173] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.025s)
[560.077485] [101/133] (463s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[560.183307] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[563.789447] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.622s)
[564.996671] [102/133] (458s left) kms_prop_blob (blob-prop-lifetime)
[565.055092] Starting subtest: blob-prop-lifetime
[565.057670] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[565.151595] [103/133] (458s left) gem_userptr_blits (readonly-unsync)
[565.223973] Subtest readonly-unsync: SKIP (0.000s)
[565.345429] [104/133] (458s left) perf (polling)
[565.427589] Starting subtest: polling
[565.430520] Starting dynamic subtest: 0-rcs0
[575.441594] Dynamic subtest 0-rcs0: SUCCESS (10.019s)
[575.454130] Starting dynamic subtest: 1-vcs1
[585.461217] Dynamic subtest 1-vcs1: SUCCESS (10.016s)
[585.464031] Subtest polling: SUCCESS (20.037s)
[585.513665] [105/133] (438s left) i915_query (query-topology-kernel-writes)
[585.568251] Starting subtest: query-topology-kernel-writes
[585.570684] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[585.675272] [106/133] (437s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[585.784123] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[586.831029] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.046s)
[586.957400] [107/133] (436s left) kms_psr (fbc-pr-sprite-blt)
[587.055882] Starting subtest: fbc-pr-sprite-blt
[587.059994] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[587.130756] [108/133] (436s left) prime_self_import (basic-with_two_bos)
[587.162820] Starting subtest: basic-with_two_bos
[587.183102] Subtest basic-with_two_bos: SUCCESS (0.024s)
[587.284771] [109/133] (436s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[587.383181] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[588.407190] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.024s)
[588.543086] [110/133] (435s left) gem_exec_reloc (basic-cpu-read)
[588.601992] Subtest basic-cpu-read: SKIP (0.000s)
[588.688902] [111/133] (435s left) gem_ctx_shared (exec-shared-gtt)
[588.749776] Starting subtest: exec-shared-gtt
[588.752094] Starting dynamic subtest: rcs0
[588.761204] Dynamic subtest rcs0: SUCCESS (0.011s)
[588.771212] Starting dynamic subtest: bcs0
[588.773687] Dynamic subtest bcs0: SUCCESS (0.006s)
[588.783748] Starting dynamic subtest: vcs0
[588.785707] Dynamic subtest vcs0: SUCCESS (0.008s)
[588.795941] Starting dynamic subtest: vcs1
[588.797783] Dynamic subtest vcs1: SUCCESS (0.010s)
[588.808141] Starting dynamic subtest: vecs0
[588.810219] Dynamic subtest vecs0: SUCCESS (0.007s)
[588.820768] Starting dynamic subtest: ccs0
[588.823434] Dynamic subtest ccs0: SUCCESS (0.006s)
[588.825677] Subtest exec-shared-gtt: SUCCESS (0.054s)
[588.994063] [112/133] (434s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[589.094668] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[589.096709] Starting dynamic subtest: pipe-A
[589.117044] Dynamic subtest pipe-A: SKIP (0.017s)
[589.128117] Starting dynamic subtest: pipe-B
[589.151093] Dynamic subtest pipe-B: SKIP (0.032s)
[589.161550] Starting dynamic subtest: pipe-C
[589.184362] Dynamic subtest pipe-C: SKIP (0.031s)
[589.198686] Starting dynamic subtest: pipe-D
[589.213067] Dynamic subtest pipe-D: SKIP (0.032s)
[589.216803] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.115s)
[589.315701] [113/133] (434s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[589.414881] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[596.719157] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.308s)
[596.859099] [114/133] (427s left) kms_getfb (getfb-handle-protection)
[596.952030] Starting subtest: getfb-handle-protection
[596.969188] Subtest getfb-handle-protection: SUCCESS (0.019s)
[597.089333] [115/133] (426s left) gem_ctx_persistence (process)
[597.150047] Starting subtest: process
[597.308716] Subtest process: SUCCESS (0.161s)
[597.391948] [116/133] (426s left) i915_selftest (mock)
[599.206381] Starting subtest: mock
[599.209532] Starting dynamic subtest: sanitycheck
[600.759511] Dynamic subtest sanitycheck: SUCCESS (1.553s)
[600.771058] Starting dynamic subtest: shmem
[602.295738] Dynamic subtest shmem: SUCCESS (1.534s)
[602.312067] Starting dynamic subtest: fence
[611.347912] Dynamic subtest fence: SUCCESS (9.052s)
[611.358854] Starting dynamic subtest: scatterlist
[613.879378] Dynamic subtest scatterlist: SUCCESS (2.532s)
[613.891263] Starting dynamic subtest: syncmap
[617.914044] Dynamic subtest syncmap: SUCCESS (4.034s)
[617.925349] Starting dynamic subtest: uncore
[619.452761] Dynamic subtest uncore: SUCCESS (1.538s)
[619.464660] Starting dynamic subtest: ring
[620.974925] Dynamic subtest ring: SUCCESS (1.521s)
[620.986140] Starting dynamic subtest: engine
[622.473712] Dynamic subtest engine: SUCCESS (1.498s)
[622.486052] Starting dynamic subtest: timelines
[627.244896] Dynamic subtest timelines: SUCCESS (4.771s)
[627.261740] Starting dynamic subtest: requests
[631.936553] Dynamic subtest requests: SUCCESS (4.692s)
[631.947064] Starting dynamic subtest: objects
[633.596376] Dynamic subtest objects: SUCCESS (1.658s)
[633.608543] Starting dynamic subtest: phys
[635.196049] Dynamic subtest phys: SUCCESS (1.599s)
[635.206865] Starting dynamic subtest: dmabuf
[636.822730] Dynamic subtest dmabuf: SUCCESS (1.625s)
[636.833697] Starting dynamic subtest: vma
[643.457914] Dynamic subtest vma: SUCCESS (6.630s)
[643.469083] Starting dynamic subtest: evict
[645.738542] Dynamic subtest evict: SUCCESS (2.278s)
[645.749300] Starting dynamic subtest: gtt
[649.909143] Dynamic subtest gtt: SUCCESS (4.168s)
[649.921030] Starting dynamic subtest: hugepages
[651.684017] Dynamic subtest hugepages: SUCCESS (1.773s)
[651.694937] Starting dynamic subtest: memory_region
[655.027123] Dynamic subtest memory_region: SUCCESS (3.341s)
[655.030374] Subtest mock: SUCCESS (55.825s)
[655.061227] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[655.061969] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[655.065990] [117/133] (369s left) kms_pm_rpm (legacy-planes-dpms)
[659.354375] Starting subtest: legacy-planes-dpms
[659.357351] Starting dynamic subtest: plane-65
[667.938968] Dynamic subtest plane-65: SUCCESS (8.583s)
[667.951359] Starting dynamic subtest: plane-95
[676.233357] Dynamic subtest plane-95: SUCCESS (8.291s)
[676.246693] Starting dynamic subtest: plane-125
[684.564494] Dynamic subtest plane-125: SUCCESS (8.328s)
[684.578309] Starting dynamic subtest: plane-135
[692.964430] Dynamic subtest plane-135: SUCCESS (8.398s)
[692.967355] Subtest legacy-planes-dpms: SUCCESS (33.612s)
[693.369255] [FACT kms_pm_rpm (legacy-planes-dpms)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[693.370850] [FACT kms_pm_rpm (legacy-planes-dpms)] new: kernel.kmod_is_loaded.i915: true
[693.374976] [118/133] (330s left) kms_cursor_crc (cursor-random-32x10)
[693.543421] Starting subtest: cursor-random-32x10
[693.597236] Subtest cursor-random-32x10: SKIP (0.050s)
[693.853198] [119/133] (330s left) kms_cursor_crc (cursor-offscreen-32x32)
[694.011912] Starting subtest: cursor-offscreen-32x32
[694.061343] Subtest cursor-offscreen-32x32: SKIP (0.048s)
[694.363338] [120/133] (329s left) syncobj_wait (single-wait-all-for-submit-submitted)
[694.411091] Starting subtest: single-wait-all-for-submit-submitted
[694.520267] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.107s)
[694.597016] [121/133] (329s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[694.648192] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[694.706571] [122/133] (329s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[694.753723] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[694.756130] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[694.840755] [123/133] (329s left) kms_chamelium_hpd (hdmi-hpd)
[695.222786] Subtest hdmi-hpd: SKIP (0.000s)
[696.048691] [124/133] (328s left) gem_exec_reloc (basic-gtt-noreloc)
[696.118398] Subtest basic-gtt-noreloc: SKIP (0.000s)
[696.187134] [125/133] (328s left) kms_flip (2x-wf_vblank-ts-check)
[696.278377] Starting subtest: 2x-wf_vblank-ts-check
[696.286975] Subtest 2x-wf_vblank-ts-check: SKIP (0.010s)
[696.381395] [126/133] (328s left) kms_psr (pr-primary-mmap-cpu)
[696.469261] Starting subtest: pr-primary-mmap-cpu
[696.474375] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[696.561213] [127/133] (327s left) gem_readwrite (read-write)
[696.613491] Subtest read-write: SKIP (0.000s)
[696.672025] [128/133] (327s left) fbdev (write)
[696.709040] Starting subtest: write
[697.071992] Subtest write: SUCCESS (0.362s)
[697.140296] [129/133] (327s left) kms_dp_aux_dev (basic)
[697.192305] Starting subtest: basic
[697.417358] Subtest basic: SUCCESS (0.224s)
[697.490904] [130/133] (327s left) kms_psr (fbc-psr2-sprite-render)
[697.581248] Starting subtest: fbc-psr2-sprite-render
[697.584158] Starting dynamic subtest: eDP-1
[697.589161] Dynamic subtest eDP-1: SKIP (0.000s)
[697.593413] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[697.656845] [131/133] (327s left) gem_ctx_persistence (engines-cleanup)
[697.711337] Starting subtest: engines-cleanup
[697.714199] Starting dynamic subtest: rcs0
[697.783367] Dynamic subtest rcs0: SUCCESS (0.072s)
[697.796243] Starting dynamic subtest: bcs0
[697.823372] Dynamic subtest bcs0: SUCCESS (0.039s)
[697.837937] Starting dynamic subtest: vcs0
[697.867389] Dynamic subtest vcs0: SUCCESS (0.041s)
[697.877370] Starting dynamic subtest: vcs1
[697.913668] Dynamic subtest vcs1: SUCCESS (0.044s)
[697.925209] Starting dynamic subtest: vecs0
[697.956296] Dynamic subtest vecs0: SUCCESS (0.041s)
[697.968043] Starting dynamic subtest: ccs0
[697.992404] Dynamic subtest ccs0: SUCCESS (0.035s)
[697.994745] Subtest engines-cleanup: SUCCESS (0.282s)
[698.069389] [132/133] (326s left) sysfs_heartbeat_interval (idempotent)
[698.122282] Starting subtest: idempotent
[698.125412] Starting dynamic subtest: vecs0
[698.128347] Dynamic subtest vecs0: SUCCESS (0.001s)
[698.140018] Starting dynamic subtest: ccs0
[698.142367] Dynamic subtest ccs0: SUCCESS (0.001s)
[698.152431] Starting dynamic subtest: vcs0
[698.154842] Dynamic subtest vcs0: SUCCESS (0.000s)
[698.164387] Starting dynamic subtest: bcs0
[698.166761] Dynamic subtest bcs0: SUCCESS (0.001s)
[698.176219] Starting dynamic subtest: rcs0
[698.178773] Dynamic subtest rcs0: SUCCESS (0.000s)
[698.190565] Starting dynamic subtest: vcs1
[698.193369] Dynamic subtest vcs1: SUCCESS (0.000s)
[698.195741] Subtest idempotent: SUCCESS (0.008s)
[698.239702] [133/133] (326s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[698.334271] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[705.475302] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.146s)
[705.587884] 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.