[57.667418] Initializing watchdogs
[57.667462]   /dev/watchdog0
[57.682386] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[57.686650] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.688834] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.692204] [001/133] (960s left) core_sysfs (read-all-entries)
[57.767837] Starting subtest: read-all-entries
[57.770257] Subtest read-all-entries: SUCCESS (0.003s)
[57.872876] [002/133] (960s left) kms_chamelium_edid (hdmi-edid-read)
[59.029259] Subtest hdmi-edid-read: SKIP (0.000s)
[59.332135] [003/133] (958s left) perf (short-reads)
[59.462384] Starting subtest: short-reads
[59.477362] Subtest short-reads: SUCCESS (0.017s)
[59.517676] [004/133] (958s left) kms_psr (fbc-pr-primary-mmap-cpu)
[59.594997] Starting subtest: fbc-pr-primary-mmap-cpu
[59.599313] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[59.667595] [005/133] (958s left) gem_ctx_shared (q-in-order)
[59.726410] Starting subtest: Q-in-order
[59.728774] Starting dynamic subtest: rcs0
[59.883919] Dynamic subtest rcs0: SUCCESS (0.155s)
[59.897102] Starting dynamic subtest: vcs0
[59.960480] Dynamic subtest vcs0: SUCCESS (0.078s)
[59.974907] Starting dynamic subtest: vcs1
[60.038766] Dynamic subtest vcs1: SUCCESS (0.078s)
[60.053814] Starting dynamic subtest: vecs0
[60.117883] Dynamic subtest vecs0: SUCCESS (0.079s)
[60.130945] Starting dynamic subtest: ccs0
[60.199965] Dynamic subtest ccs0: SUCCESS (0.081s)
[60.202938] Subtest Q-in-order: SUCCESS (0.473s)
[61.942548] [FACT gem_ctx_shared (q-in-order)] new: kernel.kmod_is_loaded.vgem: true
[61.945957] [006/133] (956s left) kms_plane_multiple (2x-tiling-4)
[62.010699] Starting subtest: 2x-tiling-4
[62.015088] Subtest 2x-tiling-4: SKIP (0.000s)
[62.134226] [007/133] (956s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[62.195758] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[62.262803] [008/133] (956s left) gem_render_copy (linear-to-vebox-yf-tiled)
[62.319045] Starting subtest: linear-to-vebox-yf-tiled
[62.323776] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[62.501951] [009/133] (956s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[62.586491] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[62.588823] Starting dynamic subtest: pipe-A-eDP-1
[62.612066] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[62.622178] Starting dynamic subtest: pipe-B-eDP-1
[62.644559] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[62.651460] Starting dynamic subtest: pipe-C-eDP-1
[62.672554] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[62.679393] Starting dynamic subtest: pipe-D-eDP-1
[62.701461] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[62.705953] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[64.863268] [010/133] (953s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[64.951748] Starting subtest: psr-indfb-scaledprimary
[70.678855] Subtest psr-indfb-scaledprimary: SUCCESS (5.731s)
[70.801859] [011/133] (947s left) gem_lmem_swapping (basic)
[70.848091] Subtest basic: SKIP (0.000s)
[70.888819] [012/133] (947s left) gem_exec_params (secure-non-root)
[70.954750] Starting subtest: secure-non-root
[70.959373] Subtest secure-non-root: SKIP (0.000s)
[71.069824] [013/133] (947s left) kms_fbcon_fbt (fbc-suspend)
[71.121097] Starting subtest: fbc-suspend
[120.874488] Subtest fbc-suspend: SUCCESS (19.329s)
[122.227457] [014/133] (896s left) gem_exec_schedule (u-submit-golden-slice)
[122.321247] Starting subtest: u-submit-golden-slice
[122.323928] Starting dynamic subtest: rcs0
[122.359117] Dynamic subtest rcs0: SUCCESS (0.050s)
[122.368195] Starting dynamic subtest: bcs0
[122.390430] Dynamic subtest bcs0: SUCCESS (0.031s)
[122.399528] Starting dynamic subtest: vcs0
[122.433781] Dynamic subtest vcs0: SUCCESS (0.043s)
[122.445639] Starting dynamic subtest: vcs1
[122.463453] Dynamic subtest vcs1: SUCCESS (0.029s)
[122.473766] Starting dynamic subtest: vecs0
[122.491036] Dynamic subtest vecs0: SUCCESS (0.028s)
[122.500080] Starting dynamic subtest: ccs0
[122.519426] Dynamic subtest ccs0: SUCCESS (0.028s)
[122.522135] Subtest u-submit-golden-slice: SUCCESS (0.210s)
[124.361499] [015/133] (894s left) gem_ctx_persistence (heartbeat-stop)
[124.422034] Starting subtest: heartbeat-stop
[124.427977] Subtest heartbeat-stop: SKIP (0.000s)
[124.514759] [016/133] (894s left) sysfs_preempt_timeout (timeout)
[124.568126] Starting subtest: timeout
[124.571185] Starting dynamic subtest: vecs0
[134.252221] Dynamic subtest vecs0: SUCCESS (9.681s)
[134.265090] Starting dynamic subtest: ccs0
[135.506733] Dynamic subtest ccs0: SUCCESS (1.255s)
[135.517128] Starting dynamic subtest: vcs0
[145.259982] Dynamic subtest vcs0: SUCCESS (9.751s)
[145.279213] Starting dynamic subtest: bcs0
[146.544368] Dynamic subtest bcs0: SUCCESS (1.284s)
[146.555969] Starting dynamic subtest: rcs0
[147.788973] Dynamic subtest rcs0: SUCCESS (1.246s)
[147.798766] Starting dynamic subtest: vcs1
[157.291244] Dynamic subtest vcs1: SUCCESS (9.501s)
[157.294098] Subtest timeout: SUCCESS (32.723s)
[157.368443] [017/133] (861s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[157.448520] Starting subtest: 2x-absolute-wf_vblank-interruptible
[157.458626] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.008s)
[157.570010] [018/133] (861s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[157.630227] Subtest untiled-to-tiled: SKIP (0.000s)
[157.694669] [019/133] (861s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[157.788721] Starting subtest: 4-tiled-8bpp-rotate-90
[157.811096] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.021s)
[157.911808] [020/133] (861s left) kms_vrr (flipline)
[157.987928] Starting subtest: flipline
[157.996195] Subtest flipline: SKIP (0.000s)
[158.067521] [021/133] (861s left) kms_content_protection (suspend-resume)
[158.189610] Starting subtest: suspend-resume
[158.194845] Subtest suspend-resume: SKIP (0.000s)
[158.306364] [022/133] (860s left) gem_exec_schedule (u-independent)
[158.365570] Starting subtest: u-independent
[158.367362] Starting dynamic subtest: rcs0
[160.245765] Dynamic subtest rcs0: SUCCESS (1.887s)
[160.258197] Starting dynamic subtest: vcs0
[162.312897] Dynamic subtest vcs0: SUCCESS (2.066s)
[162.324973] Starting dynamic subtest: vcs1
[164.288146] Dynamic subtest vcs1: SUCCESS (1.974s)
[164.305054] Starting dynamic subtest: vecs0
[166.258833] Dynamic subtest vecs0: SUCCESS (1.970s)
[166.272197] Starting dynamic subtest: ccs0
[168.245082] Dynamic subtest ccs0: SUCCESS (1.986s)
[168.248231] Subtest u-independent: SUCCESS (9.887s)
[168.552675] [023/133] (850s left) kms_addfb_basic (bad-pitch-0)
[168.606953] Starting subtest: bad-pitch-0
[168.610526] Subtest bad-pitch-0: SUCCESS (0.000s)
[168.720217] [024/133] (850s left) kms_scaling_modes (scaling-mode-full-aspect)
[168.792920] Starting subtest: scaling-mode-full-aspect
[168.795061] Starting dynamic subtest: pipe-A-eDP-1
[168.889875] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.098s)
[168.898820] Starting dynamic subtest: pipe-B-eDP-1
[170.061850] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.171s)
[170.072746] Starting dynamic subtest: pipe-C-eDP-1
[171.280675] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.218s)
[171.289482] Starting dynamic subtest: pipe-D-eDP-1
[172.406910] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.124s)
[172.409707] Subtest scaling-mode-full-aspect: SUCCESS (3.616s)
[173.573759] [025/133] (845s left) kms_joiner (basic-ultra-joiner)
[173.651069] Starting subtest: basic-ultra-joiner
[173.656862] Subtest basic-ultra-joiner: SKIP (0.000s)
[173.716172] [026/133] (845s left) gem_exec_params (invalid-fence-in-submit)
[173.775063] Starting subtest: invalid-fence-in-submit
[173.777809] Subtest invalid-fence-in-submit: SUCCESS (0.002s)
[173.896302] [027/133] (845s left) gem_userptr_blits (dmabuf-sync)
[173.979100] Starting subtest: dmabuf-sync
[173.984016] Subtest dmabuf-sync: SKIP (0.002s)
[174.108762] [028/133] (845s left) gen9_exec_parse (bb-start-cmd)
[174.164015] Subtest bb-start-cmd: SKIP (0.000s)
[174.220256] [029/133] (845s left) kms_flip (wf_vblank-ts-check)
[174.288219] Starting subtest: wf_vblank-ts-check
[174.290997] Starting dynamic subtest: A-eDP1
[183.215979] Dynamic subtest A-eDP1: SUCCESS (8.930s)
[183.225848] Starting dynamic subtest: B-eDP1
[192.147020] Dynamic subtest B-eDP1: SUCCESS (8.931s)
[192.158502] Starting dynamic subtest: C-eDP1
[201.065140] Dynamic subtest C-eDP1: SUCCESS (8.916s)
[201.074692] Starting dynamic subtest: D-eDP1
[209.997846] Dynamic subtest D-eDP1: SUCCESS (8.931s)
[210.000567] Subtest wf_vblank-ts-check: SUCCESS (35.715s)
[211.228302] [030/133] (808s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[211.319204] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[212.322628] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.004s)
[212.445404] [031/133] (807s left) kms_big_fb (x-tiled-addfb)
[212.524836] Starting subtest: x-tiled-addfb
[212.526892] Subtest x-tiled-addfb: SUCCESS (0.000s)
[212.613315] [032/133] (806s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[212.695873] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[212.700198] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[212.784215] [033/133] (806s left) gem_tiled_blits (basic)
[212.837208] Subtest basic: SKIP (0.000s)
[212.910720] [034/133] (806s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[212.981900] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[212.992851] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.008s)
[213.065720] [035/133] (806s left) kms_atomic_transition (plane-toggle-modeset-transition)
[213.134243] Starting subtest: plane-toggle-modeset-transition
[213.136920] Starting dynamic subtest: pipe-A-eDP-1
[225.890136] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.755s)
[225.900484] Starting dynamic subtest: pipe-B-eDP-1
[238.303764] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.410s)
[238.306507] Subtest plane-toggle-modeset-transition: SUCCESS (25.170s)
[239.116700] [036/133] (780s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[239.196984] Starting subtest: primary-y-tiled-reflect-x-270
[239.202188] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[239.271143] [037/133] (780s left) api_intel_bb (lot-of-buffers)
[239.327661] Starting subtest: lot-of-buffers
[240.328484] Subtest lot-of-buffers: SUCCESS (1.000s)
[240.779016] [038/133] (778s left) i915_drm_fdinfo (most-busy-check-all)
[240.821328] Starting subtest: most-busy-check-all
[240.823663] Starting dynamic subtest: rcs0
[240.828507] Dynamic subtest rcs0: SKIP (0.005s)
[240.837987] Starting dynamic subtest: bcs0
[240.842836] Dynamic subtest bcs0: SKIP (0.000s)
[240.851386] Starting dynamic subtest: vcs0
[240.855930] Dynamic subtest vcs0: SKIP (0.000s)
[240.864008] Starting dynamic subtest: vcs1
[240.868113] Dynamic subtest vcs1: SKIP (0.000s)
[240.876136] Starting dynamic subtest: vecs0
[240.880543] Dynamic subtest vecs0: SKIP (0.000s)
[240.888403] Starting dynamic subtest: ccs0
[240.892628] Dynamic subtest ccs0: SKIP (0.000s)
[240.897011] Subtest most-busy-check-all: SKIP (0.008s)
[240.942592] [039/133] (778s left) kms_psr (psr2-dpms)
[241.041327] Starting subtest: psr2-dpms
[241.043828] Starting dynamic subtest: eDP-1
[243.953127] Dynamic subtest eDP-1: SUCCESS (2.913s)
[243.956175] Subtest psr2-dpms: SUCCESS (2.914s)
[244.832412] [040/133] (775s left) gem_ctx_persistence (engines-cleanup)
[244.884977] Starting subtest: engines-cleanup
[244.888009] Starting dynamic subtest: rcs0
[244.961182] Dynamic subtest rcs0: SUCCESS (0.076s)
[244.979870] Starting dynamic subtest: bcs0
[245.001489] Dynamic subtest bcs0: SUCCESS (0.039s)
[245.011722] Starting dynamic subtest: vcs0
[245.046839] Dynamic subtest vcs0: SUCCESS (0.044s)
[245.056700] Starting dynamic subtest: vcs1
[245.098870] Dynamic subtest vcs1: SUCCESS (0.050s)
[245.110961] Starting dynamic subtest: vecs0
[245.144683] Dynamic subtest vecs0: SUCCESS (0.045s)
[245.155801] Starting dynamic subtest: ccs0
[245.168633] Dynamic subtest ccs0: SUCCESS (0.023s)
[245.171399] Subtest engines-cleanup: SUCCESS (0.284s)
[245.292051] [041/133] (774s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[245.349073] Starting subtest: multi-wait-for-submit-submitted-signaled
[245.352045] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[245.451911] [042/133] (774s left) gem_lmem_swapping (smem-oom)
[245.498724] Subtest smem-oom: SKIP (0.000s)
[245.562406] [043/133] (774s left) gem_eio (hibernate)
[245.789335] Starting subtest: hibernate
[259.219082] Subtest hibernate: SUCCESS (13.432s)
[268.374057] [044/133] (760s left) gem_exec_schedule (pi-shared-iova)
[268.578250] Starting subtest: pi-shared-iova
[268.580842] Starting dynamic subtest: rcs0
[268.754670] Dynamic subtest rcs0: SUCCESS (0.178s)
[268.767612] Starting dynamic subtest: vcs0
[268.859906] Dynamic subtest vcs0: SUCCESS (0.105s)
[268.871869] Starting dynamic subtest: vcs1
[268.951193] Dynamic subtest vcs1: SUCCESS (0.091s)
[268.964230] Starting dynamic subtest: vecs0
[269.044826] Dynamic subtest vecs0: SUCCESS (0.093s)
[269.057617] Starting dynamic subtest: ccs0
[269.176966] Dynamic subtest ccs0: SUCCESS (0.131s)
[269.180208] Subtest pi-shared-iova: SUCCESS (0.600s)
[270.345162] [045/133] (758s left) kms_prime (basic-crc-vgem)
[270.412322] Starting subtest: basic-crc-vgem
[270.414697] Starting dynamic subtest: second-to-first
[271.462764] Dynamic subtest second-to-first: SUCCESS (1.056s)
[271.464938] Subtest basic-crc-vgem: SUCCESS (1.056s)
[271.557294] [046/133] (757s left) api_intel_bb (add-remove-objects)
[271.631905] Starting subtest: add-remove-objects
[271.636517] Subtest add-remove-objects: SUCCESS (0.007s)
[271.737645] [047/133] (757s left) kms_hdmi_inject (inject-audio)
[271.794189] Subtest inject-audio: SKIP (0.000s)
[271.851650] [048/133] (757s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[271.931794] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[271.936002] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[272.032395] [049/133] (757s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[272.103341] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[272.105259] Starting dynamic subtest: pipe-A-eDP-1
[272.125205] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[272.135874] Starting dynamic subtest: pipe-B-eDP-1
[272.154210] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[272.162825] Starting dynamic subtest: pipe-C-eDP-1
[272.181322] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[272.189593] Starting dynamic subtest: pipe-D-eDP-1
[272.207768] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[272.211448] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[274.377475] [050/133] (754s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[274.452192] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[274.455183] Starting dynamic subtest: pipe-A-default-mode
[277.212897] Dynamic subtest pipe-A-default-mode: SUCCESS (2.760s)
[277.215903] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.761s)
[278.068459] [051/133] (751s left) perf_pmu (busy-double-start)
[278.112264] Starting subtest: busy-double-start
[278.115054] Starting dynamic subtest: rcs0
[281.764654] Dynamic subtest rcs0: FAIL (3.583s)
[281.775831] Starting dynamic subtest: bcs0
[285.265724] Dynamic subtest bcs0: SUCCESS (3.571s)
[285.279512] Starting dynamic subtest: vcs0
[289.776293] Dynamic subtest vcs0: SUCCESS (4.509s)
[289.789475] Starting dynamic subtest: vcs1
[293.832459] Dynamic subtest vcs1: SUCCESS (4.054s)
[293.846206] Starting dynamic subtest: vecs0
[297.792548] Dynamic subtest vecs0: SUCCESS (3.958s)
[297.806385] Starting dynamic subtest: ccs0
[301.447030] Dynamic subtest ccs0: FAIL (3.567s)
[301.449589] Subtest busy-double-start: FAIL (23.250s)
[301.493714] [052/133] (727s left) gem_ctx_create (basic-files)
[301.551689] Starting subtest: basic-files
[303.559457] Subtest basic-files: SUCCESS (2.008s)
[305.313352] [053/133] (724s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[305.392033] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[305.397031] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[305.487729] [054/133] (724s left) syncobj_wait (single-wait-submitted)
[305.554213] Starting subtest: single-wait-submitted
[305.653656] Subtest single-wait-submitted: SUCCESS (0.102s)
[305.734736] [055/133] (723s left) gem_ctx_param (get-priority-new-ctx)
[305.791412] Starting subtest: get-priority-new-ctx
[305.794188] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[305.907799] [056/133] (723s left) i915_pm_freq_api (freq-basic-api)
[305.970995] Starting subtest: freq-basic-api
[305.973825] Starting dynamic subtest: gt0
[305.976392] Dynamic subtest gt0: SUCCESS (0.005s)
[305.987498] Starting dynamic subtest: gt1
[305.989779] Dynamic subtest gt1: SUCCESS (0.003s)
[305.991906] Subtest freq-basic-api: SUCCESS (0.010s)
[306.065692] [057/133] (723s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[306.146972] Starting subtest: pr-overlay-plane-update-continuous-sf
[306.152196] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[306.217395] [058/133] (723s left) kms_cursor_crc (cursor-alpha-transparent)
[306.284928] Starting subtest: cursor-alpha-transparent
[306.287254] Starting dynamic subtest: pipe-A-eDP-1
[306.900930] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.613s)
[306.912182] Starting dynamic subtest: pipe-D-eDP-1
[308.150105] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.249s)
[308.153036] Subtest cursor-alpha-transparent: SUCCESS (1.865s)
[309.033434] [059/133] (720s left) kms_cursor_crc (cursor-sliding-256x256)
[309.275673] Starting subtest: cursor-sliding-256x256
[309.281030] Starting dynamic subtest: pipe-A-eDP-1
[312.513099] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.234s)
[312.544238] Starting dynamic subtest: pipe-D-eDP-1
[316.436079] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.900s)
[316.439064] Subtest cursor-sliding-256x256: SUCCESS (7.159s)
[317.312457] [060/133] (712s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[317.408315] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[317.413684] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[317.504601] [061/133] (712s left) kms_atomic_interruptible (legacy-dpms)
[317.587721] Starting subtest: legacy-dpms
[317.590161] Starting dynamic subtest: pipe-A-eDP-1
[325.008830] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.420s)
[325.011329] Subtest legacy-dpms: SUCCESS (7.421s)
[325.822839] [062/133] (704s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[325.901200] Starting subtest: crc-primary-basic-yf-tiled-ccs
[325.903739] Starting dynamic subtest: pipe-A-eDP-1
[325.926902] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[325.937706] Starting dynamic subtest: pipe-B-eDP-1
[325.961873] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[325.971655] Starting dynamic subtest: pipe-C-eDP-1
[325.996678] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[326.006472] Starting dynamic subtest: pipe-D-eDP-1
[326.031590] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[326.036226] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.005s)
[328.111650] [063/133] (701s left) kms_pipe_crc_basic (suspend-read-crc)
[328.185689] Starting subtest: suspend-read-crc
[328.187938] Starting dynamic subtest: pipe-A-eDP-1
[345.545085] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.536s)
[345.555243] Starting dynamic subtest: pipe-B-eDP-1
[363.551399] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.135s)
[363.564827] Starting dynamic subtest: pipe-C-eDP-1
[381.506336] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.037s)
[381.517521] Starting dynamic subtest: pipe-D-eDP-1
[399.507307] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.089s)
[399.509652] Subtest suspend-read-crc: SUCCESS (11.802s)
[400.362733] [064/133] (629s left) gem_userptr_blits (map-fixed-invalidate-busy)
[400.441221] Starting subtest: map-fixed-invalidate-busy
[400.446485] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[400.570082] [065/133] (629s left) kms_lease (atomic-implicit-crtc)
[400.646977] Starting subtest: atomic-implicit-crtc
[400.649456] Starting dynamic subtest: pipe-A-eDP-1
[400.662177] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[400.680627] Starting dynamic subtest: pipe-B-eDP-1
[400.693468] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[400.703126] Starting dynamic subtest: pipe-C-eDP-1
[400.715163] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[400.725081] Starting dynamic subtest: pipe-D-eDP-1
[400.738121] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s)
[400.740417] Subtest atomic-implicit-crtc: SUCCESS (0.034s)
[400.784022] [066/133] (629s left) gem_bad_reloc (negative-reloc)
[400.841634] Subtest negative-reloc: SKIP (0.000s)
[400.913851] [067/133] (629s left) i915_suspend (debugfs-reader)
[400.975447] Starting subtest: debugfs-reader
[418.632874] Subtest debugfs-reader: SUCCESS (3.144s)
[418.711178] [068/133] (611s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[418.774242] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[418.873370] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.102s)
[418.964160] [069/133] (611s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[419.035116] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[419.037760] Starting dynamic subtest: pipe-A-eDP-1
[420.349089] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.311s)
[420.632005] Starting dynamic subtest: pipe-B-eDP-1
[421.674385] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.050s)
[421.943822] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.901s)
[422.787237] [070/133] (607s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[422.875891] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[422.881123] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[422.960995] [071/133] (607s left) kms_psr (fbc-pr-sprite-blt)
[423.035022] Starting subtest: fbc-pr-sprite-blt
[423.040442] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[423.105487] [072/133] (607s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[423.186435] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[423.191095] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[423.269442] [073/133] (607s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[423.355861] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[423.360334] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[423.458335] [074/133] (606s left) kms_cdclk (mode-transition-all-outputs)
[423.531856] Starting subtest: mode-transition-all-outputs
[423.818745] Subtest mode-transition-all-outputs: SKIP (0.285s)
[424.628399] [075/133] (605s left) kms_atomic_transition (plane-all-transition-fencing)
[424.705193] Starting subtest: plane-all-transition-fencing
[424.707640] Starting dynamic subtest: pipe-A-eDP-1
[427.205028] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.498s)
[427.520422] Starting dynamic subtest: pipe-B-eDP-1
[430.767587] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.256s)
[431.070518] Subtest plane-all-transition-fencing: SUCCESS (6.359s)
[431.891359] [076/133] (598s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[431.997011] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[438.975189] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (6.979s)
[439.091642] [077/133] (591s left) kms_cursor_crc (cursor-random-256x85)
[439.342538] Starting subtest: cursor-random-256x85
[439.386722] Subtest cursor-random-256x85: SKIP (0.039s)
[439.573301] [078/133] (590s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[439.654040] Starting subtest: drrs-dirtyfb-ioctl
[439.669117] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[439.748517] [079/133] (590s left) gem_exec_balancer (parallel)
[440.000018] Starting subtest: parallel
[440.922128] Subtest parallel: SUCCESS (0.922s)
[441.345562] [080/133] (589s left) syncobj_timeline (multi-wait-all-available-signaled)
[441.414143] Starting subtest: multi-wait-all-available-signaled
[441.416762] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s)
[441.513979] [081/133] (589s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[441.569027] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[441.573946] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[441.755645] [082/133] (588s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[441.839196] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[441.844091] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[441.924745] [083/133] (588s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[442.016055] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[442.021293] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[442.113580] [084/133] (588s left) perf (invalid-open-flags)
[442.218083] Starting subtest: invalid-open-flags
[442.221228] Subtest invalid-open-flags: SUCCESS (0.000s)
[442.269259] [085/133] (588s left) syncobj_wait (wait-for-submit-snapshot)
[442.327900] Starting subtest: wait-for-submit-snapshot
[442.408686] Subtest wait-for-submit-snapshot: SUCCESS (0.084s)
[442.487083] [086/133] (588s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[442.559525] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[442.561990] Starting dynamic subtest: pipe-A
[443.743048] Dynamic subtest pipe-A: SUCCESS (1.185s)
[443.753457] Starting dynamic subtest: pipe-B
[446.042650] Dynamic subtest pipe-B: SUCCESS (2.297s)
[446.053062] Starting dynamic subtest: pipe-C
[447.222824] Dynamic subtest pipe-C: SUCCESS (1.178s)
[447.233221] Starting dynamic subtest: pipe-D
[448.374739] Dynamic subtest pipe-D: SUCCESS (1.150s)
[448.377114] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.815s)
[449.574367] [087/133] (581s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[449.619835] Starting subtest: framebuffer-vs-set-tiling
[449.624883] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[449.737100] [088/133] (581s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[449.813597] Starting subtest: fbc-psr-sprite-mmap-cpu
[449.816017] Starting dynamic subtest: eDP-1
[449.820866] Dynamic subtest eDP-1: SKIP (0.000s)
[449.825516] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[449.890829] [089/133] (581s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[449.960361] Starting subtest: multi-wait-for-submit-submitted-signaled
[449.962990] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[450.063537] [090/133] (580s left) gen7_exec_parse (basic-allowed)
[450.121144] Subtest basic-allowed: SKIP (0.000s)
[450.188757] [091/133] (580s left) kms_psr (pr-dpms)
[450.264972] Starting subtest: pr-dpms
[450.270147] Subtest pr-dpms: SKIP (0.000s)
[450.343940] [092/133] (580s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[450.416193] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[454.321751] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (3.908s)
[455.466565] [093/133] (575s left) kms_async_flips (crc-atomic)
[455.538327] Starting subtest: crc-atomic
[455.913124] Starting dynamic subtest: pipe-A-eDP-1
[458.817943] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.902s)
[459.205072] Starting dynamic subtest: pipe-B-eDP-1
[462.132827] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.935s)
[462.524148] Starting dynamic subtest: pipe-C-eDP-1
[465.435993] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.925s)
[465.842018] Starting dynamic subtest: pipe-D-eDP-1
[468.672956] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.851s)
[468.675831] Subtest crc-atomic: SUCCESS (13.129s)
[469.845176] [094/133] (561s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[469.929737] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[469.934997] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[470.027921] [095/133] (561s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[470.101563] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[470.106683] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[470.193510] [096/133] (561s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[470.275957] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[477.292441] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.016s)
[477.394641] [097/133] (553s left) gem_flink_basic (bad-open)
[477.449008] Starting subtest: bad-open
[477.451806] Subtest bad-open: SUCCESS (0.000s)
[477.568593] [098/133] (553s left) kms_big_fb (linear-32bpp-rotate-180)
[477.671145] Starting subtest: linear-32bpp-rotate-180
[479.215007] Subtest linear-32bpp-rotate-180: SUCCESS (1.542s)
[479.386196] [099/133] (552s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[479.458734] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[479.462736] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[479.536316] [100/133] (551s left) prime_self_import (basic-with_one_bo_two_files)
[479.574808] Starting subtest: basic-with_one_bo_two_files
[479.588189] Subtest basic-with_one_bo_two_files: SUCCESS (0.014s)
[479.688639] [101/133] (551s left) gem_close (basic)
[479.743473] Starting subtest: basic
[479.745867] Subtest basic: SUCCESS (0.000s)
[479.836697] [102/133] (551s left) gem_spin_batch (engines)
[479.886844] Starting subtest: engines
[479.889188] Starting dynamic subtest: rcs0
[483.128233] Dynamic subtest rcs0: SUCCESS (3.234s)
[483.141452] Starting dynamic subtest: bcs0
[486.365876] Dynamic subtest bcs0: SUCCESS (3.233s)
[486.379234] Starting dynamic subtest: vcs0
[489.604019] Dynamic subtest vcs0: SUCCESS (3.233s)
[489.617011] Starting dynamic subtest: vcs1
[492.842768] Dynamic subtest vcs1: SUCCESS (3.235s)
[492.856044] Starting dynamic subtest: vecs0
[496.078574] Dynamic subtest vecs0: SUCCESS (3.231s)
[496.091277] Starting dynamic subtest: ccs0
[499.315593] Dynamic subtest ccs0: SUCCESS (3.233s)
[499.318145] Subtest engines: SUCCESS (19.416s)
[499.538749] [103/133] (532s left) gem_pxp (create-regular-buffer)
[499.682703] Starting subtest: create-regular-buffer
[499.685883] Subtest create-regular-buffer: SUCCESS (0.000s)
[499.788577] [104/133] (531s left) kms_pm_rpm (basic-rte)
[499.829211] Starting subtest: basic-rte
[502.863983] Subtest basic-rte: SUCCESS (3.039s)
[504.377710] [105/133] (527s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[504.467239] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[508.156242] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.693s)
[509.355629] [106/133] (522s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[509.445137] Starting subtest: yf-tiled-64bpp-rotate-180
[509.450978] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[509.540652] [107/133] (522s left) i915_pm_rpm (gem-pread)
[511.444587] Starting subtest: gem-pread
[513.156560] Subtest gem-pread: SUCCESS (1.710s)
[513.246381] [108/133] (518s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[513.325126] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[513.330243] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[513.425004] [109/133] (518s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[513.495216] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[520.195744] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.711s)
[520.313354] [110/133] (511s left) gem_render_copy (y-tiled-ccs-to-linear)
[520.362005] Starting subtest: y-tiled-ccs-to-linear
[520.367902] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[520.548841] [111/133] (511s left) syncobj_timeline (32bits-limit)
[520.608085] Starting subtest: 32bits-limit
[520.610860] Subtest 32bits-limit: SUCCESS (0.001s)
[520.718353] [112/133] (511s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[520.797938] Starting subtest: fbc-pr-cursor-plane-update-sf
[520.803142] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[520.862406] [113/133] (511s left) gem_exec_fence (syncobj-import)
[521.300201] Starting subtest: syncobj-import
[521.306680] Subtest syncobj-import: SUCCESS (0.005s)
[522.401256] [114/133] (509s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[522.777637] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[523.634955] [115/133] (508s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[523.692153] Starting subtest: single-wait-for-submit-available-submitted
[523.694629] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[523.778480] [116/133] (508s left) gem_exec_balancer (sliced)
[523.836149] Starting subtest: sliced
[523.842122] Subtest sliced: SKIP (0.000s)
[524.138122] [117/133] (508s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[524.213972] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[524.222592] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.007s)
[524.300705] [118/133] (507s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[524.371843] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[524.374244] Starting dynamic subtest: pipe-A-eDP-1
[524.395852] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[524.407896] Starting dynamic subtest: pipe-B-eDP-1
[524.429994] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[524.440034] Starting dynamic subtest: pipe-C-eDP-1
[524.462934] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[524.472871] Starting dynamic subtest: pipe-D-eDP-1
[524.495428] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[524.497963] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[526.529969] [119/133] (505s left) kms_plane (pixel-format-4-tiled-modifier)
[526.603553] Starting subtest: pixel-format-4-tiled-modifier
[526.632038] Starting dynamic subtest: pipe-A-plane-0
[527.320752] Dynamic subtest pipe-A-plane-0: SUCCESS (0.689s)
[527.331696] Starting dynamic subtest: pipe-A-plane-3
[527.798870] Dynamic subtest pipe-A-plane-3: SUCCESS (0.476s)
[527.808589] Starting dynamic subtest: pipe-A-plane-5
[527.812579] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[528.920257] Starting dynamic subtest: pipe-B-plane-0
[529.622219] Dynamic subtest pipe-B-plane-0: SUCCESS (0.711s)
[529.632974] Starting dynamic subtest: pipe-B-plane-3
[530.100696] Dynamic subtest pipe-B-plane-3: SUCCESS (0.478s)
[530.111119] Starting dynamic subtest: pipe-B-plane-5
[530.115641] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[530.412125] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.811s)
[531.285565] [120/133] (501s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[531.368119] Starting subtest: plane-lut1d-post-ctm3x4
[531.513422] Starting dynamic subtest: pipe-A-plane-0
[531.875781] Dynamic subtest pipe-A-plane-0: FAIL (0.153s)
[531.888752] Starting dynamic subtest: pipe-A-plane-1
[532.151793] Dynamic subtest pipe-A-plane-1: FAIL (0.165s)
[532.167873] Starting dynamic subtest: pipe-A-plane-2
[532.414521] Dynamic subtest pipe-A-plane-2: FAIL (0.165s)
[533.181993] Starting dynamic subtest: pipe-B-plane-0
[533.650258] Dynamic subtest pipe-B-plane-0: FAIL (0.152s)
[533.661055] Starting dynamic subtest: pipe-B-plane-1
[534.027868] Dynamic subtest pipe-B-plane-1: FAIL (0.177s)
[534.038426] Starting dynamic subtest: pipe-B-plane-2
[534.378795] Dynamic subtest pipe-B-plane-2: FAIL (0.685s)
[535.416858] Starting dynamic subtest: pipe-C-plane-0
[535.967144] Dynamic subtest pipe-C-plane-0: FAIL (0.139s)
[535.980007] Starting dynamic subtest: pipe-C-plane-1
[536.433082] Dynamic subtest pipe-C-plane-1: FAIL (0.707s)
[536.445017] Starting dynamic subtest: pipe-C-plane-2
[536.896236] Dynamic subtest pipe-C-plane-2: FAIL (0.160s)
[537.634807] Starting dynamic subtest: pipe-D-plane-0
[538.307111] Dynamic subtest pipe-D-plane-0: FAIL (0.140s)
[538.319066] Starting dynamic subtest: pipe-D-plane-1
[538.830190] Dynamic subtest pipe-D-plane-1: FAIL (0.704s)
[538.842678] Starting dynamic subtest: pipe-D-plane-2
[539.365002] Dynamic subtest pipe-D-plane-2: FAIL (0.633s)
[539.408055] Subtest plane-lut1d-post-ctm3x4: FAIL (8.045s)
[540.202899] [121/133] (492s left) kms_universal_plane (universal-plane-functional)
[540.285142] Starting subtest: universal-plane-functional
[540.287570] Starting dynamic subtest: pipe-A-eDP-1
[544.264502] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.978s)
[544.276056] Starting dynamic subtest: pipe-B-eDP-1
[548.741052] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.479s)
[548.753109] Starting dynamic subtest: pipe-C-eDP-1
[553.080898] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.335s)
[553.092108] Starting dynamic subtest: pipe-D-eDP-1
[557.404177] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.325s)
[557.406857] Subtest universal-plane-functional: SUCCESS (17.122s)
[558.259420] [122/133] (474s left) kms_feature_discovery (display)
[558.342149] Starting subtest: display
[558.344789] Subtest display: SUCCESS (0.000s)
[558.415024] [123/133] (474s left) kms_async_flips (async-flip-suspend-resume)
[558.488036] Starting subtest: async-flip-suspend-resume
[558.864748] Starting dynamic subtest: pipe-A-eDP-1
[576.638787] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.909s)
[577.006514] Starting dynamic subtest: pipe-B-eDP-1
[594.645021] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.937s)
[595.032789] Starting dynamic subtest: pipe-C-eDP-1
[612.650937] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.901s)
[613.020344] Starting dynamic subtest: pipe-D-eDP-1
[630.654340] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.929s)
[630.656748] Subtest async-flip-suspend-resume: SUCCESS (13.161s)
[631.832278] [124/133] (400s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[631.914753] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[631.919732] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[632.012997] [125/133] (400s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[632.089546] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[639.018372] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.923s)
[639.167695] [126/133] (393s left) gem_create (create-ext-placement-all)
[639.336116] Starting subtest: create-ext-placement-all
[639.339202] Subtest create-ext-placement-all: SUCCESS (0.000s)
[639.439498] [127/133] (393s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[639.526474] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[646.391807] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.867s)
[646.509491] [128/133] (386s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[646.570242] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[646.676613] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.108s)
[646.757103] [129/133] (385s left) gem_mmap_gtt (isolation)
[646.806704] Subtest isolation: SKIP (0.000s)
[646.866941] [130/133] (385s left) perf_pmu (init-busy)
[646.910403] Starting subtest: init-busy
[646.913275] Starting dynamic subtest: rcs0
[646.916070] Dynamic subtest rcs0: SUCCESS (0.001s)
[646.930226] Starting dynamic subtest: bcs0
[646.932411] Dynamic subtest bcs0: SUCCESS (0.001s)
[646.942540] Starting dynamic subtest: vcs0
[646.944936] Dynamic subtest vcs0: SUCCESS (0.001s)
[646.954911] Starting dynamic subtest: vcs1
[646.956851] Dynamic subtest vcs1: SUCCESS (0.001s)
[646.966913] Starting dynamic subtest: vecs0
[646.969089] Dynamic subtest vecs0: SUCCESS (0.001s)
[646.978752] Starting dynamic subtest: ccs0
[646.980902] Dynamic subtest ccs0: SUCCESS (0.001s)
[646.983250] Subtest init-busy: SUCCESS (0.008s)
[647.025179] [131/133] (385s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[647.109965] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[647.114524] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[647.199958] [132/133] (385s left) prime_vgem (fence-wait)
[647.275969] Starting subtest: fence-wait
[647.278615] Starting dynamic subtest: rcs0
[648.322921] Dynamic subtest rcs0: SUCCESS (1.045s)
[648.336001] Starting dynamic subtest: bcs0
[649.378339] Dynamic subtest bcs0: SUCCESS (1.054s)
[649.391724] Starting dynamic subtest: vcs0
[650.420714] Dynamic subtest vcs0: SUCCESS (1.040s)
[650.433703] Starting dynamic subtest: vcs1
[651.463235] Dynamic subtest vcs1: SUCCESS (1.040s)
[651.477388] Starting dynamic subtest: vecs0
[652.505480] Dynamic subtest vecs0: SUCCESS (1.039s)
[652.519965] Starting dynamic subtest: ccs0
[653.549695] Dynamic subtest ccs0: SUCCESS (1.041s)
[653.552648] Subtest fence-wait: SUCCESS (6.270s)
[653.665755] [133/133] (379s left) kms_plane_scaling (planes-downscale-factor-0-75)
[653.762748] Starting subtest: planes-downscale-factor-0-75
[653.765556] Starting dynamic subtest: pipe-A
[653.782832] Dynamic subtest pipe-A: SKIP (0.017s)
[653.793700] Starting dynamic subtest: pipe-B
[653.814405] Dynamic subtest pipe-B: SKIP (0.029s)
[653.824872] Starting dynamic subtest: pipe-C
[653.842477] Dynamic subtest pipe-C: SKIP (0.029s)
[653.852629] Starting dynamic subtest: pipe-D
[653.872470] Dynamic subtest pipe-D: SKIP (0.029s)
[653.877464] Subtest planes-downscale-factor-0-75: SKIP (0.106s)
[653.972324] Closing watchdogs
results: parsing output: 0/ for test: core_sysfs
results: parsing output: 1/ for test: kms_chamelium_edid
results: parsing output: 2/ for test: perf
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: gem_ctx_shared
results: parsing output: 5/ for test: kms_plane_multiple
results: parsing output: 6/ for test: gem_exec_reloc
results: parsing output: 7/ for test: gem_render_copy
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_lmem_swapping
results: parsing output: 11/ for test: gem_exec_params
results: parsing output: 12/ for test: kms_fbcon_fbt
results: parsing output: 13/ for test: gem_exec_schedule
results: parsing output: 14/ for test: gem_ctx_persistence
results: parsing output: 15/ for test: sysfs_preempt_timeout
results: parsing output: 16/ for test: kms_flip
results: parsing output: 17/ for test: gem_set_tiling_vs_blt
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_vrr
results: parsing output: 20/ for test: kms_content_protection
results: parsing output: 21/ for test: gem_exec_schedule
results: parsing output: 22/ for test: kms_addfb_basic
results: parsing output: 23/ for test: kms_scaling_modes
results: parsing output: 24/ for test: kms_joiner
results: parsing output: 25/ for test: gem_exec_params
results: parsing output: 26/ for test: gem_userptr_blits
results: parsing output: 27/ for test: gen9_exec_parse
results: parsing output: 28/ for test: kms_flip
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_tiled_blits
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: kms_atomic_transition
results: parsing output: 35/ for test: kms_rotation_crc
results: parsing output: 36/ for test: api_intel_bb
results: parsing output: 37/ for test: i915_drm_fdinfo
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: gem_ctx_persistence
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: gem_lmem_swapping
results: parsing output: 42/ for test: gem_eio
results: parsing output: 43/ for test: gem_exec_schedule
results: parsing output: 44/ for test: kms_prime
results: parsing output: 45/ for test: api_intel_bb
results: parsing output: 46/ for test: kms_hdmi_inject
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: kms_flip_scaled_crc
results: parsing output: 50/ for test: perf_pmu
results: parsing output: 51/ for test: gem_ctx_create
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: syncobj_wait
results: parsing output: 54/ for test: gem_ctx_param
results: parsing output: 55/ for test: i915_pm_freq_api
results: parsing output: 56/ for test: kms_psr2_sf
results: parsing output: 57/ for test: kms_cursor_crc
results: parsing output: 58/ for test: kms_cursor_crc
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_atomic_interruptible
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: kms_pipe_crc_basic
results: parsing output: 63/ for test: gem_userptr_blits
results: parsing output: 64/ for test: kms_lease
results: parsing output: 65/ for test: gem_bad_reloc
results: parsing output: 66/ for test: i915_suspend
results: parsing output: 67/ for test: syncobj_wait
results: parsing output: 68/ for test: kms_atomic_transition
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_cdclk
results: parsing output: 74/ for test: kms_atomic_transition
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_cursor_crc
results: parsing output: 77/ for test: kms_dirtyfb
results: parsing output: 78/ for test: gem_exec_balancer
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: gem_render_copy
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: perf
results: parsing output: 84/ for test: syncobj_wait
results: parsing output: 85/ for test: kms_plane_scaling
results: parsing output: 86/ for test: kms_addfb_basic
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: syncobj_wait
results: parsing output: 89/ for test: gen7_exec_parse
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_async_flips
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_flink_basic
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_flip_scaled_crc
results: parsing output: 99/ for test: prime_self_import
results: parsing output: 100/ for test: gem_close
results: parsing output: 101/ for test: gem_spin_batch
results: parsing output: 102/ for test: gem_pxp
results: parsing output: 103/ for test: kms_pm_rpm
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: i915_pm_rpm
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_render_copy
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: kms_psr2_sf
results: parsing output: 112/ for test: gem_exec_fence
results: parsing output: 113/ for test: kms_chamelium_hpd
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: gem_exec_balancer
results: parsing output: 116/ for test: kms_flip
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: kms_plane
results: parsing output: 119/ for test: kms_color_pipeline
results: parsing output: 120/ for test: kms_universal_plane
results: parsing output: 121/ for test: kms_feature_discovery
results: parsing output: 122/ for test: kms_async_flips
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_create
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: syncobj_timeline
results: parsing output: 128/ for test: gem_mmap_gtt
results: parsing output: 129/ for test: perf_pmu
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: prime_vgem
results: parsing output: 132/ for test: kms_plane_scaling
Done.