[53.780095] Initializing watchdogs
[53.780405]   /dev/watchdog0
[53.797820] [001/142] (960s left) gem_exec_fence (parallel)
[54.198588] Starting subtest: parallel
[54.200089] Starting dynamic subtest: rcs0
[56.351193] Dynamic subtest rcs0: SUCCESS (2.151s)
[56.363890] Starting dynamic subtest: bcs0
[58.507127] Dynamic subtest bcs0: SUCCESS (2.153s)
[58.519959] Starting dynamic subtest: vcs0
[60.657220] Dynamic subtest vcs0: SUCCESS (2.149s)
[60.670662] Starting dynamic subtest: vecs0
[62.809379] Dynamic subtest vecs0: SUCCESS (2.154s)
[62.810743] Subtest parallel: SUCCESS (8.611s)
[63.550942] [002/142] (950s left) kms_draw_crc (fill-fb)
[63.872250] Starting subtest: fill-fb
[64.348794] Subtest fill-fb: SUCCESS (0.474s)
[64.448644] [003/142] (949s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs)
[64.934787] Starting subtest: pipe-A-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs
[64.941125] Subtest pipe-A-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs: SKIP (0.005s)
[65.490657] [004/142] (948s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[65.803062] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[65.805703] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[65.907765] [005/142] (948s left) gem_render_copy (linear-to-vebox-y-tiled)
[66.136663] Starting subtest: linear-to-vebox-y-tiled
[66.139235] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[66.341985] [006/142] (948s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[66.557990] Starting subtest: writes-after-reads-uncached
[87.226691] Subtest writes-after-reads-uncached: SUCCESS (20.669s)
[87.339547] [007/142] (927s left) dmabuf_sync_file (export-wait-after-attach)
[87.555872] Starting subtest: export-wait-after-attach
[87.557678] Subtest export-wait-after-attach: SUCCESS (0.002s)
[87.623151] [008/142] (926s left) gem_readwrite (new-obj)
[87.827947] Starting subtest: new-obj
[87.830685] Subtest new-obj: SUCCESS (0.000s)
[87.922636] [009/142] (926s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[88.231363] Starting subtest: primary-y-tiled-reflect-x-270
[88.234029] Subtest primary-y-tiled-reflect-x-270: SKIP (0.003s)
[88.307122] [010/142] (926s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_mtl_rc_ccs)
[88.826054] Starting subtest: pipe-B-crc-primary-basic-4_tiled_mtl_rc_ccs
[88.831298] Subtest pipe-B-crc-primary-basic-4_tiled_mtl_rc_ccs: SKIP (0.002s)
[89.359493] [011/142] (925s left) gem_exec_reloc (basic-cpu-read-noreloc)
[89.577378] Starting subtest: basic-cpu-read-noreloc
[89.593668] Subtest basic-cpu-read-noreloc: SUCCESS (0.016s)
[89.776115] [012/142] (924s left) kms_content_protection (lic)
[90.122631] Starting subtest: LIC
[90.158703] Starting dynamic subtest: pipe-A-DP-1
[210.709940] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[211.400262] Closing watchdogs
[211.409487] Initializing watchdogs
[211.409666]   /dev/watchdog0
[211.429376] [013/142] (803s left) drm_fdinfo (virtual-busy)
[211.646521] Starting subtest: virtual-busy
[213.815965] Subtest virtual-busy: SUCCESS (2.170s)
[213.893574] [014/142] (800s left) i915_suspend (debugfs-reader)
[214.096073] Starting subtest: debugfs-reader
[250.105235] Subtest debugfs-reader: SUCCESS (20.009s)
[250.197675] [015/142] (780s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[250.501529] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[250.505929] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.003s)
[250.598172] [016/142] (780s left) api_intel_bb (crc32)
[250.803394] Starting subtest: crc32
[250.806144] Subtest crc32: SKIP (0.000s)
[250.897280] [017/142] (779s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[251.215468] Starting subtest: yf-tiled-16bpp-rotate-0
[255.158152] Subtest yf-tiled-16bpp-rotate-0: SUCCESS (3.942s)
[255.484545] [018/142] (775s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[255.805263] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[255.807793] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[255.997910] [019/142] (774s left) v3d/v3d_wait_bo (unused-bo-1ns)
[256.259635] Subtest unused-bo-1ns: SKIP (0.000s)
[256.330985] [020/142] (774s left) kms_ccs (pipe-d-missing-ccs-buffer-y_tiled_gen12_rc_ccs)
[257.046772] Subtest pipe-D-missing-ccs-buffer-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[257.360921] [021/142] (773s left) v3d/v3d_perfmon (get-values-invalid-pointer)
[257.622423] Subtest get-values-invalid-pointer: SKIP (0.000s)
[257.695074] [022/142] (773s left) kms_ccs (pipe-c-missing-ccs-buffer-yf_tiled_ccs)
[258.362969] Starting subtest: pipe-C-missing-ccs-buffer-yf_tiled_ccs
[258.365929] Subtest pipe-C-missing-ccs-buffer-yf_tiled_ccs: SKIP (0.000s)
[258.719721] [023/142] (772s left) gem_exec_whisper (basic-queues-priority)
[258.948402] Starting subtest: basic-queues-priority
[272.570611] Subtest basic-queues-priority: SUCCESS (13.620s)
[272.770932] [024/142] (758s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[273.093171] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[273.095805] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[273.188206] [025/142] (758s left) kms_ccs (pipe-a-bad-aux-stride-4_tiled_mtl_rc_ccs_cc)
[273.666055] Starting subtest: pipe-A-bad-aux-stride-4_tiled_mtl_rc_ccs_cc
[273.668844] Subtest pipe-A-bad-aux-stride-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[274.220959] [026/142] (757s left) gem_lmem_swapping (parallel-random-verify-ccs)
[274.433546] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[274.487460] [027/142] (756s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[274.799852] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[274.802401] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[274.905189] [028/142] (756s left) kms_ccs (pipe-c-ccs-on-another-bo-y_tiled_gen12_rc_ccs)
[275.596981] Starting subtest: pipe-C-ccs-on-another-bo-y_tiled_gen12_rc_ccs
[275.600100] Subtest pipe-C-ccs-on-another-bo-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[275.944073] [029/142] (755s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[276.157467] Starting subtest: etime-multi-wait-for-submit-submitted
[276.267212] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.108s)
[276.359907] [030/142] (755s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[276.661374] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[276.662742] Starting dynamic subtest: pipe-A-valid-mode
[277.337701] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.675s)
[277.338995] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (0.678s)
[277.661762] [031/142] (753s left) kms_plane_multiple (tiling-none)
[277.967859] Starting subtest: tiling-none
[277.969609] Starting dynamic subtest: pipe-A-DP-1
[279.422337] Dynamic subtest pipe-A-DP-1: SUCCESS (1.455s)
[279.446815] Starting dynamic subtest: pipe-B-DP-1
[281.129190] Dynamic subtest pipe-B-DP-1: SUCCESS (1.696s)
[281.154371] Starting dynamic subtest: pipe-C-DP-1
[282.822456] Dynamic subtest pipe-C-DP-1: SUCCESS (1.690s)
[282.823770] Subtest tiling-none: SUCCESS (4.859s)
[283.187875] [032/142] (748s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[283.512033] Starting subtest: y-tiled-8bpp-rotate-90
[283.594625] Subtest y-tiled-8bpp-rotate-90: SKIP (0.079s)
[283.704456] [033/142] (747s left) kms_plane_scaling (plane-upscale-with-rotation-factor-0-25)
[284.011245] Starting subtest: plane-upscale-with-rotation-factor-0-25
[284.012550] Starting dynamic subtest: pipe-A-DP-1
[284.063072] Dynamic subtest pipe-A-DP-1: SKIP (0.050s)
[284.117165] Starting dynamic subtest: pipe-B-DP-1
[284.424973] Dynamic subtest pipe-B-DP-1: SKIP (0.356s)
[284.448335] Starting dynamic subtest: pipe-C-DP-1
[284.779761] Dynamic subtest pipe-C-DP-1: SKIP (0.348s)
[284.783181] Subtest plane-upscale-with-rotation-factor-0-25: SKIP (0.770s)
[285.190776] [034/142] (746s left) kms_ccs (pipe-b-random-ccs-data-y_tiled_gen12_mc_ccs)
[285.744699] Starting subtest: pipe-B-random-ccs-data-y_tiled_gen12_mc_ccs
[285.748709] Subtest pipe-B-random-ccs-data-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[286.232710] [035/142] (745s left) gem_exec_suspend (basic-s4-devices)
[286.464489] Starting subtest: basic-S4-devices
[286.465952] Starting dynamic subtest: smem
[298.072932] Dynamic subtest smem: SUCCESS (11.608s)
[298.074658] Subtest basic-S4-devices: SUCCESS (11.610s)
[301.281602] [036/142] (733s left) gem_exec_balancer (semaphore)
[301.513763] Starting subtest: semaphore
[305.648755] Subtest semaphore: SUCCESS (4.135s)
[309.576345] [037/142] (725s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[309.897887] Starting subtest: basic-flip-before-cursor-atomic
[310.949092] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.050s)
[311.289295] [038/142] (723s left) kms_ccs (pipe-a-random-ccs-data-4_tiled_mtl_mc_ccs)
[311.719788] Starting subtest: pipe-A-random-ccs-data-4_tiled_mtl_mc_ccs
[311.723840] Subtest pipe-A-random-ccs-data-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[312.344100] [039/142] (722s left) kms_ccs (pipe-b-bad-pixel-format-4_tiled_mtl_rc_ccs)
[312.846674] Starting subtest: pipe-B-bad-pixel-format-4_tiled_mtl_rc_ccs
[312.849459] Subtest pipe-B-bad-pixel-format-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[313.391813] [040/142] (721s left) perf_pmu (enable-race)
[313.602191] Starting subtest: enable-race
[313.603652] Starting dynamic subtest: rcs0
[326.276860] Dynamic subtest rcs0: SUCCESS (12.673s)
[326.300141] Starting dynamic subtest: bcs0
[339.002810] Dynamic subtest bcs0: SUCCESS (12.723s)
[339.026791] Starting dynamic subtest: vcs0
[351.667754] Dynamic subtest vcs0: SUCCESS (12.661s)
[351.691311] Starting dynamic subtest: vecs0
[364.338994] Dynamic subtest vecs0: SUCCESS (12.669s)
[364.340923] Subtest enable-race: SUCCESS (50.738s)
[364.441637] [041/142] (670s left) gem_mmap_offset (blt-coherency)
[364.648235] Starting subtest: blt-coherency
[364.666456] Subtest blt-coherency: SUCCESS (0.020s)
[364.773884] [042/142] (670s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[364.999506] Starting subtest: y-tiled-to-vebox-yf-tiled
[365.002179] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[365.208158] [043/142] (669s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-pwrite)
[365.523854] Starting subtest: psr-1p-offscren-pri-shrfb-draw-pwrite
[365.526688] Subtest psr-1p-offscren-pri-shrfb-draw-pwrite: SKIP (0.000s)
[365.625660] [044/142] (669s left) gem_partial_pwrite_pread (reads-snoop)
[365.839680] Starting subtest: reads-snoop
[372.612551] Subtest reads-snoop: SUCCESS (6.775s)
[372.724415] [045/142] (662s left) i915_pciid
[373.024993] [046/142] (662s left) kms_vblank (pipe-c-ts-continuation-modeset)
[373.328522] Starting subtest: pipe-C-ts-continuation-modeset
[374.459568] Subtest pipe-C-ts-continuation-modeset: SUCCESS (1.135s)
[374.792598] [047/142] (660s left) gem_mmap_wc (write-cpu-read-wc)
[374.998966] Starting subtest: write-cpu-read-wc
[375.275575] Subtest write-cpu-read-wc: SUCCESS (0.276s)
[375.359179] [048/142] (659s left) kms_color (invalid-degamma-lut-sizes)
[375.666098] Starting subtest: invalid-degamma-lut-sizes
[375.668684] Starting dynamic subtest: pipe-A
[375.768253] Dynamic subtest pipe-A: SUCCESS (0.104s)
[375.799877] Starting dynamic subtest: pipe-B
[375.802559] Dynamic subtest pipe-B: SUCCESS (0.007s)
[375.834634] Starting dynamic subtest: pipe-C
[375.837197] Dynamic subtest pipe-C: SUCCESS (0.007s)
[375.839726] Subtest invalid-degamma-lut-sizes: SUCCESS (0.125s)
[376.115463] [049/142] (659s left) kms_fbcon_fbt (psr-suspend)
[376.333714] Starting subtest: psr-suspend
[376.336789] Subtest psr-suspend: SKIP (0.000s)
[376.444220] [050/142] (658s left) kms_atomic (atomic-invalid-params)
[376.872185] Starting subtest: atomic-invalid-params
[376.956689] Subtest atomic-invalid-params: SUCCESS (0.085s)
[377.405428] [051/142] (657s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[377.749710] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[377.752310] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.003s)
[377.860918] [052/142] (657s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[378.208524] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[378.211512] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[378.340937] [053/142] (657s left) i915_pm_freq_api (freq-basic-api)
[378.672727] Subtest freq-basic-api: SKIP (0.000s)
[378.742880] [054/142] (656s left) kms_ccs (pipe-c-ccs-on-another-bo-yf_tiled_ccs)
[379.626804] Starting subtest: pipe-C-ccs-on-another-bo-yf_tiled_ccs
[379.633096] Subtest pipe-C-ccs-on-another-bo-yf_tiled_ccs: SKIP (0.000s)
[379.970870] [055/142] (655s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[380.302562] Starting subtest: y-tiled-16bpp-rotate-90
[380.377777] Subtest y-tiled-16bpp-rotate-90: SKIP (0.071s)
[380.487682] [056/142] (655s left) kms_sequence (get-forked-busy)
[380.788672] Starting subtest: get-forked-busy
[380.790093] Starting dynamic subtest: DP-1-pipe-A
[383.240689] Dynamic subtest DP-1-pipe-A: SUCCESS (2.451s)
[383.265148] Starting dynamic subtest: DP-1-pipe-B
[385.980159] Dynamic subtest DP-1-pipe-B: SUCCESS (2.734s)
[386.004242] Starting dynamic subtest: DP-1-pipe-C
[388.881504] Dynamic subtest DP-1-pipe-C: SUCCESS (2.897s)
[388.882929] Subtest get-forked-busy: SUCCESS (8.098s)
[389.197300] [057/142] (646s left) gem_ctx_param (get-priority-new-ctx)
[389.399660] Starting subtest: get-priority-new-ctx
[389.401309] Subtest get-priority-new-ctx: SUCCESS (0.000s)
[389.496659] [058/142] (646s left) kms_chamelium_color (degamma)
[389.802779] Subtest degamma: SKIP (0.000s)
[389.861277] [059/142] (645s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[390.172922] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[392.286505] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (2.115s)
[392.412281] [060/142] (643s left) gem_ctx_persistence (legacy-engines-mixed-process)
[392.622491] Starting subtest: legacy-engines-mixed-process
[392.626924] Starting dynamic subtest: render
[393.000419] Dynamic subtest render: SUCCESS (0.373s)
[393.023779] Starting dynamic subtest: bsd
[393.356728] Dynamic subtest bsd: SUCCESS (0.355s)
[393.383322] Starting dynamic subtest: blt
[393.718757] Dynamic subtest blt: SUCCESS (0.358s)
[393.745276] Starting dynamic subtest: vebox
[394.076757] Dynamic subtest vebox: SUCCESS (0.354s)
[394.078995] Subtest legacy-engines-mixed-process: SUCCESS (1.455s)
[394.180325] [061/142] (641s left) syncobj_basic (bad-create-flags)
[394.381810] Starting subtest: bad-create-flags
[394.384587] Subtest bad-create-flags: SUCCESS (0.000s)
[394.479827] [062/142] (641s left) kms_psr2_sf (overlay-plane-move-continuous-exceed-fully-sf)
[394.682689] Subtest overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[394.746729] [063/142] (641s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[395.062299] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[395.065769] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[395.163647] [064/142] (640s left) gem_pxp (fail-invalid-protected-context)
[397.887962] Subtest fail-invalid-protected-context: SKIP (0.000s)
[397.977928] [065/142] (637s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[398.283708] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[398.286670] Subtest psr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[398.396703] [066/142] (637s left) sysfs_timeslice_duration (timeout)
[398.604519] Starting subtest: timeout
[398.608719] Starting dynamic subtest: vecs0
[399.518052] Dynamic subtest vecs0: SUCCESS (0.909s)
[399.545099] Starting dynamic subtest: vcs0
[400.408597] Dynamic subtest vcs0: SUCCESS (0.890s)
[400.434126] Starting dynamic subtest: bcs0
[401.303749] Dynamic subtest bcs0: SUCCESS (0.892s)
[401.329874] Starting dynamic subtest: rcs0
[402.224890] Dynamic subtest rcs0: SUCCESS (0.915s)
[402.226465] Subtest timeout: SUCCESS (3.619s)
[402.312438] [067/142] (633s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[402.612406] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[403.726292] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (1.112s)
[404.048455] [068/142] (631s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[404.353855] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[404.356942] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[404.463536] [069/142] (631s left) kms_ccs (pipe-d-crc-sprite-planes-basic-yf_tiled_ccs)
[405.183509] Subtest pipe-D-crc-sprite-planes-basic-yf_tiled_ccs: SKIP (0.000s)
[405.500323] [070/142] (630s left) gem_exec_flush (basic-batch-kernel-default-uc)
[405.725242] Starting subtest: basic-batch-kernel-default-uc
[411.508202] Subtest basic-batch-kernel-default-uc: SUCCESS (5.779s)
[411.715842] [071/142] (624s left) kms_psr (sprite_mmap_gtt)
[411.920724] Subtest sprite_mmap_gtt: SKIP (0.000s)
[411.981702] [072/142] (624s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[412.299819] Starting subtest: 4-tiled-8bpp-rotate-90
[412.302823] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.000s)
[412.399790] [073/142] (623s left) kms_chamelium_frames (hdmi-frame-dump)
[412.788195] Subtest hdmi-frame-dump: SKIP (0.000s)
[413.080377] [074/142] (623s left) kms_cursor_edge_walk (256x256-right-edge)
[413.378303] Starting subtest: 256x256-right-edge
[413.379678] Starting dynamic subtest: pipe-A-DP-1
[417.027446] Dynamic subtest pipe-A-DP-1: SUCCESS (3.646s)
[417.057099] Starting dynamic subtest: pipe-C-DP-1
[420.515907] Dynamic subtest pipe-C-DP-1: SUCCESS (3.481s)
[420.517250] Subtest 256x256-right-edge: SUCCESS (7.140s)
[420.829215] [075/142] (615s left) gen9_exec_parse (bb-chained)
[421.057463] Starting subtest: bb-chained
[421.068869] Subtest bb-chained: SUCCESS (0.011s)
[421.295454] [076/142] (615s left) gem_exec_schedule (manyslice)
[421.530065] Starting subtest: manyslice
[421.531520] Starting dynamic subtest: rcs0
[423.157728] Dynamic subtest rcs0: SUCCESS (1.623s)
[423.190339] Starting dynamic subtest: bcs0
[426.583488] Dynamic subtest bcs0: SUCCESS (3.421s)
[426.609527] Starting dynamic subtest: vcs0
[427.406826] Dynamic subtest vcs0: SUCCESS (0.819s)
[427.432396] Starting dynamic subtest: vecs0
[428.232144] Dynamic subtest vecs0: SUCCESS (0.823s)
[428.233701] Subtest manyslice: SUCCESS (6.701s)
[428.577733] [077/142] (607s left) gem_ctx_exec (basic-invalid-context)
[428.783929] Starting subtest: basic-invalid-context
[428.790467] Subtest basic-invalid-context: SUCCESS (0.006s)
[428.909610] [078/142] (607s left) kms_vblank (pipe-d-wait-idle)
[429.218449] Subtest pipe-D-wait-idle: SKIP (0.000s)
[429.311272] [079/142] (607s left) vc4/vc4_wait_seqno (bad-seqno-1ns)
[429.567056] Subtest bad-seqno-1ns: SKIP (0.000s)
[429.642148] [080/142] (606s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[429.936273] Starting subtest: flip-vs-cursor-atomic-transitions
[445.508522] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (15.569s)
[445.832117] [081/142] (590s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[446.151883] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[446.155057] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[446.263757] [082/142] (590s left) kms_psr (psr2_sprite_render)
[446.467099] Subtest psr2_sprite_render: SKIP (0.000s)
[446.529293] [083/142] (590s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[446.828976] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[446.830390] Starting dynamic subtest: pipe-A-valid-mode
[447.509098] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.675s)
[447.510499] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (0.680s)
[447.865315] [084/142] (588s left) gem_flink_race (flink_name)
[448.061434] Starting subtest: flink_name
[453.437484] Subtest flink_name: SUCCESS (5.374s)
[453.530666] [085/142] (583s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[453.836612] Starting subtest: cursorA-vs-flipB-atomic
[453.839649] Subtest cursorA-vs-flipB-atomic: SKIP (0.003s)
[453.932159] [086/142] (582s left) kms_cursor_crc (cursor-random-64x64)
[454.236817] Starting subtest: cursor-random-64x64
[454.248455] Starting dynamic subtest: pipe-A-DP-1
[458.054933] Dynamic subtest pipe-A-DP-1: SUCCESS (3.806s)
[458.158815] Starting dynamic subtest: pipe-C-DP-1
[462.287432] Dynamic subtest pipe-C-DP-1: SUCCESS (4.146s)
[462.288719] Subtest cursor-random-64x64: SUCCESS (8.050s)
[462.655902] [087/142] (574s left) kms_vblank (pipe-c-ts-continuation-dpms-rpm)
[462.964463] Starting subtest: pipe-C-ts-continuation-dpms-rpm
[465.462297] Subtest pipe-C-ts-continuation-dpms-rpm: SUCCESS (2.498s)
[465.953054] [088/142] (570s left) gem_exec_reloc (basic-cpu-gtt)
[466.166612] Starting subtest: basic-cpu-gtt
[466.190650] Subtest basic-cpu-gtt: SUCCESS (0.024s)
[466.386855] [089/142] (570s left) kms_ccs (pipe-a-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc)
[466.844798] Starting subtest: pipe-A-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc
[466.847571] Subtest pipe-A-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[467.462519] [090/142] (569s left) kms_vblank (pipe-d-query-forked)
[467.764209] Subtest pipe-D-query-forked: SKIP (0.000s)
[467.845586] [091/142] (569s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[468.151835] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[469.717856] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (1.567s)
[469.846233] [092/142] (567s left) v3d/v3d_submit_csd (multiple-job-submission)
[470.118650] Subtest multiple-job-submission: SKIP (0.000s)
[470.197301] [093/142] (566s left) gem_wait (await)
[470.442463] Starting subtest: await
[470.444549] Starting dynamic subtest: all-engines
[471.476688] Dynamic subtest all-engines: SUCCESS (1.033s)
[471.502952] Starting dynamic subtest: rcs0
[472.505159] Dynamic subtest rcs0: SUCCESS (1.025s)
[472.534066] Starting dynamic subtest: bcs0
[473.541640] Dynamic subtest bcs0: SUCCESS (1.032s)
[473.567488] Starting dynamic subtest: vcs0
[474.569587] Dynamic subtest vcs0: SUCCESS (1.024s)
[474.596156] Starting dynamic subtest: vecs0
[475.597958] Dynamic subtest vecs0: SUCCESS (1.025s)
[475.599807] Subtest await: SUCCESS (5.157s)
[475.847988] [094/142] (561s left) gem_mmap_gtt (basic-read-write-distinct)
[476.055096] Starting subtest: basic-read-write-distinct
[476.087515] Subtest basic-read-write-distinct: SUCCESS (0.034s)
[476.212740] [095/142] (560s left) vc4/vc4_wait_bo (bad-bo)
[476.470543] Subtest bad-bo: SKIP (0.000s)
[476.544993] [096/142] (560s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[476.749157] Starting subtest: cpuset-basic-small-copy-odd
[483.958665] Subtest cpuset-basic-small-copy-odd: SUCCESS (7.210s)
[484.062203] [097/142] (553s left) kms_frontbuffer_tracking (fbc-suspend)
[484.503435] Starting subtest: fbc-suspend
[522.798217] Subtest fbc-suspend: SUCCESS (5.982s)
[526.049262] [098/142] (546s left) gem_exec_balancer (hang)
[530.089239] Starting subtest: hang
[533.669820] Subtest hang: SUCCESS (3.583s)
[533.776762] [099/142] (538s left) core_auth (basic-auth)
[533.979049] Starting subtest: basic-auth
[533.980323] Subtest basic-auth: SUCCESS (0.001s)
[534.076081] [100/142] (538s left) perf_pmu (module-unload)
[534.299210] Starting subtest: module-unload
[573.350501] Subtest module-unload: SUCCESS (39.050s)
[573.389311] [101/142] (499s left) i915_pm_rpm (legacy-planes-dpms)
[576.799925] Starting subtest: legacy-planes-dpms
[576.802012] Starting dynamic subtest: plane-39
[579.628256] Dynamic subtest plane-39: SUCCESS (2.828s)
[579.649436] Starting dynamic subtest: plane-47
[582.529666] Dynamic subtest plane-47: SUCCESS (2.900s)
[582.532712] Subtest legacy-planes-dpms: SUCCESS (5.733s)
[583.016774] [102/142] (489s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[583.356233] Starting subtest: 4-tiled-64bpp-rotate-180
[583.359304] Subtest 4-tiled-64bpp-rotate-180: SKIP (0.000s)
[583.462581] [103/142] (489s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[583.766002] Starting subtest: bo-too-small-due-to-tiling
[583.767468] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[583.861790] [104/142] (489s left) gem_exec_parallel (engines)
[584.100363] Starting subtest: engines
[584.101808] Starting dynamic subtest: basic
[587.830010] Dynamic subtest basic: SUCCESS (3.728s)
[587.857419] Starting dynamic subtest: contexts
[591.811144] Dynamic subtest contexts: SUCCESS (3.977s)
[591.838297] Starting dynamic subtest: fds
[596.963871] Dynamic subtest fds: SUCCESS (5.151s)
[596.992061] Starting dynamic subtest: userptr
[600.805632] Dynamic subtest userptr: SUCCESS (3.838s)
[600.807226] Subtest engines: SUCCESS (16.706s)
[601.016936] [105/142] (471s left) gem_exec_schedule (wide)
[601.390230] Starting subtest: wide
[601.391892] Starting dynamic subtest: rcs0
[621.808603] Dynamic subtest rcs0: SUCCESS (20.409s)
[621.837216] Starting dynamic subtest: bcs0
[643.277259] Dynamic subtest bcs0: SUCCESS (21.472s)
[643.358760] Starting dynamic subtest: vcs0
[664.249497] Dynamic subtest vcs0: SUCCESS (20.955s)
[664.320288] Starting dynamic subtest: vecs0
[685.035194] Dynamic subtest vecs0: SUCCESS (20.783s)
[685.042540] Subtest wide: SUCCESS (83.640s)
[686.001263] [106/142] (386s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[686.330097] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[686.333329] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[686.433575] [107/142] (386s left) kms_frontbuffer_tracking (psr-slowdraw)
[686.760392] Starting subtest: psr-slowdraw
[686.763363] Subtest psr-slowdraw: SKIP (0.000s)
[686.867406] [108/142] (386s left) kms_plane_alpha_blend (alpha-basic)
[687.185165] Starting subtest: alpha-basic
[687.514785] Starting dynamic subtest: pipe-A-DP-1
[688.120906] Dynamic subtest pipe-A-DP-1: FAIL (0.279s)
[688.143818] Starting dynamic subtest: pipe-C-DP-1
[688.950091] Dynamic subtest pipe-C-DP-1: FAIL (0.697s)
[688.951423] Subtest alpha-basic: FAIL (1.394s)
[688.995766] [109/142] (384s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[689.309391] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[689.312075] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[689.424708] [110/142] (383s left) vgem_basic (mmap)
[689.644568] Starting subtest: mmap
[689.673163] Subtest mmap: SUCCESS (0.029s)
[689.756819] [111/142] (383s left) gem_eio (in-flight-external)
[690.000095] Starting subtest: in-flight-external
[690.085211] Subtest in-flight-external: SUCCESS (0.080s)
[690.258401] [112/142] (382s left) kms_flip (nonexisting-fb)
[690.553049] Starting subtest: nonexisting-fb
[690.554458] Starting dynamic subtest: A-DP1
[691.093327] Dynamic subtest A-DP1: SUCCESS (0.541s)
[691.121301] Starting dynamic subtest: B-DP1
[691.567965] Dynamic subtest B-DP1: SUCCESS (0.469s)
[691.592636] Starting dynamic subtest: C-DP1
[692.025527] Dynamic subtest C-DP1: SUCCESS (0.458s)
[692.029742] Subtest nonexisting-fb: SUCCESS (1.481s)
[692.447765] [113/142] (380s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[692.783144] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[692.815030] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.030s)
[692.945961] [114/142] (380s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[693.272065] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[693.276348] Starting dynamic subtest: pipe-A-DP-1
[693.365545] Dynamic subtest pipe-A-DP-1: SKIP (0.088s)
[693.394099] Starting dynamic subtest: pipe-B-DP-1
[693.760043] Dynamic subtest pipe-B-DP-1: SKIP (0.386s)
[693.785662] Starting dynamic subtest: pipe-C-DP-1
[694.148959] Dynamic subtest pipe-C-DP-1: SKIP (0.384s)
[694.151552] Subtest plane-scaler-with-clipping-clamping-rotation: SKIP (0.876s)
[694.556650] [115/142] (378s left) kms_getfb (getfb2-handle-zero)
[694.778432] Starting subtest: getfb2-handle-zero
[694.780175] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[694.889569] [116/142] (378s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[695.212508] Starting subtest: plane-all-modeset-transition-fencing
[695.213996] Starting dynamic subtest: pipe-A-DP-1
[752.360883] Dynamic subtest pipe-A-DP-1: SUCCESS (57.147s)
[752.489719] Starting dynamic subtest: pipe-B-DP-1
[809.439518] Dynamic subtest pipe-B-DP-1: SUCCESS (56.974s)
[809.538802] Subtest plane-all-modeset-transition-fencing: SUCCESS (114.328s)
[809.888987] [117/142] (263s left) kms_ccs (pipe-b-crc-sprite-planes-basic-yf_tiled_ccs)
[810.491114] Starting subtest: pipe-B-crc-sprite-planes-basic-yf_tiled_ccs
[811.016864] Subtest pipe-B-crc-sprite-planes-basic-yf_tiled_ccs: SUCCESS (0.526s)
[811.563515] [118/142] (261s left) syncobj_timeline (multi-wait-available-submitted)
[811.779107] Starting subtest: multi-wait-available-submitted
[811.780778] Subtest multi-wait-available-submitted: SUCCESS (0.002s)
[811.879610] [119/142] (261s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[812.212190] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[812.214753] Subtest psr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[812.330333] [120/142] (261s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[812.660545] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[812.663817] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[812.779898] [121/142] (260s left) kms_vblank (pipe-c-query-idle)
[813.092707] Starting subtest: pipe-C-query-idle
[815.837763] Subtest pipe-C-query-idle: SUCCESS (2.747s)
[816.177419] [122/142] (257s left) kms_setmode (basic)
[816.397226] Starting subtest: basic
[816.601325] Starting dynamic subtest: pipe-A-DP-1
[818.909724] Dynamic subtest pipe-A-DP-1: SUCCESS (2.305s)
[819.074502] Starting dynamic subtest: pipe-B-DP-1
[821.353517] Dynamic subtest pipe-B-DP-1: SUCCESS (2.300s)
[821.451436] Subtest basic: SUCCESS (5.055s)
[821.813814] [123/142] (251s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[822.129903] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[822.132451] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[822.245469] [124/142] (251s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[822.480796] Starting subtest: y-tiled-ccs-to-y-tiled
[822.485017] Starting dynamic subtest: smem
[822.789214] Dynamic subtest smem: SUCCESS (0.301s)
[822.790667] Subtest y-tiled-ccs-to-y-tiled: SUCCESS (0.305s)
[822.996734] [125/142] (250s left) gem_exec_fair (basic-none-share)
[823.237381] Starting subtest: basic-none-share
[823.241609] Starting dynamic subtest: rcs0
[828.883050] Dynamic subtest rcs0: SUCCESS (5.641s)
[828.884456] Subtest basic-none-share: SUCCESS (5.644s)
[829.095665] [126/142] (244s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[829.438579] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[830.979206] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.541s)
[831.133482] [127/142] (242s left) kms_invalid_mode (zero-hdisplay)
[831.450484] Starting subtest: zero-hdisplay
[831.460116] Starting dynamic subtest: DP-1-pipe-A
[831.556961] Dynamic subtest DP-1-pipe-A: SUCCESS (0.099s)
[831.586509] Starting dynamic subtest: DP-1-pipe-B
[831.588299] Dynamic subtest DP-1-pipe-B: SUCCESS (0.015s)
[831.614502] Starting dynamic subtest: DP-1-pipe-C
[831.616180] Dynamic subtest DP-1-pipe-C: SUCCESS (0.014s)
[831.618977] Subtest zero-hdisplay: SUCCESS (0.145s)
[831.913171] [128/142] (242s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[832.135133] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[832.139671] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.002s)
[832.230781] [129/142] (241s left) kms_addfb_basic (unused-modifier)
[832.444724] Starting subtest: unused-modifier
[832.446459] Subtest unused-modifier: SUCCESS (0.000s)
[832.663342] [130/142] (241s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_mtl_mc_ccs)
[833.402550] Subtest pipe-D-crc-primary-basic-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[833.712417] [131/142] (240s left) dumb_buffer (create-clear)
[833.924923] Starting subtest: create-clear
[878.358663] Subtest create-clear: SUCCESS (44.430s)
[878.544190] [132/142] (195s left) syncobj_wait (invalid-signal-one-illegal-handle)
[878.748742] Starting subtest: invalid-signal-one-illegal-handle
[878.750644] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[878.846422] [133/142] (195s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[879.075170] Starting subtest: untiled-to-tiled
[879.197859] Subtest untiled-to-tiled: SUCCESS (0.120s)
[879.311321] [134/142] (194s left) syncobj_timeline (transfer-timeline-point)
[879.527462] Starting subtest: transfer-timeline-point
[879.529226] Subtest transfer-timeline-point: SUCCESS (0.001s)
[879.628823] [135/142] (194s left) syncobj_timeline (invalid-wait-zero-handles)
[879.845000] Starting subtest: invalid-wait-zero-handles
[879.846461] Subtest invalid-wait-zero-handles: SUCCESS (0.000s)
[879.944401] [136/142] (194s left) kms_ccs (pipe-c-random-ccs-data-yf_tiled_ccs)
[880.610803] Starting subtest: pipe-C-random-ccs-data-yf_tiled_ccs
[880.615390] Subtest pipe-C-random-ccs-data-yf_tiled_ccs: SKIP (0.000s)
[880.994271] [137/142] (193s left) gem_ctx_persistence (many-contexts)
[881.218258] Starting subtest: many-contexts
[914.066973] Subtest many-contexts: SUCCESS (32.847s)
[914.159203] [138/142] (160s left) gem_userptr_blits (set-cache-level)
[914.389594] Starting subtest: set-cache-level
[914.390935] Subtest set-cache-level: SUCCESS (0.001s)
[914.561279] [139/142] (159s left) gem_blits (basic)
[914.782624] Starting subtest: basic
[928.861321] Subtest basic: SUCCESS (14.076s)
[928.976481] [140/142] (145s left) kms_cursor_crc (cursor-onscreen-256x85)
[929.303778] Starting subtest: cursor-onscreen-256x85
[929.315546] Starting dynamic subtest: pipe-A-DP-1
[931.663262] Dynamic subtest pipe-A-DP-1: SUCCESS (2.345s)
[931.768526] Starting dynamic subtest: pipe-C-DP-1
[934.433978] Dynamic subtest pipe-C-DP-1: SUCCESS (2.678s)
[934.435450] Subtest cursor-onscreen-256x85: SUCCESS (5.120s)
[934.790814] [141/142] (139s left) gem_readwrite (read-bad-handle)
[935.002092] Starting subtest: read-bad-handle
[935.004731] Subtest read-bad-handle: SUCCESS (0.000s)
[935.120515] [142/142] (139s left) kms_flip (plain-flip-fb-recreate)
[935.414498] Starting subtest: plain-flip-fb-recreate
[935.421686] Starting dynamic subtest: A-DP1
[946.257602] Dynamic subtest A-DP1: SUCCESS (10.838s)
[946.288056] Starting dynamic subtest: B-DP1
[957.037486] Dynamic subtest B-DP1: SUCCESS (10.776s)
[957.068197] Starting dynamic subtest: C-DP1
[967.775817] Dynamic subtest C-DP1: SUCCESS (10.735s)
[967.780717] Subtest plain-flip-fb-recreate: SUCCESS (32.364s)
[968.190506] Closing watchdogs
Done.