[56.635373] Initializing watchdogs
[56.635423]   /dev/watchdog0
[56.642309] [001/131] (960s left) kms_addfb_basic (basic-y-tiled-legacy)
[56.704344] Starting subtest: basic-y-tiled-legacy
[56.706384] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[56.853730] [002/131] (960s left) gem_exec_fence (syncobj-repeat)
[57.294791] Starting subtest: syncobj-repeat
[57.471428] Subtest syncobj-repeat: SUCCESS (0.175s)
[59.011871] [003/131] (958s left) syncobj_wait (reset-signaled)
[59.073070] Starting subtest: reset-signaled
[59.074214] Subtest reset-signaled: SUCCESS (0.000s)
[59.164721] [004/131] (958s left) kms_atomic_interruptible (atomic-setmode)
[59.265042] Starting subtest: atomic-setmode
[59.266074] Starting dynamic subtest: pipe-A-eDP-1
[66.123197] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.874s)
[66.124098] Subtest atomic-setmode: SUCCESS (6.875s)
[66.881928] [005/131] (950s left) gem_exec_schedule (preempt-queue-chain)
[66.945936] Subtest preempt-queue-chain: SKIP (0.000s)
[67.219320] [006/131] (949s left) kms_flip (dpms-off-confusion-interruptible)
[67.320133] Starting subtest: dpms-off-confusion-interruptible
[67.322254] Starting dynamic subtest: A-eDP1
[76.009054] Dynamic subtest A-eDP1: SUCCESS (8.693s)
[76.015933] Starting dynamic subtest: B-eDP1
[84.633537] Dynamic subtest B-eDP1: SUCCESS (8.625s)
[84.639613] Starting dynamic subtest: C-eDP1
[93.231319] Dynamic subtest C-eDP1: SUCCESS (8.598s)
[93.238728] Starting dynamic subtest: D-eDP1
[101.850075] Dynamic subtest D-eDP1: SUCCESS (8.618s)
[101.853644] Subtest dpms-off-confusion-interruptible: SUCCESS (34.541s)
[102.991147] [007/131] (914s left) kms_psr2_su (frontbuffer-xrgb8888)
[103.045361] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[103.081627] [008/131] (914s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[103.178599] Starting subtest: primary-yf-tiled-reflect-x-180
[103.239241] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.060s)
[103.316428] [009/131] (913s left) gem_linear_blits (basic)
[103.593815] Starting subtest: basic
[103.602395] Subtest basic: SUCCESS (0.009s)
[103.723022] [010/131] (913s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[103.855771] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[120.647224] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (16.791s)
[121.411114] [011/131] (895s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[126.374242] Starting subtest: pr-cursor-plane-update-sf
[126.376330] Subtest pr-cursor-plane-update-sf: SKIP (0.002s)
[127.210367] [012/131] (890s left) kms_hdr (static-swap)
[127.316595] Starting subtest: static-swap
[127.319459] Subtest static-swap: SKIP (0.000s)
[127.365639] [013/131] (889s left) kms_pm_backlight (fade-with-suspend)
[127.456953] Starting subtest: fade-with-suspend
[146.122432] Starting dynamic subtest: eDP-1
[148.790852] Dynamic subtest eDP-1: SUCCESS (2.670s)
[148.792002] Subtest fade-with-suspend: SUCCESS (6.232s)
[155.593595] [014/131] (882s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[155.704018] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[156.278496] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.581s)
[156.403684] [015/131] (882s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[156.582318] Starting subtest: cursor-rapid-movement-128x128
[156.585366] Starting dynamic subtest: pipe-A-eDP-1
[157.120689] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.540s)
[157.145833] Starting dynamic subtest: pipe-D-eDP-1
[158.282748] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.152s)
[158.283799] Subtest cursor-rapid-movement-128x128: SUCCESS (1.714s)
[159.106160] [016/131] (879s left) gem_mmap_wc (read-write)
[159.165636] Subtest read-write: SKIP (0.000s)
[159.207375] [017/131] (879s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[159.276208] Starting subtest: etime-single-wait-available-unsubmitted
[159.386266] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.108s)
[159.437327] [018/131] (879s left) kms_big_fb (linear-32bpp-rotate-180)
[159.533127] Starting subtest: linear-32bpp-rotate-180
[160.836100] Subtest linear-32bpp-rotate-180: SUCCESS (1.311s)
[160.959176] [019/131] (877s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[161.058790] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[161.060471] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[161.127923] [020/131] (877s left) gem_fence_thrash (bo-copy)
[161.159541] Starting subtest: bo-copy
[161.186145] Subtest bo-copy: SKIP (0.026s)
[161.224326] [021/131] (877s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[161.322488] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[161.324179] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[161.405428] [022/131] (877s left) gem_exec_reloc (basic-cpu)
[161.465231] Subtest basic-cpu: SKIP (0.000s)
[161.524773] [023/131] (876s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[161.633445] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[164.061798] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (2.441s)
[164.177215] [024/131] (874s left) kms_chamelium_hpd (dp-hpd)
[164.553571] Subtest dp-hpd: SKIP (0.000s)
[165.306773] [025/131] (873s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[165.406943] Starting subtest: fbcpsr-indfb-scaledprimary
[171.027548] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.636s)
[171.175929] [026/131] (867s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[171.270690] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[171.272356] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[171.357027] [027/131] (867s left) kms_atomic (plane-primary-legacy)
[171.446749] Starting subtest: plane-primary-legacy
[171.447838] Starting dynamic subtest: pipe-A-eDP-1
[171.887958] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.440s)
[171.888818] Subtest plane-primary-legacy: SUCCESS (0.441s)
[172.678963] [028/131] (865s left) kms_cdclk (mode-transition-all-outputs)
[172.778645] Starting subtest: mode-transition-all-outputs
[173.068995] Subtest mode-transition-all-outputs: SKIP (0.289s)
[173.907783] [029/131] (864s left) kms_vblank (ts-continuation-idle-hang)
[174.008523] Starting subtest: ts-continuation-idle-hang
[174.010569] Starting dynamic subtest: pipe-A-eDP-1
[200.796859] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.793s)
[200.805699] Starting dynamic subtest: pipe-D-eDP-1
[225.760552] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.969s)
[225.761620] Subtest ts-continuation-idle-hang: SUCCESS (51.768s)
[226.530810] [030/131] (812s left) vgem_basic (bad-handle)
[226.573362] Starting subtest: bad-handle
[226.574277] Subtest bad-handle: SUCCESS (0.000s)
[226.610046] [031/131] (811s left) sw_sync (sync_merge)
[226.643834] Starting subtest: sync_merge
[226.644947] Subtest sync_merge: SUCCESS (0.000s)
[226.676330] [032/131] (811s left) kms_big_fb (yf-tiled-addfb)
[226.770120] Starting subtest: yf-tiled-addfb
[226.771868] Subtest yf-tiled-addfb: SKIP (0.000s)
[226.839279] [033/131] (811s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[226.927771] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[226.930145] Starting dynamic subtest: pipe-A-default-mode
[228.102483] Dynamic subtest pipe-A-default-mode: SKIP (1.172s)
[228.104545] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.173s)
[228.231915] [034/131] (810s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[228.334839] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[228.336774] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[228.407092] [035/131] (810s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[228.455847] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[228.456890] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[228.547360] [036/131] (810s left) perf_pmu (idle)
[228.585982] Starting subtest: idle
[228.587521] Starting dynamic subtest: rcs0
[229.161939] Dynamic subtest rcs0: SUCCESS (0.573s)
[229.171545] Starting dynamic subtest: bcs0
[229.684129] Dynamic subtest bcs0: SUCCESS (0.520s)
[229.693880] Starting dynamic subtest: vcs0
[230.212125] Dynamic subtest vcs0: SUCCESS (0.527s)
[230.220808] Starting dynamic subtest: vcs1
[230.743529] Dynamic subtest vcs1: SUCCESS (0.530s)
[230.753131] Starting dynamic subtest: vecs0
[231.270895] Dynamic subtest vecs0: SUCCESS (0.526s)
[231.279965] Starting dynamic subtest: ccs0
[231.792909] Dynamic subtest ccs0: SUCCESS (0.521s)
[231.794573] Subtest idle: SUCCESS (3.206s)
[231.888612] [037/131] (806s left) gem_lmem_swapping (verify-random)
[231.930617] Subtest verify-random: SKIP (0.000s)
[231.947437] [038/131] (806s left) gem_userptr_blits (stress-purge)
[232.023980] Starting subtest: stress-purge
[237.405016] Subtest stress-purge: SUCCESS (5.385s)
[237.536783] [039/131] (801s left) gem_softpin (evict-active)
[237.628966] Starting subtest: evict-active
[237.638393] Subtest evict-active: SUCCESS (0.010s)
[237.775204] [040/131] (800s left) debugfs_test (read_all_entries_display_on)
[237.890700] Starting subtest: read_all_entries_display_on
[238.240080] Subtest read_all_entries_display_on: SUCCESS (0.349s)
[238.353838] [041/131] (800s left) sysfs_heartbeat_interval (idempotent)
[238.413182] Starting subtest: idempotent
[238.414343] Starting dynamic subtest: vecs0
[238.415409] Dynamic subtest vecs0: SUCCESS (0.001s)
[238.423944] Starting dynamic subtest: ccs0
[238.424892] Dynamic subtest ccs0: SUCCESS (0.001s)
[238.431983] Starting dynamic subtest: vcs0
[238.432917] Dynamic subtest vcs0: SUCCESS (0.000s)
[238.440074] Starting dynamic subtest: bcs0
[238.441030] Dynamic subtest bcs0: SUCCESS (0.001s)
[238.447818] Starting dynamic subtest: rcs0
[238.448754] Dynamic subtest rcs0: SUCCESS (0.000s)
[238.455606] Starting dynamic subtest: vcs1
[238.456542] Dynamic subtest vcs1: SUCCESS (0.000s)
[238.457458] Subtest idempotent: SUCCESS (0.006s)
[238.523381] [042/131] (800s left) gem_readwrite (write-bad-handle)
[238.581671] Subtest write-bad-handle: SKIP (0.000s)
[238.624934] [043/131] (800s left) syncobj_wait (invalid-wait-bad-flags)
[238.695303] Starting subtest: invalid-wait-bad-flags
[238.696338] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[238.792147] [044/131] (800s left) gem_userptr_blits (dmabuf-unsync)
[238.846841] Subtest dmabuf-unsync: SKIP (0.000s)
[238.986609] [045/131] (799s left) sw_sync (sync_busy_fork)
[239.020052] Starting subtest: sync_busy_fork
[240.035739] Subtest sync_busy_fork: SUCCESS (1.014s)
[240.075991] [046/131] (798s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[240.170933] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[240.171845] Starting dynamic subtest: pipe-A-eDP-1
[240.180309] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[240.187751] Starting dynamic subtest: pipe-B-eDP-1
[240.196144] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[240.203873] Starting dynamic subtest: pipe-C-eDP-1
[240.211922] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[240.218619] Starting dynamic subtest: pipe-D-eDP-1
[240.227119] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[240.228782] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[242.297391] [047/131] (796s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[242.406309] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[242.408431] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[242.477562] [048/131] (796s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[242.584378] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[242.586140] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[242.657882] [049/131] (796s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[242.762219] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[242.763901] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[242.841011] [050/131] (796s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[242.934939] Starting subtest: psr-dirtyfb-ioctl
[242.935991] Starting dynamic subtest: A-eDP-1
[244.730457] Dynamic subtest A-eDP-1: SUCCESS (1.794s)
[244.731673] Subtest psr-dirtyfb-ioctl: SUCCESS (1.796s)
[245.528586] [051/131] (793s left) gem_flink_basic (bad-open)
[245.582374] Starting subtest: bad-open
[245.583625] Subtest bad-open: SUCCESS (0.000s)
[245.685626] [052/131] (793s left) kms_psr (fbc-pr-sprite-plane-onoff)
[245.779917] Starting subtest: fbc-pr-sprite-plane-onoff
[245.782042] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[245.831339] [053/131] (793s left) syncobj_wait (invalid-single-wait-unsubmitted)
[245.884715] Starting subtest: invalid-single-wait-unsubmitted
[245.886027] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[245.971493] [054/131] (792s left) gen9_exec_parse (allowed-single)
[246.029886] Subtest allowed-single: SKIP (0.000s)
[246.082210] [055/131] (792s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[246.134917] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[246.136091] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[246.232788] [056/131] (792s left) i915_query (query-topology-unsupported)
[246.283838] Starting subtest: query-topology-unsupported
[246.286263] Subtest query-topology-unsupported: SKIP (0.000s)
[246.381182] [057/131] (792s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[246.480709] Starting subtest: bad-pixel-format-yf-tiled-ccs
[246.481645] Starting dynamic subtest: pipe-A-eDP-1
[246.490434] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[246.498646] Starting dynamic subtest: pipe-B-eDP-1
[246.507439] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[246.515108] Starting dynamic subtest: pipe-C-eDP-1
[246.523733] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[246.530834] Starting dynamic subtest: pipe-D-eDP-1
[246.539802] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[246.541547] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.003s)
[248.578420] [058/131] (790s left) kms_legacy_colorkey (invalid-plane)
[248.675699] Starting subtest: invalid-plane
[248.676575] Starting dynamic subtest: zero-id
[248.677418] Dynamic subtest zero-id: SUCCESS (0.000s)
[248.684671] Starting dynamic subtest: outrange-id
[248.685498] Dynamic subtest outrange-id: SUCCESS (0.000s)
[248.686342] Subtest invalid-plane: SUCCESS (0.001s)
[248.725389] [059/131] (790s left) gem_lmem_swapping (massive-random)
[248.768874] Subtest massive-random: SKIP (0.000s)
[248.789235] [060/131] (790s left) i915_hangman (error-state-basic)
[248.843785] Starting subtest: error-state-basic
[248.951552] Subtest error-state-basic: SUCCESS (0.108s)
[249.003552] [061/131] (790s left) gem_userptr_blits (nohangcheck)
[249.071647] Starting subtest: nohangcheck
[249.330509] Subtest nohangcheck: SUCCESS (0.257s)
[249.435172] [062/131] (789s left) gem_userptr_blits (coherency-sync)
[249.504766] Starting subtest: coherency-sync
[249.658359] Subtest coherency-sync: SKIP (0.134s)
[249.754423] [063/131] (789s left) kms_flip (blocking-wf_vblank)
[249.885617] Starting subtest: blocking-wf_vblank
[249.887860] Starting dynamic subtest: A-eDP1
[258.844585] Dynamic subtest A-eDP1: SUCCESS (8.953s)
[258.854865] Starting dynamic subtest: B-eDP1
[267.769505] Dynamic subtest B-eDP1: SUCCESS (8.922s)
[267.779529] Starting dynamic subtest: C-eDP1
[276.681708] Dynamic subtest C-eDP1: SUCCESS (8.909s)
[276.697392] Starting dynamic subtest: D-eDP1
[285.602782] Dynamic subtest D-eDP1: SUCCESS (8.919s)
[285.607417] Subtest blocking-wf_vblank: SUCCESS (35.714s)
[286.803445] [064/131] (752s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[286.862662] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[286.904537] [065/131] (752s left) drm_fdinfo (memory-info-purgeable)
[286.943206] Starting subtest: memory-info-purgeable
[286.944131] Starting dynamic subtest: smem0
[289.779118] Dynamic subtest smem0: SUCCESS (2.835s)
[289.780694] Subtest memory-info-purgeable: SUCCESS (2.836s)
[289.833834] [066/131] (749s left) gem_ctx_persistence (userptr)
[289.884542] Starting subtest: userptr
[290.111879] Subtest userptr: SUCCESS (0.226s)
[290.169315] [067/131] (749s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[290.269878] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[290.270914] Starting dynamic subtest: pipe-A-default-mode
[291.370171] Dynamic subtest pipe-A-default-mode: SKIP (1.097s)
[291.372045] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.099s)
[291.515272] [068/131] (747s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[291.610269] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[291.611935] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[291.707500] [069/131] (747s left) prime_vgem (fence-wait)
[291.795744] Starting subtest: fence-wait
[291.796852] Starting dynamic subtest: rcs0
[292.848412] Dynamic subtest rcs0: SUCCESS (1.050s)
[292.858730] Starting dynamic subtest: bcs0
[293.901025] Dynamic subtest bcs0: SUCCESS (1.051s)
[293.909702] Starting dynamic subtest: vcs0
[294.950563] Dynamic subtest vcs0: SUCCESS (1.048s)
[294.959304] Starting dynamic subtest: vcs1
[295.994148] Dynamic subtest vcs1: SUCCESS (1.042s)
[296.002359] Starting dynamic subtest: vecs0
[297.037133] Dynamic subtest vecs0: SUCCESS (1.041s)
[297.046040] Starting dynamic subtest: ccs0
[298.975469] Dynamic subtest ccs0: SUCCESS (1.936s)
[298.976710] Subtest fence-wait: SUCCESS (7.178s)
[299.093764] [070/131] (740s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[299.198966] Starting subtest: y-tiled-32bpp-rotate-90
[299.200827] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[299.275580] [071/131] (739s left) kms_content_protection (dp-mst-lic-type-0)
[299.424691] Starting subtest: dp-mst-lic-type-0
[299.427825] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[299.529861] [072/131] (739s left) kms_psr (fbc-psr2-suspend)
[299.617889] Starting subtest: fbc-psr2-suspend
[299.618994] Starting dynamic subtest: eDP-1
[299.621003] Dynamic subtest eDP-1: SKIP (0.000s)
[299.622796] Subtest fbc-psr2-suspend: SKIP (0.001s)
[299.670963] [073/131] (739s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[299.776828] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[304.806833] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (5.032s)
[304.922129] [074/131] (734s left) kms_chamelium_audio (hdmi-audio-edid)
[305.298803] Subtest hdmi-audio-edid: SKIP (0.000s)
[306.075285] [075/131] (733s left) kms_plane_alpha_blend (alpha-opaque-fb)
[306.169891] Starting subtest: alpha-opaque-fb
[306.449654] Starting dynamic subtest: pipe-A-eDP-1
[307.058712] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.609s)
[307.066590] Starting dynamic subtest: pipe-D-eDP-1
[308.348118] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.288s)
[308.349115] Subtest alpha-opaque-fb: SUCCESS (2.178s)
[309.148919] [076/131] (730s left) syncobj_wait (single-wait-all-signaled)
[309.199266] Starting subtest: single-wait-all-signaled
[309.200224] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[309.292532] [077/131] (730s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[309.391889] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[309.392964] Starting dynamic subtest: pipe-A-eDP-1
[309.402046] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[309.410139] Starting dynamic subtest: pipe-B-eDP-1
[309.418425] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[309.425895] Starting dynamic subtest: pipe-C-eDP-1
[309.434032] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[309.441530] Starting dynamic subtest: pipe-D-eDP-1
[309.450050] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[309.451779] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[311.496849] [078/131] (727s left) gem_mmap_offset (mmap-unmap)
[311.547677] Starting subtest: mmap-unmap
[311.548547] Starting dynamic subtest: smem0
[333.692849] Dynamic subtest smem0: SUCCESS (22.148s)
[333.694478] Subtest mmap-unmap: SUCCESS (22.149s)
[333.793460] [079/131] (705s left) i915_query (query-topology-garbage-items)
[333.848207] Starting subtest: query-topology-garbage-items
[333.849392] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[333.949413] [080/131] (705s left) kms_addfb_basic (addfb25-bad-modifier)
[334.013138] Starting subtest: addfb25-bad-modifier
[334.014159] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[334.139661] [081/131] (705s left) gem_exec_balancer (nop)
[334.203364] Starting subtest: nop
[380.612032] Subtest nop: SUCCESS (46.419s)
[380.865194] [082/131] (658s left) gem_workarounds (reset-fd)
[380.924339] Starting subtest: reset-fd
[381.109116] Subtest reset-fd: SUCCESS (0.185s)
[381.230678] [083/131] (658s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[381.353956] Starting subtest: short-busy-flip-before-cursor-toggle
[381.355772] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[381.444464] [084/131] (658s left) gem_exec_whisper (basic-queues-priority)
[381.501110] Starting subtest: basic-queues-priority
[405.907814] Subtest basic-queues-priority: SUCCESS (24.393s)
[406.069351] [085/131] (633s left) kms_invalid_mode (bad-vtotal)
[406.164428] Starting subtest: bad-vtotal
[406.165246] Starting dynamic subtest: pipe-A-eDP-1
[406.446996] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s)
[406.455244] Starting dynamic subtest: pipe-B-eDP-1
[406.456331] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[406.465503] Starting dynamic subtest: pipe-C-eDP-1
[406.466452] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[406.474064] Starting dynamic subtest: pipe-D-eDP-1
[406.475518] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[406.476664] Subtest bad-vtotal: SUCCESS (0.287s)
[407.211209] [086/131] (632s left) gem_sync (basic-each)
[407.276428] Starting subtest: basic-each
[409.655289] Subtest basic-each: SUCCESS (2.379s)
[409.818623] [087/131] (629s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[409.915926] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[409.916863] Starting dynamic subtest: pipe-A-eDP-1
[410.134674] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.205s)
[410.143260] Starting dynamic subtest: pipe-B-eDP-1
[411.369721] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.234s)
[411.377985] Starting dynamic subtest: pipe-C-eDP-1
[412.575464] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.206s)
[412.583662] Starting dynamic subtest: pipe-D-eDP-1
[413.799795] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.221s)
[413.800756] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.870s)
[414.918884] [088/131] (624s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[414.987924] Starting subtest: multi-wait-all-for-submit-signaled
[414.988958] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[415.076467] [089/131] (624s left) gem_ctx_exec (basic-norecovery)
[415.123286] Starting subtest: basic-norecovery
[415.487820] Subtest basic-norecovery: SUCCESS (0.364s)
[415.579529] [090/131] (623s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[415.668434] Starting subtest: fbcpsr-stridechange
[419.690989] Subtest fbcpsr-stridechange: SUCCESS (4.023s)
[419.807538] [091/131] (619s left) gem_ringfill (legacy-basic)
[425.000554] Starting subtest: legacy-basic
[425.001776] Starting dynamic subtest: default
[425.066738] Dynamic subtest default: SUCCESS (0.065s)
[425.076821] Starting dynamic subtest: render
[425.107916] Dynamic subtest render: SUCCESS (0.040s)
[425.116674] Starting dynamic subtest: bsd
[425.148624] Dynamic subtest bsd: SUCCESS (0.039s)
[425.157688] Starting dynamic subtest: bsd1
[425.191728] Dynamic subtest bsd1: SUCCESS (0.041s)
[425.201400] Starting dynamic subtest: bsd2
[425.230608] Dynamic subtest bsd2: SUCCESS (0.037s)
[425.239481] Starting dynamic subtest: blt
[425.273530] Dynamic subtest blt: SUCCESS (0.041s)
[425.286115] Starting dynamic subtest: vebox
[425.316723] Dynamic subtest vebox: SUCCESS (0.041s)
[425.317921] Subtest legacy-basic: SUCCESS (0.318s)
[425.373467] [092/131] (614s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[425.470037] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[430.747249] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (5.278s)
[430.871934] [093/131] (608s left) kms_plane_scaling (planes-upscale-20x20)
[430.974916] Starting subtest: planes-upscale-20x20
[430.975973] Starting dynamic subtest: pipe-A
[431.041266] Dynamic subtest pipe-A: SUCCESS (0.066s)
[431.056414] Starting dynamic subtest: pipe-B
[432.149461] Dynamic subtest pipe-B: SUCCESS (1.106s)
[432.159027] Starting dynamic subtest: pipe-C
[433.255306] Dynamic subtest pipe-C: SUCCESS (1.105s)
[433.266120] Starting dynamic subtest: pipe-D
[434.377850] Dynamic subtest pipe-D: SUCCESS (1.121s)
[434.378795] Subtest planes-upscale-20x20: SUCCESS (3.403s)
[435.513688] [094/131] (604s left) i915_pm_rps (waitboost)
[435.570789] Starting subtest: waitboost
[435.602608] Subtest waitboost: FAIL (0.014s)
[435.627338] [095/131] (604s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[435.722865] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[435.723947] Starting dynamic subtest: pipe-A
[435.730043] Dynamic subtest pipe-A: SKIP (0.004s)
[435.738760] Starting dynamic subtest: pipe-B
[435.745384] Dynamic subtest pipe-B: SKIP (0.015s)
[435.753160] Starting dynamic subtest: pipe-C
[435.761149] Dynamic subtest pipe-C: SKIP (0.015s)
[435.768837] Starting dynamic subtest: pipe-D
[435.776716] Dynamic subtest pipe-D: SKIP (0.015s)
[435.778459] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.052s)
[435.873802] [096/131] (603s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[435.975038] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[435.976759] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[436.052389] [097/131] (603s left) gem_fence_thrash (bo-write-verify-threaded-none)
[436.083439] Starting subtest: bo-write-verify-threaded-none
[436.109806] Subtest bo-write-verify-threaded-none: SKIP (0.025s)
[436.155918] [098/131] (603s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[436.254075] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[436.254995] Starting dynamic subtest: pipe-A-default-mode
[436.540450] Dynamic subtest pipe-A-default-mode: SKIP (0.284s)
[436.542209] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.286s)
[437.335924] [099/131] (602s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[437.442937] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[437.444641] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[437.550472] [100/131] (602s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[437.665019] Starting subtest: cursorB-vs-flipA-varying-size
[437.667940] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[437.813204] [101/131] (601s left) sw_sync (sync_multi_consumer)
[437.846075] Starting subtest: sync_multi_consumer
[438.335181] Subtest sync_multi_consumer: SUCCESS (0.487s)
[438.372415] [102/131] (601s left) syncobj_eventfd (timeline-wait-signaled)
[438.436983] Starting subtest: timeline-wait-signaled
[438.437888] Subtest timeline-wait-signaled: SUCCESS (0.001s)
[438.535021] [103/131] (601s left) api_intel_bb (crc32)
[438.584320] Starting subtest: crc32
[438.585360] Starting dynamic subtest: rcs0-smem0
[438.861740] Dynamic subtest rcs0-smem0: SUCCESS (0.276s)
[438.872603] Starting dynamic subtest: bcs0-smem0
[439.206142] Dynamic subtest bcs0-smem0: SUCCESS (0.342s)
[439.217297] Starting dynamic subtest: vcs0-smem0
[439.525895] Dynamic subtest vcs0-smem0: SUCCESS (0.317s)
[439.536021] Starting dynamic subtest: vcs1-smem0
[439.853488] Dynamic subtest vcs1-smem0: SUCCESS (0.325s)
[439.863964] Starting dynamic subtest: vecs0-smem0
[440.211958] Dynamic subtest vecs0-smem0: SUCCESS (0.356s)
[440.222484] Starting dynamic subtest: ccs0-smem0
[440.534772] Dynamic subtest ccs0-smem0: SUCCESS (0.320s)
[440.536294] Subtest crc32: SUCCESS (1.950s)
[440.636288] [104/131] (599s left) gem_partial_pwrite_pread (write-display)
[440.685043] Subtest write-display: SKIP (0.000s)
[440.742315] [105/131] (599s left) gem_exec_fence (keep-in-fence)
[440.919007] Starting subtest: keep-in-fence
[440.920417] Starting dynamic subtest: rcs0
[440.993892] Dynamic subtest rcs0: SUCCESS (0.074s)
[441.005087] Starting dynamic subtest: bcs0
[441.051683] Dynamic subtest bcs0: SUCCESS (0.056s)
[441.062414] Starting dynamic subtest: vcs0
[443.047435] Dynamic subtest vcs0: SUCCESS (1.991s)
[443.058534] Starting dynamic subtest: vcs1
[445.030926] Dynamic subtest vcs1: SUCCESS (1.981s)
[445.041609] Starting dynamic subtest: vecs0
[447.015053] Dynamic subtest vecs0: SUCCESS (1.982s)
[447.026126] Starting dynamic subtest: ccs0
[447.242377] Dynamic subtest ccs0: SUCCESS (0.228s)
[447.243531] Subtest keep-in-fence: SUCCESS (6.324s)
[449.152183] [106/131] (590s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[449.243595] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[449.245408] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[449.341538] [107/131] (590s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[449.437826] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[449.439885] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[449.540992] [108/131] (590s left) kms_sequence (queue-busy)
[449.633883] Starting subtest: queue-busy
[449.634920] Starting dynamic subtest: pipe-A-eDP-1
[451.568546] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.932s)
[451.576472] Starting dynamic subtest: pipe-B-eDP-1
[454.130708] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.562s)
[454.139108] Starting dynamic subtest: pipe-C-eDP-1
[456.750593] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.619s)
[456.759088] Starting dynamic subtest: pipe-D-eDP-1
[459.269634] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.517s)
[459.270600] Subtest queue-busy: SUCCESS (9.635s)
[460.035499] [109/131] (579s left) gem_pxp (reject-modify-context-protection-off-2)
[460.162387] Starting subtest: reject-modify-context-protection-off-2
[460.163545] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[461.266124] [110/131] (578s left) kms_psr (psr-cursor-mmap-cpu)
[461.359467] Starting subtest: psr-cursor-mmap-cpu
[461.360414] Starting dynamic subtest: eDP-1
[463.038746] Dynamic subtest eDP-1: SUCCESS (1.679s)
[463.039887] Subtest psr-cursor-mmap-cpu: SUCCESS (1.680s)
[463.883100] [111/131] (576s left) gem_exec_schedule (implicit-boths)
[463.957119] Starting subtest: implicit-boths
[463.958109] Starting dynamic subtest: rcs0
[464.059035] Dynamic subtest rcs0: SUCCESS (0.101s)
[464.069671] Starting dynamic subtest: vcs0
[464.144798] Dynamic subtest vcs0: SUCCESS (0.085s)
[464.155812] Starting dynamic subtest: vcs1
[464.216377] Dynamic subtest vcs1: SUCCESS (0.071s)
[464.227123] Starting dynamic subtest: vecs0
[464.289580] Dynamic subtest vecs0: SUCCESS (0.073s)
[464.300180] Starting dynamic subtest: ccs0
[464.373447] Dynamic subtest ccs0: SUCCESS (0.084s)
[464.375020] Subtest implicit-boths: SUCCESS (0.416s)
[466.104489] [112/131] (573s left) template (a)
[466.154235] Starting subtest: A
[466.155153] Subtest A: SUCCESS (0.000s)
[466.246971] [113/131] (573s left) gem_pxp (display-protected-crc)
[467.345869] Starting subtest: display-protected-crc
[468.923041] Subtest display-protected-crc: SUCCESS (1.577s)
[469.018168] [114/131] (570s left) kms_psr (pr-sprite-mmap-cpu)
[469.120182] Starting subtest: pr-sprite-mmap-cpu
[469.121922] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[469.171409] [115/131] (570s left) gem_busy (extended)
[469.358014] Starting subtest: extended
[469.359401] Starting dynamic subtest: rcs0
[469.449579] Dynamic subtest rcs0: SUCCESS (0.092s)
[469.460496] Starting dynamic subtest: bcs0
[469.491163] Dynamic subtest bcs0: SUCCESS (0.040s)
[469.505568] Starting dynamic subtest: vcs0
[471.014475] Dynamic subtest vcs0: SUCCESS (1.519s)
[471.025719] Starting dynamic subtest: vcs1
[473.062898] Dynamic subtest vcs1: SUCCESS (2.046s)
[473.074041] Starting dynamic subtest: vecs0
[475.047433] Dynamic subtest vecs0: SUCCESS (1.982s)
[475.058357] Starting dynamic subtest: ccs0
[475.093472] Dynamic subtest ccs0: SUCCESS (0.047s)
[475.095076] Subtest extended: SUCCESS (5.737s)
[475.323346] [116/131] (564s left) gem_softpin (softpin)
[475.384810] Starting subtest: softpin
[507.672316] Subtest softpin: SUCCESS (32.286s)
[507.781439] [117/131] (532s left) gem_exec_schedule (u-semaphore-codependency)
[507.841265] Starting subtest: u-semaphore-codependency
[507.859090] Subtest u-semaphore-codependency: SUCCESS (0.018s)
[508.191473] [118/131] (531s left) kms_setmode (invalid-clone-single-crtc-stealing)
[508.235310] Starting subtest: invalid-clone-single-crtc-stealing
[508.238044] Subtest invalid-clone-single-crtc-stealing: SKIP (0.001s)
[508.322438] [119/131] (531s left) kms_vrr (max-min)
[508.423153] Starting subtest: max-min
[508.427348] Subtest max-min: SKIP (0.000s)
[508.475929] [120/131] (531s left) kms_color (ctm-max)
[508.594741] Starting subtest: ctm-max
[508.595674] Starting dynamic subtest: pipe-A-eDP-1
[509.260225] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.664s)
[509.271315] Starting dynamic subtest: pipe-B-eDP-1
[510.642863] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.382s)
[510.654270] Starting dynamic subtest: pipe-C-eDP-1
[511.919493] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.277s)
[511.927646] Starting dynamic subtest: pipe-D-eDP-1
[513.235790] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.315s)
[513.236794] Subtest ctm-max: SUCCESS (4.641s)
[514.085834] [121/131] (526s left) kms_prime (basic-crc-vgem)
[516.130511] Starting subtest: basic-crc-vgem
[516.131461] Starting dynamic subtest: second-to-first
[516.967643] Dynamic subtest second-to-first: SUCCESS (0.840s)
[516.968586] Subtest basic-crc-vgem: SUCCESS (0.841s)
[517.030613] [122/131] (523s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[517.148660] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[517.150705] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[517.215831] [123/131] (522s left) gem_userptr_blits (process-exit-busy)
[517.283509] Starting subtest: process-exit-busy
[517.298945] Subtest process-exit-busy: SUCCESS (0.015s)
[517.407734] [124/131] (522s left) kms_cursor_crc (cursor-onscreen-128x42)
[517.600799] Starting subtest: cursor-onscreen-128x42
[517.637240] Subtest cursor-onscreen-128x42: SKIP (0.034s)
[517.847147] [125/131] (522s left) gem_ctx_param (invalid-set-ringsize)
[517.890703] Starting subtest: invalid-set-ringsize
[517.891708] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[517.936885] [126/131] (522s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[520.161671] Starting subtest: modeset-non-lpsp-stress-no-wait
[520.206340] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.044s)
[520.504290] [127/131] (519s left) syncobj_timeline (single-wait-signaled)
[520.561851] Starting subtest: single-wait-signaled
[520.562969] Subtest single-wait-signaled: SUCCESS (0.000s)
[520.661169] [128/131] (519s left) kms_psr (psr-sprite-mmap-cpu)
[520.757923] Starting subtest: psr-sprite-mmap-cpu
[520.758860] Starting dynamic subtest: eDP-1
[522.535661] Dynamic subtest eDP-1: SUCCESS (1.776s)
[522.536540] Subtest psr-sprite-mmap-cpu: SUCCESS (1.777s)
[523.351865] [129/131] (516s left) gem_eio (create-ext)
[523.581523] Starting subtest: create-ext
[523.935734] Subtest create-ext: SUCCESS (0.357s)
[524.057041] [130/131] (516s left) drm_fdinfo (all-busy-check-all)
[524.095381] Starting subtest: all-busy-check-all
[524.098582] Subtest all-busy-check-all: SKIP (0.003s)
[524.141788] [131/131] (516s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[524.278296] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[525.144019] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (0.866s)
[525.268390] Closing watchdogs
Done.