[57.612286] Initializing watchdogs [57.612333] /dev/watchdog0 [57.639551] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [57.643882] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.646518] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.649768] [001/155] (960s left) gem_create (create-ext-cpu-access-big) [57.837048] Starting subtest: create-ext-cpu-access-big [57.842485] Subtest create-ext-cpu-access-big: SKIP (0.001s) [57.908884] [002/155] (960s left) gem_ctx_param (vm) [57.958410] Starting subtest: vm [58.033654] Subtest vm: SUCCESS (0.074s) [58.150600] [003/155] (960s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-blt) [58.264761] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-blt [58.269150] Subtest psrhdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [58.354284] [004/155] (959s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs) [58.408875] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs [58.413579] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s) [58.585974] [005/155] (959s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-blt) [58.682222] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-blt [58.686973] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [58.781439] [006/155] (959s left) vgem_basic (busy-fence) [58.851433] Starting subtest: busy-fence [58.853408] Subtest busy-fence: SUCCESS (0.001s) [58.905502] [FACT vgem_basic (busy-fence)] new: kernel.kmod_is_loaded.vgem: true [58.908596] [007/155] (959s left) kms_big_fb (x-tiled-8bpp-rotate-270) [59.008995] Starting subtest: x-tiled-8bpp-rotate-270 [59.044114] Subtest x-tiled-8bpp-rotate-270: SKIP (0.035s) [59.138871] [008/155] (959s left) syncobj_eventfd (invalid-bad-flags) [59.196023] Starting subtest: invalid-bad-flags [59.198333] Subtest invalid-bad-flags: SUCCESS (0.000s) [59.293225] [009/155] (959s left) gem_mmap_wc (write-read) [59.349600] Subtest write-read: SKIP (0.000s) [59.399212] [010/155] (959s left) kms_chamelium_frames (dp-crc-multiple) [59.792956] Subtest dp-crc-multiple: SKIP (0.000s) [60.589596] [011/155] (957s left) gem_spin_batch (engines) [60.653860] Starting subtest: engines [60.656069] Starting dynamic subtest: rcs0 [63.892639] Dynamic subtest rcs0: SUCCESS (3.235s) [63.902119] Starting dynamic subtest: bcs0 [67.183566] Dynamic subtest bcs0: SUCCESS (3.237s) [67.194861] Starting dynamic subtest: vcs0 [70.369374] Dynamic subtest vcs0: SUCCESS (3.235s) [70.379764] Starting dynamic subtest: vcs1 [73.698156] Dynamic subtest vcs1: SUCCESS (3.327s) [73.708142] Starting dynamic subtest: vecs0 [76.986369] Dynamic subtest vecs0: SUCCESS (3.236s) [76.995891] Starting dynamic subtest: ccs0 [80.220044] Dynamic subtest ccs0: SUCCESS (3.232s) [80.222318] Subtest engines: SUCCESS (19.510s) [80.356669] [012/155] (938s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers) [80.453418] Starting subtest: plane-upscale-20x20-with-modifiers [80.455773] Starting dynamic subtest: pipe-A [80.791767] Dynamic subtest pipe-A: SUCCESS (0.338s) [80.801124] Starting dynamic subtest: pipe-B [82.194080] Dynamic subtest pipe-B: SUCCESS (1.402s) [82.203494] Starting dynamic subtest: pipe-C [83.642586] Dynamic subtest pipe-C: SUCCESS (1.448s) [83.650170] Starting dynamic subtest: pipe-D [85.073786] Dynamic subtest pipe-D: SUCCESS (1.429s) [85.077779] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.618s) [86.236482] [013/155] (932s left) gem_userptr_blits (stress-mm-invalidate-close-overlap) [86.310760] Starting subtest: stress-mm-invalidate-close-overlap [88.512473] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s) [88.586158] [014/155] (930s left) kms_concurrent (multi-plane-atomic-lowres) [88.683828] Starting subtest: multi-plane-atomic-lowres [88.686087] Starting dynamic subtest: pipe-A-eDP-1 [89.204196] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.518s) [89.214143] Starting dynamic subtest: pipe-B-eDP-1 [90.503210] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.297s) [90.515812] Starting dynamic subtest: pipe-C-eDP-1 [91.719732] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.216s) [91.729104] Starting dynamic subtest: pipe-D-eDP-1 [92.971100] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.252s) [92.973333] Subtest multi-plane-atomic-lowres: SUCCESS (4.287s) [93.776180] [015/155] (924s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-shrfb-plflip-blt) [93.882255] Starting subtest: fbchdr-2p-scndscrn-shrfb-plflip-blt [93.886241] Subtest fbchdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [93.968994] [016/155] (924s left) kms_psr (fbc-psr-cursor-plane-onoff) [94.063789] Starting subtest: fbc-psr-cursor-plane-onoff [94.066125] Starting dynamic subtest: eDP-1 [94.070390] Dynamic subtest eDP-1: SKIP (0.000s) [94.074854] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s) [94.138291] [017/155] (924s left) api_intel_allocator (execbuf-with-allocator) [94.197630] Starting subtest: execbuf-with-allocator [94.203778] Subtest execbuf-with-allocator: SUCCESS (0.007s) [94.293803] [018/155] (924s left) gem_exec_fence (syncobj-timeline-invalid-wait) [94.820545] Starting subtest: syncobj-timeline-invalid-wait [94.825183] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.005s) [96.388838] [019/155] (922s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu) [96.487303] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu [96.491652] Subtest psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [96.573889] [020/155] (922s left) kms_psr (fbc-psr2-sprite-plane-onoff) [96.664842] Starting subtest: fbc-psr2-sprite-plane-onoff [96.667058] Starting dynamic subtest: eDP-1 [96.671388] Dynamic subtest eDP-1: SKIP (0.000s) [96.675788] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.000s) [96.745073] [021/155] (922s left) gem_render_copy (yf-tiled) [96.812611] Starting subtest: yf-tiled [96.817624] Subtest yf-tiled: SKIP (0.000s) [96.991658] [022/155] (921s left) gem_ctx_param (non-root-set) [97.052370] Starting subtest: non-root-set [97.068241] Subtest non-root-set: SUCCESS (0.018s) [97.162742] [023/155] (921s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers) [97.252213] Starting subtest: plane-scaler-unity-scaling-with-modifiers [97.254630] Starting dynamic subtest: pipe-A [97.591316] Dynamic subtest pipe-A: SUCCESS (0.339s) [97.599508] Starting dynamic subtest: pipe-B [98.991847] Dynamic subtest pipe-B: SUCCESS (1.399s) [98.999621] Starting dynamic subtest: pipe-C [100.444317] Dynamic subtest pipe-C: SUCCESS (1.452s) [100.453833] Starting dynamic subtest: pipe-D [101.849200] Dynamic subtest pipe-D: SUCCESS (1.405s) [101.851872] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.597s) [103.014301] [024/155] (916s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-pwrite) [103.112922] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-pwrite [103.117133] Subtest hdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [103.200741] [025/155] (915s left) kms_lease (atomic-implicit-crtc) [103.281616] Starting subtest: atomic-implicit-crtc [103.283964] Starting dynamic subtest: pipe-A-eDP-1 [103.295251] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [103.304271] Starting dynamic subtest: pipe-B-eDP-1 [103.315259] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s) [103.322683] Starting dynamic subtest: pipe-C-eDP-1 [103.333078] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s) [103.340596] Starting dynamic subtest: pipe-D-eDP-1 [103.351089] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s) [103.352907] Subtest atomic-implicit-crtc: SUCCESS (0.033s) [103.420415] [026/155] (915s left) kms_cursor_crc (cursor-rapid-movement-256x85) [103.681743] Starting subtest: cursor-rapid-movement-256x85 [103.727489] Subtest cursor-rapid-movement-256x85: SKIP (0.043s) [103.903584] [027/155] (915s left) gem_close_race (basic-process) [103.969462] Starting subtest: basic-process [104.017740] Subtest basic-process: SUCCESS (0.048s) [104.214787] [028/155] (914s left) kms_psr (psr2-primary-render) [104.312337] Starting subtest: psr2-primary-render [104.314781] Starting dynamic subtest: eDP-1 [106.032999] Dynamic subtest eDP-1: SUCCESS (1.719s) [106.035331] Subtest psr2-primary-render: SUCCESS (1.720s) [106.895183] [029/155] (912s left) kms_rotation_crc (cursor-rotation-180) [106.982745] Starting subtest: cursor-rotation-180 [108.481844] Subtest cursor-rotation-180: SUCCESS (1.501s) [109.658872] [030/155] (909s left) gem_mmap_gtt (basic-small-bo-tiledx) [109.710823] Subtest basic-small-bo-tiledX: SKIP (0.000s) [109.772596] [031/155] (909s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs) [109.860450] Starting subtest: crc-primary-suspend-yf-tiled-ccs [109.862857] Starting dynamic subtest: pipe-A-eDP-1 [109.872409] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [109.882492] Starting dynamic subtest: pipe-B-eDP-1 [109.891426] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [109.899296] Starting dynamic subtest: pipe-C-eDP-1 [109.908392] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [109.916522] Starting dynamic subtest: pipe-D-eDP-1 [109.924881] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [109.929078] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.003s) [112.117227] [032/155] (907s left) kms_cursor_crc (cursor-offscreen-32x10) [112.275581] Starting subtest: cursor-offscreen-32x10 [112.321532] Subtest cursor-offscreen-32x10: SKIP (0.043s) [112.583504] [033/155] (906s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-move) [112.680199] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-move [112.684373] Subtest psrhdr-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [112.775118] [034/155] (906s left) kms_flip (nonexisting-fb-interruptible) [112.863385] Starting subtest: nonexisting-fb-interruptible [112.865742] Starting dynamic subtest: A-eDP1 [114.007519] Dynamic subtest A-eDP1: SUCCESS (1.144s) [114.016171] Starting dynamic subtest: B-eDP1 [115.139070] Dynamic subtest B-eDP1: SUCCESS (1.130s) [115.147088] Starting dynamic subtest: C-eDP1 [116.265391] Dynamic subtest C-eDP1: SUCCESS (1.125s) [116.275417] Starting dynamic subtest: D-eDP1 [117.406835] Dynamic subtest D-eDP1: SUCCESS (1.140s) [117.409323] Subtest nonexisting-fb-interruptible: SUCCESS (4.547s) [118.566441] [035/155] (900s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render) [118.669111] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render [118.673389] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [118.772912] [036/155] (900s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite) [118.879749] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite [118.883908] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [118.977907] [037/155] (900s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping) [119.078047] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping [119.102972] Starting dynamic subtest: pipe-A-plane-0 [119.369838] Dynamic subtest pipe-A-plane-0: SUCCESS (0.267s) [119.379320] Starting dynamic subtest: pipe-A-plane-3 [119.580365] Dynamic subtest pipe-A-plane-3: SUCCESS (0.210s) [120.660098] Starting dynamic subtest: pipe-B-plane-0 [120.941648] Dynamic subtest pipe-B-plane-0: SUCCESS (0.289s) [120.952404] Starting dynamic subtest: pipe-B-plane-3 [121.153869] Dynamic subtest pipe-B-plane-3: SUCCESS (0.210s) [121.465480] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.388s) [122.333166] [038/155] (897s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [122.430681] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu [122.434760] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [122.531813] [039/155] (897s left) i915_pm_rpm (sysfs-read) [124.464963] Starting subtest: sysfs-read [125.612934] Subtest sysfs-read: SUCCESS (1.148s) [126.024505] [040/155] (893s left) kms_addfb_basic (unused-offsets) [126.074826] Starting subtest: unused-offsets [126.077193] Subtest unused-offsets: SUCCESS (0.000s) [126.217645] [041/155] (893s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling) [126.306826] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling [126.309054] Starting dynamic subtest: pipe-A-default-mode [127.454347] Dynamic subtest pipe-A-default-mode: SKIP (1.145s) [127.458914] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.146s) [127.596418] [042/155] (892s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc) [127.694679] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc [127.697111] Starting dynamic subtest: pipe-A-eDP-1 [127.718033] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [127.728072] Starting dynamic subtest: pipe-B-eDP-1 [127.747367] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [127.754613] Starting dynamic subtest: pipe-C-eDP-1 [127.774039] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [127.781094] Starting dynamic subtest: pipe-D-eDP-1 [127.800593] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [127.802497] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.007s) [129.996954] [043/155] (889s left) syncobj_timeline (wait-all-delayed-signal) [130.065945] Starting subtest: wait-all-delayed-signal [130.165219] Subtest wait-all-delayed-signal: SUCCESS (0.103s) [130.242828] [044/155] (889s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite) [130.348243] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite [130.352455] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s) [130.455166] [045/155] (889s left) gem_gpgpu_fill (offset-16x16) [130.510299] Starting subtest: offset-16x16 [130.515365] Subtest offset-16x16: SUCCESS (0.007s) [130.655462] [046/155] (889s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf) [130.748066] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf [130.750403] Starting dynamic subtest: pipe-A-eDP-1 [130.846698] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s) [130.858120] Starting dynamic subtest: pipe-B-eDP-1 [131.975795] Dynamic subtest pipe-B-eDP-1: SKIP (1.125s) [131.980290] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.230s) [133.264821] [047/155] (886s left) gem_exec_balancer (parallel-bb-first) [133.520465] Starting subtest: parallel-bb-first [134.427688] Subtest parallel-bb-first: SUCCESS (0.907s) [135.332193] [048/155] (884s left) gem_workarounds (basic-read-fd) [135.393357] Starting subtest: basic-read-fd [135.404562] Subtest basic-read-fd: SUCCESS (0.011s) [135.526981] [049/155] (884s left) kms_content_protection (dp-mst-lic-type-1) [135.663848] Starting subtest: dp-mst-lic-type-1 [135.668803] Subtest dp-mst-lic-type-1: SKIP (0.000s) [135.794545] [050/155] (884s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-gtt) [135.900219] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-gtt [135.904450] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [135.996722] [051/155] (884s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0) [136.097610] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0 [136.102195] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s) [136.187475] [052/155] (883s left) kms_prime (basic-modeset-hybrid) [136.268911] Subtest basic-modeset-hybrid: SKIP (0.000s) [136.356967] [053/155] (883s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [136.451505] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu [136.455191] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [136.560098] [054/155] (883s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-pwrite) [136.652285] Starting subtest: hdr-rgb101010-draw-pwrite [136.655767] Subtest hdr-rgb101010-draw-pwrite: SKIP (0.000s) [136.734081] [055/155] (883s left) i915_drm_fdinfo (virtual-busy-all) [136.769938] Starting subtest: virtual-busy-all [136.773802] Subtest virtual-busy-all: SKIP (0.000s) [136.837337] [056/155] (883s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt) [136.936424] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt [136.940024] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [137.038389] [057/155] (883s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff) [137.139883] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff [137.143330] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [137.248952] [058/155] (883s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-pwrite) [137.339264] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-pwrite [137.342943] Subtest hdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s) [137.456916] [059/155] (882s left) gem_mmap_gtt (medium-copy-odd) [137.517037] Subtest medium-copy-odd: SKIP (0.000s) [137.572305] [060/155] (882s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff) [137.667601] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff [137.670896] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [137.755886] [061/155] (882s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [137.854599] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu [137.858046] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [137.968901] [062/155] (882s left) gem_madvise (dontneed-before-pwrite) [138.003586] Starting subtest: dontneed-before-pwrite [138.022791] Subtest dontneed-before-pwrite: SKIP (0.016s) [138.083756] [063/155] (882s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu) [138.172193] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu [145.242052] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.072s) [145.341308] [064/155] (875s left) syncobj_basic (bad-flags-handle-to-fd) [145.388038] Starting subtest: bad-flags-handle-to-fd [145.390285] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s) [145.469204] [065/155] (875s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt) [145.565956] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt [145.570778] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [145.663799] [066/155] (875s left) gem_wait (await) [145.732482] Starting subtest: await [145.734919] Starting dynamic subtest: all-engines [146.857830] Dynamic subtest all-engines: SUCCESS (1.124s) [146.874663] Starting dynamic subtest: rcs0 [147.917084] Dynamic subtest rcs0: SUCCESS (1.057s) [147.933947] Starting dynamic subtest: bcs0 [148.974764] Dynamic subtest bcs0: SUCCESS (1.056s) [148.990722] Starting dynamic subtest: vcs0 [150.031400] Dynamic subtest vcs0: SUCCESS (1.054s) [150.047590] Starting dynamic subtest: vcs1 [151.086561] Dynamic subtest vcs1: SUCCESS (1.053s) [151.102780] Starting dynamic subtest: vecs0 [152.144229] Dynamic subtest vecs0: SUCCESS (1.054s) [152.158222] Starting dynamic subtest: ccs0 [153.203318] Dynamic subtest ccs0: SUCCESS (1.058s) [153.206639] Subtest await: SUCCESS (7.471s) [153.402211] [067/155] (867s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-render) [153.504246] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-render [153.508574] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [153.584901] [068/155] (867s left) gem_eio (hibernate) [153.775355] Starting subtest: hibernate [168.416264] Subtest hibernate: SUCCESS (14.639s) [175.545940] [069/155] (852s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180) [175.667095] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180 [176.736365] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.070s) [176.847503] [070/155] (851s left) kms_3d (basic) [176.903174] Starting subtest: basic [179.202212] Subtest basic: SUCCESS (2.301s) [179.711131] [071/155] (848s left) syncobj_timeline (etime-single-wait-for-submit-submitted) [179.763422] Starting subtest: etime-single-wait-for-submit-submitted [179.871307] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.106s) [179.948098] [072/155] (848s left) gem_ccs (block-multicopy-inplace) [180.016344] Starting subtest: block-multicopy-inplace [180.020651] Subtest block-multicopy-inplace: SKIP (0.000s) [180.117449] [073/155] (847s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-render) [180.205807] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-render [180.209763] Subtest hdr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [180.290707] [074/155] (847s left) gem_exec_params (invalid-ring2) [180.351567] Starting subtest: invalid-ring2 [180.353686] Subtest invalid-ring2: SUCCESS (0.000s) [180.469143] [075/155] (847s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render) [180.567204] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render [187.305114] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.743s) [187.441901] [076/155] (840s left) kms_busy (extended-pageflip-hang-newfb) [187.537350] Starting subtest: extended-pageflip-hang-newfb [187.539502] Starting dynamic subtest: pipe-A [215.065627] Dynamic subtest pipe-A: SUCCESS (27.527s) [215.079814] Starting dynamic subtest: pipe-D [240.074236] Dynamic subtest pipe-D: SUCCESS (25.007s) [240.076932] Subtest extended-pageflip-hang-newfb: SUCCESS (52.538s) [240.958683] [077/155] (787s left) gem_eio (banned) [241.144941] Starting subtest: banned [241.647535] Subtest banned: SUCCESS (0.503s) [241.824999] [078/155] (786s left) kms_vblank (wait-idle-hang) [241.924193] Starting subtest: wait-idle-hang [241.925886] Starting dynamic subtest: pipe-A-eDP-1 [243.826112] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.902s) [243.840577] Starting dynamic subtest: pipe-D-eDP-1 [246.266883] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.437s) [246.269239] Subtest wait-idle-hang: SUCCESS (4.343s) [247.170633] [079/155] (781s left) kms_psr (fbc-pr-sprite-mmap-gtt) [247.268091] Starting subtest: fbc-pr-sprite-mmap-gtt [247.272185] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s) [247.341074] [080/155] (780s left) syncobj_wait (multi-wait-all-for-submit-submitted) [247.408693] Starting subtest: multi-wait-all-for-submit-submitted [247.511491] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.103s) [247.587376] [081/155] (780s left) gem_render_copy (linear) [247.651443] Starting subtest: linear [247.653714] Starting dynamic subtest: smem [247.690682] Dynamic subtest smem: SUCCESS (0.039s) [247.693053] Subtest linear: SUCCESS (0.039s) [247.917804] [082/155] (780s left) syncobj_wait (invalid-single-wait-unsubmitted) [247.975941] Starting subtest: invalid-single-wait-unsubmitted [247.978101] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s) [248.086440] [083/155] (780s left) gem_fence_thrash (bo-write-verify-y) [248.122329] Starting subtest: bo-write-verify-y [248.150622] Subtest bo-write-verify-y: SKIP (0.025s) [248.213018] [084/155] (780s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu) [248.306370] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu [255.076194] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.775s) [255.212130] [085/155] (773s left) gem_userptr_blits (sync-unmap) [255.285992] Starting subtest: sync-unmap [255.301418] Subtest sync-unmap: SUCCESS (0.015s) [255.430991] [086/155] (773s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-pwrite) [255.524654] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-pwrite [255.528813] Subtest fbchdr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [255.626445] [087/155] (772s left) gem_softpin (evict-snoop-interruptible) [255.683998] Starting subtest: evict-snoop-interruptible [255.688171] Subtest evict-snoop-interruptible: SKIP (0.000s) [255.811722] [088/155] (772s left) kms_flip (2x-blocking-absolute-wf_vblank) [255.901792] Starting subtest: 2x-blocking-absolute-wf_vblank [255.910732] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s) [256.023597] [089/155] (772s left) gem_exec_schedule (pi-shared-iova) [256.208235] Starting subtest: pi-shared-iova [256.210280] Starting dynamic subtest: rcs0 [256.281066] Dynamic subtest rcs0: SUCCESS (0.074s) [256.298421] Starting dynamic subtest: vcs0 [256.341960] Dynamic subtest vcs0: SUCCESS (0.060s) [256.351679] Starting dynamic subtest: vcs1 [256.395203] Dynamic subtest vcs1: SUCCESS (0.053s) [256.405636] Starting dynamic subtest: vecs0 [256.452084] Dynamic subtest vecs0: SUCCESS (0.055s) [256.463524] Starting dynamic subtest: ccs0 [256.522299] Dynamic subtest ccs0: SUCCESS (0.070s) [256.524827] Subtest pi-shared-iova: SUCCESS (0.317s) [258.379901] [090/155] (770s left) gem_userptr_blits (usage-restrictions) [258.442633] Starting subtest: usage-restrictions [258.444923] Subtest usage-restrictions: SUCCESS (0.000s) [258.553412] [091/155] (770s left) dumb_buffer (map-uaf) [258.609973] Starting subtest: map-uaf [258.614787] Subtest map-uaf: SUCCESS (0.005s) [258.733398] [092/155] (770s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt) [258.837600] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt [258.841945] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [258.936590] [093/155] (769s left) kms_flip (2x-flip-vs-rmfb-interruptible) [259.033872] Starting subtest: 2x-flip-vs-rmfb-interruptible [259.045472] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.012s) [259.124204] [094/155] (769s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [259.228867] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip [260.052828] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.826s) [260.239472] [095/155] (768s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [260.334177] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-mmap-gtt [260.338476] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [260.431196] [096/155] (768s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c) [260.499051] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s) [260.552729] [097/155] (768s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode) [260.931412] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s) [261.728216] [098/155] (767s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-pwrite) [261.836578] Starting subtest: fbcpsrhdr-rgb101010-draw-pwrite [261.840815] Subtest fbcpsrhdr-rgb101010-draw-pwrite: SKIP (0.000s) [261.947206] [099/155] (767s left) gem_mmap_wc (bad-object) [262.009563] Subtest bad-object: SKIP (0.000s) [262.069896] [100/155] (767s left) gem_mmap_wc (coherency) [262.134641] Subtest coherency: SKIP (0.000s) [262.193401] [101/155] (766s left) gem_exec_reloc (basic-range) [262.259607] Subtest basic-range: SKIP (0.000s) [262.355524] [102/155] (766s left) gen9_exec_parse (allowed-single) [262.406249] Subtest allowed-single: SKIP (0.000s) [262.473976] [103/155] (766s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt) [262.571491] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt [269.465380] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.899s) [269.603246] [104/155] (759s left) i915_pm_rps (thresholds-idle) [269.662737] Starting subtest: thresholds-idle [269.667569] Subtest thresholds-idle: SKIP (0.001s) [269.765196] [105/155] (759s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt) [269.866643] Starting subtest: fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt [269.870703] Subtest fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [269.958753] [106/155] (759s left) kms_flip (flip-vs-dpms-on-nop-interruptible) [270.060629] Starting subtest: flip-vs-dpms-on-nop-interruptible [270.062916] Starting dynamic subtest: A-eDP1 [271.915892] Dynamic subtest A-eDP1: SUCCESS (1.854s) [271.928568] Starting dynamic subtest: B-eDP1 [273.817635] Dynamic subtest B-eDP1: SUCCESS (1.900s) [273.829507] Starting dynamic subtest: C-eDP1 [275.709174] Dynamic subtest C-eDP1: SUCCESS (1.890s) [275.721628] Starting dynamic subtest: D-eDP1 [277.608806] Dynamic subtest D-eDP1: SUCCESS (1.898s) [277.614849] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.552s) [278.858182] [107/155] (750s left) api_intel_bb (lot-of-buffers) [278.921133] Starting subtest: lot-of-buffers [279.934217] Subtest lot-of-buffers: SUCCESS (1.012s) [280.391988] [108/155] (749s left) gem_pipe_control_store_loop (reused-buffer) [280.447693] Starting subtest: reused-buffer [282.603277] Subtest reused-buffer: SUCCESS (2.155s) [282.727426] [109/155] (746s left) gem_mmap_offset (mmap-unmap) [282.782134] Starting subtest: mmap-unmap [282.784563] Starting dynamic subtest: smem0 [305.755278] Dynamic subtest smem0: SUCCESS (22.921s) [305.757842] Subtest mmap-unmap: SUCCESS (22.922s) [305.858632] [110/155] (723s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-mmap-wc) [305.966605] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-mmap-wc [305.970719] Subtest hdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [306.057332] [111/155] (723s left) kms_invalid_mode (bad-hsync-end) [306.157485] Starting subtest: bad-hsync-end [306.159729] Starting dynamic subtest: pipe-A-eDP-1 [306.439714] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s) [306.450247] Starting dynamic subtest: pipe-B-eDP-1 [306.452241] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [306.461798] Starting dynamic subtest: pipe-C-eDP-1 [306.464323] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [306.476433] Starting dynamic subtest: pipe-D-eDP-1 [306.478808] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [306.481197] Subtest bad-hsync-end: SUCCESS (0.288s) [307.254391] [112/155] (722s left) syncobj_wait (single-wait-for-submit-unsubmitted) [307.303757] Starting subtest: single-wait-for-submit-unsubmitted [307.407875] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.101s) [307.495504] [113/155] (722s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot) [307.601582] Starting subtest: modeset-atomic-cursor-hotspot [307.606032] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s) [307.758478] [114/155] (721s left) gem_ctx_persistence (heartbeat-close) [307.819298] Starting subtest: heartbeat-close [307.823838] Subtest heartbeat-close: SKIP (0.000s) [307.943841] [115/155] (721s left) kms_vrr (seamless-rr-switch-drrs) [308.033270] Starting subtest: seamless-rr-switch-drrs [308.039497] Subtest seamless-rr-switch-drrs: SKIP (0.000s) [308.121981] [116/155] (721s left) kms_properties (crtc-properties-legacy) [308.220138] Starting subtest: crtc-properties-legacy [308.222354] Starting dynamic subtest: pipe-A-eDP-1 [308.663799] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.444s) [308.673761] Starting dynamic subtest: pipe-B-eDP-1 [309.885235] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.219s) [309.895658] Starting dynamic subtest: pipe-C-eDP-1 [311.080423] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.194s) [311.091423] Starting dynamic subtest: pipe-D-eDP-1 [312.274907] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.191s) [312.277188] Subtest crtc-properties-legacy: SUCCESS (4.054s) [313.146992] [117/155] (716s left) kms_chamelium_color (ctm-0-75) [313.236200] Subtest ctm-0-75: SKIP (0.000s) [313.282409] [118/155] (716s left) kms_big_fb (yf-tiled-32bpp-rotate-270) [313.381626] Starting subtest: yf-tiled-32bpp-rotate-270 [313.385989] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s) [313.489809] [119/155] (716s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite) [313.579696] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite [320.688127] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.113s) [320.835057] [120/155] (709s left) syncobj_wait (multi-wait-all-submitted-signaled) [320.889075] Starting subtest: multi-wait-all-submitted-signaled [320.990109] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.101s) [321.066699] [121/155] (708s left) i915_pm_freq_api (freq-reset-multiple) [321.127711] Starting subtest: freq-reset-multiple [321.129876] Starting dynamic subtest: gt0 [330.711631] Dynamic subtest gt0: SUCCESS (9.581s) [330.720979] Starting dynamic subtest: gt1 [339.095862] Dynamic subtest gt1: SUCCESS (8.383s) [339.098886] Subtest freq-reset-multiple: SUCCESS (17.966s) [339.176067] [122/155] (690s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-shrfb-msflip-blt) [339.282640] Starting subtest: hdr-2p-scndscrn-shrfb-msflip-blt [339.287099] Subtest hdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [339.394513] [123/155] (690s left) syncobj_timeline (invalid-wait-bad-flags) [339.445913] Starting subtest: invalid-wait-bad-flags [339.448281] Subtest invalid-wait-bad-flags: SUCCESS (0.000s) [339.537605] [124/155] (690s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs) [339.628218] Starting subtest: missing-ccs-buffer-y-tiled-ccs [339.630525] Starting dynamic subtest: pipe-A-eDP-1 [339.653394] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [339.665330] Starting dynamic subtest: pipe-B-eDP-1 [339.686907] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [339.696201] Starting dynamic subtest: pipe-C-eDP-1 [339.717819] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [339.726964] Starting dynamic subtest: pipe-D-eDP-1 [339.748590] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [339.753040] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.004s) [341.854511] [125/155] (688s left) perf_pmu (invalid-open) [341.897930] Starting subtest: invalid-open [341.900353] Subtest invalid-open: SUCCESS (0.000s) [342.006985] [126/155] (688s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf) [342.104426] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf [342.108520] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [342.174589] [127/155] (688s left) kms_vblank (query-forked) [342.258281] Starting subtest: query-forked [342.260620] Starting dynamic subtest: pipe-A-eDP-1 [344.072435] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.816s) [344.087832] Starting dynamic subtest: pipe-D-eDP-1 [346.632847] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.558s) [346.635348] Subtest query-forked: SUCCESS (4.378s) [347.445245] [128/155] (682s left) syncobj_timeline (multi-wait-for-submit-available-submitted) [347.507127] Starting subtest: multi-wait-for-submit-available-submitted [347.509368] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s) [347.595837] [129/155] (682s left) kms_feature_discovery (display-3x) [347.680262] Starting subtest: display-3x [347.684309] Subtest display-3x: SKIP (0.000s) [347.753901] [130/155] (682s left) kms_flip (flip-vs-panning) [347.845315] Starting subtest: flip-vs-panning [347.847188] Starting dynamic subtest: A-eDP1 [356.633262] Dynamic subtest A-eDP1: SUCCESS (8.790s) [356.646335] Starting dynamic subtest: B-eDP1 [365.322756] Dynamic subtest B-eDP1: SUCCESS (8.688s) [365.332474] Starting dynamic subtest: C-eDP1 [374.016741] Dynamic subtest C-eDP1: SUCCESS (8.692s) [374.029035] Starting dynamic subtest: D-eDP1 [382.714836] Dynamic subtest D-eDP1: SUCCESS (8.695s) [382.719319] Subtest flip-vs-panning: SUCCESS (34.875s) [383.948605] [131/155] (646s left) gem_exec_schedule (preempt-user) [384.015307] Starting subtest: preempt-user [384.017143] Starting dynamic subtest: rcs0 [384.035959] Dynamic subtest rcs0: SUCCESS (0.026s) [384.048349] Starting dynamic subtest: bcs0 [384.057896] Dynamic subtest bcs0: SUCCESS (0.021s) [384.067667] Starting dynamic subtest: vcs0 [384.081135] Dynamic subtest vcs0: SUCCESS (0.022s) [384.093200] Starting dynamic subtest: vcs1 [384.104279] Dynamic subtest vcs1: SUCCESS (0.022s) [384.115897] Starting dynamic subtest: vecs0 [384.124108] Dynamic subtest vecs0: SUCCESS (0.019s) [384.134238] Starting dynamic subtest: ccs0 [384.147500] Dynamic subtest ccs0: SUCCESS (0.023s) [384.149753] Subtest preempt-user: SUCCESS (0.138s) [385.381773] [132/155] (645s left) kms_big_fb (yf-tiled-64bpp-rotate-270) [385.484275] Starting subtest: yf-tiled-64bpp-rotate-270 [385.488753] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s) [385.594205] [133/155] (644s left) gem_mmap_gtt (fault-concurrent-x) [385.646755] Subtest fault-concurrent-X: SKIP (0.000s) [385.703089] [134/155] (644s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-blt) [385.800425] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-blt [385.804673] Subtest psrhdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [385.886230] [135/155] (644s left) kms_cursor_edge_walk (128x128-left-edge) [385.972737] Starting subtest: 128x128-left-edge [385.974962] Starting dynamic subtest: pipe-A-eDP-1 [389.473309] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.499s) [389.483765] Starting dynamic subtest: pipe-D-eDP-1 [392.667278] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.192s) [392.669557] Subtest 128x128-left-edge: SUCCESS (6.693s) [393.546048] [136/155] (637s left) kms_async_flips (test-time-stamp-atomic) [393.643129] Starting subtest: test-time-stamp-atomic [394.026768] Starting dynamic subtest: pipe-A-eDP-1 [394.810626] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.781s) [395.192946] Starting dynamic subtest: pipe-B-eDP-1 [396.019098] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.832s) [396.413641] Starting dynamic subtest: pipe-C-eDP-1 [397.212707] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.807s) [397.579222] Starting dynamic subtest: pipe-D-eDP-1 [398.415845] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.842s) [398.418248] Subtest test-time-stamp-atomic: SUCCESS (4.773s) [399.667809] [137/155] (631s left) kms_plane_multiple (tiling-none) [399.757886] Starting subtest: tiling-none [399.759821] Starting dynamic subtest: pipe-A-eDP-1 [403.571213] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.813s) [403.581997] Starting dynamic subtest: pipe-B-eDP-1 [408.174374] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.600s) [408.184786] Starting dynamic subtest: pipe-C-eDP-1 [412.754838] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.582s) [412.766302] Starting dynamic subtest: pipe-D-eDP-1 [417.363208] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.605s) [417.365500] Subtest tiling-none: SUCCESS (17.604s) [418.232584] [138/155] (612s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt) [418.341910] Starting subtest: psr-2p-primscrn-indfb-plflip-blt [418.346162] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [418.445584] [139/155] (612s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt) [418.548910] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt [422.893224] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.350s) [424.045097] [140/155] (606s left) gem_unref_active_buffers [424.239479] [141/155] (606s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt) [424.335078] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt [424.339474] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [424.452299] [142/155] (606s left) kms_selftest (drm_cmdline_parser) [424.492322] Starting subtest: drm_cmdline_parser [424.546425] Starting dynamic subtest: drm_test_cmdline_force_d_only [424.639081] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.094s) [424.650081] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi [424.727071] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.087s) [424.738941] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi [424.822801] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.093s) [424.834673] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital [424.909230] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.086s) [424.921242] Starting dynamic subtest: drm_test_cmdline_force_e_only [424.996708] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.088s) [425.007239] Starting dynamic subtest: drm_test_cmdline_res [425.088514] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.090s) [425.097274] Starting dynamic subtest: drm_test_cmdline_res_vesa [425.184785] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.095s) [425.195559] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank [425.290793] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.106s) [425.302056] Starting dynamic subtest: drm_test_cmdline_res_rblank [425.403633] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.112s) [425.414231] Starting dynamic subtest: drm_test_cmdline_res_bpp [425.493474] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.087s) [425.503080] Starting dynamic subtest: drm_test_cmdline_res_refresh [425.575546] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.082s) [425.585995] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh [425.688706] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.112s) [425.700130] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced [425.777577] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.089s) [425.786560] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins [425.883123] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.104s) [425.893063] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off [425.976764] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.094s) [425.985695] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on [426.057538] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.081s) [426.066314] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog [426.157493] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.098s) [426.168235] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital [426.245015] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.086s) [426.253959] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on [426.334925] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.089s) [426.344059] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on [426.433902] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.098s) [426.444940] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins [426.534092] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.099s) [426.543037] Starting dynamic subtest: drm_test_cmdline_name [426.656421] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.121s) [426.665785] Starting dynamic subtest: drm_test_cmdline_name_bpp [426.740291] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.083s) [426.751444] Starting dynamic subtest: drm_test_cmdline_name_option [426.836386] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.096s) [426.848459] Starting dynamic subtest: drm_test_cmdline_name_bpp_option [426.930379] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.092s) [426.941166] Starting dynamic subtest: drm_test_cmdline_rotate_0 [427.042289] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.113s) [427.054878] Starting dynamic subtest: drm_test_cmdline_rotate_90 [427.195321] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.150s) [427.209069] Starting dynamic subtest: drm_test_cmdline_rotate_180 [427.350202] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.155s) [427.359754] Starting dynamic subtest: drm_test_cmdline_rotate_270 [427.501708] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.149s) [427.511370] Starting dynamic subtest: drm_test_cmdline_hmirror [427.627455] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.124s) [427.637449] Starting dynamic subtest: drm_test_cmdline_vmirror [427.757637] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.130s) [427.767402] Starting dynamic subtest: drm_test_cmdline_margin_options [427.897599] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.138s) [427.910951] Starting dynamic subtest: drm_test_cmdline_multiple_options [428.067405] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.168s) [428.079096] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option [428.188868] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.121s) [428.198948] Starting dynamic subtest: drm_test_cmdline_extra_and_option [428.323759] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.134s) [428.335075] Starting dynamic subtest: drm_test_cmdline_freestanding_options [428.447755] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.122s) [428.458843] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options [428.543314] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.092s) [428.554799] Starting dynamic subtest: drm_test_cmdline_panel_orientation [428.647439] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.102s) [428.657074] Starting dynamic subtest: drm_test_cmdline_invalid [428.762727] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.115s) [428.772452] Starting dynamic subtest: drm_test_cmdline_tv_options [428.890091] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.125s) [428.891995] Subtest drm_cmdline_parser: SUCCESS (4.398s) [429.056468] [143/155] (601s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite) [429.160739] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite [429.164772] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [429.250748] [144/155] (601s left) gem_exec_whisper (basic-fds-forked) [429.309887] Starting subtest: basic-fds-forked [453.571557] Subtest basic-fds-forked: SUCCESS (24.202s) [453.707265] [145/155] (577s left) kms_plane_alpha_blend (constant-alpha-max) [453.821233] Starting subtest: constant-alpha-max [454.117084] Starting dynamic subtest: pipe-A-eDP-1 [455.206765] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.089s) [455.218647] Starting dynamic subtest: pipe-D-eDP-1 [456.828120] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.621s) [456.830524] Subtest constant-alpha-max: SUCCESS (3.009s) [457.633093] [146/155] (573s left) gem_exec_endless (dispatch) [457.691125] Starting subtest: dispatch [457.693427] Starting dynamic subtest: rcs0 [457.700318] Dynamic subtest rcs0: SUCCESS (0.006s) [457.711198] Starting dynamic subtest: bcs0 [457.715633] Dynamic subtest bcs0: SUCCESS (0.005s) [457.726595] Starting dynamic subtest: vcs0 [457.731151] Dynamic subtest vcs0: SUCCESS (0.005s) [457.741145] Starting dynamic subtest: vcs1 [457.745206] Dynamic subtest vcs1: SUCCESS (0.006s) [457.754893] Starting dynamic subtest: vecs0 [457.759052] Dynamic subtest vecs0: SUCCESS (0.005s) [457.768983] Starting dynamic subtest: ccs0 [457.773102] Dynamic subtest ccs0: SUCCESS (0.004s) [457.775046] Subtest dispatch: SUCCESS (0.036s) [459.300715] [147/155] (571s left) gem_exec_params (invalid-fence-in-submit) [459.361577] Starting subtest: invalid-fence-in-submit [459.363900] Subtest invalid-fence-in-submit: SUCCESS (0.003s) [459.478264] [148/155] (571s left) gem_exec_create (madvise) [459.539669] Starting subtest: madvise [459.541873] Starting dynamic subtest: smem [480.372082] Dynamic subtest smem: SUCCESS (20.829s) [480.374785] Subtest madvise: SUCCESS (20.830s) [481.082714] [149/155] (550s left) kms_pm_rpm (i2c) [482.612231] Starting subtest: i2c [488.334960] Subtest i2c: SUCCESS (5.725s) [488.422557] [150/155] (542s left) kms_psr (psr2-cursor-render) [488.522070] Starting subtest: psr2-cursor-render [488.524289] Starting dynamic subtest: eDP-1 [490.218609] Dynamic subtest eDP-1: SUCCESS (1.696s) [490.221230] Subtest psr2-cursor-render: SUCCESS (1.697s) [491.103315] [151/155] (540s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions) [491.220610] Starting subtest: cursorB-vs-flipA-atomic-transitions [491.225306] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s) [491.404072] [152/155] (539s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render) [491.505672] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render [491.509758] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [491.605746] [153/155] (539s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs) [491.689438] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs [491.691341] Starting dynamic subtest: pipe-A-eDP-1 [492.130684] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.443s) [492.143643] Starting dynamic subtest: pipe-B-eDP-1 [492.161683] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s) [492.173994] Starting dynamic subtest: pipe-C-eDP-1 [492.190121] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s) [492.200267] Starting dynamic subtest: pipe-D-eDP-1 [492.215927] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s) [492.217644] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.457s) [494.466978] [154/155] (536s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled) [494.519995] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled [494.622062] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.102s) [494.716041] [155/155] (536s left) kms_legacy_colorkey (basic) [494.824286] Starting subtest: basic [494.826521] Starting dynamic subtest: pipe-A [494.867690] Dynamic subtest pipe-A: SUCCESS (0.045s) [494.880503] Starting dynamic subtest: pipe-B [494.882452] Dynamic subtest pipe-B: SUCCESS (0.000s) [494.892586] Starting dynamic subtest: pipe-C [494.894796] Dynamic subtest pipe-C: SUCCESS (0.000s) [494.904869] Starting dynamic subtest: pipe-D [494.907086] Dynamic subtest pipe-D: SUCCESS (0.000s) [494.909251] Subtest basic: SUCCESS (0.049s) [494.944932] Closing watchdogs results: parsing output: 0/ for test: gem_create results: parsing output: 1/ for test: gem_ctx_param results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: gem_render_copy results: parsing output: 4/ for test: kms_frontbuffer_tracking results: parsing output: 5/ for test: vgem_basic results: parsing output: 6/ for test: kms_big_fb results: parsing output: 7/ for test: syncobj_eventfd results: parsing output: 8/ for test: gem_mmap_wc results: parsing output: 9/ for test: kms_chamelium_frames results: parsing output: 10/ for test: gem_spin_batch results: parsing output: 11/ for test: kms_plane_scaling results: parsing output: 12/ for test: gem_userptr_blits results: parsing output: 13/ for test: kms_concurrent results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: kms_psr results: parsing output: 16/ for test: api_intel_allocator results: parsing output: 17/ for test: gem_exec_fence results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: kms_psr results: parsing output: 20/ for test: gem_render_copy results: parsing output: 21/ for test: gem_ctx_param results: parsing output: 22/ for test: kms_plane_scaling results: parsing output: 23/ for test: kms_frontbuffer_tracking results: parsing output: 24/ for test: kms_lease results: parsing output: 25/ for test: kms_cursor_crc results: parsing output: 26/ for test: gem_close_race results: parsing output: 27/ for test: kms_psr results: parsing output: 28/ for test: kms_rotation_crc results: parsing output: 29/ for test: gem_mmap_gtt results: parsing output: 30/ for test: kms_ccs results: parsing output: 31/ for test: kms_cursor_crc results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: kms_flip results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: kms_plane results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: i915_pm_rpm results: parsing output: 39/ for test: kms_addfb_basic results: parsing output: 40/ for test: kms_flip_scaled_crc results: parsing output: 41/ for test: kms_ccs results: parsing output: 42/ for test: syncobj_timeline results: parsing output: 43/ for test: kms_frontbuffer_tracking results: parsing output: 44/ for test: gem_gpgpu_fill results: parsing output: 45/ for test: kms_psr2_sf results: parsing output: 46/ for test: gem_exec_balancer results: parsing output: 47/ for test: gem_workarounds results: parsing output: 48/ for test: kms_content_protection results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: kms_big_fb results: parsing output: 51/ for test: kms_prime results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: i915_drm_fdinfo results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: gem_mmap_gtt results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: gem_madvise results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: syncobj_basic results: parsing output: 64/ for test: kms_frontbuffer_tracking results: parsing output: 65/ for test: gem_wait results: parsing output: 66/ for test: kms_frontbuffer_tracking results: parsing output: 67/ for test: gem_eio results: parsing output: 68/ for test: kms_big_fb results: parsing output: 69/ for test: kms_3d results: parsing output: 70/ for test: syncobj_timeline results: parsing output: 71/ for test: gem_ccs results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: gem_exec_params results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: kms_busy results: parsing output: 76/ for test: gem_eio results: parsing output: 77/ for test: kms_vblank results: parsing output: 78/ for test: kms_psr results: parsing output: 79/ for test: syncobj_wait results: parsing output: 80/ for test: gem_render_copy results: parsing output: 81/ for test: syncobj_wait results: parsing output: 82/ for test: gem_fence_thrash results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: gem_userptr_blits results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: gem_softpin results: parsing output: 87/ for test: kms_flip results: parsing output: 88/ for test: gem_exec_schedule results: parsing output: 89/ for test: gem_userptr_blits results: parsing output: 90/ for test: dumb_buffer results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: kms_flip results: parsing output: 93/ for test: kms_big_fb results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: kms_pipe_b_c_ivb results: parsing output: 96/ for test: kms_chamelium_hpd results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: gem_mmap_wc results: parsing output: 99/ for test: gem_mmap_wc results: parsing output: 100/ for test: gem_exec_reloc results: parsing output: 101/ for test: gen9_exec_parse results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: i915_pm_rps results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: kms_flip results: parsing output: 106/ for test: api_intel_bb results: parsing output: 107/ for test: gem_pipe_control_store_loop results: parsing output: 108/ for test: gem_mmap_offset results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: kms_invalid_mode results: parsing output: 111/ for test: syncobj_wait results: parsing output: 112/ for test: kms_cursor_legacy results: parsing output: 113/ for test: gem_ctx_persistence results: parsing output: 114/ for test: kms_vrr results: parsing output: 115/ for test: kms_properties results: parsing output: 116/ for test: kms_chamelium_color results: parsing output: 117/ for test: kms_big_fb results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: syncobj_wait results: parsing output: 120/ for test: i915_pm_freq_api results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: syncobj_timeline results: parsing output: 123/ for test: kms_ccs results: parsing output: 124/ for test: perf_pmu results: parsing output: 125/ for test: kms_psr2_sf results: parsing output: 126/ for test: kms_vblank results: parsing output: 127/ for test: syncobj_timeline results: parsing output: 128/ for test: kms_feature_discovery results: parsing output: 129/ for test: kms_flip results: parsing output: 130/ for test: gem_exec_schedule results: parsing output: 131/ for test: kms_big_fb results: parsing output: 132/ for test: gem_mmap_gtt results: parsing output: 133/ for test: kms_frontbuffer_tracking results: parsing output: 134/ for test: kms_cursor_edge_walk results: parsing output: 135/ for test: kms_async_flips results: parsing output: 136/ for test: kms_plane_multiple results: parsing output: 137/ for test: kms_frontbuffer_tracking results: parsing output: 138/ for test: kms_frontbuffer_tracking results: parsing output: 139/ for test: gem_unref_active_buffers results: parsing output: 140/ for test: kms_frontbuffer_tracking results: parsing output: 141/ for test: kms_selftest results: parsing output: 142/ for test: kms_frontbuffer_tracking results: parsing output: 143/ for test: gem_exec_whisper results: parsing output: 144/ for test: kms_plane_alpha_blend results: parsing output: 145/ for test: gem_exec_endless results: parsing output: 146/ for test: gem_exec_params results: parsing output: 147/ for test: gem_exec_create results: parsing output: 148/ for test: kms_pm_rpm results: parsing output: 149/ for test: kms_psr results: parsing output: 150/ for test: kms_cursor_legacy results: parsing output: 151/ for test: kms_frontbuffer_tracking results: parsing output: 152/ for test: kms_ccs results: parsing output: 153/ for test: syncobj_timeline results: parsing output: 154/ for test: kms_legacy_colorkey Done.