[57.645668] Initializing watchdogs
[57.645718]   /dev/watchdog0
[57.660208] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.664732] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.666818] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.668825] [001/131] (960s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[57.774913] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[57.776846] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[57.884736] [002/131] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[57.971280] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[57.973055] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[58.089740] [003/131] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[58.182582] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[58.184110] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[58.310813] [004/131] (959s left) gem_barrier_race (remote-request)
[58.356227] Starting subtest: remote-request
[58.357339] Starting dynamic subtest: rcs0
[63.560212] Dynamic subtest rcs0: SUCCESS (5.186s)
[63.561635] Subtest remote-request: SUCCESS (5.186s)
[63.716259] [005/131] (954s left) api_intel_bb (add-remove-objects)
[63.771171] Starting subtest: add-remove-objects
[63.780526] Subtest add-remove-objects: SUCCESS (0.010s)
[63.935240] [006/131] (954s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[64.051485] Starting subtest: 4-tiled-16bpp-rotate-0
[65.410099] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.356s)
[65.536202] [007/131] (952s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[65.633137] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[65.634043] Starting dynamic subtest: pipe-A-eDP-1
[65.850238] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.205s)
[65.858371] Starting dynamic subtest: pipe-B-eDP-1
[67.077213] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.223s)
[67.084396] Starting dynamic subtest: pipe-C-eDP-1
[68.281403] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.202s)
[68.288039] Starting dynamic subtest: pipe-D-eDP-1
[69.511570] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.229s)
[69.512427] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.863s)
[70.675950] [008/131] (947s left) gem_mmap_wc (read)
[70.729952] Subtest read: SKIP (0.000s)
[70.788940] [009/131] (947s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[70.844959] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[70.917167] [010/131] (947s left) gem_render_copy (y-tiled)
[70.984083] Starting subtest: y-tiled
[70.985881] Subtest y-tiled: SKIP (0.000s)
[71.179611] [011/131] (947s left) perf (per-context-mode-unprivileged)
[71.293541] Starting subtest: per-context-mode-unprivileged
[71.295425] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[71.318995] [012/131] (947s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[71.376928] Starting subtest: wait-all-for-submit-delayed-submit
[71.482802] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.104s)
[71.569334] [013/131] (946s left) kms_invalid_mode (bad-vtotal)
[71.654908] Starting subtest: bad-vtotal
[71.655860] Starting dynamic subtest: pipe-A-eDP-1
[71.937021] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s)
[71.943475] Starting dynamic subtest: pipe-B-eDP-1
[71.944363] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[71.949832] Starting dynamic subtest: pipe-C-eDP-1
[71.950749] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[71.956120] Starting dynamic subtest: pipe-D-eDP-1
[71.956977] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[71.957904] Subtest bad-vtotal: SUCCESS (0.287s)
[72.797948] [014/131] (945s left) i915_drm_fdinfo (virtual-busy-idle)
[72.836887] Starting subtest: virtual-busy-idle
[72.838718] Subtest virtual-busy-idle: SKIP (0.000s)
[72.923358] [015/131] (945s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[72.977958] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[73.030067] [016/131] (945s left) gen9_exec_parse (bb-chained)
[73.080131] Subtest bb-chained: SKIP (0.000s)
[73.147250] [017/131] (945s left) kms_psr (fbc-psr-primary-page-flip)
[73.234443] Starting subtest: fbc-psr-primary-page-flip
[73.235460] Starting dynamic subtest: eDP-1
[73.237411] Dynamic subtest eDP-1: SKIP (0.000s)
[73.239259] Subtest fbc-psr-primary-page-flip: SKIP (0.000s)
[73.320053] [018/131] (945s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[73.414787] Starting subtest: random-ccs-data-y-tiled-ccs
[73.415801] Starting dynamic subtest: pipe-A-eDP-1
[73.425742] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[73.431577] Starting dynamic subtest: pipe-B-eDP-1
[73.441248] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[73.447089] Starting dynamic subtest: pipe-C-eDP-1
[73.456350] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[73.461784] Starting dynamic subtest: pipe-D-eDP-1
[73.471211] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[73.472915] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.003s)
[75.588232] [019/131] (943s left) sysfs_timeslice_duration (invalid)
[75.652585] Starting subtest: invalid
[75.653588] Starting dynamic subtest: vecs0
[75.654738] Dynamic subtest vecs0: SUCCESS (0.000s)
[75.662412] Starting dynamic subtest: ccs0
[75.663311] Dynamic subtest ccs0: SUCCESS (0.000s)
[75.669067] Starting dynamic subtest: vcs0
[75.669913] Dynamic subtest vcs0: SUCCESS (0.000s)
[75.675353] Starting dynamic subtest: bcs0
[75.676189] Dynamic subtest bcs0: SUCCESS (0.000s)
[75.681715] Starting dynamic subtest: rcs0
[75.682609] Dynamic subtest rcs0: SUCCESS (0.000s)
[75.687935] Starting dynamic subtest: vcs1
[75.688823] Dynamic subtest vcs1: SUCCESS (0.000s)
[75.689730] Subtest invalid: SUCCESS (0.003s)
[75.738903] [020/131] (942s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[75.821813] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[75.823515] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[75.943941] [021/131] (942s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[76.034821] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[76.035683] Starting dynamic subtest: pipe-A-default-mode
[76.324137] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[76.325875] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.288s)
[77.213632] [022/131] (941s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[77.271849] Starting subtest: saturated-hostile-nopreempt
[77.272905] Starting dynamic subtest: rcs0
[77.361603] Dynamic subtest rcs0: SKIP (0.087s)
[77.369871] Starting dynamic subtest: bcs0
[77.383045] Dynamic subtest bcs0: SKIP (0.022s)
[77.388734] Starting dynamic subtest: vcs0
[77.401081] Dynamic subtest vcs0: SKIP (0.017s)
[77.406790] Starting dynamic subtest: vcs1
[77.415976] Dynamic subtest vcs1: SKIP (0.014s)
[77.421646] Starting dynamic subtest: vecs0
[77.440926] Dynamic subtest vecs0: SKIP (0.025s)
[77.446543] Starting dynamic subtest: ccs0
[77.458953] Dynamic subtest ccs0: SKIP (0.017s)
[77.460854] Subtest saturated-hostile-nopreempt: SKIP (0.187s)
[77.556632] [023/131] (941s left) gem_ctx_param (set-priority-not-supported)
[77.605353] Starting subtest: set-priority-not-supported
[77.607214] Subtest set-priority-not-supported: SKIP (0.000s)
[77.681359] [024/131] (941s left) kms_cursor_crc (cursor-sliding-128x128)
[77.872541] Starting subtest: cursor-sliding-128x128
[77.876025] Starting dynamic subtest: pipe-A-eDP-1
[81.082757] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.207s)
[81.109578] Starting dynamic subtest: pipe-D-eDP-1
[84.994587] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.894s)
[84.995557] Subtest cursor-sliding-128x128: SUCCESS (7.122s)
[85.864455] [025/131] (932s left) kms_psr (psr-cursor-mmap-cpu)
[85.967356] Starting subtest: psr-cursor-mmap-cpu
[85.968503] Starting dynamic subtest: eDP-1
[87.659755] Dynamic subtest eDP-1: SUCCESS (1.694s)
[87.660645] Subtest psr-cursor-mmap-cpu: SUCCESS (1.695s)
[88.545814] [026/131] (930s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[88.642398] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[95.338965] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.698s)
[95.498675] [027/131] (923s left) gem_ctx_persistence (engines-hostile)
[95.565755] Starting subtest: engines-hostile
[95.566698] Starting dynamic subtest: rcs0
[95.694954] Dynamic subtest rcs0: SUCCESS (0.128s)
[95.703874] Starting dynamic subtest: bcs0
[95.824885] Dynamic subtest bcs0: SUCCESS (0.129s)
[95.834228] Starting dynamic subtest: vcs0
[95.953784] Dynamic subtest vcs0: SUCCESS (0.128s)
[95.962827] Starting dynamic subtest: vcs1
[96.083814] Dynamic subtest vcs1: SUCCESS (0.129s)
[96.092466] Starting dynamic subtest: vecs0
[96.199664] Dynamic subtest vecs0: SUCCESS (0.115s)
[96.208452] Starting dynamic subtest: ccs0
[96.318850] Dynamic subtest ccs0: SUCCESS (0.118s)
[96.320417] Subtest engines-hostile: SUCCESS (0.753s)
[96.410744] [028/131] (922s left) kms_setmode (basic-clone-single-crtc)
[96.463299] Starting subtest: basic-clone-single-crtc
[96.465847] Subtest basic-clone-single-crtc: SKIP (0.000s)
[96.594516] [029/131] (922s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[101.599203] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[101.600055] Starting dynamic subtest: pipe-A-eDP-1
[113.308687] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.709s)
[113.316914] Starting dynamic subtest: pipe-B-eDP-1
[125.047064] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.738s)
[125.048085] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (23.451s)
[125.910765] [030/131] (893s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[126.002566] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[132.454209] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.453s)
[132.584051] [031/131] (886s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[132.677960] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[132.679725] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[133.855167] [032/131] (885s left) gem_exec_reloc (basic-gtt-wc)
[133.903888] Subtest basic-gtt-wc: SKIP (0.000s)
[133.976815] [033/131] (885s left) gem_tiled_pread_basic
[134.082852] [034/131] (885s left) kms_sequence (queue-busy)
[134.167396] Starting subtest: queue-busy
[134.168307] Starting dynamic subtest: pipe-A-eDP-1
[136.098055] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.930s)
[136.104465] Starting dynamic subtest: pipe-B-eDP-1
[138.730682] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.631s)
[138.737255] Starting dynamic subtest: pipe-C-eDP-1
[141.369241] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.639s)
[141.375206] Starting dynamic subtest: pipe-D-eDP-1
[143.900332] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.529s)
[143.901472] Subtest queue-busy: SUCCESS (9.734s)
[144.717156] [035/131] (874s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[144.775540] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[144.776544] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[144.910060] [036/131] (874s left) gem_ppgtt (blt-vs-render-ctxn)
[144.975294] Starting subtest: blt-vs-render-ctxN
[177.938803] Subtest blt-vs-render-ctxN: SUCCESS (32.958s)
[178.090180] [037/131] (841s left) kms_psr (pr-primary-mmap-cpu)
[178.223889] Starting subtest: pr-primary-mmap-cpu
[178.225558] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[178.315984] [038/131] (840s left) kms_plane_scaling (planes-downscale-factor-0-75)
[178.408330] Starting subtest: planes-downscale-factor-0-75
[178.409258] Starting dynamic subtest: pipe-A
[178.424800] Dynamic subtest pipe-A: SKIP (0.016s)
[178.435406] Starting dynamic subtest: pipe-B
[178.451563] Dynamic subtest pipe-B: SKIP (0.026s)
[178.457962] Starting dynamic subtest: pipe-C
[178.478919] Dynamic subtest pipe-C: SKIP (0.027s)
[178.492780] Starting dynamic subtest: pipe-D
[178.516686] Dynamic subtest pipe-D: SKIP (0.028s)
[178.518519] Subtest planes-downscale-factor-0-75: SKIP (0.099s)
[178.622950] [039/131] (840s left) gem_softpin (evict-active)
[178.686329] Starting subtest: evict-active
[178.691779] Subtest evict-active: SUCCESS (0.005s)
[178.850706] [040/131] (840s left) syncobj_timeline (device-submit-unordered)
[178.910388] Starting subtest: device-submit-unordered
[178.911395] Subtest device-submit-unordered: SUCCESS (0.000s)
[179.026080] [041/131] (840s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[179.112457] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[179.114195] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[179.235699] [042/131] (840s left) gem_exec_schedule (submit-late-slice)
[179.296319] Starting subtest: submit-late-slice
[179.297145] Starting dynamic subtest: rcs0
[179.330424] Dynamic subtest rcs0: SUCCESS (0.034s)
[179.339024] Starting dynamic subtest: bcs0
[179.359059] Dynamic subtest bcs0: SUCCESS (0.028s)
[179.366565] Starting dynamic subtest: vcs0
[179.391934] Dynamic subtest vcs0: SUCCESS (0.032s)
[179.398631] Starting dynamic subtest: vcs1
[179.423112] Dynamic subtest vcs1: SUCCESS (0.031s)
[179.430036] Starting dynamic subtest: vecs0
[179.454458] Dynamic subtest vecs0: SUCCESS (0.031s)
[179.461206] Starting dynamic subtest: ccs0
[179.488180] Dynamic subtest ccs0: SUCCESS (0.033s)
[179.489080] Subtest submit-late-slice: SUCCESS (0.192s)
[181.014218] [043/131] (838s left) kms_plane (pixel-format)
[181.108164] Starting subtest: pixel-format
[181.135764] Starting dynamic subtest: pipe-A-plane-0
[185.835716] Dynamic subtest pipe-A-plane-0: SUCCESS (4.700s)
[185.842104] Starting dynamic subtest: pipe-A-plane-3
[188.035788] Dynamic subtest pipe-A-plane-3: SUCCESS (2.199s)
[188.042621] Starting dynamic subtest: pipe-A-plane-5
[188.235812] Dynamic subtest pipe-A-plane-5: SUCCESS (0.199s)
[189.395864] Starting dynamic subtest: pipe-B-plane-0
[193.922943] Dynamic subtest pipe-B-plane-0: SUCCESS (4.533s)
[193.929667] Starting dynamic subtest: pipe-B-plane-3
[196.189684] Dynamic subtest pipe-B-plane-3: SUCCESS (2.266s)
[196.196201] Starting dynamic subtest: pipe-B-plane-5
[196.400923] Dynamic subtest pipe-B-plane-5: SUCCESS (0.210s)
[196.707226] Subtest pixel-format: SUCCESS (15.599s)
[197.587142] [044/131] (821s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[197.676065] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[197.676936] Starting dynamic subtest: pipe-A-eDP-1
[197.683978] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[197.691852] Starting dynamic subtest: pipe-B-eDP-1
[197.699232] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[197.707151] Starting dynamic subtest: pipe-C-eDP-1
[197.714586] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[197.720444] Starting dynamic subtest: pipe-D-eDP-1
[197.727945] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[197.728829] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.007s)
[199.858941] [045/131] (819s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[199.959331] Starting subtest: 2x-plain-flip-ts-check-interruptible
[199.970950] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.011s)
[200.069570] [046/131] (819s left) api_intel_bb (reset-flags)
[200.118568] Starting subtest: reset-flags
[200.126204] Subtest reset-flags: SUCCESS (0.009s)
[200.254558] [047/131] (819s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[200.310082] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[200.343350] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.015s)
[200.412789] [048/131] (819s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[205.428864] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[205.430609] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.002s)
[206.291170] [049/131] (813s left) i915_suspend (sysfs-reader)
[206.348770] Starting subtest: sysfs-reader
[224.616649] Subtest sysfs-reader: SUCCESS (7.980s)
[230.718108] [050/131] (794s left) gem_mmap_gtt (basic-wc)
[230.784664] Subtest basic-wc: SKIP (0.000s)
[230.849555] [051/131] (794s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[230.959989] Starting subtest: fbc-rgb565-draw-mmap-gtt
[230.961804] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[231.090462] [052/131] (794s left) gem_exec_flush (basic-uc-set-default)
[231.154638] Starting subtest: basic-uc-set-default
[236.694874] Subtest basic-uc-set-default: SUCCESS (5.454s)
[236.898468] [053/131] (788s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[236.991058] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[243.923262] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.883s)
[244.111187] [054/131] (781s left) kms_flip (2x-plain-flip)
[244.202392] Starting subtest: 2x-plain-flip
[244.212922] Subtest 2x-plain-flip: SKIP (0.011s)
[244.306736] [055/131] (781s left) core_setmaster_vs_auth
[244.499123] [056/131] (781s left) gem_userptr_blits (dmabuf-unsync)
[244.551084] Subtest dmabuf-unsync: SKIP (0.000s)
[244.722424] [057/131] (781s left) kms_scaling_modes (scaling-mode-center)
[244.820179] Starting subtest: scaling-mode-center
[244.821108] Starting dynamic subtest: pipe-A-eDP-1
[244.920204] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.100s)
[244.931055] Starting dynamic subtest: pipe-B-eDP-1
[246.070189] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.144s)
[246.079490] Starting dynamic subtest: pipe-C-eDP-1
[247.187097] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.112s)
[247.196401] Starting dynamic subtest: pipe-D-eDP-1
[248.319503] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.128s)
[248.320440] Subtest scaling-mode-center: SUCCESS (3.490s)
[249.501761] [058/131] (776s left) gem_exec_flush (basic-batch-kernel-default-wb)
[249.573779] Starting subtest: basic-batch-kernel-default-wb
[256.559046] Subtest basic-batch-kernel-default-wb: SUCCESS (6.972s)
[256.775370] [059/131] (769s left) perf (i915-ref-count)
[256.859675] Starting subtest: i915-ref-count
[256.886922] Subtest i915-ref-count: SUCCESS (0.027s)
[256.937986] [060/131] (769s left) kms_lease (page-flip-implicit-plane)
[257.029506] Starting subtest: page-flip-implicit-plane
[257.030330] Starting dynamic subtest: pipe-A-eDP-1
[257.521581] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.491s)
[257.530628] Starting dynamic subtest: pipe-B-eDP-1
[258.649833] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.125s)
[258.661406] Starting dynamic subtest: pipe-C-eDP-1
[259.766338] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.113s)
[259.777443] Starting dynamic subtest: pipe-D-eDP-1
[260.897236] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.128s)
[260.899155] Subtest page-flip-implicit-plane: SUCCESS (3.862s)
[261.744553] [061/131] (764s left) gem_softpin (allocator-evict)
[261.808993] Starting subtest: allocator-evict
[261.809857] Starting dynamic subtest: rcs0
[285.336493] Dynamic subtest rcs0: SUCCESS (23.513s)
[285.346800] Starting dynamic subtest: bcs0
[309.238664] Dynamic subtest bcs0: SUCCESS (23.889s)
[309.249185] Starting dynamic subtest: vcs0
[333.172511] Dynamic subtest vcs0: SUCCESS (23.924s)
[333.181504] Starting dynamic subtest: vcs1
[356.684481] Dynamic subtest vcs1: SUCCESS (23.506s)
[356.695480] Starting dynamic subtest: vecs0
[380.627114] Dynamic subtest vecs0: SUCCESS (23.932s)
[380.639647] Starting dynamic subtest: ccs0
[404.456499] Dynamic subtest ccs0: SUCCESS (23.819s)
[404.457622] Subtest allocator-evict: SUCCESS (142.594s)
[404.549596] [062/131] (621s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[404.669083] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[404.670064] Starting dynamic subtest: pipe-A-eDP-1
[404.678383] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[404.689097] Starting dynamic subtest: pipe-B-eDP-1
[404.698136] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[404.705673] Starting dynamic subtest: pipe-C-eDP-1
[404.712767] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[404.719718] Starting dynamic subtest: pipe-D-eDP-1
[404.726813] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[404.727605] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[406.846275] [063/131] (619s left) kms_content_protection (content-type-change)
[407.000147] Starting subtest: content-type-change
[407.002153] Subtest content-type-change: SKIP (0.000s)
[407.165528] [064/131] (618s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[407.315710] Starting subtest: cursor-rapid-movement-32x10
[407.354671] Subtest cursor-rapid-movement-32x10: SKIP (0.036s)
[407.645913] [065/131] (618s left) syncobj_basic (bad-destroy)
[407.697195] Starting subtest: bad-destroy
[407.698101] Subtest bad-destroy: SUCCESS (0.000s)
[407.813860] [066/131] (618s left) kms_flip (bo-too-big-interruptible)
[407.906845] Starting subtest: bo-too-big-interruptible
[407.909405] Starting dynamic subtest: A-eDP1
[409.170735] Dynamic subtest A-eDP1: SUCCESS (1.261s)
[409.180227] Starting dynamic subtest: B-eDP1
[410.405724] Dynamic subtest B-eDP1: SUCCESS (1.232s)
[410.415565] Starting dynamic subtest: C-eDP1
[411.658420] Dynamic subtest C-eDP1: SUCCESS (1.250s)
[411.666214] Starting dynamic subtest: D-eDP1
[412.902837] Dynamic subtest D-eDP1: SUCCESS (1.243s)
[412.908195] Subtest bo-too-big-interruptible: SUCCESS (4.999s)
[414.124521] [067/131] (612s left) kms_pm_dc (dc6-dpms)
[415.237653] Starting subtest: dc6-dpms
[417.285418] Subtest dc6-dpms: SUCCESS (2.044s)
[417.379348] [068/131] (608s left) gen9_exec_parse (unaligned-jump)
[417.425049] Subtest unaligned-jump: SKIP (0.000s)
[417.494791] [069/131] (608s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[417.600117] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[418.537062] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.936s)
[418.721896] [070/131] (607s left) perf_pmu (init-wait)
[418.759145] Starting subtest: init-wait
[418.760252] Starting dynamic subtest: rcs0
[418.763057] Dynamic subtest rcs0: SUCCESS (0.002s)
[418.771993] Starting dynamic subtest: bcs0
[418.772870] Dynamic subtest bcs0: SUCCESS (0.000s)
[418.780068] Starting dynamic subtest: vcs0
[418.780935] Dynamic subtest vcs0: SUCCESS (0.001s)
[418.788245] Starting dynamic subtest: vcs1
[418.789190] Dynamic subtest vcs1: SUCCESS (0.001s)
[418.801046] Starting dynamic subtest: vecs0
[418.802033] Dynamic subtest vecs0: SUCCESS (0.000s)
[418.811622] Starting dynamic subtest: ccs0
[418.812499] Dynamic subtest ccs0: SUCCESS (0.000s)
[418.813382] Subtest init-wait: SUCCESS (0.009s)
[418.881065] [071/131] (607s left) kms_getfb (getfb-handle-not-fb)
[418.971856] Starting subtest: getfb-handle-not-fb
[418.972707] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[419.100277] [072/131] (607s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[419.155277] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[419.156208] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[419.282844] [073/131] (607s left) kms_dsc (dsc-with-bpc-formats)
[419.366518] Starting subtest: dsc-with-bpc-formats
[419.407980] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[419.457756] [074/131] (606s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[419.836158] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[420.635543] [075/131] (605s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[420.726893] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[420.728622] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[420.853915] [076/131] (605s left) syncobj_timeline (invalid-signal-zero-handles)
[420.913659] Starting subtest: invalid-signal-zero-handles
[420.914647] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[421.030148] [077/131] (605s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[421.116896] Starting subtest: addfb25-y-tiled-legacy
[421.117780] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[421.244199] [078/131] (605s left) gem_exec_fence (invalid-timeline-fence-array)
[421.839096] Starting subtest: invalid-timeline-fence-array
[421.843123] Subtest invalid-timeline-fence-array: SUCCESS (0.005s)
[423.254896] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[423.257218] [079/131] (603s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[423.318437] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[423.320330] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[423.516595] [080/131] (603s left) kms_psr (fbc-psr2-dpms)
[423.607020] Starting subtest: fbc-psr2-dpms
[423.607994] Starting dynamic subtest: eDP-1
[423.609950] Dynamic subtest eDP-1: SKIP (0.000s)
[423.611658] Subtest fbc-psr2-dpms: SKIP (0.001s)
[423.699528] [081/131] (602s left) gem_exec_alignment (many)
[423.752817] Starting subtest: many
[446.153899] Subtest many: SUCCESS (22.389s)
[448.293766] [082/131] (578s left) gem_mmap_offset (ptrace)
[448.377122] Starting subtest: ptrace
[448.383316] Starting dynamic subtest: smem0-wb
[448.403529] Dynamic subtest smem0-wb: SUCCESS (0.020s)
[448.412247] Starting dynamic subtest: smem0-wc
[448.424334] Dynamic subtest smem0-wc: SUCCESS (0.020s)
[448.433235] Starting dynamic subtest: smem0-uc
[448.445548] Dynamic subtest smem0-uc: SUCCESS (0.020s)
[448.446658] Subtest ptrace: SUCCESS (0.070s)
[448.601967] [083/131] (578s left) gem_exec_schedule (noreorder-priority)
[448.788030] Starting subtest: noreorder-priority
[448.789265] Starting dynamic subtest: rcs0
[449.956232] Dynamic subtest rcs0: SUCCESS (1.168s)
[449.967907] Starting dynamic subtest: vcs0
[451.190565] Dynamic subtest vcs0: SUCCESS (1.229s)
[451.200905] Starting dynamic subtest: vcs1
[453.178794] Dynamic subtest vcs1: SUCCESS (1.985s)
[453.189200] Starting dynamic subtest: vecs0
[455.158539] Dynamic subtest vecs0: SUCCESS (1.978s)
[455.175757] Starting dynamic subtest: ccs0
[456.309408] Dynamic subtest ccs0: SUCCESS (1.153s)
[456.310724] Subtest noreorder-priority: SUCCESS (7.524s)
[456.507562] [084/131] (570s left) gem_ctx_engines (execute-one)
[456.575041] Starting subtest: execute-one
[459.530944] Subtest execute-one: SUCCESS (2.961s)
[459.735871] [085/131] (567s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[459.854385] Starting subtest: flip-vs-cursor-legacy
[466.924394] Subtest flip-vs-cursor-legacy: SUCCESS (7.079s)
[467.803435] [086/131] (558s left) perf_pmu (busy-double-start)
[467.847711] Starting subtest: busy-double-start
[467.848505] Starting dynamic subtest: rcs0
[471.443285] Dynamic subtest rcs0: FAIL (3.579s)
[471.451655] Starting dynamic subtest: bcs0
[475.009064] Dynamic subtest bcs0: SUCCESS (3.589s)
[475.020171] Starting dynamic subtest: vcs0
[478.766877] Dynamic subtest vcs0: SUCCESS (3.759s)
[478.778395] Starting dynamic subtest: vcs1
[482.733982] Dynamic subtest vcs1: SUCCESS (3.968s)
[482.745794] Starting dynamic subtest: vecs0
[486.767184] Dynamic subtest vecs0: SUCCESS (4.033s)
[486.779638] Starting dynamic subtest: ccs0
[490.361149] Dynamic subtest ccs0: FAIL (3.569s)
[490.362035] Subtest busy-double-start: FAIL (22.508s)
[490.485163] [087/131] (536s left) gem_exec_alignment (single)
[490.543815] Starting subtest: single
[490.546137] Subtest single: SUCCESS (0.004s)
[490.704343] [088/131] (536s left) gem_exec_balancer (parallel)
[490.965131] Starting subtest: parallel
[491.872717] Subtest parallel: SUCCESS (0.909s)
[492.229790] [089/131] (534s left) kms_dp_aux_dev
[492.590946] [090/131] (534s left) kms_flip (basic-flip-vs-modeset)
[492.684639] Starting subtest: basic-flip-vs-modeset
[492.687112] Starting dynamic subtest: A-eDP1
[495.259376] Dynamic subtest A-eDP1: SUCCESS (2.574s)
[495.267344] Starting dynamic subtest: B-eDP1
[497.428334] Dynamic subtest B-eDP1: SUCCESS (2.169s)
[497.436767] Starting dynamic subtest: C-eDP1
[499.601049] Dynamic subtest C-eDP1: SUCCESS (2.172s)
[499.608898] Starting dynamic subtest: D-eDP1
[501.684252] Dynamic subtest D-eDP1: SUCCESS (2.083s)
[501.686289] Subtest basic-flip-vs-modeset: SUCCESS (9.005s)
[502.510668] [091/131] (524s left) gem_exec_capture (capture-recoverable)
[502.573174] Starting subtest: capture-recoverable
[502.574481] Subtest capture-recoverable: SUCCESS (0.003s)
[502.717920] [092/131] (524s left) gem_userptr_blits (create-destroy-sync)
[502.777268] Starting subtest: create-destroy-sync
[507.789673] Subtest create-destroy-sync: SUCCESS (5.011s)
[507.945174] [093/131] (519s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[508.053208] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[508.054850] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[508.156237] [094/131] (518s left) kms_mmap_write_crc (main)
[508.243940] Starting subtest: main
[508.244934] Starting dynamic subtest: pipe-A-eDP-1
[511.566067] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.322s)
[511.566885] Subtest main: SUCCESS (3.323s)
[512.432531] [095/131] (514s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[512.532234] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[512.533925] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[512.666473] [096/131] (514s left) kms_content_protection (srm)
[512.803574] Starting subtest: srm
[512.806998] Subtest srm: SKIP (0.002s)
[512.962680] [097/131] (514s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[513.078244] Starting subtest: cursorB-vs-flipA-toggle
[513.080979] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[513.240112] [098/131] (513s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[513.339120] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[513.340980] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[513.478191] [099/131] (513s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[513.571654] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[513.573651] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[513.700377] [100/131] (513s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[513.796321] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[513.798073] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[513.918204] [101/131] (513s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[514.033687] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[514.035469] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[514.153139] [102/131] (513s left) gem_mmap (bad-object)
[514.205639] Subtest bad-object: SKIP (0.000s)
[514.273823] [103/131] (513s left) kms_chamelium_frames (hdmi-aspect-ratio)
[514.647880] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[515.417885] [104/131] (511s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[515.507369] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[515.509243] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[515.621462] [105/131] (511s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[515.719635] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[516.666570] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.947s)
[516.828143] [106/131] (510s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[516.922270] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[516.924040] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[517.059582] [107/131] (510s left) gem_exec_params (rs-invalid)
[517.115580] Starting subtest: rs-invalid
[517.117615] Subtest rs-invalid: SUCCESS (0.003s)
[517.278912] [108/131] (510s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[517.391789] Starting subtest: x-tiled-64bpp-rotate-180
[518.824806] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.434s)
[519.054639] [109/131] (508s left) gem_mmap_offset (blt-coherency)
[519.117054] Starting subtest: blt-coherency
[519.123006] Subtest blt-coherency: SUCCESS (0.008s)
[519.286934] [110/131] (508s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[519.384863] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[520.385617] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.001s)
[520.564001] [111/131] (507s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[520.664924] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[520.666523] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[520.778938] [112/131] (506s left) gem_fence_thrash (bo-write-verify-threaded-none)
[520.810928] Starting subtest: bo-write-verify-threaded-none
[520.840656] Subtest bo-write-verify-threaded-none: SKIP (0.030s)
[520.916152] [113/131] (506s left) dmabuf_sync_file (import-basic)
[520.955538] Starting subtest: import-basic
[520.956528] Subtest import-basic: SUCCESS (0.001s)
[521.035421] [114/131] (506s left) gem_exec_whisper (basic-contexts-forked-all)
[521.109263] Starting subtest: basic-contexts-forked-all
[542.327439] Subtest basic-contexts-forked-all: SUCCESS (21.215s)
[542.529637] [115/131] (485s left) kms_vblank (ts-continuation-idle-hang)
[542.623989] Starting subtest: ts-continuation-idle-hang
[542.624860] Starting dynamic subtest: pipe-A-eDP-1
[569.053622] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.426s)
[569.066400] Starting dynamic subtest: pipe-D-eDP-1
[593.937973] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.880s)
[593.938991] Subtest ts-continuation-idle-hang: SUCCESS (51.310s)
[594.824988] [116/131] (432s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[594.920805] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[599.377678] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.458s)
[600.528878] [117/131] (427s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[600.618310] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[607.983805] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.367s)
[608.185617] [118/131] (419s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[613.212087] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[613.214028] Starting dynamic subtest: pipe-A-eDP-1
[619.732568] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.518s)
[619.741188] Starting dynamic subtest: pipe-B-eDP-1
[626.396688] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.661s)
[626.397584] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (13.184s)
[627.293832] [119/131] (400s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[627.356573] Starting subtest: mixed-tiled-to-y-tiled-ccs
[627.358579] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[627.561072] [120/131] (400s left) gem_exec_reloc (basic-cpu-read-active)
[627.618130] Subtest basic-cpu-read-active: SKIP (0.000s)
[627.688539] [121/131] (400s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[627.779421] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[627.780355] Starting dynamic subtest: pipe-A
[628.131068] Dynamic subtest pipe-A: SUCCESS (0.353s)
[628.139745] Starting dynamic subtest: pipe-B
[629.574020] Dynamic subtest pipe-B: SUCCESS (1.442s)
[629.590687] Starting dynamic subtest: pipe-C
[631.002451] Dynamic subtest pipe-C: SUCCESS (1.427s)
[631.010929] Starting dynamic subtest: pipe-D
[632.431766] Dynamic subtest pipe-D: SUCCESS (1.429s)
[632.432683] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.654s)
[633.623021] [122/131] (394s left) syncobj_wait (single-wait-for-submit-signaled)
[633.676606] Starting subtest: single-wait-for-submit-signaled
[633.677510] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[633.791465] [123/131] (394s left) gem_exec_params (no-blt)
[633.847771] Starting subtest: no-blt
[633.849390] Subtest no-blt: SUCCESS (0.003s)
[634.006352] [124/131] (394s left) kms_rotation_crc (bad-tiling)
[634.113003] Starting subtest: bad-tiling
[634.114899] Subtest bad-tiling: SKIP (0.001s)
[634.204486] [125/131] (393s left) kms_prime (basic-crc-vgem)
[634.294058] Starting subtest: basic-crc-vgem
[634.295185] Starting dynamic subtest: second-to-first
[635.263692] Dynamic subtest second-to-first: SUCCESS (0.971s)
[635.264577] Subtest basic-crc-vgem: SUCCESS (0.972s)
[635.366762] [126/131] (392s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[635.512718] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[635.513572] Starting dynamic subtest: pipe-A-default-mode
[635.798625] Dynamic subtest pipe-A-default-mode: SKIP (0.284s)
[635.800374] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.285s)
[636.647068] [127/131] (391s left) i915_pm_rpm (gem-pread)
[638.365054] Starting subtest: gem-pread
[640.215242] Subtest gem-pread: SUCCESS (1.853s)
[640.327326] [128/131] (387s left) gem_userptr_blits (userfault)
[640.401897] Starting subtest: userfault
[640.408662] Subtest userfault: SUCCESS (0.009s)
[640.550410] [129/131] (387s left) syncobj_timeline (multi-wait-signaled)
[640.616913] Starting subtest: multi-wait-signaled
[640.617877] Subtest multi-wait-signaled: SUCCESS (0.000s)
[640.730103] [130/131] (387s left) gem_exec_whisper (basic-sync-all)
[640.802114] Starting subtest: basic-sync-all
[647.089167] Subtest basic-sync-all: SUCCESS (6.285s)
[647.295188] [131/131] (381s left) drm_read (short-buffer-nonblock)
[647.441833] Starting subtest: short-buffer-nonblock
[647.442685] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[647.598343] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_barrier_race
results: parsing output: 4/ for test: api_intel_bb
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: gem_mmap_wc
results: parsing output: 8/ for test: gem_mmap_gtt
results: parsing output: 9/ for test: gem_render_copy
results: parsing output: 10/ for test: perf
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: kms_invalid_mode
results: parsing output: 13/ for test: i915_drm_fdinfo
results: parsing output: 14/ for test: kms_pipe_b_c_ivb
results: parsing output: 15/ for test: gen9_exec_parse
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: sysfs_timeslice_duration
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_flip_scaled_crc
results: parsing output: 21/ for test: gem_ctx_persistence
results: parsing output: 22/ for test: gem_ctx_param
results: parsing output: 23/ for test: kms_cursor_crc
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_ctx_persistence
results: parsing output: 27/ for test: kms_setmode
results: parsing output: 28/ for test: kms_psr2_sf
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_ccs
results: parsing output: 31/ for test: gem_exec_reloc
results: parsing output: 32/ for test: gem_tiled_pread_basic
results: parsing output: 33/ for test: kms_sequence
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: gem_ppgtt
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: kms_plane_scaling
results: parsing output: 38/ for test: gem_softpin
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_exec_schedule
results: parsing output: 42/ for test: kms_plane
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: kms_flip
results: parsing output: 45/ for test: api_intel_bb
results: parsing output: 46/ for test: sriov_basic
results: parsing output: 47/ for test: kms_psr2_sf
results: parsing output: 48/ for test: i915_suspend
results: parsing output: 49/ for test: gem_mmap_gtt
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_exec_flush
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_flip
results: parsing output: 54/ for test: core_setmaster_vs_auth
results: parsing output: 55/ for test: gem_userptr_blits
results: parsing output: 56/ for test: kms_scaling_modes
results: parsing output: 57/ for test: gem_exec_flush
results: parsing output: 58/ for test: perf
results: parsing output: 59/ for test: kms_lease
results: parsing output: 60/ for test: gem_softpin
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: kms_content_protection
results: parsing output: 63/ for test: kms_cursor_crc
results: parsing output: 64/ for test: syncobj_basic
results: parsing output: 65/ for test: kms_flip
results: parsing output: 66/ for test: kms_pm_dc
results: parsing output: 67/ for test: gen9_exec_parse
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: perf_pmu
results: parsing output: 70/ for test: kms_getfb
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: kms_dsc
results: parsing output: 73/ for test: kms_chamelium_hpd
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: kms_addfb_basic
results: parsing output: 77/ for test: gem_exec_fence
results: parsing output: 78/ for test: gem_render_copy
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: gem_exec_alignment
results: parsing output: 81/ for test: gem_mmap_offset
results: parsing output: 82/ for test: gem_exec_schedule
results: parsing output: 83/ for test: gem_ctx_engines
results: parsing output: 84/ for test: kms_cursor_legacy
results: parsing output: 85/ for test: perf_pmu
results: parsing output: 86/ for test: gem_exec_alignment
results: parsing output: 87/ for test: gem_exec_balancer
results: parsing output: 88/ for test: kms_dp_aux_dev
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: gem_exec_capture
results: parsing output: 91/ for test: gem_userptr_blits
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: kms_mmap_write_crc
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_content_protection
results: parsing output: 96/ for test: kms_cursor_legacy
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_mmap
results: parsing output: 102/ for test: kms_chamelium_frames
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_exec_params
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: gem_mmap_offset
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_fence_thrash
results: parsing output: 112/ for test: dmabuf_sync_file
results: parsing output: 113/ for test: gem_exec_whisper
results: parsing output: 114/ for test: kms_vblank
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_psr2_sf
results: parsing output: 118/ for test: gem_render_copy
results: parsing output: 119/ for test: gem_exec_reloc
results: parsing output: 120/ for test: kms_plane_scaling
results: parsing output: 121/ for test: syncobj_wait
results: parsing output: 122/ for test: gem_exec_params
results: parsing output: 123/ for test: kms_rotation_crc
results: parsing output: 124/ for test: kms_prime
results: parsing output: 125/ for test: kms_flip_scaled_crc
results: parsing output: 126/ for test: i915_pm_rpm
results: parsing output: 127/ for test: gem_userptr_blits
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: gem_exec_whisper
results: parsing output: 130/ for test: drm_read
Done.