[39.450138] Initializing watchdogs
[39.450265]   /dev/watchdog0
[39.464029] [001/143] (960s left) drm_fdinfo (virtual-busy-idle-all)
[39.537096] Starting subtest: virtual-busy-idle-all
[39.542130] Subtest virtual-busy-idle-all: SKIP (0.000s)
[39.604400] [002/143] (960s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[39.661175] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[39.663584] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[39.728877] [003/143] (960s left) gem_exec_whisper (basic-contexts-priority)
[39.788333] Starting subtest: basic-contexts-priority
[65.170060] Subtest basic-contexts-priority: SUCCESS (25.377s)
[65.349232] [004/143] (934s left) kms_vblank (crtc-id)
[65.433719] Starting subtest: crtc-id
[65.435979] Starting dynamic subtest: pipe-A-eDP-1
[65.935358] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.504s)
[65.951572] Starting dynamic subtest: pipe-D-eDP-1
[67.172619] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.227s)
[67.175496] Subtest crtc-id: SUCCESS (1.738s)
[68.073997] [005/143] (931s left) gem_exec_schedule (preempt-user)
[68.161410] Starting subtest: preempt-user
[68.163494] Starting dynamic subtest: rcs0
[68.172253] Dynamic subtest rcs0: SUCCESS (0.021s)
[68.187441] Starting dynamic subtest: bcs0
[68.207968] Dynamic subtest bcs0: SUCCESS (0.036s)
[68.221744] Starting dynamic subtest: vcs0
[68.227445] Dynamic subtest vcs0: SUCCESS (0.019s)
[68.237801] Starting dynamic subtest: vcs1
[68.259537] Dynamic subtest vcs1: SUCCESS (0.032s)
[68.272137] Starting dynamic subtest: vecs0
[68.282715] Dynamic subtest vecs0: SUCCESS (0.023s)
[68.292831] Starting dynamic subtest: ccs0
[68.308949] Dynamic subtest ccs0: SUCCESS (0.026s)
[68.311872] Subtest preempt-user: SUCCESS (0.157s)
[68.637800] [006/143] (931s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[68.705896] Starting subtest: plane-all-modeset-transition-internal-panels
[68.708312] Starting dynamic subtest: pipe-A-eDP-1
[70.387479] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.681s)
[70.714171] Starting dynamic subtest: pipe-B-eDP-1
[72.095800] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.397s)
[72.420030] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (3.714s)
[73.322679] [007/143] (926s left) kms_frontbuffer_tracking (psr-suspend)
[73.389580] Starting subtest: psr-suspend
[112.238820] Subtest psr-suspend: SUCCESS (9.359s)
[117.357641] [008/143] (917s left) kms_psr (psr-primary-render)
[117.471629] Starting subtest: psr-primary-render
[117.474116] Starting dynamic subtest: eDP-1
[119.319315] Dynamic subtest eDP-1: SUCCESS (1.849s)
[119.322099] Subtest psr-primary-render: SUCCESS (1.849s)
[120.230249] [009/143] (914s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[120.305707] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[121.572496] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.266s)
[121.690634] [010/143] (913s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[121.744524] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[121.842508] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.101s)
[121.914755] [011/143] (912s left) kms_pm_backlight (basic-brightness)
[121.984981] Starting subtest: basic-brightness
[122.045790] Starting dynamic subtest: eDP-1
[122.559141] Dynamic subtest eDP-1: SUCCESS (0.511s)
[122.562491] Subtest basic-brightness: SUCCESS (0.573s)
[123.485779] [012/143] (911s left) kms_ccs (pipe-a-bad-rotation-90-y-tiled-gen12-rc-ccs)
[123.829456] Starting subtest: pipe-A-bad-rotation-90-y-tiled-gen12-rc-ccs
[123.834369] Subtest pipe-A-bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[124.708721] [013/143] (910s left) gem_spin_batch (resubmit)
[124.797380] Starting subtest: resubmit
[124.799916] Starting dynamic subtest: rcs0
[124.807454] Dynamic subtest rcs0: SUCCESS (0.010s)
[124.821392] Starting dynamic subtest: bcs0
[124.823467] Dynamic subtest bcs0: SUCCESS (0.004s)
[124.833225] Starting dynamic subtest: vcs0
[124.835629] Dynamic subtest vcs0: SUCCESS (0.004s)
[124.843633] Starting dynamic subtest: vcs1
[124.846006] Dynamic subtest vcs1: SUCCESS (0.004s)
[124.852640] Starting dynamic subtest: vecs0
[124.855003] Dynamic subtest vecs0: SUCCESS (0.004s)
[124.861610] Starting dynamic subtest: ccs0
[124.863967] Dynamic subtest ccs0: SUCCESS (0.004s)
[124.866344] Subtest resubmit: SUCCESS (0.030s)
[125.042115] [014/143] (909s left) gem_exec_flush (basic-batch-kernel-default-wb)
[125.107666] Starting subtest: basic-batch-kernel-default-wb
[131.193109] Subtest basic-batch-kernel-default-wb: SUCCESS (6.088s)
[131.382066] [015/143] (903s left) gem_ctx_param (invalid-set-ringsize)
[131.449809] Starting subtest: invalid-set-ringsize
[131.452357] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[131.515486] [016/143] (903s left) kms_ccs (pipe-b-missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[131.914451] Starting subtest: pipe-B-missing-ccs-buffer-y-tiled-gen12-mc-ccs
[131.919511] Subtest pipe-B-missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[132.759550] [017/143] (902s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[132.814444] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[132.818866] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[132.902612] [018/143] (902s left) kms_getfb (getfb2-handle-zero)
[132.957988] Starting subtest: getfb2-handle-zero
[132.960725] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[133.040843] [019/143] (901s left) kms_ccs (pipe-a-crc-primary-rotation-180-yf-tiled-ccs)
[133.402766] Starting subtest: pipe-A-crc-primary-rotation-180-yf-tiled-ccs
[133.407935] Subtest pipe-A-crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.000s)
[134.312514] [020/143] (900s left) kms_chamelium_color (ctm-0-75)
[134.394656] Subtest ctm-0-75: SKIP (0.000s)
[134.411353] [021/143] (900s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[134.487053] Starting subtest: yf-tiled-16bpp-rotate-270
[134.491129] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[134.573512] [022/143] (900s left) gem_create (hog-create)
[134.642033] Starting subtest: hog-create
[134.645271] Starting dynamic subtest: smem0
[150.169005] Dynamic subtest smem0: FAIL (15.447s)
[150.171121] Subtest hog-create: FAIL (15.447s)
[152.041653] [023/143] (883s left) perf_pmu (invalid-init)
[152.089529] Starting subtest: invalid-init
[152.091972] Subtest invalid-init: SUCCESS (0.000s)
[152.153999] [024/143] (882s left) perf_pmu (semaphore-wait-idle)
[152.213298] Starting subtest: semaphore-wait-idle
[152.216297] Starting dynamic subtest: rcs0
[152.741476] Dynamic subtest rcs0: SUCCESS (0.526s)
[152.760831] Starting dynamic subtest: bcs0
[153.260245] Dynamic subtest bcs0: SUCCESS (0.516s)
[153.280484] Starting dynamic subtest: vcs0
[153.775018] Dynamic subtest vcs0: SUCCESS (0.516s)
[153.794157] Starting dynamic subtest: vcs1
[154.290708] Dynamic subtest vcs1: SUCCESS (0.514s)
[154.310178] Starting dynamic subtest: vecs0
[154.804988] Dynamic subtest vecs0: SUCCESS (0.514s)
[154.824240] Starting dynamic subtest: ccs0
[155.319333] Dynamic subtest ccs0: SUCCESS (0.514s)
[155.322520] Subtest semaphore-wait-idle: SUCCESS (3.104s)
[155.435642] [025/143] (879s left) core_setmaster_vs_auth
[155.550913] [026/143] (879s left) kms_ccs (pipe-b-crc-primary-basic-y-tiled-ccs)
[155.937644] Starting subtest: pipe-B-crc-primary-basic-y-tiled-ccs
[155.943065] Subtest pipe-B-crc-primary-basic-y-tiled-ccs: SKIP (0.000s)
[156.830148] [027/143] (878s left) kms_pm_dc (dc6-dpms)
[157.909586] Starting subtest: dc6-dpms
[164.926012] Subtest dc6-dpms: FAIL (6.668s)
[164.955817] [028/143] (870s left) gem_flink_basic (bad-open)
[165.014350] Starting subtest: bad-open
[165.016676] Subtest bad-open: SUCCESS (0.000s)
[165.084586] [029/143] (870s left) gem_pwrite_snooped
[165.174773] [030/143] (870s left) i915_power (sanity)
[165.234541] Starting subtest: sanity
[169.276223] Subtest sanity: SUCCESS (4.038s)
[170.982934] [031/143] (864s left) gem_caching (read-writes)
[171.044712] Subtest read-writes: SKIP (0.000s)
[171.070912] [032/143] (864s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[171.146754] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[171.149163] Starting dynamic subtest: pipe-A-eDP-1
[171.220867] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.070s)
[171.240009] Starting dynamic subtest: pipe-B-eDP-1
[172.449986] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.229s)
[172.472028] Starting dynamic subtest: pipe-C-eDP-1
[173.654236] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.201s)
[173.676308] Starting dynamic subtest: pipe-D-eDP-1
[174.870261] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.213s)
[174.872732] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.724s)
[176.102285] [033/143] (859s left) kms_psr (fbc-psr2-sprite-plane-move)
[176.195950] Starting subtest: fbc-psr2-sprite-plane-move
[176.198459] Starting dynamic subtest: eDP-1
[176.203416] Dynamic subtest eDP-1: SKIP (0.000s)
[176.207385] Subtest fbc-psr2-sprite-plane-move: SKIP (0.000s)
[176.318665] [034/143] (859s left) kms_ccs (pipe-d-bad-pixel-format-4-tiled-mtl-rc-ccs)
[176.765470] Starting subtest: pipe-D-bad-pixel-format-4-tiled-mtl-rc-ccs
[176.768633] Subtest pipe-D-bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.000s)
[177.584903] [035/143] (857s left) kms_psr2_sf (overlay-plane-update-sf-dmg-area)
[182.758355] Starting subtest: overlay-plane-update-sf-dmg-area
[182.761165] Starting dynamic subtest: pipe-A-eDP-1
[189.556336] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.795s)
[189.575531] Starting dynamic subtest: pipe-B-eDP-1
[196.341683] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.782s)
[196.344394] Subtest overlay-plane-update-sf-dmg-area: SUCCESS (13.584s)
[197.221761] [036/143] (838s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[197.296446] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[198.130496] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.836s)
[198.271857] [037/143] (837s left) gem_userptr_blits (sd-probe)
[198.335134] Starting subtest: sd-probe
[198.337450] Subtest sd-probe: SUCCESS (0.000s)
[198.438328] [038/143] (837s left) kms_selftest (drm_cmdline_parser)
[198.512291] Starting subtest: drm_cmdline_parser
[198.649358] Starting dynamic subtest: drm_test_cmdline_force_d_only
[198.662974] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.013s)
[198.686452] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[198.688933] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.000s)
[198.706267] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[198.708675] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.000s)
[198.719778] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[198.722176] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.000s)
[198.731024] Starting dynamic subtest: drm_test_cmdline_force_e_only
[198.733482] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.000s)
[198.741436] Starting dynamic subtest: drm_test_cmdline_res
[198.743922] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.000s)
[198.751421] Starting dynamic subtest: drm_test_cmdline_res_vesa
[198.753845] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.000s)
[198.761110] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[198.763614] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.000s)
[198.770667] Starting dynamic subtest: drm_test_cmdline_res_rblank
[198.773098] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.000s)
[198.780088] Starting dynamic subtest: drm_test_cmdline_res_bpp
[198.782539] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.000s)
[198.789508] Starting dynamic subtest: drm_test_cmdline_res_refresh
[198.791968] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.000s)
[198.803221] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[198.805606] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.000s)
[198.812835] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[198.815237] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.000s)
[198.822239] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[198.824717] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.000s)
[198.831648] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[198.834037] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.000s)
[198.840883] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[198.843324] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.000s)
[198.850232] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[198.852678] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.000s)
[198.859629] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[198.862230] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.000s)
[198.869866] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[198.872363] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.000s)
[198.879317] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[198.881832] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.000s)
[198.888417] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[198.890409] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.000s)
[198.896967] Starting dynamic subtest: drm_test_cmdline_name
[198.899044] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.000s)
[198.905391] Starting dynamic subtest: drm_test_cmdline_name_bpp
[198.907410] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.000s)
[198.913616] Starting dynamic subtest: drm_test_cmdline_name_option
[198.915622] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.000s)
[198.921893] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[198.923914] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.000s)
[198.930000] Starting dynamic subtest: drm_test_cmdline_rotate_0
[198.932054] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.000s)
[198.938228] Starting dynamic subtest: drm_test_cmdline_rotate_90
[198.940624] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.000s)
[198.947083] Starting dynamic subtest: drm_test_cmdline_rotate_180
[198.949518] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.000s)
[198.956110] Starting dynamic subtest: drm_test_cmdline_rotate_270
[198.958496] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.000s)
[198.964987] Starting dynamic subtest: drm_test_cmdline_hmirror
[198.967381] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.000s)
[198.973905] Starting dynamic subtest: drm_test_cmdline_vmirror
[198.976614] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.000s)
[198.982919] Starting dynamic subtest: drm_test_cmdline_margin_options
[198.985037] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.000s)
[198.991265] Starting dynamic subtest: drm_test_cmdline_multiple_options
[198.993291] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.000s)
[198.999386] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[199.001415] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.000s)
[199.007570] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[199.009568] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.000s)
[199.015620] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[199.017629] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.000s)
[199.023718] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[199.025759] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.000s)
[199.031895] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[199.033973] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.000s)
[199.040323] Starting dynamic subtest: drm_test_cmdline_invalid
[199.042335] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.001s)
[199.048518] Starting dynamic subtest: drm_test_cmdline_tv_options
[199.050543] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.002s)
[199.052526] Subtest drm_cmdline_parser: SUCCESS (0.181s)
[199.068114] [039/143] (836s left) gem_close_race (multigpu-basic-threads)
[199.128289] Starting subtest: multigpu-basic-threads
[199.132859] Subtest multigpu-basic-threads: SKIP (0.000s)
[199.345106] [040/143] (836s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[199.416083] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[200.235309] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.825s)
[200.406484] [041/143] (835s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[200.487147] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[200.492629] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[200.574921] [042/143] (835s left) vc4/vc4_perfmon (get-values-valid-perfmon)
[200.665822] Subtest get-values-valid-perfmon: SKIP (0.000s)
[200.709819] [043/143] (834s left) gem_mmap_offset (perf)
[200.751183] Starting subtest: perf
[200.753467] Starting dynamic subtest: smem0
[201.137216] Dynamic subtest smem0: SUCCESS (0.386s)
[201.139528] Subtest perf: SUCCESS (0.387s)
[201.215484] [044/143] (834s left) kms_atomic (plane-primary-legacy)
[201.276941] Starting subtest: plane-primary-legacy
[201.279490] Starting dynamic subtest: pipe-A-eDP-1
[201.756223] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.476s)
[201.759038] Subtest plane-primary-legacy: SUCCESS (0.478s)
[202.663374] [045/143] (833s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[202.782861] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[205.599778] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (2.821s)
[205.747095] [046/143] (830s left) i915_pm_rpm (gem-execbuf-stress)
[207.274636] Starting subtest: gem-execbuf-stress
[207.277501] Starting dynamic subtest: smem0
[249.971115] Dynamic subtest smem0: SUCCESS (42.694s)
[249.991590] Starting dynamic subtest: extra-wait-smem0
[338.053678] Dynamic subtest extra-wait-smem0: SUCCESS (88.081s)
[338.056831] Subtest gem-execbuf-stress: SUCCESS (130.778s)
[338.425721] [047/143] (697s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[338.497244] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[338.501945] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[338.596484] [048/143] (697s left) gem_workarounds (basic-read-fd)
[338.676632] Starting subtest: basic-read-fd
[338.690382] Subtest basic-read-fd: SUCCESS (0.014s)
[338.797064] [049/143] (697s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[338.901569] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[338.906385] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[338.997757] [050/143] (696s left) kms_ccs (pipe-b-crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[339.371874] Starting subtest: pipe-B-crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[341.935848] Subtest pipe-B-crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (2.564s)
[343.140295] [051/143] (692s left) syncobj_wait (single-wait-for-submit-signaled)
[343.197741] Starting subtest: single-wait-for-submit-signaled
[343.199794] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[343.264646] [052/143] (692s left) gem_exec_balancer (hog)
[343.353906] Starting subtest: hog
[343.359057] Subtest hog: SKIP (0.000s)
[343.599812] [053/143] (692s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[346.190032] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SKIP (0.000s)
[346.265265] [054/143] (689s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[346.360786] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[346.365136] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[346.451369] [055/143] (689s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[346.514749] Starting subtest: y-tiled-to-vebox-yf-tiled
[346.521076] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[346.703639] [056/143] (689s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-pwrite)
[346.786103] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-pwrite
[351.966971] Subtest fbc-1p-offscren-pri-shrfb-draw-pwrite: SUCCESS (5.187s)
[352.081868] [057/143] (684s left) kms_ccs (pipe-a-random-ccs-data-4-tiled-dg2-rc-ccs)
[352.455335] Starting subtest: pipe-A-random-ccs-data-4-tiled-dg2-rc-ccs
[352.464682] Subtest pipe-A-random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[353.386881] [058/143] (682s left) kms_ccs (pipe-d-ccs-on-another-bo-yf-tiled-ccs)
[353.813944] Starting subtest: pipe-D-ccs-on-another-bo-yf-tiled-ccs
[353.818910] Subtest pipe-D-ccs-on-another-bo-yf-tiled-ccs: SKIP (0.000s)
[354.663456] [059/143] (681s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[354.731385] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[359.832779] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.103s)
[359.922905] [060/143] (676s left) gem_exec_fence (syncobj-signal)
[360.419274] Starting subtest: syncobj-signal
[360.425423] Subtest syncobj-signal: SUCCESS (0.005s)
[362.029734] [061/143] (674s left) kms_flip (plain-flip-fb-recreate)
[362.084749] Starting subtest: plain-flip-fb-recreate
[362.087302] Starting dynamic subtest: A-eDP1
[371.026790] Dynamic subtest A-eDP1: SUCCESS (8.944s)
[371.046466] Starting dynamic subtest: B-eDP1
[379.988403] Dynamic subtest B-eDP1: SUCCESS (8.959s)
[380.007869] Starting dynamic subtest: C-eDP1
[388.936891] Dynamic subtest C-eDP1: SUCCESS (8.946s)
[388.956620] Starting dynamic subtest: D-eDP1
[397.895726] Dynamic subtest D-eDP1: SUCCESS (8.958s)
[397.905011] Subtest plain-flip-fb-recreate: SUCCESS (35.825s)
[399.149715] [062/143] (637s left) device_reset (unbind-reset-rebind)
[399.244071] Starting subtest: unbind-reset-rebind
[400.955974] Subtest unbind-reset-rebind: SUCCESS (1.712s)
[401.283330] [063/143] (634s left) kms_ccs (pipe-a-bad-pixel-format-4-tiled-mtl-mc-ccs)
[401.335965] Starting subtest: pipe-A-bad-pixel-format-4-tiled-mtl-mc-ccs
[401.338994] Subtest pipe-A-bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.001s)
[402.535496] [064/143] (633s left) kms_prop_blob (invalid-get-prop)
[402.575853] Starting subtest: invalid-get-prop
[402.578390] Subtest invalid-get-prop: SUCCESS (0.000s)
[402.630350] [065/143] (633s left) kms_properties (invalid-properties-atomic)
[402.696697] Starting subtest: invalid-properties-atomic
[402.917136] Subtest invalid-properties-atomic: SUCCESS (0.223s)
[402.983123] [066/143] (633s left) kms_psr (pr-no-drrs)
[403.050321] Starting subtest: pr-no-drrs
[403.055298] Subtest pr-no-drrs: SKIP (0.000s)
[403.149447] [067/143] (633s left) gem_exec_schedule (out-order)
[403.235778] Starting subtest: out-order
[403.238398] Starting dynamic subtest: rcs0
[403.317586] Dynamic subtest rcs0: SUCCESS (0.094s)
[403.335703] Starting dynamic subtest: vcs0
[403.402997] Dynamic subtest vcs0: SUCCESS (0.084s)
[403.423806] Starting dynamic subtest: vcs1
[403.474273] Dynamic subtest vcs1: SUCCESS (0.070s)
[403.496384] Starting dynamic subtest: vecs0
[403.567946] Dynamic subtest vecs0: SUCCESS (0.093s)
[403.586787] Starting dynamic subtest: ccs0
[403.649824] Dynamic subtest ccs0: SUCCESS (0.081s)
[403.652344] Subtest out-order: SUCCESS (0.427s)
[405.064513] [068/143] (631s left) perf (missing-sample-flags)
[405.182138] Starting subtest: missing-sample-flags
[405.184808] Subtest missing-sample-flags: SUCCESS (0.001s)
[405.213227] [069/143] (631s left) kms_psr (fbc-psr2-basic)
[405.266045] Starting subtest: fbc-psr2-basic
[405.268794] Starting dynamic subtest: eDP-1
[405.273930] Dynamic subtest eDP-1: SKIP (0.000s)
[405.278984] Subtest fbc-psr2-basic: SKIP (0.002s)
[405.405007] [070/143] (631s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[405.459337] Starting subtest: legacy-engines-hostile-preempt
[405.461534] Starting dynamic subtest: render
[405.493260] Dynamic subtest render: SUCCESS (0.037s)
[405.513664] Starting dynamic subtest: bsd1
[406.945687] Dynamic subtest bsd1: SUCCESS (1.450s)
[406.968016] Starting dynamic subtest: bsd2
[408.929845] Dynamic subtest bsd2: SUCCESS (1.982s)
[408.951594] Starting dynamic subtest: blt
[409.129943] Dynamic subtest blt: SUCCESS (0.199s)
[409.150190] Starting dynamic subtest: vebox
[410.893616] Dynamic subtest vebox: SUCCESS (1.760s)
[410.896402] Subtest legacy-engines-hostile-preempt: SUCCESS (5.437s)
[411.002484] [071/143] (625s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[411.399257] Starting subtest: pipe-D-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[413.118693] Subtest pipe-D-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (1.718s)
[414.312700] [072/143] (622s left) vc4/vc4_mmap (mmap-bad-handle)
[414.407843] Subtest mmap-bad-handle: SKIP (0.000s)
[414.465151] [073/143] (622s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[414.529431] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[414.533243] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[414.597671] [074/143] (622s left) kms_vblank (ts-continuation-modeset)
[414.690509] Starting subtest: ts-continuation-modeset
[414.692978] Starting dynamic subtest: pipe-A-eDP-1
[416.282038] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.587s)
[416.301242] Starting dynamic subtest: pipe-D-eDP-1
[418.647503] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.361s)
[418.650260] Subtest ts-continuation-modeset: SUCCESS (3.957s)
[419.560156] [075/143] (617s left) kms_chamelium_hpd (common-hpd-after-suspend)
[419.959586] Subtest common-hpd-after-suspend: SKIP (0.000s)
[420.810036] [076/143] (615s left) gem_readwrite (read-bad-handle)
[420.893275] Subtest read-bad-handle: SKIP (0.000s)
[420.937904] [077/143] (615s left) kms_dsc (dsc-with-formats)
[420.999704] Subtest dsc-with-formats: SKIP (0.000s)
[421.028689] [078/143] (615s left) kms_cursor_edge_walk (256x256-top-bottom)
[421.097230] Starting subtest: 256x256-top-bottom
[421.099902] Starting dynamic subtest: pipe-A-eDP-1
[424.649724] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.554s)
[424.667161] Starting dynamic subtest: pipe-D-eDP-1
[427.931550] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.276s)
[427.934125] Subtest 256x256-top-bottom: SUCCESS (6.836s)
[428.840304] [079/143] (607s left) gem_exec_whisper (basic-sync-all)
[428.911706] Starting subtest: basic-sync-all
[438.305021] Subtest basic-sync-all: SUCCESS (9.391s)
[438.493003] [080/143] (598s left) kms_vrr (flip-basic)
[438.596724] Starting subtest: flip-basic
[438.601651] Subtest flip-basic: SKIP (0.000s)
[438.660912] [081/143] (598s left) kms_rotation_crc (primary-rotation-90)
[438.759716] Starting subtest: primary-rotation-90
[438.764453] Subtest primary-rotation-90: SKIP (0.001s)
[438.838097] [082/143] (598s left) gem_lmem_swapping (parallel-random)
[438.905127] Subtest parallel-random: SKIP (0.000s)
[438.948289] [083/143] (597s left) kms_lease (lease-invalid-connector)
[439.015330] Starting subtest: lease-invalid-connector
[439.017854] Starting dynamic subtest: pipe-A-eDP-1
[439.020325] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[439.030678] Starting dynamic subtest: pipe-B-eDP-1
[439.033021] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[439.040554] Starting dynamic subtest: pipe-C-eDP-1
[439.043012] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[439.049981] Starting dynamic subtest: pipe-D-eDP-1
[439.052089] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[439.054189] Subtest lease-invalid-connector: SUCCESS (0.003s)
[439.073752] [084/143] (597s left) kms_flip (bo-too-big)
[439.144401] Starting subtest: bo-too-big
[439.146587] Starting dynamic subtest: A-eDP1
[440.623738] Dynamic subtest A-eDP1: SUCCESS (1.481s)
[440.643624] Starting dynamic subtest: B-eDP1
[442.070639] Dynamic subtest B-eDP1: SUCCESS (1.443s)
[442.092003] Starting dynamic subtest: C-eDP1
[443.576156] Dynamic subtest C-eDP1: SUCCESS (1.504s)
[443.588954] Starting dynamic subtest: D-eDP1
[445.018131] Dynamic subtest D-eDP1: SUCCESS (1.440s)
[445.020930] Subtest bo-too-big: SUCCESS (5.880s)
[446.314106] [085/143] (590s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[446.388519] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[446.390594] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[446.460736] [086/143] (590s left) gem_mmap_gtt (basic-small-bo)
[446.526099] Subtest basic-small-bo: SKIP (0.000s)
[446.569873] [087/143] (590s left) kms_ccs (pipe-c-ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[446.992558] Starting subtest: pipe-C-ccs-on-another-bo-4-tiled-mtl-mc-ccs
[447.017072] Subtest pipe-C-ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.022s)
[447.832632] [088/143] (589s left) api_intel_bb (delta-check)
[447.909010] Starting subtest: delta-check
[447.911831] Subtest delta-check: SUCCESS (0.007s)
[448.015586] [089/143] (589s left) gem_exec_flush (basic-wb-prw-default)
[448.072329] Starting subtest: basic-wb-prw-default
[453.519066] Subtest basic-wb-prw-default: SUCCESS (5.451s)
[453.703719] [090/143] (583s left) kms_plane_lowres (tiling-yf)
[453.800595] Starting subtest: tiling-yf
[453.805316] Subtest tiling-yf: SKIP (0.000s)
[453.860342] [091/143] (583s left) syncobj_timeline (signal)
[453.904880] Starting subtest: signal
[453.906964] Subtest signal: SUCCESS (0.000s)
[453.974373] [092/143] (583s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[454.057495] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[454.062761] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[454.140073] [093/143] (583s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[454.202605] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[454.219326] [094/143] (582s left) gem_exec_fence (syncobj-timeline-export)
[454.795943] Starting subtest: syncobj-timeline-export
[454.806076] Subtest syncobj-timeline-export: SUCCESS (0.012s)
[456.034816] [095/143] (581s left) kms_plane_cursor (overlay)
[456.120632] Starting subtest: overlay
[456.125606] Starting dynamic subtest: pipe-A-eDP-1-size-64
[459.308190] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (3.187s)
[459.377239] Starting dynamic subtest: pipe-A-eDP-1-size-128
[462.598506] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (3.238s)
[462.667594] Starting dynamic subtest: pipe-A-eDP-1-size-256
[465.949634] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (3.293s)
[466.327042] Starting dynamic subtest: pipe-B-eDP-1-size-64
[470.239663] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.926s)
[470.305921] Starting dynamic subtest: pipe-B-eDP-1-size-128
[473.549133] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (3.260s)
[473.618075] Starting dynamic subtest: pipe-B-eDP-1-size-256
[476.869121] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (3.271s)
[477.247041] Starting dynamic subtest: pipe-C-eDP-1-size-64
[480.835334] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.609s)
[480.882922] Starting dynamic subtest: pipe-C-eDP-1-size-128
[483.624361] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.757s)
[483.673175] Starting dynamic subtest: pipe-C-eDP-1-size-256
[486.380241] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.724s)
[486.723431] Starting dynamic subtest: pipe-D-eDP-1-size-64
[490.345464] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.641s)
[490.385634] Starting dynamic subtest: pipe-D-eDP-1-size-128
[493.234122] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.857s)
[493.276148] Starting dynamic subtest: pipe-D-eDP-1-size-256
[496.122531] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.857s)
[496.449592] Subtest overlay: SUCCESS (40.327s)
[497.385276] [096/143] (539s left) gen9_exec_parse (batch-zero-length)
[497.456350] Subtest batch-zero-length: SKIP (0.000s)
[497.493335] [097/143] (539s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[497.772620] Starting subtest: cursor-rapid-movement-max-size
[497.780351] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[497.885722] [098/143] (539s left) api_intel_bb (render)
[497.941009] Starting subtest: render
[497.943840] Starting dynamic subtest: render-none-512
[498.032314] Dynamic subtest render-none-512: SUCCESS (0.093s)
[498.054239] Starting dynamic subtest: render-none-1024
[498.434148] Dynamic subtest render-none-1024: SUCCESS (0.400s)
[498.454721] Starting dynamic subtest: render-x-512
[498.514520] Dynamic subtest render-x-512: SUCCESS (0.081s)
[498.535253] Starting dynamic subtest: render-x-1024
[498.855502] Dynamic subtest render-x-1024: SUCCESS (0.339s)
[498.876053] Starting dynamic subtest: render-y-512
[498.933586] Dynamic subtest render-y-512: SUCCESS (0.079s)
[498.954500] Starting dynamic subtest: render-y-1024
[499.272643] Dynamic subtest render-y-1024: SUCCESS (0.338s)
[499.275482] Subtest render: SUCCESS (1.332s)
[499.359663] [099/143] (538s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[499.435076] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[499.440383] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[499.508963] [100/143] (537s left) syncobj_timeline (invalid-query-bad-pad)
[499.570180] Starting subtest: invalid-query-bad-pad
[499.572812] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[499.646394] [101/143] (537s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-cpu)
[499.746833] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-cpu
[502.506074] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (2.764s)
[502.618652] [102/143] (534s left) gen9_exec_parse (valid-registers)
[502.677270] Subtest valid-registers: SKIP (0.000s)
[502.722995] [103/143] (534s left) kms_addfb_basic (legacy-format)
[502.793135] Starting subtest: legacy-format
[502.846260] Subtest legacy-format: SUCCESS (0.043s)
[502.926859] [104/143] (534s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[503.005763] Starting subtest: psr-rgb565-draw-mmap-cpu
[507.763248] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (4.760s)
[507.875800] [105/143] (529s left) vgem_basic (dmabuf-fence-before)
[507.919554] Starting subtest: dmabuf-fence-before
[507.921934] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[507.968350] [106/143] (529s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[508.331665] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[509.189223] [107/143] (528s left) kms_cursor_crc (cursor-dpms)
[509.297988] Starting subtest: cursor-dpms
[509.304086] Starting dynamic subtest: pipe-A-eDP-1
[512.542224] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.240s)
[512.565261] Starting dynamic subtest: pipe-D-eDP-1
[516.490325] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.944s)
[516.493212] Subtest cursor-dpms: SUCCESS (7.192s)
[517.381228] [108/143] (520s left) kms_ccs (pipe-c-crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[517.802350] Starting subtest: pipe-C-crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[517.808179] Subtest pipe-C-crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[518.691073] [109/143] (518s left) kms_psr (pr-sprite-blt)
[518.754736] Starting subtest: pr-sprite-blt
[518.759688] Subtest pr-sprite-blt: SKIP (0.000s)
[518.859484] [110/143] (518s left) gem_exec_async (forked-writes)
[518.928970] Starting subtest: forked-writes
[518.931676] Starting dynamic subtest: rcs0
[518.960833] Dynamic subtest rcs0: SUCCESS (0.031s)
[518.983707] Starting dynamic subtest: bcs0
[518.998300] Dynamic subtest bcs0: SUCCESS (0.036s)
[519.012178] Starting dynamic subtest: vcs0
[519.025910] Dynamic subtest vcs0: SUCCESS (0.027s)
[519.036264] Starting dynamic subtest: vcs1
[519.051405] Dynamic subtest vcs1: SUCCESS (0.025s)
[519.062159] Starting dynamic subtest: vecs0
[519.078265] Dynamic subtest vecs0: SUCCESS (0.026s)
[519.086278] Starting dynamic subtest: ccs0
[519.100872] Dynamic subtest ccs0: SUCCESS (0.022s)
[519.103336] Subtest forked-writes: SUCCESS (0.172s)
[519.329844] [111/143] (518s left) gem_exec_reloc (basic-gtt-noreloc)
[519.397857] Subtest basic-gtt-noreloc: SKIP (0.000s)
[519.467769] [112/143] (518s left) gem_exec_parallel (fds)
[519.508991] Starting subtest: fds
[519.511452] Starting dynamic subtest: rcs0
[523.276009] Dynamic subtest rcs0: SUCCESS (3.768s)
[523.302272] Starting dynamic subtest: bcs0
[527.714615] Dynamic subtest bcs0: SUCCESS (4.437s)
[527.722878] Starting dynamic subtest: vcs0
[533.060408] Dynamic subtest vcs0: SUCCESS (5.344s)
[533.085390] Starting dynamic subtest: vcs1
[537.157941] Dynamic subtest vcs1: SUCCESS (4.096s)
[537.180085] Starting dynamic subtest: vecs0
[541.083620] Dynamic subtest vecs0: SUCCESS (3.924s)
[541.105712] Starting dynamic subtest: ccs0
[546.287781] Dynamic subtest ccs0: SUCCESS (5.203s)
[546.291133] Subtest fds: SUCCESS (26.781s)
[546.484289] [113/143] (491s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[546.575759] Starting subtest: fbcpsr-rgb101010-draw-render
[551.409389] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (4.836s)
[551.535376] [114/143] (486s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[551.639367] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[551.643774] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[551.739726] [115/143] (486s left) gem_mmap_wc (set-cache-level)
[551.791699] Subtest set-cache-level: SKIP (0.000s)
[551.806587] [116/143] (486s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[551.912393] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[551.914887] Starting dynamic subtest: pipe-A-default-mode
[552.226963] Dynamic subtest pipe-A-default-mode: SKIP (0.314s)
[552.231877] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.315s)
[553.081457] [117/143] (484s left) kms_ccs (pipe-b-bad-pixel-format-y-tiled-gen12-rc-ccs)
[553.454031] Starting subtest: pipe-B-bad-pixel-format-y-tiled-gen12-rc-ccs
[553.459774] Subtest pipe-B-bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[554.344161] [118/143] (483s left) gem_ppgtt (flink-and-close-vma-leak)
[554.404925] Starting subtest: flink-and-close-vma-leak
[554.444407] Subtest flink-and-close-vma-leak: SUCCESS (0.041s)
[554.551432] [119/143] (483s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[554.606293] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[554.707134] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.103s)
[554.787514] [120/143] (483s left) kms_cursor_crc (cursor-random-32x10)
[554.900758] Starting subtest: cursor-random-32x10
[554.932109] Subtest cursor-random-32x10: SKIP (0.026s)
[555.162693] [121/143] (482s left) prime_busy (before-wait)
[555.232433] Starting subtest: before-wait
[555.234844] Starting dynamic subtest: rcs0
[555.249231] Dynamic subtest rcs0: SUCCESS (0.014s)
[555.270163] Starting dynamic subtest: bcs0
[555.289369] Dynamic subtest bcs0: SUCCESS (0.040s)
[555.311136] Starting dynamic subtest: vcs0
[555.330474] Dynamic subtest vcs0: SUCCESS (0.039s)
[555.352968] Starting dynamic subtest: vcs1
[555.371285] Dynamic subtest vcs1: SUCCESS (0.039s)
[555.390021] Starting dynamic subtest: vecs0
[555.413554] Dynamic subtest vecs0: SUCCESS (0.041s)
[555.430735] Starting dynamic subtest: ccs0
[555.455772] Dynamic subtest ccs0: SUCCESS (0.041s)
[555.568531] Subtest before-wait: SUCCESS (0.335s)
[555.647816] [122/143] (482s left) kms_ccs (pipe-d-missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[556.097769] Starting subtest: pipe-D-missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[556.100593] Subtest pipe-D-missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.000s)
[556.927615] [123/143] (481s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[557.030961] Starting subtest: cursorB-vs-flipA-legacy
[557.035840] Subtest cursorB-vs-flipA-legacy: SKIP (0.002s)
[557.132698] [124/143] (481s left) kms_addfb_basic (invalid-get-prop-any)
[557.188514] Starting subtest: invalid-get-prop-any
[557.191150] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[557.305941] [125/143] (480s left) v3d/v3d_submit_csd (multisync-out-syncs)
[557.407257] Subtest multisync-out-syncs: SKIP (0.000s)
[557.466301] [126/143] (480s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[557.550603] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[557.553081] Starting dynamic subtest: pipe-A-default-mode
[560.444264] Dynamic subtest pipe-A-default-mode: SUCCESS (2.895s)
[560.447301] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.897s)
[561.389032] [127/143] (476s left) syncobj_timeline (wait-all-snapshot)
[561.435599] Starting subtest: wait-all-snapshot
[561.519535] Subtest wait-all-snapshot: SUCCESS (0.083s)
[561.598824] [128/143] (476s left) sysfs_timeslice_duration (invalid)
[561.674988] Starting subtest: invalid
[561.677816] Starting dynamic subtest: vecs0
[561.680305] Dynamic subtest vecs0: SUCCESS (0.001s)
[561.700293] Starting dynamic subtest: ccs0
[561.702847] Dynamic subtest ccs0: SUCCESS (0.000s)
[561.714456] Starting dynamic subtest: vcs0
[561.716855] Dynamic subtest vcs0: SUCCESS (0.000s)
[561.725595] Starting dynamic subtest: bcs0
[561.727978] Dynamic subtest bcs0: SUCCESS (0.000s)
[561.735563] Starting dynamic subtest: rcs0
[561.737523] Dynamic subtest rcs0: SUCCESS (0.000s)
[561.744768] Starting dynamic subtest: vcs1
[561.746812] Dynamic subtest vcs1: SUCCESS (0.000s)
[561.748777] Subtest invalid: SUCCESS (0.011s)
[561.765942] [129/143] (476s left) vgem_basic (mmap)
[561.822268] Starting subtest: mmap
[561.824859] Subtest mmap: SUCCESS (0.007s)
[561.869812] [130/143] (476s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[561.942401] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[561.947179] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[562.027003] [131/143] (476s left) gem_pxp (reject-modify-context-protection-off-2)
[564.635386] Subtest reject-modify-context-protection-off-2: SKIP (0.000s)
[564.713302] [132/143] (473s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[564.796869] Starting subtest: plane-all-modeset-transition-fencing
[564.801033] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[564.862769] [133/143] (473s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[564.943330] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[569.564560] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (4.625s)
[569.686578] [134/143] (468s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[569.783661] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[573.076022] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (3.296s)
[573.213425] [135/143] (465s left) gem_workarounds (suspend-resume-fd)
[573.266714] Starting subtest: suspend-resume-fd
[589.250237] Subtest suspend-resume-fd: SUCCESS (1.179s)
[589.348026] [136/143] (464s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[589.461101] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[589.465568] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[589.559460] [137/143] (463s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc)
[589.667931] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc
[594.165135] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc: SUCCESS (4.498s)
[594.282064] [138/143] (459s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[594.398273] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[595.428251] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (1.027s)
[596.345794] [139/143] (457s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[596.740388] Starting subtest: pipe-C-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[598.402634] Subtest pipe-C-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (1.663s)
[599.586766] [140/143] (453s left) v3d/v3d_perfmon (destroy-valid-perfmon)
[599.676758] Subtest destroy-valid-perfmon: SKIP (0.000s)
[599.737918] [141/143] (453s left) gem_ctx_bad_destroy (invalid-default-ctx)
[599.793712] Starting subtest: invalid-default-ctx
[599.796191] Subtest invalid-default-ctx: SUCCESS (0.000s)
[599.865912] [142/143] (453s left) perf_pmu (busy-double-start)
[599.906674] Starting subtest: busy-double-start
[599.908477] Starting dynamic subtest: rcs0
[603.469707] Dynamic subtest rcs0: SUCCESS (3.567s)
[603.492284] Starting dynamic subtest: bcs0
[607.050962] Dynamic subtest bcs0: SUCCESS (3.579s)
[607.073900] Starting dynamic subtest: vcs0
[611.257074] Dynamic subtest vcs0: SUCCESS (4.204s)
[611.279809] Starting dynamic subtest: vcs1
[615.235742] Dynamic subtest vcs1: SUCCESS (3.977s)
[615.259525] Starting dynamic subtest: vecs0
[619.259878] Dynamic subtest vecs0: SUCCESS (4.023s)
[619.282616] Starting dynamic subtest: ccs0
[622.886461] Dynamic subtest ccs0: FAIL (3.576s)
[622.888565] Subtest busy-double-start: FAIL (22.936s)
[622.938896] [143/143] (430s left) gem_exec_endless (dispatch)
[623.015568] Starting subtest: dispatch
[623.017973] Starting dynamic subtest: rcs0
[623.022263] Dynamic subtest rcs0: SUCCESS (0.004s)
[623.034472] Starting dynamic subtest: bcs0
[623.039792] Dynamic subtest bcs0: SUCCESS (0.006s)
[623.050270] Starting dynamic subtest: vcs0
[623.054463] Dynamic subtest vcs0: SUCCESS (0.004s)
[623.061982] Starting dynamic subtest: vcs1
[623.066198] Dynamic subtest vcs1: SUCCESS (0.004s)
[623.073578] Starting dynamic subtest: vecs0
[623.077819] Dynamic subtest vecs0: SUCCESS (0.006s)
[623.085249] Starting dynamic subtest: ccs0
[623.089447] Dynamic subtest ccs0: SUCCESS (0.004s)
[623.091351] Subtest dispatch: SUCCESS (0.032s)
[624.795407] Closing watchdogs
Done.