[57.610357] Initializing watchdogs [57.610403] /dev/watchdog0 [57.624094] [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] [57.628551] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.630771] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.634184] [001/133] (960s left) kms_addfb_basic (bo-too-small) [57.748499] Starting subtest: bo-too-small [57.750321] Subtest bo-too-small: SUCCESS (0.000s) [57.852745] [002/133] (960s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling) [57.936642] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling [57.938958] Starting dynamic subtest: pipe-A-default-mode [59.108079] Dynamic subtest pipe-A-default-mode: SKIP (1.177s) [59.112296] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.178s) [59.250963] [003/133] (958s left) kms_dp_link_training (uhbr-mst) [59.345071] Starting subtest: uhbr-mst [59.353356] Subtest uhbr-mst: SKIP (0.000s) [59.426848] [004/133] (958s left) syncobj_wait (single-wait-submitted) [59.489656] Starting subtest: single-wait-submitted [59.594768] Subtest single-wait-submitted: SUCCESS (0.104s) [59.665839] [005/133] (958s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs) [59.725856] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs [59.730152] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s) [59.911929] [006/133] (958s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt) [60.003193] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt [60.007383] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [60.123566] [007/133] (958s left) kms_addfb_basic (bad-pitch-256) [60.187870] Starting subtest: bad-pitch-256 [60.189894] Subtest bad-pitch-256: SUCCESS (0.000s) [60.327318] [008/133] (958s left) gem_exec_reloc (basic-write-gtt-noreloc) [60.398290] Subtest basic-write-gtt-noreloc: SKIP (0.000s) [60.461693] [009/133] (957s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d) [60.561305] Starting subtest: plane-lut1d-ctm3x4-lut1d [60.707316] Starting dynamic subtest: pipe-A-plane-0 [60.861980] Dynamic subtest pipe-A-plane-0: SUCCESS (0.155s) [60.868525] Starting dynamic subtest: pipe-A-plane-1 [60.995100] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s) [61.001755] Starting dynamic subtest: pipe-A-plane-2 [61.149427] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s) [62.360479] Starting dynamic subtest: pipe-B-plane-0 [62.496857] Dynamic subtest pipe-B-plane-0: SUCCESS (0.145s) [62.505033] Starting dynamic subtest: pipe-B-plane-1 [62.629395] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s) [62.636376] Starting dynamic subtest: pipe-B-plane-2 [62.774062] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s) [63.966924] Starting dynamic subtest: pipe-C-plane-0 [64.125494] Dynamic subtest pipe-C-plane-0: SUCCESS (0.167s) [64.134298] Starting dynamic subtest: pipe-C-plane-1 [64.291618] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s) [64.299074] Starting dynamic subtest: pipe-C-plane-2 [64.435534] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s) [65.585554] Starting dynamic subtest: pipe-D-plane-0 [65.713300] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s) [65.721720] Starting dynamic subtest: pipe-D-plane-1 [65.846421] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s) [65.854626] Starting dynamic subtest: pipe-D-plane-2 [65.979392] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s) [66.267604] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (5.724s) [67.090755] [010/133] (951s left) gem_mmap_gtt (cpuset-medium-copy) [67.387818] Subtest cpuset-medium-copy: SKIP (0.000s) [67.646955] [011/133] (950s left) syncobj_wait (invalid-signal-bad-pad) [67.839184] Starting subtest: invalid-signal-bad-pad [67.841365] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [68.067599] [012/133] (950s left) kms_flip (plain-flip-interruptible) [68.168861] Starting subtest: plain-flip-interruptible [68.171245] Starting dynamic subtest: A-eDP1 [69.868145] Dynamic subtest A-eDP1: SUCCESS (1.701s) [69.878527] Starting dynamic subtest: B-eDP1 [71.498053] Dynamic subtest B-eDP1: SUCCESS (1.631s) [71.507968] Starting dynamic subtest: C-eDP1 [73.119816] Dynamic subtest C-eDP1: SUCCESS (1.622s) [73.132067] Starting dynamic subtest: D-eDP1 [74.996332] Dynamic subtest D-eDP1: SUCCESS (1.877s) [75.001701] Subtest plain-flip-interruptible: SUCCESS (6.840s) [76.163707] [013/133] (942s left) api_intel_allocator (simple-allocator) [76.229593] Starting subtest: simple-allocator [76.232064] Starting dynamic subtest: basic [76.234425] Dynamic subtest basic: SUCCESS (0.004s) [76.245984] Starting dynamic subtest: parallel-one [76.422703] Dynamic subtest parallel-one: SUCCESS (0.186s) [76.434073] Starting dynamic subtest: print [76.436324] Dynamic subtest print: SUCCESS (0.000s) [76.442753] Starting dynamic subtest: reuse [76.444677] Dynamic subtest reuse: SUCCESS (0.000s) [76.451067] Starting dynamic subtest: reserve [76.453045] Dynamic subtest reserve: SUCCESS (0.000s) [76.459291] Starting dynamic subtest: fork-reopen-allocator [76.461224] Dynamic subtest fork-reopen-allocator: SUCCESS (0.010s) [76.463207] Subtest simple-allocator: SUCCESS (0.203s) [76.559215] [014/133] (942s left) kms_big_fb (linear-64bpp-rotate-0) [76.664368] Starting subtest: linear-64bpp-rotate-0 [78.241308] Subtest linear-64bpp-rotate-0: SUCCESS (1.579s) [78.407130] [015/133] (940s left) gem_ctx_persistence (saturated-hostile) [78.464930] Starting subtest: saturated-hostile [78.466841] Starting dynamic subtest: rcs0 [79.272768] Dynamic subtest rcs0: SUCCESS (0.810s) [79.284032] Starting dynamic subtest: bcs0 [80.054429] Dynamic subtest bcs0: SUCCESS (0.780s) [80.064378] Starting dynamic subtest: vcs0 [80.844139] Dynamic subtest vcs0: SUCCESS (0.789s) [80.854590] Starting dynamic subtest: vcs1 [81.659415] Dynamic subtest vcs1: SUCCESS (0.814s) [81.668309] Starting dynamic subtest: vecs0 [82.455014] Dynamic subtest vecs0: SUCCESS (0.794s) [82.467474] Starting dynamic subtest: ccs0 [83.298091] Dynamic subtest ccs0: SUCCESS (0.842s) [83.300980] Subtest saturated-hostile: SUCCESS (4.835s) [83.394762] [016/133] (935s left) gem_softpin (evict-single-offset) [83.464983] Starting subtest: evict-single-offset [111.895040] Subtest evict-single-offset: SUCCESS (28.426s) [111.973679] [017/133] (906s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted) [112.084726] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted [112.087086] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s) [112.195576] [018/133] (906s left) syncobj_basic (create-signaled) [112.255891] Starting subtest: create-signaled [112.258173] Subtest create-signaled: SUCCESS (0.000s) [112.347310] [019/133] (906s left) kms_fbcon_fbt (psr-suspend) [112.401207] Starting subtest: psr-suspend [162.433042] Subtest psr-suspend: SUCCESS (20.047s) [162.507362] [020/133] (856s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k) [162.891467] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s) [163.713489] [021/133] (855s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic) [163.827083] Starting subtest: 2x-long-cursor-vs-flip-atomic [163.831436] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s) [163.967016] [022/133] (854s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled) [164.017679] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [164.019521] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s) [164.126100] [023/133] (854s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset) [164.216109] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset [164.227174] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.010s) [164.315459] [024/133] (854s left) gem_ctx_persistence (engines-persistence) [164.381295] Starting subtest: engines-persistence [164.383671] Starting dynamic subtest: rcs0 [165.205570] Dynamic subtest rcs0: SUCCESS (0.836s) [165.217418] Starting dynamic subtest: bcs0 [165.976713] Dynamic subtest bcs0: SUCCESS (0.781s) [165.987432] Starting dynamic subtest: vcs0 [166.730148] Dynamic subtest vcs0: SUCCESS (0.761s) [166.742676] Starting dynamic subtest: vcs1 [167.504912] Dynamic subtest vcs1: SUCCESS (0.781s) [167.516277] Starting dynamic subtest: vecs0 [168.262979] Dynamic subtest vecs0: SUCCESS (0.764s) [168.274142] Starting dynamic subtest: ccs0 [169.045577] Dynamic subtest ccs0: SUCCESS (0.788s) [169.048181] Subtest engines-persistence: SUCCESS (4.719s) [169.122024] [025/133] (849s left) gem_pwrite (basic-self) [169.190160] Subtest basic-self: SKIP (0.000s) [169.247499] [026/133] (849s left) kms_frontbuffer_tracking (psr-1p-rte) [169.355530] Starting subtest: psr-1p-rte [174.756935] Subtest psr-1p-rte: SUCCESS (5.439s) [174.889970] [027/133] (844s left) api_intel_bb (render) [174.940159] Starting subtest: render [174.942154] Starting dynamic subtest: render-none-512 [175.042723] Dynamic subtest render-none-512: SUCCESS (0.105s) [175.053384] Starting dynamic subtest: render-none-1024 [175.421659] Dynamic subtest render-none-1024: SUCCESS (0.378s) [175.432791] Starting dynamic subtest: render-x-512 [175.512052] Dynamic subtest render-x-512: SUCCESS (0.090s) [175.522975] Starting dynamic subtest: render-x-1024 [175.846263] Dynamic subtest render-x-1024: SUCCESS (0.334s) [175.857620] Starting dynamic subtest: render-y-512 [175.932493] Dynamic subtest render-y-512: SUCCESS (0.087s) [175.943054] Starting dynamic subtest: render-y-1024 [176.267101] Dynamic subtest render-y-1024: SUCCESS (0.334s) [176.269954] Subtest render: SUCCESS (1.332s) [176.388575] [028/133] (842s left) kms_psr2_su (frontbuffer-xrgb8888) [176.446318] Subtest frontbuffer-XRGB8888: SKIP (0.000s) [176.514603] [029/133] (842s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [176.613539] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [176.617905] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [176.704407] [030/133] (842s left) i915_drm_fdinfo (memory-info-resident) [176.744791] Starting subtest: memory-info-resident [176.747022] Starting dynamic subtest: smem0 [179.306581] Dynamic subtest smem0: SUCCESS (2.571s) [179.308844] Subtest memory-info-resident: SUCCESS (2.572s) [179.382472] [031/133] (839s left) dmabuf_sync_file (export-before-signal) [179.500818] Starting subtest: export-before-signal [179.502764] Subtest export-before-signal: SUCCESS (0.001s) [179.554885] [FACT dmabuf_sync_file (export-before-signal)] new: kernel.kmod_is_loaded.vgem: true [179.557455] [032/133] (839s left) vgem_basic (second-client) [179.600452] Starting subtest: second-client [179.622395] Subtest second-client: SUCCESS (0.022s) [179.678628] [033/133] (839s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf) [179.782771] Starting subtest: fbc-psr2-cursor-plane-update-sf [179.784681] Starting dynamic subtest: pipe-A-eDP-1 [179.857287] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s) [179.867169] Starting dynamic subtest: pipe-B-eDP-1 [181.032857] Dynamic subtest pipe-B-eDP-1: SKIP (1.176s) [181.037093] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.256s) [182.213746] [034/133] (837s left) kms_rotation_crc (bad-pixel-format) [182.310769] Starting subtest: bad-pixel-format [182.315164] Subtest bad-pixel-format: SKIP (0.001s) [182.380480] [035/133] (837s left) kms_cursor_crc (cursor-rapid-movement-32x32) [182.520988] Starting subtest: cursor-rapid-movement-32x32 [182.568058] Subtest cursor-rapid-movement-32x32: SKIP (0.041s) [182.878333] [036/133] (836s left) kms_frontbuffer_tracking (fbc-tiling-linear) [182.965441] Starting subtest: fbc-tiling-linear [186.625078] Subtest fbc-tiling-linear: SUCCESS (3.668s) [187.817500] [037/133] (831s left) gem_userptr_blits (usage-restrictions) [187.871448] Starting subtest: usage-restrictions [187.873328] Subtest usage-restrictions: SUCCESS (0.000s) [187.992170] [038/133] (831s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier) [188.087423] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier [188.115438] Starting dynamic subtest: pipe-A-plane-0 [188.559056] Dynamic subtest pipe-A-plane-0: SUCCESS (0.444s) [188.568631] Starting dynamic subtest: pipe-A-plane-3 [188.814016] Dynamic subtest pipe-A-plane-3: SUCCESS (0.254s) [188.822998] Starting dynamic subtest: pipe-A-plane-5 [188.826416] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [189.897574] Starting dynamic subtest: pipe-B-plane-0 [190.322667] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s) [190.336670] Starting dynamic subtest: pipe-B-plane-3 [190.578522] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s) [190.587851] Starting dynamic subtest: pipe-B-plane-5 [190.592325] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [190.892361] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.807s) [191.712616] [039/133] (827s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes) [192.252970] Starting subtest: syncobj-timeline-multiple-ext-nodes [192.255536] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.003s) [193.166025] [040/133] (826s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite) [193.257315] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite [193.261619] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [193.357659] [041/133] (826s left) gem_exec_schedule (semaphore-user) [193.432196] Starting subtest: semaphore-user [193.481283] Subtest semaphore-user: SUCCESS (0.057s) [195.145753] [042/133] (824s left) gem_exec_gttfill (all-engines) [195.208011] Starting subtest: all-engines [218.396676] Subtest all-engines: SUCCESS (23.182s) [218.586694] [043/133] (801s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes) [218.676955] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s) [218.736467] [044/133] (801s left) prime_mmap (test_forked_cpu_write) [218.794034] Starting subtest: test_forked_cpu_write [218.796267] Starting dynamic subtest: test_forked_cpu_write-smem [218.800974] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.006s) [218.803267] Subtest test_forked_cpu_write: SUCCESS (0.007s) [218.900904] [045/133] (800s left) gem_ctx_engines (invalid-engines) [218.959823] Starting subtest: invalid-engines [218.970520] Subtest invalid-engines: SUCCESS (0.011s) [219.207396] [046/133] (800s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu) [219.306749] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu [219.311058] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [219.418933] [047/133] (800s left) gem_mmap_offset (partial-unmap) [219.475968] Starting subtest: partial-unmap [219.478083] Starting dynamic subtest: smem0 [219.979740] Dynamic subtest smem0: SUCCESS (0.504s) [219.982307] Subtest partial-unmap: SUCCESS (0.504s) [220.094518] [048/133] (799s left) syncobj_basic (bad-pad-fd-to-handle) [220.145738] Starting subtest: bad-pad-fd-to-handle [220.147810] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [220.242033] [049/133] (799s left) i915_pm_rc6_residency (media-rc6-accuracy) [220.295971] Starting subtest: media-rc6-accuracy [220.300286] Subtest media-rc6-accuracy: SKIP (0.000s) [220.377635] [050/133] (799s left) kms_psr (pr-sprite-mmap-cpu) [220.474008] Starting subtest: pr-sprite-mmap-cpu [220.478433] Subtest pr-sprite-mmap-cpu: SKIP (0.000s) [220.562412] [051/133] (799s left) perf_pmu (busy-idle) [220.607021] Starting subtest: busy-idle [220.609999] Starting dynamic subtest: rcs0 [221.300261] Dynamic subtest rcs0: SUCCESS (0.693s) [221.316495] Starting dynamic subtest: bcs0 [221.965297] Dynamic subtest bcs0: SUCCESS (0.664s) [221.977516] Starting dynamic subtest: vcs0 [223.125328] Dynamic subtest vcs0: SUCCESS (1.157s) [223.137321] Starting dynamic subtest: vcs1 [225.108565] Dynamic subtest vcs1: SUCCESS (1.981s) [225.123011] Starting dynamic subtest: vecs0 [227.092743] Dynamic subtest vecs0: SUCCESS (1.982s) [227.104915] Starting dynamic subtest: ccs0 [227.758866] Dynamic subtest ccs0: SUCCESS (0.666s) [227.761431] Subtest busy-idle: SUCCESS (7.154s) [227.857276] [052/133] (792s left) gem_pxp (verify-pxp-stale-buf-execution) [227.981106] Starting subtest: verify-pxp-stale-buf-execution [229.047771] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.068s) [229.189816] [053/133] (791s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs) [229.296702] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs [229.298891] Starting dynamic subtest: pipe-A-eDP-1 [229.307807] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [229.317678] Starting dynamic subtest: pipe-B-eDP-1 [229.326535] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [229.335773] Starting dynamic subtest: pipe-C-eDP-1 [229.344196] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [229.352803] Starting dynamic subtest: pipe-D-eDP-1 [229.361676] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [229.365981] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.004s) [231.474719] [054/133] (788s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt) [231.573004] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt [238.832755] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.266s) [238.987364] [055/133] (781s left) kms_vblank (wait-forked-hang) [239.094926] Starting subtest: wait-forked-hang [239.097135] Starting dynamic subtest: pipe-A-eDP-1 [265.943217] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.850s) [265.957940] Starting dynamic subtest: pipe-D-eDP-1 [290.899996] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.950s) [290.902116] Subtest wait-forked-hang: SUCCESS (51.805s) [291.726865] [056/133] (728s left) kms_content_protection (atomic-dpms-hdcp14) [291.881428] Starting subtest: atomic-dpms-hdcp14 [291.886273] Subtest atomic-dpms-hdcp14: SKIP (0.000s) [292.016837] [057/133] (728s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc) [292.108584] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc [292.110953] Starting dynamic subtest: pipe-A-eDP-1 [292.136603] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [292.147364] Starting dynamic subtest: pipe-B-eDP-1 [292.171510] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [292.180712] Starting dynamic subtest: pipe-C-eDP-1 [292.205438] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [292.214120] Starting dynamic subtest: pipe-D-eDP-1 [292.239081] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [292.243184] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [294.391065] [058/133] (726s left) syncobj_wait (reset-multiple-signaled) [294.456129] Starting subtest: reset-multiple-signaled [294.458525] Subtest reset-multiple-signaled: SUCCESS (0.000s) [294.531888] [059/133] (725s left) syncobj_wait (single-wait-for-submit-submitted) [294.583980] Starting subtest: single-wait-for-submit-submitted [294.689807] Subtest single-wait-for-submit-submitted: SUCCESS (0.105s) [294.765168] [060/133] (725s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render) [294.868885] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render [294.873311] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [294.954476] [061/133] (725s left) kms_big_fb (x-tiled-32bpp-rotate-270) [295.054898] Starting subtest: x-tiled-32bpp-rotate-270 [295.074907] Subtest x-tiled-32bpp-rotate-270: SKIP (0.020s) [295.190922] [062/133] (725s left) kms_pipe_crc_basic (hang-read-crc) [295.299323] Starting subtest: hang-read-crc [295.301720] Starting dynamic subtest: pipe-A-eDP-1 [297.468742] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.168s) [297.479299] Starting dynamic subtest: pipe-B-eDP-1 [300.152930] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.683s) [300.162808] Starting dynamic subtest: pipe-C-eDP-1 [302.841456] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.690s) [302.851741] Starting dynamic subtest: pipe-D-eDP-1 [305.507918] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.665s) [305.510328] Subtest hang-read-crc: SUCCESS (10.212s) [306.368677] [063/133] (714s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy) [306.494500] Starting subtest: 2x-long-flip-vs-cursor-legacy [306.498886] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s) [306.641599] [064/133] (714s left) gem_flink_basic (bad-flink) [306.693297] Starting subtest: bad-flink [306.695476] Subtest bad-flink: SUCCESS (0.000s) [306.782542] [065/133] (713s left) syncobj_timeline (single-wait-all-for-submit-signaled) [306.845630] Starting subtest: single-wait-all-for-submit-signaled [306.847972] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [306.965948] [066/133] (713s left) gem_lmem_swapping (heavy-verify-random) [307.011481] Subtest heavy-verify-random: SKIP (0.000s) [307.060326] [067/133] (713s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt) [307.167039] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt [311.592736] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.431s) [312.766686] [068/133] (708s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling) [312.868478] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling [312.870799] Starting dynamic subtest: pipe-A-default-mode [314.034686] Dynamic subtest pipe-A-default-mode: SKIP (1.159s) [314.038825] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.160s) [314.187167] [069/133] (706s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [314.297960] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip [314.302271] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [314.416404] [070/133] (706s left) gem_exec_alignment (forked) [314.485198] Starting subtest: forked [353.366887] Subtest forked: SUCCESS (38.886s) [353.493650] [071/133] (667s left) gem_exec_whisper (basic-contexts-all) [353.590942] Starting subtest: basic-contexts-all [365.489816] Subtest basic-contexts-all: SUCCESS (11.897s) [365.674561] [072/133] (655s left) kms_big_fb (4-tiled-32bpp-rotate-90) [365.784794] Starting subtest: 4-tiled-32bpp-rotate-90 [365.805210] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s) [365.921316] [073/133] (655s left) gem_exec_await (wide-contexts) [366.152896] Starting subtest: wide-contexts [388.831748] Subtest wide-contexts: SUCCESS (22.680s) [389.024393] [074/133] (632s left) drm_read (invalid-buffer) [389.243023] Starting subtest: invalid-buffer [389.245414] Subtest invalid-buffer: SUCCESS (0.000s) [389.368196] [075/133] (631s left) gem_userptr_blits (stress-mm) [389.431610] Starting subtest: stress-mm [394.804536] Subtest stress-mm: SUCCESS (5.370s) [394.946814] [076/133] (626s left) kms_atomic_transition (plane-all-transition-fencing) [395.046120] Starting subtest: plane-all-transition-fencing [395.048156] Starting dynamic subtest: pipe-A-eDP-1 [397.550772] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.507s) [397.870303] Starting dynamic subtest: pipe-B-eDP-1 [401.132559] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.271s) [401.429914] Subtest plane-all-transition-fencing: SUCCESS (6.385s) [402.246019] [077/133] (618s left) gem_pread (snoop) [402.316849] Subtest snoop: SKIP (0.000s) [402.385320] [078/133] (618s left) kms_chamelium_hpd (dp-hpd-for-each-pipe) [402.768818] Subtest dp-hpd-for-each-pipe: SKIP (0.000s) [403.558509] [079/133] (617s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt) [403.649449] Starting subtest: psr-rgb101010-draw-blt [410.980964] Subtest psr-rgb101010-draw-blt: SUCCESS (7.333s) [411.110702] [080/133] (610s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [411.206509] Starting subtest: addfb25-y-tiled-small-legacy [411.210791] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [411.299542] [081/133] (610s left) gem_exec_params (rel-constants-invalid-rel-gen5) [411.357788] Starting subtest: rel-constants-invalid-rel-gen5 [411.360182] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s) [411.467364] [082/133] (609s left) kms_async_flips (crc-atomic) [411.562031] Starting subtest: crc-atomic [411.932486] Starting dynamic subtest: pipe-A-eDP-1 [414.827819] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.893s) [415.207333] Starting dynamic subtest: pipe-B-eDP-1 [418.067128] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.869s) [418.447403] Starting dynamic subtest: pipe-C-eDP-1 [421.371751] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.934s) [421.746507] Starting dynamic subtest: pipe-D-eDP-1 [424.599537] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.864s) [424.601659] Subtest crc-atomic: SUCCESS (13.037s) [425.789362] [083/133] (595s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render) [425.895907] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render [429.977265] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.084s) [431.170481] [084/133] (590s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render) [431.271462] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render [431.275347] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [431.371653] [085/133] (590s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs) [431.454897] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs [431.457134] Starting dynamic subtest: pipe-A-eDP-1 [431.478682] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [431.489262] Starting dynamic subtest: pipe-B-eDP-1 [431.509593] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [431.518468] Starting dynamic subtest: pipe-C-eDP-1 [431.538715] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [431.547621] Starting dynamic subtest: pipe-D-eDP-1 [431.568369] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [431.572533] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.004s) [433.727288] [086/133] (587s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc) [433.826600] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc [433.830999] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [433.922841] [087/133] (587s left) kms_cursor_legacy (flip-vs-cursor-atomic) [434.044670] Starting subtest: flip-vs-cursor-atomic [441.449943] Subtest flip-vs-cursor-atomic: SUCCESS (7.403s) [442.251202] [088/133] (579s left) kms_lease (implicit-plane-lease) [442.359531] Starting subtest: implicit-plane-lease [442.361453] Subtest implicit-plane-lease: SUCCESS (0.003s) [442.465899] [089/133] (579s left) gem_exec_capture (capture) [442.522133] Starting subtest: capture [442.524340] Starting dynamic subtest: rcs0-smem [443.356684] Dynamic subtest rcs0-smem: SUCCESS (0.834s) [443.368506] Starting dynamic subtest: bcs0-smem [444.393937] Dynamic subtest bcs0-smem: SUCCESS (1.035s) [444.404671] Starting dynamic subtest: vcs0-smem [445.214924] Dynamic subtest vcs0-smem: SUCCESS (0.820s) [445.224066] Starting dynamic subtest: vcs1-smem [446.030823] Dynamic subtest vcs1-smem: SUCCESS (0.817s) [446.040074] Starting dynamic subtest: vecs0-smem [447.422675] Dynamic subtest vecs0-smem: FAIL (1.333s) [447.433646] Starting dynamic subtest: ccs0-smem [448.684581] Dynamic subtest ccs0-smem: SUCCESS (1.319s) [448.686934] Subtest capture: FAIL (6.163s) [448.815631] [090/133] (572s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc) [448.906344] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc [448.908620] Starting dynamic subtest: pipe-A-eDP-1 [448.917524] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [448.930083] Starting dynamic subtest: pipe-B-eDP-1 [448.939160] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [448.948427] Starting dynamic subtest: pipe-C-eDP-1 [448.956845] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [448.966032] Starting dynamic subtest: pipe-D-eDP-1 [448.975760] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [448.980188] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s) [451.118526] [091/133] (570s left) kms_cursor_crc (cursor-alpha-transparent) [451.215388] Starting subtest: cursor-alpha-transparent [451.217680] Starting dynamic subtest: pipe-A-eDP-1 [451.833686] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.619s) [451.844591] Starting dynamic subtest: pipe-D-eDP-1 [453.091205] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.256s) [453.093365] Subtest cursor-alpha-transparent: SUCCESS (1.878s) [453.896816] [092/133] (567s left) i915_drm_fdinfo (virtual-busy-idle-all) [453.943510] Starting subtest: virtual-busy-idle-all [453.947841] Subtest virtual-busy-idle-all: SKIP (0.000s) [454.017038] [093/133] (567s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled) [454.071174] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled [454.179062] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.104s) [454.256613] [094/133] (567s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping) [454.342115] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping [454.346243] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s) [454.430269] [095/133] (567s left) kms_joiner (basic-force-ultra-joiner) [454.530756] Starting subtest: basic-force-ultra-joiner [454.534931] Subtest basic-force-ultra-joiner: SKIP (0.000s) [454.597358] [096/133] (567s left) kms_flip (plain-flip-fb-recreate-interruptible) [454.683608] Starting subtest: plain-flip-fb-recreate-interruptible [454.686061] Starting dynamic subtest: A-eDP1 [463.589523] Dynamic subtest A-eDP1: SUCCESS (8.905s) [463.600292] Starting dynamic subtest: B-eDP1 [472.430086] Dynamic subtest B-eDP1: SUCCESS (8.839s) [472.440301] Starting dynamic subtest: C-eDP1 [481.247464] Dynamic subtest C-eDP1: SUCCESS (8.816s) [481.259944] Starting dynamic subtest: D-eDP1 [490.074056] Dynamic subtest D-eDP1: SUCCESS (8.824s) [490.078251] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.394s) [491.259890] [097/133] (530s left) kms_pm_rpm (pm-caching) [493.296999] Starting subtest: pm-caching [493.302403] Subtest pm-caching: SKIP (0.000s) [493.673105] [098/133] (528s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt) [493.777872] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt [493.782601] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [493.877340] [099/133] (528s left) kms_selftest (drm_format_helper) [493.919095] Starting subtest: drm_format_helper [493.942704] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8 [494.074089] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.132s) [494.084679] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332 [494.188759] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.112s) [494.199468] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565 [494.279666] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.091s) [494.290297] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555 [494.404346] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.123s) [494.414248] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555 [494.506789] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.102s) [494.516003] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551 [494.600616] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.094s) [494.610241] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888 [494.709500] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.107s) [494.718576] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888 [494.825718] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.115s) [494.835387] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888 [494.918211] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.091s) [494.927618] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010 [495.022338] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.104s) [495.032020] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010 [495.124919] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.101s) [495.134402] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono [495.224023] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.097s) [495.233720] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab [495.316672] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.094s) [495.327846] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888 [495.411891] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.092s) [495.420731] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888 [495.499950] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.088s) [495.508946] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset [495.593377] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.092s) [495.603327] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy [495.688200] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.095s) [495.689970] Subtest drm_format_helper: SUCCESS (1.769s) [495.838097] [100/133] (526s left) kms_psr (fbc-psr-cursor-mmap-gtt) [495.926563] Starting subtest: fbc-psr-cursor-mmap-gtt [495.928495] Starting dynamic subtest: eDP-1 [495.931859] Dynamic subtest eDP-1: SKIP (0.000s) [495.935290] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s) [496.014414] [101/133] (526s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled) [496.066200] Starting subtest: invalid-multi-wait-unsubmitted-signaled [496.068127] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.001s) [496.168172] [102/133] (526s left) gem_fence_thrash (bo-copy) [496.204520] Starting subtest: bo-copy [496.224374] Subtest bo-copy: SKIP (0.020s) [496.280585] [103/133] (526s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all) [496.332183] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all [496.390436] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.010s) [496.429542] [104/133] (525s left) sysfs_timeslice_duration (duration) [496.484262] Starting subtest: duration [496.486356] Starting dynamic subtest: vecs0 [510.003425] Dynamic subtest vecs0: SUCCESS (13.517s) [510.016784] Starting dynamic subtest: ccs0 [523.146097] Dynamic subtest ccs0: SUCCESS (13.143s) [523.158078] Starting dynamic subtest: vcs0 [537.012647] Dynamic subtest vcs0: SUCCESS (13.864s) [537.025078] Starting dynamic subtest: bcs0 [550.143322] Dynamic subtest bcs0: SUCCESS (13.131s) [550.157136] Starting dynamic subtest: rcs0 [563.274050] Dynamic subtest rcs0: SUCCESS (13.130s) [563.287325] Starting dynamic subtest: vcs1 [577.074683] Dynamic subtest vcs1: SUCCESS (13.799s) [577.077461] Subtest duration: SUCCESS (80.600s) [577.159063] [105/133] (445s left) gen7_exec_parse (basic-allowed) [577.233807] Subtest basic-allowed: SKIP (0.000s) [577.311978] [106/133] (445s left) gem_exec_balancer (hang) [577.581633] Starting subtest: hang [579.621174] Subtest hang: SUCCESS (2.043s) [579.729952] [107/133] (442s left) gem_mmap_gtt (basic-write-gtt) [579.789930] Subtest basic-write-gtt: SKIP (0.000s) [579.858429] [108/133] (442s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs) [579.957425] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs [579.959698] Starting dynamic subtest: pipe-A-eDP-1 [579.982858] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [579.995612] Starting dynamic subtest: pipe-B-eDP-1 [580.016600] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [580.026465] Starting dynamic subtest: pipe-C-eDP-1 [580.047924] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [580.057396] Starting dynamic subtest: pipe-D-eDP-1 [580.079385] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [580.083467] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.004s) [582.215649] [109/133] (440s left) fbdev (eof) [582.264235] Starting subtest: eof [582.266626] Subtest eof: SUCCESS (0.000s) [582.339801] [110/133] (440s left) gen7_exec_parse (cmd-crossing-page) [582.413138] Subtest cmd-crossing-page: SKIP (0.000s) [582.493642] [111/133] (440s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation) [582.579835] Starting subtest: plane-scaler-unity-scaling-with-rotation [582.582063] Starting dynamic subtest: pipe-A [582.806879] Dynamic subtest pipe-A: SUCCESS (0.228s) [582.817584] Starting dynamic subtest: pipe-B [584.078703] Dynamic subtest pipe-B: SUCCESS (1.271s) [584.094917] Starting dynamic subtest: pipe-C [585.434906] Dynamic subtest pipe-C: SUCCESS (1.354s) [585.445460] Starting dynamic subtest: pipe-D [586.743819] Dynamic subtest pipe-D: SUCCESS (1.307s) [586.746310] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.167s) [587.940203] [112/133] (434s left) gem_userptr_blits (sync-unmap-after-close) [588.017842] Starting subtest: sync-unmap-after-close [588.027953] Subtest sync-unmap-after-close: SUCCESS (0.010s) [588.143894] [113/133] (434s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move) [588.238574] Starting subtest: fbc-2p-scndscrn-spr-indfb-move [588.242692] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [588.334033] [114/133] (434s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move) [588.430603] Starting subtest: psr-2p-scndscrn-cur-indfb-move [588.434945] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [588.535751] [115/133] (434s left) kms_properties (colorop-properties-legacy) [588.620542] Starting subtest: colorop-properties-legacy [588.622887] Starting dynamic subtest: pipe-A-eDP-1 [588.988205] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.364s) [589.001597] Starting dynamic subtest: pipe-B-eDP-1 [590.107031] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.117s) [590.121429] Starting dynamic subtest: pipe-C-eDP-1 [591.143684] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.036s) [591.155291] Starting dynamic subtest: pipe-D-eDP-1 [592.170439] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.028s) [592.172819] Subtest colorop-properties-legacy: SUCCESS (3.551s) [592.979937] [116/133] (429s left) gem_partial_pwrite_pread (reads-uncached) [593.044432] Subtest reads-uncached: SKIP (0.000s) [593.112835] [117/133] (429s left) syncobj_timeline (etime-single-wait-available-unsubmitted) [593.170216] Starting subtest: etime-single-wait-available-unsubmitted [593.272094] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.102s) [593.350687] [118/133] (429s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5) [593.437990] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5 [593.440313] Starting dynamic subtest: pipe-A [593.457501] Dynamic subtest pipe-A: SKIP (0.017s) [593.468288] Starting dynamic subtest: pipe-B [593.488714] Dynamic subtest pipe-B: SKIP (0.029s) [593.498966] Starting dynamic subtest: pipe-C [593.518917] Dynamic subtest pipe-C: SKIP (0.029s) [593.528969] Starting dynamic subtest: pipe-D [593.548050] Dynamic subtest pipe-D: SKIP (0.029s) [593.551801] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.107s) [593.659431] [119/133] (429s left) kms_psr (psr-sprite-blt) [593.752334] Starting subtest: psr-sprite-blt [593.754592] Starting dynamic subtest: eDP-1 [595.478387] Dynamic subtest eDP-1: SUCCESS (1.727s) [595.480876] Subtest psr-sprite-blt: SUCCESS (1.728s) [596.312004] [120/133] (426s left) perf (gen12-unprivileged-single-ctx-counters) [596.466145] Starting subtest: gen12-unprivileged-single-ctx-counters [596.468384] Starting dynamic subtest: rcs0 [596.579493] Dynamic subtest rcs0: SUCCESS (0.113s) [596.581697] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.114s) [596.624413] [121/133] (426s left) gem_exec_schedule (preempt-engines) [596.728640] Starting subtest: preempt-engines [596.730862] Starting dynamic subtest: rcs0 [598.970605] Dynamic subtest rcs0: SUCCESS (2.246s) [599.002927] Starting dynamic subtest: bcs0 [601.254276] Dynamic subtest bcs0: SUCCESS (2.281s) [601.269044] Starting dynamic subtest: vcs0 [603.613322] Dynamic subtest vcs0: SUCCESS (2.358s) [603.622935] Starting dynamic subtest: vcs1 [605.896895] Dynamic subtest vcs1: SUCCESS (2.282s) [605.913398] Starting dynamic subtest: vecs0 [608.162702] Dynamic subtest vecs0: SUCCESS (2.265s) [608.175907] Starting dynamic subtest: ccs0 [610.488083] Dynamic subtest ccs0: SUCCESS (2.322s) [610.490999] Subtest preempt-engines: SUCCESS (13.767s) [610.794375] [122/133] (412s left) gem_exec_reloc (basic-gtt-wc-active) [610.857048] Subtest basic-gtt-wc-active: SKIP (0.000s) [610.945009] [123/133] (412s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180) [611.049585] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180 [612.128098] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.079s) [612.241269] [124/133] (410s left) i915_query (query-regions-garbage-items) [612.295660] Starting subtest: query-regions-garbage-items [612.297245] Subtest query-regions-garbage-items: SUCCESS (0.000s) [612.398600] [125/133] (410s left) kms_psr (psr2-cursor-render) [612.492460] Starting subtest: psr2-cursor-render [612.494373] Starting dynamic subtest: eDP-1 [614.198015] Dynamic subtest eDP-1: SUCCESS (1.706s) [614.200302] Subtest psr2-cursor-render: SUCCESS (1.707s) [615.071522] [126/133] (408s left) kms_psr (fbc-psr2-primary-mmap-cpu) [615.165757] Starting subtest: fbc-psr2-primary-mmap-cpu [615.168044] Starting dynamic subtest: eDP-1 [615.172181] Dynamic subtest eDP-1: SKIP (0.000s) [615.176292] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s) [615.258887] [127/133] (408s left) gem_render_copy (linear) [615.319542] Starting subtest: linear [615.321746] Starting dynamic subtest: smem [615.358239] Dynamic subtest smem: SUCCESS (0.038s) [615.360697] Subtest linear: SUCCESS (0.039s) [615.548387] [128/133] (407s left) kms_pm_rpm (dpms-mode-unset-lpsp) [617.274730] Starting subtest: dpms-mode-unset-lpsp [621.358090] Subtest dpms-mode-unset-lpsp: SUCCESS (4.087s) [621.736154] [129/133] (401s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu) [621.840164] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu [628.321248] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.483s) [628.436670] [130/133] (395s left) kms_cursor_edge_walk (128x128-top-edge) [628.526378] Starting subtest: 128x128-top-edge [628.528719] Starting dynamic subtest: pipe-A-eDP-1 [632.000607] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.474s) [632.011401] Starting dynamic subtest: pipe-D-eDP-1 [635.151173] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.149s) [635.153389] Subtest 128x128-top-edge: SUCCESS (6.626s) [635.963692] [131/133] (387s left) kms_draw_crc (draw-method-render) [636.055536] Starting subtest: draw-method-render [636.057510] Starting dynamic subtest: xrgb8888-untiled [636.284587] Dynamic subtest xrgb8888-untiled: SUCCESS (0.232s) [636.295136] Starting dynamic subtest: rgb565-untiled [636.506997] Dynamic subtest rgb565-untiled: SUCCESS (0.222s) [636.517621] Starting dynamic subtest: xrgb2101010-untiled [636.729169] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s) [636.739841] Starting dynamic subtest: xbgr16161616f-untiled [636.950953] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s) [636.960781] Starting dynamic subtest: xrgb8888-xtiled [637.062048] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.110s) [637.071721] Starting dynamic subtest: rgb565-xtiled [637.173196] Dynamic subtest rgb565-xtiled: SUCCESS (0.110s) [637.183038] Starting dynamic subtest: xrgb2101010-xtiled [637.284304] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s) [637.294604] Starting dynamic subtest: xbgr16161616f-xtiled [637.417576] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s) [637.429488] Starting dynamic subtest: xrgb8888-4tiled [637.539895] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.120s) [637.551878] Starting dynamic subtest: rgb565-4tiled [637.651085] Dynamic subtest rgb565-4tiled: SUCCESS (0.109s) [637.662804] Starting dynamic subtest: xrgb2101010-4tiled [637.762489] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.109s) [637.774800] Starting dynamic subtest: xbgr16161616f-4tiled [637.895354] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.132s) [637.897309] Subtest draw-method-render: SUCCESS (1.844s) [638.003259] [132/133] (385s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip) [638.097310] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip [638.101074] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [638.200214] [133/133] (385s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [638.301393] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc [638.305112] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [638.398295] Closing watchdogs results: parsing output: 0/ for test: kms_addfb_basic results: parsing output: 1/ for test: kms_flip_scaled_crc results: parsing output: 2/ for test: kms_dp_link_training results: parsing output: 3/ for test: syncobj_wait results: parsing output: 4/ for test: gem_render_copy results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: kms_addfb_basic results: parsing output: 7/ for test: gem_exec_reloc results: parsing output: 8/ for test: kms_color_pipeline results: parsing output: 9/ for test: gem_mmap_gtt results: parsing output: 10/ for test: syncobj_wait results: parsing output: 11/ for test: kms_flip results: parsing output: 12/ for test: api_intel_allocator results: parsing output: 13/ for test: kms_big_fb results: parsing output: 14/ for test: gem_ctx_persistence results: parsing output: 15/ for test: gem_softpin results: parsing output: 16/ for test: syncobj_timeline results: parsing output: 17/ for test: syncobj_basic results: parsing output: 18/ for test: kms_fbcon_fbt results: parsing output: 19/ for test: kms_chamelium_edid results: parsing output: 20/ for test: kms_cursor_legacy results: parsing output: 21/ for test: syncobj_wait results: parsing output: 22/ for test: kms_flip results: parsing output: 23/ for test: gem_ctx_persistence results: parsing output: 24/ for test: gem_pwrite results: parsing output: 25/ for test: kms_frontbuffer_tracking results: parsing output: 26/ for test: api_intel_bb results: parsing output: 27/ for test: kms_psr2_su results: parsing output: 28/ for test: kms_big_fb results: parsing output: 29/ for test: i915_drm_fdinfo results: parsing output: 30/ for test: dmabuf_sync_file results: parsing output: 31/ for test: vgem_basic results: parsing output: 32/ for test: kms_psr2_sf results: parsing output: 33/ for test: kms_rotation_crc results: parsing output: 34/ for test: kms_cursor_crc results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: gem_userptr_blits results: parsing output: 37/ for test: kms_plane results: parsing output: 38/ for test: gem_exec_fence results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: gem_exec_schedule results: parsing output: 41/ for test: gem_exec_gttfill results: parsing output: 42/ for test: kms_pipe_b_c_ivb results: parsing output: 43/ for test: prime_mmap results: parsing output: 44/ for test: gem_ctx_engines results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: gem_mmap_offset results: parsing output: 47/ for test: syncobj_basic results: parsing output: 48/ for test: i915_pm_rc6_residency results: parsing output: 49/ for test: kms_psr results: parsing output: 50/ for test: perf_pmu results: parsing output: 51/ for test: gem_pxp results: parsing output: 52/ for test: kms_ccs results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: kms_vblank results: parsing output: 55/ for test: kms_content_protection results: parsing output: 56/ for test: kms_ccs results: parsing output: 57/ for test: syncobj_wait results: parsing output: 58/ for test: syncobj_wait results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: kms_big_fb results: parsing output: 61/ for test: kms_pipe_crc_basic results: parsing output: 62/ for test: kms_cursor_legacy results: parsing output: 63/ for test: gem_flink_basic results: parsing output: 64/ for test: syncobj_timeline results: parsing output: 65/ for test: gem_lmem_swapping results: parsing output: 66/ for test: kms_frontbuffer_tracking results: parsing output: 67/ for test: kms_flip_scaled_crc results: parsing output: 68/ for test: kms_big_fb results: parsing output: 69/ for test: gem_exec_alignment results: parsing output: 70/ for test: gem_exec_whisper results: parsing output: 71/ for test: kms_big_fb results: parsing output: 72/ for test: gem_exec_await results: parsing output: 73/ for test: drm_read results: parsing output: 74/ for test: gem_userptr_blits results: parsing output: 75/ for test: kms_atomic_transition results: parsing output: 76/ for test: gem_pread results: parsing output: 77/ for test: kms_chamelium_hpd results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: kms_addfb_basic results: parsing output: 80/ for test: gem_exec_params results: parsing output: 81/ for test: kms_async_flips results: parsing output: 82/ for test: kms_frontbuffer_tracking results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: kms_ccs results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: kms_cursor_legacy results: parsing output: 87/ for test: kms_lease results: parsing output: 88/ for test: gem_exec_capture results: parsing output: 89/ for test: kms_ccs results: parsing output: 90/ for test: kms_cursor_crc results: parsing output: 91/ for test: i915_drm_fdinfo results: parsing output: 92/ for test: syncobj_timeline results: parsing output: 93/ for test: kms_plane results: parsing output: 94/ for test: kms_joiner results: parsing output: 95/ for test: kms_flip results: parsing output: 96/ for test: kms_pm_rpm results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: kms_selftest results: parsing output: 99/ for test: kms_psr results: parsing output: 100/ for test: syncobj_timeline results: parsing output: 101/ for test: gem_fence_thrash results: parsing output: 102/ for test: sriov_basic results: parsing output: 103/ for test: sysfs_timeslice_duration results: parsing output: 104/ for test: gen7_exec_parse results: parsing output: 105/ for test: gem_exec_balancer results: parsing output: 106/ for test: gem_mmap_gtt results: parsing output: 107/ for test: kms_ccs results: parsing output: 108/ for test: fbdev results: parsing output: 109/ for test: gen7_exec_parse results: parsing output: 110/ for test: kms_plane_scaling results: parsing output: 111/ for test: gem_userptr_blits results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: kms_properties results: parsing output: 115/ for test: gem_partial_pwrite_pread results: parsing output: 116/ for test: syncobj_timeline results: parsing output: 117/ for test: kms_plane_scaling results: parsing output: 118/ for test: kms_psr results: parsing output: 119/ for test: perf results: parsing output: 120/ for test: gem_exec_schedule results: parsing output: 121/ for test: gem_exec_reloc results: parsing output: 122/ for test: kms_big_fb results: parsing output: 123/ for test: i915_query results: parsing output: 124/ for test: kms_psr results: parsing output: 125/ for test: kms_psr results: parsing output: 126/ for test: gem_render_copy results: parsing output: 127/ for test: kms_pm_rpm results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: kms_cursor_edge_walk results: parsing output: 130/ for test: kms_draw_crc results: parsing output: 131/ for test: kms_big_fb results: parsing output: 132/ for test: kms_frontbuffer_tracking Done.