[57.167566] Initializing watchdogs
[57.167614]   /dev/watchdog0
[57.184012] [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.188402] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.190788] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.194183] [001/133] (960s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[57.319556] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[57.321682] Starting dynamic subtest: pipe-A-default-mode
[58.478762] Dynamic subtest pipe-A-default-mode: SKIP (1.155s)
[58.483737] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.156s)
[58.656582] [002/133] (959s left) kms_hdr (invalid-hdr)
[58.766265] Starting subtest: invalid-hdr
[60.858727] Starting dynamic subtest: pipe-A-eDP-1
[63.281891] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.425s)
[63.284406] Subtest invalid-hdr: SUCCESS (4.516s)
[63.416209] [003/133] (954s left) kms_flip (2x-plain-flip-fb-recreate)
[63.513129] Starting subtest: 2x-plain-flip-fb-recreate
[63.524429] Subtest 2x-plain-flip-fb-recreate: SKIP (0.011s)
[63.654577] [004/133] (954s left) kms_chamelium_hpd (vga-hpd-fast)
[64.031641] Subtest vga-hpd-fast: SKIP (0.000s)
[64.875705] [005/133] (952s left) gem_exec_fence (invalid-timeline-fence-array)
[65.437636] Starting subtest: invalid-timeline-fence-array
[65.442815] Subtest invalid-timeline-fence-array: SUCCESS (0.006s)
[67.212701] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[67.217448] [006/133] (950s left) gem_exec_balancer (bonded-sync)
[67.388430] Starting subtest: bonded-sync
[67.393029] Subtest bonded-sync: SKIP (0.000s)
[68.008390] [007/133] (949s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[68.152057] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[68.156175] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[68.331168] [008/133] (949s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[68.403711] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[68.489711] [009/133] (949s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[68.600057] Starting subtest: y-tiled-8bpp-rotate-270
[68.604376] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[68.727929] [010/133] (949s left) kms_psr (psr2-cursor-mmap-gtt)
[68.826912] Starting subtest: psr2-cursor-mmap-gtt
[68.829263] Starting dynamic subtest: eDP-1
[70.589458] Dynamic subtest eDP-1: SUCCESS (1.764s)
[70.591714] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.765s)
[71.481937] [011/133] (946s left) i915_drm_fdinfo (virtual-busy)
[71.521724] Starting subtest: virtual-busy
[71.526307] Subtest virtual-busy: SKIP (0.000s)
[71.598386] [012/133] (946s left) syncobj_wait (multi-wait-for-submit-signaled)
[71.656934] Starting subtest: multi-wait-for-submit-signaled
[71.659390] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[71.796818] [013/133] (946s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[71.898368] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[71.902494] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[72.013995] [014/133] (946s left) kms_pm_rpm (fences)
[74.043489] Starting subtest: fences
[74.049234] Subtest fences: SKIP (0.000s)
[74.457997] [015/133] (943s left) gem_userptr_blits (sync-unmap-cycles)
[74.525132] Starting subtest: sync-unmap-cycles
[79.894868] Subtest sync-unmap-cycles: SUCCESS (5.372s)
[80.054179] [016/133] (938s left) gem_userptr_blits (readonly-unsync)
[80.129451] Subtest readonly-unsync: SKIP (0.000s)
[80.293728] [017/133] (938s left) gem_render_copy (x-tiled)
[80.355180] Starting subtest: x-tiled
[80.357174] Starting dynamic subtest: smem
[80.403076] Dynamic subtest smem: SUCCESS (0.047s)
[80.405242] Subtest x-tiled: SUCCESS (0.048s)
[80.608092] [018/133] (937s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[80.718292] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[80.723118] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[81.859439] [019/133] (936s left) kms_cursor_crc (cursor-sliding-64x21)
[82.049283] Starting subtest: cursor-sliding-64x21
[82.098362] Subtest cursor-sliding-64x21: SKIP (0.045s)
[82.370128] [020/133] (936s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[82.487564] Starting subtest: x-tiled-32bpp-rotate-90
[82.506406] Subtest x-tiled-32bpp-rotate-90: SKIP (0.019s)
[82.642534] [021/133] (935s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[82.744336] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[82.758752] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.014s)
[82.846187] [022/133] (935s left) gem_exec_params (no-blt)
[82.901258] Starting subtest: no-blt
[82.902955] Subtest no-blt: SUCCESS (0.002s)
[83.044907] [023/133] (935s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[83.196578] Starting subtest: cursor-rapid-movement-32x10
[83.242135] Subtest cursor-rapid-movement-32x10: SKIP (0.044s)
[83.506437] [024/133] (935s left) syncobj_timeline (invalid-wait-bad-flags)
[83.559142] Starting subtest: invalid-wait-bad-flags
[83.560805] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[83.668994] [025/133] (935s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[83.761128] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[83.771764] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[83.849597] [026/133] (934s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[83.966488] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[83.970099] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s)
[84.121753] [027/133] (934s left) kms_psr (fbc-psr-no-drrs)
[84.223669] Starting subtest: fbc-psr-no-drrs
[84.225551] Starting dynamic subtest: eDP-1
[84.228931] Dynamic subtest eDP-1: SKIP (0.000s)
[84.232331] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[84.326724] [028/133] (934s left) gem_exec_schedule (submit-late-slice)
[84.399783] Starting subtest: submit-late-slice
[84.401722] Starting dynamic subtest: rcs0
[84.435301] Dynamic subtest rcs0: SUCCESS (0.045s)
[84.445210] Starting dynamic subtest: bcs0
[84.466135] Dynamic subtest bcs0: SUCCESS (0.031s)
[84.472935] Starting dynamic subtest: vcs0
[84.497112] Dynamic subtest vcs0: SUCCESS (0.031s)
[84.504522] Starting dynamic subtest: vcs1
[84.531210] Dynamic subtest vcs1: SUCCESS (0.034s)
[84.538209] Starting dynamic subtest: vecs0
[84.559270] Dynamic subtest vecs0: SUCCESS (0.028s)
[84.566412] Starting dynamic subtest: ccs0
[84.589433] Dynamic subtest ccs0: SUCCESS (0.030s)
[84.591348] Subtest submit-late-slice: SUCCESS (0.199s)
[85.965531] [029/133] (932s left) kms_big_fb (linear-16bpp-rotate-180)
[86.077644] Starting subtest: linear-16bpp-rotate-180
[87.411593] Subtest linear-16bpp-rotate-180: SUCCESS (1.334s)
[87.579408] [030/133] (931s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[87.684449] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[87.686339] Starting dynamic subtest: pipe-A-eDP-1
[88.123474] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.414s)
[88.131348] Starting dynamic subtest: pipe-B-eDP-1
[89.591535] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.464s)
[89.601537] Starting dynamic subtest: pipe-C-eDP-1
[90.974699] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.381s)
[90.985061] Starting dynamic subtest: pipe-D-eDP-1
[92.314253] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.340s)
[92.316226] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.602s)
[93.502386] [031/133] (925s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[93.568258] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[93.672575] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[93.756971] [032/133] (925s left) kms_async_flips (async-flip-dpms)
[93.868190] Starting subtest: async-flip-dpms
[94.252480] Starting dynamic subtest: pipe-A-eDP-1
[98.110272] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.856s)
[98.503441] Starting dynamic subtest: pipe-B-eDP-1
[101.285062] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.787s)
[101.681336] Starting dynamic subtest: pipe-C-eDP-1
[104.451933] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.777s)
[104.830052] Starting dynamic subtest: pipe-D-eDP-1
[107.610936] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.786s)
[107.613410] Subtest async-flip-dpms: SUCCESS (13.744s)
[108.813428] [033/133] (910s left) kms_properties (plane-properties-atomic)
[108.922365] Starting subtest: plane-properties-atomic
[108.924307] Starting dynamic subtest: pipe-A-eDP-1
[109.469534] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.546s)
[109.477987] Starting dynamic subtest: pipe-B-eDP-1
[110.757045] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.286s)
[110.766565] Starting dynamic subtest: pipe-C-eDP-1
[111.990851] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.234s)
[111.999716] Starting dynamic subtest: pipe-D-eDP-1
[113.227236] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.233s)
[113.229434] Subtest plane-properties-atomic: SUCCESS (4.304s)
[114.031816] [034/133] (905s left) api_intel_allocator (alloc-simple)
[114.099379] Starting subtest: alloc-simple
[114.101790] Subtest alloc-simple: SUCCESS (0.004s)
[114.243768] [035/133] (904s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[114.335129] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[114.348309] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[114.422515] [036/133] (904s left) kms_flip (2x-flip-vs-rmfb)
[114.510783] Starting subtest: 2x-flip-vs-rmfb
[114.521323] Subtest 2x-flip-vs-rmfb: SKIP (0.011s)
[114.612203] [037/133] (904s left) syncobj_timeline (reset-unsignaled)
[114.675925] Starting subtest: reset-unsignaled
[114.678101] Subtest reset-unsignaled: SUCCESS (0.000s)
[114.797818] [038/133] (904s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[114.899817] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[122.015225] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.118s)
[122.161829] [039/133] (897s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[122.262961] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[122.267407] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[122.382373] [040/133] (896s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[122.492422] Starting subtest: yf-tiled-8bpp-rotate-0
[122.496547] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[122.607196] [041/133] (896s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[122.704494] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[127.036699] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.336s)
[128.168876] [042/133] (891s left) kms_cdclk (mode-transition)
[128.261327] Starting subtest: mode-transition
[128.263683] Starting dynamic subtest: pipe-A-eDP-1
[128.566355] Dynamic subtest pipe-A-eDP-1: SKIP (0.303s)
[128.574960] Starting dynamic subtest: pipe-B-eDP-1
[128.579763] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[128.587202] Starting dynamic subtest: pipe-C-eDP-1
[128.591880] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[128.599247] Starting dynamic subtest: pipe-D-eDP-1
[128.603445] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[128.607641] Subtest mode-transition: SKIP (0.310s)
[129.387481] [043/133] (890s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[129.477773] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[133.242104] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.769s)
[134.386845] [044/133] (885s left) gem_userptr_blits (unsync-unmap-after-close)
[134.462452] Subtest unsync-unmap-after-close: SKIP (0.000s)
[134.615112] [045/133] (884s left) perf_pmu (most-busy-idle-check-all)
[134.660240] Starting subtest: most-busy-idle-check-all
[134.662033] Starting dynamic subtest: rcs0
[135.893725] Dynamic subtest rcs0: SUCCESS (1.232s)
[135.904932] Starting dynamic subtest: bcs0
[137.877878] Dynamic subtest bcs0: SUCCESS (1.982s)
[137.889792] Starting dynamic subtest: vcs0
[139.925770] Dynamic subtest vcs0: SUCCESS (2.045s)
[139.936885] Starting dynamic subtest: vcs1
[141.909615] Dynamic subtest vcs1: SUCCESS (1.981s)
[141.921205] Starting dynamic subtest: vecs0
[143.892572] Dynamic subtest vecs0: SUCCESS (1.981s)
[143.904181] Starting dynamic subtest: ccs0
[145.877638] Dynamic subtest ccs0: SUCCESS (1.982s)
[145.880751] Subtest most-busy-idle-check-all: SUCCESS (11.218s)
[146.002591] [046/133] (873s left) sw_sync (sync_merge_invalid)
[146.043561] Starting subtest: sync_merge_invalid
[146.069680] Subtest sync_merge_invalid: SUCCESS (0.026s)
[146.162978] [047/133] (873s left) kms_atomic_interruptible (legacy-pageflip)
[146.271516] Starting subtest: legacy-pageflip
[146.273728] Starting dynamic subtest: pipe-A-eDP-1
[153.692541] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.419s)
[153.695017] Subtest legacy-pageflip: SUCCESS (7.421s)
[154.540499] [048/133] (865s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[154.644779] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[161.354957] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.711s)
[161.512154] [049/133] (858s left) kms_psr (psr-dpms)
[161.609076] Starting subtest: psr-dpms
[161.611309] Starting dynamic subtest: eDP-1
[164.587958] Dynamic subtest eDP-1: SUCCESS (2.977s)
[164.590770] Subtest psr-dpms: SUCCESS (2.978s)
[165.486403] [050/133] (854s left) kms_cursor_crc (cursor-onscreen-128x128)
[165.690199] Starting subtest: cursor-onscreen-128x128
[165.695935] Starting dynamic subtest: pipe-A-eDP-1
[167.806684] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.110s)
[167.834094] Starting dynamic subtest: pipe-D-eDP-1
[170.700248] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.874s)
[170.702507] Subtest cursor-onscreen-128x128: SUCCESS (5.010s)
[171.521916] [051/133] (848s left) gem_ctx_persistence (legacy-engines-hang)
[171.579560] Starting subtest: legacy-engines-hang
[171.582020] Starting dynamic subtest: render
[171.691991] Dynamic subtest render: SUCCESS (0.112s)
[171.705164] Starting dynamic subtest: bsd1
[171.808822] Dynamic subtest bsd1: SUCCESS (0.113s)
[171.819822] Starting dynamic subtest: bsd2
[171.885535] Dynamic subtest bsd2: SUCCESS (0.074s)
[171.898157] Starting dynamic subtest: blt
[172.049971] Dynamic subtest blt: SUCCESS (0.161s)
[172.063465] Starting dynamic subtest: vebox
[172.127629] Dynamic subtest vebox: SUCCESS (0.075s)
[172.130021] Subtest legacy-engines-hang: SUCCESS (0.550s)
[172.261416] [052/133] (847s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[172.365217] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[179.580513] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.217s)
[179.729251] [053/133] (840s left) syncobj_timeline (signal-array)
[179.790686] Starting subtest: signal-array
[179.792668] Subtest signal-array: SUCCESS (0.000s)
[179.921274] [054/133] (839s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[180.013346] Starting subtest: fb-8bpc-vs-panel-6bpc
[180.015604] Starting dynamic subtest: pipe-A-eDP-1
[181.404578] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.393s)
[181.406943] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.394s)
[182.212709] [055/133] (837s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[182.315018] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[182.319474] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[182.430066] [056/133] (837s left) kms_chamelium_color (ctm-red-to-blue)
[182.527169] Subtest ctm-red-to-blue: SKIP (0.000s)
[182.570023] [057/133] (837s left) kms_psr (fbc-pr-sprite-plane-move)
[182.656080] Starting subtest: fbc-pr-sprite-plane-move
[182.660170] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[182.738610] [058/133] (837s left) gem_spin_batch (engines)
[182.799404] Starting subtest: engines
[182.801658] Starting dynamic subtest: rcs0
[186.036689] Dynamic subtest rcs0: SUCCESS (3.234s)
[186.046917] Starting dynamic subtest: bcs0
[189.273527] Dynamic subtest bcs0: SUCCESS (3.235s)
[189.283952] Starting dynamic subtest: vcs0
[192.507996] Dynamic subtest vcs0: SUCCESS (3.232s)
[192.518144] Starting dynamic subtest: vcs1
[195.745090] Dynamic subtest vcs1: SUCCESS (3.234s)
[195.755372] Starting dynamic subtest: vecs0
[198.981859] Dynamic subtest vecs0: SUCCESS (3.234s)
[198.992153] Starting dynamic subtest: ccs0
[202.219273] Dynamic subtest ccs0: SUCCESS (3.235s)
[202.221720] Subtest engines: SUCCESS (19.419s)
[202.468144] [059/133] (817s left) kms_plane (plane-position-hole-dpms)
[202.577415] Starting subtest: plane-position-hole-dpms
[203.090814] Starting dynamic subtest: pipe-A-plane-1
[205.502278] Dynamic subtest pipe-A-plane-1: SUCCESS (2.410s)
[205.510330] Starting dynamic subtest: pipe-A-plane-2
[207.833037] Dynamic subtest pipe-A-plane-2: SUCCESS (2.331s)
[207.841266] Starting dynamic subtest: pipe-A-plane-3
[210.190093] Dynamic subtest pipe-A-plane-3: SUCCESS (2.356s)
[210.198799] Starting dynamic subtest: pipe-A-plane-4
[212.580518] Dynamic subtest pipe-A-plane-4: SUCCESS (2.389s)
[212.589344] Starting dynamic subtest: pipe-A-plane-5
[212.608560] Dynamic subtest pipe-A-plane-5: SUCCESS (0.027s)
[213.821613] Starting dynamic subtest: pipe-B-plane-1
[216.172522] Dynamic subtest pipe-B-plane-1: SUCCESS (2.359s)
[216.180803] Starting dynamic subtest: pipe-B-plane-2
[218.511211] Dynamic subtest pipe-B-plane-2: SUCCESS (2.337s)
[218.519648] Starting dynamic subtest: pipe-B-plane-3
[220.871948] Dynamic subtest pipe-B-plane-3: SUCCESS (2.360s)
[220.880365] Starting dynamic subtest: pipe-B-plane-4
[223.220218] Dynamic subtest pipe-B-plane-4: SUCCESS (2.347s)
[223.228943] Starting dynamic subtest: pipe-B-plane-5
[223.243487] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[223.245723] Subtest plane-position-hole-dpms: SUCCESS (20.666s)
[224.055633] [060/133] (796s left) gem_exec_whisper (basic-normal)
[224.120955] Starting subtest: basic-normal
[227.571173] Subtest basic-normal: SUCCESS (3.448s)
[227.781408] [061/133] (792s left) kms_plane_scaling (planes-downscale-factor-0-5)
[227.881119] Starting subtest: planes-downscale-factor-0-5
[227.883463] Starting dynamic subtest: pipe-A
[227.903026] Dynamic subtest pipe-A: SKIP (0.017s)
[227.913465] Starting dynamic subtest: pipe-B
[227.930411] Dynamic subtest pipe-B: SKIP (0.029s)
[227.938997] Starting dynamic subtest: pipe-C
[227.961822] Dynamic subtest pipe-C: SKIP (0.029s)
[227.969528] Starting dynamic subtest: pipe-D
[227.990185] Dynamic subtest pipe-D: SKIP (0.029s)
[227.994531] Subtest planes-downscale-factor-0-5: SKIP (0.107s)
[228.126247] [062/133] (792s left) gem_exec_fence (basic-busy)
[228.309519] Starting subtest: basic-busy
[228.311982] Starting dynamic subtest: rcs0
[228.427324] Dynamic subtest rcs0: SUCCESS (0.118s)
[228.438106] Starting dynamic subtest: bcs0
[228.481493] Dynamic subtest bcs0: SUCCESS (0.052s)
[228.494333] Starting dynamic subtest: vcs0
[228.543112] Dynamic subtest vcs0: SUCCESS (0.060s)
[228.554170] Starting dynamic subtest: vcs1
[228.596950] Dynamic subtest vcs1: SUCCESS (0.052s)
[228.607202] Starting dynamic subtest: vecs0
[228.661028] Dynamic subtest vecs0: SUCCESS (0.062s)
[228.671330] Starting dynamic subtest: ccs0
[228.722146] Dynamic subtest ccs0: SUCCESS (0.059s)
[228.724589] Subtest basic-busy: SUCCESS (0.415s)
[230.994106] [063/133] (789s left) gem_exec_reloc (basic-cpu-noreloc)
[231.059812] Subtest basic-cpu-noreloc: SKIP (0.000s)
[231.154876] [064/133] (789s left) kms_joiner (basic-max-non-joiner)
[231.267316] Starting subtest: basic-max-non-joiner
[231.271598] Subtest basic-max-non-joiner: SKIP (0.000s)
[231.344400] [065/133] (789s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[231.413276] Starting subtest: single-wait-for-submit-unsubmitted
[231.521471] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[231.609927] [066/133] (788s left) kms_feature_discovery (chamelium)
[231.718415] Starting subtest: chamelium
[231.722944] Subtest chamelium: SKIP (0.000s)
[231.818280] [067/133] (788s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[231.865681] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[231.934486] [068/133] (788s left) sysfs_heartbeat_interval (invalid)
[231.999764] Starting subtest: invalid
[232.002208] Starting dynamic subtest: vecs0
[232.004534] Dynamic subtest vecs0: SUCCESS (0.000s)
[232.014037] Starting dynamic subtest: ccs0
[232.016203] Dynamic subtest ccs0: SUCCESS (0.000s)
[232.023875] Starting dynamic subtest: vcs0
[232.025787] Dynamic subtest vcs0: SUCCESS (0.000s)
[232.033572] Starting dynamic subtest: bcs0
[232.036092] Dynamic subtest bcs0: SUCCESS (0.000s)
[232.043603] Starting dynamic subtest: rcs0
[232.045824] Dynamic subtest rcs0: SUCCESS (0.000s)
[232.053430] Starting dynamic subtest: vcs1
[232.055666] Dynamic subtest vcs1: SUCCESS (0.000s)
[232.057880] Subtest invalid: SUCCESS (0.006s)
[232.093531] [069/133] (788s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[232.184906] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[236.636279] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.453s)
[237.848180] [070/133] (782s left) kms_addfb_basic (too-high)
[237.943698] Starting subtest: too-high
[237.945798] Subtest too-high: SUCCESS (0.000s)
[238.088029] [071/133] (782s left) gem_mmap_offset (bad-extensions)
[238.148083] Starting subtest: bad-extensions
[238.149945] Subtest bad-extensions: SUCCESS (0.000s)
[238.268212] [072/133] (782s left) gem_ccs (block-copy-uncompressed)
[238.326822] Starting subtest: block-copy-uncompressed
[238.329121] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[238.349493] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.022s)
[238.361361] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[238.366881] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[238.374552] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[238.386462] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.019s)
[238.394176] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[238.403367] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[238.405684] Subtest block-copy-uncompressed: SUCCESS (0.077s)
[238.556925] [073/133] (782s left) kms_sequence (queue-idle)
[238.657476] Starting subtest: queue-idle
[238.659894] Starting dynamic subtest: pipe-A-eDP-1
[240.480849] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.821s)
[240.489335] Starting dynamic subtest: pipe-B-eDP-1
[243.008688] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.529s)
[243.019371] Starting dynamic subtest: pipe-C-eDP-1
[245.508614] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.496s)
[245.517291] Starting dynamic subtest: pipe-D-eDP-1
[247.939206] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.430s)
[247.941737] Subtest queue-idle: SUCCESS (9.283s)
[248.764523] [074/133] (771s left) kms_atomic (plane-overlay-legacy)
[248.865031] Starting subtest: plane-overlay-legacy
[248.867172] Starting dynamic subtest: pipe-A-eDP-1
[249.289041] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.422s)
[249.291352] Subtest plane-overlay-legacy: SUCCESS (0.424s)
[250.099806] [075/133] (770s left) gem_exec_whisper (basic-queues-forked)
[250.170057] Starting subtest: basic-queues-forked
[273.977061] Subtest basic-queues-forked: SUCCESS (23.806s)
[274.176527] [076/133] (746s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[274.298295] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[274.302362] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[274.424061] [077/133] (746s left) kms_lease (lease-unleased-connector)
[274.515267] Starting subtest: lease-unleased-connector
[274.517590] Starting dynamic subtest: pipe-A-eDP-1
[274.522814] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[274.531683] Starting dynamic subtest: pipe-B-eDP-1
[274.533743] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[274.542283] Starting dynamic subtest: pipe-C-eDP-1
[274.544877] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[274.553685] Starting dynamic subtest: pipe-D-eDP-1
[274.555857] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.008s)
[274.557699] Subtest lease-unleased-connector: SUCCESS (0.037s)
[274.683243] [078/133] (746s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[274.782632] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[281.623885] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.845s)
[281.758986] [079/133] (739s left) gem_mmap (pf-nonblock)
[281.818183] Subtest pf-nonblock: SKIP (0.000s)
[281.880307] [080/133] (739s left) i915_query (query-regions-unallocated)
[281.949071] Starting subtest: query-regions-unallocated
[281.951442] Subtest query-regions-unallocated: SUCCESS (0.000s)
[282.075823] [081/133] (738s left) kms_prime (basic-crc-vgem)
[282.163880] Starting subtest: basic-crc-vgem
[282.166149] Starting dynamic subtest: second-to-first
[283.140229] Dynamic subtest second-to-first: SUCCESS (0.980s)
[283.142339] Subtest basic-crc-vgem: SUCCESS (0.981s)
[283.244259] [082/133] (737s left) kms_color (ctm-0-50)
[283.389290] Starting subtest: ctm-0-50
[283.391132] Starting dynamic subtest: pipe-A-eDP-1
[286.856738] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.467s)
[286.872576] Starting dynamic subtest: pipe-B-eDP-1
[291.155272] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.299s)
[291.165394] Starting dynamic subtest: pipe-C-eDP-1
[295.239843] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.083s)
[295.247995] Starting dynamic subtest: pipe-D-eDP-1
[299.256760] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.017s)
[299.259089] Subtest ctm-0-50: SUCCESS (15.869s)
[300.078607] [083/133] (721s left) gem_pxp (reject-modify-context-protection-off-3)
[300.211239] Starting subtest: reject-modify-context-protection-off-3
[300.213801] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[300.353718] [084/133] (720s left) perf (non-zero-reason)
[300.486508] Starting subtest: non-zero-reason
[300.488416] Starting dynamic subtest: 0-rcs0
[305.968254] Dynamic subtest 0-rcs0: SUCCESS (5.481s)
[305.979944] Starting dynamic subtest: 1-vcs1
[309.917217] Dynamic subtest 1-vcs1: SUCCESS (3.947s)
[309.920110] Subtest non-zero-reason: SUCCESS (9.431s)
[309.967212] [085/133] (711s left) gem_mmap_wc (read-write-distinct)
[310.034082] Subtest read-write-distinct: SKIP (0.000s)
[310.101695] [086/133] (711s left) kms_psr (pr-primary-render)
[310.200824] Starting subtest: pr-primary-render
[310.205181] Subtest pr-primary-render: SKIP (0.000s)
[310.284644] [087/133] (710s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[310.401825] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[310.404137] Starting dynamic subtest: pipe-A-default-mode
[311.524687] Dynamic subtest pipe-A-default-mode: SKIP (1.122s)
[311.529251] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.123s)
[311.734230] [088/133] (709s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[311.872246] Starting subtest: psr-rgb565-draw-pwrite
[318.915235] Subtest psr-rgb565-draw-pwrite: SUCCESS (7.046s)
[319.046765] [089/133] (702s left) syncobj_basic (bad-pad-fd-to-handle)
[319.109119] Starting subtest: bad-pad-fd-to-handle
[319.110966] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[319.228256] [090/133] (702s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[319.327753] Starting subtest: psr-rgb565-draw-mmap-gtt
[319.332143] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[319.419769] [091/133] (701s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[319.540336] Starting subtest: cursorA-vs-flipA-legacy
[330.677154] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.136s)
[331.549319] [092/133] (689s left) sriov_basic (enable-vfs-bind-unbind-each)
[331.613557] Starting subtest: enable-vfs-bind-unbind-each
[331.615649] Starting dynamic subtest: numvfs-1
[331.695754] Dynamic subtest numvfs-1: FAIL (0.027s)
[331.709121] Starting dynamic subtest: numvfs-2
[331.784024] Dynamic subtest numvfs-2: FAIL (0.004s)
[331.793864] Starting dynamic subtest: numvfs-3
[331.866874] Dynamic subtest numvfs-3: FAIL (0.003s)
[331.876416] Starting dynamic subtest: numvfs-4
[331.949577] Dynamic subtest numvfs-4: FAIL (0.003s)
[331.958551] Starting dynamic subtest: numvfs-5
[332.031031] Dynamic subtest numvfs-5: FAIL (0.004s)
[332.042103] Starting dynamic subtest: numvfs-6
[332.115619] Dynamic subtest numvfs-6: FAIL (0.004s)
[332.124762] Starting dynamic subtest: numvfs-7
[332.197051] Dynamic subtest numvfs-7: FAIL (0.004s)
[332.207454] Starting dynamic subtest: numvfs-random
[332.278641] Dynamic subtest numvfs-random: FAIL (0.004s)
[332.281044] Subtest enable-vfs-bind-unbind-each: FAIL (0.059s)
[332.318290] [093/133] (689s left) gem_exec_schedule (implicit-write-read)
[332.391998] Starting subtest: implicit-write-read
[332.394335] Starting dynamic subtest: rcs0
[332.491210] Dynamic subtest rcs0: SUCCESS (0.110s)
[332.501710] Starting dynamic subtest: vcs0
[332.576538] Dynamic subtest vcs0: SUCCESS (0.084s)
[332.587471] Starting dynamic subtest: vcs1
[332.652953] Dynamic subtest vcs1: SUCCESS (0.076s)
[332.664857] Starting dynamic subtest: vecs0
[332.726621] Dynamic subtest vecs0: SUCCESS (0.072s)
[332.737098] Starting dynamic subtest: ccs0
[332.809221] Dynamic subtest ccs0: SUCCESS (0.082s)
[332.811213] Subtest implicit-write-read: SUCCESS (0.429s)
[334.011871] [094/133] (687s left) kms_flip (2x-nonexisting-fb)
[334.116422] Starting subtest: 2x-nonexisting-fb
[334.126181] Subtest 2x-nonexisting-fb: SKIP (0.011s)
[334.218264] [095/133] (687s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[334.331116] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[334.335068] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[334.426251] [096/133] (687s left) kms_vblank (ts-continuation-modeset)
[334.527274] Starting subtest: ts-continuation-modeset
[334.529439] Starting dynamic subtest: pipe-A-eDP-1
[336.004431] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.476s)
[336.018068] Starting dynamic subtest: pipe-D-eDP-1
[338.153476] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.148s)
[338.155805] Subtest ts-continuation-modeset: SUCCESS (3.628s)
[338.964154] [097/133] (682s left) gem_create (hog-create)
[339.025703] Starting subtest: hog-create
[339.027891] Starting dynamic subtest: smem0
[371.959293] Dynamic subtest smem0: SUCCESS (32.931s)
[371.961858] Subtest hog-create: SUCCESS (32.933s)
[372.155513] [098/133] (649s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[372.265189] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[379.262449] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.000s)
[379.410341] [099/133] (642s left) kms_concurrent (multi-plane-atomic-lowres)
[379.510881] Starting subtest: multi-plane-atomic-lowres
[379.513538] Starting dynamic subtest: pipe-A-eDP-1
[380.021549] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.508s)
[380.023919] Subtest multi-plane-atomic-lowres: SUCCESS (0.509s)
[380.832500] [100/133] (640s left) i915_module_load (reload-no-display)
[380.880123] Starting subtest: reload-no-display
[387.171114] Subtest reload-no-display: SUCCESS (6.289s)
[387.201143] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[387.201856] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[387.205184] [101/133] (634s left) syncobj_eventfd (invalid-bad-pad)
[388.755268] Starting subtest: invalid-bad-pad
[388.757665] Subtest invalid-bad-pad: SUCCESS (0.000s)
[388.844778] [FACT syncobj_eventfd (invalid-bad-pad)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[388.846130] [FACT syncobj_eventfd (invalid-bad-pad)] new: kernel.kmod_is_loaded.i915: true
[388.849811] [102/133] (633s left) gem_eio (wait-wedge-10ms)
[389.006588] Starting subtest: wait-wedge-10ms
[390.970520] Subtest wait-wedge-10ms: SUCCESS (1.964s)
[391.099266] [103/133] (630s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[391.169431] Starting subtest: invalid-bsd2-flag-on-vebox
[391.171825] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[391.275335] [104/133] (630s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[391.374313] Starting subtest: pr-cursor-plane-update-sf
[391.378336] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[391.451779] [105/133] (630s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[391.548259] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[391.552334] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[391.660525] [106/133] (630s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[391.763811] Starting subtest: psr2-plane-move-sf-dmg-area
[391.766149] Starting dynamic subtest: pipe-A-eDP-1
[396.375260] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.615s)
[396.384438] Starting dynamic subtest: pipe-B-eDP-1
[401.698060] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.322s)
[401.700310] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.940s)
[402.570568] [107/133] (619s left) gem_eio (in-flight-contexts-1us)
[402.746070] Starting subtest: in-flight-contexts-1us
[410.933253] Subtest in-flight-contexts-1us: SUCCESS (8.186s)
[411.110526] [108/133] (610s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[411.218264] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[411.220627] Starting dynamic subtest: pipe-A-eDP-1
[411.243345] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[411.254257] Starting dynamic subtest: pipe-B-eDP-1
[411.275111] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[411.283130] Starting dynamic subtest: pipe-C-eDP-1
[411.304331] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[411.313651] Starting dynamic subtest: pipe-D-eDP-1
[411.335451] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[411.339494] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[413.439603] [109/133] (608s left) i915_pm_rps (fence-order)
[413.501457] Starting subtest: fence-order
[416.542707] Subtest fence-order: SUCCESS (3.039s)
[416.663592] [110/133] (605s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[416.729527] Starting subtest: yf-tiled-ccs-to-y-tiled
[416.734075] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[416.924094] [111/133] (605s left) gem_exec_schedule (fairslice-all)
[416.994526] Starting subtest: fairslice-all
[419.063944] Subtest fairslice-all: SUCCESS (2.073s)
[419.372903] [112/133] (602s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[419.502308] Starting subtest: cursor-vs-flip-varying-size
[450.324161] Subtest cursor-vs-flip-varying-size: SUCCESS (30.819s)
[451.166905] [113/133] (571s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[451.278243] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[451.282592] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[451.406919] [114/133] (570s left) gem_readwrite (beyond-eob)
[451.469952] Subtest beyond-EOB: SKIP (0.000s)
[451.535410] [115/133] (570s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[451.641144] Starting subtest: plane-use-after-nonblocking-unbind
[451.643307] Starting dynamic subtest: pipe-A-eDP-1
[451.701660] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[452.026756] Starting dynamic subtest: pipe-B-eDP-1
[452.865860] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.847s)
[453.162067] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.523s)
[454.037691] [116/133] (568s left) gem_ctx_persistence (engines-hostile-preempt)
[454.098597] Starting subtest: engines-hostile-preempt
[454.100903] Starting dynamic subtest: rcs0
[454.229973] Dynamic subtest rcs0: SUCCESS (0.131s)
[454.241206] Starting dynamic subtest: bcs0
[454.313236] Dynamic subtest bcs0: SUCCESS (0.081s)
[454.323578] Starting dynamic subtest: vcs0
[455.876596] Dynamic subtest vcs0: SUCCESS (1.560s)
[455.887701] Starting dynamic subtest: vcs1
[457.955221] Dynamic subtest vcs1: SUCCESS (2.076s)
[457.966713] Starting dynamic subtest: vecs0
[459.955641] Dynamic subtest vecs0: SUCCESS (1.997s)
[459.971326] Starting dynamic subtest: ccs0
[460.049408] Dynamic subtest ccs0: SUCCESS (0.092s)
[460.051998] Subtest engines-hostile-preempt: SUCCESS (5.951s)
[460.138041] [117/133] (562s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[460.203795] Starting subtest: invalid-bsd1-flag-on-blt
[460.206315] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[460.334386] [118/133] (562s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[460.448603] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[460.452744] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[460.553552] [119/133] (561s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[460.665614] Starting subtest: fbcpsr-rgb101010-draw-blt
[467.419398] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.756s)
[467.589652] [120/133] (554s left) gem_vm_create (isolation)
[467.649751] Starting subtest: isolation
[467.658999] Subtest isolation: SUCCESS (0.008s)
[467.813573] [121/133] (554s left) kms_plane_cursor (overlay)
[467.929391] Starting subtest: overlay
[467.933857] Starting dynamic subtest: pipe-A-eDP-1-size-64
[470.446096] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.517s)
[470.504540] Starting dynamic subtest: pipe-A-eDP-1-size-128
[472.947040] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.449s)
[473.006071] Starting dynamic subtest: pipe-A-eDP-1-size-256
[475.425720] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.427s)
[475.779395] Starting dynamic subtest: pipe-B-eDP-1-size-64
[478.955226] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.185s)
[479.014181] Starting dynamic subtest: pipe-B-eDP-1-size-128
[481.457769] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.449s)
[481.516595] Starting dynamic subtest: pipe-B-eDP-1-size-256
[484.025105] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.515s)
[484.371510] Starting dynamic subtest: pipe-C-eDP-1-size-64
[487.225482] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.864s)
[487.263340] Starting dynamic subtest: pipe-C-eDP-1-size-128
[489.336810] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.080s)
[489.374466] Starting dynamic subtest: pipe-C-eDP-1-size-256
[491.448598] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.080s)
[491.778742] Starting dynamic subtest: pipe-D-eDP-1-size-64
[494.691713] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.921s)
[494.728917] Starting dynamic subtest: pipe-D-eDP-1-size-128
[496.835937] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.113s)
[496.880056] Starting dynamic subtest: pipe-D-eDP-1-size-256
[498.980216] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.114s)
[499.306316] Subtest overlay: SUCCESS (31.378s)
[500.208794] [122/133] (522s left) gem_exec_reloc (basic-write-cpu-active)
[500.273433] Subtest basic-write-cpu-active: SKIP (0.000s)
[500.362600] [123/133] (522s left) gen9_exec_parse (allowed-single)
[500.419482] Subtest allowed-single: SKIP (0.000s)
[500.509170] [124/133] (522s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[500.603412] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[500.605624] Starting dynamic subtest: A-eDP1
[509.529113] Dynamic subtest A-eDP1: SUCCESS (8.924s)
[509.539430] Starting dynamic subtest: B-eDP1
[518.467611] Dynamic subtest B-eDP1: SUCCESS (8.936s)
[518.479725] Starting dynamic subtest: C-eDP1
[527.384379] Dynamic subtest C-eDP1: SUCCESS (8.914s)
[527.393384] Starting dynamic subtest: D-eDP1
[536.226253] Dynamic subtest D-eDP1: SUCCESS (8.839s)
[536.231222] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.626s)
[537.467711] [125/133] (485s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[537.572419] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[538.286826] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.715s)
[538.497641] [126/133] (484s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[538.607398] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[538.609566] Starting dynamic subtest: pipe-A-eDP-1
[538.632082] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.027s)
[538.644205] Starting dynamic subtest: pipe-B-eDP-1
[538.663989] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.023s)
[538.676607] Starting dynamic subtest: pipe-C-eDP-1
[538.696231] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.024s)
[538.709063] Starting dynamic subtest: pipe-D-eDP-1
[538.729585] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.024s)
[538.731917] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.102s)
[541.019325] [127/133] (481s left) kms_rmfb (close-fd)
[541.114539] Starting subtest: close-fd
[541.116831] Starting dynamic subtest: pipe-A-eDP-1
[541.222451] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.107s)
[541.232120] Starting dynamic subtest: pipe-B-eDP-1
[542.387417] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.162s)
[542.404695] Starting dynamic subtest: pipe-C-eDP-1
[543.585062] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.199s)
[543.594164] Starting dynamic subtest: pipe-D-eDP-1
[544.715291] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s)
[544.717440] Subtest close-fd: SUCCESS (3.601s)
[545.933644] [128/133] (476s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[546.038967] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[546.043163] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[546.160474] [129/133] (476s left) api_intel_bb (object-reloc-keep-cache)
[546.214103] Starting subtest: object-reloc-keep-cache
[546.218573] Subtest object-reloc-keep-cache: SKIP (0.002s)
[546.365838] [130/133] (476s left) gem_eio (kms)
[546.638750] Starting subtest: kms
[567.428704] Subtest kms: SUCCESS (20.787s)
[567.583357] [131/133] (455s left) perf (non-system-wide-paranoid)
[567.700234] Starting subtest: non-system-wide-paranoid
[567.731325] Subtest non-system-wide-paranoid: SUCCESS (0.033s)
[567.780390] [132/133] (455s left) dmabuf_sync_file (export-wait-after-attach)
[567.816317] Starting subtest: export-wait-after-attach
[567.818538] Subtest export-wait-after-attach: SUCCESS (0.001s)
[567.883656] [133/133] (455s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[567.990791] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[568.662358] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.672s)
[568.868484] Closing watchdogs
results: parsing output: 0/ for test: kms_flip_scaled_crc
results: parsing output: 1/ for test: kms_hdr
results: parsing output: 2/ for test: kms_flip
results: parsing output: 3/ for test: kms_chamelium_hpd
results: parsing output: 4/ for test: gem_exec_fence
results: parsing output: 5/ for test: gem_exec_balancer
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_exec_reloc
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: i915_drm_fdinfo
results: parsing output: 11/ for test: syncobj_wait
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_pm_rpm
results: parsing output: 14/ for test: gem_userptr_blits
results: parsing output: 15/ for test: gem_userptr_blits
results: parsing output: 16/ for test: gem_render_copy
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: kms_cursor_crc
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: gem_exec_params
results: parsing output: 22/ for test: kms_cursor_crc
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: kms_plane
results: parsing output: 25/ for test: kms_cursor_legacy
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: gem_exec_schedule
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: kms_async_flips
results: parsing output: 32/ for test: kms_properties
results: parsing output: 33/ for test: api_intel_allocator
results: parsing output: 34/ for test: kms_plane
results: parsing output: 35/ for test: kms_flip
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_cdclk
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_userptr_blits
results: parsing output: 44/ for test: perf_pmu
results: parsing output: 45/ for test: sw_sync
results: parsing output: 46/ for test: kms_atomic_interruptible
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_cursor_crc
results: parsing output: 50/ for test: gem_ctx_persistence
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: kms_dither
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_chamelium_color
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: gem_spin_batch
results: parsing output: 58/ for test: kms_plane
results: parsing output: 59/ for test: gem_exec_whisper
results: parsing output: 60/ for test: kms_plane_scaling
results: parsing output: 61/ for test: gem_exec_fence
results: parsing output: 62/ for test: gem_exec_reloc
results: parsing output: 63/ for test: kms_joiner
results: parsing output: 64/ for test: syncobj_wait
results: parsing output: 65/ for test: kms_feature_discovery
results: parsing output: 66/ for test: gem_mmap_gtt
results: parsing output: 67/ for test: sysfs_heartbeat_interval
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_addfb_basic
results: parsing output: 70/ for test: gem_mmap_offset
results: parsing output: 71/ for test: gem_ccs
results: parsing output: 72/ for test: kms_sequence
results: parsing output: 73/ for test: kms_atomic
results: parsing output: 74/ for test: gem_exec_whisper
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_lease
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_mmap
results: parsing output: 79/ for test: i915_query
results: parsing output: 80/ for test: kms_prime
results: parsing output: 81/ for test: kms_color
results: parsing output: 82/ for test: gem_pxp
results: parsing output: 83/ for test: perf
results: parsing output: 84/ for test: gem_mmap_wc
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: kms_flip_scaled_crc
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: syncobj_basic
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_cursor_legacy
results: parsing output: 91/ for test: sriov_basic
results: parsing output: 92/ for test: gem_exec_schedule
results: parsing output: 93/ for test: kms_flip
results: parsing output: 94/ for test: kms_psr2_sf
results: parsing output: 95/ for test: kms_vblank
results: parsing output: 96/ for test: gem_create
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_concurrent
results: parsing output: 99/ for test: i915_module_load
results: parsing output: 100/ for test: syncobj_eventfd
results: parsing output: 101/ for test: gem_eio
results: parsing output: 102/ for test: gem_exec_params
results: parsing output: 103/ for test: kms_psr2_sf
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_psr2_sf
results: parsing output: 106/ for test: gem_eio
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: i915_pm_rps
results: parsing output: 109/ for test: gem_render_copy
results: parsing output: 110/ for test: gem_exec_schedule
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_readwrite
results: parsing output: 114/ for test: kms_atomic_transition
results: parsing output: 115/ for test: gem_ctx_persistence
results: parsing output: 116/ for test: gem_exec_params
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_vm_create
results: parsing output: 120/ for test: kms_plane_cursor
results: parsing output: 121/ for test: gem_exec_reloc
results: parsing output: 122/ for test: gen9_exec_parse
results: parsing output: 123/ for test: kms_flip
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: kms_rmfb
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: api_intel_bb
results: parsing output: 129/ for test: gem_eio
results: parsing output: 130/ for test: perf
results: parsing output: 131/ for test: dmabuf_sync_file
results: parsing output: 132/ for test: kms_big_fb
Done.