[62.978642] Initializing watchdogs [62.978691] /dev/watchdog0 [62.994146] [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] [62.998803] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [63.001111] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [63.003419] [001/133] (960s left) gem_exec_balancer (indices) [63.069351] Starting subtest: indices [65.917830] Subtest indices: SUCCESS (2.839s) [66.225107] [002/133] (957s left) kms_flip (2x-plain-flip-interruptible) [66.321926] Starting subtest: 2x-plain-flip-interruptible [66.333033] Subtest 2x-plain-flip-interruptible: SKIP (0.011s) [66.416544] [003/133] (957s left) i915_suspend (debugfs-reader) [66.459274] Starting subtest: debugfs-reader [84.779724] Subtest debugfs-reader: SUCCESS (3.692s) [91.899232] [004/133] (938s left) kms_psr (fbc-psr-sprite-plane-onoff) [91.990071] Starting subtest: fbc-psr-sprite-plane-onoff [91.991230] Starting dynamic subtest: eDP-1 [91.992876] Dynamic subtest eDP-1: SKIP (0.000s) [91.994593] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.000s) [92.067531] [005/133] (938s left) kms_plane (plane-panning-top-left) [92.172800] Starting subtest: plane-panning-top-left [92.173842] Starting dynamic subtest: pipe-A [93.920153] Dynamic subtest pipe-A: SUCCESS (1.755s) [93.929062] Starting dynamic subtest: pipe-B [96.341126] Dynamic subtest pipe-B: SUCCESS (2.433s) [96.342173] Subtest plane-panning-top-left: SUCCESS (4.189s) [97.147104] [006/133] (933s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt) [97.238354] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt [97.240035] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [97.334387] [007/133] (933s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt) [97.414434] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt [97.416060] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [97.506110] [008/133] (933s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt) [97.600335] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt [97.602007] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [97.678588] [009/133] (933s left) kms_pipe_crc_basic (read-crc-frame-sequence) [97.772260] Starting subtest: read-crc-frame-sequence [97.773221] Starting dynamic subtest: pipe-A-eDP-1 [98.486489] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.715s) [98.493540] Starting dynamic subtest: pipe-B-eDP-1 [99.908426] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.426s) [99.917559] Starting dynamic subtest: pipe-C-eDP-1 [101.304548] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.399s) [101.311417] Starting dynamic subtest: pipe-D-eDP-1 [102.616035] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.314s) [102.616954] Subtest read-crc-frame-sequence: SUCCESS (4.858s) [103.429122] [010/133] (927s left) kms_psr (psr-primary-mmap-cpu) [103.525709] Starting subtest: psr-primary-mmap-cpu [103.526674] Starting dynamic subtest: eDP-1 [105.237549] Dynamic subtest eDP-1: SUCCESS (1.715s) [105.238368] Subtest psr-primary-mmap-cpu: SUCCESS (1.715s) [106.107653] [011/133] (924s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt) [106.207017] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt [106.208827] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [106.298788] [012/133] (924s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move) [106.393818] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move [113.801612] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.417s) [113.915676] [013/133] (917s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite) [114.006548] Starting subtest: psr-rgb565-draw-pwrite [121.170193] Subtest psr-rgb565-draw-pwrite: SUCCESS (7.170s) [121.264564] [014/133] (909s left) testdisplay [121.570254] [015/133] (909s left) syncobj_timeline (invalid-wait-illegal-handle) [121.612993] Starting subtest: invalid-wait-illegal-handle [121.614537] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [121.701685] [016/133] (909s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc) [121.795976] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc [128.622753] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.815s) [128.742779] [017/133] (902s left) gem_vm_create (invalid-destroy) [128.803098] Starting subtest: invalid-destroy [128.805365] Subtest invalid-destroy: SUCCESS (0.002s) [128.895130] [018/133] (902s left) kms_addfb_basic (unused-pitches) [128.942913] Starting subtest: unused-pitches [128.943753] Subtest unused-pitches: SUCCESS (0.000s) [129.078756] [019/133] (902s left) gem_softpin (zero) [129.137701] Starting subtest: zero [129.142961] Subtest zero: SUCCESS (0.005s) [129.268221] [020/133] (901s left) i915_hangman (engine-engine-error) [129.323735] Starting subtest: engine-engine-error [129.324775] Starting dynamic subtest: rcs0 [130.535654] Dynamic subtest rcs0: SUCCESS (1.201s) [130.545854] Starting dynamic subtest: bcs0 [132.517187] Dynamic subtest bcs0: SUCCESS (1.980s) [132.526588] Starting dynamic subtest: vcs0 [134.501111] Dynamic subtest vcs0: SUCCESS (1.982s) [134.510753] Starting dynamic subtest: vcs1 [136.484980] Dynamic subtest vcs1: SUCCESS (1.982s) [136.494430] Starting dynamic subtest: vecs0 [138.532704] Dynamic subtest vecs0: SUCCESS (2.046s) [138.543817] Starting dynamic subtest: ccs0 [140.517930] Dynamic subtest ccs0: SUCCESS (1.983s) [140.519397] Subtest engine-engine-error: SUCCESS (11.184s) [140.584529] [021/133] (890s left) kms_plane (pixel-format-4-tiled-modifier) [140.700074] Starting subtest: pixel-format-4-tiled-modifier [140.728370] Starting dynamic subtest: pipe-A-plane-0 [141.394933] Dynamic subtest pipe-A-plane-0: SUCCESS (0.667s) [141.402894] Starting dynamic subtest: pipe-A-plane-3 [141.817091] Dynamic subtest pipe-A-plane-3: SUCCESS (0.421s) [141.824187] Starting dynamic subtest: pipe-A-plane-5 [141.825879] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [142.964781] Starting dynamic subtest: pipe-B-plane-0 [143.613984] Dynamic subtest pipe-B-plane-0: SUCCESS (0.656s) [143.621307] Starting dynamic subtest: pipe-B-plane-3 [144.036106] Dynamic subtest pipe-B-plane-3: SUCCESS (0.421s) [144.043993] Starting dynamic subtest: pipe-B-plane-5 [144.045873] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [144.354839] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.655s) [145.223470] [022/133] (886s left) perf_pmu (faulting-read) [145.257504] Starting subtest: faulting-read [145.258596] Starting dynamic subtest: wb [145.259630] Dynamic subtest wb: SUCCESS (0.002s) [145.268915] Starting dynamic subtest: wc [145.269899] Dynamic subtest wc: SUCCESS (0.000s) [145.276905] Starting dynamic subtest: uc [145.277844] Dynamic subtest uc: SUCCESS (0.000s) [145.278771] Subtest faulting-read: SUCCESS (0.003s) [145.362548] [023/133] (885s left) gem_exec_capture (capture) [145.436897] Starting subtest: capture [145.437925] Starting dynamic subtest: rcs0-smem [146.268842] Dynamic subtest rcs0-smem: SUCCESS (0.831s) [146.276244] Starting dynamic subtest: bcs0-smem [147.594347] Dynamic subtest bcs0-smem: SUCCESS (1.325s) [147.601784] Starting dynamic subtest: vcs0-smem [148.415971] Dynamic subtest vcs0-smem: SUCCESS (0.822s) [148.422996] Starting dynamic subtest: vcs1-smem [149.239884] Dynamic subtest vcs1-smem: SUCCESS (0.824s) [149.246666] Starting dynamic subtest: vecs0-smem [150.587785] Dynamic subtest vecs0-smem: FAIL (1.327s) [150.594692] Starting dynamic subtest: ccs0-smem [151.896478] Dynamic subtest ccs0-smem: SUCCESS (1.328s) [151.898054] Subtest capture: FAIL (6.460s) [152.016522] [024/133] (879s left) prime_vgem (basic-write) [152.127477] Starting subtest: basic-write [152.133464] Subtest basic-write: SKIP (0.005s) [152.229211] [FACT prime_vgem (basic-write)] new: kernel.kmod_is_loaded.vgem: true [152.231420] [025/133] (879s left) gem_exec_fence (syncobj-invalid-wait) [152.652489] Starting subtest: syncobj-invalid-wait [152.653513] Subtest syncobj-invalid-wait: SUCCESS (0.001s) [154.653991] [026/133] (876s left) prime_vgem (fence-wait) [154.719558] Starting subtest: fence-wait [154.720536] Starting dynamic subtest: rcs0 [155.761908] Dynamic subtest rcs0: SUCCESS (1.034s) [155.771897] Starting dynamic subtest: bcs0 [156.827758] Dynamic subtest bcs0: SUCCESS (1.065s) [156.837981] Starting dynamic subtest: vcs0 [157.876940] Dynamic subtest vcs0: SUCCESS (1.048s) [157.887728] Starting dynamic subtest: vcs1 [158.918367] Dynamic subtest vcs1: SUCCESS (1.040s) [158.927106] Starting dynamic subtest: vecs0 [159.960012] Dynamic subtest vecs0: SUCCESS (1.040s) [159.969574] Starting dynamic subtest: ccs0 [161.528813] Dynamic subtest ccs0: SUCCESS (1.567s) [161.529924] Subtest fence-wait: SUCCESS (6.804s) [161.673839] [027/133] (869s left) gem_flink_basic (flink-lifetime) [161.723716] Starting subtest: flink-lifetime [161.726321] Subtest flink-lifetime: SUCCESS (0.002s) [161.836095] [028/133] (869s left) gem_pxp (verify-pxp-stale-buf-execution) [161.949961] Starting subtest: verify-pxp-stale-buf-execution [163.021315] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.071s) [163.142069] [029/133] (868s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions) [163.273848] Starting subtest: cursor-vs-flip-atomic-transitions [193.324000] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.054s) [194.149696] [030/133] (837s left) gem_exec_reloc (basic-gtt-noreloc) [194.205648] Subtest basic-gtt-noreloc: SKIP (0.000s) [194.271135] [031/133] (837s left) syncobj_timeline (multi-wait-available-submitted-signaled) [194.329609] Starting subtest: multi-wait-available-submitted-signaled [194.330555] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s) [194.432341] [032/133] (837s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt) [194.525665] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt [198.286998] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.760s) [199.468267] [033/133] (832s left) kms_flip (flip-vs-blocking-wf-vblank) [199.555807] Starting subtest: flip-vs-blocking-wf-vblank [199.558291] Starting dynamic subtest: A-eDP1 [208.491502] Dynamic subtest A-eDP1: SUCCESS (8.931s) [208.502743] Starting dynamic subtest: B-eDP1 [217.422310] Dynamic subtest B-eDP1: SUCCESS (8.927s) [217.434500] Starting dynamic subtest: C-eDP1 [226.367977] Dynamic subtest C-eDP1: SUCCESS (8.907s) [226.375921] Starting dynamic subtest: D-eDP1 [235.301389] Dynamic subtest D-eDP1: SUCCESS (8.931s) [235.302276] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.709s) [236.490632] [034/133] (795s left) gen3_render_tiledy_blits [236.585878] [035/133] (795s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [236.677564] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt [236.679315] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [236.782807] [036/133] (794s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt) [236.871020] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt [236.872813] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [236.966601] [037/133] (794s left) perf (gen8-unprivileged-single-ctx-counters) [237.089096] Starting subtest: gen8-unprivileged-single-ctx-counters [237.091105] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s) [237.126507] [038/133] (794s left) kms_big_fb (4-tiled-8bpp-rotate-90) [237.224678] Starting subtest: 4-tiled-8bpp-rotate-90 [237.248318] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.022s) [237.344085] [039/133] (794s left) gem_ccs (block-multicopy-compressed) [237.391972] Starting subtest: block-multicopy-compressed [237.393706] Subtest block-multicopy-compressed: SKIP (0.000s) [237.481378] [040/133] (794s left) gem_exec_params (invalid-bsd1-flag-on-blt) [237.524608] Starting subtest: invalid-bsd1-flag-on-blt [237.525696] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s) [237.608525] [041/133] (794s left) gem_pread (uncached) [237.657659] Subtest uncached: SKIP (0.000s) [237.708809] [042/133] (794s left) kms_cursor_legacy (cursorb-vs-flipa-toggle) [237.815973] Starting subtest: cursorB-vs-flipA-toggle [237.818812] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s) [237.966779] [043/133] (794s left) gem_exec_reloc (basic-wc-cpu-active) [238.018741] Subtest basic-wc-cpu-active: SKIP (0.000s) [238.082526] [044/133] (793s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs) [238.163458] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs [238.165148] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s) [239.330597] [045/133] (792s left) i915_query (query-topology-matches-eu-total) [239.370200] Starting subtest: query-topology-matches-eu-total [239.371068] Subtest query-topology-matches-eu-total: SUCCESS (0.000s) [239.477614] [046/133] (792s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs) [239.572308] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs [239.573151] Starting dynamic subtest: pipe-A-eDP-1 [239.582209] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [239.590190] Starting dynamic subtest: pipe-B-eDP-1 [239.599322] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [239.606884] Starting dynamic subtest: pipe-C-eDP-1 [239.615608] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [239.623024] Starting dynamic subtest: pipe-D-eDP-1 [239.632027] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [239.633688] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s) [241.803275] [047/133] (790s left) kms_big_fb (yf-tiled-16bpp-rotate-180) [241.928093] Starting subtest: yf-tiled-16bpp-rotate-180 [241.929698] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s) [242.033439] [048/133] (790s left) kms_prop_blob (invalid-get-prop-any) [242.081083] Starting subtest: invalid-get-prop-any [242.082151] Subtest invalid-get-prop-any: SUCCESS (0.000s) [242.168075] [049/133] (790s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs) [242.259385] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs [242.260224] Starting dynamic subtest: pipe-A-eDP-1 [242.268166] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [242.276550] Starting dynamic subtest: pipe-B-eDP-1 [242.283796] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [242.291221] Starting dynamic subtest: pipe-C-eDP-1 [242.298382] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [242.305397] Starting dynamic subtest: pipe-D-eDP-1 [242.312224] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [242.312978] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.005s) [244.582824] [050/133] (787s left) kms_content_protection (lic-type-0-hdcp14) [244.759862] Starting subtest: lic-type-0-hdcp14 [244.761955] Subtest lic-type-0-hdcp14: SKIP (0.000s) [244.883333] [051/133] (787s left) kms_pm_rpm (basic-rte) [244.911648] Starting subtest: basic-rte [248.169906] Subtest basic-rte: SUCCESS (3.259s) [250.000248] [052/133] (782s left) gem_ctx_shared (q-promotion) [250.059253] Starting subtest: Q-promotion [250.060072] Starting dynamic subtest: rcs0 [250.158900] Dynamic subtest rcs0: SUCCESS (0.099s) [250.175607] Starting dynamic subtest: vcs0 [250.253641] Dynamic subtest vcs0: SUCCESS (0.094s) [250.270169] Starting dynamic subtest: vcs1 [250.334342] Dynamic subtest vcs1: SUCCESS (0.078s) [250.350934] Starting dynamic subtest: vecs0 [250.405939] Dynamic subtest vecs0: SUCCESS (0.071s) [250.422361] Starting dynamic subtest: ccs0 [250.482729] Dynamic subtest ccs0: SUCCESS (0.076s) [250.484249] Subtest Q-promotion: SUCCESS (0.423s) [251.600274] [053/133] (780s left) kms_pm_rpm (universal-planes-dpms) [253.725979] Starting subtest: universal-planes-dpms [253.727609] Starting dynamic subtest: plane-35 [262.138998] Dynamic subtest plane-35: SUCCESS (8.414s) [262.150118] Starting dynamic subtest: plane-65 [270.481933] Dynamic subtest plane-65: SUCCESS (8.341s) [270.494243] Starting dynamic subtest: plane-95 [278.914657] Dynamic subtest plane-95: SUCCESS (8.432s) [278.926832] Starting dynamic subtest: plane-125 [287.256860] Dynamic subtest plane-125: SUCCESS (8.341s) [287.269416] Starting dynamic subtest: plane-135 [295.579592] Dynamic subtest plane-135: SUCCESS (8.322s) [295.592403] Starting dynamic subtest: plane-145 [304.205103] Dynamic subtest plane-145: SUCCESS (8.625s) [304.206634] Subtest universal-planes-dpms: SUCCESS (50.492s) [304.594861] [054/133] (727s left) sysfs_defaults (readonly) [304.653541] Starting subtest: readonly [304.654438] Starting dynamic subtest: vecs0 [304.655324] Dynamic subtest vecs0: SUCCESS (0.000s) [304.665013] Starting dynamic subtest: ccs0 [304.665941] Dynamic subtest ccs0: SUCCESS (0.000s) [304.673651] Starting dynamic subtest: vcs0 [304.674510] Dynamic subtest vcs0: SUCCESS (0.000s) [304.681623] Starting dynamic subtest: bcs0 [304.682642] Dynamic subtest bcs0: SUCCESS (0.000s) [304.689844] Starting dynamic subtest: rcs0 [304.690736] Dynamic subtest rcs0: SUCCESS (0.000s) [304.698110] Starting dynamic subtest: vcs1 [304.698999] Dynamic subtest vcs1: SUCCESS (0.000s) [304.699885] Subtest readonly: SUCCESS (0.006s) [304.728865] [055/133] (727s left) kms_psr (psr2-sprite-blt) [304.824588] Starting subtest: psr2-sprite-blt [304.825501] Starting dynamic subtest: eDP-1 [306.563374] Dynamic subtest eDP-1: SUCCESS (1.740s) [306.564189] Subtest psr2-sprite-blt: SUCCESS (1.741s) [307.425961] [056/133] (725s left) gem_basic (create-close) [307.477752] Starting subtest: create-close [307.479473] Subtest create-close: SUCCESS (0.000s) [307.581197] [057/133] (724s left) kms_cursor_legacy (cursora-vs-flipa-legacy) [307.690850] Starting subtest: cursorA-vs-flipA-legacy [318.828387] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.137s) [319.659326] [058/133] (712s left) perf (enable-disable) [319.740078] Starting subtest: enable-disable [319.741177] Starting dynamic subtest: 0-rcs0 [322.012646] Dynamic subtest 0-rcs0: SUCCESS (2.260s) [322.023231] Starting dynamic subtest: 1-vecs0 [326.484208] Dynamic subtest 1-vecs0: SUCCESS (4.469s) [326.485748] Subtest enable-disable: SUCCESS (6.732s) [326.520207] [059/133] (706s left) gem_render_copy_redux (normal) [326.584046] Starting subtest: normal [326.944335] Subtest normal: SUCCESS (0.362s) [327.079665] [060/133] (705s left) kms_chamelium_color (degamma) [327.166331] Subtest degamma: SKIP (0.000s) [327.209688] [061/133] (705s left) kms_cursor_edge_walk (256x256-top-edge) [327.290577] Starting subtest: 256x256-top-edge [327.291491] Starting dynamic subtest: pipe-A-eDP-1 [330.739853] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.447s) [330.747355] Starting dynamic subtest: pipe-D-eDP-1 [333.863544] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.121s) [333.864391] Subtest 256x256-top-edge: SUCCESS (6.571s) [334.682957] [062/133] (697s left) kms_vrr (flip-suspend) [334.766584] Starting subtest: flip-suspend [334.769086] Subtest flip-suspend: SKIP (0.000s) [334.834089] [063/133] (697s left) kms_big_fb (y-tiled-16bpp-rotate-0) [334.936949] Starting subtest: y-tiled-16bpp-rotate-0 [334.938620] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s) [335.024481] [064/133] (697s left) gem_exec_fence (syncobj-wait) [335.447802] Starting subtest: syncobj-wait [336.537900] Subtest syncobj-wait: SUCCESS (1.081s) [336.859294] [065/133] (695s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary) [336.973000] Starting subtest: psr-indfb-scaledprimary [342.779474] Subtest psr-indfb-scaledprimary: SUCCESS (5.820s) [342.902020] [066/133] (689s left) gem_mmap_offset (ptrace) [342.957426] Starting subtest: ptrace [342.959523] Starting dynamic subtest: smem0-wb [342.977754] Dynamic subtest smem0-wb: SUCCESS (0.018s) [342.988226] Starting dynamic subtest: smem0-wc [342.997462] Dynamic subtest smem0-wc: SUCCESS (0.019s) [343.004893] Starting dynamic subtest: smem0-uc [343.013999] Dynamic subtest smem0-uc: SUCCESS (0.016s) [343.014836] Subtest ptrace: SUCCESS (0.058s) [343.117579] [067/133] (689s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling) [343.195901] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling [343.196810] Starting dynamic subtest: pipe-A-default-mode [345.949332] Dynamic subtest pipe-A-default-mode: SUCCESS (2.753s) [345.950232] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.754s) [346.778458] [068/133] (686s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode) [347.160180] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s) [347.984981] [069/133] (684s left) gem_ctx_engines (execute-one) [348.032393] Starting subtest: execute-one [350.509084] Subtest execute-one: SUCCESS (2.477s) [350.688944] [070/133] (682s left) gem_exec_schedule (pi-shared-iova) [350.859834] Starting subtest: pi-shared-iova [350.860936] Starting dynamic subtest: rcs0 [351.015076] Dynamic subtest rcs0: SUCCESS (0.147s) [351.026831] Starting dynamic subtest: vcs0 [351.092670] Dynamic subtest vcs0: SUCCESS (0.085s) [351.103758] Starting dynamic subtest: vcs1 [351.176269] Dynamic subtest vcs1: SUCCESS (0.082s) [351.187788] Starting dynamic subtest: vecs0 [351.258546] Dynamic subtest vecs0: SUCCESS (0.082s) [351.270460] Starting dynamic subtest: ccs0 [351.367049] Dynamic subtest ccs0: SUCCESS (0.107s) [351.368522] Subtest pi-shared-iova: SUCCESS (0.509s) [352.664067] [071/133] (680s left) kms_atomic_transition (modeset-transition) [352.751536] Starting subtest: modeset-transition [352.752481] Starting dynamic subtest: 1x-outputs [363.557772] Dynamic subtest 1x-outputs: SUCCESS (10.803s) [363.559011] Subtest modeset-transition: SUCCESS (10.805s) [364.425418] [072/133] (668s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move) [364.508633] Starting subtest: fbc-2p-scndscrn-spr-indfb-move [364.510323] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [364.602080] [073/133] (668s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled) [364.652897] Starting subtest: invalid-multi-wait-unsubmitted-signaled [364.653842] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s) [364.753003] [074/133] (668s left) kms_cursor_crc (cursor-onscreen-64x64) [364.917706] Starting subtest: cursor-onscreen-64x64 [364.921562] Starting dynamic subtest: pipe-A-eDP-1 [367.042372] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.120s) [367.072833] Starting dynamic subtest: pipe-D-eDP-1 [369.802412] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.737s) [369.803359] Subtest cursor-onscreen-64x64: SUCCESS (4.884s) [370.690065] [075/133] (662s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render) [370.788685] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render [370.790561] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [370.878130] [076/133] (662s left) syncobj_wait (invalid-wait-bad-flags) [370.919892] Starting subtest: invalid-wait-bad-flags [370.920835] Subtest invalid-wait-bad-flags: SUCCESS (0.000s) [370.989720] [077/133] (662s left) gem_exec_schedule (preempt-queue-contexts-chain) [371.047179] Subtest preempt-queue-contexts-chain: SKIP (0.000s) [371.339560] [078/133] (661s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [371.439671] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [371.441434] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s) [371.510282] [079/133] (661s left) perf_pmu (rc6) [371.553853] Starting subtest: rc6 [371.554676] Starting dynamic subtest: gt0 [377.915533] Dynamic subtest gt0: SUCCESS (6.360s) [377.925288] Starting dynamic subtest: runtime-pm-gt0 [385.636438] Dynamic subtest runtime-pm-gt0: SUCCESS (7.711s) [385.644634] Starting dynamic subtest: runtime-pm-long-gt0 [398.073514] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.435s) [398.084061] Starting dynamic subtest: other-idle-gt0 [404.415986] Dynamic subtest other-idle-gt0: SUCCESS (6.341s) [404.424830] Starting dynamic subtest: gt1 [410.758121] Dynamic subtest gt1: SUCCESS (6.340s) [410.766112] Starting dynamic subtest: runtime-pm-gt1 [418.196627] Dynamic subtest runtime-pm-gt1: SUCCESS (7.436s) [418.207554] Starting dynamic subtest: runtime-pm-long-gt1 [430.638168] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.440s) [430.646797] Starting dynamic subtest: other-idle-gt1 [436.981252] Dynamic subtest other-idle-gt1: SUCCESS (6.341s) [436.982376] Subtest rc6: SUCCESS (65.422s) [437.586010] [080/133] (595s left) perf (per-context-mode-unprivileged) [437.640468] Starting subtest: per-context-mode-unprivileged [437.642483] Subtest per-context-mode-unprivileged: SKIP (0.000s) [437.683662] [081/133] (595s left) api_intel_allocator (reopen) [437.728967] Starting subtest: reopen [437.730731] Subtest reopen: SUCCESS (0.003s) [437.816248] [082/133] (595s left) kms_psr (pr-primary-page-flip) [437.899486] Starting subtest: pr-primary-page-flip [437.901179] Subtest pr-primary-page-flip: SKIP (0.000s) [437.951598] [083/133] (595s left) kms_lease (lessee-list) [438.045908] Starting subtest: lessee-list [438.046794] Starting dynamic subtest: pipe-A-eDP-1 [438.047874] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s) [438.056014] Starting dynamic subtest: pipe-B-eDP-1 [438.056908] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [438.064470] Starting dynamic subtest: pipe-C-eDP-1 [438.065318] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [438.075806] Starting dynamic subtest: pipe-D-eDP-1 [438.076677] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [438.077561] Subtest lessee-list: SUCCESS (0.009s) [438.139826] [084/133] (595s left) i915_drm_fdinfo (isolation) [438.174285] Starting subtest: isolation [438.175186] Starting dynamic subtest: rcs0 [438.205318] Dynamic subtest rcs0: SKIP (0.030s) [438.216090] Starting dynamic subtest: bcs0 [438.217819] Dynamic subtest bcs0: SKIP (0.000s) [438.225442] Starting dynamic subtest: vcs0 [438.227041] Dynamic subtest vcs0: SKIP (0.000s) [438.234375] Starting dynamic subtest: vcs1 [438.236101] Dynamic subtest vcs1: SKIP (0.000s) [438.243399] Starting dynamic subtest: vecs0 [438.245022] Dynamic subtest vecs0: SKIP (0.000s) [438.252261] Starting dynamic subtest: ccs0 [438.253897] Dynamic subtest ccs0: SKIP (0.000s) [438.255727] Subtest isolation: SKIP (0.037s) [438.285626] [085/133] (595s left) gen9_exec_parse (bb-oversize) [438.339865] Subtest bb-oversize: SKIP (0.000s) [438.411517] [086/133] (595s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [438.518424] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip [438.520257] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [438.589206] [087/133] (594s left) kms_joiner (basic-big-joiner) [438.679913] Starting subtest: basic-big-joiner [438.681468] Subtest basic-big-joiner: SKIP (0.000s) [438.722269] [088/133] (594s left) prime_mmap (test_forked_cpu_write) [438.766467] Starting subtest: test_forked_cpu_write [438.767306] Starting dynamic subtest: test_forked_cpu_write-smem [438.779991] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.013s) [438.781421] Subtest test_forked_cpu_write: SUCCESS (0.015s) [438.894666] [089/133] (594s left) syncobj_timeline (wait-all-for-submit-snapshot) [438.958088] Starting subtest: wait-all-for-submit-snapshot [439.040009] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s) [439.086745] [090/133] (594s left) i915_pm_freq_mult (media-freq) [439.136999] Starting subtest: media-freq [439.137900] Starting dynamic subtest: gt0 [439.139611] Dynamic subtest gt0: SKIP (0.000s) [439.148209] Starting dynamic subtest: gt1 [439.149864] Dynamic subtest gt1: SKIP (0.000s) [439.151482] Subtest media-freq: SKIP (0.001s) [439.207185] [091/133] (594s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt) [439.299310] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt [439.301538] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [439.363943] [092/133] (594s left) kms_big_fb (linear-32bpp-rotate-90) [439.463285] Starting subtest: linear-32bpp-rotate-90 [439.482424] Subtest linear-32bpp-rotate-90: SKIP (0.019s) [439.568933] [093/133] (594s left) gem_exec_reloc (basic-gtt-read) [439.612317] Subtest basic-gtt-read: SKIP (0.000s) [439.688881] [094/133] (594s left) kms_psr (fbc-pr-no-drrs) [439.772493] Starting subtest: fbc-pr-no-drrs [439.774240] Subtest fbc-pr-no-drrs: SKIP (0.000s) [439.815783] [095/133] (594s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc) [439.916580] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc [443.986717] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.070s) [445.100908] [096/133] (588s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs) [445.200048] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs [445.200940] Starting dynamic subtest: pipe-A-eDP-1 [445.209620] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [445.217347] Starting dynamic subtest: pipe-B-eDP-1 [445.225545] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [445.233066] Starting dynamic subtest: pipe-C-eDP-1 [445.241698] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [445.250255] Starting dynamic subtest: pipe-D-eDP-1 [445.259206] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [445.260814] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.006s) [447.457726] [097/133] (586s left) kms_big_fb (yf-tiled-8bpp-rotate-270) [447.553310] Starting subtest: yf-tiled-8bpp-rotate-270 [447.555081] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s) [447.622937] [098/133] (586s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs) [447.716432] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs [447.717327] Starting dynamic subtest: pipe-A-eDP-1 [448.150636] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.435s) [448.162521] Starting dynamic subtest: pipe-B-eDP-1 [448.170153] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.005s) [448.177869] Starting dynamic subtest: pipe-C-eDP-1 [448.185262] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.003s) [448.192475] Starting dynamic subtest: pipe-D-eDP-1 [448.199580] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s) [448.200367] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.454s) [450.426917] [099/133] (583s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled) [450.476092] Starting subtest: yf-tiled-to-vebox-yf-tiled [450.478043] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s) [450.629402] [100/133] (583s left) gem_lmem_swapping (verify-random-ccs) [450.664451] Subtest verify-random-ccs: SKIP (0.000s) [450.704621] [101/133] (583s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions) [450.821092] Starting subtest: short-busy-flip-before-cursor-atomic-transitions [450.823205] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s) [450.936508] [102/133] (583s left) kms_fence_pin_leak [451.102911] [103/133] (582s left) kms_getfb (getfb2-handle-closed) [451.186984] Starting subtest: getfb2-handle-closed [451.188168] Subtest getfb2-handle-closed: SUCCESS (0.000s) [451.249482] [104/133] (582s left) perf (non-system-wide-paranoid) [451.309418] Starting subtest: non-system-wide-paranoid [451.336473] Subtest non-system-wide-paranoid: SUCCESS (0.027s) [451.381940] [105/133] (582s left) kms_vrr (flip-basic) [451.475682] Starting subtest: flip-basic [451.478404] Subtest flip-basic: SKIP (0.000s) [451.519192] [106/133] (582s left) gem_ctx_param (invalid-get-engines) [451.573799] Starting subtest: invalid-get-engines [451.574813] Subtest invalid-get-engines: SUCCESS (0.001s) [451.643967] [107/133] (582s left) kms_flip (basic-plain-flip) [451.743539] Starting subtest: basic-plain-flip [451.744477] Starting dynamic subtest: A-eDP1 [453.475429] Dynamic subtest A-eDP1: SUCCESS (1.731s) [453.486766] Starting dynamic subtest: B-eDP1 [455.127728] Dynamic subtest B-eDP1: SUCCESS (1.650s) [455.140687] Starting dynamic subtest: C-eDP1 [456.754466] Dynamic subtest C-eDP1: SUCCESS (1.625s) [456.765781] Starting dynamic subtest: D-eDP1 [458.400065] Dynamic subtest D-eDP1: SUCCESS (1.643s) [458.403726] Subtest basic-plain-flip: SUCCESS (6.660s) [459.529696] [108/133] (574s left) syncobj_wait (wait-all-delayed-signal) [459.585440] Starting subtest: wait-all-delayed-signal [459.688496] Subtest wait-all-delayed-signal: SUCCESS (0.102s) [459.735997] [109/133] (574s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf) [459.819213] Starting subtest: pr-overlay-plane-update-continuous-sf [459.821254] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s) [459.864354] [110/133] (574s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25) [459.944406] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25 [459.945258] Starting dynamic subtest: pipe-A [460.009062] Dynamic subtest pipe-A: SUCCESS (0.065s) [460.019495] Starting dynamic subtest: pipe-B [461.181349] Dynamic subtest pipe-B: SUCCESS (1.171s) [461.191493] Starting dynamic subtest: pipe-C [462.298240] Dynamic subtest pipe-C: SUCCESS (1.115s) [462.305801] Starting dynamic subtest: pipe-D [463.436806] Dynamic subtest pipe-D: SUCCESS (1.138s) [463.437785] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.494s) [464.572865] [111/133] (569s left) drm_buddy (drm_buddy) [464.604859] Starting subtest: drm_buddy [464.606589] Subtest drm_buddy: SKIP (0.001s) [464.639709] [112/133] (569s left) gem_mmap_gtt (ptrace) [464.683765] Subtest ptrace: SKIP (0.000s) [464.743725] [113/133] (569s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu) [464.832848] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu [471.916274] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.085s) [472.015356] [114/133] (562s left) kms_getfb (getfb-handle-valid) [472.100562] Starting subtest: getfb-handle-valid [472.101507] Subtest getfb-handle-valid: SUCCESS (0.000s) [472.174031] [115/133] (562s left) syncobj_timeline (etime-single-wait-all-submitted) [472.221539] Starting subtest: etime-single-wait-all-submitted [472.339041] Subtest etime-single-wait-all-submitted: SUCCESS (0.108s) [472.377446] [116/133] (562s left) gem_exec_whisper (basic-queues-priority-all) [472.432692] Starting subtest: basic-queues-priority-all [492.933077] Subtest basic-queues-priority-all: SUCCESS (20.493s) [493.084024] [117/133] (541s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted) [493.131236] Starting subtest: multi-wait-for-submit-unsubmitted-submitted [493.232828] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.101s) [493.280618] [118/133] (541s left) kms_draw_crc (draw-method-pwrite) [493.359131] Starting subtest: draw-method-pwrite [493.360060] Starting dynamic subtest: xrgb8888-untiled [493.970400] Dynamic subtest xrgb8888-untiled: SUCCESS (0.611s) [493.978737] Starting dynamic subtest: rgb565-untiled [494.437044] Dynamic subtest rgb565-untiled: SUCCESS (0.466s) [494.446872] Starting dynamic subtest: xrgb2101010-untiled [495.003604] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.566s) [495.016984] Starting dynamic subtest: xbgr16161616f-untiled [495.814606] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.809s) [495.824347] Starting dynamic subtest: xrgb8888-xtiled [497.703548] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.887s) [497.714653] Starting dynamic subtest: rgb565-xtiled [498.836275] Dynamic subtest rgb565-xtiled: SUCCESS (1.132s) [498.845183] Starting dynamic subtest: xrgb2101010-xtiled [500.691567] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.855s) [500.700204] Starting dynamic subtest: xbgr16161616f-xtiled [504.235426] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.544s) [504.243843] Starting dynamic subtest: xrgb8888-4tiled [505.424224] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.188s) [505.432959] Starting dynamic subtest: rgb565-4tiled [506.013256] Dynamic subtest rgb565-4tiled: SUCCESS (0.588s) [506.023062] Starting dynamic subtest: xrgb2101010-4tiled [507.168518] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.153s) [507.177234] Starting dynamic subtest: xbgr16161616f-4tiled [510.345572] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.177s) [510.346507] Subtest draw-method-pwrite: SUCCESS (16.990s) [510.413390] [119/133] (524s left) sw_sync (sync_expired_merge) [510.448106] Starting subtest: sync_expired_merge [511.531586] Subtest sync_expired_merge: SUCCESS (1.074s) [511.563853] [120/133] (523s left) kms_color (legacy-gamma-reset) [511.646762] Starting subtest: legacy-gamma-reset [511.647579] Starting dynamic subtest: pipe-A-eDP-1 [512.022003] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.375s) [512.029837] Starting dynamic subtest: pipe-B-eDP-1 [512.034632] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.013s) [512.043263] Starting dynamic subtest: pipe-C-eDP-1 [512.052349] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.016s) [512.060001] Starting dynamic subtest: pipe-D-eDP-1 [512.064033] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s) [512.065019] Subtest legacy-gamma-reset: SUCCESS (0.419s) [512.814297] [121/133] (521s left) core_auth (getclient-simple) [512.849725] Starting subtest: getclient-simple [512.861838] Subtest getclient-simple: SUCCESS (0.013s) [512.961606] [122/133] (521s left) intel_hwmon (hwmon-write) [513.014625] Subtest hwmon-write: SKIP (0.000s) [513.084883] [123/133] (521s left) kms_big_fb (x-tiled-8bpp-rotate-0) [513.180390] Starting subtest: x-tiled-8bpp-rotate-0 [514.416794] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.237s) [514.502037] [124/133] (520s left) kms_psr (fbc-psr2-basic) [514.587602] Starting subtest: fbc-psr2-basic [514.588479] Starting dynamic subtest: eDP-1 [514.590155] Dynamic subtest eDP-1: SKIP (0.000s) [514.591996] Subtest fbc-psr2-basic: SKIP (0.001s) [514.631664] [125/133] (520s left) gem_ctx_persistence (legacy-engines-hang) [514.682535] Starting subtest: legacy-engines-hang [514.683327] Starting dynamic subtest: render [514.767605] Dynamic subtest render: SUCCESS (0.084s) [514.779501] Starting dynamic subtest: bsd1 [514.859683] Dynamic subtest bsd1: SUCCESS (0.089s) [514.871401] Starting dynamic subtest: bsd2 [514.963571] Dynamic subtest bsd2: SUCCESS (0.101s) [514.975514] Starting dynamic subtest: blt [515.053505] Dynamic subtest blt: SUCCESS (0.087s) [515.065543] Starting dynamic subtest: vebox [515.137560] Dynamic subtest vebox: SUCCESS (0.081s) [515.140770] Subtest legacy-engines-hang: SUCCESS (0.456s) [515.189061] [126/133] (519s left) kms_flip (2x-wf_vblank-ts-check) [515.271870] Starting subtest: 2x-wf_vblank-ts-check [515.281726] Subtest 2x-wf_vblank-ts-check: SKIP (0.011s) [515.339789] [127/133] (519s left) gem_exec_store (dword) [515.392683] Starting subtest: dword [515.393654] Starting dynamic subtest: rcs0 [515.464879] Dynamic subtest rcs0: SUCCESS (0.071s) [515.482365] Starting dynamic subtest: bcs0 [515.506541] Dynamic subtest bcs0: SUCCESS (0.040s) [515.518414] Starting dynamic subtest: vcs0 [515.548528] Dynamic subtest vcs0: SUCCESS (0.040s) [515.558826] Starting dynamic subtest: vcs1 [515.591444] Dynamic subtest vcs1: SUCCESS (0.041s) [515.600809] Starting dynamic subtest: vecs0 [515.633740] Dynamic subtest vecs0: SUCCESS (0.040s) [515.644211] Starting dynamic subtest: ccs0 [515.677588] Dynamic subtest ccs0: SUCCESS (0.041s) [515.680551] Subtest dword: SUCCESS (0.286s) [515.834238] [128/133] (519s left) kms_flip (nonexisting-fb-interruptible) [515.935620] Starting subtest: nonexisting-fb-interruptible [515.938342] Starting dynamic subtest: A-eDP1 [517.125961] Dynamic subtest A-eDP1: SUCCESS (1.188s) [517.138046] Starting dynamic subtest: B-eDP1 [518.252805] Dynamic subtest B-eDP1: SUCCESS (1.125s) [518.262156] Starting dynamic subtest: C-eDP1 [519.388413] Dynamic subtest C-eDP1: SUCCESS (1.135s) [519.396886] Starting dynamic subtest: D-eDP1 [520.525722] Dynamic subtest D-eDP1: SUCCESS (1.137s) [520.530399] Subtest nonexisting-fb-interruptible: SUCCESS (4.596s) [521.665299] [129/133] (513s left) kms_plane_cursor (primary) [521.749415] Starting subtest: primary [521.751480] Starting dynamic subtest: pipe-A-eDP-1-size-64 [524.324727] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.576s) [524.349538] Starting dynamic subtest: pipe-A-eDP-1-size-128 [526.957092] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.616s) [526.981416] Starting dynamic subtest: pipe-A-eDP-1-size-256 [529.545321] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.572s) [529.864497] Starting dynamic subtest: pipe-B-eDP-1-size-64 [533.184183] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.328s) [533.210969] Starting dynamic subtest: pipe-B-eDP-1-size-128 [535.751156] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.549s) [535.778283] Starting dynamic subtest: pipe-B-eDP-1-size-256 [538.352475] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.583s) [538.668640] Starting dynamic subtest: pipe-C-eDP-1-size-64 [541.528910] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.869s) [541.560904] Starting dynamic subtest: pipe-C-eDP-1-size-128 [543.738271] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.191s) [543.766304] Starting dynamic subtest: pipe-C-eDP-1-size-256 [545.937915] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.181s) [546.252683] Starting dynamic subtest: pipe-D-eDP-1-size-64 [549.183318] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.939s) [549.210477] Starting dynamic subtest: pipe-D-eDP-1-size-128 [551.382883] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.181s) [551.409745] Starting dynamic subtest: pipe-D-eDP-1-size-256 [553.593327] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.191s) [553.899577] Subtest primary: SUCCESS (32.156s) [554.684187] [130/133] (480s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu) [554.775509] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu [561.717634] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.944s) [561.802255] [131/133] (473s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted) [561.857437] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted [561.960626] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.103s) [562.010534] [132/133] (473s left) kms_selftest (drm_framebuffer) [562.042938] Starting subtest: drm_framebuffer [562.087714] Starting dynamic subtest: drm_test_framebuffer_check_src_coords [562.189318] Dynamic subtest drm_test_framebuffer_check_src_coords: SUCCESS (0.102s) [562.201725] Starting dynamic subtest: drm_test_framebuffer_cleanup [562.291859] Dynamic subtest drm_test_framebuffer_cleanup: SUCCESS (0.102s) [562.305611] Starting dynamic subtest: drm_test_framebuffer_create [562.475344] Dynamic subtest drm_test_framebuffer_create: SUCCESS (0.182s) [562.486700] Starting dynamic subtest: drm_test_framebuffer_free [562.642956] Dynamic subtest drm_test_framebuffer_free: FAIL (0.142s) [562.644740] Subtest drm_framebuffer: FAIL (0.577s) [562.719611] Aborting: Kernel badly tainted (0x44244, 0x200) (check dmesg for details): TAINT_WARN: WARN_ON has happened. [562.737900] [FACT kms_selftest (drm_framebuffer)] new: kernel.is_tainted.taint_warn: true [562.738806] 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.