[60.718355] Initializing watchdogs
[60.718397]   /dev/watchdog0
[60.738508] [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]
[60.742913] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.745371] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.748702] [001/133] (960s left) perf_pmu (all-busy-check-all)
[60.816740] Starting subtest: all-busy-check-all
[61.910796] Subtest all-busy-check-all: SUCCESS (1.092s)
[62.034191] [002/133] (959s left) gem_render_copy (y-tiled-to-vebox-linear)
[62.096937] Starting subtest: y-tiled-to-vebox-linear
[62.101621] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[62.301202] [003/133] (959s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[62.373410] Starting subtest: map-fixed-invalidate-overlap
[62.378539] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[62.535337] [004/133] (958s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[62.636219] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[62.640208] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[62.735986] [005/133] (958s left) syncobj_timeline (wait-all-for-submit-complex)
[62.786828] Starting subtest: wait-all-for-submit-complex
[63.000912] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[63.085179] [006/133] (958s left) gen9_exec_parse (secure-batches)
[63.139567] Subtest secure-batches: SKIP (0.000s)
[63.211091] [007/133] (958s left) gem_mmap_gtt (isolation)
[63.267784] Subtest isolation: SKIP (0.000s)
[63.329060] [008/133] (958s left) kms_rotation_crc (primary-rotation-180)
[63.406349] Starting subtest: primary-rotation-180
[70.364180] Subtest primary-rotation-180: SUCCESS (6.958s)
[71.551595] [009/133] (949s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[71.647950] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[71.650464] Starting dynamic subtest: pipe-A-eDP-1
[71.673722] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[71.682758] Starting dynamic subtest: pipe-B-eDP-1
[71.704168] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[71.711306] Starting dynamic subtest: pipe-C-eDP-1
[71.731846] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[71.739139] Starting dynamic subtest: pipe-D-eDP-1
[71.761186] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[71.765165] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[73.922343] [010/133] (947s left) kms_properties (plane-properties-legacy)
[74.011881] Starting subtest: plane-properties-legacy
[74.014306] Starting dynamic subtest: pipe-A-eDP-1
[74.579121] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.569s)
[74.586755] Starting dynamic subtest: pipe-B-eDP-1
[75.881091] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.300s)
[75.889908] Starting dynamic subtest: pipe-C-eDP-1
[77.113867] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.232s)
[77.122823] Starting dynamic subtest: pipe-D-eDP-1
[78.347543] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.231s)
[78.349904] Subtest plane-properties-legacy: SUCCESS (4.336s)
[79.156458] [011/133] (942s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[79.275826] Starting subtest: yf-tiled-32bpp-rotate-270
[79.280572] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[79.415566] [012/133] (942s left) gem_exec_fence (basic-wait)
[79.597311] Starting subtest: basic-wait
[79.599767] Starting dynamic subtest: rcs0
[79.684036] Dynamic subtest rcs0: SUCCESS (0.087s)
[79.693226] Starting dynamic subtest: bcs0
[79.752510] Dynamic subtest bcs0: SUCCESS (0.068s)
[79.762160] Starting dynamic subtest: vcs0
[79.817934] Dynamic subtest vcs0: SUCCESS (0.065s)
[79.827954] Starting dynamic subtest: vcs1
[79.877933] Dynamic subtest vcs1: SUCCESS (0.058s)
[79.889833] Starting dynamic subtest: vecs0
[79.932820] Dynamic subtest vecs0: SUCCESS (0.054s)
[79.941738] Starting dynamic subtest: ccs0
[79.993701] Dynamic subtest ccs0: SUCCESS (0.060s)
[79.996113] Subtest basic-wait: SUCCESS (0.397s)
[82.013608] [FACT gem_exec_fence (basic-wait)] new: kernel.kmod_is_loaded.vgem: true
[82.016659] [013/133] (939s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[82.117460] Starting subtest: async-flip-with-page-flip-events-linear
[82.501053] Starting dynamic subtest: pipe-A-eDP-1
[85.241993] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.739s)
[85.603611] Starting dynamic subtest: pipe-B-eDP-1
[88.372779] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.776s)
[88.754910] Starting dynamic subtest: pipe-C-eDP-1
[91.504803] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.755s)
[91.872977] Starting dynamic subtest: pipe-D-eDP-1
[94.642077] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.776s)
[94.644527] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.524s)
[95.858200] [014/133] (925s left) kms_psr (fbc-psr-cursor-plane-move)
[95.961290] Starting subtest: fbc-psr-cursor-plane-move
[95.963235] Starting dynamic subtest: eDP-1
[95.967238] Dynamic subtest eDP-1: SKIP (0.000s)
[95.971298] Subtest fbc-psr-cursor-plane-move: SKIP (0.000s)
[96.055417] [015/133] (925s left) kms_psr (pr-cursor-plane-onoff)
[96.150973] Starting subtest: pr-cursor-plane-onoff
[96.155191] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[96.230381] [016/133] (925s left) prime_vgem (fence-flip-hang)
[96.322883] Subtest fence-flip-hang: SKIP (0.000s)
[96.460752] [017/133] (925s left) drm_mm (drm_mm)
[96.497582] Starting subtest: drm_mm
[96.505701] Starting dynamic subtest: drm_test_mm_init
[96.649794] Dynamic subtest drm_test_mm_init: SUCCESS (0.142s)
[96.658398] Starting dynamic subtest: drm_test_mm_debug
[96.771357] Dynamic subtest drm_test_mm_debug: SUCCESS (0.122s)
[96.780719] Starting dynamic subtest: drm_test_mm_align32
[96.934473] Dynamic subtest drm_test_mm_align32: SUCCESS (0.162s)
[96.943665] Starting dynamic subtest: drm_test_mm_align64
[97.072477] Dynamic subtest drm_test_mm_align64: SUCCESS (0.138s)
[97.081518] Starting dynamic subtest: drm_test_mm_lowest
[97.164085] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.093s)
[97.171225] Starting dynamic subtest: drm_test_mm_highest
[97.285976] Dynamic subtest drm_test_mm_highest: SUCCESS (0.120s)
[97.288019] Subtest drm_mm: SUCCESS (0.788s)
[97.499335] [018/133] (924s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[97.592193] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[97.603752] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[97.694007] [019/133] (924s left) kms_vrr (lobf)
[97.791808] Starting subtest: lobf
[97.796442] Subtest lobf: SKIP (0.000s)
[97.884605] [020/133] (924s left) kms_async_flips (test-cursor-atomic)
[97.976890] Starting subtest: test-cursor-atomic
[97.981209] Subtest test-cursor-atomic: SKIP (0.000s)
[99.183219] [021/133] (922s left) kms_plane_multiple (2x-tiling-none)
[99.284815] Starting subtest: 2x-tiling-none
[99.289201] Subtest 2x-tiling-none: SKIP (0.000s)
[99.370278] [022/133] (922s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[99.428864] Starting subtest: etime-single-wait-all-available-unsubmitted
[99.536792] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.107s)
[99.622204] [023/133] (922s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[99.724564] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[99.726859] Starting dynamic subtest: pipe-A-eDP-1
[99.808796] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[99.818459] Starting dynamic subtest: pipe-B-eDP-1
[100.951655] Dynamic subtest pipe-B-eDP-1: SKIP (1.142s)
[100.956121] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.232s)
[102.144827] [024/133] (920s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[102.243182] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[109.235218] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.994s)
[109.374664] [025/133] (912s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[109.461288] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[109.463632] Starting dynamic subtest: pipe-A
[109.481720] Dynamic subtest pipe-A: SKIP (0.017s)
[109.497981] Starting dynamic subtest: pipe-B
[109.512629] Dynamic subtest pipe-B: SKIP (0.029s)
[109.529280] Starting dynamic subtest: pipe-C
[109.543269] Dynamic subtest pipe-C: SKIP (0.030s)
[109.552047] Starting dynamic subtest: pipe-D
[109.571828] Dynamic subtest pipe-D: SKIP (0.029s)
[109.575978] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.107s)
[109.697962] [026/133] (912s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[109.799318] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[114.268687] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.474s)
[115.499657] [027/133] (906s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[115.613929] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[115.618609] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[115.750763] [028/133] (906s left) kms_cursor_crc (cursor-sliding-128x128)
[115.977638] Starting subtest: cursor-sliding-128x128
[115.982407] Starting dynamic subtest: pipe-A-eDP-1
[119.187946] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.205s)
[119.216930] Starting dynamic subtest: pipe-D-eDP-1
[123.037079] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.831s)
[123.039369] Subtest cursor-sliding-128x128: SUCCESS (7.062s)
[123.929492] [029/133] (898s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[124.023160] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[124.027614] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[124.130297] [030/133] (898s left) core_auth (many-magics)
[124.196141] Starting subtest: many-magics
[125.032116] Subtest many-magics: SUCCESS (0.837s)
[125.261768] [031/133] (897s left) gem_reg_read (bad-register)
[125.330619] Starting subtest: bad-register
[125.332823] Subtest bad-register: SUCCESS (0.000s)
[125.463238] [032/133] (897s left) kms_invalid_mode (bad-vtotal)
[125.565986] Starting subtest: bad-vtotal
[125.568355] Starting dynamic subtest: pipe-A-eDP-1
[125.859830] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.295s)
[125.869765] Starting dynamic subtest: pipe-B-eDP-1
[125.872176] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[125.879650] Starting dynamic subtest: pipe-C-eDP-1
[125.882056] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[125.889377] Starting dynamic subtest: pipe-D-eDP-1
[125.891652] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[125.893930] Subtest bad-vtotal: SUCCESS (0.299s)
[126.676098] [033/133] (895s left) kms_psr (psr2-cursor-render)
[126.785108] Starting subtest: psr2-cursor-render
[126.787453] Starting dynamic subtest: eDP-1
[128.526455] Dynamic subtest eDP-1: SUCCESS (1.741s)
[128.528736] Subtest psr2-cursor-render: SUCCESS (1.742s)
[129.341030] [034/133] (893s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[129.438916] Starting subtest: random-ccs-data-yf-tiled-ccs
[129.441268] Starting dynamic subtest: pipe-A-eDP-1
[129.466592] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[129.476309] Starting dynamic subtest: pipe-B-eDP-1
[129.498912] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[129.506114] Starting dynamic subtest: pipe-C-eDP-1
[129.528201] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[129.535200] Starting dynamic subtest: pipe-D-eDP-1
[129.559324] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[129.563755] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.004s)
[131.707404] [035/133] (890s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[131.771789] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[131.839757] [036/133] (890s left) gem_tiling_max_stride
[131.962433] [037/133] (890s left) kms_cursor_crc (cursor-onscreen-512x512)
[132.217092] Starting subtest: cursor-onscreen-512x512
[132.221841] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[132.404602] [038/133] (890s left) kms_flip (2x-blocking-absolute-wf_vblank)
[132.497395] Starting subtest: 2x-blocking-absolute-wf_vblank
[132.506257] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.010s)
[132.611733] [039/133] (890s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[132.718089] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[132.721693] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[132.846805] [040/133] (889s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[132.945162] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[132.946998] Starting dynamic subtest: pipe-A-eDP-1
[132.964542] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[132.974061] Starting dynamic subtest: pipe-B-eDP-1
[132.990477] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[132.997889] Starting dynamic subtest: pipe-C-eDP-1
[133.013783] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[133.021011] Starting dynamic subtest: pipe-D-eDP-1
[133.036952] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[133.038754] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.012s)
[135.163045] [041/133] (887s left) sw_sync (sync_busy)
[135.196962] Starting subtest: sync_busy
[135.199237] Subtest sync_busy: SUCCESS (0.002s)
[135.271920] [042/133] (887s left) gem_mmap (pf-nonblock)
[135.329499] Subtest pf-nonblock: SKIP (0.000s)
[135.390843] [043/133] (887s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[135.491778] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[135.496082] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[135.597515] [044/133] (887s left) gem_softpin (evict-snoop)
[135.653604] Starting subtest: evict-snoop
[135.658648] Subtest evict-snoop: SKIP (0.000s)
[135.775852] [045/133] (887s left) kms_cursor_legacy (torture-bo)
[135.901933] Starting subtest: torture-bo
[135.904286] Starting dynamic subtest: pipe-A
[142.121739] Dynamic subtest pipe-A: SUCCESS (6.216s)
[142.133417] Starting dynamic subtest: pipe-B
[148.689249] Dynamic subtest pipe-B: SUCCESS (6.567s)
[148.700516] Starting dynamic subtest: pipe-C
[155.206414] Dynamic subtest pipe-C: SUCCESS (6.515s)
[155.215100] Starting dynamic subtest: pipe-D
[162.817241] Dynamic subtest pipe-D: SUCCESS (7.610s)
[162.825947] Starting dynamic subtest: all-pipes
[169.773175] Dynamic subtest all-pipes: SUCCESS (6.955s)
[169.775507] Subtest torture-bo: SUCCESS (33.869s)
[169.976992] [046/133] (853s left) i915_pm_rps (reset)
[170.064630] Starting subtest: reset
[178.527033] Subtest reset: SUCCESS (8.461s)
[178.684938] [047/133] (844s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[178.752238] Starting subtest: y-tiled-ccs-to-x-tiled
[178.756885] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[178.946626] [048/133] (844s left) gem_wait (write-busy)
[179.008809] Starting subtest: write-busy
[179.011239] Starting dynamic subtest: all-engines
[179.680488] Dynamic subtest all-engines: SUCCESS (0.672s)
[179.692987] Starting dynamic subtest: rcs0
[180.243517] Dynamic subtest rcs0: SUCCESS (0.561s)
[180.259125] Starting dynamic subtest: bcs0
[180.795207] Dynamic subtest bcs0: SUCCESS (0.551s)
[180.809671] Starting dynamic subtest: vcs0
[181.908059] Dynamic subtest vcs0: SUCCESS (1.110s)
[181.923485] Starting dynamic subtest: vcs1
[183.892455] Dynamic subtest vcs1: SUCCESS (1.983s)
[183.907875] Starting dynamic subtest: vecs0
[185.879110] Dynamic subtest vecs0: SUCCESS (1.984s)
[185.893715] Starting dynamic subtest: ccs0
[186.430204] Dynamic subtest ccs0: SUCCESS (0.551s)
[186.432950] Subtest write-busy: SUCCESS (7.422s)
[186.637812] [049/133] (836s left) gem_exec_whisper (basic-queues-priority-all)
[186.713613] Starting subtest: basic-queues-priority-all
[210.180514] Subtest basic-queues-priority-all: SUCCESS (23.462s)
[210.369604] [050/133] (812s left) syncobj_wait (wait-any-snapshot)
[210.430169] Starting subtest: wait-any-snapshot
[210.511052] Subtest wait-any-snapshot: SUCCESS (0.081s)
[210.600624] [051/133] (812s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[210.709164] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[210.713482] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[210.840407] [052/133] (812s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[210.934576] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[210.961594] Starting dynamic subtest: pipe-A-plane-0
[210.966091] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[210.975129] Starting dynamic subtest: pipe-A-plane-3
[210.979724] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[210.990634] Starting dynamic subtest: pipe-A-plane-5
[210.994955] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[212.036881] Starting dynamic subtest: pipe-B-plane-0
[212.041067] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[212.049451] Starting dynamic subtest: pipe-B-plane-3
[212.054061] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[212.062671] Starting dynamic subtest: pipe-B-plane-5
[212.067503] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[212.350146] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (1.414s)
[213.222660] [053/133] (810s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[213.321131] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[213.325156] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[213.400266] [054/133] (810s left) kms_plane (plane-position-hole-dpms)
[213.490896] Starting subtest: plane-position-hole-dpms
[214.024923] Starting dynamic subtest: pipe-A-plane-1
[216.303602] Dynamic subtest pipe-A-plane-1: SUCCESS (2.279s)
[216.313637] Starting dynamic subtest: pipe-A-plane-2
[218.671929] Dynamic subtest pipe-A-plane-2: SUCCESS (2.366s)
[218.681607] Starting dynamic subtest: pipe-A-plane-3
[221.024095] Dynamic subtest pipe-A-plane-3: SUCCESS (2.352s)
[221.032767] Starting dynamic subtest: pipe-A-plane-4
[223.404203] Dynamic subtest pipe-A-plane-4: SUCCESS (2.378s)
[223.413571] Starting dynamic subtest: pipe-A-plane-5
[223.427715] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[224.567862] Starting dynamic subtest: pipe-B-plane-1
[226.816699] Dynamic subtest pipe-B-plane-1: SUCCESS (2.255s)
[226.826599] Starting dynamic subtest: pipe-B-plane-2
[229.091800] Dynamic subtest pipe-B-plane-2: SUCCESS (2.276s)
[229.102069] Starting dynamic subtest: pipe-B-plane-3
[231.434111] Dynamic subtest pipe-B-plane-3: SUCCESS (2.341s)
[231.443146] Starting dynamic subtest: pipe-B-plane-4
[233.818445] Dynamic subtest pipe-B-plane-4: SUCCESS (2.381s)
[233.827748] Starting dynamic subtest: pipe-B-plane-5
[233.840452] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[233.842468] Subtest plane-position-hole-dpms: SUCCESS (20.351s)
[234.650583] [055/133] (788s left) gem_busy (semaphore)
[234.842066] Subtest semaphore: SKIP (0.000s)
[235.102310] [056/133] (788s left) gen9_exec_parse (shadow-peek)
[235.171664] Subtest shadow-peek: SKIP (0.000s)
[235.238836] [057/133] (788s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[235.308270] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[235.312747] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[235.502363] [058/133] (788s left) kms_frontbuffer_tracking (fbc-1p-rte)
[235.590877] Starting subtest: fbc-1p-rte
[241.041299] Subtest fbc-1p-rte: SUCCESS (5.454s)
[242.207028] [059/133] (781s left) gem_exec_parallel (fds)
[242.275823] Starting subtest: fds
[242.278223] Starting dynamic subtest: rcs0
[245.514816] Dynamic subtest rcs0: SUCCESS (3.237s)
[245.525429] Starting dynamic subtest: bcs0
[249.518873] Dynamic subtest bcs0: SUCCESS (4.001s)
[249.533393] Starting dynamic subtest: vcs0
[253.211286] Dynamic subtest vcs0: SUCCESS (3.690s)
[253.222556] Starting dynamic subtest: vcs1
[257.178818] Dynamic subtest vcs1: SUCCESS (3.965s)
[257.190208] Starting dynamic subtest: vecs0
[261.182948] Dynamic subtest vecs0: SUCCESS (4.002s)
[261.194734] Starting dynamic subtest: ccs0
[265.194567] Dynamic subtest ccs0: SUCCESS (4.010s)
[265.197025] Subtest fds: SUCCESS (22.918s)
[265.413876] [060/133] (758s left) sysfs_preempt_timeout (invalid)
[265.481692] Starting subtest: invalid
[265.484165] Starting dynamic subtest: vecs0
[265.486600] Dynamic subtest vecs0: SUCCESS (0.000s)
[265.497722] Starting dynamic subtest: ccs0
[265.499969] Dynamic subtest ccs0: SUCCESS (0.000s)
[265.508293] Starting dynamic subtest: vcs0
[265.510143] Dynamic subtest vcs0: SUCCESS (0.000s)
[265.518487] Starting dynamic subtest: bcs0
[265.520658] Dynamic subtest bcs0: SUCCESS (0.000s)
[265.529105] Starting dynamic subtest: rcs0
[265.531268] Dynamic subtest rcs0: SUCCESS (0.000s)
[265.542016] Starting dynamic subtest: vcs1
[265.544226] Dynamic subtest vcs1: SUCCESS (0.000s)
[265.546288] Subtest invalid: SUCCESS (0.005s)
[265.587107] [061/133] (758s left) gem_ctx_persistence (processes)
[265.640430] Starting subtest: processes
[266.856636] Subtest processes: SUCCESS (1.216s)
[266.947384] [062/133] (756s left) i915_query (query-regions-garbage-items)
[266.993244] Starting subtest: query-regions-garbage-items
[266.995566] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[267.099729] [063/133] (756s left) kms_pipe_stress (stress-xrgb8888-untiled)
[267.191349] Starting subtest: stress-xrgb8888-untiled
[273.157258] Subtest stress-xrgb8888-untiled: SUCCESS (5.970s)
[273.210133] [064/133] (750s left) gem_softpin (noreloc-interruptible)
[273.269439] Starting subtest: noreloc-interruptible
[278.677754] Subtest noreloc-interruptible: SUCCESS (5.406s)
[278.828319] [065/133] (745s left) gem_exec_schedule (preemptive-hang)
[279.016793] Starting subtest: preemptive-hang
[279.019130] Starting dynamic subtest: rcs0
[288.000098] Dynamic subtest rcs0: SUCCESS (8.987s)
[288.008314] Starting dynamic subtest: bcs0
[297.087731] Dynamic subtest bcs0: SUCCESS (9.085s)
[297.096067] Starting dynamic subtest: vcs0
[306.045183] Dynamic subtest vcs0: SUCCESS (8.953s)
[306.057388] Starting dynamic subtest: vcs1
[315.004988] Dynamic subtest vcs1: SUCCESS (8.959s)
[315.013571] Starting dynamic subtest: vecs0
[324.025841] Dynamic subtest vecs0: SUCCESS (9.018s)
[324.037384] Starting dynamic subtest: ccs0
[333.054937] Dynamic subtest ccs0: SUCCESS (9.029s)
[333.057805] Subtest preemptive-hang: SUCCESS (54.037s)
[333.328981] [066/133] (690s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[333.470142] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[340.778061] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (7.305s)
[341.986039] [067/133] (681s left) kms_color_pipeline (plane-ctm3x4)
[342.087723] Starting subtest: plane-ctm3x4
[342.104382] Starting dynamic subtest: pipe-A-eDP-1
[342.779036] Dynamic subtest pipe-A-eDP-1: FAIL (0.289s)
[343.442097] Starting dynamic subtest: pipe-B-eDP-1
[344.238214] Dynamic subtest pipe-B-eDP-1: FAIL (0.291s)
[344.768127] Starting dynamic subtest: pipe-C-eDP-1
[345.587565] Dynamic subtest pipe-C-eDP-1: FAIL (0.227s)
[346.098099] Starting dynamic subtest: pipe-D-eDP-1
[346.902104] Dynamic subtest pipe-D-eDP-1: FAIL (0.223s)
[346.904123] Subtest plane-ctm3x4: FAIL (4.517s)
[347.490016] [068/133] (676s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[347.589187] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[351.565888] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (3.981s)
[352.708142] [069/133] (671s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[352.822313] Starting subtest: basic-flip-before-cursor-legacy
[353.749082] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.924s)
[354.630365] [070/133] (669s left) gem_exec_whisper (basic-fds-forked)
[354.697652] Starting subtest: basic-fds-forked
[378.965522] Subtest basic-fds-forked: SUCCESS (24.263s)
[379.173846] [071/133] (644s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[379.285230] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[385.852592] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.571s)
[385.988145] [072/133] (638s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[386.085918] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[386.089956] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[386.182092] [073/133] (638s left) kms_flip (2x-flip-vs-rmfb)
[386.291064] Starting subtest: 2x-flip-vs-rmfb
[386.299664] Subtest 2x-flip-vs-rmfb: SKIP (0.010s)
[386.422835] [074/133] (637s left) kms_vblank (wait-idle)
[386.510551] Starting subtest: wait-idle
[386.512678] Starting dynamic subtest: pipe-A-eDP-1
[388.277076] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.764s)
[388.291254] Starting dynamic subtest: pipe-D-eDP-1
[390.787876] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.509s)
[390.790137] Subtest wait-idle: SUCCESS (4.277s)
[391.609748] [075/133] (632s left) kms_feature_discovery (display)
[391.705649] Starting subtest: display
[391.707735] Subtest display: SUCCESS (0.000s)
[391.816532] [076/133] (632s left) syncobj_wait (wait-for-submit-snapshot)
[391.893604] Starting subtest: wait-for-submit-snapshot
[391.975622] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[392.066050] [077/133] (632s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[392.163763] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[399.144995] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.984s)
[399.267379] [078/133] (625s left) kms_big_fb (linear-addfb)
[399.390894] Starting subtest: linear-addfb
[399.393243] Subtest linear-addfb: SUCCESS (0.000s)
[399.515871] [079/133] (624s left) kms_chamelium_hpd (common-hpd-after-suspend)
[399.902318] Subtest common-hpd-after-suspend: SKIP (0.000s)
[400.770618] [080/133] (623s left) kms_getfb (getfb-addfb-different-handles)
[400.870728] Starting subtest: getfb-addfb-different-handles
[400.872883] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[400.991968] [081/133] (623s left) gem_exec_reloc (basic-write-cpu-noreloc)
[401.053281] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[401.131427] [082/133] (623s left) syncobj_basic (create-signaled)
[401.184405] Starting subtest: create-signaled
[401.186340] Subtest create-signaled: SUCCESS (0.000s)
[401.308209] [083/133] (623s left) syncobj_timeline (multi-wait-all-available-submitted)
[401.367411] Starting subtest: multi-wait-all-available-submitted
[401.369622] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[401.494249] [084/133] (623s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[401.598580] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[402.645688] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.047s)
[402.826815] [085/133] (621s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[402.889641] Starting subtest: multi-wait-all-for-submit-signaled
[402.892021] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[403.019439] [086/133] (621s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[403.115464] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[403.118863] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[403.252240] [087/133] (621s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[403.347931] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[410.065345] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.719s)
[410.190161] [088/133] (614s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[410.756908] Starting subtest: syncobj-backward-timeline-chain-engines
[410.869406] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.113s)
[411.964824] [089/133] (612s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[412.069501] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[412.073945] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[412.184870] [090/133] (612s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[412.281678] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[412.286263] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[413.433577] [091/133] (611s left) syncobj_eventfd (timeline-wait-before-signal)
[413.500611] Starting subtest: timeline-wait-before-signal
[413.530903] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[413.616762] [092/133] (611s left) gem_caching (reads)
[413.683592] Subtest reads: SKIP (0.000s)
[413.748291] [093/133] (611s left) gem_mmap_wc (invalid-flags)
[413.795101] Subtest invalid-flags: SKIP (0.000s)
[413.855966] [094/133] (611s left) gem_exec_balancer (nop)
[413.920074] Starting subtest: nop
[460.618557] Subtest nop: SUCCESS (46.697s)
[460.953821] [095/133] (564s left) kms_lease (lease-invalid-plane)
[461.044992] Starting subtest: lease-invalid-plane
[461.047294] Starting dynamic subtest: pipe-A-eDP-1
[461.049481] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[461.063064] Starting dynamic subtest: pipe-B-eDP-1
[461.065691] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[461.079187] Starting dynamic subtest: pipe-C-eDP-1
[461.081055] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[461.089029] Starting dynamic subtest: pipe-D-eDP-1
[461.090898] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[461.092966] Subtest lease-invalid-plane: SUCCESS (0.004s)
[461.130989] [096/133] (564s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k)
[461.505170] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s)
[462.310557] [097/133] (562s left) kms_psr2_su (page_flip-nv12)
[462.376818] Subtest page_flip-NV12: SKIP (0.000s)
[462.443944] [098/133] (562s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[462.539541] Starting subtest: fbc-1p-pri-indfb-multidraw
[475.496662] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (12.960s)
[476.876645] [099/133] (548s left) kms_flip (flip-vs-panning)
[476.979381] Starting subtest: flip-vs-panning
[476.981774] Starting dynamic subtest: A-eDP1
[485.672998] Dynamic subtest A-eDP1: SUCCESS (8.692s)
[485.684063] Starting dynamic subtest: B-eDP1
[494.394685] Dynamic subtest B-eDP1: SUCCESS (8.721s)
[494.404636] Starting dynamic subtest: C-eDP1
[503.104465] Dynamic subtest C-eDP1: SUCCESS (8.709s)
[503.113869] Starting dynamic subtest: D-eDP1
[511.825463] Dynamic subtest D-eDP1: SUCCESS (8.720s)
[511.829861] Subtest flip-vs-panning: SUCCESS (34.850s)
[513.099862] [100/133] (512s left) kms_psr (fbc-psr2-cursor-blt)
[513.214187] Starting subtest: fbc-psr2-cursor-blt
[513.216508] Starting dynamic subtest: eDP-1
[513.220948] Dynamic subtest eDP-1: SKIP (0.000s)
[513.225379] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[513.300223] [101/133] (512s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[513.410498] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[513.414695] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[513.518243] [102/133] (511s left) gem_exec_schedule (promotion)
[513.586656] Starting subtest: promotion
[513.588613] Starting dynamic subtest: rcs0
[513.684116] Dynamic subtest rcs0: SUCCESS (0.105s)
[513.697797] Starting dynamic subtest: vcs0
[513.774411] Dynamic subtest vcs0: SUCCESS (0.089s)
[513.784878] Starting dynamic subtest: vcs1
[513.857552] Dynamic subtest vcs1: SUCCESS (0.082s)
[513.867861] Starting dynamic subtest: vecs0
[513.946833] Dynamic subtest vecs0: SUCCESS (0.088s)
[513.957941] Starting dynamic subtest: ccs0
[514.040804] Dynamic subtest ccs0: SUCCESS (0.093s)
[514.043273] Subtest promotion: SUCCESS (0.462s)
[515.003600] [103/133] (510s left) api_intel_allocator (reserve-simple)
[515.060620] Starting subtest: reserve-simple
[515.063068] Subtest reserve-simple: SUCCESS (0.003s)
[515.201183] [104/133] (510s left) gem_spin_batch (resubmit)
[515.252424] Starting subtest: resubmit
[515.254729] Starting dynamic subtest: rcs0
[515.259558] Dynamic subtest rcs0: SUCCESS (0.006s)
[515.268864] Starting dynamic subtest: bcs0
[515.271132] Dynamic subtest bcs0: SUCCESS (0.002s)
[515.279598] Starting dynamic subtest: vcs0
[515.281458] Dynamic subtest vcs0: SUCCESS (0.002s)
[515.289212] Starting dynamic subtest: vcs1
[515.291208] Dynamic subtest vcs1: SUCCESS (0.002s)
[515.302258] Starting dynamic subtest: vecs0
[515.304122] Dynamic subtest vecs0: SUCCESS (0.002s)
[515.312743] Starting dynamic subtest: ccs0
[515.314620] Dynamic subtest ccs0: SUCCESS (0.003s)
[515.316506] Subtest resubmit: SUCCESS (0.021s)
[515.525607] [105/133] (510s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[515.633850] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[515.638346] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[515.768701] [106/133] (509s left) gem_create (busy-create)
[515.822733] Starting subtest: busy-create
[515.824872] Starting dynamic subtest: smem0
[548.898554] Dynamic subtest smem0: SUCCESS (33.074s)
[548.901557] Subtest busy-create: SUCCESS (33.076s)
[549.101695] [107/133] (476s left) i915_hangman (engine-error-state-capture)
[549.179113] Starting subtest: engine-error-state-capture
[549.181310] Starting dynamic subtest: rcs0
[552.883384] Dynamic subtest rcs0: SUCCESS (3.704s)
[552.896705] Starting dynamic subtest: bcs0
[558.899272] Dynamic subtest bcs0: SUCCESS (6.013s)
[558.910758] Starting dynamic subtest: vcs0
[566.834062] Dynamic subtest vcs0: SUCCESS (7.932s)
[566.846203] Starting dynamic subtest: vcs1
[571.827270] Dynamic subtest vcs1: SUCCESS (4.989s)
[571.839188] Starting dynamic subtest: vecs0
[576.819552] Dynamic subtest vecs0: SUCCESS (4.988s)
[576.831871] Starting dynamic subtest: ccs0
[582.835857] Dynamic subtest ccs0: SUCCESS (6.013s)
[582.838832] Subtest engine-error-state-capture: SUCCESS (33.656s)
[582.935843] [108/133] (442s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[583.032850] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[583.034769] Starting dynamic subtest: pipe-A-eDP-1
[599.775252] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.513s)
[599.791256] Starting dynamic subtest: pipe-B-eDP-1
[616.770863] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.369s)
[616.782567] Starting dynamic subtest: pipe-C-eDP-1
[633.712534] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.308s)
[633.722665] Starting dynamic subtest: pipe-D-eDP-1
[650.743743] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.373s)
[650.746534] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.569s)
[651.994397] [109/133] (373s left) gem_eio (create-ext)
[652.202521] Starting subtest: create-ext
[652.444761] Subtest create-ext: SUCCESS (0.242s)
[652.617159] [110/133] (373s left) kms_cursor_crc (cursor-sliding-64x64)
[652.798235] Starting subtest: cursor-sliding-64x64
[652.800739] Starting dynamic subtest: pipe-A-eDP-1
[656.022483] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.219s)
[656.050324] Starting dynamic subtest: pipe-D-eDP-1
[659.915571] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.866s)
[659.918435] Subtest cursor-sliding-64x64: SUCCESS (7.108s)
[660.769795] [111/133] (365s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[660.873585] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[660.878780] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[660.998387] [112/133] (364s left) kms_pm_rpm (pm-tiling)
[663.224044] Starting subtest: pm-tiling
[663.229710] Subtest pm-tiling: SKIP (0.000s)
[663.621008] [113/133] (362s left) core_getclient (basic)
[663.689738] Starting subtest: basic
[663.692670] Subtest basic: SUCCESS (0.000s)
[663.813062] [114/133] (362s left) gem_exec_flush (basic-uc-rw-default)
[663.887178] Starting subtest: basic-uc-rw-default
[669.345156] Subtest basic-uc-rw-default: SUCCESS (5.450s)
[669.539765] [115/133] (356s left) kms_big_fb (y-tiled-addfb)
[669.654585] Starting subtest: y-tiled-addfb
[669.659631] Subtest y-tiled-addfb: SKIP (0.000s)
[669.776500] [116/133] (356s left) gem_softpin (noreloc-s3)
[669.838119] Starting subtest: noreloc-S3
[689.752458] Subtest noreloc-S3: SUCCESS (5.417s)
[689.938099] [117/133] (336s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[690.045232] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[690.049435] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[690.133344] [118/133] (336s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[690.224986] Starting subtest: flip-primary-invalidate-overlay
[701.826612] Subtest flip-primary-invalidate-overlay: SUCCESS (11.593s)
[701.967401] [119/133] (324s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[702.071242] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[702.073077] Starting dynamic subtest: pipe-A-eDP-1
[702.090233] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[702.100917] Starting dynamic subtest: pipe-B-eDP-1
[702.116650] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[702.126043] Starting dynamic subtest: pipe-C-eDP-1
[702.141924] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[702.150888] Starting dynamic subtest: pipe-D-eDP-1
[702.166660] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[702.168237] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[704.250532] [120/133] (321s left) perf_pmu (idle-no-semaphores)
[704.292626] Starting subtest: idle-no-semaphores
[704.295062] Starting dynamic subtest: rcs0
[704.859855] Dynamic subtest rcs0: SUCCESS (0.566s)
[704.873222] Starting dynamic subtest: bcs0
[705.389742] Dynamic subtest bcs0: SUCCESS (0.527s)
[705.403397] Starting dynamic subtest: vcs0
[705.917216] Dynamic subtest vcs0: SUCCESS (0.524s)
[705.930214] Starting dynamic subtest: vcs1
[706.444532] Dynamic subtest vcs1: SUCCESS (0.524s)
[706.457340] Starting dynamic subtest: vecs0
[706.966947] Dynamic subtest vecs0: SUCCESS (0.519s)
[706.979403] Starting dynamic subtest: ccs0
[707.487040] Dynamic subtest ccs0: SUCCESS (0.517s)
[707.489969] Subtest idle-no-semaphores: SUCCESS (3.193s)
[707.610706] [121/133] (318s left) gem_busy (close-race)
[707.672478] Starting subtest: close-race
[733.545331] Subtest close-race: SUCCESS (25.857s)
[733.894277] [122/133] (292s left) gem_ctx_isolation (preservation-reset)
[734.121261] Starting subtest: preservation-reset
[734.124046] Starting dynamic subtest: rcs0
[734.404121] Dynamic subtest rcs0: SUCCESS (0.282s)
[734.414391] Starting dynamic subtest: bcs0
[734.762819] Dynamic subtest bcs0: SUCCESS (0.357s)
[734.772980] Starting dynamic subtest: vcs0
[735.110157] Dynamic subtest vcs0: SUCCESS (0.346s)
[735.121986] Starting dynamic subtest: vcs1
[736.787265] Dynamic subtest vcs1: SUCCESS (1.675s)
[736.798053] Starting dynamic subtest: vecs0
[738.829712] Dynamic subtest vecs0: SUCCESS (2.041s)
[738.845964] Starting dynamic subtest: ccs0
[740.838935] Dynamic subtest ccs0: SUCCESS (2.007s)
[740.841408] Subtest preservation-reset: SUCCESS (6.718s)
[741.011651] [123/133] (285s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[741.117931] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[741.122395] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[741.238659] [124/133] (285s left) kms_sequence (queue-idle)
[741.329094] Starting subtest: queue-idle
[741.331459] Starting dynamic subtest: pipe-A-eDP-1
[743.137785] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.809s)
[743.149328] Starting dynamic subtest: pipe-B-eDP-1
[745.608014] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.468s)
[745.618592] Starting dynamic subtest: pipe-C-eDP-1
[748.034851] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.424s)
[748.049139] Starting dynamic subtest: pipe-D-eDP-1
[750.460588] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.420s)
[750.462933] Subtest queue-idle: SUCCESS (9.129s)
[751.290589] [125/133] (275s left) kms_pm_dc (dc6-psr)
[752.397673] Starting subtest: dc6-psr
[755.273908] Subtest dc6-psr: SUCCESS (2.874s)
[756.135799] [126/133] (270s left) gem_readwrite (write-bad-handle)
[756.200880] Subtest write-bad-handle: SKIP (0.000s)
[756.267986] [127/133] (270s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[756.371283] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[756.375219] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[756.508376] [128/133] (270s left) kms_setmode (invalid-clone-single-crtc)
[756.574089] Starting subtest: invalid-clone-single-crtc
[756.580437] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[756.710795] [129/133] (269s left) gem_exec_fence (syncobj-wait)
[757.186997] Starting subtest: syncobj-wait
[758.536374] Subtest syncobj-wait: SUCCESS (1.347s)
[760.608462] [130/133] (266s left) kms_content_protection (content-type-change)
[760.772345] Starting subtest: content-type-change
[760.776801] Subtest content-type-change: SKIP (0.000s)
[760.944014] [131/133] (265s left) perf (polling-parameterized)
[761.100992] Starting subtest: polling-parameterized
[781.121746] Subtest polling-parameterized: SUCCESS (20.011s)
[781.172557] [132/133] (245s left) kms_fence_pin_leak
[781.339050] [133/133] (245s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[781.392131] Starting subtest: rel-constants-invalid-rel-gen5
[781.394592] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[781.506908] Closing watchdogs
results: parsing output: 0/ for test: perf_pmu
results: parsing output: 1/ for test: gem_render_copy
results: parsing output: 2/ for test: gem_userptr_blits
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: gen9_exec_parse
results: parsing output: 6/ for test: gem_mmap_gtt
results: parsing output: 7/ for test: kms_rotation_crc
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: kms_properties
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: gem_exec_fence
results: parsing output: 12/ for test: kms_async_flips
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: prime_vgem
results: parsing output: 16/ for test: drm_mm
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: kms_vrr
results: parsing output: 19/ for test: kms_async_flips
results: parsing output: 20/ for test: kms_plane_multiple
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: kms_psr2_sf
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_plane_scaling
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_cursor_crc
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: core_auth
results: parsing output: 30/ for test: gem_reg_read
results: parsing output: 31/ for test: kms_invalid_mode
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: gem_mmap_gtt
results: parsing output: 35/ for test: gem_tiling_max_stride
results: parsing output: 36/ for test: kms_cursor_crc
results: parsing output: 37/ for test: kms_flip
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: sw_sync
results: parsing output: 41/ for test: gem_mmap
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_softpin
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: i915_pm_rps
results: parsing output: 46/ for test: gem_render_copy
results: parsing output: 47/ for test: gem_wait
results: parsing output: 48/ for test: gem_exec_whisper
results: parsing output: 49/ for test: syncobj_wait
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_plane
results: parsing output: 52/ for test: kms_psr2_sf
results: parsing output: 53/ for test: kms_plane
results: parsing output: 54/ for test: gem_busy
results: parsing output: 55/ for test: gen9_exec_parse
results: parsing output: 56/ for test: gem_render_copy
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_exec_parallel
results: parsing output: 59/ for test: sysfs_preempt_timeout
results: parsing output: 60/ for test: gem_ctx_persistence
results: parsing output: 61/ for test: i915_query
results: parsing output: 62/ for test: kms_pipe_stress
results: parsing output: 63/ for test: gem_softpin
results: parsing output: 64/ for test: gem_exec_schedule
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_color_pipeline
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_cursor_legacy
results: parsing output: 69/ for test: gem_exec_whisper
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_flip_scaled_crc
results: parsing output: 72/ for test: kms_flip
results: parsing output: 73/ for test: kms_vblank
results: parsing output: 74/ for test: kms_feature_discovery
results: parsing output: 75/ for test: syncobj_wait
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_chamelium_hpd
results: parsing output: 79/ for test: kms_getfb
results: parsing output: 80/ for test: gem_exec_reloc
results: parsing output: 81/ for test: syncobj_basic
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_exec_fence
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: syncobj_eventfd
results: parsing output: 91/ for test: gem_caching
results: parsing output: 92/ for test: gem_mmap_wc
results: parsing output: 93/ for test: gem_exec_balancer
results: parsing output: 94/ for test: kms_lease
results: parsing output: 95/ for test: kms_chamelium_edid
results: parsing output: 96/ for test: kms_psr2_su
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_flip
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_exec_schedule
results: parsing output: 102/ for test: api_intel_allocator
results: parsing output: 103/ for test: gem_spin_batch
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: gem_create
results: parsing output: 106/ for test: i915_hangman
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: gem_eio
results: parsing output: 109/ for test: kms_cursor_crc
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_pm_rpm
results: parsing output: 112/ for test: core_getclient
results: parsing output: 113/ for test: gem_exec_flush
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: gem_softpin
results: parsing output: 116/ for test: kms_flip_scaled_crc
results: parsing output: 117/ for test: kms_psr_stress_test
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: perf_pmu
results: parsing output: 120/ for test: gem_busy
results: parsing output: 121/ for test: gem_ctx_isolation
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: kms_sequence
results: parsing output: 124/ for test: kms_pm_dc
results: parsing output: 125/ for test: gem_readwrite
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_setmode
results: parsing output: 128/ for test: gem_exec_fence
results: parsing output: 129/ for test: kms_content_protection
results: parsing output: 130/ for test: perf
results: parsing output: 131/ for test: kms_fence_pin_leak
results: parsing output: 132/ for test: gem_exec_params
Done.