[40.783184] Initializing watchdogs
[40.783441]   /dev/watchdog0
[40.815983] [001/141] (960s left) kms_cursor_crc (cursor-random-max-size)
[41.285768] Starting subtest: cursor-random-max-size
[41.341544] Subtest cursor-random-max-size: SKIP (0.000s)
[41.443269] [002/141] (959s left) kms_vblank (pipe-d-wait-forked-busy)
[41.835360] Subtest pipe-D-wait-forked-busy: SKIP (0.000s)
[42.016515] [003/141] (959s left) gem_eio (wait-immediate)
[42.357143] Starting subtest: wait-immediate
[42.416854] Subtest wait-immediate: SUCCESS (0.083s)
[42.626622] [004/141] (958s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[43.007843] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[43.027591] Starting dynamic subtest: pipe-A-valid-mode
[43.758849] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.739s)
[43.781507] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SUCCESS (0.742s)
[44.114240] [005/141] (957s left) v3d/v3d_get_param (get-bad-param)
[44.502768] Subtest get-bad-param: SKIP (0.000s)
[44.608210] [006/141] (957s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[44.967057] Starting subtest: cursorB-vs-flipB-toggle
[45.003267] Subtest cursorB-vs-flipB-toggle: SKIP (0.003s)
[45.111690] [007/141] (956s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[45.409562] Starting subtest: writes-after-reads-snoop
[66.056587] Subtest writes-after-reads-snoop: SUCCESS (20.666s)
[66.185352] [008/141] (935s left) syncobj_timeline (etime-multi-wait-submitted)
[66.471447] Starting subtest: etime-multi-wait-submitted
[66.566643] Subtest etime-multi-wait-submitted: SUCCESS (0.110s)
[66.669971] [009/141] (935s left) gem_mmap_wc (close)
[66.971594] Starting subtest: close
[67.024754] Subtest close: SUCCESS (0.089s)
[67.135291] [010/141] (934s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[67.559180] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[70.271973] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (2.652s)
[70.354411] [011/141] (931s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_dg2_rc_ccs_cc)
[70.943459] Starting subtest: pipe-B-crc-primary-basic-4_tiled_dg2_rc_ccs_cc
[70.980355] Subtest pipe-B-crc-primary-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.001s)
[71.476551] [012/141] (930s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-wc)
[71.889644] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-wc
[73.645637] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-wc: SUCCESS (1.816s)
[73.792136] [013/141] (928s left) feature_discovery (display)
[74.160497] Starting subtest: display
[74.184255] Subtest display: SUCCESS (0.000s)
[74.308783] [014/141] (928s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[74.740324] Starting subtest: 4-tiled-addfb-size-offset-overflow
[74.782166] Subtest 4-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[74.888369] [015/141] (927s left) gem_ctx_freq (sysfs)
[75.181663] Starting subtest: sysfs
[75.201927] Starting dynamic subtest: gt0
[80.145165] Dynamic subtest gt0: SUCCESS (4.983s)
[80.167140] Subtest sysfs: SUCCESS (4.984s)
[80.252899] [016/141] (922s left) gem_ctx_param (vm)
[80.544260] Starting subtest: vm
[80.584902] Subtest vm: SUCCESS (0.068s)
[80.722079] [017/141] (922s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[81.131655] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[81.206082] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.004s)
[81.315915] [018/141] (921s left) gem_blits (basic)
[81.609495] Starting subtest: basic
[95.558173] Subtest basic: SUCCESS (13.804s)
[95.647855] [019/141] (907s left) syncobj_timeline (single-wait-signaled)
[95.931435] Starting subtest: single-wait-signaled
[95.953134] Subtest single-wait-signaled: SUCCESS (0.002s)
[96.043436] [020/141] (907s left) gem_exec_schedule (u-lateslice)
[96.498578] Starting subtest: u-lateslice
[96.519040] Starting dynamic subtest: rcs0
[96.539311] Dynamic subtest rcs0: SUCCESS (0.038s)
[96.575234] Starting dynamic subtest: bcs0
[96.593895] Dynamic subtest bcs0: SUCCESS (0.032s)
[96.627202] Starting dynamic subtest: vcs0
[96.645703] Dynamic subtest vcs0: SUCCESS (0.030s)
[96.681796] Starting dynamic subtest: vecs0
[96.703231] Dynamic subtest vecs0: SUCCESS (0.030s)
[96.723963] Subtest u-lateslice: SUCCESS (0.133s)
[96.855797] [021/141] (906s left) kms_ccs (pipe-c-crc-primary-basic-4_tiled_dg2_mc_ccs)
[97.524541] Starting subtest: pipe-C-crc-primary-basic-4_tiled_dg2_mc_ccs
[97.562083] Subtest pipe-C-crc-primary-basic-4_tiled_dg2_mc_ccs: SKIP (0.001s)
[97.951651] [022/141] (905s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[98.367290] Starting subtest: y-tiled-64bpp-rotate-90
[98.441880] Subtest y-tiled-64bpp-rotate-90: SKIP (0.075s)
[98.558965] [023/141] (904s left) gem_exec_balancer (full-late-pulse)
[98.850604] Starting subtest: full-late-pulse
[102.985534] Subtest full-late-pulse: SUCCESS (3.951s)
[106.816405] [024/141] (896s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[107.308072] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[107.616935] [025/141] (895s left) v3d/v3d_submit_csd (bad-multisync-out-sync)
[107.959709] Subtest bad-multisync-out-sync: SKIP (0.000s)
[108.060655] [026/141] (895s left) gem_exec_capture (capture-invisible)
[108.357055] Starting subtest: capture-invisible
[108.375840] Starting dynamic subtest: smem0
[108.414684] Dynamic subtest smem0: SKIP (0.000s)
[108.458594] Subtest capture-invisible: SKIP (0.000s)
[108.561791] [027/141] (895s left) gem_exec_params (cliprects_ptr-dirt)
[108.856454] Starting subtest: cliprects_ptr-dirt
[108.875226] Subtest cliprects_ptr-dirt: SUCCESS (0.001s)
[108.958618] [028/141] (894s left) vc4/vc4_perfmon (get-values-invalid-perfmon)
[109.286166] Subtest get-values-invalid-perfmon: SKIP (0.000s)
[109.374800] [029/141] (894s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[109.807328] Starting subtest: psr-1p-pri-indfb-multidraw
[109.849156] Subtest psr-1p-pri-indfb-multidraw: SKIP (0.000s)
[109.951919] [030/141] (894s left) gem_exec_whisper (basic-queues-all)
[110.285190] Starting subtest: basic-queues-all
[120.551437] Subtest basic-queues-all: SUCCESS (10.291s)
[120.755218] [031/141] (883s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[121.126907] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[121.147426] Starting dynamic subtest: pipe-A-valid-mode
[121.797356] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.678s)
[121.816360] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (0.680s)
[122.170051] [032/141] (882s left) gem_exec_params (invalid-fence-in)
[122.452107] Starting subtest: invalid-fence-in
[122.473881] Subtest invalid-fence-in: SUCCESS (0.001s)
[122.580922] [033/141] (881s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[123.019393] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[123.058442] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[123.161748] [034/141] (881s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[123.616142] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[123.655671] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[123.762206] [035/141] (880s left) kms_ccs (pipe-d-random-ccs-data-4_tiled_dg2_rc_ccs)
[124.546175] Subtest pipe-D-random-ccs-data-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[124.864945] [036/141] (879s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[125.302399] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[125.348502] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[125.478736] [037/141] (879s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[125.927913] Starting subtest: fbc-rgb101010-draw-mmap-wc
[128.596150] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (2.647s)
[128.699175] [038/141] (876s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[129.086662] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[129.112296] Starting dynamic subtest: pipe-A-DP-1
[129.415309] Dynamic subtest pipe-A-DP-1: SUCCESS (0.318s)
[129.462818] Starting dynamic subtest: pipe-B-DP-1
[129.776735] Dynamic subtest pipe-B-DP-1: SUCCESS (0.375s)
[129.837784] Starting dynamic subtest: pipe-C-DP-1
[129.906813] Dynamic subtest pipe-C-DP-1: SKIP (0.089s)
[129.928075] Subtest planes-downscale-factor-0-5-upscale-20x20: SUCCESS (0.793s)
[130.302710] [039/141] (874s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[130.736880] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[130.774145] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[130.889249] [040/141] (874s left) kms_psr (cursor_blt)
[131.201576] Subtest cursor_blt: SKIP (0.000s)
[131.304476] [041/141] (873s left) kms_ccs (pipe-a-crc-primary-basic-y_tiled_ccs)
[131.774401] Starting subtest: pipe-A-crc-primary-basic-y_tiled_ccs
[132.680349] Subtest pipe-A-crc-primary-basic-y_tiled_ccs: SUCCESS (0.907s)
[133.402558] [042/141] (871s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[133.834398] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[133.871782] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[133.983516] [043/141] (871s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[134.274347] Starting subtest: multi-wait-for-submit-submitted-signaled
[134.295699] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[134.399680] [044/141] (871s left) gem_ctx_param (non-root-set)
[134.693278] Starting subtest: non-root-set
[134.712101] Subtest non-root-set: SUCCESS (0.033s)
[134.819277] [045/141] (870s left) kms_big_fb (yf-tiled-addfb)
[135.231256] Starting subtest: yf-tiled-addfb
[135.249608] Subtest yf-tiled-addfb: SUCCESS (0.001s)
[135.356676] [046/141] (870s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc)
[136.127412] Subtest pipe-D-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[136.457656] [047/141] (869s left) i915_pm_rpm (modeset-stress-extra-wait)
[138.411816] Starting subtest: modeset-stress-extra-wait
[191.698705] Subtest modeset-stress-extra-wait: SUCCESS (53.114s)
[191.782673] [048/141] (814s left) drm_fdinfo (busy-idle)
[192.061766] Starting subtest: busy-idle
[192.080507] Starting dynamic subtest: rcs0
[192.679608] Dynamic subtest rcs0: SUCCESS (0.632s)
[192.716273] Starting dynamic subtest: bcs0
[193.309776] Dynamic subtest bcs0: SUCCESS (0.628s)
[193.343843] Starting dynamic subtest: vcs0
[193.938606] Dynamic subtest vcs0: SUCCESS (0.627s)
[193.975133] Starting dynamic subtest: vecs0
[194.565750] Dynamic subtest vecs0: SUCCESS (0.627s)
[194.584333] Subtest busy-idle: SUCCESS (2.519s)
[194.670498] [049/141] (811s left) sw_sync (sync_busy_fork)
[194.945278] Starting subtest: sync_busy_fork
[195.969231] Subtest sync_busy_fork: SUCCESS (1.036s)
[196.068590] [050/141] (809s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[196.457882] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[196.537192] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.032s)
[196.646587] [051/141] (809s left) gen7_exec_parse (basic-offset)
[196.959626] Subtest basic-offset: SKIP (0.000s)
[197.041462] [052/141] (809s left) kms_ccs (pipe-a-bad-rotation-90-4_tiled_mtl_mc_ccs)
[197.487024] Starting subtest: pipe-A-bad-rotation-90-4_tiled_mtl_mc_ccs
[197.524129] Subtest pipe-A-bad-rotation-90-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[198.182696] [053/141] (808s left) api_intel_bb (reset-flags)
[198.506356] Starting subtest: reset-flags
[198.528475] Subtest reset-flags: SUCCESS (0.024s)
[198.633398] [054/141] (807s left) gem_ctx_param (basic-default)
[198.923093] Starting subtest: basic-default
[198.942087] Subtest basic-default: SUCCESS (0.000s)
[199.046752] [055/141] (807s left) gem_softpin (allocator-evict)
[199.340126] Starting subtest: allocator-evict
[199.359328] Starting dynamic subtest: rcs0
[235.660175] Dynamic subtest rcs0: SUCCESS (36.340s)
[235.696812] Starting dynamic subtest: bcs0
[272.761423] Dynamic subtest bcs0: SUCCESS (37.096s)
[272.800521] Starting dynamic subtest: vcs0
[309.354066] Dynamic subtest vcs0: SUCCESS (36.593s)
[309.392725] Starting dynamic subtest: vecs0
[346.165422] Dynamic subtest vecs0: SUCCESS (36.812s)
[346.186652] Subtest allocator-evict: SUCCESS (146.845s)
[346.285908] [056/141] (660s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[346.902569] Starting subtest: psr-indfb-scaledprimary
[346.941353] Subtest psr-indfb-scaledprimary: SKIP (0.000s)
[347.049887] [057/141] (659s left) kms_flip (2x-plain-flip-fb-recreate)
[347.421402] Starting subtest: 2x-plain-flip-fb-recreate
[347.460904] Subtest 2x-plain-flip-fb-recreate: SKIP (0.003s)
[347.569247] [058/141] (659s left) perf_pmu (init-sema)
[347.862786] Starting subtest: init-sema
[347.881106] Starting dynamic subtest: rcs0
[347.902411] Dynamic subtest rcs0: SUCCESS (0.002s)
[347.940350] Starting dynamic subtest: bcs0
[347.960571] Dynamic subtest bcs0: SUCCESS (0.001s)
[347.998618] Starting dynamic subtest: vcs0
[348.017391] Dynamic subtest vcs0: SUCCESS (0.001s)
[348.052829] Starting dynamic subtest: vecs0
[348.071174] Dynamic subtest vecs0: SUCCESS (0.001s)
[348.089599] Subtest init-sema: SUCCESS (0.010s)
[348.201114] [059/141] (658s left) kms_ccs (pipe-b-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc)
[348.789093] Starting subtest: pipe-B-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc
[348.831966] Subtest pipe-B-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc: SKIP (0.001s)
[349.323373] [060/141] (657s left) kms_plane_scaling (plane-downscale-with-rotation-factor-0-75)
[349.679993] Starting subtest: plane-downscale-with-rotation-factor-0-75
[349.698555] Starting dynamic subtest: pipe-A-DP-1
[349.828201] Dynamic subtest pipe-A-DP-1: SKIP (0.123s)
[349.869777] Starting dynamic subtest: pipe-B-DP-1
[350.225623] Dynamic subtest pipe-B-DP-1: SKIP (0.371s)
[350.270467] Starting dynamic subtest: pipe-C-DP-1
[350.590558] Dynamic subtest pipe-C-DP-1: SKIP (0.384s)
[350.630380] Subtest plane-downscale-with-rotation-factor-0-75: SKIP (0.891s)
[351.003829] [061/141] (656s left) kms_cursor_edge_walk (128x128-top-edge)
[351.357566] Starting subtest: 128x128-top-edge
[351.376875] Starting dynamic subtest: pipe-A-DP-1
[355.238998] Dynamic subtest pipe-A-DP-1: SUCCESS (3.861s)
[355.281584] Starting dynamic subtest: pipe-C-DP-1
[358.701407] Dynamic subtest pipe-C-DP-1: SUCCESS (3.455s)
[358.721312] Subtest 128x128-top-edge: SUCCESS (7.326s)
[359.047234] [062/141] (648s left) gem_ppgtt (shrink-vs-evict-pinned)
[359.336401] Starting subtest: shrink-vs-evict-pinned
[364.589200] Subtest shrink-vs-evict-pinned: SUCCESS (5.084s)
[364.677853] [063/141] (642s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[365.079220] Starting subtest: 4-tiled-64bpp-rotate-90
[365.116796] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.000s)
[365.224758] [064/141] (642s left) kms_addfb_basic (addfb25-4-tiled)
[365.587660] Starting subtest: addfb25-4-tiled
[365.606315] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[365.723177] [065/141] (641s left) gem_lmem_swapping (heavy-verify-random)
[366.038370] Subtest heavy-verify-random: SKIP (0.000s)
[366.131187] [066/141] (641s left) kms_content_protection (dp-mst-lic-type-1)
[366.530939] Starting subtest: dp-mst-lic-type-1
[366.568532] Subtest dp-mst-lic-type-1: SKIP (0.001s)
[366.680683] [067/141] (641s left) v3d/v3d_mmap (mmap-bad-flags)
[367.027673] Subtest mmap-bad-flags: SKIP (0.000s)
[367.112473] [068/141] (640s left) gem_pxp (protected-raw-src-copy-not-readible)
[370.102516] Subtest protected-raw-src-copy-not-readible: SKIP (0.000s)
[370.230287] [069/141] (637s left) gem_workarounds (suspend-resume-fd)
[370.540183] Starting subtest: suspend-resume-fd
[388.118128] Subtest suspend-resume-fd: SUCCESS (1.702s)
[394.398170] [070/141] (635s left) kms_flip (basic-flip-vs-dpms)
[394.744921] Starting subtest: basic-flip-vs-dpms
[394.763304] Starting dynamic subtest: A-DP1
[395.950314] Dynamic subtest A-DP1: SUCCESS (1.217s)
[395.996844] Starting dynamic subtest: B-DP1
[397.076707] Dynamic subtest B-DP1: SUCCESS (1.103s)
[397.124915] Starting dynamic subtest: C-DP1
[398.174634] Dynamic subtest C-DP1: SUCCESS (1.105s)
[398.194287] Subtest basic-flip-vs-dpms: SUCCESS (3.437s)
[398.579275] [071/141] (631s left) vgem_basic (setversion)
[398.986741] Starting subtest: setversion
[399.029724] Subtest setversion: SUCCESS (0.000s)
[399.138963] [072/141] (631s left) gem_eio (in-flight-1us)
[399.470601] Starting subtest: in-flight-1us
[400.379264] Subtest in-flight-1us: SUCCESS (0.957s)
[400.600764] [073/141] (629s left) gem_exec_schedule (preempt-hang)
[401.052004] Starting subtest: preempt-hang
[401.070500] Starting dynamic subtest: rcs0
[401.306340] Dynamic subtest rcs0: SUCCESS (0.289s)
[401.350056] Starting dynamic subtest: bcs0
[401.616300] Dynamic subtest bcs0: SUCCESS (0.309s)
[401.657667] Starting dynamic subtest: vcs0
[401.888728] Dynamic subtest vcs0: SUCCESS (0.265s)
[401.930353] Starting dynamic subtest: vecs0
[402.153658] Dynamic subtest vecs0: SUCCESS (0.271s)
[402.172204] Subtest preempt-hang: SUCCESS (1.142s)
[402.445508] [074/141] (627s left) gem_ctx_bad_destroy (invalid-default-ctx)
[402.754930] Starting subtest: invalid-default-ctx
[402.773580] Subtest invalid-default-ctx: SUCCESS (0.000s)
[402.888745] [075/141] (627s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-render)
[403.320366] Starting subtest: fbc-1p-offscren-pri-indfb-draw-render
[405.123921] Subtest fbc-1p-offscren-pri-indfb-draw-render: SUCCESS (1.882s)
[405.297376] [076/141] (625s left) kms_busy (extended-modeset-hang-oldfb)
[405.675921] Starting subtest: extended-modeset-hang-oldfb
[405.695932] Starting dynamic subtest: pipe-A
[413.209294] Dynamic subtest pipe-A: SUCCESS (7.531s)
[413.253153] Starting dynamic subtest: pipe-C
[421.231203] Dynamic subtest pipe-C: SUCCESS (7.997s)
[421.251848] Subtest extended-modeset-hang-oldfb: SUCCESS (15.542s)
[421.603246] [077/141] (609s left) kms_universal_plane (disable-primary-vs-flip-pipe-b)
[421.970099] Starting subtest: disable-primary-vs-flip-pipe-B
[423.015044] Subtest disable-primary-vs-flip-pipe-B: SUCCESS (1.038s)
[423.395286] [078/141] (607s left) kms_prop_blob (blob-prop-lifetime)
[423.690641] Starting subtest: blob-prop-lifetime
[423.712608] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[423.824271] [079/141] (607s left) kms_flip (flip-vs-panning-vs-hang)
[424.175996] Starting subtest: flip-vs-panning-vs-hang
[424.194410] Starting dynamic subtest: A-DP1
[437.978709] Dynamic subtest A-DP1: SUCCESS (13.625s)
[438.020788] Starting dynamic subtest: C-DP1
[450.966397] Dynamic subtest C-DP1: SUCCESS (12.995s)
[450.984986] Subtest flip-vs-panning-vs-hang: SUCCESS (26.629s)
[451.262088] [080/141] (579s left) gem_exec_fair (basic-none-vip)
[451.727171] Starting subtest: basic-none-vip
[451.749283] Starting dynamic subtest: rcs0
[457.434258] Dynamic subtest rcs0: SUCCESS (5.882s)
[457.455765] Subtest basic-none-vip: SUCCESS (5.884s)
[457.665476] [081/141] (573s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[458.029376] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[458.048507] Starting dynamic subtest: pipe-A-valid-mode
[458.143156] Dynamic subtest pipe-A-valid-mode: SKIP (0.088s)
[458.181713] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (0.093s)
[458.471405] [082/141] (572s left) kms_ccs (pipe-d-bad-aux-stride-y_tiled_ccs)
[459.254247] Subtest pipe-D-bad-aux-stride-y_tiled_ccs: SKIP (0.000s)
[459.584661] [083/141] (571s left) kms_atomic_interruptible (legacy-pageflip)
[459.946450] Starting subtest: legacy-pageflip
[459.965810] Starting dynamic subtest: DP-1-pipe-A
[466.538993] Dynamic subtest DP-1-pipe-A: SUCCESS (6.507s)
[466.560445] Subtest legacy-pageflip: SUCCESS (6.513s)
[466.849142] [084/141] (564s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[467.283984] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[469.318485] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (2.110s)
[469.479533] [085/141] (562s left) kms_flip (wf_vblank-ts-check-interruptible)
[469.834407] Starting subtest: wf_vblank-ts-check-interruptible
[469.852985] Starting dynamic subtest: A-DP1
[480.628132] Dynamic subtest A-DP1: SUCCESS (10.787s)
[480.670557] Starting dynamic subtest: B-DP1
[491.356977] Dynamic subtest B-DP1: SUCCESS (10.724s)
[491.401098] Starting dynamic subtest: C-DP1
[502.048673] Dynamic subtest C-DP1: SUCCESS (10.694s)
[502.071034] Subtest wf_vblank-ts-check-interruptible: SUCCESS (32.218s)
[502.484813] [086/141] (529s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[502.924727] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[502.961807] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[503.080820] [087/141] (528s left) kms_fbcon_fbt (psr-suspend)
[503.377570] Starting subtest: psr-suspend
[503.418381] Subtest psr-suspend: SKIP (0.000s)
[503.527872] [088/141] (528s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[503.970181] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[504.007572] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[504.125687] [089/141] (527s left) core_auth (basic-auth)
[504.420201] Starting subtest: basic-auth
[504.442791] Subtest basic-auth: SUCCESS (0.001s)
[504.537814] [090/141] (527s left) kms_color (deep-color)
[504.898074] Starting subtest: deep-color
[504.935591] Subtest deep-color: SKIP (0.000s)
[505.058168] [091/141] (527s left) syncobj_wait (wait-all-complex)
[505.349595] Starting subtest: wait-all-complex
[505.537694] Subtest wait-all-complex: SUCCESS (0.217s)
[505.660774] [092/141] (526s left) kms_ccs (pipe-b-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc)
[506.264761] Starting subtest: pipe-B-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc
[506.302097] Subtest pipe-B-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[506.776014] [093/141] (525s left) i915_pm_rpm (debugfs-read)
[508.634499] Starting subtest: debugfs-read
[512.303449] Subtest debugfs-read: SUCCESS (3.618s)
[512.744984] [094/141] (519s left) i915_pm_rps (waitboost)
[513.038192] Starting subtest: waitboost
[515.773285] Subtest waitboost: SUCCESS (2.577s)
[515.888533] [095/141] (516s left) vc4/vc4_perfmon (create-perfmon-exceed)
[516.224646] Subtest create-perfmon-exceed: SKIP (0.000s)
[516.338406] [096/141] (516s left) gem_ctx_param (basic)
[516.632342] Starting subtest: basic
[516.651184] Subtest basic: SUCCESS (0.000s)
[516.763505] [097/141] (516s left) kms_vblank (pipe-d-query-busy-hang)
[517.146170] Subtest pipe-D-query-busy-hang: SKIP (0.000s)
[517.344602] [098/141] (515s left) gen9_exec_parse (bb-chained)
[517.634192] Starting subtest: bb-chained
[517.655538] Subtest bb-chained: SUCCESS (0.011s)
[517.917787] [099/141] (515s left) syncobj_wait (multi-wait-submitted-signaled)
[518.202370] Starting subtest: multi-wait-submitted-signaled
[518.221530] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[518.319030] [100/141] (514s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[518.758278] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[518.798181] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[518.914803] [101/141] (514s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[519.181966] Starting subtest: single-wait-all-for-submit-unsubmitted
[519.260346] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.108s)
[519.379709] [102/141] (514s left) kms_hdmi_inject (inject-4k)
[519.693965] Subtest inject-4k: SKIP (0.000s)
[519.790930] [103/141] (513s left) kms_addfb_basic (size-max)
[520.166512] Starting subtest: size-max
[520.185308] Subtest size-max: SUCCESS (0.000s)
[520.298340] [104/141] (513s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[520.654636] Starting subtest: flip-vs-dpms-off-vs-modeset
[520.675461] Starting dynamic subtest: A-DP1
[521.865736] Dynamic subtest A-DP1: SUCCESS (1.233s)
[521.909969] Starting dynamic subtest: B-DP1
[522.920001] Dynamic subtest B-DP1: SUCCESS (1.059s)
[522.964512] Starting dynamic subtest: C-DP1
[523.989237] Dynamic subtest C-DP1: SUCCESS (1.058s)
[524.007980] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (3.363s)
[524.370827] [105/141] (509s left) kms_lease (lease_unleased_connector)
[524.730209] Starting subtest: lease_unleased_connector
[524.748941] Starting dynamic subtest: pipe-A-DP-1
[524.891057] Dynamic subtest pipe-A-DP-1: SUCCESS (0.158s)
[524.940129] Starting dynamic subtest: pipe-B-DP-1
[525.061258] Dynamic subtest pipe-B-DP-1: SUCCESS (0.168s)
[525.110106] Starting dynamic subtest: pipe-C-DP-1
[525.227534] Dynamic subtest pipe-C-DP-1: SUCCESS (0.159s)
[525.248567] Subtest lease_unleased_connector: SUCCESS (0.500s)
[525.367500] [106/141] (508s left) gem_userptr_blits (vma-merge)
[525.739839] Starting subtest: vma-merge
[546.568407] Subtest vma-merge: FAIL (20.563s)
[546.668603] [107/141] (487s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[547.105368] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[547.146716] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[547.257685] [108/141] (486s left) kms_ccs (pipe-c-ccs-on-another-bo-4_tiled_mtl_mc_ccs)
[547.993521] Starting subtest: pipe-C-ccs-on-another-bo-4_tiled_mtl_mc_ccs
[548.035140] Subtest pipe-C-ccs-on-another-bo-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[548.377154] [109/141] (485s left) gem_mmap_gtt (basic-small-copy-odd)
[548.668086] Starting subtest: basic-small-copy-odd
[551.963074] Subtest basic-small-copy-odd: SUCCESS (3.326s)
[552.107056] [110/141] (482s left) kms_vblank (pipe-b-query-idle)
[552.699462] Starting subtest: pipe-B-query-idle
[555.335362] Subtest pipe-B-query-idle: SUCCESS (2.655s)
[555.715016] [111/141] (478s left) i915_pm_dc (dc6-dpms)
[557.128126] Starting subtest: dc6-dpms
[557.171988] Subtest dc6-dpms: SKIP (0.000s)
[557.345969] [112/141] (477s left) kms_psr (psr2_primary_mmap_gtt)
[557.661225] Subtest psr2_primary_mmap_gtt: SKIP (0.000s)
[557.761990] [113/141] (476s left) kms_ccs (pipe-a-random-ccs-data-4_tiled_dg2_rc_ccs)
[558.239737] Starting subtest: pipe-A-random-ccs-data-4_tiled_dg2_rc_ccs
[558.300029] Subtest pipe-A-random-ccs-data-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[558.871715] [114/141] (475s left) kms_tiled_display (basic-test-pattern)
[559.345495] Subtest basic-test-pattern: SKIP (0.000s)
[559.460097] [115/141] (475s left) gem_exec_params (rs-invalid)
[559.753291] Starting subtest: rs-invalid
[559.772135] Subtest rs-invalid: SUCCESS (0.006s)
[559.909689] [116/141] (475s left) gem_ctx_persistence (processes)
[560.197602] Starting subtest: processes
[560.575614] Subtest processes: SUCCESS (0.383s)
[560.721512] [117/141] (474s left) gem_exec_fence (nb-await)
[561.135163] Starting subtest: nb-await
[561.154189] Starting dynamic subtest: rcs0
[561.219786] Dynamic subtest rcs0: SUCCESS (0.074s)
[561.268392] Starting dynamic subtest: bcs0
[561.289025] Dynamic subtest bcs0: SUCCESS (0.068s)
[561.337450] Starting dynamic subtest: vcs0
[561.357008] Dynamic subtest vcs0: SUCCESS (0.068s)
[561.405243] Starting dynamic subtest: vecs0
[561.447283] Dynamic subtest vecs0: SUCCESS (0.071s)
[561.468479] Subtest nb-await: SUCCESS (0.295s)
[562.134631] [118/141] (473s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[562.578459] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[562.618997] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[562.728694] [119/141] (472s left) syncobj_timeline (multi-wait-for-submit-signaled)
[563.024718] Starting subtest: multi-wait-for-submit-signaled
[563.043312] Subtest multi-wait-for-submit-signaled: SUCCESS (0.002s)
[563.139794] [120/141] (472s left) kms_ccs (pipe-c-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc)
[563.859126] Starting subtest: pipe-C-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc
[563.901312] Subtest pipe-C-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[564.277580] [121/141] (471s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[564.563654] Starting subtest: etime-single-wait-for-submit-unsubmitted
[564.635790] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[564.776989] [122/141] (470s left) kms_ccs (pipe-d-bad-rotation-90-4_tiled_dg2_rc_ccs)
[565.566421] Subtest pipe-D-bad-rotation-90-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[565.903755] [123/141] (469s left) api_intel_bb (destroy-bb)
[566.195066] Starting subtest: destroy-bb
[566.216587] Subtest destroy-bb: SUCCESS (0.024s)
[566.356657] [124/141] (469s left) vgem_slow (nohang)
[566.646448] Starting subtest: nohang
[577.093794] Subtest nohang: SUCCESS (10.290s)
[577.187571] [125/141] (458s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[577.630025] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[577.668871] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[577.780763] [126/141] (458s left) gem_create (create-invalid-size)
[578.069810] Starting subtest: create-invalid-size
[578.088610] Subtest create-invalid-size: SUCCESS (0.000s)
[578.291187] [127/141] (457s left) kms_cursor_crc (cursor-offscreen-64x21)
[578.673111] Starting subtest: cursor-offscreen-64x21
[578.691818] Starting dynamic subtest: pipe-A-DP-1
[581.417498] Dynamic subtest pipe-A-DP-1: SUCCESS (2.712s)
[581.485655] Starting dynamic subtest: pipe-C-DP-1
[584.272568] Dynamic subtest pipe-C-DP-1: SUCCESS (2.790s)
[584.294005] Subtest cursor-offscreen-64x21: SUCCESS (5.578s)
[584.654313] [128/141] (451s left) gem_lmem_swapping (verify-ccs)
[584.965560] Subtest verify-ccs: SKIP (0.000s)
[585.080066] [129/141] (451s left) kms_ccs (pipe-b-bad-rotation-90-4_tiled_mtl_rc_ccs)
[585.627680] Starting subtest: pipe-B-bad-rotation-90-4_tiled_mtl_rc_ccs
[585.667665] Subtest pipe-B-bad-rotation-90-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[586.215998] [130/141] (450s left) kms_vblank (pipe-a-ts-continuation-dpms-suspend)
[586.595282] Starting subtest: pipe-A-ts-continuation-dpms-suspend
[604.008023] Subtest pipe-A-ts-continuation-dpms-suspend: SUCCESS (1.767s)
[610.236220] [131/141] (447s left) syncobj_timeline (invalid-signal-illegal-point)
[610.521983] Starting subtest: invalid-signal-illegal-point
[610.540771] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[610.640571] [132/141] (447s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[611.004777] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[611.042942] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.003s)
[611.161076] [133/141] (446s left) prime_busy (after-wait)
[611.455884] Starting subtest: after-wait
[611.476127] Starting dynamic subtest: rcs0
[611.497969] Dynamic subtest rcs0: SUCCESS (0.022s)
[611.541596] Starting dynamic subtest: bcs0
[611.562417] Dynamic subtest bcs0: SUCCESS (0.018s)
[611.604280] Starting dynamic subtest: vcs0
[611.623347] Dynamic subtest vcs0: SUCCESS (0.015s)
[611.665877] Starting dynamic subtest: vecs0
[611.684899] Dynamic subtest vecs0: SUCCESS (0.019s)
[611.704987] Subtest after-wait: SUCCESS (0.215s)
[611.806153] [134/141] (446s left) kms_pipe_crc_basic (hang-read-crc)
[612.167211] Starting subtest: hang-read-crc
[612.186143] Starting dynamic subtest: pipe-A-DP-1
[613.398499] Dynamic subtest pipe-A-DP-1: SUCCESS (1.222s)
[613.451158] Starting dynamic subtest: pipe-B-DP-1
[615.072645] Dynamic subtest pipe-B-DP-1: SUCCESS (1.660s)
[615.127452] Starting dynamic subtest: pipe-C-DP-1
[616.954676] Dynamic subtest pipe-C-DP-1: SUCCESS (1.873s)
[616.973460] Subtest hang-read-crc: SUCCESS (4.775s)
[617.303329] [135/141] (441s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[617.742626] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[617.785467] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[617.898134] [136/141] (440s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[618.192073] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[618.229317] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[618.433817] [137/141] (440s left) kms_plane (plane-panning-bottom-right-suspend)
[618.791924] Starting subtest: plane-panning-bottom-right-suspend
[618.810475] Starting dynamic subtest: pipe-A-planes
[637.208418] Dynamic subtest pipe-A-planes: SUCCESS (2.299s)
[637.259891] Starting dynamic subtest: pipe-B-planes
[656.214460] Dynamic subtest pipe-B-planes: SUCCESS (2.497s)
[656.234809] Subtest plane-panning-bottom-right-suspend: SUCCESS (4.808s)
[661.431496] [138/141] (434s left) gem_ctx_exec (basic)
[661.729947] Starting subtest: basic
[661.750645] Subtest basic: SUCCESS (0.006s)
[661.887814] [139/141] (434s left) kms_big_fb (linear-64bpp-rotate-180)
[662.316571] Starting subtest: linear-64bpp-rotate-180
[670.465613] Subtest linear-64bpp-rotate-180: SUCCESS (8.192s)
[671.405510] [140/141] (424s left) kms_chamelium_color (ctm-max)
[671.804615] Subtest ctm-max: SKIP (0.000s)
[671.918549] [141/141] (424s left) api_intel_allocator (open-vm)
[672.235434] Starting subtest: open-vm
[672.261366] Subtest open-vm: SUCCESS (0.004s)
[672.422877] Closing watchdogs
Done.