[57.651930] Initializing watchdogs
[57.651979]   /dev/watchdog0
[57.667163] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[57.671491] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.673494] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.676869] [001/133] (960s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[57.777079] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[57.779004] Starting dynamic subtest: pipe-A-eDP-1
[58.621471] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.829s)
[58.629958] Starting dynamic subtest: pipe-B-eDP-1
[60.188445] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.551s)
[60.196077] Starting dynamic subtest: pipe-C-eDP-1
[61.688788] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.489s)
[61.697616] Starting dynamic subtest: pipe-D-eDP-1
[63.152287] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.453s)
[63.154579] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.326s)
[64.333924] [002/133] (953s left) kms_psr (fbc-pr-sprite-plane-move)
[64.422877] Starting subtest: fbc-pr-sprite-plane-move
[64.427347] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[64.488954] [003/133] (953s left) gem_eio (in-flight-contexts-immediate)
[64.637830] Starting subtest: in-flight-contexts-immediate
[70.735303] Subtest in-flight-contexts-immediate: SUCCESS (6.081s)
[70.871045] [004/133] (947s left) kms_async_flips (async-flip-suspend-resume)
[70.944957] Starting subtest: async-flip-suspend-resume
[71.319589] Starting dynamic subtest: pipe-A-eDP-1
[89.285362] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.140s)
[89.653823] Starting dynamic subtest: pipe-B-eDP-1
[107.281392] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.913s)
[107.659686] Starting dynamic subtest: pipe-C-eDP-1
[125.304087] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.910s)
[125.680383] Starting dynamic subtest: pipe-D-eDP-1
[143.306547] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.879s)
[143.308907] Subtest async-flip-suspend-resume: SUCCESS (13.300s)
[144.506720] [005/133] (873s left) kms_flip (modeset-vs-vblank-race)
[144.600104] Starting subtest: modeset-vs-vblank-race
[144.602519] Starting dynamic subtest: A-eDP1
[149.379017] Dynamic subtest A-eDP1: SUCCESS (4.710s)
[149.390647] Starting dynamic subtest: B-eDP1
[154.151058] Dynamic subtest B-eDP1: SUCCESS (4.731s)
[154.161112] Starting dynamic subtest: C-eDP1
[158.875895] Dynamic subtest C-eDP1: SUCCESS (4.701s)
[158.885255] Starting dynamic subtest: D-eDP1
[163.418736] Dynamic subtest D-eDP1: SUCCESS (4.530s)
[163.424332] Subtest modeset-vs-vblank-race: SUCCESS (18.682s)
[164.594898] [006/133] (853s left) kms_psr (pr-cursor-plane-move)
[164.680643] Starting subtest: pr-cursor-plane-move
[164.685146] Subtest pr-cursor-plane-move: SKIP (0.000s)
[164.754139] [007/133] (853s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[164.830105] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[171.997983] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.161s)
[172.087485] [008/133] (846s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[172.181270] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[172.185889] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[172.279422] [009/133] (846s left) kms_atomic_transition (modeset-transition-nonblocking)
[172.360414] Starting subtest: modeset-transition-nonblocking
[172.362369] Starting dynamic subtest: 1x-outputs
[183.671346] Dynamic subtest 1x-outputs: SUCCESS (11.314s)
[183.673604] Subtest modeset-transition-nonblocking: SUCCESS (11.316s)
[184.532910] [010/133] (833s left) i915_power (sanity)
[184.603411] Starting subtest: sanity
[188.647250] Subtest sanity: SUCCESS (4.037s)
[190.143768] [011/133] (828s left) gem_exec_whisper (basic-queues-all)
[190.202906] Starting subtest: basic-queues-all
[201.956284] Subtest basic-queues-all: SUCCESS (11.748s)
[202.141322] [012/133] (816s left) drm_read (empty-nonblock)
[202.271166] Starting subtest: empty-nonblock
[202.273174] Subtest empty-nonblock: SUCCESS (0.000s)
[202.394142] [013/133] (816s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[202.470367] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[202.474882] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[202.539017] [014/133] (816s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[202.605368] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[202.609721] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[202.677609] [015/133] (816s left) kms_psr (psr-sprite-plane-move)
[202.755627] Starting subtest: psr-sprite-plane-move
[202.757750] Starting dynamic subtest: eDP-1
[204.487294] Dynamic subtest eDP-1: SUCCESS (1.732s)
[204.489417] Subtest psr-sprite-plane-move: SUCCESS (1.733s)
[205.299934] [016/133] (813s left) gem_exec_create (legacy)
[205.375162] Starting subtest: legacy
[205.377439] Starting dynamic subtest: smem
[207.468200] Dynamic subtest smem: SUCCESS (2.092s)
[207.470630] Subtest legacy: SUCCESS (2.094s)
[207.662153] [017/133] (811s left) perf (blocking)
[207.837183] Starting subtest: blocking
[207.839222] Starting dynamic subtest: 0-rcs0
[217.854717] Dynamic subtest 0-rcs0: SUCCESS (10.013s)
[217.864546] Starting dynamic subtest: 1-vcs1
[227.880162] Dynamic subtest 1-vcs1: SUCCESS (10.021s)
[227.882572] Subtest blocking: SUCCESS (20.037s)
[227.926700] [018/133] (790s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[228.015155] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[228.019224] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[228.112689] [019/133] (790s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[228.184920] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[228.186851] Starting dynamic subtest: pipe-A-eDP-1
[228.890515] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.698s)
[228.901679] Starting dynamic subtest: pipe-B-eDP-1
[230.630168] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.738s)
[230.640231] Starting dynamic subtest: pipe-C-eDP-1
[232.357430] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.725s)
[232.367879] Starting dynamic subtest: pipe-D-eDP-1
[234.106413] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.748s)
[234.108475] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.912s)
[235.263489] [020/133] (783s left) kms_lease (lease-invalid-crtc)
[235.334838] Starting subtest: lease-invalid-crtc
[235.337232] Starting dynamic subtest: pipe-A-eDP-1
[235.339499] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[235.349877] Starting dynamic subtest: pipe-B-eDP-1
[235.352186] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[235.361399] Starting dynamic subtest: pipe-C-eDP-1
[235.363653] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[235.372596] Starting dynamic subtest: pipe-D-eDP-1
[235.374890] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[235.377097] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[235.413450] [021/133] (783s left) kms_content_protection (atomic-hdcp14)
[235.551606] Starting subtest: atomic-hdcp14
[235.556009] Subtest atomic-hdcp14: SKIP (0.000s)
[235.687385] [022/133] (783s left) gem_ctx_sseu (invalid-args)
[235.743447] Subtest invalid-args: SKIP (0.000s)
[235.808882] [023/133] (783s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[235.858319] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[235.962750] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.103s)
[236.048072] [024/133] (783s left) gem_lmem_swapping (parallel-random-engines)
[236.091895] Subtest parallel-random-engines: SKIP (0.000s)
[236.146029] [025/133] (782s left) gem_softpin (evict-prime)
[236.194189] Starting subtest: evict-prime
[236.196639] Starting dynamic subtest: rcs0
[237.358927] Dynamic subtest rcs0: SUCCESS (1.163s)
[237.370475] Starting dynamic subtest: bcs0
[238.494198] Dynamic subtest bcs0: SUCCESS (1.133s)
[238.507109] Starting dynamic subtest: vcs0
[240.058008] Dynamic subtest vcs0: SUCCESS (1.563s)
[240.071807] Starting dynamic subtest: vcs1
[242.107814] Dynamic subtest vcs1: SUCCESS (2.049s)
[242.125372] Starting dynamic subtest: vecs0
[244.100858] Dynamic subtest vecs0: SUCCESS (1.991s)
[244.117848] Starting dynamic subtest: ccs0
[245.218243] Dynamic subtest ccs0: SUCCESS (1.117s)
[245.228769] Starting dynamic subtest: all
[246.347193] Dynamic subtest all: SUCCESS (1.127s)
[246.349468] Subtest evict-prime: SUCCESS (10.156s)
[246.441931] [026/133] (772s left) kms_plane_lowres (tiling-none)
[246.508810] Starting subtest: tiling-none
[246.511097] Starting dynamic subtest: pipe-A-eDP-1
[246.515733] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[246.822599] Starting dynamic subtest: pipe-B-eDP-1
[246.827279] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[246.837360] Starting dynamic subtest: pipe-C-eDP-1
[246.841988] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[246.851820] Starting dynamic subtest: pipe-D-eDP-1
[246.856215] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[246.860632] Subtest tiling-none: SKIP (0.311s)
[247.616849] [027/133] (771s left) kms_draw_crc (draw-method-mmap-cpu)
[247.701456] Starting subtest: draw-method-mmap-cpu
[247.703461] Starting dynamic subtest: xrgb8888-untiled
[247.909268] Dynamic subtest xrgb8888-untiled: SUCCESS (0.210s)
[247.918999] Starting dynamic subtest: rgb565-untiled
[248.131332] Dynamic subtest rgb565-untiled: SUCCESS (0.222s)
[248.141063] Starting dynamic subtest: xrgb2101010-untiled
[248.342869] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.209s)
[248.355208] Starting dynamic subtest: xbgr16161616f-untiled
[248.553444] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.211s)
[248.563611] Starting dynamic subtest: xrgb8888-xtiled
[248.686267] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.131s)
[248.698999] Starting dynamic subtest: rgb565-xtiled
[248.808590] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[248.820667] Starting dynamic subtest: xrgb2101010-xtiled
[248.919394] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.109s)
[248.929194] Starting dynamic subtest: xbgr16161616f-xtiled
[249.053087] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[249.063025] Starting dynamic subtest: xrgb8888-4tiled
[249.186197] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s)
[249.195499] Starting dynamic subtest: rgb565-4tiled
[249.319506] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s)
[249.328987] Starting dynamic subtest: xrgb2101010-4tiled
[249.441664] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.122s)
[249.452237] Starting dynamic subtest: xbgr16161616f-4tiled
[249.574750] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[249.576637] Subtest draw-method-mmap-cpu: SUCCESS (1.878s)
[249.658162] [028/133] (769s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[249.718935] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[249.794974] [029/133] (769s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[249.873543] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[249.875441] Starting dynamic subtest: pipe-A-eDP-1
[249.960958] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s)
[249.971058] Starting dynamic subtest: pipe-B-eDP-1
[251.088432] Dynamic subtest pipe-B-eDP-1: SKIP (1.124s)
[251.092934] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.215s)
[252.279739] [030/133] (767s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[252.350017] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[252.354047] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[252.448010] [031/133] (766s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[252.532387] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[252.536509] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[252.639405] [032/133] (766s left) kms_rotation_crc (primary-rotation-180)
[252.709302] Starting subtest: primary-rotation-180
[259.688818] Subtest primary-rotation-180: SUCCESS (6.981s)
[260.856751] [033/133] (758s left) kms_pm_rpm (universal-planes-dpms)
[262.355476] Starting subtest: universal-planes-dpms
[262.358064] Starting dynamic subtest: plane-35
[270.636944] Dynamic subtest plane-35: SUCCESS (8.283s)
[270.649870] Starting dynamic subtest: plane-65
[278.906650] Dynamic subtest plane-65: SUCCESS (8.267s)
[278.919434] Starting dynamic subtest: plane-95
[287.175282] Dynamic subtest plane-95: SUCCESS (8.265s)
[287.188489] Starting dynamic subtest: plane-125
[295.473037] Dynamic subtest plane-125: SUCCESS (8.293s)
[295.486307] Starting dynamic subtest: plane-135
[303.773350] Dynamic subtest plane-135: SUCCESS (8.296s)
[303.786768] Starting dynamic subtest: plane-145
[312.088372] Dynamic subtest plane-145: SUCCESS (8.310s)
[312.091434] Subtest universal-planes-dpms: SUCCESS (49.731s)
[312.449407] [034/133] (707s left) kms_pm_lpsp (kms-lpsp)
[313.524829] Starting subtest: kms-lpsp
[313.527182] Starting dynamic subtest: pipe-A-eDP-1
[313.671979] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.149s)
[313.962884] Subtest kms-lpsp: SUCCESS (0.439s)
[314.783997] [035/133] (704s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[315.150419] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[315.998681] [036/133] (703s left) api_intel_allocator (two-level-inception-interruptible)
[316.048865] Starting subtest: two-level-inception-interruptible
[321.457223] Subtest two-level-inception-interruptible: SUCCESS (5.408s)
[321.578469] [037/133] (698s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[321.661825] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[321.666175] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[321.778809] [038/133] (697s left) gem_userptr_blits (huge-split)
[321.867126] Starting subtest: huge-split
[321.873796] Subtest huge-split: SUCCESS (0.007s)
[322.006291] [039/133] (697s left) gem_eio (in-flight-10ms)
[322.222525] Starting subtest: in-flight-10ms
[330.923491] Subtest in-flight-10ms: SUCCESS (8.700s)
[331.091151] [FACT gem_eio (in-flight-10ms)] new: kernel.kmod_is_loaded.vgem: true
[331.095017] [040/133] (688s left) perf_pmu (pmu-read)
[331.133103] Starting subtest: pmu-read
[331.135208] Subtest pmu-read: SUCCESS (0.003s)
[331.237356] [041/133] (688s left) kms_properties (plane-properties-atomic)
[331.307858] Starting subtest: plane-properties-atomic
[331.309791] Starting dynamic subtest: pipe-A-eDP-1
[331.857494] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.548s)
[331.869181] Starting dynamic subtest: pipe-B-eDP-1
[333.110314] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.250s)
[333.120924] Starting dynamic subtest: pipe-C-eDP-1
[334.352640] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.242s)
[334.363932] Starting dynamic subtest: pipe-D-eDP-1
[335.589714] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.232s)
[335.591700] Subtest plane-properties-atomic: SUCCESS (4.279s)
[336.385998] [042/133] (683s left) gem_ctx_exec (basic-invalid-context)
[336.435973] Starting subtest: basic-invalid-context
[336.441660] Subtest basic-invalid-context: SUCCESS (0.005s)
[336.567487] [043/133] (683s left) gem_exec_params (rel-constants-invalid)
[336.624878] Starting subtest: rel-constants-invalid
[336.627284] Subtest rel-constants-invalid: SUCCESS (0.000s)
[336.719572] [044/133] (683s left) syncobj_wait (reset-multiple-signaled)
[336.779079] Starting subtest: reset-multiple-signaled
[336.781034] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[336.898979] [045/133] (683s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[336.999123] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[337.003646] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[337.094730] [046/133] (682s left) gem_ctx_persistence (legacy-engines-mixed)
[337.151886] Starting subtest: legacy-engines-mixed
[337.154249] Starting dynamic subtest: render
[337.233154] Dynamic subtest render: SUCCESS (0.080s)
[337.250555] Starting dynamic subtest: bsd1
[337.281910] Dynamic subtest bsd1: SUCCESS (0.046s)
[337.292618] Starting dynamic subtest: bsd2
[337.334801] Dynamic subtest bsd2: SUCCESS (0.051s)
[337.352211] Starting dynamic subtest: blt
[337.385964] Dynamic subtest blt: SUCCESS (0.048s)
[337.402115] Starting dynamic subtest: vebox
[337.436034] Dynamic subtest vebox: SUCCESS (0.048s)
[337.438193] Subtest legacy-engines-mixed: SUCCESS (0.285s)
[337.528962] [047/133] (682s left) gem_pread (display)
[337.587406] Subtest display: SKIP (0.000s)
[337.654760] [048/133] (682s left) fbdev (unaligned-write)
[337.693669] Starting subtest: unaligned-write
[337.791869] Subtest unaligned-write: SUCCESS (0.097s)
[337.854495] [049/133] (682s left) syncobj_timeline (device-signal-unordered)
[337.923707] Starting subtest: device-signal-unordered
[337.925619] Subtest device-signal-unordered: SUCCESS (0.001s)
[338.045520] [050/133] (682s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[338.121643] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[345.002446] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.883s)
[345.130015] [051/133] (675s left) kms_flip (2x-flip-vs-expired-vblank)
[345.209105] Starting subtest: 2x-flip-vs-expired-vblank
[345.217201] Subtest 2x-flip-vs-expired-vblank: SKIP (0.007s)
[345.302863] [052/133] (674s left) kms_psr (psr2-sprite-render)
[345.374780] Starting subtest: psr2-sprite-render
[345.377037] Starting dynamic subtest: eDP-1
[347.106702] Dynamic subtest eDP-1: SUCCESS (1.730s)
[347.108965] Subtest psr2-sprite-render: SUCCESS (1.731s)
[347.965917] [053/133] (672s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[348.046666] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[348.048900] Starting dynamic subtest: pipe-A-eDP-1
[353.942981] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.900s)
[353.954028] Starting dynamic subtest: pipe-B-eDP-1
[360.561606] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.613s)
[360.564322] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.516s)
[361.433272] [054/133] (658s left) drm_read (short-buffer-nonblock)
[361.559204] Starting subtest: short-buffer-nonblock
[361.561091] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[361.695291] [055/133] (658s left) gem_exec_schedule (pi-userfault)
[361.871137] Starting subtest: pi-userfault
[361.873504] Starting dynamic subtest: rcs0
[361.879649] Dynamic subtest rcs0: SUCCESS (0.010s)
[361.891268] Starting dynamic subtest: bcs0
[361.893435] Dynamic subtest bcs0: SUCCESS (0.007s)
[361.903874] Starting dynamic subtest: vcs0
[361.906151] Dynamic subtest vcs0: SUCCESS (0.010s)
[361.916323] Starting dynamic subtest: vcs1
[361.918195] Dynamic subtest vcs1: SUCCESS (0.008s)
[361.928532] Starting dynamic subtest: vecs0
[361.930774] Dynamic subtest vecs0: SUCCESS (0.008s)
[361.940569] Starting dynamic subtest: ccs0
[361.942741] Dynamic subtest ccs0: SUCCESS (0.011s)
[361.944889] Subtest pi-userfault: SUCCESS (0.058s)
[362.108725] [056/133] (658s left) i915_pm_rpm (sysfs-read)
[364.219362] Starting subtest: sysfs-read
[365.371456] Subtest sysfs-read: SUCCESS (1.148s)
[365.727062] [057/133] (654s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[365.826938] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[366.817245] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.991s)
[366.946337] [058/133] (653s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[367.038913] Starting subtest: y-tiled-64bpp-rotate-270
[367.043282] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[367.133815] [059/133] (653s left) kms_psr (fbc-psr-primary-blt)
[367.203850] Starting subtest: fbc-psr-primary-blt
[367.205924] Starting dynamic subtest: eDP-1
[367.209407] Dynamic subtest eDP-1: SKIP (0.000s)
[367.213081] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[367.292498] [060/133] (653s left) vgem_basic (dmabuf-export)
[367.341406] Starting subtest: dmabuf-export
[367.357326] Subtest dmabuf-export: SUCCESS (0.018s)
[367.469660] [061/133] (653s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[367.526174] Starting subtest: multi-wait-all-for-submit-available-signaled
[367.528133] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[367.619231] [062/133] (653s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[367.695655] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[367.703134] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.007s)
[367.792644] [063/133] (652s left) syncobj_timeline (single-wait-all-available-submitted)
[367.844710] Starting subtest: single-wait-all-available-submitted
[367.846772] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[367.926589] [064/133] (652s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[367.996830] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[368.000330] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[368.096493] [065/133] (652s left) kms_universal_plane (disable-primary-vs-flip)
[368.172565] Starting subtest: disable-primary-vs-flip
[368.174559] Starting dynamic subtest: pipe-A-eDP-1
[369.703815] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.528s)
[369.715081] Starting dynamic subtest: pipe-B-eDP-1
[371.898644] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.195s)
[371.911756] Starting dynamic subtest: pipe-C-eDP-1
[374.135290] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.237s)
[374.145859] Starting dynamic subtest: pipe-D-eDP-1
[376.303898] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.164s)
[376.306109] Subtest disable-primary-vs-flip: SUCCESS (8.131s)
[377.106972] [066/133] (643s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[377.194216] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[377.198594] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[377.285899] [067/133] (643s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[377.353840] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[377.362382] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.007s)
[377.437435] [068/133] (643s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[377.516659] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[377.521177] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[377.589500] [069/133] (643s left) vgem_basic (bad-handle)
[377.630471] Starting subtest: bad-handle
[377.632481] Subtest bad-handle: SUCCESS (0.000s)
[377.692089] [070/133] (643s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[377.768279] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[377.770367] Starting dynamic subtest: pipe-A-eDP-1
[377.793217] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[377.803678] Starting dynamic subtest: pipe-B-eDP-1
[377.825378] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[377.835090] Starting dynamic subtest: pipe-C-eDP-1
[377.856936] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[377.866701] Starting dynamic subtest: pipe-D-eDP-1
[377.888493] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[377.892385] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[380.089066] [071/133] (640s left) api_intel_bb (intel-bb-blit-x)
[380.157202] Starting subtest: intel-bb-blit-x
[383.432645] Subtest intel-bb-blit-x: SUCCESS (3.278s)
[383.548937] [072/133] (637s left) kms_cursor_crc (cursor-sliding-32x10)
[383.694145] Starting subtest: cursor-sliding-32x10
[383.746385] Subtest cursor-sliding-32x10: SKIP (0.048s)
[384.040969] [073/133] (637s left) prime_self_import (export-vs-gem_close-race)
[384.076881] Starting subtest: export-vs-gem_close-race
[389.181799] Subtest export-vs-gem_close-race: SUCCESS (5.108s)
[389.284221] [074/133] (631s left) perf (non-sampling-read-error)
[389.438569] Starting subtest: non-sampling-read-error
[389.448835] Subtest non-sampling-read-error: SUCCESS (0.013s)
[389.522834] [075/133] (631s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[389.627912] Starting subtest: bad-rotation-90-y-tiled-ccs
[389.630223] Starting dynamic subtest: pipe-A-eDP-1
[389.652777] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[389.670794] Starting dynamic subtest: pipe-B-eDP-1
[389.693217] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[389.708589] Starting dynamic subtest: pipe-C-eDP-1
[389.730412] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[389.745392] Starting dynamic subtest: pipe-D-eDP-1
[389.767422] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[389.772114] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.008s)
[391.948626] [076/133] (629s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[392.032028] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[398.897841] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.870s)
[399.040453] [077/133] (622s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[399.101255] Starting subtest: invalid-bsd2-flag-on-blt
[399.103699] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[399.211274] [078/133] (622s left) kms_cursor_crc (cursor-onscreen-128x42)
[399.410499] Starting subtest: cursor-onscreen-128x42
[399.462520] Subtest cursor-onscreen-128x42: SKIP (0.047s)
[399.668828] [079/133] (621s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[399.779383] Starting subtest: modeset-atomic-cursor-hotspot
[399.784021] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[399.925734] [080/133] (621s left) gem_render_copy (linear)
[399.976530] Starting subtest: linear
[399.978641] Starting dynamic subtest: smem
[400.015531] Dynamic subtest smem: SUCCESS (0.039s)
[400.017555] Subtest linear: SUCCESS (0.039s)
[400.212656] [081/133] (621s left) prime_self_import (basic-with_one_bo_two_files)
[400.246211] Starting subtest: basic-with_one_bo_two_files
[400.266700] Subtest basic-with_one_bo_two_files: SUCCESS (0.020s)
[400.375317] [082/133] (621s left) kms_chamelium_edid (hdmi-edid-read)
[400.745430] Subtest hdmi-edid-read: SKIP (0.000s)
[401.572845] [083/133] (620s left) gem_exec_params (readonly)
[401.641779] Starting subtest: readonly
[401.644245] Subtest readonly: SUCCESS (0.002s)
[401.771543] [084/133] (619s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[401.849357] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[401.851658] Starting dynamic subtest: pipe-A-default-mode
[402.978911] Dynamic subtest pipe-A-default-mode: SKIP (1.124s)
[402.983382] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.126s)
[403.135114] [085/133] (618s left) gem_mmap_gtt (cpuset-big-copy)
[403.195344] Subtest cpuset-big-copy: SKIP (0.000s)
[403.263317] [086/133] (618s left) sriov_basic (enable-vfs-autoprobe-on)
[403.317010] Starting subtest: enable-vfs-autoprobe-on
[403.319295] Starting dynamic subtest: numvfs-1
[403.390652] Dynamic subtest numvfs-1: FAIL (0.015s)
[403.404504] Starting dynamic subtest: numvfs-2
[403.473273] Dynamic subtest numvfs-2: FAIL (0.004s)
[403.483729] Starting dynamic subtest: numvfs-3
[403.552502] Dynamic subtest numvfs-3: FAIL (0.008s)
[403.562624] Starting dynamic subtest: numvfs-4
[403.632278] Dynamic subtest numvfs-4: FAIL (0.009s)
[403.643637] Starting dynamic subtest: numvfs-5
[403.712043] Dynamic subtest numvfs-5: FAIL (0.010s)
[403.722309] Starting dynamic subtest: numvfs-6
[403.791753] Dynamic subtest numvfs-6: FAIL (0.005s)
[403.801710] Starting dynamic subtest: numvfs-7
[403.870775] Dynamic subtest numvfs-7: FAIL (0.004s)
[403.882203] Starting dynamic subtest: numvfs-random
[403.938043] Dynamic subtest numvfs-random: FAIL (0.003s)
[403.947504] Starting dynamic subtest: numvfs-all
[404.004184] Dynamic subtest numvfs-all: FAIL (0.003s)
[404.005754] Subtest enable-vfs-autoprobe-on: FAIL (0.073s)
[404.042009] [087/133] (617s left) kms_plane_scaling (planes-downscale-factor-0-75)
[404.108117] Starting subtest: planes-downscale-factor-0-75
[404.110030] Starting dynamic subtest: pipe-A
[404.127429] Dynamic subtest pipe-A: SKIP (0.017s)
[404.137608] Starting dynamic subtest: pipe-B
[404.157842] Dynamic subtest pipe-B: SKIP (0.030s)
[404.167684] Starting dynamic subtest: pipe-C
[404.188528] Dynamic subtest pipe-C: SKIP (0.029s)
[404.200002] Starting dynamic subtest: pipe-D
[404.218743] Dynamic subtest pipe-D: SKIP (0.029s)
[404.221906] Subtest planes-downscale-factor-0-75: SKIP (0.108s)
[404.312649] [088/133] (617s left) kms_plane (plane-panning-top-left)
[404.381762] Starting subtest: plane-panning-top-left
[404.383753] Starting dynamic subtest: pipe-A
[406.028030] Dynamic subtest pipe-A: SUCCESS (1.642s)
[406.039396] Starting dynamic subtest: pipe-B
[408.278057] Dynamic subtest pipe-B: SUCCESS (2.248s)
[408.280486] Subtest plane-panning-top-left: SUCCESS (3.894s)
[409.090254] [089/133] (612s left) kms_plane_cursor (overlay)
[409.171886] Starting subtest: overlay
[409.176292] Starting dynamic subtest: pipe-A-eDP-1-size-64
[411.598359] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.426s)
[411.661441] Starting dynamic subtest: pipe-A-eDP-1-size-128
[414.054342] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.404s)
[414.118422] Starting dynamic subtest: pipe-A-eDP-1-size-256
[416.533452] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.427s)
[416.889666] Starting dynamic subtest: pipe-B-eDP-1-size-64
[420.077048] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.200s)
[420.139775] Starting dynamic subtest: pipe-B-eDP-1-size-128
[422.512655] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.382s)
[422.576664] Starting dynamic subtest: pipe-B-eDP-1-size-256
[424.946149] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.382s)
[425.296067] Starting dynamic subtest: pipe-C-eDP-1-size-64
[428.052909] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.768s)
[428.092613] Starting dynamic subtest: pipe-C-eDP-1-size-128
[430.119669] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.036s)
[430.159030] Starting dynamic subtest: pipe-C-eDP-1-size-256
[432.198687] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.047s)
[432.539865] Starting dynamic subtest: pipe-D-eDP-1-size-64
[435.349327] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.821s)
[435.388601] Starting dynamic subtest: pipe-D-eDP-1-size-128
[437.481917] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.103s)
[437.523186] Starting dynamic subtest: pipe-D-eDP-1-size-256
[439.582213] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.070s)
[439.899771] Subtest overlay: SUCCESS (30.727s)
[440.703689] [090/133] (581s left) perf_pmu (busy)
[440.745095] Starting subtest: busy
[440.747224] Starting dynamic subtest: rcs0
[441.331199] Dynamic subtest rcs0: SUCCESS (0.587s)
[441.341722] Starting dynamic subtest: bcs0
[441.902509] Dynamic subtest bcs0: SUCCESS (0.569s)
[441.921494] Starting dynamic subtest: vcs0
[443.134029] Dynamic subtest vcs0: SUCCESS (1.228s)
[443.146844] Starting dynamic subtest: vcs1
[445.118052] Dynamic subtest vcs1: SUCCESS (1.982s)
[445.129810] Starting dynamic subtest: vecs0
[447.102974] Dynamic subtest vecs0: SUCCESS (1.981s)
[447.117354] Starting dynamic subtest: ccs0
[447.677628] Dynamic subtest ccs0: SUCCESS (0.573s)
[447.680137] Subtest busy: SUCCESS (6.934s)
[447.809690] [091/133] (574s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[447.890909] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[447.900118] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.008s)
[448.001624] [092/133] (573s left) kms_frontbuffer_tracking (fbc-stridechange)
[448.086078] Starting subtest: fbc-stridechange
[451.418256] Subtest fbc-stridechange: SUCCESS (3.334s)
[452.618082] [093/133] (569s left) gem_pread (bench)
[452.674358] Subtest bench: SKIP (0.000s)
[452.733821] [094/133] (569s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[452.807425] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[459.519643] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.716s)
[459.674152] [095/133] (562s left) syncobj_basic (bad-fd-to-handle)
[459.742175] Starting subtest: bad-fd-to-handle
[459.744164] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[459.837121] [096/133] (562s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[459.890306] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[459.892568] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[459.982945] [097/133] (562s left) perf (mi-rpc)
[460.072167] Starting subtest: mi-rpc
[460.076630] Subtest mi-rpc: SKIP (0.000s)
[460.120525] [098/133] (562s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[460.196731] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[460.200642] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[460.291024] [099/133] (562s left) kms_vblank (ts-continuation-modeset-rpm)
[460.368629] Starting subtest: ts-continuation-modeset-rpm
[460.370876] Starting dynamic subtest: pipe-A-eDP-1
[462.942894] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.572s)
[462.958022] Starting dynamic subtest: pipe-D-eDP-1
[465.173799] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.229s)
[465.175930] Subtest ts-continuation-modeset-rpm: SUCCESS (4.805s)
[465.966951] [100/133] (556s left) perf (non-system-wide-paranoid)
[466.050236] Starting subtest: non-system-wide-paranoid
[466.079694] Subtest non-system-wide-paranoid: SUCCESS (0.029s)
[466.118700] [101/133] (556s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[466.197457] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[466.199838] Starting dynamic subtest: pipe-A-eDP-1
[466.223880] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[466.236316] Starting dynamic subtest: pipe-B-eDP-1
[466.258899] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[466.270325] Starting dynamic subtest: pipe-C-eDP-1
[466.294460] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[466.306037] Starting dynamic subtest: pipe-D-eDP-1
[466.330325] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[466.334501] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[468.440255] [102/133] (553s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[468.528139] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[477.853413] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.329s)
[477.968727] [103/133] (544s left) gem_softpin (allocator-basic)
[478.042931] Starting subtest: allocator-basic
[478.105520] Subtest allocator-basic: SUCCESS (0.065s)
[478.236439] [104/133] (544s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[478.320305] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[485.041511] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.725s)
[485.148693] [105/133] (537s left) syncobj_basic (create-signaled)
[485.206011] Starting subtest: create-signaled
[485.208289] Subtest create-signaled: SUCCESS (0.000s)
[485.302813] [106/133] (537s left) gem_mmap (basic-small-bo)
[485.356873] Subtest basic-small-bo: SKIP (0.000s)
[485.417105] [107/133] (537s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[485.487235] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[492.001046] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.515s)
[492.131015] [108/133] (530s left) kms_force_connector_basic (force-load-detect)
[492.195175] Subtest force-load-detect: SKIP (0.000s)
[492.255262] [109/133] (530s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[492.338221] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[492.340526] Starting dynamic subtest: pipe-A-eDP-1
[492.411015] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[492.423206] Starting dynamic subtest: pipe-B-eDP-1
[493.541534] Dynamic subtest pipe-B-eDP-1: SKIP (1.127s)
[493.546274] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.206s)
[494.732505] [110/133] (528s left) gem_mmap_wc (coherency)
[494.787832] Subtest coherency: SKIP (0.000s)
[494.851151] [111/133] (527s left) kms_concurrent (multi-plane-atomic-lowres)
[494.927261] Starting subtest: multi-plane-atomic-lowres
[494.929608] Starting dynamic subtest: pipe-A-eDP-1
[495.430415] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.500s)
[495.440891] Starting dynamic subtest: pipe-B-eDP-1
[496.690253] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.259s)
[496.700625] Starting dynamic subtest: pipe-C-eDP-1
[497.888440] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.194s)
[497.900157] Starting dynamic subtest: pipe-D-eDP-1
[499.117416] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.229s)
[499.119875] Subtest multi-plane-atomic-lowres: SUCCESS (4.188s)
[499.955372] [112/133] (522s left) gem_gtt_cpu_tlb
[500.089551] [113/133] (522s left) i915_module_load (reload-no-display)
[500.126236] Starting subtest: reload-no-display
[506.104971] Subtest reload-no-display: SUCCESS (5.976s)
[506.134792] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[506.135565] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[506.138736] [114/133] (516s left) i915_drm_fdinfo (idle)
[507.578518] Starting subtest: idle
[507.580985] Starting dynamic subtest: rcs0
[508.139797] Dynamic subtest rcs0: SUCCESS (0.560s)
[508.153557] Starting dynamic subtest: bcs0
[508.681355] Dynamic subtest bcs0: SUCCESS (0.538s)
[508.692462] Starting dynamic subtest: vcs0
[509.187641] Dynamic subtest vcs0: SUCCESS (0.503s)
[509.200243] Starting dynamic subtest: vcs1
[509.693025] Dynamic subtest vcs1: SUCCESS (0.503s)
[509.705614] Starting dynamic subtest: vecs0
[510.198196] Dynamic subtest vecs0: SUCCESS (0.503s)
[510.211104] Starting dynamic subtest: ccs0
[510.703406] Dynamic subtest ccs0: SUCCESS (0.503s)
[510.706825] Subtest idle: SUCCESS (3.124s)
[510.753666] [FACT i915_drm_fdinfo (idle)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[510.755310] [FACT i915_drm_fdinfo (idle)] new: kernel.kmod_is_loaded.i915: true
[510.759097] [115/133] (512s left) dumb_buffer (create-clear)
[510.825708] Starting subtest: create-clear
[544.903596] Subtest create-clear: SUCCESS (34.069s)
[545.006469] [116/133] (478s left) kms_flip (flip-vs-fences-interruptible)
[545.095558] Starting subtest: flip-vs-fences-interruptible
[545.099617] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[545.177198] [117/133] (477s left) kms_big_fb (linear-8bpp-rotate-270)
[545.252586] Starting subtest: linear-8bpp-rotate-270
[545.291733] Subtest linear-8bpp-rotate-270: SKIP (0.036s)
[545.400378] [118/133] (477s left) gen9_exec_parse (bb-oversize)
[545.464644] Subtest bb-oversize: SKIP (0.000s)
[545.542807] [119/133] (477s left) gem_exec_schedule (smoketest)
[545.713800] Starting subtest: smoketest
[545.716328] Starting dynamic subtest: rcs0
[551.269104] Dynamic subtest rcs0: SUCCESS (5.508s)
[551.280631] Starting dynamic subtest: bcs0
[556.768928] Dynamic subtest bcs0: SUCCESS (5.496s)
[556.782201] Starting dynamic subtest: vcs0
[562.261027] Dynamic subtest vcs0: SUCCESS (5.489s)
[562.277299] Starting dynamic subtest: vcs1
[567.771664] Dynamic subtest vcs1: SUCCESS (5.504s)
[567.784219] Starting dynamic subtest: vecs0
[573.273995] Dynamic subtest vecs0: SUCCESS (5.500s)
[573.290977] Starting dynamic subtest: ccs0
[578.798324] Dynamic subtest ccs0: SUCCESS (5.521s)
[578.800234] Subtest smoketest: SUCCESS (33.028s)
[578.935962] [120/133] (444s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[579.120461] Starting subtest: cursor-rapid-movement-64x21
[579.171867] Subtest cursor-rapid-movement-64x21: SKIP (0.047s)
[579.406321] [121/133] (443s left) gem_mmap (basic)
[579.460736] Subtest basic: SKIP (0.000s)
[579.524676] [122/133] (443s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[579.631603] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[580.256143] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.625s)
[580.424078] [123/133] (442s left) gem_exec_balancer (hang)
[580.686854] Starting subtest: hang
[582.353088] Subtest hang: SUCCESS (1.669s)
[582.466883] [124/133] (440s left) gem_ctx_exec (basic-norecovery)
[582.529631] Starting subtest: basic-norecovery
[582.865317] Subtest basic-norecovery: SUCCESS (0.336s)
[582.984491] [125/133] (440s left) kms_hdr (static-toggle)
[583.056976] Starting subtest: static-toggle
[583.063867] Subtest static-toggle: SKIP (0.000s)
[583.157794] [126/133] (440s left) kms_properties (invalid-properties-legacy)
[583.237398] Starting subtest: invalid-properties-legacy
[583.333165] Subtest invalid-properties-legacy: SUCCESS (0.096s)
[583.406391] [127/133] (440s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[583.492289] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[587.799406] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.307s)
[589.012215] [128/133] (434s left) gem_workarounds (suspend-resume-context)
[589.094880] Starting subtest: suspend-resume-context
[605.256698] Subtest suspend-resume-context: SUCCESS (1.183s)
[605.385127] [129/133] (418s left) gem_exec_fence (keep-in-fence)
[605.575697] Starting subtest: keep-in-fence
[605.578799] Starting dynamic subtest: rcs0
[605.631667] Dynamic subtest rcs0: SUCCESS (0.056s)
[605.647472] Starting dynamic subtest: bcs0
[605.687847] Dynamic subtest bcs0: SUCCESS (0.054s)
[605.700546] Starting dynamic subtest: vcs0
[607.106173] Dynamic subtest vcs0: SUCCESS (1.383s)
[607.118295] Starting dynamic subtest: vcs1
[609.090013] Dynamic subtest vcs1: SUCCESS (1.944s)
[609.104835] Starting dynamic subtest: vecs0
[611.073567] Dynamic subtest vecs0: SUCCESS (1.953s)
[611.087892] Starting dynamic subtest: ccs0
[611.301004] Dynamic subtest ccs0: SUCCESS (0.223s)
[611.304126] Subtest keep-in-fence: SUCCESS (5.627s)
[613.203922] [130/133] (410s left) gem_mmap_gtt (hang-user)
[613.275550] Subtest hang-user: SKIP (0.000s)
[613.339607] [131/133] (410s left) kms_atomic_transition (plane-all-transition-fencing)
[613.416006] Starting subtest: plane-all-transition-fencing
[613.418828] Starting dynamic subtest: pipe-A-eDP-1
[615.929993] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[616.240228] Starting dynamic subtest: pipe-B-eDP-1
[619.505565] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.259s)
[619.819854] Subtest plane-all-transition-fencing: SUCCESS (6.362s)
[620.645825] [132/133] (403s left) gem_pxp (protected-raw-src-copy-not-readible)
[620.773420] Starting subtest: protected-raw-src-copy-not-readible
[620.830241] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.060s)
[620.956569] [133/133] (402s left) syncobj_wait (multi-wait-for-submit-submitted)
[621.017371] Starting subtest: multi-wait-for-submit-submitted
[621.156359] Subtest multi-wait-for-submit-submitted: SUCCESS (0.107s)
[621.198716] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: gem_eio
results: parsing output: 3/ for test: kms_async_flips
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: kms_psr
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: kms_atomic_transition
results: parsing output: 9/ for test: i915_power
results: parsing output: 10/ for test: gem_exec_whisper
results: parsing output: 11/ for test: drm_read
results: parsing output: 12/ for test: kms_flip_scaled_crc
results: parsing output: 13/ for test: kms_plane
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: gem_exec_create
results: parsing output: 16/ for test: perf
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: kms_lease
results: parsing output: 20/ for test: kms_content_protection
results: parsing output: 21/ for test: gem_ctx_sseu
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: gem_lmem_swapping
results: parsing output: 24/ for test: gem_softpin
results: parsing output: 25/ for test: kms_plane_lowres
results: parsing output: 26/ for test: kms_draw_crc
results: parsing output: 27/ for test: kms_pipe_b_c_ivb
results: parsing output: 28/ for test: kms_psr2_sf
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_rotation_crc
results: parsing output: 32/ for test: kms_pm_rpm
results: parsing output: 33/ for test: kms_pm_lpsp
results: parsing output: 34/ for test: kms_chamelium_hpd
results: parsing output: 35/ for test: api_intel_allocator
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_userptr_blits
results: parsing output: 38/ for test: gem_eio
results: parsing output: 39/ for test: perf_pmu
results: parsing output: 40/ for test: kms_properties
results: parsing output: 41/ for test: gem_ctx_exec
results: parsing output: 42/ for test: gem_exec_params
results: parsing output: 43/ for test: syncobj_wait
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: gem_ctx_persistence
results: parsing output: 46/ for test: gem_pread
results: parsing output: 47/ for test: fbdev
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: kms_psr2_sf
results: parsing output: 53/ for test: drm_read
results: parsing output: 54/ for test: gem_exec_schedule
results: parsing output: 55/ for test: i915_pm_rpm
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: vgem_basic
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: kms_flip
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_universal_plane
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: kms_flip_scaled_crc
results: parsing output: 68/ for test: vgem_basic
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: api_intel_bb
results: parsing output: 71/ for test: kms_cursor_crc
results: parsing output: 72/ for test: prime_self_import
results: parsing output: 73/ for test: perf
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_exec_params
results: parsing output: 77/ for test: kms_cursor_crc
results: parsing output: 78/ for test: kms_cursor_legacy
results: parsing output: 79/ for test: gem_render_copy
results: parsing output: 80/ for test: prime_self_import
results: parsing output: 81/ for test: kms_chamelium_edid
results: parsing output: 82/ for test: gem_exec_params
results: parsing output: 83/ for test: kms_flip_scaled_crc
results: parsing output: 84/ for test: gem_mmap_gtt
results: parsing output: 85/ for test: sriov_basic
results: parsing output: 86/ for test: kms_plane_scaling
results: parsing output: 87/ for test: kms_plane
results: parsing output: 88/ for test: kms_plane_cursor
results: parsing output: 89/ for test: perf_pmu
results: parsing output: 90/ for test: kms_flip
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_pread
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: syncobj_basic
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: perf
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_vblank
results: parsing output: 99/ for test: perf
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_softpin
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: syncobj_basic
results: parsing output: 105/ for test: gem_mmap
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_force_connector_basic
results: parsing output: 108/ for test: kms_psr2_sf
results: parsing output: 109/ for test: gem_mmap_wc
results: parsing output: 110/ for test: kms_concurrent
results: parsing output: 111/ for test: gem_gtt_cpu_tlb
results: parsing output: 112/ for test: i915_module_load
results: parsing output: 113/ for test: i915_drm_fdinfo
results: parsing output: 114/ for test: dumb_buffer
results: parsing output: 115/ for test: kms_flip
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: gen9_exec_parse
results: parsing output: 118/ for test: gem_exec_schedule
results: parsing output: 119/ for test: kms_cursor_crc
results: parsing output: 120/ for test: gem_mmap
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: gem_exec_balancer
results: parsing output: 123/ for test: gem_ctx_exec
results: parsing output: 124/ for test: kms_hdr
results: parsing output: 125/ for test: kms_properties
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_workarounds
results: parsing output: 128/ for test: gem_exec_fence
results: parsing output: 129/ for test: gem_mmap_gtt
results: parsing output: 130/ for test: kms_atomic_transition
results: parsing output: 131/ for test: gem_pxp
results: parsing output: 132/ for test: syncobj_wait
Done.