[96.786748] Initializing watchdogs
[96.786791]   /dev/watchdog0
[96.800587] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[96.807188] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[96.809321] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[96.812904] [001/134] (960s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[96.928676] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[96.940656] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.010s)
[97.049296] [002/134] (960s left) kms_addfb_basic (invalid-get-prop-any)
[97.110025] Starting subtest: invalid-get-prop-any
[97.112306] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[97.250200] [003/134] (960s left) kms_plane (plane-panning-bottom-right)
[97.342559] Starting subtest: plane-panning-bottom-right
[97.344847] Starting dynamic subtest: pipe-A
[99.091213] Dynamic subtest pipe-A: SUCCESS (1.747s)
[99.099752] Starting dynamic subtest: pipe-B
[101.443075] Dynamic subtest pipe-B: SUCCESS (2.351s)
[101.445399] Subtest plane-panning-bottom-right: SUCCESS (4.101s)
[102.254715] [004/134] (955s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[102.352467] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[102.356792] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[102.430340] [005/134] (955s left) syncobj_eventfd (invalid-bad-pad)
[102.493125] Starting subtest: invalid-bad-pad
[102.495486] Subtest invalid-bad-pad: SUCCESS (0.000s)
[102.619284] [006/134] (954s left) kms_async_flips (test-time-stamp)
[102.723619] Starting subtest: test-time-stamp
[103.109492] Starting dynamic subtest: pipe-A-eDP-1
[103.875695] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.764s)
[104.250431] Starting dynamic subtest: pipe-B-eDP-1
[105.007877] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.761s)
[105.370398] Starting dynamic subtest: pipe-C-eDP-1
[106.138793] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.772s)
[106.497888] Starting dynamic subtest: pipe-D-eDP-1
[107.270568] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.776s)
[107.272964] Subtest test-time-stamp: SUCCESS (4.547s)
[108.451324] [007/134] (949s left) gem_fence_thrash (bo-copy)
[108.489067] Starting subtest: bo-copy
[108.506166] Subtest bo-copy: SKIP (0.013s)
[108.560521] [008/134] (949s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[108.649407] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[108.676630] Starting dynamic subtest: pipe-A-plane-0
[109.099037] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[109.106287] Starting dynamic subtest: pipe-A-plane-3
[109.365351] Dynamic subtest pipe-A-plane-3: SUCCESS (0.266s)
[109.373790] Starting dynamic subtest: pipe-A-plane-5
[109.377486] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[110.511681] Starting dynamic subtest: pipe-B-plane-0
[110.938707] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[110.947167] Starting dynamic subtest: pipe-B-plane-3
[111.194318] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[111.202787] Starting dynamic subtest: pipe-B-plane-5
[111.206976] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[111.517775] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.867s)
[112.390161] [009/134] (945s left) kms_psr (psr2-cursor-mmap-gtt)
[112.486895] Starting subtest: psr2-cursor-mmap-gtt
[112.489243] Starting dynamic subtest: eDP-1
[114.155395] Dynamic subtest eDP-1: SUCCESS (1.669s)
[114.157810] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.670s)
[114.961156] [010/134] (942s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[115.058355] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[115.062773] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[116.199518] [011/134] (941s left) gem_eio (wait-1us)
[116.417754] Starting subtest: wait-1us
[116.721992] Subtest wait-1us: SUCCESS (0.305s)
[116.889348] [012/134] (940s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[117.010441] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[117.014499] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[117.134477] [013/134] (940s left) kms_big_fb (y-tiled-addfb-size-overflow)
[117.233816] Starting subtest: y-tiled-addfb-size-overflow
[117.237453] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[117.352137] [014/134] (940s left) kms_cursor_crc (cursor-onscreen-max-size)
[117.661539] Starting subtest: cursor-onscreen-max-size
[117.667024] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[117.832863] [015/134] (939s left) gem_exec_schedule (u-semaphore-resolve)
[117.908585] Starting subtest: u-semaphore-resolve
[117.938042] Subtest u-semaphore-resolve: SUCCESS (0.036s)
[118.292710] [016/134] (939s left) kms_psr (fbc-pr-suspend)
[118.391318] Starting subtest: fbc-pr-suspend
[118.395784] Subtest fbc-pr-suspend: SKIP (0.000s)
[118.472840] [017/134] (939s left) kms_psr (psr-primary-mmap-gtt)
[118.576868] Starting subtest: psr-primary-mmap-gtt
[118.579172] Starting dynamic subtest: eDP-1
[119.989471] Dynamic subtest eDP-1: SKIP (1.409s)
[119.994432] Subtest psr-primary-mmap-gtt: SKIP (1.410s)
[120.175859] [018/134] (937s left) core_setmaster (master-drop-set-shared-fd)
[120.264248] Starting subtest: master-drop-set-shared-fd
[120.272842] Subtest master-drop-set-shared-fd: SUCCESS (0.011s)
[120.309087] [019/134] (937s left) kms_psr (fbc-psr2-sprite-render)
[120.400629] Starting subtest: fbc-psr2-sprite-render
[120.402856] Starting dynamic subtest: eDP-1
[120.407255] Dynamic subtest eDP-1: SKIP (0.000s)
[120.411680] Subtest fbc-psr2-sprite-render: SKIP (0.000s)
[120.483235] [020/134] (937s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[120.577067] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[124.250780] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.677s)
[125.438611] [021/134] (932s left) kms_flip (plain-flip-fb-recreate-interruptible)
[125.528771] Starting subtest: plain-flip-fb-recreate-interruptible
[125.531203] Starting dynamic subtest: A-eDP1
[134.427430] Dynamic subtest A-eDP1: SUCCESS (8.899s)
[134.435597] Starting dynamic subtest: B-eDP1
[143.246298] Dynamic subtest B-eDP1: SUCCESS (8.818s)
[143.255647] Starting dynamic subtest: C-eDP1
[152.064880] Dynamic subtest C-eDP1: SUCCESS (8.817s)
[152.074141] Starting dynamic subtest: D-eDP1
[160.905874] Dynamic subtest D-eDP1: SUCCESS (8.840s)
[160.910699] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.384s)
[162.088902] [022/134] (895s left) gem_render_copy_redux (interruptible)
[162.158144] Starting subtest: interruptible
[162.444339] Subtest interruptible: SUCCESS (0.289s)
[162.594848] [023/134] (895s left) syncobj_timeline (invalid-wait-illegal-handle)
[162.657177] Starting subtest: invalid-wait-illegal-handle
[162.659158] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[162.757569] [024/134] (895s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[162.867348] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[170.299029] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.433s)
[170.422433] [025/134] (887s left) gem_exec_reloc (basic-wc-read-active)
[170.489261] Subtest basic-wc-read-active: SKIP (0.000s)
[170.556180] [026/134] (887s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[170.612015] Starting subtest: multi-wait-for-submit-submitted-signaled
[170.614279] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[170.730270] [027/134] (887s left) kms_chamelium_hpd (hdmi-hpd-fast)
[171.111705] Subtest hdmi-hpd-fast: SKIP (0.000s)
[171.941068] [028/134] (886s left) kms_vblank (wait-forked-hang)
[172.042806] Starting subtest: wait-forked-hang
[172.045020] Starting dynamic subtest: pipe-A-eDP-1
[198.675275] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.628s)
[198.688888] Starting dynamic subtest: pipe-D-eDP-1
[213.660883] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.981s)
[213.662789] Subtest wait-forked-hang: SUCCESS (41.614s)
[214.508779] [029/134] (843s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[214.624674] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[214.628882] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[214.750805] [030/134] (843s left) kms_prop_blob (invalid-get-prop)
[214.811920] Starting subtest: invalid-get-prop
[214.813824] Subtest invalid-get-prop: SUCCESS (0.000s)
[214.937227] [031/134] (843s left) syncobj_timeline (etime-single-wait-all-submitted)
[214.998142] Starting subtest: etime-single-wait-all-submitted
[215.105700] Subtest etime-single-wait-all-submitted: SUCCESS (0.107s)
[215.200928] [032/134] (843s left) syncobj_timeline (single-wait-all-available-submitted)
[215.277629] Starting subtest: single-wait-all-available-submitted
[215.280041] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[215.412105] [033/134] (843s left) kms_content_protection (srm)
[215.552159] Starting subtest: srm
[215.559388] Subtest srm: SKIP (0.003s)
[215.707808] [034/134] (842s left) kms_vblank (query-forked-busy-hang)
[215.809065] Starting subtest: query-forked-busy-hang
[215.810952] Starting dynamic subtest: pipe-A-eDP-1
[242.635219] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.826s)
[242.648883] Starting dynamic subtest: pipe-D-eDP-1
[257.691468] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.052s)
[257.693681] Subtest query-forked-busy-hang: SUCCESS (41.881s)
[258.577187] [035/134] (800s left) i915_drm_fdinfo (busy-check-all)
[258.613763] Starting subtest: busy-check-all
[258.615880] Starting dynamic subtest: rcs0
[258.620370] Dynamic subtest rcs0: SKIP (0.005s)
[258.627696] Starting dynamic subtest: bcs0
[258.631946] Dynamic subtest bcs0: SKIP (0.000s)
[258.638839] Starting dynamic subtest: vcs0
[258.643089] Dynamic subtest vcs0: SKIP (0.000s)
[258.649854] Starting dynamic subtest: vcs1
[258.654130] Dynamic subtest vcs1: SKIP (0.000s)
[258.660669] Starting dynamic subtest: vecs0
[258.664704] Dynamic subtest vecs0: SKIP (0.000s)
[258.671299] Starting dynamic subtest: ccs0
[258.675351] Dynamic subtest ccs0: SKIP (0.000s)
[258.679247] Subtest busy-check-all: SKIP (0.009s)
[258.712354] [036/134] (799s left) kms_psr (fbc-pr-cursor-blt)
[258.844687] Starting subtest: fbc-pr-cursor-blt
[258.848955] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[258.939745] [037/134] (799s left) kms_psr (psr-cursor-blt)
[259.039691] Starting subtest: psr-cursor-blt
[259.041891] Starting dynamic subtest: eDP-1
[260.750556] Dynamic subtest eDP-1: SUCCESS (1.712s)
[260.752803] Subtest psr-cursor-blt: SUCCESS (1.712s)
[261.627353] [038/134] (797s left) gem_eio (hibernate)
[261.816406] Starting subtest: hibernate
[276.387215] Subtest hibernate: SUCCESS (14.570s)
[284.573056] [039/134] (782s left) api_intel_bb (purge-bb)
[284.666888] Starting subtest: purge-bb
[284.672028] Subtest purge-bb: SUCCESS (0.004s)
[284.828035] [040/134] (781s left) kms_properties (get_properties-sanity-non-atomic)
[284.933561] Starting subtest: get_properties-sanity-non-atomic
[284.935715] Subtest get_properties-sanity-non-atomic: SUCCESS (0.001s)
[285.022569] [041/134] (781s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[285.127380] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[285.500871] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[288.261608] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.759s)
[288.270434] Starting dynamic subtest: pipe-A-eDP-1-4
[290.447960] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.185s)
[290.458863] Starting dynamic subtest: pipe-A-eDP-1-4
[292.458596] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[292.474810] Starting dynamic subtest: pipe-A-eDP-1-x
[294.649900] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.190s)
[295.025344] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[297.789037] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.769s)
[297.800213] Starting dynamic subtest: pipe-B-eDP-1-4
[299.974816] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[299.985880] Starting dynamic subtest: pipe-B-eDP-1-4
[301.985700] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.010s)
[301.997058] Starting dynamic subtest: pipe-B-eDP-1-x
[304.175842] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.188s)
[304.545273] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[307.314296] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.776s)
[307.324357] Starting dynamic subtest: pipe-C-eDP-1-4
[309.488079] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[309.496809] Starting dynamic subtest: pipe-C-eDP-1-4
[311.499529] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s)
[311.515220] Starting dynamic subtest: pipe-C-eDP-1-x
[313.689120] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.188s)
[314.055810] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[316.837855] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.788s)
[316.850805] Starting dynamic subtest: pipe-D-eDP-1-4
[319.012839] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[319.024262] Starting dynamic subtest: pipe-D-eDP-1-4
[321.022671] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s)
[321.034714] Starting dynamic subtest: pipe-D-eDP-1-x
[323.201291] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s)
[323.204092] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.074s)
[324.445179] [042/134] (742s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[324.510595] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[324.514761] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[324.699129] [043/134] (742s left) gem_exec_balancer (indices)
[324.761467] Starting subtest: indices
[325.874621] Subtest indices: SUCCESS (1.111s)
[326.198925] [044/134] (740s left) gem_close_race (multigpu-basic-process)
[326.270417] Starting subtest: multigpu-basic-process
[326.274861] Subtest multigpu-basic-process: SKIP (0.000s)
[326.549098] [045/134] (740s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[326.656270] Starting subtest: fbc-1p-pri-indfb-multidraw
[339.863728] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (13.211s)
[341.261380] [046/134] (725s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[341.392267] Starting subtest: flip-vs-cursor-toggle
[349.778291] Subtest flip-vs-cursor-toggle: SUCCESS (8.385s)
[350.582881] [047/134] (716s left) gem_exec_reloc (basic-write-read-noreloc)
[350.659707] Subtest basic-write-read-noreloc: SKIP (0.000s)
[350.748781] [048/134] (716s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[350.846192] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[350.850580] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[350.964994] [049/134] (716s left) gem_exec_schedule (fifo)
[351.042617] Starting subtest: fifo
[351.044873] Starting dynamic subtest: rcs0
[351.126936] Dynamic subtest rcs0: SUCCESS (0.095s)
[351.139063] Starting dynamic subtest: vcs0
[351.201586] Dynamic subtest vcs0: SUCCESS (0.074s)
[351.212038] Starting dynamic subtest: vcs1
[351.275521] Dynamic subtest vcs1: SUCCESS (0.073s)
[351.287564] Starting dynamic subtest: vecs0
[351.348602] Dynamic subtest vecs0: SUCCESS (0.073s)
[351.360370] Starting dynamic subtest: ccs0
[351.433888] Dynamic subtest ccs0: SUCCESS (0.085s)
[351.436634] Subtest fifo: SUCCESS (0.403s)
[353.027546] [050/134] (714s left) kms_dsc (dsc-with-output-formats-with-bpc)
[353.119227] Starting subtest: dsc-with-output-formats-with-bpc
[353.178051] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[353.215716] [051/134] (713s left) gem_userptr_blits (sync-unmap)
[353.286257] Starting subtest: sync-unmap
[353.299742] Subtest sync-unmap: SUCCESS (0.013s)
[353.432906] [052/134] (713s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[353.532068] Starting subtest: random-ccs-data-yf-tiled-ccs
[353.534307] Starting dynamic subtest: pipe-A-eDP-1
[353.559539] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[353.570972] Starting dynamic subtest: pipe-B-eDP-1
[353.594777] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[353.605086] Starting dynamic subtest: pipe-C-eDP-1
[353.627845] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[353.636979] Starting dynamic subtest: pipe-D-eDP-1
[353.660607] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[353.664963] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.009s)
[355.838255] [053/134] (711s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[355.934189] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[360.062279] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.131s)
[361.258217] [054/134] (706s left) gem_exec_flush (basic-uc-prw-default)
[361.341528] Starting subtest: basic-uc-prw-default
[366.825443] Subtest basic-uc-prw-default: SUCCESS (5.485s)
[367.032664] [055/134] (700s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[367.136717] Starting subtest: x-tiled-16bpp-rotate-90
[367.156837] Subtest x-tiled-16bpp-rotate-90: SKIP (0.019s)
[367.302949] [056/134] (700s left) gem_exec_schedule (preempt-engines)
[367.369601] Starting subtest: preempt-engines
[367.371760] Starting dynamic subtest: rcs0
[369.590661] Dynamic subtest rcs0: SUCCESS (2.223s)
[369.601525] Starting dynamic subtest: bcs0
[371.786266] Dynamic subtest bcs0: SUCCESS (2.193s)
[371.795789] Starting dynamic subtest: vcs0
[374.075996] Dynamic subtest vcs0: SUCCESS (2.288s)
[374.090995] Starting dynamic subtest: vcs1
[376.343773] Dynamic subtest vcs1: SUCCESS (2.267s)
[376.352741] Starting dynamic subtest: vecs0
[378.586652] Dynamic subtest vecs0: SUCCESS (2.241s)
[378.595298] Starting dynamic subtest: ccs0
[380.893862] Dynamic subtest ccs0: SUCCESS (2.305s)
[380.896194] Subtest preempt-engines: SUCCESS (13.528s)
[381.201925] [057/134] (686s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[381.312491] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[381.316835] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[381.438466] [058/134] (686s left) kms_plane_cursor (primary)
[381.533228] Starting subtest: primary
[381.537614] Starting dynamic subtest: pipe-A-eDP-1-size-64
[384.106049] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.572s)
[384.128374] Starting dynamic subtest: pipe-A-eDP-1-size-128
[386.672228] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.549s)
[386.695881] Starting dynamic subtest: pipe-A-eDP-1-size-256
[389.251764] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.562s)
[389.573737] Starting dynamic subtest: pipe-B-eDP-1-size-64
[392.884291] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.322s)
[392.915090] Starting dynamic subtest: pipe-B-eDP-1-size-128
[395.485067] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.584s)
[395.511024] Starting dynamic subtest: pipe-B-eDP-1-size-256
[398.074091] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.570s)
[398.390743] Starting dynamic subtest: pipe-C-eDP-1-size-64
[401.200437] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.821s)
[401.228367] Starting dynamic subtest: pipe-C-eDP-1-size-128
[403.389870] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.170s)
[403.419277] Starting dynamic subtest: pipe-C-eDP-1-size-256
[405.578575] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.169s)
[405.895299] Starting dynamic subtest: pipe-D-eDP-1-size-64
[408.808344] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.923s)
[408.835424] Starting dynamic subtest: pipe-D-eDP-1-size-128
[411.008308] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.180s)
[411.035108] Starting dynamic subtest: pipe-D-eDP-1-size-256
[413.298582] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.271s)
[413.606146] Subtest primary: SUCCESS (32.072s)
[414.454646] [059/134] (653s left) gem_mmap_offset (ptrace)
[414.509966] Starting subtest: ptrace
[414.512326] Starting dynamic subtest: smem0-wb
[414.522315] Dynamic subtest smem0-wb: SUCCESS (0.011s)
[414.531709] Starting dynamic subtest: smem0-wc
[414.543753] Dynamic subtest smem0-wc: SUCCESS (0.021s)
[414.552094] Starting dynamic subtest: smem0-uc
[414.562870] Dynamic subtest smem0-uc: SUCCESS (0.018s)
[414.565071] Subtest ptrace: SUCCESS (0.055s)
[414.682163] [060/134] (652s left) dumb_buffer (map-invalid-size)
[414.740441] Starting subtest: map-invalid-size
[414.742511] Subtest map-invalid-size: SUCCESS (0.000s)
[414.871239] [061/134] (652s left) kms_plane_scaling (planes-upscale-factor-0-25)
[414.959550] Starting subtest: planes-upscale-factor-0-25
[414.961645] Starting dynamic subtest: pipe-A
[415.020375] Dynamic subtest pipe-A: SUCCESS (0.062s)
[415.030670] Starting dynamic subtest: pipe-B
[416.167244] Dynamic subtest pipe-B: SUCCESS (1.146s)
[416.179685] Starting dynamic subtest: pipe-C
[417.284422] Dynamic subtest pipe-C: SUCCESS (1.114s)
[417.295590] Starting dynamic subtest: pipe-D
[418.444872] Dynamic subtest pipe-D: SUCCESS (1.158s)
[418.447106] Subtest planes-upscale-factor-0-25: SUCCESS (3.488s)
[419.690426] [062/134] (647s left) syncobj_basic (bad-destroy)
[419.770412] Starting subtest: bad-destroy
[419.772899] Subtest bad-destroy: SUCCESS (0.000s)
[419.913377] [063/134] (647s left) sysfs_preempt_timeout (invalid)
[419.973455] Starting subtest: invalid
[419.975654] Starting dynamic subtest: vecs0
[419.977917] Dynamic subtest vecs0: SUCCESS (0.000s)
[419.988092] Starting dynamic subtest: ccs0
[419.989852] Dynamic subtest ccs0: SUCCESS (0.000s)
[419.997587] Starting dynamic subtest: vcs0
[419.999453] Dynamic subtest vcs0: SUCCESS (0.000s)
[420.007280] Starting dynamic subtest: bcs0
[420.009142] Dynamic subtest bcs0: SUCCESS (0.000s)
[420.017042] Starting dynamic subtest: rcs0
[420.018861] Dynamic subtest rcs0: SUCCESS (0.000s)
[420.027094] Starting dynamic subtest: vcs1
[420.029178] Dynamic subtest vcs1: SUCCESS (0.000s)
[420.031240] Subtest invalid: SUCCESS (0.005s)
[420.107296] [064/134] (647s left) gem_eio (in-flight-internal-10ms)
[420.330831] Starting subtest: in-flight-internal-10ms
[421.980681] Subtest in-flight-internal-10ms: SUCCESS (1.649s)
[422.150113] [065/134] (645s left) kms_pm_dc (dc5-dpms)
[423.250769] Starting subtest: dc5-dpms
[425.353319] Subtest dc5-dpms: SUCCESS (2.102s)
[425.449932] [066/134] (642s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[425.550589] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[425.554685] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[425.672131] [067/134] (642s left) gem_softpin (evict-single-offset)
[425.725777] Starting subtest: evict-single-offset
[453.909780] Subtest evict-single-offset: SUCCESS (28.181s)
[454.016321] [068/134] (613s left) gem_mmap_wc (write-cpu-read-wc)
[454.112605] Subtest write-cpu-read-wc: SKIP (0.000s)
[454.181530] [069/134] (613s left) kms_cursor_edge_walk (64x64-top-edge)
[454.300723] Starting subtest: 64x64-top-edge
[454.302940] Starting dynamic subtest: pipe-A-eDP-1
[457.766033] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.464s)
[457.775614] Starting dynamic subtest: pipe-D-eDP-1
[460.878064] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.111s)
[460.880169] Subtest 64x64-top-edge: SUCCESS (6.578s)
[461.700590] [070/134] (606s left) gem_lmem_swapping (verify-random-ccs)
[461.747970] Subtest verify-random-ccs: SKIP (0.000s)
[461.785447] [071/134] (606s left) gem_exec_reloc (basic-write-gtt-active)
[461.850440] Subtest basic-write-gtt-active: SKIP (0.000s)
[461.935392] [072/134] (606s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[462.523729] Starting subtest: syncobj-stationary-timeline-chain-engines
[462.643933] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.120s)
[463.972612] [FACT gem_exec_fence (syncobj-stationary-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[463.975887] [073/134] (604s left) prime_busy (before-wait)
[464.034579] Starting subtest: before-wait
[464.039627] Starting dynamic subtest: rcs0
[464.092159] Dynamic subtest rcs0: SUCCESS (0.053s)
[464.103103] Starting dynamic subtest: bcs0
[464.151157] Dynamic subtest bcs0: SUCCESS (0.058s)
[464.161207] Starting dynamic subtest: vcs0
[464.193081] Dynamic subtest vcs0: SUCCESS (0.041s)
[464.202064] Starting dynamic subtest: vcs1
[464.234143] Dynamic subtest vcs1: SUCCESS (0.041s)
[464.243073] Starting dynamic subtest: vecs0
[464.275588] Dynamic subtest vecs0: SUCCESS (0.041s)
[464.284892] Starting dynamic subtest: ccs0
[464.317521] Dynamic subtest ccs0: SUCCESS (0.041s)
[464.425386] Subtest before-wait: SUCCESS (0.389s)
[464.511543] [074/134] (603s left) perf_pmu (semaphore-wait-idle)
[464.557290] Starting subtest: semaphore-wait-idle
[464.559691] Starting dynamic subtest: rcs0
[465.069584] Dynamic subtest rcs0: SUCCESS (0.513s)
[465.082590] Starting dynamic subtest: bcs0
[465.585655] Dynamic subtest bcs0: SUCCESS (0.513s)
[465.598754] Starting dynamic subtest: vcs0
[466.100636] Dynamic subtest vcs0: SUCCESS (0.513s)
[466.113590] Starting dynamic subtest: vcs1
[466.612424] Dynamic subtest vcs1: SUCCESS (0.510s)
[466.625632] Starting dynamic subtest: vecs0
[467.127889] Dynamic subtest vecs0: SUCCESS (0.512s)
[467.141397] Starting dynamic subtest: ccs0
[467.643629] Dynamic subtest ccs0: SUCCESS (0.513s)
[467.646521] Subtest semaphore-wait-idle: SUCCESS (3.090s)
[468.972913] [075/134] (599s left) kms_lease (lease-unleased-crtc)
[469.072016] Starting subtest: lease-unleased-crtc
[469.074247] Starting dynamic subtest: pipe-A-eDP-1
[469.370230] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.298s)
[469.381086] Starting dynamic subtest: pipe-B-eDP-1
[470.151209] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.778s)
[470.161461] Starting dynamic subtest: pipe-C-eDP-1
[470.163608] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.005s)
[470.172696] Starting dynamic subtest: pipe-D-eDP-1
[470.174804] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.005s)
[470.176968] Subtest lease-unleased-crtc: SUCCESS (1.094s)
[470.548301] [076/134] (597s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[470.678461] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[470.682849] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[470.834614] [077/134] (597s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[470.900055] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[470.902271] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[471.045398] [078/134] (597s left) kms_prop_blob (blob-prop-lifetime)
[471.109502] Starting subtest: blob-prop-lifetime
[471.111697] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[471.234944] [079/134] (597s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[471.346231] Starting subtest: yf-tiled-8bpp-rotate-90
[471.350299] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[471.489122] [080/134] (596s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[471.719720] Starting subtest: cursor-rapid-movement-256x256
[471.723885] Starting dynamic subtest: pipe-A-eDP-1
[472.270370] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.543s)
[472.297439] Starting dynamic subtest: pipe-D-eDP-1
[473.431742] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.142s)
[473.434214] Subtest cursor-rapid-movement-256x256: SUCCESS (1.710s)
[474.307394] [081/134] (594s left) kms_vrr (negative-basic)
[474.404537] Starting subtest: negative-basic
[474.410869] Starting dynamic subtest: pipe-A-eDP-1
[479.824057] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.411s)
[480.129067] Subtest negative-basic: SUCCESS (5.726s)
[480.939263] [082/134] (587s left) i915_pm_rps (fence-order)
[481.008638] Starting subtest: fence-order
[483.897793] Subtest fence-order: SUCCESS (2.890s)
[484.039174] [083/134] (584s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[484.147431] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[484.151945] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[484.271620] [084/134] (584s left) gem_ctx_param (invalid-param-get)
[484.322761] Starting subtest: invalid-param-get
[484.325028] Subtest invalid-param-get: SUCCESS (0.001s)
[484.454682] [085/134] (584s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[484.515044] Starting subtest: single-wait-for-submit-unsubmitted
[484.615960] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[484.704293] [086/134] (583s left) i915_hangman (detector)
[484.769073] Starting subtest: detector
[484.771389] Starting dynamic subtest: rcs0
[494.899755] Dynamic subtest rcs0: SUCCESS (10.128s)
[494.911897] Starting dynamic subtest: bcs0
[506.867414] Dynamic subtest bcs0: SUCCESS (11.965s)
[506.880657] Starting dynamic subtest: vcs0
[518.835350] Dynamic subtest vcs0: SUCCESS (11.965s)
[518.847511] Starting dynamic subtest: vcs1
[529.843685] Dynamic subtest vcs1: SUCCESS (11.005s)
[529.855459] Starting dynamic subtest: vecs0
[541.810733] Dynamic subtest vecs0: SUCCESS (11.964s)
[541.823211] Starting dynamic subtest: ccs0
[552.882597] Dynamic subtest ccs0: SUCCESS (11.069s)
[552.885252] Subtest detector: SUCCESS (68.112s)
[552.975778] [087/134] (515s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[553.077548] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[554.100034] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.022s)
[554.256427] [088/134] (514s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[554.348832] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[554.352391] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[554.472733] [089/134] (514s left) kms_getfb (getfb-addfb-different-handles)
[554.571096] Starting subtest: getfb-addfb-different-handles
[554.572982] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[554.683288] [090/134] (514s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[554.772361] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[554.774240] Starting dynamic subtest: pipe-A-eDP-1
[554.791709] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[554.803300] Starting dynamic subtest: pipe-B-eDP-1
[554.819905] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[554.830686] Starting dynamic subtest: pipe-C-eDP-1
[554.847229] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[554.856623] Starting dynamic subtest: pipe-D-eDP-1
[554.872552] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[554.874265] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[557.088416] [091/134] (511s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[557.203681] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[557.849765] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.648s)
[558.032641] [092/134] (510s left) perf (mi-rpc)
[558.166222] Starting subtest: mi-rpc
[558.170482] Subtest mi-rpc: SKIP (0.000s)
[558.208065] [093/134] (510s left) kms_chamelium_edid (vga-edid-read)
[558.606858] Subtest vga-edid-read: SKIP (0.000s)
[559.394197] [094/134] (509s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[559.459415] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[559.546091] [095/134] (509s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[559.679394] Starting subtest: 2x-long-cursor-vs-flip-atomic
[559.683876] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[559.836460] [096/134] (509s left) sw_sync (sync_multi_consumer_producer)
[559.874172] Starting subtest: sync_multi_consumer_producer
[560.173995] Subtest sync_multi_consumer_producer: SUCCESS (0.300s)
[560.251826] [097/134] (508s left) gem_render_copy_redux (normal)
[560.308959] Starting subtest: normal
[560.595614] Subtest normal: SUCCESS (0.286s)
[560.759399] [098/134] (508s left) kms_color (ctm-signed)
[560.862755] Starting subtest: ctm-signed
[560.865041] Starting dynamic subtest: pipe-A-eDP-1
[562.987650] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.126s)
[562.998301] Starting dynamic subtest: pipe-B-eDP-1
[565.869820] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.879s)
[565.891386] Starting dynamic subtest: pipe-C-eDP-1
[568.563059] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.694s)
[568.580999] Starting dynamic subtest: pipe-D-eDP-1
[571.225762] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.661s)
[571.228093] Subtest ctm-signed: SUCCESS (10.364s)
[572.063263] [099/134] (497s left) gem_ctx_isolation (nonpriv-switch)
[572.120781] Starting subtest: nonpriv-switch
[572.123188] Starting dynamic subtest: rcs0
[572.388847] Dynamic subtest rcs0: SUCCESS (0.268s)
[572.398913] Starting dynamic subtest: bcs0
[572.693114] Dynamic subtest bcs0: SUCCESS (0.303s)
[572.703975] Starting dynamic subtest: vcs0
[572.994359] Dynamic subtest vcs0: SUCCESS (0.301s)
[573.006067] Starting dynamic subtest: vcs1
[574.155710] Dynamic subtest vcs1: SUCCESS (1.160s)
[574.167644] Starting dynamic subtest: vecs0
[576.215984] Dynamic subtest vecs0: SUCCESS (2.059s)
[576.226132] Starting dynamic subtest: ccs0
[578.289229] Dynamic subtest ccs0: SUCCESS (2.072s)
[578.291795] Subtest nonpriv-switch: SUCCESS (6.168s)
[578.561627] [100/134] (490s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[578.674597] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[579.652528] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (0.978s)
[579.808705] [101/134] (489s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[579.924233] Starting subtest: cursorA-vs-flipA-atomic
[591.041552] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.115s)
[591.911554] [102/134] (477s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[592.026932] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[592.031680] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[592.152387] [103/134] (477s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[592.249825] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[592.252120] Starting dynamic subtest: pipe-A-eDP-1
[592.261173] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[592.272374] Starting dynamic subtest: pipe-B-eDP-1
[592.281531] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[592.290709] Starting dynamic subtest: pipe-C-eDP-1
[592.299190] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[592.308261] Starting dynamic subtest: pipe-D-eDP-1
[592.316718] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[592.321085] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s)
[594.546791] [104/134] (474s left) prime_vgem (fence-flip-hang)
[594.638694] Subtest fence-flip-hang: SKIP (0.000s)
[594.796488] [105/134] (474s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[594.890583] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[594.894702] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[595.011535] [106/134] (474s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[595.105938] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[595.108224] Starting dynamic subtest: pipe-A-eDP-1
[595.127719] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[595.139639] Starting dynamic subtest: pipe-B-eDP-1
[595.158254] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[595.168060] Starting dynamic subtest: pipe-C-eDP-1
[595.186483] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[595.196862] Starting dynamic subtest: pipe-D-eDP-1
[595.216107] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[595.218272] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[597.420964] [107/134] (472s left) gem_ctx_param (invalid-ctx-set)
[597.478924] Starting subtest: invalid-ctx-set
[597.481371] Subtest invalid-ctx-set: SUCCESS (0.001s)
[597.602917] [108/134] (471s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[597.707536] Starting subtest: psr-rgb565-draw-pwrite
[604.717945] Subtest psr-rgb565-draw-pwrite: SUCCESS (7.014s)
[604.855270] [109/134] (464s left) gem_vm_create (isolation)
[604.918974] Starting subtest: isolation
[604.929283] Subtest isolation: SUCCESS (0.010s)
[605.109854] [110/134] (464s left) gem_pxp (reject-modify-context-protection-on)
[605.248596] Starting subtest: reject-modify-context-protection-on
[605.250963] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[605.382800] [111/134] (464s left) syncobj_wait (invalid-signal-illegal-handle)
[605.444420] Starting subtest: invalid-signal-illegal-handle
[605.446360] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[605.570125] [112/134] (464s left) gem_mmap_gtt (ptrace)
[605.641266] Subtest ptrace: SKIP (0.000s)
[605.711942] [113/134] (463s left) kms_plane_multiple (tiling-none)
[605.818306] Starting subtest: tiling-none
[605.820262] Starting dynamic subtest: pipe-A-eDP-1
[609.692621] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.872s)
[609.703048] Starting dynamic subtest: pipe-B-eDP-1
[614.265179] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.574s)
[614.274940] Starting dynamic subtest: pipe-C-eDP-1
[618.760282] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.491s)
[618.770677] Starting dynamic subtest: pipe-D-eDP-1
[623.178196] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.414s)
[623.180500] Subtest tiling-none: SUCCESS (17.359s)
[624.019935] [114/134] (445s left) gem_tiled_blits (normal)
[624.092522] Subtest normal: SKIP (0.000s)
[624.171527] [115/134] (445s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[624.266479] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[624.270774] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[624.376015] [116/134] (445s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[629.369791] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[629.372217] Starting dynamic subtest: pipe-A-eDP-1
[630.154984] Dynamic subtest pipe-A-eDP-1: SKIP (0.780s)
[630.165738] Starting dynamic subtest: pipe-B-eDP-1
[631.279413] Dynamic subtest pipe-B-eDP-1: SKIP (1.123s)
[631.284074] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.907s)
[632.481331] [117/134] (437s left) gem_exec_whisper (basic-forked-all)
[632.543599] Starting subtest: basic-forked-all
[645.843617] Subtest basic-forked-all: SUCCESS (13.297s)
[646.040426] [118/134] (423s left) kms_frontbuffer_tracking (fbc-abgr161616f-draw-pwrite)
[646.139639] Starting subtest: fbc-abgr161616f-draw-pwrite
[646.143740] Subtest fbc-abgr161616f-draw-pwrite: SKIP (0.000s)
[646.264881] [119/134] (423s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[646.357289] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[653.718657] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.364s)
[653.868461] [120/134] (416s left) i915_suspend (fence-restore-untiled)
[653.935758] Starting subtest: fence-restore-untiled
[653.940199] Subtest fence-restore-untiled: SKIP (0.000s)
[654.057435] [121/134] (416s left) gem_reg_read (timestamp-monotonic)
[654.124784] Starting subtest: timestamp-monotonic
[658.557670] Subtest timestamp-monotonic: SUCCESS (4.432s)
[658.645094] [122/134] (411s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[658.748824] Starting subtest: extended-pageflip-modeset-hang-oldfb
[658.750665] Starting dynamic subtest: pipe-A
[666.635927] Dynamic subtest pipe-A: SUCCESS (7.886s)
[666.645677] Starting dynamic subtest: pipe-D
[675.272741] Dynamic subtest pipe-D: SUCCESS (8.635s)
[675.275050] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.526s)
[676.143943] [123/134] (393s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[676.235798] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[682.728249] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.494s)
[682.878487] [124/134] (387s left) gem_ctx_persistence (saturated-hostile)
[682.942270] Starting subtest: saturated-hostile
[682.944681] Starting dynamic subtest: rcs0
[683.802055] Dynamic subtest rcs0: SUCCESS (0.854s)
[683.813376] Starting dynamic subtest: bcs0
[684.598211] Dynamic subtest bcs0: SUCCESS (0.798s)
[684.610886] Starting dynamic subtest: vcs0
[685.402374] Dynamic subtest vcs0: SUCCESS (0.803s)
[685.414997] Starting dynamic subtest: vcs1
[686.224363] Dynamic subtest vcs1: SUCCESS (0.819s)
[686.237316] Starting dynamic subtest: vecs0
[687.036662] Dynamic subtest vecs0: SUCCESS (0.810s)
[687.049042] Starting dynamic subtest: ccs0
[687.892537] Dynamic subtest ccs0: SUCCESS (0.854s)
[687.895129] Subtest saturated-hostile: SUCCESS (4.951s)
[687.998165] [125/134] (382s left) gen9_exec_parse (bb-large)
[688.062096] Subtest bb-large: SKIP (0.000s)
[688.132969] [126/134] (382s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[688.390681] Starting subtest: parallel-dmabuf-import-out-fence
[689.540718] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.150s)
[689.677174] [127/134] (380s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[689.787486] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[689.791639] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[689.892518] [128/134] (380s left) kms_hdr (static-swap)
[689.993976] Starting subtest: static-swap
[690.000605] Subtest static-swap: SKIP (0.000s)
[690.081475] [129/134] (380s left) gem_ctx_shared (single-timeline)
[690.143633] Starting subtest: single-timeline
[690.163475] Subtest single-timeline: SUCCESS (0.014s)
[690.408143] [130/134] (380s left) gem_exec_whisper (basic-queues-all)
[690.476936] Starting subtest: basic-queues-all
[699.891928] Subtest basic-queues-all: SUCCESS (9.411s)
[700.095723] [131/134] (370s left) kms_flip (2x-flip-vs-panning)
[700.202073] Starting subtest: 2x-flip-vs-panning
[700.213100] Subtest 2x-flip-vs-panning: SKIP (0.010s)
[700.348525] [132/134] (370s left) kms_lease (atomic-implicit-crtc)
[700.442516] Starting subtest: atomic-implicit-crtc
[700.444826] Starting dynamic subtest: pipe-A-eDP-1
[700.455397] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[700.468914] Starting dynamic subtest: pipe-B-eDP-1
[700.480868] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[700.498018] Starting dynamic subtest: pipe-C-eDP-1
[700.508256] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[700.518228] Starting dynamic subtest: pipe-D-eDP-1
[700.528784] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[700.530968] Subtest atomic-implicit-crtc: SUCCESS (0.053s)
[700.638171] [133/134] (369s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[700.770786] Starting subtest: modeset-atomic-cursor-hotspot
[700.775280] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[700.936532] [134/134] (369s left) syncobj_wait (single-wait-signaled)
[701.002607] Starting subtest: single-wait-signaled
[701.004914] Subtest single-wait-signaled: SUCCESS (0.000s)
[701.131898] Closing watchdogs
results: parsing output: 0/ for test: kms_flip
results: parsing output: 1/ for test: kms_addfb_basic
results: parsing output: 2/ for test: kms_plane
results: parsing output: 3/ for test: kms_flip_scaled_crc
results: parsing output: 4/ for test: syncobj_eventfd
results: parsing output: 5/ for test: kms_async_flips
results: parsing output: 6/ for test: gem_fence_thrash
results: parsing output: 7/ for test: kms_plane
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: gem_eio
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: kms_cursor_crc
results: parsing output: 14/ for test: gem_exec_schedule
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: core_setmaster
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: gem_render_copy_redux
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gem_exec_reloc
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: kms_chamelium_hpd
results: parsing output: 27/ for test: kms_vblank
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_prop_blob
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: kms_content_protection
results: parsing output: 33/ for test: kms_vblank
results: parsing output: 34/ for test: i915_drm_fdinfo
results: parsing output: 35/ for test: kms_psr
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: gem_eio
results: parsing output: 38/ for test: api_intel_bb
results: parsing output: 39/ for test: kms_properties
results: parsing output: 40/ for test: kms_async_flips
results: parsing output: 41/ for test: gem_render_copy
results: parsing output: 42/ for test: gem_exec_balancer
results: parsing output: 43/ for test: gem_close_race
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: gem_exec_reloc
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_exec_schedule
results: parsing output: 49/ for test: kms_dsc
results: parsing output: 50/ for test: gem_userptr_blits
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_exec_flush
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: gem_exec_schedule
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_plane_cursor
results: parsing output: 58/ for test: gem_mmap_offset
results: parsing output: 59/ for test: dumb_buffer
results: parsing output: 60/ for test: kms_plane_scaling
results: parsing output: 61/ for test: syncobj_basic
results: parsing output: 62/ for test: sysfs_preempt_timeout
results: parsing output: 63/ for test: gem_eio
results: parsing output: 64/ for test: kms_pm_dc
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_softpin
results: parsing output: 67/ for test: gem_mmap_wc
results: parsing output: 68/ for test: kms_cursor_edge_walk
results: parsing output: 69/ for test: gem_lmem_swapping
results: parsing output: 70/ for test: gem_exec_reloc
results: parsing output: 71/ for test: gem_exec_fence
results: parsing output: 72/ for test: prime_busy
results: parsing output: 73/ for test: perf_pmu
results: parsing output: 74/ for test: kms_lease
results: parsing output: 75/ for test: kms_cursor_legacy
results: parsing output: 76/ for test: syncobj_wait
results: parsing output: 77/ for test: kms_prop_blob
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: kms_cursor_crc
results: parsing output: 80/ for test: kms_vrr
results: parsing output: 81/ for test: i915_pm_rps
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_ctx_param
results: parsing output: 84/ for test: syncobj_wait
results: parsing output: 85/ for test: i915_hangman
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_getfb
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: perf
results: parsing output: 92/ for test: kms_chamelium_edid
results: parsing output: 93/ for test: gem_fenced_exec_thrash
results: parsing output: 94/ for test: kms_cursor_legacy
results: parsing output: 95/ for test: sw_sync
results: parsing output: 96/ for test: gem_render_copy_redux
results: parsing output: 97/ for test: kms_color
results: parsing output: 98/ for test: gem_ctx_isolation
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_cursor_legacy
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: prime_vgem
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_ccs
results: parsing output: 106/ for test: gem_ctx_param
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_vm_create
results: parsing output: 109/ for test: gem_pxp
results: parsing output: 110/ for test: syncobj_wait
results: parsing output: 111/ for test: gem_mmap_gtt
results: parsing output: 112/ for test: kms_plane_multiple
results: parsing output: 113/ for test: gem_tiled_blits
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_psr2_sf
results: parsing output: 116/ for test: gem_exec_whisper
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: i915_suspend
results: parsing output: 120/ for test: gem_reg_read
results: parsing output: 121/ for test: kms_busy
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_ctx_persistence
results: parsing output: 124/ for test: gen9_exec_parse
results: parsing output: 125/ for test: gem_exec_balancer
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_hdr
results: parsing output: 128/ for test: gem_ctx_shared
results: parsing output: 129/ for test: gem_exec_whisper
results: parsing output: 130/ for test: kms_flip
results: parsing output: 131/ for test: kms_lease
results: parsing output: 132/ for test: kms_cursor_legacy
results: parsing output: 133/ for test: syncobj_wait
Done.