[38.639616] Initializing watchdogs
[38.639656]   /dev/watchdog0
[38.645550] [001/129] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[38.839805] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[38.841344] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[38.936044] [002/129] (960s left) gem_exec_reloc (basic-gtt-read-active)
[39.028207] Subtest basic-gtt-read-active: SKIP (0.000s)
[39.069608] [003/129] (960s left) kms_flip (plain-flip-fb-recreate-interruptible)
[39.293640] Starting subtest: plain-flip-fb-recreate-interruptible
[39.298790] Starting dynamic subtest: A-DP3
[44.320182] Dynamic subtest A-DP3: FAIL (4.713s)
[44.325681] Starting dynamic subtest: B-DP3
[49.315583] Dynamic subtest B-DP3: FAIL (4.872s)
[49.321185] Starting dynamic subtest: C-DP3
[55.355486] Dynamic subtest C-DP3: FAIL (5.943s)
[55.362575] Starting dynamic subtest: D-DP3
[65.497175] Dynamic subtest D-DP3: FAIL (10.020s)
[65.499097] Subtest plain-flip-fb-recreate-interruptible: FAIL (25.558s)
[65.557126] [004/129] (934s left) gem_workarounds (reset)
[65.645999] Starting subtest: reset
[65.856237] Subtest reset: SUCCESS (0.210s)
[65.912619] [005/129] (933s left) syncobj_basic (bad-destroy-pad)
[65.960103] Starting subtest: bad-destroy-pad
[65.961174] Subtest bad-destroy-pad: SUCCESS (0.000s)
[65.993640] [006/129] (933s left) gem_tiled_fence_blits (normal)
[66.051436] Subtest normal: SKIP (0.000s)
[66.096950] [007/129] (933s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[66.296042] Starting subtest: bad-aux-stride-y-tiled-ccs
[66.296932] Starting dynamic subtest: pipe-A-DP-3
[66.305326] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[66.311160] Starting dynamic subtest: pipe-B-DP-3
[66.320419] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[66.326141] Starting dynamic subtest: pipe-C-DP-3
[66.336569] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[66.342135] Starting dynamic subtest: pipe-D-DP-3
[66.352272] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[66.354315] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.003s)
[66.363678] [008/129] (933s left) kms_feature_discovery (dp-mst)
[66.546845] Starting subtest: dp-mst
[66.548589] Subtest dp-mst: SKIP (0.000s)
[66.559304] [009/129] (933s left) syncobj_wait (wait-all-snapshot)
[66.620214] Starting subtest: wait-all-snapshot
[66.703319] Subtest wait-all-snapshot: SUCCESS (0.082s)
[66.762371] [010/129] (932s left) drm_fdinfo (virtual-busy-idle-all)
[66.838901] Starting subtest: virtual-busy-idle-all
[66.840456] Subtest virtual-busy-idle-all: SKIP (0.000s)
[66.860775] [011/129] (932s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[67.040998] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[67.041789] Starting dynamic subtest: pipe-A
[79.450332] Dynamic subtest pipe-A: SUCCESS (12.395s)
[79.468757] Starting dynamic subtest: pipe-B
[90.829657] Dynamic subtest pipe-B: SUCCESS (11.373s)
[90.836600] Starting dynamic subtest: pipe-C
[102.203591] Dynamic subtest pipe-C: SUCCESS (11.369s)
[102.212559] Starting dynamic subtest: pipe-D
[113.315690] Dynamic subtest pipe-D: SUCCESS (11.105s)
[113.316565] Subtest planes-upscale-20x20-downscale-factor-0-5: SUCCESS (46.244s)
[113.509015] [012/129] (886s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[116.262602] Starting subtest: heavy-verify-multi-ccs
[116.263510] Starting dynamic subtest: lmem0
[124.543109] Dynamic subtest lmem0: SUCCESS (8.279s)
[124.544097] Subtest heavy-verify-multi-ccs: SUCCESS (8.279s)
[126.174033] [013/129] (873s left) gem_mmap (pf-nonblock)
[126.929199] Subtest pf-nonblock: SKIP (0.000s)
[126.968141] [014/129] (872s left) perf (disabled-read-error)
[127.278985] Starting subtest: disabled-read-error
[127.302948] Subtest disabled-read-error: SUCCESS (0.024s)
[127.318933] [015/129] (872s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[127.548701] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[127.550231] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[127.568334] [016/129] (872s left) gem_exec_schedule (semaphore-noskip)
[127.666986] Starting subtest: semaphore-noskip
[128.687023] Subtest semaphore-noskip: SUCCESS (1.019s)
[129.023314] [017/129] (870s left) perf_pmu (rc6)
[129.097574] Starting subtest: rc6
[129.098644] Starting dynamic subtest: gt0
[135.443944] Dynamic subtest gt0: SUCCESS (6.344s)
[135.452697] Starting dynamic subtest: runtime-pm-gt0
[143.215076] Dynamic subtest runtime-pm-gt0: SUCCESS (7.770s)
[143.221690] Starting dynamic subtest: runtime-pm-long-gt0
[155.898438] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.683s)
[155.907222] Starting dynamic subtest: other-idle-gt0
[155.909527] Dynamic subtest other-idle-gt0: SKIP (0.000s)
[155.910490] Subtest rc6: SUCCESS (26.802s)
[156.577694] [018/129] (843s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[156.812635] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[156.814403] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[156.856015] [019/129] (843s left) gem_exec_balancer (parallel-keep-submit-fence)
[157.147164] Starting subtest: parallel-keep-submit-fence
[158.644619] Subtest parallel-keep-submit-fence: SUCCESS (1.498s)
[158.689326] [020/129] (841s left) gem_ctx_bad_destroy (invalid-default-ctx)
[158.770463] Starting subtest: invalid-default-ctx
[158.771387] Subtest invalid-default-ctx: SUCCESS (0.000s)
[158.791116] [021/129] (841s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[159.009209] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[159.011056] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[159.056938] [022/129] (840s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[159.283512] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[159.285076] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[159.322925] [023/129] (840s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[159.550939] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[159.553040] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[159.589813] [024/129] (840s left) i915_hangman (hangcheck-unterminated)
[159.689272] Starting subtest: hangcheck-unterminated
[169.537865] Subtest hangcheck-unterminated: SUCCESS (9.848s)
[169.644291] [025/129] (830s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[169.752368] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[169.753909] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[169.878262] [026/129] (830s left) i915_pm_rpm (system-suspend)
[171.441326] Starting subtest: system-suspend
[191.229118] Subtest system-suspend: SUCCESS (5.047s)
[193.521505] [027/129] (823s left) kms_chamelium_edid (dp-edid-resolution-list)
[193.822943] Subtest dp-edid-resolution-list: SKIP (0.000s)
[193.948136] [028/129] (822s left) kms_psr2_su (page_flip-p010)
[194.060282] Subtest page_flip-P010: SKIP (0.000s)
[194.111631] [029/129] (822s left) gem_exec_schedule (independent)
[194.222920] Starting subtest: independent
[194.223746] Starting dynamic subtest: rcs0
[194.577989] Dynamic subtest rcs0: SUCCESS (0.355s)
[194.587266] Starting dynamic subtest: bcs0
[194.848363] Dynamic subtest bcs0: SUCCESS (0.270s)
[194.857896] Starting dynamic subtest: vcs0
[195.134325] Dynamic subtest vcs0: SUCCESS (0.285s)
[195.145557] Starting dynamic subtest: vcs1
[195.423444] Dynamic subtest vcs1: SUCCESS (0.288s)
[195.435859] Starting dynamic subtest: vecs0
[195.702568] Dynamic subtest vecs0: SUCCESS (0.278s)
[195.729435] Starting dynamic subtest: vecs1
[196.002186] Dynamic subtest vecs1: SUCCESS (0.299s)
[196.012189] Starting dynamic subtest: ccs0
[196.281480] Dynamic subtest ccs0: SUCCESS (0.278s)
[196.282917] Subtest independent: SUCCESS (2.060s)
[196.584195] [030/129] (820s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[196.803958] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[196.805763] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[196.835164] [031/129] (819s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[197.057283] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[197.059010] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[197.093091] [032/129] (819s left) gem_ctx_shared (disjoint-timelines)
[197.182670] Starting subtest: disjoint-timelines
[197.274207] Subtest disjoint-timelines: SUCCESS (0.091s)
[197.479055] [033/129] (819s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[197.709091] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[197.710812] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[197.742812] [034/129] (819s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[197.954055] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[197.954981] Starting dynamic subtest: pipe-A-valid-mode
[199.628296] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.672s)
[199.629872] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SUCCESS (1.674s)
[199.807310] [035/129] (817s left) gem_exec_fence (syncobj-repeat)
[200.274182] Starting subtest: syncobj-repeat
[200.430946] Subtest syncobj-repeat: SUCCESS (0.156s)
[200.720828] [036/129] (816s left) kms_prime (basic-crc-hybrid)
[201.867861] Subtest basic-crc-hybrid: SKIP (0.000s)
[201.884212] [037/129] (815s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[202.111459] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[202.113261] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[202.150420] [038/129] (814s left) kms_scaling_modes (scaling-mode-center)
[202.366126] Starting subtest: scaling-mode-center
[202.369672] Subtest scaling-mode-center: SKIP (0.002s)
[202.385160] [039/129] (814s left) i915_query (query-topology-garbage-items)
[202.470953] Starting subtest: query-topology-garbage-items
[202.472156] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[202.500890] [040/129] (814s left) perf_pmu (cpu-hotplug)
[202.580647] Starting subtest: cpu-hotplug
[202.600129] Subtest cpu-hotplug: SKIP (0.019s)
[202.672476] [041/129] (814s left) api_intel_bb (lot-of-buffers)
[202.773947] Starting subtest: lot-of-buffers
[204.905667] Subtest lot-of-buffers: SUCCESS (2.132s)
[204.984380] [042/129] (812s left) kms_plane (pixel-format)
[205.207979] Starting subtest: pixel-format
[205.238097] Starting dynamic subtest: pipe-A-plane-0
[213.088424] Dynamic subtest pipe-A-plane-0: SUCCESS (7.850s)
[213.098063] Starting dynamic subtest: pipe-A-plane-3
[217.840621] Dynamic subtest pipe-A-plane-3: SUCCESS (4.750s)
[217.881794] Starting dynamic subtest: pipe-A-plane-5
[218.088931] Dynamic subtest pipe-A-plane-5: SUCCESS (0.247s)
[218.380877] Starting dynamic subtest: pipe-B-plane-0
[226.045102] Dynamic subtest pipe-B-plane-0: SUCCESS (7.699s)
[226.054112] Starting dynamic subtest: pipe-B-plane-3
[230.830801] Dynamic subtest pipe-B-plane-3: SUCCESS (4.783s)
[230.868616] Starting dynamic subtest: pipe-B-plane-5
[231.046226] Dynamic subtest pipe-B-plane-5: SUCCESS (0.214s)
[231.153857] Subtest pixel-format: SUCCESS (25.942s)
[231.347914] [043/129] (785s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[231.570261] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[234.151237] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (2.580s)
[234.266139] [044/129] (782s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[234.495253] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[234.496914] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[234.571584] [045/129] (782s left) kms_psr (fbc-psr2-primary-blt)
[234.809650] Subtest fbc-psr2-primary-blt: SKIP (0.000s)
[234.828996] [046/129] (782s left) kms_psr (psr2-sprite-mmap-cpu)
[235.041711] Subtest psr2-sprite-mmap-cpu: SKIP (0.000s)
[235.061711] [047/129] (782s left) gem_ccs (block-multicopy-compressed)
[235.160148] Starting subtest: block-multicopy-compressed
[235.161069] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0-multicopy
[235.192298] Dynamic subtest linear-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.032s)
[235.201193] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0-multicopy
[235.295427] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.103s)
[235.304429] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0-multicopy
[235.310205] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.014s)
[235.318899] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0-multicopy
[235.406114] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.095s)
[235.414798] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0-multicopy
[235.420880] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.014s)
[235.429401] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0-multicopy
[235.519348] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.098s)
[235.528094] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0-multicopy
[235.534111] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.014s)
[235.542753] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0-multicopy
[235.633525] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.099s)
[235.634358] Subtest block-multicopy-compressed: SUCCESS (0.474s)
[235.699383] [048/129] (781s left) gem_exec_fair (basic-none-share)
[235.794065] Subtest basic-none-share: SKIP (0.000s)
[235.829733] [049/129] (781s left) gem_softpin (allocator-nopin)
[235.919182] Starting subtest: allocator-nopin
[236.098732] Subtest allocator-nopin: SUCCESS (0.159s)
[236.153620] [050/129] (780s left) kms_psr (fbc-psr-cursor-plane-onoff)
[236.395904] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[236.428346] [051/129] (780s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[236.653522] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[237.835301] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.181s)
[237.949996] [052/129] (779s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[238.179190] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[238.181725] Starting dynamic subtest: pipe-A-DP-3
[238.191608] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[238.200647] Starting dynamic subtest: pipe-B-DP-3
[238.211395] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[238.220281] Starting dynamic subtest: pipe-C-DP-3
[238.231591] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[238.240134] Starting dynamic subtest: pipe-D-DP-3
[238.250817] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[238.252662] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[238.265774] [053/129] (778s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[238.492695] Starting subtest: psr-rgb101010-draw-blt
[238.494456] Subtest psr-rgb101010-draw-blt: SKIP (0.000s)
[238.531120] [054/129] (778s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[238.756010] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[238.756994] Starting dynamic subtest: pipe-A
[240.933622] Dynamic subtest pipe-A: SUCCESS (2.177s)
[240.943968] Starting dynamic subtest: pipe-B
[243.030219] Dynamic subtest pipe-B: SUCCESS (2.096s)
[243.040450] Starting dynamic subtest: pipe-C
[243.340832] Dynamic subtest pipe-C: SUCCESS (0.310s)
[243.367057] Starting dynamic subtest: pipe-D
[243.667194] Dynamic subtest pipe-D: SUCCESS (0.325s)
[243.668564] Subtest plane-downscale-factor-0-5-with-pixel-format: SUCCESS (4.912s)
[243.885686] [055/129] (773s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[244.129164] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[244.132472] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.003s)
[244.156063] [056/129] (773s left) kms_cursor_crc (cursor-sliding-32x10)
[244.437719] Starting subtest: cursor-sliding-32x10
[244.485007] Subtest cursor-sliding-32x10: SKIP (0.045s)
[244.696356] [057/129] (772s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[244.939250] Starting subtest: x-tiled-32bpp-rotate-90
[244.993840] Subtest x-tiled-32bpp-rotate-90: SKIP (0.054s)
[245.075556] [058/129] (772s left) gem_close_race (basic-threads)
[245.194950] Starting subtest: basic-threads
[246.385916] Subtest basic-threads: SUCCESS (1.191s)
[246.586951] [059/129] (770s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[246.877044] Starting subtest: cursorA-vs-flipB-legacy
[246.880041] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[246.906169] [060/129] (770s left) perf_pmu (busy-idle-no-semaphores)
[246.984721] Starting subtest: busy-idle-no-semaphores
[246.985639] Starting dynamic subtest: rcs0
[247.664750] Dynamic subtest rcs0: SUCCESS (0.679s)
[247.677888] Starting dynamic subtest: bcs0
[248.314763] Dynamic subtest bcs0: SUCCESS (0.648s)
[248.328252] Starting dynamic subtest: vcs0
[248.964602] Dynamic subtest vcs0: SUCCESS (0.647s)
[248.977206] Starting dynamic subtest: vcs1
[249.613769] Dynamic subtest vcs1: SUCCESS (0.647s)
[249.624533] Starting dynamic subtest: vecs0
[250.265058] Dynamic subtest vecs0: SUCCESS (0.649s)
[250.278294] Starting dynamic subtest: vecs1
[250.915214] Dynamic subtest vecs1: SUCCESS (0.648s)
[250.928039] Starting dynamic subtest: ccs0
[251.564192] Dynamic subtest ccs0: SUCCESS (0.647s)
[251.566034] Subtest busy-idle-no-semaphores: SUCCESS (4.580s)
[251.646246] [061/129] (765s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[251.862425] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[251.864143] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[251.906413] [062/129] (765s left) syncobj_wait (single-wait-for-submit-submitted)
[251.995143] Starting subtest: single-wait-for-submit-submitted
[252.099182] Subtest single-wait-for-submit-submitted: SUCCESS (0.104s)
[252.145280] [063/129] (765s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[252.392195] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[252.394033] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[252.429207] [064/129] (765s left) kms_setmode (invalid-clone-single-crtc)
[252.519034] Starting subtest: invalid-clone-single-crtc
[252.529654] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[252.615430] [065/129] (764s left) kms_lease (lease-get)
[252.864074] Starting subtest: lease-get
[252.866589] Starting dynamic subtest: pipe-A-DP-3
[252.867426] Dynamic subtest pipe-A-DP-3: SUCCESS (0.002s)
[252.878734] Starting dynamic subtest: pipe-B-DP-3
[252.879557] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[252.888417] Starting dynamic subtest: pipe-C-DP-3
[252.889187] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[252.897903] Starting dynamic subtest: pipe-D-DP-3
[252.899104] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[252.900194] Subtest lease-get: SUCCESS (0.012s)
[252.941019] [066/129] (764s left) kms_psr2_su (frontbuffer-xrgb8888)
[253.034271] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[253.073171] [067/129] (764s left) gem_sync (basic-many-each)
[253.175331] Starting subtest: basic-many-each
[255.705418] Subtest basic-many-each: SUCCESS (2.532s)
[255.890930] [068/129] (761s left) kms_tiled_display (basic-test-pattern)
[256.252106] Subtest basic-test-pattern: SKIP (0.000s)
[256.288466] [069/129] (761s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[256.510430] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[256.511970] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[256.540371] [070/129] (761s left) kms_flip (2x-flip-vs-fences-interruptible)
[256.755828] Starting subtest: 2x-flip-vs-fences-interruptible
[256.757664] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[256.789725] [071/129] (760s left) vgem_basic (create)
[256.876844] Starting subtest: create
[256.877798] Subtest create: SUCCESS (0.000s)
[256.891142] [072/129] (760s left) kms_big_fb (linear-64bpp-rotate-90)
[257.119011] Starting subtest: linear-64bpp-rotate-90
[257.160623] Subtest linear-64bpp-rotate-90: SKIP (0.041s)
[257.239174] [073/129] (760s left) kms_pm_rpm (i2c)
[259.221023] Starting subtest: i2c
[260.604341] Subtest i2c: SUCCESS (1.384s)
[260.750515] [074/129] (756s left) kms_vrr (flip-basic-fastset)
[260.963949] Starting subtest: flip-basic-fastset
[260.966697] Subtest flip-basic-fastset: SKIP (0.000s)
[260.982257] [075/129] (756s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[261.065890] Starting subtest: invalid-single-wait-all-unsubmitted
[261.066875] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[261.099064] [076/129] (756s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[261.322402] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[261.346599] [077/129] (756s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[261.432902] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[261.433733] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[261.487654] [078/129] (756s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[261.716478] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[261.718132] Subtest psr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[261.767539] [079/129] (756s left) perf (invalid-oa-exponent)
[261.935671] Starting subtest: invalid-oa-exponent
[261.952165] Subtest invalid-oa-exponent: SUCCESS (0.016s)
[261.983816] [080/129] (755s left) gem_exec_params (rs-invalid)
[262.072045] Starting subtest: rs-invalid
[262.074062] Subtest rs-invalid: SUCCESS (0.002s)
[262.138024] [081/129] (755s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[262.357974] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[262.358875] Starting dynamic subtest: pipe-A-valid-mode
[264.200912] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.839s)
[264.202377] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (1.841s)
[264.367291] [082/129] (753s left) kms_atomic (test-only)
[264.594874] Starting subtest: test-only
[264.963861] Starting dynamic subtest: pipe-A-DP-3
[265.846810] Dynamic subtest pipe-A-DP-3: SUCCESS (0.883s)
[265.848172] Subtest test-only: SUCCESS (1.252s)
[266.060944] [083/129] (751s left) kms_color (ctm-red-to-blue)
[266.283938] Starting subtest: ctm-red-to-blue
[266.286177] Starting dynamic subtest: pipe-A-DP-3
[266.893056] Dynamic subtest pipe-A-DP-3: SUCCESS (0.606s)
[266.916517] Starting dynamic subtest: pipe-B-DP-3
[267.487237] Dynamic subtest pipe-B-DP-3: SUCCESS (0.590s)
[267.502763] Starting dynamic subtest: pipe-C-DP-3
[268.077899] Dynamic subtest pipe-C-DP-3: SUCCESS (0.589s)
[268.087930] Starting dynamic subtest: pipe-D-DP-3
[268.680300] Dynamic subtest pipe-D-DP-3: SUCCESS (0.600s)
[268.681428] Subtest ctm-red-to-blue: SUCCESS (2.395s)
[268.893758] [084/129] (748s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[269.117958] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[269.119811] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[269.138068] [085/129] (748s left) syncobj_timeline (etime-single-wait-submitted)
[269.220982] Starting subtest: etime-single-wait-submitted
[269.323191] Subtest etime-single-wait-submitted: SUCCESS (0.102s)
[269.375403] [086/129] (748s left) prime_busy (hang-wait)
[269.470060] Starting subtest: hang-wait
[269.471974] Starting dynamic subtest: rcs0
[295.632997] Dynamic subtest rcs0: SUCCESS (26.159s)
[295.642341] Starting dynamic subtest: bcs0
[302.803113] Dynamic subtest bcs0: SUCCESS (7.168s)
[302.812251] Starting dynamic subtest: vcs0
[309.763971] Dynamic subtest vcs0: SUCCESS (6.961s)
[309.773371] Starting dynamic subtest: vcs1
[316.752340] Dynamic subtest vcs1: SUCCESS (6.988s)
[316.761256] Starting dynamic subtest: vecs0
[323.777772] Dynamic subtest vecs0: SUCCESS (7.026s)
[323.787123] Starting dynamic subtest: vecs1
[330.758102] Dynamic subtest vecs1: SUCCESS (6.979s)
[330.767326] Starting dynamic subtest: ccs0
[344.605594] Dynamic subtest ccs0: SUCCESS (13.847s)
[344.606462] Subtest hang-wait: SUCCESS (75.133s)
[344.679423] [087/129] (673s left) gem_create (create-clear)
[344.765830] Starting subtest: create-clear
[344.768716] Starting dynamic subtest: lmem0
[377.963183] Dynamic subtest lmem0: SUCCESS (33.191s)
[377.972695] Starting dynamic subtest: smem0
[412.077049] Dynamic subtest smem0: SUCCESS (34.114s)
[412.077878] Subtest create-clear: SUCCESS (67.306s)
[412.382830] [088/129] (605s left) gem_exec_reloc (basic-gtt-wc-active)
[412.490120] Subtest basic-gtt-wc-active: SKIP (0.000s)
[412.596965] [089/129] (605s left) api_intel_allocator (reopen)
[412.694953] Starting subtest: reopen
[412.714919] Subtest reopen: SUCCESS (0.021s)
[412.782052] [090/129] (605s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-gtt)
[413.039799] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-gtt
[413.041464] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[413.083291] [091/129] (604s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[413.312033] Starting subtest: y-tiled-32bpp-rotate-270
[413.313835] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[413.349358] [092/129] (604s left) gem_mmap_gtt (fault-concurrent-y)
[413.438932] Subtest fault-concurrent-Y: SKIP (0.000s)
[413.507516] [093/129] (604s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[413.619333] Starting subtest: invalid-bsd1-flag-on-blt
[413.620390] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[413.649504] [094/129] (604s left) kms_content_protection (uevent)
[413.904550] Starting subtest: uevent
[413.937401] Starting dynamic subtest: pipe-A-DP-3
[448.231526] Dynamic subtest pipe-A-DP-3: FAIL (34.245s)
[448.296032] Subtest uevent: FAIL (34.390s)
[448.448645] [095/129] (569s left) gem_lmem_swapping (random-engines)
[451.105768] Starting subtest: random-engines
[451.106573] Starting dynamic subtest: lmem0
[451.720784] Dynamic subtest lmem0: SUCCESS (0.615s)
[451.721581] Subtest random-engines: SUCCESS (0.616s)
[453.170599] [096/129] (564s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[454.044110] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[455.224369] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.180s)
[455.329957] [097/129] (562s left) gem_exec_whisper (basic-contexts)
[455.397013] Starting subtest: basic-contexts
[465.759439] Subtest basic-contexts: SUCCESS (10.361s)
[465.891301] [098/129] (552s left) gem_wait (write-busy)
[465.949660] Starting subtest: write-busy
[465.950443] Starting dynamic subtest: all-engines
[466.538072] Dynamic subtest all-engines: SUCCESS (0.588s)
[466.547408] Starting dynamic subtest: rcs0
[467.083819] Dynamic subtest rcs0: SUCCESS (0.545s)
[467.092751] Starting dynamic subtest: bcs0
[467.627156] Dynamic subtest bcs0: SUCCESS (0.543s)
[467.636051] Starting dynamic subtest: vcs0
[468.168418] Dynamic subtest vcs0: SUCCESS (0.541s)
[468.177265] Starting dynamic subtest: vcs1
[468.709056] Dynamic subtest vcs1: SUCCESS (0.540s)
[468.717830] Starting dynamic subtest: vecs0
[469.248900] Dynamic subtest vecs0: SUCCESS (0.539s)
[469.257659] Starting dynamic subtest: vecs1
[469.788983] Dynamic subtest vecs1: SUCCESS (0.539s)
[469.797762] Starting dynamic subtest: ccs0
[470.328989] Dynamic subtest ccs0: SUCCESS (0.539s)
[470.329905] Subtest write-busy: SUCCESS (4.380s)
[470.508813] [099/129] (547s left) gen9_exec_parse (bb-chained)
[470.571472] Subtest bb-chained: SKIP (0.000s)
[470.608231] [100/129] (547s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[470.828467] Starting subtest: y-tiled-64bpp-rotate-180
[470.830318] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[470.871218] [101/129] (547s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[470.926655] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[470.927500] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[470.974066] [102/129] (547s left) gem_exec_nop (basic-series)
[471.042262] Starting subtest: basic-series
[475.395346] Subtest basic-series: SUCCESS (4.354s)
[475.610268] [103/129] (542s left) syncobj_timeline (single-wait-available-submitted)
[475.688266] Starting subtest: single-wait-available-submitted
[475.689198] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[475.745016] [104/129] (542s left) gem_userptr_blits (unsync-unmap-after-close)
[475.829807] Subtest unsync-unmap-after-close: SKIP (0.000s)
[475.893358] [105/129] (542s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[476.075906] Starting subtest: primary-y-tiled-reflect-x-90
[476.077665] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[476.104155] [106/129] (542s left) gen3_render_mixed_blits
[476.247141] [107/129] (542s left) kms_cursor_crc (cursor-random-512x512)
[476.637563] Starting subtest: cursor-random-512x512
[476.640389] Subtest cursor-random-512x512: SKIP (0.001s)
[476.776989] [108/129] (541s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[476.978224] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[476.980041] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[477.021229] [109/129] (541s left) gem_exec_async (forked-writes)
[477.087222] Starting subtest: forked-writes
[477.088169] Starting dynamic subtest: rcs0
[477.130049] Dynamic subtest rcs0: SUCCESS (0.043s)
[477.140491] Starting dynamic subtest: bcs0
[477.154872] Dynamic subtest bcs0: SUCCESS (0.024s)
[477.163590] Starting dynamic subtest: vcs0
[477.176784] Dynamic subtest vcs0: SUCCESS (0.021s)
[477.185345] Starting dynamic subtest: vcs1
[477.198762] Dynamic subtest vcs1: SUCCESS (0.021s)
[477.207305] Starting dynamic subtest: vecs0
[477.220779] Dynamic subtest vecs0: SUCCESS (0.021s)
[477.229257] Starting dynamic subtest: vecs1
[477.242390] Dynamic subtest vecs1: SUCCESS (0.021s)
[477.250834] Starting dynamic subtest: ccs0
[477.263930] Dynamic subtest ccs0: SUCCESS (0.021s)
[477.264732] Subtest forked-writes: SUCCESS (0.177s)
[477.497033] [110/129] (540s left) kms_getfb (getfb2-into-addfb2)
[477.571875] Starting subtest: getfb2-into-addfb2
[477.572823] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[477.624009] [111/129] (540s left) kms_flip (basic-plain-flip)
[477.807200] Starting subtest: basic-plain-flip
[477.811341] Starting dynamic subtest: A-DP3
[478.656163] Dynamic subtest A-DP3: SUCCESS (0.844s)
[478.668164] Starting dynamic subtest: B-DP3
[479.406894] Dynamic subtest B-DP3: SUCCESS (0.748s)
[479.416047] Starting dynamic subtest: C-DP3
[480.171827] Dynamic subtest C-DP3: SUCCESS (0.764s)
[480.181244] Starting dynamic subtest: D-DP3
[480.952733] Dynamic subtest D-DP3: SUCCESS (0.780s)
[480.954956] Subtest basic-plain-flip: SUCCESS (3.149s)
[481.209490] [112/129] (537s left) kms_cursor_legacy (single-bo)
[481.409950] Starting subtest: single-bo
[481.410855] Starting dynamic subtest: pipe-A
[486.789419] Dynamic subtest pipe-A: SUCCESS (5.378s)
[486.797984] Starting dynamic subtest: pipe-B
[492.166710] Dynamic subtest pipe-B: SUCCESS (5.377s)
[492.175059] Starting dynamic subtest: pipe-C
[497.543987] Dynamic subtest pipe-C: SUCCESS (5.377s)
[497.552277] Starting dynamic subtest: pipe-D
[502.921138] Dynamic subtest pipe-D: SUCCESS (5.376s)
[502.929508] Starting dynamic subtest: all-pipes
[508.299151] Dynamic subtest all-pipes: SUCCESS (5.377s)
[508.300081] Subtest single-bo: SUCCESS (26.888s)
[508.317610] [113/129] (510s left) perf_pmu (pmu-read)
[508.361732] Starting subtest: pmu-read
[508.364064] Subtest pmu-read: SUCCESS (0.002s)
[508.421818] [114/129] (510s left) kms_hdr (bpc-switch-dpms)
[508.604924] Starting subtest: bpc-switch-dpms
[512.104782] Starting dynamic subtest: pipe-A-DP-3
[513.494823] Dynamic subtest pipe-A-DP-3: SUCCESS (1.390s)
[513.496690] Subtest bpc-switch-dpms: SUCCESS (4.890s)
[513.769960] [115/129] (504s left) syncobj_timeline (invalid-transfer-bad-pad)
[513.843983] Starting subtest: invalid-transfer-bad-pad
[513.844925] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[513.880299] [116/129] (504s left) gem_linear_blits (interruptible)
[514.506146] Starting subtest: interruptible
[520.629937] Subtest interruptible: SUCCESS (6.123s)
[520.798325] [117/129] (497s left) intel_hwmon (hwmon-write)
[520.902842] Starting subtest: hwmon-write
[520.912915] Subtest hwmon-write: SUCCESS (0.011s)
[520.980451] [118/129] (497s left) dmabuf_sync_file (export-before-signal)
[521.034561] Starting subtest: export-before-signal
[521.035540] Subtest export-before-signal: SUCCESS (0.000s)
[521.049788] [119/129] (497s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[521.100951] Starting subtest: etime-multi-wait-available-unsubmitted
[521.203116] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.102s)
[521.263797] [120/129] (497s left) gem_ctx_persistence (engines-hang)
[521.338042] Starting subtest: engines-hang
[521.338975] Starting dynamic subtest: rcs0
[521.428138] Dynamic subtest rcs0: SUCCESS (0.090s)
[521.439765] Starting dynamic subtest: bcs0
[521.518993] Dynamic subtest bcs0: SUCCESS (0.090s)
[521.534401] Starting dynamic subtest: vcs0
[521.592089] Dynamic subtest vcs0: SUCCESS (0.072s)
[521.628247] Starting dynamic subtest: vcs1
[521.631398] Dynamic subtest vcs1: SUCCESS (0.037s)
[521.646057] Starting dynamic subtest: vecs0
[521.723657] Dynamic subtest vecs0: SUCCESS (0.092s)
[521.737250] Starting dynamic subtest: vecs1
[521.819468] Dynamic subtest vecs1: SUCCESS (0.094s)
[521.854054] Starting dynamic subtest: ccs0
[521.879370] Dynamic subtest ccs0: SUCCESS (0.058s)
[521.880690] Subtest engines-hang: SUCCESS (0.542s)
[521.984283] [121/129] (496s left) gem_mmap_gtt (basic-read-write)
[522.047577] Subtest basic-read-write: SKIP (0.000s)
[522.079597] [122/129] (496s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-cpu)
[522.269953] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-cpu
[524.088295] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (1.819s)
[524.167531] [123/129] (494s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[524.221633] Starting subtest: wait-all-for-submit-delayed-submit
[524.323004] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.101s)
[524.355174] [124/129] (494s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[524.554984] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[524.575066] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.019s)
[524.598104] [125/129] (494s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[524.862036] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[524.984817] [126/129] (493s left) kms_legacy_colorkey (basic)
[525.182100] Starting subtest: basic
[525.183123] Starting dynamic subtest: pipe-A
[525.248956] Dynamic subtest pipe-A: SUCCESS (0.066s)
[525.260254] Starting dynamic subtest: pipe-B
[525.261465] Dynamic subtest pipe-B: SUCCESS (0.000s)
[525.273304] Starting dynamic subtest: pipe-C
[525.274426] Dynamic subtest pipe-C: SUCCESS (0.000s)
[525.286385] Starting dynamic subtest: pipe-D
[525.287718] Dynamic subtest pipe-D: SUCCESS (0.000s)
[525.288953] Subtest basic: SUCCESS (0.070s)
[525.304244] [127/129] (493s left) gem_pxp (verify-pxp-stale-ctx-execution)
[527.892249] Subtest verify-pxp-stale-ctx-execution: SKIP (0.000s)
[527.913558] [128/129] (490s left) kms_flip (2x-plain-flip-interruptible)
[528.089689] Starting subtest: 2x-plain-flip-interruptible
[528.107660] Subtest 2x-plain-flip-interruptible: SKIP (0.017s)
[528.129378] [129/129] (490s left) kms_psr (pr-sprite-plane-onoff)
[528.316961] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[528.342472] Closing watchdogs
Done.