[32.065549] Initializing watchdogs
[32.065611]   /dev/watchdog0
[32.070023] [001/142] (960s left) prime_mmap (test_errors)
[32.123319] Starting subtest: test_errors
[32.124052] Starting dynamic subtest: test_errors-smem
[32.126934] Dynamic subtest test_errors-smem: SUCCESS (0.005s)
[32.127650] Subtest test_errors: SUCCESS (0.005s)
[32.175589] [002/142] (960s left) kms_flip (plain-flip-ts-check-interruptible)
[32.264950] Starting subtest: plain-flip-ts-check-interruptible
[32.268367] Starting dynamic subtest: A-HDMI-A1
[40.128861] Dynamic subtest A-HDMI-A1: SUCCESS (7.860s)
[40.132713] Starting dynamic subtest: B-HDMI-A1
[47.898625] Dynamic subtest B-HDMI-A1: SUCCESS (7.768s)
[47.901854] Starting dynamic subtest: C-HDMI-A1
[55.687613] Dynamic subtest C-HDMI-A1: SUCCESS (7.762s)
[55.690787] Starting dynamic subtest: D-HDMI-A1
[63.424445] Dynamic subtest D-HDMI-A1: SUCCESS (7.761s)
[63.425282] Subtest plain-flip-ts-check-interruptible: SUCCESS (31.159s)
[63.575278] [003/142] (929s left) kms_addfb_basic (small-bo)
[63.688074] Starting subtest: small-bo
[63.688843] Subtest small-bo: SUCCESS (0.000s)
[63.749762] [004/142] (928s left) v3d/v3d_wait_bo (bad-bo)
[63.820945] Subtest bad-bo: SKIP (0.000s)
[63.847698] [005/142] (928s left) gem_exec_schedule (preempt-self)
[63.906184] Starting subtest: preempt-self
[63.906901] Starting dynamic subtest: rcs0
[63.919071] Dynamic subtest rcs0: SUCCESS (0.013s)
[63.923244] Starting dynamic subtest: bcs0
[63.928149] Dynamic subtest bcs0: SUCCESS (0.009s)
[63.932202] Starting dynamic subtest: vcs0
[63.937891] Dynamic subtest vcs0: SUCCESS (0.009s)
[63.941685] Starting dynamic subtest: vcs1
[63.948072] Dynamic subtest vcs1: SUCCESS (0.010s)
[63.951860] Starting dynamic subtest: vecs0
[63.957020] Dynamic subtest vecs0: SUCCESS (0.009s)
[63.957825] Subtest preempt-self: SUCCESS (0.051s)
[64.223548] [006/142] (928s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[64.336477] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[65.379180] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SUCCESS (1.044s)
[65.472031] [007/142] (927s left) prime_vgem (fence-write-hang)
[65.572285] Subtest fence-write-hang: SKIP (0.000s)
[65.629545] [008/142] (927s left) gem_sync (basic-all)
[65.696441] Starting subtest: basic-all
[67.993172] Subtest basic-all: SUCCESS (2.297s)
[68.149378] [009/142] (924s left) kms_ccs (pipe-c-bad-pixel-format-4_tiled_mtl_mc_ccs)
[68.425440] Starting subtest: pipe-C-bad-pixel-format-4_tiled_mtl_mc_ccs
[68.426938] Subtest pipe-C-bad-pixel-format-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[68.648707] [010/142] (924s left) syncobj_timeline (single-wait-available-submitted)
[68.695745] Starting subtest: single-wait-available-submitted
[68.696539] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[68.732067] [011/142] (923s left) gem_ctx_persistence (legacy-engines-hostile)
[68.781465] Starting subtest: legacy-engines-hostile
[68.782391] Starting dynamic subtest: render
[68.862525] Dynamic subtest render: SUCCESS (0.080s)
[68.869242] Starting dynamic subtest: bsd1
[68.944556] Dynamic subtest bsd1: SUCCESS (0.081s)
[68.952126] Starting dynamic subtest: bsd2
[69.026552] Dynamic subtest bsd2: SUCCESS (0.082s)
[69.033752] Starting dynamic subtest: blt
[69.108560] Dynamic subtest blt: SUCCESS (0.081s)
[69.115633] Starting dynamic subtest: vebox
[69.194551] Dynamic subtest vebox: SUCCESS (0.086s)
[69.195521] Subtest legacy-engines-hostile: SUCCESS (0.413s)
[69.238337] [012/142] (923s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[69.344745] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[69.346124] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[69.390384] [013/142] (923s left) i915_pm_rpm (gem-idle)
[70.910582] Starting subtest: gem-idle
[76.432033] Subtest gem-idle: SUCCESS (5.522s)
[76.569914] [014/142] (916s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[76.665915] Starting subtest: disable-crc-after-crtc
[76.667416] Starting dynamic subtest: pipe-A-HDMI-A-1
[76.969282] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.302s)
[76.974795] Starting dynamic subtest: pipe-B-HDMI-A-1
[77.253423] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.283s)
[77.259420] Starting dynamic subtest: pipe-C-HDMI-A-1
[77.527428] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.271s)
[77.531862] Starting dynamic subtest: pipe-D-HDMI-A-1
[77.819767] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.291s)
[77.820492] Subtest disable-crc-after-crtc: SUCCESS (1.154s)
[77.904775] [015/142] (914s left) i915_query (test-query-geometry-subslices)
[77.954025] Starting subtest: test-query-geometry-subslices
[77.955436] Subtest test-query-geometry-subslices: SKIP (0.000s)
[77.987594] [016/142] (914s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[78.083726] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[78.084417] Starting dynamic subtest: pipe-A-valid-mode
[78.135089] Dynamic subtest pipe-A-valid-mode: SKIP (0.050s)
[78.136462] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.051s)
[78.204646] [017/142] (914s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[78.306913] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[78.308376] Subtest fbcpsr-rgb565-draw-mmap-wc: SKIP (0.000s)
[78.354799] [018/142] (914s left) kms_plane_scaling (plane-downscale-with-modifiers-factor-0-25)
[78.457669] Starting subtest: plane-downscale-with-modifiers-factor-0-25
[78.458415] Starting dynamic subtest: pipe-A-HDMI-A-1
[78.468121] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.013s)
[78.472228] Starting dynamic subtest: pipe-B-HDMI-A-1
[78.495459] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.026s)
[78.499517] Starting dynamic subtest: pipe-C-HDMI-A-1
[78.523626] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.026s)
[78.527276] Starting dynamic subtest: pipe-D-HDMI-A-1
[78.552346] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.027s)
[78.553822] Subtest plane-downscale-with-modifiers-factor-0-25: SKIP (0.099s)
[78.612862] [019/142] (914s left) gem_exec_whisper (basic-queues-priority)
[78.666457] Starting subtest: basic-queues-priority
[83.078679] Subtest basic-queues-priority: SUCCESS (4.403s)
[83.219871] [020/142] (909s left) kms_ccs (pipe-d-bad-pixel-format-y_tiled_gen12_rc_ccs)
[83.584489] Starting subtest: pipe-D-bad-pixel-format-y_tiled_gen12_rc_ccs
[83.585316] Subtest pipe-D-bad-pixel-format-y_tiled_gen12_rc_ccs: SUCCESS (0.000s)
[83.733128] [021/142] (909s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[83.780927] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[83.884286] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.103s)
[83.923193] [022/142] (908s left) kms_ccs (pipe-b-crc-primary-basic-y_tiled_gen12_rc_ccs)
[84.144467] Starting subtest: pipe-B-crc-primary-basic-y_tiled_gen12_rc_ccs
[84.341881] Subtest pipe-B-crc-primary-basic-y_tiled_gen12_rc_ccs: SUCCESS (0.198s)
[84.675353] [023/142] (908s left) gem_exec_schedule (u-semaphore-resolve)
[84.732332] Starting subtest: u-semaphore-resolve
[84.747569] Subtest u-semaphore-resolve: SUCCESS (0.015s)
[84.991538] [024/142] (907s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[85.091686] Starting subtest: fbc-farfromfence-mmap-gtt
[86.278877] Subtest fbc-farfromfence-mmap-gtt: SUCCESS (1.189s)
[86.355415] [025/142] (906s left) gem_exec_flush (basic-uc-ro-default)
[86.409752] Starting subtest: basic-uc-ro-default
[91.847054] Subtest basic-uc-ro-default: SUCCESS (5.437s)
[92.002967] [026/142] (900s left) kms_cursor_crc (cursor-random-512x512)
[92.119454] Starting subtest: cursor-random-512x512
[92.121873] Subtest cursor-random-512x512: SKIP (0.001s)
[92.176075] [027/142] (900s left) kms_ccs (pipe-c-bad-pixel-format-4_tiled_dg2_mc_ccs)
[92.455199] Starting subtest: pipe-C-bad-pixel-format-4_tiled_dg2_mc_ccs
[92.456798] Subtest pipe-C-bad-pixel-format-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[92.687138] [028/142] (900s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[92.787612] Starting subtest: psr-shrfb-scaledprimary
[92.788976] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[92.844390] [029/142] (900s left) kms_vblank (pipe-a-ts-continuation-modeset-hang)
[92.942873] Starting subtest: pipe-A-ts-continuation-modeset-hang
[106.982667] Subtest pipe-A-ts-continuation-modeset-hang: SUCCESS (14.040s)
[107.082338] [030/142] (885s left) kms_lease (implicit-plane-lease)
[107.179740] Starting subtest: implicit-plane-lease
[107.181466] Subtest implicit-plane-lease: SUCCESS (0.001s)
[107.215833] [031/142] (885s left) kms_busy (basic)
[107.314650] Starting subtest: basic
[107.316260] Starting dynamic subtest: flip
[107.627195] Dynamic subtest flip: SUCCESS (0.311s)
[107.632019] Starting dynamic subtest: modeset
[108.091852] Dynamic subtest modeset: SUCCESS (0.464s)
[108.092614] Subtest basic: SUCCESS (0.778s)
[108.201266] [032/142] (884s left) kms_properties (get_properties-sanity-atomic)
[108.311884] Starting subtest: get_properties-sanity-atomic
[108.318992] Subtest get_properties-sanity-atomic: SUCCESS (0.008s)
[108.363544] [033/142] (884s left) kms_vblank (pipe-a-query-forked-hang)
[108.461173] Starting subtest: pipe-A-query-forked-hang
[121.830438] Subtest pipe-A-query-forked-hang: SUCCESS (13.369s)
[121.931276] [034/142] (871s left) gem_exec_reloc (basic-gtt-active)
[121.985139] Starting subtest: basic-gtt-active
[122.105031] Subtest basic-gtt-active: SUCCESS (0.111s)
[122.185127] [035/142] (870s left) gem_exec_whisper (basic-sync-all)
[122.238637] Starting subtest: basic-sync-all
[124.468600] Subtest basic-sync-all: SUCCESS (2.229s)
[124.626028] [036/142] (868s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[124.729971] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[124.731368] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[124.776639] [037/142] (868s left) kms_cursor_edge_walk (128x128-top-bottom)
[124.873280] Starting subtest: 128x128-top-bottom
[124.874933] Starting dynamic subtest: pipe-A-HDMI-A-1
[126.613423] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.739s)
[126.620127] Starting dynamic subtest: pipe-D-HDMI-A-1
[128.287690] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.670s)
[128.288459] Subtest 128x128-top-bottom: SUCCESS (3.414s)
[128.366894] [038/142] (864s left) kms_atomic_transition (plane-all-transition-fencing)
[128.463202] Starting subtest: plane-all-transition-fencing
[128.464790] Starting dynamic subtest: pipe-A-HDMI-A-1
[130.387264] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.923s)
[130.453729] Starting dynamic subtest: pipe-B-HDMI-A-1
[132.455045] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.006s)
[132.496894] Subtest plane-all-transition-fencing: SUCCESS (4.033s)
[132.587493] [039/142] (860s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[132.639780] Starting subtest: multi-wait-for-submit-available-submitted
[132.640530] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[132.679148] [040/142] (860s left) gem_render_copy (yf-tiled)
[132.731186] Starting subtest: yf-tiled
[132.731998] Starting dynamic subtest: smem
[132.800339] Dynamic subtest smem: SUCCESS (0.069s)
[132.801238] Subtest yf-tiled: SUCCESS (0.069s)
[132.937830] [041/142] (860s left) kms_ccs (pipe-a-ccs-on-another-bo-4_tiled_mtl_mc_ccs)
[133.129645] Starting subtest: pipe-A-ccs-on-another-bo-4_tiled_mtl_mc_ccs
[133.131425] Subtest pipe-A-ccs-on-another-bo-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[133.464825] [042/142] (859s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[133.566485] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[134.684122] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (1.118s)
[134.772838] [043/142] (858s left) syncobj_wait (wait-all-for-submit-complex)
[134.825685] Starting subtest: wait-all-for-submit-complex
[135.048374] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[135.105103] [044/142] (857s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[135.255069] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[135.324077] [045/142] (857s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[135.372248] Starting subtest: invalid-multi-wait-unsubmitted
[135.373054] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[135.410664] [046/142] (857s left) syncobj_basic (bad-pad-fd-to-handle)
[135.461874] Starting subtest: bad-pad-fd-to-handle
[135.462594] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[135.505232] [047/142] (857s left) gem_ringfill (legacy-basic)
[135.712777] Starting subtest: legacy-basic
[135.713536] Starting dynamic subtest: default
[135.741090] Dynamic subtest default: SUCCESS (0.028s)
[135.746417] Starting dynamic subtest: render
[135.759037] Dynamic subtest render: SUCCESS (0.017s)
[135.764688] Starting dynamic subtest: bsd
[135.777178] Dynamic subtest bsd: SUCCESS (0.017s)
[135.783230] Starting dynamic subtest: bsd1
[135.794112] Dynamic subtest bsd1: SUCCESS (0.016s)
[135.799476] Starting dynamic subtest: bsd2
[135.818507] Dynamic subtest bsd2: SUCCESS (0.013s)
[135.824039] Starting dynamic subtest: blt
[135.824856] Dynamic subtest blt: SUCCESS (0.012s)
[135.830256] Starting dynamic subtest: vebox
[135.834038] Dynamic subtest vebox: SUCCESS (0.012s)
[135.834787] Subtest legacy-basic: SUCCESS (0.122s)
[135.869364] [048/142] (857s left) gem_ctx_persistence (many-contexts)
[135.922451] Starting subtest: many-contexts
[171.213361] Subtest many-contexts: SUCCESS (35.282s)
[171.255650] [049/142] (821s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_dg2_rc_ccs_cc)
[171.420453] Starting subtest: pipe-A-crc-primary-basic-4_tiled_dg2_rc_ccs_cc
[171.421975] Subtest pipe-A-crc-primary-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[171.772300] [050/142] (821s left) v3d/v3d_perfmon (destroy-invalid-perfmon)
[171.842764] Subtest destroy-invalid-perfmon: SKIP (0.000s)
[171.871923] [051/142] (821s left) vc4/vc4_wait_bo (bad-pad)
[171.959658] Subtest bad-pad: SKIP (0.000s)
[171.989213] [052/142] (821s left) kms_writeback (writeback-check-output)
[172.140569] Subtest writeback-check-output: SKIP (0.000s)
[172.158553] [053/142] (821s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[172.274266] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[172.884237] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.610s)
[172.958823] [054/142] (820s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs)
[173.316097] Starting subtest: pipe-C-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs
[173.318952] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs: SKIP (0.002s)
[173.480377] [055/142] (819s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[173.582233] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[174.808906] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (1.228s)
[174.897657] [056/142] (818s left) gem_eio (in-flight-contexts-immediate)
[174.963106] Starting subtest: in-flight-contexts-immediate
[188.229814] Subtest in-flight-contexts-immediate: SUCCESS (13.265s)
[188.308771] [057/142] (804s left) gem_caching (writes)
[188.362995] Starting subtest: writes
[197.140211] Subtest writes: SUCCESS (8.778s)
[197.204319] [058/142] (796s left) kms_content_protection (dp-mst-type-1)
[197.316177] Starting subtest: dp-mst-type-1
[197.317811] Subtest dp-mst-type-1: SKIP (0.000s)
[197.368134] [059/142] (795s left) gem_mmap_wc (write-wc-read-gtt)
[197.415603] Starting subtest: write-wc-read-gtt
[197.728877] Subtest write-wc-read-gtt: SUCCESS (0.304s)
[197.771186] [060/142] (795s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[197.819925] Starting subtest: write-cpu-read-wc-unflushed
[197.895696] Subtest write-cpu-read-wc-unflushed: SUCCESS (0.077s)
[197.954730] [061/142] (795s left) kms_vblank (pipe-a-accuracy-idle)
[198.058483] Starting subtest: pipe-A-accuracy-idle
[199.201751] Subtest pipe-A-accuracy-idle: SUCCESS (1.143s)
[199.296601] [062/142] (794s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[199.398680] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[199.400103] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[199.455404] [063/142] (793s left) kms_chamelium_edid (dp-edid-resolution-list)
[199.610538] Subtest dp-edid-resolution-list: SKIP (0.000s)
[199.669726] [064/142] (793s left) gem_exec_reloc (basic-cpu-wc-active)
[199.719837] Starting subtest: basic-cpu-wc-active
[199.839856] Subtest basic-cpu-wc-active: SUCCESS (0.111s)
[199.916503] [065/142] (793s left) syncobj_wait (wait-any-snapshot)
[199.964578] Starting subtest: wait-any-snapshot
[200.045215] Subtest wait-any-snapshot: SUCCESS (0.081s)
[200.090037] [066/142] (793s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[200.199772] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[200.201217] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[200.257261] [067/142] (793s left) kms_vblank (pipe-b-wait-busy-hang)
[200.352581] Starting subtest: pipe-B-wait-busy-hang
[213.982214] Subtest pipe-B-wait-busy-hang: SUCCESS (13.630s)
[214.096921] [068/142] (779s left) syncobj_timeline (invalid-wait-zero-handles)
[214.146168] Starting subtest: invalid-wait-zero-handles
[214.147026] Subtest invalid-wait-zero-handles: SUCCESS (0.000s)
[214.181616] [069/142] (779s left) v3d/v3d_job_submission (threaded-job-submission)
[214.249949] Subtest threaded-job-submission: SKIP (0.000s)
[214.279956] [070/142] (779s left) syncobj_wait (invalid-reset-illegal-handle)
[214.335384] Starting subtest: invalid-reset-illegal-handle
[214.336191] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[214.371187] [071/142] (779s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[214.474585] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[214.475371] Starting dynamic subtest: pipe-A-valid-mode
[215.198469] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.723s)
[215.199262] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SUCCESS (0.724s)
[215.305078] [072/142] (778s left) gem_exec_fair (basic-pace)
[215.365180] Starting subtest: basic-pace
[215.365933] Starting dynamic subtest: rcs0
[219.800917] Dynamic subtest rcs0: FAIL (4.419s)
[219.805279] Starting dynamic subtest: bcs0
[224.215561] Dynamic subtest bcs0: FAIL (4.403s)
[224.220155] Starting dynamic subtest: vcs0
[228.612580] Dynamic subtest vcs0: FAIL (4.396s)
[228.621735] Starting dynamic subtest: vcs1
[233.014679] Dynamic subtest vcs1: FAIL (4.401s)
[233.018949] Starting dynamic subtest: vecs0
[237.425540] Dynamic subtest vecs0: FAIL (4.401s)
[237.426548] Subtest basic-pace: FAIL (22.024s)
[237.541439] [073/142] (755s left) kms_psr2_sf (cursor-plane-move-continuous-exceed-fully-sf)
[237.601164] Subtest cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[237.624828] [074/142] (755s left) kms_atomic (test-only)
[237.774374] Starting subtest: test-only
[238.063715] Subtest test-only: SUCCESS (0.289s)
[238.146906] [075/142] (755s left) kms_psr2_su (page_flip-xrgb8888)
[238.194758] Subtest page_flip-XRGB8888: SKIP (0.000s)
[238.214213] [076/142] (755s left) i915_pm_backlight (basic-brightness)
[238.311482] Subtest basic-brightness: SKIP (0.000s)
[238.330609] [077/142] (755s left) kms_plane (pixel-format)
[238.427520] Starting subtest: pixel-format
[238.429413] Starting dynamic subtest: pipe-A-planes
[246.457397] Dynamic subtest pipe-A-planes: SUCCESS (8.028s)
[246.466598] Starting dynamic subtest: pipe-B-planes
[254.395783] Dynamic subtest pipe-B-planes: SUCCESS (7.935s)
[254.396579] Subtest pixel-format: SUCCESS (15.969s)
[254.499843] [078/142] (739s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[254.553236] Starting subtest: writes-after-reads-uncached
[266.195287] Subtest writes-after-reads-uncached: SUCCESS (11.642s)
[266.265272] [079/142] (727s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[266.379496] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[266.380955] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[266.428439] [080/142] (727s left) gem_create (busy-create)
[266.483027] Starting subtest: busy-create
[266.483759] Starting dynamic subtest: smem0
[298.727399] Dynamic subtest smem0: SUCCESS (32.245s)
[298.728461] Subtest busy-create: SUCCESS (32.246s)
[298.882332] [081/142] (694s left) kms_setmode (clone-exclusive-crtc)
[298.937501] Starting subtest: clone-exclusive-crtc
[298.939605] Subtest clone-exclusive-crtc: SKIP (0.001s)
[298.977579] [082/142] (694s left) gem_pxp (create-regular-buffer)
[301.582518] Subtest create-regular-buffer: SKIP (0.000s)
[301.597288] [083/142] (692s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[301.701637] Starting subtest: fbc-modesetfrombusy
[302.308971] Subtest fbc-modesetfrombusy: SUCCESS (0.610s)
[302.373115] [084/142] (691s left) gem_cs_tlb (engines)
[302.425013] Starting subtest: engines
[302.425735] Starting dynamic subtest: rcs0
[304.585290] Dynamic subtest rcs0: SUCCESS (2.151s)
[304.589985] Starting dynamic subtest: bcs0
[306.736724] Dynamic subtest bcs0: SUCCESS (2.151s)
[306.741501] Starting dynamic subtest: vcs0
[308.888043] Dynamic subtest vcs0: SUCCESS (2.151s)
[308.892716] Starting dynamic subtest: vcs1
[311.040104] Dynamic subtest vcs1: SUCCESS (2.151s)
[311.046274] Starting dynamic subtest: vecs0
[313.182767] Dynamic subtest vecs0: SUCCESS (2.151s)
[313.183480] Subtest engines: SUCCESS (10.758s)
[313.263830] [085/142] (680s left) kms_rotation_crc (primary-rotation-180)
[313.370503] Starting subtest: primary-rotation-180
[316.889593] Subtest primary-rotation-180: SUCCESS (3.519s)
[317.032091] [086/142] (676s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[317.134785] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[317.136233] Subtest psr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[317.190847] [087/142] (676s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[317.293377] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[317.294824] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[317.340805] [088/142] (676s left) gem_render_copy (y-tiled-ccs-to-linear)
[317.391559] Starting subtest: y-tiled-ccs-to-linear
[317.392327] Starting dynamic subtest: smem
[317.463302] Dynamic subtest smem: SUCCESS (0.071s)
[317.464083] Subtest y-tiled-ccs-to-linear: SUCCESS (0.072s)
[317.615722] [089/142] (676s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[317.725772] Starting subtest: yf-tiled-32bpp-rotate-270
[317.727184] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[317.782544] [090/142] (675s left) kms_big_joiner (basic)
[317.879978] Subtest basic: SKIP (0.000s)
[317.900185] [091/142] (675s left) kms_ccs (pipe-d-ccs-on-another-bo-y_tiled_ccs)
[318.304862] Starting subtest: pipe-D-ccs-on-another-bo-y_tiled_ccs
[318.306372] Subtest pipe-D-ccs-on-another-bo-y_tiled_ccs: SKIP (0.000s)
[318.401547] [092/142] (675s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[318.447993] Starting subtest: addfb25-x-tiled-mismatch-legacy
[318.448771] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[318.543451] [093/142] (675s left) perf_pmu (cpu-hotplug)
[318.593048] Starting subtest: cpu-hotplug
[327.622613] Subtest cpu-hotplug: SUCCESS (9.021s)
[327.677516] [094/142] (666s left) gem_mmap_gtt (basic-read)
[327.732765] Starting subtest: basic-read
[327.747883] Subtest basic-read: SUCCESS (0.016s)
[327.797091] [095/142] (665s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu)
[327.901189] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu
[327.902603] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[327.961417] [096/142] (665s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[328.061010] Starting subtest: primary-4-tiled-reflect-x-180
[328.114300] Subtest primary-4-tiled-reflect-x-180: SKIP (0.053s)
[328.163007] [097/142] (665s left) gem_exec_fence (syncobj-channel)
[328.477486] Starting subtest: syncobj-channel
[329.503031] Subtest syncobj-channel: SUCCESS (1.016s)
[329.765565] [098/142] (664s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[329.870405] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[329.872149] Starting dynamic subtest: pipe-A-HDMI-A-1
[329.996216] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.125s)
[330.002634] Starting dynamic subtest: pipe-B-HDMI-A-1
[330.112675] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.114s)
[330.119175] Starting dynamic subtest: pipe-C-HDMI-A-1
[330.245337] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.131s)
[330.252033] Starting dynamic subtest: pipe-D-HDMI-A-1
[330.361311] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.114s)
[330.362048] Subtest planes-unity-scaling-downscale-factor-0-5: SUCCESS (0.492s)
[330.508412] [099/142] (663s left) perf_pmu (most-busy-idle-check-all)
[330.558322] Starting subtest: most-busy-idle-check-all
[330.559040] Starting dynamic subtest: rcs0
[331.173698] Dynamic subtest rcs0: SUCCESS (0.612s)
[331.179173] Starting dynamic subtest: bcs0
[331.786190] Dynamic subtest bcs0: SUCCESS (0.613s)
[331.793481] Starting dynamic subtest: vcs0
[332.402289] Dynamic subtest vcs0: SUCCESS (0.616s)
[332.409741] Starting dynamic subtest: vcs1
[333.016208] Dynamic subtest vcs1: SUCCESS (0.613s)
[333.024755] Starting dynamic subtest: vecs0
[333.633814] Dynamic subtest vecs0: SUCCESS (0.616s)
[333.634982] Subtest most-busy-idle-check-all: SUCCESS (3.075s)
[333.680786] [100/142] (660s left) kms_universal_plane (universal-plane-pageflip-windowed-pipe-b)
[333.781455] Starting subtest: universal-plane-pageflip-windowed-pipe-B
[334.128030] Subtest universal-plane-pageflip-windowed-pipe-B: SUCCESS (0.347s)
[334.200592] [101/142] (659s left) perf_pmu (faulting-read)
[334.249308] Starting subtest: faulting-read
[334.250104] Starting dynamic subtest: gtt
[334.250853] Dynamic subtest gtt: SUCCESS (0.001s)
[334.255987] Starting dynamic subtest: wb
[334.256765] Dynamic subtest wb: SUCCESS (0.000s)
[334.261695] Starting dynamic subtest: wc
[334.262448] Dynamic subtest wc: SUCCESS (0.000s)
[334.267355] Starting dynamic subtest: uc
[334.268150] Dynamic subtest uc: SUCCESS (0.000s)
[334.268932] Subtest faulting-read: SUCCESS (0.004s)
[334.317333] [102/142] (659s left) kms_ccs (pipe-d-random-ccs-data-4_tiled_mtl_rc_ccs_cc)
[334.707217] Starting subtest: pipe-D-random-ccs-data-4_tiled_mtl_rc_ccs_cc
[334.709488] Subtest pipe-D-random-ccs-data-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[334.823662] [103/142] (659s left) gem_exec_balancer (bonded-chain)
[334.877227] Starting subtest: bonded-chain
[341.713999] Subtest bonded-chain: SUCCESS (6.828s)
[341.942081] [104/142] (651s left) sw_sync (sync_busy)
[341.996487] Starting subtest: sync_busy
[341.998188] Subtest sync_busy: SUCCESS (0.002s)
[342.024149] [105/142] (651s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[342.109751] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[342.122541] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.012s)
[342.166455] [106/142] (651s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[342.260349] Starting subtest: cursorA-vs-flipB-varying-size
[342.262813] Subtest cursorA-vs-flipB-varying-size: SKIP (0.002s)
[342.299705] [107/142] (651s left) feature_discovery (psr2)
[342.396605] Starting subtest: psr2
[342.398187] Subtest psr2: SKIP (0.000s)
[342.433398] [108/142] (651s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[342.532705] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[342.534062] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[342.582947] [109/142] (651s left) syncobj_basic (bad-pad-handle-to-fd)
[342.629768] Starting subtest: bad-pad-handle-to-fd
[342.630484] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[342.666189] [110/142] (651s left) kms_ccs (pipe-c-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc)
[342.974718] Starting subtest: pipe-C-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc
[342.976164] Subtest pipe-C-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[343.177730] [111/142] (650s left) v3d/v3d_submit_csd (valid-multisync-submission)
[343.247474] Subtest valid-multisync-submission: SKIP (0.000s)
[343.277448] [112/142] (650s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[343.379732] Starting subtest: x-tiled-32bpp-rotate-0
[344.555950] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.176s)
[344.687010] [113/142] (649s left) kms_ccs (pipe-d-crc-primary-basic-y_tiled_gen12_rc_ccs)
[345.068023] Starting subtest: pipe-D-crc-primary-basic-y_tiled_gen12_rc_ccs
[345.260469] Subtest pipe-D-crc-primary-basic-y_tiled_gen12_rc_ccs: SUCCESS (0.192s)
[345.425522] [114/142] (648s left) vc4/vc4_wait_bo (bad-bo)
[345.494808] Subtest bad-bo: SKIP (0.000s)
[345.525311] [115/142] (648s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[345.626931] Starting subtest: fbcpsr-tiling-linear
[345.628412] Subtest fbcpsr-tiling-linear: SKIP (0.000s)
[345.691738] [116/142] (648s left) sw_sync (sync_merge)
[345.737369] Starting subtest: sync_merge
[345.738190] Subtest sync_merge: SUCCESS (0.000s)
[345.768349] [117/142] (648s left) kms_ccs (pipe-b-crc-primary-rotation-180-4_tiled_dg2_rc_ccs)
[345.997819] Starting subtest: pipe-B-crc-primary-rotation-180-4_tiled_dg2_rc_ccs
[345.999305] Subtest pipe-B-crc-primary-rotation-180-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[346.281208] [118/142] (647s left) drm_fdinfo (basics)
[346.330178] Starting subtest: basics
[346.330961] Subtest basics: SUCCESS (0.000s)
[346.363711] [119/142] (647s left) kms_flip (2x-nonexisting-fb)
[346.443550] Starting subtest: 2x-nonexisting-fb
[346.455582] Subtest 2x-nonexisting-fb: SKIP (0.012s)
[346.497428] [120/142] (647s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[346.596858] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[346.598244] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[346.647397] [121/142] (647s left) gen9_exec_parse (batch-zero-length)
[346.697969] Subtest batch-zero-length: SKIP (0.000s)
[346.715197] [122/142] (647s left) gem_mmap_gtt (fault-concurrent-x)
[346.761588] Starting subtest: fault-concurrent-X
[349.305954] Subtest fault-concurrent-X: SUCCESS (2.510s)
[349.348381] [123/142] (644s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[349.460924] Starting subtest: cursor-rapid-movement-32x32
[349.501206] Subtest cursor-rapid-movement-32x32: SKIP (0.039s)
[349.572525] [124/142] (644s left) kms_universal_plane (universal-plane-pipe-b-sanity)
[349.668679] Starting subtest: universal-plane-pipe-B-sanity
[350.008198] Subtest universal-plane-pipe-B-sanity: SUCCESS (0.339s)
[350.081045] [125/142] (644s left) i915_pm_rc6_residency (rc6-fence)
[350.129038] Starting subtest: rc6-fence
[368.389050] Subtest rc6-fence: SUCCESS (18.234s)
[368.574674] [126/142] (625s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[368.627016] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[368.732716] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.105s)
[368.775701] [127/142] (625s left) gem_exec_capture (capture)
[368.828841] Starting subtest: capture
[368.829581] Starting dynamic subtest: rcs0-smem
[370.102775] Dynamic subtest rcs0-smem: SUCCESS (1.267s)
[370.107965] Starting dynamic subtest: bcs0-smem
[371.374981] Dynamic subtest bcs0-smem: SUCCESS (1.270s)
[371.380184] Starting dynamic subtest: vcs0-smem
[372.646679] Dynamic subtest vcs0-smem: SUCCESS (1.271s)
[372.651816] Starting dynamic subtest: vcs1-smem
[373.918972] Dynamic subtest vcs1-smem: SUCCESS (1.271s)
[373.924159] Starting dynamic subtest: vecs0-smem
[375.191554] Dynamic subtest vecs0-smem: SUCCESS (1.271s)
[375.192458] Subtest capture: SUCCESS (6.354s)
[375.257180] [128/142] (618s left) gem_vm_create (execbuf)
[375.317236] Starting subtest: execbuf
[375.320011] Subtest execbuf: SUCCESS (0.003s)
[375.410259] [129/142] (618s left) gem_spin_batch (legacy-resubmit-new)
[375.474363] Starting subtest: legacy-resubmit-new
[375.475159] Starting dynamic subtest: default
[375.476965] Dynamic subtest default: SUCCESS (0.002s)
[375.482840] Starting dynamic subtest: render
[375.483610] Dynamic subtest render: SUCCESS (0.002s)
[375.489379] Starting dynamic subtest: bsd
[375.490135] Dynamic subtest bsd: SUCCESS (0.002s)
[375.495802] Starting dynamic subtest: bsd1
[375.496563] Dynamic subtest bsd1: SUCCESS (0.002s)
[375.501419] Starting dynamic subtest: bsd2
[375.502209] Dynamic subtest bsd2: SUCCESS (0.002s)
[375.507034] Starting dynamic subtest: blt
[375.507932] Dynamic subtest blt: SUCCESS (0.002s)
[375.512822] Starting dynamic subtest: vebox
[375.513609] Dynamic subtest vebox: SUCCESS (0.002s)
[375.514382] Subtest legacy-resubmit-new: SUCCESS (0.018s)
[375.651655] [130/142] (618s left) kms_chamelium_frames (vga-frame-dump)
[375.804388] Subtest vga-frame-dump: SKIP (0.000s)
[375.861290] [131/142] (618s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[375.957720] Starting subtest: basic-busy-flip-before-cursor-legacy
[375.959219] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[375.992383] [132/142] (618s left) gem_render_copy (x-tiled)
[376.044174] Starting subtest: x-tiled
[376.044925] Starting dynamic subtest: smem
[376.139542] Dynamic subtest smem: SUCCESS (0.095s)
[376.140322] Subtest x-tiled: SUCCESS (0.096s)
[376.294164] [133/142] (617s left) gem_ctx_param (set-priority-invalid-size)
[376.344611] Starting subtest: set-priority-invalid-size
[376.345364] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[376.384028] [134/142] (617s left) kms_ccs (pipe-a-crc-sprite-planes-basic-yf_tiled_ccs)
[376.578447] Starting subtest: pipe-A-crc-sprite-planes-basic-yf_tiled_ccs
[376.582375] Subtest pipe-A-crc-sprite-planes-basic-yf_tiled_ccs: SKIP (0.003s)
[376.902343] [135/142] (617s left) kms_universal_plane (universal-plane-pipe-a-functional)
[376.998498] Starting subtest: universal-plane-pipe-A-functional
[378.125110] Subtest universal-plane-pipe-A-functional: SUCCESS (1.127s)
[378.198837] [136/142] (616s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[378.299990] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[378.301559] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[378.348431] [137/142] (615s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[378.449958] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[378.451460] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[378.498334] [138/142] (615s left) kms_ccs (pipe-b-bad-aux-stride-y_tiled_ccs)
[378.754600] Starting subtest: pipe-B-bad-aux-stride-y_tiled_ccs
[378.756024] Subtest pipe-B-bad-aux-stride-y_tiled_ccs: SKIP (0.000s)
[379.001500] [139/142] (615s left) gem_exec_schedule (implicit-read-write)
[379.055351] Starting subtest: implicit-read-write
[379.056077] Starting dynamic subtest: rcs0
[379.106236] Dynamic subtest rcs0: SUCCESS (0.051s)
[379.112040] Starting dynamic subtest: bcs0
[379.156188] Dynamic subtest bcs0: SUCCESS (0.049s)
[379.162588] Starting dynamic subtest: vcs0
[379.209431] Dynamic subtest vcs0: SUCCESS (0.052s)
[379.216377] Starting dynamic subtest: vcs1
[379.261761] Dynamic subtest vcs1: SUCCESS (0.051s)
[379.267652] Starting dynamic subtest: vecs0
[379.314423] Dynamic subtest vecs0: SUCCESS (0.052s)
[379.315310] Subtest implicit-read-write: SUCCESS (0.260s)
[379.580812] [140/142] (614s left) api_intel_bb (blit-reloc-purge-cache)
[379.638981] Starting subtest: blit-reloc-purge-cache
[379.644851] Subtest blit-reloc-purge-cache: SUCCESS (0.007s)
[379.716861] [141/142] (614s left) kms_psr (cursor_mmap_gtt)
[379.774518] Subtest cursor_mmap_gtt: SKIP (0.000s)
[379.794125] [142/142] (614s left) core_auth (getclient-master-drop)
[379.848185] Starting subtest: getclient-master-drop
[379.849770] Subtest getclient-master-drop: SUCCESS (0.002s)
[379.883119] Closing watchdogs
Done.