[62.108944] Initializing watchdogs
[62.108993]   /dev/watchdog0
[62.124192] [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]
[62.128889] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.131452] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.135055] [001/133] (960s left) gen9_exec_parse (cmd-crossing-page)
[62.218295] Subtest cmd-crossing-page: SKIP (0.000s)
[62.278104] [002/133] (960s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[62.401752] Starting subtest: basic-flip-after-cursor-atomic
[63.380538] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.978s)
[64.256346] [003/133] (958s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[64.377975] Starting subtest: extended-modeset-hang-newfb-with-reset
[64.380289] Starting dynamic subtest: pipe-A
[78.505067] Dynamic subtest pipe-A: SUCCESS (14.127s)
[78.513392] Starting dynamic subtest: pipe-D
[93.862430] Dynamic subtest pipe-D: SUCCESS (15.355s)
[93.864859] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (29.485s)
[94.654888] [004/133] (928s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[94.757058] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[101.719966] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.965s)
[101.874240] [005/133] (920s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[101.966139] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[108.821053] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.858s)
[108.964097] [006/133] (913s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[109.061403] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[109.086928] Starting dynamic subtest: pipe-A-plane-0
[109.386577] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[109.395961] Starting dynamic subtest: pipe-A-plane-3
[109.620294] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[110.705237] Starting dynamic subtest: pipe-B-plane-0
[111.007595] Dynamic subtest pipe-B-plane-0: SUCCESS (0.310s)
[111.018206] Starting dynamic subtest: pipe-B-plane-3
[111.251435] Dynamic subtest pipe-B-plane-3: SUCCESS (0.244s)
[111.561359] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.501s)
[112.379646] [007/133] (910s left) perf_pmu (pmu-read)
[112.422091] Starting subtest: pmu-read
[112.424568] Subtest pmu-read: SUCCESS (0.003s)
[112.535814] [008/133] (910s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[112.589330] Starting subtest: invalid-bsd1-flag-on-vebox
[112.591314] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[112.719959] [009/133] (910s left) gem_mmap_offset (bad-flags)
[112.771902] Starting subtest: bad-flags
[112.774297] Subtest bad-flags: SUCCESS (0.000s)
[112.893463] [010/133] (910s left) syncobj_wait (invalid-signal-illegal-handle)
[112.960792] Starting subtest: invalid-signal-illegal-handle
[112.962702] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[113.055731] [011/133] (910s left) kms_psr (fbc-psr2-primary-render)
[113.152684] Starting subtest: fbc-psr2-primary-render
[113.154984] Starting dynamic subtest: eDP-1
[113.159376] Dynamic subtest eDP-1: SKIP (0.000s)
[113.164427] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[113.223567] [012/133] (909s left) syncobj_wait (wait-any-snapshot)
[113.278732] Starting subtest: wait-any-snapshot
[113.358322] Subtest wait-any-snapshot: SUCCESS (0.082s)
[113.431096] [013/133] (909s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[113.479925] Starting subtest: yf-tiled-ccs-to-x-tiled
[113.483654] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[113.672298] [014/133] (909s left) gem_ctx_exec (basic-nohangcheck)
[113.727992] Starting subtest: basic-nohangcheck
[113.974459] Subtest basic-nohangcheck: SUCCESS (0.248s)
[114.102110] [015/133] (909s left) gem_exec_reloc (basic-write-read)
[114.154022] Subtest basic-write-read: SKIP (0.000s)
[114.224252] [016/133] (909s left) core_debugfs (read-all-entries)
[114.289078] Starting subtest: read-all-entries
[114.388604] Subtest read-all-entries: SUCCESS (0.100s)
[114.459482] [017/133] (908s left) kms_psr (psr-cursor-plane-onoff)
[114.557009] Starting subtest: psr-cursor-plane-onoff
[114.559284] Starting dynamic subtest: eDP-1
[116.279039] Dynamic subtest eDP-1: SUCCESS (1.721s)
[116.280994] Subtest psr-cursor-plane-onoff: SUCCESS (1.721s)
[117.147372] [018/133] (906s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[117.196192] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[117.298033] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[117.384006] [019/133] (905s left) gem_ctx_param (invalid-ctx-get)
[117.447960] Starting subtest: invalid-ctx-get
[117.450695] Subtest invalid-ctx-get: SUCCESS (0.000s)
[117.534837] [020/133] (905s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[117.644959] Starting subtest: random-ccs-data-yf-tiled-ccs
[117.647171] Starting dynamic subtest: pipe-A-eDP-1
[117.672040] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[117.681487] Starting dynamic subtest: pipe-B-eDP-1
[117.704327] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[117.711176] Starting dynamic subtest: pipe-C-eDP-1
[117.733816] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[117.741260] Starting dynamic subtest: pipe-D-eDP-1
[117.763836] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[117.768052] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.003s)
[119.929680] [021/133] (903s left) gem_ppgtt (blt-vs-render-ctx0)
[119.992946] Starting subtest: blt-vs-render-ctx0
[152.916825] Subtest blt-vs-render-ctx0: SUCCESS (32.920s)
[153.033916] [022/133] (870s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[153.176656] Starting subtest: fbc-pr-cursor-plane-update-sf
[153.181054] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[153.242168] [023/133] (870s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[153.327123] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[153.331280] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[153.396957] [024/133] (870s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[153.492879] Starting subtest: primary-4-tiled-reflect-x-0
[160.438070] Subtest primary-4-tiled-reflect-x-0: SUCCESS (6.948s)
[161.642600] [025/133] (862s left) api_intel_allocator (reserve-simple)
[161.701999] Starting subtest: reserve-simple
[161.704846] Subtest reserve-simple: SUCCESS (0.002s)
[161.812403] [026/133] (861s left) kms_big_fb (linear-32bpp-rotate-0)
[161.931696] Starting subtest: linear-32bpp-rotate-0
[163.509487] Subtest linear-32bpp-rotate-0: SUCCESS (1.578s)
[163.642178] [027/133] (860s left) kms_setmode (invalid-clone-exclusive-crtc)
[163.702056] Starting subtest: invalid-clone-exclusive-crtc
[163.707297] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[163.804105] [028/133] (859s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[163.863440] Starting subtest: yf-tiled-ccs-to-y-tiled
[163.867310] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[164.043407] [029/133] (859s left) gem_exec_params (no-vebox)
[164.096817] Starting subtest: no-vebox
[164.099245] Subtest no-vebox: SUCCESS (0.001s)
[165.985444] [030/133] (857s left) kms_dsc (dsc-with-bpc-formats)
[166.076848] Starting subtest: dsc-with-bpc-formats
[166.184993] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[166.222256] [031/133] (857s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[166.318788] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[166.322934] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[166.406203] [032/133] (857s left) gem_exec_fence (syncobj-signal)
[166.911886] Starting subtest: syncobj-signal
[166.914573] Subtest syncobj-signal: SUCCESS (0.006s)
[167.971797] [FACT gem_exec_fence (syncobj-signal)] new: kernel.kmod_is_loaded.vgem: true
[167.975265] [033/133] (855s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[168.076663] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[168.081213] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[168.161344] [034/133] (855s left) i915_pm_rpm (debugfs-read)
[169.998733] Starting subtest: debugfs-read
[171.260784] Subtest debugfs-read: SUCCESS (1.258s)
[171.645410] [035/133] (852s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[171.751617] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[171.760746] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.011s)
[171.867994] [036/133] (852s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[171.971846] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[176.212719] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.244s)
[177.341142] [037/133] (846s left) kms_invalid_mode (uint-max-clock)
[177.438215] Starting subtest: uint-max-clock
[177.440376] Starting dynamic subtest: pipe-A-eDP-1
[177.719589] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[177.728863] Starting dynamic subtest: pipe-B-eDP-1
[177.730994] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[177.739230] Starting dynamic subtest: pipe-C-eDP-1
[177.741635] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[177.749856] Starting dynamic subtest: pipe-D-eDP-1
[177.751672] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[177.753566] Subtest uint-max-clock: SUCCESS (0.290s)
[178.558079] [038/133] (845s left) i915_query (query-regions-garbage-items)
[178.609768] Starting subtest: query-regions-garbage-items
[178.611605] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[178.717867] [039/133] (845s left) kms_pm_dc (dc5-dpms)
[179.808049] Starting subtest: dc5-dpms
[181.842939] Subtest dc5-dpms: SUCCESS (2.033s)
[181.920623] [040/133] (842s left) gem_eio (wait-wedge-immediate)
[182.150446] Starting subtest: wait-wedge-immediate
[183.979369] Subtest wait-wedge-immediate: SUCCESS (1.828s)
[184.129988] [041/133] (840s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[184.244186] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[188.717851] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.478s)
[189.911175] [042/133] (834s left) gem_exec_schedule (fifo)
[189.991974] Starting subtest: fifo
[189.993983] Starting dynamic subtest: rcs0
[190.082837] Dynamic subtest rcs0: SUCCESS (0.100s)
[190.093557] Starting dynamic subtest: vcs0
[190.160870] Dynamic subtest vcs0: SUCCESS (0.077s)
[190.171791] Starting dynamic subtest: vcs1
[190.239663] Dynamic subtest vcs1: SUCCESS (0.078s)
[190.251391] Starting dynamic subtest: vecs0
[190.319115] Dynamic subtest vecs0: SUCCESS (0.077s)
[190.329708] Starting dynamic subtest: ccs0
[190.407071] Dynamic subtest ccs0: SUCCESS (0.088s)
[190.410030] Subtest fifo: SUCCESS (0.424s)
[191.975676] [043/133] (832s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[192.364626] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[193.210798] [044/133] (831s left) kms_cursor_legacy (single-bo)
[193.332162] Starting subtest: single-bo
[193.334289] Starting dynamic subtest: pipe-A
[198.714154] Dynamic subtest pipe-A: SUCCESS (5.379s)
[198.740683] Starting dynamic subtest: pipe-B
[204.097174] Dynamic subtest pipe-B: SUCCESS (5.380s)
[204.108604] Starting dynamic subtest: pipe-C
[209.479980] Dynamic subtest pipe-C: SUCCESS (5.380s)
[209.490603] Starting dynamic subtest: pipe-D
[214.863328] Dynamic subtest pipe-D: SUCCESS (5.381s)
[214.874274] Starting dynamic subtest: all-pipes
[220.251754] Dynamic subtest all-pipes: SUCCESS (5.386s)
[220.254193] Subtest single-bo: SUCCESS (26.917s)
[220.396070] [045/133] (804s left) kms_color (gamma)
[220.489037] Starting subtest: gamma
[220.490948] Starting dynamic subtest: pipe-A-eDP-1
[221.205609] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.717s)
[221.215076] Starting dynamic subtest: pipe-B-eDP-1
[222.666043] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.460s)
[222.675104] Starting dynamic subtest: pipe-C-eDP-1
[224.022213] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.356s)
[224.033219] Starting dynamic subtest: pipe-D-eDP-1
[225.337182] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.312s)
[225.339179] Subtest gamma: SUCCESS (4.848s)
[226.142144] [046/133] (798s left) kms_rotation_crc (primary-rotation-180)
[226.229349] Starting subtest: primary-rotation-180
[233.221482] Subtest primary-rotation-180: SUCCESS (6.994s)
[234.388234] [047/133] (790s left) kms_legacy_colorkey (invalid-plane)
[234.491380] Starting subtest: invalid-plane
[234.493675] Starting dynamic subtest: zero-id
[234.495505] Dynamic subtest zero-id: SUCCESS (0.000s)
[234.504295] Starting dynamic subtest: outrange-id
[234.506442] Dynamic subtest outrange-id: SUCCESS (0.000s)
[234.508623] Subtest invalid-plane: SUCCESS (0.001s)
[234.562798] [048/133] (790s left) kms_psr (fbc-psr-sprite-blt)
[234.658936] Starting subtest: fbc-psr-sprite-blt
[234.661249] Starting dynamic subtest: eDP-1
[234.665480] Dynamic subtest eDP-1: SKIP (0.000s)
[234.669735] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[234.731996] [049/133] (789s left) gem_exec_balancer (waits)
[234.798022] Starting subtest: waits
[241.316765] Subtest waits: SUCCESS (6.513s)
[241.609660] [050/133] (783s left) i915_drm_fdinfo (all-busy-check-all)
[241.650788] Starting subtest: all-busy-check-all
[241.655539] Subtest all-busy-check-all: SKIP (0.003s)
[241.735959] [051/133] (782s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[241.871130] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[248.998947] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.130s)
[249.100784] [052/133] (775s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[249.196721] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[249.201197] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[249.297268] [053/133] (775s left) gem_userptr_blits (nohangcheck)
[249.362967] Starting subtest: nohangcheck
[249.626886] Subtest nohangcheck: SUCCESS (0.263s)
[249.750345] [054/133] (775s left) vgem_basic (bad-pad)
[249.802420] Starting subtest: bad-pad
[249.804304] Subtest bad-pad: SUCCESS (0.000s)
[249.881255] [055/133] (774s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[249.982018] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[249.986428] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[250.104420] [056/133] (774s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[250.230066] Starting subtest: cursorB-vs-flipB-toggle
[250.234331] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[250.374083] [057/133] (774s left) sw_sync (sync_random_merge)
[250.409183] Starting subtest: sync_random_merge
[250.455208] Subtest sync_random_merge: SUCCESS (0.047s)
[250.529814] [058/133] (774s left) kms_cursor_crc (cursor-onscreen-max-size)
[250.829223] Starting subtest: cursor-onscreen-max-size
[250.834617] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[250.956430] [059/133] (774s left) gem_exec_params (secure-non-master)
[251.026035] Starting subtest: secure-non-master
[251.030290] Subtest secure-non-master: SKIP (0.000s)
[251.128034] [060/133] (773s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[251.231471] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[274.105953] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.876s)
[274.240740] [061/133] (750s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[274.342631] Starting subtest: x-tiled-32bpp-rotate-180
[275.810484] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.468s)
[275.931109] [062/133] (749s left) dmabuf_sync_file (export-multiwait)
[275.973615] Starting subtest: export-multiwait
[275.975532] Subtest export-multiwait: SUCCESS (0.000s)
[276.031909] [063/133] (749s left) gem_eio (execbuf)
[276.254107] Starting subtest: execbuf
[276.587162] Subtest execbuf: SUCCESS (0.332s)
[276.724527] [064/133] (748s left) perf (global-sseu-config-invalid)
[276.859051] Starting subtest: global-sseu-config-invalid
[276.862548] Subtest global-sseu-config-invalid: SKIP (0.000s)
[276.897984] [065/133] (748s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[276.980570] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[276.984455] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[278.066610] [066/133] (747s left) gem_lmem_swapping (parallel-random-engines)
[278.113718] Subtest parallel-random-engines: SKIP (0.000s)
[278.164432] [067/133] (747s left) kms_atomic_interruptible (legacy-cursor)
[278.257164] Starting subtest: legacy-cursor
[278.259429] Starting dynamic subtest: pipe-A-eDP-1
[285.688348] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.428s)
[285.690612] Subtest legacy-cursor: SUCCESS (7.429s)
[286.554736] [068/133] (738s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[286.611084] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[286.613413] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[286.707318] [069/133] (738s left) gem_mmap_wc (bad-object)
[286.768588] Subtest bad-object: SKIP (0.000s)
[286.834796] [070/133] (738s left) gem_lmem_swapping (verify-random)
[286.874109] Subtest verify-random: SKIP (0.000s)
[286.919808] [071/133] (738s left) kms_frontbuffer_tracking (psr-1p-rte)
[287.021936] Starting subtest: psr-1p-rte
[292.464420] Subtest psr-1p-rte: SUCCESS (5.445s)
[292.611701] [072/133] (732s left) gem_exec_balancer (bonded-chain)
[292.663571] Starting subtest: bonded-chain
[299.676775] Subtest bonded-chain: SUCCESS (7.011s)
[299.988054] [073/133] (725s left) perf (missing-sample-flags)
[300.078072] Starting subtest: missing-sample-flags
[300.080327] Subtest missing-sample-flags: SUCCESS (0.000s)
[300.123182] [074/133] (725s left) gem_ctx_shared (exec-shared-gtt)
[300.173896] Starting subtest: exec-shared-gtt
[300.176248] Starting dynamic subtest: rcs0
[300.183955] Dynamic subtest rcs0: SUCCESS (0.010s)
[300.193595] Starting dynamic subtest: bcs0
[300.195697] Dynamic subtest bcs0: SUCCESS (0.008s)
[300.209053] Starting dynamic subtest: vcs0
[300.211691] Dynamic subtest vcs0: SUCCESS (0.009s)
[300.220231] Starting dynamic subtest: vcs1
[300.222382] Dynamic subtest vcs1: SUCCESS (0.008s)
[300.230742] Starting dynamic subtest: vecs0
[300.233136] Dynamic subtest vecs0: SUCCESS (0.009s)
[300.241513] Starting dynamic subtest: ccs0
[300.243638] Dynamic subtest ccs0: SUCCESS (0.010s)
[300.245795] Subtest exec-shared-gtt: SUCCESS (0.058s)
[300.434956] [075/133] (725s left) kms_cursor_crc (cursor-random-128x128)
[300.665591] Starting subtest: cursor-random-128x128
[300.670310] Starting dynamic subtest: pipe-A-eDP-1
[304.054574] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.384s)
[304.084285] Starting dynamic subtest: pipe-D-eDP-1
[308.054811] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.978s)
[308.057223] Subtest cursor-random-128x128: SUCCESS (7.389s)
[308.944316] [076/133] (716s left) kms_atomic (plane-invalid-params-fence)
[309.034246] Starting subtest: plane-invalid-params-fence
[309.036583] Starting dynamic subtest: pipe-A-eDP-1
[309.400074] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.364s)
[309.401971] Subtest plane-invalid-params-fence: SUCCESS (0.366s)
[310.276135] [077/133] (715s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[310.393765] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[310.398231] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[310.498066] [078/133] (715s left) kms_pm_rpm (system-suspend-modeset)
[312.015859] Starting subtest: system-suspend-modeset
[331.475331] Subtest system-suspend-modeset: SUCCESS (4.739s)
[331.869835] [079/133] (693s left) gem_exec_schedule (u-submit-golden-slice)
[331.962415] Starting subtest: u-submit-golden-slice
[331.964819] Starting dynamic subtest: rcs0
[331.995927] Dynamic subtest rcs0: SUCCESS (0.039s)
[332.007367] Starting dynamic subtest: bcs0
[332.030642] Dynamic subtest bcs0: SUCCESS (0.034s)
[332.040316] Starting dynamic subtest: vcs0
[332.062770] Dynamic subtest vcs0: SUCCESS (0.031s)
[332.072449] Starting dynamic subtest: vcs1
[332.090359] Dynamic subtest vcs1: SUCCESS (0.027s)
[332.100079] Starting dynamic subtest: vecs0
[332.122923] Dynamic subtest vecs0: SUCCESS (0.032s)
[332.132528] Starting dynamic subtest: ccs0
[332.159131] Dynamic subtest ccs0: SUCCESS (0.035s)
[332.161776] Subtest u-submit-golden-slice: SUCCESS (0.204s)
[333.750855] [080/133] (692s left) sriov_basic (enable-vfs-autoprobe-on)
[333.813950] Starting subtest: enable-vfs-autoprobe-on
[333.816625] Starting dynamic subtest: numvfs-1
[333.899704] Dynamic subtest numvfs-1: FAIL (0.028s)
[333.911803] Starting dynamic subtest: numvfs-2
[333.988629] Dynamic subtest numvfs-2: FAIL (0.004s)
[333.999680] Starting dynamic subtest: numvfs-3
[334.073007] Dynamic subtest numvfs-3: FAIL (0.003s)
[334.084022] Starting dynamic subtest: numvfs-4
[334.158866] Dynamic subtest numvfs-4: FAIL (0.004s)
[334.169644] Starting dynamic subtest: numvfs-5
[334.243578] Dynamic subtest numvfs-5: FAIL (0.003s)
[334.254438] Starting dynamic subtest: numvfs-6
[334.328202] Dynamic subtest numvfs-6: FAIL (0.004s)
[334.337978] Starting dynamic subtest: numvfs-7
[334.411439] Dynamic subtest numvfs-7: FAIL (0.003s)
[334.421456] Starting dynamic subtest: numvfs-random
[334.494485] Dynamic subtest numvfs-random: FAIL (0.004s)
[334.505276] Starting dynamic subtest: numvfs-all
[334.577912] Dynamic subtest numvfs-all: FAIL (0.525s)
[334.579939] Subtest enable-vfs-autoprobe-on: FAIL (0.585s)
[334.620473] [081/133] (691s left) gem_partial_pwrite_pread (write-display)
[334.675082] Subtest write-display: SKIP (0.000s)
[334.737861] [082/133] (691s left) gem_exec_schedule (preempt-engines)
[334.813404] Starting subtest: preempt-engines
[334.815218] Starting dynamic subtest: rcs0
[337.164591] Dynamic subtest rcs0: SUCCESS (2.349s)
[337.174946] Starting dynamic subtest: bcs0
[339.484381] Dynamic subtest bcs0: SUCCESS (2.317s)
[339.494422] Starting dynamic subtest: vcs0
[341.798627] Dynamic subtest vcs0: SUCCESS (2.311s)
[341.809046] Starting dynamic subtest: vcs1
[344.074094] Dynamic subtest vcs1: SUCCESS (2.272s)
[344.084271] Starting dynamic subtest: vecs0
[346.345296] Dynamic subtest vecs0: SUCCESS (2.268s)
[346.354844] Starting dynamic subtest: ccs0
[348.708284] Dynamic subtest ccs0: SUCCESS (2.359s)
[348.711240] Subtest preempt-engines: SUCCESS (13.890s)
[349.010844] [083/133] (677s left) i915_getparams_basic (basic-subslice-total)
[349.070684] Starting subtest: basic-subslice-total
[349.074770] Subtest basic-subslice-total: SUCCESS (0.000s)
[349.161755] [084/133] (676s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[349.217255] Starting subtest: etime-multi-wait-all-available-unsubmitted
[349.319062] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.102s)
[349.414739] [085/133] (676s left) gem_exec_reloc (basic-write-gtt)
[349.468558] Subtest basic-write-gtt: SKIP (0.000s)
[349.536267] [086/133] (676s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[349.637623] Starting subtest: plane-upscale-20x20-with-pixel-format
[349.640002] Starting dynamic subtest: pipe-A
[350.684405] Dynamic subtest pipe-A: SUCCESS (1.049s)
[350.693827] Starting dynamic subtest: pipe-B
[352.768312] Dynamic subtest pipe-B: SUCCESS (2.083s)
[352.777481] Starting dynamic subtest: pipe-C
[353.969165] Dynamic subtest pipe-C: SUCCESS (1.199s)
[353.978795] Starting dynamic subtest: pipe-D
[355.112716] Dynamic subtest pipe-D: SUCCESS (1.142s)
[355.114866] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.478s)
[356.308765] [087/133] (669s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[356.406420] Starting subtest: psr-shrfb-scaledprimary
[362.214389] Subtest psr-shrfb-scaledprimary: SUCCESS (5.812s)
[362.340044] [088/133] (663s left) kms_selftest (drm_cmdline_parser)
[362.390440] Starting subtest: drm_cmdline_parser
[362.429745] Starting dynamic subtest: drm_test_cmdline_force_d_only
[362.513699] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.082s)
[362.524098] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[362.616532] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.102s)
[362.627606] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[362.705561] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.089s)
[362.716449] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[362.792502] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.087s)
[362.803116] Starting dynamic subtest: drm_test_cmdline_force_e_only
[362.895577] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.101s)
[362.906135] Starting dynamic subtest: drm_test_cmdline_res
[362.981704] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.085s)
[362.992206] Starting dynamic subtest: drm_test_cmdline_res_vesa
[363.067587] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.086s)
[363.078102] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[363.171064] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.103s)
[363.181626] Starting dynamic subtest: drm_test_cmdline_res_rblank
[363.265034] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.095s)
[363.275617] Starting dynamic subtest: drm_test_cmdline_res_bpp
[363.361372] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.093s)
[363.371087] Starting dynamic subtest: drm_test_cmdline_res_refresh
[363.449082] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.087s)
[363.459341] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[363.539003] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.090s)
[363.549190] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[363.625065] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.085s)
[363.636491] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[363.715278] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.088s)
[363.724412] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[363.800579] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.083s)
[363.810712] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[363.895775] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.095s)
[363.904394] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[363.983284] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.086s)
[363.997871] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[364.079098] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.096s)
[364.089244] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[364.169212] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.089s)
[364.179251] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[364.261169] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.091s)
[364.271981] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[364.347177] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.083s)
[364.357623] Starting dynamic subtest: drm_test_cmdline_name
[364.445607] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.098s)
[364.456096] Starting dynamic subtest: drm_test_cmdline_name_bpp
[364.540960] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.095s)
[364.551402] Starting dynamic subtest: drm_test_cmdline_name_option
[364.626421] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.084s)
[364.636541] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[364.738976] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.112s)
[364.749617] Starting dynamic subtest: drm_test_cmdline_rotate_0
[364.829831] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.090s)
[364.839966] Starting dynamic subtest: drm_test_cmdline_rotate_90
[364.924974] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.094s)
[364.935440] Starting dynamic subtest: drm_test_cmdline_rotate_180
[365.007868] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.083s)
[365.018383] Starting dynamic subtest: drm_test_cmdline_rotate_270
[365.105997] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.097s)
[365.116680] Starting dynamic subtest: drm_test_cmdline_hmirror
[365.188544] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.081s)
[365.198724] Starting dynamic subtest: drm_test_cmdline_vmirror
[365.278839] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.091s)
[365.288645] Starting dynamic subtest: drm_test_cmdline_margin_options
[365.375249] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.095s)
[365.386077] Starting dynamic subtest: drm_test_cmdline_multiple_options
[365.474043] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.098s)
[365.484547] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[365.570082] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.095s)
[365.580610] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[365.661298] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.091s)
[365.675881] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[365.745020] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.083s)
[365.760637] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[365.837174] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.092s)
[365.847564] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[365.928034] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.088s)
[365.937738] Starting dynamic subtest: drm_test_cmdline_invalid
[366.028455] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.099s)
[366.037699] Starting dynamic subtest: drm_test_cmdline_tv_options
[366.124112] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.095s)
[366.125713] Subtest drm_cmdline_parser: SUCCESS (3.736s)
[366.270451] [089/133] (660s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[366.369986] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[366.371983] Starting dynamic subtest: pipe-A-eDP-1
[372.318747] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.951s)
[372.329100] Starting dynamic subtest: pipe-B-eDP-1
[378.959733] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.640s)
[378.962331] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.594s)
[379.831034] [090/133] (646s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[379.928445] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[379.930775] Starting dynamic subtest: pipe-A-default-mode
[382.671762] Dynamic subtest pipe-A-default-mode: SUCCESS (2.742s)
[382.674113] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.744s)
[383.523303] [091/133] (642s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[383.647231] Starting subtest: cursor-tearing-framebuffer-change
[383.649701] Starting dynamic subtest: pipe-A-eDP-1
[384.229588] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.579s)
[384.239749] Starting dynamic subtest: pipe-D-eDP-1
[385.465735] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.234s)
[385.467701] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.816s)
[386.289194] [092/133] (640s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[386.419004] Starting subtest: flip-vs-cursor-toggle
[395.077976] Subtest flip-vs-cursor-toggle: SUCCESS (8.657s)
[395.916953] [093/133] (630s left) kms_chamelium_edid (vga-edid-read)
[396.302588] Subtest vga-edid-read: SKIP (0.000s)
[397.130121] [094/133] (629s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[397.226948] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[397.231299] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[397.313307] [095/133] (629s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[397.401001] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[397.403003] Starting dynamic subtest: pipe-A
[398.514021] Dynamic subtest pipe-A: SUCCESS (1.117s)
[398.523690] Starting dynamic subtest: pipe-B
[400.753974] Dynamic subtest pipe-B: SUCCESS (2.238s)
[400.763218] Starting dynamic subtest: pipe-C
[401.950821] Dynamic subtest pipe-C: SUCCESS (1.195s)
[401.961136] Starting dynamic subtest: pipe-D
[403.177948] Dynamic subtest pipe-D: SUCCESS (1.226s)
[403.180250] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.782s)
[404.366392] [096/133] (622s left) kms_plane_multiple (2x-tiling-x)
[404.471486] Starting subtest: 2x-tiling-x
[404.475633] Subtest 2x-tiling-x: SKIP (0.000s)
[404.543495] [097/133] (622s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[404.613566] Starting subtest: single-wait-for-submit-available-signaled
[404.615981] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[404.726707] [098/133] (621s left) kms_plane_alpha_blend (constant-alpha-mid)
[404.817953] Starting subtest: constant-alpha-mid
[405.100201] Starting dynamic subtest: pipe-A-eDP-1
[406.008546] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.908s)
[406.019390] Starting dynamic subtest: pipe-D-eDP-1
[407.447220] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.437s)
[407.449549] Subtest constant-alpha-mid: SUCCESS (2.632s)
[408.339021] [099/133] (618s left) gem_ctx_engines (invalid-engines)
[408.397035] Starting subtest: invalid-engines
[408.403617] Subtest invalid-engines: SUCCESS (0.007s)
[408.652325] [100/133] (618s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[408.753323] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[408.757490] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[408.849893] [101/133] (617s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[408.951785] Starting subtest: 4-tiled-64bpp-rotate-0
[410.597195] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.646s)
[410.767798] [102/133] (616s left) intel_hwmon (hwmon-write)
[410.823164] Subtest hwmon-write: SKIP (0.000s)
[410.883094] [103/133] (615s left) kms_hdr (invalid-hdr)
[410.967890] Starting subtest: invalid-hdr
[413.042775] Starting dynamic subtest: pipe-A-eDP-1
[416.065179] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.022s)
[416.067849] Subtest invalid-hdr: SUCCESS (5.099s)
[416.171460] [104/133] (610s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[416.273172] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[416.277151] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[416.340235] [105/133] (610s left) gem_userptr_blits (process-exit)
[416.399017] Starting subtest: process-exit
[416.407225] Subtest process-exit: SUCCESS (0.010s)
[416.539418] [106/133] (610s left) gem_exec_params (invalid-fence-in)
[416.593742] Starting subtest: invalid-fence-in
[416.595996] Subtest invalid-fence-in: SUCCESS (0.000s)
[416.686625] [107/133] (610s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[416.804778] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[416.809060] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[416.963731] [108/133] (610s left) gem_spin_batch (legacy-resubmit)
[417.022395] Starting subtest: legacy-resubmit
[417.024645] Starting dynamic subtest: default
[417.029077] Dynamic subtest default: SUCCESS (0.005s)
[417.038637] Starting dynamic subtest: render
[417.040753] Dynamic subtest render: SUCCESS (0.001s)
[417.050000] Starting dynamic subtest: bsd
[417.052220] Dynamic subtest bsd: SUCCESS (0.003s)
[417.060916] Starting dynamic subtest: bsd1
[417.062767] Dynamic subtest bsd1: SUCCESS (0.002s)
[417.071195] Starting dynamic subtest: bsd2
[417.072723] Dynamic subtest bsd2: SUCCESS (0.002s)
[417.081176] Starting dynamic subtest: blt
[417.082707] Dynamic subtest blt: SUCCESS (0.002s)
[417.091255] Starting dynamic subtest: vebox
[417.092817] Dynamic subtest vebox: SUCCESS (0.003s)
[417.094409] Subtest legacy-resubmit: SUCCESS (0.027s)
[417.277114] [109/133] (609s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[417.377011] Starting subtest: x-tiled-addfb-size-offset-overflow
[417.378917] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[417.479216] [110/133] (609s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[417.569035] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[417.570858] Starting dynamic subtest: pipe-A-eDP-1
[419.566381] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.988s)
[419.576311] Starting dynamic subtest: pipe-B-eDP-1
[421.222584] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.653s)
[421.233178] Starting dynamic subtest: pipe-C-eDP-1
[422.745587] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.523s)
[422.756236] Starting dynamic subtest: pipe-D-eDP-1
[424.257431] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.510s)
[424.259618] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.679s)
[425.431888] [111/133] (601s left) gem_ctx_bad_destroy (invalid-ctx)
[425.491283] Starting subtest: invalid-ctx
[425.493578] Subtest invalid-ctx: SUCCESS (0.000s)
[425.579175] [112/133] (601s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[425.705897] Starting subtest: cursor-vs-flip-atomic-transitions
[455.742302] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.036s)
[456.558128] [113/133] (570s left) gem_ctx_persistence (legacy-engines-mixed)
[456.622835] Starting subtest: legacy-engines-mixed
[456.625109] Starting dynamic subtest: render
[456.691228] Dynamic subtest render: SUCCESS (0.068s)
[456.703787] Starting dynamic subtest: bsd1
[456.744096] Dynamic subtest bsd1: SUCCESS (0.050s)
[456.758677] Starting dynamic subtest: bsd2
[456.803087] Dynamic subtest bsd2: SUCCESS (0.056s)
[456.814307] Starting dynamic subtest: blt
[456.854169] Dynamic subtest blt: SUCCESS (0.048s)
[456.865328] Starting dynamic subtest: vebox
[456.911181] Dynamic subtest vebox: SUCCESS (0.054s)
[456.913956] Subtest legacy-engines-mixed: SUCCESS (0.289s)
[456.990908] [114/133] (570s left) gem_exec_flush (basic-batch-kernel-default-uc)
[457.045943] Starting subtest: basic-batch-kernel-default-uc
[464.205010] Subtest basic-batch-kernel-default-uc: SUCCESS (7.158s)
[464.417816] [115/133] (562s left) gem_exec_schedule (u-semaphore-noskip)
[464.490005] Starting subtest: u-semaphore-noskip
[464.933724] Subtest u-semaphore-noskip: SUCCESS (0.450s)
[465.290508] [116/133] (562s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[465.393151] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[465.397405] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[465.497759] [117/133] (561s left) kms_psr (pr-primary-page-flip)
[465.595828] Starting subtest: pr-primary-page-flip
[465.600245] Subtest pr-primary-page-flip: SKIP (0.000s)
[465.672420] [118/133] (561s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[465.778455] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[465.780722] Starting dynamic subtest: pipe-A-eDP-1
[466.286728] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.483s)
[466.297862] Starting dynamic subtest: pipe-B-eDP-1
[467.753636] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.460s)
[467.766306] Starting dynamic subtest: pipe-C-eDP-1
[469.184258] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.431s)
[469.196315] Starting dynamic subtest: pipe-D-eDP-1
[470.578832] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.394s)
[470.580835] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.774s)
[471.712255] [119/133] (555s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[471.841957] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[471.845976] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[471.944823] [120/133] (555s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[472.050220] Starting subtest: y-tiled-8bpp-rotate-180
[472.054767] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[472.159387] [121/133] (555s left) kms_pwrite_crc
[473.836492] [122/133] (553s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[473.936923] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[473.941050] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[474.010384] [123/133] (553s left) syncobj_timeline (reset-unsignaled)
[474.061496] Starting subtest: reset-unsignaled
[474.063814] Subtest reset-unsignaled: SUCCESS (0.000s)
[474.150196] [124/133] (553s left) gem_ccs (block-copy-uncompressed)
[474.211556] Starting subtest: block-copy-uncompressed
[474.213732] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[474.234216] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.022s)
[474.248078] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[474.255122] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.020s)
[474.264621] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[474.272089] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[474.283578] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[474.290348] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[474.292592] Subtest block-copy-uncompressed: SUCCESS (0.079s)
[474.415437] [125/133] (553s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[474.549589] Starting subtest: dp-mst-type-0-suspend-resume
[474.554467] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[474.678921] [126/133] (553s left) gem_exec_params (dr1-dirt)
[474.741063] Starting subtest: DR1-dirt
[474.743359] Subtest DR1-dirt: SUCCESS (0.000s)
[474.857265] [127/133] (553s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[474.963294] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[474.966829] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[475.048696] [128/133] (552s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[475.110490] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[475.174669] [129/133] (552s left) gem_workarounds (reset-fd)
[475.242577] Starting subtest: reset-fd
[475.426565] Subtest reset-fd: SUCCESS (0.184s)
[475.537484] [130/133] (552s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[475.628815] Starting subtest: bad-aux-stride-y-tiled-ccs
[475.630612] Starting dynamic subtest: pipe-A-eDP-1
[475.649237] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[475.659384] Starting dynamic subtest: pipe-B-eDP-1
[475.677003] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[475.686435] Starting dynamic subtest: pipe-C-eDP-1
[475.704293] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[475.714821] Starting dynamic subtest: pipe-D-eDP-1
[475.732975] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[475.736339] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.005s)
[477.886331] [131/133] (550s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[477.982982] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[477.987075] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[478.084620] [132/133] (550s left) kms_vblank (ts-continuation-modeset-hang)
[478.183845] Starting subtest: ts-continuation-modeset-hang
[478.186076] Starting dynamic subtest: pipe-A-eDP-1
[505.432904] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.247s)
[505.448074] Starting dynamic subtest: pipe-D-eDP-1
[530.388701] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.952s)
[530.391054] Subtest ts-continuation-modeset-hang: SUCCESS (52.204s)
[531.222435] [133/133] (496s left) kms_flip (flip-vs-panning-interruptible)
[531.328301] Starting subtest: flip-vs-panning-interruptible
[531.330723] Starting dynamic subtest: A-eDP1
[540.016840] Dynamic subtest A-eDP1: SUCCESS (8.688s)
[540.029503] Starting dynamic subtest: B-eDP1
[548.751831] Dynamic subtest B-eDP1: SUCCESS (8.731s)
[548.762919] Starting dynamic subtest: C-eDP1
[557.473856] Dynamic subtest C-eDP1: SUCCESS (8.721s)
[557.486678] Starting dynamic subtest: D-eDP1
[566.208356] Dynamic subtest D-eDP1: SUCCESS (8.732s)
[566.212688] Subtest flip-vs-panning-interruptible: SUCCESS (34.886s)
[567.365450] Closing watchdogs
results: parsing output: 0/ for test: gen9_exec_parse
results: parsing output: 1/ for test: kms_cursor_legacy
results: parsing output: 2/ for test: kms_busy
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_plane
results: parsing output: 6/ for test: perf_pmu
results: parsing output: 7/ for test: gem_exec_params
results: parsing output: 8/ for test: gem_mmap_offset
results: parsing output: 9/ for test: syncobj_wait
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: syncobj_wait
results: parsing output: 12/ for test: gem_render_copy
results: parsing output: 13/ for test: gem_ctx_exec
results: parsing output: 14/ for test: gem_exec_reloc
results: parsing output: 15/ for test: core_debugfs
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: gem_ctx_param
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: gem_ppgtt
results: parsing output: 21/ for test: kms_psr2_sf
results: parsing output: 22/ for test: kms_flip_scaled_crc
results: parsing output: 23/ for test: kms_rotation_crc
results: parsing output: 24/ for test: api_intel_allocator
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_setmode
results: parsing output: 27/ for test: gem_render_copy
results: parsing output: 28/ for test: gem_exec_params
results: parsing output: 29/ for test: kms_dsc
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_exec_fence
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: i915_pm_rpm
results: parsing output: 34/ for test: kms_flip
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_invalid_mode
results: parsing output: 37/ for test: i915_query
results: parsing output: 38/ for test: kms_pm_dc
results: parsing output: 39/ for test: gem_eio
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_chamelium_hpd
results: parsing output: 43/ for test: kms_cursor_legacy
results: parsing output: 44/ for test: kms_color
results: parsing output: 45/ for test: kms_rotation_crc
results: parsing output: 46/ for test: kms_legacy_colorkey
results: parsing output: 47/ for test: kms_psr
results: parsing output: 48/ for test: gem_exec_balancer
results: parsing output: 49/ for test: i915_drm_fdinfo
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_userptr_blits
results: parsing output: 53/ for test: vgem_basic
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_cursor_legacy
results: parsing output: 56/ for test: sw_sync
results: parsing output: 57/ for test: kms_cursor_crc
results: parsing output: 58/ for test: gem_exec_params
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: dmabuf_sync_file
results: parsing output: 62/ for test: gem_eio
results: parsing output: 63/ for test: perf
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: gem_lmem_swapping
results: parsing output: 66/ for test: kms_atomic_interruptible
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: gem_mmap_wc
results: parsing output: 69/ for test: gem_lmem_swapping
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_exec_balancer
results: parsing output: 72/ for test: perf
results: parsing output: 73/ for test: gem_ctx_shared
results: parsing output: 74/ for test: kms_cursor_crc
results: parsing output: 75/ for test: kms_atomic
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_pm_rpm
results: parsing output: 78/ for test: gem_exec_schedule
results: parsing output: 79/ for test: sriov_basic
results: parsing output: 80/ for test: gem_partial_pwrite_pread
results: parsing output: 81/ for test: gem_exec_schedule
results: parsing output: 82/ for test: i915_getparams_basic
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: gem_exec_reloc
results: parsing output: 85/ for test: kms_plane_scaling
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_selftest
results: parsing output: 88/ for test: kms_psr2_sf
results: parsing output: 89/ for test: kms_flip_scaled_crc
results: parsing output: 90/ for test: kms_cursor_crc
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: kms_chamelium_edid
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_plane_scaling
results: parsing output: 95/ for test: kms_plane_multiple
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: kms_plane_alpha_blend
results: parsing output: 98/ for test: gem_ctx_engines
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: intel_hwmon
results: parsing output: 102/ for test: kms_hdr
results: parsing output: 103/ for test: kms_psr2_sf
results: parsing output: 104/ for test: gem_userptr_blits
results: parsing output: 105/ for test: gem_exec_params
results: parsing output: 106/ for test: kms_cursor_legacy
results: parsing output: 107/ for test: gem_spin_batch
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: gem_ctx_bad_destroy
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: gem_ctx_persistence
results: parsing output: 113/ for test: gem_exec_flush
results: parsing output: 114/ for test: gem_exec_schedule
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: kms_pwrite_crc
results: parsing output: 121/ for test: kms_flip_scaled_crc
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: gem_ccs
results: parsing output: 124/ for test: kms_content_protection
results: parsing output: 125/ for test: gem_exec_params
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_exec_reloc
results: parsing output: 128/ for test: gem_workarounds
results: parsing output: 129/ for test: kms_ccs
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_vblank
results: parsing output: 132/ for test: kms_flip
Done.