[50.526316] Initializing watchdogs [50.526479] /dev/watchdog0 [50.540069] [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] [50.544277] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [50.546396] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [50.549643] [001/131] (960s left) kms_big_fb (y-tiled-32bpp-rotate-180) [50.668535] Starting subtest: y-tiled-32bpp-rotate-180 [50.673087] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s) [50.766915] [002/131] (960s left) kms_vrr (lobf) [50.873811] Starting subtest: lobf [50.878175] Subtest lobf: SKIP (0.000s) [50.935262] [003/131] (960s left) i915_hangman (engine-engine-error) [51.013961] Starting subtest: engine-engine-error [51.015839] Starting dynamic subtest: rcs0 [52.877055] Dynamic subtest rcs0: SUCCESS (1.884s) [52.886599] Starting dynamic subtest: bcs0 [54.922058] Dynamic subtest bcs0: SUCCESS (2.063s) [54.931263] Starting dynamic subtest: vcs0 [56.908063] Dynamic subtest vcs0: SUCCESS (1.999s) [56.915993] Starting dynamic subtest: vcs1 [58.890654] Dynamic subtest vcs1: SUCCESS (1.992s) [58.900744] Starting dynamic subtest: vecs0 [60.875385] Dynamic subtest vecs0: SUCCESS (1.993s) [60.883171] Starting dynamic subtest: ccs0 [62.923372] Dynamic subtest ccs0: SUCCESS (2.054s) [62.926349] Subtest engine-engine-error: SUCCESS (11.989s) [62.995755] [004/131] (948s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [63.108231] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip [63.112802] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [63.215650] [005/131] (947s left) i915_suspend (fence-restore-untiled) [63.278070] Starting subtest: fence-restore-untiled [63.282333] Subtest fence-restore-untiled: SKIP (0.000s) [63.396995] [006/131] (947s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-render) [63.507626] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-render [68.301636] Subtest fbcpsr-1p-offscren-pri-indfb-draw-render: SUCCESS (4.806s) [68.461870] [007/131] (942s left) perf (invalid-oa-metric-set-id) [68.572857] Starting subtest: invalid-oa-metric-set-id [68.587996] Subtest invalid-oa-metric-set-id: SUCCESS (0.017s) [68.629926] [008/131] (942s left) api_intel_allocator (reserve-simple) [68.689454] Starting subtest: reserve-simple [68.694248] Subtest reserve-simple: SUCCESS (0.002s) [68.814655] [009/131] (942s left) kms_big_fb (x-tiled-8bpp-rotate-0) [68.922314] Starting subtest: x-tiled-8bpp-rotate-0 [70.077452] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.156s) [70.226520] [010/131] (941s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled) [70.275764] Starting subtest: multi-wait-all-for-submit-submitted-signaled [70.383912] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.107s) [70.447915] [011/131] (940s left) kms_cursor_legacy (forked-bo) [70.573930] Starting subtest: forked-bo [70.576113] Starting dynamic subtest: pipe-A [76.050473] Dynamic subtest pipe-A: SUCCESS (5.478s) [76.060302] Starting dynamic subtest: pipe-B [81.554598] Dynamic subtest pipe-B: SUCCESS (5.504s) [81.565448] Starting dynamic subtest: pipe-C [87.055079] Dynamic subtest pipe-C: SUCCESS (5.500s) [87.064864] Starting dynamic subtest: pipe-D [92.557966] Dynamic subtest pipe-D: SUCCESS (5.503s) [92.567534] Starting dynamic subtest: all-pipes [98.083777] Dynamic subtest all-pipes: SUCCESS (5.524s) [98.085940] Subtest forked-bo: SUCCESS (27.512s) [98.207857] [012/131] (913s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt) [98.311571] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt [98.316188] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [98.409114] [013/131] (912s left) kms_chamelium_edid (dp-mode-timings) [98.784343] Subtest dp-mode-timings: SKIP (0.000s) [99.605927] [014/131] (911s left) core_getstats [99.766255] [015/131] (911s left) gem_tiled_partial_pwrite_pread (reads) [99.830229] Subtest reads: SKIP (0.000s) [99.887369] [016/131] (911s left) gem_userptr_blits (invalid-mmap-offset-unsync) [99.960548] Subtest invalid-mmap-offset-unsync: SKIP (0.000s) [100.070471] [017/131] (911s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20) [100.174962] Starting subtest: planes-downscale-factor-0-75-upscale-20x20 [100.177252] Starting dynamic subtest: pipe-A [100.247331] Dynamic subtest pipe-A: SUCCESS (0.072s) [100.260339] Starting dynamic subtest: pipe-B [101.358324] Dynamic subtest pipe-B: SUCCESS (1.111s) [101.367440] Starting dynamic subtest: pipe-C [102.462961] Dynamic subtest pipe-C: SUCCESS (1.104s) [102.471977] Starting dynamic subtest: pipe-D [103.590658] Dynamic subtest pipe-D: SUCCESS (1.127s) [103.593021] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.416s) [104.736038] [018/131] (906s left) kms_cursor_legacy (cursora-vs-flipb-legacy) [104.863861] Starting subtest: cursorA-vs-flipB-legacy [104.868232] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s) [104.953640] [019/131] (906s left) kms_psr (psr-primary-render) [105.045250] Starting subtest: psr-primary-render [105.047717] Starting dynamic subtest: eDP-1 [106.743411] Dynamic subtest eDP-1: SUCCESS (1.696s) [106.745433] Subtest psr-primary-render: SUCCESS (1.697s) [107.584539] [020/131] (903s left) dmabuf_sync_file (export-wait-after-attach) [107.657921] Starting subtest: export-wait-after-attach [107.660310] Subtest export-wait-after-attach: SUCCESS (0.002s) [107.707187] [FACT dmabuf_sync_file (export-wait-after-attach)] new: kernel.kmod_is_loaded.vgem: true [107.710215] [021/131] (903s left) gem_close (many-handles-one-vma) [107.775087] Starting subtest: many-handles-one-vma [107.799447] Subtest many-handles-one-vma: SUCCESS (0.025s) [107.930682] [022/131] (903s left) kms_psr (fbc-pr-primary-blt) [108.033314] Starting subtest: fbc-pr-primary-blt [108.037731] Subtest fbc-pr-primary-blt: SKIP (0.000s) [108.101981] [023/131] (903s left) gem_create (create-valid-nonaligned) [108.162958] Starting subtest: create-valid-nonaligned [108.165276] Subtest create-valid-nonaligned: SUCCESS (0.000s) [108.338950] [024/131] (903s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite) [108.444312] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite [108.448715] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [108.548171] [025/131] (903s left) gem_mmap_offset (bad-object) [108.609751] Starting subtest: bad-object [108.612066] Subtest bad-object: SUCCESS (0.001s) [108.722208] [026/131] (903s left) kms_big_fb (x-tiled-64bpp-rotate-270) [108.829833] Starting subtest: x-tiled-64bpp-rotate-270 [108.847659] Subtest x-tiled-64bpp-rotate-270: SKIP (0.018s) [108.979917] [027/131] (902s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling) [109.075999] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling [109.078277] Starting dynamic subtest: pipe-A-default-mode [109.363424] Dynamic subtest pipe-A-default-mode: SKIP (0.283s) [109.368133] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.284s) [110.217229] [028/131] (901s left) kms_big_fb (linear-32bpp-rotate-0) [110.321061] Starting subtest: linear-32bpp-rotate-0 [111.987081] Subtest linear-32bpp-rotate-0: SUCCESS (1.665s) [112.214059] [029/131] (899s left) prime_self_import (reimport-vs-gem_close-race) [112.248699] Starting subtest: reimport-vs-gem_close-race [117.342650] Subtest reimport-vs-gem_close-race: SUCCESS (5.093s) [117.411011] [030/131] (894s left) kms_hdmi_inject (inject-4k) [117.756343] Starting subtest: inject-4k [118.057286] Subtest inject-4k: SUCCESS (0.304s) [118.568076] [031/131] (893s left) gem_exec_reloc (basic-wc-cpu-active) [118.625584] Subtest basic-wc-cpu-active: SKIP (0.000s) [118.685882] [032/131] (893s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs) [118.786899] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs [118.791561] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s) [119.932839] [033/131] (892s left) gem_exec_balancer (sequential) [119.998805] Starting subtest: sequential [122.923505] Subtest sequential: SUCCESS (2.924s) [123.224443] [034/131] (888s left) gem_flink_basic (bad-open) [123.286870] Starting subtest: bad-open [123.289159] Subtest bad-open: SUCCESS (0.000s) [123.379855] [035/131] (888s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite) [123.502323] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite [123.506509] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [123.607474] [036/131] (888s left) gem_softpin (noreloc) [123.666776] Starting subtest: noreloc [129.069242] Subtest noreloc: SUCCESS (5.401s) [129.203889] [037/131] (882s left) perf (gen12-oa-tlb-invalidate) [129.284862] Starting subtest: gen12-oa-tlb-invalidate [129.287307] Starting dynamic subtest: 0-rcs0 [139.339342] Dynamic subtest 0-rcs0: SUCCESS (10.052s) [139.346393] Starting dynamic subtest: 1-vecs0 [149.386291] Dynamic subtest 1-vecs0: SUCCESS (10.047s) [149.388791] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.100s) [149.450212] [038/131] (862s left) kms_content_protection (legacy) [149.618615] Starting subtest: legacy [153.362540] Subtest legacy: SKIP (3.741s) [154.525834] [039/131] (857s left) syncobj_timeline (reset-unsignaled) [154.587373] Starting subtest: reset-unsignaled [154.589587] Subtest reset-unsignaled: SUCCESS (0.000s) [154.672382] [040/131] (857s left) kms_psr (fbc-psr2-sprite-mmap-cpu) [154.760224] Starting subtest: fbc-psr2-sprite-mmap-cpu [154.762607] Starting dynamic subtest: eDP-1 [154.767079] Dynamic subtest eDP-1: SKIP (0.000s) [154.771531] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.000s) [154.825879] [041/131] (857s left) i915_pm_rps (engine-order) [154.892954] Starting subtest: engine-order [159.684862] Subtest engine-order: SUCCESS (4.788s) [159.759066] [042/131] (852s left) kms_cursor_crc (cursor-offscreen-64x64) [159.960930] Starting subtest: cursor-offscreen-64x64 [159.966163] Starting dynamic subtest: pipe-A-eDP-1 [161.929450] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.963s) [161.953072] Starting dynamic subtest: pipe-D-eDP-1 [164.527785] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.577s) [164.530108] Subtest cursor-offscreen-64x64: SUCCESS (4.564s) [165.331163] [043/131] (847s left) gem_softpin (softpin) [165.405267] Starting subtest: softpin [197.733774] Subtest softpin: SUCCESS (32.325s) [197.866806] [044/131] (814s left) gem_softpin (overlap) [197.941423] Starting subtest: overlap [198.674886] Subtest overlap: SUCCESS (0.731s) [198.804745] [045/131] (813s left) kms_prop_blob (basic) [198.850890] Starting subtest: basic [198.853326] Subtest basic: SUCCESS (0.000s) [198.961324] [046/131] (813s left) kms_joiner (basic-force-big-joiner) [199.063866] Starting subtest: basic-force-big-joiner [199.066151] Starting dynamic subtest: single [202.380229] Dynamic subtest single: SUCCESS (3.325s) [202.382426] Subtest basic-force-big-joiner: SUCCESS (3.326s) [203.524741] [047/131] (808s left) kms_plane_scaling (intel-max-src-size) [203.618681] Starting subtest: intel-max-src-size [203.625385] Subtest intel-max-src-size: SKIP (0.000s) [203.728559] [048/131] (808s left) gem_ctx_persistence (legacy-engines-mixed) [203.798601] Starting subtest: legacy-engines-mixed [203.800810] Starting dynamic subtest: render [203.896903] Dynamic subtest render: SUCCESS (0.098s) [203.907638] Starting dynamic subtest: bsd1 [203.959251] Dynamic subtest bsd1: SUCCESS (0.060s) [203.968054] Starting dynamic subtest: bsd2 [204.030873] Dynamic subtest bsd2: SUCCESS (0.071s) [204.039443] Starting dynamic subtest: blt [204.106620] Dynamic subtest blt: SUCCESS (0.075s) [204.116383] Starting dynamic subtest: vebox [204.180291] Dynamic subtest vebox: SUCCESS (0.071s) [204.182903] Subtest legacy-engines-mixed: SUCCESS (0.381s) [204.252255] [049/131] (808s left) kms_big_fb (4-tiled-32bpp-rotate-270) [204.357165] Starting subtest: 4-tiled-32bpp-rotate-270 [204.376063] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.019s) [204.494359] [050/131] (808s left) kms_lease (empty-lease) [204.583399] Starting subtest: empty-lease [204.585489] Starting dynamic subtest: pipe-A-eDP-1 [204.587389] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [204.596722] Starting dynamic subtest: pipe-B-eDP-1 [204.598522] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [204.605374] Starting dynamic subtest: pipe-C-eDP-1 [204.607177] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [204.613844] Starting dynamic subtest: pipe-D-eDP-1 [204.615686] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [204.617481] Subtest empty-lease: SUCCESS (0.006s) [204.703759] [051/131] (807s left) kms_hdr (brightness-with-hdr) [204.806632] Starting subtest: brightness-with-hdr [204.812525] Subtest brightness-with-hdr: SKIP (0.000s) [204.902309] [052/131] (807s left) gem_exec_params (cliprects-invalid) [204.956763] Starting subtest: cliprects-invalid [204.958689] Subtest cliprects-invalid: SUCCESS (0.000s) [205.069153] [053/131] (807s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-25) [205.153486] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-25 [205.155368] Starting dynamic subtest: pipe-A [205.169418] Dynamic subtest pipe-A: SKIP (0.011s) [205.177082] Starting dynamic subtest: pipe-B [205.192059] Dynamic subtest pipe-B: SKIP (0.021s) [205.199078] Starting dynamic subtest: pipe-C [205.214454] Dynamic subtest pipe-C: SKIP (0.022s) [205.222396] Starting dynamic subtest: pipe-D [205.232604] Dynamic subtest pipe-D: SKIP (0.021s) [205.235729] Subtest planes-upscale-factor-0-25-downscale-factor-0-25: SKIP (0.076s) [205.319581] [054/131] (807s left) perf (invalid-create-userspace-config) [205.398330] Starting subtest: invalid-create-userspace-config [205.400351] Subtest invalid-create-userspace-config: SUCCESS (0.001s) [205.434891] [055/131] (807s left) gem_ctx_sseu (invalid-args) [205.496452] Subtest invalid-args: SKIP (0.000s) [205.579611] [056/131] (807s left) gem_exec_schedule (pi-ringfull) [205.762358] Starting subtest: pi-ringfull [205.764269] Starting dynamic subtest: rcs0 [205.847075] Dynamic subtest rcs0: SUCCESS (0.086s) [205.856690] Starting dynamic subtest: bcs0 [205.933360] Dynamic subtest bcs0: SUCCESS (0.086s) [205.942726] Starting dynamic subtest: vcs0 [206.017507] Dynamic subtest vcs0: SUCCESS (0.083s) [206.030701] Starting dynamic subtest: vcs1 [206.097082] Dynamic subtest vcs1: SUCCESS (0.079s) [206.110702] Starting dynamic subtest: vecs0 [206.171893] Dynamic subtest vecs0: SUCCESS (0.074s) [206.186371] Starting dynamic subtest: ccs0 [206.246898] Dynamic subtest ccs0: SUCCESS (0.074s) [206.249729] Subtest pi-ringfull: SUCCESS (0.487s) [206.482434] [057/131] (806s left) gem_exec_schedule (thriceslice) [206.559798] Starting subtest: thriceslice [206.561720] Starting dynamic subtest: rcs0 [206.580797] Dynamic subtest rcs0: SUCCESS (0.029s) [206.591516] Starting dynamic subtest: bcs0 [206.608516] Dynamic subtest bcs0: SUCCESS (0.027s) [206.618375] Starting dynamic subtest: vcs0 [206.656916] Dynamic subtest vcs0: SUCCESS (0.048s) [206.664727] Starting dynamic subtest: vcs1 [206.706804] Dynamic subtest vcs1: SUCCESS (0.049s) [206.715278] Starting dynamic subtest: vecs0 [206.736774] Dynamic subtest vecs0: SUCCESS (0.029s) [206.744448] Starting dynamic subtest: ccs0 [206.765780] Dynamic subtest ccs0: SUCCESS (0.028s) [206.768138] Subtest thriceslice: SUCCESS (0.213s) [207.057681] [058/131] (805s left) gem_exec_reloc (basic-softpin) [207.128473] Subtest basic-softpin: SKIP (0.000s) [207.187576] [059/131] (805s left) syncobj_timeline (single-wait-for-submit-available-signaled) [207.243570] Starting subtest: single-wait-for-submit-available-signaled [207.245599] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s) [207.336883] [060/131] (805s left) kms_big_fb (yf-tiled-addfb-size-overflow) [207.446117] Starting subtest: yf-tiled-addfb-size-overflow [207.450393] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s) [207.543962] [061/131] (805s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs) [207.650261] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs [207.652713] Starting dynamic subtest: pipe-A-eDP-1 [207.676224] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [207.685849] Starting dynamic subtest: pipe-B-eDP-1 [207.707561] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [207.715321] Starting dynamic subtest: pipe-C-eDP-1 [207.737690] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [207.745689] Starting dynamic subtest: pipe-D-eDP-1 [207.767427] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [207.771847] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.003s) [209.830894] [062/131] (803s left) kms_dirtyfb (psr-dirtyfb-ioctl) [209.928317] Starting subtest: psr-dirtyfb-ioctl [209.930689] Starting dynamic subtest: A-eDP-1 [211.768339] Dynamic subtest A-eDP-1: SUCCESS (1.839s) [211.770619] Subtest psr-dirtyfb-ioctl: SUCCESS (1.840s) [212.624764] [063/131] (800s left) kms_async_flips (test-cursor) [212.716247] Starting subtest: test-cursor [212.720802] Subtest test-cursor: SKIP (0.000s) [213.926565] [064/131] (799s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted) [213.988117] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted [214.095636] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.108s) [214.178342] [065/131] (798s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary) [214.283300] Starting subtest: fbcpsr-shrfb-scaledprimary [219.914246] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.633s) [220.056730] [066/131] (793s left) kms_rotation_crc (cursor-rotation-180) [220.166081] Starting subtest: cursor-rotation-180 [221.644619] Subtest cursor-rotation-180: SUCCESS (1.476s) [222.824041] [067/131] (790s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc) [222.922819] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc [222.925269] Starting dynamic subtest: pipe-A-eDP-1 [222.948900] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [222.957410] Starting dynamic subtest: pipe-B-eDP-1 [222.978962] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [222.986085] Starting dynamic subtest: pipe-C-eDP-1 [223.008027] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [223.015370] Starting dynamic subtest: pipe-D-eDP-1 [223.039995] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [223.044173] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s) [225.125497] [068/131] (788s left) drm_mm (drm_mm) [225.161176] Starting subtest: drm_mm [225.172452] Starting dynamic subtest: drm_test_mm_init [225.311750] Dynamic subtest drm_test_mm_init: SUCCESS (0.137s) [225.320161] Starting dynamic subtest: drm_test_mm_debug [225.449708] Dynamic subtest drm_test_mm_debug: SUCCESS (0.138s) [225.458830] Starting dynamic subtest: drm_test_mm_align32 [225.590720] Dynamic subtest drm_test_mm_align32: SUCCESS (0.142s) [225.600287] Starting dynamic subtest: drm_test_mm_align64 [225.726868] Dynamic subtest drm_test_mm_align64: SUCCESS (0.135s) [225.735402] Starting dynamic subtest: drm_test_mm_lowest [225.867486] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.140s) [225.874320] Starting dynamic subtest: drm_test_mm_highest [225.979398] Dynamic subtest drm_test_mm_highest: SUCCESS (0.111s) [225.981530] Subtest drm_mm: SUCCESS (0.817s) [226.158892] [069/131] (787s left) gem_lmem_swapping (parallel-random-engines) [226.197511] Subtest parallel-random-engines: SKIP (0.000s) [226.231328] [070/131] (787s left) gem_mmap_gtt (basic-short) [226.288263] Subtest basic-short: SKIP (0.000s) [226.354149] [071/131] (786s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait) [228.088860] Starting subtest: modeset-non-lpsp-stress-no-wait [228.155512] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.065s) [228.622276] [072/131] (784s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc) [228.723329] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc [228.725637] Starting dynamic subtest: pipe-A-eDP-1 [228.782988] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [228.790486] Starting dynamic subtest: pipe-B-eDP-1 [228.848394] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [228.856945] Starting dynamic subtest: pipe-C-eDP-1 [228.915083] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [228.925114] Starting dynamic subtest: pipe-D-eDP-1 [228.982319] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [228.986847] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.007s) [230.940640] [073/131] (782s left) kms_pipe_crc_basic (nonblocking-crc) [231.031082] Starting subtest: nonblocking-crc [231.033378] Starting dynamic subtest: pipe-A-eDP-1 [231.764785] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.732s) [231.773361] Starting dynamic subtest: pipe-B-eDP-1 [233.186057] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.419s) [233.194724] Starting dynamic subtest: pipe-C-eDP-1 [234.564219] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.377s) [234.572606] Starting dynamic subtest: pipe-D-eDP-1 [235.953330] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.389s) [235.955693] Subtest nonblocking-crc: SUCCESS (4.922s) [236.823203] [074/131] (776s left) syncobj_timeline (etime-single-wait-all-submitted) [236.877479] Starting subtest: etime-single-wait-all-submitted [236.983908] Subtest etime-single-wait-all-submitted: SUCCESS (0.105s) [237.053541] [075/131] (776s left) gem_render_copy_redux (flink) [237.111290] Starting subtest: flink [237.957699] Subtest flink: SUCCESS (0.846s) [238.106494] [076/131] (775s left) gem_exec_schedule (implicit-read-write) [238.173548] Starting subtest: implicit-read-write [238.175443] Starting dynamic subtest: rcs0 [238.268662] Dynamic subtest rcs0: SUCCESS (0.102s) [238.278893] Starting dynamic subtest: vcs0 [238.341341] Dynamic subtest vcs0: SUCCESS (0.073s) [238.350667] Starting dynamic subtest: vcs1 [238.418618] Dynamic subtest vcs1: SUCCESS (0.077s) [238.428881] Starting dynamic subtest: vecs0 [238.490244] Dynamic subtest vecs0: SUCCESS (0.071s) [238.501495] Starting dynamic subtest: ccs0 [238.565561] Dynamic subtest ccs0: SUCCESS (0.075s) [238.567819] Subtest implicit-read-write: SUCCESS (0.400s) [240.029112] [077/131] (773s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling) [240.127156] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling [240.129391] Starting dynamic subtest: pipe-A-default-mode [240.413286] Dynamic subtest pipe-A-default-mode: SKIP (0.282s) [240.417771] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.283s) [241.225364] [078/131] (772s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt) [241.331664] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt [241.335664] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [241.433809] [079/131] (772s left) kms_rotation_crc (primary-y-tiled-reflect-x-0) [241.525096] Starting subtest: primary-y-tiled-reflect-x-0 [241.586594] Subtest primary-y-tiled-reflect-x-0: SKIP (0.059s) [241.681885] [080/131] (771s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc) [241.788990] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc [241.793226] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [241.881736] [081/131] (771s left) gem_mmap_gtt (cpuset-big-copy-xy) [241.935813] Subtest cpuset-big-copy-XY: SKIP (0.000s) [241.992475] [082/131] (771s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt) [242.099599] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt [242.103979] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [242.204059] [083/131] (771s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt) [242.314289] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt [247.532389] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (5.219s) [247.660899] [084/131] (766s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled) [247.714380] Starting subtest: invalid-multi-wait-unsubmitted-signaled [247.716416] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s) [247.820097] [085/131] (765s left) gem_exec_fence (syncobj-repeat) [248.247117] Starting subtest: syncobj-repeat [248.426655] Subtest syncobj-repeat: SUCCESS (0.178s) [249.957532] [086/131] (763s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb) [254.998741] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb [255.001118] Starting dynamic subtest: pipe-A-eDP-1 [266.000299] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.999s) [266.008885] Starting dynamic subtest: pipe-B-eDP-1 [276.997950] Dynamic subtest pipe-B-eDP-1: SUCCESS (10.995s) [277.000232] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (21.998s) [277.819177] [087/131] (736s left) kms_color (ctm-0-75) [277.927268] Starting subtest: ctm-0-75 [277.929608] Starting dynamic subtest: pipe-A-eDP-1 [282.735936] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.807s) [282.743792] Starting dynamic subtest: pipe-B-eDP-1 [288.038345] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.302s) [288.046389] Starting dynamic subtest: pipe-C-eDP-1 [293.195748] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.153s) [293.204272] Starting dynamic subtest: pipe-D-eDP-1 [298.404640] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.209s) [298.406849] Subtest ctm-0-75: SUCCESS (20.476s) [299.218388] [088/131] (714s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs) [299.321217] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs [299.323628] Starting dynamic subtest: pipe-A-eDP-1 [300.156662] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.823s) [300.165646] Starting dynamic subtest: pipe-B-eDP-1 [301.698110] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.542s) [301.705607] Starting dynamic subtest: pipe-C-eDP-1 [303.172964] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.473s) [303.181498] Starting dynamic subtest: pipe-D-eDP-1 [304.671863] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.498s) [304.674271] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.341s) [305.816078] [089/131] (708s left) gem_exec_params (invalid-bsd1-flag-on-vebox) [305.882369] Starting subtest: invalid-bsd1-flag-on-vebox [305.884865] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s) [305.990642] [090/131] (707s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt) [306.096162] Starting subtest: psr-rgb101010-draw-blt [311.239970] Subtest psr-rgb101010-draw-blt: SUCCESS (5.147s) [311.372390] [091/131] (702s left) kms_flip (bo-too-big-interruptible) [311.470766] Starting subtest: bo-too-big-interruptible [311.473067] Starting dynamic subtest: A-eDP1 [313.167058] Dynamic subtest A-eDP1: SUCCESS (1.694s) [313.174291] Starting dynamic subtest: B-eDP1 [314.872678] Dynamic subtest B-eDP1: SUCCESS (1.705s) [314.880315] Starting dynamic subtest: C-eDP1 [316.580472] Dynamic subtest C-eDP1: SUCCESS (1.707s) [316.594237] Starting dynamic subtest: D-eDP1 [318.271256] Dynamic subtest D-eDP1: SUCCESS (1.689s) [318.276776] Subtest bo-too-big-interruptible: SUCCESS (6.804s) [319.515264] [092/131] (694s left) kms_chamelium_hpd (dp-hpd-storm) [319.898974] Subtest dp-hpd-storm: SKIP (0.000s) [320.694089] [093/131] (693s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled) [320.755618] Starting subtest: yf-tiled-ccs-to-yf-tiled [320.760072] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s) [320.934285] [094/131] (693s left) kms_flip (2x-flip-vs-expired-vblank) [321.039348] Starting subtest: 2x-flip-vs-expired-vblank [321.050105] Subtest 2x-flip-vs-expired-vblank: SKIP (0.010s) [321.155450] [095/131] (692s left) gem_render_copy_redux (flink-interruptible) [321.223902] Starting subtest: flink-interruptible [322.106487] Subtest flink-interruptible: SUCCESS (0.883s) [322.254918] [096/131] (691s left) gem_tiled_pread_basic [322.380077] [097/131] (691s left) syncobj_wait (single-wait-for-submit-submitted) [322.445955] Starting subtest: single-wait-for-submit-submitted [322.550977] Subtest single-wait-for-submit-submitted: SUCCESS (0.105s) [322.620069] [098/131] (691s left) sw_sync (sync_random_merge) [322.661246] Starting subtest: sync_random_merge [322.693972] Subtest sync_random_merge: SUCCESS (0.038s) [322.747881] [099/131] (691s left) kms_vblank (ts-continuation-dpms-rpm) [322.849153] Starting subtest: ts-continuation-dpms-rpm [322.851394] Starting dynamic subtest: pipe-A-eDP-1 [325.378900] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.527s) [325.392841] Starting dynamic subtest: pipe-D-eDP-1 [327.566397] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.185s) [327.568909] Subtest ts-continuation-dpms-rpm: SUCCESS (4.716s) [328.413565] [100/131] (685s left) kms_cursor_crc (cursor-sliding-32x10) [328.552852] Starting subtest: cursor-sliding-32x10 [328.593264] Subtest cursor-sliding-32x10: SKIP (0.034s) [328.858530] [101/131] (685s left) gem_ctx_engines (none) [328.924422] Starting subtest: none [328.926915] Subtest none: SUCCESS (0.001s) [329.100032] [102/131] (685s left) gem_exec_whisper (basic-fds-priority) [329.169575] Starting subtest: basic-fds-priority [351.497877] Subtest basic-fds-priority: SUCCESS (22.325s) [351.674375] [103/131] (662s left) kms_psr (pr-cursor-blt) [351.777962] Starting subtest: pr-cursor-blt [351.782072] Subtest pr-cursor-blt: SKIP (0.000s) [351.843280] [104/131] (662s left) gem_ppgtt (shrink-vs-evict-pinned) [351.906798] Starting subtest: shrink-vs-evict-pinned [357.902166] Subtest shrink-vs-evict-pinned: SUCCESS (5.993s) [357.996542] [105/131] (656s left) gem_partial_pwrite_pread (writes-after-reads-uncached) [358.048683] Subtest writes-after-reads-uncached: SKIP (0.000s) [358.109475] [106/131] (656s left) gem_create (busy-create) [358.165982] Starting subtest: busy-create [358.168390] Starting dynamic subtest: smem0 [391.943057] Dynamic subtest smem0: SUCCESS (33.774s) [391.945481] Subtest busy-create: SUCCESS (33.775s) [392.124295] [107/131] (622s left) core_getclient [392.288190] [108/131] (622s left) gem_exec_params (no-bsd) [392.345179] Starting subtest: no-bsd [392.350394] Subtest no-bsd: SUCCESS (0.004s) [393.999846] [109/131] (620s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [394.135977] Starting subtest: basic-flip-after-cursor-atomic [395.051277] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.917s) [395.910616] [110/131] (618s left) kms_feature_discovery (psr2) [396.017067] Starting subtest: psr2 [396.018948] Subtest psr2: SUCCESS (0.000s) [396.080953] [111/131] (618s left) i915_hangman (error-state-basic) [396.142131] Starting subtest: error-state-basic [396.293413] Subtest error-state-basic: SUCCESS (0.150s) [396.363103] [112/131] (618s left) gem_wait (await) [396.433958] Starting subtest: await [396.436366] Starting dynamic subtest: all-engines [397.547340] Dynamic subtest all-engines: SUCCESS (1.112s) [397.558722] Starting dynamic subtest: rcs0 [398.614188] Dynamic subtest rcs0: SUCCESS (1.065s) [398.629735] Starting dynamic subtest: bcs0 [399.675198] Dynamic subtest bcs0: SUCCESS (1.059s) [399.690940] Starting dynamic subtest: vcs0 [400.733227] Dynamic subtest vcs0: SUCCESS (1.055s) [400.752415] Starting dynamic subtest: vcs1 [401.787490] Dynamic subtest vcs1: SUCCESS (1.053s) [401.802532] Starting dynamic subtest: vecs0 [402.840479] Dynamic subtest vecs0: SUCCESS (1.051s) [402.854812] Starting dynamic subtest: ccs0 [403.899710] Dynamic subtest ccs0: SUCCESS (1.057s) [403.902282] Subtest await: SUCCESS (7.466s) [404.093217] [113/131] (610s left) sysfs_heartbeat_interval (mixed) [404.154088] Starting subtest: mixed [404.156407] Starting dynamic subtest: vecs0 [409.378275] Dynamic subtest vecs0: SUCCESS (5.223s) [409.389236] Starting dynamic subtest: ccs0 [414.584230] Dynamic subtest ccs0: SUCCESS (5.204s) [414.596434] Starting dynamic subtest: vcs0 [419.802920] Dynamic subtest vcs0: SUCCESS (5.216s) [419.813509] Starting dynamic subtest: bcs0 [425.029142] Dynamic subtest bcs0: SUCCESS (5.224s) [425.040954] Starting dynamic subtest: rcs0 [430.239124] Dynamic subtest rcs0: SUCCESS (5.208s) [430.247450] Starting dynamic subtest: vcs1 [435.467260] Dynamic subtest vcs1: SUCCESS (5.226s) [435.469708] Subtest mixed: SUCCESS (31.313s) [435.536738] [114/131] (579s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled) [435.602341] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled [435.604720] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.001s) [435.699566] [115/131] (579s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt) [435.801139] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt [435.805334] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [435.901776] [116/131] (578s left) gem_exec_balancer (parallel-dmabuf-import-out-fence) [436.153793] Starting subtest: parallel-dmabuf-import-out-fence [437.072876] Subtest parallel-dmabuf-import-out-fence: SUCCESS (0.919s) [437.181253] [117/131] (577s left) api_intel_bb (render) [437.246084] Starting subtest: render [437.248270] Starting dynamic subtest: render-none-512 [437.345539] Dynamic subtest render-none-512: SUCCESS (0.102s) [437.356845] Starting dynamic subtest: render-none-1024 [437.730077] Dynamic subtest render-none-1024: SUCCESS (0.383s) [437.741218] Starting dynamic subtest: render-x-512 [437.815453] Dynamic subtest render-x-512: SUCCESS (0.085s) [437.826285] Starting dynamic subtest: render-x-1024 [438.165718] Dynamic subtest render-x-1024: SUCCESS (0.349s) [438.175974] Starting dynamic subtest: render-y-512 [438.253048] Dynamic subtest render-y-512: SUCCESS (0.087s) [438.263748] Starting dynamic subtest: render-y-1024 [438.596966] Dynamic subtest render-y-1024: SUCCESS (0.343s) [438.599748] Subtest render: SUCCESS (1.354s) [438.680063] [118/131] (576s left) gem_ctx_persistence (engines-mixed-process) [438.741167] Starting subtest: engines-mixed-process [438.743406] Starting dynamic subtest: rcs0 [439.936858] Dynamic subtest rcs0: SUCCESS (1.192s) [439.947351] Starting dynamic subtest: bcs0 [441.902687] Dynamic subtest bcs0: SUCCESS (1.968s) [441.911067] Starting dynamic subtest: vcs0 [443.956286] Dynamic subtest vcs0: SUCCESS (2.052s) [443.964996] Starting dynamic subtest: vcs1 [445.939637] Dynamic subtest vcs1: SUCCESS (1.981s) [445.949515] Starting dynamic subtest: vecs0 [447.937805] Dynamic subtest vecs0: SUCCESS (1.997s) [447.947146] Starting dynamic subtest: ccs0 [449.931188] Dynamic subtest ccs0: SUCCESS (1.992s) [449.933668] Subtest engines-mixed-process: SUCCESS (11.191s) [450.009204] [119/131] (564s left) kms_rotation_crc (multiplane-rotation) [450.109254] Starting subtest: multiplane-rotation [457.235157] Subtest multiplane-rotation: SUCCESS (7.126s) [457.355510] [120/131] (557s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt) [457.449313] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt [457.452739] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [457.535111] [121/131] (557s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area) [462.590904] Starting subtest: fbc-psr2-plane-move-sf-dmg-area [462.593350] Starting dynamic subtest: pipe-A-eDP-1 [463.353321] Dynamic subtest pipe-A-eDP-1: SKIP (0.758s) [463.362238] Starting dynamic subtest: pipe-B-eDP-1 [464.555523] Dynamic subtest pipe-B-eDP-1: SKIP (1.200s) [464.559815] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.962s) [465.706084] [122/131] (549s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite) [465.818467] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite [465.822605] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [465.911565] [123/131] (549s left) perf_pmu (idle-no-semaphores) [465.957067] Starting subtest: idle-no-semaphores [465.959374] Starting dynamic subtest: rcs0 [466.515644] Dynamic subtest rcs0: SUCCESS (0.557s) [466.527733] Starting dynamic subtest: bcs0 [467.038601] Dynamic subtest bcs0: SUCCESS (0.520s) [467.054820] Starting dynamic subtest: vcs0 [467.560374] Dynamic subtest vcs0: SUCCESS (0.519s) [467.572193] Starting dynamic subtest: vcs1 [468.090102] Dynamic subtest vcs1: SUCCESS (0.526s) [468.101583] Starting dynamic subtest: vecs0 [468.622610] Dynamic subtest vecs0: SUCCESS (0.529s) [468.634526] Starting dynamic subtest: ccs0 [469.146561] Dynamic subtest ccs0: SUCCESS (0.521s) [469.149265] Subtest idle-no-semaphores: SUCCESS (3.189s) [469.256901] [124/131] (545s left) kms_flip (plain-flip-ts-check-interruptible) [469.348616] Starting subtest: plain-flip-ts-check-interruptible [469.350880] Starting dynamic subtest: A-eDP1 [478.170870] Dynamic subtest A-eDP1: SUCCESS (8.821s) [478.179580] Starting dynamic subtest: B-eDP1 [487.068758] Dynamic subtest B-eDP1: SUCCESS (8.897s) [487.078283] Starting dynamic subtest: C-eDP1 [495.955058] Dynamic subtest C-eDP1: SUCCESS (8.885s) [495.965760] Starting dynamic subtest: D-eDP1 [504.852371] Dynamic subtest D-eDP1: SUCCESS (8.896s) [504.857502] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.508s) [506.000389] [125/131] (509s left) kms_cursor_legacy (flip-vs-cursor-atomic) [506.111685] Starting subtest: flip-vs-cursor-atomic [512.883037] Subtest flip-vs-cursor-atomic: SUCCESS (6.773s) [513.694776] [126/131] (501s left) gem_softpin (32b-excludes-last-page) [513.760678] Starting subtest: 32b-excludes-last-page [513.766435] Subtest 32b-excludes-last-page: SUCCESS (0.003s) [513.897618] [127/131] (501s left) kms_addfb_basic (bo-too-small-due-to-tiling) [513.995097] Starting subtest: bo-too-small-due-to-tiling [513.999440] Subtest bo-too-small-due-to-tiling: SKIP (0.000s) [514.111550] [128/131] (501s left) syncobj_eventfd (timeline-wait) [514.174602] Starting subtest: timeline-wait [514.181729] Subtest timeline-wait: SUCCESS (0.011s) [514.294287] [129/131] (501s left) kms_atomic_interruptible (legacy-dpms) [514.393068] Starting subtest: legacy-dpms [514.395361] Starting dynamic subtest: pipe-A-eDP-1 [521.788893] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.395s) [521.790721] Subtest legacy-dpms: SUCCESS (7.396s) [522.595887] [130/131] (492s left) perf_pmu (interrupts) [522.638102] Starting subtest: interrupts [523.740733] Subtest interrupts: SUCCESS (1.103s) [523.856873] [131/131] (491s left) kms_psr (pr-suspend) [523.964056] Starting subtest: pr-suspend [523.968184] Subtest pr-suspend: SKIP (0.000s) [524.024590] Closing watchdogs Done.