[56.986463] Initializing watchdogs
[56.986514]   /dev/watchdog0
[57.003361] [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.007946] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.010597] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.013954] [001/133] (960s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[57.145074] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[57.147254] Starting dynamic subtest: pipe-A
[57.166528] Dynamic subtest pipe-A: SKIP (0.019s)
[57.173828] Starting dynamic subtest: pipe-B
[57.202681] Dynamic subtest pipe-B: SKIP (0.034s)
[57.210611] Starting dynamic subtest: pipe-C
[57.237996] Dynamic subtest pipe-C: SKIP (0.035s)
[57.245247] Starting dynamic subtest: pipe-D
[57.270418] Dynamic subtest pipe-D: SKIP (0.035s)
[57.274880] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.124s)
[57.373365] [002/133] (960s left) fbdev (nullptr)
[57.415850] Starting subtest: nullptr
[57.418260] Subtest nullptr: SUCCESS (0.000s)
[57.484062] [003/133] (960s left) intel_hwmon (hwmon-read)
[57.539988] Subtest hwmon-read: SKIP (0.000s)
[57.592880] [004/133] (960s left) gem_exec_params (invalid-bsd1-flag-on-render)
[57.649871] Starting subtest: invalid-bsd1-flag-on-render
[57.652395] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[57.743603] [005/133] (959s left) i915_query (hwconfig_table)
[57.800042] Starting subtest: hwconfig_table
[58.054073] Subtest hwconfig_table: SUCCESS (0.001s)
[58.086470] [006/133] (959s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[58.182520] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[58.184348] Starting dynamic subtest: pipe-A-eDP-1
[58.191911] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[58.200306] Starting dynamic subtest: pipe-B-eDP-1
[58.207596] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[58.214509] Starting dynamic subtest: pipe-C-eDP-1
[58.221956] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[58.228343] Starting dynamic subtest: pipe-D-eDP-1
[58.235315] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[58.238827] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[60.490171] [007/133] (957s left) sysfs_timeslice_duration (idempotent)
[60.546710] Starting subtest: idempotent
[60.549079] Starting dynamic subtest: vecs0
[60.551320] Dynamic subtest vecs0: SUCCESS (0.000s)
[60.560089] Starting dynamic subtest: ccs0
[60.562238] Dynamic subtest ccs0: SUCCESS (0.000s)
[60.569249] Starting dynamic subtest: vcs0
[60.571735] Dynamic subtest vcs0: SUCCESS (0.000s)
[60.578630] Starting dynamic subtest: bcs0
[60.580788] Dynamic subtest bcs0: SUCCESS (0.000s)
[60.588034] Starting dynamic subtest: rcs0
[60.589996] Dynamic subtest rcs0: SUCCESS (0.000s)
[60.596919] Starting dynamic subtest: vcs1
[60.599355] Dynamic subtest vcs1: SUCCESS (0.000s)
[60.601583] Subtest idempotent: SUCCESS (0.004s)
[60.651414] [008/133] (957s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[60.766082] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[67.956961] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (7.203s)
[68.230926] [009/133] (949s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[68.290752] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[68.293146] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[68.383916] [010/133] (949s left) kms_psr (fbc-psr2-sprite-render)
[68.474383] Starting subtest: fbc-psr2-sprite-render
[68.476336] Starting dynamic subtest: eDP-1
[68.480511] Dynamic subtest eDP-1: SKIP (0.000s)
[68.484698] Subtest fbc-psr2-sprite-render: SKIP (0.000s)
[68.547692] [011/133] (949s left) kms_fb_coherency (memset-crc)
[68.631335] Starting subtest: memset-crc
[68.633167] Starting dynamic subtest: mmap-offset-wc
[69.057478] Dynamic subtest mmap-offset-wc: SUCCESS (0.425s)
[69.347588] Starting dynamic subtest: mmap-offset-uc
[75.523765] Dynamic subtest mmap-offset-uc: SUCCESS (6.189s)
[75.816517] Subtest memset-crc: SUCCESS (7.188s)
[76.635015] [012/133] (941s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[76.746667] Starting subtest: x-tiled-8bpp-rotate-270
[76.767122] Subtest x-tiled-8bpp-rotate-270: SKIP (0.020s)
[76.867300] [013/133] (941s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[76.963218] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[76.967561] Starting dynamic subtest: pipe-A-eDP-1
[76.990320] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[76.999454] Starting dynamic subtest: pipe-B-eDP-1
[77.020276] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[77.027944] Starting dynamic subtest: pipe-C-eDP-1
[77.049321] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[77.059051] Starting dynamic subtest: pipe-D-eDP-1
[77.081578] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[77.085579] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[79.288443] [014/133] (938s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[79.381318] Starting subtest: psr-rgb565-draw-mmap-wc
[86.262755] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.884s)
[86.362621] [015/133] (931s left) kms_color (ctm-green-to-red)
[86.459843] Starting subtest: ctm-green-to-red
[86.462060] Starting dynamic subtest: pipe-A-eDP-1
[87.164458] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.705s)
[87.175459] Starting dynamic subtest: pipe-B-eDP-1
[88.631915] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.468s)
[88.640746] Starting dynamic subtest: pipe-C-eDP-1
[89.990539] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.355s)
[90.002589] Starting dynamic subtest: pipe-D-eDP-1
[91.279747] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.289s)
[91.282118] Subtest ctm-green-to-red: SUCCESS (4.818s)
[92.120633] [016/133] (925s left) gem_userptr_blits (map-fixed-invalidate)
[92.184186] Starting subtest: map-fixed-invalidate
[92.188516] Subtest map-fixed-invalidate: SKIP (0.000s)
[92.297065] [017/133] (925s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[92.389112] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[92.393751] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[93.570159] [018/133] (924s left) kms_vblank (wait-idle-hang)
[93.661370] Starting subtest: wait-idle-hang
[93.663347] Starting dynamic subtest: pipe-A-eDP-1
[119.645649] Dynamic subtest pipe-A-eDP-1: SUCCESS (25.984s)
[119.657758] Starting dynamic subtest: pipe-D-eDP-1
[134.679095] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.031s)
[134.681753] Subtest wait-idle-hang: SUCCESS (41.019s)
[135.510776] [019/133] (882s left) core_debugfs (read-all-entries)
[135.572446] Starting subtest: read-all-entries
[135.665277] Subtest read-all-entries: SUCCESS (0.094s)
[135.728808] [020/133] (882s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[135.914067] Starting subtest: cursor-rapid-movement-64x21
[135.960209] Subtest cursor-rapid-movement-64x21: SKIP (0.042s)
[136.193970] [021/133] (882s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[136.287033] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[136.289341] Starting dynamic subtest: pipe-A-default-mode
[139.077535] Dynamic subtest pipe-A-default-mode: SUCCESS (2.791s)
[139.079944] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.792s)
[139.918355] [022/133] (878s left) prime_self_import (basic-llseek-size)
[139.965091] Starting subtest: basic-llseek-size
[139.978059] Subtest basic-llseek-size: SUCCESS (0.016s)
[140.069225] [023/133] (878s left) kms_cursor_crc (cursor-alpha-opaque)
[140.154780] Starting subtest: cursor-alpha-opaque
[140.157061] Starting dynamic subtest: pipe-A-eDP-1
[140.787515] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.629s)
[140.795780] Starting dynamic subtest: pipe-D-eDP-1
[142.096644] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.308s)
[142.099056] Subtest cursor-alpha-opaque: SUCCESS (1.939s)
[142.986343] [024/133] (875s left) syncobj_timeline (invalid-query-illegal-handle)
[143.049829] Starting subtest: invalid-query-illegal-handle
[143.052233] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[143.148756] [025/133] (875s left) kms_flip (busy-flip)
[143.240399] Starting subtest: busy-flip
[143.242752] Starting dynamic subtest: A-eDP1
[144.898461] Dynamic subtest A-eDP1: SUCCESS (1.657s)
[144.908716] Starting dynamic subtest: B-eDP1
[146.522238] Dynamic subtest B-eDP1: SUCCESS (1.622s)
[146.531910] Starting dynamic subtest: C-eDP1
[148.247253] Dynamic subtest C-eDP1: SUCCESS (1.722s)
[148.256513] Starting dynamic subtest: D-eDP1
[149.876384] Dynamic subtest D-eDP1: SUCCESS (1.627s)
[149.878765] Subtest busy-flip: SUCCESS (6.639s)
[151.038777] [026/133] (867s left) gem_pxp (create-regular-buffer)
[151.184802] Starting subtest: create-regular-buffer
[151.187280] Subtest create-regular-buffer: SUCCESS (0.000s)
[151.304074] [027/133] (867s left) kms_dp_link_training (non-uhbr-sst)
[151.396796] Starting subtest: non-uhbr-sst
[151.406613] Subtest non-uhbr-sst: SKIP (0.000s)
[151.466655] [028/133] (867s left) kms_properties (get_properties-sanity-atomic)
[151.552106] Starting subtest: get_properties-sanity-atomic
[151.554433] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[151.623096] [029/133] (866s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[151.723352] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[151.727395] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[151.825439] [030/133] (866s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[151.881577] Starting subtest: verify-pxp-key-change-after-suspend-resume
[159.945534] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (8.063s)
[161.060374] [031/133] (858s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[161.128166] Starting subtest: invalid-multi-wait-unsubmitted
[161.130627] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[161.238582] [032/133] (858s left) kms_addfb_basic (bad-pitch-1024)
[161.297461] Starting subtest: bad-pitch-1024
[161.302641] Subtest bad-pitch-1024: SUCCESS (0.000s)
[161.460995] [033/133] (858s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[161.560917] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[162.615873] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.056s)
[162.726304] [034/133] (857s left) gem_exec_reloc (basic-cpu-active)
[162.783468] Subtest basic-cpu-active: SKIP (0.000s)
[162.847666] [035/133] (856s left) gem_exec_whisper (basic-queues-forked-all)
[162.909331] Starting subtest: basic-queues-forked-all
[183.091677] Subtest basic-queues-forked-all: SUCCESS (20.179s)
[183.273980] [036/133] (836s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[183.380076] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[183.384255] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[183.467072] [037/133] (836s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[183.571806] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[183.576265] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[183.670352] [038/133] (836s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[183.775093] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[190.356300] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.583s)
[190.491202] [039/133] (829s left) kms_psr (fbc-psr2-cursor-blt)
[190.601358] Starting subtest: fbc-psr2-cursor-blt
[190.603654] Starting dynamic subtest: eDP-1
[190.608110] Dynamic subtest eDP-1: SKIP (0.000s)
[190.612493] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[190.673051] [040/133] (829s left) kms_plane_scaling (planes-upscale-20x20)
[190.757051] Starting subtest: planes-upscale-20x20
[190.759380] Starting dynamic subtest: pipe-A
[190.817906] Dynamic subtest pipe-A: SUCCESS (0.063s)
[190.828491] Starting dynamic subtest: pipe-B
[192.010693] Dynamic subtest pipe-B: SUCCESS (1.192s)
[192.022493] Starting dynamic subtest: pipe-C
[193.117195] Dynamic subtest pipe-C: SUCCESS (1.106s)
[193.126615] Starting dynamic subtest: pipe-D
[194.259924] Dynamic subtest pipe-D: SUCCESS (1.142s)
[194.262227] Subtest planes-upscale-20x20: SUCCESS (3.505s)
[195.436916] [041/133] (824s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[195.544635] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[195.546838] Starting dynamic subtest: pipe-A-eDP-1
[201.318999] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.779s)
[201.329709] Starting dynamic subtest: pipe-B-eDP-1
[207.971669] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.650s)
[207.973865] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.431s)
[208.855447] [042/133] (811s left) gem_mmap_gtt (basic-read-write)
[208.912190] Subtest basic-read-write: SKIP (0.000s)
[208.966049] [043/133] (811s left) kms_busy (extended-modeset-hang-oldfb)
[209.067112] Starting subtest: extended-modeset-hang-oldfb
[209.069506] Starting dynamic subtest: pipe-A
[220.622884] Dynamic subtest pipe-A: SUCCESS (11.555s)
[220.633489] Starting dynamic subtest: pipe-D
[232.893135] Dynamic subtest pipe-D: SUCCESS (12.265s)
[232.895271] Subtest extended-modeset-hang-oldfb: SUCCESS (23.824s)
[233.773986] [044/133] (786s left) i915_drm_fdinfo (memory-info-resident)
[233.820909] Starting subtest: memory-info-resident
[233.823314] Starting dynamic subtest: smem0
[236.749467] Dynamic subtest smem0: SUCCESS (2.931s)
[236.751827] Subtest memory-info-resident: SUCCESS (2.933s)
[236.824498] [045/133] (783s left) gem_ctx_isolation (nonpriv)
[236.889393] Starting subtest: nonpriv
[236.891515] Starting dynamic subtest: rcs0
[237.184131] Dynamic subtest rcs0: SUCCESS (0.294s)
[237.193883] Starting dynamic subtest: bcs0
[237.502906] Dynamic subtest bcs0: SUCCESS (0.318s)
[237.514447] Starting dynamic subtest: vcs0
[237.787322] Dynamic subtest vcs0: SUCCESS (0.283s)
[237.796071] Starting dynamic subtest: vcs1
[239.176431] Dynamic subtest vcs1: SUCCESS (1.388s)
[239.188653] Starting dynamic subtest: vecs0
[241.161707] Dynamic subtest vecs0: SUCCESS (1.984s)
[241.173544] Starting dynamic subtest: ccs0
[243.166784] Dynamic subtest ccs0: SUCCESS (2.003s)
[243.169618] Subtest nonpriv: SUCCESS (6.277s)
[243.424977] [046/133] (776s left) i915_drm_fdinfo (virtual-busy-hang-all)
[243.465715] Starting subtest: virtual-busy-hang-all
[243.470184] Subtest virtual-busy-hang-all: SKIP (0.000s)
[243.531575] [047/133] (776s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[243.623865] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[243.626106] Starting dynamic subtest: pipe-A-eDP-1
[243.648546] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[243.659191] Starting dynamic subtest: pipe-B-eDP-1
[243.680632] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[243.689409] Starting dynamic subtest: pipe-C-eDP-1
[243.710664] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[243.719410] Starting dynamic subtest: pipe-D-eDP-1
[243.742244] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[243.746271] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[245.947548] [048/133] (774s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[246.046517] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[246.050885] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[246.160085] [049/133] (774s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[246.262985] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[246.267041] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[246.334228] [050/133] (774s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[246.383517] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[246.385510] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s)
[246.490804] [051/133] (774s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[246.575257] Starting subtest: compare-crc-sanitycheck-xr24
[246.577633] Starting dynamic subtest: pipe-A-eDP-1
[247.205046] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.627s)
[247.220757] Starting dynamic subtest: pipe-B-eDP-1
[248.540684] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.335s)
[248.550707] Starting dynamic subtest: pipe-C-eDP-1
[249.806474] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.265s)
[249.816401] Starting dynamic subtest: pipe-D-eDP-1
[251.070475] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.260s)
[251.072653] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.493s)
[251.887884] [052/133] (768s left) kms_content_protection (uevent)
[252.033939] Starting subtest: uevent
[252.038524] Subtest uevent: SKIP (0.000s)
[252.167616] [053/133] (768s left) kms_prop_blob (basic)
[252.219096] Starting subtest: basic
[252.220972] Subtest basic: SUCCESS (0.000s)
[252.325034] [054/133] (768s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[252.467603] Starting subtest: 2x-long-cursor-vs-flip-legacy
[252.472183] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s)
[252.621682] [055/133] (768s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[252.723242] Starting subtest: pr-overlay-plane-move-continuous-sf
[252.727477] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[252.789828] [056/133] (767s left) gen7_exec_parse (basic-allocation)
[252.849998] Subtest basic-allocation: SKIP (0.000s)
[252.918272] [057/133] (767s left) sriov_basic (bind-unbind-vf)
[252.975991] Starting subtest: bind-unbind-vf
[252.978014] Starting dynamic subtest: vf-1
[253.038040] Dynamic subtest vf-1: FAIL (0.014s)
[253.046528] Starting dynamic subtest: vf-2
[253.103199] Dynamic subtest vf-2: FAIL (0.004s)
[253.111487] Starting dynamic subtest: vf-3
[253.168254] Dynamic subtest vf-3: FAIL (0.004s)
[253.176586] Starting dynamic subtest: vf-4
[253.232007] Dynamic subtest vf-4: FAIL (0.004s)
[253.240669] Starting dynamic subtest: vf-5
[253.297054] Dynamic subtest vf-5: FAIL (0.004s)
[253.305174] Starting dynamic subtest: vf-6
[253.360835] Dynamic subtest vf-6: FAIL (0.004s)
[253.370116] Starting dynamic subtest: vf-7
[253.427349] Dynamic subtest vf-7: FAIL (0.004s)
[253.435206] Starting dynamic subtest: vf-random
[253.491850] Dynamic subtest vf-random: FAIL (0.004s)
[253.500251] Starting dynamic subtest: vf-last
[253.556461] Dynamic subtest vf-last: FAIL (0.400s)
[253.558206] Subtest bind-unbind-vf: FAIL (0.448s)
[253.592320] [058/133] (767s left) gem_exec_schedule (pi-userfault)
[253.769872] Starting subtest: pi-userfault
[253.771579] Starting dynamic subtest: rcs0
[253.781015] Dynamic subtest rcs0: SUCCESS (0.012s)
[253.792103] Starting dynamic subtest: bcs0
[253.793957] Dynamic subtest bcs0: SUCCESS (0.008s)
[253.802769] Starting dynamic subtest: vcs0
[253.804383] Dynamic subtest vcs0: SUCCESS (0.007s)
[253.812998] Starting dynamic subtest: vcs1
[253.814875] Dynamic subtest vcs1: SUCCESS (0.008s)
[253.823542] Starting dynamic subtest: vecs0
[253.825195] Dynamic subtest vecs0: SUCCESS (0.008s)
[253.834101] Starting dynamic subtest: ccs0
[253.835972] Dynamic subtest ccs0: SUCCESS (0.009s)
[253.837853] Subtest pi-userfault: SUCCESS (0.057s)
[254.008096] [059/133] (766s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[254.103062] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[254.106847] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[254.217318] [060/133] (766s left) i915_query (query-garbage)
[254.261287] Starting subtest: query-garbage
[254.262924] Subtest query-garbage: SUCCESS (0.000s)
[254.353834] [061/133] (766s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[254.748167] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[255.520718] [062/133] (765s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[255.624443] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[263.410439] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.787s)
[263.537355] [063/133] (757s left) perf (gen12-mi-rpc)
[263.649987] Starting subtest: gen12-mi-rpc
[263.652272] Starting dynamic subtest: rcs0
[263.669116] Dynamic subtest rcs0: SUCCESS (0.017s)
[263.671287] Subtest gen12-mi-rpc: SUCCESS (0.018s)
[263.706918] [064/133] (757s left) gen9_exec_parse (bb-start-param)
[263.784426] Subtest bb-start-param: SKIP (0.000s)
[263.845722] [065/133] (757s left) gem_exec_schedule (thriceslice)
[263.912983] Starting subtest: thriceslice
[263.914930] Starting dynamic subtest: rcs0
[263.932720] Dynamic subtest rcs0: SUCCESS (0.030s)
[263.944867] Starting dynamic subtest: bcs0
[263.961411] Dynamic subtest bcs0: SUCCESS (0.028s)
[263.970299] Starting dynamic subtest: vcs0
[263.990296] Dynamic subtest vcs0: SUCCESS (0.027s)
[263.999305] Starting dynamic subtest: vcs1
[264.018160] Dynamic subtest vcs1: SUCCESS (0.027s)
[264.027219] Starting dynamic subtest: vecs0
[264.068616] Dynamic subtest vecs0: SUCCESS (0.049s)
[264.078212] Starting dynamic subtest: ccs0
[264.098757] Dynamic subtest ccs0: SUCCESS (0.029s)
[264.100940] Subtest thriceslice: SUCCESS (0.197s)
[264.398444] [066/133] (756s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[264.488642] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[264.492781] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[264.587900] [067/133] (756s left) syncobj_wait (wait-all-delayed-signal)
[264.637265] Starting subtest: wait-all-delayed-signal
[264.741056] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[264.820070] [068/133] (756s left) dmabuf_sync_file (export-before-signal)
[264.925837] Starting subtest: export-before-signal
[264.928330] Subtest export-before-signal: SUCCESS (0.001s)
[264.994810] [FACT dmabuf_sync_file (export-before-signal)] new: kernel.kmod_is_loaded.vgem: true
[264.998561] [069/133] (756s left) i915_pm_freq_mult (media-freq)
[265.043680] Starting subtest: media-freq
[265.045918] Starting dynamic subtest: gt0
[265.050281] Dynamic subtest gt0: SKIP (0.000s)
[265.063229] Starting dynamic subtest: gt1
[265.067824] Dynamic subtest gt1: SKIP (0.000s)
[265.072263] Subtest media-freq: SKIP (0.001s)
[265.144613] [070/133] (756s left) gem_lmem_swapping (random-engines)
[265.187776] Subtest random-engines: SKIP (0.000s)
[265.229148] [071/133] (756s left) kms_cursor_crc (cursor-sliding-256x85)
[265.489865] Starting subtest: cursor-sliding-256x85
[265.540092] Subtest cursor-sliding-256x85: SKIP (0.045s)
[265.705233] [072/133] (755s left) gem_cs_tlb (engines)
[265.776815] Starting subtest: engines
[265.778758] Starting dynamic subtest: rcs0
[267.932054] Dynamic subtest rcs0: SUCCESS (2.152s)
[267.944017] Starting dynamic subtest: bcs0
[270.087344] Dynamic subtest bcs0: SUCCESS (2.153s)
[270.097600] Starting dynamic subtest: vcs0
[272.251414] Dynamic subtest vcs0: SUCCESS (2.151s)
[272.260831] Starting dynamic subtest: vcs1
[274.392266] Dynamic subtest vcs1: SUCCESS (2.151s)
[274.403391] Starting dynamic subtest: vecs0
[276.543935] Dynamic subtest vecs0: SUCCESS (2.151s)
[276.554191] Starting dynamic subtest: ccs0
[278.697089] Dynamic subtest ccs0: SUCCESS (2.152s)
[278.699075] Subtest engines: SUCCESS (12.916s)
[278.828931] [073/133] (742s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[278.921874] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[278.949566] Starting dynamic subtest: pipe-A-plane-0
[279.581315] Dynamic subtest pipe-A-plane-0: SUCCESS (0.633s)
[279.591517] Starting dynamic subtest: pipe-A-plane-3
[279.980773] Dynamic subtest pipe-A-plane-3: SUCCESS (0.399s)
[281.051962] Starting dynamic subtest: pipe-B-plane-0
[281.693886] Dynamic subtest pipe-B-plane-0: SUCCESS (0.655s)
[281.703549] Starting dynamic subtest: pipe-B-plane-3
[282.115857] Dynamic subtest pipe-B-plane-3: SUCCESS (0.421s)
[282.438258] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (3.516s)
[283.243620] [074/133] (738s left) gem_exec_reloc (basic-active)
[283.313939] Subtest basic-active: SKIP (0.000s)
[283.389290] [075/133] (738s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[283.491277] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[283.495496] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[283.591372] [076/133] (737s left) kms_chamelium_frames (dp-frame-dump)
[283.993927] Subtest dp-frame-dump: SKIP (0.000s)
[284.772724] [077/133] (736s left) kms_hdr (static-toggle)
[284.871472] Starting subtest: static-toggle
[284.878117] Subtest static-toggle: SKIP (0.000s)
[284.960585] [078/133] (736s left) kms_atomic_transition (modeset-transition)
[285.050172] Starting subtest: modeset-transition
[285.052458] Starting dynamic subtest: 1x-outputs
[295.827100] Dynamic subtest 1x-outputs: SUCCESS (10.778s)
[295.829945] Subtest modeset-transition: SUCCESS (10.779s)
[296.681367] [079/133] (724s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[296.801640] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[297.802831] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.001s)
[297.914268] [080/133] (723s left) kms_rotation_crc (bad-tiling)
[297.999800] Starting subtest: bad-tiling
[298.003490] Subtest bad-tiling: SKIP (0.001s)
[298.073893] [081/133] (723s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[298.164482] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[298.166288] Starting dynamic subtest: pipe-A-eDP-1
[298.913923] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.741s)
[298.924735] Starting dynamic subtest: pipe-B-eDP-1
[300.701532] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.786s)
[300.711776] Starting dynamic subtest: pipe-C-eDP-1
[302.537055] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.834s)
[302.549510] Starting dynamic subtest: pipe-D-eDP-1
[304.367380] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.829s)
[304.369615] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.196s)
[305.494748] [082/133] (716s left) prime_mmap (test_errors)
[305.551531] Starting subtest: test_errors
[305.553554] Starting dynamic subtest: test_errors-smem
[305.652828] Dynamic subtest test_errors-smem: SUCCESS (0.103s)
[305.655875] Subtest test_errors: SUCCESS (0.104s)
[305.774585] [083/133] (716s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[305.887537] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[306.845256] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.958s)
[307.725185] [084/133] (714s left) gem_workarounds (reset-fd)
[307.796999] Starting subtest: reset-fd
[307.977615] Subtest reset-fd: SUCCESS (0.181s)
[308.093105] [085/133] (713s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[308.193464] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[308.197630] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[308.288527] [086/133] (713s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[308.388550] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[308.392950] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[308.501314] [087/133] (713s left) gem_exec_balancer (semaphore)
[308.570564] Starting subtest: semaphore
[309.883401] Subtest semaphore: SUCCESS (1.311s)
[310.223746] [088/133] (711s left) kms_addfb_basic (basic)
[310.286262] Starting subtest: basic
[310.288147] Subtest basic: SUCCESS (0.000s)
[310.435227] [089/133] (711s left) gem_sync (basic-all)
[310.511699] Starting subtest: basic-all
[313.878443] Subtest basic-all: SUCCESS (3.375s)
[314.083182] [090/133] (708s left) api_intel_allocator (gem-pool)
[314.147996] Starting subtest: gem-pool
[314.157095] Subtest gem-pool: SUCCESS (0.012s)
[314.294483] [091/133] (707s left) perf_pmu (busy-idle-no-semaphores)
[314.334992] Starting subtest: busy-idle-no-semaphores
[314.337313] Starting dynamic subtest: rcs0
[314.995842] Dynamic subtest rcs0: SUCCESS (0.659s)
[315.007819] Starting dynamic subtest: bcs0
[315.651686] Dynamic subtest bcs0: SUCCESS (0.653s)
[315.664213] Starting dynamic subtest: vcs0
[316.304844] Dynamic subtest vcs0: SUCCESS (0.651s)
[316.317056] Starting dynamic subtest: vcs1
[317.501070] Dynamic subtest vcs1: SUCCESS (1.194s)
[317.513076] Starting dynamic subtest: vecs0
[319.554624] Dynamic subtest vecs0: SUCCESS (2.050s)
[319.567205] Starting dynamic subtest: ccs0
[321.472712] Dynamic subtest ccs0: SUCCESS (1.916s)
[321.475673] Subtest busy-idle-no-semaphores: SUCCESS (7.137s)
[321.593305] [092/133] (700s left) kms_atomic_interruptible (legacy-setmode)
[321.688861] Starting subtest: legacy-setmode
[321.691146] Starting dynamic subtest: pipe-A-eDP-1
[328.596842] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.904s)
[328.599065] Subtest legacy-setmode: SUCCESS (6.905s)
[329.484135] [093/133] (692s left) gem_userptr_blits (sync-overlap)
[329.554896] Starting subtest: sync-overlap
[329.557229] Subtest sync-overlap: SUCCESS (0.000s)
[329.682605] [094/133] (692s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[329.777674] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[329.782234] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[329.871543] [095/133] (692s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[329.927048] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[330.033696] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.106s)
[330.111575] [096/133] (692s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[330.168622] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[330.274434] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[330.352780] [097/133] (692s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[330.438069] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[330.440391] Starting dynamic subtest: pipe-A-default-mode
[333.222411] Dynamic subtest pipe-A-default-mode: SUCCESS (2.783s)
[333.224605] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.784s)
[334.057986] [098/133] (688s left) gem_exec_whisper (basic-contexts)
[334.125112] Starting subtest: basic-contexts
[340.951290] Subtest basic-contexts: SUCCESS (6.826s)
[341.147278] [099/133] (681s left) prime_vgem (fence-flip-hang)
[341.232426] Subtest fence-flip-hang: SKIP (0.000s)
[341.336561] [100/133] (681s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[341.448080] Starting subtest: psr-farfromfence-mmap-gtt
[341.452163] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[341.568918] [101/133] (681s left) gem_exec_fence (syncobj-invalid-flags)
[342.028847] Starting subtest: syncobj-invalid-flags
[342.030894] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[343.972048] [102/133] (678s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[344.038766] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[344.043758] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[344.242488] [103/133] (678s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[344.367371] Starting subtest: fbcpsr-rgb101010-draw-blt
[351.114351] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.747s)
[351.231726] [104/133] (671s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[351.327682] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[351.332068] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[351.422701] [105/133] (671s left) kms_flip (2x-flip-vs-panning-vs-hang)
[351.515028] Starting subtest: 2x-flip-vs-panning-vs-hang
[351.527453] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.011s)
[351.621902] [106/133] (671s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[351.719111] Starting subtest: multiplane-rotation-cropping-top
[369.209880] Subtest multiplane-rotation-cropping-top: SUCCESS (17.493s)
[369.327779] [107/133] (653s left) gem_exec_balancer (full-late-pulse)
[369.399102] Starting subtest: full-late-pulse
[373.777711] Subtest full-late-pulse: SUCCESS (4.378s)
[374.098682] [108/133] (648s left) kms_psr (pr-dpms)
[374.192072] Starting subtest: pr-dpms
[374.196430] Subtest pr-dpms: SKIP (0.000s)
[374.266928] [109/133] (648s left) kms_plane_lowres (tiling-none)
[374.353957] Starting subtest: tiling-none
[374.356270] Starting dynamic subtest: pipe-A-eDP-1
[374.360832] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[374.651798] Starting dynamic subtest: pipe-B-eDP-1
[374.656555] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[374.666576] Starting dynamic subtest: pipe-C-eDP-1
[374.671337] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[374.681338] Starting dynamic subtest: pipe-D-eDP-1
[374.685862] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[374.690311] Subtest tiling-none: SKIP (0.296s)
[375.534167] [110/133] (647s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[375.632871] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[375.636935] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[375.700712] [111/133] (647s left) gem_ctx_persistence (legacy-engines-hang)
[375.753324] Starting subtest: legacy-engines-hang
[375.755628] Starting dynamic subtest: render
[375.822832] Dynamic subtest render: SUCCESS (0.069s)
[375.835698] Starting dynamic subtest: bsd1
[375.920603] Dynamic subtest bsd1: SUCCESS (0.096s)
[375.935176] Starting dynamic subtest: bsd2
[376.008844] Dynamic subtest bsd2: SUCCESS (0.085s)
[376.024125] Starting dynamic subtest: blt
[376.084644] Dynamic subtest blt: SUCCESS (0.072s)
[376.097560] Starting dynamic subtest: vebox
[376.219631] Dynamic subtest vebox: SUCCESS (0.134s)
[376.222194] Subtest legacy-engines-hang: SUCCESS (0.468s)
[376.301444] [112/133] (646s left) gem_exec_reloc (basic-write-read)
[376.379019] Subtest basic-write-read: SKIP (0.000s)
[376.452800] [113/133] (646s left) syncobj_timeline (signal-point-0)
[376.504165] Starting subtest: signal-point-0
[376.505911] Subtest signal-point-0: SUCCESS (0.000s)
[376.622152] [114/133] (646s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[376.717513] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[376.721139] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[376.792274] [115/133] (646s left) kms_pm_backlight (fade)
[376.888339] Starting subtest: fade
[376.940304] Starting dynamic subtest: eDP-1
[379.416883] Dynamic subtest eDP-1: SUCCESS (2.478s)
[379.419241] Subtest fade: SUCCESS (2.529s)
[380.262162] [116/133] (642s left) gem_ctx_shared (q-promotion)
[380.327779] Starting subtest: Q-promotion
[380.330847] Starting dynamic subtest: rcs0
[380.443354] Dynamic subtest rcs0: SUCCESS (0.113s)
[380.460064] Starting dynamic subtest: vcs0
[380.529078] Dynamic subtest vcs0: SUCCESS (0.085s)
[380.544730] Starting dynamic subtest: vcs1
[380.615156] Dynamic subtest vcs1: SUCCESS (0.084s)
[380.631929] Starting dynamic subtest: vecs0
[380.699989] Dynamic subtest vecs0: SUCCESS (0.085s)
[380.716091] Starting dynamic subtest: ccs0
[380.792978] Dynamic subtest ccs0: SUCCESS (0.091s)
[380.795605] Subtest Q-promotion: SUCCESS (0.464s)
[382.024490] [117/133] (641s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[382.130653] Starting subtest: y-tiled-8bpp-rotate-90
[382.135148] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[382.230273] [118/133] (641s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[382.328303] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[382.330181] Starting dynamic subtest: pipe-A-eDP-1
[383.699222] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.370s)
[383.978604] Starting dynamic subtest: pipe-B-eDP-1
[385.014368] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.044s)
[385.294970] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.966s)
[386.126764] [119/133] (637s left) gem_flink_basic (bad-open)
[386.183678] Starting subtest: bad-open
[386.185971] Subtest bad-open: SUCCESS (0.000s)
[386.291239] [120/133] (637s left) gem_mmap_offset (partial-unmap)
[386.355507] Starting subtest: partial-unmap
[386.357754] Starting dynamic subtest: smem0
[386.868296] Dynamic subtest smem0: SUCCESS (0.511s)
[386.871052] Subtest partial-unmap: SUCCESS (0.513s)
[386.969684] [121/133] (636s left) kms_psr (psr2-sprite-blt)
[387.057168] Starting subtest: psr2-sprite-blt
[387.059414] Starting dynamic subtest: eDP-1
[388.825487] Dynamic subtest eDP-1: SUCCESS (1.768s)
[388.827809] Subtest psr2-sprite-blt: SUCCESS (1.769s)
[389.691112] [122/133] (633s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[389.809064] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[389.813482] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[389.924547] [123/133] (633s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[389.985523] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[389.987433] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[390.084616] [124/133] (633s left) kms_flip (plain-flip-fb-recreate)
[390.192973] Starting subtest: plain-flip-fb-recreate
[390.195304] Starting dynamic subtest: A-eDP1
[399.077853] Dynamic subtest A-eDP1: SUCCESS (8.885s)
[399.089964] Starting dynamic subtest: B-eDP1
[407.920920] Dynamic subtest B-eDP1: SUCCESS (8.841s)
[407.931134] Starting dynamic subtest: C-eDP1
[416.731390] Dynamic subtest C-eDP1: SUCCESS (8.808s)
[416.747499] Starting dynamic subtest: D-eDP1
[425.560278] Dynamic subtest D-eDP1: SUCCESS (8.826s)
[425.564446] Subtest plain-flip-fb-recreate: SUCCESS (35.374s)
[426.742924] [125/133] (596s left) kms_selftest (drm_dp_mst_helper)
[426.781758] Starting subtest: drm_dp_mst_helper
[426.791033] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[426.900717] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.111s)
[426.912586] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[427.006226] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.105s)
[427.016688] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[427.112652] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.106s)
[427.114768] Subtest drm_dp_mst_helper: SUCCESS (0.332s)
[427.270757] [126/133] (596s left) gem_softpin (allocator-basic)
[427.322730] Starting subtest: allocator-basic
[427.394802] Subtest allocator-basic: SUCCESS (0.072s)
[427.520705] [127/133] (596s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[427.621917] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[427.626072] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[427.736682] [128/133] (596s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[427.840550] Starting subtest: yf-tiled-32bpp-rotate-270
[427.844635] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[427.934851] [129/133] (595s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[428.038560] Starting subtest: psr-2p-primscrn-spr-indfb-move
[428.042197] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[428.137047] [130/133] (595s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[428.231984] Starting subtest: fbc-2p-pri-indfb-multidraw
[428.235491] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[428.329025] [131/133] (595s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[428.420089] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[432.041368] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.623s)
[433.243408] [132/133] (590s left) gem_sync (basic-store-each)
[433.331838] Starting subtest: basic-store-each
[435.726770] Subtest basic-store-each: SUCCESS (2.405s)
[435.915664] [133/133] (588s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[436.018865] Starting subtest: fbc-indfb-scaledprimary
[439.026885] Subtest fbc-indfb-scaledprimary: SUCCESS (3.010s)
[440.172463] Closing watchdogs
results: parsing output: 0/ for test: kms_plane_scaling
results: parsing output: 1/ for test: fbdev
results: parsing output: 2/ for test: intel_hwmon
results: parsing output: 3/ for test: gem_exec_params
results: parsing output: 4/ for test: i915_query
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: sysfs_timeslice_duration
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: syncobj_wait
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: kms_fb_coherency
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: kms_ccs
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_color
results: parsing output: 15/ for test: gem_userptr_blits
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: kms_vblank
results: parsing output: 18/ for test: core_debugfs
results: parsing output: 19/ for test: kms_cursor_crc
results: parsing output: 20/ for test: kms_flip_scaled_crc
results: parsing output: 21/ for test: prime_self_import
results: parsing output: 22/ for test: kms_cursor_crc
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: kms_flip
results: parsing output: 25/ for test: gem_pxp
results: parsing output: 26/ for test: kms_dp_link_training
results: parsing output: 27/ for test: kms_properties
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_pxp
results: parsing output: 30/ for test: syncobj_wait
results: parsing output: 31/ for test: kms_addfb_basic
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: gem_exec_reloc
results: parsing output: 34/ for test: gem_exec_whisper
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: kms_plane_scaling
results: parsing output: 40/ for test: kms_psr2_sf
results: parsing output: 41/ for test: gem_mmap_gtt
results: parsing output: 42/ for test: kms_busy
results: parsing output: 43/ for test: i915_drm_fdinfo
results: parsing output: 44/ for test: gem_ctx_isolation
results: parsing output: 45/ for test: i915_drm_fdinfo
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_flip_scaled_crc
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: kms_pipe_crc_basic
results: parsing output: 51/ for test: kms_content_protection
results: parsing output: 52/ for test: kms_prop_blob
results: parsing output: 53/ for test: kms_cursor_legacy
results: parsing output: 54/ for test: kms_psr2_sf
results: parsing output: 55/ for test: gen7_exec_parse
results: parsing output: 56/ for test: sriov_basic
results: parsing output: 57/ for test: gem_exec_schedule
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: i915_query
results: parsing output: 60/ for test: kms_chamelium_hpd
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: perf
results: parsing output: 63/ for test: gen9_exec_parse
results: parsing output: 64/ for test: gem_exec_schedule
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: syncobj_wait
results: parsing output: 67/ for test: dmabuf_sync_file
results: parsing output: 68/ for test: i915_pm_freq_mult
results: parsing output: 69/ for test: gem_lmem_swapping
results: parsing output: 70/ for test: kms_cursor_crc
results: parsing output: 71/ for test: gem_cs_tlb
results: parsing output: 72/ for test: kms_plane
results: parsing output: 73/ for test: gem_exec_reloc
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_chamelium_frames
results: parsing output: 76/ for test: kms_hdr
results: parsing output: 77/ for test: kms_atomic_transition
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: kms_rotation_crc
results: parsing output: 80/ for test: kms_ccs
results: parsing output: 81/ for test: prime_mmap
results: parsing output: 82/ for test: kms_cursor_legacy
results: parsing output: 83/ for test: gem_workarounds
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_exec_balancer
results: parsing output: 87/ for test: kms_addfb_basic
results: parsing output: 88/ for test: gem_sync
results: parsing output: 89/ for test: api_intel_allocator
results: parsing output: 90/ for test: perf_pmu
results: parsing output: 91/ for test: kms_atomic_interruptible
results: parsing output: 92/ for test: gem_userptr_blits
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: syncobj_wait
results: parsing output: 96/ for test: kms_flip_scaled_crc
results: parsing output: 97/ for test: gem_exec_whisper
results: parsing output: 98/ for test: prime_vgem
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_exec_fence
results: parsing output: 101/ for test: gem_render_copy
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: kms_flip
results: parsing output: 105/ for test: kms_rotation_crc
results: parsing output: 106/ for test: gem_exec_balancer
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: kms_plane_lowres
results: parsing output: 109/ for test: kms_joiner
results: parsing output: 110/ for test: gem_ctx_persistence
results: parsing output: 111/ for test: gem_exec_reloc
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: kms_psr2_sf
results: parsing output: 114/ for test: kms_pm_backlight
results: parsing output: 115/ for test: gem_ctx_shared
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_atomic_transition
results: parsing output: 118/ for test: gem_flink_basic
results: parsing output: 119/ for test: gem_mmap_offset
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: kms_flip
results: parsing output: 124/ for test: kms_selftest
results: parsing output: 125/ for test: gem_softpin
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_sync
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.