[57.912007] Initializing watchdogs
[57.912205]   /dev/watchdog0
[57.927492] [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.931955] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.934190] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.937285] [001/133] (960s left) gem_exec_gttfill (engines)
[58.018523] Starting subtest: engines
[58.020929] Starting dynamic subtest: rcs0
[81.400205] Dynamic subtest rcs0: SUCCESS (23.380s)
[81.409392] Starting dynamic subtest: bcs0
[104.684154] Dynamic subtest bcs0: SUCCESS (23.283s)
[104.692527] Starting dynamic subtest: vcs0
[127.943570] Dynamic subtest vcs0: SUCCESS (23.259s)
[127.951414] Starting dynamic subtest: vcs1
[151.245266] Dynamic subtest vcs1: SUCCESS (23.300s)
[151.255792] Starting dynamic subtest: vecs0
[174.545639] Dynamic subtest vecs0: SUCCESS (23.297s)
[174.554253] Starting dynamic subtest: ccs0
[197.836409] Dynamic subtest ccs0: SUCCESS (23.289s)
[197.838906] Subtest engines: SUCCESS (139.814s)
[198.034300] [002/133] (820s left) perf (gen12-unprivileged-single-ctx-counters)
[198.208339] Starting subtest: gen12-unprivileged-single-ctx-counters
[198.210715] Starting dynamic subtest: rcs0
[199.424341] Dynamic subtest rcs0: SUCCESS (1.218s)
[199.426238] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (1.218s)
[199.468346] [003/133] (819s left) kms_joiner (basic-ultra-joiner)
[199.593390] Starting subtest: basic-ultra-joiner
[199.596771] Subtest basic-ultra-joiner: SKIP (0.000s)
[199.659585] [004/133] (818s left) prime_mmap (test_aperture_limit)
[199.716034] Starting subtest: test_aperture_limit
[199.718063] Starting dynamic subtest: test_aperture_limit-smem
[199.744316] Dynamic subtest test_aperture_limit-smem: SKIP (0.027s)
[199.748115] Subtest test_aperture_limit: SKIP (0.028s)
[199.826881] [005/133] (818s left) kms_plane (plane-position-hole)
[199.919131] Starting subtest: plane-position-hole
[200.490132] Starting dynamic subtest: pipe-A-plane-1
[201.778531] Dynamic subtest pipe-A-plane-1: SUCCESS (1.287s)
[201.788476] Starting dynamic subtest: pipe-A-plane-2
[203.091527] Dynamic subtest pipe-A-plane-2: SUCCESS (1.312s)
[203.103192] Starting dynamic subtest: pipe-A-plane-3
[204.315495] Dynamic subtest pipe-A-plane-3: SUCCESS (1.224s)
[204.325083] Starting dynamic subtest: pipe-A-plane-4
[205.575551] Dynamic subtest pipe-A-plane-4: SUCCESS (1.260s)
[205.584588] Starting dynamic subtest: pipe-A-plane-5
[205.607192] Dynamic subtest pipe-A-plane-5: SUCCESS (0.030s)
[206.822470] Starting dynamic subtest: pipe-B-plane-1
[208.159102] Dynamic subtest pipe-B-plane-1: SUCCESS (1.344s)
[208.168701] Starting dynamic subtest: pipe-B-plane-2
[209.461854] Dynamic subtest pipe-B-plane-2: SUCCESS (1.303s)
[209.470734] Starting dynamic subtest: pipe-B-plane-3
[210.782931] Dynamic subtest pipe-B-plane-3: SUCCESS (1.320s)
[210.792724] Starting dynamic subtest: pipe-B-plane-4
[212.011182] Dynamic subtest pipe-B-plane-4: SUCCESS (1.228s)
[212.020526] Starting dynamic subtest: pipe-B-plane-5
[212.037743] Dynamic subtest pipe-B-plane-5: SUCCESS (0.026s)
[212.040091] Subtest plane-position-hole: SUCCESS (12.118s)
[212.818063] [006/133] (805s left) kms_async_flips (alternate-sync-async-flip-atomic)
[212.913682] Starting subtest: alternate-sync-async-flip-atomic
[213.288762] Starting dynamic subtest: pipe-A-eDP-1
[216.091920] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.805s)
[216.476126] Starting dynamic subtest: pipe-B-eDP-1
[219.224059] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.756s)
[219.605908] Starting dynamic subtest: pipe-C-eDP-1
[222.346981] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.749s)
[222.710052] Starting dynamic subtest: pipe-D-eDP-1
[225.479491] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.776s)
[225.481483] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.569s)
[226.645302] [007/133] (792s left) kms_cursor_crc (cursor-random-64x21)
[226.838637] Starting subtest: cursor-random-64x21
[226.891151] Subtest cursor-random-64x21: SKIP (0.048s)
[227.143407] [008/133] (791s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[227.193065] Starting subtest: basic-batch-kernel-default-cmd
[227.197428] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[227.375860] [009/133] (791s left) gem_userptr_blits (map-fixed-invalidate)
[227.440819] Starting subtest: map-fixed-invalidate
[227.445256] Subtest map-fixed-invalidate: SKIP (0.000s)
[227.555244] [010/133] (791s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[227.598894] Starting subtest: multi-wait-for-submit-submitted-signaled
[227.601309] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[227.711493] [011/133] (791s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[227.816859] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[228.629701] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.815s)
[228.793975] [012/133] (790s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[228.919430] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[260.285924] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.365s)
[261.093238] [013/133] (757s left) kms_psr (psr2-basic)
[261.185852] Starting subtest: psr2-basic
[261.188148] Starting dynamic subtest: eDP-1
[262.842584] Dynamic subtest eDP-1: SUCCESS (1.657s)
[262.844884] Subtest psr2-basic: SUCCESS (1.658s)
[263.651098] [014/133] (755s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[263.755844] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[263.759738] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[263.863968] [015/133] (755s left) kms_big_fb (linear-16bpp-rotate-180)
[263.956463] Starting subtest: linear-16bpp-rotate-180
[265.357868] Subtest linear-16bpp-rotate-180: SUCCESS (1.400s)
[265.487879] [016/133] (753s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[265.574017] Starting subtest: bad-pixel-format-y-tiled-ccs
[265.575863] Starting dynamic subtest: pipe-A-eDP-1
[265.594402] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[265.602427] Starting dynamic subtest: pipe-B-eDP-1
[265.620118] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[265.627560] Starting dynamic subtest: pipe-C-eDP-1
[265.645119] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[265.653785] Starting dynamic subtest: pipe-D-eDP-1
[265.671594] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[265.674998] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.004s)
[267.807865] [017/133] (751s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[267.887483] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[267.891808] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s)
[267.960385] [018/133] (751s left) i915_drm_fdinfo (most-busy-idle-check-all)
[268.007220] Starting subtest: most-busy-idle-check-all
[268.009491] Starting dynamic subtest: rcs0
[268.014134] Dynamic subtest rcs0: SKIP (0.004s)
[268.022420] Starting dynamic subtest: bcs0
[268.026614] Dynamic subtest bcs0: SKIP (0.000s)
[268.034595] Starting dynamic subtest: vcs0
[268.038820] Dynamic subtest vcs0: SKIP (0.000s)
[268.047076] Starting dynamic subtest: vcs1
[268.051492] Dynamic subtest vcs1: SKIP (0.000s)
[268.059398] Starting dynamic subtest: vecs0
[268.063646] Dynamic subtest vecs0: SKIP (0.000s)
[268.074357] Starting dynamic subtest: ccs0
[268.078901] Dynamic subtest ccs0: SKIP (0.000s)
[268.083215] Subtest most-busy-idle-check-all: SKIP (0.008s)
[268.118902] [019/133] (751s left) perf_pmu (rc6-suspend)
[268.168696] Starting subtest: rc6-suspend
[291.068178] Subtest rc6-suspend: SUCCESS (7.655s)
[292.114485] [020/133] (727s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[292.226781] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[292.231076] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[292.319772] [021/133] (726s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[292.429122] Starting subtest: fbc-psr2-sprite-plane-onoff
[292.431438] Starting dynamic subtest: eDP-1
[292.435502] Dynamic subtest eDP-1: SKIP (0.000s)
[292.439650] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[292.505512] [022/133] (726s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[292.625080] Starting subtest: 4-tiled-16bpp-rotate-0
[293.893905] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.266s)
[294.026973] [023/133] (725s left) gem_workarounds (reset-fd)
[294.096757] Starting subtest: reset-fd
[294.279659] Subtest reset-fd: SUCCESS (0.183s)
[294.395027] [024/133] (724s left) kms_fence_pin_leak
[294.556095] [025/133] (724s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[294.608619] Starting subtest: y-tiled-to-vebox-y-tiled
[294.613038] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[294.796215] [026/133] (724s left) kms_cdclk (mode-transition)
[294.894927] Starting subtest: mode-transition
[294.897391] Starting dynamic subtest: pipe-A-eDP-1
[295.183034] Dynamic subtest pipe-A-eDP-1: SKIP (0.286s)
[295.193204] Starting dynamic subtest: pipe-B-eDP-1
[295.197917] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[295.207153] Starting dynamic subtest: pipe-C-eDP-1
[295.211937] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[295.221369] Starting dynamic subtest: pipe-D-eDP-1
[295.226208] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[295.231187] Subtest mode-transition: SKIP (0.293s)
[295.987898] [027/133] (723s left) gem_exec_params (dr4-dirt)
[296.058359] Starting subtest: DR4-dirt
[296.061197] Subtest DR4-dirt: SUCCESS (0.000s)
[296.167909] [028/133] (723s left) syncobj_wait (multi-wait-all-submitted)
[296.216523] Starting subtest: multi-wait-all-submitted
[296.322074] Subtest multi-wait-all-submitted: SUCCESS (0.106s)
[296.410070] [029/133] (723s left) gem_exec_store (basic)
[296.473168] Starting subtest: basic
[296.577145] Subtest basic: SUCCESS (0.107s)
[296.774510] [030/133] (722s left) gem_ctx_persistence (saturated-hostile)
[296.837135] Starting subtest: saturated-hostile
[296.839998] Starting dynamic subtest: rcs0
[297.670737] Dynamic subtest rcs0: SUCCESS (0.833s)
[297.683598] Starting dynamic subtest: bcs0
[298.461625] Dynamic subtest bcs0: SUCCESS (0.788s)
[298.474220] Starting dynamic subtest: vcs0
[299.265113] Dynamic subtest vcs0: SUCCESS (0.800s)
[299.276728] Starting dynamic subtest: vcs1
[300.060794] Dynamic subtest vcs1: SUCCESS (0.794s)
[300.071928] Starting dynamic subtest: vecs0
[300.862013] Dynamic subtest vecs0: SUCCESS (0.799s)
[300.874210] Starting dynamic subtest: ccs0
[301.694790] Dynamic subtest ccs0: SUCCESS (0.830s)
[301.697781] Subtest saturated-hostile: SUCCESS (4.857s)
[301.789540] [031/133] (717s left) kms_psr (psr-cursor-plane-onoff)
[301.886290] Starting subtest: psr-cursor-plane-onoff
[301.889110] Starting dynamic subtest: eDP-1
[303.575671] Dynamic subtest eDP-1: SUCCESS (1.689s)
[303.578617] Subtest psr-cursor-plane-onoff: SUCCESS (1.690s)
[304.435801] [032/133] (715s left) i915_hangman (detector)
[304.502225] Starting subtest: detector
[304.504606] Starting dynamic subtest: rcs0
[316.093203] Dynamic subtest rcs0: SUCCESS (11.586s)
[316.110107] Starting dynamic subtest: bcs0
[328.124687] Dynamic subtest bcs0: SUCCESS (12.028s)
[328.138211] Starting dynamic subtest: vcs0
[340.092620] Dynamic subtest vcs0: SUCCESS (11.964s)
[340.106364] Starting dynamic subtest: vcs1
[352.059364] Dynamic subtest vcs1: SUCCESS (11.963s)
[352.071867] Starting dynamic subtest: vecs0
[362.044567] Dynamic subtest vecs0: SUCCESS (9.981s)
[362.057367] Starting dynamic subtest: ccs0
[373.117665] Dynamic subtest ccs0: SUCCESS (11.070s)
[373.120300] Subtest detector: SUCCESS (68.608s)
[373.205706] [033/133] (646s left) kms_force_connector_basic (force-connector-state)
[373.293603] Starting subtest: force-connector-state
[373.907380] Subtest force-connector-state: SUCCESS (0.616s)
[374.883449] [034/133] (644s left) kms_universal_plane (universal-plane-sanity)
[374.970118] Starting subtest: universal-plane-sanity
[374.972354] Starting dynamic subtest: pipe-A-eDP-1
[375.570368] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.601s)
[375.581943] Starting dynamic subtest: pipe-B-eDP-1
[376.763360] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.191s)
[376.774886] Starting dynamic subtest: pipe-C-eDP-1
[377.954316] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.187s)
[377.966932] Starting dynamic subtest: pipe-D-eDP-1
[379.136034] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.180s)
[379.138714] Subtest universal-plane-sanity: SUCCESS (4.165s)
[379.971827] [035/133] (639s left) dmabuf_sync_file (import-multiple-read-write)
[380.085204] Starting subtest: import-multiple-read-write
[380.088130] Subtest import-multiple-read-write: SUCCESS (0.003s)
[380.138139] [FACT dmabuf_sync_file (import-multiple-read-write)] new: kernel.kmod_is_loaded.vgem: true
[380.142945] [036/133] (639s left) kms_pm_dc (dc5-dpms-negative)
[381.241100] Starting subtest: dc5-dpms-negative
[381.246280] Subtest dc5-dpms-negative: SKIP (0.000s)
[381.330123] [037/133] (638s left) gem_render_copy_redux (flink)
[381.388129] Starting subtest: flink
[382.244469] Subtest flink: SUCCESS (0.856s)
[382.372111] [038/133] (637s left) kms_cursor_crc (cursor-onscreen-64x64)
[382.560962] Starting subtest: cursor-onscreen-64x64
[382.563096] Starting dynamic subtest: pipe-A-eDP-1
[384.716357] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.153s)
[384.745356] Starting dynamic subtest: pipe-D-eDP-1
[387.550353] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.810s)
[387.552953] Subtest cursor-onscreen-64x64: SUCCESS (4.989s)
[388.375987] [039/133] (631s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[388.484386] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[388.489594] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[388.556874] [040/133] (631s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[388.662201] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[397.371117] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.713s)
[397.509447] [041/133] (622s left) gem_mmap_wc (bad-offset)
[397.564598] Subtest bad-offset: SKIP (0.000s)
[397.642834] [042/133] (622s left) gem_softpin (evict-single-offset)
[397.706000] Starting subtest: evict-single-offset
[421.151401] Subtest evict-single-offset: SUCCESS (23.442s)
[421.240027] [043/133] (598s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[421.458323] Starting subtest: dp-mst-type-1-suspend-resume
[421.463971] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[421.573545] [044/133] (598s left) gem_ctx_shared (q-out-order)
[421.633056] Starting subtest: Q-out-order
[421.635647] Starting dynamic subtest: rcs0
[421.752136] Dynamic subtest rcs0: SUCCESS (0.117s)
[421.771891] Starting dynamic subtest: vcs0
[421.846246] Dynamic subtest vcs0: SUCCESS (0.094s)
[421.863929] Starting dynamic subtest: vcs1
[421.932762] Dynamic subtest vcs1: SUCCESS (0.085s)
[421.950987] Starting dynamic subtest: vecs0
[422.009985] Dynamic subtest vecs0: SUCCESS (0.077s)
[422.028849] Starting dynamic subtest: ccs0
[422.111257] Dynamic subtest ccs0: SUCCESS (0.100s)
[422.114280] Subtest Q-out-order: SUCCESS (0.478s)
[423.228051] [045/133] (597s left) gem_softpin (softpin)
[423.297870] Starting subtest: softpin
[455.595397] Subtest softpin: SUCCESS (32.291s)
[455.733289] [046/133] (564s left) kms_plane_alpha_blend (coverage-7efc)
[455.851155] Starting subtest: coverage-7efc
[456.154256] Starting dynamic subtest: pipe-A-eDP-1
[456.767141] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.611s)
[456.799605] Starting dynamic subtest: pipe-D-eDP-1
[458.082846] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.294s)
[458.085399] Subtest coverage-7efc: SUCCESS (2.233s)
[458.960784] [047/133] (561s left) kms_busy (extended-pageflip-hang-oldfb)
[459.057119] Starting subtest: extended-pageflip-hang-oldfb
[459.059871] Starting dynamic subtest: pipe-A
[459.484367] Dynamic subtest pipe-A: SUCCESS (0.428s)
[459.504955] Starting dynamic subtest: pipe-D
[460.637062] Dynamic subtest pipe-D: SUCCESS (1.150s)
[460.639471] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.583s)
[461.478654] [048/133] (558s left) kms_big_fb (y-tiled-addfb)
[461.573214] Starting subtest: y-tiled-addfb
[461.577957] Subtest y-tiled-addfb: SKIP (0.000s)
[461.661510] [049/133] (558s left) kms_plane_multiple (tiling-none)
[461.750367] Starting subtest: tiling-none
[461.753213] Starting dynamic subtest: pipe-A-eDP-1
[465.609873] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.858s)
[465.625972] Starting dynamic subtest: pipe-B-eDP-1
[470.192126] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.580s)
[470.203072] Starting dynamic subtest: pipe-C-eDP-1
[474.794952] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.600s)
[474.805599] Starting dynamic subtest: pipe-D-eDP-1
[479.381003] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.587s)
[479.383838] Subtest tiling-none: SUCCESS (17.631s)
[480.262905] [050/133] (540s left) kms_chamelium_frames (dp-crc-fast)
[480.654249] Subtest dp-crc-fast: SKIP (0.000s)
[481.441083] [051/133] (539s left) i915_suspend (fence-restore-tiled2untiled)
[481.489248] Starting subtest: fence-restore-tiled2untiled
[481.495226] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[481.599952] [052/133] (538s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[481.696865] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[488.211018] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.520s)
[488.331566] [053/133] (532s left) kms_chamelium_hpd (hdmi-hpd-fast)
[488.721782] Subtest hdmi-hpd-fast: SKIP (0.000s)
[489.539698] [054/133] (531s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[489.628793] Starting subtest: fbc-psr2-primary-mmap-cpu
[489.631004] Starting dynamic subtest: eDP-1
[489.636074] Dynamic subtest eDP-1: SKIP (0.000s)
[489.640919] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[489.693085] [055/133] (531s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[489.800067] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[489.802499] Starting dynamic subtest: pipe-A-eDP-1
[506.292659] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.497s)
[506.307981] Starting dynamic subtest: pipe-B-eDP-1
[523.516920] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.220s)
[523.519162] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.720s)
[524.352902] [056/133] (496s left) api_intel_bb (object-reloc-keep-cache)
[524.412210] Starting subtest: object-reloc-keep-cache
[524.417703] Subtest object-reloc-keep-cache: SKIP (0.003s)
[524.521800] [057/133] (496s left) kms_flip (absolute-wf_vblank)
[524.606944] Starting subtest: absolute-wf_vblank
[524.609179] Starting dynamic subtest: A-eDP1
[533.389762] Dynamic subtest A-eDP1: SUCCESS (8.783s)
[533.405240] Starting dynamic subtest: B-eDP1
[542.095176] Dynamic subtest B-eDP1: SUCCESS (8.702s)
[542.108211] Starting dynamic subtest: C-eDP1
[550.771870] Dynamic subtest C-eDP1: SUCCESS (8.674s)
[550.787164] Starting dynamic subtest: D-eDP1
[559.475150] Dynamic subtest D-eDP1: SUCCESS (8.699s)
[559.481909] Subtest absolute-wf_vblank: SUCCESS (34.875s)
[560.655891] [058/133] (460s left) gem_exec_schedule (preempt-other-chain)
[560.741742] Starting subtest: preempt-other-chain
[560.744249] Starting dynamic subtest: rcs0
[560.826748] Dynamic subtest rcs0: SUCCESS (0.095s)
[560.838059] Starting dynamic subtest: bcs0
[560.920911] Dynamic subtest bcs0: SUCCESS (0.094s)
[560.933781] Starting dynamic subtest: vcs0
[561.005555] Dynamic subtest vcs0: SUCCESS (0.081s)
[561.016166] Starting dynamic subtest: vcs1
[561.138464] Dynamic subtest vcs1: SUCCESS (0.130s)
[561.153380] Starting dynamic subtest: vecs0
[561.224029] Dynamic subtest vecs0: SUCCESS (0.086s)
[561.237192] Starting dynamic subtest: ccs0
[561.307372] Dynamic subtest ccs0: SUCCESS (0.082s)
[561.310296] Subtest preempt-other-chain: SUCCESS (0.576s)
[562.231877] [059/133] (458s left) gem_exec_schedule (u-fairslice)
[562.301141] Starting subtest: u-fairslice
[562.303965] Starting dynamic subtest: rcs0
[564.314786] Dynamic subtest rcs0: SUCCESS (2.023s)
[564.327199] Starting dynamic subtest: bcs0
[566.342244] Dynamic subtest bcs0: SUCCESS (2.026s)
[566.354375] Starting dynamic subtest: vcs0
[568.367287] Dynamic subtest vcs0: SUCCESS (2.023s)
[568.378342] Starting dynamic subtest: vcs1
[570.388337] Dynamic subtest vcs1: SUCCESS (2.020s)
[570.400150] Starting dynamic subtest: vecs0
[572.407358] Dynamic subtest vecs0: SUCCESS (2.019s)
[572.420131] Starting dynamic subtest: ccs0
[574.435476] Dynamic subtest ccs0: SUCCESS (2.028s)
[574.438287] Subtest u-fairslice: SUCCESS (12.145s)
[574.752168] [060/133] (446s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[574.855718] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[574.861037] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[574.961293] [061/133] (446s left) kms_cursor_crc (cursor-sliding-256x85)
[575.229107] Starting subtest: cursor-sliding-256x85
[575.275003] Subtest cursor-sliding-256x85: SKIP (0.040s)
[575.437407] [062/133] (445s left) gem_shrink (reclaim)
[575.497503] Starting subtest: reclaim
[577.886991] Subtest reclaim: SUCCESS (2.390s)
[578.059027] [063/133] (443s left) syncobj_timeline (wait-for-submit-complex)
[578.116391] Starting subtest: wait-for-submit-complex
[578.177123] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[578.275369] [064/133] (442s left) kms_dsc (dsc-with-formats)
[578.372205] Starting subtest: dsc-with-formats
[578.419534] Subtest dsc-with-formats: SKIP (0.001s)
[578.464229] [065/133] (442s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[578.586755] Starting subtest: flip-vs-cursor-atomic
[585.748163] Subtest flip-vs-cursor-atomic: SUCCESS (7.160s)
[586.544338] [066/133] (434s left) kms_vblank (query-forked-busy)
[586.644264] Starting subtest: query-forked-busy
[586.646757] Starting dynamic subtest: pipe-A-eDP-1
[588.518187] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.875s)
[588.534818] Starting dynamic subtest: pipe-D-eDP-1
[591.072228] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.553s)
[591.075250] Subtest query-forked-busy: SUCCESS (4.431s)
[591.957742] [067/133] (429s left) kms_lease (lease-unleased-connector)
[592.054793] Starting subtest: lease-unleased-connector
[592.057175] Starting dynamic subtest: pipe-A-eDP-1
[592.059689] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[592.070023] Starting dynamic subtest: pipe-B-eDP-1
[592.072283] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s)
[592.082922] Starting dynamic subtest: pipe-C-eDP-1
[592.085237] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s)
[592.094538] Starting dynamic subtest: pipe-D-eDP-1
[592.096611] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.006s)
[592.098563] Subtest lease-unleased-connector: SUCCESS (0.029s)
[592.181929] [068/133] (429s left) kms_addfb_basic (bad-pitch-63)
[592.242719] Starting subtest: bad-pitch-63
[592.245342] Subtest bad-pitch-63: SUCCESS (0.000s)
[592.378159] [069/133] (428s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[592.479177] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[592.484080] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[592.573227] [070/133] (428s left) gem_exec_params (dr1-dirt)
[592.631657] Starting subtest: DR1-dirt
[592.634147] Subtest DR1-dirt: SUCCESS (0.000s)
[592.726775] [071/133] (428s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[592.826991] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[592.831968] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[592.919904] [072/133] (428s left) kms_rmfb (rmfb-ioctl)
[593.017152] Starting subtest: rmfb-ioctl
[593.019284] Starting dynamic subtest: pipe-A-eDP-1
[593.121091] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[593.136454] Starting dynamic subtest: pipe-B-eDP-1
[594.272651] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.148s)
[594.285122] Starting dynamic subtest: pipe-C-eDP-1
[595.466240] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.192s)
[595.478346] Starting dynamic subtest: pipe-D-eDP-1
[596.667691] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.200s)
[596.670545] Subtest rmfb-ioctl: SUCCESS (3.653s)
[597.856228] [073/133] (423s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[597.953660] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[604.623951] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.673s)
[604.747547] [074/133] (416s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[604.840624] Starting subtest: fbc-rgb565-draw-blt
[608.948020] Subtest fbc-rgb565-draw-blt: SUCCESS (4.112s)
[610.167087] [075/133] (411s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[610.259640] Starting subtest: crc-primary-basic-yf-tiled-ccs
[610.262345] Starting dynamic subtest: pipe-A-eDP-1
[610.292105] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[610.313251] Starting dynamic subtest: pipe-B-eDP-1
[610.342084] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[610.364239] Starting dynamic subtest: pipe-C-eDP-1
[610.394129] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[610.414926] Starting dynamic subtest: pipe-D-eDP-1
[610.442929] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[610.448102] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.006s)
[612.542737] [076/133] (409s left) i915_pm_rpm (sysfs-read)
[614.387145] Starting subtest: sysfs-read
[615.543163] Subtest sysfs-read: SUCCESS (1.155s)
[615.926215] [077/133] (405s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[616.018600] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[616.021226] Starting dynamic subtest: pipe-A-default-mode
[618.736203] Dynamic subtest pipe-A-default-mode: SUCCESS (2.717s)
[618.739225] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.719s)
[619.548436] [078/133] (402s left) gem_unfence_active_buffers
[619.712234] [079/133] (402s left) gem_exec_suspend (basic)
[619.776365] Starting subtest: basic
[619.778968] Starting dynamic subtest: smem
[621.150541] Dynamic subtest smem: SUCCESS (1.372s)
[621.153638] Subtest basic: SUCCESS (1.375s)
[621.339103] [080/133] (400s left) gem_exec_whisper (basic-sync)
[621.409955] Starting subtest: basic-sync
[633.699349] Subtest basic-sync: SUCCESS (12.285s)
[633.888304] [081/133] (387s left) gem_exec_params (invalid-bsd-ring)
[633.964343] Starting subtest: invalid-bsd-ring
[633.967292] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[634.078040] [082/133] (387s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[634.176367] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[634.181893] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[634.250051] [083/133] (387s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[634.319623] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[634.396097] [084/133] (387s left) gem_exec_fence (syncobj-signal)
[634.851956] Starting subtest: syncobj-signal
[634.858397] Subtest syncobj-signal: SUCCESS (0.006s)
[636.217096] [085/133] (385s left) i915_query (query-topology-coherent-slice-mask)
[636.288027] Starting subtest: query-topology-coherent-slice-mask
[636.293273] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[636.397500] [086/133] (385s left) syncobj_eventfd (invalid-illegal-handle)
[636.455276] Starting subtest: invalid-illegal-handle
[636.457871] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[636.537957] [087/133] (385s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[636.640926] Starting subtest: psr2-cursor-plane-update-sf
[636.643525] Starting dynamic subtest: pipe-A-eDP-1
[637.213354] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.574s)
[637.225693] Starting dynamic subtest: pipe-B-eDP-1
[638.520471] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.306s)
[638.523180] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.883s)
[639.350144] [088/133] (382s left) kms_flip (flip-vs-expired-vblank)
[639.446929] Starting subtest: flip-vs-expired-vblank
[639.449118] Starting dynamic subtest: A-eDP1
[648.123381] Dynamic subtest A-eDP1: SUCCESS (8.675s)
[648.136854] Starting dynamic subtest: B-eDP1
[656.817183] Dynamic subtest B-eDP1: SUCCESS (8.691s)
[656.828744] Starting dynamic subtest: C-eDP1
[665.510290] Dynamic subtest C-eDP1: SUCCESS (8.692s)
[665.525839] Starting dynamic subtest: D-eDP1
[674.205895] Dynamic subtest D-eDP1: SUCCESS (8.693s)
[674.211941] Subtest flip-vs-expired-vblank: SUCCESS (34.762s)
[675.369407] [089/133] (346s left) gem_create (create-massive)
[675.434042] Starting subtest: create-massive
[675.436407] Subtest create-massive: SUCCESS (0.000s)
[675.621924] [090/133] (346s left) kms_flip (flip-vs-wf_vblank-interruptible)
[675.720283] Starting subtest: flip-vs-wf_vblank-interruptible
[675.723240] Starting dynamic subtest: A-eDP1
[677.665189] Dynamic subtest A-eDP1: SUCCESS (1.945s)
[677.677681] Starting dynamic subtest: B-eDP1
[679.560768] Dynamic subtest B-eDP1: SUCCESS (1.892s)
[679.572094] Starting dynamic subtest: C-eDP1
[681.450238] Dynamic subtest C-eDP1: SUCCESS (1.887s)
[681.461389] Starting dynamic subtest: D-eDP1
[683.344208] Dynamic subtest D-eDP1: SUCCESS (1.892s)
[683.349663] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.629s)
[684.542518] [091/133] (337s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[684.645199] Starting subtest: psr-rgb101010-draw-mmap-cpu
[691.593116] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (6.952s)
[691.699748] [092/133] (330s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[691.763398] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[691.822702] [093/133] (330s left) gem_mmap_gtt (isolation)
[691.875187] Subtest isolation: SKIP (0.000s)
[691.971883] [094/133] (330s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[692.071630] Starting subtest: plane-lut1d-post-ctm3x4
[692.218124] Starting dynamic subtest: pipe-A-plane-0
[692.589982] Dynamic subtest pipe-A-plane-0: FAIL (0.195s)
[692.599890] Starting dynamic subtest: pipe-A-plane-1
[692.812032] Dynamic subtest pipe-A-plane-1: FAIL (0.167s)
[692.825158] Starting dynamic subtest: pipe-A-plane-2
[693.069905] Dynamic subtest pipe-A-plane-2: FAIL (0.177s)
[693.943105] Starting dynamic subtest: pipe-B-plane-0
[694.429353] Dynamic subtest pipe-B-plane-0: FAIL (0.181s)
[694.442343] Starting dynamic subtest: pipe-B-plane-1
[694.803910] Dynamic subtest pipe-B-plane-1: FAIL (0.159s)
[694.814347] Starting dynamic subtest: pipe-B-plane-2
[695.149205] Dynamic subtest pipe-B-plane-2: FAIL (0.708s)
[696.233125] Starting dynamic subtest: pipe-C-plane-0
[696.833381] Dynamic subtest pipe-C-plane-0: FAIL (0.162s)
[696.843757] Starting dynamic subtest: pipe-C-plane-1
[697.249885] Dynamic subtest pipe-C-plane-1: FAIL (0.697s)
[697.260918] Starting dynamic subtest: pipe-C-plane-2
[697.689052] Dynamic subtest pipe-C-plane-2: FAIL (0.169s)
[698.421363] Starting dynamic subtest: pipe-D-plane-0
[699.096594] Dynamic subtest pipe-D-plane-0: FAIL (0.151s)
[699.107649] Starting dynamic subtest: pipe-D-plane-1
[699.592535] Dynamic subtest pipe-D-plane-1: FAIL (0.686s)
[699.601898] Starting dynamic subtest: pipe-D-plane-2
[700.085095] Dynamic subtest pipe-D-plane-2: FAIL (0.554s)
[700.098045] Subtest plane-lut1d-post-ctm3x4: FAIL (8.028s)
[700.943076] [095/133] (321s left) kms_prime (d3hot)
[701.030262] Subtest D3hot: SKIP (0.000s)
[701.136216] [096/133] (321s left) gem_exec_reloc (basic-wc-gtt)
[701.190963] Subtest basic-wc-gtt: SKIP (0.000s)
[701.261996] [097/133] (321s left) gem_exec_balancer (parallel)
[701.530033] Starting subtest: parallel
[702.493635] Subtest parallel: SUCCESS (0.964s)
[703.176630] [098/133] (319s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[703.270629] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[703.274969] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[704.352927] [099/133] (318s left) kms_flip (plain-flip-interruptible)
[704.457599] Starting subtest: plain-flip-interruptible
[704.460018] Starting dynamic subtest: A-eDP1
[706.120897] Dynamic subtest A-eDP1: SUCCESS (1.665s)
[706.131589] Starting dynamic subtest: B-eDP1
[707.813392] Dynamic subtest B-eDP1: SUCCESS (1.691s)
[707.824321] Starting dynamic subtest: C-eDP1
[709.404172] Dynamic subtest C-eDP1: SUCCESS (1.589s)
[709.415384] Starting dynamic subtest: D-eDP1
[711.022831] Dynamic subtest D-eDP1: SUCCESS (1.617s)
[711.029288] Subtest plain-flip-interruptible: SUCCESS (6.574s)
[712.239826] [100/133] (310s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[712.335968] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[712.338212] Starting dynamic subtest: pipe-A-eDP-1
[712.363040] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[712.373914] Starting dynamic subtest: pipe-B-eDP-1
[712.399241] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[712.409087] Starting dynamic subtest: pipe-C-eDP-1
[712.434827] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[712.445251] Starting dynamic subtest: pipe-D-eDP-1
[712.471788] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[712.476383] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.005s)
[714.544898] [101/133] (308s left) gem_ctx_param (vm)
[714.599897] Starting subtest: vm
[714.659956] Subtest vm: SUCCESS (0.060s)
[714.774764] [102/133] (308s left) kms_properties (plane-properties-legacy)
[714.864942] Starting subtest: plane-properties-legacy
[714.867373] Starting dynamic subtest: pipe-A-eDP-1
[715.417191] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.551s)
[715.428585] Starting dynamic subtest: pipe-B-eDP-1
[716.685218] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.268s)
[716.696093] Starting dynamic subtest: pipe-C-eDP-1
[717.977847] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.292s)
[717.988712] Starting dynamic subtest: pipe-D-eDP-1
[719.278981] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.299s)
[719.281616] Subtest plane-properties-legacy: SUCCESS (4.415s)
[720.148537] [103/133] (302s left) gem_pxp (reject-modify-context-protection-off-3)
[720.277726] Starting subtest: reject-modify-context-protection-off-3
[720.280517] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[720.397813] [104/133] (302s left) prime_self_import (basic-with_one_bo_two_files)
[720.441282] Starting subtest: basic-with_one_bo_two_files
[720.454791] Subtest basic-with_one_bo_two_files: SUCCESS (0.015s)
[720.556106] [105/133] (302s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[720.646257] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[720.648648] Starting dynamic subtest: pipe-A
[720.720965] Dynamic subtest pipe-A: SUCCESS (0.076s)
[720.731217] Starting dynamic subtest: pipe-B
[721.829678] Dynamic subtest pipe-B: SUCCESS (1.108s)
[721.840341] Starting dynamic subtest: pipe-C
[722.914128] Dynamic subtest pipe-C: SUCCESS (1.084s)
[722.924236] Starting dynamic subtest: pipe-D
[724.017002] Dynamic subtest pipe-D: SUCCESS (1.102s)
[724.019586] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.373s)
[725.188009] [106/133] (297s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[725.292081] Starting subtest: 4-tiled-16bpp-rotate-90
[725.313070] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.020s)
[725.442918] [107/133] (297s left) gen9_exec_parse (batch-invalid-length)
[725.501972] Subtest batch-invalid-length: SKIP (0.000s)
[725.577027] [108/133] (297s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[725.621794] Starting subtest: invalid-signal-one-illegal-handle
[725.624669] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[725.710031] [109/133] (297s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[725.798151] Starting subtest: x-tiled-64bpp-rotate-180
[727.510918] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.712s)
[727.682959] [110/133] (295s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[727.790043] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[727.794626] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[727.899108] [111/133] (295s left) gem_exec_params (invalid-ring2)
[727.953075] Starting subtest: invalid-ring2
[727.955359] Subtest invalid-ring2: SUCCESS (0.000s)
[728.056834] [112/133] (295s left) gem_vm_create (invalid-create)
[728.111848] Starting subtest: invalid-create
[728.116617] Subtest invalid-create: SUCCESS (0.002s)
[728.216647] [113/133] (295s left) kms_addfb_basic (bad-pitch-128)
[728.269938] Starting subtest: bad-pitch-128
[728.271865] Subtest bad-pitch-128: SUCCESS (0.000s)
[728.400741] [114/133] (295s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[728.462969] Starting subtest: single-wait-all-for-submit-available-submitted
[728.465372] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[728.570584] [115/133] (294s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[728.680040] Starting subtest: cursorB-vs-flipA-toggle
[728.684827] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[728.826761] [116/133] (294s left) prime_vgem (fence-write-hang)
[728.920122] Subtest fence-write-hang: SKIP (0.000s)
[729.016213] [117/133] (294s left) fbdev (eof)
[729.066044] Starting subtest: eof
[729.068533] Subtest eof: SUCCESS (0.000s)
[729.137511] [118/133] (294s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[729.259800] Starting subtest: 2x-flip-vs-cursor-atomic
[729.263839] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[729.407743] [119/133] (294s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[729.506273] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[729.511099] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[729.600431] [120/133] (294s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[729.706370] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[736.559643] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.854s)
[736.749914] [121/133] (287s left) prime_mmap_kms (buffer-sharing)
[736.852085] Starting subtest: buffer-sharing
[737.290490] Subtest buffer-sharing: SUCCESS (0.441s)
[738.140336] [122/133] (285s left) gem_exec_fence (basic-await)
[738.314563] Starting subtest: basic-await
[738.317187] Starting dynamic subtest: rcs0
[738.395806] Dynamic subtest rcs0: SUCCESS (0.080s)
[738.409262] Starting dynamic subtest: bcs0
[738.472298] Dynamic subtest bcs0: SUCCESS (0.075s)
[738.485385] Starting dynamic subtest: vcs0
[738.549860] Dynamic subtest vcs0: SUCCESS (0.075s)
[738.562385] Starting dynamic subtest: vcs1
[738.625210] Dynamic subtest vcs1: SUCCESS (0.074s)
[738.638144] Starting dynamic subtest: vecs0
[738.699369] Dynamic subtest vecs0: SUCCESS (0.073s)
[738.712025] Starting dynamic subtest: ccs0
[738.772198] Dynamic subtest ccs0: SUCCESS (0.072s)
[738.775048] Subtest basic-await: SUCCESS (0.459s)
[740.219584] [123/133] (283s left) prime_busy (before-wait)
[740.270876] Starting subtest: before-wait
[740.277196] Starting dynamic subtest: rcs0
[740.308675] Dynamic subtest rcs0: SUCCESS (0.034s)
[740.320888] Starting dynamic subtest: bcs0
[740.349810] Dynamic subtest bcs0: SUCCESS (0.041s)
[740.361020] Starting dynamic subtest: vcs0
[740.392555] Dynamic subtest vcs0: SUCCESS (0.042s)
[740.404242] Starting dynamic subtest: vcs1
[740.435007] Dynamic subtest vcs1: SUCCESS (0.042s)
[740.446498] Starting dynamic subtest: vecs0
[740.478159] Dynamic subtest vecs0: SUCCESS (0.042s)
[740.489363] Starting dynamic subtest: ccs0
[740.519683] Dynamic subtest ccs0: SUCCESS (0.041s)
[740.627805] Subtest before-wait: SUCCESS (0.355s)
[740.707277] [124/133] (283s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[740.827548] Starting subtest: short-busy-flip-before-cursor-toggle
[740.832519] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[740.987701] [125/133] (282s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[741.049202] Starting subtest: invalid-multi-wait-unsubmitted
[741.052137] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[741.149439] [126/133] (282s left) gem_mmap_wc (invalid-flags)
[741.197047] Subtest invalid-flags: SKIP (0.000s)
[741.262478] [127/133] (282s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[741.360987] Starting subtest: yf-tiled-64bpp-rotate-270
[741.365073] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[741.493814] [128/133] (282s left) kms_tv_load_detect (load-detect)
[741.574883] Subtest load-detect: SKIP (0.000s)
[741.633728] [129/133] (282s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[741.727598] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[741.731880] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[741.812499] [130/133] (282s left) syncobj_wait (wait-any-complex)
[741.867912] Starting subtest: wait-any-complex
[741.929620] Subtest wait-any-complex: SUCCESS (0.063s)
[742.010742] [131/133] (282s left) sw_sync (sync_expired_merge)
[742.059076] Starting subtest: sync_expired_merge
[743.133748] Subtest sync_expired_merge: SUCCESS (1.074s)
[743.207451] [132/133] (281s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[743.305208] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[743.309955] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[743.387216] [133/133] (280s left) kms_psr (psr-suspend)
[743.492204] Starting subtest: psr-suspend
[743.494875] Starting dynamic subtest: eDP-1
[761.305884] Dynamic subtest eDP-1: SUCCESS (2.966s)
[761.308122] Subtest psr-suspend: SUCCESS (2.967s)
[762.142944] 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.