[57.700105] Initializing watchdogs
[57.700225]   /dev/watchdog0
[57.716245] [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]
[57.720733] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.723213] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.726663] [001/133] (960s left) gem_exec_gttfill (engines)
[57.803682] Starting subtest: engines
[57.806108] Starting dynamic subtest: rcs0
[81.238726] Dynamic subtest rcs0: SUCCESS (23.492s)
[81.248784] Starting dynamic subtest: bcs0
[104.559059] Dynamic subtest bcs0: SUCCESS (23.331s)
[104.569162] Starting dynamic subtest: vcs0
[127.820252] Dynamic subtest vcs0: SUCCESS (23.266s)
[127.828205] Starting dynamic subtest: vcs1
[151.264060] Dynamic subtest vcs1: SUCCESS (23.441s)
[151.274808] Starting dynamic subtest: vecs0
[174.617292] Dynamic subtest vecs0: SUCCESS (23.351s)
[174.627717] Starting dynamic subtest: ccs0
[197.924894] Dynamic subtest ccs0: SUCCESS (23.307s)
[197.927477] Subtest engines: SUCCESS (140.194s)
[198.109209] [002/133] (820s left) perf (gen12-unprivileged-single-ctx-counters)
[198.312274] Starting subtest: gen12-unprivileged-single-ctx-counters
[198.314454] Starting dynamic subtest: rcs0
[199.194968] Dynamic subtest rcs0: SUCCESS (0.883s)
[199.197040] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.884s)
[199.246393] [003/133] (819s left) kms_joiner (basic-ultra-joiner)
[199.341470] Starting subtest: basic-ultra-joiner
[199.345301] Subtest basic-ultra-joiner: SKIP (0.000s)
[199.400185] [004/133] (818s left) prime_mmap (test_aperture_limit)
[199.460136] Starting subtest: test_aperture_limit
[199.461952] Starting dynamic subtest: test_aperture_limit-smem
[199.470276] Dynamic subtest test_aperture_limit-smem: SKIP (0.010s)
[199.473645] Subtest test_aperture_limit: SKIP (0.010s)
[199.575688] [005/133] (818s left) kms_plane (plane-position-hole)
[199.660112] Starting subtest: plane-position-hole
[200.210128] Starting dynamic subtest: pipe-A-plane-1
[201.510327] Dynamic subtest pipe-A-plane-1: SUCCESS (1.297s)
[201.520888] Starting dynamic subtest: pipe-A-plane-2
[202.817953] Dynamic subtest pipe-A-plane-2: SUCCESS (1.308s)
[202.826089] Starting dynamic subtest: pipe-A-plane-3
[204.141747] Dynamic subtest pipe-A-plane-3: SUCCESS (1.325s)
[204.150719] Starting dynamic subtest: pipe-A-plane-4
[205.527483] Dynamic subtest pipe-A-plane-4: SUCCESS (1.385s)
[205.536893] Starting dynamic subtest: pipe-A-plane-5
[205.559940] Dynamic subtest pipe-A-plane-5: SUCCESS (0.030s)
[206.737063] Starting dynamic subtest: pipe-B-plane-1
[208.048779] Dynamic subtest pipe-B-plane-1: SUCCESS (1.328s)
[208.058239] Starting dynamic subtest: pipe-B-plane-2
[209.370710] Dynamic subtest pipe-B-plane-2: SUCCESS (1.320s)
[209.382414] Starting dynamic subtest: pipe-B-plane-3
[210.692985] Dynamic subtest pipe-B-plane-3: SUCCESS (1.322s)
[210.702951] Starting dynamic subtest: pipe-B-plane-4
[211.948925] Dynamic subtest pipe-B-plane-4: SUCCESS (1.258s)
[211.958810] Starting dynamic subtest: pipe-B-plane-5
[211.975501] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[211.977854] Subtest plane-position-hole: SUCCESS (12.315s)
[212.828903] [006/133] (805s left) kms_async_flips (alternate-sync-async-flip-atomic)
[212.930110] Starting subtest: alternate-sync-async-flip-atomic
[213.300657] Starting dynamic subtest: pipe-A-eDP-1
[216.117378] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.817s)
[216.491438] Starting dynamic subtest: pipe-B-eDP-1
[219.241168] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.758s)
[219.621412] Starting dynamic subtest: pipe-C-eDP-1
[222.368369] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.755s)
[222.749084] Starting dynamic subtest: pipe-D-eDP-1
[225.507340] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.770s)
[225.509221] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.582s)
[226.678884] [007/133] (791s left) kms_cursor_crc (cursor-random-64x21)
[226.866598] Starting subtest: cursor-random-64x21
[226.913852] Subtest cursor-random-64x21: SKIP (0.042s)
[227.146818] [008/133] (791s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[227.236909] Starting subtest: basic-batch-kernel-default-cmd
[227.241467] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[227.430249] [009/133] (791s left) gem_userptr_blits (map-fixed-invalidate)
[227.497976] Starting subtest: map-fixed-invalidate
[227.502565] Subtest map-fixed-invalidate: SKIP (0.000s)
[227.608404] [010/133] (790s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[227.668427] Starting subtest: multi-wait-for-submit-submitted-signaled
[227.670704] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[227.768829] [011/133] (790s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[227.867996] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[228.680408] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.815s)
[228.863160] [012/133] (789s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[228.984236] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[260.428805] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.445s)
[261.304797] [013/133] (757s left) kms_psr (psr2-basic)
[261.404145] Starting subtest: psr2-basic
[261.406487] Starting dynamic subtest: eDP-1
[262.979488] Dynamic subtest eDP-1: SUCCESS (1.575s)
[262.981922] Subtest psr2-basic: SUCCESS (1.576s)
[263.773652] [014/133] (754s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[263.894178] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[263.898586] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[264.004357] [015/133] (754s left) kms_big_fb (linear-16bpp-rotate-180)
[264.108057] Starting subtest: linear-16bpp-rotate-180
[265.386059] Subtest linear-16bpp-rotate-180: SUCCESS (1.278s)
[265.506298] [016/133] (753s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[265.601442] Starting subtest: bad-pixel-format-y-tiled-ccs
[265.603440] Starting dynamic subtest: pipe-A-eDP-1
[265.621922] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[265.634216] Starting dynamic subtest: pipe-B-eDP-1
[265.651711] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[265.659257] Starting dynamic subtest: pipe-C-eDP-1
[265.676685] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[265.684286] Starting dynamic subtest: pipe-D-eDP-1
[265.702935] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[265.706621] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.004s)
[267.780200] [017/133] (751s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[267.875913] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[267.880193] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s)
[267.947291] [018/133] (750s left) i915_drm_fdinfo (most-busy-idle-check-all)
[267.988854] Starting subtest: most-busy-idle-check-all
[267.991297] Starting dynamic subtest: rcs0
[267.995934] Dynamic subtest rcs0: SKIP (0.004s)
[268.004596] Starting dynamic subtest: bcs0
[268.008738] Dynamic subtest bcs0: SKIP (0.000s)
[268.017248] Starting dynamic subtest: vcs0
[268.021665] Dynamic subtest vcs0: SKIP (0.000s)
[268.029933] Starting dynamic subtest: vcs1
[268.034359] Dynamic subtest vcs1: SKIP (0.000s)
[268.043070] Starting dynamic subtest: vecs0
[268.047431] Dynamic subtest vecs0: SKIP (0.000s)
[268.055860] Starting dynamic subtest: ccs0
[268.060229] Dynamic subtest ccs0: SKIP (0.000s)
[268.065030] Subtest most-busy-idle-check-all: SKIP (0.008s)
[268.102789] [019/133] (750s left) perf_pmu (rc6-suspend)
[268.147941] Starting subtest: rc6-suspend
[291.446731] Subtest rc6-suspend: SUCCESS (7.729s)
[292.326349] [020/133] (726s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[292.443183] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[292.447547] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[292.554191] [021/133] (726s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[292.634355] Starting subtest: fbc-psr2-sprite-plane-onoff
[292.636190] Starting dynamic subtest: eDP-1
[292.639574] Dynamic subtest eDP-1: SKIP (0.000s)
[292.642944] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[292.702779] [022/133] (726s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[292.805868] Starting subtest: 4-tiled-16bpp-rotate-0
[294.106798] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.323s)
[294.226317] [023/133] (724s left) gem_workarounds (reset-fd)
[294.280291] Starting subtest: reset-fd
[294.468410] Subtest reset-fd: SUCCESS (0.191s)
[294.586475] [024/133] (724s left) kms_fence_pin_leak
[294.764667] [025/133] (724s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[294.830250] Starting subtest: y-tiled-to-vebox-y-tiled
[294.834038] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[295.016530] [026/133] (724s left) kms_cdclk (mode-transition)
[295.105724] Starting subtest: mode-transition
[295.108048] Starting dynamic subtest: pipe-A-eDP-1
[295.391147] Dynamic subtest pipe-A-eDP-1: SKIP (0.288s)
[295.401319] Starting dynamic subtest: pipe-B-eDP-1
[295.405906] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[295.415691] Starting dynamic subtest: pipe-C-eDP-1
[295.420239] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[295.429599] Starting dynamic subtest: pipe-D-eDP-1
[295.433661] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[295.437706] Subtest mode-transition: SKIP (0.295s)
[296.186200] [027/133] (723s left) gem_exec_params (dr4-dirt)
[296.247197] Starting subtest: DR4-dirt
[296.249523] Subtest DR4-dirt: SUCCESS (0.000s)
[296.357764] [028/133] (722s left) syncobj_wait (multi-wait-all-submitted)
[296.422195] Starting subtest: multi-wait-all-submitted
[296.528632] Subtest multi-wait-all-submitted: SUCCESS (0.106s)
[296.615181] [029/133] (722s left) gem_exec_store (basic)
[296.676581] Starting subtest: basic
[296.771209] Subtest basic: SUCCESS (0.097s)
[296.952107] [030/133] (722s left) gem_ctx_persistence (saturated-hostile)
[297.008115] Starting subtest: saturated-hostile
[297.010457] Starting dynamic subtest: rcs0
[297.823787] Dynamic subtest rcs0: SUCCESS (0.824s)
[297.836585] Starting dynamic subtest: bcs0
[298.610482] Dynamic subtest bcs0: SUCCESS (0.792s)
[298.620663] Starting dynamic subtest: vcs0
[299.396243] Dynamic subtest vcs0: SUCCESS (0.790s)
[299.409020] Starting dynamic subtest: vcs1
[300.196413] Dynamic subtest vcs1: SUCCESS (0.805s)
[300.209637] Starting dynamic subtest: vecs0
[301.006589] Dynamic subtest vecs0: SUCCESS (0.814s)
[301.019005] Starting dynamic subtest: ccs0
[301.832683] Dynamic subtest ccs0: SUCCESS (0.829s)
[301.835274] Subtest saturated-hostile: SUCCESS (4.865s)
[301.910989] [031/133] (717s left) kms_psr (psr-cursor-plane-onoff)
[302.002627] Starting subtest: psr-cursor-plane-onoff
[302.004943] Starting dynamic subtest: eDP-1
[303.712795] Dynamic subtest eDP-1: SUCCESS (1.718s)
[303.715013] Subtest psr-cursor-plane-onoff: SUCCESS (1.720s)
[304.586598] [032/133] (714s left) i915_hangman (detector)
[304.648921] Starting subtest: detector
[304.651170] Starting dynamic subtest: rcs0
[316.531217] Dynamic subtest rcs0: SUCCESS (11.909s)
[316.544014] Starting dynamic subtest: bcs0
[328.563194] Dynamic subtest bcs0: SUCCESS (12.027s)
[328.576720] Starting dynamic subtest: vcs0
[340.530571] Dynamic subtest vcs0: SUCCESS (11.965s)
[340.542909] Starting dynamic subtest: vcs1
[351.539934] Dynamic subtest vcs1: SUCCESS (11.009s)
[351.552504] Starting dynamic subtest: vecs0
[363.506812] Dynamic subtest vecs0: SUCCESS (11.969s)
[363.518930] Starting dynamic subtest: ccs0
[374.514397] Dynamic subtest ccs0: SUCCESS (11.008s)
[374.517420] Subtest detector: SUCCESS (69.901s)
[374.650428] [033/133] (644s left) kms_force_connector_basic (force-connector-state)
[374.742446] Starting subtest: force-connector-state
[375.364714] Subtest force-connector-state: SUCCESS (0.622s)
[376.267451] [034/133] (643s left) kms_universal_plane (universal-plane-sanity)
[376.362355] Starting subtest: universal-plane-sanity
[376.364775] Starting dynamic subtest: pipe-A-eDP-1
[376.960108] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.599s)
[376.970546] Starting dynamic subtest: pipe-B-eDP-1
[378.170222] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.209s)
[378.181329] Starting dynamic subtest: pipe-C-eDP-1
[379.336554] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.162s)
[379.347136] Starting dynamic subtest: pipe-D-eDP-1
[380.535640] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.200s)
[380.537928] Subtest universal-plane-sanity: SUCCESS (4.177s)
[381.366766] [035/133] (638s left) dmabuf_sync_file (import-multiple-read-write)
[381.465902] Starting subtest: import-multiple-read-write
[381.468297] Subtest import-multiple-read-write: SUCCESS (0.003s)
[381.524622] [FACT dmabuf_sync_file (import-multiple-read-write)] new: kernel.kmod_is_loaded.vgem: true
[381.527914] [036/133] (638s left) kms_pm_dc (dc5-dpms-negative)
[382.621071] Starting subtest: dc5-dpms-negative
[382.625658] Subtest dc5-dpms-negative: SKIP (0.000s)
[382.697141] [037/133] (636s left) gem_render_copy_redux (flink)
[382.759592] Starting subtest: flink
[383.586074] Subtest flink: SUCCESS (0.827s)
[383.676774] [038/133] (636s left) kms_cursor_crc (cursor-onscreen-64x64)
[383.868348] Starting subtest: cursor-onscreen-64x64
[383.870263] Starting dynamic subtest: pipe-A-eDP-1
[386.003095] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.129s)
[386.032092] Starting dynamic subtest: pipe-D-eDP-1
[388.806314] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.780s)
[388.808534] Subtest cursor-onscreen-64x64: SUCCESS (4.935s)
[389.666065] [039/133] (630s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[389.773650] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[389.777745] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[389.863225] [040/133] (629s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[389.954101] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[398.959003] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (9.004s)
[399.063250] [041/133] (620s left) gem_mmap_wc (bad-offset)
[399.126225] Subtest bad-offset: SKIP (0.000s)
[399.188198] [042/133] (620s left) gem_softpin (evict-single-offset)
[399.247621] Starting subtest: evict-single-offset
[424.597787] Subtest evict-single-offset: SUCCESS (25.345s)
[424.679522] [043/133] (595s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[424.887183] Starting subtest: dp-mst-type-1-suspend-resume
[424.891697] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[425.015199] [044/133] (594s left) gem_ctx_shared (q-out-order)
[425.080936] Starting subtest: Q-out-order
[425.083085] Starting dynamic subtest: rcs0
[425.196556] Dynamic subtest rcs0: SUCCESS (0.113s)
[425.210902] Starting dynamic subtest: vcs0
[425.286167] Dynamic subtest vcs0: SUCCESS (0.090s)
[425.303965] Starting dynamic subtest: vcs1
[425.370960] Dynamic subtest vcs1: SUCCESS (0.084s)
[425.389968] Starting dynamic subtest: vecs0
[425.450383] Dynamic subtest vecs0: SUCCESS (0.078s)
[425.468335] Starting dynamic subtest: ccs0
[425.544310] Dynamic subtest ccs0: SUCCESS (0.093s)
[425.546948] Subtest Q-out-order: SUCCESS (0.463s)
[426.680008] [045/133] (593s left) gem_softpin (softpin)
[426.741947] Starting subtest: softpin
[458.994853] Subtest softpin: SUCCESS (32.252s)
[459.123979] [046/133] (560s left) kms_plane_alpha_blend (coverage-7efc)
[459.229958] Starting subtest: coverage-7efc
[459.515546] Starting dynamic subtest: pipe-A-eDP-1
[460.082979] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.566s)
[460.112461] Starting dynamic subtest: pipe-D-eDP-1
[461.451085] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.347s)
[461.453406] Subtest coverage-7efc: SUCCESS (2.223s)
[462.262415] [047/133] (557s left) kms_busy (extended-pageflip-hang-oldfb)
[462.355257] Starting subtest: extended-pageflip-hang-oldfb
[462.357289] Starting dynamic subtest: pipe-A
[462.779653] Dynamic subtest pipe-A: SUCCESS (0.423s)
[462.790653] Starting dynamic subtest: pipe-D
[463.857508] Dynamic subtest pipe-D: SUCCESS (1.077s)
[463.859954] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.505s)
[464.665304] [048/133] (555s left) kms_big_fb (y-tiled-addfb)
[464.762955] Starting subtest: y-tiled-addfb
[464.767442] Subtest y-tiled-addfb: SKIP (0.000s)
[464.846776] [049/133] (555s left) kms_plane_multiple (tiling-none)
[464.950962] Starting subtest: tiling-none
[464.953168] Starting dynamic subtest: pipe-A-eDP-1
[468.800453] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.848s)
[468.811672] Starting dynamic subtest: pipe-B-eDP-1
[473.396705] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.595s)
[473.407539] Starting dynamic subtest: pipe-C-eDP-1
[477.974864] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.579s)
[477.986593] Starting dynamic subtest: pipe-D-eDP-1
[482.479364] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.505s)
[482.481776] Subtest tiling-none: SUCCESS (17.534s)
[483.372078] [050/133] (536s left) kms_chamelium_frames (dp-crc-fast)
[483.754906] Subtest dp-crc-fast: SKIP (0.000s)
[484.542717] [051/133] (535s left) i915_suspend (fence-restore-tiled2untiled)
[484.591903] Starting subtest: fence-restore-tiled2untiled
[484.596183] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[484.683288] [052/133] (535s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[484.775614] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[491.200290] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.428s)
[491.302155] [053/133] (529s left) kms_chamelium_hpd (hdmi-hpd-fast)
[491.685209] Subtest hdmi-hpd-fast: SKIP (0.000s)
[492.538124] [054/133] (527s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[492.637629] Starting subtest: fbc-psr2-primary-mmap-cpu
[492.639790] Starting dynamic subtest: eDP-1
[492.643774] Dynamic subtest eDP-1: SKIP (0.000s)
[492.647799] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[492.712277] [055/133] (527s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[492.816691] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[492.819052] Starting dynamic subtest: pipe-A-eDP-1
[509.294785] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.486s)
[509.305225] Starting dynamic subtest: pipe-B-eDP-1
[526.508891] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.208s)
[526.511349] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.696s)
[527.351380] [056/133] (493s left) api_intel_bb (object-reloc-keep-cache)
[527.415298] Starting subtest: object-reloc-keep-cache
[527.419987] Subtest object-reloc-keep-cache: SKIP (0.003s)
[527.520428] [057/133] (493s left) kms_flip (absolute-wf_vblank)
[527.615262] Starting subtest: absolute-wf_vblank
[527.617558] Starting dynamic subtest: A-eDP1
[536.373493] Dynamic subtest A-eDP1: SUCCESS (8.757s)
[536.385663] Starting dynamic subtest: B-eDP1
[545.086152] Dynamic subtest B-eDP1: SUCCESS (8.710s)
[545.096556] Starting dynamic subtest: C-eDP1
[553.773419] Dynamic subtest C-eDP1: SUCCESS (8.684s)
[553.787916] Starting dynamic subtest: D-eDP1
[562.473838] Dynamic subtest D-eDP1: SUCCESS (8.698s)
[562.479124] Subtest absolute-wf_vblank: SUCCESS (34.861s)
[563.650454] [058/133] (456s left) gem_exec_schedule (preempt-other-chain)
[563.728686] Starting subtest: preempt-other-chain
[563.730744] Starting dynamic subtest: rcs0
[563.807871] Dynamic subtest rcs0: SUCCESS (0.087s)
[563.820265] Starting dynamic subtest: bcs0
[563.897910] Dynamic subtest bcs0: SUCCESS (0.089s)
[563.910230] Starting dynamic subtest: vcs0
[563.985445] Dynamic subtest vcs0: SUCCESS (0.087s)
[563.995868] Starting dynamic subtest: vcs1
[564.071352] Dynamic subtest vcs1: SUCCESS (0.085s)
[564.083868] Starting dynamic subtest: vecs0
[564.158460] Dynamic subtest vecs0: SUCCESS (0.087s)
[564.170390] Starting dynamic subtest: ccs0
[564.249826] Dynamic subtest ccs0: SUCCESS (0.090s)
[564.252482] Subtest preempt-other-chain: SUCCESS (0.530s)
[565.693349] [059/133] (454s left) gem_exec_schedule (u-fairslice)
[565.757023] Starting subtest: u-fairslice
[565.759249] Starting dynamic subtest: rcs0
[567.775155] Dynamic subtest rcs0: SUCCESS (2.024s)
[567.785761] Starting dynamic subtest: bcs0
[569.797184] Dynamic subtest bcs0: SUCCESS (2.021s)
[569.809048] Starting dynamic subtest: vcs0
[571.818925] Dynamic subtest vcs0: SUCCESS (2.019s)
[571.831097] Starting dynamic subtest: vcs1
[573.838452] Dynamic subtest vcs1: SUCCESS (2.018s)
[573.850285] Starting dynamic subtest: vecs0
[575.857226] Dynamic subtest vecs0: SUCCESS (2.018s)
[575.869016] Starting dynamic subtest: ccs0
[577.878987] Dynamic subtest ccs0: SUCCESS (2.021s)
[577.880957] Subtest u-fairslice: SUCCESS (12.127s)
[578.196422] [060/133] (442s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[578.300514] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[578.304799] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[578.400338] [061/133] (442s left) kms_cursor_crc (cursor-sliding-256x85)
[578.662497] Starting subtest: cursor-sliding-256x85
[578.709092] Subtest cursor-sliding-256x85: SKIP (0.042s)
[578.897045] [062/133] (441s left) gem_shrink (reclaim)
[578.955464] Starting subtest: reclaim
[581.331243] Subtest reclaim: SUCCESS (2.370s)
[581.483420] [063/133] (439s left) syncobj_timeline (wait-for-submit-complex)
[581.540435] Starting subtest: wait-for-submit-complex
[581.601467] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[581.685206] [064/133] (439s left) kms_dsc (dsc-with-formats)
[581.775015] Starting subtest: dsc-with-formats
[581.814282] Subtest dsc-with-formats: SKIP (0.001s)
[581.862440] [065/133] (439s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[581.977340] Starting subtest: flip-vs-cursor-atomic
[589.149998] Subtest flip-vs-cursor-atomic: SUCCESS (7.173s)
[589.952637] [066/133] (430s left) kms_vblank (query-forked-busy)
[590.040775] Starting subtest: query-forked-busy
[590.042561] Starting dynamic subtest: pipe-A-eDP-1
[591.938059] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.898s)
[591.954912] Starting dynamic subtest: pipe-D-eDP-1
[594.471368] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.530s)
[594.473724] Subtest query-forked-busy: SUCCESS (4.433s)
[595.360351] [067/133] (425s left) kms_lease (lease-unleased-connector)
[595.454666] Starting subtest: lease-unleased-connector
[595.456977] Starting dynamic subtest: pipe-A-eDP-1
[595.459354] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[595.474085] Starting dynamic subtest: pipe-B-eDP-1
[595.476504] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s)
[595.487425] Starting dynamic subtest: pipe-C-eDP-1
[595.489687] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[595.499911] Starting dynamic subtest: pipe-D-eDP-1
[595.502162] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[595.504292] Subtest lease-unleased-connector: SUCCESS (0.034s)
[595.606004] [068/133] (425s left) kms_addfb_basic (bad-pitch-63)
[595.658047] Starting subtest: bad-pitch-63
[595.660317] Subtest bad-pitch-63: SUCCESS (0.000s)
[595.796166] [069/133] (425s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[595.897474] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[595.901551] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[596.000832] [070/133] (425s left) gem_exec_params (dr1-dirt)
[596.063870] Starting subtest: DR1-dirt
[596.066243] Subtest DR1-dirt: SUCCESS (0.000s)
[596.166849] [071/133] (424s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[596.269826] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[596.273994] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[596.367124] [072/133] (424s left) kms_rmfb (rmfb-ioctl)
[596.469182] Starting subtest: rmfb-ioctl
[596.470983] Starting dynamic subtest: pipe-A-eDP-1
[596.573962] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[596.587541] Starting dynamic subtest: pipe-B-eDP-1
[597.768787] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.192s)
[597.779225] Starting dynamic subtest: pipe-C-eDP-1
[598.975783] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.206s)
[598.987474] Starting dynamic subtest: pipe-D-eDP-1
[600.163386] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.186s)
[600.165832] Subtest rmfb-ioctl: SUCCESS (3.696s)
[601.351161] [073/133] (419s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[601.444714] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[608.122793] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.680s)
[608.241831] [074/133] (413s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[608.348104] Starting subtest: fbc-rgb565-draw-blt
[612.457285] Subtest fbc-rgb565-draw-blt: SUCCESS (4.112s)
[613.671477] [075/133] (407s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[613.772247] Starting subtest: crc-primary-basic-yf-tiled-ccs
[613.774660] Starting dynamic subtest: pipe-A-eDP-1
[613.797647] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[613.810478] Starting dynamic subtest: pipe-B-eDP-1
[613.831675] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[613.841679] Starting dynamic subtest: pipe-C-eDP-1
[613.863076] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[613.875090] Starting dynamic subtest: pipe-D-eDP-1
[613.896818] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[613.901236] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.006s)
[616.057735] [076/133] (405s left) i915_pm_rpm (sysfs-read)
[617.690284] Starting subtest: sysfs-read
[618.868674] Subtest sysfs-read: SUCCESS (1.172s)
[619.248432] [077/133] (402s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[619.350667] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[619.352822] Starting dynamic subtest: pipe-A-default-mode
[622.002599] Dynamic subtest pipe-A-default-mode: SUCCESS (2.652s)
[622.004962] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.654s)
[622.852742] [078/133] (398s left) gem_unfence_active_buffers
[623.021284] [079/133] (398s left) gem_exec_suspend (basic)
[623.077450] Starting subtest: basic
[623.079820] Starting dynamic subtest: smem
[624.596314] Dynamic subtest smem: SUCCESS (1.517s)
[624.599087] Subtest basic: SUCCESS (1.519s)
[624.779846] [080/133] (396s left) gem_exec_whisper (basic-sync)
[624.855378] Starting subtest: basic-sync
[634.663296] Subtest basic-sync: SUCCESS (9.806s)
[634.853846] [081/133] (386s left) gem_exec_params (invalid-bsd-ring)
[634.916052] Starting subtest: invalid-bsd-ring
[634.918624] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[635.028648] [082/133] (386s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[635.120160] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[635.124483] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[635.198259] [083/133] (386s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[635.262515] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[635.330894] [084/133] (386s left) gem_exec_fence (syncobj-signal)
[635.799277] Starting subtest: syncobj-signal
[635.804615] Subtest syncobj-signal: SUCCESS (0.004s)
[637.661756] [085/133] (384s left) i915_query (query-topology-coherent-slice-mask)
[637.713141] Starting subtest: query-topology-coherent-slice-mask
[637.717245] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[637.814363] [086/133] (384s left) syncobj_eventfd (invalid-illegal-handle)
[637.867977] Starting subtest: invalid-illegal-handle
[637.870242] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[637.964496] [087/133] (383s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[638.067940] Starting subtest: psr2-cursor-plane-update-sf
[638.070164] Starting dynamic subtest: pipe-A-eDP-1
[638.635042] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.571s)
[638.646536] Starting dynamic subtest: pipe-B-eDP-1
[639.886129] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.249s)
[639.888359] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.823s)
[640.741316] [088/133] (381s left) kms_flip (flip-vs-expired-vblank)
[640.822836] Starting subtest: flip-vs-expired-vblank
[640.825162] Starting dynamic subtest: A-eDP1
[649.525969] Dynamic subtest A-eDP1: SUCCESS (8.703s)
[649.536580] Starting dynamic subtest: B-eDP1
[658.226971] Dynamic subtest B-eDP1: SUCCESS (8.701s)
[658.240415] Starting dynamic subtest: C-eDP1
[666.903930] Dynamic subtest C-eDP1: SUCCESS (8.675s)
[666.914798] Starting dynamic subtest: D-eDP1
[675.594437] Dynamic subtest D-eDP1: SUCCESS (8.690s)
[675.599902] Subtest flip-vs-expired-vblank: SUCCESS (34.782s)
[676.828327] [089/133] (345s left) gem_create (create-massive)
[676.902567] Starting subtest: create-massive
[676.904914] Subtest create-massive: SUCCESS (0.000s)
[677.088478] [090/133] (344s left) kms_flip (flip-vs-wf_vblank-interruptible)
[677.193519] Starting subtest: flip-vs-wf_vblank-interruptible
[677.195743] Starting dynamic subtest: A-eDP1
[679.146608] Dynamic subtest A-eDP1: SUCCESS (1.952s)
[679.160333] Starting dynamic subtest: B-eDP1
[681.059351] Dynamic subtest B-eDP1: SUCCESS (1.908s)
[681.070513] Starting dynamic subtest: C-eDP1
[682.933157] Dynamic subtest C-eDP1: SUCCESS (1.872s)
[682.946212] Starting dynamic subtest: D-eDP1
[684.828568] Dynamic subtest D-eDP1: SUCCESS (1.895s)
[684.834149] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.640s)
[686.027144] [091/133] (336s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[686.134954] Starting subtest: psr-rgb101010-draw-mmap-cpu
[693.066421] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (6.935s)
[693.184122] [092/133] (328s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[693.255027] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[693.322218] [093/133] (328s left) gem_mmap_gtt (isolation)
[693.383926] Subtest isolation: SKIP (0.000s)
[693.447639] [094/133] (328s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[693.550430] Starting subtest: plane-lut1d-post-ctm3x4
[693.696662] Starting dynamic subtest: pipe-A-plane-0
[694.045332] Dynamic subtest pipe-A-plane-0: FAIL (0.188s)
[694.057366] Starting dynamic subtest: pipe-A-plane-1
[694.241518] Dynamic subtest pipe-A-plane-1: FAIL (0.186s)
[694.252044] Starting dynamic subtest: pipe-A-plane-2
[694.452192] Dynamic subtest pipe-A-plane-2: FAIL (0.192s)
[695.500989] Starting dynamic subtest: pipe-B-plane-0
[695.933597] Dynamic subtest pipe-B-plane-0: FAIL (0.175s)
[695.944428] Starting dynamic subtest: pipe-B-plane-1
[696.249104] Dynamic subtest pipe-B-plane-1: FAIL (0.178s)
[696.261508] Starting dynamic subtest: pipe-B-plane-2
[696.559057] Dynamic subtest pipe-B-plane-2: FAIL (0.175s)
[697.175651] Starting dynamic subtest: pipe-C-plane-0
[697.687341] Dynamic subtest pipe-C-plane-0: FAIL (0.152s)
[697.699553] Starting dynamic subtest: pipe-C-plane-1
[698.097201] Dynamic subtest pipe-C-plane-1: FAIL (0.204s)
[698.108954] Starting dynamic subtest: pipe-C-plane-2
[698.470650] Dynamic subtest pipe-C-plane-2: FAIL (0.623s)
[699.395251] Starting dynamic subtest: pipe-D-plane-0
[699.985887] Dynamic subtest pipe-D-plane-0: FAIL (0.141s)
[699.997858] Starting dynamic subtest: pipe-D-plane-1
[700.454439] Dynamic subtest pipe-D-plane-1: FAIL (0.630s)
[700.466077] Starting dynamic subtest: pipe-D-plane-2
[700.905267] Dynamic subtest pipe-D-plane-2: FAIL (0.569s)
[701.023328] Subtest plane-lut1d-post-ctm3x4: FAIL (7.476s)
[701.823214] [095/133] (320s left) kms_prime (d3hot)
[701.922285] Subtest D3hot: SKIP (0.000s)
[702.041926] [096/133] (320s left) gem_exec_reloc (basic-wc-gtt)
[702.105236] Subtest basic-wc-gtt: SKIP (0.000s)
[702.186103] [097/133] (320s left) gem_exec_balancer (parallel)
[702.452391] Starting subtest: parallel
[703.425317] Subtest parallel: SUCCESS (0.973s)
[704.670233] [098/133] (317s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[704.781810] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[704.786084] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[705.927088] [099/133] (316s left) kms_flip (plain-flip-interruptible)
[706.022356] Starting subtest: plain-flip-interruptible
[706.024740] Starting dynamic subtest: A-eDP1
[707.707404] Dynamic subtest A-eDP1: SUCCESS (1.684s)
[707.723383] Starting dynamic subtest: B-eDP1
[709.391123] Dynamic subtest B-eDP1: SUCCESS (1.681s)
[709.407561] Starting dynamic subtest: C-eDP1
[711.083532] Dynamic subtest C-eDP1: SUCCESS (1.688s)
[711.096467] Starting dynamic subtest: D-eDP1
[712.687908] Dynamic subtest D-eDP1: SUCCESS (1.604s)
[712.692943] Subtest plain-flip-interruptible: SUCCESS (6.672s)
[713.922835] [100/133] (308s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[714.015930] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[714.018164] Starting dynamic subtest: pipe-A-eDP-1
[714.039951] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[714.051195] Starting dynamic subtest: pipe-B-eDP-1
[714.073318] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[714.083640] Starting dynamic subtest: pipe-C-eDP-1
[714.105442] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[714.116033] Starting dynamic subtest: pipe-D-eDP-1
[714.138504] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[714.142571] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.005s)
[716.226887] [101/133] (306s left) gem_ctx_param (vm)
[716.276902] Starting subtest: vm
[716.333670] Subtest vm: SUCCESS (0.056s)
[716.478056] [102/133] (306s left) kms_properties (plane-properties-legacy)
[716.572257] Starting subtest: plane-properties-legacy
[716.574216] Starting dynamic subtest: pipe-A-eDP-1
[717.154091] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.580s)
[717.165661] Starting dynamic subtest: pipe-B-eDP-1
[718.469813] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.314s)
[718.480785] Starting dynamic subtest: pipe-C-eDP-1
[719.756762] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.289s)
[719.768749] Starting dynamic subtest: pipe-D-eDP-1
[721.041945] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.283s)
[721.044218] Subtest plane-properties-legacy: SUCCESS (4.472s)
[721.935788] [103/133] (300s left) gem_pxp (reject-modify-context-protection-off-3)
[722.078310] Starting subtest: reject-modify-context-protection-off-3
[722.080912] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[722.198085] [104/133] (300s left) prime_self_import (basic-with_one_bo_two_files)
[722.236540] Starting subtest: basic-with_one_bo_two_files
[722.262767] Subtest basic-with_one_bo_two_files: SUCCESS (0.026s)
[722.377272] [105/133] (300s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[722.474944] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[722.477217] Starting dynamic subtest: pipe-A
[722.538026] Dynamic subtest pipe-A: SUCCESS (0.065s)
[722.550167] Starting dynamic subtest: pipe-B
[723.709550] Dynamic subtest pipe-B: SUCCESS (1.171s)
[723.725386] Starting dynamic subtest: pipe-C
[724.809089] Dynamic subtest pipe-C: SUCCESS (1.099s)
[724.819915] Starting dynamic subtest: pipe-D
[725.892042] Dynamic subtest pipe-D: SUCCESS (1.082s)
[725.894358] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.420s)
[727.016182] [106/133] (295s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[727.126660] Starting subtest: 4-tiled-16bpp-rotate-90
[727.147265] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.020s)
[727.274786] [107/133] (295s left) gen9_exec_parse (batch-invalid-length)
[727.336549] Subtest batch-invalid-length: SKIP (0.000s)
[727.419135] [108/133] (295s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[727.480279] Starting subtest: invalid-signal-one-illegal-handle
[727.482562] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[727.583394] [109/133] (295s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[727.683933] Starting subtest: x-tiled-64bpp-rotate-180
[729.229137] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.546s)
[729.445508] [110/133] (293s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[729.552931] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[729.557148] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[729.662709] [111/133] (293s left) gem_exec_params (invalid-ring2)
[729.719486] Starting subtest: invalid-ring2
[729.721769] Subtest invalid-ring2: SUCCESS (0.000s)
[729.824107] [112/133] (293s left) gem_vm_create (invalid-create)
[729.888323] Starting subtest: invalid-create
[729.890597] Subtest invalid-create: SUCCESS (0.003s)
[729.999385] [113/133] (293s left) kms_addfb_basic (bad-pitch-128)
[730.060803] Starting subtest: bad-pitch-128
[730.063284] Subtest bad-pitch-128: SUCCESS (0.000s)
[730.216409] [114/133] (292s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[730.276506] Starting subtest: single-wait-all-for-submit-available-submitted
[730.278830] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[730.370636] [115/133] (292s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[730.481512] Starting subtest: cursorB-vs-flipA-toggle
[730.485382] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[730.629414] [116/133] (292s left) prime_vgem (fence-write-hang)
[730.715306] Subtest fence-write-hang: SKIP (0.000s)
[730.819269] [117/133] (292s left) fbdev (eof)
[730.866585] Starting subtest: eof
[730.868581] Subtest eof: SUCCESS (0.000s)
[730.970787] [118/133] (292s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[731.088332] Starting subtest: 2x-flip-vs-cursor-atomic
[731.092736] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[731.266508] [119/133] (292s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[731.367779] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[731.371333] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[731.472298] [120/133] (291s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[731.567896] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[738.621644] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (7.055s)
[738.772397] [121/133] (284s left) prime_mmap_kms (buffer-sharing)
[738.863611] Starting subtest: buffer-sharing
[739.307619] Subtest buffer-sharing: SUCCESS (0.444s)
[740.119836] [122/133] (283s left) gem_exec_fence (basic-await)
[740.290040] Starting subtest: basic-await
[740.292422] Starting dynamic subtest: rcs0
[740.367218] Dynamic subtest rcs0: SUCCESS (0.076s)
[740.381549] Starting dynamic subtest: bcs0
[740.443448] Dynamic subtest bcs0: SUCCESS (0.074s)
[740.455806] Starting dynamic subtest: vcs0
[740.516672] Dynamic subtest vcs0: SUCCESS (0.072s)
[740.530650] Starting dynamic subtest: vcs1
[740.591591] Dynamic subtest vcs1: SUCCESS (0.074s)
[740.604714] Starting dynamic subtest: vecs0
[740.666636] Dynamic subtest vecs0: SUCCESS (0.072s)
[740.680719] Starting dynamic subtest: ccs0
[740.740017] Dynamic subtest ccs0: SUCCESS (0.072s)
[740.742719] Subtest basic-await: SUCCESS (0.451s)
[742.709554] [123/133] (280s left) prime_busy (before-wait)
[742.780692] Starting subtest: before-wait
[742.782746] Starting dynamic subtest: rcs0
[742.822930] Dynamic subtest rcs0: SUCCESS (0.040s)
[742.836120] Starting dynamic subtest: bcs0
[742.872561] Dynamic subtest bcs0: SUCCESS (0.050s)
[742.884190] Starting dynamic subtest: vcs0
[742.914912] Dynamic subtest vcs0: SUCCESS (0.042s)
[742.925092] Starting dynamic subtest: vcs1
[742.957536] Dynamic subtest vcs1: SUCCESS (0.042s)
[742.967870] Starting dynamic subtest: vecs0
[742.999290] Dynamic subtest vecs0: SUCCESS (0.041s)
[743.009825] Starting dynamic subtest: ccs0
[743.041373] Dynamic subtest ccs0: SUCCESS (0.041s)
[743.150248] Subtest before-wait: SUCCESS (0.370s)
[743.234479] [124/133] (280s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[743.355561] Starting subtest: short-busy-flip-before-cursor-toggle
[743.360105] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[743.506508] [125/133] (280s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[743.563699] Starting subtest: invalid-multi-wait-unsubmitted
[743.565959] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[743.672427] [126/133] (279s left) gem_mmap_wc (invalid-flags)
[743.730489] Subtest invalid-flags: SKIP (0.000s)
[743.789295] [127/133] (279s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[743.884274] Starting subtest: yf-tiled-64bpp-rotate-270
[743.888376] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[743.986603] [128/133] (279s left) kms_tv_load_detect (load-detect)
[744.044131] Subtest load-detect: SKIP (0.000s)
[744.102214] [129/133] (279s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[744.197718] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[744.201099] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[744.284977] [130/133] (279s left) syncobj_wait (wait-any-complex)
[744.341056] Starting subtest: wait-any-complex
[744.402462] Subtest wait-any-complex: SUCCESS (0.062s)
[744.484108] [131/133] (279s left) sw_sync (sync_expired_merge)
[744.526555] Starting subtest: sync_expired_merge
[745.599161] Subtest sync_expired_merge: SUCCESS (1.074s)
[745.674330] [132/133] (278s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[745.774169] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[745.778506] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[745.872729] [133/133] (278s left) kms_psr (psr-suspend)
[745.960480] Starting subtest: psr-suspend
[745.962658] Starting dynamic subtest: eDP-1
[763.712614] Dynamic subtest eDP-1: SUCCESS (2.953s)
[763.715130] Subtest psr-suspend: SUCCESS (2.955s)
[764.540660] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_gttfill
results: parsing output: 1/ for test: perf
results: parsing output: 2/ for test: kms_joiner
results: parsing output: 3/ for test: prime_mmap
results: parsing output: 4/ for test: kms_plane
results: parsing output: 5/ for test: kms_async_flips
results: parsing output: 6/ for test: kms_cursor_crc
results: parsing output: 7/ for test: gem_exec_flush
results: parsing output: 8/ for test: gem_userptr_blits
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: kms_cursor_legacy
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: kms_ccs
results: parsing output: 16/ for test: kms_plane
results: parsing output: 17/ for test: i915_drm_fdinfo
results: parsing output: 18/ for test: perf_pmu
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: gem_workarounds
results: parsing output: 23/ for test: kms_fence_pin_leak
results: parsing output: 24/ for test: gem_render_copy
results: parsing output: 25/ for test: kms_cdclk
results: parsing output: 26/ for test: gem_exec_params
results: parsing output: 27/ for test: syncobj_wait
results: parsing output: 28/ for test: gem_exec_store
results: parsing output: 29/ for test: gem_ctx_persistence
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: i915_hangman
results: parsing output: 32/ for test: kms_force_connector_basic
results: parsing output: 33/ for test: kms_universal_plane
results: parsing output: 34/ for test: dmabuf_sync_file
results: parsing output: 35/ for test: kms_pm_dc
results: parsing output: 36/ for test: gem_render_copy_redux
results: parsing output: 37/ for test: kms_cursor_crc
results: parsing output: 38/ for test: kms_psr2_sf
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_mmap_wc
results: parsing output: 41/ for test: gem_softpin
results: parsing output: 42/ for test: kms_content_protection
results: parsing output: 43/ for test: gem_ctx_shared
results: parsing output: 44/ for test: gem_softpin
results: parsing output: 45/ for test: kms_plane_alpha_blend
results: parsing output: 46/ for test: kms_busy
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: kms_plane_multiple
results: parsing output: 49/ for test: kms_chamelium_frames
results: parsing output: 50/ for test: i915_suspend
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_chamelium_hpd
results: parsing output: 53/ for test: kms_psr
results: parsing output: 54/ for test: kms_psr2_sf
results: parsing output: 55/ for test: api_intel_bb
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: gem_exec_schedule
results: parsing output: 58/ for test: gem_exec_schedule
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_cursor_crc
results: parsing output: 61/ for test: gem_shrink
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: kms_dsc
results: parsing output: 64/ for test: kms_cursor_legacy
results: parsing output: 65/ for test: kms_vblank
results: parsing output: 66/ for test: kms_lease
results: parsing output: 67/ for test: kms_addfb_basic
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_exec_params
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_rmfb
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: i915_pm_rpm
results: parsing output: 76/ for test: kms_flip_scaled_crc
results: parsing output: 77/ for test: gem_unfence_active_buffers
results: parsing output: 78/ for test: gem_exec_suspend
results: parsing output: 79/ for test: gem_exec_whisper
results: parsing output: 80/ for test: gem_exec_params
results: parsing output: 81/ for test: kms_flip_scaled_crc
results: parsing output: 82/ for test: gem_fenced_exec_thrash
results: parsing output: 83/ for test: gem_exec_fence
results: parsing output: 84/ for test: i915_query
results: parsing output: 85/ for test: syncobj_eventfd
results: parsing output: 86/ for test: kms_psr2_sf
results: parsing output: 87/ for test: kms_flip
results: parsing output: 88/ for test: gem_create
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_mmap_gtt
results: parsing output: 92/ for test: gem_mmap_gtt
results: parsing output: 93/ for test: kms_color_pipeline
results: parsing output: 94/ for test: kms_prime
results: parsing output: 95/ for test: gem_exec_reloc
results: parsing output: 96/ for test: gem_exec_balancer
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: kms_flip
results: parsing output: 99/ for test: kms_ccs
results: parsing output: 100/ for test: gem_ctx_param
results: parsing output: 101/ for test: kms_properties
results: parsing output: 102/ for test: gem_pxp
results: parsing output: 103/ for test: prime_self_import
results: parsing output: 104/ for test: kms_plane_scaling
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: gen9_exec_parse
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_exec_params
results: parsing output: 111/ for test: gem_vm_create
results: parsing output: 112/ for test: kms_addfb_basic
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_cursor_legacy
results: parsing output: 115/ for test: prime_vgem
results: parsing output: 116/ for test: fbdev
results: parsing output: 117/ for test: kms_cursor_legacy
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: prime_mmap_kms
results: parsing output: 121/ for test: gem_exec_fence
results: parsing output: 122/ for test: prime_busy
results: parsing output: 123/ for test: kms_cursor_legacy
results: parsing output: 124/ for test: syncobj_timeline
results: parsing output: 125/ for test: gem_mmap_wc
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: kms_tv_load_detect
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: syncobj_wait
results: parsing output: 130/ for test: sw_sync
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_psr
Done.