[23.319892] Initializing watchdogs
[23.319949]   /dev/watchdog0
[23.324631] [001/137] (960s left) gem_exec_reloc (basic-scanout)
[23.422264] Starting subtest: basic-scanout
[23.422989] Starting dynamic subtest: rcs0
[23.630285] Dynamic subtest rcs0: SUCCESS (0.208s)
[23.633869] Starting dynamic subtest: bcs0
[23.730175] Dynamic subtest bcs0: SUCCESS (0.100s)
[23.733323] Starting dynamic subtest: vcs0
[23.838883] Dynamic subtest vcs0: SUCCESS (0.108s)
[23.843197] Starting dynamic subtest: vcs1
[23.947285] Dynamic subtest vcs1: SUCCESS (0.108s)
[23.951482] Starting dynamic subtest: vecs0
[24.055238] Dynamic subtest vecs0: SUCCESS (0.108s)
[24.056036] Subtest basic-scanout: SUCCESS (0.633s)
[24.129760] [002/137] (959s left) kms_sequence (get-busy)
[24.224212] Starting subtest: get-busy
[24.224993] Starting dynamic subtest: HDMI-A-1-pipe-A
[25.480990] Dynamic subtest HDMI-A-1-pipe-A: SUCCESS (1.257s)
[25.484932] Starting dynamic subtest: HDMI-A-1-pipe-B
[26.780468] Dynamic subtest HDMI-A-1-pipe-B: SUCCESS (1.297s)
[26.783736] Starting dynamic subtest: HDMI-A-1-pipe-C
[28.035675] Dynamic subtest HDMI-A-1-pipe-C: SUCCESS (1.254s)
[28.039111] Starting dynamic subtest: HDMI-A-1-pipe-D
[29.313210] Dynamic subtest HDMI-A-1-pipe-D: SUCCESS (1.277s)
[29.313979] Subtest get-busy: SUCCESS (5.090s)
[29.386796] [003/137] (954s left) gem_tiled_blits (basic)
[29.720310] Starting subtest: basic
[29.736756] Subtest basic: SUCCESS (0.016s)
[29.831565] [004/137] (954s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[29.974772] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[29.976180] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[30.024852] [005/137] (953s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[30.110434] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[30.111167] Starting dynamic subtest: pipe-A-valid-mode
[30.163779] Dynamic subtest pipe-A-valid-mode: SKIP (0.052s)
[30.165307] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.053s)
[30.232999] [006/137] (953s left) gem_mmap_gtt (big-bo-tiledy)
[30.275671] Starting subtest: big-bo-tiledY
[30.379580] Subtest big-bo-tiledY: SUCCESS (0.104s)
[30.458022] [007/137] (953s left) kms_flip (2x-plain-flip-interruptible)
[30.562980] Starting subtest: 2x-plain-flip-interruptible
[30.576035] Subtest 2x-plain-flip-interruptible: SKIP (0.012s)
[30.617126] [008/137] (953s left) gem_pread (display)
[30.660923] Starting subtest: display
[31.693257] Subtest display: SUCCESS (1.032s)
[31.734653] [009/137] (952s left) syncobj_wait (wait-any-interrupted)
[31.791711] Starting subtest: wait-any-interrupted
[31.897557] Subtest wait-any-interrupted: SUCCESS (0.105s)
[31.939853] [010/137] (951s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[32.052466] Starting subtest: yf-tiled-8bpp-rotate-0
[32.053960] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[32.118359] [011/137] (951s left) kms_cursor_crc (cursor-random-64x21)
[32.208322] Starting subtest: cursor-random-64x21
[32.212768] Starting dynamic subtest: pipe-A-HDMI-A-1
[34.162796] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.950s)
[34.185495] Starting dynamic subtest: pipe-B-HDMI-A-1
[36.048268] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.866s)
[36.071386] Starting dynamic subtest: pipe-C-HDMI-A-1
[37.923656] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.856s)
[37.947854] Starting dynamic subtest: pipe-D-HDMI-A-1
[39.795928] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.852s)
[39.796711] Subtest cursor-random-64x21: SUCCESS (7.587s)
[39.902250] [012/137] (944s left) vc4/vc4_perfmon (get-values-invalid-pointer)
[39.973850] Subtest get-values-invalid-pointer: SKIP (0.000s)
[40.000794] [013/137] (943s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[40.092941] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[40.094330] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[40.151510] [014/137] (943s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[40.242715] Starting subtest: x-tiled-32bpp-rotate-90
[40.294929] Subtest x-tiled-32bpp-rotate-90: SKIP (0.051s)
[40.360556] [015/137] (943s left) gem_exec_balancer (full-late-pulse)
[40.409093] Starting subtest: full-late-pulse
[41.444357] Subtest full-late-pulse: SUCCESS (1.035s)
[41.668669] [016/137] (942s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[41.758808] Starting subtest: fbcpsr-stridechange
[41.760270] Subtest fbcpsr-stridechange: SKIP (0.000s)
[41.801877] [017/137] (942s left) kms_ccs (pipe-a-crc-sprite-planes-basic-yf_tiled_ccs)
[41.968654] Starting subtest: pipe-A-crc-sprite-planes-basic-yf_tiled_ccs
[41.971770] Subtest pipe-A-crc-sprite-planes-basic-yf_tiled_ccs: SKIP (0.002s)
[42.225829] [018/137] (941s left) kms_busy (extended-modeset-hang-newfb)
[42.316324] Starting subtest: extended-modeset-hang-newfb
[42.317780] Starting dynamic subtest: pipe-A
[45.097702] Dynamic subtest pipe-A: SUCCESS (2.779s)
[45.104583] Starting dynamic subtest: pipe-D
[47.887085] Dynamic subtest pipe-D: SUCCESS (2.787s)
[47.887832] Subtest extended-modeset-hang-newfb: SUCCESS (5.570s)
[47.980965] [019/137] (936s left) vc4/vc4_tiling (get-bad-modifier)
[48.043230] Subtest get-bad-modifier: SKIP (0.000s)
[48.071593] [020/137] (935s left) tools_test (tools_test)
[48.117074] Starting subtest: tools_test
[48.209467] Subtest tools_test: SUCCESS (0.097s)
[48.237642] [021/137] (935s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[48.326699] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[48.328068] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[48.379524] [022/137] (935s left) i915_pm_rpm (pm-caching)
[49.883379] Starting subtest: pm-caching
[55.968255] Subtest pm-caching: SUCCESS (6.086s)
[56.078398] [023/137] (927s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[56.164529] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[56.166197] Starting dynamic subtest: pipe-A-valid-mode
[56.913555] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.748s)
[56.914435] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (0.748s)
[57.013106] [024/137] (927s left) kms_ccs (pipe-b-bad-rotation-90-4_tiled_dg2_mc_ccs)
[57.194912] Starting subtest: pipe-B-bad-rotation-90-4_tiled_dg2_mc_ccs
[57.196365] Subtest pipe-B-bad-rotation-90-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[57.441178] [025/137] (926s left) kms_plane (plane-panning-bottom-right-suspend)
[57.526750] Starting subtest: plane-panning-bottom-right-suspend
[57.528437] Starting dynamic subtest: pipe-A-planes
[74.799117] Dynamic subtest pipe-A-planes: SUCCESS (1.573s)
[74.805548] Starting dynamic subtest: pipe-B-planes
[91.805245] Dynamic subtest pipe-B-planes: SUCCESS (1.604s)
[91.805979] Subtest plane-panning-bottom-right-suspend: SUCCESS (3.180s)
[94.912366] [026/137] (923s left) kms_cursor_legacy (single-bo)
[95.010846] Starting subtest: single-bo
[95.011557] Starting dynamic subtest: pipe-A
[116.494596] Dynamic subtest pipe-A: SUCCESS (21.483s)
[116.499486] Starting dynamic subtest: pipe-B
[137.976861] Dynamic subtest pipe-B: SUCCESS (21.482s)
[137.981331] Starting dynamic subtest: pipe-C
[159.459183] Dynamic subtest pipe-C: SUCCESS (21.482s)
[159.463792] Starting dynamic subtest: pipe-D
[180.941388] Dynamic subtest pipe-D: SUCCESS (21.482s)
[180.946007] Starting dynamic subtest: all-pipes
[202.424312] Dynamic subtest all-pipes: SUCCESS (21.483s)
[202.425135] Subtest single-bo: SUCCESS (107.413s)
[202.457999] [027/137] (815s left) prime_busy (hang)
[202.503940] Starting subtest: hang
[202.504687] Starting dynamic subtest: rcs0
[216.414652] Dynamic subtest rcs0: SUCCESS (13.909s)
[216.419031] Starting dynamic subtest: bcs0
[223.517615] Dynamic subtest bcs0: SUCCESS (7.103s)
[223.521998] Starting dynamic subtest: vcs0
[230.557851] Dynamic subtest vcs0: SUCCESS (7.040s)
[230.562281] Starting dynamic subtest: vcs1
[237.533805] Dynamic subtest vcs1: SUCCESS (6.976s)
[237.538380] Starting dynamic subtest: vecs0
[244.573961] Dynamic subtest vecs0: SUCCESS (7.040s)
[244.574670] Subtest hang: SUCCESS (42.069s)
[244.644913] [028/137] (773s left) gem_mmap_gtt (basic-write-read)
[244.694349] Starting subtest: basic-write-read
[244.697679] Subtest basic-write-read: SUCCESS (0.004s)
[244.761851] [029/137] (773s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[244.865531] Starting subtest: 4-tiled-8bpp-rotate-90
[244.866949] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.000s)
[244.926872] [030/137] (773s left) gem_exec_reloc (basic-wc-read)
[244.970196] Starting subtest: basic-wc-read
[244.974511] Subtest basic-wc-read: SUCCESS (0.004s)
[245.054802] [031/137] (773s left) gem_partial_pwrite_pread (write-uncached)
[245.099070] Starting subtest: write-uncached
[254.870388] Subtest write-uncached: SUCCESS (9.771s)
[254.948152] [032/137] (763s left) gem_exec_fence (syncobj-timeline-unused-fence)
[255.397353] Starting subtest: syncobj-timeline-unused-fence
[255.400426] Subtest syncobj-timeline-unused-fence: SUCCESS (0.004s)
[255.547275] [033/137] (762s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[255.647806] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[255.649225] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[255.698412] [034/137] (762s left) gem_mmap_wc (bad-size)
[255.740036] Starting subtest: bad-size
[255.740811] Subtest bad-size: SUCCESS (0.000s)
[255.805212] [035/137] (762s left) gem_ctx_param (get-priority-new-ctx)
[255.858629] Starting subtest: get-priority-new-ctx
[255.859461] Subtest get-priority-new-ctx: SUCCESS (0.000s)
[255.899757] [036/137] (762s left) gem_ctx_shared (exec-single-timeline)
[255.956212] Starting subtest: exec-single-timeline
[255.956999] Starting dynamic subtest: rcs0
[256.989502] Dynamic subtest rcs0: SUCCESS (1.032s)
[256.996085] Starting dynamic subtest: bcs0
[258.012856] Dynamic subtest bcs0: SUCCESS (1.023s)
[258.019908] Starting dynamic subtest: vcs0
[259.036973] Dynamic subtest vcs0: SUCCESS (1.024s)
[259.044152] Starting dynamic subtest: vcs1
[260.060875] Dynamic subtest vcs1: SUCCESS (1.023s)
[260.068469] Starting dynamic subtest: vecs0
[261.084914] Dynamic subtest vecs0: SUCCESS (1.024s)
[261.085888] Subtest exec-single-timeline: SUCCESS (5.128s)
[261.235813] [037/137] (757s left) kms_frontbuffer_tracking (fbc-suspend)
[261.337249] Starting subtest: fbc-suspend
[296.918701] Subtest fbc-suspend: SUCCESS (5.354s)
[298.051194] [038/137] (751s left) api_intel_bb (blit-reloc-purge-cache)
[298.100371] Starting subtest: blit-reloc-purge-cache
[298.107701] Subtest blit-reloc-purge-cache: SUCCESS (0.007s)
[298.181011] [039/137] (751s left) i915_hangman (error-state-basic)
[298.240913] Starting subtest: error-state-basic
[298.245285] Subtest error-state-basic: SUCCESS (0.005s)
[298.314851] [040/137] (751s left) kms_ccs (pipe-b-crc-primary-basic-y_tiled_gen12_rc_ccs_cc)
[298.511382] Starting subtest: pipe-B-crc-primary-basic-y_tiled_gen12_rc_ccs_cc
[298.669052] Subtest pipe-B-crc-primary-basic-y_tiled_gen12_rc_ccs_cc: SUCCESS (0.158s)
[298.950729] [041/137] (750s left) api_intel_bb (reset-bb)
[298.993037] Starting subtest: reset-bb
[298.994982] Subtest reset-bb: SUCCESS (0.002s)
[299.058787] [042/137] (750s left) i915_query (query-regions-garbage-items)
[299.099931] Starting subtest: query-regions-garbage-items
[299.100817] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[299.134007] [043/137] (750s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[299.176364] Starting subtest: single-wait-for-submit-available-signaled
[299.177141] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[299.208901] [044/137] (750s left) gem_media_vme
[299.269404] [045/137] (750s left) syncobj_timeline (invalid-signal-illegal-handle)
[299.310841] Starting subtest: invalid-signal-illegal-handle
[299.311548] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[299.341796] [046/137] (750s left) gem_tiled_partial_pwrite_pread (writes)
[299.386037] Starting subtest: writes
[299.927848] Subtest writes: SUCCESS (0.542s)
[300.000622] [047/137] (749s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-render)
[300.101864] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-render
[301.023314] Subtest fbc-1p-offscren-pri-shrfb-draw-render: SUCCESS (0.922s)
[301.116769] [048/137] (748s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[301.263286] Starting subtest: addfb25-yf-tiled-legacy
[301.263989] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[301.358949] [049/137] (748s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[301.444157] Starting subtest: addfb25-framebuffer-vs-set-tiling
[301.444952] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[301.584620] [050/137] (748s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_dg2_rc_ccs)
[301.729499] Starting subtest: pipe-A-crc-primary-basic-4_tiled_dg2_rc_ccs
[301.730952] Subtest pipe-A-crc-primary-basic-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[302.007307] [051/137] (747s left) api_intel_allocator (gem-pool)
[302.048565] Starting subtest: gem-pool
[302.051642] Subtest gem-pool: SUCCESS (0.004s)
[302.116677] [052/137] (747s left) gem_exec_schedule (u-fairslice-all)
[302.168621] Starting subtest: u-fairslice-all
[304.195147] Subtest u-fairslice-all: SUCCESS (2.026s)
[304.492872] [053/137] (745s left) kms_plane_scaling (plane-upscale-with-pixel-format-factor-0-25)
[304.585926] Starting subtest: plane-upscale-with-pixel-format-factor-0-25
[304.587932] Starting dynamic subtest: pipe-A-HDMI-A-1
[306.169243] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.582s)
[306.174900] Starting dynamic subtest: pipe-B-HDMI-A-1
[307.828403] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.658s)
[307.834199] Starting dynamic subtest: pipe-C-HDMI-A-1
[308.028861] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.199s)
[308.036063] Starting dynamic subtest: pipe-D-HDMI-A-1
[308.245636] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.215s)
[308.246418] Subtest plane-upscale-with-pixel-format-factor-0-25: SUCCESS (3.660s)
[308.399575] [054/137] (741s left) gem_userptr_blits (sd-probe)
[308.446157] Starting subtest: sd-probe
[308.446958] Subtest sd-probe: SUCCESS (0.000s)
[308.524728] [055/137] (741s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[308.616174] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[308.617550] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[308.674404] [056/137] (741s left) gem_exec_create (legacy)
[308.721166] Starting subtest: legacy
[308.721990] Starting dynamic subtest: smem
[310.760970] Dynamic subtest smem: SUCCESS (2.040s)
[310.761668] Subtest legacy: SUCCESS (2.040s)
[310.917847] [057/137] (738s left) kms_ccs (pipe-c-random-ccs-data-y_tiled_ccs)
[311.189078] Starting subtest: pipe-C-random-ccs-data-y_tiled_ccs
[311.191553] Subtest pipe-C-random-ccs-data-y_tiled_ccs: SKIP (0.000s)
[311.354704] [058/137] (738s left) gem_close_race (multigpu-basic-threads)
[311.403099] Starting subtest: multigpu-basic-threads
[311.404508] Subtest multigpu-basic-threads: SKIP (0.000s)
[311.546275] [059/137] (738s left) kms_ccs (pipe-d-bad-rotation-90-y_tiled_ccs)
[311.847158] Starting subtest: pipe-D-bad-rotation-90-y_tiled_ccs
[311.848679] Subtest pipe-D-bad-rotation-90-y_tiled_ccs: SKIP (0.000s)
[311.971915] [060/137] (737s left) gem_ppgtt (blt-vs-render-ctx0)
[312.032034] Starting subtest: blt-vs-render-ctx0
[344.454009] Subtest blt-vs-render-ctx0: SUCCESS (32.422s)
[344.567145] [061/137] (705s left) kms_ccs (pipe-b-random-ccs-data-y_tiled_gen12_rc_ccs)
[344.799505] Starting subtest: pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs
[344.892369] Subtest pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs: SUCCESS (0.093s)
[345.136579] [062/137] (704s left) gem_exec_reloc (basic-write-gtt-active)
[345.194286] Starting subtest: basic-write-gtt-active
[345.304200] Subtest basic-write-gtt-active: SUCCESS (0.110s)
[345.384872] [063/137] (704s left) gem_exec_reloc (basic-gtt-read)
[345.429034] Starting subtest: basic-gtt-read
[345.433623] Subtest basic-gtt-read: SUCCESS (0.005s)
[345.517984] [064/137] (704s left) kms_psr (psr2_suspend)
[345.559787] Subtest psr2_suspend: SKIP (0.000s)
[345.578533] [065/137] (704s left) kms_ccs (pipe-d-random-ccs-data-yf_tiled_ccs)
[345.930698] Starting subtest: pipe-D-random-ccs-data-yf_tiled_ccs
[345.933079] Subtest pipe-D-random-ccs-data-yf_tiled_ccs: SKIP (0.000s)
[346.035721] [066/137] (703s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[346.122836] Starting subtest: bo-too-small-due-to-tiling
[346.123663] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[346.269516] [067/137] (703s left) kms_invalid_mode (bad-hsync-start)
[346.358278] Starting subtest: bad-hsync-start
[346.359079] Starting dynamic subtest: HDMI-A-1-pipe-A
[346.418316] Dynamic subtest HDMI-A-1-pipe-A: SUCCESS (0.060s)
[346.423791] Starting dynamic subtest: HDMI-A-1-pipe-B
[346.424588] Dynamic subtest HDMI-A-1-pipe-B: SUCCESS (0.003s)
[346.429992] Starting dynamic subtest: HDMI-A-1-pipe-C
[346.430741] Dynamic subtest HDMI-A-1-pipe-C: SUCCESS (0.001s)
[346.435992] Starting dynamic subtest: HDMI-A-1-pipe-D
[346.436742] Dynamic subtest HDMI-A-1-pipe-D: SUCCESS (0.001s)
[346.437458] Subtest bad-hsync-start: SUCCESS (0.068s)
[346.521109] [068/137] (703s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[346.611107] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[346.612502] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[346.663056] [069/137] (703s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[346.754062] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[346.755598] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[346.812817] [070/137] (703s left) kms_content_protection (lic)
[346.906664] Starting subtest: LIC
[347.221094] Subtest LIC: SKIP (0.313s)
[347.347083] [071/137] (702s left) v3d/v3d_mmap (mmap-bad-handle)
[347.408957] Subtest mmap-bad-handle: SKIP (0.000s)
[347.438372] [072/137] (702s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[347.567371] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[347.621759] [073/137] (702s left) i915_pm_rc6_residency (rc6-fence)
[347.662549] Starting subtest: rc6-fence
[365.903330] Subtest rc6-fence: SUCCESS (18.240s)
[366.120411] [074/137] (683s left) kms_flip (2x-plain-flip-ts-check)
[366.198653] Starting subtest: 2x-plain-flip-ts-check
[366.211437] Subtest 2x-plain-flip-ts-check: SKIP (0.012s)
[366.254172] [075/137] (683s left) gem_ctx_param (invalid-get-engines)
[366.294169] Starting subtest: invalid-get-engines
[366.294912] Subtest invalid-get-engines: SUCCESS (0.000s)
[366.329082] [076/137] (683s left) gem_exec_fence (basic-busy-all)
[366.381614] Starting subtest: basic-busy-all
[366.425614] Subtest basic-busy-all: SUCCESS (0.043s)
[366.952695] [077/137] (683s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[367.005381] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[367.114015] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.108s)
[367.166277] [078/137] (682s left) drm_fdinfo (busy-idle-check-all)
[367.211255] Starting subtest: busy-idle-check-all
[367.212024] Starting dynamic subtest: rcs0
[367.828799] Dynamic subtest rcs0: SUCCESS (0.617s)
[367.836589] Starting dynamic subtest: bcs0
[368.444462] Dynamic subtest bcs0: SUCCESS (0.615s)
[368.452448] Starting dynamic subtest: vcs0
[369.059310] Dynamic subtest vcs0: SUCCESS (0.614s)
[369.067376] Starting dynamic subtest: vcs1
[369.675700] Dynamic subtest vcs1: SUCCESS (0.615s)
[369.684823] Starting dynamic subtest: vecs0
[370.297853] Dynamic subtest vecs0: SUCCESS (0.621s)
[370.299107] Subtest busy-idle-check-all: SUCCESS (3.086s)
[370.345272] [079/137] (679s left) perf_pmu (faulting-read)
[370.392248] Starting subtest: faulting-read
[370.392993] Starting dynamic subtest: gtt
[370.393683] Dynamic subtest gtt: SUCCESS (0.001s)
[370.399033] Starting dynamic subtest: wb
[370.399761] Dynamic subtest wb: SUCCESS (0.000s)
[370.404855] Starting dynamic subtest: wc
[370.405532] Dynamic subtest wc: SUCCESS (0.000s)
[370.410471] Starting dynamic subtest: uc
[370.411251] Dynamic subtest uc: SUCCESS (0.000s)
[370.412037] Subtest faulting-read: SUCCESS (0.003s)
[370.461710] [080/137] (679s left) gem_render_copy (yf-tiled-to-vebox-linear)
[370.512360] Starting subtest: yf-tiled-to-vebox-linear
[370.513118] Starting dynamic subtest: smem
[370.573572] Dynamic subtest smem: SUCCESS (0.061s)
[370.574424] Subtest yf-tiled-to-vebox-linear: SUCCESS (0.061s)
[370.733377] [081/137] (679s left) prime_mmap (test_map_unmap)
[370.778502] Starting subtest: test_map_unmap
[370.779386] Starting dynamic subtest: test_map_unmap-smem
[370.780165] Dynamic subtest test_map_unmap-smem: SUCCESS (0.002s)
[370.780917] Subtest test_map_unmap: SUCCESS (0.002s)
[370.840913] [082/137] (679s left) perf_pmu (invalid-init)
[370.890069] Starting subtest: invalid-init
[370.890797] Subtest invalid-init: SUCCESS (0.000s)
[370.930397] [083/137] (679s left) kms_ccs (pipe-d-crc-primary-basic-y_tiled_gen12_rc_ccs)
[371.262603] Starting subtest: pipe-D-crc-primary-basic-y_tiled_gen12_rc_ccs
[371.515015] Subtest pipe-D-crc-primary-basic-y_tiled_gen12_rc_ccs: SUCCESS (0.252s)
[371.700639] [084/137] (678s left) syncobj_timeline (multi-wait-submitted-signaled)
[371.743030] Starting subtest: multi-wait-submitted-signaled
[371.743770] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[371.782919] [085/137] (678s left) gen7_exec_parse (basic-rejected)
[371.826294] Subtest basic-rejected: SKIP (0.000s)
[371.843360] [086/137] (678s left) gem_lmem_swapping (heavy-multi)
[371.888626] Subtest heavy-multi: SKIP (0.000s)
[371.910239] [087/137] (678s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[371.953720] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[371.954483] Starting dynamic subtest: smem
[372.031452] Dynamic subtest smem: SUCCESS (0.077s)
[372.032255] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SUCCESS (0.078s)
[372.182936] [088/137] (678s left) gem_exec_schedule (preempt-engines)
[372.242309] Starting subtest: preempt-engines
[372.243053] Starting dynamic subtest: rcs0
[372.303783] Dynamic subtest rcs0: SUCCESS (0.061s)
[372.309389] Starting dynamic subtest: bcs0
[372.362763] Dynamic subtest bcs0: SUCCESS (0.058s)
[372.368413] Starting dynamic subtest: vcs0
[372.419591] Dynamic subtest vcs0: SUCCESS (0.056s)
[372.425382] Starting dynamic subtest: vcs1
[372.477422] Dynamic subtest vcs1: SUCCESS (0.057s)
[372.483315] Starting dynamic subtest: vecs0
[372.535452] Dynamic subtest vecs0: SUCCESS (0.058s)
[372.536223] Subtest preempt-engines: SUCCESS (0.293s)
[372.799713] [089/137] (677s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[372.898535] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[372.899946] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[372.958344] [090/137] (677s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[373.043413] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[378.806239] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (5.763s)
[378.916395] [091/137] (671s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[379.008688] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[379.010169] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[379.065610] [092/137] (671s left) gem_exec_reloc (basic-wc-noreloc)
[379.108500] Starting subtest: basic-wc-noreloc
[379.110849] Subtest basic-wc-noreloc: SUCCESS (0.002s)
[379.190605] [093/137] (671s left) kms_properties (plane-properties-atomic)
[379.278209] Starting subtest: plane-properties-atomic
[379.745183] Subtest plane-properties-atomic: SUCCESS (0.468s)
[379.848864] [094/137] (670s left) fbdev (write)
[379.893199] Starting subtest: write
[380.342791] Subtest write: SUCCESS (0.450s)
[380.373747] [095/137] (669s left) kms_cursor_crc (cursor-sliding-512x512)
[380.463360] Starting subtest: cursor-sliding-512x512
[380.466189] Subtest cursor-sliding-512x512: SKIP (0.001s)
[380.523377] [096/137] (669s left) kms_content_protection (dp-mst-type-0)
[380.613876] Starting subtest: dp-mst-type-0
[380.615366] Subtest dp-mst-type-0: SKIP (0.000s)
[380.673788] [097/137] (669s left) kms_panel_fitting (atomic-fastset)
[380.759576] Starting subtest: atomic-fastset
[380.761145] Subtest atomic-fastset: SKIP (0.000s)
[380.798484] [098/137] (669s left) v3d/v3d_submit_csd (multiple-job-submission)
[380.860588] Subtest multiple-job-submission: SKIP (0.000s)
[380.890005] [099/137] (669s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[380.983242] Starting subtest: 4-tiled-64bpp-rotate-270
[380.984768] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.000s)
[381.040148] [100/137] (669s left) gem_pxp (regular-baseline-src-copy-readible)
[383.597270] Subtest regular-baseline-src-copy-readible: SKIP (0.000s)
[383.637214] [101/137] (666s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[383.682256] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[383.785744] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[383.835548] [102/137] (666s left) v3d/v3d_get_bo_offset (create-get-offsets)
[383.902589] Subtest create-get-offsets: SKIP (0.000s)
[383.933818] [103/137] (666s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[384.031949] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[384.318600] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.287s)
[384.405431] [104/137] (666s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[384.506675] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[384.508414] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[384.557554] [105/137] (665s left) perf (gen12-group-concurrent-oa-buffer-read)
[384.640619] Subtest gen12-group-concurrent-oa-buffer-read: SKIP (0.000s)
[384.654659] [106/137] (665s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[384.742924] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[384.744293] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[384.799187] [107/137] (665s left) v3d/v3d_submit_cl (multi-and-single-sync)
[384.861590] Subtest multi-and-single-sync: SKIP (0.000s)
[384.892721] [108/137] (665s left) kms_psr2_sf (cursor-plane-move-continuous-exceed-sf)
[384.947194] Subtest cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[384.958865] [109/137] (665s left) prime_vgem (basic-blt)
[385.005123] Starting subtest: basic-blt
[385.018046] Subtest basic-blt: SUCCESS (0.013s)
[385.091420] [110/137] (665s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[385.191972] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[385.727685] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.535s)
[385.803421] [111/137] (664s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[385.890725] Starting subtest: plane-all-modeset-transition-internal-panels
[385.892255] Subtest plane-all-modeset-transition-internal-panels: SKIP (0.000s)
[385.925501] [112/137] (664s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[386.016625] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[386.018205] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[386.083653] [113/137] (664s left) kms_vblank (pipe-c-wait-busy)
[386.167665] Starting subtest: pipe-C-wait-busy
[387.503553] Subtest pipe-C-wait-busy: SUCCESS (1.336s)
[387.608148] [114/137] (662s left) kms_vblank (pipe-b-ts-continuation-dpms-rpm)
[387.697399] Starting subtest: pipe-B-ts-continuation-dpms-rpm
[390.271936] Subtest pipe-B-ts-continuation-dpms-rpm: SUCCESS (2.576s)
[390.361356] [115/137] (660s left) kms_chamelium_frames (dp-crc-fast)
[390.497281] Subtest dp-crc-fast: SKIP (0.000s)
[390.550990] [116/137] (660s left) kms_ccs (pipe-c-crc-primary-rotation-180-y_tiled_ccs)
[390.811429] Starting subtest: pipe-C-crc-primary-rotation-180-y_tiled_ccs
[390.812931] Subtest pipe-C-crc-primary-rotation-180-y_tiled_ccs: SKIP (0.000s)
[390.990091] [117/137] (659s left) gem_userptr_blits (unsync-overlap)
[391.036033] Subtest unsync-overlap: SKIP (0.000s)
[391.114803] [118/137] (659s left) gem_ctx_persistence (legacy-engines-mixed)
[391.158175] Starting subtest: legacy-engines-mixed
[391.158989] Starting dynamic subtest: render
[391.194040] Dynamic subtest render: SUCCESS (0.036s)
[391.199682] Starting dynamic subtest: bsd1
[391.229081] Dynamic subtest bsd1: SUCCESS (0.035s)
[391.234671] Starting dynamic subtest: bsd2
[391.266125] Dynamic subtest bsd2: SUCCESS (0.037s)
[391.271638] Starting dynamic subtest: blt
[391.301130] Dynamic subtest blt: SUCCESS (0.035s)
[391.306608] Starting dynamic subtest: vebox
[391.336039] Dynamic subtest vebox: SUCCESS (0.034s)
[391.336763] Subtest legacy-engines-mixed: SUCCESS (0.178s)
[391.373462] [119/137] (659s left) kms_flip (wf_vblank-ts-check-interruptible)
[391.447370] Starting subtest: wf_vblank-ts-check-interruptible
[391.451902] Starting dynamic subtest: A-HDMI-A1
[399.250621] Dynamic subtest A-HDMI-A1: SUCCESS (7.799s)
[399.257456] Starting dynamic subtest: B-HDMI-A1
[407.028944] Dynamic subtest B-HDMI-A1: SUCCESS (7.777s)
[407.036266] Starting dynamic subtest: C-HDMI-A1
[414.807482] Dynamic subtest C-HDMI-A1: SUCCESS (7.778s)
[414.814604] Starting dynamic subtest: D-HDMI-A1
[422.571360] Dynamic subtest D-HDMI-A1: SUCCESS (7.763s)
[422.576278] Subtest wf_vblank-ts-check-interruptible: SUCCESS (31.129s)
[422.709896] [120/137] (627s left) kms_vblank (pipe-c-wait-idle-hang)
[422.797202] Starting subtest: pipe-C-wait-idle-hang
[436.640056] Subtest pipe-C-wait-idle-hang: SUCCESS (13.844s)
[436.753328] [121/137] (613s left) kms_plane_scaling (planes-downscale-factor-0-25-upscale-0-25)
[436.840227] Starting subtest: planes-downscale-factor-0-25-upscale-0-25
[436.841030] Starting dynamic subtest: pipe-A-HDMI-A-1
[436.877362] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.036s)
[436.882925] Starting dynamic subtest: pipe-B-HDMI-A-1
[436.912629] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.034s)
[436.918182] Starting dynamic subtest: pipe-C-HDMI-A-1
[436.947304] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.033s)
[436.952836] Starting dynamic subtest: pipe-D-HDMI-A-1
[436.982637] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.033s)
[436.984180] Subtest planes-downscale-factor-0-25-upscale-0-25: SKIP (0.142s)
[437.040906] [122/137] (613s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[437.129378] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[437.130791] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[437.173495] [123/137] (613s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[437.261971] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[437.263557] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[437.315254] [124/137] (613s left) gem_exec_flush (basic-wb-pro-default)
[437.361775] Starting subtest: basic-wb-pro-default
[442.771919] Subtest basic-wb-pro-default: SUCCESS (5.410s)
[442.929960] [125/137] (607s left) kms_lease (invalid-create-leases)
[443.037209] Starting subtest: invalid-create-leases
[443.040681] Subtest invalid-create-leases: SUCCESS (0.003s)
[443.075025] [126/137] (607s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-wc)
[443.165533] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-wc
[444.004516] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-wc: SUCCESS (0.841s)
[444.102007] [127/137] (606s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[444.153982] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[444.176336] [128/137] (606s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[444.273830] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[444.275215] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[444.325094] [129/137] (606s left) syncobj_wait (invalid-wait-zero-handles)
[444.367226] Starting subtest: invalid-wait-zero-handles
[444.367974] Subtest invalid-wait-zero-handles: SUCCESS (0.000s)
[444.399031] [130/137] (606s left) sw_sync (alloc_fence_invalid_timeline)
[444.440484] Starting subtest: alloc_fence_invalid_timeline
[444.441296] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[444.465585] [131/137] (606s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[444.510816] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[444.511687] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[444.551174] [132/137] (606s left) kms_addfb_basic (bad-pitch-63)
[444.601841] Starting subtest: bad-pitch-63
[444.602692] Subtest bad-pitch-63: SUCCESS (0.000s)
[444.791507] [133/137] (605s left) i915_hangman (detector)
[444.839561] Starting subtest: detector
[444.840341] Starting dynamic subtest: rcs0
[454.202892] Dynamic subtest rcs0: SUCCESS (9.364s)
[454.213797] Starting dynamic subtest: bcs0
[464.195053] Dynamic subtest bcs0: SUCCESS (9.991s)
[464.203965] Starting dynamic subtest: vcs0
[474.176938] Dynamic subtest vcs0: SUCCESS (9.981s)
[474.191061] Starting dynamic subtest: vcs1
[484.160946] Dynamic subtest vcs1: SUCCESS (9.983s)
[484.173197] Starting dynamic subtest: vecs0
[494.214922] Dynamic subtest vecs0: SUCCESS (10.053s)
[494.216124] Subtest detector: SUCCESS (49.376s)
[494.265630] [134/137] (556s left) gem_exec_basic (basic)
[494.314202] Starting subtest: basic
[494.315050] Starting dynamic subtest: rcs0-smem
[494.315797] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[494.321893] Starting dynamic subtest: bcs0-smem
[494.322630] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[494.327725] Starting dynamic subtest: vcs0-smem
[494.328502] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[494.333523] Starting dynamic subtest: vcs1-smem
[494.334325] Dynamic subtest vcs1-smem: SUCCESS (0.000s)
[494.339234] Starting dynamic subtest: vecs0-smem
[494.340043] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[494.340770] Subtest basic: SUCCESS (0.003s)
[494.476977] [135/137] (556s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[494.569430] Starting subtest: disable-crc-after-crtc
[494.570810] Starting dynamic subtest: pipe-A-HDMI-A-1
[494.902087] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.330s)
[494.907640] Starting dynamic subtest: pipe-B-HDMI-A-1
[495.180892] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.279s)
[495.187528] Starting dynamic subtest: pipe-C-HDMI-A-1
[495.463840] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.281s)
[495.469769] Starting dynamic subtest: pipe-D-HDMI-A-1
[495.754855] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.290s)
[495.755716] Subtest disable-crc-after-crtc: SUCCESS (1.186s)
[495.847059] [136/137] (554s left) gem_exec_store (dword)
[495.894738] Starting subtest: dword
[495.895553] Starting dynamic subtest: rcs0
[495.929340] Dynamic subtest rcs0: SUCCESS (0.034s)
[495.935477] Starting dynamic subtest: bcs0
[495.940192] Dynamic subtest bcs0: SUCCESS (0.011s)
[495.946233] Starting dynamic subtest: vcs0
[495.955253] Dynamic subtest vcs0: SUCCESS (0.015s)
[495.961246] Starting dynamic subtest: vcs1
[495.982275] Dynamic subtest vcs1: SUCCESS (0.027s)
[495.987978] Starting dynamic subtest: vecs0
[496.000218] Dynamic subtest vecs0: SUCCESS (0.018s)
[496.001014] Subtest dword: SUCCESS (0.105s)
[496.138444] [137/137] (554s left) syncobj_wait (wait-all-snapshot)
[496.180296] Starting subtest: wait-all-snapshot
[496.261314] Subtest wait-all-snapshot: SUCCESS (0.081s)
[496.295017] Closing watchdogs
Done.