[54.893316] Initializing watchdogs
[54.893362]   /dev/watchdog0
[54.908526] [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]
[54.913107] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[54.915321] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[54.918612] [001/133] (960s left) kms_addfb_basic (bad-pitch-999)
[54.994730] Starting subtest: bad-pitch-999
[54.996769] Subtest bad-pitch-999: SUCCESS (0.000s)
[55.174335] [002/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[55.275242] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[55.279492] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[55.397354] [003/133] (960s left) gem_mmap_offset (bad-extensions)
[55.451131] Starting subtest: bad-extensions
[55.453093] Subtest bad-extensions: SUCCESS (0.000s)
[55.568577] [004/133] (959s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[55.630254] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[55.632294] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[55.748396] [005/133] (959s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[55.849868] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[55.853303] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[55.966803] [006/133] (959s left) kms_colorop (plane-xr30-xr30-ctm_3x4_oversaturate)
[56.090493] Subtest plane-XR30-XR30-ctm_3x4_oversaturate: SKIP (0.000s)
[56.180445] [007/133] (959s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[56.233097] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[56.336041] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.103s)
[56.418818] [008/133] (959s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[56.529839] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[56.534421] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[56.630129] [009/133] (959s left) kms_addfb_basic (unused-offsets)
[56.687573] Starting subtest: unused-offsets
[56.689831] Subtest unused-offsets: SUCCESS (0.000s)
[56.823709] [010/133] (958s left) kms_dp_link_training (uhbr-sst)
[56.912798] Starting subtest: uhbr-sst
[56.921474] Subtest uhbr-sst: SKIP (0.000s)
[57.003618] [011/133] (958s left) kms_psr (pr-primary-page-flip)
[57.092878] Starting subtest: pr-primary-page-flip
[57.096970] Subtest pr-primary-page-flip: SKIP (0.000s)
[57.173844] [012/133] (958s left) syncobj_wait (single-wait-submitted)
[57.228942] Starting subtest: single-wait-submitted
[57.336842] Subtest single-wait-submitted: SUCCESS (0.108s)
[57.421245] [013/133] (958s left) kms_plane (pixel-format)
[57.508153] Starting subtest: pixel-format
[57.545455] Starting dynamic subtest: pipe-A-plane-0
[62.261465] Dynamic subtest pipe-A-plane-0: SUCCESS (4.745s)
[62.269597] Starting dynamic subtest: pipe-A-plane-3
[64.519596] Dynamic subtest pipe-A-plane-3: SUCCESS (2.266s)
[64.527916] Starting dynamic subtest: pipe-A-plane-5
[64.730504] Dynamic subtest pipe-A-plane-5: SUCCESS (0.211s)
[65.826900] Starting dynamic subtest: pipe-B-plane-0
[70.576968] Dynamic subtest pipe-B-plane-0: SUCCESS (4.767s)
[70.584945] Starting dynamic subtest: pipe-B-plane-3
[73.029801] Dynamic subtest pipe-B-plane-3: SUCCESS (2.455s)
[73.038408] Starting dynamic subtest: pipe-B-plane-5
[73.241454] Dynamic subtest pipe-B-plane-5: SUCCESS (0.211s)
[73.548857] Subtest pixel-format: SUCCESS (16.096s)
[74.392741] [014/133] (941s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[74.497998] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[74.500365] Starting dynamic subtest: pipe-A-eDP-1
[74.523753] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[74.533118] Starting dynamic subtest: pipe-B-eDP-1
[74.554678] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[74.561964] Starting dynamic subtest: pipe-C-eDP-1
[74.583442] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[74.590829] Starting dynamic subtest: pipe-D-eDP-1
[74.612992] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[74.617065] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[76.755583] [015/133] (939s left) kms_flip (plain-flip-interruptible)
[76.842456] Starting subtest: plain-flip-interruptible
[76.844695] Starting dynamic subtest: A-eDP1
[78.545610] Dynamic subtest A-eDP1: SUCCESS (1.703s)
[78.555503] Starting dynamic subtest: B-eDP1
[80.183839] Dynamic subtest B-eDP1: SUCCESS (1.638s)
[80.192925] Starting dynamic subtest: C-eDP1
[81.807187] Dynamic subtest C-eDP1: SUCCESS (1.623s)
[81.817217] Starting dynamic subtest: D-eDP1
[83.428093] Dynamic subtest D-eDP1: SUCCESS (1.620s)
[83.430529] Subtest plain-flip-interruptible: SUCCESS (6.591s)
[84.621401] [016/133] (931s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[84.712507] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[85.494526] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.784s)
[85.654280] [017/133] (930s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[86.042884] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[86.814846] [018/133] (929s left) kms_colorop (plane-xr24-xr24-bt2020_oetf)
[86.946662] Subtest plane-XR24-XR24-bt2020_oetf: SKIP (0.000s)
[87.040036] [019/133] (929s left) kms_big_fb (linear-8bpp-rotate-270)
[87.139013] Starting subtest: linear-8bpp-rotate-270
[87.159871] Subtest linear-8bpp-rotate-270: SKIP (0.020s)
[87.302996] [020/133] (928s left) gem_ctx_create (basic)
[87.360022] Starting subtest: basic
[87.362354] Subtest basic: SUCCESS (0.000s)
[87.555285] [021/133] (928s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[87.670654] Starting subtest: flip-vs-cursor-crc-atomic
[88.363404] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.690s)
[89.172241] [022/133] (927s left) perf (gen12-group-exclusive-stream-sample-oa)
[89.310725] Starting subtest: gen12-group-exclusive-stream-sample-oa
[89.328260] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.019s)
[89.370307] [023/133] (926s left) sysfs_heartbeat_interval (invalid)
[89.423763] Starting subtest: invalid
[89.426114] Starting dynamic subtest: vecs0
[89.428535] Dynamic subtest vecs0: SUCCESS (0.000s)
[89.436735] Starting dynamic subtest: ccs0
[89.438651] Dynamic subtest ccs0: SUCCESS (0.000s)
[89.445453] Starting dynamic subtest: vcs0
[89.447411] Dynamic subtest vcs0: SUCCESS (0.000s)
[89.454220] Starting dynamic subtest: bcs0
[89.456110] Dynamic subtest bcs0: SUCCESS (0.000s)
[89.462803] Starting dynamic subtest: rcs0
[89.464749] Dynamic subtest rcs0: SUCCESS (0.000s)
[89.471473] Starting dynamic subtest: vcs1
[89.473391] Dynamic subtest vcs1: SUCCESS (0.000s)
[89.475720] Subtest invalid: SUCCESS (0.003s)
[89.541568] [024/133] (926s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[89.645049] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[89.647365] Starting dynamic subtest: pipe-A-default-mode
[89.935020] Dynamic subtest pipe-A-default-mode: SKIP (0.289s)
[89.939879] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.290s)
[90.805902] [025/133] (925s left) kms_dsc (dsc-with-output-formats-with-bpc)
[90.901550] Starting subtest: dsc-with-output-formats-with-bpc
[90.959096] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[90.998088] [026/133] (925s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[91.102424] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[98.156703] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.056s)
[98.299697] [027/133] (918s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[98.365100] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[98.431566] [028/133] (918s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[98.527738] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[103.000416] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.476s)
[104.135781] [029/133] (912s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[104.236255] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[104.238848] Starting dynamic subtest: pipe-A-eDP-1
[104.261828] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[104.271989] Starting dynamic subtest: pipe-B-eDP-1
[104.292583] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[104.299777] Starting dynamic subtest: pipe-C-eDP-1
[104.321255] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[104.328116] Starting dynamic subtest: pipe-D-eDP-1
[104.349832] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[104.354181] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[106.501117] [030/133] (910s left) gem_mmap_gtt (big-copy-odd)
[106.550775] Subtest big-copy-odd: SKIP (0.000s)
[106.612047] [031/133] (909s left) kms_cursor_crc (cursor-tearing-position-change)
[106.732932] Starting subtest: cursor-tearing-position-change
[106.735248] Starting dynamic subtest: pipe-A-eDP-1
[107.322722] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.586s)
[107.333597] Starting dynamic subtest: pipe-D-eDP-1
[108.519547] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.195s)
[108.521713] Subtest cursor-tearing-position-change: SUCCESS (1.783s)
[109.369191] [032/133] (907s left) gem_lmem_swapping (basic)
[109.410835] Subtest basic: SKIP (0.000s)
[109.447672] [033/133] (907s left) i915_pm_rpm (gem-mmap-type)
[111.073645] Starting subtest: gem-mmap-type
[111.076113] Starting dynamic subtest: wb-smem0
[115.058193] Dynamic subtest wb-smem0: SUCCESS (3.985s)
[115.067126] Starting dynamic subtest: wc-smem0
[117.926849] Dynamic subtest wc-smem0: SUCCESS (2.868s)
[117.934424] Starting dynamic subtest: uc-smem0
[121.092240] Dynamic subtest uc-smem0: SUCCESS (3.164s)
[121.094438] Subtest gem-mmap-type: SUCCESS (10.021s)
[121.210982] [034/133] (895s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[121.304969] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[121.309247] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[121.433797] [035/133] (895s left) perf_pmu (busy-no-semaphores)
[121.470287] Starting subtest: busy-no-semaphores
[121.472592] Starting dynamic subtest: rcs0
[122.037097] Dynamic subtest rcs0: SUCCESS (0.565s)
[122.046084] Starting dynamic subtest: bcs0
[122.587231] Dynamic subtest bcs0: SUCCESS (0.548s)
[122.601388] Starting dynamic subtest: vcs0
[123.136618] Dynamic subtest vcs0: SUCCESS (0.547s)
[123.146653] Starting dynamic subtest: vcs1
[124.439255] Dynamic subtest vcs1: SUCCESS (1.300s)
[124.449994] Starting dynamic subtest: vecs0
[126.422644] Dynamic subtest vecs0: SUCCESS (1.981s)
[126.433386] Starting dynamic subtest: ccs0
[128.410288] Dynamic subtest ccs0: SUCCESS (1.985s)
[128.413437] Subtest busy-no-semaphores: SUCCESS (6.940s)
[128.548811] [036/133] (888s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[128.672892] Starting subtest: flip-vs-cursor-busy-crc-atomic
[129.475692] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.802s)
[130.278424] [037/133] (886s left) gem_spin_batch (spin-all-new)
[130.340357] Starting subtest: spin-all-new
[130.352073] Subtest spin-all-new: SUCCESS (0.013s)
[131.973699] [038/133] (884s left) i915_drm_fdinfo (virtual-busy)
[132.009901] Starting subtest: virtual-busy
[132.013987] Subtest virtual-busy: SKIP (0.000s)
[132.121246] [039/133] (884s left) kms_lease (possible-crtcs-filtering)
[132.225321] Starting subtest: possible-crtcs-filtering
[132.229999] Subtest possible-crtcs-filtering: SUCCESS (0.005s)
[132.348070] [040/133] (884s left) gem_exec_store (cachelines)
[132.421208] Starting subtest: cachelines
[132.423198] Starting dynamic subtest: rcs0
[132.511134] Dynamic subtest rcs0: SUCCESS (0.091s)
[132.522689] Starting dynamic subtest: bcs0
[132.572859] Dynamic subtest bcs0: SUCCESS (0.060s)
[132.583471] Starting dynamic subtest: vcs0
[132.633195] Dynamic subtest vcs0: SUCCESS (0.059s)
[132.643954] Starting dynamic subtest: vcs1
[132.701120] Dynamic subtest vcs1: SUCCESS (0.066s)
[132.711345] Starting dynamic subtest: vecs0
[132.767140] Dynamic subtest vecs0: SUCCESS (0.064s)
[132.777078] Starting dynamic subtest: ccs0
[132.828391] Dynamic subtest ccs0: SUCCESS (0.060s)
[132.830840] Subtest cachelines: SUCCESS (0.410s)
[133.028096] [041/133] (883s left) gem_exec_schedule (u-fairslice-all)
[133.099562] Starting subtest: u-fairslice-all
[135.155214] Subtest u-fairslice-all: SUCCESS (2.063s)
[137.033656] [042/133] (879s left) gem_tiled_partial_pwrite_pread (writes)
[137.092349] Subtest writes: SKIP (0.000s)
[137.176376] [043/133] (879s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[137.282765] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[138.350762] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.068s)
[138.501529] [044/133] (878s left) kms_getfb (getfb-repeated-different-handles)
[138.604495] Starting subtest: getfb-repeated-different-handles
[138.606278] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[138.727252] [045/133] (878s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[138.820380] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[138.822307] Starting dynamic subtest: pipe-A-default-mode
[141.499225] Dynamic subtest pipe-A-default-mode: SUCCESS (2.677s)
[141.501708] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.679s)
[142.372379] [046/133] (874s left) api_intel_bb (blit-noreloc-purge-cache)
[142.435806] Starting subtest: blit-noreloc-purge-cache
[142.447669] Subtest blit-noreloc-purge-cache: SUCCESS (0.012s)
[142.619888] [047/133] (874s left) kms_pm_rpm (modeset-non-lpsp)
[144.139055] Starting subtest: modeset-non-lpsp
[145.305377] Subtest modeset-non-lpsp: SKIP (1.168s)
[145.712699] [048/133] (871s left) gem_ctx_shared (q-promotion)
[145.783049] Starting subtest: Q-promotion
[145.785435] Starting dynamic subtest: rcs0
[145.937139] Dynamic subtest rcs0: SUCCESS (0.153s)
[145.956032] Starting dynamic subtest: vcs0
[146.022977] Dynamic subtest vcs0: SUCCESS (0.083s)
[146.038859] Starting dynamic subtest: vcs1
[146.102066] Dynamic subtest vcs1: SUCCESS (0.078s)
[146.118516] Starting dynamic subtest: vecs0
[146.180104] Dynamic subtest vecs0: SUCCESS (0.078s)
[146.195165] Starting dynamic subtest: ccs0
[146.258478] Dynamic subtest ccs0: SUCCESS (0.077s)
[146.261081] Subtest Q-promotion: SUCCESS (0.476s)
[148.061868] [FACT gem_ctx_shared (q-promotion)] new: kernel.kmod_is_loaded.vgem: true
[148.065215] [049/133] (869s left) kms_plane_cursor (viewport)
[148.169222] Starting subtest: viewport
[148.173668] Starting dynamic subtest: pipe-A-eDP-1-size-64
[151.064176] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.895s)
[151.127150] Starting dynamic subtest: pipe-A-eDP-1-size-128
[154.053979] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.938s)
[154.112737] Starting dynamic subtest: pipe-A-eDP-1-size-256
[156.999964] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.893s)
[157.350354] Starting dynamic subtest: pipe-B-eDP-1-size-64
[161.010846] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.670s)
[161.071085] Starting dynamic subtest: pipe-B-eDP-1-size-128
[163.969760] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.906s)
[164.026065] Starting dynamic subtest: pipe-B-eDP-1-size-256
[166.858818] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.838s)
[167.207026] Starting dynamic subtest: pipe-C-eDP-1-size-64
[170.478472] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.282s)
[170.514694] Starting dynamic subtest: pipe-C-eDP-1-size-128
[173.045964] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.536s)
[173.083154] Starting dynamic subtest: pipe-C-eDP-1-size-256
[175.523481] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.447s)
[175.851163] Starting dynamic subtest: pipe-D-eDP-1-size-64
[179.065585] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.224s)
[179.102887] Starting dynamic subtest: pipe-D-eDP-1-size-128
[181.621570] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.524s)
[181.658471] Starting dynamic subtest: pipe-D-eDP-1-size-256
[184.110545] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.458s)
[184.430114] Subtest viewport: SUCCESS (36.258s)
[185.288523] [050/133] (832s left) dumb_buffer (create-clear)
[185.350023] Starting subtest: create-clear
[219.627308] Subtest create-clear: SUCCESS (34.274s)
[219.771786] [051/133] (797s left) gem_exec_reloc (basic-softpin)
[219.836404] Subtest basic-softpin: SKIP (0.000s)
[219.910070] [052/133] (797s left) gem_exec_schedule (implicit-read-write)
[219.977182] Starting subtest: implicit-read-write
[219.979511] Starting dynamic subtest: rcs0
[220.144506] Dynamic subtest rcs0: SUCCESS (0.177s)
[220.152710] Starting dynamic subtest: vcs0
[220.245904] Dynamic subtest vcs0: SUCCESS (0.101s)
[220.256758] Starting dynamic subtest: vcs1
[220.344098] Dynamic subtest vcs1: SUCCESS (0.097s)
[220.354320] Starting dynamic subtest: vecs0
[220.447142] Dynamic subtest vecs0: SUCCESS (0.103s)
[220.455688] Starting dynamic subtest: ccs0
[220.568981] Dynamic subtest ccs0: SUCCESS (0.121s)
[220.571732] Subtest implicit-read-write: SUCCESS (0.603s)
[222.028426] [053/133] (795s left) gem_watchdog (default-physical)
[222.090961] Starting subtest: default-physical
[223.858468] Subtest default-physical: SUCCESS (1.779s)
[223.968105] [054/133] (793s left) kms_content_protection (dp-mst-suspend-resume)
[224.109440] Starting subtest: dp-mst-suspend-resume
[224.114016] Subtest dp-mst-suspend-resume: SKIP (0.000s)
[224.257130] [055/133] (793s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[224.313548] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[224.417501] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.103s)
[224.504173] [056/133] (793s left) kms_cursor_crc (cursor-random-256x256)
[224.723598] Starting subtest: cursor-random-256x256
[224.725979] Starting dynamic subtest: pipe-A-eDP-1
[228.066059] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.341s)
[228.098527] Starting dynamic subtest: pipe-D-eDP-1
[232.102594] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.014s)
[232.105052] Subtest cursor-random-256x256: SUCCESS (7.380s)
[232.965440] [057/133] (784s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[233.061300] Starting subtest: extended-pageflip-modeset-hang-oldfb
[233.063533] Starting dynamic subtest: pipe-A
[240.950235] Dynamic subtest pipe-A: SUCCESS (7.887s)
[240.958665] Starting dynamic subtest: pipe-D
[249.554686] Dynamic subtest pipe-D: SUCCESS (8.601s)
[249.557079] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.494s)
[250.418977] [058/133] (767s left) kms_frontbuffer_tracking (fbc-1p-rte)
[250.513538] Starting subtest: fbc-1p-rte
[255.974952] Subtest fbc-1p-rte: SUCCESS (5.466s)
[257.135855] [059/133] (760s left) kms_prop_blob (blob-prop-lifetime)
[257.198971] Starting subtest: blob-prop-lifetime
[257.201505] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[257.321608] [060/133] (760s left) kms_chamelium_audio (dp-audio)
[257.716834] Subtest dp-audio: SKIP (0.000s)
[258.511957] [061/133] (759s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[258.618724] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[258.623119] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[258.750353] [062/133] (759s left) kms_invalid_mode (clock-too-high)
[258.843329] Starting subtest: clock-too-high
[258.845526] Starting dynamic subtest: pipe-A-eDP-1
[258.849510] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[258.858703] Starting dynamic subtest: pipe-B-eDP-1
[258.862838] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[258.871113] Starting dynamic subtest: pipe-C-eDP-1
[258.875089] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[258.883134] Starting dynamic subtest: pipe-D-eDP-1
[258.887101] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[258.891069] Subtest clock-too-high: SKIP (0.005s)
[258.937425] [063/133] (758s left) gem_eio (in-flight-internal-immediate)
[259.125779] Starting subtest: in-flight-internal-immediate
[260.961973] Subtest in-flight-internal-immediate: SUCCESS (1.834s)
[261.138489] [064/133] (756s left) kms_vblank (accuracy-idle)
[261.240308] Starting subtest: accuracy-idle
[261.242457] Starting dynamic subtest: pipe-A-eDP-1
[262.991566] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.751s)
[263.005224] Starting dynamic subtest: pipe-D-eDP-1
[265.465260] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.472s)
[265.467689] Subtest accuracy-idle: SUCCESS (4.226s)
[266.300447] [065/133] (751s left) gem_tiled_wc
[266.418119] [066/133] (751s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[266.543454] Starting subtest: flip-vs-cursor-atomic
[273.616665] Subtest flip-vs-cursor-atomic: SUCCESS (7.072s)
[274.448897] [067/133] (743s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[275.005141] Starting subtest: syncobj-stationary-timeline-chain-engines
[275.129418] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.124s)
[276.032415] [068/133] (742s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[276.129138] Starting subtest: fbc-pr-cursor-mmap-gtt
[276.133660] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[276.215340] [069/133] (741s left) gem_blits (basic)
[276.276858] Starting subtest: basic
[277.699226] Subtest basic: SUCCESS (1.422s)
[277.842683] [070/133] (740s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[277.937570] Starting subtest: fbc-rgb101010-draw-mmap-wc
[282.522537] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.587s)
[283.665229] [071/133] (734s left) gem_pwrite (basic-random)
[283.724326] Subtest basic-random: SKIP (0.000s)
[283.797550] [072/133] (734s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[283.904815] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[291.320432] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.418s)
[291.490697] [073/133] (726s left) perf_pmu (semaphore-busy)
[291.531299] Starting subtest: semaphore-busy
[291.533515] Starting dynamic subtest: rcs0
[293.186765] Dynamic subtest rcs0: SUCCESS (1.654s)
[293.197891] Starting dynamic subtest: bcs0
[294.817917] Dynamic subtest bcs0: SUCCESS (1.628s)
[294.829161] Starting dynamic subtest: vcs0
[299.407712] Dynamic subtest vcs0: SUCCESS (4.586s)
[299.418842] Starting dynamic subtest: vcs1
[305.423279] Dynamic subtest vcs1: SUCCESS (6.013s)
[305.433757] Starting dynamic subtest: vecs0
[311.439567] Dynamic subtest vecs0: SUCCESS (6.012s)
[311.450783] Starting dynamic subtest: ccs0
[314.513774] Dynamic subtest ccs0: SUCCESS (3.072s)
[314.516176] Subtest semaphore-busy: SUCCESS (22.982s)
[314.653463] [074/133] (703s left) kms_psr (fbc-psr2-primary-blt)
[314.744924] Starting subtest: fbc-psr2-primary-blt
[314.747246] Starting dynamic subtest: eDP-1
[314.751608] Dynamic subtest eDP-1: SKIP (0.000s)
[314.755883] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[314.842227] [075/133] (703s left) perf (non-system-wide-paranoid)
[314.942670] Starting subtest: non-system-wide-paranoid
[314.973212] Subtest non-system-wide-paranoid: SUCCESS (0.031s)
[315.019352] [076/133] (703s left) gem_exec_flush (basic-batch-kernel-default-wb)
[315.070533] Starting subtest: basic-batch-kernel-default-wb
[321.874446] Subtest basic-batch-kernel-default-wb: SUCCESS (6.804s)
[322.089152] [077/133] (696s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[322.193345] Starting subtest: async-flip-with-page-flip-events-linear
[322.573822] Starting dynamic subtest: pipe-A-eDP-1
[323.810776] Dynamic subtest pipe-A-eDP-1: FAIL (0.784s)
[323.819517] Starting dynamic subtest: pipe-B-eDP-1
[324.731721] Dynamic subtest pipe-B-eDP-1: FAIL (0.742s)
[324.854907] Starting dynamic subtest: pipe-C-eDP-1
[327.656208] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.753s)
[327.973499] Starting dynamic subtest: pipe-D-eDP-1
[330.784221] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.766s)
[330.786903] Subtest async-flip-with-page-flip-events-linear: FAIL (8.540s)
[331.939596] [078/133] (686s left) gem_exec_balancer (full-pulse)
[332.004622] Starting subtest: full-pulse
[336.732174] Subtest full-pulse: SUCCESS (4.729s)
[337.090627] [079/133] (681s left) kms_atomic (atomic-plane-damage)
[337.186781] Starting subtest: atomic-plane-damage
[337.236019] Starting dynamic subtest: pipe-A-eDP-1
[337.765841] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.529s)
[337.768103] Subtest atomic-plane-damage: SUCCESS (0.578s)
[338.683653] [080/133] (679s left) gem_ctx_param (get-priority-new-ctx)
[338.741143] Starting subtest: get-priority-new-ctx
[338.743570] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[338.880701] [081/133] (679s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[338.977029] Starting subtest: plane-upscale-20x20-with-rotation
[338.979377] Starting dynamic subtest: pipe-A
[339.201090] Dynamic subtest pipe-A: SUCCESS (0.227s)
[339.210362] Starting dynamic subtest: pipe-B
[340.538949] Dynamic subtest pipe-B: SUCCESS (1.336s)
[340.548261] Starting dynamic subtest: pipe-C
[341.878798] Dynamic subtest pipe-C: SUCCESS (1.339s)
[341.887362] Starting dynamic subtest: pipe-D
[343.208297] Dynamic subtest pipe-D: SUCCESS (1.329s)
[343.210668] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.234s)
[344.410398] [082/133] (674s left) gem_ctx_persistence (file)
[344.466211] Starting subtest: file
[344.585680] Subtest file: SUCCESS (0.119s)
[344.739533] [083/133] (673s left) gem_render_copy (yf-tiled)
[344.796837] Starting subtest: yf-tiled
[344.801524] Subtest yf-tiled: SKIP (0.000s)
[344.995796] [084/133] (673s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[345.092423] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[345.097067] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[346.233594] [085/133] (672s left) kms_colorop (plane-xr30-xr30-3dlut_17_12_rgb)
[346.358251] Subtest plane-XR30-XR30-3dlut_17_12_rgb: SKIP (0.000s)
[346.439104] [086/133] (672s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[346.496774] Starting subtest: multi-wait-available-unsubmitted-signaled
[346.499052] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.001s)
[346.618155] [087/133] (672s left) gem_create (create-ext-set-pat)
[346.788740] Starting subtest: create-ext-set-pat
[346.790832] Subtest create-ext-set-pat: SUCCESS (0.001s)
[346.899437] [088/133] (671s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[347.018580] Starting subtest: 2x-cursor-vs-flip-atomic
[347.023259] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[347.185710] [089/133] (671s left) i915_query (query-garbage)
[347.248241] Starting subtest: query-garbage
[347.250485] Subtest query-garbage: SUCCESS (0.000s)
[347.376603] [090/133] (671s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[347.471749] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[354.339971] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.870s)
[354.515917] [091/133] (664s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[354.578686] Starting subtest: invalid-multi-wait-unsubmitted
[354.581070] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[354.700265] [092/133] (664s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[354.810447] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[354.814542] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[354.944106] [093/133] (664s left) gem_exec_reloc (basic-active)
[355.001144] Subtest basic-active: SKIP (0.000s)
[355.058471] [094/133] (664s left) i915_selftest (perf)
[357.021203] Starting subtest: perf
[357.023549] Starting dynamic subtest: engine_cs
[361.501653] Dynamic subtest engine_cs: SUCCESS (4.480s)
[361.516367] Starting dynamic subtest: request
[368.958098] Dynamic subtest request: SUCCESS (7.455s)
[368.972540] Starting dynamic subtest: migrate
[373.364282] Dynamic subtest migrate: SUCCESS (4.404s)
[373.372918] Starting dynamic subtest: region
[379.430082] Dynamic subtest region: SUCCESS (6.063s)
[379.432850] Subtest perf: SUCCESS (22.411s)
[379.460525] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[379.461238] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[379.464359] [095/133] (639s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[381.023331] Starting subtest: yf-tiled-8bpp-rotate-0
[381.027243] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[381.125474] [FACT kms_big_fb (yf-tiled-8bpp-rotate-0)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[381.126728] [FACT kms_big_fb (yf-tiled-8bpp-rotate-0)] new: kernel.kmod_is_loaded.i915: true
[381.130619] [096/133] (638s left) gem_exec_basic (basic)
[381.193044] Starting subtest: basic
[381.195206] Starting dynamic subtest: rcs0-smem
[381.200028] Dynamic subtest rcs0-smem: SUCCESS (0.007s)
[381.208740] Starting dynamic subtest: bcs0-smem
[381.210980] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[381.218637] Starting dynamic subtest: vcs0-smem
[381.220721] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[381.227999] Starting dynamic subtest: vcs1-smem
[381.230163] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[381.237480] Starting dynamic subtest: vecs0-smem
[381.239316] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[381.246185] Starting dynamic subtest: ccs0-smem
[381.248043] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[381.249934] Subtest basic: SUCCESS (0.018s)
[382.987843] [097/133] (636s left) i915_drm_fdinfo (virtual-busy-idle-all)
[383.028717] Starting subtest: virtual-busy-idle-all
[383.033575] Subtest virtual-busy-idle-all: SKIP (0.000s)
[383.103678] [098/133] (636s left) gem_create (create-invalid-size)
[383.165862] Starting subtest: create-invalid-size
[383.168088] Subtest create-invalid-size: SUCCESS (0.000s)
[383.372705] [099/133] (635s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[383.470873] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[383.475085] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[383.586309] [100/133] (635s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[383.887742] Starting subtest: cursor-rapid-movement-max-size
[383.894637] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[384.076109] [101/133] (635s left) gem_fence_thrash (bo-write-verify-threaded-y)
[384.110457] Starting subtest: bo-write-verify-threaded-y
[384.134634] Subtest bo-write-verify-threaded-y: SKIP (0.023s)
[384.209367] [102/133] (635s left) gem_mmap_wc (write-cpu-read-wc)
[384.274893] Subtest write-cpu-read-wc: SKIP (0.000s)
[384.341078] [103/133] (635s left) gem_pwrite_snooped
[384.471902] [104/133] (635s left) api_intel_bb (lot-of-buffers)
[384.522717] Starting subtest: lot-of-buffers
[385.553656] Subtest lot-of-buffers: SUCCESS (1.032s)
[386.037206] [105/133] (633s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[391.102516] Starting subtest: pr-overlay-plane-move-continuous-sf
[391.107336] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.002s)
[391.973999] [106/133] (627s left) kms_psr (psr-sprite-blt)
[392.062984] Starting subtest: psr-sprite-blt
[392.065512] Starting dynamic subtest: eDP-1
[393.777322] Dynamic subtest eDP-1: SUCCESS (1.714s)
[393.779692] Subtest psr-sprite-blt: SUCCESS (1.716s)
[394.629612] [107/133] (625s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[394.726305] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[394.730441] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[394.836721] [108/133] (624s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[394.939690] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[394.942077] Starting dynamic subtest: pipe-A-eDP-1
[395.000053] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[395.008264] Starting dynamic subtest: pipe-B-eDP-1
[395.065647] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[395.075710] Starting dynamic subtest: pipe-C-eDP-1
[395.136342] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[395.146290] Starting dynamic subtest: pipe-D-eDP-1
[395.203318] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[395.207681] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[397.188437] [109/133] (622s left) gem_ctx_param (non-root-set)
[397.243923] Starting subtest: non-root-set
[397.272224] Subtest non-root-set: SUCCESS (0.028s)
[397.379659] [110/133] (622s left) kms_flip (busy-flip)
[397.475110] Starting subtest: busy-flip
[397.477396] Starting dynamic subtest: A-eDP1
[399.189304] Dynamic subtest A-eDP1: SUCCESS (1.712s)
[399.200845] Starting dynamic subtest: B-eDP1
[400.835703] Dynamic subtest B-eDP1: SUCCESS (1.645s)
[400.845636] Starting dynamic subtest: C-eDP1
[402.568926] Dynamic subtest C-eDP1: SUCCESS (1.732s)
[402.579868] Starting dynamic subtest: D-eDP1
[404.199251] Dynamic subtest D-eDP1: SUCCESS (1.629s)
[404.201656] Subtest busy-flip: SUCCESS (6.727s)
[405.375797] [111/133] (614s left) gem_ctx_param (invalid-set-ringsize)
[405.425662] Starting subtest: invalid-set-ringsize
[405.427892] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[405.522462] [112/133] (614s left) gem_eio (in-flight-1us)
[405.720668] Starting subtest: in-flight-1us
[413.646051] Subtest in-flight-1us: SUCCESS (7.923s)
[413.786340] [113/133] (606s left) syncobj_timeline (reset-multiple-signaled)
[413.840555] Starting subtest: reset-multiple-signaled
[413.842918] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[413.957812] [114/133] (606s left) sriov_basic (bind-unbind-vf)
[414.012056] Starting subtest: bind-unbind-vf
[414.014407] Starting dynamic subtest: vf-1
[414.089299] Dynamic subtest vf-1: FAIL (0.005s)
[414.100196] Starting dynamic subtest: vf-2
[414.174099] Dynamic subtest vf-2: FAIL (0.004s)
[414.184519] Starting dynamic subtest: vf-3
[414.256595] Dynamic subtest vf-3: FAIL (0.003s)
[414.266172] Starting dynamic subtest: vf-4
[414.338766] Dynamic subtest vf-4: FAIL (0.003s)
[414.349150] Starting dynamic subtest: vf-5
[414.421757] Dynamic subtest vf-5: FAIL (0.004s)
[414.431434] Starting dynamic subtest: vf-6
[414.490227] Dynamic subtest vf-6: FAIL (0.003s)
[414.498679] Starting dynamic subtest: vf-7
[414.560329] Dynamic subtest vf-7: FAIL (0.004s)
[414.569586] Starting dynamic subtest: vf-random
[414.628015] Dynamic subtest vf-random: FAIL (0.003s)
[414.637869] Starting dynamic subtest: vf-last
[414.699697] Dynamic subtest vf-last: FAIL (0.488s)
[414.701378] Subtest bind-unbind-vf: FAIL (0.525s)
[414.737556] [115/133] (605s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[414.853121] Starting subtest: flip-vs-cursor-busy-crc-legacy
[415.670073] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.817s)
[416.515299] [116/133] (603s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[416.606792] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[416.609159] Starting dynamic subtest: A-eDP1
[420.219681] Dynamic subtest A-eDP1: SUCCESS (3.608s)
[420.229425] Starting dynamic subtest: B-eDP1
[423.413365] Dynamic subtest B-eDP1: SUCCESS (3.194s)
[423.423023] Starting dynamic subtest: C-eDP1
[426.505716] Dynamic subtest C-eDP1: SUCCESS (3.092s)
[426.515567] Starting dynamic subtest: D-eDP1
[429.629597] Dynamic subtest D-eDP1: SUCCESS (3.122s)
[429.631911] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.023s)
[430.455463] [117/133] (589s left) prime_self_import (basic-with_one_bo_two_files)
[430.490417] Starting subtest: basic-with_one_bo_two_files
[430.507524] Subtest basic-with_one_bo_two_files: SUCCESS (0.021s)
[430.643755] [118/133] (589s left) prime_self_import (export-vs-gem_close-race)
[430.676698] Starting subtest: export-vs-gem_close-race
[435.785617] Subtest export-vs-gem_close-race: SUCCESS (5.099s)
[435.872361] [119/133] (584s left) kms_psr (fbc-psr2-primary-page-flip)
[435.978251] Starting subtest: fbc-psr2-primary-page-flip
[435.980453] Starting dynamic subtest: eDP-1
[435.984508] Dynamic subtest eDP-1: SKIP (0.000s)
[435.988569] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[436.065713] [120/133] (584s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[436.157593] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[436.161968] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[436.276406] [121/133] (583s left) kms_tiled_display (basic-test-pattern)
[436.395601] Subtest basic-test-pattern: SKIP (0.000s)
[436.443026] [122/133] (583s left) kms_chamelium_frames (hdmi-frame-dump)
[436.831799] Subtest hdmi-frame-dump: SKIP (0.000s)
[437.640126] [123/133] (582s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[437.737378] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[437.739785] Starting dynamic subtest: pipe-A
[438.851771] Dynamic subtest pipe-A: SUCCESS (1.117s)
[438.861108] Starting dynamic subtest: pipe-B
[441.042080] Dynamic subtest pipe-B: SUCCESS (2.189s)
[441.050526] Starting dynamic subtest: pipe-C
[442.254439] Dynamic subtest pipe-C: SUCCESS (1.210s)
[442.268591] Starting dynamic subtest: pipe-D
[443.494673] Dynamic subtest pipe-D: SUCCESS (1.239s)
[443.497244] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.761s)
[444.697533] [124/133] (575s left) gem_lmem_swapping (verify-random)
[444.742158] Subtest verify-random: SKIP (0.000s)
[444.784402] [125/133] (575s left) kms_flip (flip-vs-absolute-wf_vblank)
[444.882926] Starting subtest: flip-vs-absolute-wf_vblank
[444.885237] Starting dynamic subtest: A-eDP1
[453.846775] Dynamic subtest A-eDP1: SUCCESS (8.964s)
[453.854944] Starting dynamic subtest: B-eDP1
[462.789809] Dynamic subtest B-eDP1: SUCCESS (8.941s)
[462.800943] Starting dynamic subtest: C-eDP1
[471.762091] Dynamic subtest C-eDP1: SUCCESS (8.926s)
[471.770576] Starting dynamic subtest: D-eDP1
[480.702486] Dynamic subtest D-eDP1: SUCCESS (8.936s)
[480.704717] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.776s)
[481.894937] [126/133] (538s left) kms_psr (psr2-no-drrs)
[481.999966] Starting subtest: psr2-no-drrs
[482.002346] Starting dynamic subtest: eDP-1
[483.665074] Dynamic subtest eDP-1: SUCCESS (1.661s)
[483.667339] Subtest psr2-no-drrs: SUCCESS (1.663s)
[484.485585] [127/133] (536s left) kms_hdr (brightness-with-hdr)
[484.572078] Starting subtest: brightness-with-hdr
[484.578267] Subtest brightness-with-hdr: SKIP (0.000s)
[484.668226] [128/133] (535s left) gen9_exec_parse (batch-invalid-length)
[484.716468] Subtest batch-invalid-length: SKIP (0.000s)
[484.799644] [129/133] (535s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[484.897266] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[486.044857] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.147s)
[486.224172] [130/133] (534s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[486.321341] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[486.324756] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[486.434197] [131/133] (534s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[486.536388] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[490.814470] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.282s)
[492.019842] [132/133] (528s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[492.082409] Starting subtest: yf-tiled-to-vebox-x-tiled
[492.087061] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[492.280872] [133/133] (528s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[492.391768] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[492.395802] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[492.517631] Closing watchdogs
results: parsing output: 0/ for test: kms_addfb_basic
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_mmap_offset
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_colorop
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: kms_addfb_basic
results: parsing output: 9/ for test: kms_dp_link_training
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: syncobj_wait
results: parsing output: 12/ for test: kms_plane
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: kms_flip
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: kms_chamelium_hpd
results: parsing output: 17/ for test: kms_colorop
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: gem_ctx_create
results: parsing output: 20/ for test: kms_cursor_legacy
results: parsing output: 21/ for test: perf
results: parsing output: 22/ for test: sysfs_heartbeat_interval
results: parsing output: 23/ for test: kms_flip_scaled_crc
results: parsing output: 24/ for test: kms_dsc
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_pipe_b_c_ivb
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: gem_mmap_gtt
results: parsing output: 30/ for test: kms_cursor_crc
results: parsing output: 31/ for test: gem_lmem_swapping
results: parsing output: 32/ for test: i915_pm_rpm
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: perf_pmu
results: parsing output: 35/ for test: kms_cursor_legacy
results: parsing output: 36/ for test: gem_spin_batch
results: parsing output: 37/ for test: i915_drm_fdinfo
results: parsing output: 38/ for test: kms_lease
results: parsing output: 39/ for test: gem_exec_store
results: parsing output: 40/ for test: gem_exec_schedule
results: parsing output: 41/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: kms_getfb
results: parsing output: 44/ for test: kms_flip_scaled_crc
results: parsing output: 45/ for test: api_intel_bb
results: parsing output: 46/ for test: kms_pm_rpm
results: parsing output: 47/ for test: gem_ctx_shared
results: parsing output: 48/ for test: kms_plane_cursor
results: parsing output: 49/ for test: dumb_buffer
results: parsing output: 50/ for test: gem_exec_reloc
results: parsing output: 51/ for test: gem_exec_schedule
results: parsing output: 52/ for test: gem_watchdog
results: parsing output: 53/ for test: kms_content_protection
results: parsing output: 54/ for test: syncobj_wait
results: parsing output: 55/ for test: kms_cursor_crc
results: parsing output: 56/ for test: kms_busy
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_prop_blob
results: parsing output: 59/ for test: kms_chamelium_audio
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_invalid_mode
results: parsing output: 62/ for test: gem_eio
results: parsing output: 63/ for test: kms_vblank
results: parsing output: 64/ for test: gem_tiled_wc
results: parsing output: 65/ for test: kms_cursor_legacy
results: parsing output: 66/ for test: gem_exec_fence
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: gem_blits
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_pwrite
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: perf_pmu
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: perf
results: parsing output: 75/ for test: gem_exec_flush
results: parsing output: 76/ for test: kms_async_flips
results: parsing output: 77/ for test: gem_exec_balancer
results: parsing output: 78/ for test: kms_atomic
results: parsing output: 79/ for test: gem_ctx_param
results: parsing output: 80/ for test: kms_plane_scaling
results: parsing output: 81/ for test: gem_ctx_persistence
results: parsing output: 82/ for test: gem_render_copy
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: kms_colorop
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: gem_create
results: parsing output: 87/ for test: kms_cursor_legacy
results: parsing output: 88/ for test: i915_query
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: syncobj_wait
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_exec_reloc
results: parsing output: 93/ for test: i915_selftest
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: gem_exec_basic
results: parsing output: 96/ for test: i915_drm_fdinfo
results: parsing output: 97/ for test: gem_create
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_cursor_crc
results: parsing output: 100/ for test: gem_fence_thrash
results: parsing output: 101/ for test: gem_mmap_wc
results: parsing output: 102/ for test: gem_pwrite_snooped
results: parsing output: 103/ for test: api_intel_bb
results: parsing output: 104/ for test: kms_psr2_sf
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: gem_ctx_param
results: parsing output: 109/ for test: kms_flip
results: parsing output: 110/ for test: gem_ctx_param
results: parsing output: 111/ for test: gem_eio
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: sriov_basic
results: parsing output: 114/ for test: kms_cursor_legacy
results: parsing output: 115/ for test: kms_flip
results: parsing output: 116/ for test: prime_self_import
results: parsing output: 117/ for test: prime_self_import
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_tiled_display
results: parsing output: 121/ for test: kms_chamelium_frames
results: parsing output: 122/ for test: kms_plane_scaling
results: parsing output: 123/ for test: gem_lmem_swapping
results: parsing output: 124/ for test: kms_flip
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: kms_hdr
results: parsing output: 127/ for test: gen9_exec_parse
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_render_copy
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.