[58.131943] Initializing watchdogs [58.131990] /dev/watchdog0 [58.147353] [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] [58.152146] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.154470] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.156410] [001/133] (960s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25) [58.266899] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25 [58.267727] Starting dynamic subtest: pipe-A [58.355586] Dynamic subtest pipe-A: SUCCESS (0.088s) [58.365641] Starting dynamic subtest: pipe-B [59.557370] Dynamic subtest pipe-B: SUCCESS (1.190s) [59.563250] Starting dynamic subtest: pipe-C [60.665745] Dynamic subtest pipe-C: SUCCESS (1.099s) [60.673259] Starting dynamic subtest: pipe-D [61.804270] Dynamic subtest pipe-D: SUCCESS (1.131s) [61.805802] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.510s) [62.975792] [002/133] (955s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [63.081364] Starting subtest: basic-flip-after-cursor-legacy [64.041949] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.955s) [64.918657] [003/133] (953s left) kms_pipe_crc_basic (hang-read-crc) [65.005164] Starting subtest: hang-read-crc [65.006165] Starting dynamic subtest: pipe-A-eDP-1 [67.105299] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.093s) [67.113641] Starting dynamic subtest: pipe-B-eDP-1 [69.881675] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.767s) [69.892635] Starting dynamic subtest: pipe-C-eDP-1 [72.603871] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.718s) [72.610551] Starting dynamic subtest: pipe-D-eDP-1 [75.295217] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.687s) [75.296119] Subtest hang-read-crc: SUCCESS (10.269s) [76.128183] [004/133] (942s left) kms_big_fb (yf-tiled-16bpp-rotate-270) [76.234783] Starting subtest: yf-tiled-16bpp-rotate-270 [76.236336] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s) [76.343487] [005/133] (942s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [76.436049] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [76.437918] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [76.522692] [006/133] (942s left) kms_legacy_colorkey (basic) [76.621239] Starting subtest: basic [76.622123] Starting dynamic subtest: pipe-A [76.666226] Dynamic subtest pipe-A: SUCCESS (0.045s) [76.675452] Starting dynamic subtest: pipe-B [76.676471] Dynamic subtest pipe-B: SUCCESS (0.001s) [76.682426] Starting dynamic subtest: pipe-C [76.683346] Dynamic subtest pipe-C: SUCCESS (0.000s) [76.689351] Starting dynamic subtest: pipe-D [76.690268] Dynamic subtest pipe-D: SUCCESS (0.000s) [76.691195] Subtest basic: SUCCESS (0.049s) [76.727960] [007/133] (942s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf) [76.808983] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf [76.810915] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [76.874413] [008/133] (942s left) kms_pm_dc (dc6-psr) [77.968908] Starting subtest: dc6-psr [80.855404] Subtest dc6-psr: SUCCESS (2.884s) [81.661024] [009/133] (937s left) gem_ctx_persistence (legacy-engines-hostile-preempt) [81.723417] Starting subtest: legacy-engines-hostile-preempt [81.724473] Starting dynamic subtest: render [81.805905] Dynamic subtest render: SUCCESS (0.081s) [81.815826] Starting dynamic subtest: bsd1 [82.911612] Dynamic subtest bsd1: SUCCESS (1.093s) [82.920633] Starting dynamic subtest: bsd2 [84.869792] Dynamic subtest bsd2: SUCCESS (1.955s) [84.878549] Starting dynamic subtest: blt [84.950483] Dynamic subtest blt: SUCCESS (0.089s) [84.958600] Starting dynamic subtest: vebox [86.918750] Dynamic subtest vebox: SUCCESS (1.955s) [86.919870] Subtest legacy-engines-hostile-preempt: SUCCESS (5.182s) [87.019621] [010/133] (931s left) kms_cursor_crc (cursor-onscreen-512x170) [87.311412] Starting subtest: cursor-onscreen-512x170 [87.313556] Subtest cursor-onscreen-512x170: SKIP (0.001s) [87.453284] [011/133] (931s left) gem_exec_params (dr4-dirt) [87.514818] Starting subtest: DR4-dirt [87.515974] Subtest DR4-dirt: SUCCESS (0.000s) [87.614113] [012/133] (931s left) core_auth (many-magics) [87.669412] Starting subtest: many-magics [88.650872] Subtest many-magics: SUCCESS (0.982s) [88.768835] [013/133] (930s left) gem_ctx_sseu (mmap-args) [88.830024] Subtest mmap-args: SKIP (0.000s) [88.879185] [014/133] (930s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa [88.921238] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled [89.025766] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.103s) [89.094575] [015/133] (930s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu) [89.194729] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu [93.228915] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (4.032s) [94.368086] [016/133] (924s left) kms_atomic_transition (modeset-transition-nonblocking) [94.462510] Starting subtest: modeset-transition-nonblocking [94.463417] Starting dynamic subtest: 1x-outputs [105.450660] Dynamic subtest 1x-outputs: SUCCESS (10.983s) [105.451885] Subtest modeset-transition-nonblocking: SUCCESS (10.984s) [106.297402] [017/133] (912s left) gem_ccs (block-copy-compressed) [106.362484] Starting subtest: block-copy-compressed [106.365341] Subtest block-copy-compressed: SKIP (0.000s) [106.457713] [018/133] (912s left) kms_plane (plane-position-hole-dpms) [106.534343] Starting subtest: plane-position-hole-dpms [107.038569] Starting dynamic subtest: pipe-A-plane-1 [109.431200] Dynamic subtest pipe-A-plane-1: SUCCESS (2.392s) [109.437944] Starting dynamic subtest: pipe-A-plane-2 [111.863719] Dynamic subtest pipe-A-plane-2: SUCCESS (2.432s) [111.870758] Starting dynamic subtest: pipe-A-plane-3 [114.221454] Dynamic subtest pipe-A-plane-3: SUCCESS (2.356s) [114.228409] Starting dynamic subtest: pipe-A-plane-4 [116.578548] Dynamic subtest pipe-A-plane-4: SUCCESS (2.356s) [116.585589] Starting dynamic subtest: pipe-A-plane-5 [116.607262] Dynamic subtest pipe-A-plane-5: SUCCESS (0.028s) [117.760278] Starting dynamic subtest: pipe-B-plane-1 [120.094341] Dynamic subtest pipe-B-plane-1: SUCCESS (2.343s) [120.100742] Starting dynamic subtest: pipe-B-plane-2 [122.487950] Dynamic subtest pipe-B-plane-2: SUCCESS (2.392s) [122.495197] Starting dynamic subtest: pipe-B-plane-3 [124.960164] Dynamic subtest pipe-B-plane-3: SUCCESS (2.471s) [124.966690] Starting dynamic subtest: pipe-B-plane-4 [127.419368] Dynamic subtest pipe-B-plane-4: SUCCESS (2.458s) [127.426333] Starting dynamic subtest: pipe-B-plane-5 [127.445597] Dynamic subtest pipe-B-plane-5: SUCCESS (0.026s) [127.446535] Subtest plane-position-hole-dpms: SUCCESS (20.908s) [128.288120] [019/133] (890s left) gem_reg_read (timestamp-monotonic) [128.348033] Starting subtest: timestamp-monotonic [132.854919] Subtest timestamp-monotonic: SUCCESS (4.497s) [132.922809] [020/133] (886s left) kms_cursor_crc (cursor-random-512x170) [133.203896] Starting subtest: cursor-random-512x170 [133.205960] Subtest cursor-random-512x170: SKIP (0.001s) [133.339309] [021/133] (885s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs) [133.416424] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs [133.417441] Starting dynamic subtest: pipe-A-eDP-1 [133.875281] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.447s) [133.883242] Starting dynamic subtest: pipe-B-eDP-1 [135.341548] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.467s) [135.348499] Starting dynamic subtest: pipe-C-eDP-1 [136.703796] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.361s) [136.710593] Starting dynamic subtest: pipe-D-eDP-1 [138.014936] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.308s) [138.015876] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.587s) [139.216592] [022/133] (880s left) kms_setmode (basic) [139.261460] Starting subtest: basic [139.592869] Starting dynamic subtest: pipe-A-eDP-1 [141.655756] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.052s) [141.990510] Starting dynamic subtest: pipe-B-eDP-1 [144.080620] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.087s) [144.382815] Subtest basic: SUCCESS (5.120s) [145.227192] [023/133] (874s left) kms_pm_rpm (universal-planes-dpms) [147.046329] Starting subtest: universal-planes-dpms [147.047580] Starting dynamic subtest: plane-35 [155.662812] Dynamic subtest plane-35: SUCCESS (8.618s) [155.672656] Starting dynamic subtest: plane-65 [164.288886] Dynamic subtest plane-65: SUCCESS (8.623s) [164.302070] Starting dynamic subtest: plane-95 [173.116864] Dynamic subtest plane-95: SUCCESS (8.817s) [173.125531] Starting dynamic subtest: plane-125 [181.731586] Dynamic subtest plane-125: SUCCESS (8.620s) [181.742090] Starting dynamic subtest: plane-135 [190.421084] Dynamic subtest plane-135: SUCCESS (8.686s) [190.430992] Starting dynamic subtest: plane-145 [199.048118] Dynamic subtest plane-145: SUCCESS (8.624s) [199.049793] Subtest universal-planes-dpms: SUCCESS (52.004s) [199.422245] [024/133] (819s left) gem_sync (basic-store-each) [199.479210] Starting subtest: basic-store-each [201.923552] Subtest basic-store-each: SUCCESS (2.445s) [202.114656] [025/133] (817s left) kms_psr (psr-cursor-blt) [202.219599] Starting subtest: psr-cursor-blt [202.220547] Starting dynamic subtest: eDP-1 [203.919350] Dynamic subtest eDP-1: SUCCESS (1.699s) [203.920210] Subtest psr-cursor-blt: SUCCESS (1.701s) [204.771877] [026/133] (814s left) perf (invalid-remove-userspace-config) [204.898327] Starting subtest: invalid-remove-userspace-config [204.905992] Subtest invalid-remove-userspace-config: SUCCESS (0.007s) [204.946141] [027/133] (814s left) gem_mmap_gtt (close-race) [205.001682] Subtest close-race: SKIP (0.000s) [205.055717] [028/133] (814s left) kms_color_pipeline (plane-ctm3x4-lut1d) [205.149516] Starting subtest: plane-ctm3x4-lut1d [205.309399] Starting dynamic subtest: pipe-A-plane-0 [205.507776] Dynamic subtest pipe-A-plane-0: SUCCESS (0.199s) [205.514808] Starting dynamic subtest: pipe-A-plane-1 [205.696543] Dynamic subtest pipe-A-plane-1: SUCCESS (0.188s) [205.703521] Starting dynamic subtest: pipe-A-plane-2 [205.885572] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s) [207.090073] Starting dynamic subtest: pipe-B-plane-0 [207.283309] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s) [207.290270] Starting dynamic subtest: pipe-B-plane-1 [207.472442] Dynamic subtest pipe-B-plane-1: SUCCESS (0.188s) [207.480622] Starting dynamic subtest: pipe-B-plane-2 [207.628162] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s) [208.805039] Starting dynamic subtest: pipe-C-plane-0 [208.965719] Dynamic subtest pipe-C-plane-0: SUCCESS (0.166s) [208.972285] Starting dynamic subtest: pipe-C-plane-1 [209.133014] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s) [209.140435] Starting dynamic subtest: pipe-C-plane-2 [209.277070] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s) [210.437905] Starting dynamic subtest: pipe-D-plane-0 [210.597986] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s) [210.604637] Starting dynamic subtest: pipe-D-plane-1 [210.775805] Dynamic subtest pipe-D-plane-1: SUCCESS (0.177s) [210.782449] Starting dynamic subtest: pipe-D-plane-2 [210.920097] Dynamic subtest pipe-D-plane-2: SUCCESS (0.143s) [211.207590] Subtest plane-ctm3x4-lut1d: SUCCESS (6.057s) [212.008012] [029/133] (807s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc) [212.117610] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc [212.119187] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [212.225281] [030/133] (807s left) sw_sync (sync_multi_timeline_wait) [212.258564] Starting subtest: sync_multi_timeline_wait [212.259665] Subtest sync_multi_timeline_wait: SUCCESS (0.000s) [212.313465] [031/133] (807s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc) [212.421578] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc [212.423593] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [212.524041] [032/133] (807s left) kms_invalid_mode (bad-htotal) [212.600611] Starting subtest: bad-htotal [212.601685] Starting dynamic subtest: pipe-A-eDP-1 [212.886506] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s) [212.893474] Starting dynamic subtest: pipe-B-eDP-1 [212.894401] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [212.900566] Starting dynamic subtest: pipe-C-eDP-1 [212.909366] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [212.917244] Starting dynamic subtest: pipe-D-eDP-1 [212.918067] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [212.918860] Subtest bad-htotal: SUCCESS (0.291s) [213.747186] [033/133] (805s left) gem_spin_batch (engines) [213.811240] Starting subtest: engines [213.812175] Starting dynamic subtest: rcs0 [217.058570] Dynamic subtest rcs0: SUCCESS (3.236s) [217.066733] Starting dynamic subtest: bcs0 [220.297485] Dynamic subtest bcs0: SUCCESS (3.236s) [220.306184] Starting dynamic subtest: vcs0 [223.573994] Dynamic subtest vcs0: SUCCESS (3.236s) [223.583288] Starting dynamic subtest: vcs1 [226.814275] Dynamic subtest vcs1: SUCCESS (3.237s) [226.823626] Starting dynamic subtest: vecs0 [230.046919] Dynamic subtest vecs0: SUCCESS (3.230s) [230.055998] Starting dynamic subtest: ccs0 [233.287820] Dynamic subtest ccs0: SUCCESS (3.238s) [233.289182] Subtest engines: SUCCESS (19.429s) [233.485250] [034/133] (786s left) gem_exec_reloc (basic-write-wc-active) [233.546862] Subtest basic-write-wc-active: SKIP (0.000s) [233.597026] [035/133] (786s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render) [233.678895] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render [240.961786] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.283s) [241.100990] [036/133] (778s left) gem_exec_fence (syncobj-timeline-unused-fence) [241.701593] Starting subtest: syncobj-timeline-unused-fence [241.702894] Subtest syncobj-timeline-unused-fence: SUCCESS (0.007s) [242.971820] [FACT gem_exec_fence (syncobj-timeline-unused-fence)] new: kernel.kmod_is_loaded.vgem: true [242.973606] [037/133] (776s left) gem_pxp (create-regular-context-1) [243.096770] Starting subtest: create-regular-context-1 [243.098230] Subtest create-regular-context-1: SUCCESS (0.002s) [243.196724] [038/133] (776s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc) [243.285113] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc [243.286918] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [243.397488] [039/133] (776s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions) [243.518876] Starting subtest: cursorA-vs-flipB-atomic-transitions [243.520600] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s) [243.655936] [040/133] (776s left) kms_flip (wf_vblank-ts-check-interruptible) [243.744159] Starting subtest: wf_vblank-ts-check-interruptible [243.746372] Starting dynamic subtest: A-eDP1 [252.652266] Dynamic subtest A-eDP1: SUCCESS (8.880s) [252.663390] Starting dynamic subtest: B-eDP1 [261.589605] Dynamic subtest B-eDP1: SUCCESS (8.934s) [261.599397] Starting dynamic subtest: C-eDP1 [270.525264] Dynamic subtest C-eDP1: SUCCESS (8.922s) [270.533223] Starting dynamic subtest: D-eDP1 [279.461844] Dynamic subtest D-eDP1: SUCCESS (8.933s) [279.463032] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.680s) [280.646140] [041/133] (739s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0) [280.737715] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0 [280.739574] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s) [280.815970] [042/133] (739s left) kms_chamelium_frames (dp-crc-single) [281.206918] Subtest dp-crc-single: SKIP (0.000s) [281.978925] [043/133] (737s left) kms_atomic_transition (plane-all-transition) [282.061277] Starting subtest: plane-all-transition [282.062144] Starting dynamic subtest: pipe-A-eDP-1 [284.558063] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.497s) [284.864171] Starting dynamic subtest: pipe-B-eDP-1 [288.059855] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.202s) [288.357112] Subtest plane-all-transition: SUCCESS (6.296s) [289.176461] [044/133] (730s left) kms_debugfs (display-off-read-all) [289.277477] Starting subtest: display-off-read-all [289.571411] Subtest display-off-read-all: SUCCESS (0.295s) [290.396573] [045/133] (729s left) gem_ctx_param (invalid-get-ringsize) [290.437529] Starting subtest: invalid-get-ringsize [290.438412] Subtest invalid-get-ringsize: SUCCESS (0.001s) [290.526949] [046/133] (729s left) sysfs_heartbeat_interval (invalid) [290.577103] Starting subtest: invalid [290.578089] Starting dynamic subtest: vecs0 [290.578974] Dynamic subtest vecs0: SUCCESS (0.000s) [290.586696] Starting dynamic subtest: ccs0 [290.587550] Dynamic subtest ccs0: SUCCESS (0.000s) [290.594328] Starting dynamic subtest: vcs0 [290.595197] Dynamic subtest vcs0: SUCCESS (0.000s) [290.601774] Starting dynamic subtest: bcs0 [290.602656] Dynamic subtest bcs0: SUCCESS (0.000s) [290.609451] Starting dynamic subtest: rcs0 [290.610366] Dynamic subtest rcs0: SUCCESS (0.000s) [290.616931] Starting dynamic subtest: vcs1 [290.617856] Dynamic subtest vcs1: SUCCESS (0.000s) [290.618764] Subtest invalid: SUCCESS (0.006s) [290.689407] [047/133] (729s left) gem_madvise (dontneed-before-exec) [290.730852] Starting subtest: dontneed-before-exec [290.746100] Subtest dontneed-before-exec: SKIP (0.016s) [290.798930] [048/133] (729s left) kms_atomic_interruptible (atomic-setmode) [290.890476] Starting subtest: atomic-setmode [290.891348] Starting dynamic subtest: pipe-A-eDP-1 [297.781411] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.890s) [297.782362] Subtest atomic-setmode: SUCCESS (6.892s) [298.665036] [049/133] (721s left) gem_render_copy (yf-tiled-to-vebox-y-tiled) [298.720607] Starting subtest: yf-tiled-to-vebox-y-tiled [298.722466] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s) [298.898146] [050/133] (721s left) prime_vgem (fence-read-hang) [298.967035] Subtest fence-read-hang: SKIP (0.000s) [299.064208] [051/133] (721s left) gem_exec_fence (syncobj-timeline-chain-engines) [299.595428] Starting subtest: syncobj-timeline-chain-engines [299.716531] Subtest syncobj-timeline-chain-engines: SUCCESS (0.121s) [300.983015] [052/133] (719s left) kms_flip (2x-flip-vs-absolute-wf_vblank) [301.069520] Starting subtest: 2x-flip-vs-absolute-wf_vblank [301.080948] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s) [301.161887] [053/133] (719s left) gem_userptr_blits (huge-split) [301.228567] Starting subtest: huge-split [301.236206] Subtest huge-split: SUCCESS (0.008s) [301.367860] [054/133] (718s left) gem_tiled_partial_pwrite_pread (reads) [301.429878] Subtest reads: SKIP (0.000s) [301.502806] [055/133] (718s left) gem_exec_create (madvise) [301.559677] Starting subtest: madvise [301.560586] Starting dynamic subtest: smem [322.971381] Dynamic subtest smem: SUCCESS (21.401s) [322.972578] Subtest madvise: SUCCESS (21.402s) [324.187633] [056/133] (696s left) prime_vgem (sync) [324.253464] Starting subtest: sync [324.254517] Starting dynamic subtest: rcs0 [324.304781] Dynamic subtest rcs0: SUCCESS (0.051s) [324.312762] Starting dynamic subtest: bcs0 [324.370137] Dynamic subtest bcs0: SUCCESS (0.064s) [324.377114] Starting dynamic subtest: vcs0 [324.422316] Dynamic subtest vcs0: SUCCESS (0.051s) [324.432775] Starting dynamic subtest: vcs1 [324.468644] Dynamic subtest vcs1: SUCCESS (0.042s) [324.475521] Starting dynamic subtest: vecs0 [324.515611] Dynamic subtest vecs0: SUCCESS (0.046s) [324.522398] Starting dynamic subtest: ccs0 [324.564898] Dynamic subtest ccs0: SUCCESS (0.048s) [324.566910] Subtest sync: SUCCESS (0.313s) [324.679560] [057/133] (695s left) kms_psr (fbc-pr-sprite-render) [324.770594] Starting subtest: fbc-pr-sprite-render [324.772511] Subtest fbc-pr-sprite-render: SKIP (0.000s) [324.837450] [058/133] (695s left) i915_drm_fdinfo (all-busy-check-all) [324.877361] Starting subtest: all-busy-check-all [324.881739] Subtest all-busy-check-all: SKIP (0.004s) [324.936393] [059/133] (695s left) i915_pm_rpm (debugfs-forcewake-user) [327.064561] Starting subtest: debugfs-forcewake-user [338.442041] Subtest debugfs-forcewake-user: SUCCESS (11.377s) [338.818954] [060/133] (681s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [338.934400] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu [338.936063] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [339.043211] [061/133] (681s left) gem_exec_fence (expired-history) [339.450253] Starting subtest: expired-history [346.594593] Subtest expired-history: SUCCESS (7.135s) [347.254643] [062/133] (673s left) kms_big_fb (4-tiled-16bpp-rotate-90) [347.355361] Starting subtest: 4-tiled-16bpp-rotate-90 [347.375580] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.020s) [347.484709] [063/133] (673s left) gem_ccs (large-ctrl-surf-copy) [347.539591] Starting subtest: large-ctrl-surf-copy [347.541891] Subtest large-ctrl-surf-copy: SKIP (0.000s) [347.639382] [064/133] (673s left) core_auth (getclient-master-drop) [347.665618] Starting subtest: getclient-master-drop [347.693190] Subtest getclient-master-drop: SUCCESS (0.026s) [347.799216] [065/133] (672s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc) [347.884427] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc [347.886062] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [347.969695] [066/133] (672s left) gem_pxp (reject-modify-context-protection-off-3) [348.065865] Starting subtest: reject-modify-context-protection-off-3 [348.066846] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s) [348.166833] [067/133] (672s left) gem_flink_basic (bad-open) [348.210343] Starting subtest: bad-open [348.211233] Subtest bad-open: SUCCESS (0.000s) [348.314572] [068/133] (672s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf) [348.407855] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf [348.409749] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [348.490527] [069/133] (672s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt) [348.589298] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt [348.590979] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [348.674920] [070/133] (672s left) kms_ccs (bad-aux-stride-y-tiled-ccs) [348.754294] Starting subtest: bad-aux-stride-y-tiled-ccs [348.755130] Starting dynamic subtest: pipe-A-eDP-1 [348.763665] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [348.770761] Starting dynamic subtest: pipe-B-eDP-1 [348.779277] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [348.788072] Starting dynamic subtest: pipe-C-eDP-1 [348.796204] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [348.802910] Starting dynamic subtest: pipe-D-eDP-1 [348.811527] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [348.813163] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.005s) [351.071514] [071/133] (669s left) gem_mmap_offset (oob-read) [351.118836] Starting subtest: oob-read [351.119794] Subtest oob-read: SUCCESS (0.000s) [351.223845] [072/133] (669s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw) [351.312029] Starting subtest: fbc-2p-pri-indfb-multidraw [351.313692] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s) [351.399347] [073/133] (669s left) kms_addfb_basic (basic-y-tiled-legacy) [351.450698] Starting subtest: basic-y-tiled-legacy [351.452578] Subtest basic-y-tiled-legacy: SKIP (0.000s) [351.565195] [074/133] (669s left) syncobj_timeline (etime-single-wait-submitted) [351.614200] Starting subtest: etime-single-wait-submitted [351.723354] Subtest etime-single-wait-submitted: SUCCESS (0.106s) [351.793428] [075/133] (669s left) gem_basic (bad-close) [351.834456] Starting subtest: bad-close [351.836102] Subtest bad-close: SUCCESS (0.000s) [351.948436] [076/133] (669s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [352.034098] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt [352.035619] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [352.123888] [077/133] (669s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [352.208269] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt [352.209929] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [352.306116] [078/133] (668s left) kms_big_fb (linear-16bpp-rotate-180) [352.402310] Starting subtest: linear-16bpp-rotate-180 [353.759258] Subtest linear-16bpp-rotate-180: SUCCESS (1.357s) [353.892264] [079/133] (667s left) perf_pmu (busy-double-start) [353.930557] Starting subtest: busy-double-start [353.931430] Starting dynamic subtest: rcs0 [357.534802] Dynamic subtest rcs0: FAIL (3.584s) [357.542788] Starting dynamic subtest: bcs0 [361.083967] Dynamic subtest bcs0: SUCCESS (3.567s) [361.094220] Starting dynamic subtest: vcs0 [365.412179] Dynamic subtest vcs0: SUCCESS (4.328s) [365.422789] Starting dynamic subtest: vcs1 [369.441241] Dynamic subtest vcs1: SUCCESS (4.027s) [369.454205] Starting dynamic subtest: vecs0 [373.425250] Dynamic subtest vecs0: SUCCESS (3.981s) [373.436579] Starting dynamic subtest: ccs0 [377.026218] Dynamic subtest ccs0: FAIL (3.568s) [377.027116] Subtest busy-double-start: FAIL (23.065s) [377.088146] [080/133] (644s left) gem_lmem_swapping (heavy-multi) [377.124443] Subtest heavy-multi: SKIP (0.000s) [377.159889] [081/133] (644s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite) [377.249621] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite [377.251288] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [377.352400] [082/133] (643s left) kms_vblank (wait-forked) [377.436120] Starting subtest: wait-forked [377.437037] Starting dynamic subtest: pipe-A-eDP-1 [379.243562] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.807s) [379.252685] Starting dynamic subtest: pipe-D-eDP-1 [381.772810] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.525s) [381.774030] Subtest wait-forked: SUCCESS (4.337s) [382.624285] [083/133] (638s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted) [382.661358] Starting subtest: multi-wait-all-for-submit-unsubmitted [382.770038] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.108s) [382.856840] [084/133] (638s left) gem_exec_reloc (basic-write-cpu) [382.920086] Subtest basic-write-cpu: SKIP (0.000s) [382.983203] [085/133] (638s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling) [383.074153] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling [383.074919] Starting dynamic subtest: pipe-A-default-mode [385.763756] Dynamic subtest pipe-A-default-mode: SUCCESS (2.688s) [385.764609] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.689s) [386.650787] [086/133] (634s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing) [386.736181] Starting subtest: plane-use-after-nonblocking-unbind-fencing [386.736956] Starting dynamic subtest: pipe-A-eDP-1 [386.800680] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.064s) [387.093873] Starting dynamic subtest: pipe-B-eDP-1 [387.940074] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.853s) [388.241249] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.505s) [389.103517] [087/133] (632s left) kms_cdclk (mode-transition-all-outputs) [389.186376] Starting subtest: mode-transition-all-outputs [389.480530] Subtest mode-transition-all-outputs: SKIP (0.293s) [390.332781] [088/133] (631s left) syncobj_wait (invalid-reset-zero-handles) [390.383501] Starting subtest: invalid-reset-zero-handles [390.384380] Subtest invalid-reset-zero-handles: SUCCESS (0.000s) [390.477542] [089/133] (631s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0) [390.577272] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0 [390.579203] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [390.671678] [090/133] (630s left) gen9_exec_parse (batch-without-end) [390.725931] Subtest batch-without-end: SKIP (0.000s) [390.790359] [091/133] (630s left) syncobj_timeline (invalid-transfer-bad-pad) [390.834561] Starting subtest: invalid-transfer-bad-pad [390.835973] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s) [390.919593] [092/133] (630s left) kms_hdmi_inject (inject-audio) [391.260035] Starting subtest: inject-audio [391.537240] Subtest inject-audio: SUCCESS (0.278s) [392.089763] [093/133] (629s left) gem_softpin (evict-snoop) [392.141956] Starting subtest: evict-snoop [392.143660] Subtest evict-snoop: SKIP (0.000s) [392.255653] [094/133] (629s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite) [392.338459] Starting subtest: fbc-rgb101010-draw-pwrite [397.783314] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.445s) [398.985091] [095/133] (622s left) gem_wait (invalid-buf) [399.049104] Starting subtest: invalid-buf [399.050023] Subtest invalid-buf: SUCCESS (0.000s) [399.252984] [096/133] (622s left) syncobj_timeline (multi-wait-for-submit-available-submitted) [399.311481] Starting subtest: multi-wait-for-submit-available-submitted [399.313049] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s) [399.395993] [097/133] (622s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c) [399.447255] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s) [399.500476] [098/133] (622s left) i915_suspend (sysfs-reader) [399.554782] Starting subtest: sysfs-reader [417.786504] Subtest sysfs-reader: SUCCESS (4.463s) [422.964157] [099/133] (604s left) kms_plane_lowres (tiling-yf) [423.060128] Starting subtest: tiling-yf [423.061938] Subtest tiling-yf: SKIP (0.000s) [423.125264] [100/133] (603s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs) [423.206562] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs [423.207613] Starting dynamic subtest: pipe-A-eDP-1 [425.544983] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.273s) [425.555006] Starting dynamic subtest: pipe-B-eDP-1 [427.958538] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.361s) [427.968647] Starting dynamic subtest: pipe-C-eDP-1 [430.065889] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.073s) [430.080644] Starting dynamic subtest: pipe-D-eDP-1 [432.206641] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.113s) [432.207611] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.826s) [433.395147] [101/133] (593s left) gem_exec_whisper (basic-fds-forked) [433.455255] Starting subtest: basic-fds-forked [458.001908] Subtest basic-fds-forked: SUCCESS (24.468s) [458.173148] [102/133] (568s left) kms_selftest (drm_format_helper) [458.203473] Starting subtest: drm_format_helper [458.285820] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8 [458.390144] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.103s) [458.399662] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332 [458.503556] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.113s) [458.513513] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565 [458.614746] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.111s) [458.625201] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555 [458.719352] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.102s) [458.727853] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555 [458.814297] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.093s) [458.823087] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551 [458.913511] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.098s) [458.922592] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888 [459.012975] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.099s) [459.022150] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888 [459.103642] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.090s) [459.112560] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888 [459.211109] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.106s) [459.220932] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010 [459.305364] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.092s) [459.317241] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010 [459.411130] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.105s) [459.421281] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono [459.510124] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.099s) [459.521864] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab [459.597396] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.086s) [459.608119] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888 [459.691233] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.092s) [459.699673] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888 [459.784182] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.092s) [459.792566] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset [459.884030] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.100s) [459.892584] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy [459.997345] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.114s) [459.999343] Subtest drm_format_helper: SUCCESS (1.794s) [460.140604] [103/133] (567s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode) [460.514067] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s) [461.360729] [104/133] (565s left) kms_plane (pixel-format-4-tiled-modifier) [461.449923] Starting subtest: pixel-format-4-tiled-modifier [461.480779] Starting dynamic subtest: pipe-A-plane-0 [462.147681] Dynamic subtest pipe-A-plane-0: SUCCESS (0.667s) [462.157640] Starting dynamic subtest: pipe-A-plane-3 [462.603818] Dynamic subtest pipe-A-plane-3: SUCCESS (0.453s) [462.615808] Starting dynamic subtest: pipe-A-plane-5 [462.617556] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [463.672890] Starting dynamic subtest: pipe-B-plane-0 [464.331017] Dynamic subtest pipe-B-plane-0: SUCCESS (0.666s) [464.340346] Starting dynamic subtest: pipe-B-plane-3 [464.742441] Dynamic subtest pipe-B-plane-3: SUCCESS (0.410s) [464.751596] Starting dynamic subtest: pipe-B-plane-5 [464.753346] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [465.051534] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.600s) [465.852221] [105/133] (561s left) gem_tiled_blits (basic) [465.921475] Subtest basic: SKIP (0.000s) [465.990632] [106/133] (561s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt) [466.078655] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt [470.573634] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.493s) [471.749578] [107/133] (555s left) kms_big_fb (x-tiled-addfb) [471.839433] Starting subtest: x-tiled-addfb [471.840387] Subtest x-tiled-addfb: SUCCESS (0.000s) [471.929900] [108/133] (555s left) gem_softpin (evict-active) [471.982824] Starting subtest: evict-active [471.990680] Subtest evict-active: SUCCESS (0.008s) [472.127275] [109/133] (555s left) perf_pmu (multi-client) [472.157277] Starting subtest: multi-client [472.158236] Starting dynamic subtest: rcs0 [473.210250] Dynamic subtest rcs0: SUCCESS (1.042s) [473.221451] Starting dynamic subtest: bcs0 [474.260832] Dynamic subtest bcs0: SUCCESS (1.048s) [474.271373] Starting dynamic subtest: vcs0 [475.313560] Dynamic subtest vcs0: SUCCESS (1.049s) [475.325060] Starting dynamic subtest: vcs1 [476.698804] Dynamic subtest vcs1: SUCCESS (1.382s) [476.710231] Starting dynamic subtest: vecs0 [478.683824] Dynamic subtest vecs0: SUCCESS (1.982s) [478.695158] Starting dynamic subtest: ccs0 [480.667681] Dynamic subtest ccs0: SUCCESS (1.980s) [480.668957] Subtest multi-client: SUCCESS (8.498s) [480.774219] [110/133] (546s left) gem_exec_balancer (hog) [480.829638] Starting subtest: hog [480.831569] Subtest hog: SKIP (0.000s) [481.129998] [111/133] (546s left) kms_content_protection (srm) [481.284656] Starting subtest: srm [481.286895] Subtest srm: SKIP (0.001s) [481.398788] [112/133] (546s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt) [481.484599] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt [481.486462] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [481.568599] [113/133] (545s left) kms_psr (psr-sprite-blt) [481.654378] Starting subtest: psr-sprite-blt [481.655337] Starting dynamic subtest: eDP-1 [483.395232] Dynamic subtest eDP-1: SUCCESS (1.739s) [483.396197] Subtest psr-sprite-blt: SUCCESS (1.740s) [484.219950] [114/133] (543s left) kms_feature_discovery (display-4x) [484.302104] Starting subtest: display-4x [484.303948] Subtest display-4x: SKIP (0.000s) [484.372649] [115/133] (543s left) kms_addfb_basic (unused-handle) [484.427606] Starting subtest: unused-handle [484.428606] Subtest unused-handle: SUCCESS (0.000s) [484.552178] [116/133] (543s left) kms_psr (fbc-pr-cursor-render) [484.648810] Starting subtest: fbc-pr-cursor-render [484.650355] Subtest fbc-pr-cursor-render: SKIP (0.000s) [484.725081] [117/133] (542s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff) [484.813647] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff [488.691657] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.876s) [489.820552] [118/133] (537s left) kms_cursor_crc (cursor-tearing-position-change) [489.924186] Starting subtest: cursor-tearing-position-change [489.925257] Starting dynamic subtest: pipe-A-eDP-1 [490.515482] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.589s) [490.524163] Starting dynamic subtest: pipe-D-eDP-1 [491.760805] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.243s) [491.761735] Subtest cursor-tearing-position-change: SUCCESS (1.836s) [492.591665] [119/133] (535s left) kms_psr (pr-basic) [492.678956] Starting subtest: pr-basic [492.680763] Subtest pr-basic: SKIP (0.000s) [492.747820] [120/133] (535s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs) [492.833073] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs [492.833968] Starting dynamic subtest: pipe-A-eDP-1 [492.837505] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [492.846232] Starting dynamic subtest: pipe-B-eDP-1 [492.849621] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [492.858047] Starting dynamic subtest: pipe-C-eDP-1 [492.861479] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [492.869962] Starting dynamic subtest: pipe-D-eDP-1 [492.873323] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [492.875188] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.004s) [495.143299] [121/133] (532s left) dumb_buffer (create-valid-dumb) [495.199446] Starting subtest: create-valid-dumb [495.200353] Subtest create-valid-dumb: SUCCESS (0.000s) [495.293996] [122/133] (532s left) i915_module_load (reload) [495.324360] Starting subtest: reload [501.422157] Subtest reload: SUCCESS (6.096s) [501.456083] [123/133] (526s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [502.633295] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt [502.634850] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [502.722682] [124/133] (525s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt) [502.808048] Starting subtest: psr-rgb565-draw-blt [509.963649] Subtest psr-rgb565-draw-blt: SUCCESS (7.153s) [510.085503] [125/133] (517s left) gem_flink_race (flink_close) [510.121426] Starting subtest: flink_close [515.221619] Subtest flink_close: SUCCESS (5.091s) [515.291693] [126/133] (512s left) kms_psr (fbc-psr-no-drrs) [515.378878] Starting subtest: fbc-psr-no-drrs [515.379830] Starting dynamic subtest: eDP-1 [515.381657] Dynamic subtest eDP-1: SKIP (0.000s) [515.383506] Subtest fbc-psr-no-drrs: SKIP (0.001s) [515.449433] [127/133] (512s left) syncobj_wait (multi-wait-all-submitted-signaled) [515.502807] Starting subtest: multi-wait-all-submitted-signaled [515.605771] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.102s) [515.682543] [128/133] (512s left) gem_exec_schedule (timeslicing) [515.757613] Starting subtest: timeslicing [515.758935] Starting dynamic subtest: rcs0 [515.780560] Dynamic subtest rcs0: SUCCESS (0.024s) [515.798379] Starting dynamic subtest: bcs0 [515.807390] Dynamic subtest bcs0: SUCCESS (0.025s) [515.818396] Starting dynamic subtest: vcs0 [515.829989] Dynamic subtest vcs0: SUCCESS (0.022s) [515.841568] Starting dynamic subtest: vcs1 [515.852935] Dynamic subtest vcs1: SUCCESS (0.021s) [515.865513] Starting dynamic subtest: vecs0 [515.876289] Dynamic subtest vecs0: SUCCESS (0.022s) [515.888712] Starting dynamic subtest: ccs0 [515.897425] Dynamic subtest ccs0: SUCCESS (0.020s) [515.898975] Subtest timeslicing: SUCCESS (0.142s) [517.629556] [129/133] (510s left) syncobj_wait (multi-wait-submitted) [517.673487] Starting subtest: multi-wait-submitted [517.793303] Subtest multi-wait-submitted: SUCCESS (0.108s) [517.853675] [130/133] (510s left) syncobj_timeline (wait-all-for-submit-snapshot) [517.897200] Starting subtest: wait-all-for-submit-snapshot [517.979343] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s) [518.049679] [131/133] (510s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling) [518.134793] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling [518.135633] Starting dynamic subtest: pipe-A-default-mode [520.808474] Dynamic subtest pipe-A-default-mode: SUCCESS (2.673s) [520.809374] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.675s) [521.681925] [132/133] (506s left) gem_exec_schedule (pi-userfault) [521.873992] Starting subtest: pi-userfault [521.875092] Starting dynamic subtest: rcs0 [521.876098] Dynamic subtest rcs0: SUCCESS (0.012s) [521.885963] Starting dynamic subtest: bcs0 [521.886842] Dynamic subtest bcs0: SUCCESS (0.008s) [521.894710] Starting dynamic subtest: vcs0 [521.895650] Dynamic subtest vcs0: SUCCESS (0.009s) [521.903618] Starting dynamic subtest: vcs1 [521.905995] Dynamic subtest vcs1: SUCCESS (0.010s) [521.915372] Starting dynamic subtest: vecs0 [521.916430] Dynamic subtest vecs0: SUCCESS (0.010s) [521.924589] Starting dynamic subtest: ccs0 [521.925625] Dynamic subtest ccs0: SUCCESS (0.008s) [521.926738] Subtest pi-userfault: SUCCESS (0.062s) [522.122619] [133/133] (506s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc) [522.210233] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc [529.253652] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.046s) [529.378652] Closing watchdogs results: parsing output: 0/ for test: kms_plane_scaling results: parsing output: 1/ for test: kms_cursor_legacy results: parsing output: 2/ for test: kms_pipe_crc_basic results: parsing output: 3/ for test: kms_big_fb results: parsing output: 4/ for test: kms_big_fb results: parsing output: 5/ for test: kms_legacy_colorkey results: parsing output: 6/ for test: kms_psr2_sf results: parsing output: 7/ for test: kms_pm_dc results: parsing output: 8/ for test: gem_ctx_persistence results: parsing output: 9/ for test: kms_cursor_crc results: parsing output: 10/ for test: gem_exec_params results: parsing output: 11/ for test: core_auth results: parsing output: 12/ for test: gem_ctx_sseu results: parsing output: 13/ for test: syncobj_timeline results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: kms_atomic_transition results: parsing output: 16/ for test: gem_ccs results: parsing output: 17/ for test: kms_plane results: parsing output: 18/ for test: gem_reg_read results: parsing output: 19/ for test: kms_cursor_crc results: parsing output: 20/ for test: kms_ccs results: parsing output: 21/ for test: kms_setmode results: parsing output: 22/ for test: kms_pm_rpm results: parsing output: 23/ for test: gem_sync results: parsing output: 24/ for test: kms_psr results: parsing output: 25/ for test: perf results: parsing output: 26/ for test: gem_mmap_gtt results: parsing output: 27/ for test: kms_color_pipeline results: parsing output: 28/ for test: kms_frontbuffer_tracking results: parsing output: 29/ for test: sw_sync results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: kms_invalid_mode results: parsing output: 32/ for test: gem_spin_batch results: parsing output: 33/ for test: gem_exec_reloc results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: gem_exec_fence results: parsing output: 36/ for test: gem_pxp results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: kms_cursor_legacy results: parsing output: 39/ for test: kms_flip results: parsing output: 40/ for test: kms_big_fb results: parsing output: 41/ for test: kms_chamelium_frames results: parsing output: 42/ for test: kms_atomic_transition results: parsing output: 43/ for test: kms_debugfs results: parsing output: 44/ for test: gem_ctx_param results: parsing output: 45/ for test: sysfs_heartbeat_interval results: parsing output: 46/ for test: gem_madvise results: parsing output: 47/ for test: kms_atomic_interruptible results: parsing output: 48/ for test: gem_render_copy results: parsing output: 49/ for test: prime_vgem results: parsing output: 50/ for test: gem_exec_fence results: parsing output: 51/ for test: kms_flip results: parsing output: 52/ for test: gem_userptr_blits results: parsing output: 53/ for test: gem_tiled_partial_pwrite_pread results: parsing output: 54/ for test: gem_exec_create results: parsing output: 55/ for test: prime_vgem results: parsing output: 56/ for test: kms_psr results: parsing output: 57/ for test: i915_drm_fdinfo results: parsing output: 58/ for test: i915_pm_rpm results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: gem_exec_fence results: parsing output: 61/ for test: kms_big_fb results: parsing output: 62/ for test: gem_ccs results: parsing output: 63/ for test: core_auth results: parsing output: 64/ for test: kms_frontbuffer_tracking results: parsing output: 65/ for test: gem_pxp results: parsing output: 66/ for test: gem_flink_basic results: parsing output: 67/ for test: kms_psr2_sf results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: kms_ccs results: parsing output: 70/ for test: gem_mmap_offset results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_addfb_basic results: parsing output: 73/ for test: syncobj_timeline results: parsing output: 74/ for test: gem_basic results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: kms_big_fb results: parsing output: 78/ for test: perf_pmu results: parsing output: 79/ for test: gem_lmem_swapping results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: kms_vblank results: parsing output: 82/ for test: syncobj_wait results: parsing output: 83/ for test: gem_exec_reloc results: parsing output: 84/ for test: kms_flip_scaled_crc results: parsing output: 85/ for test: kms_atomic_transition results: parsing output: 86/ for test: kms_cdclk results: parsing output: 87/ for test: syncobj_wait results: parsing output: 88/ for test: kms_big_fb results: parsing output: 89/ for test: gen9_exec_parse results: parsing output: 90/ for test: syncobj_timeline results: parsing output: 91/ for test: kms_hdmi_inject results: parsing output: 92/ for test: gem_softpin results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: gem_wait results: parsing output: 95/ for test: syncobj_timeline results: parsing output: 96/ for test: kms_pipe_b_c_ivb results: parsing output: 97/ for test: i915_suspend results: parsing output: 98/ for test: kms_plane_lowres results: parsing output: 99/ for test: kms_ccs results: parsing output: 100/ for test: gem_exec_whisper results: parsing output: 101/ for test: kms_selftest results: parsing output: 102/ for test: kms_chamelium_hpd results: parsing output: 103/ for test: kms_plane results: parsing output: 104/ for test: gem_tiled_blits results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: kms_big_fb results: parsing output: 107/ for test: gem_softpin results: parsing output: 108/ for test: perf_pmu results: parsing output: 109/ for test: gem_exec_balancer results: parsing output: 110/ for test: kms_content_protection results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: kms_psr results: parsing output: 113/ for test: kms_feature_discovery results: parsing output: 114/ for test: kms_addfb_basic results: parsing output: 115/ for test: kms_psr results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: kms_cursor_crc results: parsing output: 118/ for test: kms_psr results: parsing output: 119/ for test: kms_ccs results: parsing output: 120/ for test: dumb_buffer results: parsing output: 121/ for test: i915_module_load results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: gem_flink_race results: parsing output: 125/ for test: kms_psr results: parsing output: 126/ for test: syncobj_wait results: parsing output: 127/ for test: gem_exec_schedule results: parsing output: 128/ for test: syncobj_wait results: parsing output: 129/ for test: syncobj_timeline results: parsing output: 130/ for test: kms_flip_scaled_crc results: parsing output: 131/ for test: gem_exec_schedule results: parsing output: 132/ for test: kms_frontbuffer_tracking Done.