[58.052139] Initializing watchdogs
[58.052274]   /dev/watchdog0
[58.071514] [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.076191] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.078758] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.082139] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[58.209819] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[58.214361] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[58.309168] [002/133] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[58.409340] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[58.413749] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[58.517100] [003/133] (960s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[58.564834] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[58.674777] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.108s)
[58.746711] [004/133] (959s left) gem_flink_basic (double-flink)
[58.806896] Starting subtest: double-flink
[58.808880] Subtest double-flink: SUCCESS (0.000s)
[58.897402] [005/133] (959s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[59.000592] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[66.585233] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.590s)
[66.717044] [006/133] (952s left) vgem_slow (nohang)
[66.794705] Starting subtest: nohang
[76.914421] Subtest nohang: SUCCESS (10.120s)
[76.990436] [FACT vgem_slow (nohang)] new: kernel.kmod_is_loaded.vgem: true
[76.993664] [007/133] (941s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[77.119716] Starting subtest: cursorA-vs-flipB-atomic-transitions
[77.124102] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[77.262540] [008/133] (941s left) gem_exec_fence (syncobj-timeline-export)
[77.799526] Starting subtest: syncobj-timeline-export
[77.803564] Subtest syncobj-timeline-export: SUCCESS (0.007s)
[79.024656] [009/133] (939s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[79.141399] Starting subtest: short-flip-after-cursor-toggle
[80.104438] Subtest short-flip-after-cursor-toggle: SUCCESS (0.961s)
[80.996872] [010/133] (937s left) kms_cursor_edge_walk (128x128-right-edge)
[81.104132] Starting subtest: 128x128-right-edge
[81.106521] Starting dynamic subtest: pipe-A-eDP-1
[84.555524] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.452s)
[84.565047] Starting dynamic subtest: pipe-D-eDP-1
[87.684761] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.128s)
[87.687339] Subtest 128x128-right-edge: SUCCESS (6.581s)
[88.489655] [011/133] (930s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[88.603389] Starting subtest: psr-rgb565-draw-mmap-wc
[95.369859] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.770s)
[95.485643] [012/133] (923s left) perf (i915-ref-count)
[95.553479] Starting subtest: i915-ref-count
[95.624664] Subtest i915-ref-count: SUCCESS (0.070s)
[95.680810] [013/133] (923s left) kms_flip (2x-flip-vs-dpms-on-nop)
[95.777774] Starting subtest: 2x-flip-vs-dpms-on-nop
[95.787185] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s)
[95.862955] [014/133] (923s left) api_intel_allocator (reloc-allocator)
[95.917721] Starting subtest: reloc-allocator
[95.920092] Starting dynamic subtest: basic
[95.922306] Dynamic subtest basic: SUCCESS (0.003s)
[95.932685] Starting dynamic subtest: parallel-one
[95.934584] Dynamic subtest parallel-one: SUCCESS (0.009s)
[95.942351] Starting dynamic subtest: print
[95.944565] Dynamic subtest print: SUCCESS (0.000s)
[95.952070] Starting dynamic subtest: reuse
[95.954286] Dynamic subtest reuse: SUCCESS (0.000s)
[95.962065] Starting dynamic subtest: fork-reopen-allocator
[95.964190] Dynamic subtest fork-reopen-allocator: SUCCESS (0.011s)
[95.966409] Subtest reloc-allocator: SUCCESS (0.025s)
[96.075047] [015/133] (923s left) gem_exec_schedule (pi-distinct-iova)
[96.256305] Starting subtest: pi-distinct-iova
[96.258310] Starting dynamic subtest: rcs0
[96.338648] Dynamic subtest rcs0: SUCCESS (0.084s)
[96.349823] Starting dynamic subtest: vcs0
[96.402057] Dynamic subtest vcs0: SUCCESS (0.063s)
[96.410207] Starting dynamic subtest: vcs1
[96.458641] Dynamic subtest vcs1: SUCCESS (0.056s)
[96.466772] Starting dynamic subtest: vecs0
[96.513406] Dynamic subtest vecs0: SUCCESS (0.054s)
[96.528753] Starting dynamic subtest: ccs0
[96.574859] Dynamic subtest ccs0: SUCCESS (0.061s)
[96.577261] Subtest pi-distinct-iova: SUCCESS (0.321s)
[97.963643] [016/133] (921s left) kms_prime (d3hot)
[98.050325] Subtest D3hot: SKIP (0.000s)
[98.171797] [017/133] (921s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[98.283702] Starting subtest: basic-flip-after-cursor-legacy
[99.203215] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.919s)
[100.046739] [018/133] (919s left) kms_pm_dc (dc9-dpms)
[101.137751] Starting subtest: dc9-dpms
[102.564855] Subtest dc9-dpms: SUCCESS (1.428s)
[102.645187] [019/133] (916s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[102.756324] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[102.760364] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[102.871057] [020/133] (916s left) gem_exec_reloc (basic-cpu-wc-active)
[102.942703] Subtest basic-cpu-wc-active: SKIP (0.000s)
[103.007992] [021/133] (916s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[103.064828] Starting subtest: etime-multi-wait-available-unsubmitted
[103.169365] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.103s)
[103.258359] [022/133] (916s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[103.349848] Starting subtest: fbc-psr-sprite-mmap-gtt
[103.352074] Starting dynamic subtest: eDP-1
[103.356177] Dynamic subtest eDP-1: SKIP (0.000s)
[103.360201] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[103.421045] [023/133] (916s left) kms_plane_cursor (overlay)
[103.510656] Starting subtest: overlay
[103.516586] Starting dynamic subtest: pipe-A-eDP-1-size-64
[106.094169] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.586s)
[106.152709] Starting dynamic subtest: pipe-A-eDP-1-size-128
[108.661859] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.516s)
[108.720342] Starting dynamic subtest: pipe-A-eDP-1-size-256
[111.275980] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.561s)
[111.630899] Starting dynamic subtest: pipe-B-eDP-1-size-64
[114.878362] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.258s)
[114.936952] Starting dynamic subtest: pipe-B-eDP-1-size-128
[117.489562] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.561s)
[117.549341] Starting dynamic subtest: pipe-B-eDP-1-size-256
[120.079970] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.538s)
[120.427674] Starting dynamic subtest: pipe-C-eDP-1-size-64
[123.307686] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.890s)
[123.344586] Starting dynamic subtest: pipe-C-eDP-1-size-128
[125.508094] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.170s)
[125.544949] Starting dynamic subtest: pipe-C-eDP-1-size-256
[127.730414] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.192s)
[128.068702] Starting dynamic subtest: pipe-D-eDP-1-size-64
[130.929233] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.869s)
[130.966178] Starting dynamic subtest: pipe-D-eDP-1-size-128
[133.085574] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.125s)
[133.121753] Starting dynamic subtest: pipe-D-eDP-1-size-256
[135.240289] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.125s)
[135.559990] Subtest overlay: SUCCESS (32.053s)
[136.443411] [024/133] (883s left) gem_exec_schedule (fifo)
[136.526892] Starting subtest: fifo
[136.528854] Starting dynamic subtest: rcs0
[136.620063] Dynamic subtest rcs0: SUCCESS (0.102s)
[136.629627] Starting dynamic subtest: vcs0
[136.703492] Dynamic subtest vcs0: SUCCESS (0.082s)
[136.714583] Starting dynamic subtest: vcs1
[136.778061] Dynamic subtest vcs1: SUCCESS (0.075s)
[136.789621] Starting dynamic subtest: vecs0
[136.854160] Dynamic subtest vecs0: SUCCESS (0.075s)
[136.865344] Starting dynamic subtest: ccs0
[136.934430] Dynamic subtest ccs0: SUCCESS (0.079s)
[136.937316] Subtest fifo: SUCCESS (0.417s)
[137.974187] [025/133] (881s left) kms_cursor_crc (cursor-onscreen-64x21)
[138.178128] Starting subtest: cursor-onscreen-64x21
[138.235714] Subtest cursor-onscreen-64x21: SKIP (0.051s)
[138.504269] [026/133] (881s left) kms_psr (psr-sprite-plane-move)
[138.607188] Starting subtest: psr-sprite-plane-move
[138.609395] Starting dynamic subtest: eDP-1
[140.382473] Dynamic subtest eDP-1: SUCCESS (1.775s)
[140.384708] Subtest psr-sprite-plane-move: SUCCESS (1.776s)
[141.199939] [027/133] (878s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[141.301812] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[141.305821] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[141.373544] [028/133] (878s left) gem_create (hog-create)
[141.443802] Starting subtest: hog-create
[141.446152] Starting dynamic subtest: smem0
[174.942286] Dynamic subtest smem0: SUCCESS (33.494s)
[174.944886] Subtest hog-create: SUCCESS (33.496s)
[175.130000] [029/133] (844s left) gem_eio (wait-10ms)
[175.392958] Starting subtest: wait-10ms
[175.780687] Subtest wait-10ms: SUCCESS (0.387s)
[175.943201] [030/133] (843s left) kms_plane_alpha_blend (constant-alpha-max)
[176.039870] Starting subtest: constant-alpha-max
[176.341335] Starting dynamic subtest: pipe-A-eDP-1
[177.477352] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.133s)
[177.485802] Starting dynamic subtest: pipe-D-eDP-1
[179.189583] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.711s)
[179.191498] Subtest constant-alpha-max: SUCCESS (3.150s)
[180.068158] [031/133] (839s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[180.179469] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[180.183526] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[180.281989] [032/133] (839s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[180.379155] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[187.678511] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.301s)
[187.806663] [033/133] (832s left) i915_pm_rps (thresholds)
[187.863909] Starting subtest: thresholds
[187.868542] Subtest thresholds: SKIP (0.001s)
[187.965541] [034/133] (831s left) kms_flip (2x-flip-vs-panning-interruptible)
[188.060091] Starting subtest: 2x-flip-vs-panning-interruptible
[188.072493] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[188.174817] [035/133] (831s left) gem_readwrite (read-bad-handle)
[188.227339] Subtest read-bad-handle: SKIP (0.000s)
[188.285068] [036/133] (831s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[188.372336] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[188.374644] Starting dynamic subtest: pipe-A-eDP-1
[188.394885] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[188.404463] Starting dynamic subtest: pipe-B-eDP-1
[188.424918] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[188.433191] Starting dynamic subtest: pipe-C-eDP-1
[188.452965] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[188.461131] Starting dynamic subtest: pipe-D-eDP-1
[188.480902] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[188.483154] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[190.680333] [037/133] (829s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[190.778848] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[191.436266] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.659s)
[191.597525] [038/133] (828s left) kms_sequence (get-forked-busy)
[191.701232] Starting subtest: get-forked-busy
[191.703480] Starting dynamic subtest: pipe-A-eDP-1
[193.636667] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.935s)
[193.646663] Starting dynamic subtest: pipe-B-eDP-1
[196.271276] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.633s)
[196.280292] Starting dynamic subtest: pipe-C-eDP-1
[198.874832] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.601s)
[198.884094] Starting dynamic subtest: pipe-D-eDP-1
[201.428680] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.553s)
[201.430993] Subtest get-forked-busy: SUCCESS (9.728s)
[202.316693] [039/133] (817s left) gem_exec_params (dr4-dirt)
[202.373777] Starting subtest: DR4-dirt
[202.376193] Subtest DR4-dirt: SUCCESS (0.000s)
[202.478567] [040/133] (817s left) prime_mmap_coherency (write)
[202.531721] Starting subtest: write
[207.907093] Subtest write: SUCCESS (5.373s)
[208.060536] [041/133] (812s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[208.163759] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[215.523258] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.362s)
[215.669270] [042/133] (804s left) kms_psr (psr-cursor-blt)
[215.765460] Starting subtest: psr-cursor-blt
[215.767768] Starting dynamic subtest: eDP-1
[217.454091] Dynamic subtest eDP-1: SUCCESS (1.689s)
[217.456316] Subtest psr-cursor-blt: SUCCESS (1.690s)
[218.326318] [043/133] (801s left) gem_exec_balancer (individual)
[218.387249] Starting subtest: individual
[219.899741] Subtest individual: SUCCESS (1.510s)
[220.213514] [044/133] (800s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[220.319067] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[220.323615] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[221.456093] [045/133] (798s left) gem_exec_reloc (basic-gtt-read-noreloc)
[221.520785] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[221.594856] [046/133] (798s left) kms_joiner (invalid-modeset-force-big-joiner)
[221.702575] Starting subtest: invalid-modeset-force-big-joiner
[221.706938] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[221.786217] [047/133] (798s left) kms_frontbuffer_tracking (fbc-tiling-y)
[221.888730] Starting subtest: fbc-tiling-y
[221.892866] Subtest fbc-tiling-y: SKIP (0.000s)
[221.987251] [048/133] (798s left) prime_busy (after)
[222.050251] Starting subtest: after
[222.055504] Starting dynamic subtest: rcs0
[222.087421] Dynamic subtest rcs0: SUCCESS (0.033s)
[222.097857] Starting dynamic subtest: bcs0
[222.136170] Dynamic subtest bcs0: SUCCESS (0.048s)
[222.145103] Starting dynamic subtest: vcs0
[222.176342] Dynamic subtest vcs0: SUCCESS (0.039s)
[222.189269] Starting dynamic subtest: vcs1
[222.218517] Dynamic subtest vcs1: SUCCESS (0.040s)
[222.228064] Starting dynamic subtest: vecs0
[222.260042] Dynamic subtest vecs0: SUCCESS (0.040s)
[222.269357] Starting dynamic subtest: ccs0
[222.301770] Dynamic subtest ccs0: SUCCESS (0.041s)
[222.409799] Subtest after: SUCCESS (0.358s)
[222.487254] [049/133] (798s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[222.586186] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[222.588078] Starting dynamic subtest: pipe-A-eDP-1
[223.333324] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.740s)
[223.343028] Starting dynamic subtest: pipe-B-eDP-1
[225.192927] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.858s)
[225.203083] Starting dynamic subtest: pipe-C-eDP-1
[227.029333] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.834s)
[227.039597] Starting dynamic subtest: pipe-D-eDP-1
[228.862343] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.814s)
[228.864512] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.254s)
[229.988323] [050/133] (790s left) kms_cursor_legacy (forked-bo)
[230.108341] Starting subtest: forked-bo
[230.110671] Starting dynamic subtest: pipe-A
[235.599631] Dynamic subtest pipe-A: SUCCESS (5.488s)
[235.612275] Starting dynamic subtest: pipe-B
[241.072333] Dynamic subtest pipe-B: SUCCESS (5.470s)
[241.089168] Starting dynamic subtest: pipe-C
[246.538882] Dynamic subtest pipe-C: SUCCESS (5.464s)
[246.557266] Starting dynamic subtest: pipe-D
[252.005704] Dynamic subtest pipe-D: SUCCESS (5.464s)
[252.017180] Starting dynamic subtest: all-pipes
[257.502055] Dynamic subtest all-pipes: SUCCESS (5.493s)
[257.504487] Subtest forked-bo: SUCCESS (27.391s)
[257.651414] [051/133] (762s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[257.751833] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[257.756247] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[257.859734] [052/133] (762s left) gem_wait (busy)
[257.940489] Starting subtest: busy
[257.942821] Starting dynamic subtest: all-engines
[259.925126] Dynamic subtest all-engines: SUCCESS (1.983s)
[259.937073] Starting dynamic subtest: rcs0
[260.470689] Dynamic subtest rcs0: SUCCESS (0.543s)
[260.481454] Starting dynamic subtest: bcs0
[261.011218] Dynamic subtest bcs0: SUCCESS (0.540s)
[261.020493] Starting dynamic subtest: vcs0
[262.867924] Dynamic subtest vcs0: SUCCESS (1.853s)
[262.879501] Starting dynamic subtest: vcs1
[264.918204] Dynamic subtest vcs1: SUCCESS (2.047s)
[264.929954] Starting dynamic subtest: vecs0
[266.900032] Dynamic subtest vecs0: SUCCESS (1.979s)
[266.911745] Starting dynamic subtest: ccs0
[267.442387] Dynamic subtest ccs0: SUCCESS (0.541s)
[267.445082] Subtest busy: SUCCESS (9.502s)
[267.655986] [053/133] (753s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[267.769956] Starting subtest: sprite-rotation-90-pos-100-0
[267.774463] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[267.848477] [054/133] (752s left) gem_ctx_persistence (many-contexts)
[267.920783] Starting subtest: many-contexts
[313.130029] Subtest many-contexts: SUCCESS (45.206s)
[313.211836] [055/133] (707s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[313.316291] Starting subtest: psr2-cursor-plane-move-continuous-sf
[313.318513] Starting dynamic subtest: pipe-A-eDP-1
[323.667471] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.353s)
[323.679969] Starting dynamic subtest: pipe-B-eDP-1
[334.754265] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.085s)
[334.756614] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.441s)
[335.549886] [056/133] (685s left) gem_ctx_shared (detached-shared-gtt)
[335.628578] Starting subtest: detached-shared-gtt
[337.780600] Subtest detached-shared-gtt: SUCCESS (2.150s)
[338.126026] [057/133] (682s left) gem_mmap_gtt (basic-read-write-distinct)
[338.185355] Subtest basic-read-write-distinct: SKIP (0.000s)
[338.243254] [058/133] (682s left) kms_plane (pixel-format-y-tiled-modifier)
[338.340359] Starting subtest: pixel-format-y-tiled-modifier
[338.344634] Subtest pixel-format-y-tiled-modifier: SKIP (0.000s)
[338.415657] [059/133] (682s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[338.466535] Starting subtest: y-tiled-ccs-to-yf-tiled
[338.471660] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[338.646963] [060/133] (682s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[338.735786] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[338.740395] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[338.817519] [061/133] (682s left) gem_exec_whisper (basic-contexts-all)
[338.876560] Starting subtest: basic-contexts-all
[349.762754] Subtest basic-contexts-all: SUCCESS (10.883s)
[349.947791] [062/133] (671s left) kms_chamelium_frames (hdmi-aspect-ratio)
[350.342372] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[351.174388] [063/133] (669s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[351.265720] Starting subtest: psr2-overlay-plane-update-continuous-sf
[351.267844] Starting dynamic subtest: pipe-A-eDP-1
[352.387776] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.124s)
[352.397084] Starting dynamic subtest: pipe-B-eDP-1
[354.119095] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.730s)
[354.121433] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (2.857s)
[354.932251] [064/133] (666s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[355.026128] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[355.028279] Starting dynamic subtest: pipe-A-eDP-1
[355.050028] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[355.060169] Starting dynamic subtest: pipe-B-eDP-1
[355.080198] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[355.088287] Starting dynamic subtest: pipe-C-eDP-1
[355.109196] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[355.117567] Starting dynamic subtest: pipe-D-eDP-1
[355.139853] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[355.144669] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[357.308764] [065/133] (663s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[357.411592] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[357.415934] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[357.519642] [066/133] (663s left) kms_async_flips (alternate-sync-async-flip)
[357.631404] Starting subtest: alternate-sync-async-flip
[358.001765] Starting dynamic subtest: pipe-A-eDP-1
[360.788098] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.787s)
[361.179860] Starting dynamic subtest: pipe-B-eDP-1
[363.926545] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.756s)
[364.297785] Starting dynamic subtest: pipe-C-eDP-1
[367.064964] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.776s)
[367.435040] Starting dynamic subtest: pipe-D-eDP-1
[370.191158] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.766s)
[370.193253] Subtest alternate-sync-async-flip: SUCCESS (12.563s)
[371.370136] [067/133] (649s left) kms_color (ctm-0-50)
[371.465466] Starting subtest: ctm-0-50
[371.467352] Starting dynamic subtest: pipe-A-eDP-1
[374.967263] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.501s)
[374.976609] Starting dynamic subtest: pipe-B-eDP-1
[379.093046] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.125s)
[379.102524] Starting dynamic subtest: pipe-C-eDP-1
[383.060563] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.968s)
[383.069684] Starting dynamic subtest: pipe-D-eDP-1
[387.056793] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.995s)
[387.059175] Subtest ctm-0-50: SUCCESS (15.593s)
[387.881507] [068/133] (633s left) gem_pxp (display-protected-crc)
[388.013825] Starting subtest: display-protected-crc
[389.655664] Subtest display-protected-crc: SUCCESS (1.645s)
[389.764236] [069/133] (631s left) kms_vblank (ts-continuation-suspend)
[389.857102] Starting subtest: ts-continuation-suspend
[389.859216] Starting dynamic subtest: pipe-A-eDP-1
[406.131464] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.665s)
[406.147778] Starting dynamic subtest: pipe-D-eDP-1
[423.148159] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.208s)
[423.151166] Subtest ts-continuation-suspend: SUCCESS (3.877s)
[423.950189] [070/133] (597s left) api_intel_bb (delta-check)
[424.010310] Starting subtest: delta-check
[424.015006] Subtest delta-check: SUCCESS (0.008s)
[424.128630] [071/133] (597s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[424.226119] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[424.230995] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[424.327659] [072/133] (597s left) gem_ctx_param (invalid-get-no-zeromap)
[424.374755] Starting subtest: invalid-get-no-zeromap
[424.377335] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[424.467767] [073/133] (597s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[424.573532] Starting subtest: y-tiled-16bpp-rotate-0
[424.578583] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[424.671282] [074/133] (596s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[424.779767] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[428.931203] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.150s)
[430.070922] [075/133] (591s left) gem_exec_balancer (parallel-contexts)
[430.342082] Starting subtest: parallel-contexts
[433.036542] Subtest parallel-contexts: SUCCESS (2.692s)
[433.130960] [076/133] (588s left) gem_exercise_blt (fast-copy-emit)
[433.192964] Starting subtest: fast-copy-emit
[433.195469] Starting dynamic subtest: linear-smem-smem-emit
[433.225141] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.032s)
[433.237311] Starting dynamic subtest: xmajor-smem-smem-emit
[433.246026] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.020s)
[433.255956] Starting dynamic subtest: tile4-smem-smem-emit
[433.263987] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.017s)
[433.273840] Starting dynamic subtest: tile64-smem-smem-emit
[433.281221] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.016s)
[433.284044] Subtest fast-copy-emit: SUCCESS (0.088s)
[433.394080] [077/133] (588s left) kms_busy (extended-pageflip-hang-newfb)
[433.492031] Starting subtest: extended-pageflip-hang-newfb
[433.494623] Starting dynamic subtest: pipe-A
[460.129333] Dynamic subtest pipe-A: SUCCESS (26.624s)
[460.140135] Starting dynamic subtest: pipe-D
[485.082873] Dynamic subtest pipe-D: SUCCESS (24.954s)
[485.085501] Subtest extended-pageflip-hang-newfb: SUCCESS (51.584s)
[485.942673] [078/133] (535s left) kms_properties (crtc-properties-atomic)
[486.037109] Starting subtest: crtc-properties-atomic
[486.040073] Starting dynamic subtest: pipe-A-eDP-1
[486.477349] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.441s)
[486.489039] Starting dynamic subtest: pipe-B-eDP-1
[487.621104] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.142s)
[487.634931] Starting dynamic subtest: pipe-C-eDP-1
[488.745279] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.120s)
[488.757040] Starting dynamic subtest: pipe-D-eDP-1
[489.883122] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.136s)
[489.886101] Subtest crtc-properties-atomic: SUCCESS (3.847s)
[490.691285] [079/133] (531s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[490.801081] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[500.306563] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.508s)
[500.421916] [080/133] (521s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[500.518202] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[500.523328] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[500.613992] [081/133] (521s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[500.748925] Starting subtest: dp-mst-type-0-suspend-resume
[500.754251] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[500.880287] [082/133] (521s left) gem_userptr_blits (invalid-null-pointer)
[500.959274] Starting subtest: invalid-null-pointer
[500.961491] Subtest invalid-null-pointer: SUCCESS (0.002s)
[501.103329] [083/133] (520s left) sw_sync (timeline_closed)
[501.147088] Starting subtest: timeline_closed
[501.149638] Subtest timeline_closed: SUCCESS (0.000s)
[501.200051] [084/133] (520s left) gem_eio (throttle)
[501.410925] Starting subtest: throttle
[501.719952] Subtest throttle: SUCCESS (0.309s)
[501.875533] [085/133] (520s left) gem_busy (busy)
[501.931049] Starting subtest: busy
[501.933284] Starting dynamic subtest: all-engines
[501.993646] Dynamic subtest all-engines: SUCCESS (0.062s)
[502.007700] Starting dynamic subtest: rcs0
[503.362874] Dynamic subtest rcs0: SUCCESS (1.367s)
[503.373391] Starting dynamic subtest: bcs0
[503.414595] Dynamic subtest bcs0: SUCCESS (0.048s)
[503.427928] Starting dynamic subtest: vcs0
[503.453094] Dynamic subtest vcs0: SUCCESS (0.039s)
[503.463192] Starting dynamic subtest: vcs1
[505.344454] Dynamic subtest vcs1: SUCCESS (1.888s)
[505.356582] Starting dynamic subtest: vecs0
[507.328301] Dynamic subtest vecs0: SUCCESS (1.982s)
[507.340566] Starting dynamic subtest: ccs0
[509.312167] Dynamic subtest ccs0: SUCCESS (1.982s)
[509.315106] Subtest busy: SUCCESS (7.379s)
[509.655837] [086/133] (512s left) i915_pm_rpm (sysfs-read)
[511.493974] Starting subtest: sysfs-read
[512.637996] Subtest sysfs-read: SUCCESS (1.146s)
[513.011359] [087/133] (509s left) kms_lease (empty-lease)
[513.115560] Starting subtest: empty-lease
[513.118110] Starting dynamic subtest: pipe-A-eDP-1
[513.120629] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[513.134026] Starting dynamic subtest: pipe-B-eDP-1
[513.136323] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[513.146084] Starting dynamic subtest: pipe-C-eDP-1
[513.148354] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[513.157789] Starting dynamic subtest: pipe-D-eDP-1
[513.160071] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[513.162485] Subtest empty-lease: SUCCESS (0.021s)
[513.239484] [088/133] (508s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[513.337815] Starting subtest: fbc-pr-sprite-mmap-gtt
[513.342327] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[513.415584] [089/133] (508s left) kms_atomic_transition (plane-all-transition-nonblocking)
[513.519672] Starting subtest: plane-all-transition-nonblocking
[513.522005] Starting dynamic subtest: pipe-A-eDP-1
[516.013221] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[516.334117] Starting dynamic subtest: pipe-B-eDP-1
[519.550730] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.226s)
[519.853804] Subtest plane-all-transition-nonblocking: SUCCESS (6.335s)
[520.670637] [090/133] (501s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[520.730138] Starting subtest: y-tiled-ccs-to-x-tiled
[520.735987] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[520.912357] [091/133] (501s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[521.011046] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[525.398154] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.393s)
[526.590601] [092/133] (495s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[526.707251] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[526.712527] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[527.817648] [093/133] (494s left) i915_drm_fdinfo (busy-idle-check-all)
[527.866837] Starting subtest: busy-idle-check-all
[527.869465] Starting dynamic subtest: rcs0
[527.875212] Dynamic subtest rcs0: SKIP (0.004s)
[527.886333] Starting dynamic subtest: bcs0
[527.891196] Dynamic subtest bcs0: SKIP (0.000s)
[527.902474] Starting dynamic subtest: vcs0
[527.908075] Dynamic subtest vcs0: SKIP (0.000s)
[527.919647] Starting dynamic subtest: vcs1
[527.925085] Dynamic subtest vcs1: SKIP (0.000s)
[527.935124] Starting dynamic subtest: vecs0
[527.940969] Dynamic subtest vecs0: SKIP (0.000s)
[527.950844] Starting dynamic subtest: ccs0
[527.956076] Dynamic subtest ccs0: SKIP (0.000s)
[527.961245] Subtest busy-idle-check-all: SKIP (0.010s)
[528.001545] [094/133] (494s left) kms_chamelium_hpd (hdmi-hpd-fast)
[528.416788] Subtest hdmi-hpd-fast: SKIP (0.000s)
[529.222398] [095/133] (493s left) kms_feature_discovery (psr1)
[529.317034] Starting subtest: psr1
[529.319454] Subtest psr1: SUCCESS (0.000s)
[529.395406] [096/133] (493s left) gen9_exec_parse (secure-batches)
[529.444892] Subtest secure-batches: SKIP (0.000s)
[529.504822] [097/133] (493s left) kms_async_flips (test-cursor)
[529.592543] Starting subtest: test-cursor
[529.971168] Starting dynamic subtest: pipe-A-eDP-1
[530.726289] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.756s)
[531.105504] Starting dynamic subtest: pipe-B-eDP-1
[531.861337] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.764s)
[532.258133] Starting dynamic subtest: pipe-C-eDP-1
[532.994251] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.744s)
[533.366895] Starting dynamic subtest: pipe-D-eDP-1
[534.132812] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.771s)
[534.135285] Subtest test-cursor: SUCCESS (4.540s)
[535.301872] [098/133] (487s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[535.403208] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[535.408715] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[535.541798] [099/133] (487s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[535.646175] Starting subtest: 4-tiled-addfb-size-offset-overflow
[535.649357] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[535.743199] [100/133] (487s left) kms_frontbuffer_tracking (fbc-2p-rte)
[535.847229] Starting subtest: fbc-2p-rte
[535.853052] Subtest fbc-2p-rte: SKIP (0.000s)
[535.943807] [101/133] (486s left) gem_mmap_gtt (fault-concurrent-x)
[535.998248] Subtest fault-concurrent-X: SKIP (0.000s)
[536.054484] [102/133] (486s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[536.121986] Starting subtest: basic-batch-kernel-default-cmd
[536.127756] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[536.305715] [103/133] (486s left) prime_udl
[536.399594] [104/133] (486s left) kms_pm_backlight (bad-brightness)
[536.509182] Starting subtest: bad-brightness
[536.559935] Starting dynamic subtest: eDP-1
[536.872167] Dynamic subtest eDP-1: SUCCESS (0.312s)
[536.875182] Subtest bad-brightness: SUCCESS (0.366s)
[537.724068] [105/133] (485s left) gem_mmap (bad-object)
[537.791209] Subtest bad-object: SKIP (0.000s)
[537.882644] [106/133] (485s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[537.938380] Starting subtest: invalid-multi-wait-unsubmitted
[537.940971] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[538.050761] [107/133] (485s left) vgem_basic (dmabuf-fence-before)
[538.100152] Starting subtest: dmabuf-fence-before
[538.103207] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[538.172092] [108/133] (485s left) gem_exec_flush (basic-wb-rw-default)
[538.234823] Starting subtest: basic-wb-rw-default
[543.695331] Subtest basic-wb-rw-default: SUCCESS (5.461s)
[543.880304] [109/133] (479s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[543.949313] Starting subtest: x-tiled-to-vebox-y-tiled
[543.954871] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[544.132282] [110/133] (479s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[544.234875] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[544.261015] Starting dynamic subtest: pipe-A-plane-0
[544.549479] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[544.559637] Starting dynamic subtest: pipe-A-plane-3
[544.793830] Dynamic subtest pipe-A-plane-3: SUCCESS (0.243s)
[544.804320] Starting dynamic subtest: pipe-A-plane-5
[544.809483] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[545.910932] Starting dynamic subtest: pipe-B-plane-0
[546.213679] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[546.224090] Starting dynamic subtest: pipe-B-plane-3
[546.457722] Dynamic subtest pipe-B-plane-3: SUCCESS (0.244s)
[546.468051] Starting dynamic subtest: pipe-B-plane-5
[546.472668] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[546.783192] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.550s)
[547.594111] [111/133] (475s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[547.713035] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[548.699892] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.987s)
[549.536454] [112/133] (473s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[549.625327] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[549.630918] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[549.720832] [113/133] (473s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[549.819557] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[553.425143] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.610s)
[554.569816] [114/133] (468s left) gem_mmap_offset (partial-mmap)
[554.630933] Starting subtest: partial-mmap
[554.633147] Starting dynamic subtest: smem0
[554.636069] Dynamic subtest smem0: SUCCESS (0.005s)
[554.638791] Subtest partial-mmap: SUCCESS (0.005s)
[554.750136] [115/133] (468s left) kms_flip (2x-modeset-vs-vblank-race)
[554.843772] Starting subtest: 2x-modeset-vs-vblank-race
[554.852816] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[554.934413] [116/133] (468s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[555.039370] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[555.044000] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[555.121325] [117/133] (468s left) i915_query (query-topology-matches-eu-total)
[555.175235] Starting subtest: query-topology-matches-eu-total
[555.178050] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[555.287702] [118/133] (468s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[555.399594] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[556.401145] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.001s)
[556.523468] [119/133] (467s left) perf_pmu (multi-client)
[556.565048] Starting subtest: multi-client
[556.567351] Starting dynamic subtest: rcs0
[557.616039] Dynamic subtest rcs0: SUCCESS (1.052s)
[557.628504] Starting dynamic subtest: bcs0
[558.670212] Dynamic subtest bcs0: SUCCESS (1.051s)
[558.683068] Starting dynamic subtest: vcs0
[559.722241] Dynamic subtest vcs0: SUCCESS (1.049s)
[559.734463] Starting dynamic subtest: vcs1
[561.329055] Dynamic subtest vcs1: SUCCESS (1.604s)
[561.341198] Starting dynamic subtest: vecs0
[563.313124] Dynamic subtest vecs0: SUCCESS (1.982s)
[563.325953] Starting dynamic subtest: ccs0
[565.363207] Dynamic subtest ccs0: SUCCESS (2.047s)
[565.366109] Subtest multi-client: SUCCESS (8.801s)
[565.516325] [120/133] (458s left) gem_exec_schedule (submit-late-slice)
[565.594083] Starting subtest: submit-late-slice
[565.597043] Starting dynamic subtest: rcs0
[565.651995] Dynamic subtest rcs0: SUCCESS (0.068s)
[565.667405] Starting dynamic subtest: bcs0
[565.732161] Dynamic subtest bcs0: SUCCESS (0.078s)
[565.746081] Starting dynamic subtest: vcs0
[565.789379] Dynamic subtest vcs0: SUCCESS (0.056s)
[565.801307] Starting dynamic subtest: vcs1
[565.842010] Dynamic subtest vcs1: SUCCESS (0.052s)
[565.854096] Starting dynamic subtest: vecs0
[565.904310] Dynamic subtest vecs0: SUCCESS (0.061s)
[565.917548] Starting dynamic subtest: ccs0
[565.983588] Dynamic subtest ccs0: SUCCESS (0.077s)
[565.986184] Subtest submit-late-slice: SUCCESS (0.401s)
[567.447302] [121/133] (456s left) sysfs_timeslice_duration (invalid)
[567.511296] Starting subtest: invalid
[567.514100] Starting dynamic subtest: vecs0
[567.516934] Dynamic subtest vecs0: SUCCESS (0.000s)
[567.528175] Starting dynamic subtest: ccs0
[567.530619] Dynamic subtest ccs0: SUCCESS (0.000s)
[567.540725] Starting dynamic subtest: vcs0
[567.543206] Dynamic subtest vcs0: SUCCESS (0.000s)
[567.553572] Starting dynamic subtest: bcs0
[567.555571] Dynamic subtest bcs0: SUCCESS (0.000s)
[567.564766] Starting dynamic subtest: rcs0
[567.566788] Dynamic subtest rcs0: SUCCESS (0.000s)
[567.576022] Starting dynamic subtest: vcs1
[567.577992] Dynamic subtest vcs1: SUCCESS (0.000s)
[567.580035] Subtest invalid: SUCCESS (0.006s)
[567.618989] [122/133] (456s left) kms_flip (2x-wf_vblank-ts-check)
[567.705698] Starting subtest: 2x-wf_vblank-ts-check
[567.714150] Subtest 2x-wf_vblank-ts-check: SKIP (0.011s)
[567.794025] [123/133] (456s left) gem_spin_batch (legacy-resubmit)
[567.854371] Starting subtest: legacy-resubmit
[567.857287] Starting dynamic subtest: default
[567.863386] Dynamic subtest default: SUCCESS (0.007s)
[567.875933] Starting dynamic subtest: render
[567.878912] Dynamic subtest render: SUCCESS (0.001s)
[567.889310] Starting dynamic subtest: bsd
[567.891760] Dynamic subtest bsd: SUCCESS (0.003s)
[567.901696] Starting dynamic subtest: bsd1
[567.903973] Dynamic subtest bsd1: SUCCESS (0.001s)
[567.914042] Starting dynamic subtest: bsd2
[567.916220] Dynamic subtest bsd2: SUCCESS (0.002s)
[567.925899] Starting dynamic subtest: blt
[567.928219] Dynamic subtest blt: SUCCESS (0.002s)
[567.940678] Starting dynamic subtest: vebox
[567.943062] Dynamic subtest vebox: SUCCESS (0.004s)
[567.945176] Subtest legacy-resubmit: SUCCESS (0.028s)
[568.109008] [124/133] (455s left) i915_module_load (fault-injection)
[568.144779] Starting subtest: fault-injection
[568.175203] Starting dynamic subtest: __uc_init
[570.219963] Dynamic subtest __uc_init: SUCCESS (2.042s)
[570.230529] Aborting: Kernel badly tainted (0x4244, 0x200) (check dmesg for details):
	TAINT_WARN: WARN_ON has happened.

[570.235584] Starting dynamic subtest: i915_driver_mmio_probe
[570.383839] Dynamic subtest i915_driver_mmio_probe: SUCCESS (0.163s)
[570.386196] Starting dynamic subtest: i915_driver_hw_probe
[570.555144] Dynamic subtest i915_driver_hw_probe: SUCCESS (0.170s)
[570.557401] Starting dynamic subtest: i915_pci_probe
[570.681728] Dynamic subtest i915_pci_probe: SUCCESS (0.126s)
[570.684003] Starting dynamic subtest: __fw_domain_init
[570.855935] Dynamic subtest __fw_domain_init: SUCCESS (0.172s)
[570.858060] Starting dynamic subtest: intel_connector_register
[572.759090] Dynamic subtest intel_connector_register: SUCCESS (1.902s)
[572.762165] Starting dynamic subtest: i915_driver_early_probe
[572.888494] Dynamic subtest i915_driver_early_probe: SUCCESS (0.128s)
[572.891148] Starting dynamic subtest: intel_gt_init-ENODEV
[573.978150] Dynamic subtest intel_gt_init-ENODEV: SUCCESS (1.088s)
[573.980546] Starting dynamic subtest: intel_guc_ct_init
[575.110281] Dynamic subtest intel_guc_ct_init: SUCCESS (1.130s)
[575.113137] Starting dynamic subtest: uc_fw_rsa_data_create
[576.209314] Dynamic subtest uc_fw_rsa_data_create: SUCCESS (1.098s)
[665.643078] Killing the test because the kernel is tainted.
[666.587689] [FACT i915_module_load (fault-injection)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[666.587757] [FACT i915_module_load (fault-injection)] new: kernel.is_tainted.taint_warn: true
[666.588608] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: gem_flink_basic
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: vgem_slow
results: parsing output: 6/ for test: kms_cursor_legacy
results: parsing output: 7/ for test: gem_exec_fence
results: parsing output: 8/ for test: kms_cursor_legacy
results: parsing output: 9/ for test: kms_cursor_edge_walk
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: perf
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: api_intel_allocator
results: parsing output: 14/ for test: gem_exec_schedule
results: parsing output: 15/ for test: kms_prime
results: parsing output: 16/ for test: kms_cursor_legacy
results: parsing output: 17/ for test: kms_pm_dc
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_exec_reloc
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: kms_plane_cursor
results: parsing output: 23/ for test: gem_exec_schedule
results: parsing output: 24/ for test: kms_cursor_crc
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: kms_psr2_sf
results: parsing output: 27/ for test: gem_create
results: parsing output: 28/ for test: gem_eio
results: parsing output: 29/ for test: kms_plane_alpha_blend
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: i915_pm_rps
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: gem_readwrite
results: parsing output: 35/ for test: kms_ccs
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: kms_sequence
results: parsing output: 38/ for test: gem_exec_params
results: parsing output: 39/ for test: prime_mmap_coherency
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_psr
results: parsing output: 42/ for test: gem_exec_balancer
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: gem_exec_reloc
results: parsing output: 45/ for test: kms_joiner
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: prime_busy
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: kms_cursor_legacy
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_wait
results: parsing output: 52/ for test: kms_rotation_crc
results: parsing output: 53/ for test: gem_ctx_persistence
results: parsing output: 54/ for test: kms_psr2_sf
results: parsing output: 55/ for test: gem_ctx_shared
results: parsing output: 56/ for test: gem_mmap_gtt
results: parsing output: 57/ for test: kms_plane
results: parsing output: 58/ for test: gem_render_copy
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: gem_exec_whisper
results: parsing output: 61/ for test: kms_chamelium_frames
results: parsing output: 62/ for test: kms_psr2_sf
results: parsing output: 63/ for test: kms_ccs
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_async_flips
results: parsing output: 66/ for test: kms_color
results: parsing output: 67/ for test: gem_pxp
results: parsing output: 68/ for test: kms_vblank
results: parsing output: 69/ for test: api_intel_bb
results: parsing output: 70/ for test: kms_flip_scaled_crc
results: parsing output: 71/ for test: gem_ctx_param
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_exec_balancer
results: parsing output: 75/ for test: gem_exercise_blt
results: parsing output: 76/ for test: kms_busy
results: parsing output: 77/ for test: kms_properties
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_content_protection
results: parsing output: 81/ for test: gem_userptr_blits
results: parsing output: 82/ for test: sw_sync
results: parsing output: 83/ for test: gem_eio
results: parsing output: 84/ for test: gem_busy
results: parsing output: 85/ for test: i915_pm_rpm
results: parsing output: 86/ for test: kms_lease
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: kms_atomic_transition
results: parsing output: 89/ for test: gem_render_copy
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: i915_drm_fdinfo
results: parsing output: 93/ for test: kms_chamelium_hpd
results: parsing output: 94/ for test: kms_feature_discovery
results: parsing output: 95/ for test: gen9_exec_parse
results: parsing output: 96/ for test: kms_async_flips
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_mmap_gtt
results: parsing output: 101/ for test: gem_exec_flush
results: parsing output: 102/ for test: prime_udl
results: parsing output: 103/ for test: kms_pm_backlight
results: parsing output: 104/ for test: gem_mmap
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: vgem_basic
results: parsing output: 107/ for test: gem_exec_flush
results: parsing output: 108/ for test: gem_render_copy
results: parsing output: 109/ for test: kms_plane
results: parsing output: 110/ for test: kms_cursor_legacy
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_mmap_offset
results: parsing output: 114/ for test: kms_flip
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: i915_query
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: perf_pmu
results: parsing output: 119/ for test: gem_exec_schedule
results: parsing output: 120/ for test: sysfs_timeslice_duration
results: parsing output: 121/ for test: kms_flip
results: parsing output: 122/ for test: gem_spin_batch
results: parsing output: 123/ for test: i915_module_load
igt_resultgen: Added ignore regex '.*Failed to register driver for userspace access!|.*Device initialization failed.*|.*probe with driver i915 failed with error.*|.*GT1: GSC proxy handler failed to init.*|.*GT0: GUC: failed with -ENXIO.*|.*GuC fw rsa data creation failed -ENXIO.*|.*GUC: failed with -ENXIO.*|.*Failed to register driver for userspace access.*|.*GT0: GuC fw rsa data creation failed -ENXIO.*'
igt_resultgen: Added ignore regex '.*Failed to register driver for userspace access!|.*Device initialization failed.*|.*probe with driver i915 failed with error.*|.*GT1: GSC proxy handler failed to init.*|.*GT0: GUC: failed with -ENXIO.*|.*GuC fw rsa data creation failed -ENXIO.*|.*GUC: failed with -ENXIO.*|.*Failed to register driver for userspace access.*|.*GT0: GuC fw rsa data creation failed -ENXIO.*'
igt_resultgen: Added ignore regex '.*Failed to register driver for userspace access!|.*Device initialization failed.*|.*probe with driver i915 failed with error.*|.*GT1: GSC proxy handler failed to init.*|.*GT0: GUC: failed with -ENXIO.*|.*GuC fw rsa data creation failed -ENXIO.*|.*GUC: failed with -ENXIO.*|.*Failed to register driver for userspace access.*|.*GT0: GuC fw rsa data creation failed -ENXIO.*'
igt_resultgen: Added ignore regex '.*Failed to register driver for userspace access!|.*Device initialization failed.*|.*probe with driver i915 failed with error.*|.*GT1: GSC proxy handler failed to init.*|.*GT0: GUC: failed with -ENXIO.*|.*GuC fw rsa data creation failed -ENXIO.*|.*GUC: failed with -ENXIO.*|.*Failed to register driver for userspace access.*|.*GT0: GuC fw rsa data creation failed -ENXIO.*'
igt_resultgen: Added ignore regex '.*Failed to register driver for userspace access!|.*Device initialization failed.*|.*probe with driver i915 failed with error.*|.*GT1: GSC proxy handler failed to init.*|.*GT0: GUC: failed with -ENXIO.*|.*GuC fw rsa data creation failed -ENXIO.*|.*GUC: failed with -ENXIO.*|.*Failed to register driver for userspace access.*|.*GT0: GuC fw rsa data creation failed -ENXIO.*'
igt_resultgen: Added ignore regex '.*Failed to register driver for userspace access!|.*Device initialization failed.*|.*probe with driver i915 failed with error.*|.*GT1: GSC proxy handler failed to init.*|.*GT0: GUC: failed with -ENXIO.*|.*GuC fw rsa data creation failed -ENXIO.*|.*GUC: failed with -ENXIO.*|.*Failed to register driver for userspace access.*|.*GT0: GuC fw rsa data creation failed -ENXIO.*'
igt_resultgen: Added ignore regex '.*Failed to register driver for userspace access!|.*Device initialization failed.*|.*probe with driver i915 failed with error.*|.*GT1: GSC proxy handler failed to init.*|.*GT0: GUC: failed with -ENXIO.*|.*GuC fw rsa data creation failed -ENXIO.*|.*GUC: failed with -ENXIO.*|.*Failed to register driver for userspace access.*|.*GT0: GuC fw rsa data creation failed -ENXIO.*'
igt_resultgen: Added ignore regex '.*Failed to register driver for userspace access!|.*Device initialization failed.*|.*probe with driver i915 failed with error.*|.*GT1: GSC proxy handler failed to init.*|.*GT0: GUC: failed with -ENXIO.*|.*GuC fw rsa data creation failed -ENXIO.*|.*GUC: failed with -ENXIO.*|.*Failed to register driver for userspace access.*|.*GT0: GuC fw rsa data creation failed -ENXIO.*'
igt_resultgen: Added ignore regex '.*Failed to register driver for userspace access!|.*Device initialization failed.*|.*probe with driver i915 failed with error.*|.*GT1: GSC proxy handler failed to init.*|.*GT0: GUC: failed with -ENXIO.*|.*GuC fw rsa data creation failed -ENXIO.*|.*GUC: failed with -ENXIO.*|.*Failed to register driver for userspace access.*|.*GT0: GuC fw rsa data creation failed -ENXIO.*'
igt_resultgen: Added ignore regex '.*Failed to register driver for userspace access!|.*Device initialization failed.*|.*probe with driver i915 failed with error.*|.*GT1: GSC proxy handler failed to init.*|.*GT0: GUC: failed with -ENXIO.*|.*GuC fw rsa data creation failed -ENXIO.*|.*GUC: failed with -ENXIO.*|.*Failed to register driver for userspace access.*|.*GT0: GuC fw rsa data creation failed -ENXIO.*'
results: parsing output: 124/ for test: device_reset
results: no output, setting notrun
results: parsing output: 125/ for test: kms_cursor_crc
results: no output, setting notrun
results: parsing output: 126/ for test: kms_vrr
results: no output, setting notrun
results: parsing output: 127/ for test: gem_flink_basic
results: no output, setting notrun
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 129/ for test: syncobj_timeline
results: no output, setting notrun
results: parsing output: 130/ for test: kms_flip
results: no output, setting notrun
results: parsing output: 131/ for test: kms_psr
results: no output, setting notrun
results: parsing output: 132/ for test: syncobj_timeline
results: no output, setting notrun
Done.