[57.229970] Initializing watchdogs [57.230037] /dev/watchdog0 [57.244919] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [57.249733] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.252035] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.255352] [001/132] (960s left) kms_psr (fbc-psr2-no-drrs) [57.375720] Starting subtest: fbc-psr2-no-drrs [57.377824] Starting dynamic subtest: eDP-1 [57.382125] Dynamic subtest eDP-1: SKIP (0.000s) [57.386448] Subtest fbc-psr2-no-drrs: SKIP (0.000s) [57.444422] [002/132] (960s left) kms_content_protection (atomic-dpms-hdcp14) [57.588076] Starting subtest: atomic-dpms-hdcp14 [57.592845] Subtest atomic-dpms-hdcp14: SKIP (0.000s) [57.706103] [003/132] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt) [57.814712] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt [57.819127] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [57.921803] [004/132] (959s left) kms_big_fb (4-tiled-32bpp-rotate-270) [58.026707] Starting subtest: 4-tiled-32bpp-rotate-270 [58.060089] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.033s) [58.156229] [005/132] (959s left) perf (invalid-oa-exponent) [58.285533] Starting subtest: invalid-oa-exponent [58.300597] Subtest invalid-oa-exponent: SUCCESS (0.014s) [58.333899] [006/132] (959s left) core_hotunplug (unbind-rebind) [58.418448] Starting subtest: unbind-rebind [64.284718] Subtest unbind-rebind: SUCCESS (5.808s) [64.324861] [007/132] (953s left) gem_exec_params (rel-constants-invalid-ring) [66.290709] Starting subtest: rel-constants-invalid-ring [66.293144] Subtest rel-constants-invalid-ring: SUCCESS (0.000s) [66.395803] [008/132] (951s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs) [66.502841] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs [66.505121] Starting dynamic subtest: pipe-A-eDP-1 [66.514298] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [66.524063] Starting dynamic subtest: pipe-B-eDP-1 [66.532863] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [66.540375] Starting dynamic subtest: pipe-C-eDP-1 [66.548671] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [66.556142] Starting dynamic subtest: pipe-D-eDP-1 [66.564551] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [66.568642] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.003s) [68.770757] [009/132] (949s left) kms_chamelium_frames (hdmi-frame-dump) [69.155790] Subtest hdmi-frame-dump: SKIP (0.000s) [69.986695] [010/132] (948s left) kms_plane_scaling (planes-upscale-20x20) [70.087557] Starting subtest: planes-upscale-20x20 [70.089784] Starting dynamic subtest: pipe-A [70.160357] Dynamic subtest pipe-A: SUCCESS (0.076s) [70.170424] Starting dynamic subtest: pipe-B [71.337576] Dynamic subtest pipe-B: SUCCESS (1.173s) [71.347359] Starting dynamic subtest: pipe-C [72.452131] Dynamic subtest pipe-C: SUCCESS (1.112s) [72.461689] Starting dynamic subtest: pipe-D [73.584492] Dynamic subtest pipe-D: SUCCESS (1.130s) [73.586915] Subtest planes-upscale-20x20: SUCCESS (3.492s) [74.757901] [011/132] (943s left) kms_cursor_crc (cursor-offscreen-32x32) [74.899708] Starting subtest: cursor-offscreen-32x32 [74.945432] Subtest cursor-offscreen-32x32: SKIP (0.040s) [75.224661] [012/132] (942s left) kms_prime (basic-crc-hybrid) [75.312030] Subtest basic-crc-hybrid: SKIP (0.000s) [75.430780] [FACT kms_prime (basic-crc-hybrid)] new: kernel.kmod_is_loaded.vgem: true [75.434137] [013/132] (942s left) gem_exec_params (no-bsd) [75.489956] Starting subtest: no-bsd [75.492275] Subtest no-bsd: SUCCESS (0.002s) [77.376733] [014/132] (940s left) gem_exec_schedule (smoketest-all) [77.450281] Starting subtest: smoketest-all [109.833598] Subtest smoketest-all: SUCCESS (32.326s) [111.357213] [015/132] (906s left) gem_mmap_wc (read-write) [111.418733] Subtest read-write: SKIP (0.000s) [111.474117] [016/132] (906s left) gem_spin_batch (spin-each) [111.526716] Starting subtest: spin-each [114.897725] Subtest spin-each: SUCCESS (3.370s) [115.339232] [017/132] (903s left) kms_dp_linktrain_fallback (dp-fallback) [115.437861] Starting subtest: dp-fallback [115.444356] Subtest dp-fallback: SKIP (0.000s) [115.512365] [018/132] (902s left) kms_plane_lowres (tiling-yf) [115.598078] Starting subtest: tiling-yf [115.602306] Subtest tiling-yf: SKIP (0.000s) [115.668071] [019/132] (902s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip) [115.776118] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip [115.780132] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s) [115.867520] [020/132] (902s left) kms_feature_discovery (psr2) [115.960792] Starting subtest: psr2 [115.963044] Subtest psr2: SUCCESS (0.000s) [116.033304] [021/132] (902s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping) [116.122829] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping [116.127470] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s) [116.208520] [022/132] (902s left) kms_busy (extended-modeset-hang-oldfb-with-reset) [116.306831] Starting subtest: extended-modeset-hang-oldfb-with-reset [116.308861] Starting dynamic subtest: pipe-A [128.328450] Dynamic subtest pipe-A: SUCCESS (12.018s) [128.338607] Starting dynamic subtest: pipe-D [140.606273] Dynamic subtest pipe-D: SUCCESS (12.276s) [140.608473] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.298s) [141.409335] [023/132] (877s left) kms_plane (plane-position-covered) [141.512288] Starting subtest: plane-position-covered [142.019090] Starting dynamic subtest: pipe-A-plane-1 [143.291947] Dynamic subtest pipe-A-plane-1: SUCCESS (1.274s) [143.301464] Starting dynamic subtest: pipe-A-plane-2 [144.585617] Dynamic subtest pipe-A-plane-2: SUCCESS (1.291s) [144.595241] Starting dynamic subtest: pipe-A-plane-3 [145.825087] Dynamic subtest pipe-A-plane-3: SUCCESS (1.241s) [145.834402] Starting dynamic subtest: pipe-A-plane-4 [147.064742] Dynamic subtest pipe-A-plane-4: SUCCESS (1.237s) [147.074935] Starting dynamic subtest: pipe-A-plane-5 [147.087141] Dynamic subtest pipe-A-plane-5: SUCCESS (0.022s) [148.220535] Starting dynamic subtest: pipe-B-plane-1 [149.466995] Dynamic subtest pipe-B-plane-1: SUCCESS (1.256s) [149.477583] Starting dynamic subtest: pipe-B-plane-2 [150.808408] Dynamic subtest pipe-B-plane-2: SUCCESS (1.340s) [150.819740] Starting dynamic subtest: pipe-B-plane-3 [152.141757] Dynamic subtest pipe-B-plane-3: SUCCESS (1.331s) [152.151708] Starting dynamic subtest: pipe-B-plane-4 [153.409528] Dynamic subtest pipe-B-plane-4: SUCCESS (1.268s) [153.422889] Starting dynamic subtest: pipe-B-plane-5 [153.436249] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s) [153.438160] Subtest plane-position-covered: SUCCESS (11.924s) [154.281326] [024/132] (864s left) kms_psr (fbc-psr-sprite-plane-move) [154.373986] Starting subtest: fbc-psr-sprite-plane-move [154.376200] Starting dynamic subtest: eDP-1 [154.380155] Dynamic subtest eDP-1: SKIP (0.000s) [154.384182] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s) [154.462328] [025/132] (864s left) gem_ctx_persistence (engines-cleanup) [154.517081] Starting subtest: engines-cleanup [154.519289] Starting dynamic subtest: rcs0 [154.564795] Dynamic subtest rcs0: SUCCESS (0.050s) [154.575027] Starting dynamic subtest: bcs0 [154.646243] Dynamic subtest bcs0: SUCCESS (0.081s) [154.657160] Starting dynamic subtest: vcs0 [154.674859] Dynamic subtest vcs0: SUCCESS (0.027s) [154.690405] Starting dynamic subtest: vcs1 [154.742193] Dynamic subtest vcs1: SUCCESS (0.067s) [154.753816] Starting dynamic subtest: vecs0 [154.759577] Dynamic subtest vecs0: SUCCESS (0.016s) [154.767637] Starting dynamic subtest: ccs0 [154.835458] Dynamic subtest ccs0: SUCCESS (0.075s) [154.838034] Subtest engines-cleanup: SUCCESS (0.322s) [154.915520] [026/132] (863s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [155.003659] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu [155.007774] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [155.104347] [027/132] (863s left) tools_test (sysfs_l3_parity) [155.155643] Starting subtest: sysfs_l3_parity [155.225373] Subtest sysfs_l3_parity: SKIP (0.082s) [155.278569] [028/132] (863s left) kms_properties (get_properties-sanity-atomic) [155.379466] Starting subtest: get_properties-sanity-atomic [155.381474] Subtest get_properties-sanity-atomic: SUCCESS (0.002s) [155.463478] [029/132] (863s left) gem_exec_whisper (basic-contexts-forked-all) [155.530337] Starting subtest: basic-contexts-forked-all [176.347984] Subtest basic-contexts-forked-all: SUCCESS (20.812s) [176.547128] [030/132] (842s left) kms_flip (2x-flip-vs-expired-vblank) [176.654413] Starting subtest: 2x-flip-vs-expired-vblank [176.663802] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s) [176.787205] [031/132] (842s left) kms_pm_backlight (brightness-with-dpms) [176.888413] Starting subtest: brightness-with-dpms [176.939951] Starting dynamic subtest: eDP-1 [179.372963] Dynamic subtest eDP-1: SUCCESS (2.430s) [179.375183] Subtest brightness-with-dpms: SUCCESS (2.484s) [180.236673] [032/132] (838s left) gem_exec_reloc (basic-write-cpu-noreloc) [180.298792] Subtest basic-write-cpu-noreloc: SKIP (0.000s) [180.369732] [033/132] (838s left) gem_eio (in-flight-internal-immediate) [180.590513] Starting subtest: in-flight-internal-immediate [182.357631] Subtest in-flight-internal-immediate: SUCCESS (1.766s) [182.487126] [034/132] (836s left) gem_exercise_blt (fast-copy-emit) [182.546747] Starting subtest: fast-copy-emit [182.548627] Starting dynamic subtest: linear-smem-smem-emit [182.596792] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.051s) [182.608456] Starting dynamic subtest: xmajor-smem-smem-emit [182.617223] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.019s) [182.627634] Starting dynamic subtest: tile4-smem-smem-emit [182.656586] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.039s) [182.665779] Starting dynamic subtest: tile64-smem-smem-emit [182.676829] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.019s) [182.679170] Subtest fast-copy-emit: SUCCESS (0.132s) [182.799273] [035/132] (836s left) gem_exec_reloc (basic-write-gtt) [182.851816] Subtest basic-write-gtt: SKIP (0.000s) [182.928626] [036/132] (836s left) perf_pmu (idle-no-semaphores) [182.968745] Starting subtest: idle-no-semaphores [182.970991] Starting dynamic subtest: rcs0 [183.499973] Dynamic subtest rcs0: SUCCESS (0.532s) [183.512772] Starting dynamic subtest: bcs0 [184.020904] Dynamic subtest bcs0: SUCCESS (0.518s) [184.034764] Starting dynamic subtest: vcs0 [184.541767] Dynamic subtest vcs0: SUCCESS (0.519s) [184.551956] Starting dynamic subtest: vcs1 [185.061745] Dynamic subtest vcs1: SUCCESS (0.517s) [185.072568] Starting dynamic subtest: vecs0 [185.580450] Dynamic subtest vecs0: SUCCESS (0.516s) [185.593278] Starting dynamic subtest: ccs0 [186.105075] Dynamic subtest ccs0: SUCCESS (0.522s) [186.108196] Subtest idle-no-semaphores: SUCCESS (3.137s) [186.220897] [037/132] (832s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs) [186.312585] Starting subtest: ccs-on-another-bo-y-tiled-ccs [186.314735] Starting dynamic subtest: pipe-A-eDP-1 [186.337788] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [186.348754] Starting dynamic subtest: pipe-B-eDP-1 [186.370736] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [186.380619] Starting dynamic subtest: pipe-C-eDP-1 [186.403591] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [186.414237] Starting dynamic subtest: pipe-D-eDP-1 [186.437357] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [186.441598] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.003s) [188.579335] [038/132] (830s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move) [188.680733] Starting subtest: fbc-2p-scndscrn-spr-indfb-move [188.685125] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [188.777113] [039/132] (830s left) kms_color_pipeline (plane-ctm3x4-lut1d) [188.872984] Starting subtest: plane-ctm3x4-lut1d [189.032761] Starting dynamic subtest: pipe-A-plane-0 [189.186295] Dynamic subtest pipe-A-plane-0: SUCCESS (0.155s) [189.196228] Starting dynamic subtest: pipe-A-plane-1 [189.385784] Dynamic subtest pipe-A-plane-1: SUCCESS (0.200s) [189.394856] Starting dynamic subtest: pipe-A-plane-2 [189.530555] Dynamic subtest pipe-A-plane-2: SUCCESS (0.143s) [190.679245] Starting dynamic subtest: pipe-B-plane-0 [190.850189] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s) [190.859767] Starting dynamic subtest: pipe-B-plane-1 [191.039159] Dynamic subtest pipe-B-plane-1: SUCCESS (0.189s) [191.048916] Starting dynamic subtest: pipe-B-plane-2 [191.193953] Dynamic subtest pipe-B-plane-2: SUCCESS (0.153s) [192.433320] Starting dynamic subtest: pipe-C-plane-0 [192.568603] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s) [192.578173] Starting dynamic subtest: pipe-C-plane-1 [192.746927] Dynamic subtest pipe-C-plane-1: SUCCESS (0.178s) [192.770200] Starting dynamic subtest: pipe-C-plane-2 [192.913025] Dynamic subtest pipe-C-plane-2: SUCCESS (0.165s) [194.078455] Starting dynamic subtest: pipe-D-plane-0 [194.215233] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s) [194.225192] Starting dynamic subtest: pipe-D-plane-1 [194.381532] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s) [194.392141] Starting dynamic subtest: pipe-D-plane-2 [194.537818] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s) [194.830334] Subtest plane-ctm3x4-lut1d: SUCCESS (5.956s) [195.640658] [040/132] (823s left) gem_pread (self) [195.706065] Subtest self: SKIP (0.000s) [195.777560] [041/132] (823s left) kms_vrr (max-min) [195.860867] Starting subtest: max-min [195.867116] Subtest max-min: SKIP (0.000s) [195.935757] [042/132] (823s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc) [196.043409] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc [200.326651] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.287s) [201.540370] [043/132] (817s left) sysfs_preempt_timeout (timeout) [201.609099] Starting subtest: timeout [201.611568] Starting dynamic subtest: vecs0 [211.263850] Dynamic subtest vecs0: SUCCESS (9.651s) [211.277068] Starting dynamic subtest: ccs0 [212.545916] Dynamic subtest ccs0: SUCCESS (1.281s) [212.558267] Starting dynamic subtest: vcs0 [222.274345] Dynamic subtest vcs0: SUCCESS (9.727s) [222.285442] Starting dynamic subtest: bcs0 [223.552912] Dynamic subtest bcs0: SUCCESS (1.277s) [223.561925] Starting dynamic subtest: rcs0 [224.824532] Dynamic subtest rcs0: SUCCESS (1.271s) [224.835930] Starting dynamic subtest: vcs1 [234.303178] Dynamic subtest vcs1: SUCCESS (9.475s) [234.305658] Subtest timeout: SUCCESS (32.690s) [234.377360] [044/132] (785s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs) [234.433857] Starting subtest: y-tiled-ccs-to-y-tiled-ccs [234.438880] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s) [234.618549] [045/132] (784s left) gem_ctx_shared (exec-shared-gtt) [234.685291] Starting subtest: exec-shared-gtt [234.687564] Starting dynamic subtest: rcs0 [234.698345] Dynamic subtest rcs0: SUCCESS (0.015s) [234.711681] Starting dynamic subtest: bcs0 [234.713883] Dynamic subtest bcs0: SUCCESS (0.008s) [234.723437] Starting dynamic subtest: vcs0 [234.725332] Dynamic subtest vcs0: SUCCESS (0.012s) [234.735063] Starting dynamic subtest: vcs1 [234.737233] Dynamic subtest vcs1: SUCCESS (0.010s) [234.746564] Starting dynamic subtest: vecs0 [234.748486] Dynamic subtest vecs0: SUCCESS (0.010s) [234.758142] Starting dynamic subtest: ccs0 [234.760216] Dynamic subtest ccs0: SUCCESS (0.011s) [234.762304] Subtest exec-shared-gtt: SUCCESS (0.070s) [234.956361] [046/132] (784s left) kms_flip (flip-vs-dpms-off-vs-modeset) [235.047087] Starting subtest: flip-vs-dpms-off-vs-modeset [235.049402] Starting dynamic subtest: A-eDP1 [238.651423] Dynamic subtest A-eDP1: SUCCESS (3.600s) [238.662489] Starting dynamic subtest: B-eDP1 [241.887433] Dynamic subtest B-eDP1: SUCCESS (3.235s) [241.898199] Starting dynamic subtest: C-eDP1 [245.076435] Dynamic subtest C-eDP1: SUCCESS (3.188s) [245.086927] Starting dynamic subtest: D-eDP1 [248.199984] Dynamic subtest D-eDP1: SUCCESS (3.124s) [248.202395] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.154s) [248.999590] [047/132] (770s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt) [249.098569] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt [249.102838] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [249.185795] [048/132] (770s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs) [249.290140] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs [249.292412] Starting dynamic subtest: pipe-A-eDP-1 [249.316924] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [249.327440] Starting dynamic subtest: pipe-B-eDP-1 [249.350641] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [249.359821] Starting dynamic subtest: pipe-C-eDP-1 [249.383192] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [249.391980] Starting dynamic subtest: pipe-D-eDP-1 [249.415633] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [249.419690] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s) [251.563779] [049/132] (768s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs) [251.651042] Starting subtest: random-ccs-data-4-tiled-lnl-ccs [251.655859] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s) [252.794590] [050/132] (766s left) kms_psr (psr2-cursor-blt) [252.887078] Starting subtest: psr2-cursor-blt [252.889329] Starting dynamic subtest: eDP-1 [254.567309] Dynamic subtest eDP-1: SUCCESS (1.679s) [254.569650] Subtest psr2-cursor-blt: SUCCESS (1.680s) [255.463520] [051/132] (764s left) kms_flip (2x-modeset-vs-vblank-race) [255.553931] Starting subtest: 2x-modeset-vs-vblank-race [255.565595] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s) [255.646609] [052/132] (764s left) i915_drm_fdinfo (busy-idle) [255.690807] Starting subtest: busy-idle [255.692985] Starting dynamic subtest: rcs0 [255.715036] Dynamic subtest rcs0: SKIP (0.022s) [255.730360] Starting dynamic subtest: bcs0 [255.735019] Dynamic subtest bcs0: SKIP (0.019s) [255.744400] Starting dynamic subtest: vcs0 [255.748453] Dynamic subtest vcs0: SKIP (0.000s) [255.758282] Starting dynamic subtest: vcs1 [255.766794] Dynamic subtest vcs1: SKIP (0.000s) [255.780798] Starting dynamic subtest: vecs0 [255.785461] Dynamic subtest vecs0: SKIP (0.000s) [255.795050] Starting dynamic subtest: ccs0 [255.799189] Dynamic subtest ccs0: SKIP (0.000s) [255.803303] Subtest busy-idle: SKIP (0.047s) [255.841125] [053/132] (764s left) kms_chamelium_hpd (vga-hpd) [256.212950] Subtest vga-hpd: SKIP (0.000s) [257.069021] [054/132] (762s left) kms_mmap_write_crc (main) [257.174070] Starting subtest: main [257.176366] Starting dynamic subtest: pipe-A-eDP-1 [260.686743] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.509s) [260.688958] Subtest main: SUCCESS (3.511s) [261.527231] [055/132] (758s left) perf (sysctl-defaults) [261.604551] Starting subtest: sysctl-defaults [261.606750] Subtest sysctl-defaults: SUCCESS (0.000s) [261.697476] [056/132] (758s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs) [261.792155] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs [261.794380] Starting dynamic subtest: pipe-A-eDP-1 [261.814658] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [261.826133] Starting dynamic subtest: pipe-B-eDP-1 [261.844855] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [261.853936] Starting dynamic subtest: pipe-C-eDP-1 [261.873333] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [261.882233] Starting dynamic subtest: pipe-D-eDP-1 [261.901311] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [261.903168] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s) [264.065155] [057/132] (755s left) syncobj_eventfd (invalid-bad-flags) [264.123129] Starting subtest: invalid-bad-flags [264.125445] Subtest invalid-bad-flags: SUCCESS (0.000s) [264.233815] [058/132] (755s left) gem_exec_fence (syncobj-invalid-wait) [264.717916] Starting subtest: syncobj-invalid-wait [264.720352] Subtest syncobj-invalid-wait: SUCCESS (0.000s) [266.390364] [059/132] (753s left) kms_invalid_mode (bad-vtotal) [266.484310] Starting subtest: bad-vtotal [266.486604] Starting dynamic subtest: pipe-A-eDP-1 [266.773620] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s) [266.783734] Starting dynamic subtest: pipe-B-eDP-1 [266.785644] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [266.794239] Starting dynamic subtest: pipe-C-eDP-1 [266.796540] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [266.808619] Starting dynamic subtest: pipe-D-eDP-1 [266.810923] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [266.813133] Subtest bad-vtotal: SUCCESS (0.297s) [267.608172] [060/132] (752s left) syncobj_timeline (single-wait-all-available-signaled) [267.670675] Starting subtest: single-wait-all-available-signaled [267.672693] Subtest single-wait-all-available-signaled: SUCCESS (0.000s) [267.765028] [061/132] (752s left) kms_frontbuffer_tracking (psr-2p-rte) [267.854726] Starting subtest: psr-2p-rte [267.858712] Subtest psr-2p-rte: SKIP (0.000s) [267.966043] [062/132] (752s left) kms_pipe_crc_basic (hang-read-crc) [268.056312] Starting subtest: hang-read-crc [268.058527] Starting dynamic subtest: pipe-A-eDP-1 [270.161406] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.104s) [270.171554] Starting dynamic subtest: pipe-B-eDP-1 [272.850256] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.689s) [272.860295] Starting dynamic subtest: pipe-C-eDP-1 [275.572969] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.722s) [275.583193] Starting dynamic subtest: pipe-D-eDP-1 [278.238196] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.663s) [278.240473] Subtest hang-read-crc: SUCCESS (10.184s) [279.058375] [063/132] (741s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc) [279.171898] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc [286.187235] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.018s) [286.299455] [064/132] (734s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf) [286.406119] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf [286.408536] Starting dynamic subtest: pipe-A-eDP-1 [286.500800] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s) [286.510671] Starting dynamic subtest: pipe-B-eDP-1 [287.658305] Dynamic subtest pipe-B-eDP-1: SKIP (1.155s) [287.662767] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.257s) [288.863683] [065/132] (731s left) kms_big_fb (linear-64bpp-rotate-270) [288.959183] Starting subtest: linear-64bpp-rotate-270 [288.979357] Subtest linear-64bpp-rotate-270: SKIP (0.019s) [289.108377] [066/132] (731s left) gem_exec_reloc (basic-write-cpu) [289.166541] Subtest basic-write-cpu: SKIP (0.000s) [289.245061] [067/132] (731s left) api_intel_bb (object-noreloc-purge-cache-simple) [289.307730] Starting subtest: object-noreloc-purge-cache-simple [289.313512] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.006s) [289.455254] [068/132] (731s left) kms_atomic_transition (plane-all-transition-fencing) [289.556080] Starting subtest: plane-all-transition-fencing [289.558413] Starting dynamic subtest: pipe-A-eDP-1 [292.048816] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s) [292.351394] Starting dynamic subtest: pipe-B-eDP-1 [295.573370] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.230s) [295.874266] Subtest plane-all-transition-fencing: SUCCESS (6.319s) [296.702778] [069/132] (723s left) kms_getfb (getfb-handle-zero) [296.794865] Starting subtest: getfb-handle-zero [296.797051] Subtest getfb-handle-zero: SUCCESS (0.000s) [296.894174] [070/132] (723s left) gem_ctx_engines (execute-allforone) [296.948864] Starting subtest: execute-allforone [296.963286] Subtest execute-allforone: SUCCESS (0.015s) [298.358799] [071/132] (722s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc) [298.455147] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc [305.076539] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.623s) [305.192353] [072/132] (715s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move) [305.294162] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move [305.298182] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [305.389073] [073/132] (715s left) kms_rotation_crc (primary-y-tiled-reflect-x-270) [305.478353] Starting subtest: primary-y-tiled-reflect-x-270 [305.482366] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s) [305.551063] [074/132] (715s left) fbdev (nullptr) [305.590632] Starting subtest: nullptr [305.592980] Subtest nullptr: SUCCESS (0.000s) [305.648960] [075/132] (715s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size) [305.768173] Starting subtest: cursorB-vs-flipA-varying-size [305.772406] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s) [305.909457] [076/132] (714s left) kms_flip (flip-vs-suspend-interruptible) [306.003907] Starting subtest: flip-vs-suspend-interruptible [306.006290] Starting dynamic subtest: A-eDP1 [451.193458] Dynamic subtest A-eDP1: SUCCESS (11.308s) [451.195648] Subtest flip-vs-suspend-interruptible: SUCCESS (11.312s) [451.347097] [077/132] (569s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu) [451.447472] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu [458.096475] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.544s) [458.226570] [078/132] (562s left) kms_flip (2x-plain-flip-fb-recreate-interruptible) [458.318978] Starting subtest: 2x-plain-flip-fb-recreate-interruptible [458.331516] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.011s) [458.440716] [079/132] (562s left) kms_rotation_crc (multiplane-rotation-cropping-bottom) [458.537781] Starting subtest: multiplane-rotation-cropping-bottom [476.004305] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.394s) [476.124197] [080/132] (544s left) gem_mmap_gtt (cpuset-basic-small-copy) [476.194881] Subtest cpuset-basic-small-copy: SKIP (0.000s) [476.254188] [081/132] (544s left) gem_exec_schedule (u-semaphore-noskip) [476.324510] Starting subtest: u-semaphore-noskip [476.718814] Subtest u-semaphore-noskip: SUCCESS (0.396s) [477.059555] [082/132] (544s left) kms_cursor_edge_walk (128x128-top-bottom) [477.147027] Starting subtest: 128x128-top-bottom [477.149125] Starting dynamic subtest: pipe-A-eDP-1 [480.642424] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.490s) [480.653182] Starting dynamic subtest: pipe-D-eDP-1 [483.786328] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.139s) [483.788600] Subtest 128x128-top-bottom: SUCCESS (6.632s) [484.587576] [083/132] (536s left) gem_softpin (evict-active-interruptible) [484.646025] Starting subtest: evict-active-interruptible [484.651604] Subtest evict-active-interruptible: SUCCESS (0.006s) [484.783945] [084/132] (536s left) kms_prop_blob (invalid-get-prop) [484.842015] Starting subtest: invalid-get-prop [484.844194] Subtest invalid-get-prop: SUCCESS (0.000s) [484.932675] [085/132] (536s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render) [485.030568] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render [485.034977] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [485.131916] [086/132] (536s left) gem_exec_schedule (lateslice) [485.210626] Starting subtest: lateslice [485.212825] Starting dynamic subtest: rcs0 [485.221401] Dynamic subtest rcs0: SUCCESS (0.021s) [485.233982] Starting dynamic subtest: bcs0 [485.238955] Dynamic subtest bcs0: SUCCESS (0.017s) [485.249403] Starting dynamic subtest: vcs0 [485.257147] Dynamic subtest vcs0: SUCCESS (0.017s) [485.267342] Starting dynamic subtest: vcs1 [485.275409] Dynamic subtest vcs1: SUCCESS (0.017s) [485.285962] Starting dynamic subtest: vecs0 [485.292991] Dynamic subtest vecs0: SUCCESS (0.017s) [485.303218] Starting dynamic subtest: ccs0 [485.312749] Dynamic subtest ccs0: SUCCESS (0.019s) [485.315562] Subtest lateslice: SUCCESS (0.113s) [487.240027] [087/132] (534s left) gem_exec_params (invalid-batch-start-offset) [487.295721] Starting subtest: invalid-batch-start-offset [487.298033] Subtest invalid-batch-start-offset: SUCCESS (0.002s) [487.414799] [088/132] (533s left) kms_atomic_transition (modeset-transition-nonblocking-fencing) [487.511870] Starting subtest: modeset-transition-nonblocking-fencing [487.514131] Starting dynamic subtest: 1x-outputs [498.357463] Dynamic subtest 1x-outputs: SUCCESS (10.847s) [498.359973] Subtest modeset-transition-nonblocking-fencing: SUCCESS (10.848s) [499.214988] [089/132] (522s left) gem_ctx_persistence (heartbeat-close) [499.281277] Starting subtest: heartbeat-close [499.286071] Subtest heartbeat-close: SKIP (0.000s) [499.392374] [090/132] (522s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen) [499.487626] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen [499.492186] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [499.589062] [091/132] (521s left) gem_exec_params (rel-constants-invalid) [499.649457] Starting subtest: rel-constants-invalid [499.651903] Subtest rel-constants-invalid: SUCCESS (0.000s) [499.747344] [092/132] (521s left) kms_cursor_crc (cursor-random-max-size) [500.043056] Starting subtest: cursor-random-max-size [500.050192] Subtest cursor-random-max-size: SKIP (0.000s) [500.180722] [093/132] (521s left) syncobj_wait (wait-any-interrupted) [500.241196] Starting subtest: wait-any-interrupted [500.348304] Subtest wait-any-interrupted: SUCCESS (0.106s) [500.426418] [094/132] (521s left) kms_psr (psr2-sprite-plane-onoff) [500.518954] Starting subtest: psr2-sprite-plane-onoff [500.521192] Starting dynamic subtest: eDP-1 [502.219507] Dynamic subtest eDP-1: SUCCESS (1.698s) [502.221423] Subtest psr2-sprite-plane-onoff: SUCCESS (1.699s) [503.081225] [095/132] (518s left) i915_drm_fdinfo (virtual-busy-idle-all) [503.131078] Starting subtest: virtual-busy-idle-all [503.134890] Subtest virtual-busy-idle-all: SKIP (0.000s) [503.218976] [096/132] (518s left) kms_big_fb (yf-tiled-16bpp-rotate-180) [503.320472] Starting subtest: yf-tiled-16bpp-rotate-180 [503.324840] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s) [503.419719] [097/132] (518s left) kms_selftest (drm_framebuffer) [503.465874] Starting subtest: drm_framebuffer [503.496685] Starting dynamic subtest: drm_test_framebuffer_check_src_coords [503.589035] Dynamic subtest drm_test_framebuffer_check_src_coords: SUCCESS (0.097s) [503.599711] Starting dynamic subtest: drm_test_framebuffer_cleanup [503.689045] Dynamic subtest drm_test_framebuffer_cleanup: SUCCESS (0.099s) [503.702008] Starting dynamic subtest: drm_test_framebuffer_create [503.875017] Dynamic subtest drm_test_framebuffer_create: SUCCESS (0.183s) [503.886370] Starting dynamic subtest: drm_test_framebuffer_free [504.109282] Dynamic subtest drm_test_framebuffer_free: FAIL (0.181s) [504.113639] Subtest drm_framebuffer: FAIL (0.592s) [504.205352] Aborting: Kernel badly tainted (0x44244, 0x200) (check dmesg for details): TAINT_WARN: WARN_ON has happened. [504.222785] [FACT kms_selftest (drm_framebuffer)] new: kernel.is_tainted.taint_warn: true [504.223753] Closing watchdogs results: parsing output: 0/ for test: kms_psr results: parsing output: 1/ for test: kms_content_protection results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: kms_big_fb results: parsing output: 4/ for test: perf results: parsing output: 5/ for test: core_hotunplug results: parsing output: 6/ for test: gem_exec_params results: parsing output: 7/ for test: kms_ccs results: parsing output: 8/ for test: kms_chamelium_frames results: parsing output: 9/ for test: kms_plane_scaling results: parsing output: 10/ for test: kms_cursor_crc results: parsing output: 11/ for test: kms_prime results: parsing output: 12/ for test: gem_exec_params results: parsing output: 13/ for test: gem_exec_schedule results: parsing output: 14/ for test: gem_mmap_wc results: parsing output: 15/ for test: gem_spin_batch results: parsing output: 16/ for test: kms_dp_linktrain_fallback results: parsing output: 17/ for test: kms_plane_lowres results: parsing output: 18/ for test: kms_big_fb results: parsing output: 19/ for test: kms_feature_discovery results: parsing output: 20/ for test: kms_plane results: parsing output: 21/ for test: kms_busy results: parsing output: 22/ for test: kms_plane results: parsing output: 23/ for test: kms_psr results: parsing output: 24/ for test: gem_ctx_persistence results: parsing output: 25/ for test: kms_frontbuffer_tracking results: parsing output: 26/ for test: tools_test results: parsing output: 27/ for test: kms_properties results: parsing output: 28/ for test: gem_exec_whisper results: parsing output: 29/ for test: kms_flip results: parsing output: 30/ for test: kms_pm_backlight results: parsing output: 31/ for test: gem_exec_reloc results: parsing output: 32/ for test: gem_eio results: parsing output: 33/ for test: gem_exercise_blt results: parsing output: 34/ for test: gem_exec_reloc results: parsing output: 35/ for test: perf_pmu results: parsing output: 36/ for test: kms_ccs results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: kms_color_pipeline results: parsing output: 39/ for test: gem_pread results: parsing output: 40/ for test: kms_vrr results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: sysfs_preempt_timeout results: parsing output: 43/ for test: gem_render_copy results: parsing output: 44/ for test: gem_ctx_shared results: parsing output: 45/ for test: kms_flip results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: kms_ccs results: parsing output: 48/ for test: kms_ccs results: parsing output: 49/ for test: kms_psr results: parsing output: 50/ for test: kms_flip results: parsing output: 51/ for test: i915_drm_fdinfo results: parsing output: 52/ for test: kms_chamelium_hpd results: parsing output: 53/ for test: kms_mmap_write_crc results: parsing output: 54/ for test: perf results: parsing output: 55/ for test: kms_ccs results: parsing output: 56/ for test: syncobj_eventfd results: parsing output: 57/ for test: gem_exec_fence results: parsing output: 58/ for test: kms_invalid_mode results: parsing output: 59/ for test: syncobj_timeline results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: kms_pipe_crc_basic results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: kms_psr2_sf results: parsing output: 64/ for test: kms_big_fb results: parsing output: 65/ for test: gem_exec_reloc results: parsing output: 66/ for test: api_intel_bb results: parsing output: 67/ for test: kms_atomic_transition results: parsing output: 68/ for test: kms_getfb results: parsing output: 69/ for test: gem_ctx_engines results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_rotation_crc results: parsing output: 73/ for test: fbdev results: parsing output: 74/ for test: kms_cursor_legacy results: parsing output: 75/ for test: kms_flip results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: kms_flip results: parsing output: 78/ for test: kms_rotation_crc results: parsing output: 79/ for test: gem_mmap_gtt results: parsing output: 80/ for test: gem_exec_schedule results: parsing output: 81/ for test: kms_cursor_edge_walk results: parsing output: 82/ for test: gem_softpin results: parsing output: 83/ for test: kms_prop_blob results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: gem_exec_schedule results: parsing output: 86/ for test: gem_exec_params results: parsing output: 87/ for test: kms_atomic_transition results: parsing output: 88/ for test: gem_ctx_persistence results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: gem_exec_params results: parsing output: 91/ for test: kms_cursor_crc results: parsing output: 92/ for test: syncobj_wait results: parsing output: 93/ for test: kms_psr results: parsing output: 94/ for test: i915_drm_fdinfo results: parsing output: 95/ for test: kms_big_fb results: parsing output: 96/ for test: kms_selftest results: parsing output: 97/ for test: syncobj_wait results: no output, setting notrun results: parsing output: 98/ for test: gem_userptr_blits results: no output, setting notrun results: parsing output: 99/ for test: kms_flip_scaled_crc results: no output, setting notrun results: parsing output: 100/ for test: kms_flip results: no output, setting notrun results: parsing output: 101/ for test: gem_exec_balancer results: no output, setting notrun results: parsing output: 102/ for test: kms_psr results: no output, setting notrun results: parsing output: 103/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 104/ for test: kms_vblank results: no output, setting notrun results: parsing output: 105/ for test: gen9_exec_parse results: no output, setting notrun results: parsing output: 106/ for test: gem_exec_balancer results: no output, setting notrun results: parsing output: 107/ for test: gem_pxp results: no output, setting notrun results: parsing output: 108/ for test: kms_async_flips results: no output, setting notrun results: parsing output: 109/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 110/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 111/ for test: api_intel_bb results: no output, setting notrun results: parsing output: 112/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 113/ for test: kms_big_fb results: no output, setting notrun results: parsing output: 114/ for test: gem_mmap_gtt results: no output, setting notrun results: parsing output: 115/ for test: perf results: no output, setting notrun results: parsing output: 116/ for test: gem_busy results: no output, setting notrun results: parsing output: 117/ for test: i915_pm_rps results: no output, setting notrun results: parsing output: 118/ for test: kms_cursor_legacy results: no output, setting notrun results: parsing output: 119/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 120/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 121/ for test: syncobj_timeline results: no output, setting notrun results: parsing output: 122/ for test: kms_big_fb results: no output, setting notrun results: parsing output: 123/ for test: gem_mmap_offset results: no output, setting notrun results: parsing output: 124/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 125/ for test: syncobj_timeline results: no output, setting notrun results: parsing output: 126/ for test: perf results: no output, setting notrun results: parsing output: 127/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 128/ for test: kms_cursor_legacy results: no output, setting notrun results: parsing output: 129/ for test: syncobj_timeline results: no output, setting notrun results: parsing output: 130/ for test: i915_suspend results: no output, setting notrun results: parsing output: 131/ for test: prime_mmap_coherency results: no output, setting notrun Done.