[58.594059] Initializing watchdogs
[58.594111]   /dev/watchdog0
[58.607667] [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.611750] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.614046] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.617338] [001/131] (960s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[58.741348] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[58.745845] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.002s)
[58.878358] [002/131] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[58.984206] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[58.988335] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[59.121244] [003/131] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[59.234793] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[59.239144] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[59.347623] [004/131] (959s left) gem_barrier_race (remote-request)
[59.413506] Starting subtest: remote-request
[59.415653] Starting dynamic subtest: rcs0
[64.582142] Dynamic subtest rcs0: SUCCESS (5.140s)
[64.585801] Subtest remote-request: SUCCESS (5.141s)
[64.730588] [005/131] (954s left) api_intel_bb (add-remove-objects)
[64.793215] Starting subtest: add-remove-objects
[64.803088] Subtest add-remove-objects: SUCCESS (0.011s)
[64.968196] [006/131] (954s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[65.069454] Starting subtest: 4-tiled-16bpp-rotate-0
[66.419082] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.345s)
[66.571109] [007/131] (952s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[66.675392] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[66.677480] Starting dynamic subtest: pipe-A-eDP-1
[66.943455] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.247s)
[66.955955] Starting dynamic subtest: pipe-B-eDP-1
[68.220601] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.263s)
[68.229309] Starting dynamic subtest: pipe-C-eDP-1
[69.477071] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.254s)
[69.485895] Starting dynamic subtest: pipe-D-eDP-1
[70.718073] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.237s)
[70.720402] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.003s)
[71.867959] [008/131] (947s left) gem_mmap_wc (read)
[71.930185] Subtest read: SKIP (0.000s)
[71.993352] [009/131] (947s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[72.059093] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[72.128743] [010/131] (947s left) gem_render_copy (y-tiled)
[72.193446] Starting subtest: y-tiled
[72.197845] Subtest y-tiled: SKIP (0.000s)
[72.437437] [011/131] (947s left) perf (per-context-mode-unprivileged)
[72.550034] Starting subtest: per-context-mode-unprivileged
[72.554656] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[72.586665] [012/131] (946s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[72.640392] Starting subtest: wait-all-for-submit-delayed-submit
[72.744536] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.104s)
[72.847992] [013/131] (946s left) kms_invalid_mode (bad-vtotal)
[72.937319] Starting subtest: bad-vtotal
[72.939597] Starting dynamic subtest: pipe-A-eDP-1
[73.227440] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[73.235995] Starting dynamic subtest: pipe-B-eDP-1
[73.237973] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[73.244167] Starting dynamic subtest: pipe-C-eDP-1
[73.246078] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[73.252588] Starting dynamic subtest: pipe-D-eDP-1
[73.254801] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[73.257072] Subtest bad-vtotal: SUCCESS (0.293s)
[74.103160] [014/131] (945s left) i915_drm_fdinfo (virtual-busy-idle)
[74.150303] Starting subtest: virtual-busy-idle
[74.154435] Subtest virtual-busy-idle: SKIP (0.000s)
[74.233192] [015/131] (945s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[74.293318] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[74.356816] [016/131] (945s left) gen9_exec_parse (bb-chained)
[74.417469] Subtest bb-chained: SKIP (0.000s)
[74.491983] [017/131] (945s left) kms_psr (fbc-psr-primary-page-flip)
[74.586163] Starting subtest: fbc-psr-primary-page-flip
[74.588428] Starting dynamic subtest: eDP-1
[74.592968] Dynamic subtest eDP-1: SKIP (0.000s)
[74.597696] Subtest fbc-psr-primary-page-flip: SKIP (0.000s)
[74.679374] [018/131] (945s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[74.778821] Starting subtest: random-ccs-data-y-tiled-ccs
[74.781184] Starting dynamic subtest: pipe-A-eDP-1
[74.807018] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[74.816194] Starting dynamic subtest: pipe-B-eDP-1
[74.839590] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[74.847081] Starting dynamic subtest: pipe-C-eDP-1
[74.871320] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[74.879208] Starting dynamic subtest: pipe-D-eDP-1
[74.904354] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[74.908628] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.003s)
[77.010652] [019/131] (942s left) sysfs_timeslice_duration (invalid)
[77.081763] Starting subtest: invalid
[77.084192] Starting dynamic subtest: vecs0
[77.086569] Dynamic subtest vecs0: SUCCESS (0.000s)
[77.095201] Starting dynamic subtest: ccs0
[77.097070] Dynamic subtest ccs0: SUCCESS (0.000s)
[77.103809] Starting dynamic subtest: vcs0
[77.105734] Dynamic subtest vcs0: SUCCESS (0.000s)
[77.112625] Starting dynamic subtest: bcs0
[77.114522] Dynamic subtest bcs0: SUCCESS (0.000s)
[77.120667] Starting dynamic subtest: rcs0
[77.122558] Dynamic subtest rcs0: SUCCESS (0.000s)
[77.128801] Starting dynamic subtest: vcs1
[77.131073] Dynamic subtest vcs1: SUCCESS (0.000s)
[77.133675] Subtest invalid: SUCCESS (0.003s)
[77.209888] [020/131] (942s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[77.321758] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[77.325714] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[77.448762] [021/131] (942s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[77.559221] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[77.561514] Starting dynamic subtest: pipe-A-default-mode
[77.849287] Dynamic subtest pipe-A-default-mode: SKIP (0.290s)
[77.853909] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.291s)
[78.713958] [022/131] (941s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[78.785996] Starting subtest: saturated-hostile-nopreempt
[78.788430] Starting dynamic subtest: rcs0
[78.868134] Dynamic subtest rcs0: SKIP (0.078s)
[78.877944] Starting dynamic subtest: bcs0
[78.884333] Dynamic subtest bcs0: SKIP (0.016s)
[78.891071] Starting dynamic subtest: vcs0
[78.907643] Dynamic subtest vcs0: SKIP (0.023s)
[78.914416] Starting dynamic subtest: vcs1
[78.927483] Dynamic subtest vcs1: SKIP (0.019s)
[78.934304] Starting dynamic subtest: vecs0
[78.944491] Dynamic subtest vecs0: SKIP (0.016s)
[78.951198] Starting dynamic subtest: ccs0
[78.968688] Dynamic subtest ccs0: SKIP (0.023s)
[78.973051] Subtest saturated-hostile-nopreempt: SKIP (0.181s)
[79.067062] [023/131] (940s left) gem_ctx_param (set-priority-not-supported)
[79.126722] Starting subtest: set-priority-not-supported
[79.131400] Subtest set-priority-not-supported: SKIP (0.000s)
[79.222732] [024/131] (940s left) kms_cursor_crc (cursor-sliding-128x128)
[79.439059] Starting subtest: cursor-sliding-128x128
[79.444040] Starting dynamic subtest: pipe-A-eDP-1
[82.651267] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.207s)
[82.680839] Starting dynamic subtest: pipe-D-eDP-1
[86.621333] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.950s)
[86.623740] Subtest cursor-sliding-128x128: SUCCESS (7.179s)
[87.477080] [025/131] (932s left) kms_psr (psr-cursor-mmap-cpu)
[87.592264] Starting subtest: psr-cursor-mmap-cpu
[87.594626] Starting dynamic subtest: eDP-1
[89.346496] Dynamic subtest eDP-1: SUCCESS (1.754s)
[89.348937] Subtest psr-cursor-mmap-cpu: SUCCESS (1.755s)
[90.240815] [026/131] (929s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[90.343733] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[97.084065] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.743s)
[97.241879] [027/131] (922s left) gem_ctx_persistence (engines-hostile)
[97.319096] Starting subtest: engines-hostile
[97.321487] Starting dynamic subtest: rcs0
[97.440272] Dynamic subtest rcs0: SUCCESS (0.120s)
[97.450151] Starting dynamic subtest: bcs0
[97.546960] Dynamic subtest bcs0: SUCCESS (0.106s)
[97.556817] Starting dynamic subtest: vcs0
[97.652417] Dynamic subtest vcs0: SUCCESS (0.104s)
[97.662536] Starting dynamic subtest: vcs1
[97.772230] Dynamic subtest vcs1: SUCCESS (0.119s)
[97.783188] Starting dynamic subtest: vecs0
[97.842770] Dynamic subtest vecs0: SUCCESS (0.070s)
[97.851438] Starting dynamic subtest: ccs0
[97.989827] Dynamic subtest ccs0: SUCCESS (0.146s)
[97.992717] Subtest engines-hostile: SUCCESS (0.671s)
[98.091064] [028/131] (922s left) kms_setmode (basic-clone-single-crtc)
[98.148610] Starting subtest: basic-clone-single-crtc
[98.154416] Subtest basic-clone-single-crtc: SKIP (0.000s)
[98.286908] [029/131] (921s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[103.289855] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[103.292262] Starting dynamic subtest: pipe-A-eDP-1
[115.003532] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.712s)
[115.012374] Starting dynamic subtest: pipe-B-eDP-1
[126.754682] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.749s)
[126.757016] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (23.464s)
[127.616625] [030/131] (892s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[127.739772] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[134.191269] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.454s)
[134.333299] [031/131] (885s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[134.428982] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[134.433535] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[135.589885] [032/131] (884s left) gem_exec_reloc (basic-gtt-wc)
[135.664285] Subtest basic-gtt-wc: SKIP (0.000s)
[135.756703] [033/131] (884s left) gem_tiled_pread_basic
[135.886346] [034/131] (884s left) kms_sequence (queue-busy)
[135.988291] Starting subtest: queue-busy
[135.990471] Starting dynamic subtest: pipe-A-eDP-1
[137.922662] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.933s)
[137.931426] Starting dynamic subtest: pipe-B-eDP-1
[140.566750] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.644s)
[140.574905] Starting dynamic subtest: pipe-C-eDP-1
[143.170517] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.601s)
[143.179576] Starting dynamic subtest: pipe-D-eDP-1
[145.726468] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.555s)
[145.728308] Subtest queue-busy: SUCCESS (9.739s)
[146.541198] [035/131] (873s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[146.603257] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[146.605197] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[146.736017] [036/131] (873s left) gem_ppgtt (blt-vs-render-ctxn)
[146.791707] Starting subtest: blt-vs-render-ctxN
[179.862755] Subtest blt-vs-render-ctxN: SUCCESS (33.068s)
[180.012035] [037/131] (840s left) kms_psr (pr-primary-mmap-cpu)
[180.148787] Starting subtest: pr-primary-mmap-cpu
[180.153029] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[180.240610] [038/131] (840s left) kms_plane_scaling (planes-downscale-factor-0-75)
[180.334618] Starting subtest: planes-downscale-factor-0-75
[180.336840] Starting dynamic subtest: pipe-A
[180.357315] Dynamic subtest pipe-A: SKIP (0.017s)
[180.365255] Starting dynamic subtest: pipe-B
[180.388459] Dynamic subtest pipe-B: SKIP (0.030s)
[180.396424] Starting dynamic subtest: pipe-C
[180.416217] Dynamic subtest pipe-C: SKIP (0.029s)
[180.423531] Starting dynamic subtest: pipe-D
[180.446927] Dynamic subtest pipe-D: SKIP (0.029s)
[180.451288] Subtest planes-downscale-factor-0-75: SKIP (0.108s)
[180.579972] [039/131] (840s left) gem_softpin (evict-active)
[180.651869] Starting subtest: evict-active
[180.656957] Subtest evict-active: SUCCESS (0.005s)
[180.806755] [040/131] (839s left) syncobj_timeline (device-submit-unordered)
[180.863974] Starting subtest: device-submit-unordered
[180.866155] Subtest device-submit-unordered: SUCCESS (0.000s)
[180.981877] [041/131] (839s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[181.064837] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[181.068161] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[181.201583] [042/131] (839s left) gem_exec_schedule (submit-late-slice)
[181.265879] Starting subtest: submit-late-slice
[181.267470] Starting dynamic subtest: rcs0
[181.294757] Dynamic subtest rcs0: SUCCESS (0.034s)
[181.302833] Starting dynamic subtest: bcs0
[181.325098] Dynamic subtest bcs0: SUCCESS (0.030s)
[181.334395] Starting dynamic subtest: vcs0
[181.357269] Dynamic subtest vcs0: SUCCESS (0.032s)
[181.364447] Starting dynamic subtest: vcs1
[181.385647] Dynamic subtest vcs1: SUCCESS (0.028s)
[181.392609] Starting dynamic subtest: vecs0
[181.413554] Dynamic subtest vecs0: SUCCESS (0.027s)
[181.421709] Starting dynamic subtest: ccs0
[181.444136] Dynamic subtest ccs0: SUCCESS (0.030s)
[181.446034] Subtest submit-late-slice: SUCCESS (0.184s)
[183.074693] [043/131] (837s left) kms_plane (pixel-format)
[183.171148] Starting subtest: pixel-format
[183.196855] Starting dynamic subtest: pipe-A-plane-0
[187.918903] Dynamic subtest pipe-A-plane-0: SUCCESS (4.722s)
[187.928885] Starting dynamic subtest: pipe-A-plane-3
[190.196893] Dynamic subtest pipe-A-plane-3: SUCCESS (2.277s)
[190.208633] Starting dynamic subtest: pipe-A-plane-5
[190.407756] Dynamic subtest pipe-A-plane-5: SUCCESS (0.210s)
[191.493625] Starting dynamic subtest: pipe-B-plane-0
[196.142799] Dynamic subtest pipe-B-plane-0: SUCCESS (4.655s)
[196.151040] Starting dynamic subtest: pipe-B-plane-3
[198.398079] Dynamic subtest pipe-B-plane-3: SUCCESS (2.255s)
[198.407448] Starting dynamic subtest: pipe-B-plane-5
[198.620728] Dynamic subtest pipe-B-plane-5: SUCCESS (0.222s)
[198.949728] Subtest pixel-format: SUCCESS (15.778s)
[199.795348] [044/131] (821s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[199.882117] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[199.884205] Starting dynamic subtest: pipe-A-eDP-1
[199.904577] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[199.913883] Starting dynamic subtest: pipe-B-eDP-1
[199.932072] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[199.939582] Starting dynamic subtest: pipe-C-eDP-1
[199.959293] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[199.967560] Starting dynamic subtest: pipe-D-eDP-1
[199.987749] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[199.989808] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.007s)
[202.154217] [045/131] (818s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[202.261893] Starting subtest: 2x-plain-flip-ts-check-interruptible
[202.273194] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.010s)
[202.405587] [046/131] (818s left) api_intel_bb (reset-flags)
[202.468454] Starting subtest: reset-flags
[202.475329] Subtest reset-flags: SUCCESS (0.009s)
[202.626140] [047/131] (818s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[202.692778] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[202.773195] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.028s)
[202.811309] [048/131] (818s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[207.788914] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[207.793408] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.002s)
[208.673646] [049/131] (812s left) i915_suspend (sysfs-reader)
[208.743393] Starting subtest: sysfs-reader
[226.249540] Subtest sysfs-reader: SUCCESS (6.800s)
[226.363445] [050/131] (794s left) gem_mmap_gtt (basic-wc)
[226.447908] Subtest basic-wc: SKIP (0.000s)
[226.514626] [051/131] (794s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[226.612023] Starting subtest: fbc-rgb565-draw-mmap-gtt
[226.616137] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[226.750862] [052/131] (794s left) gem_exec_flush (basic-uc-set-default)
[226.812266] Starting subtest: basic-uc-set-default
[232.386014] Subtest basic-uc-set-default: SUCCESS (5.449s)
[232.597121] [053/131] (788s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[232.702439] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[239.717395] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.947s)
[239.876825] [054/131] (781s left) kms_flip (2x-plain-flip)
[239.974288] Starting subtest: 2x-plain-flip
[239.985467] Subtest 2x-plain-flip: SKIP (0.010s)
[240.129082] [055/131] (781s left) core_setmaster_vs_auth
[240.323653] [056/131] (781s left) gem_userptr_blits (dmabuf-unsync)
[240.390527] Subtest dmabuf-unsync: SKIP (0.000s)
[240.548032] [057/131] (780s left) kms_scaling_modes (scaling-mode-center)
[240.645714] Starting subtest: scaling-mode-center
[240.648085] Starting dynamic subtest: pipe-A-eDP-1
[240.771534] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.124s)
[240.780568] Starting dynamic subtest: pipe-B-eDP-1
[241.906583] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.128s)
[241.915648] Starting dynamic subtest: pipe-C-eDP-1
[243.039853] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.126s)
[243.048425] Starting dynamic subtest: pipe-D-eDP-1
[244.157295] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.112s)
[244.159680] Subtest scaling-mode-center: SUCCESS (3.496s)
[245.342983] [058/131] (776s left) gem_exec_flush (basic-batch-kernel-default-wb)
[245.406040] Starting subtest: basic-batch-kernel-default-wb
[252.527935] Subtest basic-batch-kernel-default-wb: SUCCESS (7.107s)
[252.740401] [059/131] (768s left) perf (i915-ref-count)
[252.845721] Starting subtest: i915-ref-count
[252.882452] Subtest i915-ref-count: SUCCESS (0.038s)
[252.935266] [060/131] (768s left) kms_lease (page-flip-implicit-plane)
[253.038656] Starting subtest: page-flip-implicit-plane
[253.040930] Starting dynamic subtest: pipe-A-eDP-1
[253.521381] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.480s)
[253.531458] Starting dynamic subtest: pipe-B-eDP-1
[254.685732] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.159s)
[254.694872] Starting dynamic subtest: pipe-C-eDP-1
[255.810704] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.125s)
[255.822750] Starting dynamic subtest: pipe-D-eDP-1
[256.932791] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.118s)
[256.935217] Subtest page-flip-implicit-plane: SUCCESS (3.889s)
[257.788549] [061/131] (763s left) gem_softpin (allocator-evict)
[257.843477] Starting subtest: allocator-evict
[257.845724] Starting dynamic subtest: rcs0
[281.055042] Dynamic subtest rcs0: SUCCESS (23.199s)
[281.065520] Starting dynamic subtest: bcs0
[304.866287] Dynamic subtest bcs0: SUCCESS (23.797s)
[304.877759] Starting dynamic subtest: vcs0
[328.550579] Dynamic subtest vcs0: SUCCESS (23.679s)
[328.559430] Starting dynamic subtest: vcs1
[352.183699] Dynamic subtest vcs1: SUCCESS (23.635s)
[352.193148] Starting dynamic subtest: vecs0
[375.923225] Dynamic subtest vecs0: SUCCESS (23.735s)
[375.935981] Starting dynamic subtest: ccs0
[400.041285] Dynamic subtest ccs0: SUCCESS (24.110s)
[400.044275] Subtest allocator-evict: SUCCESS (142.165s)
[400.149314] [062/131] (621s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[400.308281] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[400.310585] Starting dynamic subtest: pipe-A-eDP-1
[400.331144] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[400.342935] Starting dynamic subtest: pipe-B-eDP-1
[400.362538] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[400.371203] Starting dynamic subtest: pipe-C-eDP-1
[400.390992] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[400.400907] Starting dynamic subtest: pipe-D-eDP-1
[400.420522] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[400.422696] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[402.484416] [063/131] (619s left) kms_content_protection (content-type-change)
[402.641953] Starting subtest: content-type-change
[402.646630] Subtest content-type-change: SKIP (0.000s)
[402.810541] [064/131] (618s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[402.973925] Starting subtest: cursor-rapid-movement-32x10
[403.016235] Subtest cursor-rapid-movement-32x10: SKIP (0.038s)
[403.316108] [065/131] (618s left) syncobj_basic (bad-destroy)
[403.372901] Starting subtest: bad-destroy
[403.375168] Subtest bad-destroy: SUCCESS (0.000s)
[403.484174] [066/131] (618s left) kms_flip (bo-too-big-interruptible)
[403.596848] Starting subtest: bo-too-big-interruptible
[403.598686] Starting dynamic subtest: A-eDP1
[404.926067] Dynamic subtest A-eDP1: SUCCESS (1.327s)
[404.936118] Starting dynamic subtest: B-eDP1
[406.156179] Dynamic subtest B-eDP1: SUCCESS (1.229s)
[406.168562] Starting dynamic subtest: C-eDP1
[407.402596] Dynamic subtest C-eDP1: SUCCESS (1.243s)
[407.416529] Starting dynamic subtest: D-eDP1
[408.644404] Dynamic subtest D-eDP1: SUCCESS (1.238s)
[408.649839] Subtest bo-too-big-interruptible: SUCCESS (5.051s)
[409.892027] [067/131] (611s left) kms_pm_dc (dc6-dpms)
[411.010300] Starting subtest: dc6-dpms
[413.113871] Subtest dc6-dpms: SUCCESS (2.101s)
[413.211235] [068/131] (608s left) gen9_exec_parse (unaligned-jump)
[413.276948] Subtest unaligned-jump: SKIP (0.000s)
[413.365303] [069/131] (608s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[413.472740] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[414.578653] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.107s)
[414.741091] [070/131] (607s left) perf_pmu (init-wait)
[414.775391] Starting subtest: init-wait
[414.777366] Starting dynamic subtest: rcs0
[414.779242] Dynamic subtest rcs0: SUCCESS (0.002s)
[414.788998] Starting dynamic subtest: bcs0
[414.790764] Dynamic subtest bcs0: SUCCESS (0.000s)
[414.798879] Starting dynamic subtest: vcs0
[414.800648] Dynamic subtest vcs0: SUCCESS (0.001s)
[414.808381] Starting dynamic subtest: vcs1
[414.810130] Dynamic subtest vcs1: SUCCESS (0.001s)
[414.817839] Starting dynamic subtest: vecs0
[414.819671] Dynamic subtest vecs0: SUCCESS (0.000s)
[414.827156] Starting dynamic subtest: ccs0
[414.828707] Dynamic subtest ccs0: SUCCESS (0.000s)
[414.830595] Subtest init-wait: SUCCESS (0.008s)
[414.897009] [071/131] (607s left) kms_getfb (getfb-handle-not-fb)
[414.983650] Starting subtest: getfb-handle-not-fb
[414.985676] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[415.107147] [072/131] (606s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[415.158793] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[415.160684] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[415.281382] [073/131] (606s left) kms_dsc (dsc-with-bpc-formats)
[415.369695] Starting subtest: dsc-with-bpc-formats
[415.461862] Subtest dsc-with-bpc-formats: SKIP (0.002s)
[415.495065] [074/131] (606s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[415.874569] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[416.673153] [075/131] (605s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[416.774742] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[416.778789] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[416.913020] [076/131] (605s left) syncobj_timeline (invalid-signal-zero-handles)
[416.964125] Starting subtest: invalid-signal-zero-handles
[416.966144] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[417.076505] [077/131] (605s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[417.176532] Starting subtest: addfb25-y-tiled-legacy
[417.178436] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[417.318706] [078/131] (604s left) gem_exec_fence (invalid-timeline-fence-array)
[417.938571] Starting subtest: invalid-timeline-fence-array
[417.945621] Subtest invalid-timeline-fence-array: SUCCESS (0.007s)
[419.736629] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[419.739904] [079/131] (602s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[419.809048] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[419.813753] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[420.022972] [080/131] (602s left) kms_psr (fbc-psr2-dpms)
[420.124195] Starting subtest: fbc-psr2-dpms
[420.126388] Starting dynamic subtest: eDP-1
[420.130603] Dynamic subtest eDP-1: SKIP (0.000s)
[420.134951] Subtest fbc-psr2-dpms: SKIP (0.001s)
[420.221023] [081/131] (602s left) gem_exec_alignment (many)
[420.278959] Starting subtest: many
[441.562004] Subtest many: SUCCESS (21.274s)
[442.505640] [082/131] (579s left) gem_mmap_offset (ptrace)
[442.600158] Starting subtest: ptrace
[442.602916] Starting dynamic subtest: smem0-wb
[442.617696] Dynamic subtest smem0-wb: SUCCESS (0.015s)
[442.626177] Starting dynamic subtest: smem0-wc
[442.639739] Dynamic subtest smem0-wc: SUCCESS (0.021s)
[442.649042] Starting dynamic subtest: smem0-uc
[442.662902] Dynamic subtest smem0-uc: SUCCESS (0.022s)
[442.665153] Subtest ptrace: SUCCESS (0.066s)
[442.827652] [083/131] (579s left) gem_exec_schedule (noreorder-priority)
[443.003848] Starting subtest: noreorder-priority
[443.006544] Starting dynamic subtest: rcs0
[444.169504] Dynamic subtest rcs0: SUCCESS (1.164s)
[444.181886] Starting dynamic subtest: vcs0
[445.611705] Dynamic subtest vcs0: SUCCESS (1.440s)
[445.623045] Starting dynamic subtest: vcs1
[447.571947] Dynamic subtest vcs1: SUCCESS (1.956s)
[447.583640] Starting dynamic subtest: vecs0
[449.620865] Dynamic subtest vecs0: SUCCESS (2.044s)
[449.633254] Starting dynamic subtest: ccs0
[450.771981] Dynamic subtest ccs0: SUCCESS (1.150s)
[450.774390] Subtest noreorder-priority: SUCCESS (7.767s)
[450.987110] [084/131] (571s left) gem_ctx_engines (execute-one)
[451.048252] Starting subtest: execute-one
[454.389899] Subtest execute-one: SUCCESS (3.343s)
[455.635344] [085/131] (566s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[455.760181] Starting subtest: flip-vs-cursor-legacy
[462.735180] Subtest flip-vs-cursor-legacy: SUCCESS (6.976s)
[463.561952] [086/131] (558s left) perf_pmu (busy-double-start)
[463.599150] Starting subtest: busy-double-start
[463.601759] Starting dynamic subtest: rcs0
[467.240771] Dynamic subtest rcs0: FAIL (3.586s)
[467.251448] Starting dynamic subtest: bcs0
[470.754118] Dynamic subtest bcs0: SUCCESS (3.570s)
[470.765279] Starting dynamic subtest: vcs0
[475.133940] Dynamic subtest vcs0: SUCCESS (4.379s)
[475.145984] Starting dynamic subtest: vcs1
[479.135062] Dynamic subtest vcs1: SUCCESS (3.999s)
[479.147035] Starting dynamic subtest: vecs0
[483.132083] Dynamic subtest vecs0: SUCCESS (3.995s)
[483.143846] Starting dynamic subtest: ccs0
[486.770072] Dynamic subtest ccs0: FAIL (3.565s)
[486.772395] Subtest busy-double-start: FAIL (23.105s)
[486.852879] [087/131] (535s left) gem_exec_alignment (single)
[486.920887] Starting subtest: single
[486.923167] Subtest single: SUCCESS (0.004s)
[487.052093] [088/131] (535s left) gem_exec_balancer (parallel)
[487.307919] Starting subtest: parallel
[488.209252] Subtest parallel: SUCCESS (0.901s)
[488.599272] [089/131] (534s left) kms_dp_aux_dev
[488.971685] [090/131] (533s left) kms_flip (basic-flip-vs-modeset)
[489.064276] Starting subtest: basic-flip-vs-modeset
[489.066558] Starting dynamic subtest: A-eDP1
[491.602882] Dynamic subtest A-eDP1: SUCCESS (2.535s)
[491.612549] Starting dynamic subtest: B-eDP1
[493.768063] Dynamic subtest B-eDP1: SUCCESS (2.162s)
[493.778162] Starting dynamic subtest: C-eDP1
[495.936834] Dynamic subtest C-eDP1: SUCCESS (2.171s)
[495.947820] Starting dynamic subtest: D-eDP1
[498.085119] Dynamic subtest D-eDP1: SUCCESS (2.146s)
[498.087546] Subtest basic-flip-vs-modeset: SUCCESS (9.023s)
[498.913685] [091/131] (523s left) gem_exec_capture (capture-recoverable)
[498.966703] Starting subtest: capture-recoverable
[498.969060] Subtest capture-recoverable: SUCCESS (0.002s)
[499.122124] [092/131] (523s left) gem_userptr_blits (create-destroy-sync)
[499.186006] Starting subtest: create-destroy-sync
[504.200387] Subtest create-destroy-sync: SUCCESS (5.015s)
[504.364731] [093/131] (518s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[504.484898] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[504.489391] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[504.610611] [094/131] (518s left) kms_mmap_write_crc (main)
[504.714058] Starting subtest: main
[504.716485] Starting dynamic subtest: pipe-A-eDP-1
[508.062968] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.348s)
[508.065129] Subtest main: SUCCESS (3.349s)
[508.932294] [095/131] (513s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[509.039341] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[509.043647] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[509.180853] [096/131] (513s left) kms_content_protection (srm)
[509.329001] Starting subtest: srm
[509.336712] Subtest srm: SKIP (0.004s)
[509.493185] [097/131] (513s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[509.617021] Starting subtest: cursorB-vs-flipA-toggle
[509.621515] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[509.787078] [098/131] (513s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[509.881070] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[509.884892] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[510.030679] [099/131] (513s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[510.136583] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[510.139912] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[510.279395] [100/131] (512s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[510.378985] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[510.382441] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[510.512737] [101/131] (512s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[510.613481] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[510.617171] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[510.770660] [102/131] (512s left) gem_mmap (bad-object)
[510.824248] Subtest bad-object: SKIP (0.000s)
[510.898301] [103/131] (512s left) kms_chamelium_frames (hdmi-aspect-ratio)
[511.288505] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[512.107993] [104/131] (511s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[512.225609] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[512.229724] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[512.358180] [105/131] (510s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[512.474816] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[513.431441] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.957s)
[513.610079] [106/131] (509s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[513.711644] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[513.715257] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[513.850554] [107/131] (509s left) gem_exec_params (rs-invalid)
[513.908934] Starting subtest: rs-invalid
[513.913863] Subtest rs-invalid: SUCCESS (0.003s)
[514.072020] [108/131] (509s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[514.172565] Starting subtest: x-tiled-64bpp-rotate-180
[515.730754] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.559s)
[515.922391] [109/131] (507s left) gem_mmap_offset (blt-coherency)
[515.987145] Starting subtest: blt-coherency
[515.991949] Subtest blt-coherency: SUCCESS (0.007s)
[516.145713] [110/131] (507s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[516.246881] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[517.212420] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (0.966s)
[517.385806] [111/131] (506s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[517.496204] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[517.499604] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[517.612669] [112/131] (505s left) gem_fence_thrash (bo-write-verify-threaded-none)
[517.649126] Starting subtest: bo-write-verify-threaded-none
[517.673498] Subtest bo-write-verify-threaded-none: SKIP (0.025s)
[517.743647] [113/131] (505s left) dmabuf_sync_file (import-basic)
[517.784612] Starting subtest: import-basic
[517.786604] Subtest import-basic: SUCCESS (0.001s)
[517.867766] [114/131] (505s left) gem_exec_whisper (basic-contexts-forked-all)
[517.944447] Starting subtest: basic-contexts-forked-all
[538.512604] Subtest basic-contexts-forked-all: SUCCESS (20.562s)
[538.717934] [115/131] (484s left) kms_vblank (ts-continuation-idle-hang)
[538.814309] Starting subtest: ts-continuation-idle-hang
[538.816612] Starting dynamic subtest: pipe-A-eDP-1
[565.338675] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.519s)
[565.354552] Starting dynamic subtest: pipe-D-eDP-1
[580.372688] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.030s)
[580.375146] Subtest ts-continuation-idle-hang: SUCCESS (41.554s)
[581.213486] [116/131] (442s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[581.313519] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[585.799058] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.490s)
[587.031740] [117/131] (436s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[587.129333] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[594.627867] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.499s)
[594.831807] [118/131] (428s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[599.839247] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[599.842009] Starting dynamic subtest: pipe-A-eDP-1
[606.381938] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.542s)
[606.392396] Starting dynamic subtest: pipe-B-eDP-1
[613.008378] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.621s)
[613.010798] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (13.167s)
[613.907428] [119/131] (409s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[613.980205] Starting subtest: mixed-tiled-to-y-tiled-ccs
[613.984689] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[614.184007] [120/131] (409s left) gem_exec_reloc (basic-cpu-read-active)
[614.244785] Subtest basic-cpu-read-active: SKIP (0.000s)
[614.326913] [121/131] (409s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[614.422645] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[614.425037] Starting dynamic subtest: pipe-A
[614.762708] Dynamic subtest pipe-A: SUCCESS (0.342s)
[614.772624] Starting dynamic subtest: pipe-B
[616.244374] Dynamic subtest pipe-B: SUCCESS (1.481s)
[616.254413] Starting dynamic subtest: pipe-C
[617.638645] Dynamic subtest pipe-C: SUCCESS (1.392s)
[617.649155] Starting dynamic subtest: pipe-D
[619.080429] Dynamic subtest pipe-D: SUCCESS (1.440s)
[619.082711] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.659s)
[620.245632] [122/131] (403s left) syncobj_wait (single-wait-for-submit-signaled)
[620.304847] Starting subtest: single-wait-for-submit-signaled
[620.307103] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[620.431750] [123/131] (403s left) gem_exec_params (no-blt)
[620.492762] Starting subtest: no-blt
[620.495202] Subtest no-blt: SUCCESS (0.003s)
[620.663685] [124/131] (403s left) kms_rotation_crc (bad-tiling)
[620.759719] Starting subtest: bad-tiling
[620.763832] Subtest bad-tiling: SKIP (0.001s)
[620.856782] [125/131] (403s left) kms_prime (basic-crc-vgem)
[620.933737] Starting subtest: basic-crc-vgem
[620.936039] Starting dynamic subtest: second-to-first
[621.908667] Dynamic subtest second-to-first: SUCCESS (0.979s)
[621.910550] Subtest basic-crc-vgem: SUCCESS (0.980s)
[622.029164] [126/131] (402s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[622.121869] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[622.123801] Starting dynamic subtest: pipe-A-default-mode
[622.409279] Dynamic subtest pipe-A-default-mode: SKIP (0.284s)
[622.413642] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.285s)
[623.272959] [127/131] (400s left) i915_pm_rpm (gem-pread)
[624.808067] Starting subtest: gem-pread
[627.184429] Subtest gem-pread: SUCCESS (2.377s)
[627.271836] [128/131] (396s left) gem_userptr_blits (userfault)
[627.344960] Starting subtest: userfault
[627.347291] Subtest userfault: SUCCESS (0.007s)
[627.505536] [129/131] (396s left) syncobj_timeline (multi-wait-signaled)
[627.564416] Starting subtest: multi-wait-signaled
[627.566665] Subtest multi-wait-signaled: SUCCESS (0.000s)
[627.704970] [130/131] (396s left) gem_exec_whisper (basic-sync-all)
[627.776457] Starting subtest: basic-sync-all
[634.113637] Subtest basic-sync-all: SUCCESS (6.334s)
[634.327733] [131/131] (390s left) drm_read (short-buffer-nonblock)
[634.492005] Starting subtest: short-buffer-nonblock
[634.494459] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[634.638388] 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.