[39.889865] Initializing watchdogs
[39.889912]   /dev/watchdog0
[39.896296] [001/142] (960s left) kms_pipe_crc_basic (nonblocking-crc)
[39.989935] Starting subtest: nonblocking-crc
[39.992413] Starting dynamic subtest: pipe-A-eDP-1
[40.789508] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.799s)
[40.798644] Starting dynamic subtest: pipe-B-eDP-1
[42.370518] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.579s)
[42.380425] Starting dynamic subtest: pipe-C-eDP-1
[43.800806] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.427s)
[43.810041] Starting dynamic subtest: pipe-D-eDP-1
[45.268315] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.465s)
[45.270678] Subtest nonblocking-crc: SUCCESS (5.278s)
[46.206414] [002/142] (954s left) api_intel_bb (bb-with-allocator)
[46.250982] Starting subtest: bb-with-allocator
[46.255396] Subtest bb-with-allocator: SUCCESS (0.005s)
[46.348121] [003/142] (954s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[46.415235] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[46.419606] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[46.491027] [004/142] (953s left) syncobj_timeline (wait-any-snapshot)
[46.534983] Starting subtest: wait-any-snapshot
[46.618079] Subtest wait-any-snapshot: SUCCESS (0.082s)
[46.680597] [005/142] (953s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[46.761518] Starting subtest: invalidate-primary-flip-overlay
[57.304233] Subtest invalidate-primary-flip-overlay: SUCCESS (10.544s)
[57.417549] [006/142] (943s left) vc4/vc4_mmap (mmap-bo)
[57.493357] Subtest mmap-bo: SKIP (0.000s)
[57.538087] [007/142] (942s left) kms_ccs (pipe-a-bad-rotation-90-y_tiled_gen12_rc_ccs)
[57.881071] Starting subtest: pipe-A-bad-rotation-90-y_tiled_gen12_rc_ccs
[57.885636] Subtest pipe-A-bad-rotation-90-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[58.799472] [008/142] (941s left) kms_busy (extended-modeset-hang-newfb)
[58.892126] Starting subtest: extended-modeset-hang-newfb
[58.894380] Starting dynamic subtest: pipe-A
[81.427192] Dynamic subtest pipe-A: SUCCESS (22.534s)
[81.441219] Starting dynamic subtest: pipe-D
[104.407280] Dynamic subtest pipe-D: SUCCESS (22.976s)
[104.409793] Subtest extended-modeset-hang-newfb: SUCCESS (45.518s)
[105.328679] [009/142] (895s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[105.389984] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[105.409322] [010/142] (895s left) kms_flip (flip-vs-fences-interruptible)
[105.459140] Starting subtest: flip-vs-fences-interruptible
[105.463567] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[105.538779] [011/142] (895s left) kms_vblank (invalid)
[105.613826] Starting subtest: invalid
[106.039140] Subtest invalid: SUCCESS (0.423s)
[106.940659] [012/142] (893s left) gem_fence_thrash (bo-write-verify-threaded-y)
[106.997328] Starting subtest: bo-write-verify-threaded-y
[107.004522] Subtest bo-write-verify-threaded-y: SKIP (0.002s)
[107.033614] [013/142] (893s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[107.097656] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[109.677492] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (2.586s)
[109.805318] [014/142] (890s left) kms_properties (crtc-properties-atomic)
[109.900235] Starting subtest: crtc-properties-atomic
[113.778522] Subtest crtc-properties-atomic: SUCCESS (3.878s)
[114.685939] [015/142] (886s left) kms_universal_plane (universal-plane-pipe-b-functional)
[114.755461] Starting subtest: universal-plane-pipe-B-functional
[120.153614] Subtest universal-plane-pipe-B-functional: SUCCESS (5.400s)
[121.083893] [016/142] (879s left) gem_close (many-handles-one-vma)
[121.144943] Starting subtest: many-handles-one-vma
[121.179523] Subtest many-handles-one-vma: SUCCESS (0.035s)
[121.276967] [017/142] (879s left) debugfs_test (read_all_entries_display_on)
[121.355394] Starting subtest: read_all_entries_display_on
[121.603673] Subtest read_all_entries_display_on: SUCCESS (0.250s)
[121.715886] [018/142] (879s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[121.788032] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[121.791774] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[121.854449] [019/142] (878s left) kms_cursor_edge_walk (128x128-right-edge)
[121.918963] Starting subtest: 128x128-right-edge
[121.921399] Starting dynamic subtest: pipe-A-eDP-1
[125.494933] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.579s)
[125.504459] Starting dynamic subtest: pipe-D-eDP-1
[128.724906] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.229s)
[128.727334] Subtest 128x128-right-edge: SUCCESS (6.812s)
[129.650341] [020/142] (871s left) kms_prime (basic-modeset-hybrid)
[130.174257] Subtest basic-modeset-hybrid: SKIP (0.000s)
[130.255398] [021/142] (870s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[130.336977] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[130.341358] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[130.427641] [022/142] (870s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[130.498223] Starting subtest: y-tiled-64bpp-rotate-180
[130.502129] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[130.588361] [023/142] (870s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[130.670406] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[130.674295] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[130.750297] [024/142] (870s left) syncobj_timeline (host-signal-points)
[130.804198] Starting subtest: host-signal-points
[130.806512] Subtest host-signal-points: SUCCESS (0.003s)
[130.863375] [025/142] (870s left) fbdev (unaligned-write)
[130.917986] Starting subtest: unaligned-write
[131.019063] Subtest unaligned-write: SUCCESS (0.100s)
[131.071089] [026/142] (869s left) gem_userptr_blits (map-fixed-invalidate)
[131.121174] Starting subtest: map-fixed-invalidate
[131.125083] Subtest map-fixed-invalidate: SKIP (0.000s)
[131.216880] [027/142] (869s left) gem_softpin (noreloc)
[131.265344] Starting subtest: noreloc
[136.646251] Subtest noreloc: SUCCESS (5.380s)
[136.738896] [028/142] (864s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[136.829472] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[137.561236] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.736s)
[137.707386] [029/142] (863s left) gem_exec_params (rs-invalid)
[137.763762] Starting subtest: rs-invalid
[137.766114] Subtest rs-invalid: SUCCESS (0.005s)
[137.857238] [030/142] (863s left) gem_exec_basic (basic)
[137.912461] Starting subtest: basic
[137.914890] Starting dynamic subtest: rcs0-smem
[137.917356] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[137.924538] Starting dynamic subtest: bcs0-smem
[137.926827] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[137.933501] Starting dynamic subtest: vcs0-smem
[137.935799] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[137.942147] Starting dynamic subtest: vcs1-smem
[137.944430] Dynamic subtest vcs1-smem: SUCCESS (0.000s)
[137.950720] Starting dynamic subtest: vecs0-smem
[137.953039] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[137.959161] Starting dynamic subtest: ccs0-smem
[137.961418] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[137.963697] Subtest basic: SUCCESS (0.008s)
[139.478662] [031/142] (861s left) gem_exec_schedule (promotion)
[139.559799] Starting subtest: promotion
[139.562586] Starting dynamic subtest: rcs0
[139.601480] Dynamic subtest rcs0: SUCCESS (0.053s)
[139.612558] Starting dynamic subtest: vcs0
[139.654200] Dynamic subtest vcs0: SUCCESS (0.052s)
[139.665267] Starting dynamic subtest: vcs1
[139.708743] Dynamic subtest vcs1: SUCCESS (0.054s)
[139.720473] Starting dynamic subtest: vecs0
[139.763070] Dynamic subtest vecs0: SUCCESS (0.054s)
[139.774989] Starting dynamic subtest: ccs0
[139.822321] Dynamic subtest ccs0: SUCCESS (0.058s)
[139.825482] Subtest promotion: SUCCESS (0.274s)
[141.513187] [032/142] (859s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[141.578784] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[141.583378] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[141.655936] [033/142] (859s left) gem_exec_whisper (basic-contexts-priority-all)
[141.735064] Starting subtest: basic-contexts-priority-all
[172.776602] Subtest basic-contexts-priority-all: SUCCESS (31.038s)
[172.956057] [034/142] (828s left) gem_mmap_gtt (basic-write)
[173.025413] Subtest basic-write: SKIP (0.000s)
[173.047722] [035/142] (828s left) perf (short-reads)
[173.171071] Starting subtest: short-reads
[173.181696] Subtest short-reads: SUCCESS (0.012s)
[173.197279] [036/142] (828s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[173.250922] Starting subtest: 4-tiled-64bpp-rotate-270
[173.274576] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.026s)
[173.359708] [037/142] (827s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[173.452588] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[173.457285] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[173.539434] [038/142] (827s left) kms_ccs (pipe-b-bad-rotation-90-yf_tiled_ccs)
[173.925296] Starting subtest: pipe-B-bad-rotation-90-yf_tiled_ccs
[173.929989] Subtest pipe-B-bad-rotation-90-yf_tiled_ccs: SKIP (0.000s)
[174.776307] [039/142] (826s left) syncobj_timeline (reset-during-wait-for-submit)
[174.835161] Starting subtest: reset-during-wait-for-submit
[174.935725] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[175.002570] [040/142] (826s left) vgem_basic (second-client)
[175.084772] Starting subtest: second-client
[175.106474] Subtest second-client: SUCCESS (0.022s)
[175.155345] [041/142] (826s left) drm_fdinfo (virtual-idle)
[175.201073] Starting subtest: virtual-idle
[178.228205] Subtest virtual-idle: SUCCESS (3.027s)
[178.293923] [042/142] (823s left) kms_flip (2x-flip-vs-rmfb)
[178.358598] Starting subtest: 2x-flip-vs-rmfb
[178.371076] Subtest 2x-flip-vs-rmfb: SKIP (0.014s)
[178.434697] [043/142] (822s left) v3d/v3d_submit_cl (single-in-sync)
[178.527600] Subtest single-in-sync: SKIP (0.000s)
[178.574063] [044/142] (822s left) kms_ccs (pipe-c-random-ccs-data-4_tiled_mtl_rc_ccs)
[178.975042] Starting subtest: pipe-C-random-ccs-data-4_tiled_mtl_rc_ccs
[179.783369] Subtest pipe-C-random-ccs-data-4_tiled_mtl_rc_ccs: SUCCESS (0.805s)
[180.975878] [045/142] (820s left) kms_flip (nonexisting-fb)
[181.046951] Starting subtest: nonexisting-fb
[181.049426] Starting dynamic subtest: A-eDP1
[182.324335] Dynamic subtest A-eDP1: SUCCESS (1.280s)
[182.337224] Starting dynamic subtest: B-eDP1
[183.609137] Dynamic subtest B-eDP1: SUCCESS (1.283s)
[183.622432] Starting dynamic subtest: C-eDP1
[184.863641] Dynamic subtest C-eDP1: SUCCESS (1.253s)
[184.876525] Starting dynamic subtest: D-eDP1
[186.143322] Dynamic subtest D-eDP1: SUCCESS (1.279s)
[186.150735] Subtest nonexisting-fb: SUCCESS (5.108s)
[187.454945] [046/142] (813s left) kms_ccs (pipe-b-random-ccs-data-4_tiled_mtl_rc_ccs)
[187.855452] Starting subtest: pipe-B-random-ccs-data-4_tiled_mtl_rc_ccs
[188.676055] Subtest pipe-B-random-ccs-data-4_tiled_mtl_rc_ccs: SUCCESS (0.820s)
[189.887602] [047/142] (811s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[189.963435] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[195.206508] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (5.250s)
[195.330785] [048/142] (806s left) kms_cursor_crc (cursor-random-32x32)
[195.406066] Starting subtest: cursor-random-32x32
[195.433970] Subtest cursor-random-32x32: SKIP (0.026s)
[195.601850] [049/142] (805s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[195.675772] Starting subtest: fbc-1p-pri-indfb-multidraw
[205.739521] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (10.065s)
[205.854470] [050/142] (795s left) gem_exec_schedule (smoketest-all)
[205.915913] Starting subtest: smoketest-all
[238.274558] Subtest smoketest-all: SUCCESS (32.320s)
[239.514283] [051/142] (762s left) syncobj_wait (single-wait-signaled)
[239.580388] Starting subtest: single-wait-signaled
[239.582248] Subtest single-wait-signaled: SUCCESS (0.000s)
[239.637077] [052/142] (761s left) gem_ctx_create (basic)
[239.678120] Starting subtest: basic
[239.680582] Subtest basic: SUCCESS (0.000s)
[239.855693] [053/142] (761s left) gem_exec_balancer (invalid-bonds)
[239.921704] Starting subtest: invalid-bonds
[239.926467] Subtest invalid-bonds: SKIP (0.000s)
[240.174722] [054/142] (761s left) gem_ctx_isolation (nonpriv)
[240.236170] Starting subtest: nonpriv
[240.238722] Starting dynamic subtest: rcs0
[240.404637] Dynamic subtest rcs0: SUCCESS (0.167s)
[240.410939] Starting dynamic subtest: bcs0
[240.627397] Dynamic subtest bcs0: SUCCESS (0.225s)
[240.633091] Starting dynamic subtest: vcs0
[240.832035] Dynamic subtest vcs0: SUCCESS (0.204s)
[240.845110] Starting dynamic subtest: vcs1
[242.652205] Dynamic subtest vcs1: SUCCESS (1.820s)
[242.665669] Starting dynamic subtest: vecs0
[244.630680] Dynamic subtest vecs0: SUCCESS (1.978s)
[244.643608] Starting dynamic subtest: ccs0
[246.648603] Dynamic subtest ccs0: SUCCESS (2.018s)
[246.651081] Subtest nonpriv: SUCCESS (6.414s)
[246.873870] [055/142] (754s left) kms_ccs (pipe-c-crc-primary-rotation-180-y_tiled_gen12_rc_ccs)
[247.285263] Starting subtest: pipe-C-crc-primary-rotation-180-y_tiled_gen12_rc_ccs
[247.290497] Subtest pipe-C-crc-primary-rotation-180-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[248.179043] [056/142] (753s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[248.251187] Starting subtest: fbc-tiling-linear
[250.948551] Subtest fbc-tiling-linear: SUCCESS (2.704s)
[251.076122] [057/142] (750s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[251.135641] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[256.496839] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (5.365s)
[256.595730] [058/142] (745s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[259.175311] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SKIP (0.000s)
[259.234839] [059/142] (742s left) kms_pm_backlight (fade)
[259.312053] Starting subtest: fade
[259.363047] Starting dynamic subtest: eDP-1
[262.036594] Dynamic subtest eDP-1: SUCCESS (2.676s)
[262.039249] Subtest fade: SUCCESS (2.726s)
[262.961282] [060/142] (738s left) kms_ccs (pipe-a-random-ccs-data-4_tiled_mtl_rc_ccs)
[263.324114] Starting subtest: pipe-A-random-ccs-data-4_tiled_mtl_rc_ccs
[264.148793] Subtest pipe-A-random-ccs-data-4_tiled_mtl_rc_ccs: SUCCESS (0.825s)
[265.332245] [061/142] (736s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[265.417389] Starting subtest: stress-mm-invalidate-close-overlap
[267.597479] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.178s)
[268.212118] [062/142] (733s left) kms_chamelium_hpd (hdmi-hpd-storm)
[268.584273] Subtest hdmi-hpd-storm: SKIP (0.000s)
[269.463861] [063/142] (732s left) i915_pm_rps (basic-api)
[269.519764] Starting subtest: basic-api
[269.524471] Subtest basic-api: SKIP (0.000s)
[269.564291] [064/142] (732s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[269.650472] Starting subtest: yf-tiled-64bpp-rotate-0
[269.655892] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[269.736435] [065/142] (732s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[269.803872] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[269.841493] [066/142] (732s left) v3d/v3d_perfmon (create-perfmon-exceed)
[269.899643] Subtest create-perfmon-exceed: SKIP (0.000s)
[269.949751] [067/142] (732s left) gem_softpin (evict-snoop-interruptible)
[269.996823] Starting subtest: evict-snoop-interruptible
[270.001470] Subtest evict-snoop-interruptible: SKIP (0.000s)
[270.058124] [068/142] (731s left) gem_exec_store (dword)
[270.108051] Starting subtest: dword
[270.110065] Starting dynamic subtest: rcs0
[270.144772] Dynamic subtest rcs0: SUCCESS (0.042s)
[270.156459] Starting dynamic subtest: bcs0
[270.185770] Dynamic subtest bcs0: SUCCESS (0.040s)
[270.198308] Starting dynamic subtest: vcs0
[271.449558] Dynamic subtest vcs0: SUCCESS (1.261s)
[271.462860] Starting dynamic subtest: vcs1
[273.433266] Dynamic subtest vcs1: SUCCESS (1.982s)
[273.447286] Starting dynamic subtest: vecs0
[275.417527] Dynamic subtest vecs0: SUCCESS (1.983s)
[275.430840] Starting dynamic subtest: ccs0
[275.459319] Dynamic subtest ccs0: SUCCESS (0.042s)
[275.462164] Subtest dword: SUCCESS (5.357s)
[275.639694] [069/142] (726s left) gem_ctx_persistence (engines-queued)
[275.696889] Starting subtest: engines-queued
[275.699442] Starting dynamic subtest: rcs0
[275.730430] Dynamic subtest rcs0: SUCCESS (0.036s)
[275.744647] Starting dynamic subtest: bcs0
[275.762377] Dynamic subtest bcs0: SUCCESS (0.031s)
[275.774849] Starting dynamic subtest: vcs0
[277.403629] Dynamic subtest vcs0: SUCCESS (1.638s)
[277.416555] Starting dynamic subtest: vcs1
[279.450727] Dynamic subtest vcs1: SUCCESS (2.045s)
[279.464300] Starting dynamic subtest: vecs0
[281.434865] Dynamic subtest vecs0: SUCCESS (1.983s)
[281.455491] Starting dynamic subtest: ccs0
[281.644930] Dynamic subtest ccs0: SUCCESS (0.210s)
[281.647427] Subtest engines-queued: SUCCESS (5.951s)
[281.746674] [070/142] (720s left) kms_cursor_crc (cursor-offscreen-max-size)
[281.894678] Starting subtest: cursor-offscreen-max-size
[281.901443] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[281.988108] [071/142] (720s left) kms_ccs (pipe-a-crc-primary-basic-y_tiled_ccs)
[282.360382] Starting subtest: pipe-A-crc-primary-basic-y_tiled_ccs
[282.365131] Subtest pipe-A-crc-primary-basic-y_tiled_ccs: SKIP (0.001s)
[283.264239] [072/142] (718s left) kms_plane_cursor (overlay)
[283.338752] Starting subtest: overlay
[283.343533] Starting dynamic subtest: pipe-A-eDP-1-size-64
[286.348044] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (3.009s)
[286.403921] Starting dynamic subtest: pipe-A-eDP-1-size-128
[289.360439] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.963s)
[289.416714] Starting dynamic subtest: pipe-A-eDP-1-size-256
[292.361135] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.952s)
[292.723097] Starting dynamic subtest: pipe-B-eDP-1-size-64
[296.542417] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.832s)
[296.599323] Starting dynamic subtest: pipe-B-eDP-1-size-128
[299.632133] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (3.041s)
[299.689153] Starting dynamic subtest: pipe-B-eDP-1-size-256
[302.655158] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.974s)
[303.016223] Starting dynamic subtest: pipe-C-eDP-1-size-64
[306.364875] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.358s)
[306.398495] Starting dynamic subtest: pipe-C-eDP-1-size-128
[308.942929] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.548s)
[308.980463] Starting dynamic subtest: pipe-C-eDP-1-size-256
[311.498304] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.526s)
[311.828906] Starting dynamic subtest: pipe-D-eDP-1-size-64
[315.090567] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.273s)
[315.128217] Starting dynamic subtest: pipe-D-eDP-1-size-128
[317.680678] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.560s)
[317.716894] Starting dynamic subtest: pipe-D-eDP-1-size-256
[320.246689] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.537s)
[320.566174] Subtest overlay: SUCCESS (37.226s)
[321.471955] [073/142] (680s left) syncobj_timeline (multi-wait-all-available-signaled)
[321.529742] Starting subtest: multi-wait-all-available-signaled
[321.532151] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s)
[321.592981] [074/142] (680s left) kms_lease (atomic_implicit_crtc)
[321.662628] Starting subtest: atomic_implicit_crtc
[321.665047] Starting dynamic subtest: pipe-A-eDP-1
[321.667474] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[321.680265] Starting dynamic subtest: pipe-B-eDP-1
[321.682629] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[321.697057] Starting dynamic subtest: pipe-C-eDP-1
[321.699425] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.008s)
[321.711957] Starting dynamic subtest: pipe-D-eDP-1
[321.714392] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.006s)
[321.716752] Subtest atomic_implicit_crtc: SUCCESS (0.034s)
[321.756693] [075/142] (680s left) v3d/v3d_wait_bo (bad-pad)
[321.832302] Subtest bad-pad: SKIP (0.000s)
[321.883051] [076/142] (680s left) perf_pmu (event-wait)
[321.927966] Starting subtest: event-wait
[321.930466] Starting dynamic subtest: rcs0
[321.935236] Dynamic subtest rcs0: SKIP (0.000s)
[321.939556] Subtest event-wait: SKIP (0.001s)
[321.991159] [077/142] (680s left) gem_ccs (block-multicopy-inplace)
[322.030485] Starting subtest: block-multicopy-inplace
[322.034584] Subtest block-multicopy-inplace: SKIP (0.000s)
[322.083799] [078/142] (680s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[322.152670] Starting subtest: addfb25-y-tiled-legacy
[322.155144] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[322.242709] [079/142] (680s left) kms_concurrent (pipe-a)
[322.313882] Starting subtest: pipe-A
[322.316557] Starting dynamic subtest: eDP-1
[322.778281] Dynamic subtest eDP-1: SUCCESS (0.464s)
[322.780893] Subtest pipe-A: SUCCESS (0.465s)
[323.710984] [080/142] (678s left) gem_exec_await (wide-all)
[323.908365] Starting subtest: wide-all
[347.546115] Subtest wide-all: SUCCESS (23.637s)
[347.737661] [081/142] (654s left) kms_vblank (pipe-d-ts-continuation-dpms-rpm)
[347.860637] Starting subtest: pipe-D-ts-continuation-dpms-rpm
[351.541085] Subtest pipe-D-ts-continuation-dpms-rpm: SUCCESS (3.680s)
[352.450568] [082/142] (649s left) gem_ctx_shared (single-timeline)
[352.525571] Starting subtest: single-timeline
[352.544059] Subtest single-timeline: SUCCESS (0.004s)
[352.742308] [083/142] (649s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[352.820622] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[352.825263] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[352.910610] [084/142] (649s left) perf_pmu (busy-accuracy-2)
[352.968400] Starting subtest: busy-accuracy-2
[352.970239] Starting dynamic subtest: rcs0
[356.020505] Dynamic subtest rcs0: SUCCESS (3.050s)
[356.035811] Starting dynamic subtest: bcs0
[359.090175] Dynamic subtest bcs0: SUCCESS (3.067s)
[359.104401] Starting dynamic subtest: vcs0
[362.145441] Dynamic subtest vcs0: SUCCESS (3.055s)
[362.159413] Starting dynamic subtest: vcs1
[365.199801] Dynamic subtest vcs1: SUCCESS (3.054s)
[365.215235] Starting dynamic subtest: vecs0
[368.261187] Dynamic subtest vecs0: SUCCESS (3.059s)
[368.274213] Starting dynamic subtest: ccs0
[371.332778] Dynamic subtest ccs0: SUCCESS (3.071s)
[371.335274] Subtest busy-accuracy-2: SUCCESS (18.364s)
[371.439868] [085/142] (630s left) gem_exec_fair (basic-sync)
[371.525047] Subtest basic-sync: SKIP (0.000s)
[371.559139] [086/142] (630s left) kms_rotation_crc (primary-rotation-180)
[371.645765] Starting subtest: primary-rotation-180
[379.140984] Subtest primary-rotation-180: SUCCESS (7.499s)
[380.415708] [087/142] (622s left) kms_plane_scaling (plane-downscale-with-modifiers-factor-0-5)
[380.479605] Starting subtest: plane-downscale-with-modifiers-factor-0-5
[380.481962] Starting dynamic subtest: pipe-A-eDP-1
[380.505814] Dynamic subtest pipe-A-eDP-1: SKIP (0.020s)
[380.516723] Starting dynamic subtest: pipe-B-eDP-1
[380.532921] Dynamic subtest pipe-B-eDP-1: SKIP (0.028s)
[380.540059] Starting dynamic subtest: pipe-C-eDP-1
[380.566836] Dynamic subtest pipe-C-eDP-1: SKIP (0.034s)
[380.574255] Starting dynamic subtest: pipe-D-eDP-1
[380.605077] Dynamic subtest pipe-D-eDP-1: SKIP (0.038s)
[380.608897] Subtest plane-downscale-with-modifiers-factor-0-5: SKIP (0.123s)
[380.705453] [088/142] (621s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[380.761187] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[380.763604] Starting dynamic subtest: pipe-A-default-mode
[381.967520] Dynamic subtest pipe-A-default-mode: SKIP (1.204s)
[381.972078] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.205s)
[382.101204] [089/142] (620s left) gem_mmap_wc (write)
[382.160193] Subtest write: SKIP (0.000s)
[382.191887] [090/142] (620s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[382.259533] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[382.264504] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[382.351719] [091/142] (620s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[382.441149] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[382.444940] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[382.530153] [092/142] (620s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[382.615924] Starting subtest: fbc-rgb565-draw-render
[385.654578] Subtest fbc-rgb565-draw-render: SUCCESS (3.040s)
[385.793270] [093/142] (616s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[385.843918] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[385.847925] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[386.021433] [094/142] (616s left) i915_pm_rpm (gem-execbuf-stress)
[387.633950] Starting subtest: gem-execbuf-stress
[387.636577] Starting dynamic subtest: smem0
[430.201054] Dynamic subtest smem0: SUCCESS (42.567s)
[430.215612] Starting dynamic subtest: extra-wait-smem0
[514.187841] Dynamic subtest extra-wait-smem0: SUCCESS (83.984s)
[514.190787] Subtest gem-execbuf-stress: SUCCESS (126.554s)
[514.523830] [095/142] (488s left) kms_psr2_sf (primary-plane-update-sf-dmg-area)
[519.689270] Starting subtest: primary-plane-update-sf-dmg-area
[519.692175] Starting dynamic subtest: pipe-A-eDP-1
[526.533734] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.840s)
[526.545076] Starting dynamic subtest: pipe-B-eDP-1
[533.340232] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.803s)
[533.342598] Subtest primary-plane-update-sf-dmg-area: SUCCESS (13.650s)
[534.259720] [096/142] (468s left) gem_exec_fence (syncobj-timeline-chain-engines)
[534.817778] Starting subtest: syncobj-timeline-chain-engines
[534.858523] Subtest syncobj-timeline-chain-engines: SUCCESS (0.042s)
[536.507758] [097/142] (466s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[536.567683] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[536.571585] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[536.652163] [098/142] (466s left) vc4/vc4_tiling (get-bad-flags)
[536.749400] Subtest get-bad-flags: SKIP (0.000s)
[536.797241] [099/142] (466s left) gem_exec_reloc (basic-range-active)
[536.867291] Subtest basic-range-active: SKIP (0.000s)
[536.924271] [100/142] (465s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[537.000081] Starting subtest: basic-busy-flip-before-cursor-atomic
[537.004685] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[537.083710] [101/142] (465s left) kms_color (invalid-gamma-lut-sizes)
[537.144605] Starting subtest: invalid-gamma-lut-sizes
[537.147093] Starting dynamic subtest: pipe-A
[537.435055] Dynamic subtest pipe-A: SUCCESS (0.287s)
[537.449820] Starting dynamic subtest: pipe-B
[537.452367] Dynamic subtest pipe-B: SUCCESS (0.001s)
[537.459709] Starting dynamic subtest: pipe-C
[537.461964] Dynamic subtest pipe-C: SUCCESS (0.001s)
[537.467862] Starting dynamic subtest: pipe-D
[537.470117] Dynamic subtest pipe-D: SUCCESS (0.001s)
[537.472314] Subtest invalid-gamma-lut-sizes: SUCCESS (0.294s)
[538.368136] [102/142] (464s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs)
[538.758879] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs
[538.764223] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs: SKIP (0.001s)
[539.635378] [103/142] (463s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[539.736519] Starting subtest: short-busy-flip-before-cursor-toggle
[539.741121] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[539.862596] [104/142] (463s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[539.931529] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[539.936271] Starting dynamic subtest: pipe-A-default-mode
[540.250406] Dynamic subtest pipe-A-default-mode: SKIP (0.312s)
[540.254734] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.316s)
[541.112061] [105/142] (461s left) kms_universal_plane (disable-primary-vs-flip-pipe-d)
[541.189477] Starting subtest: disable-primary-vs-flip-pipe-D
[543.989887] Subtest disable-primary-vs-flip-pipe-D: SUCCESS (2.802s)
[544.884372] [106/142] (458s left) kms_chamelium_frames (dp-crc-multiple)
[545.254845] Subtest dp-crc-multiple: SKIP (0.000s)
[546.142187] [107/142] (456s left) gem_mmap_wc (read-write)
[546.201289] Subtest read-write: SKIP (0.000s)
[546.223107] [108/142] (456s left) kms_psr (primary_render)
[546.283172] Starting subtest: primary_render
[548.067283] Subtest primary_render: SUCCESS (1.784s)
[548.994153] [109/142] (454s left) drm_read (empty-nonblock)
[549.098834] Starting subtest: empty-nonblock
[549.101238] Subtest empty-nonblock: SUCCESS (0.000s)
[549.206682] [110/142] (453s left) syncobj_timeline (invalid-multi-wait-available-unsubmitted-submitted-signaled
[549.272051] Starting subtest: invalid-multi-wait-available-unsubmitted-submitted-signaled
[549.274650] Subtest invalid-multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[549.331716] [111/142] (453s left) prime_vgem (busy)
[549.395712] Starting subtest: busy
[549.398113] Starting dynamic subtest: rcs0
[549.431089] Dynamic subtest rcs0: SUCCESS (0.038s)
[549.444141] Starting dynamic subtest: bcs0
[549.492761] Dynamic subtest bcs0: SUCCESS (0.061s)
[549.504304] Starting dynamic subtest: vcs0
[549.543080] Dynamic subtest vcs0: SUCCESS (0.049s)
[549.560273] Starting dynamic subtest: vcs1
[549.567062] Dynamic subtest vcs1: SUCCESS (0.023s)
[549.575086] Starting dynamic subtest: vecs0
[549.604480] Dynamic subtest vecs0: SUCCESS (0.037s)
[549.612956] Starting dynamic subtest: ccs0
[549.627511] Dynamic subtest ccs0: SUCCESS (0.022s)
[549.629934] Subtest busy: SUCCESS (0.236s)
[549.722201] [112/142] (453s left) gem_render_copy_redux (flink-interruptible)
[549.785685] Starting subtest: flink-interruptible
[550.480548] Subtest flink-interruptible: SUCCESS (0.695s)
[550.551360] [113/142] (452s left) i915_module_load (reload)
[550.610946] Starting subtest: reload
[553.217592] Subtest reload: SUCCESS (2.607s)
[553.241400] [114/142] (449s left) kms_ccs (pipe-d-bad-pixel-format-4_tiled_mtl_rc_ccs_cc)
[554.822988] Starting subtest: pipe-D-bad-pixel-format-4_tiled_mtl_rc_ccs_cc
[554.825783] Subtest pipe-D-bad-pixel-format-4_tiled_mtl_rc_ccs_cc: SUCCESS (0.000s)
[555.663218] [115/142] (447s left) kms_pipe_crc_basic (bad-source)
[555.728168] Starting subtest: bad-source
[555.730401] Subtest bad-source: SUCCESS (0.000s)
[555.780656] [116/142] (447s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[555.859446] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[555.883752] [117/142] (447s left) syncobj_basic (bad-destroy-pad)
[555.941554] Starting subtest: bad-destroy-pad
[555.943480] Subtest bad-destroy-pad: SUCCESS (0.000s)
[555.997628] [118/142] (447s left) gem_exec_params (rel-constants-invalid-ring)
[556.057269] Starting subtest: rel-constants-invalid-ring
[556.059706] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[556.143645] [119/142] (447s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[556.201873] Starting subtest: psr-rgb101010-draw-mmap-wc
[561.166532] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (4.969s)
[561.272348] [120/142] (442s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[561.334527] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[561.348653] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.014s)
[561.417841] [121/142] (441s left) gem_ringfill (engines-basic)
[567.464718] Starting subtest: engines-basic
[567.467307] Starting dynamic subtest: rcs0
[567.509509] Dynamic subtest rcs0: SUCCESS (0.045s)
[567.523385] Starting dynamic subtest: bcs0
[567.552357] Dynamic subtest bcs0: SUCCESS (0.042s)
[567.565694] Starting dynamic subtest: vcs0
[567.572180] Dynamic subtest vcs0: SUCCESS (0.016s)
[567.584201] Starting dynamic subtest: vcs1
[567.589403] Dynamic subtest vcs1: SUCCESS (0.017s)
[567.600289] Starting dynamic subtest: vecs0
[567.605176] Dynamic subtest vecs0: SUCCESS (0.015s)
[567.614466] Starting dynamic subtest: ccs0
[567.648222] Dynamic subtest ccs0: SUCCESS (0.043s)
[567.650768] Subtest engines-basic: SUCCESS (0.186s)
[567.720059] [122/142] (435s left) gem_userptr_blits (stress-purge)
[567.791381] Starting subtest: stress-purge
[573.166117] Subtest stress-purge: SUCCESS (5.375s)
[573.276823] [123/142] (430s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[573.507812] Starting subtest: plane-primary-overlay-mutable-zpos
[573.513820] Subtest plane-primary-overlay-mutable-zpos: SKIP (0.000s)
[574.707719] [124/142] (428s left) kms_vblank (pipe-c-query-forked-busy)
[574.806045] Starting subtest: pipe-C-query-forked-busy
[577.809806] Subtest pipe-C-query-forked-busy: SUCCESS (3.009s)
[578.753066] [125/142] (424s left) kms_ccs (pipe-d-crc-primary-rotation-180-yf_tiled_ccs)
[579.179507] Starting subtest: pipe-D-crc-primary-rotation-180-yf_tiled_ccs
[579.185180] Subtest pipe-D-crc-primary-rotation-180-yf_tiled_ccs: SKIP (0.000s)
[580.033311] [126/142] (423s left) vgem_basic (setversion)
[580.095696] Starting subtest: setversion
[580.100174] Subtest setversion: SUCCESS (0.000s)
[580.143883] [127/142] (423s left) gen9_exec_parse (basic-rejected)
[580.203289] Subtest basic-rejected: SKIP (0.000s)
[580.223497] [128/142] (423s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[580.307701] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[580.311879] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[580.392510] [129/142] (423s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[580.494155] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[580.498615] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[580.578770] [130/142] (422s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[580.692640] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[581.743478] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.052s)
[581.879135] [131/142] (421s left) gem_eio (in-flight-internal-10ms)
[582.071289] Starting subtest: in-flight-internal-10ms
[583.533482] Subtest in-flight-internal-10ms: SUCCESS (1.460s)
[585.500610] [132/142] (418s left) kms_ccs (pipe-d-random-ccs-data-4_tiled_dg2_rc_ccs)
[585.914180] Starting subtest: pipe-D-random-ccs-data-4_tiled_dg2_rc_ccs
[585.922045] Subtest pipe-D-random-ccs-data-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[586.739873] [133/142] (416s left) gem_mmap_gtt (pf-nonblock)
[586.787835] Subtest pf-nonblock: SKIP (0.000s)
[586.807091] [134/142] (416s left) kms_ccs (pipe-c-ccs-on-another-bo-4_tiled_mtl_rc_ccs)
[587.209176] Starting subtest: pipe-C-ccs-on-another-bo-4_tiled_mtl_rc_ccs
[587.211925] Subtest pipe-C-ccs-on-another-bo-4_tiled_mtl_rc_ccs: SUCCESS (0.000s)
[588.048605] [135/142] (415s left) kms_ccs (pipe-c-bad-aux-stride-y_tiled_gen12_rc_ccs)
[588.450390] Starting subtest: pipe-C-bad-aux-stride-y_tiled_gen12_rc_ccs
[588.456285] Subtest pipe-C-bad-aux-stride-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[589.308478] [136/142] (414s left) gem_mmap_gtt (big-copy)
[589.350796] Subtest big-copy: SKIP (0.000s)
[589.368653] [137/142] (414s left) kms_chamelium_color (ctm-0-75)
[589.450427] Subtest ctm-0-75: SKIP (0.000s)
[589.469372] [138/142] (414s left) gem_basic (create-close)
[589.521128] Starting subtest: create-close
[589.525818] Subtest create-close: SUCCESS (0.000s)
[589.597789] [139/142] (414s left) gem_mmap_wc (write-wc-read-gtt)
[589.638045] Subtest write-wc-read-gtt: SKIP (0.000s)
[589.665819] [140/142] (414s left) gem_exec_params (secure-non-master)
[589.717257] Starting subtest: secure-non-master
[589.722042] Subtest secure-non-master: SKIP (0.000s)
[589.809268] [141/142] (414s left) i915_hangman (gt-engine-error)
[589.874489] Starting subtest: gt-engine-error
[589.876932] Starting dynamic subtest: rcs0
[591.449908] Dynamic subtest rcs0: SUCCESS (1.575s)
[591.467639] Starting dynamic subtest: bcs0
[593.434131] Dynamic subtest bcs0: SUCCESS (1.982s)
[593.448701] Starting dynamic subtest: vcs0
[603.595832] Dynamic subtest vcs0: FAIL (10.082s)
[603.610287] Starting dynamic subtest: vcs1
[605.466494] Dynamic subtest vcs1: SUCCESS (1.948s)
[605.481768] Starting dynamic subtest: vecs0
[607.449217] Dynamic subtest vecs0: SUCCESS (1.981s)
[607.468280] Starting dynamic subtest: ccs0
[609.433647] Dynamic subtest ccs0: SUCCESS (1.982s)
[609.436694] Subtest gt-engine-error: FAIL (19.560s)
[609.515063] [142/142] (394s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_dg2_rc_ccs)
[609.916956] Starting subtest: pipe-B-crc-primary-basic-4_tiled_dg2_rc_ccs
[609.922176] Subtest pipe-B-crc-primary-basic-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[610.813321] Closing watchdogs
Done.