[56.693798] Initializing watchdogs
[56.693844]   /dev/watchdog0
[56.706931] [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]
[56.711488] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.713756] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.717224] [001/130] (960s left) kms_psr (fbc-psr-primary-page-flip)
[56.842901] Starting subtest: fbc-psr-primary-page-flip
[56.845158] Starting dynamic subtest: eDP-1
[56.849565] Dynamic subtest eDP-1: SKIP (0.000s)
[56.854062] Subtest fbc-psr-primary-page-flip: SKIP (0.000s)
[56.936811] [002/130] (960s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[57.033379] Starting subtest: x-tiled-16bpp-rotate-90
[57.066376] Subtest x-tiled-16bpp-rotate-90: SKIP (0.032s)
[57.208772] [003/130] (960s left) kms_chamelium_color (ctm-0-50)
[57.297324] Subtest ctm-0-50: SKIP (0.000s)
[57.338624] [004/130] (959s left) kms_vblank (query-idle)
[57.436397] Starting subtest: query-idle
[57.438406] Starting dynamic subtest: pipe-A-eDP-1
[59.180518] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.751s)
[59.193200] Starting dynamic subtest: pipe-D-eDP-1
[61.614429] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.436s)
[61.616475] Subtest query-idle: SUCCESS (4.190s)
[62.465102] [005/130] (954s left) gem_exec_alignment (forked)
[62.527123] Starting subtest: forked
[99.344922] Subtest forked: SUCCESS (36.826s)
[99.933408] [006/130] (917s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[100.082620] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[100.087069] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[100.209187] [007/130] (917s left) gem_exec_await (wide-contexts)
[100.498986] Starting subtest: wide-contexts
[123.662482] Subtest wide-contexts: SUCCESS (23.163s)
[123.905329] [FACT gem_exec_await (wide-contexts)] new: kernel.kmod_is_loaded.vgem: true
[123.912333] [008/130] (893s left) kms_flip (2x-plain-flip-ts-check)
[124.060280] Starting subtest: 2x-plain-flip-ts-check
[124.070955] Subtest 2x-plain-flip-ts-check: SKIP (0.010s)
[124.214763] [009/130] (893s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[129.186315] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[129.191077] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.002s)
[130.062653] [010/130] (887s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[130.145400] Starting subtest: invalid-signal-one-illegal-handle
[130.147891] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[130.256457] [011/130] (887s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[130.350241] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[130.352667] Starting dynamic subtest: pipe-A-default-mode
[130.635827] Dynamic subtest pipe-A-default-mode: SKIP (0.284s)
[130.640538] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.285s)
[131.479602] [012/130] (886s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[131.544702] Starting subtest: invalid-smem-bo-on-discrete
[131.549537] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[131.747591] [013/130] (886s left) gem_ctx_exec (basic-norecovery)
[131.818859] Starting subtest: basic-norecovery
[132.165782] Subtest basic-norecovery: SUCCESS (0.346s)
[132.326069] [014/130] (885s left) gem_exec_parallel (contexts)
[132.392620] Starting subtest: contexts
[132.394770] Starting dynamic subtest: rcs0
[135.774230] Dynamic subtest rcs0: SUCCESS (3.379s)
[135.785877] Starting dynamic subtest: bcs0
[139.833384] Dynamic subtest bcs0: SUCCESS (4.059s)
[139.842214] Starting dynamic subtest: vcs0
[144.362852] Dynamic subtest vcs0: SUCCESS (4.528s)
[144.373572] Starting dynamic subtest: vcs1
[148.425914] Dynamic subtest vcs1: SUCCESS (4.063s)
[148.436389] Starting dynamic subtest: vecs0
[154.286351] Dynamic subtest vecs0: SUCCESS (5.859s)
[154.297076] Starting dynamic subtest: ccs0
[158.350708] Dynamic subtest ccs0: SUCCESS (4.063s)
[158.353741] Subtest contexts: SUCCESS (25.957s)
[158.563183] [015/130] (859s left) kms_flip (2x-nonexisting-fb)
[158.684080] Starting subtest: 2x-nonexisting-fb
[158.693126] Subtest 2x-nonexisting-fb: SKIP (0.010s)
[158.836110] [016/130] (859s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[158.922065] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[158.924442] Starting dynamic subtest: pipe-A
[159.273541] Dynamic subtest pipe-A: SUCCESS (0.351s)
[159.281391] Starting dynamic subtest: pipe-B
[160.665226] Dynamic subtest pipe-B: SUCCESS (1.392s)
[160.674901] Starting dynamic subtest: pipe-C
[162.088415] Dynamic subtest pipe-C: SUCCESS (1.422s)
[162.097727] Starting dynamic subtest: pipe-D
[163.515651] Dynamic subtest pipe-D: SUCCESS (1.426s)
[163.518100] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.593s)
[164.690885] [017/130] (853s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[164.809714] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[164.813974] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[164.942472] [018/130] (853s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[165.034750] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[165.037035] Starting dynamic subtest: pipe-A
[165.056856] Dynamic subtest pipe-A: SKIP (0.017s)
[165.064821] Starting dynamic subtest: pipe-B
[165.086807] Dynamic subtest pipe-B: SKIP (0.032s)
[165.096848] Starting dynamic subtest: pipe-C
[165.121509] Dynamic subtest pipe-C: SKIP (0.034s)
[165.131009] Starting dynamic subtest: pipe-D
[165.157765] Dynamic subtest pipe-D: SKIP (0.034s)
[165.162090] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.119s)
[165.287203] [019/130] (852s left) kms_psr (psr-cursor-mmap-gtt)
[165.381966] Starting subtest: psr-cursor-mmap-gtt
[165.384396] Starting dynamic subtest: eDP-1
[167.065484] Dynamic subtest eDP-1: SUCCESS (1.684s)
[167.067943] Subtest psr-cursor-mmap-gtt: SUCCESS (1.685s)
[167.953733] [020/130] (850s left) syncobj_basic (illegal-fd-to-handle)
[168.017138] Starting subtest: illegal-fd-to-handle
[168.019180] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[168.150944] [021/130] (849s left) gem_exec_whisper (basic-queues-forked)
[168.213514] Starting subtest: basic-queues-forked
[191.071864] Subtest basic-queues-forked: SUCCESS (22.852s)
[191.280866] [022/130] (826s left) kms_chamelium_frames (dp-crc-single)
[191.678101] Subtest dp-crc-single: SKIP (0.000s)
[192.444690] [023/130] (825s left) syncobj_timeline (reset-during-wait-for-submit)
[192.507563] Starting subtest: reset-during-wait-for-submit
[192.609079] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[192.706897] [024/130] (825s left) gem_userptr_blits (probe)
[192.799610] Starting subtest: probe
[192.876309] Subtest probe: SUCCESS (0.076s)
[193.030977] [025/130] (825s left) i915_pm_rpm (gem-mmap-type)
[195.101301] Starting subtest: gem-mmap-type
[195.104294] Starting dynamic subtest: wb-smem0
[198.888687] Dynamic subtest wb-smem0: SUCCESS (3.786s)
[198.898476] Starting dynamic subtest: wc-smem0
[201.726866] Dynamic subtest wc-smem0: SUCCESS (2.839s)
[201.741309] Starting dynamic subtest: uc-smem0
[205.203592] Dynamic subtest uc-smem0: SUCCESS (3.475s)
[205.205965] Subtest gem-mmap-type: SUCCESS (10.102s)
[205.326901] [026/130] (812s left) gem_eio (in-flight-contexts-10ms)
[205.556081] Starting subtest: in-flight-contexts-10ms
[218.926173] Subtest in-flight-contexts-10ms: SUCCESS (13.368s)
[219.135325] [027/130] (799s left) syncobj_timeline (32bits-limit)
[219.196947] Starting subtest: 32bits-limit
[219.199305] Subtest 32bits-limit: SUCCESS (0.001s)
[219.322648] [028/130] (799s left) gem_barrier_race (remote-request)
[219.395415] Starting subtest: remote-request
[219.398095] Starting dynamic subtest: rcs0
[224.583284] Dynamic subtest rcs0: SUCCESS (5.179s)
[224.592368] Subtest remote-request: SUCCESS (5.180s)
[224.775444] [029/130] (793s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[224.943327] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[231.680867] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.762s)
[231.835461] [030/130] (786s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[231.941573] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[231.946091] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[232.079445] [031/130] (786s left) i915_power (sanity)
[232.140859] Starting subtest: sanity
[236.185166] Subtest sanity: SUCCESS (4.039s)
[237.938913] [032/130] (780s left) gem_set_tiling_vs_gtt
[238.058897] [033/130] (780s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[238.156919] Starting subtest: fbc-psr2-cursor-mmap-gtt
[238.159328] Starting dynamic subtest: eDP-1
[238.163779] Dynamic subtest eDP-1: SKIP (0.000s)
[238.168286] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[238.253280] [034/130] (780s left) kms_plane_alpha_blend (alpha-basic)
[238.355988] Starting subtest: alpha-basic
[238.635485] Starting dynamic subtest: pipe-A-eDP-1
[240.547539] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.909s)
[240.571531] Starting dynamic subtest: pipe-D-eDP-1
[243.217341] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.652s)
[243.219678] Subtest alpha-basic: SUCCESS (4.862s)
[244.045288] [035/130] (774s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[244.135260] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[244.139473] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[244.267163] [036/130] (774s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[244.356161] Starting subtest: 2x-plain-flip-ts-check-interruptible
[244.367575] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.010s)
[244.464752] [037/130] (774s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[244.567706] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[244.579832] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.010s)
[244.678802] [038/130] (774s left) api_intel_bb (purge-bb)
[244.738415] Starting subtest: purge-bb
[244.740738] Subtest purge-bb: SUCCESS (0.004s)
[244.904987] [039/130] (773s left) kms_psr (fbc-pr-cursor-blt)
[244.997526] Starting subtest: fbc-pr-cursor-blt
[245.001109] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[245.093480] [040/130] (773s left) prime_busy (before)
[245.156619] Starting subtest: before
[245.160914] Starting dynamic subtest: rcs0
[245.205881] Dynamic subtest rcs0: SUCCESS (0.046s)
[245.216589] Starting dynamic subtest: bcs0
[245.284109] Dynamic subtest bcs0: SUCCESS (0.077s)
[245.293802] Starting dynamic subtest: vcs0
[245.324277] Dynamic subtest vcs0: SUCCESS (0.040s)
[245.334848] Starting dynamic subtest: vcs1
[245.365093] Dynamic subtest vcs1: SUCCESS (0.041s)
[245.373843] Starting dynamic subtest: vecs0
[245.406114] Dynamic subtest vecs0: SUCCESS (0.040s)
[245.414913] Starting dynamic subtest: ccs0
[245.446929] Dynamic subtest ccs0: SUCCESS (0.040s)
[245.556664] Subtest before: SUCCESS (0.398s)
[245.657313] [041/130] (773s left) i915_drm_fdinfo (virtual-idle)
[245.698774] Starting subtest: virtual-idle
[248.792590] Subtest virtual-idle: SUCCESS (3.088s)
[248.890247] [042/130] (770s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[248.996656] Starting subtest: extended-pageflip-modeset-hang-oldfb
[248.998599] Starting dynamic subtest: pipe-A
[256.879897] Dynamic subtest pipe-A: SUCCESS (7.880s)
[256.890280] Starting dynamic subtest: pipe-D
[265.542285] Dynamic subtest pipe-D: SUCCESS (8.661s)
[265.544598] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.547s)
[266.412433] [043/130] (752s left) kms_setmode (invalid-clone-single-crtc)
[266.486663] Starting subtest: invalid-clone-single-crtc
[266.493491] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[266.633563] [044/130] (752s left) gem_fence_thrash (bo-write-verify-y)
[266.671648] Starting subtest: bo-write-verify-y
[266.692341] Subtest bo-write-verify-y: SKIP (0.018s)
[266.754730] [045/130] (752s left) kms_frontbuffer_tracking (fbc-2p-rte)
[266.856611] Starting subtest: fbc-2p-rte
[266.860765] Subtest fbc-2p-rte: SKIP (0.000s)
[266.976456] [046/130] (752s left) kms_atomic (atomic-invalid-params)
[267.077838] Starting subtest: atomic-invalid-params
[267.080154] Starting dynamic subtest: pipe-A-eDP-1
[267.454813] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.377s)
[267.457258] Subtest atomic-invalid-params: SUCCESS (0.379s)
[268.347412] [047/130] (750s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[268.450745] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[268.452687] Starting dynamic subtest: pipe-A-eDP-1
[269.706350] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.257s)
[269.716310] Starting dynamic subtest: pipe-B-eDP-1
[272.025172] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.318s)
[272.034769] Starting dynamic subtest: pipe-C-eDP-1
[274.247571] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.221s)
[274.257630] Starting dynamic subtest: pipe-D-eDP-1
[276.528647] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.280s)
[276.531065] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.080s)
[277.769812] [048/130] (741s left) kms_content_protection (atomic-dpms)
[277.905641] Starting subtest: atomic-dpms
[277.910321] Subtest atomic-dpms: SKIP (0.000s)
[278.076723] [049/130] (741s left) kms_psr (psr-sprite-blt)
[278.179140] Starting subtest: psr-sprite-blt
[278.181508] Starting dynamic subtest: eDP-1
[279.995351] Dynamic subtest eDP-1: SUCCESS (1.815s)
[279.997337] Subtest psr-sprite-blt: SUCCESS (1.816s)
[280.838449] [050/130] (738s left) i915_query (query-topology-unsupported)
[280.885791] Starting subtest: query-topology-unsupported
[280.889766] Subtest query-topology-unsupported: SKIP (0.000s)
[281.018773] [051/130] (738s left) gem_userptr_blits (access-control)
[281.096268] Starting subtest: access-control
[281.100257] Subtest access-control: SKIP (0.000s)
[281.225570] [052/130] (738s left) gem_fence_thrash (bo-copy)
[281.257072] Starting subtest: bo-copy
[281.276241] Subtest bo-copy: SKIP (0.020s)
[281.327512] [053/130] (738s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[281.473569] Starting subtest: cursor-rapid-movement-32x32
[281.517286] Subtest cursor-rapid-movement-32x32: SKIP (0.038s)
[281.873552] [054/130] (737s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[281.974940] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[281.978464] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[282.111104] [055/130] (737s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[282.202256] Starting subtest: yf-tiled-64bpp-rotate-270
[282.205773] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[282.309374] [056/130] (737s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[282.404537] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[282.408082] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[282.529345] [057/130] (737s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[282.629252] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[282.631144] Starting dynamic subtest: pipe-A-eDP-1
[282.649257] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[282.660879] Starting dynamic subtest: pipe-B-eDP-1
[282.678580] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[282.686614] Starting dynamic subtest: pipe-C-eDP-1
[282.704419] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[282.712494] Starting dynamic subtest: pipe-D-eDP-1
[282.730653] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[282.733974] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[284.803053] [058/130] (734s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[284.907133] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[288.503609] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.599s)
[289.714991] [059/130] (729s left) gem_eio (wait-immediate)
[289.935012] Starting subtest: wait-immediate
[290.267296] Subtest wait-immediate: SUCCESS (0.331s)
[290.437150] [060/130] (729s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[290.545640] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[290.550070] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[290.666726] [061/130] (729s left) gem_exec_suspend (basic-s3)
[290.722611] Starting subtest: basic-S3
[290.724535] Starting dynamic subtest: smem
[310.346172] Dynamic subtest smem: SUCCESS (8.187s)
[310.349281] Subtest basic-S3: SUCCESS (8.189s)
[310.553811] [062/130] (709s left) gem_workarounds (suspend-resume)
[310.640388] Starting subtest: suspend-resume
[326.941346] Subtest suspend-resume: SUCCESS (1.182s)
[327.094707] [063/130] (692s left) gem_exec_nop (basic-parallel)
[327.194158] Starting subtest: basic-parallel
[343.453864] Subtest basic-parallel: SUCCESS (16.354s)
[343.722516] [064/130] (676s left) kms_big_fb (linear-8bpp-rotate-0)
[343.854120] Starting subtest: linear-8bpp-rotate-0
[345.066207] Subtest linear-8bpp-rotate-0: SUCCESS (1.214s)
[345.227869] [065/130] (674s left) kms_cursor_edge_walk (128x128-top-bottom)
[345.318073] Starting subtest: 128x128-top-bottom
[345.320169] Starting dynamic subtest: pipe-A-eDP-1
[348.752729] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.438s)
[348.763985] Starting dynamic subtest: pipe-D-eDP-1
[351.873564] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s)
[351.876232] Subtest 128x128-top-bottom: SUCCESS (6.565s)
[352.707541] [066/130] (667s left) perf (whitelisted-registers-userspace-config)
[352.818862] Starting subtest: whitelisted-registers-userspace-config
[352.821373] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[352.860533] [067/130] (667s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[352.958041] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[352.962486] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[353.084934] [068/130] (666s left) syncobj_wait (single-wait-for-submit-signaled)
[353.136354] Starting subtest: single-wait-for-submit-signaled
[353.138893] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[353.265040] [069/130] (666s left) gem_exec_schedule (thriceslice)
[353.346162] Starting subtest: thriceslice
[353.348661] Starting dynamic subtest: rcs0
[353.365508] Dynamic subtest rcs0: SUCCESS (0.031s)
[353.376797] Starting dynamic subtest: bcs0
[353.395873] Dynamic subtest bcs0: SUCCESS (0.030s)
[353.405353] Starting dynamic subtest: vcs0
[353.426500] Dynamic subtest vcs0: SUCCESS (0.030s)
[353.436140] Starting dynamic subtest: vcs1
[353.456125] Dynamic subtest vcs1: SUCCESS (0.029s)
[353.465727] Starting dynamic subtest: vecs0
[353.511301] Dynamic subtest vecs0: SUCCESS (0.053s)
[353.522873] Starting dynamic subtest: ccs0
[353.542671] Dynamic subtest ccs0: SUCCESS (0.029s)
[353.545307] Subtest thriceslice: SUCCESS (0.209s)
[354.524007] [070/130] (665s left) core_hotunplug (unbind-rebind)
[354.620135] Starting subtest: unbind-rebind
[360.097140] Subtest unbind-rebind: SUCCESS (5.481s)
[360.142505] [071/130] (660s left) kms_pm_rpm (universal-planes)
[361.669373] Starting subtest: universal-planes
[361.672250] Starting dynamic subtest: plane-33
[372.585744] Dynamic subtest plane-33: SUCCESS (10.910s)
[372.599380] Starting dynamic subtest: plane-63
[380.983838] Dynamic subtest plane-63: SUCCESS (8.398s)
[380.997108] Starting dynamic subtest: plane-93
[389.604319] Dynamic subtest plane-93: SUCCESS (8.620s)
[389.617778] Starting dynamic subtest: plane-123
[397.879993] Dynamic subtest plane-123: SUCCESS (8.275s)
[397.894373] Starting dynamic subtest: plane-133
[406.278798] Dynamic subtest plane-133: SUCCESS (8.399s)
[406.295312] Starting dynamic subtest: plane-143
[414.626234] Dynamic subtest plane-143: SUCCESS (8.347s)
[414.629105] Subtest universal-planes: SUCCESS (52.965s)
[415.003427] [072/130] (605s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[415.107913] Starting subtest: fbc-rgb101010-draw-mmap-wc
[419.722143] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.619s)
[420.918215] [073/130] (599s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[422.643109] Starting subtest: dpms-mode-unset-lpsp
[426.704851] Subtest dpms-mode-unset-lpsp: SUCCESS (4.062s)
[427.135592] [074/130] (593s left) kms_hdr (static-toggle)
[427.241059] Starting subtest: static-toggle
[427.248980] Subtest static-toggle: SKIP (0.000s)
[427.337521] [075/130] (593s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[427.428938] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[434.195599] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.767s)
[434.344522] [076/130] (586s left) kms_flip (dpms-vs-vblank-race)
[434.437941] Starting subtest: dpms-vs-vblank-race
[434.440453] Starting dynamic subtest: A-eDP1
[439.415196] Dynamic subtest A-eDP1: SUCCESS (4.975s)
[439.426133] Starting dynamic subtest: B-eDP1
[444.028762] Dynamic subtest B-eDP1: SUCCESS (4.611s)
[444.041025] Starting dynamic subtest: C-eDP1
[448.639539] Dynamic subtest C-eDP1: SUCCESS (4.607s)
[448.651068] Starting dynamic subtest: D-eDP1
[453.262840] Dynamic subtest D-eDP1: SUCCESS (4.624s)
[453.265693] Subtest dpms-vs-vblank-race: SUCCESS (18.825s)
[454.159082] [077/130] (566s left) kms_prop_blob (invalid-get-prop-any)
[454.219984] Starting subtest: invalid-get-prop-any
[454.223064] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[454.365843] [078/130] (566s left) gem_exec_params (rel-constants-invalid-ring)
[454.421344] Starting subtest: rel-constants-invalid-ring
[454.424308] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[454.563496] [079/130] (565s left) i915_drm_fdinfo (memory-info-idle)
[454.609120] Starting subtest: memory-info-idle
[454.611332] Starting dynamic subtest: smem0
[454.697302] Dynamic subtest smem0: SUCCESS (0.091s)
[454.700356] Subtest memory-info-idle: SUCCESS (0.092s)
[454.799591] [080/130] (565s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[454.904078] Starting subtest: fbcpsr-slowdraw
[480.124885] Subtest fbcpsr-slowdraw: SUCCESS (25.226s)
[480.285680] [081/130] (540s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[480.386118] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[480.390462] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[480.531529] [082/130] (540s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[480.632171] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[480.637346] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[480.764253] [083/130] (539s left) kms_setmode (basic-clone-single-crtc)
[480.835769] Starting subtest: basic-clone-single-crtc
[480.844098] Subtest basic-clone-single-crtc: SKIP (0.001s)
[480.969347] [084/130] (539s left) drm_read (invalid-buffer)
[481.103547] Starting subtest: invalid-buffer
[481.105831] Subtest invalid-buffer: SUCCESS (0.000s)
[481.230003] [085/130] (539s left) kms_vrr (flip-basic-fastset)
[481.317034] Starting subtest: flip-basic-fastset
[481.323312] Subtest flip-basic-fastset: SKIP (0.000s)
[481.413449] [086/130] (539s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[481.512884] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[488.183915] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.675s)
[488.333765] [087/130] (532s left) gem_mmap_offset (bad-object)
[488.401499] Starting subtest: bad-object
[488.403660] Subtest bad-object: SUCCESS (0.001s)
[488.538755] [088/130] (532s left) syncobj_timeline (single-wait-available-signaled)
[488.598648] Starting subtest: single-wait-available-signaled
[488.601123] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[488.735083] [089/130] (532s left) perf_pmu (most-busy-check-all)
[488.779578] Starting subtest: most-busy-check-all
[488.782041] Starting dynamic subtest: rcs0
[490.462157] Dynamic subtest rcs0: SUCCESS (1.682s)
[490.476393] Starting dynamic subtest: bcs0
[492.445850] Dynamic subtest bcs0: SUCCESS (1.982s)
[492.460357] Starting dynamic subtest: vcs0
[494.494184] Dynamic subtest vcs0: SUCCESS (2.045s)
[494.508554] Starting dynamic subtest: vcs1
[496.478307] Dynamic subtest vcs1: SUCCESS (1.982s)
[496.492346] Starting dynamic subtest: vecs0
[498.461878] Dynamic subtest vecs0: SUCCESS (1.981s)
[498.475692] Starting dynamic subtest: ccs0
[500.447353] Dynamic subtest ccs0: SUCCESS (1.983s)
[500.450344] Subtest most-busy-check-all: SUCCESS (11.671s)
[500.588823] [090/130] (520s left) gem_exec_big (single)
[500.667178] Starting subtest: single
[503.093803] Subtest single: SUCCESS (2.428s)
[503.323815] [091/130] (517s left) kms_psr (pr-sprite-mmap-gtt)
[503.470153] Starting subtest: pr-sprite-mmap-gtt
[503.475470] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[503.569001] [092/130] (517s left) perf_pmu (busy-idle)
[503.611142] Starting subtest: busy-idle
[503.614319] Starting dynamic subtest: rcs0
[504.297880] Dynamic subtest rcs0: SUCCESS (0.686s)
[504.312004] Starting dynamic subtest: bcs0
[504.966572] Dynamic subtest bcs0: SUCCESS (0.667s)
[504.980327] Starting dynamic subtest: vcs0
[506.463472] Dynamic subtest vcs0: SUCCESS (1.494s)
[506.478346] Starting dynamic subtest: vcs1
[508.445526] Dynamic subtest vcs1: SUCCESS (1.979s)
[508.457734] Starting dynamic subtest: vecs0
[510.493158] Dynamic subtest vecs0: SUCCESS (2.045s)
[510.507342] Starting dynamic subtest: ccs0
[511.166180] Dynamic subtest ccs0: SUCCESS (0.671s)
[511.169201] Subtest busy-idle: SUCCESS (7.558s)
[511.325525] [093/130] (509s left) gem_exec_balancer (invalid-bonds)
[511.403348] Starting subtest: invalid-bonds
[511.408185] Subtest invalid-bonds: SKIP (0.000s)
[511.725340] [094/130] (509s left) kms_chamelium_hpd (dp-hpd-fast)
[512.136171] Subtest dp-hpd-fast: SKIP (0.000s)
[512.918968] [095/130] (508s left) api_intel_allocator (reloc-allocator)
[512.981733] Starting subtest: reloc-allocator
[512.984030] Starting dynamic subtest: basic
[512.986928] Dynamic subtest basic: SUCCESS (0.005s)
[512.999263] Starting dynamic subtest: parallel-one
[513.002343] Dynamic subtest parallel-one: SUCCESS (0.009s)
[513.012860] Starting dynamic subtest: print
[513.014888] Dynamic subtest print: SUCCESS (0.000s)
[513.024952] Starting dynamic subtest: reuse
[513.027210] Dynamic subtest reuse: SUCCESS (0.000s)
[513.036888] Starting dynamic subtest: fork-reopen-allocator
[513.039131] Dynamic subtest fork-reopen-allocator: SUCCESS (0.010s)
[513.041181] Subtest reloc-allocator: SUCCESS (0.028s)
[513.135118] [096/130] (508s left) syncobj_wait (multi-wait-all-signaled)
[513.208060] Starting subtest: multi-wait-all-signaled
[513.210746] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[513.305769] [097/130] (508s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[513.368631] Starting subtest: etime-single-wait-for-submit-unsubmitted
[513.473373] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[513.578044] [098/130] (507s left) gen9_exec_parse (batch-invalid-length)
[513.642610] Subtest batch-invalid-length: SKIP (0.000s)
[513.715102] [099/130] (507s left) gem_exec_fence (syncobj-signal)
[514.138053] Starting subtest: syncobj-signal
[514.140869] Subtest syncobj-signal: SUCCESS (0.004s)
[515.603550] [100/130] (505s left) gem_exec_whisper (basic-fds-priority)
[515.670233] Starting subtest: basic-fds-priority
[541.586322] Subtest basic-fds-priority: SUCCESS (25.919s)
[541.791370] [101/130] (479s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[541.895402] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[541.897838] Starting dynamic subtest: pipe-A-eDP-1
[542.766573] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.862s)
[542.778167] Starting dynamic subtest: pipe-B-eDP-1
[544.347589] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.580s)
[544.358114] Starting dynamic subtest: pipe-C-eDP-1
[545.826221] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.477s)
[545.837366] Starting dynamic subtest: pipe-D-eDP-1
[547.450573] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.624s)
[547.452868] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.550s)
[548.681117] [102/130] (472s left) gem_exec_params (batch-first)
[548.746328] Starting subtest: batch-first
[548.750858] Subtest batch-first: SUCCESS (0.008s)
[548.913317] [103/130] (472s left) kms_flip_tiling (flip-change-tiling)
[549.015729] Starting subtest: flip-change-tiling
[549.018047] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs
[549.216560] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.202s)
[549.233121] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs
[549.362741] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.142s)
[549.378046] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[549.506984] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.142s)
[549.520551] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4
[549.679008] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.170s)
[549.691323] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x
[549.821539] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[549.833780] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear
[549.966378] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[549.978117] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs
[550.099796] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[550.120828] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs
[550.210179] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[550.223702] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[550.344707] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.132s)
[550.358352] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4
[550.488203] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s)
[550.501717] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x
[550.632990] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[550.645087] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear
[550.777269] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[550.789326] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[550.921923] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.142s)
[550.935195] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[551.056425] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s)
[551.068338] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[551.177618] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.120s)
[551.189851] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4
[551.322205] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.143s)
[551.336077] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x
[551.466235] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[551.486631] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear
[551.638088] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.169s)
[551.651320] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs
[551.782993] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s)
[551.798643] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs
[551.927538] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s)
[551.940843] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc
[552.101355] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.172s)
[552.119962] Starting dynamic subtest: pipe-A-eDP-1-4-to-4
[552.234397] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.129s)
[552.246607] Starting dynamic subtest: pipe-A-eDP-1-4-to-x
[552.389754] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.153s)
[552.402736] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear
[552.534039] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.143s)
[552.551930] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs
[552.690134] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.154s)
[552.704532] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs
[552.834842] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[552.847715] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc
[552.978874] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[552.992378] Starting dynamic subtest: pipe-A-eDP-1-x-to-4
[553.134576] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.153s)
[553.147728] Starting dynamic subtest: pipe-A-eDP-1-x-to-x
[553.256749] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.120s)
[553.268733] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear
[553.401473] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.143s)
[553.424321] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs
[553.545875] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[553.559659] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs
[553.690587] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[553.701998] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc
[553.835549] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.143s)
[553.847713] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4
[553.990753] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.153s)
[554.002327] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x
[554.146232] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.153s)
[554.158188] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear
[554.279560] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.131s)
[554.332654] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs
[555.517371] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.191s)
[555.530053] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs
[555.651626] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s)
[555.664635] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[555.796267] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.142s)
[555.810186] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4
[556.002305] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.204s)
[556.016093] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x
[556.145303] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[556.158783] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear
[556.290041] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[556.303580] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs
[556.423088] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[556.435942] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs
[556.545787] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.120s)
[556.557574] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[556.680169] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[556.692409] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4
[556.823664] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s)
[556.837188] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x
[557.006509] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.180s)
[557.020045] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear
[557.151320] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[557.164102] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[557.284699] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[557.298348] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[557.430487] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.141s)
[557.449265] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[557.551215] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.120s)
[557.564332] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4
[557.695795] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.143s)
[557.710228] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x
[557.840209] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[557.852918] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear
[557.984838] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[558.000741] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs
[558.129521] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s)
[558.145783] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs
[558.273907] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s)
[558.286890] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc
[558.418176] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[558.436818] Starting dynamic subtest: pipe-B-eDP-1-4-to-4
[558.551034] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.131s)
[558.563371] Starting dynamic subtest: pipe-B-eDP-1-4-to-x
[558.695647] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.143s)
[558.708070] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear
[558.873024] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.175s)
[558.885517] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs
[559.018136] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[559.036351] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs
[559.161832] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[559.174639] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc
[559.306742] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[559.318820] Starting dynamic subtest: pipe-B-eDP-1-x-to-4
[559.451001] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.142s)
[559.463656] Starting dynamic subtest: pipe-B-eDP-1-x-to-x
[559.572928] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.120s)
[559.586049] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear
[559.717862] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.143s)
[559.730320] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs
[559.862214] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[559.874172] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs
[560.007032] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.143s)
[560.019972] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc
[560.175010] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.165s)
[560.187812] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4
[560.346017] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.168s)
[560.357336] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x
[560.501517] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.152s)
[560.513725] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear
[560.623566] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.120s)
[560.677054] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs
[561.855654] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.186s)
[561.869305] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs
[561.966809] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[561.979325] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[562.066646] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[562.078917] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4
[562.177676] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.110s)
[562.190613] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x
[562.289038] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s)
[562.300163] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear
[562.438643] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.148s)
[562.452095] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs
[562.549632] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.109s)
[562.562957] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs
[562.649933] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[562.663346] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[562.749797] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s)
[562.761252] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4
[562.860743] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.110s)
[562.874719] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x
[562.971909] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.110s)
[562.985554] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear
[563.071782] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.099s)
[563.084577] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[563.172182] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.099s)
[563.185959] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[563.271958] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.099s)
[563.283073] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[563.372042] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[563.385844] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4
[563.541985] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.167s)
[563.556361] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x
[563.651913] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[563.663628] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear
[563.807154] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.154s)
[563.820573] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs
[563.918495] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.109s)
[563.932606] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs
[564.030064] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.109s)
[564.044218] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc
[564.141095] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.109s)
[564.155886] Starting dynamic subtest: pipe-C-eDP-1-4-to-4
[564.252025] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.109s)
[564.266477] Starting dynamic subtest: pipe-C-eDP-1-4-to-x
[564.363012] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.109s)
[564.374373] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear
[564.474300] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.110s)
[564.487975] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs
[564.584813] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.110s)
[564.595825] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs
[564.696129] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.110s)
[564.709332] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc
[564.807213] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.110s)
[564.820374] Starting dynamic subtest: pipe-C-eDP-1-x-to-4
[564.929771] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.120s)
[564.941225] Starting dynamic subtest: pipe-C-eDP-1-x-to-x
[565.040882] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.110s)
[565.052034] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear
[565.152008] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.110s)
[565.165849] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs
[565.262723] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.110s)
[565.276524] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs
[565.373681] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.110s)
[565.387037] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc
[565.474200] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.099s)
[565.487073] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4
[565.585178] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.110s)
[565.598245] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x
[565.696040] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.110s)
[565.709876] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear
[565.807332] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.110s)
[565.849822] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs
[567.092163] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.250s)
[567.105187] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs
[567.203241] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.110s)
[567.215390] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[567.314742] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.109s)
[567.332822] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4
[567.488313] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.171s)
[567.502097] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x
[567.598035] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.108s)
[567.615598] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear
[567.708531] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.109s)
[567.721322] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs
[567.809069] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.099s)
[567.827513] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs
[567.920326] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[567.933621] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[568.019875] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s)
[568.031182] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4
[568.131821] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.110s)
[568.145324] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x
[568.242450] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.110s)
[568.253147] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear
[568.353353] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.110s)
[568.367356] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[568.464788] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.110s)
[568.476114] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[568.564685] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.097s)
[568.575949] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[568.664581] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.099s)
[568.676331] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4
[568.776007] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.110s)
[568.789185] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x
[568.886392] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[568.898080] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear
[568.997845] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.110s)
[569.010084] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs
[569.109195] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.110s)
[569.121675] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs
[569.220536] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.109s)
[569.233669] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc
[569.331667] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.109s)
[569.345017] Starting dynamic subtest: pipe-D-eDP-1-4-to-4
[569.443164] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.109s)
[569.456696] Starting dynamic subtest: pipe-D-eDP-1-4-to-x
[569.554218] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.109s)
[569.566703] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear
[569.665062] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.110s)
[569.677350] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs
[569.776324] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.110s)
[569.790904] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs
[569.887009] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.109s)
[569.897590] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc
[569.998734] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.110s)
[570.009012] Starting dynamic subtest: pipe-D-eDP-1-x-to-4
[570.109598] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.109s)
[570.123842] Starting dynamic subtest: pipe-D-eDP-1-x-to-x
[570.220515] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.110s)
[570.233825] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear
[570.370696] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.148s)
[570.384361] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs
[570.481904] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s)
[570.494198] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs
[570.593692] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.110s)
[570.606559] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc
[570.703795] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.110s)
[570.716243] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4
[570.814796] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.110s)
[570.825760] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x
[570.926307] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.110s)
[570.939274] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear
[571.037497] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.109s)
[571.059653] Subtest flip-change-tiling: SUCCESS (22.039s)
[572.309642] [104/130] (449s left) kms_plane_lowres (tiling-x)
[572.413585] Starting subtest: tiling-x
[572.416293] Starting dynamic subtest: pipe-A-eDP-1
[572.421913] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[572.713767] Starting dynamic subtest: pipe-B-eDP-1
[572.718997] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[572.729075] Starting dynamic subtest: pipe-C-eDP-1
[572.734346] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[572.744812] Starting dynamic subtest: pipe-D-eDP-1
[572.750319] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[572.756181] Subtest tiling-x: SKIP (0.300s)
[573.537996] [105/130] (448s left) gem_exec_flush (basic-wb-ro-before-default)
[573.621488] Starting subtest: basic-wb-ro-before-default
[579.079442] Subtest basic-wb-ro-before-default: SUCCESS (5.462s)
[579.301603] [106/130] (442s left) gem_ctx_engines (execute-allforone)
[579.363915] Starting subtest: execute-allforone
[579.401116] Subtest execute-allforone: SUCCESS (0.037s)
[580.579027] [107/130] (441s left) kms_cursor_crc (cursor-offscreen-64x64)
[580.763770] Starting subtest: cursor-offscreen-64x64
[580.766415] Starting dynamic subtest: pipe-A-eDP-1
[582.699415] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.933s)
[582.731858] Starting dynamic subtest: pipe-D-eDP-1
[585.325314] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.603s)
[585.328200] Subtest cursor-offscreen-64x64: SUCCESS (4.560s)
[586.207949] [108/130] (435s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[586.312077] Starting subtest: bad-rotation-90-y-tiled-ccs
[586.314458] Starting dynamic subtest: pipe-A-eDP-1
[586.337811] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[586.355028] Starting dynamic subtest: pipe-B-eDP-1
[586.377472] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[586.387574] Starting dynamic subtest: pipe-C-eDP-1
[586.410111] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[586.420183] Starting dynamic subtest: pipe-D-eDP-1
[586.447752] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[586.452337] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.005s)
[588.484986] [109/130] (433s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[588.549510] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[588.648250] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.101s)
[588.752536] [110/130] (433s left) gem_ctx_persistence (heartbeat-stop)
[588.827137] Starting subtest: heartbeat-stop
[588.832093] Subtest heartbeat-stop: SKIP (0.000s)
[588.952999] [111/130] (433s left) gem_exec_reloc (basic-gtt-noreloc)
[589.012086] Subtest basic-gtt-noreloc: SKIP (0.000s)
[589.087746] [112/130] (432s left) gem_reg_read (bad-register)
[589.141553] Starting subtest: bad-register
[589.144355] Subtest bad-register: SUCCESS (0.000s)
[589.272667] [113/130] (432s left) kms_cursor_legacy (single-bo)
[589.384100] Starting subtest: single-bo
[589.386501] Starting dynamic subtest: pipe-A
[594.768334] Dynamic subtest pipe-A: SUCCESS (5.379s)
[594.780912] Starting dynamic subtest: pipe-B
[600.151973] Dynamic subtest pipe-B: SUCCESS (5.380s)
[600.163294] Starting dynamic subtest: pipe-C
[605.535052] Dynamic subtest pipe-C: SUCCESS (5.380s)
[605.546111] Starting dynamic subtest: pipe-D
[610.917053] Dynamic subtest pipe-D: SUCCESS (5.379s)
[610.929107] Starting dynamic subtest: all-pipes
[616.308131] Dynamic subtest all-pipes: SUCCESS (5.386s)
[616.310527] Subtest single-bo: SUCCESS (26.918s)
[616.475565] [114/130] (405s left) gem_mmap_offset (ptrace)
[616.547030] Starting subtest: ptrace
[616.550237] Starting dynamic subtest: smem0-wb
[616.562884] Dynamic subtest smem0-wb: SUCCESS (0.015s)
[616.573001] Starting dynamic subtest: smem0-wc
[616.582000] Dynamic subtest smem0-wc: SUCCESS (0.018s)
[616.592250] Starting dynamic subtest: smem0-uc
[616.600476] Dynamic subtest smem0-uc: SUCCESS (0.018s)
[616.603196] Subtest ptrace: SUCCESS (0.057s)
[616.753704] [115/130] (405s left) gem_userptr_blits (sync-unmap-after-close)
[616.823449] Starting subtest: sync-unmap-after-close
[616.832324] Subtest sync-unmap-after-close: SUCCESS (0.011s)
[617.004597] [116/130] (405s left) gem_exec_fence (syncobj-unused-fence)
[617.460379] Starting subtest: syncobj-unused-fence
[617.462998] Subtest syncobj-unused-fence: SUCCESS (0.005s)
[618.553791] [117/130] (403s left) gem_pread (snoop)
[618.621153] Subtest snoop: SKIP (0.000s)
[618.691077] [118/130] (403s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[618.783114] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[618.787766] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[618.910151] [119/130] (403s left) gem_render_copy (yf-tiled-ccs-to-linear)
[618.980046] Starting subtest: yf-tiled-ccs-to-linear
[618.984679] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[619.186892] [120/130] (403s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[619.246225] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[619.308655] [121/130] (403s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[619.367300] Starting subtest: rel-constants-invalid-rel-gen5
[619.369737] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[619.494160] [122/130] (402s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[619.616112] Starting subtest: cursorA-vs-flipA-atomic-transitions
[630.793991] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.178s)
[631.621374] [123/130] (390s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[631.724841] Starting subtest: 4-tiled-64bpp-rotate-270
[631.746836] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.019s)
[631.894716] [124/130] (390s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[631.988097] Starting subtest: psr-rgb565-draw-pwrite
[638.917918] Subtest psr-rgb565-draw-pwrite: SUCCESS (6.934s)
[639.072668] [125/130] (383s left) gem_exec_schedule (pi-ringfull)
[639.262620] Starting subtest: pi-ringfull
[639.264725] Starting dynamic subtest: rcs0
[639.287294] Dynamic subtest rcs0: SUCCESS (0.028s)
[639.304387] Starting dynamic subtest: bcs0
[639.315326] Dynamic subtest bcs0: SUCCESS (0.027s)
[639.328504] Starting dynamic subtest: vcs0
[639.344204] Dynamic subtest vcs0: SUCCESS (0.028s)
[639.359828] Starting dynamic subtest: vcs1
[639.372347] Dynamic subtest vcs1: SUCCESS (0.027s)
[639.387348] Starting dynamic subtest: vecs0
[639.399271] Dynamic subtest vecs0: SUCCESS (0.026s)
[639.413987] Starting dynamic subtest: ccs0
[639.427585] Dynamic subtest ccs0: SUCCESS (0.028s)
[639.430236] Subtest pi-ringfull: SUCCESS (0.169s)
[639.674645] [126/130] (382s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[639.734145] Starting subtest: y-tiled-ccs-to-yf-tiled
[639.739176] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[639.937912] [127/130] (382s left) kms_feature_discovery (display-2x)
[640.036524] Starting subtest: display-2x
[640.042250] Subtest display-2x: SKIP (0.000s)
[640.131837] [128/130] (382s left) gem_spin_batch (legacy)
[640.201781] Starting subtest: legacy
[640.204005] Starting dynamic subtest: default
[643.441226] Dynamic subtest default: SUCCESS (3.234s)
[643.452363] Starting dynamic subtest: render
[646.674262] Dynamic subtest render: SUCCESS (3.231s)
[646.687083] Starting dynamic subtest: bsd
[649.909104] Dynamic subtest bsd: SUCCESS (3.231s)
[649.922631] Starting dynamic subtest: bsd1
[653.141309] Dynamic subtest bsd1: SUCCESS (3.229s)
[653.154552] Starting dynamic subtest: bsd2
[656.375309] Dynamic subtest bsd2: SUCCESS (3.231s)
[656.389146] Starting dynamic subtest: blt
[659.610871] Dynamic subtest blt: SUCCESS (3.233s)
[659.624561] Starting dynamic subtest: vebox
[662.848310] Dynamic subtest vebox: SUCCESS (3.234s)
[662.851179] Subtest legacy: SUCCESS (22.646s)
[663.538562] [129/130] (359s left) syncobj_wait (invalid-signal-bad-pad)
[663.599126] Starting subtest: invalid-signal-bad-pad
[663.601941] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[663.736696] [130/130] (359s left) kms_lease (lease-revoke)
[663.824748] Starting subtest: lease-revoke
[663.827073] Starting dynamic subtest: pipe-A-eDP-1
[663.858818] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.034s)
[663.871922] Starting dynamic subtest: pipe-B-eDP-1
[663.894229] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.033s)
[663.904756] Starting dynamic subtest: pipe-C-eDP-1
[663.927312] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.032s)
[663.938373] Starting dynamic subtest: pipe-D-eDP-1
[663.959244] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.031s)
[663.961559] Subtest lease-revoke: SUCCESS (0.134s)
[664.086609] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: kms_chamelium_color
results: parsing output: 3/ for test: kms_vblank
results: parsing output: 4/ for test: gem_exec_alignment
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gem_exec_await
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: kms_psr2_sf
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: kms_flip_scaled_crc
results: parsing output: 11/ for test: kms_addfb_basic
results: parsing output: 12/ for test: gem_ctx_exec
results: parsing output: 13/ for test: gem_exec_parallel
results: parsing output: 14/ for test: kms_flip
results: parsing output: 15/ for test: kms_plane_scaling
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_plane_scaling
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: syncobj_basic
results: parsing output: 20/ for test: gem_exec_whisper
results: parsing output: 21/ for test: kms_chamelium_frames
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: gem_userptr_blits
results: parsing output: 24/ for test: i915_pm_rpm
results: parsing output: 25/ for test: gem_eio
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: gem_barrier_race
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: i915_power
results: parsing output: 31/ for test: gem_set_tiling_vs_gtt
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: kms_plane_alpha_blend
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_flip
results: parsing output: 36/ for test: kms_flip
results: parsing output: 37/ for test: api_intel_bb
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: prime_busy
results: parsing output: 40/ for test: i915_drm_fdinfo
results: parsing output: 41/ for test: kms_busy
results: parsing output: 42/ for test: kms_setmode
results: parsing output: 43/ for test: gem_fence_thrash
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_atomic
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: kms_content_protection
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: i915_query
results: parsing output: 50/ for test: gem_userptr_blits
results: parsing output: 51/ for test: gem_fence_thrash
results: parsing output: 52/ for test: kms_cursor_crc
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: kms_ccs
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_eio
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_exec_suspend
results: parsing output: 61/ for test: gem_workarounds
results: parsing output: 62/ for test: gem_exec_nop
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: kms_cursor_edge_walk
results: parsing output: 65/ for test: perf
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: syncobj_wait
results: parsing output: 68/ for test: gem_exec_schedule
results: parsing output: 69/ for test: core_hotunplug
results: parsing output: 70/ for test: kms_pm_rpm
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_pm_rpm
results: parsing output: 73/ for test: kms_hdr
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_flip
results: parsing output: 76/ for test: kms_prop_blob
results: parsing output: 77/ for test: gem_exec_params
results: parsing output: 78/ for test: i915_drm_fdinfo
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_setmode
results: parsing output: 83/ for test: drm_read
results: parsing output: 84/ for test: kms_vrr
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_mmap_offset
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: perf_pmu
results: parsing output: 89/ for test: gem_exec_big
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: perf_pmu
results: parsing output: 92/ for test: gem_exec_balancer
results: parsing output: 93/ for test: kms_chamelium_hpd
results: parsing output: 94/ for test: api_intel_allocator
results: parsing output: 95/ for test: syncobj_wait
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: gen9_exec_parse
results: parsing output: 98/ for test: gem_exec_fence
results: parsing output: 99/ for test: gem_exec_whisper
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: gem_exec_params
results: parsing output: 102/ for test: kms_flip_tiling
results: parsing output: 103/ for test: kms_plane_lowres
results: parsing output: 104/ for test: gem_exec_flush
results: parsing output: 105/ for test: gem_ctx_engines
results: parsing output: 106/ for test: kms_cursor_crc
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: syncobj_wait
results: parsing output: 109/ for test: gem_ctx_persistence
results: parsing output: 110/ for test: gem_exec_reloc
results: parsing output: 111/ for test: gem_reg_read
results: parsing output: 112/ for test: kms_cursor_legacy
results: parsing output: 113/ for test: gem_mmap_offset
results: parsing output: 114/ for test: gem_userptr_blits
results: parsing output: 115/ for test: gem_exec_fence
results: parsing output: 116/ for test: gem_pread
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_render_copy
results: parsing output: 119/ for test: gem_mmap_gtt
results: parsing output: 120/ for test: gem_exec_params
results: parsing output: 121/ for test: kms_cursor_legacy
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_exec_schedule
results: parsing output: 125/ for test: gem_render_copy
results: parsing output: 126/ for test: kms_feature_discovery
results: parsing output: 127/ for test: gem_spin_batch
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: kms_lease
Done.