[42.956626] Initializing watchdogs
[42.956681]   /dev/watchdog0
[42.962441] [001/143] (960s left) drm_fdinfo (virtual-busy-idle-all)
[43.015633] Starting subtest: virtual-busy-idle-all
[43.017440] Subtest virtual-busy-idle-all: SKIP (0.000s)
[43.076391] [002/143] (960s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[43.130416] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[43.131367] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[43.197091] [003/143] (960s left) gem_exec_whisper (basic-contexts-priority)
[43.253679] Starting subtest: basic-contexts-priority
[65.773794] Subtest basic-contexts-priority: SUCCESS (22.518s)
[65.947698] [004/143] (937s left) kms_vblank (crtc-id)
[67.893298] Starting subtest: crtc-id
[67.894244] Starting dynamic subtest: pipe-A-HDMI-A-3
[68.220251] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.326s)
[68.243112] Starting dynamic subtest: pipe-D-HDMI-A-3
[68.486645] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.258s)
[68.487594] Subtest crtc-id: SUCCESS (0.594s)
[68.583895] [005/143] (934s left) gem_exec_schedule (preempt-user)
[68.649412] Starting subtest: preempt-user
[68.650270] Starting dynamic subtest: rcs0
[68.703706] Dynamic subtest rcs0: SUCCESS (0.054s)
[68.708710] Starting dynamic subtest: bcs0
[68.731179] Dynamic subtest bcs0: SUCCESS (0.027s)
[68.736787] Starting dynamic subtest: vcs0
[68.760195] Dynamic subtest vcs0: SUCCESS (0.029s)
[68.765081] Starting dynamic subtest: vcs1
[68.786558] Dynamic subtest vcs1: SUCCESS (0.026s)
[68.791817] Starting dynamic subtest: vecs0
[68.813988] Dynamic subtest vecs0: SUCCESS (0.027s)
[68.819159] Starting dynamic subtest: vecs1
[68.842194] Dynamic subtest vecs1: SUCCESS (0.028s)
[68.846937] Starting dynamic subtest: ccs0
[68.869429] Dynamic subtest ccs0: SUCCESS (0.027s)
[68.874188] Starting dynamic subtest: ccs1
[68.896497] Dynamic subtest ccs1: SUCCESS (0.027s)
[68.901230] Starting dynamic subtest: ccs2
[68.924035] Dynamic subtest ccs2: SUCCESS (0.027s)
[68.928856] Starting dynamic subtest: ccs3
[68.950518] Dynamic subtest ccs3: SUCCESS (0.026s)
[68.951292] Subtest preempt-user: SUCCESS (0.301s)
[69.297898] [006/143] (934s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[71.234088] Starting subtest: plane-all-modeset-transition-internal-panels
[71.235848] Subtest plane-all-modeset-transition-internal-panels: SKIP (0.000s)
[71.281555] [007/143] (932s left) kms_frontbuffer_tracking (psr-suspend)
[73.250580] Starting subtest: psr-suspend
[73.252176] Subtest psr-suspend: SKIP (0.000s)
[73.339344] [008/143] (930s left) kms_psr (psr-primary-render)
[75.349496] Subtest psr-primary-render: SKIP (0.000s)
[75.375195] [009/143] (928s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[77.320823] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[78.587220] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.266s)
[78.700568] [010/143] (924s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[78.751791] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[78.863878] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[78.932744] [011/143] (924s left) kms_pm_backlight (basic-brightness)
[80.864344] Subtest basic-brightness: SKIP (0.000s)
[80.892312] [012/143] (922s left) kms_ccs (pipe-a-bad-rotation-90-y-tiled-gen12-rc-ccs)
[82.876389] Starting subtest: pipe-A-bad-rotation-90-y-tiled-gen12-rc-ccs
[82.878096] Subtest pipe-A-bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[83.032147] [013/143] (920s left) gem_spin_batch (resubmit)
[83.088716] Starting subtest: resubmit
[83.089583] Starting dynamic subtest: rcs0
[83.112236] Dynamic subtest rcs0: SUCCESS (0.023s)
[83.117245] Starting dynamic subtest: bcs0
[83.118155] Dynamic subtest bcs0: SUCCESS (0.002s)
[83.123061] Starting dynamic subtest: vcs0
[83.123898] Dynamic subtest vcs0: SUCCESS (0.001s)
[83.128690] Starting dynamic subtest: vcs1
[83.129509] Dynamic subtest vcs1: SUCCESS (0.001s)
[83.134430] Starting dynamic subtest: vecs0
[83.135426] Dynamic subtest vecs0: SUCCESS (0.001s)
[83.140239] Starting dynamic subtest: vecs1
[83.141323] Dynamic subtest vecs1: SUCCESS (0.002s)
[83.145811] Starting dynamic subtest: ccs0
[83.146668] Dynamic subtest ccs0: SUCCESS (0.003s)
[83.151336] Starting dynamic subtest: ccs1
[83.152232] Dynamic subtest ccs1: SUCCESS (0.003s)
[83.157053] Starting dynamic subtest: ccs2
[83.157933] Dynamic subtest ccs2: SUCCESS (0.001s)
[83.162552] Starting dynamic subtest: ccs3
[83.163439] Dynamic subtest ccs3: SUCCESS (0.002s)
[83.164334] Subtest resubmit: SUCCESS (0.041s)
[83.348680] [014/143] (920s left) gem_exec_flush (basic-batch-kernel-default-wb)
[83.395300] Subtest basic-batch-kernel-default-wb: SKIP (0.000s)
[83.425307] [015/143] (920s left) gem_ctx_param (invalid-set-ringsize)
[83.473289] Starting subtest: invalid-set-ringsize
[83.474190] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[83.535682] [016/143] (920s left) kms_ccs (pipe-b-missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[85.569192] Starting subtest: pipe-B-missing-ccs-buffer-y-tiled-gen12-mc-ccs
[85.570826] Subtest pipe-B-missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[85.701153] [017/143] (917s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[87.655168] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[87.656969] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[87.734891] [018/143] (915s left) kms_getfb (getfb2-handle-zero)
[87.844244] Starting subtest: getfb2-handle-zero
[87.845556] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[87.938712] [019/143] (915s left) kms_ccs (pipe-a-crc-primary-rotation-180-yf-tiled-ccs)
[89.963767] Starting subtest: pipe-A-crc-primary-rotation-180-yf-tiled-ccs
[89.965371] Subtest pipe-A-crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.000s)
[90.117126] [020/143] (913s left) kms_chamelium_color (ctm-0-75)
[92.064428] Subtest ctm-0-75: SKIP (0.000s)
[92.077258] [021/143] (911s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[94.019301] Starting subtest: yf-tiled-16bpp-rotate-270
[94.021118] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[94.106200] [022/143] (909s left) gem_create (hog-create)
[94.234061] Starting subtest: hog-create
[94.235209] Starting dynamic subtest: lmem0
[126.509220] Dynamic subtest lmem0: SUCCESS (32.275s)
[126.514122] Starting dynamic subtest: smem0
[158.774468] Dynamic subtest smem0: SUCCESS (32.265s)
[158.775554] Subtest hog-create: SUCCESS (64.541s)
[158.954386] [023/143] (844s left) perf_pmu (invalid-init)
[159.008670] Starting subtest: invalid-init
[159.009678] Subtest invalid-init: SUCCESS (0.000s)
[159.070075] [024/143] (844s left) perf_pmu (semaphore-wait-idle)
[159.142962] Starting subtest: semaphore-wait-idle
[159.143933] Starting dynamic subtest: rcs0
[159.676981] Dynamic subtest rcs0: SUCCESS (0.533s)
[159.685099] Starting dynamic subtest: bcs0
[160.189247] Dynamic subtest bcs0: SUCCESS (0.512s)
[160.197173] Starting dynamic subtest: vcs0
[160.701565] Dynamic subtest vcs0: SUCCESS (0.512s)
[160.708854] Starting dynamic subtest: vcs1
[161.212775] Dynamic subtest vcs1: SUCCESS (0.511s)
[161.220745] Starting dynamic subtest: vecs0
[161.725040] Dynamic subtest vecs0: SUCCESS (0.512s)
[161.733100] Starting dynamic subtest: vecs1
[162.236845] Dynamic subtest vecs1: SUCCESS (0.512s)
[162.245156] Starting dynamic subtest: ccs0
[162.749062] Dynamic subtest ccs0: SUCCESS (0.512s)
[162.757109] Starting dynamic subtest: ccs1
[163.261225] Dynamic subtest ccs1: SUCCESS (0.512s)
[163.268913] Starting dynamic subtest: ccs2
[163.773054] Dynamic subtest ccs2: SUCCESS (0.512s)
[163.780753] Starting dynamic subtest: ccs3
[164.285052] Dynamic subtest ccs3: SUCCESS (0.511s)
[164.286879] Subtest semaphore-wait-idle: SUCCESS (5.141s)
[164.408295] [025/143] (839s left) core_setmaster_vs_auth
[164.504602] [026/143] (839s left) kms_ccs (pipe-b-crc-primary-basic-y-tiled-ccs)
[166.499087] Starting subtest: pipe-B-crc-primary-basic-y-tiled-ccs
[166.500918] Subtest pipe-B-crc-primary-basic-y-tiled-ccs: SKIP (0.000s)
[166.635687] [027/143] (837s left) kms_pm_dc (dc6-dpms)
[169.582266] Starting subtest: dc6-dpms
[169.584092] Subtest dc6-dpms: SKIP (0.000s)
[169.718560] [028/143] (834s left) gem_flink_basic (bad-open)
[169.836314] Starting subtest: bad-open
[169.837291] Subtest bad-open: SUCCESS (0.000s)
[169.885754] [029/143] (833s left) gem_pwrite_snooped
[169.980076] [030/143] (833s left) i915_power (sanity)
[170.034385] Starting subtest: sanity
[174.071404] Subtest sanity: SUCCESS (4.036s)
[174.191443] [031/143] (829s left) gem_caching (read-writes)
[174.236284] Starting subtest: read-writes
[184.341699] Subtest read-writes: SUCCESS (10.105s)
[184.432977] [032/143] (819s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[186.367009] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[186.371014] Starting dynamic subtest: pipe-A-HDMI-A-3
[186.456411] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.085s)
[186.468785] Starting dynamic subtest: pipe-B-HDMI-A-3
[186.619292] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.159s)
[186.632915] Starting dynamic subtest: pipe-C-HDMI-A-3
[186.743680] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.119s)
[186.754134] Starting dynamic subtest: pipe-D-HDMI-A-3
[186.868816] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.121s)
[186.869809] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (0.502s)
[187.007292] [033/143] (816s left) kms_psr (fbc-psr2-sprite-plane-move)
[188.959802] Subtest fbc-psr2-sprite-plane-move: SKIP (0.000s)
[189.013851] [034/143] (814s left) kms_ccs (pipe-d-bad-pixel-format-4-tiled-mtl-rc-ccs)
[191.116587] Starting subtest: pipe-D-bad-pixel-format-4-tiled-mtl-rc-ccs
[191.118149] Subtest pipe-D-bad-pixel-format-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[191.221582] [035/143] (812s left) kms_psr2_sf (overlay-plane-update-sf-dmg-area)
[191.269321] Subtest overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[191.298286] [036/143] (812s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[193.244973] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[193.858213] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.613s)
[194.023313] [037/143] (809s left) gem_userptr_blits (sd-probe)
[194.070987] Starting subtest: sd-probe
[194.072602] Subtest sd-probe: SKIP (0.000s)
[194.181670] [038/143] (809s left) kms_selftest (drm_cmdline_parser)
[194.222743] Starting subtest: drm_cmdline_parser
[194.374409] Starting dynamic subtest: drm_test_cmdline_force_d_only
[194.377813] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.013s)
[194.387672] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[194.388503] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.000s)
[194.394679] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[194.395448] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.003s)
[194.401674] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[194.402477] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.000s)
[194.408217] Starting dynamic subtest: drm_test_cmdline_force_e_only
[194.409154] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.000s)
[194.415221] Starting dynamic subtest: drm_test_cmdline_res
[194.416341] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.000s)
[194.422235] Starting dynamic subtest: drm_test_cmdline_res_vesa
[194.423317] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.000s)
[194.428972] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[194.430276] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.000s)
[194.436282] Starting dynamic subtest: drm_test_cmdline_res_rblank
[194.437500] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.000s)
[194.443582] Starting dynamic subtest: drm_test_cmdline_res_bpp
[194.444777] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.000s)
[194.450545] Starting dynamic subtest: drm_test_cmdline_res_refresh
[194.451560] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.000s)
[194.457263] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[194.458135] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.000s)
[194.463629] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[194.464411] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.000s)
[194.469874] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[194.471190] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.000s)
[194.478556] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[194.479588] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.000s)
[194.485692] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[194.487064] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.000s)
[194.493306] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[194.494454] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.000s)
[194.500509] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[194.501573] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.000s)
[194.507230] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[194.508238] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.000s)
[194.514310] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[194.515554] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.000s)
[194.521575] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[194.522579] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.000s)
[194.528592] Starting dynamic subtest: drm_test_cmdline_name
[194.529750] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.000s)
[194.536200] Starting dynamic subtest: drm_test_cmdline_name_bpp
[194.537279] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.000s)
[194.543234] Starting dynamic subtest: drm_test_cmdline_name_option
[194.544552] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.000s)
[194.550681] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[194.552049] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.000s)
[194.558735] Starting dynamic subtest: drm_test_cmdline_rotate_0
[194.559582] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.000s)
[194.565451] Starting dynamic subtest: drm_test_cmdline_rotate_90
[194.566576] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.000s)
[194.572430] Starting dynamic subtest: drm_test_cmdline_rotate_180
[194.573451] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.000s)
[194.579202] Starting dynamic subtest: drm_test_cmdline_rotate_270
[194.580226] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.000s)
[194.586162] Starting dynamic subtest: drm_test_cmdline_hmirror
[194.587223] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.000s)
[194.593126] Starting dynamic subtest: drm_test_cmdline_vmirror
[194.594360] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.000s)
[194.600122] Starting dynamic subtest: drm_test_cmdline_margin_options
[194.601441] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.000s)
[194.607526] Starting dynamic subtest: drm_test_cmdline_multiple_options
[194.608681] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.000s)
[194.614939] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[194.616273] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.000s)
[194.622313] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[194.623453] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.000s)
[194.629179] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[194.630177] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.000s)
[194.636050] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[194.637186] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.000s)
[194.643325] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[194.644573] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.000s)
[194.650587] Starting dynamic subtest: drm_test_cmdline_invalid
[194.651778] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.002s)
[194.657594] Starting dynamic subtest: drm_test_cmdline_tv_options
[194.658840] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.003s)
[194.660293] Subtest drm_cmdline_parser: SUCCESS (0.173s)
[194.670693] [039/143] (809s left) gem_close_race (multigpu-basic-threads)
[194.737383] Starting subtest: multigpu-basic-threads
[194.739037] Subtest multigpu-basic-threads: SKIP (0.000s)
[194.969527] [040/143] (809s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[196.949747] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[197.541058] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.592s)
[197.703274] [041/143] (806s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[199.677979] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[199.679744] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[199.739940] [042/143] (804s left) vc4/vc4_perfmon (get-values-valid-perfmon)
[199.842303] Subtest get-values-valid-perfmon: SKIP (0.000s)
[199.897979] [043/143] (804s left) gem_mmap_offset (perf)
[199.971363] Starting subtest: perf
[199.972243] Starting dynamic subtest: lmem0
[200.239697] Dynamic subtest lmem0: SUCCESS (0.268s)
[200.245707] Starting dynamic subtest: smem0
[200.249530] Dynamic subtest smem0: SUCCESS (0.002s)
[200.250343] Subtest perf: SUCCESS (0.271s)
[200.304688] [044/143] (803s left) kms_atomic (plane-primary-legacy)
[202.239151] Starting subtest: plane-primary-legacy
[202.240144] Starting dynamic subtest: pipe-A-HDMI-A-3
[203.148409] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.908s)
[203.149348] Subtest plane-primary-legacy: SUCCESS (0.909s)
[203.299586] [045/143] (800s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[205.244270] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[207.734187] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (2.490s)
[207.883591] [046/143] (796s left) i915_pm_rpm (gem-execbuf-stress)
[212.578833] Starting subtest: gem-execbuf-stress
[212.580590] Starting dynamic subtest: lmem0
[225.541778] Dynamic subtest lmem0: SUCCESS (12.963s)
[225.550770] Starting dynamic subtest: extra-wait-lmem0
[288.947860] Dynamic subtest extra-wait-lmem0: SUCCESS (63.405s)
[288.954415] Starting dynamic subtest: smem0
[301.879636] Dynamic subtest smem0: SUCCESS (12.932s)
[301.888252] Starting dynamic subtest: extra-wait-smem0
[365.329049] Dynamic subtest extra-wait-smem0: SUCCESS (63.448s)
[365.330630] Subtest gem-execbuf-stress: SUCCESS (152.750s)
[366.465513] [047/143] (637s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[368.457395] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[368.459111] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[368.530234] [048/143] (635s left) gem_workarounds (basic-read-fd)
[368.665302] Starting subtest: basic-read-fd
[368.697750] Subtest basic-read-fd: SUCCESS (0.033s)
[368.804450] [049/143] (635s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[370.775542] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[370.777239] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[370.864839] [050/143] (633s left) kms_ccs (pipe-b-crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[372.943480] Starting subtest: pipe-B-crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[372.945276] Subtest pipe-B-crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[373.079091] [051/143] (631s left) syncobj_wait (single-wait-for-submit-signaled)
[373.120839] Starting subtest: single-wait-for-submit-signaled
[373.121805] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[373.180343] [052/143] (631s left) gem_exec_balancer (hog)
[373.248536] Starting subtest: hog
[373.250803] Subtest hog: SKIP (0.000s)
[373.528209] [053/143] (630s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[376.107330] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SKIP (0.000s)
[376.169675] [054/143] (628s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[378.113046] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[378.114893] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[378.181294] [055/143] (626s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[378.291818] Starting subtest: y-tiled-to-vebox-yf-tiled
[378.294662] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[378.493846] [056/143] (625s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-pwrite)
[380.468939] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-pwrite
[383.049717] Subtest fbc-1p-offscren-pri-shrfb-draw-pwrite: SUCCESS (2.583s)
[383.165438] [057/143] (621s left) kms_ccs (pipe-a-random-ccs-data-4-tiled-dg2-rc-ccs)
[385.145139] Starting subtest: pipe-A-random-ccs-data-4-tiled-dg2-rc-ccs
[385.258933] Subtest pipe-A-random-ccs-data-4-tiled-dg2-rc-ccs: SUCCESS (0.114s)
[385.436687] [058/143] (618s left) kms_ccs (pipe-d-ccs-on-another-bo-yf-tiled-ccs)
[387.567253] Starting subtest: pipe-D-ccs-on-another-bo-yf-tiled-ccs
[387.569098] Subtest pipe-D-ccs-on-another-bo-yf-tiled-ccs: SKIP (0.000s)
[387.661296] [059/143] (616s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[389.609731] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[389.611458] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[389.679440] [060/143] (614s left) gem_exec_fence (syncobj-signal)
[390.465405] Starting subtest: syncobj-signal
[390.484911] Subtest syncobj-signal: SUCCESS (0.019s)
[390.855371] [061/143] (613s left) kms_flip (plain-flip-fb-recreate)
[392.799412] Starting subtest: plain-flip-fb-recreate
[392.804402] Starting dynamic subtest: A-HDMI-A3
[400.814831] Dynamic subtest A-HDMI-A3: SUCCESS (8.003s)
[400.823689] Starting dynamic subtest: B-HDMI-A3
[408.753510] Dynamic subtest B-HDMI-A3: SUCCESS (7.944s)
[408.760632] Starting dynamic subtest: C-HDMI-A3
[416.698048] Dynamic subtest C-HDMI-A3: SUCCESS (7.944s)
[416.705426] Starting dynamic subtest: D-HDMI-A3
[424.642691] Dynamic subtest D-HDMI-A3: SUCCESS (7.944s)
[424.643574] Subtest plain-flip-fb-recreate: SUCCESS (31.845s)
[424.783085] [062/143] (579s left) device_reset (unbind-reset-rebind)
[424.855270] Starting subtest: unbind-reset-rebind
[426.751694] Subtest unbind-reset-rebind: SUCCESS (1.896s)
[428.791570] [063/143] (575s left) kms_ccs (pipe-a-bad-pixel-format-4-tiled-mtl-mc-ccs)
[431.619641] Starting subtest: pipe-A-bad-pixel-format-4-tiled-mtl-mc-ccs
[431.621310] Subtest pipe-A-bad-pixel-format-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[431.826967] [064/143] (572s left) kms_prop_blob (invalid-get-prop)
[431.872531] Starting subtest: invalid-get-prop
[431.873402] Subtest invalid-get-prop: SUCCESS (0.000s)
[431.939865] [065/143] (572s left) kms_properties (invalid-properties-atomic)
[433.932496] Starting subtest: invalid-properties-atomic
[434.251723] Subtest invalid-properties-atomic: SUCCESS (0.320s)
[434.309848] [066/143] (570s left) kms_psr (pr-no-drrs)
[436.248642] Subtest pr-no-drrs: SKIP (0.000s)
[436.270468] [067/143] (568s left) gem_exec_schedule (out-order)
[436.326301] Starting subtest: out-order
[436.327232] Starting dynamic subtest: rcs0
[436.591623] Dynamic subtest rcs0: SUCCESS (0.264s)
[436.598767] Starting dynamic subtest: bcs0
[436.779646] Dynamic subtest bcs0: SUCCESS (0.188s)
[436.786976] Starting dynamic subtest: vcs0
[436.976888] Dynamic subtest vcs0: SUCCESS (0.197s)
[436.984172] Starting dynamic subtest: vcs1
[437.175135] Dynamic subtest vcs1: SUCCESS (0.198s)
[437.182179] Starting dynamic subtest: vecs0
[437.373051] Dynamic subtest vecs0: SUCCESS (0.197s)
[437.380474] Starting dynamic subtest: vecs1
[437.572747] Dynamic subtest vecs1: SUCCESS (0.199s)
[437.579879] Starting dynamic subtest: ccs0
[437.767303] Dynamic subtest ccs0: SUCCESS (0.194s)
[437.774536] Starting dynamic subtest: ccs1
[437.965154] Dynamic subtest ccs1: SUCCESS (0.197s)
[437.972382] Starting dynamic subtest: ccs2
[438.164275] Dynamic subtest ccs2: SUCCESS (0.199s)
[438.171361] Starting dynamic subtest: ccs3
[438.361851] Dynamic subtest ccs3: SUCCESS (0.197s)
[438.362731] Subtest out-order: SUCCESS (2.035s)
[438.696800] [068/143] (565s left) perf (missing-sample-flags)
[439.015794] Starting subtest: missing-sample-flags
[439.016588] Subtest missing-sample-flags: SUCCESS (0.001s)
[439.041193] [069/143] (565s left) kms_psr (fbc-psr2-basic)
[440.982667] Subtest fbc-psr2-basic: SKIP (0.000s)
[441.003290] [070/143] (563s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[441.052286] Starting subtest: legacy-engines-hostile-preempt
[441.053186] Starting dynamic subtest: render
[441.116304] Dynamic subtest render: SUCCESS (0.064s)
[441.123697] Starting dynamic subtest: bsd1
[441.154379] Dynamic subtest bsd1: SUCCESS (0.037s)
[441.164891] Starting dynamic subtest: bsd2
[441.174252] Dynamic subtest bsd2: SUCCESS (0.019s)
[441.187574] Starting dynamic subtest: blt
[441.235734] Dynamic subtest blt: SUCCESS (0.060s)
[441.265310] Starting dynamic subtest: vebox
[441.294037] Dynamic subtest vebox: SUCCESS (0.056s)
[441.295646] Subtest legacy-engines-hostile-preempt: SUCCESS (0.242s)
[441.410077] [071/143] (563s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[443.487192] Starting subtest: pipe-D-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[443.489786] Subtest pipe-D-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.002s)
[443.579352] [072/143] (561s left) vc4/vc4_mmap (mmap-bad-handle)
[443.647860] Subtest mmap-bad-handle: SKIP (0.000s)
[443.696504] [073/143] (560s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[445.653506] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[445.655269] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[445.734990] [074/143] (558s left) kms_vblank (ts-continuation-modeset)
[447.750536] Starting subtest: ts-continuation-modeset
[447.751477] Starting dynamic subtest: pipe-A-HDMI-A-3
[448.150141] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.398s)
[448.158896] Starting dynamic subtest: pipe-D-HDMI-A-3
[448.402210] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.249s)
[448.403330] Subtest ts-continuation-modeset: SUCCESS (0.651s)
[448.516211] [075/143] (556s left) kms_chamelium_hpd (common-hpd-after-suspend)
[450.503420] Subtest common-hpd-after-suspend: SKIP (0.000s)
[450.560628] [076/143] (554s left) gem_readwrite (read-bad-handle)
[450.615205] Subtest read-bad-handle: SKIP (0.000s)
[450.677454] [077/143] (554s left) kms_dsc (dsc-with-formats)
[452.658138] Subtest dsc-with-formats: SKIP (0.000s)
[452.674708] [078/143] (552s left) kms_cursor_edge_walk (256x256-top-bottom)
[454.612762] Starting subtest: 256x256-top-bottom
[454.613696] Starting dynamic subtest: pipe-A-HDMI-A-3
[457.911293] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (3.298s)
[457.919884] Starting dynamic subtest: pipe-D-HDMI-A-3
[461.107448] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (3.195s)
[461.108255] Subtest 256x256-top-bottom: SUCCESS (6.496s)
[461.232109] [079/143] (543s left) gem_exec_whisper (basic-sync-all)
[461.301774] Starting subtest: basic-sync-all
[476.411457] Subtest basic-sync-all: SUCCESS (15.108s)
[476.583210] [080/143] (528s left) kms_vrr (flip-basic)
[478.530785] Starting subtest: flip-basic
[478.532686] Subtest flip-basic: SKIP (0.000s)
[478.597975] [081/143] (526s left) kms_rotation_crc (primary-rotation-90)
[480.596523] Starting subtest: primary-rotation-90
[480.598455] Subtest primary-rotation-90: SKIP (0.001s)
[480.663959] [082/143] (524s left) gem_lmem_swapping (parallel-random)
[485.864299] Starting subtest: parallel-random
[485.865065] Starting dynamic subtest: lmem0
[518.323064] Dynamic subtest lmem0: SUCCESS (32.462s)
[518.323906] Subtest parallel-random: SUCCESS (32.463s)
[519.483188] [083/143] (485s left) kms_lease (lease-invalid-connector)
[525.508369] Starting subtest: lease-invalid-connector
[525.509370] Starting dynamic subtest: pipe-A-HDMI-A-3
[525.510249] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.000s)
[525.517466] Starting dynamic subtest: pipe-B-HDMI-A-3
[525.518305] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.000s)
[525.523907] Starting dynamic subtest: pipe-C-HDMI-A-3
[525.525070] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.000s)
[525.531037] Starting dynamic subtest: pipe-D-HDMI-A-3
[525.532241] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.000s)
[525.533478] Subtest lease-invalid-connector: SUCCESS (0.005s)
[525.586099] [084/143] (479s left) kms_flip (bo-too-big)
[527.583498] Starting subtest: bo-too-big
[527.588993] Starting dynamic subtest: A-HDMI-A3
[527.802582] Dynamic subtest A-HDMI-A3: SUCCESS (0.213s)
[527.816254] Starting dynamic subtest: B-HDMI-A3
[527.988707] Dynamic subtest B-HDMI-A3: SUCCESS (0.185s)
[527.995852] Starting dynamic subtest: C-HDMI-A3
[528.140712] Dynamic subtest C-HDMI-A3: SUCCESS (0.150s)
[528.164728] Starting dynamic subtest: D-HDMI-A3
[528.323202] Dynamic subtest D-HDMI-A3: SUCCESS (0.180s)
[528.324050] Subtest bo-too-big: SUCCESS (0.741s)
[528.500113] [085/143] (476s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[528.571984] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[528.572955] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[528.635222] [086/143] (476s left) gem_mmap_gtt (basic-small-bo)
[528.718761] Subtest basic-small-bo: SKIP (0.000s)
[528.741352] [087/143] (476s left) kms_ccs (pipe-c-ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[530.790063] Starting subtest: pipe-C-ccs-on-another-bo-4-tiled-mtl-mc-ccs
[530.791721] Subtest pipe-C-ccs-on-another-bo-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[530.905218] [088/143] (474s left) api_intel_bb (delta-check)
[530.956423] Starting subtest: delta-check
[530.974232] Subtest delta-check: SUCCESS (0.018s)
[531.093520] [089/143] (473s left) gem_exec_flush (basic-wb-prw-default)
[531.154890] Subtest basic-wb-prw-default: SKIP (0.000s)
[531.199922] [090/143] (473s left) kms_plane_lowres (tiling-yf)
[533.145709] Starting subtest: tiling-yf
[533.147427] Subtest tiling-yf: SKIP (0.000s)
[533.206296] [091/143] (471s left) syncobj_timeline (signal)
[533.293926] Starting subtest: signal
[533.295470] Subtest signal: SUCCESS (0.001s)
[533.382255] [092/143] (471s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[535.365192] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[535.367110] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[535.443670] [093/143] (469s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[535.558239] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[535.584494] [094/143] (469s left) gem_exec_fence (syncobj-timeline-export)
[536.390535] Starting subtest: syncobj-timeline-export
[536.410480] Subtest syncobj-timeline-export: SUCCESS (0.025s)
[536.741509] [095/143] (468s left) kms_plane_cursor (overlay)
[538.730511] Starting subtest: overlay
[538.732420] Starting dynamic subtest: pipe-A-HDMI-A-3-size-64
[542.008275] Dynamic subtest pipe-A-HDMI-A-3-size-64: SUCCESS (3.276s)
[542.081724] Starting dynamic subtest: pipe-A-HDMI-A-3-size-128
[545.424653] Dynamic subtest pipe-A-HDMI-A-3-size-128: SUCCESS (3.349s)
[545.501214] Starting dynamic subtest: pipe-A-HDMI-A-3-size-256
[548.824867] Dynamic subtest pipe-A-HDMI-A-3-size-256: SUCCESS (3.331s)
[548.924614] Starting dynamic subtest: pipe-B-HDMI-A-3-size-64
[552.279172] Dynamic subtest pipe-B-HDMI-A-3-size-64: SUCCESS (3.362s)
[552.334751] Starting dynamic subtest: pipe-B-HDMI-A-3-size-128
[555.612582] Dynamic subtest pipe-B-HDMI-A-3-size-128: SUCCESS (3.283s)
[555.673010] Starting dynamic subtest: pipe-B-HDMI-A-3-size-256
[558.929193] Dynamic subtest pipe-B-HDMI-A-3-size-256: SUCCESS (3.265s)
[559.046949] Starting dynamic subtest: pipe-C-HDMI-A-3-size-64
[562.332945] Dynamic subtest pipe-C-HDMI-A-3-size-64: SUCCESS (3.293s)
[562.393183] Starting dynamic subtest: pipe-C-HDMI-A-3-size-128
[565.666665] Dynamic subtest pipe-C-HDMI-A-3-size-128: SUCCESS (3.281s)
[565.727280] Starting dynamic subtest: pipe-C-HDMI-A-3-size-256
[568.950252] Dynamic subtest pipe-C-HDMI-A-3-size-256: SUCCESS (3.231s)
[569.031062] Starting dynamic subtest: pipe-D-HDMI-A-3-size-64
[572.486792] Dynamic subtest pipe-D-HDMI-A-3-size-64: SUCCESS (3.461s)
[572.542560] Starting dynamic subtest: pipe-D-HDMI-A-3-size-128
[575.919012] Dynamic subtest pipe-D-HDMI-A-3-size-128: SUCCESS (3.383s)
[575.979209] Starting dynamic subtest: pipe-D-HDMI-A-3-size-256
[579.352549] Dynamic subtest pipe-D-HDMI-A-3-size-256: SUCCESS (3.382s)
[579.425722] Subtest overlay: SUCCESS (40.695s)
[579.565516] [096/143] (425s left) gen9_exec_parse (batch-zero-length)
[579.619682] Subtest batch-zero-length: SKIP (0.000s)
[579.637827] [097/143] (425s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[581.774803] Starting subtest: cursor-rapid-movement-max-size
[581.777408] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[581.913625] [098/143] (423s left) api_intel_bb (render)
[581.999911] Starting subtest: render
[582.000849] Starting dynamic subtest: render-none-512
[582.040308] Dynamic subtest render-none-512: SUCCESS (0.040s)
[582.046649] Starting dynamic subtest: render-none-1024
[582.090806] Dynamic subtest render-none-1024: SUCCESS (0.050s)
[582.097242] Starting dynamic subtest: render-x-512
[582.105478] Dynamic subtest render-x-512: SUCCESS (0.014s)
[582.111916] Starting dynamic subtest: render-x-1024
[582.164099] Dynamic subtest render-x-1024: SUCCESS (0.058s)
[582.170525] Starting dynamic subtest: render-y-512
[582.179920] Dynamic subtest render-y-512: SUCCESS (0.015s)
[582.186332] Starting dynamic subtest: render-y-1024
[582.243050] Dynamic subtest render-y-1024: SUCCESS (0.062s)
[582.243955] Subtest render: SUCCESS (0.244s)
[582.365833] [099/143] (422s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[584.335176] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[584.336820] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[584.416217] [100/143] (420s left) syncobj_timeline (invalid-query-bad-pad)
[584.541880] Starting subtest: invalid-query-bad-pad
[584.543021] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[584.600794] [101/143] (420s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-cpu)
[586.566874] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-cpu
[588.399745] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (1.832s)
[588.530677] [102/143] (416s left) gen9_exec_parse (valid-registers)
[588.580195] Subtest valid-registers: SKIP (0.000s)
[588.605011] [103/143] (416s left) kms_addfb_basic (legacy-format)
[588.649450] Starting subtest: legacy-format
[588.689580] Subtest legacy-format: SUCCESS (0.033s)
[590.646457] [104/143] (414s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[592.669904] Starting subtest: psr-rgb565-draw-mmap-cpu
[592.671611] Subtest psr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[592.748399] [105/143] (412s left) vgem_basic (dmabuf-fence-before)
[592.864513] Starting subtest: dmabuf-fence-before
[592.865634] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[592.927687] [106/143] (412s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[594.937012] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[594.992259] [107/143] (410s left) kms_cursor_crc (cursor-dpms)
[596.964886] Starting subtest: cursor-dpms
[596.966876] Starting dynamic subtest: pipe-A-HDMI-A-3
[597.995385] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (1.028s)
[598.005412] Starting dynamic subtest: pipe-D-HDMI-A-3
[598.863047] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.866s)
[598.863966] Subtest cursor-dpms: SUCCESS (1.898s)
[599.193949] [108/143] (406s left) kms_ccs (pipe-c-crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[601.234891] Starting subtest: pipe-C-crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[601.549954] Subtest pipe-C-crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SUCCESS (0.314s)
[601.789329] [109/143] (403s left) kms_psr (pr-sprite-blt)
[603.754137] Subtest pr-sprite-blt: SKIP (0.000s)
[603.777009] [110/143] (401s left) gem_exec_async (forked-writes)
[603.831346] Starting subtest: forked-writes
[603.832306] Starting dynamic subtest: rcs0
[603.904586] Dynamic subtest rcs0: SUCCESS (0.073s)
[603.914622] Starting dynamic subtest: bcs0
[603.956515] Dynamic subtest bcs0: SUCCESS (0.051s)
[603.964250] Starting dynamic subtest: vcs0
[604.003633] Dynamic subtest vcs0: SUCCESS (0.046s)
[604.010316] Starting dynamic subtest: vcs1
[604.045118] Dynamic subtest vcs1: SUCCESS (0.041s)
[604.051684] Starting dynamic subtest: vecs0
[604.091376] Dynamic subtest vecs0: SUCCESS (0.046s)
[604.098211] Starting dynamic subtest: vecs1
[604.132644] Dynamic subtest vecs1: SUCCESS (0.040s)
[604.139282] Starting dynamic subtest: ccs0
[604.173707] Dynamic subtest ccs0: SUCCESS (0.040s)
[604.180391] Starting dynamic subtest: ccs1
[604.216226] Dynamic subtest ccs1: SUCCESS (0.042s)
[604.223264] Starting dynamic subtest: ccs2
[604.259976] Dynamic subtest ccs2: SUCCESS (0.042s)
[604.266579] Starting dynamic subtest: ccs3
[604.299898] Dynamic subtest ccs3: SUCCESS (0.040s)
[604.300731] Subtest forked-writes: SUCCESS (0.469s)
[604.528860] [111/143] (400s left) gem_exec_reloc (basic-gtt-noreloc)
[604.608515] Subtest basic-gtt-noreloc: SKIP (0.000s)
[604.644294] [112/143] (400s left) gem_exec_parallel (fds)
[604.701061] Starting subtest: fds
[604.701954] Starting dynamic subtest: rcs0
[609.206859] Dynamic subtest rcs0: SUCCESS (4.505s)
[609.213971] Starting dynamic subtest: bcs0
[613.320441] Dynamic subtest bcs0: SUCCESS (4.113s)
[613.327478] Starting dynamic subtest: vcs0
[617.560791] Dynamic subtest vcs0: SUCCESS (4.240s)
[617.568074] Starting dynamic subtest: vcs1
[622.167585] Dynamic subtest vcs1: SUCCESS (4.606s)
[622.174946] Starting dynamic subtest: vecs0
[626.401460] Dynamic subtest vecs0: SUCCESS (4.233s)
[626.408611] Starting dynamic subtest: vecs1
[630.984737] Dynamic subtest vecs1: SUCCESS (4.582s)
[630.991761] Starting dynamic subtest: ccs0
[635.510370] Dynamic subtest ccs0: SUCCESS (4.525s)
[635.517400] Starting dynamic subtest: ccs1
[639.847690] Dynamic subtest ccs1: SUCCESS (4.336s)
[639.855025] Starting dynamic subtest: ccs2
[644.239319] Dynamic subtest ccs2: SUCCESS (4.391s)
[644.246626] Starting dynamic subtest: ccs3
[648.138051] Dynamic subtest ccs3: SUCCESS (3.898s)
[648.139323] Subtest fds: SUCCESS (43.437s)
[648.378569] [113/143] (357s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[650.325148] Starting subtest: fbcpsr-rgb101010-draw-render
[650.326886] Subtest fbcpsr-rgb101010-draw-render: SKIP (0.000s)
[650.407707] [114/143] (355s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[652.436958] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[652.438637] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[652.505625] [115/143] (353s left) gem_mmap_wc (set-cache-level)
[652.610535] Subtest set-cache-level: SKIP (0.000s)
[652.660314] [116/143] (352s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[654.646510] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[654.647446] Starting dynamic subtest: pipe-A-valid-mode
[655.335347] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.688s)
[655.336339] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SUCCESS (0.689s)
[655.463556] [117/143] (350s left) kms_ccs (pipe-b-bad-pixel-format-y-tiled-gen12-rc-ccs)
[657.485748] Starting subtest: pipe-B-bad-pixel-format-y-tiled-gen12-rc-ccs
[657.487628] Subtest pipe-B-bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[657.633864] [118/143] (348s left) gem_ppgtt (flink-and-close-vma-leak)
[657.700373] Starting subtest: flink-and-close-vma-leak
[657.744704] Subtest flink-and-close-vma-leak: SUCCESS (0.044s)
[657.866884] [119/143] (347s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[657.960562] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[658.065322] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.104s)
[658.163975] [120/143] (347s left) kms_cursor_crc (cursor-random-32x10)
[660.176814] Starting subtest: cursor-random-32x10
[660.221391] Subtest cursor-random-32x10: SKIP (0.042s)
[660.518151] [121/143] (345s left) prime_busy (before-wait)
[660.608497] Starting subtest: before-wait
[660.613048] Starting dynamic subtest: rcs0
[660.658330] Dynamic subtest rcs0: SUCCESS (0.045s)
[660.665529] Starting dynamic subtest: bcs0
[660.696992] Dynamic subtest bcs0: SUCCESS (0.038s)
[660.705583] Starting dynamic subtest: vcs0
[660.739534] Dynamic subtest vcs0: SUCCESS (0.042s)
[660.767039] Starting dynamic subtest: vcs1
[660.782792] Dynamic subtest vcs1: SUCCESS (0.041s)
[660.807921] Starting dynamic subtest: vecs0
[660.823518] Dynamic subtest vecs0: SUCCESS (0.039s)
[660.837887] Starting dynamic subtest: vecs1
[660.864563] Dynamic subtest vecs1: SUCCESS (0.040s)
[660.876618] Starting dynamic subtest: ccs0
[660.908573] Dynamic subtest ccs0: SUCCESS (0.043s)
[660.930285] Starting dynamic subtest: ccs1
[660.950207] Dynamic subtest ccs1: SUCCESS (0.040s)
[660.971885] Starting dynamic subtest: ccs2
[660.992321] Dynamic subtest ccs2: SUCCESS (0.041s)
[661.014207] Starting dynamic subtest: ccs3
[661.033051] Dynamic subtest ccs3: SUCCESS (0.039s)
[661.141966] Subtest before-wait: SUCCESS (0.533s)
[661.267757] [122/143] (344s left) kms_ccs (pipe-d-missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[663.322483] Starting subtest: pipe-D-missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[663.324288] Subtest pipe-D-missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[663.418590] [123/143] (342s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[665.363745] Starting subtest: cursorB-vs-flipA-legacy
[665.365674] Subtest cursorB-vs-flipA-legacy: SKIP (0.002s)
[665.421329] [124/143] (340s left) kms_addfb_basic (invalid-get-prop-any)
[665.498391] Starting subtest: invalid-get-prop-any
[665.499631] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[667.492724] [125/143] (338s left) v3d/v3d_submit_csd (multisync-out-syncs)
[667.655228] Subtest multisync-out-syncs: SKIP (0.000s)
[667.728517] [126/143] (338s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[669.706458] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[669.707445] Starting dynamic subtest: pipe-A-valid-mode
[670.556209] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.849s)
[670.557099] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (0.850s)
[670.709844] [127/143] (335s left) syncobj_timeline (wait-all-snapshot)
[670.760192] Starting subtest: wait-all-snapshot
[670.841215] Subtest wait-all-snapshot: SUCCESS (0.082s)
[670.941186] [128/143] (335s left) sysfs_timeslice_duration (invalid)
[671.000268] Starting subtest: invalid
[671.001217] Starting dynamic subtest: ccs2
[671.002146] Dynamic subtest ccs2: SUCCESS (0.000s)
[671.009374] Starting dynamic subtest: vecs0
[671.010248] Dynamic subtest vecs0: SUCCESS (0.000s)
[671.017191] Starting dynamic subtest: ccs0
[671.018204] Dynamic subtest ccs0: SUCCESS (0.000s)
[671.025210] Starting dynamic subtest: vcs0
[671.026359] Dynamic subtest vcs0: SUCCESS (0.000s)
[671.033396] Starting dynamic subtest: bcs0
[671.034527] Dynamic subtest bcs0: SUCCESS (0.000s)
[671.041445] Starting dynamic subtest: ccs3
[671.042239] Dynamic subtest ccs3: SUCCESS (0.000s)
[671.049166] Starting dynamic subtest: vecs1
[671.050188] Dynamic subtest vecs1: SUCCESS (0.000s)
[671.057670] Starting dynamic subtest: ccs1
[671.058536] Dynamic subtest ccs1: SUCCESS (0.000s)
[671.065530] Starting dynamic subtest: rcs0
[671.066639] Dynamic subtest rcs0: SUCCESS (0.000s)
[671.074111] Starting dynamic subtest: vcs1
[671.075258] Dynamic subtest vcs1: SUCCESS (0.000s)
[671.076456] Subtest invalid: SUCCESS (0.008s)
[671.088380] [129/143] (334s left) vgem_basic (mmap)
[671.140651] Starting subtest: mmap
[671.147141] Subtest mmap: SUCCESS (0.007s)
[671.187550] [130/143] (334s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[673.130639] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[673.132276] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[673.207592] [131/143] (332s left) gem_pxp (reject-modify-context-protection-off-2)
[675.842534] Subtest reject-modify-context-protection-off-2: SKIP (0.000s)
[675.918912] [132/143] (330s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[677.855422] Starting subtest: plane-all-modeset-transition-fencing
[677.856353] Starting dynamic subtest: pipe-A-HDMI-A-3
[692.776543] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (14.919s)
[692.856360] Starting dynamic subtest: pipe-B-HDMI-A-3
[701.684992] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (8.835s)
[701.741707] Subtest plane-all-modeset-transition-fencing: SUCCESS (23.886s)
[701.875691] [133/143] (304s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[703.846976] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[703.848804] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[703.922404] [134/143] (302s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[705.916924] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[708.438541] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (2.521s)
[708.558420] [135/143] (297s left) gem_workarounds (suspend-resume-fd)
[708.612109] Starting subtest: suspend-resume-fd
[727.781238] Subtest suspend-resume-fd: SUCCESS (3.822s)
[730.919624] [136/143] (293s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[732.864006] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[732.865761] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[732.930258] [137/143] (291s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc)
[734.960840] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc
[734.962572] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[735.029967] [138/143] (289s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[737.007888] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[738.017495] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (1.010s)
[738.168163] [139/143] (286s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[740.220762] Starting subtest: pipe-C-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[740.223690] Subtest pipe-C-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.002s)
[740.335557] [140/143] (284s left) v3d/v3d_perfmon (destroy-valid-perfmon)
[740.450409] Subtest destroy-valid-perfmon: SKIP (0.000s)
[740.524007] [141/143] (284s left) gem_ctx_bad_destroy (invalid-default-ctx)
[740.595291] Starting subtest: invalid-default-ctx
[740.596263] Subtest invalid-default-ctx: SUCCESS (0.000s)
[740.652116] [142/143] (283s left) perf_pmu (busy-double-start)
[740.712096] Starting subtest: busy-double-start
[740.713050] Starting dynamic subtest: rcs0
[744.316015] Dynamic subtest rcs0: SUCCESS (3.603s)
[744.328016] Starting dynamic subtest: bcs0
[747.897192] Dynamic subtest bcs0: SUCCESS (3.579s)
[747.907259] Starting dynamic subtest: vcs0
[751.477216] Dynamic subtest vcs0: FAIL (3.561s)
[751.488448] Starting dynamic subtest: vcs1
[755.036820] Dynamic subtest vcs1: FAIL (3.560s)
[755.046961] Starting dynamic subtest: vecs0
[758.598487] Dynamic subtest vecs0: FAIL (3.560s)
[758.608832] Starting dynamic subtest: vecs1
[762.162274] Dynamic subtest vecs1: FAIL (3.561s)
[762.172896] Starting dynamic subtest: ccs0
[765.728023] Dynamic subtest ccs0: SUCCESS (3.583s)
[765.740187] Starting dynamic subtest: ccs1
[769.312017] Dynamic subtest ccs1: SUCCESS (3.581s)
[769.324305] Starting dynamic subtest: ccs2
[772.899139] Dynamic subtest ccs2: SUCCESS (3.585s)
[772.909570] Starting dynamic subtest: ccs3
[776.480251] Dynamic subtest ccs3: SUCCESS (3.580s)
[776.481327] Subtest busy-double-start: FAIL (35.768s)
[776.598101] [143/143] (248s left) gem_exec_endless (dispatch)
[776.660530] Starting subtest: dispatch
[776.661458] Starting dynamic subtest: rcs0
[776.665938] Dynamic subtest rcs0: SUCCESS (0.005s)
[776.674588] Starting dynamic subtest: bcs0
[776.676241] Dynamic subtest bcs0: SUCCESS (0.004s)
[776.684811] Starting dynamic subtest: vcs0
[776.686441] Dynamic subtest vcs0: SUCCESS (0.004s)
[776.695019] Starting dynamic subtest: vcs1
[776.696946] Dynamic subtest vcs1: SUCCESS (0.005s)
[776.705673] Starting dynamic subtest: vecs0
[776.707594] Dynamic subtest vecs0: SUCCESS (0.007s)
[776.716686] Starting dynamic subtest: vecs1
[776.718308] Dynamic subtest vecs1: SUCCESS (0.007s)
[776.726686] Starting dynamic subtest: ccs0
[776.728298] Dynamic subtest ccs0: SUCCESS (0.004s)
[776.736540] Starting dynamic subtest: ccs1
[776.738317] Dynamic subtest ccs1: SUCCESS (0.004s)
[776.746519] Starting dynamic subtest: ccs2
[776.748453] Dynamic subtest ccs2: SUCCESS (0.004s)
[776.756514] Starting dynamic subtest: ccs3
[776.758243] Dynamic subtest ccs3: SUCCESS (0.004s)
[776.759217] Subtest dispatch: SUCCESS (0.055s)
[776.817193] Closing watchdogs
Done.