[59.995696] Initializing watchdogs [59.995755] /dev/watchdog0 [60.009638] [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] [60.013970] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [60.016154] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [60.019532] [001/133] (960s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0) [60.147144] Starting subtest: primary-yf-tiled-reflect-x-0 [60.227600] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.080s) [60.348859] [002/133] (960s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf) [60.445174] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf [60.449223] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [60.507068] [003/133] (960s left) i915_pm_rps (fence-order) [60.564589] Starting subtest: fence-order [63.434682] Subtest fence-order: SUCCESS (2.866s) [63.554954] [004/133] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt) [63.651252] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt [63.655236] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [63.727283] [005/133] (956s left) kms_sequence (queue-busy) [63.821670] Starting subtest: queue-busy [63.824118] Starting dynamic subtest: pipe-A-eDP-1 [65.755539] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.936s) [65.764572] Starting dynamic subtest: pipe-B-eDP-1 [68.331588] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.572s) [68.341749] Starting dynamic subtest: pipe-C-eDP-1 [70.942828] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.609s) [70.950913] Starting dynamic subtest: pipe-D-eDP-1 [73.491570] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.548s) [73.493786] Subtest queue-busy: SUCCESS (9.669s) [74.291126] [006/133] (946s left) kms_pm_rpm (dpms-non-lpsp) [76.046078] Starting subtest: dpms-non-lpsp [76.050961] Subtest dpms-non-lpsp: SKIP (0.001s) [76.628721] [007/133] (944s left) kms_plane (plane-panning-top-left) [76.714205] Starting subtest: plane-panning-top-left [76.716707] Starting dynamic subtest: pipe-A [78.380866] Dynamic subtest pipe-A: SUCCESS (1.662s) [78.390508] Starting dynamic subtest: pipe-B [80.736836] Dynamic subtest pipe-B: SUCCESS (2.356s) [80.739100] Subtest plane-panning-top-left: SUCCESS (4.020s) [81.550790] [008/133] (939s left) core_auth (many-magics) [81.604584] Starting subtest: many-magics [82.513466] Subtest many-magics: SUCCESS (0.912s) [82.682506] [009/133] (938s left) gem_ctx_persistence (engines-hang) [82.749333] Starting subtest: engines-hang [82.751643] Starting dynamic subtest: rcs0 [82.858835] Dynamic subtest rcs0: SUCCESS (0.109s) [82.869672] Starting dynamic subtest: bcs0 [82.951252] Dynamic subtest bcs0: SUCCESS (0.092s) [82.959677] Starting dynamic subtest: vcs0 [83.042566] Dynamic subtest vcs0: SUCCESS (0.090s) [83.052647] Starting dynamic subtest: vcs1 [83.137633] Dynamic subtest vcs1: SUCCESS (0.094s) [83.147177] Starting dynamic subtest: vecs0 [83.236666] Dynamic subtest vecs0: SUCCESS (0.098s) [83.246411] Starting dynamic subtest: ccs0 [83.330677] Dynamic subtest ccs0: SUCCESS (0.093s) [83.333219] Subtest engines-hang: SUCCESS (0.582s) [83.420695] [010/133] (937s left) gem_exec_reloc (basic-write-cpu-active) [83.475689] Subtest basic-write-cpu-active: SKIP (0.000s) [83.536802] [011/133] (937s left) kms_psr (fbc-psr-sprite-mmap-gtt) [83.629141] Starting subtest: fbc-psr-sprite-mmap-gtt [83.630988] Starting dynamic subtest: eDP-1 [83.634363] Dynamic subtest eDP-1: SKIP (0.000s) [83.637822] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s) [83.700552] [012/133] (937s left) gem_exec_reloc (basic-write-gtt-noreloc) [83.757982] Subtest basic-write-gtt-noreloc: SKIP (0.000s) [83.830410] [013/133] (937s left) prime_busy (hang) [83.890928] Starting subtest: hang [83.892908] Starting dynamic subtest: rcs0 [110.447666] Dynamic subtest rcs0: SUCCESS (26.552s) [110.457731] Starting dynamic subtest: bcs0 [117.537708] Dynamic subtest bcs0: SUCCESS (7.090s) [117.545072] Starting dynamic subtest: vcs0 [124.575721] Dynamic subtest vcs0: SUCCESS (7.039s) [124.583299] Starting dynamic subtest: vcs1 [131.552564] Dynamic subtest vcs1: SUCCESS (6.974s) [131.559971] Starting dynamic subtest: vecs0 [138.588776] Dynamic subtest vecs0: SUCCESS (7.034s) [138.596047] Starting dynamic subtest: ccs0 [152.428448] Dynamic subtest ccs0: SUCCESS (13.837s) [152.430978] Subtest hang: SUCCESS (68.534s) [152.554969] [014/133] (868s left) gem_reg_read (bad-register) [152.619490] Starting subtest: bad-register [152.621772] Subtest bad-register: SUCCESS (0.000s) [152.736751] [015/133] (868s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc) [152.825849] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc [152.828247] Starting dynamic subtest: pipe-A-eDP-1 [152.851156] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [152.860955] Starting dynamic subtest: pipe-B-eDP-1 [152.882746] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [152.889965] Starting dynamic subtest: pipe-C-eDP-1 [152.911439] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [152.918839] Starting dynamic subtest: pipe-D-eDP-1 [152.940580] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [152.944659] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s) [155.006320] [016/133] (866s left) gem_pxp (regular-baseline-src-copy-readible) [155.123641] Starting subtest: regular-baseline-src-copy-readible [155.181693] Subtest regular-baseline-src-copy-readible: SUCCESS (0.060s) [155.282868] [017/133] (865s left) kms_feature_discovery (psr1) [155.393820] Starting subtest: psr1 [155.396140] Subtest psr1: SUCCESS (0.000s) [155.478215] [018/133] (865s left) gem_exec_whisper (basic-queues-forked-all) [155.545601] Starting subtest: basic-queues-forked-all [173.224792] Subtest basic-queues-forked-all: SUCCESS (17.675s) [173.405761] [019/133] (847s left) kms_cursor_crc (cursor-onscreen-256x85) [173.650450] Starting subtest: cursor-onscreen-256x85 [173.696576] Subtest cursor-onscreen-256x85: SKIP (0.041s) [173.850181] [020/133] (847s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [173.958884] Starting subtest: basic-flip-after-cursor-varying-size [174.906444] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.947s) [175.730160] [021/133] (845s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt) [175.827767] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt [175.831841] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [175.940936] [022/133] (845s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant) [176.035223] Starting subtest: coverage-vs-premult-vs-constant [176.325846] Starting dynamic subtest: pipe-A-eDP-1 [176.870404] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.542s) [176.879861] Starting dynamic subtest: pipe-D-eDP-1 [178.139055] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.269s) [178.141343] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.104s) [178.983219] [023/133] (842s left) kms_flip (basic-plain-flip) [179.080849] Starting subtest: basic-plain-flip [179.083083] Starting dynamic subtest: A-eDP1 [180.795610] Dynamic subtest A-eDP1: SUCCESS (1.717s) [180.803781] Starting dynamic subtest: B-eDP1 [182.439725] Dynamic subtest B-eDP1: SUCCESS (1.643s) [182.449777] Starting dynamic subtest: C-eDP1 [184.065436] Dynamic subtest C-eDP1: SUCCESS (1.624s) [184.073413] Starting dynamic subtest: D-eDP1 [185.693755] Dynamic subtest D-eDP1: SUCCESS (1.628s) [185.698990] Subtest basic-plain-flip: SUCCESS (6.620s) [186.857026] [024/133] (834s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled) [186.917869] Starting subtest: multi-wait-available-unsubmitted-signaled [186.920330] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.001s) [187.023365] [025/133] (834s left) i915_hangman (gt-error-state-capture) [187.092818] Starting subtest: gt-error-state-capture [187.094985] Starting dynamic subtest: rcs0 [197.876776] Dynamic subtest rcs0: SUCCESS (10.782s) [197.886293] Starting dynamic subtest: bcs0 [209.908443] Dynamic subtest bcs0: SUCCESS (12.028s) [209.919734] Starting dynamic subtest: vcs0 [221.811653] Dynamic subtest vcs0: SUCCESS (11.902s) [221.829739] Starting dynamic subtest: vcs1 [232.885293] Dynamic subtest vcs1: SUCCESS (11.071s) [232.897033] Starting dynamic subtest: vecs0 [244.853068] Dynamic subtest vecs0: SUCCESS (11.966s) [244.865028] Starting dynamic subtest: ccs0 [256.884572] Dynamic subtest ccs0: SUCCESS (12.030s) [256.887703] Subtest gt-error-state-capture: SUCCESS (69.789s) [257.026327] [026/133] (764s left) gem_exec_balancer (nohangcheck) [257.294387] Starting subtest: nohangcheck [258.197770] Subtest nohangcheck: SUCCESS (0.904s) [258.318754] [027/133] (763s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled) [258.366779] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [258.369128] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s) [258.465240] [028/133] (763s left) api_intel_bb (add-remove-objects) [258.525094] Starting subtest: add-remove-objects [258.538597] Subtest add-remove-objects: SUCCESS (0.014s) [258.672942] [029/133] (762s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt) [258.785681] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt [263.311523] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.529s) [264.447861] [030/133] (757s left) gem_userptr_blits (vma-merge) [264.539141] Starting subtest: vma-merge [264.575752] Subtest vma-merge: SUCCESS (0.039s) [264.698033] [031/133] (756s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [264.793771] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu [264.798128] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [264.885493] [032/133] (756s left) gem_exec_fence (syncobj-wait) [265.341285] Starting subtest: syncobj-wait [266.839546] Subtest syncobj-wait: SUCCESS (1.497s) [267.172992] [FACT gem_exec_fence (syncobj-wait)] new: kernel.kmod_is_loaded.vgem: true [267.176369] [033/133] (754s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs) [267.275241] Starting subtest: random-ccs-data-4-tiled-lnl-ccs [267.280043] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s) [268.377787] [034/133] (753s left) i915_suspend (forcewake) [268.429322] Starting subtest: forcewake [300.315352] Subtest forcewake: SUCCESS (3.160s) [300.386169] [035/133] (721s left) syncobj_basic (bad-pad-handle-to-fd) [300.458403] Starting subtest: bad-pad-handle-to-fd [300.460393] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s) [300.564871] [036/133] (721s left) kms_cursor_legacy (cursora-vs-flipb-varying-size) [300.681777] Starting subtest: cursorA-vs-flipB-varying-size [300.686101] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s) [300.826400] [037/133] (721s left) gem_mmap (basic-small-bo) [300.877483] Subtest basic-small-bo: SKIP (0.000s) [300.936735] [038/133] (721s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc) [301.037879] Starting subtest: fbcpsr-rgb565-draw-mmap-wc [307.893417] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.824s) [308.020830] [039/133] (713s left) kms_content_protection (dp-mst-lic-type-0) [308.169024] Starting subtest: dp-mst-lic-type-0 [308.173538] Subtest dp-mst-lic-type-0: SKIP (0.000s) [308.301155] [040/133] (713s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt) [308.407378] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt [308.411803] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [308.517843] [041/133] (713s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25) [308.608675] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25 [308.611041] Starting dynamic subtest: pipe-A [308.628153] Dynamic subtest pipe-A: SKIP (0.016s) [308.638352] Starting dynamic subtest: pipe-B [308.658527] Dynamic subtest pipe-B: SKIP (0.029s) [308.668152] Starting dynamic subtest: pipe-C [308.689511] Dynamic subtest pipe-C: SKIP (0.029s) [308.700873] Starting dynamic subtest: pipe-D [308.716248] Dynamic subtest pipe-D: SKIP (0.028s) [308.720793] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.105s) [308.801842] [042/133] (713s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area) [308.905414] Starting subtest: psr2-plane-move-sf-dmg-area [308.907358] Starting dynamic subtest: pipe-A-eDP-1 [313.482638] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.566s) [313.492733] Starting dynamic subtest: pipe-B-eDP-1 [318.829020] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.340s) [318.831429] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.909s) [319.706560] [043/133] (702s left) api_intel_bb (destroy-bb) [319.764231] Starting subtest: destroy-bb [319.769043] Subtest destroy-bb: SUCCESS (0.007s) [319.896966] [044/133] (702s left) kms_chamelium_frames (hdmi-frame-dump) [320.285421] Subtest hdmi-frame-dump: SKIP (0.000s) [321.125613] [045/133] (701s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu) [321.234510] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu [327.813243] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.576s) [327.936975] [046/133] (694s left) gem_render_copy (y-tiled-ccs-to-x-tiled) [327.996869] Starting subtest: y-tiled-ccs-to-x-tiled [328.001518] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s) [328.185441] [047/133] (694s left) kms_cursor_crc (cursor-rapid-movement-128x128) [328.390985] Starting subtest: cursor-rapid-movement-128x128 [328.395696] Starting dynamic subtest: pipe-A-eDP-1 [328.947942] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.552s) [328.979904] Starting dynamic subtest: pipe-D-eDP-1 [330.187390] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.213s) [330.189582] Subtest cursor-rapid-movement-128x128: SUCCESS (1.792s) [331.048702] [048/133] (691s left) gem_pxp (create-regular-context-1) [331.170582] Starting subtest: create-regular-context-1 [331.173028] Subtest create-regular-context-1: SUCCESS (0.002s) [331.288311] [049/133] (691s left) kms_big_fb (linear-16bpp-rotate-0) [331.393619] Starting subtest: linear-16bpp-rotate-0 [332.806295] Subtest linear-16bpp-rotate-0: SUCCESS (1.412s) [332.942410] [050/133] (689s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted) [332.994321] Starting subtest: etime-multi-wait-all-available-unsubmitted [333.103802] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.107s) [333.180436] [051/133] (689s left) vgem_basic (bad-handle) [333.232046] Starting subtest: bad-handle [333.234463] Subtest bad-handle: SUCCESS (0.000s) [333.288675] [052/133] (689s left) kms_invalid_mode (uint-max-clock) [333.394029] Starting subtest: uint-max-clock [333.396235] Starting dynamic subtest: pipe-A-eDP-1 [333.697251] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.302s) [333.708375] Starting dynamic subtest: pipe-B-eDP-1 [333.710583] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [333.722189] Starting dynamic subtest: pipe-C-eDP-1 [333.724570] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [333.733803] Starting dynamic subtest: pipe-D-eDP-1 [333.736217] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [333.738502] Subtest uint-max-clock: SUCCESS (0.308s) [334.493278] [053/133] (688s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu) [334.594262] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu [338.507372] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (3.917s) [339.680538] [054/133] (682s left) gen7_exec_parse (oacontrol-tracking) [339.747239] Subtest oacontrol-tracking: SKIP (0.000s) [339.823164] [055/133] (682s left) kms_cursor_legacy (cursorb-vs-flipb-toggle) [339.939627] Starting subtest: cursorB-vs-flipB-toggle [339.944235] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s) [340.086171] [056/133] (682s left) kms_flip (2x-nonexisting-fb-interruptible) [340.183790] Starting subtest: 2x-nonexisting-fb-interruptible [340.195542] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.010s) [340.299845] [057/133] (682s left) perf (gen12-unprivileged-single-ctx-counters) [340.413890] Starting subtest: gen12-unprivileged-single-ctx-counters [340.416086] Starting dynamic subtest: rcs0 [340.628777] Dynamic subtest rcs0: SUCCESS (0.215s) [340.630845] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.216s) [340.676952] [058/133] (682s left) sw_sync (sync_multi_consumer_producer) [340.711949] Starting subtest: sync_multi_consumer_producer [341.046757] Subtest sync_multi_consumer_producer: SUCCESS (0.335s) [341.109590] [059/133] (681s left) kms_vblank (wait-idle) [341.238480] Starting subtest: wait-idle [341.240656] Starting dynamic subtest: pipe-A-eDP-1 [343.008360] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.769s) [343.022646] Starting dynamic subtest: pipe-D-eDP-1 [345.419622] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.408s) [345.422033] Subtest wait-idle: SUCCESS (4.181s) [346.246158] [060/133] (676s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt) [346.350407] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt [346.354574] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [346.461049] [061/133] (676s left) kms_psr (fbc-psr2-cursor-mmap-gtt) [346.549635] Starting subtest: fbc-psr2-cursor-mmap-gtt [346.551932] Starting dynamic subtest: eDP-1 [346.555997] Dynamic subtest eDP-1: SKIP (0.000s) [346.560018] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s) [346.624346] [062/133] (676s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt) [346.717074] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt [353.920981] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.203s) [354.054739] [063/133] (668s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling) [354.155974] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling [354.160503] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s) [354.232465] [064/133] (668s left) perf_pmu (invalid-open) [354.275389] Starting subtest: invalid-open [354.277965] Subtest invalid-open: SUCCESS (0.000s) [354.402020] [065/133] (668s left) kms_prop_blob (basic) [354.456097] Starting subtest: basic [354.458264] Subtest basic: SUCCESS (0.000s) [354.552662] [066/133] (668s left) kms_addfb_basic (size-max) [354.655734] Starting subtest: size-max [354.657932] Subtest size-max: SUCCESS (0.000s) [354.745002] [067/133] (668s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling) [354.844060] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling [354.846409] Starting dynamic subtest: pipe-A-default-mode [357.568856] Dynamic subtest pipe-A-default-mode: SUCCESS (2.724s) [357.571274] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.726s) [358.451686] [068/133] (664s left) gem_cs_tlb (engines) [358.520514] Starting subtest: engines [358.523055] Starting dynamic subtest: rcs0 [360.676396] Dynamic subtest rcs0: SUCCESS (2.151s) [360.688676] Starting dynamic subtest: bcs0 [362.828549] Dynamic subtest bcs0: SUCCESS (2.151s) [362.840963] Starting dynamic subtest: vcs0 [364.983466] Dynamic subtest vcs0: SUCCESS (2.152s) [364.996178] Starting dynamic subtest: vcs1 [367.137385] Dynamic subtest vcs1: SUCCESS (2.153s) [367.147844] Starting dynamic subtest: vecs0 [369.292583] Dynamic subtest vecs0: SUCCESS (2.152s) [369.305101] Starting dynamic subtest: ccs0 [371.445304] Dynamic subtest ccs0: SUCCESS (2.151s) [371.447281] Subtest engines: SUCCESS (12.918s) [371.559572] [069/133] (651s left) gem_softpin (reverse) [371.623845] Starting subtest: reverse [371.628279] Subtest reverse: SUCCESS (0.007s) [371.741160] [070/133] (651s left) gem_softpin (softpin) [371.807562] Starting subtest: softpin [404.179518] Subtest softpin: SUCCESS (32.360s) [404.307842] [071/133] (619s left) kms_getfb (getfb2-handle-not-fb) [404.413905] Starting subtest: getfb2-handle-not-fb [404.416089] Subtest getfb2-handle-not-fb: SUCCESS (0.000s) [404.534226] [072/133] (618s left) fbdev (unaligned-write) [404.579629] Starting subtest: unaligned-write [404.678370] Subtest unaligned-write: SUCCESS (0.098s) [404.742537] [073/133] (618s left) gem_exec_schedule (smoketest-all) [404.806732] Starting subtest: smoketest-all [437.160011] Subtest smoketest-all: SUCCESS (32.312s) [438.707545] [074/133] (584s left) gem_lmem_swapping (parallel-random-verify-ccs) [438.751700] Subtest parallel-random-verify-ccs: SKIP (0.000s) [438.799502] [075/133] (584s left) kms_big_fb (4-tiled-8bpp-rotate-0) [438.897287] Starting subtest: 4-tiled-8bpp-rotate-0 [439.999682] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.102s) [440.122558] [076/133] (583s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt) [440.226213] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt [440.230538] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [440.329230] [077/133] (583s left) kms_legacy_colorkey (basic) [440.431205] Starting subtest: basic [440.432840] Starting dynamic subtest: pipe-A [440.475068] Dynamic subtest pipe-A: SUCCESS (0.045s) [440.487257] Starting dynamic subtest: pipe-B [440.489106] Dynamic subtest pipe-B: SUCCESS (0.001s) [440.497735] Starting dynamic subtest: pipe-C [440.499374] Dynamic subtest pipe-C: SUCCESS (0.000s) [440.507399] Starting dynamic subtest: pipe-D [440.508970] Dynamic subtest pipe-D: SUCCESS (0.000s) [440.510527] Subtest basic: SUCCESS (0.051s) [440.545173] [078/133] (583s left) syncobj_basic (bad-destroy-pad) [440.599682] Starting subtest: bad-destroy-pad [440.601529] Subtest bad-destroy-pad: SUCCESS (0.000s) [440.681274] [079/133] (582s left) gem_exec_fence (syncobj-invalid-wait) [441.145872] Starting subtest: syncobj-invalid-wait [441.148189] Subtest syncobj-invalid-wait: SUCCESS (0.000s) [442.725087] [080/133] (580s left) kms_flip (blocking-absolute-wf_vblank-interruptible) [442.816624] Starting subtest: blocking-absolute-wf_vblank-interruptible [442.818910] Starting dynamic subtest: A-eDP1 [451.492901] Dynamic subtest A-eDP1: SUCCESS (8.673s) [451.507645] Starting dynamic subtest: B-eDP1 [460.226994] Dynamic subtest B-eDP1: SUCCESS (8.730s) [460.239643] Starting dynamic subtest: C-eDP1 [468.944271] Dynamic subtest C-eDP1: SUCCESS (8.713s) [468.953651] Starting dynamic subtest: D-eDP1 [477.670095] Dynamic subtest D-eDP1: SUCCESS (8.722s) [477.675509] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.851s) [478.878226] [081/133] (544s left) kms_addfb_basic (bad-pitch-256) [478.942044] Starting subtest: bad-pitch-256 [478.944437] Subtest bad-pitch-256: SUCCESS (0.000s) [479.096195] [082/133] (544s left) gem_userptr_blits (coherency-sync) [479.164442] Starting subtest: coherency-sync [479.573380] Subtest coherency-sync: SKIP (0.370s) [479.679410] [083/133] (544s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled) [479.777878] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled [479.782392] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s) [479.960690] [084/133] (543s left) syncobj_wait (wait-all-snapshot) [480.023398] Starting subtest: wait-all-snapshot [480.102673] Subtest wait-all-snapshot: SUCCESS (0.081s) [480.182157] [085/133] (543s left) kms_psr (psr-primary-blt) [480.280926] Starting subtest: psr-primary-blt [480.283226] Starting dynamic subtest: eDP-1 [481.980845] Dynamic subtest eDP-1: SUCCESS (1.701s) [481.983255] Subtest psr-primary-blt: SUCCESS (1.702s) [482.845838] [086/133] (541s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render) [482.945656] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render [482.949952] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [483.050092] [087/133] (540s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc) [483.152759] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc [483.155010] Starting dynamic subtest: pipe-A-eDP-1 [483.177593] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [483.189585] Starting dynamic subtest: pipe-B-eDP-1 [483.211059] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [483.220193] Starting dynamic subtest: pipe-C-eDP-1 [483.241363] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [483.250894] Starting dynamic subtest: pipe-D-eDP-1 [483.272159] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [483.276226] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [485.399157] [088/133] (538s left) kms_addfb_basic (invalid-set-prop) [485.457399] Starting subtest: invalid-set-prop [485.459758] Subtest invalid-set-prop: SUCCESS (0.000s) [485.610806] [089/133] (538s left) gem_ctx_shared (q-promotion) [485.685657] Starting subtest: Q-promotion [485.688403] Starting dynamic subtest: rcs0 [485.783903] Dynamic subtest rcs0: SUCCESS (0.097s) [485.800695] Starting dynamic subtest: vcs0 [485.863120] Dynamic subtest vcs0: SUCCESS (0.079s) [485.880074] Starting dynamic subtest: vcs1 [485.943189] Dynamic subtest vcs1: SUCCESS (0.079s) [485.961265] Starting dynamic subtest: vecs0 [486.025689] Dynamic subtest vecs0: SUCCESS (0.080s) [486.042710] Starting dynamic subtest: ccs0 [486.106125] Dynamic subtest ccs0: SUCCESS (0.079s) [486.108648] Subtest Q-promotion: SUCCESS (0.420s) [487.705011] [090/133] (536s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip) [487.819263] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip [488.946432] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.124s) [489.063603] [091/133] (535s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted) [489.123435] Starting subtest: multi-wait-all-for-submit-available-submitted [489.125443] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s) [489.233335] [092/133] (534s left) kms_busy (basic) [489.334074] Starting subtest: basic [489.335975] Starting dynamic subtest: flip [489.928179] Dynamic subtest flip: SUCCESS (0.592s) [489.939004] Starting dynamic subtest: modeset [493.353002] Dynamic subtest modeset: SUCCESS (3.422s) [493.355350] Subtest basic: SUCCESS (4.017s) [494.147371] [093/133] (530s left) gem_exec_schedule (u-independent) [494.225045] Starting subtest: u-independent [494.227030] Starting dynamic subtest: rcs0 [495.619260] Dynamic subtest rcs0: SUCCESS (1.402s) [495.633129] Starting dynamic subtest: vcs0 [497.613219] Dynamic subtest vcs0: SUCCESS (1.991s) [497.629796] Starting dynamic subtest: vcs1 [499.658970] Dynamic subtest vcs1: SUCCESS (2.044s) [499.672083] Starting dynamic subtest: vecs0 [501.654260] Dynamic subtest vecs0: SUCCESS (1.992s) [501.667567] Starting dynamic subtest: ccs0 [503.619737] Dynamic subtest ccs0: SUCCESS (1.963s) [503.622724] Subtest u-independent: SUCCESS (9.402s) [503.934154] [094/133] (520s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic) [504.040913] Starting subtest: async-flip-with-page-flip-events-tiled-atomic [504.427282] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [507.225638] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.797s) [507.238166] Starting dynamic subtest: pipe-A-eDP-1-4 [509.412838] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.185s) [509.425405] Starting dynamic subtest: pipe-A-eDP-1-4 [511.423773] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s) [511.435897] Starting dynamic subtest: pipe-A-eDP-1-x [513.604117] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.179s) [513.968594] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [516.758092] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.796s) [516.771873] Starting dynamic subtest: pipe-B-eDP-1-4 [518.932799] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.173s) [518.945564] Starting dynamic subtest: pipe-B-eDP-1-4 [520.943799] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.008s) [520.956114] Starting dynamic subtest: pipe-B-eDP-1-x [523.146244] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.200s) [523.521954] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [526.289191] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.775s) [526.301478] Starting dynamic subtest: pipe-C-eDP-1-4 [528.507090] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.218s) [528.517891] Starting dynamic subtest: pipe-C-eDP-1-4 [530.517273] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s) [530.530480] Starting dynamic subtest: pipe-C-eDP-1-x [532.694908] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s) [533.057703] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [535.818341] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.768s) [535.828174] Starting dynamic subtest: pipe-D-eDP-1-4 [537.993049] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s) [538.003516] Starting dynamic subtest: pipe-D-eDP-1-4 [540.002382] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s) [540.016014] Starting dynamic subtest: pipe-D-eDP-1-x [542.180716] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.176s) [542.183557] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.139s) [543.411578] [095/133] (480s left) kms_cursor_crc (cursor-sliding-256x256) [543.662116] Starting subtest: cursor-sliding-256x256 [543.667909] Starting dynamic subtest: pipe-A-eDP-1 [546.960560] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.293s) [546.990199] Starting dynamic subtest: pipe-D-eDP-1 [550.900052] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.918s) [550.902403] Subtest cursor-sliding-256x256: SUCCESS (7.238s) [551.761164] [096/133] (472s left) gem_exec_whisper (basic-fds-priority) [551.841173] Starting subtest: basic-fds-priority [574.409557] Subtest basic-fds-priority: SUCCESS (22.570s) [574.598819] [097/133] (449s left) gem_ctx_param (non-root-set) [574.658196] Starting subtest: non-root-set [574.686898] Subtest non-root-set: SUCCESS (0.029s) [574.799251] [098/133] (449s left) kms_big_fb (yf-tiled-64bpp-rotate-270) [574.899368] Starting subtest: yf-tiled-64bpp-rotate-270 [574.903870] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s) [574.992975] [099/133] (449s left) kms_async_flips (test-time-stamp-atomic) [575.077529] Starting subtest: test-time-stamp-atomic [575.453865] Starting dynamic subtest: pipe-A-eDP-1 [576.258050] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.802s) [576.640316] Starting dynamic subtest: pipe-B-eDP-1 [577.396096] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.761s) [577.761484] Starting dynamic subtest: pipe-C-eDP-1 [578.526692] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.772s) [578.897102] Starting dynamic subtest: pipe-D-eDP-1 [579.660877] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.772s) [579.663166] Subtest test-time-stamp-atomic: SUCCESS (4.584s) [580.838295] [100/133] (443s left) kms_chamelium_hpd (hdmi-hpd-storm) [581.224186] Subtest hdmi-hpd-storm: SKIP (0.000s) [582.042743] [101/133] (442s left) kms_color (ctm-red-to-blue) [582.139001] Starting subtest: ctm-red-to-blue [582.141192] Starting dynamic subtest: pipe-A-eDP-1 [582.850675] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.712s) [582.860753] Starting dynamic subtest: pipe-B-eDP-1 [584.275349] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.424s) [584.286746] Starting dynamic subtest: pipe-C-eDP-1 [585.648590] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.371s) [585.659299] Starting dynamic subtest: pipe-D-eDP-1 [586.978964] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.331s) [586.981326] Subtest ctm-red-to-blue: SUCCESS (4.841s) [587.782653] [102/133] (436s left) kms_plane_lowres (tiling-4) [587.871934] Starting subtest: tiling-4 [587.874317] Starting dynamic subtest: pipe-A-eDP-1 [587.878924] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [588.167464] Starting dynamic subtest: pipe-B-eDP-1 [588.172135] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [588.182234] Starting dynamic subtest: pipe-C-eDP-1 [588.186952] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [588.196918] Starting dynamic subtest: pipe-D-eDP-1 [588.201046] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [588.205196] Subtest tiling-4: SKIP (0.293s) [589.007784] [103/133] (435s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu) [589.100501] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu [589.104809] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [589.195708] [104/133] (435s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt) [589.297523] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt [596.105067] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.811s) [596.253618] [105/133] (428s left) kms_dp_link_training (non-uhbr-mst) [596.345929] Starting subtest: non-uhbr-mst [596.354396] Subtest non-uhbr-mst: SKIP (0.000s) [596.433884] [106/133] (428s left) kms_psr (psr2-sprite-mmap-gtt) [596.530023] Starting subtest: psr2-sprite-mmap-gtt [596.532320] Starting dynamic subtest: eDP-1 [597.963975] Dynamic subtest eDP-1: SKIP (1.431s) [597.968907] Subtest psr2-sprite-mmap-gtt: SKIP (1.433s) [598.135135] [107/133] (426s left) i915_drm_fdinfo (virtual-busy) [598.187159] Starting subtest: virtual-busy [598.191675] Subtest virtual-busy: SKIP (0.000s) [598.261271] [108/133] (426s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf) [598.373797] Starting subtest: psr2-cursor-plane-move-continuous-sf [598.376411] Starting dynamic subtest: pipe-A-eDP-1 [608.727886] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.359s) [608.738561] Starting dynamic subtest: pipe-B-eDP-1 [619.770764] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.039s) [619.773538] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.402s) [620.571346] [109/133] (404s left) gem_ctx_persistence (saturated-hostile-nopreempt) [620.637662] Starting subtest: saturated-hostile-nopreempt [620.640055] Starting dynamic subtest: rcs0 [620.697652] Dynamic subtest rcs0: SKIP (0.057s) [620.710716] Starting dynamic subtest: bcs0 [620.715578] Dynamic subtest bcs0: SKIP (0.015s) [620.725338] Starting dynamic subtest: vcs0 [620.729932] Dynamic subtest vcs0: SKIP (0.013s) [620.739403] Starting dynamic subtest: vcs1 [620.743767] Dynamic subtest vcs1: SKIP (0.012s) [620.753500] Starting dynamic subtest: vecs0 [620.757960] Dynamic subtest vecs0: SKIP (0.011s) [620.767476] Starting dynamic subtest: ccs0 [620.771941] Dynamic subtest ccs0: SKIP (0.011s) [620.776135] Subtest saturated-hostile-nopreempt: SKIP (0.126s) [620.840804] [110/133] (404s left) gem_caching (reads) [620.905204] Subtest reads: SKIP (0.000s) [620.984236] [111/133] (404s left) perf (invalid-oa-exponent) [621.092187] Starting subtest: invalid-oa-exponent [621.102364] Subtest invalid-oa-exponent: SUCCESS (0.012s) [621.155225] [112/133] (403s left) gem_exec_params (rel-constants-invalid-rel-gen5) [621.209453] Starting subtest: rel-constants-invalid-rel-gen5 [621.211828] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s) [621.351772] [113/133] (403s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite) [621.457273] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite [621.461700] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [621.547020] [114/133] (403s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs) [621.638329] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs [621.640130] Starting dynamic subtest: pipe-A-eDP-1 [621.658646] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [621.670114] Starting dynamic subtest: pipe-B-eDP-1 [621.687789] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [621.696653] Starting dynamic subtest: pipe-C-eDP-1 [621.713906] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [621.722771] Starting dynamic subtest: pipe-D-eDP-1 [621.740779] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [621.744345] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s) [623.942269] [115/133] (401s left) syncobj_timeline (wait-all-delayed-signal) [623.999666] Starting subtest: wait-all-delayed-signal [624.103464] Subtest wait-all-delayed-signal: SUCCESS (0.103s) [624.216512] [116/133] (401s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt) [624.308917] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt [624.313212] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [624.404939] [117/133] (400s left) kms_big_fb (y-tiled-16bpp-rotate-90) [624.501095] Starting subtest: y-tiled-16bpp-rotate-90 [624.505293] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s) [624.592287] [118/133] (400s left) kms_psr (pr-primary-render) [624.685116] Starting subtest: pr-primary-render [624.689453] Subtest pr-primary-render: SKIP (0.000s) [624.765520] [119/133] (400s left) syncobj_wait (invalid-reset-zero-handles) [624.817096] Starting subtest: invalid-reset-zero-handles [624.818995] Subtest invalid-reset-zero-handles: SUCCESS (0.000s) [624.913650] [120/133] (400s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc) [625.008020] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc [625.009884] Starting dynamic subtest: pipe-A-eDP-1 [625.902306] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.888s) [625.912577] Starting dynamic subtest: pipe-B-eDP-1 [627.459657] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.553s) [627.470777] Starting dynamic subtest: pipe-C-eDP-1 [628.988091] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.527s) [628.999926] Starting dynamic subtest: pipe-D-eDP-1 [630.497278] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.509s) [630.499461] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.482s) [631.661234] [121/133] (393s left) gem_exec_schedule (noreorder) [631.840169] Starting subtest: noreorder [631.842902] Starting dynamic subtest: rcs0 [631.896788] Dynamic subtest rcs0: SUCCESS (0.057s) [631.909588] Starting dynamic subtest: vcs0 [633.598457] Dynamic subtest vcs0: SUCCESS (1.698s) [633.612661] Starting dynamic subtest: vcs1 [635.589118] Dynamic subtest vcs1: SUCCESS (1.988s) [635.602703] Starting dynamic subtest: vecs0 [637.634059] Dynamic subtest vecs0: SUCCESS (2.042s) [637.646652] Starting dynamic subtest: ccs0 [637.699647] Dynamic subtest ccs0: SUCCESS (0.064s) [637.702142] Subtest noreorder: SUCCESS (5.860s) [637.887526] [122/133] (387s left) gem_exec_capture (capture) [637.946749] Starting subtest: capture [637.949043] Starting dynamic subtest: rcs0-smem [638.787703] Dynamic subtest rcs0-smem: SUCCESS (0.839s) [638.802489] Starting dynamic subtest: bcs0-smem [639.616716] Dynamic subtest bcs0-smem: SUCCESS (0.827s) [639.628888] Starting dynamic subtest: vcs0-smem [640.440544] Dynamic subtest vcs0-smem: SUCCESS (0.823s) [640.452911] Starting dynamic subtest: vcs1-smem [641.261280] Dynamic subtest vcs1-smem: SUCCESS (0.819s) [641.272733] Starting dynamic subtest: vecs0-smem [642.653038] Dynamic subtest vecs0-smem: FAIL (1.334s) [642.663530] Starting dynamic subtest: ccs0-smem [643.920602] Dynamic subtest ccs0-smem: SUCCESS (1.325s) [643.922935] Subtest capture: FAIL (5.971s) [644.042404] [123/133] (381s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu) [644.138871] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu [644.142962] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [644.246797] [124/133] (381s left) gem_exec_reloc (basic-wc-active) [644.302837] Subtest basic-wc-active: SKIP (0.000s) [644.384397] [125/133] (381s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0) [644.472362] Starting subtest: linear-max-hw-stride-64bpp-rotate-0 [645.462527] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (0.990s) [645.597870] [126/133] (380s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible) [645.659782] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s) [645.728743] [127/133] (380s left) syncobj_wait (wait-for-submit-delayed-submit) [645.774467] Starting subtest: wait-for-submit-delayed-submit [645.877114] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s) [645.955929] [128/133] (379s left) dumb_buffer (map-invalid-size) [646.020067] Starting subtest: map-invalid-size [646.022533] Subtest map-invalid-size: SUCCESS (0.000s) [646.127789] [129/133] (379s left) gem_mmap_gtt (basic-small-copy) [646.186363] Subtest basic-small-copy: SKIP (0.000s) [646.242385] [130/133] (379s left) sw_sync (sync_expired_merge) [646.280782] Starting subtest: sync_expired_merge [647.354655] Subtest sync_expired_merge: SUCCESS (1.074s) [647.417785] [131/133] (378s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping) [647.509986] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping [647.535707] Starting dynamic subtest: pipe-A-plane-0 [647.824442] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s) [647.835373] Starting dynamic subtest: pipe-A-plane-3 [648.057956] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s) [649.146195] Starting dynamic subtest: pipe-B-plane-0 [649.438328] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s) [649.455320] Starting dynamic subtest: pipe-B-plane-3 [649.671002] Dynamic subtest pipe-B-plane-3: SUCCESS (0.231s) [649.983742] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.473s) [650.826553] [132/133] (375s left) gem_mmap_offset (close-race) [650.895920] Starting subtest: close-race [671.007633] Subtest close-race: SUCCESS (20.107s) [671.147409] [133/133] (354s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted) [671.208513] Starting subtest: etime-single-wait-for-submit-available-unsubmitted [671.310929] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.102s) [671.389054] Closing watchdogs results: parsing output: 0/ for test: kms_rotation_crc results: parsing output: 1/ for test: kms_psr2_sf results: parsing output: 2/ for test: i915_pm_rps results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: kms_sequence results: parsing output: 5/ for test: kms_pm_rpm results: parsing output: 6/ for test: kms_plane results: parsing output: 7/ for test: core_auth results: parsing output: 8/ for test: gem_ctx_persistence results: parsing output: 9/ for test: gem_exec_reloc results: parsing output: 10/ for test: kms_psr results: parsing output: 11/ for test: gem_exec_reloc results: parsing output: 12/ for test: prime_busy results: parsing output: 13/ for test: gem_reg_read results: parsing output: 14/ for test: kms_ccs results: parsing output: 15/ for test: gem_pxp results: parsing output: 16/ for test: kms_feature_discovery results: parsing output: 17/ for test: gem_exec_whisper results: parsing output: 18/ for test: kms_cursor_crc results: parsing output: 19/ for test: kms_cursor_legacy results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: kms_plane_alpha_blend results: parsing output: 22/ for test: kms_flip results: parsing output: 23/ for test: syncobj_timeline results: parsing output: 24/ for test: i915_hangman results: parsing output: 25/ for test: gem_exec_balancer results: parsing output: 26/ for test: syncobj_wait results: parsing output: 27/ for test: api_intel_bb results: parsing output: 28/ for test: kms_frontbuffer_tracking results: parsing output: 29/ for test: gem_userptr_blits results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: gem_exec_fence results: parsing output: 32/ for test: kms_ccs results: parsing output: 33/ for test: i915_suspend results: parsing output: 34/ for test: syncobj_basic results: parsing output: 35/ for test: kms_cursor_legacy results: parsing output: 36/ for test: gem_mmap results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: kms_content_protection results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: kms_plane_scaling results: parsing output: 41/ for test: kms_psr2_sf results: parsing output: 42/ for test: api_intel_bb results: parsing output: 43/ for test: kms_chamelium_frames results: parsing output: 44/ for test: kms_frontbuffer_tracking results: parsing output: 45/ for test: gem_render_copy results: parsing output: 46/ for test: kms_cursor_crc results: parsing output: 47/ for test: gem_pxp results: parsing output: 48/ for test: kms_big_fb results: parsing output: 49/ for test: syncobj_timeline results: parsing output: 50/ for test: vgem_basic results: parsing output: 51/ for test: kms_invalid_mode results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: gen7_exec_parse results: parsing output: 54/ for test: kms_cursor_legacy results: parsing output: 55/ for test: kms_flip results: parsing output: 56/ for test: perf results: parsing output: 57/ for test: sw_sync results: parsing output: 58/ for test: kms_vblank results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: kms_psr results: parsing output: 61/ for test: kms_frontbuffer_tracking results: parsing output: 62/ for test: kms_flip_scaled_crc results: parsing output: 63/ for test: perf_pmu results: parsing output: 64/ for test: kms_prop_blob results: parsing output: 65/ for test: kms_addfb_basic results: parsing output: 66/ for test: kms_flip_scaled_crc results: parsing output: 67/ for test: gem_cs_tlb results: parsing output: 68/ for test: gem_softpin results: parsing output: 69/ for test: gem_softpin results: parsing output: 70/ for test: kms_getfb results: parsing output: 71/ for test: fbdev results: parsing output: 72/ for test: gem_exec_schedule results: parsing output: 73/ for test: gem_lmem_swapping results: parsing output: 74/ for test: kms_big_fb results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: kms_legacy_colorkey results: parsing output: 77/ for test: syncobj_basic results: parsing output: 78/ for test: gem_exec_fence results: parsing output: 79/ for test: kms_flip results: parsing output: 80/ for test: kms_addfb_basic results: parsing output: 81/ for test: gem_userptr_blits results: parsing output: 82/ for test: gem_render_copy results: parsing output: 83/ for test: syncobj_wait results: parsing output: 84/ for test: kms_psr results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: kms_ccs results: parsing output: 87/ for test: kms_addfb_basic results: parsing output: 88/ for test: gem_ctx_shared results: parsing output: 89/ for test: kms_big_fb results: parsing output: 90/ for test: syncobj_timeline results: parsing output: 91/ for test: kms_busy results: parsing output: 92/ for test: gem_exec_schedule results: parsing output: 93/ for test: kms_async_flips results: parsing output: 94/ for test: kms_cursor_crc results: parsing output: 95/ for test: gem_exec_whisper results: parsing output: 96/ for test: gem_ctx_param results: parsing output: 97/ for test: kms_big_fb results: parsing output: 98/ for test: kms_async_flips results: parsing output: 99/ for test: kms_chamelium_hpd results: parsing output: 100/ for test: kms_color results: parsing output: 101/ for test: kms_plane_lowres results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: kms_dp_link_training results: parsing output: 105/ for test: kms_psr results: parsing output: 106/ for test: i915_drm_fdinfo results: parsing output: 107/ for test: kms_psr2_sf results: parsing output: 108/ for test: gem_ctx_persistence results: parsing output: 109/ for test: gem_caching results: parsing output: 110/ for test: perf results: parsing output: 111/ for test: gem_exec_params results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: kms_ccs results: parsing output: 114/ for test: syncobj_timeline results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: kms_big_fb results: parsing output: 117/ for test: kms_psr results: parsing output: 118/ for test: syncobj_wait results: parsing output: 119/ for test: kms_ccs results: parsing output: 120/ for test: gem_exec_schedule results: parsing output: 121/ for test: gem_exec_capture results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: gem_exec_reloc results: parsing output: 124/ for test: kms_big_fb results: parsing output: 125/ for test: gem_fenced_exec_thrash results: parsing output: 126/ for test: syncobj_wait results: parsing output: 127/ for test: dumb_buffer results: parsing output: 128/ for test: gem_mmap_gtt results: parsing output: 129/ for test: sw_sync results: parsing output: 130/ for test: kms_plane results: parsing output: 131/ for test: gem_mmap_offset results: parsing output: 132/ for test: syncobj_timeline Done.