[150.193382] Initializing watchdogs
[150.193447]   /dev/watchdog0
[150.213050] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[150.223772] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[150.227732] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[150.230030] [001/134] (960s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[150.305502] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[150.413439] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.107s)
[150.560454] [002/134] (960s left) gem_exec_create (madvise)
[150.642141] Starting subtest: madvise
[150.643105] Starting dynamic subtest: smem
[170.782363] Dynamic subtest smem: SUCCESS (20.140s)
[170.790501] Starting dynamic subtest: lmem0
[191.078974] Dynamic subtest lmem0: SUCCESS (20.296s)
[191.080117] Subtest madvise: SUCCESS (40.437s)
[192.234186] [003/134] (918s left) kms_psr (pr-primary-mmap-cpu)
[192.411859] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[192.459057] [004/134] (918s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[192.635128] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[192.637882] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.002s)
[192.784821] [005/134] (918s left) gem_mmap_gtt (big-bo-tiledy)
[192.853982] Subtest big-bo-tiledY: SKIP (0.000s)
[192.933933] [006/134] (918s left) gem_userptr_blits (process-exit)
[193.017475] Starting subtest: process-exit
[193.026482] Subtest process-exit: SUCCESS (0.009s)
[193.212245] [007/134] (917s left) i915_suspend (basic-s2idle-without-i915)
[193.253783] Starting subtest: basic-s2idle-without-i915
[212.245987] Subtest basic-s2idle-without-i915: SUCCESS (3.833s)
[212.374009] [008/134] (898s left) kms_hdr (bpc-switch)
[212.583471] Starting subtest: bpc-switch
[215.876999] Starting dynamic subtest: pipe-A-DP-3
[216.950423] Dynamic subtest pipe-A-DP-3: SUCCESS (1.077s)
[216.951822] Subtest bpc-switch: SUCCESS (4.389s)
[217.339561] [009/134] (893s left) gem_softpin (full)
[217.418345] Starting subtest: full
[217.435611] Subtest full: SUCCESS (0.017s)
[217.657236] [010/134] (893s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[217.830910] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[217.831775] Starting dynamic subtest: pipe-A-DP-3
[217.839976] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[217.849083] Starting dynamic subtest: pipe-B-DP-3
[217.857317] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[217.866374] Starting dynamic subtest: pipe-C-DP-3
[217.874307] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[217.883126] Starting dynamic subtest: pipe-D-DP-3
[217.892356] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[217.894357] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SKIP (0.004s)
[218.325530] [011/134] (893s left) kms_psr (fbc-psr-cursor-blt)
[218.509534] Subtest fbc-psr-cursor-blt: SKIP (0.000s)
[218.571819] [012/134] (892s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[218.755559] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[218.757274] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[218.972387] [013/134] (892s left) gem_lmem_swapping (verify-random)
[221.605084] Starting subtest: verify-random
[221.606023] Starting dynamic subtest: lmem0
[230.572362] Dynamic subtest lmem0: SUCCESS (8.982s)
[230.573312] Subtest verify-random: SUCCESS (8.982s)
[231.628524] [FACT gem_lmem_swapping (verify-random)] deleted: kernel.kmod_is_loaded.i915: true
[231.630099] [014/134] (879s left) prime_vgem (coherency-blt)
[233.240216] Starting subtest: coherency-blt
[235.543227] Subtest coherency-blt: SUCCESS (2.308s)
[235.637740] [FACT prime_vgem (coherency-blt)] changed: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 -> card1
[235.640023] [FACT prime_vgem (coherency-blt)] new: kernel.kmod_is_loaded.i915: true
[235.640607] [FACT prime_vgem (coherency-blt)] new: kernel.kmod_is_loaded.vgem: true
[235.642757] [015/134] (875s left) kms_flip_scaled_crc (flip-32bpp-linear-to-32bpp-linear-reflect-x)
[235.829585] Starting subtest: flip-32bpp-linear-to-32bpp-linear-reflect-x
[235.830506] Starting dynamic subtest: pipe-A-valid-mode
[236.413106] Dynamic subtest pipe-A-valid-mode: SKIP (0.581s)
[236.415307] Subtest flip-32bpp-linear-to-32bpp-linear-reflect-x: SKIP (0.582s)
[237.003167] [016/134] (874s left) syncobj_wait (reset-signaled)
[237.082939] Starting subtest: reset-signaled
[237.084096] Subtest reset-signaled: SUCCESS (0.000s)
[237.261937] [017/134] (874s left) gem_exec_whisper (basic-contexts-forked)
[237.354491] Starting subtest: basic-contexts-forked
[259.868507] Subtest basic-contexts-forked: SUCCESS (22.525s)
[260.114505] [018/134] (851s left) gem_pxp (reject-modify-context-protection-off-1)
[262.723285] Starting subtest: reject-modify-context-protection-off-1
[262.725503] Subtest reject-modify-context-protection-off-1: SKIP (0.000s)
[262.866744] [019/134] (849s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[263.053441] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[263.055068] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[263.254706] [020/134] (848s left) kms_chamelium_frames (hdmi-crc-single)
[263.512619] Subtest hdmi-crc-single: SKIP (0.000s)
[263.659795] [021/134] (848s left) i915_pm_freq_api (freq-basic-api)
[263.744647] Starting subtest: freq-basic-api
[263.745581] Starting dynamic subtest: gt0
[263.748497] Dynamic subtest gt0: SUCCESS (0.004s)
[263.749384] Subtest freq-basic-api: SUCCESS (0.004s)
[263.874093] [022/134] (848s left) syncobj_wait (single-wait-all-submitted)
[263.960118] Starting subtest: single-wait-all-submitted
[264.062401] Subtest single-wait-all-submitted: SUCCESS (0.102s)
[264.197767] [023/134] (847s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[264.282466] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[264.284469] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[264.506528] [024/134] (847s left) gem_close_race (multigpu-basic-process)
[264.627609] Starting subtest: multigpu-basic-process
[264.629595] Subtest multigpu-basic-process: SKIP (0.000s)
[264.934733] [025/134] (847s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[265.126589] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[265.128246] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[265.319313] [026/134] (847s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[265.507215] Starting subtest: plane-downscale-factor-0-75-with-rotation
[265.508077] Starting dynamic subtest: pipe-A
[265.902029] Dynamic subtest pipe-A: SUCCESS (0.395s)
[265.925596] Starting dynamic subtest: pipe-B
[266.381331] Dynamic subtest pipe-B: SUCCESS (0.479s)
[266.396752] Starting dynamic subtest: pipe-C
[266.844562] Dynamic subtest pipe-C: SUCCESS (0.463s)
[266.858904] Starting dynamic subtest: pipe-D
[267.308429] Dynamic subtest pipe-D: SUCCESS (0.463s)
[267.309407] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (1.802s)
[267.673437] [027/134] (844s left) kms_psr (psr-primary-blt)
[267.860566] Subtest psr-primary-blt: SKIP (0.000s)
[267.912823] [028/134] (844s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[268.102633] Starting subtest: fbcpsr-shrfb-scaledprimary
[268.104323] Subtest fbcpsr-shrfb-scaledprimary: SKIP (0.000s)
[268.303733] [029/134] (844s left) gem_exec_fence (basic-busy-all)
[268.384918] Starting subtest: basic-busy-all
[268.472625] Subtest basic-busy-all: SUCCESS (0.088s)
[269.284814] [030/134] (843s left) kms_lease (setcrtc-implicit-plane)
[269.468628] Starting subtest: setcrtc-implicit-plane
[269.469513] Starting dynamic subtest: pipe-A-DP-3
[269.866343] Dynamic subtest pipe-A-DP-3: SUCCESS (0.397s)
[269.887933] Starting dynamic subtest: pipe-B-DP-3
[270.195505] Dynamic subtest pipe-B-DP-3: SUCCESS (0.327s)
[270.206027] Starting dynamic subtest: pipe-C-DP-3
[270.497928] Dynamic subtest pipe-C-DP-3: SUCCESS (0.301s)
[270.508644] Starting dynamic subtest: pipe-D-DP-3
[270.804252] Dynamic subtest pipe-D-DP-3: SUCCESS (0.305s)
[270.805356] Subtest setcrtc-implicit-plane: SUCCESS (1.336s)
[271.107637] [031/134] (841s left) kms_dirtyfb (default-dirtyfb-ioctl)
[271.288936] Starting subtest: default-dirtyfb-ioctl
[271.289779] Starting dynamic subtest: A-DP-3
[272.762884] Dynamic subtest A-DP-3: SUCCESS (1.473s)
[272.763722] Subtest default-dirtyfb-ioctl: SUCCESS (1.475s)
[273.069959] [032/134] (839s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[273.146190] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[273.212811] [033/134] (839s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[273.409605] Starting subtest: yf-tiled-64bpp-rotate-90
[273.411300] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[273.573703] [034/134] (839s left) gem_exec_schedule (smoketest)
[273.779811] Starting subtest: smoketest
[273.780675] Starting dynamic subtest: rcs0
[279.243299] Dynamic subtest rcs0: SUCCESS (5.459s)
[279.255039] Starting dynamic subtest: bcs0
[284.694952] Dynamic subtest bcs0: SUCCESS (5.454s)
[284.706181] Starting dynamic subtest: vcs0
[290.146228] Dynamic subtest vcs0: SUCCESS (5.453s)
[290.156953] Starting dynamic subtest: vcs1
[295.601007] Dynamic subtest vcs1: SUCCESS (5.458s)
[295.614042] Starting dynamic subtest: vecs0
[301.058833] Dynamic subtest vecs0: SUCCESS (5.459s)
[301.069407] Starting dynamic subtest: vecs1
[306.510432] Dynamic subtest vecs1: SUCCESS (5.453s)
[306.521782] Starting dynamic subtest: ccs0
[311.981013] Dynamic subtest ccs0: SUCCESS (5.455s)
[311.982047] Subtest smoketest: SUCCESS (38.195s)
[312.314137] [035/134] (800s left) prime_mmap (test_reprime)
[312.389591] Starting subtest: test_reprime
[312.390463] Starting dynamic subtest: test_reprime-smem
[312.435452] Dynamic subtest test_reprime-smem: SUCCESS (0.045s)
[312.445517] Starting dynamic subtest: test_reprime-lmem0
[312.629212] Dynamic subtest test_reprime-lmem0: SUCCESS (0.192s)
[312.630292] Subtest test_reprime: SUCCESS (0.239s)
[312.759268] [036/134] (800s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[312.946523] Starting subtest: addfb25-y-tiled-small-legacy
[312.948298] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[313.138126] [037/134] (800s left) gem_eio (in-flight-internal-10ms)
[313.494191] Starting subtest: in-flight-internal-10ms
[315.066149] Subtest in-flight-internal-10ms: SUCCESS (1.569s)
[315.355798] [038/134] (797s left) gem_exec_reloc (basic-wc-noreloc)
[315.443104] Subtest basic-wc-noreloc: SKIP (0.000s)
[315.523293] [039/134] (797s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[315.711783] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[315.713431] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[315.911793] [040/134] (797s left) kms_vblank (ts-continuation-suspend)
[316.097734] Starting subtest: ts-continuation-suspend
[316.099667] Starting dynamic subtest: pipe-A-DP-3
[335.567117] Dynamic subtest pipe-A-DP-3: SUCCESS (4.091s)
[335.581781] Starting dynamic subtest: pipe-D-DP-3
[355.535434] Dynamic subtest pipe-D-DP-3: SUCCESS (3.870s)
[355.536394] Subtest ts-continuation-suspend: SUCCESS (7.965s)
[355.741587] [041/134] (757s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[355.935226] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[355.950662] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.015s)
[356.080010] [042/134] (757s left) kms_flip (dpms-off-confusion-interruptible)
[356.267853] Starting subtest: dpms-off-confusion-interruptible
[356.272426] Starting dynamic subtest: A-DP3
[364.072449] Dynamic subtest A-DP3: SUCCESS (7.798s)
[364.087250] Starting dynamic subtest: B-DP3
[371.841934] Dynamic subtest B-DP3: SUCCESS (7.768s)
[371.882671] Starting dynamic subtest: C-DP3
[379.617850] Dynamic subtest C-DP3: SUCCESS (7.773s)
[379.662267] Starting dynamic subtest: D-DP3
[387.412739] Dynamic subtest D-DP3: SUCCESS (7.792s)
[387.418014] Subtest dpms-off-confusion-interruptible: SUCCESS (31.150s)
[387.777198] [043/134] (725s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[387.962336] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[391.155007] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (3.191s)
[391.466360] [044/134] (722s left) syncobj_timeline (invalid-query-illegal-handle)
[391.543671] Starting subtest: invalid-query-illegal-handle
[391.544669] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[391.692188] [045/134] (722s left) gem_mmap_wc (pf-nonblock)
[391.772593] Subtest pf-nonblock: SKIP (0.000s)
[391.854974] [046/134] (721s left) gem_exec_schedule (preempt)
[391.954058] Starting subtest: preempt
[391.954982] Starting dynamic subtest: rcs0
[392.022760] Dynamic subtest rcs0: SUCCESS (0.068s)
[392.034908] Starting dynamic subtest: bcs0
[392.058013] Dynamic subtest bcs0: SUCCESS (0.034s)
[392.070023] Starting dynamic subtest: vcs0
[392.092791] Dynamic subtest vcs0: SUCCESS (0.034s)
[392.104846] Starting dynamic subtest: vcs1
[392.127252] Dynamic subtest vcs1: SUCCESS (0.033s)
[392.139620] Starting dynamic subtest: vecs0
[392.162764] Dynamic subtest vecs0: SUCCESS (0.035s)
[392.176503] Starting dynamic subtest: vecs1
[392.197812] Dynamic subtest vecs1: SUCCESS (0.034s)
[392.211266] Starting dynamic subtest: ccs0
[392.239254] Dynamic subtest ccs0: SUCCESS (0.040s)
[392.240046] Subtest preempt: SUCCESS (0.286s)
[392.717792] [047/134] (721s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[392.795741] Starting subtest: etime-single-wait-for-submit-unsubmitted
[392.901249] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.104s)
[393.077312] [048/134] (720s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[393.261355] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[393.263524] Starting dynamic subtest: pipe-A-DP-3
[393.271761] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[393.283765] Starting dynamic subtest: pipe-B-DP-3
[393.292201] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[393.304042] Starting dynamic subtest: pipe-C-DP-3
[393.312280] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[393.324237] Starting dynamic subtest: pipe-D-DP-3
[393.334250] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[393.336238] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SKIP (0.007s)
[393.757031] [049/134] (720s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[393.947752] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[393.949949] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[394.141824] [050/134] (720s left) i915_drm_fdinfo (memory-info-idle)
[394.211707] Starting subtest: memory-info-idle
[394.212654] Starting dynamic subtest: lmem0
[394.299661] Dynamic subtest lmem0: SUCCESS (0.087s)
[394.317052] Starting dynamic subtest: smem0
[394.355428] Dynamic subtest smem0: SUCCESS (0.054s)
[394.356578] Subtest memory-info-idle: SUCCESS (0.144s)
[394.520821] [051/134] (719s left) gem_exec_params (larger-than-life-batch)
[394.602927] Starting subtest: larger-than-life-batch
[404.484868] Subtest larger-than-life-batch: SUCCESS (9.881s)
[404.999262] [052/134] (709s left) kms_chamelium_color (ctm-0-25)
[405.233897] Subtest ctm-0-25: SKIP (0.000s)
[405.298293] [053/134] (709s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[405.486000] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[405.488070] Starting dynamic subtest: pipe-A-valid-mode
[405.563051] Dynamic subtest pipe-A-valid-mode: SKIP (0.074s)
[405.564738] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.076s)
[405.760342] [054/134] (708s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[405.851518] Subtest writes-after-reads: SKIP (0.000s)
[405.942039] [055/134] (708s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[406.139310] Starting subtest: plane-lut1d-ctm3x4
[406.162789] Starting dynamic subtest: pipe-A-DP-3
[406.560912] Dynamic subtest pipe-A-DP-3: SUCCESS (0.399s)
[406.762386] Starting dynamic subtest: pipe-B-DP-3
[407.099249] Dynamic subtest pipe-B-DP-3: SUCCESS (0.348s)
[407.303759] Starting dynamic subtest: pipe-C-DP-3
[407.636432] Dynamic subtest pipe-C-DP-3: SUCCESS (0.348s)
[407.852616] Starting dynamic subtest: pipe-D-DP-3
[408.188048] Dynamic subtest pipe-D-DP-3: SUCCESS (0.348s)
[408.264071] Subtest plane-lut1d-ctm3x4: SUCCESS (2.123s)
[408.545065] [056/134] (705s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[408.738550] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[408.740348] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[408.929155] [057/134] (705s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[409.123346] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[409.125043] Subtest psr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[409.329336] [058/134] (705s left) perf_pmu (busy-no-semaphores)
[409.398692] Starting subtest: busy-no-semaphores
[409.399676] Starting dynamic subtest: rcs0
[409.977097] Dynamic subtest rcs0: SUCCESS (0.577s)
[409.996644] Starting dynamic subtest: bcs0
[410.531147] Dynamic subtest bcs0: SUCCESS (0.549s)
[410.550678] Starting dynamic subtest: vcs0
[411.086542] Dynamic subtest vcs0: SUCCESS (0.550s)
[411.106709] Starting dynamic subtest: vcs1
[411.640786] Dynamic subtest vcs1: SUCCESS (0.550s)
[411.658007] Starting dynamic subtest: vecs0
[412.193887] Dynamic subtest vecs0: SUCCESS (0.549s)
[412.213525] Starting dynamic subtest: vecs1
[412.748146] Dynamic subtest vecs1: SUCCESS (0.549s)
[412.767826] Starting dynamic subtest: ccs0
[413.304862] Dynamic subtest ccs0: SUCCESS (0.552s)
[413.309159] Subtest busy-no-semaphores: SUCCESS (3.908s)
[413.479558] [059/134] (701s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[413.667517] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[413.669340] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[413.875596] [060/134] (700s left) kms_atomic (plane-invalid-params)
[414.059891] Starting subtest: plane-invalid-params
[414.060751] Starting dynamic subtest: pipe-A-DP-3
[414.920512] Dynamic subtest pipe-A-DP-3: SUCCESS (0.860s)
[414.921613] Subtest plane-invalid-params: SUCCESS (0.862s)
[415.245380] [061/134] (699s left) kms_invalid_mode (bad-vsync-end)
[415.430862] Starting subtest: bad-vsync-end
[415.431723] Starting dynamic subtest: pipe-A-DP-3
[415.518389] Dynamic subtest pipe-A-DP-3: SUCCESS (0.086s)
[415.540376] Starting dynamic subtest: pipe-B-DP-3
[415.541493] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[415.560384] Starting dynamic subtest: pipe-C-DP-3
[415.561377] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[415.575279] Starting dynamic subtest: pipe-D-DP-3
[415.576198] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[415.577052] Subtest bad-vsync-end: SUCCESS (0.099s)
[415.810359] [062/134] (699s left) gem_exec_balancer (busy)
[415.899139] Starting subtest: busy
[416.757899] Subtest busy: SUCCESS (0.859s)
[417.173852] [063/134] (697s left) api_intel_bb (object-noreloc-purge-cache-simple)
[417.250967] Starting subtest: object-noreloc-purge-cache-simple
[417.281029] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.031s)
[417.500336] [064/134] (697s left) kms_big_fb (linear-64bpp-rotate-270)
[417.698484] Starting subtest: linear-64bpp-rotate-270
[417.755089] Subtest linear-64bpp-rotate-270: SKIP (0.056s)
[417.988863] [065/134] (697s left) kms_prime (basic-modeset-hybrid)
[418.188638] Subtest basic-modeset-hybrid: SKIP (0.000s)
[418.389390] [066/134] (696s left) gem_ctx_sseu (engines)
[418.491612] Subtest engines: SKIP (0.000s)
[418.584975] [067/134] (696s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[420.700392] Starting subtest: dpms-mode-unset-lpsp
[421.104681] Subtest dpms-mode-unset-lpsp: SKIP (0.403s)
[421.521365] [068/134] (693s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[421.706858] Starting subtest: basic-flip-after-cursor-legacy
[422.740955] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.034s)
[423.067882] [069/134] (692s left) gem_mmap_gtt (basic-read)
[423.146707] Subtest basic-read: SKIP (0.000s)
[423.230431] [070/134] (692s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[423.310096] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[423.412243] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.101s)
[423.588616] [071/134] (692s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[423.777628] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[423.779382] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[423.984053] [072/134] (691s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[424.164856] Starting subtest: cursorB-vs-flipA-atomic-transitions
[424.166517] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.002s)
[424.338018] [073/134] (691s left) perf (non-zero-reason)
[424.769850] Starting subtest: non-zero-reason
[424.770702] Starting dynamic subtest: 0-rcs0
[427.883577] Dynamic subtest 0-rcs0: FAIL (2.784s)
[427.885302] Subtest non-zero-reason: FAIL (2.786s)
[427.964430] [074/134] (688s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[428.153906] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[428.179461] Starting dynamic subtest: pipe-A-plane-0
[428.181218] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[428.195106] Starting dynamic subtest: pipe-A-plane-3
[428.196797] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[428.210584] Starting dynamic subtest: pipe-A-plane-5
[428.212360] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[428.417427] Starting dynamic subtest: pipe-B-plane-0
[428.419773] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[428.443047] Starting dynamic subtest: pipe-B-plane-3
[428.445318] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[428.459341] Starting dynamic subtest: pipe-B-plane-5
[428.461368] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[428.480361] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.326s)
[428.756641] [075/134] (687s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[428.843977] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[428.917976] [076/134] (687s left) core_setmaster (master-drop-set-shared-fd)
[429.088809] Starting subtest: master-drop-set-shared-fd
[429.120725] Subtest master-drop-set-shared-fd: SUCCESS (0.033s)
[429.171534] [077/134] (687s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-blt)
[429.360595] Starting subtest: fbcpsr-abgr161616f-draw-blt
[429.362393] Subtest fbcpsr-abgr161616f-draw-blt: SKIP (0.000s)
[429.531340] [078/134] (686s left) kms_addfb_basic (clobberred-modifier)
[429.629128] Starting subtest: clobberred-modifier
[429.630887] Subtest clobberred-modifier: SKIP (0.000s)
[429.916875] [079/134] (686s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[430.107676] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[430.108455] Starting dynamic subtest: pipe-A
[430.203873] Dynamic subtest pipe-A: SUCCESS (0.096s)
[430.236733] Starting dynamic subtest: pipe-B
[430.433030] Dynamic subtest pipe-B: SUCCESS (0.227s)
[430.454617] Starting dynamic subtest: pipe-C
[430.647840] Dynamic subtest pipe-C: SUCCESS (0.213s)
[430.667018] Starting dynamic subtest: pipe-D
[430.844290] Dynamic subtest pipe-D: SUCCESS (0.195s)
[430.845322] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (0.738s)
[431.177799] [080/134] (685s left) gem_busy (close-race)
[431.265774] Starting subtest: close-race
[453.222354] Subtest close-race: SUCCESS (21.958s)
[453.794236] [081/134] (662s left) kms_psr (fbc-psr2-cursor-render)
[454.030907] Subtest fbc-psr2-cursor-render: SKIP (0.000s)
[454.092394] [082/134] (662s left) kms_cursor_crc (cursor-onscreen-64x64)
[454.425950] Starting subtest: cursor-onscreen-64x64
[454.430990] Starting dynamic subtest: pipe-A-DP-3
[457.237138] Dynamic subtest pipe-A-DP-3: SUCCESS (2.806s)
[457.277954] Starting dynamic subtest: pipe-D-DP-3
[460.023852] Dynamic subtest pipe-D-DP-3: SUCCESS (2.757s)
[460.024947] Subtest cursor-onscreen-64x64: SUCCESS (5.596s)
[460.551240] [083/134] (656s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[460.741424] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[460.743236] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[460.906901] [084/134] (655s left) gem_exec_endless (dispatch)
[461.005264] Starting subtest: dispatch
[461.006198] Starting dynamic subtest: rcs0
[461.015717] Dynamic subtest rcs0: SUCCESS (0.010s)
[461.032598] Starting dynamic subtest: bcs0
[461.034609] Dynamic subtest bcs0: SUCCESS (0.006s)
[461.048927] Starting dynamic subtest: vcs0
[461.050691] Dynamic subtest vcs0: SUCCESS (0.006s)
[461.065125] Starting dynamic subtest: vcs1
[461.066852] Dynamic subtest vcs1: SUCCESS (0.006s)
[461.081867] Starting dynamic subtest: vecs0
[461.083637] Dynamic subtest vecs0: SUCCESS (0.006s)
[461.097701] Starting dynamic subtest: vecs1
[461.099856] Dynamic subtest vecs1: SUCCESS (0.008s)
[461.113684] Starting dynamic subtest: ccs0
[461.116008] Dynamic subtest ccs0: SUCCESS (0.006s)
[461.117236] Subtest dispatch: SUCCESS (0.059s)
[461.266956] [085/134] (655s left) kms_plane_alpha_blend (constant-alpha-max)
[461.451900] Starting subtest: constant-alpha-max
[461.701146] Starting dynamic subtest: pipe-A-DP-3
[462.638382] Dynamic subtest pipe-A-DP-3: SUCCESS (0.937s)
[462.653887] Starting dynamic subtest: pipe-D-DP-3
[463.597428] Dynamic subtest pipe-D-DP-3: SUCCESS (0.957s)
[463.598432] Subtest constant-alpha-max: SUCCESS (2.146s)
[463.848385] [086/134] (653s left) kms_feature_discovery (display-2x)
[464.033384] Starting subtest: display-2x
[464.035208] Subtest display-2x: SKIP (0.000s)
[464.209883] [087/134] (652s left) sw_sync (timeline_closed)
[464.262883] Starting subtest: timeline_closed
[464.263833] Subtest timeline_closed: SUCCESS (0.000s)
[464.415568] [088/134] (652s left) sw_sync (sync_multi_consumer)
[464.464000] Starting subtest: sync_multi_consumer
[464.787279] Subtest sync_multi_consumer: SUCCESS (0.324s)
[464.878479] [089/134] (652s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[464.955674] Subtest invalidate-primary-flip-overlay: SKIP (0.000s)
[465.022114] [090/134] (652s left) kms_selftest (drm_format)
[465.078330] Starting subtest: drm_format
[465.129379] Starting dynamic subtest: drm_test_format_block_width_invalid
[465.220010] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.090s)
[465.265003] Starting dynamic subtest: drm_test_format_block_width_one_plane
[465.300020] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.076s)
[465.321364] Starting dynamic subtest: drm_test_format_block_width_two_plane
[465.403921] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.102s)
[465.419263] Starting dynamic subtest: drm_test_format_block_width_three_plane
[465.497828] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.091s)
[465.547634] Starting dynamic subtest: drm_test_format_block_width_tiled
[465.583183] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.081s)
[465.604703] Starting dynamic subtest: drm_test_format_block_height_invalid
[465.654764] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.070s)
[465.701989] Starting dynamic subtest: drm_test_format_block_height_one_plane
[465.733981] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.076s)
[465.752043] Starting dynamic subtest: drm_test_format_block_height_two_plane
[465.811842] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.076s)
[465.859015] Starting dynamic subtest: drm_test_format_block_height_three_plane
[465.896156] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.081s)
[465.918025] Starting dynamic subtest: drm_test_format_block_height_tiled
[465.990742] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.092s)
[466.008705] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[466.076911] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.081s)
[466.122647] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[466.168845] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.088s)
[466.199691] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[466.255274] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.084s)
[466.305215] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[466.334314] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.075s)
[466.355391] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[466.417882] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.083s)
[466.433609] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[466.493331] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.073s)
[466.543504] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[466.585165] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.089s)
[466.610543] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[466.666402] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.080s)
[466.667395] Subtest drm_format: SUCCESS (1.588s)
[466.922761] [091/134] (650s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[467.113467] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[469.942385] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (2.829s)
[470.211719] [092/134] (647s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[470.488482] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[470.642526] [093/134] (646s left) gem_lmem_swapping (parallel-multi)
[473.408197] Starting subtest: parallel-multi
[473.409074] Starting dynamic subtest: lmem0
[530.470441] Dynamic subtest lmem0: SUCCESS (57.062s)
[530.471435] Subtest parallel-multi: SUCCESS (57.065s)
[531.593336] [FACT gem_lmem_swapping (parallel-multi)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card1
[531.594267] [FACT gem_lmem_swapping (parallel-multi)] deleted: kernel.kmod_is_loaded.i915: true
[531.596418] [094/134] (585s left) kms_cursor_crc (cursor-random-64x21)
[533.454738] Starting subtest: cursor-random-64x21
[533.470045] Starting dynamic subtest: pipe-A-DP-3
[538.021259] Dynamic subtest pipe-A-DP-3: SUCCESS (4.550s)
[538.071697] Starting dynamic subtest: pipe-D-DP-3
[542.615052] Dynamic subtest pipe-D-DP-3: SUCCESS (4.554s)
[542.615982] Subtest cursor-random-64x21: SUCCESS (9.160s)
[543.039436] [FACT kms_cursor_crc (cursor-random-64x21)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card1
[543.041913] [FACT kms_cursor_crc (cursor-random-64x21)] new: kernel.kmod_is_loaded.i915: true
[543.044797] [095/134] (574s left) gem_exec_params (secure-non-root)
[543.134592] Starting subtest: secure-non-root
[543.136368] Subtest secure-non-root: SKIP (0.000s)
[543.344283] [096/134] (574s left) gem_ppgtt (blt-vs-render-ctx0)
[543.425582] Starting subtest: blt-vs-render-ctx0
[576.163174] Subtest blt-vs-render-ctx0: SUCCESS (32.738s)
[576.422040] [097/134] (541s left) gen7_exec_parse (chained-batch)
[576.550046] Subtest chained-batch: SKIP (0.000s)
[576.633973] [098/134] (541s left) gem_eio (wait-10ms)
[576.922894] Starting subtest: wait-10ms
[577.608672] Subtest wait-10ms: SUCCESS (0.686s)
[577.901255] [099/134] (540s left) kms_properties (colorop-properties-atomic)
[578.087882] Starting subtest: colorop-properties-atomic
[578.088763] Starting dynamic subtest: pipe-A-DP-3
[578.281742] Dynamic subtest pipe-A-DP-3: SUCCESS (0.192s)
[578.306498] Starting dynamic subtest: pipe-B-DP-3
[578.479156] Dynamic subtest pipe-B-DP-3: SUCCESS (0.196s)
[578.493820] Starting dynamic subtest: pipe-C-DP-3
[578.664354] Dynamic subtest pipe-C-DP-3: SUCCESS (0.183s)
[578.679166] Starting dynamic subtest: pipe-D-DP-3
[578.832918] Dynamic subtest pipe-D-DP-3: SUCCESS (0.167s)
[578.833866] Subtest colorop-properties-atomic: SUCCESS (0.747s)
[579.171602] [100/134] (538s left) api_intel_allocator (default-alignment)
[579.249000] Starting subtest: default-alignment
[579.255095] Subtest default-alignment: SUCCESS (0.006s)
[579.472237] [101/134] (538s left) i915_pm_rpm (gem-execbuf)
[581.686012] Starting subtest: gem-execbuf
[581.686917] Starting dynamic subtest: lmem0
[586.361824] Dynamic subtest lmem0: SUCCESS (4.674s)
[586.379491] Starting dynamic subtest: smem0
[587.627775] Dynamic subtest smem0: SUCCESS (1.264s)
[587.633746] Subtest gem-execbuf: SUCCESS (5.944s)
[588.076370] [102/134] (530s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[588.261413] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[588.263790] Starting dynamic subtest: pipe-A-DP-3
[588.284964] Dynamic subtest pipe-A-DP-3: SKIP (0.002s)
[588.298507] Starting dynamic subtest: pipe-B-DP-3
[588.319722] Dynamic subtest pipe-B-DP-3: SKIP (0.002s)
[588.333229] Starting dynamic subtest: pipe-C-DP-3
[588.359426] Dynamic subtest pipe-C-DP-3: SKIP (0.002s)
[588.373454] Starting dynamic subtest: pipe-D-DP-3
[588.396009] Dynamic subtest pipe-D-DP-3: SKIP (0.002s)
[588.397986] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SKIP (0.015s)
[588.725431] [103/134] (529s left) gem_bad_reloc (negative-reloc)
[588.808986] Subtest negative-reloc: SKIP (0.000s)
[588.888234] [104/134] (529s left) kms_cursor_edge_walk (128x128-left-edge)
[589.074422] Starting subtest: 128x128-left-edge
[589.076686] Starting dynamic subtest: pipe-A-DP-3
[592.542455] Dynamic subtest pipe-A-DP-3: SUCCESS (3.466s)
[592.563698] Starting dynamic subtest: pipe-D-DP-3
[595.875422] Dynamic subtest pipe-D-DP-3: SUCCESS (3.329s)
[595.876371] Subtest 128x128-left-edge: SUCCESS (6.800s)
[596.212254] [105/134] (522s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[596.398870] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[596.400621] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[596.751451] [106/134] (521s left) gem_close (basic)
[596.831746] Starting subtest: basic
[596.832656] Subtest basic: SUCCESS (0.000s)
[597.014614] [107/134] (521s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[597.211939] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[598.498782] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.286s)
[598.738763] [108/134] (519s left) gem_render_copy (linear)
[598.824874] Starting subtest: linear
[598.825749] Starting dynamic subtest: smem
[598.928799] Dynamic subtest smem: SUCCESS (0.105s)
[598.943889] Starting dynamic subtest: lmem0
[599.243652] Dynamic subtest lmem0: SUCCESS (0.313s)
[599.244760] Subtest linear: SUCCESS (0.420s)
[599.585176] [109/134] (519s left) kms_content_protection (uevent)
[599.840366] Starting subtest: uevent
[599.865674] Starting dynamic subtest: pipe-A-DP-3
[634.099985] Dynamic subtest pipe-A-DP-3: FAIL (34.181s)
[634.143678] Subtest uevent: FAIL (34.301s)
[634.442365] [110/134] (484s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[634.641483] Starting subtest: y-tiled-addfb-size-offset-overflow
[634.643216] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[634.844204] [111/134] (484s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[635.034944] Starting subtest: 2x-plain-flip-ts-check-interruptible
[635.050624] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.015s)
[635.201930] [112/134] (483s left) syncobj_wait (multi-wait-all-submitted)
[635.285901] Starting subtest: multi-wait-all-submitted
[635.389720] Subtest multi-wait-all-submitted: SUCCESS (0.103s)
[635.555908] [113/134] (483s left) gem_userptr_blits (stress-purge)
[635.646325] Starting subtest: stress-purge
[641.043784] Subtest stress-purge: SUCCESS (5.397s)
[641.231469] [114/134] (477s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[641.482812] Starting subtest: 4-tiled-64bpp-rotate-180
[643.423393] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.939s)
[643.672943] [115/134] (475s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[643.866385] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[643.868035] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[644.058956] [116/134] (475s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[644.248008] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[644.272112] Starting dynamic subtest: pipe-A-plane-0
[644.273871] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[644.287756] Starting dynamic subtest: pipe-A-plane-3
[644.289522] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[644.303314] Starting dynamic subtest: pipe-A-plane-5
[644.305034] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[644.506114] Starting dynamic subtest: pipe-B-plane-0
[644.508070] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[644.528505] Starting dynamic subtest: pipe-B-plane-3
[644.530767] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[644.545383] Starting dynamic subtest: pipe-B-plane-5
[644.547663] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[644.575123] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SKIP (0.326s)
[644.848435] [117/134] (474s left) prime_mmap (test_correct_cpu_write)
[644.934089] Starting subtest: test_correct_cpu_write
[644.934929] Starting dynamic subtest: test_correct_cpu_write-smem
[644.935781] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[644.950201] Starting dynamic subtest: test_correct_cpu_write-lmem0
[644.951210] Dynamic subtest test_correct_cpu_write-lmem0: SUCCESS (0.000s)
[644.952212] Subtest test_correct_cpu_write: SUCCESS (0.003s)
[645.086601] [118/134] (474s left) kms_force_connector_basic (force-connector-state)
[645.205797] Starting subtest: force-connector-state
[645.565979] Subtest force-connector-state: SUCCESS (0.361s)
[645.999834] [119/134] (473s left) gem_ctx_persistence (legacy-engines-hang)
[646.085802] Starting subtest: legacy-engines-hang
[646.086806] Starting dynamic subtest: render
[646.195860] Dynamic subtest render: SUCCESS (0.109s)
[646.218110] Starting dynamic subtest: bsd1
[646.300669] Dynamic subtest bsd1: SUCCESS (0.102s)
[646.353123] Starting dynamic subtest: bsd2
[646.382755] Dynamic subtest bsd2: SUCCESS (0.077s)
[646.402761] Starting dynamic subtest: blt
[646.472777] Dynamic subtest blt: SUCCESS (0.087s)
[646.495368] Starting dynamic subtest: vebox
[646.560748] Dynamic subtest vebox: SUCCESS (0.083s)
[646.561855] Subtest legacy-engines-hang: SUCCESS (0.476s)
[646.771212] [120/134] (472s left) gem_exec_fence (long-history)
[647.302736] Starting subtest: long-history
[653.951583] Subtest long-history: SUCCESS (6.656s)
[655.231523] [121/134] (464s left) sysfs_heartbeat_interval (invalid)
[655.314261] Starting subtest: invalid
[655.316603] Starting dynamic subtest: vecs0
[655.317529] Dynamic subtest vecs0: SUCCESS (0.000s)
[655.332469] Starting dynamic subtest: ccs0
[655.333698] Dynamic subtest ccs0: SUCCESS (0.000s)
[655.348119] Starting dynamic subtest: vcs0
[655.349005] Dynamic subtest vcs0: SUCCESS (0.000s)
[655.363453] Starting dynamic subtest: bcs0
[655.364572] Dynamic subtest bcs0: SUCCESS (0.001s)
[655.379090] Starting dynamic subtest: vecs1
[655.380227] Dynamic subtest vecs1: SUCCESS (0.000s)
[655.394099] Starting dynamic subtest: rcs0
[655.394975] Dynamic subtest rcs0: SUCCESS (0.000s)
[655.411952] Starting dynamic subtest: vcs1
[655.413107] Dynamic subtest vcs1: SUCCESS (0.000s)
[655.413992] Subtest invalid: SUCCESS (0.011s)
[655.463465] [122/134] (464s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-mmap-gtt)
[655.654690] Starting subtest: fbcpsr-abgr161616f-draw-mmap-gtt
[655.656424] Subtest fbcpsr-abgr161616f-draw-mmap-gtt: SKIP (0.000s)
[655.849605] [123/134] (464s left) syncobj_timeline (single-wait-available-submitted)
[655.934961] Starting subtest: single-wait-available-submitted
[655.936066] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[656.080871] [124/134] (463s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[656.271624] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[656.273408] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[656.488393] [125/134] (463s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[656.682346] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[656.747390] [126/134] (463s left) gem_ctx_isolation (dirty-switch)
[656.837609] Starting subtest: dirty-switch
[656.838611] Starting dynamic subtest: rcs0
[657.441126] Dynamic subtest rcs0: SUCCESS (0.603s)
[657.457456] Starting dynamic subtest: bcs0
[658.074664] Dynamic subtest bcs0: SUCCESS (0.632s)
[658.090692] Starting dynamic subtest: vcs0
[658.700417] Dynamic subtest vcs0: SUCCESS (0.625s)
[658.715240] Starting dynamic subtest: vcs1
[659.364153] Dynamic subtest vcs1: SUCCESS (0.663s)
[659.380625] Starting dynamic subtest: vecs0
[660.011845] Dynamic subtest vecs0: SUCCESS (0.646s)
[660.027676] Starting dynamic subtest: vecs1
[660.640207] Dynamic subtest vecs1: SUCCESS (0.627s)
[660.654988] Starting dynamic subtest: ccs0
[661.286071] Dynamic subtest ccs0: SUCCESS (0.645s)
[661.286966] Subtest dirty-switch: SUCCESS (4.449s)
[661.604012] [127/134] (458s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[661.791623] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[661.793356] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[661.952351] [128/134] (458s left) gem_mmap_offset (blt-coherency)
[662.034329] Starting subtest: blt-coherency
[662.068765] Subtest blt-coherency: SUCCESS (0.036s)
[662.286436] [129/134] (458s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[662.471618] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[664.788790] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (2.318s)
[665.059397] [130/134] (455s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[665.244746] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[665.245656] Starting dynamic subtest: pipe-A-DP-3
[665.254432] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[665.269969] Starting dynamic subtest: pipe-B-DP-3
[665.278325] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[665.292453] Starting dynamic subtest: pipe-C-DP-3
[665.301201] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[665.315179] Starting dynamic subtest: pipe-D-DP-3
[665.325605] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[665.327970] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[665.716832] [131/134] (454s left) syncobj_wait (wait-for-submit-delayed-submit)
[665.795123] Starting subtest: wait-for-submit-delayed-submit
[665.897544] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[666.021580] [132/134] (454s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[666.097825] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[666.098730] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[666.259378] [133/134] (454s left) kms_psr2_su (page_flip-nv12)
[666.339706] Subtest page_flip-NV12: SKIP (0.000s)
[666.437429] [134/134] (454s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[666.626620] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[666.628384] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[666.800519] Closing watchdogs
results: parsing output: 0/ for test: syncobj_wait
results: parsing output: 1/ for test: gem_exec_create
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: kms_cursor_legacy
results: parsing output: 4/ for test: gem_mmap_gtt
results: parsing output: 5/ for test: gem_userptr_blits
results: parsing output: 6/ for test: i915_suspend
results: parsing output: 7/ for test: kms_hdr
results: parsing output: 8/ for test: gem_softpin
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_lmem_swapping
results: parsing output: 13/ for test: prime_vgem
results: parsing output: 14/ for test: kms_flip_scaled_crc
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: gem_exec_whisper
results: parsing output: 17/ for test: gem_pxp
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_chamelium_frames
results: parsing output: 20/ for test: i915_pm_freq_api
results: parsing output: 21/ for test: syncobj_wait
results: parsing output: 22/ for test: gem_render_copy
results: parsing output: 23/ for test: gem_close_race
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_plane_scaling
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_exec_fence
results: parsing output: 29/ for test: kms_lease
results: parsing output: 30/ for test: kms_dirtyfb
results: parsing output: 31/ for test: kms_pipe_b_c_ivb
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: gem_exec_schedule
results: parsing output: 34/ for test: prime_mmap
results: parsing output: 35/ for test: kms_addfb_basic
results: parsing output: 36/ for test: gem_eio
results: parsing output: 37/ for test: gem_exec_reloc
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_vblank
results: parsing output: 40/ for test: kms_flip
results: parsing output: 41/ for test: kms_flip
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: gem_mmap_wc
results: parsing output: 45/ for test: gem_exec_schedule
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: i915_drm_fdinfo
results: parsing output: 50/ for test: gem_exec_params
results: parsing output: 51/ for test: kms_chamelium_color
results: parsing output: 52/ for test: kms_flip_scaled_crc
results: parsing output: 53/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 54/ for test: kms_color_pipeline
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: perf_pmu
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_atomic
results: parsing output: 60/ for test: kms_invalid_mode
results: parsing output: 61/ for test: gem_exec_balancer
results: parsing output: 62/ for test: api_intel_bb
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: kms_prime
results: parsing output: 65/ for test: gem_ctx_sseu
results: parsing output: 66/ for test: kms_pm_rpm
results: parsing output: 67/ for test: kms_cursor_legacy
results: parsing output: 68/ for test: gem_mmap_gtt
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_cursor_legacy
results: parsing output: 72/ for test: perf
results: parsing output: 73/ for test: kms_plane
results: parsing output: 74/ for test: gem_exec_reloc
results: parsing output: 75/ for test: core_setmaster
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_addfb_basic
results: parsing output: 78/ for test: kms_plane_scaling
results: parsing output: 79/ for test: gem_busy
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: kms_cursor_crc
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_exec_endless
results: parsing output: 84/ for test: kms_plane_alpha_blend
results: parsing output: 85/ for test: kms_feature_discovery
results: parsing output: 86/ for test: sw_sync
results: parsing output: 87/ for test: sw_sync
results: parsing output: 88/ for test: kms_psr_stress_test
results: parsing output: 89/ for test: kms_selftest
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_chamelium_hpd
results: parsing output: 92/ for test: gem_lmem_swapping
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: gem_exec_params
results: parsing output: 95/ for test: gem_ppgtt
results: parsing output: 96/ for test: gen7_exec_parse
results: parsing output: 97/ for test: gem_eio
results: parsing output: 98/ for test: kms_properties
results: parsing output: 99/ for test: api_intel_allocator
results: parsing output: 100/ for test: i915_pm_rpm
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: gem_bad_reloc
results: parsing output: 103/ for test: kms_cursor_edge_walk
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: gem_close
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: gem_render_copy
results: parsing output: 108/ for test: kms_content_protection
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: syncobj_wait
results: parsing output: 112/ for test: gem_userptr_blits
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_plane
results: parsing output: 116/ for test: prime_mmap
results: parsing output: 117/ for test: kms_force_connector_basic
results: parsing output: 118/ for test: gem_ctx_persistence
results: parsing output: 119/ for test: gem_exec_fence
results: parsing output: 120/ for test: sysfs_heartbeat_interval
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_psr2_sf
results: parsing output: 125/ for test: gem_ctx_isolation
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_mmap_offset
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_ccs
results: parsing output: 130/ for test: syncobj_wait
results: parsing output: 131/ for test: syncobj_timeline
results: parsing output: 132/ for test: kms_psr2_su
results: parsing output: 133/ for test: kms_frontbuffer_tracking
Done.