[140.222339] Initializing watchdogs [140.222385] /dev/watchdog0 [140.237638] [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] [140.242157] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [140.244555] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [140.248720] [001/156] (960s left) fbdev (unaligned-read) [140.321485] Starting subtest: unaligned-read [140.336906] Subtest unaligned-read: SUCCESS (0.016s) [140.388967] [002/156] (960s left) kms_plane_alpha_blend (alpha-basic) [140.485582] Starting subtest: alpha-basic [140.798686] Starting dynamic subtest: pipe-A-eDP-1 [142.814503] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.016s) [142.853962] Starting dynamic subtest: pipe-D-eDP-1 [145.494914] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.655s) [145.497295] Subtest alpha-basic: SUCCESS (5.011s) [146.355776] [003/156] (954s left) kms_big_fb (4-tiled-addfb-size-overflow) [146.458881] Starting subtest: 4-tiled-addfb-size-overflow [146.461666] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s) [146.552361] [004/156] (954s left) kms_flip (flip-vs-panning) [146.644668] Starting subtest: flip-vs-panning [146.646728] Starting dynamic subtest: A-eDP1 [155.383863] Dynamic subtest A-eDP1: SUCCESS (8.739s) [155.392244] Starting dynamic subtest: B-eDP1 [164.115880] Dynamic subtest B-eDP1: SUCCESS (8.732s) [164.131616] Starting dynamic subtest: C-eDP1 [172.838366] Dynamic subtest C-eDP1: SUCCESS (8.720s) [172.846892] Starting dynamic subtest: D-eDP1 [181.577714] Dynamic subtest D-eDP1: SUCCESS (8.739s) [181.579882] Subtest flip-vs-panning: SUCCESS (34.939s) [182.750918] [005/156] (918s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling) [182.848274] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling [182.850697] Starting dynamic subtest: pipe-A-default-mode [185.601618] Dynamic subtest pipe-A-default-mode: SUCCESS (2.753s) [185.603794] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.754s) [186.436956] [006/156] (914s left) kms_flip (flip-vs-dpms-on-nop) [186.525944] Starting subtest: flip-vs-dpms-on-nop [186.528551] Starting dynamic subtest: A-eDP1 [188.431158] Dynamic subtest A-eDP1: SUCCESS (1.907s) [188.442183] Starting dynamic subtest: B-eDP1 [190.264651] Dynamic subtest B-eDP1: SUCCESS (1.832s) [190.276146] Starting dynamic subtest: C-eDP1 [192.089079] Dynamic subtest C-eDP1: SUCCESS (1.823s) [192.098605] Starting dynamic subtest: D-eDP1 [193.918590] Dynamic subtest D-eDP1: SUCCESS (1.829s) [193.921065] Subtest flip-vs-dpms-on-nop: SUCCESS (7.399s) [195.120346] [007/156] (905s left) i915_module_load (resize-bar) [195.158512] Starting subtest: resize-bar [195.168359] Subtest resize-bar: SKIP (0.009s) [195.214269] [008/156] (905s left) vgem_basic (dmabuf-export) [195.283671] Starting subtest: dmabuf-export [195.309594] Subtest dmabuf-export: SUCCESS (0.028s) [195.410652] [FACT vgem_basic (dmabuf-export)] new: kernel.kmod_is_loaded.vgem: true [195.413678] [009/156] (905s left) kms_atomic_interruptible (universal-setplane-primary) [195.513484] Starting subtest: universal-setplane-primary [195.515738] Starting dynamic subtest: pipe-A-eDP-1 [202.929525] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.416s) [202.931962] Subtest universal-setplane-primary: SUCCESS (7.417s) [203.767455] [010/156] (897s left) api_intel_bb (crc32) [203.814983] Starting subtest: crc32 [203.817021] Starting dynamic subtest: rcs0-smem0 [204.109944] Dynamic subtest rcs0-smem0: SUCCESS (0.295s) [204.121314] Starting dynamic subtest: bcs0-smem0 [204.453494] Dynamic subtest bcs0-smem0: SUCCESS (0.342s) [204.464860] Starting dynamic subtest: vcs0-smem0 [204.792920] Dynamic subtest vcs0-smem0: SUCCESS (0.338s) [204.804032] Starting dynamic subtest: vcs1-smem0 [205.162624] Dynamic subtest vcs1-smem0: SUCCESS (0.368s) [205.175174] Starting dynamic subtest: vecs0-smem0 [205.477036] Dynamic subtest vecs0-smem0: SUCCESS (0.313s) [205.488026] Starting dynamic subtest: ccs0-smem0 [205.798398] Dynamic subtest ccs0-smem0: SUCCESS (0.319s) [205.801280] Subtest crc32: SUCCESS (1.984s) [205.925077] [011/156] (895s left) kms_psr (fbc-psr2-sprite-plane-move) [206.029080] Starting subtest: fbc-psr2-sprite-plane-move [206.031413] Starting dynamic subtest: eDP-1 [206.035815] Dynamic subtest eDP-1: SKIP (0.000s) [206.040245] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s) [206.113912] [012/156] (895s left) kms_tiled_display (basic-test-pattern) [206.227121] Subtest basic-test-pattern: SKIP (0.000s) [206.270995] [013/156] (894s left) kms_big_fb (yf-tiled-16bpp-rotate-180) [206.374703] Starting subtest: yf-tiled-16bpp-rotate-180 [206.379302] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s) [206.464931] [014/156] (894s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs) [206.560494] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs [206.565224] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s) [207.695484] [015/156] (893s left) kms_getfb (getfb-handle-valid) [207.793200] Starting subtest: getfb-handle-valid [207.795616] Subtest getfb-handle-valid: SUCCESS (0.000s) [207.886201] [016/156] (893s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-render) [207.989235] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-render [207.993473] Subtest hdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [208.093569] [017/156] (893s left) syncobj_wait (single-wait-signaled) [208.154203] Starting subtest: single-wait-signaled [208.156603] Subtest single-wait-signaled: SUCCESS (0.000s) [208.248201] [018/156] (893s left) perf (enable-disable) [208.375695] Starting subtest: enable-disable [208.377692] Starting dynamic subtest: 0-rcs0 [210.672539] Dynamic subtest 0-rcs0: SUCCESS (2.296s) [210.682169] Starting dynamic subtest: 1-vecs0 [215.201652] Dynamic subtest 1-vecs0: SUCCESS (4.529s) [215.204026] Subtest enable-disable: SUCCESS (6.826s) [215.242267] [019/156] (886s left) kms_frontbuffer_tracking (hdr-1p-rte) [215.351725] Starting subtest: hdr-1p-rte [215.355793] Subtest hdr-1p-rte: SKIP (0.000s) [215.450043] [020/156] (886s left) gem_lmem_swapping (basic) [215.492502] Subtest basic: SKIP (0.000s) [215.532291] [021/156] (886s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt) [215.634226] Starting subtest: psr-rgb565-draw-blt [222.724093] Subtest psr-rgb565-draw-blt: SUCCESS (7.095s) [222.860157] [022/156] (878s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt) [222.957675] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt [222.962071] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [223.061313] [023/156] (878s left) gem_exec_fence (syncobj-timeline-invalid-wait) [223.621087] Starting subtest: syncobj-timeline-invalid-wait [223.623631] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.003s) [225.337315] [024/156] (876s left) gem_exec_schedule (preempt-contexts) [225.407787] Starting subtest: preempt-contexts [225.410208] Starting dynamic subtest: rcs0 [225.458054] Dynamic subtest rcs0: SUCCESS (0.059s) [225.470114] Starting dynamic subtest: bcs0 [225.539416] Dynamic subtest bcs0: SUCCESS (0.081s) [225.548630] Starting dynamic subtest: vcs0 [225.605309] Dynamic subtest vcs0: SUCCESS (0.065s) [225.615679] Starting dynamic subtest: vcs1 [225.663154] Dynamic subtest vcs1: SUCCESS (0.058s) [225.675096] Starting dynamic subtest: vecs0 [225.725255] Dynamic subtest vecs0: SUCCESS (0.059s) [225.735727] Starting dynamic subtest: ccs0 [225.801890] Dynamic subtest ccs0: SUCCESS (0.078s) [225.804449] Subtest preempt-contexts: SUCCESS (0.404s) [227.431550] [025/156] (874s left) kms_psr (fbc-pr-cursor-mmap-gtt) [227.520591] Starting subtest: fbc-pr-cursor-mmap-gtt [227.524538] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s) [227.594702] [026/156] (874s left) kms_lease (lease-get) [227.693351] Starting subtest: lease-get [227.695649] Starting dynamic subtest: pipe-A-eDP-1 [227.698091] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [227.706743] Starting dynamic subtest: pipe-B-eDP-1 [227.708622] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [227.720854] Starting dynamic subtest: pipe-C-eDP-1 [227.722709] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [227.730736] Starting dynamic subtest: pipe-D-eDP-1 [227.732734] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [227.734602] Subtest lease-get: SUCCESS (0.008s) [227.803131] [027/156] (873s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [227.905063] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu [235.125442] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.226s) [235.232124] [028/156] (866s left) perf_pmu (busy-accuracy-2) [235.278371] Starting subtest: busy-accuracy-2 [235.280510] Starting dynamic subtest: rcs0 [238.318751] Dynamic subtest rcs0: SUCCESS (3.039s) [238.329659] Starting dynamic subtest: bcs0 [241.429087] Dynamic subtest bcs0: SUCCESS (3.057s) [241.439099] Starting dynamic subtest: vcs0 [244.468809] Dynamic subtest vcs0: SUCCESS (3.041s) [244.480271] Starting dynamic subtest: vcs1 [247.515723] Dynamic subtest vcs1: SUCCESS (3.046s) [247.526979] Starting dynamic subtest: vecs0 [250.559687] Dynamic subtest vecs0: SUCCESS (3.044s) [250.569054] Starting dynamic subtest: ccs0 [253.621205] Dynamic subtest ccs0: SUCCESS (3.060s) [253.623546] Subtest busy-accuracy-2: SUCCESS (18.294s) [253.685897] [029/156] (848s left) kms_frontbuffer_tracking (psrhdr-indfb-scaledprimary) [253.798331] Starting subtest: psrhdr-indfb-scaledprimary [253.802254] Subtest psrhdr-indfb-scaledprimary: SKIP (0.000s) [253.898760] [030/156] (848s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-onoff) [253.998781] Starting subtest: fbchdr-2p-primscrn-spr-indfb-onoff [254.002976] Subtest fbchdr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [254.100535] [031/156] (847s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc) [254.214859] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc [254.219127] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [254.308355] [032/156] (847s left) gem_compute (compute-square) [254.361068] Starting subtest: compute-square [254.365635] Subtest compute-square: SUCCESS (0.007s) [254.487752] [033/156] (847s left) kms_cursor_crc (cursor-random-128x42) [254.712138] Starting subtest: cursor-random-128x42 [254.764644] Subtest cursor-random-128x42: SKIP (0.047s) [254.946824] [034/156] (847s left) perf (non-sampling-read-error) [255.039249] Starting subtest: non-sampling-read-error [255.048501] Subtest non-sampling-read-error: SUCCESS (0.008s) [255.089816] [035/156] (847s left) syncobj_basic (bad-pad-fd-to-handle) [255.149095] Starting subtest: bad-pad-fd-to-handle [255.151077] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [255.259115] [036/156] (846s left) gem_ctx_persistence (legacy-engines-mixed-process) [255.311726] Starting subtest: legacy-engines-mixed-process [255.313778] Starting dynamic subtest: render [257.271161] Dynamic subtest render: SUCCESS (1.958s) [257.283155] Starting dynamic subtest: bsd1 [259.349759] Dynamic subtest bsd1: SUCCESS (2.077s) [259.361605] Starting dynamic subtest: bsd2 [261.294858] Dynamic subtest bsd2: SUCCESS (1.942s) [261.305160] Starting dynamic subtest: blt [263.280065] Dynamic subtest blt: SUCCESS (1.982s) [263.289578] Starting dynamic subtest: vebox [265.286108] Dynamic subtest vebox: SUCCESS (2.006s) [265.288498] Subtest legacy-engines-mixed-process: SUCCESS (9.974s) [265.383290] [037/156] (836s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [265.488624] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-mmap-cpu [265.492795] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [265.575687] [038/156] (836s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-pwrite) [265.679792] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-pwrite [265.684082] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s) [265.787325] [039/156] (836s left) kms_vblank (wait-forked-busy-hang) [265.877132] Starting subtest: wait-forked-busy-hang [265.879020] Starting dynamic subtest: pipe-A-eDP-1 [292.032029] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.152s) [292.045723] Starting dynamic subtest: pipe-D-eDP-1 [307.082739] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.048s) [307.084839] Subtest wait-forked-busy-hang: SUCCESS (41.204s) [307.905317] [040/156] (794s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-blt) [308.001601] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-blt [308.005757] Subtest psrhdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [308.105075] [041/156] (794s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc) [308.192821] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc [308.195743] Starting dynamic subtest: pipe-A-eDP-1 [308.205062] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [308.216625] Starting dynamic subtest: pipe-B-eDP-1 [308.225812] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [308.235663] Starting dynamic subtest: pipe-C-eDP-1 [308.244213] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [308.253156] Starting dynamic subtest: pipe-D-eDP-1 [308.261661] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [308.265799] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s) [310.460879] [042/156] (791s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0) [310.562885] Starting subtest: primary-yf-tiled-reflect-x-0 [310.622288] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.059s) [310.728874] [043/156] (791s left) kms_prop_blob (basic) [310.784022] Starting subtest: basic [310.786238] Subtest basic: SUCCESS (0.000s) [310.899998] [044/156] (791s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs) [310.995616] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs [310.997817] Starting dynamic subtest: pipe-A-eDP-1 [311.430252] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.436s) [311.442337] Starting dynamic subtest: pipe-B-eDP-1 [311.460262] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.003s) [311.470167] Starting dynamic subtest: pipe-C-eDP-1 [311.486483] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s) [311.495089] Starting dynamic subtest: pipe-D-eDP-1 [311.511263] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s) [311.513107] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.451s) [313.726154] [045/156] (788s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format) [313.823655] Starting subtest: plane-downscale-factor-0-75-with-pixel-format [313.826065] Starting dynamic subtest: pipe-A [314.994509] Dynamic subtest pipe-A: SUCCESS (1.174s) [315.003737] Starting dynamic subtest: pipe-B [317.213869] Dynamic subtest pipe-B: SUCCESS (2.218s) [317.223576] Starting dynamic subtest: pipe-C [318.431229] Dynamic subtest pipe-C: SUCCESS (1.216s) [318.441534] Starting dynamic subtest: pipe-D [319.665816] Dynamic subtest pipe-D: SUCCESS (1.234s) [319.668295] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.846s) [320.863191] [046/156] (781s left) gem_mmap (short-mmap) [320.919131] Subtest short-mmap: SKIP (0.000s) [320.981297] [047/156] (781s left) kms_pm_lpsp (screens-disabled) [322.077529] Starting subtest: screens-disabled [322.082068] Subtest screens-disabled: SKIP (0.000s) [322.149399] [048/156] (780s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area) [322.251776] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area [322.254149] Starting dynamic subtest: pipe-A-eDP-1 [322.348488] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s) [322.360614] Starting dynamic subtest: pipe-B-eDP-1 [323.538029] Dynamic subtest pipe-B-eDP-1: SKIP (1.187s) [323.542628] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.290s) [324.733992] [049/156] (777s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move) [324.827151] Starting subtest: psr-1p-primscrn-spr-indfb-move [332.278862] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.455s) [332.424195] [050/156] (770s left) kms_flip (2x-plain-flip-interruptible) [332.518797] Starting subtest: 2x-plain-flip-interruptible [332.530991] Subtest 2x-plain-flip-interruptible: SKIP (0.011s) [332.634925] [051/156] (770s left) kms_cursor_edge_walk (256x256-left-edge) [332.722267] Starting subtest: 256x256-left-edge [332.724595] Starting dynamic subtest: pipe-A-eDP-1 [336.217661] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.495s) [336.229731] Starting dynamic subtest: pipe-D-eDP-1 [339.438792] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.221s) [339.441205] Subtest 256x256-left-edge: SUCCESS (6.718s) [340.246146] [052/156] (762s left) kms_plane_multiple (2x-tiling-x) [340.346227] Starting subtest: 2x-tiling-x [340.350748] Subtest 2x-tiling-x: SKIP (0.000s) [340.422152] [053/156] (762s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc) [340.522626] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc [340.526936] Subtest fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [340.632768] [054/156] (762s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs) [340.717203] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs [340.719464] Starting dynamic subtest: pipe-A-eDP-1 [340.777804] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [340.789035] Starting dynamic subtest: pipe-B-eDP-1 [340.848134] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [340.858129] Starting dynamic subtest: pipe-C-eDP-1 [340.915442] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [340.925950] Starting dynamic subtest: pipe-D-eDP-1 [340.982328] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [340.986696] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.009s) [343.016081] [055/156] (759s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-blt) [343.123808] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-blt [343.127880] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s) [343.225337] [056/156] (759s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render) [343.321904] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render [347.495757] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.180s) [348.640480] [057/156] (754s left) i915_drm_fdinfo (busy-idle) [348.683235] Starting subtest: busy-idle [348.685560] Starting dynamic subtest: rcs0 [348.717065] Dynamic subtest rcs0: SKIP (0.032s) [348.726739] Starting dynamic subtest: bcs0 [348.730737] Dynamic subtest bcs0: SKIP (0.000s) [348.740029] Starting dynamic subtest: vcs0 [348.744246] Dynamic subtest vcs0: SKIP (0.000s) [348.753151] Starting dynamic subtest: vcs1 [348.757161] Dynamic subtest vcs1: SKIP (0.000s) [348.766913] Starting dynamic subtest: vecs0 [348.771108] Dynamic subtest vecs0: SKIP (0.000s) [348.779797] Starting dynamic subtest: ccs0 [348.783682] Dynamic subtest ccs0: SKIP (0.001s) [348.787746] Subtest busy-idle: SKIP (0.040s) [348.825185] [058/156] (754s left) syncobj_timeline (multi-wait-available-submitted-signaled) [348.876769] Starting subtest: multi-wait-available-submitted-signaled [348.879203] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s) [348.984842] [059/156] (754s left) gem_ctx_persistence (engines-mixed) [349.049927] Starting subtest: engines-mixed [349.051968] Starting dynamic subtest: rcs0 [349.143330] Dynamic subtest rcs0: SUCCESS (0.094s) [349.155609] Starting dynamic subtest: bcs0 [349.198021] Dynamic subtest bcs0: SUCCESS (0.052s) [349.209864] Starting dynamic subtest: vcs0 [349.240594] Dynamic subtest vcs0: SUCCESS (0.041s) [349.250634] Starting dynamic subtest: vcs1 [349.289773] Dynamic subtest vcs1: SUCCESS (0.048s) [349.301881] Starting dynamic subtest: vecs0 [349.332922] Dynamic subtest vecs0: SUCCESS (0.041s) [349.344257] Starting dynamic subtest: ccs0 [349.382047] Dynamic subtest ccs0: SUCCESS (0.047s) [349.385067] Subtest engines-mixed: SUCCESS (0.334s) [349.461832] [060/156] (753s left) kms_color (ctm-blue-to-red) [349.545264] Starting subtest: ctm-blue-to-red [349.547609] Starting dynamic subtest: pipe-A-eDP-1 [350.258676] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.711s) [350.268998] Starting dynamic subtest: pipe-B-eDP-1 [351.630740] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.375s) [351.641626] Starting dynamic subtest: pipe-C-eDP-1 [352.994860] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.362s) [353.004692] Starting dynamic subtest: pipe-D-eDP-1 [354.351544] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.356s) [354.353696] Subtest ctm-blue-to-red: SUCCESS (4.807s) [355.157442] [061/156] (748s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary) [355.263052] Starting subtest: fbcpsr-indfb-scaledprimary [361.036475] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.779s) [361.201265] [062/156] (742s left) syncobj_timeline (etime-single-wait-available-unsubmitted) [361.255319] Starting subtest: etime-single-wait-available-unsubmitted [361.364598] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.108s) [361.442481] [063/156] (741s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-pwrite) [361.532046] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-pwrite [361.536297] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [361.614448] [064/156] (741s left) gen7_exec_parse (basic-rejected) [361.672962] Subtest basic-rejected: SKIP (0.000s) [361.744196] [065/156] (741s left) kms_psr (fbc-psr-suspend) [361.832975] Starting subtest: fbc-psr-suspend [361.835343] Starting dynamic subtest: eDP-1 [361.839587] Dynamic subtest eDP-1: SKIP (0.000s) [361.843837] Subtest fbc-psr-suspend: SKIP (0.001s) [361.906445] [066/156] (741s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render) [362.014051] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render [362.018333] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [362.105978] [067/156] (741s left) kms_chamelium_hpd (dp-hpd-storm-disable) [362.492971] Subtest dp-hpd-storm-disable: SKIP (0.000s) [363.303498] [068/156] (740s left) kms_psr (pr-cursor-plane-onoff) [363.398545] Starting subtest: pr-cursor-plane-onoff [363.403074] Subtest pr-cursor-plane-onoff: SKIP (0.000s) [363.490858] [069/156] (740s left) gem_exec_params (secure-non-master) [363.543456] Starting subtest: secure-non-master [363.548185] Subtest secure-non-master: SKIP (0.000s) [363.651564] [070/156] (739s left) kms_cursor_legacy (cursor-vs-flip-varying-size) [363.766655] Starting subtest: cursor-vs-flip-varying-size [395.106530] Subtest cursor-vs-flip-varying-size: SUCCESS (31.337s) [395.961796] [071/156] (707s left) kms_flip (2x-wf_vblank-ts-check) [396.059808] Starting subtest: 2x-wf_vblank-ts-check [396.069019] Subtest 2x-wf_vblank-ts-check: SKIP (0.011s) [396.161353] [072/156] (707s left) gem_mmap_gtt (close-race) [396.215073] Subtest close-race: SKIP (0.000s) [396.280046] [073/156] (707s left) gem_exec_params (invalid-bsd1-flag-on-render) [396.345836] Starting subtest: invalid-bsd1-flag-on-render [396.348079] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s) [396.462345] [074/156] (707s left) kms_big_fb (y-tiled-32bpp-rotate-0) [396.570302] Starting subtest: y-tiled-32bpp-rotate-0 [396.574535] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s) [396.674455] [075/156] (707s left) gem_exec_reloc (basic-wc-active) [396.740226] Subtest basic-wc-active: SKIP (0.000s) [396.817560] [076/156] (707s left) gem_exec_balancer (bonded-false-hang) [397.080254] Starting subtest: bonded-false-hang [397.085358] Subtest bonded-false-hang: SKIP (0.000s) [397.213120] [077/156] (706s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-mmap-gtt) [397.324715] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-mmap-gtt [397.329230] Subtest hdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [397.417784] [078/156] (706s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf) [397.516881] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf [397.521412] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [397.606828] [079/156] (706s left) kms_big_fb (linear-16bpp-rotate-270) [397.704454] Starting subtest: linear-16bpp-rotate-270 [397.725032] Subtest linear-16bpp-rotate-270: SKIP (0.019s) [397.832443] [080/156] (706s left) kms_chamelium_frames (hdmi-crc-single) [398.223256] Subtest hdmi-crc-single: SKIP (0.000s) [399.069925] [081/156] (705s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [399.175169] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-mmap-gtt [399.179429] Subtest hdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [399.284753] [082/156] (704s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-mmap-cpu) [399.389712] Starting subtest: fbchdr-rgb101010-draw-mmap-cpu [399.394024] Subtest fbchdr-rgb101010-draw-mmap-cpu: SKIP (0.000s) [399.491242] [083/156] (704s left) kms_joiner (basic-force-big-joiner) [399.581048] Starting subtest: basic-force-big-joiner [399.585213] Subtest basic-force-big-joiner: SKIP (0.000s) [399.650601] [084/156] (704s left) dmabuf_sync_file (export-before-signal) [399.691278] Starting subtest: export-before-signal [399.693722] Subtest export-before-signal: SUCCESS (0.001s) [399.749693] [085/156] (704s left) kms_atomic (plane-primary-overlay-mutable-zpos) [399.840511] Starting subtest: plane-primary-overlay-mutable-zpos [403.317622] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.476s) [404.507874] [086/156] (699s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt) [404.612173] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt [404.616306] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [404.728532] [087/156] (699s left) i915_query (query-topology-kernel-writes) [404.784305] Starting subtest: query-topology-kernel-writes [404.786680] Subtest query-topology-kernel-writes: SUCCESS (0.000s) [404.879114] [088/156] (699s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled) [404.927453] Starting subtest: multi-wait-all-for-submit-submitted-signaled [405.035584] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.108s) [405.128348] [089/156] (699s left) kms_big_fb (x-tiled-addfb) [405.227444] Starting subtest: x-tiled-addfb [405.229433] Subtest x-tiled-addfb: SUCCESS (0.000s) [405.334070] [090/156] (699s left) i915_pm_rps (engine-order) [405.394065] Starting subtest: engine-order [410.538176] Subtest engine-order: SUCCESS (5.143s) [410.657561] [091/156] (693s left) kms_addfb_basic (basic) [410.711582] Starting subtest: basic [410.714040] Subtest basic: SUCCESS (0.000s) [410.846373] [092/156] (693s left) gem_mmap_wc (coherency) [410.895335] Subtest coherency: SKIP (0.000s) [410.956110] [093/156] (693s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu) [411.051047] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu [411.055464] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [411.137763] [094/156] (693s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-fullscreen) [411.232172] Starting subtest: psrhdr-2p-primscrn-spr-indfb-fullscreen [411.236146] Subtest psrhdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [411.326550] [095/156] (693s left) kms_cursor_legacy (cursora-vs-flipa-legacy) [411.442439] Starting subtest: cursorA-vs-flipA-legacy [422.581527] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.139s) [423.435878] [096/156] (681s left) gem_userptr_blits (access-control) [423.523767] Starting subtest: access-control [423.528473] Subtest access-control: SKIP (0.000s) [423.635940] [097/156] (681s left) gem_pxp (display-protected-crc) [423.750471] Starting subtest: display-protected-crc [425.595291] Subtest display-protected-crc: SUCCESS (1.848s) [425.714482] [098/156] (679s left) prime_vgem (busy) [425.788828] Starting subtest: busy [425.791166] Starting dynamic subtest: rcs0 [425.849243] Dynamic subtest rcs0: SUCCESS (0.061s) [425.859055] Starting dynamic subtest: bcs0 [425.919410] Dynamic subtest bcs0: SUCCESS (0.069s) [425.929036] Starting dynamic subtest: vcs0 [425.965342] Dynamic subtest vcs0: SUCCESS (0.045s) [425.975067] Starting dynamic subtest: vcs1 [426.010695] Dynamic subtest vcs1: SUCCESS (0.044s) [426.020470] Starting dynamic subtest: vecs0 [426.057656] Dynamic subtest vecs0: SUCCESS (0.046s) [426.067499] Starting dynamic subtest: ccs0 [426.104333] Dynamic subtest ccs0: SUCCESS (0.046s) [426.106600] Subtest busy: SUCCESS (0.316s) [426.240204] [099/156] (678s left) gem_eio (create) [426.455062] Starting subtest: create [426.747961] Subtest create: SUCCESS (0.294s) [426.860082] [100/156] (678s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-render) [426.961368] Starting subtest: psrhdr-rgb565-draw-render [426.964852] Subtest psrhdr-rgb565-draw-render: SKIP (0.000s) [427.061667] [101/156] (677s left) kms_flip (2x-dpms-vs-vblank-race-interruptible) [427.158940] Starting subtest: 2x-dpms-vs-vblank-race-interruptible [427.175062] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.015s) [427.256717] [102/156] (677s left) kms_selftest (drm_cmdline_parser) [427.291603] Starting subtest: drm_cmdline_parser [427.299346] Starting dynamic subtest: drm_test_cmdline_force_d_only [427.382554] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.083s) [427.394416] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi [427.471886] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.088s) [427.480896] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi [427.568527] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.095s) [427.578017] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital [427.664429] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.095s) [427.674532] Starting dynamic subtest: drm_test_cmdline_force_e_only [427.755404] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.091s) [427.765964] Starting dynamic subtest: drm_test_cmdline_res [427.866705] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.109s) [427.877581] Starting dynamic subtest: drm_test_cmdline_res_vesa [427.970614] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.104s) [427.979830] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank [428.068061] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.097s) [428.077545] Starting dynamic subtest: drm_test_cmdline_res_rblank [428.177984] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.107s) [428.189520] Starting dynamic subtest: drm_test_cmdline_res_bpp [428.286494] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.108s) [428.297087] Starting dynamic subtest: drm_test_cmdline_res_refresh [428.406083] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.118s) [428.417321] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh [428.502305] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.096s) [428.513464] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced [428.601092] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.097s) [428.612118] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins [428.699062] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.098s) [428.711099] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off [428.795414] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.094s) [428.804438] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on [428.907237] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.110s) [428.918269] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog [429.009083] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.099s) [429.020160] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital [429.119055] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.110s) [429.129927] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on [429.221178] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.100s) [429.231962] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on [429.318069] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.095s) [429.329337] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins [429.421401] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.100s) [429.430392] Starting dynamic subtest: drm_test_cmdline_name [429.516766] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.095s) [429.526256] Starting dynamic subtest: drm_test_cmdline_name_bpp [429.622604] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.106s) [429.632304] Starting dynamic subtest: drm_test_cmdline_name_option [429.711923] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.086s) [429.722324] Starting dynamic subtest: drm_test_cmdline_name_bpp_option [429.809485] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.098s) [429.818797] Starting dynamic subtest: drm_test_cmdline_rotate_0 [429.919548] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.109s) [429.930886] Starting dynamic subtest: drm_test_cmdline_rotate_90 [430.008543] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.087s) [430.019962] Starting dynamic subtest: drm_test_cmdline_rotate_180 [430.115014] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.107s) [430.124092] Starting dynamic subtest: drm_test_cmdline_rotate_270 [430.212410] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.097s) [430.224041] Starting dynamic subtest: drm_test_cmdline_hmirror [430.308931] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.095s) [430.318487] Starting dynamic subtest: drm_test_cmdline_vmirror [430.409909] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.100s) [430.419046] Starting dynamic subtest: drm_test_cmdline_margin_options [430.519783] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.109s) [430.529114] Starting dynamic subtest: drm_test_cmdline_multiple_options [430.613376] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.092s) [430.623794] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option [430.693774] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.081s) [430.702965] Starting dynamic subtest: drm_test_cmdline_extra_and_option [430.792547] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.097s) [430.802768] Starting dynamic subtest: drm_test_cmdline_freestanding_options [430.888792] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.097s) [430.898228] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options [430.971695] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.083s) [430.982975] Starting dynamic subtest: drm_test_cmdline_panel_orientation [431.054363] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.079s) [431.063617] Starting dynamic subtest: drm_test_cmdline_invalid [431.176401] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.120s) [431.185686] Starting dynamic subtest: drm_test_cmdline_tv_options [431.291905] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.117s) [431.294372] Subtest drm_cmdline_parser: SUCCESS (4.004s) [431.477693] [103/156] (673s left) gem_userptr_blits (map-fixed-invalidate-busy) [431.563101] Starting subtest: map-fixed-invalidate-busy [431.567705] Subtest map-fixed-invalidate-busy: SKIP (0.000s) [431.692390] [104/156] (673s left) gem_pxp (reject-modify-context-protection-on) [431.742680] Starting subtest: reject-modify-context-protection-on [431.744829] Subtest reject-modify-context-protection-on: SUCCESS (0.001s) [431.849083] [105/156] (673s left) kms_psr (psr2-primary-blt) [431.951053] Starting subtest: psr2-primary-blt [431.953381] Starting dynamic subtest: eDP-1 [433.707306] Dynamic subtest eDP-1: SUCCESS (1.757s) [433.709757] Subtest psr2-primary-blt: SUCCESS (1.758s) [434.577085] [106/156] (670s left) syncobj_timeline (invalid-query-zero-handles) [434.636637] Starting subtest: invalid-query-zero-handles [434.638900] Subtest invalid-query-zero-handles: SUCCESS (0.000s) [434.723593] [107/156] (670s left) sysfs_heartbeat_interval (precise) [434.788153] Starting subtest: precise [434.790398] Starting dynamic subtest: vecs0 [442.302040] Dynamic subtest vecs0: SUCCESS (7.514s) [442.313688] Starting dynamic subtest: ccs0 [443.416408] Dynamic subtest ccs0: SUCCESS (1.111s) [443.428073] Starting dynamic subtest: vcs0 [451.324404] Dynamic subtest vcs0: SUCCESS (7.904s) [451.336717] Starting dynamic subtest: bcs0 [452.412931] Dynamic subtest bcs0: SUCCESS (1.089s) [452.423973] Starting dynamic subtest: rcs0 [453.515097] Dynamic subtest rcs0: SUCCESS (1.100s) [453.525094] Starting dynamic subtest: vcs1 [461.316306] Dynamic subtest vcs1: SUCCESS (7.799s) [461.318963] Subtest precise: SUCCESS (26.531s) [461.410390] [108/156] (643s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu) [461.517520] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu [465.065481] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.552s) [466.285809] [109/156] (639s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-onoff) [466.397757] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-onoff [466.401830] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s) [466.500790] [110/156] (638s left) kms_cursor_crc (cursor-offscreen-256x85) [466.772486] Starting subtest: cursor-offscreen-256x85 [466.823841] Subtest cursor-offscreen-256x85: SKIP (0.046s) [467.014638] [111/156] (638s left) gem_render_copy (y-tiled-to-vebox-x-tiled) [467.069618] Starting subtest: y-tiled-to-vebox-x-tiled [467.074242] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s) [467.281616] [112/156] (638s left) gem_softpin (softpin) [467.335097] Starting subtest: softpin [499.696696] Subtest softpin: SUCCESS (32.358s) [499.824207] [113/156] (605s left) core_auth (getclient-master-drop) [499.860404] Starting subtest: getclient-master-drop [499.876668] Subtest getclient-master-drop: SUCCESS (0.021s) [499.994226] [114/156] (605s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt) [500.088639] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt [500.092871] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [500.180197] [115/156] (605s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc) [500.285937] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc [500.289962] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [500.389262] [116/156] (605s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-shrfb-plflip-blt) [500.496629] Starting subtest: fbchdr-1p-primscrn-shrfb-plflip-blt [500.500851] Subtest fbchdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [500.592455] [117/156] (605s left) kms_chamelium_color (ctm-0-75) [500.684229] Subtest ctm-0-75: SKIP (0.000s) [500.730950] [118/156] (605s left) kms_cursor_legacy (flip-vs-cursor-varying-size) [500.849167] Starting subtest: flip-vs-cursor-varying-size [509.963873] Subtest flip-vs-cursor-varying-size: SUCCESS (9.113s) [510.799881] [119/156] (595s left) gem_exec_reloc (basic-active) [510.858312] Subtest basic-active: SKIP (0.000s) [510.933388] [120/156] (594s left) gem_wait (write-busy) [510.993416] Starting subtest: write-busy [510.996127] Starting dynamic subtest: all-engines [511.589710] Dynamic subtest all-engines: SUCCESS (0.595s) [511.605113] Starting dynamic subtest: rcs0 [512.147519] Dynamic subtest rcs0: SUCCESS (0.556s) [512.166688] Starting dynamic subtest: bcs0 [512.697052] Dynamic subtest bcs0: SUCCESS (0.548s) [512.714942] Starting dynamic subtest: vcs0 [514.304306] Dynamic subtest vcs0: SUCCESS (1.605s) [514.322446] Starting dynamic subtest: vcs1 [516.287513] Dynamic subtest vcs1: SUCCESS (1.980s) [516.304956] Starting dynamic subtest: vecs0 [518.272271] Dynamic subtest vecs0: SUCCESS (1.981s) [518.289438] Starting dynamic subtest: ccs0 [518.822238] Dynamic subtest ccs0: SUCCESS (0.550s) [518.824699] Subtest write-busy: SUCCESS (7.829s) [519.031200] [121/156] (586s left) gem_exec_balancer (semaphore) [519.087068] Starting subtest: semaphore [520.322576] Subtest semaphore: SUCCESS (1.234s) [520.640918] [122/156] (585s left) kms_frontbuffer_tracking (hdr-indfb-scaledprimary) [520.742975] Starting subtest: hdr-indfb-scaledprimary [520.747125] Subtest hdr-indfb-scaledprimary: SKIP (0.000s) [520.834701] [123/156] (585s left) kms_frontbuffer_tracking (fbcpsrhdr-farfromfence-mmap-gtt) [520.942150] Starting subtest: fbcpsrhdr-farfromfence-mmap-gtt [520.946574] Subtest fbcpsrhdr-farfromfence-mmap-gtt: SKIP (0.000s) [521.020973] [124/156] (585s left) syncobj_timeline (wait-any-snapshot) [521.071581] Starting subtest: wait-any-snapshot [521.151619] Subtest wait-any-snapshot: SUCCESS (0.081s) [521.229973] [125/156] (584s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite) [521.321579] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite [530.250598] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.933s) [530.398321] [126/156] (575s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite) [530.500785] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite [530.505136] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [530.585857] [127/156] (575s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted) [530.641523] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted [530.748546] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.106s) [530.839117] [128/156] (575s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-wc) [530.933263] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-wc [530.937573] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [531.038841] [129/156] (575s left) gem_spin_batch (legacy-resubmit-new) [531.105845] Starting subtest: legacy-resubmit-new [531.108720] Starting dynamic subtest: default [531.113919] Dynamic subtest default: SUCCESS (0.007s) [531.125287] Starting dynamic subtest: render [531.127581] Dynamic subtest render: SUCCESS (0.003s) [531.137437] Starting dynamic subtest: bsd [531.139739] Dynamic subtest bsd: SUCCESS (0.004s) [531.149350] Starting dynamic subtest: bsd1 [531.151262] Dynamic subtest bsd1: SUCCESS (0.003s) [531.160561] Starting dynamic subtest: bsd2 [531.162429] Dynamic subtest bsd2: SUCCESS (0.004s) [531.171562] Starting dynamic subtest: blt [531.173493] Dynamic subtest blt: SUCCESS (0.004s) [531.182662] Starting dynamic subtest: vebox [531.184537] Dynamic subtest vebox: SUCCESS (0.005s) [531.186423] Subtest legacy-resubmit-new: SUCCESS (0.037s) [532.342675] [130/156] (573s left) gem_mmap_gtt (zero-extend) [532.392108] Subtest zero-extend: SKIP (0.000s) [532.454865] [131/156] (573s left) perf_pmu (enable-race) [532.497797] Starting subtest: enable-race [532.500220] Starting dynamic subtest: rcs0 [545.289904] Dynamic subtest rcs0: SUCCESS (12.772s) [545.302079] Starting dynamic subtest: bcs0 [558.032096] Dynamic subtest bcs0: SUCCESS (12.739s) [558.043202] Starting dynamic subtest: vcs0 [573.247049] Dynamic subtest vcs0: SUCCESS (15.229s) [573.259853] Starting dynamic subtest: vcs1 [589.247621] Dynamic subtest vcs1: SUCCESS (15.997s) [589.262615] Starting dynamic subtest: vecs0 [605.247232] Dynamic subtest vecs0: SUCCESS (15.996s) [605.258186] Starting dynamic subtest: ccs0 [618.005588] Dynamic subtest ccs0: SUCCESS (12.737s) [618.008566] Subtest enable-race: SUCCESS (85.485s) [618.082022] [132/156] (488s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5) [618.187924] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5 [618.190266] Starting dynamic subtest: pipe-A [618.211592] Dynamic subtest pipe-A: SKIP (0.019s) [618.222417] Starting dynamic subtest: pipe-B [618.242274] Dynamic subtest pipe-B: SKIP (0.032s) [618.252645] Starting dynamic subtest: pipe-C [618.278711] Dynamic subtest pipe-C: SKIP (0.033s) [618.288920] Starting dynamic subtest: pipe-D [618.309975] Dynamic subtest pipe-D: SKIP (0.033s) [618.314442] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.120s) [618.431129] [133/156] (487s left) kms_content_protection (srm) [618.582358] Starting subtest: srm [618.589609] Subtest srm: SKIP (0.003s) [618.714976] [134/156] (487s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-onoff) [618.818864] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-onoff [618.823261] Subtest psrhdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [618.944705] [135/156] (487s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt) [619.036684] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt [623.548057] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.516s) [624.733204] [136/156] (481s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-blt) [624.840150] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-blt [624.844726] Subtest psrhdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [624.945354] [137/156] (481s left) i915_power (sanity) [624.999897] Starting subtest: sanity [629.043563] Subtest sanity: SUCCESS (4.037s) [630.361889] [138/156] (476s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [630.476241] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [630.480357] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [630.583826] [139/156] (476s left) kms_pipe_crc_basic (bad-source) [630.676263] Starting subtest: bad-source [630.678492] Subtest bad-source: SUCCESS (0.000s) [630.751370] [140/156] (475s left) gem_mmap_gtt (basic-small-bo) [630.807979] Subtest basic-small-bo: SKIP (0.000s) [630.866532] [141/156] (475s left) kms_busy (extended-pageflip-modeset-hang-oldfb) [630.976056] Starting subtest: extended-pageflip-modeset-hang-oldfb [630.978044] Starting dynamic subtest: pipe-A [638.865614] Dynamic subtest pipe-A: SUCCESS (7.888s) [638.878389] Starting dynamic subtest: pipe-D [647.527215] Dynamic subtest pipe-D: SUCCESS (8.658s) [647.529593] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.551s) [648.375011] [142/156] (458s left) kms_dp_link_training (uhbr-mst) [648.470085] Starting subtest: uhbr-mst [648.478485] Subtest uhbr-mst: SKIP (0.000s) [648.542545] [143/156] (458s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite) [648.643092] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite [648.647437] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [648.742048] [144/156] (458s left) gem_userptr_blits (stress-mm-invalidate-close) [648.810139] Starting subtest: stress-mm-invalidate-close [650.959093] Subtest stress-mm-invalidate-close: SUCCESS (2.149s) [651.081022] [145/156] (455s left) kms_dsc (dsc-with-bpc-formats) [651.174200] Starting subtest: dsc-with-bpc-formats [651.286518] Subtest dsc-with-bpc-formats: SKIP (0.003s) [651.330859] [146/156] (455s left) gem_mmap_gtt (medium-copy-xy) [651.390530] Subtest medium-copy-XY: SKIP (0.000s) [651.461614] [147/156] (455s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping) [651.556104] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping [651.560078] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s) [651.630410] [148/156] (455s left) gem_exec_reloc (basic-cpu-read) [651.685768] Subtest basic-cpu-read: SKIP (0.000s) [651.761859] [149/156] (455s left) gem_exec_flush (basic-wb-rw-default) [651.828382] Starting subtest: basic-wb-rw-default [657.312783] Subtest basic-wb-rw-default: SUCCESS (5.464s) [657.489140] [150/156] (449s left) kms_addfb_basic (basic-x-tiled-legacy) [657.556891] Starting subtest: basic-x-tiled-legacy [657.561114] Subtest basic-x-tiled-legacy: SKIP (0.000s) [657.728862] [151/156] (449s left) gem_exec_fence (basic-wait-all) [657.790906] Starting subtest: basic-wait-all [657.878093] Subtest basic-wait-all: SUCCESS (0.087s) [659.413342] [152/156] (447s left) gem_exec_whisper (basic-forked-all) [659.469223] Starting subtest: basic-forked-all [673.364299] Subtest basic-forked-all: SUCCESS (13.895s) [673.553118] [153/156] (433s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt) [673.650744] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt [680.675432] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (7.028s) [680.801228] [154/156] (426s left) gem_exec_schedule (u-semaphore-user) [680.880239] Starting subtest: u-semaphore-user [680.931449] Subtest u-semaphore-user: SUCCESS (0.057s) [682.360310] [155/156] (425s left) gem_exec_reloc (basic-gtt-noreloc) [682.419825] Subtest basic-gtt-noreloc: SKIP (0.000s) [682.490309] [156/156] (424s left) syncobj_basic (illegal-fd-to-handle) [682.545041] Starting subtest: illegal-fd-to-handle [682.547265] Subtest illegal-fd-to-handle: SUCCESS (0.000s) [682.658672] Closing watchdogs results: parsing output: 0/ for test: fbdev results: parsing output: 1/ for test: kms_plane_alpha_blend results: parsing output: 2/ for test: kms_big_fb results: parsing output: 3/ for test: kms_flip results: parsing output: 4/ for test: kms_flip_scaled_crc results: parsing output: 5/ for test: kms_flip results: parsing output: 6/ for test: i915_module_load results: parsing output: 7/ for test: vgem_basic results: parsing output: 8/ for test: kms_atomic_interruptible results: parsing output: 9/ for test: api_intel_bb results: parsing output: 10/ for test: kms_psr results: parsing output: 11/ for test: kms_tiled_display results: parsing output: 12/ for test: kms_big_fb results: parsing output: 13/ for test: kms_ccs results: parsing output: 14/ for test: kms_getfb results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: syncobj_wait results: parsing output: 17/ for test: perf results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: gem_lmem_swapping results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: gem_exec_fence results: parsing output: 23/ for test: gem_exec_schedule results: parsing output: 24/ for test: kms_psr results: parsing output: 25/ for test: kms_lease results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: perf_pmu results: parsing output: 28/ for test: kms_frontbuffer_tracking results: parsing output: 29/ for test: kms_frontbuffer_tracking results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: gem_compute results: parsing output: 32/ for test: kms_cursor_crc results: parsing output: 33/ for test: perf results: parsing output: 34/ for test: syncobj_basic results: parsing output: 35/ for test: gem_ctx_persistence results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: kms_vblank results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: kms_ccs results: parsing output: 41/ for test: kms_rotation_crc results: parsing output: 42/ for test: kms_prop_blob results: parsing output: 43/ for test: kms_ccs results: parsing output: 44/ for test: kms_plane_scaling results: parsing output: 45/ for test: gem_mmap results: parsing output: 46/ for test: kms_pm_lpsp results: parsing output: 47/ for test: kms_psr2_sf results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: kms_flip results: parsing output: 50/ for test: kms_cursor_edge_walk results: parsing output: 51/ for test: kms_plane_multiple results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: kms_ccs results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: i915_drm_fdinfo results: parsing output: 57/ for test: syncobj_timeline results: parsing output: 58/ for test: gem_ctx_persistence results: parsing output: 59/ for test: kms_color results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: syncobj_timeline results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: gen7_exec_parse results: parsing output: 64/ for test: kms_psr results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: kms_chamelium_hpd results: parsing output: 67/ for test: kms_psr results: parsing output: 68/ for test: gem_exec_params results: parsing output: 69/ for test: kms_cursor_legacy results: parsing output: 70/ for test: kms_flip results: parsing output: 71/ for test: gem_mmap_gtt results: parsing output: 72/ for test: gem_exec_params results: parsing output: 73/ for test: kms_big_fb results: parsing output: 74/ for test: gem_exec_reloc results: parsing output: 75/ for test: gem_exec_balancer results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: kms_psr2_sf results: parsing output: 78/ for test: kms_big_fb results: parsing output: 79/ for test: kms_chamelium_frames results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: kms_joiner results: parsing output: 83/ for test: dmabuf_sync_file results: parsing output: 84/ for test: kms_atomic results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: i915_query results: parsing output: 87/ for test: syncobj_wait results: parsing output: 88/ for test: kms_big_fb results: parsing output: 89/ for test: i915_pm_rps results: parsing output: 90/ for test: kms_addfb_basic results: parsing output: 91/ for test: gem_mmap_wc results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: kms_cursor_legacy results: parsing output: 95/ for test: gem_userptr_blits results: parsing output: 96/ for test: gem_pxp results: parsing output: 97/ for test: prime_vgem results: parsing output: 98/ for test: gem_eio results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: kms_flip results: parsing output: 101/ for test: kms_selftest results: parsing output: 102/ for test: gem_userptr_blits results: parsing output: 103/ for test: gem_pxp results: parsing output: 104/ for test: kms_psr results: parsing output: 105/ for test: syncobj_timeline results: parsing output: 106/ for test: sysfs_heartbeat_interval results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: kms_cursor_crc results: parsing output: 110/ for test: gem_render_copy results: parsing output: 111/ for test: gem_softpin results: parsing output: 112/ for test: core_auth results: parsing output: 113/ for test: kms_frontbuffer_tracking 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_chamelium_color results: parsing output: 117/ for test: kms_cursor_legacy results: parsing output: 118/ for test: gem_exec_reloc results: parsing output: 119/ for test: gem_wait results: parsing output: 120/ for test: gem_exec_balancer 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: syncobj_timeline results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: gem_spin_batch results: parsing output: 129/ for test: gem_mmap_gtt results: parsing output: 130/ for test: perf_pmu results: parsing output: 131/ for test: kms_plane_scaling results: parsing output: 132/ for test: kms_content_protection results: parsing output: 133/ for test: kms_frontbuffer_tracking results: parsing output: 134/ for test: kms_frontbuffer_tracking results: parsing output: 135/ for test: kms_frontbuffer_tracking results: parsing output: 136/ for test: i915_power results: parsing output: 137/ for test: kms_big_fb results: parsing output: 138/ for test: kms_pipe_crc_basic results: parsing output: 139/ for test: gem_mmap_gtt results: parsing output: 140/ for test: kms_busy results: parsing output: 141/ for test: kms_dp_link_training results: parsing output: 142/ for test: kms_frontbuffer_tracking results: parsing output: 143/ for test: gem_userptr_blits results: parsing output: 144/ for test: kms_dsc results: parsing output: 145/ for test: gem_mmap_gtt results: parsing output: 146/ for test: kms_plane results: parsing output: 147/ for test: gem_exec_reloc results: parsing output: 148/ for test: gem_exec_flush results: parsing output: 149/ for test: kms_addfb_basic results: parsing output: 150/ for test: gem_exec_fence results: parsing output: 151/ for test: gem_exec_whisper results: parsing output: 152/ for test: kms_frontbuffer_tracking results: parsing output: 153/ for test: gem_exec_schedule results: parsing output: 154/ for test: gem_exec_reloc results: parsing output: 155/ for test: syncobj_basic Done.