[56.054611] Initializing watchdogs
[56.054696]   /dev/watchdog0
[56.072549] [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]
[56.077196] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.079586] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.083136] [001/131] (960s left) gen9_exec_parse (bb-start-far)
[56.169120] Subtest bb-start-far: SKIP (0.000s)
[56.223800] [002/131] (960s left) kms_chamelium_edid (hdmi-edid-stress-resolution-4k)
[56.610608] Subtest hdmi-edid-stress-resolution-4k: SKIP (0.000s)
[57.379623] [003/131] (959s left) gem_exec_fence (syncobj-import)
[57.800090] Starting subtest: syncobj-import
[57.805890] Subtest syncobj-import: SUCCESS (0.005s)
[59.015497] [FACT gem_exec_fence (syncobj-import)] new: kernel.kmod_is_loaded.vgem: true
[59.018708] [004/131] (957s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[59.131654] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[59.136073] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[59.240758] [005/131] (957s left) gem_exec_fence (syncobj-repeat)
[59.639527] Starting subtest: syncobj-repeat
[59.814899] Subtest syncobj-repeat: SUCCESS (0.175s)
[60.963439] [006/131] (955s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[61.057967] Starting subtest: plane-upscale-20x20-with-modifiers
[61.060276] Starting dynamic subtest: pipe-A
[61.396092] Dynamic subtest pipe-A: SUCCESS (0.339s)
[61.404465] Starting dynamic subtest: pipe-B
[62.765447] Dynamic subtest pipe-B: SUCCESS (1.374s)
[62.772275] Starting dynamic subtest: pipe-C
[64.180655] Dynamic subtest pipe-C: SUCCESS (1.419s)
[64.188202] Starting dynamic subtest: pipe-D
[65.607509] Dynamic subtest pipe-D: SUCCESS (1.430s)
[65.609806] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.563s)
[66.762233] [007/131] (950s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[66.883148] Starting subtest: cursorB-vs-flipA-toggle
[66.887704] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[67.016177] [008/131] (949s left) kms_joiner (basic-force-ultra-joiner)
[67.123521] Starting subtest: basic-force-ultra-joiner
[67.127624] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[67.183550] [009/131] (949s left) gem_ctx_exec (basic)
[67.242038] Starting subtest: basic
[67.249465] Subtest basic: SUCCESS (0.009s)
[67.360612] [010/131] (949s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[67.407069] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[67.512692] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[67.583607] [011/131] (949s left) kms_addfb_basic (unused-offsets)
[67.634507] Starting subtest: unused-offsets
[67.636833] Subtest unused-offsets: SUCCESS (0.000s)
[67.783282] [012/131] (949s left) gem_pread (self)
[67.840880] Subtest self: SKIP (0.000s)
[67.909615] [013/131] (949s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[68.016984] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[68.021256] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[68.133216] [014/131] (948s left) kms_properties (connector-properties-atomic)
[68.236858] Starting subtest: connector-properties-atomic
[68.239157] Starting dynamic subtest: pipe-A-eDP-1
[75.971561] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.740s)
[75.980738] Starting dynamic subtest: pipe-None-DP-1
[75.985234] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[75.991998] Starting dynamic subtest: pipe-None-HDMI-A-1
[75.996605] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[76.003855] Starting dynamic subtest: pipe-None-DP-2
[76.007885] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[76.014159] Starting dynamic subtest: pipe-None-HDMI-A-2
[76.018266] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[76.024590] Starting dynamic subtest: pipe-None-DP-3
[76.028736] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[76.034787] Starting dynamic subtest: pipe-None-DP-4
[76.038755] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[76.040635] Subtest connector-properties-atomic: SUCCESS (7.748s)
[76.830885] [015/131] (940s left) gem_mmap (basic-small-bo)
[76.882204] Subtest basic-small-bo: SKIP (0.000s)
[76.936519] [016/131] (940s left) kms_pm_rpm (basic-rte)
[76.965519] Starting subtest: basic-rte
[80.542078] Subtest basic-rte: SUCCESS (3.577s)
[82.027533] [017/131] (935s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[82.089075] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[82.161165] [018/131] (935s left) gem_ctx_param (invalid-ctx-set)
[82.209544] Starting subtest: invalid-ctx-set
[82.211844] Subtest invalid-ctx-set: SUCCESS (0.001s)
[82.307688] [019/131] (934s left) kms_plane_cursor (primary)
[82.403041] Starting subtest: primary
[82.407212] Starting dynamic subtest: pipe-A-eDP-1-size-64
[85.252089] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.848s)
[85.272826] Starting dynamic subtest: pipe-A-eDP-1-size-128
[88.040532] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.771s)
[88.064057] Starting dynamic subtest: pipe-A-eDP-1-size-256
[90.832485] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.773s)
[91.142843] Starting dynamic subtest: pipe-B-eDP-1-size-64
[94.599531] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.464s)
[94.623518] Starting dynamic subtest: pipe-B-eDP-1-size-128
[97.511668] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.893s)
[97.536394] Starting dynamic subtest: pipe-B-eDP-1-size-256
[100.324188] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.793s)
[100.641090] Starting dynamic subtest: pipe-C-eDP-1-size-64
[103.783765] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.151s)
[103.809773] Starting dynamic subtest: pipe-C-eDP-1-size-128
[106.273517] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.469s)
[106.297912] Starting dynamic subtest: pipe-C-eDP-1-size-256
[108.685147] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.391s)
[109.007352] Starting dynamic subtest: pipe-D-eDP-1-size-64
[112.119679] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.119s)
[112.144716] Starting dynamic subtest: pipe-D-eDP-1-size-128
[114.541088] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.402s)
[114.566344] Starting dynamic subtest: pipe-D-eDP-1-size-256
[117.029853] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.468s)
[117.338348] Subtest primary: SUCCESS (34.933s)
[118.114497] [020/131] (899s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[118.233127] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[124.869146] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.643s)
[125.012571] [021/131] (892s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[125.113077] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[126.381053] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (1.270s)
[126.665702] [022/131] (890s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[126.780498] Starting subtest: cursor-vs-flip-varying-size
[157.760668] Subtest cursor-vs-flip-varying-size: SUCCESS (30.977s)
[158.131116] [023/131] (859s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[158.244774] Starting subtest: psr-2p-primscrn-cur-indfb-move
[158.249076] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[158.357212] [024/131] (859s left) gem_spin_batch (resubmit-new-all)
[158.413837] Starting subtest: resubmit-new-all
[158.416074] Starting dynamic subtest: rcs0
[158.428746] Dynamic subtest rcs0: SUCCESS (0.015s)
[158.437075] Starting dynamic subtest: bcs0
[158.441980] Dynamic subtest bcs0: SUCCESS (0.010s)
[158.450464] Starting dynamic subtest: vcs0
[158.452356] Dynamic subtest vcs0: SUCCESS (0.008s)
[158.459953] Starting dynamic subtest: vcs1
[158.462242] Dynamic subtest vcs1: SUCCESS (0.009s)
[158.471032] Starting dynamic subtest: vecs0
[158.473383] Dynamic subtest vecs0: SUCCESS (0.010s)
[158.480764] Starting dynamic subtest: ccs0
[158.482929] Dynamic subtest ccs0: SUCCESS (0.010s)
[158.484783] Subtest resubmit-new-all: SUCCESS (0.066s)
[159.931361] [025/131] (857s left) i915_suspend (basic-s2idle-without-i915)
[159.967284] Starting subtest: basic-s2idle-without-i915
[180.999631] Subtest basic-s2idle-without-i915: SUCCESS (5.798s)
[181.117684] [026/131] (836s left) kms_psr (fbc-psr-suspend)
[181.227713] Starting subtest: fbc-psr-suspend
[181.229947] Starting dynamic subtest: eDP-1
[181.234430] Dynamic subtest eDP-1: SKIP (0.000s)
[181.238812] Subtest fbc-psr-suspend: SKIP (0.001s)
[181.298730] [027/131] (836s left) prime_mmap (test_map_unmap)
[181.344060] Starting subtest: test_map_unmap
[181.346312] Starting dynamic subtest: test_map_unmap-smem
[181.371909] Dynamic subtest test_map_unmap-smem: SUCCESS (0.030s)
[181.374336] Subtest test_map_unmap: SUCCESS (0.031s)
[181.466442] [028/131] (836s left) syncobj_wait (multi-wait-signaled)
[181.512528] Starting subtest: multi-wait-signaled
[181.514695] Subtest multi-wait-signaled: SUCCESS (0.000s)
[181.610426] [029/131] (836s left) gem_ctx_param (basic)
[181.657599] Starting subtest: basic
[181.662798] Subtest basic: SUCCESS (0.003s)
[181.760217] [030/131] (835s left) gem_unfence_active_buffers
[181.925414] [031/131] (835s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-blt)
[182.016621] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-blt
[188.770111] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-blt: SUCCESS (6.816s)
[188.904548] [032/131] (828s left) prime_mmap (test_userptr)
[188.960337] Starting subtest: test_userptr
[188.962859] Starting dynamic subtest: test_userptr-smem
[188.964932] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[188.967007] Subtest test_userptr: SUCCESS (0.001s)
[189.077529] [033/131] (828s left) kms_lease (atomic-implicit-crtc)
[189.171721] Starting subtest: atomic-implicit-crtc
[189.174019] Starting dynamic subtest: pipe-A-eDP-1
[189.185322] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[189.194021] Starting dynamic subtest: pipe-B-eDP-1
[189.205438] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.008s)
[189.214373] Starting dynamic subtest: pipe-C-eDP-1
[189.224859] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.008s)
[189.232025] Starting dynamic subtest: pipe-D-eDP-1
[189.242387] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.008s)
[189.244220] Subtest atomic-implicit-crtc: SUCCESS (0.029s)
[189.307833] [034/131] (828s left) kms_psr (fbc-pr-dpms)
[189.404846] Starting subtest: fbc-pr-dpms
[189.409170] Subtest fbc-pr-dpms: SKIP (0.000s)
[189.475775] [035/131] (828s left) gem_exec_reloc (basic-cpu-read-active)
[189.539344] Subtest basic-cpu-read-active: SKIP (0.000s)
[189.597810] [036/131] (828s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[189.692378] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[189.696505] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[189.799198] [037/131] (828s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[189.892116] Starting subtest: x-tiled-16bpp-rotate-90
[189.911677] Subtest x-tiled-16bpp-rotate-90: SKIP (0.019s)
[190.031913] [038/131] (827s left) i915_drm_fdinfo (most-busy-check-all)
[190.068111] Starting subtest: most-busy-check-all
[190.069853] Starting dynamic subtest: rcs0
[190.075600] Dynamic subtest rcs0: SKIP (0.004s)
[190.083250] Starting dynamic subtest: bcs0
[190.086832] Dynamic subtest bcs0: SKIP (0.000s)
[190.094177] Starting dynamic subtest: vcs0
[190.097514] Dynamic subtest vcs0: SKIP (0.001s)
[190.104696] Starting dynamic subtest: vcs1
[190.108102] Dynamic subtest vcs1: SKIP (0.000s)
[190.115357] Starting dynamic subtest: vecs0
[190.119140] Dynamic subtest vecs0: SKIP (0.000s)
[190.127099] Starting dynamic subtest: ccs0
[190.130488] Dynamic subtest ccs0: SKIP (0.000s)
[190.134112] Subtest most-busy-check-all: SKIP (0.009s)
[190.167980] [039/131] (827s left) gem_ctx_sseu (mmap-args)
[190.227830] Subtest mmap-args: SKIP (0.000s)
[190.296720] [040/131] (827s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[190.406701] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[190.410368] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[190.515242] [041/131] (827s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[190.612111] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[190.615756] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[190.720289] [042/131] (827s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[190.810553] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[190.812658] Starting dynamic subtest: pipe-A-eDP-1
[190.832617] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[190.842092] Starting dynamic subtest: pipe-B-eDP-1
[190.860289] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[190.867907] Starting dynamic subtest: pipe-C-eDP-1
[190.886150] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[190.893984] Starting dynamic subtest: pipe-D-eDP-1
[190.912062] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[190.915644] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[192.967521] [043/131] (825s left) kms_draw_crc (draw-method-render)
[193.073487] Starting subtest: draw-method-render
[193.075800] Starting dynamic subtest: xrgb8888-untiled
[193.333176] Dynamic subtest xrgb8888-untiled: SUCCESS (0.262s)
[193.341517] Starting dynamic subtest: rgb565-untiled
[193.564958] Dynamic subtest rgb565-untiled: SUCCESS (0.233s)
[193.573583] Starting dynamic subtest: xrgb2101010-untiled
[193.764331] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.200s)
[193.772665] Starting dynamic subtest: xbgr16161616f-untiled
[194.007714] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.244s)
[194.015990] Starting dynamic subtest: xrgb8888-xtiled
[194.141131] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s)
[194.150483] Starting dynamic subtest: rgb565-xtiled
[194.251481] Dynamic subtest rgb565-xtiled: SUCCESS (0.109s)
[194.259686] Starting dynamic subtest: xrgb2101010-xtiled
[194.362967] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s)
[194.370632] Starting dynamic subtest: xbgr16161616f-xtiled
[194.507310] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.144s)
[194.514905] Starting dynamic subtest: xrgb8888-4tiled
[194.639248] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s)
[194.647771] Starting dynamic subtest: rgb565-4tiled
[194.760825] Dynamic subtest rgb565-4tiled: SUCCESS (0.122s)
[194.768512] Starting dynamic subtest: xrgb2101010-4tiled
[194.883064] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.122s)
[194.893729] Starting dynamic subtest: xbgr16161616f-4tiled
[195.026974] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s)
[195.028814] Subtest draw-method-render: SUCCESS (1.962s)
[195.117796] [044/131] (823s left) kms_setmode (basic)
[195.168193] Starting subtest: basic
[195.507545] Starting dynamic subtest: pipe-A-eDP-1
[197.683999] Dynamic subtest pipe-A-eDP-1: FAIL (2.077s)
[197.929214] Starting dynamic subtest: pipe-B-eDP-1
[200.091739] Dynamic subtest pipe-B-eDP-1: FAIL (2.060s)
[200.281891] Subtest basic: FAIL (5.123s)
[201.106910] [045/131] (817s left) syncobj_timeline (single-wait-all-available-signaled)
[201.163659] Starting subtest: single-wait-all-available-signaled
[201.165995] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[201.269095] [046/131] (817s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[201.330343] Starting subtest: y-tiled-to-vebox-yf-tiled
[201.335052] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[201.509744] [047/131] (816s left) syncobj_basic (bad-fd-to-handle)
[201.567039] Starting subtest: bad-fd-to-handle
[201.569649] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[201.671720] [048/131] (816s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[201.764812] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[208.196731] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.443s)
[208.341541] [049/131] (810s left) gem_exec_schedule (preempt-contexts)
[208.415496] Starting subtest: preempt-contexts
[208.417591] Starting dynamic subtest: rcs0
[208.466358] Dynamic subtest rcs0: SUCCESS (0.059s)
[208.474814] Starting dynamic subtest: bcs0
[208.518330] Dynamic subtest bcs0: SUCCESS (0.052s)
[208.526911] Starting dynamic subtest: vcs0
[208.566046] Dynamic subtest vcs0: SUCCESS (0.047s)
[208.574539] Starting dynamic subtest: vcs1
[208.611925] Dynamic subtest vcs1: SUCCESS (0.045s)
[208.620224] Starting dynamic subtest: vecs0
[208.654748] Dynamic subtest vecs0: SUCCESS (0.042s)
[208.664794] Starting dynamic subtest: ccs0
[208.702866] Dynamic subtest ccs0: SUCCESS (0.048s)
[208.705198] Subtest preempt-contexts: SUCCESS (0.296s)
[210.244147] [050/131] (808s left) prime_busy (after)
[210.307095] Starting subtest: after
[210.311846] Starting dynamic subtest: rcs0
[210.346908] Dynamic subtest rcs0: SUCCESS (0.036s)
[210.356401] Starting dynamic subtest: bcs0
[210.415108] Dynamic subtest bcs0: SUCCESS (0.067s)
[210.425164] Starting dynamic subtest: vcs0
[210.454990] Dynamic subtest vcs0: SUCCESS (0.040s)
[210.462966] Starting dynamic subtest: vcs1
[210.494894] Dynamic subtest vcs1: SUCCESS (0.038s)
[210.502659] Starting dynamic subtest: vecs0
[210.533472] Dynamic subtest vecs0: SUCCESS (0.038s)
[210.541142] Starting dynamic subtest: ccs0
[210.570881] Dynamic subtest ccs0: SUCCESS (0.037s)
[210.678884] Subtest after: SUCCESS (0.370s)
[210.747440] [051/131] (807s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[210.855009] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[214.456687] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.605s)
[215.593962] [052/131] (802s left) kms_flip (busy-flip)
[215.702995] Starting subtest: busy-flip
[215.705483] Starting dynamic subtest: A-eDP1
[217.402627] Dynamic subtest A-eDP1: SUCCESS (1.698s)
[217.413168] Starting dynamic subtest: B-eDP1
[219.127111] Dynamic subtest B-eDP1: SUCCESS (1.723s)
[219.135360] Starting dynamic subtest: C-eDP1
[220.843998] Dynamic subtest C-eDP1: SUCCESS (1.716s)
[220.853333] Starting dynamic subtest: D-eDP1
[222.562744] Dynamic subtest D-eDP1: SUCCESS (1.718s)
[222.565226] Subtest busy-flip: SUCCESS (6.863s)
[223.816185] [053/131] (794s left) gen7_exec_parse (chained-batch)
[223.877891] Subtest chained-batch: SKIP (0.000s)
[223.958043] [054/131] (794s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[224.060857] Starting subtest: psr-indfb-scaledprimary
[229.724762] Subtest psr-indfb-scaledprimary: SUCCESS (5.668s)
[229.857955] [055/131] (788s left) kms_big_fb (x-tiled-addfb-size-overflow)
[229.970700] Starting subtest: x-tiled-addfb-size-overflow
[229.972914] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[230.080794] [056/131] (788s left) kms_dsc (dsc-with-formats)
[230.184544] Starting subtest: dsc-with-formats
[230.225036] Subtest dsc-with-formats: SKIP (0.001s)
[230.261183] [057/131] (788s left) gem_exec_suspend (basic-s3-devices)
[230.312452] Starting subtest: basic-S3-devices
[230.314837] Starting dynamic subtest: smem
[241.111658] Dynamic subtest smem: SUCCESS (10.800s)
[241.114224] Subtest basic-S3-devices: SUCCESS (10.801s)
[241.288870] [058/131] (777s left) kms_psr (psr2-dpms)
[241.391315] Starting subtest: psr2-dpms
[241.393597] Starting dynamic subtest: eDP-1
[244.279640] Dynamic subtest eDP-1: SUCCESS (2.890s)
[244.282126] Subtest psr2-dpms: SUCCESS (2.891s)
[245.136745] [059/131] (773s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[245.189566] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[245.191817] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[245.283680] [060/131] (773s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[245.382018] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[245.384341] Starting dynamic subtest: pipe-A-default-mode
[245.676567] Dynamic subtest pipe-A-default-mode: SKIP (0.289s)
[245.681165] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.291s)
[246.457897] [061/131] (772s left) drm_read (short-buffer-wakeup)
[246.638136] Starting subtest: short-buffer-wakeup
[278.846858] Subtest short-buffer-wakeup: SUCCESS (32.216s)
[278.998286] [062/131] (739s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[279.091738] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[279.094006] Starting dynamic subtest: pipe-A-eDP-1
[279.116778] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[279.127826] Starting dynamic subtest: pipe-B-eDP-1
[279.148760] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[279.157273] Starting dynamic subtest: pipe-C-eDP-1
[279.179214] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[279.189257] Starting dynamic subtest: pipe-D-eDP-1
[279.211259] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[279.215371] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.006s)
[281.304582] [063/131] (737s left) perf (blocking-parameterized)
[281.427008] Starting subtest: blocking-parameterized
[301.461319] Subtest blocking-parameterized: SUCCESS (20.039s)
[301.512448] [064/131] (717s left) gem_mmap_gtt (fault-concurrent-x)
[301.575162] Subtest fault-concurrent-X: SKIP (0.000s)
[301.645907] [065/131] (717s left) kms_sequence (get-forked)
[301.739929] Starting subtest: get-forked
[301.742221] Starting dynamic subtest: pipe-A-eDP-1
[303.620176] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.880s)
[303.629139] Starting dynamic subtest: pipe-B-eDP-1
[306.151861] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.530s)
[306.161311] Starting dynamic subtest: pipe-C-eDP-1
[308.625795] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.474s)
[308.635484] Starting dynamic subtest: pipe-D-eDP-1
[311.152254] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.525s)
[311.154425] Subtest get-forked: SUCCESS (9.412s)
[311.995849] [066/131] (707s left) api_intel_bb (add-remove-objects)
[312.059473] Starting subtest: add-remove-objects
[312.064747] Subtest add-remove-objects: SUCCESS (0.008s)
[312.189958] [067/131] (706s left) kms_chamelium_hpd (vga-hpd-fast)
[312.558549] Subtest vga-hpd-fast: SKIP (0.000s)
[313.398099] [068/131] (705s left) syncobj_timeline (wait-for-submit-complex)
[313.454622] Starting subtest: wait-for-submit-complex
[313.516125] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[313.589950] [069/131] (705s left) kms_vblank (wait-idle-hang)
[313.677764] Starting subtest: wait-idle-hang
[313.680493] Starting dynamic subtest: pipe-A-eDP-1
[339.924985] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.250s)
[339.938671] Starting dynamic subtest: pipe-D-eDP-1
[354.973655] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.047s)
[354.975640] Subtest wait-idle-hang: SUCCESS (41.302s)
[355.765568] [070/131] (663s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[355.886130] Starting subtest: y-tiled-32bpp-rotate-180
[355.890739] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[355.981497] [071/131] (663s left) syncobj_timeline (etime-multi-wait-submitted)
[356.033168] Starting subtest: etime-multi-wait-submitted
[356.139496] Subtest etime-multi-wait-submitted: SUCCESS (0.106s)
[356.216482] [072/131] (663s left) gem_exec_flush (basic-wb-ro-default)
[356.276463] Starting subtest: basic-wb-ro-default
[361.723733] Subtest basic-wb-ro-default: SUCCESS (5.449s)
[361.906871] [073/131] (657s left) gem_ctx_engines (none)
[361.971158] Starting subtest: none
[361.973677] Subtest none: SUCCESS (0.001s)
[362.156779] [074/131] (657s left) gem_exec_schedule (fairslice)
[362.233126] Starting subtest: fairslice
[362.235174] Starting dynamic subtest: rcs0
[364.254623] Dynamic subtest rcs0: SUCCESS (2.029s)
[364.266119] Starting dynamic subtest: bcs0
[366.280937] Dynamic subtest bcs0: SUCCESS (2.025s)
[366.289353] Starting dynamic subtest: vcs0
[368.306179] Dynamic subtest vcs0: SUCCESS (2.021s)
[368.317206] Starting dynamic subtest: vcs1
[370.321625] Dynamic subtest vcs1: SUCCESS (2.019s)
[370.331730] Starting dynamic subtest: vecs0
[372.340600] Dynamic subtest vecs0: SUCCESS (2.019s)
[372.352416] Starting dynamic subtest: ccs0
[374.361434] Dynamic subtest ccs0: SUCCESS (2.020s)
[374.363702] Subtest fairslice: SUCCESS (12.138s)
[374.658691] [075/131] (644s left) perf (gen8-unprivileged-single-ctx-counters)
[374.735997] Starting subtest: gen8-unprivileged-single-ctx-counters
[374.740595] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[374.780322] [076/131] (644s left) gem_busy (parallel)
[374.968558] Starting subtest: parallel
[374.971136] Starting dynamic subtest: rcs0
[376.151021] Dynamic subtest rcs0: SUCCESS (1.182s)
[376.165016] Starting dynamic subtest: bcs0
[378.136177] Dynamic subtest bcs0: SUCCESS (1.983s)
[378.146412] Starting dynamic subtest: vcs0
[380.119137] Dynamic subtest vcs0: SUCCESS (1.981s)
[380.129919] Starting dynamic subtest: vcs1
[382.167246] Dynamic subtest vcs1: SUCCESS (2.046s)
[382.179703] Starting dynamic subtest: vecs0
[384.151438] Dynamic subtest vecs0: SUCCESS (1.983s)
[384.162845] Starting dynamic subtest: ccs0
[386.135352] Dynamic subtest ccs0: SUCCESS (1.982s)
[386.138224] Subtest parallel: SUCCESS (11.169s)
[386.367825] [077/131] (633s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[386.466776] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[386.471332] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[386.572653] [078/131] (632s left) syncobj_timeline (device-submit-unordered)
[386.620122] Starting subtest: device-submit-unordered
[386.622037] Subtest device-submit-unordered: SUCCESS (0.000s)
[386.719986] [079/131] (632s left) gem_exec_flush (basic-batch-kernel-default-wb)
[386.778301] Starting subtest: basic-batch-kernel-default-wb
[393.835024] Subtest basic-batch-kernel-default-wb: SUCCESS (7.059s)
[394.020739] [080/131] (625s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[394.120589] Starting subtest: 4-tiled-8bpp-rotate-90
[394.144516] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.023s)
[394.267572] [081/131] (625s left) i915_pm_freq_mult (media-freq)
[394.329379] Starting subtest: media-freq
[394.331381] Starting dynamic subtest: gt0
[394.335702] Dynamic subtest gt0: SKIP (0.000s)
[394.345731] Starting dynamic subtest: gt1
[394.349891] Dynamic subtest gt1: SKIP (0.000s)
[394.354136] Subtest media-freq: SKIP (0.001s)
[394.447945] [082/131] (625s left) core_setmaster (master-drop-set-shared-fd)
[394.523739] Starting subtest: master-drop-set-shared-fd
[394.531998] Subtest master-drop-set-shared-fd: SUCCESS (0.010s)
[394.568518] [083/131] (625s left) syncobj_wait (wait-all-for-submit-complex)
[394.629680] Starting subtest: wait-all-for-submit-complex
[394.845054] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[394.930228] [084/131] (624s left) gem_userptr_blits (unsync-unmap)
[394.993683] Subtest unsync-unmap: SKIP (0.000s)
[395.134106] [085/131] (624s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[395.220681] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[395.222830] Starting dynamic subtest: pipe-A-eDP-1
[395.231551] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[395.242517] Starting dynamic subtest: pipe-B-eDP-1
[395.251525] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[395.261036] Starting dynamic subtest: pipe-C-eDP-1
[395.269162] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[395.277367] Starting dynamic subtest: pipe-D-eDP-1
[395.285665] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[395.289645] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[397.493745] [086/131] (622s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[397.587731] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[397.590000] Starting dynamic subtest: pipe-A-eDP-1
[397.613331] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[397.624305] Starting dynamic subtest: pipe-B-eDP-1
[397.645221] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[397.654031] Starting dynamic subtest: pipe-C-eDP-1
[397.675509] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[397.684795] Starting dynamic subtest: pipe-D-eDP-1
[397.708069] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[397.712753] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[399.744064] [087/131] (620s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[404.780937] Starting subtest: pr-cursor-plane-update-sf
[404.785990] Subtest pr-cursor-plane-update-sf: SKIP (0.002s)
[405.633249] [088/131] (614s left) syncobj_timeline (invalid-signal-bad-pad)
[405.692649] Starting subtest: invalid-signal-bad-pad
[405.695032] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[405.805991] [089/131] (614s left) gem_exec_flush (basic-uc-set-default)
[405.861865] Starting subtest: basic-uc-set-default
[411.316350] Subtest basic-uc-set-default: SUCCESS (5.457s)
[411.501076] [090/131] (608s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[411.596921] Starting subtest: fbc-pr-sprite-mmap-gtt
[411.600950] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[411.667116] [091/131] (608s left) kms_cursor_crc (cursor-onscreen-32x10)
[411.828857] Starting subtest: cursor-onscreen-32x10
[411.876888] Subtest cursor-onscreen-32x10: SKIP (0.042s)
[412.159349] [092/131] (607s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[412.250704] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[412.252885] Starting dynamic subtest: pipe-A-eDP-1
[413.497862] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.247s)
[413.507117] Starting dynamic subtest: pipe-B-eDP-1
[415.766797] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.268s)
[415.776154] Starting dynamic subtest: pipe-C-eDP-1
[418.101336] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.334s)
[418.113132] Starting dynamic subtest: pipe-D-eDP-1
[420.404704] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.301s)
[420.407033] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.157s)
[421.535430] [093/131] (598s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[421.641643] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[421.654027] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s)
[421.767158] [094/131] (598s left) gem_exec_whisper (basic-fds-forked)
[421.827110] Starting subtest: basic-fds-forked
[445.603106] Subtest basic-fds-forked: SUCCESS (23.778s)
[445.783892] [095/131] (574s left) i915_query (query-regions-sanity-check)
[445.841809] Starting subtest: query-regions-sanity-check
[445.853409] Subtest query-regions-sanity-check: SUCCESS (0.014s)
[445.972142] [096/131] (574s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[446.076330] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[452.906438] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.834s)
[453.020128] [097/131] (567s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[453.115683] Starting subtest: primary-yf-tiled-reflect-x-90
[453.120206] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[453.188733] [098/131] (567s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[453.250214] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[453.252452] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[453.364148] [099/131] (566s left) gem_ctx_shared (single-timeline)
[453.426655] Starting subtest: single-timeline
[453.446959] Subtest single-timeline: SUCCESS (0.013s)
[453.687297] [100/131] (566s left) prime_mmap (test_forked_cpu_write)
[453.732642] Starting subtest: test_forked_cpu_write
[453.734900] Starting dynamic subtest: test_forked_cpu_write-smem
[453.737178] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.007s)
[453.739450] Subtest test_forked_cpu_write: SUCCESS (0.008s)
[453.851546] [101/131] (566s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[453.947879] Starting subtest: plane-scaler-unity-scaling-with-rotation
[453.950220] Starting dynamic subtest: pipe-A
[454.285470] Dynamic subtest pipe-A: SUCCESS (0.337s)
[454.296306] Starting dynamic subtest: pipe-B
[455.705487] Dynamic subtest pipe-B: SUCCESS (1.420s)
[455.715861] Starting dynamic subtest: pipe-C
[457.126312] Dynamic subtest pipe-C: SUCCESS (1.420s)
[457.136710] Starting dynamic subtest: pipe-D
[458.544738] Dynamic subtest pipe-D: SUCCESS (1.417s)
[458.547034] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.599s)
[459.719701] [102/131] (560s left) kms_pm_rpm (i2c)
[461.247119] Starting subtest: i2c
[466.903639] Subtest i2c: SUCCESS (5.659s)
[467.029492] [103/131] (553s left) gem_mmap_gtt (big-copy-odd)
[467.087385] Subtest big-copy-odd: SKIP (0.000s)
[467.145644] [104/131] (553s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[467.262189] Starting subtest: short-flip-after-cursor-atomic-transitions
[468.231160] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.969s)
[469.107879] [105/131] (551s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[469.166289] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[469.170542] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[469.344341] [106/131] (551s left) gem_ctx_persistence (engines-cleanup)
[469.402640] Starting subtest: engines-cleanup
[469.404980] Starting dynamic subtest: rcs0
[469.499541] Dynamic subtest rcs0: SUCCESS (0.096s)
[469.512464] Starting dynamic subtest: bcs0
[469.565639] Dynamic subtest bcs0: SUCCESS (0.064s)
[469.577855] Starting dynamic subtest: vcs0
[469.626339] Dynamic subtest vcs0: SUCCESS (0.059s)
[469.638500] Starting dynamic subtest: vcs1
[469.697678] Dynamic subtest vcs1: SUCCESS (0.069s)
[469.709302] Starting dynamic subtest: vecs0
[469.758391] Dynamic subtest vecs0: SUCCESS (0.059s)
[469.770401] Starting dynamic subtest: ccs0
[469.786096] Dynamic subtest ccs0: SUCCESS (0.026s)
[469.788397] Subtest engines-cleanup: SUCCESS (0.384s)
[469.926052] [107/131] (550s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[470.040774] Starting subtest: yf-tiled-64bpp-rotate-90
[470.045227] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[470.136574] [108/131] (550s left) kms_cursor_crc (cursor-sliding-512x170)
[470.408942] Starting subtest: cursor-sliding-512x170
[470.412639] Subtest cursor-sliding-512x170: SKIP (0.001s)
[470.563887] [109/131] (550s left) gem_exec_balancer (parallel-balancer)
[470.817184] Starting subtest: parallel-balancer
[471.673369] Subtest parallel-balancer: SUCCESS (0.856s)
[471.804144] [110/131] (548s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[476.849595] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[476.851840] Starting dynamic subtest: pipe-A-eDP-1
[477.647405] Dynamic subtest pipe-A-eDP-1: SKIP (0.795s)
[477.656588] Starting dynamic subtest: pipe-B-eDP-1
[478.771812] Dynamic subtest pipe-B-eDP-1: SKIP (1.122s)
[478.776036] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.920s)
[479.950454] [111/131] (540s left) prime_mmap (test_correct)
[480.013689] Starting subtest: test_correct
[480.015839] Starting dynamic subtest: test_correct-smem
[480.046264] Dynamic subtest test_correct-smem: SUCCESS (0.033s)
[480.048801] Subtest test_correct: SUCCESS (0.034s)
[480.156902] [112/131] (540s left) kms_flip (nonexisting-fb-interruptible)
[480.251285] Starting subtest: nonexisting-fb-interruptible
[480.253545] Starting dynamic subtest: A-eDP1
[481.433172] Dynamic subtest A-eDP1: SUCCESS (1.182s)
[481.442820] Starting dynamic subtest: B-eDP1
[482.553410] Dynamic subtest B-eDP1: SUCCESS (1.120s)
[482.563831] Starting dynamic subtest: C-eDP1
[483.676918] Dynamic subtest C-eDP1: SUCCESS (1.123s)
[483.687197] Starting dynamic subtest: D-eDP1
[484.804319] Dynamic subtest D-eDP1: SUCCESS (1.127s)
[484.810307] Subtest nonexisting-fb-interruptible: SUCCESS (4.560s)
[486.062447] [113/131] (534s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[486.164815] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[486.169258] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[486.263947] [114/131] (534s left) gem_eio (hibernate)
[486.478323] Starting subtest: hibernate
[501.133296] Subtest hibernate: SUCCESS (14.659s)
[508.288651] [115/131] (519s left) gem_pwrite (basic-exhaustion)
[508.367733] Subtest basic-exhaustion: SKIP (0.000s)
[508.456207] [116/131] (519s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[508.547021] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[508.551219] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[508.668109] [117/131] (519s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[508.765930] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[509.149025] Starting dynamic subtest: pipe-A-eDP-1
[511.952700] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.801s)
[512.338991] Starting dynamic subtest: pipe-B-eDP-1
[515.087722] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.754s)
[515.449782] Starting dynamic subtest: pipe-C-eDP-1
[518.211002] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.766s)
[518.575579] Starting dynamic subtest: pipe-D-eDP-1
[521.338218] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.770s)
[521.340674] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.564s)
[522.516979] [118/131] (505s left) gem_exec_store (pages)
[522.587600] Starting subtest: pages
[522.589713] Starting dynamic subtest: rcs0
[522.702765] Dynamic subtest rcs0: SUCCESS (0.119s)
[522.713695] Starting dynamic subtest: bcs0
[522.783889] Dynamic subtest bcs0: SUCCESS (0.079s)
[522.795401] Starting dynamic subtest: vcs0
[522.862999] Dynamic subtest vcs0: SUCCESS (0.078s)
[522.874700] Starting dynamic subtest: vcs1
[522.933577] Dynamic subtest vcs1: SUCCESS (0.070s)
[522.943596] Starting dynamic subtest: vecs0
[522.998263] Dynamic subtest vecs0: SUCCESS (0.063s)
[523.011195] Starting dynamic subtest: ccs0
[523.073434] Dynamic subtest ccs0: SUCCESS (0.075s)
[523.076281] Subtest pages: SUCCESS (0.490s)
[523.257787] [119/131] (504s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[523.646750] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[524.425906] [120/131] (503s left) kms_scaling_modes (scaling-mode-full)
[524.525897] Starting subtest: scaling-mode-full
[524.528200] Starting dynamic subtest: pipe-A-eDP-1
[524.637850] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.111s)
[524.648502] Starting dynamic subtest: pipe-B-eDP-1
[525.774171] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.133s)
[525.784179] Starting dynamic subtest: pipe-C-eDP-1
[526.970446] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.195s)
[526.983026] Starting dynamic subtest: pipe-D-eDP-1
[528.102655] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.131s)
[528.104935] Subtest scaling-mode-full: SUCCESS (3.575s)
[529.258565] [121/131] (498s left) gem_mmap (bad-size)
[529.316558] Subtest bad-size: SKIP (0.000s)
[529.371012] [122/131] (498s left) kms_cursor_crc (async-cursor-crc-framebuffer-change)
[529.490642] Starting subtest: async-cursor-crc-framebuffer-change
[529.492867] Starting dynamic subtest: pipe-A-eDP-1
[530.077446] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.585s)
[530.088979] Starting dynamic subtest: pipe-D-eDP-1
[531.278844] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.199s)
[531.281205] Subtest async-cursor-crc-framebuffer-change: SUCCESS (1.787s)
[532.117996] [123/131] (496s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[532.230989] Starting subtest: fbc-tiling-linear
[536.013550] Subtest fbc-tiling-linear: SUCCESS (3.785s)
[537.197054] [124/131] (491s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[537.295814] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[537.299828] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[537.388468] [125/131] (490s left) perf_pmu (render-node-busy)
[537.453540] Starting subtest: render-node-busy
[537.456017] Starting dynamic subtest: rcs0
[538.048631] Dynamic subtest rcs0: SUCCESS (0.594s)
[538.061205] Starting dynamic subtest: bcs0
[538.613261] Dynamic subtest bcs0: SUCCESS (0.563s)
[538.625999] Starting dynamic subtest: vcs0
[540.119320] Dynamic subtest vcs0: SUCCESS (1.502s)
[540.133303] Starting dynamic subtest: vcs1
[542.104011] Dynamic subtest vcs1: SUCCESS (1.981s)
[542.116702] Starting dynamic subtest: vecs0
[544.151604] Dynamic subtest vecs0: SUCCESS (2.045s)
[544.162877] Starting dynamic subtest: ccs0
[544.729903] Dynamic subtest ccs0: SUCCESS (0.577s)
[544.732415] Subtest render-node-busy: SUCCESS (7.275s)
[544.808021] [126/131] (483s left) kms_plane_multiple (tiling-yf)
[544.911775] Starting subtest: tiling-yf
[544.916330] Subtest tiling-yf: SKIP (0.000s)
[544.986484] [127/131] (483s left) gem_gtt_cpu_tlb
[545.115024] [128/131] (483s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[545.208428] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[551.589905] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.384s)
[551.691209] [129/131] (476s left) kms_psr (pr-cursor-plane-move)
[551.791270] Starting subtest: pr-cursor-plane-move
[551.795565] Subtest pr-cursor-plane-move: SKIP (0.000s)
[551.865558] [130/131] (476s left) gem_softpin (softpin)
[551.938089] Starting subtest: softpin
[584.253833] Subtest softpin: SUCCESS (32.305s)
[584.404968] [131/131] (444s left) kms_cursor_edge_walk (256x256-top-edge)
[584.509691] Starting subtest: 256x256-top-edge
[584.511905] Starting dynamic subtest: pipe-A-eDP-1
[587.937196] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.425s)
[587.948706] Starting dynamic subtest: pipe-D-eDP-1
[591.051583] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.111s)
[591.053931] Subtest 256x256-top-edge: SUCCESS (6.538s)
[591.856727] Closing watchdogs
results: parsing output: 0/ for test: gen9_exec_parse
results: parsing output: 1/ for test: kms_chamelium_edid
results: parsing output: 2/ for test: gem_exec_fence
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_exec_fence
results: parsing output: 5/ for test: kms_plane_scaling
results: parsing output: 6/ for test: kms_cursor_legacy
results: parsing output: 7/ for test: kms_joiner
results: parsing output: 8/ for test: gem_ctx_exec
results: parsing output: 9/ for test: syncobj_wait
results: parsing output: 10/ for test: kms_addfb_basic
results: parsing output: 11/ for test: gem_pread
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_properties
results: parsing output: 14/ for test: gem_mmap
results: parsing output: 15/ for test: kms_pm_rpm
results: parsing output: 16/ for test: gem_fenced_exec_thrash
results: parsing output: 17/ for test: gem_ctx_param
results: parsing output: 18/ for test: kms_plane_cursor
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: kms_cursor_legacy
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_spin_batch
results: parsing output: 24/ for test: i915_suspend
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: prime_mmap
results: parsing output: 27/ for test: syncobj_wait
results: parsing output: 28/ for test: gem_ctx_param
results: parsing output: 29/ for test: gem_unfence_active_buffers
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: prime_mmap
results: parsing output: 32/ for test: kms_lease
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: gem_exec_reloc
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: i915_drm_fdinfo
results: parsing output: 38/ for test: gem_ctx_sseu
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: kms_draw_crc
results: parsing output: 43/ for test: kms_setmode
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: gem_render_copy
results: parsing output: 46/ for test: syncobj_basic
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_exec_schedule
results: parsing output: 49/ for test: prime_busy
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: gen7_exec_parse
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_dsc
results: parsing output: 56/ for test: gem_exec_suspend
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: syncobj_timeline
results: parsing output: 59/ for test: kms_flip_scaled_crc
results: parsing output: 60/ for test: drm_read
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: perf
results: parsing output: 63/ for test: gem_mmap_gtt
results: parsing output: 64/ for test: kms_sequence
results: parsing output: 65/ for test: api_intel_bb
results: parsing output: 66/ for test: kms_chamelium_hpd
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: kms_vblank
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: syncobj_timeline
results: parsing output: 71/ for test: gem_exec_flush
results: parsing output: 72/ for test: gem_ctx_engines
results: parsing output: 73/ for test: gem_exec_schedule
results: parsing output: 74/ for test: perf
results: parsing output: 75/ for test: gem_busy
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: gem_exec_flush
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: i915_pm_freq_mult
results: parsing output: 81/ for test: core_setmaster
results: parsing output: 82/ for test: syncobj_wait
results: parsing output: 83/ for test: gem_userptr_blits
results: parsing output: 84/ for test: kms_ccs
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: kms_psr2_sf
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: gem_exec_flush
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: kms_cursor_crc
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: kms_flip
results: parsing output: 93/ for test: gem_exec_whisper
results: parsing output: 94/ for test: i915_query
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_rotation_crc
results: parsing output: 97/ for test: syncobj_wait
results: parsing output: 98/ for test: gem_ctx_shared
results: parsing output: 99/ for test: prime_mmap
results: parsing output: 100/ for test: kms_plane_scaling
results: parsing output: 101/ for test: kms_pm_rpm
results: parsing output: 102/ for test: gem_mmap_gtt
results: parsing output: 103/ for test: kms_cursor_legacy
results: parsing output: 104/ for test: gem_render_copy
results: parsing output: 105/ for test: gem_ctx_persistence
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: kms_cursor_crc
results: parsing output: 108/ for test: gem_exec_balancer
results: parsing output: 109/ for test: kms_psr2_sf
results: parsing output: 110/ for test: prime_mmap
results: parsing output: 111/ for test: kms_flip
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_eio
results: parsing output: 114/ for test: gem_pwrite
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_async_flips
results: parsing output: 117/ for test: gem_exec_store
results: parsing output: 118/ for test: kms_chamelium_hpd
results: parsing output: 119/ for test: kms_scaling_modes
results: parsing output: 120/ for test: gem_mmap
results: parsing output: 121/ for test: kms_cursor_crc
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: perf_pmu
results: parsing output: 125/ for test: kms_plane_multiple
results: parsing output: 126/ for test: gem_gtt_cpu_tlb
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: gem_softpin
results: parsing output: 130/ for test: kms_cursor_edge_walk
Done.