[48.967883] Initializing watchdogs
[48.968506]   /dev/watchdog0
[48.999692] [001/142] (960s left) kms_flip (dpms-vs-vblank-race)
[49.435778] Starting subtest: dpms-vs-vblank-race
[49.464130] Starting dynamic subtest: A-eDP1
[54.598728] Dynamic subtest A-eDP1: SUCCESS (5.133s)
[54.624473] Starting dynamic subtest: B-eDP1
[58.839227] Dynamic subtest B-eDP1: SUCCESS (4.239s)
[58.865323] Starting dynamic subtest: C-eDP1
[62.811585] Dynamic subtest C-eDP1: SUCCESS (3.972s)
[62.835782] Starting dynamic subtest: D-eDP1
[66.747887] Dynamic subtest D-eDP1: SUCCESS (3.933s)
[66.769922] Subtest dpms-vs-vblank-race: SUCCESS (17.336s)
[67.695591] [002/142] (941s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[68.212573] Starting subtest: fbcpsr-tiling-y
[68.217090] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[68.356347] [003/142] (941s left) kms_big_fb (linear-64bpp-rotate-0)
[68.896275] Starting subtest: linear-64bpp-rotate-0
[76.060158] Subtest linear-64bpp-rotate-0: SUCCESS (7.163s)
[76.712597] [004/142] (932s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-render)
[77.189039] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-render
[89.957094] Subtest fbcpsr-1p-offscren-pri-indfb-draw-render: SUCCESS (12.771s)
[90.213489] [005/142] (919s left) kms_ccs (pipe-a-bad-aux-stride-yf_tiled_ccs)
[91.264055] Starting subtest: pipe-A-bad-aux-stride-yf_tiled_ccs
[91.268411] Subtest pipe-A-bad-aux-stride-yf_tiled_ccs: SKIP (0.000s)
[92.513878] [006/142] (917s left) i915_pm_lpsp (kms-lpsp)
[93.995529] Starting subtest: kms-lpsp
[93.997809] Starting dynamic subtest: kms-lpsp-eDP
[94.469582] Dynamic subtest kms-lpsp-eDP: SUCCESS (0.477s)
[94.861138] Subtest kms-lpsp: SUCCESS (0.868s)
[95.841139] [007/142] (914s left) gen9_exec_parse (shadow-peek)
[96.255257] Subtest shadow-peek: SKIP (0.000s)
[96.366938] [008/142] (913s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[96.874763] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[96.879583] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[97.021109] [009/142] (912s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[97.570614] Starting subtest: y-tiled-8bpp-rotate-0
[97.575608] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[97.725434] [010/142] (912s left) fbdev (nullptr)
[98.098622] Starting subtest: nullptr
[98.101328] Subtest nullptr: SUCCESS (0.000s)
[98.250251] [011/142] (911s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[98.760054] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[98.764477] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.001s)
[98.915876] [012/142] (911s left) kms_content_protection (dp-mst-type-0)
[99.608397] Starting subtest: dp-mst-type-0
[99.613694] Subtest dp-mst-type-0: SKIP (0.000s)
[99.790067] [013/142] (910s left) i915_suspend (fence-restore-untiled)
[100.166272] Starting subtest: fence-restore-untiled
[100.170702] Subtest fence-restore-untiled: SKIP (0.000s)
[100.287517] [014/142] (910s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[100.775992] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[100.783869] Starting dynamic subtest: pipe-A-default-mode
[101.259222] Dynamic subtest pipe-A-default-mode: SKIP (0.473s)
[101.263600] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.484s)
[102.111539] [015/142] (908s left) kms_ccs (pipe-a-crc-primary-basic-y_tiled_gen12_rc_ccs)
[103.032195] Starting subtest: pipe-A-crc-primary-basic-y_tiled_gen12_rc_ccs
[103.036746] Subtest pipe-A-crc-primary-basic-y_tiled_gen12_rc_ccs: SKIP (0.002s)
[104.501863] [016/142] (905s left) i915_pm_rpm (sysfs-read)
[110.584434] Starting subtest: sysfs-read
[114.558215] Subtest sysfs-read: SUCCESS (3.965s)
[115.414627] [017/142] (895s left) kms_ccs (pipe-a-bad-rotation-90-4_tiled_mtl_mc_ccs)
[116.306549] Starting subtest: pipe-A-bad-rotation-90-4_tiled_mtl_mc_ccs
[119.439165] Subtest pipe-A-bad-rotation-90-4_tiled_mtl_mc_ccs: SUCCESS (3.127s)
[121.369348] [018/142] (889s left) kms_color (ctm-blue-to-red)
[121.841395] Starting subtest: ctm-blue-to-red
[121.844109] Starting dynamic subtest: pipe-A
[123.052614] Dynamic subtest pipe-A: SUCCESS (1.209s)
[123.095869] Starting dynamic subtest: pipe-B
[124.991645] Dynamic subtest pipe-B: SUCCESS (1.937s)
[125.021545] Starting dynamic subtest: pipe-C
[127.165180] Dynamic subtest pipe-C: SUCCESS (2.172s)
[127.195177] Starting dynamic subtest: pipe-D
[128.949646] Dynamic subtest pipe-D: SUCCESS (1.782s)
[128.952239] Subtest ctm-blue-to-red: SUCCESS (7.109s)
[129.887546] [019/142] (880s left) kms_ccs (pipe-c-missing-ccs-buffer-y_tiled_gen12_mc_ccs)
[131.350699] Starting subtest: pipe-C-missing-ccs-buffer-y_tiled_gen12_mc_ccs
[131.355265] Subtest pipe-C-missing-ccs-buffer-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[132.238184] [020/142] (878s left) kms_psr (psr2_cursor_blt)
[132.735583] Starting subtest: psr2_cursor_blt
[135.722433] Subtest psr2_cursor_blt: SUCCESS (2.984s)
[136.658418] [021/142] (874s left) perf_pmu (init-busy)
[137.053191] Starting subtest: init-busy
[137.056259] Starting dynamic subtest: rcs0
[137.064173] Dynamic subtest rcs0: SUCCESS (0.007s)
[137.103346] Starting dynamic subtest: bcs0
[137.106155] Dynamic subtest bcs0: SUCCESS (0.003s)
[137.139692] Starting dynamic subtest: vcs0
[137.142583] Dynamic subtest vcs0: SUCCESS (0.003s)
[137.173448] Starting dynamic subtest: vcs1
[137.175750] Dynamic subtest vcs1: SUCCESS (0.002s)
[137.206154] Starting dynamic subtest: vecs0
[137.208395] Dynamic subtest vecs0: SUCCESS (0.002s)
[137.238677] Starting dynamic subtest: ccs0
[137.241055] Dynamic subtest ccs0: SUCCESS (0.002s)
[137.243239] Subtest init-busy: SUCCESS (0.041s)
[137.291154] [022/142] (873s left) gem_create (create-ext-cpu-access-big)
[137.825138] Starting subtest: create-ext-cpu-access-big
[137.829774] Subtest create-ext-cpu-access-big: SKIP (0.002s)
[137.963952] [023/142] (873s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[138.506365] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[138.511092] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[138.658189] [024/142] (872s left) kms_cursor_crc (cursor-onscreen-32x10)
[139.354549] Starting subtest: cursor-onscreen-32x10
[139.645337] Subtest cursor-onscreen-32x10: SKIP (0.285s)
[140.521772] [025/142] (870s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[141.033104] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[141.037606] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.001s)
[141.189248] [026/142] (870s left) kms_lease (lease_again)
[141.668402] Starting subtest: lease_again
[141.671703] Starting dynamic subtest: pipe-A-eDP-1
[141.682570] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.009s)
[141.713697] Starting dynamic subtest: pipe-B-eDP-1
[141.715801] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[141.746225] Starting dynamic subtest: pipe-C-eDP-1
[141.748535] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.005s)
[141.781550] Starting dynamic subtest: pipe-D-eDP-1
[141.783798] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.005s)
[141.786263] Subtest lease_again: SUCCESS (0.055s)
[141.881204] [027/142] (869s left) i915_pm_rps (basic-api)
[142.285208] Starting subtest: basic-api
[142.289698] Subtest basic-api: SKIP (0.003s)
[142.429815] [028/142] (868s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[142.833571] Starting subtest: x-tiled-to-vebox-y-tiled
[142.836939] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[143.108263] [029/142] (868s left) kms_vblank (pipe-c-query-forked-busy)
[143.600762] Starting subtest: pipe-C-query-forked-busy
[147.063657] Subtest pipe-C-query-forked-busy: SUCCESS (3.459s)
[147.983717] [030/142] (863s left) gem_flink_basic (double-flink)
[148.352399] Starting subtest: double-flink
[148.355768] Subtest double-flink: SUCCESS (0.000s)
[148.502112] [031/142] (863s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[149.065340] Starting subtest: basic-flip-before-cursor-atomic
[150.501143] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.433s)
[151.439508] [032/142] (860s left) kms_flip (2x-flip-vs-panning)
[151.826278] Starting subtest: 2x-flip-vs-panning
[151.987451] Subtest 2x-flip-vs-panning: SKIP (0.161s)
[152.169808] [033/142] (859s left) drm_fdinfo (virtual-busy-all)
[152.554698] Starting subtest: virtual-busy-all
[152.559347] Subtest virtual-busy-all: SKIP (0.001s)
[152.678937] [034/142] (859s left) perf_pmu (busy-no-semaphores)
[153.066622] Starting subtest: busy-no-semaphores
[153.069356] Starting dynamic subtest: rcs0
[153.638486] Dynamic subtest rcs0: SUCCESS (0.568s)
[153.673061] Starting dynamic subtest: bcs0
[154.215293] Dynamic subtest bcs0: SUCCESS (0.573s)
[154.249810] Starting dynamic subtest: vcs0
[154.793300] Dynamic subtest vcs0: SUCCESS (0.575s)
[154.828133] Starting dynamic subtest: vcs1
[156.046353] Dynamic subtest vcs1: SUCCESS (1.250s)
[156.081600] Starting dynamic subtest: vecs0
[158.094625] Dynamic subtest vecs0: SUCCESS (2.045s)
[158.129805] Starting dynamic subtest: ccs0
[160.077108] Dynamic subtest ccs0: SUCCESS (1.980s)
[160.079465] Subtest busy-no-semaphores: SUCCESS (7.011s)
[160.293306] [035/142] (851s left) gem_exec_balancer (bonded-dual)
[160.723984] Starting subtest: bonded-dual
[160.728530] Subtest bonded-dual: SKIP (0.000s)
[161.738238] [036/142] (850s left) gem_tiled_blits (basic)
[162.136113] Subtest basic: SKIP (0.000s)
[162.260880] [037/142] (849s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[162.778149] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[175.468332] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (12.688s)
[175.726651] [038/142] (836s left) kms_ccs (pipe-d-missing-ccs-buffer-y_tiled_gen12_rc_ccs)
[177.432603] Starting subtest: pipe-D-missing-ccs-buffer-y_tiled_gen12_rc_ccs
[177.437414] Subtest pipe-D-missing-ccs-buffer-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[178.082412] [039/142] (834s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[178.569180] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[178.574136] Starting dynamic subtest: pipe-A-eDP-1
[180.830223] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.256s)
[180.878412] Starting dynamic subtest: pipe-B-eDP-1
[184.360245] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.517s)
[184.407182] Starting dynamic subtest: pipe-C-eDP-1
[187.936062] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.565s)
[187.979584] Starting dynamic subtest: pipe-D-eDP-1
[191.286265] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.338s)
[191.288582] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (12.722s)
[192.648871] [040/142] (819s left) gem_userptr_blits (dmabuf-sync)
[193.095887] Starting subtest: dmabuf-sync
[193.110222] Subtest dmabuf-sync: SKIP (0.012s)
[193.330359] [041/142] (818s left) kms_atomic (plane-cursor-legacy)
[194.135131] Starting subtest: plane-cursor-legacy
[194.271086] Subtest plane-cursor-legacy: SUCCESS (0.136s)
[195.646825] [042/142] (816s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[196.130387] Starting subtest: coverage-vs-premult-vs-constant
[197.912729] Starting dynamic subtest: pipe-A-eDP-1
[198.917205] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.004s)
[198.962356] Starting dynamic subtest: pipe-D-eDP-1
[200.671099] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.744s)
[200.673533] Subtest coverage-vs-premult-vs-constant: SUCCESS (4.544s)
[201.616192] [043/142] (810s left) gem_ctx_exec (basic-norecovery)
[201.999733] Starting subtest: basic-norecovery
[204.301867] Subtest basic-norecovery: SUCCESS (2.300s)
[204.484912] [044/142] (808s left) gem_madvise (dontneed-before-exec)
[204.851992] Starting subtest: dontneed-before-exec
[204.863401] Subtest dontneed-before-exec: SKIP (0.009s)
[205.008440] [045/142] (807s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[205.524191] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[205.528584] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[205.691943] [046/142] (807s left) kms_ccs (pipe-d-bad-pixel-format-4_tiled_mtl_mc_ccs)
[207.295049] Starting subtest: pipe-D-bad-pixel-format-4_tiled_mtl_mc_ccs
[207.302160] Subtest pipe-D-bad-pixel-format-4_tiled_mtl_mc_ccs: SUCCESS (0.006s)
[208.096907] [047/142] (804s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[208.602670] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[208.607061] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[208.776182] [048/142] (804s left) vgem_basic (unload)
[209.131613] Starting subtest: unload
[238.474364] Subtest unload: SUCCESS (29.340s)
[238.732579] [049/142] (774s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[239.232292] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[239.238714] Starting dynamic subtest: pipe-A-eDP-1
[239.360768] Dynamic subtest pipe-A-eDP-1: SKIP (0.119s)
[239.411170] Starting dynamic subtest: pipe-B-eDP-1
[239.587825] Dynamic subtest pipe-B-eDP-1: SKIP (0.213s)
[239.634176] Starting dynamic subtest: pipe-C-eDP-1
[239.828582] Dynamic subtest pipe-C-eDP-1: SKIP (0.230s)
[239.875328] Starting dynamic subtest: pipe-D-eDP-1
[240.069226] Dynamic subtest pipe-D-eDP-1: SKIP (0.228s)
[240.072647] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.837s)
[240.236471] [050/142] (772s left) vc4/vc4_label_bo (set-bad-name)
[240.701715] Subtest set-bad-name: SKIP (0.000s)
[240.834720] [051/142] (772s left) gem_lmem_swapping (random)
[241.210139] Subtest random: SKIP (0.000s)
[241.325181] [052/142] (771s left) gem_exec_schedule (noreorder)
[241.924264] Starting subtest: noreorder
[241.926773] Starting dynamic subtest: rcs0
[242.026898] Dynamic subtest rcs0: SUCCESS (0.106s)
[242.076440] Starting dynamic subtest: bcs0
[242.119293] Dynamic subtest bcs0: SUCCESS (0.087s)
[242.177612] Starting dynamic subtest: vcs0
[243.536243] Dynamic subtest vcs0: SUCCESS (1.408s)
[243.579137] Starting dynamic subtest: vcs1
[245.527297] Dynamic subtest vcs1: SUCCESS (1.987s)
[245.569670] Starting dynamic subtest: vecs0
[247.571503] Dynamic subtest vecs0: SUCCESS (2.039s)
[247.611144] Starting dynamic subtest: ccs0
[247.661751] Dynamic subtest ccs0: SUCCESS (0.089s)
[247.664209] Subtest noreorder: SUCCESS (5.745s)
[247.969155] [053/142] (765s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[248.486249] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[248.490814] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[248.644242] [054/142] (764s left) gem_ctx_sseu (engines)
[249.031248] Subtest engines: SKIP (0.000s)
[249.147749] [055/142] (764s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[249.567807] Starting subtest: yf-tiled-16bpp-rotate-0
[249.573162] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[249.720895] [056/142] (763s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[250.222874] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[250.227591] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.001s)
[250.391601] [057/142] (763s left) gem_exec_params (invalid-fence-in)
[250.789478] Starting subtest: invalid-fence-in
[250.791961] Subtest invalid-fence-in: SUCCESS (0.002s)
[250.960531] [058/142] (762s left) kms_ccs (pipe-b-random-ccs-data-4_tiled_mtl_rc_ccs)
[251.903840] Starting subtest: pipe-B-random-ccs-data-4_tiled_mtl_rc_ccs
[252.660386] Subtest pipe-B-random-ccs-data-4_tiled_mtl_rc_ccs: SUCCESS (0.756s)
[254.238917] [059/142] (759s left) gem_exec_whisper (basic-contexts-priority-all)
[254.674695] Starting subtest: basic-contexts-priority-all
[375.753935] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[385.406741] Closing watchdogs
[385.419108] Initializing watchdogs
[385.419417]   /dev/watchdog0
[385.473834] [060/142] (628s left) gem_exec_balancer (sequential)
[385.903401] Starting subtest: sequential
[394.757188] Subtest sequential: SUCCESS (8.853s)
[395.780313] [061/142] (618s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc)
[396.883182] Starting subtest: pipe-A-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc
[400.372323] Subtest pipe-A-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc: SUCCESS (3.489s)
[402.138463] [062/142] (611s left) prime_vgem (fence-write-hang)
[402.544364] Subtest fence-write-hang: SKIP (0.000s)
[402.707106] [063/142] (611s left) kms_psr (psr2_suspend)
[403.192729] Starting subtest: psr2_suspend
[424.690258] Subtest psr2_suspend: SUCCESS (21.493s)
[430.607873] [064/142] (588s left) gem_pread (exhaustion)
[430.980369] Subtest exhaustion: SKIP (0.000s)
[431.119720] [065/142] (588s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[431.652094] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[474.892153] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (43.239s)
[475.145834] [066/142] (544s left) gem_exec_reloc (basic-cpu)
[475.557774] Subtest basic-cpu: SKIP (0.000s)
[475.701652] [067/142] (543s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[476.080101] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[476.082695] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.004s)
[476.227739] [068/142] (543s left) kms_chamelium_color (ctm-green-to-red)
[476.715329] Subtest ctm-green-to-red: SKIP (0.000s)
[476.848971] [069/142] (542s left) api_intel_allocator (two-level-inception-interruptible)
[477.227297] Starting subtest: two-level-inception-interruptible
[482.898252] Subtest two-level-inception-interruptible: SUCCESS (5.669s)
[483.074422] [070/142] (536s left) kms_psr (no_drrs)
[483.570549] Starting subtest: no_drrs
[486.462653] Subtest no_drrs: SUCCESS (2.897s)
[487.346878] [071/142] (532s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[487.484442] Starting subtest: multi-wait-for-submit-unsubmitted
[487.585627] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[487.665083] [072/142] (532s left) gem_softpin (safe-alignment)
[487.801557] Starting subtest: safe-alignment
[487.839073] Subtest safe-alignment: SUCCESS (0.037s)
[489.688595] [073/142] (530s left) v3d/v3d_submit_csd (bad-flag)
[490.164116] Subtest bad-flag: SKIP (0.000s)
[490.311805] [074/142] (529s left) kms_ccs (pipe-b-bad-rotation-90-y_tiled_gen12_rc_ccs)
[491.438360] Starting subtest: pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs
[491.442433] Subtest pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[492.621406] [075/142] (527s left) gen7_exec_parse (oacontrol-tracking)
[493.013105] Subtest oacontrol-tracking: SKIP (0.000s)
[493.138364] [076/142] (527s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-render)
[493.618227] Starting subtest: fbc-1p-offscren-pri-indfb-draw-render
[502.270655] Subtest fbc-1p-offscren-pri-indfb-draw-render: SUCCESS (8.655s)
[502.533859] [077/142] (517s left) gem_ringfill (legacy-basic)
[508.548560] Starting subtest: legacy-basic
[508.551483] Starting dynamic subtest: default
[508.618363] Dynamic subtest default: SUCCESS (0.067s)
[508.676430] Starting dynamic subtest: render
[508.678746] Dynamic subtest render: SUCCESS (0.052s)
[508.731794] Starting dynamic subtest: bsd
[510.517239] Dynamic subtest bsd: SUCCESS (1.835s)
[510.570164] Starting dynamic subtest: bsd1
[512.501656] Dynamic subtest bsd1: SUCCESS (1.979s)
[512.554154] Starting dynamic subtest: bsd2
[514.486713] Dynamic subtest bsd2: SUCCESS (1.979s)
[514.539335] Starting dynamic subtest: blt
[514.547153] Dynamic subtest blt: SUCCESS (0.054s)
[514.599554] Starting dynamic subtest: vebox
[516.533480] Dynamic subtest vebox: SUCCESS (1.984s)
[516.536211] Subtest legacy-basic: SUCCESS (7.985s)
[516.723184] [078/142] (503s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[517.279107] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[520.154309] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (2.872s)
[520.462583] [079/142] (499s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[520.962743] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[535.371202] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (14.407s)
[535.637155] [080/142] (484s left) gem_userptr_blits (stress-mm)
[536.097225] Starting subtest: stress-mm
[541.472169] Subtest stress-mm: SUCCESS (5.373s)
[541.680544] [081/142] (478s left) kms_ccs (pipe-d-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc)
[543.373198] Starting subtest: pipe-D-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc
[543.381581] Subtest pipe-D-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc: SKIP (0.002s)
[544.108094] [082/142] (476s left) syncobj_timeline (invalid-multi-wait-all-available-unsubmitted-signaled)
[544.489437] Starting subtest: invalid-multi-wait-all-available-unsubmitted-signaled
[544.491869] Subtest invalid-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.003s)
[544.652148] [083/142] (476s left) kms_display_modes (mst-extended-mode-negative)
[545.154240] Starting subtest: mst-extended-mode-negative
[545.159727] Subtest mst-extended-mode-negative: SKIP (0.000s)
[545.287360] [084/142] (475s left) gem_ctx_persistence (hostile)
[545.687128] Starting subtest: hostile
[545.786683] Subtest hostile: SUCCESS (0.095s)
[545.967594] [085/142] (475s left) gem_mmap_wc (write-cpu-read-wc)
[546.335207] Subtest write-cpu-read-wc: SKIP (0.000s)
[546.459919] [086/142] (474s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[546.948434] Starting subtest: basic-max-pipe-crc-check
[546.953325] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[547.076770] [087/142] (474s left) kms_flip (flip-vs-fences)
[547.475390] Starting subtest: flip-vs-fences
[547.479600] Subtest flip-vs-fences: SKIP (0.000s)
[547.688838] [088/142] (473s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[548.189188] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[548.194212] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[548.368357] [089/142] (473s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[548.941580] Starting subtest: 2x-long-cursor-vs-flip-atomic
[548.958212] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.017s)
[549.295448] [090/142] (472s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[549.798713] Starting subtest: fbc-2p-pri-indfb-multidraw
[549.803255] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[549.966404] [091/142] (471s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[550.466340] Starting subtest: psr-2p-primscrn-cur-indfb-move
[550.470560] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[550.645234] [092/142] (471s left) gem_exec_fair (basic-none-solo)
[551.053529] Subtest basic-none-solo: SKIP (0.000s)
[551.195397] [093/142] (470s left) sw_sync (alloc_fence_invalid_timeline)
[551.569448] Starting subtest: alloc_fence_invalid_timeline
[551.571881] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[551.707134] [094/142] (470s left) gem_mmap_gtt (zero-extend)
[552.074911] Subtest zero-extend: SKIP (0.000s)
[552.205809] [095/142] (469s left) gem_tiled_swapping (non-threaded)
[552.568393] Subtest non-threaded: SKIP (0.000s)
[552.690058] [096/142] (469s left) kms_ccs (pipe-c-crc-primary-basic-4_tiled_mtl_mc_ccs)
[554.103797] Starting subtest: pipe-C-crc-primary-basic-4_tiled_mtl_mc_ccs
[562.501317] Subtest pipe-C-crc-primary-basic-4_tiled_mtl_mc_ccs: SUCCESS (8.397s)
[563.927086] [097/142] (458s left) i915_query (query-topology-unsupported)
[564.308148] Starting subtest: query-topology-unsupported
[564.312978] Subtest query-topology-unsupported: SKIP (0.000s)
[564.462671] [098/142] (457s left) vc4/vc4_wait_bo (bad-pad)
[564.939723] Subtest bad-pad: SKIP (0.000s)
[565.078134] [099/142] (457s left) kms_ccs (pipe-c-bad-pixel-format-4_tiled_mtl_rc_ccs)
[566.420231] Starting subtest: pipe-C-bad-pixel-format-4_tiled_mtl_rc_ccs
[566.422720] Subtest pipe-C-bad-pixel-format-4_tiled_mtl_rc_ccs: SUCCESS (0.001s)
[567.485100] [100/142] (454s left) sw_sync (sync_busy)
[567.860435] Starting subtest: sync_busy
[567.874780] Subtest sync_busy: SUCCESS (0.015s)
[568.024473] [101/142] (454s left) perf (enable-disable)
[568.940973] Starting subtest: enable-disable
[568.943518] Starting dynamic subtest: 0-rcs0
[572.692898] Dynamic subtest 0-rcs0: SUCCESS (3.747s)
[572.720670] Starting dynamic subtest: 1-vcs0
[578.042411] Dynamic subtest 1-vcs0: SUCCESS (5.339s)
[578.045166] Subtest enable-disable: SUCCESS (9.099s)
[578.130884] [102/142] (444s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[578.662993] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[582.306293] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (3.640s)
[582.856288] [103/142] (439s left) kms_vblank (pipe-a-ts-continuation-modeset)
[583.329387] Starting subtest: pipe-A-ts-continuation-modeset
[585.170133] Subtest pipe-A-ts-continuation-modeset: SUCCESS (1.840s)
[586.139938] [104/142] (436s left) kms_ccs (pipe-b-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs)
[587.443975] Starting subtest: pipe-B-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs
[587.459636] Subtest pipe-B-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs: SKIP (0.014s)
[588.419351] [105/142] (434s left) kms_plane_scaling (plane-upscale-with-pixel-format-20x20)
[588.903213] Starting subtest: plane-upscale-with-pixel-format-20x20
[588.909086] Starting dynamic subtest: pipe-A-eDP-1
[593.153127] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.244s)
[593.219662] Starting dynamic subtest: pipe-B-eDP-1
[598.748666] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.583s)
[598.816402] Starting dynamic subtest: pipe-C-eDP-1
[600.483648] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.722s)
[600.542111] Starting dynamic subtest: pipe-D-eDP-1
[602.200596] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.706s)
[602.203421] Subtest plane-upscale-with-pixel-format-20x20: SUCCESS (13.303s)
[603.779194] [106/142] (419s left) kms_ccs (pipe-d-bad-pixel-format-yf_tiled_ccs)
[605.204623] Starting subtest: pipe-D-bad-pixel-format-yf_tiled_ccs
[605.209132] Subtest pipe-D-bad-pixel-format-yf_tiled_ccs: SKIP (0.000s)
[605.754547] [107/142] (417s left) gem_fenced_exec_thrash (too-many-fences)
[606.150655] Subtest too-many-fences: SKIP (0.000s)
[606.289613] [108/142] (416s left) gem_tiled_pread_pwrite
[606.795100] [109/142] (416s left) vgem_basic (create)
[607.175713] Starting subtest: create
[607.178285] Subtest create: SUCCESS (0.001s)
[607.319647] [110/142] (416s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[607.828679] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[615.890756] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (8.062s)
[616.146220] [111/142] (407s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[616.649721] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[616.654621] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[616.833725] [112/142] (406s left) kms_flip (2x-nonexisting-fb-interruptible)
[617.245720] Starting subtest: 2x-nonexisting-fb-interruptible
[617.414250] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.164s)
[617.599646] [113/142] (406s left) kms_flip (2x-flip-vs-rmfb)
[617.986115] Starting subtest: 2x-flip-vs-rmfb
[618.148122] Subtest 2x-flip-vs-rmfb: SKIP (0.163s)
[618.362509] [114/142] (405s left) gem_exec_schedule (independent)
[618.796650] Starting subtest: independent
[618.798742] Starting dynamic subtest: rcs0
[620.540387] Dynamic subtest rcs0: SUCCESS (1.740s)
[620.598617] Starting dynamic subtest: bcs0
[622.528755] Dynamic subtest bcs0: SUCCESS (1.984s)
[622.587197] Starting dynamic subtest: vcs0
[624.554255] Dynamic subtest vcs0: SUCCESS (2.020s)
[624.606903] Starting dynamic subtest: vcs1
[626.542628] Dynamic subtest vcs1: SUCCESS (1.983s)
[626.599755] Starting dynamic subtest: vecs0
[628.591263] Dynamic subtest vecs0: SUCCESS (2.044s)
[628.645700] Starting dynamic subtest: ccs0
[630.527733] Dynamic subtest ccs0: SUCCESS (1.932s)
[630.530809] Subtest independent: SUCCESS (11.731s)
[631.007946] [115/142] (392s left) prime_busy (before)
[631.415286] Starting subtest: before
[631.447980] Starting dynamic subtest: rcs0
[631.477370] Dynamic subtest rcs0: SUCCESS (0.029s)
[631.537227] Starting dynamic subtest: bcs0
[631.539819] Dynamic subtest bcs0: SUCCESS (0.046s)
[631.594246] Starting dynamic subtest: vcs0
[631.596669] Dynamic subtest vcs0: SUCCESS (0.043s)
[631.651634] Starting dynamic subtest: vcs1
[631.653761] Dynamic subtest vcs1: SUCCESS (0.021s)
[631.706466] Starting dynamic subtest: vecs0
[631.708697] Dynamic subtest vecs0: SUCCESS (0.025s)
[631.761243] Starting dynamic subtest: ccs0
[631.763971] Dynamic subtest ccs0: SUCCESS (0.025s)
[631.786189] Subtest before: SUCCESS (0.372s)
[631.977908] [116/142] (391s left) syncobj_wait (single-wait-all-for-submit-submitted)
[632.358357] Starting subtest: single-wait-all-for-submit-submitted
[632.468952] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.109s)
[632.656665] [117/142] (391s left) syncobj_wait (single-wait-for-submit-signaled)
[633.033662] Starting subtest: single-wait-for-submit-signaled
[633.040323] Subtest single-wait-for-submit-signaled: SUCCESS (0.003s)
[633.229754] [118/142] (390s left) syncobj_timeline (single-wait-for-submit-signaled)
[633.605696] Starting subtest: single-wait-for-submit-signaled
[633.608238] Subtest single-wait-for-submit-signaled: SUCCESS (0.002s)
[633.801103] [119/142] (390s left) gem_ppgtt (flink-and-close-vma-leak)
[634.197322] Starting subtest: flink-and-close-vma-leak
[634.256584] Subtest flink-and-close-vma-leak: SUCCESS (0.060s)
[634.476143] [120/142] (389s left) kms_universal_plane (universal-plane-pageflip-windowed-pipe-a)
[634.980178] Starting subtest: universal-plane-pageflip-windowed-pipe-A
[635.929634] Subtest universal-plane-pageflip-windowed-pipe-A: SUCCESS (0.951s)
[636.886948] [121/142] (387s left) kms_ccs (pipe-a-random-ccs-data-y_tiled_gen12_rc_ccs_cc)
[637.867170] Starting subtest: pipe-A-random-ccs-data-y_tiled_gen12_rc_ccs_cc
[637.873573] Subtest pipe-A-random-ccs-data-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[639.269462] [122/142] (385s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[639.649222] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[639.776234] [123/142] (384s left) kms_writeback (writeback-check-output)
[640.355624] Subtest writeback-check-output: SKIP (0.000s)
[640.483817] [124/142] (384s left) kms_chamelium_frames (hdmi-aspect-ratio)
[641.369589] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[642.248783] [125/142] (382s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[642.872199] Starting subtest: cursor-rapid-movement-32x32
[643.174748] Subtest cursor-rapid-movement-32x32: SKIP (0.297s)
[644.143317] [126/142] (380s left) kms_cursor_edge_walk (128x128-left-edge)
[644.629359] Starting subtest: 128x128-left-edge
[644.636126] Starting dynamic subtest: pipe-A-eDP-1
[648.610797] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.974s)
[648.675673] Starting dynamic subtest: pipe-D-eDP-1
[652.047402] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.421s)
[652.049652] Subtest 128x128-left-edge: SUCCESS (7.418s)
[653.005588] [127/142] (371s left) gem_exec_fence (submit)
[653.599667] Starting subtest: submit
[653.604271] Subtest submit: SKIP (0.000s)
[655.711271] [128/142] (369s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[656.243451] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[656.248858] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[656.431379] [129/142] (368s left) gem_exec_schedule (submit-late-slice)
[656.882466] Starting subtest: submit-late-slice
[656.885119] Starting dynamic subtest: rcs0
[657.033304] Dynamic subtest rcs0: SUCCESS (0.146s)
[657.089279] Starting dynamic subtest: bcs0
[657.165210] Dynamic subtest bcs0: SUCCESS (0.129s)
[657.225413] Starting dynamic subtest: vcs0
[657.293713] Dynamic subtest vcs0: SUCCESS (0.125s)
[657.353086] Starting dynamic subtest: vcs1
[657.420625] Dynamic subtest vcs1: SUCCESS (0.123s)
[657.468636] Starting dynamic subtest: vecs0
[657.555768] Dynamic subtest vecs0: SUCCESS (0.130s)
[657.619786] Starting dynamic subtest: ccs0
[657.690341] Dynamic subtest ccs0: SUCCESS (0.131s)
[657.692839] Subtest submit-late-slice: SUCCESS (0.810s)
[658.757811] [130/142] (366s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[659.273482] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[659.278139] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[659.447958] [131/142] (365s left) api_intel_bb (simple-bb-ctx)
[659.823963] Starting subtest: simple-bb-ctx
[659.848238] Subtest simple-bb-ctx: SUCCESS (0.026s)
[660.036951] [132/142] (365s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[660.607118] Starting subtest: cursorB-vs-flipB-toggle
[660.616565] Subtest cursorB-vs-flipB-toggle: SKIP (0.009s)
[660.951962] [133/142] (364s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[661.471620] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[661.476213] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[661.653800] [134/142] (363s left) gem_mmap_gtt (cpuset-big-copy)
[662.030168] Subtest cpuset-big-copy: SKIP (0.000s)
[662.154363] [135/142] (363s left) vc4/vc4_purgeable_bo (mark-purgeable-twice)
[662.620541] Subtest mark-purgeable-twice: SKIP (0.000s)
[662.761439] [136/142] (363s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[663.268132] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[663.272328] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[663.454435] [137/142] (362s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[663.955545] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[663.960184] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[664.143417] [138/142] (361s left) i915_pm_backlight (bad-brightness)
[664.632672] Starting subtest: bad-brightness
[664.994617] Starting dynamic subtest: eDP-1
[665.463647] Dynamic subtest eDP-1: SUCCESS (0.469s)
[665.466638] Subtest bad-brightness: SUCCESS (0.831s)
[666.431305] [139/142] (359s left) syncobj_timeline (wait-any-interrupted)
[666.813051] Starting subtest: wait-any-interrupted
[666.916348] Subtest wait-any-interrupted: SUCCESS (0.103s)
[667.072545] [140/142] (359s left) kms_addfb_basic (size-max)
[667.559497] Starting subtest: size-max
[667.562144] Subtest size-max: SUCCESS (0.000s)
[667.739378] [141/142] (358s left) v3d/v3d_get_bo_offset (get-bad-handle)
[668.206062] Subtest get-bad-handle: SKIP (0.000s)
[668.347963] [142/142] (358s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[668.739896] Starting subtest: invalid-multi-wait-unsubmitted
[668.742837] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.001s)
[668.893895] Closing watchdogs
Done.