[55.692662] Initializing watchdogs
[55.692868]   /dev/watchdog0
[55.726360] [001/138] (960s left) gem_eio (in-flight-internal-10ms)
[56.028215] Starting subtest: in-flight-internal-10ms
[56.144211] Subtest in-flight-internal-10ms: SUCCESS (0.134s)
[56.368461] [002/138] (959s left) gem_create (hog-create)
[56.604812] Starting subtest: hog-create
[56.626671] Starting dynamic subtest: smem0
[88.871160] Dynamic subtest smem0: SUCCESS (32.268s)
[88.892687] Subtest hog-create: SUCCESS (32.268s)
[89.081801] [003/138] (927s left) gem_exec_balancer (individual)
[89.317997] Starting subtest: individual
[93.398502] Subtest individual: SUCCESS (3.913s)
[97.376365] [004/138] (919s left) gem_exec_reloc (basic-write-gtt)
[97.635787] Starting subtest: basic-write-gtt
[97.662977] Subtest basic-write-gtt: SUCCESS (0.020s)
[97.835894] [005/138] (918s left) kms_plane_scaling (planes-upscale-20x20)
[98.157619] Starting subtest: planes-upscale-20x20
[98.182681] Starting dynamic subtest: pipe-A-DP-1
[98.293254] Dynamic subtest pipe-A-DP-1: SUCCESS (0.114s)
[98.333537] Starting dynamic subtest: pipe-B-DP-1
[98.654057] Dynamic subtest pipe-B-DP-1: SUCCESS (0.368s)
[98.679972] Subtest planes-upscale-20x20: SUCCESS (0.507s)
[99.120430] [006/138] (917s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[99.430873] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[99.459866] Starting dynamic subtest: pipe-A-valid-mode
[100.161548] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.721s)
[100.181788] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SUCCESS (0.723s)
[100.506465] [007/138] (916s left) kms_ccs (pipe-a-missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[100.917694] Starting subtest: pipe-A-missing-ccs-buffer-y-tiled-gen12-mc-ccs
[100.959264] Subtest pipe-A-missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[101.363572] [008/138] (915s left) kms_draw_crc (draw-method-render)
[101.664581] Starting subtest: draw-method-render
[101.683342] Starting dynamic subtest: xrgb8888-untiled
[102.023098] Dynamic subtest xrgb8888-untiled: SUCCESS (0.360s)
[102.055784] Starting dynamic subtest: rgb565-untiled
[102.339555] Dynamic subtest rgb565-untiled: SUCCESS (0.317s)
[102.372360] Starting dynamic subtest: xrgb2101010-untiled
[102.671383] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.332s)
[102.704218] Starting dynamic subtest: xrgb8888-xtiled
[102.874629] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.200s)
[102.910076] Starting dynamic subtest: rgb565-xtiled
[103.053656] Dynamic subtest rgb565-xtiled: SUCCESS (0.183s)
[103.089295] Starting dynamic subtest: xrgb2101010-xtiled
[103.253708] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.200s)
[103.286477] Starting dynamic subtest: xrgb8888-ytiled
[103.474969] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.217s)
[103.509894] Starting dynamic subtest: rgb565-ytiled
[103.660817] Dynamic subtest rgb565-ytiled: SUCCESS (0.183s)
[103.696486] Starting dynamic subtest: xrgb2101010-ytiled
[103.870023] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.216s)
[103.891645] Subtest draw-method-render: SUCCESS (2.211s)
[104.010842] [009/138] (912s left) gen9_exec_parse (batch-without-end)
[104.245708] Starting subtest: batch-without-end
[104.266369] Subtest batch-without-end: SUCCESS (0.003s)
[104.499810] [010/138] (912s left) gem_exec_flush (basic-wb-set-default)
[104.762080] Starting subtest: basic-wb-set-default
[110.363360] Subtest basic-wb-set-default: SUCCESS (5.495s)
[110.469196] [011/138] (906s left) kms_ccs (pipe-b-crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[110.909931] Starting subtest: pipe-B-crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[110.950319] Subtest pipe-B-crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SKIP (0.001s)
[111.330165] [012/138] (905s left) kms_psr (primary_render)
[111.590836] Subtest primary_render: SKIP (0.000s)
[111.671548] [013/138] (905s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[112.053751] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[112.091120] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[112.175196] [014/138] (905s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[112.478180] Starting subtest: 2x-long-cursor-vs-flip-legacy
[112.519608] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.004s)
[112.601911] [015/138] (904s left) kms_addfb_basic (master-rmfb)
[112.837325] Starting subtest: master-rmfb
[112.856532] Subtest master-rmfb: SUCCESS (0.001s)
[113.012440] [016/138] (904s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[113.362615] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[113.405917] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[113.492523] [017/138] (904s left) api_intel_bb (intel-bb-blit-none)
[113.728605] Starting subtest: intel-bb-blit-none
[117.517071] Subtest intel-bb-blit-none: SUCCESS (3.642s)
[117.604089] [018/138] (900s left) kms_chamelium_frames (dp-crc-fast)
[118.032179] Subtest dp-crc-fast: SKIP (0.000s)
[118.322252] [019/138] (899s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[118.669870] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[118.712769] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[118.799118] [020/138] (899s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[119.091210] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[119.109960] Starting dynamic subtest: pipe-A-valid-mode
[119.783918] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.681s)
[119.806064] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (0.683s)
[120.116046] [021/138] (897s left) v3d/v3d_perfmon (create-perfmon-0)
[120.402406] Subtest create-perfmon-0: SKIP (0.000s)
[120.493583] [022/138] (897s left) gem_softpin (full)
[120.725770] Starting subtest: full
[120.748407] Subtest full: SUCCESS (0.017s)
[120.855203] [023/138] (897s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[121.209997] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[121.252472] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[121.337826] [024/138] (896s left) kms_pm_rpm (cursor)
[123.394404] Starting subtest: cursor
[125.836057] Subtest cursor: SUCCESS (2.441s)
[126.309570] [025/138] (891s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[126.630195] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[126.672166] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[126.754764] [026/138] (891s left) kms_prime (basic-modeset-hybrid)
[128.907980] Subtest basic-modeset-hybrid: SKIP (0.000s)
[129.093804] [027/138] (889s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[129.462223] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[129.499860] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[129.585372] [028/138] (888s left) kms_ccs (pipe-a-bad-aux-stride-yf-tiled-ccs)
[129.992887] Starting subtest: pipe-A-bad-aux-stride-yf-tiled-ccs
[130.013060] Subtest pipe-A-bad-aux-stride-yf-tiled-ccs: SUCCESS (0.001s)
[130.449064] [029/138] (888s left) syncobj_timeline (invalid-wait-illegal-handle)
[130.686650] Starting subtest: invalid-wait-illegal-handle
[130.705654] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[130.793981] [030/138] (887s left) kms_ccs (pipe-a-crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[131.188739] Starting subtest: pipe-A-crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[131.231659] Subtest pipe-A-crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.001s)
[131.665821] [031/138] (887s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[132.034364] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[132.076796] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[132.165396] [032/138] (886s left) gem_ctx_engines (invalid-engines)
[132.402233] Starting subtest: invalid-engines
[132.423695] Subtest invalid-engines: SUCCESS (0.014s)
[132.632557] [033/138] (886s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[132.964139] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[133.001658] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[133.090482] [034/138] (885s left) gem_ctx_param (non-root-set)
[133.327838] Starting subtest: non-root-set
[133.349800] Subtest non-root-set: SUCCESS (0.035s)
[133.446703] [035/138] (885s left) kms_ccs (pipe-c-crc-primary-rotation-180-yf-tiled-ccs)
[133.946398] Starting subtest: pipe-C-crc-primary-rotation-180-yf-tiled-ccs
[133.986517] Subtest pipe-C-crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.001s)
[134.326186] [036/138] (884s left) syncobj_wait (wait-for-submit-delayed-submit)
[134.560569] Starting subtest: wait-for-submit-delayed-submit
[134.637111] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[134.740438] [037/138] (884s left) kms_prop_blob (invalid-set-prop)
[134.977086] Starting subtest: invalid-set-prop
[134.996694] Subtest invalid-set-prop: SUCCESS (0.000s)
[135.083043] [038/138] (884s left) kms_flip (2x-flip-vs-expired-vblank)
[135.389603] Starting subtest: 2x-flip-vs-expired-vblank
[135.431241] Subtest 2x-flip-vs-expired-vblank: SKIP (0.003s)
[135.514498] [039/138] (883s left) gem_exec_balancer (sliced)
[135.744529] Starting subtest: sliced
[139.667237] Subtest sliced: SUCCESS (3.754s)
[143.622419] [040/138] (875s left) kms_cursor_crc (cursor-offscreen-512x170)
[143.943220] Starting subtest: cursor-offscreen-512x170
[143.986535] Subtest cursor-offscreen-512x170: SKIP (0.003s)
[144.073136] [041/138] (875s left) kms_ccs (pipe-d-bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[144.627908] Subtest pipe-D-bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[144.951133] [042/138] (874s left) kms_plane_alpha_blend (alpha-opaque-fb)
[145.251310] Starting subtest: alpha-opaque-fb
[145.567115] Starting dynamic subtest: pipe-A-DP-1
[151.847528] Dynamic subtest pipe-A-DP-1: FAIL (4.941s)
[151.880940] Starting dynamic subtest: pipe-C-DP-1
[157.266424] Dynamic subtest pipe-C-DP-1: FAIL (4.506s)
[157.289622] Subtest alpha-opaque-fb: FAIL (9.767s)
[157.382532] [043/138] (862s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[157.758883] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[157.795794] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[157.887073] [044/138] (861s left) kms_ccs (pipe-a-crc-primary-basic-4-tiled-dg2-mc-ccs)
[158.282789] Starting subtest: pipe-A-crc-primary-basic-4-tiled-dg2-mc-ccs
[158.321820] Subtest pipe-A-crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.001s)
[158.768530] [045/138] (861s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[159.142814] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[159.188718] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[159.284472] [046/138] (860s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[159.573327] Subtest flip-primary-invalidate-overlay: SKIP (0.000s)
[159.674521] [047/138] (860s left) kms_ccs (pipe-c-bad-pixel-format-yf-tiled-ccs)
[160.152469] Starting subtest: pipe-C-bad-pixel-format-yf-tiled-ccs
[160.200417] Subtest pipe-C-bad-pixel-format-yf-tiled-ccs: SKIP (0.000s)
[160.570253] [048/138] (859s left) kms_ccs (pipe-c-bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[161.068501] Starting subtest: pipe-C-bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[161.130736] Subtest pipe-C-bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[161.470588] [049/138] (858s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[161.837396] Starting subtest: x-tiled-8bpp-rotate-0
[164.688645] Subtest x-tiled-8bpp-rotate-0: SUCCESS (2.890s)
[164.952651] [050/138] (855s left) syncobj_timeline (reset-during-wait-for-submit)
[165.191676] Starting subtest: reset-during-wait-for-submit
[165.262764] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[165.399296] [051/138] (855s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[165.644858] Starting subtest: cpuset-basic-small-copy-XY
[173.583587] Subtest cpuset-basic-small-copy-XY: SUCCESS (7.975s)
[173.706411] [052/138] (846s left) kms_plane (plane-panning-top-left)
[174.181123] Starting subtest: plane-panning-top-left
[174.200359] Starting dynamic subtest: pipe-A
[175.082586] Dynamic subtest pipe-A: SUCCESS (0.888s)
[175.127565] Starting dynamic subtest: pipe-B
[176.071102] Dynamic subtest pipe-B: SUCCESS (0.983s)
[176.091980] Subtest plane-panning-top-left: SUCCESS (1.878s)
[176.410947] [053/138] (844s left) kms_color (legacy-gamma-reset)
[176.715577] Starting subtest: legacy-gamma-reset
[176.736988] Starting dynamic subtest: pipe-A
[176.885499] Dynamic subtest pipe-A: SUCCESS (0.161s)
[176.924789] Starting dynamic subtest: pipe-B
[176.946927] Dynamic subtest pipe-B: SUCCESS (0.025s)
[176.992835] Starting dynamic subtest: pipe-C
[177.013782] Dynamic subtest pipe-C: SUCCESS (0.026s)
[177.034223] Subtest legacy-gamma-reset: SUCCESS (0.215s)
[177.277296] [054/138] (843s left) kms_cursor_crc (cursor-sliding-128x42)
[177.599703] Starting subtest: cursor-sliding-128x42
[177.621336] Starting dynamic subtest: pipe-A-DP-1
[181.447436] Dynamic subtest pipe-A-DP-1: SUCCESS (3.834s)
[181.515876] Starting dynamic subtest: pipe-C-DP-1
[185.282331] Dynamic subtest pipe-C-DP-1: SUCCESS (3.778s)
[185.306482] Subtest cursor-sliding-128x42: SUCCESS (7.689s)
[185.653586] [055/138] (835s left) kms_cursor_crc (cursor-onscreen-64x21)
[185.969657] Starting subtest: cursor-onscreen-64x21
[185.991148] Starting dynamic subtest: pipe-A-DP-1
[188.302334] Dynamic subtest pipe-A-DP-1: SUCCESS (2.322s)
[188.391808] Starting dynamic subtest: pipe-C-DP-1
[190.802848] Dynamic subtest pipe-C-DP-1: SUCCESS (2.418s)
[190.831332] Subtest cursor-onscreen-64x21: SUCCESS (4.817s)
[191.178641] [056/138] (829s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[191.448865] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[191.556751] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.107s)
[191.676198] [057/138] (829s left) gem_sync (basic-store-each)
[192.074869] Starting subtest: basic-store-each
[194.563064] Subtest basic-store-each: SUCCESS (2.629s)
[194.787443] [058/138] (826s left) api_intel_allocator (alloc-simple)
[195.010778] Starting subtest: alloc-simple
[195.031520] Subtest alloc-simple: SUCCESS (0.005s)
[195.119181] [059/138] (826s left) drm_read (invalid-buffer)
[195.548805] Starting subtest: invalid-buffer
[195.570495] Subtest invalid-buffer: SUCCESS (0.000s)
[195.679434] [060/138] (825s left) gem_ctx_param (invalid-ctx-get)
[195.916846] Starting subtest: invalid-ctx-get
[195.935780] Subtest invalid-ctx-get: SUCCESS (0.000s)
[196.022397] [061/138] (825s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[196.394402] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[196.474039] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.022s)
[196.573934] [062/138] (824s left) kms_fbcon_fbt (psr)
[196.807196] Starting subtest: psr
[196.849774] Subtest psr: SKIP (0.000s)
[196.935990] [063/138] (824s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[197.318764] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[197.357312] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[197.444675] [064/138] (824s left) gem_eio (reset-stress)
[197.726958] Starting subtest: reset-stress
[231.116564] Subtest reset-stress: SUCCESS (33.428s)
[231.306868] [065/138] (790s left) gem_mmap_gtt (basic-small-copy)
[231.548101] Starting subtest: basic-small-copy
[234.323499] Subtest basic-small-copy: SUCCESS (2.808s)
[234.445087] [066/138] (787s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[235.017567] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[236.995280] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SUCCESS (2.056s)
[237.156849] [067/138] (784s left) gem_softpin (invalid)
[237.405606] Starting subtest: invalid
[237.424831] Subtest invalid: SUCCESS (0.012s)
[237.545585] [068/138] (784s left) kms_setmode (clone-exclusive-crtc)
[237.762666] Starting subtest: clone-exclusive-crtc
[237.825210] Subtest clone-exclusive-crtc: SKIP (0.000s)
[237.916533] [069/138] (784s left) kms_chamelium_audio (dp-audio)
[238.343869] Subtest dp-audio: SKIP (0.000s)
[238.647537] [070/138] (783s left) kms_lease (empty-lease)
[238.951261] Starting subtest: empty-lease
[238.972721] Starting dynamic subtest: pipe-A-DP-1
[238.996925] Dynamic subtest pipe-A-DP-1: SUCCESS (0.001s)
[239.035186] Starting dynamic subtest: pipe-B-DP-1
[239.056052] Dynamic subtest pipe-B-DP-1: SUCCESS (0.001s)
[239.093196] Starting dynamic subtest: pipe-C-DP-1
[239.112187] Dynamic subtest pipe-C-DP-1: SUCCESS (0.001s)
[239.131137] Subtest empty-lease: SUCCESS (0.015s)
[239.227521] [071/138] (783s left) kms_ccs (pipe-b-bad-rotation-90-4-tiled-mtl-mc-ccs)
[239.674077] Starting subtest: pipe-B-bad-rotation-90-4-tiled-mtl-mc-ccs
[239.717076] Subtest pipe-B-bad-rotation-90-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[240.116368] [072/138] (782s left) gem_exec_fence (syncobj-channel)
[240.802531] Starting subtest: syncobj-channel
[241.885191] Subtest syncobj-channel: SUCCESS (1.069s)
[242.267797] [073/138] (780s left) gem_ctx_sseu (mmap-args)
[242.524831] Subtest mmap-args: SKIP (0.000s)
[242.614798] [074/138] (779s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[242.965788] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[243.008369] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[243.100634] [075/138] (779s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[243.454126] Starting subtest: fbc-tiling-linear
[245.335871] Subtest fbc-tiling-linear: SUCCESS (1.935s)
[245.513080] [076/138] (777s left) gem_mmap_offset (open-flood)
[245.755475] Starting subtest: open-flood
[267.300822] Subtest open-flood: SUCCESS (21.559s)
[267.396677] [077/138] (755s left) kms_force_connector_basic (force-connector-state)
[267.659800] Subtest force-connector-state: SKIP (0.000s)
[267.747575] [078/138] (755s left) gem_exec_reloc (basic-gtt)
[267.998565] Starting subtest: basic-gtt
[268.019044] Subtest basic-gtt: SUCCESS (0.019s)
[268.200826] [079/138] (754s left) gem_ctx_persistence (legacy-engines-mixed-process)
[268.429494] Starting subtest: legacy-engines-mixed-process
[268.449636] Starting dynamic subtest: render
[268.792095] Dynamic subtest render: SUCCESS (0.368s)
[268.832486] Starting dynamic subtest: bsd
[269.127974] Dynamic subtest bsd: SUCCESS (0.346s)
[269.168725] Starting dynamic subtest: blt
[269.501652] Dynamic subtest blt: SUCCESS (0.365s)
[269.542086] Starting dynamic subtest: vebox
[269.849313] Dynamic subtest vebox: SUCCESS (0.352s)
[269.867921] Subtest legacy-engines-mixed-process: SUCCESS (1.443s)
[269.966985] [080/138] (753s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[270.337497] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[270.379302] Subtest fbcpsr-rgb101010-draw-pwrite: SKIP (0.000s)
[270.477537] [081/138] (752s left) kms_flip (flip-vs-fences-interruptible)
[270.781832] Starting subtest: flip-vs-fences-interruptible
[270.800817] Starting dynamic subtest: A-DP1
[281.843662] Dynamic subtest A-DP1: SUCCESS (10.862s)
[281.887347] Starting dynamic subtest: B-DP1
[292.450117] Dynamic subtest B-DP1: SUCCESS (10.781s)
[292.486914] Starting dynamic subtest: C-DP1
[303.196717] Dynamic subtest C-DP1: SUCCESS (10.748s)
[303.217749] Subtest flip-vs-fences-interruptible: SUCCESS (32.405s)
[303.652057] [082/138] (719s left) kms_addfb_basic (bad-pitch-999)
[303.887303] Starting subtest: bad-pitch-999
[303.908290] Subtest bad-pitch-999: SUCCESS (0.000s)
[304.076612] [083/138] (719s left) gem_exec_parallel (engines)
[304.312429] Starting subtest: engines
[304.331670] Starting dynamic subtest: basic
[307.645282] Dynamic subtest basic: SUCCESS (3.326s)
[307.682165] Starting dynamic subtest: contexts
[315.631699] Dynamic subtest contexts: SUCCESS (7.833s)
[315.669137] Starting dynamic subtest: fds
[324.652836] Dynamic subtest fds: SUCCESS (9.180s)
[324.690372] Starting dynamic subtest: userptr
[328.249897] Dynamic subtest userptr: SUCCESS (3.407s)
[328.269532] Subtest engines: SUCCESS (23.755s)
[328.374064] [084/138] (695s left) kms_ccs (pipe-d-crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[328.927505] Subtest pipe-D-crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[329.251958] [085/138] (694s left) gem_exec_whisper (basic-fds-priority)
[329.532604] Starting subtest: basic-fds-priority
[348.139400] Subtest basic-fds-priority: SUCCESS (18.636s)
[348.346275] [086/138] (675s left) kms_plane (plane-position-covered)
[348.648905] Starting subtest: plane-position-covered
[348.670737] Starting dynamic subtest: pipe-A
[350.144116] Dynamic subtest pipe-A: SUCCESS (1.481s)
[350.189869] Starting dynamic subtest: pipe-B
[351.851633] Dynamic subtest pipe-B: SUCCESS (1.688s)
[351.876531] Subtest plane-position-covered: SUCCESS (3.178s)
[352.214290] [087/138] (671s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[352.455821] Starting subtest: yf-tiled-ccs-to-x-tiled
[352.476156] Starting dynamic subtest: smem
[352.771357] Dynamic subtest smem: SUCCESS (0.319s)
[352.792237] Subtest yf-tiled-ccs-to-x-tiled: SUCCESS (0.321s)
[352.999917] [088/138] (670s left) gem_exec_schedule (semaphore-codependency)
[353.408711] Starting subtest: semaphore-codependency
[353.429052] Subtest semaphore-codependency: SUCCESS (0.020s)
[353.680907] [089/138] (670s left) gem_vm_create (invalid-destroy)
[353.922844] Starting subtest: invalid-destroy
[353.942086] Subtest invalid-destroy: SUCCESS (0.001s)
[354.030738] [090/138] (669s left) i915_pm_rpm (debugfs-read)
[355.802124] Starting subtest: debugfs-read
[358.897811] Subtest debugfs-read: SUCCESS (3.063s)
[359.328997] [091/138] (664s left) gem_exec_schedule (in-order)
[359.727697] Starting subtest: in-order
[359.748556] Starting dynamic subtest: rcs0
[359.767409] Dynamic subtest rcs0: SUCCESS (0.142s)
[359.807935] Starting dynamic subtest: bcs0
[359.852507] Dynamic subtest bcs0: SUCCESS (0.146s)
[359.896194] Starting dynamic subtest: vcs0
[359.986188] Dynamic subtest vcs0: SUCCESS (0.129s)
[360.030244] Starting dynamic subtest: vecs0
[360.115823] Dynamic subtest vecs0: SUCCESS (0.128s)
[360.134492] Subtest in-order: SUCCESS (0.557s)
[360.510384] [092/138] (663s left) gem_exec_fair (basic-flow)
[360.922030] Starting subtest: basic-flow
[360.942957] Starting dynamic subtest: rcs0
[365.743786] Dynamic subtest rcs0: SUCCESS (5.002s)
[365.765342] Subtest basic-flow: SUCCESS (5.004s)
[365.973283] [093/138] (658s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[366.506509] Subtest pipe-D-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[366.841183] [094/138] (657s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[367.200156] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[367.237114] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[367.335689] [095/138] (657s left) gem_mmap_wc (write-cpu-read-wc)
[367.568479] Starting subtest: write-cpu-read-wc
[367.824498] Subtest write-cpu-read-wc: SUCCESS (0.285s)
[367.936105] [096/138] (656s left) dumb_buffer (create-valid-dumb)
[368.175469] Starting subtest: create-valid-dumb
[368.194670] Subtest create-valid-dumb: SUCCESS (0.000s)
[368.286378] [097/138] (656s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[368.666100] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[368.703776] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[368.801429] [098/138] (655s left) vc4/vc4_dmabuf_poll (poll-write-waits-until-write-done)
[369.069086] Subtest poll-write-waits-until-write-done: SKIP (0.000s)
[369.162509] [099/138] (655s left) kms_properties (invalid-properties-legacy)
[369.462064] Starting subtest: invalid-properties-legacy
[369.583044] Subtest invalid-properties-legacy: SUCCESS (0.132s)
[369.707685] [100/138] (655s left) gem_lmem_swapping (heavy-verify-multi)
[369.964846] Subtest heavy-verify-multi: SKIP (0.000s)
[370.055083] [101/138] (654s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[370.354920] Starting subtest: 2x-long-cursor-vs-flip-atomic
[370.394780] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.004s)
[370.492970] [102/138] (654s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[370.836966] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[370.877771] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[370.975298] [103/138] (654s left) vc4/vc4_perfmon (create-two-perfmon)
[371.259139] Subtest create-two-perfmon: SKIP (0.000s)
[371.347199] [104/138] (653s left) gem_readwrite (new-obj)
[371.577574] Starting subtest: new-obj
[371.615371] Subtest new-obj: SUCCESS (0.001s)
[371.708854] [105/138] (653s left) kms_busy (basic)
[372.032515] Starting subtest: basic
[372.051238] Starting dynamic subtest: flip
[372.679118] Dynamic subtest flip: SUCCESS (0.632s)
[372.726045] Starting dynamic subtest: modeset
[374.103191] Dynamic subtest modeset: SUCCESS (1.434s)
[374.134488] Subtest basic: SUCCESS (2.074s)
[374.478842] [106/138] (650s left) syncobj_timeline (signal-point-0)
[374.991388] Starting subtest: signal-point-0
[375.016543] Subtest signal-point-0: SUCCESS (0.000s)
[375.124174] [107/138] (650s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[378.104725] Subtest protected-encrypted-src-copy-not-readible: SKIP (0.000s)
[378.266845] [108/138] (647s left) gem_eio (in-flight-immediate)
[378.590919] Starting subtest: in-flight-immediate
[379.423415] Subtest in-flight-immediate: SUCCESS (0.908s)
[379.642598] [109/138] (646s left) syncobj_wait (wait-delayed-signal)
[379.868730] Starting subtest: wait-delayed-signal
[379.932975] Subtest wait-delayed-signal: SUCCESS (0.103s)
[380.049378] [110/138] (645s left) debugfs_test (read_all_entries)
[380.283153] Starting subtest: read_all_entries
[380.535984] Subtest read_all_entries: SUCCESS (0.259s)
[380.731412] [111/138] (645s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[381.083723] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[381.120726] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[381.219078] [112/138] (644s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[381.649973] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[381.955664] [113/138] (644s left) gem_mmap_gtt (basic-write-gtt)
[382.196463] Starting subtest: basic-write-gtt
[382.905570] Subtest basic-write-gtt: SUCCESS (0.749s)
[383.055359] [114/138] (643s left) i915_pm_sseu (full-enable)
[383.781778] Starting subtest: full-enable
[383.802571] Subtest full-enable: SUCCESS (0.019s)
[383.918562] [115/138] (642s left) kms_ccs (pipe-d-bad-aux-stride-yf-tiled-ccs)
[384.494671] Subtest pipe-D-bad-aux-stride-yf-tiled-ccs: SKIP (0.000s)
[384.826336] [116/138] (641s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[385.415676] Starting subtest: pipe-B-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[385.454624] Subtest pipe-B-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[385.843714] [117/138] (640s left) prime_busy (after-wait)
[386.089526] Starting subtest: after-wait
[386.108816] Starting dynamic subtest: rcs0
[386.128101] Dynamic subtest rcs0: SUCCESS (0.013s)
[386.168377] Starting dynamic subtest: bcs0
[386.190051] Dynamic subtest bcs0: SUCCESS (0.013s)
[386.230523] Starting dynamic subtest: vcs0
[386.251757] Dynamic subtest vcs0: SUCCESS (0.016s)
[386.293955] Starting dynamic subtest: vecs0
[386.313325] Dynamic subtest vecs0: SUCCESS (0.027s)
[386.332331] Subtest after-wait: SUCCESS (0.214s)
[386.426459] [118/138] (640s left) gem_request_retire (retire-vma-not-inactive)
[386.652478] Starting subtest: retire-vma-not-inactive
[386.673845] Subtest retire-vma-not-inactive: SUCCESS (0.031s)
[386.820631] [119/138] (639s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[387.155620] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[387.245949] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.031s)
[387.338946] [120/138] (639s left) testdisplay
[411.121484] [121/138] (615s left) core_getclient
[411.478543] [122/138] (615s left) prime_mmap (test_dup)
[411.740642] Starting subtest: test_dup
[411.762817] Starting dynamic subtest: test_dup-smem
[411.788365] Dynamic subtest test_dup-smem: SUCCESS (0.006s)
[411.813364] Subtest test_dup: SUCCESS (0.009s)
[411.922079] [123/138] (615s left) kms_setmode (invalid-clone-single-crtc-stealing)
[412.174754] Starting subtest: invalid-clone-single-crtc-stealing
[412.242961] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[412.357341] [124/138] (614s left) kms_flip (modeset-vs-vblank-race-interruptible)
[412.712148] Starting subtest: modeset-vs-vblank-race-interruptible
[412.741544] Starting dynamic subtest: A-DP1
[417.029657] Dynamic subtest A-DP1: SUCCESS (4.353s)
[417.069984] Starting dynamic subtest: B-DP1
[421.363534] Dynamic subtest B-DP1: SUCCESS (4.335s)
[421.401989] Starting dynamic subtest: C-DP1
[425.698572] Dynamic subtest C-DP1: SUCCESS (4.322s)
[425.727752] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (13.024s)
[426.144497] [125/138] (601s left) i915_suspend (fence-restore-untiled)
[426.396215] Starting subtest: fence-restore-untiled
[445.856821] Subtest fence-restore-untiled: SUCCESS (4.543s)
[451.201572] [126/138] (596s left) perf (global-sseu-config)
[451.615427] Starting subtest: global-sseu-config
[451.636778] Starting dynamic subtest: 0-rcs0
[451.713261] Dynamic subtest 0-rcs0: SUCCESS (0.125s)
[451.732221] Subtest global-sseu-config: SUCCESS (0.128s)
[451.831401] [127/138] (595s left) dmabuf_sync_file (import-multiple-read-only)
[452.048745] Starting subtest: import-multiple-read-only
[452.067820] Subtest import-multiple-read-only: SUCCESS (0.012s)
[452.169813] [128/138] (595s left) gem_spin_batch (legacy)
[452.407160] Starting subtest: legacy
[452.429062] Starting dynamic subtest: default
[455.917414] Dynamic subtest default: SUCCESS (3.323s)
[455.961980] Starting dynamic subtest: render
[459.247309] Dynamic subtest render: SUCCESS (3.322s)
[459.290322] Starting dynamic subtest: bsd
[462.565170] Dynamic subtest bsd: SUCCESS (3.320s)
[462.609236] Starting dynamic subtest: bsd1
[465.902245] Dynamic subtest bsd1: SUCCESS (3.320s)
[465.943982] Starting dynamic subtest: blt
[469.230129] Dynamic subtest blt: SUCCESS (3.323s)
[469.273121] Starting dynamic subtest: vebox
[472.541785] Dynamic subtest vebox: SUCCESS (3.321s)
[472.560501] Subtest legacy: SUCCESS (19.948s)
[472.664870] [129/138] (575s left) kms_sequence (get-forked-busy)
[472.971481] Starting subtest: get-forked-busy
[472.992336] Starting dynamic subtest: pipe-A-DP-1
[475.439793] Dynamic subtest pipe-A-DP-1: SUCCESS (2.455s)
[475.482233] Starting dynamic subtest: pipe-B-DP-1
[478.076427] Dynamic subtest pipe-B-DP-1: SUCCESS (2.644s)
[478.131084] Starting dynamic subtest: pipe-C-DP-1
[480.772274] Dynamic subtest pipe-C-DP-1: SUCCESS (2.680s)
[480.793957] Subtest get-forked-busy: SUCCESS (7.793s)
[481.092889] [130/138] (566s left) tools_test (sysfs_l3_parity)
[481.448386] Starting subtest: sysfs_l3_parity
[481.548424] Subtest sysfs_l3_parity: SKIP (0.211s)
[481.649168] [131/138] (566s left) sysfs_preempt_timeout (idempotent)
[481.883748] Starting subtest: idempotent
[481.904921] Starting dynamic subtest: vecs0
[481.926243] Dynamic subtest vecs0: SUCCESS (0.002s)
[481.968371] Starting dynamic subtest: vcs0
[481.987311] Dynamic subtest vcs0: SUCCESS (0.002s)
[482.029115] Starting dynamic subtest: bcs0
[482.047857] Dynamic subtest bcs0: SUCCESS (0.002s)
[482.092117] Starting dynamic subtest: rcs0
[482.113548] Dynamic subtest rcs0: SUCCESS (0.002s)
[482.134237] Subtest idempotent: SUCCESS (0.020s)
[482.230601] [132/138] (565s left) perf_pmu (init-busy)
[482.452987] Starting subtest: init-busy
[482.473807] Starting dynamic subtest: rcs0
[482.492869] Dynamic subtest rcs0: SUCCESS (0.002s)
[482.534489] Starting dynamic subtest: bcs0
[482.553381] Dynamic subtest bcs0: SUCCESS (0.002s)
[482.595137] Starting dynamic subtest: vcs0
[482.616732] Dynamic subtest vcs0: SUCCESS (0.001s)
[482.661880] Starting dynamic subtest: vecs0
[482.683098] Dynamic subtest vecs0: SUCCESS (0.001s)
[482.703730] Subtest init-busy: SUCCESS (0.017s)
[482.816205] [133/138] (565s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[483.202999] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[485.357565] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SUCCESS (2.235s)
[485.520992] [134/138] (562s left) kms_vblank (wait-forked-hang)
[485.828365] Starting subtest: wait-forked-hang
[485.848506] Starting dynamic subtest: pipe-A-DP-1
[493.078376] Dynamic subtest pipe-A-DP-1: SUCCESS (7.146s)
[493.124970] Starting dynamic subtest: pipe-C-DP-1
[500.044788] Dynamic subtest pipe-C-DP-1: SUCCESS (6.957s)
[500.066394] Subtest wait-forked-hang: SUCCESS (14.117s)
[500.313343] [135/138] (548s left) v3d/v3d_submit_cl (bad-multisync-out-sync)
[500.616438] Subtest bad-multisync-out-sync: SKIP (0.000s)
[500.714450] [136/138] (547s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[501.072454] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[501.115010] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[501.213151] [137/138] (547s left) debugfs_test (sysfs)
[501.444665] Starting subtest: sysfs
[501.752518] Subtest sysfs: SUCCESS (0.331s)
[501.962441] [138/138] (546s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[502.188621] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[502.274249] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.108s)
[502.371495] Closing watchdogs
Done.