[51.798449] Initializing watchdogs
[51.798689]   /dev/watchdog0
[51.814983] [001/141] (960s left) kms_vblank (pipe-b-wait-forked-busy)
[52.160046] Starting subtest: pipe-B-wait-forked-busy
[55.066174] Subtest pipe-B-wait-forked-busy: SUCCESS (2.912s)
[55.401264] [002/141] (956s left) gem_exec_whisper (basic-contexts-all)
[55.644776] Starting subtest: basic-contexts-all
[69.248905] Subtest basic-contexts-all: SUCCESS (13.602s)
[69.454265] [003/141] (942s left) kms_chamelium_color (gamma)
[69.766993] Subtest gamma: SKIP (0.000s)
[69.817504] [004/141] (942s left) i915_pm_rpm (reg-read-ioctl)
[71.884097] Starting subtest: reg-read-ioctl
[72.522128] Subtest reg-read-ioctl: SUCCESS (0.637s)
[72.996052] [005/141] (939s left) syncobj_wait (single-wait-all-submitted)
[73.209279] Starting subtest: single-wait-all-submitted
[73.316287] Subtest single-wait-all-submitted: SUCCESS (0.108s)
[73.394393] [006/141] (939s left) syncobj_wait (invalid-wait-illegal-handle)
[73.596289] Starting subtest: invalid-wait-illegal-handle
[73.598538] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[73.677353] [007/141] (938s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[73.989618] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[73.993556] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[74.094103] [008/141] (938s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[74.408147] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[74.412071] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[74.511471] [009/141] (938s left) gem_exec_nop (basic-sequential)
[74.765442] Starting subtest: basic-sequential
[77.874923] Subtest basic-sequential: SUCCESS (3.107s)
[78.092565] [010/141] (934s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[78.406076] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[78.409947] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[78.494026] [011/141] (934s left) kms_ccs (pipe-c-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc)
[79.175097] Starting subtest: pipe-C-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc
[79.179341] Subtest pipe-C-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[79.515267] [012/141] (933s left) drm_fdinfo (most-busy-check-all)
[79.724916] Starting subtest: most-busy-check-all
[79.727871] Starting dynamic subtest: rcs0
[80.247446] Dynamic subtest rcs0: SUCCESS (0.522s)
[80.268042] Starting dynamic subtest: bcs0
[80.766617] Dynamic subtest bcs0: SUCCESS (0.519s)
[80.786542] Starting dynamic subtest: vcs0
[81.290463] Dynamic subtest vcs0: SUCCESS (0.524s)
[81.306939] Starting dynamic subtest: vecs0
[81.814425] Dynamic subtest vecs0: SUCCESS (0.524s)
[81.816614] Subtest most-busy-check-all: SUCCESS (2.090s)
[81.897788] [013/141] (930s left) i915_pciid
[82.180620] [014/141] (930s left) vc4/vc4_purgeable_bo (mark-unpurgeable-check-retained)
[82.446613] Subtest mark-unpurgeable-check-retained: SKIP (0.000s)
[82.514813] [015/141] (930s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[82.831164] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[85.060626] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (2.235s)
[85.181370] [016/141] (927s left) syncobj_timeline (reset-signaled)
[85.388550] Starting subtest: reset-signaled
[85.390692] Subtest reset-signaled: SUCCESS (0.001s)
[85.467450] [017/141] (927s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[85.790191] Starting subtest: 4-tiled-16bpp-rotate-90
[85.794426] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.000s)
[85.898821] [018/141] (927s left) kms_getfb (getfb2-handle-zero)
[86.101187] Starting subtest: getfb2-handle-zero
[86.103455] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[86.199656] [019/141] (926s left) perf (buffer-fill)
[86.540158] Starting subtest: buffer-fill
[86.542801] Starting dynamic subtest: 0-rcs0
[89.428201] Dynamic subtest 0-rcs0: SUCCESS (2.887s)
[89.430453] Subtest buffer-fill: SUCCESS (2.888s)
[89.480223] [020/141] (923s left) gem_readwrite (read-write)
[89.681641] Starting subtest: read-write
[89.689845] Subtest read-write: SUCCESS (0.000s)
[89.782843] [021/141] (923s left) gem_exec_reloc (basic-scanout)
[90.099494] Starting subtest: basic-scanout
[90.101618] Starting dynamic subtest: rcs0
[90.343956] Dynamic subtest rcs0: SUCCESS (0.247s)
[90.362790] Starting dynamic subtest: bcs0
[90.510217] Dynamic subtest bcs0: SUCCESS (0.166s)
[90.529117] Starting dynamic subtest: vcs0
[90.677235] Dynamic subtest vcs0: SUCCESS (0.167s)
[90.695939] Starting dynamic subtest: vecs0
[90.869352] Dynamic subtest vecs0: SUCCESS (0.167s)
[90.871301] Subtest basic-scanout: SUCCESS (0.748s)
[90.968265] [022/141] (922s left) kms_busy (extended-modeset-hang-newfb)
[91.298723] Starting subtest: extended-modeset-hang-newfb
[91.303241] Starting dynamic subtest: pipe-A
[94.429484] Dynamic subtest pipe-A: SUCCESS (3.125s)
[94.453185] Starting dynamic subtest: pipe-C
[97.711637] Dynamic subtest pipe-C: SUCCESS (3.275s)
[97.714134] Subtest extended-modeset-hang-newfb: SUCCESS (6.414s)
[98.048775] [023/141] (915s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[98.380906] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[98.385479] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[98.479571] [024/141] (914s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[98.788904] Starting subtest: psr-rgb101010-draw-render
[98.792932] Subtest psr-rgb101010-draw-render: SKIP (0.000s)
[98.879874] [025/141] (914s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[99.188995] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[99.192912] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[99.279641] [026/141] (913s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs)
[99.871298] Starting subtest: pipe-B-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs
[99.878393] Subtest pipe-B-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs: SKIP (0.005s)
[100.382779] [027/141] (912s left) gen9_exec_parse (bb-start-out)
[100.694121] Starting subtest: bb-start-out
[100.717161] Subtest bb-start-out: SUCCESS (0.004s)
[100.949434] [028/141] (912s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[101.305047] Starting subtest: fbc-indfb-scaledprimary
[104.456637] Subtest fbc-indfb-scaledprimary: SUCCESS (3.156s)
[104.592459] [029/141] (908s left) kms_atomic_interruptible (legacy-setmode)
[104.896838] Starting subtest: legacy-setmode
[104.899848] Starting dynamic subtest: DP-1-pipe-A
[111.414608] Dynamic subtest DP-1-pipe-A: SUCCESS (6.515s)
[111.416730] Subtest legacy-setmode: SUCCESS (6.519s)
[111.742286] [030/141] (901s left) gem_tiled_swapping (non-threaded)
[118.710591] Starting subtest: non-threaded
[146.952748] Subtest non-threaded: SUCCESS (28.204s)
[149.363830] [031/141] (864s left) kms_ccs (pipe-a-crc-primary-basic-y_tiled_gen12_rc_ccs_cc)
[150.071886] Starting subtest: pipe-A-crc-primary-basic-y_tiled_gen12_rc_ccs_cc
[150.120821] Subtest pipe-A-crc-primary-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.001s)
[150.662931] [032/141] (862s left) kms_chamelium_frames (dp-frame-dump)
[151.068397] Subtest dp-frame-dump: SKIP (0.000s)
[151.345485] [033/141] (862s left) gem_mmap_gtt (basic-read-write-distinct)
[151.551713] Starting subtest: basic-read-write-distinct
[151.585294] Subtest basic-read-write-distinct: SUCCESS (0.034s)
[151.705215] [034/141] (862s left) v3d/v3d_submit_cl (bad-flag)
[151.964426] Subtest bad-flag: SKIP (0.000s)
[152.039124] [035/141] (861s left) kms_ccs (pipe-d-bad-aux-stride-y_tiled_ccs)
[152.750098] Subtest pipe-D-bad-aux-stride-y_tiled_ccs: SKIP (0.000s)
[153.055256] [036/141] (860s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[153.360776] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[153.363822] Starting dynamic subtest: pipe-A-valid-mode
[153.443526] Dynamic subtest pipe-A-valid-mode: SKIP (0.082s)
[153.448774] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.085s)
[153.755451] [037/141] (860s left) gem_mmap_wc (coherency)
[153.980444] Starting subtest: coherency
[154.132790] Subtest coherency: SUCCESS (0.153s)
[154.255304] [038/141] (859s left) gem_eio (in-flight-external)
[154.490607] Starting subtest: in-flight-external
[154.572324] Subtest in-flight-external: SUCCESS (0.082s)
[154.755140] [039/141] (859s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[155.040828] Starting subtest: 2x-flip-vs-modeset-vs-hang
[155.044748] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.003s)
[155.156577] [040/141] (858s left) kms_cursor_crc (cursor-sliding-256x85)
[155.474746] Starting subtest: cursor-sliding-256x85
[155.485825] Starting dynamic subtest: pipe-A-DP-1
[159.330483] Dynamic subtest pipe-A-DP-1: SUCCESS (3.843s)
[159.411554] Starting dynamic subtest: pipe-C-DP-1
[163.388366] Dynamic subtest pipe-C-DP-1: SUCCESS (3.997s)
[163.390331] Subtest cursor-sliding-256x85: SUCCESS (7.914s)
[163.737684] [041/141] (850s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[164.045498] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[164.053576] Starting dynamic subtest: pipe-A-valid-mode
[164.720934] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.668s)
[164.723267] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (0.674s)
[165.054165] [042/141] (849s left) kms_cursor_edge_walk (256x256-top-edge)
[165.357199] Starting subtest: 256x256-top-edge
[165.360531] Starting dynamic subtest: pipe-A-DP-1
[168.978975] Dynamic subtest pipe-A-DP-1: SUCCESS (3.620s)
[169.006186] Starting dynamic subtest: pipe-C-DP-1
[172.443788] Dynamic subtest pipe-C-DP-1: SUCCESS (3.461s)
[172.445976] Subtest 256x256-top-edge: SUCCESS (7.091s)
[172.748745] [043/141] (841s left) kms_plane_multiple (tiling-yf)
[173.051475] Starting subtest: tiling-yf
[173.053724] Starting dynamic subtest: pipe-A-DP-1
[174.920398] Dynamic subtest pipe-A-DP-1: SUCCESS (1.870s)
[174.944788] Starting dynamic subtest: pipe-B-DP-1
[176.950242] Dynamic subtest pipe-B-DP-1: SUCCESS (2.024s)
[176.976679] Starting dynamic subtest: pipe-C-DP-1
[178.939193] Dynamic subtest pipe-C-DP-1: SUCCESS (1.982s)
[178.941333] Subtest tiling-yf: SUCCESS (5.887s)
[179.290487] [044/141] (834s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[179.619782] Starting subtest: x-tiled-64bpp-rotate-180
[187.826971] Subtest x-tiled-64bpp-rotate-180: SUCCESS (8.207s)
[188.824800] [045/141] (825s left) kms_cursor_crc (cursor-random-512x170)
[189.155364] Starting subtest: cursor-random-512x170
[189.163267] Subtest cursor-random-512x170: SKIP (0.003s)
[189.326062] [046/141] (824s left) gem_ringfill (legacy-basic)
[189.967153] Starting subtest: legacy-basic
[189.969268] Starting dynamic subtest: default
[190.124238] Dynamic subtest default: SUCCESS (0.157s)
[190.152467] Starting dynamic subtest: render
[190.185224] Dynamic subtest render: SUCCESS (0.060s)
[190.208921] Starting dynamic subtest: bsd
[190.239067] Dynamic subtest bsd: SUCCESS (0.052s)
[190.265716] Starting dynamic subtest: bsd1
[190.287922] Dynamic subtest bsd1: SUCCESS (0.048s)
[190.312454] Starting dynamic subtest: blt
[190.335264] Dynamic subtest blt: SUCCESS (0.046s)
[190.361439] Starting dynamic subtest: vebox
[190.408506] Dynamic subtest vebox: SUCCESS (0.071s)
[190.410716] Subtest legacy-basic: SUCCESS (0.443s)
[190.503329] [047/141] (823s left) v3d/v3d_job_submission (multiple-singlesync-to-multisync)
[190.762853] Subtest multiple-singlesync-to-multisync: SKIP (0.000s)
[190.836465] [048/141] (823s left) kms_atomic_interruptible (legacy-dpms)
[191.137415] Starting subtest: legacy-dpms
[191.139439] Starting dynamic subtest: DP-1-pipe-A
[197.687921] Dynamic subtest DP-1-pipe-A: SUCCESS (6.547s)
[197.690077] Subtest legacy-dpms: SUCCESS (6.551s)
[198.018728] [049/141] (816s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt)
[198.330250] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt
[198.334089] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[198.434208] [050/141] (816s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[198.748899] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[198.753096] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[198.850523] [051/141] (815s left) gem_create (busy-create)
[199.066907] Starting subtest: busy-create
[199.069100] Starting dynamic subtest: smem0
[231.331421] Dynamic subtest smem0: SUCCESS (32.263s)
[231.333555] Subtest busy-create: SUCCESS (32.264s)
[231.534770] [052/141] (782s left) prime_self_import (basic-llseek-bad)
[231.734541] Starting subtest: basic-llseek-bad
[231.738720] Subtest basic-llseek-bad: SUCCESS (0.004s)
[231.848743] [053/141] (782s left) fbdev (write)
[232.074982] Starting subtest: write
[232.810230] Subtest write: SUCCESS (0.737s)
[232.885568] [054/141] (781s left) sw_sync (sync_busy_fork)
[233.085464] Starting subtest: sync_busy_fork
[234.123141] Subtest sync_busy_fork: SUCCESS (1.037s)
[234.199655] [055/141] (780s left) kms_properties (get_properties-sanity-atomic)
[234.502849] Starting subtest: get_properties-sanity-atomic
[234.504919] Subtest get_properties-sanity-atomic: SUCCESS (0.005s)
[234.601434] [056/141] (780s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[235.408425] Starting subtest: syncobj-timeline-invalid-wait
[235.414788] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s)
[235.651142] [057/141] (779s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[236.059147] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[236.348418] [058/141] (778s left) gen7_exec_parse (basic-offset)
[236.560494] Subtest basic-offset: SKIP (0.000s)
[236.626339] [059/141] (778s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[236.949553] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[236.954087] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[237.060235] [060/141] (777s left) perf (gen12-unprivileged-single-ctx-counters)
[237.391543] Subtest gen12-unprivileged-single-ctx-counters: SKIP (0.000s)
[237.441816] [061/141] (777s left) gem_exec_fence (basic-await)
[237.798757] Starting subtest: basic-await
[237.801312] Starting dynamic subtest: rcs0
[237.924858] Dynamic subtest rcs0: SUCCESS (0.125s)
[237.950446] Starting dynamic subtest: bcs0
[238.052398] Dynamic subtest bcs0: SUCCESS (0.125s)
[238.075760] Starting dynamic subtest: vcs0
[238.180874] Dynamic subtest vcs0: SUCCESS (0.127s)
[238.204474] Starting dynamic subtest: vecs0
[238.309901] Dynamic subtest vecs0: SUCCESS (0.128s)
[238.312193] Subtest basic-await: SUCCESS (0.512s)
[238.977812] [062/141] (776s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[239.284742] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[239.288740] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.003s)
[239.376826] [063/141] (775s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_dg2_rc_ccs)
[240.087973] Subtest pipe-D-crc-primary-basic-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[240.403784] [064/141] (774s left) kms_big_fb (linear-8bpp-rotate-270)
[240.727258] Starting subtest: linear-8bpp-rotate-270
[240.812358] Subtest linear-8bpp-rotate-270: SKIP (0.082s)
[240.921877] [065/141] (774s left) perf (invalid-create-userspace-config)
[241.230283] Starting subtest: invalid-create-userspace-config
[241.232853] Subtest invalid-create-userspace-config: SUCCESS (0.006s)
[241.286784] [066/141] (773s left) kms_sequence (queue-busy)
[241.590372] Starting subtest: queue-busy
[241.592555] Starting dynamic subtest: DP-1-pipe-A
[244.091292] Dynamic subtest DP-1-pipe-A: SUCCESS (2.499s)
[244.118098] Starting dynamic subtest: DP-1-pipe-B
[246.905153] Dynamic subtest DP-1-pipe-B: SUCCESS (2.808s)
[246.928740] Starting dynamic subtest: DP-1-pipe-C
[249.812343] Dynamic subtest DP-1-pipe-C: SUCCESS (2.903s)
[249.814455] Subtest queue-busy: SUCCESS (8.223s)
[250.115804] [067/141] (765s left) kms_flip (flip-vs-suspend)
[250.413205] Starting subtest: flip-vs-suspend
[250.415353] Starting dynamic subtest: A-DP1
[303.100524] Dynamic subtest A-DP1: SUCCESS (5.158s)
[303.133458] Starting dynamic subtest: B-DP1
[356.116578] Dynamic subtest B-DP1: SUCCESS (4.891s)
[356.144590] Starting dynamic subtest: C-DP1
[408.108722] Dynamic subtest C-DP1: SUCCESS (4.842s)
[408.110991] Subtest flip-vs-suspend: SUCCESS (14.900s)
[412.587949] [068/141] (749s left) kms_vblank (pipe-d-ts-continuation-suspend)
[412.903341] Subtest pipe-D-ts-continuation-suspend: SKIP (0.000s)
[412.993576] [069/141] (749s left) kms_lease (lease_again)
[413.306682] Starting subtest: lease_again
[413.309302] Starting dynamic subtest: pipe-A-DP-1
[413.319128] Dynamic subtest pipe-A-DP-1: SUCCESS (0.004s)
[413.350934] Starting dynamic subtest: pipe-B-DP-1
[413.352937] Dynamic subtest pipe-B-DP-1: SUCCESS (0.003s)
[413.380882] Starting dynamic subtest: pipe-C-DP-1
[413.382811] Dynamic subtest pipe-C-DP-1: SUCCESS (0.003s)
[413.384753] Subtest lease_again: SUCCESS (0.020s)
[413.441259] [070/141] (748s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[413.754280] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[413.758192] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[413.875253] [071/141] (748s left) kms_content_protection (legacy)
[414.211645] Starting subtest: legacy
[414.413908] Starting dynamic subtest: pipe-A-DP-1
[534.873655] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[535.934063] Closing watchdogs
[535.946084] Initializing watchdogs
[535.946328]   /dev/watchdog0
[535.978542] [072/141] (626s left) gem_exec_async (concurrent-writes)
[536.210589] Starting subtest: concurrent-writes
[536.212791] Starting dynamic subtest: rcs0
[536.231631] Dynamic subtest rcs0: SUCCESS (0.020s)
[536.263990] Starting dynamic subtest: bcs0
[536.266327] Dynamic subtest bcs0: SUCCESS (0.014s)
[536.295426] Starting dynamic subtest: vcs0
[536.297460] Dynamic subtest vcs0: SUCCESS (0.015s)
[536.324033] Starting dynamic subtest: vecs0
[536.326068] Dynamic subtest vecs0: SUCCESS (0.014s)
[536.328056] Subtest concurrent-writes: SUCCESS (0.068s)
[536.509554] [073/141] (625s left) gem_ctx_persistence (file)
[536.720562] Starting subtest: file
[536.794450] Subtest file: SUCCESS (0.074s)
[536.908733] [074/141] (625s left) gem_ctx_persistence (saturated-hostile)
[537.120272] Starting subtest: saturated-hostile
[537.122525] Starting dynamic subtest: rcs0
[537.238478] Dynamic subtest rcs0: SUCCESS (0.117s)
[537.268818] Starting dynamic subtest: bcs0
[537.353123] Dynamic subtest bcs0: SUCCESS (0.113s)
[537.383779] Starting dynamic subtest: vcs0
[537.468126] Dynamic subtest vcs0: SUCCESS (0.114s)
[537.496229] Starting dynamic subtest: vecs0
[537.584167] Dynamic subtest vecs0: SUCCESS (0.115s)
[537.586190] Subtest saturated-hostile: SUCCESS (0.465s)
[537.710535] [075/141] (624s left) kms_flip (plain-flip-fb-recreate)
[537.996887] Starting subtest: plain-flip-fb-recreate
[538.006098] Starting dynamic subtest: A-DP1
[565.367071] Dynamic subtest A-DP1: SUCCESS (27.366s)
[565.445517] Starting dynamic subtest: B-DP1
[592.476786] Dynamic subtest B-DP1: SUCCESS (27.108s)
[592.504563] Starting dynamic subtest: C-DP1
[619.616201] Dynamic subtest C-DP1: SUCCESS (27.137s)
[619.618266] Subtest plain-flip-fb-recreate: SUCCESS (81.621s)
[636.369266] [076/141] (526s left) prime_vgem (busy)
[636.607540] Starting subtest: busy
[636.609796] Starting dynamic subtest: rcs0
[636.640240] Dynamic subtest rcs0: SUCCESS (0.032s)
[636.668027] Starting dynamic subtest: vcs0
[636.670148] Dynamic subtest vcs0: SUCCESS (0.017s)
[636.700021] Starting dynamic subtest: vecs0
[636.702259] Dynamic subtest vecs0: SUCCESS (0.024s)
[636.704281] Subtest busy: SUCCESS (0.077s)
[636.783849] [077/141] (525s left) i915_pm_dc (dc9-dpms)
[638.100327] Starting subtest: dc9-dpms
[673.764052] Subtest dc9-dpms: SUCCESS (35.664s)
[673.939904] [078/141] (488s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[674.256909] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[676.455099] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (2.204s)
[676.605982] [079/141] (486s left) syncobj_wait (invalid-signal-illegal-handle)
[676.814938] Starting subtest: invalid-signal-illegal-handle
[676.817111] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[676.904666] [080/141] (485s left) kms_prop_blob (blob-prop-lifetime)
[677.110336] Starting subtest: blob-prop-lifetime
[677.112741] Subtest blob-prop-lifetime: SUCCESS (0.002s)
[677.204223] [081/141] (485s left) kms_ccs (pipe-c-bad-pixel-format-y_tiled_ccs)
[677.814490] Starting subtest: pipe-C-bad-pixel-format-y_tiled_ccs
[677.820796] Subtest pipe-C-bad-pixel-format-y_tiled_ccs: SKIP (0.000s)
[678.274299] [082/141] (484s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[678.575655] Starting subtest: primary-yf-tiled-reflect-x-180
[678.579710] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.003s)
[678.685273] [083/141] (484s left) gem_mmap (pf-nonblock)
[678.890086] Starting subtest: pf-nonblock
[678.892774] Subtest pf-nonblock: SUCCESS (0.005s)
[679.007341] [084/141] (483s left) perf_pmu (enable-race)
[679.220962] Starting subtest: enable-race
[679.223643] Starting dynamic subtest: rcs0
[691.891597] Dynamic subtest rcs0: SUCCESS (12.670s)
[691.918588] Starting dynamic subtest: bcs0
[704.602666] Dynamic subtest bcs0: SUCCESS (12.709s)
[704.629850] Starting dynamic subtest: vcs0
[717.266305] Dynamic subtest vcs0: SUCCESS (12.662s)
[717.293202] Starting dynamic subtest: vecs0
[729.944226] Dynamic subtest vecs0: SUCCESS (12.676s)
[729.946505] Subtest enable-race: SUCCESS (50.724s)
[730.039305] [085/141] (432s left) syncobj_timeline (wait-all-interrupted)
[730.247502] Starting subtest: wait-all-interrupted
[730.357525] Subtest wait-all-interrupted: SUCCESS (0.109s)
[730.456336] [086/141] (432s left) gem_exec_balancer (parallel-out-fence)
[734.452518] Subtest parallel-out-fence: SKIP (0.000s)
[734.556667] [087/141] (428s left) syncobj_timeline (device-submit-unordered)
[734.761245] Starting subtest: device-submit-unordered
[734.763497] Subtest device-submit-unordered: SUCCESS (0.001s)
[734.855878] [088/141] (428s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[735.177979] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[735.181916] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[735.295156] [089/141] (427s left) gem_exec_schedule (pi-distinct-iova)
[735.666086] Starting subtest: pi-distinct-iova
[735.668206] Starting dynamic subtest: rcs0
[735.748133] Dynamic subtest rcs0: SUCCESS (0.077s)
[735.780983] Starting dynamic subtest: bcs0
[735.827975] Dynamic subtest bcs0: SUCCESS (0.081s)
[735.860304] Starting dynamic subtest: vcs0
[735.883355] Dynamic subtest vcs0: SUCCESS (0.055s)
[735.914504] Starting dynamic subtest: vecs0
[735.938803] Dynamic subtest vecs0: SUCCESS (0.056s)
[735.940842] Subtest pi-distinct-iova: SUCCESS (0.274s)
[736.175648] [090/141] (427s left) kms_ccs (pipe-b-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc)
[736.728285] Starting subtest: pipe-B-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc
[736.732462] Subtest pipe-B-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[737.201860] [091/141] (426s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[737.514395] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[737.518294] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[737.634775] [092/141] (425s left) gem_readwrite (new-obj)
[737.840492] Starting subtest: new-obj
[737.844417] Subtest new-obj: SUCCESS (0.001s)
[737.951225] [093/141] (425s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-gtt)
[738.264281] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-gtt
[740.084779] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-gtt: SUCCESS (1.828s)
[740.233940] [094/141] (423s left) syncobj_wait (wait-for-submit-snapshot)
[740.440198] Starting subtest: wait-for-submit-snapshot
[740.523698] Subtest wait-for-submit-snapshot: SUCCESS (0.083s)
[740.616737] [095/141] (422s left) kms_psr (primary_render)
[740.827477] Subtest primary_render: SKIP (0.000s)
[740.882740] [096/141] (422s left) i915_query (query-topology-garbage-items)
[741.084893] Starting subtest: query-topology-garbage-items
[741.087188] Subtest query-topology-garbage-items: SUCCESS (0.001s)
[741.184448] [097/141] (422s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[741.501399] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[741.538068] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.032s)
[741.668426] [098/141] (422s left) kms_ccs (pipe-c-missing-ccs-buffer-y_tiled_ccs)
[742.340212] Starting subtest: pipe-C-missing-ccs-buffer-y_tiled_ccs
[742.344493] Subtest pipe-C-missing-ccs-buffer-y_tiled_ccs: SKIP (0.000s)
[742.716530] [099/141] (421s left) vc4/vc4_dmabuf_poll (poll-read-waits-until-write-done)
[742.983318] Subtest poll-read-waits-until-write-done: SKIP (0.000s)
[743.066301] [100/141] (420s left) api_intel_allocator (standalone)
[743.270810] Starting subtest: standalone
[743.325295] Subtest standalone: SUCCESS (0.056s)
[743.433862] [101/141] (420s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[743.733388] Starting subtest: cursorB-vs-flipB-varying-size
[743.737304] Subtest cursorB-vs-flipB-varying-size: SKIP (0.003s)
[743.833206] [102/141] (420s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[744.036775] Starting subtest: multi-wait-all-for-submit-signaled
[744.039133] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[744.132864] [103/141] (419s left) syncobj_timeline (multi-wait-available-submitted)
[744.340549] Starting subtest: multi-wait-available-submitted
[744.342986] Subtest multi-wait-available-submitted: SUCCESS (0.002s)
[744.433242] [104/141] (419s left) kms_ccs (pipe-b-missing-ccs-buffer-y_tiled_gen12_mc_ccs)
[744.987472] Starting subtest: pipe-B-missing-ccs-buffer-y_tiled_gen12_mc_ccs
[744.992131] Subtest pipe-B-missing-ccs-buffer-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[745.469254] [105/141] (418s left) core_auth (getclient-master-drop)
[745.671916] Starting subtest: getclient-master-drop
[745.677560] Subtest getclient-master-drop: SUCCESS (0.005s)
[745.767930] [106/141] (418s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[745.990934] Starting subtest: yf-tiled-ccs-to-y-tiled
[745.993178] Starting dynamic subtest: smem
[746.312751] Dynamic subtest smem: SUCCESS (0.319s)
[746.314857] Subtest yf-tiled-ccs-to-y-tiled: SUCCESS (0.321s)
[746.520684] [107/141] (417s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[746.841357] Starting subtest: yf-tiled-32bpp-rotate-90
[751.733803] Subtest yf-tiled-32bpp-rotate-90: SUCCESS (4.891s)
[752.318307] [108/141] (411s left) kms_atomic (atomic_plane_damage)
[752.747947] Starting subtest: atomic_plane_damage
[752.752191] Subtest atomic_plane_damage: SKIP (0.000s)
[753.196860] [109/141] (411s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[753.514922] Starting subtest: fbcpsr-rgb101010-draw-render
[753.518877] Subtest fbcpsr-rgb101010-draw-render: SKIP (0.000s)
[753.611583] [110/141] (410s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_dg2_rc_ccs)
[754.024058] Starting subtest: pipe-A-crc-primary-basic-4_tiled_dg2_rc_ccs
[754.028360] Subtest pipe-A-crc-primary-basic-4_tiled_dg2_rc_ccs: SKIP (0.001s)
[754.657239] [111/141] (409s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-cpu)
[754.978611] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-cpu
[754.982529] Subtest psr-1p-offscren-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[755.090737] [112/141] (409s left) kms_addfb_basic (bad-pitch-65536)
[755.295277] Starting subtest: bad-pitch-65536
[755.297391] Subtest bad-pitch-65536: SUCCESS (0.001s)
[755.508336] [113/141] (408s left) gem_ctx_param (non-root-set)
[755.726581] Starting subtest: non-root-set
[755.761291] Subtest non-root-set: SUCCESS (0.035s)
[755.857769] [114/141] (408s left) kms_plane_scaling (planes-downscale-factor-0-25-upscale-20x20)
[756.156234] Starting subtest: planes-downscale-factor-0-25-upscale-20x20
[756.166475] Starting dynamic subtest: pipe-A-DP-1
[756.192989] Dynamic subtest pipe-A-DP-1: SKIP (0.028s)
[756.237502] Starting dynamic subtest: pipe-B-DP-1
[756.272283] Dynamic subtest pipe-B-DP-1: SKIP (0.076s)
[756.321573] Starting dynamic subtest: pipe-C-DP-1
[756.354614] Dynamic subtest pipe-C-DP-1: SKIP (0.076s)
[756.358716] Subtest planes-downscale-factor-0-25-upscale-20x20: SKIP (0.195s)
[756.458973] [115/141] (408s left) kms_flip (2x-busy-flip)
[756.751316] Starting subtest: 2x-busy-flip
[756.755497] Subtest 2x-busy-flip: SKIP (0.004s)
[756.874448] [116/141] (407s left) gem_exec_reloc (basic-range)
[757.089095] Starting subtest: basic-range
[757.171632] Subtest basic-range: SUCCESS (0.081s)
[757.356943] [117/141] (407s left) kms_ccs (pipe-d-crc-primary-rotation-180-y_tiled_gen12_rc_ccs)
[758.100807] Subtest pipe-D-crc-primary-rotation-180-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[758.420354] [118/141] (406s left) gem_workarounds (suspend-resume)
[758.659146] Starting subtest: suspend-resume
[776.083060] Subtest suspend-resume: SUCCESS (1.413s)
[781.583691] [119/141] (404s left) syncobj_timeline (invalid-multi-wait-all-available-unsubmitted)
[781.792727] Starting subtest: invalid-multi-wait-all-available-unsubmitted
[781.795280] Subtest invalid-multi-wait-all-available-unsubmitted: SUCCESS (0.001s)
[781.892980] [120/141] (404s left) kms_force_connector_basic (force-edid)
[782.103954] Subtest force-edid: SKIP (0.000s)
[782.173041] [121/141] (404s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[782.470581] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[782.473903] Starting dynamic subtest: pipe-A-DP-1
[782.784200] Dynamic subtest pipe-A-DP-1: SUCCESS (0.315s)
[782.831083] Starting dynamic subtest: pipe-B-DP-1
[783.173485] Dynamic subtest pipe-B-DP-1: SUCCESS (0.385s)
[783.220869] Starting dynamic subtest: pipe-C-DP-1
[783.570916] Dynamic subtest pipe-C-DP-1: SUCCESS (0.391s)
[783.573104] Subtest planes-unity-scaling-downscale-factor-0-5: SUCCESS (1.106s)
[783.973898] [122/141] (402s left) gem_lmem_swapping (random)
[784.186055] Subtest random: SKIP (0.000s)
[784.256040] [123/141] (402s left) kms_lease (simple_lease)
[784.556895] Starting subtest: simple_lease
[784.559356] Starting dynamic subtest: pipe-A-DP-1
[785.054659] Dynamic subtest pipe-A-DP-1: SUCCESS (0.497s)
[785.091171] Starting dynamic subtest: pipe-B-DP-1
[785.656295] Dynamic subtest pipe-B-DP-1: SUCCESS (0.597s)
[785.691084] Starting dynamic subtest: pipe-C-DP-1
[786.261488] Dynamic subtest pipe-C-DP-1: SUCCESS (0.599s)
[786.264281] Subtest simple_lease: SUCCESS (1.706s)
[786.584378] [124/141] (399s left) syncobj_wait (wait-all-delayed-signal)
[786.790686] Starting subtest: wait-all-delayed-signal
[786.892541] Subtest wait-all-delayed-signal: SUCCESS (0.104s)
[786.999826] [125/141] (399s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[787.308143] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[787.312520] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[787.415736] [126/141] (399s left) v3d/v3d_submit_csd (bad-multisync-pad)
[787.682484] Subtest bad-multisync-pad: SKIP (0.000s)
[787.766388] [127/141] (398s left) gem_exec_reloc (basic-cpu-noreloc)
[787.980117] Starting subtest: basic-cpu-noreloc
[787.992285] Subtest basic-cpu-noreloc: SUCCESS (0.012s)
[788.182887] [128/141] (398s left) gem_mmap_gtt (fault-concurrent-x)
[788.385981] Starting subtest: fault-concurrent-X
[791.715983] Subtest fault-concurrent-X: SUCCESS (3.331s)
[791.998746] [129/141] (394s left) kms_psr (psr2_sprite_render)
[792.203635] Subtest psr2_sprite_render: SKIP (0.000s)
[792.264569] [130/141] (394s left) gem_exec_schedule (smoketest-all)
[792.495141] Starting subtest: smoketest-all
[824.829977] Subtest smoketest-all: SUCCESS (32.326s)
[825.182662] [131/141] (361s left) kms_ccs (pipe-a-random-ccs-data-yf_tiled_ccs)
[825.619583] Starting subtest: pipe-A-random-ccs-data-yf_tiled_ccs
[826.060570] Subtest pipe-A-random-ccs-data-yf_tiled_ccs: SUCCESS (0.440s)
[826.738310] [132/141] (360s left) gem_exec_suspend (basic-s4-devices)
[826.968331] Starting subtest: basic-S4-devices
[826.970498] Starting dynamic subtest: smem
[838.339763] Dynamic subtest smem: SUCCESS (11.374s)
[838.341739] Subtest basic-S4-devices: SUCCESS (11.375s)
[841.341895] [133/141] (348s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[841.647803] Starting subtest: basic-busy-flip-before-cursor-atomic
[841.651804] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[841.841608] [134/141] (347s left) gem_spin_batch (legacy-resubmit)
[842.151056] Starting subtest: legacy-resubmit
[842.174152] Starting dynamic subtest: default
[842.197243] Dynamic subtest default: SUCCESS (0.005s)
[842.235902] Starting dynamic subtest: render
[842.259766] Dynamic subtest render: SUCCESS (0.005s)
[842.299362] Starting dynamic subtest: bsd
[842.322749] Dynamic subtest bsd: SUCCESS (0.005s)
[842.363092] Starting dynamic subtest: bsd1
[842.386057] Dynamic subtest bsd1: SUCCESS (0.004s)
[842.424401] Starting dynamic subtest: blt
[842.447529] Dynamic subtest blt: SUCCESS (0.007s)
[842.485888] Starting dynamic subtest: vebox
[842.509472] Dynamic subtest vebox: SUCCESS (0.005s)
[842.532258] Subtest legacy-resubmit: SUCCESS (0.042s)
[842.630559] [135/141] (347s left) gem_ctx_exec (basic-nohangcheck)
[842.981415] Starting subtest: basic-nohangcheck
[843.193489] Subtest basic-nohangcheck: SUCCESS (0.317s)
[843.294265] [136/141] (346s left) kms_cdclk (mode-transition-all-outputs)
[843.502011] Subtest mode-transition-all-outputs: SKIP (0.000s)
[843.565158] [137/141] (346s left) kms_ccs (pipe-b-bad-pixel-format-4_tiled_dg2_mc_ccs)
[844.070166] Starting subtest: pipe-B-bad-pixel-format-4_tiled_dg2_mc_ccs
[844.074025] Subtest pipe-B-bad-pixel-format-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[844.621858] [138/141] (345s left) gem_exec_schedule (thriceslice)
[844.853057] Starting subtest: thriceslice
[844.855571] Starting dynamic subtest: rcs0
[844.865638] Dynamic subtest rcs0: SUCCESS (0.011s)
[844.904719] Starting dynamic subtest: bcs0
[844.906849] Dynamic subtest bcs0: SUCCESS (0.013s)
[844.935542] Starting dynamic subtest: vcs0
[844.937545] Dynamic subtest vcs0: SUCCESS (0.011s)
[844.965566] Starting dynamic subtest: vecs0
[844.967564] Dynamic subtest vecs0: SUCCESS (0.010s)
[844.969475] Subtest thriceslice: SUCCESS (0.051s)
[845.255385] [139/141] (344s left) kms_vblank (pipe-c-wait-forked-busy-hang)
[845.562786] Starting subtest: pipe-C-wait-forked-busy-hang
[852.802119] Subtest pipe-C-wait-forked-busy-hang: SUCCESS (7.241s)
[853.149298] [140/141] (337s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[855.880754] Subtest verify-pxp-execution-after-suspend-resume: SKIP (0.000s)
[855.979127] [141/141] (334s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[856.298906] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[856.303100] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[856.392212] Closing watchdogs
Done.