[57.595227] Initializing watchdogs [57.595364] /dev/watchdog0 [57.609969] [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.614330] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.616534] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.619839] [001/133] (960s left) gem_exec_balancer (indices) [57.697263] Starting subtest: indices [59.890795] Subtest indices: SUCCESS (2.195s) [60.187713] [002/133] (957s left) kms_flip (2x-plain-flip-interruptible) [60.294621] Starting subtest: 2x-plain-flip-interruptible [60.306283] Subtest 2x-plain-flip-interruptible: SKIP (0.010s) [60.397827] [003/133] (957s left) i915_suspend (debugfs-reader) [60.456771] Starting subtest: debugfs-reader [78.912944] Subtest debugfs-reader: SUCCESS (3.261s) [78.972436] [004/133] (939s left) kms_psr (fbc-psr-sprite-plane-onoff) [79.084897] Starting subtest: fbc-psr-sprite-plane-onoff [79.087179] Starting dynamic subtest: eDP-1 [79.091796] Dynamic subtest eDP-1: SKIP (0.000s) [79.096395] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.000s) [79.166490] [005/133] (939s left) kms_plane (plane-panning-top-left) [79.257787] Starting subtest: plane-panning-top-left [79.260052] Starting dynamic subtest: pipe-A [81.022992] Dynamic subtest pipe-A: SUCCESS (1.779s) [81.032300] Starting dynamic subtest: pipe-B [83.358017] Dynamic subtest pipe-B: SUCCESS (2.353s) [83.360437] Subtest plane-panning-top-left: SUCCESS (4.134s) [84.173527] [006/133] (934s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt) [84.266409] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt [84.270832] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [84.358155] [007/133] (934s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt) [84.457232] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt [84.461520] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [84.566764] [008/133] (933s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt) [84.661104] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt [84.665625] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [84.764915] [009/133] (933s left) kms_pipe_crc_basic (read-crc-frame-sequence) [84.850655] Starting subtest: read-crc-frame-sequence [84.853098] Starting dynamic subtest: pipe-A-eDP-1 [85.560110] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.712s) [85.568607] Starting dynamic subtest: pipe-B-eDP-1 [86.918876] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.364s) [86.928714] Starting dynamic subtest: pipe-C-eDP-1 [88.217068] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.303s) [88.231021] Starting dynamic subtest: pipe-D-eDP-1 [89.556472] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.342s) [89.558732] Subtest read-crc-frame-sequence: SUCCESS (4.725s) [90.384635] [010/133] (928s left) kms_psr (psr-primary-mmap-cpu) [90.483753] Starting subtest: psr-primary-mmap-cpu [90.485998] Starting dynamic subtest: eDP-1 [92.258908] Dynamic subtest eDP-1: SUCCESS (1.779s) [92.260920] Subtest psr-primary-mmap-cpu: SUCCESS (1.780s) [93.123534] [011/133] (925s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt) [93.226996] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt [93.231013] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [93.321281] [012/133] (925s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move) [93.421881] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move [100.811607] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.403s) [100.948431] [013/133] (917s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite) [101.042245] Starting subtest: psr-rgb565-draw-pwrite [108.025809] Subtest psr-rgb565-draw-pwrite: SUCCESS (6.993s) [108.130109] [014/133] (910s left) testdisplay [108.452321] [015/133] (910s left) syncobj_timeline (invalid-wait-illegal-handle) [108.506615] Starting subtest: invalid-wait-illegal-handle [108.508781] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [108.590335] [016/133] (910s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc) [108.684576] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc [115.265005] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.579s) [115.387743] [017/133] (903s left) gem_vm_create (invalid-destroy) [115.447940] Starting subtest: invalid-destroy [115.450421] Subtest invalid-destroy: SUCCESS (0.002s) [115.538271] [018/133] (903s left) kms_addfb_basic (unused-pitches) [115.610060] Starting subtest: unused-pitches [115.612080] Subtest unused-pitches: SUCCESS (0.000s) [115.737780] [019/133] (903s left) gem_softpin (zero) [115.804537] Starting subtest: zero [115.815467] Subtest zero: SUCCESS (0.011s) [115.926114] [020/133] (902s left) i915_hangman (engine-engine-error) [115.993009] Starting subtest: engine-engine-error [115.995943] Starting dynamic subtest: rcs0 [117.085725] Dynamic subtest rcs0: SUCCESS (1.091s) [117.096981] Starting dynamic subtest: bcs0 [119.065384] Dynamic subtest bcs0: SUCCESS (1.977s) [119.076294] Starting dynamic subtest: vcs0 [121.049552] Dynamic subtest vcs0: SUCCESS (1.983s) [121.060516] Starting dynamic subtest: vcs1 [123.097066] Dynamic subtest vcs1: SUCCESS (2.046s) [123.108969] Starting dynamic subtest: vecs0 [125.081183] Dynamic subtest vecs0: SUCCESS (1.983s) [125.092327] Starting dynamic subtest: ccs0 [127.066072] Dynamic subtest ccs0: SUCCESS (1.983s) [127.068957] Subtest engine-engine-error: SUCCESS (11.073s) [127.190074] [021/133] (891s left) kms_plane (pixel-format-4-tiled-modifier) [127.286551] Starting subtest: pixel-format-4-tiled-modifier [127.311715] Starting dynamic subtest: pipe-A-plane-0 [127.933770] Dynamic subtest pipe-A-plane-0: SUCCESS (0.622s) [127.942179] Starting dynamic subtest: pipe-A-plane-3 [128.366754] Dynamic subtest pipe-A-plane-3: SUCCESS (0.433s) [128.375257] Starting dynamic subtest: pipe-A-plane-5 [128.378917] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [129.476661] Starting dynamic subtest: pipe-B-plane-0 [130.147280] Dynamic subtest pipe-B-plane-0: SUCCESS (0.678s) [130.157338] Starting dynamic subtest: pipe-B-plane-3 [130.591429] Dynamic subtest pipe-B-plane-3: SUCCESS (0.444s) [130.599338] Starting dynamic subtest: pipe-B-plane-5 [130.602712] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [130.921424] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.634s) [131.764157] [022/133] (887s left) perf_pmu (faulting-read) [131.807469] Starting subtest: faulting-read [131.809814] Starting dynamic subtest: wb [131.812222] Dynamic subtest wb: SUCCESS (0.001s) [131.826662] Starting dynamic subtest: wc [131.829008] Dynamic subtest wc: SUCCESS (0.000s) [131.837067] Starting dynamic subtest: uc [131.839263] Dynamic subtest uc: SUCCESS (0.000s) [131.841446] Subtest faulting-read: SUCCESS (0.002s) [131.906342] [023/133] (887s left) gem_exec_capture (capture) [131.960372] Starting subtest: capture [131.962557] Starting dynamic subtest: rcs0-smem [132.820680] Dynamic subtest rcs0-smem: SUCCESS (0.857s) [132.831235] Starting dynamic subtest: bcs0-smem [134.147388] Dynamic subtest bcs0-smem: SUCCESS (1.327s) [134.157250] Starting dynamic subtest: vcs0-smem [134.963651] Dynamic subtest vcs0-smem: SUCCESS (0.818s) [134.971915] Starting dynamic subtest: vcs1-smem [135.777579] Dynamic subtest vcs1-smem: SUCCESS (0.815s) [135.785732] Starting dynamic subtest: vecs0-smem [137.184299] Dynamic subtest vecs0-smem: FAIL (1.346s) [137.193972] Starting dynamic subtest: ccs0-smem [138.442389] Dynamic subtest ccs0-smem: SUCCESS (1.315s) [138.444765] Subtest capture: FAIL (6.481s) [138.578698] [024/133] (880s left) prime_vgem (basic-write) [138.697980] Starting subtest: basic-write [138.706487] Subtest basic-write: SKIP (0.006s) [138.798991] [FACT prime_vgem (basic-write)] new: kernel.kmod_is_loaded.vgem: true [138.802083] [025/133] (880s left) gem_exec_fence (syncobj-invalid-wait) [139.224781] Starting subtest: syncobj-invalid-wait [139.227179] Subtest syncobj-invalid-wait: SUCCESS (0.001s) [141.185667] [026/133] (877s left) prime_vgem (fence-wait) [141.261297] Starting subtest: fence-wait [141.263724] Starting dynamic subtest: rcs0 [142.302080] Dynamic subtest rcs0: SUCCESS (1.039s) [142.313000] Starting dynamic subtest: bcs0 [143.363032] Dynamic subtest bcs0: SUCCESS (1.060s) [143.374055] Starting dynamic subtest: vcs0 [144.408071] Dynamic subtest vcs0: SUCCESS (1.044s) [144.419141] Starting dynamic subtest: vcs1 [145.452484] Dynamic subtest vcs1: SUCCESS (1.042s) [145.463932] Starting dynamic subtest: vecs0 [146.491909] Dynamic subtest vecs0: SUCCESS (1.038s) [146.506605] Starting dynamic subtest: ccs0 [147.539778] Dynamic subtest ccs0: SUCCESS (1.046s) [147.542333] Subtest fence-wait: SUCCESS (6.280s) [147.683061] [027/133] (871s left) gem_flink_basic (flink-lifetime) [147.734049] Starting subtest: flink-lifetime [147.736493] Subtest flink-lifetime: SUCCESS (0.002s) [147.846525] [028/133] (871s left) gem_pxp (verify-pxp-stale-buf-execution) [147.971897] Starting subtest: verify-pxp-stale-buf-execution [149.039141] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.069s) [149.186894] [029/133] (870s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions) [149.305554] Starting subtest: cursor-vs-flip-atomic-transitions [179.125321] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (29.826s) [179.973059] [030/133] (839s left) gem_exec_reloc (basic-gtt-noreloc) [180.035395] Subtest basic-gtt-noreloc: SKIP (0.000s) [180.109680] [031/133] (839s left) syncobj_timeline (multi-wait-available-submitted-signaled) [180.164277] Starting subtest: multi-wait-available-submitted-signaled [180.166629] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s) [180.262716] [032/133] (839s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt) [180.350394] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt [184.077502] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.729s) [185.270075] [033/133] (834s left) kms_flip (flip-vs-blocking-wf-vblank) [185.377552] Starting subtest: flip-vs-blocking-wf-vblank [185.380028] Starting dynamic subtest: A-eDP1 [194.310852] Dynamic subtest A-eDP1: SUCCESS (8.934s) [194.320123] Starting dynamic subtest: B-eDP1 [203.237313] Dynamic subtest B-eDP1: SUCCESS (8.925s) [203.249333] Starting dynamic subtest: C-eDP1 [212.153705] Dynamic subtest C-eDP1: SUCCESS (8.915s) [212.168648] Starting dynamic subtest: D-eDP1 [221.135168] Dynamic subtest D-eDP1: SUCCESS (8.930s) [221.137843] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.715s) [222.300739] [034/133] (797s left) gen3_render_tiledy_blits [222.418537] [035/133] (797s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [222.522951] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt [222.527378] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [222.620848] [036/133] (796s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt) [222.725326] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt [222.729417] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [222.821816] [037/133] (796s left) perf (gen8-unprivileged-single-ctx-counters) [222.930071] Starting subtest: gen8-unprivileged-single-ctx-counters [222.934060] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s) [222.975930] [038/133] (796s left) kms_big_fb (4-tiled-8bpp-rotate-90) [223.070254] Starting subtest: 4-tiled-8bpp-rotate-90 [223.093843] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.023s) [223.204983] [039/133] (796s left) gem_ccs (block-multicopy-compressed) [223.263784] Starting subtest: block-multicopy-compressed [223.267359] Subtest block-multicopy-compressed: SKIP (0.000s) [223.386902] [040/133] (796s left) gem_exec_params (invalid-bsd1-flag-on-blt) [223.446207] Starting subtest: invalid-bsd1-flag-on-blt [223.447859] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s) [223.549565] [041/133] (796s left) gem_pread (uncached) [223.609741] Subtest uncached: SKIP (0.000s) [223.677088] [042/133] (796s left) kms_cursor_legacy (cursorb-vs-flipa-toggle) [223.795047] Starting subtest: cursorB-vs-flipA-toggle [223.799160] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s) [223.950421] [043/133] (795s left) gem_exec_reloc (basic-wc-cpu-active) [224.007656] Subtest basic-wc-cpu-active: SKIP (0.000s) [224.068091] [044/133] (795s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs) [224.160060] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs [224.163822] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s) [225.251392] [045/133] (794s left) i915_query (query-topology-matches-eu-total) [225.306115] Starting subtest: query-topology-matches-eu-total [225.308094] Subtest query-topology-matches-eu-total: SUCCESS (0.000s) [225.406317] [046/133] (794s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs) [225.498124] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs [225.500347] Starting dynamic subtest: pipe-A-eDP-1 [225.525502] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [225.535373] Starting dynamic subtest: pipe-B-eDP-1 [225.555907] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [225.563868] Starting dynamic subtest: pipe-C-eDP-1 [225.587236] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [225.595312] Starting dynamic subtest: pipe-D-eDP-1 [225.619303] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [225.623773] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s) [227.816851] [047/133] (792s left) kms_big_fb (yf-tiled-16bpp-rotate-180) [227.924128] Starting subtest: yf-tiled-16bpp-rotate-180 [227.928373] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s) [228.022924] [048/133] (791s left) kms_prop_blob (invalid-get-prop-any) [228.089769] Starting subtest: invalid-get-prop-any [228.092054] Subtest invalid-get-prop-any: SUCCESS (0.000s) [228.205137] [049/133] (791s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs) [228.297792] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs [228.300015] Starting dynamic subtest: pipe-A-eDP-1 [228.320520] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [228.330008] Starting dynamic subtest: pipe-B-eDP-1 [228.349923] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [228.358065] Starting dynamic subtest: pipe-C-eDP-1 [228.377280] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [228.385383] Starting dynamic subtest: pipe-D-eDP-1 [228.403889] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [228.406007] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.005s) [230.497143] [050/133] (789s left) kms_content_protection (lic-type-0-hdcp14) [230.631454] Starting subtest: lic-type-0-hdcp14 [230.635814] Subtest lic-type-0-hdcp14: SKIP (0.000s) [230.743378] [051/133] (789s left) kms_pm_rpm (basic-rte) [230.786982] Starting subtest: basic-rte [233.757765] Subtest basic-rte: SUCCESS (2.970s) [235.608123] [052/133] (784s left) gem_ctx_shared (q-promotion) [235.667726] Starting subtest: Q-promotion [235.670186] Starting dynamic subtest: rcs0 [235.765791] Dynamic subtest rcs0: SUCCESS (0.098s) [235.783024] Starting dynamic subtest: vcs0 [235.848179] Dynamic subtest vcs0: SUCCESS (0.079s) [235.863658] Starting dynamic subtest: vcs1 [235.921739] Dynamic subtest vcs1: SUCCESS (0.074s) [235.937343] Starting dynamic subtest: vecs0 [235.988363] Dynamic subtest vecs0: SUCCESS (0.066s) [236.005997] Starting dynamic subtest: ccs0 [236.073240] Dynamic subtest ccs0: SUCCESS (0.082s) [236.075782] Subtest Q-promotion: SUCCESS (0.405s) [237.200495] [053/133] (783s left) kms_pm_rpm (universal-planes-dpms) [239.248060] Starting subtest: universal-planes-dpms [239.251166] Starting dynamic subtest: plane-35 [247.523870] Dynamic subtest plane-35: SUCCESS (8.276s) [247.535623] Starting dynamic subtest: plane-65 [255.916316] Dynamic subtest plane-65: SUCCESS (8.391s) [255.928549] Starting dynamic subtest: plane-95 [264.344543] Dynamic subtest plane-95: SUCCESS (8.426s) [264.355986] Starting dynamic subtest: plane-125 [273.175641] Dynamic subtest plane-125: SUCCESS (8.829s) [273.187562] Starting dynamic subtest: plane-135 [281.815621] Dynamic subtest plane-135: SUCCESS (8.639s) [281.827555] Starting dynamic subtest: plane-145 [292.701014] Dynamic subtest plane-145: SUCCESS (10.885s) [292.703779] Subtest universal-planes-dpms: SUCCESS (53.467s) [293.071000] [054/133] (727s left) sysfs_defaults (readonly) [293.129965] Starting subtest: readonly [293.132208] Starting dynamic subtest: vecs0 [293.134325] Dynamic subtest vecs0: SUCCESS (0.000s) [293.142921] Starting dynamic subtest: ccs0 [293.145030] Dynamic subtest ccs0: SUCCESS (0.000s) [293.153164] Starting dynamic subtest: vcs0 [293.155335] Dynamic subtest vcs0: SUCCESS (0.000s) [293.163456] Starting dynamic subtest: bcs0 [293.165591] Dynamic subtest bcs0: SUCCESS (0.000s) [293.173829] Starting dynamic subtest: rcs0 [293.175936] Dynamic subtest rcs0: SUCCESS (0.000s) [293.185194] Starting dynamic subtest: vcs1 [293.187419] Dynamic subtest vcs1: SUCCESS (0.000s) [293.189354] Subtest readonly: SUCCESS (0.006s) [293.242877] [055/133] (727s left) kms_psr (psr2-sprite-blt) [293.346930] Starting subtest: psr2-sprite-blt [293.349204] Starting dynamic subtest: eDP-1 [295.068950] Dynamic subtest eDP-1: SUCCESS (1.721s) [295.071147] Subtest psr2-sprite-blt: SUCCESS (1.722s) [295.936685] [056/133] (724s left) gem_basic (create-close) [295.996351] Starting subtest: create-close [296.000889] Subtest create-close: SUCCESS (0.000s) [296.091862] [057/133] (724s left) kms_cursor_legacy (cursora-vs-flipa-legacy) [296.210056] Starting subtest: cursorA-vs-flipA-legacy [307.364894] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.154s) [308.175135] [058/133] (712s left) perf (enable-disable) [308.265720] Starting subtest: enable-disable [308.268258] Starting dynamic subtest: 0-rcs0 [310.554083] Dynamic subtest 0-rcs0: SUCCESS (2.233s) [310.565044] Starting dynamic subtest: 1-vcs0 [314.983453] Dynamic subtest 1-vcs0: SUCCESS (4.429s) [314.986161] Subtest enable-disable: SUCCESS (6.663s) [315.028964] [059/133] (705s left) gem_render_copy_redux (normal) [315.090411] Starting subtest: normal [315.443785] Subtest normal: SUCCESS (0.353s) [315.559727] [060/133] (704s left) kms_chamelium_color (degamma) [315.652518] Subtest degamma: SKIP (0.000s) [315.697655] [061/133] (704s left) kms_cursor_edge_walk (256x256-top-edge) [315.780814] Starting subtest: 256x256-top-edge [315.783018] Starting dynamic subtest: pipe-A-eDP-1 [319.243462] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.458s) [319.252823] Starting dynamic subtest: pipe-D-eDP-1 [322.368930] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s) [322.371126] Subtest 256x256-top-edge: SUCCESS (6.587s) [323.164957] [062/133] (697s left) kms_vrr (flip-suspend) [323.252003] Starting subtest: flip-suspend [323.258217] Subtest flip-suspend: SKIP (0.000s) [323.333549] [063/133] (697s left) kms_big_fb (y-tiled-16bpp-rotate-0) [323.426806] Starting subtest: y-tiled-16bpp-rotate-0 [323.431012] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s) [323.518807] [064/133] (697s left) gem_exec_fence (syncobj-wait) [323.958608] Starting subtest: syncobj-wait [325.135577] Subtest syncobj-wait: SUCCESS (1.175s) [325.475109] [065/133] (695s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary) [325.570399] Starting subtest: psr-indfb-scaledprimary [331.318679] Subtest psr-indfb-scaledprimary: SUCCESS (5.750s) [331.430143] [066/133] (689s left) gem_mmap_offset (ptrace) [331.496340] Starting subtest: ptrace [331.498632] Starting dynamic subtest: smem0-wb [331.513790] Dynamic subtest smem0-wb: SUCCESS (0.017s) [331.522393] Starting dynamic subtest: smem0-wc [331.534306] Dynamic subtest smem0-wc: SUCCESS (0.020s) [331.547995] Starting dynamic subtest: smem0-uc [331.553465] Dynamic subtest smem0-uc: SUCCESS (0.018s) [331.555851] Subtest ptrace: SUCCESS (0.060s) [331.678929] [067/133] (689s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling) [331.772849] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling [331.775132] Starting dynamic subtest: pipe-A-default-mode [334.532896] Dynamic subtest pipe-A-default-mode: SUCCESS (2.758s) [334.534849] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.759s) [335.387007] [068/133] (685s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode) [335.764367] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s) [336.596186] [069/133] (684s left) gem_ctx_engines (execute-one) [336.659393] Starting subtest: execute-one [339.065616] Subtest execute-one: SUCCESS (2.406s) [339.253995] [070/133] (681s left) gem_exec_schedule (pi-shared-iova) [339.425937] Starting subtest: pi-shared-iova [339.428058] Starting dynamic subtest: rcs0 [339.545016] Dynamic subtest rcs0: SUCCESS (0.121s) [339.558061] Starting dynamic subtest: vcs0 [339.626776] Dynamic subtest vcs0: SUCCESS (0.081s) [339.640056] Starting dynamic subtest: vcs1 [339.704352] Dynamic subtest vcs1: SUCCESS (0.078s) [339.713325] Starting dynamic subtest: vecs0 [339.786525] Dynamic subtest vecs0: SUCCESS (0.081s) [339.800581] Starting dynamic subtest: ccs0 [339.894496] Dynamic subtest ccs0: SUCCESS (0.106s) [339.896773] Subtest pi-shared-iova: SUCCESS (0.473s) [341.217787] [071/133] (679s left) kms_atomic_transition (modeset-transition) [341.320576] Starting subtest: modeset-transition [341.322741] Starting dynamic subtest: 1x-outputs [352.189390] Dynamic subtest 1x-outputs: SUCCESS (10.868s) [352.191804] Subtest modeset-transition: SUCCESS (10.870s) [353.053947] [072/133] (667s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move) [353.163014] Starting subtest: fbc-2p-scndscrn-spr-indfb-move [353.166957] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [353.263496] [073/133] (667s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled) [353.318731] Starting subtest: invalid-multi-wait-unsubmitted-signaled [353.321038] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s) [353.435334] [074/133] (667s left) kms_cursor_crc (cursor-onscreen-64x64) [353.613960] Starting subtest: cursor-onscreen-64x64 [353.619142] Starting dynamic subtest: pipe-A-eDP-1 [355.744076] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.124s) [355.773898] Starting dynamic subtest: pipe-D-eDP-1 [358.531501] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.762s) [358.533659] Subtest cursor-onscreen-64x64: SUCCESS (4.915s) [359.334651] [075/133] (661s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render) [359.445111] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render [359.449313] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [359.564995] [076/133] (661s left) syncobj_wait (invalid-wait-bad-flags) [359.621746] Starting subtest: invalid-wait-bad-flags [359.624085] Subtest invalid-wait-bad-flags: SUCCESS (0.000s) [359.743575] [077/133] (661s left) gem_exec_schedule (preempt-queue-contexts-chain) [359.829411] Subtest preempt-queue-contexts-chain: SKIP (0.000s) [360.119246] [078/133] (661s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [360.208091] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [360.212825] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s) [360.281105] [079/133] (661s left) perf_pmu (rc6) [360.317099] Starting subtest: rc6 [360.319352] Starting dynamic subtest: gt0 [366.737412] Dynamic subtest gt0: SUCCESS (6.367s) [366.749140] Starting dynamic subtest: runtime-pm-gt0 [374.438314] Dynamic subtest runtime-pm-gt0: SUCCESS (7.752s) [374.450154] Starting dynamic subtest: runtime-pm-long-gt0 [386.861004] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.421s) [386.873143] Starting dynamic subtest: other-idle-gt0 [393.205088] Dynamic subtest other-idle-gt0: SUCCESS (6.342s) [393.216726] Starting dynamic subtest: gt1 [399.546675] Dynamic subtest gt1: SUCCESS (6.340s) [399.558765] Starting dynamic subtest: runtime-pm-gt1 [407.069781] Dynamic subtest runtime-pm-gt1: SUCCESS (7.521s) [407.078593] Starting dynamic subtest: runtime-pm-long-gt1 [419.503109] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.433s) [419.515030] Starting dynamic subtest: other-idle-gt1 [425.899256] Dynamic subtest other-idle-gt1: SUCCESS (6.342s) [425.901738] Subtest rc6: SUCCESS (65.535s) [426.975548] [080/133] (594s left) perf (per-context-mode-unprivileged) [427.037932] Starting subtest: per-context-mode-unprivileged [427.042268] Subtest per-context-mode-unprivileged: SKIP (0.000s) [427.086677] [081/133] (594s left) api_intel_allocator (reopen) [427.141998] Starting subtest: reopen [427.143824] Subtest reopen: SUCCESS (0.004s) [427.242274] [082/133] (594s left) kms_psr (pr-primary-page-flip) [427.328046] Starting subtest: pr-primary-page-flip [427.331750] Subtest pr-primary-page-flip: SKIP (0.000s) [427.376768] [083/133] (594s left) kms_lease (lessee-list) [427.455736] Starting subtest: lessee-list [427.457539] Starting dynamic subtest: pipe-A-eDP-1 [427.459363] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s) [427.468488] Starting dynamic subtest: pipe-B-eDP-1 [427.470225] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [427.477981] Starting dynamic subtest: pipe-C-eDP-1 [427.479713] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [427.487399] Starting dynamic subtest: pipe-D-eDP-1 [427.489128] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [427.490842] Subtest lessee-list: SUCCESS (0.009s) [427.544550] [084/133] (593s left) i915_drm_fdinfo (isolation) [427.581183] Starting subtest: isolation [427.582978] Starting dynamic subtest: rcs0 [427.607878] Dynamic subtest rcs0: SKIP (0.026s) [427.616758] Starting dynamic subtest: bcs0 [427.620160] Dynamic subtest bcs0: SKIP (0.000s) [427.627995] Starting dynamic subtest: vcs0 [427.631253] Dynamic subtest vcs0: SKIP (0.000s) [427.638976] Starting dynamic subtest: vcs1 [427.642153] Dynamic subtest vcs1: SKIP (0.000s) [427.649856] Starting dynamic subtest: vecs0 [427.653098] Dynamic subtest vecs0: SKIP (0.000s) [427.660748] Starting dynamic subtest: ccs0 [427.663981] Dynamic subtest ccs0: SKIP (0.000s) [427.667297] Subtest isolation: SKIP (0.032s) [427.701806] [085/133] (593s left) gen9_exec_parse (bb-oversize) [427.762559] Subtest bb-oversize: SKIP (0.000s) [427.829291] [086/133] (593s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [427.932543] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip [427.936234] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [428.004363] [087/133] (593s left) kms_joiner (basic-big-joiner) [428.107610] Starting subtest: basic-big-joiner [428.111266] Subtest basic-big-joiner: SKIP (0.000s) [428.148131] [088/133] (593s left) prime_mmap (test_forked_cpu_write) [428.202116] Starting subtest: test_forked_cpu_write [428.203755] Starting dynamic subtest: test_forked_cpu_write-smem [428.209816] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.009s) [428.211744] Subtest test_forked_cpu_write: SUCCESS (0.010s) [428.294817] [089/133] (593s left) syncobj_timeline (wait-all-for-submit-snapshot) [428.348407] Starting subtest: wait-all-for-submit-snapshot [428.430099] Subtest wait-all-for-submit-snapshot: SUCCESS (0.083s) [428.484330] [090/133] (593s left) i915_pm_freq_mult (media-freq) [428.551760] Starting subtest: media-freq [428.553858] Starting dynamic subtest: gt0 [428.557579] Dynamic subtest gt0: SKIP (0.000s) [428.567752] Starting dynamic subtest: gt1 [428.570994] Dynamic subtest gt1: SKIP (0.000s) [428.574364] Subtest media-freq: SKIP (0.002s) [428.635373] [091/133] (593s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt) [428.738919] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt [428.742388] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [428.814497] [092/133] (592s left) kms_big_fb (linear-32bpp-rotate-90) [428.921460] Starting subtest: linear-32bpp-rotate-90 [428.940324] Subtest linear-32bpp-rotate-90: SKIP (0.018s) [429.017153] [093/133] (592s left) gem_exec_reloc (basic-gtt-read) [429.084562] Subtest basic-gtt-read: SKIP (0.000s) [429.157695] [094/133] (592s left) kms_psr (fbc-pr-no-drrs) [429.250797] Starting subtest: fbc-pr-no-drrs [429.254234] Subtest fbc-pr-no-drrs: SKIP (0.000s) [429.299436] [095/133] (592s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc) [429.389683] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc [433.379582] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (3.994s) [434.508321] [096/133] (587s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs) [434.596014] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs [434.598394] Starting dynamic subtest: pipe-A-eDP-1 [434.622130] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [434.633548] Starting dynamic subtest: pipe-B-eDP-1 [434.655327] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [434.663485] Starting dynamic subtest: pipe-C-eDP-1 [434.685181] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [434.693513] Starting dynamic subtest: pipe-D-eDP-1 [434.716161] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [434.720449] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.004s) [436.770103] [097/133] (585s left) kms_big_fb (yf-tiled-8bpp-rotate-270) [436.872918] Starting subtest: yf-tiled-8bpp-rotate-270 [436.876975] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s) [436.940915] [098/133] (585s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs) [437.022601] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs [437.024516] Starting dynamic subtest: pipe-A-eDP-1 [437.427427] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.405s) [437.439569] Starting dynamic subtest: pipe-B-eDP-1 [437.459977] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s) [437.472544] Starting dynamic subtest: pipe-C-eDP-1 [437.492616] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.003s) [437.500802] Starting dynamic subtest: pipe-D-eDP-1 [437.519052] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s) [437.520904] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.420s) [439.738212] [099/133] (582s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled) [439.808481] Starting subtest: yf-tiled-to-vebox-yf-tiled [439.813100] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s) [439.972945] [100/133] (582s left) gem_lmem_swapping (verify-random-ccs) [440.007019] Subtest verify-random-ccs: SKIP (0.000s) [440.054968] [101/133] (582s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions) [440.176258] Starting subtest: short-busy-flip-before-cursor-atomic-transitions [440.180798] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s) [440.297484] [102/133] (581s left) kms_fence_pin_leak [440.456029] [103/133] (581s left) kms_getfb (getfb2-handle-closed) [440.551608] Starting subtest: getfb2-handle-closed [440.553852] Subtest getfb2-handle-closed: SUCCESS (0.000s) [440.624432] [104/133] (581s left) perf (non-system-wide-paranoid) [440.688237] Starting subtest: non-system-wide-paranoid [440.707493] Subtest non-system-wide-paranoid: SUCCESS (0.023s) [440.755588] [105/133] (581s left) kms_vrr (flip-basic) [440.833987] Starting subtest: flip-basic [440.840562] Subtest flip-basic: SKIP (0.000s) [440.884142] [106/133] (581s left) gem_ctx_param (invalid-get-engines) [440.935205] Starting subtest: invalid-get-engines [440.937130] Subtest invalid-get-engines: SUCCESS (0.001s) [441.013636] [107/133] (581s left) kms_flip (basic-plain-flip) [441.105195] Starting subtest: basic-plain-flip [441.107253] Starting dynamic subtest: A-eDP1 [442.750800] Dynamic subtest A-eDP1: SUCCESS (1.644s) [442.762213] Starting dynamic subtest: B-eDP1 [444.396388] Dynamic subtest B-eDP1: SUCCESS (1.643s) [444.407565] Starting dynamic subtest: C-eDP1 [446.017424] Dynamic subtest C-eDP1: SUCCESS (1.619s) [446.028483] Starting dynamic subtest: D-eDP1 [447.643909] Dynamic subtest D-eDP1: SUCCESS (1.626s) [447.649183] Subtest basic-plain-flip: SUCCESS (6.545s) [448.827994] [108/133] (573s left) syncobj_wait (wait-all-delayed-signal) [448.883877] Starting subtest: wait-all-delayed-signal [448.986000] Subtest wait-all-delayed-signal: SUCCESS (0.103s) [449.041523] [109/133] (573s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf) [449.137843] Starting subtest: pr-overlay-plane-update-continuous-sf [449.142183] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s) [449.182677] [110/133] (573s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25) [449.264843] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25 [449.267182] Starting dynamic subtest: pipe-A [449.327953] Dynamic subtest pipe-A: SUCCESS (0.065s) [449.338093] Starting dynamic subtest: pipe-B [450.456269] Dynamic subtest pipe-B: SUCCESS (1.127s) [450.467805] Starting dynamic subtest: pipe-C [451.561108] Dynamic subtest pipe-C: SUCCESS (1.103s) [451.571103] Starting dynamic subtest: pipe-D [452.692181] Dynamic subtest pipe-D: SUCCESS (1.130s) [452.694487] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.430s) [453.831393] [111/133] (568s left) drm_buddy (drm_buddy) [453.875066] Starting subtest: drm_buddy [453.879536] Subtest drm_buddy: SKIP (0.001s) [453.917605] [112/133] (568s left) gem_mmap_gtt (ptrace) [453.972388] Subtest ptrace: SKIP (0.000s) [454.031745] [113/133] (568s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu) [454.123000] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu [461.104227] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.985s) [461.184792] [114/133] (561s left) kms_getfb (getfb-handle-valid) [461.273959] Starting subtest: getfb-handle-valid [461.276144] Subtest getfb-handle-valid: SUCCESS (0.000s) [461.343536] [115/133] (561s left) syncobj_timeline (etime-single-wait-all-submitted) [461.392516] Starting subtest: etime-single-wait-all-submitted [461.495223] Subtest etime-single-wait-all-submitted: SUCCESS (0.102s) [461.554010] [116/133] (561s left) gem_exec_whisper (basic-queues-priority-all) [461.614582] Starting subtest: basic-queues-priority-all [483.343798] Subtest basic-queues-priority-all: SUCCESS (21.731s) [483.509805] [117/133] (539s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted) [483.559899] Starting subtest: multi-wait-for-submit-unsubmitted-submitted [483.662763] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.105s) [483.721039] [118/133] (539s left) kms_draw_crc (draw-method-pwrite) [483.815746] Starting subtest: draw-method-pwrite [483.817950] Starting dynamic subtest: xrgb8888-untiled [484.381892] Dynamic subtest xrgb8888-untiled: SUCCESS (0.567s) [484.391207] Starting dynamic subtest: rgb565-untiled [484.815199] Dynamic subtest rgb565-untiled: SUCCESS (0.432s) [484.826611] Starting dynamic subtest: xrgb2101010-untiled [485.359366] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.544s) [485.369110] Starting dynamic subtest: xbgr16161616f-untiled [486.081742] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.722s) [486.091019] Starting dynamic subtest: xrgb8888-xtiled [487.758852] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.677s) [487.768032] Starting dynamic subtest: rgb565-xtiled [488.792465] Dynamic subtest rgb565-xtiled: SUCCESS (1.032s) [488.803329] Starting dynamic subtest: xrgb2101010-xtiled [490.436409] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.643s) [490.446500] Starting dynamic subtest: xbgr16161616f-xtiled [493.524997] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.088s) [493.534413] Starting dynamic subtest: xrgb8888-4tiled [494.547886] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.021s) [494.559608] Starting dynamic subtest: rgb565-4tiled [495.070046] Dynamic subtest rgb565-4tiled: SUCCESS (0.521s) [495.079402] Starting dynamic subtest: xrgb2101010-4tiled [496.113310] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.042s) [496.124277] Starting dynamic subtest: xbgr16161616f-4tiled [498.957981] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.844s) [498.960345] Subtest draw-method-pwrite: SUCCESS (15.147s) [499.043582] [119/133] (523s left) sw_sync (sync_expired_merge) [499.086216] Starting subtest: sync_expired_merge [500.159128] Subtest sync_expired_merge: SUCCESS (1.074s) [500.198562] [120/133] (522s left) kms_color (legacy-gamma-reset) [500.288270] Starting subtest: legacy-gamma-reset [500.290162] Starting dynamic subtest: pipe-A-eDP-1 [500.665316] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.378s) [500.674655] Starting dynamic subtest: pipe-B-eDP-1 [500.676994] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.012s) [500.688268] Starting dynamic subtest: pipe-C-eDP-1 [500.690724] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.013s) [500.699760] Starting dynamic subtest: pipe-D-eDP-1 [500.708782] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.018s) [500.711116] Subtest legacy-gamma-reset: SUCCESS (0.423s) [501.467168] [121/133] (521s left) core_auth (getclient-simple) [501.496896] Starting subtest: getclient-simple [501.513216] Subtest getclient-simple: SUCCESS (0.014s) [501.581976] [122/133] (521s left) intel_hwmon (hwmon-write) [501.655876] Subtest hwmon-write: SKIP (0.000s) [501.737043] [123/133] (521s left) kms_big_fb (x-tiled-8bpp-rotate-0) [501.841105] Starting subtest: x-tiled-8bpp-rotate-0 [503.032300] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.192s) [503.122669] [124/133] (520s left) kms_psr (fbc-psr2-basic) [503.207866] Starting subtest: fbc-psr2-basic [503.210170] Starting dynamic subtest: eDP-1 [503.213937] Dynamic subtest eDP-1: SKIP (0.000s) [503.217511] Subtest fbc-psr2-basic: SKIP (0.001s) [503.256430] [125/133] (519s left) gem_ctx_persistence (legacy-engines-hang) [503.318782] Starting subtest: legacy-engines-hang [503.320808] Starting dynamic subtest: render [503.386742] Dynamic subtest render: SUCCESS (0.068s) [503.400509] Starting dynamic subtest: bsd1 [503.479945] Dynamic subtest bsd1: SUCCESS (0.091s) [503.492741] Starting dynamic subtest: bsd2 [503.590249] Dynamic subtest bsd2: SUCCESS (0.107s) [503.609282] Starting dynamic subtest: blt [503.613653] Dynamic subtest blt: SUCCESS (0.019s) [503.621763] Starting dynamic subtest: vebox [503.729209] Dynamic subtest vebox: SUCCESS (0.116s) [503.731421] Subtest legacy-engines-hang: SUCCESS (0.412s) [503.787058] [126/133] (519s left) kms_flip (2x-wf_vblank-ts-check) [503.882658] Starting subtest: 2x-wf_vblank-ts-check [503.891398] Subtest 2x-wf_vblank-ts-check: SKIP (0.010s) [503.946571] [127/133] (519s left) gem_exec_store (dword) [504.005760] Starting subtest: dword [504.007528] Starting dynamic subtest: rcs0 [504.080300] Dynamic subtest rcs0: SUCCESS (0.075s) [504.094558] Starting dynamic subtest: bcs0 [504.123595] Dynamic subtest bcs0: SUCCESS (0.041s) [504.139121] Starting dynamic subtest: vcs0 [504.165919] Dynamic subtest vcs0: SUCCESS (0.041s) [504.177287] Starting dynamic subtest: vcs1 [504.207786] Dynamic subtest vcs1: SUCCESS (0.040s) [504.217664] Starting dynamic subtest: vecs0 [504.249193] Dynamic subtest vecs0: SUCCESS (0.039s) [504.259396] Starting dynamic subtest: ccs0 [504.291955] Dynamic subtest ccs0: SUCCESS (0.040s) [504.294123] Subtest dword: SUCCESS (0.288s) [504.454313] [128/133] (518s left) kms_flip (nonexisting-fb-interruptible) [504.541933] Starting subtest: nonexisting-fb-interruptible [504.544278] Starting dynamic subtest: A-eDP1 [505.669560] Dynamic subtest A-eDP1: SUCCESS (1.127s) [505.682683] Starting dynamic subtest: B-eDP1 [506.790339] Dynamic subtest B-eDP1: SUCCESS (1.118s) [506.802375] Starting dynamic subtest: C-eDP1 [507.919136] Dynamic subtest C-eDP1: SUCCESS (1.127s) [507.934610] Starting dynamic subtest: D-eDP1 [509.050044] Dynamic subtest D-eDP1: SUCCESS (1.130s) [509.052368] Subtest nonexisting-fb-interruptible: SUCCESS (4.513s) [510.208395] [129/133] (513s left) kms_plane_cursor (primary) [510.302309] Starting subtest: primary [510.306768] Starting dynamic subtest: pipe-A-eDP-1-size-64 [512.896392] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.596s) [512.921490] Starting dynamic subtest: pipe-A-eDP-1-size-128 [515.486505] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.571s) [515.512494] Starting dynamic subtest: pipe-A-eDP-1-size-256 [518.088091] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.583s) [518.403512] Starting dynamic subtest: pipe-B-eDP-1-size-64 [521.704452] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.313s) [521.728415] Starting dynamic subtest: pipe-B-eDP-1-size-128 [524.293755] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.571s) [524.322920] Starting dynamic subtest: pipe-B-eDP-1-size-256 [526.904018] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.594s) [527.225303] Starting dynamic subtest: pipe-C-eDP-1-size-64 [530.159755] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.945s) [530.185966] Starting dynamic subtest: pipe-C-eDP-1-size-128 [532.415081] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.236s) [532.442646] Starting dynamic subtest: pipe-C-eDP-1-size-256 [534.625380] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.191s) [534.947164] Starting dynamic subtest: pipe-D-eDP-1-size-64 [537.882181] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.949s) [537.908716] Starting dynamic subtest: pipe-D-eDP-1-size-128 [540.058914] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.158s) [540.086675] Starting dynamic subtest: pipe-D-eDP-1-size-256 [542.247989] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.169s) [542.558528] Subtest primary: SUCCESS (32.262s) [543.417611] [130/133] (479s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu) [543.527645] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu [550.291087] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.768s) [550.380244] [131/133] (473s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted) [550.443174] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted [550.551404] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.108s) [550.605817] [132/133] (472s left) kms_selftest (drm_framebuffer) [550.646228] Starting subtest: drm_framebuffer [550.707484] Starting dynamic subtest: drm_test_framebuffer_check_src_coords [550.808301] Dynamic subtest drm_test_framebuffer_check_src_coords: SUCCESS (0.103s) [550.817650] Starting dynamic subtest: drm_test_framebuffer_cleanup [550.915214] Dynamic subtest drm_test_framebuffer_cleanup: SUCCESS (0.106s) [550.926524] Starting dynamic subtest: drm_test_framebuffer_create [551.104447] Dynamic subtest drm_test_framebuffer_create: SUCCESS (0.186s) [551.114590] Starting dynamic subtest: drm_test_framebuffer_free [551.358301] Dynamic subtest drm_test_framebuffer_free: FAIL (0.190s) [551.362954] Subtest drm_framebuffer: FAIL (0.649s) [551.422301] Aborting: Kernel badly tainted (0x44244, 0x200) (check dmesg for details): TAINT_WARN: WARN_ON has happened. [551.440096] [FACT kms_selftest (drm_framebuffer)] new: kernel.is_tainted.taint_warn: true [551.440893] Closing watchdogs results: parsing output: 0/ for test: gem_exec_balancer results: parsing output: 1/ for test: kms_flip results: parsing output: 2/ for test: i915_suspend results: parsing output: 3/ for test: kms_psr results: parsing output: 4/ for test: kms_plane results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: kms_frontbuffer_tracking results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: kms_pipe_crc_basic results: parsing output: 9/ for test: kms_psr results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: testdisplay results: parsing output: 14/ for test: syncobj_timeline results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: gem_vm_create results: parsing output: 17/ for test: kms_addfb_basic results: parsing output: 18/ for test: gem_softpin results: parsing output: 19/ for test: i915_hangman results: parsing output: 20/ for test: kms_plane results: parsing output: 21/ for test: perf_pmu results: parsing output: 22/ for test: gem_exec_capture results: parsing output: 23/ for test: prime_vgem results: parsing output: 24/ for test: gem_exec_fence results: parsing output: 25/ for test: prime_vgem results: parsing output: 26/ for test: gem_flink_basic results: parsing output: 27/ for test: gem_pxp results: parsing output: 28/ for test: kms_cursor_legacy results: parsing output: 29/ for test: gem_exec_reloc results: parsing output: 30/ for test: syncobj_timeline results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: kms_flip results: parsing output: 33/ for test: gen3_render_tiledy_blits results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: perf results: parsing output: 37/ for test: kms_big_fb results: parsing output: 38/ for test: gem_ccs results: parsing output: 39/ for test: gem_exec_params results: parsing output: 40/ for test: gem_pread results: parsing output: 41/ for test: kms_cursor_legacy results: parsing output: 42/ for test: gem_exec_reloc results: parsing output: 43/ for test: kms_ccs results: parsing output: 44/ for test: i915_query results: parsing output: 45/ for test: kms_ccs results: parsing output: 46/ for test: kms_big_fb results: parsing output: 47/ for test: kms_prop_blob results: parsing output: 48/ for test: kms_ccs results: parsing output: 49/ for test: kms_content_protection results: parsing output: 50/ for test: kms_pm_rpm results: parsing output: 51/ for test: gem_ctx_shared results: parsing output: 52/ for test: kms_pm_rpm results: parsing output: 53/ for test: sysfs_defaults results: parsing output: 54/ for test: kms_psr results: parsing output: 55/ for test: gem_basic results: parsing output: 56/ for test: kms_cursor_legacy results: parsing output: 57/ for test: perf results: parsing output: 58/ for test: gem_render_copy_redux results: parsing output: 59/ for test: kms_chamelium_color results: parsing output: 60/ for test: kms_cursor_edge_walk results: parsing output: 61/ for test: kms_vrr results: parsing output: 62/ for test: kms_big_fb results: parsing output: 63/ for test: gem_exec_fence results: parsing output: 64/ for test: kms_frontbuffer_tracking results: parsing output: 65/ for test: gem_mmap_offset results: parsing output: 66/ for test: kms_flip_scaled_crc results: parsing output: 67/ for test: kms_chamelium_hpd results: parsing output: 68/ for test: gem_ctx_engines results: parsing output: 69/ for test: gem_exec_schedule results: parsing output: 70/ for test: kms_atomic_transition results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: syncobj_wait results: parsing output: 73/ for test: kms_cursor_crc results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: syncobj_wait results: parsing output: 76/ for test: gem_exec_schedule results: parsing output: 77/ for test: kms_flip_scaled_crc results: parsing output: 78/ for test: perf_pmu results: parsing output: 79/ for test: perf results: parsing output: 80/ for test: api_intel_allocator results: parsing output: 81/ for test: kms_psr results: parsing output: 82/ for test: kms_lease results: parsing output: 83/ for test: i915_drm_fdinfo results: parsing output: 84/ for test: gen9_exec_parse results: parsing output: 85/ for test: kms_big_fb results: parsing output: 86/ for test: kms_joiner results: parsing output: 87/ for test: prime_mmap results: parsing output: 88/ for test: syncobj_timeline results: parsing output: 89/ for test: i915_pm_freq_mult results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: kms_big_fb results: parsing output: 92/ for test: gem_exec_reloc results: parsing output: 93/ for test: kms_psr results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: kms_ccs results: parsing output: 96/ for test: kms_big_fb results: parsing output: 97/ for test: kms_ccs results: parsing output: 98/ for test: gem_render_copy results: parsing output: 99/ for test: gem_lmem_swapping results: parsing output: 100/ for test: kms_cursor_legacy results: parsing output: 101/ for test: kms_fence_pin_leak results: parsing output: 102/ for test: kms_getfb results: parsing output: 103/ for test: perf results: parsing output: 104/ for test: kms_vrr results: parsing output: 105/ for test: gem_ctx_param results: parsing output: 106/ for test: kms_flip results: parsing output: 107/ for test: syncobj_wait results: parsing output: 108/ for test: kms_psr2_sf results: parsing output: 109/ for test: kms_plane_scaling results: parsing output: 110/ for test: drm_buddy results: parsing output: 111/ for test: gem_mmap_gtt results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: kms_getfb results: parsing output: 114/ for test: syncobj_timeline results: parsing output: 115/ for test: gem_exec_whisper results: parsing output: 116/ for test: syncobj_wait results: parsing output: 117/ for test: kms_draw_crc results: parsing output: 118/ for test: sw_sync results: parsing output: 119/ for test: kms_color results: parsing output: 120/ for test: core_auth results: parsing output: 121/ for test: intel_hwmon results: parsing output: 122/ for test: kms_big_fb results: parsing output: 123/ for test: kms_psr results: parsing output: 124/ for test: gem_ctx_persistence results: parsing output: 125/ for test: kms_flip results: parsing output: 126/ for test: gem_exec_store results: parsing output: 127/ for test: kms_flip results: parsing output: 128/ for test: kms_plane_cursor results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: syncobj_timeline results: parsing output: 131/ for test: kms_selftest results: parsing output: 132/ for test: kms_cursor_crc results: no output, setting notrun Done.