[52.885274] Initializing watchdogs
[52.885542]   /dev/watchdog0
[52.901689] [001/141] (960s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc)
[53.395675] Starting subtest: pipe-A-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc
[53.401738] Subtest pipe-A-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.005s)
[53.929996] [002/141] (959s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[54.243817] Starting subtest: basic-busy-flip-before-cursor-varying-size
[54.247438] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[54.327823] [003/141] (959s left) drm_fdinfo (busy-check-all)
[54.549131] Starting subtest: busy-check-all
[54.550764] Starting dynamic subtest: rcs0
[55.097980] Dynamic subtest rcs0: SUCCESS (0.549s)
[55.112535] Starting dynamic subtest: bcs0
[55.636594] Dynamic subtest bcs0: SUCCESS (0.539s)
[55.650553] Starting dynamic subtest: vcs0
[56.168732] Dynamic subtest vcs0: SUCCESS (0.532s)
[56.182513] Starting dynamic subtest: vecs0
[56.697631] Dynamic subtest vecs0: SUCCESS (0.529s)
[56.699090] Subtest busy-check-all: SUCCESS (2.149s)
[56.777512] [004/141] (956s left) syncobj_wait (wait-for-submit-snapshot)
[56.989733] Starting subtest: wait-for-submit-snapshot
[57.074619] Subtest wait-for-submit-snapshot: SUCCESS (0.083s)
[57.162133] [005/141] (956s left) kms_busy (basic)
[57.484591] Starting subtest: basic
[57.486070] Starting dynamic subtest: flip
[58.366935] Dynamic subtest flip: SUCCESS (0.872s)
[58.380449] Starting dynamic subtest: modeset
[59.855042] Dynamic subtest modeset: SUCCESS (1.491s)
[59.856511] Subtest basic: SUCCESS (2.367s)
[60.203325] [006/141] (953s left) i915_pm_freq_api (freq-basic-api)
[60.420728] Subtest freq-basic-api: SKIP (0.000s)
[60.467335] [007/141] (953s left) kms_plane_alpha_blend (constant-alpha-min)
[60.769642] Starting subtest: constant-alpha-min
[61.078925] Starting dynamic subtest: pipe-A-DP-1
[61.768023] Dynamic subtest pipe-A-DP-1: SUCCESS (0.688s)
[61.781978] Starting dynamic subtest: pipe-C-DP-1
[62.713426] Dynamic subtest pipe-C-DP-1: SUCCESS (0.943s)
[62.714896] Subtest constant-alpha-min: SUCCESS (1.946s)
[63.089123] [008/141] (950s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[63.408451] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[63.411215] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[63.505052] [009/141] (950s left) kms_chamelium_color (ctm-negative)
[63.809154] Subtest ctm-negative: SKIP (0.000s)
[63.853796] [010/141] (949s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[64.179673] Starting subtest: yf-tiled-addfb-size-overflow
[64.181143] Subtest yf-tiled-addfb-size-overflow: SUCCESS (0.002s)
[64.271637] [011/141] (949s left) gem_ctx_bad_destroy (invalid-ctx)
[64.477970] Starting subtest: invalid-ctx
[64.479418] Subtest invalid-ctx: SUCCESS (0.000s)
[64.554451] [012/141] (949s left) gem_exec_flush (basic-batch-kernel-default-wb)
[64.785554] Starting subtest: basic-batch-kernel-default-wb
[70.584302] Subtest basic-batch-kernel-default-wb: SUCCESS (5.798s)
[70.773210] [013/141] (943s left) kms_plane_scaling (planes-downscale-factor-0-25-unity-scaling)
[71.078397] Starting subtest: planes-downscale-factor-0-25-unity-scaling
[71.079835] Starting dynamic subtest: pipe-A-DP-1
[71.107646] Dynamic subtest pipe-A-DP-1: SKIP (0.028s)
[71.121687] Starting dynamic subtest: pipe-B-DP-1
[71.194354] Dynamic subtest pipe-B-DP-1: SKIP (0.084s)
[71.208402] Starting dynamic subtest: pipe-C-DP-1
[71.274601] Dynamic subtest pipe-C-DP-1: SKIP (0.078s)
[71.277236] Subtest planes-downscale-factor-0-25-unity-scaling: SKIP (0.199s)
[71.373164] [014/141] (942s left) gem_exec_reloc (basic-cpu-gtt)
[71.597887] Starting subtest: basic-cpu-gtt
[71.631354] Subtest basic-cpu-gtt: SUCCESS (0.032s)
[71.808393] [015/141] (942s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[72.146664] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[72.149348] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[72.257343] [016/141] (941s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[72.573622] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[72.576147] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[72.672092] [017/141] (941s left) perf (per-context-mode-unprivileged)
[73.032492] Starting subtest: per-context-mode-unprivileged
[73.035496] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[73.070187] [018/141] (940s left) prime_busy (after-wait)
[73.280768] Starting subtest: after-wait
[73.297591] Starting dynamic subtest: rcs0
[73.319947] Dynamic subtest rcs0: SUCCESS (0.022s)
[73.334247] Starting dynamic subtest: bcs0
[73.337078] Dynamic subtest bcs0: SUCCESS (0.017s)
[73.353788] Starting dynamic subtest: vcs0
[73.355231] Dynamic subtest vcs0: SUCCESS (0.018s)
[73.371391] Starting dynamic subtest: vecs0
[73.374576] Dynamic subtest vecs0: SUCCESS (0.018s)
[73.487460] Subtest after-wait: SUCCESS (0.205s)
[73.572968] [019/141] (940s left) gem_mmap_offset (bad-flags)
[73.776216] Starting subtest: bad-flags
[73.777624] Subtest bad-flags: SUCCESS (0.000s)
[73.873088] [020/141] (940s left) gem_busy (busy)
[74.105789] Starting subtest: busy
[74.107330] Starting dynamic subtest: all-engines
[74.194240] Dynamic subtest all-engines: SUCCESS (0.086s)
[74.209058] Starting dynamic subtest: rcs0
[74.210316] Dynamic subtest rcs0: SUCCESS (0.014s)
[74.227593] Starting dynamic subtest: bcs0
[74.228903] Dynamic subtest bcs0: SUCCESS (0.013s)
[74.244665] Starting dynamic subtest: vcs0
[74.245980] Dynamic subtest vcs0: SUCCESS (0.019s)
[74.260424] Starting dynamic subtest: vecs0
[74.261796] Dynamic subtest vecs0: SUCCESS (0.012s)
[74.263132] Subtest busy: SUCCESS (0.147s)
[74.589945] [021/141] (939s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[74.892556] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[74.897317] Starting dynamic subtest: A-DP1
[76.109499] Dynamic subtest A-DP1: SUCCESS (1.210s)
[76.125348] Starting dynamic subtest: B-DP1
[77.208428] Dynamic subtest B-DP1: SUCCESS (1.098s)
[77.225232] Starting dynamic subtest: C-DP1
[78.325757] Dynamic subtest C-DP1: SUCCESS (1.116s)
[78.328045] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (3.432s)
[78.659206] [022/141] (935s left) kms_ccs (pipe-b-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs)
[79.250826] Starting subtest: pipe-B-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs
[79.257888] Subtest pipe-B-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs: SKIP (0.006s)
[79.692240] [023/141] (934s left) kms_psr (psr2_sprite_mmap_gtt)
[79.899772] Subtest psr2_sprite_mmap_gtt: SKIP (0.000s)
[79.940722] [024/141] (934s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[80.264707] Starting subtest: yf-tiled-64bpp-rotate-0
[80.267588] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[80.359474] [025/141] (933s left) kms_vblank (pipe-c-query-forked-busy-hang)
[80.667238] Starting subtest: pipe-C-query-forked-busy-hang
[87.983467] Subtest pipe-C-query-forked-busy-hang: SUCCESS (7.320s)
[88.326973] [026/141] (925s left) gem_exec_suspend (basic-s0)
[88.554635] Starting subtest: basic-S0
[88.556123] Starting dynamic subtest: smem
[109.063948] Dynamic subtest smem: SUCCESS (20.510s)
[109.065518] Subtest basic-S0: SUCCESS (20.511s)
[113.270627] [027/141] (905s left) kms_vblank (pipe-b-ts-continuation-modeset-hang)
[113.573659] Starting subtest: pipe-B-ts-continuation-modeset-hang
[121.009809] Subtest pipe-B-ts-continuation-modeset-hang: SUCCESS (7.437s)
[121.344439] [028/141] (896s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[121.669354] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[121.672553] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[121.760226] [029/141] (896s left) gem_softpin (overlap)
[121.978339] Starting subtest: overlap
[124.799138] Subtest overlap: SUCCESS (2.820s)
[124.912231] [030/141] (893s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[125.237823] Starting subtest: y-tiled-8bpp-rotate-90
[125.315167] Subtest y-tiled-8bpp-rotate-90: SKIP (0.076s)
[125.411589] [031/141] (893s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[125.728478] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[128.040028] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (2.315s)
[128.176344] [032/141] (890s left) kms_content_protection (dp-mst-type-1)
[128.509743] Starting subtest: dp-mst-type-1
[128.512631] Subtest dp-mst-type-1: SKIP (0.000s)
[128.610847] [033/141] (889s left) api_intel_bb (blit-reloc-purge-cache)
[128.817291] Starting subtest: blit-reloc-purge-cache
[128.837494] Subtest blit-reloc-purge-cache: SUCCESS (0.022s)
[128.943258] [034/141] (889s left) gem_ctx_param (invalid-ctx-get)
[129.149654] Starting subtest: invalid-ctx-get
[129.151039] Subtest invalid-ctx-get: SUCCESS (0.000s)
[129.226298] [035/141] (889s left) kms_ccs (pipe-c-ccs-on-another-bo-y_tiled_ccs)
[129.862818] Starting subtest: pipe-C-ccs-on-another-bo-y_tiled_ccs
[129.865585] Subtest pipe-C-ccs-on-another-bo-y_tiled_ccs: SKIP (0.000s)
[130.216684] [036/141] (888s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[130.540627] Starting subtest: 4-tiled-16bpp-rotate-270
[130.543932] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.000s)
[130.633628] [037/141] (888s left) syncobj_wait (wait-for-submit-delayed-submit)
[130.844719] Starting subtest: wait-for-submit-delayed-submit
[130.949759] Subtest wait-for-submit-delayed-submit: SUCCESS (0.104s)
[131.034200] [038/141] (887s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[131.340696] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[131.343494] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[131.433902] [039/141] (887s left) gem_render_copy (yf-tiled-to-vebox-linear)
[131.660466] Starting subtest: yf-tiled-to-vebox-linear
[131.663894] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[131.867248] [040/141] (886s left) gem_exec_schedule (implicit-boths)
[132.100658] Starting subtest: implicit-boths
[132.102373] Starting dynamic subtest: rcs0
[132.258773] Dynamic subtest rcs0: SUCCESS (0.155s)
[132.289978] Starting dynamic subtest: bcs0
[132.405875] Dynamic subtest bcs0: SUCCESS (0.146s)
[132.430707] Starting dynamic subtest: vcs0
[132.541106] Dynamic subtest vcs0: SUCCESS (0.134s)
[132.564111] Starting dynamic subtest: vecs0
[132.670855] Dynamic subtest vecs0: SUCCESS (0.127s)
[132.674372] Subtest implicit-boths: SUCCESS (0.567s)
[133.035359] [041/141] (885s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[133.343110] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[133.345847] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[133.452108] [042/141] (885s left) kms_big_fb (linear-32bpp-rotate-90)
[133.784874] Starting subtest: linear-32bpp-rotate-90
[133.871234] Subtest linear-32bpp-rotate-90: SKIP (0.083s)
[133.984433] [043/141] (884s left) dmabuf_sync_file (export-before-signal)
[134.262739] Starting subtest: export-before-signal
[134.267644] Subtest export-before-signal: SUCCESS (0.005s)
[134.333716] [044/141] (884s left) syncobj_wait (multi-wait-for-submit-submitted)
[134.540685] Starting subtest: multi-wait-for-submit-submitted
[134.647950] Subtest multi-wait-for-submit-submitted: SUCCESS (0.106s)
[134.733987] [045/141] (884s left) gem_spin_batch (legacy-resubmit-new)
[134.964713] Starting subtest: legacy-resubmit-new
[134.966540] Starting dynamic subtest: default
[134.974721] Dynamic subtest default: SUCCESS (0.008s)
[135.001062] Starting dynamic subtest: render
[135.002623] Dynamic subtest render: SUCCESS (0.008s)
[135.022909] Starting dynamic subtest: bsd
[135.024495] Dynamic subtest bsd: SUCCESS (0.009s)
[135.041503] Starting dynamic subtest: bsd1
[135.042894] Dynamic subtest bsd1: SUCCESS (0.009s)
[135.060659] Starting dynamic subtest: blt
[135.062028] Dynamic subtest blt: SUCCESS (0.009s)
[135.079060] Starting dynamic subtest: vebox
[135.080377] Dynamic subtest vebox: SUCCESS (0.008s)
[135.081672] Subtest legacy-resubmit-new: SUCCESS (0.060s)
[135.250467] [046/141] (883s left) perf_pmu (busy-double-start)
[135.465903] Starting subtest: busy-double-start
[135.467522] Starting dynamic subtest: rcs0
[139.021810] Dynamic subtest rcs0: SUCCESS (3.555s)
[139.042507] Starting dynamic subtest: bcs0
[142.578368] Dynamic subtest bcs0: SUCCESS (3.554s)
[142.597111] Starting dynamic subtest: vcs0
[146.130818] Dynamic subtest vcs0: SUCCESS (3.551s)
[146.150566] Starting dynamic subtest: vecs0
[149.677699] Dynamic subtest vecs0: SUCCESS (3.545s)
[149.680118] Subtest busy-double-start: SUCCESS (14.212s)
[149.769556] [047/141] (869s left) gen7_exec_parse (chained-batch)
[149.985068] Subtest chained-batch: SKIP (0.000s)
[150.034745] [048/141] (869s left) kms_universal_plane (universal-plane-pageflip-windowed-pipe-d)
[150.336859] Subtest universal-plane-pageflip-windowed-pipe-D: SKIP (0.000s)
[150.418347] [049/141] (868s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[150.731963] Starting subtest: fbc-rgb565-draw-render
[152.962598] Subtest fbc-rgb565-draw-render: SUCCESS (2.232s)
[153.100954] [050/141] (866s left) gem_userptr_blits (readonly-unsync)
[153.322722] Subtest readonly-unsync: SKIP (0.000s)
[153.485251] [051/141] (865s left) kms_psr (sprite_mmap_cpu)
[153.692177] Subtest sprite_mmap_cpu: SKIP (0.000s)
[153.750329] [052/141] (865s left) gem_mmap_gtt (fault-concurrent-x)
[153.953731] Starting subtest: fault-concurrent-X
[157.371453] Subtest fault-concurrent-X: SUCCESS (3.416s)
[157.701252] [053/141] (861s left) kms_vrr (flip-suspend)
[158.003180] Starting subtest: flip-suspend
[158.005872] Subtest flip-suspend: SKIP (0.000s)
[158.085698] [054/141] (861s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[158.394681] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[158.396592] Starting dynamic subtest: pipe-A-valid-mode
[159.055148] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.660s)
[159.056617] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (0.662s)
[159.390676] [055/141] (859s left) kms_hdr (bpc-switch)
[159.696808] Starting subtest: bpc-switch
[161.994591] Starting dynamic subtest: pipe-A-DP-1
[163.113684] Dynamic subtest pipe-A-DP-1: SUCCESS (1.119s)
[163.115303] Subtest bpc-switch: SUCCESS (3.417s)
[163.484612] [056/141] (855s left) kms_flip (2x-blocking-wf_vblank)
[163.783274] Starting subtest: 2x-blocking-wf_vblank
[163.785951] Subtest 2x-blocking-wf_vblank: SKIP (0.004s)
[163.900554] [057/141] (855s left) gem_pxp (hw-rejects-pxp-buffer)
[166.622702] Starting subtest: hw-rejects-pxp-buffer
[166.624348] Subtest hw-rejects-pxp-buffer: SUCCESS (0.000s)
[166.732779] [058/141] (852s left) gem_exec_schedule (preempt-user)
[166.971080] Starting subtest: preempt-user
[166.972659] Starting dynamic subtest: rcs0
[167.047028] Dynamic subtest rcs0: SUCCESS (0.073s)
[167.073936] Starting dynamic subtest: bcs0
[167.140315] Dynamic subtest bcs0: SUCCESS (0.090s)
[167.167901] Starting dynamic subtest: vcs0
[167.200446] Dynamic subtest vcs0: SUCCESS (0.061s)
[167.234596] Starting dynamic subtest: vecs0
[167.260658] Dynamic subtest vecs0: SUCCESS (0.059s)
[167.262457] Subtest preempt-user: SUCCESS (0.289s)
[167.600675] [059/141] (851s left) gem_exec_params (no-bsd)
[167.813468] Starting subtest: no-bsd
[167.818118] Subtest no-bsd: SUCCESS (0.002s)
[167.932855] [060/141] (851s left) gem_request_retire (retire-vma-not-inactive)
[168.148360] Starting subtest: retire-vma-not-inactive
[168.182123] Subtest retire-vma-not-inactive: SUCCESS (0.032s)
[168.283221] [061/141] (851s left) i915_pm_rpm (gem-idle)
[170.181303] Starting subtest: gem-idle
[175.639615] Subtest gem-idle: SUCCESS (5.456s)
[176.081371] [062/141] (843s left) kms_flip (flip-vs-expired-vblank-interruptible)
[176.391824] Starting subtest: flip-vs-expired-vblank-interruptible
[176.396500] Starting dynamic subtest: A-DP1
[186.910235] Dynamic subtest A-DP1: SUCCESS (10.514s)
[186.933500] Starting dynamic subtest: B-DP1
[197.368110] Dynamic subtest B-DP1: SUCCESS (10.454s)
[197.390550] Starting dynamic subtest: C-DP1
[207.839743] Dynamic subtest C-DP1: SUCCESS (10.470s)
[207.843634] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (31.451s)
[208.260478] [063/141] (811s left) gem_eio (in-flight-contexts-immediate)
[208.498450] Starting subtest: in-flight-contexts-immediate
[220.218206] Subtest in-flight-contexts-immediate: SUCCESS (11.719s)
[220.443554] [064/141] (799s left) gem_exec_fence (syncobj-export)
[221.128163] Starting subtest: syncobj-export
[221.136403] Subtest syncobj-export: SUCCESS (0.009s)
[221.493791] [065/141] (798s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[221.802174] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[221.805031] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[221.909446] [066/141] (797s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[222.220362] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[222.223135] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[222.325988] [067/141] (797s left) syncobj_wait (signal)
[222.531958] Starting subtest: signal
[222.533845] Subtest signal: SUCCESS (0.000s)
[222.625072] [068/141] (797s left) gen9_exec_parse (unaligned-jump)
[222.855205] Starting subtest: unaligned-jump
[223.117823] Subtest unaligned-jump: SUCCESS (0.261s)
[223.342359] [069/141] (796s left) kms_ccs (pipe-c-random-ccs-data-4_tiled_dg2_rc_ccs_cc)
[223.967843] Starting subtest: pipe-C-random-ccs-data-4_tiled_dg2_rc_ccs_cc
[223.972054] Subtest pipe-C-random-ccs-data-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[224.336920] [070/141] (795s left) dumb_buffer (create-valid-dumb)
[224.544372] Starting subtest: create-valid-dumb
[224.546325] Subtest create-valid-dumb: SUCCESS (0.000s)
[224.655126] [071/141] (795s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[224.972373] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[224.975365] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[225.086463] [072/141] (794s left) v3d/v3d_perfmon (destroy-invalid-perfmon)
[225.344818] Subtest destroy-invalid-perfmon: SKIP (0.000s)
[225.419087] [073/141] (794s left) gem_ctx_persistence (smoketest)
[225.634236] Starting subtest: smoketest
[256.819374] Subtest smoketest: SUCCESS (31.185s)
[256.921741] [074/141] (763s left) kms_invalid_mode (bad-hsync-start)
[257.222837] Starting subtest: bad-hsync-start
[257.224473] Starting dynamic subtest: DP-1-pipe-A
[257.320959] Dynamic subtest DP-1-pipe-A: SUCCESS (0.099s)
[257.349493] Starting dynamic subtest: DP-1-pipe-B
[257.351350] Dynamic subtest DP-1-pipe-B: SUCCESS (0.014s)
[257.382991] Starting dynamic subtest: DP-1-pipe-C
[257.385122] Dynamic subtest DP-1-pipe-C: SUCCESS (0.015s)
[257.387059] Subtest bad-hsync-start: SUCCESS (0.139s)
[257.680283] [075/141] (762s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[257.887634] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[257.992430] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.103s)
[258.079831] [076/141] (762s left) kms_plane_scaling (plane-upscale-with-rotation-20x20)
[258.390896] Starting subtest: plane-upscale-with-rotation-20x20
[258.392544] Starting dynamic subtest: pipe-A-DP-1
[258.440254] Dynamic subtest pipe-A-DP-1: SKIP (0.048s)
[258.466370] Starting dynamic subtest: pipe-B-DP-1
[258.804517] Dynamic subtest pipe-B-DP-1: SKIP (0.360s)
[258.831418] Starting dynamic subtest: pipe-C-DP-1
[259.158773] Dynamic subtest pipe-C-DP-1: SKIP (0.348s)
[259.161881] Subtest plane-upscale-with-rotation-20x20: SKIP (0.770s)
[259.564217] [077/141] (760s left) kms_ccs (pipe-c-missing-ccs-buffer-y_tiled_ccs)
[260.183077] Starting subtest: pipe-C-missing-ccs-buffer-y_tiled_ccs
[260.185732] Subtest pipe-C-missing-ccs-buffer-y_tiled_ccs: SKIP (0.000s)
[260.548833] [078/141] (759s left) kms_ccs (pipe-a-bad-rotation-90-4_tiled_mtl_rc_ccs)
[260.941320] Starting subtest: pipe-A-bad-rotation-90-4_tiled_mtl_rc_ccs
[260.944236] Subtest pipe-A-bad-rotation-90-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[261.551338] [079/141] (758s left) kms_vblank (pipe-b-wait-forked)
[261.861787] Starting subtest: pipe-B-wait-forked
[264.605501] Subtest pipe-B-wait-forked: SUCCESS (2.748s)
[264.949825] [080/141] (755s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[265.254937] Starting subtest: sprite-rotation-90-pos-100-0
[271.360264] Subtest sprite-rotation-90-pos-100-0: SUCCESS (6.106s)
[271.789920] [081/141] (748s left) kms_chamelium_hpd (vga-hpd-fast)
[272.195468] Subtest vga-hpd-fast: SKIP (0.000s)
[272.498888] [082/141] (747s left) kms_display_modes (extended-mode-basic)
[272.813277] Starting subtest: extended-mode-basic
[272.816028] Subtest extended-mode-basic: SKIP (0.000s)
[272.875364] [083/141] (747s left) gem_exec_balancer (bonded-sync)
[273.103584] Starting subtest: bonded-sync
[276.868936] Subtest bonded-sync: SUCCESS (3.763s)
[280.827635] [084/141] (739s left) syncobj_timeline (invalid-wait-bad-flags)
[281.036672] Starting subtest: invalid-wait-bad-flags
[281.038409] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[281.126263] [085/141] (739s left) gem_mmap_wc (read)
[281.328615] Starting subtest: read
[281.466512] Subtest read: SUCCESS (0.135s)
[281.559576] [086/141] (739s left) kms_flip (wf_vblank-ts-check)
[281.843392] Starting subtest: wf_vblank-ts-check
[281.844831] Starting dynamic subtest: A-DP1
[292.664984] Dynamic subtest A-DP1: SUCCESS (10.821s)
[292.691937] Starting dynamic subtest: B-DP1
[303.416361] Dynamic subtest B-DP1: SUCCESS (10.748s)
[303.441467] Starting dynamic subtest: C-DP1
[314.165591] Dynamic subtest C-DP1: SUCCESS (10.746s)
[314.170926] Subtest wf_vblank-ts-check: SUCCESS (32.329s)
[314.599155] [087/141] (706s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[314.897875] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[314.899283] Starting dynamic subtest: pipe-A-valid-mode
[315.057310] Dynamic subtest pipe-A-valid-mode: SKIP (0.155s)
[315.060415] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.159s)
[315.385983] [088/141] (705s left) kms_ccs (pipe-c-bad-rotation-90-yf_tiled_ccs)
[315.982692] Starting subtest: pipe-C-bad-rotation-90-yf_tiled_ccs
[315.985712] Subtest pipe-C-bad-rotation-90-yf_tiled_ccs: SKIP (0.000s)
[316.388900] [089/141] (704s left) sysfs_preempt_timeout (invalid)
[316.600357] Starting subtest: invalid
[316.604990] Starting dynamic subtest: vecs0
[316.606573] Dynamic subtest vecs0: SUCCESS (0.001s)
[316.631706] Starting dynamic subtest: vcs0
[316.633122] Dynamic subtest vcs0: SUCCESS (0.001s)
[316.655275] Starting dynamic subtest: bcs0
[316.656618] Dynamic subtest bcs0: SUCCESS (0.001s)
[316.678087] Starting dynamic subtest: rcs0
[316.679464] Dynamic subtest rcs0: SUCCESS (0.001s)
[316.680805] Subtest invalid: SUCCESS (0.017s)
[316.723650] [090/141] (704s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[317.030761] Starting subtest: nonblocking-crc-frame-sequence
[317.032288] Starting dynamic subtest: pipe-A-DP-1
[317.625788] Dynamic subtest pipe-A-DP-1: SUCCESS (0.594s)
[317.650527] Starting dynamic subtest: pipe-B-DP-1
[318.511890] Dynamic subtest pipe-B-DP-1: SUCCESS (0.881s)
[318.542316] Starting dynamic subtest: pipe-C-DP-1
[319.539235] Dynamic subtest pipe-C-DP-1: SUCCESS (1.021s)
[319.540578] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.512s)
[319.866133] [091/141] (701s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[320.073738] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[320.078474] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.003s)
[320.163851] [092/141] (700s left) kms_ccs (pipe-d-random-ccs-data-4_tiled_dg2_rc_ccs_cc)
[320.832526] Subtest pipe-D-random-ccs-data-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[321.153506] [093/141] (699s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[321.477324] Starting subtest: cursor-rapid-movement-512x512
[321.483370] Subtest cursor-rapid-movement-512x512: SKIP (0.003s)
[321.586618] [094/141] (699s left) gem_reg_read (timestamp-moving)
[321.786940] Starting subtest: timestamp-moving
[322.789386] Subtest timestamp-moving: SUCCESS (1.001s)
[322.886649] [095/141] (698s left) kms_cursor_crc (cursor-offscreen-512x512)
[323.201585] Starting subtest: cursor-offscreen-512x512
[323.206951] Subtest cursor-offscreen-512x512: SKIP (0.003s)
[323.320564] [096/141] (697s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[323.639322] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[323.642360] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[323.754668] [097/141] (697s left) gem_lmem_swapping (parallel-random)
[323.968324] Subtest parallel-random: SKIP (0.000s)
[324.034931] [098/141] (697s left) gem_gtt_cpu_tlb
[324.353108] [099/141] (696s left) perf_pmu (all-busy-check-all)
[324.561068] Starting subtest: all-busy-check-all
[325.089896] Subtest all-busy-check-all: SUCCESS (0.529s)
[325.186794] [100/141] (696s left) v3d/v3d_submit_cl (simple-flush-cache)
[325.443375] Subtest simple-flush-cache: SKIP (0.000s)
[325.520193] [101/141] (695s left) kms_concurrent (pipe-b)
[325.825315] Starting subtest: pipe-B
[325.829794] Starting dynamic subtest: DP-1
[326.709932] Dynamic subtest DP-1: SUCCESS (0.882s)
[326.711620] Subtest pipe-B: SUCCESS (0.887s)
[327.039804] [102/141] (694s left) kms_psr (basic)
[327.245745] Subtest basic: SKIP (0.000s)
[327.304588] [103/141] (694s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[327.506708] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[327.508416] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.001s)
[327.605772] [104/141] (693s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[327.926698] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[327.929826] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[328.039364] [105/141] (693s left) kms_ccs (pipe-b-missing-ccs-buffer-y_tiled_ccs)
[328.562554] Starting subtest: pipe-B-missing-ccs-buffer-y_tiled_ccs
[328.564321] Subtest pipe-B-missing-ccs-buffer-y_tiled_ccs: SUCCESS (0.001s)
[329.028942] [106/141] (692s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[329.343223] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[329.346225] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[329.445284] [107/141] (692s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[329.745304] Starting subtest: plane-use-after-nonblocking-unbind
[329.746768] Starting dynamic subtest: pipe-A-DP-1
[329.899710] Dynamic subtest pipe-A-DP-1: SUCCESS (0.154s)
[330.037076] Starting dynamic subtest: pipe-B-DP-1
[330.639629] Dynamic subtest pipe-B-DP-1: SUCCESS (0.634s)
[330.741745] Subtest plane-use-after-nonblocking-unbind: SUCCESS (0.998s)
[331.091579] [108/141] (690s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[331.413414] Starting subtest: x-tiled-16bpp-rotate-90
[331.513428] Subtest x-tiled-16bpp-rotate-90: SKIP (0.098s)
[331.641378] [109/141] (690s left) kms_psr (psr2_no_drrs)
[331.847205] Subtest psr2_no_drrs: SKIP (0.000s)
[331.906407] [110/141] (689s left) i915_pm_dc (dc5-dpms)
[333.221443] Starting subtest: dc5-dpms
[334.666713] Subtest dc5-dpms: SUCCESS (1.447s)
[334.873570] [111/141] (686s left) kms_ccs (pipe-d-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc)
[335.534476] Subtest pipe-D-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[335.858950] [112/141] (685s left) syncobj_wait (invalid-reset-one-illegal-handle)
[336.064894] Starting subtest: invalid-reset-one-illegal-handle
[336.066998] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[336.158748] [113/141] (685s left) kms_ccs (pipe-a-crc-primary-rotation-180-y_tiled_ccs)
[336.566445] Starting subtest: pipe-A-crc-primary-rotation-180-y_tiled_ccs
[337.223658] Subtest pipe-A-crc-primary-rotation-180-y_tiled_ccs: SUCCESS (0.657s)
[337.928047] [114/141] (683s left) kms_ccs (pipe-d-ccs-on-another-bo-yf_tiled_ccs)
[338.625174] Subtest pipe-D-ccs-on-another-bo-yf_tiled_ccs: SKIP (0.000s)
[338.948160] [115/141] (682s left) vgem_basic (dmabuf-fence-before)
[339.154218] Starting subtest: dmabuf-fence-before
[339.156161] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[339.231801] [116/141] (682s left) kms_ccs (pipe-b-ccs-on-another-bo-y_tiled_ccs)
[339.779906] Starting subtest: pipe-B-ccs-on-another-bo-y_tiled_ccs
[339.781716] Subtest pipe-B-ccs-on-another-bo-y_tiled_ccs: SUCCESS (0.002s)
[340.239674] [117/141] (681s left) vc4/vc4_perfmon (create-single-perfmon)
[340.496469] Subtest create-single-perfmon: SKIP (0.000s)
[340.572559] [118/141] (681s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[340.795730] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[340.798689] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[341.006415] [119/141] (681s left) gem_exec_capture (capture)
[341.225050] Starting subtest: capture
[341.226667] Starting dynamic subtest: rcs0-smem
[342.515635] Dynamic subtest rcs0-smem: SUCCESS (1.290s)
[342.544637] Starting dynamic subtest: bcs0-smem
[343.799280] Dynamic subtest bcs0-smem: SUCCESS (1.281s)
[343.827988] Starting dynamic subtest: vcs0-smem
[345.086304] Dynamic subtest vcs0-smem: SUCCESS (1.283s)
[345.112406] Starting dynamic subtest: vecs0-smem
[346.366224] Dynamic subtest vecs0-smem: SUCCESS (1.277s)
[346.367725] Subtest capture: SUCCESS (5.143s)
[346.472943] [120/141] (675s left) v3d/v3d_submit_csd (valid-submission)
[346.729453] Subtest valid-submission: SKIP (0.000s)
[346.806136] [121/141] (675s left) syncobj_timeline (reset-unsignaled)
[347.013224] Starting subtest: reset-unsignaled
[347.015461] Subtest reset-unsignaled: SUCCESS (0.000s)
[347.106362] [122/141] (675s left) kms_getfb (getfb-reject-ccs)
[347.311863] Starting subtest: getfb-reject-ccs
[347.313904] Subtest getfb-reject-ccs: SUCCESS (0.000s)
[347.422494] [123/141] (674s left) gem_exec_fence (expired-history)
[348.082969] Starting subtest: expired-history
[353.877233] Subtest expired-history: SUCCESS (5.796s)
[354.509162] [124/141] (667s left) gem_sync (basic-store-each)
[354.744484] Starting subtest: basic-store-each
[357.291181] Subtest basic-store-each: SUCCESS (2.546s)
[357.507964] [125/141] (664s left) gem_exec_flush (basic-uc-pro-default)
[357.737928] Starting subtest: basic-uc-pro-default
[363.205969] Subtest basic-uc-pro-default: SUCCESS (5.468s)
[363.422411] [126/141] (659s left) kms_async_flips (invalid-async-flip)
[363.724190] Starting subtest: invalid-async-flip
[364.150435] Starting dynamic subtest: pipe-A-DP-1
[364.529255] Dynamic subtest pipe-A-DP-1: SUCCESS (0.379s)
[365.072569] Starting dynamic subtest: pipe-B-DP-1
[365.312242] Dynamic subtest pipe-B-DP-1: SUCCESS (0.272s)
[365.706979] Starting dynamic subtest: pipe-C-DP-1
[365.958949] Dynamic subtest pipe-C-DP-1: SUCCESS (0.273s)
[365.961575] Subtest invalid-async-flip: SUCCESS (2.240s)
[366.514518] [127/141] (655s left) i915_pm_rpm (system-suspend-modeset)
[368.316265] Starting subtest: system-suspend-modeset
[385.780927] Subtest system-suspend-modeset: SUCCESS (2.466s)
[389.371910] [128/141] (651s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[389.583570] Starting subtest: legacy-engines-hostile-preempt
[389.585171] Starting dynamic subtest: render
[389.679958] Dynamic subtest render: SUCCESS (0.095s)
[389.710440] Starting dynamic subtest: bsd
[389.775434] Dynamic subtest bsd: SUCCESS (0.091s)
[389.802324] Starting dynamic subtest: blt
[389.866803] Dynamic subtest blt: SUCCESS (0.089s)
[389.895111] Starting dynamic subtest: vebox
[389.955801] Dynamic subtest vebox: SUCCESS (0.085s)
[389.957679] Subtest legacy-engines-hostile-preempt: SUCCESS (0.374s)
[390.064587] [129/141] (650s left) syncobj_timeline (etime-multi-wait-all-submitted)
[390.268433] Starting subtest: etime-multi-wait-all-submitted
[390.376411] Subtest etime-multi-wait-all-submitted: SUCCESS (0.106s)
[390.464153] [130/141] (650s left) kms_force_connector_basic (force-edid)
[390.666633] Subtest force-edid: SKIP (0.000s)
[390.730125] [131/141] (649s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[391.030772] Starting subtest: cursorB-vs-flipB-varying-size
[391.034234] Subtest cursorB-vs-flipB-varying-size: SKIP (0.003s)
[391.131150] [132/141] (649s left) kms_plane_scaling (plane-scaler-with-modifiers-unity-scaling)
[391.433503] Starting subtest: plane-scaler-with-modifiers-unity-scaling
[391.434891] Starting dynamic subtest: pipe-A-DP-1
[392.367220] Dynamic subtest pipe-A-DP-1: SUCCESS (0.932s)
[392.397420] Starting dynamic subtest: pipe-B-DP-1
[393.587454] Dynamic subtest pipe-B-DP-1: SUCCESS (1.215s)
[393.616984] Starting dynamic subtest: pipe-C-DP-1
[394.491805] Dynamic subtest pipe-C-DP-1: SUCCESS (0.900s)
[394.493494] Subtest plane-scaler-with-modifiers-unity-scaling: SUCCESS (3.062s)
[394.896146] [133/141] (645s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[395.205791] Starting subtest: psr-rgb101010-draw-render
[395.208767] Subtest psr-rgb101010-draw-render: SKIP (0.000s)
[395.312442] [134/141] (645s left) api_intel_allocator (gem-pool)
[395.516579] Starting subtest: gem-pool
[395.536259] Subtest gem-pool: SUCCESS (0.019s)
[395.662548] [135/141] (645s left) kms_ccs (pipe-b-bad-pixel-format-y_tiled_ccs)
[396.128433] Starting subtest: pipe-B-bad-pixel-format-y_tiled_ccs
[396.130046] Subtest pipe-B-bad-pixel-format-y_tiled_ccs: SUCCESS (0.001s)
[396.653959] [136/141] (644s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[396.972958] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[396.976060] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[397.086546] [137/141] (643s left) kms_flip (2x-plain-flip-interruptible)
[397.383213] Starting subtest: 2x-plain-flip-interruptible
[397.388697] Subtest 2x-plain-flip-interruptible: SKIP (0.003s)
[397.487326] [138/141] (643s left) gem_exec_schedule (u-submit-golden-slice)
[397.721397] Starting subtest: u-submit-golden-slice
[397.722989] Starting dynamic subtest: rcs0
[397.783085] Dynamic subtest rcs0: SUCCESS (0.059s)
[397.809670] Starting dynamic subtest: bcs0
[397.838718] Dynamic subtest bcs0: SUCCESS (0.054s)
[397.868607] Starting dynamic subtest: vcs0
[397.893930] Dynamic subtest vcs0: SUCCESS (0.052s)
[397.925242] Starting dynamic subtest: vecs0
[397.946337] Dynamic subtest vecs0: SUCCESS (0.050s)
[397.947863] Subtest u-submit-golden-slice: SUCCESS (0.226s)
[398.304070] [139/141] (642s left) gem_ctx_isolation (preservation-reset)
[398.647966] Starting subtest: preservation-reset
[398.649688] Starting dynamic subtest: rcs0
[399.842062] Dynamic subtest rcs0: SUCCESS (1.192s)
[399.867327] Starting dynamic subtest: bcs0
[401.304954] Dynamic subtest bcs0: SUCCESS (1.460s)
[401.330757] Starting dynamic subtest: vcs0
[402.398465] Dynamic subtest vcs0: SUCCESS (1.091s)
[402.422465] Starting dynamic subtest: vecs0
[403.527801] Dynamic subtest vecs0: SUCCESS (1.127s)
[403.530644] Subtest preservation-reset: SUCCESS (4.881s)
[403.670263] [140/141] (637s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[403.875729] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[403.877456] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.001s)
[403.969806] [141/141] (637s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[404.376358] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[404.671087] Closing watchdogs
Done.