[73.903375] Initializing watchdogs
[73.903423]   /dev/watchdog0
[73.918104] [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]
[73.922812] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[73.924936] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[73.928629] [001/155] (960s left) kms_pm_lpsp (screens-disabled)
[75.058557] Starting subtest: screens-disabled
[75.062895] Subtest screens-disabled: SKIP (0.000s)
[75.120502] [002/155] (959s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[75.212254] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[75.216969] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[76.377262] [003/155] (958s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt)
[76.489751] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt
[76.494146] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[76.590951] [004/155] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[76.693087] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[76.697304] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[76.778904] [005/155] (957s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[76.879633] Starting subtest: 4-tiled-8bpp-rotate-270
[76.902642] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.023s)
[77.022631] [006/155] (957s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-onoff)
[77.120081] Starting subtest: hdr-2p-scndscrn-cur-indfb-onoff
[77.124686] Subtest hdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[77.211887] [007/155] (957s left) gem_mmap_offset (ptrace)
[77.268659] Starting subtest: ptrace
[77.270732] Starting dynamic subtest: smem0-wb
[77.281530] Dynamic subtest smem0-wb: SUCCESS (0.012s)
[77.291092] Starting dynamic subtest: smem0-wc
[77.301423] Dynamic subtest smem0-wc: SUCCESS (0.019s)
[77.308407] Starting dynamic subtest: smem0-uc
[77.320423] Dynamic subtest smem0-uc: SUCCESS (0.019s)
[77.322390] Subtest ptrace: SUCCESS (0.054s)
[77.434645] [008/155] (957s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-pwrite)
[77.539584] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-pwrite
[77.542935] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[77.641645] [009/155] (957s left) kms_flip (flip-vs-expired-vblank-interruptible)
[77.732530] Starting subtest: flip-vs-expired-vblank-interruptible
[77.736389] Starting dynamic subtest: A-eDP1
[86.408828] Dynamic subtest A-eDP1: SUCCESS (8.679s)
[86.420553] Starting dynamic subtest: B-eDP1
[90.257383] Dynamic subtest B-eDP1: FAIL (3.358s)
[90.266045] Starting dynamic subtest: C-eDP1
[98.492229] Dynamic subtest C-eDP1: SUCCESS (8.673s)
[98.503590] Starting dynamic subtest: D-eDP1
[107.116738] Dynamic subtest D-eDP1: SUCCESS (8.624s)
[107.118852] Subtest flip-vs-expired-vblank-interruptible: FAIL (29.344s)
[108.273237] [010/155] (926s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[108.385202] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[109.031848] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.648s)
[109.181238] [011/155] (925s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[109.279360] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[109.305562] Starting dynamic subtest: pipe-A-plane-0
[109.593789] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[109.602149] Starting dynamic subtest: pipe-A-plane-3
[109.827324] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[109.836650] Starting dynamic subtest: pipe-A-plane-5
[109.841284] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[110.944484] Starting dynamic subtest: pipe-B-plane-0
[111.247819] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[111.257320] Starting dynamic subtest: pipe-B-plane-3
[111.492246] Dynamic subtest pipe-B-plane-3: SUCCESS (0.244s)
[111.499828] Starting dynamic subtest: pipe-B-plane-5
[111.504216] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[111.801290] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.522s)
[112.608215] [012/155] (922s left) kms_chamelium_edid (vga-edid-read)
[112.985213] Subtest vga-edid-read: SKIP (0.000s)
[113.825593] [013/155] (921s left) kms_frontbuffer_tracking (hdr-rgb565-draw-render)
[113.931402] Starting subtest: hdr-rgb565-draw-render
[113.935882] Subtest hdr-rgb565-draw-render: SKIP (0.000s)
[114.022968] [014/155] (920s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[114.120323] Starting subtest: dsc-fractional-bpp-with-bpc
[114.151214] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s)
[114.197967] [015/155] (920s left) gem_ctx_param (invalid-size-set)
[114.252640] Starting subtest: invalid-size-set
[114.254972] Subtest invalid-size-set: SUCCESS (0.001s)
[114.362671] [016/155] (920s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-fullscreen)
[114.470065] Starting subtest: fbchdr-2p-primscrn-spr-indfb-fullscreen
[114.474138] Subtest fbchdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[114.551698] [017/155] (920s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[114.660920] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[121.979381] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.324s)
[122.121884] [018/155] (912s left) kms_pm_backlight (fade-with-dpms)
[122.224540] Starting subtest: fade-with-dpms
[124.333308] Starting dynamic subtest: eDP-1
[127.330619] Dynamic subtest eDP-1: SUCCESS (2.995s)
[127.333278] Subtest fade-with-dpms: SUCCESS (5.105s)
[128.220492] [019/155] (906s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[128.318425] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[135.391916] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.080s)
[135.511247] [020/155] (899s left) kms_psr (psr2-cursor-plane-move)
[135.598521] Starting subtest: psr2-cursor-plane-move
[135.600965] Starting dynamic subtest: eDP-1
[137.333780] Dynamic subtest eDP-1: SUCCESS (1.734s)
[137.335737] Subtest psr2-cursor-plane-move: SUCCESS (1.734s)
[138.205191] [021/155] (896s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[138.303423] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[138.305647] Starting dynamic subtest: pipe-A-eDP-1
[138.325484] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[138.334044] Starting dynamic subtest: pipe-B-eDP-1
[138.354255] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[138.361855] Starting dynamic subtest: pipe-C-eDP-1
[138.381352] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[138.388954] Starting dynamic subtest: pipe-D-eDP-1
[138.408811] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[138.410823] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.004s)
[140.593145] [022/155] (894s left) gem_exec_params (larger-than-life-batch)
[140.651384] Starting subtest: larger-than-life-batch
[142.958756] Subtest larger-than-life-batch: SUCCESS (2.306s)
[143.353400] [023/155] (891s left) sw_sync (alloc_fence)
[143.451793] Starting subtest: alloc_fence
[143.454317] Subtest alloc_fence: SUCCESS (0.000s)
[143.513126] [024/155] (891s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-blt)
[143.614223] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-blt
[143.618668] Subtest psrhdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[143.713768] [025/155] (891s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[143.805295] Starting subtest: fbcpsr-rgb565-draw-pwrite
[150.892160] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (7.094s)
[151.014702] [026/155] (884s left) kms_atomic (plane-invalid-params-fence)
[151.120084] Starting subtest: plane-invalid-params-fence
[151.122401] Starting dynamic subtest: pipe-A-eDP-1
[151.512092] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.392s)
[151.514144] Subtest plane-invalid-params-fence: SUCCESS (0.393s)
[152.347334] [027/155] (883s left) kms_big_fb (linear-16bpp-rotate-0)
[152.458550] Starting subtest: linear-16bpp-rotate-0
[153.837217] Subtest linear-16bpp-rotate-0: SUCCESS (1.379s)
[153.968352] [028/155] (881s left) gem_exec_schedule (submit-golden-slice)
[154.049723] Starting subtest: submit-golden-slice
[154.051876] Starting dynamic subtest: rcs0
[154.084485] Dynamic subtest rcs0: SUCCESS (0.035s)
[154.098039] Starting dynamic subtest: bcs0
[154.119191] Dynamic subtest bcs0: SUCCESS (0.034s)
[154.132644] Starting dynamic subtest: vcs0
[154.150551] Dynamic subtest vcs0: SUCCESS (0.031s)
[154.159211] Starting dynamic subtest: vcs1
[154.184234] Dynamic subtest vcs1: SUCCESS (0.033s)
[154.192097] Starting dynamic subtest: vecs0
[154.221530] Dynamic subtest vecs0: SUCCESS (0.037s)
[154.229775] Starting dynamic subtest: ccs0
[154.252078] Dynamic subtest ccs0: SUCCESS (0.030s)
[154.254139] Subtest submit-golden-slice: SUCCESS (0.203s)
[155.431486] [029/155] (880s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[155.528818] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt
[155.533109] Subtest psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[155.623487] [030/155] (879s left) perf_pmu (busy-accuracy-2)
[155.660603] Starting subtest: busy-accuracy-2
[155.662946] Starting dynamic subtest: rcs0
[158.706465] Dynamic subtest rcs0: SUCCESS (3.043s)
[158.718981] Starting dynamic subtest: bcs0
[161.812819] Dynamic subtest bcs0: SUCCESS (3.056s)
[161.821460] Starting dynamic subtest: vcs0
[164.855458] Dynamic subtest vcs0: SUCCESS (3.042s)
[164.865500] Starting dynamic subtest: vcs1
[167.905717] Dynamic subtest vcs1: SUCCESS (3.046s)
[167.916691] Starting dynamic subtest: vecs0
[170.950574] Dynamic subtest vecs0: SUCCESS (3.043s)
[170.960395] Starting dynamic subtest: ccs0
[174.006947] Dynamic subtest ccs0: SUCCESS (3.054s)
[174.009421] Subtest busy-accuracy-2: SUCCESS (18.294s)
[174.072762] [031/155] (861s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[174.203093] Starting subtest: short-flip-before-cursor-toggle
[175.127142] Subtest short-flip-before-cursor-toggle: SUCCESS (0.923s)
[175.980827] [032/155] (859s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[176.074519] Starting subtest: flip-vs-dpms-off-vs-modeset
[176.077074] Starting dynamic subtest: A-eDP1
[179.730242] Dynamic subtest A-eDP1: SUCCESS (3.653s)
[179.739935] Starting dynamic subtest: B-eDP1
[182.954694] Dynamic subtest B-eDP1: SUCCESS (3.223s)
[182.964471] Starting dynamic subtest: C-eDP1
[186.281652] Dynamic subtest C-eDP1: SUCCESS (3.326s)
[186.290745] Starting dynamic subtest: D-eDP1
[189.582791] Dynamic subtest D-eDP1: SUCCESS (3.299s)
[189.585079] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.507s)
[190.391921] [033/155] (845s left) gem_userptr_blits (sync-unmap-cycles)
[190.463768] Starting subtest: sync-unmap-cycles
[195.842215] Subtest sync-unmap-cycles: SUCCESS (5.379s)
[195.963840] [034/155] (839s left) sysfs_heartbeat_interval (idempotent)
[196.020170] Starting subtest: idempotent
[196.022011] Starting dynamic subtest: vecs0
[196.024097] Dynamic subtest vecs0: SUCCESS (0.001s)
[196.035849] Starting dynamic subtest: ccs0
[196.037469] Dynamic subtest ccs0: SUCCESS (0.002s)
[196.045882] Starting dynamic subtest: vcs0
[196.047855] Dynamic subtest vcs0: SUCCESS (0.000s)
[196.056143] Starting dynamic subtest: bcs0
[196.058097] Dynamic subtest bcs0: SUCCESS (0.002s)
[196.066057] Starting dynamic subtest: rcs0
[196.067702] Dynamic subtest rcs0: SUCCESS (0.002s)
[196.078325] Starting dynamic subtest: vcs1
[196.079929] Dynamic subtest vcs1: SUCCESS (0.000s)
[196.081565] Subtest idempotent: SUCCESS (0.012s)
[196.115739] [035/155] (839s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[196.214053] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[202.817054] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.605s)
[202.962614] [036/155] (832s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-pgflip-blt)
[203.060988] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-pgflip-blt
[203.065515] Subtest fbcpsrhdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[203.164416] [037/155] (832s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[203.264581] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[203.268765] Subtest fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[203.346723] [038/155] (832s left) gem_ctx_persistence (heartbeat-hostile)
[203.413127] Starting subtest: heartbeat-hostile
[203.417965] Subtest heartbeat-hostile: SKIP (0.000s)
[203.520238] [039/155] (832s left) kms_plane_scaling (planes-downscale-factor-0-75)
[203.607180] Starting subtest: planes-downscale-factor-0-75
[203.609486] Starting dynamic subtest: pipe-A
[203.630059] Dynamic subtest pipe-A: SKIP (0.018s)
[203.639808] Starting dynamic subtest: pipe-B
[203.662724] Dynamic subtest pipe-B: SKIP (0.032s)
[203.672399] Starting dynamic subtest: pipe-C
[203.695410] Dynamic subtest pipe-C: SKIP (0.032s)
[203.704692] Starting dynamic subtest: pipe-D
[203.726369] Dynamic subtest pipe-D: SKIP (0.032s)
[203.730713] Subtest planes-downscale-factor-0-75: SKIP (0.117s)
[203.837086] [040/155] (832s left) kms_frontbuffer_tracking (psrhdr-suspend)
[203.930465] Starting subtest: psrhdr-suspend
[203.934191] Subtest psrhdr-suspend: SKIP (0.000s)
[204.027395] [041/155] (831s left) kms_frontbuffer_tracking (fbcpsrhdr-modesetfrombusy)
[204.132878] Starting subtest: fbcpsrhdr-modesetfrombusy
[204.136260] Subtest fbcpsrhdr-modesetfrombusy: SKIP (0.000s)
[204.235348] [042/155] (831s left) syncobj_wait (single-wait-signaled)
[204.291510] Starting subtest: single-wait-signaled
[204.293479] Subtest single-wait-signaled: SUCCESS (0.000s)
[204.383607] [043/155] (831s left) gem_tiled_partial_pwrite_pread (writes)
[204.448840] Subtest writes: SKIP (0.000s)
[204.533851] [044/155] (831s left) syncobj_basic (bad-flags-fd-to-handle)
[204.592250] Starting subtest: bad-flags-fd-to-handle
[204.594079] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[204.695165] [045/155] (831s left) kms_vblank (wait-busy-hang)
[204.789537] Starting subtest: wait-busy-hang
[204.791463] Starting dynamic subtest: pipe-A-eDP-1
[231.053858] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.262s)
[231.068586] Starting dynamic subtest: pipe-D-eDP-1
[256.070770] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.011s)
[256.072842] Subtest wait-busy-hang: SUCCESS (51.278s)
[256.901463] [046/155] (779s left) syncobj_timeline (invalid-query-one-illegal-handle)
[256.973071] Starting subtest: invalid-query-one-illegal-handle
[256.975536] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[257.086266] [047/155] (779s left) syncobj_basic (bad-flags-handle-to-fd)
[257.140478] Starting subtest: bad-flags-handle-to-fd
[257.142687] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[257.254973] [048/155] (778s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[257.361786] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[261.014651] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.658s)
[262.195950] [049/155] (774s left) gem_ctx_param (invalid-ctx-set)
[262.245838] Starting subtest: invalid-ctx-set
[262.248273] Subtest invalid-ctx-set: SUCCESS (0.001s)
[262.353767] [050/155] (773s left) syncobj_wait (wait-all-complex)
[262.398688] Starting subtest: wait-all-complex
[262.613495] Subtest wait-all-complex: SUCCESS (0.214s)
[262.691248] [051/155] (773s left) kms_cursor_crc (cursor-sliding-32x10)
[262.848981] Starting subtest: cursor-sliding-32x10
[262.896227] Subtest cursor-sliding-32x10: SKIP (0.043s)
[263.168588] [052/155] (773s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[263.260492] Starting subtest: y-tiled-64bpp-rotate-90
[263.264676] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[263.353671] [053/155] (773s left) gen9_exec_parse (batch-invalid-length)
[263.418596] Subtest batch-invalid-length: SKIP (0.000s)
[263.491570] [054/155] (772s left) gem_exec_whisper (basic-sync-all)
[263.552613] Starting subtest: basic-sync-all
[270.017405] Subtest basic-sync-all: SUCCESS (6.464s)
[270.201875] [055/155] (766s left) kms_universal_plane (universal-plane-pageflip-windowed)
[270.316020] Starting subtest: universal-plane-pageflip-windowed
[270.317926] Starting dynamic subtest: pipe-A-eDP-1
[270.879576] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.563s)
[270.890219] Starting dynamic subtest: pipe-B-eDP-1
[272.097193] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.218s)
[272.107731] Starting dynamic subtest: pipe-C-eDP-1
[273.309654] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.208s)
[273.321581] Starting dynamic subtest: pipe-D-eDP-1
[274.547538] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.236s)
[274.549682] Subtest universal-plane-pageflip-windowed: SUCCESS (4.231s)
[275.417280] [056/155] (761s left) gem_mmap_offset (blt-coherency)
[275.475249] Starting subtest: blt-coherency
[275.482858] Subtest blt-coherency: SUCCESS (0.009s)
[275.597329] [057/155] (760s left) kms_psr (psr-primary-mmap-gtt)
[275.681245] Starting subtest: psr-primary-mmap-gtt
[275.683528] Starting dynamic subtest: eDP-1
[277.113256] Dynamic subtest eDP-1: SKIP (1.429s)
[277.118977] Subtest psr-primary-mmap-gtt: SKIP (1.432s)
[277.290934] [058/155] (759s left) kms_psr (fbc-pr-cursor-render)
[277.387962] Starting subtest: fbc-pr-cursor-render
[277.392108] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[277.458046] [059/155] (759s left) i915_pm_rps (thresholds-idle)
[277.515072] Starting subtest: thresholds-idle
[277.519601] Subtest thresholds-idle: SKIP (0.001s)
[277.610784] [060/155] (759s left) kms_chamelium_color (ctm-0-75)
[277.709365] Subtest ctm-0-75: SKIP (0.000s)
[277.752952] [061/155] (758s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[277.844940] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[277.847192] Starting dynamic subtest: pipe-A-eDP-1
[277.869599] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[277.881442] Starting dynamic subtest: pipe-B-eDP-1
[277.902487] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[277.912100] Starting dynamic subtest: pipe-C-eDP-1
[277.932267] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[277.940645] Starting dynamic subtest: pipe-D-eDP-1
[277.961455] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[277.965576] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[280.104350] [062/155] (756s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[280.199066] Starting subtest: primary-y-tiled-reflect-x-270
[280.203650] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[280.270151] [063/155] (756s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[280.381725] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[280.386452] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[280.481383] [064/155] (756s left) gem_shrink (reclaim)
[280.553884] Starting subtest: reclaim
[283.005796] Subtest reclaim: SUCCESS (2.452s)
[283.176221] [065/155] (753s left) gem_mmap_gtt (close-race)
[283.227815] Subtest close-race: SKIP (0.000s)
[283.287246] [066/155] (753s left) gem_exec_nop (basic-parallel)
[283.355614] Starting subtest: basic-parallel
[299.270395] Subtest basic-parallel: SUCCESS (15.923s)
[299.491110] [067/155] (737s left) gem_exec_schedule (u-submit-late-slice)
[299.557975] Starting subtest: u-submit-late-slice
[299.560105] Starting dynamic subtest: rcs0
[299.603468] Dynamic subtest rcs0: SUCCESS (0.054s)
[299.614348] Starting dynamic subtest: bcs0
[299.651511] Dynamic subtest bcs0: SUCCESS (0.047s)
[299.662431] Starting dynamic subtest: vcs0
[299.692436] Dynamic subtest vcs0: SUCCESS (0.040s)
[299.701994] Starting dynamic subtest: vcs1
[299.739711] Dynamic subtest vcs1: SUCCESS (0.046s)
[299.749035] Starting dynamic subtest: vecs0
[299.784399] Dynamic subtest vecs0: SUCCESS (0.044s)
[299.793180] Starting dynamic subtest: ccs0
[299.831163] Dynamic subtest ccs0: SUCCESS (0.046s)
[299.833759] Subtest u-submit-late-slice: SUCCESS (0.282s)
[301.422832] [068/155] (735s left) fbdev (write)
[301.472602] Starting subtest: write
[301.837781] Subtest write: SUCCESS (0.363s)
[301.913056] [069/155] (735s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-move)
[302.023449] Starting subtest: fbchdr-1p-primscrn-cur-indfb-move
[302.027853] Subtest fbchdr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[302.116386] [070/155] (734s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-onoff)
[302.212554] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-onoff
[302.216792] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[302.326542] [071/155] (734s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[302.450466] Starting subtest: cursor-vs-flip-varying-size
[333.637605] Subtest cursor-vs-flip-varying-size: SUCCESS (31.183s)
[334.444910] [072/155] (702s left) gem_ctx_persistence (engines-mixed-process)
[334.509289] Starting subtest: engines-mixed-process
[334.511758] Starting dynamic subtest: rcs0
[336.332176] Dynamic subtest rcs0: SUCCESS (1.823s)
[336.344136] Starting dynamic subtest: bcs0
[338.294255] Dynamic subtest bcs0: SUCCESS (1.959s)
[338.303852] Starting dynamic subtest: vcs0
[340.308095] Dynamic subtest vcs0: SUCCESS (2.015s)
[340.320200] Starting dynamic subtest: vcs1
[342.294840] Dynamic subtest vcs1: SUCCESS (1.985s)
[342.306962] Starting dynamic subtest: vecs0
[344.332863] Dynamic subtest vecs0: SUCCESS (2.036s)
[344.345269] Starting dynamic subtest: ccs0
[346.324475] Dynamic subtest ccs0: SUCCESS (1.990s)
[346.326942] Subtest engines-mixed-process: SUCCESS (11.816s)
[346.404531] [073/155] (690s left) i915_drm_fdinfo (busy-hang)
[346.445071] Starting subtest: busy-hang
[346.447189] Starting dynamic subtest: rcs0
[346.483156] Dynamic subtest rcs0: SKIP (0.037s)
[346.493939] Starting dynamic subtest: bcs0
[346.497843] Dynamic subtest bcs0: SKIP (0.001s)
[346.507058] Starting dynamic subtest: vcs0
[346.511111] Dynamic subtest vcs0: SKIP (0.001s)
[346.520359] Starting dynamic subtest: vcs1
[346.524442] Dynamic subtest vcs1: SKIP (0.001s)
[346.533538] Starting dynamic subtest: vecs0
[346.537576] Dynamic subtest vecs0: SKIP (0.001s)
[346.546340] Starting dynamic subtest: ccs0
[346.550235] Dynamic subtest ccs0: SKIP (0.001s)
[346.554087] Subtest busy-hang: SKIP (0.047s)
[346.589519] [074/155] (690s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[346.698540] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[346.702793] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[346.788753] [075/155] (690s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[346.834288] Starting subtest: etime-multi-wait-all-submitted-signaled
[346.937914] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.102s)
[347.014748] [076/155] (690s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[347.104321] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[347.108790] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s)
[347.179291] [077/155] (690s left) gem_exec_schedule (pi-distinct-iova)
[347.360883] Starting subtest: pi-distinct-iova
[347.363331] Starting dynamic subtest: rcs0
[347.441338] Dynamic subtest rcs0: SUCCESS (0.083s)
[347.450971] Starting dynamic subtest: vcs0
[347.498329] Dynamic subtest vcs0: SUCCESS (0.055s)
[347.510985] Starting dynamic subtest: vcs1
[347.558317] Dynamic subtest vcs1: SUCCESS (0.059s)
[347.569887] Starting dynamic subtest: vecs0
[347.617237] Dynamic subtest vecs0: SUCCESS (0.058s)
[347.630479] Starting dynamic subtest: ccs0
[347.692924] Dynamic subtest ccs0: SUCCESS (0.073s)
[347.695857] Subtest pi-distinct-iova: SUCCESS (0.337s)
[349.412066] [078/155] (687s left) gem_exec_flush (basic-wb-set-default)
[349.480762] Starting subtest: basic-wb-set-default
[354.965690] Subtest basic-wb-set-default: SUCCESS (5.454s)
[355.136816] [079/155] (682s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[355.189162] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[355.191417] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[355.297688] [080/155] (682s left) kms_color (invalid-gamma-lut-sizes)
[355.403714] Starting subtest: invalid-gamma-lut-sizes
[355.406108] Starting dynamic subtest: pipe-A
[355.696645] Dynamic subtest pipe-A: SUCCESS (0.292s)
[355.708800] Starting dynamic subtest: pipe-B
[355.711234] Dynamic subtest pipe-B: SUCCESS (0.000s)
[355.721378] Starting dynamic subtest: pipe-C
[355.723800] Dynamic subtest pipe-C: SUCCESS (0.000s)
[355.733399] Starting dynamic subtest: pipe-D
[355.735398] Dynamic subtest pipe-D: SUCCESS (0.000s)
[355.737280] Subtest invalid-gamma-lut-sizes: SUCCESS (0.296s)
[356.585928] [081/155] (680s left) gem_exec_reloc (basic-cpu)
[356.643727] Subtest basic-cpu: SKIP (0.000s)
[356.702986] [082/155] (680s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[356.803860] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[360.674753] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (3.876s)
[361.868930] [083/155] (675s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[361.985809] Starting subtest: cursorA-vs-flipA-varying-size
[373.112442] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.124s)
[373.999865] [084/155] (663s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[374.054528] Starting subtest: invalid-multi-wait-all-unsubmitted
[374.056948] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[374.160363] [085/155] (663s left) kms_setmode (invalid-clone-single-crtc)
[374.213778] Starting subtest: invalid-clone-single-crtc
[374.220287] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[374.329748] [086/155] (663s left) gem_softpin (evict-single-offset)
[374.392257] Starting subtest: evict-single-offset
[399.237239] Subtest evict-single-offset: SUCCESS (24.841s)
[399.321306] [087/155] (638s left) prime_vgem (basic-blt)
[399.516246] Starting subtest: basic-blt
[399.541440] Subtest basic-blt: SUCCESS (0.028s)
[399.682980] [FACT prime_vgem (basic-blt)] new: kernel.kmod_is_loaded.vgem: true
[399.685854] [088/155] (638s left) kms_lease (lease-again)
[399.785923] Starting subtest: lease-again
[399.788201] Starting dynamic subtest: pipe-A-eDP-1
[399.790382] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s)
[399.800771] Starting dynamic subtest: pipe-B-eDP-1
[399.802998] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[399.812215] Starting dynamic subtest: pipe-C-eDP-1
[399.814064] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[399.823028] Starting dynamic subtest: pipe-D-eDP-1
[399.824838] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[399.826704] Subtest lease-again: SUCCESS (0.016s)
[399.918942] [089/155] (637s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[400.030135] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[400.034319] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[400.145205] [090/155] (637s left) gem_userptr_blits (mmap-offset-banned)
[400.208865] Starting subtest: mmap-offset-banned
[400.211269] Starting dynamic subtest: wb
[400.213488] Dynamic subtest wb: SUCCESS (0.000s)
[400.226042] Starting dynamic subtest: wc
[400.227956] Dynamic subtest wc: SUCCESS (0.000s)
[400.237274] Starting dynamic subtest: uc
[400.239199] Dynamic subtest uc: SUCCESS (0.000s)
[400.241065] Subtest mmap-offset-banned: SUCCESS (0.002s)
[400.329130] [091/155] (637s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[400.433046] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[400.436508] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[400.540929] [092/155] (637s left) kms_frontbuffer_tracking (hdr-1p-primscrn-shrfb-plflip-blt)
[400.631980] Starting subtest: hdr-1p-primscrn-shrfb-plflip-blt
[400.635523] Subtest hdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[400.720426] [093/155] (637s left) kms_chamelium_hpd (dp-hpd-fast)
[401.106238] Subtest dp-hpd-fast: SKIP (0.000s)
[401.897682] [094/155] (636s left) gem_tiling_max_stride
[402.027843] [095/155] (636s left) api_intel_bb (reset-bb)
[402.089801] Starting subtest: reset-bb
[402.095730] Subtest reset-bb: SUCCESS (0.007s)
[402.223857] [096/155] (635s left) i915_hangman (gt-engine-error)
[402.284684] Starting subtest: gt-engine-error
[402.286928] Starting dynamic subtest: rcs0
[404.261363] Dynamic subtest rcs0: SUCCESS (1.975s)
[404.274529] Starting dynamic subtest: bcs0
[406.244201] Dynamic subtest bcs0: SUCCESS (1.980s)
[406.258408] Starting dynamic subtest: vcs0
[408.291337] Dynamic subtest vcs0: SUCCESS (2.043s)
[408.304036] Starting dynamic subtest: vcs1
[410.275903] Dynamic subtest vcs1: SUCCESS (1.981s)
[410.293516] Starting dynamic subtest: vecs0
[412.260228] Dynamic subtest vecs0: SUCCESS (1.982s)
[412.271939] Starting dynamic subtest: ccs0
[414.243809] Dynamic subtest ccs0: SUCCESS (1.981s)
[414.246944] Subtest gt-engine-error: SUCCESS (11.960s)
[414.383236] [097/155] (623s left) kms_selftest (drm_dp_mst_helper)
[414.424892] Starting subtest: drm_dp_mst_helper
[414.433873] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[414.544598] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.111s)
[414.554381] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[414.644745] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.099s)
[414.654999] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[414.748070] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.102s)
[414.750397] Subtest drm_dp_mst_helper: SUCCESS (0.323s)
[414.887040] [098/155] (623s left) gem_exec_capture (capture-recoverable)
[414.945910] Starting subtest: capture-recoverable
[414.950372] Subtest capture-recoverable: SUCCESS (0.005s)
[415.078131] [099/155] (623s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[415.187961] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[415.192408] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[415.261313] [100/155] (623s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[415.364296] Starting subtest: psr-rgb565-draw-mmap-gtt
[415.368855] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[415.465804] [101/155] (622s left) kms_psr (fbc-psr2-dpms)
[415.557209] Starting subtest: fbc-psr2-dpms
[415.559121] Starting dynamic subtest: eDP-1
[415.562752] Dynamic subtest eDP-1: SKIP (0.000s)
[415.566034] Subtest fbc-psr2-dpms: SKIP (0.001s)
[415.632474] [102/155] (622s left) kms_frontbuffer_tracking (fbc-tiling-y)
[415.726061] Starting subtest: fbc-tiling-y
[415.729401] Subtest fbc-tiling-y: SKIP (0.000s)
[415.817400] [103/155] (622s left) kms_prop_blob (invalid-get-prop)
[415.881043] Starting subtest: invalid-get-prop
[415.882955] Subtest invalid-get-prop: SUCCESS (0.000s)
[415.978866] [104/155] (622s left) kms_addfb_basic (bad-pitch-128)
[416.030561] Starting subtest: bad-pitch-128
[416.032600] Subtest bad-pitch-128: SUCCESS (0.000s)
[416.170736] [105/155] (622s left) api_intel_allocator (execbuf-with-allocator)
[416.227620] Starting subtest: execbuf-with-allocator
[416.229754] Subtest execbuf-with-allocator: SUCCESS (0.005s)
[416.347796] [106/155] (622s left) syncobj_wait (invalid-signal-zero-handles)
[416.399403] Starting subtest: invalid-signal-zero-handles
[416.401280] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[416.512158] [107/155] (622s left) kms_invalid_mode (bad-vtotal)
[416.600765] Starting subtest: bad-vtotal
[416.602681] Starting dynamic subtest: pipe-A-eDP-1
[416.886703] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[416.898062] Starting dynamic subtest: pipe-B-eDP-1
[416.900024] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[416.910289] Starting dynamic subtest: pipe-C-eDP-1
[416.912547] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[416.922423] Starting dynamic subtest: pipe-D-eDP-1
[416.924706] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[416.927112] Subtest bad-vtotal: SUCCESS (0.292s)
[417.751632] [108/155] (620s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[417.802072] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[417.804241] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[417.898621] [109/155] (620s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[417.985884] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[417.990504] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[418.055802] [110/155] (620s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-render)
[418.148438] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-render
[418.152691] Subtest fbchdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[418.248318] [111/155] (620s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[418.766859] Starting subtest: syncobj-stationary-timeline-chain-engines
[418.891607] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.125s)
[420.392087] [112/155] (618s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[420.484820] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[424.955184] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.476s)
[426.155906] [113/155] (612s left) kms_properties (colorop-properties-legacy)
[426.248678] Starting subtest: colorop-properties-legacy
[426.251244] Starting dynamic subtest: pipe-A-eDP-1
[426.642282] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.393s)
[426.652736] Starting dynamic subtest: pipe-B-eDP-1
[427.698105] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.054s)
[427.709440] Starting dynamic subtest: pipe-C-eDP-1
[428.735855] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.037s)
[428.747290] Starting dynamic subtest: pipe-D-eDP-1
[429.785600] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.049s)
[429.787899] Subtest colorop-properties-legacy: SUCCESS (3.540s)
[430.669699] [114/155] (608s left) gem_exec_reloc (basic-cpu-noreloc)
[430.737288] Subtest basic-cpu-noreloc: SKIP (0.000s)
[430.817857] [115/155] (608s left) gem_userptr_blits (dmabuf-sync)
[430.887159] Starting subtest: dmabuf-sync
[430.891792] Subtest dmabuf-sync: SKIP (0.004s)
[431.022712] [116/155] (607s left) syncobj_timeline (single-wait-all-signaled)
[431.078212] Starting subtest: single-wait-all-signaled
[431.080082] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[431.169854] [117/155] (607s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[431.271198] Starting subtest: async-flip-with-page-flip-events-tiled
[431.640339] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[434.495229] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.802s)
[434.510026] Starting dynamic subtest: pipe-A-eDP-1-4
[436.680641] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.184s)
[436.696742] Starting dynamic subtest: pipe-A-eDP-1-4
[438.639753] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[438.650117] Starting dynamic subtest: pipe-A-eDP-1-x
[440.880935] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.188s)
[441.198443] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[444.025698] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.785s)
[444.039085] Starting dynamic subtest: pipe-B-eDP-1-4
[446.211707] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.184s)
[446.224983] Starting dynamic subtest: pipe-B-eDP-1-4
[448.170081] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[448.180769] Starting dynamic subtest: pipe-B-eDP-1-x
[450.411537] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[450.727891] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[453.566410] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.790s)
[453.578301] Starting dynamic subtest: pipe-C-eDP-1-4
[455.732277] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.172s)
[455.743684] Starting dynamic subtest: pipe-C-eDP-1-4
[457.691278] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[457.702800] Starting dynamic subtest: pipe-C-eDP-1-x
[459.921592] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[460.238298] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[463.036406] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.807s)
[463.048983] Starting dynamic subtest: pipe-D-eDP-1-4
[465.222342] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.184s)
[465.235146] Starting dynamic subtest: pipe-D-eDP-1-4
[467.232343] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[467.247641] Starting dynamic subtest: pipe-D-eDP-1-x
[469.475476] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.190s)
[469.477561] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.152s)
[470.617068] [118/155] (568s left) kms_psr (fbc-psr-primary-page-flip)
[470.707233] Starting subtest: fbc-psr-primary-page-flip
[470.709356] Starting dynamic subtest: eDP-1
[470.713200] Dynamic subtest eDP-1: SKIP (0.000s)
[470.717144] Subtest fbc-psr-primary-page-flip: SKIP (0.001s)
[470.779728] [119/155] (568s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-move)
[470.881358] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-move
[470.885417] Subtest psrhdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[470.995503] [120/155] (568s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[471.108516] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[472.142568] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.034s)
[472.268195] [121/155] (566s left) kms_plane_alpha_blend (alpha-basic)
[472.356197] Starting subtest: alpha-basic
[472.643040] Starting dynamic subtest: pipe-A-eDP-1
[474.591202] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.945s)
[474.619324] Starting dynamic subtest: pipe-D-eDP-1
[477.291715] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.682s)
[477.294197] Subtest alpha-basic: SUCCESS (4.937s)
[478.186932] [122/155] (561s left) gem_create (create-massive)
[478.243483] Starting subtest: create-massive
[478.245685] Subtest create-massive: SUCCESS (0.000s)
[478.427886] [123/155] (560s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-mmap-wc)
[478.523749] Starting subtest: psrhdr-rgb101010-draw-mmap-wc
[478.527774] Subtest psrhdr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[478.618549] [124/155] (560s left) gem_mmap_gtt (basic-small-copy-xy)
[478.674127] Subtest basic-small-copy-XY: SKIP (0.000s)
[478.740406] [125/155] (560s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[478.798957] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[478.803996] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[478.985098] [126/155] (560s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-shrfb-plflip-blt)
[479.094257] Starting subtest: fbchdr-2p-scndscrn-shrfb-plflip-blt
[479.098494] Subtest fbchdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[479.194930] [127/155] (560s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[479.287397] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[479.289670] Starting dynamic subtest: pipe-A-eDP-1
[479.312601] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[479.324655] Starting dynamic subtest: pipe-B-eDP-1
[479.345607] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[479.356037] Starting dynamic subtest: pipe-C-eDP-1
[479.377744] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[479.390836] Starting dynamic subtest: pipe-D-eDP-1
[479.413026] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[479.417301] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[481.527220] [128/155] (557s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[481.629415] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[481.633421] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[481.732613] [129/155] (557s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[482.002057] Starting subtest: cursor-rapid-movement-256x85
[482.060231] Subtest cursor-rapid-movement-256x85: SKIP (0.052s)
[482.239989] [130/155] (557s left) dumb_buffer (create-valid-dumb)
[482.291081] Starting subtest: create-valid-dumb
[482.293309] Subtest create-valid-dumb: SUCCESS (0.000s)
[482.386479] [131/155] (557s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[482.487939] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[489.454895] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.968s)
[489.594896] [132/155] (550s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-pwrite)
[489.692756] Starting subtest: fbchdr-rgb565-draw-pwrite
[489.696713] Subtest fbchdr-rgb565-draw-pwrite: SKIP (0.000s)
[489.776216] [133/155] (549s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[489.879425] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[489.883582] Subtest hdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[489.986583] [134/155] (549s left) perf_pmu (multi-client)
[490.028395] Starting subtest: multi-client
[490.030806] Starting dynamic subtest: rcs0
[491.076763] Dynamic subtest rcs0: SUCCESS (1.049s)
[491.087787] Starting dynamic subtest: bcs0
[492.129090] Dynamic subtest bcs0: SUCCESS (1.049s)
[492.140781] Starting dynamic subtest: vcs0
[493.181451] Dynamic subtest vcs0: SUCCESS (1.049s)
[493.193083] Starting dynamic subtest: vcs1
[494.333412] Dynamic subtest vcs1: SUCCESS (1.147s)
[494.346206] Starting dynamic subtest: vecs0
[496.315689] Dynamic subtest vecs0: SUCCESS (1.980s)
[496.329228] Starting dynamic subtest: ccs0
[498.301254] Dynamic subtest ccs0: SUCCESS (1.983s)
[498.303819] Subtest multi-client: SUCCESS (8.276s)
[498.417566] [135/155] (541s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[498.526690] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[498.531067] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[498.634314] [136/155] (541s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[498.739737] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[498.743842] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[498.832625] [137/155] (540s left) gem_linear_blits (normal)
[499.006962] Starting subtest: normal
[502.620501] Subtest normal: SUCCESS (3.616s)
[502.766272] [138/155] (537s left) syncobj_basic (bad-fd-to-handle)
[502.871127] Starting subtest: bad-fd-to-handle
[502.873405] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[502.990958] [139/155] (536s left) kms_cursor_crc (cursor-onscreen-64x21)
[503.210817] Starting subtest: cursor-onscreen-64x21
[503.258784] Subtest cursor-onscreen-64x21: SKIP (0.042s)
[503.504730] [140/155] (536s left) kms_addfb_basic (addfb25-bad-modifier)
[503.596451] Starting subtest: addfb25-bad-modifier
[503.598732] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[503.717632] [141/155] (536s left) kms_content_protection (legacy)
[503.858743] Starting subtest: legacy
[503.862541] Subtest legacy: SKIP (0.000s)
[503.994756] [142/155] (536s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[504.118090] Starting subtest: verify-pxp-execution-after-suspend-resume
[511.299603] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.179s)
[511.446822] [143/155] (528s left) gem_exec_balancer (invalid-bonds)
[511.523724] Starting subtest: invalid-bonds
[511.528987] Subtest invalid-bonds: SKIP (0.000s)
[511.826037] [144/155] (528s left) i915_pm_rpm (gem-mmap-type)
[513.485466] Starting subtest: gem-mmap-type
[513.487760] Starting dynamic subtest: wb-smem0
[517.469372] Dynamic subtest wb-smem0: SUCCESS (3.988s)
[517.481989] Starting dynamic subtest: wc-smem0
[520.357906] Dynamic subtest wc-smem0: SUCCESS (2.887s)
[520.369219] Starting dynamic subtest: uc-smem0
[523.574611] Dynamic subtest uc-smem0: SUCCESS (3.216s)
[523.576984] Subtest gem-mmap-type: SUCCESS (10.095s)
[523.689112] [145/155] (516s left) gem_exec_reloc (basic-write-gtt-active)
[523.744526] Subtest basic-write-gtt-active: SKIP (0.000s)
[523.826156] [146/155] (516s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[523.935182] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[523.939147] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[524.026481] [147/155] (516s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-render)
[524.117712] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-render
[524.121731] Subtest hdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[524.229878] [148/155] (516s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[524.324309] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[524.328567] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[524.403302] [149/155] (515s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[524.496405] Starting subtest: fbc-dirtyfb-ioctl
[524.498645] Starting dynamic subtest: A-eDP-1
[527.087165] Dynamic subtest A-eDP-1: SUCCESS (2.592s)
[527.089636] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.593s)
[527.988600] [150/155] (512s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-render)
[528.080607] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-render
[528.084667] Subtest psrhdr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[528.186458] [151/155] (512s left) gem_exec_params (invalid-fence-in)
[528.250790] Starting subtest: invalid-fence-in
[528.253152] Subtest invalid-fence-in: SUCCESS (0.000s)
[528.369453] [152/155] (512s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[528.477327] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[528.481697] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[528.576620] [153/155] (511s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[528.677796] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[528.681846] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[528.773069] [154/155] (511s left) kms_flip (flip-vs-panning)
[528.874097] Starting subtest: flip-vs-panning
[528.876362] Starting dynamic subtest: A-eDP1
[537.604496] Dynamic subtest A-eDP1: SUCCESS (8.729s)
[537.618802] Starting dynamic subtest: B-eDP1
[546.338318] Dynamic subtest B-eDP1: SUCCESS (8.731s)
[546.352945] Starting dynamic subtest: C-eDP1
[555.059650] Dynamic subtest C-eDP1: SUCCESS (8.720s)
[555.073084] Starting dynamic subtest: D-eDP1
[563.791999] Dynamic subtest D-eDP1: SUCCESS (8.732s)
[563.795963] Subtest flip-vs-panning: SUCCESS (34.921s)
[564.961575] [155/155] (475s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[565.054116] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[565.058225] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[565.139794] Closing watchdogs
results: parsing output: 0/ for test: kms_pm_lpsp
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gem_mmap_offset
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_flip
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: kms_plane
results: parsing output: 11/ for test: kms_chamelium_edid
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_dsc
results: parsing output: 14/ for test: gem_ctx_param
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_pm_backlight
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: gem_exec_params
results: parsing output: 22/ for test: sw_sync
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_atomic
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: gem_exec_schedule
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: perf_pmu
results: parsing output: 30/ for test: kms_cursor_legacy
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: gem_userptr_blits
results: parsing output: 33/ for test: sysfs_heartbeat_interval
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_ctx_persistence
results: parsing output: 38/ for test: kms_plane_scaling
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: syncobj_wait
results: parsing output: 42/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 43/ for test: syncobj_basic
results: parsing output: 44/ for test: kms_vblank
results: parsing output: 45/ for test: syncobj_timeline
results: parsing output: 46/ for test: syncobj_basic
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_ctx_param
results: parsing output: 49/ for test: syncobj_wait
results: parsing output: 50/ for test: kms_cursor_crc
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: gen9_exec_parse
results: parsing output: 53/ for test: gem_exec_whisper
results: parsing output: 54/ for test: kms_universal_plane
results: parsing output: 55/ for test: gem_mmap_offset
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: i915_pm_rps
results: parsing output: 59/ for test: kms_chamelium_color
results: parsing output: 60/ for test: kms_ccs
results: parsing output: 61/ for test: kms_rotation_crc
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_shrink
results: parsing output: 64/ for test: gem_mmap_gtt
results: parsing output: 65/ for test: gem_exec_nop
results: parsing output: 66/ for test: gem_exec_schedule
results: parsing output: 67/ for test: fbdev
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_cursor_legacy
results: parsing output: 71/ for test: gem_ctx_persistence
results: parsing output: 72/ for test: i915_drm_fdinfo
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: syncobj_timeline
results: parsing output: 75/ for test: kms_plane
results: parsing output: 76/ for test: gem_exec_schedule
results: parsing output: 77/ for test: gem_exec_flush
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: kms_color
results: parsing output: 80/ for test: gem_exec_reloc
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_cursor_legacy
results: parsing output: 83/ for test: syncobj_wait
results: parsing output: 84/ for test: kms_setmode
results: parsing output: 85/ for test: gem_softpin
results: parsing output: 86/ for test: prime_vgem
results: parsing output: 87/ for test: kms_lease
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_userptr_blits
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_chamelium_hpd
results: parsing output: 93/ for test: gem_tiling_max_stride
results: parsing output: 94/ for test: api_intel_bb
results: parsing output: 95/ for test: i915_hangman
results: parsing output: 96/ for test: kms_selftest
results: parsing output: 97/ for test: gem_exec_capture
results: parsing output: 98/ for test: kms_flip_scaled_crc
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_prop_blob
results: parsing output: 103/ for test: kms_addfb_basic
results: parsing output: 104/ for test: api_intel_allocator
results: parsing output: 105/ for test: syncobj_wait
results: parsing output: 106/ for test: kms_invalid_mode
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: kms_flip_scaled_crc
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_exec_fence
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_properties
results: parsing output: 113/ for test: gem_exec_reloc
results: parsing output: 114/ for test: gem_userptr_blits
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: kms_async_flips
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: kms_plane_alpha_blend
results: parsing output: 121/ for test: gem_create
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_mmap_gtt
results: parsing output: 124/ for test: gem_render_copy
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_ccs
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_cursor_crc
results: parsing output: 129/ for test: dumb_buffer
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: perf_pmu
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: gem_linear_blits
results: parsing output: 137/ for test: syncobj_basic
results: parsing output: 138/ for test: kms_cursor_crc
results: parsing output: 139/ for test: kms_addfb_basic
results: parsing output: 140/ for test: kms_content_protection
results: parsing output: 141/ for test: gem_pxp
results: parsing output: 142/ for test: gem_exec_balancer
results: parsing output: 143/ for test: i915_pm_rpm
results: parsing output: 144/ for test: gem_exec_reloc
results: parsing output: 145/ for test: kms_big_fb
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: kms_psr2_sf
results: parsing output: 148/ for test: kms_dirtyfb
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: gem_exec_params
results: parsing output: 151/ for test: kms_big_fb
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: kms_flip
results: parsing output: 154/ for test: kms_frontbuffer_tracking
Done.