[42.440770] Initializing watchdogs
[42.440836]   /dev/watchdog0
[42.446741] [001/141] (960s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc)
[44.470877] Starting subtest: pipe-A-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc
[45.775152] Subtest pipe-A-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc: SUCCESS (1.304s)
[46.053544] [002/141] (956s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[48.005397] Starting subtest: basic-busy-flip-before-cursor-varying-size
[48.007227] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[48.068703] [003/141] (954s left) drm_fdinfo (busy-check-all)
[48.155327] Starting subtest: busy-check-all
[48.156352] Starting dynamic subtest: rcs0
[48.178543] Dynamic subtest rcs0: SKIP (0.022s)
[48.183311] Starting dynamic subtest: bcs0
[48.184893] Dynamic subtest bcs0: SKIP (0.001s)
[48.189136] Starting dynamic subtest: vcs0
[48.190711] Dynamic subtest vcs0: SKIP (0.000s)
[48.194835] Starting dynamic subtest: vcs1
[48.196371] Dynamic subtest vcs1: SKIP (0.000s)
[48.200526] Starting dynamic subtest: vecs0
[48.202050] Dynamic subtest vecs0: SKIP (0.000s)
[48.206275] Starting dynamic subtest: vecs1
[48.207801] Dynamic subtest vecs1: SKIP (0.000s)
[48.211985] Starting dynamic subtest: ccs0
[48.213647] Dynamic subtest ccs0: SKIP (0.000s)
[48.217806] Starting dynamic subtest: ccs1
[48.219367] Dynamic subtest ccs1: SKIP (0.000s)
[48.224759] Starting dynamic subtest: ccs2
[48.226330] Dynamic subtest ccs2: SKIP (0.000s)
[48.230496] Starting dynamic subtest: ccs3
[48.232496] Dynamic subtest ccs3: SKIP (0.000s)
[48.234552] Subtest busy-check-all: SKIP (0.026s)
[48.242469] [004/141] (954s left) syncobj_wait (wait-for-submit-snapshot)
[48.331981] Starting subtest: wait-for-submit-snapshot
[48.414848] Subtest wait-for-submit-snapshot: SUCCESS (0.083s)
[48.484859] [005/141] (954s left) kms_busy (basic)
[50.445146] Starting subtest: basic
[50.445954] Starting dynamic subtest: flip
[51.030322] Dynamic subtest flip: SUCCESS (0.583s)
[51.035099] Starting dynamic subtest: modeset
[51.582398] Dynamic subtest modeset: SUCCESS (0.552s)
[51.583343] Subtest basic: SUCCESS (1.136s)
[51.719873] [006/141] (951s left) i915_pm_freq_api (freq-basic-api)
[51.784065] Starting subtest: freq-basic-api
[51.784994] Starting dynamic subtest: gt0
[51.786881] Dynamic subtest gt0: SUCCESS (0.002s)
[51.787726] Subtest freq-basic-api: SUCCESS (0.002s)
[51.835515] [007/141] (951s left) kms_plane_alpha_blend (constant-alpha-min)
[53.788142] Starting subtest: constant-alpha-min
[53.978363] Starting dynamic subtest: pipe-A-HDMI-A-3
[54.628116] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.649s)
[54.632785] Starting dynamic subtest: pipe-D-HDMI-A-3
[55.272061] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.643s)
[55.272865] Subtest constant-alpha-min: SUCCESS (1.485s)
[55.406152] [008/141] (947s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[57.365356] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[57.366921] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[57.439449] [009/141] (945s left) kms_chamelium_color (ctm-negative)
[59.415562] Subtest ctm-negative: SKIP (0.000s)
[59.432416] [010/141] (943s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[61.391704] Starting subtest: yf-tiled-addfb-size-overflow
[61.393300] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[61.473931] [011/141] (941s left) gem_ctx_bad_destroy (invalid-ctx)
[61.577022] Starting subtest: invalid-ctx
[61.577896] Subtest invalid-ctx: SUCCESS (0.000s)
[61.641978] [012/141] (941s left) gem_exec_flush (basic-batch-kernel-default-wb)
[61.743271] Subtest basic-batch-kernel-default-wb: SKIP (0.000s)
[61.782951] [013/141] (941s left) kms_plane_scaling (planes-downscale-factor-0-25-unity-scaling)
[63.746055] Starting subtest: planes-downscale-factor-0-25-unity-scaling
[63.746861] Starting dynamic subtest: pipe-A-HDMI-A-3
[63.759932] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.012s)
[63.764742] Starting dynamic subtest: pipe-B-HDMI-A-3
[63.784926] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.024s)
[63.789506] Starting dynamic subtest: pipe-C-HDMI-A-3
[63.809967] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.024s)
[63.814556] Starting dynamic subtest: pipe-D-HDMI-A-3
[63.833606] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.023s)
[63.835102] Subtest planes-downscale-factor-0-25-unity-scaling: SKIP (0.086s)
[63.905506] [014/141] (939s left) gem_exec_reloc (basic-cpu-gtt)
[63.969165] Subtest basic-cpu-gtt: SKIP (0.000s)
[64.015894] [015/141] (939s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[65.975180] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[65.976897] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[66.039575] [016/141] (937s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[68.006726] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[68.008254] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[68.089803] [017/141] (935s left) perf (per-context-mode-unprivileged)
[68.465982] Starting subtest: per-context-mode-unprivileged
[68.467579] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[68.486988] [018/141] (934s left) prime_busy (after-wait)
[68.549212] Starting subtest: after-wait
[68.553042] Starting dynamic subtest: rcs0
[68.590132] Dynamic subtest rcs0: SUCCESS (0.037s)
[68.594974] Starting dynamic subtest: bcs0
[68.628244] Dynamic subtest bcs0: SUCCESS (0.038s)
[68.632876] Starting dynamic subtest: vcs0
[68.666767] Dynamic subtest vcs0: SUCCESS (0.038s)
[68.671378] Starting dynamic subtest: vcs1
[68.704516] Dynamic subtest vcs1: SUCCESS (0.038s)
[68.709165] Starting dynamic subtest: vecs0
[68.742504] Dynamic subtest vecs0: SUCCESS (0.038s)
[68.747207] Starting dynamic subtest: vecs1
[68.780648] Dynamic subtest vecs1: SUCCESS (0.038s)
[68.785364] Starting dynamic subtest: ccs0
[68.819378] Dynamic subtest ccs0: SUCCESS (0.039s)
[68.823920] Starting dynamic subtest: ccs1
[68.859146] Dynamic subtest ccs1: SUCCESS (0.040s)
[68.863703] Starting dynamic subtest: ccs2
[68.897516] Dynamic subtest ccs2: SUCCESS (0.038s)
[68.902136] Starting dynamic subtest: ccs3
[68.935490] Dynamic subtest ccs3: SUCCESS (0.038s)
[69.038968] Subtest after-wait: SUCCESS (0.490s)
[69.139687] [019/141] (934s left) gem_mmap_offset (bad-flags)
[69.197642] Starting subtest: bad-flags
[69.198587] Subtest bad-flags: SUCCESS (0.000s)
[69.277885] [020/141] (933s left) gem_busy (busy)
[69.351080] Starting subtest: busy
[69.351925] Starting dynamic subtest: all-engines
[69.451203] Dynamic subtest all-engines: SUCCESS (0.100s)
[69.456187] Starting dynamic subtest: rcs0
[69.527965] Dynamic subtest rcs0: SUCCESS (0.077s)
[69.533208] Starting dynamic subtest: bcs0
[69.570127] Dynamic subtest bcs0: SUCCESS (0.042s)
[69.576967] Starting dynamic subtest: vcs0
[69.611281] Dynamic subtest vcs0: SUCCESS (0.041s)
[69.627772] Starting dynamic subtest: vcs1
[69.652204] Dynamic subtest vcs1: SUCCESS (0.041s)
[69.668648] Starting dynamic subtest: vecs0
[69.693926] Dynamic subtest vecs0: SUCCESS (0.041s)
[69.710547] Starting dynamic subtest: vecs1
[69.736488] Dynamic subtest vecs1: SUCCESS (0.042s)
[69.752665] Starting dynamic subtest: ccs0
[69.779601] Dynamic subtest ccs0: SUCCESS (0.043s)
[69.796087] Starting dynamic subtest: ccs1
[69.822446] Dynamic subtest ccs1: SUCCESS (0.043s)
[69.838606] Starting dynamic subtest: ccs2
[69.864492] Dynamic subtest ccs2: SUCCESS (0.042s)
[69.880676] Starting dynamic subtest: ccs3
[69.905926] Dynamic subtest ccs3: SUCCESS (0.041s)
[69.907506] Subtest busy: SUCCESS (0.554s)
[70.275630] [021/141] (932s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[71.291951] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[71.297530] Starting dynamic subtest: A-HDMI-A3
[72.067677] Dynamic subtest A-HDMI-A3: SUCCESS (0.770s)
[72.072666] Starting dynamic subtest: B-HDMI-A3
[72.728156] Dynamic subtest B-HDMI-A3: SUCCESS (0.660s)
[72.733309] Starting dynamic subtest: C-HDMI-A3
[73.383271] Dynamic subtest C-HDMI-A3: SUCCESS (0.655s)
[73.388326] Starting dynamic subtest: D-HDMI-A3
[74.044497] Dynamic subtest D-HDMI-A3: SUCCESS (0.661s)
[74.045380] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (2.753s)
[74.178264] [022/141] (929s left) kms_ccs (pipe-b-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs)
[76.232819] Starting subtest: pipe-B-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs
[76.235436] Subtest pipe-B-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs: SKIP (0.002s)
[76.391768] [023/141] (926s left) kms_psr (psr2_sprite_mmap_gtt)
[76.451364] Subtest psr2_sprite_mmap_gtt: SKIP (0.000s)
[76.467367] [024/141] (926s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[78.428463] Starting subtest: yf-tiled-64bpp-rotate-0
[78.430269] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[78.507453] [025/141] (924s left) kms_vblank (pipe-c-query-forked-busy-hang)
[80.457448] Starting subtest: pipe-C-query-forked-busy-hang
[95.031854] Subtest pipe-C-query-forked-busy-hang: SUCCESS (14.574s)
[95.149290] [026/141] (908s left) gem_exec_suspend (basic-s0)
[95.217114] Starting subtest: basic-S0
[95.217899] Starting dynamic subtest: smem
[115.762108] Dynamic subtest smem: SUCCESS (6.505s)
[115.768043] Starting dynamic subtest: lmem0
[136.815944] Dynamic subtest lmem0: SUCCESS (6.205s)
[136.817299] Subtest basic-S0: SUCCESS (12.712s)
[140.056435] [027/141] (895s left) kms_vblank (pipe-b-ts-continuation-modeset-hang)
[142.005569] Starting subtest: pipe-B-ts-continuation-modeset-hang
[155.908210] Subtest pipe-B-ts-continuation-modeset-hang: SUCCESS (13.903s)
[156.030117] [028/141] (879s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[157.989050] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[157.990743] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[158.061571] [029/141] (877s left) gem_softpin (overlap)
[158.160801] Starting subtest: overlap
[160.464861] Subtest overlap: SUCCESS (2.270s)
[160.534672] [030/141] (874s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[162.505944] Starting subtest: y-tiled-8bpp-rotate-90
[162.507772] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[162.579043] [031/141] (872s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[164.594185] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[167.182272] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (2.590s)
[167.303333] [032/141] (867s left) kms_content_protection (dp-mst-type-1)
[169.305708] Starting subtest: dp-mst-type-1
[169.307524] Subtest dp-mst-type-1: SKIP (0.000s)
[169.422712] [033/141] (865s left) api_intel_bb (blit-reloc-purge-cache)
[169.546261] Starting subtest: blit-reloc-purge-cache
[169.548258] Subtest blit-reloc-purge-cache: SKIP (0.000s)
[169.654996] [034/141] (865s left) gem_ctx_param (invalid-ctx-get)
[169.750574] Starting subtest: invalid-ctx-get
[169.751473] Subtest invalid-ctx-get: SUCCESS (0.000s)
[169.812836] [035/141] (865s left) kms_ccs (pipe-c-ccs-on-another-bo-y_tiled_ccs)
[171.908610] Starting subtest: pipe-C-ccs-on-another-bo-y_tiled_ccs
[171.910280] Subtest pipe-C-ccs-on-another-bo-y_tiled_ccs: SKIP (0.000s)
[172.046647] [036/141] (863s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[174.007682] Starting subtest: 4-tiled-16bpp-rotate-270
[174.060722] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.053s)
[174.173049] [037/141] (861s left) syncobj_wait (wait-for-submit-delayed-submit)
[174.282121] Starting subtest: wait-for-submit-delayed-submit
[174.382441] Subtest wait-for-submit-delayed-submit: SUCCESS (0.101s)
[174.471278] [038/141] (860s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[176.437957] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[176.439502] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[176.524989] [039/141] (858s left) gem_render_copy (yf-tiled-to-vebox-linear)
[176.633810] Starting subtest: yf-tiled-to-vebox-linear
[176.636178] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[176.835443] [040/141] (858s left) gem_exec_schedule (implicit-boths)
[176.937641] Starting subtest: implicit-boths
[176.938460] Starting dynamic subtest: rcs0
[177.213897] Dynamic subtest rcs0: SUCCESS (0.267s)
[177.219618] Starting dynamic subtest: bcs0
[177.395383] Dynamic subtest bcs0: SUCCESS (0.184s)
[177.401342] Starting dynamic subtest: vcs0
[177.593652] Dynamic subtest vcs0: SUCCESS (0.195s)
[177.599515] Starting dynamic subtest: vcs1
[177.788302] Dynamic subtest vcs1: SUCCESS (0.194s)
[177.794311] Starting dynamic subtest: vecs0
[177.983467] Dynamic subtest vecs0: SUCCESS (0.195s)
[177.989358] Starting dynamic subtest: vecs1
[178.182651] Dynamic subtest vecs1: SUCCESS (0.199s)
[178.188761] Starting dynamic subtest: ccs0
[178.426686] Dynamic subtest ccs0: SUCCESS (0.243s)
[178.432515] Starting dynamic subtest: ccs1
[178.618262] Dynamic subtest ccs1: SUCCESS (0.191s)
[178.624143] Starting dynamic subtest: ccs2
[178.809016] Dynamic subtest ccs2: SUCCESS (0.190s)
[178.815211] Starting dynamic subtest: ccs3
[179.000800] Dynamic subtest ccs3: SUCCESS (0.191s)
[179.001734] Subtest implicit-boths: SUCCESS (2.055s)
[179.342748] [041/141] (856s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[181.312727] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[181.314309] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[181.410925] [042/141] (854s left) kms_big_fb (linear-32bpp-rotate-90)
[183.434921] Starting subtest: linear-32bpp-rotate-90
[183.477709] Subtest linear-32bpp-rotate-90: SKIP (0.042s)
[183.588607] [043/141] (851s left) dmabuf_sync_file (export-before-signal)
[183.760708] Starting subtest: export-before-signal
[183.761632] Subtest export-before-signal: SUCCESS (0.001s)
[183.814728] [044/141] (851s left) syncobj_wait (multi-wait-for-submit-submitted)
[183.893740] Starting subtest: multi-wait-for-submit-submitted
[183.994866] Subtest multi-wait-for-submit-submitted: SUCCESS (0.102s)
[184.073742] [045/141] (851s left) gem_spin_batch (legacy-resubmit-new)
[184.140974] Starting subtest: legacy-resubmit-new
[184.141925] Starting dynamic subtest: default
[184.165126] Dynamic subtest default: SUCCESS (0.024s)
[184.171278] Starting dynamic subtest: render
[184.172164] Dynamic subtest render: SUCCESS (0.002s)
[184.178229] Starting dynamic subtest: bsd
[184.179047] Dynamic subtest bsd: SUCCESS (0.003s)
[184.185213] Starting dynamic subtest: bsd1
[184.186004] Dynamic subtest bsd1: SUCCESS (0.003s)
[184.191793] Starting dynamic subtest: bsd2
[184.192597] Dynamic subtest bsd2: SUCCESS (0.002s)
[184.198335] Starting dynamic subtest: blt
[184.199221] Dynamic subtest blt: SUCCESS (0.004s)
[184.204984] Starting dynamic subtest: vebox
[184.205775] Dynamic subtest vebox: SUCCESS (0.005s)
[184.206567] Subtest legacy-resubmit-new: SUCCESS (0.048s)
[184.413820] [046/141] (851s left) perf_pmu (busy-double-start)
[184.477751] Starting subtest: busy-double-start
[184.478582] Starting dynamic subtest: rcs0
[188.072501] Dynamic subtest rcs0: SUCCESS (3.593s)
[188.083762] Starting dynamic subtest: bcs0
[191.641691] Dynamic subtest bcs0: SUCCESS (3.568s)
[191.650583] Starting dynamic subtest: vcs0
[195.237955] Dynamic subtest vcs0: FAIL (3.572s)
[195.246890] Starting dynamic subtest: vcs1
[198.801445] Dynamic subtest vcs1: FAIL (3.560s)
[198.809894] Starting dynamic subtest: vecs0
[202.363189] Dynamic subtest vecs0: FAIL (3.560s)
[202.371770] Starting dynamic subtest: vecs1
[205.922436] Dynamic subtest vecs1: FAIL (3.560s)
[205.930900] Starting dynamic subtest: ccs0
[209.476591] Dynamic subtest ccs0: SUCCESS (3.579s)
[209.487041] Starting dynamic subtest: ccs1
[213.064490] Dynamic subtest ccs1: SUCCESS (3.586s)
[213.075025] Starting dynamic subtest: ccs2
[216.652789] Dynamic subtest ccs2: SUCCESS (3.586s)
[216.661617] Starting dynamic subtest: ccs3
[220.238812] Dynamic subtest ccs3: SUCCESS (3.584s)
[220.240767] Subtest busy-double-start: FAIL (35.761s)
[220.325073] [047/141] (815s left) gen7_exec_parse (chained-batch)
[220.388735] Subtest chained-batch: SKIP (0.000s)
[220.418831] [048/141] (815s left) kms_universal_plane (universal-plane-pageflip-windowed-pipe-d)
[222.379481] Starting subtest: universal-plane-pageflip-windowed-pipe-D
[223.083583] Subtest universal-plane-pageflip-windowed-pipe-D: SUCCESS (0.705s)
[223.222078] [049/141] (812s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[225.184167] Starting subtest: fbc-rgb565-draw-render
[227.758735] Subtest fbc-rgb565-draw-render: SUCCESS (2.576s)
[227.873112] [050/141] (807s left) gem_userptr_blits (readonly-unsync)
[227.942905] Subtest readonly-unsync: SKIP (0.000s)
[228.075125] [051/141] (807s left) kms_psr (sprite_mmap_cpu)
[228.144614] Subtest sprite_mmap_cpu: SKIP (0.000s)
[228.165880] [052/141] (807s left) gem_mmap_gtt (fault-concurrent-x)
[228.228384] Subtest fault-concurrent-X: SKIP (0.000s)
[228.270751] [053/141] (807s left) kms_vrr (flip-suspend)
[230.259405] Starting subtest: flip-suspend
[230.261035] Subtest flip-suspend: SKIP (0.000s)
[230.321842] [054/141] (805s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[232.297724] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[232.298639] Starting dynamic subtest: pipe-A-valid-mode
[233.407603] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.108s)
[233.408619] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (1.109s)
[233.552648] [055/141] (802s left) kms_hdr (bpc-switch)
[235.512637] Starting subtest: bpc-switch
[235.514378] Subtest bpc-switch: SKIP (0.000s)
[235.568197] [056/141] (800s left) kms_flip (2x-blocking-wf_vblank)
[236.595552] Starting subtest: 2x-blocking-wf_vblank
[236.609913] Subtest 2x-blocking-wf_vblank: SKIP (0.015s)
[236.668054] [057/141] (799s left) gem_pxp (hw-rejects-pxp-buffer)
[239.316222] Starting subtest: hw-rejects-pxp-buffer
[239.317616] Subtest hw-rejects-pxp-buffer: SUCCESS (0.000s)
[239.387092] [058/141] (796s left) gem_exec_schedule (preempt-user)
[239.457770] Starting subtest: preempt-user
[239.458720] Starting dynamic subtest: rcs0
[239.514753] Dynamic subtest rcs0: SUCCESS (0.057s)
[239.521195] Starting dynamic subtest: bcs0
[239.543796] Dynamic subtest bcs0: SUCCESS (0.029s)
[239.550195] Starting dynamic subtest: vcs0
[239.574097] Dynamic subtest vcs0: SUCCESS (0.030s)
[239.580906] Starting dynamic subtest: vcs1
[239.610776] Dynamic subtest vcs1: SUCCESS (0.036s)
[239.617568] Starting dynamic subtest: vecs0
[239.639603] Dynamic subtest vecs0: SUCCESS (0.028s)
[239.645852] Starting dynamic subtest: vecs1
[239.668443] Dynamic subtest vecs1: SUCCESS (0.028s)
[239.674863] Starting dynamic subtest: ccs0
[239.698891] Dynamic subtest ccs0: SUCCESS (0.030s)
[239.705536] Starting dynamic subtest: ccs1
[239.728530] Dynamic subtest ccs1: SUCCESS (0.029s)
[239.735104] Starting dynamic subtest: ccs2
[239.757785] Dynamic subtest ccs2: SUCCESS (0.029s)
[239.764565] Starting dynamic subtest: ccs3
[239.786580] Dynamic subtest ccs3: SUCCESS (0.028s)
[239.787455] Subtest preempt-user: SUCCESS (0.329s)
[240.156307] [059/141] (795s left) gem_exec_params (no-bsd)
[240.231123] Starting subtest: no-bsd
[240.233273] Subtest no-bsd: SUCCESS (0.001s)
[240.335468] [060/141] (795s left) gem_request_retire (retire-vma-not-inactive)
[240.433061] Starting subtest: retire-vma-not-inactive
[240.509901] Subtest retire-vma-not-inactive: SUCCESS (0.077s)
[240.655184] [061/141] (795s left) i915_pm_rpm (gem-idle)
[245.401941] Starting subtest: gem-idle
[252.736480] Subtest gem-idle: SUCCESS (7.335s)
[253.770644] [062/141] (782s left) kms_flip (flip-vs-expired-vblank-interruptible)
[254.799852] Starting subtest: flip-vs-expired-vblank-interruptible
[254.806629] Starting dynamic subtest: A-HDMI-A3
[262.519000] Dynamic subtest A-HDMI-A3: SUCCESS (7.712s)
[262.527423] Starting dynamic subtest: B-HDMI-A3
[270.167133] Dynamic subtest B-HDMI-A3: SUCCESS (7.647s)
[270.174276] Starting dynamic subtest: C-HDMI-A3
[277.816023] Dynamic subtest C-HDMI-A3: SUCCESS (7.648s)
[277.823518] Starting dynamic subtest: D-HDMI-A3
[285.461224] Dynamic subtest D-HDMI-A3: SUCCESS (7.644s)
[285.462062] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (30.662s)
[285.616643] [063/141] (750s left) gem_eio (in-flight-contexts-immediate)
[285.892150] Starting subtest: in-flight-contexts-immediate
[299.310067] Subtest in-flight-contexts-immediate: SUCCESS (13.418s)
[301.266879] [064/141] (734s left) gem_exec_fence (syncobj-export)
[302.126802] Starting subtest: syncobj-export
[302.153139] Subtest syncobj-export: SUCCESS (0.027s)
[302.548244] [065/141] (733s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[304.505869] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[304.507476] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[304.584659] [066/141] (731s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[306.583439] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[306.585201] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[306.650765] [067/141] (729s left) syncobj_wait (signal)
[306.735267] Starting subtest: signal
[306.736402] Subtest signal: SUCCESS (0.000s)
[306.830923] [068/141] (729s left) gen9_exec_parse (unaligned-jump)
[306.926154] Subtest unaligned-jump: SKIP (0.000s)
[306.944282] [069/141] (729s left) kms_ccs (pipe-c-random-ccs-data-4_tiled_dg2_rc_ccs_cc)
[309.021768] Starting subtest: pipe-C-random-ccs-data-4_tiled_dg2_rc_ccs_cc
[309.136269] Subtest pipe-C-random-ccs-data-4_tiled_dg2_rc_ccs_cc: SUCCESS (0.115s)
[309.291226] [070/141] (726s left) dumb_buffer (create-valid-dumb)
[309.350919] Starting subtest: create-valid-dumb
[309.351747] Subtest create-valid-dumb: SUCCESS (0.000s)
[309.441146] [071/141] (726s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[311.400915] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[311.402760] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[311.475280] [072/141] (724s left) v3d/v3d_perfmon (destroy-invalid-perfmon)
[311.592872] Subtest destroy-invalid-perfmon: SKIP (0.000s)
[311.646619] [073/141] (724s left) gem_ctx_persistence (smoketest)
[311.725878] Starting subtest: smoketest
[343.064435] Subtest smoketest: SUCCESS (31.330s)
[343.165604] [074/141] (693s left) kms_invalid_mode (bad-hsync-start)
[345.151653] Starting subtest: bad-hsync-start
[345.152604] Starting dynamic subtest: HDMI-A-3-pipe-A
[345.204907] Dynamic subtest HDMI-A-3-pipe-A: SUCCESS (0.053s)
[345.213916] Starting dynamic subtest: HDMI-A-3-pipe-B
[345.214819] Dynamic subtest HDMI-A-3-pipe-B: SUCCESS (0.007s)
[345.222782] Starting dynamic subtest: HDMI-A-3-pipe-C
[345.223612] Dynamic subtest HDMI-A-3-pipe-C: SUCCESS (0.007s)
[345.231856] Starting dynamic subtest: HDMI-A-3-pipe-D
[345.232698] Dynamic subtest HDMI-A-3-pipe-D: SUCCESS (0.007s)
[345.233501] Subtest bad-hsync-start: SUCCESS (0.080s)
[345.339111] [075/141] (690s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[345.398890] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[345.506786] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.108s)
[345.608328] [076/141] (690s left) kms_plane_scaling (plane-upscale-with-rotation-20x20)
[347.572481] Starting subtest: plane-upscale-with-rotation-20x20
[347.573481] Starting dynamic subtest: pipe-A-HDMI-A-3
[347.939531] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.367s)
[347.948557] Starting dynamic subtest: pipe-B-HDMI-A-3
[348.312347] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.371s)
[348.321643] Starting dynamic subtest: pipe-C-HDMI-A-3
[348.686496] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.373s)
[348.695918] Starting dynamic subtest: pipe-D-HDMI-A-3
[349.059923] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.372s)
[349.060879] Subtest plane-upscale-with-rotation-20x20: SUCCESS (1.489s)
[349.248670] [077/141] (687s left) kms_ccs (pipe-c-missing-ccs-buffer-y_tiled_ccs)
[351.336836] Starting subtest: pipe-C-missing-ccs-buffer-y_tiled_ccs
[351.338532] Subtest pipe-C-missing-ccs-buffer-y_tiled_ccs: SKIP (0.000s)
[351.474485] [078/141] (684s left) kms_ccs (pipe-a-bad-rotation-90-4_tiled_mtl_rc_ccs)
[353.465772] Starting subtest: pipe-A-bad-rotation-90-4_tiled_mtl_rc_ccs
[353.467543] Subtest pipe-A-bad-rotation-90-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[353.685423] [079/141] (682s left) kms_vblank (pipe-b-wait-forked)
[355.642646] Starting subtest: pipe-B-wait-forked
[358.000382] Subtest pipe-B-wait-forked: SUCCESS (2.358s)
[358.100115] [080/141] (678s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[360.056476] Starting subtest: sprite-rotation-90-pos-100-0
[360.058222] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[360.115992] [081/141] (676s left) kms_chamelium_hpd (vga-hpd-fast)
[362.126047] Subtest vga-hpd-fast: SKIP (0.000s)
[362.181690] [082/141] (674s left) kms_display_modes (extended-mode-basic)
[364.138804] Starting subtest: extended-mode-basic
[364.140887] Subtest extended-mode-basic: SKIP (0.000s)
[364.163085] [083/141] (672s left) gem_exec_balancer (bonded-sync)
[364.235947] Starting subtest: bonded-sync
[364.237751] Subtest bonded-sync: SKIP (0.000s)
[364.553746] [084/141] (671s left) syncobj_timeline (invalid-wait-bad-flags)
[364.619900] Starting subtest: invalid-wait-bad-flags
[364.620807] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[364.690332] [085/141] (671s left) gem_mmap_wc (read)
[364.762293] Subtest read: SKIP (0.000s)
[364.779297] [086/141] (671s left) kms_flip (wf_vblank-ts-check)
[365.794682] Starting subtest: wf_vblank-ts-check
[365.801213] Starting dynamic subtest: A-HDMI-A3
[373.818649] Dynamic subtest A-HDMI-A3: SUCCESS (8.017s)
[373.827575] Starting dynamic subtest: B-HDMI-A3
[381.766430] Dynamic subtest B-HDMI-A3: SUCCESS (7.947s)
[381.774429] Starting dynamic subtest: C-HDMI-A3
[389.736623] Dynamic subtest C-HDMI-A3: SUCCESS (7.946s)
[389.745181] Starting dynamic subtest: D-HDMI-A3
[397.658569] Dynamic subtest D-HDMI-A3: SUCCESS (7.944s)
[397.659531] Subtest wf_vblank-ts-check: SUCCESS (31.865s)
[397.799267] [087/141] (638s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[399.755551] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[399.756478] Starting dynamic subtest: pipe-A-valid-mode
[399.805557] Dynamic subtest pipe-A-valid-mode: SKIP (0.050s)
[399.807296] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.051s)
[399.895094] [088/141] (636s left) kms_ccs (pipe-c-bad-rotation-90-yf_tiled_ccs)
[401.971721] Starting subtest: pipe-C-bad-rotation-90-yf_tiled_ccs
[401.973409] Subtest pipe-C-bad-rotation-90-yf_tiled_ccs: SKIP (0.000s)
[402.123748] [089/141] (634s left) sysfs_preempt_timeout (invalid)
[402.187588] Starting subtest: invalid
[402.188457] Starting dynamic subtest: ccs2
[402.189262] Dynamic subtest ccs2: SUCCESS (0.000s)
[402.196794] Starting dynamic subtest: vecs0
[402.197607] Dynamic subtest vecs0: SUCCESS (0.000s)
[402.205105] Starting dynamic subtest: ccs0
[402.205966] Dynamic subtest ccs0: SUCCESS (0.000s)
[402.213297] Starting dynamic subtest: vcs0
[402.214092] Dynamic subtest vcs0: SUCCESS (0.000s)
[402.221409] Starting dynamic subtest: bcs0
[402.222201] Dynamic subtest bcs0: SUCCESS (0.000s)
[402.229672] Starting dynamic subtest: ccs3
[402.230468] Dynamic subtest ccs3: SUCCESS (0.000s)
[402.237908] Starting dynamic subtest: vecs1
[402.238704] Dynamic subtest vecs1: SUCCESS (0.000s)
[402.247431] Starting dynamic subtest: ccs1
[402.248228] Dynamic subtest ccs1: SUCCESS (0.000s)
[402.255526] Starting dynamic subtest: rcs0
[402.256320] Dynamic subtest rcs0: SUCCESS (0.000s)
[402.263642] Starting dynamic subtest: vcs1
[402.264423] Dynamic subtest vcs1: SUCCESS (0.000s)
[402.265340] Subtest invalid: SUCCESS (0.009s)
[402.278818] [090/141] (634s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[404.242620] Starting subtest: nonblocking-crc-frame-sequence
[404.244723] Starting dynamic subtest: pipe-A-HDMI-A-3
[404.914686] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.668s)
[404.922875] Starting dynamic subtest: pipe-B-HDMI-A-3
[405.478602] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.564s)
[405.488263] Starting dynamic subtest: pipe-C-HDMI-A-3
[406.087784] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.608s)
[406.097833] Starting dynamic subtest: pipe-D-HDMI-A-3
[406.760665] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.670s)
[406.761487] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.520s)
[406.885487] [091/141] (629s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[406.945112] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[406.945978] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[407.002543] [092/141] (629s left) kms_ccs (pipe-d-random-ccs-data-4_tiled_dg2_rc_ccs_cc)
[409.124828] Starting subtest: pipe-D-random-ccs-data-4_tiled_dg2_rc_ccs_cc
[409.238456] Subtest pipe-D-random-ccs-data-4_tiled_dg2_rc_ccs_cc: SUCCESS (0.114s)
[409.380516] [093/141] (627s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[411.503755] Starting subtest: cursor-rapid-movement-512x512
[411.506837] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[411.692917] [094/141] (624s left) gem_reg_read (timestamp-moving)
[411.787603] Starting subtest: timestamp-moving
[412.797058] Subtest timestamp-moving: SUCCESS (1.001s)
[412.850915] [095/141] (623s left) kms_cursor_crc (cursor-offscreen-512x512)
[414.969639] Starting subtest: cursor-offscreen-512x512
[414.972466] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[415.174791] [096/141] (621s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[417.161158] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[417.162800] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[417.249080] [097/141] (619s left) gem_lmem_swapping (parallel-random)
[421.634585] Starting subtest: parallel-random
[421.635358] Starting dynamic subtest: lmem0
[422.304735] Dynamic subtest lmem0: SUCCESS (0.670s)
[422.305507] Subtest parallel-random: SUCCESS (0.671s)
[423.827561] [098/141] (612s left) gem_gtt_cpu_tlb
[427.188261] [099/141] (609s left) perf_pmu (all-busy-check-all)
[427.261025] Starting subtest: all-busy-check-all
[427.847196] Subtest all-busy-check-all: SUCCESS (0.586s)
[427.920353] [100/141] (608s left) v3d/v3d_submit_cl (simple-flush-cache)
[428.013474] Subtest simple-flush-cache: SKIP (0.000s)
[428.063559] [101/141] (608s left) kms_concurrent (pipe-b)
[430.033723] Starting subtest: pipe-B
[430.035851] Starting dynamic subtest: HDMI-A-3
[430.314503] Dynamic subtest HDMI-A-3: SUCCESS (0.279s)
[430.315521] Subtest pipe-B: SUCCESS (0.280s)
[430.447770] [102/141] (606s left) kms_psr (basic)
[430.508673] Subtest basic: SKIP (0.000s)
[430.540605] [103/141] (606s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[430.600689] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[430.601585] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[430.663470] [104/141] (606s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[432.647772] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[433.849781] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.202s)
[433.971521] [105/141] (602s left) kms_ccs (pipe-b-missing-ccs-buffer-y_tiled_ccs)
[436.039945] Starting subtest: pipe-B-missing-ccs-buffer-y_tiled_ccs
[436.041776] Subtest pipe-B-missing-ccs-buffer-y_tiled_ccs: SKIP (0.000s)
[436.212155] [106/141] (600s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[438.166667] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[438.168320] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[438.246588] [107/141] (598s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[440.241779] Starting subtest: plane-use-after-nonblocking-unbind
[440.244468] Starting dynamic subtest: pipe-A-HDMI-A-3
[440.330145] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.087s)
[440.375488] Starting dynamic subtest: pipe-B-HDMI-A-3
[440.516477] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.147s)
[440.539582] Subtest plane-use-after-nonblocking-unbind: SUCCESS (0.298s)
[440.644977] [108/141] (596s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[442.606730] Starting subtest: x-tiled-16bpp-rotate-90
[442.664822] Subtest x-tiled-16bpp-rotate-90: SKIP (0.057s)
[442.785227] [109/141] (594s left) kms_psr (psr2_no_drrs)
[442.897666] Subtest psr2_no_drrs: SKIP (0.000s)
[442.921910] [110/141] (593s left) i915_pm_dc (dc5-dpms)
[445.867655] Starting subtest: dc5-dpms
[447.005828] Subtest dc5-dpms: SUCCESS (1.129s)
[447.156312] [111/141] (589s left) kms_ccs (pipe-d-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc)
[449.273699] Starting subtest: pipe-D-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc
[449.275497] Subtest pipe-D-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[449.384485] [112/141] (587s left) syncobj_wait (invalid-reset-one-illegal-handle)
[449.444985] Starting subtest: invalid-reset-one-illegal-handle
[449.445895] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[449.500272] [113/141] (587s left) kms_ccs (pipe-a-crc-primary-rotation-180-y_tiled_ccs)
[451.502879] Starting subtest: pipe-A-crc-primary-rotation-180-y_tiled_ccs
[451.504537] Subtest pipe-A-crc-primary-rotation-180-y_tiled_ccs: SKIP (0.000s)
[451.716580] [114/141] (585s left) kms_ccs (pipe-d-ccs-on-another-bo-yf_tiled_ccs)
[453.846831] Starting subtest: pipe-D-ccs-on-another-bo-yf_tiled_ccs
[453.848522] Subtest pipe-D-ccs-on-another-bo-yf_tiled_ccs: SKIP (0.000s)
[453.945489] [115/141] (582s left) vgem_basic (dmabuf-fence-before)
[454.014141] Starting subtest: dmabuf-fence-before
[454.015071] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[454.061839] [116/141] (582s left) kms_ccs (pipe-b-ccs-on-another-bo-y_tiled_ccs)
[456.108825] Starting subtest: pipe-B-ccs-on-another-bo-y_tiled_ccs
[456.110600] Subtest pipe-B-ccs-on-another-bo-y_tiled_ccs: SKIP (0.000s)
[456.274064] [117/141] (580s left) vc4/vc4_perfmon (create-single-perfmon)
[456.359628] Subtest create-single-perfmon: SKIP (0.000s)
[456.407535] [118/141] (580s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[456.472566] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[456.474543] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[456.644284] [119/141] (580s left) gem_exec_capture (capture)
[456.714899] Starting subtest: capture
[456.715855] Starting dynamic subtest: rcs0-smem
[457.657813] Dynamic subtest rcs0-smem: SUCCESS (0.937s)
[457.664425] Starting dynamic subtest: rcs0-lmem0
[458.567972] Dynamic subtest rcs0-lmem0: SUCCESS (0.909s)
[458.574478] Starting dynamic subtest: bcs0-smem
[459.464939] Dynamic subtest bcs0-smem: SUCCESS (0.896s)
[459.471486] Starting dynamic subtest: bcs0-lmem0
[460.355383] Dynamic subtest bcs0-lmem0: SUCCESS (0.890s)
[460.361875] Starting dynamic subtest: vcs0-smem
[461.244527] Dynamic subtest vcs0-smem: SUCCESS (0.888s)
[461.251163] Starting dynamic subtest: vcs0-lmem0
[462.134176] Dynamic subtest vcs0-lmem0: SUCCESS (0.889s)
[462.140707] Starting dynamic subtest: vcs1-smem
[463.528509] Dynamic subtest vcs1-smem: SUCCESS (1.394s)
[463.535076] Starting dynamic subtest: vcs1-lmem0
[464.612935] Dynamic subtest vcs1-lmem0: SUCCESS (1.084s)
[464.619565] Starting dynamic subtest: vecs0-smem
[465.506198] Dynamic subtest vecs0-smem: SUCCESS (0.891s)
[465.512799] Starting dynamic subtest: vecs0-lmem0
[466.590551] Dynamic subtest vecs0-lmem0: SUCCESS (1.085s)
[466.597178] Starting dynamic subtest: vecs1-smem
[467.478156] Dynamic subtest vecs1-smem: SUCCESS (0.886s)
[467.484753] Starting dynamic subtest: vecs1-lmem0
[468.373679] Dynamic subtest vecs1-lmem0: SUCCESS (0.896s)
[468.380302] Starting dynamic subtest: ccs0-smem
[469.277869] Dynamic subtest ccs0-smem: SUCCESS (0.903s)
[469.284493] Starting dynamic subtest: ccs0-lmem0
[470.188542] Dynamic subtest ccs0-lmem0: SUCCESS (0.910s)
[470.195164] Starting dynamic subtest: ccs1-smem
[471.596713] Dynamic subtest ccs1-smem: SUCCESS (1.407s)
[471.603355] Starting dynamic subtest: ccs1-lmem0
[472.506066] Dynamic subtest ccs1-lmem0: SUCCESS (0.908s)
[472.512686] Starting dynamic subtest: ccs2-smem
[473.403631] Dynamic subtest ccs2-smem: SUCCESS (0.898s)
[473.410253] Starting dynamic subtest: ccs2-lmem0
[474.310178] Dynamic subtest ccs2-lmem0: SUCCESS (0.905s)
[474.316818] Starting dynamic subtest: ccs3-smem
[475.210121] Dynamic subtest ccs3-smem: SUCCESS (0.900s)
[475.216772] Starting dynamic subtest: ccs3-lmem0
[476.117895] Dynamic subtest ccs3-lmem0: SUCCESS (0.906s)
[476.118982] Subtest capture: SUCCESS (19.396s)
[476.221088] [120/141] (560s left) v3d/v3d_submit_csd (valid-submission)
[476.310419] Subtest valid-submission: SKIP (0.000s)
[476.358953] [121/141] (560s left) syncobj_timeline (reset-unsignaled)
[476.418734] Starting subtest: reset-unsignaled
[476.419932] Subtest reset-unsignaled: SUCCESS (0.000s)
[476.478069] [122/141] (560s left) kms_getfb (getfb-reject-ccs)
[476.542969] Starting subtest: getfb-reject-ccs
[476.544762] Subtest getfb-reject-ccs: SKIP (0.000s)
[476.652516] [123/141] (560s left) gem_exec_fence (expired-history)
[477.461539] Starting subtest: expired-history
[483.783578] Subtest expired-history: SUCCESS (6.315s)
[485.210792] [124/141] (551s left) gem_sync (basic-store-each)
[485.286733] Starting subtest: basic-store-each
[489.214613] Subtest basic-store-each: SUCCESS (3.927s)
[489.432228] [125/141] (547s left) gem_exec_flush (basic-uc-pro-default)
[489.525101] Subtest basic-uc-pro-default: SKIP (0.000s)
[489.568643] [126/141] (547s left) kms_async_flips (invalid-async-flip)
[491.526534] Starting subtest: invalid-async-flip
[491.528087] Subtest invalid-async-flip: SKIP (0.000s)
[492.132318] [127/141] (545s left) i915_pm_rpm (system-suspend-modeset)
[496.451609] Starting subtest: system-suspend-modeset
[518.900629] Subtest system-suspend-modeset: SUCCESS (8.180s)
[521.060070] [128/141] (531s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[521.139732] Starting subtest: legacy-engines-hostile-preempt
[521.140572] Starting dynamic subtest: render
[521.203549] Dynamic subtest render: SUCCESS (0.063s)
[521.214063] Starting dynamic subtest: bsd1
[521.236536] Dynamic subtest bsd1: SUCCESS (0.032s)
[521.253634] Starting dynamic subtest: bsd2
[521.285175] Dynamic subtest bsd2: SUCCESS (0.046s)
[521.297795] Starting dynamic subtest: blt
[521.331664] Dynamic subtest blt: SUCCESS (0.044s)
[521.346606] Starting dynamic subtest: vebox
[521.371904] Dynamic subtest vebox: SUCCESS (0.039s)
[521.373220] Subtest legacy-engines-hostile-preempt: SUCCESS (0.232s)
[521.476025] [129/141] (530s left) syncobj_timeline (etime-multi-wait-all-submitted)
[521.538835] Starting subtest: etime-multi-wait-all-submitted
[521.643889] Subtest etime-multi-wait-all-submitted: SUCCESS (0.106s)
[521.751281] [130/141] (530s left) kms_force_connector_basic (force-edid)
[521.876387] Starting subtest: force-edid
[521.889865] Subtest force-edid: SUCCESS (0.015s)
[523.962750] [131/141] (528s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[525.928537] Starting subtest: cursorB-vs-flipB-varying-size
[525.930514] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[525.996524] [132/141] (526s left) kms_plane_scaling (plane-scaler-with-modifiers-unity-scaling)
[527.960452] Starting subtest: plane-scaler-with-modifiers-unity-scaling
[527.961411] Starting dynamic subtest: pipe-A-HDMI-A-3
[528.613176] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.653s)
[528.622643] Starting dynamic subtest: pipe-B-HDMI-A-3
[529.186253] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.571s)
[529.195129] Starting dynamic subtest: pipe-C-HDMI-A-3
[529.792856] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.605s)
[529.801660] Starting dynamic subtest: pipe-D-HDMI-A-3
[530.383982] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.589s)
[530.384892] Subtest plane-scaler-with-modifiers-unity-scaling: SUCCESS (2.425s)
[530.523816] [133/141] (522s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[532.486372] Starting subtest: psr-rgb101010-draw-render
[532.487984] Subtest psr-rgb101010-draw-render: SKIP (0.000s)
[532.558143] [134/141] (520s left) api_intel_allocator (gem-pool)
[532.641820] Starting subtest: gem-pool
[532.674877] Subtest gem-pool: SUCCESS (0.033s)
[532.753335] [135/141] (519s left) kms_ccs (pipe-b-bad-pixel-format-y_tiled_ccs)
[534.813731] Starting subtest: pipe-B-bad-pixel-format-y_tiled_ccs
[534.815590] Subtest pipe-B-bad-pixel-format-y_tiled_ccs: SKIP (0.000s)
[535.006056] [136/141] (517s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[536.966161] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[536.967732] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[537.040824] [137/141] (515s left) kms_flip (2x-plain-flip-interruptible)
[538.088448] Starting subtest: 2x-plain-flip-interruptible
[538.104010] Subtest 2x-plain-flip-interruptible: SKIP (0.015s)
[538.174454] [138/141] (514s left) gem_exec_schedule (u-submit-golden-slice)
[538.300961] Starting subtest: u-submit-golden-slice
[538.301774] Starting dynamic subtest: rcs0
[538.372139] Dynamic subtest rcs0: SUCCESS (0.071s)
[538.380374] Starting dynamic subtest: bcs0
[538.424676] Dynamic subtest bcs0: SUCCESS (0.052s)
[538.432473] Starting dynamic subtest: vcs0
[538.477483] Dynamic subtest vcs0: SUCCESS (0.052s)
[538.485424] Starting dynamic subtest: vcs1
[538.545398] Dynamic subtest vcs1: SUCCESS (0.067s)
[538.553245] Starting dynamic subtest: vecs0
[538.611032] Dynamic subtest vecs0: SUCCESS (0.065s)
[538.618864] Starting dynamic subtest: vecs1
[538.664360] Dynamic subtest vecs1: SUCCESS (0.053s)
[538.672217] Starting dynamic subtest: ccs0
[538.718394] Dynamic subtest ccs0: SUCCESS (0.053s)
[538.726356] Starting dynamic subtest: ccs1
[538.769579] Dynamic subtest ccs1: SUCCESS (0.050s)
[538.777278] Starting dynamic subtest: ccs2
[538.822389] Dynamic subtest ccs2: SUCCESS (0.052s)
[538.830292] Starting dynamic subtest: ccs3
[538.876645] Dynamic subtest ccs3: SUCCESS (0.054s)
[538.877453] Subtest u-submit-golden-slice: SUCCESS (0.576s)
[539.322671] [139/141] (513s left) gem_ctx_isolation (preservation-reset)
[539.518359] Starting subtest: preservation-reset
[539.519299] Starting dynamic subtest: rcs0
[540.026811] Dynamic subtest rcs0: SUCCESS (0.513s)
[540.035064] Starting dynamic subtest: bcs0
[540.598751] Dynamic subtest bcs0: SUCCESS (0.580s)
[540.607071] Starting dynamic subtest: vcs0
[541.181602] Dynamic subtest vcs0: SUCCESS (0.582s)
[541.189700] Starting dynamic subtest: vcs1
[541.724796] Dynamic subtest vcs1: SUCCESS (0.542s)
[541.732878] Starting dynamic subtest: vecs0
[542.308640] Dynamic subtest vecs0: SUCCESS (0.583s)
[542.316585] Starting dynamic subtest: vecs1
[542.888586] Dynamic subtest vecs1: SUCCESS (0.579s)
[542.897031] Starting dynamic subtest: ccs0
[543.421961] Dynamic subtest ccs0: SUCCESS (0.533s)
[543.430519] Starting dynamic subtest: ccs1
[543.983025] Dynamic subtest ccs1: SUCCESS (0.560s)
[543.991389] Starting dynamic subtest: ccs2
[544.554159] Dynamic subtest ccs2: SUCCESS (0.570s)
[544.562438] Starting dynamic subtest: ccs3
[545.112697] Dynamic subtest ccs3: SUCCESS (0.558s)
[545.113515] Subtest preservation-reset: SUCCESS (5.610s)
[545.282196] [140/141] (507s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[545.345851] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[545.346772] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[545.409034] [141/141] (507s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[547.415082] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[547.469084] Closing watchdogs
Done.