[58.238396] Initializing watchdogs [58.238443] /dev/watchdog0 [58.254495] [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.258924] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.261277] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.264684] [001/156] (960s left) kms_pm_rpm (pm-caching) [63.095691] Starting subtest: pm-caching [63.100609] Subtest pm-caching: SKIP (0.000s) [63.851126] [002/156] (954s left) perf (gen12-group-exclusive-stream-ctx-handle) [63.973536] Starting subtest: gen12-group-exclusive-stream-ctx-handle [63.998747] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.026s) [64.045498] [003/156] (954s left) gem_eio (wait-wedge-10ms) [65.386065] Starting subtest: wait-wedge-10ms [67.348071] Subtest wait-wedge-10ms: SUCCESS (1.970s) [67.483410] [004/156] (951s left) kms_chamelium_frames (hdmi-crc-fast) [67.871547] Subtest hdmi-crc-fast: SKIP (0.000s) [68.730849] [005/156] (950s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-pwrite) [68.843971] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-pwrite [68.848840] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s) [68.950903] [006/156] (950s left) i915_hangman (engine-engine-hang) [69.007106] Starting subtest: engine-engine-hang [69.009422] Starting dynamic subtest: rcs0 [70.270595] Dynamic subtest rcs0: SUCCESS (1.266s) [70.288702] Starting dynamic subtest: bcs0 [72.316619] Dynamic subtest bcs0: SUCCESS (2.048s) [72.328365] Starting dynamic subtest: vcs0 [74.300354] Dynamic subtest vcs0: SUCCESS (1.986s) [74.310676] Starting dynamic subtest: vcs1 [76.285595] Dynamic subtest vcs1: SUCCESS (1.986s) [76.296767] Starting dynamic subtest: vecs0 [78.268780] Dynamic subtest vecs0: SUCCESS (1.983s) [78.280408] Starting dynamic subtest: ccs0 [80.318457] Dynamic subtest ccs0: SUCCESS (2.050s) [80.321804] Subtest engine-engine-hang: SUCCESS (11.326s) [80.397660] [007/156] (938s left) gem_exec_whisper (basic-queues-priority-all) [80.453724] Starting subtest: basic-queues-priority-all [102.731086] Subtest basic-queues-priority-all: SUCCESS (22.276s) [102.925184] [008/156] (916s left) syncobj_wait (invalid-multi-wait-all-unsubmitted) [102.975657] Starting subtest: invalid-multi-wait-all-unsubmitted [102.978071] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s) [103.093186] [009/156] (915s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt) [103.191514] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt [103.195985] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [103.280325] [010/156] (915s left) gem_exec_fence (syncobj-timeline-invalid-wait) [103.851040] Starting subtest: syncobj-timeline-invalid-wait [103.853979] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s) [105.400730] [FACT gem_exec_fence (syncobj-timeline-invalid-wait)] new: kernel.kmod_is_loaded.vgem: true [105.404099] [011/156] (913s left) gem_exec_whisper (basic-contexts-forked) [105.487325] Starting subtest: basic-contexts-forked [128.668749] Subtest basic-contexts-forked: SUCCESS (23.180s) [128.850598] [012/156] (890s left) syncobj_wait (multi-wait-all-submitted) [128.901435] Starting subtest: multi-wait-all-submitted [129.011864] Subtest multi-wait-all-submitted: SUCCESS (0.108s) [129.086671] [013/156] (890s left) api_intel_bb (blit-noreloc-purge-cache) [129.139809] Starting subtest: blit-noreloc-purge-cache [129.152485] Subtest blit-noreloc-purge-cache: SUCCESS (0.015s) [129.244976] [014/156] (890s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs) [129.341360] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs [129.343258] Starting dynamic subtest: pipe-A-eDP-1 [146.164217] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.911s) [146.174482] Starting dynamic subtest: pipe-B-eDP-1 [164.167214] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.787s) [164.177389] Starting dynamic subtest: pipe-C-eDP-1 [182.124223] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.834s) [182.135785] Starting dynamic subtest: pipe-D-eDP-1 [200.103479] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.740s) [200.105337] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (10.275s) [207.293377] [015/156] (818s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-mmap-cpu) [207.413424] Starting subtest: psrhdr-rgb101010-draw-mmap-cpu [207.417976] Subtest psrhdr-rgb101010-draw-mmap-cpu: SKIP (0.000s) [207.510934] [016/156] (817s left) gem_exec_parallel (engines) [207.572679] Starting subtest: engines [207.575089] Starting dynamic subtest: basic [209.828367] Dynamic subtest basic: SUCCESS (2.286s) [209.839638] Starting dynamic subtest: contexts [214.124376] Dynamic subtest contexts: SUCCESS (4.347s) [214.136415] Starting dynamic subtest: fds [217.897468] Dynamic subtest fds: SUCCESS (3.800s) [217.909682] Starting dynamic subtest: userptr [219.811511] Dynamic subtest userptr: SUCCESS (1.922s) [219.814666] Subtest engines: SUCCESS (12.358s) [220.004798] [017/156] (805s left) kms_async_flips (basic-modeset-with-all-modifiers-formats) [220.102371] Starting subtest: basic-modeset-with-all-modifiers-formats [220.477216] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888 [221.242943] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.769s) [221.253876] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010 [221.262354] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.019s) [221.272441] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F [221.284805] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s) [221.299377] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565 [221.439502] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.155s) [221.453441] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888 [221.461919] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.022s) [221.471990] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010 [221.484784] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s) [221.497656] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F [221.506132] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.021s) [221.517903] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV [221.528038] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.022s) [221.537927] Starting dynamic subtest: pipe-A-eDP-1-4-Y210 [221.550380] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.022s) [221.566354] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888 [221.572417] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.022s) [221.582663] Starting dynamic subtest: pipe-A-eDP-1-4-XV30 [221.594587] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.022s) [221.604928] Starting dynamic subtest: pipe-A-eDP-1-4-XV36 [221.616375] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s) [221.626634] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565 [221.771710] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.155s) [221.783100] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888 [221.793817] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.022s) [221.804914] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010 [221.815991] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.022s) [221.826029] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F [221.837866] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s) [221.847853] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV [221.860187] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s) [221.870071] Starting dynamic subtest: pipe-A-eDP-1-x-Y210 [221.882529] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.022s) [221.892667] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888 [221.904984] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s) [221.918476] Starting dynamic subtest: pipe-A-eDP-1-x-XV30 [221.926894] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s) [221.937270] Starting dynamic subtest: pipe-A-eDP-1-x-XV36 [221.948834] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s) [221.959650] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565 [222.104235] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.156s) [222.114789] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888 [222.126262] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.022s) [222.136237] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010 [222.147931] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s) [222.159394] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F [222.170327] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s) [222.180503] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV [222.192443] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s) [222.202585] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210 [222.214537] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s) [222.224662] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888 [222.236821] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s) [222.247491] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30 [222.259035] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s) [222.270067] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36 [222.280832] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s) [222.658235] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.567s) [223.507837] [018/156] (801s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf) [223.622706] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf [223.626795] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [223.699522] [019/156] (801s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite) [223.796793] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite [223.801187] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [223.879532] [020/156] (801s left) gem_ctx_param (vm) [223.935486] Starting subtest: vm [223.983981] Subtest vm: SUCCESS (0.048s) [224.103493] [021/156] (801s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size) [224.220221] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size [224.225299] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s) [224.377516] [022/156] (801s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic) [224.500706] Starting subtest: 2x-long-cursor-vs-flip-atomic [224.504563] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s) [224.662916] [023/156] (801s left) gem_exec_reloc (basic-cpu-gtt-active) [224.711124] Subtest basic-cpu-gtt-active: SKIP (0.000s) [224.772386] [024/156] (800s left) prime_self_import (basic-llseek-size) [224.802838] Starting subtest: basic-llseek-size [224.828094] Subtest basic-llseek-size: SUCCESS (0.025s) [224.930371] [025/156] (800s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu) [225.025260] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu [225.028973] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [225.111952] [026/156] (800s left) kms_joiner (basic-force-ultra-joiner) [225.212373] Starting subtest: basic-force-ultra-joiner [225.215896] Subtest basic-force-ultra-joiner: SKIP (0.000s) [225.280165] [027/156] (800s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt) [225.381955] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt [225.385318] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [225.513213] [028/156] (800s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [225.607307] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-mmap-gtt [225.610853] Subtest hdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [225.700809] [029/156] (800s left) kms_psr (fbc-pr-cursor-mmap-cpu) [225.791226] Starting subtest: fbc-pr-cursor-mmap-cpu [225.794631] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s) [225.862444] [030/156] (800s left) kms_vblank (query-busy) [225.967974] Starting subtest: query-busy [225.969621] Starting dynamic subtest: pipe-A-eDP-1 [227.852753] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.888s) [227.869379] Starting dynamic subtest: pipe-D-eDP-1 [230.467596] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.618s) [230.470107] Subtest query-busy: SUCCESS (4.508s) [231.278435] [031/156] (794s left) kms_flip (basic-flip-vs-wf_vblank) [231.376964] Starting subtest: basic-flip-vs-wf_vblank [231.379290] Starting dynamic subtest: A-eDP1 [233.322910] Dynamic subtest A-eDP1: SUCCESS (1.948s) [233.335704] Starting dynamic subtest: B-eDP1 [235.253409] Dynamic subtest B-eDP1: SUCCESS (1.931s) [235.264794] Starting dynamic subtest: C-eDP1 [237.160189] Dynamic subtest C-eDP1: SUCCESS (1.906s) [237.172842] Starting dynamic subtest: D-eDP1 [239.087522] Dynamic subtest D-eDP1: SUCCESS (1.926s) [239.089879] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.721s) [240.329727] [032/156] (785s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [240.431537] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [241.055454] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.626s) [241.241253] [033/156] (784s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [241.340429] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [241.344796] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [241.429983] [034/156] (784s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [241.527995] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-mmap-gtt [241.532494] Subtest hdr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [241.630312] [035/156] (784s left) syncobj_wait (signal) [241.687674] Starting subtest: signal [241.690023] Subtest signal: SUCCESS (0.000s) [241.798081] [036/156] (784s left) kms_cursor_edge_walk (128x128-left-edge) [241.891866] Starting subtest: 128x128-left-edge [241.894148] Starting dynamic subtest: pipe-A-eDP-1 [245.392831] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.498s) [245.407351] Starting dynamic subtest: pipe-D-eDP-1 [248.612221] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.220s) [248.614526] Subtest 128x128-left-edge: SUCCESS (6.720s) [249.425193] [037/156] (776s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff) [249.527958] Starting subtest: psr-1p-primscrn-cur-indfb-onoff [256.536901] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.016s) [256.661562] [038/156] (769s left) perf (non-system-wide-paranoid) [256.765206] Starting subtest: non-system-wide-paranoid [256.790448] Subtest non-system-wide-paranoid: SUCCESS (0.025s) [256.840088] [039/156] (769s left) kms_hdmi_inject (inject-4k) [257.170352] Starting subtest: inject-4k [257.521623] Subtest inject-4k: SUCCESS (0.352s) [258.028903] [040/156] (768s left) perf_pmu (render-node-busy) [258.119221] Starting subtest: render-node-busy [258.121337] Starting dynamic subtest: rcs0 [258.699032] Dynamic subtest rcs0: SUCCESS (0.582s) [258.712552] Starting dynamic subtest: bcs0 [259.264013] Dynamic subtest bcs0: SUCCESS (0.563s) [259.276949] Starting dynamic subtest: vcs0 [260.835829] Dynamic subtest vcs0: SUCCESS (1.569s) [260.849246] Starting dynamic subtest: vcs1 [262.819224] Dynamic subtest vcs1: SUCCESS (1.982s) [262.832508] Starting dynamic subtest: vecs0 [264.803213] Dynamic subtest vecs0: SUCCESS (1.982s) [264.816168] Starting dynamic subtest: ccs0 [265.365065] Dynamic subtest ccs0: SUCCESS (0.561s) [265.367692] Subtest render-node-busy: SUCCESS (7.251s) [265.442886] [041/156] (761s left) gem_mmap_gtt (cpuset-medium-copy) [265.499090] Subtest cpuset-medium-copy: SKIP (0.000s) [265.560390] [042/156] (760s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [265.667979] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [265.672304] Subtest hdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [265.768447] [043/156] (760s left) gem_pxp (verify-pxp-execution-after-suspend-resume) [265.886416] Starting subtest: verify-pxp-execution-after-suspend-resume [272.911598] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.028s) [279.059629] [044/156] (753s left) gem_create (create-ext-placement-all) [279.235542] Starting subtest: create-ext-placement-all [279.238335] Subtest create-ext-placement-all: SUCCESS (0.000s) [279.360535] [045/156] (753s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode) [279.759338] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s) [280.556580] [046/156] (752s left) gem_userptr_blits (process-exit-busy) [280.628281] Starting subtest: process-exit-busy [280.641493] Subtest process-exit-busy: SUCCESS (0.018s) [280.786716] [047/156] (751s left) gem_busy (extended) [280.979467] Starting subtest: extended [280.982081] Starting dynamic subtest: rcs0 [281.069281] Dynamic subtest rcs0: SUCCESS (0.090s) [281.085341] Starting dynamic subtest: bcs0 [281.111301] Dynamic subtest bcs0: SUCCESS (0.040s) [281.122780] Starting dynamic subtest: vcs0 [282.788004] Dynamic subtest vcs0: SUCCESS (1.674s) [282.800204] Starting dynamic subtest: vcs1 [284.836706] Dynamic subtest vcs1: SUCCESS (2.045s) [284.850552] Starting dynamic subtest: vecs0 [286.820288] Dynamic subtest vecs0: SUCCESS (1.981s) [286.833042] Starting dynamic subtest: ccs0 [286.865792] Dynamic subtest ccs0: SUCCESS (0.046s) [286.868278] Subtest extended: SUCCESS (5.888s) [287.106373] [048/156] (745s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format) [287.197438] Starting subtest: plane-upscale-20x20-with-pixel-format [287.199671] Starting dynamic subtest: pipe-A [288.244696] Dynamic subtest pipe-A: SUCCESS (1.050s) [288.255896] Starting dynamic subtest: pipe-B [290.350152] Dynamic subtest pipe-B: SUCCESS (2.105s) [290.359994] Starting dynamic subtest: pipe-C [291.505009] Dynamic subtest pipe-C: SUCCESS (1.154s) [291.517502] Starting dynamic subtest: pipe-D [292.696898] Dynamic subtest pipe-D: SUCCESS (1.191s) [292.699260] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.503s) [293.865495] [049/156] (738s left) i915_selftest (mock) [298.569392] Starting subtest: mock [298.571964] Starting dynamic subtest: sanitycheck [299.256001] Dynamic subtest sanitycheck: SUCCESS (0.687s) [299.266892] Starting dynamic subtest: shmem [299.929259] Dynamic subtest shmem: SUCCESS (0.671s) [299.940079] Starting dynamic subtest: fence [307.965014] Dynamic subtest fence: SUCCESS (8.035s) [307.976100] Starting dynamic subtest: scatterlist [309.662044] Dynamic subtest scatterlist: SUCCESS (1.695s) [309.672559] Starting dynamic subtest: syncmap [312.846481] Dynamic subtest syncmap: SUCCESS (3.184s) [312.857364] Starting dynamic subtest: uncore [313.523514] Dynamic subtest uncore: SUCCESS (0.676s) [313.534434] Starting dynamic subtest: ring [314.199790] Dynamic subtest ring: SUCCESS (0.674s) [314.210631] Starting dynamic subtest: engine [314.865007] Dynamic subtest engine: SUCCESS (0.663s) [314.878144] Starting dynamic subtest: timelines [318.726774] Dynamic subtest timelines: SUCCESS (3.860s) [318.737021] Starting dynamic subtest: requests [322.442571] Dynamic subtest requests: SUCCESS (3.716s) [322.452965] Starting dynamic subtest: objects [323.247116] Dynamic subtest objects: SUCCESS (0.804s) [323.257497] Starting dynamic subtest: phys [324.027662] Dynamic subtest phys: SUCCESS (0.779s) [324.038009] Starting dynamic subtest: dmabuf [324.785558] Dynamic subtest dmabuf: SUCCESS (0.757s) [324.796033] Starting dynamic subtest: vma [330.538578] Dynamic subtest vma: SUCCESS (5.753s) [330.549633] Starting dynamic subtest: evict [331.972156] Dynamic subtest evict: SUCCESS (1.433s) [331.984343] Starting dynamic subtest: gtt [335.349156] Dynamic subtest gtt: SUCCESS (3.376s) [335.359453] Starting dynamic subtest: hugepages [336.249320] Dynamic subtest hugepages: SUCCESS (0.898s) [336.259813] Starting dynamic subtest: memory_region [338.798198] Dynamic subtest memory_region: SUCCESS (2.548s) [338.800693] Subtest mock: SUCCESS (40.239s) [338.828891] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [338.829567] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true [338.832866] [050/156] (694s left) prime_vgem (sync) [340.403169] Starting subtest: sync [340.405466] Starting dynamic subtest: rcs0 [340.461369] Dynamic subtest rcs0: SUCCESS (0.057s) [340.472668] Starting dynamic subtest: bcs0 [340.524862] Dynamic subtest bcs0: SUCCESS (0.063s) [340.534504] Starting dynamic subtest: vcs0 [340.574049] Dynamic subtest vcs0: SUCCESS (0.049s) [340.583380] Starting dynamic subtest: vcs1 [340.620202] Dynamic subtest vcs1: SUCCESS (0.045s) [340.629813] Starting dynamic subtest: vecs0 [340.665934] Dynamic subtest vecs0: SUCCESS (0.045s) [340.675678] Starting dynamic subtest: ccs0 [340.711753] Dynamic subtest ccs0: SUCCESS (0.045s) [340.714099] Subtest sync: SUCCESS (0.310s) [340.807480] [FACT prime_vgem (sync)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [340.808667] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.i915: true [340.813022] [051/156] (692s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions) [340.933041] Starting subtest: short-flip-after-cursor-atomic-transitions [341.923231] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.988s) [342.760368] [052/156] (690s left) kms_frontbuffer_tracking (fbc-2p-rte) [342.861835] Starting subtest: fbc-2p-rte [342.866291] Subtest fbc-2p-rte: SKIP (0.000s) [342.960235] [053/156] (690s left) kms_vrr (flip-basic-fastset) [343.047677] Starting subtest: flip-basic-fastset [343.053743] Subtest flip-basic-fastset: SKIP (0.000s) [343.119957] [054/156] (689s left) gem_ctx_param (basic) [343.177270] Starting subtest: basic [343.179727] Subtest basic: SUCCESS (0.002s) [343.275351] [055/156] (689s left) sw_sync (sync_multi_consumer_producer) [343.310720] Starting subtest: sync_multi_consumer_producer [343.608538] Subtest sync_multi_consumer_producer: SUCCESS (0.300s) [343.672120] [056/156] (689s left) vgem_basic (debugfs) [343.713056] Starting subtest: debugfs [343.715312] Subtest debugfs: SUCCESS (0.001s) [343.772894] [057/156] (689s left) kms_content_protection (dp-mst-lic-type-0-hdcp14) [343.899227] Starting subtest: dp-mst-lic-type-0-hdcp14 [343.903789] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s) [344.032225] [058/156] (689s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite) [344.134277] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite [344.138212] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [344.249059] [059/156] (688s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-mmap-wc) [344.355705] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-mmap-wc [344.360158] Subtest fbchdr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [344.454957] [060/156] (688s left) kms_properties (colorop-properties-atomic) [344.545583] Starting subtest: colorop-properties-atomic [344.547411] Starting dynamic subtest: pipe-A-eDP-1 [344.916134] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.371s) [344.927314] Starting dynamic subtest: pipe-B-eDP-1 [346.038088] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.120s) [346.047583] Starting dynamic subtest: pipe-C-eDP-1 [347.067365] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.029s) [347.078443] Starting dynamic subtest: pipe-D-eDP-1 [348.130389] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.063s) [348.132676] Subtest colorop-properties-atomic: SUCCESS (3.588s) [349.021297] [061/156] (684s left) kms_pm_rpm (dpms-non-lpsp) [350.948639] Starting subtest: dpms-non-lpsp [350.953250] Subtest dpms-non-lpsp: SKIP (0.001s) [351.332563] [062/156] (682s left) kms_cdclk (mode-transition-all-outputs) [351.428256] Starting subtest: mode-transition-all-outputs [351.719295] Subtest mode-transition-all-outputs: SKIP (0.285s) [352.558848] [063/156] (680s left) kms_ccs (crc-primary-basic-y-tiled-ccs) [352.663711] Starting subtest: crc-primary-basic-y-tiled-ccs [352.666019] Starting dynamic subtest: pipe-A-eDP-1 [352.689731] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [352.702212] Starting dynamic subtest: pipe-B-eDP-1 [352.724358] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [352.735523] Starting dynamic subtest: pipe-C-eDP-1 [352.757239] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [352.766564] Starting dynamic subtest: pipe-D-eDP-1 [352.788675] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [352.792983] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s) [354.923203] [064/156] (678s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-render) [355.016880] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-render [355.020899] Subtest hdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s) [355.117934] [065/156] (678s left) gem_caching (reads) [355.173350] Subtest reads: SKIP (0.000s) [355.240867] [066/156] (678s left) sysfs_preempt_timeout (timeout) [355.298377] Starting subtest: timeout [355.300285] Starting dynamic subtest: vecs0 [364.828082] Dynamic subtest vecs0: SUCCESS (9.532s) [364.839547] Starting dynamic subtest: ccs0 [365.983804] Dynamic subtest ccs0: SUCCESS (1.154s) [365.998176] Starting dynamic subtest: vcs0 [375.845179] Dynamic subtest vcs0: SUCCESS (9.861s) [375.859053] Starting dynamic subtest: bcs0 [377.063099] Dynamic subtest bcs0: SUCCESS (1.217s) [377.075229] Starting dynamic subtest: rcs0 [378.323982] Dynamic subtest rcs0: SUCCESS (1.261s) [378.337269] Starting dynamic subtest: vcs1 [387.804109] Dynamic subtest vcs1: SUCCESS (9.480s) [387.806851] Subtest timeout: SUCCESS (32.517s) [387.881117] [067/156] (645s left) kms_cursor_legacy (cursor-vs-flip-legacy) [388.012076] Starting subtest: cursor-vs-flip-legacy [417.782605] Subtest cursor-vs-flip-legacy: SUCCESS (29.781s) [418.624869] [068/156] (614s left) kms_rotation_crc (primary-rotation-90) [418.722378] Starting subtest: primary-rotation-90 [418.726364] Subtest primary-rotation-90: SKIP (0.001s) [418.795454] [069/156] (614s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size) [418.918135] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size [450.825225] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.917s) [451.637155] [070/156] (582s left) kms_atomic (plane-invalid-params-fence) [451.744502] Starting subtest: plane-invalid-params-fence [451.746889] Starting dynamic subtest: pipe-A-eDP-1 [452.102672] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.355s) [452.104666] Subtest plane-invalid-params-fence: SUCCESS (0.357s) [452.967903] [071/156] (580s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu) [453.074292] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu [457.803159] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (4.735s) [457.917198] [072/156] (575s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc) [458.010470] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc [458.012732] Starting dynamic subtest: pipe-A-eDP-1 [458.036717] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [458.049012] Starting dynamic subtest: pipe-B-eDP-1 [458.070770] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [458.080897] Starting dynamic subtest: pipe-C-eDP-1 [458.103661] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [458.113458] Starting dynamic subtest: pipe-D-eDP-1 [458.136777] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [458.141368] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s) [460.257874] [073/156] (573s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-pwrite) [460.352281] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-pwrite [460.356674] Subtest hdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [460.455934] [074/156] (573s left) kms_frontbuffer_tracking (hdr-1p-rte) [460.548884] Starting subtest: hdr-1p-rte [460.552704] Subtest hdr-1p-rte: SKIP (0.000s) [460.642907] [075/156] (573s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-pgflip-blt) [460.745737] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-pgflip-blt [460.749860] Subtest fbcpsrhdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [460.840462] [076/156] (573s left) kms_cursor_crc (cursor-random-32x10) [461.009273] Starting subtest: cursor-random-32x10 [461.059646] Subtest cursor-random-32x10: SKIP (0.045s) [461.338199] [077/156] (572s left) kms_frontbuffer_tracking (psr-rgb565-draw-render) [461.440015] Starting subtest: psr-rgb565-draw-render [468.548281] Subtest psr-rgb565-draw-render: SUCCESS (7.114s) [468.672823] [078/156] (565s left) gem_exec_schedule (noreorder-priority) [468.852808] Starting subtest: noreorder-priority [468.855408] Starting dynamic subtest: rcs0 [469.995936] Dynamic subtest rcs0: SUCCESS (1.145s) [470.012928] Starting dynamic subtest: vcs0 [471.840468] Dynamic subtest vcs0: SUCCESS (1.842s) [471.853450] Starting dynamic subtest: vcs1 [473.821078] Dynamic subtest vcs1: SUCCESS (1.979s) [473.833011] Starting dynamic subtest: vecs0 [475.787010] Dynamic subtest vecs0: SUCCESS (1.964s) [475.800411] Starting dynamic subtest: ccs0 [476.933455] Dynamic subtest ccs0: SUCCESS (1.146s) [476.935942] Subtest noreorder-priority: SUCCESS (8.086s) [477.123113] [079/156] (556s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt) [477.225401] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt [483.972930] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.756s) [484.113594] [080/156] (550s left) kms_psr (fbc-psr2-primary-render) [484.201562] Starting subtest: fbc-psr2-primary-render [484.203880] Starting dynamic subtest: eDP-1 [484.208234] Dynamic subtest eDP-1: SKIP (0.000s) [484.212659] Subtest fbc-psr2-primary-render: SKIP (0.001s) [484.276450] [081/156] (549s left) gem_ctx_shared (single-timeline) [484.338896] Starting subtest: single-timeline [484.358979] Subtest single-timeline: SUCCESS (0.013s) [484.572892] [082/156] (549s left) gem_spin_batch (spin-all) [484.639687] Starting subtest: spin-all [484.656104] Subtest spin-all: SUCCESS (0.013s) [485.838098] [083/156] (548s left) prime_mmap (test_reprime) [485.890690] Starting subtest: test_reprime [485.892552] Starting dynamic subtest: test_reprime-smem [485.924663] Dynamic subtest test_reprime-smem: SUCCESS (0.036s) [485.927160] Subtest test_reprime: SUCCESS (0.037s) [486.033128] [084/156] (548s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-shrfb-pgflip-blt) [486.138201] Starting subtest: psrhdr-1p-primscrn-shrfb-pgflip-blt [486.142673] Subtest psrhdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [486.230672] [085/156] (548s left) i915_pm_rc6_residency (rc6-fence) [486.277210] Starting subtest: rc6-fence [486.314737] Starting dynamic subtest: gt0 [498.635574] Dynamic subtest gt0: SUCCESS (12.325s) [498.651325] Starting dynamic subtest: gt1 [512.801300] Dynamic subtest gt1: SUCCESS (14.169s) [512.803999] Subtest rc6-fence: SUCCESS (26.537s) [512.881567] [086/156] (521s left) gem_pxp (create-regular-context-2) [513.004336] Starting subtest: create-regular-context-2 [513.006675] Subtest create-regular-context-2: SUCCESS (0.002s) [513.121843] [087/156] (521s left) gem_eio (wait-1us) [513.348325] Starting subtest: wait-1us [513.670900] Subtest wait-1us: SUCCESS (0.323s) [513.800909] [088/156] (520s left) gen9_exec_parse (bb-oversize) [513.865401] Subtest bb-oversize: SKIP (0.000s) [513.940325] [089/156] (520s left) kms_frontbuffer_tracking (fbchdr-modesetfrombusy) [514.039902] Starting subtest: fbchdr-modesetfrombusy [514.043420] Subtest fbchdr-modesetfrombusy: SKIP (0.000s) [514.143994] [090/156] (520s left) kms_cursor_crc (cursor-onscreen-256x256) [514.377672] Starting subtest: cursor-onscreen-256x256 [514.381825] Starting dynamic subtest: pipe-A-eDP-1 [516.479159] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.099s) [516.511858] Starting dynamic subtest: pipe-D-eDP-1 [519.279827] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.780s) [519.282475] Subtest cursor-onscreen-256x256: SUCCESS (4.904s) [520.155273] [091/156] (514s left) gem_exec_params (cliprects_ptr-dirt) [520.217461] Starting subtest: cliprects_ptr-dirt [520.219779] Subtest cliprects_ptr-dirt: SUCCESS (0.000s) [520.316650] [092/156] (514s left) gem_exec_suspend (basic) [520.381133] Starting subtest: basic [520.383466] Starting dynamic subtest: smem [521.827872] Dynamic subtest smem: SUCCESS (1.445s) [521.830651] Subtest basic: SUCCESS (1.447s) [522.030142] [093/156] (512s left) syncobj_timeline (wait-all-snapshot) [522.076152] Starting subtest: wait-all-snapshot [522.158401] Subtest wait-all-snapshot: SUCCESS (0.083s) [522.238727] [094/156] (512s left) kms_psr (fbc-psr-cursor-plane-move) [522.322749] Starting subtest: fbc-psr-cursor-plane-move [522.325018] Starting dynamic subtest: eDP-1 [522.329365] Dynamic subtest eDP-1: SKIP (0.000s) [522.333806] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s) [522.412507] [095/156] (512s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs) [522.478635] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs [522.483273] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s) [522.679348] [096/156] (512s left) gem_exec_balancer (bonded-sync) [522.751779] Starting subtest: bonded-sync [522.755963] Subtest bonded-sync: SKIP (0.000s) [523.054463] [097/156] (511s left) gen3_render_mixed_blits [523.160203] [098/156] (511s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted) [523.210231] Starting subtest: etime-single-wait-for-submit-available-unsubmitted [523.309911] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.101s) [523.387348] [099/156] (511s left) vgem_basic (dmabuf-export) [523.429011] Starting subtest: dmabuf-export [523.453170] Subtest dmabuf-export: SUCCESS (0.027s) [523.565033] [100/156] (511s left) kms_dsc (dsc-basic) [523.659557] Starting subtest: dsc-basic [523.672875] Subtest dsc-basic: SKIP (0.000s) [523.732969] [101/156] (511s left) kms_big_fb (y-tiled-addfb-size-offset-overflow) [523.834416] Starting subtest: y-tiled-addfb-size-offset-overflow [523.838755] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s) [523.938071] [102/156] (511s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite) [524.039785] Starting subtest: psr-rgb101010-draw-pwrite [531.920810] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.888s) [532.022502] [103/156] (503s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-indfb-msflip-blt) [532.116260] Starting subtest: fbcpsrhdr-2p-primscrn-indfb-msflip-blt [532.120511] Subtest fbcpsrhdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [532.210851] [104/156] (502s left) kms_big_fb (4-tiled-addfb) [532.317585] Starting subtest: 4-tiled-addfb [532.319882] Subtest 4-tiled-addfb: SUCCESS (0.000s) [532.434690] [105/156] (502s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-pwrite) [532.535721] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-pwrite [532.539987] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [532.637947] [106/156] (502s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen) [532.735921] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen [532.740360] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [532.847714] [107/156] (502s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu) [532.939680] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu [539.680083] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.738s) [539.833998] [108/156] (495s left) gem_userptr_blits (huge-split) [539.905446] Starting subtest: huge-split [539.910155] Subtest huge-split: SUCCESS (0.006s) [540.037206] [109/156] (495s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-render) [540.137779] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-render [540.142194] Subtest psrhdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [540.232042] [110/156] (495s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen) [540.341451] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen [546.941905] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.597s) [547.078431] [111/156] (488s left) gem_tiled_pread_pwrite [547.214459] [112/156] (488s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [547.317236] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu [547.321324] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [547.417505] [113/156] (488s left) gem_userptr_blits (usage-restrictions) [547.480375] Starting subtest: usage-restrictions [547.482674] Subtest usage-restrictions: SUCCESS (0.000s) [547.602723] [114/156] (488s left) gem_eio (in-flight-contexts-10ms) [547.842486] Starting subtest: in-flight-contexts-10ms [561.849270] Subtest in-flight-contexts-10ms: SUCCESS (13.991s) [562.007828] [115/156] (473s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc) [562.123540] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc [562.128022] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [562.218528] [116/156] (473s left) gem_render_copy_redux (normal) [562.277004] Starting subtest: normal [562.635330] Subtest normal: SUCCESS (0.361s) [562.747808] [117/156] (472s left) kms_psr (psr2-sprite-mmap-cpu) [562.841882] Starting subtest: psr2-sprite-mmap-cpu [562.843789] Starting dynamic subtest: eDP-1 [564.568875] Dynamic subtest eDP-1: SUCCESS (1.724s) [564.571209] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.725s) [565.428494] [118/156] (470s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-pwrite) [565.524224] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-pwrite [565.528485] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [565.624974] [119/156] (470s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier) [565.711297] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier [565.715912] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier: SKIP (0.000s) [565.797411] [120/156] (470s left) kms_psr (psr-suspend) [565.885982] Starting subtest: psr-suspend [565.888283] Starting dynamic subtest: eDP-1 [584.425517] Dynamic subtest eDP-1: SUCCESS (3.359s) [584.428254] Subtest psr-suspend: SUCCESS (3.360s) [591.312081] [121/156] (450s left) kms_frontbuffer_tracking (fbcpsr-2p-rte) [591.439442] Starting subtest: fbcpsr-2p-rte [591.445077] Subtest fbcpsr-2p-rte: SKIP (0.000s) [591.544264] [122/156] (450s left) kms_dp_link_training (uhbr-sst) [591.637019] Starting subtest: uhbr-sst [591.647036] Subtest uhbr-sst: SKIP (0.000s) [591.722016] [123/156] (450s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping) [591.810255] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping [591.815098] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s) [591.888247] [124/156] (450s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render) [591.988994] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render [591.993767] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [592.086268] [125/156] (450s left) syncobj_timeline (signal-array) [592.138113] Starting subtest: signal-array [592.140856] Subtest signal-array: SUCCESS (0.000s) [592.225496] [126/156] (449s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render) [592.322239] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render [599.111230] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.880s) [599.246860] [127/156] (442s left) gem_exec_reloc (basic-cpu-read) [599.311382] Subtest basic-cpu-read: SKIP (0.000s) [599.376952] [128/156] (442s left) gem_exec_fence (concurrent) [599.549274] Starting subtest: concurrent [599.554494] Subtest concurrent: SKIP (0.000s) [601.038061] [129/156] (441s left) kms_properties (get_properties-sanity-atomic) [601.123986] Starting subtest: get_properties-sanity-atomic [601.126705] Subtest get_properties-sanity-atomic: SUCCESS (0.002s) [601.200443] [130/156] (441s left) kms_big_fb (linear-8bpp-rotate-180) [601.304185] Starting subtest: linear-8bpp-rotate-180 [602.623895] Subtest linear-8bpp-rotate-180: SUCCESS (1.327s) [602.756019] [131/156] (439s left) kms_lease (setcrtc-implicit-plane) [602.846695] Starting subtest: setcrtc-implicit-plane [602.849228] Starting dynamic subtest: pipe-A-eDP-1 [603.323877] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.478s) [603.336082] Starting dynamic subtest: pipe-B-eDP-1 [604.448776] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.128s) [604.462962] Starting dynamic subtest: pipe-C-eDP-1 [605.546042] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.100s) [605.560964] Starting dynamic subtest: pipe-D-eDP-1 [606.677224] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.136s) [606.680128] Subtest setcrtc-implicit-plane: SUCCESS (3.849s) [607.525498] [132/156] (434s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling) [607.627073] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling [607.629423] Starting dynamic subtest: pipe-A-default-mode [610.361143] Dynamic subtest pipe-A-default-mode: SUCCESS (2.739s) [610.364112] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.741s) [611.206508] [133/156] (431s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation) [611.296507] Starting subtest: plane-scaler-unity-scaling-with-rotation [611.299019] Starting dynamic subtest: pipe-A [611.523374] Dynamic subtest pipe-A: SUCCESS (0.229s) [611.535016] Starting dynamic subtest: pipe-B [612.863983] Dynamic subtest pipe-B: SUCCESS (1.342s) [612.875281] Starting dynamic subtest: pipe-C [614.188008] Dynamic subtest pipe-C: SUCCESS (1.325s) [614.202173] Starting dynamic subtest: pipe-D [615.521961] Dynamic subtest pipe-D: SUCCESS (1.335s) [615.524353] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.235s) [616.737531] [134/156] (425s left) gem_exec_schedule (submit-late-slice) [616.808219] Starting subtest: submit-late-slice [616.810688] Starting dynamic subtest: rcs0 [616.840858] Dynamic subtest rcs0: SUCCESS (0.044s) [616.860218] Starting dynamic subtest: bcs0 [616.877971] Dynamic subtest bcs0: SUCCESS (0.034s) [616.891513] Starting dynamic subtest: vcs0 [616.910991] Dynamic subtest vcs0: SUCCESS (0.032s) [616.922380] Starting dynamic subtest: vcs1 [616.949161] Dynamic subtest vcs1: SUCCESS (0.037s) [616.961251] Starting dynamic subtest: vecs0 [616.984130] Dynamic subtest vecs0: SUCCESS (0.033s) [616.995632] Starting dynamic subtest: ccs0 [617.019131] Dynamic subtest ccs0: SUCCESS (0.035s) [617.022039] Subtest submit-late-slice: SUCCESS (0.223s) [618.048515] [135/156] (424s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [618.153051] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [618.158057] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [618.241029] [136/156] (424s left) kms_color (ctm-green-to-red) [618.336290] Starting subtest: ctm-green-to-red [618.338700] Starting dynamic subtest: pipe-A-eDP-1 [619.044987] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.711s) [619.058933] Starting dynamic subtest: pipe-B-eDP-1 [620.406556] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.360s) [620.418150] Starting dynamic subtest: pipe-C-eDP-1 [621.756272] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.350s) [621.769174] Starting dynamic subtest: pipe-D-eDP-1 [623.116379] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.359s) [623.119135] Subtest ctm-green-to-red: SUCCESS (4.785s) [623.924605] [137/156] (418s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt) [624.027770] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt [624.033074] Subtest fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [624.126045] [138/156] (418s left) kms_hdr (static-toggle-suspend) [624.215432] Starting subtest: static-toggle-suspend [624.217986] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010 [624.222932] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s) [624.235269] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F [624.240618] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s) [624.245788] Subtest static-toggle-suspend: SKIP (0.003s) [624.290937] [139/156] (418s left) kms_flip (2x-flip-vs-suspend-interruptible) [624.387488] Starting subtest: 2x-flip-vs-suspend-interruptible [624.392221] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.002s) [624.493201] [140/156] (418s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc) [624.584742] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc [624.587005] Starting dynamic subtest: pipe-A-eDP-1 [624.663055] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [624.674919] Starting dynamic subtest: pipe-B-eDP-1 [624.752102] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [624.764066] Starting dynamic subtest: pipe-C-eDP-1 [624.840695] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [624.852158] Starting dynamic subtest: pipe-D-eDP-1 [624.919018] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [624.924174] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s) [626.896162] [141/156] (415s left) core_getstats (basic) [626.958611] Starting subtest: basic [626.961077] Subtest basic: SUCCESS (0.000s) [627.062961] [142/156] (415s left) gem_mmap_offset (oob-read) [627.117110] Starting subtest: oob-read [627.120037] Subtest oob-read: SUCCESS (0.000s) [627.211772] [143/156] (415s left) gem_ctx_persistence (heartbeat-stop) [627.266453] Starting subtest: heartbeat-stop [627.271090] Subtest heartbeat-stop: SKIP (0.000s) [627.356017] [144/156] (415s left) dumb_buffer (map-invalid-size) [627.414218] Starting subtest: map-invalid-size [627.416919] Subtest map-invalid-size: SUCCESS (0.000s) [627.522951] [145/156] (415s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-mmap-cpu) [627.618028] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-mmap-cpu [627.622770] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [627.720712] [146/156] (415s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted) [627.774387] Starting subtest: etime-multi-wait-all-for-submit-submitted [627.883446] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.108s) [627.967074] [147/156] (415s left) kms_busy (extended-pageflip-modeset-hang-oldfb) [628.060996] Starting subtest: extended-pageflip-modeset-hang-oldfb [628.063647] Starting dynamic subtest: pipe-A [635.950001] Dynamic subtest pipe-A: SUCCESS (7.891s) [635.962862] Starting dynamic subtest: pipe-D [644.590339] Dynamic subtest pipe-D: SUCCESS (8.638s) [644.593215] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.533s) [645.454421] [148/156] (397s left) kms_plane_alpha_blend (alpha-7efc) [645.548808] Starting subtest: alpha-7efc [645.856116] Starting dynamic subtest: pipe-A-eDP-1 [646.478493] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.621s) [646.508132] Starting dynamic subtest: pipe-D-eDP-1 [647.783152] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.286s) [647.785960] Subtest alpha-7efc: SUCCESS (2.237s) [648.630535] [149/156] (394s left) gem_mmap_gtt (basic-small-copy-odd) [648.684169] Subtest basic-small-copy-odd: SKIP (0.000s) [648.751496] [150/156] (394s left) gem_workarounds (reset-fd) [648.812229] Starting subtest: reset-fd [648.969915] Subtest reset-fd: SUCCESS (0.158s) [649.081438] [151/156] (394s left) syncobj_timeline (invalid-query-zero-handles) [649.133274] Starting subtest: invalid-query-zero-handles [649.136225] Subtest invalid-query-zero-handles: SUCCESS (0.000s) [649.231508] [152/156] (394s left) kms_big_fb (x-tiled-8bpp-rotate-0) [649.328678] Starting subtest: x-tiled-8bpp-rotate-0 [650.598905] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.272s) [650.721613] [153/156] (392s left) i915_drm_fdinfo (busy) [650.765164] Starting subtest: busy [650.767493] Starting dynamic subtest: rcs0 [650.779080] Dynamic subtest rcs0: SKIP (0.015s) [650.790303] Starting dynamic subtest: bcs0 [650.797703] Dynamic subtest bcs0: SKIP (0.018s) [650.808288] Starting dynamic subtest: vcs0 [650.812246] Dynamic subtest vcs0: SKIP (0.000s) [650.822887] Starting dynamic subtest: vcs1 [650.827309] Dynamic subtest vcs1: SKIP (0.000s) [650.838259] Starting dynamic subtest: vecs0 [650.842794] Dynamic subtest vecs0: SKIP (0.000s) [650.853261] Starting dynamic subtest: ccs0 [650.857815] Dynamic subtest ccs0: SKIP (0.000s) [650.862019] Subtest busy: SKIP (0.038s) [650.902380] [154/156] (392s left) kms_big_fb (yf-tiled-64bpp-rotate-180) [651.001743] Starting subtest: yf-tiled-64bpp-rotate-180 [651.006607] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s) [651.100132] [155/156] (392s left) gem_ctx_create (basic-files) [651.159706] Starting subtest: basic-files [653.167684] Subtest basic-files: SUCCESS (2.009s) [655.017880] [156/156] (388s left) kms_psr (psr2-cursor-plane-onoff) [655.118899] Starting subtest: psr2-cursor-plane-onoff [655.121680] Starting dynamic subtest: eDP-1 [656.803943] Dynamic subtest eDP-1: SUCCESS (1.686s) [656.806570] Subtest psr2-cursor-plane-onoff: SUCCESS (1.687s) [657.719170] Closing watchdogs results: parsing output: 0/ for test: kms_pm_rpm results: parsing output: 1/ for test: perf results: parsing output: 2/ for test: gem_eio results: parsing output: 3/ for test: kms_chamelium_frames results: parsing output: 4/ for test: kms_frontbuffer_tracking results: parsing output: 5/ for test: i915_hangman results: parsing output: 6/ for test: gem_exec_whisper results: parsing output: 7/ for test: syncobj_wait results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: gem_exec_fence results: parsing output: 10/ for test: gem_exec_whisper results: parsing output: 11/ for test: syncobj_wait results: parsing output: 12/ for test: api_intel_bb results: parsing output: 13/ for test: kms_ccs results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: gem_exec_parallel results: parsing output: 16/ for test: kms_async_flips results: parsing output: 17/ for test: kms_psr2_sf results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: gem_ctx_param results: parsing output: 20/ for test: kms_cursor_legacy results: parsing output: 21/ for test: kms_cursor_legacy results: parsing output: 22/ for test: gem_exec_reloc results: parsing output: 23/ for test: prime_self_import results: parsing output: 24/ for test: kms_frontbuffer_tracking results: parsing output: 25/ for test: kms_joiner results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: kms_frontbuffer_tracking results: parsing output: 28/ for test: kms_psr results: parsing output: 29/ for test: kms_vblank results: parsing output: 30/ for test: kms_flip results: parsing output: 31/ for test: kms_big_fb results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: kms_frontbuffer_tracking results: parsing output: 34/ for test: syncobj_wait results: parsing output: 35/ for test: kms_cursor_edge_walk results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: perf results: parsing output: 38/ for test: kms_hdmi_inject results: parsing output: 39/ for test: perf_pmu results: parsing output: 40/ for test: gem_mmap_gtt results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: gem_pxp results: parsing output: 43/ for test: gem_create results: parsing output: 44/ for test: kms_chamelium_hpd results: parsing output: 45/ for test: gem_userptr_blits results: parsing output: 46/ for test: gem_busy results: parsing output: 47/ for test: kms_plane_scaling results: parsing output: 48/ for test: i915_selftest results: parsing output: 49/ for test: prime_vgem results: parsing output: 50/ for test: kms_cursor_legacy results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: kms_vrr results: parsing output: 53/ for test: gem_ctx_param results: parsing output: 54/ for test: sw_sync results: parsing output: 55/ for test: vgem_basic results: parsing output: 56/ for test: kms_content_protection results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: kms_properties results: parsing output: 60/ for test: kms_pm_rpm results: parsing output: 61/ for test: kms_cdclk results: parsing output: 62/ for test: kms_ccs results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: gem_caching results: parsing output: 65/ for test: sysfs_preempt_timeout results: parsing output: 66/ for test: kms_cursor_legacy results: parsing output: 67/ for test: kms_rotation_crc results: parsing output: 68/ for test: kms_cursor_legacy results: parsing output: 69/ for test: kms_atomic results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: kms_ccs results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: kms_cursor_crc results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: gem_exec_schedule results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: kms_psr results: parsing output: 80/ for test: gem_ctx_shared results: parsing output: 81/ for test: gem_spin_batch results: parsing output: 82/ for test: prime_mmap results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: i915_pm_rc6_residency results: parsing output: 85/ for test: gem_pxp results: parsing output: 86/ for test: gem_eio results: parsing output: 87/ for test: gen9_exec_parse results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: kms_cursor_crc results: parsing output: 90/ for test: gem_exec_params results: parsing output: 91/ for test: gem_exec_suspend results: parsing output: 92/ for test: syncobj_timeline results: parsing output: 93/ for test: kms_psr results: parsing output: 94/ for test: gem_render_copy results: parsing output: 95/ for test: gem_exec_balancer results: parsing output: 96/ for test: gen3_render_mixed_blits results: parsing output: 97/ for test: syncobj_timeline results: parsing output: 98/ for test: vgem_basic results: parsing output: 99/ for test: kms_dsc results: parsing output: 100/ for test: kms_big_fb results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: kms_big_fb results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: gem_userptr_blits results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: gem_tiled_pread_pwrite results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: gem_userptr_blits results: parsing output: 113/ for test: gem_eio results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: gem_render_copy_redux results: parsing output: 116/ for test: kms_psr results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: kms_plane results: parsing output: 119/ for test: kms_psr results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: kms_dp_link_training results: parsing output: 122/ for test: kms_plane results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: syncobj_timeline results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: gem_exec_reloc results: parsing output: 127/ for test: gem_exec_fence results: parsing output: 128/ for test: kms_properties results: parsing output: 129/ for test: kms_big_fb results: parsing output: 130/ for test: kms_lease results: parsing output: 131/ for test: kms_flip_scaled_crc results: parsing output: 132/ for test: kms_plane_scaling results: parsing output: 133/ for test: gem_exec_schedule results: parsing output: 134/ for test: kms_frontbuffer_tracking results: parsing output: 135/ for test: kms_color results: parsing output: 136/ for test: kms_frontbuffer_tracking results: parsing output: 137/ for test: kms_hdr results: parsing output: 138/ for test: kms_flip results: parsing output: 139/ for test: kms_ccs results: parsing output: 140/ for test: core_getstats results: parsing output: 141/ for test: gem_mmap_offset results: parsing output: 142/ for test: gem_ctx_persistence results: parsing output: 143/ for test: dumb_buffer results: parsing output: 144/ for test: kms_frontbuffer_tracking results: parsing output: 145/ for test: syncobj_timeline results: parsing output: 146/ for test: kms_busy results: parsing output: 147/ for test: kms_plane_alpha_blend results: parsing output: 148/ for test: gem_mmap_gtt results: parsing output: 149/ for test: gem_workarounds results: parsing output: 150/ for test: syncobj_timeline results: parsing output: 151/ for test: kms_big_fb results: parsing output: 152/ for test: i915_drm_fdinfo results: parsing output: 153/ for test: kms_big_fb results: parsing output: 154/ for test: gem_ctx_create results: parsing output: 155/ for test: kms_psr Done.