[57.414832] Initializing watchdogs [57.414881] /dev/watchdog0 [57.429468] [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.433746] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.435948] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.439216] [001/156] (960s left) api_intel_allocator (execbuf-with-allocator) [57.536619] Starting subtest: execbuf-with-allocator [57.547479] Subtest execbuf-with-allocator: SUCCESS (0.013s) [57.673617] [002/156] (960s left) gem_busy (semaphore) [57.859714] Subtest semaphore: SKIP (0.000s) [58.082226] [003/156] (959s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [58.183528] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt [58.187744] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [58.286053] [004/156] (959s left) gem_exec_reloc (basic-wc-read-noreloc) [58.346581] Subtest basic-wc-read-noreloc: SKIP (0.000s) [58.422125] [005/156] (959s left) gem_exec_schedule (promotion) [58.482671] Starting subtest: promotion [58.484997] Starting dynamic subtest: rcs0 [58.576893] Dynamic subtest rcs0: SUCCESS (0.101s) [58.588036] Starting dynamic subtest: vcs0 [58.666750] Dynamic subtest vcs0: SUCCESS (0.090s) [58.680163] Starting dynamic subtest: vcs1 [58.750553] Dynamic subtest vcs1: SUCCESS (0.084s) [58.760927] Starting dynamic subtest: vecs0 [58.831621] Dynamic subtest vecs0: SUCCESS (0.081s) [58.846069] Starting dynamic subtest: ccs0 [58.918966] Dynamic subtest ccs0: SUCCESS (0.086s) [58.921899] Subtest promotion: SUCCESS (0.444s) [60.386096] [006/156] (957s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0) [60.485978] Starting subtest: linear-max-hw-stride-64bpp-rotate-0 [61.616745] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.132s) [61.733649] [007/156] (956s left) perf (global-sseu-config) [61.857869] Starting subtest: global-sseu-config [61.861043] Subtest global-sseu-config: SKIP (0.000s) [61.899353] [008/156] (956s left) gem_exec_balancer (persistence) [62.158761] Starting subtest: persistence [63.087040] Subtest persistence: SUCCESS (0.927s) [63.205028] [009/156] (955s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-render) [63.302249] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-render [63.306781] Subtest psrhdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [63.385970] [010/156] (954s left) gem_ctx_bad_destroy (invalid-default-ctx) [63.435482] Starting subtest: invalid-default-ctx [63.437636] Subtest invalid-default-ctx: SUCCESS (0.000s) [63.494935] [011/156] (954s left) kms_selftest (drm_format_helper) [63.532521] Starting subtest: drm_format_helper [63.552268] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8 [63.654797] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.103s) [63.664409] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332 [63.793381] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.139s) [63.801379] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565 [63.904793] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.110s) [63.912363] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555 [64.022393] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.117s) [64.032916] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555 [64.128077] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.107s) [64.135042] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551 [64.222135] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.093s) [64.230318] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888 [64.318874] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.095s) [64.328281] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888 [64.430194] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.114s) [64.440166] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888 [64.546990] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.115s) [64.555625] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010 [64.643470] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.094s) [64.652882] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010 [64.731568] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.090s) [64.739374] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono [64.827926] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.094s) [64.835130] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab [64.934041] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.105s) [64.942985] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888 [65.038555] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.103s) [65.047979] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888 [65.159179] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.120s) [65.168263] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset [65.248644] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.090s) [65.257428] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy [65.349856] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.100s) [65.351984] Subtest drm_format_helper: SUCCESS (1.817s) [65.520813] [012/156] (952s left) gem_mmap_offset (partial-unmap) [65.569932] Starting subtest: partial-unmap [65.571741] Starting dynamic subtest: smem0 [66.042739] Dynamic subtest smem0: SUCCESS (0.472s) [66.045389] Subtest partial-unmap: SUCCESS (0.472s) [66.143216] [013/156] (952s left) kms_flip (flip-vs-fences-interruptible) [66.248068] Starting subtest: flip-vs-fences-interruptible [66.252300] Subtest flip-vs-fences-interruptible: SKIP (0.000s) [66.353058] [014/156] (952s left) kms_plane_alpha_blend (constant-alpha-mid) [66.445297] Starting subtest: constant-alpha-mid [66.735438] Starting dynamic subtest: pipe-A-eDP-1 [67.595697] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.857s) [67.605945] Starting dynamic subtest: pipe-D-eDP-1 [69.048697] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.451s) [69.051106] Subtest constant-alpha-mid: SUCCESS (2.600s) [69.921769] [015/156] (948s left) gem_exec_reloc (basic-cpu-active) [69.985462] Subtest basic-cpu-active: SKIP (0.000s) [70.069653] [016/156] (948s left) gem_exec_balancer (full-late) [70.130910] Starting subtest: full-late [75.185217] Subtest full-late: SUCCESS (5.054s) [75.496774] [017/156] (943s left) kms_frontbuffer_tracking (fbc-1p-rte) [75.601744] Starting subtest: fbc-1p-rte [81.067034] Subtest fbc-1p-rte: SUCCESS (5.470s) [82.223646] [018/156] (936s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs) [82.313548] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs [82.315593] Starting dynamic subtest: pipe-A-eDP-1 [84.415074] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.103s) [84.422944] Starting dynamic subtest: pipe-B-eDP-1 [86.553487] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.137s) [86.563145] Starting dynamic subtest: pipe-C-eDP-1 [88.582659] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.028s) [88.591985] Starting dynamic subtest: pipe-D-eDP-1 [90.584331] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.000s) [90.586609] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.271s) [91.746138] [019/156] (926s left) kms_vblank (wait-forked-busy-hang) [91.847083] Starting subtest: wait-forked-busy-hang [91.848997] Starting dynamic subtest: pipe-A-eDP-1 [118.089940] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.240s) [118.103746] Starting dynamic subtest: pipe-D-eDP-1 [133.054496] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.961s) [133.056757] Subtest wait-forked-busy-hang: SUCCESS (41.205s) [133.903755] [020/156] (884s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [134.020581] Starting subtest: basic-busy-flip-before-cursor-legacy [134.025248] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [134.196185] [021/156] (884s left) kms_cursor_crc (cursor-rapid-movement-32x10) [134.358880] Starting subtest: cursor-rapid-movement-32x10 [134.403121] Subtest cursor-rapid-movement-32x10: SKIP (0.042s) [134.673046] [022/156] (884s left) prime_vgem (fence-read-hang) [134.768222] Subtest fence-read-hang: SKIP (0.000s) [134.860395] [FACT prime_vgem (fence-read-hang)] new: kernel.kmod_is_loaded.vgem: true [134.863575] [023/156] (883s left) gem_exec_parallel (engines) [134.922302] Starting subtest: engines [134.923886] Starting dynamic subtest: basic [138.307403] Dynamic subtest basic: SUCCESS (3.385s) [138.318439] Starting dynamic subtest: contexts [142.638187] Dynamic subtest contexts: SUCCESS (4.329s) [142.647174] Starting dynamic subtest: fds [146.366686] Dynamic subtest fds: SUCCESS (3.727s) [146.381621] Starting dynamic subtest: userptr [148.292881] Dynamic subtest userptr: SUCCESS (1.924s) [148.295943] Subtest engines: SUCCESS (13.372s) [148.527573] [024/156] (870s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-onoff) [148.633362] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-onoff [148.637430] Subtest fbchdr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [148.739797] [025/156] (870s left) kms_getfb (getfb-handle-protection) [148.829688] Starting subtest: getfb-handle-protection [148.850628] Subtest getfb-handle-protection: SUCCESS (0.023s) [148.979576] [026/156] (869s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling) [149.064356] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling [149.066624] Starting dynamic subtest: pipe-A-default-mode [151.861423] Dynamic subtest pipe-A-default-mode: SUCCESS (2.795s) [151.863928] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.797s) [152.685872] [027/156] (866s left) kms_psr (fbc-psr2-sprite-blt) [152.781702] Starting subtest: fbc-psr2-sprite-blt [152.784033] Starting dynamic subtest: eDP-1 [152.788339] Dynamic subtest eDP-1: SKIP (0.000s) [152.792467] Subtest fbc-psr2-sprite-blt: SKIP (0.001s) [152.853369] [028/156] (866s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render) [152.948814] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render [159.748817] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.806s) [159.907458] [029/156] (859s left) kms_addfb_basic (addfb25-modifier-no-flag) [160.005899] Starting subtest: addfb25-modifier-no-flag [160.008302] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [160.102849] [030/156] (859s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc) [160.191943] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc [160.194286] Starting dynamic subtest: pipe-A-eDP-1 [160.203464] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [160.214025] Starting dynamic subtest: pipe-B-eDP-1 [160.222950] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [160.232037] Starting dynamic subtest: pipe-C-eDP-1 [160.240285] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [160.248630] Starting dynamic subtest: pipe-D-eDP-1 [160.257165] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [160.261268] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s) [162.477040] [031/156] (856s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-blt) [162.567059] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-blt [162.571181] Subtest hdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [162.652485] [032/156] (856s left) perf (gen8-unprivileged-single-ctx-counters) [162.741316] Starting subtest: gen8-unprivileged-single-ctx-counters [162.745974] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s) [162.786451] [033/156] (856s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt) [162.876684] Starting subtest: psr-farfromfence-mmap-gtt [162.880784] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s) [162.970592] [034/156] (856s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite) [163.060108] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite [163.064391] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [163.143613] [035/156] (856s left) gem_partial_pwrite_pread (reads-snoop) [163.196575] Subtest reads-snoop: SKIP (0.000s) [163.261501] [036/156] (856s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf) [163.357414] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf [163.359714] Starting dynamic subtest: pipe-A-eDP-1 [163.451708] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s) [163.461137] Starting dynamic subtest: pipe-B-eDP-1 [164.562261] Dynamic subtest pipe-B-eDP-1: SKIP (1.107s) [164.567097] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.208s) [165.767967] [037/156] (853s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt) [165.862202] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt [165.866460] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [165.951418] [038/156] (853s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc) [166.053367] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc [166.057700] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [166.146410] [039/156] (853s left) kms_psr (fbc-psr-sprite-plane-onoff) [166.233184] Starting subtest: fbc-psr-sprite-plane-onoff [166.235501] Starting dynamic subtest: eDP-1 [166.239999] Dynamic subtest eDP-1: SKIP (0.000s) [166.244530] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s) [166.315939] [040/156] (853s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d) [166.417236] Starting subtest: plane-lut1d-ctm3x4-lut1d [166.585239] Starting dynamic subtest: pipe-A-plane-0 [166.751425] Dynamic subtest pipe-A-plane-0: SUCCESS (0.167s) [166.761371] Starting dynamic subtest: pipe-A-plane-1 [166.906992] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s) [166.918589] Starting dynamic subtest: pipe-A-plane-2 [167.051483] Dynamic subtest pipe-A-plane-2: SUCCESS (0.144s) [168.304234] Starting dynamic subtest: pipe-B-plane-0 [168.493647] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s) [168.502546] Starting dynamic subtest: pipe-B-plane-1 [168.627619] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s) [168.637525] Starting dynamic subtest: pipe-B-plane-2 [168.760454] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s) [169.980959] Starting dynamic subtest: pipe-C-plane-0 [170.106752] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s) [170.116325] Starting dynamic subtest: pipe-C-plane-1 [170.262301] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s) [170.271902] Starting dynamic subtest: pipe-C-plane-2 [170.407051] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s) [171.608810] Starting dynamic subtest: pipe-D-plane-0 [171.746669] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s) [171.755812] Starting dynamic subtest: pipe-D-plane-1 [171.913334] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s) [171.923072] Starting dynamic subtest: pipe-D-plane-2 [172.079404] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s) [172.364465] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (5.948s) [173.182871] [041/156] (846s left) gem_ctx_param (invalid-get-no-zeromap) [173.241683] Starting subtest: invalid-get-no-zeromap [173.243998] Subtest invalid-get-no-zeromap: SUCCESS (0.001s) [173.359924] [042/156] (846s left) kms_psr (psr-primary-mmap-gtt) [173.450716] Starting subtest: psr-primary-mmap-gtt [173.453012] Starting dynamic subtest: eDP-1 [174.876285] Dynamic subtest eDP-1: SKIP (1.422s) [174.880684] Subtest psr-primary-mmap-gtt: SKIP (1.424s) [175.045308] [043/156] (844s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-blt) [175.146891] Starting subtest: hdr-rgb101010-draw-blt [175.151136] Subtest hdr-rgb101010-draw-blt: SKIP (0.000s) [175.249315] [044/156] (844s left) kms_cursor_crc (cursor-onscreen-128x42) [175.475693] Starting subtest: cursor-onscreen-128x42 [175.524613] Subtest cursor-onscreen-128x42: SKIP (0.043s) [175.733274] [045/156] (843s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [175.839034] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu [175.843151] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [175.940175] [046/156] (843s left) kms_setmode (basic) [176.000079] Starting subtest: basic [176.342172] Starting dynamic subtest: pipe-A-eDP-1 [178.435902] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.089s) [178.780264] Starting dynamic subtest: pipe-B-eDP-1 [180.862766] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.090s) [181.173668] Subtest basic: SUCCESS (5.169s) [182.033404] [047/156] (837s left) kms_psr (pr-cursor-mmap-cpu) [182.128085] Starting subtest: pr-cursor-mmap-cpu [182.132473] Subtest pr-cursor-mmap-cpu: SKIP (0.000s) [182.205942] [048/156] (837s left) gem_exec_schedule (preempt-queue) [182.281106] Subtest preempt-queue: SKIP (0.000s) [182.565189] [049/156] (837s left) kms_frontbuffer_tracking (hdr-2p-primscrn-shrfb-plflip-blt) [182.658489] Starting subtest: hdr-2p-primscrn-shrfb-plflip-blt [182.662802] Subtest hdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [182.748517] [050/156] (837s left) gem_userptr_blits (map-fixed-invalidate) [182.808974] Starting subtest: map-fixed-invalidate [182.813063] Subtest map-fixed-invalidate: SKIP (0.000s) [182.949196] [051/156] (837s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt) [183.064172] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt [183.068450] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [183.184646] [052/156] (836s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping) [183.277522] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping [183.281534] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s) [183.351450] [053/156] (836s left) gem_ctx_shared (q-out-order) [183.413155] Starting subtest: Q-out-order [183.415535] Starting dynamic subtest: rcs0 [183.527872] Dynamic subtest rcs0: SUCCESS (0.112s) [183.541601] Starting dynamic subtest: vcs0 [183.639734] Dynamic subtest vcs0: SUCCESS (0.112s) [183.651847] Starting dynamic subtest: vcs1 [183.733180] Dynamic subtest vcs1: SUCCESS (0.093s) [183.749862] Starting dynamic subtest: vecs0 [183.823857] Dynamic subtest vecs0: SUCCESS (0.090s) [183.841679] Starting dynamic subtest: ccs0 [183.912626] Dynamic subtest ccs0: SUCCESS (0.087s) [183.915085] Subtest Q-out-order: SUCCESS (0.500s) [185.381420] [054/156] (834s left) i915_pm_rps (engine-order) [185.442746] Starting subtest: engine-order [190.362405] Subtest engine-order: SUCCESS (4.921s) [190.479769] [055/156] (829s left) kms_frontbuffer_tracking (fbchdr-tiling-linear) [190.594233] Starting subtest: fbchdr-tiling-linear [190.598514] Subtest fbchdr-tiling-linear: SKIP (0.000s) [190.690998] [056/156] (829s left) gem_pxp (create-protected-buffer) [190.814079] Starting subtest: create-protected-buffer [190.816560] Subtest create-protected-buffer: SUCCESS (0.000s) [190.934119] [057/156] (829s left) syncobj_eventfd (binary-wait) [191.000536] Starting subtest: binary-wait [191.010948] Subtest binary-wait: SUCCESS (0.010s) [191.085175] [058/156] (829s left) kms_prop_blob (basic) [191.139247] Starting subtest: basic [191.141587] Subtest basic: SUCCESS (0.000s) [191.236580] [059/156] (829s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen) [191.336361] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen [191.340348] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [191.430419] [060/156] (828s left) gem_create (create-invalid-size) [191.480757] Starting subtest: create-invalid-size [191.482887] Subtest create-invalid-size: SUCCESS (0.000s) [191.667665] [061/156] (828s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt) [191.759082] Starting subtest: fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt [191.763320] Subtest fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [191.876655] [062/156] (828s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt) [191.977225] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt [191.981502] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [192.082770] [063/156] (828s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [192.175775] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [192.955885] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.781s) [193.129505] [064/156] (827s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling) [193.217083] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling [193.219247] Starting dynamic subtest: pipe-A-default-mode [194.383610] Dynamic subtest pipe-A-default-mode: SKIP (1.163s) [194.387758] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.165s) [194.533410] [065/156] (826s left) i915_pm_rps (thresholds-park) [194.601841] Starting subtest: thresholds-park [194.605730] Subtest thresholds-park: SKIP (0.001s) [194.702418] [066/156] (825s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt) [194.799550] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt [194.803852] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [194.899925] [067/156] (825s left) gem_ctx_persistence (userptr) [194.949379] Starting subtest: userptr [195.137356] Subtest userptr: SUCCESS (0.187s) [195.216412] [068/156] (825s left) sw_sync (alloc_timeline) [195.250470] Starting subtest: alloc_timeline [195.252684] Subtest alloc_timeline: SUCCESS (0.000s) [195.301243] [069/156] (825s left) gem_eio (unwedge-stress) [195.521742] Starting subtest: unwedge-stress [195.523803] Starting dynamic subtest: render [200.275161] Dynamic subtest render: SUCCESS (4.750s) [200.291400] Starting dynamic subtest: bsd1 [218.764694] Dynamic subtest bsd1: SUCCESS (18.488s) [218.779643] Starting dynamic subtest: bsd2 [236.778852] Dynamic subtest bsd2: SUCCESS (18.013s) [236.796075] Starting dynamic subtest: blt [236.799966] Dynamic subtest blt: SKIP (0.000s) [236.808955] Starting dynamic subtest: vebox [254.747212] Dynamic subtest vebox: SUCCESS (17.967s) [254.749299] Subtest unwedge-stress: SUCCESS (59.222s) [256.361674] [070/156] (764s left) kms_ccs (random-ccs-data-yf-tiled-ccs) [256.458070] Starting subtest: random-ccs-data-yf-tiled-ccs [256.460339] Starting dynamic subtest: pipe-A-eDP-1 [256.485511] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [256.496748] Starting dynamic subtest: pipe-B-eDP-1 [256.520907] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [256.530180] Starting dynamic subtest: pipe-C-eDP-1 [256.554353] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [256.563438] Starting dynamic subtest: pipe-D-eDP-1 [256.590695] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [256.595193] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.004s) [258.702987] [071/156] (762s left) gem_madvise (dontneed-after-mmap) [258.739290] Starting subtest: dontneed-after-mmap [258.761847] Subtest dontneed-after-mmap: SUCCESS (0.024s) [258.863680] [072/156] (761s left) gem_spin_batch (resubmit-new) [258.930349] Starting subtest: resubmit-new [258.932780] Starting dynamic subtest: rcs0 [258.938082] Dynamic subtest rcs0: SUCCESS (0.007s) [258.947904] Starting dynamic subtest: bcs0 [258.949851] Dynamic subtest bcs0: SUCCESS (0.005s) [258.959330] Starting dynamic subtest: vcs0 [258.961623] Dynamic subtest vcs0: SUCCESS (0.007s) [258.971067] Starting dynamic subtest: vcs1 [258.972868] Dynamic subtest vcs1: SUCCESS (0.004s) [258.982571] Starting dynamic subtest: vecs0 [258.984432] Dynamic subtest vecs0: SUCCESS (0.005s) [258.992991] Starting dynamic subtest: ccs0 [258.994883] Dynamic subtest ccs0: SUCCESS (0.005s) [258.996764] Subtest resubmit-new: SUCCESS (0.038s) [260.338978] [073/156] (760s left) syncobj_basic (create-signaled) [260.395631] Starting subtest: create-signaled [260.398079] Subtest create-signaled: SUCCESS (0.000s) [260.520164] [074/156] (760s left) kms_pm_dc (dc5-dpms-negative) [261.625043] Starting subtest: dc5-dpms-negative [261.629719] Subtest dc5-dpms-negative: SKIP (0.000s) [261.711160] [075/156] (759s left) syncobj_timeline (single-wait-all-signaled) [261.761587] Starting subtest: single-wait-all-signaled [261.764054] Subtest single-wait-all-signaled: SUCCESS (0.000s) [261.859121] [076/156] (759s left) gem_workarounds (suspend-resume) [261.930222] Starting subtest: suspend-resume [278.138734] Subtest suspend-resume: SUCCESS (2.043s) [278.263200] [077/156] (742s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt) [278.394644] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt [278.399042] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [278.491806] [078/156] (742s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs) [278.587231] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs [278.589540] Starting dynamic subtest: pipe-A-eDP-1 [278.846134] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.226s) [278.858676] Starting dynamic subtest: pipe-B-eDP-1 [280.169035] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.319s) [280.181577] Starting dynamic subtest: pipe-C-eDP-1 [281.380205] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.209s) [281.391781] Starting dynamic subtest: pipe-D-eDP-1 [282.605522] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.227s) [282.607813] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.987s) [283.742652] [079/156] (737s left) dumb_buffer (create-clear) [283.809367] Starting subtest: create-clear [318.028065] Subtest create-clear: SUCCESS (34.206s) [318.128467] [080/156] (703s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-pwrite) [318.234739] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-pwrite [318.238788] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [318.336151] [081/156] (702s left) gem_ctx_engines (none) [318.393868] Starting subtest: none [318.396567] Subtest none: SUCCESS (0.001s) [318.606966] [082/156] (702s left) syncobj_timeline (device-submit-unordered) [318.661146] Starting subtest: device-submit-unordered [318.663375] Subtest device-submit-unordered: SUCCESS (0.001s) [318.783306] [083/156] (702s left) kms_debugfs (display-on-read-all) [318.881928] Starting subtest: display-on-read-all [319.048062] Subtest display-on-read-all: SUCCESS (0.168s) [319.172415] [084/156] (702s left) kms_psr (fbc-pr-dpms) [319.279389] Starting subtest: fbc-pr-dpms [319.283371] Subtest fbc-pr-dpms: SKIP (0.000s) [319.350922] [085/156] (702s left) gem_exec_fence (syncobj-invalid-wait) [319.752328] Starting subtest: syncobj-invalid-wait [319.754613] Subtest syncobj-invalid-wait: SUCCESS (0.001s) [321.500409] [086/156] (699s left) sw_sync (sync_multi_timeline_wait) [321.536906] Starting subtest: sync_multi_timeline_wait [321.539409] Subtest sync_multi_timeline_wait: SUCCESS (0.001s) [321.590615] [087/156] (699s left) prime_self_import (reimport-vs-gem_close-race) [321.625551] Starting subtest: reimport-vs-gem_close-race [326.707597] Subtest reimport-vs-gem_close-race: SUCCESS (5.082s) [326.783101] [088/156] (694s left) kms_rmfb (rmfb-ioctl) [326.873116] Starting subtest: rmfb-ioctl [326.875438] Starting dynamic subtest: pipe-A-eDP-1 [326.976974] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.105s) [326.989658] Starting dynamic subtest: pipe-B-eDP-1 [328.200227] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.222s) [328.211314] Starting dynamic subtest: pipe-C-eDP-1 [329.426778] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.225s) [329.437099] Starting dynamic subtest: pipe-D-eDP-1 [330.654133] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.226s) [330.656424] Subtest rmfb-ioctl: SUCCESS (3.783s) [331.873317] [089/156] (689s left) syncobj_timeline (invalid-multi-wait-unsubmitted) [331.932651] Starting subtest: invalid-multi-wait-unsubmitted [331.935035] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [332.034080] [090/156] (689s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-pwrite) [332.138343] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-pwrite [332.142669] Subtest hdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [332.244158] [091/156] (689s left) syncobj_timeline (multi-wait-all-available-submitted) [332.294793] Starting subtest: multi-wait-all-available-submitted [332.296659] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s) [332.396452] [092/156] (689s left) syncobj_timeline (multi-wait-all-signaled) [332.450971] Starting subtest: multi-wait-all-signaled [332.453315] Subtest multi-wait-all-signaled: SUCCESS (0.001s) [332.565613] [093/156] (689s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render) [332.660524] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render [332.664940] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [332.766500] [094/156] (689s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [332.868270] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [332.871809] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [332.971428] [095/156] (688s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling) [333.060388] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling [333.064176] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s) [333.131363] [096/156] (688s left) kms_chamelium_frames (dp-crc-fast) [333.507264] Subtest dp-crc-fast: SKIP (0.000s) [334.301740] [097/156] (687s left) kms_content_protection (dp-mst-type-1-suspend-resume) [334.441258] Starting subtest: dp-mst-type-1-suspend-resume [334.445325] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s) [334.575708] [098/156] (687s left) perf_pmu (most-busy-idle-check-all) [334.614738] Starting subtest: most-busy-idle-check-all [334.617217] Starting dynamic subtest: rcs0 [336.465933] Dynamic subtest rcs0: SUCCESS (1.849s) [336.479981] Starting dynamic subtest: bcs0 [338.450668] Dynamic subtest bcs0: SUCCESS (1.982s) [338.464746] Starting dynamic subtest: vcs0 [340.434642] Dynamic subtest vcs0: SUCCESS (1.980s) [340.449516] Starting dynamic subtest: vcs1 [342.485749] Dynamic subtest vcs1: SUCCESS (2.047s) [342.501047] Starting dynamic subtest: vecs0 [344.466564] Dynamic subtest vecs0: SUCCESS (1.977s) [344.480332] Starting dynamic subtest: ccs0 [346.450881] Dynamic subtest ccs0: SUCCESS (1.981s) [346.454044] Subtest most-busy-idle-check-all: SUCCESS (11.835s) [346.572689] [099/156] (675s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe) [346.960198] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s) [347.825675] [100/156] (674s left) kms_async_flips (invalid-async-flip-atomic) [347.923960] Starting subtest: invalid-async-flip-atomic [348.299238] Starting dynamic subtest: pipe-A-eDP-1 [349.162667] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.866s) [349.524833] Starting dynamic subtest: pipe-B-eDP-1 [350.399064] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.883s) [350.756174] Starting dynamic subtest: pipe-C-eDP-1 [351.524109] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.776s) [351.883020] Starting dynamic subtest: pipe-D-eDP-1 [352.645355] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.776s) [352.647744] Subtest invalid-async-flip-atomic: SUCCESS (4.721s) [353.817426] [101/156] (668s left) gem_eio (wait-immediate) [353.998211] Starting subtest: wait-immediate [354.294121] Subtest wait-immediate: SUCCESS (0.296s) [354.450926] [102/156] (667s left) gem_exec_whisper (basic-contexts-forked-all) [354.510818] Starting subtest: basic-contexts-forked-all [375.466039] Subtest basic-contexts-forked-all: SUCCESS (20.951s) [375.652313] [103/156] (646s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt) [375.770626] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt [380.394300] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.631s) [381.598977] [104/156] (640s left) kms_invalid_mode (bad-vtotal) [381.696542] Starting subtest: bad-vtotal [381.698882] Starting dynamic subtest: pipe-A-eDP-1 [381.985561] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s) [381.996619] Starting dynamic subtest: pipe-B-eDP-1 [381.998589] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [382.008947] Starting dynamic subtest: pipe-C-eDP-1 [382.011777] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [382.022707] Starting dynamic subtest: pipe-D-eDP-1 [382.025048] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [382.027413] Subtest bad-vtotal: SUCCESS (0.296s) [382.819864] [105/156] (639s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt) [382.920273] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt [382.924656] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [383.010475] [106/156] (639s left) sw_sync (sync_random_merge) [383.048073] Starting subtest: sync_random_merge [383.089273] Subtest sync_random_merge: SUCCESS (0.045s) [383.152430] [107/156] (639s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy) [383.269529] Starting subtest: flip-vs-cursor-busy-crc-legacy [383.974826] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.704s) [384.854227] [108/156] (637s left) gem_mmap_gtt (basic-small-bo-tiledx) [384.916789] Subtest basic-small-bo-tiledX: SKIP (0.000s) [384.985288] [109/156] (637s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc) [385.076301] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc [385.080604] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [385.169706] [110/156] (637s left) gem_softpin (32b-excludes-last-page) [385.216315] Starting subtest: 32b-excludes-last-page [385.221136] Subtest 32b-excludes-last-page: SUCCESS (0.003s) [385.344865] [111/156] (637s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-pwrite) [385.447956] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-pwrite [385.452574] Subtest psrhdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [385.533790] [112/156] (637s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move) [385.632545] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move [393.021912] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.394s) [393.157362] [113/156] (629s left) gem_lmem_swapping (smem-oom) [393.212523] Subtest smem-oom: SKIP (0.000s) [393.277732] [114/156] (629s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [393.376644] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip [393.381160] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [393.477448] [115/156] (629s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing) [393.567965] Starting subtest: plane-all-transition-nonblocking-fencing [393.570269] Starting dynamic subtest: pipe-A-eDP-1 [396.062902] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.497s) [396.378452] Starting dynamic subtest: pipe-B-eDP-1 [399.631658] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.271s) [399.928592] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.362s) [400.730632] [116/156] (621s left) kms_addfb_basic (invalid-smem-bo-on-discrete) [400.794494] Starting subtest: invalid-smem-bo-on-discrete [400.799134] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s) [400.965026] [117/156] (621s left) i915_drm_fdinfo (memory-info-shared) [401.004974] Starting subtest: memory-info-shared [401.007383] Starting dynamic subtest: smem0 [401.061308] Dynamic subtest smem0: SUCCESS (0.059s) [401.063818] Subtest memory-info-shared: SUCCESS (0.060s) [401.138476] [118/156] (621s left) gem_userptr_blits (invalid-mmap-offset-unsync) [401.198452] Subtest invalid-mmap-offset-unsync: SKIP (0.000s) [401.343439] [119/156] (621s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [401.441660] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt [401.446053] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [401.542479] [120/156] (621s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-indfb-plflip-blt) [401.637854] Starting subtest: fbcpsrhdr-2p-primscrn-indfb-plflip-blt [401.641990] Subtest fbcpsrhdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [401.740081] [121/156] (621s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [401.846704] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip [402.671439] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.826s) [402.843514] [122/156] (620s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-indfb-plflip-blt) [402.945889] Starting subtest: psrhdr-1p-primscrn-indfb-plflip-blt [402.949989] Subtest psrhdr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s) [403.041661] [123/156] (619s left) kms_cursor_legacy (cursor-vs-flip-varying-size) [403.159993] Starting subtest: cursor-vs-flip-varying-size [434.442855] Subtest cursor-vs-flip-varying-size: SUCCESS (31.279s) [435.259912] [124/156] (587s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [435.367987] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip [435.372240] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s) [435.465686] [125/156] (587s left) kms_pm_backlight (fade) [435.556187] Starting subtest: fade [435.604076] Starting dynamic subtest: eDP-1 [438.602993] Dynamic subtest eDP-1: SUCCESS (2.997s) [438.605514] Subtest fade: SUCCESS (3.048s) [439.501295] [126/156] (583s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [439.606060] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt [439.610728] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [439.711646] [127/156] (583s left) gem_pxp (reject-modify-context-protection-on) [439.810880] Starting subtest: reject-modify-context-protection-on [439.813302] Subtest reject-modify-context-protection-on: SUCCESS (0.001s) [439.917666] [128/156] (583s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt) [440.013821] Starting subtest: psr-1p-primscrn-indfb-msflip-blt [447.293442] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.285s) [447.420447] [129/156] (575s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-move) [447.529221] Starting subtest: fbchdr-2p-primscrn-cur-indfb-move [447.533485] Subtest fbchdr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [447.662172] [130/156] (575s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size) [447.783438] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size [447.787982] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s) [447.928480] [131/156] (575s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf) [448.035287] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf [448.039642] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s) [448.102844] [132/156] (575s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-blt) [448.207591] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-blt [448.211667] Subtest fbchdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [448.321048] [133/156] (575s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-render) [448.417703] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-render [448.420959] Subtest fbchdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s) [448.514505] [134/156] (575s left) gem_lmem_swapping (heavy-verify-random) [448.559052] Subtest heavy-verify-random: SKIP (0.000s) [448.600594] [135/156] (574s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt) [448.701119] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt [448.704499] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [448.795691] [136/156] (574s left) sysfs_timeslice_duration (timeout) [448.839153] Starting subtest: timeout [448.841109] Starting dynamic subtest: vecs0 [458.442900] Dynamic subtest vecs0: SUCCESS (9.599s) [458.455877] Starting dynamic subtest: ccs0 [459.697743] Dynamic subtest ccs0: SUCCESS (1.254s) [459.713580] Starting dynamic subtest: vcs0 [469.454886] Dynamic subtest vcs0: SUCCESS (9.751s) [469.466653] Starting dynamic subtest: bcs0 [470.041794] Dynamic subtest bcs0: SUCCESS (0.585s) [470.053287] Starting dynamic subtest: rcs0 [471.288569] Dynamic subtest rcs0: SUCCESS (1.247s) [471.298930] Starting dynamic subtest: vcs1 [480.462930] Dynamic subtest vcs1: SUCCESS (9.170s) [480.465768] Subtest timeout: SUCCESS (31.618s) [480.541457] [137/156] (543s left) i915_pm_freq_api (freq-reset) [480.600877] Starting subtest: freq-reset [480.603420] Starting dynamic subtest: gt0 [480.792284] Dynamic subtest gt0: SUCCESS (0.188s) [480.803525] Starting dynamic subtest: gt1 [480.949857] Dynamic subtest gt1: SUCCESS (0.157s) [480.952768] Subtest freq-reset: SUCCESS (0.348s) [481.050935] [138/156] (542s left) kms_atomic_interruptible (legacy-cursor) [481.151353] Starting subtest: legacy-cursor [481.153670] Starting dynamic subtest: pipe-A-eDP-1 [488.536331] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.385s) [488.538841] Subtest legacy-cursor: SUCCESS (7.387s) [489.388097] [139/156] (534s left) kms_frontbuffer_tracking (fbcpsrhdr-stridechange) [489.489571] Starting subtest: fbcpsrhdr-stridechange [489.493951] Subtest fbcpsrhdr-stridechange: SKIP (0.000s) [489.596902] [140/156] (534s left) kms_cursor_crc (cursor-sliding-max-size) [489.912639] Starting subtest: cursor-sliding-max-size [489.919201] Subtest cursor-sliding-max-size: SKIP (0.000s) [490.062957] [141/156] (533s left) kms_flip (dpms-off-confusion) [490.153269] Starting subtest: dpms-off-confusion [490.158245] Starting dynamic subtest: A-eDP1 [498.806176] Dynamic subtest A-eDP1: SUCCESS (8.647s) [498.818745] Starting dynamic subtest: B-eDP1 [507.533381] Dynamic subtest B-eDP1: SUCCESS (8.727s) [507.545109] Starting dynamic subtest: C-eDP1 [516.172217] Dynamic subtest C-eDP1: SUCCESS (8.638s) [516.184780] Starting dynamic subtest: D-eDP1 [524.895668] Dynamic subtest D-eDP1: SUCCESS (8.723s) [524.900755] Subtest dpms-off-confusion: SUCCESS (34.746s) [526.089553] [142/156] (497s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-mmap-wc) [526.181614] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-mmap-wc [526.186048] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [526.303652] [143/156] (497s left) kms_lease (page-flip-implicit-plane) [526.396858] Starting subtest: page-flip-implicit-plane [526.399089] Starting dynamic subtest: pipe-A-eDP-1 [526.878744] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.481s) [526.889445] Starting dynamic subtest: pipe-B-eDP-1 [527.999531] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.119s) [528.010656] Starting dynamic subtest: pipe-C-eDP-1 [529.101162] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.101s) [529.113758] Starting dynamic subtest: pipe-D-eDP-1 [530.237571] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.133s) [530.239976] Subtest page-flip-implicit-plane: SUCCESS (3.840s) [531.081201] [144/156] (492s left) kms_cursor_legacy (cursora-vs-flipa-atomic) [531.206512] Starting subtest: cursorA-vs-flipA-atomic [542.334280] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.127s) [543.207490] [145/156] (480s left) syncobj_wait (wait-any-interrupted) [543.262226] Starting subtest: wait-any-interrupted [543.366093] Subtest wait-any-interrupted: SUCCESS (0.102s) [543.444539] [146/156] (480s left) gen9_exec_parse (secure-batches) [543.499598] Subtest secure-batches: SKIP (0.000s) [543.574396] [147/156] (480s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc) [543.663853] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc [543.666192] Starting dynamic subtest: pipe-A-eDP-1 [543.689068] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [543.701484] Starting dynamic subtest: pipe-B-eDP-1 [543.723362] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [543.734181] Starting dynamic subtest: pipe-C-eDP-1 [543.756299] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [543.766638] Starting dynamic subtest: pipe-D-eDP-1 [543.788523] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [543.792602] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s) [545.968127] [148/156] (478s left) kms_feature_discovery (chamelium) [546.070808] Starting subtest: chamelium [546.075287] Subtest chamelium: SKIP (0.000s) [546.142804] [149/156] (478s left) kms_psr (psr-dpms) [546.224944] Starting subtest: psr-dpms [546.227187] Starting dynamic subtest: eDP-1 [549.205391] Dynamic subtest eDP-1: SUCCESS (2.982s) [549.207877] Subtest psr-dpms: SUCCESS (2.983s) [550.084194] [150/156] (474s left) api_intel_bb (destroy-bb) [550.137246] Starting subtest: destroy-bb [550.145739] Subtest destroy-bb: SUCCESS (0.008s) [550.265501] [151/156] (473s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled) [550.321608] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled [550.323804] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s) [550.424020] [152/156] (473s left) gem_userptr_blits (access-control) [550.496447] Starting subtest: access-control [550.500755] Subtest access-control: SKIP (0.000s) [550.635668] [153/156] (473s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier) [550.724085] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier [550.728038] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s) [550.807985] [154/156] (473s left) kms_big_fb (4-tiled-32bpp-rotate-270) [550.909219] Starting subtest: 4-tiled-32bpp-rotate-270 [550.928558] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.018s) [551.040482] [155/156] (473s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers) [551.145560] Starting subtest: plane-scaler-with-clipping-clamping-modifiers [551.147573] Starting dynamic subtest: pipe-A [551.483770] Dynamic subtest pipe-A: SUCCESS (0.340s) [551.494611] Starting dynamic subtest: pipe-B [552.886409] Dynamic subtest pipe-B: SUCCESS (1.401s) [552.897385] Starting dynamic subtest: pipe-C [554.304043] Dynamic subtest pipe-C: SUCCESS (1.416s) [554.317567] Starting dynamic subtest: pipe-D [555.729449] Dynamic subtest pipe-D: SUCCESS (1.425s) [555.731807] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.586s) [556.912650] [156/156] (467s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu) [557.021068] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu [557.025522] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [557.109608] Closing watchdogs results: parsing output: 0/ for test: api_intel_allocator results: parsing output: 1/ for test: gem_busy results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: gem_exec_reloc results: parsing output: 4/ for test: gem_exec_schedule results: parsing output: 5/ for test: kms_big_fb results: parsing output: 6/ for test: perf results: parsing output: 7/ for test: gem_exec_balancer results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: gem_ctx_bad_destroy results: parsing output: 10/ for test: kms_selftest results: parsing output: 11/ for test: gem_mmap_offset results: parsing output: 12/ for test: kms_flip results: parsing output: 13/ for test: kms_plane_alpha_blend results: parsing output: 14/ for test: gem_exec_reloc results: parsing output: 15/ for test: gem_exec_balancer results: parsing output: 16/ for test: kms_frontbuffer_tracking results: parsing output: 17/ for test: kms_ccs results: parsing output: 18/ for test: kms_vblank results: parsing output: 19/ for test: kms_cursor_legacy results: parsing output: 20/ for test: kms_cursor_crc results: parsing output: 21/ for test: prime_vgem results: parsing output: 22/ for test: gem_exec_parallel results: parsing output: 23/ for test: kms_frontbuffer_tracking results: parsing output: 24/ for test: kms_getfb results: parsing output: 25/ for test: kms_flip_scaled_crc results: parsing output: 26/ for test: kms_psr results: parsing output: 27/ for test: kms_frontbuffer_tracking results: parsing output: 28/ for test: kms_addfb_basic results: parsing output: 29/ for test: kms_ccs results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: perf results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: kms_frontbuffer_tracking results: parsing output: 34/ for test: gem_partial_pwrite_pread results: parsing output: 35/ for test: kms_psr2_sf results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: kms_psr results: parsing output: 39/ for test: kms_color_pipeline results: parsing output: 40/ for test: gem_ctx_param results: parsing output: 41/ for test: kms_psr results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: kms_cursor_crc results: parsing output: 44/ for test: kms_frontbuffer_tracking results: parsing output: 45/ for test: kms_setmode results: parsing output: 46/ for test: kms_psr results: parsing output: 47/ for test: gem_exec_schedule results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: gem_userptr_blits results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: kms_plane results: parsing output: 52/ for test: gem_ctx_shared results: parsing output: 53/ for test: i915_pm_rps results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: gem_pxp results: parsing output: 56/ for test: syncobj_eventfd results: parsing output: 57/ for test: kms_prop_blob results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: gem_create results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: kms_frontbuffer_tracking results: parsing output: 62/ for test: kms_big_fb results: parsing output: 63/ for test: kms_flip_scaled_crc results: parsing output: 64/ for test: i915_pm_rps results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: gem_ctx_persistence results: parsing output: 67/ for test: sw_sync results: parsing output: 68/ for test: gem_eio results: parsing output: 69/ for test: kms_ccs results: parsing output: 70/ for test: gem_madvise results: parsing output: 71/ for test: gem_spin_batch results: parsing output: 72/ for test: syncobj_basic results: parsing output: 73/ for test: kms_pm_dc results: parsing output: 74/ for test: syncobj_timeline results: parsing output: 75/ for test: gem_workarounds results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: kms_ccs results: parsing output: 78/ for test: dumb_buffer results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: gem_ctx_engines results: parsing output: 81/ for test: syncobj_timeline results: parsing output: 82/ for test: kms_debugfs results: parsing output: 83/ for test: kms_psr results: parsing output: 84/ for test: gem_exec_fence results: parsing output: 85/ for test: sw_sync results: parsing output: 86/ for test: prime_self_import results: parsing output: 87/ for test: kms_rmfb results: parsing output: 88/ for test: syncobj_timeline results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: syncobj_timeline results: parsing output: 91/ for test: syncobj_timeline results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: kms_big_fb results: parsing output: 94/ for test: kms_flip_scaled_crc results: parsing output: 95/ for test: kms_chamelium_frames results: parsing output: 96/ for test: kms_content_protection results: parsing output: 97/ for test: perf_pmu results: parsing output: 98/ for test: kms_chamelium_hpd results: parsing output: 99/ for test: kms_async_flips results: parsing output: 100/ for test: gem_eio results: parsing output: 101/ for test: gem_exec_whisper results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: kms_invalid_mode results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: sw_sync results: parsing output: 106/ for test: kms_cursor_legacy results: parsing output: 107/ for test: gem_mmap_gtt results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: gem_softpin results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: gem_lmem_swapping results: parsing output: 113/ for test: kms_big_fb results: parsing output: 114/ for test: kms_atomic_transition results: parsing output: 115/ for test: kms_addfb_basic results: parsing output: 116/ for test: i915_drm_fdinfo results: parsing output: 117/ for test: gem_userptr_blits results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: kms_big_fb results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: kms_cursor_legacy results: parsing output: 123/ for test: kms_big_fb results: parsing output: 124/ for test: kms_pm_backlight results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: gem_pxp results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: kms_cursor_legacy results: parsing output: 130/ for test: kms_psr2_sf results: parsing output: 131/ for test: kms_frontbuffer_tracking results: parsing output: 132/ for test: kms_frontbuffer_tracking results: parsing output: 133/ for test: gem_lmem_swapping results: parsing output: 134/ for test: kms_frontbuffer_tracking results: parsing output: 135/ for test: sysfs_timeslice_duration results: parsing output: 136/ for test: i915_pm_freq_api results: parsing output: 137/ for test: kms_atomic_interruptible results: parsing output: 138/ for test: kms_frontbuffer_tracking results: parsing output: 139/ for test: kms_cursor_crc results: parsing output: 140/ for test: kms_flip results: parsing output: 141/ for test: kms_frontbuffer_tracking results: parsing output: 142/ for test: kms_lease results: parsing output: 143/ for test: kms_cursor_legacy results: parsing output: 144/ for test: syncobj_wait results: parsing output: 145/ for test: gen9_exec_parse results: parsing output: 146/ for test: kms_ccs results: parsing output: 147/ for test: kms_feature_discovery results: parsing output: 148/ for test: kms_psr results: parsing output: 149/ for test: api_intel_bb results: parsing output: 150/ for test: syncobj_wait results: parsing output: 151/ for test: gem_userptr_blits results: parsing output: 152/ for test: kms_plane results: parsing output: 153/ for test: kms_big_fb results: parsing output: 154/ for test: kms_plane_scaling results: parsing output: 155/ for test: kms_frontbuffer_tracking Done.