[101.613179] Initializing watchdogs
[101.613226]   /dev/watchdog0
[101.628285] [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]
[101.632720] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[101.635207] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[101.638707] [001/133] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[101.766951] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[101.771613] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[101.871573] [002/133] (960s left) gem_mmap_gtt (fault-concurrent-x)
[101.922949] Subtest fault-concurrent-X: SKIP (0.000s)
[101.972680] [003/133] (960s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[102.063972] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[102.075128] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.010s)
[102.180892] [004/133] (960s left) syncobj_wait (wait-any-snapshot)
[102.223756] Starting subtest: wait-any-snapshot
[102.305420] Subtest wait-any-snapshot: SUCCESS (0.082s)
[102.389181] [005/133] (959s left) kms_frontbuffer_tracking (psr-1p-rte)
[102.490597] Starting subtest: psr-1p-rte
[107.896318] Subtest psr-1p-rte: SUCCESS (5.412s)
[108.029835] [006/133] (954s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[108.133611] Starting subtest: disable-crc-after-crtc
[108.135996] Starting dynamic subtest: pipe-A-eDP-1
[109.838679] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.703s)
[109.848247] Starting dynamic subtest: pipe-B-eDP-1
[112.132758] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.295s)
[112.143988] Starting dynamic subtest: pipe-C-eDP-1
[114.400724] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.266s)
[114.409733] Starting dynamic subtest: pipe-D-eDP-1
[116.677273] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.276s)
[116.679963] Subtest disable-crc-after-crtc: SUCCESS (8.545s)
[117.518377] [007/133] (944s left) kms_dp_link_training (uhbr-sst)
[117.604957] Starting subtest: uhbr-sst
[117.613252] Subtest uhbr-sst: SKIP (0.000s)
[117.685112] [008/133] (944s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[117.734077] Starting subtest: invalid-single-wait-all-unsubmitted
[117.736312] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[117.831824] [009/133] (944s left) gem_ctx_isolation (preservation)
[117.896585] Starting subtest: preservation
[117.899062] Starting dynamic subtest: rcs0
[118.037617] Dynamic subtest rcs0: SUCCESS (0.140s)
[118.048784] Starting dynamic subtest: bcs0
[118.205613] Dynamic subtest bcs0: SUCCESS (0.168s)
[118.213694] Starting dynamic subtest: vcs0
[118.365960] Dynamic subtest vcs0: SUCCESS (0.161s)
[118.373602] Starting dynamic subtest: vcs1
[120.452679] Dynamic subtest vcs1: SUCCESS (2.086s)
[120.461050] Starting dynamic subtest: vecs0
[122.430074] Dynamic subtest vecs0: SUCCESS (1.978s)
[122.440633] Starting dynamic subtest: ccs0
[124.415719] Dynamic subtest ccs0: SUCCESS (1.985s)
[124.419379] Subtest preservation: SUCCESS (6.519s)
[124.651078] [010/133] (937s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[124.747598] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[124.751795] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[124.833891] [011/133] (937s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[124.923273] Starting subtest: primary-y-tiled-reflect-x-270
[124.927798] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[124.996120] [012/133] (937s left) kms_psr (fbc-psr-no-drrs)
[125.088634] Starting subtest: fbc-psr-no-drrs
[125.090788] Starting dynamic subtest: eDP-1
[125.094667] Dynamic subtest eDP-1: SKIP (0.000s)
[125.098602] Subtest fbc-psr-no-drrs: SKIP (0.000s)
[125.157645] [013/133] (937s left) core_setmaster (master-drop-set-user)
[125.248595] Starting subtest: master-drop-set-user
[125.261498] Subtest master-drop-set-user: SUCCESS (0.016s)
[125.298095] [014/133] (937s left) gem_eio (wait-1us)
[125.501936] Starting subtest: wait-1us
[125.787058] Subtest wait-1us: SUCCESS (0.287s)
[125.926983] [015/133] (936s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[126.025148] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[126.027135] Starting dynamic subtest: pipe-A-eDP-1
[126.044857] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[126.054107] Starting dynamic subtest: pipe-B-eDP-1
[126.070611] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[126.078155] Starting dynamic subtest: pipe-C-eDP-1
[126.095210] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[126.102839] Starting dynamic subtest: pipe-D-eDP-1
[126.118876] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[126.120522] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[128.268941] [016/133] (934s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[128.368801] Starting subtest: y-tiled-16bpp-rotate-90
[128.373140] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[128.453092] [017/133] (934s left) gem_ppgtt (shrink-vs-evict-pinned)
[128.507046] Starting subtest: shrink-vs-evict-pinned
[134.298496] Subtest shrink-vs-evict-pinned: SUCCESS (5.791s)
[134.391469] [018/133] (928s left) kms_getfb (getfb-reject-nv12)
[134.492972] Starting subtest: getfb-reject-nv12
[134.495276] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[134.592217] [019/133] (928s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[134.679725] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[142.376677] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.700s)
[142.486895] [020/133] (920s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[142.582054] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[142.586243] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[142.698971] [021/133] (920s left) kms_properties (plane-properties-legacy)
[142.788300] Starting subtest: plane-properties-legacy
[142.790691] Starting dynamic subtest: pipe-A-eDP-1
[143.367716] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.578s)
[143.377609] Starting dynamic subtest: pipe-B-eDP-1
[144.660441] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.290s)
[144.669479] Starting dynamic subtest: pipe-C-eDP-1
[145.901709] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.241s)
[145.912810] Starting dynamic subtest: pipe-D-eDP-1
[147.137323] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.234s)
[147.139232] Subtest plane-properties-legacy: SUCCESS (4.347s)
[147.937576] [022/133] (914s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[148.033032] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[148.037394] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[148.112170] [023/133] (914s left) gem_exec_reloc (basic-cpu-noreloc)
[148.170638] Subtest basic-cpu-noreloc: SKIP (0.000s)
[148.235498] [024/133] (914s left) i915_query (query-topology-coherent-slice-mask)
[148.286545] Starting subtest: query-topology-coherent-slice-mask
[148.291031] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[148.382170] [025/133] (914s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[148.438540] Starting subtest: multi-wait-available-submitted-signaled
[148.441193] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s)
[148.531980] [026/133] (914s left) gem_exec_fence (syncobj-unused-fence)
[148.968135] Starting subtest: syncobj-unused-fence
[148.973054] Subtest syncobj-unused-fence: SUCCESS (0.004s)
[150.352500] [FACT gem_exec_fence (syncobj-unused-fence)] new: kernel.kmod_is_loaded.vgem: true
[150.356653] [027/133] (912s left) gem_mmap_wc (write-read-distinct)
[150.423382] Subtest write-read-distinct: SKIP (0.000s)
[150.483462] [028/133] (912s left) kms_cursor_edge_walk (128x128-top-bottom)
[150.591238] Starting subtest: 128x128-top-bottom
[150.593593] Starting dynamic subtest: pipe-A-eDP-1
[153.998893] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.408s)
[154.007439] Starting dynamic subtest: pipe-D-eDP-1
[157.126536] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.126s)
[157.128872] Subtest 128x128-top-bottom: SUCCESS (6.536s)
[157.945934] [029/133] (905s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[158.047036] Starting subtest: fbc-psr2-primary-mmap-cpu
[158.049353] Starting dynamic subtest: eDP-1
[158.053772] Dynamic subtest eDP-1: SKIP (0.000s)
[158.058478] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[158.122466] [030/133] (905s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[158.216065] Starting subtest: x-tiled-32bpp-rotate-270
[158.235266] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s)
[158.347344] [031/133] (904s left) kms_psr (pr-cursor-mmap-cpu)
[158.438325] Starting subtest: pr-cursor-mmap-cpu
[158.442429] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[158.509194] [032/133] (904s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[158.600657] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[158.604787] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[158.718032] [033/133] (904s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[158.809050] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[158.813427] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[158.914934] [034/133] (904s left) kms_big_fb (yf-tiled-addfb)
[159.017225] Starting subtest: yf-tiled-addfb
[159.020813] Subtest yf-tiled-addfb: SKIP (0.000s)
[159.119957] [035/133] (904s left) prime_vgem (wait)
[159.185083] Starting subtest: wait
[159.187221] Starting dynamic subtest: rcs0
[159.226221] Dynamic subtest rcs0: SUCCESS (0.041s)
[159.234510] Starting dynamic subtest: bcs0
[159.283691] Dynamic subtest bcs0: SUCCESS (0.057s)
[159.292016] Starting dynamic subtest: vcs0
[159.329760] Dynamic subtest vcs0: SUCCESS (0.046s)
[159.338317] Starting dynamic subtest: vcs1
[159.374707] Dynamic subtest vcs1: SUCCESS (0.044s)
[159.382688] Starting dynamic subtest: vecs0
[159.421690] Dynamic subtest vecs0: SUCCESS (0.046s)
[159.429969] Starting dynamic subtest: ccs0
[159.467839] Dynamic subtest ccs0: SUCCESS (0.045s)
[159.469777] Subtest wait: SUCCESS (0.283s)
[159.579376] [036/133] (903s left) gem_mmap_offset (partial-remap)
[159.629101] Starting subtest: partial-remap
[159.630989] Starting dynamic subtest: smem0
[159.638499] Dynamic subtest smem0: SUCCESS (0.004s)
[159.640363] Subtest partial-remap: SUCCESS (0.004s)
[159.741286] [037/133] (903s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[159.823608] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[159.825651] Starting dynamic subtest: pipe-A-eDP-1
[165.705346] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.884s)
[165.715248] Starting dynamic subtest: pipe-B-eDP-1
[172.364893] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.656s)
[172.367079] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.542s)
[173.237446] [038/133] (890s left) kms_hdr (static-toggle-suspend)
[173.340167] Starting subtest: static-toggle-suspend
[173.346829] Subtest static-toggle-suspend: SKIP (0.000s)
[173.411301] [039/133] (890s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[173.459637] Starting subtest: yf-tiled-to-vebox-yf-tiled
[173.463953] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[173.643963] [040/133] (890s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[173.721083] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[173.723394] Starting dynamic subtest: pipe-A-eDP-1
[173.746719] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[173.756248] Starting dynamic subtest: pipe-B-eDP-1
[173.778137] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[173.786335] Starting dynamic subtest: pipe-C-eDP-1
[173.808432] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[173.816632] Starting dynamic subtest: pipe-D-eDP-1
[173.839525] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[173.843639] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[175.909551] [041/133] (887s left) kms_pm_rpm (pc8-residency)
[177.431295] Starting subtest: pc8-residency
[177.436247] Subtest pc8-residency: SKIP (0.000s)
[178.152759] [042/133] (885s left) gem_exec_schedule (preemptive-hang)
[178.336789] Starting subtest: preemptive-hang
[178.339792] Starting dynamic subtest: rcs0
[187.440528] Dynamic subtest rcs0: SUCCESS (9.101s)
[187.452893] Starting dynamic subtest: bcs0
[196.392994] Dynamic subtest bcs0: SUCCESS (8.952s)
[196.403061] Starting dynamic subtest: vcs0
[205.422626] Dynamic subtest vcs0: SUCCESS (9.029s)
[205.431079] Starting dynamic subtest: vcs1
[214.441052] Dynamic subtest vcs1: SUCCESS (9.018s)
[214.452819] Starting dynamic subtest: vecs0
[223.397685] Dynamic subtest vecs0: SUCCESS (8.954s)
[223.409121] Starting dynamic subtest: ccs0
[232.430438] Dynamic subtest ccs0: SUCCESS (9.031s)
[232.433216] Subtest preemptive-hang: SUCCESS (54.092s)
[232.701696] [043/133] (831s left) kms_pipe_crc_basic (bad-source)
[232.810036] Starting subtest: bad-source
[232.812185] Subtest bad-source: SUCCESS (0.000s)
[232.881087] [044/133] (830s left) gem_exec_schedule (preempt-user)
[232.951261] Starting subtest: preempt-user
[232.953315] Starting dynamic subtest: rcs0
[232.971812] Dynamic subtest rcs0: SUCCESS (0.028s)
[232.983997] Starting dynamic subtest: bcs0
[232.990920] Dynamic subtest bcs0: SUCCESS (0.018s)
[232.999682] Starting dynamic subtest: vcs0
[233.009628] Dynamic subtest vcs0: SUCCESS (0.018s)
[233.018242] Starting dynamic subtest: vcs1
[233.029721] Dynamic subtest vcs1: SUCCESS (0.020s)
[233.038730] Starting dynamic subtest: vecs0
[233.048260] Dynamic subtest vecs0: SUCCESS (0.018s)
[233.060530] Starting dynamic subtest: ccs0
[233.073679] Dynamic subtest ccs0: SUCCESS (0.025s)
[233.075915] Subtest preempt-user: SUCCESS (0.130s)
[234.376814] [045/133] (829s left) gem_huc_copy (huc-copy)
[234.452518] Starting subtest: huc-copy
[234.455044] Subtest huc-copy: SUCCESS (0.004s)
[234.565285] [046/133] (829s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[234.668105] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[235.768697] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.100s)
[235.891548] [047/133] (828s left) kms_content_protection (dp-mst-lic-type-1)
[236.032658] Starting subtest: dp-mst-lic-type-1
[236.036443] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[236.172100] [048/133] (827s left) core_getclient (basic)
[236.229671] Starting subtest: basic
[236.231340] Subtest basic: SUCCESS (0.000s)
[236.333580] [049/133] (827s left) gem_mmap (short-mmap)
[236.382018] Subtest short-mmap: SKIP (0.000s)
[236.442462] [050/133] (827s left) perf_pmu (busy-check-all)
[236.481641] Starting subtest: busy-check-all
[236.483651] Starting dynamic subtest: rcs0
[237.046529] Dynamic subtest rcs0: SUCCESS (0.565s)
[237.058041] Starting dynamic subtest: bcs0
[237.597565] Dynamic subtest bcs0: SUCCESS (0.550s)
[237.610193] Starting dynamic subtest: vcs0
[239.300531] Dynamic subtest vcs0: SUCCESS (1.698s)
[239.312917] Starting dynamic subtest: vcs1
[241.283583] Dynamic subtest vcs1: SUCCESS (1.981s)
[241.295726] Starting dynamic subtest: vecs0
[243.267771] Dynamic subtest vecs0: SUCCESS (1.981s)
[243.279953] Starting dynamic subtest: ccs0
[243.823217] Dynamic subtest ccs0: SUCCESS (0.555s)
[243.825740] Subtest busy-check-all: SUCCESS (7.342s)
[243.928398] [051/133] (820s left) gem_partial_pwrite_pread (write-display)
[243.998470] Subtest write-display: SKIP (0.000s)
[244.076299] [052/133] (820s left) gem_ctx_sseu (invalid-sseu)
[244.142406] Subtest invalid-sseu: SKIP (0.000s)
[244.213921] [053/133] (819s left) kms_plane_multiple (tiling-none)
[244.305875] Starting subtest: tiling-none
[244.308188] Starting dynamic subtest: pipe-A-eDP-1
[247.968631] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.662s)
[247.979038] Starting dynamic subtest: pipe-B-eDP-1
[252.311863] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.345s)
[252.321567] Starting dynamic subtest: pipe-C-eDP-1
[256.643157] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.329s)
[256.652772] Starting dynamic subtest: pipe-D-eDP-1
[261.062218] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.416s)
[261.064544] Subtest tiling-none: SUCCESS (16.757s)
[261.868535] [054/133] (802s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[261.927314] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[262.003836] [055/133] (802s left) i915_pm_rpm (system-suspend-devices)
[263.527419] Starting subtest: system-suspend-devices
[271.350835] Subtest system-suspend-devices: SUCCESS (7.824s)
[271.727401] [056/133] (792s left) kms_async_flips (test-time-stamp-atomic)
[271.837531] Starting subtest: test-time-stamp-atomic
[272.213876] Starting dynamic subtest: pipe-A-eDP-1
[273.019785] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.805s)
[273.403960] Starting dynamic subtest: pipe-B-eDP-1
[274.163064] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.767s)
[274.549265] Starting dynamic subtest: pipe-C-eDP-1
[275.310893] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.766s)
[275.690831] Starting dynamic subtest: pipe-D-eDP-1
[276.440893] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.758s)
[276.443381] Subtest test-time-stamp-atomic: SUCCESS (4.605s)
[277.595666] [057/133] (786s left) kms_cursor_crc (cursor-offscreen-256x256)
[277.825705] Starting subtest: cursor-offscreen-256x256
[277.830871] Starting dynamic subtest: pipe-A-eDP-1
[279.787711] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.956s)
[279.816591] Starting dynamic subtest: pipe-D-eDP-1
[282.386155] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.576s)
[282.388570] Subtest cursor-offscreen-256x256: SUCCESS (4.559s)
[283.257997] [058/133] (781s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[283.351520] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[283.355901] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[283.459345] [059/133] (780s left) gem_exec_await (wide-contexts)
[283.656374] Starting subtest: wide-contexts
[307.214870] Subtest wide-contexts: SUCCESS (23.556s)
[307.416885] [060/133] (757s left) kms_flip (nonexisting-fb-interruptible)
[307.574939] Starting subtest: nonexisting-fb-interruptible
[307.577311] Starting dynamic subtest: A-eDP1
[308.736352] Dynamic subtest A-eDP1: SUCCESS (1.160s)
[308.750356] Starting dynamic subtest: B-eDP1
[309.866632] Dynamic subtest B-eDP1: SUCCESS (1.129s)
[309.880866] Starting dynamic subtest: C-eDP1
[310.995502] Dynamic subtest C-eDP1: SUCCESS (1.126s)
[311.006928] Starting dynamic subtest: D-eDP1
[312.129515] Dynamic subtest D-eDP1: SUCCESS (1.133s)
[312.136501] Subtest nonexisting-fb-interruptible: SUCCESS (4.562s)
[313.312259] [061/133] (751s left) kms_psr (psr2-no-drrs)
[313.407850] Starting subtest: psr2-no-drrs
[313.410263] Starting dynamic subtest: eDP-1
[314.972791] Dynamic subtest eDP-1: SUCCESS (1.563s)
[314.975119] Subtest psr2-no-drrs: SUCCESS (1.565s)
[315.757028] [062/133] (748s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[315.859148] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[315.885412] Starting dynamic subtest: pipe-A-plane-0
[316.173696] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[316.185700] Starting dynamic subtest: pipe-A-plane-3
[316.407359] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[317.547321] Starting dynamic subtest: pipe-B-plane-0
[317.839520] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[317.850801] Starting dynamic subtest: pipe-B-plane-3
[318.083825] Dynamic subtest pipe-B-plane-3: SUCCESS (0.244s)
[318.391515] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.534s)
[319.228993] [063/133] (745s left) gem_exec_balancer (bonded-true-hang)
[319.500060] Starting subtest: bonded-true-hang
[319.505152] Subtest bonded-true-hang: SKIP (0.000s)
[319.604913] [064/133] (745s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[319.982686] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[320.840306] [065/133] (743s left) gem_exec_reloc (basic-write-cpu-noreloc)
[320.907862] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[320.979130] [066/133] (743s left) kms_hdmi_inject (inject-4k)
[321.309902] Starting subtest: inject-4k
[321.631833] Subtest inject-4k: SUCCESS (0.323s)
[322.209102] [067/133] (742s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[322.293779] Starting subtest: etime-single-wait-all-for-submit-submitted
[322.399095] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.103s)
[322.475242] [068/133] (742s left) kms_flip (flip-vs-modeset-vs-hang)
[322.572604] Starting subtest: flip-vs-modeset-vs-hang
[322.575260] Starting dynamic subtest: A-eDP1
[373.787253] Dynamic subtest A-eDP1: SUCCESS (51.208s)
[373.803344] Starting dynamic subtest: D-eDP1
[423.774868] Dynamic subtest D-eDP1: SUCCESS (49.987s)
[423.777615] Subtest flip-vs-modeset-vs-hang: SUCCESS (101.200s)
[424.156603] [069/133] (640s left) kms_lease (master-vs-lease)
[424.250542] Starting subtest: master-vs-lease
[424.252850] Subtest master-vs-lease: SUCCESS (0.002s)
[424.364448] [070/133] (640s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[424.447897] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[424.450294] Starting dynamic subtest: pipe-A-eDP-1
[425.013313] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.537s)
[425.025339] Starting dynamic subtest: pipe-B-eDP-1
[426.515335] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.497s)
[426.527773] Starting dynamic subtest: pipe-C-eDP-1
[427.991325] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.478s)
[428.001633] Starting dynamic subtest: pipe-D-eDP-1
[429.336671] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.343s)
[429.338677] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.861s)
[430.471720] [071/133] (634s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[430.530456] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[430.535302] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[430.711919] [072/133] (634s left) gem_ctx_engines (invalid-engines)
[430.768775] Starting subtest: invalid-engines
[430.777102] Subtest invalid-engines: SUCCESS (0.008s)
[431.017871] [073/133] (634s left) gem_exec_params (dr4-dirt)
[431.071069] Starting subtest: DR4-dirt
[431.072883] Subtest DR4-dirt: SUCCESS (0.000s)
[431.169570] [074/133] (633s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[431.267518] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[431.272077] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[431.360521] [075/133] (633s left) sw_sync (sync_multi_producer_single_consumer)
[431.407042] Starting subtest: sync_multi_producer_single_consumer
[432.477108] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[432.538476] [076/133] (632s left) syncobj_timeline (wait-all-for-submit-complex)
[432.595216] Starting subtest: wait-all-for-submit-complex
[432.809331] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[432.897524] [077/133] (632s left) gem_eio (execbuf)
[433.088085] Starting subtest: execbuf
[433.367413] Subtest execbuf: SUCCESS (0.277s)
[433.513453] [078/133] (631s left) gem_partial_pwrite_pread (writes-after-reads)
[433.569825] Subtest writes-after-reads: SKIP (0.000s)
[433.651746] [079/133] (631s left) kms_feature_discovery (dp-mst)
[433.738800] Starting subtest: dp-mst
[433.743243] Subtest dp-mst: SKIP (0.000s)
[433.827671] [080/133] (631s left) perf (low-oa-exponent-permissions)
[433.954260] Starting subtest: low-oa-exponent-permissions
[433.989290] Subtest low-oa-exponent-permissions: SUCCESS (0.035s)
[434.038033] [081/133] (631s left) gem_exec_fence (syncobj-import)
[434.479276] Starting subtest: syncobj-import
[434.482083] Subtest syncobj-import: SUCCESS (0.005s)
[436.374472] [082/133] (629s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[436.488133] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[436.490330] Starting dynamic subtest: pipe-A-eDP-1
[436.581790] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[436.595329] Starting dynamic subtest: pipe-B-eDP-1
[437.726158] Dynamic subtest pipe-B-eDP-1: SKIP (1.141s)
[437.730693] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.244s)
[438.971101] [083/133] (626s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[439.087488] Starting subtest: cursorB-vs-flipB-atomic
[439.092062] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[439.236594] [084/133] (626s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[439.324464] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[439.336599] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.011s)
[439.413285] [085/133] (626s left) kms_vblank (ts-continuation-idle)
[439.494224] Starting subtest: ts-continuation-idle
[439.496093] Starting dynamic subtest: pipe-A-eDP-1
[439.903183] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.406s)
[439.920092] Starting dynamic subtest: pipe-D-eDP-1
[441.027988] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.123s)
[441.030390] Subtest ts-continuation-idle: SUCCESS (1.535s)
[441.874636] [086/133] (623s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[441.970105] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[441.974602] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[443.068408] [087/133] (622s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[443.164626] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[443.168891] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[443.267477] [088/133] (622s left) syncobj_eventfd (invalid-bad-flags)
[443.314916] Starting subtest: invalid-bad-flags
[443.317210] Subtest invalid-bad-flags: SUCCESS (0.000s)
[443.399650] [089/133] (622s left) kms_pwrite_crc (basic)
[443.484456] Starting subtest: basic
[444.184868] Subtest basic: SUCCESS (0.702s)
[444.978381] [090/133] (620s left) gem_sync (basic-store-each)
[445.058436] Starting subtest: basic-store-each
[447.406565] Subtest basic-store-each: SUCCESS (2.359s)
[447.593979] [091/133] (618s left) kms_universal_plane (universal-plane-sanity)
[447.702083] Starting subtest: universal-plane-sanity
[447.703987] Starting dynamic subtest: pipe-A-eDP-1
[448.311688] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.611s)
[448.323313] Starting dynamic subtest: pipe-B-eDP-1
[449.559430] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.244s)
[449.570752] Starting dynamic subtest: pipe-C-eDP-1
[450.757627] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.196s)
[450.769725] Starting dynamic subtest: pipe-D-eDP-1
[451.939806] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.181s)
[451.942425] Subtest universal-plane-sanity: SUCCESS (4.239s)
[452.770394] [092/133] (613s left) gem_spin_batch (legacy)
[452.825384] Starting subtest: legacy
[452.827722] Starting dynamic subtest: default
[456.066718] Dynamic subtest default: SUCCESS (3.235s)
[456.076982] Starting dynamic subtest: render
[459.303115] Dynamic subtest render: SUCCESS (3.233s)
[459.314635] Starting dynamic subtest: bsd
[462.541773] Dynamic subtest bsd: SUCCESS (3.235s)
[462.552725] Starting dynamic subtest: bsd1
[465.779855] Dynamic subtest bsd1: SUCCESS (3.234s)
[465.789677] Starting dynamic subtest: bsd2
[469.015075] Dynamic subtest bsd2: SUCCESS (3.231s)
[469.026752] Starting dynamic subtest: blt
[472.257125] Dynamic subtest blt: SUCCESS (3.238s)
[472.269236] Starting dynamic subtest: vebox
[475.494258] Dynamic subtest vebox: SUCCESS (3.234s)
[475.496471] Subtest legacy: SUCCESS (22.664s)
[476.368403] [093/133] (589s left) kms_rotation_crc (primary-rotation-90)
[476.474735] Starting subtest: primary-rotation-90
[476.479054] Subtest primary-rotation-90: SKIP (0.001s)
[476.548836] [094/133] (589s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[476.640991] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[485.180340] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.543s)
[485.302976] [095/133] (580s left) api_intel_allocator (default-alignment)
[485.358459] Starting subtest: default-alignment
[485.360645] Subtest default-alignment: SUCCESS (0.004s)
[485.501990] [096/133] (580s left) kms_chamelium_frames (hdmi-frame-dump)
[485.904356] Subtest hdmi-frame-dump: SKIP (0.000s)
[486.752096] [097/133] (579s left) kms_chamelium_audio (hdmi-audio)
[487.150044] Subtest hdmi-audio: SKIP (0.000s)
[487.946824] [098/133] (578s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[488.043463] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[488.867821] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.826s)
[489.018498] [099/133] (577s left) gen7_exec_parse (bitmasks)
[489.075609] Subtest bitmasks: SKIP (0.000s)
[489.148627] [100/133] (577s left) gem_mmap_wc (set-cache-level)
[489.205318] Subtest set-cache-level: SKIP (0.000s)
[489.284278] [101/133] (576s left) gem_madvise (dontneed-before-exec)
[489.317572] Starting subtest: dontneed-before-exec
[489.341401] Subtest dontneed-before-exec: SKIP (0.019s)
[489.398289] [102/133] (576s left) i915_module_load (resize-bar)
[489.436967] Starting subtest: resize-bar
[489.443600] Subtest resize-bar: SKIP (0.006s)
[489.484889] [103/133] (576s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[489.580041] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[489.582223] Starting dynamic subtest: pipe-A-eDP-1
[489.590824] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[489.601753] Starting dynamic subtest: pipe-B-eDP-1
[489.611456] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[489.621796] Starting dynamic subtest: pipe-C-eDP-1
[489.630395] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[489.640512] Starting dynamic subtest: pipe-D-eDP-1
[489.648989] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[489.653083] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s)
[491.877452] [104/133] (574s left) gem_eio (wait-immediate)
[492.094512] Starting subtest: wait-immediate
[492.436736] Subtest wait-immediate: SUCCESS (0.341s)
[492.587226] [105/133] (573s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[492.708643] Starting subtest: 2x-long-flip-vs-cursor-legacy
[492.713021] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[492.864483] [106/133] (573s left) gem_exec_reloc (basic-gtt-wc-active)
[492.922947] Subtest basic-gtt-wc-active: SKIP (0.000s)
[492.994345] [107/133] (573s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[493.098029] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[493.101490] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[493.171454] [108/133] (573s left) kms_frontbuffer_tracking (fbc-tiling-4)
[493.264924] Starting subtest: fbc-tiling-4
[497.442030] Subtest fbc-tiling-4: SUCCESS (4.179s)
[498.583883] [109/133] (567s left) kms_big_fb (linear-32bpp-rotate-270)
[498.688495] Starting subtest: linear-32bpp-rotate-270
[498.707439] Subtest linear-32bpp-rotate-270: SKIP (0.018s)
[498.845663] [110/133] (567s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[498.934443] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[498.937072] Starting dynamic subtest: pipe-A
[499.069141] Dynamic subtest pipe-A: SKIP (0.130s)
[499.083198] Starting dynamic subtest: pipe-B
[500.206399] Dynamic subtest pipe-B: SKIP (1.138s)
[500.217484] Starting dynamic subtest: pipe-C
[501.399901] Dynamic subtest pipe-C: SUCCESS (1.197s)
[501.410218] Starting dynamic subtest: pipe-D
[502.607546] Dynamic subtest pipe-D: SUCCESS (1.207s)
[502.609890] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.676s)
[503.758144] [111/133] (562s left) fbdev (pan)
[503.792631] Starting subtest: pan
[503.819887] Subtest pan: SUCCESS (0.031s)
[503.893461] [112/133] (562s left) gem_exec_capture (pi)
[503.952881] Starting subtest: pi
[503.955156] Starting dynamic subtest: rcs0
[507.936686] Dynamic subtest rcs0: SUCCESS (3.983s)
[507.947604] Starting dynamic subtest: bcs0
[511.850703] Dynamic subtest bcs0: SUCCESS (3.913s)
[511.863776] Starting dynamic subtest: vcs0
[515.751329] Dynamic subtest vcs0: SUCCESS (3.899s)
[515.767433] Starting dynamic subtest: vcs1
[519.590741] Dynamic subtest vcs1: SUCCESS (3.839s)
[519.603225] Starting dynamic subtest: vecs0
[523.464193] Dynamic subtest vecs0: SUCCESS (3.871s)
[523.475656] Starting dynamic subtest: ccs0
[527.396697] Dynamic subtest ccs0: SUCCESS (3.931s)
[527.399208] Subtest pi: SUCCESS (23.443s)
[527.478307] [113/133] (539s left) i915_query (query-regions-garbage-items)
[527.583856] Starting subtest: query-regions-garbage-items
[527.586631] Subtest query-regions-garbage-items: SUCCESS (0.001s)
[527.696631] [114/133] (539s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[527.794380] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[527.798742] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[527.868653] [115/133] (538s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[527.959075] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[527.963455] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[528.055370] [116/133] (538s left) gem_userptr_blits (sd-probe)
[528.120854] Starting subtest: sd-probe
[528.122784] Subtest sd-probe: SUCCESS (0.000s)
[528.243155] [117/133] (538s left) i915_drm_fdinfo (busy-check-all)
[528.278069] Starting subtest: busy-check-all
[528.280260] Starting dynamic subtest: rcs0
[528.284723] Dynamic subtest rcs0: SKIP (0.004s)
[528.294982] Starting dynamic subtest: bcs0
[528.299309] Dynamic subtest bcs0: SKIP (0.000s)
[528.308985] Starting dynamic subtest: vcs0
[528.313093] Dynamic subtest vcs0: SKIP (0.000s)
[528.322430] Starting dynamic subtest: vcs1
[528.326576] Dynamic subtest vcs1: SKIP (0.000s)
[528.336048] Starting dynamic subtest: vecs0
[528.339802] Dynamic subtest vecs0: SKIP (0.000s)
[528.348778] Starting dynamic subtest: ccs0
[528.352187] Dynamic subtest ccs0: SKIP (0.000s)
[528.355512] Subtest busy-check-all: SKIP (0.009s)
[528.392859] [118/133] (538s left) syncobj_timeline (wait-zero-handles)
[528.477472] Starting subtest: wait-zero-handles
[528.479629] Subtest wait-zero-handles: SUCCESS (0.000s)
[528.554818] [119/133] (538s left) syncobj_basic (bad-create-flags)
[528.605210] Starting subtest: bad-create-flags
[528.607233] Subtest bad-create-flags: SUCCESS (0.000s)
[528.696645] [120/133] (538s left) perf_pmu (busy-start)
[528.733429] Starting subtest: busy-start
[528.735345] Starting dynamic subtest: rcs0
[531.287059] Dynamic subtest rcs0: SUCCESS (2.552s)
[531.299731] Starting dynamic subtest: bcs0
[533.836405] Dynamic subtest bcs0: SUCCESS (2.548s)
[533.851134] Starting dynamic subtest: vcs0
[537.282387] Dynamic subtest vcs0: SUCCESS (3.441s)
[537.295974] Starting dynamic subtest: vcs1
[541.313990] Dynamic subtest vcs1: SUCCESS (4.029s)
[541.327046] Starting dynamic subtest: vecs0
[545.281878] Dynamic subtest vecs0: SUCCESS (3.966s)
[545.295086] Starting dynamic subtest: ccs0
[547.832693] Dynamic subtest ccs0: SUCCESS (2.549s)
[547.835263] Subtest busy-start: SUCCESS (19.099s)
[547.942417] [121/133] (519s left) gem_ctx_persistence (processes)
[548.000294] Starting subtest: processes
[549.259657] Subtest processes: SUCCESS (1.259s)
[549.339972] [122/133] (517s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[549.437562] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[549.441770] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[549.551554] [123/133] (517s left) gen3_mixed_blits
[549.671047] [124/133] (517s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[549.769304] Starting subtest: async-flip-with-page-flip-events-tiled
[550.159849] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[552.907336] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.746s)
[552.919112] Starting dynamic subtest: pipe-A-eDP-1-4
[555.092500] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.184s)
[555.103067] Starting dynamic subtest: pipe-A-eDP-1-4
[557.103629] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[557.114432] Starting dynamic subtest: pipe-A-eDP-1-x
[559.283101] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s)
[559.662483] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[562.404698] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.748s)
[562.420575] Starting dynamic subtest: pipe-B-eDP-1-4
[564.590056] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[564.603096] Starting dynamic subtest: pipe-B-eDP-1-4
[566.600311] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[566.614022] Starting dynamic subtest: pipe-B-eDP-1-x
[568.790894] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[569.163723] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[571.901970] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.748s)
[571.916391] Starting dynamic subtest: pipe-C-eDP-1-4
[574.077069] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[574.087515] Starting dynamic subtest: pipe-C-eDP-1-4
[576.087322] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[576.098874] Starting dynamic subtest: pipe-C-eDP-1-x
[578.265577] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[578.637807] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[581.396743] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.767s)
[581.411246] Starting dynamic subtest: pipe-D-eDP-1-4
[583.570967] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s)
[583.581854] Starting dynamic subtest: pipe-D-eDP-1-4
[585.581135] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[585.591853] Starting dynamic subtest: pipe-D-eDP-1-x
[587.759176] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s)
[587.761780] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (37.991s)
[588.954226] [125/133] (478s left) gem_exec_whisper (basic-contexts)
[589.023428] Starting subtest: basic-contexts
[596.340136] Subtest basic-contexts: SUCCESS (7.319s)
[596.531929] [126/133] (470s left) kms_cursor_crc (cursor-random-512x170)
[596.853113] Starting subtest: cursor-random-512x170
[596.857586] Subtest cursor-random-512x170: SKIP (0.001s)
[597.001287] [127/133] (470s left) kms_color_pipeline (plane-ctm3x4)
[597.103303] Starting subtest: plane-ctm3x4
[597.248851] Starting dynamic subtest: pipe-A-plane-0
[597.415827] Dynamic subtest pipe-A-plane-0: SUCCESS (0.167s)
[597.427270] Starting dynamic subtest: pipe-A-plane-1
[597.549969] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[597.560066] Starting dynamic subtest: pipe-A-plane-2
[597.704196] Dynamic subtest pipe-A-plane-2: SUCCESS (0.153s)
[598.964177] Starting dynamic subtest: pipe-B-plane-0
[599.120391] Dynamic subtest pipe-B-plane-0: SUCCESS (0.167s)
[599.131123] Starting dynamic subtest: pipe-B-plane-1
[599.253538] Dynamic subtest pipe-B-plane-1: SUCCESS (0.132s)
[599.265407] Starting dynamic subtest: pipe-B-plane-2
[599.398977] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s)
[600.632196] Starting dynamic subtest: pipe-C-plane-0
[600.756667] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[600.769812] Starting dynamic subtest: pipe-C-plane-1
[600.867729] Dynamic subtest pipe-C-plane-1: SUCCESS (0.111s)
[600.881837] Starting dynamic subtest: pipe-C-plane-2
[601.000998] Dynamic subtest pipe-C-plane-2: SUCCESS (0.132s)
[602.245444] Starting dynamic subtest: pipe-D-plane-0
[602.369275] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[602.382167] Starting dynamic subtest: pipe-D-plane-1
[602.491739] Dynamic subtest pipe-D-plane-1: SUCCESS (0.122s)
[602.502374] Starting dynamic subtest: pipe-D-plane-2
[602.625062] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[602.913937] Subtest plane-ctm3x4: SUCCESS (5.811s)
[603.761052] [128/133] (463s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[603.860527] Starting subtest: fbcpsr-1p-rte
[610.798253] Subtest fbcpsr-1p-rte: SUCCESS (6.941s)
[610.958675] [129/133] (456s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[611.083756] Starting subtest: basic-flip-before-cursor-legacy
[612.022663] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.937s)
[612.855942] [130/133] (454s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[612.941168] Starting subtest: plane-upscale-factor-0-25-with-rotation
[612.943420] Starting dynamic subtest: pipe-A
[613.165353] Dynamic subtest pipe-A: SUCCESS (0.227s)
[613.175886] Starting dynamic subtest: pipe-B
[614.509119] Dynamic subtest pipe-B: SUCCESS (1.343s)
[614.520351] Starting dynamic subtest: pipe-C
[615.802134] Dynamic subtest pipe-C: SUCCESS (1.292s)
[615.813917] Starting dynamic subtest: pipe-D
[617.097303] Dynamic subtest pipe-D: SUCCESS (1.294s)
[617.099596] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.159s)
[618.244461] [131/133] (449s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[618.368608] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[650.140813] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.770s)
[650.951826] [132/133] (416s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[651.057516] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[651.062166] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[651.155828] [133/133] (416s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[653.486472] Starting subtest: dpms-mode-unset-lpsp
[657.559429] Subtest dpms-mode-unset-lpsp: SUCCESS (4.073s)
[657.937355] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_mmap_gtt
results: parsing output: 2/ for test: kms_flip
results: parsing output: 3/ for test: syncobj_wait
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_pipe_crc_basic
results: parsing output: 6/ for test: kms_dp_link_training
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: gem_ctx_isolation
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_rotation_crc
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: core_setmaster
results: parsing output: 13/ for test: gem_eio
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: gem_ppgtt
results: parsing output: 17/ for test: kms_getfb
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_properties
results: parsing output: 21/ for test: kms_flip_scaled_crc
results: parsing output: 22/ for test: gem_exec_reloc
results: parsing output: 23/ for test: i915_query
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: gem_exec_fence
results: parsing output: 26/ for test: gem_mmap_wc
results: parsing output: 27/ for test: kms_cursor_edge_walk
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: prime_vgem
results: parsing output: 35/ for test: gem_mmap_offset
results: parsing output: 36/ for test: kms_psr2_sf
results: parsing output: 37/ for test: kms_hdr
results: parsing output: 38/ for test: gem_render_copy
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: kms_pm_rpm
results: parsing output: 41/ for test: gem_exec_schedule
results: parsing output: 42/ for test: kms_pipe_crc_basic
results: parsing output: 43/ for test: gem_exec_schedule
results: parsing output: 44/ for test: gem_huc_copy
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: kms_content_protection
results: parsing output: 47/ for test: core_getclient
results: parsing output: 48/ for test: gem_mmap
results: parsing output: 49/ for test: perf_pmu
results: parsing output: 50/ for test: gem_partial_pwrite_pread
results: parsing output: 51/ for test: gem_ctx_sseu
results: parsing output: 52/ for test: kms_plane_multiple
results: parsing output: 53/ for test: gem_fenced_exec_thrash
results: parsing output: 54/ for test: i915_pm_rpm
results: parsing output: 55/ for test: kms_async_flips
results: parsing output: 56/ for test: kms_cursor_crc
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_exec_await
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: kms_plane
results: parsing output: 62/ for test: gem_exec_balancer
results: parsing output: 63/ for test: kms_chamelium_hpd
results: parsing output: 64/ for test: gem_exec_reloc
results: parsing output: 65/ for test: kms_hdmi_inject
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: kms_flip
results: parsing output: 68/ for test: kms_lease
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: gem_render_copy
results: parsing output: 71/ for test: gem_ctx_engines
results: parsing output: 72/ for test: gem_exec_params
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: sw_sync
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: gem_eio
results: parsing output: 77/ for test: gem_partial_pwrite_pread
results: parsing output: 78/ for test: kms_feature_discovery
results: parsing output: 79/ for test: perf
results: parsing output: 80/ for test: gem_exec_fence
results: parsing output: 81/ for test: kms_psr2_sf
results: parsing output: 82/ for test: kms_cursor_legacy
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: kms_vblank
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: syncobj_eventfd
results: parsing output: 88/ for test: kms_pwrite_crc
results: parsing output: 89/ for test: gem_sync
results: parsing output: 90/ for test: kms_universal_plane
results: parsing output: 91/ for test: gem_spin_batch
results: parsing output: 92/ for test: kms_rotation_crc
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: api_intel_allocator
results: parsing output: 95/ for test: kms_chamelium_frames
results: parsing output: 96/ for test: kms_chamelium_audio
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: gen7_exec_parse
results: parsing output: 99/ for test: gem_mmap_wc
results: parsing output: 100/ for test: gem_madvise
results: parsing output: 101/ for test: i915_module_load
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: gem_eio
results: parsing output: 104/ for test: kms_cursor_legacy
results: parsing output: 105/ for test: gem_exec_reloc
results: parsing output: 106/ for test: kms_psr2_sf
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_plane_scaling
results: parsing output: 110/ for test: fbdev
results: parsing output: 111/ for test: gem_exec_capture
results: parsing output: 112/ for test: i915_query
results: parsing output: 113/ for test: kms_flip_scaled_crc
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_userptr_blits
results: parsing output: 116/ for test: i915_drm_fdinfo
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: syncobj_basic
results: parsing output: 119/ for test: perf_pmu
results: parsing output: 120/ for test: gem_ctx_persistence
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gen3_mixed_blits
results: parsing output: 123/ for test: kms_async_flips
results: parsing output: 124/ for test: gem_exec_whisper
results: parsing output: 125/ for test: kms_cursor_crc
results: parsing output: 126/ for test: kms_color_pipeline
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_cursor_legacy
results: parsing output: 129/ for test: kms_plane_scaling
results: parsing output: 130/ for test: kms_cursor_legacy
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_pm_rpm
Done.