[24.759872] Initializing watchdogs
[24.759928]   /dev/watchdog0
[24.765118] [001/143] (960s left) kms_vblank (wait-busy)
[26.726345] Starting subtest: wait-busy
[26.727166] Starting dynamic subtest: pipe-A-HDMI-A-1
[29.182247] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.455s)
[29.188492] Starting dynamic subtest: pipe-D-HDMI-A-1
[31.526053] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.340s)
[31.526924] Subtest wait-busy: SUCCESS (4.799s)
[31.624438] [002/143] (953s left) i915_pm_rps (waitboost)
[31.693865] Starting subtest: waitboost
[34.275441] Subtest waitboost: SUCCESS (2.582s)
[34.346821] [003/143] (950s left) syncobj_timeline (single-wait-for-submit-signaled)
[34.403183] Starting subtest: single-wait-for-submit-signaled
[34.404081] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[34.513971] [004/143] (950s left) kms_plane_scaling (planes-downscale-factor-0-25-upscale-factor-0-25)
[36.491423] Starting subtest: planes-downscale-factor-0-25-upscale-factor-0-25
[36.495136] Starting dynamic subtest: pipe-A-HDMI-A-1
[36.508238] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.012s)
[36.515177] Starting dynamic subtest: pipe-B-HDMI-A-1
[36.536962] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.025s)
[36.544099] Starting dynamic subtest: pipe-C-HDMI-A-1
[36.567205] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.025s)
[36.573482] Starting dynamic subtest: pipe-D-HDMI-A-1
[36.596382] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.025s)
[36.598101] Subtest planes-downscale-factor-0-25-upscale-factor-0-25: SKIP (0.104s)
[36.672328] [005/143] (948s left) kms_flip (absolute-wf_vblank)
[38.620466] Starting subtest: absolute-wf_vblank
[38.623713] Starting dynamic subtest: A-HDMI-A1
[46.422178] Dynamic subtest A-HDMI-A1: SUCCESS (7.798s)
[46.427659] Starting dynamic subtest: B-HDMI-A1
[54.082880] Dynamic subtest B-HDMI-A1: SUCCESS (7.660s)
[54.087756] Starting dynamic subtest: C-HDMI-A1
[61.743742] Dynamic subtest C-HDMI-A1: SUCCESS (7.660s)
[61.748347] Starting dynamic subtest: D-HDMI-A1
[69.405503] Dynamic subtest D-HDMI-A1: SUCCESS (7.661s)
[69.407714] Subtest absolute-wf_vblank: SUCCESS (30.789s)
[69.561292] [006/143] (915s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[71.523429] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[74.413377] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (2.890s)
[74.575215] [007/143] (910s left) i915_module_load (reload)
[74.665168] Starting subtest: reload
[85.332809] Subtest reload: SUCCESS (10.668s)
[85.342838] [008/143] (900s left) gem_readwrite (write-bad-handle)
[85.445323] Subtest write-bad-handle: SKIP (0.000s)
[85.477491] [009/143] (899s left) gem_ctx_persistence (userptr)
[85.573645] Starting subtest: userptr
[85.750141] Subtest userptr: SUCCESS (0.176s)
[85.854409] [010/143] (899s left) sysfs_heartbeat_interval (precise)
[85.954347] Starting subtest: precise
[85.955352] Starting dynamic subtest: ccs2
[87.339526] Dynamic subtest ccs2: SUCCESS (1.385s)
[87.344737] Starting dynamic subtest: vecs0
[88.624065] Dynamic subtest vecs0: SUCCESS (1.284s)
[88.629165] Starting dynamic subtest: ccs0
[91.604899] Dynamic subtest ccs0: SUCCESS (2.980s)
[91.613865] Starting dynamic subtest: vcs0
[92.956541] Dynamic subtest vcs0: SUCCESS (1.352s)
[92.961588] Starting dynamic subtest: bcs0
[95.510207] Dynamic subtest bcs0: SUCCESS (2.553s)
[95.518331] Starting dynamic subtest: ccs3
[98.563283] Dynamic subtest ccs3: SUCCESS (3.053s)
[98.568299] Starting dynamic subtest: vecs1
[99.905595] Dynamic subtest vecs1: SUCCESS (1.342s)
[99.910657] Starting dynamic subtest: ccs1
[101.320847] Dynamic subtest ccs1: SUCCESS (1.415s)
[101.325739] Starting dynamic subtest: rcs0
[104.586510] Dynamic subtest rcs0: SUCCESS (3.266s)
[104.591519] Starting dynamic subtest: vcs1
[107.510233] Dynamic subtest vcs1: SUCCESS (2.923s)
[107.511580] Subtest precise: SUCCESS (21.556s)
[107.635083] [011/143] (877s left) kms_chamelium_frames (hdmi-aspect-ratio)
[109.658594] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[109.710335] [012/143] (875s left) kms_draw_crc (draw-method-render)
[111.661383] Starting subtest: draw-method-render
[111.662348] Starting dynamic subtest: xrgb8888-untiled
[112.087254] Dynamic subtest xrgb8888-untiled: SUCCESS (0.425s)
[112.094532] Starting dynamic subtest: rgb565-untiled
[112.403810] Dynamic subtest rgb565-untiled: SUCCESS (0.316s)
[112.411373] Starting dynamic subtest: xrgb2101010-untiled
[112.703810] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.299s)
[112.713169] Starting dynamic subtest: xrgb8888-xtiled
[112.870342] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.166s)
[112.892344] Starting dynamic subtest: rgb565-xtiled
[113.053845] Dynamic subtest rgb565-xtiled: SUCCESS (0.183s)
[113.076481] Starting dynamic subtest: xrgb2101010-xtiled
[113.220097] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.166s)
[113.229026] Starting dynamic subtest: xrgb8888-4tiled
[113.370058] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.151s)
[113.375565] Starting dynamic subtest: rgb565-4tiled
[113.520685] Dynamic subtest rgb565-4tiled: SUCCESS (0.149s)
[113.542697] Starting dynamic subtest: xrgb2101010-4tiled
[113.685744] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.166s)
[113.686779] Subtest draw-method-render: SUCCESS (2.024s)
[113.805284] [013/143] (871s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[115.777226] Starting subtest: short-flip-after-cursor-atomic-transitions
[116.792746] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (1.014s)
[116.936844] [014/143] (868s left) perf_pmu (render-node-busy-idle)
[117.037250] Starting subtest: render-node-busy-idle
[117.038145] Starting dynamic subtest: rcs0
[117.726186] Dynamic subtest rcs0: SUCCESS (0.688s)
[117.735539] Starting dynamic subtest: bcs0
[118.388413] Dynamic subtest bcs0: SUCCESS (0.662s)
[118.397967] Starting dynamic subtest: vcs0
[119.060112] Dynamic subtest vcs0: SUCCESS (0.671s)
[119.069561] Starting dynamic subtest: vcs1
[119.715921] Dynamic subtest vcs1: SUCCESS (0.655s)
[119.725537] Starting dynamic subtest: vecs0
[120.379978] Dynamic subtest vecs0: SUCCESS (0.664s)
[120.389626] Starting dynamic subtest: vecs1
[121.043102] Dynamic subtest vecs1: SUCCESS (0.663s)
[121.052618] Starting dynamic subtest: ccs0
[121.705291] Dynamic subtest ccs0: SUCCESS (0.662s)
[121.715626] Starting dynamic subtest: ccs1
[122.368322] Dynamic subtest ccs1: SUCCESS (0.663s)
[122.378460] Starting dynamic subtest: ccs2
[123.026239] Dynamic subtest ccs2: SUCCESS (0.658s)
[123.036513] Starting dynamic subtest: ccs3
[123.681376] Dynamic subtest ccs3: SUCCESS (0.655s)
[123.683476] Subtest render-node-busy-idle: SUCCESS (6.643s)
[123.736830] [015/143] (861s left) vgem_basic (create)
[123.823700] Starting subtest: create
[123.825200] Subtest create: SUCCESS (0.000s)
[123.900839] [016/143] (861s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[125.861055] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[125.862811] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[125.919639] [017/143] (859s left) syncobj_wait (invalid-wait-zero-handles)
[126.031770] Starting subtest: invalid-wait-zero-handles
[126.087044] Subtest invalid-wait-zero-handles: FAIL (0.030s)
[126.154267] [018/143] (859s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[128.233196] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[128.309478] [019/143] (857s left) syncobj_timeline (invalid-query-bad-pad)
[128.394283] Starting subtest: invalid-query-bad-pad
[128.395218] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[128.465290] [020/143] (857s left) vc4/vc4_perfmon (destroy-invalid-perfmon)
[128.562139] Subtest destroy-invalid-perfmon: SKIP (0.000s)
[128.608539] [021/143] (857s left) kms_3d
[130.558199] [022/143] (855s left) v3d/v3d_submit_csd (bad-in-sync)
[130.642130] Subtest bad-in-sync: SKIP (0.000s)
[130.693310] [023/143] (855s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[132.646872] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[132.648674] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[132.725275] [024/143] (853s left) gem_exec_nop (basic-sequential)
[132.864592] Starting subtest: basic-sequential
[138.297244] Subtest basic-sequential: SUCCESS (5.433s)
[138.513996] [025/143] (847s left) gem_mmap (short-mmap)
[138.577378] Subtest short-mmap: SKIP (0.000s)
[138.616170] [026/143] (847s left) kms_ccs (pipe-d-crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[140.703316] Starting subtest: pipe-D-crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[140.705902] Subtest pipe-D-crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.002s)
[140.830583] [027/143] (845s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[142.827336] Starting subtest: cursor-vs-flip-atomic-transitions
[172.756383] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (29.928s)
[172.895047] [028/143] (812s left) gem_exec_schedule (u-fairslice)
[172.966836] Starting subtest: u-fairslice
[172.967728] Starting dynamic subtest: rcs0
[175.008565] Dynamic subtest rcs0: SUCCESS (2.041s)
[175.014458] Starting dynamic subtest: bcs0
[177.027243] Dynamic subtest bcs0: SUCCESS (2.018s)
[177.032940] Starting dynamic subtest: vcs0
[179.043042] Dynamic subtest vcs0: SUCCESS (2.016s)
[179.049218] Starting dynamic subtest: vcs1
[181.061169] Dynamic subtest vcs1: SUCCESS (2.018s)
[181.067090] Starting dynamic subtest: vecs0
[183.076723] Dynamic subtest vecs0: SUCCESS (2.015s)
[183.082606] Starting dynamic subtest: vecs1
[185.091131] Dynamic subtest vecs1: SUCCESS (2.014s)
[185.097172] Starting dynamic subtest: ccs0
[187.107943] Dynamic subtest ccs0: SUCCESS (2.017s)
[187.114270] Starting dynamic subtest: ccs1
[189.124188] Dynamic subtest ccs1: SUCCESS (2.016s)
[189.130470] Starting dynamic subtest: ccs2
[191.140633] Dynamic subtest ccs2: SUCCESS (2.016s)
[191.147047] Starting dynamic subtest: ccs3
[193.156984] Dynamic subtest ccs3: SUCCESS (2.016s)
[193.157850] Subtest u-fairslice: SUCCESS (20.189s)
[193.488404] [029/143] (792s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[195.449128] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[195.450741] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[195.513293] [030/143] (790s left) kms_lease (lease-revoke)
[197.497330] Starting subtest: lease-revoke
[197.498252] Starting dynamic subtest: pipe-A-HDMI-A-1
[197.570836] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.072s)
[197.577034] Starting dynamic subtest: pipe-B-HDMI-A-1
[197.618881] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.048s)
[197.627929] Starting dynamic subtest: pipe-C-HDMI-A-1
[197.681792] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.062s)
[197.695149] Starting dynamic subtest: pipe-D-HDMI-A-1
[197.745768] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.062s)
[197.746862] Subtest lease-revoke: SUCCESS (0.249s)
[197.896063] [031/143] (788s left) gem_mmap_gtt (big-bo-tiledy)
[197.997413] Subtest big-bo-tiledY: SKIP (0.000s)
[198.040965] [032/143] (787s left) kms_plane_alpha_blend (constant-alpha-max)
[200.008501] Starting subtest: constant-alpha-max
[200.221871] Starting dynamic subtest: pipe-A-HDMI-A-1
[201.102543] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.880s)
[201.108538] Starting dynamic subtest: pipe-D-HDMI-A-1
[201.967445] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.864s)
[201.968330] Subtest constant-alpha-max: SUCCESS (1.959s)
[202.088656] [033/143] (783s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[202.153063] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[202.155119] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[202.342668] [034/143] (783s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[202.438221] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[202.463786] [035/143] (783s left) kms_cursor_edge_walk (256x256-top-bottom)
[204.415770] Starting subtest: 256x256-top-bottom
[204.416720] Starting dynamic subtest: pipe-A-HDMI-A-1
[207.719359] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.303s)
[207.725246] Starting dynamic subtest: pipe-D-HDMI-A-1
[210.940334] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (3.220s)
[210.941309] Subtest 256x256-top-bottom: SUCCESS (6.526s)
[211.058387] [036/143] (774s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-render)
[213.021391] Starting subtest: psr-1p-offscren-pri-shrfb-draw-render
[213.023062] Subtest psr-1p-offscren-pri-shrfb-draw-render: SKIP (0.000s)
[213.089477] [037/143] (772s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[215.113519] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[215.114398] Starting dynamic subtest: pipe-A-valid-mode
[215.185551] Dynamic subtest pipe-A-valid-mode: SKIP (0.069s)
[215.189071] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.070s)
[215.336845] [038/143] (770s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[215.436215] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[215.437227] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[215.566360] [039/143] (770s left) api_intel_bb (add-remove-objects)
[215.663281] Starting subtest: add-remove-objects
[215.701926] Subtest add-remove-objects: SUCCESS (0.039s)
[215.829497] [040/143] (770s left) kms_feature_discovery (dp-mst)
[217.812560] Starting subtest: dp-mst
[217.814347] Subtest dp-mst: SKIP (0.000s)
[217.865039] [041/143] (768s left) gem_exec_parallel (userptr)
[218.002019] Starting subtest: userptr
[218.003444] Starting dynamic subtest: rcs0
[219.678801] Dynamic subtest rcs0: SUCCESS (1.674s)
[219.685625] Starting dynamic subtest: bcs0
[221.308674] Dynamic subtest bcs0: SUCCESS (1.632s)
[221.314988] Starting dynamic subtest: vcs0
[222.980661] Dynamic subtest vcs0: SUCCESS (1.672s)
[222.988385] Starting dynamic subtest: vcs1
[224.651513] Dynamic subtest vcs1: SUCCESS (1.670s)
[224.658481] Starting dynamic subtest: vecs0
[226.275565] Dynamic subtest vecs0: SUCCESS (1.624s)
[226.282209] Starting dynamic subtest: vecs1
[227.909432] Dynamic subtest vecs1: SUCCESS (1.633s)
[227.915798] Starting dynamic subtest: ccs0
[229.561467] Dynamic subtest ccs0: SUCCESS (1.652s)
[229.567485] Starting dynamic subtest: ccs1
[231.178528] Dynamic subtest ccs1: SUCCESS (1.617s)
[231.184912] Starting dynamic subtest: ccs2
[232.867669] Dynamic subtest ccs2: SUCCESS (1.689s)
[232.874667] Starting dynamic subtest: ccs3
[234.469501] Dynamic subtest ccs3: SUCCESS (1.602s)
[234.470410] Subtest userptr: SUCCESS (16.468s)
[234.714674] [042/143] (751s left) syncobj_wait (multi-wait-for-submit-submitted)
[234.781401] Starting subtest: multi-wait-for-submit-submitted
[234.882837] Subtest multi-wait-for-submit-submitted: SUCCESS (0.101s)
[234.970519] [043/143] (751s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[236.955041] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.000s)
[236.974816] [044/143] (749s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[238.935368] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[238.937228] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[239.002050] [045/143] (747s left) kms_ccs (pipe-a-bad-rotation-90-4-tiled-mtl-rc-ccs)
[241.041107] Starting subtest: pipe-A-bad-rotation-90-4-tiled-mtl-rc-ccs
[241.042822] Subtest pipe-A-bad-rotation-90-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[241.200505] [046/143] (745s left) kms_ccs (pipe-d-crc-primary-basic-yf-tiled-ccs)
[243.272794] Starting subtest: pipe-D-crc-primary-basic-yf-tiled-ccs
[243.274449] Subtest pipe-D-crc-primary-basic-yf-tiled-ccs: SKIP (0.000s)
[243.376321] [047/143] (742s left) vc4/vc4_label_bo (set-kernel-name)
[243.446485] Subtest set-kernel-name: SKIP (0.000s)
[243.500231] [048/143] (742s left) kms_ccs (pipe-b-crc-primary-basic-4-tiled-mtl-rc-ccs)
[245.557118] Starting subtest: pipe-B-crc-primary-basic-4-tiled-mtl-rc-ccs
[245.558917] Subtest pipe-B-crc-primary-basic-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[245.697851] [049/143] (740s left) gem_exec_balancer (full-late-pulse)
[245.789255] Starting subtest: full-late-pulse
[247.166337] Subtest full-late-pulse: SUCCESS (1.377s)
[247.465354] [050/143] (738s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[252.580681] Starting subtest: modeset-non-lpsp-stress-no-wait
[253.628406] Subtest modeset-non-lpsp-stress-no-wait: SKIP (1.047s)
[253.791171] [051/143] (732s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[255.826219] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[255.827777] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[255.912865] [052/143] (730s left) gem_close_race (multigpu-basic-process)
[256.085385] Starting subtest: multigpu-basic-process
[256.086979] Subtest multigpu-basic-process: SKIP (0.000s)
[256.313574] [053/143] (730s left) gem_exec_schedule (preempt-engines)
[256.382361] Starting subtest: preempt-engines
[256.383358] Starting dynamic subtest: rcs0
[258.601574] Dynamic subtest rcs0: SUCCESS (2.218s)
[258.612420] Starting dynamic subtest: bcs0
[260.799717] Dynamic subtest bcs0: SUCCESS (2.196s)
[260.807276] Starting dynamic subtest: vcs0
[263.117228] Dynamic subtest vcs0: SUCCESS (2.316s)
[263.124569] Starting dynamic subtest: vcs1
[265.433506] Dynamic subtest vcs1: SUCCESS (2.314s)
[265.440430] Starting dynamic subtest: vecs0
[267.754078] Dynamic subtest vecs0: SUCCESS (2.318s)
[267.760589] Starting dynamic subtest: vecs1
[270.068933] Dynamic subtest vecs1: SUCCESS (2.314s)
[270.076377] Starting dynamic subtest: ccs0
[272.289346] Dynamic subtest ccs0: SUCCESS (2.219s)
[272.296488] Starting dynamic subtest: ccs1
[274.516265] Dynamic subtest ccs1: SUCCESS (2.225s)
[274.524622] Starting dynamic subtest: ccs2
[276.737435] Dynamic subtest ccs2: SUCCESS (2.220s)
[276.745190] Starting dynamic subtest: ccs3
[278.959504] Dynamic subtest ccs3: SUCCESS (2.220s)
[278.961245] Subtest preempt-engines: SUCCESS (22.577s)
[279.276856] [054/143] (707s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[281.243380] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[281.245122] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[281.312835] [055/143] (705s left) gem_exec_suspend (basic)
[281.454830] Starting subtest: basic
[281.455895] Starting dynamic subtest: smem
[282.411801] Dynamic subtest smem: SUCCESS (0.957s)
[282.419311] Starting dynamic subtest: lmem0
[283.340860] Dynamic subtest lmem0: SUCCESS (0.928s)
[283.342281] Subtest basic: SUCCESS (1.885s)
[283.550609] [056/143] (702s left) gem_exec_async (concurrent-writes)
[283.651349] Starting subtest: concurrent-writes
[283.652305] Starting dynamic subtest: rcs0
[283.699217] Dynamic subtest rcs0: SUCCESS (0.048s)
[283.706467] Starting dynamic subtest: bcs0
[283.712907] Dynamic subtest bcs0: SUCCESS (0.013s)
[283.719256] Starting dynamic subtest: vcs0
[283.724685] Dynamic subtest vcs0: SUCCESS (0.011s)
[283.731054] Starting dynamic subtest: vcs1
[283.736849] Dynamic subtest vcs1: SUCCESS (0.012s)
[283.743157] Starting dynamic subtest: vecs0
[283.748810] Dynamic subtest vecs0: SUCCESS (0.011s)
[283.755225] Starting dynamic subtest: vecs1
[283.760796] Dynamic subtest vecs1: SUCCESS (0.012s)
[283.767164] Starting dynamic subtest: ccs0
[283.772843] Dynamic subtest ccs0: SUCCESS (0.012s)
[283.779291] Starting dynamic subtest: ccs1
[283.784719] Dynamic subtest ccs1: SUCCESS (0.012s)
[283.791146] Starting dynamic subtest: ccs2
[283.796794] Dynamic subtest ccs2: SUCCESS (0.012s)
[283.803138] Starting dynamic subtest: ccs3
[283.808831] Dynamic subtest ccs3: SUCCESS (0.011s)
[283.809982] Subtest concurrent-writes: SUCCESS (0.158s)
[284.055356] [057/143] (702s left) kms_addfb_basic (master-rmfb)
[284.149021] Starting subtest: master-rmfb
[284.149870] Subtest master-rmfb: SUCCESS (0.001s)
[286.132545] [058/143] (700s left) kms_properties (connector-properties-legacy)
[288.163455] Starting subtest: connector-properties-legacy
[288.961923] Subtest connector-properties-legacy: SUCCESS (0.799s)
[289.128447] [059/143] (697s left) kms_cursor_crc (cursor-onscreen-256x256)
[291.260136] Starting subtest: cursor-onscreen-256x256
[291.265103] Starting dynamic subtest: pipe-A-HDMI-A-1
[294.068855] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.805s)
[294.106444] Starting dynamic subtest: pipe-D-HDMI-A-1
[296.624925] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.524s)
[296.625875] Subtest cursor-onscreen-256x256: SUCCESS (5.364s)
[296.847043] [060/143] (689s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y-tiled-ccs)
[298.900047] Starting subtest: pipe-B-crc-sprite-planes-basic-y-tiled-ccs
[298.902915] Subtest pipe-B-crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.002s)
[299.029951] [061/143] (687s left) gem_partial_pwrite_pread (reads-snoop)
[299.099349] Subtest reads-snoop: SKIP (0.000s)
[299.139884] [062/143] (687s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[301.104818] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[301.106410] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[301.184578] [063/143] (685s left) kms_ccs (pipe-a-bad-aux-stride-y-tiled-ccs)
[303.267809] Starting subtest: pipe-A-bad-aux-stride-y-tiled-ccs
[303.269726] Subtest pipe-A-bad-aux-stride-y-tiled-ccs: SKIP (0.000s)
[303.415926] [064/143] (683s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[305.384393] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[305.386054] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[305.453479] [065/143] (681s left) drm_fdinfo (memory-info-idle)
[305.571386] Starting subtest: memory-info-idle
[305.572597] Starting dynamic subtest: lmem0
[305.630852] Dynamic subtest lmem0: SUCCESS (0.059s)
[305.637153] Starting dynamic subtest: smem0
[305.664990] Dynamic subtest smem0: SUCCESS (0.034s)
[305.665945] Subtest memory-info-idle: SUCCESS (0.094s)
[305.768521] [066/143] (680s left) gem_exec_fence (invalid-fence-array)
[306.591708] Starting subtest: invalid-fence-array
[306.595143] Subtest invalid-fence-array: SUCCESS (0.002s)
[306.982607] [067/143] (679s left) kms_universal_plane (universal-plane-pageflip-windowed)
[308.975604] Starting subtest: universal-plane-pageflip-windowed
[308.976521] Starting dynamic subtest: pipe-A-HDMI-A-1
[309.509231] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.531s)
[309.526958] Starting dynamic subtest: pipe-B-HDMI-A-1
[309.881809] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.369s)
[309.889608] Starting dynamic subtest: pipe-C-HDMI-A-1
[310.263863] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.379s)
[310.276488] Starting dynamic subtest: pipe-D-HDMI-A-1
[310.635870] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.371s)
[310.636646] Subtest universal-plane-pageflip-windowed: SUCCESS (1.660s)
[310.762394] [068/143] (675s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[312.722530] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[312.724241] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[312.820777] [069/143] (673s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[312.958406] Starting subtest: multi-wait-available-unsubmitted-signaled
[312.959372] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.001s)
[313.032093] [070/143] (673s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[313.118948] Starting subtest: framebuffer-vs-set-tiling
[313.120583] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[315.079951] [071/143] (671s left) gem_exec_whisper (basic-fds-forked-all)
[315.191275] Starting subtest: basic-fds-forked-all
[346.903969] Subtest basic-fds-forked-all: SUCCESS (31.712s)
[348.558697] [072/143] (638s left) gem_ctx_persistence (heartbeat-close)
[348.653220] Starting subtest: heartbeat-close
[348.654910] Subtest heartbeat-close: SKIP (0.000s)
[348.733337] [073/143] (638s left) kms_ccs (pipe-d-bad-aux-stride-y-tiled-gen12-rc-ccs)
[350.839750] Starting subtest: pipe-D-bad-aux-stride-y-tiled-gen12-rc-ccs
[350.841528] Subtest pipe-D-bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[350.932507] [074/143] (635s left) kms_ccs (pipe-d-missing-ccs-buffer-yf-tiled-ccs)
[353.005474] Starting subtest: pipe-D-missing-ccs-buffer-yf-tiled-ccs
[353.007281] Subtest pipe-D-missing-ccs-buffer-yf-tiled-ccs: SKIP (0.000s)
[353.101576] [075/143] (633s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[355.061789] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[355.062801] Starting dynamic subtest: pipe-A-valid-mode
[355.111412] Dynamic subtest pipe-A-valid-mode: SKIP (0.047s)
[355.113196] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.049s)
[355.200558] [076/143] (631s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[357.197969] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[358.417564] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.219s)
[358.523556] [077/143] (628s left) kms_atomic_transition (plane-all-transition-fencing)
[360.469126] Starting subtest: plane-all-transition-fencing
[360.470114] Starting dynamic subtest: pipe-A-HDMI-A-1
[364.250905] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.781s)
[364.328815] Starting dynamic subtest: pipe-B-HDMI-A-1
[368.145329] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.822s)
[368.201638] Subtest plane-all-transition-fencing: SUCCESS (7.732s)
[368.318059] [078/143] (618s left) syncobj_timeline (reset-during-wait-for-submit)
[368.378384] Starting subtest: reset-during-wait-for-submit
[368.480267] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[368.556327] [079/143] (618s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[370.520570] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[370.522188] Subtest fbcpsr-rgb565-draw-mmap-wc: SKIP (0.000s)
[370.600992] [080/143] (616s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[372.645115] Starting subtest: fbcpsr-2p-rte
[372.646865] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[372.732552] [081/143] (614s left) gem_userptr_blits (probe)
[372.902069] Starting subtest: probe
[373.080671] Subtest probe: SUCCESS (0.165s)
[373.177840] [082/143] (613s left) gen9_exec_parse (batch-invalid-length)
[373.244820] Subtest batch-invalid-length: SKIP (0.000s)
[373.288597] [083/143] (613s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[375.244944] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[375.246837] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[375.314318] [084/143] (611s left) gem_mmap_gtt (basic-read)
[375.431428] Subtest basic-read: SKIP (0.000s)
[375.483804] [085/143] (611s left) gem_eio (wait-wedge-immediate)
[375.795922] Starting subtest: wait-wedge-immediate
[377.407336] Subtest wait-wedge-immediate: SUCCESS (1.612s)
[379.364023] [086/143] (607s left) kms_ccs (pipe-c-crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[381.428876] Starting subtest: pipe-C-crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[381.430661] Subtest pipe-C-crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[381.550639] [087/143] (605s left) kms_ccs (pipe-a-missing-ccs-buffer-y-tiled-ccs)
[383.567087] Starting subtest: pipe-A-missing-ccs-buffer-y-tiled-ccs
[383.568897] Subtest pipe-A-missing-ccs-buffer-y-tiled-ccs: SKIP (0.000s)
[383.721485] [088/143] (603s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[385.687500] Starting subtest: x-tiled-32bpp-rotate-270
[385.740397] Subtest x-tiled-32bpp-rotate-270: SKIP (0.052s)
[385.867608] [089/143] (601s left) gem_softpin (allocator-nopin)
[385.990182] Starting subtest: allocator-nopin
[386.168194] Subtest allocator-nopin: SUCCESS (0.177s)
[386.284505] [090/143] (600s left) gem_pxp (create-protected-buffer)
[388.900937] Subtest create-protected-buffer: SKIP (0.000s)
[388.961123] [091/143] (598s left) kms_psr (fbc-pr-no-drrs)
[390.912627] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[390.931891] [092/143] (596s left) kms_psr2_sf (fbc-cursor-plane-update-sf)
[390.995600] Subtest fbc-cursor-plane-update-sf: SKIP (0.000s)
[391.043136] [093/143] (596s left) gem_mmap (basic-small-bo)
[391.134554] Subtest basic-small-bo: SKIP (0.000s)
[391.168061] [094/143] (596s left) kms_psr (fbc-psr-basic)
[393.142114] Subtest fbc-psr-basic: SKIP (0.000s)
[393.165599] [095/143] (594s left) gem_mmap_gtt (close-race)
[393.221202] Subtest close-race: SKIP (0.000s)
[393.253616] [096/143] (594s left) gem_workarounds (reset)
[393.380581] Starting subtest: reset
[393.630964] Subtest reset: SUCCESS (0.250s)
[393.777792] [097/143] (593s left) syncobj_eventfd (invalid-bad-pad)
[393.852473] Starting subtest: invalid-bad-pad
[393.853429] Subtest invalid-bad-pad: SUCCESS (0.000s)
[393.934651] [098/143] (593s left) gem_sync (basic-store-each)
[394.006016] Starting subtest: basic-store-each
[398.216758] Subtest basic-store-each: SUCCESS (4.210s)
[398.453092] [099/143] (588s left) kms_fbcon_fbt (psr)
[398.555203] Starting subtest: psr
[398.557210] Subtest psr: SKIP (0.000s)
[398.652696] [100/143] (588s left) kms_cursor_crc (cursor-sliding-32x10)
[400.687973] Starting subtest: cursor-sliding-32x10
[400.730887] Subtest cursor-sliding-32x10: SKIP (0.040s)
[401.027591] [101/143] (586s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[403.011470] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[405.807704] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (2.796s)
[405.952834] [102/143] (581s left) kms_selftest (drm_damage_helper)
[406.020432] Starting subtest: drm_damage_helper
[406.159120] Starting dynamic subtest: drm_test_damage_iter_no_damage
[406.190846] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.028s)
[406.216255] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[406.217336] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.000s)
[406.228951] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[406.229907] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.000s)
[406.238722] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[406.239587] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.000s)
[406.246939] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[406.247771] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.000s)
[406.254926] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[406.256105] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.000s)
[406.263404] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[406.264242] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.000s)
[406.271340] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[406.272136] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.000s)
[406.279256] Starting dynamic subtest: drm_test_damage_iter_single_damage
[406.280099] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.000s)
[406.287194] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[406.287998] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.000s)
[406.295203] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[406.296061] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.000s)
[406.303143] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[406.304156] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.000s)
[406.314100] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[406.315214] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.000s)
[406.322609] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[406.323625] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.000s)
[406.330987] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[406.332211] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.000s)
[406.339612] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[406.340739] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.000s)
[406.348206] Starting dynamic subtest: drm_test_damage_iter_damage
[406.349352] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.000s)
[406.356535] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[406.357602] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.000s)
[406.364970] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[406.365977] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.000s)
[406.373530] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[406.374741] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.000s)
[406.382347] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[406.383587] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.000s)
[406.384921] Subtest drm_damage_helper: SUCCESS (0.210s)
[406.404543] [103/143] (581s left) perf (i915-ref-count)
[406.501804] Starting subtest: i915-ref-count
[406.773698] Subtest i915-ref-count: SUCCESS (0.272s)
[406.853663] [104/143] (580s left) kms_setmode (basic-clone-single-crtc)
[406.917353] Starting subtest: basic-clone-single-crtc
[406.919857] Subtest basic-clone-single-crtc: SKIP (0.000s)
[407.000079] [105/143] (580s left) gem_mmap_offset (bad-flags)
[407.065087] Starting subtest: bad-flags
[407.065924] Subtest bad-flags: SUCCESS (0.000s)
[407.154148] [106/143] (580s left) kms_ccs (pipe-a-crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[409.148434] Starting subtest: pipe-A-crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[409.150275] Subtest pipe-A-crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[409.310086] [107/143] (578s left) gem_exec_fair (basic-pace)
[409.377368] Subtest basic-pace: SKIP (0.000s)
[409.419860] [108/143] (578s left) gem_pxp (hw-rejects-pxp-buffer)
[412.016958] Starting subtest: hw-rejects-pxp-buffer
[412.018265] Subtest hw-rejects-pxp-buffer: SUCCESS (0.000s)
[412.111070] [109/143] (575s left) perf_pmu (enable-race)
[412.163375] Starting subtest: enable-race
[412.164341] Starting dynamic subtest: rcs0
[424.924901] Dynamic subtest rcs0: SUCCESS (12.761s)
[424.933229] Starting dynamic subtest: bcs0
[437.671791] Dynamic subtest bcs0: SUCCESS (12.746s)
[437.680123] Starting dynamic subtest: vcs0
[450.417661] Dynamic subtest vcs0: SUCCESS (12.745s)
[450.425837] Starting dynamic subtest: vcs1
[463.168231] Dynamic subtest vcs1: SUCCESS (12.748s)
[463.176149] Starting dynamic subtest: vecs0
[475.911713] Dynamic subtest vecs0: SUCCESS (12.744s)
[475.920572] Starting dynamic subtest: vecs1
[488.656810] Dynamic subtest vecs1: SUCCESS (12.744s)
[488.665089] Starting dynamic subtest: ccs0
[501.403413] Dynamic subtest ccs0: SUCCESS (12.746s)
[501.411488] Starting dynamic subtest: ccs1
[514.149444] Dynamic subtest ccs1: SUCCESS (12.745s)
[514.157183] Starting dynamic subtest: ccs2
[526.895455] Dynamic subtest ccs2: SUCCESS (12.745s)
[526.903625] Starting dynamic subtest: ccs3
[539.642538] Dynamic subtest ccs3: SUCCESS (12.746s)
[539.643548] Subtest enable-race: SUCCESS (127.479s)
[539.757545] [110/143] (447s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[541.714368] Starting subtest: psr-2p-primscrn-spr-indfb-move
[541.716254] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[541.783306] [111/143] (445s left) gem_eio (wait-wedge-1us)
[542.150179] Starting subtest: wait-wedge-1us
[543.425801] Subtest wait-wedge-1us: SUCCESS (1.277s)
[545.383914] [112/143] (442s left) kms_ccs (pipe-b-random-ccs-data-4-tiled-mtl-mc-ccs)
[547.496744] Starting subtest: pipe-B-random-ccs-data-4-tiled-mtl-mc-ccs
[547.499439] Subtest pipe-B-random-ccs-data-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[547.634694] [113/143] (440s left) kms_ccs (pipe-c-bad-pixel-format-4-tiled-mtl-mc-ccs)
[549.677587] Starting subtest: pipe-C-bad-pixel-format-4-tiled-mtl-mc-ccs
[549.679475] Subtest pipe-C-bad-pixel-format-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[549.804957] [114/143] (437s left) kms_atomic_transition (modeset-transition)
[551.760237] Starting subtest: modeset-transition
[551.761188] Starting dynamic subtest: 1x-outputs
[554.292223] Dynamic subtest 1x-outputs: SUCCESS (2.532s)
[554.336203] Subtest modeset-transition: SUCCESS (2.575s)
[554.457995] [115/143] (433s left) gem_create (create-ext-cpu-access-big)