[58.894522] Initializing watchdogs
[58.894583]   /dev/watchdog0
[58.908473] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.912883] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.915523] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.918837] [001/133] (960s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[59.191933] Starting subtest: cursor-rapid-movement-256x85
[59.248477] Subtest cursor-rapid-movement-256x85: SKIP (0.051s)
[59.419647] [002/133] (960s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[59.508801] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[59.513112] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[59.584151] [003/133] (959s left) kms_plane_alpha_blend (alpha-transparent-fb)
[59.675444] Starting subtest: alpha-transparent-fb
[59.961214] Starting dynamic subtest: pipe-A-eDP-1
[60.629335] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.665s)
[60.637574] Starting dynamic subtest: pipe-D-eDP-1
[62.007506] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.373s)
[62.009863] Subtest alpha-transparent-fb: SUCCESS (2.327s)
[62.852376] [004/133] (956s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[62.957055] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[62.961646] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[63.047059] [005/133] (956s left) gem_softpin (allocator-fork)
[63.110348] Starting subtest: allocator-fork
[65.326348] Subtest allocator-fork: SUCCESS (2.212s)
[65.459102] [006/133] (954s left) perf_pmu (semaphore-busy)
[65.498820] Starting subtest: semaphore-busy
[65.501018] Starting dynamic subtest: rcs0
[67.143321] Dynamic subtest rcs0: SUCCESS (1.638s)
[67.152406] Starting dynamic subtest: bcs0
[68.893269] Dynamic subtest bcs0: SUCCESS (1.749s)
[68.903422] Starting dynamic subtest: vcs0
[73.477842] Dynamic subtest vcs0: SUCCESS (4.528s)
[73.488151] Starting dynamic subtest: vcs1
[79.493424] Dynamic subtest vcs1: SUCCESS (6.014s)
[79.503065] Starting dynamic subtest: vecs0
[85.394988] Dynamic subtest vecs0: SUCCESS (5.951s)
[85.404044] Starting dynamic subtest: ccs0
[88.529877] Dynamic subtest ccs0: SUCCESS (3.133s)
[88.532557] Subtest semaphore-busy: SUCCESS (23.020s)
[88.637369] [007/133] (931s left) api_intel_bb (blit-noreloc-purge-cache)
[88.696380] Starting subtest: blit-noreloc-purge-cache
[88.709229] Subtest blit-noreloc-purge-cache: SUCCESS (0.014s)
[88.793349] [008/133] (930s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[88.901959] Starting subtest: psr-2p-primscrn-cur-indfb-move
[88.906340] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[88.993116] [009/133] (930s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[89.091079] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[89.095519] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[89.180380] [010/133] (930s left) gem_softpin (invalid)
[89.236776] Starting subtest: invalid
[89.245148] Subtest invalid: SUCCESS (0.008s)
[89.366179] [011/133] (930s left) sysfs_heartbeat_interval (invalid)
[89.414813] Starting subtest: invalid
[89.417181] Starting dynamic subtest: vecs0
[89.419372] Dynamic subtest vecs0: SUCCESS (0.000s)
[89.430711] Starting dynamic subtest: ccs0
[89.432607] Dynamic subtest ccs0: SUCCESS (0.000s)
[89.439498] Starting dynamic subtest: vcs0
[89.441411] Dynamic subtest vcs0: SUCCESS (0.000s)
[89.448259] Starting dynamic subtest: bcs0
[89.450119] Dynamic subtest bcs0: SUCCESS (0.000s)
[89.457193] Starting dynamic subtest: rcs0
[89.459380] Dynamic subtest rcs0: SUCCESS (0.000s)
[89.466625] Starting dynamic subtest: vcs1
[89.468607] Dynamic subtest vcs1: SUCCESS (0.000s)
[89.470521] Subtest invalid: SUCCESS (0.003s)
[89.509384] [012/133] (930s left) kms_vrr (flip-dpms)
[89.597053] Starting subtest: flip-dpms
[89.602380] Subtest flip-dpms: SKIP (0.000s)
[89.682099] [013/133] (930s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[89.778092] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[96.815958] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.039s)
[96.940718] [014/133] (922s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[97.041175] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[97.045566] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[97.134504] [015/133] (922s left) kms_pm_dc (dc6-psr)
[98.239674] Starting subtest: dc6-psr
[101.108029] Subtest dc6-psr: SUCCESS (2.867s)
[101.908349] [016/133] (918s left) kms_plane_scaling (intel-max-src-size)
[102.010514] Starting subtest: intel-max-src-size
[102.016932] Subtest intel-max-src-size: SKIP (0.000s)
[102.112660] [017/133] (917s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[102.204881] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[102.208997] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[102.274189] [018/133] (917s left) prime_vgem (coherency-blt)
[102.422415] Starting subtest: coherency-blt
[103.443665] Subtest coherency-blt: SUCCESS (1.020s)
[103.567672] [FACT prime_vgem (coherency-blt)] new: kernel.kmod_is_loaded.vgem: true
[103.570743] [019/133] (916s left) i915_drm_fdinfo (virtual-busy-idle-all)
[103.609858] Starting subtest: virtual-busy-idle-all
[103.614140] Subtest virtual-busy-idle-all: SKIP (0.000s)
[103.690982] [020/133] (916s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[103.756930] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[103.759324] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[103.877720] [021/133] (916s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[103.972124] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[103.974365] Starting dynamic subtest: pipe-A-eDP-1
[104.042622] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[104.052844] Starting dynamic subtest: pipe-B-eDP-1
[105.186184] Dynamic subtest pipe-B-eDP-1: SKIP (1.142s)
[105.190987] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.221s)
[106.375346] [022/133] (913s left) prime_self_import (basic-llseek-size)
[106.412405] Starting subtest: basic-llseek-size
[106.426841] Subtest basic-llseek-size: SUCCESS (0.015s)
[106.520139] [023/133] (913s left) kms_lease (invalid-create-leases)
[106.620602] Starting subtest: invalid-create-leases
[106.624718] Subtest invalid-create-leases: SUCCESS (0.005s)
[106.725404] [024/133] (913s left) syncobj_timeline (invalid-signal-illegal-point)
[106.796697] Starting subtest: invalid-signal-illegal-point
[106.799074] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[106.901853] [025/133] (913s left) kms_psr (psr-sprite-mmap-gtt)
[106.996833] Starting subtest: psr-sprite-mmap-gtt
[106.999035] Starting dynamic subtest: eDP-1
[108.505039] Dynamic subtest eDP-1: SKIP (1.503s)
[108.509903] Subtest psr-sprite-mmap-gtt: SKIP (1.505s)
[108.674247] [026/133] (911s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[108.744835] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[108.850431] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.103s)
[108.924817] [027/133] (911s left) gem_request_retire (retire-vma-not-inactive)
[108.993301] Starting subtest: retire-vma-not-inactive
[109.053127] Subtest retire-vma-not-inactive: SUCCESS (0.057s)
[109.172351] [028/133] (911s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[109.256769] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[109.259068] Starting dynamic subtest: pipe-A-eDP-1
[109.267876] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[109.279879] Starting dynamic subtest: pipe-B-eDP-1
[109.288600] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[109.296080] Starting dynamic subtest: pipe-C-eDP-1
[109.304557] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[109.312095] Starting dynamic subtest: pipe-D-eDP-1
[109.320652] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[109.325049] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[111.498666] [029/133] (909s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[111.595499] Starting subtest: plane-upscale-20x20-with-rotation
[111.597752] Starting dynamic subtest: pipe-A
[111.821272] Dynamic subtest pipe-A: SUCCESS (0.227s)
[111.830804] Starting dynamic subtest: pipe-B
[113.079832] Dynamic subtest pipe-B: SUCCESS (1.258s)
[113.088894] Starting dynamic subtest: pipe-C
[114.411724] Dynamic subtest pipe-C: SUCCESS (1.331s)
[114.420823] Starting dynamic subtest: pipe-D
[115.748560] Dynamic subtest pipe-D: SUCCESS (1.336s)
[115.750908] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.155s)
[116.918424] [030/133] (903s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[117.010120] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[117.012462] Starting dynamic subtest: pipe-A-eDP-1
[117.033796] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.020s)
[117.047744] Starting dynamic subtest: pipe-B-eDP-1
[117.067407] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.021s)
[117.076622] Starting dynamic subtest: pipe-C-eDP-1
[117.096539] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[117.104647] Starting dynamic subtest: pipe-D-eDP-1
[117.124276] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.019s)
[117.126459] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.082s)
[119.316151] [031/133] (901s left) kms_vrr (max-min)
[119.405085] Starting subtest: max-min
[119.411205] Subtest max-min: SKIP (0.000s)
[119.475120] [032/133] (901s left) gem_pxp (create-regular-buffer)
[119.600522] Starting subtest: create-regular-buffer
[119.602761] Subtest create-regular-buffer: SUCCESS (0.000s)
[119.719944] [033/133] (900s left) kms_pm_rpm (modeset-non-lpsp-stress)
[121.270114] Starting subtest: modeset-non-lpsp-stress
[122.425091] Subtest modeset-non-lpsp-stress: SKIP (1.155s)
[122.804372] [034/133] (897s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[122.932480] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[122.936945] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[123.075796] [035/133] (897s left) gem_exec_schedule (u-fairslice-all)
[123.147625] Starting subtest: u-fairslice-all
[125.201205] Subtest u-fairslice-all: SUCCESS (2.054s)
[126.945401] [036/133] (893s left) perf (blocking)
[127.061108] Starting subtest: blocking
[127.063044] Starting dynamic subtest: 0-rcs0
[137.133242] Dynamic subtest 0-rcs0: SUCCESS (10.017s)
[137.143150] Starting dynamic subtest: 1-vecs0
[147.155728] Dynamic subtest 1-vecs0: SUCCESS (10.023s)
[147.158407] Subtest blocking: SUCCESS (20.042s)
[147.201853] [037/133] (873s left) kms_cursor_edge_walk (128x128-top-edge)
[147.302067] Starting subtest: 128x128-top-edge
[147.304479] Starting dynamic subtest: pipe-A-eDP-1
[150.748613] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.445s)
[150.758497] Starting dynamic subtest: pipe-D-eDP-1
[153.883105] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.135s)
[153.885463] Subtest 128x128-top-edge: SUCCESS (6.582s)
[154.693333] [038/133] (866s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[154.747156] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[154.851051] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.103s)
[154.925146] [039/133] (865s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[155.027384] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[155.029720] Starting dynamic subtest: pipe-A-eDP-1
[155.111342] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[155.120770] Starting dynamic subtest: pipe-B-eDP-1
[156.257871] Dynamic subtest pipe-B-eDP-1: SKIP (1.145s)
[156.262220] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.235s)
[157.459855] [040/133] (863s left) kms_addfb_basic (unused-pitches)
[157.522093] Starting subtest: unused-pitches
[157.524491] Subtest unused-pitches: SUCCESS (0.000s)
[157.659747] [041/133] (863s left) kms_busy (extended-pageflip-hang-newfb)
[157.762656] Starting subtest: extended-pageflip-hang-newfb
[157.765227] Starting dynamic subtest: pipe-A
[183.665532] Dynamic subtest pipe-A: SUCCESS (25.901s)
[183.677531] Starting dynamic subtest: pipe-D
[208.699030] Dynamic subtest pipe-D: SUCCESS (25.031s)
[208.701359] Subtest extended-pageflip-hang-newfb: SUCCESS (50.937s)
[209.528281] [042/133] (811s left) kms_hdr (static-toggle-dpms)
[209.629432] Starting subtest: static-toggle-dpms
[209.635739] Subtest static-toggle-dpms: SKIP (0.000s)
[209.714856] [043/133] (811s left) gem_mmap_gtt (cpuset-big-copy-odd)
[209.780610] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[209.832914] [044/133] (811s left) gem_exec_whisper (basic-contexts-priority-all)
[209.883528] Starting subtest: basic-contexts-priority-all
[232.750027] Subtest basic-contexts-priority-all: SUCCESS (22.810s)
[232.895324] [045/133] (788s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[232.952583] Starting subtest: basic-batch-kernel-default-cmd
[232.956629] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[233.149195] [046/133] (788s left) kms_color_pipeline (plane-lut1d-lut1d)
[233.247709] Starting subtest: plane-lut1d-lut1d
[233.371431] Starting dynamic subtest: pipe-A-plane-0
[233.704747] Dynamic subtest pipe-A-plane-0: FAIL (0.163s)
[233.715308] Starting dynamic subtest: pipe-A-plane-1
[233.937525] Dynamic subtest pipe-A-plane-1: FAIL (0.167s)
[233.947413] Starting dynamic subtest: pipe-A-plane-2
[234.186710] Dynamic subtest pipe-A-plane-2: FAIL (0.177s)
[235.140450] Starting dynamic subtest: pipe-B-plane-0
[235.575429] Dynamic subtest pipe-B-plane-0: FAIL (0.163s)
[235.586057] Starting dynamic subtest: pipe-B-plane-1
[235.897398] Dynamic subtest pipe-B-plane-1: FAIL (0.155s)
[235.907605] Starting dynamic subtest: pipe-B-plane-2
[236.198566] Dynamic subtest pipe-B-plane-2: FAIL (0.617s)
[237.228689] Starting dynamic subtest: pipe-C-plane-0
[237.737369] Dynamic subtest pipe-C-plane-0: FAIL (0.140s)
[237.747736] Starting dynamic subtest: pipe-C-plane-1
[238.147160] Dynamic subtest pipe-C-plane-1: FAIL (0.624s)
[238.155484] Starting dynamic subtest: pipe-C-plane-2
[238.553665] Dynamic subtest pipe-C-plane-2: FAIL (0.194s)
[239.375981] Starting dynamic subtest: pipe-D-plane-0
[239.980906] Dynamic subtest pipe-D-plane-0: FAIL (0.140s)
[239.991221] Starting dynamic subtest: pipe-D-plane-1
[240.445199] Dynamic subtest pipe-D-plane-1: FAIL (0.611s)
[240.454707] Starting dynamic subtest: pipe-D-plane-2
[240.893643] Dynamic subtest pipe-D-plane-2: FAIL (0.543s)
[240.973761] Subtest plane-lut1d-lut1d: FAIL (7.727s)
[241.839371] [047/133] (779s left) kms_psr (pr-dpms)
[241.935852] Starting subtest: pr-dpms
[241.941021] Subtest pr-dpms: SKIP (0.000s)
[242.018425] [048/133] (779s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[242.106598] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[242.111091] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[242.211621] [049/133] (779s left) kms_rotation_crc (sprite-rotation-270)
[242.298623] Starting subtest: sprite-rotation-270
[242.303096] Subtest sprite-rotation-270: SKIP (0.001s)
[242.372717] [050/133] (779s left) kms_plane_multiple (tiling-y)
[242.459384] Starting subtest: tiling-y
[242.463498] Subtest tiling-y: SKIP (0.000s)
[242.543498] [051/133] (778s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[242.655463] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[243.474852] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.820s)
[243.625945] [052/133] (777s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[243.721052] Starting subtest: 2x-flip-vs-modeset-vs-hang
[243.729377] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.010s)
[243.843419] [053/133] (777s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[243.941920] Starting subtest: 4-tiled-64bpp-rotate-90
[243.961344] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.019s)
[244.074639] [054/133] (777s left) gem_lmem_swapping (heavy-verify-random-ccs)
[244.117621] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[244.158521] [055/133] (777s left) kms_psr (fbc-psr-cursor-plane-move)
[244.241805] Starting subtest: fbc-psr-cursor-plane-move
[244.244075] Starting dynamic subtest: eDP-1
[244.248039] Dynamic subtest eDP-1: SKIP (0.000s)
[244.252048] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[244.321931] [056/133] (777s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[244.375867] Starting subtest: yf-tiled-ccs-to-yf-tiled
[244.379557] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[244.578272] [057/133] (777s left) kms_getfb (getfb2-handle-closed)
[244.659103] Starting subtest: getfb2-handle-closed
[244.661405] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[244.764540] [058/133] (776s left) gem_ctx_persistence (legacy-engines-queued)
[244.813128] Starting subtest: legacy-engines-queued
[244.815321] Starting dynamic subtest: render
[244.888925] Dynamic subtest render: SUCCESS (0.075s)
[244.901080] Starting dynamic subtest: bsd1
[246.902362] Dynamic subtest bsd1: SUCCESS (2.009s)
[246.914945] Starting dynamic subtest: bsd2
[248.882905] Dynamic subtest bsd2: SUCCESS (1.977s)
[248.894600] Starting dynamic subtest: blt
[248.943844] Dynamic subtest blt: SUCCESS (0.060s)
[248.954883] Starting dynamic subtest: vebox
[250.867555] Dynamic subtest vebox: SUCCESS (1.920s)
[250.870563] Subtest legacy-engines-queued: SUCCESS (6.054s)
[250.950122] [059/133] (770s left) kms_flip (2x-flip-vs-dpms-on-nop)
[251.074161] Starting subtest: 2x-flip-vs-dpms-on-nop
[251.085563] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s)
[251.205742] [060/133] (770s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[251.315562] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[251.319932] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[251.407524] [061/133] (770s left) kms_big_fb (x-tiled-addfb)
[251.501178] Starting subtest: x-tiled-addfb
[251.503307] Subtest x-tiled-addfb: SUCCESS (0.000s)
[251.613575] [062/133] (770s left) gem_exec_reloc (basic-gtt-read-active)
[251.675586] Subtest basic-gtt-read-active: SKIP (0.000s)
[251.751360] [063/133] (770s left) kms_content_protection (atomic)
[251.889607] Starting subtest: atomic
[251.893291] Subtest atomic: SKIP (0.000s)
[252.007680] [064/133] (769s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[252.103100] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[252.106614] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[252.209843] [065/133] (769s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[252.328485] Starting subtest: basic-flip-before-cursor-legacy
[253.259257] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.929s)
[254.064995] [066/133] (768s left) gem_exec_fence (expired-history)
[254.545086] Starting subtest: expired-history
[261.629249] Subtest expired-history: SUCCESS (7.078s)
[262.246191] [067/133] (759s left) gem_exec_balancer (individual)
[262.302466] Starting subtest: individual
[263.893222] Subtest individual: SUCCESS (1.589s)
[264.255282] [068/133] (757s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[264.341938] Starting subtest: fbc-psr2-primary-mmap-gtt
[264.344591] Starting dynamic subtest: eDP-1
[264.349172] Dynamic subtest eDP-1: SKIP (0.000s)
[264.353522] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[264.414999] [069/133] (757s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[264.459681] Starting subtest: multi-wait-available-unsubmitted-signaled
[264.461777] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[264.564386] [070/133] (757s left) kms_flip (blocking-absolute-wf_vblank)
[264.660088] Starting subtest: blocking-absolute-wf_vblank
[264.662374] Starting dynamic subtest: A-eDP1
[273.458998] Dynamic subtest A-eDP1: SUCCESS (8.763s)
[273.468569] Starting dynamic subtest: B-eDP1
[282.190618] Dynamic subtest B-eDP1: SUCCESS (8.731s)
[282.200719] Starting dynamic subtest: C-eDP1
[290.922227] Dynamic subtest C-eDP1: SUCCESS (8.716s)
[290.931141] Starting dynamic subtest: D-eDP1
[299.657359] Dynamic subtest D-eDP1: SUCCESS (8.731s)
[299.659809] Subtest blocking-absolute-wf_vblank: SUCCESS (34.954s)
[300.825521] [071/133] (721s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[300.882718] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[300.986536] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.102s)
[301.065617] [072/133] (721s left) kms_psr (psr2-sprite-render)
[301.154041] Starting subtest: psr2-sprite-render
[301.156271] Starting dynamic subtest: eDP-1
[302.904026] Dynamic subtest eDP-1: SUCCESS (1.749s)
[302.906359] Subtest psr2-sprite-render: SUCCESS (1.750s)
[303.782430] [073/133] (718s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[303.881049] Starting subtest: fbc-rgb101010-draw-render
[308.493943] Subtest fbc-rgb101010-draw-render: SUCCESS (4.617s)
[309.676380] [074/133] (712s left) i915_pm_rps (waitboost)
[309.742886] Starting subtest: waitboost
[316.092343] Subtest waitboost: SUCCESS (6.347s)
[316.169926] [075/133] (706s left) gem_exec_schedule (preempt-other-chain)
[316.244183] Starting subtest: preempt-other-chain
[316.246399] Starting dynamic subtest: rcs0
[316.376271] Dynamic subtest rcs0: SUCCESS (0.137s)
[316.386415] Starting dynamic subtest: bcs0
[316.516895] Dynamic subtest bcs0: SUCCESS (0.140s)
[316.532105] Starting dynamic subtest: vcs0
[316.642773] Dynamic subtest vcs0: SUCCESS (0.125s)
[316.654792] Starting dynamic subtest: vcs1
[316.766929] Dynamic subtest vcs1: SUCCESS (0.124s)
[316.780012] Starting dynamic subtest: vecs0
[316.894041] Dynamic subtest vecs0: SUCCESS (0.126s)
[316.906802] Starting dynamic subtest: ccs0
[317.019490] Dynamic subtest ccs0: SUCCESS (0.125s)
[317.021869] Subtest preempt-other-chain: SUCCESS (0.782s)
[318.006620] [076/133] (704s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[318.130053] Starting subtest: flip-vs-cursor-crc-legacy
[318.775675] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.644s)
[319.594311] [077/133] (702s left) kms_draw_crc (draw-method-blt)
[319.685507] Starting subtest: draw-method-blt
[319.687651] Starting dynamic subtest: xrgb8888-untiled
[319.928268] Dynamic subtest xrgb8888-untiled: SUCCESS (0.243s)
[319.937577] Starting dynamic subtest: rgb565-untiled
[320.139454] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[320.148585] Starting dynamic subtest: xrgb2101010-untiled
[320.361598] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.220s)
[320.371235] Starting dynamic subtest: xbgr16161616f-untiled
[320.583666] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.222s)
[320.594595] Starting dynamic subtest: xrgb8888-xtiled
[320.695043] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.109s)
[320.709169] Starting dynamic subtest: rgb565-xtiled
[320.806314] Dynamic subtest rgb565-xtiled: SUCCESS (0.109s)
[320.814990] Starting dynamic subtest: xrgb2101010-xtiled
[320.916830] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[320.925398] Starting dynamic subtest: xbgr16161616f-xtiled
[321.038941] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.121s)
[321.048678] Starting dynamic subtest: xrgb8888-4tiled
[321.161148] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.121s)
[321.169513] Starting dynamic subtest: rgb565-4tiled
[321.283922] Dynamic subtest rgb565-4tiled: SUCCESS (0.121s)
[321.292273] Starting dynamic subtest: xrgb2101010-4tiled
[321.383663] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.099s)
[321.392289] Starting dynamic subtest: xbgr16161616f-4tiled
[321.483491] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.099s)
[321.485451] Subtest draw-method-blt: SUCCESS (1.800s)
[321.611832] [078/133] (700s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[321.715646] Starting subtest: y-tiled-32bpp-rotate-180
[321.719259] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[321.808463] [079/133] (700s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[321.893495] Starting subtest: bad-aux-stride-y-tiled-ccs
[321.895435] Starting dynamic subtest: pipe-A-eDP-1
[321.914661] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[321.924601] Starting dynamic subtest: pipe-B-eDP-1
[321.942369] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[321.949779] Starting dynamic subtest: pipe-C-eDP-1
[321.967256] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[321.974885] Starting dynamic subtest: pipe-D-eDP-1
[321.992760] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[321.996240] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.005s)
[324.077046] [080/133] (698s left) template (b)
[324.139484] Starting subtest: B
[324.141482] Subtest B: SUCCESS (0.000s)
[324.228016] [081/133] (698s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[324.328452] Starting subtest: psr-1p-primscrn-cur-indfb-move
[331.633696] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.308s)
[331.772928] [082/133] (690s left) kms_dp_link_training (non-uhbr-mst)
[331.885264] Starting subtest: non-uhbr-mst
[331.894121] Subtest non-uhbr-mst: SKIP (0.000s)
[331.978469] [083/133] (690s left) perf (polling)
[332.073282] Starting subtest: polling
[332.075615] Starting dynamic subtest: 0-rcs0
[342.162479] Dynamic subtest 0-rcs0: SUCCESS (10.033s)
[342.173428] Starting dynamic subtest: 1-vcs0
[352.180092] Dynamic subtest 1-vcs0: SUCCESS (10.018s)
[352.182249] Subtest polling: SUCCESS (20.054s)
[352.221871] [084/133] (670s left) gem_ccs (block-copy-compressed)
[352.294448] Starting subtest: block-copy-compressed
[352.299132] Subtest block-copy-compressed: SKIP (0.000s)
[352.395483] [085/133] (670s left) gem_exec_params (invalid-bsd2-flag-on-render)
[352.454640] Starting subtest: invalid-bsd2-flag-on-render
[352.456921] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[352.558999] [086/133] (670s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[352.654292] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[352.747965] [087/133] (670s left) gem_exec_reloc (basic-cpu-read)
[352.811405] Subtest basic-cpu-read: SKIP (0.000s)
[352.883664] [088/133] (670s left) kms_chamelium_color (ctm-negative)
[352.979178] Subtest ctm-negative: SKIP (0.000s)
[353.027222] [089/133] (670s left) kms_rmfb (close-fd)
[353.121581] Starting subtest: close-fd
[353.123733] Starting dynamic subtest: pipe-A-eDP-1
[353.230055] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.107s)
[353.248151] Starting dynamic subtest: pipe-B-eDP-1
[354.373895] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.143s)
[354.382376] Starting dynamic subtest: pipe-C-eDP-1
[355.507195] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.131s)
[355.519201] Starting dynamic subtest: pipe-D-eDP-1
[356.642194] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.133s)
[356.644587] Subtest close-fd: SUCCESS (3.519s)
[357.858831] [090/133] (665s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[357.964639] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[357.969143] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[358.052938] [091/133] (665s left) gem_flink_race (flink_name)
[358.086698] Starting subtest: flink_name
[363.542344] Subtest flink_name: SUCCESS (5.400s)
[363.603565] [092/133] (659s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[363.715893] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[370.508765] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.794s)
[370.671317] [093/133] (652s left) gem_ringfill (basic-all)
[375.897734] Starting subtest: basic-all
[377.071435] Subtest basic-all: SUCCESS (1.173s)
[377.186679] [094/133] (646s left) i915_pm_rps (basic-api)
[377.259321] Starting subtest: basic-api
[377.264229] Subtest basic-api: SKIP (0.001s)
[377.357828] [095/133] (645s left) gem_wait (write-wait)
[377.434649] Starting subtest: write-wait
[377.437044] Starting dynamic subtest: all-engines
[378.554950] Dynamic subtest all-engines: SUCCESS (1.119s)
[378.572707] Starting dynamic subtest: rcs0
[379.611915] Dynamic subtest rcs0: SUCCESS (1.054s)
[379.628629] Starting dynamic subtest: bcs0
[380.668194] Dynamic subtest bcs0: SUCCESS (1.054s)
[380.685466] Starting dynamic subtest: vcs0
[381.723049] Dynamic subtest vcs0: SUCCESS (1.053s)
[381.738777] Starting dynamic subtest: vcs1
[382.775900] Dynamic subtest vcs1: SUCCESS (1.050s)
[382.791730] Starting dynamic subtest: vecs0
[383.829131] Dynamic subtest vecs0: SUCCESS (1.051s)
[383.845488] Starting dynamic subtest: ccs0
[384.885568] Dynamic subtest ccs0: SUCCESS (1.055s)
[384.888157] Subtest write-wait: SUCCESS (7.452s)
[385.101795] [096/133] (638s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[385.215359] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[388.892032] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.680s)
[390.032117] [097/133] (633s left) gem_ctx_shared (detached-shared-gtt)
[390.096933] Starting subtest: detached-shared-gtt
[392.301991] Subtest detached-shared-gtt: SUCCESS (2.150s)
[392.664698] [098/133] (630s left) gem_linear_blits (basic)
[393.043801] Starting subtest: basic
[393.058970] Subtest basic: SUCCESS (0.015s)
[393.197534] [099/133] (630s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[393.359632] Starting subtest: short-flip-before-cursor-atomic-transitions
[394.356864] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.997s)
[395.241733] [100/133] (628s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[395.623624] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[396.438788] [101/133] (627s left) gem_exec_gttfill (engines)
[396.528404] Starting subtest: engines
[396.530829] Starting dynamic subtest: rcs0
[419.186834] Dynamic subtest rcs0: SUCCESS (22.659s)
[419.200809] Starting dynamic subtest: bcs0
[442.488689] Dynamic subtest bcs0: SUCCESS (23.299s)
[442.499505] Starting dynamic subtest: vcs0
[465.791771] Dynamic subtest vcs0: SUCCESS (23.301s)
[465.804027] Starting dynamic subtest: vcs1
[489.080352] Dynamic subtest vcs1: SUCCESS (23.287s)
[489.092972] Starting dynamic subtest: vecs0
[512.452737] Dynamic subtest vecs0: SUCCESS (23.368s)
[512.464776] Starting dynamic subtest: ccs0
[535.798365] Dynamic subtest ccs0: SUCCESS (23.343s)
[535.801065] Subtest engines: SUCCESS (139.269s)
[535.994218] [102/133] (487s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[536.150587] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[536.154890] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[536.272448] [103/133] (487s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[536.372065] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[536.376229] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[536.477704] [104/133] (487s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[536.568423] Starting subtest: 2x-flip-vs-rmfb-interruptible
[536.579687] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.010s)
[536.680629] [105/133] (487s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[536.769403] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[536.773717] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[536.858836] [106/133] (486s left) core_getversion (all-cards)
[536.905890] Starting subtest: all-cards
[536.925139] Subtest all-cards: SUCCESS (0.022s)
[536.962560] [107/133] (486s left) gem_ctx_exec (basic-nohangcheck)
[537.017091] Starting subtest: basic-nohangcheck
[537.277994] Subtest basic-nohangcheck: SUCCESS (0.261s)
[537.392715] [108/133] (486s left) kms_psr (fbc-pr-no-drrs)
[537.484272] Starting subtest: fbc-pr-no-drrs
[537.488472] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[537.569423] [109/133] (486s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[537.628533] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[537.679432] [110/133] (486s left) i915_drm_fdinfo (most-busy-check-all)
[537.726170] Starting subtest: most-busy-check-all
[537.728085] Starting dynamic subtest: rcs0
[537.732651] Dynamic subtest rcs0: SKIP (0.004s)
[537.743922] Starting dynamic subtest: bcs0
[537.748316] Dynamic subtest bcs0: SKIP (0.000s)
[537.757073] Starting dynamic subtest: vcs0
[537.761517] Dynamic subtest vcs0: SKIP (0.000s)
[537.770520] Starting dynamic subtest: vcs1
[537.774710] Dynamic subtest vcs1: SKIP (0.000s)
[537.783703] Starting dynamic subtest: vecs0
[537.788043] Dynamic subtest vecs0: SKIP (0.000s)
[537.796948] Starting dynamic subtest: ccs0
[537.801223] Dynamic subtest ccs0: SKIP (0.000s)
[537.805565] Subtest most-busy-check-all: SKIP (0.009s)
[537.845254] [111/133] (486s left) gen3_render_tiledy_blits
[537.991514] [112/133] (486s left) gem_softpin (evict-active)
[538.047595] Starting subtest: evict-active
[538.052448] Subtest evict-active: SUCCESS (0.007s)
[538.147592] [113/133] (485s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[538.258710] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[538.262373] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[538.378329] [114/133] (485s left) gem_exec_params (invalid-bsd1-flag-on-render)
[538.443218] Starting subtest: invalid-bsd1-flag-on-render
[538.445271] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[538.547278] [115/133] (485s left) kms_atomic (crtc-invalid-params)
[538.627736] Starting subtest: crtc-invalid-params
[538.629683] Starting dynamic subtest: pipe-A-eDP-1
[539.016341] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.389s)
[539.018703] Subtest crtc-invalid-params: SUCCESS (0.390s)
[539.899195] [116/133] (484s left) gem_exec_fence (parallel)
[540.067895] Starting subtest: parallel
[540.070463] Starting dynamic subtest: rcs0
[542.216289] Dynamic subtest rcs0: SUCCESS (2.149s)
[542.227074] Starting dynamic subtest: bcs0
[544.366139] Dynamic subtest bcs0: SUCCESS (2.149s)
[544.376631] Starting dynamic subtest: vcs0
[546.519883] Dynamic subtest vcs0: SUCCESS (2.153s)
[546.530960] Starting dynamic subtest: vcs1
[548.671058] Dynamic subtest vcs1: SUCCESS (2.150s)
[548.681298] Starting dynamic subtest: vecs0
[550.821011] Dynamic subtest vecs0: SUCCESS (2.149s)
[550.831344] Starting dynamic subtest: ccs0
[552.973739] Dynamic subtest ccs0: SUCCESS (2.152s)
[552.975612] Subtest parallel: SUCCESS (12.907s)
[554.040695] [117/133] (470s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[554.143242] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[555.244406] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.102s)
[555.355103] [118/133] (468s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[555.448274] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[555.451554] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[555.553363] [119/133] (468s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[555.645636] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[555.649237] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[555.753776] [120/133] (468s left) kms_cursor_crc (cursor-onscreen-512x512)
[556.019984] Starting subtest: cursor-onscreen-512x512
[556.024018] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[556.190883] [121/133] (468s left) gem_ctx_engines (execute-allforone)
[556.256661] Starting subtest: execute-allforone
[556.276592] Subtest execute-allforone: SUCCESS (0.020s)
[557.918942] [122/133] (466s left) gen9_exec_parse (bb-start-far)
[557.981526] Subtest bb-start-far: SKIP (0.000s)
[558.059587] [123/133] (466s left) gem_exec_fence (basic-busy-all)
[558.110316] Starting subtest: basic-busy-all
[558.191515] Subtest basic-busy-all: SUCCESS (0.082s)
[559.962852] [124/133] (464s left) gem_caching (read-writes)
[560.017304] Subtest read-writes: SKIP (0.000s)
[560.104765] [125/133] (464s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[560.158918] Starting subtest: single-wait-all-for-submit-available-signaled
[560.161405] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[560.278996] [126/133] (464s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[560.384664] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[560.389078] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[560.479770] [127/133] (464s left) gem_mmap_offset (bad-flags)
[560.541661] Starting subtest: bad-flags
[560.543952] Subtest bad-flags: SUCCESS (0.000s)
[560.648616] [128/133] (464s left) kms_vblank (invalid)
[560.732816] Starting subtest: invalid
[560.735117] Starting dynamic subtest: pipe-A-eDP-1
[561.143349] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.410s)
[561.145615] Subtest invalid: SUCCESS (0.411s)
[562.027571] [129/133] (462s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[562.131845] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[562.134154] Starting dynamic subtest: pipe-A-eDP-1
[562.155057] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[562.166731] Starting dynamic subtest: pipe-B-eDP-1
[562.185787] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[562.194359] Starting dynamic subtest: pipe-C-eDP-1
[562.213639] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[562.222420] Starting dynamic subtest: pipe-D-eDP-1
[562.241690] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[562.243575] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[564.288585] [130/133] (460s left) syncobj_wait (invalid-signal-one-illegal-handle)
[564.351057] Starting subtest: invalid-signal-one-illegal-handle
[564.353314] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[564.446176] [131/133] (460s left) api_intel_bb (simple-bb-ctx)
[564.508575] Starting subtest: simple-bb-ctx
[564.515302] Subtest simple-bb-ctx: SUCCESS (0.009s)
[564.645193] [132/133] (460s left) kms_chamelium_color (gamma)
[564.745050] Subtest gamma: SKIP (0.000s)
[564.789606] [133/133] (460s left) gem_ctx_param (set-priority-not-supported)
[564.851510] Starting subtest: set-priority-not-supported
[564.856080] Subtest set-priority-not-supported: SKIP (0.000s)
[564.926967] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_crc
results: parsing output: 1/ for test: kms_flip_scaled_crc
results: parsing output: 2/ for test: kms_plane_alpha_blend
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_softpin
results: parsing output: 5/ for test: perf_pmu
results: parsing output: 6/ for test: api_intel_bb
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: gem_softpin
results: parsing output: 10/ for test: sysfs_heartbeat_interval
results: parsing output: 11/ for test: kms_vrr
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_pm_dc
results: parsing output: 15/ for test: kms_plane_scaling
results: parsing output: 16/ for test: kms_plane
results: parsing output: 17/ for test: prime_vgem
results: parsing output: 18/ for test: i915_drm_fdinfo
results: parsing output: 19/ for test: syncobj_wait
results: parsing output: 20/ for test: kms_psr2_sf
results: parsing output: 21/ for test: prime_self_import
results: parsing output: 22/ for test: kms_lease
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: syncobj_wait
results: parsing output: 26/ for test: gem_request_retire
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: kms_plane_scaling
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: kms_vrr
results: parsing output: 31/ for test: gem_pxp
results: parsing output: 32/ for test: kms_pm_rpm
results: parsing output: 33/ for test: kms_cursor_legacy
results: parsing output: 34/ for test: gem_exec_schedule
results: parsing output: 35/ for test: perf
results: parsing output: 36/ for test: kms_cursor_edge_walk
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: kms_psr2_sf
results: parsing output: 39/ for test: kms_addfb_basic
results: parsing output: 40/ for test: kms_busy
results: parsing output: 41/ for test: kms_hdr
results: parsing output: 42/ for test: gem_mmap_gtt
results: parsing output: 43/ for test: gem_exec_whisper
results: parsing output: 44/ for test: gem_exec_flush
results: parsing output: 45/ for test: kms_color_pipeline
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_rotation_crc
results: parsing output: 49/ for test: kms_plane_multiple
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: gem_lmem_swapping
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: gem_render_copy
results: parsing output: 56/ for test: kms_getfb
results: parsing output: 57/ for test: gem_ctx_persistence
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: gem_exec_reloc
results: parsing output: 62/ for test: kms_content_protection
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_cursor_legacy
results: parsing output: 65/ for test: gem_exec_fence
results: parsing output: 66/ for test: gem_exec_balancer
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: syncobj_timeline
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: i915_pm_rps
results: parsing output: 74/ for test: gem_exec_schedule
results: parsing output: 75/ for test: kms_cursor_legacy
results: parsing output: 76/ for test: kms_draw_crc
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: template
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_dp_link_training
results: parsing output: 82/ for test: perf
results: parsing output: 83/ for test: gem_ccs
results: parsing output: 84/ for test: gem_exec_params
results: parsing output: 85/ for test: kms_addfb_basic
results: parsing output: 86/ for test: gem_exec_reloc
results: parsing output: 87/ for test: kms_chamelium_color
results: parsing output: 88/ for test: kms_rmfb
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gem_flink_race
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_ringfill
results: parsing output: 93/ for test: i915_pm_rps
results: parsing output: 94/ for test: gem_wait
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_ctx_shared
results: parsing output: 97/ for test: gem_linear_blits
results: parsing output: 98/ for test: kms_cursor_legacy
results: parsing output: 99/ for test: kms_chamelium_hpd
results: parsing output: 100/ for test: gem_exec_gttfill
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: core_getversion
results: parsing output: 106/ for test: gem_ctx_exec
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: kms_pipe_b_c_ivb
results: parsing output: 109/ for test: i915_drm_fdinfo
results: parsing output: 110/ for test: gen3_render_tiledy_blits
results: parsing output: 111/ for test: gem_softpin
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_exec_params
results: parsing output: 114/ for test: kms_atomic
results: parsing output: 115/ for test: gem_exec_fence
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_cursor_crc
results: parsing output: 120/ for test: gem_ctx_engines
results: parsing output: 121/ for test: gen9_exec_parse
results: parsing output: 122/ for test: gem_exec_fence
results: parsing output: 123/ for test: gem_caching
results: parsing output: 124/ for test: syncobj_timeline
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_mmap_offset
results: parsing output: 127/ for test: kms_vblank
results: parsing output: 128/ for test: kms_ccs
results: parsing output: 129/ for test: syncobj_wait
results: parsing output: 130/ for test: api_intel_bb
results: parsing output: 131/ for test: kms_chamelium_color
results: parsing output: 132/ for test: gem_ctx_param
Done.