[57.066878] Initializing watchdogs
[57.066924]   /dev/watchdog0
[57.080877] [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.085135] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.087267] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.090552] [001/133] (960s left) gem_exec_reloc (basic-cpu-wc)
[57.175814] Subtest basic-cpu-wc: SKIP (0.000s)
[57.238176] [002/133] (960s left) kms_flip (nonblocking-read)
[57.347739] Starting subtest: nonblocking-read
[57.349637] Subtest nonblocking-read: SUCCESS (0.000s)
[57.450578] [003/133] (960s left) perf (invalid-open-flags)
[57.582216] Starting subtest: invalid-open-flags
[57.584056] Subtest invalid-open-flags: SUCCESS (0.000s)
[57.623543] [004/133] (960s left) kms_content_protection (dp-mst-lic-type-1)
[57.760540] Starting subtest: dp-mst-lic-type-1
[57.765275] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[57.878116] [005/133] (959s left) kms_psr (psr2-sprite-plane-move)
[57.977235] Starting subtest: psr2-sprite-plane-move
[57.979249] Starting dynamic subtest: eDP-1
[59.766958] Dynamic subtest eDP-1: SUCCESS (1.790s)
[59.769548] Subtest psr2-sprite-plane-move: SUCCESS (1.790s)
[60.604214] [006/133] (957s left) gem_ctx_sseu (invalid-sseu)
[60.681118] Subtest invalid-sseu: SKIP (0.000s)
[60.766047] [007/133] (957s left) gem_eio (wait-wedge-1us)
[60.913742] Starting subtest: wait-wedge-1us
[62.309983] Subtest wait-wedge-1us: SUCCESS (1.396s)
[62.472316] [008/133] (955s left) kms_chamelium_frames (hdmi-crc-single)
[62.854552] Subtest hdmi-crc-single: SKIP (0.000s)
[63.626339] [009/133] (954s left) kms_dsc (dsc-basic)
[63.718340] Starting subtest: dsc-basic
[63.732333] Subtest dsc-basic: SKIP (0.000s)
[63.794635] [010/133] (954s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[63.885100] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[63.889376] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[63.953792] [011/133] (954s left) gem_sync (basic-all)
[64.034325] Starting subtest: basic-all
[67.270929] Subtest basic-all: SUCCESS (3.247s)
[67.454028] [012/133] (950s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[67.563329] Starting subtest: y-tiled-64bpp-rotate-90
[67.567267] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[67.655323] [013/133] (950s left) kms_properties (connector-properties-legacy)
[67.752284] Starting subtest: connector-properties-legacy
[67.754675] Starting dynamic subtest: pipe-A-eDP-1
[75.654952] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.901s)
[75.664320] Starting dynamic subtest: pipe-None-DP-1
[75.668504] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[75.677608] Starting dynamic subtest: pipe-None-HDMI-A-1
[75.681950] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[75.689687] Starting dynamic subtest: pipe-None-DP-2
[75.693770] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[75.700786] Starting dynamic subtest: pipe-None-HDMI-A-2
[75.705207] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[75.713671] Starting dynamic subtest: pipe-None-DP-3
[75.719242] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[75.728719] Starting dynamic subtest: pipe-None-DP-4
[75.733337] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[75.735621] Subtest connector-properties-legacy: SUCCESS (7.910s)
[76.517907] [014/133] (941s left) syncobj_basic (bad-flags-fd-to-handle)
[76.576996] Starting subtest: bad-flags-fd-to-handle
[76.579276] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[76.674696] [015/133] (941s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[76.768513] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[76.770810] Starting dynamic subtest: pipe-A-eDP-1
[82.611107] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.845s)
[82.626687] Starting dynamic subtest: pipe-B-eDP-1
[89.266580] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.655s)
[89.268798] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.502s)
[90.130728] [016/133] (928s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[90.231482] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[90.235689] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[90.326193] [017/133] (927s left) kms_pm_rpm (universal-planes)
[92.467708] Starting subtest: universal-planes
[92.469948] Starting dynamic subtest: plane-35
[100.801095] Dynamic subtest plane-35: SUCCESS (8.337s)
[100.811179] Starting dynamic subtest: plane-65
[109.103073] Dynamic subtest plane-65: SUCCESS (8.299s)
[109.114227] Starting dynamic subtest: plane-95
[117.403371] Dynamic subtest plane-95: SUCCESS (8.298s)
[117.413837] Starting dynamic subtest: plane-125
[125.680120] Dynamic subtest plane-125: SUCCESS (8.275s)
[125.692353] Starting dynamic subtest: plane-135
[133.982834] Dynamic subtest plane-135: SUCCESS (8.301s)
[133.992458] Starting dynamic subtest: plane-145
[142.282756] Dynamic subtest plane-145: SUCCESS (8.298s)
[142.285492] Subtest universal-planes: SUCCESS (49.819s)
[142.665378] [018/133] (875s left) kms_big_fb (linear-32bpp-rotate-90)
[142.767093] Starting subtest: linear-32bpp-rotate-90
[142.789760] Subtest linear-32bpp-rotate-90: SKIP (0.021s)
[142.901492] [019/133] (875s left) kms_mmap_write_crc (main)
[142.997677] Starting subtest: main
[143.000096] Starting dynamic subtest: pipe-A-eDP-1
[146.365591] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.365s)
[146.367637] Subtest main: SUCCESS (3.367s)
[147.185346] [020/133] (871s left) gem_wait (await)
[147.242436] Starting subtest: await
[147.244874] Starting dynamic subtest: all-engines
[148.382947] Dynamic subtest all-engines: SUCCESS (1.140s)
[148.398866] Starting dynamic subtest: rcs0
[149.437288] Dynamic subtest rcs0: SUCCESS (1.053s)
[149.452930] Starting dynamic subtest: bcs0
[150.493458] Dynamic subtest bcs0: SUCCESS (1.054s)
[150.509825] Starting dynamic subtest: vcs0
[151.547859] Dynamic subtest vcs0: SUCCESS (1.052s)
[151.562867] Starting dynamic subtest: vcs1
[152.600646] Dynamic subtest vcs1: SUCCESS (1.051s)
[152.616083] Starting dynamic subtest: vecs0
[153.654525] Dynamic subtest vecs0: SUCCESS (1.053s)
[153.670766] Starting dynamic subtest: ccs0
[154.711498] Dynamic subtest ccs0: SUCCESS (1.055s)
[154.714100] Subtest await: SUCCESS (7.469s)
[154.906638] [FACT gem_wait (await)] new: kernel.kmod_is_loaded.vgem: true
[154.909975] [021/133] (863s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[155.006503] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[155.010665] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[155.101686] [022/133] (863s left) kms_flip (absolute-wf_vblank-interruptible)
[155.192473] Starting subtest: absolute-wf_vblank-interruptible
[155.194861] Starting dynamic subtest: A-eDP1
[163.943797] Dynamic subtest A-eDP1: SUCCESS (8.749s)
[163.955605] Starting dynamic subtest: B-eDP1
[172.674174] Dynamic subtest B-eDP1: SUCCESS (8.727s)
[172.683367] Starting dynamic subtest: C-eDP1
[181.389304] Dynamic subtest C-eDP1: SUCCESS (8.712s)
[181.397613] Starting dynamic subtest: D-eDP1
[190.124101] Dynamic subtest D-eDP1: SUCCESS (8.734s)
[190.128781] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.934s)
[191.340898] [023/133] (827s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[191.454167] Starting subtest: cursor-tearing-framebuffer-change
[191.456554] Starting dynamic subtest: pipe-A-eDP-1
[192.033722] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.575s)
[192.043207] Starting dynamic subtest: pipe-D-eDP-1
[193.275667] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.241s)
[193.277710] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.819s)
[194.114758] [024/133] (824s left) gem_exec_schedule (preempt-contexts)
[194.186727] Starting subtest: preempt-contexts
[194.188980] Starting dynamic subtest: rcs0
[194.246571] Dynamic subtest rcs0: SUCCESS (0.066s)
[194.255284] Starting dynamic subtest: bcs0
[194.301393] Dynamic subtest bcs0: SUCCESS (0.054s)
[194.311422] Starting dynamic subtest: vcs0
[194.348441] Dynamic subtest vcs0: SUCCESS (0.046s)
[194.357223] Starting dynamic subtest: vcs1
[194.405023] Dynamic subtest vcs1: SUCCESS (0.055s)
[194.414518] Starting dynamic subtest: vecs0
[194.445231] Dynamic subtest vecs0: SUCCESS (0.040s)
[194.453810] Starting dynamic subtest: ccs0
[194.495546] Dynamic subtest ccs0: SUCCESS (0.050s)
[194.497754] Subtest preempt-contexts: SUCCESS (0.315s)
[196.382487] [025/133] (822s left) syncobj_wait (invalid-reset-zero-handles)
[196.450424] Starting subtest: invalid-reset-zero-handles
[196.452465] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[196.546670] [026/133] (822s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[196.637298] Starting subtest: fbcpsr-2p-rte
[196.641567] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[196.741107] [027/133] (821s left) gem_exec_whisper (basic-queues)
[196.803977] Starting subtest: basic-queues
[203.271756] Subtest basic-queues: SUCCESS (6.465s)
[203.457166] [028/133] (815s left) perf (oa-exponents)
[203.555923] Starting subtest: oa-exponents
[203.558645] Starting dynamic subtest: 0-rcs0
[205.362335] Dynamic subtest 0-rcs0: SUCCESS (1.805s)
[205.372740] Starting dynamic subtest: 1-vcs0
[207.189956] Dynamic subtest 1-vcs0: SUCCESS (1.827s)
[207.192486] Subtest oa-exponents: SUCCESS (3.633s)
[207.239214] [029/133] (811s left) prime_busy (before)
[207.287529] Starting subtest: before
[207.292595] Starting dynamic subtest: rcs0
[207.324130] Dynamic subtest rcs0: SUCCESS (0.034s)
[207.334173] Starting dynamic subtest: bcs0
[207.382754] Dynamic subtest bcs0: SUCCESS (0.058s)
[207.392827] Starting dynamic subtest: vcs0
[207.425533] Dynamic subtest vcs0: SUCCESS (0.043s)
[207.435096] Starting dynamic subtest: vcs1
[207.467054] Dynamic subtest vcs1: SUCCESS (0.041s)
[207.476295] Starting dynamic subtest: vecs0
[207.509842] Dynamic subtest vecs0: SUCCESS (0.042s)
[207.519703] Starting dynamic subtest: ccs0
[207.552527] Dynamic subtest ccs0: SUCCESS (0.042s)
[207.660831] Subtest before: SUCCESS (0.372s)
[207.740895] [030/133] (811s left) gem_ctx_engines (none)
[207.818601] Starting subtest: none
[207.820553] Subtest none: SUCCESS (0.001s)
[208.014791] [031/133] (810s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[208.131544] Starting subtest: verify-pxp-stale-buf-optout-execution
[209.194399] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.065s)
[209.321829] [032/133] (809s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[209.378888] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[209.487944] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.109s)
[209.563555] [033/133] (809s left) gem_exec_capture (capture)
[209.613512] Starting subtest: capture
[209.615976] Starting dynamic subtest: rcs0-smem
[210.449896] Dynamic subtest rcs0-smem: SUCCESS (0.834s)
[210.459745] Starting dynamic subtest: bcs0-smem
[211.273688] Dynamic subtest bcs0-smem: SUCCESS (0.824s)
[211.282429] Starting dynamic subtest: vcs0-smem
[212.103755] Dynamic subtest vcs0-smem: SUCCESS (0.828s)
[212.112148] Starting dynamic subtest: vcs1-smem
[212.920356] Dynamic subtest vcs1-smem: SUCCESS (0.818s)
[212.930527] Starting dynamic subtest: vecs0-smem
[214.316308] Dynamic subtest vecs0-smem: FAIL (1.333s)
[214.326464] Starting dynamic subtest: ccs0-smem
[215.581794] Dynamic subtest ccs0-smem: SUCCESS (1.325s)
[215.584228] Subtest capture: FAIL (5.966s)
[215.696242] [034/133] (803s left) gem_ctx_param (invalid-set-ringsize)
[215.748806] Starting subtest: invalid-set-ringsize
[215.751320] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[215.824224] [035/133] (803s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[215.934855] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[215.939153] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[216.031928] [036/133] (802s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[216.130911] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[222.853070] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.726s)
[222.986967] [037/133] (796s left) gem_exec_params (sol-reset-not-gen7)
[223.052190] Starting subtest: sol-reset-not-gen7
[223.054517] Subtest sol-reset-not-gen7: SUCCESS (0.002s)
[223.175210] [038/133] (795s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[223.265080] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[223.269350] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[223.355919] [039/133] (795s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[223.420125] Starting subtest: legacy-engines-hostile-preempt
[223.422533] Starting dynamic subtest: render
[223.473431] Dynamic subtest render: SUCCESS (0.053s)
[223.488060] Starting dynamic subtest: bsd1
[225.256760] Dynamic subtest bsd1: SUCCESS (1.780s)
[225.269112] Starting dynamic subtest: bsd2
[227.257583] Dynamic subtest bsd2: SUCCESS (1.998s)
[227.269543] Starting dynamic subtest: blt
[227.316080] Dynamic subtest blt: SUCCESS (0.057s)
[227.327439] Starting dynamic subtest: vebox
[229.316498] Dynamic subtest vebox: SUCCESS (1.997s)
[229.319242] Subtest legacy-engines-hostile-preempt: SUCCESS (5.896s)
[229.406745] [040/133] (789s left) gem_exec_params (no-bsd)
[229.475414] Starting subtest: no-bsd
[229.480375] Subtest no-bsd: SUCCESS (0.003s)
[231.348167] [041/133] (787s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[231.451634] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[231.456170] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[231.542363] [042/133] (787s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[231.654561] Starting subtest: basic-busy-flip-before-cursor-legacy
[231.659310] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[231.802375] [043/133] (787s left) kms_cdclk (plane-scaling)
[231.892842] Starting subtest: plane-scaling
[231.895075] Starting dynamic subtest: pipe-A-eDP-1
[232.186225] Dynamic subtest pipe-A-eDP-1: SKIP (0.289s)
[232.196880] Starting dynamic subtest: pipe-B-eDP-1
[232.201974] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[232.211114] Starting dynamic subtest: pipe-C-eDP-1
[232.215432] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[232.224571] Starting dynamic subtest: pipe-D-eDP-1
[232.228881] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[232.233163] Subtest plane-scaling: SKIP (0.296s)
[233.061057] [044/133] (786s left) gem_ccs (block-copy-uncompressed)
[233.125242] Starting subtest: block-copy-uncompressed
[233.127534] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[233.144923] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.021s)
[233.154076] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[233.163298] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.018s)
[233.171795] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[233.180240] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[233.189256] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[233.215319] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.034s)
[233.217580] Subtest block-copy-uncompressed: SUCCESS (0.093s)
[233.339134] [045/133] (786s left) kms_psr (fbc-pr-sprite-plane-move)
[233.422112] Starting subtest: fbc-pr-sprite-plane-move
[233.426627] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[233.516649] [046/133] (785s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[233.621368] Starting subtest: basic-flip-after-cursor-atomic
[234.538162] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.917s)
[235.395788] [047/133] (784s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[235.499095] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[235.503481] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[235.599754] [048/133] (783s left) gem_tiled_partial_pwrite_pread (reads)
[235.663858] Subtest reads: SKIP (0.000s)
[235.735487] [049/133] (783s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[235.833252] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[235.835548] Starting dynamic subtest: pipe-A
[236.082818] Dynamic subtest pipe-A: SUCCESS (0.251s)
[236.097931] Starting dynamic subtest: pipe-B
[237.386208] Dynamic subtest pipe-B: SUCCESS (1.302s)
[237.395314] Starting dynamic subtest: pipe-C
[238.707426] Dynamic subtest pipe-C: SUCCESS (1.320s)
[238.716584] Starting dynamic subtest: pipe-D
[240.053738] Dynamic subtest pipe-D: SUCCESS (1.345s)
[240.056095] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.223s)
[241.206188] [050/133] (778s left) gen7_exec_parse (batch-without-end)
[241.270311] Subtest batch-without-end: SKIP (0.000s)
[241.339750] [051/133] (778s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[241.432853] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[241.436966] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[241.531756] [052/133] (778s left) perf_pmu (invalid-open)
[241.568754] Starting subtest: invalid-open
[241.570867] Subtest invalid-open: SUCCESS (0.000s)
[241.663982] [053/133] (778s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[241.773205] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[241.777603] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[241.876766] [054/133] (777s left) perf_pmu (busy)
[241.913310] Starting subtest: busy
[241.915783] Starting dynamic subtest: rcs0
[242.499120] Dynamic subtest rcs0: SUCCESS (0.588s)
[242.510561] Starting dynamic subtest: bcs0
[243.059360] Dynamic subtest bcs0: SUCCESS (0.558s)
[243.070880] Starting dynamic subtest: vcs0
[244.288256] Dynamic subtest vcs0: SUCCESS (1.227s)
[244.299764] Starting dynamic subtest: vcs1
[246.275746] Dynamic subtest vcs1: SUCCESS (1.983s)
[246.287828] Starting dynamic subtest: vecs0
[248.323034] Dynamic subtest vecs0: SUCCESS (2.045s)
[248.338490] Starting dynamic subtest: ccs0
[248.898275] Dynamic subtest ccs0: SUCCESS (0.574s)
[248.900823] Subtest busy: SUCCESS (6.989s)
[248.996891] [055/133] (770s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[249.094086] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[249.096463] Starting dynamic subtest: pipe-A-eDP-1
[249.154595] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[249.455718] Starting dynamic subtest: pipe-B-eDP-1
[250.216279] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.769s)
[250.508258] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.412s)
[251.379922] [056/133] (768s left) kms_flip (bo-too-big)
[251.474612] Starting subtest: bo-too-big
[251.476964] Starting dynamic subtest: A-eDP1
[252.816669] Dynamic subtest A-eDP1: SUCCESS (1.341s)
[252.825812] Starting dynamic subtest: B-eDP1
[254.064746] Dynamic subtest B-eDP1: SUCCESS (1.247s)
[254.076767] Starting dynamic subtest: C-eDP1
[255.409161] Dynamic subtest C-eDP1: SUCCESS (1.342s)
[255.421499] Starting dynamic subtest: D-eDP1
[256.744918] Dynamic subtest D-eDP1: SUCCESS (1.334s)
[256.747474] Subtest bo-too-big: SUCCESS (5.274s)
[257.967884] [057/133] (761s left) i915_pm_rps (basic-api)
[258.029712] Starting subtest: basic-api
[258.033782] Subtest basic-api: SKIP (0.001s)
[258.131954] [058/133] (761s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[258.229044] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[258.231351] Starting dynamic subtest: pipe-A-eDP-1
[258.312377] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[258.322219] Starting dynamic subtest: pipe-B-eDP-1
[259.434384] Dynamic subtest pipe-B-eDP-1: SKIP (1.119s)
[259.438769] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.209s)
[260.620016] [059/133] (759s left) kms_psr (fbc-psr-sprite-blt)
[260.706106] Starting subtest: fbc-psr-sprite-blt
[260.708347] Starting dynamic subtest: eDP-1
[260.712354] Dynamic subtest eDP-1: SKIP (0.000s)
[260.716367] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[260.792997] [060/133] (759s left) gem_ringfill (engines-basic)
[266.309587] Starting subtest: engines-basic
[266.312188] Starting dynamic subtest: rcs0
[266.383022] Dynamic subtest rcs0: SUCCESS (0.072s)
[266.393493] Starting dynamic subtest: bcs0
[266.429749] Dynamic subtest bcs0: SUCCESS (0.045s)
[266.440041] Starting dynamic subtest: vcs0
[266.472739] Dynamic subtest vcs0: SUCCESS (0.041s)
[266.482719] Starting dynamic subtest: vcs1
[266.515317] Dynamic subtest vcs1: SUCCESS (0.040s)
[266.529062] Starting dynamic subtest: vecs0
[266.559324] Dynamic subtest vecs0: SUCCESS (0.042s)
[266.570806] Starting dynamic subtest: ccs0
[266.603847] Dynamic subtest ccs0: SUCCESS (0.043s)
[266.606473] Subtest engines-basic: SUCCESS (0.296s)
[266.687485] [061/133] (753s left) kms_psr (psr-dpms)
[266.792739] Starting subtest: psr-dpms
[266.794996] Starting dynamic subtest: eDP-1
[269.754825] Dynamic subtest eDP-1: SUCCESS (2.963s)
[269.757218] Subtest psr-dpms: SUCCESS (2.964s)
[270.624433] [062/133] (749s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[270.729238] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[271.397243] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.670s)
[271.550357] [063/133] (748s left) kms_joiner (basic-max-non-joiner)
[271.654629] Starting subtest: basic-max-non-joiner
[271.659030] Subtest basic-max-non-joiner: SKIP (0.000s)
[271.719593] [064/133] (748s left) i915_drm_fdinfo (virtual-idle)
[271.764375] Starting subtest: virtual-idle
[274.802080] Subtest virtual-idle: SUCCESS (3.034s)
[274.875796] [065/133] (745s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[274.979198] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[283.627557] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.651s)
[283.766716] [066/133] (736s left) gem_exec_balancer (full-pulse)
[283.831040] Starting subtest: full-pulse
[288.164503] Subtest full-pulse: SUCCESS (4.333s)
[288.481136] [067/133] (731s left) kms_selftest (drm_dp_mst_helper)
[288.518289] Starting subtest: drm_dp_mst_helper
[288.532051] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[288.626427] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.095s)
[288.635380] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[288.731439] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.103s)
[288.739777] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[288.842254] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.110s)
[288.844094] Subtest drm_dp_mst_helper: SUCCESS (0.324s)
[289.000244] [068/133] (731s left) kms_addfb_basic (tile-pitch-mismatch)
[289.061690] Starting subtest: tile-pitch-mismatch
[289.066268] Subtest tile-pitch-mismatch: SKIP (0.000s)
[289.228908] [069/133] (731s left) gem_huc_copy (huc-copy)
[289.297721] Starting subtest: huc-copy
[289.299933] Subtest huc-copy: SUCCESS (0.003s)
[289.418924] [070/133] (730s left) api_intel_bb (bb-with-allocator)
[289.468935] Starting subtest: bb-with-allocator
[289.474452] Subtest bb-with-allocator: SUCCESS (0.006s)
[289.605388] [071/133] (730s left) syncobj_timeline (wait-all-delayed-signal)
[289.653501] Starting subtest: wait-all-delayed-signal
[289.759305] Subtest wait-all-delayed-signal: SUCCESS (0.104s)
[289.835966] [072/133] (730s left) kms_psr (fbc-psr-suspend)
[289.950333] Starting subtest: fbc-psr-suspend
[289.952659] Starting dynamic subtest: eDP-1
[289.957138] Dynamic subtest eDP-1: SKIP (0.000s)
[289.961285] Subtest fbc-psr-suspend: SKIP (0.001s)
[290.022514] [073/133] (730s left) syncobj_wait (single-wait-for-submit-submitted)
[290.075816] Starting subtest: single-wait-for-submit-submitted
[290.183667] Subtest single-wait-for-submit-submitted: SUCCESS (0.107s)
[290.273549] [074/133] (730s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[290.372237] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[290.376920] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[290.459417] [075/133] (730s left) kms_flip (2x-flip-vs-panning-vs-hang)
[290.547466] Starting subtest: 2x-flip-vs-panning-vs-hang
[290.551900] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.002s)
[290.629274] [076/133] (730s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[290.720079] Starting subtest: addfb25-y-tiled-small-legacy
[290.724462] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[290.804501] [077/133] (729s left) syncobj_timeline (invalid-query-bad-pad)
[290.857505] Starting subtest: invalid-query-bad-pad
[290.859485] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[290.947428] [078/133] (729s left) kms_chamelium_hpd (hdmi-hpd)
[291.339626] Subtest hdmi-hpd: SKIP (0.000s)
[292.113375] [079/133] (728s left) dmabuf_sync_file (export-multiwait)
[292.162134] Starting subtest: export-multiwait
[292.164457] Subtest export-multiwait: SUCCESS (0.001s)
[292.230578] [080/133] (728s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[292.320366] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[292.324848] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[292.392883] [081/133] (728s left) gem_partial_pwrite_pread (reads)
[292.442605] Subtest reads: SKIP (0.000s)
[292.509211] [082/133] (728s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[292.602060] Starting subtest: fbcpsr-tiling-y
[292.605950] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[292.684168] [083/133] (728s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[292.806876] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[293.798211] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (0.992s)
[293.935577] [084/133] (727s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[294.204805] Starting subtest: cursor-rapid-movement-256x85
[294.249769] Subtest cursor-rapid-movement-256x85: SKIP (0.042s)
[294.450861] [085/133] (726s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[294.555869] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[294.559204] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[294.672689] [086/133] (726s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[294.768401] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[294.770279] Starting dynamic subtest: pipe-A-eDP-1
[294.915992] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.140s)
[294.926981] Starting dynamic subtest: pipe-B-eDP-1
[294.942358] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[294.951151] Starting dynamic subtest: pipe-C-eDP-1
[294.967507] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[294.977733] Starting dynamic subtest: pipe-D-eDP-1
[294.993278] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[294.994962] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.177s)
[297.201351] [087/133] (723s left) kms_pm_rpm (basic-pci-d3-state)
[299.431272] Starting subtest: basic-pci-d3-state
[300.909664] Subtest basic-pci-d3-state: SUCCESS (1.478s)
[301.012970] [088/133] (720s left) kms_joiner (invalid-modeset-ultra-joiner)
[301.105076] Starting subtest: invalid-modeset-ultra-joiner
[301.109281] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[301.168162] [089/133] (720s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[301.252140] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[301.254394] Starting dynamic subtest: pipe-A-eDP-1
[301.274065] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[301.284239] Starting dynamic subtest: pipe-B-eDP-1
[301.302432] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[301.311006] Starting dynamic subtest: pipe-C-eDP-1
[301.329458] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[301.337928] Starting dynamic subtest: pipe-D-eDP-1
[301.356195] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[301.357983] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[303.546602] [090/133] (717s left) sysfs_heartbeat_interval (mixed)
[303.601565] Starting subtest: mixed
[303.603803] Starting dynamic subtest: vecs0
[308.855178] Dynamic subtest vecs0: SUCCESS (5.252s)
[308.867217] Starting dynamic subtest: ccs0
[314.036900] Dynamic subtest ccs0: SUCCESS (5.179s)
[314.048673] Starting dynamic subtest: vcs0
[319.236318] Dynamic subtest vcs0: SUCCESS (5.197s)
[319.248019] Starting dynamic subtest: bcs0
[324.420905] Dynamic subtest bcs0: SUCCESS (5.182s)
[324.433192] Starting dynamic subtest: rcs0
[329.584567] Dynamic subtest rcs0: SUCCESS (5.162s)
[329.596225] Starting dynamic subtest: vcs1
[334.830567] Dynamic subtest vcs1: SUCCESS (5.245s)
[334.833204] Subtest mixed: SUCCESS (31.230s)
[334.923583] [091/133] (686s left) syncobj_timeline (multi-wait-submitted-signaled)
[334.982592] Starting subtest: multi-wait-submitted-signaled
[334.985038] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[335.073852] [092/133] (686s left) i915_drm_fdinfo (all-busy-idle-check-all)
[335.115460] Starting subtest: all-busy-idle-check-all
[335.122466] Subtest all-busy-idle-check-all: SKIP (0.003s)
[335.190180] [093/133] (686s left) kms_tv_load_detect (load-detect)
[335.279908] Subtest load-detect: SKIP (0.000s)
[335.352128] [094/133] (686s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[335.444910] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[335.474116] Starting dynamic subtest: pipe-A-plane-0
[335.762797] Dynamic subtest pipe-A-plane-0: SUCCESS (0.288s)
[335.773356] Starting dynamic subtest: pipe-A-plane-3
[335.995646] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[337.105380] Starting dynamic subtest: pipe-B-plane-0
[337.386468] Dynamic subtest pipe-B-plane-0: SUCCESS (0.289s)
[337.398031] Starting dynamic subtest: pipe-B-plane-3
[337.619750] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[337.926555] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.483s)
[338.776585] [095/133] (682s left) gem_exec_fence (syncobj-unused-fence)
[339.229959] Starting subtest: syncobj-unused-fence
[339.235069] Subtest syncobj-unused-fence: SUCCESS (0.005s)
[340.345606] [096/133] (681s left) kms_flip (flip-vs-blocking-wf-vblank)
[340.449518] Starting subtest: flip-vs-blocking-wf-vblank
[340.451853] Starting dynamic subtest: A-eDP1
[349.426050] Dynamic subtest A-eDP1: SUCCESS (8.976s)
[349.439979] Starting dynamic subtest: B-eDP1
[358.358474] Dynamic subtest B-eDP1: SUCCESS (8.929s)
[358.373386] Starting dynamic subtest: C-eDP1
[367.289068] Dynamic subtest C-eDP1: SUCCESS (8.927s)
[367.299783] Starting dynamic subtest: D-eDP1
[376.223731] Dynamic subtest D-eDP1: SUCCESS (8.929s)
[376.225885] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.775s)
[377.472139] [097/133] (644s left) gem_exec_reloc (basic-wc-read-active)
[377.534945] Subtest basic-wc-read-active: SKIP (0.000s)
[377.607919] [098/133] (643s left) kms_rotation_crc (bad-pixel-format)
[377.706403] Starting subtest: bad-pixel-format
[377.710682] Subtest bad-pixel-format: SKIP (0.001s)
[377.782821] [099/133] (643s left) kms_plane_multiple (2x-tiling-x)
[377.879927] Starting subtest: 2x-tiling-x
[377.883885] Subtest 2x-tiling-x: SKIP (0.000s)
[377.957540] [100/133] (643s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[378.022867] Starting subtest: single-wait-for-submit-unsubmitted
[378.127263] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.104s)
[378.203963] [101/133] (643s left) kms_vblank (ts-continuation-modeset-rpm)
[378.305947] Starting subtest: ts-continuation-modeset-rpm
[378.307821] Starting dynamic subtest: pipe-A-eDP-1
[380.859737] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.553s)
[380.874512] Starting dynamic subtest: pipe-D-eDP-1
[383.098025] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.236s)
[383.100328] Subtest ts-continuation-modeset-rpm: SUCCESS (4.792s)
[383.984737] [102/133] (637s left) gem_exec_fence (submit67)
[384.171059] Starting subtest: submit67
[384.175816] Subtest submit67: SKIP (0.000s)
[386.400771] [103/133] (635s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[386.447533] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[386.550224] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[386.632650] [104/133] (635s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[386.739671] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[386.893043] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.156s)
[386.998437] [105/133] (634s left) gem_mmap_gtt (basic-short)
[387.050138] Subtest basic-short: SKIP (0.000s)
[387.108393] [106/133] (634s left) gem_exec_schedule (semaphore-codependency)
[387.174880] Starting subtest: semaphore-codependency
[387.187295] Subtest semaphore-codependency: SUCCESS (0.021s)
[387.526269] [107/133] (634s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[387.636595] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[387.640624] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[387.748858] [108/133] (634s left) gem_exec_reloc (basic-cpu-gtt-active)
[387.817107] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[387.886764] [109/133] (634s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[387.998202] Starting subtest: psr-modesetfrombusy
[394.164970] Subtest psr-modesetfrombusy: SUCCESS (6.170s)
[394.291987] [110/133] (627s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[394.391442] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[394.393126] Starting dynamic subtest: pipe-A-eDP-1
[395.165935] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.769s)
[395.175067] Starting dynamic subtest: pipe-B-eDP-1
[396.685175] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.515s)
[396.695535] Starting dynamic subtest: pipe-C-eDP-1
[398.174603] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.489s)
[398.185283] Starting dynamic subtest: pipe-D-eDP-1
[399.704586] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.527s)
[399.706691] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.305s)
[400.873351] [111/133] (621s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[400.986288] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[400.990433] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[401.069199] [112/133] (621s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[401.167252] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[401.171367] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[401.240277] [113/133] (620s left) gem_ctx_create (basic)
[401.302970] Starting subtest: basic
[401.305268] Subtest basic: SUCCESS (0.000s)
[401.486806] [114/133] (620s left) api_intel_bb (offset-control)
[401.546676] Starting subtest: offset-control
[401.551406] Subtest offset-control: SUCCESS (0.008s)
[401.672558] [115/133] (620s left) kms_color_pipeline (plane-lut1d-lut1d)
[401.775674] Starting subtest: plane-lut1d-lut1d
[401.901459] Starting dynamic subtest: pipe-A-plane-0
[402.043879] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[402.054261] Starting dynamic subtest: pipe-A-plane-1
[402.177458] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[402.187138] Starting dynamic subtest: pipe-A-plane-2
[402.322168] Dynamic subtest pipe-A-plane-2: SUCCESS (0.144s)
[403.458993] Starting dynamic subtest: pipe-B-plane-0
[403.606181] Dynamic subtest pipe-B-plane-0: SUCCESS (0.155s)
[403.616366] Starting dynamic subtest: pipe-B-plane-1
[403.740059] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s)
[403.750503] Starting dynamic subtest: pipe-B-plane-2
[403.884341] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s)
[405.100462] Starting dynamic subtest: pipe-C-plane-0
[405.237082] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[405.249595] Starting dynamic subtest: pipe-C-plane-1
[405.370200] Dynamic subtest pipe-C-plane-1: SUCCESS (0.132s)
[405.384206] Starting dynamic subtest: pipe-C-plane-2
[405.514355] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[406.745811] Starting dynamic subtest: pipe-D-plane-0
[406.884112] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[406.893423] Starting dynamic subtest: pipe-D-plane-1
[407.038131] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[407.047682] Starting dynamic subtest: pipe-D-plane-2
[407.204618] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[407.495370] Subtest plane-lut1d-lut1d: SUCCESS (5.719s)
[408.304713] [116/133] (614s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[408.412031] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[408.414204] Starting dynamic subtest: pipe-A-eDP-1
[408.440038] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[408.453332] Starting dynamic subtest: pipe-B-eDP-1
[408.476243] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[408.486594] Starting dynamic subtest: pipe-C-eDP-1
[408.509900] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[408.519062] Starting dynamic subtest: pipe-D-eDP-1
[408.543075] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[408.547411] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[410.662108] [117/133] (611s left) kms_cursor_crc (cursor-offscreen-256x256)
[410.938442] Starting subtest: cursor-offscreen-256x256
[410.943842] Starting dynamic subtest: pipe-A-eDP-1
[412.901517] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.958s)
[412.928400] Starting dynamic subtest: pipe-D-eDP-1
[415.482471] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.559s)
[415.484660] Subtest cursor-offscreen-256x256: SUCCESS (4.541s)
[416.335265] [118/133] (606s left) i915_selftest (perf)
[419.690028] Starting subtest: perf
[419.692815] Starting dynamic subtest: engine_cs
[424.039044] Dynamic subtest engine_cs: SUCCESS (4.349s)
[424.048748] Starting dynamic subtest: request
[429.313041] Dynamic subtest request: SUCCESS (5.272s)
[429.322896] Starting dynamic subtest: migrate
[433.681677] Dynamic subtest migrate: SUCCESS (4.367s)
[433.691027] Starting dynamic subtest: region
[439.257312] Dynamic subtest region: SUCCESS (5.574s)
[439.259923] Subtest perf: SUCCESS (19.568s)
[439.286324] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[439.287042] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[439.290180] [119/133] (583s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[440.898521] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[447.581596] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.684s)
[447.717009] [FACT kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[447.718199] [FACT kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)] new: kernel.kmod_is_loaded.i915: true
[447.722086] [120/133] (574s left) gem_spin_batch (legacy)
[447.794139] Starting subtest: legacy
[447.796503] Starting dynamic subtest: default
[451.039366] Dynamic subtest default: SUCCESS (3.240s)
[451.048185] Starting dynamic subtest: render
[454.274559] Dynamic subtest render: SUCCESS (3.231s)
[454.285838] Starting dynamic subtest: bsd
[457.512084] Dynamic subtest bsd: SUCCESS (3.234s)
[457.523114] Starting dynamic subtest: bsd1
[460.748677] Dynamic subtest bsd1: SUCCESS (3.233s)
[460.759728] Starting dynamic subtest: bsd2
[463.992199] Dynamic subtest bsd2: SUCCESS (3.236s)
[464.000852] Starting dynamic subtest: blt
[467.225509] Dynamic subtest blt: SUCCESS (3.233s)
[467.235048] Starting dynamic subtest: vebox
[470.463210] Dynamic subtest vebox: SUCCESS (3.234s)
[470.465343] Subtest legacy: SUCCESS (22.666s)
[472.339620] [121/133] (550s left) kms_flip (modeset-vs-vblank-race-interruptible)
[472.445288] Starting subtest: modeset-vs-vblank-race-interruptible
[472.447646] Starting dynamic subtest: A-eDP1
[477.098930] Dynamic subtest A-eDP1: SUCCESS (4.652s)
[477.112838] Starting dynamic subtest: B-eDP1
[481.740859] Dynamic subtest B-eDP1: SUCCESS (4.638s)
[481.754690] Starting dynamic subtest: C-eDP1
[486.265037] Dynamic subtest C-eDP1: SUCCESS (4.521s)
[486.273863] Starting dynamic subtest: D-eDP1
[490.894057] Dynamic subtest D-eDP1: SUCCESS (4.628s)
[490.899263] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.453s)
[492.285793] [122/133] (530s left) kms_rotation_crc (sprite-rotation-90)
[492.377393] Starting subtest: sprite-rotation-90
[492.381894] Subtest sprite-rotation-90: SKIP (0.001s)
[492.450382] [123/133] (530s left) gem_media_fill (media-fill)
[492.507072] Subtest media-fill: SKIP (0.000s)
[492.614501] [124/133] (530s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[492.728266] Starting subtest: cursorA-vs-flipA-atomic-transitions
[503.894683] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.165s)
[504.703447] [125/133] (517s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[504.801835] Starting subtest: 4-tiled-16bpp-rotate-180
[506.168702] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.367s)
[506.302273] [126/133] (516s left) kms_dp_link_training (uhbr-mst)
[506.398460] Starting subtest: uhbr-mst
[506.405719] Subtest uhbr-mst: SKIP (0.000s)
[506.471211] [127/133] (516s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[506.570330] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[506.573823] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[506.654972] [128/133] (516s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[506.708316] Starting subtest: invalid-single-wait-all-unsubmitted
[506.710279] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[506.815565] [129/133] (516s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[506.908278] Starting subtest: x-tiled-16bpp-rotate-0
[508.266931] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.359s)
[508.392089] [130/133] (514s left) gem_mmap_gtt (zero-extend)
[508.446401] Subtest zero-extend: SKIP (0.000s)
[508.505056] [131/133] (514s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[508.608479] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[508.612179] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[508.725596] [132/133] (514s left) kms_flip (basic-flip-vs-wf_vblank)
[508.804546] Starting subtest: basic-flip-vs-wf_vblank
[508.806495] Starting dynamic subtest: A-eDP1
[510.749664] Dynamic subtest A-eDP1: SUCCESS (1.943s)
[510.759757] Starting dynamic subtest: B-eDP1
[512.680515] Dynamic subtest B-eDP1: SUCCESS (1.930s)
[512.689123] Starting dynamic subtest: C-eDP1
[514.602040] Dynamic subtest C-eDP1: SUCCESS (1.920s)
[514.610700] Starting dynamic subtest: D-eDP1
[516.532435] Dynamic subtest D-eDP1: SUCCESS (1.927s)
[516.534794] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.731s)
[517.755778] [133/133] (505s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[517.854750] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[524.878778] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.026s)
[525.009698] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_reloc
results: parsing output: 1/ for test: kms_flip
results: parsing output: 2/ for test: perf
results: parsing output: 3/ for test: kms_content_protection
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: gem_ctx_sseu
results: parsing output: 6/ for test: gem_eio
results: parsing output: 7/ for test: kms_chamelium_frames
results: parsing output: 8/ for test: kms_dsc
results: parsing output: 9/ for test: kms_flip_scaled_crc
results: parsing output: 10/ for test: gem_sync
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: kms_properties
results: parsing output: 13/ for test: syncobj_basic
results: parsing output: 14/ for test: kms_psr2_sf
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_pm_rpm
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: kms_mmap_write_crc
results: parsing output: 19/ for test: gem_wait
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: kms_cursor_crc
results: parsing output: 23/ for test: gem_exec_schedule
results: parsing output: 24/ for test: syncobj_wait
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_exec_whisper
results: parsing output: 27/ for test: perf
results: parsing output: 28/ for test: prime_busy
results: parsing output: 29/ for test: gem_ctx_engines
results: parsing output: 30/ for test: gem_pxp
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: gem_exec_capture
results: parsing output: 33/ for test: gem_ctx_param
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gem_exec_params
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: gem_ctx_persistence
results: parsing output: 39/ for test: gem_exec_params
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_cursor_legacy
results: parsing output: 42/ for test: kms_cdclk
results: parsing output: 43/ for test: gem_ccs
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 48/ for test: kms_plane_scaling
results: parsing output: 49/ for test: gen7_exec_parse
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: perf_pmu
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: perf_pmu
results: parsing output: 54/ for test: kms_atomic_transition
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: i915_pm_rps
results: parsing output: 57/ for test: kms_psr2_sf
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: gem_ringfill
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_joiner
results: parsing output: 63/ for test: i915_drm_fdinfo
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_exec_balancer
results: parsing output: 66/ for test: kms_selftest
results: parsing output: 67/ for test: kms_addfb_basic
results: parsing output: 68/ for test: gem_huc_copy
results: parsing output: 69/ for test: api_intel_bb
results: parsing output: 70/ for test: syncobj_timeline
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: syncobj_wait
results: parsing output: 73/ for test: kms_flip_scaled_crc
results: parsing output: 74/ for test: kms_flip
results: parsing output: 75/ for test: kms_addfb_basic
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: kms_chamelium_hpd
results: parsing output: 78/ for test: dmabuf_sync_file
results: parsing output: 79/ for test: kms_flip_scaled_crc
results: parsing output: 80/ for test: gem_partial_pwrite_pread
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: kms_cursor_crc
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: kms_pm_rpm
results: parsing output: 87/ for test: kms_joiner
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: sysfs_heartbeat_interval
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: i915_drm_fdinfo
results: parsing output: 92/ for test: kms_tv_load_detect
results: parsing output: 93/ for test: kms_plane
results: parsing output: 94/ for test: gem_exec_fence
results: parsing output: 95/ for test: kms_flip
results: parsing output: 96/ for test: gem_exec_reloc
results: parsing output: 97/ for test: kms_rotation_crc
results: parsing output: 98/ for test: kms_plane_multiple
results: parsing output: 99/ for test: syncobj_wait
results: parsing output: 100/ for test: kms_vblank
results: parsing output: 101/ for test: gem_exec_fence
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: gem_pxp
results: parsing output: 104/ for test: gem_mmap_gtt
results: parsing output: 105/ for test: gem_exec_schedule
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_exec_reloc
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: kms_psr2_sf
results: parsing output: 111/ for test: kms_plane
results: parsing output: 112/ for test: gem_ctx_create
results: parsing output: 113/ for test: api_intel_bb
results: parsing output: 114/ for test: kms_color_pipeline
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: kms_cursor_crc
results: parsing output: 117/ for test: i915_selftest
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_spin_batch
results: parsing output: 120/ for test: kms_flip
results: parsing output: 121/ for test: kms_rotation_crc
results: parsing output: 122/ for test: gem_media_fill
results: parsing output: 123/ for test: kms_cursor_legacy
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_dp_link_training
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: syncobj_wait
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: gem_mmap_gtt
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_flip
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.