[58.585803] Initializing watchdogs
[58.585847]   /dev/watchdog0
[58.598987] [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.603070] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.605229] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.608572] [001/131] (960s left) kms_lease (cursor-implicit-plane)
[58.728960] Starting subtest: cursor-implicit-plane
[58.731407] Starting dynamic subtest: pipe-A-eDP-1
[59.226346] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.499s)
[59.233870] Starting dynamic subtest: pipe-B-eDP-1
[60.332670] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.108s)
[60.341266] Starting dynamic subtest: pipe-C-eDP-1
[61.444072] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.114s)
[61.453169] Starting dynamic subtest: pipe-D-eDP-1
[62.568040] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.125s)
[62.570292] Subtest cursor-implicit-plane: SUCCESS (3.849s)
[63.453701] [002/131] (955s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[63.552835] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[63.555283] Starting dynamic subtest: pipe-A-eDP-1
[63.564405] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[63.573079] Starting dynamic subtest: pipe-B-eDP-1
[63.582095] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[63.589070] Starting dynamic subtest: pipe-C-eDP-1
[63.598349] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[63.607527] Starting dynamic subtest: pipe-D-eDP-1
[63.616307] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[63.620697] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[65.804985] [003/131] (953s left) kms_rotation_crc (sprite-rotation-90)
[65.913955] Starting subtest: sprite-rotation-90
[65.917864] Subtest sprite-rotation-90: SKIP (0.001s)
[66.005117] [004/131] (953s left) gem_exec_schedule (preempt-other)
[66.085390] Starting subtest: preempt-other
[66.087461] Starting dynamic subtest: rcs0
[66.152107] Dynamic subtest rcs0: SUCCESS (0.069s)
[66.163397] Starting dynamic subtest: bcs0
[66.214155] Dynamic subtest bcs0: SUCCESS (0.062s)
[66.223830] Starting dynamic subtest: vcs0
[66.276915] Dynamic subtest vcs0: SUCCESS (0.063s)
[66.286806] Starting dynamic subtest: vcs1
[66.343577] Dynamic subtest vcs1: SUCCESS (0.065s)
[66.354468] Starting dynamic subtest: vecs0
[66.406140] Dynamic subtest vecs0: SUCCESS (0.063s)
[66.417955] Starting dynamic subtest: ccs0
[66.467920] Dynamic subtest ccs0: SUCCESS (0.063s)
[66.470163] Subtest preempt-other: SUCCESS (0.386s)
[68.151710] [005/131] (951s left) gem_mmap_gtt (big-bo-tiledy)
[68.210898] Subtest big-bo-tiledY: SKIP (0.000s)
[68.276265] [006/131] (951s left) kms_cursor_crc (cursor-random-512x170)
[68.589591] Starting subtest: cursor-random-512x170
[68.594501] Subtest cursor-random-512x170: SKIP (0.001s)
[68.764312] [007/131] (950s left) gem_ctx_param (get-priority-new-ctx)
[68.827411] Starting subtest: get-priority-new-ctx
[68.829689] Subtest get-priority-new-ctx: SUCCESS (0.002s)
[68.965908] [008/131] (950s left) syncobj_timeline (invalid-wait-illegal-handle)
[69.018846] Starting subtest: invalid-wait-illegal-handle
[69.021151] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[69.132544] [009/131] (950s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[69.247131] Starting subtest: 4-tiled-32bpp-rotate-90
[69.266902] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[69.448788] [010/131] (950s left) kms_pm_rpm (fences-dpms)
[71.078997] Starting subtest: fences-dpms
[71.084307] Subtest fences-dpms: SKIP (0.000s)
[71.743507] [011/131] (947s left) kms_psr (fbc-pr-basic)
[71.843392] Starting subtest: fbc-pr-basic
[71.847465] Subtest fbc-pr-basic: SKIP (0.000s)
[71.934837] [012/131] (947s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[71.988710] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[71.993277] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[72.190367] [013/131] (947s left) syncobj_wait (single-wait-for-submit-submitted)
[72.244106] Starting subtest: single-wait-for-submit-submitted
[72.345204] Subtest single-wait-for-submit-submitted: SUCCESS (0.102s)
[72.439873] [014/131] (947s left) prime_self_import (basic-with_one_bo)
[72.477741] Starting subtest: basic-with_one_bo
[72.494858] Subtest basic-with_one_bo: SUCCESS (0.018s)
[72.640675] [015/131] (946s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[72.734181] Starting subtest: psr-rgb565-draw-render
[79.759741] Subtest psr-rgb565-draw-render: SUCCESS (7.031s)
[79.905345] [016/131] (939s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[80.004808] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[80.009341] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[80.136165] [017/131] (939s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[80.226160] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[80.230363] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[80.368178] [018/131] (939s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[80.469459] Starting subtest: random-ccs-data-y-tiled-ccs
[80.471783] Starting dynamic subtest: pipe-A-eDP-1
[80.497464] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[80.506791] Starting dynamic subtest: pipe-B-eDP-1
[80.530273] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[80.537208] Starting dynamic subtest: pipe-C-eDP-1
[80.560834] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[80.567945] Starting dynamic subtest: pipe-D-eDP-1
[80.592063] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[80.596423] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.003s)
[82.751473] [019/131] (937s left) kms_vblank (ts-continuation-dpms-suspend)
[82.853030] Starting subtest: ts-continuation-dpms-suspend
[82.855289] Starting dynamic subtest: pipe-A-eDP-1
[100.396336] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.545s)
[100.410279] Starting dynamic subtest: pipe-D-eDP-1
[118.401016] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.516s)
[118.403473] Subtest ts-continuation-dpms-suspend: SUCCESS (8.064s)
[119.210193] [020/131] (900s left) kms_sequence (get-busy)
[119.299659] Starting subtest: get-busy
[119.302262] Starting dynamic subtest: pipe-A-eDP-1
[121.196831] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.924s)
[121.206497] Starting dynamic subtest: pipe-B-eDP-1
[123.748690] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.575s)
[123.762390] Starting dynamic subtest: pipe-C-eDP-1
[126.326024] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.596s)
[126.336791] Starting dynamic subtest: pipe-D-eDP-1
[128.867054] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.551s)
[128.869659] Subtest get-busy: SUCCESS (9.650s)
[129.684860] [021/131] (890s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[129.816375] Starting subtest: short-flip-before-cursor-toggle
[130.728877] Subtest short-flip-before-cursor-toggle: SUCCESS (0.917s)
[131.607337] [022/131] (888s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[131.664945] Starting subtest: etime-multi-wait-for-submit-submitted
[131.771945] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.108s)
[131.868291] [023/131] (888s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[132.263394] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[133.078711] [024/131] (886s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[133.185055] Starting subtest: yf-tiled-16bpp-rotate-0
[133.190737] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[133.307976] [025/131] (886s left) gem_cs_tlb (engines)
[133.375051] Starting subtest: engines
[133.377811] Starting dynamic subtest: rcs0
[135.556021] Dynamic subtest rcs0: SUCCESS (2.153s)
[135.568948] Starting dynamic subtest: bcs0
[137.675033] Dynamic subtest bcs0: SUCCESS (2.152s)
[137.685670] Starting dynamic subtest: vcs0
[139.824812] Dynamic subtest vcs0: SUCCESS (2.153s)
[139.835911] Starting dynamic subtest: vcs1
[141.975506] Dynamic subtest vcs1: SUCCESS (2.153s)
[141.986676] Starting dynamic subtest: vecs0
[144.129187] Dynamic subtest vecs0: SUCCESS (2.156s)
[144.140627] Starting dynamic subtest: ccs0
[146.279613] Dynamic subtest ccs0: SUCCESS (2.152s)
[146.282209] Subtest engines: SUCCESS (12.920s)
[146.433365] [026/131] (873s left) syncobj_timeline (device-signal-unordered)
[146.493688] Starting subtest: device-signal-unordered
[146.496480] Subtest device-signal-unordered: SUCCESS (0.001s)
[146.634722] [027/131] (873s left) kms_prime (d3hot)
[146.723046] Subtest D3hot: SKIP (0.000s)
[146.882662] [FACT kms_prime (d3hot)] new: kernel.kmod_is_loaded.vgem: true
[146.886412] [028/131] (873s left) gem_ctx_persistence (saturated-hostile)
[146.950783] Starting subtest: saturated-hostile
[146.953807] Starting dynamic subtest: rcs0
[147.786853] Dynamic subtest rcs0: SUCCESS (0.837s)
[147.797031] Starting dynamic subtest: bcs0
[148.590517] Dynamic subtest bcs0: SUCCESS (0.803s)
[148.602298] Starting dynamic subtest: vcs0
[149.406718] Dynamic subtest vcs0: SUCCESS (0.816s)
[149.418036] Starting dynamic subtest: vcs1
[150.230877] Dynamic subtest vcs1: SUCCESS (0.822s)
[150.242703] Starting dynamic subtest: vecs0
[151.061344] Dynamic subtest vecs0: SUCCESS (0.828s)
[151.073165] Starting dynamic subtest: ccs0
[151.898957] Dynamic subtest ccs0: SUCCESS (0.836s)
[151.901710] Subtest saturated-hostile: SUCCESS (4.949s)
[151.998489] [029/131] (868s left) gem_mmap_gtt (basic-read-write-distinct)
[152.051914] Subtest basic-read-write-distinct: SKIP (0.000s)
[152.103863] [030/131] (868s left) gem_ctx_shared (create-shared-gtt)
[152.163719] Starting subtest: create-shared-gtt
[154.319822] Subtest create-shared-gtt: SUCCESS (2.153s)
[154.640470] [031/131] (865s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[154.754682] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[154.757175] Starting dynamic subtest: pipe-A-eDP-1
[154.782053] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[154.791259] Starting dynamic subtest: pipe-B-eDP-1
[154.816270] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[154.824047] Starting dynamic subtest: pipe-C-eDP-1
[154.849445] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[154.857440] Starting dynamic subtest: pipe-D-eDP-1
[154.883033] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[154.887792] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[156.969792] [032/131] (863s left) perf_pmu (idle-no-semaphores)
[157.015865] Starting subtest: idle-no-semaphores
[157.018838] Starting dynamic subtest: rcs0
[157.566816] Dynamic subtest rcs0: SUCCESS (0.549s)
[157.577053] Starting dynamic subtest: bcs0
[158.088607] Dynamic subtest bcs0: SUCCESS (0.520s)
[158.099926] Starting dynamic subtest: vcs0
[158.618829] Dynamic subtest vcs0: SUCCESS (0.528s)
[158.629776] Starting dynamic subtest: vcs1
[159.139537] Dynamic subtest vcs1: SUCCESS (0.519s)
[159.151966] Starting dynamic subtest: vecs0
[159.664032] Dynamic subtest vecs0: SUCCESS (0.523s)
[159.676099] Starting dynamic subtest: ccs0
[160.182398] Dynamic subtest ccs0: SUCCESS (0.517s)
[160.185359] Subtest idle-no-semaphores: SUCCESS (3.166s)
[160.327670] [033/131] (860s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[160.435930] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[160.441903] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[160.546505] [034/131] (859s left) kms_feature_discovery (psr1)
[160.647854] Starting subtest: psr1
[160.650903] Subtest psr1: SUCCESS (0.000s)
[160.743858] [035/131] (859s left) gem_readwrite (new-obj)
[160.810955] Subtest new-obj: SKIP (0.000s)
[160.878462] [036/131] (859s left) gem_watchdog (default-physical)
[160.958888] Starting subtest: default-physical
[162.713942] Subtest default-physical: SUCCESS (1.769s)
[162.829180] [037/131] (857s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[162.936341] Starting subtest: x-tiled-16bpp-rotate-0
[164.170702] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.235s)
[164.318277] [038/131] (856s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[164.420835] Starting subtest: fbc-psr2-sprite-mmap-cpu
[164.423184] Starting dynamic subtest: eDP-1
[164.427384] Dynamic subtest eDP-1: SKIP (0.000s)
[164.431601] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[164.518086] [039/131] (856s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[164.612275] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[164.616513] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[164.750297] [040/131] (855s left) gem_exec_whisper (basic-contexts-forked-all)
[164.810501] Starting subtest: basic-contexts-forked-all
[187.313838] Subtest basic-contexts-forked-all: SUCCESS (22.502s)
[187.523094] [041/131] (833s left) gem_mmap_gtt (big-bo-tiledx)
[187.582665] Subtest big-bo-tiledX: SKIP (0.000s)
[187.647221] [042/131] (833s left) gem_exec_reloc (basic-wc-noreloc)
[187.697378] Subtest basic-wc-noreloc: SKIP (0.000s)
[187.756179] [043/131] (832s left) kms_vblank (wait-idle-hang)
[187.851334] Starting subtest: wait-idle-hang
[187.854026] Starting dynamic subtest: pipe-A-eDP-1
[214.225725] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.379s)
[214.240552] Starting dynamic subtest: pipe-D-eDP-1
[229.217063] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.983s)
[229.219898] Subtest wait-idle-hang: SUCCESS (41.367s)
[230.031229] [044/131] (790s left) kms_psr (pr-suspend)
[230.132596] Starting subtest: pr-suspend
[230.137722] Subtest pr-suspend: SKIP (0.000s)
[230.230335] [045/131] (790s left) kms_big_fb (linear-32bpp-rotate-0)
[230.327926] Starting subtest: linear-32bpp-rotate-0
[231.874306] Subtest linear-32bpp-rotate-0: SUCCESS (1.545s)
[232.040567] [046/131] (788s left) gem_exec_balancer (bonded-pair)
[232.101423] Starting subtest: bonded-pair
[232.106281] Subtest bonded-pair: SKIP (0.000s)
[232.456372] [047/131] (788s left) gem_exec_big (single)
[232.531068] Starting subtest: single
[234.944159] Subtest single: SUCCESS (2.414s)
[235.195898] [048/131] (785s left) gem_exec_reloc (basic-wc-read-active)
[235.303634] Subtest basic-wc-read-active: SKIP (0.000s)
[235.371877] [049/131] (785s left) i915_suspend (basic-s3-without-i915)
[235.408635] Starting subtest: basic-s3-without-i915
[237.438368] Subtest basic-s3-without-i915: SKIP (2.027s)
[240.380559] [050/131] (780s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[240.501998] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[244.611075] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.112s)
[245.826277] [051/131] (775s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[245.927830] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[245.932809] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[246.066629] [052/131] (775s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[246.200239] Starting subtest: cursor-vs-flip-atomic-transitions
[276.035736] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (29.838s)
[276.860510] [053/131] (744s left) gem_request_retire (retire-vma-not-inactive)
[276.943759] Starting subtest: retire-vma-not-inactive
[277.004896] Subtest retire-vma-not-inactive: SUCCESS (0.058s)
[277.178250] [054/131] (744s left) kms_addfb_basic (addfb25-4-tiled)
[277.283830] Starting subtest: addfb25-4-tiled
[277.286195] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[277.416986] [055/131] (743s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[277.535382] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[278.491315] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.958s)
[279.392398] [056/131] (741s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[279.495142] Starting subtest: 2x-flip-vs-modeset-vs-hang
[279.503043] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.010s)
[279.604411] [057/131] (741s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[279.709942] Starting subtest: plane-lut1d-ctm3x4-lut1d
[279.724796] Starting dynamic subtest: pipe-A-eDP-1
[280.473581] Dynamic subtest pipe-A-eDP-1: FAIL (0.310s)
[281.139375] Starting dynamic subtest: pipe-B-eDP-1
[282.090638] Dynamic subtest pipe-B-eDP-1: FAIL (0.302s)
[282.470925] Starting dynamic subtest: pipe-C-eDP-1
[283.428601] Dynamic subtest pipe-C-eDP-1: FAIL (0.257s)
[283.798203] Starting dynamic subtest: pipe-D-eDP-1
[284.761023] Dynamic subtest pipe-D-eDP-1: FAIL (0.268s)
[284.763853] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (4.629s)
[285.188616] [058/131] (736s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[285.563715] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[286.375228] [059/131] (735s left) syncobj_wait (single-wait-signaled)
[286.437295] Starting subtest: single-wait-signaled
[286.439779] Subtest single-wait-signaled: SUCCESS (0.000s)
[286.576322] [060/131] (734s left) gem_exec_reloc (basic-wc-read)
[286.637954] Subtest basic-wc-read: SKIP (0.000s)
[286.693254] [061/131] (734s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[286.799997] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[286.802755] Starting dynamic subtest: pipe-A
[286.865739] Dynamic subtest pipe-A: SUCCESS (0.067s)
[286.874844] Starting dynamic subtest: pipe-B
[288.017029] Dynamic subtest pipe-B: SUCCESS (1.149s)
[288.028043] Starting dynamic subtest: pipe-C
[289.133044] Dynamic subtest pipe-C: SUCCESS (1.115s)
[289.142391] Starting dynamic subtest: pipe-D
[290.252876] Dynamic subtest pipe-D: SUCCESS (1.119s)
[290.255915] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.455s)
[291.440509] [062/131] (730s left) gem_exec_nop (basic-sequential)
[291.511927] Starting subtest: basic-sequential
[307.545243] Subtest basic-sequential: SUCCESS (16.047s)
[307.795296] [063/131] (713s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[307.896919] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[307.902027] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[308.023957] [064/131] (713s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[308.118009] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[308.120763] Starting dynamic subtest: pipe-A-eDP-1
[308.147369] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[308.161674] Starting dynamic subtest: pipe-B-eDP-1
[308.187147] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[308.195646] Starting dynamic subtest: pipe-C-eDP-1
[308.221207] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[308.229215] Starting dynamic subtest: pipe-D-eDP-1
[308.254830] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[308.259762] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[310.320349] [065/131] (711s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[310.444771] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[317.507492] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.070s)
[317.659302] [066/131] (704s left) gem_exec_params (invalid-bsd2-flag-on-render)
[317.724610] Starting subtest: invalid-bsd2-flag-on-render
[317.726869] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[317.858339] [067/131] (703s left) gem_ctx_persistence (engines-hang)
[317.919818] Starting subtest: engines-hang
[317.922990] Starting dynamic subtest: rcs0
[317.971439] Dynamic subtest rcs0: SUCCESS (0.052s)
[317.980603] Starting dynamic subtest: bcs0
[318.107483] Dynamic subtest bcs0: SUCCESS (0.134s)
[318.119686] Starting dynamic subtest: vcs0
[318.225380] Dynamic subtest vcs0: SUCCESS (0.116s)
[318.237838] Starting dynamic subtest: vcs1
[318.322122] Dynamic subtest vcs1: SUCCESS (0.095s)
[318.334824] Starting dynamic subtest: vecs0
[318.439024] Dynamic subtest vecs0: SUCCESS (0.115s)
[318.450918] Starting dynamic subtest: ccs0
[318.559146] Dynamic subtest ccs0: SUCCESS (0.118s)
[318.561829] Subtest engines-hang: SUCCESS (0.641s)
[318.667369] [068/131] (703s left) gem_spin_batch (legacy)
[318.737543] Starting subtest: legacy
[318.740000] Starting dynamic subtest: default
[321.978032] Dynamic subtest default: SUCCESS (3.236s)
[321.989169] Starting dynamic subtest: render
[325.214047] Dynamic subtest render: SUCCESS (3.234s)
[325.225951] Starting dynamic subtest: bsd
[328.448332] Dynamic subtest bsd: SUCCESS (3.232s)
[328.459914] Starting dynamic subtest: bsd1
[331.686663] Dynamic subtest bsd1: SUCCESS (3.236s)
[331.697859] Starting dynamic subtest: bsd2
[334.920096] Dynamic subtest bsd2: SUCCESS (3.232s)
[334.931249] Starting dynamic subtest: blt
[338.156122] Dynamic subtest blt: SUCCESS (3.235s)
[338.168829] Starting dynamic subtest: vebox
[341.394541] Dynamic subtest vebox: SUCCESS (3.235s)
[341.396853] Subtest legacy: SUCCESS (22.658s)
[343.490370] [069/131] (678s left) tools_test (tools_test)
[343.563319] Starting subtest: tools_test
[343.617993] Subtest tools_test: SUCCESS (0.075s)
[343.707571] [070/131] (678s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[348.789350] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[348.794952] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.002s)
[349.660743] [071/131] (672s left) kms_cursor_crc (cursor-random-128x128)
[349.864628] Starting subtest: cursor-random-128x128
[349.870277] Starting dynamic subtest: pipe-A-eDP-1
[353.220687] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.351s)
[353.247262] Starting dynamic subtest: pipe-D-eDP-1
[357.245060] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.999s)
[357.247805] Subtest cursor-random-128x128: SUCCESS (7.374s)
[358.140399] [072/131] (663s left) vgem_basic (dmabuf-mmap)
[358.188062] Starting subtest: dmabuf-mmap
[358.227936] Subtest dmabuf-mmap: SUCCESS (0.042s)
[358.313488] [073/131] (663s left) kms_cursor_edge_walk (128x128-top-bottom)
[358.411838] Starting subtest: 128x128-top-bottom
[358.414592] Starting dynamic subtest: pipe-A-eDP-1
[361.883010] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.471s)
[361.893190] Starting dynamic subtest: pipe-D-eDP-1
[365.001671] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.116s)
[365.003919] Subtest 128x128-top-bottom: SUCCESS (6.589s)
[365.834588] [074/131] (656s left) gem_exec_schedule (semaphore-user)
[365.918287] Starting subtest: semaphore-user
[365.966605] Subtest semaphore-user: SUCCESS (0.057s)
[367.446568] [075/131] (654s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[367.567294] Starting subtest: y-tiled-8bpp-rotate-90
[367.572051] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[367.700360] [076/131] (654s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[372.708638] Starting subtest: psr2-plane-move-sf-dmg-area
[372.711038] Starting dynamic subtest: pipe-A-eDP-1
[378.013946] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.301s)
[378.025839] Starting dynamic subtest: pipe-B-eDP-1
[383.349803] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.334s)
[383.352697] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (10.639s)
[384.232403] [077/131] (638s left) gem_pxp (hw-rejects-pxp-context)
[384.361879] Starting subtest: hw-rejects-pxp-context
[384.367265] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[384.487030] [078/131] (637s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[384.604016] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[388.941441] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.341s)
[390.133756] [079/131] (632s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[390.233898] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[390.236805] Starting dynamic subtest: pipe-A-eDP-1
[390.651019] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.419s)
[390.662680] Starting dynamic subtest: pipe-B-eDP-1
[390.683302] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[390.692705] Starting dynamic subtest: pipe-C-eDP-1
[390.715267] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[390.723964] Starting dynamic subtest: pipe-D-eDP-1
[390.746936] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[390.749760] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.433s)
[392.974388] [080/131] (629s left) gem_bad_reloc (negative-reloc)
[393.039820] Subtest negative-reloc: SKIP (0.000s)
[393.120359] [081/131] (629s left) gem_exec_fence (syncobj-export)
[393.562174] Starting subtest: syncobj-export
[393.564909] Subtest syncobj-export: SUCCESS (0.005s)
[395.552368] [082/131] (626s left) kms_getfb (getfb-reject-nv12)
[395.659766] Starting subtest: getfb-reject-nv12
[395.662351] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[395.782788] [083/131] (626s left) kms_draw_crc (draw-method-mmap-cpu)
[395.881030] Starting subtest: draw-method-mmap-cpu
[395.883316] Starting dynamic subtest: xrgb8888-untiled
[396.091698] Dynamic subtest xrgb8888-untiled: SUCCESS (0.211s)
[396.100999] Starting dynamic subtest: rgb565-untiled
[396.291682] Dynamic subtest rgb565-untiled: SUCCESS (0.199s)
[396.300928] Starting dynamic subtest: xrgb2101010-untiled
[396.491304] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.199s)
[396.500476] Starting dynamic subtest: xbgr16161616f-untiled
[396.702575] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.210s)
[396.711516] Starting dynamic subtest: xrgb8888-xtiled
[396.826246] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[396.834516] Starting dynamic subtest: rgb565-xtiled
[396.958794] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s)
[396.967948] Starting dynamic subtest: xrgb2101010-xtiled
[397.080046] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.120s)
[397.088935] Starting dynamic subtest: xbgr16161616f-xtiled
[397.213629] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[397.222892] Starting dynamic subtest: xrgb8888-4tiled
[397.358485] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[397.367030] Starting dynamic subtest: rgb565-4tiled
[397.491652] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s)
[397.500730] Starting dynamic subtest: xrgb2101010-4tiled
[397.613619] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.121s)
[397.622874] Starting dynamic subtest: xbgr16161616f-4tiled
[397.758175] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s)
[397.764798] Subtest draw-method-mmap-cpu: SUCCESS (1.879s)
[397.885436] [084/131] (624s left) vgem_basic (second-client)
[397.937960] Starting subtest: second-client
[397.960407] Subtest second-client: SUCCESS (0.022s)
[398.043362] [085/131] (624s left) kms_plane_multiple (2x-tiling-4)
[398.131809] Starting subtest: 2x-tiling-4
[398.136310] Subtest 2x-tiling-4: SKIP (0.000s)
[398.232059] [086/131] (624s left) gem_mmap_gtt (ptrace)
[398.283855] Subtest ptrace: SKIP (0.000s)
[398.345347] [087/131] (624s left) kms_psr (psr-primary-mmap-gtt)
[398.451565] Starting subtest: psr-primary-mmap-gtt
[398.453578] Starting dynamic subtest: eDP-1
[399.851827] Dynamic subtest eDP-1: SKIP (1.397s)
[399.857043] Subtest psr-primary-mmap-gtt: SKIP (1.399s)
[400.069312] [088/131] (622s left) kms_atomic (plane-immutable-zpos)
[400.167440] Starting subtest: plane-immutable-zpos
[400.169941] Starting dynamic subtest: pipe-A-eDP-1
[400.800890] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.633s)
[400.803914] Subtest plane-immutable-zpos: SUCCESS (0.634s)
[401.639473] [089/131] (621s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[401.754808] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[401.757036] Starting dynamic subtest: pipe-A
[401.776597] Dynamic subtest pipe-A: SKIP (0.017s)
[401.786535] Starting dynamic subtest: pipe-B
[401.803470] Dynamic subtest pipe-B: SKIP (0.028s)
[401.812996] Starting dynamic subtest: pipe-C
[401.833775] Dynamic subtest pipe-C: SKIP (0.028s)
[401.843011] Starting dynamic subtest: pipe-D
[401.860755] Dynamic subtest pipe-D: SKIP (0.028s)
[401.865577] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.103s)
[402.000545] [090/131] (620s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[402.065032] Starting subtest: single-wait-for-submit-available-signaled
[402.067817] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[402.179356] [091/131] (620s left) i915_drm_fdinfo (busy-check-all)
[402.220633] Starting subtest: busy-check-all
[402.223051] Starting dynamic subtest: rcs0
[402.228053] Dynamic subtest rcs0: SKIP (0.004s)
[402.237702] Starting dynamic subtest: bcs0
[402.242866] Dynamic subtest bcs0: SKIP (0.000s)
[402.253037] Starting dynamic subtest: vcs0
[402.258618] Dynamic subtest vcs0: SKIP (0.000s)
[402.267554] Starting dynamic subtest: vcs1
[402.272527] Dynamic subtest vcs1: SKIP (0.000s)
[402.281551] Starting dynamic subtest: vecs0
[402.286329] Dynamic subtest vecs0: SKIP (0.000s)
[402.295313] Starting dynamic subtest: ccs0
[402.300116] Dynamic subtest ccs0: SKIP (0.000s)
[402.304842] Subtest busy-check-all: SKIP (0.009s)
[402.343646] [092/131] (620s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[402.482801] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[402.485651] Starting dynamic subtest: pipe-A-default-mode
[402.774936] Dynamic subtest pipe-A-default-mode: SKIP (0.288s)
[402.780168] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.290s)
[403.667628] [093/131] (619s left) i915_hangman (gt-error-state-capture)
[403.732023] Starting subtest: gt-error-state-capture
[403.734317] Starting dynamic subtest: rcs0
[415.414345] Dynamic subtest rcs0: SUCCESS (11.681s)
[415.427363] Starting dynamic subtest: bcs0
[427.381907] Dynamic subtest bcs0: SUCCESS (11.965s)
[427.394311] Starting dynamic subtest: vcs0
[438.387795] Dynamic subtest vcs0: SUCCESS (11.004s)
[438.397454] Starting dynamic subtest: vcs1
[449.333821] Dynamic subtest vcs1: SUCCESS (10.943s)
[449.347026] Starting dynamic subtest: vecs0
[460.343127] Dynamic subtest vecs0: SUCCESS (11.008s)
[460.356044] Starting dynamic subtest: ccs0
[471.416026] Dynamic subtest ccs0: SUCCESS (11.069s)
[471.419427] Subtest gt-error-state-capture: SUCCESS (67.687s)
[471.520920] [094/131] (551s left) api_intel_bb (reset-flags)
[471.589949] Starting subtest: reset-flags
[471.601029] Subtest reset-flags: SUCCESS (0.014s)
[471.776702] [095/131] (551s left) gem_userptr_blits (sync-unmap-cycles)
[471.848610] Starting subtest: sync-unmap-cycles
[477.218163] Subtest sync-unmap-cycles: SUCCESS (5.371s)
[477.388555] [096/131] (545s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[477.492327] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[477.496497] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[477.630444] [097/131] (545s left) perf_pmu (most-busy-check-all)
[477.677731] Starting subtest: most-busy-check-all
[477.679591] Starting dynamic subtest: rcs0
[479.448379] Dynamic subtest rcs0: SUCCESS (1.771s)
[479.460752] Starting dynamic subtest: bcs0
[481.432640] Dynamic subtest bcs0: SUCCESS (1.981s)
[481.445213] Starting dynamic subtest: vcs0
[483.416691] Dynamic subtest vcs0: SUCCESS (1.982s)
[483.430037] Starting dynamic subtest: vcs1
[485.464741] Dynamic subtest vcs1: SUCCESS (2.045s)
[485.476985] Starting dynamic subtest: vecs0
[487.448505] Dynamic subtest vecs0: SUCCESS (1.981s)
[487.461076] Starting dynamic subtest: ccs0
[489.432383] Dynamic subtest ccs0: SUCCESS (1.982s)
[489.435069] Subtest most-busy-check-all: SUCCESS (11.758s)
[489.556804] [098/131] (533s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[489.690548] Starting subtest: short-flip-before-cursor-atomic-transitions
[490.670823] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.981s)
[491.488568] [099/131] (531s left) kms_plane_cursor (overlay)
[491.596233] Starting subtest: overlay
[491.601241] Starting dynamic subtest: pipe-A-eDP-1-size-64
[493.989908] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.394s)
[494.049733] Starting dynamic subtest: pipe-A-eDP-1-size-128
[496.412766] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.371s)
[496.473706] Starting dynamic subtest: pipe-A-eDP-1-size-256
[498.935785] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.470s)
[499.287837] Starting dynamic subtest: pipe-B-eDP-1-size-64
[502.394740] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.120s)
[502.453720] Starting dynamic subtest: pipe-B-eDP-1-size-128
[504.928885] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.482s)
[504.989389] Starting dynamic subtest: pipe-B-eDP-1-size-256
[507.485015] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.504s)
[507.831060] Starting dynamic subtest: pipe-C-eDP-1-size-64
[510.597719] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.778s)
[510.635184] Starting dynamic subtest: pipe-C-eDP-1-size-128
[512.662401] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.036s)
[512.701923] Starting dynamic subtest: pipe-C-eDP-1-size-256
[514.721149] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.023s)
[515.068151] Starting dynamic subtest: pipe-D-eDP-1-size-64
[517.749022] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.701s)
[517.786868] Starting dynamic subtest: pipe-D-eDP-1-size-128
[519.803833] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.024s)
[519.841420] Starting dynamic subtest: pipe-D-eDP-1-size-256
[521.870714] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.036s)
[522.201169] Subtest overlay: SUCCESS (30.609s)
[523.026095] [100/131] (500s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[523.116331] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[523.118631] Starting dynamic subtest: pipe-A-default-mode
[525.854537] Dynamic subtest pipe-A-default-mode: SUCCESS (2.738s)
[525.857020] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.739s)
[526.758849] [101/131] (496s left) kms_flip (flip-vs-fences-interruptible)
[526.881711] Starting subtest: flip-vs-fences-interruptible
[526.886776] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[527.019435] [102/131] (496s left) syncobj_wait (single-wait-for-submit-signaled)
[527.090401] Starting subtest: single-wait-for-submit-signaled
[527.093036] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[527.221420] [103/131] (496s left) i915_pm_rps (engine-order)
[527.298429] Starting subtest: engine-order
[532.131045] Subtest engine-order: SUCCESS (4.835s)
[532.286379] [104/131] (491s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[532.340917] Subtest writes-after-reads: SKIP (0.000s)
[532.423526] [105/131] (491s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[532.534689] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[532.539615] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[532.661413] [106/131] (490s left) gem_exec_reloc (basic-write-read)
[532.727866] Subtest basic-write-read: SKIP (0.000s)
[532.797145] [107/131] (490s left) kms_lease (lease-unleased-connector)
[532.887006] Starting subtest: lease-unleased-connector
[532.889648] Starting dynamic subtest: pipe-A-eDP-1
[532.892088] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[532.903630] Starting dynamic subtest: pipe-B-eDP-1
[532.906318] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.008s)
[532.917838] Starting dynamic subtest: pipe-C-eDP-1
[532.920876] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s)
[532.930810] Starting dynamic subtest: pipe-D-eDP-1
[532.933404] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[532.935833] Subtest lease-unleased-connector: SUCCESS (0.033s)
[533.048279] [108/131] (490s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[533.155254] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[533.159753] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[533.291092] [109/131] (490s left) api_intel_bb (add-remove-objects)
[533.362393] Starting subtest: add-remove-objects
[533.367855] Subtest add-remove-objects: SUCCESS (0.007s)
[533.484214] [110/131] (490s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[533.576875] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[533.579212] Starting dynamic subtest: pipe-A-eDP-1
[533.603870] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[533.613776] Starting dynamic subtest: pipe-B-eDP-1
[533.638281] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[533.647004] Starting dynamic subtest: pipe-C-eDP-1
[533.672396] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[533.681026] Starting dynamic subtest: pipe-D-eDP-1
[533.705772] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[533.710361] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[535.781242] [111/131] (487s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[535.835946] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[535.839037] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[535.974760] [112/131] (487s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[536.066731] Starting subtest: fbcpsr-stridechange
[542.191291] Subtest fbcpsr-stridechange: SUCCESS (6.128s)
[542.368785] [113/131] (481s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[542.467757] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[542.472836] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[542.613991] [114/131] (481s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[542.731764] Starting subtest: cursorA-vs-flipA-toggle
[553.853993] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.125s)
[554.710202] [115/131] (469s left) kms_flip (2x-flip-vs-fences)
[554.809861] Starting subtest: 2x-flip-vs-fences
[554.814792] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[554.941569] [116/131] (468s left) gem_exec_parallel (userptr)
[555.005325] Starting subtest: userptr
[555.007879] Starting dynamic subtest: rcs0
[556.793013] Dynamic subtest rcs0: SUCCESS (1.788s)
[556.805467] Starting dynamic subtest: bcs0
[558.577174] Dynamic subtest bcs0: SUCCESS (1.781s)
[558.587049] Starting dynamic subtest: vcs0
[560.425064] Dynamic subtest vcs0: SUCCESS (1.846s)
[560.435455] Starting dynamic subtest: vcs1
[562.477815] Dynamic subtest vcs1: SUCCESS (2.050s)
[562.488052] Starting dynamic subtest: vecs0
[564.398369] Dynamic subtest vecs0: SUCCESS (1.919s)
[564.411056] Starting dynamic subtest: ccs0
[566.171602] Dynamic subtest ccs0: SUCCESS (1.774s)
[566.174173] Subtest userptr: SUCCESS (11.169s)
[566.381414] [117/131] (457s left) gem_lmem_swapping (random-engines)
[566.431151] Subtest random-engines: SKIP (0.000s)
[566.477809] [118/131] (457s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[566.589652] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[566.594753] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[566.719530] [119/131] (457s left) gem_lmem_swapping (heavy-verify-multi)
[566.770617] Subtest heavy-verify-multi: SKIP (0.000s)
[566.828343] [120/131] (457s left) gem_userptr_blits (map-fixed-invalidate-busy)
[566.903450] Starting subtest: map-fixed-invalidate-busy
[566.908417] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[567.062551] [121/131] (457s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[567.155665] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[567.160826] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[567.280260] [122/131] (456s left) syncobj_timeline (wait-any-snapshot)
[567.341055] Starting subtest: wait-any-snapshot
[567.420991] Subtest wait-any-snapshot: SUCCESS (0.083s)
[567.521359] [123/131] (456s left) gen9_exec_parse (bb-chained)
[567.578184] Subtest bb-chained: SKIP (0.000s)
[567.671455] [124/131] (456s left) kms_cursor_crc (cursor-alpha-opaque)
[567.757849] Starting subtest: cursor-alpha-opaque
[567.760162] Starting dynamic subtest: pipe-A-eDP-1
[568.365694] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.609s)
[568.374857] Starting dynamic subtest: pipe-D-eDP-1
[569.671657] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.303s)
[569.674407] Subtest cursor-alpha-opaque: SUCCESS (1.914s)
[570.576269] [125/131] (453s left) dmabuf (all-tests)
[570.613922] Starting subtest: all-tests
[570.616301] Starting dynamic subtest: sanitycheck
[570.777795] Dynamic subtest sanitycheck: SUCCESS (0.164s)
[570.791900] Starting dynamic subtest: dma_fence
[571.075199] Dynamic subtest dma_fence: SUCCESS (0.295s)
[571.088985] Starting dynamic subtest: dma_fence_chain
[579.438701] Dynamic subtest dma_fence_chain: SUCCESS (8.363s)
[579.453928] Starting dynamic subtest: dma_fence_unwrap
[579.547456] Dynamic subtest dma_fence_unwrap: SUCCESS (0.107s)
[579.561699] Starting dynamic subtest: dma_resv
[579.669008] Dynamic subtest dma_resv: SUCCESS (0.118s)
[579.672019] Subtest all-tests: SUCCESS (9.058s)
[579.759470] [126/131] (444s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[579.861784] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[588.229910] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.373s)
[588.368072] [127/131] (436s left) gem_fenced_exec_thrash (no-spare-fences)
[588.436067] Subtest no-spare-fences: SKIP (0.000s)
[588.513783] [128/131] (435s left) kms_psr (pr-no-drrs)
[588.605895] Starting subtest: pr-no-drrs
[588.611004] Subtest pr-no-drrs: SKIP (0.000s)
[588.700872] [129/131] (435s left) gem_pxp (display-protected-crc)
[588.764389] Starting subtest: display-protected-crc
[590.682223] Subtest display-protected-crc: SUCCESS (1.918s)
[590.832567] [130/131] (433s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[590.922838] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[597.387883] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.470s)
[597.539565] [131/131] (427s left) i915_query (query-topology-known-pci-ids)
[597.587988] Starting subtest: query-topology-known-pci-ids
[597.592899] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[597.712495] Closing watchdogs
results: parsing output: 0/ for test: kms_lease
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: kms_rotation_crc
results: parsing output: 3/ for test: gem_exec_schedule
results: parsing output: 4/ for test: gem_mmap_gtt
results: parsing output: 5/ for test: kms_cursor_crc
results: parsing output: 6/ for test: gem_ctx_param
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: kms_pm_rpm
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: gem_render_copy
results: parsing output: 12/ for test: syncobj_wait
results: parsing output: 13/ for test: prime_self_import
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: kms_vblank
results: parsing output: 19/ for test: kms_sequence
results: parsing output: 20/ for test: kms_cursor_legacy
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: kms_chamelium_edid
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: gem_cs_tlb
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: kms_prime
results: parsing output: 27/ for test: gem_ctx_persistence
results: parsing output: 28/ for test: gem_mmap_gtt
results: parsing output: 29/ for test: gem_ctx_shared
results: parsing output: 30/ for test: kms_ccs
results: parsing output: 31/ for test: perf_pmu
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_feature_discovery
results: parsing output: 34/ for test: gem_readwrite
results: parsing output: 35/ for test: gem_watchdog
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: kms_psr
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_exec_whisper
results: parsing output: 40/ for test: gem_mmap_gtt
results: parsing output: 41/ for test: gem_exec_reloc
results: parsing output: 42/ for test: kms_vblank
results: parsing output: 43/ for test: kms_psr
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: gem_exec_balancer
results: parsing output: 46/ for test: gem_exec_big
results: parsing output: 47/ for test: gem_exec_reloc
results: parsing output: 48/ for test: i915_suspend
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_cursor_legacy
results: parsing output: 52/ for test: gem_request_retire
results: parsing output: 53/ for test: kms_addfb_basic
results: parsing output: 54/ for test: kms_cursor_legacy
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: kms_color_pipeline
results: parsing output: 57/ for test: kms_chamelium_hpd
results: parsing output: 58/ for test: syncobj_wait
results: parsing output: 59/ for test: gem_exec_reloc
results: parsing output: 60/ for test: kms_plane_scaling
results: parsing output: 61/ for test: gem_exec_nop
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_ccs
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_exec_params
results: parsing output: 66/ for test: gem_ctx_persistence
results: parsing output: 67/ for test: gem_spin_batch
results: parsing output: 68/ for test: tools_test
results: parsing output: 69/ for test: kms_psr2_sf
results: parsing output: 70/ for test: kms_cursor_crc
results: parsing output: 71/ for test: vgem_basic
results: parsing output: 72/ for test: kms_cursor_edge_walk
results: parsing output: 73/ for test: gem_exec_schedule
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: kms_psr2_sf
results: parsing output: 76/ for test: gem_pxp
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: gem_bad_reloc
results: parsing output: 80/ for test: gem_exec_fence
results: parsing output: 81/ for test: kms_getfb
results: parsing output: 82/ for test: kms_draw_crc
results: parsing output: 83/ for test: vgem_basic
results: parsing output: 84/ for test: kms_plane_multiple
results: parsing output: 85/ for test: gem_mmap_gtt
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: kms_atomic
results: parsing output: 88/ for test: kms_plane_scaling
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: i915_drm_fdinfo
results: parsing output: 91/ for test: kms_flip_scaled_crc
results: parsing output: 92/ for test: i915_hangman
results: parsing output: 93/ for test: api_intel_bb
results: parsing output: 94/ for test: gem_userptr_blits
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: perf_pmu
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: kms_plane_cursor
results: parsing output: 99/ for test: kms_flip_scaled_crc
results: parsing output: 100/ for test: kms_flip
results: parsing output: 101/ for test: syncobj_wait
results: parsing output: 102/ for test: i915_pm_rps
results: parsing output: 103/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: gem_exec_reloc
results: parsing output: 106/ for test: kms_lease
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: api_intel_bb
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_cursor_legacy
results: parsing output: 114/ for test: kms_flip
results: parsing output: 115/ for test: gem_exec_parallel
results: parsing output: 116/ for test: gem_lmem_swapping
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_lmem_swapping
results: parsing output: 119/ for test: gem_userptr_blits
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: gen9_exec_parse
results: parsing output: 123/ for test: kms_cursor_crc
results: parsing output: 124/ for test: dmabuf
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_fenced_exec_thrash
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: gem_pxp
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: i915_query
Done.