[62.572517] Initializing watchdogs [62.572598] /dev/watchdog0 [62.587889] [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.592264] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [62.594907] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [62.598409] [001/133] (960s left) gem_exec_balancer (indices) [62.686925] Starting subtest: indices [64.886876] Subtest indices: SUCCESS (2.193s) [65.196724] [002/133] (957s left) kms_flip (2x-plain-flip-interruptible) [65.312743] Starting subtest: 2x-plain-flip-interruptible [65.324397] Subtest 2x-plain-flip-interruptible: SKIP (0.011s) [65.394675] [003/133] (957s left) i915_suspend (debugfs-reader) [65.448966] Starting subtest: debugfs-reader [83.746303] Subtest debugfs-reader: SUCCESS (4.377s) [92.930155] [004/133] (939s left) kms_psr (fbc-psr-sprite-plane-onoff) [93.043076] Starting subtest: fbc-psr-sprite-plane-onoff [93.044957] Starting dynamic subtest: eDP-1 [93.048977] Dynamic subtest eDP-1: SKIP (0.000s) [93.053016] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.000s) [93.114442] [005/133] (939s left) kms_plane (plane-panning-top-left) [93.203551] Starting subtest: plane-panning-top-left [93.205976] Starting dynamic subtest: pipe-A [94.897096] Dynamic subtest pipe-A: SUCCESS (1.669s) [94.906388] Starting dynamic subtest: pipe-B [97.250855] Dynamic subtest pipe-B: SUCCESS (2.313s) [97.253199] Subtest plane-panning-top-left: SUCCESS (3.984s) [98.090039] [006/133] (934s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt) [98.194599] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt [98.199015] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [98.301709] [007/133] (934s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt) [98.406620] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt [98.410783] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [98.497051] [008/133] (934s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt) [98.590486] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt [98.594714] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [98.698609] [009/133] (933s left) kms_pipe_crc_basic (read-crc-frame-sequence) [98.791461] Starting subtest: read-crc-frame-sequence [98.793786] Starting dynamic subtest: pipe-A-eDP-1 [99.503481] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.704s) [99.512009] Starting dynamic subtest: pipe-B-eDP-1 [100.904951] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.386s) [100.916715] Starting dynamic subtest: pipe-C-eDP-1 [102.187150] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.271s) [102.196151] Starting dynamic subtest: pipe-D-eDP-1 [103.549326] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.349s) [103.551672] Subtest read-crc-frame-sequence: SUCCESS (4.714s) [104.400987] [010/133] (928s left) kms_psr (psr-primary-mmap-cpu) [104.504419] Starting subtest: psr-primary-mmap-cpu [104.506806] Starting dynamic subtest: eDP-1 [106.196059] Dynamic subtest eDP-1: SUCCESS (1.682s) [106.198518] Subtest psr-primary-mmap-cpu: SUCCESS (1.683s) [107.076060] [011/133] (925s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt) [107.167931] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt [107.172360] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [107.280309] [012/133] (925s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move) [107.381101] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move [114.738658] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.341s) [114.872179] [013/133] (917s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite) [114.989063] Starting subtest: psr-rgb565-draw-pwrite [121.943423] Subtest psr-rgb565-draw-pwrite: SUCCESS (6.948s) [122.048648] [014/133] (910s left) testdisplay [122.388702] [015/133] (910s left) syncobj_timeline (invalid-wait-illegal-handle) [122.449629] Starting subtest: invalid-wait-illegal-handle [122.452020] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [122.553464] [016/133] (910s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc) [122.659223] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc [129.332806] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.673s) [129.455637] [017/133] (903s left) gem_vm_create (invalid-destroy) [129.523761] Starting subtest: invalid-destroy [129.526010] Subtest invalid-destroy: SUCCESS (0.002s) [129.631569] [018/133] (903s left) kms_addfb_basic (unused-pitches) [129.680270] Starting subtest: unused-pitches [129.682183] Subtest unused-pitches: SUCCESS (0.000s) [129.821562] [019/133] (903s left) gem_softpin (zero) [129.885102] Starting subtest: zero [129.889652] Subtest zero: SUCCESS (0.006s) [129.992849] [020/133] (903s left) i915_hangman (engine-engine-error) [130.063129] Starting subtest: engine-engine-error [130.065055] Starting dynamic subtest: rcs0 [131.796701] Dynamic subtest rcs0: SUCCESS (1.732s) [131.807225] Starting dynamic subtest: bcs0 [133.779094] Dynamic subtest bcs0: SUCCESS (1.980s) [133.790456] Starting dynamic subtest: vcs0 [137.863727] Dynamic subtest vcs0: SUCCESS (4.028s) [137.874159] Starting dynamic subtest: vcs1 [139.796606] Dynamic subtest vcs1: SUCCESS (1.984s) [139.808517] Starting dynamic subtest: vecs0 [141.781033] Dynamic subtest vecs0: SUCCESS (1.982s) [141.792319] Starting dynamic subtest: ccs0 [143.827411] Dynamic subtest ccs0: SUCCESS (2.044s) [143.830158] Subtest engine-engine-error: SUCCESS (13.760s) [143.910577] [021/133] (889s left) kms_plane (pixel-format-4-tiled-modifier) [144.005966] Starting subtest: pixel-format-4-tiled-modifier [144.036863] Starting dynamic subtest: pipe-A-plane-0 [144.681579] Dynamic subtest pipe-A-plane-0: SUCCESS (0.644s) [144.689809] Starting dynamic subtest: pipe-A-plane-3 [145.059065] Dynamic subtest pipe-A-plane-3: SUCCESS (0.377s) [145.066883] Starting dynamic subtest: pipe-A-plane-5 [145.070277] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [146.226470] Starting dynamic subtest: pipe-B-plane-0 [146.840752] Dynamic subtest pipe-B-plane-0: SUCCESS (0.633s) [146.850028] Starting dynamic subtest: pipe-B-plane-3 [147.251646] Dynamic subtest pipe-B-plane-3: SUCCESS (0.411s) [147.259747] Starting dynamic subtest: pipe-B-plane-5 [147.262950] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [147.558055] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.550s) [148.392494] [022/133] (884s left) perf_pmu (faulting-read) [148.434824] Starting subtest: faulting-read [148.437172] Starting dynamic subtest: wb [148.439127] Dynamic subtest wb: SUCCESS (0.001s) [148.447652] Starting dynamic subtest: wc [148.449880] Dynamic subtest wc: SUCCESS (0.000s) [148.458128] Starting dynamic subtest: uc [148.460490] Dynamic subtest uc: SUCCESS (0.000s) [148.462414] Subtest faulting-read: SUCCESS (0.003s) [148.539757] [023/133] (884s left) gem_exec_capture (capture) [148.597653] Starting subtest: capture [148.600031] Starting dynamic subtest: rcs0-smem [149.436436] Dynamic subtest rcs0-smem: SUCCESS (0.837s) [149.446884] Starting dynamic subtest: bcs0-smem [150.761055] Dynamic subtest bcs0-smem: SUCCESS (1.323s) [150.770353] Starting dynamic subtest: vcs0-smem [151.578621] Dynamic subtest vcs0-smem: SUCCESS (0.816s) [151.589111] Starting dynamic subtest: vcs1-smem [152.900800] Dynamic subtest vcs1-smem: SUCCESS (1.321s) [152.909675] Starting dynamic subtest: vecs0-smem [153.798871] Dynamic subtest vecs0-smem: FAIL (0.838s) [153.808781] Starting dynamic subtest: ccs0-smem [155.059148] Dynamic subtest ccs0-smem: SUCCESS (1.319s) [155.061402] Subtest capture: FAIL (6.457s) [155.179028] [024/133] (877s left) prime_vgem (basic-write) [155.294786] Starting subtest: basic-write [155.302026] Subtest basic-write: SKIP (0.005s) [155.395638] [FACT prime_vgem (basic-write)] new: kernel.kmod_is_loaded.vgem: true [155.399267] [025/133] (877s left) gem_exec_fence (syncobj-invalid-wait) [155.845225] Starting subtest: syncobj-invalid-wait [155.847796] Subtest syncobj-invalid-wait: SUCCESS (0.000s) [156.850387] [026/133] (876s left) prime_vgem (fence-wait) [156.915366] Starting subtest: fence-wait [156.917817] Starting dynamic subtest: rcs0 [157.949052] Dynamic subtest rcs0: SUCCESS (1.032s) [157.960433] Starting dynamic subtest: bcs0 [159.008602] Dynamic subtest bcs0: SUCCESS (1.058s) [159.020179] Starting dynamic subtest: vcs0 [160.058692] Dynamic subtest vcs0: SUCCESS (1.048s) [160.070131] Starting dynamic subtest: vcs1 [161.101566] Dynamic subtest vcs1: SUCCESS (1.040s) [161.113167] Starting dynamic subtest: vecs0 [162.145503] Dynamic subtest vecs0: SUCCESS (1.041s) [162.157121] Starting dynamic subtest: ccs0 [163.190261] Dynamic subtest ccs0: SUCCESS (1.043s) [163.193081] Subtest fence-wait: SUCCESS (6.272s) [163.309299] [027/133] (869s left) gem_flink_basic (flink-lifetime) [163.374450] Starting subtest: flink-lifetime [163.376770] Subtest flink-lifetime: SUCCESS (0.002s) [163.484201] [028/133] (869s left) gem_pxp (verify-pxp-stale-buf-execution) [163.611956] Starting subtest: verify-pxp-stale-buf-execution [164.679446] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.068s) [164.805166] [029/133] (868s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions) [164.924675] Starting subtest: cursor-vs-flip-atomic-transitions [194.944165] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.010s) [195.747685] [030/133] (837s left) gem_exec_reloc (basic-gtt-noreloc) [195.812964] Subtest basic-gtt-noreloc: SKIP (0.000s) [195.884201] [031/133] (837s left) syncobj_timeline (multi-wait-available-submitted-signaled) [195.944360] Starting subtest: multi-wait-available-submitted-signaled [195.946693] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s) [196.055378] [032/133] (837s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt) [196.164883] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt [199.879346] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.719s) [201.063999] [033/133] (832s left) kms_flip (flip-vs-blocking-wf-vblank) [201.171282] Starting subtest: flip-vs-blocking-wf-vblank [201.173681] Starting dynamic subtest: A-eDP1 [210.079616] Dynamic subtest A-eDP1: SUCCESS (8.910s) [210.090879] Starting dynamic subtest: B-eDP1 [219.012960] Dynamic subtest B-eDP1: SUCCESS (8.932s) [219.023476] Starting dynamic subtest: C-eDP1 [227.984070] Dynamic subtest C-eDP1: SUCCESS (8.923s) [227.994292] Starting dynamic subtest: D-eDP1 [236.920493] Dynamic subtest D-eDP1: SUCCESS (8.932s) [236.922534] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.709s) [238.101476] [034/133] (795s left) gen3_render_tiledy_blits [238.272942] [035/133] (795s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [238.377920] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt [238.382336] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [238.486227] [036/133] (795s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt) [238.585470] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt [238.589425] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [238.685337] [037/133] (795s left) perf (gen8-unprivileged-single-ctx-counters) [238.819103] Starting subtest: gen8-unprivileged-single-ctx-counters [238.822742] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s) [238.862540] [038/133] (794s left) kms_big_fb (4-tiled-8bpp-rotate-90) [238.950794] Starting subtest: 4-tiled-8bpp-rotate-90 [238.970963] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.020s) [239.082644] [039/133] (794s left) gem_ccs (block-multicopy-compressed) [239.135969] Starting subtest: block-multicopy-compressed [239.139694] Subtest block-multicopy-compressed: SKIP (0.000s) [239.231886] [040/133] (794s left) gem_exec_params (invalid-bsd1-flag-on-blt) [239.282894] Starting subtest: invalid-bsd1-flag-on-blt [239.284613] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s) [239.379819] [041/133] (794s left) gem_pread (uncached) [239.435014] Subtest uncached: SKIP (0.000s) [239.509192] [042/133] (794s left) kms_cursor_legacy (cursorb-vs-flipa-toggle) [239.618562] Starting subtest: cursorB-vs-flipA-toggle [239.622201] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s) [239.778093] [043/133] (794s left) gem_exec_reloc (basic-wc-cpu-active) [239.841458] Subtest basic-wc-cpu-active: SKIP (0.000s) [239.900143] [044/133] (794s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs) [239.988620] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs [239.992232] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s) [241.146765] [045/133] (792s left) i915_query (query-topology-matches-eu-total) [241.201271] Starting subtest: query-topology-matches-eu-total [241.203433] Subtest query-topology-matches-eu-total: SUCCESS (0.000s) [241.312725] [046/133] (792s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs) [241.398386] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs [241.400604] Starting dynamic subtest: pipe-A-eDP-1 [241.424379] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [241.434374] Starting dynamic subtest: pipe-B-eDP-1 [241.457002] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [241.465367] Starting dynamic subtest: pipe-C-eDP-1 [241.488887] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [241.496858] Starting dynamic subtest: pipe-D-eDP-1 [241.520555] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [241.524795] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s) [243.616106] [047/133] (790s left) kms_big_fb (yf-tiled-16bpp-rotate-180) [243.723516] Starting subtest: yf-tiled-16bpp-rotate-180 [243.727954] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s) [243.807992] [048/133] (790s left) kms_prop_blob (invalid-get-prop-any) [243.868231] Starting subtest: invalid-get-prop-any [243.870451] Subtest invalid-get-prop-any: SUCCESS (0.000s) [243.974374] [049/133] (790s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs) [244.072237] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs [244.074577] Starting dynamic subtest: pipe-A-eDP-1 [244.094196] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [244.104992] Starting dynamic subtest: pipe-B-eDP-1 [244.123505] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [244.131883] Starting dynamic subtest: pipe-C-eDP-1 [244.150297] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [244.158526] Starting dynamic subtest: pipe-D-eDP-1 [244.177077] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [244.178944] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.007s) [246.283780] [050/133] (788s left) kms_content_protection (lic-type-0-hdcp14) [246.419457] Starting subtest: lic-type-0-hdcp14 [246.424167] Subtest lic-type-0-hdcp14: SKIP (0.000s) [246.558312] [051/133] (787s left) kms_pm_rpm (basic-rte) [246.598017] Starting subtest: basic-rte [249.527831] Subtest basic-rte: SUCCESS (2.932s) [251.311209] [052/133] (783s left) gem_ctx_shared (q-promotion) [251.370880] Starting subtest: Q-promotion [251.373480] Starting dynamic subtest: rcs0 [251.469372] Dynamic subtest rcs0: SUCCESS (0.097s) [251.485418] Starting dynamic subtest: vcs0 [251.554820] Dynamic subtest vcs0: SUCCESS (0.085s) [251.570449] Starting dynamic subtest: vcs1 [251.629213] Dynamic subtest vcs1: SUCCESS (0.074s) [251.644982] Starting dynamic subtest: vecs0 [251.700359] Dynamic subtest vecs0: SUCCESS (0.070s) [251.715771] Starting dynamic subtest: ccs0 [251.779223] Dynamic subtest ccs0: SUCCESS (0.077s) [251.781551] Subtest Q-promotion: SUCCESS (0.407s) [252.953259] [053/133] (781s left) kms_pm_rpm (universal-planes-dpms) [254.984382] Starting subtest: universal-planes-dpms [254.987133] Starting dynamic subtest: plane-35 [263.254359] Dynamic subtest plane-35: SUCCESS (8.270s) [263.266057] Starting dynamic subtest: plane-65 [271.653925] Dynamic subtest plane-65: SUCCESS (8.394s) [271.665322] Starting dynamic subtest: plane-95 [279.939432] Dynamic subtest plane-95: SUCCESS (8.280s) [279.951051] Starting dynamic subtest: plane-125 [288.566442] Dynamic subtest plane-125: SUCCESS (8.622s) [288.580481] Starting dynamic subtest: plane-135 [296.867438] Dynamic subtest plane-135: SUCCESS (8.294s) [296.879436] Starting dynamic subtest: plane-145 [305.364360] Dynamic subtest plane-145: SUCCESS (8.490s) [305.367378] Subtest universal-planes-dpms: SUCCESS (50.369s) [305.767473] [054/133] (728s left) sysfs_defaults (readonly) [305.828209] Starting subtest: readonly [305.830707] Starting dynamic subtest: vecs0 [305.833120] Dynamic subtest vecs0: SUCCESS (0.000s) [305.843236] Starting dynamic subtest: ccs0 [305.845412] Dynamic subtest ccs0: SUCCESS (0.000s) [305.853795] Starting dynamic subtest: vcs0 [305.855727] Dynamic subtest vcs0: SUCCESS (0.000s) [305.864161] Starting dynamic subtest: bcs0 [305.866092] Dynamic subtest bcs0: SUCCESS (0.000s) [305.874995] Starting dynamic subtest: rcs0 [305.877215] Dynamic subtest rcs0: SUCCESS (0.000s) [305.885680] Starting dynamic subtest: vcs1 [305.887539] Dynamic subtest vcs1: SUCCESS (0.000s) [305.889429] Subtest readonly: SUCCESS (0.006s) [305.927326] [055/133] (728s left) kms_psr (psr2-sprite-blt) [306.018565] Starting subtest: psr2-sprite-blt [306.020784] Starting dynamic subtest: eDP-1 [307.746355] Dynamic subtest eDP-1: SUCCESS (1.726s) [307.748661] Subtest psr2-sprite-blt: SUCCESS (1.727s) [308.618979] [056/133] (725s left) gem_basic (create-close) [308.679115] Starting subtest: create-close [308.683495] Subtest create-close: SUCCESS (0.000s) [308.776661] [057/133] (725s left) kms_cursor_legacy (cursora-vs-flipa-legacy) [308.889824] Starting subtest: cursorA-vs-flipA-legacy [320.026796] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.134s) [320.844785] [058/133] (713s left) perf (enable-disable) [320.944141] Starting subtest: enable-disable [320.946598] Starting dynamic subtest: 0-rcs0 [323.258656] Dynamic subtest 0-rcs0: SUCCESS (2.260s) [323.270319] Starting dynamic subtest: 1-vcs0 [327.692953] Dynamic subtest 1-vcs0: SUCCESS (4.489s) [327.695276] Subtest enable-disable: SUCCESS (6.750s) [327.745818] [059/133] (706s left) gem_render_copy_redux (normal) [327.805860] Starting subtest: normal [328.176620] Subtest normal: SUCCESS (0.371s) [328.306549] [060/133] (706s left) kms_chamelium_color (degamma) [328.408215] Subtest degamma: SKIP (0.000s) [328.456319] [061/133] (706s left) kms_cursor_edge_walk (256x256-top-edge) [328.562293] Starting subtest: 256x256-top-edge [328.564550] Starting dynamic subtest: pipe-A-eDP-1 [332.006610] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.446s) [332.016532] Starting dynamic subtest: pipe-D-eDP-1 [335.137950] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.129s) [335.139932] Subtest 256x256-top-edge: SUCCESS (6.577s) [335.935834] [062/133] (698s left) kms_vrr (flip-suspend) [336.028764] Starting subtest: flip-suspend [336.035225] Subtest flip-suspend: SKIP (0.000s) [336.100609] [063/133] (698s left) kms_big_fb (y-tiled-16bpp-rotate-0) [336.213264] Starting subtest: y-tiled-16bpp-rotate-0 [336.217770] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s) [336.310803] [064/133] (698s left) gem_exec_fence (syncobj-wait) [336.769937] Starting subtest: syncobj-wait [337.840466] Subtest syncobj-wait: SUCCESS (1.069s) [338.171439] [065/133] (696s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary) [338.262332] Starting subtest: psr-indfb-scaledprimary [343.993404] Subtest psr-indfb-scaledprimary: SUCCESS (5.736s) [344.122957] [066/133] (690s left) gem_mmap_offset (ptrace) [344.193731] Starting subtest: ptrace [344.196105] Starting dynamic subtest: smem0-wb [344.215049] Dynamic subtest smem0-wb: SUCCESS (0.020s) [344.225892] Starting dynamic subtest: smem0-wc [344.236661] Dynamic subtest smem0-wc: SUCCESS (0.021s) [344.245651] Starting dynamic subtest: smem0-uc [344.257163] Dynamic subtest smem0-uc: SUCCESS (0.020s) [344.259535] Subtest ptrace: SUCCESS (0.066s) [344.372397] [067/133] (690s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling) [344.472432] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling [344.474760] Starting dynamic subtest: pipe-A-default-mode [347.216535] Dynamic subtest pipe-A-default-mode: SUCCESS (2.743s) [347.218697] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.744s) [348.056295] [068/133] (686s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode) [348.440026] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s) [349.266148] [069/133] (685s left) gem_ctx_engines (execute-one) [349.322977] Starting subtest: execute-one [351.735156] Subtest execute-one: SUCCESS (2.413s) [351.977273] [070/133] (683s left) gem_exec_schedule (pi-shared-iova) [352.163000] Starting subtest: pi-shared-iova [352.165074] Starting dynamic subtest: rcs0 [352.298227] Dynamic subtest rcs0: SUCCESS (0.138s) [352.312671] Starting dynamic subtest: vcs0 [352.375652] Dynamic subtest vcs0: SUCCESS (0.078s) [352.386786] Starting dynamic subtest: vcs1 [352.457117] Dynamic subtest vcs1: SUCCESS (0.080s) [352.466458] Starting dynamic subtest: vecs0 [352.553132] Dynamic subtest vecs0: SUCCESS (0.094s) [352.565574] Starting dynamic subtest: ccs0 [352.655327] Dynamic subtest ccs0: SUCCESS (0.102s) [352.658251] Subtest pi-shared-iova: SUCCESS (0.497s) [353.949347] [071/133] (681s left) kms_atomic_transition (modeset-transition) [354.049191] Starting subtest: modeset-transition [354.051069] Starting dynamic subtest: 1x-outputs [364.853702] Dynamic subtest 1x-outputs: SUCCESS (10.804s) [364.856069] Subtest modeset-transition: SUCCESS (10.806s) [365.713321] [072/133] (669s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move) [365.819270] Starting subtest: fbc-2p-scndscrn-spr-indfb-move [365.823631] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [365.927834] [073/133] (669s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled) [365.978847] Starting subtest: invalid-multi-wait-unsubmitted-signaled [365.981069] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s) [366.077537] [074/133] (669s left) kms_cursor_crc (cursor-onscreen-64x64) [366.242064] Starting subtest: cursor-onscreen-64x64 [366.247321] Starting dynamic subtest: pipe-A-eDP-1 [368.353807] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.108s) [368.383635] Starting dynamic subtest: pipe-D-eDP-1 [371.088271] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.714s) [371.090557] Subtest cursor-onscreen-64x64: SUCCESS (4.846s) [371.893926] [075/133] (663s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render) [372.005141] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render [372.009518] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [372.115847] [076/133] (663s left) syncobj_wait (invalid-wait-bad-flags) [372.171532] Starting subtest: invalid-wait-bad-flags [372.173792] Subtest invalid-wait-bad-flags: SUCCESS (0.000s) [372.256358] [077/133] (663s left) gem_exec_schedule (preempt-queue-contexts-chain) [372.329685] Subtest preempt-queue-contexts-chain: SKIP (0.000s) [372.618533] [078/133] (662s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [372.724679] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [372.728589] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s) [372.796336] [079/133] (662s left) perf_pmu (rc6) [372.834680] Starting subtest: rc6 [372.836888] Starting dynamic subtest: gt0 [379.243596] Dynamic subtest gt0: SUCCESS (6.354s) [379.256428] Starting dynamic subtest: runtime-pm-gt0 [386.955470] Dynamic subtest runtime-pm-gt0: SUCCESS (7.762s) [386.967544] Starting dynamic subtest: runtime-pm-long-gt0 [399.450803] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.492s) [399.464363] Starting dynamic subtest: other-idle-gt0 [405.844754] Dynamic subtest other-idle-gt0: SUCCESS (6.340s) [405.857179] Starting dynamic subtest: gt1 [412.135726] Dynamic subtest gt1: SUCCESS (6.338s) [412.147833] Starting dynamic subtest: runtime-pm-gt1 [419.574411] Dynamic subtest runtime-pm-gt1: SUCCESS (7.434s) [419.586722] Starting dynamic subtest: runtime-pm-long-gt1 [432.067861] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.488s) [432.079789] Starting dynamic subtest: other-idle-gt1 [438.464109] Dynamic subtest other-idle-gt1: SUCCESS (6.341s) [438.466635] Subtest rc6: SUCCESS (65.571s) [439.546462] [080/133] (595s left) perf (per-context-mode-unprivileged) [439.610576] Starting subtest: per-context-mode-unprivileged [439.615211] Subtest per-context-mode-unprivileged: SKIP (0.000s) [439.660675] [081/133] (595s left) api_intel_allocator (reopen) [439.713125] Starting subtest: reopen [439.715003] Subtest reopen: SUCCESS (0.004s) [439.809279] [082/133] (595s left) kms_psr (pr-primary-page-flip) [439.905905] Starting subtest: pr-primary-page-flip [439.909588] Subtest pr-primary-page-flip: SKIP (0.000s) [439.956254] [083/133] (595s left) kms_lease (lessee-list) [440.046316] Starting subtest: lessee-list [440.048256] Starting dynamic subtest: pipe-A-eDP-1 [440.050056] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [440.059531] Starting dynamic subtest: pipe-B-eDP-1 [440.061263] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [440.069752] Starting dynamic subtest: pipe-C-eDP-1 [440.071496] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [440.080267] Starting dynamic subtest: pipe-D-eDP-1 [440.082124] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [440.083887] Subtest lessee-list: SUCCESS (0.009s) [440.144325] [084/133] (595s left) i915_drm_fdinfo (isolation) [440.180624] Starting subtest: isolation [440.182434] Starting dynamic subtest: rcs0 [440.203898] Dynamic subtest rcs0: SKIP (0.023s) [440.214971] Starting dynamic subtest: bcs0 [440.218692] Dynamic subtest bcs0: SKIP (0.000s) [440.227383] Starting dynamic subtest: vcs0 [440.231541] Dynamic subtest vcs0: SKIP (0.000s) [440.245247] Starting dynamic subtest: vcs1 [440.248621] Dynamic subtest vcs1: SKIP (0.000s) [440.256501] Starting dynamic subtest: vecs0 [440.259858] Dynamic subtest vecs0: SKIP (0.000s) [440.267708] Starting dynamic subtest: ccs0 [440.271142] Dynamic subtest ccs0: SKIP (0.000s) [440.274447] Subtest isolation: SKIP (0.028s) [440.310349] [085/133] (595s left) gen9_exec_parse (bb-oversize) [440.374924] Subtest bb-oversize: SKIP (0.000s) [440.491774] [086/133] (595s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [440.606658] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip [440.610514] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [440.681458] [087/133] (595s left) kms_joiner (basic-big-joiner) [440.788440] Starting subtest: basic-big-joiner [440.791788] Subtest basic-big-joiner: SKIP (0.000s) [440.836429] [088/133] (595s left) prime_mmap (test_forked_cpu_write) [440.889353] Starting subtest: test_forked_cpu_write [440.891100] Starting dynamic subtest: test_forked_cpu_write-smem [440.895616] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.006s) [440.897550] Subtest test_forked_cpu_write: SUCCESS (0.007s) [440.974832] [089/133] (594s left) syncobj_timeline (wait-all-for-submit-snapshot) [441.020572] Starting subtest: wait-all-for-submit-snapshot [441.102099] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s) [441.156236] [090/133] (594s left) i915_pm_freq_mult (media-freq) [441.202073] Starting subtest: media-freq [441.204055] Starting dynamic subtest: gt0 [441.207583] Dynamic subtest gt0: SKIP (0.000s) [441.217413] Starting dynamic subtest: gt1 [441.220908] Dynamic subtest gt1: SKIP (0.000s) [441.224329] Subtest media-freq: SKIP (0.001s) [441.285902] [091/133] (594s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt) [441.375847] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt [441.379381] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [441.453343] [092/133] (594s left) kms_big_fb (linear-32bpp-rotate-90) [441.559954] Starting subtest: linear-32bpp-rotate-90 [441.582382] Subtest linear-32bpp-rotate-90: SKIP (0.022s) [441.674304] [093/133] (594s left) gem_exec_reloc (basic-gtt-read) [441.734665] Subtest basic-gtt-read: SKIP (0.000s) [441.799321] [094/133] (594s left) kms_psr (fbc-pr-no-drrs) [441.885970] Starting subtest: fbc-pr-no-drrs [441.889702] Subtest fbc-pr-no-drrs: SKIP (0.000s) [441.936690] [095/133] (594s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc) [442.032760] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc [446.065456] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.033s) [447.247986] [096/133] (588s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs) [447.345635] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs [447.347997] Starting dynamic subtest: pipe-A-eDP-1 [447.371354] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [447.385283] Starting dynamic subtest: pipe-B-eDP-1 [447.405729] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [447.414452] Starting dynamic subtest: pipe-C-eDP-1 [447.435969] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [447.444504] Starting dynamic subtest: pipe-D-eDP-1 [447.466507] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [447.470846] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.007s) [449.528849] [097/133] (586s left) kms_big_fb (yf-tiled-8bpp-rotate-270) [449.626673] Starting subtest: yf-tiled-8bpp-rotate-270 [449.630537] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s) [449.704267] [098/133] (586s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs) [449.794819] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs [449.796983] Starting dynamic subtest: pipe-A-eDP-1 [450.218154] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.424s) [450.230083] Starting dynamic subtest: pipe-B-eDP-1 [450.249737] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s) [450.260884] Starting dynamic subtest: pipe-C-eDP-1 [450.279208] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.003s) [450.288119] Starting dynamic subtest: pipe-D-eDP-1 [450.306498] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s) [450.308566] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.439s) [452.502533] [099/133] (583s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled) [452.565010] Starting subtest: yf-tiled-to-vebox-yf-tiled [452.569457] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s) [452.726045] [100/133] (583s left) gem_lmem_swapping (verify-random-ccs) [452.769006] Subtest verify-random-ccs: SKIP (0.000s) [452.815167] [101/133] (583s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions) [452.933778] Starting subtest: short-busy-flip-before-cursor-atomic-transitions [452.938121] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s) [453.058339] [102/133] (583s left) kms_fence_pin_leak [453.212262] [103/133] (583s left) kms_getfb (getfb2-handle-closed) [453.297853] Starting subtest: getfb2-handle-closed [453.300055] Subtest getfb2-handle-closed: SUCCESS (0.000s) [453.376949] [104/133] (583s left) perf (non-system-wide-paranoid) [453.437069] Starting subtest: non-system-wide-paranoid [453.464500] Subtest non-system-wide-paranoid: SUCCESS (0.027s) [453.516349] [105/133] (583s left) kms_vrr (flip-basic) [453.611254] Starting subtest: flip-basic [453.617126] Subtest flip-basic: SKIP (0.000s) [453.658379] [106/133] (583s left) gem_ctx_param (invalid-get-engines) [453.719456] Starting subtest: invalid-get-engines [453.721647] Subtest invalid-get-engines: SUCCESS (0.001s) [453.816614] [107/133] (582s left) kms_flip (basic-plain-flip) [453.908833] Starting subtest: basic-plain-flip [453.910709] Starting dynamic subtest: A-eDP1 [455.599853] Dynamic subtest A-eDP1: SUCCESS (1.689s) [455.610730] Starting dynamic subtest: B-eDP1 [457.241031] Dynamic subtest B-eDP1: SUCCESS (1.639s) [457.252562] Starting dynamic subtest: C-eDP1 [458.867897] Dynamic subtest C-eDP1: SUCCESS (1.625s) [458.887616] Starting dynamic subtest: D-eDP1 [460.507959] Dynamic subtest D-eDP1: SUCCESS (1.637s) [460.513980] Subtest basic-plain-flip: SUCCESS (6.603s) [461.667495] [108/133] (575s left) syncobj_wait (wait-all-delayed-signal) [461.726229] Starting subtest: wait-all-delayed-signal [461.828743] Subtest wait-all-delayed-signal: SUCCESS (0.103s) [461.888488] [109/133] (574s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf) [461.985114] Starting subtest: pr-overlay-plane-update-continuous-sf [461.989262] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s) [462.031251] [110/133] (574s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25) [462.122404] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25 [462.124529] Starting dynamic subtest: pipe-A [462.184710] Dynamic subtest pipe-A: SUCCESS (0.065s) [462.193838] Starting dynamic subtest: pipe-B [463.301950] Dynamic subtest pipe-B: SUCCESS (1.116s) [463.314217] Starting dynamic subtest: pipe-C [464.409150] Dynamic subtest pipe-C: SUCCESS (1.106s) [464.418487] Starting dynamic subtest: pipe-D [465.547694] Dynamic subtest pipe-D: SUCCESS (1.137s) [465.549882] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.428s) [466.676710] [111/133] (570s left) drm_buddy (drm_buddy) [466.716786] Starting subtest: drm_buddy [466.721205] Subtest drm_buddy: SKIP (0.001s) [466.762523] [112/133] (570s left) gem_mmap_gtt (ptrace) [466.827150] Subtest ptrace: SKIP (0.000s) [466.889854] [113/133] (570s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu) [466.989246] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu [473.987907] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.000s) [474.070201] [114/133] (562s left) kms_getfb (getfb-handle-valid) [474.161777] Starting subtest: getfb-handle-valid [474.163739] Subtest getfb-handle-valid: SUCCESS (0.000s) [474.234648] [115/133] (562s left) syncobj_timeline (etime-single-wait-all-submitted) [474.288424] Starting subtest: etime-single-wait-all-submitted [474.393625] Subtest etime-single-wait-all-submitted: SUCCESS (0.105s) [474.447074] [116/133] (562s left) gem_exec_whisper (basic-queues-priority-all) [474.517822] Starting subtest: basic-queues-priority-all [496.110671] Subtest basic-queues-priority-all: SUCCESS (21.585s) [496.276890] [117/133] (540s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted) [496.334900] Starting subtest: multi-wait-for-submit-unsubmitted-submitted [496.441412] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.107s) [496.497122] [118/133] (540s left) kms_draw_crc (draw-method-pwrite) [496.587411] Starting subtest: draw-method-pwrite [496.589594] Starting dynamic subtest: xrgb8888-untiled [497.208835] Dynamic subtest xrgb8888-untiled: SUCCESS (0.622s) [497.218649] Starting dynamic subtest: rgb565-untiled [497.720313] Dynamic subtest rgb565-untiled: SUCCESS (0.510s) [497.731895] Starting dynamic subtest: xrgb2101010-untiled [498.331511] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.610s) [498.341323] Starting dynamic subtest: xbgr16161616f-untiled [499.154102] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.821s) [499.165520] Starting dynamic subtest: xrgb8888-xtiled [501.310049] Dynamic subtest xrgb8888-xtiled: SUCCESS (2.155s) [501.322538] Starting dynamic subtest: rgb565-xtiled [502.676796] Dynamic subtest rgb565-xtiled: SUCCESS (1.364s) [502.686805] Starting dynamic subtest: xrgb2101010-xtiled [504.788649] Dynamic subtest xrgb2101010-xtiled: SUCCESS (2.110s) [504.798675] Starting dynamic subtest: xbgr16161616f-xtiled [508.511963] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.722s) [508.521720] Starting dynamic subtest: xrgb8888-4tiled [509.801047] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.288s) [509.812898] Starting dynamic subtest: rgb565-4tiled [510.479175] Dynamic subtest rgb565-4tiled: SUCCESS (0.677s) [510.490649] Starting dynamic subtest: xrgb2101010-4tiled [511.759421] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.277s) [511.769062] Starting dynamic subtest: xbgr16161616f-4tiled [515.135723] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.376s) [515.137884] Subtest draw-method-pwrite: SUCCESS (18.546s) [515.210699] [119/133] (522s left) sw_sync (sync_expired_merge) [515.248056] Starting subtest: sync_expired_merge [516.321438] Subtest sync_expired_merge: SUCCESS (1.074s) [516.364114] [120/133] (520s left) kms_color (legacy-gamma-reset) [516.458566] Starting subtest: legacy-gamma-reset [516.460470] Starting dynamic subtest: pipe-A-eDP-1 [516.830219] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.374s) [516.839950] Starting dynamic subtest: pipe-B-eDP-1 [516.844326] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.012s) [516.853346] Starting dynamic subtest: pipe-C-eDP-1 [516.858258] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.012s) [516.867468] Starting dynamic subtest: pipe-D-eDP-1 [516.869693] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s) [516.872033] Subtest legacy-gamma-reset: SUCCESS (0.413s) [517.639375] [121/133] (519s left) core_auth (getclient-simple) [517.679475] Starting subtest: getclient-simple [517.697232] Subtest getclient-simple: SUCCESS (0.018s) [517.786511] [122/133] (519s left) intel_hwmon (hwmon-write) [517.839990] Subtest hwmon-write: SKIP (0.000s) [517.906927] [123/133] (519s left) kms_big_fb (x-tiled-8bpp-rotate-0) [518.008023] Starting subtest: x-tiled-8bpp-rotate-0 [519.177815] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.169s) [519.289944] [124/133] (518s left) kms_psr (fbc-psr2-basic) [519.383362] Starting subtest: fbc-psr2-basic [519.385267] Starting dynamic subtest: eDP-1 [519.389020] Dynamic subtest eDP-1: SKIP (0.000s) [519.392601] Subtest fbc-psr2-basic: SKIP (0.001s) [519.433519] [125/133] (518s left) gem_ctx_persistence (legacy-engines-hang) [519.490781] Starting subtest: legacy-engines-hang [519.492863] Starting dynamic subtest: render [519.578109] Dynamic subtest render: SUCCESS (0.086s) [519.591975] Starting dynamic subtest: bsd1 [519.672207] Dynamic subtest bsd1: SUCCESS (0.091s) [519.684256] Starting dynamic subtest: bsd2 [519.769597] Dynamic subtest bsd2: SUCCESS (0.095s) [519.784042] Starting dynamic subtest: blt [519.869513] Dynamic subtest blt: SUCCESS (0.097s) [519.883204] Starting dynamic subtest: vebox [519.975734] Dynamic subtest vebox: SUCCESS (0.103s) [519.977939] Subtest legacy-engines-hang: SUCCESS (0.486s) [520.032309] [126/133] (517s left) kms_flip (2x-wf_vblank-ts-check) [520.128873] Starting subtest: 2x-wf_vblank-ts-check [520.140298] Subtest 2x-wf_vblank-ts-check: SKIP (0.011s) [520.197686] [127/133] (517s left) gem_exec_store (dword) [520.247632] Starting subtest: dword [520.249297] Starting dynamic subtest: rcs0 [520.311598] Dynamic subtest rcs0: SUCCESS (0.064s) [520.323660] Starting dynamic subtest: bcs0 [520.352302] Dynamic subtest bcs0: SUCCESS (0.039s) [520.364298] Starting dynamic subtest: vcs0 [520.397565] Dynamic subtest vcs0: SUCCESS (0.042s) [520.410951] Starting dynamic subtest: vcs1 [520.440195] Dynamic subtest vcs1: SUCCESS (0.041s) [520.450267] Starting dynamic subtest: vecs0 [520.481141] Dynamic subtest vecs0: SUCCESS (0.039s) [520.494464] Starting dynamic subtest: ccs0 [520.525422] Dynamic subtest ccs0: SUCCESS (0.042s) [520.527438] Subtest dword: SUCCESS (0.280s) [520.700530] [128/133] (516s left) kms_flip (nonexisting-fb-interruptible) [520.809999] Starting subtest: nonexisting-fb-interruptible [520.812269] Starting dynamic subtest: A-eDP1 [521.934927] Dynamic subtest A-eDP1: SUCCESS (1.123s) [521.947300] Starting dynamic subtest: B-eDP1 [523.069038] Dynamic subtest B-eDP1: SUCCESS (1.132s) [523.078722] Starting dynamic subtest: C-eDP1 [524.198747] Dynamic subtest C-eDP1: SUCCESS (1.128s) [524.210640] Starting dynamic subtest: D-eDP1 [525.332653] Dynamic subtest D-eDP1: SUCCESS (1.133s) [525.337475] Subtest nonexisting-fb-interruptible: SUCCESS (4.527s) [526.493858] [129/133] (511s left) kms_plane_cursor (primary) [526.580806] Starting subtest: primary [526.585185] Starting dynamic subtest: pipe-A-eDP-1-size-64 [529.124429] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.543s) [529.148600] Starting dynamic subtest: pipe-A-eDP-1-size-128 [531.724914] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.582s) [531.750778] Starting dynamic subtest: pipe-A-eDP-1-size-256 [534.350082] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.605s) [534.671154] Starting dynamic subtest: pipe-B-eDP-1-size-64 [537.898084] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.238s) [537.923113] Starting dynamic subtest: pipe-B-eDP-1-size-128 [540.467521] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.550s) [540.491217] Starting dynamic subtest: pipe-B-eDP-1-size-256 [543.046774] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.560s) [543.362554] Starting dynamic subtest: pipe-C-eDP-1-size-64 [546.270858] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.921s) [546.298759] Starting dynamic subtest: pipe-C-eDP-1-size-128 [548.472672] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.180s) [548.499807] Starting dynamic subtest: pipe-C-eDP-1-size-256 [550.683741] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.191s) [551.009218] Starting dynamic subtest: pipe-D-eDP-1-size-64 [553.916027] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.917s) [553.943723] Starting dynamic subtest: pipe-D-eDP-1-size-128 [556.160959] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.225s) [556.190843] Starting dynamic subtest: pipe-D-eDP-1-size-256 [558.362326] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.181s) [558.668970] Subtest primary: SUCCESS (32.079s) [559.448031] [130/133] (478s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu) [559.542367] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu [566.319407] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.779s) [566.424333] [131/133] (471s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted) [566.491949] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted [566.601624] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.108s) [566.655002] [132/133] (471s left) kms_selftest (drm_framebuffer) [566.697422] Starting subtest: drm_framebuffer [566.749130] Starting dynamic subtest: drm_test_framebuffer_check_src_coords [566.853442] Dynamic subtest drm_test_framebuffer_check_src_coords: SUCCESS (0.105s) [566.866275] Starting dynamic subtest: drm_test_framebuffer_cleanup [566.968171] Dynamic subtest drm_test_framebuffer_cleanup: SUCCESS (0.110s) [566.980242] Starting dynamic subtest: drm_test_framebuffer_create [567.149442] Dynamic subtest drm_test_framebuffer_create: SUCCESS (0.182s) [567.160307] Starting dynamic subtest: drm_test_framebuffer_free [567.368427] Dynamic subtest drm_test_framebuffer_free: FAIL (0.164s) [567.372611] Subtest drm_framebuffer: FAIL (0.619s) [567.424714] Aborting: Kernel badly tainted (0x44244, 0x200) (check dmesg for details): TAINT_WARN: WARN_ON has happened. [567.443214] [FACT kms_selftest (drm_framebuffer)] new: kernel.is_tainted.taint_warn: true [567.444151] 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.