[57.998170] Initializing watchdogs
[57.998217]   /dev/watchdog0
[58.012341] [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]
[58.016669] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.018846] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.021930] [001/131] (960s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[58.136985] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[58.139368] Starting dynamic subtest: pipe-A-eDP-1
[58.163767] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[58.177721] Starting dynamic subtest: pipe-B-eDP-1
[58.200650] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[58.207227] Starting dynamic subtest: pipe-C-eDP-1
[58.228821] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[58.236092] Starting dynamic subtest: pipe-D-eDP-1
[58.258216] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[58.262249] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.004s)
[60.436708] [002/131] (958s left) gem_create (create-clear)
[60.493631] Starting subtest: create-clear
[60.495766] Starting dynamic subtest: smem0
[93.370187] Dynamic subtest smem0: SUCCESS (32.843s)
[93.372342] Subtest create-clear: SUCCESS (32.844s)
[93.556278] [003/131] (925s left) gem_exec_schedule (pi-distinct-iova)
[93.747138] Starting subtest: pi-distinct-iova
[93.749147] Starting dynamic subtest: rcs0
[93.897033] Dynamic subtest rcs0: SUCCESS (0.151s)
[93.906841] Starting dynamic subtest: vcs0
[93.991041] Dynamic subtest vcs0: SUCCESS (0.094s)
[94.001699] Starting dynamic subtest: vcs1
[94.075267] Dynamic subtest vcs1: SUCCESS (0.084s)
[94.082908] Starting dynamic subtest: vecs0
[94.155296] Dynamic subtest vecs0: SUCCESS (0.080s)
[94.167496] Starting dynamic subtest: ccs0
[94.260484] Dynamic subtest ccs0: SUCCESS (0.105s)
[94.262919] Subtest pi-distinct-iova: SUCCESS (0.517s)
[95.400248] [004/131] (923s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[95.505809] Starting subtest: plane-upscale-20x20-with-modifiers
[95.508117] Starting dynamic subtest: pipe-A
[95.843354] Dynamic subtest pipe-A: SUCCESS (0.340s)
[95.851104] Starting dynamic subtest: pipe-B
[97.255789] Dynamic subtest pipe-B: SUCCESS (1.412s)
[97.265943] Starting dynamic subtest: pipe-C
[98.910489] Dynamic subtest pipe-C: SUCCESS (1.654s)
[98.920229] Starting dynamic subtest: pipe-D
[100.346584] Dynamic subtest pipe-D: SUCCESS (1.436s)
[100.348735] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.843s)
[101.515802] [005/131] (917s left) syncobj_wait (wait-for-submit-snapshot)
[101.576357] Starting subtest: wait-for-submit-snapshot
[101.658029] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[101.732648] [006/131] (916s left) kms_async_flips (test-cursor)
[101.820293] Starting subtest: test-cursor
[102.195428] Starting dynamic subtest: pipe-A-eDP-1
[103.012037] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.817s)
[103.396220] Starting dynamic subtest: pipe-B-eDP-1
[104.144411] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.754s)
[104.523177] Starting dynamic subtest: pipe-C-eDP-1
[105.266113] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.749s)
[105.637031] Starting dynamic subtest: pipe-D-eDP-1
[106.396354] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.767s)
[106.398746] Subtest test-cursor: SUCCESS (4.578s)
[107.573251] [007/131] (911s left) gem_exec_whisper (basic-contexts-all)
[107.636767] Starting subtest: basic-contexts-all
[119.207766] Subtest basic-contexts-all: SUCCESS (11.566s)
[119.400655] [008/131] (899s left) gem_exec_params (sol-reset-invalid)
[119.456942] Starting subtest: sol-reset-invalid
[119.459373] Subtest sol-reset-invalid: SUCCESS (0.005s)
[121.377560] [009/131] (897s left) sysfs_timeslice_duration (timeout)
[121.435526] Starting subtest: timeout
[121.437701] Starting dynamic subtest: vecs0
[131.264308] Dynamic subtest vecs0: SUCCESS (9.825s)
[131.277366] Starting dynamic subtest: ccs0
[132.584348] Dynamic subtest ccs0: SUCCESS (1.320s)
[132.592831] Starting dynamic subtest: vcs0
[142.281080] Dynamic subtest vcs0: SUCCESS (9.692s)
[142.291786] Starting dynamic subtest: bcs0
[142.872854] Dynamic subtest bcs0: SUCCESS (0.595s)
[142.881076] Starting dynamic subtest: rcs0
[144.080261] Dynamic subtest rcs0: SUCCESS (1.206s)
[144.089561] Starting dynamic subtest: vcs1
[153.283811] Dynamic subtest vcs1: SUCCESS (9.201s)
[153.286072] Subtest timeout: SUCCESS (31.845s)
[153.368046] [010/131] (865s left) kms_chamelium_hpd (dp-hpd)
[153.754294] Subtest dp-hpd: SKIP (0.000s)
[154.573860] [011/131] (864s left) gen9_exec_parse (unaligned-access)
[154.631104] Subtest unaligned-access: SKIP (0.000s)
[154.697553] [012/131] (864s left) perf_pmu (render-node-busy-idle)
[154.763774] Starting subtest: render-node-busy-idle
[154.766210] Starting dynamic subtest: rcs0
[155.457471] Dynamic subtest rcs0: SUCCESS (0.693s)
[155.467844] Starting dynamic subtest: bcs0
[156.123982] Dynamic subtest bcs0: SUCCESS (0.666s)
[156.135882] Starting dynamic subtest: vcs0
[157.319515] Dynamic subtest vcs0: SUCCESS (1.193s)
[157.331187] Starting dynamic subtest: vcs1
[159.302437] Dynamic subtest vcs1: SUCCESS (1.981s)
[159.312058] Starting dynamic subtest: vecs0
[161.286999] Dynamic subtest vecs0: SUCCESS (1.983s)
[161.296382] Starting dynamic subtest: ccs0
[161.953261] Dynamic subtest ccs0: SUCCESS (0.667s)
[161.955771] Subtest render-node-busy-idle: SUCCESS (7.190s)
[162.028214] [013/131] (856s left) kms_psr (fbc-pr-cursor-plane-onoff)
[162.124064] Starting subtest: fbc-pr-cursor-plane-onoff
[162.128558] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[162.195323] [014/131] (856s left) kms_color (ctm-signed)
[162.275317] Starting subtest: ctm-signed
[162.277280] Starting dynamic subtest: pipe-A-eDP-1
[164.375500] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.099s)
[164.385750] Starting dynamic subtest: pipe-B-eDP-1
[167.152868] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.777s)
[167.161749] Starting dynamic subtest: pipe-C-eDP-1
[169.868067] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.716s)
[169.877556] Starting dynamic subtest: pipe-D-eDP-1
[172.533304] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.665s)
[172.535601] Subtest ctm-signed: SUCCESS (10.259s)
[173.356104] [015/131] (845s left) kms_cursor_crc (cursor-onscreen-128x42)
[173.580324] Starting subtest: cursor-onscreen-128x42
[173.627050] Subtest cursor-onscreen-128x42: SKIP (0.043s)
[173.827251] [016/131] (845s left) sriov_basic (bind-unbind-vf)
[173.887776] Starting subtest: bind-unbind-vf
[173.890188] Starting dynamic subtest: vf-1
[173.960791] Dynamic subtest vf-1: FAIL (0.021s)
[173.969408] Starting dynamic subtest: vf-2
[174.042507] Dynamic subtest vf-2: FAIL (0.004s)
[174.052509] Starting dynamic subtest: vf-3
[174.126078] Dynamic subtest vf-3: FAIL (0.004s)
[174.135743] Starting dynamic subtest: vf-4
[174.211077] Dynamic subtest vf-4: FAIL (0.003s)
[174.229373] Starting dynamic subtest: vf-5
[174.303952] Dynamic subtest vf-5: FAIL (0.006s)
[174.315054] Starting dynamic subtest: vf-6
[174.374897] Dynamic subtest vf-6: FAIL (0.004s)
[174.384094] Starting dynamic subtest: vf-7
[174.444351] Dynamic subtest vf-7: FAIL (0.004s)
[174.451878] Starting dynamic subtest: vf-random
[174.509127] Dynamic subtest vf-random: FAIL (0.004s)
[174.517070] Starting dynamic subtest: vf-last
[174.575623] Dynamic subtest vf-last: FAIL (0.497s)
[174.577525] Subtest bind-unbind-vf: FAIL (0.551s)
[174.611792] [017/131] (844s left) gem_ctx_param (invalid-set-ringsize)
[174.665767] Starting subtest: invalid-set-ringsize
[174.667858] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[174.747510] [018/131] (844s left) kms_busy (basic)
[174.844189] Starting subtest: basic
[174.846073] Starting dynamic subtest: flip
[175.468614] Dynamic subtest flip: SUCCESS (0.623s)
[175.477609] Starting dynamic subtest: modeset
[179.117708] Dynamic subtest modeset: SUCCESS (3.648s)
[179.119898] Subtest basic: SUCCESS (4.273s)
[179.907763] [019/131] (839s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[180.011041] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[180.015551] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[181.131205] [020/131] (838s left) kms_psr (psr-cursor-mmap-gtt)
[181.245355] Starting subtest: psr-cursor-mmap-gtt
[181.247678] Starting dynamic subtest: eDP-1
[182.929800] Dynamic subtest eDP-1: SUCCESS (1.682s)
[182.932080] Subtest psr-cursor-mmap-gtt: SUCCESS (1.683s)
[183.788097] [021/131] (835s left) i915_selftest (perf)
[185.561959] Starting subtest: perf
[185.564465] Starting dynamic subtest: engine_cs
[189.899306] Dynamic subtest engine_cs: SUCCESS (4.337s)
[189.908250] Starting dynamic subtest: request
[197.220390] Dynamic subtest request: SUCCESS (7.320s)
[197.234281] Starting dynamic subtest: migrate
[201.557684] Dynamic subtest migrate: SUCCESS (4.336s)
[201.566663] Starting dynamic subtest: region
[207.216560] Dynamic subtest region: SUCCESS (5.658s)
[207.219219] Subtest perf: SUCCESS (21.655s)
[207.246498] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[207.249582] [022/131] (812s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[208.822832] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[215.666119] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.846s)
[215.807687] [FACT kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)] new: kernel.kmod_is_loaded.i915: true
[215.811442] [023/131] (803s left) sw_sync (sync_multi_timeline_wait)
[215.854234] Starting subtest: sync_multi_timeline_wait
[215.856552] Subtest sync_multi_timeline_wait: SUCCESS (0.001s)
[215.922885] [024/131] (803s left) gem_shrink (reclaim)
[215.981942] Starting subtest: reclaim
[218.364640] Subtest reclaim: SUCCESS (2.378s)
[218.515874] [025/131] (800s left) syncobj_basic (bad-destroy)
[218.563244] Starting subtest: bad-destroy
[218.565523] Subtest bad-destroy: SUCCESS (0.000s)
[218.650656] [026/131] (800s left) gem_bad_reloc (negative-reloc-lut)
[218.701737] Subtest negative-reloc-lut: SKIP (0.000s)
[218.763294] [027/131] (800s left) syncobj_basic (bad-destroy-pad)
[218.802481] Starting subtest: bad-destroy-pad
[218.804736] Subtest bad-destroy-pad: SUCCESS (0.000s)
[218.895678] [028/131] (800s left) gem_spin_batch (spin-all-new)
[218.950467] Starting subtest: spin-all-new
[218.976630] Subtest spin-all-new: SUCCESS (0.026s)
[220.348511] [029/131] (799s left) gem_exec_whisper (basic-queues-forked-all)
[220.410095] Starting subtest: basic-queues-forked-all
[240.666976] Subtest basic-queues-forked-all: SUCCESS (20.252s)
[240.857025] [030/131] (778s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[240.925632] Starting subtest: x-tiled-to-vebox-yf-tiled
[240.929808] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[241.102809] [031/131] (778s left) kms_cdclk (plane-scaling)
[241.196041] Starting subtest: plane-scaling
[241.198445] Starting dynamic subtest: pipe-A-eDP-1
[241.487176] Dynamic subtest pipe-A-eDP-1: SKIP (0.289s)
[241.496067] Starting dynamic subtest: pipe-B-eDP-1
[241.500405] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[241.509691] Starting dynamic subtest: pipe-C-eDP-1
[241.514174] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[241.523225] Starting dynamic subtest: pipe-D-eDP-1
[241.527613] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[241.531878] Subtest plane-scaling: SKIP (0.297s)
[242.276915] [032/131] (777s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[242.378690] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[242.383232] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[242.477337] [033/131] (777s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[242.579832] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[242.584202] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[242.694553] [034/131] (777s left) kms_plane_multiple (tiling-yf)
[242.781196] Starting subtest: tiling-yf
[242.785206] Subtest tiling-yf: SKIP (0.000s)
[242.849405] [035/131] (776s left) dmabuf (all-tests)
[242.885821] Starting subtest: all-tests
[242.890773] Subtest all-tests: SKIP (0.000s)
[242.940593] [036/131] (776s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[243.031571] Starting subtest: pixel-format-linear-modifier-source-clamping
[243.057783] Starting dynamic subtest: pipe-A-plane-0
[246.635265] Dynamic subtest pipe-A-plane-0: SUCCESS (3.578s)
[246.643882] Starting dynamic subtest: pipe-A-plane-3
[248.335329] Dynamic subtest pipe-A-plane-3: SUCCESS (1.699s)
[249.458722] Starting dynamic subtest: pipe-B-plane-0
[253.029140] Dynamic subtest pipe-B-plane-0: SUCCESS (3.578s)
[253.037520] Starting dynamic subtest: pipe-B-plane-3
[254.684247] Dynamic subtest pipe-B-plane-3: SUCCESS (1.655s)
[255.007580] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (11.977s)
[255.830056] [037/131] (764s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[255.941385] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[255.945580] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[256.034471] [038/131] (763s left) kms_draw_crc (draw-method-pwrite)
[256.129171] Starting subtest: draw-method-pwrite
[256.131334] Starting dynamic subtest: xrgb8888-untiled
[256.693634] Dynamic subtest xrgb8888-untiled: SUCCESS (0.566s)
[256.703036] Starting dynamic subtest: rgb565-untiled
[257.127542] Dynamic subtest rgb565-untiled: SUCCESS (0.433s)
[257.138098] Starting dynamic subtest: xrgb2101010-untiled
[257.672755] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.544s)
[257.681770] Starting dynamic subtest: xbgr16161616f-untiled
[258.416647] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.744s)
[258.425796] Starting dynamic subtest: xrgb8888-xtiled
[260.205076] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.788s)
[260.218956] Starting dynamic subtest: rgb565-xtiled
[261.271651] Dynamic subtest rgb565-xtiled: SUCCESS (1.066s)
[261.280995] Starting dynamic subtest: xrgb2101010-xtiled
[263.060615] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.788s)
[263.070563] Starting dynamic subtest: xbgr16161616f-xtiled
[266.338462] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.277s)
[266.347840] Starting dynamic subtest: xrgb8888-4tiled
[267.427374] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.088s)
[267.437208] Starting dynamic subtest: rgb565-4tiled
[267.994088] Dynamic subtest rgb565-4tiled: SUCCESS (0.566s)
[268.003812] Starting dynamic subtest: xrgb2101010-4tiled
[269.083043] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.087s)
[269.092414] Starting dynamic subtest: xbgr16161616f-4tiled
[272.027431] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.944s)
[272.029801] Subtest draw-method-pwrite: SUCCESS (15.900s)
[272.117491] [039/131] (747s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[272.220648] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[272.224937] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[272.327946] [040/131] (747s left) perf_pmu (busy-check-all)
[272.365899] Starting subtest: busy-check-all
[272.367936] Starting dynamic subtest: rcs0
[272.918565] Dynamic subtest rcs0: SUCCESS (0.554s)
[272.932754] Starting dynamic subtest: bcs0
[273.469598] Dynamic subtest bcs0: SUCCESS (0.549s)
[273.483099] Starting dynamic subtest: vcs0
[275.270654] Dynamic subtest vcs0: SUCCESS (1.797s)
[275.283147] Starting dynamic subtest: vcs1
[277.319338] Dynamic subtest vcs1: SUCCESS (2.045s)
[277.334046] Starting dynamic subtest: vecs0
[279.303327] Dynamic subtest vecs0: SUCCESS (1.981s)
[279.315874] Starting dynamic subtest: ccs0
[279.858998] Dynamic subtest ccs0: SUCCESS (0.555s)
[279.861918] Subtest busy-check-all: SUCCESS (7.496s)
[279.959958] [041/131] (740s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[280.069425] Starting subtest: x-tiled-8bpp-rotate-90
[280.089887] Subtest x-tiled-8bpp-rotate-90: SKIP (0.020s)
[280.214492] [042/131] (739s left) kms_hdr (invalid-hdr)
[280.307344] Starting subtest: invalid-hdr
[282.439326] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[285.430672] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (2.992s)
[286.545344] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[289.537354] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (3.003s)
[289.539536] Subtest invalid-hdr: SUCCESS (9.232s)
[289.667601] [043/131] (730s left) kms_flip (2x-dpms-vs-vblank-race)
[289.769653] Starting subtest: 2x-dpms-vs-vblank-race
[289.778289] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s)
[289.890653] [044/131] (730s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[289.974860] Starting subtest: psr-2p-pri-indfb-multidraw
[289.979228] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[290.076157] [045/131] (730s left) kms_lease (lease-invalid-connector)
[290.166978] Starting subtest: lease-invalid-connector
[290.169123] Starting dynamic subtest: pipe-A-eDP-1
[290.171431] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[290.180721] Starting dynamic subtest: pipe-B-eDP-1
[290.182955] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[290.191610] Starting dynamic subtest: pipe-C-eDP-1
[290.193851] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[290.202315] Starting dynamic subtest: pipe-D-eDP-1
[290.204672] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[290.206959] Subtest lease-invalid-connector: SUCCESS (0.004s)
[290.243022] [046/131] (730s left) gem_ppgtt (shrink-vs-evict-pinned)
[290.297787] Starting subtest: shrink-vs-evict-pinned
[298.237358] Subtest shrink-vs-evict-pinned: SUCCESS (7.938s)
[298.324311] [047/131] (721s left) kms_frontbuffer_tracking (psr-suspend)
[298.425075] Starting subtest: psr-suspend
[336.662911] Subtest psr-suspend: SUCCESS (8.093s)
[336.764251] [048/131] (683s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[336.873110] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[337.887671] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.002s)
[338.033866] [049/131] (682s left) gem_madvise (dontneed-before-pwrite)
[338.071319] Starting subtest: dontneed-before-pwrite
[338.100642] Subtest dontneed-before-pwrite: SKIP (0.026s)
[338.158486] [050/131] (682s left) kms_cursor_crc (cursor-random-256x256)
[338.414907] Starting subtest: cursor-random-256x256
[338.416815] Starting dynamic subtest: pipe-A-eDP-1
[341.783665] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.334s)
[341.818141] Starting dynamic subtest: pipe-D-eDP-1
[345.852326] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.016s)
[345.854660] Subtest cursor-random-256x256: SUCCESS (7.380s)
[346.702972] [051/131] (673s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[346.827129] Starting subtest: cursor-vs-flip-varying-size
[378.050148] Subtest cursor-vs-flip-varying-size: SUCCESS (31.191s)
[378.861638] [052/131] (641s left) gem_mmap_offset (mmap-boundaries)
[378.931669] Starting subtest: mmap-boundaries
[378.933641] Starting dynamic subtest: smem0
[379.214707] Dynamic subtest smem0: SUCCESS (0.284s)
[379.217714] Subtest mmap-boundaries: SUCCESS (0.285s)
[379.364999] [053/131] (641s left) gem_mmap_gtt (basic-write)
[379.413497] Subtest basic-write: SKIP (0.000s)
[379.466615] [054/131] (641s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[379.516367] Starting subtest: single-wait-for-submit-available-signaled
[379.518299] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[379.603901] [055/131] (641s left) api_intel_bb (blit-reloc-purge-cache)
[379.653966] Starting subtest: blit-reloc-purge-cache
[379.658400] Subtest blit-reloc-purge-cache: SKIP (0.000s)
[379.792482] [056/131] (640s left) kms_pm_lpsp (screens-disabled)
[380.893222] Starting subtest: screens-disabled
[380.897551] Subtest screens-disabled: SKIP (0.000s)
[380.980697] [057/131] (639s left) kms_addfb_basic (bad-pitch-1024)
[381.031977] Starting subtest: bad-pitch-1024
[381.034516] Subtest bad-pitch-1024: SUCCESS (0.000s)
[381.171844] [058/131] (639s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[381.257301] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[381.261380] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[381.357795] [059/131] (639s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[381.470349] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[381.474470] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[381.558812] [060/131] (639s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[381.648310] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[381.653167] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[382.800893] [061/131] (638s left) perf (rc6-disable)
[382.922752] Starting subtest: rc6-disable
[383.095822] Subtest rc6-disable: SUCCESS (0.173s)
[383.136608] [062/131] (637s left) syncobj_wait (invalid-reset-zero-handles)
[383.193752] Starting subtest: invalid-reset-zero-handles
[383.196014] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[383.306402] [063/131] (637s left) gem_exec_params (larger-than-life-batch)
[383.364065] Starting subtest: larger-than-life-batch
[385.734343] Subtest larger-than-life-batch: SUCCESS (2.368s)
[386.473595] [064/131] (634s left) kms_big_fb (linear-32bpp-rotate-180)
[386.624017] Starting subtest: linear-32bpp-rotate-180
[388.214828] Subtest linear-32bpp-rotate-180: SUCCESS (1.590s)
[388.338176] [065/131] (632s left) gem_mmap_wc (write-read)
[388.386438] Subtest write-read: SKIP (0.000s)
[388.452782] [066/131] (632s left) kms_cursor_legacy (torture-bo)
[388.571167] Starting subtest: torture-bo
[388.572735] Starting dynamic subtest: pipe-A
[395.045435] Dynamic subtest pipe-A: SUCCESS (6.469s)
[395.059037] Starting dynamic subtest: pipe-B
[401.497582] Dynamic subtest pipe-B: SUCCESS (6.450s)
[401.511024] Starting dynamic subtest: pipe-C
[408.360438] Dynamic subtest pipe-C: SUCCESS (6.857s)
[408.372873] Starting dynamic subtest: pipe-D
[413.994207] Dynamic subtest pipe-D: SUCCESS (5.630s)
[414.010831] Starting dynamic subtest: all-pipes
[421.754848] Dynamic subtest all-pipes: SUCCESS (7.755s)
[421.757407] Subtest torture-bo: SUCCESS (33.173s)
[421.913602] [067/131] (599s left) gem_userptr_blits (create-destroy-sync)
[421.980250] Starting subtest: create-destroy-sync
[426.989510] Subtest create-destroy-sync: SUCCESS (5.009s)
[427.110615] [068/131] (594s left) gem_mmap_gtt (basic-short)
[427.158256] Subtest basic-short: SKIP (0.000s)
[427.215135] [069/131] (593s left) gem_mmap_wc (write)
[427.267481] Subtest write: SKIP (0.000s)
[427.328072] [070/131] (593s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[427.427736] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[427.430162] Starting dynamic subtest: pipe-A-eDP-1
[427.455957] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[427.468658] Starting dynamic subtest: pipe-B-eDP-1
[427.491356] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[427.501384] Starting dynamic subtest: pipe-C-eDP-1
[427.524898] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[427.536508] Starting dynamic subtest: pipe-D-eDP-1
[427.560518] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[427.565265] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[429.586329] [071/131] (591s left) kms_cursor_crc (cursor-sliding-max-size)
[429.898246] Starting subtest: cursor-sliding-max-size
[429.904635] Subtest cursor-sliding-max-size: SKIP (0.000s)
[430.036821] [072/131] (591s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[430.100409] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[430.207153] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.105s)
[430.286101] [073/131] (591s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[430.389595] Starting subtest: nonblocking-crc-frame-sequence
[430.391826] Starting dynamic subtest: pipe-A-eDP-1
[431.134751] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.744s)
[431.146855] Starting dynamic subtest: pipe-B-eDP-1
[432.507826] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.369s)
[432.518716] Starting dynamic subtest: pipe-C-eDP-1
[433.901608] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.392s)
[433.913144] Starting dynamic subtest: pipe-D-eDP-1
[435.246290] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.343s)
[435.248261] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.856s)
[436.042971] [074/131] (585s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[436.140920] Starting subtest: plane-all-modeset-transition-internal-panels
[436.142806] Starting dynamic subtest: pipe-A-eDP-1
[437.489623] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.348s)
[437.776950] Starting dynamic subtest: pipe-B-eDP-1
[438.818415] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.051s)
[439.093458] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.954s)
[439.941938] [075/131] (581s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[439.993595] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[440.102683] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.108s)
[440.187725] [076/131] (581s left) gem_lmem_swapping (parallel-random-verify-ccs)
[440.228829] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[440.273208] [077/131] (581s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[440.365866] Starting subtest: pr-overlay-plane-move-continuous-sf
[440.370093] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[440.429082] [078/131] (581s left) gem_exec_balancer (nohangcheck)
[440.691571] Starting subtest: nohangcheck
[441.589791] Subtest nohangcheck: SUCCESS (0.897s)
[441.731510] [079/131] (579s left) api_intel_bb (full-batch)
[441.786753] Starting subtest: full-batch
[441.791895] Subtest full-batch: SUCCESS (0.006s)
[441.923499] [080/131] (579s left) gen9_exec_parse (basic-rejected)
[441.992537] Subtest basic-rejected: SKIP (0.000s)
[442.075785] [081/131] (579s left) gem_mmap_gtt (medium-copy)
[442.128865] Subtest medium-copy: SKIP (0.000s)
[442.194277] [082/131] (579s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[442.298610] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[442.302916] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[442.395095] [083/131] (579s left) gem_sync (basic-store-all)
[442.469241] Starting subtest: basic-store-all
[445.174620] Subtest basic-store-all: SUCCESS (2.716s)
[445.358899] [084/131] (576s left) gem_ctx_bad_destroy (invalid-default-ctx)
[445.425843] Starting subtest: invalid-default-ctx
[445.428095] Subtest invalid-default-ctx: SUCCESS (0.000s)
[445.496690] [085/131] (576s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[445.581743] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[445.583934] Starting dynamic subtest: pipe-A-default-mode
[448.290360] Dynamic subtest pipe-A-default-mode: SUCCESS (2.709s)
[448.292738] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.710s)
[449.131945] [086/131] (572s left) kms_chamelium_frames (dp-crc-single)
[449.512434] Subtest dp-crc-single: SKIP (0.000s)
[450.336949] [087/131] (571s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[450.440344] Starting subtest: yf-tiled-addfb-size-offset-overflow
[450.444892] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[450.564690] [088/131] (571s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[450.658002] Starting subtest: fbc-psr2-sprite-plane-onoff
[450.659892] Starting dynamic subtest: eDP-1
[450.664005] Dynamic subtest eDP-1: SKIP (0.000s)
[450.668074] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[450.739853] [089/131] (571s left) gem_exec_parallel (basic)
[450.804651] Starting subtest: basic
[450.807120] Starting dynamic subtest: rcs0
[452.284731] Dynamic subtest rcs0: SUCCESS (1.479s)
[452.298264] Starting dynamic subtest: bcs0
[453.781808] Dynamic subtest bcs0: SUCCESS (1.496s)
[453.792441] Starting dynamic subtest: vcs0
[455.442674] Dynamic subtest vcs0: SUCCESS (1.657s)
[455.458357] Starting dynamic subtest: vcs1
[457.394863] Dynamic subtest vcs1: SUCCESS (1.950s)
[457.408617] Starting dynamic subtest: vecs0
[459.377049] Dynamic subtest vecs0: SUCCESS (1.980s)
[459.389396] Starting dynamic subtest: ccs0
[460.879300] Dynamic subtest ccs0: SUCCESS (1.500s)
[460.881835] Subtest basic: SUCCESS (10.074s)
[461.096837] [090/131] (560s left) prime_mmap (test_reprime)
[461.148159] Starting subtest: test_reprime
[461.150173] Starting dynamic subtest: test_reprime-smem
[461.178631] Dynamic subtest test_reprime-smem: SUCCESS (0.031s)
[461.181095] Subtest test_reprime: SUCCESS (0.032s)
[461.309115] [091/131] (560s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[461.358051] Starting subtest: invalid-single-wait-all-unsubmitted
[461.360367] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[461.456257] [092/131] (560s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[461.553473] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[468.649312] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.097s)
[468.759003] [093/131] (553s left) perf (low-oa-exponent-permissions)
[468.866528] Starting subtest: low-oa-exponent-permissions
[468.902845] Subtest low-oa-exponent-permissions: SUCCESS (0.036s)
[468.950067] [094/131] (553s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[469.037939] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[469.041917] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[469.136235] [095/131] (553s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[469.188469] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[469.257088] [096/131] (553s left) kms_flip (basic-flip-vs-dpms)
[469.351134] Starting subtest: basic-flip-vs-dpms
[469.353402] Starting dynamic subtest: A-eDP1
[471.880339] Dynamic subtest A-eDP1: SUCCESS (2.529s)
[471.891884] Starting dynamic subtest: B-eDP1
[474.058927] Dynamic subtest B-eDP1: SUCCESS (2.175s)
[474.073110] Starting dynamic subtest: C-eDP1
[476.130561] Dynamic subtest C-eDP1: SUCCESS (2.070s)
[476.142365] Starting dynamic subtest: D-eDP1
[478.229688] Dynamic subtest D-eDP1: SUCCESS (2.098s)
[478.231997] Subtest basic-flip-vs-dpms: SUCCESS (8.882s)
[479.032098] [097/131] (543s left) kms_prop_blob (invalid-set-prop-any)
[479.088416] Starting subtest: invalid-set-prop-any
[479.090826] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[479.199299] [098/131] (543s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[479.295808] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[479.299875] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s)
[479.368180] [099/131] (543s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[479.454892] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[479.457160] Starting dynamic subtest: pipe-A
[479.474705] Dynamic subtest pipe-A: SKIP (0.016s)
[479.485947] Starting dynamic subtest: pipe-B
[479.506435] Dynamic subtest pipe-B: SKIP (0.030s)
[479.520370] Starting dynamic subtest: pipe-C
[479.536598] Dynamic subtest pipe-C: SKIP (0.030s)
[479.549064] Starting dynamic subtest: pipe-D
[479.567368] Dynamic subtest pipe-D: SKIP (0.030s)
[479.571657] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.109s)
[479.673727] [100/131] (542s left) gem_exec_schedule (promotion)
[479.745199] Starting subtest: promotion
[479.747502] Starting dynamic subtest: rcs0
[479.838817] Dynamic subtest rcs0: SUCCESS (0.102s)
[479.853986] Starting dynamic subtest: vcs0
[479.924510] Dynamic subtest vcs0: SUCCESS (0.084s)
[479.944684] Starting dynamic subtest: vcs1
[480.004415] Dynamic subtest vcs1: SUCCESS (0.080s)
[480.018559] Starting dynamic subtest: vecs0
[480.087784] Dynamic subtest vecs0: SUCCESS (0.082s)
[480.104686] Starting dynamic subtest: ccs0
[480.175666] Dynamic subtest ccs0: SUCCESS (0.087s)
[480.178106] Subtest promotion: SUCCESS (0.440s)
[481.496311] [101/131] (540s left) kms_psr (fbc-psr2-cursor-render)
[481.592578] Starting subtest: fbc-psr2-cursor-render
[481.594977] Starting dynamic subtest: eDP-1
[481.599456] Dynamic subtest eDP-1: SKIP (0.000s)
[481.603911] Subtest fbc-psr2-cursor-render: SKIP (0.001s)
[481.662310] [102/131] (540s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[481.748919] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[481.752803] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[481.843356] [103/131] (540s left) kms_scaling_modes (scaling-mode-full)
[481.943786] Starting subtest: scaling-mode-full
[481.945648] Starting dynamic subtest: pipe-A-eDP-1
[482.038477] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.097s)
[482.051081] Starting dynamic subtest: pipe-B-eDP-1
[483.267752] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.226s)
[483.281631] Starting dynamic subtest: pipe-C-eDP-1
[484.384861] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.118s)
[484.397804] Starting dynamic subtest: pipe-D-eDP-1
[485.514537] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.128s)
[485.516894] Subtest scaling-mode-full: SUCCESS (3.573s)
[486.680840] [104/131] (535s left) kms_joiner (invalid-modeset-big-joiner)
[486.783714] Starting subtest: invalid-modeset-big-joiner
[486.787868] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[486.853910] [105/131] (535s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[486.944499] Starting subtest: fbcpsr-indfb-scaledprimary
[492.783635] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.840s)
[492.923077] [106/131] (529s left) gem_exec_fence (syncobj-export)
[493.421667] Starting subtest: syncobj-export
[493.424043] Subtest syncobj-export: SUCCESS (0.005s)
[494.546593] [FACT gem_exec_fence (syncobj-export)] new: kernel.kmod_is_loaded.vgem: true
[494.551972] [107/131] (528s left) gem_render_copy_redux (normal)
[494.619836] Starting subtest: normal
[494.871710] Subtest normal: SUCCESS (0.250s)
[494.986920] [108/131] (527s left) gem_userptr_blits (userfault)
[495.053983] Starting subtest: userfault
[495.055861] Subtest userfault: SUCCESS (0.009s)
[495.189036] [109/131] (527s left) gem_ctx_persistence (heartbeat-stop)
[495.249497] Starting subtest: heartbeat-stop
[495.254010] Subtest heartbeat-stop: SKIP (0.000s)
[495.375616] [110/131] (527s left) gem_mmap_gtt (basic-small-bo-tiledy)
[495.437110] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[495.504903] [111/131] (527s left) gem_exec_create (legacy)
[495.560137] Starting subtest: legacy
[495.562071] Starting dynamic subtest: smem
[497.656472] Dynamic subtest smem: SUCCESS (2.095s)
[497.658951] Subtest legacy: SUCCESS (2.096s)
[497.843803] [112/131] (525s left) i915_hangman (engine-error-state-capture)
[497.922317] Starting subtest: engine-error-state-capture
[497.924476] Starting dynamic subtest: rcs0
[501.395292] Dynamic subtest rcs0: SUCCESS (3.472s)
[501.409812] Starting dynamic subtest: bcs0
[507.409818] Dynamic subtest bcs0: SUCCESS (6.009s)
[507.424149] Starting dynamic subtest: vcs0
[512.401062] Dynamic subtest vcs0: SUCCESS (4.987s)
[512.414555] Starting dynamic subtest: vcs1
[518.351969] Dynamic subtest vcs1: SUCCESS (5.946s)
[518.364690] Starting dynamic subtest: vecs0
[523.408998] Dynamic subtest vecs0: SUCCESS (5.053s)
[523.423365] Starting dynamic subtest: ccs0
[529.359930] Dynamic subtest ccs0: SUCCESS (5.946s)
[529.363476] Subtest engine-error-state-capture: SUCCESS (31.430s)
[529.440562] [113/131] (493s left) kms_flip (blocking-absolute-wf_vblank)
[529.534339] Starting subtest: blocking-absolute-wf_vblank
[529.536653] Starting dynamic subtest: A-eDP1
[538.288769] Dynamic subtest A-eDP1: SUCCESS (8.754s)
[538.299832] Starting dynamic subtest: B-eDP1
[547.033037] Dynamic subtest B-eDP1: SUCCESS (8.740s)
[547.049398] Starting dynamic subtest: C-eDP1
[555.757719] Dynamic subtest C-eDP1: SUCCESS (8.719s)
[555.769450] Starting dynamic subtest: D-eDP1
[564.491407] Dynamic subtest D-eDP1: SUCCESS (8.733s)
[564.493821] Subtest blocking-absolute-wf_vblank: SUCCESS (34.956s)
[565.705893] [114/131] (457s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[565.801481] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[565.805524] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[565.891934] [115/131] (457s left) gem_exec_reloc (basic-write-wc)
[565.938218] Subtest basic-write-wc: SKIP (0.000s)
[566.010993] [116/131] (457s left) kms_vblank (query-idle-hang)
[566.107697] Starting subtest: query-idle-hang
[566.109902] Starting dynamic subtest: pipe-A-eDP-1
[592.169526] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.066s)
[592.189064] Starting dynamic subtest: pipe-D-eDP-1
[617.197597] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.026s)
[617.199983] Subtest query-idle-hang: SUCCESS (51.097s)
[618.057087] [117/131] (405s left) kms_setmode (invalid-clone-single-crtc-stealing)
[618.117747] Starting subtest: invalid-clone-single-crtc-stealing
[618.124112] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[618.212528] [118/131] (405s left) kms_cursor_crc (cursor-alpha-opaque)
[618.295941] Starting subtest: cursor-alpha-opaque
[618.298205] Starting dynamic subtest: pipe-A-eDP-1
[618.929354] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.631s)
[618.940509] Starting dynamic subtest: pipe-D-eDP-1
[620.211043] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.284s)
[620.213483] Subtest cursor-alpha-opaque: SUCCESS (1.918s)
[621.020626] [119/131] (402s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[621.077514] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[621.079379] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[621.191704] [120/131] (402s left) kms_psr (pr-no-drrs)
[621.282342] Starting subtest: pr-no-drrs
[621.286481] Subtest pr-no-drrs: SKIP (0.000s)
[621.358836] [121/131] (401s left) gem_tiled_blits (basic)
[621.414429] Subtest basic: SKIP (0.000s)
[621.502564] [122/131] (401s left) kms_addfb_basic (addfb25-4-tiled)
[621.593191] Starting subtest: addfb25-4-tiled
[621.595442] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[621.700400] [123/131] (401s left) kms_atomic_interruptible (legacy-pageflip)
[621.789884] Starting subtest: legacy-pageflip
[621.792198] Starting dynamic subtest: pipe-A-eDP-1
[629.223823] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.431s)
[629.226003] Subtest legacy-pageflip: SUCCESS (7.432s)
[630.073597] [124/131] (393s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[630.160359] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[630.164432] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[630.260908] [125/131] (393s left) gem_ctx_shared (exec-shared-gtt)
[630.311479] Starting subtest: exec-shared-gtt
[630.313868] Starting dynamic subtest: rcs0
[630.318998] Dynamic subtest rcs0: SUCCESS (0.007s)
[630.330851] Starting dynamic subtest: bcs0
[630.332733] Dynamic subtest bcs0: SUCCESS (0.008s)
[630.344173] Starting dynamic subtest: vcs0
[630.346336] Dynamic subtest vcs0: SUCCESS (0.007s)
[630.357210] Starting dynamic subtest: vcs1
[630.359100] Dynamic subtest vcs1: SUCCESS (0.007s)
[630.369929] Starting dynamic subtest: vecs0
[630.372141] Dynamic subtest vecs0: SUCCESS (0.007s)
[630.384490] Starting dynamic subtest: ccs0
[630.386811] Dynamic subtest ccs0: SUCCESS (0.009s)
[630.388955] Subtest exec-shared-gtt: SUCCESS (0.050s)
[632.498100] [126/131] (391s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[632.603403] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[633.205594] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.604s)
[633.377814] [127/131] (390s left) i915_pm_rc6_residency (rc6-idle)
[633.442238] Starting subtest: rc6-idle
[633.463546] Starting dynamic subtest: gt0-rcs0
[657.747832] Dynamic subtest gt0-rcs0: SUCCESS (24.282s)
[657.760845] Starting dynamic subtest: gt0-bcs0
[682.021330] Dynamic subtest gt0-bcs0: SUCCESS (24.267s)
[682.032251] Starting dynamic subtest: gt0-ccs0
[706.316889] Dynamic subtest gt0-ccs0: SUCCESS (24.289s)
[706.329642] Starting dynamic subtest: gt1-vcs0
[712.493240] Dynamic subtest gt1-vcs0: SUCCESS (6.170s)
[712.504515] Starting dynamic subtest: gt1-vecs0
[718.666112] Dynamic subtest gt1-vecs0: SUCCESS (6.169s)
[718.668907] Subtest rc6-idle: SUCCESS (85.213s)
[718.748220] [128/131] (304s left) kms_universal_plane (universal-plane-pageflip-windowed)
[718.843577] Starting subtest: universal-plane-pageflip-windowed
[718.845744] Starting dynamic subtest: pipe-A-eDP-1
[719.441851] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.596s)
[719.452714] Starting dynamic subtest: pipe-B-eDP-1
[720.698724] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.257s)
[720.710841] Starting dynamic subtest: pipe-C-eDP-1
[721.924640] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.223s)
[721.936673] Starting dynamic subtest: pipe-D-eDP-1
[723.150661] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.224s)
[723.152499] Subtest universal-plane-pageflip-windowed: SUCCESS (4.306s)
[724.000850] [129/131] (299s left) gem_softpin (allocator-basic)
[724.061476] Starting subtest: allocator-basic
[724.122706] Subtest allocator-basic: SUCCESS (0.063s)
[724.242236] [130/131] (299s left) kms_flip (2x-absolute-wf_vblank)
[724.336005] Starting subtest: 2x-absolute-wf_vblank
[724.344753] Subtest 2x-absolute-wf_vblank: SKIP (0.010s)
[724.443047] [131/131] (299s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[724.543036] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[724.547358] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[724.634378] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: gem_create
results: parsing output: 2/ for test: gem_exec_schedule
results: parsing output: 3/ for test: kms_plane_scaling
results: parsing output: 4/ for test: syncobj_wait
results: parsing output: 5/ for test: kms_async_flips
results: parsing output: 6/ for test: gem_exec_whisper
results: parsing output: 7/ for test: gem_exec_params
results: parsing output: 8/ for test: sysfs_timeslice_duration
results: parsing output: 9/ for test: kms_chamelium_hpd
results: parsing output: 10/ for test: gen9_exec_parse
results: parsing output: 11/ for test: perf_pmu
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: kms_color
results: parsing output: 14/ for test: kms_cursor_crc
results: parsing output: 15/ for test: sriov_basic
results: parsing output: 16/ for test: gem_ctx_param
results: parsing output: 17/ for test: kms_busy
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: i915_selftest
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: sw_sync
results: parsing output: 23/ for test: gem_shrink
results: parsing output: 24/ for test: syncobj_basic
results: parsing output: 25/ for test: gem_bad_reloc
results: parsing output: 26/ for test: syncobj_basic
results: parsing output: 27/ for test: gem_spin_batch
results: parsing output: 28/ for test: gem_exec_whisper
results: parsing output: 29/ for test: gem_render_copy
results: parsing output: 30/ for test: kms_cdclk
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_plane_multiple
results: parsing output: 34/ for test: dmabuf
results: parsing output: 35/ for test: kms_plane
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_draw_crc
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: perf_pmu
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: kms_hdr
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_lease
results: parsing output: 45/ for test: gem_ppgtt
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: gem_madvise
results: parsing output: 49/ for test: kms_cursor_crc
results: parsing output: 50/ for test: kms_cursor_legacy
results: parsing output: 51/ for test: gem_mmap_offset
results: parsing output: 52/ for test: gem_mmap_gtt
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: api_intel_bb
results: parsing output: 55/ for test: kms_pm_lpsp
results: parsing output: 56/ for test: kms_addfb_basic
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: perf
results: parsing output: 61/ for test: syncobj_wait
results: parsing output: 62/ for test: gem_exec_params
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: gem_mmap_wc
results: parsing output: 65/ for test: kms_cursor_legacy
results: parsing output: 66/ for test: gem_userptr_blits
results: parsing output: 67/ for test: gem_mmap_gtt
results: parsing output: 68/ for test: gem_mmap_wc
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: kms_cursor_crc
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: kms_pipe_crc_basic
results: parsing output: 73/ for test: kms_atomic_transition
results: parsing output: 74/ for test: syncobj_timeline
results: parsing output: 75/ for test: gem_lmem_swapping
results: parsing output: 76/ for test: kms_psr2_sf
results: parsing output: 77/ for test: gem_exec_balancer
results: parsing output: 78/ for test: api_intel_bb
results: parsing output: 79/ for test: gen9_exec_parse
results: parsing output: 80/ for test: gem_mmap_gtt
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_sync
results: parsing output: 83/ for test: gem_ctx_bad_destroy
results: parsing output: 84/ for test: kms_flip_scaled_crc
results: parsing output: 85/ for test: kms_chamelium_frames
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: gem_exec_parallel
results: parsing output: 89/ for test: prime_mmap
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: perf
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_exec_reloc
results: parsing output: 95/ for test: kms_flip
results: parsing output: 96/ for test: kms_prop_blob
results: parsing output: 97/ for test: kms_flip_scaled_crc
results: parsing output: 98/ for test: kms_plane_scaling
results: parsing output: 99/ for test: gem_exec_schedule
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_scaling_modes
results: parsing output: 103/ for test: kms_joiner
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_exec_fence
results: parsing output: 106/ for test: gem_render_copy_redux
results: parsing output: 107/ for test: gem_userptr_blits
results: parsing output: 108/ for test: gem_ctx_persistence
results: parsing output: 109/ for test: gem_mmap_gtt
results: parsing output: 110/ for test: gem_exec_create
results: parsing output: 111/ for test: i915_hangman
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_exec_reloc
results: parsing output: 115/ for test: kms_vblank
results: parsing output: 116/ for test: kms_setmode
results: parsing output: 117/ for test: kms_cursor_crc
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: gem_tiled_blits
results: parsing output: 121/ for test: kms_addfb_basic
results: parsing output: 122/ for test: kms_atomic_interruptible
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_ctx_shared
results: parsing output: 125/ for test: kms_big_fb
results: parsing output: 126/ for test: i915_pm_rc6_residency
results: parsing output: 127/ for test: kms_universal_plane
results: parsing output: 128/ for test: gem_softpin
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: kms_frontbuffer_tracking
Done.