[43.544861] Initializing watchdogs
[43.544901]   /dev/watchdog0
[43.551961] [001/142] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[43.640733] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[47.032786] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (3.396s)
[47.159547] [002/142] (956s left) kms_draw_crc (fill-fb)
[47.238489] Starting subtest: fill-fb
[47.720240] Subtest fill-fb: SUCCESS (0.483s)
[47.800192] [003/142] (956s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-gtt)
[47.869217] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-gtt
[47.873125] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[47.954722] [004/142] (956s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[48.018796] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[48.022845] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[48.190740] [005/142] (955s left) gem_ctx_shared (disjoint-timelines)
[48.262810] Starting subtest: disjoint-timelines
[48.294782] Subtest disjoint-timelines: SUCCESS (0.032s)
[48.504455] [006/142] (955s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[48.564478] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[48.584117] [007/142] (955s left) perf (global-sseu-config)
[48.718728] Subtest global-sseu-config: SKIP (0.000s)
[48.747243] [008/142] (955s left) gem_exec_balancer (waits)
[48.811925] Starting subtest: waits
[55.042343] Subtest waits: SUCCESS (6.229s)
[55.283345] [009/142] (948s left) kms_lease (lease-invalid-connector)
[55.361433] Starting subtest: lease-invalid-connector
[55.363740] Starting dynamic subtest: pipe-A-eDP-1
[55.365614] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[55.369908] Starting dynamic subtest: pipe-B-eDP-1
[55.371826] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[55.375948] Starting dynamic subtest: pipe-C-eDP-1
[55.377919] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[55.382042] Starting dynamic subtest: pipe-D-eDP-1
[55.383932] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[55.385835] Subtest lease-invalid-connector: SUCCESS (0.002s)
[55.420059] [010/142] (948s left) kms_ccs (pipe-d-crc-primary-rotation-180-4_tiled_mtl_rc_ccs)
[55.845499] Starting subtest: pipe-D-crc-primary-rotation-180-4_tiled_mtl_rc_ccs
[56.821536] Subtest pipe-D-crc-primary-rotation-180-4_tiled_mtl_rc_ccs: SUCCESS (0.976s)
[58.009113] [011/142] (946s left) kms_plane_alpha_blend (coverage-7efc)
[58.084091] Starting subtest: coverage-7efc
[58.330846] Starting dynamic subtest: pipe-A-eDP-1
[58.897725] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.564s)
[58.925986] Starting dynamic subtest: pipe-D-eDP-1
[60.279777] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.362s)
[60.282213] Subtest coverage-7efc: SUCCESS (2.195s)
[61.146991] [012/142] (943s left) gem_lmem_swapping (verify)
[61.219395] Subtest verify: SKIP (0.000s)
[61.242108] [013/142] (943s left) perf (blocking)
[61.313227] Starting subtest: blocking
[61.315683] Starting dynamic subtest: 0-rcs0
[71.356673] Dynamic subtest 0-rcs0: SUCCESS (10.040s)
[71.362295] Starting dynamic subtest: 1-vcs1
[81.377796] Dynamic subtest 1-vcs1: SUCCESS (10.022s)
[81.380660] Subtest blocking: SUCCESS (20.063s)
[81.412868] [014/142] (922s left) kms_chamelium_hpd (dp-hpd-fast)
[81.806525] Subtest dp-hpd-fast: SKIP (0.000s)
[82.691753] [015/142] (921s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[82.752259] Starting subtest: mixed-tiled-to-y-tiled-ccs
[82.756338] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[82.922970] [016/142] (921s left) gem_exec_schedule (preempt-contexts)
[83.000173] Starting subtest: preempt-contexts
[83.002809] Starting dynamic subtest: rcs0
[83.018847] Dynamic subtest rcs0: SUCCESS (0.029s)
[83.030619] Starting dynamic subtest: bcs0
[83.064620] Dynamic subtest bcs0: SUCCESS (0.046s)
[83.071713] Starting dynamic subtest: vcs0
[83.098736] Dynamic subtest vcs0: SUCCESS (0.033s)
[83.105116] Starting dynamic subtest: vcs1
[83.134382] Dynamic subtest vcs1: SUCCESS (0.036s)
[83.143731] Starting dynamic subtest: vecs0
[83.180449] Dynamic subtest vecs0: SUCCESS (0.046s)
[83.187868] Starting dynamic subtest: ccs0
[83.213213] Dynamic subtest ccs0: SUCCESS (0.032s)
[83.215180] Subtest preempt-contexts: SUCCESS (0.223s)
[84.538427] [017/142] (919s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[84.621068] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[84.625695] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[84.699116] [018/142] (919s left) i915_pm_rpm (dpms-mode-unset-non-lpsp)
[86.630854] Starting subtest: dpms-mode-unset-non-lpsp
[90.053609] Subtest dpms-mode-unset-non-lpsp: SKIP (3.421s)
[90.888333] [019/142] (913s left) kms_flip (flip-vs-expired-vblank-interruptible)
[90.951292] Starting subtest: flip-vs-expired-vblank-interruptible
[90.959405] Starting dynamic subtest: A-eDP1
[99.693658] Dynamic subtest A-eDP1: SUCCESS (8.733s)
[99.705621] Starting dynamic subtest: B-eDP1
[108.385764] Dynamic subtest B-eDP1: SUCCESS (8.691s)
[108.397142] Starting dynamic subtest: C-eDP1
[117.077709] Dynamic subtest C-eDP1: SUCCESS (8.692s)
[117.088985] Starting dynamic subtest: D-eDP1
[125.845732] Dynamic subtest D-eDP1: SUCCESS (8.768s)
[125.853477] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.902s)
[127.144557] [020/142] (877s left) kms_chamelium_audio (dp-audio-edid)
[127.497297] Subtest dp-audio-edid: SKIP (0.000s)
[128.389046] [021/142] (876s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[128.438850] Subtest tiled-to-tiled: SKIP (0.000s)
[128.457356] [022/142] (876s left) gem_exec_balancer (hog)
[128.499087] Starting subtest: hog
[128.503861] Subtest hog: SKIP (0.000s)
[128.752265] [023/142] (875s left) gem_exec_parallel (fds)
[128.826093] Starting subtest: fds
[128.828661] Starting dynamic subtest: rcs0
[130.859478] Dynamic subtest rcs0: SUCCESS (2.033s)
[130.871222] Starting dynamic subtest: bcs0
[132.884074] Dynamic subtest bcs0: SUCCESS (2.023s)
[132.895114] Starting dynamic subtest: vcs0
[136.431079] Dynamic subtest vcs0: SUCCESS (3.546s)
[136.445538] Starting dynamic subtest: vcs1
[138.561946] Dynamic subtest vcs1: SUCCESS (2.131s)
[138.567589] Starting dynamic subtest: vecs0
[140.691115] Dynamic subtest vecs0: SUCCESS (2.129s)
[140.701926] Starting dynamic subtest: ccs0
[142.828122] Dynamic subtest ccs0: SUCCESS (2.137s)
[142.830452] Subtest fds: SUCCESS (14.003s)
[143.021410] [024/142] (861s left) i915_pm_rps (thresholds-idle)
[143.077608] Starting subtest: thresholds-idle
[143.080073] Starting dynamic subtest: gt0
[143.083986] Dynamic subtest gt0: SKIP (0.002s)
[143.094521] Starting dynamic subtest: gt1
[143.099105] Dynamic subtest gt1: SKIP (0.000s)
[143.103679] Subtest thresholds-idle: SKIP (0.002s)
[143.143902] [025/142] (861s left) kms_ccs (pipe-b-crc-primary-rotation-180-y_tiled_gen12_mc_ccs)
[143.595630] Starting subtest: pipe-B-crc-primary-rotation-180-y_tiled_gen12_mc_ccs
[143.600233] Subtest pipe-B-crc-primary-rotation-180-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[144.426483] [026/142] (860s left) gem_sync (basic-all)
[144.497432] Starting subtest: basic-all
[148.421488] Subtest basic-all: SUCCESS (3.927s)
[148.599423] [027/142] (856s left) gem_mmap_gtt (cpuset-big-copy)
[148.653217] Subtest cpuset-big-copy: SKIP (0.000s)
[148.668951] [028/142] (856s left) gem_exec_params (invalid-fence-in-submit)
[148.727814] Starting subtest: invalid-fence-in-submit
[148.729979] Subtest invalid-fence-in-submit: SUCCESS (0.001s)
[148.823267] [029/142] (855s left) syncobj_wait (wait-all-snapshot)
[148.876990] Starting subtest: wait-all-snapshot
[148.955888] Subtest wait-all-snapshot: SUCCESS (0.081s)
[149.024389] [030/142] (855s left) gem_create (create-clear)
[149.071027] Starting subtest: create-clear
[149.073285] Starting dynamic subtest: smem0
[182.202784] Dynamic subtest smem0: SUCCESS (33.136s)
[182.204678] Subtest create-clear: SUCCESS (33.136s)
[182.381812] [031/142] (822s left) perf_pmu (invalid-open)
[182.430710] Starting subtest: invalid-open
[182.433405] Subtest invalid-open: SUCCESS (0.000s)
[182.476061] [032/142] (822s left) gem_exec_schedule (pi-common)
[182.668236] Starting subtest: pi-common
[182.679750] Starting dynamic subtest: rcs0
[182.746717] Dynamic subtest rcs0: SUCCESS (0.082s)
[182.767746] Starting dynamic subtest: bcs0
[182.824581] Dynamic subtest bcs0: SUCCESS (0.077s)
[182.845933] Starting dynamic subtest: vcs0
[182.904218] Dynamic subtest vcs0: SUCCESS (0.079s)
[182.924788] Starting dynamic subtest: vcs1
[182.984704] Dynamic subtest vcs1: SUCCESS (0.080s)
[183.004235] Starting dynamic subtest: vecs0
[183.060280] Dynamic subtest vecs0: SUCCESS (0.076s)
[183.080734] Starting dynamic subtest: ccs0
[183.140838] Dynamic subtest ccs0: SUCCESS (0.080s)
[183.143592] Subtest pi-common: SUCCESS (0.477s)
[183.359244] [033/142] (821s left) api_intel_bb (blit-reloc-purge-cache)
[183.424578] Starting subtest: blit-reloc-purge-cache
[183.429361] Subtest blit-reloc-purge-cache: SKIP (0.001s)
[183.513492] [034/142] (821s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs)
[183.909094] Starting subtest: pipe-C-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs
[183.914498] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs: SKIP (0.001s)
[184.796487] [035/142] (820s left) kms_ccs (pipe-c-ccs-on-another-bo-4_tiled_mtl_mc_ccs)
[185.190257] Starting subtest: pipe-C-ccs-on-another-bo-4_tiled_mtl_mc_ccs
[185.213508] Subtest pipe-C-ccs-on-another-bo-4_tiled_mtl_mc_ccs: SUCCESS (0.022s)
[186.031973] [036/142] (818s left) kms_fence_pin_leak
[186.120363] [037/142] (818s left) kms_ccs (pipe-b-bad-aux-stride-y_tiled_gen12_rc_ccs_cc)
[186.504330] Starting subtest: pipe-B-bad-aux-stride-y_tiled_gen12_rc_ccs_cc
[186.509883] Subtest pipe-B-bad-aux-stride-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[187.371225] [038/142] (817s left) sw_sync (sync_expired_merge)
[187.420868] Starting subtest: sync_expired_merge
[188.496167] Subtest sync_expired_merge: SUCCESS (1.074s)
[188.543479] [039/142] (816s left) gem_exec_reloc (basic-write-cpu)
[188.606076] Subtest basic-write-cpu: SKIP (0.000s)
[188.662445] [040/142] (816s left) gem_ccs (block-copy-compressed)
[188.709372] Starting subtest: block-copy-compressed
[188.714243] Subtest block-copy-compressed: SKIP (0.000s)
[188.766642] [041/142] (816s left) kms_big_fb (4-tiled-addfb)
[188.855787] Starting subtest: 4-tiled-addfb
[188.858153] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[188.940911] [042/142] (816s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[188.986515] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[189.092506] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.107s)
[189.157409] [043/142] (815s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[189.246791] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[193.985247] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (4.742s)
[194.105391] [044/142] (810s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[194.170065] Starting subtest: primary-yf-tiled-reflect-x-270
[194.173869] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[194.226044] [045/142] (810s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[194.302897] Starting subtest: x-tiled-64bpp-rotate-270
[194.318899] Subtest x-tiled-64bpp-rotate-270: SKIP (0.016s)
[194.409925] [046/142] (810s left) kms_atomic_transition (modeset-transition-nonblocking)
[194.501329] Starting subtest: modeset-transition-nonblocking
[194.503364] Starting dynamic subtest: 1x-outputs
[206.923404] Dynamic subtest 1x-outputs: SUCCESS (12.424s)
[207.219825] Subtest modeset-transition-nonblocking: SUCCESS (12.717s)
[208.093708] [047/142] (797s left) gem_mmap_offset (oob-read)
[208.146115] Starting subtest: oob-read
[208.148460] Subtest oob-read: SUCCESS (0.000s)
[208.214647] [048/142] (796s left) prime_busy (hang)
[208.270241] Starting subtest: hang
[208.272270] Starting dynamic subtest: rcs0
[221.960279] Dynamic subtest rcs0: SUCCESS (13.689s)
[221.965279] Starting dynamic subtest: bcs0
[229.117224] Dynamic subtest bcs0: SUCCESS (7.157s)
[229.122625] Starting dynamic subtest: vcs0
[236.095026] Dynamic subtest vcs0: SUCCESS (6.977s)
[236.100766] Starting dynamic subtest: vcs1
[243.132671] Dynamic subtest vcs1: SUCCESS (7.040s)
[243.138575] Starting dynamic subtest: vecs0
[250.111384] Dynamic subtest vecs0: SUCCESS (6.980s)
[250.116381] Starting dynamic subtest: ccs0
[263.961570] Dynamic subtest ccs0: SUCCESS (13.846s)
[263.964361] Subtest hang: SUCCESS (55.690s)
[264.047746] [049/142] (741s left) i915_pm_rpm (modeset-stress-extra-wait)
[265.640174] Starting subtest: modeset-stress-extra-wait
[322.501851] Subtest modeset-stress-extra-wait: SUCCESS (56.860s)
[322.583566] [050/142] (682s left) kms_rotation_crc (cursor-rotation-180)
[322.656809] Starting subtest: cursor-rotation-180
[324.297634] Subtest cursor-rotation-180: SUCCESS (1.639s)
[325.548307] [051/142] (679s left) api_intel_bb (reset-bb)
[325.595383] Starting subtest: reset-bb
[325.597803] Subtest reset-bb: SUCCESS (0.004s)
[325.691847] [052/142] (679s left) kms_ccs (pipe-a-missing-ccs-buffer-y_tiled_gen12_mc_ccs)
[326.075032] Starting subtest: pipe-A-missing-ccs-buffer-y_tiled_gen12_mc_ccs
[326.080639] Subtest pipe-A-missing-ccs-buffer-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[326.942095] [053/142] (678s left) kms_ccs (pipe-a-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc)
[327.315711] Starting subtest: pipe-A-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc
[327.318350] Subtest pipe-A-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc: SUCCESS (0.000s)
[328.235818] [054/142] (677s left) i915_suspend (basic-s2idle-without-i915)
[328.272758] Starting subtest: basic-s2idle-without-i915
[347.628283] Subtest basic-s2idle-without-i915: SUCCESS (3.357s)
[347.676177] [055/142] (673s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[347.768298] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[348.501857] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.734s)
[348.689243] [056/142] (672s left) kms_ccs (pipe-a-bad-rotation-90-4_tiled_dg2_rc_ccs_cc)
[349.075626] Starting subtest: pipe-A-bad-rotation-90-4_tiled_dg2_rc_ccs_cc
[349.080379] Subtest pipe-A-bad-rotation-90-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[349.990235] [057/142] (671s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[350.065454] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[355.011142] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.948s)
[355.110391] [058/142] (666s left) syncobj_wait (invalid-wait-bad-flags)
[355.167951] Starting subtest: invalid-wait-bad-flags
[355.169874] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[355.231102] [059/142] (666s left) gem_exec_store (dword)
[355.302447] Starting subtest: dword
[355.305186] Starting dynamic subtest: rcs0
[355.343515] Dynamic subtest rcs0: SUCCESS (0.041s)
[355.356818] Starting dynamic subtest: bcs0
[355.384628] Dynamic subtest bcs0: SUCCESS (0.040s)
[355.398376] Starting dynamic subtest: vcs0
[357.442055] Dynamic subtest vcs0: SUCCESS (2.055s)
[357.455393] Starting dynamic subtest: vcs1
[359.425952] Dynamic subtest vcs1: SUCCESS (1.982s)
[359.439027] Starting dynamic subtest: vecs0
[361.412313] Dynamic subtest vecs0: SUCCESS (1.981s)
[361.425889] Starting dynamic subtest: ccs0
[361.452025] Dynamic subtest ccs0: SUCCESS (0.042s)
[361.455037] Subtest dword: SUCCESS (6.150s)
[361.630211] [060/142] (659s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[361.724312] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[361.728698] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[361.808790] [061/142] (659s left) kms_cursor_crc (cursor-onscreen-64x64)
[361.901808] Starting subtest: cursor-onscreen-64x64
[361.904205] Starting dynamic subtest: pipe-A-eDP-1
[364.049910] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.143s)
[364.081874] Starting dynamic subtest: pipe-D-eDP-1
[366.923676] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.853s)
[366.926312] Subtest cursor-onscreen-64x64: SUCCESS (5.022s)
[367.815997] [062/142] (653s left) kms_flip (absolute-wf_vblank-interruptible)
[367.884195] Starting subtest: absolute-wf_vblank-interruptible
[367.886584] Starting dynamic subtest: A-eDP1
[376.662390] Dynamic subtest A-eDP1: SUCCESS (8.777s)
[376.676444] Starting dynamic subtest: B-eDP1
[385.428649] Dynamic subtest B-eDP1: SUCCESS (8.764s)
[385.444648] Starting dynamic subtest: C-eDP1
[394.186498] Dynamic subtest C-eDP1: SUCCESS (8.757s)
[394.200534] Starting dynamic subtest: D-eDP1
[402.954670] Dynamic subtest D-eDP1: SUCCESS (8.765s)
[402.960419] Subtest absolute-wf_vblank-interruptible: SUCCESS (35.078s)
[404.193837] [063/142] (617s left) gem_ctx_persistence (processes)
[404.261467] Starting subtest: processes
[405.426766] Subtest processes: SUCCESS (1.167s)
[405.500642] [064/142] (616s left) gem_readwrite (read-bad-handle)
[405.561838] Subtest read-bad-handle: SKIP (0.000s)
[405.593241] [065/142] (615s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[405.695463] Starting subtest: cursor-vs-flip-toggle
[434.646983] Subtest cursor-vs-flip-toggle: SUCCESS (28.951s)
[435.557495] [066/142] (586s left) kms_addfb_basic (invalid-get-prop-any)
[435.616926] Starting subtest: invalid-get-prop-any
[435.618986] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[435.722458] [067/142] (585s left) v3d/v3d_get_param (get-bad-flags)
[435.798604] Subtest get-bad-flags: SKIP (0.000s)
[435.842669] [068/142] (585s left) gem_softpin (evict-snoop-interruptible)
[435.892748] Starting subtest: evict-snoop-interruptible
[435.897977] Subtest evict-snoop-interruptible: SKIP (0.000s)
[435.940844] [069/142] (585s left) syncobj_timeline (multi-wait-all-available-submitted)
[436.006292] Starting subtest: multi-wait-all-available-submitted
[436.008743] Subtest multi-wait-all-available-submitted: SUCCESS (0.001s)
[436.074504] [070/142] (585s left) drm_mm (drm_mm)
[436.126816] Starting subtest: drm_mm
[436.145406] Starting dynamic subtest: drm_mm-drm_test_mm_init
[436.147839] Dynamic subtest drm_mm-drm_test_mm_init: SUCCESS (0.000s)
[436.161725] Starting dynamic subtest: drm_mm-drm_test_mm_debug
[436.163737] Dynamic subtest drm_mm-drm_test_mm_debug: SUCCESS (0.000s)
[438.671585] Starting dynamic subtest: drm_mm-drm_test_mm_reserve
[438.674528] Dynamic subtest drm_mm-drm_test_mm_reserve: SUCCESS (0.000s)
[446.846605] Starting dynamic subtest: drm_mm-drm_test_mm_insert
[446.849101] Dynamic subtest drm_mm-drm_test_mm_insert: SUCCESS (0.000s)
[446.862044] Starting dynamic subtest: drm_mm-drm_test_mm_replace
[446.864502] Dynamic subtest drm_mm-drm_test_mm_replace: SUCCESS (0.000s)
[449.751741] Starting dynamic subtest: drm_mm-drm_test_mm_insert_range
[449.754892] Dynamic subtest drm_mm-drm_test_mm_insert_range: SUCCESS (0.000s)
[449.790070] Starting dynamic subtest: drm_mm-drm_test_mm_frag
[449.792123] Dynamic subtest drm_mm-drm_test_mm_frag: SUCCESS (0.000s)
[449.801697] Starting dynamic subtest: drm_mm-drm_test_mm_align
[449.803650] Dynamic subtest drm_mm-drm_test_mm_align: SUCCESS (0.000s)
[449.811069] Starting dynamic subtest: drm_mm-drm_test_mm_align32
[449.813001] Dynamic subtest drm_mm-drm_test_mm_align32: SUCCESS (0.000s)
[449.819615] Starting dynamic subtest: drm_mm-drm_test_mm_align64
[449.821560] Dynamic subtest drm_mm-drm_test_mm_align64: SUCCESS (0.000s)
[450.427092] Starting dynamic subtest: drm_mm-drm_test_mm_evict
[450.430041] Dynamic subtest drm_mm-drm_test_mm_evict: SUCCESS (0.000s)
[450.443792] Starting dynamic subtest: drm_mm-drm_test_mm_evict_range
[450.446517] Dynamic subtest drm_mm-drm_test_mm_evict_range: SUCCESS (0.000s)
[450.508129] Starting dynamic subtest: drm_mm-drm_test_mm_topdown
[450.510213] Dynamic subtest drm_mm-drm_test_mm_topdown: SUCCESS (0.000s)
[450.522053] Starting dynamic subtest: drm_mm-drm_test_mm_bottomup
[450.524080] Dynamic subtest drm_mm-drm_test_mm_bottomup: SUCCESS (0.000s)
[450.532451] Starting dynamic subtest: drm_mm-drm_test_mm_lowest
[450.534305] Dynamic subtest drm_mm-drm_test_mm_lowest: SUCCESS (0.000s)
[450.540475] Starting dynamic subtest: drm_mm-drm_test_mm_highest
[450.542515] Dynamic subtest drm_mm-drm_test_mm_highest: SUCCESS (0.000s)
[451.052063] Starting dynamic subtest: drm_mm-drm_test_mm_color
[451.054873] Dynamic subtest drm_mm-drm_test_mm_color: SUCCESS (0.000s)
[451.067053] Starting dynamic subtest: drm_mm-drm_test_mm_color_evict
[451.070061] Dynamic subtest drm_mm-drm_test_mm_color_evict: SUCCESS (0.000s)
[451.361164] Starting dynamic subtest: drm_mm-drm_test_mm_color_evict_range
[451.363495] Dynamic subtest drm_mm-drm_test_mm_color_evict_range: SUCCESS (0.000s)
[451.365579] Subtest drm_mm: SUCCESS (15.221s)
[451.469477] [071/142] (570s left) kms_addfb_basic (bad-pitch-63)
[451.524524] Starting subtest: bad-pitch-63
[451.526794] Subtest bad-pitch-63: SUCCESS (0.000s)
[451.643302] [072/142] (570s left) vgem_basic (sysfs)
[451.718685] Starting subtest: sysfs
[451.721005] Subtest sysfs: SUCCESS (0.000s)
[451.760887] [073/142] (569s left) i915_query (query-garbage)
[451.793416] Starting subtest: query-garbage
[451.795464] Subtest query-garbage: SUCCESS (0.000s)
[451.839755] [074/142] (569s left) kms_psr (psr2_cursor_plane_onoff)
[451.919375] Starting subtest: psr2_cursor_plane_onoff
[453.677259] Subtest psr2_cursor_plane_onoff: SUCCESS (1.755s)
[454.569133] [075/142] (567s left) kms_vblank (pipe-d-query-busy-hang)
[454.661615] Starting subtest: pipe-D-query-busy-hang
[470.260326] Subtest pipe-D-query-busy-hang: SUCCESS (15.599s)
[471.209794] [076/142] (550s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc)
[471.620677] Starting subtest: pipe-B-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc
[471.625580] Subtest pipe-B-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.001s)
[472.490727] [077/142] (549s left) gem_exec_reloc (basic-write-read-noreloc)
[472.554988] Subtest basic-write-read-noreloc: SKIP (0.000s)
[472.614497] [078/142] (549s left) sw_sync (sync_merge_same)
[472.665147] Starting subtest: sync_merge_same
[472.667195] Subtest sync_merge_same: SUCCESS (0.000s)
[472.714274] [079/142] (549s left) vc4/vc4_tiling (get-bad-flags)
[472.801213] Subtest get-bad-flags: SKIP (0.000s)
[472.852130] [080/142] (549s left) kms_vblank (pipe-b-wait-forked-hang)
[472.909948] Starting subtest: pipe-B-wait-forked-hang
[488.229081] Subtest pipe-B-wait-forked-hang: SUCCESS (15.320s)
[489.119369] [081/142] (532s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[489.215008] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[494.528588] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (5.319s)
[494.640718] [082/142] (527s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[494.745836] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[494.750155] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.003s)
[494.880021] [083/142] (527s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[494.934052] Starting subtest: y-tiled-to-vebox-y-tiled
[494.938369] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[495.113127] [084/142] (526s left) vc4/vc4_create_bo (create-bo-0)
[495.197639] Subtest create-bo-0: SKIP (0.000s)
[495.247815] [085/142] (526s left) syncobj_wait (reset-multiple-signaled)
[495.299388] Starting subtest: reset-multiple-signaled
[495.301856] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[495.360501] [086/142] (526s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[495.428664] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[495.430906] Starting dynamic subtest: pipe-A-eDP-1
[495.435314] Dynamic subtest pipe-A-eDP-1: SKIP (0.003s)
[495.449001] Starting dynamic subtest: pipe-B-eDP-1
[495.453575] Dynamic subtest pipe-B-eDP-1: SKIP (0.012s)
[495.465156] Starting dynamic subtest: pipe-C-eDP-1
[495.469800] Dynamic subtest pipe-C-eDP-1: SKIP (0.012s)
[495.483693] Starting dynamic subtest: pipe-D-eDP-1
[495.487526] Dynamic subtest pipe-D-eDP-1: SKIP (0.012s)
[495.491439] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.043s)
[495.546556] [087/142] (526s left) v3d/v3d_submit_cl (single-out-sync)
[495.609029] Subtest single-out-sync: SKIP (0.000s)
[495.662088] [088/142] (526s left) gem_readwrite (new-obj)
[495.707370] Subtest new-obj: SKIP (0.000s)
[495.739083] [089/142] (526s left) kms_cursor_edge_walk (256x256-left-edge)
[495.825415] Starting subtest: 256x256-left-edge
[495.827787] Starting dynamic subtest: pipe-A-eDP-1
[499.361438] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.533s)
[499.376707] Starting dynamic subtest: pipe-D-eDP-1
[502.589873] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.226s)
[502.592595] Subtest 256x256-left-edge: SUCCESS (6.764s)
[503.516838] [090/142] (518s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[503.590045] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[506.795854] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (3.212s)
[506.926988] [091/142] (515s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[506.995024] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[506.997406] Starting dynamic subtest: pipe-A-eDP-1
[507.642532] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.647s)
[507.653035] Starting dynamic subtest: pipe-B-eDP-1
[509.425677] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.779s)
[509.438075] Starting dynamic subtest: pipe-C-eDP-1
[511.229112] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.801s)
[511.240208] Starting dynamic subtest: pipe-D-eDP-1
[513.033926] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.803s)
[513.036328] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (6.042s)
[514.281417] [092/142] (507s left) vc4/vc4_label_bo (set-label)
[514.358242] Subtest set-label: SKIP (0.000s)
[514.405302] [093/142] (507s left) prime_vgem (basic-gtt)
[514.501964] Starting subtest: basic-gtt
[514.506671] Subtest basic-gtt: SKIP (0.000s)
[514.580916] [094/142] (507s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[514.641246] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[514.645537] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[514.734570] [095/142] (507s left) i915_hangman (error-state-basic)
[514.816134] Starting subtest: error-state-basic
[514.911859] Subtest error-state-basic: SUCCESS (0.097s)
[514.975847] [096/142] (507s left) gem_exec_reloc (basic-gtt)
[515.041789] Subtest basic-gtt: SKIP (0.000s)
[515.106453] [097/142] (507s left) gem_huc_copy (huc-copy)
[515.174348] Starting subtest: huc-copy
[515.176430] Subtest huc-copy: SUCCESS (0.002s)
[515.258966] [098/142] (507s left) kms_content_protection (uevent)
[515.370395] Starting subtest: uevent
[518.901985] Subtest uevent: SKIP (3.527s)
[520.165454] [099/142] (502s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[520.252833] Starting subtest: y-tiled-8bpp-rotate-270
[520.257133] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[520.340732] [100/142] (502s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[520.411364] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[520.415313] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[520.499917] [101/142] (502s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[520.586391] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[520.591009] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[520.666401] [102/142] (501s left) kms_atomic_transition (plane-toggle-modeset-transition)
[520.748474] Starting subtest: plane-toggle-modeset-transition
[520.750860] Starting dynamic subtest: pipe-A-eDP-1
[535.184912] Dynamic subtest pipe-A-eDP-1: SUCCESS (14.435s)
[535.205482] Starting dynamic subtest: pipe-B-eDP-1
[549.351701] Dynamic subtest pipe-B-eDP-1: SUCCESS (14.162s)
[549.354363] Subtest plane-toggle-modeset-transition: SUCCESS (28.604s)
[550.250722] [103/142] (472s left) kms_prime (basic-crc-vgem)
[550.803568] Starting subtest: basic-crc-vgem
[550.806054] Starting dynamic subtest: second-to-first
[551.823909] Dynamic subtest second-to-first: SUCCESS (1.025s)
[551.826018] Subtest basic-crc-vgem: SUCCESS (1.026s)
[551.901380] [104/142] (470s left) kms_psr (primary_render)
[552.024245] Starting subtest: primary_render
[553.863435] Subtest primary_render: SUCCESS (1.839s)
[554.795281] [105/142] (467s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_dg2_mc_ccs)
[555.192905] Starting subtest: pipe-B-crc-primary-basic-4_tiled_dg2_mc_ccs
[555.197861] Subtest pipe-B-crc-primary-basic-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[556.072388] [106/142] (466s left) kms_flip (modeset-vs-vblank-race-interruptible)
[556.145460] Starting subtest: modeset-vs-vblank-race-interruptible
[556.150590] Starting dynamic subtest: A-eDP1
[561.050771] Dynamic subtest A-eDP1: SUCCESS (4.902s)
[561.066064] Starting dynamic subtest: B-eDP1
[565.980182] Dynamic subtest B-eDP1: SUCCESS (4.928s)
[565.995959] Starting dynamic subtest: C-eDP1
[570.885597] Dynamic subtest C-eDP1: SUCCESS (4.903s)
[570.900434] Starting dynamic subtest: D-eDP1
[575.749995] Dynamic subtest D-eDP1: SUCCESS (4.863s)
[575.758053] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (19.613s)
[577.063587] [107/142] (445s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[577.136773] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[577.139090] Starting dynamic subtest: pipe-A-default-mode
[577.460072] Dynamic subtest pipe-A-default-mode: SKIP (0.319s)
[577.464751] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.320s)
[578.314170] [108/142] (444s left) kms_psr (psr2_suspend)
[578.394438] Starting subtest: psr2_suspend
[596.202800] Subtest psr2_suspend: SUCCESS (3.813s)
[597.127087] [109/142] (439s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[597.202060] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[602.581059] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (5.383s)
[602.717695] [110/142] (434s left) gen9_exec_parse (bb-start-cmd)
[602.772246] Subtest bb-start-cmd: SKIP (0.000s)
[602.800199] [111/142] (433s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[602.898724] Starting subtest: yf-tiled-64bpp-rotate-180
[602.903265] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[602.976456] [112/142] (433s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-render)
[603.032882] Starting subtest: psr-1p-offscren-pri-shrfb-draw-render
[608.083494] Subtest psr-1p-offscren-pri-shrfb-draw-render: SUCCESS (5.053s)
[608.215817] [113/142] (428s left) gem_userptr_blits (dmabuf-sync)
[608.303701] Starting subtest: dmabuf-sync
[608.312359] Subtest dmabuf-sync: SKIP (0.005s)
[608.413434] [114/142] (428s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[608.504535] Starting subtest: yf-tiled-8bpp-rotate-180
[608.508729] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[608.591363] [115/142] (428s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[608.762216] Starting subtest: cursor-rapid-movement-128x42
[608.764694] Starting dynamic subtest: pipe-A-eDP-1
[609.342062] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.577s)
[609.370708] Starting dynamic subtest: pipe-D-eDP-1
[610.658578] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.291s)
[610.661188] Subtest cursor-rapid-movement-128x42: SUCCESS (1.894s)
[611.535441] [116/142] (425s left) syncobj_wait (single-wait-all-for-submit-signaled)
[611.589732] Starting subtest: single-wait-all-for-submit-signaled
[611.592141] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[611.654293] [117/142] (425s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[611.708417] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[611.710921] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.001s)
[611.776571] [118/142] (425s left) gem_userptr_blits (input-checking)
[611.842019] Starting subtest: input-checking
[611.844366] Subtest input-checking: SUCCESS (0.000s)
[611.961827] [119/142] (425s left) gem_partial_pwrite_pread (write-uncached)
[612.009940] Subtest write-uncached: SKIP (0.000s)
[612.049178] [120/142] (424s left) kms_ccs (pipe-c-random-ccs-data-4_tiled_mtl_rc_ccs_cc)
[612.441627] Starting subtest: pipe-C-random-ccs-data-4_tiled_mtl_rc_ccs_cc
[613.252842] Subtest pipe-C-random-ccs-data-4_tiled_mtl_rc_ccs_cc: SUCCESS (0.811s)
[614.483204] [121/142] (422s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[614.559871] Starting subtest: fb-8bpc-vs-panel-6bpc
[614.562279] Starting dynamic subtest: pipe-A-eDP-1
[615.999797] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.436s)
[616.001853] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.437s)
[616.916082] [122/142] (420s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc)
[617.325204] Starting subtest: pipe-D-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc
[617.330682] Subtest pipe-D-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.001s)
[618.193261] [123/142] (418s left) kms_plane_lowres (tiling-none)
[618.265052] Starting subtest: tiling-none
[618.267544] Starting dynamic subtest: pipe-A-eDP-1
[618.272308] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[618.566373] Starting dynamic subtest: pipe-B-eDP-1
[618.571965] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[618.581499] Starting dynamic subtest: pipe-C-eDP-1
[618.586337] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[618.595603] Starting dynamic subtest: pipe-D-eDP-1
[618.600362] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[618.605209] Subtest tiling-none: SKIP (0.314s)
[619.474057] [124/142] (417s left) kms_ccs (pipe-c-bad-aux-stride-4_tiled_mtl_rc_ccs_cc)
[619.880856] Starting subtest: pipe-C-bad-aux-stride-4_tiled_mtl_rc_ccs_cc
[619.883576] Subtest pipe-C-bad-aux-stride-4_tiled_mtl_rc_ccs_cc: SUCCESS (0.000s)
[620.722510] [125/142] (416s left) gem_linear_blits (interruptible)
[621.211784] Starting subtest: interruptible
[625.665585] Subtest interruptible: SUCCESS (4.453s)
[625.821611] [126/142] (411s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[625.972981] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[625.975407] Starting dynamic subtest: pipe-A-default-mode
[626.261793] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[626.266668] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.288s)
[627.158683] [127/142] (410s left) syncobj_wait (single-wait-all-submitted)
[627.213642] Starting subtest: single-wait-all-submitted
[627.321512] Subtest single-wait-all-submitted: SUCCESS (0.106s)
[627.394478] [128/142] (409s left) gem_exec_reloc (basic-range-active)
[627.459606] Subtest basic-range-active: SKIP (0.000s)
[627.518869] [129/142] (409s left) gem_vm_create (isolation)
[627.575803] Starting subtest: isolation
[627.578251] Subtest isolation: SUCCESS (0.003s)
[627.680285] [130/142] (409s left) sysfs_timeslice_duration (invalid)
[627.757078] Starting subtest: invalid
[627.759445] Starting dynamic subtest: vecs0
[627.761942] Dynamic subtest vecs0: SUCCESS (0.000s)
[627.771457] Starting dynamic subtest: ccs0
[627.773243] Dynamic subtest ccs0: SUCCESS (0.000s)
[627.781883] Starting dynamic subtest: vcs0
[627.783816] Dynamic subtest vcs0: SUCCESS (0.000s)
[627.793597] Starting dynamic subtest: bcs0
[627.795690] Dynamic subtest bcs0: SUCCESS (0.000s)
[627.803288] Starting dynamic subtest: rcs0
[627.805436] Dynamic subtest rcs0: SUCCESS (0.000s)
[627.812064] Starting dynamic subtest: vcs1
[627.814138] Dynamic subtest vcs1: SUCCESS (0.000s)
[627.816245] Subtest invalid: SUCCESS (0.006s)
[627.831530] [131/142] (409s left) gem_ctx_isolation (dirty-create)
[627.894083] Starting subtest: dirty-create
[627.896624] Starting dynamic subtest: rcs0
[628.016163] Dynamic subtest rcs0: SUCCESS (0.122s)
[628.023176] Starting dynamic subtest: bcs0
[628.156403] Dynamic subtest bcs0: SUCCESS (0.140s)
[628.172210] Starting dynamic subtest: vcs0
[628.313845] Dynamic subtest vcs0: SUCCESS (0.157s)
[628.330400] Starting dynamic subtest: vcs1
[629.573142] Dynamic subtest vcs1: SUCCESS (1.259s)
[629.583446] Starting dynamic subtest: vecs0
[631.579603] Dynamic subtest vecs0: SUCCESS (2.006s)
[631.591950] Starting dynamic subtest: ccs0
[633.564890] Dynamic subtest ccs0: SUCCESS (1.985s)
[633.567797] Subtest dirty-create: SUCCESS (5.671s)
[633.794800] [132/142] (403s left) syncobj_timeline (wait-all-complex)
[633.865743] Starting subtest: wait-all-complex
[634.081600] Subtest wait-all-complex: SUCCESS (0.217s)
[634.155695] [133/142] (403s left) gem_render_copy_redux (normal)
[634.201256] Starting subtest: normal
[634.638628] Subtest normal: SUCCESS (0.437s)
[634.735905] [134/142] (402s left) gem_exec_fence (basic-busy)
[634.947380] Starting subtest: basic-busy
[634.953222] Starting dynamic subtest: rcs0
[635.006926] Dynamic subtest rcs0: SUCCESS (0.056s)
[635.023156] Starting dynamic subtest: bcs0
[635.059087] Dynamic subtest bcs0: SUCCESS (0.051s)
[635.075600] Starting dynamic subtest: vcs0
[635.088022] Dynamic subtest vcs0: SUCCESS (0.028s)
[635.101725] Starting dynamic subtest: vcs1
[635.111784] Dynamic subtest vcs1: SUCCESS (0.023s)
[635.127203] Starting dynamic subtest: vecs0
[635.142756] Dynamic subtest vecs0: SUCCESS (0.030s)
[635.159769] Starting dynamic subtest: ccs0
[635.200659] Dynamic subtest ccs0: SUCCESS (0.056s)
[635.203154] Subtest basic-busy: SUCCESS (0.253s)
[636.499131] [135/142] (400s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[636.566226] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[636.578212] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.013s)
[636.652475] [136/142] (400s left) kms_vrr (flip-dpms)
[636.743088] Starting subtest: flip-dpms
[636.748002] Subtest flip-dpms: SKIP (0.000s)
[636.806663] [137/142] (400s left) kms_invalid_mode (bad-hsync-end)
[636.904432] Starting subtest: bad-hsync-end
[636.906755] Starting dynamic subtest: eDP-1-pipe-A
[637.192324] Dynamic subtest eDP-1-pipe-A: SUCCESS (0.285s)
[637.208591] Starting dynamic subtest: eDP-1-pipe-B
[637.211019] Dynamic subtest eDP-1-pipe-B: SUCCESS (0.001s)
[637.224067] Starting dynamic subtest: eDP-1-pipe-C
[637.226500] Dynamic subtest eDP-1-pipe-C: SUCCESS (0.001s)
[637.236484] Starting dynamic subtest: eDP-1-pipe-D
[637.239071] Dynamic subtest eDP-1-pipe-D: SUCCESS (0.001s)
[637.241567] Subtest bad-hsync-end: SUCCESS (0.297s)
[638.086309] [138/142] (399s left) kms_feature_discovery (psr2)
[638.149062] Starting subtest: psr2
[638.151139] Subtest psr2: SUCCESS (0.000s)
[638.197439] [139/142] (399s left) kms_chamelium_hpd (dp-hpd)
[638.563838] Subtest dp-hpd: SKIP (0.000s)
[639.472265] [140/142] (398s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[639.540969] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[639.545531] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[639.621869] [141/142] (397s left) kms_addfb_basic (small-bo)
[639.673767] Starting subtest: small-bo
[639.676081] Subtest small-bo: SUCCESS (0.000s)
[639.751694] [142/142] (397s left) kms_ccs (pipe-d-bad-rotation-90-4_tiled_mtl_rc_ccs)
[640.181651] Starting subtest: pipe-D-bad-rotation-90-4_tiled_mtl_rc_ccs
[640.962683] Subtest pipe-D-bad-rotation-90-4_tiled_mtl_rc_ccs: SUCCESS (0.778s)
[642.144891] Closing watchdogs
Done.