[58.075302] Initializing watchdogs
[58.075361]   /dev/watchdog0
[58.089116] [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]
[58.093644] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.095887] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.099200] [001/133] (960s left) gem_exec_store (pages)
[58.189757] Starting subtest: pages
[58.192140] Starting dynamic subtest: rcs0
[58.286723] Dynamic subtest rcs0: SUCCESS (0.097s)
[58.296406] Starting dynamic subtest: bcs0
[58.355569] Dynamic subtest bcs0: SUCCESS (0.069s)
[58.365214] Starting dynamic subtest: vcs0
[58.424598] Dynamic subtest vcs0: SUCCESS (0.069s)
[58.434349] Starting dynamic subtest: vcs1
[58.490892] Dynamic subtest vcs1: SUCCESS (0.066s)
[58.499242] Starting dynamic subtest: vecs0
[58.566453] Dynamic subtest vecs0: SUCCESS (0.075s)
[58.575851] Starting dynamic subtest: ccs0
[58.636980] Dynamic subtest ccs0: SUCCESS (0.071s)
[58.639837] Subtest pages: SUCCESS (0.449s)
[58.820936] [002/133] (959s left) kms_joiner (basic-force-ultra-joiner)
[58.924378] Starting subtest: basic-force-ultra-joiner
[58.929022] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[58.986928] [003/133] (959s left) kms_cursor_edge_walk (64x64-top-edge)
[59.071555] Starting subtest: 64x64-top-edge
[59.073813] Starting dynamic subtest: pipe-A-eDP-1
[62.522555] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.459s)
[62.531325] Starting dynamic subtest: pipe-D-eDP-1
[65.652160] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.133s)
[65.654607] Subtest 64x64-top-edge: SUCCESS (6.594s)
[66.442686] [004/133] (952s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[66.541317] Starting subtest: compare-crc-sanitycheck-nv12
[66.543691] Starting dynamic subtest: pipe-A-eDP-1
[68.005895] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.465s)
[68.015075] Starting dynamic subtest: pipe-B-eDP-1
[68.893569] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.886s)
[68.908299] Starting dynamic subtest: pipe-C-eDP-1
[70.083475] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.193s)
[70.091696] Starting dynamic subtest: pipe-D-eDP-1
[71.343112] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.257s)
[71.345442] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.807s)
[72.143186] [005/133] (946s left) kms_cursor_crc (cursor-onscreen-32x10)
[72.312668] Starting subtest: cursor-onscreen-32x10
[72.365623] Subtest cursor-onscreen-32x10: SKIP (0.046s)
[72.618629] [006/133] (946s left) gem_wait (wait)
[72.678678] Starting subtest: wait
[72.680678] Starting dynamic subtest: all-engines
[73.941032] Dynamic subtest all-engines: SUCCESS (1.263s)
[73.950375] Starting dynamic subtest: rcs0
[74.987146] Dynamic subtest rcs0: SUCCESS (1.047s)
[74.996438] Starting dynamic subtest: bcs0
[76.033457] Dynamic subtest bcs0: SUCCESS (1.045s)
[76.043394] Starting dynamic subtest: vcs0
[77.077070] Dynamic subtest vcs0: SUCCESS (1.043s)
[77.088578] Starting dynamic subtest: vcs1
[78.121519] Dynamic subtest vcs1: SUCCESS (1.044s)
[78.130625] Starting dynamic subtest: vecs0
[79.166792] Dynamic subtest vecs0: SUCCESS (1.044s)
[79.176816] Starting dynamic subtest: ccs0
[80.212123] Dynamic subtest ccs0: SUCCESS (1.045s)
[80.214562] Subtest wait: SUCCESS (7.538s)
[80.407772] [007/133] (938s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[80.507607] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[80.511919] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[80.588927] [008/133] (938s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[80.691657] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[80.696231] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[80.794072] [009/133] (938s left) kms_atomic_transition (modeset-transition-nonblocking)
[80.876982] Starting subtest: modeset-transition-nonblocking
[80.879428] Starting dynamic subtest: 1x-outputs
[91.813484] Dynamic subtest 1x-outputs: SUCCESS (10.936s)
[91.816058] Subtest modeset-transition-nonblocking: SUCCESS (10.937s)
[92.677176] [010/133] (926s left) kms_psr (fbc-pr-sprite-blt)
[92.773924] Starting subtest: fbc-pr-sprite-blt
[92.778047] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[92.857959] [011/133] (926s left) kms_psr (pr-primary-page-flip)
[92.957069] Starting subtest: pr-primary-page-flip
[92.961421] Subtest pr-primary-page-flip: SKIP (0.000s)
[93.027471] [012/133] (925s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[93.077867] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[93.080319] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[93.174292] [013/133] (925s left) gem_softpin (evict-prime)
[93.225847] Starting subtest: evict-prime
[93.228151] Starting dynamic subtest: rcs0
[94.395197] Dynamic subtest rcs0: SUCCESS (1.169s)
[94.403457] Starting dynamic subtest: bcs0
[95.522785] Dynamic subtest bcs0: SUCCESS (1.127s)
[95.530308] Starting dynamic subtest: vcs0
[96.857155] Dynamic subtest vcs0: SUCCESS (1.332s)
[96.867425] Starting dynamic subtest: vcs1
[98.848679] Dynamic subtest vcs1: SUCCESS (1.990s)
[98.856413] Starting dynamic subtest: vecs0
[100.893361] Dynamic subtest vecs0: SUCCESS (2.044s)
[100.903343] Starting dynamic subtest: ccs0
[102.025999] Dynamic subtest ccs0: SUCCESS (1.133s)
[102.033337] Starting dynamic subtest: all
[103.892494] Dynamic subtest all: SUCCESS (1.864s)
[103.895435] Subtest evict-prime: SUCCESS (10.665s)
[103.967195] [014/133] (915s left) perf_pmu (busy-idle-no-semaphores)
[104.006158] Starting subtest: busy-idle-no-semaphores
[104.008139] Starting dynamic subtest: rcs0
[104.680416] Dynamic subtest rcs0: SUCCESS (0.673s)
[104.691120] Starting dynamic subtest: bcs0
[105.335134] Dynamic subtest bcs0: SUCCESS (0.654s)
[105.345409] Starting dynamic subtest: vcs0
[105.989205] Dynamic subtest vcs0: SUCCESS (0.653s)
[106.000192] Starting dynamic subtest: vcs1
[107.518849] Dynamic subtest vcs1: SUCCESS (1.529s)
[107.527329] Starting dynamic subtest: vecs0
[109.501934] Dynamic subtest vecs0: SUCCESS (1.982s)
[109.510936] Starting dynamic subtest: ccs0
[111.553015] Dynamic subtest ccs0: SUCCESS (2.050s)
[111.555882] Subtest busy-idle-no-semaphores: SUCCESS (7.547s)
[111.684615] [015/133] (907s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[111.731029] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[111.733311] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[111.823734] [016/133] (907s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[111.930244] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[111.934549] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[112.041729] [017/133] (907s left) gem_lmem_swapping (parallel-random-verify-ccs)
[112.085349] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[112.125375] [018/133] (907s left) syncobj_eventfd (timeline-wait-signaled)
[112.185068] Starting subtest: timeline-wait-signaled
[112.187291] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[112.268358] [019/133] (907s left) vgem_basic (mmap)
[112.393516] Starting subtest: mmap
[112.398113] Subtest mmap: SUCCESS (0.007s)
[112.448382] [FACT vgem_basic (mmap)] new: kernel.kmod_is_loaded.vgem: true
[112.451433] [020/133] (906s left) api_intel_allocator (fork-simple-stress-signal)
[112.501415] Starting subtest: fork-simple-stress-signal
[117.903501] Subtest fork-simple-stress-signal: SUCCESS (5.403s)
[118.023765] [021/133] (901s left) gen7_exec_parse (batch-without-end)
[118.090154] Subtest batch-without-end: SKIP (0.000s)
[118.187700] [022/133] (901s left) gem_ctx_persistence (smoketest)
[118.262632] Starting subtest: smoketest
[158.836923] Subtest smoketest: SUCCESS (40.565s)
[158.912655] [023/133] (860s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[159.027318] Starting subtest: bad-aux-stride-yf-tiled-ccs
[159.029662] Starting dynamic subtest: pipe-A-eDP-1
[159.053274] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[159.063051] Starting dynamic subtest: pipe-B-eDP-1
[159.085264] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[159.092653] Starting dynamic subtest: pipe-C-eDP-1
[159.115375] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[159.123179] Starting dynamic subtest: pipe-D-eDP-1
[159.145325] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[159.149373] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.003s)
[161.249294] [024/133] (858s left) kms_plane_lowres (tiling-4)
[161.345024] Starting subtest: tiling-4
[161.347580] Starting dynamic subtest: pipe-A-eDP-1
[161.352475] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[161.644787] Starting dynamic subtest: pipe-B-eDP-1
[161.649559] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[161.657397] Starting dynamic subtest: pipe-C-eDP-1
[161.662082] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[161.669634] Starting dynamic subtest: pipe-D-eDP-1
[161.673731] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[161.677834] Subtest tiling-4: SKIP (0.295s)
[162.479967] [025/133] (857s left) kms_getfb (getfb-repeated-different-handles)
[162.583061] Starting subtest: getfb-repeated-different-handles
[162.585338] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[162.685265] [026/133] (856s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[162.775342] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[162.777755] Starting dynamic subtest: pipe-A
[162.840740] Dynamic subtest pipe-A: SUCCESS (0.065s)
[162.850620] Starting dynamic subtest: pipe-B
[164.004977] Dynamic subtest pipe-B: SUCCESS (1.163s)
[164.014668] Starting dynamic subtest: pipe-C
[165.119446] Dynamic subtest pipe-C: SUCCESS (1.114s)
[165.127819] Starting dynamic subtest: pipe-D
[166.258413] Dynamic subtest pipe-D: SUCCESS (1.138s)
[166.260773] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.482s)
[167.440181] [027/133] (852s left) gem_wait (invalid-flags)
[167.493310] Starting subtest: invalid-flags
[167.495701] Subtest invalid-flags: SUCCESS (0.000s)
[167.699930] [028/133] (851s left) i915_suspend (basic-s3-without-i915)
[167.741743] Starting subtest: basic-s3-without-i915
[169.449327] Subtest basic-s3-without-i915: SKIP (1.703s)
[170.982647] [029/133] (848s left) drm_read (empty-nonblock)
[171.145045] Starting subtest: empty-nonblock
[171.147407] Subtest empty-nonblock: SUCCESS (0.000s)
[171.266668] [030/133] (848s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[171.376116] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[171.380111] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[171.467838] [031/133] (848s left) kms_flip (flip-vs-fences-interruptible)
[171.562133] Starting subtest: flip-vs-fences-interruptible
[171.566630] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[171.637089] [032/133] (848s left) kms_addfb_basic (master-rmfb)
[171.690849] Starting subtest: master-rmfb
[171.693097] Subtest master-rmfb: SUCCESS (0.001s)
[171.821641] [033/133] (848s left) kms_plane_scaling (invalid-num-scalers)
[171.907839] Starting subtest: invalid-num-scalers
[171.909750] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[171.927086] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.018s)
[171.934547] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[171.966118] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.036s)
[171.973444] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[172.001696] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.036s)
[172.008734] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[172.039499] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.035s)
[172.041343] Subtest invalid-num-scalers: SUCCESS (0.130s)
[172.144776] [034/133] (847s left) api_intel_bb (simple-bb)
[172.192321] Starting subtest: simple-bb
[172.197251] Subtest simple-bb: SUCCESS (0.006s)
[172.305907] [035/133] (847s left) gem_pxp (fail-invalid-protected-context)
[172.427259] Starting subtest: fail-invalid-protected-context
[172.429333] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[172.529850] [036/133] (847s left) kms_addfb_basic (bad-pitch-63)
[172.591363] Starting subtest: bad-pitch-63
[172.593153] Subtest bad-pitch-63: SUCCESS (0.000s)
[172.781778] [037/133] (847s left) prime_vgem (wait)
[172.859033] Starting subtest: wait
[172.860958] Starting dynamic subtest: rcs0
[172.898994] Dynamic subtest rcs0: SUCCESS (0.040s)
[172.906272] Starting dynamic subtest: bcs0
[172.949993] Dynamic subtest bcs0: SUCCESS (0.050s)
[172.957502] Starting dynamic subtest: vcs0
[172.991726] Dynamic subtest vcs0: SUCCESS (0.041s)
[172.999535] Starting dynamic subtest: vcs1
[173.038699] Dynamic subtest vcs1: SUCCESS (0.047s)
[173.046134] Starting dynamic subtest: vecs0
[173.086597] Dynamic subtest vecs0: SUCCESS (0.047s)
[173.093925] Starting dynamic subtest: ccs0
[173.134685] Dynamic subtest ccs0: SUCCESS (0.047s)
[173.136578] Subtest wait: SUCCESS (0.276s)
[173.255588] [038/133] (846s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[173.346057] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[173.349574] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[173.438570] [039/133] (846s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[173.527092] Starting subtest: fbcpsr-tiling-linear
[180.070785] Subtest fbcpsr-tiling-linear: SUCCESS (6.544s)
[180.192639] [040/133] (839s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[180.302419] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[180.307049] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[180.402543] [041/133] (839s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[180.508979] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[180.513400] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[180.618753] [042/133] (839s left) gem_create (create-ext-cpu-access-big)
[180.777888] Starting subtest: create-ext-cpu-access-big
[180.782560] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[180.862090] [043/133] (839s left) prime_self_import (basic-with_two_bos)
[180.900725] Starting subtest: basic-with_two_bos
[180.929946] Subtest basic-with_two_bos: SUCCESS (0.028s)
[181.034146] [044/133] (839s left) gem_ctx_sseu (engines)
[181.091896] Subtest engines: SKIP (0.000s)
[181.161461] [045/133] (839s left) gem_exec_balancer (parallel)
[181.420796] Starting subtest: parallel
[182.340920] Subtest parallel: SUCCESS (0.920s)
[182.984580] [046/133] (837s left) syncobj_wait (signal)
[183.057071] Starting subtest: signal
[183.059338] Subtest signal: SUCCESS (0.000s)
[183.177195] [047/133] (837s left) kms_sequence (get-busy)
[183.269819] Starting subtest: get-busy
[183.271784] Starting dynamic subtest: pipe-A-eDP-1
[185.212790] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.942s)
[185.222036] Starting dynamic subtest: pipe-B-eDP-1
[187.801711] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.590s)
[187.813608] Starting dynamic subtest: pipe-C-eDP-1
[190.417259] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.613s)
[190.426105] Starting dynamic subtest: pipe-D-eDP-1
[192.962934] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.544s)
[192.965332] Subtest get-busy: SUCCESS (9.693s)
[193.841120] [048/133] (826s left) i915_drm_fdinfo (virtual-busy-hang)
[193.888191] Starting subtest: virtual-busy-hang
[193.892165] Subtest virtual-busy-hang: SKIP (0.000s)
[193.962242] [049/133] (826s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[194.027205] Subtest tiled-to-untiled: SKIP (0.000s)
[194.087595] [050/133] (826s left) perf_pmu (all-busy-idle-check-all)
[194.128195] Starting subtest: all-busy-idle-check-all
[195.926049] Subtest all-busy-idle-check-all: SUCCESS (1.795s)
[196.015530] [051/133] (824s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[196.123429] Starting subtest: cursor-vs-flip-legacy
[225.743354] Subtest cursor-vs-flip-legacy: SUCCESS (29.617s)
[226.586164] [052/133] (794s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[226.682180] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[226.711075] Starting dynamic subtest: pipe-A-plane-0
[226.999369] Dynamic subtest pipe-A-plane-0: SUCCESS (0.288s)
[227.008827] Starting dynamic subtest: pipe-A-plane-3
[227.232576] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[228.361213] Starting dynamic subtest: pipe-B-plane-0
[228.664728] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[228.672865] Starting dynamic subtest: pipe-B-plane-3
[228.908988] Dynamic subtest pipe-B-plane-3: SUCCESS (0.243s)
[229.232487] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.551s)
[230.038215] [053/133] (790s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[230.140932] Starting subtest: psr-1p-primscrn-spr-indfb-move
[237.690953] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.554s)
[237.824474] [054/133] (782s left) gem_partial_pwrite_pread (write-display)
[237.879284] Subtest write-display: SKIP (0.000s)
[237.949030] [055/133] (782s left) dmabuf_sync_file (import-basic)
[237.992676] Starting subtest: import-basic
[237.994946] Subtest import-basic: SUCCESS (0.002s)
[238.061488] [056/133] (782s left) prime_mmap (test_invalid_sync_flags)
[238.118048] Starting subtest: test_invalid_sync_flags
[238.120289] Starting dynamic subtest: test_invalid_sync_flags-smem
[238.122146] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[238.124060] Subtest test_invalid_sync_flags: SUCCESS (0.001s)
[238.223603] [057/133] (782s left) gem_mmap_gtt (medium-copy-xy)
[238.269654] Subtest medium-copy-XY: SKIP (0.000s)
[238.324200] [058/133] (782s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[238.420887] Starting subtest: plane-lut1d-pre-ctm3x4
[238.567276] Starting dynamic subtest: pipe-A-plane-0
[238.722385] Dynamic subtest pipe-A-plane-0: SUCCESS (0.156s)
[238.730503] Starting dynamic subtest: pipe-A-plane-1
[238.879304] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[238.887486] Starting dynamic subtest: pipe-A-plane-2
[239.045307] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[240.225771] Starting dynamic subtest: pipe-B-plane-0
[240.407674] Dynamic subtest pipe-B-plane-0: SUCCESS (0.189s)
[240.416217] Starting dynamic subtest: pipe-B-plane-1
[240.596377] Dynamic subtest pipe-B-plane-1: SUCCESS (0.188s)
[240.609747] Starting dynamic subtest: pipe-B-plane-2
[240.795283] Dynamic subtest pipe-B-plane-2: SUCCESS (0.198s)
[241.946386] Starting dynamic subtest: pipe-C-plane-0
[242.072609] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[242.081262] Starting dynamic subtest: pipe-C-plane-1
[242.217548] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[242.225995] Starting dynamic subtest: pipe-C-plane-2
[242.350859] Dynamic subtest pipe-C-plane-2: SUCCESS (0.133s)
[243.586146] Starting dynamic subtest: pipe-D-plane-0
[243.710107] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[243.719853] Starting dynamic subtest: pipe-D-plane-1
[243.854442] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[243.862915] Starting dynamic subtest: pipe-D-plane-2
[243.999122] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[244.293199] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (5.871s)
[245.169855] [059/133] (775s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[245.277225] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[245.281678] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[245.339334] [060/133] (775s left) gem_mmap_gtt (basic-small-copy)
[245.394618] Subtest basic-small-copy: SKIP (0.000s)
[245.456409] [061/133] (775s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[245.558211] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[250.143590] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.588s)
[251.260112] [062/133] (769s left) perf (gen12-group-exclusive-stream-ctx-handle)
[251.402073] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[251.432289] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.030s)
[251.477211] [063/133] (769s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[252.901080] Starting subtest: psr-rgb565-draw-mmap-cpu
[259.648459] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.750s)
[259.792134] [064/133] (761s left) gem_exec_schedule (out-order)
[259.872384] Starting subtest: out-order
[259.874385] Starting dynamic subtest: rcs0
[259.987615] Dynamic subtest rcs0: SUCCESS (0.116s)
[259.998547] Starting dynamic subtest: vcs0
[260.076572] Dynamic subtest vcs0: SUCCESS (0.088s)
[260.088337] Starting dynamic subtest: vcs1
[260.160626] Dynamic subtest vcs1: SUCCESS (0.084s)
[260.172301] Starting dynamic subtest: vecs0
[260.249023] Dynamic subtest vecs0: SUCCESS (0.087s)
[260.258085] Starting dynamic subtest: ccs0
[260.337286] Dynamic subtest ccs0: SUCCESS (0.086s)
[260.339749] Subtest out-order: SUCCESS (0.467s)
[261.982162] [065/133] (759s left) gem_exec_capture (capture)
[262.050134] Starting subtest: capture
[262.052443] Starting dynamic subtest: rcs0-smem
[262.890172] Dynamic subtest rcs0-smem: SUCCESS (0.842s)
[262.898868] Starting dynamic subtest: bcs0-smem
[263.716659] Dynamic subtest bcs0-smem: SUCCESS (0.825s)
[263.727686] Starting dynamic subtest: vcs0-smem
[264.545261] Dynamic subtest vcs0-smem: SUCCESS (0.827s)
[264.554856] Starting dynamic subtest: vcs1-smem
[265.859619] Dynamic subtest vcs1-smem: SUCCESS (1.316s)
[265.870575] Starting dynamic subtest: vecs0-smem
[266.748091] Dynamic subtest vecs0-smem: FAIL (0.821s)
[266.758140] Starting dynamic subtest: ccs0-smem
[268.059504] Dynamic subtest ccs0-smem: SUCCESS (1.375s)
[268.061885] Subtest capture: FAIL (6.010s)
[268.203456] [066/133] (753s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[268.267169] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[268.329356] [067/133] (752s left) gem_ccs (block-copy-uncompressed)
[268.383227] Starting subtest: block-copy-uncompressed
[268.385564] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[268.410219] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.026s)
[268.420189] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[268.432250] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.021s)
[268.439983] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[268.452678] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.020s)
[268.460789] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[268.474801] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.021s)
[268.477187] Subtest block-copy-uncompressed: SUCCESS (0.092s)
[268.605367] [068/133] (752s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[268.708517] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[268.712754] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[268.806236] [069/133] (752s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[268.908822] Starting subtest: fbc-rgb101010-draw-blt
[273.479039] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.574s)
[274.585392] [070/133] (746s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[274.687631] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[274.692037] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[274.754925] [071/133] (746s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[274.856342] Starting subtest: 4-tiled-64bpp-rotate-180
[276.333844] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.478s)
[276.527404] [072/133] (744s left) gem_tiled_partial_pwrite_pread (writes)
[276.585225] Subtest writes: SKIP (0.000s)
[276.654656] [073/133] (744s left) syncobj_timeline (invalid-wait-illegal-handle)
[276.712910] Starting subtest: invalid-wait-illegal-handle
[276.714942] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[276.829120] [074/133] (744s left) gem_ctx_isolation (preservation-reset)
[277.009033] Starting subtest: preservation-reset
[277.011759] Starting dynamic subtest: rcs0
[277.290727] Dynamic subtest rcs0: SUCCESS (0.282s)
[277.300232] Starting dynamic subtest: bcs0
[277.583125] Dynamic subtest bcs0: SUCCESS (0.291s)
[277.595384] Starting dynamic subtest: vcs0
[277.893415] Dynamic subtest vcs0: SUCCESS (0.309s)
[277.901602] Starting dynamic subtest: vcs1
[279.204516] Dynamic subtest vcs1: SUCCESS (1.310s)
[279.217520] Starting dynamic subtest: vecs0
[281.179967] Dynamic subtest vecs0: SUCCESS (1.975s)
[281.191194] Starting dynamic subtest: ccs0
[283.178491] Dynamic subtest ccs0: SUCCESS (1.998s)
[283.180904] Subtest preservation-reset: SUCCESS (6.173s)
[283.301363] [075/133] (738s left) gem_exec_schedule (smoketest-all)
[283.372752] Starting subtest: smoketest-all
[315.773818] Subtest smoketest-all: SUCCESS (32.360s)
[316.983148] [076/133] (704s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[317.090048] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[317.092307] Starting dynamic subtest: pipe-A-eDP-1
[317.112730] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[317.123714] Starting dynamic subtest: pipe-B-eDP-1
[317.142990] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[317.151431] Starting dynamic subtest: pipe-C-eDP-1
[317.171132] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[317.180287] Starting dynamic subtest: pipe-D-eDP-1
[317.199608] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[317.201517] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[319.335073] [077/133] (702s left) i915_query (query-topology-known-pci-ids)
[319.387964] Starting subtest: query-topology-known-pci-ids
[319.391631] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[319.484287] [078/133] (702s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[319.567022] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[319.569264] Starting dynamic subtest: pipe-A-eDP-1
[319.577892] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[319.586846] Starting dynamic subtest: pipe-B-eDP-1
[319.595578] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[319.607219] Starting dynamic subtest: pipe-C-eDP-1
[319.615727] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[319.623531] Starting dynamic subtest: pipe-D-eDP-1
[319.631697] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[319.635662] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s)
[321.809972] [079/133] (699s left) kms_psr (fbc-psr2-sprite-render)
[321.908376] Starting subtest: fbc-psr2-sprite-render
[321.910623] Starting dynamic subtest: eDP-1
[321.915071] Dynamic subtest eDP-1: SKIP (0.000s)
[321.919422] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[321.979928] [080/133] (699s left) kms_cursor_crc (cursor-random-256x85)
[322.236260] Starting subtest: cursor-random-256x85
[322.283966] Subtest cursor-random-256x85: SKIP (0.042s)
[322.471788] [081/133] (699s left) kms_addfb_basic (addfb25-modifier-no-flag)
[322.566227] Starting subtest: addfb25-modifier-no-flag
[322.568411] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[322.668618] [082/133] (699s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[322.765399] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[322.767348] Starting dynamic subtest: pipe-A-default-mode
[325.536052] Dynamic subtest pipe-A-default-mode: SUCCESS (2.769s)
[325.538591] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.771s)
[326.385536] [083/133] (695s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[326.486273] Starting subtest: invalidate-primary-flip-overlay
[337.277780] Subtest invalidate-primary-flip-overlay: SUCCESS (10.794s)
[337.395332] [084/133] (684s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[337.487616] Starting subtest: primary-y-tiled-reflect-x-0
[337.547380] Subtest primary-y-tiled-reflect-x-0: SKIP (0.059s)
[337.659424] [085/133] (684s left) kms_lease (lease-invalid-connector)
[337.752039] Starting subtest: lease-invalid-connector
[337.753910] Starting dynamic subtest: pipe-A-eDP-1
[337.755837] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[337.763599] Starting dynamic subtest: pipe-B-eDP-1
[337.765185] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[337.773161] Starting dynamic subtest: pipe-C-eDP-1
[337.774870] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[337.782525] Starting dynamic subtest: pipe-D-eDP-1
[337.784155] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[337.785728] Subtest lease-invalid-connector: SUCCESS (0.004s)
[337.828264] [086/133] (684s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[337.886586] Starting subtest: etime-single-wait-for-submit-unsubmitted
[337.993968] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[338.070873] [087/133] (684s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[338.177703] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[338.182139] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[338.272857] [088/133] (683s left) i915_pm_rpm (gem-mmap-type)
[340.017261] Starting subtest: gem-mmap-type
[340.019779] Starting dynamic subtest: wb-smem0
[343.308977] Dynamic subtest wb-smem0: SUCCESS (3.293s)
[343.317926] Starting dynamic subtest: wc-smem0
[346.461494] Dynamic subtest wc-smem0: SUCCESS (3.152s)
[346.470707] Starting dynamic subtest: uc-smem0
[349.323359] Dynamic subtest uc-smem0: SUCCESS (2.861s)
[349.325809] Subtest gem-mmap-type: SUCCESS (9.311s)
[349.409968] [089/133] (672s left) kms_content_protection (uevent-hdcp14)
[349.556042] Starting subtest: uevent-hdcp14
[349.560484] Subtest uevent-hdcp14: SKIP (0.000s)
[349.693219] [090/133] (672s left) gem_mmap_wc (set-cache-level)
[349.749589] Subtest set-cache-level: SKIP (0.000s)
[349.825973] [091/133] (672s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[349.918170] Starting subtest: plane-use-after-nonblocking-unbind
[349.920420] Starting dynamic subtest: pipe-A-eDP-1
[349.978819] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[350.287756] Starting dynamic subtest: pipe-B-eDP-1
[351.089073] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.811s)
[351.383354] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.465s)
[352.248850] [092/133] (670s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[352.309161] Starting subtest: framebuffer-vs-set-tiling
[352.313688] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[352.443506] [093/133] (669s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[352.529732] Starting subtest: fbcpsr-1p-rte
[359.551894] Subtest fbcpsr-1p-rte: SUCCESS (7.027s)
[359.720743] [094/133] (662s left) kms_chamelium_frames (hdmi-aspect-ratio)
[360.101053] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[360.879079] [095/133] (661s left) gem_eio (in-flight-1us)
[361.112119] Starting subtest: in-flight-1us
[370.015185] Subtest in-flight-1us: SUCCESS (8.902s)
[370.146700] [096/133] (652s left) kms_flip (bo-too-big-interruptible)
[370.240694] Starting subtest: bo-too-big-interruptible
[370.243024] Starting dynamic subtest: A-eDP1
[371.542570] Dynamic subtest A-eDP1: SUCCESS (1.301s)
[371.553817] Starting dynamic subtest: B-eDP1
[372.773360] Dynamic subtest B-eDP1: SUCCESS (1.230s)
[372.785036] Starting dynamic subtest: C-eDP1
[374.011227] Dynamic subtest C-eDP1: SUCCESS (1.236s)
[374.021982] Starting dynamic subtest: D-eDP1
[375.253869] Dynamic subtest D-eDP1: SUCCESS (1.240s)
[375.259332] Subtest bo-too-big-interruptible: SUCCESS (5.019s)
[376.471255] [097/133] (646s left) kms_psr (psr2-primary-mmap-cpu)
[376.564936] Starting subtest: psr2-primary-mmap-cpu
[376.567102] Starting dynamic subtest: eDP-1
[378.255705] Dynamic subtest eDP-1: SUCCESS (1.688s)
[378.257664] Subtest psr2-primary-mmap-cpu: SUCCESS (1.690s)
[379.128421] [098/133] (643s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[379.227356] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[379.231737] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[379.296706] [099/133] (643s left) gem_caching (reads)
[379.367726] Subtest reads: SKIP (0.000s)
[379.438208] [100/133] (643s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[379.498569] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[379.503081] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[379.681062] [101/133] (643s left) gem_exec_schedule (reorder-wide)
[379.869060] Subtest reorder-wide: SKIP (0.000s)
[380.042242] [102/133] (642s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[380.101740] Starting subtest: yf-tiled-ccs-to-yf-tiled
[380.106414] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[380.296698] [103/133] (642s left) gem_exec_fence (syncobj-unused-fence)
[380.696648] Starting subtest: syncobj-unused-fence
[380.702613] Subtest syncobj-unused-fence: SUCCESS (0.005s)
[381.991639] [104/133] (640s left) gem_exec_fence (submit67)
[382.188956] Starting subtest: submit67
[382.193550] Subtest submit67: SKIP (0.000s)
[383.918988] [105/133] (638s left) syncobj_wait (reset-multiple-signaled)
[383.987075] Starting subtest: reset-multiple-signaled
[383.989462] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[384.093785] [106/133] (638s left) kms_pm_dc (dc9-dpms)
[385.185040] Starting subtest: dc9-dpms
[386.602845] Subtest dc9-dpms: SUCCESS (1.419s)
[386.685736] [107/133] (636s left) sysfs_heartbeat_interval (invalid)
[386.749077] Starting subtest: invalid
[386.751455] Starting dynamic subtest: vecs0
[386.753662] Dynamic subtest vecs0: SUCCESS (0.000s)
[386.763080] Starting dynamic subtest: ccs0
[386.765192] Dynamic subtest ccs0: SUCCESS (0.000s)
[386.773255] Starting dynamic subtest: vcs0
[386.775377] Dynamic subtest vcs0: SUCCESS (0.000s)
[386.783381] Starting dynamic subtest: bcs0
[386.785554] Dynamic subtest bcs0: SUCCESS (0.000s)
[386.793482] Starting dynamic subtest: rcs0
[386.795354] Dynamic subtest rcs0: SUCCESS (0.000s)
[386.803338] Starting dynamic subtest: vcs1
[386.805627] Dynamic subtest vcs1: SUCCESS (0.000s)
[386.807758] Subtest invalid: SUCCESS (0.005s)
[386.849541] [108/133] (636s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[387.224983] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[388.063798] [109/133] (634s left) gem_mmap_offset (bad-extensions)
[388.111052] Starting subtest: bad-extensions
[388.113240] Subtest bad-extensions: SUCCESS (0.000s)
[388.195576] [110/133] (634s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[388.291769] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[392.238951] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (3.950s)
[393.387283] [111/133] (629s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[393.479395] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[393.483534] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[393.596793] [112/133] (629s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[393.683156] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[393.685444] Starting dynamic subtest: pipe-A-eDP-1
[394.252986] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.540s)
[394.264278] Starting dynamic subtest: pipe-B-eDP-1
[395.715997] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.461s)
[395.735962] Starting dynamic subtest: pipe-C-eDP-1
[397.120925] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.408s)
[397.131634] Starting dynamic subtest: pipe-D-eDP-1
[398.514859] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.393s)
[398.516749] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.806s)
[399.699337] [113/133] (623s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[399.800308] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[404.223940] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.426s)
[405.415949] [114/133] (617s left) gem_exercise_blt (fast-copy)
[405.471722] Starting subtest: fast-copy
[405.474129] Starting dynamic subtest: linear-smem-smem
[405.493831] Dynamic subtest linear-smem-smem: SUCCESS (0.022s)
[405.505772] Starting dynamic subtest: xmajor-smem-smem
[405.514237] Dynamic subtest xmajor-smem-smem: SUCCESS (0.020s)
[405.522955] Starting dynamic subtest: tile4-smem-smem
[405.531230] Dynamic subtest tile4-smem-smem: SUCCESS (0.017s)
[405.540085] Starting dynamic subtest: tile64-smem-smem
[405.549746] Dynamic subtest tile64-smem-smem: SUCCESS (0.018s)
[405.552060] Subtest fast-copy: SUCCESS (0.079s)
[405.667875] [115/133] (617s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[405.767657] Starting subtest: x-tiled-32bpp-rotate-90
[405.788654] Subtest x-tiled-32bpp-rotate-90: SKIP (0.020s)
[405.892433] [116/133] (617s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[405.993335] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[405.995465] Starting dynamic subtest: pipe-A-eDP-1
[411.870563] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.880s)
[411.882742] Starting dynamic subtest: pipe-B-eDP-1
[418.509240] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.639s)
[418.511629] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.522s)
[419.388260] [117/133] (603s left) kms_dsc (dsc-with-bpc-formats)
[419.484032] Starting subtest: dsc-with-bpc-formats
[419.596733] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[419.636514] [118/133] (603s left) gem_exec_flush (basic-wb-ro-before-default)
[419.693799] Starting subtest: basic-wb-ro-before-default
[425.149503] Subtest basic-wb-ro-before-default: SUCCESS (5.456s)
[425.361494] [119/133] (598s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[425.476877] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[426.624981] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.148s)
[426.731570] [120/133] (596s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[426.834678] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[426.838330] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[426.946100] [121/133] (596s left) syncobj_wait (single-wait-all-signaled)
[426.989398] Starting subtest: single-wait-all-signaled
[426.991390] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[427.091155] [122/133] (596s left) i915_hangman (engine-engine-error)
[427.145484] Starting subtest: engine-engine-error
[427.147450] Starting dynamic subtest: rcs0
[428.852325] Dynamic subtest rcs0: SUCCESS (1.704s)
[428.863601] Starting dynamic subtest: bcs0
[430.900435] Dynamic subtest bcs0: SUCCESS (2.045s)
[430.911362] Starting dynamic subtest: vcs0
[432.884016] Dynamic subtest vcs0: SUCCESS (1.981s)
[432.897339] Starting dynamic subtest: vcs1
[434.868794] Dynamic subtest vcs1: SUCCESS (1.982s)
[434.880486] Starting dynamic subtest: vecs0
[436.853225] Dynamic subtest vecs0: SUCCESS (1.982s)
[436.864930] Starting dynamic subtest: ccs0
[438.836356] Dynamic subtest ccs0: SUCCESS (1.980s)
[438.839410] Subtest engine-engine-error: SUCCESS (11.690s)
[438.953807] [123/133] (584s left) kms_chamelium_color (ctm-blue-to-red)
[439.046873] Subtest ctm-blue-to-red: SKIP (0.000s)
[439.090704] [124/133] (584s left) kms_properties (invalid-properties-atomic)
[439.181048] Starting subtest: invalid-properties-atomic
[439.482534] Subtest invalid-properties-atomic: SUCCESS (0.302s)
[439.555064] [125/133] (584s left) kms_prime (basic-crc-vgem)
[439.632865] Starting subtest: basic-crc-vgem
[439.635240] Starting dynamic subtest: second-to-first
[440.635488] Dynamic subtest second-to-first: SUCCESS (1.006s)
[440.637733] Subtest basic-crc-vgem: SUCCESS (1.007s)
[440.740500] [126/133] (582s left) kms_big_fb (linear-8bpp-rotate-0)
[440.879908] Starting subtest: linear-8bpp-rotate-0
[442.150815] Subtest linear-8bpp-rotate-0: SUCCESS (1.270s)
[442.283434] [127/133] (581s left) gem_exec_create (forked)
[442.333258] Starting subtest: forked
[442.335158] Starting dynamic subtest: smem
[463.895504] Dynamic subtest smem: SUCCESS (21.559s)
[463.898283] Subtest forked: SUCCESS (21.562s)
[464.095090] [128/133] (559s left) kms_cursor_legacy (torture-move)
[464.227205] Starting subtest: torture-move
[464.229472] Starting dynamic subtest: pipe-A
[470.434623] Dynamic subtest pipe-A: SUCCESS (6.203s)
[470.449310] Starting dynamic subtest: pipe-B
[476.555137] Dynamic subtest pipe-B: SUCCESS (6.119s)
[476.567035] Starting dynamic subtest: pipe-C
[483.994040] Dynamic subtest pipe-C: SUCCESS (7.436s)
[484.008545] Starting dynamic subtest: pipe-D
[491.837292] Dynamic subtest pipe-D: SUCCESS (7.841s)
[491.846674] Starting dynamic subtest: all-pipes
[499.803616] Dynamic subtest all-pipes: SUCCESS (7.962s)
[499.805834] Subtest torture-move: SUCCESS (35.573s)
[499.975525] [129/133] (523s left) kms_vrr (flip-basic)
[500.094088] Starting subtest: flip-basic
[500.100108] Subtest flip-basic: SKIP (0.000s)
[500.164113] [130/133] (523s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[500.283519] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[500.288189] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s)
[500.435861] [131/133] (523s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[500.492057] Starting subtest: single-wait-all-for-submit-available-submitted
[500.494411] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[500.583104] [132/133] (523s left) kms_hdr (invalid-metadata-sizes)
[500.667796] Starting subtest: invalid-metadata-sizes
[500.673807] Subtest invalid-metadata-sizes: SKIP (0.000s)
[500.736855] [133/133] (523s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[500.824572] Starting subtest: yf-tiled-64bpp-rotate-90
[500.828343] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[500.926920] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_store
results: parsing output: 1/ for test: kms_joiner
results: parsing output: 2/ for test: kms_cursor_edge_walk
results: parsing output: 3/ for test: kms_pipe_crc_basic
results: parsing output: 4/ for test: kms_cursor_crc
results: parsing output: 5/ for test: gem_wait
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_atomic_transition
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: gem_softpin
results: parsing output: 13/ for test: perf_pmu
results: parsing output: 14/ for test: syncobj_wait
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_lmem_swapping
results: parsing output: 17/ for test: syncobj_eventfd
results: parsing output: 18/ for test: vgem_basic
results: parsing output: 19/ for test: api_intel_allocator
results: parsing output: 20/ for test: gen7_exec_parse
results: parsing output: 21/ for test: gem_ctx_persistence
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: kms_plane_lowres
results: parsing output: 24/ for test: kms_getfb
results: parsing output: 25/ for test: kms_plane_scaling
results: parsing output: 26/ for test: gem_wait
results: parsing output: 27/ for test: i915_suspend
results: parsing output: 28/ for test: drm_read
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_flip
results: parsing output: 31/ for test: kms_addfb_basic
results: parsing output: 32/ for test: kms_plane_scaling
results: parsing output: 33/ for test: api_intel_bb
results: parsing output: 34/ for test: gem_pxp
results: parsing output: 35/ for test: kms_addfb_basic
results: parsing output: 36/ for test: prime_vgem
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: gem_create
results: parsing output: 42/ for test: prime_self_import
results: parsing output: 43/ for test: gem_ctx_sseu
results: parsing output: 44/ for test: gem_exec_balancer
results: parsing output: 45/ for test: syncobj_wait
results: parsing output: 46/ for test: kms_sequence
results: parsing output: 47/ for test: i915_drm_fdinfo
results: parsing output: 48/ for test: gem_set_tiling_vs_blt
results: parsing output: 49/ for test: perf_pmu
results: parsing output: 50/ for test: kms_cursor_legacy
results: parsing output: 51/ for test: kms_plane
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_partial_pwrite_pread
results: parsing output: 54/ for test: dmabuf_sync_file
results: parsing output: 55/ for test: prime_mmap
results: parsing output: 56/ for test: gem_mmap_gtt
results: parsing output: 57/ for test: kms_color_pipeline
results: parsing output: 58/ for test: kms_psr2_sf
results: parsing output: 59/ for test: gem_mmap_gtt
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: perf
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_exec_schedule
results: parsing output: 64/ for test: gem_exec_capture
results: parsing output: 65/ for test: gem_mmap_wc
results: parsing output: 66/ for test: gem_ccs
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_psr2_sf
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: gem_ctx_isolation
results: parsing output: 74/ for test: gem_exec_schedule
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: i915_query
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: kms_cursor_crc
results: parsing output: 80/ for test: kms_addfb_basic
results: parsing output: 81/ for test: kms_flip_scaled_crc
results: parsing output: 82/ for test: kms_psr_stress_test
results: parsing output: 83/ for test: kms_rotation_crc
results: parsing output: 84/ for test: kms_lease
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: i915_pm_rpm
results: parsing output: 88/ for test: kms_content_protection
results: parsing output: 89/ for test: gem_mmap_wc
results: parsing output: 90/ for test: kms_atomic_transition
results: parsing output: 91/ for test: kms_addfb_basic
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_chamelium_frames
results: parsing output: 94/ for test: gem_eio
results: parsing output: 95/ for test: kms_flip
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: kms_flip_scaled_crc
results: parsing output: 98/ for test: gem_caching
results: parsing output: 99/ for test: gem_render_copy
results: parsing output: 100/ for test: gem_exec_schedule
results: parsing output: 101/ for test: gem_render_copy
results: parsing output: 102/ for test: gem_exec_fence
results: parsing output: 103/ for test: gem_exec_fence
results: parsing output: 104/ for test: syncobj_wait
results: parsing output: 105/ for test: kms_pm_dc
results: parsing output: 106/ for test: sysfs_heartbeat_interval
results: parsing output: 107/ for test: kms_chamelium_hpd
results: parsing output: 108/ for test: gem_mmap_offset
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_ccs
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_exercise_blt
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: kms_psr2_sf
results: parsing output: 116/ for test: kms_dsc
results: parsing output: 117/ for test: gem_exec_flush
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: syncobj_wait
results: parsing output: 121/ for test: i915_hangman
results: parsing output: 122/ for test: kms_chamelium_color
results: parsing output: 123/ for test: kms_properties
results: parsing output: 124/ for test: kms_prime
results: parsing output: 125/ for test: kms_big_fb
results: parsing output: 126/ for test: gem_exec_create
results: parsing output: 127/ for test: kms_cursor_legacy
results: parsing output: 128/ for test: kms_vrr
results: parsing output: 129/ for test: kms_cursor_legacy
results: parsing output: 130/ for test: syncobj_timeline
results: parsing output: 131/ for test: kms_hdr
results: parsing output: 132/ for test: kms_big_fb
Done.