[56.655350] Initializing watchdogs
[56.655415]   /dev/watchdog0
[56.675136] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[56.686215] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[56.690169] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.692745] [001/131] (960s left) kms_feature_discovery (display-2x)
[56.882958] Starting subtest: display-2x
[56.884640] Subtest display-2x: SKIP (0.000s)
[56.990919] [002/131] (960s left) api_intel_allocator (gem-pool)
[57.062181] Starting subtest: gem-pool
[57.097669] Subtest gem-pool: SUCCESS (0.036s)
[57.288174] [003/131] (960s left) gem_eio (throttle)
[57.532397] Starting subtest: throttle
[57.957381] Subtest throttle: SUCCESS (0.428s)
[58.176284] [004/131] (959s left) kms_flip (basic-plain-flip)
[58.362967] Starting subtest: basic-plain-flip
[58.366692] Starting dynamic subtest: A-DP3
[59.250945] Dynamic subtest A-DP3: SUCCESS (0.888s)
[59.260709] Starting dynamic subtest: B-DP3
[60.059473] Dynamic subtest B-DP3: SUCCESS (0.811s)
[60.072054] Starting dynamic subtest: C-DP3
[60.845063] Dynamic subtest C-DP3: SUCCESS (0.787s)
[60.855537] Starting dynamic subtest: D-DP3
[61.630117] Dynamic subtest D-DP3: SUCCESS (0.786s)
[61.636372] Subtest basic-plain-flip: SUCCESS (3.287s)
[62.007081] [005/131] (955s left) i915_module_load (reload-with-fault-injection)
[62.052244] Starting subtest: reload-with-fault-injection
[77.065625] Subtest reload-with-fault-injection: SUCCESS (15.035s)
[77.091602] [FACT i915_module_load (reload-with-fault-injection)] deleted: kernel.kmod_is_loaded.i915: true
[77.093228] [006/131] (940s left) sysfs_timeslice_duration (timeout)
[78.640317] Starting subtest: timeout
[78.641325] Starting dynamic subtest: vecs0
[80.195161] Dynamic subtest vecs0: SUCCESS (1.558s)
[80.203535] Starting dynamic subtest: ccs0
[81.793482] Dynamic subtest ccs0: SUCCESS (1.599s)
[81.802145] Starting dynamic subtest: vcs0
[83.374284] Dynamic subtest vcs0: SUCCESS (1.582s)
[83.382520] Starting dynamic subtest: bcs0
[84.441227] Dynamic subtest bcs0: SUCCESS (1.067s)
[84.449357] Starting dynamic subtest: vecs1
[86.226149] Dynamic subtest vecs1: SUCCESS (1.786s)
[86.234469] Starting dynamic subtest: rcs0
[87.891219] Dynamic subtest rcs0: SUCCESS (1.666s)
[87.899755] Starting dynamic subtest: vcs1
[89.542264] Dynamic subtest vcs1: SUCCESS (1.652s)
[89.543177] Subtest timeout: SUCCESS (10.912s)
[89.620196] [FACT sysfs_timeslice_duration (timeout)] new: kernel.kmod_is_loaded.i915: true
[89.622763] [007/131] (927s left) kms_cursor_crc (cursor-size-change)
[89.821290] Starting subtest: cursor-size-change
[89.822229] Starting dynamic subtest: pipe-A-DP-3
[90.737706] Dynamic subtest pipe-A-DP-3: SUCCESS (0.916s)
[90.752509] Starting dynamic subtest: pipe-D-DP-3
[91.507310] Dynamic subtest pipe-D-DP-3: SUCCESS (0.768s)
[91.508361] Subtest cursor-size-change: SUCCESS (1.687s)
[92.215849] [008/131] (925s left) core_auth (basic-auth)
[92.289124] Starting subtest: basic-auth
[92.301423] Subtest basic-auth: SUCCESS (0.012s)
[92.423597] [009/131] (925s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[92.612237] Starting subtest: random-ccs-data-yf-tiled-ccs
[92.613178] Starting dynamic subtest: pipe-A-DP-3
[92.622796] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[92.630967] Starting dynamic subtest: pipe-B-DP-3
[92.640519] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[92.648507] Starting dynamic subtest: pipe-C-DP-3
[92.657860] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[92.666099] Starting dynamic subtest: pipe-D-DP-3
[92.677774] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[92.680022] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.004s)
[93.062303] [010/131] (924s left) gem_create (busy-create)
[93.138442] Starting subtest: busy-create
[93.139422] Starting dynamic subtest: lmem0
[125.409256] Dynamic subtest lmem0: SUCCESS (32.279s)
[125.417807] Starting dynamic subtest: smem0
[157.656402] Dynamic subtest smem0: SUCCESS (32.247s)
[157.657413] Subtest busy-create: SUCCESS (64.527s)
[157.926160] [011/131] (859s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[157.997283] Starting subtest: etime-single-wait-for-submit-unsubmitted
[158.101365] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[158.213180] [012/131] (859s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[158.402579] Starting subtest: basic-flip-after-cursor-varying-size
[159.415559] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.011s)
[159.671063] [013/131] (858s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[159.871734] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[159.873423] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[160.022983] [014/131] (858s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[160.221820] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[160.223430] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[160.341469] [015/131] (857s left) perf (invalid-create-userspace-config)
[160.691430] Starting subtest: invalid-create-userspace-config
[160.693420] Subtest invalid-create-userspace-config: SUCCESS (0.002s)
[160.751779] [016/131] (857s left) kms_plane (plane-position-hole-dpms)
[160.939273] Starting subtest: plane-position-hole-dpms
[161.378524] Starting dynamic subtest: pipe-A-plane-1
[162.056650] Dynamic subtest pipe-A-plane-1: SUCCESS (0.678s)
[162.067966] Starting dynamic subtest: pipe-A-plane-2
[162.714455] Dynamic subtest pipe-A-plane-2: SUCCESS (0.657s)
[162.723286] Starting dynamic subtest: pipe-A-plane-3
[163.371057] Dynamic subtest pipe-A-plane-3: SUCCESS (0.656s)
[163.382709] Starting dynamic subtest: pipe-A-plane-4
[164.033471] Dynamic subtest pipe-A-plane-4: SUCCESS (0.662s)
[164.046069] Starting dynamic subtest: pipe-A-plane-5
[164.060428] Dynamic subtest pipe-A-plane-5: SUCCESS (0.026s)
[164.422183] Starting dynamic subtest: pipe-B-plane-1
[165.030154] Dynamic subtest pipe-B-plane-1: SUCCESS (0.617s)
[165.039064] Starting dynamic subtest: pipe-B-plane-2
[165.673079] Dynamic subtest pipe-B-plane-2: SUCCESS (0.642s)
[165.681782] Starting dynamic subtest: pipe-B-plane-3
[166.315247] Dynamic subtest pipe-B-plane-3: SUCCESS (0.642s)
[166.331013] Starting dynamic subtest: pipe-B-plane-4
[166.949283] Dynamic subtest pipe-B-plane-4: SUCCESS (0.633s)
[166.958357] Starting dynamic subtest: pipe-B-plane-5
[166.970978] Dynamic subtest pipe-B-plane-5: SUCCESS (0.021s)
[166.971936] Subtest plane-position-hole-dpms: SUCCESS (6.031s)
[167.211269] [017/131] (851s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[167.403425] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[167.404383] Starting dynamic subtest: pipe-A-valid-mode
[169.193482] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.787s)
[169.195046] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (1.789s)
[169.459015] [018/131] (848s left) gem_exec_schedule (smoketest-all)
[169.544504] Starting subtest: smoketest-all
[201.859246] Subtest smoketest-all: SUCCESS (32.310s)
[202.255105] [019/131] (816s left) perf (per-context-mode-unprivileged)
[202.461966] Starting subtest: per-context-mode-unprivileged
[202.464161] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[202.509829] [020/131] (815s left) gem_exec_fence (syncobj-timeline-signal)
[203.162265] Starting subtest: syncobj-timeline-signal
[203.195435] Subtest syncobj-timeline-signal: SUCCESS (0.033s)
[203.508541] [FACT gem_exec_fence (syncobj-timeline-signal)] new: kernel.kmod_is_loaded.vgem: true
[203.510699] [021/131] (814s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[203.705369] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[203.706345] Starting dynamic subtest: pipe-A
[203.800377] Dynamic subtest pipe-A: SUCCESS (0.095s)
[203.810779] Starting dynamic subtest: pipe-B
[204.000505] Dynamic subtest pipe-B: SUCCESS (0.199s)
[204.015257] Starting dynamic subtest: pipe-C
[204.215337] Dynamic subtest pipe-C: SUCCESS (0.214s)
[204.230129] Starting dynamic subtest: pipe-D
[204.431418] Dynamic subtest pipe-D: SUCCESS (0.215s)
[204.432468] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SUCCESS (0.726s)
[204.762080] [022/131] (813s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[204.959408] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[204.961701] Starting dynamic subtest: pipe-A-DP-3
[204.970304] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[204.979202] Starting dynamic subtest: pipe-B-DP-3
[204.987643] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[204.996449] Starting dynamic subtest: pipe-C-DP-3
[205.004997] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[205.013813] Starting dynamic subtest: pipe-D-DP-3
[205.025038] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[205.027192] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SKIP (0.008s)
[205.427626] [023/131] (813s left) kms_cursor_crc (cursor-onscreen-32x32)
[205.737899] Starting subtest: cursor-onscreen-32x32
[205.787581] Subtest cursor-onscreen-32x32: SKIP (0.048s)
[206.191612] [024/131] (812s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[206.401957] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[206.403556] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[206.532600] [025/131] (812s left) kms_prop_blob (blob-prop-core)
[206.613420] Starting subtest: blob-prop-core
[206.614562] Subtest blob-prop-core: SUCCESS (0.000s)
[206.737842] [026/131] (812s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[206.941972] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[206.943715] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[207.108116] [027/131] (811s left) gem_exec_schedule (preempt-queue-chain)
[207.203823] Subtest preempt-queue-chain: SKIP (0.000s)
[207.579353] [028/131] (811s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[207.783416] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[207.784383] Starting dynamic subtest: pipe-A-valid-mode
[207.855844] Dynamic subtest pipe-A-valid-mode: SKIP (0.076s)
[207.857504] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.078s)
[208.059882] [029/131] (811s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[208.272663] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[208.274427] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[208.397633] [030/131] (810s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[208.603173] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[208.654971] [031/131] (810s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[208.744631] Starting subtest: yf-tiled-ccs-to-y-tiled
[208.746797] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[209.000708] [032/131] (810s left) perf_pmu (semaphore-wait)
[209.072510] Starting subtest: semaphore-wait
[209.073499] Starting dynamic subtest: rcs0
[209.625210] Dynamic subtest rcs0: SUCCESS (0.544s)
[209.640904] Starting dynamic subtest: bcs0
[210.131314] Dynamic subtest bcs0: SUCCESS (0.510s)
[210.143919] Starting dynamic subtest: vcs0
[210.646500] Dynamic subtest vcs0: SUCCESS (0.509s)
[210.656252] Starting dynamic subtest: vcs1
[211.156819] Dynamic subtest vcs1: SUCCESS (0.509s)
[211.170404] Starting dynamic subtest: vecs0
[211.670032] Dynamic subtest vecs0: SUCCESS (0.510s)
[211.683074] Starting dynamic subtest: vecs1
[212.183259] Dynamic subtest vecs1: SUCCESS (0.510s)
[212.196480] Starting dynamic subtest: ccs0
[212.696714] Dynamic subtest ccs0: SUCCESS (0.510s)
[212.698699] Subtest semaphore-wait: SUCCESS (3.625s)
[212.845097] [033/131] (806s left) kms_flip (2x-plain-flip-interruptible)
[213.044106] Starting subtest: 2x-plain-flip-interruptible
[213.059566] Subtest 2x-plain-flip-interruptible: SKIP (0.015s)
[213.173618] [034/131] (806s left) gem_exec_flush (basic-wb-rw-before-default)
[213.258715] Subtest basic-wb-rw-before-default: SKIP (0.000s)
[213.339283] [035/131] (806s left) gen7_exec_parse (oacontrol-tracking)
[213.423625] Subtest oacontrol-tracking: SKIP (0.000s)
[213.491183] [036/131] (806s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[213.700574] Starting subtest: yf-tiled-16bpp-rotate-270
[213.702298] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[213.861793] [037/131] (805s left) kms_psr (psr-sprite-plane-move)
[214.058168] Subtest psr-sprite-plane-move: SKIP (0.000s)
[214.123239] [038/131] (805s left) gem_exec_params (rsvd2-dirt)
[214.212127] Starting subtest: rsvd2-dirt
[214.214074] Subtest rsvd2-dirt: SKIP (0.000s)
[214.369974] [039/131] (805s left) kms_flip (flip-vs-wf_vblank-interruptible)
[214.570061] Starting subtest: flip-vs-wf_vblank-interruptible
[214.574762] Starting dynamic subtest: A-DP3
[215.828297] Dynamic subtest A-DP3: SUCCESS (1.253s)
[215.841331] Starting dynamic subtest: B-DP3
[217.027439] Dynamic subtest B-DP3: SUCCESS (1.198s)
[217.037702] Starting dynamic subtest: C-DP3
[218.229070] Dynamic subtest C-DP3: SUCCESS (1.201s)
[218.241206] Starting dynamic subtest: D-DP3
[219.262270] Dynamic subtest D-DP3: SUCCESS (1.031s)
[219.270185] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (4.699s)
[219.578782] [040/131] (800s left) kms_universal_plane (universal-plane-pageflip-windowed)
[219.775435] Starting subtest: universal-plane-pageflip-windowed
[219.777925] Starting dynamic subtest: pipe-A-DP-3
[220.369836] Dynamic subtest pipe-A-DP-3: SUCCESS (0.592s)
[220.386850] Starting dynamic subtest: pipe-B-DP-3
[220.878482] Dynamic subtest pipe-B-DP-3: SUCCESS (0.506s)
[220.894454] Starting dynamic subtest: pipe-C-DP-3
[221.381432] Dynamic subtest pipe-C-DP-3: SUCCESS (0.500s)
[221.394508] Starting dynamic subtest: pipe-D-DP-3
[221.912450] Dynamic subtest pipe-D-DP-3: SUCCESS (0.529s)
[221.913394] Subtest universal-plane-pageflip-windowed: SUCCESS (2.137s)
[222.172567] [041/131] (797s left) gem_exec_balancer (nohangcheck)
[222.581958] Starting subtest: nohangcheck
[224.221391] Subtest nohangcheck: SUCCESS (1.640s)
[224.349022] [042/131] (795s left) kms_big_fb (linear-16bpp-rotate-180)
[224.567369] Starting subtest: linear-16bpp-rotate-180
[226.662467] Subtest linear-16bpp-rotate-180: SUCCESS (2.094s)
[226.845998] [043/131] (793s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[227.046248] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[227.048159] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[227.182032] [044/131] (792s left) gem_exec_async (forked-writes)
[227.274404] Starting subtest: forked-writes
[227.275341] Starting dynamic subtest: rcs0
[227.337956] Dynamic subtest rcs0: SUCCESS (0.063s)
[227.350686] Starting dynamic subtest: bcs0
[227.376439] Dynamic subtest bcs0: SUCCESS (0.038s)
[227.387736] Starting dynamic subtest: vcs0
[227.413065] Dynamic subtest vcs0: SUCCESS (0.036s)
[227.423088] Starting dynamic subtest: vcs1
[227.447436] Dynamic subtest vcs1: SUCCESS (0.033s)
[227.457437] Starting dynamic subtest: vecs0
[227.482785] Dynamic subtest vecs0: SUCCESS (0.034s)
[227.492789] Starting dynamic subtest: vecs1
[227.516703] Dynamic subtest vecs1: SUCCESS (0.033s)
[227.526760] Starting dynamic subtest: ccs0
[227.550891] Dynamic subtest ccs0: SUCCESS (0.033s)
[227.551846] Subtest forked-writes: SUCCESS (0.277s)
[227.862341] [045/131] (792s left) gem_mmap_gtt (basic-write)
[227.946204] Subtest basic-write: SKIP (0.000s)
[228.022536] [046/131] (792s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[228.223150] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[228.375685] [047/131] (791s left) kms_chamelium_edid (hdmi-mode-timings)
[228.656559] Subtest hdmi-mode-timings: SKIP (0.000s)
[228.812350] [048/131] (791s left) kms_vrr (seamless-rr-switch-drrs)
[229.013519] Starting subtest: seamless-rr-switch-drrs
[229.016256] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[229.108008] [049/131] (791s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[229.195385] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[229.270499] [050/131] (791s left) kms_psr (pr-primary-page-flip)
[229.467189] Subtest pr-primary-page-flip: SKIP (0.000s)
[229.555305] [051/131] (791s left) kms_psr (fbc-psr-cursor-plane-move)
[229.755147] Subtest fbc-psr-cursor-plane-move: SKIP (0.000s)
[229.815412] [052/131] (790s left) i915_selftest (perf)
[230.932984] Starting subtest: perf
[230.934047] Starting dynamic subtest: engine_cs
[232.605153] Dynamic subtest engine_cs: SUCCESS (1.671s)
[232.615948] Starting dynamic subtest: request
[237.295919] Dynamic subtest request: SUCCESS (4.690s)
[237.304175] Starting dynamic subtest: migrate
[239.054118] Dynamic subtest migrate: SUCCESS (1.757s)
[239.063195] Starting dynamic subtest: region
[267.298147] Dynamic subtest region: SUCCESS (28.245s)
[267.299129] Subtest perf: SUCCESS (36.369s)
[267.328985] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[267.330240] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[267.332174] [053/131] (753s left) kms_invalid_mode (zero-vdisplay)
[268.988175] Starting subtest: zero-vdisplay
[268.989136] Starting dynamic subtest: pipe-A-DP-3
[269.063185] Dynamic subtest pipe-A-DP-3: SUCCESS (0.073s)
[269.073723] Starting dynamic subtest: pipe-B-DP-3
[269.074663] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[269.085056] Starting dynamic subtest: pipe-C-DP-3
[269.086035] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[269.094438] Starting dynamic subtest: pipe-D-DP-3
[269.095418] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[269.096332] Subtest zero-vdisplay: SUCCESS (0.083s)
[269.314488] [FACT kms_invalid_mode (zero-vdisplay)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[269.316891] [FACT kms_invalid_mode (zero-vdisplay)] new: kernel.kmod_is_loaded.i915: true
[269.319977] [054/131] (751s left) tools_test (sysfs_l3_parity)
[269.375012] Starting subtest: sysfs_l3_parity
[269.445058] Subtest sysfs_l3_parity: SKIP (0.074s)
[269.541461] [055/131] (751s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[269.751438] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[269.803976] [056/131] (751s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[270.011359] Starting subtest: fbcpsr-slowdraw
[270.013139] Subtest fbcpsr-slowdraw: SKIP (0.000s)
[270.139713] [057/131] (750s left) syncobj_timeline (signal)
[270.217572] Starting subtest: signal
[270.218452] Subtest signal: SUCCESS (0.000s)
[270.362848] [058/131] (750s left) kms_content_protection (atomic)
[270.642030] Starting subtest: atomic
[270.678220] Starting dynamic subtest: pipe-A-DP-3
[393.369583] Dynamic subtest pipe-A-DP-3: FAIL (122.521s)
[393.370761] Subtest atomic: FAIL (122.663s)
[393.571754] [059/131] (627s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[393.773198] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[393.774982] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[393.909200] [060/131] (627s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[394.117061] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[394.118798] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[394.263803] [061/131] (626s left) gem_vm_create (execbuf)
[394.356292] Starting subtest: execbuf
[394.364143] Subtest execbuf: SUCCESS (0.008s)
[394.553566] [062/131] (626s left) gem_softpin (reverse)
[394.640681] Starting subtest: reverse
[394.654070] Subtest reverse: SUCCESS (0.013s)
[394.801515] [063/131] (626s left) core_setmaster_vs_auth
[395.068833] [064/131] (626s left) kms_lease (lessee-list)
[395.270506] Starting subtest: lessee-list
[395.273063] Starting dynamic subtest: pipe-A-DP-3
[395.273989] Dynamic subtest pipe-A-DP-3: SUCCESS (0.002s)
[395.285071] Starting dynamic subtest: pipe-B-DP-3
[395.286097] Dynamic subtest pipe-B-DP-3: SUCCESS (0.002s)
[395.295731] Starting dynamic subtest: pipe-C-DP-3
[395.296574] Dynamic subtest pipe-C-DP-3: SUCCESS (0.002s)
[395.306139] Starting dynamic subtest: pipe-D-DP-3
[395.307404] Dynamic subtest pipe-D-DP-3: SUCCESS (0.002s)
[395.308503] Subtest lessee-list: SUCCESS (0.015s)
[395.424378] [065/131] (626s left) gem_ctx_persistence (legacy-engines-cleanup)
[395.514290] Starting subtest: legacy-engines-cleanup
[395.515262] Starting dynamic subtest: render
[395.618443] Dynamic subtest render: SUCCESS (0.103s)
[395.633586] Starting dynamic subtest: bsd1
[395.671910] Dynamic subtest bsd1: SUCCESS (0.051s)
[395.712926] Starting dynamic subtest: bsd2
[395.714071] Dynamic subtest bsd2: SUCCESS (0.033s)
[395.729588] Starting dynamic subtest: blt
[395.753500] Dynamic subtest blt: SUCCESS (0.042s)
[395.765217] Starting dynamic subtest: vebox
[395.794289] Dynamic subtest vebox: SUCCESS (0.040s)
[395.795229] Subtest legacy-engines-cleanup: SUCCESS (0.281s)
[395.994073] [066/131] (625s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[396.192239] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[396.247987] [067/131] (625s left) gem_fence_thrash (bo-copy)
[396.299516] Starting subtest: bo-copy
[396.330284] Subtest bo-copy: SKIP (0.030s)
[396.399017] [068/131] (625s left) kms_atomic (plane-immutable-zpos)
[396.600537] Starting subtest: plane-immutable-zpos
[396.603162] Starting dynamic subtest: pipe-A-DP-3
[397.510095] Dynamic subtest pipe-A-DP-3: SUCCESS (0.908s)
[397.511017] Subtest plane-immutable-zpos: SUCCESS (0.910s)
[397.775937] [069/131] (623s left) prime_mmap_coherency (ioctl-errors)
[397.862059] Starting subtest: ioctl-errors
[403.748639] Subtest ioctl-errors: SUCCESS (5.887s)
[403.953790] [070/131] (617s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[404.091516] Starting subtest: multi-wait-for-submit-submitted-signaled
[404.092557] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[404.215510] [071/131] (617s left) syncobj_eventfd (invalid-illegal-handle)
[404.294336] Starting subtest: invalid-illegal-handle
[404.295272] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[404.430421] [072/131] (617s left) syncobj_timeline (invalid-wait-illegal-handle)
[404.515372] Starting subtest: invalid-wait-illegal-handle
[404.516311] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[404.658895] [073/131] (617s left) gem_ctx_param (invalid-ctx-set)
[404.739818] Starting subtest: invalid-ctx-set
[404.742225] Subtest invalid-ctx-set: SUCCESS (0.002s)
[404.905765] [074/131] (617s left) kms_pipe_crc_basic (read-crc)
[405.107535] Starting subtest: read-crc
[405.110156] Starting dynamic subtest: pipe-A-DP-3
[405.786530] Dynamic subtest pipe-A-DP-3: SUCCESS (0.677s)
[405.802144] Starting dynamic subtest: pipe-B-DP-3
[406.379821] Dynamic subtest pipe-B-DP-3: SUCCESS (0.590s)
[406.394220] Starting dynamic subtest: pipe-C-DP-3
[406.942283] Dynamic subtest pipe-C-DP-3: SUCCESS (0.561s)
[406.956390] Starting dynamic subtest: pipe-D-DP-3
[407.536449] Dynamic subtest pipe-D-DP-3: SUCCESS (0.591s)
[407.537453] Subtest read-crc: SUCCESS (2.429s)
[407.813851] [075/131] (614s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[410.422418] Starting subtest: verify-pxp-key-change-after-suspend-resume
[410.424365] Subtest verify-pxp-key-change-after-suspend-resume: SKIP (0.000s)
[410.520535] [076/131] (611s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[410.723193] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[410.724916] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[410.881690] [077/131] (611s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[411.080563] Starting subtest: bad-rotation-90-y-tiled-ccs
[411.083158] Starting dynamic subtest: pipe-A-DP-3
[411.091807] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[411.102061] Starting dynamic subtest: pipe-B-DP-3
[411.110702] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[411.120553] Starting dynamic subtest: pipe-C-DP-3
[411.129122] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[411.139219] Starting dynamic subtest: pipe-D-DP-3
[411.150612] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[411.152840] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.007s)
[411.546475] [078/131] (610s left) kms_vrr (flipline)
[411.742487] Starting subtest: flipline
[411.745171] Subtest flipline: SKIP (0.000s)
[411.835785] [079/131] (610s left) vgem_slow (nohang)
[411.898436] Starting subtest: nohang
[421.975124] Subtest nohang: SUCCESS (10.076s)
[422.049824] [080/131] (600s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[422.247575] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[422.250113] Starting dynamic subtest: pipe-A-DP-3
[425.801621] Dynamic subtest pipe-A-DP-3: SUCCESS (3.538s)
[425.816375] Starting dynamic subtest: pipe-B-DP-3
[426.354078] Dynamic subtest pipe-B-DP-3: SUCCESS (0.543s)
[426.379149] Starting dynamic subtest: pipe-C-DP-3
[426.920640] Dynamic subtest pipe-C-DP-3: SUCCESS (0.559s)
[426.946129] Starting dynamic subtest: pipe-D-DP-3
[427.487981] Dynamic subtest pipe-D-DP-3: SUCCESS (0.557s)
[427.489933] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SUCCESS (5.224s)
[427.828643] [081/131] (594s left) i915_drm_fdinfo (most-busy-check-all)
[427.903624] Starting subtest: most-busy-check-all
[427.904542] Starting dynamic subtest: rcs0
[427.933063] Dynamic subtest rcs0: SKIP (0.028s)
[427.943468] Starting dynamic subtest: bcs0
[427.945433] Dynamic subtest bcs0: SKIP (0.000s)
[427.955642] Starting dynamic subtest: vcs0
[427.957940] Dynamic subtest vcs0: SKIP (0.000s)
[427.968245] Starting dynamic subtest: vcs1
[427.970817] Dynamic subtest vcs1: SKIP (0.001s)
[427.980944] Starting dynamic subtest: vecs0
[427.983468] Dynamic subtest vecs0: SKIP (0.000s)
[427.993335] Starting dynamic subtest: vecs1
[427.996984] Dynamic subtest vecs1: SKIP (0.000s)
[428.006884] Starting dynamic subtest: ccs0
[428.009229] Dynamic subtest ccs0: SKIP (0.000s)
[428.011479] Subtest most-busy-check-all: SKIP (0.037s)
[428.056722] [082/131] (594s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[428.288325] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[428.290165] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[428.445448] [083/131] (594s left) gem_exec_schedule (u-submit-early-slice)
[428.542421] Starting subtest: u-submit-early-slice
[428.543384] Starting dynamic subtest: rcs0
[428.630216] Dynamic subtest rcs0: SUCCESS (0.087s)
[428.642080] Starting dynamic subtest: bcs0
[428.687188] Dynamic subtest bcs0: SUCCESS (0.056s)
[428.697775] Starting dynamic subtest: vcs0
[428.746267] Dynamic subtest vcs0: SUCCESS (0.058s)
[428.757972] Starting dynamic subtest: vcs1
[428.803438] Dynamic subtest vcs1: SUCCESS (0.056s)
[428.815226] Starting dynamic subtest: vecs0
[428.865150] Dynamic subtest vecs0: SUCCESS (0.061s)
[428.875773] Starting dynamic subtest: vecs1
[428.919193] Dynamic subtest vecs1: SUCCESS (0.053s)
[428.929519] Starting dynamic subtest: ccs0
[428.976209] Dynamic subtest ccs0: SUCCESS (0.056s)
[428.977210] Subtest u-submit-early-slice: SUCCESS (0.434s)
[429.496619] [084/131] (593s left) kms_properties (get_properties-sanity-non-atomic)
[429.697510] Starting subtest: get_properties-sanity-non-atomic
[429.700124] Subtest get_properties-sanity-non-atomic: SUCCESS (0.002s)
[429.800227] [085/131] (593s left) gem_exec_whisper (basic-normal-all)
[429.896915] Starting subtest: basic-normal-all
[432.134221] Subtest basic-normal-all: SUCCESS (2.236s)
[432.391702] [086/131] (590s left) gem_ctx_shared (exec-shared-gtt)
[432.486360] Starting subtest: exec-shared-gtt
[432.489156] Starting dynamic subtest: rcs0
[432.492337] Dynamic subtest rcs0: SUCCESS (0.010s)
[432.504384] Starting dynamic subtest: bcs0
[432.505331] Dynamic subtest bcs0: SUCCESS (0.007s)
[432.515867] Starting dynamic subtest: vcs0
[432.516876] Dynamic subtest vcs0: SUCCESS (0.006s)
[432.528230] Starting dynamic subtest: vcs1
[432.529175] Dynamic subtest vcs1: SUCCESS (0.007s)
[432.541380] Starting dynamic subtest: vecs0
[432.542298] Dynamic subtest vecs0: SUCCESS (0.006s)
[432.553068] Starting dynamic subtest: vecs1
[432.554372] Dynamic subtest vecs1: SUCCESS (0.008s)
[432.564678] Starting dynamic subtest: ccs0
[432.565908] Dynamic subtest ccs0: SUCCESS (0.008s)
[432.567264] Subtest exec-shared-gtt: SUCCESS (0.059s)
[432.796477] [087/131] (590s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[432.991560] Starting subtest: bad-aux-stride-yf-tiled-ccs
[432.994158] Starting dynamic subtest: pipe-A-DP-3
[433.002825] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[433.013260] Starting dynamic subtest: pipe-B-DP-3
[433.021769] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[433.032022] Starting dynamic subtest: pipe-C-DP-3
[433.040382] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[433.050765] Starting dynamic subtest: pipe-D-DP-3
[433.061825] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[433.064109] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.007s)
[433.467279] [088/131] (589s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[433.959105] Starting subtest: cursor-rapid-movement-512x170
[433.962331] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[434.182447] [089/131] (589s left) gem_pread (exhaustion)
[434.264189] Subtest exhaustion: SKIP (0.000s)
[434.348549] [090/131] (588s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[434.427635] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[434.428540] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[434.581258] [091/131] (588s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[434.792084] Starting subtest: x-tiled-8bpp-rotate-180
[436.331381] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.538s)
[436.530339] [092/131] (586s left) gem_mmap (basic)
[436.612390] Subtest basic: SKIP (0.000s)
[436.695879] [093/131] (586s left) perf_pmu (rc6-all-gts)
[436.769448] Starting subtest: rc6-all-gts
[436.771249] Subtest rc6-all-gts: SKIP (0.000s)
[436.914155] [094/131] (586s left) gem_workarounds (basic-read-context)
[437.014333] Starting subtest: basic-read-context
[437.055168] Subtest basic-read-context: SUCCESS (0.042s)
[437.213512] [095/131] (586s left) gem_madvise (dontneed-after-mmap)
[437.262422] Starting subtest: dontneed-after-mmap
[437.310429] Subtest dontneed-after-mmap: SUCCESS (0.049s)
[437.478358] [096/131] (586s left) kms_color (ctm-max)
[437.675503] Starting subtest: ctm-max
[437.676441] Starting dynamic subtest: pipe-A-DP-3
[438.345355] Dynamic subtest pipe-A-DP-3: SUCCESS (0.669s)
[438.369930] Starting dynamic subtest: pipe-B-DP-3
[438.963304] Dynamic subtest pipe-B-DP-3: SUCCESS (0.615s)
[438.978063] Starting dynamic subtest: pipe-C-DP-3
[439.560464] Dynamic subtest pipe-C-DP-3: SUCCESS (0.596s)
[439.575695] Starting dynamic subtest: pipe-D-DP-3
[440.175590] Dynamic subtest pipe-D-DP-3: SUCCESS (0.614s)
[440.176586] Subtest ctm-max: SUCCESS (2.500s)
[440.452314] [097/131] (583s left) api_intel_bb (blit-reloc-purge-cache)
[440.533480] Starting subtest: blit-reloc-purge-cache
[440.535322] Subtest blit-reloc-purge-cache: SKIP (0.001s)
[440.712369] [098/131] (583s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[440.914040] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[440.915660] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[441.053359] [099/131] (582s left) kms_cursor_edge_walk (256x256-top-edge)
[441.253586] Starting subtest: 256x256-top-edge
[441.256150] Starting dynamic subtest: pipe-A-DP-3
[444.725612] Dynamic subtest pipe-A-DP-3: SUCCESS (3.470s)
[444.742175] Starting dynamic subtest: pipe-D-DP-3
[448.056948] Dynamic subtest pipe-D-DP-3: SUCCESS (3.329s)
[448.057963] Subtest 256x256-top-edge: SUCCESS (6.804s)
[448.313531] [100/131] (575s left) gem_userptr_blits (sync-unmap-after-close)
[448.406542] Starting subtest: sync-unmap-after-close
[448.427374] Subtest sync-unmap-after-close: SUCCESS (0.021s)
[448.621677] [101/131] (575s left) kms_psr (fbc-pr-sprite-plane-onoff)
[448.818186] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[448.881607] [102/131] (575s left) i915_pm_rps (thresholds-idle)
[448.976092] Starting subtest: thresholds-idle
[448.977955] Subtest thresholds-idle: SKIP (0.001s)
[449.077075] [103/131] (575s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[449.285644] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[450.585892] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.299s)
[450.786938] [104/131] (573s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[451.019420] Starting subtest: extended-modeset-hang-newfb-with-reset
[451.021706] Starting dynamic subtest: pipe-A
[471.968194] Dynamic subtest pipe-A: SUCCESS (20.948s)
[471.989537] Starting dynamic subtest: pipe-D
[492.969861] Dynamic subtest pipe-D: SUCCESS (20.995s)
[492.971486] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (41.954s)
[493.243787] [105/131] (531s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[493.445139] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[493.446881] Subtest fbcpsr-rgb101010-draw-pwrite: SKIP (0.000s)
[493.574918] [106/131] (530s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[493.779166] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[493.780918] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[493.937610] [107/131] (530s left) gem_userptr_blits (invalid-null-pointer)
[494.024259] Starting subtest: invalid-null-pointer
[494.025162] Subtest invalid-null-pointer: SUCCESS (0.001s)
[494.176246] [108/131] (530s left) gem_exec_schedule (fifo)
[494.269348] Starting subtest: fifo
[494.270304] Starting dynamic subtest: rcs0
[494.552264] Dynamic subtest rcs0: SUCCESS (0.282s)
[494.563753] Starting dynamic subtest: bcs0
[494.753939] Dynamic subtest bcs0: SUCCESS (0.200s)
[494.765354] Starting dynamic subtest: vcs0
[494.959177] Dynamic subtest vcs0: SUCCESS (0.204s)
[494.970701] Starting dynamic subtest: vcs1
[495.164697] Dynamic subtest vcs1: SUCCESS (0.204s)
[495.176224] Starting dynamic subtest: vecs0
[495.376924] Dynamic subtest vecs0: SUCCESS (0.211s)
[495.388517] Starting dynamic subtest: vecs1
[495.584224] Dynamic subtest vecs1: SUCCESS (0.206s)
[495.595841] Starting dynamic subtest: ccs0
[495.795136] Dynamic subtest ccs0: SUCCESS (0.210s)
[495.796415] Subtest fifo: SUCCESS (1.526s)
[496.190289] [109/131] (528s left) gem_lmem_swapping (verify-ccs)
[498.989322] Starting subtest: verify-ccs
[498.990256] Starting dynamic subtest: lmem0
[545.027212] Dynamic subtest lmem0: SUCCESS (46.035s)
[545.028218] Subtest verify-ccs: SUCCESS (46.036s)
[547.150889] [FACT gem_lmem_swapping (verify-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[547.151905] [FACT gem_lmem_swapping (verify-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[547.153937] [110/131] (477s left) syncobj_wait (multi-wait-submitted)
[548.720365] Starting subtest: multi-wait-submitted
[548.820796] Subtest multi-wait-submitted: SUCCESS (0.101s)
[548.923387] [FACT syncobj_wait (multi-wait-submitted)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[548.926024] [FACT syncobj_wait (multi-wait-submitted)] new: kernel.kmod_is_loaded.i915: true
[548.929161] [111/131] (475s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[549.137501] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[549.139231] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[549.278840] [112/131] (475s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[549.476557] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[549.477468] Starting dynamic subtest: pipe-A
[549.868443] Dynamic subtest pipe-A: SUCCESS (0.391s)
[549.894254] Starting dynamic subtest: pipe-B
[550.351188] Dynamic subtest pipe-B: SUCCESS (0.480s)
[550.373248] Starting dynamic subtest: pipe-C
[550.833602] Dynamic subtest pipe-C: SUCCESS (0.480s)
[550.866630] Starting dynamic subtest: pipe-D
[551.331886] Dynamic subtest pipe-D: SUCCESS (0.495s)
[551.332898] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (1.855s)
[551.680567] [113/131] (473s left) kms_pm_rpm (basic-rte)
[551.736580] Starting subtest: basic-rte
[554.709483] Subtest basic-rte: SUCCESS (2.973s)
[555.476758] [114/131] (469s left) core_setmaster (master-drop-set-shared-fd)
[555.610430] Starting subtest: master-drop-set-shared-fd
[555.643430] Subtest master-drop-set-shared-fd: SUCCESS (0.033s)
[555.692953] [115/131] (469s left) gem_exec_create (forked)
[555.789264] Starting subtest: forked
[555.790258] Starting dynamic subtest: smem
[575.936563] Dynamic subtest smem: SUCCESS (20.143s)
[575.952963] Starting dynamic subtest: lmem0
[596.082383] Dynamic subtest lmem0: SUCCESS (20.141s)
[596.083302] Subtest forked: SUCCESS (40.286s)
[596.331779] [116/131] (428s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[596.534133] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[596.535930] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[596.679631] [117/131] (428s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[596.883091] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[596.884881] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[597.029620] [118/131] (428s left) gem_exec_fence (parallel)
[597.241873] Starting subtest: parallel
[597.242824] Starting dynamic subtest: rcs0
[599.388393] Dynamic subtest rcs0: SUCCESS (2.150s)
[599.398834] Starting dynamic subtest: bcs0
[601.539672] Dynamic subtest bcs0: SUCCESS (2.150s)
[601.551619] Starting dynamic subtest: vcs0
[603.697173] Dynamic subtest vcs0: SUCCESS (2.156s)
[603.709217] Starting dynamic subtest: vcs1
[605.847510] Dynamic subtest vcs1: SUCCESS (2.149s)
[605.859470] Starting dynamic subtest: vecs0
[608.002507] Dynamic subtest vecs0: SUCCESS (2.154s)
[608.014444] Starting dynamic subtest: vecs1
[610.159918] Dynamic subtest vecs1: SUCCESS (2.156s)
[610.170521] Starting dynamic subtest: ccs0
[612.316565] Dynamic subtest ccs0: SUCCESS (2.155s)
[612.317430] Subtest parallel: SUCCESS (15.077s)
[613.021186] [119/131] (412s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[613.099486] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[613.100421] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[613.226569] [120/131] (412s left) kms_flip (2x-flip-vs-panning-interruptible)
[613.426936] Starting subtest: 2x-flip-vs-panning-interruptible
[613.442384] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.014s)
[613.546990] [121/131] (411s left) gem_ctx_isolation (dirty-create)
[613.644980] Starting subtest: dirty-create
[613.645875] Starting dynamic subtest: rcs0
[614.289762] Dynamic subtest rcs0: SUCCESS (0.644s)
[614.301997] Starting dynamic subtest: bcs0
[614.969372] Dynamic subtest bcs0: SUCCESS (0.678s)
[614.980122] Starting dynamic subtest: vcs0
[615.632736] Dynamic subtest vcs0: SUCCESS (0.662s)
[615.643220] Starting dynamic subtest: vcs1
[616.314143] Dynamic subtest vcs1: SUCCESS (0.680s)
[616.324842] Starting dynamic subtest: vecs0
[616.974594] Dynamic subtest vecs0: SUCCESS (0.659s)
[616.985129] Starting dynamic subtest: vecs1
[617.661472] Dynamic subtest vecs1: SUCCESS (0.686s)
[617.672068] Starting dynamic subtest: ccs0
[618.338293] Dynamic subtest ccs0: SUCCESS (0.676s)
[618.339350] Subtest dirty-create: SUCCESS (4.693s)
[618.624464] [122/131] (406s left) gem_bad_reloc (negative-reloc)
[618.712066] Subtest negative-reloc: SKIP (0.000s)
[618.806259] [123/131] (406s left) kms_psr (psr2-suspend)
[619.008243] Subtest psr2-suspend: SKIP (0.000s)
[619.069140] [124/131] (406s left) kms_dsc (dsc-basic)
[619.265680] Starting subtest: dsc-basic
[619.270968] Subtest dsc-basic: SKIP (0.001s)
[619.360886] [125/131] (406s left) kms_chamelium_hpd (dp-hpd)
[619.632918] Subtest dp-hpd: SKIP (0.000s)
[619.789561] [126/131] (406s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[619.993132] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[622.614288] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (2.621s)
[622.834102] [127/131] (403s left) gen9_exec_parse (shadow-peek)
[622.921426] Subtest shadow-peek: SKIP (0.000s)
[623.009889] [128/131] (402s left) kms_atomic_transition (modeset-transition-nonblocking)
[623.206768] Starting subtest: modeset-transition-nonblocking
[623.207693] Starting dynamic subtest: 1x-outputs
[625.760247] Dynamic subtest 1x-outputs: SUCCESS (2.551s)
[625.814978] Subtest modeset-transition-nonblocking: SUCCESS (2.607s)
[626.095347] [129/131] (399s left) drm_read (short-buffer-block)
[626.359041] Starting subtest: short-buffer-block
[626.359925] Subtest short-buffer-block: SUCCESS (0.000s)
[626.592985] [130/131] (399s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[626.792166] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[626.793961] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[626.902962] [131/131] (399s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[627.101119] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[627.116673] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.015s)
[627.215075] Closing watchdogs
results: parsing output: 0/ for test: kms_feature_discovery
results: parsing output: 1/ for test: api_intel_allocator
results: parsing output: 2/ for test: gem_eio
results: parsing output: 3/ for test: kms_flip
results: parsing output: 4/ for test: i915_module_load
results: parsing output: 5/ for test: sysfs_timeslice_duration
results: parsing output: 6/ for test: kms_cursor_crc
results: parsing output: 7/ for test: core_auth
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: gem_create
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: kms_cursor_legacy
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: perf
results: parsing output: 15/ for test: kms_plane
results: parsing output: 16/ for test: kms_flip_scaled_crc
results: parsing output: 17/ for test: gem_exec_schedule
results: parsing output: 18/ for test: perf
results: parsing output: 19/ for test: gem_exec_fence
results: parsing output: 20/ for test: kms_plane_scaling
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: kms_cursor_crc
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_prop_blob
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_exec_schedule
results: parsing output: 27/ for test: kms_flip_scaled_crc
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: kms_psr2_sf
results: parsing output: 30/ for test: gem_render_copy
results: parsing output: 31/ for test: perf_pmu
results: parsing output: 32/ for test: kms_flip
results: parsing output: 33/ for test: gem_exec_flush
results: parsing output: 34/ for test: gen7_exec_parse
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: gem_exec_params
results: parsing output: 38/ for test: kms_flip
results: parsing output: 39/ for test: kms_universal_plane
results: parsing output: 40/ for test: gem_exec_balancer
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_exec_async
results: parsing output: 44/ for test: gem_mmap_gtt
results: parsing output: 45/ for test: kms_addfb_basic
results: parsing output: 46/ for test: kms_chamelium_edid
results: parsing output: 47/ for test: kms_vrr
results: parsing output: 48/ for test: gem_mmap_gtt
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: i915_selftest
results: parsing output: 52/ for test: kms_invalid_mode
results: parsing output: 53/ for test: tools_test
results: parsing output: 54/ for test: kms_psr2_sf
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: kms_content_protection
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_vm_create
results: parsing output: 61/ for test: gem_softpin
results: parsing output: 62/ for test: core_setmaster_vs_auth
results: parsing output: 63/ for test: kms_lease
results: parsing output: 64/ for test: gem_ctx_persistence
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: gem_fence_thrash
results: parsing output: 67/ for test: kms_atomic
results: parsing output: 68/ for test: prime_mmap_coherency
results: parsing output: 69/ for test: syncobj_wait
results: parsing output: 70/ for test: syncobj_eventfd
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: gem_ctx_param
results: parsing output: 73/ for test: kms_pipe_crc_basic
results: parsing output: 74/ for test: gem_pxp
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_ccs
results: parsing output: 77/ for test: kms_vrr
results: parsing output: 78/ for test: vgem_slow
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: i915_drm_fdinfo
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_exec_schedule
results: parsing output: 83/ for test: kms_properties
results: parsing output: 84/ for test: gem_exec_whisper
results: parsing output: 85/ for test: gem_ctx_shared
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: kms_cursor_crc
results: parsing output: 88/ for test: gem_pread
results: parsing output: 89/ for test: syncobj_wait
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: gem_mmap
results: parsing output: 92/ for test: perf_pmu
results: parsing output: 93/ for test: gem_workarounds
results: parsing output: 94/ for test: gem_madvise
results: parsing output: 95/ for test: kms_color
results: parsing output: 96/ for test: api_intel_bb
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_cursor_edge_walk
results: parsing output: 99/ for test: gem_userptr_blits
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: i915_pm_rps
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: kms_busy
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_userptr_blits
results: parsing output: 107/ for test: gem_exec_schedule
results: parsing output: 108/ for test: gem_lmem_swapping
results: parsing output: 109/ for test: syncobj_wait
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_plane_scaling
results: parsing output: 112/ for test: kms_pm_rpm
results: parsing output: 113/ for test: core_setmaster
results: parsing output: 114/ for test: gem_exec_create
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: gem_exec_fence
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: kms_flip
results: parsing output: 120/ for test: gem_ctx_isolation
results: parsing output: 121/ for test: gem_bad_reloc
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: kms_dsc
results: parsing output: 124/ for test: kms_chamelium_hpd
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gen9_exec_parse
results: parsing output: 127/ for test: kms_atomic_transition
results: parsing output: 128/ for test: drm_read
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_flip
Done.