[59.531067] Initializing watchdogs
[59.531131]   /dev/watchdog0
[59.550638] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[59.561494] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[59.565393] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.567788] [001/131] (960s left) kms_frontbuffer_tracking (fbc-2p-rte)
[59.770947] Starting subtest: fbc-2p-rte
[59.772565] Subtest fbc-2p-rte: SKIP (0.000s)
[59.887436] [002/131] (960s left) i915_hangman (gt-error-state-capture)
[59.979626] Starting subtest: gt-error-state-capture
[59.980449] Starting dynamic subtest: rcs0
[70.110512] Dynamic subtest rcs0: SUCCESS (10.096s)
[70.121599] Starting dynamic subtest: bcs0
[80.071425] Dynamic subtest bcs0: SUCCESS (9.950s)
[80.080478] Starting dynamic subtest: vcs0
[90.099403] Dynamic subtest vcs0: SUCCESS (10.021s)
[90.107723] Starting dynamic subtest: vcs1
[100.071648] Dynamic subtest vcs1: SUCCESS (9.968s)
[100.079594] Starting dynamic subtest: vecs0
[110.072435] Dynamic subtest vecs0: SUCCESS (9.998s)
[110.080488] Starting dynamic subtest: vecs1
[120.075745] Dynamic subtest vecs1: SUCCESS (10.001s)
[120.089975] Starting dynamic subtest: ccs0
[130.076560] Dynamic subtest ccs0: SUCCESS (9.999s)
[130.077588] Subtest gt-error-state-capture: SUCCESS (70.036s)
[130.254589] [003/131] (889s left) kms_getfb (getfb2-handle-closed)
[130.444446] Starting subtest: getfb2-handle-closed
[130.445322] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[130.579224] [004/131] (889s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[130.772617] Subtest psr2-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[130.814490] [005/131] (889s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[130.882253] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[130.950473] [006/131] (889s left) i915_pm_rps (thresholds-idle)
[131.025466] Starting subtest: thresholds-idle
[131.027252] Subtest thresholds-idle: SKIP (0.000s)
[131.136999] [007/131] (889s left) kms_properties (plane-properties-legacy)
[131.324170] Starting subtest: plane-properties-legacy
[131.325119] Starting dynamic subtest: pipe-A-DP-3
[131.872744] Dynamic subtest pipe-A-DP-3: SUCCESS (0.547s)
[131.887513] Starting dynamic subtest: pipe-B-DP-3
[132.405409] Dynamic subtest pipe-B-DP-3: SUCCESS (0.531s)
[132.414619] Starting dynamic subtest: pipe-C-DP-3
[132.929198] Dynamic subtest pipe-C-DP-3: SUCCESS (0.522s)
[132.937539] Starting dynamic subtest: pipe-D-DP-3
[133.468250] Dynamic subtest pipe-D-DP-3: SUCCESS (0.539s)
[133.469179] Subtest plane-properties-legacy: SUCCESS (2.144s)
[133.725423] [008/131] (886s left) sysfs_heartbeat_interval (invalid)
[133.802940] Starting subtest: invalid
[133.803850] Starting dynamic subtest: vecs0
[133.804677] Dynamic subtest vecs0: SUCCESS (0.000s)
[133.813230] Starting dynamic subtest: ccs0
[133.814522] Dynamic subtest ccs0: SUCCESS (0.000s)
[133.822637] Starting dynamic subtest: vcs0
[133.823783] Dynamic subtest vcs0: SUCCESS (0.000s)
[133.831569] Starting dynamic subtest: bcs0
[133.832739] Dynamic subtest bcs0: SUCCESS (0.000s)
[133.840628] Starting dynamic subtest: vecs1
[133.841649] Dynamic subtest vecs1: SUCCESS (0.000s)
[133.852258] Starting dynamic subtest: rcs0
[133.853173] Dynamic subtest rcs0: SUCCESS (0.000s)
[133.861137] Starting dynamic subtest: vcs1
[133.862362] Dynamic subtest vcs1: SUCCESS (0.000s)
[133.863621] Subtest invalid: SUCCESS (0.004s)
[133.902021] [009/131] (886s left) kms_chamelium_color (ctm-max)
[134.091470] Subtest ctm-max: SKIP (0.000s)
[134.153317] [010/131] (886s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[134.340145] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[134.341050] Starting dynamic subtest: pipe-A-DP-3
[141.250320] Dynamic subtest pipe-A-DP-3: SUCCESS (6.908s)
[141.264037] Starting dynamic subtest: pipe-B-DP-3
[142.867720] Dynamic subtest pipe-B-DP-3: SUCCESS (1.614s)
[142.903600] Starting dynamic subtest: pipe-C-DP-3
[144.482932] Dynamic subtest pipe-C-DP-3: SUCCESS (1.611s)
[144.498210] Starting dynamic subtest: pipe-D-DP-3
[146.081755] Dynamic subtest pipe-D-DP-3: SUCCESS (1.594s)
[146.083603] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SUCCESS (11.740s)
[146.442510] [011/131] (874s left) gem_ctx_persistence (engines-mixed-process)
[146.524457] Starting subtest: engines-mixed-process
[146.525395] Starting dynamic subtest: rcs0
[147.898890] Dynamic subtest rcs0: SUCCESS (1.374s)
[147.907978] Starting dynamic subtest: bcs0
[149.889629] Dynamic subtest bcs0: SUCCESS (1.990s)
[149.899818] Starting dynamic subtest: vcs0
[151.870312] Dynamic subtest vcs0: SUCCESS (1.981s)
[151.880636] Starting dynamic subtest: vcs1
[153.907804] Dynamic subtest vcs1: SUCCESS (2.037s)
[153.917171] Starting dynamic subtest: vecs0
[155.900863] Dynamic subtest vecs0: SUCCESS (1.993s)
[155.910573] Starting dynamic subtest: vecs1
[157.890871] Dynamic subtest vecs1: SUCCESS (1.990s)
[157.900079] Starting dynamic subtest: ccs0
[159.870243] Dynamic subtest ccs0: SUCCESS (1.979s)
[159.871437] Subtest engines-mixed-process: SUCCESS (13.346s)
[159.972914] [012/131] (860s left) gem_exec_capture (capture-invisible)
[160.052753] Starting subtest: capture-invisible
[160.053635] Starting dynamic subtest: lmem0
[160.055379] Dynamic subtest lmem0: SKIP (0.000s)
[160.064496] Starting dynamic subtest: smem0
[160.066579] Dynamic subtest smem0: SKIP (0.000s)
[160.068574] Subtest capture-invisible: SKIP (0.000s)
[160.204029] [013/131] (860s left) syncobj_eventfd (invalid-bad-flags)
[160.273933] Starting subtest: invalid-bad-flags
[160.274732] Subtest invalid-bad-flags: SUCCESS (0.000s)
[160.442059] [014/131] (860s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[160.628105] Starting subtest: plane-downscale-factor-0-5-with-rotation
[160.628898] Starting dynamic subtest: pipe-A
[161.013431] Dynamic subtest pipe-A: SUCCESS (0.385s)
[161.030472] Starting dynamic subtest: pipe-B
[161.495936] Dynamic subtest pipe-B: SUCCESS (0.482s)
[161.514554] Starting dynamic subtest: pipe-C
[161.978949] Dynamic subtest pipe-C: SUCCESS (0.482s)
[161.993320] Starting dynamic subtest: pipe-D
[162.459697] Dynamic subtest pipe-D: SUCCESS (0.481s)
[162.460555] Subtest plane-downscale-factor-0-5-with-rotation: SUCCESS (1.832s)
[162.768438] [015/131] (858s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[162.957221] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[162.958160] Starting dynamic subtest: pipe-A-DP-3
[162.966698] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[162.975477] Starting dynamic subtest: pipe-B-DP-3
[162.983927] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[162.992481] Starting dynamic subtest: pipe-C-DP-3
[163.000746] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[163.009173] Starting dynamic subtest: pipe-D-DP-3
[163.020081] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[163.022122] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.004s)
[163.438067] [016/131] (857s left) kms_content_protection (dp-mst-type-1)
[163.691517] Starting subtest: dp-mst-type-1
[163.693295] Subtest dp-mst-type-1: SKIP (0.000s)
[163.860563] [017/131] (857s left) gem_mmap_gtt (medium-copy)
[163.930070] Subtest medium-copy: SKIP (0.000s)
[163.997552] [018/131] (857s left) kms_frontbuffer_tracking (fbc-suspend)
[164.192590] Starting subtest: fbc-suspend
[204.603930] Subtest fbc-suspend: SUCCESS (10.841s)
[204.834064] [019/131] (816s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[205.030600] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[205.032319] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[205.149435] [020/131] (816s left) gem_eio (wait-wedge-1us)
[205.428400] Starting subtest: wait-wedge-1us
[206.462397] Subtest wait-wedge-1us: SUCCESS (1.036s)
[206.673977] [021/131] (814s left) kms_pm_rpm (cursor-dpms)
[208.604218] Starting subtest: cursor-dpms
[208.607581] Subtest cursor-dpms: SKIP (0.000s)
[208.992631] [022/131] (812s left) gem_partial_pwrite_pread (writes-after-reads-display)
[209.068333] Subtest writes-after-reads-display: SKIP (0.000s)
[209.136538] [023/131] (812s left) gem_ctx_persistence (legacy-engines-mixed)
[209.212236] Starting subtest: legacy-engines-mixed
[209.213196] Starting dynamic subtest: render
[209.313393] Dynamic subtest render: SUCCESS (0.101s)
[209.327194] Starting dynamic subtest: bsd1
[209.369770] Dynamic subtest bsd1: SUCCESS (0.055s)
[209.408466] Starting dynamic subtest: bsd2
[209.445622] Dynamic subtest bsd2: SUCCESS (0.074s)
[209.478744] Starting dynamic subtest: blt
[209.509424] Dynamic subtest blt: SUCCESS (0.062s)
[209.535239] Starting dynamic subtest: vebox
[209.564349] Dynamic subtest vebox: SUCCESS (0.054s)
[209.565455] Subtest legacy-engines-mixed: SUCCESS (0.352s)
[209.760607] [024/131] (811s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[209.956502] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[210.003533] [025/131] (811s left) vgem_basic (debugfs)
[210.115299] Starting subtest: debugfs
[210.119644] Subtest debugfs: SUCCESS (0.003s)
[210.243240] [FACT vgem_basic (debugfs)] new: kernel.kmod_is_loaded.vgem: true
[210.245041] [026/131] (811s left) gen7_exec_parse (chained-batch)
[210.331081] Subtest chained-batch: SKIP (0.000s)
[210.406178] [027/131] (811s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[210.617942] Starting subtest: fbc-rgb565-draw-mmap-cpu
[217.081015] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (6.462s)
[217.236681] [028/131] (804s left) kms_chamelium_hpd (hdmi-hpd)
[217.525115] Subtest hdmi-hpd: SKIP (0.000s)
[217.709043] [029/131] (804s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[217.789176] Starting subtest: etime-multi-wait-all-for-submit-submitted
[217.893439] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.103s)
[218.034483] [030/131] (803s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[218.229220] Starting subtest: bad-pixel-format-yf-tiled-ccs
[218.230139] Starting dynamic subtest: pipe-A-DP-3
[218.238390] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[218.249385] Starting dynamic subtest: pipe-B-DP-3
[218.258458] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[218.269086] Starting dynamic subtest: pipe-C-DP-3
[218.277380] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[218.288021] Starting dynamic subtest: pipe-D-DP-3
[218.297936] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[218.299992] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s)
[218.695901] [031/131] (803s left) gem_ctx_param (invalid-size-get)
[218.776419] Starting subtest: invalid-size-get
[218.778257] Subtest invalid-size-get: SUCCESS (0.001s)
[218.933181] [032/131] (803s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[219.019012] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[219.019922] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[219.152605] [033/131] (803s left) kms_mmap_write_crc (main)
[219.351359] Starting subtest: main
[219.353355] Starting dynamic subtest: pipe-A-DP-3
[223.098114] Dynamic subtest pipe-A-DP-3: SUCCESS (3.744s)
[223.099549] Subtest main: SUCCESS (3.746s)
[223.394224] [034/131] (798s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[223.595758] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[223.597331] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[223.715733] [035/131] (798s left) gem_exec_parallel (basic)
[223.803484] Starting subtest: basic
[223.804413] Starting dynamic subtest: rcs0
[225.345405] Dynamic subtest rcs0: SUCCESS (1.541s)
[225.358941] Starting dynamic subtest: bcs0
[226.846508] Dynamic subtest bcs0: SUCCESS (1.500s)
[226.860200] Starting dynamic subtest: vcs0
[228.350463] Dynamic subtest vcs0: SUCCESS (1.503s)
[228.362699] Starting dynamic subtest: vcs1
[229.853305] Dynamic subtest vcs1: SUCCESS (1.502s)
[229.866148] Starting dynamic subtest: vecs0
[231.320375] Dynamic subtest vecs0: SUCCESS (1.466s)
[231.332995] Starting dynamic subtest: vecs1
[232.771604] Dynamic subtest vecs1: SUCCESS (1.451s)
[232.783587] Starting dynamic subtest: ccs0
[234.237386] Dynamic subtest ccs0: SUCCESS (1.465s)
[234.238501] Subtest basic: SUCCESS (10.433s)
[234.521214] [036/131] (787s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[234.725184] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[234.726889] Subtest fbcpsr-1p-pri-indfb-multidraw: SKIP (0.000s)
[234.853747] [037/131] (787s left) kms_pwrite_crc
[235.958908] [038/131] (786s left) gen9_exec_parse (bb-start-far)
[236.042023] Subtest bb-start-far: SKIP (0.000s)
[236.124306] [039/131] (786s left) kms_rotation_crc (bad-pixel-format)
[236.318231] Starting subtest: bad-pixel-format
[236.319978] Subtest bad-pixel-format: SKIP (0.001s)
[236.426900] [040/131] (786s left) gem_exec_params (rs-invalid)
[236.512239] Starting subtest: rs-invalid
[236.515159] Subtest rs-invalid: SUCCESS (0.002s)
[236.714893] [041/131] (786s left) gem_exec_schedule (u-submit-early-slice)
[236.805537] Starting subtest: u-submit-early-slice
[236.806420] Starting dynamic subtest: rcs0
[236.889288] Dynamic subtest rcs0: SUCCESS (0.083s)
[236.900825] Starting dynamic subtest: bcs0
[236.946131] Dynamic subtest bcs0: SUCCESS (0.056s)
[236.957405] Starting dynamic subtest: vcs0
[237.000836] Dynamic subtest vcs0: SUCCESS (0.054s)
[237.012481] Starting dynamic subtest: vcs1
[237.056601] Dynamic subtest vcs1: SUCCESS (0.055s)
[237.067891] Starting dynamic subtest: vecs0
[237.111730] Dynamic subtest vecs0: SUCCESS (0.055s)
[237.123993] Starting dynamic subtest: vecs1
[237.169294] Dynamic subtest vecs1: SUCCESS (0.057s)
[237.180907] Starting dynamic subtest: ccs0
[237.225337] Dynamic subtest ccs0: SUCCESS (0.056s)
[237.226181] Subtest u-submit-early-slice: SUCCESS (0.420s)
[237.713560] [042/131] (785s left) gem_exec_balancer (invalid-balancer)
[237.800186] Starting subtest: invalid-balancer
[239.367001] Subtest invalid-balancer: SUCCESS (1.566s)
[239.785825] [043/131] (783s left) kms_cursor_crc (cursor-onscreen-512x170)
[240.271307] Starting subtest: cursor-onscreen-512x170
[240.273086] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[240.528205] [044/131] (782s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[240.736348] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[240.738147] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[240.865501] [045/131] (782s left) gem_mmap_gtt (isolation)
[240.943764] Subtest isolation: SKIP (0.000s)
[241.008456] [046/131] (782s left) kms_invalid_mode (zero-vdisplay)
[241.205049] Starting subtest: zero-vdisplay
[241.205953] Starting dynamic subtest: pipe-A-DP-3
[241.294772] Dynamic subtest pipe-A-DP-3: SUCCESS (0.086s)
[241.311953] Starting dynamic subtest: pipe-B-DP-3
[241.313234] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[241.329986] Starting dynamic subtest: pipe-C-DP-3
[241.331068] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[241.344377] Starting dynamic subtest: pipe-D-DP-3
[241.345259] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[241.346179] Subtest zero-vdisplay: SUCCESS (0.095s)
[241.543673] [047/131] (781s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[241.751127] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[242.464685] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.713s)
[242.720759] [048/131] (780s left) syncobj_wait (reset-signaled)
[242.800129] Starting subtest: reset-signaled
[242.801129] Subtest reset-signaled: SUCCESS (0.000s)
[242.948613] [049/131] (780s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[243.156209] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[243.157898] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[243.285186] [050/131] (780s left) prime_self_import (basic-with_one_bo_two_files)
[243.354521] Starting subtest: basic-with_one_bo_two_files
[243.398840] Subtest basic-with_one_bo_two_files: SUCCESS (0.045s)
[243.547932] [051/131] (779s left) gem_userptr_blits (access-control)
[243.642751] Starting subtest: access-control
[243.644536] Subtest access-control: SKIP (0.000s)
[243.830791] [052/131] (779s left) perf (invalid-open-flags)
[244.209378] Starting subtest: invalid-open-flags
[244.210242] Subtest invalid-open-flags: SUCCESS (0.000s)
[244.262255] [053/131] (779s left) prime_vgem (basic-fence-mmap)
[244.349522] Starting subtest: basic-fence-mmap
[244.351600] Subtest basic-fence-mmap: SKIP (0.000s)
[244.472368] [054/131] (779s left) gem_eio (in-flight-immediate)
[244.779407] Starting subtest: in-flight-immediate
[249.872440] Subtest in-flight-immediate: SUCCESS (5.093s)
[250.113062] [055/131] (773s left) gem_userptr_blits (process-exit)
[250.203887] Starting subtest: process-exit
[250.212198] Subtest process-exit: SUCCESS (0.008s)
[250.364500] [056/131] (773s left) kms_color (ctm-negative)
[250.565280] Starting subtest: ctm-negative
[250.566184] Starting dynamic subtest: pipe-A-DP-3
[251.253849] Dynamic subtest pipe-A-DP-3: SUCCESS (0.687s)
[251.282067] Starting dynamic subtest: pipe-B-DP-3
[251.860325] Dynamic subtest pipe-B-DP-3: SUCCESS (0.604s)
[251.880539] Starting dynamic subtest: pipe-C-DP-3
[252.475425] Dynamic subtest pipe-C-DP-3: SUCCESS (0.615s)
[252.488428] Starting dynamic subtest: pipe-D-DP-3
[253.085476] Dynamic subtest pipe-D-DP-3: SUCCESS (0.609s)
[253.086471] Subtest ctm-negative: SUCCESS (2.520s)
[253.352413] [057/131] (770s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[253.560156] Starting subtest: x-tiled-16bpp-rotate-180
[255.272740] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.712s)
[255.437466] [058/131] (768s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[255.641687] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[255.643236] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[255.779898] [059/131] (768s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[255.979798] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[255.981462] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[256.111855] [060/131] (768s left) kms_cursor_crc (cursor-sliding-512x170)
[256.605753] Starting subtest: cursor-sliding-512x170
[256.607441] Subtest cursor-sliding-512x170: SKIP (0.001s)
[256.829443] [061/131] (767s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[256.909390] Starting subtest: single-wait-all-for-submit-unsubmitted
[257.013269] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.103s)
[257.136034] [062/131] (767s left) kms_cursor_edge_walk (256x256-right-edge)
[257.330318] Starting subtest: 256x256-right-edge
[257.332396] Starting dynamic subtest: pipe-A-DP-3
[260.760176] Dynamic subtest pipe-A-DP-3: SUCCESS (3.428s)
[260.776791] Starting dynamic subtest: pipe-D-DP-3
[264.104391] Dynamic subtest pipe-D-DP-3: SUCCESS (3.341s)
[264.105754] Subtest 256x256-right-edge: SUCCESS (6.773s)
[264.375244] [063/131] (760s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[264.578965] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[264.580707] Subtest psr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[264.739559] [064/131] (759s left) gem_lmem_swapping (verify-random-ccs)
[267.382092] Starting subtest: verify-random-ccs
[267.382897] Starting dynamic subtest: lmem0
[274.558161] Dynamic subtest lmem0: SUCCESS (7.176s)
[274.559097] Subtest verify-random-ccs: SUCCESS (7.177s)
[275.633864] [FACT gem_lmem_swapping (verify-random-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[275.635289] [FACT gem_lmem_swapping (verify-random-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[275.637440] [065/131] (748s left) kms_psr (fbc-pr-suspend)
[277.301061] Subtest fbc-pr-suspend: SKIP (0.000s)
[277.382233] [FACT kms_psr (fbc-pr-suspend)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[277.384565] [FACT kms_psr (fbc-pr-suspend)] new: kernel.kmod_is_loaded.i915: true
[277.387100] [066/131] (747s left) kms_async_flips (async-flip-suspend-resume)
[277.584463] Starting subtest: async-flip-suspend-resume
[277.811941] Starting dynamic subtest: pipe-A-DP-3
[298.180214] Dynamic subtest pipe-A-DP-3: SUCCESS (5.050s)
[298.379577] Starting dynamic subtest: pipe-B-DP-3
[319.140091] Dynamic subtest pipe-B-DP-3: SUCCESS (4.634s)
[319.317707] Starting dynamic subtest: pipe-C-DP-3
[338.488956] Dynamic subtest pipe-C-DP-3: FAIL (3.832s)
[338.562432] Starting dynamic subtest: pipe-D-DP-3
[358.550439] Dynamic subtest pipe-D-DP-3: SUCCESS (4.544s)
[358.551215] Subtest async-flip-suspend-resume: FAIL (18.808s)
[358.979801] [067/131] (665s left) kms_lease (lease-revoke)
[359.205927] Starting subtest: lease-revoke
[359.208109] Starting dynamic subtest: pipe-A-DP-3
[359.317770] Dynamic subtest pipe-A-DP-3: SUCCESS (0.109s)
[359.327982] Starting dynamic subtest: pipe-B-DP-3
[359.395882] Dynamic subtest pipe-B-DP-3: SUCCESS (0.077s)
[359.407925] Starting dynamic subtest: pipe-C-DP-3
[359.477756] Dynamic subtest pipe-C-DP-3: SUCCESS (0.079s)
[359.487998] Starting dynamic subtest: pipe-D-DP-3
[359.553689] Dynamic subtest pipe-D-DP-3: SUCCESS (0.075s)
[359.554592] Subtest lease-revoke: SUCCESS (0.348s)
[359.722317] [068/131] (665s left) gem_exec_gttfill (multigpu-basic)
[359.923483] Starting subtest: multigpu-basic
[375.765323] Subtest multigpu-basic: SUCCESS (15.840s)
[375.859296] [069/131] (648s left) gem_create (hog-create)
[375.999012] Starting subtest: hog-create
[375.999876] Starting dynamic subtest: lmem0
[408.310725] Dynamic subtest lmem0: SUCCESS (32.310s)
[408.322976] Starting dynamic subtest: smem0
[440.563662] Dynamic subtest smem0: SUCCESS (32.250s)
[440.564594] Subtest hog-create: SUCCESS (64.562s)
[440.813723] [070/131] (584s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[441.020581] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[441.022262] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[441.159740] [071/131] (583s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[441.367832] Starting subtest: yf-tiled-16bpp-rotate-0
[441.369547] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[441.506464] [072/131] (583s left) kms_frontbuffer_tracking (psr-2p-rte)
[441.705402] Starting subtest: psr-2p-rte
[441.707081] Subtest psr-2p-rte: SKIP (0.000s)
[441.871079] [073/131] (583s left) prime_mmap_coherency (write)
[441.957948] Starting subtest: write
[447.368165] Subtest write: SUCCESS (5.409s)
[447.500519] [074/131] (577s left) gem_gpgpu_fill (offset-16x16)
[447.582561] Starting subtest: offset-16x16
[447.613837] Subtest offset-16x16: SUCCESS (0.031s)
[447.850998] [075/131] (577s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[447.941859] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[447.943812] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[448.175025] [076/131] (577s left) core_auth (getclient-simple)
[448.221456] Starting subtest: getclient-simple
[448.251714] Subtest getclient-simple: SUCCESS (0.030s)
[448.375275] [077/131] (576s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[448.568900] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[448.570693] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[448.880887] [078/131] (576s left) kms_vblank (wait-busy)
[449.077883] Starting subtest: wait-busy
[449.080110] Starting dynamic subtest: pipe-A-DP-3
[451.572525] Dynamic subtest pipe-A-DP-3: SUCCESS (2.493s)
[451.593259] Starting dynamic subtest: pipe-D-DP-3
[454.006091] Dynamic subtest pipe-D-DP-3: SUCCESS (2.425s)
[454.007060] Subtest wait-busy: SUCCESS (4.927s)
[454.253045] [079/131] (571s left) prime_mmap (test_reprime)
[454.329345] Starting subtest: test_reprime
[454.330245] Starting dynamic subtest: test_reprime-smem
[454.377021] Dynamic subtest test_reprime-smem: SUCCESS (0.047s)
[454.388781] Starting dynamic subtest: test_reprime-lmem0
[454.577162] Dynamic subtest test_reprime-lmem0: SUCCESS (0.199s)
[454.578088] Subtest test_reprime: SUCCESS (0.249s)
[454.751488] [080/131] (570s left) syncobj_timeline (wait-all-for-submit-snapshot)
[454.839088] Starting subtest: wait-all-for-submit-snapshot
[454.922616] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[455.054708] [081/131] (570s left) kms_psr (fbc-psr-sprite-plane-move)
[455.252464] Subtest fbc-psr-sprite-plane-move: SKIP (0.000s)
[455.312200] [082/131] (570s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[455.521837] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[456.233336] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.711s)
[456.481995] [083/131] (569s left) gem_exec_schedule (preempt-queue-chain)
[456.573996] Subtest preempt-queue-chain: SKIP (0.000s)
[456.915322] [084/131] (568s left) api_intel_bb (misplaced-blitter)
[456.995024] Starting subtest: misplaced-blitter
[457.028146] Subtest misplaced-blitter: SUCCESS (0.034s)
[457.179905] [085/131] (568s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-blt)
[457.375452] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-blt
[457.377185] Subtest fbcpsr-1p-offscren-pri-indfb-draw-blt: SKIP (0.000s)
[457.501091] [086/131] (568s left) gem_mmap_offset (partial-remap)
[457.579039] Starting subtest: partial-remap
[457.579912] Starting dynamic subtest: lmem0
[457.582388] Dynamic subtest lmem0: SUCCESS (0.003s)
[457.594644] Starting dynamic subtest: smem0
[457.596976] Dynamic subtest smem0: SUCCESS (0.004s)
[457.598007] Subtest partial-remap: SUCCESS (0.009s)
[457.765762] [087/131] (568s left) kms_pm_rpm (universal-planes)
[459.795604] Starting subtest: universal-planes
[459.799071] Starting dynamic subtest: plane-33
[462.650043] Dynamic subtest plane-33: SUCCESS (2.852s)
[462.698983] Starting dynamic subtest: plane-43
[465.459967] Dynamic subtest plane-43: SUCCESS (2.804s)
[465.508987] Starting dynamic subtest: plane-53
[468.176543] Dynamic subtest plane-53: SUCCESS (2.711s)
[468.223367] Starting dynamic subtest: plane-63
[471.090631] Dynamic subtest plane-63: SUCCESS (2.909s)
[471.137225] Starting dynamic subtest: plane-73
[474.046177] Dynamic subtest plane-73: SUCCESS (2.950s)
[474.092897] Starting dynamic subtest: plane-83
[476.867087] Dynamic subtest plane-83: SUCCESS (2.815s)
[476.873349] Subtest universal-planes: SUCCESS (17.074s)
[477.259150] [088/131] (548s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[477.462627] Starting subtest: fbcpsr-slowdraw
[477.464451] Subtest fbcpsr-slowdraw: SKIP (0.000s)
[477.591823] [089/131] (548s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[477.786992] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[477.789332] Starting dynamic subtest: pipe-A-valid-mode
[477.863706] Dynamic subtest pipe-A-valid-mode: SKIP (0.074s)
[477.865435] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.075s)
[478.073789] [090/131] (548s left) prime_self_import (export-vs-gem_close-race)
[478.122830] Starting subtest: export-vs-gem_close-race
[483.210811] Subtest export-vs-gem_close-race: SUCCESS (5.089s)
[483.331869] [091/131] (543s left) gem_exec_balancer (fairslice)
[483.457581] Starting subtest: fairslice
[489.077488] Subtest fairslice: SUCCESS (5.619s)
[489.472825] [092/131] (536s left) gem_pwrite (basic-random)
[489.551682] Subtest basic-random: SKIP (0.000s)
[489.640060] [093/131] (536s left) gem_exec_flush (basic-uc-pro-default)
[489.721593] Subtest basic-uc-pro-default: SKIP (0.000s)
[489.814183] [094/131] (536s left) gem_busy (semaphore)
[490.052113] Subtest semaphore: SKIP (0.000s)
[490.374197] [095/131] (536s left) kms_atomic (test-only)
[490.575897] Starting subtest: test-only
[490.987783] Starting dynamic subtest: pipe-A-DP-3
[491.906796] Dynamic subtest pipe-A-DP-3: SUCCESS (0.919s)
[491.907687] Subtest test-only: SUCCESS (1.331s)
[492.167090] [096/131] (534s left) i915_drm_fdinfo (memory-info-purgeable)
[492.237970] Starting subtest: memory-info-purgeable
[492.238881] Starting dynamic subtest: lmem0
[495.472260] Dynamic subtest lmem0: SUCCESS (3.233s)
[495.514438] Starting dynamic subtest: smem0
[500.093881] Dynamic subtest smem0: SUCCESS (4.617s)
[500.094800] Subtest memory-info-purgeable: SUCCESS (7.856s)
[500.189288] [097/131] (526s left) kms_writeback (writeback-fb-id)
[500.387344] Subtest writeback-fb-id: SKIP (0.000s)
[500.447929] [098/131] (526s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[500.529140] Starting subtest: invalid-smem-bo-on-discrete
[500.529934] Subtest invalid-smem-bo-on-discrete: SUCCESS (0.000s)
[500.771480] [099/131] (526s left) syncobj_wait (wait-all-snapshot)
[500.849858] Starting subtest: wait-all-snapshot
[500.932899] Subtest wait-all-snapshot: SUCCESS (0.082s)
[501.085309] [100/131] (525s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[501.282299] Starting subtest: 2x-plain-flip-ts-check-interruptible
[501.297413] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.014s)
[501.418603] [101/131] (525s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[501.616797] Starting subtest: cursorA-vs-flipB-legacy
[501.618568] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[501.733197] [102/131] (525s left) gem_exec_reloc (basic-cpu-read-active)
[501.819036] Subtest basic-cpu-read-active: SKIP (0.000s)
[501.923234] [103/131] (525s left) kms_dp_linktrain_fallback (dsc-fallback)
[502.120194] Starting subtest: dsc-fallback
[502.122797] Subtest dsc-fallback: SKIP (0.001s)
[502.251241] [104/131] (524s left) kms_plane_scaling (planes-scaler-unity-scaling)
[502.452904] Starting subtest: planes-scaler-unity-scaling
[502.453803] Starting dynamic subtest: pipe-A
[502.552049] Dynamic subtest pipe-A: SUCCESS (0.098s)
[502.576670] Starting dynamic subtest: pipe-B
[502.767687] Dynamic subtest pipe-B: SUCCESS (0.214s)
[502.792972] Starting dynamic subtest: pipe-C
[503.016598] Dynamic subtest pipe-C: SUCCESS (0.247s)
[503.030036] Starting dynamic subtest: pipe-D
[503.215616] Dynamic subtest pipe-D: SUCCESS (0.198s)
[503.216678] Subtest planes-scaler-unity-scaling: SUCCESS (0.763s)
[503.532435] [105/131] (523s left) perf_pmu (init-sema)
[503.603518] Starting subtest: init-sema
[503.604502] Starting dynamic subtest: rcs0
[503.606899] Dynamic subtest rcs0: SUCCESS (0.003s)
[503.620542] Starting dynamic subtest: bcs0
[503.621467] Dynamic subtest bcs0: SUCCESS (0.000s)
[503.633289] Starting dynamic subtest: vcs0
[503.634169] Dynamic subtest vcs0: SUCCESS (0.001s)
[503.645986] Starting dynamic subtest: vcs1
[503.647033] Dynamic subtest vcs1: SUCCESS (0.001s)
[503.658976] Starting dynamic subtest: vecs0
[503.660198] Dynamic subtest vecs0: SUCCESS (0.000s)
[503.672798] Starting dynamic subtest: vecs1
[503.674055] Dynamic subtest vecs1: SUCCESS (0.001s)
[503.686035] Starting dynamic subtest: ccs0
[503.687213] Dynamic subtest ccs0: SUCCESS (0.001s)
[503.688397] Subtest init-sema: SUCCESS (0.014s)
[503.748510] [106/131] (523s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[503.942669] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[504.010215] [107/131] (523s left) kms_vblank (query-idle-hang)
[504.205894] Starting subtest: query-idle-hang
[504.208162] Starting dynamic subtest: pipe-A-DP-3
[530.309377] Dynamic subtest pipe-A-DP-3: SUCCESS (26.100s)
[530.324554] Starting dynamic subtest: pipe-D-DP-3
[555.256493] Dynamic subtest pipe-D-DP-3: SUCCESS (24.941s)
[555.257481] Subtest query-idle-hang: SUCCESS (51.047s)
[555.526877] [108/131] (471s left) gem_exec_suspend (basic-s4-devices)
[555.616747] Starting subtest: basic-S4-devices
[555.617692] Starting dynamic subtest: smem
[565.956942] Dynamic subtest smem: SUCCESS (10.339s)
[565.969911] Starting dynamic subtest: lmem0
[576.287344] Dynamic subtest lmem0: SUCCESS (10.329s)
[576.288227] Subtest basic-S4-devices: SUCCESS (20.670s)
[582.567047] [109/131] (450s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[582.767463] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[582.769174] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[582.899928] [110/131] (450s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[583.092849] Starting subtest: random-ccs-data-y-tiled-ccs
[583.095085] Starting dynamic subtest: pipe-A-DP-3
[583.103582] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[583.116725] Starting dynamic subtest: pipe-B-DP-3
[583.125567] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[583.138072] Starting dynamic subtest: pipe-C-DP-3
[583.147446] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[583.160194] Starting dynamic subtest: pipe-D-DP-3
[583.171945] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[583.173945] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.007s)
[583.560788] [111/131] (450s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[583.757909] Starting subtest: primary-y-tiled-reflect-x-0
[583.859988] Subtest primary-y-tiled-reflect-x-0: SKIP (0.100s)
[584.044325] [112/131] (449s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[584.243454] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[586.992967] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (2.749s)
[587.169076] [113/131] (446s left) drm_mm (drm_mm)
[587.223935] Starting subtest: drm_mm
[587.270271] Starting dynamic subtest: drm_test_mm_init
[587.331266] Dynamic subtest drm_test_mm_init: SUCCESS (0.062s)
[587.354549] Starting dynamic subtest: drm_test_mm_debug
[587.414499] Dynamic subtest drm_test_mm_debug: SUCCESS (0.080s)
[587.461449] Starting dynamic subtest: drm_test_mm_align32
[587.501225] Dynamic subtest drm_test_mm_align32: SUCCESS (0.083s)
[587.524191] Starting dynamic subtest: drm_test_mm_align64
[587.594551] Dynamic subtest drm_test_mm_align64: SUCCESS (0.091s)
[587.641434] Starting dynamic subtest: drm_test_mm_lowest
[587.680261] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.080s)
[587.700901] Starting dynamic subtest: drm_test_mm_highest
[587.763285] Dynamic subtest drm_test_mm_highest: SUCCESS (0.080s)
[587.764977] Subtest drm_mm: SUCCESS (0.539s)
[587.977096] [114/131] (445s left) kms_psr (psr-dpms)
[588.173616] Subtest psr-dpms: SKIP (0.000s)
[588.266492] [115/131] (445s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[588.345852] Starting subtest: multi-wait-all-for-submit-submitted
[588.449708] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.103s)
[588.621047] [116/131] (445s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[588.819334] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[588.821045] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[588.977810] [117/131] (445s left) gem_render_copy (y-tiled-to-vebox-linear)
[589.060924] Starting subtest: y-tiled-to-vebox-linear
[589.063017] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[589.296668] [118/131] (444s left) kms_psr (psr2-primary-mmap-cpu)
[589.494467] Subtest psr2-primary-mmap-cpu: SKIP (0.000s)
[589.555874] [119/131] (444s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[589.757033] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[589.759455] Starting dynamic subtest: pipe-A-valid-mode
[591.520202] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.759s)
[591.521612] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SUCCESS (1.762s)
[591.782509] [120/131] (442s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[591.993588] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[591.995390] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[592.130371] [121/131] (442s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[592.328374] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[592.330133] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[592.468013] [122/131] (442s left) gem_readwrite (new-obj)
[592.547482] Subtest new-obj: SKIP (0.000s)
[592.623549] [123/131] (441s left) kms_sequence (get-forked)
[592.817915] Starting subtest: get-forked
[592.820352] Starting dynamic subtest: pipe-A-DP-3
[595.246233] Dynamic subtest pipe-A-DP-3: SUCCESS (2.427s)
[595.263096] Starting dynamic subtest: pipe-B-DP-3
[597.609831] Dynamic subtest pipe-B-DP-3: SUCCESS (2.362s)
[597.628744] Starting dynamic subtest: pipe-C-DP-3
[599.984813] Dynamic subtest pipe-C-DP-3: SUCCESS (2.373s)
[600.002676] Starting dynamic subtest: pipe-D-DP-3
[602.358334] Dynamic subtest pipe-D-DP-3: SUCCESS (2.371s)
[602.359324] Subtest get-forked: SUCCESS (9.540s)
[602.630076] [124/131] (432s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[602.828370] Starting subtest: cursorA-vs-flipB-toggle
[602.830097] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[602.940239] [125/131] (431s left) syncobj_wait (reset-unsignaled)
[603.019819] Starting subtest: reset-unsignaled
[603.020714] Subtest reset-unsignaled: SUCCESS (0.000s)
[603.186098] [126/131] (431s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[603.263890] Starting subtest: etime-single-wait-all-for-submit-submitted
[603.371708] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.105s)
[603.489015] [127/131] (431s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[603.569771] Starting subtest: invalid-single-wait-all-unsubmitted
[603.570766] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[603.713531] [128/131] (431s left) kms_flip (flip-vs-suspend)
[603.910367] Starting subtest: flip-vs-suspend
[603.914886] Starting dynamic subtest: A-DP3
[643.790895] Dynamic subtest A-DP3: SUCCESS (7.698s)
[643.805764] Starting dynamic subtest: B-DP3
[683.012803] Dynamic subtest B-DP3: SUCCESS (7.225s)
[683.030687] Starting dynamic subtest: C-DP3
[722.162811] Dynamic subtest C-DP3: SUCCESS (7.087s)
[722.178040] Starting dynamic subtest: D-DP3
[761.403397] Dynamic subtest D-DP3: SUCCESS (7.165s)
[761.405540] Subtest flip-vs-suspend: SUCCESS (29.189s)
[761.672625] [129/131] (273s left) gem_tiled_blits (normal)
[761.761317] Subtest normal: SKIP (0.000s)
[761.847582] [130/131] (273s left) gem_spin_batch (legacy-resubmit-new)
[761.936461] Starting subtest: legacy-resubmit-new
[761.938560] Starting dynamic subtest: default
[761.971845] Dynamic subtest default: SUCCESS (0.034s)
[761.987722] Starting dynamic subtest: render
[761.988818] Dynamic subtest render: SUCCESS (0.004s)
[762.002444] Starting dynamic subtest: bsd
[762.003257] Dynamic subtest bsd: SUCCESS (0.007s)
[762.016654] Starting dynamic subtest: bsd1
[762.017437] Dynamic subtest bsd1: SUCCESS (0.006s)
[762.030055] Starting dynamic subtest: bsd2
[762.030853] Dynamic subtest bsd2: SUCCESS (0.004s)
[762.043471] Starting dynamic subtest: blt
[762.044291] Dynamic subtest blt: SUCCESS (0.004s)
[762.056926] Starting dynamic subtest: vebox
[762.057802] Dynamic subtest vebox: SUCCESS (0.004s)
[762.058671] Subtest legacy-resubmit-new: SUCCESS (0.074s)
[762.269092] [131/131] (272s left) kms_plane_cursor (primary)
[762.463292] Starting subtest: primary
[762.464982] Starting dynamic subtest: pipe-A-DP-3-size-64
[765.900088] Dynamic subtest pipe-A-DP-3-size-64: SUCCESS (3.435s)
[765.995478] Starting dynamic subtest: pipe-A-DP-3-size-128
[769.483821] Dynamic subtest pipe-A-DP-3-size-128: SUCCESS (3.531s)
[769.549441] Starting dynamic subtest: pipe-A-DP-3-size-256
[773.034163] Dynamic subtest pipe-A-DP-3-size-256: SUCCESS (3.499s)
[773.169385] Starting dynamic subtest: pipe-B-DP-3-size-64
[776.722195] Dynamic subtest pipe-B-DP-3-size-64: SUCCESS (3.573s)
[776.773020] Starting dynamic subtest: pipe-B-DP-3-size-128
[780.255832] Dynamic subtest pipe-B-DP-3-size-128: SUCCESS (3.498s)
[780.303052] Starting dynamic subtest: pipe-B-DP-3-size-256
[783.789421] Dynamic subtest pipe-B-DP-3-size-256: SUCCESS (3.500s)
[783.928270] Starting dynamic subtest: pipe-C-DP-3-size-64
[787.449198] Dynamic subtest pipe-C-DP-3-size-64: SUCCESS (3.543s)
[787.500157] Starting dynamic subtest: pipe-C-DP-3-size-128
[790.949620] Dynamic subtest pipe-C-DP-3-size-128: SUCCESS (3.464s)
[790.998896] Starting dynamic subtest: pipe-C-DP-3-size-256
[794.499827] Dynamic subtest pipe-C-DP-3-size-256: SUCCESS (3.516s)
[794.642699] Starting dynamic subtest: pipe-D-DP-3-size-64
[798.162931] Dynamic subtest pipe-D-DP-3-size-64: SUCCESS (3.535s)
[798.211310] Starting dynamic subtest: pipe-D-DP-3-size-128
[801.680029] Dynamic subtest pipe-D-DP-3-size-128: SUCCESS (3.483s)
[801.731283] Starting dynamic subtest: pipe-D-DP-3-size-256
[805.163800] Dynamic subtest pipe-D-DP-3-size-256: SUCCESS (3.449s)
[805.255913] Subtest primary: SUCCESS (42.789s)
[805.518168] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: i915_hangman
results: parsing output: 2/ for test: kms_getfb
results: parsing output: 3/ for test: kms_psr2_sf
results: parsing output: 4/ for test: kms_pipe_b_c_ivb
results: parsing output: 5/ for test: i915_pm_rps
results: parsing output: 6/ for test: kms_properties
results: parsing output: 7/ for test: sysfs_heartbeat_interval
results: parsing output: 8/ for test: kms_chamelium_color
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: gem_ctx_persistence
results: parsing output: 11/ for test: gem_exec_capture
results: parsing output: 12/ for test: syncobj_eventfd
results: parsing output: 13/ for test: kms_plane_scaling
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: kms_content_protection
results: parsing output: 16/ for test: gem_mmap_gtt
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_eio
results: parsing output: 20/ for test: kms_pm_rpm
results: parsing output: 21/ for test: gem_partial_pwrite_pread
results: parsing output: 22/ for test: gem_ctx_persistence
results: parsing output: 23/ for test: kms_psr2_sf
results: parsing output: 24/ for test: vgem_basic
results: parsing output: 25/ for test: gen7_exec_parse
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_chamelium_hpd
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: gem_ctx_param
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: kms_mmap_write_crc
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_exec_parallel
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_pwrite_crc
results: parsing output: 37/ for test: gen9_exec_parse
results: parsing output: 38/ for test: kms_rotation_crc
results: parsing output: 39/ for test: gem_exec_params
results: parsing output: 40/ for test: gem_exec_schedule
results: parsing output: 41/ for test: gem_exec_balancer
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_mmap_gtt
results: parsing output: 45/ for test: kms_invalid_mode
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: syncobj_wait
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: prime_self_import
results: parsing output: 50/ for test: gem_userptr_blits
results: parsing output: 51/ for test: perf
results: parsing output: 52/ for test: prime_vgem
results: parsing output: 53/ for test: gem_eio
results: parsing output: 54/ for test: gem_userptr_blits
results: parsing output: 55/ for test: kms_color
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_cursor_crc
results: parsing output: 60/ for test: syncobj_wait
results: parsing output: 61/ for test: kms_cursor_edge_walk
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_lmem_swapping
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: kms_async_flips
results: parsing output: 66/ for test: kms_lease
results: parsing output: 67/ for test: gem_exec_gttfill
results: parsing output: 68/ for test: gem_create
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: prime_mmap_coherency
results: parsing output: 73/ for test: gem_gpgpu_fill
results: parsing output: 74/ for test: gem_render_copy
results: parsing output: 75/ for test: core_auth
results: parsing output: 76/ for test: kms_ccs
results: parsing output: 77/ for test: kms_vblank
results: parsing output: 78/ for test: prime_mmap
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: gem_exec_schedule
results: parsing output: 83/ for test: api_intel_bb
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_mmap_offset
results: parsing output: 86/ for test: kms_pm_rpm
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_flip_scaled_crc
results: parsing output: 89/ for test: prime_self_import
results: parsing output: 90/ for test: gem_exec_balancer
results: parsing output: 91/ for test: gem_pwrite
results: parsing output: 92/ for test: gem_exec_flush
results: parsing output: 93/ for test: gem_busy
results: parsing output: 94/ for test: kms_atomic
results: parsing output: 95/ for test: i915_drm_fdinfo
results: parsing output: 96/ for test: kms_writeback
results: parsing output: 97/ for test: kms_addfb_basic
results: parsing output: 98/ for test: syncobj_wait
results: parsing output: 99/ for test: kms_flip
results: parsing output: 100/ for test: kms_cursor_legacy
results: parsing output: 101/ for test: gem_exec_reloc
results: parsing output: 102/ for test: kms_dp_linktrain_fallback
results: parsing output: 103/ for test: kms_plane_scaling
results: parsing output: 104/ for test: perf_pmu
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: kms_vblank
results: parsing output: 107/ for test: gem_exec_suspend
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: kms_rotation_crc
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: drm_mm
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: syncobj_wait
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: gem_render_copy
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: kms_flip_scaled_crc
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_readwrite
results: parsing output: 122/ for test: kms_sequence
results: parsing output: 123/ for test: kms_cursor_legacy
results: parsing output: 124/ for test: syncobj_wait
results: parsing output: 125/ for test: syncobj_timeline
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: gem_tiled_blits
results: parsing output: 129/ for test: gem_spin_batch
results: parsing output: 130/ for test: kms_plane_cursor
Done.