[54.531844] Initializing watchdogs
[54.532345]   /dev/watchdog0
[54.548960] [001/142] (960s left) kms_ccs (pipe-a-random-ccs-data-4_tiled_dg2_rc_ccs)
[55.002811] Starting subtest: pipe-A-random-ccs-data-4_tiled_dg2_rc_ccs
[55.006866] Subtest pipe-A-random-ccs-data-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[55.567618] [002/142] (959s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[55.886119] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[55.888780] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[55.979632] [003/142] (959s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[56.306794] Starting subtest: yf-tiled-8bpp-rotate-90
[56.309844] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[56.395518] [004/142] (958s left) gem_softpin (evict-prime)
[56.625562] Starting subtest: evict-prime
[56.627069] Starting dynamic subtest: rcs0
[57.763954] Dynamic subtest rcs0: SUCCESS (1.139s)
[57.787329] Starting dynamic subtest: bcs0
[58.881454] Dynamic subtest bcs0: SUCCESS (1.117s)
[58.900820] Starting dynamic subtest: vcs0
[60.004808] Dynamic subtest vcs0: SUCCESS (1.123s)
[60.022180] Starting dynamic subtest: vecs0
[61.129217] Dynamic subtest vecs0: SUCCESS (1.124s)
[61.147831] Starting dynamic subtest: all
[62.242337] Dynamic subtest all: SUCCESS (1.113s)
[62.243734] Subtest evict-prime: SUCCESS (5.617s)
[62.331409] [005/142] (952s left) syncobj_wait (multi-wait-all-submitted)
[62.541775] Starting subtest: multi-wait-all-submitted
[62.648977] Subtest multi-wait-all-submitted: SUCCESS (0.107s)
[62.741429] [006/142] (952s left) perf_pmu (busy-no-semaphores)
[62.953853] Starting subtest: busy-no-semaphores
[62.955482] Starting dynamic subtest: rcs0
[63.492336] Dynamic subtest rcs0: SUCCESS (0.537s)
[63.508310] Starting dynamic subtest: bcs0
[64.020437] Dynamic subtest bcs0: SUCCESS (0.527s)
[64.035676] Starting dynamic subtest: vcs0
[64.546666] Dynamic subtest vcs0: SUCCESS (0.525s)
[64.561666] Starting dynamic subtest: vecs0
[65.074414] Dynamic subtest vecs0: SUCCESS (0.527s)
[65.075814] Subtest busy-no-semaphores: SUCCESS (2.120s)
[65.181634] [007/142] (950s left) syncobj_wait (multi-wait-for-submit-submitted)
[65.391872] Starting subtest: multi-wait-for-submit-submitted
[65.497109] Subtest multi-wait-for-submit-submitted: SUCCESS (0.105s)
[65.581275] [008/142] (949s left) kms_chamelium_color (ctm-0-75)
[65.885478] Subtest ctm-0-75: SKIP (0.000s)
[65.930405] [009/142] (949s left) gem_ctx_shared (q-promotion)
[66.161476] Starting subtest: Q-promotion
[66.163158] Starting dynamic subtest: rcs0
[66.351803] Dynamic subtest rcs0: SUCCESS (0.189s)
[66.371383] Starting dynamic subtest: bcs0
[66.472534] Dynamic subtest bcs0: SUCCESS (0.121s)
[66.491561] Starting dynamic subtest: vcs0
[66.570866] Dynamic subtest vcs0: SUCCESS (0.098s)
[66.589884] Starting dynamic subtest: vecs0
[66.669659] Dynamic subtest vecs0: SUCCESS (0.098s)
[66.671451] Subtest Q-promotion: SUCCESS (0.508s)
[66.898939] [010/142] (948s left) kms_ccs (pipe-d-crc-primary-rotation-180-4_tiled_dg2_mc_ccs)
[67.580652] Subtest pipe-D-crc-primary-rotation-180-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[67.896921] [011/142] (947s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[68.196792] Starting subtest: compare-crc-sanitycheck-xr24
[68.198240] Starting dynamic subtest: pipe-A-DP-1
[68.640807] Dynamic subtest pipe-A-DP-1: SUCCESS (0.444s)
[68.658136] Starting dynamic subtest: pipe-B-DP-1
[69.377768] Dynamic subtest pipe-B-DP-1: SUCCESS (0.732s)
[69.393788] Starting dynamic subtest: pipe-C-DP-1
[70.245105] Dynamic subtest pipe-C-DP-1: SUCCESS (0.860s)
[70.246609] Subtest compare-crc-sanitycheck-xr24: SUCCESS (2.044s)
[70.570456] [012/142] (944s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu)
[70.888590] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu
[70.891518] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[70.987852] [013/142] (944s left) gem_mmap_wc (write-wc-read-gtt)
[71.196226] Starting subtest: write-wc-read-gtt
[71.739395] Subtest write-wc-read-gtt: SUCCESS (0.544s)
[71.853314] [014/142] (943s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs)
[72.528764] Starting subtest: pipe-C-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs
[72.533985] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs: SKIP (0.004s)
[72.844155] [015/142] (942s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[73.068186] Starting subtest: y-tiled-ccs-to-yf-tiled
[73.069770] Starting dynamic subtest: smem
[73.463860] Dynamic subtest smem: SUCCESS (0.396s)
[73.465230] Subtest y-tiled-ccs-to-yf-tiled: SUCCESS (0.396s)
[73.662303] [016/142] (941s left) kms_big_joiner (basic)
[73.970076] Subtest basic: SKIP (0.000s)
[74.009492] [017/142] (941s left) gem_fence_thrash (bo-write-verify-threaded-y)
[74.210638] Starting subtest: bo-write-verify-threaded-y
[76.785641] Subtest bo-write-verify-threaded-y: SUCCESS (2.577s)
[76.879775] [018/142] (938s left) sw_sync (sync_multi_timeline_wait)
[77.081241] Starting subtest: sync_multi_timeline_wait
[77.082732] Subtest sync_multi_timeline_wait: SUCCESS (0.002s)
[77.144187] [019/142] (938s left) kms_atomic (atomic_plane_damage)
[77.750726] Starting subtest: atomic_plane_damage
[77.757370] Subtest atomic_plane_damage: SKIP (0.000s)
[78.181448] [020/142] (937s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[78.481753] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[78.483177] Starting dynamic subtest: pipe-A-valid-mode
[79.236192] Dynamic subtest pipe-A-valid-mode: SKIP (0.752s)
[79.239447] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.754s)
[79.637653] [021/142] (936s left) kms_flip (dpms-off-confusion-interruptible)
[79.941170] Starting subtest: dpms-off-confusion-interruptible
[79.945426] Starting dynamic subtest: A-DP1
[90.469898] Dynamic subtest A-DP1: SUCCESS (10.524s)
[90.488799] Starting dynamic subtest: B-DP1
[100.919973] Dynamic subtest B-DP1: SUCCESS (10.445s)
[100.941360] Starting dynamic subtest: C-DP1
[111.354412] Dynamic subtest C-DP1: SUCCESS (10.429s)
[111.357158] Subtest dpms-off-confusion-interruptible: SUCCESS (31.415s)
[111.745119] [022/142] (904s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[112.055681] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[114.305828] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SUCCESS (2.252s)
[114.442085] [023/142] (901s left) kms_rotation_crc (sprite-rotation-270)
[114.748972] Starting subtest: sprite-rotation-270
[120.882891] Subtest sprite-rotation-270: SUCCESS (6.133s)
[121.303987] [024/142] (894s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[121.617217] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[121.619852] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[121.719799] [025/142] (894s left) kms_flip (nonexisting-fb)
[122.006478] Starting subtest: nonexisting-fb
[122.007905] Starting dynamic subtest: A-DP1
[122.559558] Dynamic subtest A-DP1: SUCCESS (0.553s)
[122.577372] Starting dynamic subtest: B-DP1
[123.016133] Dynamic subtest B-DP1: SUCCESS (0.455s)
[123.032651] Starting dynamic subtest: C-DP1
[123.479098] Dynamic subtest C-DP1: SUCCESS (0.463s)
[123.482566] Subtest nonexisting-fb: SUCCESS (1.481s)
[123.909350] [026/142] (892s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[124.221582] Starting subtest: fbc-rgb565-draw-mmap-gtt
[126.385308] Subtest fbc-rgb565-draw-mmap-gtt: SUCCESS (2.165s)
[126.507598] [027/142] (889s left) kms_invalid_mode (zero-hdisplay)
[126.822753] Starting subtest: zero-hdisplay
[126.825534] Starting dynamic subtest: DP-1-pipe-A
[126.911391] Dynamic subtest DP-1-pipe-A: SUCCESS (0.097s)
[126.936558] Starting dynamic subtest: DP-1-pipe-B
[126.939430] Dynamic subtest DP-1-pipe-B: SUCCESS (0.014s)
[126.958210] Starting dynamic subtest: DP-1-pipe-C
[126.959484] Dynamic subtest DP-1-pipe-C: SUCCESS (0.016s)
[126.961179] Subtest zero-hdisplay: SUCCESS (0.135s)
[127.285550] [028/142] (888s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[127.598690] Starting subtest: cursor-rapid-movement-32x10
[127.716924] Subtest cursor-rapid-movement-32x10: SKIP (0.116s)
[127.834336] [029/142] (888s left) prime_mmap (test_refcounting)
[128.043289] Starting subtest: test_refcounting
[128.044659] Starting dynamic subtest: test_refcounting-smem
[128.050447] Dynamic subtest test_refcounting-smem: SUCCESS (0.007s)
[128.052529] Subtest test_refcounting: SUCCESS (0.008s)
[128.150752] [030/142] (887s left) kms_ccs (pipe-b-crc-primary-rotation-180-yf_tiled_ccs)
[128.653244] Starting subtest: pipe-B-crc-primary-rotation-180-yf_tiled_ccs
[129.305663] Subtest pipe-B-crc-primary-rotation-180-yf_tiled_ccs: SUCCESS (0.652s)
[129.868715] [031/142] (886s left) drm_read (short-buffer-nonblock)
[130.297709] Starting subtest: short-buffer-nonblock
[130.300470] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[130.418715] [032/142] (885s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[130.719620] Starting subtest: cursorA-vs-flipA-atomic-transitions
[141.835179] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.115s)
[142.199083] [033/142] (873s left) gem_partial_pwrite_pread (reads-uncached)
[142.426536] Starting subtest: reads-uncached
[149.284764] Subtest reads-uncached: SUCCESS (6.858s)
[149.397612] [034/142] (866s left) syncobj_timeline (invalid-signal-bad-pad)
[149.608702] Starting subtest: invalid-signal-bad-pad
[149.610442] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[149.697570] [035/142] (866s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[150.013513] Starting subtest: primary-yf-tiled-reflect-x-90
[150.016507] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.003s)
[150.100162] [036/142] (866s left) vgem_basic (bad-flag)
[150.325790] Starting subtest: bad-flag
[150.327412] Subtest bad-flag: SUCCESS (0.000s)
[150.398456] [037/142] (865s left) kms_ccs (pipe-c-bad-pixel-format-4_tiled_mtl_rc_ccs_cc)
[151.007572] Starting subtest: pipe-C-bad-pixel-format-4_tiled_mtl_rc_ccs_cc
[151.010380] Subtest pipe-C-bad-pixel-format-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[151.421882] [038/142] (864s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[151.738924] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[151.742550] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[151.838978] [039/142] (864s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[152.054157] Starting subtest: invalid-bsd2-flag-on-vebox
[152.056133] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.001s)
[152.155175] [040/142] (864s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[152.461655] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[152.463206] Starting dynamic subtest: pipe-A-DP-1
[152.805057] Dynamic subtest pipe-A-DP-1: SUCCESS (0.345s)
[152.830056] Starting dynamic subtest: pipe-B-DP-1
[153.211418] Dynamic subtest pipe-B-DP-1: SUCCESS (0.401s)
[153.231359] Starting dynamic subtest: pipe-C-DP-1
[153.592453] Dynamic subtest pipe-C-DP-1: SUCCESS (0.375s)
[153.593937] Subtest planes-downscale-factor-0-5-unity-scaling: SUCCESS (1.135s)
[154.002123] [041/142] (862s left) gem_ctx_persistence (engines-queued)
[154.217929] Starting subtest: engines-queued
[154.219801] Starting dynamic subtest: rcs0
[154.274393] Dynamic subtest rcs0: SUCCESS (0.053s)
[154.291912] Starting dynamic subtest: bcs0
[154.425516] Dynamic subtest bcs0: SUCCESS (0.151s)
[154.447132] Starting dynamic subtest: vcs0
[154.482506] Dynamic subtest vcs0: SUCCESS (0.055s)
[154.503753] Starting dynamic subtest: vecs0
[154.535582] Dynamic subtest vecs0: SUCCESS (0.051s)
[154.537076] Subtest engines-queued: SUCCESS (0.319s)
[154.635879] [042/142] (861s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[154.840555] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[154.842148] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.002s)
[154.935453] [043/142] (861s left) gem_exec_capture (pi)
[155.153134] Starting subtest: pi
[155.155254] Starting dynamic subtest: rcs0
[185.648035] Dynamic subtest rcs0: SUCCESS (30.493s)
[185.668202] Starting dynamic subtest: bcs0
[215.415408] Dynamic subtest bcs0: SUCCESS (29.767s)
[215.437278] Starting dynamic subtest: vcs0
[245.224751] Dynamic subtest vcs0: SUCCESS (29.807s)
[245.246759] Starting dynamic subtest: vecs0
[275.722623] Dynamic subtest vecs0: SUCCESS (30.494s)
[275.724386] Subtest pi: SUCCESS (120.571s)
[275.824711] [044/142] (740s left) api_intel_allocator (two-level-inception-interruptible)
[276.156266] Starting subtest: two-level-inception-interruptible
[281.710437] Subtest two-level-inception-interruptible: SUCCESS (5.554s)
[281.804989] [045/142] (734s left) kms_universal_plane (universal-plane-pipe-a-sanity)
[282.115623] Starting subtest: universal-plane-pipe-A-sanity
[282.547055] Subtest universal-plane-pipe-A-sanity: SUCCESS (0.433s)
[282.867831] [046/142] (733s left) kms_ccs (pipe-a-bad-pixel-format-y_tiled_ccs)
[283.171916] Starting subtest: pipe-A-bad-pixel-format-y_tiled_ccs
[283.173418] Subtest pipe-A-bad-pixel-format-y_tiled_ccs: SUCCESS (0.001s)
[283.868757] [047/142] (732s left) v3d/v3d_wait_bo (used-bo-1ns)
[284.146748] Subtest used-bo-1ns: SKIP (0.000s)
[284.218471] [048/142] (732s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[284.540368] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[284.543067] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[284.636282] [049/142] (732s left) kms_atomic_interruptible (atomic-setmode)
[284.946332] Starting subtest: atomic-setmode
[284.950639] Starting dynamic subtest: DP-1-pipe-A
[291.504164] Dynamic subtest DP-1-pipe-A: SUCCESS (6.549s)
[291.505693] Subtest atomic-setmode: SUCCESS (6.554s)
[291.842508] [050/142] (725s left) kms_chamelium_frames (hdmi-crc-multiple)
[292.234373] Subtest hdmi-crc-multiple: SKIP (0.000s)
[292.526257] [051/142] (724s left) perf_pmu (rc6-suspend)
[292.738790] Starting subtest: rc6-suspend
[316.151507] Subtest rc6-suspend: SUCCESS (8.701s)
[317.249815] [052/142] (715s left) kms_vblank (pipe-c-query-idle)
[317.553144] Starting subtest: pipe-C-query-idle
[320.398768] Subtest pipe-C-query-idle: SUCCESS (2.846s)
[320.715366] [053/142] (711s left) i915_pm_rpm (dpms-mode-unset-non-lpsp)
[322.704802] Starting subtest: dpms-mode-unset-non-lpsp
[324.276642] Subtest dpms-mode-unset-non-lpsp: SUCCESS (1.572s)
[324.765963] [054/142] (707s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[325.107922] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[325.111270] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[325.212948] [055/142] (707s left) kms_psr2_su (frontbuffer-xrgb8888)
[325.419063] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[325.477476] [056/142] (707s left) syncobj_timeline (single-wait-all-available-signaled)
[325.682117] Starting subtest: single-wait-all-available-signaled
[325.683977] Subtest single-wait-all-available-signaled: SUCCESS (0.001s)
[325.778823] [057/142] (707s left) gem_madvise (dontneed-before-exec)
[325.979417] Starting subtest: dontneed-before-exec
[325.989965] Subtest dontneed-before-exec: SUCCESS (0.008s)
[326.095115] [058/142] (706s left) kms_concurrent (pipe-b)
[326.403997] Starting subtest: pipe-B
[326.405938] Starting dynamic subtest: DP-1
[327.280763] Dynamic subtest DP-1: SUCCESS (0.872s)
[327.282566] Subtest pipe-B: SUCCESS (0.877s)
[327.607641] [059/142] (705s left) kms_universal_plane (cursor-fb-leak-pipe-b)
[327.913140] Starting subtest: cursor-fb-leak-pipe-B
[328.630470] Subtest cursor-fb-leak-pipe-B: SUCCESS (0.720s)
[328.988009] [060/142] (704s left) gen9_exec_parse (bb-start-cmd)
[329.220469] Starting subtest: bb-start-cmd
[329.227495] Subtest bb-start-cmd: SUCCESS (0.006s)
[329.455143] [061/142] (703s left) gem_eio (wait-1us)
[329.690577] Starting subtest: wait-1us
[329.781152] Subtest wait-1us: SUCCESS (0.090s)
[329.989553] [062/142] (703s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[330.300103] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[330.301629] Starting dynamic subtest: pipe-A-valid-mode
[331.005167] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.703s)
[331.006827] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SUCCESS (0.708s)
[331.363766] [063/142] (701s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[331.677088] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[334.001031] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (2.326s)
[334.130439] [064/142] (699s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[334.452751] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[334.455758] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[334.563934] [065/142] (698s left) syncobj_wait (wait-any-snapshot)
[334.770162] Starting subtest: wait-any-snapshot
[334.853190] Subtest wait-any-snapshot: SUCCESS (0.082s)
[334.946610] [066/142] (698s left) kms_vrr (flip-basic)
[335.249402] Starting subtest: flip-basic
[335.252034] Subtest flip-basic: SKIP (0.000s)
[335.330575] [067/142] (697s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[335.651032] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[335.654214] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[335.764230] [068/142] (697s left) gem_create (create-ext-cpu-access-sanity-check)
[336.096921] Starting subtest: create-ext-cpu-access-sanity-check
[336.100393] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[336.197184] [069/142] (697s left) kms_sequence (queue-idle)
[336.506662] Starting subtest: queue-idle
[336.508593] Starting dynamic subtest: DP-1-pipe-A
[338.797356] Dynamic subtest DP-1-pipe-A: SUCCESS (2.290s)
[338.827734] Starting dynamic subtest: DP-1-pipe-B
[341.386274] Dynamic subtest DP-1-pipe-B: SUCCESS (2.584s)
[341.415089] Starting dynamic subtest: DP-1-pipe-C
[344.088076] Dynamic subtest DP-1-pipe-C: SUCCESS (2.697s)
[344.089467] Subtest queue-idle: SUCCESS (7.585s)
[344.419487] [070/142] (689s left) kms_ccs (pipe-d-bad-pixel-format-4_tiled_mtl_rc_ccs)
[345.097844] Subtest pipe-D-bad-pixel-format-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[345.415949] [071/142] (688s left) i915_query (engine-info)
[345.624517] Starting subtest: engine-info
[345.627147] Subtest engine-info: SUCCESS (0.004s)
[345.750508] [072/142] (687s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[346.063644] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[346.066501] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[346.165986] [073/142] (687s left) syncobj_timeline (32bits-limit)
[346.374119] Starting subtest: 32bits-limit
[346.379042] Subtest 32bits-limit: SUCCESS (0.003s)
[346.466011] [074/142] (687s left) perf (unprivileged-single-ctx-counters)
[346.807353] Starting subtest: unprivileged-single-ctx-counters
[346.810589] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[346.864495] [075/142] (686s left) api_intel_bb (simple-bb-ctx)
[347.072716] Starting subtest: simple-bb-ctx
[347.086625] Subtest simple-bb-ctx: SUCCESS (0.014s)
[347.198945] [076/142] (686s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[347.518462] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[347.521953] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[347.632855] [077/142] (686s left) kms_plane_scaling (plane-downscale-with-pixel-format-factor-0-25)
[347.943703] Starting subtest: plane-downscale-with-pixel-format-factor-0-25
[347.945179] Starting dynamic subtest: pipe-A-DP-1
[347.990189] Dynamic subtest pipe-A-DP-1: SKIP (0.039s)
[348.029304] Starting dynamic subtest: pipe-B-DP-1
[348.084036] Dynamic subtest pipe-B-DP-1: SKIP (0.094s)
[348.120355] Starting dynamic subtest: pipe-C-DP-1
[348.187444] Dynamic subtest pipe-C-DP-1: SKIP (0.094s)
[348.190963] Subtest plane-downscale-with-pixel-format-factor-0-25: SKIP (0.243s)
[348.282566] [078/142] (685s left) i915_pm_dc (dc5-psr)
[349.595189] Starting subtest: dc5-psr
[349.599832] Subtest dc5-psr: SKIP (0.000s)
[349.765890] [079/142] (684s left) kms_ccs (pipe-b-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc)
[350.299058] Starting subtest: pipe-B-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc
[350.301836] Subtest pipe-B-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[350.763459] [080/142] (683s left) kms_getfb (getfb-handle-valid)
[350.969829] Starting subtest: getfb-handle-valid
[350.971642] Subtest getfb-handle-valid: SUCCESS (0.000s)
[351.080252] [081/142] (682s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[351.387190] Starting subtest: fbc-tiling-linear
[353.283478] Subtest fbc-tiling-linear: SUCCESS (1.898s)
[353.430246] [082/142] (680s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-render)
[353.757262] Starting subtest: psr-1p-offscren-pri-indfb-draw-render
[353.760230] Subtest psr-1p-offscren-pri-indfb-draw-render: SKIP (0.000s)
[353.863595] [083/142] (680s left) kms_ccs (pipe-d-random-ccs-data-4_tiled_mtl_rc_ccs)
[354.575714] Subtest pipe-D-random-ccs-data-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[354.911602] [084/142] (679s left) kms_addfb_basic (invalid-get-prop)
[355.120387] Starting subtest: invalid-get-prop
[355.121975] Subtest invalid-get-prop: SUCCESS (0.000s)
[355.328449] [085/142] (678s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[355.732777] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[356.035786] [086/142] (678s left) gem_exec_store (cachelines)
[356.266438] Starting subtest: cachelines
[356.271539] Starting dynamic subtest: rcs0
[356.319811] Dynamic subtest rcs0: SUCCESS (0.051s)
[356.352629] Starting dynamic subtest: bcs0
[356.354139] Dynamic subtest bcs0: SUCCESS (0.028s)
[356.381385] Starting dynamic subtest: vcs0
[356.383801] Dynamic subtest vcs0: SUCCESS (0.025s)
[356.410144] Starting dynamic subtest: vecs0
[356.414918] Dynamic subtest vecs0: SUCCESS (0.031s)
[356.416396] Subtest cachelines: SUCCESS (0.147s)
[356.630333] [087/142] (677s left) gem_exec_fence (submit67)
[356.993231] Starting subtest: submit67
[356.995027] Starting dynamic subtest: rcs0
[359.274539] Dynamic subtest rcs0: SUCCESS (2.279s)
[359.305128] Starting dynamic subtest: bcs0
[360.302167] Dynamic subtest bcs0: SUCCESS (1.020s)
[360.340612] Starting dynamic subtest: vcs0
[361.398211] Dynamic subtest vcs0: SUCCESS (1.092s)
[361.430835] Starting dynamic subtest: vecs0
[362.553251] Dynamic subtest vecs0: SUCCESS (1.154s)
[362.554947] Subtest submit67: SUCCESS (5.558s)
[363.230071] [088/142] (671s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[363.444388] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[363.512235] [089/142] (670s left) drm_fdinfo (busy-hang)
[363.723513] Starting subtest: busy-hang
[363.725133] Starting dynamic subtest: rcs0
[364.768031] Dynamic subtest rcs0: SUCCESS (1.043s)
[364.796577] Starting dynamic subtest: bcs0
[365.824827] Dynamic subtest bcs0: SUCCESS (1.054s)
[365.851699] Starting dynamic subtest: vcs0
[366.859371] Dynamic subtest vcs0: SUCCESS (1.032s)
[366.888187] Starting dynamic subtest: vecs0
[367.904721] Dynamic subtest vecs0: SUCCESS (1.042s)
[367.906263] Subtest busy-hang: SUCCESS (4.182s)
[367.996501] [090/142] (666s left) i915_suspend (debugfs-reader)
[368.202785] Starting subtest: debugfs-reader
[388.017604] Subtest debugfs-reader: SUCCESS (3.511s)
[392.763347] [091/142] (662s left) kms_flip (dpms-vs-vblank-race-interruptible)
[393.074986] Starting subtest: dpms-vs-vblank-race-interruptible
[393.080342] Starting dynamic subtest: A-DP1
[397.380013] Dynamic subtest A-DP1: SUCCESS (4.286s)
[397.405447] Starting dynamic subtest: B-DP1
[401.663309] Dynamic subtest B-DP1: SUCCESS (4.283s)
[401.688083] Starting dynamic subtest: C-DP1
[405.876124] Dynamic subtest C-DP1: SUCCESS (4.218s)
[405.879213] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (12.802s)
[406.262364] [092/142] (649s left) kms_ccs (pipe-a-crc-primary-basic-y_tiled_gen12_mc_ccs)
[406.693177] Starting subtest: pipe-A-crc-primary-basic-y_tiled_gen12_mc_ccs
[406.696162] Subtest pipe-A-crc-primary-basic-y_tiled_gen12_mc_ccs: SKIP (0.002s)
[407.281684] [093/142] (648s left) kms_flip (flip-vs-blocking-wf-vblank)
[407.572753] Starting subtest: flip-vs-blocking-wf-vblank
[407.577364] Starting dynamic subtest: A-DP1
[418.393903] Dynamic subtest A-DP1: SUCCESS (10.818s)
[418.419314] Starting dynamic subtest: B-DP1
[429.159174] Dynamic subtest B-DP1: SUCCESS (10.763s)
[429.185922] Starting dynamic subtest: C-DP1
[439.917798] Dynamic subtest C-DP1: SUCCESS (10.755s)
[439.922528] Subtest flip-vs-blocking-wf-vblank: SUCCESS (32.351s)
[440.358588] [094/142] (615s left) v3d/v3d_create_bo (create-bo-4096)
[440.628123] Subtest create-bo-4096: SKIP (0.000s)
[440.706102] [095/142] (614s left) vc4/vc4_perfmon (create-single-perfmon)
[440.961229] Subtest create-single-perfmon: SKIP (0.000s)
[441.038803] [096/142] (614s left) gem_userptr_blits (probe)
[441.315583] Starting subtest: probe
[442.628132] Subtest probe: SUCCESS (1.312s)
[442.755673] [097/142] (612s left) gem_exec_schedule (noreorder-corked)
[443.128086] Starting subtest: noreorder-corked
[443.129694] Starting dynamic subtest: rcs0
[444.256640] Dynamic subtest rcs0: SUCCESS (1.127s)
[444.284163] Starting dynamic subtest: bcs0
[445.388418] Dynamic subtest bcs0: SUCCESS (1.128s)
[445.419266] Starting dynamic subtest: vcs0
[446.519934] Dynamic subtest vcs0: SUCCESS (1.127s)
[446.547916] Starting dynamic subtest: vecs0
[447.648748] Dynamic subtest vecs0: SUCCESS (1.125s)
[447.650867] Subtest noreorder-corked: SUCCESS (4.522s)
[447.856732] [098/142] (607s left) gem_mmap_gtt (isolation)
[448.062974] Starting subtest: isolation
[448.068803] Subtest isolation: SUCCESS (0.003s)
[448.171730] [099/142] (607s left) kms_ccs (pipe-b-bad-pixel-format-y_tiled_gen12_rc_ccs)
[448.656154] Starting subtest: pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs
[448.658853] Subtest pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[449.170499] [100/142] (606s left) gem_pread (display)
[449.377991] Starting subtest: display
[453.758995] Subtest display: SUCCESS (4.381s)
[453.869083] [101/142] (601s left) gem_exec_schedule (submit-golden-slice)
[454.107519] Starting subtest: submit-golden-slice
[454.109287] Starting dynamic subtest: rcs0
[454.158799] Dynamic subtest rcs0: SUCCESS (0.050s)
[454.183841] Starting dynamic subtest: bcs0
[454.211743] Dynamic subtest bcs0: SUCCESS (0.051s)
[454.239535] Starting dynamic subtest: vcs0
[454.258061] Dynamic subtest vcs0: SUCCESS (0.043s)
[454.290675] Starting dynamic subtest: vecs0
[454.309082] Dynamic subtest vecs0: SUCCESS (0.047s)
[454.310633] Subtest submit-golden-slice: SUCCESS (0.203s)
[454.686756] [102/142] (601s left) v3d/v3d_perfmon (get-values-invalid-perfmon)
[454.941928] Subtest get-values-invalid-perfmon: SKIP (0.000s)
[455.026812] [103/142] (600s left) prime_mmap (test_forked_cpu_write)
[455.232522] Starting subtest: test_forked_cpu_write
[455.234797] Starting dynamic subtest: test_forked_cpu_write-smem
[455.267626] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.034s)
[455.269380] Subtest test_forked_cpu_write: SUCCESS (0.037s)
[455.388519] [104/142] (600s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[455.601532] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[455.603584] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.002s)
[455.685991] [105/142] (600s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[455.892792] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[455.951242] [106/142] (600s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[456.260235] Starting subtest: psr-rgb565-draw-pwrite
[456.263035] Subtest psr-rgb565-draw-pwrite: SKIP (0.000s)
[456.370933] [107/142] (599s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[456.694247] Starting subtest: x-tiled-32bpp-rotate-270
[456.781414] Subtest x-tiled-32bpp-rotate-270: SKIP (0.086s)
[456.887516] [108/142] (599s left) kms_ccs (pipe-d-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc)
[457.568171] Subtest pipe-D-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[457.883662] [109/142] (598s left) feature_discovery (chamelium)
[458.187507] Starting subtest: chamelium
[458.190393] Subtest chamelium: SKIP (0.001s)
[458.283550] [110/142] (597s left) gem_exec_balancer (bonded-pair)
[458.516375] Starting subtest: bonded-pair
[462.269399] Subtest bonded-pair: SUCCESS (3.752s)
[466.216689] [111/142] (590s left) kms_plane_alpha_blend (constant-alpha-min)
[466.526248] Starting subtest: constant-alpha-min
[466.831935] Starting dynamic subtest: pipe-A-DP-1
[467.519154] Dynamic subtest pipe-A-DP-1: SUCCESS (0.684s)
[467.545471] Starting dynamic subtest: pipe-C-DP-1
[468.460438] Dynamic subtest pipe-C-DP-1: SUCCESS (0.937s)
[468.461978] Subtest constant-alpha-min: SUCCESS (1.936s)
[468.820505] [112/142] (587s left) gem_exec_params (rs-invalid)
[469.034733] Starting subtest: rs-invalid
[469.043305] Subtest rs-invalid: SUCCESS (0.006s)
[469.153482] [113/142] (587s left) kms_draw_crc (fill-fb)
[469.456328] Starting subtest: fill-fb
[469.892524] Subtest fill-fb: SUCCESS (0.435s)
[470.020133] [114/142] (586s left) kms_fb_coherency (memset-crc)
[470.323239] Starting subtest: memset-crc
[470.324672] Starting dynamic subtest: mmap-gtt
[470.789715] Dynamic subtest mmap-gtt: SUCCESS (0.466s)
[470.928905] Starting dynamic subtest: mmap-offset-wc
[471.493617] Dynamic subtest mmap-offset-wc: SUCCESS (0.592s)
[471.620579] Starting dynamic subtest: mmap-offset-uc
[472.878284] Dynamic subtest mmap-offset-uc: SUCCESS (1.285s)
[473.013159] Starting dynamic subtest: mmap-legacy-wc
[473.599995] Dynamic subtest mmap-legacy-wc: SUCCESS (0.608s)
[473.702677] Subtest memset-crc: SUCCESS (3.378s)
[474.054208] [115/142] (582s left) kms_ccs (pipe-c-bad-rotation-90-y_tiled_gen12_rc_ccs_cc)
[474.639519] Starting subtest: pipe-C-bad-rotation-90-y_tiled_gen12_rc_ccs_cc
[474.642431] Subtest pipe-C-bad-rotation-90-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[475.055565] [116/142] (581s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[475.373154] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[475.376224] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[475.488498] [117/142] (581s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[475.792274] Starting subtest: 2x-flip-vs-rmfb-interruptible
[475.798187] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.004s)
[475.905442] [118/142] (580s left) gem_exec_balancer (parallel-keep-in-fence)
[479.941889] Subtest parallel-keep-in-fence: SKIP (0.000s)
[480.038455] [119/142] (576s left) gem_eio (reset-stress)
[480.269317] Starting subtest: reset-stress
[513.187410] Subtest reset-stress: SUCCESS (32.921s)
[513.389500] [120/142] (543s left) kms_big_fb (linear-8bpp-rotate-270)
[513.727999] Starting subtest: linear-8bpp-rotate-270
[513.818587] Subtest linear-8bpp-rotate-270: SKIP (0.090s)
[513.938743] [121/142] (542s left) i915_pm_rpm (system-suspend-devices)
[515.754727] Starting subtest: system-suspend-devices
[521.927896] Subtest system-suspend-devices: SUCCESS (5.915s)
[527.173760] [122/142] (534s left) sw_sync (sync_busy)
[527.380096] Starting subtest: sync_busy
[527.385862] Subtest sync_busy: SUCCESS (0.007s)
[527.462120] [123/142] (534s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[527.763564] Starting subtest: 2x-long-cursor-vs-flip-atomic
[527.766288] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.005s)
[527.863805] [124/142] (534s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[528.169255] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[528.172563] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.004s)
[528.263596] [125/142] (533s left) kms_prop_blob (blob-prop-validate)
[528.468433] Starting subtest: blob-prop-validate
[528.470163] Subtest blob-prop-validate: SUCCESS (0.000s)
[528.564192] [126/142] (533s left) gem_mmap_gtt (basic-read)
[528.768304] Starting subtest: basic-read
[528.847910] Subtest basic-read: SUCCESS (0.080s)
[528.962581] [127/142] (533s left) gem_ctx_param (invalid-set-ringsize)
[529.169356] Starting subtest: invalid-set-ringsize
[529.171378] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[529.262622] [128/142] (532s left) kms_vblank (pipe-a-ts-continuation-modeset-rpm)
[529.569194] Starting subtest: pipe-A-ts-continuation-modeset-rpm
[531.493188] Subtest pipe-A-ts-continuation-modeset-rpm: SUCCESS (1.926s)
[531.928048] [129/142] (530s left) gem_pread (bench)
[532.136313] Starting subtest: bench
[536.375307] Subtest bench: SUCCESS (4.237s)
[536.478381] [130/142] (525s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-pwrite)
[536.794654] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-pwrite
[536.798133] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-pwrite: SKIP (0.000s)
[536.911260] [131/142] (525s left) vgem_basic (dmabuf-fence-before)
[537.116268] Starting subtest: dmabuf-fence-before
[537.118091] Subtest dmabuf-fence-before: SUCCESS (0.002s)
[537.194240] [132/142] (525s left) gem_wait (busy)
[537.444424] Starting subtest: busy
[537.446322] Starting dynamic subtest: all-engines
[537.971333] Dynamic subtest all-engines: SUCCESS (0.528s)
[538.003201] Starting dynamic subtest: rcs0
[538.499108] Dynamic subtest rcs0: SUCCESS (0.523s)
[538.527489] Starting dynamic subtest: bcs0
[539.019671] Dynamic subtest bcs0: SUCCESS (0.517s)
[539.048311] Starting dynamic subtest: vcs0
[539.537670] Dynamic subtest vcs0: SUCCESS (0.515s)
[539.567261] Starting dynamic subtest: vecs0
[540.052792] Dynamic subtest vecs0: SUCCESS (0.512s)
[540.054779] Subtest busy: SUCCESS (2.613s)
[540.311265] [133/142] (521s left) kms_scaling_modes (scaling-mode-none)
[540.619468] Starting subtest: scaling-mode-none
[540.622365] Subtest scaling-mode-none: SKIP (0.001s)
[540.711366] [134/142] (521s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[541.045383] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[542.498056] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.452s)
[542.646671] [135/142] (519s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[542.968542] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[542.971402] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[543.061444] [136/142] (519s left) kms_cursor_edge_walk (256x256-left-edge)
[543.366098] Starting subtest: 256x256-left-edge
[543.367549] Starting dynamic subtest: pipe-A-DP-1
[547.018254] Dynamic subtest pipe-A-DP-1: SUCCESS (3.648s)
[547.045189] Starting dynamic subtest: pipe-C-DP-1
[550.505346] Dynamic subtest pipe-C-DP-1: SUCCESS (3.482s)
[550.506794] Subtest 256x256-left-edge: SUCCESS (7.140s)
[550.827707] [137/142] (511s left) v3d/v3d_submit_cl (multiple-job-submission)
[551.097508] Subtest multiple-job-submission: SKIP (0.000s)
[551.175792] [138/142] (511s left) kms_cursor_crc (cursor-random-128x128)
[551.494730] Starting subtest: cursor-random-128x128
[551.507875] Starting dynamic subtest: pipe-A-DP-1
[555.315538] Dynamic subtest pipe-A-DP-1: SUCCESS (3.807s)
[555.427354] Starting dynamic subtest: pipe-C-DP-1
[559.549226] Dynamic subtest pipe-C-DP-1: SUCCESS (4.152s)
[559.550902] Subtest cursor-random-128x128: SUCCESS (8.054s)
[559.915432] [139/142] (502s left) kms_vblank (pipe-c-query-forked-busy-hang)
[560.214157] Starting subtest: pipe-C-query-forked-busy-hang
[568.026730] Subtest pipe-C-query-forked-busy-hang: SUCCESS (7.814s)
[568.387210] [140/142] (494s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[568.701708] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[568.704559] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[568.803160] [141/142] (493s left) kms_content_protection (atomic)
[569.141054] Starting subtest: atomic
[569.173530] Starting dynamic subtest: pipe-A-DP-1
[689.370092] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[690.146340] Closing watchdogs
[690.149476] Initializing watchdogs
[690.149662]   /dev/watchdog0
[690.180096] [142/142] (372s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc)
[690.757316] Starting subtest: pipe-B-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc
[690.766851] Subtest pipe-B-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.005s)
[691.194960] Closing watchdogs
Done.