[52.805421] Initializing watchdogs
[52.805669]   /dev/watchdog0
[52.838446] [001/142] (960s left) kms_cursor_crc (cursor-random-256x85)
[53.298640] Starting subtest: cursor-random-256x85
[53.339461] Starting dynamic subtest: pipe-A-DP-1
[57.355393] Dynamic subtest pipe-A-DP-1: SUCCESS (4.013s)
[57.432074] Starting dynamic subtest: pipe-C-DP-1
[61.532238] Dynamic subtest pipe-C-DP-1: SUCCESS (4.127s)
[61.551220] Subtest cursor-random-256x85: SUCCESS (8.239s)
[61.936999] [002/142] (951s left) i915_pm_freq_mult (media-freq)
[62.236325] Starting subtest: media-freq
[62.255081] Starting dynamic subtest: gt0
[62.293505] Dynamic subtest gt0: SKIP (0.000s)
[62.336099] Subtest media-freq: SKIP (0.001s)
[62.434739] [003/142] (951s left) kms_ccs (pipe-d-random-ccs-data-yf_tiled_ccs)
[63.241861] Subtest pipe-D-random-ccs-data-yf_tiled_ccs: SKIP (0.000s)
[63.545500] [004/142] (950s left) kms_addfb_basic (addfb25-bad-modifier)
[63.843394] Starting subtest: addfb25-bad-modifier
[63.863772] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[64.038714] [005/142] (949s left) gem_set_tiling_vs_pwrite
[64.489580] [006/142] (949s left) gem_ctx_param (invalid-param-set)
[64.786676] Starting subtest: invalid-param-set
[64.807117] Subtest invalid-param-set: SUCCESS (0.000s)
[64.902844] [007/142] (948s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[65.348839] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[65.385977] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[65.487240] [008/142] (948s left) gem_mmap_gtt (cpuset-big-copy-xy)
[65.778477] Starting subtest: cpuset-big-copy-XY
[91.000640] Subtest cpuset-big-copy-XY: SUCCESS (25.252s)
[91.112747] [009/142] (922s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[91.722080] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[93.447212] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.775s)
[93.625594] [010/142] (920s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[93.955206] Starting subtest: multi-wait-all-for-submit-signaled
[93.974560] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.003s)
[94.081917] [011/142] (920s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[94.489318] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[94.528173] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[94.642934] [012/142] (919s left) vc4/vc4_purgeable_bo (mark-unpurgeable-purged)
[95.002680] Subtest mark-unpurgeable-purged: SKIP (0.000s)
[95.084890] [013/142] (919s left) syncobj_timeline (multi-wait-all-available-signaled)
[95.383685] Starting subtest: multi-wait-all-available-signaled
[95.402747] Subtest multi-wait-all-available-signaled: SUCCESS (0.002s)
[95.488140] [014/142] (919s left) kms_psr (psr2_cursor_mmap_cpu)
[95.802969] Subtest psr2_cursor_mmap_cpu: SKIP (0.000s)
[95.890936] [015/142] (918s left) gem_eio (banned)
[96.232923] Starting subtest: banned
[96.360195] Subtest banned: SUCCESS (0.144s)
[96.567211] [016/142] (918s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[96.959388] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[98.252383] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (1.312s)
[98.612729] [017/142] (916s left) kms_ccs (pipe-a-missing-ccs-buffer-y_tiled_gen12_mc_ccs)
[99.115166] Starting subtest: pipe-A-missing-ccs-buffer-y_tiled_gen12_mc_ccs
[99.155442] Subtest pipe-A-missing-ccs-buffer-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[99.746135] [018/142] (915s left) kms_invalid_mode (bad-vsync-end)
[100.132656] Starting subtest: bad-vsync-end
[100.154360] Starting dynamic subtest: DP-1-pipe-A
[100.222620] Dynamic subtest DP-1-pipe-A: SUCCESS (0.094s)
[100.256155] Starting dynamic subtest: DP-1-pipe-B
[100.276969] Dynamic subtest DP-1-pipe-B: SUCCESS (0.014s)
[100.320991] Starting dynamic subtest: DP-1-pipe-C
[100.342509] Dynamic subtest DP-1-pipe-C: SUCCESS (0.015s)
[100.364674] Subtest bad-vsync-end: SUCCESS (0.133s)
[100.613333] [019/142] (914s left) kms_ccs (pipe-a-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc)
[101.123598] Starting subtest: pipe-A-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc
[101.162719] Subtest pipe-A-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[101.714972] [020/142] (913s left) kms_flip (2x-flip-vs-wf_vblank)
[102.085530] Starting subtest: 2x-flip-vs-wf_vblank
[102.129351] Subtest 2x-flip-vs-wf_vblank: SKIP (0.003s)
[102.236549] [021/142] (912s left) kms_universal_plane (cursor-fb-leak-pipe-a)
[102.624323] Starting subtest: cursor-fb-leak-pipe-A
[102.947517] Subtest cursor-fb-leak-pipe-A: SUCCESS (0.323s)
[103.312037] [022/142] (911s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[103.608750] Starting subtest: basic-wc-cpu-noreloc
[103.631739] Subtest basic-wc-cpu-noreloc: SUCCESS (0.011s)
[103.825763] [023/142] (911s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[104.203103] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[104.242486] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.003s)
[104.350381] [024/142] (911s left) kms_cursor_crc (cursor-sliding-512x512)
[104.740486] Starting subtest: cursor-sliding-512x512
[104.780150] Subtest cursor-sliding-512x512: SKIP (0.003s)
[104.889461] [025/142] (910s left) gem_exec_flush (basic-uc-prw-default)
[105.226970] Starting subtest: basic-uc-prw-default
[110.849563] Subtest basic-uc-prw-default: SUCCESS (5.478s)
[110.952654] [026/142] (904s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[111.387624] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[111.426506] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[111.528867] [027/142] (904s left) gem_exec_whisper (basic-queues)
[111.862422] Starting subtest: basic-queues
[119.050894] Subtest basic-queues: SUCCESS (7.146s)
[119.189560] [028/142] (896s left) kms_ccs (pipe-b-bad-aux-stride-4_tiled_mtl_rc_ccs_cc)
[119.826756] Starting subtest: pipe-B-bad-aux-stride-4_tiled_mtl_rc_ccs_cc
[119.866655] Subtest pipe-B-bad-aux-stride-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[120.295552] [029/142] (895s left) kms_content_protection (srm)
[120.699037] Starting subtest: srm
[120.760597] Starting dynamic subtest: pipe-A-DP-1
[241.593892] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[248.435616] Closing watchdogs
[248.446584] Initializing watchdogs
[248.446781]   /dev/watchdog0
[248.501540] [030/142] (767s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[248.887141] Starting subtest: 2x-cursor-vs-flip-atomic
[248.927380] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.005s)
[249.032914] [031/142] (767s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[249.425614] Starting subtest: primary-y-tiled-reflect-x-180
[249.466288] Subtest primary-y-tiled-reflect-x-180: SKIP (0.003s)
[249.568822] [032/142] (766s left) gem_exec_params (secure-non-master)
[249.864992] Starting subtest: secure-non-master
[249.903795] Subtest secure-non-master: SKIP (0.000s)
[250.015107] [033/142] (766s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[250.405207] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[251.948487] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.566s)
[252.136436] [034/142] (764s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[252.486675] Starting subtest: flip-vs-dpms-off-vs-modeset
[252.505554] Starting dynamic subtest: A-DP1
[253.746826] Dynamic subtest A-DP1: SUCCESS (1.261s)
[253.788674] Starting dynamic subtest: B-DP1
[254.852535] Dynamic subtest B-DP1: SUCCESS (1.102s)
[254.902589] Starting dynamic subtest: C-DP1
[255.943730] Dynamic subtest C-DP1: SUCCESS (1.099s)
[255.964048] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (3.469s)
[256.312764] [035/142] (760s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-render)
[256.759388] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-render
[256.796506] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-render: SKIP (0.000s)
[256.905750] [036/142] (759s left) kms_prop_blob (blob-prop-lifetime)
[257.199037] Starting subtest: blob-prop-lifetime
[257.220568] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[257.326298] [037/142] (759s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[257.745456] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[257.786466] Subtest psr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[257.892467] [038/142] (758s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[258.841242] Starting subtest: syncobj-timeline-invalid-flags
[258.862587] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.001s)
[259.093262] [039/142] (757s left) gem_exec_fence (invalid-timeline-fence-array)
[259.914634] Starting subtest: invalid-timeline-fence-array
[259.933532] Subtest invalid-timeline-fence-array: SUCCESS (0.012s)
[260.197281] [040/142] (756s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[260.557998] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[260.577267] Starting dynamic subtest: pipe-A-DP-1
[260.648533] Dynamic subtest pipe-A-DP-1: SUCCESS (0.076s)
[260.693723] Starting dynamic subtest: pipe-B-DP-1
[261.003199] Dynamic subtest pipe-B-DP-1: SUCCESS (0.355s)
[261.042073] Starting dynamic subtest: pipe-C-DP-1
[261.112616] Dynamic subtest pipe-C-DP-1: SKIP (0.084s)
[261.132134] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (0.527s)
[261.521737] [041/142] (755s left) prime_vgem (basic-fence-read)
[261.863128] Starting subtest: basic-fence-read
[261.920801] Subtest basic-fence-read: SUCCESS (0.107s)
[262.056267] [042/142] (755s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[262.474425] Starting subtest: fbcpsr-slowdraw
[262.515111] Subtest fbcpsr-slowdraw: SKIP (0.000s)
[262.627214] [043/142] (754s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[262.981724] Starting subtest: cursor-vs-flip-toggle
[304.779597] Subtest cursor-vs-flip-toggle: SUCCESS (41.793s)
[305.141092] [044/142] (712s left) kms_ccs (pipe-d-ccs-on-another-bo-4_tiled_mtl_rc_ccs)
[305.932449] Subtest pipe-D-ccs-on-another-bo-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[306.263529] [045/142] (711s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[306.626727] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[306.647368] Starting dynamic subtest: pipe-A-valid-mode
[307.354854] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.708s)
[307.374426] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SUCCESS (0.711s)
[307.730392] [046/142] (709s left) kms_ccs (pipe-b-random-ccs-data-4_tiled_dg2_rc_ccs)
[308.329284] Starting subtest: pipe-B-random-ccs-data-4_tiled_dg2_rc_ccs
[308.391272] Subtest pipe-B-random-ccs-data-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[308.861299] [047/142] (708s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[309.285199] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[309.340511] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[309.486186] [048/142] (708s left) kms_vblank (pipe-d-query-forked-hang)
[309.869200] Subtest pipe-D-query-forked-hang: SKIP (0.000s)
[310.061357] [049/142] (707s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[310.499951] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[310.537371] Subtest fbcpsr-rgb101010-draw-pwrite: SKIP (0.000s)
[310.647440] [050/142] (707s left) i915_pm_rps (basic-api)
[310.938731] Starting subtest: basic-api
[310.961121] Subtest basic-api: SUCCESS (0.007s)
[311.074614] [051/142] (707s left) v3d/v3d_submit_csd (bad-flag)
[311.415781] Subtest bad-flag: SKIP (0.000s)
[311.524773] [052/142] (706s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[311.807133] Starting subtest: multi-wait-for-submit-available-signaled
[311.828706] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.002s)
[311.939414] [053/142] (706s left) gem_eio (in-flight-contexts-10ms)
[312.271581] Starting subtest: in-flight-contexts-10ms
[324.244448] Subtest in-flight-contexts-10ms: SUCCESS (12.026s)
[324.466377] [054/142] (694s left) kms_ccs (pipe-a-crc-primary-basic-yf_tiled_ccs)
[324.943373] Starting subtest: pipe-A-crc-primary-basic-yf_tiled_ccs
[325.581055] Subtest pipe-A-crc-primary-basic-yf_tiled_ccs: SUCCESS (0.649s)
[326.366357] [055/142] (692s left) kms_frontbuffer_tracking (fbc-badstride)
[326.809526] Starting subtest: fbc-badstride
[334.755357] Subtest fbc-badstride: SUCCESS (7.935s)
[334.844201] [056/142] (683s left) gem_exec_schedule (lateslice)
[335.302812] Starting subtest: lateslice
[335.321517] Starting dynamic subtest: rcs0
[335.342952] Dynamic subtest rcs0: SUCCESS (0.031s)
[335.380747] Starting dynamic subtest: bcs0
[335.402145] Dynamic subtest bcs0: SUCCESS (0.033s)
[335.439405] Starting dynamic subtest: vcs0
[335.458416] Dynamic subtest vcs0: SUCCESS (0.028s)
[335.493669] Starting dynamic subtest: vecs0
[335.512545] Dynamic subtest vecs0: SUCCESS (0.029s)
[335.531335] Subtest lateslice: SUCCESS (0.132s)
[335.666094] [057/142] (683s left) kms_ccs (pipe-a-bad-pixel-format-4_tiled_mtl_mc_ccs)
[336.022961] Starting subtest: pipe-A-bad-pixel-format-4_tiled_mtl_mc_ccs
[336.061255] Subtest pipe-A-bad-pixel-format-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[336.803106] [058/142] (682s left) kms_draw_crc (draw-method-mmap-cpu)
[337.164437] Starting subtest: draw-method-mmap-cpu
[337.182761] Starting dynamic subtest: xrgb8888-untiled
[337.453680] Dynamic subtest xrgb8888-untiled: SUCCESS (0.288s)
[337.489693] Starting dynamic subtest: rgb565-untiled
[337.721149] Dynamic subtest rgb565-untiled: SUCCESS (0.265s)
[337.756991] Starting dynamic subtest: xrgb2101010-untiled
[338.003176] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.281s)
[338.039417] Starting dynamic subtest: xrgb8888-xtiled
[338.191251] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.181s)
[338.227120] Starting dynamic subtest: rgb565-xtiled
[338.376158] Dynamic subtest rgb565-xtiled: SUCCESS (0.181s)
[338.413161] Starting dynamic subtest: xrgb2101010-xtiled
[338.559045] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.181s)
[338.593973] Starting dynamic subtest: xrgb8888-ytiled
[338.755071] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.198s)
[338.790103] Starting dynamic subtest: rgb565-ytiled
[338.940350] Dynamic subtest rgb565-ytiled: SUCCESS (0.181s)
[338.977720] Starting dynamic subtest: xrgb2101010-ytiled
[339.119772] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.181s)
[339.141403] Subtest draw-method-mmap-cpu: SUCCESS (1.956s)
[339.271966] [059/142] (679s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[339.737751] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[340.041351] [060/142] (679s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[340.461813] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[340.538713] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.029s)
[340.650574] [061/142] (678s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[341.002221] Starting subtest: basic-flip-before-cursor-legacy
[342.085401] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.078s)
[342.450427] [062/142] (676s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[342.865318] Starting subtest: psr-farfromfence-mmap-gtt
[342.908143] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[343.018145] [063/142] (676s left) syncobj_timeline (single-wait-available-submitted)
[343.315693] Starting subtest: single-wait-available-submitted
[343.334419] Subtest single-wait-available-submitted: SUCCESS (0.001s)
[343.441187] [064/142] (676s left) api_intel_bb (object-reloc-keep-cache)
[343.739818] Starting subtest: object-reloc-keep-cache
[343.758583] Subtest object-reloc-keep-cache: SUCCESS (0.012s)
[343.856568] [065/142] (675s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[344.264818] Starting subtest: addfb25-yf-tiled-legacy
[344.290222] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[344.420660] [066/142] (675s left) gen9_exec_parse (batch-zero-length)
[344.718279] Starting subtest: batch-zero-length
[344.738279] Subtest batch-zero-length: SUCCESS (0.002s)
[344.958812] [067/142] (674s left) kms_rotation_crc (bad-pixel-format)
[345.312382] Starting subtest: bad-pixel-format
[347.071925] Subtest bad-pixel-format: SUCCESS (1.758s)
[347.526073] [068/142] (672s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[347.967446] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[348.005917] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[348.119632] [069/142] (671s left) drm_fdinfo (basics)
[348.419148] Starting subtest: basics
[348.439938] Subtest basics: SUCCESS (0.000s)
[348.544999] [070/142] (671s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[348.986737] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[349.023986] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[349.134701] [071/142] (671s left) kms_vblank (pipe-b-ts-continuation-modeset)
[349.489661] Starting subtest: pipe-B-ts-continuation-modeset
[350.467967] Subtest pipe-B-ts-continuation-modeset: SUCCESS (0.979s)
[350.852243] [072/142] (669s left) gem_exec_balancer (parallel)
[355.136158] Subtest parallel: SKIP (0.000s)
[355.225352] [073/142] (665s left) kms_ccs (pipe-d-crc-primary-rotation-180-4_tiled_dg2_rc_ccs)
[356.028935] Subtest pipe-D-crc-primary-rotation-180-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[356.354230] [074/142] (664s left) kms_ccs (pipe-c-crc-primary-basic-4_tiled_mtl_rc_ccs_cc)
[357.054317] Starting subtest: pipe-C-crc-primary-basic-4_tiled_mtl_rc_ccs_cc
[357.092743] Subtest pipe-C-crc-primary-basic-4_tiled_mtl_rc_ccs_cc: SKIP (0.001s)
[357.470068] [075/142] (663s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[357.828366] Starting subtest: short-busy-flip-before-cursor-toggle
[357.869191] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[357.983808] [076/142] (662s left) kms_ccs (pipe-b-crc-primary-rotation-180-4_tiled_mtl_mc_ccs)
[358.560981] Starting subtest: pipe-B-crc-primary-rotation-180-4_tiled_mtl_mc_ccs
[358.604969] Subtest pipe-B-crc-primary-rotation-180-4_tiled_mtl_mc_ccs: SKIP (0.001s)
[359.082341] [077/142] (661s left) kms_flip (flip-vs-rmfb-interruptible)
[359.461619] Starting subtest: flip-vs-rmfb-interruptible
[359.483913] Starting dynamic subtest: A-DP1
[369.940784] Dynamic subtest A-DP1: SUCCESS (10.493s)
[369.981899] Starting dynamic subtest: B-DP1
[380.330437] Dynamic subtest B-DP1: SUCCESS (10.393s)
[380.366720] Starting dynamic subtest: C-DP1
[390.776835] Dynamic subtest C-DP1: SUCCESS (10.422s)
[390.802930] Subtest flip-vs-rmfb-interruptible: SUCCESS (31.324s)
[391.200819] [078/142] (629s left) kms_psr (cursor_plane_move)
[391.543857] Subtest cursor_plane_move: SKIP (0.000s)
[391.687624] [079/142] (629s left) gem_exec_params (invalid-fence-in-submit)
[391.995298] Starting subtest: invalid-fence-in-submit
[392.020381] Subtest invalid-fence-in-submit: SUCCESS (0.005s)
[392.148915] [080/142] (629s left) kms_lease (multimaster-lease)
[392.521125] Starting subtest: multimaster-lease
[392.542694] Subtest multimaster-lease: SUCCESS (0.006s)
[392.664088] [081/142] (628s left) kms_plane_scaling (plane-downscale-with-rotation-factor-0-75)
[393.021326] Starting subtest: plane-downscale-with-rotation-factor-0-75
[393.040538] Starting dynamic subtest: pipe-A-DP-1
[393.159932] Dynamic subtest pipe-A-DP-1: SKIP (0.097s)
[393.218699] Starting dynamic subtest: pipe-B-DP-1
[393.550098] Dynamic subtest pipe-B-DP-1: SKIP (0.381s)
[393.609268] Starting dynamic subtest: pipe-C-DP-1
[393.914055] Dynamic subtest pipe-C-DP-1: SKIP (0.383s)
[393.961439] Subtest plane-downscale-with-rotation-factor-0-75: SKIP (0.879s)
[394.341426] [082/142] (627s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[394.780448] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[394.817703] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[394.933703] [083/142] (626s left) prime_vgem (basic-blt)
[395.241109] Starting subtest: basic-blt
[395.261798] Subtest basic-blt: SUCCESS (0.053s)
[395.422913] [084/142] (626s left) v3d/v3d_job_submission (multiple-singlesync-to-multisync)
[395.779172] Subtest multiple-singlesync-to-multisync: SKIP (0.000s)
[395.891468] [085/142] (625s left) syncobj_timeline (etime-single-wait-submitted)
[396.183283] Starting subtest: etime-single-wait-submitted
[396.235795] Subtest etime-single-wait-submitted: SUCCESS (0.104s)
[396.375943] [086/142] (625s left) kms_ccs (pipe-c-bad-pixel-format-y_tiled_ccs)
[397.049981] Starting subtest: pipe-C-bad-pixel-format-y_tiled_ccs
[397.092586] Subtest pipe-C-bad-pixel-format-y_tiled_ccs: SKIP (0.000s)
[397.494366] [087/142] (624s left) i915_pm_dc (dc6-psr)
[398.889259] Starting subtest: dc6-psr
[398.933125] Subtest dc6-psr: SKIP (0.000s)
[399.090221] [088/142] (623s left) vc4/vc4_perfmon (create-perfmon-exceed)
[399.426744] Subtest create-perfmon-exceed: SKIP (0.000s)
[399.540517] [089/142] (622s left) kms_flip (2x-dpms-vs-vblank-race)
[399.892387] Starting subtest: 2x-dpms-vs-vblank-race
[399.930241] Subtest 2x-dpms-vs-vblank-race: SKIP (0.003s)
[400.045932] [090/142] (622s left) vgem_basic (bad-fence)
[400.341995] Starting subtest: bad-fence
[400.363944] Subtest bad-fence: SUCCESS (0.000s)
[400.474253] [091/142] (621s left) gem_ctx_persistence (engines-cleanup)
[400.771510] Starting subtest: engines-cleanup
[400.791425] Starting dynamic subtest: rcs0
[400.810500] Dynamic subtest rcs0: SUCCESS (0.036s)
[400.847888] Starting dynamic subtest: bcs0
[400.866799] Dynamic subtest bcs0: SUCCESS (0.034s)
[400.904452] Starting dynamic subtest: vcs0
[400.925964] Dynamic subtest vcs0: SUCCESS (0.035s)
[400.964743] Starting dynamic subtest: vecs0
[400.985283] Dynamic subtest vecs0: SUCCESS (0.033s)
[401.005597] Subtest engines-cleanup: SUCCESS (0.150s)
[401.113102] [092/142] (621s left) kms_flip (flip-vs-panning-interruptible)
[401.491068] Starting subtest: flip-vs-panning-interruptible
[401.511737] Starting dynamic subtest: A-DP1
[412.026746] Dynamic subtest A-DP1: SUCCESS (10.541s)
[412.067215] Starting dynamic subtest: B-DP1
[422.510254] Dynamic subtest B-DP1: SUCCESS (10.486s)
[422.551061] Starting dynamic subtest: C-DP1
[433.034204] Dynamic subtest C-DP1: SUCCESS (10.509s)
[433.052652] Subtest flip-vs-panning-interruptible: SUCCESS (31.551s)
[433.481753] [093/142] (589s left) gem_pxp (reject-modify-context-protection-off-2)
[436.453337] Subtest reject-modify-context-protection-off-2: SKIP (0.000s)
[436.623426] [094/142] (586s left) gem_exec_params (invalid-ring2)
[436.915383] Starting subtest: invalid-ring2
[436.934523] Subtest invalid-ring2: SUCCESS (0.001s)
[437.051252] [095/142] (585s left) gem_exec_nop (basic-parallel)
[437.505638] Starting subtest: basic-parallel
[440.518351] Subtest basic-parallel: SUCCESS (3.161s)
[440.767535] [096/142] (582s left) gem_basic (create-fd-close)
[441.058131] Starting subtest: create-fd-close
[441.098191] Subtest create-fd-close: SUCCESS (0.000s)
[441.205971] [097/142] (581s left) gem_exec_schedule (timeslicing)
[441.650199] Starting subtest: timeslicing
[441.668879] Starting dynamic subtest: rcs0
[441.690234] Dynamic subtest rcs0: SUCCESS (0.009s)
[441.728895] Starting dynamic subtest: bcs0
[441.749552] Dynamic subtest bcs0: SUCCESS (0.009s)
[441.788347] Starting dynamic subtest: vcs0
[441.807289] Dynamic subtest vcs0: SUCCESS (0.006s)
[441.844523] Starting dynamic subtest: vecs0
[441.863322] Dynamic subtest vecs0: SUCCESS (0.006s)
[441.881923] Subtest timeslicing: SUCCESS (0.039s)
[441.996341] [098/142] (581s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[442.405325] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[442.448636] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[442.560569] [099/142] (580s left) perf_pmu (faulting-read)
[442.856383] Starting subtest: faulting-read
[442.875073] Starting dynamic subtest: gtt
[442.893790] Dynamic subtest gtt: SUCCESS (0.005s)
[442.929755] Starting dynamic subtest: wb
[442.948325] Dynamic subtest wb: SUCCESS (0.002s)
[442.987204] Starting dynamic subtest: wc
[443.008829] Dynamic subtest wc: SUCCESS (0.001s)
[443.046559] Starting dynamic subtest: uc
[443.067155] Dynamic subtest uc: SUCCESS (0.001s)
[443.091205] Subtest faulting-read: SUCCESS (0.017s)
[443.220445] [100/142] (580s left) kms_color (deep-color)
[443.579639] Starting subtest: deep-color
[443.619270] Subtest deep-color: SKIP (0.000s)
[443.733518] [101/142] (579s left) kms_atomic (plane-invalid-params-fence)
[444.200524] Starting subtest: plane-invalid-params-fence
[444.242258] Subtest plane-invalid-params-fence: SUCCESS (0.032s)
[444.706443] [102/142] (578s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[445.084565] Starting subtest: yf-tiled-16bpp-rotate-270
[445.169445] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.070s)
[445.285565] [103/142] (578s left) kms_writeback (writeback-fb-id)
[445.738558] Subtest writeback-fb-id: SKIP (0.000s)
[445.849475] [104/142] (577s left) kms_plane (pixel-format-source-clamping)
[446.209048] Starting subtest: pixel-format-source-clamping
[446.230125] Starting dynamic subtest: pipe-A-planes
[452.595091] Dynamic subtest pipe-A-planes: SUCCESS (6.377s)
[452.631514] Starting dynamic subtest: pipe-B-planes
[459.116376] Dynamic subtest pipe-B-planes: SUCCESS (6.492s)
[459.138947] Subtest pixel-format-source-clamping: SUCCESS (12.880s)
[459.485930] [105/142] (564s left) gem_bad_reloc (negative-reloc-lut)
[459.811105] Starting subtest: negative-reloc-lut
[459.882234] Subtest negative-reloc-lut: SUCCESS (0.002s)
[460.019693] [106/142] (564s left) kms_vblank (pipe-b-wait-forked-hang)
[460.394157] Starting subtest: pipe-B-wait-forked-hang
[468.190830] Subtest pipe-B-wait-forked-hang: SUCCESS (7.650s)
[468.472384] [107/142] (555s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[468.940182] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[468.989663] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[469.122126] [108/142] (555s left) kms_universal_plane (cursor-fb-leak-pipe-c)
[469.474452] Starting subtest: cursor-fb-leak-pipe-C
[470.319981] Subtest cursor-fb-leak-pipe-C: SUCCESS (0.833s)
[470.682274] [109/142] (553s left) kms_ccs (pipe-b-bad-rotation-90-y_tiled_gen12_rc_ccs)
[471.235098] Starting subtest: pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs
[471.283475] Subtest pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[471.814101] [110/142] (552s left) gem_ctx_shared (exec-shared-gtt)
[472.116646] Starting subtest: exec-shared-gtt
[472.135622] Starting dynamic subtest: rcs0
[472.154394] Dynamic subtest rcs0: SUCCESS (0.010s)
[472.190489] Starting dynamic subtest: bcs0
[472.210407] Dynamic subtest bcs0: SUCCESS (0.012s)
[472.249257] Starting dynamic subtest: vcs0
[472.270732] Dynamic subtest vcs0: SUCCESS (0.008s)
[472.310583] Starting dynamic subtest: vecs0
[472.330381] Dynamic subtest vecs0: SUCCESS (0.008s)
[472.349150] Subtest exec-shared-gtt: SUCCESS (0.050s)
[472.458271] [111/142] (552s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[472.748112] Starting subtest: yf-tiled-ccs-to-y-tiled
[472.768381] Starting dynamic subtest: smem
[473.065828] Dynamic subtest smem: SUCCESS (0.322s)
[473.091771] Subtest yf-tiled-ccs-to-y-tiled: SUCCESS (0.325s)
[473.307253] [112/142] (551s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-blt)
[473.744203] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-blt
[473.785389] Subtest fbcpsr-1p-offscren-pri-indfb-draw-blt: SKIP (0.000s)
[473.898564] [113/142] (550s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[474.310748] Starting subtest: psr-rgb565-draw-mmap-cpu
[474.353375] Subtest psr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[474.465104] [114/142] (550s left) i915_pm_rpm (legacy-planes)
[476.403833] Starting subtest: legacy-planes
[476.424621] Starting dynamic subtest: plane-39
[479.242153] Dynamic subtest plane-39: SUCCESS (2.834s)
[479.286317] Starting dynamic subtest: plane-47
[482.064719] Dynamic subtest plane-47: SUCCESS (2.820s)
[482.087065] Subtest legacy-planes: SUCCESS (5.660s)
[482.587077] [115/142] (542s left) gem_create (busy-create)
[482.910779] Starting subtest: busy-create
[482.932942] Starting dynamic subtest: smem0
[515.163508] Dynamic subtest smem0: SUCCESS (32.259s)
[515.182185] Subtest busy-create: SUCCESS (32.262s)
[515.393220] [116/142] (509s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[515.811294] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[515.848744] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[515.968246] [117/142] (509s left) gem_mmap_offset (close-race)
[516.261226] Starting subtest: close-race
[536.510668] Subtest close-race: SUCCESS (20.110s)
[536.603578] [118/142] (488s left) kms_atomic_transition (plane-all-transition-fencing)
[536.968453] Starting subtest: plane-all-transition-fencing
[536.990376] Starting dynamic subtest: pipe-A-DP-1
[540.901773] Dynamic subtest pipe-A-DP-1: SUCCESS (3.939s)
[541.043080] Starting dynamic subtest: pipe-B-DP-1
[545.443961] Dynamic subtest pipe-B-DP-1: SUCCESS (4.435s)
[545.559940] Subtest plane-all-transition-fencing: SUCCESS (8.580s)
[545.915600] [119/142] (479s left) gem_userptr_blits (process-exit)
[546.294254] Starting subtest: process-exit
[546.312939] Subtest process-exit: SUCCESS (0.037s)
[546.454920] [120/142] (479s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[546.782646] Starting subtest: basic-batch-kernel-default-cmd
[552.416609] Subtest basic-batch-kernel-default-cmd: SUCCESS (5.686s)
[552.670841] [121/142] (473s left) prime_self_import (basic-with_one_bo_two_files)
[552.939744] Starting subtest: basic-with_one_bo_two_files
[552.977853] Subtest basic-with_one_bo_two_files: SUCCESS (0.005s)
[553.116952] [122/142] (472s left) kms_ccs (pipe-d-bad-pixel-format-y_tiled_ccs)
[553.909423] Subtest pipe-D-bad-pixel-format-y_tiled_ccs: SKIP (0.000s)
[554.255961] [123/142] (471s left) gem_exec_balancer (bonded-chain)
[554.563329] Starting subtest: bonded-chain
[558.374290] Subtest bonded-chain: SUCCESS (3.643s)
[562.281268] [124/142] (463s left) core_setmaster (master-drop-set-root)
[564.316716] Starting subtest: master-drop-set-root
[564.354529] Subtest master-drop-set-root: SUCCESS (0.011s)
[564.469908] [125/142] (461s left) v3d/v3d_submit_cl (bad-pad)
[564.824439] Subtest bad-pad: SKIP (0.000s)
[564.933121] [126/142] (461s left) gem_ctx_isolation (dirty-create)
[565.231882] Starting subtest: dirty-create
[565.250948] Starting dynamic subtest: rcs0
[566.873995] Dynamic subtest rcs0: SUCCESS (1.648s)
[566.916136] Starting dynamic subtest: bcs0
[568.991768] Dynamic subtest bcs0: SUCCESS (2.107s)
[569.030060] Starting dynamic subtest: vcs0
[570.565158] Dynamic subtest vcs0: SUCCESS (1.577s)
[570.604747] Starting dynamic subtest: vecs0
[572.179354] Dynamic subtest vecs0: SUCCESS (1.611s)
[572.200708] Subtest dirty-create: SUCCESS (6.954s)
[572.434236] [127/142] (454s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[572.714310] Starting subtest: invalid-bsd1-flag-on-vebox
[572.735632] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.001s)
[572.849060] [128/142] (453s left) gen7_exec_parse (batch-without-end)
[573.150493] Subtest batch-without-end: SKIP (0.000s)
[573.258735] [129/142] (453s left) gem_exec_reloc (basic-cpu-read)
[573.547586] Starting subtest: basic-cpu-read
[573.566496] Subtest basic-cpu-read: SUCCESS (0.020s)
[573.786921] [130/142] (453s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[574.184502] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[576.176323] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (2.055s)
[576.368921] [131/142] (450s left) gem_pipe_control_store_loop (fresh-buffer)
[576.661662] Starting subtest: fresh-buffer
[578.966421] Subtest fresh-buffer: SUCCESS (2.155s)
[579.054818] [132/142] (447s left) syncobj_wait (invalid-reset-illegal-handle)
[579.338607] Starting subtest: invalid-reset-illegal-handle
[579.357356] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[579.451143] [133/142] (447s left) kms_ccs (pipe-c-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs)
[580.216896] Starting subtest: pipe-C-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs
[580.255673] Subtest pipe-C-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs: SKIP (0.004s)
[580.584151] [134/142] (446s left) gem_mmap_gtt (big-bo)
[580.878653] Starting subtest: big-bo
[582.524583] Subtest big-bo: SUCCESS (1.682s)
[582.807274] [135/142] (444s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[583.361689] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[583.380566] Starting dynamic subtest: pipe-A-valid-mode
[584.081247] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.723s)
[584.103472] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SUCCESS (0.728s)
[584.454960] [136/142] (442s left) gem_lmem_swapping (smem-oom)
[584.810520] Subtest smem-oom: SKIP (0.000s)
[584.923467] [137/142] (442s left) kms_sequence (queue-idle)
[585.293602] Starting subtest: queue-idle
[585.312670] Starting dynamic subtest: DP-1-pipe-A
[587.592784] Dynamic subtest DP-1-pipe-A: SUCCESS (2.283s)
[587.647103] Starting dynamic subtest: DP-1-pipe-B
[590.131931] Dynamic subtest DP-1-pipe-B: SUCCESS (2.561s)
[590.179403] Starting dynamic subtest: DP-1-pipe-C
[592.812730] Dynamic subtest DP-1-pipe-C: SUCCESS (2.676s)
[592.832698] Subtest queue-idle: SUCCESS (7.536s)
[593.171475] [138/142] (434s left) kms_chamelium_color (ctm-negative)
[593.551740] Subtest ctm-negative: SKIP (0.000s)
[593.668170] [139/142] (434s left) gem_spin_batch (resubmit-new-all)
[593.960195] Starting subtest: resubmit-new-all
[593.981688] Starting dynamic subtest: rcs0
[594.002921] Dynamic subtest rcs0: SUCCESS (0.013s)
[594.041215] Starting dynamic subtest: bcs0
[594.059813] Dynamic subtest bcs0: SUCCESS (0.012s)
[594.096126] Starting dynamic subtest: vcs0
[594.114688] Dynamic subtest vcs0: SUCCESS (0.012s)
[594.152473] Starting dynamic subtest: vecs0
[594.173757] Dynamic subtest vecs0: SUCCESS (0.012s)
[594.195417] Subtest resubmit-new-all: SUCCESS (0.061s)
[594.305402] [140/142] (433s left) gem_softpin (allocator-nopin)
[594.599837] Starting subtest: allocator-nopin
[594.814772] Subtest allocator-nopin: SUCCESS (0.242s)
[594.981597] [141/142] (432s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[595.274826] Starting subtest: etime-single-wait-all-for-submit-submitted
[595.355851] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.107s)
[595.477221] [142/142] (432s left) gem_mmap_wc (read-write)
[595.772715] Starting subtest: read-write
[595.791702] Subtest read-write: SUCCESS (0.032s)
[595.891243] Closing watchdogs
Done.