[55.782375] Initializing watchdogs
[55.782424]   /dev/watchdog0
[55.798527] [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]
[55.803034] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.805585] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.809041] [001/133] (960s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[55.921352] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[55.923320] Starting dynamic subtest: pipe-A-default-mode
[57.067222] Dynamic subtest pipe-A-default-mode: SKIP (1.132s)
[57.071885] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.133s)
[57.232680] [002/133] (959s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[57.325321] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[57.327575] Starting dynamic subtest: pipe-A-eDP-1
[57.350644] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[57.361145] Starting dynamic subtest: pipe-B-eDP-1
[57.384678] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[57.394266] Starting dynamic subtest: pipe-C-eDP-1
[57.417227] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[57.425378] Starting dynamic subtest: pipe-D-eDP-1
[57.447652] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[57.451794] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[59.598583] [003/133] (956s left) syncobj_basic (create-signaled)
[59.658815] Starting subtest: create-signaled
[59.660763] Subtest create-signaled: SUCCESS (0.000s)
[59.746895] [004/133] (956s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[59.838746] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[59.843193] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[59.927739] [005/133] (956s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[60.026273] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[60.028536] Starting dynamic subtest: pipe-A-eDP-1
[60.049926] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[60.059906] Starting dynamic subtest: pipe-B-eDP-1
[60.079763] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[60.086928] Starting dynamic subtest: pipe-C-eDP-1
[60.105223] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[60.112482] Starting dynamic subtest: pipe-D-eDP-1
[60.131757] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[60.133996] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[62.270706] [006/133] (954s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[62.377702] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[68.998424] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.606s)
[69.109517] [007/133] (947s left) kms_properties (invalid-properties-legacy)
[69.203427] Starting subtest: invalid-properties-legacy
[69.308325] Subtest invalid-properties-legacy: SUCCESS (0.106s)
[69.377343] [008/133] (947s left) gem_close_race (basic-threads)
[69.448955] Starting subtest: basic-threads
[70.782047] Subtest basic-threads: SUCCESS (1.333s)
[70.961974] [009/133] (945s left) kms_3d (basic)
[71.027236] Starting subtest: basic
[73.038311] Subtest basic: SUCCESS (2.011s)
[73.604234] [010/133] (943s left) kms_chamelium_frames (vga-frame-dump)
[74.038709] Subtest vga-frame-dump: SKIP (0.000s)
[74.827850] [011/133] (941s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[74.926234] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[81.874211] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (6.947s)
[81.978282] [012/133] (934s left) gem_render_copy_redux (normal)
[82.042513] Starting subtest: normal
[82.297086] Subtest normal: SUCCESS (0.255s)
[82.422195] [013/133] (934s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[82.517568] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[83.185482] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.670s)
[83.388094] [014/133] (933s left) gem_exec_params (rel-constants-invalid)
[83.455203] Starting subtest: rel-constants-invalid
[83.457738] Subtest rel-constants-invalid: SUCCESS (0.000s)
[83.559967] [015/133] (933s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[83.653352] Starting subtest: primary-x-tiled-reflect-x-0
[90.602523] Subtest primary-x-tiled-reflect-x-0: SUCCESS (6.948s)
[91.777998] [016/133] (925s left) gem_fenced_exec_thrash (too-many-fences)
[91.838960] Subtest too-many-fences: SKIP (0.000s)
[91.909904] [017/133] (925s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[91.968718] Starting subtest: invalid-single-wait-all-unsubmitted
[91.971425] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[92.064617] [018/133] (924s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[92.173171] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[124.111127] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.934s)
[124.984708] [019/133] (892s left) kms_vrr (flip-basic)
[125.076935] Starting subtest: flip-basic
[125.083246] Subtest flip-basic: SKIP (0.000s)
[125.161332] [020/133] (891s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[125.222166] Starting subtest: wait-all-for-submit-delayed-submit
[125.326193] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[125.401643] [021/133] (891s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[125.512203] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[125.516246] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[125.579349] [022/133] (891s left) kms_cursor_crc (cursor-random-64x64)
[125.758234] Starting subtest: cursor-random-64x64
[125.763211] Starting dynamic subtest: pipe-A-eDP-1
[129.096226] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.333s)
[129.129859] Starting dynamic subtest: pipe-D-eDP-1
[133.140976] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.018s)
[133.143056] Subtest cursor-random-64x64: SUCCESS (7.379s)
[133.954295] [023/133] (883s left) kms_cdclk (mode-transition)
[134.059101] Starting subtest: mode-transition
[134.061412] Starting dynamic subtest: pipe-A-eDP-1
[134.351215] Dynamic subtest pipe-A-eDP-1: SKIP (0.290s)
[134.360329] Starting dynamic subtest: pipe-B-eDP-1
[134.364695] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[134.372620] Starting dynamic subtest: pipe-C-eDP-1
[134.377086] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[134.385020] Starting dynamic subtest: pipe-D-eDP-1
[134.389324] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[134.393747] Subtest mode-transition: SKIP (0.296s)
[135.154766] [024/133] (882s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[135.253079] Starting subtest: psr-dirtyfb-ioctl
[135.255589] Starting dynamic subtest: A-eDP-1
[139.201957] Dynamic subtest A-eDP-1: SUCCESS (3.950s)
[139.204300] Subtest psr-dirtyfb-ioctl: SUCCESS (3.951s)
[140.061630] [025/133] (877s left) gem_pread (exhaustion)
[140.115525] Subtest exhaustion: SKIP (0.000s)
[140.182306] [026/133] (877s left) dumb_buffer (map-invalid-size)
[140.235969] Starting subtest: map-invalid-size
[140.238231] Subtest map-invalid-size: SUCCESS (0.000s)
[140.331278] [027/133] (877s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[140.434647] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[140.438786] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[140.529307] [028/133] (876s left) kms_psr (fbc-psr2-cursor-plane-move)
[140.628482] Starting subtest: fbc-psr2-cursor-plane-move
[140.630737] Starting dynamic subtest: eDP-1
[140.635230] Dynamic subtest eDP-1: SKIP (0.000s)
[140.639688] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[140.697219] [029/133] (876s left) gem_spin_batch (legacy-resubmit-new)
[140.764841] Starting subtest: legacy-resubmit-new
[140.767287] Starting dynamic subtest: default
[140.772706] Dynamic subtest default: SUCCESS (0.007s)
[140.781339] Starting dynamic subtest: render
[140.783716] Dynamic subtest render: SUCCESS (0.003s)
[140.791997] Starting dynamic subtest: bsd
[140.794299] Dynamic subtest bsd: SUCCESS (0.004s)
[140.802688] Starting dynamic subtest: bsd1
[140.804580] Dynamic subtest bsd1: SUCCESS (0.005s)
[140.812129] Starting dynamic subtest: bsd2
[140.813974] Dynamic subtest bsd2: SUCCESS (0.003s)
[140.821446] Starting dynamic subtest: blt
[140.823331] Dynamic subtest blt: SUCCESS (0.004s)
[140.830633] Starting dynamic subtest: vebox
[140.832526] Dynamic subtest vebox: SUCCESS (0.003s)
[140.834424] Subtest legacy-resubmit-new: SUCCESS (0.033s)
[142.384884] [030/133] (875s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[142.498974] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[142.503379] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[142.612153] [031/133] (874s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[142.705742] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[142.709840] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[142.826882] [032/133] (874s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[142.928611] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[142.932646] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[143.026104] [033/133] (874s left) gem_set_tiling_vs_pwrite
[143.137370] [034/133] (874s left) kms_atomic_interruptible (universal-setplane-cursor)
[143.232291] Starting subtest: universal-setplane-cursor
[143.234527] Starting dynamic subtest: pipe-A-eDP-1
[150.636053] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.402s)
[150.638409] Subtest universal-setplane-cursor: SUCCESS (7.403s)
[151.447469] [035/133] (866s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[151.549495] Starting subtest: x-tiled-16bpp-rotate-270
[151.568848] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[151.675066] [036/133] (866s left) gem_exec_create (forked)
[151.732776] Starting subtest: forked
[151.735032] Starting dynamic subtest: smem
[173.247685] Dynamic subtest smem: SUCCESS (21.518s)
[173.250531] Subtest forked: SUCCESS (21.520s)
[173.436373] [037/133] (844s left) kms_cursor_edge_walk (256x256-right-edge)
[173.547520] Starting subtest: 256x256-right-edge
[173.549764] Starting dynamic subtest: pipe-A-eDP-1
[176.986627] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.440s)
[176.998844] Starting dynamic subtest: pipe-D-eDP-1
[180.178769] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.191s)
[180.181131] Subtest 256x256-right-edge: SUCCESS (6.633s)
[181.046242] [038/133] (836s left) gem_eio (kms)
[181.338967] Starting subtest: kms
[200.687719] Subtest kms: SUCCESS (19.348s)
[201.835947] [FACT gem_eio (kms)] new: kernel.kmod_is_loaded.vgem: true
[201.839958] [039/133] (815s left) gen9_exec_parse (allowed-all)
[201.913382] Subtest allowed-all: SKIP (0.000s)
[201.987381] [040/133] (815s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[202.088166] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[202.092230] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[202.161106] [041/133] (815s left) i915_suspend (fence-restore-untiled)
[202.209344] Starting subtest: fence-restore-untiled
[202.213570] Subtest fence-restore-untiled: SKIP (0.000s)
[202.329593] [042/133] (815s left) kms_plane (pixel-format-4-tiled-modifier)
[202.417306] Starting subtest: pixel-format-4-tiled-modifier
[202.442931] Starting dynamic subtest: pipe-A-plane-0
[203.142367] Dynamic subtest pipe-A-plane-0: SUCCESS (0.700s)
[203.153830] Starting dynamic subtest: pipe-A-plane-3
[203.576527] Dynamic subtest pipe-A-plane-3: SUCCESS (0.433s)
[203.584927] Starting dynamic subtest: pipe-A-plane-5
[203.592545] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[204.699227] Starting dynamic subtest: pipe-B-plane-0
[205.380834] Dynamic subtest pipe-B-plane-0: SUCCESS (0.689s)
[205.389619] Starting dynamic subtest: pipe-B-plane-3
[205.813786] Dynamic subtest pipe-B-plane-3: SUCCESS (0.432s)
[205.822904] Starting dynamic subtest: pipe-B-plane-5
[205.826467] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[206.127890] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.710s)
[206.959723] [043/133] (811s left) kms_plane_scaling (planes-upscale-20x20)
[207.053043] Starting subtest: planes-upscale-20x20
[207.055379] Starting dynamic subtest: pipe-A
[207.113073] Dynamic subtest pipe-A: SUCCESS (0.062s)
[207.123799] Starting dynamic subtest: pipe-B
[208.235274] Dynamic subtest pipe-B: SUCCESS (1.121s)
[208.246578] Starting dynamic subtest: pipe-C
[209.312822] Dynamic subtest pipe-C: SUCCESS (1.076s)
[209.322355] Starting dynamic subtest: pipe-D
[210.414363] Dynamic subtest pipe-D: SUCCESS (1.101s)
[210.416717] Subtest planes-upscale-20x20: SUCCESS (3.364s)
[211.565082] [044/133] (806s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[211.664646] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[211.668974] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[211.760971] [045/133] (806s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[211.826617] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[211.828973] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[211.916643] [046/133] (806s left) kms_fbcon_fbt (fbc)
[211.974226] Starting subtest: fbc
[218.481813] Subtest fbc: SUCCESS (6.506s)
[219.624819] [047/133] (798s left) prime_mmap_coherency (ioctl-errors)
[219.683485] Starting subtest: ioctl-errors
[222.697706] Subtest ioctl-errors: SUCCESS (3.014s)
[222.852084] [048/133] (795s left) gem_exec_schedule (u-semaphore-noskip)
[222.956491] Starting subtest: u-semaphore-noskip
[223.407416] Subtest u-semaphore-noskip: SUCCESS (0.450s)
[223.751920] [049/133] (794s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[223.860519] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[231.023101] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.168s)
[231.136925] [050/133] (787s left) syncobj_timeline (wait-all-for-submit-complex)
[231.197299] Starting subtest: wait-all-for-submit-complex
[231.410885] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[231.488857] [051/133] (786s left) kms_chamelium_frames (dp-crc-single)
[231.876547] Subtest dp-crc-single: SKIP (0.000s)
[232.719443] [052/133] (785s left) prime_mmap (test_errors)
[232.773178] Starting subtest: test_errors
[232.775137] Starting dynamic subtest: test_errors-smem
[232.867861] Dynamic subtest test_errors-smem: SUCCESS (0.096s)
[232.870777] Subtest test_errors: SUCCESS (0.098s)
[232.959972] [053/133] (785s left) kms_psr (pr-sprite-mmap-gtt)
[233.069937] Starting subtest: pr-sprite-mmap-gtt
[233.074377] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[233.161549] [054/133] (785s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[233.222035] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[233.224440] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[233.340269] [055/133] (785s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[233.435806] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[233.438184] Starting dynamic subtest: pipe-A-eDP-1
[233.496147] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[233.506480] Starting dynamic subtest: pipe-B-eDP-1
[233.560823] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[233.572204] Starting dynamic subtest: pipe-C-eDP-1
[233.629938] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[233.639534] Starting dynamic subtest: pipe-D-eDP-1
[233.687565] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[233.691290] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.009s)
[235.639296] [056/133] (782s left) gem_pwrite_snooped
[235.779353] [057/133] (782s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[235.879500] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[235.883859] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[235.988669] [058/133] (782s left) gem_exec_reloc (basic-gtt-active)
[236.044949] Subtest basic-gtt-active: SKIP (0.000s)
[236.126230] [059/133] (782s left) kms_async_flips (crc-atomic)
[236.216965] Starting subtest: crc-atomic
[236.592851] Starting dynamic subtest: pipe-A-eDP-1
[239.531675] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.940s)
[239.921073] Starting dynamic subtest: pipe-B-eDP-1
[242.836313] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.925s)
[243.222697] Starting dynamic subtest: pipe-C-eDP-1
[246.100145] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.888s)
[246.478174] Starting dynamic subtest: pipe-D-eDP-1
[249.394223] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.925s)
[249.396578] Subtest crc-atomic: SUCCESS (13.179s)
[250.634679] [060/133] (768s left) syncobj_wait (wait-zero-handles)
[250.689963] Starting subtest: wait-zero-handles
[250.692193] Subtest wait-zero-handles: SUCCESS (0.000s)
[250.792244] [061/133] (767s left) api_intel_bb (crc32)
[250.851182] Starting subtest: crc32
[250.853368] Starting dynamic subtest: rcs0-smem0
[251.151416] Dynamic subtest rcs0-smem0: SUCCESS (0.300s)
[251.164396] Starting dynamic subtest: bcs0-smem0
[251.492686] Dynamic subtest bcs0-smem0: SUCCESS (0.338s)
[251.505172] Starting dynamic subtest: vcs0-smem0
[251.873650] Dynamic subtest vcs0-smem0: SUCCESS (0.378s)
[251.885805] Starting dynamic subtest: vcs1-smem0
[252.240184] Dynamic subtest vcs1-smem0: SUCCESS (0.363s)
[252.251815] Starting dynamic subtest: vecs0-smem0
[252.587378] Dynamic subtest vecs0-smem0: SUCCESS (0.345s)
[252.598994] Starting dynamic subtest: ccs0-smem0
[252.917348] Dynamic subtest ccs0-smem0: SUCCESS (0.327s)
[252.920042] Subtest crc32: SUCCESS (2.069s)
[253.042738] [062/133] (765s left) perf (stress-open-close)
[253.187111] Starting subtest: stress-open-close
[253.189287] Starting dynamic subtest: 0-rcs0
[255.359960] Dynamic subtest 0-rcs0: SUCCESS (2.174s)
[255.370275] Starting dynamic subtest: 1-vcs0
[257.523035] Dynamic subtest 1-vcs0: SUCCESS (2.162s)
[257.525186] Subtest stress-open-close: SUCCESS (4.338s)
[257.572102] [063/133] (761s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[257.673222] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[257.675049] Starting dynamic subtest: pipe-A-eDP-1
[257.828938] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.147s)
[257.840641] Starting dynamic subtest: pipe-B-eDP-1
[257.857524] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[257.866148] Starting dynamic subtest: pipe-C-eDP-1
[257.882073] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[257.890363] Starting dynamic subtest: pipe-D-eDP-1
[257.906293] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[257.907864] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.157s)
[260.035163] [064/133] (758s left) gem_eio (in-flight-1us)
[260.268259] Starting subtest: in-flight-1us
[269.180520] Subtest in-flight-1us: SUCCESS (8.912s)
[269.300670] [065/133] (749s left) kms_psr (fbc-psr-primary-blt)
[269.410504] Starting subtest: fbc-psr-primary-blt
[269.412828] Starting dynamic subtest: eDP-1
[269.417189] Dynamic subtest eDP-1: SKIP (0.000s)
[269.421794] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[269.483162] [066/133] (749s left) gem_mmap_wc (coherency)
[269.541860] Subtest coherency: SKIP (0.000s)
[269.606248] [067/133] (749s left) kms_cursor_crc (cursor-onscreen-max-size)
[269.949446] Starting subtest: cursor-onscreen-max-size
[269.955074] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[270.092128] [068/133] (748s left) gem_lmem_swapping (parallel-random)
[270.134706] Subtest parallel-random: SKIP (0.000s)
[270.184961] [069/133] (748s left) gen9_exec_parse (valid-registers)
[270.244715] Subtest valid-registers: SKIP (0.000s)
[270.313206] [070/133] (748s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[270.410840] Starting subtest: y-tiled-64bpp-rotate-270
[270.414639] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[270.505051] [071/133] (748s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[270.618398] Starting subtest: psr-1p-pri-indfb-multidraw
[293.441371] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (22.822s)
[293.554348] [072/133] (725s left) kms_lease (atomic-implicit-crtc)
[293.654430] Starting subtest: atomic-implicit-crtc
[293.656310] Starting dynamic subtest: pipe-A-eDP-1
[293.665719] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[293.675960] Starting dynamic subtest: pipe-B-eDP-1
[293.685469] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[293.694935] Starting dynamic subtest: pipe-C-eDP-1
[293.703954] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[293.712531] Starting dynamic subtest: pipe-D-eDP-1
[293.721331] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[293.722922] Subtest atomic-implicit-crtc: SUCCESS (0.036s)
[293.806133] [073/133] (725s left) kms_feature_discovery (display-2x)
[293.889568] Starting subtest: display-2x
[293.893247] Subtest display-2x: SKIP (0.000s)
[293.961768] [074/133] (725s left) gem_exec_fence (invalid-fence-array)
[294.391108] Starting subtest: invalid-fence-array
[294.393900] Subtest invalid-fence-array: SUCCESS (0.002s)
[296.421438] [075/133] (722s left) kms_universal_plane (universal-plane-sanity)
[296.517045] Starting subtest: universal-plane-sanity
[296.519370] Starting dynamic subtest: pipe-A-eDP-1
[297.118572] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.602s)
[297.133205] Starting dynamic subtest: pipe-B-eDP-1
[298.329606] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.207s)
[298.342090] Starting dynamic subtest: pipe-C-eDP-1
[299.508404] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.180s)
[299.518240] Starting dynamic subtest: pipe-D-eDP-1
[300.706432] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.196s)
[300.708819] Subtest universal-plane-sanity: SUCCESS (4.192s)
[301.528990] [076/133] (717s left) kms_color (ctm-negative)
[301.644166] Starting subtest: ctm-negative
[301.646071] Starting dynamic subtest: pipe-A-eDP-1
[302.368533] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.725s)
[302.378393] Starting dynamic subtest: pipe-B-eDP-1
[303.816270] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.448s)
[303.826288] Starting dynamic subtest: pipe-C-eDP-1
[305.150496] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.330s)
[305.160460] Starting dynamic subtest: pipe-D-eDP-1
[306.563768] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.411s)
[306.566166] Subtest ctm-negative: SUCCESS (4.918s)
[307.436209] [077/133] (712s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[307.537824] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[316.092126] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.558s)
[316.194973] [078/133] (703s left) kms_invalid_mode (int-max-clock)
[316.294616] Starting subtest: int-max-clock
[316.297661] Starting dynamic subtest: pipe-A-eDP-1
[316.579750] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[316.590497] Starting dynamic subtest: pipe-B-eDP-1
[316.592474] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[316.601737] Starting dynamic subtest: pipe-C-eDP-1
[316.603868] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[316.616840] Starting dynamic subtest: pipe-D-eDP-1
[316.619890] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[316.622719] Subtest int-max-clock: SUCCESS (0.294s)
[317.431611] [079/133] (702s left) gem_userptr_blits (create-destroy-sync)
[317.499234] Starting subtest: create-destroy-sync
[322.523617] Subtest create-destroy-sync: SUCCESS (5.023s)
[322.652523] [080/133] (696s left) gem_ccs (suspend-resume)
[322.707459] Starting subtest: suspend-resume
[322.712148] Subtest suspend-resume: SKIP (0.000s)
[322.808819] [081/133] (696s left) kms_big_fb (linear-16bpp-rotate-180)
[322.904595] Starting subtest: linear-16bpp-rotate-180
[324.251191] Subtest linear-16bpp-rotate-180: SUCCESS (1.346s)
[324.366485] [082/133] (695s left) gem_exec_store (basic)
[324.434711] Starting subtest: basic
[324.529609] Subtest basic: SUCCESS (0.094s)
[324.714399] [083/133] (694s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[324.814318] Starting subtest: stress-xrgb8888-ytiled
[324.818893] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[324.895996] [084/133] (694s left) syncobj_timeline (etime-multi-wait-all-submitted)
[324.953604] Starting subtest: etime-multi-wait-all-submitted
[325.057611] Subtest etime-multi-wait-all-submitted: SUCCESS (0.104s)
[325.145361] [085/133] (694s left) kms_flip (2x-flip-vs-dpms)
[325.241690] Starting subtest: 2x-flip-vs-dpms
[325.251264] Subtest 2x-flip-vs-dpms: SKIP (0.011s)
[325.330034] [086/133] (694s left) gem_exec_reloc (basic-gtt-read)
[325.392168] Subtest basic-gtt-read: SKIP (0.000s)
[325.464458] [087/133] (694s left) gem_exec_create (madvise)
[325.530466] Starting subtest: madvise
[325.532812] Starting dynamic subtest: smem
[347.323800] Dynamic subtest smem: SUCCESS (21.790s)
[347.326671] Subtest madvise: SUCCESS (21.791s)
[348.119237] [088/133] (671s left) gem_eio (in-flight-contexts-1us)
[348.373327] Starting subtest: in-flight-contexts-1us
[362.327692] Subtest in-flight-contexts-1us: SUCCESS (13.951s)
[362.488769] [089/133] (657s left) kms_flip (flip-vs-expired-vblank)
[362.578291] Starting subtest: flip-vs-expired-vblank
[362.580558] Starting dynamic subtest: A-eDP1
[371.300264] Dynamic subtest A-eDP1: SUCCESS (8.721s)
[371.311102] Starting dynamic subtest: B-eDP1
[380.007579] Dynamic subtest B-eDP1: SUCCESS (8.706s)
[380.019736] Starting dynamic subtest: C-eDP1
[388.698513] Dynamic subtest C-eDP1: SUCCESS (8.688s)
[388.707882] Starting dynamic subtest: D-eDP1
[397.387759] Dynamic subtest D-eDP1: SUCCESS (8.688s)
[397.392741] Subtest flip-vs-expired-vblank: SUCCESS (34.813s)
[398.543461] [090/133] (621s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[398.651835] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[398.654109] Starting dynamic subtest: pipe-A
[398.676342] Dynamic subtest pipe-A: SKIP (0.021s)
[398.686060] Starting dynamic subtest: pipe-B
[398.709523] Dynamic subtest pipe-B: SKIP (0.030s)
[398.719628] Starting dynamic subtest: pipe-C
[398.737605] Dynamic subtest pipe-C: SKIP (0.030s)
[398.746965] Starting dynamic subtest: pipe-D
[398.770193] Dynamic subtest pipe-D: SKIP (0.032s)
[398.773827] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.115s)
[398.884836] [091/133] (621s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[398.980146] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[398.982328] Starting dynamic subtest: pipe-A-default-mode
[401.741075] Dynamic subtest pipe-A-default-mode: SUCCESS (2.760s)
[401.743390] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.761s)
[402.536484] [092/133] (617s left) prime_vgem (basic-read)
[402.618564] Starting subtest: basic-read
[402.642455] Subtest basic-read: SKIP (0.023s)
[402.763519] [093/133] (617s left) kms_plane_multiple (tiling-x)
[402.849254] Starting subtest: tiling-x
[402.851115] Starting dynamic subtest: pipe-A-eDP-1
[406.765591] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.915s)
[406.779396] Starting dynamic subtest: pipe-B-eDP-1
[411.368173] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.601s)
[411.377894] Starting dynamic subtest: pipe-C-eDP-1
[415.939654] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.567s)
[415.952378] Starting dynamic subtest: pipe-D-eDP-1
[420.461168] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.523s)
[420.463401] Subtest tiling-x: SUCCESS (17.613s)
[421.320461] [094/133] (598s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[421.419680] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[421.423803] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[421.512588] [095/133] (598s left) gem_exec_schedule (noreorder-corked)
[421.703980] Starting subtest: noreorder-corked
[421.705975] Starting dynamic subtest: rcs0
[422.845933] Dynamic subtest rcs0: SUCCESS (1.145s)
[422.858062] Starting dynamic subtest: vcs0
[424.316521] Dynamic subtest vcs0: SUCCESS (1.467s)
[424.328416] Starting dynamic subtest: vcs1
[426.300324] Dynamic subtest vcs1: SUCCESS (1.981s)
[426.312572] Starting dynamic subtest: vecs0
[428.279180] Dynamic subtest vecs0: SUCCESS (1.977s)
[428.291284] Starting dynamic subtest: ccs0
[429.426186] Dynamic subtest ccs0: SUCCESS (1.146s)
[429.428955] Subtest noreorder-corked: SUCCESS (7.727s)
[429.616945] [096/133] (590s left) gem_exec_balancer (bonded-semaphore)
[429.673976] Starting subtest: bonded-semaphore
[429.678426] Subtest bonded-semaphore: SKIP (0.000s)
[429.987742] [097/133] (590s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[430.098795] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[430.103192] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[430.202551] [098/133] (590s left) gem_mmap_offset (blt-coherency)
[430.264377] Starting subtest: blt-coherency
[430.271636] Subtest blt-coherency: SUCCESS (0.010s)
[430.392649] [099/133] (589s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[430.485076] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[431.297927] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.814s)
[431.483567] [100/133] (588s left) gem_busy (semaphore)
[431.677124] Subtest semaphore: SKIP (0.000s)
[431.915454] [101/133] (588s left) gem_ctx_persistence (legacy-engines-hostile)
[431.975436] Starting subtest: legacy-engines-hostile
[431.977934] Starting dynamic subtest: render
[432.045944] Dynamic subtest render: SUCCESS (0.069s)
[432.060955] Starting dynamic subtest: bsd1
[432.131840] Dynamic subtest bsd1: SUCCESS (0.083s)
[432.143932] Starting dynamic subtest: bsd2
[432.202041] Dynamic subtest bsd2: SUCCESS (0.067s)
[432.212790] Starting dynamic subtest: blt
[432.334087] Dynamic subtest blt: SUCCESS (0.129s)
[432.346245] Starting dynamic subtest: vebox
[432.433915] Dynamic subtest vebox: SUCCESS (0.097s)
[432.436619] Subtest legacy-engines-hostile: SUCCESS (0.459s)
[432.527854] [102/133] (587s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[432.635311] Starting subtest: multiplane-rotation-cropping-bottom
[450.049066] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.416s)
[450.154785] [103/133] (570s left) syncobj_eventfd (invalid-illegal-eventfd)
[450.216041] Starting subtest: invalid-illegal-eventfd
[450.218064] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[450.316736] [104/133] (570s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[450.380763] Starting subtest: yf-tiled-to-vebox-x-tiled
[450.384992] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[450.566949] [105/133] (570s left) kms_psr (fbc-pr-primary-mmap-cpu)
[450.668468] Starting subtest: fbc-pr-primary-mmap-cpu
[450.672750] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[450.744562] [106/133] (569s left) gem_userptr_blits (userfault)
[450.812215] Starting subtest: userfault
[450.814437] Subtest userfault: SUCCESS (0.006s)
[450.946135] [107/133] (569s left) i915_pm_rps (basic-api)
[451.007144] Starting subtest: basic-api
[451.011383] Subtest basic-api: SKIP (0.001s)
[451.114642] [108/133] (569s left) gem_ctx_exec (basic)
[451.175381] Starting subtest: basic
[451.181264] Subtest basic: SUCCESS (0.004s)
[451.325060] [109/133] (569s left) kms_pm_rpm (basic-pci-d3-state)
[453.467526] Starting subtest: basic-pci-d3-state
[454.922075] Subtest basic-pci-d3-state: SUCCESS (1.458s)
[455.013211] [110/133] (565s left) syncobj_wait (wait-delayed-signal)
[455.072870] Starting subtest: wait-delayed-signal
[455.174142] Subtest wait-delayed-signal: SUCCESS (0.103s)
[455.259542] [111/133] (565s left) gem_exec_fence (expired-history)
[455.734149] Starting subtest: expired-history
[462.908738] Subtest expired-history: SUCCESS (7.175s)
[463.674713] [112/133] (557s left) gem_exec_reloc (basic-range-active)
[463.744322] Subtest basic-range-active: SKIP (0.000s)
[463.812127] [113/133] (557s left) perf_pmu (busy-accuracy-50)
[463.857932] Starting subtest: busy-accuracy-50
[463.860439] Starting dynamic subtest: rcs0
[465.392855] Dynamic subtest rcs0: SUCCESS (1.534s)
[465.405147] Starting dynamic subtest: bcs0
[466.934414] Dynamic subtest bcs0: SUCCESS (1.539s)
[466.945309] Starting dynamic subtest: vcs0
[468.479854] Dynamic subtest vcs0: SUCCESS (1.542s)
[468.491053] Starting dynamic subtest: vcs1
[470.021942] Dynamic subtest vcs1: SUCCESS (1.540s)
[470.032774] Starting dynamic subtest: vecs0
[471.563362] Dynamic subtest vecs0: SUCCESS (1.538s)
[471.574108] Starting dynamic subtest: ccs0
[473.109781] Dynamic subtest ccs0: SUCCESS (1.544s)
[473.111750] Subtest busy-accuracy-50: SUCCESS (9.252s)
[473.221511] [114/133] (547s left) api_intel_bb (object-noreloc-purge-cache-simple)
[473.277915] Starting subtest: object-noreloc-purge-cache-simple
[473.282267] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.007s)
[473.392819] [115/133] (547s left) gem_pxp (protected-raw-src-copy-not-readible)
[473.518089] Starting subtest: protected-raw-src-copy-not-readible
[473.588934] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.074s)
[473.716292] [116/133] (547s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[473.820582] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[473.824745] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[473.918637] [117/133] (547s left) kms_psr (psr2-cursor-mmap-cpu)
[474.019572] Starting subtest: psr2-cursor-mmap-cpu
[474.021749] Starting dynamic subtest: eDP-1
[475.775741] Dynamic subtest eDP-1: SUCCESS (1.757s)
[475.778077] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.758s)
[476.627241] [118/133] (544s left) syncobj_wait (invalid-reset-one-illegal-handle)
[476.679502] Starting subtest: invalid-reset-one-illegal-handle
[476.681695] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[476.765762] [119/133] (544s left) gem_ctx_exec (basic-nohangcheck)
[476.826457] Starting subtest: basic-nohangcheck
[477.060620] Subtest basic-nohangcheck: SUCCESS (0.235s)
[477.199920] [120/133] (544s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[477.301648] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[480.836492] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.538s)
[482.032987] [121/133] (539s left) kms_flip (absolute-wf_vblank-interruptible)
[482.129669] Starting subtest: absolute-wf_vblank-interruptible
[482.131953] Starting dynamic subtest: A-eDP1
[490.846996] Dynamic subtest A-eDP1: SUCCESS (8.715s)
[490.858638] Starting dynamic subtest: B-eDP1
[499.548894] Dynamic subtest B-eDP1: SUCCESS (8.700s)
[499.560333] Starting dynamic subtest: C-eDP1
[508.240078] Dynamic subtest C-eDP1: SUCCESS (8.689s)
[508.250343] Starting dynamic subtest: D-eDP1
[516.935052] Dynamic subtest D-eDP1: SUCCESS (8.694s)
[516.940264] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.808s)
[518.116522] [122/133] (503s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[518.180553] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[518.246149] [123/133] (503s left) gem_exec_gttfill (multigpu-basic)
[518.426302] Starting subtest: multigpu-basic
[532.396425] Subtest multigpu-basic: SUCCESS (13.972s)
[532.493688] [124/133] (488s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[532.643347] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[532.647393] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[532.727132] [125/133] (488s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[532.794583] Subtest tiled-to-untiled: SKIP (0.000s)
[532.863954] [126/133] (488s left) kms_content_protection (atomic-hdcp14)
[533.026586] Starting subtest: atomic-hdcp14
[533.031085] Subtest atomic-hdcp14: SKIP (0.000s)
[533.160416] [127/133] (488s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[533.268686] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[533.272940] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[533.390468] [128/133] (488s left) i915_pm_freq_api (freq-reset-multiple)
[533.452213] Starting subtest: freq-reset-multiple
[533.454264] Starting dynamic subtest: gt0
[543.117066] Dynamic subtest gt0: SUCCESS (9.662s)
[543.126859] Starting dynamic subtest: gt1
[551.582911] Dynamic subtest gt1: SUCCESS (8.461s)
[551.585557] Subtest freq-reset-multiple: SUCCESS (18.125s)
[551.658119] [129/133] (470s left) perf (invalid-remove-userspace-config)
[551.785678] Starting subtest: invalid-remove-userspace-config
[551.794613] Subtest invalid-remove-userspace-config: SUCCESS (0.007s)
[551.841249] [130/133] (469s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[551.950842] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[551.955127] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[552.052048] [131/133] (469s left) kms_pm_rpm (package-g7)
[553.593637] Starting subtest: package-g7
[553.598607] Subtest package-g7: SKIP (0.000s)
[554.332692] [132/133] (467s left) gem_mmap_gtt (basic-small-bo-tiledy)
[554.392756] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[554.453770] [133/133] (467s left) perf_pmu (module-unload)