[55.774324] Initializing watchdogs
[55.774375]   /dev/watchdog0
[55.789453] [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]
[55.794128] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.796950] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.800405] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[55.928265] Starting subtest: fbcpsr-slowdraw
[81.184742] Subtest fbcpsr-slowdraw: SUCCESS (25.256s)
[81.328316] [002/133] (935s left) prime_mmap (test_aperture_limit)
[81.386542] Starting subtest: test_aperture_limit
[81.388640] Starting dynamic subtest: test_aperture_limit-smem
[81.401201] Dynamic subtest test_aperture_limit-smem: SKIP (0.013s)
[81.405147] Subtest test_aperture_limit: SKIP (0.014s)
[81.496283] [003/133] (934s left) gem_eio (in-flight-10ms)
[81.663568] Starting subtest: in-flight-10ms
[89.178046] Subtest in-flight-10ms: SUCCESS (7.515s)
[89.351873] [FACT gem_eio (in-flight-10ms)] new: kernel.kmod_is_loaded.vgem: true
[89.354944] [004/133] (927s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[89.469254] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[89.471580] Starting dynamic subtest: pipe-A-eDP-1
[96.110513] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.646s)
[96.120450] Starting dynamic subtest: pipe-B-eDP-1
[103.077485] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.966s)
[103.079818] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.614s)
[103.947116] [005/133] (912s left) gem_exec_fence (syncobj-invalid-flags)
[104.371215] Starting subtest: syncobj-invalid-flags
[104.373663] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[105.352457] [006/133] (911s left) gem_softpin (allocator-evict)
[105.413871] Starting subtest: allocator-evict
[105.416384] Starting dynamic subtest: rcs0
[130.114088] Dynamic subtest rcs0: SUCCESS (24.698s)
[130.125505] Starting dynamic subtest: bcs0
[154.045443] Dynamic subtest bcs0: SUCCESS (23.930s)
[154.056610] Starting dynamic subtest: vcs0
[177.635327] Dynamic subtest vcs0: SUCCESS (23.587s)
[177.646841] Starting dynamic subtest: vcs1
[201.479432] Dynamic subtest vcs1: SUCCESS (23.843s)
[201.489976] Starting dynamic subtest: vecs0
[225.449828] Dynamic subtest vecs0: SUCCESS (23.970s)
[225.461786] Starting dynamic subtest: ccs0
[249.155125] Dynamic subtest ccs0: SUCCESS (23.704s)
[249.157572] Subtest allocator-evict: SUCCESS (143.736s)
[249.236891] [007/133] (767s left) gem_exec_params (dr4-dirt)
[249.348352] Starting subtest: DR4-dirt
[249.350683] Subtest DR4-dirt: SUCCESS (0.000s)
[249.476598] [008/133] (767s left) kms_prop_blob (basic)
[249.531821] Starting subtest: basic
[249.534059] Subtest basic: SUCCESS (0.000s)
[249.613537] [009/133] (767s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[249.738588] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[249.784666] [010/133] (766s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[249.853445] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[249.855886] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[249.939901] [011/133] (766s left) perf_pmu (busy-idle-no-semaphores)
[249.984630] Starting subtest: busy-idle-no-semaphores
[249.987041] Starting dynamic subtest: rcs0
[250.625501] Dynamic subtest rcs0: SUCCESS (0.641s)
[250.637758] Starting dynamic subtest: bcs0
[251.275483] Dynamic subtest bcs0: SUCCESS (0.649s)
[251.288398] Starting dynamic subtest: vcs0
[251.926050] Dynamic subtest vcs0: SUCCESS (0.649s)
[251.938049] Starting dynamic subtest: vcs1
[253.924930] Dynamic subtest vcs1: SUCCESS (1.998s)
[253.936710] Starting dynamic subtest: vecs0
[255.910777] Dynamic subtest vecs0: SUCCESS (1.985s)
[255.922063] Starting dynamic subtest: ccs0
[257.892726] Dynamic subtest ccs0: SUCCESS (1.980s)
[257.895152] Subtest busy-idle-no-semaphores: SUCCESS (7.908s)
[258.010234] [012/133] (758s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[258.111569] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[258.116322] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[258.185840] [013/133] (758s left) kms_chamelium_hpd (vga-hpd)
[258.565043] Subtest vga-hpd: SKIP (0.000s)
[259.336147] [014/133] (757s left) kms_fb_coherency (memset-crc)
[259.425745] Starting subtest: memset-crc
[259.428055] Starting dynamic subtest: mmap-offset-wc
[259.838899] Dynamic subtest mmap-offset-wc: SUCCESS (0.413s)
[260.139432] Starting dynamic subtest: mmap-offset-uc
[266.304526] Dynamic subtest mmap-offset-uc: SUCCESS (6.172s)
[266.595251] Subtest memset-crc: SUCCESS (7.170s)
[267.432720] [015/133] (749s left) sw_sync (sync_expired_merge)
[267.477408] Starting subtest: sync_expired_merge
[268.552062] Subtest sync_expired_merge: SUCCESS (1.074s)
[268.614334] [016/133] (748s left) gem_ccs (block-copy-uncompressed)
[268.675421] Starting subtest: block-copy-uncompressed
[268.677901] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[268.700071] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.024s)
[268.711593] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[268.719418] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.019s)
[268.728419] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[268.737193] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[268.746059] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[268.764744] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.027s)
[268.767148] Subtest block-copy-uncompressed: SUCCESS (0.089s)
[268.900873] [017/133] (748s left) gem_eio (wait-1us)
[269.126172] Starting subtest: wait-1us
[269.436756] Subtest wait-1us: SUCCESS (0.309s)
[269.587930] [018/133] (747s left) gem_exec_flush (basic-wb-ro-before-default)
[269.641689] Starting subtest: basic-wb-ro-before-default
[275.131095] Subtest basic-wb-ro-before-default: SUCCESS (5.460s)
[275.291545] [019/133] (741s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[275.406741] Starting subtest: multiplane-rotation-cropping-top
[292.954233] Subtest multiplane-rotation-cropping-top: SUCCESS (17.549s)
[293.076118] [020/133] (724s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[293.195146] Starting subtest: cursorA-vs-flipB-atomic-transitions
[293.198855] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[293.340057] [021/133] (723s left) i915_drm_fdinfo (memory-info-idle)
[293.381196] Starting subtest: memory-info-idle
[293.383494] Starting dynamic subtest: smem0
[293.437539] Dynamic subtest smem0: SUCCESS (0.057s)
[293.439694] Subtest memory-info-idle: SUCCESS (0.057s)
[293.514949] [022/133] (723s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[293.580075] Starting subtest: stress-mm-invalidate-close-overlap
[295.729596] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[295.866927] [023/133] (721s left) perf_pmu (busy-double-start)
[295.915512] Starting subtest: busy-double-start
[295.917631] Starting dynamic subtest: rcs0
[299.565290] Dynamic subtest rcs0: FAIL (3.595s)
[299.577763] Starting dynamic subtest: bcs0
[303.093618] Dynamic subtest bcs0: SUCCESS (3.584s)
[303.105422] Starting dynamic subtest: vcs0
[306.810697] Dynamic subtest vcs0: SUCCESS (3.715s)
[306.823077] Starting dynamic subtest: vcs1
[310.780856] Dynamic subtest vcs1: SUCCESS (3.968s)
[310.792735] Starting dynamic subtest: vecs0
[314.841746] Dynamic subtest vecs0: SUCCESS (4.059s)
[314.853693] Starting dynamic subtest: ccs0
[318.480564] Dynamic subtest ccs0: FAIL (3.567s)
[318.482928] Subtest busy-double-start: FAIL (22.496s)
[318.524518] [024/133] (698s left) syncobj_wait (multi-wait-signaled)
[318.588036] Starting subtest: multi-wait-signaled
[318.590350] Subtest multi-wait-signaled: SUCCESS (0.000s)
[318.694795] [025/133] (698s left) kms_flip (busy-flip)
[318.802849] Starting subtest: busy-flip
[318.805161] Starting dynamic subtest: A-eDP1
[320.546101] Dynamic subtest A-eDP1: SUCCESS (1.745s)
[320.558103] Starting dynamic subtest: B-eDP1
[322.182702] Dynamic subtest B-eDP1: SUCCESS (1.634s)
[322.196777] Starting dynamic subtest: C-eDP1
[323.899580] Dynamic subtest C-eDP1: SUCCESS (1.715s)
[323.910779] Starting dynamic subtest: D-eDP1
[325.520699] Dynamic subtest D-eDP1: SUCCESS (1.620s)
[325.525917] Subtest busy-flip: SUCCESS (6.725s)
[326.681268] [026/133] (690s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[326.782088] Starting subtest: addfb25-y-tiled-small-legacy
[326.786441] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[326.884089] [027/133] (690s left) sw_sync (alloc_fence_invalid_timeline)
[326.928970] Starting subtest: alloc_fence_invalid_timeline
[326.930831] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[326.978850] [028/133] (690s left) gem_exec_whisper (basic-queues-all)
[327.042624] Starting subtest: basic-queues-all
[337.935103] Subtest basic-queues-all: SUCCESS (10.890s)
[338.119358] [029/133] (679s left) kms_cursor_crc (cursor-sliding-128x42)
[338.359576] Starting subtest: cursor-sliding-128x42
[338.408891] Subtest cursor-sliding-128x42: SKIP (0.044s)
[338.615090] [030/133] (678s left) sysfs_heartbeat_interval (mixed)
[338.672618] Starting subtest: mixed
[338.674950] Starting dynamic subtest: vecs0
[343.917646] Dynamic subtest vecs0: SUCCESS (5.244s)
[343.928852] Starting dynamic subtest: ccs0
[349.115610] Dynamic subtest ccs0: SUCCESS (5.196s)
[349.126095] Starting dynamic subtest: vcs0
[354.333384] Dynamic subtest vcs0: SUCCESS (5.215s)
[354.345848] Starting dynamic subtest: bcs0
[359.558741] Dynamic subtest bcs0: SUCCESS (5.224s)
[359.571042] Starting dynamic subtest: rcs0
[364.737497] Dynamic subtest rcs0: SUCCESS (5.177s)
[364.749727] Starting dynamic subtest: vcs1
[369.942197] Dynamic subtest vcs1: SUCCESS (5.203s)
[369.944669] Subtest mixed: SUCCESS (31.270s)
[370.021430] [031/133] (647s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[370.161805] Starting subtest: cursor-vs-flip-atomic-transitions
[400.445090] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.285s)
[401.314847] [032/133] (616s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[401.412791] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[401.417212] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[401.508858] [033/133] (616s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[401.602108] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[401.606591] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[401.675771] [034/133] (616s left) gem_exec_reloc (basic-range-active)
[401.733354] Subtest basic-range-active: SKIP (0.000s)
[401.823117] [035/133] (615s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[401.927922] Starting subtest: yf-tiled-8bpp-rotate-90
[401.932423] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[402.019524] [036/133] (615s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[402.112997] Starting subtest: psr-rgb565-draw-mmap-gtt
[402.117225] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[402.209818] [037/133] (615s left) kms_chamelium_frames (hdmi-aspect-ratio)
[402.599976] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[403.404405] [038/133] (614s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[403.465618] Starting subtest: etime-single-wait-for-submit-unsubmitted
[403.568151] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[403.649466] [039/133] (614s left) kms_cursor_crc (cursor-onscreen-256x85)
[403.911735] Starting subtest: cursor-onscreen-256x85
[403.956916] Subtest cursor-onscreen-256x85: SKIP (0.042s)
[404.148064] [040/133] (613s left) i915_module_load (reload)
[404.185628] Starting subtest: reload
[407.400940] Subtest reload: SUCCESS (3.221s)
[407.439684] [041/133] (610s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[409.253058] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[409.255367] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[409.368792] [042/133] (608s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[409.476475] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[409.478671] Starting dynamic subtest: pipe-A-eDP-1
[409.500187] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[409.509672] Starting dynamic subtest: pipe-B-eDP-1
[409.530493] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[409.538572] Starting dynamic subtest: pipe-C-eDP-1
[409.559072] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[409.569192] Starting dynamic subtest: pipe-D-eDP-1
[409.591205] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[409.595586] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[411.733781] [043/133] (606s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[411.828245] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[412.946543] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.118s)
[413.084886] [044/133] (605s left) kms_flip (2x-flip-vs-suspend)
[413.173591] Starting subtest: 2x-flip-vs-suspend
[413.177240] Subtest 2x-flip-vs-suspend: SKIP (0.002s)
[413.270809] [045/133] (604s left) gen9_exec_parse (cmd-crossing-page)
[413.345625] Subtest cmd-crossing-page: SKIP (0.000s)
[413.412113] [046/133] (604s left) kms_pm_rpm (fences)
[415.436780] Starting subtest: fences
[415.441938] Subtest fences: SKIP (0.000s)
[415.814754] [047/133] (602s left) kms_async_flips (test-cursor-atomic)
[415.907320] Starting subtest: test-cursor-atomic
[416.294982] Starting dynamic subtest: pipe-A-eDP-1
[417.092566] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.798s)
[417.463550] Starting dynamic subtest: pipe-B-eDP-1
[418.227855] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.773s)
[418.617529] Starting dynamic subtest: pipe-C-eDP-1
[419.369656] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.760s)
[419.739809] Starting dynamic subtest: pipe-D-eDP-1
[420.497368] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.771s)
[420.499711] Subtest test-cursor-atomic: SUCCESS (4.593s)
[421.674152] [048/133] (596s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[421.771882] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[429.131352] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.362s)
[429.244513] [049/133] (589s left) kms_psr (pr-cursor-plane-move)
[429.348654] Starting subtest: pr-cursor-plane-move
[429.352950] Subtest pr-cursor-plane-move: SKIP (0.000s)
[429.425200] [050/133] (588s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[429.525924] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[429.528197] Starting dynamic subtest: A-eDP1
[438.449159] Dynamic subtest A-eDP1: SUCCESS (8.922s)
[438.460630] Starting dynamic subtest: B-eDP1
[447.385314] Dynamic subtest B-eDP1: SUCCESS (8.933s)
[447.395563] Starting dynamic subtest: C-eDP1
[456.352502] Dynamic subtest C-eDP1: SUCCESS (8.919s)
[456.364026] Starting dynamic subtest: D-eDP1
[465.244364] Dynamic subtest D-eDP1: SUCCESS (8.935s)
[465.249714] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.721s)
[466.472581] [051/133] (551s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[466.566320] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[466.570751] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[466.669445] [052/133] (551s left) gem_mmap_gtt (medium-copy-odd)
[466.733310] Subtest medium-copy-odd: SKIP (0.000s)
[466.792857] [053/133] (551s left) dmabuf_sync_file (import-multiple-read-only)
[466.844853] Starting subtest: import-multiple-read-only
[466.847087] Subtest import-multiple-read-only: SUCCESS (0.003s)
[466.913648] [054/133] (551s left) gem_wait (await)
[466.969503] Starting subtest: await
[466.971717] Starting dynamic subtest: all-engines
[468.093843] Dynamic subtest all-engines: SUCCESS (1.124s)
[468.109584] Starting dynamic subtest: rcs0
[469.154904] Dynamic subtest rcs0: SUCCESS (1.059s)
[469.171952] Starting dynamic subtest: bcs0
[470.212935] Dynamic subtest bcs0: SUCCESS (1.055s)
[470.228201] Starting dynamic subtest: vcs0
[471.265810] Dynamic subtest vcs0: SUCCESS (1.051s)
[471.282298] Starting dynamic subtest: vcs1
[472.321092] Dynamic subtest vcs1: SUCCESS (1.052s)
[472.336694] Starting dynamic subtest: vecs0
[473.372647] Dynamic subtest vecs0: SUCCESS (1.050s)
[473.390517] Starting dynamic subtest: ccs0
[474.429230] Dynamic subtest ccs0: SUCCESS (1.055s)
[474.431682] Subtest await: SUCCESS (7.461s)
[474.629565] [055/133] (543s left) kms_invalid_mode (overflow-vrefresh)
[474.729460] Starting subtest: overflow-vrefresh
[474.731767] Starting dynamic subtest: pipe-A-eDP-1
[475.016157] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[475.025646] Starting dynamic subtest: pipe-B-eDP-1
[475.027878] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[475.038407] Starting dynamic subtest: pipe-C-eDP-1
[475.040347] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[475.049259] Starting dynamic subtest: pipe-D-eDP-1
[475.051442] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[475.053715] Subtest overflow-vrefresh: SUCCESS (0.292s)
[475.810241] [056/133] (542s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[475.907026] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[475.911533] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[476.007707] [057/133] (542s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[476.097973] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[476.102473] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[477.237606] [058/133] (541s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[477.342968] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[477.345250] Starting dynamic subtest: pipe-A-eDP-1
[477.420484] Dynamic subtest pipe-A-eDP-1: SKIP (0.081s)
[477.430488] Starting dynamic subtest: pipe-B-eDP-1
[478.508616] Dynamic subtest pipe-B-eDP-1: SKIP (1.085s)
[478.512823] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.169s)
[479.695684] [059/133] (539s left) kms_cursor_edge_walk (64x64-left-edge)
[479.800182] Starting subtest: 64x64-left-edge
[479.802525] Starting dynamic subtest: pipe-A-eDP-1
[483.272691] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.472s)
[483.282134] Starting dynamic subtest: pipe-D-eDP-1
[486.403996] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.129s)
[486.406363] Subtest 64x64-left-edge: SUCCESS (6.605s)
[487.209822] [060/133] (531s left) gem_lmem_swapping (parallel-random-verify-ccs)
[487.260749] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[487.309602] [061/133] (531s left) syncobj_timeline (32bits-limit)
[487.368081] Starting subtest: 32bits-limit
[487.370374] Subtest 32bits-limit: SUCCESS (0.001s)
[487.488360] [062/133] (531s left) gem_exec_params (secure-non-root)
[487.542455] Starting subtest: secure-non-root
[487.547077] Subtest secure-non-root: SKIP (0.000s)
[487.666920] [063/133] (531s left) gem_exec_parallel (engines)
[487.737038] Starting subtest: engines
[487.739288] Starting dynamic subtest: basic
[489.220929] Dynamic subtest basic: SUCCESS (1.482s)
[489.231252] Starting dynamic subtest: contexts
[493.612467] Dynamic subtest contexts: SUCCESS (4.390s)
[493.622757] Starting dynamic subtest: fds
[497.424919] Dynamic subtest fds: SUCCESS (3.810s)
[497.434541] Starting dynamic subtest: userptr
[499.260082] Dynamic subtest userptr: SUCCESS (1.833s)
[499.263074] Subtest engines: SUCCESS (11.523s)
[499.459353] [064/133] (519s left) kms_addfb_basic (too-wide)
[499.553832] Starting subtest: too-wide
[499.556096] Subtest too-wide: SUCCESS (0.000s)
[499.674097] [065/133] (519s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[499.772699] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[506.926134] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.158s)
[507.073329] [066/133] (511s left) kms_addfb_basic (unused-modifier)
[507.118367] Starting subtest: unused-modifier
[507.120218] Subtest unused-modifier: SUCCESS (0.000s)
[507.279530] [067/133] (511s left) kms_getfb (getfb2-accept-nv12)
[507.363503] Starting subtest: getfb2-accept-nv12
[507.365660] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[507.460012] [068/133] (511s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[507.551170] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[507.553057] Starting dynamic subtest: pipe-A-eDP-1
[507.694802] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.135s)
[507.707176] Starting dynamic subtest: pipe-B-eDP-1
[507.725755] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[507.735089] Starting dynamic subtest: pipe-C-eDP-1
[507.753140] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[507.761713] Starting dynamic subtest: pipe-D-eDP-1
[507.780193] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[507.782060] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.145s)
[509.976096] [069/133] (509s left) kms_plane_alpha_blend (alpha-transparent-fb)
[510.063201] Starting subtest: alpha-transparent-fb
[510.344768] Starting dynamic subtest: pipe-A-eDP-1
[510.977303] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.632s)
[510.987824] Starting dynamic subtest: pipe-D-eDP-1
[512.357901] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.376s)
[512.360075] Subtest alpha-transparent-fb: SUCCESS (2.294s)
[513.150525] [070/133] (506s left) gem_exec_schedule (preempt-queue-chain)
[513.228856] Subtest preempt-queue-chain: SKIP (0.000s)
[513.521042] [071/133] (505s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[513.612680] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[513.617087] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[513.715237] [072/133] (505s left) gem_flink_basic (bad-open)
[513.785466] Starting subtest: bad-open
[513.787815] Subtest bad-open: SUCCESS (0.000s)
[513.874324] [073/133] (505s left) gem_tiled_pread_pwrite
[513.996015] [074/133] (505s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[514.094980] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[520.765228] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.671s)
[520.879834] [075/133] (498s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[520.974422] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[525.236083] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.265s)
[526.385236] [076/133] (493s left) kms_vblank (wait-idle-hang)
[526.475152] Starting subtest: wait-idle-hang
[526.477083] Starting dynamic subtest: pipe-A-eDP-1
[554.054922] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.577s)
[554.069780] Starting dynamic subtest: pipe-D-eDP-1
[569.090734] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.034s)
[569.093458] Subtest wait-idle-hang: SUCCESS (42.616s)
[569.949794] [077/133] (449s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[570.052034] Starting subtest: y-tiled-16bpp-rotate-180
[570.056420] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[570.150317] [078/133] (449s left) api_intel_bb (object-reloc-keep-cache)
[570.217597] Starting subtest: object-reloc-keep-cache
[570.221929] Subtest object-reloc-keep-cache: SKIP (0.003s)
[570.341533] [079/133] (449s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[570.427440] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[577.154145] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.730s)
[577.278256] [080/133] (442s left) gem_exec_store (pages)
[577.341587] Starting subtest: pages
[577.343938] Starting dynamic subtest: rcs0
[577.424686] Dynamic subtest rcs0: SUCCESS (0.083s)
[577.436394] Starting dynamic subtest: bcs0
[577.496750] Dynamic subtest bcs0: SUCCESS (0.070s)
[577.507711] Starting dynamic subtest: vcs0
[577.561444] Dynamic subtest vcs0: SUCCESS (0.064s)
[577.571199] Starting dynamic subtest: vcs1
[577.628883] Dynamic subtest vcs1: SUCCESS (0.067s)
[577.640087] Starting dynamic subtest: vecs0
[577.693868] Dynamic subtest vecs0: SUCCESS (0.064s)
[577.704570] Starting dynamic subtest: ccs0
[577.761046] Dynamic subtest ccs0: SUCCESS (0.066s)
[577.763306] Subtest pages: SUCCESS (0.421s)
[577.961222] [081/133] (441s left) syncobj_timeline (signal-array)
[578.018740] Starting subtest: signal-array
[578.020921] Subtest signal-array: SUCCESS (0.000s)
[578.110475] [082/133] (441s left) kms_big_fb (linear-8bpp-rotate-90)
[578.202818] Starting subtest: linear-8bpp-rotate-90
[578.224060] Subtest linear-8bpp-rotate-90: SKIP (0.021s)
[578.354829] [083/133] (441s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[578.460132] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[579.587186] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.127s)
[579.708627] [084/133] (440s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[579.803416] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[579.806924] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[579.885236] [085/133] (439s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[579.984215] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[579.986070] Starting dynamic subtest: pipe-A
[580.225048] Dynamic subtest pipe-A: SUCCESS (0.241s)
[580.234959] Starting dynamic subtest: pipe-B
[581.562521] Dynamic subtest pipe-B: SUCCESS (1.336s)
[581.573364] Starting dynamic subtest: pipe-C
[582.906314] Dynamic subtest pipe-C: SUCCESS (1.343s)
[582.916623] Starting dynamic subtest: pipe-D
[584.226931] Dynamic subtest pipe-D: SUCCESS (1.320s)
[584.229304] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.244s)
[585.411467] [086/133] (434s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[585.476417] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[585.481146] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[585.674511] [087/133] (434s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[585.766194] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[585.768151] Starting dynamic subtest: pipe-A-eDP-1
[586.623979] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.852s)
[586.638931] Starting dynamic subtest: pipe-B-eDP-1
[588.139481] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.513s)
[588.149867] Starting dynamic subtest: pipe-C-eDP-1
[589.658884] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.517s)
[589.668952] Starting dynamic subtest: pipe-D-eDP-1
[591.153112] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.495s)
[591.155143] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.382s)
[592.321854] [088/133] (427s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[592.430642] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[592.434841] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[592.549242] [089/133] (427s left) prime_busy (before)
[592.608073] Starting subtest: before
[592.612857] Starting dynamic subtest: rcs0
[592.643491] Dynamic subtest rcs0: SUCCESS (0.031s)
[592.659157] Starting dynamic subtest: bcs0
[592.684996] Dynamic subtest bcs0: SUCCESS (0.040s)
[592.695456] Starting dynamic subtest: vcs0
[592.725211] Dynamic subtest vcs0: SUCCESS (0.039s)
[592.736688] Starting dynamic subtest: vcs1
[592.765267] Dynamic subtest vcs1: SUCCESS (0.040s)
[592.775019] Starting dynamic subtest: vecs0
[592.806962] Dynamic subtest vecs0: SUCCESS (0.041s)
[592.816413] Starting dynamic subtest: ccs0
[592.846315] Dynamic subtest ccs0: SUCCESS (0.039s)
[592.954776] Subtest before: SUCCESS (0.345s)
[593.032428] [090/133] (427s left) prime_self_import (reimport-vs-gem_close-race)
[593.071307] Starting subtest: reimport-vs-gem_close-race
[598.171690] Subtest reimport-vs-gem_close-race: SUCCESS (5.064s)
[598.230694] [091/133] (421s left) kms_busy (extended-modeset-hang-oldfb)
[598.326481] Starting subtest: extended-modeset-hang-oldfb
[598.328763] Starting dynamic subtest: pipe-A
[610.099399] Dynamic subtest pipe-A: SUCCESS (11.769s)
[610.109917] Starting dynamic subtest: pipe-D
[622.377105] Dynamic subtest pipe-D: SUCCESS (12.276s)
[622.379491] Subtest extended-modeset-hang-oldfb: SUCCESS (24.051s)
[623.270688] [092/133] (396s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[623.363820] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[623.368104] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[623.457414] [093/133] (396s left) kms_content_protection (legacy-hdcp14)
[623.597977] Starting subtest: legacy-hdcp14
[623.602558] Subtest legacy-hdcp14: SKIP (0.000s)
[623.745140] [094/133] (396s left) kms_color_pipeline (plane-lut1d-lut1d)
[623.853543] Starting subtest: plane-lut1d-lut1d
[623.977214] Starting dynamic subtest: pipe-A-plane-0
[624.177165] Dynamic subtest pipe-A-plane-0: SUCCESS (0.200s)
[624.187762] Starting dynamic subtest: pipe-A-plane-1
[624.365653] Dynamic subtest pipe-A-plane-1: SUCCESS (0.188s)
[624.375336] Starting dynamic subtest: pipe-A-plane-2
[624.532517] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[625.743883] Starting dynamic subtest: pipe-B-plane-0
[625.891669] Dynamic subtest pipe-B-plane-0: SUCCESS (0.155s)
[625.901880] Starting dynamic subtest: pipe-B-plane-1
[626.058231] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[626.068146] Starting dynamic subtest: pipe-B-plane-2
[626.202406] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s)
[627.375078] Starting dynamic subtest: pipe-C-plane-0
[627.522517] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[627.532862] Starting dynamic subtest: pipe-C-plane-1
[627.666801] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[627.677041] Starting dynamic subtest: pipe-C-plane-2
[627.822178] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[629.009729] Starting dynamic subtest: pipe-D-plane-0
[629.145697] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[629.155327] Starting dynamic subtest: pipe-D-plane-1
[629.279058] Dynamic subtest pipe-D-plane-1: SUCCESS (0.132s)
[629.289087] Starting dynamic subtest: pipe-D-plane-2
[629.423745] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[629.714968] Subtest plane-lut1d-lut1d: SUCCESS (5.856s)
[630.588355] [095/133] (389s left) gem_exec_balancer (bonded-sync)
[630.652493] Starting subtest: bonded-sync
[630.657154] Subtest bonded-sync: SKIP (0.000s)
[630.979422] [096/133] (389s left) kms_dp_link_training (non-uhbr-mst)
[631.079401] Starting subtest: non-uhbr-mst
[631.088107] Subtest non-uhbr-mst: SKIP (0.000s)
[631.166261] [097/133] (389s left) gem_mmap_wc (invalid-flags)
[631.231932] Subtest invalid-flags: SKIP (0.000s)
[631.292034] [098/133] (389s left) kms_plane_cursor (viewport)
[631.388712] Starting subtest: viewport
[631.393204] Starting dynamic subtest: pipe-A-eDP-1-size-64
[633.875139] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.486s)
[633.936046] Starting dynamic subtest: pipe-A-eDP-1-size-128
[636.364578] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.438s)
[636.426898] Starting dynamic subtest: pipe-A-eDP-1-size-256
[638.888188] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.471s)
[639.236842] Starting dynamic subtest: pipe-B-eDP-1-size-64
[642.542054] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.316s)
[642.602664] Starting dynamic subtest: pipe-B-eDP-1-size-128
[645.144508] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.552s)
[645.203027] Starting dynamic subtest: pipe-B-eDP-1-size-256
[647.677564] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.483s)
[648.030050] Starting dynamic subtest: pipe-C-eDP-1-size-64
[650.932088] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.914s)
[650.971052] Starting dynamic subtest: pipe-C-eDP-1-size-128
[653.089500] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.125s)
[653.133212] Starting dynamic subtest: pipe-C-eDP-1-size-256
[655.277238] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.158s)
[655.604975] Starting dynamic subtest: pipe-D-eDP-1-size-64
[658.450676] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.857s)
[658.489767] Starting dynamic subtest: pipe-D-eDP-1-size-128
[660.617543] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.136s)
[660.656993] Starting dynamic subtest: pipe-D-eDP-1-size-256
[662.762028] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.114s)
[663.084230] Subtest viewport: SUCCESS (31.692s)
[663.884879] [099/133] (356s left) gem_exec_schedule (preempt-self)
[663.971336] Starting subtest: preempt-self
[663.973283] Starting dynamic subtest: rcs0
[664.013188] Dynamic subtest rcs0: SUCCESS (0.043s)
[664.025904] Starting dynamic subtest: bcs0
[664.043160] Dynamic subtest bcs0: SUCCESS (0.027s)
[664.054380] Starting dynamic subtest: vcs0
[664.060746] Dynamic subtest vcs0: SUCCESS (0.016s)
[664.070472] Starting dynamic subtest: vcs1
[664.084570] Dynamic subtest vcs1: SUCCESS (0.023s)
[664.099844] Starting dynamic subtest: vecs0
[664.104713] Dynamic subtest vecs0: SUCCESS (0.018s)
[664.114214] Starting dynamic subtest: ccs0
[664.122710] Dynamic subtest ccs0: SUCCESS (0.018s)
[664.124997] Subtest preempt-self: SUCCESS (0.154s)
[665.297306] [100/133] (355s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[665.402808] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[665.406987] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[665.505257] [101/133] (355s left) gem_pwrite (basic-exhaustion)
[665.568244] Subtest basic-exhaustion: SKIP (0.000s)
[665.633282] [102/133] (354s left) gem_ctx_engines (execute-oneforall)
[665.687698] Starting subtest: execute-oneforall
[666.274701] Subtest execute-oneforall: SUCCESS (0.585s)
[667.385344] [103/133] (353s left) gem_ctx_persistence (engines-cleanup)
[667.451373] Starting subtest: engines-cleanup
[667.453835] Starting dynamic subtest: rcs0
[667.536374] Dynamic subtest rcs0: SUCCESS (0.084s)
[667.549915] Starting dynamic subtest: bcs0
[667.564375] Dynamic subtest bcs0: SUCCESS (0.027s)
[667.574077] Starting dynamic subtest: vcs0
[667.604321] Dynamic subtest vcs0: SUCCESS (0.039s)
[667.613620] Starting dynamic subtest: vcs1
[667.680281] Dynamic subtest vcs1: SUCCESS (0.075s)
[667.692149] Starting dynamic subtest: vecs0
[667.739903] Dynamic subtest vecs0: SUCCESS (0.057s)
[667.751231] Starting dynamic subtest: ccs0
[667.775759] Dynamic subtest ccs0: SUCCESS (0.034s)
[667.778715] Subtest engines-cleanup: SUCCESS (0.325s)
[667.865484] [104/133] (352s left) i915_pm_rc6_residency (media-rc6-accuracy)
[667.930805] Starting subtest: media-rc6-accuracy
[667.935390] Subtest media-rc6-accuracy: SKIP (0.000s)
[668.077530] [105/133] (352s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[668.183363] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[669.196485] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.015s)
[669.321873] [106/133] (351s left) vgem_basic (dmabuf-fence)
[669.369809] Starting subtest: dmabuf-fence
[669.372153] Subtest dmabuf-fence: SUCCESS (0.001s)
[669.426971] [107/133] (351s left) gem_ctx_shared (q-out-order)
[669.494828] Starting subtest: Q-out-order
[669.496973] Starting dynamic subtest: rcs0
[669.614351] Dynamic subtest rcs0: SUCCESS (0.120s)
[669.626855] Starting dynamic subtest: vcs0
[669.716363] Dynamic subtest vcs0: SUCCESS (0.101s)
[669.729607] Starting dynamic subtest: vcs1
[669.805336] Dynamic subtest vcs1: SUCCESS (0.088s)
[669.822981] Starting dynamic subtest: vecs0
[669.905745] Dynamic subtest vecs0: SUCCESS (0.099s)
[669.923828] Starting dynamic subtest: ccs0
[669.998472] Dynamic subtest ccs0: SUCCESS (0.091s)
[670.000800] Subtest Q-out-order: SUCCESS (0.507s)
[671.376995] [108/133] (349s left) api_intel_allocator (reloc-allocator)
[671.429667] Starting subtest: reloc-allocator
[671.431787] Starting dynamic subtest: basic
[671.434295] Dynamic subtest basic: SUCCESS (0.004s)
[671.450518] Starting dynamic subtest: parallel-one
[671.452398] Dynamic subtest parallel-one: SUCCESS (0.009s)
[671.462342] Starting dynamic subtest: print
[671.464462] Dynamic subtest print: SUCCESS (0.000s)
[671.474053] Starting dynamic subtest: reuse
[671.476141] Dynamic subtest reuse: SUCCESS (0.000s)
[671.485569] Starting dynamic subtest: fork-reopen-allocator
[671.487659] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[671.489724] Subtest reloc-allocator: SUCCESS (0.028s)
[671.574870] [109/133] (349s left) kms_cdclk (mode-transition-all-outputs)
[671.662250] Starting subtest: mode-transition-all-outputs
[671.950061] Subtest mode-transition-all-outputs: SKIP (0.287s)
[672.830467] [110/133] (348s left) kms_lease (simple-lease)
[672.936774] Starting subtest: simple-lease
[672.939128] Starting dynamic subtest: pipe-A-eDP-1
[673.428205] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.490s)
[673.438468] Starting dynamic subtest: pipe-B-eDP-1
[674.846432] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.417s)
[674.858790] Starting dynamic subtest: pipe-C-eDP-1
[676.262220] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.411s)
[676.272083] Starting dynamic subtest: pipe-D-eDP-1
[677.665379] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.402s)
[677.667738] Subtest simple-lease: SUCCESS (4.728s)
[678.480350] [111/133] (342s left) gem_ctx_persistence (legacy-engines-mixed)
[678.539255] Starting subtest: legacy-engines-mixed
[678.541677] Starting dynamic subtest: render
[678.620080] Dynamic subtest render: SUCCESS (0.079s)
[678.631896] Starting dynamic subtest: bsd1
[678.663253] Dynamic subtest bsd1: SUCCESS (0.041s)
[678.675847] Starting dynamic subtest: bsd2
[678.687753] Dynamic subtest bsd2: SUCCESS (0.023s)
[678.699241] Starting dynamic subtest: blt
[678.737416] Dynamic subtest blt: SUCCESS (0.048s)
[678.747530] Starting dynamic subtest: vebox
[678.806471] Dynamic subtest vebox: SUCCESS (0.068s)
[678.808862] Subtest legacy-engines-mixed: SUCCESS (0.267s)
[678.885054] [112/133] (342s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[678.954201] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[679.019394] [113/133] (342s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[679.074663] Starting subtest: invalid-bsd2-flag-on-blt
[679.077067] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[679.179720] [114/133] (341s left) i915_query (hwconfig_table)
[679.229867] Starting subtest: hwconfig_table
[679.509598] Subtest hwconfig_table: SUCCESS (0.001s)
[679.548245] [115/133] (341s left) sw_sync (sync_busy_fork)
[679.586208] Starting subtest: sync_busy_fork
[680.599952] Subtest sync_busy_fork: SUCCESS (1.011s)
[680.664605] [116/133] (340s left) gem_mmap_wc (set-cache-level)
[680.724178] Subtest set-cache-level: SKIP (0.000s)
[680.793041] [117/133] (340s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[680.903200] Starting subtest: fbcpsr-tiling-linear
[687.456342] Subtest fbcpsr-tiling-linear: SUCCESS (6.556s)
[687.595877] [118/133] (333s left) kms_getfb (getfb-handle-closed)
[687.694535] Starting subtest: getfb-handle-closed
[687.696680] Subtest getfb-handle-closed: SUCCESS (0.000s)
[687.791962] [119/133] (333s left) gem_exec_balancer (parallel-contexts)
[688.050910] Starting subtest: parallel-contexts
[690.846506] Subtest parallel-contexts: SUCCESS (2.795s)
[691.484486] [120/133] (329s left) kms_psr (psr-cursor-mmap-cpu)
[691.590850] Starting subtest: psr-cursor-mmap-cpu
[691.593093] Starting dynamic subtest: eDP-1
[693.282596] Dynamic subtest eDP-1: SUCCESS (1.691s)
[693.284930] Subtest psr-cursor-mmap-cpu: SUCCESS (1.692s)
[694.155387] [121/133] (327s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[694.249368] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[694.253668] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[694.358535] [122/133] (327s left) prime_udl
[694.446273] [123/133] (327s left) gem_mmap_gtt (fault-concurrent-y)
[694.500551] Subtest fault-concurrent-Y: SKIP (0.000s)
[694.559516] [124/133] (327s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[694.643767] Starting subtest: fbc-psr2-sprite-plane-onoff
[694.646018] Starting dynamic subtest: eDP-1
[694.650595] Dynamic subtest eDP-1: SKIP (0.000s)
[694.654837] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[694.721630] [125/133] (326s left) kms_psr (fbc-pr-sprite-blt)
[694.883906] Starting subtest: fbc-pr-sprite-blt
[694.888338] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[694.957945] [126/133] (326s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[695.212753] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[695.222215] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[695.424593] [127/133] (326s left) gem_exec_flush (basic-uc-ro-default)
[695.587764] Starting subtest: basic-uc-ro-default
[701.121643] Subtest basic-uc-ro-default: SUCCESS (5.533s)
[701.308324] [128/133] (320s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[701.403901] Starting subtest: pr-cursor-plane-update-sf
[701.408373] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[701.512523] [129/133] (320s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[701.621824] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[705.851720] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.233s)
[707.032343] [130/133] (314s left) kms_draw_crc (fill-fb)
[707.121782] Starting subtest: fill-fb
[707.598894] Subtest fill-fb: SUCCESS (0.478s)
[707.693859] [131/133] (314s left) gem_pxp (verify-pxp-stale-buf-execution)
[707.824452] Starting subtest: verify-pxp-stale-buf-execution
[708.887321] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.064s)
[709.031141] [132/133] (312s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[709.092227] Subtest no-spare-fences-busy: SKIP (0.000s)
[709.159746] [133/133] (312s left) gem_exec_nop (basic-series)
[709.228171] Starting subtest: basic-series
[725.312065] Subtest basic-series: SUCCESS (16.090s)
[725.543174] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: prime_mmap
results: parsing output: 2/ for test: gem_eio
results: parsing output: 3/ for test: kms_psr2_sf
results: parsing output: 4/ for test: gem_exec_fence
results: parsing output: 5/ for test: gem_softpin
results: parsing output: 6/ for test: gem_exec_params
results: parsing output: 7/ for test: kms_prop_blob
results: parsing output: 8/ for test: kms_tiled_display
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: perf_pmu
results: parsing output: 11/ for test: kms_plane
results: parsing output: 12/ for test: kms_chamelium_hpd
results: parsing output: 13/ for test: kms_fb_coherency
results: parsing output: 14/ for test: sw_sync
results: parsing output: 15/ for test: gem_ccs
results: parsing output: 16/ for test: gem_eio
results: parsing output: 17/ for test: gem_exec_flush
results: parsing output: 18/ for test: kms_rotation_crc
results: parsing output: 19/ for test: kms_cursor_legacy
results: parsing output: 20/ for test: i915_drm_fdinfo
results: parsing output: 21/ for test: gem_userptr_blits
results: parsing output: 22/ for test: perf_pmu
results: parsing output: 23/ for test: syncobj_wait
results: parsing output: 24/ for test: kms_flip
results: parsing output: 25/ for test: kms_addfb_basic
results: parsing output: 26/ for test: sw_sync
results: parsing output: 27/ for test: gem_exec_whisper
results: parsing output: 28/ for test: kms_cursor_crc
results: parsing output: 29/ for test: sysfs_heartbeat_interval
results: parsing output: 30/ for test: kms_cursor_legacy
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_plane
results: parsing output: 33/ for test: gem_exec_reloc
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_chamelium_frames
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: kms_cursor_crc
results: parsing output: 39/ for test: i915_module_load
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: gen9_exec_parse
results: parsing output: 45/ for test: kms_pm_rpm
results: parsing output: 46/ for test: kms_async_flips
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_flip
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_mmap_gtt
results: parsing output: 52/ for test: dmabuf_sync_file
results: parsing output: 53/ for test: gem_wait
results: parsing output: 54/ for test: kms_invalid_mode
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_ccs
results: parsing output: 57/ for test: kms_psr2_sf
results: parsing output: 58/ for test: kms_cursor_edge_walk
results: parsing output: 59/ for test: gem_lmem_swapping
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: gem_exec_params
results: parsing output: 62/ for test: gem_exec_parallel
results: parsing output: 63/ for test: kms_addfb_basic
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_addfb_basic
results: parsing output: 66/ for test: kms_getfb
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: kms_plane_alpha_blend
results: parsing output: 69/ for test: gem_exec_schedule
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_flink_basic
results: parsing output: 72/ for test: gem_tiled_pread_pwrite
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_vblank
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: api_intel_bb
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_exec_store
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: kms_flip_scaled_crc
results: parsing output: 84/ for test: kms_plane_scaling
results: parsing output: 85/ for test: gem_render_copy
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: prime_busy
results: parsing output: 89/ for test: prime_self_import
results: parsing output: 90/ for test: kms_busy
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_content_protection
results: parsing output: 93/ for test: kms_color_pipeline
results: parsing output: 94/ for test: gem_exec_balancer
results: parsing output: 95/ for test: kms_dp_link_training
results: parsing output: 96/ for test: gem_mmap_wc
results: parsing output: 97/ for test: kms_plane_cursor
results: parsing output: 98/ for test: gem_exec_schedule
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_pwrite
results: parsing output: 101/ for test: gem_ctx_engines
results: parsing output: 102/ for test: gem_ctx_persistence
results: parsing output: 103/ for test: i915_pm_rc6_residency
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: vgem_basic
results: parsing output: 106/ for test: gem_ctx_shared
results: parsing output: 107/ for test: api_intel_allocator
results: parsing output: 108/ for test: kms_cdclk
results: parsing output: 109/ for test: kms_lease
results: parsing output: 110/ for test: gem_ctx_persistence
results: parsing output: 111/ for test: gem_exec_reloc
results: parsing output: 112/ for test: gem_exec_params
results: parsing output: 113/ for test: i915_query
results: parsing output: 114/ for test: sw_sync
results: parsing output: 115/ for test: gem_mmap_wc
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_getfb
results: parsing output: 118/ for test: gem_exec_balancer
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: prime_udl
results: parsing output: 122/ for test: gem_mmap_gtt
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: gem_exec_flush
results: parsing output: 127/ for test: kms_psr2_sf
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_draw_crc
results: parsing output: 130/ for test: gem_pxp
results: parsing output: 131/ for test: gem_fenced_exec_thrash
results: parsing output: 132/ for test: gem_exec_nop
Done.