[61.079571] Initializing watchdogs
[61.079617]   /dev/watchdog0
[61.093844] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[61.098143] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.100326] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.103812] [001/133] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[61.227703] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[65.685061] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.466s)
[66.811443] [002/133] (954s left) gem_render_copy (linear-to-vebox-yf-tiled)
[66.880715] Starting subtest: linear-to-vebox-yf-tiled
[66.885200] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[67.666403] [003/133] (954s left) syncobj_timeline (invalid-signal-bad-pad)
[67.757876] Starting subtest: invalid-signal-bad-pad
[67.759823] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[67.941074] [004/133] (953s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[68.114374] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[68.119092] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[68.209158] [005/133] (953s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[68.290840] Starting subtest: async-flip-with-page-flip-events-tiled
[68.669471] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[71.481236] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.811s)
[71.492166] Starting dynamic subtest: pipe-A-eDP-1-4
[73.654260] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s)
[73.664653] Starting dynamic subtest: pipe-A-eDP-1-4
[75.663113] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[75.673071] Starting dynamic subtest: pipe-A-eDP-1-x
[77.852602] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.190s)
[78.225123] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[81.006752] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.787s)
[81.015562] Starting dynamic subtest: pipe-B-eDP-1-4
[83.192561] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[83.203040] Starting dynamic subtest: pipe-B-eDP-1-4
[85.202066] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[85.212619] Starting dynamic subtest: pipe-B-eDP-1-x
[87.392266] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.190s)
[87.758489] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[90.534521] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.782s)
[90.544800] Starting dynamic subtest: pipe-C-eDP-1-4
[92.709261] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[92.716853] Starting dynamic subtest: pipe-C-eDP-1-4
[94.719725] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s)
[94.727630] Starting dynamic subtest: pipe-C-eDP-1-x
[96.898827] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[97.260784] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[100.071054] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.815s)
[100.082119] Starting dynamic subtest: pipe-D-eDP-1-4
[102.233777] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.163s)
[102.243662] Starting dynamic subtest: pipe-D-eDP-1-4
[104.244516] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s)
[104.252272] Starting dynamic subtest: pipe-D-eDP-1-x
[106.424435] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.180s)
[106.426893] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.137s)
[107.664867] [006/133] (914s left) kms_flip (flip-vs-dpms-on-nop)
[107.769589] Starting subtest: flip-vs-dpms-on-nop
[107.771836] Starting dynamic subtest: A-eDP1
[109.656059] Dynamic subtest A-eDP1: SUCCESS (1.886s)
[109.663456] Starting dynamic subtest: B-eDP1
[111.488625] Dynamic subtest B-eDP1: SUCCESS (1.831s)
[111.498609] Starting dynamic subtest: C-eDP1
[113.303908] Dynamic subtest C-eDP1: SUCCESS (1.815s)
[113.311290] Starting dynamic subtest: D-eDP1
[115.152758] Dynamic subtest D-eDP1: SUCCESS (1.847s)
[115.157825] Subtest flip-vs-dpms-on-nop: SUCCESS (7.389s)
[116.319213] [007/133] (905s left) i915_drm_fdinfo (busy-hang)
[116.371209] Starting subtest: busy-hang
[116.373411] Starting dynamic subtest: rcs0
[116.395927] Dynamic subtest rcs0: SKIP (0.022s)
[116.404934] Starting dynamic subtest: bcs0
[116.408859] Dynamic subtest bcs0: SKIP (0.001s)
[116.416379] Starting dynamic subtest: vcs0
[116.420715] Dynamic subtest vcs0: SKIP (0.000s)
[116.430671] Starting dynamic subtest: vcs1
[116.434666] Dynamic subtest vcs1: SKIP (0.000s)
[116.441349] Starting dynamic subtest: vecs0
[116.445369] Dynamic subtest vecs0: SKIP (0.001s)
[116.452071] Starting dynamic subtest: ccs0
[116.456036] Dynamic subtest ccs0: SKIP (0.000s)
[116.459942] Subtest busy-hang: SKIP (0.026s)
[116.493986] [008/133] (905s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[116.592286] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[116.594709] Starting dynamic subtest: pipe-A-eDP-1
[116.615905] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[116.626057] Starting dynamic subtest: pipe-B-eDP-1
[116.645561] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[116.653087] Starting dynamic subtest: pipe-C-eDP-1
[116.672812] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[116.682373] Starting dynamic subtest: pipe-D-eDP-1
[116.702880] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[116.705144] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.004s)
[118.822398] [009/133] (903s left) dmabuf_sync_file (export-before-signal)
[118.912339] Starting subtest: export-before-signal
[118.914711] Subtest export-before-signal: SUCCESS (0.003s)
[118.965775] [FACT dmabuf_sync_file (export-before-signal)] new: kernel.kmod_is_loaded.vgem: true
[118.968951] [010/133] (902s left) gem_mmap_offset (partial-unmap)
[119.037718] Starting subtest: partial-unmap
[119.039798] Starting dynamic subtest: smem0
[119.542953] Dynamic subtest smem0: SUCCESS (0.505s)
[119.545591] Subtest partial-unmap: SUCCESS (0.506s)
[119.629064] [011/133] (902s left) kms_cursor_edge_walk (256x256-top-edge)
[119.727910] Starting subtest: 256x256-top-edge
[119.730215] Starting dynamic subtest: pipe-A-eDP-1
[123.174584] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.447s)
[123.184076] Starting dynamic subtest: pipe-D-eDP-1
[126.301724] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s)
[126.303604] Subtest 256x256-top-edge: SUCCESS (6.574s)
[127.105171] [012/133] (894s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[127.157809] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[127.226413] [013/133] (894s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[127.323082] Starting subtest: psr2-cursor-plane-update-sf
[127.325592] Starting dynamic subtest: pipe-A-eDP-1
[127.875420] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.556s)
[127.884320] Starting dynamic subtest: pipe-B-eDP-1
[129.183684] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.307s)
[129.186111] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.865s)
[130.065039] [014/133] (892s left) kms_hdr (invalid-metadata-sizes)
[130.164112] Starting subtest: invalid-metadata-sizes
[130.170398] Subtest invalid-metadata-sizes: SKIP (0.000s)
[130.234453] [015/133] (891s left) perf_pmu (init-wait)
[130.270927] Starting subtest: init-wait
[130.273230] Starting dynamic subtest: rcs0
[130.275547] Dynamic subtest rcs0: SUCCESS (0.002s)
[130.284322] Starting dynamic subtest: bcs0
[130.286132] Dynamic subtest bcs0: SUCCESS (0.000s)
[130.292825] Starting dynamic subtest: vcs0
[130.294718] Dynamic subtest vcs0: SUCCESS (0.001s)
[130.301783] Starting dynamic subtest: vcs1
[130.303818] Dynamic subtest vcs1: SUCCESS (0.000s)
[130.310740] Starting dynamic subtest: vecs0
[130.312918] Dynamic subtest vecs0: SUCCESS (0.001s)
[130.319830] Starting dynamic subtest: ccs0
[130.322014] Dynamic subtest ccs0: SUCCESS (0.000s)
[130.324253] Subtest init-wait: SUCCESS (0.006s)
[130.381516] [016/133] (891s left) perf (unprivileged-single-ctx-counters)
[130.505594] Starting subtest: unprivileged-single-ctx-counters
[130.509811] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[130.550830] [017/133] (891s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[130.653106] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[130.657202] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[130.749039] [018/133] (891s left) gem_exec_create (legacy)
[130.816583] Starting subtest: legacy
[130.818985] Starting dynamic subtest: smem
[134.870346] Dynamic subtest smem: SUCCESS (4.052s)
[134.873103] Subtest legacy: SUCCESS (4.053s)
[135.065998] [019/133] (887s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[135.169225] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[135.171542] Starting dynamic subtest: pipe-A
[135.508902] Dynamic subtest pipe-A: SUCCESS (0.339s)
[135.521728] Starting dynamic subtest: pipe-B
[136.957079] Dynamic subtest pipe-B: SUCCESS (1.447s)
[136.968418] Starting dynamic subtest: pipe-C
[138.378729] Dynamic subtest pipe-C: SUCCESS (1.421s)
[138.388286] Starting dynamic subtest: pipe-D
[139.816657] Dynamic subtest pipe-D: SUCCESS (1.438s)
[139.818850] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.648s)
[140.974318] [020/133] (881s left) kms_tiled_display (basic-test-pattern)
[141.092228] Subtest basic-test-pattern: SKIP (0.000s)
[141.139505] [021/133] (881s left) kms_flip (flip-vs-wf_vblank-interruptible)
[141.230378] Starting subtest: flip-vs-wf_vblank-interruptible
[141.232728] Starting dynamic subtest: A-eDP1
[143.120576] Dynamic subtest A-eDP1: SUCCESS (1.889s)
[143.130085] Starting dynamic subtest: B-eDP1
[145.049658] Dynamic subtest B-eDP1: SUCCESS (1.927s)
[145.059622] Starting dynamic subtest: C-eDP1
[146.969530] Dynamic subtest C-eDP1: SUCCESS (1.919s)
[146.979330] Starting dynamic subtest: D-eDP1
[148.814708] Dynamic subtest D-eDP1: SUCCESS (1.844s)
[148.819695] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.589s)
[150.040631] [022/133] (872s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[150.129847] Starting subtest: fbc-tiling-linear
[153.858469] Subtest fbc-tiling-linear: SUCCESS (3.732s)
[155.068247] [023/133] (867s left) gem_exec_balancer (busy)
[155.136666] Starting subtest: busy
[156.888565] Subtest busy: SUCCESS (1.750s)
[157.208074] [024/133] (865s left) i915_pm_rps (engine-order)
[157.270853] Starting subtest: engine-order
[162.480846] Subtest engine-order: SUCCESS (5.207s)
[162.619100] [025/133] (859s left) gem_userptr_blits (map-fixed-invalidate)
[162.679475] Starting subtest: map-fixed-invalidate
[162.683622] Subtest map-fixed-invalidate: SKIP (0.000s)
[162.807679] [026/133] (859s left) kms_addfb_basic (clobberred-modifier)
[162.860053] Starting subtest: clobberred-modifier
[162.864306] Subtest clobberred-modifier: SKIP (0.000s)
[162.992576] [027/133] (859s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[163.085722] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf
[163.088417] Starting dynamic subtest: pipe-A-eDP-1
[163.171584] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[163.181090] Starting dynamic subtest: pipe-B-eDP-1
[164.310082] Dynamic subtest pipe-B-eDP-1: SKIP (1.138s)
[164.314906] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.228s)
[165.516933] [028/133] (857s left) gem_exec_schedule (out-order)
[165.595565] Starting subtest: out-order
[165.597808] Starting dynamic subtest: rcs0
[165.705319] Dynamic subtest rcs0: SUCCESS (0.117s)
[165.716091] Starting dynamic subtest: vcs0
[165.786123] Dynamic subtest vcs0: SUCCESS (0.080s)
[165.797416] Starting dynamic subtest: vcs1
[165.869914] Dynamic subtest vcs1: SUCCESS (0.083s)
[165.879094] Starting dynamic subtest: vecs0
[165.957579] Dynamic subtest vecs0: SUCCESS (0.087s)
[165.965897] Starting dynamic subtest: ccs0
[166.048318] Dynamic subtest ccs0: SUCCESS (0.090s)
[166.051263] Subtest out-order: SUCCESS (0.461s)
[167.030617] [029/133] (855s left) kms_vrr (flip-basic-fastset)
[167.128882] Starting subtest: flip-basic-fastset
[167.135028] Subtest flip-basic-fastset: SKIP (0.000s)
[167.199964] [030/133] (855s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[167.286559] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[167.290936] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[168.438212] [031/133] (854s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[168.538278] Starting subtest: y-tiled-32bpp-rotate-0
[168.542317] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[168.642915] [032/133] (854s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[169.225146] Starting subtest: syncobj-timeline-invalid-wait
[169.227649] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s)
[170.927986] [033/133] (851s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[170.995711] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[171.000662] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[171.177336] [034/133] (851s left) gem_sync (basic-all)
[171.258302] Starting subtest: basic-all
[174.869860] Subtest basic-all: SUCCESS (3.619s)
[175.060706] [035/133] (847s left) syncobj_timeline (wait-all-delayed-signal)
[175.114649] Starting subtest: wait-all-delayed-signal
[175.218783] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[175.297915] [036/133] (847s left) kms_cursor_crc (cursor-offscreen-128x42)
[175.517930] Starting subtest: cursor-offscreen-128x42
[175.564387] Subtest cursor-offscreen-128x42: SKIP (0.041s)
[175.767305] [037/133] (847s left) i915_hangman (error-state-basic)
[175.831709] Starting subtest: error-state-basic
[176.000658] Subtest error-state-basic: SUCCESS (0.168s)
[176.078614] [038/133] (847s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[176.129141] Starting subtest: etime-single-wait-for-submit-submitted
[176.233455] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.104s)
[176.315461] [039/133] (846s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[176.684680] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[177.550040] [040/133] (845s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[177.659870] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[177.664164] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[177.749911] [041/133] (845s left) perf (gen12-oa-tlb-invalidate)
[177.843787] Starting subtest: gen12-oa-tlb-invalidate
[177.846018] Starting dynamic subtest: 0-rcs0
[187.903865] Dynamic subtest 0-rcs0: SUCCESS (10.059s)
[187.913429] Starting dynamic subtest: 1-vcs0
[197.953085] Dynamic subtest 1-vcs0: SUCCESS (10.048s)
[197.955987] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.109s)
[198.003766] [042/133] (825s left) gem_exec_reloc (basic-cpu-wc)
[198.073276] Subtest basic-cpu-wc: SKIP (0.000s)
[198.156489] [043/133] (825s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[198.270127] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[198.274239] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[198.389944] [044/133] (824s left) gem_mmap_gtt (basic-small-bo)
[198.452099] Subtest basic-small-bo: SKIP (0.000s)
[198.516098] [045/133] (824s left) gem_lmem_swapping (massive)
[198.557967] Subtest massive: SKIP (0.000s)
[198.603879] [046/133] (824s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[198.691837] Starting subtest: fbc-psr-sprite-mmap-gtt
[198.694038] Starting dynamic subtest: eDP-1
[198.697924] Dynamic subtest eDP-1: SKIP (0.000s)
[198.701776] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[198.762949] [047/133] (824s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[198.865204] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[198.869214] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[198.961841] [048/133] (824s left) kms_lease (lease-invalid-connector)
[199.063988] Starting subtest: lease-invalid-connector
[199.065868] Starting dynamic subtest: pipe-A-eDP-1
[199.067573] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[199.075214] Starting dynamic subtest: pipe-B-eDP-1
[199.076760] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[199.084470] Starting dynamic subtest: pipe-C-eDP-1
[199.086141] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[199.093616] Starting dynamic subtest: pipe-D-eDP-1
[199.095099] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[199.096613] Subtest lease-invalid-connector: SUCCESS (0.003s)
[199.135564] [049/133] (824s left) perf (create-destroy-userspace-config)
[199.223550] Starting subtest: create-destroy-userspace-config
[199.241083] Subtest create-destroy-userspace-config: SUCCESS (0.016s)
[199.284737] [050/133] (824s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[199.387559] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[199.389480] Starting dynamic subtest: pipe-A-eDP-1
[215.443177] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.286s)
[215.454101] Starting dynamic subtest: pipe-B-eDP-1
[232.420658] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.458s)
[232.430148] Starting dynamic subtest: pipe-C-eDP-1
[249.374938] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.434s)
[249.385158] Starting dynamic subtest: pipe-D-eDP-1
[266.358752] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.344s)
[266.360726] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (9.525s)
[267.505380] [051/133] (756s left) gem_spin_batch (engines)
[267.577986] Starting subtest: engines
[267.580373] Starting dynamic subtest: rcs0
[270.814262] Dynamic subtest rcs0: SUCCESS (3.253s)
[270.825671] Starting dynamic subtest: bcs0
[274.045593] Dynamic subtest bcs0: SUCCESS (3.244s)
[274.058447] Starting dynamic subtest: vcs0
[277.276339] Dynamic subtest vcs0: SUCCESS (3.239s)
[277.285948] Starting dynamic subtest: vcs1
[280.508847] Dynamic subtest vcs1: SUCCESS (3.237s)
[280.518449] Starting dynamic subtest: vecs0
[283.739458] Dynamic subtest vecs0: SUCCESS (3.234s)
[283.749797] Starting dynamic subtest: ccs0
[286.972675] Dynamic subtest ccs0: SUCCESS (3.235s)
[286.974869] Subtest engines: SUCCESS (19.457s)
[287.210844] [052/133] (736s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[287.312702] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[287.316840] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[287.422245] [053/133] (736s left) prime_self_import (basic-with_one_bo_two_files)
[287.465816] Starting subtest: basic-with_one_bo_two_files
[287.498986] Subtest basic-with_one_bo_two_files: SUCCESS (0.033s)
[287.596655] [054/133] (736s left) kms_flip (flip-vs-rmfb-interruptible)
[287.687400] Starting subtest: flip-vs-rmfb-interruptible
[287.689575] Starting dynamic subtest: A-eDP1
[296.325148] Dynamic subtest A-eDP1: SUCCESS (8.645s)
[296.338610] Starting dynamic subtest: B-eDP1
[304.960306] Dynamic subtest B-eDP1: SUCCESS (8.629s)
[304.973211] Starting dynamic subtest: C-eDP1
[313.578043] Dynamic subtest C-eDP1: SUCCESS (8.613s)
[313.590393] Starting dynamic subtest: D-eDP1
[322.241977] Dynamic subtest D-eDP1: SUCCESS (8.662s)
[322.246318] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.565s)
[323.397688] [055/133] (700s left) gem_mmap_gtt (cpuset-medium-copy)
[323.467358] Subtest cpuset-medium-copy: SKIP (0.000s)
[323.534974] [056/133] (700s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[323.637056] Starting subtest: fbcpsr-slowdraw
[348.739682] Subtest fbcpsr-slowdraw: SUCCESS (25.113s)
[348.866137] [057/133] (675s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[348.967108] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[348.971198] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[349.061096] [058/133] (674s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[349.151453] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[355.832363] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.687s)
[355.943301] [059/133] (668s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[356.035084] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[356.039250] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[356.140834] [060/133] (667s left) gem_wait (await)
[356.205709] Starting subtest: await
[356.208067] Starting dynamic subtest: all-engines
[357.315399] Dynamic subtest all-engines: SUCCESS (1.110s)
[357.332727] Starting dynamic subtest: rcs0
[358.372245] Dynamic subtest rcs0: SUCCESS (1.055s)
[358.388917] Starting dynamic subtest: bcs0
[359.430751] Dynamic subtest bcs0: SUCCESS (1.057s)
[359.448445] Starting dynamic subtest: vcs0
[360.484734] Dynamic subtest vcs0: SUCCESS (1.052s)
[360.503002] Starting dynamic subtest: vcs1
[361.538783] Dynamic subtest vcs1: SUCCESS (1.052s)
[361.555095] Starting dynamic subtest: vecs0
[362.592880] Dynamic subtest vecs0: SUCCESS (1.051s)
[362.609729] Starting dynamic subtest: ccs0
[363.652385] Dynamic subtest ccs0: SUCCESS (1.055s)
[363.655062] Subtest await: SUCCESS (7.447s)
[363.870522] [061/133] (660s left) kms_rotation_crc (bad-pixel-format)
[363.973745] Starting subtest: bad-pixel-format
[363.978307] Subtest bad-pixel-format: SKIP (0.001s)
[364.047903] [062/133] (660s left) syncobj_wait (multi-wait-submitted-signaled)
[364.104242] Starting subtest: multi-wait-submitted-signaled
[364.106255] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[364.218064] [063/133] (659s left) kms_color (degamma)
[364.321889] Starting subtest: degamma
[364.324081] Starting dynamic subtest: pipe-A-eDP-1
[365.042295] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.721s)
[365.051492] Starting dynamic subtest: pipe-B-eDP-1
[366.451912] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.409s)
[366.462481] Starting dynamic subtest: pipe-C-eDP-1
[367.857227] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.404s)
[367.871890] Starting dynamic subtest: pipe-D-eDP-1
[369.264954] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.406s)
[369.267389] Subtest degamma: SUCCESS (4.942s)
[370.066242] [064/133] (654s left) syncobj_timeline (wait-for-submit-snapshot)
[370.131254] Starting subtest: wait-for-submit-snapshot
[370.212234] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[370.289129] [065/133] (653s left) prime_mmap (test_correct)
[370.338538] Starting subtest: test_correct
[370.340334] Starting dynamic subtest: test_correct-smem
[370.367715] Dynamic subtest test_correct-smem: SUCCESS (0.031s)
[370.370149] Subtest test_correct: SUCCESS (0.031s)
[370.468209] [066/133] (653s left) gem_exec_flush (basic-uc-set-default)
[370.530879] Starting subtest: basic-uc-set-default
[375.992993] Subtest basic-uc-set-default: SUCCESS (5.461s)
[376.179095] [067/133] (648s left) kms_dsc (dsc-fractional-bpp)
[376.299018] Starting subtest: dsc-fractional-bpp
[376.311493] Subtest dsc-fractional-bpp: SKIP (0.000s)
[376.370734] [068/133] (647s left) gem_flink_basic (bad-flink)
[376.425722] Starting subtest: bad-flink
[376.427953] Subtest bad-flink: SUCCESS (0.000s)
[376.515233] [069/133] (647s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[376.607187] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[380.924048] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.321s)
[382.069752] [070/133] (642s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[382.171694] Starting subtest: fbc-psr2-primary-mmap-cpu
[382.173937] Starting dynamic subtest: eDP-1
[382.178239] Dynamic subtest eDP-1: SKIP (0.000s)
[382.182483] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[382.244451] [071/133] (642s left) gem_fence_thrash (bo-write-verify-threaded-y)
[382.288567] Starting subtest: bo-write-verify-threaded-y
[382.299845] Subtest bo-write-verify-threaded-y: SKIP (0.013s)
[382.362137] [072/133] (642s left) kms_fbcon_fbt (psr-suspend)
[382.426020] Starting subtest: psr-suspend
[432.201534] Subtest psr-suspend: SUCCESS (19.811s)
[432.268366] [073/133] (592s left) kms_flip (basic-flip-vs-modeset)
[432.366691] Starting subtest: basic-flip-vs-modeset
[432.368594] Starting dynamic subtest: A-eDP1
[434.937115] Dynamic subtest A-eDP1: SUCCESS (2.584s)
[434.947158] Starting dynamic subtest: B-eDP1
[437.112344] Dynamic subtest B-eDP1: SUCCESS (2.179s)
[437.122344] Starting dynamic subtest: C-eDP1
[439.281410] Dynamic subtest C-eDP1: SUCCESS (2.175s)
[439.290708] Starting dynamic subtest: D-eDP1
[441.433045] Dynamic subtest D-eDP1: SUCCESS (2.156s)
[441.435414] Subtest basic-flip-vs-modeset: SUCCESS (9.101s)
[442.239211] [074/133] (582s left) gem_mmap_wc (invalid-flags)
[442.305948] Subtest invalid-flags: SKIP (0.000s)
[442.364251] [075/133] (582s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[442.450680] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[442.454933] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[442.536828] [076/133] (582s left) kms_chamelium_edid (dp-edid-resolution-list)
[442.902867] Subtest dp-edid-resolution-list: SKIP (0.000s)
[443.739767] [077/133] (580s left) prime_busy (hang)
[443.790817] Starting subtest: hang
[443.793144] Starting dynamic subtest: rcs0
[470.005631] Dynamic subtest rcs0: SUCCESS (26.223s)
[470.015154] Starting dynamic subtest: bcs0
[477.095308] Dynamic subtest bcs0: SUCCESS (7.088s)
[477.104605] Starting dynamic subtest: vcs0
[484.134212] Dynamic subtest vcs0: SUCCESS (7.038s)
[484.143026] Starting dynamic subtest: vcs1
[491.104115] Dynamic subtest vcs1: SUCCESS (6.973s)
[491.113792] Starting dynamic subtest: vecs0
[498.147846] Dynamic subtest vecs0: SUCCESS (7.041s)
[498.157305] Starting dynamic subtest: ccs0
[511.982634] Dynamic subtest ccs0: SUCCESS (13.837s)
[511.984887] Subtest hang: SUCCESS (68.208s)
[512.097873] [078/133] (512s left) gem_exec_alignment (pi)
[512.169399] Starting subtest: pi
[563.350596] Subtest pi: SUCCESS (51.175s)
[564.421269] [079/133] (460s left) gen3_render_linear_blits
[564.587634] [080/133] (460s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[564.691462] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[564.693722] Starting dynamic subtest: pipe-A
[564.712317] Dynamic subtest pipe-A: SKIP (0.018s)
[564.723284] Starting dynamic subtest: pipe-B
[564.746051] Dynamic subtest pipe-B: SKIP (0.032s)
[564.756199] Starting dynamic subtest: pipe-C
[564.778608] Dynamic subtest pipe-C: SKIP (0.032s)
[564.788220] Starting dynamic subtest: pipe-D
[564.807600] Dynamic subtest pipe-D: SKIP (0.029s)
[564.811651] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.114s)
[564.914183] [081/133] (459s left) gem_mmap_offset (pf-nonblock)
[564.970678] Starting subtest: pf-nonblock
[564.980637] Subtest pf-nonblock: SUCCESS (0.010s)
[565.108530] [082/133] (459s left) syncobj_wait (reset-unsignaled)
[565.184106] Starting subtest: reset-unsignaled
[565.186725] Subtest reset-unsignaled: SUCCESS (0.000s)
[565.281834] [083/133] (459s left) kms_pm_rpm (dpms-non-lpsp)
[567.646443] Starting subtest: dpms-non-lpsp
[567.651175] Subtest dpms-non-lpsp: SKIP (0.001s)
[568.032947] [084/133] (456s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[568.124669] Starting subtest: x-tiled-16bpp-rotate-90
[568.144465] Subtest x-tiled-16bpp-rotate-90: SKIP (0.019s)
[568.257025] [085/133] (456s left) kms_psr (pr-primary-page-flip)
[568.359967] Starting subtest: pr-primary-page-flip
[568.364147] Subtest pr-primary-page-flip: SKIP (0.000s)
[568.430351] [086/133] (456s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[568.537755] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[568.542139] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[568.637599] [087/133] (456s left) syncobj_eventfd (timeline-wait-before-signal)
[568.689539] Starting subtest: timeline-wait-before-signal
[568.719272] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[568.800027] [088/133] (456s left) kms_debugfs (display-on-read-all)
[568.896864] Starting subtest: display-on-read-all
[569.062507] Subtest display-on-read-all: SUCCESS (0.165s)
[569.174373] [089/133] (456s left) api_intel_bb (render-ccs)
[569.234975] Starting subtest: render-ccs
[569.584491] Subtest render-ccs: SUCCESS (0.349s)
[569.707019] [090/133] (455s left) gem_ctx_freq (sysfs)
[569.764833] Starting subtest: sysfs
[569.767140] Starting dynamic subtest: gt0
[575.254528] Dynamic subtest gt0: SUCCESS (5.489s)
[575.268848] Starting dynamic subtest: gt1
[616.470581] Dynamic subtest gt1: SUCCESS (41.220s)
[616.473605] Subtest sysfs: SUCCESS (46.712s)
[616.594097] [091/133] (408s left) kms_atomic (test-only)
[616.693520] Starting subtest: test-only
[616.755214] Starting dynamic subtest: pipe-A-eDP-1
[619.322082] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.570s)
[619.324421] Subtest test-only: SUCCESS (2.632s)
[620.211217] [092/133] (405s left) i915_pm_rps (thresholds-idle)
[620.273571] Starting subtest: thresholds-idle
[620.278196] Subtest thresholds-idle: SKIP (0.000s)
[620.383481] [093/133] (405s left) gem_busy (parallel)
[620.565583] Starting subtest: parallel
[620.567864] Starting dynamic subtest: rcs0
[622.423320] Dynamic subtest rcs0: SUCCESS (1.857s)
[622.436292] Starting dynamic subtest: bcs0
[624.472403] Dynamic subtest bcs0: SUCCESS (2.047s)
[624.484983] Starting dynamic subtest: vcs0
[626.455529] Dynamic subtest vcs0: SUCCESS (1.981s)
[626.468230] Starting dynamic subtest: vcs1
[628.440897] Dynamic subtest vcs1: SUCCESS (1.982s)
[628.457569] Starting dynamic subtest: vecs0
[630.487360] Dynamic subtest vecs0: SUCCESS (2.044s)
[630.503237] Starting dynamic subtest: ccs0
[632.472756] Dynamic subtest ccs0: SUCCESS (1.982s)
[632.475601] Subtest parallel: SUCCESS (11.910s)
[632.709010] [094/133] (392s left) kms_cursor_crc (cursor-size-hints)
[632.852354] Starting subtest: cursor-size-hints
[632.854143] Starting dynamic subtest: pipe-A-eDP-1
[633.460958] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.609s)
[633.471145] Starting dynamic subtest: pipe-D-eDP-1
[634.785122] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.322s)
[634.787369] Subtest cursor-size-hints: SUCCESS (1.934s)
[635.670308] [095/133] (389s left) gem_exec_reloc (basic-wc)
[635.742332] Subtest basic-wc: SKIP (0.000s)
[635.817524] [096/133] (389s left) gem_mmap_gtt (basic-read-write)
[635.870387] Subtest basic-read-write: SKIP (0.000s)
[635.938803] [097/133] (389s left) kms_rotation_crc (sprite-rotation-270)
[636.030718] Starting subtest: sprite-rotation-270
[636.035126] Subtest sprite-rotation-270: SKIP (0.001s)
[636.103094] [098/133] (389s left) kms_content_protection (atomic-hdcp14)
[636.238405] Starting subtest: atomic-hdcp14
[636.242945] Subtest atomic-hdcp14: SKIP (0.000s)
[636.370823] [099/133] (389s left) kms_flip (flip-vs-fences-interruptible)
[636.459616] Starting subtest: flip-vs-fences-interruptible
[636.463973] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[636.553588] [100/133] (389s left) kms_scaling_modes (scaling-mode-full)
[636.646035] Starting subtest: scaling-mode-full
[636.647868] Starting dynamic subtest: pipe-A-eDP-1
[636.738450] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.093s)
[636.751307] Starting dynamic subtest: pipe-B-eDP-1
[637.873085] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.131s)
[637.884354] Starting dynamic subtest: pipe-C-eDP-1
[639.000516] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.126s)
[639.012258] Starting dynamic subtest: pipe-D-eDP-1
[640.143612] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.143s)
[640.146102] Subtest scaling-mode-full: SUCCESS (3.500s)
[641.312156] [101/133] (384s left) perf (enable-disable)
[641.411161] Starting subtest: enable-disable
[641.413521] Starting dynamic subtest: 0-rcs0
[643.655672] Dynamic subtest 0-rcs0: SUCCESS (2.243s)
[643.666418] Starting dynamic subtest: 1-vcs0
[648.155105] Dynamic subtest 1-vcs0: SUCCESS (4.500s)
[648.157363] Subtest enable-disable: SUCCESS (6.745s)
[648.207329] [102/133] (377s left) gem_exec_whisper (basic-contexts-forked-all)
[648.288305] Starting subtest: basic-contexts-forked-all
[668.401697] Subtest basic-contexts-forked-all: SUCCESS (20.104s)
[668.587431] [103/133] (357s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[668.691101] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[668.693324] Starting dynamic subtest: pipe-A-eDP-1
[668.767801] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s)
[668.779770] Starting dynamic subtest: pipe-B-eDP-1
[669.881855] Dynamic subtest pipe-B-eDP-1: SKIP (1.113s)
[669.886023] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.193s)
[671.075190] [104/133] (354s left) api_intel_allocator (gem-pool)
[671.129817] Starting subtest: gem-pool
[671.134742] Subtest gem-pool: SUCCESS (0.007s)
[671.261803] [105/133] (354s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[671.386055] Starting subtest: cursorA-vs-flipB-atomic
[671.390573] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[671.531184] [106/133] (354s left) gen7_exec_parse (basic-offset)
[671.578584] Subtest basic-offset: SKIP (0.000s)
[671.647332] [107/133] (354s left) kms_invalid_mode (bad-vsync-start)
[671.731831] Starting subtest: bad-vsync-start
[671.734101] Starting dynamic subtest: pipe-A-eDP-1
[672.020609] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[672.031802] Starting dynamic subtest: pipe-B-eDP-1
[672.033958] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[672.043614] Starting dynamic subtest: pipe-C-eDP-1
[672.046149] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[672.055443] Starting dynamic subtest: pipe-D-eDP-1
[672.057709] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[672.059846] Subtest bad-vsync-start: SUCCESS (0.295s)
[672.819698] [108/133] (353s left) gem_exec_params (readonly)
[672.867985] Starting subtest: readonly
[672.870388] Subtest readonly: SUCCESS (0.002s)
[672.976597] [109/133] (353s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[673.073037] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[673.686279] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.614s)
[673.831829] [110/133] (352s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[673.929039] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[673.931397] Starting dynamic subtest: pipe-A-eDP-1
[673.952179] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[673.962691] Starting dynamic subtest: pipe-B-eDP-1
[673.982302] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[673.992062] Starting dynamic subtest: pipe-C-eDP-1
[674.011948] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[674.023826] Starting dynamic subtest: pipe-D-eDP-1
[674.043109] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[674.045319] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[676.099743] [111/133] (350s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[676.190771] Starting subtest: fbc-shrfb-scaledprimary
[679.221781] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.033s)
[680.402473] [112/133] (345s left) kms_cdclk (mode-transition)
[680.504573] Starting subtest: mode-transition
[680.506727] Starting dynamic subtest: pipe-A-eDP-1
[680.790982] Dynamic subtest pipe-A-eDP-1: SKIP (0.283s)
[680.802335] Starting dynamic subtest: pipe-B-eDP-1
[680.808278] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[680.824183] Starting dynamic subtest: pipe-C-eDP-1
[680.828499] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[680.838112] Starting dynamic subtest: pipe-D-eDP-1
[680.842419] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[680.846688] Subtest mode-transition: SKIP (0.291s)
[681.618839] [113/133] (344s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[681.718370] Starting subtest: 4-tiled-8bpp-rotate-0
[682.910038] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.191s)
[683.032866] [114/133] (343s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[683.096646] Starting subtest: map-fixed-invalidate-overlap
[683.099997] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[683.201042] [115/133] (343s left) kms_psr (psr2-cursor-mmap-gtt)
[683.288080] Starting subtest: psr2-cursor-mmap-gtt
[683.289862] Starting dynamic subtest: eDP-1
[685.010715] Dynamic subtest eDP-1: SUCCESS (1.722s)
[685.013045] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.723s)
[685.887952] [116/133] (340s left) kms_pm_rpm (i2c)
[687.625568] Starting subtest: i2c
[693.098594] Subtest i2c: SUCCESS (5.476s)
[693.217534] [117/133] (333s left) kms_plane_alpha_blend (alpha-7efc)
[693.302431] Starting subtest: alpha-7efc
[693.591073] Starting dynamic subtest: pipe-A-eDP-1
[694.192537] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.600s)
[694.223876] Starting dynamic subtest: pipe-D-eDP-1
[695.483891] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.270s)
[695.486291] Subtest alpha-7efc: SUCCESS (2.182s)
[696.348589] [118/133] (330s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[696.441770] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[696.446142] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s)
[696.514729] [119/133] (329s left) gem_create (create-ext-set-pat)
[696.676277] Starting subtest: create-ext-set-pat
[696.678266] Subtest create-ext-set-pat: SUCCESS (0.001s)
[696.770999] [120/133] (329s left) gem_ctx_persistence (legacy-engines-mixed)
[696.832919] Starting subtest: legacy-engines-mixed
[696.834763] Starting dynamic subtest: render
[696.905596] Dynamic subtest render: SUCCESS (0.074s)
[696.918776] Starting dynamic subtest: bsd1
[696.942868] Dynamic subtest bsd1: SUCCESS (0.035s)
[696.952466] Starting dynamic subtest: bsd2
[696.993192] Dynamic subtest bsd2: SUCCESS (0.049s)
[697.005103] Starting dynamic subtest: blt
[697.058441] Dynamic subtest blt: SUCCESS (0.063s)
[697.070964] Starting dynamic subtest: vebox
[697.116301] Dynamic subtest vebox: SUCCESS (0.055s)
[697.118817] Subtest legacy-engines-mixed: SUCCESS (0.287s)
[697.208754] [121/133] (329s left) gem_exec_flush (basic-batch-kernel-default-uc)
[697.270205] Starting subtest: basic-batch-kernel-default-uc
[703.240159] Subtest basic-batch-kernel-default-uc: SUCCESS (5.970s)
[703.447106] [122/133] (323s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[703.559294] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[703.563505] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[703.647511] [123/133] (323s left) kms_big_fb (linear-32bpp-rotate-0)
[703.749436] Starting subtest: linear-32bpp-rotate-0
[705.308609] Subtest linear-32bpp-rotate-0: SUCCESS (1.559s)
[705.453625] [124/133] (321s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[705.516119] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[705.597279] [125/133] (321s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[705.701064] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[705.704528] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[705.803944] [126/133] (320s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[705.913657] Starting subtest: flip-vs-cursor-atomic
[713.320175] Subtest flip-vs-cursor-atomic: SUCCESS (7.405s)
[714.183355] [127/133] (312s left) syncobj_timeline (reset-during-wait-for-submit)
[714.257215] Starting subtest: reset-during-wait-for-submit
[714.359619] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[714.455803] [128/133] (312s left) i915_query (query-topology-kernel-writes)
[714.517401] Starting subtest: query-topology-kernel-writes
[714.519306] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[714.626945] [129/133] (312s left) gem_exec_schedule (submit-early-slice)
[714.691812] Starting subtest: submit-early-slice
[714.693668] Starting dynamic subtest: rcs0
[714.725032] Dynamic subtest rcs0: SUCCESS (0.041s)
[714.738251] Starting dynamic subtest: bcs0
[714.759799] Dynamic subtest bcs0: SUCCESS (0.034s)
[714.770180] Starting dynamic subtest: vcs0
[714.801460] Dynamic subtest vcs0: SUCCESS (0.041s)
[714.811897] Starting dynamic subtest: vcs1
[714.837503] Dynamic subtest vcs1: SUCCESS (0.035s)
[714.848724] Starting dynamic subtest: vecs0
[714.872986] Dynamic subtest vecs0: SUCCESS (0.035s)
[714.882924] Starting dynamic subtest: ccs0
[714.910724] Dynamic subtest ccs0: SUCCESS (0.037s)
[714.912963] Subtest submit-early-slice: SUCCESS (0.228s)
[716.530831] [130/133] (310s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[716.641827] Starting subtest: short-flip-before-cursor-atomic-transitions
[717.630431] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.987s)
[718.506483] [131/133] (308s left) gem_unfence_active_buffers
[718.657452] [132/133] (308s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[718.750848] Starting subtest: fbc-farfromfence-mmap-gtt
[718.754653] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[718.852912] [133/133] (308s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[718.954548] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[725.584883] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.631s)
[725.720991] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_render_copy
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: kms_async_flips
results: parsing output: 5/ for test: kms_flip
results: parsing output: 6/ for test: i915_drm_fdinfo
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: dmabuf_sync_file
results: parsing output: 9/ for test: gem_mmap_offset
results: parsing output: 10/ for test: kms_cursor_edge_walk
results: parsing output: 11/ for test: kms_pipe_b_c_ivb
results: parsing output: 12/ for test: kms_psr2_sf
results: parsing output: 13/ for test: kms_hdr
results: parsing output: 14/ for test: perf_pmu
results: parsing output: 15/ for test: perf
results: parsing output: 16/ for test: kms_big_fb
results: parsing output: 17/ for test: gem_exec_create
results: parsing output: 18/ for test: kms_plane_scaling
results: parsing output: 19/ for test: kms_tiled_display
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_exec_balancer
results: parsing output: 23/ for test: i915_pm_rps
results: parsing output: 24/ for test: gem_userptr_blits
results: parsing output: 25/ for test: kms_addfb_basic
results: parsing output: 26/ for test: kms_psr2_sf
results: parsing output: 27/ for test: gem_exec_schedule
results: parsing output: 28/ for test: kms_vrr
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: gem_exec_fence
results: parsing output: 32/ for test: gem_render_copy
results: parsing output: 33/ for test: gem_sync
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: kms_cursor_crc
results: parsing output: 36/ for test: i915_hangman
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: kms_chamelium_hpd
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: perf
results: parsing output: 41/ for test: gem_exec_reloc
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_mmap_gtt
results: parsing output: 44/ for test: gem_lmem_swapping
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_lease
results: parsing output: 48/ for test: perf
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: gem_spin_batch
results: parsing output: 51/ for test: kms_plane
results: parsing output: 52/ for test: prime_self_import
results: parsing output: 53/ for test: kms_flip
results: parsing output: 54/ for test: gem_mmap_gtt
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_wait
results: parsing output: 60/ for test: kms_rotation_crc
results: parsing output: 61/ for test: syncobj_wait
results: parsing output: 62/ for test: kms_color
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: prime_mmap
results: parsing output: 65/ for test: gem_exec_flush
results: parsing output: 66/ for test: kms_dsc
results: parsing output: 67/ for test: gem_flink_basic
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: gem_fence_thrash
results: parsing output: 71/ for test: kms_fbcon_fbt
results: parsing output: 72/ for test: kms_flip
results: parsing output: 73/ for test: gem_mmap_wc
results: parsing output: 74/ for test: kms_flip_scaled_crc
results: parsing output: 75/ for test: kms_chamelium_edid
results: parsing output: 76/ for test: prime_busy
results: parsing output: 77/ for test: gem_exec_alignment
results: parsing output: 78/ for test: gen3_render_linear_blits
results: parsing output: 79/ for test: kms_plane_scaling
results: parsing output: 80/ for test: gem_mmap_offset
results: parsing output: 81/ for test: syncobj_wait
results: parsing output: 82/ for test: kms_pm_rpm
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: syncobj_eventfd
results: parsing output: 87/ for test: kms_debugfs
results: parsing output: 88/ for test: api_intel_bb
results: parsing output: 89/ for test: gem_ctx_freq
results: parsing output: 90/ for test: kms_atomic
results: parsing output: 91/ for test: i915_pm_rps
results: parsing output: 92/ for test: gem_busy
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: gem_exec_reloc
results: parsing output: 95/ for test: gem_mmap_gtt
results: parsing output: 96/ for test: kms_rotation_crc
results: parsing output: 97/ for test: kms_content_protection
results: parsing output: 98/ for test: kms_flip
results: parsing output: 99/ for test: kms_scaling_modes
results: parsing output: 100/ for test: perf
results: parsing output: 101/ for test: gem_exec_whisper
results: parsing output: 102/ for test: kms_psr2_sf
results: parsing output: 103/ for test: api_intel_allocator
results: parsing output: 104/ for test: kms_cursor_legacy
results: parsing output: 105/ for test: gen7_exec_parse
results: parsing output: 106/ for test: kms_invalid_mode
results: parsing output: 107/ for test: gem_exec_params
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_cdclk
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: gem_userptr_blits
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: kms_pm_rpm
results: parsing output: 116/ for test: kms_plane_alpha_blend
results: parsing output: 117/ for test: kms_plane
results: parsing output: 118/ for test: gem_create
results: parsing output: 119/ for test: gem_ctx_persistence
results: parsing output: 120/ for test: gem_exec_flush
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: gem_exec_reloc
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_cursor_legacy
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: i915_query
results: parsing output: 128/ for test: gem_exec_schedule
results: parsing output: 129/ for test: kms_cursor_legacy
results: parsing output: 130/ for test: gem_unfence_active_buffers
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.