[57.969723] Initializing watchdogs
[57.969766]   /dev/watchdog0
[57.986410] [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.990938] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.993459] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.995595] [001/156] (960s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[58.097403] Starting subtest: fbc-psr2-primary-mmap-cpu
[58.098435] Starting dynamic subtest: eDP-1
[58.100254] Dynamic subtest eDP-1: SKIP (0.000s)
[58.102038] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s)
[58.161760] [002/156] (960s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[58.253720] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[65.402295] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (7.091s)
[65.524621] [003/156] (953s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[65.622350] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[72.593036] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.950s)
[72.838504] [004/156] (945s left) gem_pxp (hw-rejects-pxp-buffer)
[73.043056] Starting subtest: hw-rejects-pxp-buffer
[73.045698] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[73.186530] [005/156] (945s left) syncobj_timeline (multi-wait-for-submit-signaled)
[73.290393] Starting subtest: multi-wait-for-submit-signaled
[73.291610] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[73.449892] [006/156] (945s left) i915_pm_rps (reset)
[73.520172] Starting subtest: reset
[81.953664] Subtest reset: SUCCESS (8.420s)
[82.086107] [007/156] (936s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-render)
[82.183374] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-render
[82.184970] Subtest hdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[82.278393] [008/156] (936s left) perf (missing-sample-flags)
[82.391414] Starting subtest: missing-sample-flags
[82.392337] Subtest missing-sample-flags: SUCCESS (0.000s)
[82.431378] [009/156] (936s left) gem_ctx_shared (exec-single-timeline)
[82.491628] Starting subtest: exec-single-timeline
[82.492705] Starting dynamic subtest: rcs0
[83.523590] Dynamic subtest rcs0: SUCCESS (1.022s)
[83.536589] Starting dynamic subtest: bcs0
[84.611258] Dynamic subtest bcs0: SUCCESS (1.086s)
[84.621967] Starting dynamic subtest: vcs0
[85.702834] Dynamic subtest vcs0: SUCCESS (1.090s)
[85.715485] Starting dynamic subtest: vcs1
[86.788992] Dynamic subtest vcs1: SUCCESS (1.084s)
[86.796440] Starting dynamic subtest: vecs0
[87.876944] Dynamic subtest vecs0: SUCCESS (1.085s)
[87.886999] Starting dynamic subtest: ccs0
[88.964682] Dynamic subtest ccs0: SUCCESS (1.085s)
[88.965910] Subtest exec-single-timeline: SUCCESS (6.461s)
[89.140761] [010/156] (929s left) prime_vgem (sync)
[89.272781] Starting subtest: sync
[89.273908] Starting dynamic subtest: rcs0
[89.315329] Dynamic subtest rcs0: SUCCESS (0.042s)
[89.322831] Starting dynamic subtest: bcs0
[89.363777] Dynamic subtest bcs0: SUCCESS (0.047s)
[89.370872] Starting dynamic subtest: vcs0
[89.414364] Dynamic subtest vcs0: SUCCESS (0.051s)
[89.421122] Starting dynamic subtest: vcs1
[89.462270] Dynamic subtest vcs1: SUCCESS (0.048s)
[89.469280] Starting dynamic subtest: vecs0
[89.510503] Dynamic subtest vecs0: SUCCESS (0.048s)
[89.517444] Starting dynamic subtest: ccs0
[89.558908] Dynamic subtest ccs0: SUCCESS (0.048s)
[89.559793] Subtest sync: SUCCESS (0.286s)
[89.678824] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.vgem: true
[89.680522] [011/156] (929s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[89.786628] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[89.787523] Starting dynamic subtest: pipe-A-eDP-1
[96.565226] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.777s)
[96.578237] Starting dynamic subtest: pipe-B-eDP-1
[103.777603] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.209s)
[103.778775] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.988s)
[104.631794] [012/156] (914s left) kms_addfb_basic (bad-pitch-65536)
[104.681019] Starting subtest: bad-pitch-65536
[104.681944] Subtest bad-pitch-65536: SUCCESS (0.000s)
[104.830410] [013/156] (914s left) kms_plane (pixel-format-4-tiled-modifier)
[104.919954] Starting subtest: pixel-format-4-tiled-modifier
[104.946346] Starting dynamic subtest: pipe-A-plane-0
[105.346869] Dynamic subtest pipe-A-plane-0: SUCCESS (0.400s)
[105.356353] Starting dynamic subtest: pipe-A-plane-3
[105.702081] Dynamic subtest pipe-A-plane-3: SUCCESS (0.355s)
[105.711245] Starting dynamic subtest: pipe-A-plane-5
[105.712916] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[106.818828] Starting dynamic subtest: pipe-B-plane-0
[107.222297] Dynamic subtest pipe-B-plane-0: SUCCESS (0.411s)
[107.231164] Starting dynamic subtest: pipe-B-plane-3
[107.556107] Dynamic subtest pipe-B-plane-3: SUCCESS (0.333s)
[107.564889] Starting dynamic subtest: pipe-B-plane-5
[107.566545] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[107.864231] Subtest pixel-format-4-tiled-modifier: SUCCESS (2.944s)
[108.691836] [014/156] (910s left) api_intel_allocator (two-level-inception)
[108.740570] Starting subtest: two-level-inception
[114.187417] Subtest two-level-inception: SUCCESS (5.401s)
[114.271524] [015/156] (904s left) gem_ctx_persistence (legacy-engines-mixed-process)
[114.330421] Starting subtest: legacy-engines-mixed-process
[114.331383] Starting dynamic subtest: render
[116.336815] Dynamic subtest render: SUCCESS (2.005s)
[116.349211] Starting dynamic subtest: bsd1
[118.332096] Dynamic subtest bsd1: SUCCESS (1.993s)
[118.342950] Starting dynamic subtest: bsd2
[120.363504] Dynamic subtest bsd2: SUCCESS (2.030s)
[120.374423] Starting dynamic subtest: blt
[122.316504] Dynamic subtest blt: SUCCESS (1.951s)
[122.324463] Starting dynamic subtest: vebox
[124.310195] Dynamic subtest vebox: SUCCESS (1.993s)
[124.311293] Subtest legacy-engines-mixed-process: SUCCESS (9.979s)
[124.384065] [016/156] (894s left) kms_atomic_interruptible (universal-setplane-cursor)
[124.470236] Starting subtest: universal-setplane-cursor
[124.471061] Starting dynamic subtest: pipe-A-eDP-1
[131.904732] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.433s)
[131.905805] Subtest universal-setplane-cursor: SUCCESS (7.434s)
[132.750573] [017/156] (886s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[132.850154] Starting subtest: fbc-modesetfrombusy
[136.974403] Subtest fbc-modesetfrombusy: SUCCESS (4.125s)
[138.136145] [018/156] (880s left) gem_softpin (evict-active)
[138.187377] Starting subtest: evict-active
[138.192906] Subtest evict-active: SUCCESS (0.006s)
[138.299766] [019/156] (880s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[138.387711] Starting subtest: extended-pageflip-modeset-hang-oldfb
[138.388576] Starting dynamic subtest: pipe-A
[146.318452] Dynamic subtest pipe-A: SUCCESS (7.929s)
[146.326459] Starting dynamic subtest: pipe-D
[154.953308] Dynamic subtest pipe-D: SUCCESS (8.633s)
[154.954289] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.566s)
[155.786800] [020/156] (863s left) kms_hdr (bpc-switch-dpms)
[155.872080] Starting subtest: bpc-switch-dpms
[155.872963] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[161.503660] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (5.631s)
[161.513852] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[167.074063] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (5.569s)
[167.075258] Subtest bpc-switch-dpms: SUCCESS (11.203s)
[167.171488] [021/156] (852s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[167.271993] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[167.273828] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[167.366244] [022/156] (851s left) gem_huc_copy (huc-copy)
[167.421690] Starting subtest: huc-copy
[167.424505] Subtest huc-copy: SUCCESS (0.003s)
[167.541682] [023/156] (851s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[167.631779] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[172.230409] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.599s)
[173.440184] [024/156] (845s left) i915_drm_fdinfo (virtual-idle)
[173.475179] Starting subtest: virtual-idle
[176.542615] Subtest virtual-idle: SUCCESS (3.056s)
[176.620126] [025/156] (842s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[176.735905] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[176.736952] Starting dynamic subtest: pipe-A-eDP-1
[176.745047] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[176.752418] Starting dynamic subtest: pipe-B-eDP-1
[176.760313] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[176.768182] Starting dynamic subtest: pipe-C-eDP-1
[176.775687] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[176.783093] Starting dynamic subtest: pipe-D-eDP-1
[176.790373] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[176.791242] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[178.995483] [026/156] (840s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[179.088157] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[181.587533] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (2.501s)
[182.698527] [027/156] (836s left) syncobj_timeline (wait-all-for-submit-complex)
[182.747439] Starting subtest: wait-all-for-submit-complex
[182.971626] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[183.031884] [028/156] (836s left) gem_mmap_gtt (basic-short)
[183.081512] Subtest basic-short: SKIP (0.000s)
[183.137163] [029/156] (836s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[183.181242] Starting subtest: etime-multi-wait-all-available-unsubmitted
[183.300949] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.108s)
[183.362131] [030/156] (836s left) kms_pm_dc (dc5-dpms)
[184.462275] Starting subtest: dc5-dpms
[186.582816] Subtest dc5-dpms: SUCCESS (2.109s)
[186.661345] [031/156] (832s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-pgflip-blt)
[186.759073] Starting subtest: psrhdr-2p-scndscrn-shrfb-pgflip-blt
[186.760708] Subtest psrhdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[186.852331] [032/156] (832s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[186.945851] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[186.947556] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[187.043290] [033/156] (832s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[187.136442] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[187.138359] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[188.265035] [034/156] (831s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[188.363488] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[188.365058] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[188.475774] [035/156] (831s left) kms_cursor_crc (cursor-offscreen-512x170)
[188.772905] Starting subtest: cursor-offscreen-512x170
[188.775089] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[188.930136] [036/156] (830s left) kms_flip (plain-flip-fb-recreate-interruptible)
[189.018711] Starting subtest: plain-flip-fb-recreate-interruptible
[189.021129] Starting dynamic subtest: A-eDP1
[197.850702] Dynamic subtest A-eDP1: SUCCESS (8.829s)
[197.863065] Starting dynamic subtest: B-eDP1
[206.683166] Dynamic subtest B-eDP1: SUCCESS (8.831s)
[206.694364] Starting dynamic subtest: C-eDP1
[215.499595] Dynamic subtest C-eDP1: SUCCESS (8.814s)
[215.510851] Starting dynamic subtest: D-eDP1
[224.331341] Dynamic subtest D-eDP1: SUCCESS (8.829s)
[224.334325] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.313s)
[225.507831] [037/156] (794s left) gem_busy (parallel)
[225.694338] Starting subtest: parallel
[225.695187] Starting dynamic subtest: rcs0
[227.367814] Dynamic subtest rcs0: SUCCESS (1.668s)
[227.377545] Starting dynamic subtest: bcs0
[229.351330] Dynamic subtest bcs0: SUCCESS (1.980s)
[229.361503] Starting dynamic subtest: vcs0
[231.335424] Dynamic subtest vcs0: SUCCESS (1.982s)
[231.343409] Starting dynamic subtest: vcs1
[233.319437] Dynamic subtest vcs1: SUCCESS (1.981s)
[233.329851] Starting dynamic subtest: vecs0
[235.367820] Dynamic subtest vecs0: SUCCESS (2.045s)
[235.379884] Starting dynamic subtest: ccs0
[237.351832] Dynamic subtest ccs0: SUCCESS (1.982s)
[237.353456] Subtest parallel: SUCCESS (11.653s)
[237.582923] [038/156] (782s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[237.691087] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc
[237.692702] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[237.791461] [039/156] (782s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[237.886253] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[237.887224] Starting dynamic subtest: pipe-A
[238.225224] Dynamic subtest pipe-A: SUCCESS (0.339s)
[238.232780] Starting dynamic subtest: pipe-B
[239.614187] Dynamic subtest pipe-B: SUCCESS (1.388s)
[239.622076] Starting dynamic subtest: pipe-C
[241.052403] Dynamic subtest pipe-C: SUCCESS (1.437s)
[241.061211] Starting dynamic subtest: pipe-D
[242.485171] Dynamic subtest pipe-D: SUCCESS (1.432s)
[242.486054] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.600s)
[243.644586] [040/156] (776s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[243.697436] Starting subtest: multi-wait-all-available-submitted-signaled
[243.698473] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.001s)
[243.786473] [041/156] (776s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[243.878422] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[243.880201] Subtest hdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[243.986784] [042/156] (775s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-pwrite)
[244.074594] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-pwrite
[244.076348] Subtest hdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[244.168467] [043/156] (775s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[244.255710] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[244.267904] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.011s)
[244.340852] [044/156] (775s left) syncobj_basic (bad-flags-handle-to-fd)
[244.385753] Starting subtest: bad-flags-handle-to-fd
[244.386637] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[244.486382] [045/156] (775s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[244.546680] Starting subtest: map-fixed-invalidate-overlap-busy
[244.548320] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[244.664886] [046/156] (775s left) kms_lease (lease-unleased-crtc)
[244.758223] Starting subtest: lease-unleased-crtc
[244.759095] Starting dynamic subtest: pipe-A-eDP-1
[245.049987] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s)
[245.059416] Starting dynamic subtest: pipe-B-eDP-1
[245.793743] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.740s)
[245.805146] Starting dynamic subtest: pipe-C-eDP-1
[245.806235] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[245.813798] Starting dynamic subtest: pipe-D-eDP-1
[245.814861] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[245.815920] Subtest lease-unleased-crtc: SUCCESS (1.046s)
[246.161987] [047/156] (773s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[246.209398] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[246.210450] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[246.323656] [048/156] (773s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[246.407199] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[246.409074] Starting dynamic subtest: pipe-A-eDP-1
[246.419417] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[246.428771] Starting dynamic subtest: pipe-B-eDP-1
[246.437787] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[246.454205] Starting dynamic subtest: pipe-C-eDP-1
[246.462042] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[246.469182] Starting dynamic subtest: pipe-D-eDP-1
[246.477581] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[246.479346] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[248.756442] [049/156] (771s left) gem_flink_basic (bad-open)
[248.807430] Starting subtest: bad-open
[248.808622] Subtest bad-open: SUCCESS (0.000s)
[248.896698] [050/156] (771s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[248.994135] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[248.995898] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[249.080418] [051/156] (771s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[249.177802] Starting subtest: drrs-dirtyfb-ioctl
[249.183209] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[249.265833] [052/156] (771s left) gem_userptr_blits (create-destroy-unsync)
[249.334850] Subtest create-destroy-unsync: SKIP (0.000s)
[249.442746] [053/156] (770s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[249.537451] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[249.539376] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[249.618085] [054/156] (770s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-pwrite)
[249.713416] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-pwrite
[249.715380] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[249.800514] [055/156] (770s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[249.895249] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[249.896896] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[250.020962] [056/156] (770s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[250.120992] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[250.122825] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[250.235034] [057/156] (770s left) gem_spin_batch (legacy-resubmit)
[250.291857] Starting subtest: legacy-resubmit
[250.292675] Starting dynamic subtest: default
[250.298675] Dynamic subtest default: SUCCESS (0.008s)
[250.306642] Starting dynamic subtest: render
[250.307574] Dynamic subtest render: SUCCESS (0.001s)
[250.315064] Starting dynamic subtest: bsd
[250.315954] Dynamic subtest bsd: SUCCESS (0.003s)
[250.323330] Starting dynamic subtest: bsd1
[250.324189] Dynamic subtest bsd1: SUCCESS (0.001s)
[250.331568] Starting dynamic subtest: bsd2
[250.332469] Dynamic subtest bsd2: SUCCESS (0.002s)
[250.339786] Starting dynamic subtest: blt
[250.340696] Dynamic subtest blt: SUCCESS (0.002s)
[250.348072] Starting dynamic subtest: vebox
[250.348930] Dynamic subtest vebox: SUCCESS (0.002s)
[250.349974] Subtest legacy-resubmit: SUCCESS (0.025s)
[250.540734] [058/156] (769s left) gem_exec_whisper (basic-fds)
[250.593265] Starting subtest: basic-fds
[258.392576] Subtest basic-fds: SUCCESS (7.798s)
[258.586287] [059/156] (761s left) kms_frontbuffer_tracking (fbcpsrhdr-stridechange)
[258.677141] Starting subtest: fbcpsrhdr-stridechange
[258.678635] Subtest fbcpsrhdr-stridechange: SKIP (0.000s)
[258.777110] [060/156] (761s left) kms_flip (2x-modeset-vs-vblank-race)
[258.861456] Starting subtest: 2x-modeset-vs-vblank-race
[258.873058] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[258.963889] [061/156] (761s left) gem_ctx_param (get-priority-new-ctx)
[259.017664] Starting subtest: get-priority-new-ctx
[259.018617] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[259.120161] [062/156] (761s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-fullscreen)
[259.220987] Starting subtest: hdr-2p-scndscrn-spr-indfb-fullscreen
[259.222887] Subtest hdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[259.305927] [063/156] (761s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[259.398833] Starting subtest: psr2-cursor-plane-move-continuous-sf
[259.399646] Starting dynamic subtest: pipe-A-eDP-1
[269.759546] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.358s)
[269.768252] Starting dynamic subtest: pipe-B-eDP-1
[280.810578] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.049s)
[280.811501] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.410s)
[281.694868] [064/156] (739s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[281.771374] Starting subtest: fbc-psr-sprite-mmap-gtt
[281.772303] Starting dynamic subtest: eDP-1
[281.773967] Dynamic subtest eDP-1: SKIP (0.000s)
[281.775655] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[281.852788] [065/156] (738s left) gem_vm_create (create-ext)
[281.912567] Starting subtest: create-ext
[281.918893] Subtest create-ext: SUCCESS (0.006s)
[282.036217] [066/156] (738s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[282.126114] Starting subtest: coverage-vs-premult-vs-constant
[282.404876] Starting dynamic subtest: pipe-A-eDP-1
[282.988380] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.583s)
[282.996913] Starting dynamic subtest: pipe-D-eDP-1
[284.324711] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.334s)
[284.325794] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.208s)
[285.159480] [067/156] (735s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[285.244389] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[285.245889] Subtest fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[285.341069] [068/156] (735s left) gem_exec_reloc (basic-cpu-read-active)
[285.386258] Subtest basic-cpu-read-active: SKIP (0.000s)
[285.458580] [069/156] (735s left) kms_sequence (queue-idle)
[285.547646] Starting subtest: queue-idle
[285.548577] Starting dynamic subtest: pipe-A-eDP-1
[287.351386] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.803s)
[287.359809] Starting dynamic subtest: pipe-B-eDP-1
[289.837177] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.485s)
[289.847077] Starting dynamic subtest: pipe-C-eDP-1
[292.364774] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.525s)
[292.373359] Starting dynamic subtest: pipe-D-eDP-1
[294.797340] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.431s)
[294.798131] Subtest queue-idle: SUCCESS (9.250s)
[295.601898] [070/156] (725s left) kms_scaling_modes (scaling-mode-full-aspect)
[295.690753] Starting subtest: scaling-mode-full-aspect
[295.691851] Starting dynamic subtest: pipe-A-eDP-1
[295.783823] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s)
[295.795418] Starting dynamic subtest: pipe-B-eDP-1
[296.922233] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.137s)
[296.933189] Starting dynamic subtest: pipe-C-eDP-1
[298.129335] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.205s)
[298.140787] Starting dynamic subtest: pipe-D-eDP-1
[299.254061] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.123s)
[299.254988] Subtest scaling-mode-full-aspect: SUCCESS (3.565s)
[300.431640] [071/156] (720s left) kms_big_fb (linear-64bpp-rotate-270)
[300.524730] Starting subtest: linear-64bpp-rotate-270
[300.544188] Subtest linear-64bpp-rotate-270: SKIP (0.019s)
[300.668674] [072/156] (720s left) kms_cursor_crc (cursor-sliding-128x42)
[300.879672] Starting subtest: cursor-sliding-128x42
[300.922486] Subtest cursor-sliding-128x42: SKIP (0.041s)
[301.141602] [073/156] (719s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[301.233384] Starting subtest: 4-tiled-16bpp-rotate-180
[302.615795] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.382s)
[302.710566] [074/156] (718s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[302.808233] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[302.809821] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[302.911725] [075/156] (718s left) gem_mmap_gtt (flink-race)
[302.971013] Subtest flink-race: SKIP (0.000s)
[303.035705] [076/156] (718s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[303.414788] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[304.231857] [077/156] (716s left) api_intel_bb (simple-bb-ctx)
[304.277896] Starting subtest: simple-bb-ctx
[304.286054] Subtest simple-bb-ctx: SUCCESS (0.009s)
[304.413804] [078/156] (716s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[304.503160] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[304.504872] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[304.595184] [079/156] (716s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[304.683927] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[304.685725] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[304.786769] [080/156] (716s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[304.877449] Starting subtest: yf-tiled-16bpp-rotate-90
[304.879517] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[304.961497] [081/156] (716s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[305.047066] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[305.048776] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[305.153223] [082/156] (716s left) syncobj_wait (wait-for-submit-complex)
[305.197059] Starting subtest: wait-for-submit-complex
[305.259574] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[305.342922] [083/156] (716s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[305.427086] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[305.428724] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[305.518830] [084/156] (715s left) testdisplay
[305.808769] [085/156] (715s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt)
[305.908177] Starting subtest: fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt
[305.909819] Subtest fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[306.006854] [086/156] (715s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[306.088818] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[306.089675] Starting dynamic subtest: pipe-A
[306.152179] Dynamic subtest pipe-A: SUCCESS (0.064s)
[306.162950] Starting dynamic subtest: pipe-B
[307.281220] Dynamic subtest pipe-B: SUCCESS (1.128s)
[307.293457] Starting dynamic subtest: pipe-C
[308.391929] Dynamic subtest pipe-C: SUCCESS (1.109s)
[308.400184] Starting dynamic subtest: pipe-D
[309.522133] Dynamic subtest pipe-D: SUCCESS (1.130s)
[309.523082] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.435s)
[310.669303] [087/156] (710s left) gem_exec_schedule (preempt)
[310.730198] Starting subtest: preempt
[310.731354] Starting dynamic subtest: rcs0
[310.752549] Dynamic subtest rcs0: SUCCESS (0.022s)
[310.763091] Starting dynamic subtest: bcs0
[310.770525] Dynamic subtest bcs0: SUCCESS (0.017s)
[310.780089] Starting dynamic subtest: vcs0
[310.794550] Dynamic subtest vcs0: SUCCESS (0.023s)
[310.804271] Starting dynamic subtest: vcs1
[310.815224] Dynamic subtest vcs1: SUCCESS (0.020s)
[310.823729] Starting dynamic subtest: vecs0
[310.836124] Dynamic subtest vecs0: SUCCESS (0.020s)
[310.844912] Starting dynamic subtest: ccs0
[310.858839] Dynamic subtest ccs0: SUCCESS (0.022s)
[310.859946] Subtest preempt: SUCCESS (0.129s)
[312.453768] [088/156] (709s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-mmap-cpu)
[312.541709] Starting subtest: fbchdr-rgb565-draw-mmap-cpu
[312.543610] Subtest fbchdr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[312.649047] [089/156] (708s left) gem_exec_params (invalid-bsd-ring)
[312.701243] Starting subtest: invalid-bsd-ring
[312.702175] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[312.791366] [090/156] (708s left) kms_psr (psr-primary-blt)
[312.872428] Starting subtest: psr-primary-blt
[312.873242] Starting dynamic subtest: eDP-1
[314.584352] Dynamic subtest eDP-1: SUCCESS (1.711s)
[314.585242] Subtest psr-primary-blt: SUCCESS (1.712s)
[315.452930] [091/156] (706s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[315.500681] Subtest untiled-to-tiled: SKIP (0.000s)
[315.562730] [092/156] (706s left) gem_ctx_persistence (file)
[315.608382] Starting subtest: file
[315.704060] Subtest file: SUCCESS (0.095s)
[315.828293] [093/156] (705s left) gem_exec_params (sol-reset-invalid)
[315.884630] Starting subtest: sol-reset-invalid
[315.887260] Subtest sol-reset-invalid: SUCCESS (0.003s)
[317.425152] [094/156] (704s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[317.522449] Starting subtest: y-tiled-16bpp-rotate-0
[317.524394] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[317.612975] [095/156] (704s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[317.709286] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[317.710904] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[317.816686] [096/156] (704s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[317.902636] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[324.702565] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.788s)
[324.822160] [097/156] (697s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[324.910125] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[324.911806] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[324.978553] [098/156] (696s left) gem_exec_reloc (basic-cpu-gtt)
[325.038298] Subtest basic-cpu-gtt: SKIP (0.000s)
[325.112056] [099/156] (696s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[325.201618] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[331.944223] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.744s)
[332.063395] [100/156] (689s left) kms_color (ctm-red-to-blue)
[332.157597] Starting subtest: ctm-red-to-blue
[332.158663] Starting dynamic subtest: pipe-A-eDP-1
[332.903111] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.746s)
[332.911420] Starting dynamic subtest: pipe-B-eDP-1
[334.321203] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.417s)
[334.337386] Starting dynamic subtest: pipe-C-eDP-1
[335.688876] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.365s)
[335.699612] Starting dynamic subtest: pipe-D-eDP-1
[337.018535] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.330s)
[337.019492] Subtest ctm-red-to-blue: SUCCESS (4.862s)
[337.823588] [101/156] (684s left) kms_psr (psr2-dpms)
[337.911168] Starting subtest: psr2-dpms
[337.912130] Starting dynamic subtest: eDP-1
[340.837588] Dynamic subtest eDP-1: SUCCESS (2.924s)
[340.838908] Subtest psr2-dpms: SUCCESS (2.925s)
[341.694554] [102/156] (680s left) kms_lease (atomic-implicit-crtc)
[341.793064] Starting subtest: atomic-implicit-crtc
[341.793933] Starting dynamic subtest: pipe-A-eDP-1
[341.798522] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[341.807095] Starting dynamic subtest: pipe-B-eDP-1
[341.811482] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[341.821282] Starting dynamic subtest: pipe-C-eDP-1
[341.825537] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[341.833564] Starting dynamic subtest: pipe-D-eDP-1
[341.837653] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[341.838503] Subtest atomic-implicit-crtc: SUCCESS (0.037s)
[341.949239] [103/156] (680s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt)
[342.049626] Starting subtest: fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt
[342.051407] Subtest fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[342.166708] [104/156] (679s left) gem_pread (display)
[342.222731] Subtest display: SKIP (0.000s)
[342.280943] [105/156] (679s left) syncobj_basic (bad-handle-to-fd)
[342.324571] Starting subtest: bad-handle-to-fd
[342.325578] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[342.422646] [106/156] (679s left) i915_drm_fdinfo (memory-info-idle)
[342.461031] Starting subtest: memory-info-idle
[342.462226] Starting dynamic subtest: smem0
[342.503814] Dynamic subtest smem0: SUCCESS (0.042s)
[342.505168] Subtest memory-info-idle: SUCCESS (0.043s)
[342.573032] [107/156] (679s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[342.659130] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[342.661062] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[342.766292] [108/156] (679s left) i915_query (query-topology-garbage-items)
[342.806254] Starting subtest: query-topology-garbage-items
[342.807238] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[342.904527] [109/156] (679s left) perf_pmu (busy-start)
[342.938194] Starting subtest: busy-start
[342.939133] Starting dynamic subtest: rcs0
[345.491371] Dynamic subtest rcs0: SUCCESS (2.552s)
[345.503731] Starting dynamic subtest: bcs0
[348.053777] Dynamic subtest bcs0: SUCCESS (2.548s)
[348.063239] Starting dynamic subtest: vcs0
[351.334757] Dynamic subtest vcs0: SUCCESS (3.281s)
[351.344566] Starting dynamic subtest: vcs1
[355.303036] Dynamic subtest vcs1: SUCCESS (3.965s)
[355.312704] Starting dynamic subtest: vecs0
[359.335348] Dynamic subtest vecs0: SUCCESS (4.029s)
[359.344858] Starting dynamic subtest: ccs0
[361.891318] Dynamic subtest ccs0: SUCCESS (2.549s)
[361.892354] Subtest busy-start: SUCCESS (18.940s)
[361.996548] [110/156] (660s left) prime_vgem (fence-flip-hang)
[362.059760] Subtest fence-flip-hang: SKIP (0.000s)
[362.162033] [111/156] (660s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[362.263234] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu
[362.264890] Subtest fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[362.381209] [112/156] (659s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[362.466378] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[362.468250] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[362.547722] [113/156] (659s left) kms_cursor_crc (cursor-sliding-64x64)
[362.723396] Starting subtest: cursor-sliding-64x64
[362.727608] Starting dynamic subtest: pipe-A-eDP-1
[365.948486] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.221s)
[365.978053] Starting dynamic subtest: pipe-D-eDP-1
[369.888812] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.917s)
[369.889883] Subtest cursor-sliding-64x64: SUCCESS (7.164s)
[370.758341] [114/156] (651s left) gem_ctx_bad_destroy (double-destroy)
[370.812056] Starting subtest: double-destroy
[370.813106] Subtest double-destroy: SUCCESS (0.000s)
[370.894572] [115/156] (651s left) kms_vrr (flip-suspend)
[370.974355] Starting subtest: flip-suspend
[370.976984] Subtest flip-suspend: SKIP (0.000s)
[371.052226] [116/156] (651s left) gem_exec_params (readonly)
[371.094261] Starting subtest: readonly
[371.096611] Subtest readonly: SUCCESS (0.002s)
[371.214310] [117/156] (651s left) gem_exec_schedule (preempt-self)
[371.274334] Starting subtest: preempt-self
[371.275541] Starting dynamic subtest: rcs0
[371.298950] Dynamic subtest rcs0: SUCCESS (0.024s)
[371.307272] Starting dynamic subtest: bcs0
[371.321087] Dynamic subtest bcs0: SUCCESS (0.021s)
[371.328922] Starting dynamic subtest: vcs0
[371.340944] Dynamic subtest vcs0: SUCCESS (0.019s)
[371.348900] Starting dynamic subtest: vcs1
[371.365586] Dynamic subtest vcs1: SUCCESS (0.024s)
[371.373835] Starting dynamic subtest: vecs0
[371.390207] Dynamic subtest vecs0: SUCCESS (0.024s)
[371.403721] Starting dynamic subtest: ccs0
[371.413681] Dynamic subtest ccs0: SUCCESS (0.023s)
[371.414710] Subtest preempt-self: SUCCESS (0.140s)
[373.427745] [118/156] (649s left) kms_chamelium_hpd (hdmi-hpd)
[373.807885] Subtest hdmi-hpd: SKIP (0.000s)
[374.670546] [119/156] (647s left) gem_exec_await (wide-contexts)
[374.882752] Starting subtest: wide-contexts
[398.355825] Subtest wide-contexts: SUCCESS (23.467s)
[398.542947] [120/156] (624s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[398.706432] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[405.471209] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.766s)
[405.604836] [121/156] (617s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[405.699252] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[405.700865] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[405.804280] [122/156] (616s left) sw_sync (sync_random_merge)
[405.841096] Starting subtest: sync_random_merge
[405.886371] Subtest sync_random_merge: SUCCESS (0.046s)
[405.954953] [123/156] (616s left) kms_content_protection (uevent-hdcp14)
[406.099843] Starting subtest: uevent-hdcp14
[406.101671] Subtest uevent-hdcp14: SKIP (0.000s)
[406.200057] [124/156] (616s left) gen9_exec_parse (bb-start-out)
[406.253765] Subtest bb-start-out: SKIP (0.000s)
[406.322706] [125/156] (616s left) gem_exec_balancer (parallel-balancer)
[406.596134] Starting subtest: parallel-balancer
[407.597160] Subtest parallel-balancer: SUCCESS (1.001s)
[407.706999] [126/156] (615s left) vgem_basic (dmabuf-fence-before)
[407.750059] Starting subtest: dmabuf-fence-before
[407.751101] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[407.819937] [127/156] (615s left) kms_force_connector_basic (prune-stale-modes)
[407.893112] Starting subtest: prune-stale-modes
[408.336168] Subtest prune-stale-modes: SUCCESS (0.443s)
[408.467899] [128/156] (614s left) kms_chamelium_audio (hdmi-audio-edid)
[408.865607] Subtest hdmi-audio-edid: SKIP (0.000s)
[409.725419] [129/156] (613s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[409.780789] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[409.782702] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[409.960556] [130/156] (613s left) gem_exec_fence (submit)
[410.136454] Starting subtest: submit
[410.138238] Subtest submit: SKIP (0.000s)
[412.414206] [131/156] (610s left) kms_flip (flip-vs-rmfb)
[412.499709] Starting subtest: flip-vs-rmfb
[412.501931] Starting dynamic subtest: A-eDP1
[421.212823] Dynamic subtest A-eDP1: SUCCESS (8.710s)
[421.224404] Starting dynamic subtest: B-eDP1
[429.917138] Dynamic subtest B-eDP1: SUCCESS (8.702s)
[429.929214] Starting dynamic subtest: C-eDP1
[438.600751] Dynamic subtest C-eDP1: SUCCESS (8.682s)
[438.612999] Starting dynamic subtest: D-eDP1
[447.308071] Dynamic subtest D-eDP1: SUCCESS (8.705s)
[447.312661] Subtest flip-vs-rmfb: SUCCESS (34.811s)
[448.544993] [132/156] (574s left) perf (global-sseu-config-invalid)
[448.641187] Starting subtest: global-sseu-config-invalid
[448.643272] Subtest global-sseu-config-invalid: SKIP (0.000s)
[448.677701] [133/156] (574s left) kms_async_flips (crc-atomic)
[448.758399] Starting subtest: crc-atomic
[449.140566] Starting dynamic subtest: pipe-A-eDP-1
[452.022635] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.881s)
[452.407105] Starting dynamic subtest: pipe-B-eDP-1
[455.330037] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.931s)
[455.709700] Starting dynamic subtest: pipe-C-eDP-1
[458.624024] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.925s)
[458.990747] Starting dynamic subtest: pipe-D-eDP-1
[461.915210] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.934s)
[461.916084] Subtest crc-atomic: SUCCESS (13.157s)
[463.138202] [134/156] (560s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[463.228310] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[466.771424] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.544s)
[467.960695] [135/156] (555s left) kms_dsc (dsc-with-formats)
[468.050292] Starting subtest: dsc-with-formats
[468.065245] Subtest dsc-with-formats: SKIP (0.001s)
[468.118630] [136/156] (555s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[468.221292] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[468.223032] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[468.310984] [137/156] (554s left) gem_mmap_gtt (fault-concurrent-x)
[468.353833] Subtest fault-concurrent-X: SKIP (0.000s)
[468.404253] [138/156] (554s left) gem_workarounds (reset-context)
[468.463036] Starting subtest: reset-context
[468.647361] Subtest reset-context: SUCCESS (0.184s)
[468.764992] [139/156] (554s left) kms_flip (basic-plain-flip)
[468.847067] Starting subtest: basic-plain-flip
[468.849007] Starting dynamic subtest: A-eDP1
[470.519096] Dynamic subtest A-eDP1: SUCCESS (1.670s)
[470.532790] Starting dynamic subtest: B-eDP1
[472.224781] Dynamic subtest B-eDP1: SUCCESS (1.703s)
[472.238397] Starting dynamic subtest: C-eDP1
[473.906926] Dynamic subtest C-eDP1: SUCCESS (1.679s)
[473.918601] Starting dynamic subtest: D-eDP1
[475.607213] Dynamic subtest D-eDP1: SUCCESS (1.698s)
[475.608174] Subtest basic-plain-flip: SUCCESS (6.761s)
[476.846977] [140/156] (546s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-render)
[476.941377] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-render
[476.942967] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[477.027951] [141/156] (546s left) kms_setmode (basic-clone-single-crtc)
[477.072843] Starting subtest: basic-clone-single-crtc
[477.075269] Subtest basic-clone-single-crtc: SKIP (0.000s)
[477.174923] [142/156] (546s left) kms_frontbuffer_tracking (fbc-suspend)
[477.266117] Starting subtest: fbc-suspend
[515.444214] Subtest fbc-suspend: SUCCESS (8.444s)
[520.720152] [143/156] (506s left) kms_pm_rpm (pm-caching)
[522.259179] Starting subtest: pm-caching
[522.261932] Subtest pm-caching: SKIP (0.000s)
[523.007907] [144/156] (504s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-blt)
[523.097269] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-blt
[523.099084] Subtest hdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[523.186082] [145/156] (504s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[523.285262] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[523.287163] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[523.387653] [146/156] (504s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[523.482436] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[523.483374] Starting dynamic subtest: pipe-A-eDP-1
[523.492155] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[523.504886] Starting dynamic subtest: pipe-B-eDP-1
[523.513582] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[523.523618] Starting dynamic subtest: pipe-C-eDP-1
[523.531411] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[523.540853] Starting dynamic subtest: pipe-D-eDP-1
[523.548942] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[523.550534] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[525.750608] [147/156] (501s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[525.851361] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[525.853037] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[525.936803] [148/156] (501s left) gem_exec_big (single)
[525.993266] Starting subtest: single
[530.649132] Subtest single: SUCCESS (4.597s)
[530.884225] [149/156] (496s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[530.988428] Starting subtest: yf-tiled-ccs-to-y-tiled
[530.990286] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[531.170284] [150/156] (496s left) gem_create (create-massive)
[531.223932] Starting subtest: create-massive
[531.224959] Subtest create-massive: SUCCESS (0.000s)
[531.422071] [151/156] (496s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[531.517647] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[535.747477] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (4.209s)
[536.924753] [152/156] (490s left) vgem_basic (bad-handle)
[536.970346] Starting subtest: bad-handle
[536.971383] Subtest bad-handle: SUCCESS (0.000s)
[537.038914] [153/156] (490s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[537.136114] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[537.137817] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[537.208236] [154/156] (490s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[537.310906] Starting subtest: 4-tiled-32bpp-rotate-180
[538.750053] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.435s)
[538.893608] [155/156] (489s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc)
[538.982204] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc
[538.983871] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[539.079845] [156/156] (488s left) dmabuf_sync_file (import-multiple-read-write)
[539.122941] Starting subtest: import-multiple-read-write
[539.131981] Subtest import-multiple-read-write: SUCCESS (0.009s)
[539.187366] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_pxp
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: i915_pm_rps
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: perf
results: parsing output: 8/ for test: gem_ctx_shared
results: parsing output: 9/ for test: prime_vgem
results: parsing output: 10/ for test: kms_psr2_sf
results: parsing output: 11/ for test: kms_addfb_basic
results: parsing output: 12/ for test: kms_plane
results: parsing output: 13/ for test: api_intel_allocator
results: parsing output: 14/ for test: gem_ctx_persistence
results: parsing output: 15/ for test: kms_atomic_interruptible
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_softpin
results: parsing output: 18/ for test: kms_busy
results: parsing output: 19/ for test: kms_hdr
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_huc_copy
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: i915_drm_fdinfo
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: gem_mmap_gtt
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: kms_pm_dc
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_cursor_crc
results: parsing output: 35/ for test: kms_flip
results: parsing output: 36/ for test: gem_busy
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_plane_scaling
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: syncobj_basic
results: parsing output: 44/ for test: gem_userptr_blits
results: parsing output: 45/ for test: kms_lease
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: gem_flink_basic
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_dirtyfb
results: parsing output: 51/ for test: gem_userptr_blits
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_spin_batch
results: parsing output: 57/ for test: gem_exec_whisper
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: gem_ctx_param
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_psr2_sf
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: gem_vm_create
results: parsing output: 65/ for test: kms_plane_alpha_blend
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_exec_reloc
results: parsing output: 68/ for test: kms_sequence
results: parsing output: 69/ for test: kms_scaling_modes
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_cursor_crc
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_mmap_gtt
results: parsing output: 75/ for test: kms_chamelium_edid
results: parsing output: 76/ for test: api_intel_bb
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: syncobj_wait
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: testdisplay
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_plane_scaling
results: parsing output: 86/ for test: gem_exec_schedule
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_exec_params
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: gem_set_tiling_vs_blt
results: parsing output: 91/ for test: gem_ctx_persistence
results: parsing output: 92/ for test: gem_exec_params
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_flip_scaled_crc
results: parsing output: 97/ for test: gem_exec_reloc
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_color
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: kms_lease
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_pread
results: parsing output: 104/ for test: syncobj_basic
results: parsing output: 105/ for test: i915_drm_fdinfo
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: i915_query
results: parsing output: 108/ for test: perf_pmu
results: parsing output: 109/ for test: prime_vgem
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_plane
results: parsing output: 112/ for test: kms_cursor_crc
results: parsing output: 113/ for test: gem_ctx_bad_destroy
results: parsing output: 114/ for test: kms_vrr
results: parsing output: 115/ for test: gem_exec_params
results: parsing output: 116/ for test: gem_exec_schedule
results: parsing output: 117/ for test: kms_chamelium_hpd
results: parsing output: 118/ for test: gem_exec_await
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: sw_sync
results: parsing output: 122/ for test: kms_content_protection
results: parsing output: 123/ for test: gen9_exec_parse
results: parsing output: 124/ for test: gem_exec_balancer
results: parsing output: 125/ for test: vgem_basic
results: parsing output: 126/ for test: kms_force_connector_basic
results: parsing output: 127/ for test: kms_chamelium_audio
results: parsing output: 128/ for test: gem_render_copy
results: parsing output: 129/ for test: gem_exec_fence
results: parsing output: 130/ for test: kms_flip
results: parsing output: 131/ for test: perf
results: parsing output: 132/ for test: kms_async_flips
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: kms_dsc
results: parsing output: 135/ for test: kms_big_fb
results: parsing output: 136/ for test: gem_mmap_gtt
results: parsing output: 137/ for test: gem_workarounds
results: parsing output: 138/ for test: kms_flip
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: kms_setmode
results: parsing output: 141/ for test: kms_frontbuffer_tracking
results: parsing output: 142/ for test: kms_pm_rpm
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: kms_big_fb
results: parsing output: 145/ for test: kms_ccs
results: parsing output: 146/ for test: kms_flip_scaled_crc
results: parsing output: 147/ for test: gem_exec_big
results: parsing output: 148/ for test: gem_render_copy
results: parsing output: 149/ for test: gem_create
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: vgem_basic
results: parsing output: 152/ for test: kms_psr2_sf
results: parsing output: 153/ for test: kms_big_fb
results: parsing output: 154/ for test: kms_frontbuffer_tracking
results: parsing output: 155/ for test: dmabuf_sync_file
Done.