[21.367982] Initializing watchdogs
[21.368059]   /dev/watchdog0
[21.372289] [001/137] (960s left) feature_discovery (display-2x)
[21.471484] Starting subtest: display-2x
[21.473281] Subtest display-2x: SKIP (0.000s)
[21.510780] [002/137] (960s left) perf_pmu (rc6-suspend)
[21.557174] Starting subtest: rc6-suspend
[44.855754] Subtest rc6-suspend: SUCCESS (7.658s)
[46.903642] [003/137] (952s left) gem_exec_schedule (u-submit-early-slice)
[46.961876] Starting subtest: u-submit-early-slice
[46.962648] Starting dynamic subtest: rcs0
[46.993773] Dynamic subtest rcs0: SUCCESS (0.032s)
[46.997763] Starting dynamic subtest: bcs0
[47.018454] Dynamic subtest bcs0: SUCCESS (0.025s)
[47.022638] Starting dynamic subtest: vcs0
[47.047487] Dynamic subtest vcs0: SUCCESS (0.029s)
[47.051126] Starting dynamic subtest: vcs1
[47.074273] Dynamic subtest vcs1: SUCCESS (0.027s)
[47.078235] Starting dynamic subtest: vecs0
[47.099754] Dynamic subtest vecs0: SUCCESS (0.025s)
[47.100474] Subtest u-submit-early-slice: SUCCESS (0.138s)
[47.367683] [004/137] (952s left) gem_softpin (safe-alignment)
[47.423730] Starting subtest: safe-alignment
[47.431751] Subtest safe-alignment: SUCCESS (0.008s)
[47.505769] [005/137] (952s left) kms_cursor_edge_walk (128x128-top-bottom)
[47.605273] Starting subtest: 128x128-top-bottom
[47.606130] Starting dynamic subtest: pipe-A-HDMI-A-1
[49.399683] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.794s)
[49.403884] Starting dynamic subtest: pipe-D-HDMI-A-1
[51.071302] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.670s)
[51.072061] Subtest 128x128-top-bottom: SUCCESS (3.467s)
[51.150679] [006/137] (948s left) prime_vgem (coherency-blt)
[51.232459] Starting subtest: coherency-blt
[51.913491] Subtest coherency-blt: SUCCESS (0.680s)
[51.986568] [007/137] (947s left) gem_exec_whisper (basic-contexts-forked)
[52.048180] Starting subtest: basic-contexts-forked
[56.019194] Subtest basic-contexts-forked: SUCCESS (3.970s)
[56.178200] [008/137] (943s left) kms_ccs (pipe-d-bad-pixel-format-y_tiled_gen12_mc_ccs)
[56.487662] Starting subtest: pipe-D-bad-pixel-format-y_tiled_gen12_mc_ccs
[56.489186] Subtest pipe-D-bad-pixel-format-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[56.618604] [009/137] (943s left) kms_addfb_basic (size-max)
[56.727662] Starting subtest: size-max
[56.728425] Subtest size-max: SUCCESS (0.000s)
[56.875030] [010/137] (942s left) kms_vrr (negative-basic)
[56.962234] Starting subtest: negative-basic
[56.963908] Subtest negative-basic: SKIP (0.000s)
[56.977575] [011/137] (942s left) kms_properties (plane-properties-legacy)
[57.065814] Starting subtest: plane-properties-legacy
[58.052610] Subtest plane-properties-legacy: SUCCESS (0.987s)
[58.146431] [012/137] (941s left) kms_ccs (pipe-b-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc)
[58.354266] Starting subtest: pipe-B-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc
[58.355010] Subtest pipe-B-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc: SUCCESS (0.000s)
[58.571028] [013/137] (941s left) gem_mmap_gtt (hang)
[58.613193] Starting subtest: hang
[64.031635] Subtest hang: SUCCESS (5.419s)
[64.109020] [014/137] (935s left) kms_ccs (pipe-d-random-ccs-data-y_tiled_gen12_rc_ccs)
[64.455730] Starting subtest: pipe-D-random-ccs-data-y_tiled_gen12_rc_ccs
[64.550611] Subtest pipe-D-random-ccs-data-y_tiled_gen12_rc_ccs: SUCCESS (0.095s)
[64.698148] [015/137] (934s left) device_reset (unbind-cold-reset-rebind)
[65.060495] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[65.082111] [016/137] (934s left) gem_exec_suspend (basic-s3)
[65.126453] Starting subtest: basic-S3
[65.127484] Starting dynamic subtest: smem
[83.031183] Dynamic subtest smem: SUCCESS (2.302s)
[83.031959] Subtest basic-S3: SUCCESS (2.303s)
[87.723192] [017/137] (932s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[87.822783] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[87.824242] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[87.870655] [018/137] (931s left) kms_plane_cursor (primary)
[87.956834] Starting subtest: primary
[87.958354] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64
[89.159118] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (1.201s)
[89.188039] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128
[90.384468] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (1.200s)
[90.412473] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256
[91.609332] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (1.200s)
[91.679742] Starting dynamic subtest: pipe-B-HDMI-A-1-size-64
[92.910161] Dynamic subtest pipe-B-HDMI-A-1-size-64: SUCCESS (1.235s)
[92.929966] Starting dynamic subtest: pipe-B-HDMI-A-1-size-128
[94.127117] Dynamic subtest pipe-B-HDMI-A-1-size-128: SUCCESS (1.200s)
[94.147954] Starting dynamic subtest: pipe-B-HDMI-A-1-size-256
[95.343859] Dynamic subtest pipe-B-HDMI-A-1-size-256: SUCCESS (1.200s)
[95.406835] Starting dynamic subtest: pipe-C-HDMI-A-1-size-64
[96.639900] Dynamic subtest pipe-C-HDMI-A-1-size-64: SUCCESS (1.237s)
[96.659915] Starting dynamic subtest: pipe-C-HDMI-A-1-size-128
[97.856631] Dynamic subtest pipe-C-HDMI-A-1-size-128: SUCCESS (1.200s)
[97.876467] Starting dynamic subtest: pipe-C-HDMI-A-1-size-256
[99.073528] Dynamic subtest pipe-C-HDMI-A-1-size-256: SUCCESS (1.200s)
[99.136038] Starting dynamic subtest: pipe-D-HDMI-A-1-size-64
[100.367208] Dynamic subtest pipe-D-HDMI-A-1-size-64: SUCCESS (1.235s)
[100.386712] Starting dynamic subtest: pipe-D-HDMI-A-1-size-128
[101.584011] Dynamic subtest pipe-D-HDMI-A-1-size-128: SUCCESS (1.200s)
[101.603613] Starting dynamic subtest: pipe-D-HDMI-A-1-size-256
[102.800826] Dynamic subtest pipe-D-HDMI-A-1-size-256: SUCCESS (1.200s)
[102.857428] Subtest primary: SUCCESS (14.901s)
[102.928774] [019/137] (916s left) gem_exec_schedule (fairslice-all)
[102.980821] Starting subtest: fairslice-all
[105.005584] Subtest fairslice-all: SUCCESS (2.025s)
[105.278646] [020/137] (914s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[105.381643] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[105.382568] Starting dynamic subtest: pipe-A-valid-mode
[105.433386] Dynamic subtest pipe-A-valid-mode: SKIP (0.050s)
[105.435040] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.052s)
[105.502943] [021/137] (914s left) kms_ccs (pipe-b-bad-pixel-format-4_tiled_dg2_rc_ccs_cc)
[105.676348] Starting subtest: pipe-B-bad-pixel-format-4_tiled_dg2_rc_ccs_cc
[105.677792] Subtest pipe-B-bad-pixel-format-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[105.924590] [022/137] (913s left) syncobj_wait (invalid-reset-zero-handles)
[105.967167] Starting subtest: invalid-reset-zero-handles
[105.967953] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[105.998993] [023/137] (913s left) kms_big_fb (linear-32bpp-rotate-0)
[106.091965] Starting subtest: linear-32bpp-rotate-0
[107.304273] Subtest linear-32bpp-rotate-0: SUCCESS (1.212s)
[107.406382] [024/137] (912s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[107.545080] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[107.598346] [025/137] (912s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[107.689092] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[107.690445] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[107.745006] [026/137] (912s left) i915_pm_rpm (system-suspend)
[109.253740] Starting subtest: system-suspend
[127.529101] Subtest system-suspend: SUCCESS (3.619s)
[131.799275] [027/137] (906s left) v3d/v3d_submit_csd (bad-extension)
[131.878073] Subtest bad-extension: SKIP (0.000s)
[131.910930] [028/137] (906s left) kms_ccs (pipe-c-crc-sprite-planes-basic-yf_tiled_ccs)
[132.203058] Starting subtest: pipe-C-crc-sprite-planes-basic-yf_tiled_ccs
[132.205985] Subtest pipe-C-crc-sprite-planes-basic-yf_tiled_ccs: SKIP (0.002s)
[132.342398] [029/137] (906s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[132.438261] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[133.063626] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.625s)
[133.146842] [030/137] (905s left) kms_async_flips (alternate-sync-async-flip)
[133.235261] Starting subtest: alternate-sync-async-flip
[133.236038] Starting dynamic subtest: pipe-A-HDMI-A-1
[135.477025] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.240s)
[135.485822] Starting dynamic subtest: pipe-B-HDMI-A-1
[137.675710] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.196s)
[137.683645] Starting dynamic subtest: pipe-C-HDMI-A-1
[139.853672] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.176s)
[139.862540] Starting dynamic subtest: pipe-D-HDMI-A-1
[142.033800] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.178s)
[142.035298] Subtest alternate-sync-async-flip: SUCCESS (8.798s)
[142.223654] [031/137] (896s left) api_intel_allocator (reopen-fork)
[142.266249] Starting subtest: reopen-fork
[145.501776] Subtest reopen-fork: SUCCESS (3.235s)
[145.550260] [032/137] (893s left) syncobj_timeline (wait-all-delayed-signal)
[145.603104] Starting subtest: wait-all-delayed-signal
[145.705948] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[145.752745] [033/137] (893s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[145.849826] Starting subtest: 4-tiled-addfb-size-offset-overflow
[145.851198] Subtest 4-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[145.907133] [034/137] (892s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[145.996255] Starting subtest: psr-rgb101010-draw-pwrite
[145.997630] Subtest psr-rgb101010-draw-pwrite: SKIP (0.000s)
[146.048916] [035/137] (892s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[146.138884] Starting subtest: fbc-rgb565-draw-mmap-gtt
[147.162056] Subtest fbc-rgb565-draw-mmap-gtt: SUCCESS (1.025s)
[147.242156] [036/137] (891s left) gem_exec_reloc (basic-cpu-gtt-active)
[147.296966] Starting subtest: basic-cpu-gtt-active
[147.414036] Subtest basic-cpu-gtt-active: SUCCESS (0.116s)
[147.507806] [037/137] (891s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[147.550845] Starting subtest: invalid-bsd1-flag-on-blt
[147.551660] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[147.619985] [038/137] (891s left) prime_vgem (fence-flip-hang)
[147.682170] Subtest fence-flip-hang: SKIP (0.000s)
[147.752048] [039/137] (891s left) kms_addfb_basic (tile-pitch-mismatch)
[147.934473] Starting subtest: tile-pitch-mismatch
[147.935253] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[147.984081] [040/137] (890s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[148.071694] Starting subtest: 2x-flip-vs-cursor-atomic
[148.074710] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.002s)
[148.107968] [041/137] (890s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[148.199829] Starting subtest: fbcpsr-rgb565-draw-pwrite
[148.201256] Subtest fbcpsr-rgb565-draw-pwrite: SKIP (0.000s)
[148.257476] [042/137] (890s left) kms_ccs (pipe-c-crc-primary-basic-y_tiled_ccs)
[148.504987] Starting subtest: pipe-C-crc-primary-basic-y_tiled_ccs
[148.506449] Subtest pipe-C-crc-primary-basic-y_tiled_ccs: SKIP (0.000s)
[148.681816] [043/137] (890s left) kms_addfb_basic (too-high)
[148.769156] Starting subtest: too-high
[148.769943] Subtest too-high: SUCCESS (0.000s)
[148.915159] [044/137] (890s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[149.001514] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[149.002207] Starting dynamic subtest: pipe-A-HDMI-A-1
[149.151117] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.149s)
[149.156156] Starting dynamic subtest: pipe-B-HDMI-A-1
[149.285369] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.133s)
[149.291609] Starting dynamic subtest: pipe-C-HDMI-A-1
[149.411018] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.124s)
[149.417203] Starting dynamic subtest: pipe-D-HDMI-A-1
[149.534822] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.122s)
[149.535589] Subtest planes-unity-scaling-downscale-factor-0-5: SUCCESS (0.534s)
[149.642527] [045/137] (889s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[149.729642] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[149.730467] Starting dynamic subtest: pipe-A-valid-mode
[149.794436] Dynamic subtest pipe-A-valid-mode: SKIP (0.064s)
[149.795955] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.065s)
[149.900443] [046/137] (889s left) vc4/vc4_wait_bo (unused-bo-0ns)
[149.978019] Subtest unused-bo-0ns: SKIP (0.000s)
[150.008250] [047/137] (888s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[150.101873] Starting subtest: fbcpsr-tiling-linear
[150.103437] Subtest fbcpsr-tiling-linear: SKIP (0.000s)
[150.158389] [048/137] (888s left) kms_hdr (invalid-metadata-sizes)
[150.247168] Starting subtest: invalid-metadata-sizes
[150.248590] Subtest invalid-metadata-sizes: SKIP (0.000s)
[150.283226] [049/137] (888s left) kms_prop_blob (invalid-set-prop)
[150.328188] Starting subtest: invalid-set-prop
[150.328930] Subtest invalid-set-prop: SUCCESS (0.000s)
[150.365023] [050/137] (888s left) gem_exec_fence (syncobj-timeline-chain-engines)
[150.755633] Starting subtest: syncobj-timeline-chain-engines
[150.802914] Subtest syncobj-timeline-chain-engines: SUCCESS (0.048s)
[150.942368] [051/137] (888s left) gem_exec_schedule (pi-userfault)
[151.098658] Starting subtest: pi-userfault
[151.099417] Starting dynamic subtest: rcs0
[151.106762] Dynamic subtest rcs0: SUCCESS (0.003s)
[151.112489] Starting dynamic subtest: bcs0
[151.113203] Dynamic subtest bcs0: SUCCESS (0.002s)
[151.117943] Starting dynamic subtest: vcs0
[151.118649] Dynamic subtest vcs0: SUCCESS (0.002s)
[151.123090] Starting dynamic subtest: vcs1
[151.123800] Dynamic subtest vcs1: SUCCESS (0.003s)
[151.128167] Starting dynamic subtest: vecs0
[151.128884] Dynamic subtest vecs0: SUCCESS (0.002s)
[151.129592] Subtest pi-userfault: SUCCESS (0.014s)
[151.248656] [052/137] (887s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[151.289942] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[151.290758] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[151.324253] [053/137] (887s left) perf_pmu (busy-idle)
[151.366184] Starting subtest: busy-idle
[151.366930] Starting dynamic subtest: rcs0
[151.986257] Dynamic subtest rcs0: SUCCESS (0.619s)
[151.993367] Starting dynamic subtest: bcs0
[152.602273] Dynamic subtest bcs0: SUCCESS (0.615s)
[152.609688] Starting dynamic subtest: vcs0
[153.222152] Dynamic subtest vcs0: SUCCESS (0.619s)
[153.229804] Starting dynamic subtest: vcs1
[153.838223] Dynamic subtest vcs1: SUCCESS (0.615s)
[153.845829] Starting dynamic subtest: vecs0
[154.455118] Dynamic subtest vecs0: SUCCESS (0.616s)
[154.456205] Subtest busy-idle: SUCCESS (3.089s)
[154.497291] [054/137] (884s left) kms_cursor_crc (cursor-random-128x128)
[154.589700] Starting subtest: cursor-random-128x128
[154.595582] Starting dynamic subtest: pipe-A-HDMI-A-1
[156.486258] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.892s)
[156.511324] Starting dynamic subtest: pipe-B-HDMI-A-1
[158.381197] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.876s)
[158.407514] Starting dynamic subtest: pipe-C-HDMI-A-1
[160.542395] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.141s)
[160.564787] Starting dynamic subtest: pipe-D-HDMI-A-1
[162.422772] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.862s)
[162.423546] Subtest cursor-random-128x128: SUCCESS (7.833s)
[162.516290] [055/137] (876s left) gem_exec_reloc (basic-write-wc-active)
[162.561197] Starting subtest: basic-write-wc-active
[162.670731] Subtest basic-write-wc-active: SUCCESS (0.109s)
[162.756974] [056/137] (876s left) kms_cursor_legacy (single-move)
[162.843134] Starting subtest: single-move
[162.843920] Starting dynamic subtest: pipe-A
[184.326941] Dynamic subtest pipe-A: SUCCESS (21.483s)
[184.331868] Starting dynamic subtest: pipe-B
[205.809612] Dynamic subtest pipe-B: SUCCESS (21.482s)
[205.814317] Starting dynamic subtest: pipe-C
[227.292073] Dynamic subtest pipe-C: SUCCESS (21.482s)
[227.296734] Starting dynamic subtest: pipe-D
[248.774689] Dynamic subtest pipe-D: SUCCESS (21.482s)
[248.779347] Starting dynamic subtest: all-pipes
[270.257800] Dynamic subtest all-pipes: SUCCESS (21.483s)
[270.258656] Subtest single-move: SUCCESS (107.414s)
[270.289097] [057/137] (768s left) prime_self_import (basic-llseek-size)
[270.328778] Starting subtest: basic-llseek-size
[270.330966] Subtest basic-llseek-size: SUCCESS (0.002s)
[270.384114] [058/137] (768s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[270.474136] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[270.475520] Subtest psr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[270.531380] [059/137] (768s left) gem_ctx_exec (basic-nohangcheck)
[270.573361] Starting subtest: basic-nohangcheck
[271.375959] Subtest basic-nohangcheck: SUCCESS (0.803s)
[271.420040] [060/137] (767s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-gtt)
[271.518050] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-gtt
[272.362135] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-gtt: SUCCESS (0.846s)
[272.457239] [061/137] (766s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[272.558820] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[272.560209] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[272.614990] [062/137] (766s left) kms_ccs (pipe-b-crc-primary-basic-y_tiled_ccs)
[272.807756] Starting subtest: pipe-B-crc-primary-basic-y_tiled_ccs
[272.809142] Subtest pipe-B-crc-primary-basic-y_tiled_ccs: SKIP (0.000s)
[273.047161] [063/137] (766s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[273.148614] Starting subtest: y-tiled-16bpp-rotate-270
[274.033022] Subtest y-tiled-16bpp-rotate-270: SUCCESS (0.884s)
[274.121638] [064/137] (765s left) gem_exec_reloc (basic-cpu-read-noreloc)
[274.168528] Starting subtest: basic-cpu-read-noreloc
[274.170568] Subtest basic-cpu-read-noreloc: SUCCESS (0.002s)
[274.254241] [065/137] (764s left) kms_addfb_basic (invalid-set-prop-any)
[274.431188] Starting subtest: invalid-set-prop-any
[274.431990] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[274.488706] [066/137] (764s left) kms_vblank (pipe-b-ts-continuation-idle-hang)
[274.577814] Starting subtest: pipe-B-ts-continuation-idle-hang
[288.604032] Subtest pipe-B-ts-continuation-idle-hang: SUCCESS (14.027s)
[288.703930] [067/137] (750s left) kms_vblank (pipe-b-wait-forked-busy-hang)
[288.791585] Starting subtest: pipe-B-wait-forked-busy-hang
[302.429557] Subtest pipe-B-wait-forked-busy-hang: SUCCESS (13.637s)
[302.537059] [068/137] (736s left) gem_exec_balancer (parallel-ordering)
[302.758669] Starting subtest: parallel-ordering
[302.919769] Subtest parallel-ordering: FAIL (0.150s)
[302.993161] [069/137] (736s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[303.080095] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[303.081587] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[303.120359] [070/137] (736s left) kms_mmap_write_crc (main)
[303.208061] Starting subtest: main
[303.209859] Starting dynamic subtest: pipe-A-HDMI-A-1
[304.598076] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.389s)
[304.598817] Subtest main: SUCCESS (1.390s)
[304.703856] [071/137] (734s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[304.796346] Starting subtest: psr-2p-pri-indfb-multidraw
[304.797746] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[304.849462] [072/137] (734s left) gem_sync (basic-many-each)
[304.898512] Starting subtest: basic-many-each
[307.105840] Subtest basic-many-each: SUCCESS (2.208s)
[307.264737] [073/137] (732s left) i915_pm_dc (dc5-psr)
[308.382711] Starting subtest: dc5-psr
[308.384230] Subtest dc5-psr: SKIP (0.000s)
[308.418190] [074/137] (730s left) kms_ccs (pipe-a-bad-aux-stride-y_tiled_gen12_rc_ccs)
[308.597287] Starting subtest: pipe-A-bad-aux-stride-y_tiled_gen12_rc_ccs
[308.598084] Subtest pipe-A-bad-aux-stride-y_tiled_gen12_rc_ccs: SUCCESS (0.000s)
[308.856773] [075/137] (730s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[308.931855] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[308.935195] Starting dynamic subtest: A-HDMI-A1
[309.652339] Dynamic subtest A-HDMI-A1: SUCCESS (0.716s)
[309.657268] Starting dynamic subtest: B-HDMI-A1
[310.238180] Dynamic subtest B-HDMI-A1: SUCCESS (0.585s)
[310.244285] Starting dynamic subtest: C-HDMI-A1
[310.823145] Dynamic subtest C-HDMI-A1: SUCCESS (0.585s)
[310.828025] Starting dynamic subtest: D-HDMI-A1
[311.396882] Dynamic subtest D-HDMI-A1: SUCCESS (0.573s)
[311.398801] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (2.467s)
[311.484058] [076/137] (727s left) kms_sequence (get-forked)
[311.576170] Starting subtest: get-forked
[311.576939] Starting dynamic subtest: HDMI-A-1-pipe-A
[312.785622] Dynamic subtest HDMI-A-1-pipe-A: SUCCESS (1.209s)
[312.791922] Starting dynamic subtest: HDMI-A-1-pipe-B
[313.990365] Dynamic subtest HDMI-A-1-pipe-B: SUCCESS (1.203s)
[313.995122] Starting dynamic subtest: HDMI-A-1-pipe-C
[315.199120] Dynamic subtest HDMI-A-1-pipe-C: SUCCESS (1.208s)
[315.206442] Starting dynamic subtest: HDMI-A-1-pipe-D
[316.402921] Dynamic subtest HDMI-A-1-pipe-D: SUCCESS (1.202s)
[316.403717] Subtest get-forked: SUCCESS (4.828s)
[316.474006] [077/137] (722s left) drm_fdinfo (busy)
[316.518574] Starting subtest: busy
[316.519321] Starting dynamic subtest: rcs0
[317.030565] Dynamic subtest rcs0: SUCCESS (0.513s)
[317.035551] Starting dynamic subtest: bcs0
[317.540648] Dynamic subtest bcs0: SUCCESS (0.510s)
[317.545718] Starting dynamic subtest: vcs0
[318.050637] Dynamic subtest vcs0: SUCCESS (0.510s)
[318.055482] Starting dynamic subtest: vcs1
[318.560626] Dynamic subtest vcs1: SUCCESS (0.510s)
[318.565540] Starting dynamic subtest: vecs0
[319.072642] Dynamic subtest vecs0: SUCCESS (0.512s)
[319.073356] Subtest busy: SUCCESS (2.555s)
[319.107656] [078/137] (720s left) kms_color (legacy-gamma-reset)
[319.196900] Starting subtest: legacy-gamma-reset
[319.197658] Starting dynamic subtest: pipe-A-HDMI-A-1
[319.344452] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.147s)
[319.349793] Starting dynamic subtest: pipe-B-HDMI-A-1
[320.508562] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.163s)
[320.514277] Starting dynamic subtest: pipe-C-HDMI-A-1
[321.667735] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.157s)
[321.673656] Starting dynamic subtest: pipe-D-HDMI-A-1
[322.841514] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.172s)
[322.842204] Subtest legacy-gamma-reset: SUCCESS (3.645s)
[322.914974] [079/137] (716s left) gen9_exec_parse (allowed-all)
[322.960512] Subtest allowed-all: SKIP (0.000s)
[322.982952] [080/137] (716s left) gem_close_race (multigpu-basic-process)
[323.036057] Starting subtest: multigpu-basic-process
[323.037528] Subtest multigpu-basic-process: SKIP (0.000s)
[323.172042] [081/137] (716s left) gem_mmap_offset (bad-flags)
[323.213453] Starting subtest: bad-flags
[323.214160] Subtest bad-flags: SUCCESS (0.000s)
[323.271995] [082/137] (716s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[323.312965] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[323.313766] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[323.346849] [083/137] (716s left) gem_softpin (allocator-basic-reserve)
[323.390345] Starting subtest: allocator-basic-reserve
[323.447465] Subtest allocator-basic-reserve: SUCCESS (0.057s)
[323.497159] [084/137] (715s left) kms_properties (invalid-properties-atomic)
[323.585810] Starting subtest: invalid-properties-atomic
[324.033367] Subtest invalid-properties-atomic: SUCCESS (0.448s)
[324.072051] [085/137] (715s left) kms_psr (psr2_primary_page_flip)
[324.114125] Subtest psr2_primary_page_flip: SKIP (0.000s)
[324.132972] [086/137] (715s left) debugfs_test (read_all_entries)
[324.175790] Starting subtest: read_all_entries
[324.261696] Subtest read_all_entries: SUCCESS (0.085s)
[324.338910] [087/137] (715s left) syncobj_timeline (invalid-multi-wait-available-unsubmitted-submitted-signaled
[324.381711] Starting subtest: invalid-multi-wait-available-unsubmitted-submitted-signaled
[324.382515] Subtest invalid-multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[324.414139] [088/137] (715s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[324.454898] Starting subtest: cpuset-basic-small-copy-XY
[329.981275] Subtest cpuset-basic-small-copy-XY: SUCCESS (5.526s)
[330.014610] [089/137] (709s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[330.101121] Starting subtest: multi-wait-all-for-submit-available-signaled
[330.102162] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[330.143932] [090/137] (709s left) kms_psr (primary_blt)
[330.197566] Subtest primary_blt: SKIP (0.000s)
[330.216827] [091/137] (709s left) v3d/v3d_job_submission (array-job-submission)
[330.286192] Subtest array-job-submission: SKIP (0.000s)
[330.316026] [092/137] (709s left) kms_rotation_crc (sprite-rotation-270)
[330.415209] Starting subtest: sprite-rotation-270
[333.996518] Subtest sprite-rotation-270: SUCCESS (3.582s)
[334.156481] [093/137] (705s left) kms_vblank (pipe-a-wait-busy-hang)
[334.243453] Starting subtest: pipe-A-wait-busy-hang
[348.513397] Subtest pipe-A-wait-busy-hang: SUCCESS (14.269s)
[348.618072] [094/137] (690s left) gem_ctx_persistence (engines-mixed)
[348.664090] Starting subtest: engines-mixed
[348.664935] Starting dynamic subtest: rcs0
[348.701830] Dynamic subtest rcs0: SUCCESS (0.037s)
[348.708450] Starting dynamic subtest: bcs0
[348.743712] Dynamic subtest bcs0: SUCCESS (0.042s)
[348.748842] Starting dynamic subtest: vcs0
[348.783212] Dynamic subtest vcs0: SUCCESS (0.039s)
[348.797992] Starting dynamic subtest: vcs1
[348.827366] Dynamic subtest vcs1: SUCCESS (0.043s)
[348.839983] Starting dynamic subtest: vecs0
[348.870284] Dynamic subtest vecs0: SUCCESS (0.042s)
[348.871435] Subtest engines-mixed: SUCCESS (0.206s)
[348.920868] [095/137] (690s left) gem_eio (in-flight-10ms)
[348.974653] Starting subtest: in-flight-10ms
[351.162663] Subtest in-flight-10ms: SUCCESS (2.187s)
[351.237663] [096/137] (688s left) gem_flink_basic (bad-open)
[351.279518] Starting subtest: bad-open
[351.280263] Subtest bad-open: SUCCESS (0.000s)
[351.318383] [097/137] (688s left) gem_sync (basic-store-all)
[351.377268] Starting subtest: basic-store-all
[353.534751] Subtest basic-store-all: SUCCESS (2.159s)
[353.687333] [098/137] (685s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[353.785056] Starting subtest: yf-tiled-addfb-size-overflow
[353.786533] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[353.843639] [099/137] (685s left) kms_vblank (pipe-c-accuracy-idle)
[353.928456] Starting subtest: pipe-C-accuracy-idle
[355.168751] Subtest pipe-C-accuracy-idle: SUCCESS (1.241s)
[355.262288] [100/137] (684s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[355.357006] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[355.665310] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.308s)
[355.763422] [101/137] (683s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[355.850787] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[355.863875] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.012s)
[355.903708] [102/137] (683s left) kms_ccs (pipe-a-bad-rotation-90-y_tiled_gen12_mc_ccs)
[356.039986] Starting subtest: pipe-A-bad-rotation-90-y_tiled_gen12_mc_ccs
[356.041621] Subtest pipe-A-bad-rotation-90-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[356.329750] [103/137] (683s left) kms_setmode (clone-exclusive-crtc)
[356.371386] Starting subtest: clone-exclusive-crtc
[356.373596] Subtest clone-exclusive-crtc: SKIP (0.000s)
[356.404575] [104/137] (683s left) vc4/vc4_label_bo (set-kernel-name)
[356.467162] Subtest set-kernel-name: SKIP (0.000s)
[356.496825] [105/137] (683s left) perf (invalid-open-flags)
[356.578937] Starting subtest: invalid-open-flags
[356.580397] Subtest invalid-open-flags: SUCCESS (0.000s)
[356.593752] [106/137] (683s left) gem_exec_endless (dispatch)
[356.642760] Starting subtest: dispatch
[356.643534] Starting dynamic subtest: rcs0
[356.646086] Dynamic subtest rcs0: SUCCESS (0.002s)
[356.651677] Starting dynamic subtest: bcs0
[356.653348] Dynamic subtest bcs0: SUCCESS (0.002s)
[356.658671] Starting dynamic subtest: vcs0
[356.660112] Dynamic subtest vcs0: SUCCESS (0.002s)
[356.665424] Starting dynamic subtest: vcs1
[356.666759] Dynamic subtest vcs1: SUCCESS (0.002s)
[356.671667] Starting dynamic subtest: vecs0
[356.672982] Dynamic subtest vecs0: SUCCESS (0.002s)
[356.673644] Subtest dispatch: SUCCESS (0.011s)
[356.728005] [107/137] (682s left) core_getclient
[356.812678] [108/137] (682s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[356.910593] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[356.911950] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[356.954634] [109/137] (682s left) gem_eio (context-create)
[357.000933] Starting subtest: context-create
[357.033515] Subtest context-create: SUCCESS (0.032s)
[357.109177] [110/137] (682s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[357.154916] Starting subtest: tiled-to-tiled
[357.285578] Subtest tiled-to-tiled: SUCCESS (0.121s)
[357.346180] [111/137] (682s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[357.448902] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[357.450366] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[357.505364] [112/137] (682s left) vc4/vc4_purgeable_bo (mark-purgeable)
[357.567648] Subtest mark-purgeable: SKIP (0.000s)
[357.597873] [113/137] (682s left) gem_lmem_swapping (parallel-multi)
[357.646181] Subtest parallel-multi: SKIP (0.000s)
[357.665048] [114/137] (682s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[357.712060] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[357.712823] Starting dynamic subtest: smem
[357.784661] Dynamic subtest smem: SUCCESS (0.072s)
[357.785413] Subtest mixed-tiled-to-yf-tiled-ccs: SUCCESS (0.073s)
[357.942536] [115/137] (681s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[358.043316] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[359.134132] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (1.093s)
[359.229448] [116/137] (680s left) kms_flip (2x-absolute-wf_vblank)
[359.307801] Starting subtest: 2x-absolute-wf_vblank
[359.319428] Subtest 2x-absolute-wf_vblank: SKIP (0.012s)
[359.365258] [117/137] (680s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[359.460995] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[359.462691] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[359.507122] [118/137] (680s left) gem_exec_params (no-blt)
[359.552212] Starting subtest: no-blt
[359.552963] Subtest no-blt: SUCCESS (0.001s)
[359.631784] [119/137] (680s left) core_getstats
[359.722998] [120/137] (680s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[359.824022] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[359.825435] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[359.880368] [121/137] (679s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[359.969038] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[359.970746] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[360.032333] [122/137] (679s left) gen9_exec_parse (shadow-peek)
[360.078330] Subtest shadow-peek: SKIP (0.000s)
[360.098975] [123/137] (679s left) i915_query (query-topology-garbage-items)
[360.141990] Starting subtest: query-topology-garbage-items
[360.142830] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[360.182388] [124/137] (679s left) gem_ctx_persistence (processes)
[360.234893] Starting subtest: processes
[360.630843] Subtest processes: SUCCESS (0.389s)
[360.663954] [125/137] (679s left) gem_pwrite (basic-random)
[360.704180] Starting subtest: basic-random
[366.171230] Subtest basic-random: SUCCESS (5.465s)
[366.225652] [126/137] (673s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[366.356462] Starting subtest: 4-tiled-64bpp-rotate-90
[366.357881] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.000s)
[366.406637] [127/137] (673s left) kms_cursor_crc (cursor-onscreen-32x10)
[366.495684] Starting subtest: cursor-onscreen-32x10
[366.582434] Subtest cursor-onscreen-32x10: SKIP (0.085s)
[366.647948] [128/137] (673s left) kms_plane_scaling (plane-downscale-with-modifiers-factor-0-25)
[366.732920] Starting subtest: plane-downscale-with-modifiers-factor-0-25
[366.734679] Starting dynamic subtest: pipe-A-HDMI-A-1
[366.748369] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.013s)
[366.753542] Starting dynamic subtest: pipe-B-HDMI-A-1
[366.775016] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.026s)
[366.780200] Starting dynamic subtest: pipe-C-HDMI-A-1
[366.801418] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.026s)
[366.806668] Starting dynamic subtest: pipe-D-HDMI-A-1
[366.829083] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.025s)
[366.830464] Subtest plane-downscale-with-modifiers-factor-0-25: SKIP (0.095s)
[366.889595] [129/137] (673s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[366.980572] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[366.981949] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[367.039435] [130/137] (672s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[367.090168] Starting subtest: stress-mm-invalidate-close-overlap
[369.238453] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[369.315342] [131/137] (670s left) kms_ccs (pipe-a-random-ccs-data-y_tiled_ccs)
[369.479798] Starting subtest: pipe-A-random-ccs-data-y_tiled_ccs
[369.481878] Subtest pipe-A-random-ccs-data-y_tiled_ccs: SKIP (0.000s)
[369.760960] [132/137] (670s left) kms_chamelium_frames (vga-frame-dump)
[369.893343] Subtest vga-frame-dump: SKIP (0.000s)
[369.948091] [133/137] (670s left) v3d/v3d_create_bo (create-bo-0)
[370.013324] Subtest create-bo-0: SKIP (0.000s)
[370.044449] [134/137] (669s left) kms_psr2_sf (overlay-plane-move-continuous-sf)
[370.090215] Subtest overlay-plane-move-continuous-sf: SKIP (0.000s)
[370.113334] [135/137] (669s left) kms_rmfb (rmfb-ioctl)
[370.202850] Starting subtest: rmfb-ioctl
[370.203671] Starting dynamic subtest: pipe-A-HDMI-A-1
[370.295760] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.092s)
[370.302418] Starting dynamic subtest: pipe-B-HDMI-A-1
[370.453282] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.156s)
[370.460074] Starting dynamic subtest: pipe-C-HDMI-A-1
[370.604138] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.150s)
[370.612107] Starting dynamic subtest: pipe-D-HDMI-A-1
[370.752882] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.148s)
[370.753649] Subtest rmfb-ioctl: SUCCESS (0.550s)
[370.891377] [136/137] (669s left) i915_pm_rpm (dpms-mode-unset-lpsp)
[372.448530] Starting subtest: dpms-mode-unset-lpsp
[376.333271] Subtest dpms-mode-unset-lpsp: SUCCESS (3.884s)
[376.466155] [137/137] (663s left) kms_ccs (pipe-d-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc)
[376.795348] Starting subtest: pipe-D-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc
[376.951656] Subtest pipe-D-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc: SUCCESS (0.156s)
[377.096133] Closing watchdogs
Done.