[59.393448] Initializing watchdogs
[59.393493]   /dev/watchdog0
[59.409212] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.413689] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.415925] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.419159] [001/133] (960s left) kms_big_fb (linear-64bpp-rotate-0)
[59.547156] Starting subtest: linear-64bpp-rotate-0
[61.214341] Subtest linear-64bpp-rotate-0: SUCCESS (1.668s)
[61.391867] [002/133] (958s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[61.481740] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[61.485846] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.000s)
[61.562347] [003/133] (958s left) gem_exec_balancer (persistence)
[61.830534] Starting subtest: persistence
[62.709136] Subtest persistence: SUCCESS (0.880s)
[62.852665] [004/133] (957s left) gem_ctx_shared (disjoint-timelines)
[62.918558] Starting subtest: disjoint-timelines
[62.972380] Subtest disjoint-timelines: SUCCESS (0.054s)
[63.220403] [FACT gem_ctx_shared (disjoint-timelines)] new: kernel.kmod_is_loaded.vgem: true
[63.223664] [005/133] (956s left) gen9_exec_parse (bb-secure)
[63.278074] Subtest bb-secure: SKIP (0.000s)
[63.358335] [006/133] (956s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[63.459362] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[68.432815] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.976s)
[69.582858] [007/133] (950s left) kms_cursor_crc (cursor-onscreen-512x170)
[69.874935] Starting subtest: cursor-onscreen-512x170
[69.879399] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[70.051180] [008/133] (950s left) gem_ctx_persistence (engines-mixed-process)
[70.119961] Starting subtest: engines-mixed-process
[70.121968] Starting dynamic subtest: rcs0
[71.919673] Dynamic subtest rcs0: SUCCESS (1.802s)
[71.929229] Starting dynamic subtest: bcs0
[73.896583] Dynamic subtest bcs0: SUCCESS (1.976s)
[73.906689] Starting dynamic subtest: vcs0
[75.946676] Dynamic subtest vcs0: SUCCESS (2.049s)
[75.956314] Starting dynamic subtest: vcs1
[77.915652] Dynamic subtest vcs1: SUCCESS (1.968s)
[77.923214] Starting dynamic subtest: vecs0
[79.922771] Dynamic subtest vecs0: SUCCESS (2.006s)
[79.932349] Starting dynamic subtest: ccs0
[81.860356] Dynamic subtest ccs0: SUCCESS (1.936s)
[81.862539] Subtest engines-mixed-process: SUCCESS (11.741s)
[82.000692] [009/133] (938s left) kms_plane (pixel-format-yf-tiled-modifier)
[82.121222] Starting subtest: pixel-format-yf-tiled-modifier
[82.134495] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s)
[82.218642] [010/133] (938s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[82.323645] Starting subtest: y-tiled-8bpp-rotate-90
[82.327895] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[82.442068] [011/133] (937s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[82.547316] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[82.551449] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[82.660500] [012/133] (937s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[82.759970] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[82.762588] Starting dynamic subtest: pipe-A-eDP-1
[82.785368] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[82.794557] Starting dynamic subtest: pipe-B-eDP-1
[82.816574] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[82.824270] Starting dynamic subtest: pipe-C-eDP-1
[82.846099] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[82.854882] Starting dynamic subtest: pipe-D-eDP-1
[82.872913] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[82.876259] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.004s)
[84.942505] [013/133] (935s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[85.045270] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[85.049547] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[85.167941] [014/133] (935s left) gem_mmap_gtt (big-copy)
[85.229047] Subtest big-copy: SKIP (0.000s)
[85.294783] [015/133] (935s left) gem_ctx_param (set-priority-not-supported)
[85.354402] Starting subtest: set-priority-not-supported
[85.359104] Subtest set-priority-not-supported: SKIP (0.000s)
[85.439666] [016/133] (935s left) kms_pm_backlight (fade)
[85.549302] Starting subtest: fade
[85.601094] Starting dynamic subtest: eDP-1
[88.271045] Dynamic subtest eDP-1: SUCCESS (2.670s)
[88.273712] Subtest fade: SUCCESS (2.721s)
[89.081345] [017/133] (931s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[89.201401] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[89.205790] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[89.305198] [018/133] (931s left) kms_cursor_crc (cursor-sliding-512x512)
[89.567874] Starting subtest: cursor-sliding-512x512
[89.572391] Subtest cursor-sliding-512x512: SKIP (0.001s)
[89.771046] [019/133] (930s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[89.875449] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[89.879618] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[89.975132] [020/133] (930s left) kms_flip (flip-vs-expired-vblank-interruptible)
[90.071648] Starting subtest: flip-vs-expired-vblank-interruptible
[90.073688] Starting dynamic subtest: A-eDP1
[98.776568] Dynamic subtest A-eDP1: SUCCESS (8.702s)
[98.786877] Starting dynamic subtest: B-eDP1
[107.412052] Dynamic subtest B-eDP1: SUCCESS (8.632s)
[107.422860] Starting dynamic subtest: C-eDP1
[116.030434] Dynamic subtest C-eDP1: SUCCESS (8.618s)
[116.040341] Starting dynamic subtest: D-eDP1
[124.658037] Dynamic subtest D-eDP1: SUCCESS (8.626s)
[124.663101] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.589s)
[125.844342] [021/133] (894s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[125.937464] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[125.941931] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[126.055281] [022/133] (894s left) sw_sync (alloc_timeline)
[126.093073] Starting subtest: alloc_timeline
[126.095165] Subtest alloc_timeline: SUCCESS (0.000s)
[126.156162] [023/133] (894s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[126.211509] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[126.213405] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[126.333139] [024/133] (894s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[126.426158] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[126.430156] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[126.527706] [025/133] (894s left) perf_pmu (semaphore-wait-idle)
[126.565959] Starting subtest: semaphore-wait-idle
[126.568213] Starting dynamic subtest: rcs0
[127.080608] Dynamic subtest rcs0: SUCCESS (0.513s)
[127.091242] Starting dynamic subtest: bcs0
[127.593342] Dynamic subtest bcs0: SUCCESS (0.511s)
[127.603730] Starting dynamic subtest: vcs0
[128.105784] Dynamic subtest vcs0: SUCCESS (0.511s)
[128.116315] Starting dynamic subtest: vcs1
[128.618023] Dynamic subtest vcs1: SUCCESS (0.511s)
[128.628770] Starting dynamic subtest: vecs0
[129.129962] Dynamic subtest vecs0: SUCCESS (0.511s)
[129.141229] Starting dynamic subtest: ccs0
[129.645696] Dynamic subtest ccs0: SUCCESS (0.514s)
[129.648792] Subtest semaphore-wait-idle: SUCCESS (3.078s)
[130.986359] [026/133] (889s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[131.087370] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[137.902273] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.817s)
[138.061328] [027/133] (882s left) kms_vblank (accuracy-idle)
[138.175697] Starting subtest: accuracy-idle
[138.177940] Starting dynamic subtest: pipe-A-eDP-1
[139.935978] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.760s)
[139.948622] Starting dynamic subtest: pipe-D-eDP-1
[142.383663] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.444s)
[142.385603] Subtest accuracy-idle: SUCCESS (4.207s)
[143.219374] [028/133] (877s left) gem_pread (self)
[143.283985] Subtest self: SKIP (0.000s)
[143.344384] [029/133] (877s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[143.734624] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[144.518026] [030/133] (876s left) kms_addfb_basic (invalid-set-prop-any)
[144.578311] Starting subtest: invalid-set-prop-any
[144.580258] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[144.734670] [031/133] (876s left) kms_psr (psr-sprite-render)
[144.819181] Starting subtest: psr-sprite-render
[144.821499] Starting dynamic subtest: eDP-1
[146.557462] Dynamic subtest eDP-1: SUCCESS (1.738s)
[146.559617] Subtest psr-sprite-render: SUCCESS (1.739s)
[147.410250] [032/133] (873s left) gem_mmap_gtt (coherency)
[147.469727] Subtest coherency: SKIP (0.000s)
[147.524599] [033/133] (873s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[147.626156] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[147.630418] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[147.739103] [034/133] (873s left) kms_flip (flip-vs-modeset-vs-hang)
[147.844598] Starting subtest: flip-vs-modeset-vs-hang
[147.846978] Starting dynamic subtest: A-eDP1
[199.405804] Dynamic subtest A-eDP1: SUCCESS (51.563s)
[199.416126] Starting dynamic subtest: D-eDP1
[249.389604] Dynamic subtest D-eDP1: SUCCESS (49.983s)
[249.391942] Subtest flip-vs-modeset-vs-hang: SUCCESS (101.553s)
[249.783602] [035/133] (771s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[249.884305] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[249.897150] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.011s)
[249.989898] [036/133] (771s left) syncobj_timeline (signal-point-0)
[250.044840] Starting subtest: signal-point-0
[250.047926] Subtest signal-point-0: SUCCESS (0.000s)
[250.158616] [037/133] (771s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[250.267283] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[250.269521] Starting dynamic subtest: pipe-A-eDP-1
[250.385539] Dynamic subtest pipe-A-eDP-1: SKIP (0.122s)
[250.398533] Starting dynamic subtest: pipe-B-eDP-1
[251.545836] Dynamic subtest pipe-B-eDP-1: SKIP (1.159s)
[251.550499] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.283s)
[252.750654] [038/133] (768s left) gem_ctx_persistence (userptr)
[252.813753] Starting subtest: userptr
[253.010376] Subtest userptr: SUCCESS (0.196s)
[253.087818] [039/133] (768s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[253.185760] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[253.190242] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[254.288804] [040/133] (767s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[254.385481] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[258.005013] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.623s)
[259.193054] [041/133] (762s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[259.342185] Starting subtest: basic-flip-after-cursor-atomic
[260.255382] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.912s)
[261.131089] [042/133] (760s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[261.246722] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[261.251033] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[261.356767] [043/133] (760s left) gem_ccs (block-multicopy-compressed)
[261.422900] Starting subtest: block-multicopy-compressed
[261.427334] Subtest block-multicopy-compressed: SKIP (0.000s)
[261.537726] [044/133] (760s left) kms_flip (plain-flip-ts-check)
[261.638058] Starting subtest: plain-flip-ts-check
[261.640466] Starting dynamic subtest: A-eDP1
[270.505827] Dynamic subtest A-eDP1: SUCCESS (8.870s)
[270.515785] Starting dynamic subtest: B-eDP1
[279.333261] Dynamic subtest B-eDP1: SUCCESS (8.823s)
[279.343876] Starting dynamic subtest: C-eDP1
[288.156820] Dynamic subtest C-eDP1: SUCCESS (8.820s)
[288.166987] Starting dynamic subtest: D-eDP1
[296.989479] Dynamic subtest D-eDP1: SUCCESS (8.830s)
[296.994323] Subtest plain-flip-ts-check: SUCCESS (35.356s)
[298.204646] [045/133] (723s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[298.603281] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[299.387255] [046/133] (722s left) gem_exec_flush (basic-wb-ro-before-default)
[299.446774] Starting subtest: basic-wb-ro-before-default
[304.910189] Subtest basic-wb-ro-before-default: SUCCESS (5.463s)
[305.108270] [047/133] (716s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[305.169262] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[305.241940] [048/133] (716s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[305.305227] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[305.374635] [049/133] (716s left) dmabuf_sync_file (export-multiwait)
[305.421340] Starting subtest: export-multiwait
[305.423328] Subtest export-multiwait: SUCCESS (0.000s)
[305.491368] [050/133] (716s left) i915_drm_fdinfo (virtual-busy-hang-all)
[305.527099] Starting subtest: virtual-busy-hang-all
[305.531279] Subtest virtual-busy-hang-all: SKIP (0.000s)
[305.611773] [051/133] (716s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[305.714272] Starting subtest: fbcpsr-slowdraw
[330.946632] Subtest fbcpsr-slowdraw: SUCCESS (25.233s)
[331.094614] [052/133] (690s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[331.228258] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[331.232557] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[331.351816] [053/133] (690s left) gem_mmap_wc (read-write)
[331.417117] Subtest read-write: SKIP (0.000s)
[331.482043] [054/133] (690s left) syncobj_timeline (invalid-signal-illegal-point)
[331.541753] Starting subtest: invalid-signal-illegal-point
[331.544403] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[331.670060] [055/133] (690s left) kms_cursor_crc (cursor-random-64x64)
[331.848207] Starting subtest: cursor-random-64x64
[331.852269] Starting dynamic subtest: pipe-A-eDP-1
[335.195410] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.339s)
[335.222221] Starting dynamic subtest: pipe-D-eDP-1
[339.227560] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.013s)
[339.229908] Subtest cursor-random-64x64: SUCCESS (7.378s)
[340.121274] [056/133] (682s left) kms_force_connector_basic (prune-stale-modes)
[340.222741] Starting subtest: prune-stale-modes
[340.664530] Subtest prune-stale-modes: SUCCESS (0.442s)
[340.816560] [057/133] (681s left) gem_lmem_swapping (basic)
[340.861661] Subtest basic: SKIP (0.000s)
[340.904707] [058/133] (681s left) kms_properties (crtc-properties-legacy)
[340.991020] Starting subtest: crtc-properties-legacy
[340.993336] Starting dynamic subtest: pipe-A-eDP-1
[341.437409] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.446s)
[341.446105] Starting dynamic subtest: pipe-B-eDP-1
[342.559766] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.122s)
[342.573704] Starting dynamic subtest: pipe-C-eDP-1
[343.749691] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.188s)
[343.759207] Starting dynamic subtest: pipe-D-eDP-1
[344.881755] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s)
[344.883852] Subtest crtc-properties-legacy: SUCCESS (3.891s)
[345.739583] [059/133] (676s left) kms_hdr (brightness-with-hdr)
[345.845621] Starting subtest: brightness-with-hdr
[345.852025] Subtest brightness-with-hdr: SKIP (0.000s)
[345.930245] [060/133] (676s left) kms_lease (empty-lease)
[346.028611] Starting subtest: empty-lease
[346.030744] Starting dynamic subtest: pipe-A-eDP-1
[346.032935] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[346.041733] Starting dynamic subtest: pipe-B-eDP-1
[346.043574] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[346.051653] Starting dynamic subtest: pipe-C-eDP-1
[346.053507] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[346.061374] Starting dynamic subtest: pipe-D-eDP-1
[346.063259] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[346.065158] Subtest empty-lease: SUCCESS (0.009s)
[346.157829] [061/133] (676s left) kms_invalid_mode (overflow-vrefresh)
[346.260579] Starting subtest: overflow-vrefresh
[346.262834] Starting dynamic subtest: pipe-A-eDP-1
[346.547452] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s)
[346.556562] Starting dynamic subtest: pipe-B-eDP-1
[346.558470] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[346.566592] Starting dynamic subtest: pipe-C-eDP-1
[346.568531] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[346.579070] Starting dynamic subtest: pipe-D-eDP-1
[346.581190] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[346.583263] Subtest overflow-vrefresh: SUCCESS (0.295s)
[347.373942] [062/133] (675s left) gem_softpin (evict-active-interruptible)
[347.442814] Starting subtest: evict-active-interruptible
[347.449764] Subtest evict-active-interruptible: SUCCESS (0.007s)
[347.548659] [063/133] (674s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping)
[347.648078] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping
[347.661090] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[347.743475] [064/133] (674s left) kms_content_protection (dp-mst-type-0-hdcp14)
[347.884843] Starting subtest: dp-mst-type-0-hdcp14
[347.889290] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[348.049208] [065/133] (674s left) kms_pm_rpm (pm-caching)
[350.069624] Starting subtest: pm-caching
[350.074456] Subtest pm-caching: SKIP (0.000s)
[350.455024] [066/133] (672s left) syncobj_basic (create-signaled)
[350.522352] Starting subtest: create-signaled
[350.524241] Subtest create-signaled: SUCCESS (0.000s)
[350.641064] [067/133] (671s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[350.755330] Starting subtest: cursor-vs-flip-legacy
[380.091871] Subtest cursor-vs-flip-legacy: SUCCESS (29.334s)
[380.939383] [068/133] (641s left) prime_mmap (test_map_unmap)
[381.012935] Starting subtest: test_map_unmap
[381.014791] Starting dynamic subtest: test_map_unmap-smem
[381.043609] Dynamic subtest test_map_unmap-smem: SUCCESS (0.031s)
[381.046069] Subtest test_map_unmap: SUCCESS (0.032s)
[381.160644] [069/133] (641s left) perf (whitelisted-registers-userspace-config)
[381.304657] Starting subtest: whitelisted-registers-userspace-config
[381.306535] Subtest whitelisted-registers-userspace-config: SUCCESS (0.000s)
[381.348116] [070/133] (641s left) gem_eio (wait-1us)
[381.569530] Starting subtest: wait-1us
[381.928355] Subtest wait-1us: SUCCESS (0.360s)
[382.090062] [071/133] (640s left) gem_exec_gttfill (engines)
[382.155472] Starting subtest: engines
[382.157332] Starting dynamic subtest: rcs0
[405.092823] Dynamic subtest rcs0: SUCCESS (22.937s)
[405.105342] Starting dynamic subtest: bcs0
[428.382440] Dynamic subtest bcs0: SUCCESS (23.287s)
[428.394377] Starting dynamic subtest: vcs0
[451.690111] Dynamic subtest vcs0: SUCCESS (23.305s)
[451.699080] Starting dynamic subtest: vcs1
[474.972073] Dynamic subtest vcs1: SUCCESS (23.280s)
[474.983976] Starting dynamic subtest: vecs0
[498.305958] Dynamic subtest vecs0: SUCCESS (23.333s)
[498.316062] Starting dynamic subtest: ccs0
[521.637053] Dynamic subtest ccs0: SUCCESS (23.328s)
[521.639803] Subtest engines: SUCCESS (139.480s)
[521.838352] [072/133] (500s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[521.992777] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[528.803335] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.812s)
[528.989102] [073/133] (493s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[529.096589] Starting subtest: plane-lut1d-ctm3x4-lut1d
[529.110247] Starting dynamic subtest: pipe-A-eDP-1
[529.831221] Dynamic subtest pipe-A-eDP-1: FAIL (0.338s)
[530.562083] Starting dynamic subtest: pipe-B-eDP-1
[531.367388] Dynamic subtest pipe-B-eDP-1: FAIL (0.280s)
[531.858927] Starting dynamic subtest: pipe-C-eDP-1
[532.673933] Dynamic subtest pipe-C-eDP-1: FAIL (0.235s)
[533.162767] Starting dynamic subtest: pipe-D-eDP-1
[533.990038] Dynamic subtest pipe-D-eDP-1: FAIL (0.245s)
[533.992248] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (4.595s)
[534.531421] [074/133] (488s left) gem_userptr_blits (map-fixed-invalidate-busy)
[534.601319] Starting subtest: map-fixed-invalidate-busy
[534.605612] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[534.767529] [075/133] (488s left) gem_exec_balancer (hog)
[534.839016] Starting subtest: hog
[534.843356] Subtest hog: SKIP (0.000s)
[535.183453] [076/133] (487s left) syncobj_timeline (multi-wait-for-submit-signaled)
[535.250974] Starting subtest: multi-wait-for-submit-signaled
[535.253242] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[535.374602] [077/133] (487s left) core_getclient (basic)
[535.433449] Starting subtest: basic
[535.435606] Subtest basic: SUCCESS (0.000s)
[535.541553] [078/133] (487s left) kms_vrr (flip-dpms)
[535.650663] Starting subtest: flip-dpms
[535.657187] Subtest flip-dpms: SKIP (0.000s)
[535.739018] [079/133] (487s left) kms_psr (pr-suspend)
[535.843044] Starting subtest: pr-suspend
[535.847111] Subtest pr-suspend: SKIP (0.000s)
[535.938495] [080/133] (487s left) i915_pm_rc6_residency (rc6-fence)
[536.001568] Starting subtest: rc6-fence
[536.049514] Starting dynamic subtest: gt0
[548.365863] Dynamic subtest gt0: SUCCESS (12.315s)
[548.377792] Starting dynamic subtest: gt1
[561.877452] Dynamic subtest gt1: SUCCESS (13.507s)
[561.880998] Subtest rc6-fence: SUCCESS (25.876s)
[561.971192] [081/133] (461s left) kms_chamelium_audio (dp-audio-edid)
[562.375835] Subtest dp-audio-edid: SKIP (0.000s)
[563.184197] [082/133] (460s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[563.294904] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[563.299210] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[563.394435] [083/133] (459s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[563.494178] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[563.496562] Starting dynamic subtest: pipe-A-eDP-1
[563.519064] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[563.533133] Starting dynamic subtest: pipe-B-eDP-1
[563.554820] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[563.565574] Starting dynamic subtest: pipe-C-eDP-1
[563.586735] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[563.595587] Starting dynamic subtest: pipe-D-eDP-1
[563.616752] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[563.621039] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.009s)
[565.730961] [084/133] (457s left) prime_vgem (fence-read-hang)
[565.822750] Subtest fence-read-hang: SKIP (0.000s)
[565.956050] [085/133] (457s left) i915_drm_fdinfo (busy-hang)
[565.997066] Starting subtest: busy-hang
[565.999229] Starting dynamic subtest: rcs0
[566.030704] Dynamic subtest rcs0: SKIP (0.033s)
[566.041652] Starting dynamic subtest: bcs0
[566.045671] Dynamic subtest bcs0: SKIP (0.001s)
[566.054494] Starting dynamic subtest: vcs0
[566.058473] Dynamic subtest vcs0: SKIP (0.000s)
[566.067270] Starting dynamic subtest: vcs1
[566.071367] Dynamic subtest vcs1: SKIP (0.000s)
[566.079893] Starting dynamic subtest: vecs0
[566.084069] Dynamic subtest vecs0: SKIP (0.000s)
[566.092677] Starting dynamic subtest: ccs0
[566.096788] Dynamic subtest ccs0: SKIP (0.001s)
[566.101040] Subtest busy-hang: SKIP (0.040s)
[566.137907] [086/133] (457s left) gem_exec_schedule (u-semaphore-user)
[566.213606] Starting subtest: u-semaphore-user
[566.267304] Subtest u-semaphore-user: SUCCESS (0.057s)
[567.946946] [087/133] (455s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[568.013961] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[568.018686] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[568.209308] [088/133] (455s left) perf_pmu (render-node-busy-idle)
[568.312058] Starting subtest: render-node-busy-idle
[568.314133] Starting dynamic subtest: rcs0
[568.984251] Dynamic subtest rcs0: SUCCESS (0.674s)
[568.995241] Starting dynamic subtest: bcs0
[569.654640] Dynamic subtest bcs0: SUCCESS (0.668s)
[569.666155] Starting dynamic subtest: vcs0
[570.901879] Dynamic subtest vcs0: SUCCESS (1.244s)
[570.913981] Starting dynamic subtest: vcs1
[572.886378] Dynamic subtest vcs1: SUCCESS (1.981s)
[572.898603] Starting dynamic subtest: vecs0
[574.932525] Dynamic subtest vecs0: SUCCESS (2.043s)
[574.941958] Starting dynamic subtest: ccs0
[575.601768] Dynamic subtest ccs0: SUCCESS (0.669s)
[575.604283] Subtest render-node-busy-idle: SUCCESS (7.293s)
[575.691577] [089/133] (447s left) vgem_slow (nohang)
[575.732578] Starting subtest: nohang
[585.843405] Subtest nohang: SUCCESS (10.112s)
[585.926262] [090/133] (437s left) i915_pm_rps (waitboost)
[586.005857] Starting subtest: waitboost
[592.110308] Subtest waitboost: SUCCESS (6.103s)
[592.264369] [091/133] (431s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[592.371780] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[592.374069] Starting dynamic subtest: pipe-A-eDP-1
[609.481562] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.988s)
[609.493121] Starting dynamic subtest: pipe-B-eDP-1
[627.458680] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.837s)
[627.469713] Starting dynamic subtest: pipe-C-eDP-1
[645.383085] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.754s)
[645.393705] Starting dynamic subtest: pipe-D-eDP-1
[663.391167] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.728s)
[663.393385] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (10.312s)
[670.642022] [092/133] (359s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[670.754368] Starting subtest: fbc-psr-cursor-mmap-gtt
[670.756189] Starting dynamic subtest: eDP-1
[670.760140] Dynamic subtest eDP-1: SKIP (0.000s)
[670.764153] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[670.837974] [093/133] (358s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[670.935656] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[670.939744] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[671.038272] [094/133] (358s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[671.140857] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[671.144929] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[671.280776] [095/133] (358s left) kms_vrr (seamless-rr-switch-drrs)
[671.379705] Starting subtest: seamless-rr-switch-drrs
[671.386178] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[671.466449] [096/133] (358s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[671.565243] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[671.569354] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[671.708844] [097/133] (358s left) kms_getfb (getfb-handle-not-fb)
[671.817695] Starting subtest: getfb-handle-not-fb
[671.819667] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[671.948673] [098/133] (358s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[672.059824] Starting subtest: yf-tiled-16bpp-rotate-270
[672.063452] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[672.185029] [099/133] (357s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[672.285945] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[672.900403] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.615s)
[673.137618] [100/133] (356s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[673.259271] Starting subtest: flip-vs-cursor-legacy
[680.414585] Subtest flip-vs-cursor-legacy: SUCCESS (7.148s)
[681.241321] [101/133] (348s left) kms_psr (fbc-psr2-basic)
[681.356045] Starting subtest: fbc-psr2-basic
[681.358404] Starting dynamic subtest: eDP-1
[681.362470] Dynamic subtest eDP-1: SKIP (0.000s)
[681.366640] Subtest fbc-psr2-basic: SKIP (0.001s)
[681.440841] [102/133] (348s left) gem_softpin (full)
[681.504767] Starting subtest: full
[681.512722] Subtest full: SUCCESS (0.008s)
[681.685022] [103/133] (348s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[681.791156] Starting subtest: x-tiled-8bpp-rotate-270
[681.812551] Subtest x-tiled-8bpp-rotate-270: SKIP (0.021s)
[681.963259] [104/133] (348s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[682.060855] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[682.063121] Starting dynamic subtest: pipe-A
[682.090010] Dynamic subtest pipe-A: SKIP (0.025s)
[682.100291] Starting dynamic subtest: pipe-B
[682.124133] Dynamic subtest pipe-B: SKIP (0.032s)
[682.134065] Starting dynamic subtest: pipe-C
[682.158276] Dynamic subtest pipe-C: SKIP (0.034s)
[682.167832] Starting dynamic subtest: pipe-D
[682.188545] Dynamic subtest pipe-D: SKIP (0.030s)
[682.191691] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.125s)
[682.319564] [105/133] (347s left) gem_close_race (basic-threads)
[682.381670] Starting subtest: basic-threads
[683.792571] Subtest basic-threads: SUCCESS (1.409s)
[683.989840] [106/133] (346s left) syncobj_wait (multi-wait-submitted)
[684.057555] Starting subtest: multi-wait-submitted
[684.163342] Subtest multi-wait-submitted: SUCCESS (0.104s)
[684.253469] [107/133] (346s left) gem_wait (await)
[684.320034] Starting subtest: await
[684.322687] Starting dynamic subtest: all-engines
[685.461047] Dynamic subtest all-engines: SUCCESS (1.140s)
[685.479239] Starting dynamic subtest: rcs0
[686.524796] Dynamic subtest rcs0: SUCCESS (1.061s)
[686.543177] Starting dynamic subtest: bcs0
[687.582250] Dynamic subtest bcs0: SUCCESS (1.055s)
[687.600800] Starting dynamic subtest: vcs0
[688.637508] Dynamic subtest vcs0: SUCCESS (1.053s)
[688.657008] Starting dynamic subtest: vcs1
[689.696535] Dynamic subtest vcs1: SUCCESS (1.055s)
[689.713643] Starting dynamic subtest: vecs0
[690.749663] Dynamic subtest vecs0: SUCCESS (1.051s)
[690.767667] Starting dynamic subtest: ccs0
[691.808534] Dynamic subtest ccs0: SUCCESS (1.056s)
[691.811223] Subtest await: SUCCESS (7.486s)
[692.015788] [108/133] (338s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[692.085280] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[692.187260] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.102s)
[692.282229] [109/133] (338s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[692.419932] Starting subtest: cursor-vs-flip-toggle
[723.152994] Subtest cursor-vs-flip-toggle: SUCCESS (30.725s)
[724.022265] [110/133] (306s left) gem_exec_whisper (basic-normal-all)
[724.081029] Starting subtest: basic-normal-all
[726.360463] Subtest basic-normal-all: SUCCESS (2.279s)
[726.571937] [111/133] (303s left) gem_ccs (large-ctrl-surf-copy)
[726.637855] Starting subtest: large-ctrl-surf-copy
[726.642597] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[726.772561] [112/133] (303s left) kms_dsc (dsc-with-bpc)
[726.870380] Starting subtest: dsc-with-bpc
[726.900502] Subtest dsc-with-bpc: SKIP (0.001s)
[726.952681] [113/133] (303s left) gem_mmap_offset (clear-via-pagefault)
[727.005608] Starting subtest: clear-via-pagefault
[727.007579] Starting dynamic subtest: smem0
[761.522855] Dynamic subtest smem0: SUCCESS (34.506s)
[761.525049] Subtest clear-via-pagefault: SUCCESS (34.507s)
[761.655692] [114/133] (268s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[761.763049] Starting subtest: async-flip-with-page-flip-events-tiled
[762.135176] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[764.864288] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.729s)
[764.874555] Starting dynamic subtest: pipe-A-eDP-1-4
[767.050245] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.185s)
[767.063048] Starting dynamic subtest: pipe-A-eDP-1-4
[769.060337] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[769.071164] Starting dynamic subtest: pipe-A-eDP-1-x
[771.238676] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.177s)
[771.613570] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[774.359262] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.753s)
[774.369698] Starting dynamic subtest: pipe-B-eDP-1-4
[776.545316] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[776.557256] Starting dynamic subtest: pipe-B-eDP-1-4
[778.555261] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[778.565522] Starting dynamic subtest: pipe-B-eDP-1-x
[780.768662] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.212s)
[781.159812] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[783.948785] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.796s)
[783.961255] Starting dynamic subtest: pipe-C-eDP-1-4
[786.123961] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[786.135346] Starting dynamic subtest: pipe-C-eDP-1-4
[788.134073] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[788.146790] Starting dynamic subtest: pipe-C-eDP-1-x
[790.324320] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.189s)
[790.698008] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[793.450364] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.760s)
[793.461330] Starting dynamic subtest: pipe-D-eDP-1-4
[795.636326] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.185s)
[795.646889] Starting dynamic subtest: pipe-D-eDP-1-4
[797.646752] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.008s)
[797.658016] Starting dynamic subtest: pipe-D-eDP-1-x
[799.825399] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s)
[799.827597] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.063s)
[801.022452] [115/133] (229s left) gem_exec_fence (keep-in-fence)
[801.215704] Starting subtest: keep-in-fence
[801.218310] Starting dynamic subtest: rcs0
[801.291459] Dynamic subtest rcs0: SUCCESS (0.075s)
[801.304468] Starting dynamic subtest: bcs0
[801.345448] Dynamic subtest bcs0: SUCCESS (0.052s)
[801.358442] Starting dynamic subtest: vcs0
[802.616423] Dynamic subtest vcs0: SUCCESS (1.267s)
[802.629090] Starting dynamic subtest: vcs1
[804.599768] Dynamic subtest vcs1: SUCCESS (1.981s)
[804.613277] Starting dynamic subtest: vecs0
[806.647769] Dynamic subtest vecs0: SUCCESS (2.045s)
[806.660673] Starting dynamic subtest: ccs0
[806.883756] Dynamic subtest ccs0: SUCCESS (0.234s)
[806.886863] Subtest keep-in-fence: SUCCESS (5.668s)
[808.745252] [116/133] (222s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[808.801869] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[808.907116] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[809.002976] [117/133] (221s left) kms_properties (colorop-properties-legacy)
[809.098249] Starting subtest: colorop-properties-legacy
[809.100670] Starting dynamic subtest: pipe-A-eDP-1
[809.431534] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.334s)
[809.443209] Starting dynamic subtest: pipe-B-eDP-1
[810.548374] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.113s)
[810.559838] Starting dynamic subtest: pipe-C-eDP-1
[811.636774] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.089s)
[811.648886] Starting dynamic subtest: pipe-D-eDP-1
[812.738742] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.100s)
[812.741075] Subtest colorop-properties-legacy: SUCCESS (3.642s)
[813.627582] [118/133] (217s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[813.698235] Starting subtest: yf-tiled-to-vebox-yf-tiled
[813.702565] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[813.892664] [119/133] (216s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[813.953466] Starting subtest: wait-all-for-submit-delayed-submit
[814.055446] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[814.146933] [120/133] (216s left) prime_self_import (basic-with_one_bo)
[814.183009] Starting subtest: basic-with_one_bo
[814.208438] Subtest basic-with_one_bo: SUCCESS (0.027s)
[814.347340] [121/133] (216s left) gem_mmap_gtt (basic-small-copy)
[814.412571] Subtest basic-small-copy: SKIP (0.000s)
[814.489389] [122/133] (216s left) gem_exec_reloc (basic-cpu-read-noreloc)
[814.557013] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[814.655274] [123/133] (216s left) gem_exec_schedule (preempt-hang)
[814.836298] Starting subtest: preempt-hang
[814.839009] Starting dynamic subtest: rcs0
[815.063224] Dynamic subtest rcs0: SUCCESS (0.226s)
[815.074336] Starting dynamic subtest: bcs0
[815.286161] Dynamic subtest bcs0: SUCCESS (0.222s)
[815.297632] Starting dynamic subtest: vcs0
[815.511243] Dynamic subtest vcs0: SUCCESS (0.224s)
[815.527004] Starting dynamic subtest: vcs1
[815.734725] Dynamic subtest vcs1: SUCCESS (0.222s)
[815.747450] Starting dynamic subtest: vecs0
[815.959464] Dynamic subtest vecs0: SUCCESS (0.224s)
[815.971577] Starting dynamic subtest: ccs0
[816.203495] Dynamic subtest ccs0: SUCCESS (0.246s)
[816.205834] Subtest preempt-hang: SUCCESS (1.369s)
[816.767818] [124/133] (214s left) sysfs_preempt_timeout (timeout)
[816.845574] Starting subtest: timeout
[816.847948] Starting dynamic subtest: vecs0
[826.631477] Dynamic subtest vecs0: SUCCESS (9.781s)
[826.643980] Starting dynamic subtest: ccs0
[828.068640] Dynamic subtest ccs0: SUCCESS (1.436s)
[828.081186] Starting dynamic subtest: vcs0
[837.643463] Dynamic subtest vcs0: SUCCESS (9.569s)
[837.655833] Starting dynamic subtest: bcs0
[839.077712] Dynamic subtest bcs0: SUCCESS (1.433s)
[839.090408] Starting dynamic subtest: rcs0
[840.384981] Dynamic subtest rcs0: SUCCESS (1.305s)
[840.397907] Starting dynamic subtest: vcs1
[849.607864] Dynamic subtest vcs1: SUCCESS (9.218s)
[849.610242] Subtest timeout: SUCCESS (32.756s)
[849.707729] [125/133] (181s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[849.829768] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[849.834120] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[849.988512] [126/133] (181s left) kms_psr (psr2-cursor-render)
[850.077416] Starting subtest: psr2-cursor-render
[850.079789] Starting dynamic subtest: eDP-1
[851.760780] Dynamic subtest eDP-1: SUCCESS (1.684s)
[851.763137] Subtest psr2-cursor-render: SUCCESS (1.685s)
[852.623488] [127/133] (178s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[852.732265] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[852.736429] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[852.863457] [128/133] (178s left) kms_psr (fbc-pr-primary-blt)
[852.959089] Starting subtest: fbc-pr-primary-blt
[852.963287] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[853.047080] [129/133] (178s left) kms_fbcon_fbt (psr-suspend)
[853.108437] Starting subtest: psr-suspend
[904.246103] Subtest psr-suspend: SUCCESS (20.625s)
[905.352634] [130/133] (127s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[905.468146] Starting subtest: stress-xrgb8888-ytiled
[905.473246] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[905.563555] [131/133] (126s left) syncobj_eventfd (timeline-wait-signaled)
[905.627569] Starting subtest: timeline-wait-signaled
[905.629534] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[905.735769] [132/133] (126s left) kms_async_flips (test-time-stamp-atomic)
[905.825502] Starting subtest: test-time-stamp-atomic
[906.204553] Starting dynamic subtest: pipe-A-eDP-1
[906.966021] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.759s)
[907.343450] Starting dynamic subtest: pipe-B-eDP-1
[908.163464] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.826s)
[908.530904] Starting dynamic subtest: pipe-C-eDP-1
[909.358913] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.836s)
[909.736521] Starting dynamic subtest: pipe-D-eDP-1
[910.572043] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.844s)
[910.574485] Subtest test-time-stamp-atomic: SUCCESS (4.746s)
[911.808533] [133/133] (120s left) kms_plane_scaling (invalid-num-scalers)
[911.907096] Starting subtest: invalid-num-scalers
[911.909706] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[911.924372] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.018s)
[911.934823] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[911.958731] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.032s)
[911.971787] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[911.994250] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.032s)
[912.004459] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[912.026972] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.032s)
[912.029267] Subtest invalid-num-scalers: SUCCESS (0.122s)
[912.141368] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: kms_flip_scaled_crc
results: parsing output: 2/ for test: gem_exec_balancer
results: parsing output: 3/ for test: gem_ctx_shared
results: parsing output: 4/ for test: gen9_exec_parse
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_cursor_crc
results: parsing output: 7/ for test: gem_ctx_persistence
results: parsing output: 8/ for test: kms_plane
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_ccs
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: gem_mmap_gtt
results: parsing output: 14/ for test: gem_ctx_param
results: parsing output: 15/ for test: kms_pm_backlight
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_cursor_crc
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: sw_sync
results: parsing output: 22/ for test: syncobj_wait
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: perf_pmu
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_vblank
results: parsing output: 27/ for test: gem_pread
results: parsing output: 28/ for test: kms_chamelium_frames
results: parsing output: 29/ for test: kms_addfb_basic
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: gem_mmap_gtt
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: kms_flip
results: parsing output: 35/ for test: syncobj_timeline
results: parsing output: 36/ for test: kms_psr2_sf
results: parsing output: 37/ for test: gem_ctx_persistence
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_cursor_legacy
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: gem_ccs
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: kms_chamelium_hpd
results: parsing output: 45/ for test: gem_exec_flush
results: parsing output: 46/ for test: kms_pipe_b_c_ivb
results: parsing output: 47/ for test: gem_mmap_gtt
results: parsing output: 48/ for test: dmabuf_sync_file
results: parsing output: 49/ for test: i915_drm_fdinfo
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: gem_mmap_wc
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: kms_cursor_crc
results: parsing output: 55/ for test: kms_force_connector_basic
results: parsing output: 56/ for test: gem_lmem_swapping
results: parsing output: 57/ for test: kms_properties
results: parsing output: 58/ for test: kms_hdr
results: parsing output: 59/ for test: kms_lease
results: parsing output: 60/ for test: kms_invalid_mode
results: parsing output: 61/ for test: gem_softpin
results: parsing output: 62/ for test: kms_plane
results: parsing output: 63/ for test: kms_content_protection
results: parsing output: 64/ for test: kms_pm_rpm
results: parsing output: 65/ for test: syncobj_basic
results: parsing output: 66/ for test: kms_cursor_legacy
results: parsing output: 67/ for test: prime_mmap
results: parsing output: 68/ for test: perf
results: parsing output: 69/ for test: gem_eio
results: parsing output: 70/ for test: gem_exec_gttfill
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_color_pipeline
results: parsing output: 73/ for test: gem_userptr_blits
results: parsing output: 74/ for test: gem_exec_balancer
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: core_getclient
results: parsing output: 77/ for test: kms_vrr
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: i915_pm_rc6_residency
results: parsing output: 80/ for test: kms_chamelium_audio
results: parsing output: 81/ for test: kms_flip_scaled_crc
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: prime_vgem
results: parsing output: 84/ for test: i915_drm_fdinfo
results: parsing output: 85/ for test: gem_exec_schedule
results: parsing output: 86/ for test: gem_render_copy
results: parsing output: 87/ for test: perf_pmu
results: parsing output: 88/ for test: vgem_slow
results: parsing output: 89/ for test: i915_pm_rps
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_vrr
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_getfb
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: gem_softpin
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: kms_plane_scaling
results: parsing output: 104/ for test: gem_close_race
results: parsing output: 105/ for test: syncobj_wait
results: parsing output: 106/ for test: gem_wait
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: gem_exec_whisper
results: parsing output: 110/ for test: gem_ccs
results: parsing output: 111/ for test: kms_dsc
results: parsing output: 112/ for test: gem_mmap_offset
results: parsing output: 113/ for test: kms_async_flips
results: parsing output: 114/ for test: gem_exec_fence
results: parsing output: 115/ for test: syncobj_wait
results: parsing output: 116/ for test: kms_properties
results: parsing output: 117/ for test: gem_render_copy
results: parsing output: 118/ for test: syncobj_wait
results: parsing output: 119/ for test: prime_self_import
results: parsing output: 120/ for test: gem_mmap_gtt
results: parsing output: 121/ for test: gem_exec_reloc
results: parsing output: 122/ for test: gem_exec_schedule
results: parsing output: 123/ for test: sysfs_preempt_timeout
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_fbcon_fbt
results: parsing output: 129/ for test: kms_pipe_stress
results: parsing output: 130/ for test: syncobj_eventfd
results: parsing output: 131/ for test: kms_async_flips
results: parsing output: 132/ for test: kms_plane_scaling
Done.