[61.534234] Initializing watchdogs
[61.534303]   /dev/watchdog0
[61.554534] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[61.566436] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card1
[61.570253] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.572816] [001/131] (960s left) kms_feature_discovery (display-2x)
[61.777819] Starting subtest: display-2x
[61.779487] Subtest display-2x: SKIP (0.000s)
[61.880986] [002/131] (960s left) api_intel_allocator (gem-pool)
[61.949293] Starting subtest: gem-pool
[61.986361] Subtest gem-pool: SUCCESS (0.037s)
[62.134473] [003/131] (960s left) gem_eio (throttle)
[62.389119] Starting subtest: throttle
[62.785961] Subtest throttle: SUCCESS (0.397s)
[62.994563] [004/131] (959s left) kms_flip (basic-plain-flip)
[63.183942] Starting subtest: basic-plain-flip
[63.187716] Starting dynamic subtest: A-DP3
[64.080771] Dynamic subtest A-DP3: SUCCESS (0.893s)
[64.092705] Starting dynamic subtest: B-DP3
[64.845522] Dynamic subtest B-DP3: SUCCESS (0.764s)
[64.856620] Starting dynamic subtest: C-DP3
[65.618064] Dynamic subtest C-DP3: SUCCESS (0.771s)
[65.628586] Starting dynamic subtest: D-DP3
[66.389272] Dynamic subtest D-DP3: SUCCESS (0.770s)
[66.391057] Subtest basic-plain-flip: SUCCESS (3.207s)
[66.719393] [005/131] (955s left) i915_module_load (reload-with-fault-injection)
[66.767267] Starting subtest: reload-with-fault-injection
[89.310260] Subtest reload-with-fault-injection: SUCCESS (22.542s)
[89.336697] [FACT i915_module_load (reload-with-fault-injection)] deleted: kernel.kmod_is_loaded.i915: true
[89.338371] [006/131] (932s left) sysfs_timeslice_duration (timeout)
[90.940136] Starting subtest: timeout
[90.941095] Starting dynamic subtest: vecs0
[92.526231] Dynamic subtest vecs0: SUCCESS (1.587s)
[92.534149] Starting dynamic subtest: ccs0
[94.113364] Dynamic subtest ccs0: SUCCESS (1.587s)
[94.121524] Starting dynamic subtest: vcs0
[95.697322] Dynamic subtest vcs0: SUCCESS (1.583s)
[95.705562] Starting dynamic subtest: bcs0
[96.736362] Dynamic subtest bcs0: SUCCESS (1.039s)
[96.744339] Starting dynamic subtest: vecs1
[98.437126] Dynamic subtest vecs1: SUCCESS (1.700s)
[98.445064] Starting dynamic subtest: rcs0
[100.087193] Dynamic subtest rcs0: SUCCESS (1.649s)
[100.095165] Starting dynamic subtest: vcs1
[101.706459] Dynamic subtest vcs1: SUCCESS (1.619s)
[101.707626] Subtest timeout: SUCCESS (10.768s)
[101.790734] [FACT sysfs_timeslice_duration (timeout)] changed: hardware.pci.drm_card_at_addr.0000:03:00.0: card1 -> card0
[101.793180] [FACT sysfs_timeslice_duration (timeout)] new: kernel.kmod_is_loaded.i915: true
[101.795573] [007/131] (920s left) kms_cursor_crc (cursor-size-change)
[101.988307] Starting subtest: cursor-size-change
[101.990385] Starting dynamic subtest: pipe-A-DP-3
[102.897109] Dynamic subtest pipe-A-DP-3: SUCCESS (0.907s)
[102.905163] Starting dynamic subtest: pipe-D-DP-3
[103.706900] Dynamic subtest pipe-D-DP-3: SUCCESS (0.809s)
[103.707898] Subtest cursor-size-change: SUCCESS (1.718s)
[104.339197] [008/131] (918s left) core_auth (basic-auth)
[104.413053] Starting subtest: basic-auth
[104.426125] Subtest basic-auth: SUCCESS (0.013s)
[104.534658] [009/131] (917s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[104.720214] Starting subtest: random-ccs-data-yf-tiled-ccs
[104.721129] Starting dynamic subtest: pipe-A-DP-3
[104.730335] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[104.738303] Starting dynamic subtest: pipe-B-DP-3
[104.747834] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[104.755587] Starting dynamic subtest: pipe-C-DP-3
[104.764504] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[104.772254] Starting dynamic subtest: pipe-D-DP-3
[104.783114] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[104.784702] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.004s)
[105.201918] [010/131] (917s left) gem_create (busy-create)
[105.277373] Starting subtest: busy-create
[105.278298] Starting dynamic subtest: lmem0
[137.577207] Dynamic subtest lmem0: SUCCESS (32.300s)
[137.585470] Starting dynamic subtest: smem0
[169.832392] Dynamic subtest smem0: SUCCESS (32.253s)
[169.833363] Subtest busy-create: SUCCESS (64.553s)
[170.081779] [011/131] (852s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[170.161159] Starting subtest: etime-single-wait-for-submit-unsubmitted
[170.268508] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[170.365146] [012/131] (852s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[170.560805] Starting subtest: basic-flip-after-cursor-varying-size
[171.578515] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.016s)
[171.857182] [013/131] (850s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[172.048880] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[172.050502] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[172.185548] [014/131] (850s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[172.381881] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[172.383526] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[172.513458] [015/131] (850s left) perf (invalid-create-userspace-config)
[172.895508] Starting subtest: invalid-create-userspace-config
[172.897402] Subtest invalid-create-userspace-config: SUCCESS (0.002s)
[172.954534] [016/131] (849s left) kms_plane (plane-position-hole-dpms)
[173.141271] Starting subtest: plane-position-hole-dpms
[173.577708] Starting dynamic subtest: pipe-A-plane-1
[174.231065] Dynamic subtest pipe-A-plane-1: SUCCESS (0.653s)
[174.242860] Starting dynamic subtest: pipe-A-plane-2
[174.957051] Dynamic subtest pipe-A-plane-2: SUCCESS (0.725s)
[174.974815] Starting dynamic subtest: pipe-A-plane-3
[175.652151] Dynamic subtest pipe-A-plane-3: SUCCESS (0.694s)
[175.662998] Starting dynamic subtest: pipe-A-plane-4
[176.336295] Dynamic subtest pipe-A-plane-4: SUCCESS (0.678s)
[176.345591] Starting dynamic subtest: pipe-A-plane-5
[176.350943] Dynamic subtest pipe-A-plane-5: SUCCESS (0.019s)
[176.709553] Starting dynamic subtest: pipe-B-plane-1
[177.321299] Dynamic subtest pipe-B-plane-1: SUCCESS (0.621s)
[177.330341] Starting dynamic subtest: pipe-B-plane-2
[177.971166] Dynamic subtest pipe-B-plane-2: SUCCESS (0.649s)
[177.979517] Starting dynamic subtest: pipe-B-plane-3
[178.622366] Dynamic subtest pipe-B-plane-3: SUCCESS (0.650s)
[178.630856] Starting dynamic subtest: pipe-B-plane-4
[179.254047] Dynamic subtest pipe-B-plane-4: SUCCESS (0.632s)
[179.264325] Starting dynamic subtest: pipe-B-plane-5
[179.276918] Dynamic subtest pipe-B-plane-5: SUCCESS (0.021s)
[179.277864] Subtest plane-position-hole-dpms: SUCCESS (6.135s)
[179.525647] [017/131] (843s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[179.712467] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[179.714612] Starting dynamic subtest: pipe-A-valid-mode
[181.575862] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.861s)
[181.577303] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (1.863s)
[181.843612] [018/131] (841s left) gem_exec_schedule (smoketest-all)
[181.929597] Starting subtest: smoketest-all
[214.247341] Subtest smoketest-all: SUCCESS (32.311s)
[214.611696] [019/131] (808s left) perf (per-context-mode-unprivileged)
[214.796955] Starting subtest: per-context-mode-unprivileged
[214.798920] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[214.853815] [020/131] (808s left) gem_exec_fence (syncobj-timeline-signal)
[215.505885] Starting subtest: syncobj-timeline-signal
[215.538190] Subtest syncobj-timeline-signal: SUCCESS (0.032s)
[215.814088] [FACT gem_exec_fence (syncobj-timeline-signal)] new: kernel.kmod_is_loaded.vgem: true
[215.816401] [021/131] (807s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[216.012423] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[216.013352] Starting dynamic subtest: pipe-A
[216.110944] Dynamic subtest pipe-A: SUCCESS (0.098s)
[216.119290] Starting dynamic subtest: pipe-B
[216.330603] Dynamic subtest pipe-B: SUCCESS (0.219s)
[216.340184] Starting dynamic subtest: pipe-C
[216.530531] Dynamic subtest pipe-C: SUCCESS (0.199s)
[216.544943] Starting dynamic subtest: pipe-D
[216.745605] Dynamic subtest pipe-D: SUCCESS (0.214s)
[216.746523] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SUCCESS (0.734s)
[217.056715] [022/131] (806s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[217.254422] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[217.256669] Starting dynamic subtest: pipe-A-DP-3
[217.264736] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[217.273176] Starting dynamic subtest: pipe-B-DP-3
[217.281362] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[217.289568] Starting dynamic subtest: pipe-C-DP-3
[217.297914] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[217.306132] Starting dynamic subtest: pipe-D-DP-3
[217.315662] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[217.317657] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SKIP (0.008s)
[217.728949] [023/131] (805s left) kms_cursor_crc (cursor-onscreen-32x32)
[218.026421] Starting subtest: cursor-onscreen-32x32
[218.079656] Subtest cursor-onscreen-32x32: SKIP (0.051s)
[218.508824] [024/131] (804s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[218.710054] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[218.711870] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[218.854321] [025/131] (804s left) kms_prop_blob (blob-prop-core)
[218.932311] Starting subtest: blob-prop-core
[218.933332] Subtest blob-prop-core: SUCCESS (0.000s)
[219.092980] [026/131] (804s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[219.295965] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[219.297637] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[219.432758] [027/131] (804s left) gem_exec_schedule (preempt-queue-chain)
[219.529561] Subtest preempt-queue-chain: SKIP (0.000s)
[219.857994] [028/131] (803s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[220.055518] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[220.057833] Starting dynamic subtest: pipe-A-valid-mode
[220.139656] Dynamic subtest pipe-A-valid-mode: SKIP (0.081s)
[220.141542] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.083s)
[220.359251] [029/131] (803s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[220.571413] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[220.573202] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[220.708649] [030/131] (803s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[220.912030] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[220.962993] [031/131] (803s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[221.050699] Starting subtest: yf-tiled-ccs-to-y-tiled
[221.052410] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[221.302627] [032/131] (802s left) perf_pmu (semaphore-wait)
[221.374973] Starting subtest: semaphore-wait
[221.375860] Starting dynamic subtest: rcs0
[221.931187] Dynamic subtest rcs0: SUCCESS (0.541s)
[221.954168] Starting dynamic subtest: bcs0
[222.429679] Dynamic subtest bcs0: SUCCESS (0.511s)
[222.442356] Starting dynamic subtest: vcs0
[222.944561] Dynamic subtest vcs0: SUCCESS (0.511s)
[222.962573] Starting dynamic subtest: vcs1
[223.463531] Dynamic subtest vcs1: SUCCESS (0.515s)
[223.476545] Starting dynamic subtest: vecs0
[223.977209] Dynamic subtest vecs0: SUCCESS (0.509s)
[223.989684] Starting dynamic subtest: vecs1
[224.490493] Dynamic subtest vecs1: SUCCESS (0.509s)
[224.502789] Starting dynamic subtest: ccs0
[225.003495] Dynamic subtest ccs0: SUCCESS (0.509s)
[225.005532] Subtest semaphore-wait: SUCCESS (3.629s)
[225.166856] [033/131] (798s left) kms_flip (2x-plain-flip-interruptible)
[225.372944] Starting subtest: 2x-plain-flip-interruptible
[225.388385] Subtest 2x-plain-flip-interruptible: SKIP (0.015s)
[225.495995] [034/131] (798s left) gem_exec_flush (basic-wb-rw-before-default)
[225.581287] Subtest basic-wb-rw-before-default: SKIP (0.000s)
[225.670345] [035/131] (798s left) gen7_exec_parse (oacontrol-tracking)
[225.756444] Subtest oacontrol-tracking: SKIP (0.000s)
[225.831318] [036/131] (798s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[226.038409] Starting subtest: yf-tiled-16bpp-rotate-270
[226.040281] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[226.175711] [037/131] (798s left) kms_psr (psr-sprite-plane-move)
[226.376092] Subtest psr-sprite-plane-move: SKIP (0.000s)
[226.430799] [038/131] (798s left) gem_exec_params (rsvd2-dirt)
[226.516072] Starting subtest: rsvd2-dirt
[226.518168] Subtest rsvd2-dirt: SKIP (0.000s)
[226.669899] [039/131] (797s left) kms_flip (flip-vs-wf_vblank-interruptible)
[226.871029] Starting subtest: flip-vs-wf_vblank-interruptible
[226.875720] Starting dynamic subtest: A-DP3
[227.976392] Dynamic subtest A-DP3: SUCCESS (1.100s)
[227.993701] Starting dynamic subtest: B-DP3
[229.003612] Dynamic subtest B-DP3: SUCCESS (1.022s)
[229.016469] Starting dynamic subtest: C-DP3
[230.042772] Dynamic subtest C-DP3: SUCCESS (1.038s)
[230.054083] Starting dynamic subtest: D-DP3
[231.072400] Dynamic subtest D-DP3: SUCCESS (1.028s)
[231.074576] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (4.203s)
[231.389852] [040/131] (793s left) kms_universal_plane (universal-plane-pageflip-windowed)
[231.587441] Starting subtest: universal-plane-pageflip-windowed
[231.589843] Starting dynamic subtest: pipe-A-DP-3
[232.212949] Dynamic subtest pipe-A-DP-3: SUCCESS (0.623s)
[232.223958] Starting dynamic subtest: pipe-B-DP-3
[232.684936] Dynamic subtest pipe-B-DP-3: SUCCESS (0.470s)
[232.703483] Starting dynamic subtest: pipe-C-DP-3
[233.193207] Dynamic subtest pipe-C-DP-3: SUCCESS (0.505s)
[233.203069] Starting dynamic subtest: pipe-D-DP-3
[233.667203] Dynamic subtest pipe-D-DP-3: SUCCESS (0.472s)
[233.668305] Subtest universal-plane-pageflip-windowed: SUCCESS (2.079s)
[233.939500] [041/131] (790s left) gem_exec_balancer (nohangcheck)
[234.351476] Starting subtest: nohangcheck
[235.972043] Subtest nohangcheck: SUCCESS (1.620s)
[236.102186] [042/131] (788s left) kms_big_fb (linear-16bpp-rotate-180)
[236.315422] Starting subtest: linear-16bpp-rotate-180
[238.272033] Subtest linear-16bpp-rotate-180: SUCCESS (1.955s)
[238.486069] [043/131] (786s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[238.688048] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[238.689786] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[238.833121] [044/131] (786s left) gem_exec_async (forked-writes)
[238.934836] Starting subtest: forked-writes
[238.935739] Starting dynamic subtest: rcs0
[239.000417] Dynamic subtest rcs0: SUCCESS (0.065s)
[239.013256] Starting dynamic subtest: bcs0
[239.038681] Dynamic subtest bcs0: SUCCESS (0.037s)
[239.048462] Starting dynamic subtest: vcs0
[239.072572] Dynamic subtest vcs0: SUCCESS (0.033s)
[239.082447] Starting dynamic subtest: vcs1
[239.106272] Dynamic subtest vcs1: SUCCESS (0.033s)
[239.116067] Starting dynamic subtest: vecs0
[239.140397] Dynamic subtest vecs0: SUCCESS (0.033s)
[239.150172] Starting dynamic subtest: vecs1
[239.174248] Dynamic subtest vecs1: SUCCESS (0.033s)
[239.184591] Starting dynamic subtest: ccs0
[239.207959] Dynamic subtest ccs0: SUCCESS (0.033s)
[239.208923] Subtest forked-writes: SUCCESS (0.274s)
[239.486929] [045/131] (785s left) gem_mmap_gtt (basic-write)
[239.566154] Subtest basic-write: SKIP (0.000s)
[239.631840] [046/131] (785s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[239.828133] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[239.956592] [047/131] (785s left) kms_chamelium_edid (hdmi-mode-timings)
[240.230894] Subtest hdmi-mode-timings: SKIP (0.000s)
[240.380988] [048/131] (784s left) kms_vrr (seamless-rr-switch-drrs)
[240.576465] Starting subtest: seamless-rr-switch-drrs
[240.579055] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[240.685494] [049/131] (784s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[240.766244] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[240.839151] [050/131] (784s left) kms_psr (pr-primary-page-flip)
[241.036232] Subtest pr-primary-page-flip: SKIP (0.000s)
[241.134529] [051/131] (784s left) kms_psr (fbc-psr-cursor-plane-move)
[241.346376] Subtest fbc-psr-cursor-plane-move: SKIP (0.000s)
[241.403413] [052/131] (784s left) i915_selftest (perf)
[242.738268] Starting subtest: perf
[242.739241] Starting dynamic subtest: engine_cs
[244.431139] Dynamic subtest engine_cs: SUCCESS (1.692s)
[244.440056] Starting dynamic subtest: request
[249.198107] Dynamic subtest request: SUCCESS (4.766s)
[249.207211] Starting dynamic subtest: migrate
[250.917932] Dynamic subtest migrate: SUCCESS (1.718s)
[250.926434] Starting dynamic subtest: region
[279.071909] Dynamic subtest region: SUCCESS (28.152s)
[279.072823] Subtest perf: SUCCESS (36.334s)
[279.111261] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[279.112396] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[279.114768] [053/131] (746s left) kms_invalid_mode (zero-vdisplay)
[280.822200] Starting subtest: zero-vdisplay
[280.824831] Starting dynamic subtest: pipe-A-DP-3
[280.906494] Dynamic subtest pipe-A-DP-3: SUCCESS (0.082s)
[280.918961] Starting dynamic subtest: pipe-B-DP-3
[280.919971] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[280.931189] Starting dynamic subtest: pipe-C-DP-3
[280.932154] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[280.940957] Starting dynamic subtest: pipe-D-DP-3
[280.941891] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[280.942745] Subtest zero-vdisplay: SUCCESS (0.093s)
[281.166320] [FACT kms_invalid_mode (zero-vdisplay)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[281.168675] [FACT kms_invalid_mode (zero-vdisplay)] new: kernel.kmod_is_loaded.i915: true
[281.171416] [054/131] (744s left) tools_test (sysfs_l3_parity)
[281.225823] Starting subtest: sysfs_l3_parity
[281.292277] Subtest sysfs_l3_parity: SKIP (0.070s)
[281.383404] [055/131] (744s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[281.595082] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[281.650968] [056/131] (744s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[281.856434] Starting subtest: fbcpsr-slowdraw
[281.858187] Subtest fbcpsr-slowdraw: SKIP (0.000s)
[281.998915] [057/131] (743s left) syncobj_timeline (signal)
[282.078428] Starting subtest: signal
[282.079385] Subtest signal: SUCCESS (0.000s)
[282.212059] [058/131] (743s left) kms_content_protection (atomic)
[282.486473] Starting subtest: atomic
[282.524647] Starting dynamic subtest: pipe-A-DP-3
[407.954454] Dynamic subtest pipe-A-DP-3: FAIL (125.253s)
[407.955419] Subtest atomic: FAIL (125.384s)
[408.138511] [059/131] (617s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[408.341028] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[408.342694] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[408.483749] [060/131] (617s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[408.684116] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[408.685781] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[408.840749] [061/131] (617s left) gem_vm_create (execbuf)
[408.931338] Starting subtest: execbuf
[408.939345] Subtest execbuf: SUCCESS (0.008s)
[409.114679] [062/131] (617s left) gem_softpin (reverse)
[409.201708] Starting subtest: reverse
[409.216078] Subtest reverse: SUCCESS (0.014s)
[409.342181] [063/131] (616s left) core_setmaster_vs_auth
[409.594637] [064/131] (616s left) kms_lease (lessee-list)
[409.789511] Starting subtest: lessee-list
[409.791813] Starting dynamic subtest: pipe-A-DP-3
[409.794152] Dynamic subtest pipe-A-DP-3: SUCCESS (0.002s)
[409.804078] Starting dynamic subtest: pipe-B-DP-3
[409.804846] Dynamic subtest pipe-B-DP-3: SUCCESS (0.002s)
[409.813767] Starting dynamic subtest: pipe-C-DP-3
[409.814613] Dynamic subtest pipe-C-DP-3: SUCCESS (0.002s)
[409.823486] Starting dynamic subtest: pipe-D-DP-3
[409.824566] Dynamic subtest pipe-D-DP-3: SUCCESS (0.002s)
[409.825550] Subtest lessee-list: SUCCESS (0.015s)
[409.936248] [065/131] (616s left) gem_ctx_persistence (legacy-engines-cleanup)
[410.022217] Starting subtest: legacy-engines-cleanup
[410.023102] Starting dynamic subtest: render
[410.130427] Dynamic subtest render: SUCCESS (0.107s)
[410.146900] Starting dynamic subtest: bsd1
[410.171835] Dynamic subtest bsd1: SUCCESS (0.039s)
[410.200920] Starting dynamic subtest: bsd2
[410.202142] Dynamic subtest bsd2: SUCCESS (0.027s)
[410.218797] Starting dynamic subtest: blt
[410.245306] Dynamic subtest blt: SUCCESS (0.041s)
[410.256837] Starting dynamic subtest: vebox
[410.296785] Dynamic subtest vebox: SUCCESS (0.050s)
[410.298448] Subtest legacy-engines-cleanup: SUCCESS (0.276s)
[410.493530] [066/131] (615s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[410.695223] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[410.750369] [067/131] (615s left) gem_fence_thrash (bo-copy)
[410.800122] Starting subtest: bo-copy
[410.832204] Subtest bo-copy: SKIP (0.032s)
[410.899106] [068/131] (615s left) kms_atomic (plane-immutable-zpos)
[411.097477] Starting subtest: plane-immutable-zpos
[411.099905] Starting dynamic subtest: pipe-A-DP-3
[412.030075] Dynamic subtest pipe-A-DP-3: SUCCESS (0.930s)
[412.030989] Subtest plane-immutable-zpos: SUCCESS (0.932s)
[412.288793] [069/131] (614s left) prime_mmap_coherency (ioctl-errors)
[412.376254] Starting subtest: ioctl-errors
[418.255354] Subtest ioctl-errors: SUCCESS (5.879s)
[418.479499] [070/131] (608s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[418.613638] Starting subtest: multi-wait-for-submit-submitted-signaled
[418.614528] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[418.721249] [071/131] (608s left) syncobj_eventfd (invalid-illegal-handle)
[418.801299] Starting subtest: invalid-illegal-handle
[418.802175] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[418.937184] [072/131] (607s left) syncobj_timeline (invalid-wait-illegal-handle)
[419.017287] Starting subtest: invalid-wait-illegal-handle
[419.018234] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[419.185396] [073/131] (607s left) gem_ctx_param (invalid-ctx-set)
[419.265843] Starting subtest: invalid-ctx-set
[419.268165] Subtest invalid-ctx-set: SUCCESS (0.002s)
[419.431496] [074/131] (607s left) kms_pipe_crc_basic (read-crc)
[419.634576] Starting subtest: read-crc
[419.637094] Starting dynamic subtest: pipe-A-DP-3
[420.333144] Dynamic subtest pipe-A-DP-3: SUCCESS (0.697s)
[420.350971] Starting dynamic subtest: pipe-B-DP-3
[420.946389] Dynamic subtest pipe-B-DP-3: SUCCESS (0.608s)
[420.968238] Starting dynamic subtest: pipe-C-DP-3
[421.521218] Dynamic subtest pipe-C-DP-3: SUCCESS (0.571s)
[421.541223] Starting dynamic subtest: pipe-D-DP-3
[422.097524] Dynamic subtest pipe-D-DP-3: SUCCESS (0.573s)
[422.098576] Subtest read-crc: SUCCESS (2.463s)
[422.375351] [075/131] (604s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[424.979750] Starting subtest: verify-pxp-key-change-after-suspend-resume
[424.981427] Subtest verify-pxp-key-change-after-suspend-resume: SKIP (0.000s)
[425.077844] [076/131] (602s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[425.284055] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[425.285576] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[425.439904] [077/131] (601s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[425.640490] Starting subtest: bad-rotation-90-y-tiled-ccs
[425.642932] Starting dynamic subtest: pipe-A-DP-3
[425.651447] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[425.661369] Starting dynamic subtest: pipe-B-DP-3
[425.669872] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[425.679556] Starting dynamic subtest: pipe-C-DP-3
[425.687735] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[425.697413] Starting dynamic subtest: pipe-D-DP-3
[425.707778] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[425.709762] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.007s)
[426.150098] [078/131] (601s left) kms_vrr (flipline)
[426.351483] Starting subtest: flipline
[426.354171] Subtest flipline: SKIP (0.000s)
[426.453208] [079/131] (600s left) vgem_slow (nohang)
[426.514973] Starting subtest: nohang
[436.822138] Subtest nohang: SUCCESS (10.306s)
[436.898543] [080/131] (590s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[437.101524] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[437.104058] Starting dynamic subtest: pipe-A-DP-3
[440.586364] Dynamic subtest pipe-A-DP-3: SUCCESS (3.468s)
[440.600847] Starting dynamic subtest: pipe-B-DP-3
[441.137084] Dynamic subtest pipe-B-DP-3: SUCCESS (0.542s)
[441.161206] Starting dynamic subtest: pipe-C-DP-3
[441.701232] Dynamic subtest pipe-C-DP-3: SUCCESS (0.557s)
[441.728145] Starting dynamic subtest: pipe-D-DP-3
[442.268384] Dynamic subtest pipe-D-DP-3: SUCCESS (0.558s)
[442.270260] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SUCCESS (5.152s)
[442.614109] [081/131] (584s left) i915_drm_fdinfo (most-busy-check-all)
[442.684809] Starting subtest: most-busy-check-all
[442.685710] Starting dynamic subtest: rcs0
[442.714797] Dynamic subtest rcs0: SKIP (0.028s)
[442.724906] Starting dynamic subtest: bcs0
[442.726692] Dynamic subtest bcs0: SKIP (0.001s)
[442.736794] Starting dynamic subtest: vcs0
[442.739168] Dynamic subtest vcs0: SKIP (0.000s)
[442.748787] Starting dynamic subtest: vcs1
[442.750572] Dynamic subtest vcs1: SKIP (0.001s)
[442.760269] Starting dynamic subtest: vecs0
[442.762382] Dynamic subtest vecs0: SKIP (0.000s)
[442.772137] Starting dynamic subtest: vecs1
[442.773979] Dynamic subtest vecs1: SKIP (0.001s)
[442.783367] Starting dynamic subtest: ccs0
[442.785483] Dynamic subtest ccs0: SKIP (0.000s)
[442.787360] Subtest most-busy-check-all: SKIP (0.038s)
[442.833590] [082/131] (584s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[443.075050] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[443.076696] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[443.227255] [083/131] (584s left) gem_exec_schedule (u-submit-early-slice)
[443.322164] Starting subtest: u-submit-early-slice
[443.323133] Starting dynamic subtest: rcs0
[443.405068] Dynamic subtest rcs0: SUCCESS (0.082s)
[443.415317] Starting dynamic subtest: bcs0
[443.461537] Dynamic subtest bcs0: SUCCESS (0.055s)
[443.471793] Starting dynamic subtest: vcs0
[443.520749] Dynamic subtest vcs0: SUCCESS (0.058s)
[443.531069] Starting dynamic subtest: vcs1
[443.582134] Dynamic subtest vcs1: SUCCESS (0.060s)
[443.592873] Starting dynamic subtest: vecs0
[443.641483] Dynamic subtest vecs0: SUCCESS (0.058s)
[443.651667] Starting dynamic subtest: vecs1
[443.695612] Dynamic subtest vecs1: SUCCESS (0.053s)
[443.705555] Starting dynamic subtest: ccs0
[443.752227] Dynamic subtest ccs0: SUCCESS (0.056s)
[443.753102] Subtest u-submit-early-slice: SUCCESS (0.431s)
[444.170437] [084/131] (583s left) kms_properties (get_properties-sanity-non-atomic)
[444.366484] Starting subtest: get_properties-sanity-non-atomic
[444.368934] Subtest get_properties-sanity-non-atomic: SUCCESS (0.002s)
[444.471154] [085/131] (583s left) gem_exec_whisper (basic-normal-all)
[444.561544] Starting subtest: basic-normal-all
[446.764131] Subtest basic-normal-all: SUCCESS (2.201s)
[447.027818] [086/131] (580s left) gem_ctx_shared (exec-shared-gtt)
[447.121411] Starting subtest: exec-shared-gtt
[447.122332] Starting dynamic subtest: rcs0
[447.132133] Dynamic subtest rcs0: SUCCESS (0.010s)
[447.144519] Starting dynamic subtest: bcs0
[447.145449] Dynamic subtest bcs0: SUCCESS (0.006s)
[447.157534] Starting dynamic subtest: vcs0
[447.158400] Dynamic subtest vcs0: SUCCESS (0.006s)
[447.169477] Starting dynamic subtest: vcs1
[447.170378] Dynamic subtest vcs1: SUCCESS (0.008s)
[447.181029] Starting dynamic subtest: vecs0
[447.181953] Dynamic subtest vecs0: SUCCESS (0.006s)
[447.192092] Starting dynamic subtest: vecs1
[447.192940] Dynamic subtest vecs1: SUCCESS (0.007s)
[447.202955] Starting dynamic subtest: ccs0
[447.203935] Dynamic subtest ccs0: SUCCESS (0.006s)
[447.204879] Subtest exec-shared-gtt: SUCCESS (0.058s)
[447.431876] [087/131] (580s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[447.630502] Starting subtest: bad-aux-stride-yf-tiled-ccs
[447.632925] Starting dynamic subtest: pipe-A-DP-3
[447.641083] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[447.651298] Starting dynamic subtest: pipe-B-DP-3
[447.659255] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[447.669433] Starting dynamic subtest: pipe-C-DP-3
[447.677561] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[447.687825] Starting dynamic subtest: pipe-D-DP-3
[447.697899] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[447.700145] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.007s)
[448.100780] [088/131] (579s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[448.600417] Starting subtest: cursor-rapid-movement-512x170
[448.602222] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[448.839358] [089/131] (579s left) gem_pread (exhaustion)
[448.919272] Subtest exhaustion: SKIP (0.000s)
[449.003079] [090/131] (579s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[449.084452] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[449.085413] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[449.227401] [091/131] (578s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[449.436673] Starting subtest: x-tiled-8bpp-rotate-180
[451.067225] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.629s)
[451.275982] [092/131] (577s left) gem_mmap (basic)
[451.362216] Subtest basic: SKIP (0.000s)
[451.427164] [093/131] (576s left) perf_pmu (rc6-all-gts)
[451.502847] Starting subtest: rc6-all-gts
[451.504601] Subtest rc6-all-gts: SKIP (0.000s)
[451.644095] [094/131] (576s left) gem_workarounds (basic-read-context)
[451.740966] Starting subtest: basic-read-context
[451.790074] Subtest basic-read-context: SUCCESS (0.042s)
[451.954895] [095/131] (576s left) gem_madvise (dontneed-after-mmap)
[452.004360] Starting subtest: dontneed-after-mmap
[452.056428] Subtest dontneed-after-mmap: SUCCESS (0.051s)
[452.218369] [096/131] (576s left) kms_color (ctm-max)
[452.412543] Starting subtest: ctm-max
[452.413451] Starting dynamic subtest: pipe-A-DP-3
[453.065743] Dynamic subtest pipe-A-DP-3: SUCCESS (0.650s)
[453.087955] Starting dynamic subtest: pipe-B-DP-3
[453.648252] Dynamic subtest pipe-B-DP-3: SUCCESS (0.582s)
[453.664591] Starting dynamic subtest: pipe-C-DP-3
[454.243358] Dynamic subtest pipe-C-DP-3: SUCCESS (0.594s)
[454.254550] Starting dynamic subtest: pipe-D-DP-3
[454.856018] Dynamic subtest pipe-D-DP-3: SUCCESS (0.610s)
[454.857032] Subtest ctm-max: SUCCESS (2.442s)
[455.104505] [097/131] (573s left) api_intel_bb (blit-reloc-purge-cache)
[455.183641] Starting subtest: blit-reloc-purge-cache
[455.185454] Subtest blit-reloc-purge-cache: SKIP (0.001s)
[455.355452] [098/131] (573s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[455.558969] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[455.560632] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[455.712284] [099/131] (573s left) kms_cursor_edge_walk (256x256-top-edge)
[455.911543] Starting subtest: 256x256-top-edge
[455.913979] Starting dynamic subtest: pipe-A-DP-3
[459.414913] Dynamic subtest pipe-A-DP-3: SUCCESS (3.502s)
[459.430398] Starting dynamic subtest: pipe-D-DP-3
[462.780433] Dynamic subtest pipe-D-DP-3: SUCCESS (3.363s)
[462.781391] Subtest 256x256-top-edge: SUCCESS (6.869s)
[463.022604] [100/131] (565s left) gem_userptr_blits (sync-unmap-after-close)
[463.113983] Starting subtest: sync-unmap-after-close
[463.134644] Subtest sync-unmap-after-close: SUCCESS (0.021s)
[463.327228] [101/131] (565s left) kms_psr (fbc-pr-sprite-plane-onoff)
[463.526126] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[463.583409] [102/131] (565s left) i915_pm_rps (thresholds-idle)
[463.678998] Starting subtest: thresholds-idle
[463.680904] Subtest thresholds-idle: SKIP (0.001s)
[463.773763] [103/131] (565s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[463.983262] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[465.339244] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.355s)
[465.499954] [104/131] (563s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[465.723282] Starting subtest: extended-modeset-hang-newfb-with-reset
[465.724196] Starting dynamic subtest: pipe-A
[486.868292] Dynamic subtest pipe-A: SUCCESS (21.142s)
[486.906456] Starting dynamic subtest: pipe-D
[507.813601] Dynamic subtest pipe-D: SUCCESS (20.933s)
[507.818253] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (42.091s)
[508.077725] [105/131] (521s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[508.277121] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[508.278800] Subtest fbcpsr-rgb101010-draw-pwrite: SKIP (0.000s)
[508.428404] [106/131] (520s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[508.638033] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[508.639695] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[508.798662] [107/131] (520s left) gem_userptr_blits (invalid-null-pointer)
[508.886450] Starting subtest: invalid-null-pointer
[508.887293] Subtest invalid-null-pointer: SUCCESS (0.001s)
[509.073337] [108/131] (520s left) gem_exec_schedule (fifo)
[509.163770] Starting subtest: fifo
[509.164614] Starting dynamic subtest: rcs0
[509.444528] Dynamic subtest rcs0: SUCCESS (0.280s)
[509.455712] Starting dynamic subtest: bcs0
[509.642052] Dynamic subtest bcs0: SUCCESS (0.196s)
[509.653311] Starting dynamic subtest: vcs0
[509.850912] Dynamic subtest vcs0: SUCCESS (0.208s)
[509.862208] Starting dynamic subtest: vcs1
[510.060914] Dynamic subtest vcs1: SUCCESS (0.209s)
[510.072220] Starting dynamic subtest: vecs0
[510.274130] Dynamic subtest vecs0: SUCCESS (0.212s)
[510.285435] Starting dynamic subtest: vecs1
[510.487452] Dynamic subtest vecs1: SUCCESS (0.212s)
[510.498638] Starting dynamic subtest: ccs0
[510.696766] Dynamic subtest ccs0: SUCCESS (0.208s)
[510.697719] Subtest fifo: SUCCESS (1.533s)
[511.157517] [109/131] (518s left) gem_lmem_swapping (verify-ccs)
[514.021430] Starting subtest: verify-ccs
[514.022287] Starting dynamic subtest: lmem0
[554.486879] Dynamic subtest lmem0: SUCCESS (40.465s)
[554.487795] Subtest verify-ccs: SUCCESS (40.466s)
[556.837492] [FACT gem_lmem_swapping (verify-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[556.838463] [FACT gem_lmem_swapping (verify-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[556.840429] [110/131] (472s left) syncobj_wait (multi-wait-submitted)
[558.463497] Starting subtest: multi-wait-submitted
[558.574349] Subtest multi-wait-submitted: SUCCESS (0.109s)
[558.663682] [FACT syncobj_wait (multi-wait-submitted)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[558.666311] [FACT syncobj_wait (multi-wait-submitted)] new: kernel.kmod_is_loaded.i915: true
[558.669239] [111/131] (470s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[558.872282] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[558.873975] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[559.029755] [112/131] (470s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[559.227633] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[559.228541] Starting dynamic subtest: pipe-A
[559.623125] Dynamic subtest pipe-A: SUCCESS (0.395s)
[559.641497] Starting dynamic subtest: pipe-B
[560.107070] Dynamic subtest pipe-B: SUCCESS (0.482s)
[560.129158] Starting dynamic subtest: pipe-C
[560.606849] Dynamic subtest pipe-C: SUCCESS (0.497s)
[560.632638] Starting dynamic subtest: pipe-D
[561.091016] Dynamic subtest pipe-D: SUCCESS (0.482s)
[561.092199] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (1.864s)
[561.424858] [113/131] (468s left) kms_pm_rpm (basic-rte)
[561.474767] Starting subtest: basic-rte
[563.702110] Subtest basic-rte: SUCCESS (2.228s)
[564.378106] [114/131] (465s left) core_setmaster (master-drop-set-shared-fd)
[564.512424] Starting subtest: master-drop-set-shared-fd
[564.544270] Subtest master-drop-set-shared-fd: SUCCESS (0.033s)
[564.593118] [115/131] (465s left) gem_exec_create (forked)
[564.687696] Starting subtest: forked
[564.688588] Starting dynamic subtest: smem
[584.835016] Dynamic subtest smem: SUCCESS (20.146s)
[584.856569] Starting dynamic subtest: lmem0
[604.988245] Dynamic subtest lmem0: SUCCESS (20.151s)
[604.989261] Subtest forked: SUCCESS (40.301s)
[605.242144] [116/131] (424s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[605.444040] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[605.445727] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[605.596210] [117/131] (424s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[605.794151] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[605.795911] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[605.963947] [118/131] (424s left) gem_exec_fence (parallel)
[606.179500] Starting subtest: parallel
[606.184116] Starting dynamic subtest: rcs0
[608.335502] Dynamic subtest rcs0: SUCCESS (2.155s)
[608.346788] Starting dynamic subtest: bcs0
[610.485996] Dynamic subtest bcs0: SUCCESS (2.149s)
[610.496401] Starting dynamic subtest: vcs0
[612.641366] Dynamic subtest vcs0: SUCCESS (2.154s)
[612.651756] Starting dynamic subtest: vcs1
[614.795967] Dynamic subtest vcs1: SUCCESS (2.153s)
[614.806280] Starting dynamic subtest: vecs0
[616.952246] Dynamic subtest vecs0: SUCCESS (2.155s)
[616.964250] Starting dynamic subtest: vecs1
[619.106847] Dynamic subtest vecs1: SUCCESS (2.154s)
[619.118644] Starting dynamic subtest: ccs0
[621.257362] Dynamic subtest ccs0: SUCCESS (2.149s)
[621.258352] Subtest parallel: SUCCESS (15.079s)
[622.017407] [119/131] (408s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[622.097453] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[622.098464] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[622.246685] [120/131] (408s left) kms_flip (2x-flip-vs-panning-interruptible)
[622.458178] Starting subtest: 2x-flip-vs-panning-interruptible
[622.473918] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.015s)
[622.567152] [121/131] (407s left) gem_ctx_isolation (dirty-create)
[622.659452] Starting subtest: dirty-create
[622.660401] Starting dynamic subtest: rcs0
[623.271538] Dynamic subtest rcs0: SUCCESS (0.612s)
[623.282363] Starting dynamic subtest: bcs0
[623.944278] Dynamic subtest bcs0: SUCCESS (0.672s)
[623.954753] Starting dynamic subtest: vcs0
[624.585078] Dynamic subtest vcs0: SUCCESS (0.640s)
[624.596078] Starting dynamic subtest: vcs1
[625.250447] Dynamic subtest vcs1: SUCCESS (0.664s)
[625.260974] Starting dynamic subtest: vecs0
[625.897629] Dynamic subtest vecs0: SUCCESS (0.646s)
[625.908299] Starting dynamic subtest: vecs1
[626.586365] Dynamic subtest vecs1: SUCCESS (0.688s)
[626.596868] Starting dynamic subtest: ccs0
[627.250413] Dynamic subtest ccs0: SUCCESS (0.663s)
[627.251373] Subtest dirty-create: SUCCESS (4.591s)
[627.530141] [122/131] (402s left) gem_bad_reloc (negative-reloc)
[627.616948] Subtest negative-reloc: SKIP (0.000s)
[627.692844] [123/131] (402s left) kms_psr (psr2-suspend)
[627.890120] Subtest psr2-suspend: SKIP (0.000s)
[627.942875] [124/131] (402s left) kms_dsc (dsc-basic)
[628.138647] Starting subtest: dsc-basic
[628.143722] Subtest dsc-basic: SKIP (0.001s)
[628.234229] [125/131] (402s left) kms_chamelium_hpd (dp-hpd)
[628.509730] Subtest dp-hpd: SKIP (0.000s)
[628.666037] [126/131] (402s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[628.868088] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[631.506615] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (2.638s)
[631.726592] [127/131] (399s left) gen9_exec_parse (shadow-peek)
[631.813471] Subtest shadow-peek: SKIP (0.000s)
[631.924395] [128/131] (398s left) kms_atomic_transition (modeset-transition-nonblocking)
[632.122659] Starting subtest: modeset-transition-nonblocking
[632.123495] Starting dynamic subtest: 1x-outputs
[634.682694] Dynamic subtest 1x-outputs: SUCCESS (2.558s)
[634.738531] Subtest modeset-transition-nonblocking: SUCCESS (2.615s)
[635.002818] [129/131] (395s left) drm_read (short-buffer-block)
[635.276763] Starting subtest: short-buffer-block
[635.277776] Subtest short-buffer-block: SUCCESS (0.000s)
[635.495086] [130/131] (395s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[635.699151] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[635.700916] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[635.837436] [131/131] (395s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[636.039173] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[636.054773] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.015s)
[636.179248] 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.