[56.975564] Initializing watchdogs
[56.975649]   /dev/watchdog0
[56.995455] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[57.006194] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[57.010307] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.012734] [001/131] (960s left) kms_addfb_basic (invalid-set-prop)
[57.085975] Starting subtest: invalid-set-prop
[57.086898] Subtest invalid-set-prop: SUCCESS (0.000s)
[57.365106] [002/131] (960s left) gem_exec_params (invalid-fence-in)
[57.445465] Starting subtest: invalid-fence-in
[57.446449] Subtest invalid-fence-in: SUCCESS (0.000s)
[57.579728] [003/131] (960s left) kms_psr2_su (page_flip-p010)
[57.652097] Subtest page_flip-P010: SKIP (0.000s)
[57.712700] [004/131] (959s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[57.900200] Starting subtest: coverage-vs-premult-vs-constant
[58.170402] Starting dynamic subtest: pipe-A-DP-3
[58.687499] Dynamic subtest pipe-A-DP-3: SUCCESS (0.508s)
[58.698392] Starting dynamic subtest: pipe-D-DP-3
[59.270123] Dynamic subtest pipe-D-DP-3: SUCCESS (0.573s)
[59.270901] Subtest coverage-vs-premult-vs-constant: SUCCESS (1.349s)
[59.562194] [005/131] (958s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[59.755209] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[59.756183] Starting dynamic subtest: pipe-A-DP-3
[59.764865] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[59.772329] Starting dynamic subtest: pipe-B-DP-3
[59.781083] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[59.788470] Starting dynamic subtest: pipe-C-DP-3
[59.796990] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[59.804273] Starting dynamic subtest: pipe-D-DP-3
[59.814549] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[59.816544] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[60.214124] [006/131] (957s left) kms_content_protection (dp-mst-type-0)
[60.472295] Starting subtest: dp-mst-type-0
[60.474172] Subtest dp-mst-type-0: SKIP (0.000s)
[60.658973] [007/131] (957s left) gem_ctx_engines (independent)
[60.743870] Starting subtest: independent
[60.744821] Starting dynamic subtest: rcs0
[60.918039] Dynamic subtest rcs0: SUCCESS (0.172s)
[60.925742] Starting dynamic subtest: bcs0
[61.078062] Dynamic subtest bcs0: SUCCESS (0.158s)
[61.085827] Starting dynamic subtest: vcs0
[61.251259] Dynamic subtest vcs0: SUCCESS (0.171s)
[61.259073] Starting dynamic subtest: vcs1
[61.422328] Dynamic subtest vcs1: SUCCESS (0.169s)
[61.430162] Starting dynamic subtest: vecs0
[61.595744] Dynamic subtest vecs0: SUCCESS (0.171s)
[61.603474] Starting dynamic subtest: vecs1
[61.765343] Dynamic subtest vecs1: SUCCESS (0.168s)
[61.773151] Starting dynamic subtest: ccs0
[61.953374] Dynamic subtest ccs0: SUCCESS (0.186s)
[61.961466] Starting dynamic subtest: all-engines
[62.402427] Dynamic subtest all-engines: SUCCESS (0.444s)
[62.403379] Subtest independent: SUCCESS (1.641s)
[63.043528] [008/131] (954s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[63.233518] Starting subtest: cursor-vs-flip-atomic
[94.323470] Subtest cursor-vs-flip-atomic: SUCCESS (31.035s)
[94.583124] [009/131] (923s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[94.786619] Starting subtest: y-tiled-8bpp-rotate-270
[94.788280] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[94.914528] [010/131] (923s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[95.113939] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[95.115542] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[95.243854] [011/131] (922s left) kms_pm_dc (dc5-dpms-negative)
[96.436958] Starting subtest: dc5-dpms-negative
[100.665566] Subtest dc5-dpms-negative: SUCCESS (4.228s)
[100.755332] [012/131] (917s left) kms_flip (2x-blocking-wf_vblank)
[100.945967] Starting subtest: 2x-blocking-wf_vblank
[100.960631] Subtest 2x-blocking-wf_vblank: SKIP (0.014s)
[101.053397] [013/131] (917s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[101.241195] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[101.242148] Starting dynamic subtest: pipe-A-valid-mode
[101.338553] Dynamic subtest pipe-A-valid-mode: SKIP (0.095s)
[101.340500] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.096s)
[101.548793] [014/131] (916s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[101.742618] Starting subtest: psr-modesetfrombusy
[101.744377] Subtest psr-modesetfrombusy: SKIP (0.000s)
[101.873831] [015/131] (916s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[102.071945] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[102.820567] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.748s)
[103.056170] [016/131] (915s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[103.254137] Starting subtest: yf-tiled-addfb-size-overflow
[103.255716] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[103.392501] [017/131] (915s left) gem_softpin (32b-excludes-last-page)
[103.467393] Starting subtest: 32b-excludes-last-page
[103.472073] Subtest 32b-excludes-last-page: SUCCESS (0.004s)
[103.648527] [018/131] (914s left) kms_fbcon_fbt (psr)
[103.722166] Starting subtest: psr
[103.723989] Subtest psr: SKIP (0.000s)
[103.885794] [019/131] (914s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[103.960856] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[104.050019] [020/131] (914s left) gem_userptr_blits (probe)
[104.144443] Starting subtest: probe
[104.262300] Subtest probe: SUCCESS (0.118s)
[104.410421] [021/131] (914s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[104.599720] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[104.601383] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[104.718319] [022/131] (914s left) gem_ctx_bad_destroy (invalid-default-ctx)
[104.791385] Starting subtest: invalid-default-ctx
[104.792385] Subtest invalid-default-ctx: SUCCESS (0.000s)
[104.932793] [023/131] (914s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[105.132083] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[106.236076] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (1.104s)
[106.430742] [024/131] (912s left) syncobj_timeline (signal)
[106.498965] Starting subtest: signal
[106.499912] Subtest signal: SUCCESS (0.000s)
[106.661478] [025/131] (912s left) core_sysfs (read-all-entries)
[106.729912] Starting subtest: read-all-entries
[106.733201] Subtest read-all-entries: SUCCESS (0.004s)
[106.853340] [026/131] (912s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[107.047301] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[107.089507] [027/131] (912s left) syncobj_wait (wait-any-interrupted)
[107.158829] Starting subtest: wait-any-interrupted
[107.268838] Subtest wait-any-interrupted: SUCCESS (0.108s)
[107.426906] [028/131] (911s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[107.625791] Starting subtest: fbcpsr-2p-rte
[107.628166] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[107.763618] [029/131] (911s left) gem_close_race (multigpu-basic-threads)
[107.867017] Starting subtest: multigpu-basic-threads
[107.869197] Subtest multigpu-basic-threads: SKIP (0.000s)
[108.127484] [030/131] (911s left) kms_big_fb (linear-64bpp-rotate-180)
[108.326076] Starting subtest: linear-64bpp-rotate-180
[110.385862] Subtest linear-64bpp-rotate-180: SUCCESS (2.060s)
[110.555519] [031/131] (908s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[110.741467] Starting subtest: cursorA-vs-flipA-atomic
[121.712942] Subtest cursorA-vs-flipA-atomic: SUCCESS (10.970s)
[122.000417] [032/131] (897s left) i915_pm_rc6_residency (rc6-idle)
[122.066011] Starting subtest: rc6-idle
[122.085158] Starting dynamic subtest: gt0-rcs0
[146.514743] Dynamic subtest gt0-rcs0: SUCCESS (24.430s)
[146.528083] Starting dynamic subtest: gt0-bcs0
[170.915685] Dynamic subtest gt0-bcs0: SUCCESS (24.400s)
[170.924790] Starting dynamic subtest: gt0-vcs0
[195.367816] Dynamic subtest gt0-vcs0: SUCCESS (24.451s)
[195.381053] Starting dynamic subtest: gt0-vecs0
[219.768722] Dynamic subtest gt0-vecs0: SUCCESS (24.401s)
[219.777894] Starting dynamic subtest: gt0-ccs0
[244.232058] Dynamic subtest gt0-ccs0: SUCCESS (24.462s)
[244.234058] Subtest rc6-idle: SUCCESS (122.168s)
[244.448964] [033/131] (775s left) prime_self_import (export-vs-gem_close-race)
[244.491241] Starting subtest: export-vs-gem_close-race
[249.572344] Subtest export-vs-gem_close-race: SUCCESS (5.080s)
[249.689579] [034/131] (770s left) perf (invalid-create-userspace-config)
[250.101910] Starting subtest: invalid-create-userspace-config
[250.104038] Subtest invalid-create-userspace-config: SUCCESS (0.002s)
[250.154586] [035/131] (769s left) perf (non-sampling-read-error)
[250.348532] Starting subtest: non-sampling-read-error
[250.367874] Subtest non-sampling-read-error: SUCCESS (0.019s)
[250.421568] [036/131] (769s left) i915_drm_fdinfo (virtual-busy-idle-all)
[250.482138] Starting subtest: virtual-busy-idle-all
[250.483951] Subtest virtual-busy-idle-all: SKIP (0.000s)
[250.592574] [037/131] (769s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[250.787838] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[250.789523] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[250.917118] [038/131] (769s left) gem_mmap_gtt (cpuset-big-copy-odd)
[250.987981] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[251.060663] [039/131] (768s left) gem_exec_balancer (individual)
[251.141429] Starting subtest: individual
[253.175494] Subtest individual: SUCCESS (2.034s)
[253.563532] [040/131] (766s left) kms_sequence (get-busy)
[253.755149] Starting subtest: get-busy
[253.756054] Starting dynamic subtest: pipe-A-DP-3
[256.339200] Dynamic subtest pipe-A-DP-3: SUCCESS (2.583s)
[256.349180] Starting dynamic subtest: pipe-B-DP-3
[258.814439] Dynamic subtest pipe-B-DP-3: SUCCESS (2.475s)
[258.825501] Starting dynamic subtest: pipe-C-DP-3
[261.292322] Dynamic subtest pipe-C-DP-3: SUCCESS (2.477s)
[261.301368] Starting dynamic subtest: pipe-D-DP-3
[263.773472] Dynamic subtest pipe-D-DP-3: SUCCESS (2.480s)
[263.774430] Subtest get-busy: SUCCESS (10.019s)
[264.030318] [041/131] (756s left) gem_ctx_param (set-priority-not-supported)
[264.099622] Starting subtest: set-priority-not-supported
[264.101414] Subtest set-priority-not-supported: SKIP (0.000s)
[264.192358] [042/131] (755s left) kms_async_flips (async-flip-suspend-resume)
[264.381377] Starting subtest: async-flip-suspend-resume
[264.613601] Starting dynamic subtest: pipe-A-DP-3
[284.461747] Dynamic subtest pipe-A-DP-3: SUCCESS (4.982s)
[284.683830] Starting dynamic subtest: pipe-B-DP-3
[305.436449] Dynamic subtest pipe-B-DP-3: SUCCESS (4.569s)
[305.608567] Starting dynamic subtest: pipe-C-DP-3
[325.347695] Dynamic subtest pipe-C-DP-3: SUCCESS (4.506s)
[325.535380] Starting dynamic subtest: pipe-D-DP-3
[345.336830] Dynamic subtest pipe-D-DP-3: SUCCESS (4.558s)
[345.337662] Subtest async-flip-suspend-resume: SUCCESS (19.405s)
[345.737406] [043/131] (674s left) kms_hdr (static-toggle)
[345.926948] Starting subtest: static-toggle
[349.314340] Starting dynamic subtest: pipe-A-DP-3
[350.459235] Dynamic subtest pipe-A-DP-3: SUCCESS (1.146s)
[350.460491] Subtest static-toggle: SUCCESS (4.533s)
[350.790971] [044/131] (669s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[350.869119] Starting subtest: legacy-engines-hostile-preempt
[350.870059] Starting dynamic subtest: render
[350.985060] Dynamic subtest render: SUCCESS (0.114s)
[351.001876] Starting dynamic subtest: bsd1
[351.041850] Dynamic subtest bsd1: SUCCESS (0.054s)
[351.062679] Starting dynamic subtest: bsd2
[351.086065] Dynamic subtest bsd2: SUCCESS (0.043s)
[351.115236] Starting dynamic subtest: blt
[351.147978] Dynamic subtest blt: SUCCESS (0.060s)
[351.191678] Starting dynamic subtest: vebox
[351.217959] Dynamic subtest vebox: SUCCESS (0.068s)
[351.219183] Subtest legacy-engines-hostile-preempt: SUCCESS (0.349s)
[351.391207] [045/131] (669s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[351.580021] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[351.580999] Starting dynamic subtest: pipe-A-DP-3
[355.128770] Dynamic subtest pipe-A-DP-3: SUCCESS (3.532s)
[355.143715] Starting dynamic subtest: pipe-B-DP-3
[355.715416] Dynamic subtest pipe-B-DP-3: SUCCESS (0.579s)
[355.740010] Starting dynamic subtest: pipe-C-DP-3
[356.316880] Dynamic subtest pipe-C-DP-3: SUCCESS (0.596s)
[356.344793] Starting dynamic subtest: pipe-D-DP-3
[356.918330] Dynamic subtest pipe-D-DP-3: SUCCESS (0.596s)
[356.920039] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SUCCESS (5.322s)
[357.321507] [046/131] (663s left) gem_workarounds (suspend-resume)
[357.412141] Starting subtest: suspend-resume
[376.501244] Subtest suspend-resume: SUCCESS (3.750s)
[377.643144] [047/131] (643s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[377.836574] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[377.838346] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[378.004216] [048/131] (643s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[378.082124] Subtest writes-after-reads-uncached: SKIP (0.000s)
[378.179970] [049/131] (643s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[378.377469] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[378.379041] Subtest psr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[378.513234] [050/131] (643s left) kms_color (invalid-ctm-matrix-sizes)
[378.700851] Starting subtest: invalid-ctm-matrix-sizes
[378.701796] Starting dynamic subtest: pipe-A
[378.703931] Dynamic subtest pipe-A: SUCCESS (0.003s)
[378.714774] Starting dynamic subtest: pipe-B
[378.715716] Dynamic subtest pipe-B: SUCCESS (0.005s)
[378.726621] Starting dynamic subtest: pipe-C
[378.727755] Dynamic subtest pipe-C: SUCCESS (0.005s)
[378.738737] Starting dynamic subtest: pipe-D
[378.739670] Dynamic subtest pipe-D: SUCCESS (0.006s)
[378.740502] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.021s)
[378.836839] [051/131] (642s left) perf_pmu (semaphore-busy)
[378.900310] Starting subtest: semaphore-busy
[378.901307] Starting dynamic subtest: rcs0
[380.576902] Dynamic subtest rcs0: SUCCESS (1.673s)
[380.591035] Starting dynamic subtest: bcs0
[382.221796] Dynamic subtest bcs0: SUCCESS (1.642s)
[382.237393] Starting dynamic subtest: vcs0
[382.857958] Dynamic subtest vcs0: FAIL (0.597s)
[382.870740] Starting dynamic subtest: vcs1
[383.418917] Dynamic subtest vcs1: FAIL (0.573s)
[383.432685] Starting dynamic subtest: vecs0
[383.992468] Dynamic subtest vecs0: FAIL (0.569s)
[384.005987] Starting dynamic subtest: vecs1
[384.566443] Dynamic subtest vecs1: FAIL (0.570s)
[384.594599] Starting dynamic subtest: ccs0
[385.139021] Dynamic subtest ccs0: FAIL (0.575s)
[385.139973] Subtest semaphore-busy: FAIL (6.217s)
[385.316821] [052/131] (636s left) kms_lease (empty-lease)
[385.504857] Starting subtest: empty-lease
[385.505810] Starting dynamic subtest: pipe-A-DP-3
[385.507853] Dynamic subtest pipe-A-DP-3: SUCCESS (0.002s)
[385.520633] Starting dynamic subtest: pipe-B-DP-3
[385.521622] Dynamic subtest pipe-B-DP-3: SUCCESS (0.002s)
[385.533065] Starting dynamic subtest: pipe-C-DP-3
[385.534032] Dynamic subtest pipe-C-DP-3: SUCCESS (0.002s)
[385.544862] Starting dynamic subtest: pipe-D-DP-3
[385.545804] Dynamic subtest pipe-D-DP-3: SUCCESS (0.002s)
[385.546710] Subtest empty-lease: SUCCESS (0.013s)
[385.637270] [053/131] (636s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[386.142514] Starting subtest: cursor-rapid-movement-max-size
[386.145935] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[386.365253] [054/131] (635s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[386.555389] Starting subtest: fbcpsr-indfb-scaledprimary
[386.557014] Subtest fbcpsr-indfb-scaledprimary: SKIP (0.000s)
[386.705688] [055/131] (635s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[386.897160] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[386.912538] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.014s)
[387.009640] [056/131] (635s left) gem_wait (wait)
[387.093343] Starting subtest: wait
[387.094328] Starting dynamic subtest: all-engines
[388.200163] Dynamic subtest all-engines: SUCCESS (1.106s)
[388.214301] Starting dynamic subtest: rcs0
[389.256508] Dynamic subtest rcs0: SUCCESS (1.054s)
[389.273051] Starting dynamic subtest: bcs0
[390.314721] Dynamic subtest bcs0: SUCCESS (1.055s)
[390.331173] Starting dynamic subtest: vcs0
[391.379822] Dynamic subtest vcs0: SUCCESS (1.055s)
[391.420773] Starting dynamic subtest: vcs1
[392.432557] Dynamic subtest vcs1: SUCCESS (1.057s)
[392.451187] Starting dynamic subtest: vecs0
[393.490544] Dynamic subtest vecs0: SUCCESS (1.055s)
[393.510043] Starting dynamic subtest: vecs1
[394.549278] Dynamic subtest vecs1: SUCCESS (1.056s)
[394.594591] Starting dynamic subtest: ccs0
[395.608227] Dynamic subtest ccs0: SUCCESS (1.056s)
[395.610101] Subtest wait: SUCCESS (8.516s)
[395.869240] [057/131] (626s left) gem_mmap_offset (clear)
[395.936708] Starting subtest: clear
[395.937696] Starting dynamic subtest: lmem0
[421.796074] Dynamic subtest lmem0: SUCCESS (25.856s)
[421.817456] Starting dynamic subtest: smem0
[447.787578] Dynamic subtest smem0: SUCCESS (25.997s)
[447.789103] Subtest clear: SUCCESS (51.854s)
[448.095143] [058/131] (574s left) gem_eio (in-flight-internal-immediate)
[448.459940] Starting subtest: in-flight-internal-immediate
[449.746737] Subtest in-flight-internal-immediate: SUCCESS (1.287s)
[449.985334] [059/131] (572s left) gem_exec_capture (userptr)
[450.062730] Starting subtest: userptr
[451.037983] Subtest userptr: SUCCESS (0.975s)
[451.171505] [060/131] (571s left) gem_ctx_persistence (engines-mixed-process)
[451.251135] Starting subtest: engines-mixed-process
[451.252033] Starting dynamic subtest: rcs0
[452.759754] Dynamic subtest rcs0: SUCCESS (1.508s)
[452.773348] Starting dynamic subtest: bcs0
[454.738539] Dynamic subtest bcs0: SUCCESS (1.978s)
[454.752160] Starting dynamic subtest: vcs0
[456.786492] Dynamic subtest vcs0: SUCCESS (2.047s)
[456.800058] Starting dynamic subtest: vcs1
[458.771340] Dynamic subtest vcs1: SUCCESS (1.984s)
[458.784705] Starting dynamic subtest: vecs0
[460.759588] Dynamic subtest vecs0: SUCCESS (1.987s)
[460.773128] Starting dynamic subtest: vecs1
[462.806544] Dynamic subtest vecs1: SUCCESS (2.046s)
[462.820130] Starting dynamic subtest: ccs0
[464.777326] Dynamic subtest ccs0: SUCCESS (1.970s)
[464.778537] Subtest engines-mixed-process: SUCCESS (13.527s)
[464.884100] [061/131] (557s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[465.076640] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[465.078314] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[465.208457] [062/131] (557s left) sysfs_heartbeat_interval (precise)
[465.282818] Starting subtest: precise
[465.283735] Starting dynamic subtest: vecs0
[468.023719] Dynamic subtest vecs0: SUCCESS (2.740s)
[468.036910] Starting dynamic subtest: ccs0
[469.620687] Dynamic subtest ccs0: SUCCESS (1.596s)
[469.633620] Starting dynamic subtest: vcs0
[472.028902] Dynamic subtest vcs0: SUCCESS (2.407s)
[472.041775] Starting dynamic subtest: bcs0
[473.486786] Dynamic subtest bcs0: SUCCESS (1.457s)
[473.499455] Starting dynamic subtest: vecs1
[474.954668] Dynamic subtest vecs1: SUCCESS (1.467s)
[474.967488] Starting dynamic subtest: rcs0
[476.428902] Dynamic subtest rcs0: SUCCESS (1.473s)
[476.441905] Starting dynamic subtest: vcs1
[477.855627] Dynamic subtest vcs1: SUCCESS (1.426s)
[477.856548] Subtest precise: SUCCESS (12.572s)
[478.001895] [063/131] (544s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[478.198461] Starting subtest: stress-xrgb8888-ytiled
[478.200151] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[478.280015] [064/131] (544s left) syncobj_wait (reset-during-wait-for-submit)
[478.359984] Starting subtest: reset-during-wait-for-submit
[478.463429] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[478.630195] [065/131] (544s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[478.825491] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[478.827212] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[478.960628] [066/131] (543s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[479.157047] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[479.214539] [067/131] (543s left) kms_cursor_crc (cursor-onscreen-128x42)
[479.615059] Starting subtest: cursor-onscreen-128x42
[479.620162] Starting dynamic subtest: pipe-A-DP-3
[482.311282] Dynamic subtest pipe-A-DP-3: SUCCESS (2.689s)
[482.352476] Starting dynamic subtest: pipe-D-DP-3
[485.103909] Dynamic subtest pipe-D-DP-3: SUCCESS (2.762s)
[485.104910] Subtest cursor-onscreen-128x42: SUCCESS (5.488s)
[485.498387] [068/131] (537s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[485.685984] Starting subtest: fb-8bpc-vs-panel-6bpc
[485.688446] Starting dynamic subtest: pipe-A-DP-3
[486.081369] Dynamic subtest pipe-A-DP-3: SUCCESS (0.393s)
[486.082705] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (0.396s)
[486.320552] [069/131] (536s left) kms_flip (2x-flip-vs-suspend)
[486.507578] Starting subtest: 2x-flip-vs-suspend
[486.522545] Subtest 2x-flip-vs-suspend: SKIP (0.014s)
[486.623399] [070/131] (536s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[486.700013] Starting subtest: yf-tiled-ccs-to-x-tiled
[486.702104] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[486.952400] [071/131] (536s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[487.140971] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[487.143357] Starting dynamic subtest: pipe-A-DP-3
[487.151773] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[487.164126] Starting dynamic subtest: pipe-B-DP-3
[487.172741] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[487.184796] Starting dynamic subtest: pipe-C-DP-3
[487.193236] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[487.205378] Starting dynamic subtest: pipe-D-DP-3
[487.216647] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[487.219040] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SKIP (0.006s)
[487.634100] [072/131] (535s left) prime_mmap (test_dup)
[487.721345] Starting subtest: test_dup
[487.722258] Starting dynamic subtest: test_dup-smem
[487.767892] Dynamic subtest test_dup-smem: SUCCESS (0.046s)
[487.780315] Starting dynamic subtest: test_dup-lmem0
[487.963074] Dynamic subtest test_dup-lmem0: SUCCESS (0.194s)
[487.964071] Subtest test_dup: SUCCESS (0.242s)
[488.053781] [073/131] (535s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[488.775022] Starting subtest: syncobj-timeline-multiple-ext-nodes
[488.777292] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.002s)
[489.119917] [FACT gem_exec_fence (syncobj-timeline-multiple-ext-nodes)] new: kernel.kmod_is_loaded.vgem: true
[489.122135] [074/131] (534s left) drm_read (short-buffer-block)
[489.389912] Starting subtest: short-buffer-block
[489.390812] Subtest short-buffer-block: SUCCESS (0.000s)
[489.622474] [075/131] (533s left) kms_psr (fbc-psr2-sprite-plane-move)
[489.824715] Subtest fbc-psr2-sprite-plane-move: SKIP (0.000s)
[489.908685] [076/131] (533s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[490.119908] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[490.121711] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[490.274223] [077/131] (533s left) gem_exec_whisper (basic-queues-priority-all)
[490.371014] Starting subtest: basic-queues-priority-all
[512.337996] Subtest basic-queues-priority-all: SUCCESS (21.964s)
[512.582687] [078/131] (511s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[512.662776] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[512.663909] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[512.830121] [079/131] (510s left) kms_addfb_basic (too-wide)
[513.027033] Starting subtest: too-wide
[513.028083] Subtest too-wide: SUCCESS (0.000s)
[513.159812] [080/131] (510s left) kms_chamelium_edid (vga-edid-read)
[513.436560] Subtest vga-edid-read: SKIP (0.000s)
[513.597748] [081/131] (510s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[513.683603] Subtest tiled-to-tiled: SKIP (0.000s)
[513.749136] [082/131] (510s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[514.035780] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[514.199320] [083/131] (509s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[514.400506] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[514.415984] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.015s)
[514.539683] [084/131] (509s left) i915_drm_fdinfo (busy-idle-check-all)
[514.609001] Starting subtest: busy-idle-check-all
[514.609944] Starting dynamic subtest: rcs0
[514.638971] Dynamic subtest rcs0: SKIP (0.029s)
[514.652457] Starting dynamic subtest: bcs0
[514.654705] Dynamic subtest bcs0: SKIP (0.001s)
[514.667583] Starting dynamic subtest: vcs0
[514.669918] Dynamic subtest vcs0: SKIP (0.001s)
[514.682983] Starting dynamic subtest: vcs1
[514.685972] Dynamic subtest vcs1: SKIP (0.000s)
[514.699291] Starting dynamic subtest: vecs0
[514.701552] Dynamic subtest vecs0: SKIP (0.000s)
[514.714120] Starting dynamic subtest: vecs1
[514.716028] Dynamic subtest vecs1: SKIP (0.001s)
[514.728593] Starting dynamic subtest: ccs0
[514.730864] Dynamic subtest ccs0: SKIP (0.001s)
[514.733266] Subtest busy-idle-check-all: SKIP (0.037s)
[514.780490] [085/131] (509s left) gem_ctx_sseu (mmap-args)
[514.885133] Subtest mmap-args: SKIP (0.000s)
[514.977397] [086/131] (509s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[515.175561] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[515.177388] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[515.310513] [087/131] (508s left) i915_pm_rps (reset)
[515.398320] Starting subtest: reset
[519.201125] Subtest reset: SUCCESS (3.803s)
[519.382474] [088/131] (504s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[519.581116] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[519.583442] Starting dynamic subtest: pipe-A-valid-mode
[519.663907] Dynamic subtest pipe-A-valid-mode: SKIP (0.080s)
[519.665789] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.082s)
[519.879378] [089/131] (504s left) kms_vblank (wait-busy-hang)
[520.076042] Starting subtest: wait-busy-hang
[520.078508] Starting dynamic subtest: pipe-A-DP-3
[546.468717] Dynamic subtest pipe-A-DP-3: SUCCESS (26.390s)
[546.485190] Starting dynamic subtest: pipe-D-DP-3
[571.467973] Dynamic subtest pipe-D-DP-3: SUCCESS (24.995s)
[571.468949] Subtest wait-busy-hang: SUCCESS (51.391s)
[571.731666] [090/131] (452s left) gem_exec_schedule (semaphore-user)
[571.823108] Starting subtest: semaphore-user
[571.908864] Subtest semaphore-user: SUCCESS (0.086s)
[572.337650] [091/131] (452s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[572.536608] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[572.538427] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[572.699901] [092/131] (451s left) gem_userptr_blits (unsync-unmap)
[572.786588] Subtest unsync-unmap: SKIP (0.000s)
[572.977869] [093/131] (451s left) gem_exec_schedule (independent)
[573.065043] Starting subtest: independent
[573.065966] Starting dynamic subtest: rcs0
[573.498143] Dynamic subtest rcs0: SUCCESS (0.432s)
[573.512332] Starting dynamic subtest: bcs0
[573.890259] Dynamic subtest bcs0: SUCCESS (0.391s)
[573.923753] Starting dynamic subtest: vcs0
[574.294898] Dynamic subtest vcs0: SUCCESS (0.403s)
[574.309585] Starting dynamic subtest: vcs1
[574.676167] Dynamic subtest vcs1: SUCCESS (0.380s)
[574.694599] Starting dynamic subtest: vecs0
[575.056931] Dynamic subtest vecs0: SUCCESS (0.379s)
[575.074603] Starting dynamic subtest: vecs1
[575.437898] Dynamic subtest vecs1: SUCCESS (0.380s)
[575.451317] Starting dynamic subtest: ccs0
[575.782106] Dynamic subtest ccs0: SUCCESS (0.343s)
[575.783218] Subtest independent: SUCCESS (2.718s)
[576.149965] [094/131] (448s left) gem_exec_schedule (u-submit-early-slice)
[576.242868] Starting subtest: u-submit-early-slice
[576.243822] Starting dynamic subtest: rcs0
[576.317279] Dynamic subtest rcs0: SUCCESS (0.074s)
[576.330343] Starting dynamic subtest: bcs0
[576.369890] Dynamic subtest bcs0: SUCCESS (0.052s)
[576.383049] Starting dynamic subtest: vcs0
[576.422797] Dynamic subtest vcs0: SUCCESS (0.052s)
[576.435923] Starting dynamic subtest: vcs1
[576.474696] Dynamic subtest vcs1: SUCCESS (0.051s)
[576.488130] Starting dynamic subtest: vecs0
[576.525722] Dynamic subtest vecs0: SUCCESS (0.050s)
[576.538838] Starting dynamic subtest: vecs1
[576.576792] Dynamic subtest vecs1: SUCCESS (0.050s)
[576.589803] Starting dynamic subtest: ccs0
[576.628306] Dynamic subtest ccs0: SUCCESS (0.050s)
[576.629179] Subtest u-submit-early-slice: SUCCESS (0.386s)
[577.097574] [095/131] (447s left) gem_media_vme
[577.272462] [096/131] (447s left) gem_mmap_gtt (basic-small-copy-odd)
[577.354062] Subtest basic-small-copy-odd: SKIP (0.000s)
[577.423809] [097/131] (447s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[577.621579] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[577.623429] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[577.778145] [098/131] (447s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[577.977564] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[577.979259] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[578.136086] [099/131] (447s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[578.216010] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[578.321351] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.104s)
[578.475292] [100/131] (446s left) prime_vgem (wait)
[578.565490] Starting subtest: wait
[578.566465] Starting dynamic subtest: rcs0
[578.640687] Dynamic subtest rcs0: SUCCESS (0.075s)
[578.654344] Starting dynamic subtest: bcs0
[578.683024] Dynamic subtest bcs0: SUCCESS (0.041s)
[578.696423] Starting dynamic subtest: vcs0
[578.725057] Dynamic subtest vcs0: SUCCESS (0.041s)
[578.741414] Starting dynamic subtest: vcs1
[578.766563] Dynamic subtest vcs1: SUCCESS (0.040s)
[578.787657] Starting dynamic subtest: vecs0
[578.807615] Dynamic subtest vecs0: SUCCESS (0.040s)
[578.828642] Starting dynamic subtest: vecs1
[578.848380] Dynamic subtest vecs1: SUCCESS (0.040s)
[578.869437] Starting dynamic subtest: ccs0
[578.888296] Dynamic subtest ccs0: SUCCESS (0.038s)
[578.889279] Subtest wait: SUCCESS (0.323s)
[579.075949] [101/131] (446s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[579.273998] Starting subtest: primary-y-tiled-reflect-x-0
[579.379577] Subtest primary-y-tiled-reflect-x-0: SKIP (0.103s)
[579.561752] [102/131] (445s left) gem_exec_reloc (basic-gtt-wc)
[579.643945] Subtest basic-gtt-wc: SKIP (0.000s)
[579.751927] [103/131] (445s left) kms_writeback (writeback-invalid-parameters)
[579.946460] Subtest writeback-invalid-parameters: SKIP (0.000s)
[580.007987] [104/131] (445s left) gem_mmap_gtt (fault-concurrent)
[580.086773] Subtest fault-concurrent: SKIP (0.000s)
[580.176357] [105/131] (445s left) kms_psr (fbc-psr-sprite-render)
[580.374704] Subtest fbc-psr-sprite-render: SKIP (0.000s)
[580.440092] [106/131] (445s left) kms_prime (basic-crc-hybrid)
[580.638955] Subtest basic-crc-hybrid: SKIP (0.000s)
[580.766951] [107/131] (444s left) fbdev (read)
[580.827860] Starting subtest: read
[583.707644] Subtest read: SUCCESS (2.879s)
[583.795684] [108/131] (441s left) kms_sequence (get-forked-busy)
[583.992045] Starting subtest: get-forked-busy
[583.994580] Starting dynamic subtest: pipe-A-DP-3
[586.629120] Dynamic subtest pipe-A-DP-3: SUCCESS (2.634s)
[586.656656] Starting dynamic subtest: pipe-B-DP-3
[589.216422] Dynamic subtest pipe-B-DP-3: SUCCESS (2.584s)
[589.268968] Starting dynamic subtest: pipe-C-DP-3
[591.845033] Dynamic subtest pipe-C-DP-3: SUCCESS (2.624s)
[591.868487] Starting dynamic subtest: pipe-D-DP-3
[594.428133] Dynamic subtest pipe-D-DP-3: SUCCESS (2.578s)
[594.429593] Subtest get-forked-busy: SUCCESS (10.435s)
[594.754067] [109/131] (431s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[594.952628] Starting subtest: addfb25-y-tiled-small-legacy
[594.954418] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[595.102430] [110/131] (430s left) kms_cdclk (plane-scaling)
[595.298041] Starting subtest: plane-scaling
[595.298978] Starting dynamic subtest: pipe-A-DP-3
[595.381810] Dynamic subtest pipe-A-DP-3: SKIP (0.081s)
[595.398049] Starting dynamic subtest: pipe-B-DP-3
[595.399908] Dynamic subtest pipe-B-DP-3: SKIP (0.003s)
[595.413090] Starting dynamic subtest: pipe-C-DP-3
[595.414812] Dynamic subtest pipe-C-DP-3: SKIP (0.003s)
[595.427673] Starting dynamic subtest: pipe-D-DP-3
[595.429251] Dynamic subtest pipe-D-DP-3: SKIP (0.002s)
[595.430755] Subtest plane-scaling: SKIP (0.095s)
[595.608623] [111/131] (430s left) api_intel_bb (lot-of-buffers)
[595.687920] Starting subtest: lot-of-buffers
[598.932405] Subtest lot-of-buffers: SUCCESS (3.244s)
[599.145902] [112/131] (426s left) gem_mmap_gtt (basic-small-bo)
[599.226903] Subtest basic-small-bo: SKIP (0.000s)
[599.297510] [113/131] (426s left) gem_mmap_wc (copy)
[599.376694] Subtest copy: SKIP (0.000s)
[599.451505] [114/131] (426s left) syncobj_timeline (invalid-signal-illegal-handle)
[599.534764] Starting subtest: invalid-signal-illegal-handle
[599.535727] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[599.736096] [115/131] (426s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[599.934065] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[599.934914] Starting dynamic subtest: pipe-A
[600.035247] Dynamic subtest pipe-A: SUCCESS (0.100s)
[600.061596] Starting dynamic subtest: pipe-B
[600.285625] Dynamic subtest pipe-B: SUCCESS (0.249s)
[600.298692] Starting dynamic subtest: pipe-C
[600.485923] Dynamic subtest pipe-C: SUCCESS (0.199s)
[600.507257] Starting dynamic subtest: pipe-D
[600.721522] Dynamic subtest pipe-D: SUCCESS (0.234s)
[600.722418] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (0.788s)
[601.048053] [116/131] (425s left) kms_psr (psr2-sprite-plane-move)
[601.245596] Subtest psr2-sprite-plane-move: SKIP (0.000s)
[601.302231] [117/131] (425s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[601.503672] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[601.505438] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[601.658279] [118/131] (424s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[601.854046] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[601.856382] Starting dynamic subtest: pipe-A-DP-3
[601.864023] Dynamic subtest pipe-A-DP-3: SUCCESS (0.001s)
[601.877432] Starting dynamic subtest: pipe-B-DP-3
[601.885041] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[601.898106] Starting dynamic subtest: pipe-C-DP-3
[601.905687] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[601.918951] Starting dynamic subtest: pipe-D-DP-3
[601.928005] Dynamic subtest pipe-D-DP-3: SUCCESS (0.000s)
[601.929100] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SUCCESS (0.008s)
[602.377417] [119/131] (424s left) gem_pxp (create-regular-buffer)
[604.991028] Starting subtest: create-regular-buffer
[604.992961] Subtest create-regular-buffer: SKIP (0.000s)
[605.102251] [120/131] (421s left) kms_psr (pr-sprite-plane-move)
[605.298658] Subtest pr-sprite-plane-move: SKIP (0.000s)
[605.370092] [121/131] (421s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-cpu)
[605.576550] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-cpu
[605.578336] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[605.718699] [122/131] (421s left) syncobj_timeline (wait-any-complex)
[605.800866] Starting subtest: wait-any-complex
[605.863786] Subtest wait-any-complex: SUCCESS (0.063s)
[606.008378] [123/131] (420s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[606.215397] Starting subtest: 4-tiled-16bpp-rotate-0
[608.007871] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.791s)
[608.163045] [124/131] (418s left) kms_plane (plane-position-hole-dpms)
[608.357045] Starting subtest: plane-position-hole-dpms
[608.807092] Starting dynamic subtest: pipe-A-plane-1
[609.498421] Dynamic subtest pipe-A-plane-1: SUCCESS (0.691s)
[609.519426] Starting dynamic subtest: pipe-A-plane-2
[610.220485] Dynamic subtest pipe-A-plane-2: SUCCESS (0.719s)
[610.238585] Starting dynamic subtest: pipe-A-plane-3
[610.932081] Dynamic subtest pipe-A-plane-3: SUCCESS (0.711s)
[610.949727] Starting dynamic subtest: pipe-A-plane-4
[611.618752] Dynamic subtest pipe-A-plane-4: SUCCESS (0.686s)
[611.632453] Starting dynamic subtest: pipe-A-plane-5
[611.642224] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[611.994973] Starting dynamic subtest: pipe-B-plane-1
[612.623750] Dynamic subtest pipe-B-plane-1: SUCCESS (0.643s)
[612.637312] Starting dynamic subtest: pipe-B-plane-2
[613.266335] Dynamic subtest pipe-B-plane-2: SUCCESS (0.641s)
[613.290300] Starting dynamic subtest: pipe-B-plane-3
[613.936975] Dynamic subtest pipe-B-plane-3: SUCCESS (0.668s)
[613.950578] Starting dynamic subtest: pipe-B-plane-4
[614.592786] Dynamic subtest pipe-B-plane-4: SUCCESS (0.655s)
[614.606813] Starting dynamic subtest: pipe-B-plane-5
[614.615135] Dynamic subtest pipe-B-plane-5: SUCCESS (0.021s)
[614.615962] Subtest plane-position-hole-dpms: SUCCESS (6.257s)
[614.873304] [125/131] (412s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[615.073577] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[615.075357] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[615.236043] [126/131] (411s left) kms_frontbuffer_tracking (fbc-stridechange)
[615.434712] Starting subtest: fbc-stridechange
[619.053885] Subtest fbc-stridechange: FAIL (3.268s)
[619.131669] [127/131] (408s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[619.332522] Starting subtest: basic-busy-flip-before-cursor-varying-size
[619.334234] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[619.438391] [128/131] (407s left) gem_request_retire (retire-vma-not-inactive)
[619.521482] Starting subtest: retire-vma-not-inactive
[619.605282] Subtest retire-vma-not-inactive: SUCCESS (0.084s)
[619.781483] [129/131] (407s left) gem_ppgtt (blt-vs-render-ctxn)
[619.865461] Starting subtest: blt-vs-render-ctxN
[652.594090] Subtest blt-vs-render-ctxN: SUCCESS (32.726s)
[652.778296] [130/131] (374s left) kms_flip (modeset-vs-vblank-race-interruptible)
[653.040651] Starting subtest: modeset-vs-vblank-race-interruptible
[653.045420] Starting dynamic subtest: A-DP3
[656.246055] Dynamic subtest A-DP3: SUCCESS (3.200s)
[656.292464] Starting dynamic subtest: B-DP3
[659.462760] Dynamic subtest B-DP3: SUCCESS (3.210s)
[659.513979] Starting dynamic subtest: C-DP3
[662.640144] Dynamic subtest C-DP3: SUCCESS (3.172s)
[662.685800] Starting dynamic subtest: D-DP3
[665.834906] Dynamic subtest D-DP3: SUCCESS (3.189s)
[665.843230] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (12.801s)
[666.219404] [131/131] (361s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[666.892114] Starting subtest: syncobj-backward-timeline-chain-engines
[667.068530] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.177s)
[667.382367] Closing watchdogs
results: parsing output: 0/ for test: kms_addfb_basic
results: parsing output: 1/ for test: gem_exec_params
results: parsing output: 2/ for test: kms_psr2_su
results: parsing output: 3/ for test: kms_plane_alpha_blend
results: parsing output: 4/ for test: kms_ccs
results: parsing output: 5/ for test: kms_content_protection
results: parsing output: 6/ for test: gem_ctx_engines
results: parsing output: 7/ for test: kms_cursor_legacy
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_pm_dc
results: parsing output: 11/ for test: kms_flip
results: parsing output: 12/ for test: kms_flip_scaled_crc
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: gem_softpin
results: parsing output: 17/ for test: kms_fbcon_fbt
results: parsing output: 18/ for test: gem_exec_flush
results: parsing output: 19/ for test: gem_userptr_blits
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_ctx_bad_destroy
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: core_sysfs
results: parsing output: 25/ for test: kms_psr2_sf
results: parsing output: 26/ for test: syncobj_wait
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_close_race
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_cursor_legacy
results: parsing output: 31/ for test: i915_pm_rc6_residency
results: parsing output: 32/ for test: prime_self_import
results: parsing output: 33/ for test: perf
results: parsing output: 34/ for test: perf
results: parsing output: 35/ for test: i915_drm_fdinfo
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_mmap_gtt
results: parsing output: 38/ for test: gem_exec_balancer
results: parsing output: 39/ for test: kms_sequence
results: parsing output: 40/ for test: gem_ctx_param
results: parsing output: 41/ for test: kms_async_flips
results: parsing output: 42/ for test: kms_hdr
results: parsing output: 43/ for test: gem_ctx_persistence
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: gem_workarounds
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: gem_partial_pwrite_pread
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_color
results: parsing output: 50/ for test: perf_pmu
results: parsing output: 51/ for test: kms_lease
results: parsing output: 52/ for test: kms_cursor_crc
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_flip
results: parsing output: 55/ for test: gem_wait
results: parsing output: 56/ for test: gem_mmap_offset
results: parsing output: 57/ for test: gem_eio
results: parsing output: 58/ for test: gem_exec_capture
results: parsing output: 59/ for test: gem_ctx_persistence
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: sysfs_heartbeat_interval
results: parsing output: 62/ for test: kms_pipe_stress
results: parsing output: 63/ for test: syncobj_wait
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_psr2_sf
results: parsing output: 66/ for test: kms_cursor_crc
results: parsing output: 67/ for test: kms_dither
results: parsing output: 68/ for test: kms_flip
results: parsing output: 69/ for test: gem_render_copy
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: prime_mmap
results: parsing output: 72/ for test: gem_exec_fence
results: parsing output: 73/ for test: drm_read
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: gem_exec_whisper
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: kms_addfb_basic
results: parsing output: 79/ for test: kms_chamelium_edid
results: parsing output: 80/ for test: gem_set_tiling_vs_blt
results: parsing output: 81/ for test: kms_chamelium_hpd
results: parsing output: 82/ for test: kms_flip
results: parsing output: 83/ for test: i915_drm_fdinfo
results: parsing output: 84/ for test: gem_ctx_sseu
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: i915_pm_rps
results: parsing output: 87/ for test: kms_flip_scaled_crc
results: parsing output: 88/ for test: kms_vblank
results: parsing output: 89/ for test: gem_exec_schedule
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_userptr_blits
results: parsing output: 92/ for test: gem_exec_schedule
results: parsing output: 93/ for test: gem_exec_schedule
results: parsing output: 94/ for test: gem_media_vme
results: parsing output: 95/ for test: gem_mmap_gtt
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: syncobj_timeline
results: parsing output: 99/ for test: prime_vgem
results: parsing output: 100/ for test: kms_rotation_crc
results: parsing output: 101/ for test: gem_exec_reloc
results: parsing output: 102/ for test: kms_writeback
results: parsing output: 103/ for test: gem_mmap_gtt
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: kms_prime
results: parsing output: 106/ for test: fbdev
results: parsing output: 107/ for test: kms_sequence
results: parsing output: 108/ for test: kms_addfb_basic
results: parsing output: 109/ for test: kms_cdclk
results: parsing output: 110/ for test: api_intel_bb
results: parsing output: 111/ for test: gem_mmap_gtt
results: parsing output: 112/ for test: gem_mmap_wc
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_plane_scaling
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: gem_pxp
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: kms_plane
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_cursor_legacy
results: parsing output: 127/ for test: gem_request_retire
results: parsing output: 128/ for test: gem_ppgtt
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: gem_exec_fence
Done.