[59.358414] Initializing watchdogs
[59.358481]   /dev/watchdog0
[59.371867] [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]
[59.376643] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.378853] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.382039] [001/132] (960s left) gem_sync (basic-all)
[59.482612] Starting subtest: basic-all
[62.873134] Subtest basic-all: SUCCESS (3.411s)
[63.065993] [002/132] (956s left) gem_mmap_gtt (zero-extend)
[63.133256] Subtest zero-extend: SKIP (0.000s)
[63.188377] [003/132] (956s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[63.293384] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[63.297663] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[63.390418] [004/132] (956s left) prime_self_import (basic-with_two_bos)
[63.433260] Starting subtest: basic-with_two_bos
[63.458566] Subtest basic-with_two_bos: SUCCESS (0.029s)
[63.560204] [005/132] (956s left) gem_readwrite (read-bad-handle)
[63.617997] Subtest read-bad-handle: SKIP (0.000s)
[63.671698] [006/132] (956s left) gem_exec_parallel (fds)
[63.728595] Starting subtest: fds
[63.730923] Starting dynamic subtest: rcs0
[66.401212] Dynamic subtest rcs0: SUCCESS (2.678s)
[66.409868] Starting dynamic subtest: bcs0
[70.087613] Dynamic subtest bcs0: SUCCESS (3.690s)
[70.096297] Starting dynamic subtest: vcs0
[74.142321] Dynamic subtest vcs0: SUCCESS (4.057s)
[74.150880] Starting dynamic subtest: vcs1
[78.192579] Dynamic subtest vcs1: SUCCESS (4.051s)
[78.200435] Starting dynamic subtest: vecs0
[82.211652] Dynamic subtest vecs0: SUCCESS (4.018s)
[82.227969] Starting dynamic subtest: ccs0
[86.084451] Dynamic subtest ccs0: SUCCESS (3.871s)
[86.087694] Subtest fds: SUCCESS (22.371s)
[86.291056] [007/132] (933s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[86.389581] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[86.393853] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[86.489184] [008/132] (933s left) gem_exec_schedule (u-fairslice)
[86.562903] Starting subtest: u-fairslice
[86.565243] Starting dynamic subtest: rcs0
[88.577974] Dynamic subtest rcs0: SUCCESS (2.021s)
[88.588218] Starting dynamic subtest: bcs0
[90.595018] Dynamic subtest bcs0: SUCCESS (2.018s)
[90.604167] Starting dynamic subtest: vcs0
[92.662038] Dynamic subtest vcs0: SUCCESS (2.016s)
[92.671361] Starting dynamic subtest: vcs1
[94.630817] Dynamic subtest vcs1: SUCCESS (2.017s)
[94.640738] Starting dynamic subtest: vecs0
[96.700525] Dynamic subtest vecs0: SUCCESS (2.021s)
[96.709873] Starting dynamic subtest: ccs0
[98.675561] Dynamic subtest ccs0: SUCCESS (2.025s)
[98.677584] Subtest u-fairslice: SUCCESS (12.119s)
[98.985027] [009/132] (921s left) kms_plane_multiple (2x-tiling-yf)
[99.080130] Starting subtest: 2x-tiling-yf
[99.084732] Subtest 2x-tiling-yf: SKIP (0.000s)
[99.149045] [010/132] (921s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[99.241168] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[99.245098] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[99.356555] [011/132] (920s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[99.458660] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[99.462955] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[99.554800] [012/132] (920s left) gem_lmem_swapping (basic)
[99.594811] Subtest basic: SKIP (0.000s)
[99.636607] [013/132] (920s left) gem_mmap_wc (bad-size)
[99.710175] Subtest bad-size: SKIP (0.000s)
[99.771658] [014/132] (920s left) kms_psr (pr-sprite-plane-onoff)
[99.867017] Starting subtest: pr-sprite-plane-onoff
[99.871514] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[99.936006] [015/132] (920s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[100.032136] Starting subtest: 4-tiled-16bpp-rotate-0
[101.354073] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.323s)
[101.471368] [016/132] (918s left) syncobj_timeline (etime-single-wait-submitted)
[101.525092] Starting subtest: etime-single-wait-submitted
[101.636482] Subtest etime-single-wait-submitted: SUCCESS (0.110s)
[101.718753] [017/132] (918s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[101.824778] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[102.758091] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.934s)
[102.887437] [018/132] (917s left) kms_plane (plane-position-hole-dpms)
[102.983087] Starting subtest: plane-position-hole-dpms
[103.495332] Starting dynamic subtest: pipe-A-plane-1
[105.934345] Dynamic subtest pipe-A-plane-1: SUCCESS (2.441s)
[105.944326] Starting dynamic subtest: pipe-A-plane-2
[108.377592] Dynamic subtest pipe-A-plane-2: SUCCESS (2.442s)
[108.387964] Starting dynamic subtest: pipe-A-plane-3
[110.720667] Dynamic subtest pipe-A-plane-3: SUCCESS (2.344s)
[110.729339] Starting dynamic subtest: pipe-A-plane-4
[113.094012] Dynamic subtest pipe-A-plane-4: SUCCESS (2.371s)
[113.102664] Starting dynamic subtest: pipe-A-plane-5
[113.119609] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[114.260601] Starting dynamic subtest: pipe-B-plane-1
[116.725180] Dynamic subtest pipe-B-plane-1: SUCCESS (2.469s)
[116.741513] Starting dynamic subtest: pipe-B-plane-2
[119.069166] Dynamic subtest pipe-B-plane-2: SUCCESS (2.343s)
[119.078064] Starting dynamic subtest: pipe-B-plane-3
[121.425229] Dynamic subtest pipe-B-plane-3: SUCCESS (2.354s)
[121.436970] Starting dynamic subtest: pipe-B-plane-4
[123.789204] Dynamic subtest pipe-B-plane-4: SUCCESS (2.362s)
[123.799451] Starting dynamic subtest: pipe-B-plane-5
[123.812480] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[123.814376] Subtest plane-position-hole-dpms: SUCCESS (20.827s)
[124.603430] [019/132] (895s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[124.668924] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[124.770050] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.101s)
[124.839612] [020/132] (895s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[124.946564] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[124.951103] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[125.045260] [021/132] (895s left) gem_mmap_wc (set-cache-level)
[125.110174] Subtest set-cache-level: SKIP (0.000s)
[125.171343] [022/132] (895s left) kms_vblank (query-busy-hang)
[125.265377] Starting subtest: query-busy-hang
[125.267644] Starting dynamic subtest: pipe-A-eDP-1
[151.636671] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.371s)
[151.649397] Starting dynamic subtest: pipe-D-eDP-1
[166.684069] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.044s)
[166.686491] Subtest query-busy-hang: SUCCESS (41.419s)
[167.472873] [023/132] (853s left) gem_partial_pwrite_pread (write-display)
[167.523777] Subtest write-display: SKIP (0.000s)
[167.583493] [024/132] (853s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[167.682583] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[171.632400] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (3.953s)
[172.793293] [025/132] (847s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[172.889932] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[172.893929] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[172.955562] [026/132] (847s left) gem_ccs (block-multicopy-compressed)
[173.013838] Starting subtest: block-multicopy-compressed
[173.018185] Subtest block-multicopy-compressed: SKIP (0.000s)
[173.117747] [027/132] (847s left) kms_flip (wf_vblank-ts-check-interruptible)
[173.223717] Starting subtest: wf_vblank-ts-check-interruptible
[173.226190] Starting dynamic subtest: A-eDP1
[182.151593] Dynamic subtest A-eDP1: SUCCESS (8.898s)
[182.161868] Starting dynamic subtest: B-eDP1
[191.093427] Dynamic subtest B-eDP1: SUCCESS (8.940s)
[191.100666] Starting dynamic subtest: C-eDP1
[200.012973] Dynamic subtest C-eDP1: SUCCESS (8.906s)
[200.022986] Starting dynamic subtest: D-eDP1
[208.938426] Dynamic subtest D-eDP1: SUCCESS (8.922s)
[208.940907] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.676s)
[210.112913] [028/132] (810s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[210.204218] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[210.206135] Starting dynamic subtest: pipe-A
[210.539198] Dynamic subtest pipe-A: SUCCESS (0.338s)
[210.548396] Starting dynamic subtest: pipe-B
[211.909181] Dynamic subtest pipe-B: SUCCESS (1.368s)
[211.917814] Starting dynamic subtest: pipe-C
[213.340420] Dynamic subtest pipe-C: SUCCESS (1.431s)
[213.348925] Starting dynamic subtest: pipe-D
[214.772543] Dynamic subtest pipe-D: SUCCESS (1.431s)
[214.774873] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.571s)
[215.944646] [029/132] (804s left) kms_flip (2x-busy-flip)
[216.026294] Starting subtest: 2x-busy-flip
[216.036934] Subtest 2x-busy-flip: SKIP (0.010s)
[216.112508] [030/132] (804s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[216.197387] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[216.199733] Starting dynamic subtest: pipe-A-eDP-1
[216.223220] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[216.233173] Starting dynamic subtest: pipe-B-eDP-1
[216.254526] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[216.263159] Starting dynamic subtest: pipe-C-eDP-1
[216.284544] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[216.292279] Starting dynamic subtest: pipe-D-eDP-1
[216.314157] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[216.318582] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[218.510265] [031/132] (802s left) kms_chamelium_frames (dp-crc-fast)
[218.899196] Subtest dp-crc-fast: SKIP (0.000s)
[219.701688] [032/132] (801s left) kms_big_fb (linear-8bpp-rotate-270)
[219.792267] Starting subtest: linear-8bpp-rotate-270
[219.813056] Subtest linear-8bpp-rotate-270: SKIP (0.020s)
[219.924517] [033/132] (801s left) gem_madvise (dontneed-before-pwrite)
[219.963730] Starting subtest: dontneed-before-pwrite
[219.990308] Subtest dontneed-before-pwrite: SKIP (0.026s)
[220.048457] [034/132] (801s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[220.139804] Starting subtest: primary-4-tiled-reflect-x-0
[227.100390] Subtest primary-4-tiled-reflect-x-0: SUCCESS (6.961s)
[228.275600] [035/132] (792s left) kms_flip (absolute-wf_vblank)
[228.385846] Starting subtest: absolute-wf_vblank
[228.387839] Starting dynamic subtest: A-eDP1
[237.167781] Dynamic subtest A-eDP1: SUCCESS (8.746s)
[237.183967] Starting dynamic subtest: B-eDP1
[245.887292] Dynamic subtest B-eDP1: SUCCESS (8.721s)
[245.896127] Starting dynamic subtest: C-eDP1
[254.622433] Dynamic subtest C-eDP1: SUCCESS (8.719s)
[254.631810] Starting dynamic subtest: D-eDP1
[263.358932] Dynamic subtest D-eDP1: SUCCESS (8.733s)
[263.361759] Subtest absolute-wf_vblank: SUCCESS (34.933s)
[264.541586] [036/132] (756s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[264.634159] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[264.636332] Starting dynamic subtest: pipe-A-default-mode
[265.797442] Dynamic subtest pipe-A-default-mode: SKIP (1.161s)
[265.801172] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.163s)
[265.961743] [037/132] (755s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[266.045082] Starting subtest: async-flip-with-page-flip-events-linear
[266.429499] Starting dynamic subtest: pipe-A-eDP-1
[269.298546] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.815s)
[269.619471] Starting dynamic subtest: pipe-B-eDP-1
[272.422974] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.758s)
[272.732092] Starting dynamic subtest: pipe-C-eDP-1
[275.548700] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.771s)
[275.854321] Starting dynamic subtest: pipe-D-eDP-1
[278.677924] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.768s)
[278.680637] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.574s)
[279.787558] [038/132] (741s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[279.889730] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[279.894437] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[280.030569] [039/132] (741s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[280.127611] Starting subtest: fbc-pr-cursor-plane-update-sf
[280.131785] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[280.197464] [040/132] (741s left) gem_softpin (full)
[280.250621] Starting subtest: full
[280.258337] Subtest full: SUCCESS (0.008s)
[280.389939] [041/132] (741s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[280.479334] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[280.481610] Starting dynamic subtest: pipe-A-eDP-1
[281.289732] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.802s)
[281.297193] Starting dynamic subtest: pipe-B-eDP-1
[282.800066] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.506s)
[282.809600] Starting dynamic subtest: pipe-C-eDP-1
[284.300035] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.498s)
[284.310519] Starting dynamic subtest: pipe-D-eDP-1
[285.754716] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.454s)
[285.756950] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.265s)
[286.923863] [042/132] (734s left) kms_cursor_crc (cursor-offscreen-128x42)
[287.148994] Starting subtest: cursor-offscreen-128x42
[287.191966] Subtest cursor-offscreen-128x42: SKIP (0.041s)
[287.398121] [043/132] (734s left) kms_color_pipeline (plane-ctm3x4)
[287.509150] Starting subtest: plane-ctm3x4
[287.643817] Starting dynamic subtest: pipe-A-plane-0
[287.950943] Dynamic subtest pipe-A-plane-0: FAIL (0.164s)
[287.960070] Starting dynamic subtest: pipe-A-plane-1
[288.133703] Dynamic subtest pipe-A-plane-1: FAIL (0.132s)
[288.141178] Starting dynamic subtest: pipe-A-plane-2
[288.341946] Dynamic subtest pipe-A-plane-2: FAIL (0.143s)
[289.310302] Starting dynamic subtest: pipe-B-plane-0
[289.701376] Dynamic subtest pipe-B-plane-0: FAIL (0.141s)
[289.709152] Starting dynamic subtest: pipe-B-plane-1
[290.004678] Dynamic subtest pipe-B-plane-1: FAIL (0.144s)
[290.013096] Starting dynamic subtest: pipe-B-plane-2
[290.314843] Dynamic subtest pipe-B-plane-2: FAIL (0.143s)
[290.956790] Starting dynamic subtest: pipe-C-plane-0
[291.406629] Dynamic subtest pipe-C-plane-0: FAIL (0.108s)
[291.416816] Starting dynamic subtest: pipe-C-plane-1
[291.802254] Dynamic subtest pipe-C-plane-1: FAIL (0.120s)
[291.809343] Starting dynamic subtest: pipe-C-plane-2
[292.160262] Dynamic subtest pipe-C-plane-2: FAIL (0.163s)
[292.978719] Starting dynamic subtest: pipe-D-plane-0
[293.550944] Dynamic subtest pipe-D-plane-0: FAIL (0.129s)
[293.560552] Starting dynamic subtest: pipe-D-plane-1
[294.000497] Dynamic subtest pipe-D-plane-1: FAIL (0.589s)
[294.009520] Starting dynamic subtest: pipe-D-plane-2
[294.434959] Dynamic subtest pipe-D-plane-2: FAIL (0.523s)
[294.512250] Subtest plane-ctm3x4: FAIL (7.005s)
[295.346075] [044/132] (726s left) gem_mmap (bad-size)
[295.402624] Subtest bad-size: SKIP (0.000s)
[295.453163] [045/132] (726s left) prime_vgem (basic-fence-mmap)
[295.613080] Starting subtest: basic-fence-mmap
[295.617791] Subtest basic-fence-mmap: SKIP (0.000s)
[295.705834] [FACT prime_vgem (basic-fence-mmap)] new: kernel.kmod_is_loaded.vgem: true
[295.711027] [046/132] (725s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[295.804604] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[295.808989] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[295.894272] [047/132] (725s left) kms_frontbuffer_tracking (psr-suspend)
[295.986760] Starting subtest: psr-suspend
[334.575451] Subtest psr-suspend: SUCCESS (8.033s)
[334.687580] [048/132] (686s left) gem_exec_params (cliprects-invalid)
[334.763499] Starting subtest: cliprects-invalid
[334.765940] Subtest cliprects-invalid: SUCCESS (0.000s)
[334.865198] [049/132] (686s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[334.954121] Starting subtest: stress-xrgb8888-xtiled
[340.766093] Subtest stress-xrgb8888-xtiled: SUCCESS (5.916s)
[340.816236] [050/132] (680s left) prime_self_import (reimport-vs-gem_close-race)
[340.853579] Starting subtest: reimport-vs-gem_close-race
[345.954762] Subtest reimport-vs-gem_close-race: SUCCESS (5.126s)
[346.034096] [051/132] (675s left) gem_mmap_gtt (hang)
[346.091824] Subtest hang: SKIP (0.000s)
[346.149747] [052/132] (675s left) gem_ctx_param (invalid-ctx-get)
[346.196200] Starting subtest: invalid-ctx-get
[346.198323] Subtest invalid-ctx-get: SUCCESS (0.000s)
[346.257925] [053/132] (675s left) syncobj_timeline (single-wait-signaled)
[346.305529] Starting subtest: single-wait-signaled
[346.307541] Subtest single-wait-signaled: SUCCESS (0.000s)
[346.401536] [054/132] (675s left) gem_exec_balancer (parallel)
[346.656489] Starting subtest: parallel
[347.586075] Subtest parallel: SUCCESS (0.934s)
[348.553678] [055/132] (673s left) kms_psr (fbc-psr-cursor-plane-move)
[348.669254] Starting subtest: fbc-psr-cursor-plane-move
[348.671436] Starting dynamic subtest: eDP-1
[348.675826] Dynamic subtest eDP-1: SKIP (0.000s)
[348.680015] Subtest fbc-psr-cursor-plane-move: SKIP (0.002s)
[348.751854] [056/132] (673s left) gem_ctx_engines (execute-one)
[348.811269] Starting subtest: execute-one
[351.258785] Subtest execute-one: SUCCESS (2.457s)
[351.568364] [057/132] (670s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[351.675843] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[351.680065] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[351.782379] [058/132] (670s left) syncobj_eventfd (timeline-wait)
[351.831899] Starting subtest: timeline-wait
[351.840532] Subtest timeline-wait: SUCCESS (0.011s)
[351.934806] [059/132] (670s left) gem_exec_fence (submit-chain)
[352.124210] Starting subtest: submit-chain
[352.141346] Subtest submit-chain: SUCCESS (0.018s)
[353.596970] [060/132] (668s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[353.672418] Starting subtest: map-fixed-invalidate-overlap-busy
[353.676642] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[353.793859] [061/132] (668s left) kms_fbcon_fbt (psr-suspend)
[353.843965] Starting subtest: psr-suspend
[403.043000] Subtest psr-suspend: SUCCESS (19.934s)
[403.120000] [062/132] (619s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[403.189721] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[403.192059] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[403.301221] [063/132] (618s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[403.391514] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[410.742995] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.424s)
[410.851109] [064/132] (611s left) kms_chamelium_color (ctm-blue-to-red)
[410.954160] Subtest ctm-blue-to-red: SKIP (0.000s)
[411.000351] [065/132] (611s left) core_setmaster (master-drop-set-user)
[411.100187] Starting subtest: master-drop-set-user
[411.113878] Subtest master-drop-set-user: SUCCESS (0.016s)
[411.152482] [066/132] (611s left) syncobj_wait (wait-all-complex)
[411.206885] Starting subtest: wait-all-complex
[411.421377] Subtest wait-all-complex: SUCCESS (0.215s)
[411.512475] [067/132] (610s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[411.562590] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[411.564956] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[411.658845] [068/132] (610s left) gem_exec_parallel (userptr)
[411.715702] Starting subtest: userptr
[411.718033] Starting dynamic subtest: rcs0
[413.173698] Dynamic subtest rcs0: SUCCESS (1.464s)
[413.184132] Starting dynamic subtest: bcs0
[414.652091] Dynamic subtest bcs0: SUCCESS (1.478s)
[414.661920] Starting dynamic subtest: vcs0
[418.068798] Dynamic subtest vcs0: SUCCESS (3.378s)
[418.080412] Starting dynamic subtest: vcs1
[420.005942] Dynamic subtest vcs1: SUCCESS (1.985s)
[420.018717] Starting dynamic subtest: vecs0
[421.985333] Dynamic subtest vecs0: SUCCESS (1.986s)
[421.995958] Starting dynamic subtest: ccs0
[423.472881] Dynamic subtest ccs0: SUCCESS (1.488s)
[423.475289] Subtest userptr: SUCCESS (11.791s)
[423.675601] [069/132] (598s left) kms_pm_rpm (pm-tiling)
[425.201680] Starting subtest: pm-tiling
[425.207176] Subtest pm-tiling: SKIP (0.000s)
[425.986882] [070/132] (596s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[426.083805] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[426.086200] Starting dynamic subtest: pipe-A-eDP-1
[426.167966] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[426.178291] Starting dynamic subtest: pipe-B-eDP-1
[427.352440] Dynamic subtest pipe-B-eDP-1: SKIP (1.183s)
[427.357249] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.273s)
[428.522310] [071/132] (594s left) kms_psr (psr2-cursor-mmap-gtt)
[428.612300] Starting subtest: psr2-cursor-mmap-gtt
[428.614543] Starting dynamic subtest: eDP-1
[430.303989] Dynamic subtest eDP-1: SUCCESS (1.690s)
[430.306606] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.691s)
[431.186745] [072/132] (591s left) i915_pm_rps (waitboost)
[431.248151] Starting subtest: waitboost
[437.589322] Subtest waitboost: SUCCESS (6.337s)
[437.669841] [073/132] (585s left) gem_ctx_persistence (hang)
[437.749992] Starting subtest: hang
[437.754726] Subtest hang: SKIP (0.000s)
[437.866605] [074/132] (584s left) kms_psr (fbc-psr2-sprite-blt)
[437.968869] Starting subtest: fbc-psr2-sprite-blt
[437.971141] Starting dynamic subtest: eDP-1
[437.975083] Dynamic subtest eDP-1: SKIP (0.000s)
[437.979113] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[438.040227] [075/132] (584s left) kms_lease (empty-lease)
[438.127844] Starting subtest: empty-lease
[438.130098] Starting dynamic subtest: pipe-A-eDP-1
[438.132386] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[438.144797] Starting dynamic subtest: pipe-B-eDP-1
[438.146668] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[438.154879] Starting dynamic subtest: pipe-C-eDP-1
[438.156736] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[438.164512] Starting dynamic subtest: pipe-D-eDP-1
[438.166407] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[438.168268] Subtest empty-lease: SUCCESS (0.009s)
[438.240990] [076/132] (584s left) syncobj_wait (wait-all-for-submit-complex)
[438.298905] Starting subtest: wait-all-for-submit-complex
[438.511782] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[438.584322] [077/132] (584s left) api_intel_bb (reset-bb)
[438.637222] Starting subtest: reset-bb
[438.639524] Subtest reset-bb: SUCCESS (0.004s)
[438.759798] [078/132] (584s left) kms_chamelium_hpd (hdmi-hpd-storm)
[439.145276] Subtest hdmi-hpd-storm: SKIP (0.000s)
[439.996085] [079/132] (582s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[440.092545] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[440.096641] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[440.197643] [080/132] (582s left) gem_exec_schedule (u-submit-late-slice)
[440.268605] Starting subtest: u-submit-late-slice
[440.270840] Starting dynamic subtest: rcs0
[440.295080] Dynamic subtest rcs0: SUCCESS (0.034s)
[440.307070] Starting dynamic subtest: bcs0
[440.330499] Dynamic subtest bcs0: SUCCESS (0.035s)
[440.339636] Starting dynamic subtest: vcs0
[440.359418] Dynamic subtest vcs0: SUCCESS (0.028s)
[440.368310] Starting dynamic subtest: vcs1
[440.390131] Dynamic subtest vcs1: SUCCESS (0.030s)
[440.399388] Starting dynamic subtest: vecs0
[440.417458] Dynamic subtest vecs0: SUCCESS (0.027s)
[440.426162] Starting dynamic subtest: ccs0
[440.448884] Dynamic subtest ccs0: SUCCESS (0.031s)
[440.451208] Subtest u-submit-late-slice: SUCCESS (0.188s)
[442.106635] [081/132] (580s left) kms_invalid_mode (int-max-clock)
[442.206070] Starting subtest: int-max-clock
[442.208272] Starting dynamic subtest: pipe-A-eDP-1
[442.497611] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s)
[442.509534] Starting dynamic subtest: pipe-B-eDP-1
[442.511791] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[442.520014] Starting dynamic subtest: pipe-C-eDP-1
[442.521983] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[442.529750] Starting dynamic subtest: pipe-D-eDP-1
[442.531736] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[442.533723] Subtest int-max-clock: SUCCESS (0.296s)
[443.346100] [082/132] (579s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[443.408161] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[443.482217] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.008s)
[443.521992] [083/132] (579s left) gem_exec_suspend (basic-s3)
[443.581125] Starting subtest: basic-S3
[443.583414] Starting dynamic subtest: smem
[463.959131] Dynamic subtest smem: SUCCESS (6.409s)
[463.961633] Subtest basic-S3: SUCCESS (6.411s)
[464.141814] [084/132] (558s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[464.267881] Starting subtest: verify-pxp-key-change-after-suspend-resume
[471.426854] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.270s)
[471.532397] [085/132] (551s left) gem_exec_schedule (pi-common)
[471.719745] Starting subtest: pi-common
[471.721971] Starting dynamic subtest: rcs0
[471.754490] Dynamic subtest rcs0: SUCCESS (0.038s)
[471.764099] Starting dynamic subtest: bcs0
[471.802723] Dynamic subtest bcs0: SUCCESS (0.048s)
[471.811617] Starting dynamic subtest: vcs0
[471.842906] Dynamic subtest vcs0: SUCCESS (0.040s)
[471.852096] Starting dynamic subtest: vcs1
[471.877610] Dynamic subtest vcs1: SUCCESS (0.034s)
[471.886136] Starting dynamic subtest: vecs0
[471.909405] Dynamic subtest vecs0: SUCCESS (0.031s)
[471.922588] Starting dynamic subtest: ccs0
[471.939144] Dynamic subtest ccs0: SUCCESS (0.029s)
[471.941358] Subtest pi-common: SUCCESS (0.225s)
[472.154910] [086/132] (551s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[472.262241] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[472.266197] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[472.369516] [087/132] (550s left) gem_exec_balancer (parallel-contexts)
[472.624158] Starting subtest: parallel-contexts
[475.321750] Subtest parallel-contexts: SUCCESS (2.715s)
[476.115965] [088/132] (547s left) i915_hangman (gt-engine-error)
[476.176203] Starting subtest: gt-engine-error
[476.178246] Starting dynamic subtest: rcs0
[478.006893] Dynamic subtest rcs0: SUCCESS (1.839s)
[478.022412] Starting dynamic subtest: bcs0
[479.998055] Dynamic subtest bcs0: SUCCESS (1.986s)
[480.010695] Starting dynamic subtest: vcs0
[481.974656] Dynamic subtest vcs0: SUCCESS (1.989s)
[481.985924] Starting dynamic subtest: vcs1
[484.022279] Dynamic subtest vcs1: SUCCESS (2.049s)
[484.033959] Starting dynamic subtest: vecs0
[486.007235] Dynamic subtest vecs0: SUCCESS (1.986s)
[486.021313] Starting dynamic subtest: ccs0
[487.925832] Dynamic subtest ccs0: SUCCESS (1.919s)
[487.928606] Subtest gt-engine-error: SUCCESS (11.785s)
[488.055680] [089/132] (535s left) kms_cursor_crc (cursor-random-512x512)
[488.318669] Starting subtest: cursor-random-512x512
[488.323265] Subtest cursor-random-512x512: SKIP (0.001s)
[488.488063] [090/132] (534s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[488.584973] Starting subtest: fb-8bpc-vs-panel-6bpc
[488.587178] Starting dynamic subtest: pipe-A-eDP-1
[490.054677] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.472s)
[490.057203] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.473s)
[490.929988] [091/132] (532s left) perf_pmu (busy-start)
[490.968621] Starting subtest: busy-start
[490.970628] Starting dynamic subtest: rcs0
[493.519037] Dynamic subtest rcs0: SUCCESS (2.554s)
[493.531517] Starting dynamic subtest: bcs0
[496.090976] Dynamic subtest bcs0: SUCCESS (2.550s)
[496.103087] Starting dynamic subtest: vcs0
[500.055762] Dynamic subtest vcs0: SUCCESS (3.985s)
[500.068295] Starting dynamic subtest: vcs1
[504.023637] Dynamic subtest vcs1: SUCCESS (3.966s)
[504.036076] Starting dynamic subtest: vecs0
[508.055797] Dynamic subtest vecs0: SUCCESS (4.027s)
[508.068360] Starting dynamic subtest: ccs0
[510.622866] Dynamic subtest ccs0: SUCCESS (2.546s)
[510.625537] Subtest busy-start: SUCCESS (19.642s)
[510.714038] [092/132] (512s left) gem_fence_thrash (bo-write-verify-threaded-x)
[510.752545] Starting subtest: bo-write-verify-threaded-x
[510.766490] Subtest bo-write-verify-threaded-x: SKIP (0.013s)
[510.830141] [093/132] (512s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[510.936844] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[510.940926] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[511.038756] [094/132] (512s left) kms_flip (2x-plain-flip-interruptible)
[511.136492] Starting subtest: 2x-plain-flip-interruptible
[511.148674] Subtest 2x-plain-flip-interruptible: SKIP (0.011s)
[511.234888] [095/132] (512s left) gem_exec_reloc (basic-cpu-wc-active)
[511.292129] Subtest basic-cpu-wc-active: SKIP (0.000s)
[511.377004] [096/132] (512s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[511.480104] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[511.482428] Starting dynamic subtest: pipe-A-eDP-1
[511.537974] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[511.548198] Starting dynamic subtest: pipe-B-eDP-1
[511.602755] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[511.612934] Starting dynamic subtest: pipe-C-eDP-1
[511.659762] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[511.668971] Starting dynamic subtest: pipe-D-eDP-1
[511.714883] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[511.718456] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[513.781053] [097/132] (509s left) kms_vrr (lobf)
[513.867956] Starting subtest: lobf
[513.873212] Subtest lobf: SKIP (0.000s)
[513.969596] [098/132] (509s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[514.061433] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[514.065734] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[514.154795] [099/132] (509s left) kms_busy (extended-modeset-hang-oldfb)
[514.257066] Starting subtest: extended-modeset-hang-oldfb
[514.259269] Starting dynamic subtest: pipe-A
[526.421938] Dynamic subtest pipe-A: SUCCESS (12.161s)
[526.431899] Starting dynamic subtest: pipe-D
[538.980823] Dynamic subtest pipe-D: SUCCESS (12.560s)
[538.983351] Subtest extended-modeset-hang-oldfb: SUCCESS (24.726s)
[539.777909] [100/132] (484s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[539.845383] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[539.849677] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[540.027655] [101/132] (483s left) sw_sync (sync_multi_producer_single_consumer)
[540.067450] Starting subtest: sync_multi_producer_single_consumer
[541.141623] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[541.217115] [102/132] (482s left) kms_content_protection (dp-mst-type-1)
[541.349097] Starting subtest: dp-mst-type-1
[541.353615] Subtest dp-mst-type-1: SKIP (0.000s)
[541.469212] [103/132] (482s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[541.576727] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[545.126769] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.555s)
[546.261475] [104/132] (477s left) gem_ctx_isolation (preservation-reset)
[546.444957] Starting subtest: preservation-reset
[546.447700] Starting dynamic subtest: rcs0
[546.681312] Dynamic subtest rcs0: SUCCESS (0.239s)
[546.691311] Starting dynamic subtest: bcs0
[546.980591] Dynamic subtest bcs0: SUCCESS (0.298s)
[546.991717] Starting dynamic subtest: vcs0
[547.253526] Dynamic subtest vcs0: SUCCESS (0.272s)
[547.264401] Starting dynamic subtest: vcs1
[549.287429] Dynamic subtest vcs1: SUCCESS (2.033s)
[549.302562] Starting dynamic subtest: vecs0
[551.264996] Dynamic subtest vecs0: SUCCESS (1.978s)
[551.278007] Starting dynamic subtest: ccs0
[553.299249] Dynamic subtest ccs0: SUCCESS (2.034s)
[553.301689] Subtest preservation-reset: SUCCESS (6.862s)
[553.416582] [105/132] (470s left) gem_userptr_blits (probe)
[553.486209] Starting subtest: probe
[553.563556] Subtest probe: SUCCESS (0.077s)
[553.682503] [106/132] (470s left) kms_rotation_crc (exhaust-fences)
[553.772928] Starting subtest: exhaust-fences
[553.777260] Subtest exhaust-fences: SKIP (0.000s)
[553.843897] [107/132] (470s left) kms_feature_discovery (display-4x)
[553.942964] Starting subtest: display-4x
[553.947291] Subtest display-4x: SKIP (0.000s)
[554.029954] [108/132] (470s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[554.120061] Starting subtest: psr-farfromfence-mmap-gtt
[554.123543] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[554.230176] [109/132] (469s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[554.329880] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[560.923967] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.598s)
[561.024262] [110/132] (463s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[561.136746] Starting subtest: y-tiled-64bpp-rotate-0
[561.141186] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[561.235112] [111/132] (463s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[561.350631] Starting subtest: cursorA-vs-flipB-legacy
[561.355925] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[561.497598] [112/132] (462s left) kms_pm_lpsp (screens-disabled)
[562.587294] Starting subtest: screens-disabled
[562.591270] Subtest screens-disabled: SKIP (0.000s)
[562.661585] [113/132] (461s left) syncobj_wait (reset-signaled)
[562.715711] Starting subtest: reset-signaled
[562.717896] Subtest reset-signaled: SUCCESS (0.000s)
[562.802861] [114/132] (461s left) i915_drm_fdinfo (memory-info-resident)
[562.848088] Starting subtest: memory-info-resident
[562.850259] Starting dynamic subtest: smem0
[565.344727] Dynamic subtest smem0: SUCCESS (2.499s)
[565.346756] Subtest memory-info-resident: SUCCESS (2.500s)
[565.416506] [115/132] (458s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[565.477279] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[565.479505] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[565.637224] [116/132] (458s left) i915_pm_rpm (gem-evict-pwrite)
[567.178789] Starting subtest: gem-evict-pwrite
[567.183623] Subtest gem-evict-pwrite: SKIP (0.000s)
[567.913651] [117/132] (456s left) gem_eio (in-flight-internal-immediate)
[568.113953] Starting subtest: in-flight-internal-immediate
[570.067719] Subtest in-flight-internal-immediate: SUCCESS (1.951s)
[570.181781] [118/132] (454s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[570.278603] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[570.283105] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[570.352839] [119/132] (454s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[570.447436] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[570.449855] Starting dynamic subtest: pipe-A-eDP-1
[587.306846] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.406s)
[587.316821] Starting dynamic subtest: pipe-B-eDP-1
[604.228253] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.404s)
[604.238612] Starting dynamic subtest: pipe-C-eDP-1
[621.187702] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.318s)
[621.197815] Starting dynamic subtest: pipe-D-eDP-1
[638.229714] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.380s)
[638.232117] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.514s)
[639.431191] [120/132] (385s left) vgem_basic (dmabuf-mmap)
[639.477208] Starting subtest: dmabuf-mmap
[639.524155] Subtest dmabuf-mmap: SUCCESS (0.051s)
[639.579848] [121/132] (385s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[639.689210] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[639.694481] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[639.786787] [122/132] (384s left) gem_exec_async (forked-writes)
[639.844764] Starting subtest: forked-writes
[639.847446] Starting dynamic subtest: rcs0
[639.874008] Dynamic subtest rcs0: SUCCESS (0.029s)
[639.886274] Starting dynamic subtest: bcs0
[639.895972] Dynamic subtest bcs0: SUCCESS (0.022s)
[639.915477] Starting dynamic subtest: vcs0
[639.923121] Dynamic subtest vcs0: SUCCESS (0.022s)
[639.942186] Starting dynamic subtest: vcs1
[639.945170] Dynamic subtest vcs1: SUCCESS (0.021s)
[639.956307] Starting dynamic subtest: vecs0
[639.964159] Dynamic subtest vecs0: SUCCESS (0.021s)
[639.975018] Starting dynamic subtest: ccs0
[639.985598] Dynamic subtest ccs0: SUCCESS (0.021s)
[639.988532] Subtest forked-writes: SUCCESS (0.143s)
[640.215328] [123/132] (384s left) gem_exec_alignment (single)
[640.278453] Starting subtest: single
[640.281321] Subtest single: SUCCESS (0.002s)
[640.395644] [124/132] (384s left) api_intel_allocator (reserve-simple)
[640.443898] Starting subtest: reserve-simple
[640.446319] Subtest reserve-simple: SUCCESS (0.003s)
[640.541293] [125/132] (384s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[640.588644] Starting subtest: multi-wait-for-submit-available-signaled
[640.591341] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s)
[640.688827] [126/132] (384s left) gen7_exec_parse (batch-without-end)
[640.743693] Subtest batch-without-end: SKIP (0.000s)
[640.815805] [127/132] (384s left) kms_vblank (wait-forked-busy-hang)
[640.895417] Starting subtest: wait-forked-busy-hang
[640.897944] Starting dynamic subtest: pipe-A-eDP-1
[667.181982] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.438s)
[667.198601] Starting dynamic subtest: pipe-D-eDP-1
[682.227062] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.057s)
[682.230142] Subtest wait-forked-busy-hang: SUCCESS (41.500s)
[683.103088] [128/132] (341s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[683.215700] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[684.215095] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.001s)
[684.394952] [129/132] (340s left) gen3_render_mixed_blits
[684.508571] [130/132] (340s left) kms_psr (fbc-pr-primary-mmap-gtt)
[684.598184] Starting subtest: fbc-pr-primary-mmap-gtt
[684.603031] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[684.679369] [131/132] (340s left) kms_cursor_crc (cursor-suspend)
[684.793759] Starting subtest: cursor-suspend
[684.796095] Starting dynamic subtest: pipe-A-eDP-1
[717.564138] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.195s)
[717.574786] Starting dynamic subtest: pipe-D-eDP-1
[751.537859] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.751s)
[751.540095] Subtest cursor-suspend: SUCCESS (6.949s)
[752.328561] [132/132] (272s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[752.433521] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[753.501721] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.090s)
[753.606759] Closing watchdogs
results: parsing output: 0/ for test: gem_sync
results: parsing output: 1/ for test: gem_mmap_gtt
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: prime_self_import
results: parsing output: 4/ for test: gem_readwrite
results: parsing output: 5/ for test: gem_exec_parallel
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_exec_schedule
results: parsing output: 8/ for test: kms_plane_multiple
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_lmem_swapping
results: parsing output: 12/ for test: gem_mmap_wc
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: kms_big_fb
results: parsing output: 17/ for test: kms_plane
results: parsing output: 18/ for test: syncobj_wait
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_mmap_wc
results: parsing output: 21/ for test: kms_vblank
results: parsing output: 22/ for test: gem_partial_pwrite_pread
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_plane
results: parsing output: 25/ for test: gem_ccs
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: kms_plane_scaling
results: parsing output: 28/ for test: kms_flip
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: kms_chamelium_frames
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: gem_madvise
results: parsing output: 33/ for test: kms_rotation_crc
results: parsing output: 34/ for test: kms_flip
results: parsing output: 35/ for test: kms_flip_scaled_crc
results: parsing output: 36/ for test: kms_async_flips
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_psr2_sf
results: parsing output: 39/ for test: gem_softpin
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: kms_cursor_crc
results: parsing output: 42/ for test: kms_color_pipeline
results: parsing output: 43/ for test: gem_mmap
results: parsing output: 44/ for test: prime_vgem
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: gem_exec_params
results: parsing output: 48/ for test: kms_pipe_stress
results: parsing output: 49/ for test: prime_self_import
results: parsing output: 50/ for test: gem_mmap_gtt
results: parsing output: 51/ for test: gem_ctx_param
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: gem_exec_balancer
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: gem_ctx_engines
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: syncobj_eventfd
results: parsing output: 58/ for test: gem_exec_fence
results: parsing output: 59/ for test: gem_userptr_blits
results: parsing output: 60/ for test: kms_fbcon_fbt
results: parsing output: 61/ for test: syncobj_wait
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_chamelium_color
results: parsing output: 64/ for test: core_setmaster
results: parsing output: 65/ for test: syncobj_wait
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: gem_exec_parallel
results: parsing output: 68/ for test: kms_pm_rpm
results: parsing output: 69/ for test: kms_psr2_sf
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: i915_pm_rps
results: parsing output: 72/ for test: gem_ctx_persistence
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: kms_lease
results: parsing output: 75/ for test: syncobj_wait
results: parsing output: 76/ for test: api_intel_bb
results: parsing output: 77/ for test: kms_chamelium_hpd
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_exec_schedule
results: parsing output: 80/ for test: kms_invalid_mode
results: parsing output: 81/ for test: sriov_basic
results: parsing output: 82/ for test: gem_exec_suspend
results: parsing output: 83/ for test: gem_pxp
results: parsing output: 84/ for test: gem_exec_schedule
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_exec_balancer
results: parsing output: 87/ for test: i915_hangman
results: parsing output: 88/ for test: kms_cursor_crc
results: parsing output: 89/ for test: kms_dither
results: parsing output: 90/ for test: perf_pmu
results: parsing output: 91/ for test: gem_fence_thrash
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_flip
results: parsing output: 94/ for test: gem_exec_reloc
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: kms_vrr
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_busy
results: parsing output: 99/ for test: gem_render_copy
results: parsing output: 100/ for test: sw_sync
results: parsing output: 101/ for test: kms_content_protection
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_ctx_isolation
results: parsing output: 104/ for test: gem_userptr_blits
results: parsing output: 105/ for test: kms_rotation_crc
results: parsing output: 106/ for test: kms_feature_discovery
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: kms_cursor_legacy
results: parsing output: 111/ for test: kms_pm_lpsp
results: parsing output: 112/ for test: syncobj_wait
results: parsing output: 113/ for test: i915_drm_fdinfo
results: parsing output: 114/ for test: syncobj_wait
results: parsing output: 115/ for test: i915_pm_rpm
results: parsing output: 116/ for test: gem_eio
results: parsing output: 117/ for test: kms_flip_scaled_crc
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: vgem_basic
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_exec_async
results: parsing output: 122/ for test: gem_exec_alignment
results: parsing output: 123/ for test: api_intel_allocator
results: parsing output: 124/ for test: syncobj_timeline
results: parsing output: 125/ for test: gen7_exec_parse
results: parsing output: 126/ for test: kms_vblank
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: gen3_render_mixed_blits
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: kms_cursor_crc
results: parsing output: 131/ for test: kms_big_fb
Done.