[61.757741] Initializing watchdogs
[61.757843]   /dev/watchdog0
[61.772289] [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]
[61.776640] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.779061] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.782361] [001/132] (960s left) sw_sync (sync_multi_consumer)
[61.839702] Starting subtest: sync_multi_consumer
[62.271713] Subtest sync_multi_consumer: SUCCESS (0.429s)
[62.348213] [002/132] (959s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[62.737903] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[63.581933] [003/132] (958s left) gem_softpin (evict-active-interruptible)
[63.642984] Starting subtest: evict-active-interruptible
[63.648796] Subtest evict-active-interruptible: SUCCESS (0.006s)
[63.765069] [004/132] (958s left) gem_ctx_sseu (invalid-args)
[63.831028] Subtest invalid-args: SKIP (0.000s)
[63.883323] [005/132] (958s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[63.990728] Starting subtest: fbc-psr2-cursor-plane-update-sf
[63.993051] Starting dynamic subtest: pipe-A-eDP-1
[64.070190] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[64.077133] Starting dynamic subtest: pipe-B-eDP-1
[65.196065] Dynamic subtest pipe-B-eDP-1: SKIP (1.120s)
[65.200962] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.201s)
[66.385971] [006/132] (956s left) gem_create (create-ext-set-pat)
[66.546063] Starting subtest: create-ext-set-pat
[66.548686] Subtest create-ext-set-pat: SUCCESS (0.001s)
[66.638142] [007/132] (955s left) perf_pmu (all-busy-check-all)
[66.684852] Starting subtest: all-busy-check-all
[67.925682] Subtest all-busy-check-all: SUCCESS (1.237s)
[68.123839] [008/132] (954s left) perf_pmu (busy-accuracy-50)
[68.168862] Starting subtest: busy-accuracy-50
[68.171464] Starting dynamic subtest: rcs0
[69.711182] Dynamic subtest rcs0: SUCCESS (1.537s)
[69.723073] Starting dynamic subtest: bcs0
[71.262616] Dynamic subtest bcs0: SUCCESS (1.549s)
[71.270798] Starting dynamic subtest: vcs0
[72.804086] Dynamic subtest vcs0: SUCCESS (1.539s)
[72.814070] Starting dynamic subtest: vcs1
[74.349887] Dynamic subtest vcs1: SUCCESS (1.544s)
[74.357706] Starting dynamic subtest: vecs0
[75.888926] Dynamic subtest vecs0: SUCCESS (1.537s)
[75.896456] Starting dynamic subtest: ccs0
[77.436109] Dynamic subtest ccs0: SUCCESS (1.545s)
[77.438561] Subtest busy-accuracy-50: SUCCESS (9.258s)
[77.546751] [009/132] (945s left) prime_mmap_coherency (ioctl-errors)
[77.607353] Starting subtest: ioctl-errors
[91.925077] Subtest ioctl-errors: SUCCESS (14.313s)
[92.083091] [010/132] (930s left) kms_psr (psr-primary-mmap-cpu)
[92.211416] Starting subtest: psr-primary-mmap-cpu
[92.213474] Starting dynamic subtest: eDP-1
[93.919885] Dynamic subtest eDP-1: SUCCESS (1.708s)
[93.922296] Subtest psr-primary-mmap-cpu: SUCCESS (1.709s)
[94.797723] [011/132] (927s left) gem_softpin (allocator-fork)
[94.860704] Starting subtest: allocator-fork
[97.069087] Subtest allocator-fork: SUCCESS (2.206s)
[97.204433] [012/132] (925s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[97.303613] Starting subtest: stress-xrgb8888-xtiled
[103.278865] Subtest stress-xrgb8888-xtiled: SUCCESS (5.977s)
[103.321769] [013/132] (919s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[103.422178] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[103.425548] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[103.514679] [014/132] (919s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[103.614899] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[103.618249] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[103.723930] [015/132] (919s left) kms_getfb (getfb2-handle-not-fb)
[103.814048] Starting subtest: getfb2-handle-not-fb
[103.815839] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[103.909911] [016/132] (918s left) gem_exec_reloc (basic-cpu-gtt-active)
[103.976031] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[104.049707] [017/132] (918s left) gem_ringfill (engines-basic)
[109.913064] Starting subtest: engines-basic
[109.915618] Starting dynamic subtest: rcs0
[109.965592] Dynamic subtest rcs0: SUCCESS (0.053s)
[109.975854] Starting dynamic subtest: bcs0
[110.010826] Dynamic subtest bcs0: SUCCESS (0.044s)
[110.020778] Starting dynamic subtest: vcs0
[110.055196] Dynamic subtest vcs0: SUCCESS (0.043s)
[110.065529] Starting dynamic subtest: vcs1
[110.100094] Dynamic subtest vcs1: SUCCESS (0.043s)
[110.109799] Starting dynamic subtest: vecs0
[110.142985] Dynamic subtest vecs0: SUCCESS (0.041s)
[110.153739] Starting dynamic subtest: ccs0
[110.188893] Dynamic subtest ccs0: SUCCESS (0.044s)
[110.191182] Subtest engines-basic: SUCCESS (0.278s)
[110.262677] [FACT gem_ringfill (engines-basic)] new: kernel.kmod_is_loaded.vgem: true
[110.266036] [018/132] (912s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[110.365165] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[110.376284] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.010s)
[110.447551] [019/132] (912s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[110.513574] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[110.568507] [020/132] (912s left) gem_userptr_blits (sd-probe)
[110.632512] Starting subtest: sd-probe
[110.634834] Subtest sd-probe: SUCCESS (0.000s)
[110.757880] [021/132] (912s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[110.845090] Starting subtest: async-flip-with-page-flip-events-tiled
[111.219600] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[113.967765] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.747s)
[113.978535] Starting dynamic subtest: pipe-A-eDP-1-4
[116.142145] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s)
[116.150391] Starting dynamic subtest: pipe-A-eDP-1-4
[118.152782] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[118.163665] Starting dynamic subtest: pipe-A-eDP-1-x
[120.342684] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[120.711929] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[123.494270] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.788s)
[123.502707] Starting dynamic subtest: pipe-B-eDP-1-4
[125.669277] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.174s)
[125.680762] Starting dynamic subtest: pipe-B-eDP-1-4
[127.679240] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[127.689522] Starting dynamic subtest: pipe-B-eDP-1-x
[129.858426] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.179s)
[130.231316] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[133.012092] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.786s)
[133.023934] Starting dynamic subtest: pipe-C-eDP-1-4
[135.175022] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.163s)
[135.183947] Starting dynamic subtest: pipe-C-eDP-1-4
[137.186548] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s)
[137.196736] Starting dynamic subtest: pipe-C-eDP-1-x
[139.365080] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[139.728094] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[142.539915] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.818s)
[142.551974] Starting dynamic subtest: pipe-D-eDP-1-4
[144.714675] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[144.723583] Starting dynamic subtest: pipe-D-eDP-1-4
[146.725066] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s)
[146.734090] Starting dynamic subtest: pipe-D-eDP-1-x
[148.903227] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[148.905455] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.055s)
[150.122413] [022/132] (872s left) gem_mmap (bad-offset)
[150.180470] Subtest bad-offset: SKIP (0.000s)
[150.237625] [023/132] (872s left) gem_mmap_offset (open-flood)
[150.291824] Starting subtest: open-flood
[171.778530] Subtest open-flood: SUCCESS (21.488s)
[171.876499] [024/132] (851s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[171.925689] Starting subtest: mixed-tiled-to-y-tiled-ccs
[171.929576] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[172.128355] [025/132] (851s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[172.221918] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[172.224731] Starting dynamic subtest: pipe-A-eDP-1
[172.234241] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[172.246937] Starting dynamic subtest: pipe-B-eDP-1
[172.256056] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[172.264038] Starting dynamic subtest: pipe-C-eDP-1
[172.272574] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[172.280793] Starting dynamic subtest: pipe-D-eDP-1
[172.289222] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[172.293311] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[174.481678] [026/132] (848s left) kms_prop_blob (blob-prop-lifetime)
[174.529743] Starting subtest: blob-prop-lifetime
[174.532053] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[174.623937] [027/132] (848s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[174.717182] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[175.308384] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.593s)
[175.469506] [028/132] (847s left) kms_flip (flip-vs-expired-vblank)
[175.554239] Starting subtest: flip-vs-expired-vblank
[175.556523] Starting dynamic subtest: A-eDP1
[184.192357] Dynamic subtest A-eDP1: SUCCESS (8.640s)
[184.200877] Starting dynamic subtest: B-eDP1
[192.833384] Dynamic subtest B-eDP1: SUCCESS (8.638s)
[192.841560] Starting dynamic subtest: C-eDP1
[201.459602] Dynamic subtest C-eDP1: SUCCESS (8.624s)
[201.467854] Starting dynamic subtest: D-eDP1
[210.093942] Dynamic subtest D-eDP1: SUCCESS (8.632s)
[210.099459] Subtest flip-vs-expired-vblank: SUCCESS (34.547s)
[211.262946] [029/132] (812s left) gem_exec_whisper (basic-contexts-all)
[211.330303] Starting subtest: basic-contexts-all
[222.210859] Subtest basic-contexts-all: SUCCESS (10.879s)
[222.394208] [030/132] (800s left) gem_eio (in-flight-internal-1us)
[222.639532] Starting subtest: in-flight-internal-1us
[223.992345] Subtest in-flight-internal-1us: SUCCESS (1.353s)
[224.114972] [031/132] (799s left) gem_ctx_persistence (process)
[224.177651] Starting subtest: process
[224.343535] Subtest process: SUCCESS (0.166s)
[224.433289] [032/132] (799s left) gem_exec_schedule (noreorder-priority)
[224.612965] Starting subtest: noreorder-priority
[224.615566] Starting dynamic subtest: rcs0
[225.757373] Dynamic subtest rcs0: SUCCESS (1.144s)
[225.770745] Starting dynamic subtest: vcs0
[226.898359] Dynamic subtest vcs0: SUCCESS (1.139s)
[226.909889] Starting dynamic subtest: vcs1
[228.874319] Dynamic subtest vcs1: SUCCESS (1.973s)
[228.886316] Starting dynamic subtest: vecs0
[230.928097] Dynamic subtest vecs0: SUCCESS (2.050s)
[230.939254] Starting dynamic subtest: ccs0
[232.063087] Dynamic subtest ccs0: SUCCESS (1.136s)
[232.065595] Subtest noreorder-priority: SUCCESS (7.451s)
[232.246027] [033/132] (791s left) syncobj_wait (reset-during-wait-for-submit)
[232.311034] Starting subtest: reset-during-wait-for-submit
[232.413537] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[232.490573] [034/132] (791s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[232.584906] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[232.587225] Starting dynamic subtest: pipe-A-eDP-1
[232.607883] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[232.620584] Starting dynamic subtest: pipe-B-eDP-1
[232.640299] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[232.648951] Starting dynamic subtest: pipe-C-eDP-1
[232.668159] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[232.679753] Starting dynamic subtest: pipe-D-eDP-1
[232.700023] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[232.702279] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.007s)
[234.769204] [035/132] (788s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[234.874822] Starting subtest: yf-tiled-16bpp-rotate-180
[234.879088] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[234.979460] [036/132] (788s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[235.072788] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[235.075135] Starting dynamic subtest: pipe-A-eDP-1
[235.892138] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.814s)
[235.901024] Starting dynamic subtest: pipe-B-eDP-1
[237.504181] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.608s)
[237.513546] Starting dynamic subtest: pipe-C-eDP-1
[238.959745] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.453s)
[238.969299] Starting dynamic subtest: pipe-D-eDP-1
[240.574062] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.615s)
[240.576371] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.495s)
[241.772377] [037/132] (781s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[241.864319] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[241.868662] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[241.958307] [038/132] (781s left) kms_cursor_crc (cursor-sliding-512x512)
[242.246673] Starting subtest: cursor-sliding-512x512
[242.251022] Subtest cursor-sliding-512x512: SKIP (0.001s)
[242.396095] [039/132] (781s left) kms_big_fb (linear-addfb)
[242.488921] Starting subtest: linear-addfb
[242.491196] Subtest linear-addfb: SUCCESS (0.000s)
[242.586860] [040/132] (781s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[242.639874] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[242.642078] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.001s)
[242.742187] [041/132] (781s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[242.836473] Starting subtest: psr2-overlay-plane-move-continuous-sf
[242.838438] Starting dynamic subtest: pipe-A-eDP-1
[248.808059] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.974s)
[248.817231] Starting dynamic subtest: pipe-B-eDP-1
[255.457839] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.646s)
[255.460096] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (12.623s)
[256.342723] [042/132] (767s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[256.406601] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[256.409086] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[256.543393] [043/132] (767s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[256.660406] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[256.664758] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[256.749900] [044/132] (767s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[256.867831] Starting subtest: short-flip-before-cursor-atomic-transitions
[257.804673] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.937s)
[258.653689] [045/132] (765s left) kms_vrr (flip-basic-fastset)
[258.739356] Starting subtest: flip-basic-fastset
[258.745816] Subtest flip-basic-fastset: SKIP (0.000s)
[258.811788] [046/132] (765s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[258.908738] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[258.913194] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[259.006614] [047/132] (765s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[259.108054] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[259.112547] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[259.207137] [048/132] (764s left) gem_exec_fence (basic-wait)
[259.389939] Starting subtest: basic-wait
[259.392660] Starting dynamic subtest: rcs0
[259.469474] Dynamic subtest rcs0: SUCCESS (0.081s)
[259.480936] Starting dynamic subtest: bcs0
[259.535337] Dynamic subtest bcs0: SUCCESS (0.064s)
[259.547017] Starting dynamic subtest: vcs0
[259.588108] Dynamic subtest vcs0: SUCCESS (0.051s)
[259.599068] Starting dynamic subtest: vcs1
[259.642892] Dynamic subtest vcs1: SUCCESS (0.053s)
[259.653864] Starting dynamic subtest: vecs0
[259.696064] Dynamic subtest vecs0: SUCCESS (0.051s)
[259.706775] Starting dynamic subtest: ccs0
[259.754959] Dynamic subtest ccs0: SUCCESS (0.056s)
[259.757757] Subtest basic-wait: SUCCESS (0.367s)
[262.001978] [049/132] (762s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[262.061256] Starting subtest: multi-wait-all-for-submit-available-signaled
[262.063548] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[262.161389] [050/132] (762s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[262.206234] Starting subtest: single-wait-all-for-submit-available-signaled
[262.208550] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[262.308627] [051/132] (762s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[262.414582] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[262.418962] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[262.507766] [052/132] (761s left) api_intel_bb (object-noreloc-purge-cache-simple)
[262.558135] Starting subtest: object-noreloc-purge-cache-simple
[262.562198] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.006s)
[262.683905] [053/132] (761s left) syncobj_wait (invalid-signal-bad-pad)
[262.739387] Starting subtest: invalid-signal-bad-pad
[262.741632] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[262.840197] [054/132] (761s left) kms_invalid_mode (zero-clock)
[262.936165] Starting subtest: zero-clock
[262.938445] Starting dynamic subtest: pipe-A-eDP-1
[263.229196] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.293s)
[263.242830] Starting dynamic subtest: pipe-B-eDP-1
[263.245204] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[263.265326] Starting dynamic subtest: pipe-C-eDP-1
[263.267575] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[263.285658] Starting dynamic subtest: pipe-D-eDP-1
[263.288177] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[263.290544] Subtest zero-clock: SUCCESS (0.302s)
[264.075747] [055/132] (760s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[264.128603] Starting subtest: etime-multi-wait-all-available-unsubmitted
[264.232882] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.104s)
[264.309655] [056/132] (760s left) fbdev (info)
[264.349486] Starting subtest: info
[264.351536] Subtest info: SUCCESS (0.000s)
[264.417565] [057/132] (760s left) gem_eio (suspend)
[264.648147] Starting subtest: suspend
[277.773072] Subtest suspend: SUCCESS (13.123s)
[277.898451] [058/132] (746s left) gem_eio (wait-wedge-10ms)
[278.113060] Starting subtest: wait-wedge-10ms
[279.952913] Subtest wait-wedge-10ms: SUCCESS (1.838s)
[280.063567] [059/132] (744s left) perf_pmu (render-node-busy)
[280.126949] Starting subtest: render-node-busy
[280.129707] Starting dynamic subtest: rcs0
[280.712873] Dynamic subtest rcs0: SUCCESS (0.585s)
[280.724222] Starting dynamic subtest: bcs0
[281.270074] Dynamic subtest bcs0: SUCCESS (0.555s)
[281.281977] Starting dynamic subtest: vcs0
[282.901869] Dynamic subtest vcs0: SUCCESS (1.627s)
[282.916421] Starting dynamic subtest: vcs1
[284.885702] Dynamic subtest vcs1: SUCCESS (1.980s)
[284.898462] Starting dynamic subtest: vecs0
[286.933699] Dynamic subtest vecs0: SUCCESS (2.045s)
[286.946305] Starting dynamic subtest: ccs0
[287.495487] Dynamic subtest ccs0: SUCCESS (0.561s)
[287.497957] Subtest render-node-busy: SUCCESS (7.369s)
[287.584011] [060/132] (737s left) perf (invalid-remove-userspace-config)
[287.722391] Starting subtest: invalid-remove-userspace-config
[287.731732] Subtest invalid-remove-userspace-config: SUCCESS (0.011s)
[287.773766] [061/132] (736s left) gem_mmap_gtt (basic-write-read)
[287.829660] Subtest basic-write-read: SKIP (0.000s)
[287.885644] [062/132] (736s left) kms_fbcon_fbt (psr-suspend)
[287.934199] Starting subtest: psr-suspend
[336.925492] Subtest psr-suspend: SUCCESS (19.587s)
[337.008833] [063/132] (687s left) kms_lease (atomic-implicit-crtc)
[337.111227] Starting subtest: atomic-implicit-crtc
[337.113807] Starting dynamic subtest: pipe-A-eDP-1
[337.126851] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[337.138074] Starting dynamic subtest: pipe-B-eDP-1
[337.151486] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.018s)
[337.160905] Starting dynamic subtest: pipe-C-eDP-1
[337.174344] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.014s)
[337.183888] Starting dynamic subtest: pipe-D-eDP-1
[337.197065] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[337.199834] Subtest atomic-implicit-crtc: SUCCESS (0.052s)
[337.259603] [064/132] (687s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[337.354376] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[337.359231] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[337.428723] [065/132] (687s left) kms_content_protection (dp-mst-lic-type-0)
[337.585402] Starting subtest: dp-mst-lic-type-0
[337.590743] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[337.703935] [066/132] (687s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[337.810869] Starting subtest: 2x-long-cursor-vs-flip-atomic
[337.815577] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[337.954850] [067/132] (687s left) kms_atomic (plane-invalid-params)
[338.043664] Starting subtest: plane-invalid-params
[338.045823] Starting dynamic subtest: pipe-A-eDP-1
[338.452676] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.401s)
[338.454952] Subtest plane-invalid-params: SUCCESS (0.403s)
[339.343472] [068/132] (685s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[339.426673] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[339.429079] Starting dynamic subtest: pipe-A-eDP-1
[339.495351] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[339.505081] Starting dynamic subtest: pipe-B-eDP-1
[339.572865] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[339.584101] Starting dynamic subtest: pipe-C-eDP-1
[339.652771] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[339.663685] Starting dynamic subtest: pipe-D-eDP-1
[339.730760] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[339.735963] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.008s)
[341.667972] [069/132] (683s left) kms_dsc (dsc-with-output-formats)
[341.762536] Starting subtest: dsc-with-output-formats
[341.786943] Subtest dsc-with-output-formats: SKIP (0.000s)
[341.833859] [070/132] (683s left) kms_color_pipeline (plane-lut1d-lut1d)
[341.935917] Starting subtest: plane-lut1d-lut1d
[342.082821] Starting dynamic subtest: pipe-A-plane-0
[342.250656] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[342.261077] Starting dynamic subtest: pipe-A-plane-1
[342.429801] Dynamic subtest pipe-A-plane-1: SUCCESS (0.177s)
[342.440344] Starting dynamic subtest: pipe-A-plane-2
[342.586351] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s)
[343.783276] Starting dynamic subtest: pipe-B-plane-0
[343.956029] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s)
[343.966106] Starting dynamic subtest: pipe-B-plane-1
[344.157877] Dynamic subtest pipe-B-plane-1: SUCCESS (0.197s)
[344.168635] Starting dynamic subtest: pipe-B-plane-2
[344.302134] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s)
[345.501891] Starting dynamic subtest: pipe-C-plane-0
[345.638473] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[345.649400] Starting dynamic subtest: pipe-C-plane-1
[345.783746] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[345.793927] Starting dynamic subtest: pipe-C-plane-2
[345.928618] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[347.152607] Starting dynamic subtest: pipe-D-plane-0
[347.292309] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[347.301763] Starting dynamic subtest: pipe-D-plane-1
[347.446012] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[347.455787] Starting dynamic subtest: pipe-D-plane-2
[347.580408] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[347.876899] Subtest plane-lut1d-lut1d: SUCCESS (5.905s)
[348.718357] [071/132] (676s left) kms_psr (psr-cursor-mmap-cpu)
[348.806773] Starting subtest: psr-cursor-mmap-cpu
[348.809281] Starting dynamic subtest: eDP-1
[350.523969] Dynamic subtest eDP-1: SUCCESS (1.711s)
[350.526929] Subtest psr-cursor-mmap-cpu: SUCCESS (1.713s)
[351.394280] [072/132] (673s left) kms_chamelium_color (ctm-negative)
[351.483568] Subtest ctm-negative: SKIP (0.000s)
[351.530931] [073/132] (673s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[351.589679] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[351.654828] [074/132] (673s left) kms_psr (fbc-psr-no-drrs)
[351.744361] Starting subtest: fbc-psr-no-drrs
[351.746904] Starting dynamic subtest: eDP-1
[351.751964] Dynamic subtest eDP-1: SKIP (0.000s)
[351.756955] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[351.815967] [075/132] (673s left) gem_reg_read (timestamp-monotonic)
[351.878774] Starting subtest: timestamp-monotonic
[356.355056] Subtest timestamp-monotonic: SUCCESS (4.467s)
[356.432478] [076/132] (668s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[356.544845] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[363.357071] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.807s)
[363.458207] [077/132] (661s left) gem_exec_fence (syncobj-signal)
[363.887287] Starting subtest: syncobj-signal
[363.893960] Subtest syncobj-signal: SUCCESS (0.006s)
[365.267837] [078/132] (660s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[365.584887] Starting subtest: cursor-rapid-movement-max-size
[365.592887] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[365.713687] [079/132] (659s left) sw_sync (sync_random_merge)
[365.760793] Starting subtest: sync_random_merge
[365.799589] Subtest sync_random_merge: SUCCESS (0.041s)
[365.861734] [080/132] (659s left) gen3_render_tiledx_blits
[365.988917] [081/132] (659s left) kms_fence_pin_leak
[366.162462] [082/132] (659s left) kms_selftest (drm_dp_mst_helper)
[366.203386] Starting subtest: drm_dp_mst_helper
[366.212716] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[366.308548] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.094s)
[366.319570] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[366.401375] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.092s)
[366.411816] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[366.509879] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.108s)
[366.511914] Subtest drm_dp_mst_helper: SUCCESS (0.307s)
[366.673191] [083/132] (658s left) i915_selftest (mock)
[368.359577] Starting subtest: mock
[368.364413] Starting dynamic subtest: sanitycheck
[369.963515] Dynamic subtest sanitycheck: SUCCESS (1.604s)
[369.974628] Starting dynamic subtest: shmem
[371.557456] Dynamic subtest shmem: SUCCESS (1.592s)
[371.568470] Starting dynamic subtest: fence
[380.373775] Dynamic subtest fence: SUCCESS (8.814s)
[380.389007] Starting dynamic subtest: scatterlist
[382.926091] Dynamic subtest scatterlist: SUCCESS (2.550s)
[382.936130] Starting dynamic subtest: syncmap
[387.363527] Dynamic subtest syncmap: SUCCESS (4.434s)
[387.374065] Starting dynamic subtest: uncore
[388.881447] Dynamic subtest uncore: SUCCESS (1.516s)
[388.891546] Starting dynamic subtest: ring
[390.423550] Dynamic subtest ring: SUCCESS (1.540s)
[390.433706] Starting dynamic subtest: engine
[391.947474] Dynamic subtest engine: SUCCESS (1.521s)
[391.957993] Starting dynamic subtest: timelines
[396.491402] Dynamic subtest timelines: SUCCESS (4.540s)
[396.501887] Starting dynamic subtest: requests
[400.989240] Dynamic subtest requests: SUCCESS (4.495s)
[400.997895] Starting dynamic subtest: objects
[402.580672] Dynamic subtest objects: SUCCESS (1.590s)
[402.590886] Starting dynamic subtest: phys
[404.226096] Dynamic subtest phys: SUCCESS (1.643s)
[404.235879] Starting dynamic subtest: dmabuf
[405.866769] Dynamic subtest dmabuf: SUCCESS (1.639s)
[405.875092] Starting dynamic subtest: vma
[412.346464] Dynamic subtest vma: SUCCESS (6.475s)
[412.356504] Starting dynamic subtest: evict
[414.537804] Dynamic subtest evict: SUCCESS (2.189s)
[414.548583] Starting dynamic subtest: gtt
[418.669807] Dynamic subtest gtt: SUCCESS (4.129s)
[418.679967] Starting dynamic subtest: hugepages
[420.469822] Dynamic subtest hugepages: SUCCESS (1.798s)
[420.480309] Starting dynamic subtest: memory_region
[423.694805] Dynamic subtest memory_region: SUCCESS (3.223s)
[423.697893] Subtest mock: SUCCESS (55.320s)
[423.728180] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[423.728862] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[423.732440] [084/132] (601s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[426.159092] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[433.094583] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.937s)
[433.237409] [FACT kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[433.238597] [FACT kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)] new: kernel.kmod_is_loaded.i915: true
[433.243893] [085/132] (592s left) gem_exec_reloc (basic-write-gtt)
[433.305934] Subtest basic-write-gtt: SKIP (0.000s)
[433.372212] [086/132] (592s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping)
[433.467916] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping
[433.472635] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s)
[433.555136] [087/132] (592s left) kms_atomic_interruptible (legacy-cursor)
[433.642774] Starting subtest: legacy-cursor
[433.645211] Starting dynamic subtest: pipe-A-eDP-1
[441.025336] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.383s)
[441.027689] Subtest legacy-cursor: SUCCESS (7.384s)
[441.867442] [088/132] (583s left) gem_ctx_param (invalid-set-ringsize)
[441.936409] Starting subtest: invalid-set-ringsize
[441.939062] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[442.008088] [089/132] (583s left) prime_vgem (shrink)
[442.082473] Starting subtest: shrink
[442.104974] Subtest shrink: SUCCESS (0.020s)
[442.212085] [090/132] (583s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[442.310933] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[442.315590] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[442.402529] [091/132] (583s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[442.506910] Starting subtest: fbc-rgb101010-draw-mmap-wc
[447.045748] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.544s)
[448.180378] [092/132] (577s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[448.266157] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[448.269194] Starting dynamic subtest: pipe-A
[448.328548] Dynamic subtest pipe-A: SUCCESS (0.065s)
[448.339207] Starting dynamic subtest: pipe-B
[449.489550] Dynamic subtest pipe-B: SUCCESS (1.160s)
[449.501083] Starting dynamic subtest: pipe-C
[450.600617] Dynamic subtest pipe-C: SUCCESS (1.110s)
[450.613420] Starting dynamic subtest: pipe-D
[451.730831] Dynamic subtest pipe-D: SUCCESS (1.130s)
[451.733812] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.468s)
[452.890441] [093/132] (573s left) kms_pm_dc (dc5-retention-flops)
[453.997063] Starting subtest: dc5-retention-flops
[454.002885] Subtest dc5-retention-flops: SKIP (0.000s)
[454.073500] [094/132] (572s left) sysfs_preempt_timeout (idempotent)
[454.128115] Starting subtest: idempotent
[454.130775] Starting dynamic subtest: vecs0
[454.133262] Dynamic subtest vecs0: SUCCESS (0.000s)
[454.142980] Starting dynamic subtest: ccs0
[454.145709] Dynamic subtest ccs0: SUCCESS (0.000s)
[454.154287] Starting dynamic subtest: vcs0
[454.156377] Dynamic subtest vcs0: SUCCESS (0.000s)
[454.165131] Starting dynamic subtest: bcs0
[454.167759] Dynamic subtest bcs0: SUCCESS (0.000s)
[454.176573] Starting dynamic subtest: rcs0
[454.178960] Dynamic subtest rcs0: SUCCESS (0.000s)
[454.188066] Starting dynamic subtest: vcs1
[454.190805] Dynamic subtest vcs1: SUCCESS (0.000s)
[454.193546] Subtest idempotent: SUCCESS (0.006s)
[454.232598] [095/132] (571s left) gem_exec_schedule (semaphore-power)
[454.408826] Subtest semaphore-power: SKIP (0.000s)
[454.609161] [096/132] (571s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[454.700777] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[454.705696] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[454.770173] [097/132] (571s left) gem_exec_fence (syncobj-timeline-wait)
[455.297739] Starting subtest: syncobj-timeline-wait
[456.233261] Subtest syncobj-timeline-wait: SUCCESS (0.935s)
[458.244568] [098/132] (568s left) gen9_exec_parse (bb-secure)
[458.305823] Subtest bb-secure: SKIP (0.000s)
[458.384577] [099/132] (567s left) gem_mmap_gtt (big-copy-odd)
[458.437663] Subtest big-copy-odd: SKIP (0.000s)
[458.500917] [100/132] (567s left) api_intel_allocator (alloc-simple)
[458.550119] Starting subtest: alloc-simple
[458.552775] Subtest alloc-simple: SUCCESS (0.004s)
[458.684563] [101/132] (567s left) gem_pwrite (basic-exhaustion)
[458.744899] Subtest basic-exhaustion: SKIP (0.000s)
[458.817308] [102/132] (567s left) sw_sync (sync_merge_same)
[458.860684] Starting subtest: sync_merge_same
[458.863381] Subtest sync_merge_same: SUCCESS (0.000s)
[458.928124] [103/132] (567s left) gem_exec_reloc (basic-gtt-read-noreloc)
[458.989928] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[459.061131] [104/132] (567s left) syncobj_wait (wait-any-interrupted)
[459.116897] Starting subtest: wait-any-interrupted
[459.217487] Subtest wait-any-interrupted: SUCCESS (0.102s)
[459.295183] [105/132] (567s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[459.399907] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[459.404880] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[459.492748] [106/132] (567s left) gem_exec_gttfill (basic)
[459.557664] Starting subtest: basic
[462.042024] Subtest basic: SUCCESS (2.484s)
[462.236420] [107/132] (564s left) kms_cursor_crc (cursor-offscreen-512x170)
[462.599473] Starting subtest: cursor-offscreen-512x170
[462.604732] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[462.746089] [108/132] (563s left) gem_exec_balancer (bonded-true-hang)
[463.009097] Starting subtest: bonded-true-hang
[463.014461] Subtest bonded-true-hang: SKIP (0.000s)
[463.119475] [109/132] (563s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[463.212023] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[463.217722] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[463.311665] [110/132] (563s left) gem_exec_reloc (basic-cpu-wc-active)
[463.370940] Subtest basic-cpu-wc-active: SKIP (0.000s)
[463.436414] [111/132] (563s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[463.543501] Starting subtest: fbcpsr-rgb101010-draw-render
[470.245075] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.706s)
[470.348263] [112/132] (556s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[470.739607] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[471.519577] [113/132] (555s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[471.623149] Starting subtest: y-tiled-8bpp-rotate-180
[471.628094] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[471.724245] [114/132] (555s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[471.820450] Starting subtest: bad-rotation-90-yf-tiled-ccs
[471.822711] Starting dynamic subtest: pipe-A-eDP-1
[471.846807] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[471.856255] Starting dynamic subtest: pipe-B-eDP-1
[471.881026] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[471.890727] Starting dynamic subtest: pipe-C-eDP-1
[471.916013] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[471.925001] Starting dynamic subtest: pipe-D-eDP-1
[471.950982] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[471.955823] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.004s)
[474.089906] [115/132] (552s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[474.194514] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[474.199909] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[474.280169] [116/132] (552s left) gem_lmem_swapping (parallel-multi)
[474.332478] Subtest parallel-multi: SKIP (0.000s)
[474.382842] [117/132] (552s left) kms_plane (plane-position-covered)
[474.476779] Starting subtest: plane-position-covered
[474.992476] Starting dynamic subtest: pipe-A-plane-1
[476.261627] Dynamic subtest pipe-A-plane-1: SUCCESS (1.270s)
[476.276099] Starting dynamic subtest: pipe-A-plane-2
[477.585985] Dynamic subtest pipe-A-plane-2: SUCCESS (1.321s)
[477.596754] Starting dynamic subtest: pipe-A-plane-3
[478.831794] Dynamic subtest pipe-A-plane-3: SUCCESS (1.248s)
[478.842867] Starting dynamic subtest: pipe-A-plane-4
[480.056524] Dynamic subtest pipe-A-plane-4: SUCCESS (1.223s)
[480.067619] Starting dynamic subtest: pipe-A-plane-5
[480.084490] Dynamic subtest pipe-A-plane-5: SUCCESS (0.026s)
[481.227176] Starting dynamic subtest: pipe-B-plane-1
[482.547851] Dynamic subtest pipe-B-plane-1: SUCCESS (1.328s)
[482.557890] Starting dynamic subtest: pipe-B-plane-2
[483.882621] Dynamic subtest pipe-B-plane-2: SUCCESS (1.333s)
[483.893448] Starting dynamic subtest: pipe-B-plane-3
[485.198608] Dynamic subtest pipe-B-plane-3: SUCCESS (1.312s)
[485.209114] Starting dynamic subtest: pipe-B-plane-4
[486.524782] Dynamic subtest pipe-B-plane-4: SUCCESS (1.327s)
[486.535591] Starting dynamic subtest: pipe-B-plane-5
[486.550966] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[486.553553] Subtest plane-position-covered: SUCCESS (12.072s)
[487.402441] [118/132] (539s left) i915_drm_fdinfo (busy-idle)
[487.452227] Starting subtest: busy-idle
[487.454954] Starting dynamic subtest: rcs0
[487.465017] Dynamic subtest rcs0: SKIP (0.011s)
[487.475723] Starting dynamic subtest: bcs0
[487.480936] Dynamic subtest bcs0: SKIP (0.015s)
[487.490330] Starting dynamic subtest: vcs0
[487.495230] Dynamic subtest vcs0: SKIP (0.000s)
[487.504792] Starting dynamic subtest: vcs1
[487.509811] Dynamic subtest vcs1: SKIP (0.000s)
[487.519016] Starting dynamic subtest: vecs0
[487.524334] Dynamic subtest vecs0: SKIP (0.000s)
[487.533884] Starting dynamic subtest: ccs0
[487.539026] Dynamic subtest ccs0: SKIP (0.000s)
[487.544351] Subtest busy-idle: SKIP (0.031s)
[487.584490] [119/132] (539s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[487.683777] Starting subtest: fbc-dirtyfb-ioctl
[487.685949] Starting dynamic subtest: A-eDP-1
[490.284874] Dynamic subtest A-eDP-1: SUCCESS (2.600s)
[490.287888] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.601s)
[491.170437] [120/132] (536s left) i915_pm_rpm (system-suspend-execbuf)
[493.347968] Starting subtest: system-suspend-execbuf
[550.891874] Subtest system-suspend-execbuf: SUCCESS (42.840s)
[551.273880] [121/132] (475s left) gem_eio (throttle)
[551.513278] Starting subtest: throttle
[551.835181] Subtest throttle: SUCCESS (0.319s)
[551.960779] [122/132] (475s left) dumb_buffer (map-invalid-size)
[552.013298] Starting subtest: map-invalid-size
[552.015501] Subtest map-invalid-size: SUCCESS (0.000s)
[552.125693] [123/132] (475s left) kms_plane_cursor (overlay)
[552.241142] Starting subtest: overlay
[552.244751] Starting dynamic subtest: pipe-A-eDP-1-size-64
[554.805746] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.560s)
[554.866515] Starting dynamic subtest: pipe-A-eDP-1-size-128
[557.307525] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.449s)
[557.372652] Starting dynamic subtest: pipe-A-eDP-1-size-256
[559.899818] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.540s)
[560.252886] Starting dynamic subtest: pipe-B-eDP-1-size-64
[563.503080] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.258s)
[563.563997] Starting dynamic subtest: pipe-B-eDP-1-size-128
[566.038299] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.483s)
[566.098606] Starting dynamic subtest: pipe-B-eDP-1-size-256
[568.563216] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.472s)
[568.918542] Starting dynamic subtest: pipe-C-eDP-1-size-64
[571.737995] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.830s)
[571.776284] Starting dynamic subtest: pipe-C-eDP-1-size-128
[573.993250] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.225s)
[574.032515] Starting dynamic subtest: pipe-C-eDP-1-size-256
[576.139379] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.114s)
[576.474407] Starting dynamic subtest: pipe-D-eDP-1-size-64
[579.278328] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.818s)
[579.316639] Starting dynamic subtest: pipe-D-eDP-1-size-128
[581.422921] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.114s)
[581.461010] Starting dynamic subtest: pipe-D-eDP-1-size-256
[583.637639] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.181s)
[583.958630] Subtest overlay: SUCCESS (31.703s)
[584.815140] [124/132] (442s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[584.910250] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[584.921459] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[585.007164] [125/132] (442s left) kms_psr (fbc-pr-primary-render)
[585.104892] Starting subtest: fbc-pr-primary-render
[585.109312] Subtest fbc-pr-primary-render: SKIP (0.000s)
[585.193018] [126/132] (442s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[585.313344] Starting subtest: cursorA-vs-flipB-toggle
[585.317964] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[585.473306] [127/132] (442s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[585.586254] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[586.677200] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.090s)
[586.823515] [128/132] (440s left) i915_hangman (gt-engine-hang)
[586.883924] Starting subtest: gt-engine-hang
[586.885774] Starting dynamic subtest: rcs0
[588.666042] Dynamic subtest rcs0: SUCCESS (1.780s)
[588.683926] Starting dynamic subtest: bcs0
[590.649531] Dynamic subtest bcs0: SUCCESS (1.980s)
[590.662872] Starting dynamic subtest: vcs0
[592.634550] Dynamic subtest vcs0: SUCCESS (1.980s)
[592.646880] Starting dynamic subtest: vcs1
[594.681177] Dynamic subtest vcs1: SUCCESS (2.043s)
[594.694787] Starting dynamic subtest: vecs0
[596.665233] Dynamic subtest vecs0: SUCCESS (1.981s)
[596.678931] Starting dynamic subtest: ccs0
[598.584398] Dynamic subtest ccs0: SUCCESS (1.915s)
[598.586886] Subtest gt-engine-hang: SUCCESS (11.696s)
[598.685076] [129/132] (428s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[598.783568] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[598.788013] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[598.890124] [130/132] (428s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[598.985968] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[598.990484] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[599.063280] [131/132] (428s left) kms_pm_rpm (pc8-residency)
[600.786670] Starting subtest: pc8-residency
[600.792281] Subtest pc8-residency: SKIP (0.000s)
[601.377908] [132/132] (426s left) kms_psr (pr-cursor-mmap-cpu)
[601.477565] Starting subtest: pr-cursor-mmap-cpu
[601.481986] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[601.561228] Closing watchdogs
results: parsing output: 0/ for test: sw_sync
results: parsing output: 1/ for test: kms_chamelium_edid
results: parsing output: 2/ for test: gem_softpin
results: parsing output: 3/ for test: gem_ctx_sseu
results: parsing output: 4/ for test: kms_psr2_sf
results: parsing output: 5/ for test: gem_create
results: parsing output: 6/ for test: perf_pmu
results: parsing output: 7/ for test: perf_pmu
results: parsing output: 8/ for test: prime_mmap_coherency
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: gem_softpin
results: parsing output: 11/ for test: kms_pipe_stress
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_getfb
results: parsing output: 15/ for test: gem_exec_reloc
results: parsing output: 16/ for test: gem_ringfill
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: kms_pipe_b_c_ivb
results: parsing output: 19/ for test: gem_userptr_blits
results: parsing output: 20/ for test: kms_async_flips
results: parsing output: 21/ for test: gem_mmap
results: parsing output: 22/ for test: gem_mmap_offset
results: parsing output: 23/ for test: gem_render_copy
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_prop_blob
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: gem_exec_whisper
results: parsing output: 29/ for test: gem_eio
results: parsing output: 30/ for test: gem_ctx_persistence
results: parsing output: 31/ for test: gem_exec_schedule
results: parsing output: 32/ for test: syncobj_wait
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: kms_ccs
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_cursor_crc
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: kms_psr2_sf
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_cursor_legacy
results: parsing output: 44/ for test: kms_vrr
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: gem_exec_fence
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: api_intel_bb
results: parsing output: 52/ for test: syncobj_wait
results: parsing output: 53/ for test: kms_invalid_mode
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: fbdev
results: parsing output: 56/ for test: gem_eio
results: parsing output: 57/ for test: gem_eio
results: parsing output: 58/ for test: perf_pmu
results: parsing output: 59/ for test: perf
results: parsing output: 60/ for test: gem_mmap_gtt
results: parsing output: 61/ for test: kms_fbcon_fbt
results: parsing output: 62/ for test: kms_lease
results: parsing output: 63/ for test: kms_flip_scaled_crc
results: parsing output: 64/ for test: kms_content_protection
results: parsing output: 65/ for test: kms_cursor_legacy
results: parsing output: 66/ for test: kms_atomic
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: kms_dsc
results: parsing output: 69/ for test: kms_color_pipeline
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: kms_chamelium_color
results: parsing output: 72/ for test: gem_fenced_exec_thrash
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: gem_reg_read
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_exec_fence
results: parsing output: 77/ for test: kms_cursor_crc
results: parsing output: 78/ for test: sw_sync
results: parsing output: 79/ for test: gen3_render_tiledx_blits
results: parsing output: 80/ for test: kms_fence_pin_leak
results: parsing output: 81/ for test: kms_selftest
results: parsing output: 82/ for test: i915_selftest
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_exec_reloc
results: parsing output: 85/ for test: kms_plane
results: parsing output: 86/ for test: kms_atomic_interruptible
results: parsing output: 87/ for test: gem_ctx_param
results: parsing output: 88/ for test: prime_vgem
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_plane_scaling
results: parsing output: 92/ for test: kms_pm_dc
results: parsing output: 93/ for test: sysfs_preempt_timeout
results: parsing output: 94/ for test: gem_exec_schedule
results: parsing output: 95/ for test: kms_flip_scaled_crc
results: parsing output: 96/ for test: gem_exec_fence
results: parsing output: 97/ for test: gen9_exec_parse
results: parsing output: 98/ for test: gem_mmap_gtt
results: parsing output: 99/ for test: api_intel_allocator
results: parsing output: 100/ for test: gem_pwrite
results: parsing output: 101/ for test: sw_sync
results: parsing output: 102/ for test: gem_exec_reloc
results: parsing output: 103/ for test: syncobj_wait
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_exec_gttfill
results: parsing output: 106/ for test: kms_cursor_crc
results: parsing output: 107/ for test: gem_exec_balancer
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_exec_reloc
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_chamelium_hpd
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: kms_ccs
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: gem_lmem_swapping
results: parsing output: 116/ for test: kms_plane
results: parsing output: 117/ for test: i915_drm_fdinfo
results: parsing output: 118/ for test: kms_dirtyfb
results: parsing output: 119/ for test: i915_pm_rpm
results: parsing output: 120/ for test: gem_eio
results: parsing output: 121/ for test: dumb_buffer
results: parsing output: 122/ for test: kms_plane_cursor
results: parsing output: 123/ for test: kms_flip
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: kms_cursor_legacy
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: i915_hangman
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_flip_scaled_crc
results: parsing output: 130/ for test: kms_pm_rpm
results: parsing output: 131/ for test: kms_psr
Done.