[61.058115] Initializing watchdogs
[61.058256]   /dev/watchdog0
[61.073323] [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]
[61.077813] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.079865] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.081916] [001/133] (960s left) gem_tiled_blits (interruptible)
[61.140217] Subtest interruptible: SKIP (0.000s)
[61.201954] [002/133] (960s left) perf_pmu (interrupts-sync)
[61.240976] Starting subtest: interrupts-sync
[62.361670] Subtest interrupts-sync: SUCCESS (1.125s)
[62.486438] [FACT perf_pmu (interrupts-sync)] new: kernel.kmod_is_loaded.vgem: true
[62.488141] [003/133] (959s left) kms_content_protection (atomic-hdcp14)
[62.645352] Starting subtest: atomic-hdcp14
[62.648333] Subtest atomic-hdcp14: SKIP (0.000s)
[62.796738] [004/133] (958s left) gem_ctx_persistence (legacy-engines-hostile)
[62.864669] Starting subtest: legacy-engines-hostile
[62.865726] Starting dynamic subtest: render
[63.016956] Dynamic subtest render: SUCCESS (0.152s)
[63.026074] Starting dynamic subtest: bsd1
[63.136876] Dynamic subtest bsd1: SUCCESS (0.119s)
[63.145651] Starting dynamic subtest: bsd2
[63.251733] Dynamic subtest bsd2: SUCCESS (0.114s)
[63.260044] Starting dynamic subtest: blt
[63.366025] Dynamic subtest blt: SUCCESS (0.113s)
[63.374972] Starting dynamic subtest: vebox
[63.473838] Dynamic subtest vebox: SUCCESS (0.107s)
[63.475633] Subtest legacy-engines-hostile: SUCCESS (0.612s)
[63.559414] [005/133] (958s left) kms_pipe_crc_basic (read-crc)
[63.655472] Starting subtest: read-crc
[63.656604] Starting dynamic subtest: pipe-A-eDP-1
[64.365400] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.713s)
[64.370949] Starting dynamic subtest: pipe-B-eDP-1
[65.716149] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.354s)
[65.722850] Starting dynamic subtest: pipe-C-eDP-1
[67.006732] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.293s)
[67.015265] Starting dynamic subtest: pipe-D-eDP-1
[68.359492] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.353s)
[68.360411] Subtest read-crc: SUCCESS (4.719s)
[69.180781] [006/133] (952s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[69.280877] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[69.281888] Starting dynamic subtest: pipe-A
[69.299606] Dynamic subtest pipe-A: SKIP (0.016s)
[69.305600] Starting dynamic subtest: pipe-B
[69.327701] Dynamic subtest pipe-B: SKIP (0.028s)
[69.333492] Starting dynamic subtest: pipe-C
[69.356188] Dynamic subtest pipe-C: SKIP (0.028s)
[69.363759] Starting dynamic subtest: pipe-D
[69.383826] Dynamic subtest pipe-D: SKIP (0.028s)
[69.385464] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.102s)
[69.512028] [007/133] (952s left) syncobj_eventfd (invalid-illegal-handle)
[69.569141] Starting subtest: invalid-illegal-handle
[69.570086] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[69.668414] [008/133] (952s left) kms_atomic (plane-primary-legacy)
[69.763406] Starting subtest: plane-primary-legacy
[69.764379] Starting dynamic subtest: pipe-A-eDP-1
[70.228515] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.465s)
[70.229474] Subtest plane-primary-legacy: SUCCESS (0.466s)
[71.099308] [009/133] (950s left) gem_eio (wait-10ms)
[71.289078] Starting subtest: wait-10ms
[71.546364] Subtest wait-10ms: SUCCESS (0.259s)
[71.709730] [010/133] (950s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[71.812720] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[71.814474] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[71.888177] [011/133] (950s left) perf (unprivileged-single-ctx-counters)
[72.009779] Starting subtest: unprivileged-single-ctx-counters
[72.011751] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[72.042846] [012/133] (949s left) gem_mmap_gtt (basic-read-write-distinct)
[72.109118] Subtest basic-read-write-distinct: SKIP (0.000s)
[72.176047] [013/133] (949s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[72.275194] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[72.276923] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[72.398980] [014/133] (949s left) kms_prime (basic-crc-vgem)
[72.476986] Starting subtest: basic-crc-vgem
[72.477971] Starting dynamic subtest: second-to-first
[73.433106] Dynamic subtest second-to-first: SUCCESS (0.959s)
[73.434056] Subtest basic-crc-vgem: SUCCESS (0.959s)
[73.532893] [015/133] (948s left) gen7_exec_parse (bitmasks)
[73.637173] Subtest bitmasks: SKIP (0.000s)
[73.715923] [016/133] (948s left) gem_create (create-ext-set-pat)
[73.881790] Starting subtest: create-ext-set-pat
[73.882977] Subtest create-ext-set-pat: SUCCESS (0.001s)
[73.993423] [017/133] (948s left) kms_lease (possible-crtcs-filtering)
[74.092462] Starting subtest: possible-crtcs-filtering
[74.097083] Subtest possible-crtcs-filtering: SUCCESS (0.006s)
[74.213197] [018/133] (947s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[74.313850] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[80.937472] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.622s)
[81.088694] [019/133] (941s left) vgem_basic (dmabuf-mmap)
[81.123105] Starting subtest: dmabuf-mmap
[81.128345] Subtest dmabuf-mmap: SUCCESS (0.007s)
[81.182568] [020/133] (940s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[81.265850] Starting subtest: 2x-flip-vs-rmfb-interruptible
[81.277180] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.010s)
[81.401361] [021/133] (940s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[81.505914] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[88.522436] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (7.017s)
[88.646932] [022/133] (933s left) kms_vblank (ts-continuation-modeset-hang)
[88.729577] Starting subtest: ts-continuation-modeset-hang
[88.730579] Starting dynamic subtest: pipe-A-eDP-1
[115.779778] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.049s)
[115.788301] Starting dynamic subtest: pipe-D-eDP-1
[130.730340] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.948s)
[130.731378] Subtest ts-continuation-modeset-hang: SUCCESS (42.001s)
[131.559546] [023/133] (890s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[131.665134] Starting subtest: yf-tiled-8bpp-rotate-0
[131.667022] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[131.805276] [024/133] (890s left) kms_chamelium_edid (dp-edid-read)
[132.188597] Subtest dp-edid-read: SKIP (0.000s)
[132.951087] [025/133] (889s left) gem_eio (context-create)
[133.126253] Starting subtest: context-create
[133.362628] Subtest context-create: SUCCESS (0.236s)
[133.503826] [026/133] (888s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[133.610240] Starting subtest: flip-vs-cursor-atomic
[140.711938] Subtest flip-vs-cursor-atomic: SUCCESS (7.101s)
[141.571898] [027/133] (880s left) i915_query (query-topology-coherent-slice-mask)
[141.638508] Starting subtest: query-topology-coherent-slice-mask
[141.640487] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[141.742291] [028/133] (880s left) gem_softpin (allocator-evict)
[141.802216] Starting subtest: allocator-evict
[141.803341] Starting dynamic subtest: rcs0
[165.342098] Dynamic subtest rcs0: SUCCESS (23.537s)
[165.349398] Starting dynamic subtest: bcs0
[189.192788] Dynamic subtest bcs0: SUCCESS (23.848s)
[189.201788] Starting dynamic subtest: vcs0
[212.776138] Dynamic subtest vcs0: SUCCESS (23.581s)
[212.786317] Starting dynamic subtest: vcs1
[236.455065] Dynamic subtest vcs1: SUCCESS (23.678s)
[236.463710] Starting dynamic subtest: vecs0
[260.155069] Dynamic subtest vecs0: SUCCESS (23.697s)
[260.165118] Starting dynamic subtest: ccs0
[283.840727] Dynamic subtest ccs0: SUCCESS (23.684s)
[283.841775] Subtest allocator-evict: SUCCESS (142.031s)
[283.928471] [029/133] (738s left) gem_lmem_swapping (verify)
[283.999046] Subtest verify: SKIP (0.000s)
[284.039201] [030/133] (738s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[284.099230] Starting subtest: yf-tiled-to-vebox-x-tiled
[284.101119] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[284.285409] [031/133] (738s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[284.394449] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[284.422138] Starting dynamic subtest: pipe-A-plane-0
[284.424039] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[284.432976] Starting dynamic subtest: pipe-A-plane-3
[284.434861] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[284.441691] Starting dynamic subtest: pipe-A-plane-5
[284.444279] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[285.475517] Starting dynamic subtest: pipe-B-plane-0
[285.477320] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[285.484317] Starting dynamic subtest: pipe-B-plane-3
[285.486206] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[285.493068] Starting dynamic subtest: pipe-B-plane-5
[285.494934] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[285.787119] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (1.392s)
[286.669182] [032/133] (735s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[286.766247] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[286.768024] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[286.892522] [033/133] (735s left) i915_query (test-query-geometry-subslices)
[286.955325] Starting subtest: test-query-geometry-subslices
[286.956446] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[287.112213] [034/133] (735s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[287.209474] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[287.211411] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[287.330106] [035/133] (735s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[287.424278] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[287.426051] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[287.542454] [036/133] (735s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[287.639133] Starting subtest: psr2-overlay-plane-update-continuous-sf
[287.640034] Starting dynamic subtest: pipe-A-eDP-1
[288.757399] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.118s)
[288.764881] Starting dynamic subtest: pipe-B-eDP-1
[290.500050] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.742s)
[290.501066] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (2.863s)
[291.323299] [037/133] (731s left) kms_getfb (getfb-handle-protection)
[291.413536] Starting subtest: getfb-handle-protection
[291.434937] Subtest getfb-handle-protection: SUCCESS (0.022s)
[291.583797] [038/133] (731s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[291.694262] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[291.706085] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.011s)
[291.791133] [039/133] (731s left) api_intel_bb (blit-reloc-keep-cache)
[291.859823] Starting subtest: blit-reloc-keep-cache
[291.861857] Subtest blit-reloc-keep-cache: SKIP (0.001s)
[292.004722] [040/133] (730s left) kms_color (ctm-signed)
[292.107044] Starting subtest: ctm-signed
[292.107880] Starting dynamic subtest: pipe-A-eDP-1
[294.896142] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.788s)
[294.912836] Starting dynamic subtest: pipe-B-eDP-1
[297.222837] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.326s)
[297.233035] Starting dynamic subtest: pipe-C-eDP-1
[299.842376] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.620s)
[299.850263] Starting dynamic subtest: pipe-D-eDP-1
[302.515921] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.672s)
[302.516797] Subtest ctm-signed: SUCCESS (10.409s)
[303.355067] [041/133] (719s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[303.458488] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[303.460217] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[303.585272] [042/133] (719s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[303.688572] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[303.690271] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[303.804058] [043/133] (719s left) gem_mmap_gtt (basic-write)
[303.864046] Subtest basic-write: SKIP (0.000s)
[303.934326] [044/133] (719s left) syncobj_basic (bad-handle-to-fd)
[303.998644] Starting subtest: bad-handle-to-fd
[303.999692] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[304.113029] [045/133] (718s left) kms_properties (get_properties-sanity-non-atomic)
[304.203642] Starting subtest: get_properties-sanity-non-atomic
[304.204587] Subtest get_properties-sanity-non-atomic: SUCCESS (0.002s)
[304.284644] [046/133] (718s left) gem_exec_schedule (pi-userfault)
[304.471936] Starting subtest: pi-userfault
[304.472982] Starting dynamic subtest: rcs0
[304.483181] Dynamic subtest rcs0: SUCCESS (0.013s)
[304.491526] Starting dynamic subtest: bcs0
[304.492481] Dynamic subtest bcs0: SUCCESS (0.008s)
[304.504182] Starting dynamic subtest: vcs0
[304.505092] Dynamic subtest vcs0: SUCCESS (0.008s)
[304.516532] Starting dynamic subtest: vcs1
[304.517617] Dynamic subtest vcs1: SUCCESS (0.008s)
[304.529304] Starting dynamic subtest: vecs0
[304.530489] Dynamic subtest vecs0: SUCCESS (0.008s)
[304.540046] Starting dynamic subtest: ccs0
[304.541063] Dynamic subtest ccs0: SUCCESS (0.007s)
[304.542048] Subtest pi-userfault: SUCCESS (0.055s)
[304.730438] [047/133] (718s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[305.117932] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[305.952173] [048/133] (717s left) gem_mmap_wc (close)
[306.008161] Subtest close: SKIP (0.000s)
[306.071198] [049/133] (717s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[306.160453] Starting subtest: fbc-pr-sprite-mmap-cpu
[306.162301] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[306.244851] [050/133] (717s left) device_reset (cold-reset-bound)
[306.291509] Starting subtest: cold-reset-bound
[306.293359] Subtest cold-reset-bound: SKIP (0.000s)
[306.359156] [051/133] (716s left) gem_softpin (evict-active)
[306.430616] Starting subtest: evict-active
[306.436933] Subtest evict-active: SUCCESS (0.006s)
[306.574595] [052/133] (716s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[306.630733] Starting subtest: etime-multi-wait-all-submitted-signaled
[306.739812] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.106s)
[306.819813] [053/133] (716s left) gem_exec_schedule (u-lateslice)
[306.892299] Starting subtest: u-lateslice
[306.893269] Starting dynamic subtest: rcs0
[306.913067] Dynamic subtest rcs0: SUCCESS (0.022s)
[306.921729] Starting dynamic subtest: bcs0
[306.931080] Dynamic subtest bcs0: SUCCESS (0.018s)
[306.938541] Starting dynamic subtest: vcs0
[306.949053] Dynamic subtest vcs0: SUCCESS (0.017s)
[306.956428] Starting dynamic subtest: vcs1
[306.967736] Dynamic subtest vcs1: SUCCESS (0.018s)
[306.976323] Starting dynamic subtest: vecs0
[306.987303] Dynamic subtest vecs0: SUCCESS (0.019s)
[306.995913] Starting dynamic subtest: ccs0
[307.008392] Dynamic subtest ccs0: SUCCESS (0.021s)
[307.009365] Subtest u-lateslice: SUCCESS (0.118s)
[308.984342] [054/133] (714s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[309.077022] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[309.077903] Starting dynamic subtest: pipe-A
[309.427784] Dynamic subtest pipe-A: SUCCESS (0.351s)
[309.436120] Starting dynamic subtest: pipe-B
[310.869750] Dynamic subtest pipe-B: SUCCESS (1.440s)
[310.877199] Starting dynamic subtest: pipe-C
[312.305647] Dynamic subtest pipe-C: SUCCESS (1.435s)
[312.314032] Starting dynamic subtest: pipe-D
[313.734324] Dynamic subtest pipe-D: SUCCESS (1.428s)
[313.735179] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.658s)
[314.906434] [055/133] (708s left) sw_sync (sync_merge_same)
[314.941190] Starting subtest: sync_merge_same
[314.942101] Subtest sync_merge_same: SUCCESS (0.000s)
[315.000047] [056/133] (708s left) gem_ppgtt (shrink-vs-evict-any)
[315.060515] Starting subtest: shrink-vs-evict-any
[322.896942] Subtest shrink-vs-evict-any: SUCCESS (7.833s)
[323.001956] [057/133] (700s left) syncobj_timeline (wait-delayed-signal)
[323.064236] Starting subtest: wait-delayed-signal
[323.169701] Subtest wait-delayed-signal: SUCCESS (0.103s)
[323.257269] [058/133] (700s left) kms_big_fb (linear-64bpp-rotate-270)
[323.366222] Starting subtest: linear-64bpp-rotate-270
[323.385890] Subtest linear-64bpp-rotate-270: SKIP (0.019s)
[323.543433] [059/133] (699s left) sw_sync (timeline_closed)
[323.571476] Starting subtest: timeline_closed
[323.572739] Subtest timeline_closed: SUCCESS (0.000s)
[323.626788] [060/133] (699s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[323.717801] Starting subtest: primary-yf-tiled-reflect-x-270
[323.719510] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[323.812186] [061/133] (699s left) kms_pm_rpm (drm-resources-equal)
[326.050889] Starting subtest: drm-resources-equal
[331.075630] Subtest drm-resources-equal: SUCCESS (5.027s)
[331.176790] [062/133] (692s left) syncobj_wait (wait-all-complex)
[331.226829] Starting subtest: wait-all-complex
[331.442569] Subtest wait-all-complex: SUCCESS (0.213s)
[331.522315] [063/133] (692s left) gem_exec_params (invalid-bsd2-flag-on-render)
[331.573076] Starting subtest: invalid-bsd2-flag-on-render
[331.574052] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[331.672700] [064/133] (692s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[331.778424] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[331.780057] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[331.932872] [065/133] (691s left) kms_flip (2x-nonexisting-fb-interruptible)
[332.023952] Starting subtest: 2x-nonexisting-fb-interruptible
[332.034994] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.011s)
[332.118091] [066/133] (691s left) gem_exec_store (cachelines)
[332.174206] Starting subtest: cachelines
[332.175145] Starting dynamic subtest: rcs0
[332.288858] Dynamic subtest rcs0: SUCCESS (0.114s)
[332.299791] Starting dynamic subtest: bcs0
[332.359273] Dynamic subtest bcs0: SUCCESS (0.069s)
[332.370579] Starting dynamic subtest: vcs0
[332.419216] Dynamic subtest vcs0: SUCCESS (0.058s)
[332.429795] Starting dynamic subtest: vcs1
[332.481200] Dynamic subtest vcs1: SUCCESS (0.060s)
[332.492510] Starting dynamic subtest: vecs0
[332.543945] Dynamic subtest vecs0: SUCCESS (0.061s)
[332.554604] Starting dynamic subtest: ccs0
[332.608341] Dynamic subtest ccs0: SUCCESS (0.063s)
[332.611066] Subtest cachelines: SUCCESS (0.435s)
[332.799658] [067/133] (691s left) gem_userptr_blits (sd-probe)
[332.863420] Starting subtest: sd-probe
[332.864347] Subtest sd-probe: SUCCESS (0.000s)
[333.021755] [068/133] (690s left) core_auth (getclient-simple)
[333.049581] Starting subtest: getclient-simple
[333.075541] Subtest getclient-simple: SUCCESS (0.025s)
[333.179740] [069/133] (690s left) kms_selftest (drm_dp_mst_helper)
[333.211275] Starting subtest: drm_dp_mst_helper
[333.257026] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[333.399049] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.142s)
[333.408688] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[333.533472] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.133s)
[333.541302] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[333.654948] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.121s)
[333.655831] Subtest drm_dp_mst_helper: SUCCESS (0.443s)
[333.866335] [070/133] (690s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[333.957325] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[333.958225] Starting dynamic subtest: pipe-A-eDP-1
[334.824675] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.865s)
[334.832126] Starting dynamic subtest: pipe-B-eDP-1
[336.329223] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.503s)
[336.336863] Starting dynamic subtest: pipe-C-eDP-1
[337.831369] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.501s)
[337.839048] Starting dynamic subtest: pipe-D-eDP-1
[339.290755] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.458s)
[339.291689] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.331s)
[340.469062] [071/133] (683s left) perf_pmu (render-node-busy)
[340.580424] Starting subtest: render-node-busy
[340.581472] Starting dynamic subtest: rcs0
[341.186416] Dynamic subtest rcs0: SUCCESS (0.607s)
[341.197101] Starting dynamic subtest: bcs0
[341.756783] Dynamic subtest bcs0: SUCCESS (0.567s)
[341.767239] Starting dynamic subtest: vcs0
[342.935444] Dynamic subtest vcs0: SUCCESS (1.173s)
[342.945336] Starting dynamic subtest: vcs1
[344.919620] Dynamic subtest vcs1: SUCCESS (1.981s)
[344.929533] Starting dynamic subtest: vecs0
[346.904425] Dynamic subtest vecs0: SUCCESS (1.982s)
[346.914391] Starting dynamic subtest: ccs0
[347.475808] Dynamic subtest ccs0: SUCCESS (0.571s)
[347.477108] Subtest render-node-busy: SUCCESS (6.899s)
[347.559318] [072/133] (676s left) gem_exec_schedule (fairslice)
[347.621896] Starting subtest: fairslice
[347.622801] Starting dynamic subtest: rcs0
[349.651466] Dynamic subtest rcs0: SUCCESS (2.028s)
[349.659522] Starting dynamic subtest: bcs0
[351.674856] Dynamic subtest bcs0: SUCCESS (2.022s)
[351.683271] Starting dynamic subtest: vcs0
[353.697053] Dynamic subtest vcs0: SUCCESS (2.022s)
[353.705177] Starting dynamic subtest: vcs1
[355.718180] Dynamic subtest vcs1: SUCCESS (2.019s)
[355.726176] Starting dynamic subtest: vecs0
[357.739264] Dynamic subtest vecs0: SUCCESS (2.020s)
[357.747242] Starting dynamic subtest: ccs0
[359.762973] Dynamic subtest ccs0: SUCCESS (2.023s)
[359.763948] Subtest fairslice: SUCCESS (12.139s)
[360.070526] [073/133] (663s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[360.166262] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[360.167109] Starting dynamic subtest: pipe-A-default-mode
[362.925047] Dynamic subtest pipe-A-default-mode: SUCCESS (2.757s)
[362.925948] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.759s)
[363.775570] [074/133] (660s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[363.871516] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[363.872432] Starting dynamic subtest: pipe-A-eDP-1
[363.881126] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[363.889284] Starting dynamic subtest: pipe-B-eDP-1
[363.898093] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[363.905804] Starting dynamic subtest: pipe-C-eDP-1
[363.914047] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[363.921440] Starting dynamic subtest: pipe-D-eDP-1
[363.929457] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[363.931050] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[366.051155] [075/133] (658s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[366.141403] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[366.143184] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[366.234908] [076/133] (657s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[366.327844] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[366.328826] Starting dynamic subtest: pipe-A-eDP-1
[366.466915] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.135s)
[366.475894] Starting dynamic subtest: pipe-B-eDP-1
[366.485304] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[366.502417] Starting dynamic subtest: pipe-C-eDP-1
[366.510858] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[366.526323] Starting dynamic subtest: pipe-D-eDP-1
[366.534559] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[366.535498] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.144s)
[368.723305] [077/133] (655s left) kms_cursor_crc (cursor-onscreen-32x10)
[368.877347] Starting subtest: cursor-onscreen-32x10
[368.916409] Subtest cursor-onscreen-32x10: SKIP (0.036s)
[369.199800] [078/133] (654s left) gem_tiled_fence_blits (basic)
[369.258772] Subtest basic: SKIP (0.000s)
[369.335975] [079/133] (654s left) i915_drm_fdinfo (all-busy-check-all)
[369.373516] Starting subtest: all-busy-check-all
[369.378648] Subtest all-busy-check-all: SKIP (0.004s)
[369.449451] [080/133] (654s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[369.580663] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[374.215890] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.635s)
[375.348438] [081/133] (648s left) perf_pmu (busy-accuracy-98)
[375.385463] Starting subtest: busy-accuracy-98
[375.386404] Starting dynamic subtest: rcs0
[378.425394] Dynamic subtest rcs0: SUCCESS (3.038s)
[378.435087] Starting dynamic subtest: bcs0
[381.479547] Dynamic subtest bcs0: SUCCESS (3.051s)
[381.489568] Starting dynamic subtest: vcs0
[384.523816] Dynamic subtest vcs0: SUCCESS (3.042s)
[384.532560] Starting dynamic subtest: vcs1
[387.566452] Dynamic subtest vcs1: SUCCESS (3.039s)
[387.577472] Starting dynamic subtest: vecs0
[390.609239] Dynamic subtest vecs0: SUCCESS (3.040s)
[390.617891] Starting dynamic subtest: ccs0
[393.662279] Dynamic subtest ccs0: SUCCESS (3.050s)
[393.663391] Subtest busy-accuracy-98: SUCCESS (18.276s)
[393.817244] [082/133] (630s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[393.917499] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[393.919059] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[394.023915] [083/133] (630s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[394.083987] Starting subtest: x-tiled-to-vebox-yf-tiled
[394.085856] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[394.275532] [084/133] (630s left) kms_psr (psr-cursor-mmap-cpu)
[394.366445] Starting subtest: psr-cursor-mmap-cpu
[394.367283] Starting dynamic subtest: eDP-1
[396.121035] Dynamic subtest eDP-1: SUCCESS (1.755s)
[396.121845] Subtest psr-cursor-mmap-cpu: SUCCESS (1.755s)
[397.003972] [085/133] (627s left) kms_big_fb (x-tiled-addfb-size-overflow)
[397.093779] Starting subtest: x-tiled-addfb-size-overflow
[397.094600] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[397.203675] [086/133] (627s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[397.300344] Starting subtest: random-ccs-data-yf-tiled-ccs
[397.301281] Starting dynamic subtest: pipe-A-eDP-1
[397.310693] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[397.318180] Starting dynamic subtest: pipe-B-eDP-1
[397.328062] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[397.335595] Starting dynamic subtest: pipe-C-eDP-1
[397.344920] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[397.352271] Starting dynamic subtest: pipe-D-eDP-1
[397.361584] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[397.363274] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.005s)
[399.578503] [087/133] (624s left) kms_cursor_edge_walk (128x128-top-bottom)
[399.667284] Starting subtest: 128x128-top-bottom
[399.668201] Starting dynamic subtest: pipe-A-eDP-1
[403.141947] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.474s)
[403.149425] Starting dynamic subtest: pipe-D-eDP-1
[406.260778] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.118s)
[406.261670] Subtest 128x128-top-bottom: SUCCESS (6.594s)
[407.080700] [088/133] (617s left) gem_exec_flush (basic-wb-ro-default)
[407.141422] Starting subtest: basic-wb-ro-default
[412.597684] Subtest basic-wb-ro-default: SUCCESS (5.456s)
[412.790445] [089/133] (611s left) gem_exec_params (sol-reset-invalid)
[412.848047] Starting subtest: sol-reset-invalid
[412.848972] Subtest sol-reset-invalid: SUCCESS (0.004s)
[414.999302] [090/133] (609s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[415.100902] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[422.528933] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.428s)
[422.691123] [091/133] (601s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[422.784126] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[422.785831] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[422.891711] [092/133] (601s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[422.985904] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[422.987675] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[423.053949] [093/133] (601s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[423.150859] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[430.409556] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.260s)
[430.560908] [094/133] (594s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[430.661359] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[437.911764] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.251s)
[438.065369] [095/133] (586s left) gem_busy (semaphore)
[438.266822] Subtest semaphore: SKIP (0.000s)
[438.518317] [096/133] (586s left) gem_exec_nop (basic-series)
[438.583118] Starting subtest: basic-series
[454.937760] Subtest basic-series: SUCCESS (16.352s)
[455.184706] [097/133] (569s left) kms_addfb_basic (basic-x-tiled-legacy)
[455.233375] Starting subtest: basic-x-tiled-legacy
[455.235195] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[455.405971] [098/133] (569s left) i915_pm_rpm (system-suspend-devices)
[457.043242] Starting subtest: system-suspend-devices
[464.828296] Subtest system-suspend-devices: SUCCESS (7.786s)
[472.229319] [099/133] (559s left) kms_big_fb (4-tiled-addfb-size-overflow)
[472.340564] Starting subtest: 4-tiled-addfb-size-overflow
[472.341484] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[472.462451] [100/133] (559s left) gem_exec_fence (syncobj-repeat)
[472.887948] Starting subtest: syncobj-repeat
[473.065409] Subtest syncobj-repeat: SUCCESS (0.175s)
[474.071998] [101/133] (557s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[474.181879] Starting subtest: cursorA-vs-flipB-atomic
[474.183565] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[474.333226] [102/133] (557s left) perf (polling-parameterized)
[474.429050] Starting subtest: polling-parameterized
[494.453100] Subtest polling-parameterized: SUCCESS (20.021s)
[494.494741] [103/133] (537s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[494.718299] Starting subtest: cursor-rapid-movement-128x42
[494.756953] Subtest cursor-rapid-movement-128x42: SKIP (0.038s)
[494.973938] [104/133] (537s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[495.072913] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[503.900227] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.827s)
[504.019955] [105/133] (528s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[504.127145] Starting subtest: x-tiled-8bpp-rotate-0
[505.208730] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.082s)
[505.372557] [106/133] (526s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[505.474703] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[505.476302] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[505.596391] [107/133] (526s left) i915_drm_fdinfo (virtual-busy-hang-all)
[505.628146] Starting subtest: virtual-busy-hang-all
[505.629884] Subtest virtual-busy-hang-all: SKIP (0.000s)
[505.709817] [108/133] (526s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[505.794798] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[505.796334] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[505.915872] [109/133] (526s left) gem_exec_capture (capture-invisible)
[505.972582] Starting subtest: capture-invisible
[505.973688] Starting dynamic subtest: smem0
[505.975753] Dynamic subtest smem0: SKIP (0.000s)
[505.977847] Subtest capture-invisible: SKIP (0.001s)
[506.098840] [110/133] (526s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[506.190924] Starting subtest: psr-2p-primscrn-spr-indfb-move
[506.192712] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[506.299282] [111/133] (525s left) kms_psr (pr-primary-page-flip)
[506.385139] Starting subtest: pr-primary-page-flip
[506.387050] Subtest pr-primary-page-flip: SKIP (0.000s)
[506.480560] [112/133] (525s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[506.588633] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[506.590819] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[506.681390] [113/133] (525s left) gem_tiled_fence_blits (normal)
[506.744149] Subtest normal: SKIP (0.000s)
[506.833054] [114/133] (525s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[506.913932] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[506.914975] Starting dynamic subtest: pipe-A-eDP-1
[506.942598] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[506.952180] Starting dynamic subtest: pipe-B-eDP-1
[506.973832] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[506.981997] Starting dynamic subtest: pipe-C-eDP-1
[507.003241] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[507.010837] Starting dynamic subtest: pipe-D-eDP-1
[507.033934] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[507.035675] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.010s)
[509.083100] [115/133] (523s left) kms_psr (psr-primary-mmap-gtt)
[509.189550] Starting subtest: psr-primary-mmap-gtt
[509.190477] Starting dynamic subtest: eDP-1
[510.608891] Dynamic subtest eDP-1: SKIP (1.415s)
[510.611217] Subtest psr-primary-mmap-gtt: SKIP (1.417s)
[510.818333] [116/133] (521s left) gem_mmap_gtt (zero-extend)
[510.877375] Subtest zero-extend: SKIP (0.000s)
[510.927442] [117/133] (521s left) gem_mmap_gtt (basic-small-copy-xy)
[510.983922] Subtest basic-small-copy-XY: SKIP (0.000s)
[511.042234] [118/133] (521s left) syncobj_timeline (wait-all-complex)
[511.099496] Starting subtest: wait-all-complex
[511.316387] Subtest wait-all-complex: SUCCESS (0.214s)
[511.409796] [119/133] (521s left) gem_mmap_gtt (basic-short)
[511.458603] Subtest basic-short: SKIP (0.000s)
[511.510733] [120/133] (521s left) kms_invalid_mode (zero-clock)
[511.606825] Starting subtest: zero-clock
[511.607706] Starting dynamic subtest: pipe-A-eDP-1
[511.888151] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.281s)
[511.897199] Starting dynamic subtest: pipe-B-eDP-1
[511.898034] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[511.905472] Starting dynamic subtest: pipe-C-eDP-1
[511.906389] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[511.913946] Starting dynamic subtest: pipe-D-eDP-1
[511.914857] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[511.915791] Subtest zero-clock: SUCCESS (0.287s)
[512.769359] [121/133] (519s left) gem_exec_balancer (nop)
[512.838684] Starting subtest: nop
[559.418497] Subtest nop: SUCCESS (46.578s)
[559.747468] [122/133] (472s left) gem_ctx_isolation (dirty-create)
[559.806828] Starting subtest: dirty-create
[559.807895] Starting dynamic subtest: rcs0
[560.030835] Dynamic subtest rcs0: SUCCESS (0.224s)
[560.041980] Starting dynamic subtest: bcs0
[560.277627] Dynamic subtest bcs0: SUCCESS (0.246s)
[560.288043] Starting dynamic subtest: vcs0
[560.557397] Dynamic subtest vcs0: SUCCESS (0.279s)
[560.565636] Starting dynamic subtest: vcs1
[562.195085] Dynamic subtest vcs1: SUCCESS (1.636s)
[562.203919] Starting dynamic subtest: vecs0
[564.152727] Dynamic subtest vecs0: SUCCESS (1.957s)
[564.161080] Starting dynamic subtest: ccs0
[566.155077] Dynamic subtest ccs0: SUCCESS (2.001s)
[566.156419] Subtest dirty-create: SUCCESS (6.348s)
[566.443013] [123/133] (466s left) gem_exec_parallel (fds)
[566.507416] Starting subtest: fds
[566.508537] Starting dynamic subtest: rcs0
[569.972338] Dynamic subtest rcs0: SUCCESS (3.462s)
[569.983064] Starting dynamic subtest: bcs0
[573.500347] Dynamic subtest bcs0: SUCCESS (3.527s)
[573.511767] Starting dynamic subtest: vcs0
[577.255678] Dynamic subtest vcs0: SUCCESS (3.753s)
[577.267179] Starting dynamic subtest: vcs1
[581.201363] Dynamic subtest vcs1: SUCCESS (3.945s)
[581.210085] Starting dynamic subtest: vecs0
[585.234526] Dynamic subtest vecs0: SUCCESS (4.030s)
[585.246648] Starting dynamic subtest: ccs0
[588.900263] Dynamic subtest ccs0: SUCCESS (3.663s)
[588.901610] Subtest fds: SUCCESS (22.391s)
[589.100522] [124/133] (443s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[589.194371] Starting subtest: fbc-psr-sprite-mmap-gtt
[589.195388] Starting dynamic subtest: eDP-1
[589.197281] Dynamic subtest eDP-1: SKIP (0.000s)
[589.198988] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[589.270913] [125/133] (443s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[589.332623] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[589.333783] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[589.454136] [126/133] (443s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[589.551658] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[589.553342] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[589.673371] [127/133] (443s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[589.734228] Starting subtest: multi-wait-available-unsubmitted-signaled
[589.735121] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[589.836766] [128/133] (443s left) kms_feature_discovery (chamelium)
[589.932818] Starting subtest: chamelium
[589.934661] Subtest chamelium: SKIP (0.000s)
[590.013182] [129/133] (442s left) kms_flip (dpms-off-confusion)
[590.102322] Starting subtest: dpms-off-confusion
[590.104657] Starting dynamic subtest: A-eDP1
[598.760926] Dynamic subtest A-eDP1: SUCCESS (8.656s)
[598.772050] Starting dynamic subtest: B-eDP1
[607.399553] Dynamic subtest B-eDP1: SUCCESS (8.636s)
[607.409937] Starting dynamic subtest: C-eDP1
[616.036856] Dynamic subtest C-eDP1: SUCCESS (8.636s)
[616.047761] Starting dynamic subtest: D-eDP1
[624.668706] Dynamic subtest D-eDP1: SUCCESS (8.629s)
[624.673438] Subtest dpms-off-confusion: SUCCESS (34.570s)
[625.846766] [130/133] (407s left) gem_lmem_swapping (heavy-verify-random)
[625.881830] Subtest heavy-verify-random: SKIP (0.000s)
[625.918597] [131/133] (407s left) kms_plane_multiple (tiling-4)
[626.012203] Starting subtest: tiling-4
[626.013106] Starting dynamic subtest: pipe-A-eDP-1
[629.686858] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.673s)
[629.695590] Starting dynamic subtest: pipe-B-eDP-1
[634.116841] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.429s)
[634.126452] Starting dynamic subtest: pipe-C-eDP-1
[638.438528] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.320s)
[638.446813] Starting dynamic subtest: pipe-D-eDP-1
[642.772526] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.333s)
[642.773436] Subtest tiling-4: SUCCESS (16.760s)
[643.595325] [132/133] (389s left) vgem_slow (nohang)
[643.638757] Starting subtest: nohang
[653.940679] Subtest nohang: SUCCESS (10.299s)
[654.011463] [133/133] (378s left) gem_eio (wait-1us)
[654.232610] Starting subtest: wait-1us
[654.614267] Subtest wait-1us: SUCCESS (0.382s)
[654.777119] Closing watchdogs
results: parsing output: 0/ for test: gem_tiled_blits
results: parsing output: 1/ for test: perf_pmu
results: parsing output: 2/ for test: kms_content_protection
results: parsing output: 3/ for test: gem_ctx_persistence
results: parsing output: 4/ for test: kms_pipe_crc_basic
results: parsing output: 5/ for test: kms_plane_scaling
results: parsing output: 6/ for test: syncobj_eventfd
results: parsing output: 7/ for test: kms_atomic
results: parsing output: 8/ for test: gem_eio
results: parsing output: 9/ for test: kms_psr2_sf
results: parsing output: 10/ for test: perf
results: parsing output: 11/ for test: gem_mmap_gtt
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_prime
results: parsing output: 14/ for test: gen7_exec_parse
results: parsing output: 15/ for test: gem_create
results: parsing output: 16/ for test: kms_lease
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: vgem_basic
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_vblank
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_chamelium_edid
results: parsing output: 24/ for test: gem_eio
results: parsing output: 25/ for test: kms_cursor_legacy
results: parsing output: 26/ for test: i915_query
results: parsing output: 27/ for test: gem_softpin
results: parsing output: 28/ for test: gem_lmem_swapping
results: parsing output: 29/ for test: gem_render_copy
results: parsing output: 30/ for test: kms_plane
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: i915_query
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_psr2_sf
results: parsing output: 36/ for test: kms_getfb
results: parsing output: 37/ for test: kms_flip
results: parsing output: 38/ for test: api_intel_bb
results: parsing output: 39/ for test: kms_color
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_mmap_gtt
results: parsing output: 43/ for test: syncobj_basic
results: parsing output: 44/ for test: kms_properties
results: parsing output: 45/ for test: gem_exec_schedule
results: parsing output: 46/ for test: kms_chamelium_hpd
results: parsing output: 47/ for test: gem_mmap_wc
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: device_reset
results: parsing output: 50/ for test: gem_softpin
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: gem_exec_schedule
results: parsing output: 53/ for test: kms_plane_scaling
results: parsing output: 54/ for test: sw_sync
results: parsing output: 55/ for test: gem_ppgtt
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: sw_sync
results: parsing output: 59/ for test: kms_rotation_crc
results: parsing output: 60/ for test: kms_pm_rpm
results: parsing output: 61/ for test: syncobj_wait
results: parsing output: 62/ for test: gem_exec_params
results: parsing output: 63/ for test: kms_cursor_legacy
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: gem_exec_store
results: parsing output: 66/ for test: gem_userptr_blits
results: parsing output: 67/ for test: core_auth
results: parsing output: 68/ for test: kms_selftest
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: perf_pmu
results: parsing output: 71/ for test: gem_exec_schedule
results: parsing output: 72/ for test: kms_flip_scaled_crc
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: kms_flip_scaled_crc
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: kms_cursor_crc
results: parsing output: 77/ for test: gem_tiled_fence_blits
results: parsing output: 78/ for test: i915_drm_fdinfo
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: perf_pmu
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_render_copy
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: kms_cursor_edge_walk
results: parsing output: 87/ for test: gem_exec_flush
results: parsing output: 88/ for test: gem_exec_params
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_psr2_sf
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_busy
results: parsing output: 95/ for test: gem_exec_nop
results: parsing output: 96/ for test: kms_addfb_basic
results: parsing output: 97/ for test: i915_pm_rpm
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: gem_exec_fence
results: parsing output: 100/ for test: kms_cursor_legacy
results: parsing output: 101/ for test: perf
results: parsing output: 102/ for test: kms_cursor_crc
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: i915_drm_fdinfo
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_exec_capture
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: gem_tiled_fence_blits
results: parsing output: 113/ for test: kms_ccs
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: gem_mmap_gtt
results: parsing output: 116/ for test: gem_mmap_gtt
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: gem_mmap_gtt
results: parsing output: 119/ for test: kms_invalid_mode
results: parsing output: 120/ for test: gem_exec_balancer
results: parsing output: 121/ for test: gem_ctx_isolation
results: parsing output: 122/ for test: gem_exec_parallel
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: syncobj_timeline
results: parsing output: 125/ for test: kms_big_fb
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: kms_feature_discovery
results: parsing output: 128/ for test: kms_flip
results: parsing output: 129/ for test: gem_lmem_swapping
results: parsing output: 130/ for test: kms_plane_multiple
results: parsing output: 131/ for test: vgem_slow
results: parsing output: 132/ for test: gem_eio
Done.