[51.475339] Initializing watchdogs
[51.475786]   /dev/watchdog0
[51.508863] [001/142] (960s left) i915_pm_freq_api (freq-suspend)
[51.961106] Starting subtest: freq-suspend
[51.964054] Starting dynamic subtest: gt0
[52.081819] Dynamic subtest gt0: SKIP (0.114s)
[52.107251] Starting dynamic subtest: gt1
[52.187437] Dynamic subtest gt1: SKIP (0.105s)
[52.193826] Subtest freq-suspend: SKIP (0.221s)
[52.354530] [002/142] (959s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_mtl_rc_ccs_cc)
[53.309423] Starting subtest: pipe-A-crc-primary-basic-4_tiled_mtl_rc_ccs_cc
[54.627888] Subtest pipe-A-crc-primary-basic-4_tiled_mtl_rc_ccs_cc: SUCCESS (1.323s)
[56.543234] [003/142] (955s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[57.049440] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[57.056164] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[57.210156] [004/142] (955s left) gem_eio (wait-wedge-immediate)
[58.050351] Starting subtest: wait-wedge-immediate
[59.724859] Subtest wait-wedge-immediate: SUCCESS (1.675s)
[61.594937] [005/142] (950s left) kms_ccs (pipe-b-ccs-on-another-bo-yf_tiled_ccs)
[62.574145] Starting subtest: pipe-B-ccs-on-another-bo-yf_tiled_ccs
[62.580551] Subtest pipe-B-ccs-on-another-bo-yf_tiled_ccs: SKIP (0.000s)
[63.387729] [006/142] (948s left) kms_getfb (getfb-reject-ccs)
[63.766889] Starting subtest: getfb-reject-ccs
[63.771144] Subtest getfb-reject-ccs: SUCCESS (0.002s)
[63.949324] [007/142] (948s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[64.508435] Starting subtest: cursor-vs-flip-toggle
[114.332605] Subtest cursor-vs-flip-toggle: SUCCESS (49.827s)
[115.276507] [008/142] (897s left) gem_lmem_swapping (parallel-random-verify)
[115.674178] Subtest parallel-random-verify: SKIP (0.000s)
[115.775441] [009/142] (896s left) i915_pm_rpm (gem-execbuf)
[121.885377] Starting subtest: gem-execbuf
[121.889105] Starting dynamic subtest: smem0
[124.631168] Dynamic subtest smem0: SUCCESS (2.741s)
[124.635225] Subtest gem-execbuf: SUCCESS (2.743s)
[124.808887] [010/142] (887s left) v3d/v3d_create_bo (create-bo-0)
[125.276773] Subtest create-bo-0: SKIP (0.000s)
[125.393383] [011/142] (887s left) gem_exec_reloc (basic-cpu-active)
[125.781889] Subtest basic-cpu-active: SKIP (0.000s)
[125.909112] [012/142] (886s left) kms_chamelium_frames (hdmi-crc-multiple)
[126.772919] Subtest hdmi-crc-multiple: SKIP (0.000s)
[127.636130] [013/142] (885s left) perf (non-system-wide-paranoid)
[128.517184] Starting subtest: non-system-wide-paranoid
[128.696993] Subtest non-system-wide-paranoid: SUCCESS (0.179s)
[128.796676] [014/142] (884s left) syncobj_timeline (multi-wait-all-available-signaled)
[129.171676] Starting subtest: multi-wait-all-available-signaled
[129.175314] Subtest multi-wait-all-available-signaled: SUCCESS (0.004s)
[129.309438] [015/142] (883s left) kms_content_protection (srm)
[129.993829] Starting subtest: srm
[134.121956] Subtest srm: SKIP (4.125s)
[135.635669] [016/142] (877s left) gem_close (many-handles-one-vma)
[136.026778] Starting subtest: many-handles-one-vma
[136.183293] Subtest many-handles-one-vma: SUCCESS (0.155s)
[136.329087] [017/142] (876s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[136.869402] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[139.728695] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (2.856s)
[140.090177] [018/142] (873s left) gem_softpin (allocator-fork)
[140.491702] Starting subtest: allocator-fork
[143.108836] Subtest allocator-fork: SUCCESS (2.617s)
[143.315163] [019/142] (870s left) syncobj_timeline (reset-signaled)
[143.682106] Starting subtest: reset-signaled
[143.685521] Subtest reset-signaled: SUCCESS (0.002s)
[143.849326] [020/142] (869s left) kms_addfb_basic (unused-pitches)
[144.214537] Starting subtest: unused-pitches
[144.217778] Subtest unused-pitches: SUCCESS (0.000s)
[144.493802] [021/142] (869s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[144.992999] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[144.999365] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[145.150231] [022/142] (868s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[145.636169] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[145.641954] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[145.794371] [023/142] (867s left) kms_ccs (pipe-d-missing-ccs-buffer-y_tiled_ccs)
[147.516489] Starting subtest: pipe-D-missing-ccs-buffer-y_tiled_ccs
[147.523170] Subtest pipe-D-missing-ccs-buffer-y_tiled_ccs: SKIP (0.000s)
[148.180245] [024/142] (865s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[148.551839] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[148.556112] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.002s)
[148.693585] [025/142] (865s left) kms_ccs (pipe-a-bad-rotation-90-y_tiled_gen12_rc_ccs_cc)
[149.568754] Starting subtest: pipe-A-bad-rotation-90-y_tiled_gen12_rc_ccs_cc
[149.575569] Subtest pipe-A-bad-rotation-90-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[151.000784] [026/142] (862s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[151.510583] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[151.517622] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[151.653066] [027/142] (862s left) kms_ccs (pipe-b-random-ccs-data-y_tiled_gen12_rc_ccs)
[152.858319] Starting subtest: pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs
[152.868299] Subtest pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[154.007685] [028/142] (860s left) gem_mmap_gtt (basic-small-copy)
[154.382800] Subtest basic-small-copy: SKIP (0.000s)
[154.494865] [029/142] (859s left) kms_ccs (pipe-d-bad-rotation-90-yf_tiled_ccs)
[156.104597] Starting subtest: pipe-D-bad-rotation-90-yf_tiled_ccs
[156.110824] Subtest pipe-D-bad-rotation-90-yf_tiled_ccs: SKIP (0.000s)
[156.849377] [030/142] (857s left) kms_vblank (pipe-b-wait-forked)
[157.322329] Starting subtest: pipe-B-wait-forked
[161.039975] Subtest pipe-B-wait-forked: SUCCESS (3.721s)
[161.985266] [031/142] (852s left) kms_lease (lease-uevent)
[162.457510] Starting subtest: lease-uevent
[163.499057] Subtest lease-uevent: SUCCESS (1.041s)
[163.636693] [032/142] (850s left) kms_flip (flip-vs-rmfb-interruptible)
[164.056381] Starting subtest: flip-vs-rmfb-interruptible
[164.090312] Starting dynamic subtest: A-eDP1
[173.339757] Dynamic subtest A-eDP1: SUCCESS (9.249s)
[173.378803] Starting dynamic subtest: B-eDP1
[182.404089] Dynamic subtest B-eDP1: SUCCESS (9.058s)
[182.440550] Starting dynamic subtest: C-eDP1
[191.441690] Dynamic subtest C-eDP1: SUCCESS (9.032s)
[191.478214] Starting dynamic subtest: D-eDP1
[200.503450] Dynamic subtest D-eDP1: SUCCESS (9.056s)
[200.528526] Subtest flip-vs-rmfb-interruptible: SUCCESS (36.472s)
[202.079815] [033/142] (812s left) gem_exec_fair (basic-none-share)
[202.495943] Subtest basic-none-share: SKIP (0.000s)
[202.632996] [034/142] (811s left) kms_flip (modeset-vs-vblank-race-interruptible)
[203.059791] Starting subtest: modeset-vs-vblank-race-interruptible
[203.086628] Starting dynamic subtest: A-eDP1
[208.649634] Dynamic subtest A-eDP1: SUCCESS (5.563s)
[208.689178] Starting dynamic subtest: B-eDP1
[214.010633] Dynamic subtest B-eDP1: SUCCESS (5.355s)
[214.063543] Starting dynamic subtest: C-eDP1
[219.435714] Dynamic subtest C-eDP1: SUCCESS (5.416s)
[219.477637] Starting dynamic subtest: D-eDP1
[224.869335] Dynamic subtest D-eDP1: SUCCESS (5.427s)
[224.896403] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (21.842s)
[226.458258] [035/142] (788s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[226.996326] Starting subtest: x-tiled-16bpp-rotate-90
[227.063358] Subtest x-tiled-16bpp-rotate-90: SKIP (0.059s)
[227.241500] [036/142] (787s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[227.748952] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[227.756133] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[227.901747] [037/142] (786s left) kms_prop_blob (blob-prop-lifetime)
[228.277480] Starting subtest: blob-prop-lifetime
[228.281364] Subtest blob-prop-lifetime: SUCCESS (0.004s)
[228.410159] [038/142] (786s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-pwrite)
[228.924602] Starting subtest: psr-1p-offscren-pri-shrfb-draw-pwrite
[245.142173] Subtest psr-1p-offscren-pri-shrfb-draw-pwrite: SUCCESS (16.226s)
[245.424770] [039/142] (769s left) perf (whitelisted-registers-userspace-config)
[246.041422] Starting subtest: whitelisted-registers-userspace-config
[246.045154] Subtest whitelisted-registers-userspace-config: SUCCESS (0.004s)
[246.141323] [040/142] (768s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[247.397324] Starting subtest: cursor-rapid-movement-512x170
[247.408670] Subtest cursor-rapid-movement-512x170: SKIP (0.007s)
[247.732342] [041/142] (767s left) kms_lease (lease_unleased_crtc)
[248.225302] Starting subtest: lease_unleased_crtc
[248.234644] Starting dynamic subtest: pipe-A-eDP-1
[248.652386] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.418s)
[248.696962] Starting dynamic subtest: pipe-B-eDP-1
[249.461274] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.804s)
[249.494226] Starting dynamic subtest: pipe-C-eDP-1
[249.498212] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.021s)
[249.520266] Starting dynamic subtest: pipe-D-eDP-1
[249.524387] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.019s)
[249.528816] Subtest lease_unleased_crtc: SUCCESS (1.293s)
[250.087934] [042/142] (765s left) prime_mmap (test_map_unmap)
[250.471883] Starting subtest: test_map_unmap
[250.475476] Starting dynamic subtest: test_map_unmap-smem
[250.989315] Dynamic subtest test_map_unmap-smem: SUCCESS (0.518s)
[250.993446] Subtest test_map_unmap: SUCCESS (0.524s)
[251.142302] [043/142] (764s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[251.512537] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[251.777119] [044/142] (763s left) gem_vm_create (invalid-destroy)
[252.182528] Starting subtest: invalid-destroy
[252.186634] Subtest invalid-destroy: SUCCESS (0.004s)
[252.351890] [045/142] (763s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[252.880356] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[252.887188] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[253.046347] [046/142] (762s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[253.565221] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[253.572212] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[253.728971] [047/142] (761s left) kms_universal_plane (cursor-fb-leak-pipe-b)
[254.221771] Starting subtest: cursor-fb-leak-pipe-B
[256.505083] Subtest cursor-fb-leak-pipe-B: SUCCESS (2.282s)
[257.432445] [048/142] (758s left) gem_tiled_fence_blits (basic)
[257.829894] Subtest basic: SKIP (0.000s)
[257.938522] [049/142] (757s left) gem_lmem_swapping (verify-random-ccs)
[258.329749] Subtest verify-random-ccs: SKIP (0.000s)
[258.443414] [050/142] (757s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[258.955682] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[269.463733] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (10.516s)
[269.775853] [051/142] (746s left) api_intel_allocator (reopen)
[270.163474] Starting subtest: reopen
[270.170215] Subtest reopen: SUCCESS (0.013s)
[270.351129] [052/142] (745s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[270.823876] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[270.833769] Starting dynamic subtest: pipe-A-default-mode
[271.247553] Dynamic subtest pipe-A-default-mode: SKIP (0.410s)
[271.253704] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.424s)
[272.183481] [053/142] (743s left) kms_ccs (pipe-c-ccs-on-another-bo-y_tiled_gen12_mc_ccs)
[273.667418] Starting subtest: pipe-C-ccs-on-another-bo-y_tiled_gen12_mc_ccs
[273.673069] Subtest pipe-C-ccs-on-another-bo-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[274.528550] [054/142] (741s left) sw_sync (sync_merge_invalid)
[274.902208] Starting subtest: sync_merge_invalid
[274.919910] Subtest sync_merge_invalid: SUCCESS (0.014s)
[275.031361] [055/142] (741s left) kms_frontbuffer_tracking (fbc-1p-rte)
[275.526765] Starting subtest: fbc-1p-rte
[283.615284] Subtest fbc-1p-rte: SUCCESS (8.095s)
[283.905283] [056/142] (732s left) kms_psr (psr2_no_drrs)
[284.381282] Starting subtest: psr2_no_drrs
[287.243458] Subtest psr2_no_drrs: SUCCESS (2.856s)
[288.152668] [057/142] (728s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[288.628857] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[288.638216] Starting dynamic subtest: pipe-A-eDP-1
[288.681828] Dynamic subtest pipe-A-eDP-1: SKIP (0.038s)
[288.726801] Starting dynamic subtest: pipe-B-eDP-1
[288.837154] Dynamic subtest pipe-B-eDP-1: SKIP (0.142s)
[288.878414] Starting dynamic subtest: pipe-C-eDP-1
[288.992396] Dynamic subtest pipe-C-eDP-1: SKIP (0.146s)
[289.035198] Starting dynamic subtest: pipe-D-eDP-1
[289.142478] Dynamic subtest pipe-D-eDP-1: SKIP (0.142s)
[289.149318] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.512s)
[289.308960] [058/142] (727s left) kms_ccs (pipe-c-bad-pixel-format-4_tiled_mtl_rc_ccs)
[290.654421] Starting subtest: pipe-C-bad-pixel-format-4_tiled_mtl_rc_ccs
[290.658262] Subtest pipe-C-bad-pixel-format-4_tiled_mtl_rc_ccs: SUCCESS (0.001s)
[291.672962] [059/142] (724s left) v3d/v3d_wait_bo (used-bo)
[292.123881] Subtest used-bo: SKIP (0.000s)
[292.252682] [060/142] (724s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[292.779569] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[292.785918] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[292.936515] [061/142] (723s left) syncobj_timeline (wait-any-complex)
[293.304746] Starting subtest: wait-any-complex
[293.372429] Subtest wait-any-complex: SUCCESS (0.068s)
[293.514668] [062/142] (723s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs)
[294.850232] Starting subtest: pipe-B-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs
[294.867125] Subtest pipe-B-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs: SKIP (0.013s)
[295.936409] [063/142] (720s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[296.490392] Starting subtest: cursorB-vs-flipA-atomic
[296.506466] Subtest cursorB-vs-flipA-atomic: SKIP (0.015s)
[296.828511] [064/142] (720s left) kms_big_joiner (basic)
[297.302222] Subtest basic: SKIP (0.000s)
[297.413785] [065/142] (719s left) gem_render_tiled_blits (basic)
[297.811418] Subtest basic: SKIP (0.000s)
[297.923524] [066/142] (719s left) gem_exec_reloc (basic-gtt-active)
[298.320869] Subtest basic-gtt-active: SKIP (0.000s)
[298.446682] [067/142] (718s left) gem_userptr_blits (coherency-unsync)
[298.844873] Subtest coherency-unsync: SKIP (0.000s)
[299.109559] [068/142] (718s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[299.980133] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[300.840705] [069/142] (716s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[301.241748] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[301.247766] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[301.510880] [070/142] (715s left) kms_ccs (pipe-b-bad-aux-stride-y_tiled_gen12_rc_ccs_cc)
[302.807820] Starting subtest: pipe-B-bad-aux-stride-y_tiled_gen12_rc_ccs_cc
[302.814070] Subtest pipe-B-bad-aux-stride-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[303.883604] [071/142] (713s left) perf_pmu (semaphore-wait-idle)
[304.275855] Starting subtest: semaphore-wait-idle
[304.279261] Starting dynamic subtest: rcs0
[304.809505] Dynamic subtest rcs0: SUCCESS (0.530s)
[304.850336] Starting dynamic subtest: bcs0
[305.332771] Dynamic subtest bcs0: SUCCESS (0.519s)
[305.371537] Starting dynamic subtest: vcs0
[305.853712] Dynamic subtest vcs0: SUCCESS (0.516s)
[305.893636] Starting dynamic subtest: vcs1
[306.375873] Dynamic subtest vcs1: SUCCESS (0.517s)
[306.419496] Starting dynamic subtest: vecs0
[306.898129] Dynamic subtest vecs0: SUCCESS (0.517s)
[306.939708] Starting dynamic subtest: ccs0
[307.422577] Dynamic subtest ccs0: SUCCESS (0.520s)
[307.425990] Subtest semaphore-wait-idle: SUCCESS (3.148s)
[308.672424] [072/142] (708s left) drm_fdinfo (most-busy-idle-check-all)
[309.064314] Starting subtest: most-busy-idle-check-all
[309.067638] Starting dynamic subtest: rcs0
[309.083516] Dynamic subtest rcs0: SKIP (0.013s)
[309.123450] Starting dynamic subtest: bcs0
[309.129526] Dynamic subtest bcs0: SKIP (0.003s)
[309.168423] Starting dynamic subtest: vcs0
[309.174562] Dynamic subtest vcs0: SKIP (0.003s)
[309.212355] Starting dynamic subtest: vcs1
[309.218675] Dynamic subtest vcs1: SKIP (0.002s)
[309.256357] Starting dynamic subtest: vecs0
[309.262909] Dynamic subtest vecs0: SKIP (0.002s)
[309.300351] Starting dynamic subtest: ccs0
[309.306913] Dynamic subtest ccs0: SKIP (0.002s)
[309.313458] Subtest most-busy-idle-check-all: SKIP (0.051s)
[309.373396] [073/142] (708s left) v3d/v3d_submit_csd (bad-multisync-out-sync)
[309.844156] Subtest bad-multisync-out-sync: SKIP (0.000s)
[309.978733] [074/142] (707s left) kms_selftest (drm_damage)
[310.333113] Starting subtest: drm_damage
[310.348794] Subtest drm_damage: SKIP (0.011s)
[310.495788] [075/142] (707s left) kms_atomic (test-only)
[311.296236] Starting subtest: test-only
[314.322135] Subtest test-only: SUCCESS (3.027s)
[315.267432] [076/142] (702s left) gem_exec_schedule (preempt-queue-contexts-chain)
[315.713606] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[316.136751] [077/142] (701s left) kms_vblank (pipe-d-query-idle)
[316.606257] Starting subtest: pipe-D-query-idle
[320.525823] Subtest pipe-D-query-idle: SUCCESS (3.916s)
[321.467522] [078/142] (696s left) kms_chamelium_color (ctm-0-75)
[321.944848] Subtest ctm-0-75: SKIP (0.000s)
[322.069667] [079/142] (696s left) kms_ccs (pipe-c-missing-ccs-buffer-4_tiled_mtl_rc_ccs)
[323.552146] Starting subtest: pipe-C-missing-ccs-buffer-4_tiled_mtl_rc_ccs
[323.555612] Subtest pipe-C-missing-ccs-buffer-4_tiled_mtl_rc_ccs: SUCCESS (0.001s)
[324.463630] [080/142] (693s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-render)
[324.969423] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-render
[339.856952] Subtest fbc-1p-offscren-pri-shrfb-draw-render: SUCCESS (14.896s)
[340.131986] [081/142] (678s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[340.659136] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[354.459315] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (13.801s)
[354.700507] [082/142] (663s left) gen9_exec_parse (bb-start-out)
[355.097518] Subtest bb-start-out: SKIP (0.000s)
[355.213581] [083/142] (663s left) perf_pmu (busy-double-start)
[355.599847] Starting subtest: busy-double-start
[355.603951] Starting dynamic subtest: rcs0
[359.290439] Dynamic subtest rcs0: FAIL (3.637s)
[359.330266] Starting dynamic subtest: bcs0
[362.829711] Dynamic subtest bcs0: SUCCESS (3.588s)
[362.876359] Starting dynamic subtest: vcs0
[367.014257] Dynamic subtest vcs0: SUCCESS (4.181s)
[367.060338] Starting dynamic subtest: vcs1
[370.982730] Dynamic subtest vcs1: SUCCESS (3.964s)
[371.028969] Starting dynamic subtest: vecs0
[375.001205] Dynamic subtest vecs0: SUCCESS (4.014s)
[375.042070] Starting dynamic subtest: ccs0
[378.581987] Dynamic subtest ccs0: SUCCESS (3.577s)
[378.585663] Subtest busy-double-start: FAIL (22.985s)
[378.789509] [084/142] (639s left) i915_module_load (load)
[379.170634] Starting subtest: load
[379.183414] Subtest load: SKIP (0.005s)
[379.327109] [085/142] (639s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[379.883445] Starting subtest: y-tiled-64bpp-rotate-270
[379.889821] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[380.053375] [086/142] (638s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[380.554585] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[380.561210] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.001s)
[380.721903] [087/142] (638s left) gem_exec_schedule (u-submit-late-slice)
[381.158585] Starting subtest: u-submit-late-slice
[381.162761] Starting dynamic subtest: rcs0
[381.306499] Dynamic subtest rcs0: SUCCESS (0.145s)
[381.352119] Starting dynamic subtest: bcs0
[381.440606] Dynamic subtest bcs0: SUCCESS (0.130s)
[381.482406] Starting dynamic subtest: vcs0
[381.571502] Dynamic subtest vcs0: SUCCESS (0.127s)
[381.613606] Starting dynamic subtest: vcs1
[381.703120] Dynamic subtest vcs1: SUCCESS (0.128s)
[381.744269] Starting dynamic subtest: vecs0
[381.827341] Dynamic subtest vecs0: SUCCESS (0.120s)
[381.870885] Starting dynamic subtest: ccs0
[381.953093] Dynamic subtest ccs0: SUCCESS (0.122s)
[381.956819] Subtest u-submit-late-slice: SUCCESS (0.796s)
[382.677207] [088/142] (636s left) gem_eio (throttle)
[384.399440] Starting subtest: throttle
[387.083783] Subtest throttle: SUCCESS (2.682s)
[388.649903] [089/142] (630s left) gem_exec_reloc (basic-wc)
[389.042590] Subtest basic-wc: SKIP (0.000s)
[389.169532] [090/142] (629s left) gem_ctx_engines (independent)
[389.588335] Starting subtest: independent
[389.591602] Starting dynamic subtest: rcs0
[390.054183] Dynamic subtest rcs0: SUCCESS (0.462s)
[390.094248] Starting dynamic subtest: bcs0
[390.411589] Dynamic subtest bcs0: SUCCESS (0.352s)
[390.461161] Starting dynamic subtest: vcs0
[390.673867] Dynamic subtest vcs0: SUCCESS (0.260s)
[390.719824] Starting dynamic subtest: vcs1
[391.112431] Dynamic subtest vcs1: SUCCESS (0.434s)
[391.154114] Starting dynamic subtest: vecs0
[391.598399] Dynamic subtest vecs0: SUCCESS (0.482s)
[391.645951] Starting dynamic subtest: ccs0
[392.181302] Dynamic subtest ccs0: SUCCESS (0.578s)
[392.223244] Starting dynamic subtest: all-engines
[392.944889] Dynamic subtest all-engines: SUCCESS (0.759s)
[392.949247] Subtest independent: SUCCESS (3.357s)
[394.661238] [091/142] (624s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[395.244730] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[416.589899] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (21.346s)
[417.525062] [092/142] (601s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[418.014480] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[418.027278] Starting dynamic subtest: pipe-A-default-mode
[418.428837] Dynamic subtest pipe-A-default-mode: SKIP (0.400s)
[418.435621] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.415s)
[419.362759] [093/142] (599s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[419.863862] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[419.870592] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[420.031466] [094/142] (599s left) kms_addfb_basic (small-bo)
[420.505521] Starting subtest: small-bo
[420.509745] Subtest small-bo: SUCCESS (0.000s)
[420.670459] [095/142] (598s left) gem_eio (wait-wedge-10ms)
[422.577453] Starting subtest: wait-wedge-10ms
[425.287261] Subtest wait-wedge-10ms: SUCCESS (2.712s)
[426.612530] [096/142] (592s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[427.087389] Starting subtest: plane-all-modeset-transition-internal-panels
[427.096416] Starting dynamic subtest: pipe-A-eDP-1
[429.666219] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.568s)
[430.105923] Starting dynamic subtest: pipe-B-eDP-1
[432.449785] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.378s)
[432.839190] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (5.751s)
[433.791808] [097/142] (585s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[434.303418] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[434.310142] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[434.488203] [098/142] (585s left) gem_mmap_offset (bad-object)
[434.852517] Starting subtest: bad-object
[434.861779] Subtest bad-object: SUCCESS (0.006s)
[435.040974] [099/142] (584s left) i915_pm_rpm (universal-planes-dpms)
[437.659719] Starting subtest: universal-planes-dpms
[437.663495] Starting dynamic subtest: plane-31
[465.588527] Dynamic subtest plane-31: SUCCESS (27.925s)
[465.639433] Starting dynamic subtest: plane-40
[490.104741] Dynamic subtest plane-40: SUCCESS (24.511s)
[490.159166] Starting dynamic subtest: plane-49
[514.476089] Dynamic subtest plane-49: SUCCESS (24.366s)
[514.526448] Starting dynamic subtest: plane-58
[538.969804] Dynamic subtest plane-58: SUCCESS (24.487s)
[539.020874] Starting dynamic subtest: plane-67
[567.394556] Dynamic subtest plane-67: SUCCESS (28.421s)
[567.449181] Starting dynamic subtest: plane-76
[592.096387] Dynamic subtest plane-76: SUCCESS (24.695s)
[592.100204] Subtest universal-planes-dpms: SUCCESS (154.438s)
[593.316646] [100/142] (426s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[595.608144] Starting subtest: syncobj-timeline-invalid-flags
[595.612083] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.002s)
[595.885324] [101/142] (424s left) gem_exec_reloc (basic-gtt-read-active)
[596.294564] Subtest basic-gtt-read-active: SKIP (0.000s)
[596.443223] [102/142] (423s left) kms_ccs (pipe-a-random-ccs-data-4_tiled_dg2_mc_ccs)
[597.414413] Starting subtest: pipe-A-random-ccs-data-4_tiled_dg2_mc_ccs
[597.425293] Subtest pipe-A-random-ccs-data-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[598.843591] [103/142] (421s left) vgem_basic (bad-flag)
[599.223617] Starting subtest: bad-flag
[599.227381] Subtest bad-flag: SUCCESS (0.000s)
[599.356917] [104/142] (420s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[599.886487] Starting subtest: yf-tiled-16bpp-rotate-270
[599.894381] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[600.041650] [105/142] (420s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs)
[601.839335] Starting subtest: pipe-D-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs
[622.622798] Subtest pipe-D-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs: SUCCESS (20.783s)
[624.077355] [106/142] (396s left) kms_plane_multiple (tiling-none)
[624.561045] Starting subtest: tiling-none
[624.570114] Starting dynamic subtest: pipe-A-eDP-1
[629.343891] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.776s)
[629.394926] Starting dynamic subtest: pipe-B-eDP-1
[634.855880] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.503s)
[634.903495] Starting dynamic subtest: pipe-C-eDP-1
[640.230752] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.366s)
[640.278361] Starting dynamic subtest: pipe-D-eDP-1
[645.590620] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.349s)
[645.594097] Subtest tiling-none: SUCCESS (21.030s)
[646.527678] [107/142] (374s left) syncobj_timeline (32bits-limit)
[646.914347] Starting subtest: 32bits-limit
[646.918236] Subtest 32bits-limit: SUCCESS (0.004s)
[647.062948] [108/142] (373s left) gem_madvise (dontneed-after-mmap)
[647.422513] Starting subtest: dontneed-after-mmap
[647.454556] Subtest dontneed-after-mmap: SUCCESS (0.028s)
[647.622700] [109/142] (373s left) syncobj_wait (invalid-signal-bad-pad)
[647.991398] Starting subtest: invalid-signal-bad-pad
[647.994939] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[648.124594] [110/142] (372s left) kms_universal_plane (universal-plane-pipe-a-functional)
[648.602841] Starting subtest: universal-plane-pipe-A-functional
[654.684020] Subtest universal-plane-pipe-A-functional: SUCCESS (6.079s)
[655.593985] [111/142] (365s left) gem_userptr_blits (stress-purge)
[656.032696] Starting subtest: stress-purge
[661.523160] Subtest stress-purge: SUCCESS (5.488s)
[661.805474] [112/142] (359s left) kms_flip (flip-vs-panning-interruptible)
[662.379310] Starting subtest: flip-vs-panning-interruptible
[662.411520] Starting dynamic subtest: A-eDP1
[672.123289] Dynamic subtest A-eDP1: SUCCESS (9.712s)
[672.146985] Starting dynamic subtest: B-eDP1
[681.434777] Dynamic subtest B-eDP1: SUCCESS (9.305s)
[681.486310] Starting dynamic subtest: C-eDP1
[690.750221] Dynamic subtest C-eDP1: SUCCESS (9.311s)
[690.800454] Starting dynamic subtest: D-eDP1
[700.077965] Dynamic subtest D-eDP1: SUCCESS (9.323s)
[700.103301] Subtest flip-vs-panning-interruptible: SUCCESS (37.724s)
[701.679144] [113/142] (319s left) kms_setmode (invalid-clone-single-crtc-stealing)
[702.051149] Starting subtest: invalid-clone-single-crtc-stealing
[702.061318] Subtest invalid-clone-single-crtc-stealing: SKIP (0.003s)
[702.175249] [114/142] (318s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[702.688154] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[702.694875] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[702.855815] [115/142] (318s left) v3d/v3d_submit_cl (bad-pad)
[703.299769] Subtest bad-pad: SKIP (0.000s)
[703.399705] [116/142] (317s left) kms_ccs (pipe-c-random-ccs-data-y_tiled_gen12_rc_ccs_cc)
[704.854600] Starting subtest: pipe-C-random-ccs-data-y_tiled_gen12_rc_ccs_cc
[704.864228] Subtest pipe-C-random-ccs-data-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[705.788593] [117/142] (315s left) api_intel_bb (full-batch)
[706.166755] Starting subtest: full-batch
[706.183946] Subtest full-batch: SUCCESS (0.018s)
[706.363191] [118/142] (315s left) gem_exec_schedule (implicit-read-write)
[706.803496] Starting subtest: implicit-read-write
[706.806921] Starting dynamic subtest: rcs0
[707.185319] Dynamic subtest rcs0: SUCCESS (0.379s)
[707.235583] Starting dynamic subtest: bcs0
[707.469708] Dynamic subtest bcs0: SUCCESS (0.281s)
[707.522281] Starting dynamic subtest: vcs0
[707.736783] Dynamic subtest vcs0: SUCCESS (0.263s)
[707.787301] Starting dynamic subtest: vcs1
[708.002594] Dynamic subtest vcs1: SUCCESS (0.263s)
[708.051434] Starting dynamic subtest: vecs0
[708.278583] Dynamic subtest vecs0: SUCCESS (0.273s)
[708.324630] Starting dynamic subtest: ccs0
[708.591126] Dynamic subtest ccs0: SUCCESS (0.308s)
[708.595134] Subtest implicit-read-write: SUCCESS (1.788s)
[709.779217] [119/142] (311s left) dumb_buffer (create-clear)
[710.153842] Starting subtest: create-clear
[752.228824] Subtest create-clear: SUCCESS (42.070s)
[752.438742] [120/142] (269s left) gem_ctx_persistence (process)
[752.840697] Starting subtest: process
[753.038274] Subtest process: SUCCESS (0.197s)
[753.222669] [121/142] (268s left) debugfs_test (sysfs)
[753.628582] Starting subtest: sysfs
[755.029715] Subtest sysfs: SUCCESS (1.397s)
[755.289121] [122/142] (266s left) kms_flip (flip-vs-wf_vblank-interruptible)
[755.703236] Starting subtest: flip-vs-wf_vblank-interruptible
[755.734608] Starting dynamic subtest: A-eDP1
[758.180751] Dynamic subtest A-eDP1: SUCCESS (2.446s)
[758.234769] Starting dynamic subtest: B-eDP1
[760.511291] Dynamic subtest B-eDP1: SUCCESS (2.326s)
[760.563822] Starting dynamic subtest: C-eDP1
[762.817333] Dynamic subtest C-eDP1: SUCCESS (2.302s)
[762.868815] Starting dynamic subtest: D-eDP1
[765.120178] Dynamic subtest D-eDP1: SUCCESS (2.299s)
[765.160125] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (9.457s)
[766.696280] [123/142] (255s left) kms_flip (flip-vs-panning-vs-hang)
[767.085748] Starting subtest: flip-vs-panning-vs-hang
[767.103157] Starting dynamic subtest: A-eDP1
[808.416086] Dynamic subtest A-eDP1: SUCCESS (41.317s)
[808.467473] Starting dynamic subtest: D-eDP1
[849.437717] Dynamic subtest D-eDP1: SUCCESS (41.017s)
[849.452481] Subtest flip-vs-panning-vs-hang: SUCCESS (82.371s)
[851.045686] [124/142] (170s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[851.591956] Starting subtest: x-tiled-32bpp-rotate-180
[857.059368] Subtest x-tiled-32bpp-rotate-180: SUCCESS (5.464s)
[857.644760] [125/142] (164s left) kms_psr (suspend)
[858.158551] Starting subtest: suspend
[877.935742] Subtest suspend: SUCCESS (19.776s)
[878.902859] [126/142] (143s left) sw_sync (sync_multi_consumer)
[879.279664] Starting subtest: sync_multi_consumer
[881.037128] Subtest sync_multi_consumer: SUCCESS (1.764s)
[881.107787] [127/142] (141s left) vc4/vc4_perfmon (create-perfmon-invalid-events)
[881.484082] Subtest create-perfmon-invalid-events: SKIP (0.000s)
[881.621516] [128/142] (140s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[882.151655] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[882.160605] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[882.349234] [129/142] (140s left) kms_cursor_crc (cursor-random-256x85)
[883.424827] Starting subtest: cursor-random-256x85
[883.451832] Starting dynamic subtest: pipe-A-eDP-1
[889.570377] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.114s)
[889.752078] Starting dynamic subtest: pipe-D-eDP-1
[896.184717] Dynamic subtest pipe-D-eDP-1: SUCCESS (6.486s)
[896.188394] Subtest cursor-random-256x85: SUCCESS (12.760s)
[897.141905] [130/142] (125s left) kms_flip (basic-flip-vs-dpms)
[897.529765] Starting subtest: basic-flip-vs-dpms
[897.559628] Starting dynamic subtest: A-eDP1
[900.919745] Dynamic subtest A-eDP1: SUCCESS (3.360s)
[900.980964] Starting dynamic subtest: B-eDP1
[903.458464] Dynamic subtest B-eDP1: SUCCESS (2.529s)
[903.508584] Starting dynamic subtest: C-eDP1
[906.067270] Dynamic subtest C-eDP1: SUCCESS (2.601s)
[906.119163] Starting dynamic subtest: D-eDP1
[908.620266] Dynamic subtest D-eDP1: SUCCESS (2.549s)
[908.640330] Subtest basic-flip-vs-dpms: SUCCESS (11.113s)
[909.575603] [131/142] (113s left) kms_flip (2x-flip-vs-suspend-interruptible)
[909.992917] Starting subtest: 2x-flip-vs-suspend-interruptible
[910.162972] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.166s)
[910.344304] [132/142] (112s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[910.848490] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[922.702166] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (11.858s)
[922.903076] [133/142] ( 99s left) gem_create (create-clear)
[923.284728] Starting subtest: create-clear
[923.288485] Starting dynamic subtest: smem0
[957.637876] Dynamic subtest smem0: SUCCESS (34.350s)
[957.640984] Subtest create-clear: SUCCESS (34.353s)
[957.906648] [134/142] ( 65s left) gem_exec_balancer (invalid-balancer)
[958.152917] Starting subtest: invalid-balancer
[964.828156] Subtest invalid-balancer: SUCCESS (6.668s)
[965.833851] [135/142] ( 57s left) gem_mmap_gtt (basic-write-gtt)
[966.203959] Subtest basic-write-gtt: SKIP (0.000s)
[966.333996] [136/142] ( 56s left) gem_pwrite (basic-self)
[966.704134] Subtest basic-self: SKIP (0.000s)
[966.849853] [137/142] ( 56s left) kms_plane_scaling (planes-downscale-factor-0-25)
[967.324281] Starting subtest: planes-downscale-factor-0-25
[967.334170] Starting dynamic subtest: pipe-A-eDP-1
[967.414489] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s)
[967.465384] Starting dynamic subtest: pipe-B-eDP-1
[967.504501] Dynamic subtest pipe-B-eDP-1: SKIP (0.075s)
[967.559392] Starting dynamic subtest: pipe-C-eDP-1
[967.566629] Dynamic subtest pipe-C-eDP-1: SKIP (0.042s)
[967.619891] Starting dynamic subtest: pipe-D-eDP-1
[967.625954] Dynamic subtest pipe-D-eDP-1: SKIP (0.042s)
[967.632122] Subtest planes-downscale-factor-0-25: SKIP (0.268s)
[967.773455] [138/142] ( 55s left) gem_exec_balancer (full-late)
[968.189800] Starting subtest: full-late
[978.931918] Subtest full-late: SUCCESS (10.742s)
[979.972765] [139/142] ( 43s left) gem_ctx_persistence (heartbeat-many)
[980.387627] Starting subtest: heartbeat-many
[980.394809] Subtest heartbeat-many: SKIP (0.001s)
[980.600151] [140/142] ( 42s left) gem_exec_whisper (basic-contexts-forked-all)
[981.027449] Starting subtest: basic-contexts-forked-all
[1090.315682] Subtest basic-contexts-forked-all: SUCCESS (109.283s)
[1090.619461] Overall timeout time exceeded, stopping.
[1090.620802] Closing watchdogs
Done.