[57.198298] Initializing watchdogs
[57.198342]   /dev/watchdog0
[57.211882] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.216195] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.218342] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.221668] [001/131] (960s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[57.342858] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[57.345413] Starting dynamic subtest: pipe-A-eDP-1
[89.246267] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.548s)
[89.254516] Starting dynamic subtest: pipe-B-eDP-1
[122.169376] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.839s)
[122.179083] Starting dynamic subtest: pipe-C-eDP-1
[155.142122] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.738s)
[155.150951] Starting dynamic subtest: pipe-D-eDP-1
[188.148022] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.630s)
[188.150870] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (18.758s)
[189.418462] [002/131] (828s left) kms_psr (fbc-psr2-primary-page-flip)
[189.523845] Starting subtest: fbc-psr2-primary-page-flip
[189.526086] Starting dynamic subtest: eDP-1
[189.531082] Dynamic subtest eDP-1: SKIP (0.000s)
[189.536139] Subtest fbc-psr2-primary-page-flip: SKIP (0.000s)
[189.637561] [003/131] (828s left) kms_flip (2x-flip-vs-dpms-on-nop)
[189.725379] Starting subtest: 2x-flip-vs-dpms-on-nop
[189.734104] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.010s)
[189.855533] [004/131] (828s left) kms_big_fb (y-tiled-addfb)
[189.963907] Starting subtest: y-tiled-addfb
[189.968879] Subtest y-tiled-addfb: SKIP (0.000s)
[190.078233] [005/131] (827s left) kms_cursor_crc (cursor-offscreen-128x128)
[190.308254] Starting subtest: cursor-offscreen-128x128
[190.311123] Starting dynamic subtest: pipe-A-eDP-1
[192.297253] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.963s)
[192.322951] Starting dynamic subtest: pipe-D-eDP-1
[194.967768] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.630s)
[194.970264] Subtest cursor-offscreen-128x128: SUCCESS (4.617s)
[195.837942] [006/131] (822s left) gem_vm_create (execbuf)
[195.907011] Starting subtest: execbuf
[195.917492] Subtest execbuf: SUCCESS (0.010s)
[196.079665] [007/131] (821s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[196.145002] Starting subtest: rel-constants-invalid-rel-gen5
[196.148077] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[196.274091] [008/131] (821s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[196.376521] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[200.324271] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (3.936s)
[201.462499] [009/131] (816s left) gem_mmap_gtt (basic-small-bo-tiledy)
[201.521927] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[201.583199] [010/131] (816s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[201.682938] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[201.688091] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[201.801919] [011/131] (816s left) kms_flip (absolute-wf_vblank)
[201.892834] Starting subtest: absolute-wf_vblank
[201.895330] Starting dynamic subtest: A-eDP1
[210.597943] Dynamic subtest A-eDP1: SUCCESS (8.688s)
[210.606687] Starting dynamic subtest: B-eDP1
[219.342350] Dynamic subtest B-eDP1: SUCCESS (8.737s)
[219.353082] Starting dynamic subtest: C-eDP1
[228.059625] Dynamic subtest C-eDP1: SUCCESS (8.719s)
[228.070337] Starting dynamic subtest: D-eDP1
[236.791644] Dynamic subtest D-eDP1: SUCCESS (8.732s)
[236.794240] Subtest absolute-wf_vblank: SUCCESS (34.883s)
[238.020276] [012/131] (780s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[238.134239] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[244.812961] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.679s)
[244.958699] [013/131] (773s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[245.531125] Starting subtest: syncobj-timeline-invalid-wait
[245.536779] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.005s)
[246.817579] [FACT gem_exec_fence (syncobj-timeline-invalid-wait)] new: kernel.kmod_is_loaded.vgem: true
[246.821607] [014/131] (771s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[251.798335] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[251.803903] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.003s)
[252.671666] [015/131] (765s left) device_reset (unbind-reset-rebind)
[252.725886] Starting subtest: unbind-reset-rebind
[255.811089] Subtest unbind-reset-rebind: SUCCESS (3.080s)
[255.854576] [016/131] (762s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[255.957277] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[255.961377] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[256.089472] [017/131] (762s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[256.202966] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[256.208592] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[256.338276] [018/131] (762s left) api_intel_allocator (reopen)
[256.405481] Starting subtest: reopen
[256.410479] Subtest reopen: SUCCESS (0.005s)
[256.581358] [019/131] (761s left) gem_ctx_param (non-root-set)
[256.644846] Starting subtest: non-root-set
[256.666995] Subtest non-root-set: SUCCESS (0.022s)
[256.775896] [020/131] (761s left) gem_sync (basic-each)
[256.852813] Starting subtest: basic-each
[259.414542] Subtest basic-each: SUCCESS (2.573s)
[259.628333] [021/131] (758s left) gem_partial_pwrite_pread (reads-snoop)
[259.704951] Subtest reads-snoop: SKIP (0.000s)
[259.780061] [022/131] (758s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[259.883305] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[259.887566] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[260.014244] [023/131] (758s left) kms_pm_rpm (fences)
[261.961054] Starting subtest: fences
[261.966948] Subtest fences: SKIP (0.000s)
[262.344533] [024/131] (756s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[262.457303] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[262.462067] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[262.566892] [025/131] (756s left) kms_flip (flip-vs-modeset-vs-hang)
[262.665173] Starting subtest: flip-vs-modeset-vs-hang
[262.668376] Starting dynamic subtest: A-eDP1
[302.246690] Dynamic subtest A-eDP1: SUCCESS (39.578s)
[302.256342] Starting dynamic subtest: D-eDP1
[352.233751] Dynamic subtest D-eDP1: SUCCESS (49.980s)
[352.236794] Subtest flip-vs-modeset-vs-hang: SUCCESS (89.566s)
[352.638328] [026/131] (666s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[357.693697] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf
[357.698838] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.002s)
[358.569372] [027/131] (660s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[358.626890] Starting subtest: etime-single-wait-all-available-unsubmitted
[358.728998] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.104s)
[358.829004] [028/131] (660s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[358.927648] Starting subtest: fbc-pr-sprite-mmap-cpu
[358.932562] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[359.024303] [029/131] (659s left) kms_addfb_basic (small-bo)
[359.120882] Starting subtest: small-bo
[359.123535] Subtest small-bo: SUCCESS (0.000s)
[359.258871] [030/131] (659s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[359.365322] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[359.370493] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[359.496588] [031/131] (659s left) fbdev (eof)
[359.555819] Starting subtest: eof
[359.558838] Subtest eof: SUCCESS (0.000s)
[359.661630] [032/131] (659s left) syncobj_timeline (reset-signaled)
[359.728564] Starting subtest: reset-signaled
[359.731343] Subtest reset-signaled: SUCCESS (0.000s)
[359.862744] [033/131] (659s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[360.251018] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[361.062476] [034/131] (658s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[361.127008] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[361.233713] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.107s)
[361.334370] [035/131] (657s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[361.435240] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[361.437672] Starting dynamic subtest: pipe-A-default-mode
[361.723888] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[361.728747] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.287s)
[362.543056] [036/131] (656s left) gem_softpin (evict-snoop-interruptible)
[362.611087] Starting subtest: evict-snoop-interruptible
[362.616952] Subtest evict-snoop-interruptible: SKIP (0.000s)
[362.771744] [037/131] (656s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[362.875908] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[363.866863] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.989s)
[364.046479] [038/131] (655s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[364.150688] Starting subtest: plane-upscale-factor-0-25-with-rotation
[364.153000] Starting dynamic subtest: pipe-A
[364.375791] Dynamic subtest pipe-A: SUCCESS (0.227s)
[364.384084] Starting dynamic subtest: pipe-B
[365.705733] Dynamic subtest pipe-B: SUCCESS (1.328s)
[365.714537] Starting dynamic subtest: pipe-C
[367.033575] Dynamic subtest pipe-C: SUCCESS (1.327s)
[367.042948] Starting dynamic subtest: pipe-D
[368.374068] Dynamic subtest pipe-D: SUCCESS (1.339s)
[368.376794] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.225s)
[369.567615] [039/131] (649s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[369.666192] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[369.671897] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[369.786020] [040/131] (649s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[369.905175] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[370.551358] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.648s)
[370.769838] [041/131] (648s left) gem_render_copy_redux (flink)
[370.837776] Starting subtest: flink
[371.534597] Subtest flink: SUCCESS (0.700s)
[371.694096] [042/131] (647s left) perf (low-oa-exponent-permissions)
[371.818327] Starting subtest: low-oa-exponent-permissions
[371.854771] Subtest low-oa-exponent-permissions: SUCCESS (0.038s)
[371.905479] [043/131] (647s left) kms_scaling_modes (scaling-mode-full-aspect)
[371.998746] Starting subtest: scaling-mode-full-aspect
[372.000677] Starting dynamic subtest: pipe-A-eDP-1
[372.093877] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.096s)
[372.102668] Starting dynamic subtest: pipe-B-eDP-1
[373.265865] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.170s)
[373.276344] Starting dynamic subtest: pipe-C-eDP-1
[374.368696] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.102s)
[374.378241] Starting dynamic subtest: pipe-D-eDP-1
[375.497098] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s)
[375.499948] Subtest scaling-mode-full-aspect: SUCCESS (3.499s)
[376.689048] [044/131] (642s left) kms_getfb (getfb2-handle-protection)
[376.777775] Starting subtest: getfb2-handle-protection
[376.799654] Subtest getfb2-handle-protection: SUCCESS (0.023s)
[376.982572] [045/131] (642s left) gem_eio (wait-wedge-10ms)
[377.213001] Starting subtest: wait-wedge-10ms
[378.845345] Subtest wait-wedge-10ms: SUCCESS (1.633s)
[379.004905] [046/131] (640s left) kms_legacy_colorkey (invalid-plane)
[379.096593] Starting subtest: invalid-plane
[379.099070] Starting dynamic subtest: zero-id
[379.101862] Dynamic subtest zero-id: SUCCESS (0.000s)
[379.110915] Starting dynamic subtest: outrange-id
[379.113855] Dynamic subtest outrange-id: SUCCESS (0.000s)
[379.116455] Subtest invalid-plane: SUCCESS (0.001s)
[379.193434] [047/131] (640s left) gem_exec_balancer (invalid-bonds)
[379.254090] Starting subtest: invalid-bonds
[379.259878] Subtest invalid-bonds: SKIP (0.000s)
[379.571938] [048/131] (640s left) kms_cursor_crc (cursor-sliding-128x42)
[379.788238] Starting subtest: cursor-sliding-128x42
[379.832791] Subtest cursor-sliding-128x42: SKIP (0.039s)
[380.100482] [049/131] (639s left) syncobj_timeline (multi-wait-available-signaled)
[380.162232] Starting subtest: multi-wait-available-signaled
[380.164952] Subtest multi-wait-available-signaled: SUCCESS (0.001s)
[380.285576] [050/131] (639s left) kms_selftest (drm_format_helper)
[380.325590] Starting subtest: drm_format_helper
[380.356788] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[380.529127] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.170s)
[380.543353] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[380.678115] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.148s)
[380.687667] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[380.831969] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.153s)
[380.842356] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[380.997095] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.164s)
[381.006325] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[381.152968] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.153s)
[381.163533] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[381.297881] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.144s)
[381.307681] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[381.437940] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.139s)
[381.448066] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[381.574920] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.136s)
[381.585119] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[381.703949] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.128s)
[381.714097] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[381.838004] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.134s)
[381.848058] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[381.964885] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.127s)
[381.975556] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[382.110120] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.141s)
[382.120130] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[382.222901] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.116s)
[382.232089] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[382.376504] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.151s)
[382.386668] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[382.527729] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.151s)
[382.537262] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[382.668842] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.139s)
[382.678722] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[382.807112] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.140s)
[382.809863] Subtest drm_format_helper: SUCCESS (2.483s)
[383.043463] [051/131] (636s left) kms_busy (basic-hang)
[383.147358] Starting subtest: basic-hang
[383.149936] Starting dynamic subtest: flip-pipe-A
[383.727998] Dynamic subtest flip-pipe-A: SUCCESS (0.579s)
[383.737767] Starting dynamic subtest: modeset-pipe-A
[387.421001] Dynamic subtest modeset-pipe-A: SUCCESS (3.693s)
[387.432490] Starting dynamic subtest: flip-pipe-D
[388.619142] Dynamic subtest flip-pipe-D: SUCCESS (1.196s)
[388.628224] Starting dynamic subtest: modeset-pipe-D
[392.054188] Dynamic subtest modeset-pipe-D: SUCCESS (3.431s)
[392.056727] Subtest basic-hang: SUCCESS (8.906s)
[392.893611] [052/131] (627s left) i915_selftest (perf)
[394.839987] Starting subtest: perf
[394.842540] Starting dynamic subtest: engine_cs
[399.029633] Dynamic subtest engine_cs: SUCCESS (4.192s)
[399.039717] Starting dynamic subtest: request
[405.756284] Dynamic subtest request: SUCCESS (6.722s)
[405.770783] Starting dynamic subtest: migrate
[410.044321] Dynamic subtest migrate: SUCCESS (4.284s)
[410.053093] Starting dynamic subtest: region
[415.640661] Dynamic subtest region: SUCCESS (5.595s)
[415.643675] Subtest perf: SUCCESS (20.803s)
[415.673551] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[415.674335] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[415.677962] [053/131] (604s left) gem_exec_balancer (semaphore)
[418.547361] Starting subtest: semaphore
[419.806275] Subtest semaphore: SUCCESS (1.256s)
[420.102584] [FACT gem_exec_balancer (semaphore)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[420.103783] [FACT gem_exec_balancer (semaphore)] new: kernel.kmod_is_loaded.i915: true
[420.108133] [054/131] (599s left) kms_psr (pr-basic)
[420.219066] Starting subtest: pr-basic
[420.224100] Subtest pr-basic: SKIP (0.000s)
[420.317170] [055/131] (599s left) gem_mmap_gtt (bad-object)
[420.366042] Subtest bad-object: SKIP (0.000s)
[420.434325] [056/131] (599s left) kms_invalid_mode (bad-hsync-start)
[420.539517] Starting subtest: bad-hsync-start
[420.542017] Starting dynamic subtest: pipe-A-eDP-1
[420.833503] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.293s)
[420.842636] Starting dynamic subtest: pipe-B-eDP-1
[420.845059] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[420.852884] Starting dynamic subtest: pipe-C-eDP-1
[420.855650] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[420.863641] Starting dynamic subtest: pipe-D-eDP-1
[420.866099] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[420.868564] Subtest bad-hsync-start: SUCCESS (0.299s)
[421.716490] [057/131] (598s left) gem_tiled_fence_blits (basic)
[421.787939] Subtest basic: SKIP (0.000s)
[421.870688] [058/131] (598s left) kms_flip (flip-vs-absolute-wf_vblank)
[421.959071] Starting subtest: flip-vs-absolute-wf_vblank
[421.961770] Starting dynamic subtest: A-eDP1
[430.843738] Dynamic subtest A-eDP1: SUCCESS (8.886s)
[430.859764] Starting dynamic subtest: B-eDP1
[439.774583] Dynamic subtest B-eDP1: SUCCESS (8.929s)
[439.782746] Starting dynamic subtest: C-eDP1
[448.692930] Dynamic subtest C-eDP1: SUCCESS (8.917s)
[448.703068] Starting dynamic subtest: D-eDP1
[457.627126] Dynamic subtest D-eDP1: SUCCESS (8.933s)
[457.629737] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.677s)
[458.875514] [059/131] (561s left) gem_basic (create-close)
[458.940608] Starting subtest: create-close
[458.946077] Subtest create-close: SUCCESS (0.000s)
[459.054461] [060/131] (561s left) syncobj_timeline (wait-all-interrupted)
[459.113754] Starting subtest: wait-all-interrupted
[459.217858] Subtest wait-all-interrupted: SUCCESS (0.105s)
[459.317275] [061/131] (560s left) perf (invalid-open-flags)
[459.460721] Starting subtest: invalid-open-flags
[459.462892] Subtest invalid-open-flags: SUCCESS (0.000s)
[459.503114] [062/131] (560s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[459.622388] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[466.709102] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (7.088s)
[466.847422] [063/131] (553s left) gem_exec_gttfill (basic)
[466.920344] Starting subtest: basic
[469.827209] Subtest basic: SUCCESS (2.905s)
[470.088677] [064/131] (550s left) kms_chamelium_color (gamma)
[470.250562] Subtest gamma: SKIP (0.000s)
[470.296521] [065/131] (550s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[470.370822] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[470.377103] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[470.572877] [066/131] (549s left) gem_spin_batch (spin-each)
[470.639065] Starting subtest: spin-each
[473.909992] Subtest spin-each: SUCCESS (3.260s)
[475.872682] [067/131] (544s left) perf (non-zero-reason)
[476.008057] Starting subtest: non-zero-reason
[476.011018] Starting dynamic subtest: 0-rcs0
[481.271059] Dynamic subtest 0-rcs0: SUCCESS (5.261s)
[481.285927] Starting dynamic subtest: 1-vcs0
[485.128744] Dynamic subtest 1-vcs0: SUCCESS (3.857s)
[485.132083] Subtest non-zero-reason: SUCCESS (9.120s)
[485.176885] [068/131] (535s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[485.255950] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[485.320932] [069/131] (535s left) gem_exec_schedule (u-semaphore-noskip)
[485.405066] Starting subtest: u-semaphore-noskip
[485.866904] Subtest u-semaphore-noskip: SUCCESS (0.463s)
[486.244408] [070/131] (534s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[486.366767] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[486.371934] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[487.557350] [071/131] (533s left) gem_ctx_param (basic-default)
[487.635076] Starting subtest: basic-default
[487.637742] Subtest basic-default: SUCCESS (0.000s)
[487.734197] [072/131] (533s left) gem_ctx_param (get-priority-new-ctx)
[487.795600] Starting subtest: get-priority-new-ctx
[487.798625] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[487.916335] [073/131] (532s left) kms_properties (connector-properties-legacy)
[488.021558] Starting subtest: connector-properties-legacy
[488.023867] Starting dynamic subtest: pipe-A-eDP-1
[495.842084] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.820s)
[495.856282] Starting dynamic subtest: pipe-None-DP-1
[495.861880] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[495.872607] Starting dynamic subtest: pipe-None-HDMI-A-1
[495.877970] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[495.887092] Starting dynamic subtest: pipe-None-DP-2
[495.892496] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[495.901910] Starting dynamic subtest: pipe-None-HDMI-A-2
[495.907016] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[495.916643] Starting dynamic subtest: pipe-None-DP-3
[495.922080] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[495.933604] Starting dynamic subtest: pipe-None-DP-4
[495.938276] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[495.940626] Subtest connector-properties-legacy: SUCCESS (7.831s)
[496.719434] [074/131] (524s left) kms_vblank (wait-busy-hang)
[496.809758] Starting subtest: wait-busy-hang
[496.811845] Starting dynamic subtest: pipe-A-eDP-1
[523.530766] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.717s)
[523.546564] Starting dynamic subtest: pipe-D-eDP-1
[538.517982] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.981s)
[538.520561] Subtest wait-busy-hang: SUCCESS (41.702s)
[539.393290] [075/131] (481s left) kms_prop_blob (basic)
[539.445469] Starting subtest: basic
[539.447778] Subtest basic: SUCCESS (0.000s)
[539.565815] [076/131] (481s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[539.667350] Starting subtest: psr-1p-pri-indfb-multidraw
[561.961071] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (22.294s)
[562.112329] [077/131] (458s left) kms_force_connector_basic (prune-stale-modes)
[562.200790] Starting subtest: prune-stale-modes
[562.644769] Subtest prune-stale-modes: SUCCESS (0.446s)
[562.834567] [078/131] (458s left) kms_atomic_interruptible (atomic-setmode)
[562.921079] Starting subtest: atomic-setmode
[562.923198] Starting dynamic subtest: pipe-A-eDP-1
[569.803899] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.881s)
[569.806931] Subtest atomic-setmode: SUCCESS (6.883s)
[570.653421] [079/131] (450s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[570.745121] Starting subtest: basic-modeset-with-all-modifiers-formats
[571.117824] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[571.874339] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.758s)
[571.883725] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[571.896320] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[571.905018] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[571.918466] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.021s)
[571.927408] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[572.074466] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.155s)
[572.083640] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[572.096346] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[572.105357] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[572.118889] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s)
[572.127691] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[572.140958] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s)
[572.149825] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[572.162945] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.021s)
[572.171936] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[572.185101] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[572.194055] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[572.207534] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s)
[572.216342] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[572.229686] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[572.238815] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[572.252217] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s)
[572.261107] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[572.396320] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.143s)
[572.405716] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[572.418685] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s)
[572.429067] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[572.441062] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.022s)
[572.450011] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[572.463131] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[572.471990] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[572.485007] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.021s)
[572.493997] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[572.507664] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.022s)
[572.516571] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[572.530071] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s)
[572.538965] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[572.552059] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s)
[572.560994] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[572.574609] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[572.583458] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[572.730363] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.155s)
[572.739590] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[572.751900] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[572.761966] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[572.774489] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s)
[572.785553] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[572.796753] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[572.805844] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[572.819020] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s)
[572.827772] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[572.841579] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[572.852519] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[572.863327] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.021s)
[572.872285] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[572.886306] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[572.895488] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[572.908541] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.020s)
[573.334935] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.593s)
[574.158224] [080/131] (446s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[574.259530] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[574.264528] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[574.390477] [081/131] (446s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[574.497888] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[574.502881] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[574.627648] [082/131] (446s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[574.726039] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[574.731928] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[574.850423] [083/131] (446s left) kms_psr (psr2-no-drrs)
[574.952725] Starting subtest: psr2-no-drrs
[574.955272] Starting dynamic subtest: eDP-1
[576.574444] Dynamic subtest eDP-1: SUCCESS (1.622s)
[576.576915] Subtest psr2-no-drrs: SUCCESS (1.623s)
[577.466638] [084/131] (443s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[577.556963] Starting subtest: bad-rotation-90-yf-tiled-ccs
[577.559798] Starting dynamic subtest: pipe-A-eDP-1
[577.585681] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[577.596204] Starting dynamic subtest: pipe-B-eDP-1
[577.621805] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[577.631089] Starting dynamic subtest: pipe-C-eDP-1
[577.657538] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[577.666595] Starting dynamic subtest: pipe-D-eDP-1
[577.692851] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[577.697677] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.004s)
[579.857046] [085/131] (441s left) gem_exec_whisper (basic-fds-forked-all)
[579.928865] Starting subtest: basic-fds-forked-all
[602.655096] Subtest basic-fds-forked-all: SUCCESS (22.722s)
[602.865293] [086/131] (418s left) kms_content_protection (lic-type-1)
[603.025073] Starting subtest: lic-type-1
[603.030581] Subtest lic-type-1: SKIP (0.000s)
[603.178781] [087/131] (418s left) gem_exec_reloc (basic-write-cpu-active)
[603.239591] Subtest basic-write-cpu-active: SKIP (0.000s)
[603.320618] [088/131] (418s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[603.424966] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[609.937703] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.514s)
[610.110328] [089/131] (411s left) kms_lease (lease-again)
[610.218839] Starting subtest: lease-again
[610.221495] Starting dynamic subtest: pipe-A-eDP-1
[610.223862] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s)
[610.233274] Starting dynamic subtest: pipe-B-eDP-1
[610.235537] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[610.244741] Starting dynamic subtest: pipe-C-eDP-1
[610.247223] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[610.256246] Starting dynamic subtest: pipe-D-eDP-1
[610.258702] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[610.261087] Subtest lease-again: SUCCESS (0.014s)
[610.372378] [090/131] (411s left) prime_vgem (basic-blt)
[610.466902] Starting subtest: basic-blt
[610.562609] Subtest basic-blt: SUCCESS (0.096s)
[610.734469] [091/131] (410s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[610.787124] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[610.847939] [092/131] (410s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[610.941325] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[610.945711] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[611.055556] [093/131] (410s left) i915_drm_fdinfo (memory-info-idle)
[611.090670] Starting subtest: memory-info-idle
[611.092858] Starting dynamic subtest: smem0
[611.157560] Dynamic subtest smem0: SUCCESS (0.067s)
[611.160182] Subtest memory-info-idle: SUCCESS (0.068s)
[611.252399] [094/131] (410s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[611.357982] Starting subtest: x-tiled-8bpp-rotate-90
[611.380357] Subtest x-tiled-8bpp-rotate-90: SKIP (0.021s)
[611.516867] [095/131] (410s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[611.620685] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[615.967020] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.349s)
[617.162359] [096/131] (404s left) kms_plane_multiple (tiling-none)
[617.244894] Starting subtest: tiling-none
[617.247228] Starting dynamic subtest: pipe-A-eDP-1
[621.074744] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.830s)
[621.086607] Starting dynamic subtest: pipe-B-eDP-1
[625.710982] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.633s)
[625.721666] Starting dynamic subtest: pipe-C-eDP-1
[630.258935] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.547s)
[630.269229] Starting dynamic subtest: pipe-D-eDP-1
[634.863503] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.601s)
[634.866010] Subtest tiling-none: SUCCESS (17.617s)
[635.755825] [097/131] (386s left) kms_atomic (plane-cursor-legacy)
[635.848760] Starting subtest: plane-cursor-legacy
[635.850817] Starting dynamic subtest: pipe-A-eDP-1
[636.228262] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.380s)
[636.230704] Subtest plane-cursor-legacy: SUCCESS (0.381s)
[637.073911] [098/131] (384s left) gem_partial_pwrite_pread (write-display)
[637.158937] Subtest write-display: SKIP (0.000s)
[637.229565] [099/131] (384s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[637.332432] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[637.337637] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[637.444614] [100/131] (384s left) perf_pmu (semaphore-wait-idle)
[637.489958] Starting subtest: semaphore-wait-idle
[637.492019] Starting dynamic subtest: rcs0
[638.004759] Dynamic subtest rcs0: SUCCESS (0.515s)
[638.017966] Starting dynamic subtest: bcs0
[638.519053] Dynamic subtest bcs0: SUCCESS (0.511s)
[638.531862] Starting dynamic subtest: vcs0
[639.033360] Dynamic subtest vcs0: SUCCESS (0.511s)
[639.051098] Starting dynamic subtest: vcs1
[639.547402] Dynamic subtest vcs1: SUCCESS (0.511s)
[639.561100] Starting dynamic subtest: vecs0
[640.060620] Dynamic subtest vecs0: SUCCESS (0.510s)
[640.073062] Starting dynamic subtest: ccs0
[640.576526] Dynamic subtest ccs0: SUCCESS (0.513s)
[640.579796] Subtest semaphore-wait-idle: SUCCESS (3.088s)
[641.848948] [101/131] (380s left) syncobj_basic (bad-pad-fd-to-handle)
[641.900105] Starting subtest: bad-pad-fd-to-handle
[641.902616] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[642.020859] [102/131] (380s left) gem_exec_gttfill (all-engines)
[642.094771] Starting subtest: all-engines
[665.634132] Subtest all-engines: SUCCESS (23.533s)
[665.848744] [103/131] (356s left) gem_lmem_swapping (heavy-verify-multi)
[665.940103] Subtest heavy-verify-multi: SKIP (0.000s)
[665.989671] [104/131] (356s left) kms_cursor_crc (cursor-random-64x21)
[666.200744] Starting subtest: cursor-random-64x21
[666.243779] Subtest cursor-random-64x21: SKIP (0.039s)
[666.509006] [105/131] (355s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[666.607670] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[666.619427] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s)
[666.723636] [106/131] (355s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[666.850653] Starting subtest: basic-flip-after-cursor-atomic
[667.784978] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.935s)
[668.662520] [107/131] (353s left) gem_pxp (create-protected-buffer)
[668.797648] Starting subtest: create-protected-buffer
[668.800127] Subtest create-protected-buffer: SUCCESS (0.000s)
[668.926728] [108/131] (353s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[669.030108] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[669.034946] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[669.144588] [109/131] (353s left) gem_render_copy (linear-to-vebox-yf-tiled)
[669.215916] Starting subtest: linear-to-vebox-yf-tiled
[669.221609] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[669.422091] [110/131] (353s left) kms_draw_crc (draw-method-pwrite)
[669.518066] Starting subtest: draw-method-pwrite
[669.520483] Starting dynamic subtest: xrgb8888-untiled
[670.038526] Dynamic subtest xrgb8888-untiled: SUCCESS (0.523s)
[670.049973] Starting dynamic subtest: rgb565-untiled
[670.482942] Dynamic subtest rgb565-untiled: SUCCESS (0.443s)
[670.493090] Starting dynamic subtest: xrgb2101010-untiled
[671.005083] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.521s)
[671.015011] Starting dynamic subtest: xbgr16161616f-untiled
[671.738022] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.733s)
[671.748301] Starting dynamic subtest: xrgb8888-xtiled
[673.437814] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.699s)
[673.448064] Starting dynamic subtest: rgb565-xtiled
[674.482322] Dynamic subtest rgb565-xtiled: SUCCESS (1.044s)
[674.492085] Starting dynamic subtest: xrgb2101010-xtiled
[676.159807] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.677s)
[676.169869] Starting dynamic subtest: xbgr16161616f-xtiled
[679.292659] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.133s)
[679.302867] Starting dynamic subtest: xrgb8888-4tiled
[680.347828] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.054s)
[680.357815] Starting dynamic subtest: rgb565-4tiled
[680.892087] Dynamic subtest rgb565-4tiled: SUCCESS (0.544s)
[680.902062] Starting dynamic subtest: xrgb2101010-4tiled
[681.925671] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.033s)
[681.935916] Starting dynamic subtest: xbgr16161616f-4tiled
[684.791624] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.866s)
[684.794477] Subtest draw-method-pwrite: SUCCESS (15.279s)
[684.923338] [111/131] (337s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[685.054796] Starting subtest: short-busy-flip-before-cursor-toggle
[685.059878] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[685.220348] [112/131] (337s left) gem_close_race (multigpu-basic-process)
[685.296014] Starting subtest: multigpu-basic-process
[685.301323] Subtest multigpu-basic-process: SKIP (0.000s)
[685.542299] [113/131] (337s left) gem_ctx_persistence (engines-queued)
[685.604755] Starting subtest: engines-queued
[685.607327] Starting dynamic subtest: rcs0
[685.690840] Dynamic subtest rcs0: SUCCESS (0.086s)
[685.704990] Starting dynamic subtest: bcs0
[685.726073] Dynamic subtest bcs0: SUCCESS (0.033s)
[685.736668] Starting dynamic subtest: vcs0
[687.726625] Dynamic subtest vcs0: SUCCESS (1.998s)
[687.740080] Starting dynamic subtest: vcs1
[689.708093] Dynamic subtest vcs1: SUCCESS (1.979s)
[689.721117] Starting dynamic subtest: vecs0
[691.755897] Dynamic subtest vecs0: SUCCESS (2.045s)
[691.768943] Starting dynamic subtest: ccs0
[691.951013] Dynamic subtest ccs0: SUCCESS (0.194s)
[691.953980] Subtest engines-queued: SUCCESS (6.348s)
[692.125246] [114/131] (330s left) gem_mmap_gtt (fault-concurrent-y)
[692.196064] Subtest fault-concurrent-Y: SKIP (0.000s)
[692.253471] [115/131] (330s left) gem_ctx_isolation (clean)
[692.310519] Starting subtest: clean
[692.313388] Starting dynamic subtest: rcs0
[692.366266] Dynamic subtest rcs0: SUCCESS (0.056s)
[692.378883] Starting dynamic subtest: bcs0
[692.464746] Dynamic subtest bcs0: SUCCESS (0.097s)
[692.476880] Starting dynamic subtest: vcs0
[692.562993] Dynamic subtest vcs0: SUCCESS (0.097s)
[692.575098] Starting dynamic subtest: vcs1
[693.815627] Dynamic subtest vcs1: SUCCESS (1.252s)
[693.827423] Starting dynamic subtest: vecs0
[695.757336] Dynamic subtest vecs0: SUCCESS (1.941s)
[695.769801] Starting dynamic subtest: ccs0
[697.810625] Dynamic subtest ccs0: SUCCESS (2.053s)
[697.813247] Subtest clean: SUCCESS (5.501s)
[698.083554] [116/131] (324s left) gem_exec_schedule (implicit-read-write)
[698.162548] Starting subtest: implicit-read-write
[698.164980] Starting dynamic subtest: rcs0
[698.344241] Dynamic subtest rcs0: SUCCESS (0.193s)
[698.355612] Starting dynamic subtest: vcs0
[698.460817] Dynamic subtest vcs0: SUCCESS (0.116s)
[698.473542] Starting dynamic subtest: vcs1
[698.571471] Dynamic subtest vcs1: SUCCESS (0.110s)
[698.585595] Starting dynamic subtest: vecs0
[698.681497] Dynamic subtest vecs0: SUCCESS (0.109s)
[698.694568] Starting dynamic subtest: ccs0
[698.818351] Dynamic subtest ccs0: SUCCESS (0.136s)
[698.821120] Subtest implicit-read-write: SUCCESS (0.668s)
[699.930133] [117/131] (322s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[700.031516] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[700.033954] Starting dynamic subtest: pipe-A-eDP-1
[700.098588] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[700.109630] Starting dynamic subtest: pipe-B-eDP-1
[700.176527] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[700.187857] Starting dynamic subtest: pipe-C-eDP-1
[700.256101] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[700.265816] Starting dynamic subtest: pipe-D-eDP-1
[700.334956] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[700.340500] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.008s)
[702.252128] [118/131] (320s left) perf (missing-sample-flags)
[702.377007] Starting subtest: missing-sample-flags
[702.379662] Subtest missing-sample-flags: SUCCESS (0.000s)
[702.419449] [119/131] (320s left) kms_color (ctm-0-50)
[702.526116] Starting subtest: ctm-0-50
[702.528860] Starting dynamic subtest: pipe-A-eDP-1
[706.059962] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.535s)
[706.076813] Starting dynamic subtest: pipe-B-eDP-1
[710.265914] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.206s)
[710.282577] Starting dynamic subtest: pipe-C-eDP-1
[714.331835] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.063s)
[714.354300] Starting dynamic subtest: pipe-D-eDP-1
[718.330065] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.998s)
[718.332548] Subtest ctm-0-50: SUCCESS (15.805s)
[719.150929] [120/131] (303s left) i915_pm_rps (fence-order)
[719.216598] Starting subtest: fence-order
[722.076084] Subtest fence-order: SUCCESS (2.857s)
[722.194757] [121/131] (300s left) kms_psr (pr-sprite-blt)
[722.294864] Starting subtest: pr-sprite-blt
[722.299696] Subtest pr-sprite-blt: SKIP (0.000s)
[722.393819] [122/131] (300s left) kms_plane (plane-panning-bottom-right)
[722.491665] Starting subtest: plane-panning-bottom-right
[722.493814] Starting dynamic subtest: pipe-A
[724.143112] Dynamic subtest pipe-A: SUCCESS (1.649s)
[724.154591] Starting dynamic subtest: pipe-B
[726.485771] Dynamic subtest pipe-B: SUCCESS (2.345s)
[726.488554] Subtest plane-panning-bottom-right: SUCCESS (3.997s)
[727.352756] [123/131] (295s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[727.456931] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[727.467931] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.011s)
[727.567962] [124/131] (295s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[727.671251] Starting subtest: yf-tiled-32bpp-rotate-90
[727.675969] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[727.807442] [125/131] (295s left) perf_pmu (interrupts-sync)
[727.851049] Starting subtest: interrupts-sync
[728.931681] Subtest interrupts-sync: SUCCESS (1.080s)
[729.079345] [126/131] (294s left) sysfs_timeslice_duration (timeout)
[729.144960] Starting subtest: timeout
[729.148000] Starting dynamic subtest: vecs0
[738.790437] Dynamic subtest vecs0: SUCCESS (9.642s)
[738.802601] Starting dynamic subtest: ccs0
[740.115991] Dynamic subtest ccs0: SUCCESS (1.325s)
[740.128492] Starting dynamic subtest: vcs0
[749.791829] Dynamic subtest vcs0: SUCCESS (9.672s)
[749.804648] Starting dynamic subtest: bcs0
[750.360434] Dynamic subtest bcs0: SUCCESS (0.569s)
[750.372198] Starting dynamic subtest: rcs0
[751.572687] Dynamic subtest rcs0: SUCCESS (1.209s)
[751.585720] Starting dynamic subtest: vcs1
[760.799194] Dynamic subtest vcs1: SUCCESS (9.223s)
[760.802236] Subtest timeout: SUCCESS (31.653s)
[760.898365] [127/131] (262s left) api_intel_bb (delta-check)
[760.954726] Starting subtest: delta-check
[760.963216] Subtest delta-check: SUCCESS (0.011s)
[761.101317] [128/131] (262s left) gen7_exec_parse (basic-rejected)
[761.168114] Subtest basic-rejected: SKIP (0.000s)
[761.232144] [129/131] (262s left) syncobj_basic (bad-flags-handle-to-fd)
[761.281612] Starting subtest: bad-flags-handle-to-fd
[761.284388] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[761.392444] [130/131] (261s left) i915_pm_freq_api (freq-reset-multiple)
[761.448885] Starting subtest: freq-reset-multiple
[761.451638] Starting dynamic subtest: gt0
[770.518878] Dynamic subtest gt0: SUCCESS (9.067s)
[770.529122] Starting dynamic subtest: gt1
[778.446513] Dynamic subtest gt1: SUCCESS (7.928s)
[778.449073] Subtest freq-reset-multiple: SUCCESS (16.997s)
[778.555267] [131/131] (244s left) gem_ctx_shared (q-out-order)
[778.633063] Starting subtest: Q-out-order
[778.635894] Starting dynamic subtest: rcs0
[778.802788] Dynamic subtest rcs0: SUCCESS (0.168s)
[778.815238] Starting dynamic subtest: vcs0
[778.921074] Dynamic subtest vcs0: SUCCESS (0.118s)
[778.938988] Starting dynamic subtest: vcs1
[779.039496] Dynamic subtest vcs1: SUCCESS (0.118s)
[779.057628] Starting dynamic subtest: vecs0
[779.150101] Dynamic subtest vecs0: SUCCESS (0.110s)
[779.167087] Starting dynamic subtest: ccs0
[779.284600] Dynamic subtest ccs0: SUCCESS (0.132s)
[779.287742] Subtest Q-out-order: SUCCESS (0.651s)
[780.899709] 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.