[58.280500] Initializing watchdogs
[58.280546]   /dev/watchdog0
[58.295771] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.300053] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.302469] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.305997] [001/133] (960s left) kms_force_connector_basic (force-connector-state)
[58.406542] Starting subtest: force-connector-state
[59.037510] Subtest force-connector-state: SUCCESS (0.631s)
[59.941608] [002/133] (958s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[60.030107] Starting subtest: compare-crc-sanitycheck-nv12
[60.032838] Starting dynamic subtest: pipe-A-eDP-1
[60.691852] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.661s)
[60.700848] Starting dynamic subtest: pipe-B-eDP-1
[61.957879] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.266s)
[61.966196] Starting dynamic subtest: pipe-C-eDP-1
[63.228675] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.271s)
[63.237129] Starting dynamic subtest: pipe-D-eDP-1
[64.437599] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.207s)
[64.440064] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.408s)
[65.315168] [003/133] (953s left) kms_async_flips (async-flip-dpms)
[65.410912] Starting subtest: async-flip-dpms
[65.783010] Starting dynamic subtest: pipe-A-eDP-1
[69.673406] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.889s)
[70.048423] Starting dynamic subtest: pipe-B-eDP-1
[72.966440] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.924s)
[73.362973] Starting dynamic subtest: pipe-C-eDP-1
[76.264080] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.909s)
[76.640181] Starting dynamic subtest: pipe-D-eDP-1
[79.461077] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.829s)
[79.463529] Subtest async-flip-dpms: SUCCESS (14.051s)
[80.634915] [004/133] (938s left) kms_flip (flip-vs-suspend-interruptible)
[80.732807] Starting subtest: flip-vs-suspend-interruptible
[80.735172] Starting dynamic subtest: A-eDP1
[113.760667] Dynamic subtest A-eDP1: SUCCESS (4.263s)
[113.769866] Starting dynamic subtest: B-eDP1
[162.750511] Dynamic subtest B-eDP1: SUCCESS (4.496s)
[162.762423] Starting dynamic subtest: C-eDP1
[211.751214] Dynamic subtest C-eDP1: SUCCESS (4.521s)
[211.762765] Starting dynamic subtest: D-eDP1
[260.745868] Dynamic subtest D-eDP1: SUCCESS (4.628s)
[260.748576] Subtest flip-vs-suspend-interruptible: SUCCESS (17.918s)
[261.916587] [005/133] (757s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[262.027978] Starting subtest: fbc-rgb101010-draw-pwrite
[267.477593] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.455s)
[268.627506] [006/133] (750s left) kms_vblank (ts-continuation-idle-hang)
[268.723845] Starting subtest: ts-continuation-idle-hang
[268.726552] Starting dynamic subtest: pipe-A-eDP-1
[294.777568] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.050s)
[294.795494] Starting dynamic subtest: pipe-D-eDP-1
[309.745878] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.962s)
[309.748825] Subtest ts-continuation-idle-hang: SUCCESS (41.015s)
[310.591069] [007/133] (708s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[310.693968] Starting subtest: fbc-rgb565-draw-mmap-gtt
[310.698997] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[310.797445] [008/133] (708s left) syncobj_wait (single-wait-signaled)
[310.849142] Starting subtest: single-wait-signaled
[310.852022] Subtest single-wait-signaled: SUCCESS (0.000s)
[310.942955] [009/133] (708s left) kms_cursor_legacy (single-move)
[311.076841] Starting subtest: single-move
[311.079555] Starting dynamic subtest: pipe-A
[316.460296] Dynamic subtest pipe-A: SUCCESS (5.381s)
[316.470493] Starting dynamic subtest: pipe-B
[321.843141] Dynamic subtest pipe-B: SUCCESS (5.380s)
[321.853411] Starting dynamic subtest: pipe-C
[327.226028] Dynamic subtest pipe-C: SUCCESS (5.380s)
[327.236421] Starting dynamic subtest: pipe-D
[332.609160] Dynamic subtest pipe-D: SUCCESS (5.380s)
[332.617874] Starting dynamic subtest: all-pipes
[337.997698] Dynamic subtest all-pipes: SUCCESS (5.386s)
[338.000418] Subtest single-move: SUCCESS (26.917s)
[338.143093] [010/133] (681s left) gem_exec_balancer (waits)
[338.214688] Starting subtest: waits
[344.764882] Subtest waits: SUCCESS (6.548s)
[345.070908] [011/133] (674s left) i915_pm_freq_mult (media-freq)
[345.127970] Starting subtest: media-freq
[345.130827] Starting dynamic subtest: gt0
[345.135952] Dynamic subtest gt0: SKIP (0.000s)
[345.145610] Starting dynamic subtest: gt1
[345.150953] Dynamic subtest gt1: SKIP (0.000s)
[345.156387] Subtest media-freq: SKIP (0.001s)
[345.226912] [012/133] (674s left) gem_exec_params (cliprects_ptr-dirt)
[345.289913] Starting subtest: cliprects_ptr-dirt
[345.292770] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[345.388370] [013/133] (673s left) gem_partial_pwrite_pread (write-uncached)
[345.445049] Subtest write-uncached: SKIP (0.000s)
[345.510656] [014/133] (673s left) syncobj_timeline (wait-all-interrupted)
[345.568766] Starting subtest: wait-all-interrupted
[345.670367] Subtest wait-all-interrupted: SUCCESS (0.101s)
[345.747127] [015/133] (673s left) gem_exec_reloc (basic-cpu-wc-active)
[345.815175] Subtest basic-cpu-wc-active: SKIP (0.000s)
[345.883903] [016/133] (673s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[345.983250] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[345.987728] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[346.062165] [017/133] (673s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[346.230270] Starting subtest: cursor-rapid-movement-32x32
[346.280278] Subtest cursor-rapid-movement-32x32: SKIP (0.045s)
[346.548257] [018/133] (672s left) kms_pm_rpm (drm-resources-equal)
[348.184574] Starting subtest: drm-resources-equal
[353.444846] Subtest drm-resources-equal: SUCCESS (5.260s)
[353.533603] [019/133] (666s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[353.609467] Subtest tiled-to-untiled: SKIP (0.000s)
[353.679163] [020/133] (665s left) gem_ctx_persistence (engines-hang)
[353.729688] Starting subtest: engines-hang
[353.732561] Starting dynamic subtest: rcs0
[353.792315] Dynamic subtest rcs0: SUCCESS (0.062s)
[353.804969] Starting dynamic subtest: bcs0
[353.885257] Dynamic subtest bcs0: SUCCESS (0.091s)
[353.897006] Starting dynamic subtest: vcs0
[353.975464] Dynamic subtest vcs0: SUCCESS (0.089s)
[353.984907] Starting dynamic subtest: vcs1
[354.066937] Dynamic subtest vcs1: SUCCESS (0.090s)
[354.078263] Starting dynamic subtest: vecs0
[354.155601] Dynamic subtest vecs0: SUCCESS (0.087s)
[354.170964] Starting dynamic subtest: ccs0
[354.246984] Dynamic subtest ccs0: SUCCESS (0.090s)
[354.249953] Subtest engines-hang: SUCCESS (0.518s)
[354.327428] [021/133] (665s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[354.426292] Starting subtest: yf-tiled-64bpp-rotate-0
[354.429979] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[354.505659] [022/133] (665s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[354.563756] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[354.624670] [023/133] (665s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[354.716430] Starting subtest: bad-rotation-90-yf-tiled-ccs
[354.718611] Starting dynamic subtest: pipe-A-eDP-1
[354.742859] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[354.753768] Starting dynamic subtest: pipe-B-eDP-1
[354.774673] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[354.782169] Starting dynamic subtest: pipe-C-eDP-1
[354.803591] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[354.811784] Starting dynamic subtest: pipe-D-eDP-1
[354.833949] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[354.838329] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.004s)
[356.996206] [024/133] (662s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[357.053687] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[357.115095] [025/133] (662s left) gem_exec_reloc (basic-write-wc)
[357.172225] Subtest basic-write-wc: SKIP (0.000s)
[357.229752] [026/133] (662s left) gem_userptr_blits (huge-split)
[357.302480] Starting subtest: huge-split
[357.313014] Subtest huge-split: SUCCESS (0.011s)
[357.431254] [027/133] (662s left) kms_cdclk (mode-transition-all-outputs)
[357.514679] Starting subtest: mode-transition-all-outputs
[357.811669] Subtest mode-transition-all-outputs: SKIP (0.295s)
[358.609855] [028/133] (661s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[358.706731] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[362.523471] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.819s)
[363.710637] [029/133] (656s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[363.809667] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[371.202310] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.395s)
[371.324045] [030/133] (648s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[371.433529] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[371.438296] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[371.526460] [031/133] (648s left) kms_addfb_basic (addfb25-bad-modifier)
[371.630980] Starting subtest: addfb25-bad-modifier
[371.633821] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[371.715167] [032/133] (648s left) gem_exec_schedule (semaphore-user)
[371.786575] Starting subtest: semaphore-user
[371.832461] Subtest semaphore-user: SUCCESS (0.057s)
[373.021331] [033/133] (647s left) gem_exec_reloc (basic-write-gtt)
[373.079453] Subtest basic-write-gtt: SKIP (0.000s)
[373.175662] [034/133] (647s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[373.273169] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[373.275445] Starting dynamic subtest: A-eDP1
[376.934482] Dynamic subtest A-eDP1: SUCCESS (3.656s)
[376.944510] Starting dynamic subtest: B-eDP1
[380.222336] Dynamic subtest B-eDP1: SUCCESS (3.288s)
[380.232056] Starting dynamic subtest: C-eDP1
[383.527489] Dynamic subtest C-eDP1: SUCCESS (3.306s)
[383.536003] Starting dynamic subtest: D-eDP1
[386.833807] Dynamic subtest D-eDP1: SUCCESS (3.304s)
[386.836788] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.560s)
[387.702783] [035/133] (632s left) kms_psr (pr-dpms)
[387.792989] Starting subtest: pr-dpms
[387.798873] Subtest pr-dpms: SKIP (0.000s)
[387.877270] [036/133] (632s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[388.258601] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[389.074228] [037/133] (631s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[389.166837] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[393.917423] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.755s)
[395.101782] [038/133] (625s left) gem_softpin (softpin)
[395.156833] Starting subtest: softpin
[427.456954] Subtest softpin: SUCCESS (32.296s)
[427.598950] [039/133] (592s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[427.650704] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[427.655900] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[427.833472] [040/133] (592s left) kms_addfb_basic (too-high)
[427.921715] Starting subtest: too-high
[427.923905] Subtest too-high: SUCCESS (0.000s)
[428.020461] [041/133] (592s left) gen9_exec_parse (basic-rejected-ctx-param)
[428.083011] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[428.156508] [042/133] (592s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[428.248208] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[428.250828] Starting dynamic subtest: pipe-A-eDP-1
[428.318095] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[428.330875] Starting dynamic subtest: pipe-B-eDP-1
[428.400572] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[428.411102] Starting dynamic subtest: pipe-C-eDP-1
[428.480974] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[428.491900] Starting dynamic subtest: pipe-D-eDP-1
[428.558755] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[428.564206] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.009s)
[430.485191] [043/133] (590s left) kms_cursor_crc (cursor-offscreen-32x32)
[430.638409] Starting subtest: cursor-offscreen-32x32
[430.688913] Subtest cursor-offscreen-32x32: SKIP (0.048s)
[430.964650] [044/133] (589s left) gem_render_copy_redux (interruptible)
[431.025190] Starting subtest: interruptible
[431.287336] Subtest interruptible: SUCCESS (0.262s)
[431.406967] [045/133] (589s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[431.512215] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[431.524274] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.010s)
[431.618626] [046/133] (589s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[431.725227] Starting subtest: 4-tiled-32bpp-rotate-0
[433.126990] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.401s)
[433.235404] [047/133] (587s left) gem_softpin (invalid)
[433.293829] Starting subtest: invalid
[433.301361] Subtest invalid: SUCCESS (0.007s)
[433.434539] [048/133] (587s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[433.534489] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[439.999598] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.468s)
[440.111030] [049/133] (580s left) kms_psr (fbc-psr-sprite-plane-onoff)
[440.196808] Starting subtest: fbc-psr-sprite-plane-onoff
[440.199767] Starting dynamic subtest: eDP-1
[440.205017] Dynamic subtest eDP-1: SKIP (0.000s)
[440.210188] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[440.268862] [050/133] (580s left) gem_exec_whisper (basic-sync-all)
[440.346959] Starting subtest: basic-sync-all
[447.480804] Subtest basic-sync-all: SUCCESS (7.130s)
[447.671470] [051/133] (573s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[447.770715] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[447.775562] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[447.860867] [052/133] (573s left) gem_spin_batch (spin-all)
[447.919468] Starting subtest: spin-all
[447.937749] Subtest spin-all: SUCCESS (0.017s)
[450.014933] [053/133] (570s left) gem_ppgtt (shrink-vs-evict-pinned)
[450.067194] Starting subtest: shrink-vs-evict-pinned
[455.947821] Subtest shrink-vs-evict-pinned: SUCCESS (5.879s)
[456.048697] [054/133] (564s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[456.165969] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[457.190680] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.026s)
[457.322090] [055/133] (563s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[457.456674] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[457.501869] [056/133] (563s left) perf (buffer-fill)
[457.623894] Starting subtest: buffer-fill
[457.626421] Starting dynamic subtest: 0-rcs0
[459.869316] Dynamic subtest 0-rcs0: SUCCESS (2.245s)
[459.879060] Starting dynamic subtest: 1-vcs1
[464.265983] Dynamic subtest 1-vcs1: SUCCESS (4.395s)
[464.268647] Subtest buffer-fill: SUCCESS (6.642s)
[464.307368] [057/133] (556s left) syncobj_basic (illegal-fd-to-handle)
[464.370262] Starting subtest: illegal-fd-to-handle
[464.372878] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[464.467320] [058/133] (556s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[464.561295] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[464.566220] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s)
[464.634082] [059/133] (556s left) syncobj_timeline (wait-for-submit-complex)
[464.695266] Starting subtest: wait-for-submit-complex
[464.757502] Subtest wait-for-submit-complex: SUCCESS (0.064s)
[464.858859] [060/133] (556s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[464.954004] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[471.910950] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.959s)
[472.030373] [061/133] (549s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[472.093965] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[472.170826] [062/133] (549s left) gem_mmap_gtt (hang-user)
[472.226796] Subtest hang-user: SKIP (0.000s)
[472.294200] [063/133] (549s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[472.347868] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[472.350741] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[472.439622] [064/133] (549s left) api_intel_bb (simple-bb-ctx)
[472.508464] Starting subtest: simple-bb-ctx
[472.516960] Subtest simple-bb-ctx: SUCCESS (0.011s)
[472.633820] [065/133] (548s left) kms_flip (dpms-off-confusion)
[472.732958] Starting subtest: dpms-off-confusion
[472.735779] Starting dynamic subtest: A-eDP1
[481.469136] Dynamic subtest A-eDP1: SUCCESS (8.737s)
[481.483276] Starting dynamic subtest: B-eDP1
[490.171135] Dynamic subtest B-eDP1: SUCCESS (8.700s)
[490.184992] Starting dynamic subtest: C-eDP1
[498.842211] Dynamic subtest C-eDP1: SUCCESS (8.669s)
[498.851462] Starting dynamic subtest: D-eDP1
[507.455795] Dynamic subtest D-eDP1: SUCCESS (8.612s)
[507.461648] Subtest dpms-off-confusion: SUCCESS (34.728s)
[508.684316] [066/133] (512s left) kms_cursor_edge_walk (128x128-top-edge)
[508.789266] Starting subtest: 128x128-top-edge
[508.791672] Starting dynamic subtest: pipe-A-eDP-1
[512.247688] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.459s)
[512.260458] Starting dynamic subtest: pipe-D-eDP-1
[515.417585] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.164s)
[515.419768] Subtest 128x128-top-edge: SUCCESS (6.627s)
[516.289195] [067/133] (505s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[516.384906] Starting subtest: fbcpsr-tiling-4
[523.339998] Subtest fbcpsr-tiling-4: SUCCESS (6.958s)
[523.460944] [068/133] (498s left) gem_exec_async (concurrent-writes)
[523.520139] Starting subtest: concurrent-writes
[523.522864] Starting dynamic subtest: rcs0
[523.537912] Dynamic subtest rcs0: SUCCESS (0.018s)
[523.548024] Starting dynamic subtest: bcs0
[523.550490] Dynamic subtest bcs0: SUCCESS (0.007s)
[523.562331] Starting dynamic subtest: vcs0
[523.565221] Dynamic subtest vcs0: SUCCESS (0.005s)
[523.575023] Starting dynamic subtest: vcs1
[523.577625] Dynamic subtest vcs1: SUCCESS (0.005s)
[523.587969] Starting dynamic subtest: vecs0
[523.590735] Dynamic subtest vecs0: SUCCESS (0.005s)
[523.599904] Starting dynamic subtest: ccs0
[523.602628] Dynamic subtest ccs0: SUCCESS (0.008s)
[523.605197] Subtest concurrent-writes: SUCCESS (0.052s)
[523.799405] [069/133] (497s left) kms_hdr (static-toggle-dpms)
[523.890996] Starting subtest: static-toggle-dpms
[523.898720] Subtest static-toggle-dpms: SKIP (0.000s)
[523.961563] [070/133] (497s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[524.015914] Starting subtest: etime-single-wait-for-submit-unsubmitted
[524.120782] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[524.199279] [071/133] (497s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[524.315630] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[524.326545] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.011s)
[524.404092] [072/133] (497s left) gem_ctx_engines (independent)
[524.462040] Starting subtest: independent
[524.464567] Starting dynamic subtest: rcs0
[524.585455] Dynamic subtest rcs0: SUCCESS (0.122s)
[524.594531] Starting dynamic subtest: bcs0
[524.695604] Dynamic subtest bcs0: SUCCESS (0.110s)
[524.706621] Starting dynamic subtest: vcs0
[524.812221] Dynamic subtest vcs0: SUCCESS (0.115s)
[524.823396] Starting dynamic subtest: vcs1
[524.932451] Dynamic subtest vcs1: SUCCESS (0.119s)
[524.945963] Starting dynamic subtest: vecs0
[525.051882] Dynamic subtest vecs0: SUCCESS (0.118s)
[525.064762] Starting dynamic subtest: ccs0
[525.174286] Dynamic subtest ccs0: SUCCESS (0.121s)
[525.186491] Starting dynamic subtest: all-engines
[525.654787] Dynamic subtest all-engines: SUCCESS (0.481s)
[525.657477] Subtest independent: SUCCESS (1.192s)
[526.135387] [073/133] (495s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[526.237745] Starting subtest: psr2-plane-move-sf-dmg-area
[526.240307] Starting dynamic subtest: pipe-A-eDP-1
[530.728705] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.493s)
[530.739508] Starting dynamic subtest: pipe-B-eDP-1
[535.944461] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.212s)
[535.946678] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.708s)
[536.779796] [074/133] (485s left) kms_plane_scaling (planes-upscale-factor-0-25)
[536.905510] Starting subtest: planes-upscale-factor-0-25
[536.908099] Starting dynamic subtest: pipe-A
[536.974894] Dynamic subtest pipe-A: SUCCESS (0.070s)
[536.985153] Starting dynamic subtest: pipe-B
[538.170125] Dynamic subtest pipe-B: SUCCESS (1.193s)
[538.182341] Starting dynamic subtest: pipe-C
[539.251708] Dynamic subtest pipe-C: SUCCESS (1.080s)
[539.261843] Starting dynamic subtest: pipe-D
[540.350426] Dynamic subtest pipe-D: SUCCESS (1.098s)
[540.352973] Subtest planes-upscale-factor-0-25: SUCCESS (3.447s)
[541.486740] [075/133] (480s left) kms_big_fb (linear-8bpp-rotate-180)
[541.589747] Starting subtest: linear-8bpp-rotate-180
[542.825740] Subtest linear-8bpp-rotate-180: SUCCESS (1.236s)
[542.947808] [076/133] (478s left) kms_addfb_basic (bad-pitch-128)
[542.998973] Starting subtest: bad-pitch-128
[543.001010] Subtest bad-pitch-128: SUCCESS (0.000s)
[543.118497] [077/133] (478s left) kms_color_pipeline (plane-ctm3x4)
[543.214722] Starting subtest: plane-ctm3x4
[543.339006] Starting dynamic subtest: pipe-A-plane-0
[543.527714] Dynamic subtest pipe-A-plane-0: SUCCESS (0.189s)
[543.537419] Starting dynamic subtest: pipe-A-plane-1
[543.638681] Dynamic subtest pipe-A-plane-1: SUCCESS (0.110s)
[543.648261] Starting dynamic subtest: pipe-A-plane-2
[543.750238] Dynamic subtest pipe-A-plane-2: SUCCESS (0.110s)
[544.934704] Starting dynamic subtest: pipe-B-plane-0
[545.090788] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[545.103549] Starting dynamic subtest: pipe-B-plane-1
[545.269958] Dynamic subtest pipe-B-plane-1: SUCCESS (0.175s)
[545.279882] Starting dynamic subtest: pipe-B-plane-2
[545.379906] Dynamic subtest pipe-B-plane-2: SUCCESS (0.110s)
[546.548587] Starting dynamic subtest: pipe-C-plane-0
[546.651451] Dynamic subtest pipe-C-plane-0: SUCCESS (0.111s)
[546.660554] Starting dynamic subtest: pipe-C-plane-1
[546.762979] Dynamic subtest pipe-C-plane-1: SUCCESS (0.110s)
[546.772758] Starting dynamic subtest: pipe-C-plane-2
[546.873793] Dynamic subtest pipe-C-plane-2: SUCCESS (0.110s)
[548.042666] Starting dynamic subtest: pipe-D-plane-0
[548.146974] Dynamic subtest pipe-D-plane-0: SUCCESS (0.111s)
[548.156803] Starting dynamic subtest: pipe-D-plane-1
[548.261754] Dynamic subtest pipe-D-plane-1: SUCCESS (0.111s)
[548.271333] Starting dynamic subtest: pipe-D-plane-2
[548.391107] Dynamic subtest pipe-D-plane-2: SUCCESS (0.130s)
[548.676610] Subtest plane-ctm3x4: SUCCESS (5.462s)
[549.481092] [078/133] (472s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[549.586698] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[556.806946] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.224s)
[556.948376] [079/133] (465s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[557.042706] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[557.045203] Starting dynamic subtest: pipe-A-eDP-1
[557.055797] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[557.066519] Starting dynamic subtest: pipe-B-eDP-1
[557.076638] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[557.086596] Starting dynamic subtest: pipe-C-eDP-1
[557.096418] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[557.105785] Starting dynamic subtest: pipe-D-eDP-1
[557.115990] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[557.121057] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[559.287256] [080/133] (462s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[559.381854] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[559.387103] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[559.477200] [081/133] (462s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[559.578255] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[559.604110] Starting dynamic subtest: pipe-A-plane-0
[560.281229] Dynamic subtest pipe-A-plane-0: SUCCESS (0.677s)
[560.290646] Starting dynamic subtest: pipe-A-plane-3
[560.705557] Dynamic subtest pipe-A-plane-3: SUCCESS (0.421s)
[561.836893] Starting dynamic subtest: pipe-B-plane-0
[562.473956] Dynamic subtest pipe-B-plane-0: SUCCESS (0.644s)
[562.484022] Starting dynamic subtest: pipe-B-plane-3
[562.884544] Dynamic subtest pipe-B-plane-3: SUCCESS (0.410s)
[563.203979] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (3.628s)
[564.081389] [082/133] (458s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[564.179860] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[564.184852] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[564.278944] [083/133] (457s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[564.375762] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[564.380575] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[564.459754] [084/133] (457s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[564.554286] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[564.559518] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[564.647024] [085/133] (457s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[564.749784] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[564.754945] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[564.849915] [086/133] (457s left) gem_basic (multigpu-create-close)
[564.911019] Starting subtest: multigpu-create-close
[564.916757] Subtest multigpu-create-close: SKIP (0.000s)
[565.028014] [087/133] (457s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[565.123459] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[565.127806] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[566.284329] [088/133] (456s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[566.389989] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[566.394582] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[566.485939] [089/133] (455s left) gem_exec_gttfill (basic)
[566.545825] Starting subtest: basic
[569.192716] Subtest basic: SUCCESS (2.646s)
[569.376890] [090/133] (453s left) kms_flip (basic-flip-vs-dpms)
[569.525143] Starting subtest: basic-flip-vs-dpms
[569.527465] Starting dynamic subtest: A-eDP1
[572.128540] Dynamic subtest A-eDP1: SUCCESS (2.601s)
[572.138489] Starting dynamic subtest: B-eDP1
[574.318978] Dynamic subtest B-eDP1: SUCCESS (2.190s)
[574.331289] Starting dynamic subtest: C-eDP1
[576.503944] Dynamic subtest C-eDP1: SUCCESS (2.184s)
[576.514978] Starting dynamic subtest: D-eDP1
[578.707908] Dynamic subtest D-eDP1: SUCCESS (2.202s)
[578.710597] Subtest basic-flip-vs-dpms: SUCCESS (9.185s)
[579.587356] [091/133] (442s left) sriov_basic (enable-vfs-autoprobe-on)
[579.642741] Starting subtest: enable-vfs-autoprobe-on
[579.645467] Starting dynamic subtest: numvfs-1
[579.732744] Dynamic subtest numvfs-1: FAIL (0.031s)
[579.744912] Starting dynamic subtest: numvfs-2
[579.828743] Dynamic subtest numvfs-2: FAIL (0.004s)
[579.839556] Starting dynamic subtest: numvfs-3
[579.926436] Dynamic subtest numvfs-3: FAIL (0.003s)
[579.936786] Starting dynamic subtest: numvfs-4
[580.021773] Dynamic subtest numvfs-4: FAIL (0.003s)
[580.032730] Starting dynamic subtest: numvfs-5
[580.119688] Dynamic subtest numvfs-5: FAIL (0.004s)
[580.129783] Starting dynamic subtest: numvfs-6
[580.215368] Dynamic subtest numvfs-6: FAIL (0.004s)
[580.226063] Starting dynamic subtest: numvfs-7
[580.311378] Dynamic subtest numvfs-7: FAIL (0.004s)
[580.324382] Starting dynamic subtest: numvfs-random
[580.408717] Dynamic subtest numvfs-random: FAIL (0.004s)
[580.418909] Starting dynamic subtest: numvfs-all
[580.505757] Dynamic subtest numvfs-all: FAIL (0.595s)
[580.508156] Subtest enable-vfs-autoprobe-on: FAIL (0.658s)
[580.546638] [092/133] (442s left) api_intel_allocator (two-level-inception)
[580.597175] Starting subtest: two-level-inception
[585.996486] Subtest two-level-inception: SUCCESS (5.400s)
[586.116908] [093/133] (436s left) perf_pmu (all-busy-idle-check-all)
[586.160698] Starting subtest: all-busy-idle-check-all
[588.023906] Subtest all-busy-idle-check-all: SUCCESS (1.864s)
[588.148961] [094/133] (434s left) kms_pm_rpm (modeset-non-lpsp-stress)
[590.177194] Starting subtest: modeset-non-lpsp-stress
[591.333804] Subtest modeset-non-lpsp-stress: SKIP (1.154s)
[591.712215] [095/133] (431s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[591.780480] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[591.889739] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.107s)
[591.964192] [096/133] (430s left) gem_exec_whisper (basic-normal)
[592.023857] Starting subtest: basic-normal
[595.702982] Subtest basic-normal: SUCCESS (3.679s)
[595.886901] [097/133] (426s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[595.985731] Starting subtest: 4-tiled-16bpp-rotate-180
[597.342799] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.357s)
[597.462817] [098/133] (425s left) gem_exec_schedule (pi-shared-iova)
[597.644881] Starting subtest: pi-shared-iova
[597.647677] Starting dynamic subtest: rcs0
[597.731383] Dynamic subtest rcs0: SUCCESS (0.090s)
[597.746547] Starting dynamic subtest: vcs0
[597.787902] Dynamic subtest vcs0: SUCCESS (0.055s)
[597.801568] Starting dynamic subtest: vcs1
[597.847735] Dynamic subtest vcs1: SUCCESS (0.059s)
[597.860363] Starting dynamic subtest: vecs0
[597.899902] Dynamic subtest vecs0: SUCCESS (0.052s)
[597.912902] Starting dynamic subtest: ccs0
[597.962961] Dynamic subtest ccs0: SUCCESS (0.062s)
[597.965794] Subtest pi-shared-iova: SUCCESS (0.322s)
[599.049583] [099/133] (423s left) i915_drm_fdinfo (idle)
[599.097997] Starting subtest: idle
[599.100806] Starting dynamic subtest: rcs0
[599.657265] Dynamic subtest rcs0: SUCCESS (0.558s)
[599.669846] Starting dynamic subtest: bcs0
[600.167837] Dynamic subtest bcs0: SUCCESS (0.503s)
[600.177960] Starting dynamic subtest: vcs0
[600.670289] Dynamic subtest vcs0: SUCCESS (0.503s)
[600.683017] Starting dynamic subtest: vcs1
[601.175287] Dynamic subtest vcs1: SUCCESS (0.503s)
[601.187980] Starting dynamic subtest: vecs0
[601.681153] Dynamic subtest vecs0: SUCCESS (0.503s)
[601.694242] Starting dynamic subtest: ccs0
[602.187205] Dynamic subtest ccs0: SUCCESS (0.503s)
[602.189982] Subtest idle: SUCCESS (3.089s)
[602.276817] [100/133] (420s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[602.384772] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[602.389854] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[602.474754] [101/133] (420s left) perf_pmu (busy-accuracy-50)
[602.520682] Starting subtest: busy-accuracy-50
[602.523364] Starting dynamic subtest: rcs0
[604.051431] Dynamic subtest rcs0: SUCCESS (1.530s)
[604.061971] Starting dynamic subtest: bcs0
[605.594157] Dynamic subtest bcs0: SUCCESS (1.541s)
[605.607336] Starting dynamic subtest: vcs0
[607.141194] Dynamic subtest vcs0: SUCCESS (1.544s)
[607.154764] Starting dynamic subtest: vcs1
[608.681654] Dynamic subtest vcs1: SUCCESS (1.538s)
[608.692129] Starting dynamic subtest: vecs0
[610.222774] Dynamic subtest vecs0: SUCCESS (1.539s)
[610.232866] Starting dynamic subtest: ccs0
[611.770516] Dynamic subtest ccs0: SUCCESS (1.545s)
[611.773334] Subtest busy-accuracy-50: SUCCESS (9.249s)
[611.881728] [102/133] (411s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[611.947563] Starting subtest: multi-wait-all-available-submitted-signaled
[611.949977] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[612.049215] [103/133] (410s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[612.145835] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[612.151225] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[612.249229] [104/133] (410s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[612.353865] Starting subtest: psr2-cursor-plane-move-continuous-sf
[612.356595] Starting dynamic subtest: pipe-A-eDP-1
[622.718991] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.366s)
[622.741072] Starting dynamic subtest: pipe-B-eDP-1
[633.841015] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.120s)
[633.843967] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.490s)
[634.678887] [105/133] (388s left) gem_partial_pwrite_pread (reads-display)
[634.737887] Subtest reads-display: SKIP (0.000s)
[634.808090] [106/133] (388s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[634.960244] Starting subtest: dp-mst-lic-type-0-hdcp14
[634.965802] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[635.076915] [107/133] (388s left) gem_reg_read (bad-register)
[635.134205] Starting subtest: bad-register
[635.136850] Subtest bad-register: SUCCESS (0.000s)
[635.239531] [108/133] (388s left) gem_ctx_persistence (heartbeat-hang)
[635.292794] Starting subtest: heartbeat-hang
[635.297785] Subtest heartbeat-hang: SKIP (0.000s)
[635.406430] [109/133] (387s left) syncobj_eventfd (timeline-wait-before-signal)
[635.467818] Starting subtest: timeline-wait-before-signal
[635.497961] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[635.576419] [110/133] (387s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[635.669573] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[640.056947] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.391s)
[641.187695] [111/133] (382s left) kms_psr (psr2-primary-mmap-cpu)
[641.283786] Starting subtest: psr2-primary-mmap-cpu
[641.286794] Starting dynamic subtest: eDP-1
[643.039667] Dynamic subtest eDP-1: SUCCESS (1.755s)
[643.042469] Subtest psr2-primary-mmap-cpu: SUCCESS (1.756s)
[643.869602] [112/133] (379s left) kms_atomic_interruptible (legacy-pageflip)
[643.954416] Starting subtest: legacy-pageflip
[643.956914] Starting dynamic subtest: pipe-A-eDP-1
[651.358373] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.400s)
[651.360712] Subtest legacy-pageflip: SUCCESS (7.402s)
[652.173554] [113/133] (371s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[652.282007] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[652.287571] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[652.387865] [114/133] (371s left) kms_addfb_basic (unused-offsets)
[652.449214] Starting subtest: unused-offsets
[652.451769] Subtest unused-offsets: SUCCESS (0.000s)
[652.581383] [115/133] (370s left) dmabuf_sync_file (export-wait-after-attach)
[652.688557] Starting subtest: export-wait-after-attach
[652.691348] Subtest export-wait-after-attach: SUCCESS (0.001s)
[652.742634] [FACT dmabuf_sync_file (export-wait-after-attach)] new: kernel.kmod_is_loaded.vgem: true
[652.746152] [116/133] (370s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[652.831687] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[652.834484] Starting dynamic subtest: pipe-A
[652.956962] Dynamic subtest pipe-A: SKIP (0.119s)
[652.967645] Starting dynamic subtest: pipe-B
[654.128318] Dynamic subtest pipe-B: SKIP (1.172s)
[654.141223] Starting dynamic subtest: pipe-C
[655.308005] Dynamic subtest pipe-C: SUCCESS (1.186s)
[655.319015] Starting dynamic subtest: pipe-D
[656.504914] Dynamic subtest pipe-D: SUCCESS (1.196s)
[656.507859] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.676s)
[657.687094] [117/133] (365s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[658.070404] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[658.853638] [118/133] (364s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[658.915965] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[658.920944] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[659.101360] [119/133] (364s left) perf_pmu (most-busy-idle-check-all)
[659.148021] Starting subtest: most-busy-idle-check-all
[659.150688] Starting dynamic subtest: rcs0
[660.981360] Dynamic subtest rcs0: SUCCESS (1.835s)
[660.993660] Starting dynamic subtest: bcs0
[662.966902] Dynamic subtest bcs0: SUCCESS (1.982s)
[662.979983] Starting dynamic subtest: vcs0
[665.013556] Dynamic subtest vcs0: SUCCESS (2.044s)
[665.027120] Starting dynamic subtest: vcs1
[666.998596] Dynamic subtest vcs1: SUCCESS (1.983s)
[667.013205] Starting dynamic subtest: vecs0
[668.982502] Dynamic subtest vecs0: SUCCESS (1.981s)
[668.996025] Starting dynamic subtest: ccs0
[670.967850] Dynamic subtest ccs0: SUCCESS (1.982s)
[670.970969] Subtest most-busy-idle-check-all: SUCCESS (11.823s)
[671.105572] [120/133] (352s left) kms_flip (flip-vs-fences)
[671.211001] Starting subtest: flip-vs-fences
[671.215656] Subtest flip-vs-fences: SKIP (0.000s)
[671.322679] [121/133] (352s left) gem_exec_fence (syncobj-export)
[671.731347] Starting subtest: syncobj-export
[671.738631] Subtest syncobj-export: SUCCESS (0.007s)
[673.098844] [122/133] (350s left) i915_power (sanity)
[673.153573] Starting subtest: sanity
[677.206782] Subtest sanity: SUCCESS (4.046s)
[679.051536] [123/133] (344s left) kms_getfb (getfb2-accept-nv12)
[679.148221] Starting subtest: getfb2-accept-nv12
[679.150951] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[679.245427] [124/133] (344s left) i915_drm_fdinfo (virtual-busy-idle)
[679.294737] Starting subtest: virtual-busy-idle
[679.299847] Subtest virtual-busy-idle: SKIP (0.000s)
[679.366105] [125/133] (344s left) gem_exec_balancer (invalid-bonds)
[679.422780] Starting subtest: invalid-bonds
[679.428630] Subtest invalid-bonds: SKIP (0.000s)
[679.707242] [126/133] (344s left) gem_exec_fence (syncobj-timeline-signal)
[680.217534] Starting subtest: syncobj-timeline-signal
[680.225335] Subtest syncobj-timeline-signal: SUCCESS (0.008s)
[682.080539] [127/133] (342s left) kms_psr (psr-primary-render)
[682.182171] Starting subtest: psr-primary-render
[682.184826] Starting dynamic subtest: eDP-1
[683.940773] Dynamic subtest eDP-1: SUCCESS (1.760s)
[683.943716] Subtest psr-primary-render: SUCCESS (1.761s)
[684.774513] [128/133] (339s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[684.863968] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[684.868777] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[684.931634] [129/133] (339s left) kms_plane_lowres (tiling-none)
[685.014978] Starting subtest: tiling-none
[685.017396] Starting dynamic subtest: pipe-A-eDP-1
[685.021883] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[685.311421] Starting dynamic subtest: pipe-B-eDP-1
[685.315885] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[685.328164] Starting dynamic subtest: pipe-C-eDP-1
[685.332986] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[685.342968] Starting dynamic subtest: pipe-D-eDP-1
[685.347842] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[685.352782] Subtest tiling-none: SKIP (0.295s)
[686.176482] [130/133] (338s left) kms_draw_crc (draw-method-render)
[686.275647] Starting subtest: draw-method-render
[686.277870] Starting dynamic subtest: xrgb8888-untiled
[686.517757] Dynamic subtest xrgb8888-untiled: SUCCESS (0.244s)
[686.528533] Starting dynamic subtest: rgb565-untiled
[686.761776] Dynamic subtest rgb565-untiled: SUCCESS (0.242s)
[686.771833] Starting dynamic subtest: xrgb2101010-untiled
[686.984635] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[686.994974] Starting dynamic subtest: xbgr16161616f-untiled
[687.206294] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[687.216603] Starting dynamic subtest: xrgb8888-xtiled
[687.328292] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[687.340448] Starting dynamic subtest: rgb565-xtiled
[687.439170] Dynamic subtest rgb565-xtiled: SUCCESS (0.110s)
[687.449593] Starting dynamic subtest: xrgb2101010-xtiled
[687.550592] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[687.560903] Starting dynamic subtest: xbgr16161616f-xtiled
[687.672864] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.122s)
[687.683235] Starting dynamic subtest: xrgb8888-4tiled
[687.806493] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s)
[687.816894] Starting dynamic subtest: rgb565-4tiled
[687.917404] Dynamic subtest rgb565-4tiled: SUCCESS (0.110s)
[687.928121] Starting dynamic subtest: xrgb2101010-4tiled
[688.028530] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.110s)
[688.039710] Starting dynamic subtest: xbgr16161616f-4tiled
[688.150964] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.121s)
[688.153718] Subtest draw-method-render: SUCCESS (1.878s)
[688.261024] [131/133] (335s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[688.332284] Subtest writes-after-reads: SKIP (0.000s)
[688.400733] [132/133] (335s left) gem_userptr_blits (process-exit-busy)
[688.458747] Starting subtest: process-exit-busy
[688.475831] Subtest process-exit-busy: SUCCESS (0.018s)
[688.586944] [133/133] (335s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[688.679561] Starting subtest: fbc-psr2-cursor-plane-onoff
[688.681723] Starting dynamic subtest: eDP-1
[688.686243] Dynamic subtest eDP-1: SKIP (0.000s)
[688.690767] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.002s)
[688.763343] Closing watchdogs
results: parsing output: 0/ for test: kms_force_connector_basic
results: parsing output: 1/ for test: kms_pipe_crc_basic
results: parsing output: 2/ for test: kms_async_flips
results: parsing output: 3/ for test: kms_flip
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_vblank
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: syncobj_wait
results: parsing output: 8/ for test: kms_cursor_legacy
results: parsing output: 9/ for test: gem_exec_balancer
results: parsing output: 10/ for test: i915_pm_freq_mult
results: parsing output: 11/ for test: gem_exec_params
results: parsing output: 12/ for test: gem_partial_pwrite_pread
results: parsing output: 13/ for test: syncobj_timeline
results: parsing output: 14/ for test: gem_exec_reloc
results: parsing output: 15/ for test: kms_joiner
results: parsing output: 16/ for test: kms_cursor_crc
results: parsing output: 17/ for test: kms_pm_rpm
results: parsing output: 18/ for test: gem_set_tiling_vs_blt
results: parsing output: 19/ for test: gem_ctx_persistence
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: gem_mmap_gtt
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: kms_pipe_b_c_ivb
results: parsing output: 24/ for test: gem_exec_reloc
results: parsing output: 25/ for test: gem_userptr_blits
results: parsing output: 26/ for test: kms_cdclk
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_addfb_basic
results: parsing output: 31/ for test: gem_exec_schedule
results: parsing output: 32/ for test: gem_exec_reloc
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: kms_chamelium_hpd
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_softpin
results: parsing output: 38/ for test: gem_render_copy
results: parsing output: 39/ for test: kms_addfb_basic
results: parsing output: 40/ for test: gen9_exec_parse
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: gem_render_copy_redux
results: parsing output: 44/ for test: kms_flip
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: gem_softpin
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: gem_exec_whisper
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_spin_batch
results: parsing output: 52/ for test: gem_ppgtt
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: kms_tiled_display
results: parsing output: 55/ for test: perf
results: parsing output: 56/ for test: syncobj_basic
results: parsing output: 57/ for test: kms_flip_scaled_crc
results: parsing output: 58/ for test: syncobj_timeline
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_exec_reloc
results: parsing output: 61/ for test: gem_mmap_gtt
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: api_intel_bb
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: kms_cursor_edge_walk
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_exec_async
results: parsing output: 68/ for test: kms_hdr
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: gem_ctx_engines
results: parsing output: 72/ for test: kms_psr2_sf
results: parsing output: 73/ for test: kms_plane_scaling
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: kms_addfb_basic
results: parsing output: 76/ for test: kms_color_pipeline
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_plane
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: gem_basic
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_exec_gttfill
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: sriov_basic
results: parsing output: 91/ for test: api_intel_allocator
results: parsing output: 92/ for test: perf_pmu
results: parsing output: 93/ for test: kms_pm_rpm
results: parsing output: 94/ for test: syncobj_wait
results: parsing output: 95/ for test: gem_exec_whisper
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: gem_exec_schedule
results: parsing output: 98/ for test: i915_drm_fdinfo
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: perf_pmu
results: parsing output: 101/ for test: syncobj_timeline
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_psr2_sf
results: parsing output: 104/ for test: gem_partial_pwrite_pread
results: parsing output: 105/ for test: kms_content_protection
results: parsing output: 106/ for test: gem_reg_read
results: parsing output: 107/ for test: gem_ctx_persistence
results: parsing output: 108/ for test: syncobj_eventfd
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: kms_atomic_interruptible
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: kms_addfb_basic
results: parsing output: 114/ for test: dmabuf_sync_file
results: parsing output: 115/ for test: kms_plane_scaling
results: parsing output: 116/ for test: kms_chamelium_edid
results: parsing output: 117/ for test: gem_render_copy
results: parsing output: 118/ for test: perf_pmu
results: parsing output: 119/ for test: kms_flip
results: parsing output: 120/ for test: gem_exec_fence
results: parsing output: 121/ for test: i915_power
results: parsing output: 122/ for test: kms_getfb
results: parsing output: 123/ for test: i915_drm_fdinfo
results: parsing output: 124/ for test: gem_exec_balancer
results: parsing output: 125/ for test: gem_exec_fence
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: kms_psr2_sf
results: parsing output: 128/ for test: kms_plane_lowres
results: parsing output: 129/ for test: kms_draw_crc
results: parsing output: 130/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 131/ for test: gem_userptr_blits
results: parsing output: 132/ for test: kms_psr
Done.