[57.721569] Initializing watchdogs
[57.721616]   /dev/watchdog0
[57.735186] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.739262] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.741914] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.745208] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[57.865902] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[64.663853] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.836s)
[64.784325] [002/133] (953s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[64.880146] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[64.882549] Starting dynamic subtest: pipe-A-eDP-1
[64.905757] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[64.915268] Starting dynamic subtest: pipe-B-eDP-1
[64.936288] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[64.942786] Starting dynamic subtest: pipe-C-eDP-1
[64.964199] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[64.970965] Starting dynamic subtest: pipe-D-eDP-1
[64.992768] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[64.996814] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[67.164965] [003/133] (951s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[67.525418] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[67.527799] Starting dynamic subtest: pipe-A-eDP-1
[67.551124] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[67.560422] Starting dynamic subtest: pipe-B-eDP-1
[67.583662] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[67.590902] Starting dynamic subtest: pipe-C-eDP-1
[67.613711] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[67.621063] Starting dynamic subtest: pipe-D-eDP-1
[67.644399] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[67.648663] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[69.727853] [004/133] (948s left) gem_softpin (overlap)
[69.801613] Starting subtest: overlap
[70.707387] Subtest overlap: SUCCESS (0.905s)
[70.814567] [005/133] (947s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[70.928451] Starting subtest: basic-flip-after-cursor-varying-size
[71.875923] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.948s)
[72.750638] [006/133] (945s left) kms_setmode (invalid-clone-single-crtc)
[72.812570] Starting subtest: invalid-clone-single-crtc
[72.818837] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[72.905321] [007/133] (945s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[72.963241] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[73.027494] [008/133] (945s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[73.132076] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[73.134425] Starting dynamic subtest: pipe-A
[73.152165] Dynamic subtest pipe-A: SKIP (0.017s)
[73.160921] Starting dynamic subtest: pipe-B
[73.185475] Dynamic subtest pipe-B: SKIP (0.034s)
[73.192875] Starting dynamic subtest: pipe-C
[73.219733] Dynamic subtest pipe-C: SKIP (0.034s)
[73.226876] Starting dynamic subtest: pipe-D
[73.251490] Dynamic subtest pipe-D: SKIP (0.030s)
[73.255887] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.116s)
[73.373697] [009/133] (945s left) i915_suspend (debugfs-reader)
[73.426685] Starting subtest: debugfs-reader
[92.291646] Subtest debugfs-reader: SUCCESS (3.291s)
[92.429886] [010/133] (926s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[92.541298] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[92.543539] Starting dynamic subtest: pipe-A-eDP-1
[99.090032] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.725s)
[99.100176] Starting dynamic subtest: pipe-B-eDP-1
[105.921333] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.904s)
[105.923601] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.631s)
[106.782163] [011/133] (911s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[106.849732] Starting subtest: invalid-bsd2-flag-on-vebox
[106.852175] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[106.953704] [012/133] (911s left) gem_mmap_offset (mmap-unmap)
[107.000518] Starting subtest: mmap-unmap
[107.005625] Starting dynamic subtest: smem0
[130.069176] Dynamic subtest smem0: SUCCESS (23.061s)
[130.071816] Subtest mmap-unmap: SUCCESS (23.062s)
[130.122933] [013/133] (888s left) kms_content_protection (lic-type-0)
[130.275205] Starting subtest: lic-type-0
[130.279782] Subtest lic-type-0: SKIP (0.000s)
[130.396951] [014/133] (888s left) gem_exec_balancer (parallel-bb-first)
[130.665889] Starting subtest: parallel-bb-first
[131.606906] Subtest parallel-bb-first: SUCCESS (0.945s)
[132.521685] [015/133] (886s left) gem_reg_read (timestamp-moving)
[132.585243] Starting subtest: timestamp-moving
[133.586964] Subtest timestamp-moving: SUCCESS (1.001s)
[133.661680] [016/133] (885s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[133.771429] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[140.631252] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.864s)
[140.751639] [017/133] (878s left) syncobj_timeline (single-wait-signaled)
[140.810394] Starting subtest: single-wait-signaled
[140.813185] Subtest single-wait-signaled: SUCCESS (0.001s)
[140.915108] [018/133] (878s left) gem_exec_reloc (basic-gtt-read-active)
[140.982950] Subtest basic-gtt-read-active: SKIP (0.000s)
[141.072004] [019/133] (877s left) syncobj_wait (reset-multiple-signaled)
[141.127296] Starting subtest: reset-multiple-signaled
[141.129719] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[141.222384] [020/133] (877s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[141.317392] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[142.418034] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.101s)
[142.538124] [021/133] (876s left) kms_vblank (ts-continuation-modeset)
[142.633083] Starting subtest: ts-continuation-modeset
[142.635631] Starting dynamic subtest: pipe-A-eDP-1
[144.125564] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.491s)
[144.139687] Starting dynamic subtest: pipe-D-eDP-1
[146.301104] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.172s)
[146.303457] Subtest ts-continuation-modeset: SUCCESS (3.667s)
[147.102091] [022/133] (872s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[147.201009] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[147.205478] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[147.305260] [023/133] (871s left) kms_dp_aux_dev
[147.655358] [024/133] (871s left) gem_mmap_wc (close)
[147.711106] Subtest close: SKIP (0.000s)
[147.765250] [025/133] (871s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[147.858485] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[152.350998] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.498s)
[153.514647] [026/133] (865s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[153.610298] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[153.612592] Starting dynamic subtest: pipe-A-eDP-1
[153.670979] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[153.681111] Starting dynamic subtest: pipe-B-eDP-1
[153.745030] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[153.755291] Starting dynamic subtest: pipe-C-eDP-1
[153.811676] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[153.820650] Starting dynamic subtest: pipe-D-eDP-1
[153.876620] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[153.880755] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s)
[155.852741] [027/133] (863s left) gem_ctx_persistence (idempotent)
[155.904948] Starting subtest: idempotent
[155.907499] Subtest idempotent: SUCCESS (0.000s)
[156.008919] [028/133] (863s left) prime_mmap (test_reprime)
[156.070025] Starting subtest: test_reprime
[156.071982] Starting dynamic subtest: test_reprime-smem
[156.101925] Dynamic subtest test_reprime-smem: SUCCESS (0.033s)
[156.104477] Subtest test_reprime: SUCCESS (0.034s)
[156.206416] [029/133] (863s left) kms_psr (fbc-psr-sprite-plane-move)
[156.297246] Starting subtest: fbc-psr-sprite-plane-move
[156.299777] Starting dynamic subtest: eDP-1
[156.304272] Dynamic subtest eDP-1: SKIP (0.000s)
[156.308674] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[156.382009] [030/133] (863s left) syncobj_eventfd (invalid-illegal-handle)
[156.444492] Starting subtest: invalid-illegal-handle
[156.446548] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[156.553002] [031/133] (862s left) gem_exec_schedule (preempt-contexts)
[156.626198] Starting subtest: preempt-contexts
[156.628395] Starting dynamic subtest: rcs0
[156.680336] Dynamic subtest rcs0: SUCCESS (0.058s)
[156.690226] Starting dynamic subtest: bcs0
[156.738969] Dynamic subtest bcs0: SUCCESS (0.058s)
[156.752239] Starting dynamic subtest: vcs0
[156.782906] Dynamic subtest vcs0: SUCCESS (0.044s)
[156.790724] Starting dynamic subtest: vcs1
[156.849858] Dynamic subtest vcs1: SUCCESS (0.066s)
[156.857768] Starting dynamic subtest: vecs0
[156.897623] Dynamic subtest vecs0: SUCCESS (0.047s)
[156.905994] Starting dynamic subtest: ccs0
[156.957281] Dynamic subtest ccs0: SUCCESS (0.059s)
[156.959216] Subtest preempt-contexts: SUCCESS (0.337s)
[158.620940] [032/133] (860s left) kms_atomic_interruptible (universal-setplane-primary)
[158.716075] Starting subtest: universal-setplane-primary
[158.718477] Starting dynamic subtest: pipe-A-eDP-1
[166.095070] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.380s)
[166.097416] Subtest universal-setplane-primary: SUCCESS (7.382s)
[166.931098] [033/133] (852s left) sw_sync (sync_multi_consumer)
[166.964521] Starting subtest: sync_multi_consumer
[167.397854] Subtest sync_multi_consumer: SUCCESS (0.434s)
[167.497417] [034/133] (852s left) gem_exec_fence (parallel)
[167.684792] Starting subtest: parallel
[167.687157] Starting dynamic subtest: rcs0
[169.835745] Dynamic subtest rcs0: SUCCESS (2.152s)
[169.846118] Starting dynamic subtest: bcs0
[171.985266] Dynamic subtest bcs0: SUCCESS (2.150s)
[171.995585] Starting dynamic subtest: vcs0
[174.133766] Dynamic subtest vcs0: SUCCESS (2.149s)
[174.141649] Starting dynamic subtest: vcs1
[176.283096] Dynamic subtest vcs1: SUCCESS (2.149s)
[176.294285] Starting dynamic subtest: vecs0
[178.435372] Dynamic subtest vecs0: SUCCESS (2.153s)
[178.445293] Starting dynamic subtest: ccs0
[180.587016] Dynamic subtest ccs0: SUCCESS (2.152s)
[180.589092] Subtest parallel: SUCCESS (12.909s)
[181.586958] [FACT gem_exec_fence (parallel)] new: kernel.kmod_is_loaded.vgem: true
[181.590558] [035/133] (838s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[181.709706] Starting subtest: 2x-long-cursor-vs-flip-atomic
[181.714470] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[181.854209] [036/133] (837s left) syncobj_wait (invalid-reset-one-illegal-handle)
[181.905628] Starting subtest: invalid-reset-one-illegal-handle
[181.907618] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[181.999020] [037/133] (837s left) i915_hangman (gt-engine-error)
[182.081830] Starting subtest: gt-engine-error
[182.083758] Starting dynamic subtest: rcs0
[183.463086] Dynamic subtest rcs0: SUCCESS (1.381s)
[183.475181] Starting dynamic subtest: bcs0
[185.447376] Dynamic subtest bcs0: SUCCESS (1.983s)
[185.459105] Starting dynamic subtest: vcs0
[187.492637] Dynamic subtest vcs0: SUCCESS (2.043s)
[187.504093] Starting dynamic subtest: vcs1
[189.413453] Dynamic subtest vcs1: SUCCESS (1.917s)
[189.424900] Starting dynamic subtest: vecs0
[190.501505] Dynamic subtest vecs0: SUCCESS (1.084s)
[190.513646] Starting dynamic subtest: ccs0
[192.486380] Dynamic subtest ccs0: SUCCESS (1.981s)
[192.489135] Subtest gt-engine-error: SUCCESS (10.403s)
[192.630577] [038/133] (827s left) kms_prop_blob (invalid-get-prop-any)
[192.690547] Starting subtest: invalid-get-prop-any
[192.692739] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[192.772266] [039/133] (827s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[192.867308] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[192.869583] Starting dynamic subtest: pipe-A-eDP-1
[192.892197] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[192.902261] Starting dynamic subtest: pipe-B-eDP-1
[192.924092] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[192.932319] Starting dynamic subtest: pipe-C-eDP-1
[192.954125] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[192.961732] Starting dynamic subtest: pipe-D-eDP-1
[192.983402] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[192.987793] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.005s)
[195.099464] [040/133] (824s left) device_reset (cold-reset-bound)
[195.149545] Starting subtest: cold-reset-bound
[195.153678] Subtest cold-reset-bound: SKIP (0.000s)
[195.222109] [041/133] (824s left) gem_flink_basic (flink-lifetime)
[195.285887] Starting subtest: flink-lifetime
[195.288535] Subtest flink-lifetime: SUCCESS (0.002s)
[195.407485] [042/133] (824s left) kms_addfb_basic (addfb25-4-tiled)
[195.500815] Starting subtest: addfb25-4-tiled
[195.502648] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[195.594447] [043/133] (824s left) gem_ppgtt (shrink-vs-evict-pinned)
[195.658522] Starting subtest: shrink-vs-evict-pinned
[201.502756] Subtest shrink-vs-evict-pinned: SUCCESS (5.839s)
[201.590956] [044/133] (818s left) gem_exec_whisper (basic-fds-priority-all)
[201.660917] Starting subtest: basic-fds-priority-all
[225.492345] Subtest basic-fds-priority-all: SUCCESS (23.827s)
[225.676448] [045/133] (794s left) kms_flip (2x-flip-vs-dpms)
[225.771589] Starting subtest: 2x-flip-vs-dpms
[225.782137] Subtest 2x-flip-vs-dpms: SKIP (0.010s)
[225.871249] [046/133] (794s left) perf_pmu (semaphore-wait)
[225.909588] Starting subtest: semaphore-wait
[225.911906] Starting dynamic subtest: rcs0
[226.426728] Dynamic subtest rcs0: SUCCESS (0.515s)
[226.438838] Starting dynamic subtest: bcs0
[226.940338] Dynamic subtest bcs0: SUCCESS (0.511s)
[226.950651] Starting dynamic subtest: vcs0
[227.454619] Dynamic subtest vcs0: SUCCESS (0.512s)
[227.465289] Starting dynamic subtest: vcs1
[227.968261] Dynamic subtest vcs1: SUCCESS (0.511s)
[227.979768] Starting dynamic subtest: vecs0
[228.483663] Dynamic subtest vecs0: SUCCESS (0.511s)
[228.497035] Starting dynamic subtest: ccs0
[228.998500] Dynamic subtest ccs0: SUCCESS (0.513s)
[229.001313] Subtest semaphore-wait: SUCCESS (3.089s)
[230.544974] [047/133] (789s left) perf (invalid-oa-metric-set-id)
[230.662471] Starting subtest: invalid-oa-metric-set-id
[230.680543] Subtest invalid-oa-metric-set-id: SUCCESS (0.019s)
[230.721369] [048/133] (789s left) sysfs_preempt_timeout (timeout)
[230.776336] Starting subtest: timeout
[230.778654] Starting dynamic subtest: vecs0
[240.521021] Dynamic subtest vecs0: SUCCESS (9.741s)
[240.533091] Starting dynamic subtest: ccs0
[241.752149] Dynamic subtest ccs0: SUCCESS (1.230s)
[241.761712] Starting dynamic subtest: vcs0
[251.521635] Dynamic subtest vcs0: SUCCESS (9.768s)
[251.532694] Starting dynamic subtest: bcs0
[252.765890] Dynamic subtest bcs0: SUCCESS (1.245s)
[252.780765] Starting dynamic subtest: rcs0
[253.930866] Dynamic subtest rcs0: SUCCESS (1.164s)
[253.939785] Starting dynamic subtest: vcs1
[263.486364] Dynamic subtest vcs1: SUCCESS (9.553s)
[263.488829] Subtest timeout: SUCCESS (32.712s)
[263.565284] [049/133] (756s left) perf_pmu (busy-idle-no-semaphores)
[263.609879] Starting subtest: busy-idle-no-semaphores
[263.612082] Starting dynamic subtest: rcs0
[264.283383] Dynamic subtest rcs0: SUCCESS (0.674s)
[264.293177] Starting dynamic subtest: bcs0
[264.940634] Dynamic subtest bcs0: SUCCESS (0.655s)
[264.952625] Starting dynamic subtest: vcs0
[265.594179] Dynamic subtest vcs0: SUCCESS (0.652s)
[265.606798] Starting dynamic subtest: vcs1
[267.118279] Dynamic subtest vcs1: SUCCESS (1.522s)
[267.129097] Starting dynamic subtest: vecs0
[269.103198] Dynamic subtest vecs0: SUCCESS (1.982s)
[269.114992] Starting dynamic subtest: ccs0
[271.154405] Dynamic subtest ccs0: SUCCESS (2.049s)
[271.157256] Subtest busy-idle-no-semaphores: SUCCESS (7.547s)
[271.297084] [050/133] (749s left) gen9_exec_parse (bb-chained)
[271.358832] Subtest bb-chained: SKIP (0.000s)
[271.422065] [051/133] (748s left) kms_big_fb (linear-64bpp-rotate-180)
[271.530417] Starting subtest: linear-64bpp-rotate-180
[273.177143] Subtest linear-64bpp-rotate-180: SUCCESS (1.648s)
[273.341208] [052/133] (747s left) kms_flip (flip-vs-suspend-interruptible)
[273.440701] Starting subtest: flip-vs-suspend-interruptible
[273.442600] Starting dynamic subtest: A-eDP1
[323.298754] Dynamic subtest A-eDP1: SUCCESS (4.523s)
[323.309012] Starting dynamic subtest: B-eDP1
[372.317591] Dynamic subtest B-eDP1: SUCCESS (4.511s)
[372.328782] Starting dynamic subtest: C-eDP1
[421.296071] Dynamic subtest C-eDP1: SUCCESS (4.572s)
[421.311934] Starting dynamic subtest: D-eDP1
[470.279715] Dynamic subtest D-eDP1: SUCCESS (4.559s)
[470.285084] Subtest flip-vs-suspend-interruptible: SUCCESS (18.175s)
[471.430222] [053/133] (549s left) gem_spin_batch (legacy-resubmit-new)
[471.508612] Starting subtest: legacy-resubmit-new
[471.510804] Starting dynamic subtest: default
[471.515551] Dynamic subtest default: SUCCESS (0.007s)
[471.527940] Starting dynamic subtest: render
[471.530060] Dynamic subtest render: SUCCESS (0.003s)
[471.539285] Starting dynamic subtest: bsd
[471.541437] Dynamic subtest bsd: SUCCESS (0.004s)
[471.550442] Starting dynamic subtest: bsd1
[471.552221] Dynamic subtest bsd1: SUCCESS (0.004s)
[471.561072] Starting dynamic subtest: bsd2
[471.562816] Dynamic subtest bsd2: SUCCESS (0.003s)
[471.571438] Starting dynamic subtest: blt
[471.573263] Dynamic subtest blt: SUCCESS (0.006s)
[471.581641] Starting dynamic subtest: vebox
[471.583515] Dynamic subtest vebox: SUCCESS (0.004s)
[471.585364] Subtest legacy-resubmit-new: SUCCESS (0.036s)
[473.328856] [054/133] (547s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[473.429166] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[473.433299] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[473.522387] [055/133] (547s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[473.616851] Starting subtest: extended-pageflip-modeset-hang-oldfb
[473.619225] Starting dynamic subtest: pipe-A
[481.364573] Dynamic subtest pipe-A: SUCCESS (7.883s)
[481.373866] Starting dynamic subtest: pipe-D
[489.970558] Dynamic subtest pipe-D: SUCCESS (8.657s)
[489.972872] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.545s)
[490.819480] [056/133] (529s left) kms_atomic (plane-overlay-legacy)
[490.912055] Starting subtest: plane-overlay-legacy
[490.914292] Starting dynamic subtest: pipe-A-eDP-1
[491.345024] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.434s)
[491.346911] Subtest plane-overlay-legacy: SUCCESS (0.435s)
[492.158851] [057/133] (528s left) kms_psr (psr-sprite-plane-move)
[492.255988] Starting subtest: psr-sprite-plane-move
[492.258336] Starting dynamic subtest: eDP-1
[494.015223] Dynamic subtest eDP-1: SUCCESS (1.765s)
[494.017494] Subtest psr-sprite-plane-move: SUCCESS (1.765s)
[494.816631] [058/133] (525s left) gem_exec_create (madvise)
[494.875092] Starting subtest: madvise
[494.877440] Starting dynamic subtest: smem
[516.415062] Dynamic subtest smem: SUCCESS (21.536s)
[516.417607] Subtest madvise: SUCCESS (21.537s)
[517.381956] [059/133] (503s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping)
[517.492681] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping
[517.497051] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s)
[517.577186] [060/133] (503s left) gem_lmem_swapping (parallel-random)
[517.617656] Subtest parallel-random: SKIP (0.000s)
[517.662837] [061/133] (503s left) kms_flip (2x-plain-flip)
[517.756520] Starting subtest: 2x-plain-flip
[517.768239] Subtest 2x-plain-flip: SKIP (0.011s)
[517.881340] [062/133] (502s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[517.943447] Starting subtest: multi-wait-for-submit-submitted-signaled
[517.945864] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[518.066384] [063/133] (502s left) gem_mmap_gtt (fault-concurrent-x)
[518.129515] Subtest fault-concurrent-X: SKIP (0.000s)
[518.200411] [064/133] (502s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[518.301704] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[524.966569] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.667s)
[525.081295] [065/133] (495s left) prime_mmap_coherency (write)
[525.137394] Starting subtest: write
[530.516949] Subtest write: SUCCESS (5.378s)
[530.681682] [066/133] (490s left) gem_ctx_freq (sysfs)
[530.753141] Starting subtest: sysfs
[530.755403] Starting dynamic subtest: gt0
[536.277779] Dynamic subtest gt0: SUCCESS (5.525s)
[536.289450] Starting dynamic subtest: gt1
[578.305167] Dynamic subtest gt1: SUCCESS (42.027s)
[578.308276] Subtest sysfs: SUCCESS (47.555s)
[578.463551] [067/133] (442s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[578.567222] Starting subtest: fbcpsr-slowdraw
[603.745367] Subtest fbcpsr-slowdraw: SUCCESS (25.179s)
[603.874300] [068/133] (417s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[603.991315] Starting subtest: 2x-cursor-vs-flip-atomic
[603.995933] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[604.139685] [069/133] (417s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[604.244832] Starting subtest: flip-vs-cursor-toggle
[612.782321] Subtest flip-vs-cursor-toggle: SUCCESS (8.540s)
[613.599375] [070/133] (407s left) kms_pm_rpm (modeset-lpsp)
[615.444795] Starting subtest: modeset-lpsp
[616.913398] Subtest modeset-lpsp: SUCCESS (1.473s)
[617.036897] [071/133] (404s left) gem_exec_schedule (fairslice)
[617.120863] Starting subtest: fairslice
[617.127521] Starting dynamic subtest: rcs0
[619.136137] Dynamic subtest rcs0: SUCCESS (2.024s)
[619.146381] Starting dynamic subtest: bcs0
[621.157509] Dynamic subtest bcs0: SUCCESS (2.020s)
[621.169241] Starting dynamic subtest: vcs0
[623.229239] Dynamic subtest vcs0: SUCCESS (2.019s)
[623.240126] Starting dynamic subtest: vcs1
[625.196902] Dynamic subtest vcs1: SUCCESS (2.019s)
[625.206627] Starting dynamic subtest: vecs0
[627.267753] Dynamic subtest vecs0: SUCCESS (2.022s)
[627.279130] Starting dynamic subtest: ccs0
[629.239588] Dynamic subtest ccs0: SUCCESS (2.019s)
[629.241763] Subtest fairslice: SUCCESS (12.128s)
[629.536717] [072/133] (391s left) api_intel_bb (object-reloc-keep-cache)
[629.591263] Starting subtest: object-reloc-keep-cache
[629.599215] Subtest object-reloc-keep-cache: SKIP (0.006s)
[629.702065] [073/133] (391s left) perf_pmu (busy-check-all)
[629.742995] Starting subtest: busy-check-all
[629.744784] Starting dynamic subtest: rcs0
[630.299522] Dynamic subtest rcs0: SUCCESS (0.557s)
[630.312415] Starting dynamic subtest: bcs0
[630.854518] Dynamic subtest bcs0: SUCCESS (0.552s)
[630.867345] Starting dynamic subtest: vcs0
[632.320290] Dynamic subtest vcs0: SUCCESS (1.463s)
[632.331748] Starting dynamic subtest: vcs1
[634.306427] Dynamic subtest vcs1: SUCCESS (1.984s)
[634.320907] Starting dynamic subtest: vecs0
[636.289620] Dynamic subtest vecs0: SUCCESS (1.980s)
[636.302829] Starting dynamic subtest: ccs0
[636.844268] Dynamic subtest ccs0: SUCCESS (0.553s)
[636.846863] Subtest busy-check-all: SUCCESS (7.105s)
[636.961590] [074/133] (384s left) gem_ctx_exec (basic-close-race)
[637.020656] Starting subtest: basic-close-race
[643.195245] Subtest basic-close-race: SUCCESS (6.121s)
[643.266154] [075/133] (378s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[643.372764] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[643.377032] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[643.460108] [076/133] (377s left) kms_flip (plain-flip-ts-check)
[643.555827] Starting subtest: plain-flip-ts-check
[643.557942] Starting dynamic subtest: A-eDP1
[652.496092] Dynamic subtest A-eDP1: SUCCESS (8.913s)
[652.506677] Starting dynamic subtest: B-eDP1
[661.335054] Dynamic subtest B-eDP1: SUCCESS (8.836s)
[661.348394] Starting dynamic subtest: C-eDP1
[670.163277] Dynamic subtest C-eDP1: SUCCESS (8.817s)
[670.174621] Starting dynamic subtest: D-eDP1
[678.939648] Dynamic subtest D-eDP1: SUCCESS (8.821s)
[678.944426] Subtest plain-flip-ts-check: SUCCESS (35.398s)
[680.108088] [077/133] (341s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[680.205203] Starting subtest: fbc-psr2-cursor-mmap-gtt
[680.207402] Starting dynamic subtest: eDP-1
[680.212040] Dynamic subtest eDP-1: SKIP (0.000s)
[680.216769] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[680.276516] [078/133] (341s left) api_intel_bb (blit-reloc-keep-cache)
[680.342252] Starting subtest: blit-reloc-keep-cache
[680.346581] Subtest blit-reloc-keep-cache: SKIP (0.000s)
[680.456004] [079/133] (341s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[680.542518] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[680.546932] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[680.631273] [080/133] (340s left) gem_softpin (evict-active)
[680.690317] Starting subtest: evict-active
[680.695679] Subtest evict-active: SUCCESS (0.005s)
[680.785315] [081/133] (340s left) kms_chamelium_frames (vga-frame-dump)
[681.159584] Subtest vga-frame-dump: SKIP (0.000s)
[681.935765] [082/133] (339s left) kms_color (ctm-green-to-red)
[682.027932] Starting subtest: ctm-green-to-red
[682.030391] Starting dynamic subtest: pipe-A-eDP-1
[682.719536] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.693s)
[682.729461] Starting dynamic subtest: pipe-B-eDP-1
[684.153123] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.431s)
[684.163146] Starting dynamic subtest: pipe-C-eDP-1
[685.520781] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.368s)
[685.532541] Starting dynamic subtest: pipe-D-eDP-1
[686.831203] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.310s)
[686.833350] Subtest ctm-green-to-red: SUCCESS (4.805s)
[687.682886] [083/133] (334s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[687.845953] Starting subtest: cursor-rapid-movement-32x32
[687.890181] Subtest cursor-rapid-movement-32x32: SKIP (0.040s)
[688.182274] [084/133] (333s left) sw_sync (sync_merge_invalid)
[688.220846] Starting subtest: sync_merge_invalid
[688.237175] Subtest sync_merge_invalid: SUCCESS (0.015s)
[688.293889] [085/133] (333s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[688.349281] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[688.405161] [086/133] (333s left) kms_pm_dc (dc5-dpms-negative)
[689.524448] Starting subtest: dc5-dpms-negative
[689.529087] Subtest dc5-dpms-negative: SKIP (0.000s)
[689.629711] [087/133] (332s left) i915_pm_rpm (gem-idle)
[691.449568] Starting subtest: gem-idle
[697.652444] Subtest gem-idle: SUCCESS (6.193s)
[697.973749] [088/133] (323s left) kms_lease (page-flip-implicit-plane)
[699.335838] Starting subtest: page-flip-implicit-plane
[699.338216] Starting dynamic subtest: pipe-A-eDP-1
[699.819242] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.484s)
[699.831284] Starting dynamic subtest: pipe-B-eDP-1
[700.923229] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.100s)
[700.933430] Starting dynamic subtest: pipe-C-eDP-1
[702.031205] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.108s)
[702.041454] Starting dynamic subtest: pipe-D-eDP-1
[703.174069] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.139s)
[703.176377] Subtest page-flip-implicit-plane: SUCCESS (3.837s)
[704.008634] [089/133] (317s left) gem_wait (busy)
[704.064363] Starting subtest: busy
[704.066793] Starting dynamic subtest: all-engines
[705.345526] Dynamic subtest all-engines: SUCCESS (1.278s)
[705.360165] Starting dynamic subtest: rcs0
[705.885773] Dynamic subtest rcs0: SUCCESS (0.539s)
[705.898116] Starting dynamic subtest: bcs0
[706.425345] Dynamic subtest bcs0: SUCCESS (0.538s)
[706.438586] Starting dynamic subtest: vcs0
[708.289361] Dynamic subtest vcs0: SUCCESS (1.861s)
[708.301020] Starting dynamic subtest: vcs1
[710.336886] Dynamic subtest vcs1: SUCCESS (2.044s)
[710.349143] Starting dynamic subtest: vecs0
[712.321031] Dynamic subtest vecs0: SUCCESS (1.981s)
[712.334784] Starting dynamic subtest: ccs0
[712.862874] Dynamic subtest ccs0: SUCCESS (0.541s)
[712.865245] Subtest busy: SUCCESS (8.796s)
[713.061163] [090/133] (308s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[713.170149] Starting subtest: 4-tiled-64bpp-rotate-90
[713.189291] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.018s)
[713.292263] [091/133] (308s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[713.379014] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[718.000271] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.624s)
[719.134016] [092/133] (302s left) gem_render_copy_redux (flink-interruptible)
[719.191614] Starting subtest: flink-interruptible
[719.905938] Subtest flink-interruptible: SUCCESS (0.717s)
[720.055632] [093/133] (302s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[720.111911] Starting subtest: invalid-single-wait-all-unsubmitted
[720.113906] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[720.208595] [094/133] (302s left) kms_addfb_basic (unused-modifier)
[720.269604] Starting subtest: unused-modifier
[720.271645] Subtest unused-modifier: SUCCESS (0.000s)
[720.414283] [095/133] (301s left) i915_drm_fdinfo (memory-info-idle)
[720.453820] Starting subtest: memory-info-idle
[720.455872] Starting dynamic subtest: smem0
[720.473072] Dynamic subtest smem0: SUCCESS (0.022s)
[720.475057] Subtest memory-info-idle: SUCCESS (0.022s)
[720.546956] [096/133] (301s left) gem_eio (kms)
[720.795799] Starting subtest: kms
[740.379519] Subtest kms: SUCCESS (19.579s)
[741.556772] [097/133] (280s left) gem_exec_fence (basic-busy)
[741.745900] Starting subtest: basic-busy
[741.748296] Starting dynamic subtest: rcs0
[741.833178] Dynamic subtest rcs0: SUCCESS (0.090s)
[741.845944] Starting dynamic subtest: bcs0
[741.885069] Dynamic subtest bcs0: SUCCESS (0.049s)
[741.897407] Starting dynamic subtest: vcs0
[741.939935] Dynamic subtest vcs0: SUCCESS (0.053s)
[741.952089] Starting dynamic subtest: vcs1
[741.992383] Dynamic subtest vcs1: SUCCESS (0.050s)
[742.004402] Starting dynamic subtest: vecs0
[742.053745] Dynamic subtest vecs0: SUCCESS (0.059s)
[742.066470] Starting dynamic subtest: ccs0
[742.115674] Dynamic subtest ccs0: SUCCESS (0.060s)
[742.118282] Subtest basic-busy: SUCCESS (0.374s)
[744.400242] [098/133] (277s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[744.502752] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[744.507091] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[744.574485] [099/133] (277s left) gem_fence_thrash (bo-write-verify-threaded-y)
[744.610998] Starting subtest: bo-write-verify-threaded-y
[744.637062] Subtest bo-write-verify-threaded-y: SKIP (0.024s)
[744.699114] [100/133] (277s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[744.796378] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[744.800513] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[744.893389] [101/133] (277s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[745.008379] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[745.012580] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[745.094045] [102/133] (277s left) kms_plane_multiple (tiling-4)
[745.204720] Starting subtest: tiling-4
[745.207035] Starting dynamic subtest: pipe-A-eDP-1
[748.920443] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.715s)
[748.930808] Starting dynamic subtest: pipe-B-eDP-1
[753.253084] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.330s)
[753.263712] Starting dynamic subtest: pipe-C-eDP-1
[757.569831] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.316s)
[757.580380] Starting dynamic subtest: pipe-D-eDP-1
[761.911503] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.341s)
[761.913789] Subtest tiling-4: SUCCESS (16.707s)
[762.725368] [103/133] (259s left) kms_feature_discovery (psr2)
[762.822021] Starting subtest: psr2
[762.824443] Subtest psr2: SUCCESS (0.000s)
[762.897499] [104/133] (259s left) kms_psr (psr-cursor-render)
[762.982908] Starting subtest: psr-cursor-render
[762.984998] Starting dynamic subtest: eDP-1
[764.714160] Dynamic subtest eDP-1: SUCCESS (1.731s)
[764.716343] Subtest psr-cursor-render: SUCCESS (1.732s)
[765.575840] [105/133] (257s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[765.691418] Starting subtest: basic-busy-flip-before-cursor-varying-size
[765.696084] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[765.838029] [106/133] (256s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[765.926518] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[765.930910] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[766.008507] [107/133] (256s left) syncobj_timeline (host-signal-ordered)
[766.064305] Starting subtest: host-signal-ordered
[766.066529] Subtest host-signal-ordered: SUCCESS (0.000s)
[766.177467] [108/133] (256s left) kms_addfb_basic (invalid-set-prop)
[766.226918] Starting subtest: invalid-set-prop
[766.228869] Subtest invalid-set-prop: SUCCESS (0.000s)
[766.384043] [109/133] (256s left) kms_psr (psr2-basic)
[766.484029] Starting subtest: psr2-basic
[766.486328] Starting dynamic subtest: eDP-1
[768.144965] Dynamic subtest eDP-1: SUCCESS (1.661s)
[768.147264] Subtest psr2-basic: SUCCESS (1.662s)
[768.951063] [110/133] (253s left) gem_mmap_gtt (basic-write-gtt)
[769.016906] Subtest basic-write-gtt: SKIP (0.000s)
[769.088210] [111/133] (253s left) kms_cursor_crc (cursor-onscreen-32x10)
[769.266727] Starting subtest: cursor-onscreen-32x10
[769.319907] Subtest cursor-onscreen-32x10: SKIP (0.049s)
[769.621552] [112/133] (253s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[769.716928] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[769.719425] Starting dynamic subtest: pipe-A-eDP-1
[769.815242] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[769.828591] Starting dynamic subtest: pipe-B-eDP-1
[770.924131] Dynamic subtest pipe-B-eDP-1: SKIP (1.107s)
[770.928524] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.210s)
[772.112395] [113/133] (250s left) kms_chamelium_color (ctm-0-50)
[772.208951] Subtest ctm-0-50: SKIP (0.000s)
[772.253937] [114/133] (250s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[772.349349] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[779.013987] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.666s)
[779.136760] [115/133] (243s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k)
[779.523558] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s)
[780.344047] [116/133] (242s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[780.437068] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[780.439485] Starting dynamic subtest: pipe-A-default-mode
[781.622436] Dynamic subtest pipe-A-default-mode: SKIP (1.184s)
[781.626551] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.186s)
[781.746683] [117/133] (241s left) gem_exec_schedule (preempt-queue-contexts-chain)
[781.818508] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[782.110092] [118/133] (241s left) kms_getfb (getfb-handle-not-fb)
[782.215128] Starting subtest: getfb-handle-not-fb
[782.217323] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[782.315505] [119/133] (240s left) kms_joiner (basic-force-ultra-joiner)
[782.407027] Starting subtest: basic-force-ultra-joiner
[782.411076] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[782.474748] [120/133] (240s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[782.579623] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[782.702504] [121/133] (240s left) kms_sequence (get-idle)
[782.802076] Starting subtest: get-idle
[782.803948] Starting dynamic subtest: pipe-A-eDP-1
[784.617284] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.815s)
[784.628080] Starting dynamic subtest: pipe-B-eDP-1
[787.056569] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.439s)
[787.067218] Starting dynamic subtest: pipe-C-eDP-1
[789.471952] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.412s)
[789.482578] Starting dynamic subtest: pipe-D-eDP-1
[791.916132] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.445s)
[791.918432] Subtest get-idle: SUCCESS (9.116s)
[792.719104] [122/133] (230s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[792.831090] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[793.499467] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.670s)
[793.688249] [123/133] (229s left) fbdev (nullptr)
[793.733983] Starting subtest: nullptr
[793.736111] Subtest nullptr: SUCCESS (0.000s)
[793.790989] [124/133] (229s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[793.891817] Starting subtest: y-tiled-64bpp-rotate-0
[793.896325] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[794.010065] [125/133] (229s left) kms_plane (plane-position-covered)
[794.108458] Starting subtest: plane-position-covered
[794.627272] Starting dynamic subtest: pipe-A-plane-1
[795.925400] Dynamic subtest pipe-A-plane-1: SUCCESS (1.297s)
[795.938277] Starting dynamic subtest: pipe-A-plane-2
[797.265329] Dynamic subtest pipe-A-plane-2: SUCCESS (1.339s)
[797.276944] Starting dynamic subtest: pipe-A-plane-3
[798.581963] Dynamic subtest pipe-A-plane-3: SUCCESS (1.317s)
[798.593943] Starting dynamic subtest: pipe-A-plane-4
[799.878537] Dynamic subtest pipe-A-plane-4: SUCCESS (1.296s)
[799.889955] Starting dynamic subtest: pipe-A-plane-5
[799.907024] Dynamic subtest pipe-A-plane-5: SUCCESS (0.026s)
[801.034486] Starting dynamic subtest: pipe-B-plane-1
[802.287085] Dynamic subtest pipe-B-plane-1: SUCCESS (1.260s)
[802.297450] Starting dynamic subtest: pipe-B-plane-2
[803.600486] Dynamic subtest pipe-B-plane-2: SUCCESS (1.312s)
[803.612945] Starting dynamic subtest: pipe-B-plane-3
[804.876356] Dynamic subtest pipe-B-plane-3: SUCCESS (1.276s)
[804.886331] Starting dynamic subtest: pipe-B-plane-4
[806.169085] Dynamic subtest pipe-B-plane-4: SUCCESS (1.293s)
[806.181332] Starting dynamic subtest: pipe-B-plane-5
[806.198770] Dynamic subtest pipe-B-plane-5: SUCCESS (0.027s)
[806.201164] Subtest plane-position-covered: SUCCESS (12.090s)
[807.047634] [126/133] (216s left) perf (low-oa-exponent-permissions)
[807.148204] Starting subtest: low-oa-exponent-permissions
[807.173146] Subtest low-oa-exponent-permissions: SUCCESS (0.027s)
[807.213442] [127/133] (216s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[807.274657] Starting subtest: x-tiled-to-vebox-yf-tiled
[807.278784] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[807.457722] [128/133] (216s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[807.519680] Starting subtest: yf-tiled-to-vebox-x-tiled
[807.524418] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[807.724200] [129/133] (215s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[807.813900] Starting subtest: psr-2p-primscrn-spr-indfb-move
[807.817843] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[807.914128] [130/133] (215s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[807.996458] Starting subtest: basic-max-pipe-crc-check
[808.000318] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[808.043357] [131/133] (215s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[808.092126] Starting subtest: multi-wait-all-for-submit-submitted
[808.197331] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.105s)
[808.278081] [132/133] (215s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[808.383564] Starting subtest: psr-indfb-scaledprimary
[814.127149] Subtest psr-indfb-scaledprimary: SUCCESS (5.743s)
[814.235237] [133/133] (209s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[814.339066] Starting subtest: yf-tiled-64bpp-rotate-270
[814.343344] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[814.452786] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: gem_softpin
results: parsing output: 4/ for test: kms_cursor_legacy
results: parsing output: 5/ for test: kms_setmode
results: parsing output: 6/ for test: gem_fenced_exec_thrash
results: parsing output: 7/ for test: kms_plane_scaling
results: parsing output: 8/ for test: i915_suspend
results: parsing output: 9/ for test: kms_psr2_sf
results: parsing output: 10/ for test: gem_exec_params
results: parsing output: 11/ for test: gem_mmap_offset
results: parsing output: 12/ for test: kms_content_protection
results: parsing output: 13/ for test: gem_exec_balancer
results: parsing output: 14/ for test: gem_reg_read
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: gem_exec_reloc
results: parsing output: 18/ for test: syncobj_wait
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: kms_vblank
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_dp_aux_dev
results: parsing output: 23/ for test: gem_mmap_wc
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: gem_ctx_persistence
results: parsing output: 27/ for test: prime_mmap
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: syncobj_eventfd
results: parsing output: 30/ for test: gem_exec_schedule
results: parsing output: 31/ for test: kms_atomic_interruptible
results: parsing output: 32/ for test: sw_sync
results: parsing output: 33/ for test: gem_exec_fence
results: parsing output: 34/ for test: kms_cursor_legacy
results: parsing output: 35/ for test: syncobj_wait
results: parsing output: 36/ for test: i915_hangman
results: parsing output: 37/ for test: kms_prop_blob
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: device_reset
results: parsing output: 40/ for test: gem_flink_basic
results: parsing output: 41/ for test: kms_addfb_basic
results: parsing output: 42/ for test: gem_ppgtt
results: parsing output: 43/ for test: gem_exec_whisper
results: parsing output: 44/ for test: kms_flip
results: parsing output: 45/ for test: perf_pmu
results: parsing output: 46/ for test: perf
results: parsing output: 47/ for test: sysfs_preempt_timeout
results: parsing output: 48/ for test: perf_pmu
results: parsing output: 49/ for test: gen9_exec_parse
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: gem_spin_batch
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_busy
results: parsing output: 55/ for test: kms_atomic
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: gem_exec_create
results: parsing output: 58/ for test: kms_plane
results: parsing output: 59/ for test: gem_lmem_swapping
results: parsing output: 60/ for test: kms_flip
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: gem_mmap_gtt
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: prime_mmap_coherency
results: parsing output: 65/ for test: gem_ctx_freq
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_cursor_legacy
results: parsing output: 68/ for test: kms_cursor_legacy
results: parsing output: 69/ for test: kms_pm_rpm
results: parsing output: 70/ for test: gem_exec_schedule
results: parsing output: 71/ for test: api_intel_bb
results: parsing output: 72/ for test: perf_pmu
results: parsing output: 73/ for test: gem_ctx_exec
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_flip
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: api_intel_bb
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_softpin
results: parsing output: 80/ for test: kms_chamelium_frames
results: parsing output: 81/ for test: kms_color
results: parsing output: 82/ for test: kms_cursor_crc
results: parsing output: 83/ for test: sw_sync
results: parsing output: 84/ for test: kms_pipe_b_c_ivb
results: parsing output: 85/ for test: kms_pm_dc
results: parsing output: 86/ for test: i915_pm_rpm
results: parsing output: 87/ for test: kms_lease
results: parsing output: 88/ for test: gem_wait
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_render_copy_redux
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: kms_addfb_basic
results: parsing output: 94/ for test: i915_drm_fdinfo
results: parsing output: 95/ for test: gem_eio
results: parsing output: 96/ for test: gem_exec_fence
results: parsing output: 97/ for test: kms_flip_scaled_crc
results: parsing output: 98/ for test: gem_fence_thrash
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_plane_multiple
results: parsing output: 102/ for test: kms_feature_discovery
results: parsing output: 103/ for test: kms_psr
results: parsing output: 104/ for test: kms_cursor_legacy
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: kms_addfb_basic
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: gem_mmap_gtt
results: parsing output: 110/ for test: kms_cursor_crc
results: parsing output: 111/ for test: kms_psr2_sf
results: parsing output: 112/ for test: kms_chamelium_color
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_chamelium_edid
results: parsing output: 115/ for test: kms_flip_scaled_crc
results: parsing output: 116/ for test: gem_exec_schedule
results: parsing output: 117/ for test: kms_getfb
results: parsing output: 118/ for test: kms_joiner
results: parsing output: 119/ for test: kms_addfb_basic
results: parsing output: 120/ for test: kms_sequence
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: fbdev
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: kms_plane
results: parsing output: 125/ for test: perf
results: parsing output: 126/ for test: gem_render_copy
results: parsing output: 127/ for test: gem_render_copy
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_multipipe_modeset
results: parsing output: 130/ for test: syncobj_wait
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_big_fb
Done.