[56.534687] Initializing watchdogs
[56.534732]   /dev/watchdog0
[56.549152] [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.553422] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.555574] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.559073] [001/133] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[56.696906] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[56.701412] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[56.791840] [002/133] (960s left) gem_mmap_gtt (fault-concurrent-x)
[56.843257] Subtest fault-concurrent-X: SKIP (0.000s)
[56.899160] [003/133] (960s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[56.997324] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[57.010197] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s)
[57.092985] [004/133] (960s left) syncobj_wait (wait-any-snapshot)
[57.157069] Starting subtest: wait-any-snapshot
[57.238962] Subtest wait-any-snapshot: SUCCESS (0.083s)
[57.310115] [005/133] (959s left) kms_frontbuffer_tracking (psr-1p-rte)
[57.409584] Starting subtest: psr-1p-rte
[62.840906] Subtest psr-1p-rte: SUCCESS (5.488s)
[62.983284] [006/133] (954s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[63.078918] Starting subtest: disable-crc-after-crtc
[63.081244] Starting dynamic subtest: pipe-A-eDP-1
[64.764760] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.694s)
[64.773805] Starting dynamic subtest: pipe-B-eDP-1
[67.109028] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.354s)
[67.118108] Starting dynamic subtest: pipe-C-eDP-1
[69.342359] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.239s)
[69.350539] Starting dynamic subtest: pipe-D-eDP-1
[71.629403] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.291s)
[71.631580] Subtest disable-crc-after-crtc: SUCCESS (8.582s)
[72.508446] [007/133] (944s left) kms_dp_link_training (uhbr-sst)
[72.706325] Starting subtest: uhbr-sst
[72.714831] Subtest uhbr-sst: SKIP (0.000s)
[72.991753] [008/133] (944s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[73.088562] Starting subtest: invalid-single-wait-all-unsubmitted
[73.090938] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[73.215048] [009/133] (944s left) gem_ctx_isolation (preservation)
[73.293445] Starting subtest: preservation
[73.295844] Starting dynamic subtest: rcs0
[73.543772] Dynamic subtest rcs0: SUCCESS (0.250s)
[73.551897] Starting dynamic subtest: bcs0
[73.688780] Dynamic subtest bcs0: SUCCESS (0.146s)
[73.699534] Starting dynamic subtest: vcs0
[73.834652] Dynamic subtest vcs0: SUCCESS (0.146s)
[73.846549] Starting dynamic subtest: vcs1
[75.450810] Dynamic subtest vcs1: SUCCESS (1.618s)
[75.461808] Starting dynamic subtest: vecs0
[77.435705] Dynamic subtest vecs0: SUCCESS (1.986s)
[77.445021] Starting dynamic subtest: ccs0
[79.422290] Dynamic subtest ccs0: SUCCESS (1.988s)
[79.425077] Subtest preservation: SUCCESS (6.135s)
[79.641526] [010/133] (937s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[79.736421] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[79.740850] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[79.844282] [011/133] (937s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[79.925087] Starting subtest: primary-y-tiled-reflect-x-270
[79.929501] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[80.005654] [012/133] (937s left) kms_psr (fbc-psr-no-drrs)
[80.108824] Starting subtest: fbc-psr-no-drrs
[80.111108] Starting dynamic subtest: eDP-1
[80.115243] Dynamic subtest eDP-1: SKIP (0.000s)
[80.119356] Subtest fbc-psr-no-drrs: SKIP (0.000s)
[80.193760] [013/133] (937s left) core_setmaster (master-drop-set-user)
[80.276824] Starting subtest: master-drop-set-user
[80.290924] Subtest master-drop-set-user: SUCCESS (0.013s)
[80.326959] [014/133] (937s left) gem_eio (wait-1us)
[80.517327] Starting subtest: wait-1us
[80.797122] Subtest wait-1us: SUCCESS (0.280s)
[80.946125] [015/133] (936s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[81.035911] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[81.037928] Starting dynamic subtest: pipe-A-eDP-1
[81.054076] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[81.062077] Starting dynamic subtest: pipe-B-eDP-1
[81.078343] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[81.085486] Starting dynamic subtest: pipe-C-eDP-1
[81.103182] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[81.118970] Starting dynamic subtest: pipe-D-eDP-1
[81.136943] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[81.138759] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[83.302860] [016/133] (934s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[83.406719] Starting subtest: y-tiled-16bpp-rotate-90
[83.411025] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[83.499387] [017/133] (934s left) gem_ppgtt (shrink-vs-evict-pinned)
[83.561085] Starting subtest: shrink-vs-evict-pinned
[91.254581] Subtest shrink-vs-evict-pinned: SUCCESS (7.691s)
[91.344376] [018/133] (926s left) kms_getfb (getfb-reject-nv12)
[91.441603] Starting subtest: getfb-reject-nv12
[91.443836] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[91.532196] [019/133] (926s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[91.637595] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[99.328883] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.694s)
[99.449158] [020/133] (918s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[99.549525] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[99.553667] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[99.654461] [021/133] (918s left) kms_properties (plane-properties-legacy)
[99.748344] Starting subtest: plane-properties-legacy
[99.750980] Starting dynamic subtest: pipe-A-eDP-1
[100.333634] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.586s)
[100.344111] Starting dynamic subtest: pipe-B-eDP-1
[101.615115] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.279s)
[101.624522] Starting dynamic subtest: pipe-C-eDP-1
[102.840834] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.226s)
[102.850326] Starting dynamic subtest: pipe-D-eDP-1
[104.082419] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.241s)
[104.084723] Subtest plane-properties-legacy: SUCCESS (4.336s)
[104.887916] [022/133] (913s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[104.969850] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[104.974090] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[105.039448] [023/133] (912s left) gem_exec_reloc (basic-cpu-noreloc)
[105.093640] Subtest basic-cpu-noreloc: SKIP (0.000s)
[105.181119] [024/133] (912s left) i915_query (query-topology-coherent-slice-mask)
[105.233876] Starting subtest: query-topology-coherent-slice-mask
[105.238647] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[105.347881] [025/133] (912s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[105.396338] Starting subtest: multi-wait-available-submitted-signaled
[105.398655] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s)
[105.480372] [026/133] (912s left) gem_exec_fence (syncobj-unused-fence)
[105.933913] Starting subtest: syncobj-unused-fence
[105.939581] Subtest syncobj-unused-fence: SUCCESS (0.005s)
[107.335368] [FACT gem_exec_fence (syncobj-unused-fence)] new: kernel.kmod_is_loaded.vgem: true
[107.338767] [027/133] (910s left) gem_mmap_wc (write-read-distinct)
[107.395143] Subtest write-read-distinct: SKIP (0.000s)
[107.468930] [028/133] (910s left) kms_cursor_edge_walk (128x128-top-bottom)
[107.565913] Starting subtest: 128x128-top-bottom
[107.568270] Starting dynamic subtest: pipe-A-eDP-1
[111.035918] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.471s)
[111.046089] Starting dynamic subtest: pipe-D-eDP-1
[114.157809] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.120s)
[114.160170] Subtest 128x128-top-bottom: SUCCESS (6.593s)
[114.955681] [029/133] (903s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[115.065870] Starting subtest: fbc-psr2-primary-mmap-cpu
[115.068220] Starting dynamic subtest: eDP-1
[115.072596] Dynamic subtest eDP-1: SKIP (0.000s)
[115.076971] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[115.136059] [030/133] (903s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[115.246541] Starting subtest: x-tiled-32bpp-rotate-270
[115.267103] Subtest x-tiled-32bpp-rotate-270: SKIP (0.021s)
[115.394109] [031/133] (902s left) kms_psr (pr-cursor-mmap-cpu)
[115.484843] Starting subtest: pr-cursor-mmap-cpu
[115.489097] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[115.566288] [032/133] (902s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[115.662342] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[115.666265] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[115.766810] [033/133] (902s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[115.854592] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[115.859066] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[115.938164] [034/133] (902s left) kms_big_fb (yf-tiled-addfb)
[116.037704] Starting subtest: yf-tiled-addfb
[116.041496] Subtest yf-tiled-addfb: SKIP (0.000s)
[116.128900] [035/133] (902s left) prime_vgem (wait)
[116.203079] Starting subtest: wait
[116.205062] Starting dynamic subtest: rcs0
[116.245507] Dynamic subtest rcs0: SUCCESS (0.043s)
[116.254073] Starting dynamic subtest: bcs0
[116.300312] Dynamic subtest bcs0: SUCCESS (0.054s)
[116.308916] Starting dynamic subtest: vcs0
[116.344573] Dynamic subtest vcs0: SUCCESS (0.044s)
[116.352694] Starting dynamic subtest: vcs1
[116.393735] Dynamic subtest vcs1: SUCCESS (0.049s)
[116.401896] Starting dynamic subtest: vecs0
[116.440313] Dynamic subtest vecs0: SUCCESS (0.046s)
[116.448197] Starting dynamic subtest: ccs0
[116.488208] Dynamic subtest ccs0: SUCCESS (0.047s)
[116.490064] Subtest wait: SUCCESS (0.286s)
[116.600639] [036/133] (901s left) gem_mmap_offset (partial-remap)
[116.661067] Starting subtest: partial-remap
[116.663167] Starting dynamic subtest: smem0
[116.670607] Dynamic subtest smem0: SUCCESS (0.004s)
[116.672478] Subtest partial-remap: SUCCESS (0.004s)
[116.777923] [037/133] (901s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[116.876268] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[116.878171] Starting dynamic subtest: pipe-A-eDP-1
[122.728340] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.855s)
[122.738763] Starting dynamic subtest: pipe-B-eDP-1
[129.378097] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.647s)
[129.380452] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.505s)
[130.246479] [038/133] (888s left) kms_hdr (static-toggle-suspend)
[130.338249] Starting subtest: static-toggle-suspend
[130.344894] Subtest static-toggle-suspend: SKIP (0.000s)
[130.411339] [039/133] (888s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[130.466760] Starting subtest: yf-tiled-to-vebox-yf-tiled
[130.471194] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[130.651125] [040/133] (888s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[130.749395] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[130.751754] Starting dynamic subtest: pipe-A-eDP-1
[130.775361] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[130.786278] Starting dynamic subtest: pipe-B-eDP-1
[130.808331] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[130.816948] Starting dynamic subtest: pipe-C-eDP-1
[130.839703] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[130.847769] Starting dynamic subtest: pipe-D-eDP-1
[130.869937] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[130.874301] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[133.004162] [041/133] (885s left) kms_pm_rpm (pc8-residency)
[134.524572] Starting subtest: pc8-residency
[134.529515] Subtest pc8-residency: SKIP (0.000s)
[135.249741] [042/133] (883s left) gem_exec_schedule (preemptive-hang)
[135.422765] Starting subtest: preemptive-hang
[135.425838] Starting dynamic subtest: rcs0
[144.425755] Dynamic subtest rcs0: SUCCESS (9.001s)
[144.436499] Starting dynamic subtest: bcs0
[153.382054] Dynamic subtest bcs0: SUCCESS (8.957s)
[153.393178] Starting dynamic subtest: vcs0
[162.403744] Dynamic subtest vcs0: SUCCESS (9.020s)
[162.412026] Starting dynamic subtest: vcs1
[171.429934] Dynamic subtest vcs1: SUCCESS (9.024s)
[171.440096] Starting dynamic subtest: vecs0
[180.389310] Dynamic subtest vecs0: SUCCESS (8.958s)
[180.400931] Starting dynamic subtest: ccs0
[189.416217] Dynamic subtest ccs0: SUCCESS (9.026s)
[189.418831] Subtest preemptive-hang: SUCCESS (53.993s)
[189.655758] [043/133] (829s left) kms_pipe_crc_basic (bad-source)
[189.740978] Starting subtest: bad-source
[189.743490] Subtest bad-source: SUCCESS (0.000s)
[189.829090] [044/133] (829s left) gem_exec_schedule (preempt-user)
[189.892930] Starting subtest: preempt-user
[189.894948] Starting dynamic subtest: rcs0
[189.908618] Dynamic subtest rcs0: SUCCESS (0.023s)
[189.920528] Starting dynamic subtest: bcs0
[189.926185] Dynamic subtest bcs0: SUCCESS (0.017s)
[189.936082] Starting dynamic subtest: vcs0
[189.945278] Dynamic subtest vcs0: SUCCESS (0.018s)
[189.954077] Starting dynamic subtest: vcs1
[189.964298] Dynamic subtest vcs1: SUCCESS (0.018s)
[189.973115] Starting dynamic subtest: vecs0
[189.986966] Dynamic subtest vecs0: SUCCESS (0.022s)
[189.995979] Starting dynamic subtest: ccs0
[190.008244] Dynamic subtest ccs0: SUCCESS (0.021s)
[190.010563] Subtest preempt-user: SUCCESS (0.123s)
[191.381312] [045/133] (827s left) gem_huc_copy (huc-copy)
[191.440899] Starting subtest: huc-copy
[191.445384] Subtest huc-copy: SUCCESS (0.004s)
[191.550291] [046/133] (827s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[191.662374] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[192.699877] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.037s)
[192.829799] [047/133] (826s left) kms_content_protection (dp-mst-lic-type-1)
[192.958210] Starting subtest: dp-mst-lic-type-1
[192.961957] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[193.107031] [048/133] (825s left) core_getclient (basic)
[193.156232] Starting subtest: basic
[193.158236] Subtest basic: SUCCESS (0.000s)
[193.266348] [049/133] (825s left) gem_mmap (short-mmap)
[193.326224] Subtest short-mmap: SKIP (0.000s)
[193.398301] [050/133] (825s left) perf_pmu (busy-check-all)
[193.435150] Starting subtest: busy-check-all
[193.437064] Starting dynamic subtest: rcs0
[193.985664] Dynamic subtest rcs0: SUCCESS (0.550s)
[193.997956] Starting dynamic subtest: bcs0
[194.538197] Dynamic subtest bcs0: SUCCESS (0.551s)
[194.550290] Starting dynamic subtest: vcs0
[196.285415] Dynamic subtest vcs0: SUCCESS (1.744s)
[196.297334] Starting dynamic subtest: vcs1
[198.269592] Dynamic subtest vcs1: SUCCESS (1.982s)
[198.283811] Starting dynamic subtest: vecs0
[200.318079] Dynamic subtest vecs0: SUCCESS (2.046s)
[200.329983] Starting dynamic subtest: ccs0
[200.872040] Dynamic subtest ccs0: SUCCESS (0.554s)
[200.874860] Subtest busy-check-all: SUCCESS (7.437s)
[200.981179] [051/133] (818s left) gem_partial_pwrite_pread (write-display)
[201.048477] Subtest write-display: SKIP (0.000s)
[201.114551] [052/133] (818s left) gem_ctx_sseu (invalid-sseu)
[201.169985] Subtest invalid-sseu: SKIP (0.000s)
[201.237870] [053/133] (817s left) kms_plane_multiple (tiling-none)
[201.333436] Starting subtest: tiling-none
[201.335389] Starting dynamic subtest: pipe-A-eDP-1
[205.159803] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.825s)
[205.170040] Starting dynamic subtest: pipe-B-eDP-1
[209.611905] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.451s)
[209.621307] Starting dynamic subtest: pipe-C-eDP-1
[213.950070] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.336s)
[213.959260] Starting dynamic subtest: pipe-D-eDP-1
[218.275597] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.326s)
[218.277995] Subtest tiling-none: SUCCESS (16.942s)
[219.081354] [054/133] (800s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[219.142671] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[219.219360] [055/133] (800s left) i915_pm_rpm (system-suspend-devices)
[221.457309] Starting subtest: system-suspend-devices
[229.232998] Subtest system-suspend-devices: SUCCESS (7.780s)
[229.602058] [056/133] (789s left) kms_async_flips (test-time-stamp-atomic)
[229.719271] Starting subtest: test-time-stamp-atomic
[230.091321] Starting dynamic subtest: pipe-A-eDP-1
[230.887500] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.794s)
[231.277211] Starting dynamic subtest: pipe-B-eDP-1
[232.028330] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.756s)
[232.396225] Starting dynamic subtest: pipe-C-eDP-1
[233.159923] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.770s)
[233.524787] Starting dynamic subtest: pipe-D-eDP-1
[234.282649] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.764s)
[234.285105] Subtest test-time-stamp-atomic: SUCCESS (4.564s)
[235.436557] [057/133] (783s left) kms_cursor_crc (cursor-offscreen-256x256)
[235.673308] Starting subtest: cursor-offscreen-256x256
[235.675682] Starting dynamic subtest: pipe-A-eDP-1
[237.620663] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.944s)
[237.648891] Starting dynamic subtest: pipe-D-eDP-1
[240.248791] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.608s)
[240.251117] Subtest cursor-offscreen-256x256: SUCCESS (4.578s)
[241.104047] [058/133] (778s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[241.208709] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[241.212814] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[241.315342] [059/133] (778s left) gem_exec_await (wide-contexts)
[241.511800] Starting subtest: wide-contexts
[265.201475] Subtest wide-contexts: SUCCESS (23.687s)
[265.401902] [060/133] (754s left) kms_flip (nonexisting-fb-interruptible)
[265.545062] Starting subtest: nonexisting-fb-interruptible
[265.547413] Starting dynamic subtest: A-eDP1
[266.702640] Dynamic subtest A-eDP1: SUCCESS (1.156s)
[266.713980] Starting dynamic subtest: B-eDP1
[267.829387] Dynamic subtest B-eDP1: SUCCESS (1.126s)
[267.841434] Starting dynamic subtest: C-eDP1
[268.969514] Dynamic subtest C-eDP1: SUCCESS (1.139s)
[268.980477] Starting dynamic subtest: D-eDP1
[270.095817] Dynamic subtest D-eDP1: SUCCESS (1.125s)
[270.098319] Subtest nonexisting-fb-interruptible: SUCCESS (4.554s)
[271.269983] [061/133] (748s left) kms_psr (psr2-no-drrs)
[271.365742] Starting subtest: psr2-no-drrs
[271.368153] Starting dynamic subtest: eDP-1
[272.935463] Dynamic subtest eDP-1: SUCCESS (1.569s)
[272.937750] Subtest psr2-no-drrs: SUCCESS (1.571s)
[273.731217] [062/133] (745s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[273.839350] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[273.865877] Starting dynamic subtest: pipe-A-plane-0
[274.154421] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[274.165072] Starting dynamic subtest: pipe-A-plane-3
[274.387840] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[275.523432] Starting dynamic subtest: pipe-B-plane-0
[275.814617] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[275.826791] Starting dynamic subtest: pipe-B-plane-3
[276.047486] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[276.353716] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.516s)
[277.189699] [063/133] (742s left) gem_exec_balancer (bonded-true-hang)
[277.460130] Starting subtest: bonded-true-hang
[277.464701] Subtest bonded-true-hang: SKIP (0.000s)
[277.564670] [064/133] (742s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[277.944113] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[278.718362] [065/133] (740s left) gem_exec_reloc (basic-write-cpu-noreloc)
[278.774036] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[278.850184] [066/133] (740s left) kms_hdmi_inject (inject-4k)
[279.193699] Starting subtest: inject-4k
[279.517591] Subtest inject-4k: SUCCESS (0.325s)
[280.100514] [067/133] (739s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[280.166312] Starting subtest: etime-single-wait-all-for-submit-submitted
[280.274360] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.106s)
[280.356397] [068/133] (739s left) kms_flip (flip-vs-modeset-vs-hang)
[280.442276] Starting subtest: flip-vs-modeset-vs-hang
[280.444629] Starting dynamic subtest: A-eDP1
[331.734883] Dynamic subtest A-eDP1: SUCCESS (51.290s)
[331.753299] Starting dynamic subtest: D-eDP1
[381.785743] Dynamic subtest D-eDP1: SUCCESS (50.049s)
[381.788812] Subtest flip-vs-modeset-vs-hang: SUCCESS (101.347s)
[382.194535] [069/133] (637s left) kms_lease (master-vs-lease)
[382.303101] Starting subtest: master-vs-lease
[382.305609] Subtest master-vs-lease: SUCCESS (0.001s)
[382.403980] [070/133] (637s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[382.490154] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[382.492318] Starting dynamic subtest: pipe-A-eDP-1
[382.989095] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.470s)
[383.001794] Starting dynamic subtest: pipe-B-eDP-1
[384.509226] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.518s)
[384.520335] Starting dynamic subtest: pipe-C-eDP-1
[385.918058] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.405s)
[385.930942] Starting dynamic subtest: pipe-D-eDP-1
[387.289117] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.373s)
[387.291115] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.771s)
[388.428092] [071/133] (631s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[388.485614] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[388.490273] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[388.672396] [072/133] (631s left) gem_ctx_engines (invalid-engines)
[388.735078] Starting subtest: invalid-engines
[388.742759] Subtest invalid-engines: SUCCESS (0.008s)
[388.964268] [073/133] (631s left) gem_exec_params (dr4-dirt)
[389.018083] Starting subtest: DR4-dirt
[389.020400] Subtest DR4-dirt: SUCCESS (0.000s)
[389.124948] [074/133] (630s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[389.233258] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[389.237183] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[389.326675] [075/133] (630s left) sw_sync (sync_multi_producer_single_consumer)
[389.361681] Starting subtest: sync_multi_producer_single_consumer
[390.435101] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[390.498572] [076/133] (629s left) syncobj_timeline (wait-all-for-submit-complex)
[390.559592] Starting subtest: wait-all-for-submit-complex
[390.772050] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[390.864293] [077/133] (629s left) gem_eio (execbuf)
[391.073206] Starting subtest: execbuf
[391.355401] Subtest execbuf: SUCCESS (0.282s)
[391.465983] [078/133] (628s left) gem_partial_pwrite_pread (writes-after-reads)
[391.522660] Subtest writes-after-reads: SKIP (0.000s)
[391.593377] [079/133] (628s left) kms_feature_discovery (dp-mst)
[391.683895] Starting subtest: dp-mst
[391.688284] Subtest dp-mst: SKIP (0.000s)
[391.755540] [080/133] (628s left) perf (low-oa-exponent-permissions)
[391.879649] Starting subtest: low-oa-exponent-permissions
[391.918577] Subtest low-oa-exponent-permissions: SUCCESS (0.040s)
[391.968854] [081/133] (628s left) gem_exec_fence (syncobj-import)
[392.386109] Starting subtest: syncobj-import
[392.391575] Subtest syncobj-import: SUCCESS (0.005s)
[394.381474] [082/133] (626s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[394.489479] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[394.491664] Starting dynamic subtest: pipe-A-eDP-1
[394.586096] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[394.598780] Starting dynamic subtest: pipe-B-eDP-1
[395.704766] Dynamic subtest pipe-B-eDP-1: SKIP (1.116s)
[395.709578] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.219s)
[396.903828] [083/133] (623s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[397.023046] Starting subtest: cursorB-vs-flipB-atomic
[397.027722] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[397.169300] [084/133] (623s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[397.256760] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[397.267726] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.010s)
[397.381314] [085/133] (623s left) kms_vblank (ts-continuation-idle)
[397.476418] Starting subtest: ts-continuation-idle
[397.478632] Starting dynamic subtest: pipe-A-eDP-1
[397.881538] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.405s)
[397.897093] Starting dynamic subtest: pipe-D-eDP-1
[398.983714] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.098s)
[398.985649] Subtest ts-continuation-idle: SUCCESS (1.507s)
[399.848252] [086/133] (620s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[399.939115] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[399.943579] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[401.079239] [087/133] (619s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[401.170747] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[401.175265] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[401.262635] [088/133] (619s left) syncobj_eventfd (invalid-bad-flags)
[401.317678] Starting subtest: invalid-bad-flags
[401.320068] Subtest invalid-bad-flags: SUCCESS (0.000s)
[401.434330] [089/133] (619s left) kms_pwrite_crc (basic)
[401.526309] Starting subtest: basic
[402.233538] Subtest basic: SUCCESS (0.707s)
[403.031798] [090/133] (617s left) gem_sync (basic-store-each)
[403.106329] Starting subtest: basic-store-each
[405.513431] Subtest basic-store-each: SUCCESS (2.418s)
[405.705661] [091/133] (615s left) kms_universal_plane (universal-plane-sanity)
[405.801516] Starting subtest: universal-plane-sanity
[405.803785] Starting dynamic subtest: pipe-A-eDP-1
[406.406146] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.604s)
[406.418756] Starting dynamic subtest: pipe-B-eDP-1
[407.661336] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.255s)
[407.672550] Starting dynamic subtest: pipe-C-eDP-1
[408.862649] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.199s)
[408.875846] Starting dynamic subtest: pipe-D-eDP-1
[410.084721] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.222s)
[410.086884] Subtest universal-plane-sanity: SUCCESS (4.286s)
[410.946158] [092/133] (609s left) gem_spin_batch (legacy)
[411.008313] Starting subtest: legacy
[411.010718] Starting dynamic subtest: default
[414.246426] Dynamic subtest default: SUCCESS (3.233s)
[414.260044] Starting dynamic subtest: render
[417.480873] Dynamic subtest render: SUCCESS (3.230s)
[417.491687] Starting dynamic subtest: bsd
[420.720796] Dynamic subtest bsd: SUCCESS (3.237s)
[420.733664] Starting dynamic subtest: bsd1
[423.955959] Dynamic subtest bsd1: SUCCESS (3.232s)
[423.968389] Starting dynamic subtest: bsd2
[427.190932] Dynamic subtest bsd2: SUCCESS (3.231s)
[427.203259] Starting dynamic subtest: blt
[430.427677] Dynamic subtest blt: SUCCESS (3.234s)
[430.440316] Starting dynamic subtest: vebox
[433.669055] Dynamic subtest vebox: SUCCESS (3.237s)
[433.671789] Subtest legacy: SUCCESS (22.657s)
[434.322122] [093/133] (586s left) kms_rotation_crc (primary-rotation-90)
[434.425944] Starting subtest: primary-rotation-90
[434.430258] Subtest primary-rotation-90: SKIP (0.001s)
[434.498470] [094/133] (586s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[434.595987] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[443.147637] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.555s)
[443.260111] [095/133] (577s left) api_intel_allocator (default-alignment)
[443.310579] Starting subtest: default-alignment
[443.312975] Subtest default-alignment: SUCCESS (0.004s)
[443.440814] [096/133] (577s left) kms_chamelium_frames (hdmi-frame-dump)
[443.816172] Subtest hdmi-frame-dump: SKIP (0.000s)
[444.610887] [097/133] (576s left) kms_chamelium_audio (hdmi-audio)
[444.999892] Subtest hdmi-audio: SKIP (0.000s)
[445.841351] [098/133] (575s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[445.956362] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[446.814034] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.859s)
[446.973653] [099/133] (574s left) gen7_exec_parse (bitmasks)
[447.038600] Subtest bitmasks: SKIP (0.000s)
[447.097348] [100/133] (574s left) gem_mmap_wc (set-cache-level)
[447.159266] Subtest set-cache-level: SKIP (0.000s)
[447.218204] [101/133] (573s left) gem_madvise (dontneed-before-exec)
[447.253635] Starting subtest: dontneed-before-exec
[447.271355] Subtest dontneed-before-exec: SKIP (0.016s)
[447.357229] [102/133] (573s left) i915_module_load (resize-bar)
[447.391700] Starting subtest: resize-bar
[447.398668] Subtest resize-bar: SKIP (0.005s)
[447.444405] [103/133] (573s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[447.536102] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[447.538443] Starting dynamic subtest: pipe-A-eDP-1
[447.547609] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[447.559178] Starting dynamic subtest: pipe-B-eDP-1
[447.568270] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[447.578521] Starting dynamic subtest: pipe-C-eDP-1
[447.587121] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[447.596796] Starting dynamic subtest: pipe-D-eDP-1
[447.605468] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[447.609635] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s)
[449.808308] [104/133] (571s left) gem_eio (wait-immediate)
[450.020501] Starting subtest: wait-immediate
[450.348470] Subtest wait-immediate: SUCCESS (0.330s)
[450.497502] [105/133] (570s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[450.614035] Starting subtest: 2x-long-flip-vs-cursor-legacy
[450.618697] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[450.771312] [106/133] (570s left) gem_exec_reloc (basic-gtt-wc-active)
[450.837582] Subtest basic-gtt-wc-active: SKIP (0.000s)
[450.910217] [107/133] (570s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[451.007432] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[451.011108] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[451.091744] [108/133] (570s left) kms_frontbuffer_tracking (fbc-tiling-4)
[451.182296] Starting subtest: fbc-tiling-4
[455.403236] Subtest fbc-tiling-4: SUCCESS (4.223s)
[456.512059] [109/133] (565s left) kms_big_fb (linear-32bpp-rotate-270)
[456.611200] Starting subtest: linear-32bpp-rotate-270
[456.632095] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[456.748479] [110/133] (564s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[456.836635] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[456.839055] Starting dynamic subtest: pipe-A
[456.947070] Dynamic subtest pipe-A: SKIP (0.107s)
[456.957935] Starting dynamic subtest: pipe-B
[458.187434] Dynamic subtest pipe-B: SKIP (1.239s)
[458.198703] Starting dynamic subtest: pipe-C
[459.324185] Dynamic subtest pipe-C: SUCCESS (1.142s)
[459.334723] Starting dynamic subtest: pipe-D
[460.479621] Dynamic subtest pipe-D: SUCCESS (1.154s)
[460.482447] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.646s)
[461.683148] [111/133] (559s left) fbdev (pan)
[461.726206] Starting subtest: pan
[461.748823] Subtest pan: SUCCESS (0.024s)
[461.818462] [112/133] (559s left) gem_exec_capture (pi)
[461.878444] Starting subtest: pi
[461.880832] Starting dynamic subtest: rcs0
[465.881252] Dynamic subtest rcs0: SUCCESS (4.005s)
[465.892665] Starting dynamic subtest: bcs0
[469.831251] Dynamic subtest bcs0: SUCCESS (3.948s)
[469.842890] Starting dynamic subtest: vcs0
[473.715899] Dynamic subtest vcs0: SUCCESS (3.884s)
[473.727029] Starting dynamic subtest: vcs1
[477.550563] Dynamic subtest vcs1: SUCCESS (3.831s)
[477.563741] Starting dynamic subtest: vecs0
[481.510180] Dynamic subtest vecs0: SUCCESS (3.960s)
[481.524989] Starting dynamic subtest: ccs0
[485.454697] Dynamic subtest ccs0: SUCCESS (3.942s)
[485.456959] Subtest pi: SUCCESS (23.580s)
[485.549598] [113/133] (536s left) i915_query (query-regions-garbage-items)
[485.654780] Starting subtest: query-regions-garbage-items
[485.657190] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[485.764947] [114/133] (536s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[485.869996] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[485.874303] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[485.943860] [115/133] (535s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[486.034989] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[486.039194] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[486.128399] [116/133] (535s left) gem_userptr_blits (sd-probe)
[486.201616] Starting subtest: sd-probe
[486.203850] Subtest sd-probe: SUCCESS (0.000s)
[486.320443] [117/133] (535s left) i915_drm_fdinfo (busy-check-all)
[486.362437] Starting subtest: busy-check-all
[486.364804] Starting dynamic subtest: rcs0
[486.369498] Dynamic subtest rcs0: SKIP (0.004s)
[486.381341] Starting dynamic subtest: bcs0
[486.385893] Dynamic subtest bcs0: SKIP (0.000s)
[486.398785] Starting dynamic subtest: vcs0
[486.402357] Dynamic subtest vcs0: SKIP (0.000s)
[486.411721] Starting dynamic subtest: vcs1
[486.415224] Dynamic subtest vcs1: SKIP (0.000s)
[486.424588] Starting dynamic subtest: vecs0
[486.428023] Dynamic subtest vecs0: SKIP (0.000s)
[486.437248] Starting dynamic subtest: ccs0
[486.440881] Dynamic subtest ccs0: SKIP (0.000s)
[486.444379] Subtest busy-check-all: SKIP (0.010s)
[486.481479] [118/133] (535s left) syncobj_timeline (wait-zero-handles)
[486.564763] Starting subtest: wait-zero-handles
[486.567137] Subtest wait-zero-handles: SUCCESS (0.000s)
[486.666649] [119/133] (535s left) syncobj_basic (bad-create-flags)
[486.715512] Starting subtest: bad-create-flags
[486.717246] Subtest bad-create-flags: SUCCESS (0.000s)
[486.840165] [120/133] (535s left) perf_pmu (busy-start)
[486.877439] Starting subtest: busy-start
[486.879341] Starting dynamic subtest: rcs0
[489.429367] Dynamic subtest rcs0: SUCCESS (2.551s)
[489.441616] Starting dynamic subtest: bcs0
[491.979043] Dynamic subtest bcs0: SUCCESS (2.547s)
[491.992900] Starting dynamic subtest: vcs0
[495.294983] Dynamic subtest vcs0: SUCCESS (3.311s)
[495.310510] Starting dynamic subtest: vcs1
[499.261964] Dynamic subtest vcs1: SUCCESS (3.965s)
[499.274158] Starting dynamic subtest: vecs0
[503.292527] Dynamic subtest vecs0: SUCCESS (4.029s)
[503.305628] Starting dynamic subtest: ccs0
[505.843661] Dynamic subtest ccs0: SUCCESS (2.549s)
[505.846168] Subtest busy-start: SUCCESS (18.966s)
[505.941898] [121/133] (516s left) gem_ctx_persistence (processes)
[505.995332] Starting subtest: processes
[507.275727] Subtest processes: SUCCESS (1.280s)
[507.364074] [122/133] (514s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[507.464611] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[507.468765] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[507.573832] [123/133] (514s left) gen3_mixed_blits
[507.699627] [124/133] (514s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[507.791128] Starting subtest: async-flip-with-page-flip-events-tiled
[508.167686] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[510.943995] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.776s)
[510.958100] Starting dynamic subtest: pipe-A-eDP-1-4
[513.128596] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.184s)
[513.141200] Starting dynamic subtest: pipe-A-eDP-1-4
[515.138778] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[515.150092] Starting dynamic subtest: pipe-A-eDP-1-x
[517.317875] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s)
[517.716889] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[520.474282] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.766s)
[520.485815] Starting dynamic subtest: pipe-B-eDP-1-4
[522.660623] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[522.671284] Starting dynamic subtest: pipe-B-eDP-1-4
[524.670397] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[524.681474] Starting dynamic subtest: pipe-B-eDP-1-x
[526.859989] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[527.231368] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[529.999475] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.775s)
[530.010938] Starting dynamic subtest: pipe-C-eDP-1-4
[532.173733] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[532.184723] Starting dynamic subtest: pipe-C-eDP-1-4
[534.184368] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[534.197923] Starting dynamic subtest: pipe-C-eDP-1-x
[536.363307] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[536.735638] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[539.539489] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.816s)
[539.551108] Starting dynamic subtest: pipe-D-eDP-1-4
[541.711786] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.172s)
[541.722478] Starting dynamic subtest: pipe-D-eDP-1-4
[543.722844] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[543.734207] Starting dynamic subtest: pipe-D-eDP-1-x
[545.901996] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s)
[545.905041] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.111s)
[547.121580] [125/133] (475s left) gem_exec_whisper (basic-contexts)
[547.180565] Starting subtest: basic-contexts
[554.453728] Subtest basic-contexts: SUCCESS (7.270s)
[554.640623] [126/133] (467s left) kms_cursor_crc (cursor-random-512x170)
[554.938090] Starting subtest: cursor-random-512x170
[554.942597] Subtest cursor-random-512x170: SKIP (0.001s)
[555.085669] [127/133] (467s left) kms_color_pipeline (plane-ctm3x4)
[555.184221] Starting subtest: plane-ctm3x4
[555.329838] Starting dynamic subtest: pipe-A-plane-0
[555.496424] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[555.507509] Starting dynamic subtest: pipe-A-plane-1
[555.629156] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[555.639833] Starting dynamic subtest: pipe-A-plane-2
[555.784794] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s)
[557.053171] Starting dynamic subtest: pipe-B-plane-0
[557.209124] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[557.225190] Starting dynamic subtest: pipe-B-plane-1
[557.342556] Dynamic subtest pipe-B-plane-1: SUCCESS (0.132s)
[557.354179] Starting dynamic subtest: pipe-B-plane-2
[557.497851] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s)
[558.740356] Starting dynamic subtest: pipe-C-plane-0
[558.853436] Dynamic subtest pipe-C-plane-0: SUCCESS (0.122s)
[558.864651] Starting dynamic subtest: pipe-C-plane-1
[558.964726] Dynamic subtest pipe-C-plane-1: SUCCESS (0.110s)
[558.975847] Starting dynamic subtest: pipe-C-plane-2
[559.075928] Dynamic subtest pipe-C-plane-2: SUCCESS (0.110s)
[560.265187] Starting dynamic subtest: pipe-D-plane-0
[560.388129] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[560.398602] Starting dynamic subtest: pipe-D-plane-1
[560.521175] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s)
[560.531704] Starting dynamic subtest: pipe-D-plane-2
[560.632568] Dynamic subtest pipe-D-plane-2: SUCCESS (0.110s)
[560.936515] Subtest plane-ctm3x4: SUCCESS (5.752s)
[561.736607] [128/133] (460s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[561.825919] Starting subtest: fbcpsr-1p-rte
[568.852410] Subtest fbcpsr-1p-rte: SUCCESS (7.031s)
[569.001249] [129/133] (453s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[569.116323] Starting subtest: basic-flip-before-cursor-legacy
[570.079043] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.959s)
[570.915338] [130/133] (451s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[571.009173] Starting subtest: plane-upscale-factor-0-25-with-rotation
[571.011465] Starting dynamic subtest: pipe-A
[571.234186] Dynamic subtest pipe-A: SUCCESS (0.227s)
[571.245065] Starting dynamic subtest: pipe-B
[572.490531] Dynamic subtest pipe-B: SUCCESS (1.255s)
[572.503494] Starting dynamic subtest: pipe-C
[573.833504] Dynamic subtest pipe-C: SUCCESS (1.342s)
[573.844689] Starting dynamic subtest: pipe-D
[575.173457] Dynamic subtest pipe-D: SUCCESS (1.339s)
[575.175892] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.167s)
[576.354014] [131/133] (446s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[576.482292] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[608.267824] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.787s)
[609.092199] [132/133] (413s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[609.186307] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[609.190239] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[609.286973] [133/133] (413s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[611.418447] Starting subtest: dpms-mode-unset-lpsp
[615.516093] Subtest dpms-mode-unset-lpsp: SUCCESS (4.097s)
[615.897204] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_mmap_gtt
results: parsing output: 2/ for test: kms_flip
results: parsing output: 3/ for test: syncobj_wait
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_pipe_crc_basic
results: parsing output: 6/ for test: kms_dp_link_training
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: gem_ctx_isolation
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_rotation_crc
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: core_setmaster
results: parsing output: 13/ for test: gem_eio
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: gem_ppgtt
results: parsing output: 17/ for test: kms_getfb
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_properties
results: parsing output: 21/ for test: kms_flip_scaled_crc
results: parsing output: 22/ for test: gem_exec_reloc
results: parsing output: 23/ for test: i915_query
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: gem_exec_fence
results: parsing output: 26/ for test: gem_mmap_wc
results: parsing output: 27/ for test: kms_cursor_edge_walk
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: prime_vgem
results: parsing output: 35/ for test: gem_mmap_offset
results: parsing output: 36/ for test: kms_psr2_sf
results: parsing output: 37/ for test: kms_hdr
results: parsing output: 38/ for test: gem_render_copy
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: kms_pm_rpm
results: parsing output: 41/ for test: gem_exec_schedule
results: parsing output: 42/ for test: kms_pipe_crc_basic
results: parsing output: 43/ for test: gem_exec_schedule
results: parsing output: 44/ for test: gem_huc_copy
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: kms_content_protection
results: parsing output: 47/ for test: core_getclient
results: parsing output: 48/ for test: gem_mmap
results: parsing output: 49/ for test: perf_pmu
results: parsing output: 50/ for test: gem_partial_pwrite_pread
results: parsing output: 51/ for test: gem_ctx_sseu
results: parsing output: 52/ for test: kms_plane_multiple
results: parsing output: 53/ for test: gem_fenced_exec_thrash
results: parsing output: 54/ for test: i915_pm_rpm
results: parsing output: 55/ for test: kms_async_flips
results: parsing output: 56/ for test: kms_cursor_crc
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_exec_await
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: kms_plane
results: parsing output: 62/ for test: gem_exec_balancer
results: parsing output: 63/ for test: kms_chamelium_hpd
results: parsing output: 64/ for test: gem_exec_reloc
results: parsing output: 65/ for test: kms_hdmi_inject
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: kms_flip
results: parsing output: 68/ for test: kms_lease
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: gem_render_copy
results: parsing output: 71/ for test: gem_ctx_engines
results: parsing output: 72/ for test: gem_exec_params
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: sw_sync
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: gem_eio
results: parsing output: 77/ for test: gem_partial_pwrite_pread
results: parsing output: 78/ for test: kms_feature_discovery
results: parsing output: 79/ for test: perf
results: parsing output: 80/ for test: gem_exec_fence
results: parsing output: 81/ for test: kms_psr2_sf
results: parsing output: 82/ for test: kms_cursor_legacy
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: kms_vblank
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: syncobj_eventfd
results: parsing output: 88/ for test: kms_pwrite_crc
results: parsing output: 89/ for test: gem_sync
results: parsing output: 90/ for test: kms_universal_plane
results: parsing output: 91/ for test: gem_spin_batch
results: parsing output: 92/ for test: kms_rotation_crc
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: api_intel_allocator
results: parsing output: 95/ for test: kms_chamelium_frames
results: parsing output: 96/ for test: kms_chamelium_audio
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: gen7_exec_parse
results: parsing output: 99/ for test: gem_mmap_wc
results: parsing output: 100/ for test: gem_madvise
results: parsing output: 101/ for test: i915_module_load
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: gem_eio
results: parsing output: 104/ for test: kms_cursor_legacy
results: parsing output: 105/ for test: gem_exec_reloc
results: parsing output: 106/ for test: kms_psr2_sf
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_plane_scaling
results: parsing output: 110/ for test: fbdev
results: parsing output: 111/ for test: gem_exec_capture
results: parsing output: 112/ for test: i915_query
results: parsing output: 113/ for test: kms_flip_scaled_crc
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_userptr_blits
results: parsing output: 116/ for test: i915_drm_fdinfo
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: syncobj_basic
results: parsing output: 119/ for test: perf_pmu
results: parsing output: 120/ for test: gem_ctx_persistence
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gen3_mixed_blits
results: parsing output: 123/ for test: kms_async_flips
results: parsing output: 124/ for test: gem_exec_whisper
results: parsing output: 125/ for test: kms_cursor_crc
results: parsing output: 126/ for test: kms_color_pipeline
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_cursor_legacy
results: parsing output: 129/ for test: kms_plane_scaling
results: parsing output: 130/ for test: kms_cursor_legacy
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_pm_rpm
Done.