[61.070138] Initializing watchdogs [61.070183] /dev/watchdog0 [61.090689] [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] [61.096453] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [61.100205] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [61.104224] [001/134] (960s left) syncobj_timeline (invalid-wait-bad-flags) [61.179958] Starting subtest: invalid-wait-bad-flags [61.182388] Subtest invalid-wait-bad-flags: SUCCESS (0.000s) [61.302912] [002/134] (960s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render) [61.406812] Starting subtest: fbcpsr-rgb101010-draw-render [68.147907] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.798s) [68.315502] [003/134] (953s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode) [68.713957] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s) [69.492756] [004/134] (952s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt) [69.596978] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt [69.601295] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [69.763881] [005/134] (952s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc) [69.865788] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc [69.868056] Starting dynamic subtest: pipe-A-eDP-1 [70.736982] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.867s) [70.746111] Starting dynamic subtest: pipe-B-eDP-1 [72.357075] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.622s) [72.365588] Starting dynamic subtest: pipe-C-eDP-1 [73.855681] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.503s) [73.863200] Starting dynamic subtest: pipe-D-eDP-1 [75.387087] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.534s) [75.388967] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.529s) [76.634687] [006/134] (945s left) kms_big_fb (yf-tiled-16bpp-rotate-270) [76.750372] Starting subtest: yf-tiled-16bpp-rotate-270 [76.754330] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s) [76.864893] [007/134] (944s left) kms_async_flips (alternate-sync-async-flip-atomic) [76.958934] Starting subtest: alternate-sync-async-flip-atomic [77.330761] Starting dynamic subtest: pipe-A-eDP-1 [78.732103] Dynamic subtest pipe-A-eDP-1: FAIL (0.812s) [78.741708] Starting dynamic subtest: pipe-B-eDP-1 [79.607200] Dynamic subtest pipe-B-eDP-1: FAIL (0.737s) [79.619935] Starting dynamic subtest: pipe-C-eDP-1 [82.385940] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.773s) [82.749383] Starting dynamic subtest: pipe-D-eDP-1 [85.515080] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.770s) [85.517150] Subtest alternate-sync-async-flip-atomic: FAIL (8.564s) [86.701258] [008/134] (935s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area) [91.756929] Starting subtest: pr-primary-plane-update-sf-dmg-area [91.761735] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.002s) [92.614452] [009/134] (929s left) gem_exec_reloc (basic-write-cpu) [92.686845] Subtest basic-write-cpu: SKIP (0.000s) [92.759786] [010/134] (929s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render) [92.858427] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render [100.194349] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.339s) [100.342411] [011/134] (921s left) gem_exec_flush (basic-wb-rw-before-default) [100.404304] Starting subtest: basic-wb-rw-before-default [105.858755] Subtest basic-wb-rw-before-default: SUCCESS (5.454s) [106.053946] [012/134] (915s left) kms_colorop (plane-xr30-xr30-pq_125_eotf-pq_125_inv_eotf) [106.197206] Subtest plane-XR30-XR30-pq_125_eotf-pq_125_inv_eotf: SKIP (0.000s) [106.284951] [013/134] (915s left) syncobj_timeline (invalid-signal-bad-pad) [106.344155] Starting subtest: invalid-signal-bad-pad [106.346547] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [106.456127] [014/134] (915s left) kms_getfb (getfb-addfb-different-handles) [106.550935] Starting subtest: getfb-addfb-different-handles [106.553214] Subtest getfb-addfb-different-handles: SUCCESS (0.000s) [106.683166] [015/134] (915s left) perf_pmu (module-unload) [106.776438] Starting subtest: module-unload [115.261092] Subtest module-unload: FAIL (8.369s) [115.290636] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true [115.293599] [016/134] (906s left) kms_atomic_transition (modeset-transition) [116.837143] Starting subtest: modeset-transition [116.839351] Starting dynamic subtest: 1x-outputs [127.704953] Dynamic subtest 1x-outputs: SUCCESS (10.868s) [127.708112] Subtest modeset-transition: SUCCESS (10.869s) [128.577905] [FACT kms_atomic_transition (modeset-transition)] new: kernel.kmod_is_loaded.i915: true [128.581580] [017/134] (893s left) kms_cursor_crc (cursor-random-max-size) [128.871161] Starting subtest: cursor-random-max-size [128.877386] Subtest cursor-random-max-size: SKIP (0.000s) [129.027980] [018/134] (893s left) gem_pxp (hw-rejects-pxp-context) [129.158504] Starting subtest: hw-rejects-pxp-context [129.163063] Subtest hw-rejects-pxp-context: SKIP (0.000s) [129.273803] [019/134] (893s left) kms_flip (2x-flip-vs-expired-vblank-interruptible) [129.357062] Starting subtest: 2x-flip-vs-expired-vblank-interruptible [129.369086] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s) [129.490442] [020/134] (892s left) gem_exec_params (no-blt) [129.553586] Starting subtest: no-blt [129.558419] Subtest no-blt: SUCCESS (0.002s) [129.694380] [021/134] (892s left) tools_test (tools_test) [129.739732] Starting subtest: tools_test [129.786295] Subtest tools_test: SUCCESS (0.062s) [129.868270] [022/134] (892s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs) [129.966895] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs [129.968893] Starting dynamic subtest: pipe-A-eDP-1 [129.988280] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [129.998284] Starting dynamic subtest: pipe-B-eDP-1 [130.016086] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [130.023091] Starting dynamic subtest: pipe-C-eDP-1 [130.040449] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [130.047601] Starting dynamic subtest: pipe-D-eDP-1 [130.065890] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [130.069667] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.006s) [132.152532] [023/134] (890s left) gem_lmem_swapping (heavy-random) [132.194331] Subtest heavy-random: SKIP (0.000s) [132.238810] [024/134] (890s left) gem_softpin (evict-prime) [132.301557] Starting subtest: evict-prime [132.304042] Starting dynamic subtest: rcs0 [133.455887] Dynamic subtest rcs0: SUCCESS (1.154s) [133.465223] Starting dynamic subtest: bcs0 [134.598313] Dynamic subtest bcs0: SUCCESS (1.140s) [134.609948] Starting dynamic subtest: vcs0 [135.846675] Dynamic subtest vcs0: SUCCESS (1.245s) [135.858566] Starting dynamic subtest: vcs1 [137.907517] Dynamic subtest vcs1: SUCCESS (2.058s) [137.921532] Starting dynamic subtest: vecs0 [139.892069] Dynamic subtest vecs0: SUCCESS (1.983s) [139.903714] Starting dynamic subtest: ccs0 [141.049496] Dynamic subtest ccs0: SUCCESS (1.157s) [141.060548] Starting dynamic subtest: all [142.851030] Dynamic subtest all: SUCCESS (1.799s) [142.853829] Subtest evict-prime: SUCCESS (10.548s) [142.991930] [025/134] (879s left) prime_mmap (test_userptr) [143.045717] Starting subtest: test_userptr [143.048250] Starting dynamic subtest: test_userptr-smem [143.050345] Dynamic subtest test_userptr-smem: SUCCESS (0.000s) [143.052452] Subtest test_userptr: SUCCESS (0.001s) [143.168969] [026/134] (879s left) gem_exec_whisper (basic-fds) [143.233110] Starting subtest: basic-fds [150.631034] Subtest basic-fds: SUCCESS (7.397s) [150.823092] [027/134] (871s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy) [150.942364] Starting subtest: 2x-flip-vs-cursor-legacy [150.946946] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s) [151.094300] [028/134] (871s left) gem_exec_schedule (preempt-hang) [151.271270] Starting subtest: preempt-hang [151.273766] Starting dynamic subtest: rcs0 [151.509468] Dynamic subtest rcs0: SUCCESS (0.238s) [151.520342] Starting dynamic subtest: bcs0 [151.743231] Dynamic subtest bcs0: SUCCESS (0.232s) [151.753547] Starting dynamic subtest: vcs0 [151.973562] Dynamic subtest vcs0: SUCCESS (0.229s) [151.982345] Starting dynamic subtest: vcs1 [152.207896] Dynamic subtest vcs1: SUCCESS (0.234s) [152.218218] Starting dynamic subtest: vecs0 [152.435111] Dynamic subtest vecs0: SUCCESS (0.225s) [152.445104] Starting dynamic subtest: ccs0 [152.659932] Dynamic subtest ccs0: SUCCESS (0.224s) [152.662221] Subtest preempt-hang: SUCCESS (1.388s) [153.048726] [029/134] (869s left) gem_ctx_param (vm) [153.112016] Starting subtest: vm [153.150806] Subtest vm: SUCCESS (0.038s) [153.331305] [030/134] (869s left) kms_psr (fbc-psr-sprite-blt) [153.422764] Starting subtest: fbc-psr-sprite-blt [153.425026] Starting dynamic subtest: eDP-1 [153.428894] Dynamic subtest eDP-1: SKIP (0.000s) [153.432821] Subtest fbc-psr-sprite-blt: SKIP (0.001s) [153.504096] [031/134] (869s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen) [153.605276] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen [160.353689] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.752s) [160.519558] [032/134] (862s left) gem_exec_capture (capture-invisible) [160.591313] Starting subtest: capture-invisible [160.593667] Starting dynamic subtest: smem0 [160.598228] Dynamic subtest smem0: SKIP (0.000s) [160.602740] Subtest capture-invisible: SKIP (0.001s) [160.724442] [033/134] (862s left) vgem_slow (nohang) [160.825319] Starting subtest: nohang [171.120415] Subtest nohang: SUCCESS (10.294s) [171.200598] [FACT vgem_slow (nohang)] new: kernel.kmod_is_loaded.vgem: true [171.204053] [034/134] (851s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [171.305270] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [171.309914] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [171.428036] [035/134] (851s left) kms_chamelium_color (ctm-negative) [171.522352] Subtest ctm-negative: SKIP (0.000s) [171.565171] [036/134] (851s left) gem_exec_reloc (basic-write-read) [171.618627] Subtest basic-write-read: SKIP (0.000s) [171.686987] [037/134] (851s left) gem_eio (context-create) [171.917378] Starting subtest: context-create [172.255900] Subtest context-create: SUCCESS (0.339s) [172.438184] [038/134] (850s left) perf (gen12-invalid-class-instance) [172.560610] Starting subtest: gen12-invalid-class-instance [172.570184] Subtest gen12-invalid-class-instance: SUCCESS (0.009s) [172.610452] [039/134] (850s left) dmabuf_sync_file (export-multiwait) [172.644133] Starting subtest: export-multiwait [172.645817] Subtest export-multiwait: SUCCESS (0.000s) [172.726894] [040/134] (850s left) kms_psr (fbc-psr-no-drrs) [172.816403] Starting subtest: fbc-psr-no-drrs [172.818355] Starting dynamic subtest: eDP-1 [172.821841] Dynamic subtest eDP-1: SKIP (0.000s) [172.825468] Subtest fbc-psr-no-drrs: SKIP (0.001s) [172.897505] [041/134] (850s left) kms_rotation_crc (multiplane-rotation-cropping-bottom) [172.994784] Starting subtest: multiplane-rotation-cropping-bottom [180.351928] Subtest multiplane-rotation-cropping-bottom: SUCCESS (7.360s) [180.517534] [042/134] (842s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render) [180.617853] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render [180.621458] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [180.755404] [043/134] (842s left) gem_exec_balancer (bonded-dual) [180.811374] Starting subtest: bonded-dual [180.815394] Subtest bonded-dual: SKIP (0.000s) [181.140744] [044/134] (842s left) kms_hdr (invalid-metadata-sizes) [181.225486] Starting subtest: invalid-metadata-sizes [181.231917] Subtest invalid-metadata-sizes: SKIP (0.000s) [181.322607] [045/134] (841s left) gem_userptr_blits (process-exit) [181.392840] Starting subtest: process-exit [181.398207] Subtest process-exit: SUCCESS (0.007s) [181.551598] [046/134] (841s left) kms_cursor_crc (cursor-offscreen-256x85) [181.808649] Starting subtest: cursor-offscreen-256x85 [181.855243] Subtest cursor-offscreen-256x85: SKIP (0.043s) [182.071950] [047/134] (841s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc) [182.159361] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc [182.161362] Starting dynamic subtest: pipe-A-eDP-1 [182.178569] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [182.188928] Starting dynamic subtest: pipe-B-eDP-1 [182.204441] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [182.212764] Starting dynamic subtest: pipe-C-eDP-1 [182.228671] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [182.236894] Starting dynamic subtest: pipe-D-eDP-1 [182.252873] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [182.254508] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s) [184.435939] [048/134] (838s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c) [184.494191] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s) [184.547376] [049/134] (838s left) i915_drm_fdinfo (memory-info-shared) [184.587256] Starting subtest: memory-info-shared [184.589569] Starting dynamic subtest: smem0 [184.650261] Dynamic subtest smem0: SUCCESS (0.065s) [184.653120] Subtest memory-info-shared: SUCCESS (0.066s) [184.721474] [050/134] (838s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation) [184.808601] Starting subtest: plane-scaler-unity-scaling-with-rotation [184.810863] Starting dynamic subtest: pipe-A [185.034683] Dynamic subtest pipe-A: SUCCESS (0.228s) [185.044188] Starting dynamic subtest: pipe-B [186.301178] Dynamic subtest pipe-B: SUCCESS (1.266s) [186.310745] Starting dynamic subtest: pipe-C [187.631136] Dynamic subtest pipe-C: SUCCESS (1.329s) [187.642144] Starting dynamic subtest: pipe-D [188.951912] Dynamic subtest pipe-D: SUCCESS (1.320s) [188.954097] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.146s) [190.133718] [051/134] (833s left) kms_big_fb (4-tiled-64bpp-rotate-0) [190.240704] Starting subtest: 4-tiled-64bpp-rotate-0 [191.923146] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.684s) [192.144919] [052/134] (831s left) gem_mmap_gtt (big-bo) [192.211557] Subtest big-bo: SKIP (0.000s) [192.277220] [053/134] (831s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all) [192.330064] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all [192.392341] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.006s) [192.455438] [054/134] (831s left) kms_addfb_basic (addfb25-modifier-no-flag) [192.542469] Starting subtest: addfb25-modifier-no-flag [192.544266] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [192.661104] [055/134] (831s left) kms_chamelium_edid (dp-edid-resolution-list) [193.040092] Subtest dp-edid-resolution-list: SKIP (0.000s) [193.831932] [056/134] (829s left) gem_madvise (dontneed-before-mmap) [193.868365] Starting subtest: dontneed-before-mmap [193.890714] Subtest dontneed-before-mmap: SUCCESS (0.024s) [194.029697] [057/134] (829s left) kms_hdmi_inject (inject-audio) [194.380088] Starting subtest: inject-audio [194.659056] Subtest inject-audio: SUCCESS (0.280s) [195.240072] [058/134] (828s left) core_auth (basic-auth) [195.293085] Starting subtest: basic-auth [195.295439] Subtest basic-auth: SUCCESS (0.001s) [195.418368] [059/134] (828s left) gem_userptr_blits (map-fixed-invalidate-busy) [195.480418] Starting subtest: map-fixed-invalidate-busy [195.484558] Subtest map-fixed-invalidate-busy: SKIP (0.000s) [195.615530] [060/134] (828s left) gem_exec_reloc (basic-concurrent16) [195.677725] Subtest basic-concurrent16: SKIP (0.000s) [195.765281] [061/134] (828s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite) [195.863743] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite [195.867867] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [195.993551] [062/134] (828s left) kms_dp_link_training (non-uhbr-mst) [196.086014] Starting subtest: non-uhbr-mst [196.094469] Subtest non-uhbr-mst: SKIP (0.000s) [196.170474] [063/134] (827s left) kms_scaling_modes (scaling-mode-none) [196.255637] Starting subtest: scaling-mode-none [196.257400] Starting dynamic subtest: pipe-A-eDP-1 [196.347108] Dynamic subtest pipe-A-eDP-1: SKIP (0.091s) [196.356106] Starting dynamic subtest: pipe-B-eDP-1 [196.380089] Dynamic subtest pipe-B-eDP-1: SKIP (0.030s) [196.388951] Starting dynamic subtest: pipe-C-eDP-1 [196.410393] Dynamic subtest pipe-C-eDP-1: SKIP (0.029s) [196.419473] Starting dynamic subtest: pipe-D-eDP-1 [196.441706] Dynamic subtest pipe-D-eDP-1: SKIP (0.030s) [196.445442] Subtest scaling-mode-none: SKIP (0.187s) [196.588673] [064/134] (827s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [196.674871] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt [196.678481] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [196.802122] [065/134] (827s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf) [201.758865] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf [201.761199] Starting dynamic subtest: pipe-A-eDP-1 [202.530408] Dynamic subtest pipe-A-eDP-1: SKIP (0.767s) [202.540396] Starting dynamic subtest: pipe-B-eDP-1 [203.629875] Dynamic subtest pipe-B-eDP-1: SKIP (1.097s) [203.634114] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.869s) [204.903308] [066/134] (819s left) syncobj_timeline (single-wait-for-submit-signaled) [204.956541] Starting subtest: single-wait-for-submit-signaled [204.958510] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s) [205.069981] [067/134] (819s left) vgem_basic (dmabuf-export) [205.106957] Starting subtest: dmabuf-export [205.135681] Subtest dmabuf-export: SUCCESS (0.030s) [205.269524] [068/134] (818s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [205.390495] Starting subtest: basic-busy-flip-before-cursor-legacy [205.395054] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [205.548110] [069/134] (818s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu) [205.648359] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu [205.652479] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [205.793581] [070/134] (818s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf) [210.859434] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf [210.863936] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.002s) [211.694218] [071/134] (812s left) kms_rotation_crc (sprite-rotation-90) [211.788704] Starting subtest: sprite-rotation-90 [211.793114] Subtest sprite-rotation-90: SKIP (0.001s) [211.885153] [072/134] (812s left) kms_vblank (ts-continuation-modeset-rpm) [211.982956] Starting subtest: ts-continuation-modeset-rpm [211.985114] Starting dynamic subtest: pipe-A-eDP-1 [214.471687] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.485s) [214.484721] Starting dynamic subtest: pipe-D-eDP-1 [216.629324] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.159s) [216.631671] Subtest ts-continuation-modeset-rpm: SUCCESS (4.648s) [217.485603] [073/134] (806s left) gem_exec_schedule (semaphore-user) [217.560872] Starting subtest: semaphore-user [217.610799] Subtest semaphore-user: SUCCESS (0.056s) [218.962050] [074/134] (805s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc) [219.060402] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc [223.340418] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.285s) [224.519729] [075/134] (800s left) kms_flip (dpms-off-confusion) [224.608469] Starting subtest: dpms-off-confusion [224.610478] Starting dynamic subtest: A-eDP1 [233.255317] Dynamic subtest A-eDP1: SUCCESS (8.647s) [233.266733] Starting dynamic subtest: B-eDP1 [241.948961] Dynamic subtest B-eDP1: SUCCESS (8.691s) [241.959189] Starting dynamic subtest: C-eDP1 [250.645190] Dynamic subtest C-eDP1: SUCCESS (8.695s) [250.655414] Starting dynamic subtest: D-eDP1 [259.337067] Dynamic subtest D-eDP1: SUCCESS (8.691s) [259.343234] Subtest dpms-off-confusion: SUCCESS (34.734s) [260.587303] [076/134] (764s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [260.678499] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [260.682591] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [260.808935] [077/134] (763s left) kms_lease (lease-unleased-crtc) [260.898339] Starting subtest: lease-unleased-crtc [260.902568] Starting dynamic subtest: pipe-A-eDP-1 [261.191931] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s) [261.201835] Starting dynamic subtest: pipe-B-eDP-1 [261.910222] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.717s) [261.919917] Starting dynamic subtest: pipe-C-eDP-1 [261.922502] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s) [261.931737] Starting dynamic subtest: pipe-D-eDP-1 [261.934128] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.005s) [261.936492] Subtest lease-unleased-crtc: SUCCESS (1.029s) [262.297185] [078/134] (762s left) kms_cursor_edge_walk (128x128-right-edge) [262.395728] Starting subtest: 128x128-right-edge [262.397940] Starting dynamic subtest: pipe-A-eDP-1 [265.825657] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.429s) [265.840343] Starting dynamic subtest: pipe-D-eDP-1 [269.004500] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.176s) [269.006489] Subtest 128x128-right-edge: SUCCESS (6.607s) [269.895136] [079/134] (754s left) gen9_exec_parse (bb-start-out) [269.954589] Subtest bb-start-out: SKIP (0.000s) [270.027272] [080/134] (754s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc) [270.131298] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc [270.135176] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [270.269198] [081/134] (754s left) i915_pm_rpm (gem-pread) [272.104614] Starting subtest: gem-pread [273.865061] Subtest gem-pread: SUCCESS (1.763s) [273.966423] [082/134] (750s left) kms_plane_alpha_blend (constant-alpha-min) [274.068342] Starting subtest: constant-alpha-min [274.354802] Starting dynamic subtest: pipe-A-eDP-1 [275.063411] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.707s) [275.072979] Starting dynamic subtest: pipe-D-eDP-1 [276.508882] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.442s) [276.511229] Subtest constant-alpha-min: SUCCESS (2.441s) [277.388414] [083/134] (747s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render) [277.485856] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render [277.489995] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [277.611458] [084/134] (747s left) gem_mmap_gtt (cpuset-big-copy-odd) [277.679261] Subtest cpuset-big-copy-odd: SKIP (0.000s) [277.742114] [085/134] (747s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite) [277.842708] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite [286.411402] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.572s) [286.572742] [086/134] (738s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt) [286.667437] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt [290.776104] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.111s) [292.007329] [087/134] (733s left) kms_flip (2x-flip-vs-dpms-on-nop) [292.110112] Starting subtest: 2x-flip-vs-dpms-on-nop [292.119566] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s) [292.262389] [088/134] (732s left) gem_basic (bad-close) [292.314637] Starting subtest: bad-close [292.319045] Subtest bad-close: SUCCESS (0.000s) [292.451408] [089/134] (732s left) kms_psr (psr2-cursor-render) [292.537950] Starting subtest: psr2-cursor-render [292.540187] Starting dynamic subtest: eDP-1 [294.206732] Dynamic subtest eDP-1: SUCCESS (1.668s) [294.209104] Subtest psr2-cursor-render: SUCCESS (1.669s) [295.092594] [090/134] (730s left) api_intel_bb (render-ccs) [295.152059] Starting subtest: render-ccs [295.507523] Subtest render-ccs: SUCCESS (0.355s) [295.697399] [091/134] (729s left) kms_cursor_crc (cursor-offscreen-64x21) [295.887848] Starting subtest: cursor-offscreen-64x21 [295.935939] Subtest cursor-offscreen-64x21: SKIP (0.043s) [296.195797] [092/134] (729s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [296.313658] Starting subtest: basic-busy-flip-before-cursor-atomic [296.318528] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [296.491896] [093/134] (728s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted) [296.552878] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted [296.653646] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.102s) [296.740789] [094/134] (728s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move) [296.836798] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move [296.840351] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [296.973571] [095/134] (728s left) gem_flink_basic (bad-open) [297.032760] Starting subtest: bad-open [297.034846] Subtest bad-open: SUCCESS (0.000s) [297.160995] [096/134] (728s left) kms_flip (2x-blocking-wf_vblank) [297.263873] Starting subtest: 2x-blocking-wf_vblank [297.272778] Subtest 2x-blocking-wf_vblank: SKIP (0.011s) [297.409351] [097/134] (728s left) kms_big_fb (linear-8bpp-rotate-0) [297.504537] Starting subtest: linear-8bpp-rotate-0 [298.761057] Subtest linear-8bpp-rotate-0: SUCCESS (1.257s) [298.914269] [098/134] (726s left) api_intel_allocator (fork-simple-once) [298.968242] Starting subtest: fork-simple-once [298.984219] Subtest fork-simple-once: SUCCESS (0.018s) [299.153315] [099/134] (726s left) kms_big_fb (y-tiled-32bpp-rotate-180) [299.243866] Starting subtest: y-tiled-32bpp-rotate-180 [299.247850] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s) [299.352524] [100/134] (726s left) syncobj_timeline (wait-all-for-submit-delayed-submit) [299.415878] Starting subtest: wait-all-for-submit-delayed-submit [299.521339] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s) [299.623313] [101/134] (726s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers) [299.719063] Starting subtest: plane-downscale-factor-0-75-with-modifiers [299.721323] Starting dynamic subtest: pipe-A [300.058972] Dynamic subtest pipe-A: SUCCESS (0.342s) [300.068720] Starting dynamic subtest: pipe-B [301.440060] Dynamic subtest pipe-B: SUCCESS (1.380s) [301.449957] Starting dynamic subtest: pipe-C [302.841259] Dynamic subtest pipe-C: SUCCESS (1.400s) [302.851626] Starting dynamic subtest: pipe-D [304.240579] Dynamic subtest pipe-D: SUCCESS (1.398s) [304.242984] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.524s) [305.414326] [102/134] (720s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs) [305.523641] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs [305.526064] Starting dynamic subtest: pipe-A-eDP-1 [306.400221] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.870s) [306.409662] Starting dynamic subtest: pipe-B-eDP-1 [308.052199] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.648s) [308.062630] Starting dynamic subtest: pipe-C-eDP-1 [309.565927] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.514s) [309.576080] Starting dynamic subtest: pipe-D-eDP-1 [311.055193] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.488s) [311.057513] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.526s) [312.289626] [103/134] (713s left) kms_big_fb (yf-tiled-addfb) [312.394615] Starting subtest: yf-tiled-addfb [312.398829] Subtest yf-tiled-addfb: SKIP (0.000s) [312.519203] [104/134] (713s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite) [312.624412] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite [321.904722] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.283s) [322.057179] [105/134] (703s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu) [322.165169] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu [328.752612] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.589s) [328.919959] [106/134] (696s left) gem_exec_reloc (basic-wc-gtt-active) [328.989294] Subtest basic-wc-gtt-active: SKIP (0.000s) [329.078167] [107/134] (696s left) perf (global-sseu-config-invalid) [329.179708] Starting subtest: global-sseu-config-invalid [329.184213] Subtest global-sseu-config-invalid: SKIP (0.000s) [329.221531] [108/134] (696s left) kms_pm_rpm (fences-dpms) [331.055568] Starting subtest: fences-dpms [331.061220] Subtest fences-dpms: SKIP (0.000s) [331.510634] [109/134] (694s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling) [331.608859] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling [331.611078] Starting dynamic subtest: pipe-A-default-mode [332.801620] Dynamic subtest pipe-A-default-mode: SKIP (1.187s) [332.806243] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.189s) [332.975710] [110/134] (693s left) kms_pm_rpm (cursor-dpms) [335.104079] Starting subtest: cursor-dpms [335.109039] Subtest cursor-dpms: SKIP (0.000s) [335.493196] [111/134] (690s left) syncobj_wait (invalid-multi-wait-all-unsubmitted) [335.554718] Starting subtest: invalid-multi-wait-all-unsubmitted [335.556734] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s) [335.677266] [112/134] (690s left) kms_psr (fbc-pr-sprite-render) [335.772800] Starting subtest: fbc-pr-sprite-render [335.776954] Subtest fbc-pr-sprite-render: SKIP (0.000s) [335.857582] [113/134] (690s left) kms_big_fb (x-tiled-16bpp-rotate-270) [335.964250] Starting subtest: x-tiled-16bpp-rotate-270 [335.983788] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s) [336.144249] [114/134] (690s left) perf (invalid-remove-userspace-config) [336.244808] Starting subtest: invalid-remove-userspace-config [336.250671] Subtest invalid-remove-userspace-config: SUCCESS (0.009s) [336.296928] [115/134] (689s left) gem_watchdog (default-virtual) [336.372593] Starting subtest: default-virtual [342.648195] Subtest default-virtual: SUCCESS (6.284s) [342.740796] [116/134] (683s left) sw_sync (sync_merge_same) [342.773127] Starting subtest: sync_merge_same [342.775439] Subtest sync_merge_same: SUCCESS (0.000s) [342.856759] [117/134] (683s left) gem_ringfill (basic-all) [348.887992] Starting subtest: basic-all [350.048089] Subtest basic-all: SUCCESS (1.160s) [350.212041] [118/134] (676s left) gem_ccs (suspend-resume) [350.290020] Starting subtest: suspend-resume [350.294268] Subtest suspend-resume: SKIP (0.000s) [350.445016] [119/134] (675s left) gem_workarounds (basic-read) [350.507612] Starting subtest: basic-read [350.523754] Subtest basic-read: SUCCESS (0.017s) [350.671239] [120/134] (675s left) gem_softpin (noreloc-s3) [350.734841] Starting subtest: noreloc-S3 [370.627219] Subtest noreloc-S3: SUCCESS (5.403s) [370.764921] Aborting: Kernel badly tainted (0x4244, 0x200) (check dmesg for details): TAINT_WARN: WARN_ON has happened. [370.782491] [FACT gem_softpin (noreloc-s3)] new: kernel.is_tainted.taint_warn: true [370.783329] Closing watchdogs results: parsing output: 0/ for test: syncobj_timeline results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: kms_chamelium_hpd results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: kms_ccs results: parsing output: 5/ for test: kms_big_fb results: parsing output: 6/ for test: kms_async_flips results: parsing output: 7/ for test: kms_psr2_sf results: parsing output: 8/ for test: gem_exec_reloc results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: gem_exec_flush results: parsing output: 11/ for test: kms_colorop results: parsing output: 12/ for test: syncobj_timeline results: parsing output: 13/ for test: kms_getfb results: parsing output: 14/ for test: perf_pmu results: parsing output: 15/ for test: kms_atomic_transition results: parsing output: 16/ for test: kms_cursor_crc results: parsing output: 17/ for test: gem_pxp results: parsing output: 18/ for test: kms_flip results: parsing output: 19/ for test: gem_exec_params results: parsing output: 20/ for test: tools_test results: parsing output: 21/ for test: kms_ccs results: parsing output: 22/ for test: gem_lmem_swapping results: parsing output: 23/ for test: gem_softpin results: parsing output: 24/ for test: prime_mmap results: parsing output: 25/ for test: gem_exec_whisper results: parsing output: 26/ for test: kms_cursor_legacy results: parsing output: 27/ for test: gem_exec_schedule results: parsing output: 28/ for test: gem_ctx_param results: parsing output: 29/ for test: kms_psr results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: gem_exec_capture results: parsing output: 32/ for test: vgem_slow results: parsing output: 33/ for test: kms_big_fb results: parsing output: 34/ for test: kms_chamelium_color results: parsing output: 35/ for test: gem_exec_reloc results: parsing output: 36/ for test: gem_eio results: parsing output: 37/ for test: perf results: parsing output: 38/ for test: dmabuf_sync_file results: parsing output: 39/ for test: kms_psr results: parsing output: 40/ for test: kms_rotation_crc results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: gem_exec_balancer results: parsing output: 43/ for test: kms_hdr results: parsing output: 44/ for test: gem_userptr_blits results: parsing output: 45/ for test: kms_cursor_crc results: parsing output: 46/ for test: kms_ccs results: parsing output: 47/ for test: kms_pipe_b_c_ivb results: parsing output: 48/ for test: i915_drm_fdinfo results: parsing output: 49/ for test: kms_plane_scaling results: parsing output: 50/ for test: kms_big_fb results: parsing output: 51/ for test: gem_mmap_gtt results: parsing output: 52/ for test: sriov_basic results: parsing output: 53/ for test: kms_addfb_basic results: parsing output: 54/ for test: kms_chamelium_edid results: parsing output: 55/ for test: gem_madvise results: parsing output: 56/ for test: kms_hdmi_inject results: parsing output: 57/ for test: core_auth results: parsing output: 58/ for test: gem_userptr_blits results: parsing output: 59/ for test: gem_exec_reloc results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: kms_dp_link_training results: parsing output: 62/ for test: kms_scaling_modes results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: kms_psr2_sf results: parsing output: 65/ for test: syncobj_timeline results: parsing output: 66/ for test: vgem_basic results: parsing output: 67/ for test: kms_cursor_legacy results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: kms_psr2_sf results: parsing output: 70/ for test: kms_rotation_crc results: parsing output: 71/ for test: kms_vblank results: parsing output: 72/ for test: gem_exec_schedule results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_flip results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: kms_lease results: parsing output: 77/ for test: kms_cursor_edge_walk results: parsing output: 78/ for test: gen9_exec_parse results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: i915_pm_rpm results: parsing output: 81/ for test: kms_plane_alpha_blend results: parsing output: 82/ for test: kms_frontbuffer_tracking results: parsing output: 83/ for test: gem_mmap_gtt results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: kms_flip results: parsing output: 87/ for test: gem_basic results: parsing output: 88/ for test: kms_psr results: parsing output: 89/ for test: api_intel_bb results: parsing output: 90/ for test: kms_cursor_crc results: parsing output: 91/ for test: kms_cursor_legacy results: parsing output: 92/ for test: syncobj_timeline results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: gem_flink_basic results: parsing output: 95/ for test: kms_flip results: parsing output: 96/ for test: kms_big_fb results: parsing output: 97/ for test: api_intel_allocator results: parsing output: 98/ for test: kms_big_fb results: parsing output: 99/ for test: syncobj_timeline results: parsing output: 100/ for test: kms_plane_scaling results: parsing output: 101/ for test: kms_ccs results: parsing output: 102/ for test: kms_big_fb results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: gem_exec_reloc results: parsing output: 106/ for test: perf results: parsing output: 107/ for test: kms_pm_rpm results: parsing output: 108/ for test: kms_flip_scaled_crc results: parsing output: 109/ for test: kms_pm_rpm results: parsing output: 110/ for test: syncobj_wait results: parsing output: 111/ for test: kms_psr results: parsing output: 112/ for test: kms_big_fb results: parsing output: 113/ for test: perf results: parsing output: 114/ for test: gem_watchdog results: parsing output: 115/ for test: sw_sync results: parsing output: 116/ for test: gem_ringfill results: parsing output: 117/ for test: gem_ccs results: parsing output: 118/ for test: gem_workarounds results: parsing output: 119/ for test: gem_softpin results: parsing output: 120/ for test: vgem_basic results: no output, setting notrun results: parsing output: 121/ for test: gem_mmap_gtt results: no output, setting notrun results: parsing output: 122/ for test: i915_drm_fdinfo results: no output, setting notrun results: parsing output: 123/ for test: kms_force_connector_basic results: no output, setting notrun results: parsing output: 124/ for test: i915_pm_rps results: no output, setting notrun results: parsing output: 125/ for test: fbdev results: no output, setting notrun results: parsing output: 126/ for test: kms_colorop results: no output, setting notrun results: parsing output: 127/ for test: gem_ctx_persistence results: no output, setting notrun results: parsing output: 128/ for test: prime_mmap results: no output, setting notrun results: parsing output: 129/ for test: gem_pxp results: no output, setting notrun results: parsing output: 130/ for test: kms_colorop results: no output, setting notrun results: parsing output: 131/ for test: gem_partial_pwrite_pread results: no output, setting notrun results: parsing output: 132/ for test: kms_joiner results: no output, setting notrun results: parsing output: 133/ for test: gem_exec_fence results: no output, setting notrun Done.