[60.575835] Initializing watchdogs
[60.575901]   /dev/watchdog0
[60.583709] [001/131] (960s left) prime_mmap (test_correct_cpu_write)
[60.655505] Starting subtest: test_correct_cpu_write
[60.656430] Starting dynamic subtest: test_correct_cpu_write-smem
[60.657326] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[60.663572] Starting dynamic subtest: test_correct_cpu_write-lmem0
[60.664765] Dynamic subtest test_correct_cpu_write-lmem0: SUCCESS (0.000s)
[60.665839] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[60.791893] [002/131] (960s left) kms_psr (fbc-pr-basic)
[61.055706] Subtest fbc-pr-basic: SKIP (0.000s)
[61.077405] [003/131] (960s left) kms_rotation_crc (sprite-rotation-90)
[61.296556] Starting subtest: sprite-rotation-90
[61.299283] Subtest sprite-rotation-90: SKIP (0.001s)
[61.348711] [004/131] (959s left) kms_getfb (getfb-repeated-different-handles)
[61.418990] Starting subtest: getfb-repeated-different-handles
[61.419930] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[61.515574] [005/131] (959s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[61.781142] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[61.782918] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[61.879701] [006/131] (959s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[62.126258] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[62.127177] Starting dynamic subtest: pipe-A-DP-4
[62.135708] Dynamic subtest pipe-A-DP-4: SKIP (0.000s)
[62.142218] Starting dynamic subtest: pipe-B-DP-4
[62.150869] Dynamic subtest pipe-B-DP-4: SKIP (0.000s)
[62.157377] Starting dynamic subtest: pipe-C-DP-4
[62.165757] Dynamic subtest pipe-C-DP-4: SKIP (0.000s)
[62.171769] Starting dynamic subtest: pipe-D-DP-4
[62.180179] Dynamic subtest pipe-D-DP-4: SKIP (0.000s)
[62.181917] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.003s)
[62.534834] [007/131] (958s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[62.798250] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[62.799996] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[62.881350] [008/131] (958s left) gem_exec_alignment (many)
[62.985998] Starting subtest: many
[85.399644] Subtest many: SUCCESS (22.404s)
[85.933983] [009/131] (935s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[86.225402] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[86.226292] Starting dynamic subtest: pipe-A-DP-4
[88.618894] Dynamic subtest pipe-A-DP-4: SUCCESS (2.393s)
[88.626162] Starting dynamic subtest: pipe-B-DP-4
[88.633931] Dynamic subtest pipe-B-DP-4: SUCCESS (0.004s)
[88.641111] Starting dynamic subtest: pipe-C-DP-4
[88.649261] Dynamic subtest pipe-C-DP-4: SUCCESS (0.005s)
[88.656556] Starting dynamic subtest: pipe-D-DP-4
[88.664488] Dynamic subtest pipe-D-DP-4: SUCCESS (0.008s)
[88.665381] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SUCCESS (2.413s)
[89.088961] [010/131] (932s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[89.351195] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[90.613130] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.261s)
[90.772725] [011/131] (930s left) kms_atomic (plane-overlay-legacy)
[90.992760] Starting subtest: plane-overlay-legacy
[90.993641] Starting dynamic subtest: pipe-A-DP-4
[91.686205] Dynamic subtest pipe-A-DP-4: SUCCESS (0.692s)
[91.687129] Subtest plane-overlay-legacy: SUCCESS (0.693s)
[91.924679] [012/131] (929s left) kms_plane (plane-panning-bottom-right-suspend)
[92.189099] Starting subtest: plane-panning-bottom-right-suspend
[92.189980] Starting dynamic subtest: pipe-A
[111.622247] Dynamic subtest pipe-A: SUCCESS (4.491s)
[111.631378] Starting dynamic subtest: pipe-B
[131.618746] Dynamic subtest pipe-B: SUCCESS (4.010s)
[131.619665] Subtest plane-panning-bottom-right-suspend: SUCCESS (8.502s)
[137.860158] [013/131] (920s left) kms_async_flips (test-time-stamp)
[138.083466] Starting subtest: test-time-stamp
[138.311220] Starting dynamic subtest: pipe-A-DP-4
[138.602717] Dynamic subtest pipe-A-DP-4: SUCCESS (0.290s)
[138.866531] Starting dynamic subtest: pipe-B-DP-4
[139.008877] Dynamic subtest pipe-B-DP-4: SUCCESS (0.149s)
[139.213617] Starting dynamic subtest: pipe-C-DP-4
[139.355596] Dynamic subtest pipe-C-DP-4: SUCCESS (0.148s)
[139.598130] Starting dynamic subtest: pipe-D-DP-4
[139.742634] Dynamic subtest pipe-D-DP-4: SUCCESS (0.151s)
[139.744519] Subtest test-time-stamp: SUCCESS (1.658s)
[140.225827] [014/131] (918s left) gem_mmap_gtt (zero-extend)
[140.309590] Subtest zero-extend: SKIP (0.000s)
[140.357389] [015/131] (918s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[140.598723] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[143.213150] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (2.614s)
[143.395082] [016/131] (915s left) perf (gen12-group-exclusive-stream-sample-oa)
[143.762525] Starting subtest: gen12-group-exclusive-stream-sample-oa
[143.783430] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.020s)
[143.810813] [017/131] (914s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[144.124302] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[144.126313] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[144.367734] [018/131] (914s left) gem_exec_reloc (basic-wc-gtt)
[144.505857] Subtest basic-wc-gtt: SKIP (0.000s)
[144.539113] [019/131] (914s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[147.183305] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SKIP (0.000s)
[147.271681] [020/131] (911s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[147.385659] Starting subtest: invalid-multi-wait-unsubmitted
[147.386609] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[147.484750] [021/131] (911s left) prime_vgem (basic-gtt)
[147.764746] Starting subtest: basic-gtt
[147.766963] Subtest basic-gtt: SKIP (0.000s)
[147.911151] [022/131] (910s left) kms_pipe_crc_basic (nonblocking-crc)
[148.187367] Starting subtest: nonblocking-crc
[148.188501] Starting dynamic subtest: pipe-A-DP-4
[148.885954] Dynamic subtest pipe-A-DP-4: SUCCESS (0.698s)
[148.901847] Starting dynamic subtest: pipe-B-DP-4
[149.499617] Dynamic subtest pipe-B-DP-4: SUCCESS (0.612s)
[149.515780] Starting dynamic subtest: pipe-C-DP-4
[150.128454] Dynamic subtest pipe-C-DP-4: SUCCESS (0.627s)
[150.141461] Starting dynamic subtest: pipe-D-DP-4
[150.744353] Dynamic subtest pipe-D-DP-4: SUCCESS (0.614s)
[150.745394] Subtest nonblocking-crc: SUCCESS (2.557s)
[150.986621] [023/131] (907s left) gem_render_copy (y-tiled-to-vebox-linear)
[151.142456] Starting subtest: y-tiled-to-vebox-linear
[151.144664] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[151.370667] [024/131] (907s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[151.658863] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[151.660661] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[151.747134] [025/131] (907s left) gem_render_copy (linear-to-vebox-yf-tiled)
[151.903245] Starting subtest: linear-to-vebox-yf-tiled
[151.905194] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[152.089218] [026/131] (906s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[152.380888] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[152.382876] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[152.476347] [027/131] (906s left) kms_prop_blob (blob-prop-core)
[152.617751] Starting subtest: blob-prop-core
[152.618997] Subtest blob-prop-core: SUCCESS (0.000s)
[152.733911] [028/131] (906s left) i915_hangman (engine-error-state-capture)
[152.875922] Starting subtest: engine-error-state-capture
[152.876858] Starting dynamic subtest: rcs0
[155.569010] Dynamic subtest rcs0: SUCCESS (2.614s)
[155.580155] Starting dynamic subtest: bcs0
[159.478863] Dynamic subtest bcs0: SUCCESS (3.833s)
[159.488831] Starting dynamic subtest: vcs0
[163.545224] Dynamic subtest vcs0: SUCCESS (4.018s)
[163.557163] Starting dynamic subtest: vcs1
[167.471928] Dynamic subtest vcs1: SUCCESS (3.898s)
[167.481210] Starting dynamic subtest: vecs0
[171.546361] Dynamic subtest vecs0: SUCCESS (4.056s)
[171.558544] Starting dynamic subtest: vecs1
[175.477730] Dynamic subtest vecs1: SUCCESS (3.920s)
[175.487974] Starting dynamic subtest: ccs0
[178.546929] Dynamic subtest ccs0: SUCCESS (3.063s)
[178.547922] Subtest engine-error-state-capture: SUCCESS (25.405s)
[178.656824] [029/131] (880s left) kms_cursor_legacy (torture-move)
[178.934812] Starting subtest: torture-move
[178.935802] Starting dynamic subtest: pipe-A
[184.589944] Dynamic subtest pipe-A: SUCCESS (5.647s)
[184.599314] Starting dynamic subtest: pipe-B
[190.058423] Dynamic subtest pipe-B: SUCCESS (5.467s)
[190.067834] Starting dynamic subtest: pipe-C
[195.638839] Dynamic subtest pipe-C: SUCCESS (5.577s)
[195.649534] Starting dynamic subtest: pipe-D
[201.165158] Dynamic subtest pipe-D: SUCCESS (5.526s)
[201.175542] Starting dynamic subtest: all-pipes
[206.613869] Dynamic subtest all-pipes: SUCCESS (5.446s)
[206.614805] Subtest torture-move: SUCCESS (27.665s)
[206.683027] [030/131] (852s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[207.021437] Starting subtest: short-flip-before-cursor-atomic-transitions
[208.072884] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (1.050s)
[208.323510] [031/131] (851s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[208.609610] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[208.611454] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[208.704070] [032/131] (850s left) gem_exec_capture (capture-invisible)
[208.856257] Starting subtest: capture-invisible
[208.857392] Starting dynamic subtest: lmem0
[208.859353] Dynamic subtest lmem0: SKIP (0.000s)
[208.868998] Starting dynamic subtest: smem0
[208.871014] Dynamic subtest smem0: SKIP (0.000s)
[208.872982] Subtest capture-invisible: SKIP (0.001s)
[208.962217] [033/131] (850s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[209.271700] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[212.110119] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (2.838s)
[212.254185] [034/131] (847s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[212.526844] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[212.528806] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[212.619091] [035/131] (846s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[212.912147] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[212.938992] [036/131] (846s left) kms_vblank (ts-continuation-dpms-rpm)
[213.213618] Starting subtest: ts-continuation-dpms-rpm
[213.215899] Starting dynamic subtest: pipe-A-DP-4
[215.005258] Dynamic subtest pipe-A-DP-4: SUCCESS (1.789s)
[215.024617] Starting dynamic subtest: pipe-D-DP-4
[216.007262] Dynamic subtest pipe-D-DP-4: SUCCESS (0.996s)
[216.008552] Subtest ts-continuation-dpms-rpm: SUCCESS (2.792s)
[216.211976] [037/131] (843s left) gem_ctx_param (invalid-get-engines)
[216.354795] Starting subtest: invalid-get-engines
[216.356743] Subtest invalid-get-engines: SUCCESS (0.001s)
[216.494111] [038/131] (843s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[216.802810] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[217.460372] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.658s)
[217.611246] [039/131] (842s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[217.901627] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[221.196691] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (3.294s)
[221.350937] [040/131] (838s left) kms_flip (2x-flip-vs-rmfb)
[221.619308] Starting subtest: 2x-flip-vs-rmfb
[221.632023] Subtest 2x-flip-vs-rmfb: SKIP (0.013s)
[221.698294] [041/131] (838s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[221.976793] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[221.978564] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[222.077571] [042/131] (837s left) kms_flip (plain-flip-ts-check)
[222.385423] Starting subtest: plain-flip-ts-check
[222.390367] Starting dynamic subtest: A-DP4
[230.526477] Dynamic subtest A-DP4: SUCCESS (8.132s)
[230.539585] Starting dynamic subtest: B-DP4
[238.590086] Dynamic subtest B-DP4: SUCCESS (8.058s)
[238.600592] Starting dynamic subtest: C-DP4
[246.631967] Dynamic subtest C-DP4: SUCCESS (8.038s)
[246.641836] Starting dynamic subtest: D-DP4
[254.684014] Dynamic subtest D-DP4: SUCCESS (8.052s)
[254.688754] Subtest plain-flip-ts-check: SUCCESS (32.293s)
[254.999470] [043/131] (804s left) gem_spin_batch (resubmit-new-all)
[255.143264] Starting subtest: resubmit-new-all
[255.144247] Starting dynamic subtest: rcs0
[255.176389] Dynamic subtest rcs0: SUCCESS (0.033s)
[255.186468] Starting dynamic subtest: bcs0
[255.187388] Dynamic subtest bcs0: SUCCESS (0.006s)
[255.197063] Starting dynamic subtest: vcs0
[255.197954] Dynamic subtest vcs0: SUCCESS (0.007s)
[255.207654] Starting dynamic subtest: vcs1
[255.208572] Dynamic subtest vcs1: SUCCESS (0.006s)
[255.218278] Starting dynamic subtest: vecs0
[255.219202] Dynamic subtest vecs0: SUCCESS (0.007s)
[255.228788] Starting dynamic subtest: vecs1
[255.229882] Dynamic subtest vecs1: SUCCESS (0.006s)
[255.239257] Starting dynamic subtest: ccs0
[255.240328] Dynamic subtest ccs0: SUCCESS (0.006s)
[255.241495] Subtest resubmit-new-all: SUCCESS (0.075s)
[255.533361] [044/131] (804s left) kms_selftest (drm_format)
[255.642525] Starting subtest: drm_format
[255.658547] Starting dynamic subtest: drm_test_format_block_width_invalid
[255.776286] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.116s)
[255.787323] Starting dynamic subtest: drm_test_format_block_width_one_plane
[255.862779] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.085s)
[255.904130] Starting dynamic subtest: drm_test_format_block_width_two_plane
[255.950656] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.085s)
[255.989853] Starting dynamic subtest: drm_test_format_block_width_three_plane
[256.063742] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.112s)
[256.105447] Starting dynamic subtest: drm_test_format_block_width_tiled
[256.173780] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.106s)
[256.186479] Starting dynamic subtest: drm_test_format_block_height_invalid
[256.265796] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.092s)
[256.306934] Starting dynamic subtest: drm_test_format_block_height_one_plane
[256.382526] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.115s)
[256.423932] Starting dynamic subtest: drm_test_format_block_height_two_plane
[256.480592] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.095s)
[256.519379] Starting dynamic subtest: drm_test_format_block_height_three_plane
[256.579413] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.096s)
[256.618601] Starting dynamic subtest: drm_test_format_block_height_tiled
[256.675643] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.094s)
[256.716965] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[256.786655] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.109s)
[256.828499] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[256.903736] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.107s)
[256.941953] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[256.994827] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.096s)
[257.007371] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[257.085594] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.082s)
[257.125939] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[257.191330] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.109s)
[257.227774] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[257.303682] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.112s)
[257.344298] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[257.430805] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.125s)
[257.443025] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[257.514613] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.081s)
[257.516476] Subtest drm_format: SUCCESS (1.873s)
[257.708933] [045/131] (802s left) kms_pm_dc (dc6-psr)
[258.996150] Starting subtest: dc6-psr
[258.998057] Subtest dc6-psr: SKIP (0.000s)
[259.068829] [046/131] (800s left) kms_flip (2x-flip-vs-suspend)
[259.356488] Starting subtest: 2x-flip-vs-suspend
[259.369850] Subtest 2x-flip-vs-suspend: SKIP (0.014s)
[259.433862] [047/131] (800s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[259.720843] Starting subtest: psr-rgb565-draw-mmap-wc
[259.722684] Subtest psr-rgb565-draw-mmap-wc: SKIP (0.000s)
[259.812031] [048/131] (800s left) syncobj_wait (invalid-wait-bad-flags)
[259.963904] Starting subtest: invalid-wait-bad-flags
[259.964851] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[260.079176] [049/131] (799s left) kms_cursor_crc (cursor-sliding-32x32)
[260.416145] Starting subtest: cursor-sliding-32x32
[260.463551] Subtest cursor-sliding-32x32: SKIP (0.045s)
[260.833501] [050/131] (799s left) kms_content_protection (uevent)
[261.181379] Starting subtest: uevent
[261.216371] Starting dynamic subtest: pipe-A-DP-4
[295.740322] Dynamic subtest pipe-A-DP-4: FAIL (34.474s)
[295.805913] Subtest uevent: FAIL (34.625s)
[296.027289] [051/131] (764s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[296.307676] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.000s)
[296.343250] [052/131] (763s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[296.621340] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[296.623136] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[296.739743] [053/131] (763s left) kms_cursor_crc (cursor-onscreen-256x256)
[297.203504] Starting subtest: cursor-onscreen-256x256
[297.208053] Starting dynamic subtest: pipe-A-DP-4
[299.932177] Dynamic subtest pipe-A-DP-4: SUCCESS (2.723s)
[299.985096] Starting dynamic subtest: pipe-D-DP-4
[302.667384] Dynamic subtest pipe-D-DP-4: SUCCESS (2.692s)
[302.668350] Subtest cursor-onscreen-256x256: SUCCESS (5.463s)
[303.032475] [054/131] (757s left) gem_ctx_persistence (userptr)
[303.175192] Starting subtest: userptr
[303.385015] Subtest userptr: SUCCESS (0.209s)
[303.492872] [055/131] (756s left) kms_lease (lease-uevent)
[303.787546] Starting subtest: lease-uevent
[304.802809] Subtest lease-uevent: SUCCESS (1.015s)
[304.869364] [056/131] (755s left) kms_chamelium_hpd (vga-hpd-fast)
[305.224990] Subtest vga-hpd-fast: SKIP (0.000s)
[305.344860] [057/131] (754s left) api_intel_bb (blit-reloc-keep-cache)
[305.491621] Starting subtest: blit-reloc-keep-cache
[305.493492] Subtest blit-reloc-keep-cache: SKIP (0.000s)
[305.641654] [058/131] (754s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[305.908630] Starting subtest: plane-primary-toggle-with-vblank-wait
[305.909561] Starting dynamic subtest: pipe-A-DP-4
[306.125304] Dynamic subtest pipe-A-DP-4: SUCCESS (0.215s)
[306.238218] Starting dynamic subtest: pipe-B-DP-4
[306.451502] Dynamic subtest pipe-B-DP-4: SUCCESS (0.249s)
[306.504606] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (0.596s)
[306.716864] [059/131] (753s left) kms_flip (2x-wf_vblank-ts-check)
[306.990938] Starting subtest: 2x-wf_vblank-ts-check
[307.004581] Subtest 2x-wf_vblank-ts-check: SKIP (0.013s)
[307.090204] [060/131] (753s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[307.389525] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[308.616200] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.225s)
[308.775208] [061/131] (751s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[309.056849] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[309.058735] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[309.165797] [062/131] (751s left) gem_flink_race (flink_close)
[309.294876] Starting subtest: flink_close
[314.351687] Subtest flink_close: SUCCESS (5.055s)
[314.423855] [063/131] (746s left) gem_exec_whisper (basic-fds)
[314.653882] Starting subtest: basic-fds
[323.142008] Subtest basic-fds: SUCCESS (8.479s)
[323.330878] [064/131] (737s left) gem_lmem_evict (dontneed-evict-race)
[327.062914] Starting subtest: dontneed-evict-race
[329.163425] Subtest dontneed-evict-race: SUCCESS (2.100s)
[331.115023] [065/131] (729s left) gem_softpin (noreloc-interruptible)
[332.559014] Starting subtest: noreloc-interruptible
[338.017301] Subtest noreloc-interruptible: SUCCESS (5.457s)
[338.102392] [066/131] (722s left) gem_exec_reloc (basic-write-cpu-active)
[338.185843] Subtest basic-write-cpu-active: SKIP (0.000s)
[338.259370] [067/131] (722s left) drm_fdinfo (virtual-busy-hang-all)
[338.345810] Starting subtest: virtual-busy-hang-all
[338.347684] Subtest virtual-busy-hang-all: SKIP (0.000s)
[338.427263] [068/131] (722s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[341.064557] Starting subtest: gem-execbuf-stress-pc8
[341.157758] Subtest gem-execbuf-stress-pc8: SKIP (0.093s)
[341.391022] [069/131] (719s left) gem_exec_schedule (semaphore-resolve)
[341.477605] Starting subtest: semaphore-resolve
[341.547845] Subtest semaphore-resolve: SUCCESS (0.070s)
[341.981916] [070/131] (718s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[342.206380] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[342.207412] Starting dynamic subtest: pipe-A-DP-4
[342.217437] Dynamic subtest pipe-A-DP-4: SKIP (0.000s)
[342.228077] Starting dynamic subtest: pipe-B-DP-4
[342.236750] Dynamic subtest pipe-B-DP-4: SKIP (0.000s)
[342.246025] Starting dynamic subtest: pipe-C-DP-4
[342.254561] Dynamic subtest pipe-C-DP-4: SKIP (0.000s)
[342.263913] Starting dynamic subtest: pipe-D-DP-4
[342.272971] Dynamic subtest pipe-D-DP-4: SKIP (0.000s)
[342.274679] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SKIP (0.009s)
[342.653370] [071/131] (718s left) kms_psr (pr-primary-render)
[342.897983] Subtest pr-primary-render: SKIP (0.000s)
[342.932127] [072/131] (717s left) kms_invalid_mode (uint-max-clock)
[343.177782] Starting subtest: uint-max-clock
[343.178857] Starting dynamic subtest: pipe-A-DP-4
[343.280584] Dynamic subtest pipe-A-DP-4: SUCCESS (0.101s)
[343.300964] Starting dynamic subtest: pipe-B-DP-4
[343.302096] Dynamic subtest pipe-B-DP-4: SUCCESS (0.002s)
[343.313492] Starting dynamic subtest: pipe-C-DP-4
[343.314443] Dynamic subtest pipe-C-DP-4: SUCCESS (0.001s)
[343.323891] Starting dynamic subtest: pipe-D-DP-4
[343.324844] Dynamic subtest pipe-D-DP-4: SUCCESS (0.001s)
[343.325759] Subtest uint-max-clock: SUCCESS (0.119s)
[343.509346] [073/131] (717s left) gem_userptr_blits (stress-purge)
[343.603692] Starting subtest: stress-purge
[348.992994] Subtest stress-purge: SUCCESS (5.387s)
[349.150256] [074/131] (711s left) gem_exec_gttfill (engines)
[349.330014] Starting subtest: engines
[349.330940] Starting dynamic subtest: rcs0
[374.698947] Dynamic subtest rcs0: SUCCESS (25.360s)
[374.709683] Starting dynamic subtest: bcs0
[400.419894] Dynamic subtest bcs0: SUCCESS (25.726s)
[400.429960] Starting dynamic subtest: vcs0
[426.083335] Dynamic subtest vcs0: SUCCESS (25.665s)
[426.093381] Starting dynamic subtest: vcs1
[451.728389] Dynamic subtest vcs1: SUCCESS (25.644s)
[451.738639] Starting dynamic subtest: vecs0
[477.364515] Dynamic subtest vecs0: SUCCESS (25.633s)
[477.374673] Starting dynamic subtest: vecs1
[503.053065] Dynamic subtest vecs1: SUCCESS (25.684s)
[503.063322] Starting dynamic subtest: ccs0
[528.765804] Dynamic subtest ccs0: SUCCESS (25.707s)
[528.766882] Subtest engines: SUCCESS (179.425s)
[528.993999] [075/131] (531s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[529.264783] Starting subtest: psr-2p-pri-indfb-multidraw
[529.266701] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[529.360464] [076/131] (531s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[529.579433] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[529.581119] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[529.710509] [077/131] (531s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[529.801567] Starting subtest: etime-multi-wait-for-submit-submitted
[529.911479] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.108s)
[529.991260] [078/131] (531s left) gem_mmap_wc (write)
[530.091649] Subtest write: SKIP (0.000s)
[530.141392] [079/131] (530s left) perf_pmu (most-busy-check-all)
[530.205640] Starting subtest: most-busy-check-all
[530.206599] Starting dynamic subtest: rcs0
[530.783430] Dynamic subtest rcs0: SUCCESS (0.577s)
[530.796983] Starting dynamic subtest: bcs0
[531.336537] Dynamic subtest bcs0: SUCCESS (0.552s)
[531.347614] Starting dynamic subtest: vcs0
[531.889087] Dynamic subtest vcs0: SUCCESS (0.551s)
[531.903564] Starting dynamic subtest: vcs1
[532.444116] Dynamic subtest vcs1: SUCCESS (0.551s)
[532.458839] Starting dynamic subtest: vecs0
[532.998088] Dynamic subtest vecs0: SUCCESS (0.550s)
[533.012263] Starting dynamic subtest: vecs1
[533.554228] Dynamic subtest vecs1: SUCCESS (0.554s)
[533.564990] Starting dynamic subtest: ccs0
[534.106544] Dynamic subtest ccs0: SUCCESS (0.550s)
[534.108573] Subtest most-busy-check-all: SUCCESS (3.901s)
[534.245800] [080/131] (526s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[534.470793] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[534.471697] Starting dynamic subtest: pipe-A-valid-mode
[534.553608] Dynamic subtest pipe-A-valid-mode: SKIP (0.081s)
[534.555416] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.083s)
[534.717103] [081/131] (526s left) gem_exec_params (invalid-bsd2-flag-on-render)
[534.812615] Starting subtest: invalid-bsd2-flag-on-render
[534.813555] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[534.922500] [082/131] (526s left) prime_vgem (busy)
[535.107148] Starting subtest: busy
[535.108051] Starting dynamic subtest: rcs0
[535.169699] Dynamic subtest rcs0: SUCCESS (0.062s)
[535.180752] Starting dynamic subtest: bcs0
[535.215890] Dynamic subtest bcs0: SUCCESS (0.045s)
[535.229283] Starting dynamic subtest: vcs0
[535.256593] Dynamic subtest vcs0: SUCCESS (0.040s)
[535.278783] Starting dynamic subtest: vcs1
[535.297064] Dynamic subtest vcs1: SUCCESS (0.039s)
[535.319435] Starting dynamic subtest: vecs0
[535.337480] Dynamic subtest vecs0: SUCCESS (0.039s)
[535.354801] Starting dynamic subtest: vecs1
[535.378060] Dynamic subtest vecs1: SUCCESS (0.039s)
[535.393199] Starting dynamic subtest: ccs0
[535.417764] Dynamic subtest ccs0: SUCCESS (0.039s)
[535.418736] Subtest busy: SUCCESS (0.311s)
[535.576600] [083/131] (525s left) kms_psr (fbc-psr-dpms)
[535.817909] Subtest fbc-psr-dpms: SKIP (0.000s)
[535.844165] [084/131] (525s left) gem_unfence_active_buffers
[536.058614] [085/131] (525s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[536.315812] Starting subtest: short-flip-before-cursor-toggle
[537.361136] Subtest short-flip-before-cursor-toggle: SUCCESS (1.045s)
[537.616169] [086/131] (523s left) prime_mmap (test_map_unmap)
[537.701768] Starting subtest: test_map_unmap
[537.702707] Starting dynamic subtest: test_map_unmap-smem
[537.750290] Dynamic subtest test_map_unmap-smem: SUCCESS (0.048s)
[537.761295] Starting dynamic subtest: test_map_unmap-lmem0
[537.962092] Dynamic subtest test_map_unmap-lmem0: SUCCESS (0.210s)
[537.963059] Subtest test_map_unmap: SUCCESS (0.261s)
[538.079676] [087/131] (523s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-blt)
[538.318306] Starting subtest: psr-1p-offscren-pri-indfb-draw-blt
[538.320012] Subtest psr-1p-offscren-pri-indfb-draw-blt: SKIP (0.000s)
[538.432699] [088/131] (523s left) gem_lmem_swapping (verify-random)
[542.015966] Starting subtest: verify-random
[542.017127] Starting dynamic subtest: lmem0
[549.319337] Dynamic subtest lmem0: SUCCESS (7.301s)
[549.320324] Subtest verify-random: SUCCESS (7.302s)
[551.230950] [089/131] (510s left) gem_exec_balancer (full-late-pulse)
[552.738020] Starting subtest: full-late-pulse
[554.490831] Subtest full-late-pulse: SUCCESS (1.752s)
[554.854808] [090/131] (506s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[555.113996] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[555.115907] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[555.236882] [091/131] (506s left) gem_busy (busy)
[555.329619] Starting subtest: busy
[555.330580] Starting dynamic subtest: all-engines
[555.420216] Dynamic subtest all-engines: SUCCESS (0.090s)
[555.432984] Starting dynamic subtest: rcs0
[555.519884] Dynamic subtest rcs0: SUCCESS (0.098s)
[555.530803] Starting dynamic subtest: bcs0
[555.577988] Dynamic subtest bcs0: SUCCESS (0.057s)
[555.604560] Starting dynamic subtest: vcs0
[555.622230] Dynamic subtest vcs0: SUCCESS (0.043s)
[555.649462] Starting dynamic subtest: vcs1
[555.666297] Dynamic subtest vcs1: SUCCESS (0.042s)
[555.691936] Starting dynamic subtest: vecs0
[555.708068] Dynamic subtest vecs0: SUCCESS (0.040s)
[555.722832] Starting dynamic subtest: vecs1
[555.748224] Dynamic subtest vecs1: SUCCESS (0.038s)
[555.762947] Starting dynamic subtest: ccs0
[555.788514] Dynamic subtest ccs0: SUCCESS (0.039s)
[555.789750] Subtest busy: SUCCESS (0.458s)
[556.235553] [092/131] (505s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[556.314034] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[556.314934] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[556.454332] [093/131] (505s left) kms_flip (basic-flip-vs-wf_vblank)
[556.682777] Starting subtest: basic-flip-vs-wf_vblank
[556.688954] Starting dynamic subtest: A-DP4
[557.835935] Dynamic subtest A-DP4: SUCCESS (1.147s)
[557.850347] Starting dynamic subtest: B-DP4
[558.870711] Dynamic subtest B-DP4: SUCCESS (1.033s)
[558.883993] Starting dynamic subtest: C-DP4
[559.905641] Dynamic subtest C-DP4: SUCCESS (1.033s)
[559.918261] Starting dynamic subtest: D-DP4
[560.970959] Dynamic subtest D-DP4: SUCCESS (1.064s)
[560.971922] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.288s)
[561.256074] [094/131] (500s left) kms_pm_rpm (pm-tiling)
[563.064397] Starting subtest: pm-tiling
[563.068640] Subtest pm-tiling: SKIP (0.000s)
[563.415822] [095/131] (498s left) syncobj_wait (multi-wait-all-submitted-signaled)
[563.486044] Starting subtest: multi-wait-all-submitted-signaled
[563.590334] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.104s)
[563.707588] [096/131] (498s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[563.953979] Starting subtest: cursorA-vs-flipA-atomic
[574.925472] Subtest cursorA-vs-flipA-atomic: SUCCESS (10.969s)
[575.153549] [097/131] (486s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[575.247911] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[575.248908] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[575.369290] [098/131] (486s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[575.452441] Starting subtest: multi-wait-all-for-submit-available-submitted
[575.453390] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[575.607584] [099/131] (486s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[575.843422] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[575.845233] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[575.961960] [100/131] (486s left) kms_cursor_edge_walk (256x256-top-bottom)
[576.197766] Starting subtest: 256x256-top-bottom
[576.198680] Starting dynamic subtest: pipe-A-DP-4
[579.673860] Dynamic subtest pipe-A-DP-4: SUCCESS (3.474s)
[579.693477] Starting dynamic subtest: pipe-D-DP-4
[583.006555] Dynamic subtest pipe-D-DP-4: SUCCESS (3.329s)
[583.007505] Subtest 256x256-top-bottom: SUCCESS (6.808s)
[583.239521] [101/131] (478s left) kms_flip (flip-vs-wf_vblank-interruptible)
[583.477337] Starting subtest: flip-vs-wf_vblank-interruptible
[583.482900] Starting dynamic subtest: A-DP4
[584.576615] Dynamic subtest A-DP4: SUCCESS (1.093s)
[584.591412] Starting dynamic subtest: B-DP4
[585.591691] Dynamic subtest B-DP4: SUCCESS (1.013s)
[585.604800] Starting dynamic subtest: C-DP4
[586.603697] Dynamic subtest C-DP4: SUCCESS (1.011s)
[586.617784] Starting dynamic subtest: D-DP4
[587.645804] Dynamic subtest D-DP4: SUCCESS (1.041s)
[587.646763] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (4.168s)
[587.963880] [102/131] (474s left) drm_buddy (drm_buddy)
[588.030704] Starting subtest: drm_buddy
[588.042815] Starting dynamic subtest: drm_test_buddy_alloc_limit
[588.187171] Dynamic subtest drm_test_buddy_alloc_limit: SUCCESS (0.143s)
[588.197852] Starting dynamic subtest: drm_test_buddy_alloc_optimistic
[588.265703] Dynamic subtest drm_test_buddy_alloc_optimistic: SUCCESS (0.077s)
[588.280241] Starting dynamic subtest: drm_test_buddy_alloc_pessimistic
[588.380016] Dynamic subtest drm_test_buddy_alloc_pessimistic: SUCCESS (0.110s)
[588.423178] Starting dynamic subtest: drm_test_buddy_alloc_pathological
[588.497226] Dynamic subtest drm_test_buddy_alloc_pathological: SUCCESS (0.111s)
[588.540914] Starting dynamic subtest: drm_test_buddy_alloc_contiguous
[588.597032] Dynamic subtest drm_test_buddy_alloc_contiguous: SUCCESS (0.096s)
[588.642401] Starting dynamic subtest: drm_test_buddy_alloc_clear
[588.769767] Dynamic subtest drm_test_buddy_alloc_clear: SUCCESS (0.169s)
[588.780397] Starting dynamic subtest: drm_test_buddy_alloc_range_bias
[588.863155] Dynamic subtest drm_test_buddy_alloc_range_bias: SUCCESS (0.093s)
[588.864075] Subtest drm_buddy: SUCCESS (0.833s)
[589.070604] [103/131] (473s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[589.158658] Subtest no-spare-fences-busy: SKIP (0.000s)
[589.243535] [104/131] (472s left) gem_tiled_blits (interruptible)
[589.329831] Subtest interruptible: SKIP (0.000s)
[589.403803] [105/131] (472s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[589.640393] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[589.642230] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[589.761293] [106/131] (472s left) api_intel_bb (render)
[589.846855] Starting subtest: render
[589.847830] Starting dynamic subtest: render-none-512
[589.893372] Dynamic subtest render-none-512: SUCCESS (0.047s)
[589.905580] Starting dynamic subtest: render-none-1024
[589.980581] Dynamic subtest render-none-1024: SUCCESS (0.086s)
[589.991498] Starting dynamic subtest: render-x-512
[589.998678] Dynamic subtest render-x-512: SUCCESS (0.017s)
[590.009671] Starting dynamic subtest: render-x-1024
[590.078390] Dynamic subtest render-x-1024: SUCCESS (0.079s)
[590.089173] Starting dynamic subtest: render-y-512
[590.096546] Dynamic subtest render-y-512: SUCCESS (0.017s)
[590.107555] Starting dynamic subtest: render-y-1024
[590.163298] Dynamic subtest render-y-1024: SUCCESS (0.066s)
[590.164257] Subtest render: SUCCESS (0.317s)
[590.319804] [107/131] (471s left) prime_vgem (fence-write-hang)
[590.448964] Subtest fence-write-hang: SKIP (0.000s)
[590.585273] [108/131] (471s left) kms_chamelium_color (ctm-limited-range)
[590.839507] Subtest ctm-limited-range: SKIP (0.000s)
[590.880829] [109/131] (471s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[591.116856] Starting subtest: yf-tiled-16bpp-rotate-270
[591.118682] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[591.216376] [110/131] (471s left) gem_exec_reloc (basic-write-wc-noreloc)
[591.318689] Subtest basic-write-wc-noreloc: SKIP (0.000s)
[591.404660] [111/131] (471s left) kms_getfb (getfb2-accept-ccs)
[591.491801] Starting subtest: getfb2-accept-ccs
[591.492753] Subtest getfb2-accept-ccs: SUCCESS (0.000s)
[591.636518] [112/131] (470s left) perf_pmu (faulting-read)
[591.712013] Starting subtest: faulting-read
[591.712943] Starting dynamic subtest: fixed
[591.713854] Dynamic subtest fixed: SUCCESS (0.001s)
[591.714746] Subtest faulting-read: SUCCESS (0.002s)
[591.812494] [113/131] (470s left) kms_addfb_basic (size-max)
[592.040087] Starting subtest: size-max
[592.040941] Subtest size-max: SUCCESS (0.000s)
[592.154847] [114/131] (470s left) kms_psr (psr-sprite-plane-onoff)
[592.421219] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[592.448057] [115/131] (470s left) gem_exec_schedule (noreorder)
[592.697240] Starting subtest: noreorder
[592.698576] Starting dynamic subtest: rcs0
[592.795823] Dynamic subtest rcs0: SUCCESS (0.100s)
[592.810546] Starting dynamic subtest: bcs0
[592.858007] Dynamic subtest bcs0: SUCCESS (0.061s)
[592.886683] Starting dynamic subtest: vcs0
[592.937113] Dynamic subtest vcs0: SUCCESS (0.076s)
[592.981346] Starting dynamic subtest: vcs1
[593.032361] Dynamic subtest vcs1: SUCCESS (0.091s)
[593.061564] Starting dynamic subtest: vecs0
[593.109010] Dynamic subtest vecs0: SUCCESS (0.074s)
[593.153040] Starting dynamic subtest: vecs1
[593.205376] Dynamic subtest vecs1: SUCCESS (0.093s)
[593.246441] Starting dynamic subtest: ccs0
[593.268984] Dynamic subtest ccs0: SUCCESS (0.061s)
[593.269963] Subtest noreorder: SUCCESS (0.575s)
[593.529744] [116/131] (469s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[593.758041] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[593.758936] Starting dynamic subtest: pipe-A-DP-4
[593.762398] Dynamic subtest pipe-A-DP-4: SKIP (0.000s)
[593.773364] Starting dynamic subtest: pipe-B-DP-4
[593.776816] Dynamic subtest pipe-B-DP-4: SKIP (0.000s)
[593.787584] Starting dynamic subtest: pipe-C-DP-4
[593.791158] Dynamic subtest pipe-C-DP-4: SKIP (0.000s)
[593.801800] Starting dynamic subtest: pipe-D-DP-4
[593.805396] Dynamic subtest pipe-D-DP-4: SKIP (0.000s)
[593.807046] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[594.176189] [117/131] (468s left) sysfs_heartbeat_interval (precise)
[594.264400] Starting subtest: precise
[594.265397] Starting dynamic subtest: vecs0
[595.996692] Dynamic subtest vecs0: SUCCESS (1.731s)
[596.010636] Starting dynamic subtest: ccs0
[597.518693] Dynamic subtest ccs0: SUCCESS (1.520s)
[597.529847] Starting dynamic subtest: vcs0
[600.083727] Dynamic subtest vcs0: SUCCESS (2.563s)
[600.095259] Starting dynamic subtest: bcs0
[601.527724] Dynamic subtest bcs0: SUCCESS (1.443s)
[601.539107] Starting dynamic subtest: vecs1
[603.040502] Dynamic subtest vecs1: SUCCESS (1.511s)
[603.057916] Starting dynamic subtest: rcs0
[606.110834] Dynamic subtest rcs0: SUCCESS (3.067s)
[606.122324] Starting dynamic subtest: vcs1
[607.565224] Dynamic subtest vcs1: SUCCESS (1.453s)
[607.573278] Subtest precise: SUCCESS (13.298s)
[607.699968] [118/131] (455s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-25)
[607.928897] Starting subtest: planes-upscale-20x20-downscale-factor-0-25
[607.929715] Starting dynamic subtest: pipe-A
[608.661532] Dynamic subtest pipe-A: SKIP (0.730s)
[608.672049] Starting dynamic subtest: pipe-B
[609.760334] Dynamic subtest pipe-B: SKIP (1.098s)
[609.770806] Starting dynamic subtest: pipe-C
[610.858644] Dynamic subtest pipe-C: SKIP (1.096s)
[610.869526] Starting dynamic subtest: pipe-D
[611.951267] Dynamic subtest pipe-D: SKIP (1.093s)
[611.952652] Subtest planes-upscale-20x20-downscale-factor-0-25: SKIP (4.021s)
[612.064312] [119/131] (450s left) kms_psr (psr2-sprite-mmap-cpu)
[612.301872] Subtest psr2-sprite-mmap-cpu: SKIP (0.000s)
[612.326968] [120/131] (450s left) kms_addfb_basic (too-wide)
[612.551644] Starting subtest: too-wide
[612.552619] Subtest too-wide: SUCCESS (0.000s)
[612.631565] [121/131] (450s left) gen3_render_tiledx_blits
[612.745028] [122/131] (450s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[612.825020] Starting subtest: rel-constants-invalid-rel-gen5
[612.825972] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[612.913977] [123/131] (449s left) gem_exec_fence (syncobj-timeline-wait)
[613.499235] Starting subtest: syncobj-timeline-wait
[613.598472] Subtest syncobj-timeline-wait: SUCCESS (0.107s)
[613.815487] [124/131] (449s left) gen9_exec_parse (bb-secure)
[613.897107] Subtest bb-secure: SKIP (0.000s)
[613.960382] [125/131] (448s left) gem_mmap_wc (read-write-distinct)
[614.033744] Subtest read-write-distinct: SKIP (0.000s)
[614.078742] [126/131] (448s left) sysfs_timeslice_duration (duration)
[614.159787] Starting subtest: duration
[614.160676] Starting dynamic subtest: vecs0
[627.349520] Dynamic subtest vecs0: SUCCESS (13.185s)
[627.364651] Starting dynamic subtest: ccs0
[640.486996] Dynamic subtest ccs0: SUCCESS (13.138s)
[640.500582] Starting dynamic subtest: vcs0
[653.627570] Dynamic subtest vcs0: SUCCESS (13.147s)
[653.641695] Starting dynamic subtest: bcs0
[666.765622] Dynamic subtest bcs0: SUCCESS (13.141s)
[666.780057] Starting dynamic subtest: vecs1
[679.902085] Dynamic subtest vecs1: SUCCESS (13.138s)
[679.916982] Starting dynamic subtest: rcs0
[693.047516] Dynamic subtest rcs0: SUCCESS (13.147s)
[693.062100] Starting dynamic subtest: vcs1
[706.177985] Dynamic subtest vcs1: SUCCESS (13.130s)
[706.178987] Subtest duration: SUCCESS (92.047s)
[706.243398] [127/131] (356s left) perf (invalid-oa-metric-set-id)
[706.588831] Starting subtest: invalid-oa-metric-set-id
[706.606787] Subtest invalid-oa-metric-set-id: SUCCESS (0.019s)
[706.638863] [128/131] (356s left) gem_ctx_engines (invalid-engines)
[706.803273] Starting subtest: invalid-engines
[706.835815] Subtest invalid-engines: SUCCESS (0.032s)
[707.117415] [129/131] (355s left) i915_query (query-regions-unallocated)
[707.245890] Starting subtest: query-regions-unallocated
[708.106202] Subtest query-regions-unallocated: SUCCESS (0.861s)
[708.179361] [130/131] (354s left) kms_chamelium_frames (dp-crc-single)
[708.530495] Subtest dp-crc-single: SKIP (0.000s)
[708.653758] [131/131] (354s left) gem_unref_active_buffers
[709.032670] Closing watchdogs
Done.