[59.148273] Initializing watchdogs
[59.148319]   /dev/watchdog0
[59.161565] [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]
[59.166263] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.168454] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.171783] [001/130] (960s left) kms_psr (fbc-psr-primary-page-flip)
[59.288048] Starting subtest: fbc-psr-primary-page-flip
[59.289987] Starting dynamic subtest: eDP-1
[59.294206] Dynamic subtest eDP-1: SKIP (0.000s)
[59.298191] Subtest fbc-psr-primary-page-flip: SKIP (0.000s)
[59.377980] [002/130] (960s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[59.481747] Starting subtest: x-tiled-16bpp-rotate-90
[59.514251] Subtest x-tiled-16bpp-rotate-90: SKIP (0.032s)
[59.665803] [003/130] (960s left) kms_chamelium_color (ctm-0-50)
[59.765393] Subtest ctm-0-50: SKIP (0.000s)
[59.807328] [004/130] (959s left) kms_vblank (query-idle)
[59.905774] Starting subtest: query-idle
[59.908054] Starting dynamic subtest: pipe-A-eDP-1
[61.650174] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.749s)
[61.662986] Starting dynamic subtest: pipe-D-eDP-1
[64.108838] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.464s)
[64.111613] Subtest query-idle: SUCCESS (4.216s)
[64.954593] [005/130] (954s left) gem_exec_alignment (forked)
[65.029597] Starting subtest: forked
[101.933888] Subtest forked: SUCCESS (36.912s)
[103.256902] [006/130] (916s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[103.405371] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[103.409462] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[103.520923] [007/130] (916s left) gem_exec_await (wide-contexts)
[103.794406] Starting subtest: wide-contexts
[126.622610] Subtest wide-contexts: SUCCESS (22.828s)
[126.831607] [FACT gem_exec_await (wide-contexts)] new: kernel.kmod_is_loaded.vgem: true
[126.835843] [008/130] (893s left) kms_flip (2x-plain-flip-ts-check)
[126.992798] Starting subtest: 2x-plain-flip-ts-check
[127.002040] Subtest 2x-plain-flip-ts-check: SKIP (0.010s)
[127.145484] [009/130] (892s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[132.164084] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[132.168653] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.003s)
[133.037673] [010/130] (886s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[133.092971] Starting subtest: invalid-signal-one-illegal-handle
[133.095394] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[133.213870] [011/130] (886s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[133.313811] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[133.316604] Starting dynamic subtest: pipe-A-default-mode
[133.602229] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[133.606979] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.286s)
[134.468598] [012/130] (885s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[134.538277] Starting subtest: invalid-smem-bo-on-discrete
[134.543150] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[134.728531] [013/130] (885s left) gem_ctx_exec (basic-norecovery)
[134.797858] Starting subtest: basic-norecovery
[135.153681] Subtest basic-norecovery: SUCCESS (0.357s)
[135.320998] [014/130] (884s left) gem_exec_parallel (contexts)
[135.400066] Starting subtest: contexts
[135.401877] Starting dynamic subtest: rcs0
[139.068702] Dynamic subtest rcs0: SUCCESS (3.668s)
[139.079536] Starting dynamic subtest: bcs0
[143.097978] Dynamic subtest bcs0: SUCCESS (4.028s)
[143.108952] Starting dynamic subtest: vcs0
[147.430223] Dynamic subtest vcs0: SUCCESS (4.330s)
[147.441258] Starting dynamic subtest: vcs1
[151.476466] Dynamic subtest vcs1: SUCCESS (4.045s)
[151.486875] Starting dynamic subtest: vecs0
[155.491035] Dynamic subtest vecs0: SUCCESS (4.013s)
[155.505472] Starting dynamic subtest: ccs0
[159.915293] Dynamic subtest ccs0: SUCCESS (4.424s)
[159.917904] Subtest contexts: SUCCESS (24.515s)
[160.126109] [015/130] (860s left) kms_flip (2x-nonexisting-fb)
[160.221361] Starting subtest: 2x-nonexisting-fb
[160.231225] Subtest 2x-nonexisting-fb: SKIP (0.010s)
[160.376459] [016/130] (859s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[160.467801] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[160.470140] Starting dynamic subtest: pipe-A
[160.805948] Dynamic subtest pipe-A: SUCCESS (0.340s)
[160.814591] Starting dynamic subtest: pipe-B
[162.247594] Dynamic subtest pipe-B: SUCCESS (1.441s)
[162.255413] Starting dynamic subtest: pipe-C
[163.678619] Dynamic subtest pipe-C: SUCCESS (1.430s)
[163.688088] Starting dynamic subtest: pipe-D
[165.099291] Dynamic subtest pipe-D: SUCCESS (1.420s)
[165.101622] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.634s)
[166.299031] [017/130] (853s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[166.395499] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[166.399956] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[166.538363] [018/130] (853s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[166.624315] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[166.626727] Starting dynamic subtest: pipe-A
[166.644211] Dynamic subtest pipe-A: SKIP (0.015s)
[166.653534] Starting dynamic subtest: pipe-B
[166.672927] Dynamic subtest pipe-B: SKIP (0.028s)
[166.680827] Starting dynamic subtest: pipe-C
[166.702763] Dynamic subtest pipe-C: SKIP (0.029s)
[166.710649] Starting dynamic subtest: pipe-D
[166.729252] Dynamic subtest pipe-D: SKIP (0.028s)
[166.733062] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.101s)
[166.858189] [019/130] (853s left) kms_psr (psr-cursor-mmap-gtt)
[166.957130] Starting subtest: psr-cursor-mmap-gtt
[166.959579] Starting dynamic subtest: eDP-1
[168.683939] Dynamic subtest eDP-1: SUCCESS (1.727s)
[168.686410] Subtest psr-cursor-mmap-gtt: SUCCESS (1.727s)
[169.563915] [020/130] (850s left) syncobj_basic (illegal-fd-to-handle)
[169.624056] Starting subtest: illegal-fd-to-handle
[169.626368] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[169.759661] [021/130] (850s left) gem_exec_whisper (basic-queues-forked)
[169.829807] Starting subtest: basic-queues-forked
[192.943911] Subtest basic-queues-forked: SUCCESS (23.109s)
[193.146611] [022/130] (827s left) kms_chamelium_frames (dp-crc-single)
[193.538441] Subtest dp-crc-single: SKIP (0.000s)
[194.354550] [023/130] (826s left) syncobj_timeline (reset-during-wait-for-submit)
[194.413653] Starting subtest: reset-during-wait-for-submit
[194.517499] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[194.626649] [024/130] (825s left) gem_userptr_blits (probe)
[194.710031] Starting subtest: probe
[194.800667] Subtest probe: SUCCESS (0.091s)
[194.958698] [025/130] (825s left) i915_pm_rpm (gem-mmap-type)
[197.017419] Starting subtest: gem-mmap-type
[197.019889] Starting dynamic subtest: wb-smem0
[200.205396] Dynamic subtest wb-smem0: SUCCESS (3.187s)
[200.215198] Starting dynamic subtest: wc-smem0
[203.073387] Dynamic subtest wc-smem0: SUCCESS (2.867s)
[203.083225] Starting dynamic subtest: uc-smem0
[206.248638] Dynamic subtest uc-smem0: SUCCESS (3.176s)
[206.251056] Subtest gem-mmap-type: SUCCESS (9.232s)
[206.377675] [026/130] (814s left) gem_eio (in-flight-contexts-10ms)
[206.619066] Starting subtest: in-flight-contexts-10ms
[217.895058] Subtest in-flight-contexts-10ms: SUCCESS (11.275s)
[218.088316] [027/130] (802s left) syncobj_timeline (32bits-limit)
[218.153797] Starting subtest: 32bits-limit
[218.156047] Subtest 32bits-limit: SUCCESS (0.001s)
[218.281239] [028/130] (802s left) gem_barrier_race (remote-request)
[218.356081] Starting subtest: remote-request
[218.358373] Starting dynamic subtest: rcs0
[223.523098] Dynamic subtest rcs0: SUCCESS (5.169s)
[223.525139] Subtest remote-request: SUCCESS (5.170s)
[223.690345] [029/130] (797s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[223.797760] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[230.616669] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.820s)
[230.808336] [030/130] (790s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[230.912343] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[230.916645] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[231.034371] [031/130] (789s left) i915_power (sanity)
[231.097223] Starting subtest: sanity
[235.149985] Subtest sanity: SUCCESS (4.045s)
[236.994014] [032/130] (783s left) gem_set_tiling_vs_gtt
[237.131546] [033/130] (783s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[237.223027] Starting subtest: fbc-psr2-cursor-mmap-gtt
[237.225381] Starting dynamic subtest: eDP-1
[237.229858] Dynamic subtest eDP-1: SKIP (0.000s)
[237.234216] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.002s)
[237.323255] [034/130] (783s left) kms_plane_alpha_blend (alpha-basic)
[237.414187] Starting subtest: alpha-basic
[237.693834] Starting dynamic subtest: pipe-A-eDP-1
[239.598297] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.902s)
[239.626263] Starting dynamic subtest: pipe-D-eDP-1
[242.293484] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.678s)
[242.295813] Subtest alpha-basic: SUCCESS (4.879s)
[243.194302] [035/130] (777s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[243.285299] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[243.289592] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[243.432915] [036/130] (777s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[243.532466] Starting subtest: 2x-plain-flip-ts-check-interruptible
[243.544090] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.010s)
[243.686127] [037/130] (777s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[243.796129] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[243.808139] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.010s)
[243.949291] [038/130] (777s left) api_intel_bb (purge-bb)
[244.022326] Starting subtest: purge-bb
[244.027078] Subtest purge-bb: SUCCESS (0.004s)
[244.198483] [039/130] (777s left) kms_psr (fbc-pr-cursor-blt)
[244.278375] Starting subtest: fbc-pr-cursor-blt
[244.281830] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[244.381976] [040/130] (776s left) prime_busy (before)
[244.444728] Starting subtest: before
[244.449122] Starting dynamic subtest: rcs0
[244.496812] Dynamic subtest rcs0: SUCCESS (0.049s)
[244.507484] Starting dynamic subtest: bcs0
[244.579711] Dynamic subtest bcs0: SUCCESS (0.082s)
[244.589934] Starting dynamic subtest: vcs0
[244.621169] Dynamic subtest vcs0: SUCCESS (0.040s)
[244.631199] Starting dynamic subtest: vcs1
[244.662741] Dynamic subtest vcs1: SUCCESS (0.040s)
[244.671093] Starting dynamic subtest: vecs0
[244.702921] Dynamic subtest vecs0: SUCCESS (0.039s)
[244.711277] Starting dynamic subtest: ccs0
[244.743654] Dynamic subtest ccs0: SUCCESS (0.040s)
[244.853541] Subtest before: SUCCESS (0.407s)
[244.953107] [041/130] (776s left) i915_drm_fdinfo (virtual-idle)
[244.994161] Starting subtest: virtual-idle
[248.032518] Subtest virtual-idle: SUCCESS (3.039s)
[248.131274] [042/130] (773s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[248.235708] Starting subtest: extended-pageflip-modeset-hang-oldfb
[248.237599] Starting dynamic subtest: pipe-A
[256.133629] Dynamic subtest pipe-A: SUCCESS (7.895s)
[256.143380] Starting dynamic subtest: pipe-D
[264.779644] Dynamic subtest pipe-D: SUCCESS (8.645s)
[264.782702] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.546s)
[265.657571] [043/130] (755s left) kms_setmode (invalid-clone-single-crtc)
[265.723266] Starting subtest: invalid-clone-single-crtc
[265.729522] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[265.854303] [044/130] (755s left) gem_fence_thrash (bo-write-verify-y)
[265.890809] Starting subtest: bo-write-verify-y
[265.920287] Subtest bo-write-verify-y: SKIP (0.027s)
[265.989250] [045/130] (755s left) kms_frontbuffer_tracking (fbc-2p-rte)
[266.084592] Starting subtest: fbc-2p-rte
[266.088981] Subtest fbc-2p-rte: SKIP (0.000s)
[266.219802] [046/130] (755s left) kms_atomic (atomic-invalid-params)
[266.315881] Starting subtest: atomic-invalid-params
[266.318152] Starting dynamic subtest: pipe-A-eDP-1
[266.694212] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.376s)
[266.696513] Subtest atomic-invalid-params: SUCCESS (0.378s)
[267.579613] [047/130] (753s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[267.681100] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[267.683058] Starting dynamic subtest: pipe-A-eDP-1
[268.889888] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.210s)
[268.899288] Starting dynamic subtest: pipe-B-eDP-1
[271.157032] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.266s)
[271.167177] Starting dynamic subtest: pipe-C-eDP-1
[273.421438] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.263s)
[273.429707] Starting dynamic subtest: pipe-D-eDP-1
[275.728668] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.306s)
[275.730861] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.050s)
[276.925912] [048/130] (744s left) kms_content_protection (atomic-dpms)
[277.076133] Starting subtest: atomic-dpms
[277.080719] Subtest atomic-dpms: SKIP (0.000s)
[277.244391] [049/130] (744s left) kms_psr (psr-sprite-blt)
[277.346996] Starting subtest: psr-sprite-blt
[277.349404] Starting dynamic subtest: eDP-1
[279.106781] Dynamic subtest eDP-1: SUCCESS (1.760s)
[279.109155] Subtest psr-sprite-blt: SUCCESS (1.762s)
[279.966913] [050/130] (741s left) i915_query (query-topology-unsupported)
[280.022069] Starting subtest: query-topology-unsupported
[280.026186] Subtest query-topology-unsupported: SKIP (0.000s)
[280.181009] [051/130] (741s left) gem_userptr_blits (access-control)
[280.245308] Starting subtest: access-control
[280.249508] Subtest access-control: SKIP (0.000s)
[280.405174] [052/130] (741s left) gem_fence_thrash (bo-copy)
[280.436881] Starting subtest: bo-copy
[280.454895] Subtest bo-copy: SKIP (0.013s)
[280.525432] [053/130] (741s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[280.668958] Starting subtest: cursor-rapid-movement-32x32
[280.711575] Subtest cursor-rapid-movement-32x32: SKIP (0.040s)
[281.024512] [054/130] (740s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[281.124246] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[281.127717] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[281.266677] [055/130] (740s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[281.369188] Starting subtest: yf-tiled-64bpp-rotate-270
[281.372735] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[281.506536] [056/130] (740s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[281.618873] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[281.622267] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[281.764368] [057/130] (740s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[281.853395] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[281.855298] Starting dynamic subtest: pipe-A-eDP-1
[281.874114] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[281.884060] Starting dynamic subtest: pipe-B-eDP-1
[281.901270] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[281.909654] Starting dynamic subtest: pipe-C-eDP-1
[281.926954] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[281.935646] Starting dynamic subtest: pipe-D-eDP-1
[281.953453] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[281.956937] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[284.129419] [058/130] (737s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[284.223438] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[287.837081] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.617s)
[289.047764] [059/130] (733s left) gem_eio (wait-immediate)
[289.259054] Starting subtest: wait-immediate
[289.601199] Subtest wait-immediate: SUCCESS (0.340s)
[289.758280] [060/130] (732s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[289.862144] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[289.866170] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[290.014490] [061/130] (732s left) gem_exec_suspend (basic-s3)
[290.086138] Starting subtest: basic-S3
[290.087931] Starting dynamic subtest: smem
[310.464827] Dynamic subtest smem: SUCCESS (8.812s)
[310.467667] Subtest basic-S3: SUCCESS (8.814s)
[310.675744] [062/130] (711s left) gem_workarounds (suspend-resume)
[310.759476] Starting subtest: suspend-resume
[327.182883] Subtest suspend-resume: SUCCESS (1.170s)
[327.300297] [063/130] (694s left) gem_exec_nop (basic-parallel)
[327.390428] Starting subtest: basic-parallel
[343.695089] Subtest basic-parallel: SUCCESS (16.451s)
[343.976700] [064/130] (678s left) kms_big_fb (linear-8bpp-rotate-0)
[344.085070] Starting subtest: linear-8bpp-rotate-0
[345.262626] Subtest linear-8bpp-rotate-0: SUCCESS (1.180s)
[345.394481] [065/130] (676s left) kms_cursor_edge_walk (128x128-top-bottom)
[345.500179] Starting subtest: 128x128-top-bottom
[345.502189] Starting dynamic subtest: pipe-A-eDP-1
[348.931246] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.435s)
[348.951655] Starting dynamic subtest: pipe-D-eDP-1
[352.049795] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.122s)
[352.051682] Subtest 128x128-top-bottom: SUCCESS (6.560s)
[352.875411] [066/130] (669s left) perf (whitelisted-registers-userspace-config)
[352.996676] Starting subtest: whitelisted-registers-userspace-config
[352.999145] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[353.047917] [067/130] (669s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[353.152517] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[353.157001] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[353.295651] [068/130] (669s left) syncobj_wait (single-wait-for-submit-signaled)
[353.360454] Starting subtest: single-wait-for-submit-signaled
[353.362885] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[353.488060] [069/130] (669s left) gem_exec_schedule (thriceslice)
[353.568120] Starting subtest: thriceslice
[353.570173] Starting dynamic subtest: rcs0
[353.586347] Dynamic subtest rcs0: SUCCESS (0.029s)
[353.598087] Starting dynamic subtest: bcs0
[353.615155] Dynamic subtest bcs0: SUCCESS (0.028s)
[353.625112] Starting dynamic subtest: vcs0
[353.666180] Dynamic subtest vcs0: SUCCESS (0.050s)
[353.679184] Starting dynamic subtest: vcs1
[353.696062] Dynamic subtest vcs1: SUCCESS (0.028s)
[353.705552] Starting dynamic subtest: vecs0
[353.724400] Dynamic subtest vecs0: SUCCESS (0.027s)
[353.733847] Starting dynamic subtest: ccs0
[353.753277] Dynamic subtest ccs0: SUCCESS (0.028s)
[353.755470] Subtest thriceslice: SUCCESS (0.197s)
[354.075670] [070/130] (668s left) core_hotunplug (unbind-rebind)
[354.169020] Starting subtest: unbind-rebind
[360.423655] Subtest unbind-rebind: SUCCESS (6.257s)
[360.474840] [071/130] (662s left) kms_pm_rpm (universal-planes)
[362.022778] Starting subtest: universal-planes
[362.025294] Starting dynamic subtest: plane-33
[370.276919] Dynamic subtest plane-33: SUCCESS (8.255s)
[370.289530] Starting dynamic subtest: plane-63
[378.545624] Dynamic subtest plane-63: SUCCESS (8.266s)
[378.558142] Starting dynamic subtest: plane-93
[387.145578] Dynamic subtest plane-93: SUCCESS (8.599s)
[387.158052] Starting dynamic subtest: plane-123
[395.438764] Dynamic subtest plane-123: SUCCESS (8.292s)
[395.451653] Starting dynamic subtest: plane-133
[403.718406] Dynamic subtest plane-133: SUCCESS (8.280s)
[403.736299] Starting dynamic subtest: plane-143
[412.403955] Dynamic subtest plane-143: SUCCESS (8.685s)
[412.406719] Subtest universal-planes: SUCCESS (50.394s)
[412.792134] [072/130] (609s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[412.895849] Starting subtest: fbc-rgb101010-draw-mmap-wc
[417.461097] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.571s)
[418.602989] [073/130] (604s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[420.828759] Starting subtest: dpms-mode-unset-lpsp
[424.894779] Subtest dpms-mode-unset-lpsp: SUCCESS (4.064s)
[425.293035] [074/130] (597s left) kms_hdr (static-toggle)
[425.388141] Starting subtest: static-toggle
[425.394650] Subtest static-toggle: SKIP (0.000s)
[425.488771] [075/130] (597s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[425.581891] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[432.410076] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.828s)
[432.572064] [076/130] (590s left) kms_flip (dpms-vs-vblank-race)
[432.667802] Starting subtest: dpms-vs-vblank-race
[432.670062] Starting dynamic subtest: A-eDP1
[436.541246] Dynamic subtest A-eDP1: SUCCESS (3.869s)
[436.551878] Starting dynamic subtest: B-eDP1
[441.147030] Dynamic subtest B-eDP1: SUCCESS (4.603s)
[441.157277] Starting dynamic subtest: C-eDP1
[445.773435] Dynamic subtest C-eDP1: SUCCESS (4.624s)
[445.785578] Starting dynamic subtest: D-eDP1
[450.409604] Dynamic subtest D-eDP1: SUCCESS (4.635s)
[450.411786] Subtest dpms-vs-vblank-race: SUCCESS (17.739s)
[451.307692] [077/130] (571s left) kms_prop_blob (invalid-get-prop-any)
[451.370042] Starting subtest: invalid-get-prop-any
[451.372238] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[451.509526] [078/130] (571s left) gem_exec_params (rel-constants-invalid-ring)
[451.568550] Starting subtest: rel-constants-invalid-ring
[451.570813] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[451.713403] [079/130] (571s left) i915_drm_fdinfo (memory-info-idle)
[451.755379] Starting subtest: memory-info-idle
[451.757592] Starting dynamic subtest: smem0
[451.816661] Dynamic subtest smem0: SUCCESS (0.063s)
[451.819424] Subtest memory-info-idle: SUCCESS (0.064s)
[451.915765] [080/130] (571s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[452.022174] Starting subtest: fbcpsr-slowdraw
[477.165145] Subtest fbcpsr-slowdraw: SUCCESS (25.147s)
[477.339149] [081/130] (545s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[477.442047] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[477.446520] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[477.582605] [082/130] (545s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[477.676586] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[477.680959] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[477.800144] [083/130] (545s left) kms_setmode (basic-clone-single-crtc)
[477.861872] Starting subtest: basic-clone-single-crtc
[477.868080] Subtest basic-clone-single-crtc: SKIP (0.000s)
[477.976675] [084/130] (545s left) drm_read (invalid-buffer)
[478.109811] Starting subtest: invalid-buffer
[478.111873] Subtest invalid-buffer: SUCCESS (0.000s)
[478.273196] [085/130] (544s left) kms_vrr (flip-basic-fastset)
[478.361825] Starting subtest: flip-basic-fastset
[478.367120] Subtest flip-basic-fastset: SKIP (0.000s)
[478.461145] [086/130] (544s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[478.565069] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[485.277638] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.716s)
[485.432175] [087/130] (537s left) gem_mmap_offset (bad-object)
[485.498649] Starting subtest: bad-object
[485.501286] Subtest bad-object: SUCCESS (0.001s)
[485.635826] [088/130] (537s left) syncobj_timeline (single-wait-available-signaled)
[485.691182] Starting subtest: single-wait-available-signaled
[485.693117] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[485.814301] [089/130] (537s left) perf_pmu (most-busy-check-all)
[485.860120] Starting subtest: most-busy-check-all
[485.862463] Starting dynamic subtest: rcs0
[487.694152] Dynamic subtest rcs0: SUCCESS (1.832s)
[487.708584] Starting dynamic subtest: bcs0
[489.742274] Dynamic subtest bcs0: SUCCESS (2.045s)
[489.756004] Starting dynamic subtest: vcs0
[491.725464] Dynamic subtest vcs0: SUCCESS (1.981s)
[491.739518] Starting dynamic subtest: vcs1
[493.710465] Dynamic subtest vcs1: SUCCESS (1.983s)
[493.724651] Starting dynamic subtest: vecs0
[495.694095] Dynamic subtest vecs0: SUCCESS (1.981s)
[495.708001] Starting dynamic subtest: ccs0
[497.742431] Dynamic subtest ccs0: SUCCESS (2.046s)
[497.745495] Subtest most-busy-check-all: SUCCESS (11.884s)
[497.882179] [090/130] (525s left) gem_exec_big (single)
[497.939601] Starting subtest: single
[500.272999] Subtest single: SUCCESS (2.332s)
[500.522912] [091/130] (522s left) kms_psr (pr-sprite-mmap-gtt)
[500.663376] Starting subtest: pr-sprite-mmap-gtt
[500.667868] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[500.776178] [092/130] (522s left) perf_pmu (busy-idle)
[500.833771] Starting subtest: busy-idle
[500.836271] Starting dynamic subtest: rcs0
[501.543404] Dynamic subtest rcs0: SUCCESS (0.709s)
[501.556384] Starting dynamic subtest: bcs0
[502.214431] Dynamic subtest bcs0: SUCCESS (0.669s)
[502.230380] Starting dynamic subtest: vcs0
[503.693762] Dynamic subtest vcs0: SUCCESS (1.475s)
[503.706593] Starting dynamic subtest: vcs1
[505.742690] Dynamic subtest vcs1: SUCCESS (2.047s)
[505.755520] Starting dynamic subtest: vecs0
[507.725753] Dynamic subtest vecs0: SUCCESS (1.980s)
[507.738902] Starting dynamic subtest: ccs0
[508.400293] Dynamic subtest ccs0: SUCCESS (0.673s)
[508.402857] Subtest busy-idle: SUCCESS (7.569s)
[508.529801] [093/130] (514s left) gem_exec_balancer (invalid-bonds)
[508.599436] Starting subtest: invalid-bonds
[508.604027] Subtest invalid-bonds: SKIP (0.000s)
[508.925876] [094/130] (514s left) kms_chamelium_hpd (dp-hpd-fast)
[509.318481] Subtest dp-hpd-fast: SKIP (0.000s)
[510.183126] [095/130] (513s left) api_intel_allocator (reloc-allocator)
[510.245770] Starting subtest: reloc-allocator
[510.248363] Starting dynamic subtest: basic
[510.250499] Dynamic subtest basic: SUCCESS (0.003s)
[510.261406] Starting dynamic subtest: parallel-one
[510.263689] Dynamic subtest parallel-one: SUCCESS (0.008s)
[510.273570] Starting dynamic subtest: print
[510.275476] Dynamic subtest print: SUCCESS (0.000s)
[510.284675] Starting dynamic subtest: reuse
[510.286606] Dynamic subtest reuse: SUCCESS (0.000s)
[510.295716] Starting dynamic subtest: fork-reopen-allocator
[510.297801] Dynamic subtest fork-reopen-allocator: SUCCESS (0.010s)
[510.299809] Subtest reloc-allocator: SUCCESS (0.024s)
[510.429323] [096/130] (513s left) syncobj_wait (multi-wait-all-signaled)
[510.496497] Starting subtest: multi-wait-all-signaled
[510.498741] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[510.604348] [097/130] (513s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[510.665779] Starting subtest: etime-single-wait-for-submit-unsubmitted
[510.769524] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[510.880528] [098/130] (512s left) gen9_exec_parse (batch-invalid-length)
[510.935612] Subtest batch-invalid-length: SKIP (0.000s)
[511.025596] [099/130] (512s left) gem_exec_fence (syncobj-signal)
[511.455706] Starting subtest: syncobj-signal
[511.461861] Subtest syncobj-signal: SUCCESS (0.004s)
[512.852707] [100/130] (510s left) gem_exec_whisper (basic-fds-priority)
[512.925013] Starting subtest: basic-fds-priority
[536.489816] Subtest basic-fds-priority: SUCCESS (23.568s)
[536.700934] [101/130] (487s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[536.804296] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[536.806535] Starting dynamic subtest: pipe-A-eDP-1
[537.676909] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.866s)
[537.687853] Starting dynamic subtest: pipe-B-eDP-1
[539.325903] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.648s)
[539.336986] Starting dynamic subtest: pipe-C-eDP-1
[540.868919] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.541s)
[540.878829] Starting dynamic subtest: pipe-D-eDP-1
[542.337329] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.469s)
[542.339271] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.529s)
[543.541093] [102/130] (480s left) gem_exec_params (batch-first)
[543.600120] Starting subtest: batch-first
[543.602848] Subtest batch-first: SUCCESS (0.006s)
[543.754923] [103/130] (480s left) kms_flip_tiling (flip-change-tiling)
[543.851696] Starting subtest: flip-change-tiling
[543.854106] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs
[544.105604] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.252s)
[544.118296] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs
[544.251337] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.142s)
[544.264206] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[544.395690] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.142s)
[544.408702] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4
[544.567082] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.169s)
[544.580171] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x
[544.726774] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.158s)
[544.738768] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear
[544.848557] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.120s)
[544.863232] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs
[544.960742] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.109s)
[544.973861] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs
[545.071666] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[545.083252] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[545.217075] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.142s)
[545.235146] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4
[545.372023] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.154s)
[545.384631] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x
[545.514961] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[545.530351] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear
[545.659968] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[545.680780] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[545.804737] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.141s)
[545.817453] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[545.949992] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.142s)
[545.964996] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[546.070987] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.120s)
[546.083706] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4
[546.244349] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.170s)
[546.263098] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x
[546.398313] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.154s)
[546.410857] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear
[546.542486] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[546.560993] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs
[546.687510] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s)
[546.700290] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs
[546.832057] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.141s)
[546.845271] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc
[546.976268] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[546.987549] Starting dynamic subtest: pipe-A-eDP-1-4-to-4
[547.109096] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.131s)
[547.121679] Starting dynamic subtest: pipe-A-eDP-1-4-to-x
[547.264228] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.153s)
[547.276489] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear
[547.408638] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.142s)
[547.419790] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs
[547.552702] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[547.566754] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs
[547.697383] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[547.709260] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc
[547.841803] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[547.856778] Starting dynamic subtest: pipe-A-eDP-1-x-to-4
[548.029871] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.185s)
[548.044425] Starting dynamic subtest: pipe-A-eDP-1-x-to-x
[548.152684] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.120s)
[548.165214] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear
[548.296899] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.142s)
[548.309756] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs
[548.440744] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[548.455259] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs
[548.585404] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.141s)
[548.600102] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc
[548.730406] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.143s)
[548.741611] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4
[548.906034] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.174s)
[548.921010] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x
[549.050655] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.142s)
[549.063291] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear
[549.172772] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.120s)
[549.225489] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs
[550.487800] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.269s)
[550.501481] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs
[550.633469] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.142s)
[550.646453] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[550.766662] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[550.779823] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4
[550.938716] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.170s)
[550.951786] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x
[551.081756] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[551.094591] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear
[551.226562] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[551.238340] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs
[551.370987] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.142s)
[551.384878] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs
[551.482536] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[551.495520] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[551.628260] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.142s)
[551.641075] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4
[551.800175] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.170s)
[551.813235] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x
[551.942690] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[551.954722] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear
[552.087189] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[552.099376] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[552.221504] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[552.233912] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[552.355758] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s)
[552.367497] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[552.466066] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[552.479018] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4
[552.610482] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.142s)
[552.623428] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x
[552.754348] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[552.767819] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear
[552.898894] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[552.912258] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs
[553.044234] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s)
[553.058037] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs
[553.188440] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s)
[553.202053] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc
[553.332991] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[553.348455] Starting dynamic subtest: pipe-B-eDP-1-4-to-4
[553.455101] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.120s)
[553.473206] Starting dynamic subtest: pipe-B-eDP-1-4-to-x
[553.599182] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.142s)
[553.612130] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear
[553.743647] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.142s)
[553.761976] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs
[553.888155] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.143s)
[553.900838] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs
[554.032043] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[554.046920] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc
[554.176752] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[554.189039] Starting dynamic subtest: pipe-B-eDP-1-x-to-4
[554.321145] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.142s)
[554.336019] Starting dynamic subtest: pipe-B-eDP-1-x-to-x
[554.457554] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.131s)
[554.475252] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear
[554.599803] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.142s)
[554.612193] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs
[554.743921] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[554.756545] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs
[554.888245] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[554.901474] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc
[555.032508] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[555.047337] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4
[555.177230] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.142s)
[555.192591] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x
[555.322320] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.142s)
[555.335324] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear
[555.444827] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.120s)
[555.499715] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs
[556.733362] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.242s)
[556.746816] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs
[556.844432] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[556.856796] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[556.944399] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[556.957789] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4
[557.055837] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s)
[557.069013] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x
[557.166175] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s)
[557.179422] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear
[557.277588] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.109s)
[557.288966] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs
[557.388980] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.109s)
[557.402720] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs
[557.499828] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[557.512109] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[557.599715] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[557.613932] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4
[557.710594] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.108s)
[557.724200] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x
[557.821482] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[557.835981] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear
[557.932441] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.109s)
[557.945005] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[558.033284] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s)
[558.046490] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[558.144341] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.109s)
[558.156713] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[558.244222] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[558.258134] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4
[558.355402] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.108s)
[558.370612] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x
[558.466289] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.108s)
[558.478777] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear
[558.588340] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.120s)
[558.603251] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs
[558.688641] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.098s)
[558.700625] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs
[558.800352] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.109s)
[558.812881] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc
[558.910911] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.109s)
[558.925851] Starting dynamic subtest: pipe-C-eDP-1-4-to-4
[559.022320] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.109s)
[559.035096] Starting dynamic subtest: pipe-C-eDP-1-4-to-x
[559.132829] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.109s)
[559.145330] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear
[559.244307] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.110s)
[559.257122] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs
[559.355168] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.109s)
[559.369207] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs
[559.455219] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.098s)
[559.467030] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc
[559.555375] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.099s)
[559.566540] Starting dynamic subtest: pipe-C-eDP-1-x-to-4
[559.666866] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.109s)
[559.679069] Starting dynamic subtest: pipe-C-eDP-1-x-to-x
[559.777643] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.110s)
[559.792697] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear
[559.889355] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.109s)
[559.902164] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs
[559.988991] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.098s)
[560.001247] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs
[560.089030] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.099s)
[560.101757] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc
[560.200254] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.110s)
[560.212050] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4
[560.311131] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.109s)
[560.326768] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x
[560.422789] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.109s)
[560.435839] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear
[560.533815] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.109s)
[560.575183] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs
[561.773091] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.204s)
[561.786457] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs
[561.873015] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[561.887765] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[561.995485] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.119s)
[562.007127] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4
[562.106393] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s)
[562.118928] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x
[562.217207] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s)
[562.228116] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear
[562.328389] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.110s)
[562.343754] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs
[562.439718] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.110s)
[562.453098] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs
[562.539786] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[562.550868] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[562.651058] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.109s)
[562.663226] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4
[562.761634] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s)
[562.774218] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x
[562.872705] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[562.884607] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear
[562.972856] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.098s)
[562.984483] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[563.073367] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.099s)
[563.085574] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[563.173245] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[563.185214] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[563.273108] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[563.285559] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4
[563.384237] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s)
[563.397201] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x
[563.495069] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[563.507282] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear
[563.617157] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.121s)
[563.630013] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs
[563.728862] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.109s)
[563.740493] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs
[563.840167] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.109s)
[563.851005] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc
[563.940216] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.098s)
[563.951189] Starting dynamic subtest: pipe-D-eDP-1-4-to-4
[564.051274] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.110s)
[564.063977] Starting dynamic subtest: pipe-D-eDP-1-4-to-x
[564.161925] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.109s)
[564.172984] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear
[564.273048] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.110s)
[564.285259] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs
[564.384240] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.110s)
[564.396448] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs
[564.495467] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.109s)
[564.506798] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc
[564.606795] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.109s)
[564.618466] Starting dynamic subtest: pipe-D-eDP-1-x-to-4
[564.717844] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.109s)
[564.729973] Starting dynamic subtest: pipe-D-eDP-1-x-to-x
[564.839799] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.121s)
[564.853801] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear
[564.989805] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.147s)
[565.003141] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs
[565.089837] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.098s)
[565.104313] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs
[565.240315] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.147s)
[565.252260] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc
[565.350944] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s)
[565.368274] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4
[565.461927] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.109s)
[565.473942] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x
[565.572982] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.110s)
[565.585059] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear
[565.695595] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.120s)
[565.728467] Subtest flip-change-tiling: SUCCESS (21.874s)
[566.994190] [104/130] (456s left) kms_plane_lowres (tiling-x)
[567.094058] Starting subtest: tiling-x
[567.096416] Starting dynamic subtest: pipe-A-eDP-1
[567.101006] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[567.387492] Starting dynamic subtest: pipe-B-eDP-1
[567.392093] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[567.401673] Starting dynamic subtest: pipe-C-eDP-1
[567.406309] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[567.415845] Starting dynamic subtest: pipe-D-eDP-1
[567.419964] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[567.423919] Subtest tiling-x: SKIP (0.292s)
[568.226754] [105/130] (455s left) gem_exec_flush (basic-wb-ro-before-default)
[568.291251] Starting subtest: basic-wb-ro-before-default
[573.749834] Subtest basic-wb-ro-before-default: SUCCESS (5.458s)
[573.969239] [106/130] (450s left) gem_ctx_engines (execute-allforone)
[574.042564] Starting subtest: execute-allforone
[574.065522] Subtest execute-allforone: SUCCESS (0.023s)
[575.815221] [107/130] (448s left) kms_cursor_crc (cursor-offscreen-64x64)
[575.997864] Starting subtest: cursor-offscreen-64x64
[576.000165] Starting dynamic subtest: pipe-A-eDP-1
[577.940276] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.939s)
[577.967629] Starting dynamic subtest: pipe-D-eDP-1
[580.516310] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.556s)
[580.518637] Subtest cursor-offscreen-64x64: SUCCESS (4.520s)
[581.398266] [108/130] (442s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[581.502886] Starting subtest: bad-rotation-90-y-tiled-ccs
[581.505171] Starting dynamic subtest: pipe-A-eDP-1
[581.527050] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[581.539665] Starting dynamic subtest: pipe-B-eDP-1
[581.561483] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[581.571205] Starting dynamic subtest: pipe-C-eDP-1
[581.593120] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[581.602587] Starting dynamic subtest: pipe-D-eDP-1
[581.625317] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[581.629938] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.004s)
[583.687160] [109/130] (440s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[583.758512] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[583.866112] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.107s)
[583.968944] [110/130] (440s left) gem_ctx_persistence (heartbeat-stop)
[584.035899] Starting subtest: heartbeat-stop
[584.040531] Subtest heartbeat-stop: SKIP (0.000s)
[584.170342] [111/130] (440s left) gem_exec_reloc (basic-gtt-noreloc)
[584.236582] Subtest basic-gtt-noreloc: SKIP (0.000s)
[584.318015] [112/130] (440s left) gem_reg_read (bad-register)
[584.363398] Starting subtest: bad-register
[584.365654] Subtest bad-register: SUCCESS (0.000s)
[584.502641] [113/130] (439s left) kms_cursor_legacy (single-bo)
[584.649548] Starting subtest: single-bo
[584.651818] Starting dynamic subtest: pipe-A
[590.034857] Dynamic subtest pipe-A: SUCCESS (5.380s)
[590.047446] Starting dynamic subtest: pipe-B
[595.416199] Dynamic subtest pipe-B: SUCCESS (5.380s)
[595.428231] Starting dynamic subtest: pipe-C
[600.795534] Dynamic subtest pipe-C: SUCCESS (5.378s)
[600.808302] Starting dynamic subtest: pipe-D
[606.182422] Dynamic subtest pipe-D: SUCCESS (5.381s)
[606.194365] Starting dynamic subtest: all-pipes
[611.565662] Dynamic subtest all-pipes: SUCCESS (5.385s)
[611.568129] Subtest single-bo: SUCCESS (26.911s)
[611.734635] [114/130] (412s left) gem_mmap_offset (ptrace)
[611.796985] Starting subtest: ptrace
[611.799256] Starting dynamic subtest: smem0-wb
[611.816939] Dynamic subtest smem0-wb: SUCCESS (0.019s)
[611.827569] Starting dynamic subtest: smem0-wc
[611.833933] Dynamic subtest smem0-wc: SUCCESS (0.016s)
[611.843469] Starting dynamic subtest: smem0-uc
[611.852821] Dynamic subtest smem0-uc: SUCCESS (0.018s)
[611.855134] Subtest ptrace: SUCCESS (0.059s)
[612.019958] [115/130] (412s left) gem_userptr_blits (sync-unmap-after-close)
[612.088618] Starting subtest: sync-unmap-after-close
[612.098013] Subtest sync-unmap-after-close: SUCCESS (0.011s)
[612.261511] [116/130] (412s left) gem_exec_fence (syncobj-unused-fence)
[612.725900] Starting subtest: syncobj-unused-fence
[612.731225] Subtest syncobj-unused-fence: SUCCESS (0.005s)
[613.825997] [117/130] (410s left) gem_pread (snoop)
[613.884569] Subtest snoop: SKIP (0.000s)
[613.955693] [118/130] (410s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[614.047374] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[614.051443] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[614.190110] [119/130] (410s left) gem_render_copy (yf-tiled-ccs-to-linear)
[614.260992] Starting subtest: yf-tiled-ccs-to-linear
[614.265567] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[614.470125] [120/130] (410s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[614.526620] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[614.592215] [121/130] (410s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[614.655621] Starting subtest: rel-constants-invalid-rel-gen5
[614.658004] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[614.804371] [122/130] (409s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[614.925081] Starting subtest: cursorA-vs-flipA-atomic-transitions
[626.101136] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.174s)
[626.920289] [123/130] (397s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[627.027168] Starting subtest: 4-tiled-64bpp-rotate-270
[627.050425] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.020s)
[627.209865] [124/130] (397s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[627.308539] Starting subtest: psr-rgb565-draw-pwrite
[634.225359] Subtest psr-rgb565-draw-pwrite: SUCCESS (6.920s)
[634.367174] [125/130] (390s left) gem_exec_schedule (pi-ringfull)
[634.543384] Starting subtest: pi-ringfull
[634.545602] Starting dynamic subtest: rcs0
[634.568872] Dynamic subtest rcs0: SUCCESS (0.029s)
[634.581748] Starting dynamic subtest: bcs0
[634.597743] Dynamic subtest bcs0: SUCCESS (0.028s)
[634.612192] Starting dynamic subtest: vcs0
[634.624301] Dynamic subtest vcs0: SUCCESS (0.026s)
[634.638425] Starting dynamic subtest: vcs1
[634.651538] Dynamic subtest vcs1: SUCCESS (0.026s)
[634.666394] Starting dynamic subtest: vecs0
[634.678189] Dynamic subtest vecs0: SUCCESS (0.026s)
[634.692784] Starting dynamic subtest: ccs0
[634.705338] Dynamic subtest ccs0: SUCCESS (0.026s)
[634.707549] Subtest pi-ringfull: SUCCESS (0.166s)
[634.964039] [126/130] (389s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[635.022836] Starting subtest: y-tiled-ccs-to-yf-tiled
[635.026902] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[635.226188] [127/130] (389s left) kms_feature_discovery (display-2x)
[635.323854] Starting subtest: display-2x
[635.328340] Subtest display-2x: SKIP (0.000s)
[635.432614] [128/130] (389s left) gem_spin_batch (legacy)
[635.497635] Starting subtest: legacy
[635.499699] Starting dynamic subtest: default
[638.734062] Dynamic subtest default: SUCCESS (3.234s)
[638.746887] Starting dynamic subtest: render
[641.968498] Dynamic subtest render: SUCCESS (3.232s)
[641.981116] Starting dynamic subtest: bsd
[645.205223] Dynamic subtest bsd: SUCCESS (3.235s)
[645.218548] Starting dynamic subtest: bsd1
[648.439856] Dynamic subtest bsd1: SUCCESS (3.230s)
[648.452792] Starting dynamic subtest: bsd2
[651.673879] Dynamic subtest bsd2: SUCCESS (3.231s)
[651.686293] Starting dynamic subtest: blt
[654.910968] Dynamic subtest blt: SUCCESS (3.235s)
[654.923628] Starting dynamic subtest: vebox
[658.143031] Dynamic subtest vebox: SUCCESS (3.230s)
[658.145577] Subtest legacy: SUCCESS (22.647s)
[658.846825] [129/130] (366s left) syncobj_wait (invalid-signal-bad-pad)
[658.897542] Starting subtest: invalid-signal-bad-pad
[658.899563] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[659.038224] [130/130] (366s left) kms_lease (lease-revoke)
[659.132769] Starting subtest: lease-revoke
[659.134965] Starting dynamic subtest: pipe-A-eDP-1
[659.165442] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.031s)
[659.177252] Starting dynamic subtest: pipe-B-eDP-1
[659.191096] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.027s)
[659.201666] Starting dynamic subtest: pipe-C-eDP-1
[659.219660] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.027s)
[659.230782] Starting dynamic subtest: pipe-D-eDP-1
[659.247208] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.026s)
[659.249476] Subtest lease-revoke: SUCCESS (0.117s)
[659.395513] 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.