[43.553359] Initializing watchdogs
[43.553438]   /dev/watchdog0
[43.559509] [001/137] (960s left) feature_discovery (display-2x)
[45.531925] Starting subtest: display-2x
[45.533783] Subtest display-2x: SKIP (0.000s)
[45.598849] [002/137] (958s left) perf_pmu (rc6-suspend)
[45.676782] Starting subtest: rc6-suspend
[72.319887] Subtest rc6-suspend: SUCCESS (15.205s)
[73.587080] [003/137] (943s left) gem_exec_schedule (u-submit-early-slice)
[73.669290] Starting subtest: u-submit-early-slice
[73.670230] Starting dynamic subtest: rcs0
[73.723932] Dynamic subtest rcs0: SUCCESS (0.055s)
[73.729933] Starting dynamic subtest: bcs0
[73.758754] Dynamic subtest bcs0: SUCCESS (0.035s)
[73.764884] Starting dynamic subtest: vcs0
[73.792473] Dynamic subtest vcs0: SUCCESS (0.034s)
[73.798440] Starting dynamic subtest: vcs1
[73.825793] Dynamic subtest vcs1: SUCCESS (0.033s)
[73.831791] Starting dynamic subtest: vecs0
[73.858769] Dynamic subtest vecs0: SUCCESS (0.032s)
[73.860436] Subtest u-submit-early-slice: SUCCESS (0.189s)
[74.255104] [004/137] (942s left) gem_softpin (safe-alignment)
[74.331155] Starting subtest: safe-alignment
[74.364621] Subtest safe-alignment: SUCCESS (0.033s)
[74.487299] [005/137] (942s left) kms_cursor_edge_walk (128x128-top-bottom)
[76.456319] Starting subtest: 128x128-top-bottom
[76.457052] Starting dynamic subtest: pipe-A-HDMI-A-4
[79.845191] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (3.388s)
[79.852493] Starting dynamic subtest: pipe-D-HDMI-A-4
[83.059530] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (3.213s)
[83.060387] Subtest 128x128-top-bottom: SUCCESS (6.605s)
[83.178958] [006/137] (933s left) prime_vgem (coherency-blt)
[83.285249] Starting subtest: coherency-blt
[85.382102] Subtest coherency-blt: SUCCESS (2.094s)
[85.469022] [007/137] (931s left) gem_exec_whisper (basic-contexts-forked)
[85.542135] Starting subtest: basic-contexts-forked
[107.839829] Subtest basic-contexts-forked: SUCCESS (22.294s)
[108.028604] [008/137] (908s left) kms_ccs (pipe-d-bad-pixel-format-y_tiled_gen12_mc_ccs)
[110.293746] Starting subtest: pipe-D-bad-pixel-format-y_tiled_gen12_mc_ccs
[110.295935] Subtest pipe-D-bad-pixel-format-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[110.466675] [009/137] (906s left) kms_addfb_basic (size-max)
[112.427806] Starting subtest: size-max
[112.428790] Subtest size-max: SUCCESS (0.000s)
[116.337454] [010/137] (900s left) kms_vrr (negative-basic)
[118.302974] Starting subtest: negative-basic
[118.305346] Subtest negative-basic: SKIP (0.000s)
[118.325367] [011/137] (898s left) kms_properties (plane-properties-legacy)
[120.291104] Starting subtest: plane-properties-legacy
[122.039913] Subtest plane-properties-legacy: SUCCESS (1.744s)
[122.164350] [012/137] (894s left) kms_ccs (pipe-b-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc)
[124.293429] Starting subtest: pipe-B-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc
[124.294546] Subtest pipe-B-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc: SUCCESS (0.000s)
[124.585836] [013/137] (892s left) gem_mmap_gtt (hang)
[124.647296] Subtest hang: SKIP (0.000s)
[124.679428] [014/137] (892s left) kms_ccs (pipe-d-random-ccs-data-y_tiled_gen12_rc_ccs)
[126.974759] Starting subtest: pipe-D-random-ccs-data-y_tiled_gen12_rc_ccs
[127.084569] Subtest pipe-D-random-ccs-data-y_tiled_gen12_rc_ccs: SUCCESS (0.110s)
[127.248948] [015/137] (889s left) device_reset (unbind-cold-reset-rebind)
[127.355208] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[127.415518] [016/137] (889s left) gem_exec_suspend (basic-s3)
[127.483602] Starting subtest: basic-S3
[127.484582] Starting dynamic subtest: smem
[151.253925] Dynamic subtest smem: SUCCESS (11.980s)
[151.263447] Starting dynamic subtest: lmem0
[175.157635] Dynamic subtest lmem0: SUCCESS (11.604s)
[175.158702] Subtest basic-S3: SUCCESS (23.584s)
[181.366376] [017/137] (865s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[183.393712] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[183.395721] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[183.468267] [018/137] (863s left) kms_plane_cursor (primary)
[185.450066] Starting subtest: primary
[185.452134] Starting dynamic subtest: pipe-A-HDMI-A-4-size-64
[189.085467] Dynamic subtest pipe-A-HDMI-A-4-size-64: SUCCESS (3.634s)
[189.141802] Starting dynamic subtest: pipe-A-HDMI-A-4-size-128
[192.768300] Dynamic subtest pipe-A-HDMI-A-4-size-128: SUCCESS (3.633s)
[192.825242] Starting dynamic subtest: pipe-A-HDMI-A-4-size-256
[196.384401] Dynamic subtest pipe-A-HDMI-A-4-size-256: SUCCESS (3.566s)
[196.465735] Starting dynamic subtest: pipe-B-HDMI-A-4-size-64
[200.020897] Dynamic subtest pipe-B-HDMI-A-4-size-64: SUCCESS (3.561s)
[200.062553] Starting dynamic subtest: pipe-B-HDMI-A-4-size-128
[203.620527] Dynamic subtest pipe-B-HDMI-A-4-size-128: SUCCESS (3.566s)
[203.663903] Starting dynamic subtest: pipe-B-HDMI-A-4-size-256
[207.136433] Dynamic subtest pipe-B-HDMI-A-4-size-256: SUCCESS (3.483s)
[207.202291] Starting dynamic subtest: pipe-C-HDMI-A-4-size-64
[210.643603] Dynamic subtest pipe-C-HDMI-A-4-size-64: SUCCESS (3.448s)
[210.686159] Starting dynamic subtest: pipe-C-HDMI-A-4-size-128
[214.243232] Dynamic subtest pipe-C-HDMI-A-4-size-128: SUCCESS (3.566s)
[214.288566] Starting dynamic subtest: pipe-C-HDMI-A-4-size-256
[217.809400] Dynamic subtest pipe-C-HDMI-A-4-size-256: SUCCESS (3.532s)
[217.879549] Starting dynamic subtest: pipe-D-HDMI-A-4-size-64
[221.348142] Dynamic subtest pipe-D-HDMI-A-4-size-64: SUCCESS (3.479s)
[221.390554] Starting dynamic subtest: pipe-D-HDMI-A-4-size-128
[224.981159] Dynamic subtest pipe-D-HDMI-A-4-size-128: SUCCESS (3.599s)
[225.022771] Starting dynamic subtest: pipe-D-HDMI-A-4-size-256
[228.647299] Dynamic subtest pipe-D-HDMI-A-4-size-256: SUCCESS (3.633s)
[228.704340] Subtest primary: SUCCESS (43.255s)
[228.853857] [019/137] (818s left) gem_exec_schedule (fairslice-all)
[228.924460] Starting subtest: fairslice-all
[230.982635] Subtest fairslice-all: SUCCESS (2.058s)
[231.364454] [020/137] (815s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[233.356742] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[233.357696] Starting dynamic subtest: pipe-A-valid-mode
[233.394263] Dynamic subtest pipe-A-valid-mode: SKIP (0.037s)
[233.396248] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.038s)
[233.481169] [021/137] (813s left) kms_ccs (pipe-b-bad-pixel-format-4_tiled_dg2_rc_ccs_cc)
[235.565039] Starting subtest: pipe-B-bad-pixel-format-4_tiled_dg2_rc_ccs_cc
[235.566607] Subtest pipe-B-bad-pixel-format-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[235.904373] [022/137] (811s left) syncobj_wait (invalid-reset-zero-handles)
[235.966936] Starting subtest: invalid-reset-zero-handles
[235.967789] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[236.020858] [023/137] (811s left) kms_big_fb (linear-32bpp-rotate-0)
[237.997559] Starting subtest: linear-32bpp-rotate-0
[239.959212] Subtest linear-32bpp-rotate-0: SUCCESS (1.958s)
[240.071619] [024/137] (807s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[242.095363] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[242.152909] [025/137] (805s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[244.122783] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[244.124764] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[244.206144] [026/137] (803s left) i915_pm_rpm (system-suspend)
[248.485125] Starting subtest: system-suspend
[272.240276] Subtest system-suspend: SUCCESS (11.871s)
[278.350026] [027/137] (785s left) v3d/v3d_submit_csd (bad-extension)
[278.436728] Subtest bad-extension: SKIP (0.000s)
[278.484632] [028/137] (785s left) kms_ccs (pipe-c-crc-sprite-planes-basic-yf_tiled_ccs)
[280.727282] Starting subtest: pipe-C-crc-sprite-planes-basic-yf_tiled_ccs
[280.731359] Subtest pipe-C-crc-sprite-planes-basic-yf_tiled_ccs: SKIP (0.003s)
[280.912170] [029/137] (783s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[282.891011] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[284.046953] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.155s)
[284.146169] [030/137] (780s left) kms_async_flips (alternate-sync-async-flip)
[286.119241] Starting subtest: alternate-sync-async-flip
[286.120193] Starting dynamic subtest: pipe-A-HDMI-A-4
[290.060352] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (3.939s)
[290.067609] Starting dynamic subtest: pipe-B-HDMI-A-4
[293.818422] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (3.757s)
[293.825679] Starting dynamic subtest: pipe-C-HDMI-A-4
[297.191024] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (3.371s)
[297.198329] Starting dynamic subtest: pipe-D-HDMI-A-4
[300.194439] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (3.002s)
[300.195417] Subtest alternate-sync-async-flip: SUCCESS (14.074s)
[300.878951] [031/137] (763s left) api_intel_allocator (reopen-fork)
[300.943353] Starting subtest: reopen-fork
[304.187172] Subtest reopen-fork: SUCCESS (3.241s)
[304.282572] [032/137] (759s left) syncobj_timeline (wait-all-delayed-signal)
[304.347513] Starting subtest: wait-all-delayed-signal
[304.455764] Subtest wait-all-delayed-signal: SUCCESS (0.104s)
[304.584790] [033/137] (759s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[306.579286] Starting subtest: 4-tiled-addfb-size-offset-overflow
[306.581174] Subtest 4-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[306.644948] [034/137] (757s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[308.638098] Starting subtest: psr-rgb101010-draw-pwrite
[308.640292] Subtest psr-rgb101010-draw-pwrite: SKIP (0.000s)
[308.711019] [035/137] (755s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[310.702634] Starting subtest: fbc-rgb565-draw-mmap-gtt
[310.704600] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[310.777281] [036/137] (753s left) gem_exec_reloc (basic-cpu-gtt-active)
[310.861191] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[310.904518] [037/137] (753s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[310.970275] Starting subtest: invalid-bsd1-flag-on-blt
[310.971303] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[311.114916] [038/137] (753s left) prime_vgem (fence-flip-hang)
[311.201182] Subtest fence-flip-hang: SKIP (0.000s)
[311.283153] [039/137] (753s left) kms_addfb_basic (tile-pitch-mismatch)
[317.074606] Starting subtest: tile-pitch-mismatch
[317.076771] Subtest tile-pitch-mismatch: SKIP (0.000s)
[317.144309] [040/137] (747s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[319.124300] Starting subtest: 2x-flip-vs-cursor-atomic
[319.128902] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.003s)
[319.196828] [041/137] (745s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[321.182116] Starting subtest: fbcpsr-rgb565-draw-pwrite
[321.184252] Subtest fbcpsr-rgb565-draw-pwrite: SKIP (0.000s)
[321.259391] [042/137] (743s left) kms_ccs (pipe-c-crc-primary-basic-y_tiled_ccs)
[323.462699] Starting subtest: pipe-C-crc-primary-basic-y_tiled_ccs
[323.464623] Subtest pipe-C-crc-primary-basic-y_tiled_ccs: SKIP (0.000s)
[323.703242] [043/137] (740s left) kms_addfb_basic (too-high)
[325.670022] Starting subtest: too-high
[325.671010] Subtest too-high: SUCCESS (0.000s)
[329.568592] [044/137] (734s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[331.552202] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[331.553369] Starting dynamic subtest: pipe-A-HDMI-A-4
[331.773620] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.221s)
[331.781795] Starting dynamic subtest: pipe-B-HDMI-A-4
[331.945545] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.170s)
[331.953875] Starting dynamic subtest: pipe-C-HDMI-A-4
[332.117562] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.170s)
[332.125914] Starting dynamic subtest: pipe-D-HDMI-A-4
[332.289595] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.170s)
[332.290501] Subtest planes-unity-scaling-downscale-factor-0-5: SUCCESS (0.740s)
[332.428707] [045/137] (732s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[334.392303] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[334.393456] Starting dynamic subtest: pipe-A-valid-mode
[334.481971] Dynamic subtest pipe-A-valid-mode: SKIP (0.088s)
[334.487036] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.091s)
[334.614070] [046/137] (729s left) vc4/vc4_wait_bo (unused-bo-0ns)
[334.698327] Subtest unused-bo-0ns: SKIP (0.000s)
[334.746536] [047/137] (729s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[336.717538] Starting subtest: fbcpsr-tiling-linear
[336.719598] Subtest fbcpsr-tiling-linear: SKIP (0.000s)
[336.797439] [048/137] (727s left) kms_hdr (invalid-metadata-sizes)
[338.783871] Starting subtest: invalid-metadata-sizes
[338.785984] Subtest invalid-metadata-sizes: SKIP (0.000s)
[338.846936] [049/137] (725s left) kms_prop_blob (invalid-set-prop)
[338.914171] Starting subtest: invalid-set-prop
[338.915291] Subtest invalid-set-prop: SUCCESS (0.000s)
[338.986490] [050/137] (725s left) gem_exec_fence (syncobj-timeline-chain-engines)
[339.549312] Starting subtest: syncobj-timeline-chain-engines
[339.642243] Subtest syncobj-timeline-chain-engines: SUCCESS (0.097s)
[339.943563] [051/137] (724s left) gem_exec_schedule (pi-userfault)
[340.151960] Starting subtest: pi-userfault
[340.152898] Starting dynamic subtest: rcs0
[340.156200] Dynamic subtest rcs0: SUCCESS (0.007s)
[340.165254] Starting dynamic subtest: bcs0
[340.166156] Dynamic subtest bcs0: SUCCESS (0.007s)
[340.175433] Starting dynamic subtest: vcs0
[340.176317] Dynamic subtest vcs0: SUCCESS (0.007s)
[340.185741] Starting dynamic subtest: vcs1
[340.186643] Dynamic subtest vcs1: SUCCESS (0.008s)
[340.195867] Starting dynamic subtest: vecs0
[340.196978] Dynamic subtest vecs0: SUCCESS (0.009s)
[340.198095] Subtest pi-userfault: SUCCESS (0.041s)
[340.401027] [052/137] (724s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[340.469334] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[340.470155] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[340.533205] [053/137] (724s left) perf_pmu (busy-idle)
[340.598300] Starting subtest: busy-idle
[340.599222] Starting dynamic subtest: rcs0
[341.269753] Dynamic subtest rcs0: SUCCESS (0.670s)
[341.282806] Starting dynamic subtest: bcs0
[341.922070] Dynamic subtest bcs0: SUCCESS (0.650s)
[341.931310] Starting dynamic subtest: vcs0
[342.571560] Dynamic subtest vcs0: SUCCESS (0.648s)
[342.581485] Starting dynamic subtest: vcs1
[343.221040] Dynamic subtest vcs1: SUCCESS (0.648s)
[343.230329] Starting dynamic subtest: vecs0
[343.868254] Dynamic subtest vecs0: SUCCESS (0.646s)
[343.869409] Subtest busy-idle: SUCCESS (3.270s)
[343.938627] [054/137] (720s left) kms_cursor_crc (cursor-random-128x128)
[346.011911] Starting subtest: cursor-random-128x128
[346.017814] Starting dynamic subtest: pipe-A-HDMI-A-4
[350.618257] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (4.601s)
[350.643638] Starting dynamic subtest: pipe-B-HDMI-A-4
[355.500888] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (4.865s)
[355.526553] Starting dynamic subtest: pipe-C-HDMI-A-4
[360.710587] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (5.189s)
[360.738560] Starting dynamic subtest: pipe-D-HDMI-A-4
[366.124947] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (5.394s)
[366.126095] Subtest cursor-random-128x128: SUCCESS (20.113s)
[366.424890] [055/137] (698s left) gem_exec_reloc (basic-write-wc-active)
[366.491689] Subtest basic-write-wc-active: SKIP (0.000s)
[366.533330] [056/137] (698s left) kms_cursor_legacy (single-move)
[368.501086] Starting subtest: single-move
[368.502219] Starting dynamic subtest: pipe-A
[389.991181] Dynamic subtest pipe-A: SUCCESS (21.486s)
[389.998872] Starting dynamic subtest: pipe-B
[411.476826] Dynamic subtest pipe-B: SUCCESS (21.485s)
[411.484310] Starting dynamic subtest: pipe-C
[432.962479] Dynamic subtest pipe-C: SUCCESS (21.485s)
[432.969825] Starting dynamic subtest: pipe-D
[454.448071] Dynamic subtest pipe-D: SUCCESS (21.485s)
[454.455397] Starting dynamic subtest: all-pipes
[475.934098] Dynamic subtest all-pipes: SUCCESS (21.485s)
[475.935102] Subtest single-move: SUCCESS (107.430s)
[475.994068] [057/137] (588s left) prime_self_import (basic-llseek-size)
[476.052758] Starting subtest: basic-llseek-size
[476.055400] Subtest basic-llseek-size: SUCCESS (0.003s)
[476.161578] [058/137] (588s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[478.161050] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[478.162997] Subtest psr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[478.243207] [059/137] (586s left) gem_ctx_exec (basic-nohangcheck)
[478.322028] Starting subtest: basic-nohangcheck
[478.460981] Subtest basic-nohangcheck: SUCCESS (0.139s)
[478.585719] [060/137] (586s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-gtt)
[480.583238] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-gtt
[480.585472] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[480.662708] [061/137] (584s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[482.655664] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[482.657631] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[482.743331] [062/137] (582s left) kms_ccs (pipe-b-crc-primary-basic-y_tiled_ccs)
[484.876890] Starting subtest: pipe-B-crc-primary-basic-y_tiled_ccs
[484.878980] Subtest pipe-B-crc-primary-basic-y_tiled_ccs: SKIP (0.001s)
[485.201630] [063/137] (579s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[487.177791] Starting subtest: y-tiled-16bpp-rotate-270
[488.755363] Subtest y-tiled-16bpp-rotate-270: SUCCESS (1.573s)
[488.869727] [064/137] (575s left) gem_exec_reloc (basic-cpu-read-noreloc)
[488.938531] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[488.977134] [065/137] (575s left) kms_addfb_basic (invalid-set-prop-any)
[494.754153] Starting subtest: invalid-set-prop-any
[494.755198] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[494.833940] [066/137] (570s left) kms_vblank (pipe-b-ts-continuation-idle-hang)
[496.817165] Starting subtest: pipe-B-ts-continuation-idle-hang
[510.748774] Subtest pipe-B-ts-continuation-idle-hang: SUCCESS (13.934s)
[510.870740] [067/137] (554s left) kms_vblank (pipe-b-wait-forked-busy-hang)
[512.838405] Starting subtest: pipe-B-wait-forked-busy-hang
[526.738290] Subtest pipe-B-wait-forked-busy-hang: SUCCESS (13.901s)
[526.857634] [068/137] (538s left) gem_exec_balancer (parallel-ordering)
[527.146816] Starting subtest: parallel-ordering
[528.444698] Subtest parallel-ordering: SUCCESS (1.298s)
[528.542275] [069/137] (536s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[530.510016] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[530.512024] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.002s)
[530.572909] [070/137] (534s left) kms_mmap_write_crc (main)
[532.550656] Starting subtest: main
[532.553096] Starting dynamic subtest: pipe-A-HDMI-A-4
[536.478430] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (3.926s)
[536.479382] Subtest main: SUCCESS (3.927s)
[536.608027] [071/137] (528s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[538.576153] Starting subtest: psr-2p-pri-indfb-multidraw
[538.578041] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[538.656318] [072/137] (526s left) gem_sync (basic-many-each)
[538.746297] Starting subtest: basic-many-each
[541.159689] Subtest basic-many-each: SUCCESS (2.414s)
[541.408831] [073/137] (523s left) i915_pm_dc (dc5-psr)
[544.396060] Starting subtest: dc5-psr
[544.398182] Subtest dc5-psr: SKIP (0.000s)
[544.644628] [074/137] (520s left) kms_ccs (pipe-a-bad-aux-stride-y_tiled_gen12_rc_ccs)
[546.752824] Starting subtest: pipe-A-bad-aux-stride-y_tiled_gen12_rc_ccs
[546.753810] Subtest pipe-A-bad-aux-stride-y_tiled_gen12_rc_ccs: SUCCESS (0.001s)
[547.114237] [075/137] (517s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[548.134261] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[548.145710] Starting dynamic subtest: A-HDMI-A4
[548.884231] Dynamic subtest A-HDMI-A4: SUCCESS (0.739s)
[548.891906] Starting dynamic subtest: B-HDMI-A4
[549.519958] Dynamic subtest B-HDMI-A4: SUCCESS (0.634s)
[549.527464] Starting dynamic subtest: C-HDMI-A4
[550.224772] Dynamic subtest C-HDMI-A4: SUCCESS (0.704s)
[550.232848] Starting dynamic subtest: D-HDMI-A4
[550.820979] Dynamic subtest D-HDMI-A4: SUCCESS (0.595s)
[550.822099] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (2.686s)
[550.937256] [076/137] (514s left) kms_sequence (get-forked)
[552.905819] Starting subtest: get-forked
[552.906685] Starting dynamic subtest: HDMI-A-4-pipe-A
[555.209551] Dynamic subtest HDMI-A-4-pipe-A: SUCCESS (2.302s)
[555.221163] Starting dynamic subtest: HDMI-A-4-pipe-B
[557.822551] Dynamic subtest HDMI-A-4-pipe-B: SUCCESS (2.611s)
[557.833632] Starting dynamic subtest: HDMI-A-4-pipe-C
[560.811109] Dynamic subtest HDMI-A-4-pipe-C: SUCCESS (2.987s)
[560.822841] Starting dynamic subtest: HDMI-A-4-pipe-D
[564.181348] Dynamic subtest HDMI-A-4-pipe-D: SUCCESS (3.368s)
[564.182359] Subtest get-forked: SUCCESS (11.276s)
[564.296948] [077/137] (500s left) drm_fdinfo (busy)
[564.363316] Subtest busy: SKIP (0.000s)
[564.389806] [078/137] (500s left) kms_color (legacy-gamma-reset)
[566.354806] Starting subtest: legacy-gamma-reset
[566.357793] Starting dynamic subtest: pipe-A-HDMI-A-4
[568.114849] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (1.757s)
[568.122632] Starting dynamic subtest: pipe-B-HDMI-A-4
[569.798375] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (1.683s)
[569.807368] Starting dynamic subtest: pipe-C-HDMI-A-4
[571.474674] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (1.674s)
[571.484454] Starting dynamic subtest: pipe-D-HDMI-A-4
[573.152004] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (1.675s)
[573.153043] Subtest legacy-gamma-reset: SUCCESS (6.797s)
[573.244352] [079/137] (491s left) gen9_exec_parse (allowed-all)
[573.313037] Subtest allowed-all: SKIP (0.000s)
[573.339416] [080/137] (491s left) gem_close_race (multigpu-basic-process)
[573.419320] Starting subtest: multigpu-basic-process
[573.421160] Subtest multigpu-basic-process: SKIP (0.000s)
[573.642320] [081/137] (491s left) gem_mmap_offset (bad-flags)
[573.702871] Starting subtest: bad-flags
[573.703758] Subtest bad-flags: SUCCESS (0.000s)
[573.792545] [082/137] (491s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[573.852790] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[573.853579] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[573.908750] [083/137] (491s left) gem_softpin (allocator-basic-reserve)
[573.971513] Starting subtest: allocator-basic-reserve
[574.163701] Subtest allocator-basic-reserve: SUCCESS (0.189s)
[574.258869] [084/137] (490s left) kms_properties (invalid-properties-atomic)
[576.216014] Starting subtest: invalid-properties-atomic
[577.002574] Subtest invalid-properties-atomic: SUCCESS (0.784s)
[577.059873] [085/137] (488s left) kms_psr (psr2_primary_page_flip)
[577.121908] Subtest psr2_primary_page_flip: SKIP (0.000s)
[577.152432] [086/137] (488s left) debugfs_test (read_all_entries)
[577.216125] Starting subtest: read_all_entries
[577.629955] Subtest read_all_entries: SUCCESS (0.413s)
[579.592424] [087/137] (485s left) syncobj_timeline (invalid-multi-wait-available-unsubmitted-submitted-signaled
[579.653089] Starting subtest: invalid-multi-wait-available-unsubmitted-submitted-signaled
[579.653960] Subtest invalid-multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[579.708731] [088/137] (485s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[579.769606] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[579.802040] [089/137] (485s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[579.863099] Starting subtest: multi-wait-all-for-submit-available-signaled
[579.864082] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.001s)
[579.925160] [090/137] (485s left) kms_psr (primary_blt)
[579.986126] Subtest primary_blt: SKIP (0.000s)
[580.018707] [091/137] (485s left) v3d/v3d_job_submission (array-job-submission)
[580.109084] Subtest array-job-submission: SKIP (0.000s)
[580.158934] [092/137] (485s left) kms_rotation_crc (sprite-rotation-270)
[582.124854] Starting subtest: sprite-rotation-270
[589.286727] Subtest sprite-rotation-270: SUCCESS (7.161s)
[589.453664] [093/137] (475s left) kms_vblank (pipe-a-wait-busy-hang)
[591.421954] Starting subtest: pipe-A-wait-busy-hang
[604.774407] Subtest pipe-A-wait-busy-hang: SUCCESS (13.354s)
[604.877310] [094/137] (460s left) gem_ctx_persistence (engines-mixed)
[604.941796] Starting subtest: engines-mixed
[604.942610] Starting dynamic subtest: rcs0
[605.001291] Dynamic subtest rcs0: SUCCESS (0.059s)
[605.009254] Starting dynamic subtest: bcs0
[605.043875] Dynamic subtest bcs0: SUCCESS (0.042s)
[605.059099] Starting dynamic subtest: vcs0
[605.087410] Dynamic subtest vcs0: SUCCESS (0.042s)
[605.098279] Starting dynamic subtest: vcs1
[605.134828] Dynamic subtest vcs1: SUCCESS (0.046s)
[605.157499] Starting dynamic subtest: vecs0
[605.189755] Dynamic subtest vecs0: SUCCESS (0.053s)
[605.192201] Subtest engines-mixed: SUCCESS (0.247s)
[605.325282] [095/137] (460s left) gem_eio (in-flight-10ms)
[605.508111] Starting subtest: in-flight-10ms
[609.721820] Subtest in-flight-10ms: SUCCESS (4.214s)
[611.769747] [096/137] (453s left) gem_flink_basic (bad-open)
[611.829343] Starting subtest: bad-open
[611.830286] Subtest bad-open: SUCCESS (0.000s)
[611.896939] [097/137] (453s left) gem_sync (basic-store-all)
[611.977698] Starting subtest: basic-store-all
[615.283275] Subtest basic-store-all: SUCCESS (3.306s)
[615.466201] [098/137] (449s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[617.444417] Starting subtest: yf-tiled-addfb-size-overflow
[617.446402] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[617.509883] [099/137] (447s left) kms_vblank (pipe-c-accuracy-idle)
[619.494092] Starting subtest: pipe-C-accuracy-idle
[622.513330] Subtest pipe-C-accuracy-idle: SUCCESS (3.022s)
[622.621600] [100/137] (442s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[624.601259] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[625.137040] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.536s)
[625.239134] [101/137] (440s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[626.256108] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[626.282343] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.025s)
[626.356221] [102/137] (439s left) kms_ccs (pipe-a-bad-rotation-90-y_tiled_gen12_mc_ccs)
[628.397060] Starting subtest: pipe-A-bad-rotation-90-y_tiled_gen12_mc_ccs
[628.399902] Subtest pipe-A-bad-rotation-90-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[628.819741] [103/137] (436s left) kms_setmode (clone-exclusive-crtc)
[628.880537] Starting subtest: clone-exclusive-crtc
[628.883566] Subtest clone-exclusive-crtc: SKIP (0.000s)
[628.936542] [104/137] (436s left) vc4/vc4_label_bo (set-kernel-name)
[629.019655] Subtest set-kernel-name: SKIP (0.000s)
[629.069372] [105/137] (436s left) perf (invalid-open-flags)
[629.182180] Starting subtest: invalid-open-flags
[629.183173] Subtest invalid-open-flags: SUCCESS (0.000s)
[629.200480] [106/137] (436s left) gem_exec_endless (dispatch)
[629.278481] Starting subtest: dispatch
[629.279414] Starting dynamic subtest: rcs0
[629.285127] Dynamic subtest rcs0: SUCCESS (0.005s)
[629.293411] Starting dynamic subtest: bcs0
[629.295353] Dynamic subtest bcs0: SUCCESS (0.005s)
[629.303490] Starting dynamic subtest: vcs0
[629.305450] Dynamic subtest vcs0: SUCCESS (0.005s)
[629.314146] Starting dynamic subtest: vcs1
[629.316737] Dynamic subtest vcs1: SUCCESS (0.005s)
[629.325300] Starting dynamic subtest: vecs0
[629.328088] Dynamic subtest vecs0: SUCCESS (0.005s)
[629.329537] Subtest dispatch: SUCCESS (0.029s)
[629.419476] [107/137] (436s left) core_getclient
[629.587270] [108/137] (436s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[631.582555] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[631.584480] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[631.669850] [109/137] (433s left) gem_eio (context-create)
[631.896936] Starting subtest: context-create
[632.193480] Subtest context-create: SUCCESS (0.297s)
[634.304136] [110/137] (431s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[634.374519] Subtest tiled-to-tiled: SKIP (0.000s)
[634.395125] [111/137] (431s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[636.364726] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[636.366605] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[636.452311] [112/137] (429s left) vc4/vc4_purgeable_bo (mark-purgeable)
[636.552096] Subtest mark-purgeable: SKIP (0.000s)
[636.605488] [113/137] (429s left) gem_lmem_swapping (parallel-multi)
[640.086550] Starting subtest: parallel-multi
[640.087284] Starting dynamic subtest: lmem0
[649.606637] Dynamic subtest lmem0: SUCCESS (9.516s)
[649.607588] Subtest parallel-multi: SUCCESS (9.517s)
[650.608958] [114/137] (415s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[653.044508] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[653.045306] Starting dynamic subtest: smem
[653.155165] Dynamic subtest smem: SUCCESS (0.109s)
[653.164195] Starting dynamic subtest: lmem0
[654.106661] Dynamic subtest lmem0: SUCCESS (0.949s)
[654.107586] Subtest mixed-tiled-to-yf-tiled-ccs: SUCCESS (1.059s)
[654.255379] [115/137] (411s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[656.228179] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[658.553340] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (2.326s)
[658.704237] [116/137] (407s left) kms_flip (2x-absolute-wf_vblank)
[659.723258] Starting subtest: 2x-absolute-wf_vblank
[659.748459] Subtest 2x-absolute-wf_vblank: SKIP (0.025s)
[659.818923] [117/137] (405s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[661.821986] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[661.824274] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[661.901987] [118/137] (403s left) gem_exec_params (no-blt)
[661.987962] Starting subtest: no-blt
[661.990651] Subtest no-blt: SUCCESS (0.001s)
[662.112013] [119/137] (403s left) core_getstats
[662.253435] [120/137] (403s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[664.227539] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[664.229540] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[664.319026] [121/137] (401s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[666.316862] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[666.319131] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[666.401271] [122/137] (399s left) gen9_exec_parse (shadow-peek)
[666.484861] Subtest shadow-peek: SKIP (0.000s)
[666.511502] [123/137] (399s left) i915_query (query-topology-garbage-items)
[666.573506] Starting subtest: query-topology-garbage-items
[666.574474] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[666.641525] [124/137] (399s left) gem_ctx_persistence (processes)
[666.728312] Starting subtest: processes
[668.155731] Subtest processes: SUCCESS (1.430s)
[668.225114] [125/137] (397s left) gem_pwrite (basic-random)
[668.286583] Subtest basic-random: SKIP (0.000s)
[668.327698] [126/137] (397s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[670.306722] Starting subtest: 4-tiled-64bpp-rotate-90
[670.308697] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.000s)
[670.384721] [127/137] (395s left) kms_cursor_crc (cursor-onscreen-32x10)
[672.436253] Starting subtest: cursor-onscreen-32x10
[672.519316] Subtest cursor-onscreen-32x10: SKIP (0.080s)
[672.801179] [128/137] (393s left) kms_plane_scaling (plane-downscale-with-modifiers-factor-0-25)
[674.749130] Starting subtest: plane-downscale-with-modifiers-factor-0-25
[674.750267] Starting dynamic subtest: pipe-A-HDMI-A-4
[674.790495] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.040s)
[674.798585] Starting dynamic subtest: pipe-B-HDMI-A-4
[674.828483] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.036s)
[674.837397] Starting dynamic subtest: pipe-C-HDMI-A-4
[674.867182] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.036s)
[674.875271] Starting dynamic subtest: pipe-D-HDMI-A-4
[674.904203] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.036s)
[674.905948] Subtest plane-downscale-with-modifiers-factor-0-25: SKIP (0.156s)
[675.000801] [129/137] (391s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[676.970679] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[676.972717] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[677.050344] [130/137] (388s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[677.138382] Starting subtest: stress-mm-invalidate-close-overlap
[679.289886] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[679.393831] [131/137] (386s left) kms_ccs (pipe-a-random-ccs-data-y_tiled_ccs)
[681.452559] Starting subtest: pipe-A-random-ccs-data-y_tiled_ccs
[681.455048] Subtest pipe-A-random-ccs-data-y_tiled_ccs: SKIP (0.000s)
[681.842247] [132/137] (384s left) kms_chamelium_frames (vga-frame-dump)
[683.848660] Subtest vga-frame-dump: SKIP (0.000s)
[683.905804] [133/137] (382s left) v3d/v3d_create_bo (create-bo-0)
[683.994761] Subtest create-bo-0: SKIP (0.000s)
[684.044111] [134/137] (382s left) kms_psr2_sf (overlay-plane-move-continuous-sf)
[684.105790] Subtest overlay-plane-move-continuous-sf: SKIP (0.000s)
[684.136979] [135/137] (381s left) kms_rmfb (rmfb-ioctl)
[686.103003] Starting subtest: rmfb-ioctl
[686.104052] Starting dynamic subtest: pipe-A-HDMI-A-4
[686.277030] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.173s)
[686.285191] Starting dynamic subtest: pipe-B-HDMI-A-4
[686.483314] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.205s)
[686.491815] Starting dynamic subtest: pipe-C-HDMI-A-4
[686.688367] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.203s)
[686.696446] Starting dynamic subtest: pipe-D-HDMI-A-4
[686.894292] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.204s)
[686.895073] Subtest rmfb-ioctl: SUCCESS (0.792s)
[687.017762] [136/137] (379s left) i915_pm_rpm (dpms-mode-unset-lpsp)
[691.462505] Starting subtest: dpms-mode-unset-lpsp
[693.950606] Subtest dpms-mode-unset-lpsp: SKIP (2.485s)
[695.073384] [137/137] (371s left) kms_ccs (pipe-d-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc)
[697.350635] Starting subtest: pipe-D-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc
[697.656105] Subtest pipe-D-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc: SUCCESS (0.306s)
[697.872049] Closing watchdogs
Done.