[59.300253] Initializing watchdogs
[59.300298]   /dev/watchdog0
[59.313732] [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]
[59.317803] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.320138] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.323578] [001/131] (960s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[59.455021] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[59.457190] Starting dynamic subtest: pipe-A-eDP-1
[92.043190] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.514s)
[92.052210] Starting dynamic subtest: pipe-B-eDP-1
[125.006006] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.107s)
[125.014818] Starting dynamic subtest: pipe-C-eDP-1
[157.986809] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.678s)
[157.999825] Starting dynamic subtest: pipe-D-eDP-1
[190.965051] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.623s)
[190.967525] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (17.926s)
[192.206447] [002/131] (827s left) kms_psr (fbc-psr2-primary-page-flip)
[192.317818] Starting subtest: fbc-psr2-primary-page-flip
[192.320540] Starting dynamic subtest: eDP-1
[192.325681] Dynamic subtest eDP-1: SKIP (0.000s)
[192.330927] Subtest fbc-psr2-primary-page-flip: SKIP (0.000s)
[192.408941] [003/131] (827s left) kms_flip (2x-flip-vs-dpms-on-nop)
[192.528339] Starting subtest: 2x-flip-vs-dpms-on-nop
[192.536661] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.010s)
[192.687416] [004/131] (827s left) kms_big_fb (y-tiled-addfb)
[192.794844] Starting subtest: y-tiled-addfb
[192.799059] Subtest y-tiled-addfb: SKIP (0.000s)
[192.923069] [005/131] (827s left) kms_cursor_crc (cursor-offscreen-128x128)
[193.125907] Starting subtest: cursor-offscreen-128x128
[193.128549] Starting dynamic subtest: pipe-A-eDP-1
[195.067433] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.944s)
[195.091325] Starting dynamic subtest: pipe-D-eDP-1
[197.683396] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.605s)
[197.686325] Subtest cursor-offscreen-128x128: SUCCESS (4.572s)
[198.559222] [006/131] (821s left) gem_vm_create (execbuf)
[198.622011] Starting subtest: execbuf
[198.630892] Subtest execbuf: SUCCESS (0.009s)
[198.776877] [007/131] (821s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[198.853856] Starting subtest: rel-constants-invalid-rel-gen5
[198.856869] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[199.003441] [008/131] (821s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[199.111852] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[203.095323] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (3.996s)
[204.256582] [009/131] (815s left) gem_mmap_gtt (basic-small-bo-tiledy)
[204.314601] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[204.374066] [010/131] (815s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[204.474828] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[204.479850] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[204.614905] [011/131] (815s left) kms_flip (absolute-wf_vblank)
[204.714799] Starting subtest: absolute-wf_vblank
[204.717557] Starting dynamic subtest: A-eDP1
[213.477672] Dynamic subtest A-eDP1: SUCCESS (8.774s)
[213.490850] Starting dynamic subtest: B-eDP1
[222.198255] Dynamic subtest B-eDP1: SUCCESS (8.725s)
[222.205852] Starting dynamic subtest: C-eDP1
[230.925021] Dynamic subtest C-eDP1: SUCCESS (8.722s)
[230.934757] Starting dynamic subtest: D-eDP1
[239.660506] Dynamic subtest D-eDP1: SUCCESS (8.733s)
[239.666180] Subtest absolute-wf_vblank: SUCCESS (34.964s)
[240.899506] [012/131] (779s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[241.001953] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[247.708087] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.710s)
[247.853249] [013/131] (772s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[248.411040] Starting subtest: syncobj-timeline-invalid-wait
[248.413891] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s)
[249.636174] [FACT gem_exec_fence (syncobj-timeline-invalid-wait)] new: kernel.kmod_is_loaded.vgem: true
[249.639604] [014/131] (770s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[254.780059] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[254.785837] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[255.662546] [015/131] (764s left) device_reset (unbind-reset-rebind)
[255.717343] Starting subtest: unbind-reset-rebind
[260.453831] Subtest unbind-reset-rebind: SUCCESS (4.733s)
[260.495282] [016/131] (759s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[260.603397] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[260.607587] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[260.737717] [017/131] (759s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[260.840898] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[260.845049] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[260.986310] [018/131] (759s left) api_intel_allocator (reopen)
[261.056071] Starting subtest: reopen
[261.058675] Subtest reopen: SUCCESS (0.004s)
[261.199043] [019/131] (759s left) gem_ctx_param (non-root-set)
[261.258908] Starting subtest: non-root-set
[261.277735] Subtest non-root-set: SUCCESS (0.018s)
[261.390534] [020/131] (759s left) gem_sync (basic-each)
[261.467299] Starting subtest: basic-each
[263.938309] Subtest basic-each: SUCCESS (2.484s)
[264.145440] [021/131] (756s left) gem_partial_pwrite_pread (reads-snoop)
[264.211036] Subtest reads-snoop: SKIP (0.000s)
[264.281356] [022/131] (756s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[264.386041] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[264.391722] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[264.521912] [023/131] (756s left) kms_pm_rpm (fences)
[266.747425] Starting subtest: fences
[266.752876] Subtest fences: SKIP (0.000s)
[267.146304] [024/131] (753s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[267.260697] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[267.265836] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[267.393908] [025/131] (753s left) kms_flip (flip-vs-modeset-vs-hang)
[267.493482] Starting subtest: flip-vs-modeset-vs-hang
[267.495904] Starting dynamic subtest: A-eDP1
[319.011887] Dynamic subtest A-eDP1: SUCCESS (51.518s)
[319.020475] Starting dynamic subtest: D-eDP1
[368.995766] Dynamic subtest D-eDP1: SUCCESS (49.986s)
[368.998506] Subtest flip-vs-modeset-vs-hang: SUCCESS (101.508s)
[369.413101] [026/131] (651s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[374.467999] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf
[374.473846] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.002s)
[375.328740] [027/131] (645s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[375.385939] Starting subtest: etime-single-wait-all-available-unsubmitted
[375.486055] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.101s)
[375.585389] [028/131] (645s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[375.679951] Starting subtest: fbc-pr-sprite-mmap-cpu
[375.685425] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[375.777361] [029/131] (645s left) kms_addfb_basic (small-bo)
[375.871741] Starting subtest: small-bo
[375.873800] Subtest small-bo: SUCCESS (0.000s)
[375.989309] [030/131] (644s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[376.091785] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[376.096727] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[376.208182] [031/131] (644s left) fbdev (eof)
[376.254772] Starting subtest: eof
[376.256838] Subtest eof: SUCCESS (0.000s)
[376.359343] [032/131] (644s left) syncobj_timeline (reset-signaled)
[376.410471] Starting subtest: reset-signaled
[376.412524] Subtest reset-signaled: SUCCESS (0.000s)
[376.537283] [033/131] (644s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[376.931559] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[377.727744] [034/131] (643s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[377.790327] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[377.895065] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.105s)
[377.995365] [035/131] (643s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[378.091037] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[378.093742] Starting dynamic subtest: pipe-A-default-mode
[378.393059] Dynamic subtest pipe-A-default-mode: SKIP (0.299s)
[378.398209] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.300s)
[379.209568] [036/131] (642s left) gem_softpin (evict-snoop-interruptible)
[379.282832] Starting subtest: evict-snoop-interruptible
[379.288083] Subtest evict-snoop-interruptible: SKIP (0.000s)
[379.421649] [037/131] (641s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[379.525852] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[380.762143] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: FAIL (0.535s)
[380.801320] [038/131] (640s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[380.896636] Starting subtest: plane-upscale-factor-0-25-with-rotation
[380.898711] Starting dynamic subtest: pipe-A
[381.121776] Dynamic subtest pipe-A: SUCCESS (0.226s)
[381.139416] Starting dynamic subtest: pipe-B
[382.386601] Dynamic subtest pipe-B: SUCCESS (1.263s)
[382.394730] Starting dynamic subtest: pipe-C
[383.746177] Dynamic subtest pipe-C: SUCCESS (1.359s)
[383.754732] Starting dynamic subtest: pipe-D
[385.059914] Dynamic subtest pipe-D: SUCCESS (1.313s)
[385.063063] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.166s)
[386.251517] [039/131] (635s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[386.353016] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[386.359041] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[386.475935] [040/131] (634s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[386.585277] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[387.253314] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.670s)
[387.473289] [041/131] (633s left) gem_render_copy_redux (flink)
[387.529794] Starting subtest: flink
[388.248097] Subtest flink: SUCCESS (0.720s)
[388.414163] [042/131] (633s left) perf (low-oa-exponent-permissions)
[388.557244] Starting subtest: low-oa-exponent-permissions
[388.589834] Subtest low-oa-exponent-permissions: SUCCESS (0.034s)
[388.638416] [043/131] (632s left) kms_scaling_modes (scaling-mode-full-aspect)
[388.740631] Starting subtest: scaling-mode-full-aspect
[388.742802] Starting dynamic subtest: pipe-A-eDP-1
[388.834676] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.095s)
[388.848566] Starting dynamic subtest: pipe-B-eDP-1
[389.963752] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.127s)
[389.973376] Starting dynamic subtest: pipe-C-eDP-1
[391.075763] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.110s)
[391.084913] Starting dynamic subtest: pipe-D-eDP-1
[392.218744] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.142s)
[392.221056] Subtest scaling-mode-full-aspect: SUCCESS (3.480s)
[393.407076] [044/131] (628s left) kms_getfb (getfb2-handle-protection)
[393.499009] Starting subtest: getfb2-handle-protection
[393.527086] Subtest getfb2-handle-protection: SUCCESS (0.029s)
[393.685808] [045/131] (627s left) gem_eio (wait-wedge-10ms)
[393.921665] Starting subtest: wait-wedge-10ms
[395.613205] Subtest wait-wedge-10ms: SUCCESS (1.691s)
[395.792496] [046/131] (625s left) kms_legacy_colorkey (invalid-plane)
[395.889932] Starting subtest: invalid-plane
[395.892630] Starting dynamic subtest: zero-id
[395.895009] Dynamic subtest zero-id: SUCCESS (0.000s)
[395.904537] Starting dynamic subtest: outrange-id
[395.906615] Dynamic subtest outrange-id: SUCCESS (0.000s)
[395.908769] Subtest invalid-plane: SUCCESS (0.001s)
[395.985193] [047/131] (625s left) gem_exec_balancer (invalid-bonds)
[396.040766] Starting subtest: invalid-bonds
[396.047822] Subtest invalid-bonds: SKIP (0.000s)
[396.356746] [048/131] (625s left) kms_cursor_crc (cursor-sliding-128x42)
[396.585499] Starting subtest: cursor-sliding-128x42
[396.630755] Subtest cursor-sliding-128x42: SKIP (0.038s)
[396.881514] [049/131] (624s left) syncobj_timeline (multi-wait-available-signaled)
[396.944639] Starting subtest: multi-wait-available-signaled
[396.947420] Subtest multi-wait-available-signaled: SUCCESS (0.000s)
[397.088863] [050/131] (624s left) kms_selftest (drm_format_helper)
[397.123437] Starting subtest: drm_format_helper
[397.149669] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[397.296453] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.148s)
[397.305914] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[397.492794] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.165s)
[397.501318] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[397.639684] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.173s)
[397.648373] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[397.809626] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.169s)
[397.818829] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[397.976356] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.168s)
[397.985228] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[398.123206] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.142s)
[398.132179] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[398.282722] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.159s)
[398.292053] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[398.429931] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.144s)
[398.439459] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[398.556198] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.125s)
[398.566733] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[398.685883] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.129s)
[398.695712] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[398.793912] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.110s)
[398.803590] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[398.953280] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.158s)
[398.962673] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[399.101915] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.147s)
[399.110524] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[399.253918] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.150s)
[399.263976] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[399.385330] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.132s)
[399.394315] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[399.494833] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.108s)
[399.504704] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[399.628289] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.130s)
[399.630875] Subtest drm_format_helper: SUCCESS (2.505s)
[399.849170] [051/131] (622s left) kms_busy (basic-hang)
[399.950762] Starting subtest: basic-hang
[399.953227] Starting dynamic subtest: flip-pipe-A
[400.550171] Dynamic subtest flip-pipe-A: SUCCESS (0.599s)
[400.564962] Starting dynamic subtest: modeset-pipe-A
[403.999826] Dynamic subtest modeset-pipe-A: SUCCESS (3.450s)
[404.010337] Starting dynamic subtest: flip-pipe-D
[405.265792] Dynamic subtest flip-pipe-D: SUCCESS (1.265s)
[405.276649] Starting dynamic subtest: modeset-pipe-D
[408.698098] Dynamic subtest modeset-pipe-D: SUCCESS (3.430s)
[408.701029] Subtest basic-hang: SUCCESS (8.750s)
[409.534837] [052/131] (612s left) i915_selftest (perf)
[411.581514] Starting subtest: perf
[411.583695] Starting dynamic subtest: engine_cs
[417.345284] Dynamic subtest engine_cs: SUCCESS (5.764s)
[417.359437] Starting dynamic subtest: request
[423.950454] Dynamic subtest request: SUCCESS (6.593s)
[423.964678] Starting dynamic subtest: migrate
[429.681194] Dynamic subtest migrate: SUCCESS (5.722s)
[429.691176] Starting dynamic subtest: region
[435.384401] Dynamic subtest region: SUCCESS (5.695s)
[435.387596] Subtest perf: SUCCESS (23.783s)
[435.416951] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[435.417657] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[435.421568] [053/131] (586s left) gem_exec_balancer (semaphore)
[438.362083] Starting subtest: semaphore
[439.584532] Subtest semaphore: SUCCESS (1.221s)
[439.882927] [FACT gem_exec_balancer (semaphore)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[439.884099] [FACT gem_exec_balancer (semaphore)] new: kernel.kmod_is_loaded.i915: true
[439.887837] [054/131] (582s left) kms_psr (pr-basic)
[439.998734] Starting subtest: pr-basic
[440.003593] Subtest pr-basic: SKIP (0.000s)
[440.092266] [055/131] (581s left) gem_mmap_gtt (bad-object)
[440.156869] Subtest bad-object: SKIP (0.000s)
[440.211734] [056/131] (581s left) kms_invalid_mode (bad-hsync-start)
[440.305658] Starting subtest: bad-hsync-start
[440.308288] Starting dynamic subtest: pipe-A-eDP-1
[440.596042] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.293s)
[440.604180] Starting dynamic subtest: pipe-B-eDP-1
[440.606399] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[440.613626] Starting dynamic subtest: pipe-C-eDP-1
[440.615759] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[440.623332] Starting dynamic subtest: pipe-D-eDP-1
[440.625856] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[440.628230] Subtest bad-hsync-start: SUCCESS (0.299s)
[441.443740] [057/131] (580s left) gem_tiled_fence_blits (basic)
[441.514080] Subtest basic: SKIP (0.000s)
[441.567954] [058/131] (580s left) kms_flip (flip-vs-absolute-wf_vblank)
[441.665735] Starting subtest: flip-vs-absolute-wf_vblank
[441.668654] Starting dynamic subtest: A-eDP1
[450.566472] Dynamic subtest A-eDP1: SUCCESS (8.898s)
[450.574671] Starting dynamic subtest: B-eDP1
[459.491886] Dynamic subtest B-eDP1: SUCCESS (8.921s)
[459.501078] Starting dynamic subtest: C-eDP1
[468.423947] Dynamic subtest C-eDP1: SUCCESS (8.927s)
[468.433553] Starting dynamic subtest: D-eDP1
[477.359520] Dynamic subtest D-eDP1: SUCCESS (8.931s)
[477.361848] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.685s)
[478.609893] [059/131] (543s left) gem_basic (create-close)
[478.677072] Starting subtest: create-close
[478.682827] Subtest create-close: SUCCESS (0.000s)
[478.802407] [060/131] (543s left) syncobj_timeline (wait-all-interrupted)
[478.862800] Starting subtest: wait-all-interrupted
[478.962667] Subtest wait-all-interrupted: SUCCESS (0.101s)
[479.063838] [061/131] (543s left) perf (invalid-open-flags)
[479.197323] Starting subtest: invalid-open-flags
[479.199703] Subtest invalid-open-flags: SUCCESS (0.000s)
[479.240276] [062/131] (543s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[479.343709] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[486.183660] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.842s)
[486.352585] [063/131] (535s left) gem_exec_gttfill (basic)
[486.426028] Starting subtest: basic
[488.912049] Subtest basic: SUCCESS (2.485s)
[489.126263] [064/131] (533s left) kms_chamelium_color (gamma)
[489.285973] Subtest gamma: SKIP (0.000s)
[489.332867] [065/131] (533s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[489.408918] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[489.414840] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[489.614352] [066/131] (532s left) gem_spin_batch (spin-each)
[489.685040] Starting subtest: spin-each
[492.957764] Subtest spin-each: SUCCESS (3.263s)
[493.640484] [067/131] (528s left) perf (non-zero-reason)
[493.785740] Starting subtest: non-zero-reason
[493.788052] Starting dynamic subtest: 0-rcs0
[499.073034] Dynamic subtest 0-rcs0: SUCCESS (5.288s)
[499.082346] Starting dynamic subtest: 1-vcs0
[502.925205] Dynamic subtest 1-vcs0: SUCCESS (3.850s)
[502.928346] Subtest non-zero-reason: SUCCESS (9.140s)
[502.969568] [068/131] (519s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[503.034934] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[503.105321] [069/131] (519s left) gem_exec_schedule (u-semaphore-noskip)
[503.184306] Starting subtest: u-semaphore-noskip
[503.645606] Subtest u-semaphore-noskip: SUCCESS (0.467s)
[504.586636] [070/131] (518s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[504.695029] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[504.700158] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[505.812524] [071/131] (516s left) gem_ctx_param (basic-default)
[505.868900] Starting subtest: basic-default
[505.872077] Subtest basic-default: SUCCESS (0.000s)
[505.967370] [072/131] (516s left) gem_ctx_param (get-priority-new-ctx)
[506.025911] Starting subtest: get-priority-new-ctx
[506.028944] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[506.141117] [073/131] (516s left) kms_properties (connector-properties-legacy)
[506.231786] Starting subtest: connector-properties-legacy
[506.234416] Starting dynamic subtest: pipe-A-eDP-1
[514.098268] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.862s)
[514.107999] Starting dynamic subtest: pipe-None-DP-1
[514.112902] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[514.121227] Starting dynamic subtest: pipe-None-HDMI-A-1
[514.125859] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[514.134639] Starting dynamic subtest: pipe-None-DP-2
[514.139800] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[514.148248] Starting dynamic subtest: pipe-None-HDMI-A-2
[514.153263] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[514.162176] Starting dynamic subtest: pipe-None-DP-3
[514.166929] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[514.178528] Starting dynamic subtest: pipe-None-DP-4
[514.185019] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[514.188582] Subtest connector-properties-legacy: SUCCESS (7.876s)
[514.986582] [074/131] (507s left) kms_vblank (wait-busy-hang)
[515.085818] Starting subtest: wait-busy-hang
[515.088639] Starting dynamic subtest: pipe-A-eDP-1
[541.338497] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.251s)
[541.352428] Starting dynamic subtest: pipe-D-eDP-1
[556.289811] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.946s)
[556.293037] Subtest wait-busy-hang: SUCCESS (41.204s)
[557.143377] [075/131] (465s left) kms_prop_blob (basic)
[557.201062] Starting subtest: basic
[557.203666] Subtest basic: SUCCESS (0.000s)
[557.319503] [076/131] (465s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[557.430630] Starting subtest: psr-1p-pri-indfb-multidraw
[579.738540] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (22.309s)
[579.888246] [077/131] (443s left) kms_force_connector_basic (prune-stale-modes)
[579.986057] Starting subtest: prune-stale-modes
[580.430751] Subtest prune-stale-modes: SUCCESS (0.447s)
[580.590356] [078/131] (442s left) kms_atomic_interruptible (atomic-setmode)
[580.675330] Starting subtest: atomic-setmode
[580.677519] Starting dynamic subtest: pipe-A-eDP-1
[587.548669] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.871s)
[587.551358] Subtest atomic-setmode: SUCCESS (6.872s)
[588.386108] [079/131] (434s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[588.483847] Starting subtest: basic-modeset-with-all-modifiers-formats
[588.864546] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[589.606009] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.743s)
[589.614968] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[589.628216] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[589.636935] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[589.650429] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.021s)
[589.659306] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[589.806352] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.155s)
[589.822613] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[589.828237] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[589.842108] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[589.850518] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.021s)
[589.863820] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[589.873036] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.021s)
[589.884176] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[589.895362] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.021s)
[589.905820] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[589.917306] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[589.925723] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[589.939434] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s)
[589.947670] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[589.961518] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[589.969850] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[589.983945] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s)
[589.992778] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[590.139631] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.155s)
[590.148525] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[590.161423] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.022s)
[590.170702] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[590.183582] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.021s)
[590.192005] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[590.206016] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[590.214271] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[590.228047] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.021s)
[590.236825] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[590.250297] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.022s)
[590.258742] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[590.272844] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s)
[590.281832] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[590.295460] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.021s)
[590.304082] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[590.317856] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.020s)
[590.326831] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[590.495443] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.175s)
[590.503474] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[590.517171] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.022s)
[590.526260] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[590.539667] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s)
[590.548064] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[590.562248] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[590.570615] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[590.584336] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.021s)
[590.596177] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[590.606452] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.019s)
[590.615183] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[590.628557] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.021s)
[590.637058] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[590.650739] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[590.659441] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[590.673414] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s)
[591.056030] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.574s)
[591.876122] [080/131] (431s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[591.986910] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[591.991951] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[592.120501] [081/131] (430s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[592.222337] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[592.227709] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[592.361430] [082/131] (430s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[592.462307] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[592.467425] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[592.599339] [083/131] (430s left) kms_psr (psr2-no-drrs)
[592.706884] Starting subtest: psr2-no-drrs
[592.709589] Starting dynamic subtest: eDP-1
[594.308712] Dynamic subtest eDP-1: SUCCESS (1.601s)
[594.311349] Subtest psr2-no-drrs: SUCCESS (1.603s)
[595.182393] [084/131] (428s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[595.270737] Starting subtest: bad-rotation-90-yf-tiled-ccs
[595.273345] Starting dynamic subtest: pipe-A-eDP-1
[595.298266] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[595.307499] Starting dynamic subtest: pipe-B-eDP-1
[595.331486] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[595.340017] Starting dynamic subtest: pipe-C-eDP-1
[595.364790] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[595.373013] Starting dynamic subtest: pipe-D-eDP-1
[595.399661] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[595.404888] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.004s)
[597.576078] [085/131] (425s left) gem_exec_whisper (basic-fds-forked-all)
[597.647538] Starting subtest: basic-fds-forked-all
[619.766969] Subtest basic-fds-forked-all: SUCCESS (22.115s)
[619.977360] [086/131] (403s left) kms_content_protection (lic-type-1)
[620.130781] Starting subtest: lic-type-1
[620.135885] Subtest lic-type-1: SKIP (0.000s)
[620.298495] [087/131] (403s left) gem_exec_reloc (basic-write-cpu-active)
[620.371825] Subtest basic-write-cpu-active: SKIP (0.000s)
[620.455390] [088/131] (402s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[620.546681] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[627.052855] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.506s)
[627.204784] [089/131] (396s left) kms_lease (lease-again)
[627.304675] Starting subtest: lease-again
[627.307314] Starting dynamic subtest: pipe-A-eDP-1
[627.309790] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s)
[627.319773] Starting dynamic subtest: pipe-B-eDP-1
[627.322539] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[627.331896] Starting dynamic subtest: pipe-C-eDP-1
[627.334754] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[627.344177] Starting dynamic subtest: pipe-D-eDP-1
[627.346796] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[627.349498] Subtest lease-again: SUCCESS (0.014s)
[627.451540] [090/131] (396s left) prime_vgem (basic-blt)
[627.525035] Starting subtest: basic-blt
[627.614561] Subtest basic-blt: SUCCESS (0.092s)
[627.779137] [091/131] (395s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[627.834072] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[627.887928] [092/131] (395s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[627.994045] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[627.997980] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[628.109185] [093/131] (395s left) i915_drm_fdinfo (memory-info-idle)
[628.150680] Starting subtest: memory-info-idle
[628.153056] Starting dynamic subtest: smem0
[628.219330] Dynamic subtest smem0: SUCCESS (0.069s)
[628.222076] Subtest memory-info-idle: SUCCESS (0.070s)
[628.321017] [094/131] (395s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[628.426388] Starting subtest: x-tiled-8bpp-rotate-90
[628.448832] Subtest x-tiled-8bpp-rotate-90: SKIP (0.021s)
[628.608720] [095/131] (395s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[628.718192] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[632.972457] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.257s)
[634.182999] [096/131] (389s left) kms_plane_multiple (tiling-none)
[634.287561] Starting subtest: tiling-none
[634.289955] Starting dynamic subtest: pipe-A-eDP-1
[638.085756] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.799s)
[638.096032] Starting dynamic subtest: pipe-B-eDP-1
[642.681043] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.595s)
[642.690770] Starting dynamic subtest: pipe-C-eDP-1
[647.275334] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.590s)
[647.286059] Starting dynamic subtest: pipe-D-eDP-1
[651.861061] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.586s)
[651.863927] Subtest tiling-none: SUCCESS (17.574s)
[652.687213] [097/131] (371s left) kms_atomic (plane-cursor-legacy)
[652.792386] Starting subtest: plane-cursor-legacy
[652.794727] Starting dynamic subtest: pipe-A-eDP-1
[653.167916] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.376s)
[653.170930] Subtest plane-cursor-legacy: SUCCESS (0.378s)
[654.065882] [098/131] (369s left) gem_partial_pwrite_pread (write-display)
[654.141704] Subtest write-display: SKIP (0.000s)
[654.209341] [099/131] (369s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[654.316241] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[654.321564] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[654.431587] [100/131] (369s left) perf_pmu (semaphore-wait-idle)
[654.474606] Starting subtest: semaphore-wait-idle
[654.476565] Starting dynamic subtest: rcs0
[654.992041] Dynamic subtest rcs0: SUCCESS (0.517s)
[655.009575] Starting dynamic subtest: bcs0
[655.506056] Dynamic subtest bcs0: SUCCESS (0.511s)
[655.518700] Starting dynamic subtest: vcs0
[656.019931] Dynamic subtest vcs0: SUCCESS (0.511s)
[656.032754] Starting dynamic subtest: vcs1
[656.533026] Dynamic subtest vcs1: SUCCESS (0.510s)
[656.545323] Starting dynamic subtest: vecs0
[657.046260] Dynamic subtest vecs0: SUCCESS (0.510s)
[657.059340] Starting dynamic subtest: ccs0
[657.562836] Dynamic subtest ccs0: SUCCESS (0.514s)
[657.565956] Subtest semaphore-wait-idle: SUCCESS (3.090s)
[657.705324] [101/131] (366s left) syncobj_basic (bad-pad-fd-to-handle)
[657.762189] Starting subtest: bad-pad-fd-to-handle
[657.764942] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[657.889665] [102/131] (366s left) gem_exec_gttfill (all-engines)
[657.967772] Starting subtest: all-engines
[682.569432] Subtest all-engines: SUCCESS (24.601s)
[682.783753] [103/131] (341s left) gem_lmem_swapping (heavy-verify-multi)
[682.875842] Subtest heavy-verify-multi: SKIP (0.000s)
[682.924212] [104/131] (341s left) kms_cursor_crc (cursor-random-64x21)
[683.127639] Starting subtest: cursor-random-64x21
[683.174287] Subtest cursor-random-64x21: SKIP (0.039s)
[683.421870] [105/131] (340s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[683.528265] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[683.539887] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.010s)
[683.665037] [106/131] (340s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[683.789532] Starting subtest: basic-flip-after-cursor-atomic
[684.734012] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.943s)
[685.586369] [107/131] (338s left) gem_pxp (create-protected-buffer)
[685.713955] Starting subtest: create-protected-buffer
[685.716827] Subtest create-protected-buffer: SUCCESS (0.000s)
[685.860219] [108/131] (338s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[685.967817] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[685.972844] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[686.100005] [109/131] (338s left) gem_render_copy (linear-to-vebox-yf-tiled)
[686.170825] Starting subtest: linear-to-vebox-yf-tiled
[686.175812] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[686.373509] [110/131] (337s left) kms_draw_crc (draw-method-pwrite)
[686.471884] Starting subtest: draw-method-pwrite
[686.474543] Starting dynamic subtest: xrgb8888-untiled
[687.015300] Dynamic subtest xrgb8888-untiled: SUCCESS (0.545s)
[687.024698] Starting dynamic subtest: rgb565-untiled
[687.460067] Dynamic subtest rgb565-untiled: SUCCESS (0.444s)
[687.470454] Starting dynamic subtest: xrgb2101010-untiled
[687.970833] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.510s)
[687.980608] Starting dynamic subtest: xbgr16161616f-untiled
[688.837849] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.866s)
[688.848353] Starting dynamic subtest: xrgb8888-xtiled
[690.581879] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.742s)
[690.591942] Starting dynamic subtest: rgb565-xtiled
[691.648822] Dynamic subtest rgb565-xtiled: SUCCESS (1.066s)
[691.659179] Starting dynamic subtest: xrgb2101010-xtiled
[693.381711] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.733s)
[693.395555] Starting dynamic subtest: xbgr16161616f-xtiled
[696.593058] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.210s)
[696.604070] Starting dynamic subtest: xrgb8888-4tiled
[697.648858] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.053s)
[697.661452] Starting dynamic subtest: rgb565-4tiled
[698.226783] Dynamic subtest rgb565-4tiled: SUCCESS (0.577s)
[698.244352] Starting dynamic subtest: xrgb2101010-4tiled
[699.283949] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.053s)
[699.306725] Starting dynamic subtest: xbgr16161616f-4tiled
[702.214904] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.931s)
[702.217792] Subtest draw-method-pwrite: SUCCESS (15.746s)
[702.333843] [111/131] (322s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[702.462061] Starting subtest: short-busy-flip-before-cursor-toggle
[702.466538] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[702.627126] [112/131] (321s left) gem_close_race (multigpu-basic-process)
[702.690484] Starting subtest: multigpu-basic-process
[702.695059] Subtest multigpu-basic-process: SKIP (0.000s)
[702.952646] [113/131] (321s left) gem_ctx_persistence (engines-queued)
[703.020019] Starting subtest: engines-queued
[703.022952] Starting dynamic subtest: rcs0
[703.126294] Dynamic subtest rcs0: SUCCESS (0.105s)
[703.139288] Starting dynamic subtest: bcs0
[703.192324] Dynamic subtest bcs0: SUCCESS (0.063s)
[703.204435] Starting dynamic subtest: vcs0
[704.555024] Dynamic subtest vcs0: SUCCESS (1.359s)
[704.567969] Starting dynamic subtest: vcs1
[706.536590] Dynamic subtest vcs1: SUCCESS (1.979s)
[706.549308] Starting dynamic subtest: vecs0
[708.521393] Dynamic subtest vecs0: SUCCESS (1.982s)
[708.533867] Starting dynamic subtest: ccs0
[708.704894] Dynamic subtest ccs0: SUCCESS (0.182s)
[708.707920] Subtest engines-queued: SUCCESS (5.685s)
[708.870314] [114/131] (315s left) gem_mmap_gtt (fault-concurrent-y)
[708.931550] Subtest fault-concurrent-Y: SKIP (0.000s)
[708.997378] [115/131] (315s left) gem_ctx_isolation (clean)
[709.056030] Starting subtest: clean
[709.058828] Starting dynamic subtest: rcs0
[709.121524] Dynamic subtest rcs0: SUCCESS (0.065s)
[709.131240] Starting dynamic subtest: bcs0
[709.216624] Dynamic subtest bcs0: SUCCESS (0.094s)
[709.226291] Starting dynamic subtest: vcs0
[709.304176] Dynamic subtest vcs0: SUCCESS (0.087s)
[709.316045] Starting dynamic subtest: vcs1
[710.568642] Dynamic subtest vcs1: SUCCESS (1.263s)
[710.578744] Starting dynamic subtest: vecs0
[712.637808] Dynamic subtest vecs0: SUCCESS (2.059s)
[712.647159] Starting dynamic subtest: ccs0
[714.619432] Dynamic subtest ccs0: SUCCESS (1.991s)
[714.622258] Subtest clean: SUCCESS (5.564s)
[714.892400] [116/131] (309s left) gem_exec_schedule (implicit-read-write)
[714.962714] Starting subtest: implicit-read-write
[714.965305] Starting dynamic subtest: rcs0
[715.138401] Dynamic subtest rcs0: SUCCESS (0.188s)
[715.148080] Starting dynamic subtest: vcs0
[715.251652] Dynamic subtest vcs0: SUCCESS (0.112s)
[715.264110] Starting dynamic subtest: vcs1
[715.369539] Dynamic subtest vcs1: SUCCESS (0.117s)
[715.381511] Starting dynamic subtest: vecs0
[715.481649] Dynamic subtest vecs0: SUCCESS (0.111s)
[715.495914] Starting dynamic subtest: ccs0
[715.620665] Dynamic subtest ccs0: SUCCESS (0.138s)
[715.623016] Subtest implicit-read-write: SUCCESS (0.671s)
[716.719211] [117/131] (307s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[716.812015] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[716.814960] Starting dynamic subtest: pipe-A-eDP-1
[716.879532] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[716.889032] Starting dynamic subtest: pipe-B-eDP-1
[716.956880] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[716.967847] Starting dynamic subtest: pipe-C-eDP-1
[717.036522] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[717.046463] Starting dynamic subtest: pipe-D-eDP-1
[717.112884] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[717.117709] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s)
[719.071586] [118/131] (305s left) perf (missing-sample-flags)
[719.199356] Starting subtest: missing-sample-flags
[719.202414] Subtest missing-sample-flags: SUCCESS (0.000s)
[719.252372] [119/131] (305s left) kms_color (ctm-0-50)
[719.346303] Starting subtest: ctm-0-50
[719.348797] Starting dynamic subtest: pipe-A-eDP-1
[722.811054] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.462s)
[722.821030] Starting dynamic subtest: pipe-B-eDP-1
[726.974577] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.164s)
[726.986868] Starting dynamic subtest: pipe-C-eDP-1
[730.942796] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.966s)
[730.953055] Starting dynamic subtest: pipe-D-eDP-1
[734.937904] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.996s)
[734.940962] Subtest ctm-0-50: SUCCESS (15.592s)
[735.762519] [120/131] (288s left) i915_pm_rps (fence-order)
[735.828920] Starting subtest: fence-order
[738.700745] Subtest fence-order: SUCCESS (2.869s)
[738.854929] [121/131] (285s left) kms_psr (pr-sprite-blt)
[738.958072] Starting subtest: pr-sprite-blt
[738.962927] Subtest pr-sprite-blt: SKIP (0.000s)
[739.056788] [122/131] (285s left) kms_plane (plane-panning-bottom-right)
[739.156346] Starting subtest: plane-panning-bottom-right
[739.158431] Starting dynamic subtest: pipe-A
[740.856795] Dynamic subtest pipe-A: SUCCESS (1.701s)
[740.868864] Starting dynamic subtest: pipe-B
[743.170400] Dynamic subtest pipe-B: SUCCESS (2.309s)
[743.172541] Subtest plane-panning-bottom-right: SUCCESS (4.014s)
[744.062470] [123/131] (280s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[744.168383] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[744.178952] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.010s)
[744.320359] [124/131] (280s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[744.435908] Starting subtest: yf-tiled-32bpp-rotate-90
[744.440845] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[744.568401] [125/131] (280s left) perf_pmu (interrupts-sync)
[744.616579] Starting subtest: interrupts-sync
[745.718306] Subtest interrupts-sync: SUCCESS (1.104s)
[745.885236] [126/131] (279s left) sysfs_timeslice_duration (timeout)
[745.968178] Starting subtest: timeout
[745.970925] Starting dynamic subtest: vecs0
[755.539486] Dynamic subtest vecs0: SUCCESS (9.568s)
[755.552012] Starting dynamic subtest: ccs0
[756.747677] Dynamic subtest ccs0: SUCCESS (1.208s)
[756.759480] Starting dynamic subtest: vcs0
[766.556183] Dynamic subtest vcs0: SUCCESS (9.805s)
[766.571916] Starting dynamic subtest: bcs0
[767.184019] Dynamic subtest bcs0: SUCCESS (0.625s)
[767.196928] Starting dynamic subtest: rcs0
[768.433919] Dynamic subtest rcs0: SUCCESS (1.248s)
[768.447584] Starting dynamic subtest: vcs1
[777.568036] Dynamic subtest vcs1: SUCCESS (9.130s)
[777.571019] Subtest timeout: SUCCESS (31.598s)
[777.668520] [127/131] (247s left) api_intel_bb (delta-check)
[777.726889] Starting subtest: delta-check
[777.737693] Subtest delta-check: SUCCESS (0.011s)
[777.860233] [128/131] (247s left) gen7_exec_parse (basic-rejected)
[777.926247] Subtest basic-rejected: SKIP (0.000s)
[778.006630] [129/131] (247s left) syncobj_basic (bad-flags-handle-to-fd)
[778.065966] Starting subtest: bad-flags-handle-to-fd
[778.068649] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[778.245239] [130/131] (246s left) i915_pm_freq_api (freq-reset-multiple)
[778.341446] Starting subtest: freq-reset-multiple
[778.344308] Starting dynamic subtest: gt0
[787.605294] Dynamic subtest gt0: SUCCESS (9.262s)
[787.615058] Starting dynamic subtest: gt1
[795.517458] Dynamic subtest gt1: SUCCESS (7.913s)
[795.520338] Subtest freq-reset-multiple: SUCCESS (17.176s)
[795.624236] [131/131] (229s left) gem_ctx_shared (q-out-order)
[795.687047] Starting subtest: Q-out-order
[795.689778] Starting dynamic subtest: rcs0
[795.854712] Dynamic subtest rcs0: SUCCESS (0.166s)
[795.872252] Starting dynamic subtest: vcs0
[795.965955] Dynamic subtest vcs0: SUCCESS (0.110s)
[795.978428] Starting dynamic subtest: vcs1
[796.089617] Dynamic subtest vcs1: SUCCESS (0.122s)
[796.107021] Starting dynamic subtest: vecs0
[796.200706] Dynamic subtest vecs0: SUCCESS (0.111s)
[796.219499] Starting dynamic subtest: ccs0
[796.331638] Dynamic subtest ccs0: SUCCESS (0.129s)
[796.334066] Subtest Q-out-order: SUCCESS (0.643s)
[797.698132] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: kms_flip
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: kms_cursor_crc
results: parsing output: 5/ for test: gem_vm_create
results: parsing output: 6/ for test: gem_exec_params
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: gem_mmap_gtt
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_exec_fence
results: parsing output: 13/ for test: kms_psr2_sf
results: parsing output: 14/ for test: device_reset
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: api_intel_allocator
results: parsing output: 18/ for test: gem_ctx_param
results: parsing output: 19/ for test: gem_sync
results: parsing output: 20/ for test: gem_partial_pwrite_pread
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_pm_rpm
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_flip
results: parsing output: 25/ for test: kms_psr2_sf
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: kms_addfb_basic
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: fbdev
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: kms_chamelium_edid
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: kms_flip_scaled_crc
results: parsing output: 35/ for test: gem_softpin
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: kms_plane_scaling
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: gem_render_copy_redux
results: parsing output: 41/ for test: perf
results: parsing output: 42/ for test: kms_scaling_modes
results: parsing output: 43/ for test: kms_getfb
results: parsing output: 44/ for test: gem_eio
results: parsing output: 45/ for test: kms_legacy_colorkey
results: parsing output: 46/ for test: gem_exec_balancer
results: parsing output: 47/ for test: kms_cursor_crc
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: kms_selftest
results: parsing output: 50/ for test: kms_busy
results: parsing output: 51/ for test: i915_selftest
results: parsing output: 52/ for test: gem_exec_balancer
results: parsing output: 53/ for test: kms_psr
results: parsing output: 54/ for test: gem_mmap_gtt
results: parsing output: 55/ for test: kms_invalid_mode
results: parsing output: 56/ for test: gem_tiled_fence_blits
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: gem_basic
results: parsing output: 59/ for test: syncobj_timeline
results: parsing output: 60/ for test: perf
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gem_exec_gttfill
results: parsing output: 63/ for test: kms_chamelium_color
results: parsing output: 64/ for test: gem_render_copy
results: parsing output: 65/ for test: gem_spin_batch
results: parsing output: 66/ for test: perf
results: parsing output: 67/ for test: gem_exec_reloc
results: parsing output: 68/ for test: gem_exec_schedule
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: gem_ctx_param
results: parsing output: 71/ for test: gem_ctx_param
results: parsing output: 72/ for test: kms_properties
results: parsing output: 73/ for test: kms_vblank
results: parsing output: 74/ for test: kms_prop_blob
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_force_connector_basic
results: parsing output: 77/ for test: kms_atomic_interruptible
results: parsing output: 78/ for test: kms_async_flips
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: gem_exec_whisper
results: parsing output: 85/ for test: kms_content_protection
results: parsing output: 86/ for test: gem_exec_reloc
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_lease
results: parsing output: 89/ for test: prime_vgem
results: parsing output: 90/ for test: kms_pipe_b_c_ivb
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: i915_drm_fdinfo
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_plane_multiple
results: parsing output: 96/ for test: kms_atomic
results: parsing output: 97/ for test: gem_partial_pwrite_pread
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: perf_pmu
results: parsing output: 100/ for test: syncobj_basic
results: parsing output: 101/ for test: gem_exec_gttfill
results: parsing output: 102/ for test: gem_lmem_swapping
results: parsing output: 103/ for test: kms_cursor_crc
results: parsing output: 104/ for test: kms_flip
results: parsing output: 105/ for test: kms_cursor_legacy
results: parsing output: 106/ for test: gem_pxp
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_render_copy
results: parsing output: 109/ for test: kms_draw_crc
results: parsing output: 110/ for test: kms_cursor_legacy
results: parsing output: 111/ for test: gem_close_race
results: parsing output: 112/ for test: gem_ctx_persistence
results: parsing output: 113/ for test: gem_mmap_gtt
results: parsing output: 114/ for test: gem_ctx_isolation
results: parsing output: 115/ for test: gem_exec_schedule
results: parsing output: 116/ for test: kms_ccs
results: parsing output: 117/ for test: perf
results: parsing output: 118/ for test: kms_color
results: parsing output: 119/ for test: i915_pm_rps
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: kms_plane
results: parsing output: 122/ for test: kms_flip
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: perf_pmu
results: parsing output: 125/ for test: sysfs_timeslice_duration
results: parsing output: 126/ for test: api_intel_bb
results: parsing output: 127/ for test: gen7_exec_parse
results: parsing output: 128/ for test: syncobj_basic
results: parsing output: 129/ for test: i915_pm_freq_api
results: parsing output: 130/ for test: gem_ctx_shared
Done.