[57.450542] Initializing watchdogs [57.450591] /dev/watchdog0 [57.464739] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [57.469312] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.471618] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.475210] [001/133] (960s left) gem_exec_fence (syncobj-backward-timeline-chain-engines) [58.066096] Starting subtest: syncobj-backward-timeline-chain-engines [58.225840] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.160s) [60.007086] [FACT gem_exec_fence (syncobj-backward-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true [60.010550] [002/133] (958s left) kms_lease (possible-crtcs-filtering) [60.106905] Starting subtest: possible-crtcs-filtering [60.113898] Subtest possible-crtcs-filtering: SUCCESS (0.005s) [60.227326] [003/133] (957s left) kms_flip (2x-wf_vblank-ts-check) [60.322969] Starting subtest: 2x-wf_vblank-ts-check [60.331747] Subtest 2x-wf_vblank-ts-check: SKIP (0.011s) [60.439522] [004/133] (957s left) kms_color (ctm-signed) [60.533957] Starting subtest: ctm-signed [60.536266] Starting dynamic subtest: pipe-A-eDP-1 [62.687076] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.156s) [62.695663] Starting dynamic subtest: pipe-B-eDP-1 [65.456904] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.773s) [65.469514] Starting dynamic subtest: pipe-C-eDP-1 [68.075931] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.624s) [68.088981] Starting dynamic subtest: pipe-D-eDP-1 [70.748096] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.673s) [70.750542] Subtest ctm-signed: SUCCESS (10.228s) [71.573033] [005/133] (946s left) gem_exec_capture (capture-recoverable) [71.633082] Starting subtest: capture-recoverable [71.638087] Subtest capture-recoverable: SUCCESS (0.003s) [71.768532] [006/133] (946s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render) [71.870994] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render [76.312757] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.447s) [77.484925] [007/133] (940s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite) [77.592784] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite [77.597256] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [77.698183] [008/133] (940s left) kms_atomic_interruptible (universal-setplane-primary) [77.803166] Starting subtest: universal-setplane-primary [77.805526] Starting dynamic subtest: pipe-A-eDP-1 [85.230079] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.425s) [85.232240] Subtest universal-setplane-primary: SUCCESS (7.426s) [86.049384] [009/133] (932s left) gen3_render_mixed_blits [86.185519] [010/133] (932s left) gem_ctx_exec (basic-nohangcheck) [86.250065] Starting subtest: basic-nohangcheck [86.494923] Subtest basic-nohangcheck: SUCCESS (0.246s) [86.633633] [011/133] (931s left) perf (global-sseu-config-invalid) [86.754411] Starting subtest: global-sseu-config-invalid [86.758013] Subtest global-sseu-config-invalid: SKIP (0.000s) [86.811302] [012/133] (931s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc) [86.908920] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc [86.911297] Starting dynamic subtest: pipe-A-eDP-1 [86.934802] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [86.944470] Starting dynamic subtest: pipe-B-eDP-1 [86.965903] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [86.973042] Starting dynamic subtest: pipe-C-eDP-1 [86.994579] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [87.001854] Starting dynamic subtest: pipe-D-eDP-1 [87.024766] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [87.028835] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s) [89.124640] [013/133] (929s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs) [89.232214] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs [89.234587] Starting dynamic subtest: pipe-A-eDP-1 [89.258682] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [89.267535] Starting dynamic subtest: pipe-B-eDP-1 [89.289858] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [89.297074] Starting dynamic subtest: pipe-C-eDP-1 [89.318916] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [89.327777] Starting dynamic subtest: pipe-D-eDP-1 [89.349262] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [89.353288] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.003s) [91.396265] [014/133] (927s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move) [91.490961] Starting subtest: psr-2p-scndscrn-spr-indfb-move [91.495276] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [91.572969] [015/133] (926s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc) [91.660944] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc [91.663311] Starting dynamic subtest: pipe-A-eDP-1 [91.685628] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [91.694841] Starting dynamic subtest: pipe-B-eDP-1 [91.715629] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [91.723293] Starting dynamic subtest: pipe-C-eDP-1 [91.744291] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [91.753792] Starting dynamic subtest: pipe-D-eDP-1 [91.775362] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [91.779282] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [93.881935] [016/133] (924s left) kms_vblank (ts-continuation-suspend) [93.971059] Starting subtest: ts-continuation-suspend [93.973216] Starting dynamic subtest: pipe-A-eDP-1 [110.714939] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.802s) [110.728264] Starting dynamic subtest: pipe-D-eDP-1 [127.545905] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.210s) [127.548125] Subtest ts-continuation-suspend: SUCCESS (4.016s) [128.351920] [017/133] (890s left) prime_self_import (export-vs-gem_close-race) [128.396304] Starting subtest: export-vs-gem_close-race [133.489499] Subtest export-vs-gem_close-race: SUCCESS (5.143s) [133.566467] [018/133] (885s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render) [133.669404] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render [140.515872] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.882s) [140.666741] [019/133] (878s left) api_intel_bb (purge-bb) [140.718335] Starting subtest: purge-bb [140.720270] Subtest purge-bb: SUCCESS (0.005s) [140.844629] [020/133] (877s left) kms_pm_backlight (fade-with-dpms) [140.933939] Starting subtest: fade-with-dpms [143.063593] Starting dynamic subtest: eDP-1 [145.550940] Dynamic subtest eDP-1: SUCCESS (2.490s) [145.553402] Subtest fade-with-dpms: SUCCESS (4.628s) [146.342599] [021/133] (872s left) gem_exec_whisper (basic-fds-forked) [146.403740] Starting subtest: basic-fds-forked [170.426797] Subtest basic-fds-forked: SUCCESS (24.030s) [170.618443] [022/133] (848s left) kms_frontbuffer_tracking (fbc-suspend) [170.719896] Starting subtest: fbc-suspend [208.689777] Subtest fbc-suspend: SUCCESS (7.419s) [209.867881] [023/133] (809s left) prime_busy (after) [209.927884] Starting subtest: after [209.930041] Starting dynamic subtest: rcs0 [209.953905] Dynamic subtest rcs0: SUCCESS (0.024s) [209.964852] Starting dynamic subtest: bcs0 [210.001803] Dynamic subtest bcs0: SUCCESS (0.048s) [210.011620] Starting dynamic subtest: vcs0 [210.042201] Dynamic subtest vcs0: SUCCESS (0.040s) [210.051514] Starting dynamic subtest: vcs1 [210.083679] Dynamic subtest vcs1: SUCCESS (0.041s) [210.092638] Starting dynamic subtest: vecs0 [210.124093] Dynamic subtest vecs0: SUCCESS (0.040s) [210.133148] Starting dynamic subtest: ccs0 [210.165571] Dynamic subtest ccs0: SUCCESS (0.041s) [210.273707] Subtest after: SUCCESS (0.348s) [210.385899] [024/133] (808s left) vgem_basic (bad-flag) [210.436352] Starting subtest: bad-flag [210.438771] Subtest bad-flag: SUCCESS (0.000s) [210.493123] [025/133] (808s left) kms_flip (2x-flip-vs-wf_vblank) [210.575997] Starting subtest: 2x-flip-vs-wf_vblank [210.587791] Subtest 2x-flip-vs-wf_vblank: SKIP (0.011s) [210.666188] [026/133] (808s left) gem_exec_suspend (basic-s3-devices) [210.723431] Starting subtest: basic-S3-devices [210.725801] Starting dynamic subtest: smem [222.134002] Dynamic subtest smem: SUCCESS (11.457s) [222.137022] Subtest basic-S3-devices: SUCCESS (11.459s) [222.317584] [027/133] (796s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0) [222.424405] Starting subtest: linear-max-hw-stride-32bpp-rotate-0 [223.580616] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.158s) [223.689869] [028/133] (795s left) gem_mmap_wc (read-write-distinct) [223.759954] Subtest read-write-distinct: SKIP (0.000s) [223.822888] [029/133] (795s left) kms_cursor_crc (cursor-onscreen-128x128) [224.026161] Starting subtest: cursor-onscreen-128x128 [224.027995] Starting dynamic subtest: pipe-A-eDP-1 [226.137442] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.109s) [226.164245] Starting dynamic subtest: pipe-D-eDP-1 [228.898805] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.743s) [228.901105] Subtest cursor-onscreen-128x128: SUCCESS (4.877s) [229.768287] [030/133] (789s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted) [229.833705] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted [229.937647] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.103s) [230.015973] [031/133] (789s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc) [230.122433] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc [230.126585] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [230.238862] [032/133] (789s left) kms_psr (psr-sprite-plane-onoff) [230.352836] Starting subtest: psr-sprite-plane-onoff [230.355081] Starting dynamic subtest: eDP-1 [232.110129] Dynamic subtest eDP-1: SUCCESS (1.757s) [232.112410] Subtest psr-sprite-plane-onoff: SUCCESS (1.758s) [232.924133] [033/133] (786s left) kms_tv_load_detect (load-detect) [232.989850] Subtest load-detect: SKIP (0.000s) [233.047484] [034/133] (786s left) kms_addfb_basic (bo-too-small) [233.148045] Starting subtest: bo-too-small [233.149960] Subtest bo-too-small: SUCCESS (0.000s) [233.243211] [035/133] (786s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled) [233.285939] Starting subtest: invalid-multi-wait-unsubmitted-signaled [233.288205] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s) [233.385414] [036/133] (786s left) prime_self_import (basic-with_one_bo) [233.428049] Starting subtest: basic-with_one_bo [233.449941] Subtest basic-with_one_bo: SUCCESS (0.025s) [233.563828] [037/133] (785s left) gem_close (many-handles-one-vma) [233.617224] Starting subtest: many-handles-one-vma [233.638807] Subtest many-handles-one-vma: SUCCESS (0.023s) [233.728873] [038/133] (785s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf) [233.835601] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf [233.839783] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s) [233.902950] [039/133] (785s left) gem_ctx_sseu (mmap-args) [233.959681] Subtest mmap-args: SKIP (0.000s) [234.035272] [040/133] (785s left) kms_pm_rpm (modeset-non-lpsp-stress) [236.277011] Starting subtest: modeset-non-lpsp-stress [237.430669] Subtest modeset-non-lpsp-stress: SKIP (1.154s) [237.819435] [041/133] (781s left) kms_psr (fbc-psr-cursor-render) [237.917187] Starting subtest: fbc-psr-cursor-render [237.919447] Starting dynamic subtest: eDP-1 [237.923874] Dynamic subtest eDP-1: SKIP (0.000s) [237.928418] Subtest fbc-psr-cursor-render: SKIP (0.001s) [237.991396] [042/133] (781s left) gem_userptr_blits (dmabuf-sync) [238.053771] Starting subtest: dmabuf-sync [238.058304] Subtest dmabuf-sync: SKIP (0.002s) [238.203120] [043/133] (781s left) kms_joiner (basic-force-big-joiner) [238.300431] Starting subtest: basic-force-big-joiner [238.304535] Subtest basic-force-big-joiner: SKIP (0.000s) [238.371857] [044/133] (781s left) kms_plane (pixel-format-y-tiled-ccs-modifier) [238.458128] Starting subtest: pixel-format-y-tiled-ccs-modifier [238.462546] Subtest pixel-format-y-tiled-ccs-modifier: SKIP (0.000s) [238.528683] [045/133] (781s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc) [238.619265] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc [238.621498] Starting dynamic subtest: pipe-A-eDP-1 [238.679368] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [238.688529] Starting dynamic subtest: pipe-B-eDP-1 [238.744217] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [238.753827] Starting dynamic subtest: pipe-C-eDP-1 [238.800053] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [238.808189] Starting dynamic subtest: pipe-D-eDP-1 [238.856526] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [238.859897] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s) [240.763626] [046/133] (779s left) gem_ctx_param (non-root-set) [240.824756] Starting subtest: non-root-set [240.846584] Subtest non-root-set: SUCCESS (0.023s) [240.953169] [047/133] (778s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move) [241.058086] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move [241.062491] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [241.144403] [048/133] (778s left) gem_partial_pwrite_pread (write-uncached) [241.212855] Subtest write-uncached: SKIP (0.000s) [241.293741] [049/133] (778s left) gem_lmem_swapping (random-engines) [241.345132] Subtest random-engines: SKIP (0.000s) [241.397691] [050/133] (778s left) kms_big_fb (yf-tiled-addfb-size-overflow) [241.508709] Starting subtest: yf-tiled-addfb-size-overflow [241.512937] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s) [241.623185] [051/133] (778s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen) [241.717728] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen [241.721464] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [241.810705] [052/133] (778s left) perf (polling) [241.913099] Starting subtest: polling [241.914993] Starting dynamic subtest: 0-rcs0 [251.929149] Dynamic subtest 0-rcs0: SUCCESS (10.022s) [251.939368] Starting dynamic subtest: 1-vcs0 [261.949351] Dynamic subtest 1-vcs0: SUCCESS (10.019s) [261.953274] Subtest polling: SUCCESS (20.044s) [261.998537] [053/133] (758s left) kms_plane_cursor (primary) [262.098249] Starting subtest: primary [262.102788] Starting dynamic subtest: pipe-A-eDP-1-size-64 [264.683011] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.585s) [264.710114] Starting dynamic subtest: pipe-A-eDP-1-size-128 [267.272047] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.571s) [267.296943] Starting dynamic subtest: pipe-A-eDP-1-size-256 [269.871817] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.582s) [270.186428] Starting dynamic subtest: pipe-B-eDP-1-size-64 [273.445943] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.269s) [273.470594] Starting dynamic subtest: pipe-B-eDP-1-size-128 [276.057663] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.594s) [276.081347] Starting dynamic subtest: pipe-B-eDP-1-size-256 [278.658078] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.583s) [278.979103] Starting dynamic subtest: pipe-C-eDP-1-size-64 [281.886141] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.917s) [281.913304] Starting dynamic subtest: pipe-C-eDP-1-size-128 [284.085292] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.180s) [284.111726] Starting dynamic subtest: pipe-C-eDP-1-size-256 [286.285456] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.180s) [286.608896] Starting dynamic subtest: pipe-D-eDP-1-size-64 [289.521520] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.923s) [289.550744] Starting dynamic subtest: pipe-D-eDP-1-size-128 [291.765077] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.225s) [291.790233] Starting dynamic subtest: pipe-D-eDP-1-size-256 [293.964347] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.181s) [294.273580] Subtest primary: SUCCESS (32.185s) [295.085588] [054/133] (725s left) fbdev (info) [295.123916] Starting subtest: info [295.126267] Subtest info: SUCCESS (0.000s) [295.194941] [055/133] (725s left) syncobj_wait (wait-all-for-submit-snapshot) [295.257520] Starting subtest: wait-all-for-submit-snapshot [295.337839] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s) [295.417103] [056/133] (724s left) gem_lmem_swapping (heavy-verify-multi) [295.465178] Subtest heavy-verify-multi: SKIP (0.000s) [295.512147] [057/133] (724s left) sw_sync (sync_busy_fork) [295.553099] Starting subtest: sync_busy_fork [296.565514] Subtest sync_busy_fork: SUCCESS (1.013s) [296.629854] [058/133] (723s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling) [296.722274] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling [296.726261] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s) [296.794324] [059/133] (723s left) gem_exec_schedule (smoketest) [296.975002] Starting subtest: smoketest [296.977765] Starting dynamic subtest: rcs0 [302.514806] Dynamic subtest rcs0: SUCCESS (5.495s) [302.528566] Starting dynamic subtest: bcs0 [308.029922] Dynamic subtest bcs0: SUCCESS (5.509s) [308.041003] Starting dynamic subtest: vcs0 [313.530295] Dynamic subtest vcs0: SUCCESS (5.506s) [313.541062] Starting dynamic subtest: vcs1 [319.030772] Dynamic subtest vcs1: SUCCESS (5.496s) [319.045296] Starting dynamic subtest: vecs0 [324.519724] Dynamic subtest vecs0: SUCCESS (5.492s) [324.529619] Starting dynamic subtest: ccs0 [330.030458] Dynamic subtest ccs0: SUCCESS (5.514s) [330.032695] Subtest smoketest: SUCCESS (33.022s) [330.197781] [060/133] (690s left) kms_async_flips (async-flip-hang) [330.306867] Starting subtest: async-flip-hang [330.677720] Starting dynamic subtest: pipe-A-eDP-1 [345.553949] Dynamic subtest pipe-A-eDP-1: SUCCESS (14.880s) [345.922698] Starting dynamic subtest: pipe-B-eDP-1 [361.613374] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.702s) [361.992650] Starting dynamic subtest: pipe-C-eDP-1 [377.546631] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.563s) [377.916221] Starting dynamic subtest: pipe-D-eDP-1 [393.557847] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.624s) [393.560280] Subtest async-flip-hang: SUCCESS (63.250s) [394.791630] [061/133] (625s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [394.900389] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu [394.904356] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [394.985805] [062/133] (625s left) prime_mmap (test_map_unmap) [395.037010] Starting subtest: test_map_unmap [395.038876] Starting dynamic subtest: test_map_unmap-smem [395.066208] Dynamic subtest test_map_unmap-smem: SUCCESS (0.031s) [395.068630] Subtest test_map_unmap: SUCCESS (0.032s) [395.154616] [063/133] (625s left) kms_psr (fbc-psr2-primary-mmap-cpu) [395.251171] Starting subtest: fbc-psr2-primary-mmap-cpu [395.253485] Starting dynamic subtest: eDP-1 [395.257407] Dynamic subtest eDP-1: SKIP (0.000s) [395.261432] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s) [395.335002] [064/133] (625s left) kms_psr (fbc-pr-cursor-mmap-cpu) [395.428564] Starting subtest: fbc-pr-cursor-mmap-cpu [395.433091] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s) [395.500807] [065/133] (625s left) i915_suspend (debugfs-reader) [395.557758] Starting subtest: debugfs-reader [414.245147] Subtest debugfs-reader: SUCCESS (3.187s) [414.357191] [066/133] (606s left) gem_exec_await (wide-contexts) [414.557927] Starting subtest: wide-contexts [439.527938] Subtest wide-contexts: SUCCESS (25.080s) [439.734226] [067/133] (581s left) i915_hangman (gt-engine-error) [439.851347] Starting subtest: gt-engine-error [439.853647] Starting dynamic subtest: rcs0 [441.573240] Dynamic subtest rcs0: SUCCESS (1.721s) [441.586899] Starting dynamic subtest: bcs0 [443.557157] Dynamic subtest bcs0: SUCCESS (1.983s) [443.569258] Starting dynamic subtest: vcs0 [445.540910] Dynamic subtest vcs0: SUCCESS (1.982s) [445.553908] Starting dynamic subtest: vcs1 [447.588288] Dynamic subtest vcs1: SUCCESS (2.045s) [447.603934] Starting dynamic subtest: vecs0 [449.509688] Dynamic subtest vecs0: SUCCESS (1.917s) [449.522321] Starting dynamic subtest: ccs0 [451.556718] Dynamic subtest ccs0: SUCCESS (2.043s) [451.559647] Subtest gt-engine-error: SUCCESS (11.708s) [451.698180] [068/133] (569s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled) [451.758611] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled [451.760989] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s) [451.853034] [069/133] (569s left) kms_selftest (drm_dp_mst_helper) [451.899456] Starting subtest: drm_dp_mst_helper [451.909127] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode [452.009830] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.101s) [452.024612] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div [452.102505] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.092s) [452.112307] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode [452.196561] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.094s) [452.198956] Subtest drm_dp_mst_helper: SUCCESS (0.300s) [452.363289] [070/133] (568s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling) [452.470532] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling [452.475160] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s) [452.544075] [071/133] (568s left) kms_flip (2x-dpms-vs-vblank-race) [452.647351] Starting subtest: 2x-dpms-vs-vblank-race [452.656390] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s) [452.775758] [072/133] (568s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling) [452.874920] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling [452.878613] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s) [452.956464] [073/133] (568s left) syncobj_wait (invalid-multi-wait-unsubmitted) [453.003092] Starting subtest: invalid-multi-wait-unsubmitted [453.004977] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [453.097139] [074/133] (567s left) api_intel_allocator (two-level-inception-interruptible) [453.154456] Starting subtest: two-level-inception-interruptible [458.561089] Subtest two-level-inception-interruptible: SUCCESS (5.405s) [458.692807] [075/133] (562s left) kms_big_fb (4-tiled-addfb-size-overflow) [458.802339] Starting subtest: 4-tiled-addfb-size-overflow [458.804542] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s) [458.901983] [076/133] (562s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [458.994630] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu [458.998842] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [459.099831] [077/133] (562s left) kms_setmode (invalid-clone-single-crtc) [459.151103] Starting subtest: invalid-clone-single-crtc [459.157471] Subtest invalid-clone-single-crtc: SKIP (0.000s) [459.262193] [078/133] (562s left) kms_cursor_crc (cursor-rapid-movement-512x170) [459.574135] Starting subtest: cursor-rapid-movement-512x170 [459.578179] Subtest cursor-rapid-movement-512x170: SKIP (0.001s) [459.709027] [079/133] (561s left) gem_mmap_gtt (basic-small-copy-odd) [459.778518] Subtest basic-small-copy-odd: SKIP (0.000s) [459.854006] [080/133] (561s left) gem_userptr_blits (huge-split) [459.933982] Starting subtest: huge-split [459.940936] Subtest huge-split: SUCCESS (0.007s) [460.063990] [081/133] (561s left) gem_create (create-size-update) [460.120094] Starting subtest: create-size-update [460.121780] Subtest create-size-update: SUCCESS (0.000s) [460.326266] [082/133] (561s left) gem_exec_reloc (basic-wc-gtt-noreloc) [460.378944] Subtest basic-wc-gtt-noreloc: SKIP (0.000s) [460.458610] [083/133] (561s left) syncobj_timeline (single-wait-all-for-submit-signaled) [460.509156] Starting subtest: single-wait-all-for-submit-signaled [460.511324] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [460.618902] [084/133] (560s left) kms_psr (psr2-sprite-plane-move) [460.720003] Starting subtest: psr2-sprite-plane-move [460.722119] Starting dynamic subtest: eDP-1 [462.509058] Dynamic subtest eDP-1: SUCCESS (1.787s) [462.511424] Subtest psr2-sprite-plane-move: SUCCESS (1.788s) [463.348297] [085/133] (558s left) kms_chamelium_color (ctm-0-25) [463.440111] Subtest ctm-0-25: SKIP (0.000s) [463.487473] [086/133] (558s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render) [463.578556] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render [463.582945] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [463.703714] [087/133] (557s left) kms_flip (2x-flip-vs-panning-vs-hang) [463.795743] Starting subtest: 2x-flip-vs-panning-vs-hang [463.807569] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.013s) [463.889635] [088/133] (557s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render) [463.985113] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render [463.989068] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [464.074140] [089/133] (557s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling) [464.163961] Starting subtest: planes-downscale-factor-0-5-unity-scaling [464.166091] Starting dynamic subtest: pipe-A [464.185804] Dynamic subtest pipe-A: SKIP (0.019s) [464.195361] Starting dynamic subtest: pipe-B [464.219374] Dynamic subtest pipe-B: SKIP (0.033s) [464.230711] Starting dynamic subtest: pipe-C [464.254697] Dynamic subtest pipe-C: SKIP (0.032s) [464.264587] Starting dynamic subtest: pipe-D [464.284556] Dynamic subtest pipe-D: SKIP (0.032s) [464.287716] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.118s) [464.381886] [090/133] (557s left) kms_plane_scaling (invalid-parameters) [464.472421] Starting subtest: invalid-parameters [464.474325] Starting dynamic subtest: less-than-1-height-src [464.486013] Dynamic subtest less-than-1-height-src: SUCCESS (0.014s) [464.495352] Starting dynamic subtest: less-than-1-width-src [464.500069] Dynamic subtest less-than-1-width-src: SUCCESS (0.014s) [464.501968] Subtest invalid-parameters: SUCCESS (0.029s) [464.594843] [091/133] (557s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu) [464.692344] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu [471.360717] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.670s) [471.491601] [092/133] (550s left) gem_exec_params (invalid-bsd2-flag-on-vebox) [471.555342] Starting subtest: invalid-bsd2-flag-on-vebox [471.557729] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s) [471.666906] [093/133] (550s left) kms_cursor_edge_walk (64x64-right-edge) [471.768900] Starting subtest: 64x64-right-edge [471.771114] Starting dynamic subtest: pipe-A-eDP-1 [475.257798] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.490s) [475.267252] Starting dynamic subtest: pipe-D-eDP-1 [478.377684] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.118s) [478.380017] Subtest 64x64-right-edge: SUCCESS (6.612s) [479.179959] [094/133] (542s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt) [479.285029] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt [486.066758] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.787s) [486.238060] [095/133] (535s left) perf_pmu (frequency) [486.282870] Starting subtest: frequency [486.287819] Starting dynamic subtest: gt0 [488.439134] Dynamic subtest gt0: SUCCESS (2.147s) [488.459977] Starting dynamic subtest: idle-gt0 [488.944697] Dynamic subtest idle-gt0: SUCCESS (0.504s) [488.956316] Starting dynamic subtest: gt1 [493.617245] Dynamic subtest gt1: SUCCESS (4.668s) [493.630024] Starting dynamic subtest: idle-gt1 [494.141384] Dynamic subtest idle-gt1: SUCCESS (0.525s) [494.143967] Subtest frequency: SUCCESS (7.862s) [494.253017] [096/133] (527s left) kms_pipe_crc_basic (read-crc) [494.376253] Starting subtest: read-crc [494.378546] Starting dynamic subtest: pipe-A-eDP-1 [495.096686] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.720s) [495.106579] Starting dynamic subtest: pipe-B-eDP-1 [496.475355] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.377s) [496.486088] Starting dynamic subtest: pipe-C-eDP-1 [497.869548] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.396s) [497.879697] Starting dynamic subtest: pipe-D-eDP-1 [499.188564] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.317s) [499.191105] Subtest read-crc: SUCCESS (4.816s) [500.029540] [097/133] (522s left) gen9_exec_parse (batch-invalid-length) [500.092631] Subtest batch-invalid-length: SKIP (0.000s) [500.164497] [098/133] (521s left) kms_getfb (getfb2-handle-not-fb) [500.247754] Starting subtest: getfb2-handle-not-fb [500.250042] Subtest getfb2-handle-not-fb: SUCCESS (0.000s) [500.351244] [099/133] (521s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt) [500.447985] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt [507.820372] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.378s) [507.945353] [100/133] (514s left) kms_atomic (crtc-invalid-params) [508.037956] Starting subtest: crtc-invalid-params [508.040251] Starting dynamic subtest: pipe-A-eDP-1 [508.396275] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.358s) [508.398489] Subtest crtc-invalid-params: SUCCESS (0.359s) [509.276582] [101/133] (512s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc) [509.365233] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc [513.686847] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.323s) [514.890262] [102/133] (507s left) dumb_buffer (create-clear) [514.950925] Starting subtest: create-clear [548.820860] Subtest create-clear: SUCCESS (33.861s) [548.922213] [103/133] (473s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt) [549.028196] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt [549.032730] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [549.108824] [104/133] (473s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled) [549.157305] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled [549.161979] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s) [549.340835] [105/133] (473s left) gem_mmap_wc (bad-offset) [549.395045] Subtest bad-offset: SKIP (0.000s) [549.452555] [106/133] (472s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area) [549.545067] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area [549.547420] Starting dynamic subtest: pipe-A-eDP-1 [549.666743] Dynamic subtest pipe-A-eDP-1: SKIP (0.122s) [549.680856] Starting dynamic subtest: pipe-B-eDP-1 [550.857452] Dynamic subtest pipe-B-eDP-1: SKIP (1.188s) [550.862202] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.314s) [552.037317] [107/133] (470s left) gem_ctx_persistence (heartbeat-hang) [552.093733] Starting subtest: heartbeat-hang [552.098371] Subtest heartbeat-hang: SKIP (0.000s) [552.195000] [108/133] (470s left) gem_mmap_offset (bad-extensions) [552.258665] Starting subtest: bad-extensions [552.260938] Subtest bad-extensions: SUCCESS (0.000s) [552.359008] [109/133] (470s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [552.455138] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip [553.246118] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.792s) [553.442569] [110/133] (469s left) kms_dirtyfb (psr-dirtyfb-ioctl) [553.538106] Starting subtest: psr-dirtyfb-ioctl [553.540370] Starting dynamic subtest: A-eDP-1 [557.367756] Dynamic subtest A-eDP-1: SUCCESS (3.829s) [557.370066] Subtest psr-dirtyfb-ioctl: SUCCESS (3.830s) [558.243204] [111/133] (464s left) syncobj_wait (wait-all-for-submit-complex) [558.313979] Starting subtest: wait-all-for-submit-complex [558.529866] Subtest wait-all-for-submit-complex: SUCCESS (0.214s) [558.610665] [112/133] (464s left) gem_mmap (short-mmap) [558.671434] Subtest short-mmap: SKIP (0.000s) [558.728343] [113/133] (464s left) gem_spin_batch (legacy-resubmit-new) [558.784610] Starting subtest: legacy-resubmit-new [558.786929] Starting dynamic subtest: default [558.793395] Dynamic subtest default: SUCCESS (0.008s) [558.805447] Starting dynamic subtest: render [558.807753] Dynamic subtest render: SUCCESS (0.005s) [558.817551] Starting dynamic subtest: bsd [558.819802] Dynamic subtest bsd: SUCCESS (0.005s) [558.831038] Starting dynamic subtest: bsd1 [558.833206] Dynamic subtest bsd1: SUCCESS (0.007s) [558.842455] Starting dynamic subtest: bsd2 [558.844609] Dynamic subtest bsd2: SUCCESS (0.003s) [558.853696] Starting dynamic subtest: blt [558.855960] Dynamic subtest blt: SUCCESS (0.004s) [558.865197] Starting dynamic subtest: vebox [558.867469] Dynamic subtest vebox: SUCCESS (0.005s) [558.869734] Subtest legacy-resubmit-new: SUCCESS (0.043s) [560.688721] [114/133] (462s left) kms_content_protection (mei-interface) [560.833749] Starting subtest: mei-interface [560.838325] Subtest mei-interface: SKIP (0.001s) [560.958181] [115/133] (461s left) perf_pmu (enable-race) [561.003311] Starting subtest: enable-race [561.007855] Starting dynamic subtest: rcs0 [573.777899] Dynamic subtest rcs0: SUCCESS (12.776s) [573.790333] Starting dynamic subtest: bcs0 [586.521054] Dynamic subtest bcs0: SUCCESS (12.743s) [586.533323] Starting dynamic subtest: vcs0 [602.630191] Dynamic subtest vcs0: SUCCESS (16.109s) [602.641142] Starting dynamic subtest: vcs1 [618.630371] Dynamic subtest vcs1: SUCCESS (16.001s) [618.642894] Starting dynamic subtest: vecs0 [634.630732] Dynamic subtest vecs0: SUCCESS (16.002s) [634.643399] Starting dynamic subtest: ccs0 [647.374363] Dynamic subtest ccs0: SUCCESS (12.740s) [647.376746] Subtest enable-race: SUCCESS (86.385s) [647.528350] [116/133] (375s left) gem_exec_schedule (preempt) [647.607182] Starting subtest: preempt [647.609484] Starting dynamic subtest: rcs0 [647.635949] Dynamic subtest rcs0: SUCCESS (0.036s) [647.648964] Starting dynamic subtest: bcs0 [647.665683] Dynamic subtest bcs0: SUCCESS (0.029s) [647.675420] Starting dynamic subtest: vcs0 [647.693485] Dynamic subtest vcs0: SUCCESS (0.027s) [647.703436] Starting dynamic subtest: vcs1 [647.730810] Dynamic subtest vcs1: SUCCESS (0.036s) [647.742483] Starting dynamic subtest: vecs0 [647.754832] Dynamic subtest vecs0: SUCCESS (0.023s) [647.764791] Starting dynamic subtest: ccs0 [647.791102] Dynamic subtest ccs0: SUCCESS (0.036s) [647.793519] Subtest preempt: SUCCESS (0.192s) [649.677214] [117/133] (373s left) gem_mmap_wc (read-write) [649.733541] Subtest read-write: SKIP (0.000s) [649.791355] [118/133] (373s left) gem_pxp (reject-modify-context-protection-off-2) [649.912314] Starting subtest: reject-modify-context-protection-off-2 [649.914770] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s) [650.018485] [119/133] (373s left) kms_psr (pr-dpms) [650.115976] Starting subtest: pr-dpms [650.120445] Subtest pr-dpms: SKIP (0.000s) [650.204060] [120/133] (372s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k) [650.585278] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s) [651.434067] [121/133] (371s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted) [651.499831] Starting subtest: etime-single-wait-all-for-submit-unsubmitted [651.601917] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.101s) [651.683373] [122/133] (371s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs) [651.769711] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs [651.772534] Starting dynamic subtest: pipe-A-eDP-1 [651.793946] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [651.807931] Starting dynamic subtest: pipe-B-eDP-1 [651.827517] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [651.837016] Starting dynamic subtest: pipe-C-eDP-1 [651.856596] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [651.865842] Starting dynamic subtest: pipe-D-eDP-1 [651.885394] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [651.887604] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.007s) [654.004762] [123/133] (369s left) gem_readwrite (read-write) [654.053213] Subtest read-write: SKIP (0.000s) [654.115094] [124/133] (369s left) gem_exec_balancer (invalid-bonds) [654.174537] Starting subtest: invalid-bonds [654.178994] Subtest invalid-bonds: SKIP (0.000s) [654.474012] [125/133] (368s left) kms_big_fb (y-tiled-64bpp-rotate-180) [654.579605] Starting subtest: y-tiled-64bpp-rotate-180 [654.584059] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s) [654.670560] [126/133] (368s left) kms_dsc (dsc-with-bpc) [654.766165] Starting subtest: dsc-with-bpc [654.796255] Subtest dsc-with-bpc: SKIP (0.001s) [654.838347] [127/133] (368s left) gem_exec_reloc (basic-concurrent0) [654.889887] Subtest basic-concurrent0: SKIP (0.000s) [654.959426] [128/133] (368s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe) [655.338240] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s) [656.118502] [129/133] (367s left) i915_drm_fdinfo (most-busy-check-all) [656.171288] Starting subtest: most-busy-check-all [656.173240] Starting dynamic subtest: rcs0 [656.178014] Dynamic subtest rcs0: SKIP (0.004s) [656.189121] Starting dynamic subtest: bcs0 [656.193652] Dynamic subtest bcs0: SKIP (0.000s) [656.203245] Starting dynamic subtest: vcs0 [656.207801] Dynamic subtest vcs0: SKIP (0.000s) [656.217022] Starting dynamic subtest: vcs1 [656.221180] Dynamic subtest vcs1: SKIP (0.000s) [656.230372] Starting dynamic subtest: vecs0 [656.234621] Dynamic subtest vecs0: SKIP (0.000s) [656.243772] Starting dynamic subtest: ccs0 [656.247953] Dynamic subtest ccs0: SKIP (0.000s) [656.252144] Subtest most-busy-check-all: SKIP (0.009s) [656.289071] [130/133] (367s left) gem_mmap_gtt (coherency) [656.372454] Subtest coherency: SKIP (0.000s) [656.435704] [131/133] (367s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [656.544228] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip [657.335455] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.792s) [657.487037] [132/133] (366s left) i915_pm_rps (fence-order) [657.562739] Starting subtest: fence-order [660.617928] Subtest fence-order: SUCCESS (3.054s) [660.748481] [133/133] (362s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render) [660.872661] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render [667.605775] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.733s) [667.730555] Closing watchdogs results: parsing output: 0/ for test: gem_exec_fence results: parsing output: 1/ for test: kms_lease results: parsing output: 2/ for test: kms_flip results: parsing output: 3/ for test: kms_color results: parsing output: 4/ for test: gem_exec_capture results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: kms_frontbuffer_tracking results: parsing output: 7/ for test: kms_atomic_interruptible results: parsing output: 8/ for test: gen3_render_mixed_blits results: parsing output: 9/ for test: gem_ctx_exec results: parsing output: 10/ for test: perf results: parsing output: 11/ for test: kms_ccs results: parsing output: 12/ for test: kms_ccs results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: kms_ccs results: parsing output: 15/ for test: kms_vblank results: parsing output: 16/ for test: prime_self_import results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: api_intel_bb results: parsing output: 19/ for test: kms_pm_backlight results: parsing output: 20/ for test: gem_exec_whisper results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: prime_busy results: parsing output: 23/ for test: vgem_basic results: parsing output: 24/ for test: kms_flip results: parsing output: 25/ for test: gem_exec_suspend results: parsing output: 26/ for test: kms_big_fb results: parsing output: 27/ for test: gem_mmap_wc results: parsing output: 28/ for test: kms_cursor_crc results: parsing output: 29/ for test: syncobj_timeline results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: kms_psr results: parsing output: 32/ for test: kms_tv_load_detect results: parsing output: 33/ for test: kms_addfb_basic results: parsing output: 34/ for test: syncobj_timeline results: parsing output: 35/ for test: prime_self_import results: parsing output: 36/ for test: gem_close results: parsing output: 37/ for test: kms_psr2_sf results: parsing output: 38/ for test: gem_ctx_sseu results: parsing output: 39/ for test: kms_pm_rpm results: parsing output: 40/ for test: kms_psr results: parsing output: 41/ for test: gem_userptr_blits results: parsing output: 42/ for test: kms_joiner results: parsing output: 43/ for test: kms_plane results: parsing output: 44/ for test: kms_ccs results: parsing output: 45/ for test: gem_ctx_param results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: gem_partial_pwrite_pread results: parsing output: 48/ for test: gem_lmem_swapping results: parsing output: 49/ for test: kms_big_fb results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: perf results: parsing output: 52/ for test: kms_plane_cursor results: parsing output: 53/ for test: fbdev results: parsing output: 54/ for test: syncobj_wait results: parsing output: 55/ for test: gem_lmem_swapping results: parsing output: 56/ for test: sw_sync results: parsing output: 57/ for test: kms_flip_scaled_crc results: parsing output: 58/ for test: gem_exec_schedule results: parsing output: 59/ for test: kms_async_flips results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: prime_mmap results: parsing output: 62/ for test: kms_psr results: parsing output: 63/ for test: kms_psr results: parsing output: 64/ for test: i915_suspend results: parsing output: 65/ for test: gem_exec_await results: parsing output: 66/ for test: i915_hangman results: parsing output: 67/ for test: syncobj_timeline results: parsing output: 68/ for test: kms_selftest results: parsing output: 69/ for test: kms_flip_scaled_crc results: parsing output: 70/ for test: kms_flip results: parsing output: 71/ for test: kms_flip_scaled_crc results: parsing output: 72/ for test: syncobj_wait results: parsing output: 73/ for test: api_intel_allocator results: parsing output: 74/ for test: kms_big_fb results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: kms_setmode results: parsing output: 77/ for test: kms_cursor_crc results: parsing output: 78/ for test: gem_mmap_gtt results: parsing output: 79/ for test: gem_userptr_blits results: parsing output: 80/ for test: gem_create results: parsing output: 81/ for test: gem_exec_reloc results: parsing output: 82/ for test: syncobj_timeline results: parsing output: 83/ for test: kms_psr results: parsing output: 84/ for test: kms_chamelium_color results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: kms_flip results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: kms_plane_scaling results: parsing output: 89/ for test: kms_plane_scaling results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: gem_exec_params results: parsing output: 92/ for test: kms_cursor_edge_walk results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: perf_pmu results: parsing output: 95/ for test: kms_pipe_crc_basic results: parsing output: 96/ for test: gen9_exec_parse results: parsing output: 97/ for test: kms_getfb results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: kms_atomic results: parsing output: 100/ for test: kms_frontbuffer_tracking results: parsing output: 101/ for test: dumb_buffer results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: gem_render_copy results: parsing output: 104/ for test: gem_mmap_wc results: parsing output: 105/ for test: kms_psr2_sf results: parsing output: 106/ for test: gem_ctx_persistence results: parsing output: 107/ for test: gem_mmap_offset results: parsing output: 108/ for test: kms_big_fb results: parsing output: 109/ for test: kms_dirtyfb results: parsing output: 110/ for test: syncobj_wait results: parsing output: 111/ for test: gem_mmap results: parsing output: 112/ for test: gem_spin_batch results: parsing output: 113/ for test: kms_content_protection results: parsing output: 114/ for test: perf_pmu results: parsing output: 115/ for test: gem_exec_schedule results: parsing output: 116/ for test: gem_mmap_wc results: parsing output: 117/ for test: gem_pxp results: parsing output: 118/ for test: kms_psr results: parsing output: 119/ for test: kms_chamelium_edid results: parsing output: 120/ for test: syncobj_timeline results: parsing output: 121/ for test: kms_ccs results: parsing output: 122/ for test: gem_readwrite results: parsing output: 123/ for test: gem_exec_balancer results: parsing output: 124/ for test: kms_big_fb results: parsing output: 125/ for test: kms_dsc results: parsing output: 126/ for test: gem_exec_reloc results: parsing output: 127/ for test: kms_chamelium_hpd results: parsing output: 128/ for test: i915_drm_fdinfo results: parsing output: 129/ for test: gem_mmap_gtt results: parsing output: 130/ for test: kms_big_fb results: parsing output: 131/ for test: i915_pm_rps results: parsing output: 132/ for test: kms_frontbuffer_tracking Done.