[56.598414] Initializing watchdogs [56.598460] /dev/watchdog0 [56.613244] [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] [56.618191] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [56.621164] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [56.624527] [001/156] (960s left) kms_psr (fbc-pr-primary-page-flip) [56.758926] Starting subtest: fbc-pr-primary-page-flip [56.763467] Subtest fbc-pr-primary-page-flip: SKIP (0.000s) [56.829451] [002/156] (960s left) kms_cursor_crc (cursor-rapid-movement-128x128) [57.029490] Starting subtest: cursor-rapid-movement-128x128 [57.042459] Starting dynamic subtest: pipe-A-eDP-1 [57.656133] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.611s) [57.687265] Starting dynamic subtest: pipe-D-eDP-1 [58.875185] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.192s) [58.877426] Subtest cursor-rapid-movement-128x128: SUCCESS (1.844s) [59.720528] [003/156] (957s left) gem_ctx_param (invalid-param-set) [59.778743] Starting subtest: invalid-param-set [59.781687] Subtest invalid-param-set: SUCCESS (0.000s) [59.851375] [004/156] (957s left) gem_exec_balancer (nop) [59.906968] Starting subtest: nop [106.635676] Subtest nop: SUCCESS (46.701s) [106.949094] [005/156] (910s left) kms_flip (flip-vs-modeset-vs-hang) [107.047539] Starting subtest: flip-vs-modeset-vs-hang [107.049998] Starting dynamic subtest: A-eDP1 [157.787684] Dynamic subtest A-eDP1: SUCCESS (50.735s) [157.795538] Starting dynamic subtest: D-eDP1 [207.765802] Dynamic subtest D-eDP1: SUCCESS (49.974s) [207.768705] Subtest flip-vs-modeset-vs-hang: SUCCESS (100.713s) [208.148468] [006/156] (809s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt) [208.253978] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt [208.258615] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [208.356297] [007/156] (808s left) gem_exec_fence (syncobj-backward-timeline-chain-engines) [208.913317] Starting subtest: syncobj-backward-timeline-chain-engines [209.008078] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.096s) [210.380393] [FACT gem_exec_fence (syncobj-backward-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true [210.383964] [008/156] (807s left) gem_spin_batch (legacy-resubmit-new) [210.445465] Starting subtest: legacy-resubmit-new [210.447909] Starting dynamic subtest: default [210.453901] Dynamic subtest default: SUCCESS (0.008s) [210.465802] Starting dynamic subtest: render [210.468253] Dynamic subtest render: SUCCESS (0.003s) [210.479750] Starting dynamic subtest: bsd [210.482188] Dynamic subtest bsd: SUCCESS (0.005s) [210.489692] Starting dynamic subtest: bsd1 [210.491682] Dynamic subtest bsd1: SUCCESS (0.006s) [210.499038] Starting dynamic subtest: bsd2 [210.500975] Dynamic subtest bsd2: SUCCESS (0.003s) [210.508218] Starting dynamic subtest: blt [210.510125] Dynamic subtest blt: SUCCESS (0.004s) [210.517408] Starting dynamic subtest: vebox [210.519320] Dynamic subtest vebox: SUCCESS (0.004s) [210.521200] Subtest legacy-resubmit-new: SUCCESS (0.036s) [212.339207] [009/156] (805s left) kms_frontbuffer_tracking (psrhdr-slowdraw) [212.446576] Starting subtest: psrhdr-slowdraw [212.450837] Subtest psrhdr-slowdraw: SKIP (0.000s) [212.557288] [010/156] (804s left) perf (invalid-create-userspace-config) [212.682369] Starting subtest: invalid-create-userspace-config [212.684611] Subtest invalid-create-userspace-config: SUCCESS (0.001s) [212.725168] [011/156] (804s left) gem_eio (in-flight-contexts-1us) [212.946874] Starting subtest: in-flight-contexts-1us [226.328543] Subtest in-flight-contexts-1us: SUCCESS (13.379s) [226.509239] [012/156] (791s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-render) [226.614587] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-render [226.618971] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [226.695986] [013/156] (790s left) kms_cursor_edge_walk (64x64-top-bottom) [226.787650] Starting subtest: 64x64-top-bottom [226.790091] Starting dynamic subtest: pipe-A-eDP-1 [230.306820] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.518s) [230.317086] Starting dynamic subtest: pipe-D-eDP-1 [233.424262] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.114s) [233.426545] Subtest 64x64-top-bottom: SUCCESS (6.635s) [234.222935] [014/156] (783s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs) [234.316960] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs [234.319319] Starting dynamic subtest: pipe-A-eDP-1 [234.792700] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.449s) [234.802274] Starting dynamic subtest: pipe-B-eDP-1 [236.266066] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.471s) [236.276133] Starting dynamic subtest: pipe-C-eDP-1 [237.636016] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.368s) [237.653817] Starting dynamic subtest: pipe-D-eDP-1 [238.991784] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.358s) [238.994063] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.650s) [240.146319] [015/156] (777s left) kms_frontbuffer_tracking (psrhdr-farfromfence-mmap-gtt) [240.255904] Starting subtest: psrhdr-farfromfence-mmap-gtt [240.260426] Subtest psrhdr-farfromfence-mmap-gtt: SKIP (0.000s) [240.371698] [016/156] (777s left) kms_properties (plane-properties-atomic) [240.467748] Starting subtest: plane-properties-atomic [240.469672] Starting dynamic subtest: pipe-A-eDP-1 [241.026958] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.558s) [241.036888] Starting dynamic subtest: pipe-B-eDP-1 [242.327059] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.299s) [242.337815] Starting dynamic subtest: pipe-C-eDP-1 [243.639029] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.312s) [243.647841] Starting dynamic subtest: pipe-D-eDP-1 [244.875142] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.235s) [244.877431] Subtest plane-properties-atomic: SUCCESS (4.409s) [245.674546] [017/156] (772s left) gem_pwrite (basic-exhaustion) [245.743580] Subtest basic-exhaustion: SKIP (0.000s) [245.804673] [018/156] (772s left) gem_userptr_blits (create-destroy-unsync) [245.861135] Subtest create-destroy-unsync: SKIP (0.000s) [245.994196] [019/156] (771s left) kms_psr (fbc-psr-cursor-blt) [246.084242] Starting subtest: fbc-psr-cursor-blt [246.086551] Starting dynamic subtest: eDP-1 [246.090690] Dynamic subtest eDP-1: SKIP (0.000s) [246.094851] Subtest fbc-psr-cursor-blt: SKIP (0.001s) [246.158175] [020/156] (771s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render) [246.250232] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render [253.039823] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.795s) [253.176695] [021/156] (764s left) kms_plane_scaling (invalid-num-scalers) [253.271685] Starting subtest: invalid-num-scalers [253.274625] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers [253.292640] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.019s) [253.302900] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers [253.327771] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.035s) [253.336668] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers [253.366059] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.036s) [253.374926] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers [253.402511] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.035s) [253.404840] Subtest invalid-num-scalers: SUCCESS (0.130s) [253.502079] [022/156] (764s left) kms_psr (psr-cursor-plane-onoff) [253.591894] Starting subtest: psr-cursor-plane-onoff [253.594140] Starting dynamic subtest: eDP-1 [255.287908] Dynamic subtest eDP-1: SUCCESS (1.695s) [255.290279] Subtest psr-cursor-plane-onoff: SUCCESS (1.696s) [256.167813] [023/156] (761s left) api_intel_allocator (two-level-inception-interruptible) [256.239169] Starting subtest: two-level-inception-interruptible [261.644432] Subtest two-level-inception-interruptible: SUCCESS (5.405s) [261.739380] [024/156] (756s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs) [261.842295] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs [261.846997] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s) [262.986504] [025/156] (755s left) kms_plane (pixel-format-4-tiled-modifier) [263.082791] Starting subtest: pixel-format-4-tiled-modifier [263.109424] Starting dynamic subtest: pipe-A-plane-0 [263.798081] Dynamic subtest pipe-A-plane-0: SUCCESS (0.689s) [263.806857] Starting dynamic subtest: pipe-A-plane-3 [264.253436] Dynamic subtest pipe-A-plane-3: SUCCESS (0.454s) [264.262766] Starting dynamic subtest: pipe-A-plane-5 [264.266274] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [265.378761] Starting dynamic subtest: pipe-B-plane-0 [266.024756] Dynamic subtest pipe-B-plane-0: SUCCESS (0.655s) [266.033849] Starting dynamic subtest: pipe-B-plane-3 [266.435653] Dynamic subtest pipe-B-plane-3: SUCCESS (0.411s) [266.445662] Starting dynamic subtest: pipe-B-plane-5 [266.449271] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [266.756431] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.672s) [267.565417] [026/156] (750s left) syncobj_wait (wait-any-snapshot) [267.624269] Starting subtest: wait-any-snapshot [267.704248] Subtest wait-any-snapshot: SUCCESS (0.081s) [267.780574] [027/156] (750s left) gem_ctx_param (invalid-param-get) [267.834900] Starting subtest: invalid-param-get [267.837307] Subtest invalid-param-get: SUCCESS (0.001s) [267.946511] [028/156] (750s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc) [268.035661] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc [268.039974] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [268.122153] [029/156] (750s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-blt) [268.222683] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-blt [268.227241] Subtest hdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [268.322095] [030/156] (749s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip) [268.415902] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip [268.420227] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [268.499331] [031/156] (749s left) kms_dp_link_training (non-uhbr-mst) [268.591633] Starting subtest: non-uhbr-mst [268.598987] Subtest non-uhbr-mst: SKIP (0.000s) [268.661188] [032/156] (749s left) gem_fenced_exec_thrash (too-many-fences) [268.716303] Subtest too-many-fences: SKIP (0.000s) [268.786979] [033/156] (749s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-blt) [268.895019] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-blt [268.898478] Subtest hdr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [268.990103] [034/156] (749s left) kms_big_fb (yf-tiled-32bpp-rotate-270) [269.091992] Starting subtest: yf-tiled-32bpp-rotate-270 [269.095658] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s) [269.180340] [035/156] (749s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite) [269.276065] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite [269.279855] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [269.359401] [036/156] (749s left) syncobj_timeline (single-wait-available-signaled) [269.410872] Starting subtest: single-wait-available-signaled [269.412798] Subtest single-wait-available-signaled: SUCCESS (0.000s) [269.522318] [037/156] (749s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs) [269.607821] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs [269.609772] Starting dynamic subtest: pipe-A-eDP-1 [269.753397] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.136s) [269.764104] Starting dynamic subtest: pipe-B-eDP-1 [269.781035] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [269.789298] Starting dynamic subtest: pipe-C-eDP-1 [269.805155] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s) [269.813222] Starting dynamic subtest: pipe-D-eDP-1 [269.829184] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s) [269.830708] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.145s) [272.049213] [038/156] (746s left) gem_exec_reloc (basic-wc-gtt) [272.105636] Subtest basic-wc-gtt: SKIP (0.000s) [272.173336] [039/156] (746s left) kms_universal_plane (cursor-fb-leak) [272.252126] Starting subtest: cursor-fb-leak [272.254077] Starting dynamic subtest: pipe-A-eDP-1 [272.608678] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.357s) [272.621905] Starting dynamic subtest: pipe-B-eDP-1 [273.972828] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.362s) [273.987236] Starting dynamic subtest: pipe-C-eDP-1 [275.377192] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.401s) [275.391441] Starting dynamic subtest: pipe-D-eDP-1 [276.725098] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.346s) [276.727430] Subtest cursor-fb-leak: SUCCESS (4.476s) [277.925819] [040/156] (740s left) kms_flip (2x-plain-flip-fb-recreate) [278.024055] Starting subtest: 2x-plain-flip-fb-recreate [278.033384] Subtest 2x-plain-flip-fb-recreate: SKIP (0.011s) [278.140100] [041/156] (740s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt) [278.242093] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt [278.246095] Subtest fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [278.338274] [042/156] (740s left) core_debugfs (read-all-entries) [278.400878] Starting subtest: read-all-entries [278.501917] Subtest read-all-entries: SUCCESS (0.100s) [278.565575] [043/156] (740s left) i915_suspend (forcewake) [278.626222] Starting subtest: forcewake [310.282596] Subtest forcewake: SUCCESS (2.386s) [310.362234] [044/156] (708s left) kms_big_fb (x-tiled-32bpp-rotate-180) [310.472734] Starting subtest: x-tiled-32bpp-rotate-180 [311.961282] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.479s) [312.084176] [045/156] (706s left) gem_ctx_isolation (preservation) [312.162315] Starting subtest: preservation [312.163946] Starting dynamic subtest: rcs0 [312.294726] Dynamic subtest rcs0: SUCCESS (0.133s) [312.308654] Starting dynamic subtest: bcs0 [312.459311] Dynamic subtest bcs0: SUCCESS (0.162s) [312.473417] Starting dynamic subtest: vcs0 [312.614032] Dynamic subtest vcs0: SUCCESS (0.153s) [312.626105] Starting dynamic subtest: vcs1 [314.696097] Dynamic subtest vcs1: SUCCESS (2.069s) [314.706215] Starting dynamic subtest: vecs0 [316.682032] Dynamic subtest vecs0: SUCCESS (1.978s) [316.694917] Starting dynamic subtest: ccs0 [318.672898] Dynamic subtest ccs0: SUCCESS (1.983s) [318.676164] Subtest preservation: SUCCESS (6.484s) [318.902453] [046/156] (700s left) gem_exec_params (batch-first) [318.962821] Starting subtest: batch-first [318.971353] Subtest batch-first: SUCCESS (0.008s) [319.068118] [047/156] (699s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-indfb-msflip-blt) [319.170901] Starting subtest: psrhdr-1p-primscrn-indfb-msflip-blt [319.175294] Subtest psrhdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s) [319.277111] [048/156] (699s left) vgem_basic (dmabuf-mmap) [319.333120] Starting subtest: dmabuf-mmap [319.355855] Subtest dmabuf-mmap: SUCCESS (0.027s) [319.414084] [049/156] (699s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling) [319.523271] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling [319.525517] Starting dynamic subtest: pipe-A-default-mode [320.649966] Dynamic subtest pipe-A-default-mode: SKIP (1.122s) [320.654310] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.124s) [320.774197] [050/156] (698s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-mmap-gtt) [320.875223] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-mmap-gtt [320.879374] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [320.983738] [051/156] (698s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc) [321.073719] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc [327.626399] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.548s) [327.754267] [052/156] (691s left) gem_pxp (protected-raw-src-copy-not-readible) [327.881948] Starting subtest: protected-raw-src-copy-not-readible [327.938995] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.060s) [328.056298] [053/156] (691s left) prime_vgem (basic-fence-flip) [328.117838] Starting subtest: basic-fence-flip [328.408910] Subtest basic-fence-flip: SUCCESS (0.291s) [328.517490] [054/156] (690s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs) [328.600189] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs [328.602429] Starting dynamic subtest: pipe-A-eDP-1 [328.624807] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [328.637957] Starting dynamic subtest: pipe-B-eDP-1 [328.658720] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [328.668789] Starting dynamic subtest: pipe-C-eDP-1 [328.690347] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [328.700203] Starting dynamic subtest: pipe-D-eDP-1 [328.721719] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [328.726173] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.006s) [330.927721] [055/156] (688s left) syncobj_wait (single-wait-all-submitted) [330.978378] Starting subtest: single-wait-all-submitted [331.085630] Subtest single-wait-all-submitted: SUCCESS (0.107s) [331.163646] [056/156] (688s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary) [331.261909] Starting subtest: fbcpsr-indfb-scaledprimary [336.995588] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.734s) [337.129007] [057/156] (682s left) gem_eio (in-flight-suspend) [337.368199] Starting subtest: in-flight-suspend [379.860060] Subtest in-flight-suspend: SUCCESS (13.497s) [384.014353] [058/156] (639s left) gem_exercise_blt (fast-copy) [384.078350] Starting subtest: fast-copy [384.080631] Starting dynamic subtest: linear-smem-smem [384.106711] Dynamic subtest linear-smem-smem: SUCCESS (0.028s) [384.118176] Starting dynamic subtest: xmajor-smem-smem [384.128193] Dynamic subtest xmajor-smem-smem: SUCCESS (0.021s) [384.137756] Starting dynamic subtest: tile4-smem-smem [384.149685] Dynamic subtest tile4-smem-smem: SUCCESS (0.021s) [384.158849] Starting dynamic subtest: tile64-smem-smem [384.170968] Dynamic subtest tile64-smem-smem: SUCCESS (0.021s) [384.173228] Subtest fast-copy: SUCCESS (0.093s) [384.279940] [059/156] (639s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite) [384.386139] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite [384.390252] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [384.487968] [060/156] (639s left) perf (polling) [384.585492] Starting subtest: polling [384.587920] Starting dynamic subtest: 0-rcs0 [394.599114] Dynamic subtest 0-rcs0: SUCCESS (9.991s) [394.610063] Starting dynamic subtest: 1-vcs0 [404.608993] Dynamic subtest 1-vcs0: SUCCESS (9.993s) [404.611614] Subtest polling: SUCCESS (19.986s) [404.670480] [061/156] (618s left) sw_sync (sync_random_merge) [404.712161] Starting subtest: sync_random_merge [404.756941] Subtest sync_random_merge: SUCCESS (0.046s) [404.817798] [062/156] (618s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt) [404.914090] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt [411.785276] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.866s) [411.940676] [063/156] (611s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf) [412.055499] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf [412.059597] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [412.138201] [064/156] (611s left) gem_exec_gttfill (engines) [412.207461] Starting subtest: engines [412.209910] Starting dynamic subtest: rcs0 [435.197520] Dynamic subtest rcs0: SUCCESS (22.966s) [435.207384] Starting dynamic subtest: bcs0 [458.631542] Dynamic subtest bcs0: SUCCESS (23.414s) [458.641664] Starting dynamic subtest: vcs0 [482.042551] Dynamic subtest vcs0: SUCCESS (23.393s) [482.055151] Starting dynamic subtest: vcs1 [505.471352] Dynamic subtest vcs1: SUCCESS (23.414s) [505.484307] Starting dynamic subtest: vecs0 [528.917246] Dynamic subtest vecs0: SUCCESS (23.429s) [528.930257] Starting dynamic subtest: ccs0 [552.256345] Dynamic subtest ccs0: SUCCESS (23.326s) [552.259491] Subtest engines: SUCCESS (139.957s) [552.455736] [065/156] (471s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-blt) [552.623586] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-blt [552.628335] Subtest psrhdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [552.741692] [066/156] (471s left) syncobj_timeline (invalid-wait-bad-flags) [552.800569] Starting subtest: invalid-wait-bad-flags [552.802836] Subtest invalid-wait-bad-flags: SUCCESS (0.000s) [552.879449] [067/156] (471s left) sysfs_timeslice_duration (timeout) [552.928035] Starting subtest: timeout [552.930416] Starting dynamic subtest: vecs0 [562.574309] Dynamic subtest vecs0: SUCCESS (9.638s) [562.586122] Starting dynamic subtest: ccs0 [563.885598] Dynamic subtest ccs0: SUCCESS (1.309s) [563.897608] Starting dynamic subtest: vcs0 [573.583726] Dynamic subtest vcs0: SUCCESS (9.690s) [573.593818] Starting dynamic subtest: bcs0 [574.205932] Dynamic subtest bcs0: SUCCESS (0.621s) [574.222530] Starting dynamic subtest: rcs0 [575.479389] Dynamic subtest rcs0: SUCCESS (1.270s) [575.489599] Starting dynamic subtest: vcs1 [584.525099] Dynamic subtest vcs1: SUCCESS (9.078s) [584.527780] Subtest timeout: SUCCESS (31.619s) [584.604475] [068/156] (439s left) kms_cursor_legacy (cursora-vs-flipa-varying-size) [584.731454] Starting subtest: cursorA-vs-flipA-varying-size [595.957852] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.251s) [596.794068] [069/156] (427s left) gem_render_copy (y-tiled-ccs-to-x-tiled) [596.857265] Starting subtest: y-tiled-ccs-to-x-tiled [596.861808] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s) [597.044566] [070/156] (426s left) kms_cursor_legacy (flip-vs-cursor-atomic) [597.162435] Starting subtest: flip-vs-cursor-atomic [604.682438] Subtest flip-vs-cursor-atomic: SUCCESS (7.529s) [605.519711] [071/156] (418s left) gem_exec_schedule (wide) [605.691375] Starting subtest: wide [605.694087] Starting dynamic subtest: rcs0 [616.292529] Dynamic subtest rcs0: SUCCESS (10.609s) [616.305832] Starting dynamic subtest: vcs0 [628.757090] Dynamic subtest vcs0: SUCCESS (12.470s) [628.767603] Starting dynamic subtest: vcs1 [640.567384] Dynamic subtest vcs1: SUCCESS (11.812s) [640.578792] Starting dynamic subtest: vecs0 [652.617942] Dynamic subtest vecs0: SUCCESS (12.047s) [652.631161] Starting dynamic subtest: ccs0 [667.010269] Dynamic subtest ccs0: SUCCESS (14.390s) [667.012742] Subtest wide: SUCCESS (61.332s) [670.490515] [072/156] (353s left) sw_sync (alloc_merge_fence) [670.531801] Starting subtest: alloc_merge_fence [670.533745] Subtest alloc_merge_fence: SUCCESS (0.000s) [670.589459] [073/156] (353s left) kms_getfb (getfb-handle-zero) [670.699495] Starting subtest: getfb-handle-zero [670.701757] Subtest getfb-handle-zero: SUCCESS (0.000s) [670.807067] [074/156] (353s left) kms_chamelium_edid (hdmi-edid-read) [671.198768] Subtest hdmi-edid-read: SKIP (0.000s) [671.998831] [075/156] (352s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic) [672.129375] Starting subtest: flip-vs-cursor-crc-atomic [672.815701] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.684s) [673.649123] [076/156] (350s left) kms_async_flips (alternate-sync-async-flip) [673.736219] Starting subtest: alternate-sync-async-flip [674.131075] Starting dynamic subtest: pipe-A-eDP-1 [676.943386] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.813s) [677.357656] Starting dynamic subtest: pipe-B-eDP-1 [680.084043] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.736s) [680.477948] Starting dynamic subtest: pipe-C-eDP-1 [683.225568] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.757s) [683.593016] Starting dynamic subtest: pipe-D-eDP-1 [686.359773] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.775s) [686.361727] Subtest alternate-sync-async-flip: SUCCESS (12.626s) [687.520659] [077/156] (336s left) kms_invalid_mode (clock-too-high) [687.629583] Starting subtest: clock-too-high [687.631704] Starting dynamic subtest: pipe-A-eDP-1 [687.923456] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.294s) [687.934479] Starting dynamic subtest: pipe-B-eDP-1 [687.938914] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [687.949266] Starting dynamic subtest: pipe-C-eDP-1 [687.953183] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [687.962768] Starting dynamic subtest: pipe-D-eDP-1 [687.966783] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [687.969376] Subtest clock-too-high: SUCCESS (0.300s) [688.765895] [078/156] (335s left) syncobj_wait (wait-all-interrupted) [688.814716] Starting subtest: wait-all-interrupted [688.914264] Subtest wait-all-interrupted: SUCCESS (0.101s) [689.007732] [079/156] (335s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-blt) [689.119625] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-blt [689.123915] Subtest hdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s) [689.220311] [080/156] (335s left) kms_chamelium_hpd (hdmi-hpd-storm) [689.600377] Subtest hdmi-hpd-storm: SKIP (0.000s) [690.378724] [081/156] (334s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels) [690.475692] Starting subtest: plane-all-modeset-transition-fencing-internal-panels [690.477886] Starting dynamic subtest: pipe-A-eDP-1 [691.840408] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.364s) [692.130003] Starting dynamic subtest: pipe-B-eDP-1 [693.173873] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.054s) [693.446357] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.972s) [694.283269] [082/156] (330s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-shrfb-plflip-blt) [694.392618] Starting subtest: fbchdr-2p-scndscrn-shrfb-plflip-blt [694.396721] Subtest fbchdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [694.515787] [083/156] (330s left) kms_psr_stress_test (flip-primary-invalidate-overlay) [694.610975] Starting subtest: flip-primary-invalidate-overlay [706.214991] Subtest flip-primary-invalidate-overlay: SUCCESS (11.607s) [706.377950] [084/156] (318s left) syncobj_eventfd (binary-wait-before-signal) [706.442063] Starting subtest: binary-wait-before-signal [706.471581] Subtest binary-wait-before-signal: SUCCESS (0.031s) [706.546290] [085/156] (318s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-mmap-gtt) [706.644687] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-mmap-gtt [706.648283] Subtest hdr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [706.740941] [086/156] (317s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-render) [706.835751] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-render [706.839322] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [706.925881] [087/156] (317s left) i915_drm_fdinfo (all-busy-check-all) [706.970230] Starting subtest: all-busy-check-all [706.976102] Subtest all-busy-check-all: SKIP (0.004s) [707.049027] [088/156] (317s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu) [707.151325] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu [710.773026] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.625s) [711.990697] [089/156] (312s left) i915_pm_rc6_residency (media-rc6-accuracy) [712.048761] Starting subtest: media-rc6-accuracy [712.053114] Subtest media-rc6-accuracy: SKIP (0.000s) [712.167110] [090/156] (312s left) kms_psr (pr-sprite-plane-onoff) [712.274042] Starting subtest: pr-sprite-plane-onoff [712.278125] Subtest pr-sprite-plane-onoff: SKIP (0.000s) [712.346475] [091/156] (312s left) gem_ccs (block-multicopy-compressed) [712.409091] Starting subtest: block-multicopy-compressed [712.413554] Subtest block-multicopy-compressed: SKIP (0.000s) [712.517911] [092/156] (312s left) kms_content_protection (legacy-hdcp14) [712.664790] Starting subtest: legacy-hdcp14 [712.668894] Subtest legacy-hdcp14: SKIP (0.000s) [712.804948] [093/156] (312s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite) [712.909804] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite [712.913287] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [713.007283] [094/156] (312s left) kms_fbcon_fbt (fbc) [713.062388] Starting subtest: fbc [719.389258] Subtest fbc: SUCCESS (6.326s) [720.493393] [095/156] (304s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen) [720.593906] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen [720.598033] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [720.696263] [096/156] (304s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc) [720.789540] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc [724.776707] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (3.993s) [725.924807] [097/156] (299s left) kms_color_pipeline (plane-lut1d) [726.024489] Starting subtest: plane-lut1d [726.160497] Starting dynamic subtest: pipe-A-plane-0 [726.320056] Dynamic subtest pipe-A-plane-0: SUCCESS (0.154s) [726.332277] Starting dynamic subtest: pipe-A-plane-1 [726.460825] Dynamic subtest pipe-A-plane-1: SUCCESS (0.144s) [726.471244] Starting dynamic subtest: pipe-A-plane-2 [726.625827] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s) [727.774567] Starting dynamic subtest: pipe-B-plane-0 [727.943930] Dynamic subtest pipe-B-plane-0: SUCCESS (0.177s) [727.954710] Starting dynamic subtest: pipe-B-plane-1 [728.098933] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s) [728.109848] Starting dynamic subtest: pipe-B-plane-2 [728.232066] Dynamic subtest pipe-B-plane-2: SUCCESS (0.132s) [729.410913] Starting dynamic subtest: pipe-C-plane-0 [729.555229] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s) [729.566030] Starting dynamic subtest: pipe-C-plane-1 [729.710643] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s) [729.721013] Starting dynamic subtest: pipe-C-plane-2 [729.877432] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s) [731.024961] Starting dynamic subtest: pipe-D-plane-0 [731.193938] Dynamic subtest pipe-D-plane-0: SUCCESS (0.177s) [731.204644] Starting dynamic subtest: pipe-D-plane-1 [731.371810] Dynamic subtest pipe-D-plane-1: SUCCESS (0.177s) [731.382674] Starting dynamic subtest: pipe-D-plane-2 [731.538576] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s) [731.837550] Subtest plane-lut1d: SUCCESS (5.813s) [732.720203] [098/156] (292s left) kms_psr (fbc-pr-sprite-mmap-gtt) [732.840872] Starting subtest: fbc-pr-sprite-mmap-gtt [732.845270] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s) [732.914985] [099/156] (292s left) gem_tiled_swapping (non-threaded) [732.978991] Subtest non-threaded: SKIP (0.000s) [733.045960] [100/156] (292s left) gem_exec_flush (basic-wb-set-default) [733.110849] Starting subtest: basic-wb-set-default [738.564733] Subtest basic-wb-set-default: SUCCESS (5.455s) [738.752419] [101/156] (286s left) gem_exec_balancer (parallel-out-fence) [739.015451] Starting subtest: parallel-out-fence [740.261543] Subtest parallel-out-fence: SUCCESS (1.246s) [740.374693] [102/156] (285s left) kms_pm_rpm (cursor) [741.907255] Starting subtest: cursor [741.912116] Subtest cursor: SKIP (0.000s) [742.648401] [103/156] (282s left) syncobj_timeline (single-wait-all-available-submitted) [742.699319] Starting subtest: single-wait-all-available-submitted [742.701573] Subtest single-wait-all-available-submitted: SUCCESS (0.000s) [742.809921] [104/156] (282s left) gem_exec_schedule (u-fairslice-all) [742.876483] Starting subtest: u-fairslice-all [744.931579] Subtest u-fairslice-all: SUCCESS (2.062s) [745.226315] [105/156] (280s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic) [745.341001] Starting subtest: 2x-cursor-vs-flip-atomic [745.345467] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s) [745.486546] [106/156] (280s left) kms_frontbuffer_tracking (psr-2p-rte) [745.595082] Starting subtest: psr-2p-rte [745.599456] Subtest psr-2p-rte: SKIP (0.000s) [745.697013] [107/156] (279s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt) [745.811314] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt [745.815561] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [745.927665] [108/156] (279s left) i915_drm_fdinfo (virtual-idle) [745.972453] Starting subtest: virtual-idle [749.041299] Subtest virtual-idle: SUCCESS (3.063s) [749.115454] [109/156] (276s left) kms_plane_scaling (plane-upscale-20x20-with-rotation) [749.210731] Starting subtest: plane-upscale-20x20-with-rotation [749.212975] Starting dynamic subtest: pipe-A [749.445876] Dynamic subtest pipe-A: SUCCESS (0.238s) [749.456810] Starting dynamic subtest: pipe-B [750.817707] Dynamic subtest pipe-B: SUCCESS (1.370s) [750.828415] Starting dynamic subtest: pipe-C [752.138434] Dynamic subtest pipe-C: SUCCESS (1.319s) [752.149673] Starting dynamic subtest: pipe-D [753.480519] Dynamic subtest pipe-D: SUCCESS (1.341s) [753.482918] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.274s) [754.755279] [110/156] (270s left) kms_frontbuffer_tracking (hdr-rgb565-draw-blt) [754.855272] Starting subtest: hdr-rgb565-draw-blt [754.859667] Subtest hdr-rgb565-draw-blt: SKIP (0.000s) [754.962679] [111/156] (270s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-shrfb-msflip-blt) [755.070855] Starting subtest: psrhdr-1p-primscrn-shrfb-msflip-blt [755.074815] Subtest psrhdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [755.181995] [112/156] (270s left) kms_vrr (max-min) [755.277524] Starting subtest: max-min [755.283570] Subtest max-min: SKIP (0.000s) [755.353379] [113/156] (270s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc) [755.453970] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc [759.713524] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.268s) [760.839863] [114/156] (265s left) gen9_exec_parse (bb-chained) [760.898155] Subtest bb-chained: SKIP (0.000s) [760.989725] [115/156] (264s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite) [761.086405] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite [761.090669] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [761.185172] [116/156] (264s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-render) [761.292342] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-render [761.296734] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s) [761.393205] [117/156] (264s left) kms_big_fb (4-tiled-addfb-size-overflow) [761.497608] Starting subtest: 4-tiled-addfb-size-overflow [761.499809] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s) [761.603101] [118/156] (264s left) gem_ctx_persistence (legacy-engines-cleanup) [761.659228] Starting subtest: legacy-engines-cleanup [761.661478] Starting dynamic subtest: render [761.722093] Dynamic subtest render: SUCCESS (0.062s) [761.737267] Starting dynamic subtest: bsd1 [761.766522] Dynamic subtest bsd1: SUCCESS (0.042s) [761.778767] Starting dynamic subtest: bsd2 [761.801411] Dynamic subtest bsd2: SUCCESS (0.032s) [761.813267] Starting dynamic subtest: blt [761.838566] Dynamic subtest blt: SUCCESS (0.035s) [761.850576] Starting dynamic subtest: vebox [761.872558] Dynamic subtest vebox: SUCCESS (0.032s) [761.874565] Subtest legacy-engines-cleanup: SUCCESS (0.215s) [761.951129] [119/156] (264s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs) [762.006982] Starting subtest: y-tiled-ccs-to-y-tiled-ccs [762.010437] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s) [762.193139] [120/156] (263s left) kms_cursor_crc (cursor-onscreen-128x42) [762.447374] Starting subtest: cursor-onscreen-128x42 [762.499603] Subtest cursor-onscreen-128x42: SKIP (0.046s) [762.737071] [121/156] (263s left) gem_mmap_offset (oob-read) [762.796568] Starting subtest: oob-read [762.798809] Subtest oob-read: SUCCESS (0.000s) [762.894441] [122/156] (263s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [762.986090] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu [762.990561] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [763.114210] [123/156] (263s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt) [763.218020] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt [763.221364] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [763.320961] [124/156] (263s left) syncobj_timeline (etime-single-wait-submitted) [763.381036] Starting subtest: etime-single-wait-submitted [763.482747] Subtest etime-single-wait-submitted: SUCCESS (0.101s) [763.562754] [125/156] (262s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-gtt) [763.669647] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-gtt [763.673480] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [763.766605] [126/156] (262s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu) [763.860600] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu [770.527384] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.669s) [770.678225] [127/156] (255s left) gem_wait (await) [770.746728] Starting subtest: await [770.748993] Starting dynamic subtest: all-engines [771.849955] Dynamic subtest all-engines: SUCCESS (1.103s) [771.867349] Starting dynamic subtest: rcs0 [772.912070] Dynamic subtest rcs0: SUCCESS (1.059s) [772.930157] Starting dynamic subtest: bcs0 [773.972669] Dynamic subtest bcs0: SUCCESS (1.058s) [773.990373] Starting dynamic subtest: vcs0 [775.030252] Dynamic subtest vcs0: SUCCESS (1.055s) [775.048403] Starting dynamic subtest: vcs1 [776.086071] Dynamic subtest vcs1: SUCCESS (1.053s) [776.104278] Starting dynamic subtest: vecs0 [777.140856] Dynamic subtest vecs0: SUCCESS (1.052s) [777.158216] Starting dynamic subtest: ccs0 [778.197654] Dynamic subtest ccs0: SUCCESS (1.055s) [778.200027] Subtest await: SUCCESS (7.451s) [778.403450] [128/156] (248s left) gem_eio (banned) [778.616589] Starting subtest: banned [779.218434] Subtest banned: SUCCESS (0.601s) [779.396696] [129/156] (247s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf) [779.489630] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf [779.491556] Starting dynamic subtest: pipe-A-eDP-1 [779.586517] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s) [779.598414] Starting dynamic subtest: pipe-B-eDP-1 [780.731723] Dynamic subtest pipe-B-eDP-1: SKIP (1.143s) [780.736231] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.245s) [781.927370] [130/156] (244s left) kms_lease (lease-unleased-connector) [782.020496] Starting subtest: lease-unleased-connector [782.022615] Starting dynamic subtest: pipe-A-eDP-1 [782.027633] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s) [782.038457] Starting dynamic subtest: pipe-B-eDP-1 [782.040645] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s) [782.051176] Starting dynamic subtest: pipe-C-eDP-1 [782.053421] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.008s) [782.064243] Starting dynamic subtest: pipe-D-eDP-1 [782.066122] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s) [782.068003] Subtest lease-unleased-connector: SUCCESS (0.037s) [782.157601] [131/156] (244s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-mmap-gtt) [782.256135] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-mmap-gtt [782.260358] Subtest fbchdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [782.364186] [132/156] (244s left) kms_draw_crc (draw-method-mmap-wc) [782.450632] Starting subtest: draw-method-mmap-wc [782.452762] Starting dynamic subtest: xrgb8888-untiled [782.695950] Dynamic subtest xrgb8888-untiled: SUCCESS (0.247s) [782.706848] Starting dynamic subtest: rgb565-untiled [782.895377] Dynamic subtest rgb565-untiled: SUCCESS (0.199s) [782.905868] Starting dynamic subtest: xrgb2101010-untiled [783.106606] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.210s) [783.117026] Starting dynamic subtest: xbgr16161616f-untiled [783.306779] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.199s) [783.317077] Starting dynamic subtest: xrgb8888-xtiled [783.428879] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s) [783.438656] Starting dynamic subtest: rgb565-xtiled [783.550891] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s) [783.561316] Starting dynamic subtest: xrgb2101010-xtiled [783.673145] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s) [783.683536] Starting dynamic subtest: xbgr16161616f-xtiled [783.784579] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.110s) [783.794440] Starting dynamic subtest: xrgb8888-4tiled [783.940558] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.155s) [783.952028] Starting dynamic subtest: rgb565-4tiled [784.073356] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s) [784.085969] Starting dynamic subtest: xrgb2101010-4tiled [784.218024] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.142s) [784.228339] Starting dynamic subtest: xbgr16161616f-4tiled [784.373593] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.155s) [784.375365] Subtest draw-method-mmap-wc: SUCCESS (1.925s) [784.483553] [133/156] (242s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [784.596912] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt [784.600779] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [784.739359] [134/156] (242s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping) [784.824982] Starting subtest: pixel-format-y-tiled-modifier-source-clamping [784.828568] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s) [784.898059] [135/156] (241s left) kms_flip (flip-vs-dpms-on-nop) [784.998041] Starting subtest: flip-vs-dpms-on-nop [785.000079] Starting dynamic subtest: A-eDP1 [786.822614] Dynamic subtest A-eDP1: SUCCESS (1.825s) [786.836690] Starting dynamic subtest: B-eDP1 [788.647250] Dynamic subtest B-eDP1: SUCCESS (1.821s) [788.662915] Starting dynamic subtest: C-eDP1 [790.475128] Dynamic subtest C-eDP1: SUCCESS (1.825s) [790.488707] Starting dynamic subtest: D-eDP1 [792.314251] Dynamic subtest D-eDP1: SUCCESS (1.836s) [792.316825] Subtest flip-vs-dpms-on-nop: SUCCESS (7.320s) [793.498745] [136/156] (233s left) gem_ppgtt (flink-and-close-vma-leak) [793.570026] Starting subtest: flink-and-close-vma-leak [793.611853] Subtest flink-and-close-vma-leak: SUCCESS (0.041s) [793.753606] [137/156] (233s left) gem_mmap_gtt (cpuset-basic-small-copy-xy) [793.816733] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s) [793.882397] [138/156] (233s left) perf (gen12-mi-rpc) [793.996239] Starting subtest: gen12-mi-rpc [793.998573] Starting dynamic subtest: rcs0 [794.020575] Dynamic subtest rcs0: SUCCESS (0.021s) [794.022858] Subtest gen12-mi-rpc: SUCCESS (0.022s) [794.062428] [139/156] (232s left) kms_atomic (plane-invalid-params-fence) [794.165576] Starting subtest: plane-invalid-params-fence [794.167851] Starting dynamic subtest: pipe-A-eDP-1 [794.520848] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.354s) [794.523037] Subtest plane-invalid-params-fence: SUCCESS (0.355s) [795.337335] [140/156] (231s left) perf_pmu (pmu-read) [795.380788] Starting subtest: pmu-read [795.383082] Subtest pmu-read: SUCCESS (0.002s) [795.503196] [141/156] (231s left) gem_create (create-ext-cpu-access-big) [795.674674] Starting subtest: create-ext-cpu-access-big [795.679180] Subtest create-ext-cpu-access-big: SKIP (0.001s) [795.751732] [142/156] (231s left) kms_big_fb (y-tiled-16bpp-rotate-0) [795.854810] Starting subtest: y-tiled-16bpp-rotate-0 [795.859333] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s) [795.974727] [143/156] (231s left) gem_exec_schedule (preempt-contexts) [796.046476] Starting subtest: preempt-contexts [796.048434] Starting dynamic subtest: rcs0 [796.098406] Dynamic subtest rcs0: SUCCESS (0.058s) [796.114686] Starting dynamic subtest: bcs0 [796.153593] Dynamic subtest bcs0: SUCCESS (0.054s) [796.165156] Starting dynamic subtest: vcs0 [796.203239] Dynamic subtest vcs0: SUCCESS (0.048s) [796.218805] Starting dynamic subtest: vcs1 [796.256342] Dynamic subtest vcs1: SUCCESS (0.051s) [796.270212] Starting dynamic subtest: vecs0 [796.314059] Dynamic subtest vecs0: SUCCESS (0.057s) [796.330818] Starting dynamic subtest: ccs0 [796.373566] Dynamic subtest ccs0: SUCCESS (0.058s) [796.375694] Subtest preempt-contexts: SUCCESS (0.334s) [797.690964] [144/156] (229s left) kms_big_fb (yf-tiled-8bpp-rotate-270) [797.784078] Starting subtest: yf-tiled-8bpp-rotate-270 [797.788464] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s) [797.882030] [145/156] (229s left) gem_ctx_shared (single-timeline) [797.945750] Starting subtest: single-timeline [797.967177] Subtest single-timeline: SUCCESS (0.013s) [798.200902] [146/156] (229s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180) [798.314869] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180 [799.282256] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.967s) [799.408353] [147/156] (228s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs) [799.505587] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs [799.507471] Starting dynamic subtest: pipe-A-eDP-1 [800.765644] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.262s) [800.777363] Starting dynamic subtest: pipe-B-eDP-1 [803.106096] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.339s) [803.118160] Starting dynamic subtest: pipe-C-eDP-1 [805.418220] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.311s) [805.428945] Starting dynamic subtest: pipe-D-eDP-1 [807.740360] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.320s) [807.743175] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.237s) [808.936254] [148/156] (218s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-mmap-wc) [809.039840] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-mmap-wc [809.044053] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [809.140865] [149/156] (218s left) gem_mmap_wc (write-gtt-read-wc) [809.196114] Subtest write-gtt-read-wc: SKIP (0.000s) [809.262227] [150/156] (218s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes) [809.315815] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s) [809.380199] [151/156] (218s left) kms_plane_lowres (tiling-none) [809.462541] Starting subtest: tiling-none [809.464647] Starting dynamic subtest: pipe-A-eDP-1 [809.469001] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [809.763687] Starting dynamic subtest: pipe-B-eDP-1 [809.768287] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [809.778845] Starting dynamic subtest: pipe-C-eDP-1 [809.783439] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [809.794236] Starting dynamic subtest: pipe-D-eDP-1 [809.798466] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [809.802613] Subtest tiling-none: SKIP (0.299s) [810.575567] [152/156] (217s left) dumb_buffer (create-valid-dumb) [810.632122] Starting subtest: create-valid-dumb [810.634336] Subtest create-valid-dumb: SUCCESS (0.000s) [810.732401] [153/156] (216s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted) [810.785832] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted [810.891960] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.106s) [810.972269] [154/156] (216s left) perf (rc6-disable) [811.054471] Starting subtest: rc6-disable [811.226581] Subtest rc6-disable: SUCCESS (0.174s) [811.273914] [155/156] (216s left) kms_pm_rpm (modeset-lpsp-stress) [812.792417] Starting subtest: modeset-lpsp-stress [829.209441] Subtest modeset-lpsp-stress: SUCCESS (16.418s) [829.299031] [156/156] (198s left) kms_rotation_crc (bad-pixel-format) [829.401646] Starting subtest: bad-pixel-format [829.405633] Subtest bad-pixel-format: SKIP (0.001s) [829.471894] Closing watchdogs results: parsing output: 0/ for test: kms_psr results: parsing output: 1/ for test: kms_cursor_crc results: parsing output: 2/ for test: gem_ctx_param results: parsing output: 3/ for test: gem_exec_balancer results: parsing output: 4/ for test: kms_flip results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: gem_exec_fence results: parsing output: 7/ for test: gem_spin_batch results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: perf results: parsing output: 10/ for test: gem_eio results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: kms_cursor_edge_walk results: parsing output: 13/ for test: kms_ccs results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: kms_properties results: parsing output: 16/ for test: gem_pwrite results: parsing output: 17/ for test: gem_userptr_blits results: parsing output: 18/ for test: kms_psr results: parsing output: 19/ for test: kms_frontbuffer_tracking results: parsing output: 20/ for test: kms_plane_scaling results: parsing output: 21/ for test: kms_psr results: parsing output: 22/ for test: api_intel_allocator results: parsing output: 23/ for test: kms_ccs results: parsing output: 24/ for test: kms_plane results: parsing output: 25/ for test: syncobj_wait results: parsing output: 26/ for test: gem_ctx_param results: parsing output: 27/ for test: kms_frontbuffer_tracking results: parsing output: 28/ for test: kms_frontbuffer_tracking results: parsing output: 29/ for test: kms_big_fb results: parsing output: 30/ for test: kms_dp_link_training results: parsing output: 31/ for test: gem_fenced_exec_thrash results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: kms_big_fb results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: syncobj_timeline results: parsing output: 36/ for test: kms_ccs results: parsing output: 37/ for test: gem_exec_reloc results: parsing output: 38/ for test: kms_universal_plane results: parsing output: 39/ for test: kms_flip results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: core_debugfs results: parsing output: 42/ for test: i915_suspend results: parsing output: 43/ for test: kms_big_fb results: parsing output: 44/ for test: gem_ctx_isolation results: parsing output: 45/ for test: gem_exec_params results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: vgem_basic results: parsing output: 48/ for test: kms_flip_scaled_crc results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: gem_pxp results: parsing output: 52/ for test: prime_vgem results: parsing output: 53/ for test: kms_ccs results: parsing output: 54/ for test: syncobj_wait results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: gem_eio results: parsing output: 57/ for test: gem_exercise_blt results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: perf results: parsing output: 60/ for test: sw_sync results: parsing output: 61/ for test: kms_frontbuffer_tracking results: parsing output: 62/ for test: kms_psr2_sf results: parsing output: 63/ for test: gem_exec_gttfill results: parsing output: 64/ for test: kms_frontbuffer_tracking results: parsing output: 65/ for test: syncobj_timeline results: parsing output: 66/ for test: sysfs_timeslice_duration results: parsing output: 67/ for test: kms_cursor_legacy results: parsing output: 68/ for test: gem_render_copy results: parsing output: 69/ for test: kms_cursor_legacy results: parsing output: 70/ for test: gem_exec_schedule results: parsing output: 71/ for test: sw_sync results: parsing output: 72/ for test: kms_getfb results: parsing output: 73/ for test: kms_chamelium_edid results: parsing output: 74/ for test: kms_cursor_legacy results: parsing output: 75/ for test: kms_async_flips results: parsing output: 76/ for test: kms_invalid_mode results: parsing output: 77/ for test: syncobj_wait results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: kms_chamelium_hpd results: parsing output: 80/ for test: kms_atomic_transition results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: kms_psr_stress_test results: parsing output: 83/ for test: syncobj_eventfd results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: i915_drm_fdinfo results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: i915_pm_rc6_residency results: parsing output: 89/ for test: kms_psr results: parsing output: 90/ for test: gem_ccs results: parsing output: 91/ for test: kms_content_protection results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: kms_fbcon_fbt results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: kms_color_pipeline results: parsing output: 97/ for test: kms_psr results: parsing output: 98/ for test: gem_tiled_swapping results: parsing output: 99/ for test: gem_exec_flush results: parsing output: 100/ for test: gem_exec_balancer results: parsing output: 101/ for test: kms_pm_rpm results: parsing output: 102/ for test: syncobj_timeline results: parsing output: 103/ for test: gem_exec_schedule results: parsing output: 104/ for test: kms_cursor_legacy results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: i915_drm_fdinfo results: parsing output: 108/ for test: kms_plane_scaling results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: kms_vrr results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: gen9_exec_parse results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: kms_big_fb results: parsing output: 117/ for test: gem_ctx_persistence results: parsing output: 118/ for test: gem_render_copy results: parsing output: 119/ for test: kms_cursor_crc results: parsing output: 120/ for test: gem_mmap_offset results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: syncobj_timeline results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: gem_wait results: parsing output: 127/ for test: gem_eio results: parsing output: 128/ for test: kms_psr2_sf results: parsing output: 129/ for test: kms_lease results: parsing output: 130/ for test: kms_frontbuffer_tracking results: parsing output: 131/ for test: kms_draw_crc results: parsing output: 132/ for test: kms_frontbuffer_tracking results: parsing output: 133/ for test: kms_plane results: parsing output: 134/ for test: kms_flip results: parsing output: 135/ for test: gem_ppgtt results: parsing output: 136/ for test: gem_mmap_gtt results: parsing output: 137/ for test: perf results: parsing output: 138/ for test: kms_atomic results: parsing output: 139/ for test: perf_pmu results: parsing output: 140/ for test: gem_create results: parsing output: 141/ for test: kms_big_fb results: parsing output: 142/ for test: gem_exec_schedule results: parsing output: 143/ for test: kms_big_fb results: parsing output: 144/ for test: gem_ctx_shared results: parsing output: 145/ for test: kms_big_fb results: parsing output: 146/ for test: kms_ccs results: parsing output: 147/ for test: kms_frontbuffer_tracking results: parsing output: 148/ for test: gem_mmap_wc results: parsing output: 149/ for test: kms_pipe_b_c_ivb results: parsing output: 150/ for test: kms_plane_lowres results: parsing output: 151/ for test: dumb_buffer results: parsing output: 152/ for test: syncobj_timeline results: parsing output: 153/ for test: perf results: parsing output: 154/ for test: kms_pm_rpm results: parsing output: 155/ for test: kms_rotation_crc Done.