[57.117509] Initializing watchdogs
[57.117557]   /dev/watchdog0
[57.134021] [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]
[57.138417] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.140747] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.144170] [001/131] (960s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[57.266039] Starting subtest: fbc-psr-sprite-mmap-cpu
[57.267958] Starting dynamic subtest: eDP-1
[57.271994] Dynamic subtest eDP-1: SKIP (0.000s)
[57.275922] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.000s)
[57.360327] [002/131] (960s left) vgem_basic (create)
[57.424441] Starting subtest: create
[57.426596] Subtest create: SUCCESS (0.000s)
[57.504229] [FACT vgem_basic (create)] new: kernel.kmod_is_loaded.vgem: true
[57.507682] [003/131] (960s left) gem_exec_alignment (many)
[57.569405] Starting subtest: many
[81.299995] Subtest many: SUCCESS (23.696s)
[82.841584] [004/131] (934s left) gem_userptr_blits (create-destroy-sync)
[82.957279] Starting subtest: create-destroy-sync
[87.976039] Subtest create-destroy-sync: SUCCESS (5.016s)
[88.142569] [005/131] (929s left) perf_pmu (busy-double-start)
[88.187444] Starting subtest: busy-double-start
[88.189653] Starting dynamic subtest: rcs0
[91.831620] Dynamic subtest rcs0: FAIL (3.591s)
[91.841033] Starting dynamic subtest: bcs0
[95.348380] Dynamic subtest bcs0: SUCCESS (3.570s)
[95.357457] Starting dynamic subtest: vcs0
[99.420757] Dynamic subtest vcs0: SUCCESS (4.071s)
[99.430507] Starting dynamic subtest: vcs1
[103.476910] Dynamic subtest vcs1: SUCCESS (4.054s)
[103.487765] Starting dynamic subtest: vecs0
[107.451960] Dynamic subtest vecs0: SUCCESS (3.974s)
[107.462354] Starting dynamic subtest: ccs0
[111.085791] Dynamic subtest ccs0: FAIL (3.564s)
[111.087792] Subtest busy-double-start: FAIL (22.827s)
[111.160558] [006/131] (906s left) prime_mmap (test_aperture_limit)
[111.231883] Starting subtest: test_aperture_limit
[111.234026] Starting dynamic subtest: test_aperture_limit-smem
[111.244744] Dynamic subtest test_aperture_limit-smem: SKIP (0.012s)
[111.249179] Subtest test_aperture_limit: SKIP (0.013s)
[111.381583] [007/131] (906s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[111.494068] Starting subtest: psr-farfromfence-mmap-gtt
[111.497992] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[111.630288] [008/131] (906s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[111.741169] Starting subtest: invalid-modeset-force-ultra-joiner
[111.745305] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[111.828532] [009/131] (906s left) gem_exec_schedule (pi-distinct-iova)
[112.019919] Starting subtest: pi-distinct-iova
[112.022296] Starting dynamic subtest: rcs0
[112.097257] Dynamic subtest rcs0: SUCCESS (0.079s)
[112.108955] Starting dynamic subtest: vcs0
[112.159313] Dynamic subtest vcs0: SUCCESS (0.062s)
[112.169988] Starting dynamic subtest: vcs1
[112.215574] Dynamic subtest vcs1: SUCCESS (0.056s)
[112.226861] Starting dynamic subtest: vecs0
[112.270254] Dynamic subtest vecs0: SUCCESS (0.054s)
[112.281451] Starting dynamic subtest: ccs0
[112.327192] Dynamic subtest ccs0: SUCCESS (0.058s)
[112.329839] Subtest pi-distinct-iova: SUCCESS (0.309s)
[114.016459] [010/131] (903s left) gem_exec_whisper (basic-fds-forked)
[114.088667] Starting subtest: basic-fds-forked
[138.363163] Subtest basic-fds-forked: SUCCESS (24.267s)
[138.570133] [011/131] (879s left) gem_lmem_swapping (parallel-random)
[138.617280] Subtest parallel-random: SKIP (0.000s)
[138.662227] [012/131] (879s left) kms_content_protection (atomic-dpms-hdcp14)
[138.826210] Starting subtest: atomic-dpms-hdcp14
[138.831020] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[138.970876] [013/131] (879s left) gem_exec_schedule (fifo)
[139.055992] Starting subtest: fifo
[139.057923] Starting dynamic subtest: rcs0
[139.146653] Dynamic subtest rcs0: SUCCESS (0.098s)
[139.157947] Starting dynamic subtest: vcs0
[139.220600] Dynamic subtest vcs0: SUCCESS (0.074s)
[139.231510] Starting dynamic subtest: vcs1
[139.295698] Dynamic subtest vcs1: SUCCESS (0.074s)
[139.307166] Starting dynamic subtest: vecs0
[139.366066] Dynamic subtest vecs0: SUCCESS (0.070s)
[139.377695] Starting dynamic subtest: ccs0
[139.444483] Dynamic subtest ccs0: SUCCESS (0.079s)
[139.446836] Subtest fifo: SUCCESS (0.397s)
[141.028741] [014/131] (877s left) kms_chamelium_color (ctm-0-25)
[141.124370] Subtest ctm-0-25: SKIP (0.000s)
[141.168110] [015/131] (877s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[141.269557] Starting subtest: x-tiled-32bpp-rotate-180
[142.658158] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.389s)
[142.860325] [016/131] (875s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[142.972130] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[143.785884] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.814s)
[143.993729] [017/131] (874s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[144.057490] Starting subtest: invalid-signal-one-illegal-handle
[144.059877] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[144.196403] [018/131] (874s left) gem_linear_blits (interruptible)
[144.399346] Starting subtest: interruptible
[148.317725] Subtest interruptible: SUCCESS (3.919s)
[148.581074] [019/131] (869s left) gem_workarounds (reset-context)
[148.699592] Starting subtest: reset-context
[148.904518] Subtest reset-context: SUCCESS (0.205s)
[149.064618] [020/131] (869s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[149.169252] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[149.171418] Starting dynamic subtest: pipe-A-eDP-1
[149.193812] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[149.204845] Starting dynamic subtest: pipe-B-eDP-1
[149.226572] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[149.235114] Starting dynamic subtest: pipe-C-eDP-1
[149.256439] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[149.265262] Starting dynamic subtest: pipe-D-eDP-1
[149.286558] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[149.290775] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[151.447615] [021/131] (867s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[151.548693] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[151.551116] Starting dynamic subtest: pipe-A-eDP-1
[151.572389] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[151.581391] Starting dynamic subtest: pipe-B-eDP-1
[151.599749] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[151.607950] Starting dynamic subtest: pipe-C-eDP-1
[151.627051] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[151.635473] Starting dynamic subtest: pipe-D-eDP-1
[151.656174] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[151.657979] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.004s)
[153.815348] [022/131] (864s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[153.938638] Starting subtest: short-flip-after-cursor-toggle
[154.885076] Subtest short-flip-after-cursor-toggle: SUCCESS (0.945s)
[155.741820] [023/131] (862s left) kms_psr (fbc-psr2-primary-render)
[155.832619] Starting subtest: fbc-psr2-primary-render
[155.834446] Starting dynamic subtest: eDP-1
[155.838399] Dynamic subtest eDP-1: SKIP (0.000s)
[155.842157] Subtest fbc-psr2-primary-render: SKIP (0.000s)
[155.927831] [024/131] (862s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[156.018081] Starting subtest: plane-primary-toggle-with-vblank-wait
[156.020436] Starting dynamic subtest: pipe-A-eDP-1
[156.191771] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[156.507338] Starting dynamic subtest: pipe-B-eDP-1
[157.429129] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.931s)
[157.741072] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.722s)
[158.617929] [025/131] (860s left) gem_exec_fence (submit-chain)
[158.801691] Starting subtest: submit-chain
[158.825539] Subtest submit-chain: SUCCESS (0.024s)
[161.035234] [026/131] (857s left) gem_render_copy (y-tiled-to-vebox-linear)
[161.102487] Starting subtest: y-tiled-to-vebox-linear
[161.106955] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[161.313595] [027/131] (857s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[161.430697] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[161.435317] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[161.559021] [028/131] (857s left) syncobj_timeline (single-wait-available-submitted)
[161.623070] Starting subtest: single-wait-available-submitted
[161.625441] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[161.764612] [029/131] (857s left) sysfs_heartbeat_interval (nopreempt)
[161.831757] Starting subtest: nopreempt
[161.834135] Starting dynamic subtest: vecs0
[171.947419] Dynamic subtest vecs0: SUCCESS (10.115s)
[171.959559] Starting dynamic subtest: ccs0
[175.972111] Dynamic subtest ccs0: SUCCESS (4.023s)
[175.983570] Starting dynamic subtest: vcs0
[184.933128] Dynamic subtest vcs0: SUCCESS (8.960s)
[184.944493] Starting dynamic subtest: bcs0
[188.938068] Dynamic subtest bcs0: SUCCESS (4.004s)
[188.950035] Starting dynamic subtest: rcs0
[193.035904] Dynamic subtest rcs0: SUCCESS (4.095s)
[193.047153] Starting dynamic subtest: vcs1
[202.924265] Dynamic subtest vcs1: SUCCESS (9.888s)
[202.926878] Subtest nopreempt: SUCCESS (41.092s)
[203.027996] [030/131] (815s left) sw_sync (sync_busy_fork)
[203.067415] Starting subtest: sync_busy_fork
[204.078784] Subtest sync_busy_fork: SUCCESS (1.011s)
[204.170729] [031/131] (814s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[204.281495] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[204.285790] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[204.385675] [032/131] (814s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[204.495438] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[211.493046] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.001s)
[211.654936] [033/131] (807s left) kms_prime (basic-modeset-hybrid)
[211.755536] Subtest basic-modeset-hybrid: SKIP (0.000s)
[211.872065] [034/131] (807s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[211.972343] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[211.974637] Starting dynamic subtest: pipe-A-eDP-1
[211.997321] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[212.008190] Starting dynamic subtest: pipe-B-eDP-1
[212.029635] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[212.038611] Starting dynamic subtest: pipe-C-eDP-1
[212.060991] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[212.069986] Starting dynamic subtest: pipe-D-eDP-1
[212.091994] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[212.096127] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[214.230098] [035/131] (804s left) kms_feature_discovery (display)
[214.334125] Starting subtest: display
[214.336474] Subtest display: SUCCESS (0.000s)
[214.430985] [036/131] (804s left) gem_create (create-ext-placement-all)
[214.607733] Starting subtest: create-ext-placement-all
[214.609926] Subtest create-ext-placement-all: SUCCESS (0.000s)
[214.751296] [037/131] (804s left) prime_mmap (test_reprime)
[214.817525] Starting subtest: test_reprime
[214.819873] Starting dynamic subtest: test_reprime-smem
[214.847683] Dynamic subtest test_reprime-smem: SUCCESS (0.032s)
[214.850023] Subtest test_reprime: SUCCESS (0.033s)
[214.986911] [038/131] (804s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[215.093132] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[221.717206] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.627s)
[221.901488] [039/131] (797s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[222.004575] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[222.006682] Starting dynamic subtest: pipe-A-default-mode
[222.315920] Dynamic subtest pipe-A-default-mode: SKIP (0.310s)
[222.320210] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.311s)
[223.116308] [040/131] (796s left) gem_softpin (full)
[223.179601] Starting subtest: full
[223.187584] Subtest full: SUCCESS (0.008s)
[223.356762] [041/131] (795s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[223.452444] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[223.456617] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[223.583875] [042/131] (795s left) kms_psr (psr2-sprite-blt)
[223.680068] Starting subtest: psr2-sprite-blt
[223.682348] Starting dynamic subtest: eDP-1
[225.405240] Dynamic subtest eDP-1: SUCCESS (1.724s)
[225.407409] Subtest psr2-sprite-blt: SUCCESS (1.725s)
[226.290206] [043/131] (793s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[226.393142] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[230.840656] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.452s)
[231.994374] [044/131] (787s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[232.094997] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[239.089033] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.996s)
[239.238794] [045/131] (780s left) kms_setmode (invalid-clone-single-crtc-stealing)
[239.302292] Starting subtest: invalid-clone-single-crtc-stealing
[239.308490] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[239.433037] [046/131] (780s left) api_intel_bb (crc32)
[239.490720] Starting subtest: crc32
[239.492901] Starting dynamic subtest: rcs0-smem0
[239.796242] Dynamic subtest rcs0-smem0: SUCCESS (0.306s)
[239.807549] Starting dynamic subtest: bcs0-smem0
[240.161105] Dynamic subtest bcs0-smem0: SUCCESS (0.363s)
[240.170918] Starting dynamic subtest: vcs0-smem0
[240.588880] Dynamic subtest vcs0-smem0: SUCCESS (0.425s)
[240.600644] Starting dynamic subtest: vcs1-smem0
[240.944505] Dynamic subtest vcs1-smem0: SUCCESS (0.353s)
[240.956686] Starting dynamic subtest: vecs0-smem0
[241.324279] Dynamic subtest vecs0-smem0: SUCCESS (0.378s)
[241.335813] Starting dynamic subtest: ccs0-smem0
[241.674762] Dynamic subtest ccs0-smem0: SUCCESS (0.350s)
[241.677620] Subtest crc32: SUCCESS (2.188s)
[241.840419] [047/131] (777s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[241.947982] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[241.959649] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.011s)
[242.082963] [048/131] (777s left) kms_frontbuffer_tracking (basic)
[242.197375] Starting subtest: basic
[245.463055] Subtest basic: SUCCESS (3.271s)
[245.624924] [049/131] (773s left) gem_partial_pwrite_pread (write)
[245.682452] Subtest write: SKIP (0.000s)
[245.767508] [050/131] (773s left) gem_exec_schedule (u-fairslice)
[245.835606] Starting subtest: u-fairslice
[245.837450] Starting dynamic subtest: rcs0
[247.855936] Dynamic subtest rcs0: SUCCESS (2.021s)
[247.866036] Starting dynamic subtest: bcs0
[249.873795] Dynamic subtest bcs0: SUCCESS (2.018s)
[249.884046] Starting dynamic subtest: vcs0
[251.893112] Dynamic subtest vcs0: SUCCESS (2.019s)
[251.901952] Starting dynamic subtest: vcs1
[253.913188] Dynamic subtest vcs1: SUCCESS (2.018s)
[253.925101] Starting dynamic subtest: vecs0
[255.934371] Dynamic subtest vecs0: SUCCESS (2.021s)
[255.943840] Starting dynamic subtest: ccs0
[257.961458] Dynamic subtest ccs0: SUCCESS (2.026s)
[257.963412] Subtest u-fairslice: SUCCESS (12.128s)
[258.286510] [051/131] (761s left) i915_hangman (gt-error-state-capture)
[258.360876] Starting subtest: gt-error-state-capture
[258.363124] Starting dynamic subtest: rcs0
[269.876911] Dynamic subtest rcs0: SUCCESS (11.515s)
[269.888732] Starting dynamic subtest: bcs0
[281.843460] Dynamic subtest bcs0: SUCCESS (11.963s)
[281.855806] Starting dynamic subtest: vcs0
[292.851702] Dynamic subtest vcs0: SUCCESS (11.005s)
[292.863752] Starting dynamic subtest: vcs1
[304.820463] Dynamic subtest vcs1: SUCCESS (11.966s)
[304.831824] Starting dynamic subtest: vecs0
[316.851905] Dynamic subtest vecs0: SUCCESS (12.028s)
[316.864412] Starting dynamic subtest: ccs0
[328.884618] Dynamic subtest ccs0: SUCCESS (12.030s)
[328.887433] Subtest gt-error-state-capture: SUCCESS (70.521s)
[328.990573] [052/131] (690s left) gem_exec_fence (basic-wait)
[329.181197] Starting subtest: basic-wait
[329.183158] Starting dynamic subtest: rcs0
[329.284337] Dynamic subtest rcs0: SUCCESS (0.105s)
[329.295902] Starting dynamic subtest: bcs0
[329.345536] Dynamic subtest bcs0: SUCCESS (0.060s)
[329.356594] Starting dynamic subtest: vcs0
[329.402646] Dynamic subtest vcs0: SUCCESS (0.054s)
[329.413566] Starting dynamic subtest: vcs1
[329.471073] Dynamic subtest vcs1: SUCCESS (0.067s)
[329.481856] Starting dynamic subtest: vecs0
[329.534956] Dynamic subtest vecs0: SUCCESS (0.062s)
[329.546101] Starting dynamic subtest: ccs0
[329.600109] Dynamic subtest ccs0: SUCCESS (0.063s)
[329.602466] Subtest basic-wait: SUCCESS (0.423s)
[331.025926] [053/131] (688s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[331.136516] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[338.471263] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (7.336s)
[338.668400] [054/131] (681s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[338.792745] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[345.669940] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.878s)
[345.840011] [055/131] (674s left) i915_drm_fdinfo (idle)
[345.889255] Starting subtest: idle
[345.891063] Starting dynamic subtest: rcs0
[346.458760] Dynamic subtest rcs0: SUCCESS (0.570s)
[346.468879] Starting dynamic subtest: bcs0
[346.966779] Dynamic subtest bcs0: SUCCESS (0.504s)
[346.975998] Starting dynamic subtest: vcs0
[347.472435] Dynamic subtest vcs0: SUCCESS (0.503s)
[347.481320] Starting dynamic subtest: vcs1
[347.978390] Dynamic subtest vcs1: SUCCESS (0.503s)
[347.987876] Starting dynamic subtest: vecs0
[348.484039] Dynamic subtest vecs0: SUCCESS (0.503s)
[348.493121] Starting dynamic subtest: ccs0
[348.990210] Dynamic subtest ccs0: SUCCESS (0.503s)
[348.993235] Subtest idle: SUCCESS (3.103s)
[349.098886] [056/131] (670s left) prime_vgem (coherency-blt)
[349.172304] Starting subtest: coherency-blt
[351.168680] Subtest coherency-blt: SUCCESS (1.995s)
[351.353133] [057/131] (668s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[351.453073] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[351.457164] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[351.603027] [058/131] (668s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[351.691712] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[351.694020] Starting dynamic subtest: pipe-A-default-mode
[352.013427] Dynamic subtest pipe-A-default-mode: SKIP (0.321s)
[352.017769] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.322s)
[352.826040] [059/131] (667s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[352.926707] Starting subtest: y-tiled-8bpp-rotate-90
[352.931100] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[353.037678] [060/131] (667s left) i915_pm_rps (reset)
[353.106167] Starting subtest: reset
[361.550196] Subtest reset: SUCCESS (8.443s)
[361.722661] [061/131] (658s left) kms_chamelium_hpd (hdmi-hpd-storm)
[362.129644] Subtest hdmi-hpd-storm: SKIP (0.000s)
[362.924072] [062/131] (657s left) kms_dp_link_training (uhbr-mst)
[363.014941] Starting subtest: uhbr-mst
[363.023483] Subtest uhbr-mst: SKIP (0.000s)
[363.113450] [063/131] (657s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[363.217595] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[367.528899] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.315s)
[368.682503] [064/131] (651s left) kms_psr (psr-sprite-plane-onoff)
[368.779638] Starting subtest: psr-sprite-plane-onoff
[368.781783] Starting dynamic subtest: eDP-1
[370.583513] Dynamic subtest eDP-1: SUCCESS (1.802s)
[370.585488] Subtest psr-sprite-plane-onoff: SUCCESS (1.802s)
[371.423932] [065/131] (648s left) gem_ctx_isolation (preservation-s3)
[371.493050] Starting subtest: preservation-S3
[371.494992] Starting dynamic subtest: rcs0
[387.866242] Dynamic subtest rcs0: SUCCESS (5.423s)
[387.879363] Starting dynamic subtest: bcs0
[404.888443] Dynamic subtest bcs0: SUCCESS (1.773s)
[404.898587] Starting dynamic subtest: vcs0
[421.867228] Dynamic subtest vcs0: SUCCESS (2.735s)
[421.877026] Starting dynamic subtest: vcs1
[439.869119] Dynamic subtest vcs1: SUCCESS (4.959s)
[439.880534] Starting dynamic subtest: vecs0
[457.876931] Dynamic subtest vecs0: SUCCESS (4.998s)
[457.887172] Starting dynamic subtest: ccs0
[475.876182] Dynamic subtest ccs0: SUCCESS (3.130s)
[475.878571] Subtest preservation-S3: SUCCESS (23.026s)
[487.169513] [066/131] (544s left) gem_ctx_persistence (engines-queued)
[487.259743] Starting subtest: engines-queued
[487.262142] Starting dynamic subtest: rcs0
[487.378313] Dynamic subtest rcs0: SUCCESS (0.115s)
[487.390067] Starting dynamic subtest: bcs0
[487.410613] Dynamic subtest bcs0: SUCCESS (0.031s)
[487.420843] Starting dynamic subtest: vcs0
[489.218991] Dynamic subtest vcs0: SUCCESS (1.772s)
[489.232346] Starting dynamic subtest: vcs1
[491.266780] Dynamic subtest vcs1: SUCCESS (2.016s)
[491.278838] Starting dynamic subtest: vecs0
[493.250615] Dynamic subtest vecs0: SUCCESS (1.959s)
[493.272049] Starting dynamic subtest: ccs0
[493.440713] Dynamic subtest ccs0: SUCCESS (0.187s)
[493.443138] Subtest engines-queued: SUCCESS (6.092s)
[493.614788] [067/131] (537s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[493.725084] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[493.729524] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[493.848105] [068/131] (537s left) perf (create-destroy-userspace-config)
[494.006309] Starting subtest: create-destroy-userspace-config
[494.029046] Subtest create-destroy-userspace-config: SUCCESS (0.022s)
[494.073846] [069/131] (537s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[494.187465] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[494.191405] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[494.299640] [070/131] (537s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[494.375460] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[494.462635] [071/131] (537s left) gem_mmap_gtt (big-copy-odd)
[494.530958] Subtest big-copy-odd: SKIP (0.000s)
[494.602087] [072/131] (536s left) kms_vblank (query-idle)
[494.705662] Starting subtest: query-idle
[494.707538] Starting dynamic subtest: pipe-A-eDP-1
[496.476881] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.758s)
[496.491616] Starting dynamic subtest: pipe-D-eDP-1
[498.962161] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.469s)
[498.964484] Subtest query-idle: SUCCESS (4.231s)
[499.816954] [073/131] (531s left) kms_cursor_edge_walk (256x256-top-edge)
[499.918097] Starting subtest: 256x256-top-edge
[499.920357] Starting dynamic subtest: pipe-A-eDP-1
[503.367395] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.436s)
[503.378181] Starting dynamic subtest: pipe-D-eDP-1
[506.488583] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.112s)
[506.490435] Subtest 256x256-top-edge: SUCCESS (6.551s)
[507.347008] [074/131] (524s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[507.406712] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[507.408909] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[507.539478] [075/131] (524s left) dumb_buffer (create-valid-dumb)
[507.587244] Starting subtest: create-valid-dumb
[507.589370] Subtest create-valid-dumb: SUCCESS (0.000s)
[507.730399] [076/131] (524s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[507.828353] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[507.832534] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[507.975408] [077/131] (523s left) kms_pm_dc (dc5-dpms)
[509.085125] Starting subtest: dc5-dpms
[511.193743] Subtest dc5-dpms: SUCCESS (2.105s)
[511.297635] [078/131] (520s left) perf (per-context-mode-unprivileged)
[511.406161] Starting subtest: per-context-mode-unprivileged
[511.411008] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[511.453668] [079/131] (520s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[511.523838] Starting subtest: invalid-bsd2-flag-on-vebox
[511.526124] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[511.650581] [080/131] (520s left) syncobj_timeline (invalid-transfer-illegal-handle)
[511.705482] Starting subtest: invalid-transfer-illegal-handle
[511.707793] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[511.830545] [081/131] (520s left) kms_flip (2x-flip-vs-fences-interruptible)
[511.930618] Starting subtest: 2x-flip-vs-fences-interruptible
[511.935206] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[512.057757] [082/131] (519s left) kms_atomic (plane-overlay-legacy)
[512.172092] Starting subtest: plane-overlay-legacy
[512.174401] Starting dynamic subtest: pipe-A-eDP-1
[512.645246] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.469s)
[512.647555] Subtest plane-overlay-legacy: SUCCESS (0.472s)
[513.511352] [083/131] (518s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[513.622387] Starting subtest: 4-tiled-8bpp-rotate-90
[513.643475] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.021s)
[513.811326] [084/131] (518s left) gem_lmem_swapping (verify-random)
[513.858286] Subtest verify-random: SKIP (0.000s)
[513.904629] [085/131] (518s left) gem_mmap_offset (mmap-unmap)
[513.951068] Starting subtest: mmap-unmap
[513.953259] Starting dynamic subtest: smem0
[536.926963] Dynamic subtest smem0: SUCCESS (22.969s)
[536.930037] Subtest mmap-unmap: SUCCESS (22.970s)
[537.064402] [086/131] (495s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[537.166313] Starting subtest: flip-primary-invalidate-overlay
[548.767042] Subtest flip-primary-invalidate-overlay: SUCCESS (11.600s)
[548.920593] [087/131] (483s left) kms_plane_multiple (tiling-x)
[549.027619] Starting subtest: tiling-x
[549.029649] Starting dynamic subtest: pipe-A-eDP-1
[552.739326] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.707s)
[552.750780] Starting dynamic subtest: pipe-B-eDP-1
[557.168729] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.427s)
[557.179460] Starting dynamic subtest: pipe-C-eDP-1
[561.518151] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.348s)
[561.529322] Starting dynamic subtest: pipe-D-eDP-1
[565.867808] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.347s)
[565.870003] Subtest tiling-x: SUCCESS (16.834s)
[566.700375] [088/131] (465s left) gem_exec_flush (basic-batch-kernel-default-uc)
[566.785622] Starting subtest: basic-batch-kernel-default-uc
[574.446903] Subtest basic-batch-kernel-default-uc: SUCCESS (7.658s)
[574.659712] [089/131] (457s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[574.759918] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[581.867101] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.107s)
[582.050720] [090/131] (450s left) kms_vblank (wait-forked)
[582.145778] Starting subtest: wait-forked
[582.147861] Starting dynamic subtest: pipe-A-eDP-1
[583.954269] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.808s)
[583.970141] Starting dynamic subtest: pipe-D-eDP-1
[586.431461] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.474s)
[586.433317] Subtest wait-forked: SUCCESS (4.287s)
[587.321917] [091/131] (445s left) kms_color (ctm-signed)
[587.423439] Starting subtest: ctm-signed
[587.425342] Starting dynamic subtest: pipe-A-eDP-1
[589.573979] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.151s)
[589.584450] Starting dynamic subtest: pipe-B-eDP-1
[592.356680] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.783s)
[592.367019] Starting dynamic subtest: pipe-C-eDP-1
[595.081466] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.724s)
[595.092362] Starting dynamic subtest: pipe-D-eDP-1
[597.739761] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.659s)
[597.742165] Subtest ctm-signed: SUCCESS (10.320s)
[598.583637] [092/131] (433s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[603.727444] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[603.729731] Starting dynamic subtest: pipe-A-eDP-1
[615.454991] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.727s)
[615.465957] Starting dynamic subtest: pipe-B-eDP-1
[627.186498] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.729s)
[627.188650] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (23.460s)
[628.063527] [093/131] (404s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[628.174552] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[628.178501] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[628.317257] [094/131] (404s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[628.422061] Starting subtest: fbc-rgb101010-draw-mmap-wc
[633.047269] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.628s)
[634.267316] [095/131] (398s left) kms_cursor_crc (cursor-random-128x42)
[634.493238] Starting subtest: cursor-random-128x42
[634.552267] Subtest cursor-random-128x42: SKIP (0.050s)
[634.797590] [096/131] (397s left) gem_basic (create-fd-close)
[634.857938] Starting subtest: create-fd-close
[634.862337] Subtest create-fd-close: SUCCESS (0.000s)
[635.001650] [097/131] (397s left) gem_bad_reloc (negative-reloc)
[635.060516] Subtest negative-reloc: SKIP (0.000s)
[635.150545] [098/131] (397s left) gem_exec_reloc (basic-write-gtt-noreloc)
[635.213081] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[635.278416] [099/131] (397s left) vgem_basic (dmabuf-mmap)
[635.322227] Starting subtest: dmabuf-mmap
[635.351414] Subtest dmabuf-mmap: SUCCESS (0.031s)
[635.442710] [100/131] (397s left) perf (unprivileged-single-ctx-counters)
[635.544181] Starting subtest: unprivileged-single-ctx-counters
[635.548061] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[635.590752] [101/131] (397s left) gem_mmap_gtt (basic-small-copy)
[635.654847] Subtest basic-small-copy: SKIP (0.000s)
[635.721775] [102/131] (397s left) kms_async_flips (async-flip-suspend-resume)
[635.807466] Starting subtest: async-flip-suspend-resume
[636.188052] Starting dynamic subtest: pipe-A-eDP-1
[653.850844] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.254s)
[654.229321] Starting dynamic subtest: pipe-B-eDP-1
[672.843141] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.256s)
[673.199547] Starting dynamic subtest: pipe-C-eDP-1
[691.863774] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.284s)
[692.241631] Starting dynamic subtest: pipe-D-eDP-1
[710.847469] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.291s)
[710.850480] Subtest async-flip-suspend-resume: SUCCESS (14.565s)
[722.071997] [103/131] (320s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[722.477899] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[723.269511] [104/131] (319s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[723.388949] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[723.393785] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[723.527890] [105/131] (319s left) i915_query (engine-info-invalid)
[723.582115] Starting subtest: engine-info-invalid
[723.584582] Subtest engine-info-invalid: SUCCESS (0.000s)
[723.720768] [106/131] (319s left) perf (polling-parameterized)
[723.820589] Starting subtest: polling-parameterized
[743.839898] Subtest polling-parameterized: SUCCESS (19.893s)
[743.900219] [107/131] (299s left) api_intel_allocator (fork-simple-once)
[743.964547] Starting subtest: fork-simple-once
[743.978399] Subtest fork-simple-once: SUCCESS (0.016s)
[744.119966] [108/131] (299s left) kms_cursor_crc (cursor-sliding-32x32)
[744.272910] Starting subtest: cursor-sliding-32x32
[744.318086] Subtest cursor-sliding-32x32: SKIP (0.039s)
[744.618100] [109/131] (298s left) gem_mmap_wc (read)
[744.676834] Subtest read: SKIP (0.000s)
[744.742915] [110/131] (298s left) kms_psr (fbc-pr-sprite-render)
[744.839936] Starting subtest: fbc-pr-sprite-render
[744.844961] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[744.933735] [111/131] (298s left) gem_vm_create (execbuf)
[745.006930] Starting subtest: execbuf
[745.015636] Subtest execbuf: SUCCESS (0.009s)
[745.191970] [112/131] (298s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[745.294829] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[746.164724] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.870s)
[746.353274] [113/131] (297s left) gem_render_copy (linear-to-vebox-y-tiled)
[746.410712] Starting subtest: linear-to-vebox-y-tiled
[746.415728] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[746.614646] [114/131] (296s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[751.628771] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[751.631137] Starting dynamic subtest: pipe-A-eDP-1
[752.420360] Dynamic subtest pipe-A-eDP-1: SKIP (0.786s)
[752.430975] Starting dynamic subtest: pipe-B-eDP-1
[753.555109] Dynamic subtest pipe-B-eDP-1: SKIP (1.133s)
[753.560027] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.923s)
[754.759995] [115/131] (288s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[754.865950] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[754.868432] Starting dynamic subtest: pipe-A-eDP-1
[771.050374] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.854s)
[771.061748] Starting dynamic subtest: pipe-B-eDP-1
[789.026530] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.814s)
[789.037763] Starting dynamic subtest: pipe-C-eDP-1
[807.000360] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.814s)
[807.010925] Starting dynamic subtest: pipe-D-eDP-1
[824.989071] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.741s)
[824.991461] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (10.229s)
[832.188420] [116/131] (217s left) kms_plane_alpha_blend (constant-alpha-max)
[832.294959] Starting subtest: constant-alpha-max
[832.584023] Starting dynamic subtest: pipe-A-eDP-1
[833.574700] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.989s)
[833.586746] Starting dynamic subtest: pipe-D-eDP-1
[835.164590] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.588s)
[835.166974] Subtest constant-alpha-max: SUCCESS (2.871s)
[836.051615] [117/131] (213s left) gem_flink_basic (double-flink)
[836.118503] Starting subtest: double-flink
[836.120858] Subtest double-flink: SUCCESS (0.000s)
[836.255345] [118/131] (213s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[836.349292] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[836.351387] Starting dynamic subtest: pipe-A
[836.370323] Dynamic subtest pipe-A: SKIP (0.017s)
[836.383429] Starting dynamic subtest: pipe-B
[836.422998] Dynamic subtest pipe-B: SKIP (0.052s)
[836.432810] Starting dynamic subtest: pipe-C
[836.461856] Dynamic subtest pipe-C: SKIP (0.035s)
[836.477323] Starting dynamic subtest: pipe-D
[836.493058] Dynamic subtest pipe-D: SKIP (0.030s)
[836.497374] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.139s)
[836.610416] [119/131] (213s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[836.681890] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[836.752492] [120/131] (212s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[836.838133] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[836.842133] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[836.971114] [121/131] (212s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[837.098995] Starting subtest: cursorA-vs-flipA-atomic-transitions
[848.287868] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.182s)
[849.185137] [122/131] (200s left) gem_pread (self)
[849.254428] Subtest self: SKIP (0.000s)
[849.317825] [123/131] (200s left) gem_exec_reloc (basic-cpu-wc)
[849.372461] Subtest basic-cpu-wc: SKIP (0.000s)
[849.441616] [124/131] (200s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[849.501312] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[849.601587] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.101s)
[849.705518] [125/131] (200s left) kms_lease (master-vs-lease)
[849.795937] Starting subtest: master-vs-lease
[849.798204] Subtest master-vs-lease: SUCCESS (0.002s)
[849.932924] [126/131] (200s left) gem_exec_balancer (busy)
[849.989274] Starting subtest: busy
[851.691603] Subtest busy: SUCCESS (1.700s)
[852.052622] [127/131] (197s left) gen9_exec_parse (bb-start-param)
[852.114834] Subtest bb-start-param: SKIP (0.000s)
[852.184417] [128/131] (197s left) kms_pm_rpm (i2c)
[853.798456] Starting subtest: i2c
[859.349221] Subtest i2c: SUCCESS (5.541s)
[859.453942] [129/131] (190s left) kms_flip (plain-flip-ts-check)
[859.547871] Starting subtest: plain-flip-ts-check
[859.550079] Starting dynamic subtest: A-eDP1
[868.414913] Dynamic subtest A-eDP1: SUCCESS (8.861s)
[868.431528] Starting dynamic subtest: B-eDP1
[877.234385] Dynamic subtest B-eDP1: SUCCESS (8.813s)
[877.252394] Starting dynamic subtest: C-eDP1
[886.070302] Dynamic subtest C-eDP1: SUCCESS (8.829s)
[886.085191] Starting dynamic subtest: D-eDP1
[894.905173] Dynamic subtest D-eDP1: SUCCESS (8.829s)
[894.907560] Subtest plain-flip-ts-check: SUCCESS (35.343s)
[896.117990] [130/131] (154s left) gem_exec_params (invalid-ring2)
[896.218577] Starting subtest: invalid-ring2
[896.220477] Subtest invalid-ring2: SUCCESS (0.000s)
[896.480701] [131/131] (153s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[896.585190] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[896.589680] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[896.711974] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: vgem_basic
results: parsing output: 2/ for test: gem_exec_alignment
results: parsing output: 3/ for test: gem_userptr_blits
results: parsing output: 4/ for test: perf_pmu
results: parsing output: 5/ for test: prime_mmap
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_joiner
results: parsing output: 8/ for test: gem_exec_schedule
results: parsing output: 9/ for test: gem_exec_whisper
results: parsing output: 10/ for test: gem_lmem_swapping
results: parsing output: 11/ for test: kms_content_protection
results: parsing output: 12/ for test: gem_exec_schedule
results: parsing output: 13/ for test: kms_chamelium_color
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: gem_linear_blits
results: parsing output: 18/ for test: gem_workarounds
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: kms_cursor_legacy
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: kms_atomic_transition
results: parsing output: 24/ for test: gem_exec_fence
results: parsing output: 25/ for test: gem_render_copy
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: sysfs_heartbeat_interval
results: parsing output: 29/ for test: sw_sync
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_prime
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: kms_feature_discovery
results: parsing output: 35/ for test: gem_create
results: parsing output: 36/ for test: prime_mmap
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_flip_scaled_crc
results: parsing output: 39/ for test: gem_softpin
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_psr
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_setmode
results: parsing output: 45/ for test: api_intel_bb
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_partial_pwrite_pread
results: parsing output: 49/ for test: gem_exec_schedule
results: parsing output: 50/ for test: i915_hangman
results: parsing output: 51/ for test: gem_exec_fence
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: i915_drm_fdinfo
results: parsing output: 55/ for test: prime_vgem
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_flip_scaled_crc
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: i915_pm_rps
results: parsing output: 60/ for test: kms_chamelium_hpd
results: parsing output: 61/ for test: kms_dp_link_training
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: gem_ctx_isolation
results: parsing output: 65/ for test: gem_ctx_persistence
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: perf
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: gem_fenced_exec_thrash
results: parsing output: 70/ for test: gem_mmap_gtt
results: parsing output: 71/ for test: kms_vblank
results: parsing output: 72/ for test: kms_cursor_edge_walk
results: parsing output: 73/ for test: syncobj_wait
results: parsing output: 74/ for test: dumb_buffer
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_pm_dc
results: parsing output: 77/ for test: perf
results: parsing output: 78/ for test: gem_exec_params
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_atomic
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: gem_lmem_swapping
results: parsing output: 84/ for test: gem_mmap_offset
results: parsing output: 85/ for test: kms_psr_stress_test
results: parsing output: 86/ for test: kms_plane_multiple
results: parsing output: 87/ for test: gem_exec_flush
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_vblank
results: parsing output: 90/ for test: kms_color
results: parsing output: 91/ for test: kms_psr2_sf
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_cursor_crc
results: parsing output: 95/ for test: gem_basic
results: parsing output: 96/ for test: gem_bad_reloc
results: parsing output: 97/ for test: gem_exec_reloc
results: parsing output: 98/ for test: vgem_basic
results: parsing output: 99/ for test: perf
results: parsing output: 100/ for test: gem_mmap_gtt
results: parsing output: 101/ for test: kms_async_flips
results: parsing output: 102/ for test: kms_chamelium_edid
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: i915_query
results: parsing output: 105/ for test: perf
results: parsing output: 106/ for test: api_intel_allocator
results: parsing output: 107/ for test: kms_cursor_crc
results: parsing output: 108/ for test: gem_mmap_wc
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: gem_vm_create
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: gem_render_copy
results: parsing output: 113/ for test: kms_psr2_sf
results: parsing output: 114/ for test: kms_ccs
results: parsing output: 115/ for test: kms_plane_alpha_blend
results: parsing output: 116/ for test: gem_flink_basic
results: parsing output: 117/ for test: kms_plane_scaling
results: parsing output: 118/ for test: kms_pipe_b_c_ivb
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_cursor_legacy
results: parsing output: 121/ for test: gem_pread
results: parsing output: 122/ for test: gem_exec_reloc
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_lease
results: parsing output: 125/ for test: gem_exec_balancer
results: parsing output: 126/ for test: gen9_exec_parse
results: parsing output: 127/ for test: kms_pm_rpm
results: parsing output: 128/ for test: kms_flip
results: parsing output: 129/ for test: gem_exec_params
results: parsing output: 130/ for test: kms_frontbuffer_tracking
Done.