[58.396987] Initializing watchdogs
[58.397625]   /dev/watchdog0
[58.432467] [001/142] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[58.983517] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[58.990513] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[59.161416] [002/142] (959s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[59.677044] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[59.683575] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[59.832158] [003/142] (959s left) kms_ccs (pipe-a-bad-pixel-format-4_tiled_dg2_mc_ccs)
[60.319139] Starting subtest: pipe-A-bad-pixel-format-4_tiled_dg2_mc_ccs
[60.325539] Subtest pipe-A-bad-pixel-format-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[62.178184] [004/142] (956s left) kms_ccs (pipe-c-bad-pixel-format-y_tiled_ccs)
[63.534382] Starting subtest: pipe-C-bad-pixel-format-y_tiled_ccs
[63.540808] Subtest pipe-C-bad-pixel-format-y_tiled_ccs: SKIP (0.000s)
[64.558825] [005/142] (954s left) gem_exec_balancer (smoke)
[65.002867] Starting subtest: smoke
[92.811914] Subtest smoke: SUCCESS (27.805s)
[94.699994] [006/142] (924s left) kms_plane (plane-position-covered)
[95.200930] Starting subtest: plane-position-covered
[95.207817] Starting dynamic subtest: pipe-A-planes
[103.139259] Dynamic subtest pipe-A-planes: SUCCESS (7.933s)
[103.174367] Starting dynamic subtest: pipe-B-planes
[110.964265] Dynamic subtest pipe-B-planes: SUCCESS (7.816s)
[110.967436] Subtest plane-position-covered: SUCCESS (15.765s)
[111.810797] [007/142] (907s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[112.305823] Starting subtest: fbcpsr-slowdraw
[150.122746] Subtest fbcpsr-slowdraw: SUCCESS (37.815s)
[150.371111] [008/142] (869s left) prime_vgem (fence-flip-hang)
[150.908128] Subtest fence-flip-hang: SKIP (0.000s)
[151.066479] [009/142] (868s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[151.551938] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[151.560540] Starting dynamic subtest: pipe-A-default-mode
[151.963366] Dynamic subtest pipe-A-default-mode: SKIP (0.396s)
[151.970223] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.408s)
[152.890638] [010/142] (866s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[153.398966] Starting subtest: psr-2p-primscrn-spr-indfb-move
[153.405741] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[153.540041] [011/142] (866s left) gem_exec_fence (syncobj-import)
[155.435789] Starting subtest: syncobj-import
[155.456582] Subtest syncobj-import: SUCCESS (0.020s)
[155.870935] [012/142] (863s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[156.366210] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[170.379544] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (14.017s)
[170.669752] [013/142] (849s left) gem_softpin (evict-snoop-interruptible)
[171.078320] Starting subtest: evict-snoop-interruptible
[171.085957] Subtest evict-snoop-interruptible: SKIP (0.000s)
[171.215536] [014/142] (848s left) kms_flip (plain-flip-fb-recreate-interruptible)
[171.631912] Starting subtest: plain-flip-fb-recreate-interruptible
[171.664217] Starting dynamic subtest: A-eDP1
[181.379049] Dynamic subtest A-eDP1: SUCCESS (9.715s)
[181.413893] Starting dynamic subtest: B-eDP1
[190.653198] Dynamic subtest B-eDP1: SUCCESS (9.270s)
[190.686430] Starting dynamic subtest: C-eDP1
[199.617122] Dynamic subtest C-eDP1: SUCCESS (8.961s)
[199.645651] Starting dynamic subtest: D-eDP1
[208.845970] Dynamic subtest D-eDP1: SUCCESS (9.224s)
[208.871615] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (37.240s)
[210.356500] [015/142] (809s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[210.867676] Starting subtest: fbc-tiling-linear
[218.614883] Subtest fbc-tiling-linear: SUCCESS (7.748s)
[218.871472] [016/142] (801s left) feature_discovery (display-2x)
[219.385338] Starting subtest: display-2x
[219.392333] Subtest display-2x: SKIP (0.000s)
[219.525459] [017/142] (800s left) vc4/vc4_dmabuf_poll (poll-write-waits-until-write-done)
[220.001871] Subtest poll-write-waits-until-write-done: SKIP (0.000s)
[220.131281] [018/142] (800s left) kms_plane_lowres (tiling-4)
[220.605864] Starting subtest: tiling-4
[220.614438] Starting dynamic subtest: pipe-A-eDP-1
[220.620846] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[221.048949] Starting dynamic subtest: pipe-B-eDP-1
[221.055317] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[221.090937] Starting dynamic subtest: pipe-C-eDP-1
[221.098193] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[221.133949] Starting dynamic subtest: pipe-D-eDP-1
[221.141355] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[221.148694] Subtest tiling-4: SKIP (0.502s)
[221.952198] [019/142] (798s left) kms_ccs (pipe-c-crc-primary-basic-y_tiled_gen12_rc_ccs)
[223.336101] Starting subtest: pipe-C-crc-primary-basic-y_tiled_gen12_rc_ccs
[223.342310] Subtest pipe-C-crc-primary-basic-y_tiled_gen12_rc_ccs: SKIP (0.002s)
[224.310972] [020/142] (796s left) gem_exec_flush (basic-wb-ro-default)
[224.741890] Starting subtest: basic-wb-ro-default
[230.649119] Subtest basic-wb-ro-default: SUCCESS (5.907s)
[230.954977] [021/142] (789s left) gem_ctx_persistence (heartbeat-hang)
[231.369196] Starting subtest: heartbeat-hang
[231.376274] Subtest heartbeat-hang: SKIP (0.001s)
[231.563725] [022/142] (788s left) kms_flip (nonexisting-fb)
[231.972454] Starting subtest: nonexisting-fb
[231.997664] Starting dynamic subtest: A-eDP1
[233.746951] Dynamic subtest A-eDP1: SUCCESS (1.749s)
[233.783933] Starting dynamic subtest: B-eDP1
[235.343970] Dynamic subtest B-eDP1: SUCCESS (1.593s)
[235.377973] Starting dynamic subtest: C-eDP1
[236.942359] Dynamic subtest C-eDP1: SUCCESS (1.593s)
[236.978380] Starting dynamic subtest: D-eDP1
[238.531182] Dynamic subtest D-eDP1: SUCCESS (1.584s)
[238.552075] Subtest nonexisting-fb: SUCCESS (6.586s)
[240.121469] [023/142] (780s left) kms_cursor_crc (cursor-random-128x42)
[241.073146] Starting subtest: cursor-random-128x42
[241.108630] Starting dynamic subtest: pipe-A-eDP-1
[247.302530] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.192s)
[247.474654] Starting dynamic subtest: pipe-D-eDP-1
[254.620367] Dynamic subtest pipe-D-eDP-1: SUCCESS (7.176s)
[254.624284] Subtest cursor-random-128x42: SUCCESS (13.546s)
[255.638769] [024/142] (765s left) vc4/vc4_purgeable_bo (mark-unpurgeable-twice)
[256.118458] Subtest mark-unpurgeable-twice: SKIP (0.000s)
[256.242127] [025/142] (764s left) v3d/v3d_submit_csd (bad-extension)
[256.718792] Subtest bad-extension: SKIP (0.000s)
[256.846643] [026/142] (763s left) kms_invalid_mode (bad-vtotal)
[257.334907] Starting subtest: bad-vtotal
[257.338540] Starting dynamic subtest: eDP-1-pipe-A
[257.747696] Dynamic subtest eDP-1-pipe-A: SUCCESS (0.406s)
[257.792863] Starting dynamic subtest: eDP-1-pipe-B
[257.796572] Dynamic subtest eDP-1-pipe-B: SUCCESS (0.040s)
[257.841257] Starting dynamic subtest: eDP-1-pipe-C
[257.844905] Dynamic subtest eDP-1-pipe-C: SUCCESS (0.040s)
[257.888564] Starting dynamic subtest: eDP-1-pipe-D
[257.892339] Dynamic subtest eDP-1-pipe-D: SUCCESS (0.040s)
[257.895756] Subtest bad-vtotal: SUCCESS (0.563s)
[258.664451] [027/142] (762s left) i915_pm_rpm (debugfs-read)
[264.774747] Starting subtest: debugfs-read
[386.091550] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[388.098903] Closing watchdogs
[388.114092] Initializing watchdogs
[388.114426]   /dev/watchdog0
[388.160833] [028/142] (632s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[388.672564] Starting subtest: psr-rgb101010-draw-pwrite
[407.798815] Subtest psr-rgb101010-draw-pwrite: SUCCESS (19.133s)
[408.057130] [029/142] (613s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y_tiled_ccs)
[409.351154] Starting subtest: pipe-B-crc-sprite-planes-basic-y_tiled_ccs
[409.362756] Subtest pipe-B-crc-sprite-planes-basic-y_tiled_ccs: SKIP (0.013s)
[410.397799] [030/142] (610s left) prime_mmap (test_errors)
[410.770782] Starting subtest: test_errors
[410.774534] Starting dynamic subtest: test_errors-smem
[412.359472] Dynamic subtest test_errors-smem: SUCCESS (1.591s)
[412.363041] Subtest test_errors: SUCCESS (1.595s)
[412.521691] [031/142] (608s left) gem_exec_capture (capture-recoverable)
[412.914625] Starting subtest: capture-recoverable
[412.930494] Subtest capture-recoverable: SUCCESS (0.014s)
[413.098132] [032/142] (608s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[413.675944] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[434.397605] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (20.719s)
[435.308624] [033/142] (586s left) drm_fdinfo (all-busy-check-all)
[435.708452] Starting subtest: all-busy-check-all
[435.722176] Subtest all-busy-check-all: SKIP (0.017s)
[435.856360] [034/142] (585s left) kms_vblank (pipe-a-ts-continuation-suspend)
[436.355785] Starting subtest: pipe-A-ts-continuation-suspend
[453.908467] Subtest pipe-A-ts-continuation-suspend: SUCCESS (17.554s)
[454.863191] [035/142] (566s left) gem_exec_schedule (smoketest)
[455.487938] Starting subtest: smoketest
[455.492089] Starting dynamic subtest: rcs0
[461.442980] Dynamic subtest rcs0: SUCCESS (5.883s)
[461.478551] Starting dynamic subtest: bcs0
[467.518683] Dynamic subtest bcs0: SUCCESS (6.069s)
[467.550869] Starting dynamic subtest: vcs0
[473.430141] Dynamic subtest vcs0: SUCCESS (5.907s)
[473.464655] Starting dynamic subtest: vcs1
[479.418826] Dynamic subtest vcs1: SUCCESS (5.977s)
[479.444204] Starting dynamic subtest: vecs0
[485.311278] Dynamic subtest vecs0: SUCCESS (5.893s)
[485.347334] Starting dynamic subtest: ccs0
[491.352716] Dynamic subtest ccs0: SUCCESS (6.041s)
[491.355756] Subtest smoketest: SUCCESS (35.801s)
[491.681105] [036/142] (529s left) kms_prime (basic-modeset-hybrid)
[495.592485] Subtest basic-modeset-hybrid: SKIP (0.000s)
[495.769378] [037/142] (525s left) api_intel_bb (object-noreloc-purge-cache-simple)
[496.160357] Starting subtest: object-noreloc-purge-cache-simple
[496.176492] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.020s)
[496.372679] [038/142] (525s left) gem_exec_suspend (basic-s3)
[496.800694] Starting subtest: basic-S3
[496.804226] Starting dynamic subtest: smem
[524.476181] Dynamic subtest smem: SUCCESS (27.671s)
[524.479892] Subtest basic-S3: SUCCESS (27.676s)
[524.760412] [039/142] (497s left) gem_create (hog-create)
[525.156532] Starting subtest: hog-create
[525.160697] Starting dynamic subtest: smem0
[558.534986] Dynamic subtest smem0: SUCCESS (33.375s)
[558.538523] Subtest hog-create: SUCCESS (33.380s)
[558.820388] [040/142] (463s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[559.646287] Starting subtest: cursor-rapid-movement-64x21
[559.677659] Starting dynamic subtest: pipe-A-eDP-1
[560.937943] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.258s)
[561.099174] Starting dynamic subtest: pipe-D-eDP-1
[563.680069] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.610s)
[563.683542] Subtest cursor-rapid-movement-64x21: SUCCESS (4.031s)
[564.849580] [041/142] (457s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[565.240882] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[565.358210] [042/142] (456s left) kms_ccs (pipe-d-bad-rotation-90-4_tiled_mtl_rc_ccs_cc)
[566.977416] Starting subtest: pipe-D-bad-rotation-90-4_tiled_mtl_rc_ccs_cc
[567.446816] Subtest pipe-D-bad-rotation-90-4_tiled_mtl_rc_ccs_cc: SUCCESS (0.466s)
[568.775486] [043/142] (453s left) gem_exec_schedule (preempt-queue-chain)
[569.219439] Subtest preempt-queue-chain: SKIP (0.000s)
[569.646687] [044/142] (452s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[570.155300] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[581.369892] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (11.216s)
[581.654582] [045/142] (440s left) gem_ctx_create (basic)
[582.084335] Starting subtest: basic
[582.087836] Subtest basic: SUCCESS (0.000s)
[582.365333] [046/142] (440s left) gem_eio (wait-1us)
[584.065994] Starting subtest: wait-1us
[586.724952] Subtest wait-1us: SUCCESS (2.665s)
[588.700119] [047/142] (433s left) kms_plane_scaling (planes-downscale-factor-0-25)
[589.187844] Starting subtest: planes-downscale-factor-0-25
[589.196779] Starting dynamic subtest: pipe-A-eDP-1
[589.286755] Dynamic subtest pipe-A-eDP-1: SKIP (0.090s)
[589.340240] Starting dynamic subtest: pipe-B-eDP-1
[589.481877] Dynamic subtest pipe-B-eDP-1: SKIP (0.183s)
[589.537105] Starting dynamic subtest: pipe-C-eDP-1
[589.675809] Dynamic subtest pipe-C-eDP-1: SKIP (0.184s)
[589.728548] Starting dynamic subtest: pipe-D-eDP-1
[589.871245] Dynamic subtest pipe-D-eDP-1: SKIP (0.184s)
[589.877425] Subtest planes-downscale-factor-0-25: SKIP (0.685s)
[590.053419] [048/142] (432s left) i915_query (query-regions-garbage-items)
[590.426462] Starting subtest: query-regions-garbage-items
[590.430281] Subtest query-regions-garbage-items: SUCCESS (0.003s)
[590.587464] [049/142] (432s left) gem_exec_reloc (basic-scanout)
[590.986845] Subtest basic-scanout: SKIP (0.000s)
[591.135415] [050/142] (431s left) kms_psr2_sf (plane-move-sf-dmg-area)
[598.485365] Starting subtest: plane-move-sf-dmg-area
[598.494100] Starting dynamic subtest: pipe-A-eDP-1
[604.291332] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.800s)
[604.342829] Starting dynamic subtest: pipe-B-eDP-1
[610.095368] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.790s)
[610.098792] Subtest plane-move-sf-dmg-area: SUCCESS (11.610s)
[611.057783] [051/142] (411s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[611.586642] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[611.593197] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[611.755592] [052/142] (411s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[617.862415] Starting subtest: gem-execbuf-stress-pc8
[617.962810] Subtest gem-execbuf-stress-pc8: SKIP (0.097s)
[619.165894] [053/142] (403s left) gem_ctx_param (invalid-param-get)
[619.547337] Starting subtest: invalid-param-get
[619.550927] Subtest invalid-param-get: SUCCESS (0.001s)
[619.702137] [054/142] (403s left) syncobj_timeline (wait-for-submit-complex)
[620.079754] Starting subtest: wait-for-submit-complex
[620.144501] Subtest wait-for-submit-complex: SUCCESS (0.065s)
[620.298718] [055/142] (403s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-pwrite)
[620.827657] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-pwrite
[637.826316] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-pwrite: SUCCESS (17.007s)
[638.112127] [056/142] (385s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[638.702807] Starting subtest: modeset-atomic-cursor-hotspot
[638.709733] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[639.022697] [057/142] (384s left) gem_mmap_gtt (hang-busy)
[639.389818] Subtest hang-busy: SKIP (0.000s)
[639.513075] [058/142] (384s left) gem_mmap_gtt (coherency)
[639.892749] Subtest coherency: SKIP (0.000s)
[640.018902] [059/142] (383s left) kms_chamelium_edid (hdmi-edid-stress-resolution-4k)
[640.899915] Subtest hdmi-edid-stress-resolution-4k: SKIP (0.000s)
[641.780278] [060/142] (382s left) syncobj_wait (multi-wait-signaled)
[642.163855] Starting subtest: multi-wait-signaled
[642.168062] Subtest multi-wait-signaled: SUCCESS (0.002s)
[642.316130] [061/142] (381s left) gen9_exec_parse (bb-start-param)
[642.710486] Subtest bb-start-param: SKIP (0.000s)
[642.829627] [062/142] (381s left) kms_draw_crc (fill-fb)
[643.320549] Starting subtest: fill-fb
[644.576862] Subtest fill-fb: SUCCESS (1.256s)
[644.762659] [063/142] (379s left) kms_addfb_basic (bad-pitch-999)
[645.143039] Starting subtest: bad-pitch-999
[645.146120] Subtest bad-pitch-999: SUCCESS (0.000s)
[645.423643] [064/142] (378s left) syncobj_timeline (invalid-query-one-illegal-handle)
[645.801599] Starting subtest: invalid-query-one-illegal-handle
[645.805286] Subtest invalid-query-one-illegal-handle: SUCCESS (0.002s)
[645.953502] [065/142] (378s left) syncobj_timeline (invalid-wait-zero-handles)
[646.333949] Starting subtest: invalid-wait-zero-handles
[646.337499] Subtest invalid-wait-zero-handles: SUCCESS (0.000s)
[646.490780] [066/142] (377s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[647.003588] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[661.677329] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (14.679s)
[661.934479] [067/142] (362s left) gem_exec_async (forked-writes)
[662.365412] Starting subtest: forked-writes
[662.368855] Starting dynamic subtest: rcs0
[662.567130] Dynamic subtest rcs0: SUCCESS (0.199s)
[662.620733] Starting dynamic subtest: bcs0
[662.760146] Dynamic subtest bcs0: SUCCESS (0.188s)
[662.810053] Starting dynamic subtest: vcs0
[662.946361] Dynamic subtest vcs0: SUCCESS (0.182s)
[662.994575] Starting dynamic subtest: vcs1
[663.137721] Dynamic subtest vcs1: SUCCESS (0.187s)
[663.187544] Starting dynamic subtest: vecs0
[663.315889] Dynamic subtest vecs0: SUCCESS (0.174s)
[663.362569] Starting dynamic subtest: ccs0
[663.505348] Dynamic subtest ccs0: SUCCESS (0.185s)
[663.508787] Subtest forked-writes: SUCCESS (1.141s)
[663.785972] [068/142] (360s left) prime_self_import (export-vs-gem_close-race)
[664.144826] Starting subtest: export-vs-gem_close-race
[669.231092] Subtest export-vs-gem_close-race: SUCCESS (5.083s)
[669.392063] [069/142] (355s left) kms_flip (dpms-vs-vblank-race-interruptible)
[669.798104] Starting subtest: dpms-vs-vblank-race-interruptible
[669.819185] Starting dynamic subtest: A-eDP1
[674.468035] Dynamic subtest A-eDP1: SUCCESS (4.641s)
[674.505828] Starting dynamic subtest: B-eDP1
[678.344434] Dynamic subtest B-eDP1: SUCCESS (3.878s)
[678.394140] Starting dynamic subtest: C-eDP1
[682.310631] Dynamic subtest C-eDP1: SUCCESS (3.962s)
[682.359226] Starting dynamic subtest: D-eDP1
[686.231624] Dynamic subtest D-eDP1: SUCCESS (3.914s)
[686.256837] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (16.462s)
[687.179513] [070/142] (337s left) kms_cdclk (mode-transition-all-outputs)
[687.660077] Starting subtest: mode-transition-all-outputs
[688.066816] Subtest mode-transition-all-outputs: SKIP (0.408s)
[689.007973] [071/142] (335s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[689.548770] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[694.004925] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (4.459s)
[694.683528] [072/142] (330s left) kms_big_fb (linear-16bpp-rotate-180)
[695.222418] Starting subtest: linear-16bpp-rotate-180
[699.687350] Subtest linear-16bpp-rotate-180: SUCCESS (4.460s)
[700.070806] [073/142] (324s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[700.492398] Starting subtest: 2x-flip-vs-rmfb-interruptible
[700.662540] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.166s)
[700.842659] [074/142] (324s left) kms_ccs (pipe-a-random-ccs-data-4_tiled_dg2_mc_ccs)
[701.805732] Starting subtest: pipe-A-random-ccs-data-4_tiled_dg2_mc_ccs
[701.814956] Subtest pipe-A-random-ccs-data-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[703.241487] [075/142] (321s left) kms_atomic (atomic_plane_damage)
[704.041156] Starting subtest: atomic_plane_damage
[705.001156] Subtest atomic_plane_damage: SUCCESS (0.960s)
[706.349146] [076/142] (318s left) vc4/vc4_wait_seqno (bad-seqno-1ns)
[706.825147] Subtest bad-seqno-1ns: SKIP (0.000s)
[706.962558] [077/142] (318s left) kms_chamelium_hpd (hdmi-hpd-storm)
[707.835407] Subtest hdmi-hpd-storm: SKIP (0.000s)
[708.713532] [078/142] (316s left) kms_vblank (pipe-a-wait-forked-busy-hang)
[709.199357] Starting subtest: pipe-A-wait-forked-busy-hang
[723.822521] Subtest pipe-A-wait-forked-busy-hang: SUCCESS (14.625s)
[724.783050] [079/142] (300s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[725.296449] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[725.303413] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[725.479332] [080/142] (300s left) kms_psr (psr2_sprite_plane_move)
[725.956294] Starting subtest: psr2_sprite_plane_move
[729.038602] Subtest psr2_sprite_plane_move: SUCCESS (3.078s)
[729.990755] [081/142] (295s left) kms_draw_crc (draw-method-mmap-cpu)
[730.478318] Starting subtest: draw-method-mmap-cpu
[730.481976] Starting dynamic subtest: xrgb8888-untiled
[731.142217] Dynamic subtest xrgb8888-untiled: SUCCESS (0.660s)
[731.192738] Starting dynamic subtest: rgb565-untiled
[731.585659] Dynamic subtest rgb565-untiled: SUCCESS (0.441s)
[731.633188] Starting dynamic subtest: xrgb2101010-untiled
[732.221098] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.629s)
[732.274507] Starting dynamic subtest: xrgb8888-xtiled
[732.675255] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.452s)
[732.727182] Starting dynamic subtest: rgb565-xtiled
[733.129827] Dynamic subtest rgb565-xtiled: SUCCESS (0.451s)
[733.186589] Starting dynamic subtest: xrgb2101010-xtiled
[733.564146] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.428s)
[733.612752] Starting dynamic subtest: xrgb8888-4tiled
[734.077703] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.507s)
[734.129179] Starting dynamic subtest: rgb565-4tiled
[734.567508] Dynamic subtest rgb565-4tiled: SUCCESS (0.485s)
[734.618843] Starting dynamic subtest: xrgb2101010-4tiled
[735.076308] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.507s)
[735.079744] Subtest draw-method-mmap-cpu: SUCCESS (4.597s)
[735.255147] [082/142] (290s left) gem_exec_params (dr1-dirt)
[735.652961] Starting subtest: DR1-dirt
[735.656664] Subtest DR1-dirt: SUCCESS (0.001s)
[735.850195] [083/142] (290s left) kms_atomic_interruptible (legacy-dpms)
[736.353593] Starting subtest: legacy-dpms
[736.365425] Starting dynamic subtest: eDP-1-pipe-A
[744.237754] Dynamic subtest eDP-1-pipe-A: SUCCESS (7.868s)
[744.241512] Subtest legacy-dpms: SUCCESS (7.882s)
[744.984967] [084/142] (281s left) gem_wait (busy)
[745.434937] Starting subtest: busy
[745.438647] Starting dynamic subtest: all-engines
[746.555145] Dynamic subtest all-engines: SUCCESS (1.122s)
[746.608263] Starting dynamic subtest: rcs0
[747.109649] Dynamic subtest rcs0: SUCCESS (0.552s)
[747.164309] Starting dynamic subtest: bcs0
[747.661997] Dynamic subtest bcs0: SUCCESS (0.547s)
[747.720948] Starting dynamic subtest: vcs0
[749.498609] Dynamic subtest vcs0: SUCCESS (1.831s)
[749.548969] Starting dynamic subtest: vcs1
[751.547253] Dynamic subtest vcs1: SUCCESS (2.043s)
[751.597494] Starting dynamic subtest: vecs0
[753.530973] Dynamic subtest vecs0: SUCCESS (1.979s)
[753.581191] Starting dynamic subtest: ccs0
[754.082772] Dynamic subtest ccs0: SUCCESS (0.549s)
[754.087139] Subtest busy: SUCCESS (8.656s)
[754.481371] [085/142] (271s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[755.023429] Starting subtest: x-tiled-8bpp-rotate-90
[755.083553] Subtest x-tiled-8bpp-rotate-90: SKIP (0.057s)
[755.289605] [086/142] (270s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[755.798585] Starting subtest: fbcpsr-rgb101010-draw-render
[763.783191] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (7.985s)
[764.005495] [087/142] (262s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[764.574544] Starting subtest: cursorA-vs-flipA-varying-size
[776.417507] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.842s)
[777.381222] [088/142] (249s left) gem_exec_reloc (basic-wc-read-active)
[777.797675] Subtest basic-wc-read-active: SKIP (0.000s)
[777.955481] [089/142] (248s left) gem_ppgtt (shrink-vs-evict-any)
[778.355567] Starting subtest: shrink-vs-evict-any
[785.643267] Subtest shrink-vs-evict-any: SUCCESS (7.293s)
[785.831309] [090/142] (240s left) kms_flip (absolute-wf_vblank)
[786.231109] Starting subtest: absolute-wf_vblank
[786.258393] Starting dynamic subtest: A-eDP1
[795.597113] Dynamic subtest A-eDP1: SUCCESS (9.338s)
[795.649274] Starting dynamic subtest: B-eDP1
[804.763765] Dynamic subtest B-eDP1: SUCCESS (9.161s)
[804.814479] Starting dynamic subtest: C-eDP1
[813.910839] Dynamic subtest C-eDP1: SUCCESS (9.138s)
[813.954170] Starting dynamic subtest: D-eDP1
[823.054591] Dynamic subtest D-eDP1: SUCCESS (9.143s)
[823.080764] Subtest absolute-wf_vblank: SUCCESS (36.855s)
[824.650963] [091/142] (202s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[825.157247] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[825.163842] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[825.336851] [092/142] (201s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[825.724379] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[825.727458] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.003s)
[825.885154] [093/142] (200s left) kms_color (deep-color)
[826.374738] Starting subtest: deep-color
[827.646259] Starting dynamic subtest: pipe-A-eDP-1-gamma
[830.082267] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (2.434s)
[830.129057] Starting dynamic subtest: pipe-A-eDP-1-degamma
[833.227066] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (3.141s)
[833.273678] Starting dynamic subtest: pipe-A-eDP-1-ctm
[836.133558] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (2.899s)
[837.007295] Starting dynamic subtest: pipe-B-eDP-1-gamma
[839.366952] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (2.408s)
[839.414506] Starting dynamic subtest: pipe-B-eDP-1-degamma
[842.454984] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (3.083s)
[842.504576] Starting dynamic subtest: pipe-B-eDP-1-ctm
[845.286839] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (2.830s)
[846.158966] Starting dynamic subtest: pipe-C-eDP-1-gamma
[848.455370] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (2.345s)
[848.502336] Starting dynamic subtest: pipe-C-eDP-1-degamma
[851.142522] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (2.682s)
[851.196781] Starting dynamic subtest: pipe-C-eDP-1-ctm
[852.801990] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.659s)
[853.723079] Starting dynamic subtest: pipe-D-eDP-1-gamma
[854.998107] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (1.320s)
[855.049609] Starting dynamic subtest: pipe-D-eDP-1-degamma
[857.017889] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (2.016s)
[857.071200] Starting dynamic subtest: pipe-D-eDP-1-ctm
[858.658895] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.637s)
[858.662048] Subtest deep-color: SUCCESS (32.276s)
[859.588606] [094/142] (167s left) kms_big_fb (y-tiled-addfb)
[860.143995] Starting subtest: y-tiled-addfb
[860.150793] Subtest y-tiled-addfb: SKIP (0.000s)
[860.341971] [095/142] (166s left) kms_pipe_crc_basic (nonblocking-crc)
[860.824201] Starting subtest: nonblocking-crc
[860.832727] Starting dynamic subtest: pipe-A-eDP-1
[862.140317] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.306s)
[862.212329] Starting dynamic subtest: pipe-B-eDP-1
[864.179735] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.025s)
[864.234874] Starting dynamic subtest: pipe-C-eDP-1
[866.459058] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.271s)
[866.518890] Starting dynamic subtest: pipe-D-eDP-1
[868.908240] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.435s)
[868.911508] Subtest nonblocking-crc: SUCCESS (8.086s)
[869.868410] [096/142] (157s left) kms_ccs (pipe-c-bad-aux-stride-4_tiled_mtl_mc_ccs)
[871.391110] Starting subtest: pipe-C-bad-aux-stride-4_tiled_mtl_mc_ccs
[871.896098] Subtest pipe-C-bad-aux-stride-4_tiled_mtl_mc_ccs: SUCCESS (0.505s)
[872.761063] [097/142] (154s left) gem_userptr_blits (sd-probe)
[873.155875] Starting subtest: sd-probe
[873.159423] Subtest sd-probe: SUCCESS (0.004s)
[873.454434] [098/142] (153s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[873.997447] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[874.003685] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[874.175066] [099/142] (153s left) gem_render_copy (y-tiled-ccs-to-linear)
[874.584520] Starting subtest: y-tiled-ccs-to-linear
[874.590559] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[874.881425] [100/142] (152s left) gem_softpin (evict-active)
[875.285232] Starting subtest: evict-active
[875.309560] Subtest evict-active: SUCCESS (0.024s)
[875.481161] [101/142] (152s left) perf (polling-small-buf)
[876.389786] Starting subtest: polling-small-buf
[876.513518] Subtest polling-small-buf: SUCCESS (0.124s)
[876.632837] [102/142] (151s left) device_reset (cold-reset-bound)
[877.429712] Subtest cold-reset-bound: SKIP (0.000s)
[877.606851] [103/142] (150s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[878.206725] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[879.875438] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (1.669s)
[880.801784] [104/142] (147s left) kms_ccs (pipe-c-random-ccs-data-4_tiled_mtl_rc_ccs)
[882.242619] Starting subtest: pipe-C-random-ccs-data-4_tiled_mtl_rc_ccs
[883.442862] Subtest pipe-C-random-ccs-data-4_tiled_mtl_rc_ccs: SUCCESS (1.199s)
[884.865766] [105/142] (143s left) perf_pmu (busy-idle-no-semaphores)
[885.265548] Starting subtest: busy-idle-no-semaphores
[885.268832] Starting dynamic subtest: rcs0
[885.936999] Dynamic subtest rcs0: SUCCESS (0.674s)
[885.994210] Starting dynamic subtest: bcs0
[886.614917] Dynamic subtest bcs0: SUCCESS (0.673s)
[886.676079] Starting dynamic subtest: vcs0
[887.292300] Dynamic subtest vcs0: SUCCESS (0.674s)
[887.345310] Starting dynamic subtest: vcs1
[889.139358] Dynamic subtest vcs1: SUCCESS (1.842s)
[889.193349] Starting dynamic subtest: vecs0
[891.126364] Dynamic subtest vecs0: SUCCESS (1.982s)
[891.182354] Starting dynamic subtest: ccs0
[893.179335] Dynamic subtest ccs0: SUCCESS (2.049s)
[893.183532] Subtest busy-idle-no-semaphores: SUCCESS (7.921s)
[893.413512] [106/142] (134s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[893.978935] Starting subtest: 4-tiled-64bpp-rotate-90
[894.047886] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.059s)
[894.241313] [107/142] (133s left) kms_vblank (pipe-b-wait-busy)
[894.731641] Starting subtest: pipe-B-wait-busy
[897.921050] Subtest pipe-B-wait-busy: SUCCESS (3.190s)
[898.917075] [108/142] (129s left) v3d/v3d_perfmon (get-values-invalid-perfmon)
[899.394501] Subtest get-values-invalid-perfmon: SKIP (0.000s)
[899.541578] [109/142] (128s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_mtl_mc_ccs)
[900.466164] Starting subtest: pipe-A-crc-primary-basic-4_tiled_mtl_mc_ccs
[909.201132] Subtest pipe-A-crc-primary-basic-4_tiled_mtl_mc_ccs: SUCCESS (8.735s)
[911.051301] [110/142] (117s left) gem_lmem_swapping (massive-random)
[911.456443] Subtest massive-random: SKIP (0.000s)
[911.583629] [111/142] (116s left) gem_close_race (basic-threads)
[912.023490] Starting subtest: basic-threads
[913.584495] Subtest basic-threads: SUCCESS (1.555s)
[913.870911] [112/142] (114s left) kms_ccs (pipe-b-bad-rotation-90-4_tiled_dg2_rc_ccs_cc)
[914.968298] Starting subtest: pipe-B-bad-rotation-90-4_tiled_dg2_rc_ccs_cc
[914.974973] Subtest pipe-B-bad-rotation-90-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[916.233934] [113/142] (112s left) kms_ccs (pipe-d-crc-primary-basic-y_tiled_ccs)
[917.847615] Starting subtest: pipe-D-crc-primary-basic-y_tiled_ccs
[917.854135] Subtest pipe-D-crc-primary-basic-y_tiled_ccs: SKIP (0.003s)
[918.586515] [114/142] (110s left) prime_mmap (test_reprime)
[918.978828] Starting subtest: test_reprime
[918.982876] Starting dynamic subtest: test_reprime-smem
[919.510551] Dynamic subtest test_reprime-smem: SUCCESS (0.534s)
[919.514258] Subtest test_reprime: SUCCESS (0.541s)
[919.695250] [115/142] (109s left) kms_universal_plane (universal-plane-pipe-c-sanity)
[920.176316] Starting subtest: universal-plane-pipe-C-sanity
[922.511388] Subtest universal-plane-pipe-C-sanity: SUCCESS (2.332s)
[923.476944] [116/142] (105s left) kms_addfb_basic (basic-x-tiled-legacy)
[923.856095] Starting subtest: basic-x-tiled-legacy
[923.862629] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[924.128873] [117/142] (105s left) kms_ccs (pipe-b-bad-aux-stride-yf_tiled_ccs)
[925.425206] Starting subtest: pipe-B-bad-aux-stride-yf_tiled_ccs
[925.431528] Subtest pipe-B-bad-aux-stride-yf_tiled_ccs: SKIP (0.000s)
[926.532948] [118/142] (102s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[926.915434] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[927.026602] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.110s)
[927.186243] [119/142] (102s left) i915_pm_backlight (fade-with-dpms)
[927.666876] Starting subtest: fade-with-dpms
[930.250769] Starting dynamic subtest: eDP-1
[933.176224] Dynamic subtest eDP-1: SUCCESS (2.922s)
[933.179864] Subtest fade-with-dpms: SUCCESS (5.508s)
[934.517447] [120/142] ( 94s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[934.902668] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[934.906867] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.002s)
[935.069410] [121/142] ( 94s left) kms_vblank (pipe-d-query-forked-busy)
[935.549722] Starting subtest: pipe-D-query-forked-busy
[939.873997] Subtest pipe-D-query-forked-busy: SUCCESS (4.321s)
[940.838429] [122/142] ( 88s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[941.247893] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[941.254507] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[941.531051] [123/142] ( 88s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[942.010085] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[942.020396] Starting dynamic subtest: pipe-A-default-mode
[942.575145] Dynamic subtest pipe-A-default-mode: SKIP (0.551s)
[942.581585] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.565s)
[943.390562] [124/142] ( 86s left) gem_ctx_persistence (userptr)
[943.797394] Starting subtest: userptr
[944.008488] Subtest userptr: SUCCESS (0.211s)
[944.177210] [125/142] ( 85s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs)
[945.724345] Starting subtest: pipe-C-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs
[945.739316] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs: SKIP (0.013s)
[946.563666] [126/142] ( 83s left) kms_addfb_basic (bad-pitch-0)
[946.783536] Starting subtest: bad-pitch-0
[946.787568] Subtest bad-pitch-0: SUCCESS (0.000s)
[946.978613] [127/142] ( 83s left) kms_ccs (pipe-a-bad-rotation-90-4_tiled_dg2_rc_ccs)
[947.882759] Starting subtest: pipe-A-bad-rotation-90-4_tiled_dg2_rc_ccs
[947.889714] Subtest pipe-A-bad-rotation-90-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[949.366265] [128/142] ( 80s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[949.906532] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[949.912887] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[950.081381] [129/142] ( 80s left) kms_flip (flip-vs-panning)
[950.486641] Starting subtest: flip-vs-panning
[950.516408] Starting dynamic subtest: A-eDP1
[959.993845] Dynamic subtest A-eDP1: SUCCESS (9.478s)
[960.053864] Starting dynamic subtest: B-eDP1
[969.338078] Dynamic subtest B-eDP1: SUCCESS (9.339s)
[969.407717] Starting dynamic subtest: C-eDP1
[978.661646] Dynamic subtest C-eDP1: SUCCESS (9.319s)
[978.731642] Starting dynamic subtest: D-eDP1
[988.006935] Dynamic subtest D-eDP1: SUCCESS (9.340s)
[988.031231] Subtest flip-vs-panning: SUCCESS (37.546s)
[989.585680] [130/142] ( 40s left) kms_ccs (pipe-d-random-ccs-data-yf_tiled_ccs)
[991.290331] Starting subtest: pipe-D-random-ccs-data-yf_tiled_ccs
[991.299995] Subtest pipe-D-random-ccs-data-yf_tiled_ccs: SKIP (0.000s)
[991.995210] [131/142] ( 38s left) gem_softpin (allocator-basic-reserve)
[992.393507] Starting subtest: allocator-basic-reserve
[992.954619] Subtest allocator-basic-reserve: SUCCESS (0.560s)
[993.199668] [132/142] ( 37s left) gem_readwrite (beyond-eob)
[993.573928] Subtest beyond-EOB: SKIP (0.000s)
[993.710902] [133/142] ( 37s left) kms_vrr (negative-basic)
[994.179242] Starting subtest: negative-basic
[994.189146] Starting dynamic subtest: pipe-A-eDP-1
[1000.253204] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.064s)
[1000.256171] Subtest negative-basic: SUCCESS (6.072s)
[1001.216719] [134/142] ( 29s left) gem_eio (in-flight-1us)
[1002.823390] Starting subtest: in-flight-1us
[1034.632058] Subtest in-flight-1us: SUCCESS (31.807s)
[1036.692416] Overall timeout time exceeded, stopping.
[1036.693779] Closing watchdogs
Done.