[56.528441] Initializing watchdogs
[56.528492]   /dev/watchdog0
[56.543153] [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]
[56.547872] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.550097] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.553804] [001/133] (960s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[56.629080] Starting subtest: invalid-single-wait-all-unsubmitted
[56.631445] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[56.736431] [002/133] (960s left) kms_pm_lpsp (kms-lpsp)
[57.844100] Starting subtest: kms-lpsp
[57.846120] Starting dynamic subtest: pipe-A-eDP-1
[58.027167] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.189s)
[58.343989] Subtest kms-lpsp: SUCCESS (0.509s)
[59.135900] [003/133] (957s left) api_intel_bb (reset-flags)
[59.190776] Starting subtest: reset-flags
[59.195965] Subtest reset-flags: SUCCESS (0.007s)
[59.322410] [004/133] (957s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[59.418171] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[59.422532] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[59.519997] [005/133] (957s left) gem_exec_balancer (bonded-semaphore)
[59.587719] Starting subtest: bonded-semaphore
[59.592286] Subtest bonded-semaphore: SKIP (0.000s)
[59.882542] [006/133] (957s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[59.942816] Starting subtest: legacy-engines-hostile-preempt
[59.945194] Starting dynamic subtest: render
[60.017947] Dynamic subtest render: SUCCESS (0.075s)
[60.031257] Starting dynamic subtest: bsd1
[61.295958] Dynamic subtest bsd1: SUCCESS (1.285s)
[61.306038] Starting dynamic subtest: bsd2
[63.299228] Dynamic subtest bsd2: SUCCESS (2.013s)
[63.308778] Starting dynamic subtest: blt
[63.361819] Dynamic subtest blt: SUCCESS (0.064s)
[63.371206] Starting dynamic subtest: vebox
[65.262068] Dynamic subtest vebox: SUCCESS (1.904s)
[65.264806] Subtest legacy-engines-hostile-preempt: SUCCESS (5.349s)
[65.383651] [007/133] (951s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[65.491180] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[65.499930] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.011s)
[65.574364] [008/133] (951s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[65.664985] Starting subtest: x-tiled-32bpp-rotate-270
[65.685034] Subtest x-tiled-32bpp-rotate-270: SKIP (0.020s)
[65.795423] [009/133] (951s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[65.891485] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[65.895940] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[65.979908] [010/133] (951s left) gem_gtt_cpu_tlb
[66.090597] [011/133] (951s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[66.180383] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[66.185038] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s)
[66.249330] [012/133] (951s left) syncobj_timeline (wait-delayed-signal)
[66.303899] Starting subtest: wait-delayed-signal
[66.412475] Subtest wait-delayed-signal: SUCCESS (0.104s)
[66.493048] [013/133] (951s left) kms_plane_scaling (invalid-num-scalers)
[66.585066] Starting subtest: invalid-num-scalers
[66.587157] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[66.604197] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.019s)
[66.611492] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[66.640439] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.036s)
[66.647800] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[66.677087] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.036s)
[66.684663] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[66.714770] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.036s)
[66.717100] Subtest invalid-num-scalers: SUCCESS (0.130s)
[66.818645] [014/133] (950s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[66.913825] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[66.916134] Starting dynamic subtest: pipe-A-eDP-1
[66.939416] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[66.951496] Starting dynamic subtest: pipe-B-eDP-1
[66.972246] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[66.979590] Starting dynamic subtest: pipe-C-eDP-1
[67.009730] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[67.017996] Starting dynamic subtest: pipe-D-eDP-1
[67.040061] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[67.044094] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[69.140420] [015/133] (948s left) kms_invalid_mode (bad-hsync-end)
[69.234226] Starting subtest: bad-hsync-end
[69.236552] Starting dynamic subtest: pipe-A-eDP-1
[69.523625] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[69.530908] Starting dynamic subtest: pipe-B-eDP-1
[69.532836] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[69.539595] Starting dynamic subtest: pipe-C-eDP-1
[69.542305] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[69.550553] Starting dynamic subtest: pipe-D-eDP-1
[69.552805] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[69.555184] Subtest bad-hsync-end: SUCCESS (0.293s)
[70.372021] [016/133] (947s left) gem_mmap_wc (set-cache-level)
[70.431945] Subtest set-cache-level: SKIP (0.000s)
[70.494792] [017/133] (947s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[70.588359] Starting subtest: primary-yf-tiled-reflect-x-270
[70.592956] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[70.663024] [018/133] (947s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[70.763983] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[78.182826] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.433s)
[78.305050] [019/133] (939s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[78.401145] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[78.403432] Starting dynamic subtest: pipe-A
[78.421183] Dynamic subtest pipe-A: SKIP (0.018s)
[78.430305] Starting dynamic subtest: pipe-B
[78.457201] Dynamic subtest pipe-B: SKIP (0.035s)
[78.465144] Starting dynamic subtest: pipe-C
[78.491989] Dynamic subtest pipe-C: SKIP (0.034s)
[78.499542] Starting dynamic subtest: pipe-D
[78.521145] Dynamic subtest pipe-D: SKIP (0.031s)
[78.524802] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.119s)
[78.599137] [020/133] (939s left) perf (gen12-group-concurrent-oa-buffer-read)
[78.709990] Starting subtest: gen12-group-concurrent-oa-buffer-read
[88.748653] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.040s)
[88.798770] [021/133] (929s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[88.898645] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[95.953058] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.059s)
[96.079183] [022/133] (921s left) gem_exec_fence (syncobj-export)
[96.531217] Starting subtest: syncobj-export
[96.537705] Subtest syncobj-export: SUCCESS (0.007s)
[98.390640] [FACT gem_exec_fence (syncobj-export)] new: kernel.kmod_is_loaded.vgem: true
[98.394126] [023/133] (919s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[98.485087] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[98.487356] Starting dynamic subtest: pipe-A-default-mode
[99.677359] Dynamic subtest pipe-A-default-mode: SKIP (1.189s)
[99.681677] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.190s)
[99.821079] [024/133] (918s left) perf_pmu (semaphore-wait)
[99.865598] Starting subtest: semaphore-wait
[99.867455] Starting dynamic subtest: rcs0
[100.382501] Dynamic subtest rcs0: SUCCESS (0.516s)
[100.394122] Starting dynamic subtest: bcs0
[100.895533] Dynamic subtest bcs0: SUCCESS (0.512s)
[100.905280] Starting dynamic subtest: vcs0
[101.410588] Dynamic subtest vcs0: SUCCESS (0.513s)
[101.421729] Starting dynamic subtest: vcs1
[101.923882] Dynamic subtest vcs1: SUCCESS (0.512s)
[101.933808] Starting dynamic subtest: vecs0
[102.437285] Dynamic subtest vecs0: SUCCESS (0.511s)
[102.448826] Starting dynamic subtest: ccs0
[102.952372] Dynamic subtest ccs0: SUCCESS (0.514s)
[102.955175] Subtest semaphore-wait: SUCCESS (3.088s)
[104.415648] [025/133] (913s left) kms_flip (flip-vs-rmfb-interruptible)
[104.522908] Starting subtest: flip-vs-rmfb-interruptible
[104.525217] Starting dynamic subtest: A-eDP1
[113.135223] Dynamic subtest A-eDP1: SUCCESS (8.611s)
[113.145281] Starting dynamic subtest: B-eDP1
[121.768315] Dynamic subtest B-eDP1: SUCCESS (8.631s)
[121.778861] Starting dynamic subtest: C-eDP1
[130.384186] Dynamic subtest C-eDP1: SUCCESS (8.614s)
[130.399543] Starting dynamic subtest: D-eDP1
[139.016253] Dynamic subtest D-eDP1: SUCCESS (8.630s)
[139.020706] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.497s)
[140.196848] [026/133] (877s left) i915_drm_fdinfo (context-close-stress)
[140.243058] Starting subtest: context-close-stress
[150.988586] Subtest context-close-stress: SUCCESS (10.745s)
[151.181875] [027/133] (866s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[151.425535] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[151.429624] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[151.516790] [028/133] (866s left) api_intel_allocator (execbuf-with-allocator)
[151.571979] Starting subtest: execbuf-with-allocator
[151.576709] Subtest execbuf-with-allocator: SUCCESS (0.006s)
[151.694727] [029/133] (866s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[151.795574] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[158.508920] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.714s)
[158.611334] [030/133] (859s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[158.713021] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[158.805767] [031/133] (859s left) kms_cursor_crc (cursor-onscreen-128x42)
[159.036710] Starting subtest: cursor-onscreen-128x42
[159.087474] Subtest cursor-onscreen-128x42: SKIP (0.046s)
[159.301657] [032/133] (858s left) gem_close_race (basic-threads)
[159.357558] Starting subtest: basic-threads
[160.823061] Subtest basic-threads: SUCCESS (1.465s)
[161.005244] [033/133] (857s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[161.097050] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[161.101215] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[161.166819] [034/133] (857s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[161.266343] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[168.757025] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.494s)
[168.893303] [035/133] (849s left) syncobj_wait (invalid-reset-bad-pad)
[168.947718] Starting subtest: invalid-reset-bad-pad
[168.949829] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[169.040864] [036/133] (849s left) i915_query (query-topology-garbage-items)
[169.093805] Starting subtest: query-topology-garbage-items
[169.095617] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[169.183998] [037/133] (849s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[169.293390] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[169.297757] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[169.436832] [038/133] (849s left) kms_vblank (ts-continuation-dpms-rpm)
[169.543123] Starting subtest: ts-continuation-dpms-rpm
[169.545226] Starting dynamic subtest: pipe-A-eDP-1
[172.062595] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.517s)
[172.084030] Starting dynamic subtest: pipe-D-eDP-1
[174.319545] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.255s)
[174.321941] Subtest ts-continuation-dpms-rpm: SUCCESS (4.777s)
[175.190753] [039/133] (843s left) kms_atomic_transition (plane-all-transition-fencing)
[175.293786] Starting subtest: plane-all-transition-fencing
[175.296229] Starting dynamic subtest: pipe-A-eDP-1
[177.787522] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[178.098220] Starting dynamic subtest: pipe-B-eDP-1
[181.317794] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.228s)
[181.619732] Subtest plane-all-transition-fencing: SUCCESS (6.327s)
[182.449234] [040/133] (836s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[182.554506] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[182.558842] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[182.639627] [041/133] (835s left) gem_userptr_blits (forbidden-operations)
[182.708701] Starting subtest: forbidden-operations
[182.712803] Subtest forbidden-operations: SKIP (0.000s)
[182.847557] [042/133] (835s left) i915_pm_rpm (system-suspend-devices)
[184.383295] Starting subtest: system-suspend-devices
[192.163449] Subtest system-suspend-devices: SUCCESS (7.783s)
[192.537909] [043/133] (826s left) kms_chamelium_hpd (hdmi-hpd-fast)
[192.969511] Subtest hdmi-hpd-fast: SKIP (0.000s)
[193.746225] [044/133] (825s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[193.844849] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[198.551608] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.711s)
[199.761407] [045/133] (819s left) gem_busy (semaphore)
[199.958471] Subtest semaphore: SKIP (0.000s)
[200.190125] [046/133] (818s left) gem_ctx_freq (sysfs)
[200.249567] Starting subtest: sysfs
[200.251996] Starting dynamic subtest: gt0
[205.750674] Dynamic subtest gt0: SUCCESS (5.501s)
[205.761990] Starting dynamic subtest: gt1
[247.303477] Dynamic subtest gt1: SUCCESS (41.550s)
[247.306094] Subtest sysfs: SUCCESS (47.054s)
[247.425095] [047/133] (771s left) kms_psr (psr2-sprite-plane-move)
[247.528108] Starting subtest: psr2-sprite-plane-move
[247.530348] Starting dynamic subtest: eDP-1
[249.272438] Dynamic subtest eDP-1: SUCCESS (1.744s)
[249.274640] Subtest psr2-sprite-plane-move: SUCCESS (1.745s)
[250.103785] [048/133] (768s left) gem_watchdog (default-virtual)
[250.172170] Starting subtest: default-virtual
[256.446947] Subtest default-virtual: SUCCESS (6.283s)
[256.551753] [049/133] (762s left) gem_exec_flush (basic-wb-ro-default)
[256.627253] Starting subtest: basic-wb-ro-default
[262.089703] Subtest basic-wb-ro-default: SUCCESS (5.465s)
[262.283465] [050/133] (756s left) kms_plane_alpha_blend (alpha-7efc)
[262.389229] Starting subtest: alpha-7efc
[262.696944] Starting dynamic subtest: pipe-A-eDP-1
[263.299097] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.599s)
[263.326269] Starting dynamic subtest: pipe-D-eDP-1
[264.597768] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.278s)
[264.600066] Subtest alpha-7efc: SUCCESS (2.208s)
[265.481250] [051/133] (753s left) gem_set_tiling_vs_pwrite
[265.614228] [052/133] (753s left) kms_cursor_crc (cursor-sliding-512x512)
[265.887756] Starting subtest: cursor-sliding-512x512
[265.892293] Subtest cursor-sliding-512x512: SKIP (0.001s)
[266.052550] [053/133] (753s left) kms_big_fb (linear-32bpp-rotate-180)
[266.150517] Starting subtest: linear-32bpp-rotate-180
[267.737660] Subtest linear-32bpp-rotate-180: SUCCESS (1.589s)
[267.886904] [054/133] (751s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[267.942957] Subtest tiled-to-tiled: SKIP (0.000s)
[268.009398] [055/133] (751s left) gem_lmem_swapping (verify-random)
[268.056514] Subtest verify-random: SKIP (0.000s)
[268.096300] [056/133] (751s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[268.207181] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[268.211119] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[268.308116] [057/133] (751s left) gem_mmap_gtt (basic-small-bo-tiledx)
[268.378149] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[268.440764] [058/133] (750s left) kms_chamelium_frames (dp-crc-single)
[268.814274] Subtest dp-crc-single: SKIP (0.000s)
[269.668261] [059/133] (749s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[269.772773] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[273.362793] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.596s)
[274.484511] [060/133] (744s left) gem_exec_nop (basic-series)
[274.564847] Starting subtest: basic-series
[290.317061] Subtest basic-series: SUCCESS (15.759s)
[290.566262] [061/133] (728s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[290.672297] Starting subtest: bad-rotation-90-yf-tiled-ccs
[290.674835] Starting dynamic subtest: pipe-A-eDP-1
[290.696715] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[290.709703] Starting dynamic subtest: pipe-B-eDP-1
[290.733725] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[290.745085] Starting dynamic subtest: pipe-C-eDP-1
[290.767246] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[290.776350] Starting dynamic subtest: pipe-D-eDP-1
[290.798442] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[290.802488] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.005s)
[292.957492] [062/133] (726s left) gem_render_copy (linear-to-vebox-yf-tiled)
[293.017087] Starting subtest: linear-to-vebox-yf-tiled
[293.021505] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[293.199899] [063/133] (726s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[293.308088] Starting subtest: psr-1p-primscrn-cur-indfb-move
[300.708431] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.407s)
[300.857356] [064/133] (718s left) kms_flip (2x-flip-vs-dpms-on-nop)
[300.955162] Starting subtest: 2x-flip-vs-dpms-on-nop
[300.966604] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s)
[301.044611] [065/133] (718s left) dumb_buffer (map-invalid-size)
[301.104462] Starting subtest: map-invalid-size
[301.106571] Subtest map-invalid-size: SUCCESS (0.000s)
[301.204717] [066/133] (718s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[301.296760] Starting subtest: pr-plane-move-sf-dmg-area
[301.301223] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[301.364250] [067/133] (718s left) gen7_exec_parse (basic-offset)
[301.421604] Subtest basic-offset: SKIP (0.000s)
[301.486446] [068/133] (718s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[301.538450] Starting subtest: etime-single-wait-for-submit-unsubmitted
[301.644777] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.104s)
[301.719908] [069/133] (718s left) kms_psr (psr-primary-render)
[301.821453] Starting subtest: psr-primary-render
[301.823824] Starting dynamic subtest: eDP-1
[303.558904] Dynamic subtest eDP-1: SUCCESS (1.737s)
[303.561475] Subtest psr-primary-render: SUCCESS (1.738s)
[304.425386] [070/133] (715s left) kms_psr (fbc-psr-sprite-plane-move)
[304.522281] Starting subtest: fbc-psr-sprite-plane-move
[304.524589] Starting dynamic subtest: eDP-1
[304.528938] Dynamic subtest eDP-1: SKIP (0.000s)
[304.533519] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[304.633328] [071/133] (715s left) gem_lmem_swapping (basic)
[304.687773] Subtest basic: SKIP (0.000s)
[304.734959] [072/133] (715s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[304.845059] Starting subtest: cursorB-vs-flipA-toggle
[304.849317] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[304.992361] [073/133] (715s left) gem_mmap_wc (write-gtt-read-wc)
[305.060562] Subtest write-gtt-read-wc: SKIP (0.000s)
[305.119772] [074/133] (714s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[305.212156] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[305.238633] Starting dynamic subtest: pipe-A-plane-0
[305.526089] Dynamic subtest pipe-A-plane-0: SUCCESS (0.288s)
[305.537248] Starting dynamic subtest: pipe-A-plane-3
[305.759365] Dynamic subtest pipe-A-plane-3: SUCCESS (0.231s)
[306.904412] Starting dynamic subtest: pipe-B-plane-0
[307.195533] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[307.207176] Starting dynamic subtest: pipe-B-plane-3
[307.428749] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[307.737710] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.527s)
[308.574582] [075/133] (711s left) sw_sync (alloc_fence)
[308.612821] Starting subtest: alloc_fence
[308.615583] Subtest alloc_fence: SUCCESS (0.000s)
[308.674677] [076/133] (711s left) kms_psr2_su (frontbuffer-xrgb8888)
[308.731669] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[308.786974] [077/133] (711s left) kms_pm_rpm (pm-caching)
[310.416814] Starting subtest: pm-caching
[310.421840] Subtest pm-caching: SKIP (0.000s)
[311.019885] [078/133] (709s left) kms_fbcon_fbt (psr)
[311.075867] Starting subtest: psr
[318.435874] Subtest psr: SUCCESS (7.357s)
[318.511156] [079/133] (701s left) i915_drm_fdinfo (virtual-busy-idle)
[318.559674] Starting subtest: virtual-busy-idle
[318.563741] Subtest virtual-busy-idle: SKIP (0.000s)
[318.625293] [080/133] (701s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[318.738603] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[318.743050] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[318.829378] [081/133] (701s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[318.932769] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[318.937340] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[319.039156] [082/133] (701s left) kms_draw_crc (draw-method-mmap-cpu)
[319.133854] Starting subtest: draw-method-mmap-cpu
[319.136207] Starting dynamic subtest: xrgb8888-untiled
[319.399075] Dynamic subtest xrgb8888-untiled: SUCCESS (0.267s)
[319.408885] Starting dynamic subtest: rgb565-untiled
[319.643047] Dynamic subtest rgb565-untiled: SUCCESS (0.243s)
[319.652525] Starting dynamic subtest: xrgb2101010-untiled
[319.854321] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.210s)
[319.866219] Starting dynamic subtest: xbgr16161616f-untiled
[320.076294] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[320.085485] Starting dynamic subtest: xrgb8888-xtiled
[320.220753] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.144s)
[320.229994] Starting dynamic subtest: rgb565-xtiled
[320.354186] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s)
[320.362884] Starting dynamic subtest: xrgb2101010-xtiled
[320.487460] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.133s)
[320.496423] Starting dynamic subtest: xbgr16161616f-xtiled
[320.620784] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[320.631525] Starting dynamic subtest: xrgb8888-4tiled
[320.764885] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[320.775111] Starting dynamic subtest: rgb565-4tiled
[320.920723] Dynamic subtest rgb565-4tiled: SUCCESS (0.155s)
[320.929918] Starting dynamic subtest: xrgb2101010-4tiled
[321.053991] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s)
[321.063155] Starting dynamic subtest: xbgr16161616f-4tiled
[321.198520] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s)
[321.200413] Subtest draw-method-mmap-cpu: SUCCESS (2.068s)
[321.303668] [083/133] (699s left) gem_exec_schedule (u-semaphore-noskip)
[321.381521] Starting subtest: u-semaphore-noskip
[321.782561] Subtest u-semaphore-noskip: SUCCESS (0.403s)
[322.117329] [084/133] (698s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[322.211168] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[323.255175] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.045s)
[323.376950] [085/133] (697s left) gem_exec_balancer (semaphore)
[323.438038] Starting subtest: semaphore
[325.323255] Subtest semaphore: SUCCESS (1.883s)
[325.642192] [086/133] (694s left) gem_mmap_wc (read-write-distinct)
[325.699268] Subtest read-write-distinct: SKIP (0.000s)
[325.761091] [087/133] (694s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[325.840789] Starting subtest: multi-wait-all-for-submit-signaled
[325.842781] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[325.928509] [088/133] (694s left) perf_pmu (rc6-suspend)
[325.972135] Starting subtest: rc6-suspend
[348.551232] Subtest rc6-suspend: SUCCESS (7.572s)
[349.561288] [089/133] (671s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[349.669267] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[349.673623] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[349.738335] [090/133] (671s left) perf (invalid-oa-metric-set-id)
[349.836682] Starting subtest: invalid-oa-metric-set-id
[349.849484] Subtest invalid-oa-metric-set-id: SUCCESS (0.013s)
[349.891398] [091/133] (670s left) syncobj_timeline (wait-any-complex)
[349.950720] Starting subtest: wait-any-complex
[350.011872] Subtest wait-any-complex: SUCCESS (0.064s)
[350.086290] [092/133] (670s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[350.189454] Starting subtest: y-tiled-8bpp-rotate-90
[350.194081] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[350.291071] [093/133] (670s left) kms_frontbuffer_tracking (fbc-tiling-y)
[350.395414] Starting subtest: fbc-tiling-y
[350.400028] Subtest fbc-tiling-y: SKIP (0.000s)
[350.488399] [094/133] (670s left) kms_hdmi_inject (inject-4k)
[350.827728] Starting subtest: inject-4k
[351.136710] Subtest inject-4k: SUCCESS (0.314s)
[351.718783] [095/133] (669s left) gem_exec_schedule (deep)
[351.897713] Starting subtest: deep
[351.900470] Starting dynamic subtest: rcs0
[357.085014] Dynamic subtest rcs0: SKIP (5.217s)
[357.098231] Starting dynamic subtest: vcs0
[367.452695] Dynamic subtest vcs0: SUCCESS (10.395s)
[367.468705] Starting dynamic subtest: vcs1
[378.516276] Dynamic subtest vcs1: SUCCESS (11.076s)
[378.529295] Starting dynamic subtest: vecs0
[389.353862] Dynamic subtest vecs0: SUCCESS (10.841s)
[389.369328] Starting dynamic subtest: ccs0
[401.576598] Dynamic subtest ccs0: SUCCESS (12.229s)
[401.579396] Subtest deep: SUCCESS (49.764s)
[403.026142] [096/133] (617s left) kms_flip (flip-vs-panning-interruptible)
[403.123314] Starting subtest: flip-vs-panning-interruptible
[403.125734] Starting dynamic subtest: A-eDP1
[411.867200] Dynamic subtest A-eDP1: SUCCESS (8.747s)
[411.877579] Starting dynamic subtest: B-eDP1
[420.575359] Dynamic subtest B-eDP1: SUCCESS (8.711s)
[420.585898] Starting dynamic subtest: C-eDP1
[429.248622] Dynamic subtest C-eDP1: SUCCESS (8.676s)
[429.260138] Starting dynamic subtest: D-eDP1
[437.953909] Dynamic subtest D-eDP1: SUCCESS (8.709s)
[437.958962] Subtest flip-vs-panning-interruptible: SUCCESS (34.852s)
[439.179195] [097/133] (581s left) gem_exec_schedule (preempt)
[439.263528] Starting subtest: preempt
[439.265948] Starting dynamic subtest: rcs0
[439.276473] Dynamic subtest rcs0: SUCCESS (0.024s)
[439.286987] Starting dynamic subtest: bcs0
[439.305200] Dynamic subtest bcs0: SUCCESS (0.027s)
[439.315503] Starting dynamic subtest: vcs0
[439.331916] Dynamic subtest vcs0: SUCCESS (0.026s)
[439.341971] Starting dynamic subtest: vcs1
[439.356342] Dynamic subtest vcs1: SUCCESS (0.024s)
[439.367640] Starting dynamic subtest: vecs0
[439.377301] Dynamic subtest vecs0: SUCCESS (0.020s)
[439.387711] Starting dynamic subtest: ccs0
[439.408312] Dynamic subtest ccs0: SUCCESS (0.030s)
[439.411087] Subtest preempt: SUCCESS (0.156s)
[441.467085] [098/133] (579s left) prime_mmap (test_map_unmap)
[441.516326] Starting subtest: test_map_unmap
[441.518978] Starting dynamic subtest: test_map_unmap-smem
[441.548710] Dynamic subtest test_map_unmap-smem: SUCCESS (0.034s)
[441.551360] Subtest test_map_unmap: SUCCESS (0.035s)
[441.638053] [099/133] (579s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[441.737445] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[441.742576] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[441.834319] [100/133] (579s left) gem_softpin (evict-single-offset)
[441.889120] Starting subtest: evict-single-offset
[469.350587] Subtest evict-single-offset: SUCCESS (27.418s)
[469.455164] [101/133] (551s left) gem_close (basic)
[469.561235] Starting subtest: basic
[469.563741] Subtest basic: SUCCESS (0.000s)
[469.649284] [102/133] (551s left) kms_psr (fbc-pr-primary-mmap-gtt)
[469.754494] Starting subtest: fbc-pr-primary-mmap-gtt
[469.759353] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[469.828026] [103/133] (551s left) kms_frontbuffer_tracking (basic)
[469.922936] Starting subtest: basic
[473.178561] Subtest basic: SUCCESS (3.258s)
[473.308417] [104/133] (548s left) gem_partial_pwrite_pread (write-display)
[473.368466] Subtest write-display: SKIP (0.000s)
[473.444073] [105/133] (547s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[473.559021] Starting subtest: cursorA-vs-flipB-toggle
[473.562870] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[473.703753] [106/133] (547s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[473.806338] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[474.895954] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.090s)
[475.018551] [107/133] (546s left) gem_mmap_offset (partial-mmap)
[475.068350] Starting subtest: partial-mmap
[475.070387] Starting dynamic subtest: smem0
[475.072292] Dynamic subtest smem0: SUCCESS (0.004s)
[475.074344] Subtest partial-mmap: SUCCESS (0.005s)
[475.187414] [108/133] (546s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[475.276682] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[475.281026] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[476.482136] [109/133] (545s left) gem_create (create-size-update)
[476.547325] Starting subtest: create-size-update
[476.549706] Subtest create-size-update: SUCCESS (0.000s)
[476.760324] [110/133] (544s left) gem_pread (exhaustion)
[476.825124] Subtest exhaustion: SKIP (0.000s)
[476.894426] [111/133] (544s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[476.949537] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[477.055967] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.106s)
[477.147660] [112/133] (544s left) gem_exec_async (concurrent-writes)
[477.210619] Starting subtest: concurrent-writes
[477.213252] Starting dynamic subtest: rcs0
[477.227350] Dynamic subtest rcs0: SUCCESS (0.016s)
[477.239486] Starting dynamic subtest: bcs0
[477.242059] Dynamic subtest bcs0: SUCCESS (0.006s)
[477.252247] Starting dynamic subtest: vcs0
[477.254578] Dynamic subtest vcs0: SUCCESS (0.006s)
[477.264633] Starting dynamic subtest: vcs1
[477.266951] Dynamic subtest vcs1: SUCCESS (0.004s)
[477.276253] Starting dynamic subtest: vecs0
[477.278601] Dynamic subtest vecs0: SUCCESS (0.005s)
[477.288136] Starting dynamic subtest: ccs0
[477.290330] Dynamic subtest ccs0: SUCCESS (0.007s)
[477.292497] Subtest concurrent-writes: SUCCESS (0.049s)
[477.486093] [113/133] (544s left) kms_psr (pr-cursor-render)
[477.580723] Starting subtest: pr-cursor-render
[477.585630] Subtest pr-cursor-render: SKIP (0.000s)
[477.654957] [114/133] (544s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[477.747257] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[477.749511] Starting dynamic subtest: pipe-A-eDP-1
[477.808596] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[477.818648] Starting dynamic subtest: pipe-B-eDP-1
[477.885269] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[477.896133] Starting dynamic subtest: pipe-C-eDP-1
[477.962906] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[477.973311] Starting dynamic subtest: pipe-D-eDP-1
[478.037266] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[478.042384] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.009s)
[480.040794] [115/133] (541s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[480.174375] Starting subtest: short-flip-after-cursor-toggle
[481.087710] Subtest short-flip-after-cursor-toggle: SUCCESS (0.912s)
[481.934691] [116/133] (540s left) kms_content_protection (lic-type-0)
[482.085167] Starting subtest: lic-type-0
[482.091011] Subtest lic-type-0: SKIP (0.000s)
[482.202527] [117/133] (539s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[482.297525] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[482.302779] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[482.380229] [118/133] (539s left) kms_lease (lease-invalid-connector)
[482.468063] Starting subtest: lease-invalid-connector
[482.470473] Starting dynamic subtest: pipe-A-eDP-1
[482.472963] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[482.482826] Starting dynamic subtest: pipe-B-eDP-1
[482.485411] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[482.495189] Starting dynamic subtest: pipe-C-eDP-1
[482.497321] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[482.506468] Starting dynamic subtest: pipe-D-eDP-1
[482.508296] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[482.510422] Subtest lease-invalid-connector: SUCCESS (0.004s)
[482.548900] [119/133] (539s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[482.778555] Starting subtest: cursor-rapid-movement-128x42
[482.823325] Subtest cursor-rapid-movement-128x42: SKIP (0.041s)
[483.020118] [120/133] (539s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[483.114455] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[483.118472] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[483.205738] [121/133] (538s left) prime_vgem (basic-read)
[483.274004] Starting subtest: basic-read
[483.324340] Subtest basic-read: SKIP (0.047s)
[483.418893] [122/133] (538s left) gem_exec_flush (basic-uc-prw-default)
[483.483207] Starting subtest: basic-uc-prw-default
[488.956482] Subtest basic-uc-prw-default: SUCCESS (5.473s)
[489.144021] [123/133] (533s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[489.195951] Starting subtest: multi-wait-all-for-submit-signaled
[489.198438] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[489.300597] [124/133] (533s left) kms_scaling_modes (scaling-mode-none)
[489.394383] Starting subtest: scaling-mode-none
[489.397200] Starting dynamic subtest: pipe-A-eDP-1
[489.489440] Dynamic subtest pipe-A-eDP-1: SKIP (0.095s)
[489.500224] Starting dynamic subtest: pipe-B-eDP-1
[489.528335] Dynamic subtest pipe-B-eDP-1: SKIP (0.035s)
[489.538845] Starting dynamic subtest: pipe-C-eDP-1
[489.559780] Dynamic subtest pipe-C-eDP-1: SKIP (0.030s)
[489.570738] Starting dynamic subtest: pipe-D-eDP-1
[489.605723] Dynamic subtest pipe-D-eDP-1: SKIP (0.045s)
[489.611592] Subtest scaling-mode-none: SKIP (0.211s)
[489.715570] [125/133] (532s left) syncobj_timeline (invalid-signal-illegal-handle)
[489.766562] Starting subtest: invalid-signal-illegal-handle
[489.769425] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[489.876110] [126/133] (532s left) kms_getfb (getfb2-handle-not-fb)
[489.962482] Starting subtest: getfb2-handle-not-fb
[489.965200] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[490.059243] [127/133] (532s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[490.117457] Starting subtest: y-tiled-to-vebox-y-tiled
[490.122273] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[490.304501] [128/133] (532s left) gem_exec_whisper (basic-contexts-forked-all)
[490.363541] Starting subtest: basic-contexts-forked-all
[511.307395] Subtest basic-contexts-forked-all: SUCCESS (20.938s)
[511.492745] [129/133] (511s left) kms_async_flips (invalid-async-flip-atomic)
[511.585236] Starting subtest: invalid-async-flip-atomic
[511.957578] Starting dynamic subtest: pipe-A-eDP-1
[512.825350] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.867s)
[513.195849] Starting dynamic subtest: pipe-B-eDP-1
[514.020257] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.839s)
[514.380371] Starting dynamic subtest: pipe-C-eDP-1
[515.208699] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.837s)
[515.564189] Starting dynamic subtest: pipe-D-eDP-1
[516.419223] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.864s)
[516.421839] Subtest invalid-async-flip-atomic: SUCCESS (4.835s)
[517.636461] [130/133] (504s left) syncobj_wait (wait-all-for-submit-complex)
[517.689993] Starting subtest: wait-all-for-submit-complex
[517.906958] Subtest wait-all-for-submit-complex: SUCCESS (0.216s)
[518.039043] [131/133] (504s left) kms_cdclk (plane-scaling)
[518.137569] Starting subtest: plane-scaling
[518.140420] Starting dynamic subtest: pipe-A-eDP-1
[518.427244] Dynamic subtest pipe-A-eDP-1: SKIP (0.288s)
[518.438234] Starting dynamic subtest: pipe-B-eDP-1
[518.442950] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[518.453740] Starting dynamic subtest: pipe-C-eDP-1
[518.459432] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[518.469713] Starting dynamic subtest: pipe-D-eDP-1
[518.474703] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[518.479747] Subtest plane-scaling: SKIP (0.295s)
[519.228332] [132/133] (503s left) kms_color_pipeline (plane-lut1d)
[519.322224] Starting subtest: plane-lut1d
[519.482110] Starting dynamic subtest: pipe-A-plane-0
[519.651247] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[519.661643] Starting dynamic subtest: pipe-A-plane-1
[519.837696] Dynamic subtest pipe-A-plane-1: SUCCESS (0.188s)
[519.853230] Starting dynamic subtest: pipe-A-plane-2
[520.026570] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s)
[521.224568] Starting dynamic subtest: pipe-B-plane-0
[521.393907] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s)
[521.404643] Starting dynamic subtest: pipe-B-plane-1
[521.539587] Dynamic subtest pipe-B-plane-1: SUCCESS (0.144s)
[521.550113] Starting dynamic subtest: pipe-B-plane-2
[521.706952] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[522.888736] Starting dynamic subtest: pipe-C-plane-0
[523.023883] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[523.034389] Starting dynamic subtest: pipe-C-plane-1
[523.180925] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[523.194356] Starting dynamic subtest: pipe-C-plane-2
[523.324445] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[524.486145] Starting dynamic subtest: pipe-D-plane-0
[524.631938] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[524.642744] Starting dynamic subtest: pipe-D-plane-1
[524.798077] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[524.808742] Starting dynamic subtest: pipe-D-plane-2
[524.964287] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[525.253702] Subtest plane-lut1d: SUCCESS (5.928s)
[526.142587] [133/133] (496s left) gem_eio (reset-stress)
[526.365340] Starting subtest: reset-stress
[526.368200] Starting dynamic subtest: render
[531.220689] Dynamic subtest render: SUCCESS (4.852s)
[531.233166] Starting dynamic subtest: bsd1
[548.801439] Dynamic subtest bsd1: SUCCESS (17.578s)
[548.818296] Starting dynamic subtest: bsd2
[566.867174] Dynamic subtest bsd2: SUCCESS (18.064s)
[566.886762] Starting dynamic subtest: blt
[566.891627] Dynamic subtest blt: SKIP (0.000s)
[566.902716] Starting dynamic subtest: vebox
[584.849378] Dynamic subtest vebox: SUCCESS (17.980s)
[584.851553] Subtest reset-stress: SUCCESS (58.477s)
[586.383694] Closing watchdogs
results: parsing output: 0/ for test: syncobj_wait
results: parsing output: 1/ for test: kms_pm_lpsp
results: parsing output: 2/ for test: api_intel_bb
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_exec_balancer
results: parsing output: 5/ for test: gem_ctx_persistence
results: parsing output: 6/ for test: kms_flip
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_gtt_cpu_tlb
results: parsing output: 10/ for test: kms_plane
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: kms_plane_scaling
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: kms_invalid_mode
results: parsing output: 15/ for test: gem_mmap_wc
results: parsing output: 16/ for test: kms_rotation_crc
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_plane_scaling
results: parsing output: 19/ for test: perf
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_exec_fence
results: parsing output: 22/ for test: kms_flip_scaled_crc
results: parsing output: 23/ for test: perf_pmu
results: parsing output: 24/ for test: kms_flip
results: parsing output: 25/ for test: i915_drm_fdinfo
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: api_intel_allocator
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_addfb_basic
results: parsing output: 30/ for test: kms_cursor_crc
results: parsing output: 31/ for test: gem_close_race
results: parsing output: 32/ for test: kms_flip_scaled_crc
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: i915_query
results: parsing output: 36/ for test: kms_cursor_legacy
results: parsing output: 37/ for test: kms_vblank
results: parsing output: 38/ for test: kms_atomic_transition
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_userptr_blits
results: parsing output: 41/ for test: i915_pm_rpm
results: parsing output: 42/ for test: kms_chamelium_hpd
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_busy
results: parsing output: 45/ for test: gem_ctx_freq
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: gem_watchdog
results: parsing output: 48/ for test: gem_exec_flush
results: parsing output: 49/ for test: kms_plane_alpha_blend
results: parsing output: 50/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: gem_set_tiling_vs_blt
results: parsing output: 54/ for test: gem_lmem_swapping
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: gem_mmap_gtt
results: parsing output: 57/ for test: kms_chamelium_frames
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_exec_nop
results: parsing output: 60/ for test: kms_ccs
results: parsing output: 61/ for test: gem_render_copy
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: dumb_buffer
results: parsing output: 65/ for test: kms_psr2_sf
results: parsing output: 66/ for test: gen7_exec_parse
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: gem_lmem_swapping
results: parsing output: 71/ for test: kms_cursor_legacy
results: parsing output: 72/ for test: gem_mmap_wc
results: parsing output: 73/ for test: kms_plane
results: parsing output: 74/ for test: sw_sync
results: parsing output: 75/ for test: kms_psr2_su
results: parsing output: 76/ for test: kms_pm_rpm
results: parsing output: 77/ for test: kms_fbcon_fbt
results: parsing output: 78/ for test: i915_drm_fdinfo
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_draw_crc
results: parsing output: 82/ for test: gem_exec_schedule
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: gem_exec_balancer
results: parsing output: 85/ for test: gem_mmap_wc
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: perf_pmu
results: parsing output: 88/ for test: kms_psr2_sf
results: parsing output: 89/ for test: perf
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_hdmi_inject
results: parsing output: 94/ for test: gem_exec_schedule
results: parsing output: 95/ for test: kms_flip
results: parsing output: 96/ for test: gem_exec_schedule
results: parsing output: 97/ for test: prime_mmap
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_softpin
results: parsing output: 100/ for test: gem_close
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_partial_pwrite_pread
results: parsing output: 104/ for test: kms_cursor_legacy
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: gem_mmap_offset
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: gem_create
results: parsing output: 109/ for test: gem_pread
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: gem_exec_async
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: kms_ccs
results: parsing output: 114/ for test: kms_cursor_legacy
results: parsing output: 115/ for test: kms_content_protection
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_lease
results: parsing output: 118/ for test: kms_cursor_crc
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: prime_vgem
results: parsing output: 121/ for test: gem_exec_flush
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: kms_scaling_modes
results: parsing output: 124/ for test: syncobj_timeline
results: parsing output: 125/ for test: kms_getfb
results: parsing output: 126/ for test: gem_render_copy
results: parsing output: 127/ for test: gem_exec_whisper
results: parsing output: 128/ for test: kms_async_flips
results: parsing output: 129/ for test: syncobj_wait
results: parsing output: 130/ for test: kms_cdclk
results: parsing output: 131/ for test: kms_color_pipeline
results: parsing output: 132/ for test: gem_eio
Done.