[56.505253] Initializing watchdogs [56.505300] /dev/watchdog0 [56.519217] [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] [56.523805] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [56.526374] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [56.530144] [001/132] (960s left) syncobj_wait (multi-wait-all-for-submit-submitted) [56.595795] Starting subtest: multi-wait-all-for-submit-submitted [56.702368] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.108s) [56.810415] [002/132] (960s left) i915_drm_fdinfo (most-busy-check-all) [56.860530] Starting subtest: most-busy-check-all [56.862658] Starting dynamic subtest: rcs0 [56.870976] Dynamic subtest rcs0: SKIP (0.008s) [56.877674] Starting dynamic subtest: bcs0 [56.882129] Dynamic subtest bcs0: SKIP (0.000s) [56.888741] Starting dynamic subtest: vcs0 [56.892914] Dynamic subtest vcs0: SKIP (0.000s) [56.899414] Starting dynamic subtest: vcs1 [56.903285] Dynamic subtest vcs1: SKIP (0.000s) [56.909208] Starting dynamic subtest: vecs0 [56.913134] Dynamic subtest vecs0: SKIP (0.000s) [56.919714] Starting dynamic subtest: ccs0 [56.923868] Dynamic subtest ccs0: SKIP (0.000s) [56.928575] Subtest most-busy-check-all: SKIP (0.011s) [56.960118] [003/132] (960s left) kms_flip (dpms-vs-vblank-race) [57.077444] Starting subtest: dpms-vs-vblank-race [57.079512] Starting dynamic subtest: A-eDP1 [62.066107] Dynamic subtest A-eDP1: SUCCESS (5.028s) [62.075152] Starting dynamic subtest: B-eDP1 [65.569888] Dynamic subtest B-eDP1: SUCCESS (3.521s) [65.577155] Starting dynamic subtest: C-eDP1 [70.156385] Dynamic subtest C-eDP1: SUCCESS (4.599s) [70.168108] Starting dynamic subtest: D-eDP1 [74.628928] Dynamic subtest D-eDP1: SUCCESS (4.477s) [74.631123] Subtest dpms-vs-vblank-race: SUCCESS (17.631s) [75.517426] [004/132] (941s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180) [75.618283] Starting subtest: linear-max-hw-stride-32bpp-rotate-180 [76.672075] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.056s) [76.836894] [005/132] (940s left) i915_selftest (live) [78.820184] Starting subtest: live [78.822679] Starting dynamic subtest: sanitycheck [83.360352] Dynamic subtest sanitycheck: SUCCESS (4.542s) [83.369212] Starting dynamic subtest: uncore [87.859916] Dynamic subtest uncore: SUCCESS (4.499s) [87.868855] Starting dynamic subtest: workarounds [91.254712] Dynamic subtest workarounds: SUCCESS (3.393s) [91.263673] Starting dynamic subtest: gt_engines [95.925814] Dynamic subtest gt_engines: SUCCESS (4.670s) [95.940638] Starting dynamic subtest: gt_timelines [113.760412] Dynamic subtest gt_timelines: SUCCESS (17.833s) [113.769193] Starting dynamic subtest: gt_contexts [118.323533] Dynamic subtest gt_contexts: SUCCESS (4.562s) [118.330446] Starting dynamic subtest: gt_lrc [122.895384] Dynamic subtest gt_lrc: SUCCESS (4.571s) [122.903928] Starting dynamic subtest: gt_mocs [126.002792] Dynamic subtest gt_mocs: SUCCESS (3.106s) [126.012026] Starting dynamic subtest: gt_pm [132.926283] Dynamic subtest gt_pm: SUCCESS (6.922s) [132.935567] Starting dynamic subtest: gt_heartbeat [137.461428] Dynamic subtest gt_heartbeat: SUCCESS (4.534s) [137.470515] Starting dynamic subtest: gt_tlb [146.892376] Dynamic subtest gt_tlb: SUCCESS (9.429s) [146.901418] Starting dynamic subtest: requests [158.607076] Dynamic subtest requests: SUCCESS (11.713s) [158.614316] Starting dynamic subtest: migrate [164.726904] Dynamic subtest migrate: SUCCESS (6.118s) [164.734543] Starting dynamic subtest: active [169.260422] Dynamic subtest active: SUCCESS (4.532s) [169.269061] Starting dynamic subtest: objects [172.772294] Dynamic subtest objects: SUCCESS (3.510s) [172.781433] Starting dynamic subtest: mman [177.705996] Dynamic subtest mman: SUCCESS (4.932s) [177.714912] Starting dynamic subtest: dmabuf [180.716069] Dynamic subtest dmabuf: SUCCESS (3.009s) [180.723498] Starting dynamic subtest: vma [185.247273] Dynamic subtest vma: SUCCESS (4.530s) [185.260897] Starting dynamic subtest: coherency [190.849317] Dynamic subtest coherency: SUCCESS (5.600s) [190.857811] Starting dynamic subtest: gtt [202.900502] Dynamic subtest gtt: SUCCESS (12.049s) [202.909699] Starting dynamic subtest: gem [208.881817] Dynamic subtest gem: SUCCESS (5.980s) [208.891244] Starting dynamic subtest: evict [212.979821] Dynamic subtest evict: SUCCESS (4.096s) [212.989205] Starting dynamic subtest: hugepages [222.497523] Dynamic subtest hugepages: SUCCESS (9.515s) [222.506668] Starting dynamic subtest: gem_contexts [248.626063] Dynamic subtest gem_contexts: SUCCESS (26.126s) [248.635228] Starting dynamic subtest: client [253.066867] Dynamic subtest client: SUCCESS (4.440s) [253.075467] Starting dynamic subtest: gem_migrate [257.620625] Dynamic subtest gem_migrate: SUCCESS (4.551s) [257.629037] Starting dynamic subtest: reset [260.656054] Dynamic subtest reset: SUCCESS (3.034s) [260.664634] Starting dynamic subtest: memory_region [265.204697] Dynamic subtest memory_region: SUCCESS (4.547s) [265.212723] Starting dynamic subtest: hangcheck [279.036563] Dynamic subtest hangcheck: SUCCESS (13.829s) [279.045695] Starting dynamic subtest: execlists [283.584871] Dynamic subtest execlists: SUCCESS (4.546s) [283.594553] Starting dynamic subtest: ring_submission [288.097207] Dynamic subtest ring_submission: SUCCESS (4.510s) [288.106191] Starting dynamic subtest: perf [292.649076] Dynamic subtest perf: SUCCESS (4.550s) [292.656347] Starting dynamic subtest: slpc [306.904934] Dynamic subtest slpc: SUCCESS (14.252s) [306.919033] Starting dynamic subtest: guc [311.014108] Dynamic subtest guc: SUCCESS (4.106s) [311.023068] Starting dynamic subtest: guc_multi_lrc [315.572072] Dynamic subtest guc_multi_lrc: SUCCESS (4.556s) [315.581191] Starting dynamic subtest: guc_hang [320.785321] Dynamic subtest guc_hang: SUCCESS (5.212s) [320.799305] Starting dynamic subtest: late_gt_pm [325.290222] Dynamic subtest late_gt_pm: SUCCESS (4.502s) [325.292930] Subtest live: SUCCESS (246.464s) [325.319783] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [325.322862] [006/132] (691s left) kms_vrr (negative-basic) [326.873053] Starting subtest: negative-basic [326.879624] Starting dynamic subtest: pipe-A-eDP-1 [332.348186] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.467s) [332.673211] Subtest negative-basic: SUCCESS (5.801s) [333.787393] [FACT kms_vrr (negative-basic)] new: kernel.kmod_is_loaded.i915: true [333.790797] [007/132] (683s left) i915_pm_rpm (gem-mmap-type) [339.241703] Starting subtest: gem-mmap-type [339.244242] Starting dynamic subtest: wb-smem0 [343.126500] Dynamic subtest wb-smem0: SUCCESS (3.886s) [343.134266] Starting dynamic subtest: wc-smem0 [346.280862] Dynamic subtest wc-smem0: SUCCESS (3.151s) [346.289972] Starting dynamic subtest: uc-smem0 [349.462990] Dynamic subtest uc-smem0: SUCCESS (3.182s) [349.465369] Subtest gem-mmap-type: SUCCESS (10.223s) [349.547512] [008/132] (667s left) kms_setmode (invalid-clone-single-crtc-stealing) [349.602756] Starting subtest: invalid-clone-single-crtc-stealing [349.609329] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s) [349.718759] [009/132] (667s left) kms_plane_scaling (intel-max-src-size) [349.810086] Starting subtest: intel-max-src-size [349.816529] Subtest intel-max-src-size: SKIP (0.000s) [349.928827] [010/132] (667s left) gem_ppgtt (blt-vs-render-ctxn) [349.986611] Starting subtest: blt-vs-render-ctxN [383.007922] Subtest blt-vs-render-ctxN: SUCCESS (33.018s) [383.177013] [011/132] (634s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs) [383.300822] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs [383.305168] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s) [384.452112] [012/132] (633s left) gem_ccs (block-multicopy-inplace) [384.517795] Starting subtest: block-multicopy-inplace [384.522494] Subtest block-multicopy-inplace: SKIP (0.000s) [384.653547] [013/132] (632s left) vgem_basic (busy-fence) [384.769206] Starting subtest: busy-fence [384.771413] Subtest busy-fence: SUCCESS (0.000s) [384.835228] [FACT vgem_basic (busy-fence)] new: kernel.kmod_is_loaded.vgem: true [384.838705] [014/132] (632s left) kms_busy (extended-pageflip-hang-newfb) [384.958392] Starting subtest: extended-pageflip-hang-newfb [384.960679] Starting dynamic subtest: pipe-A [411.707944] Dynamic subtest pipe-A: SUCCESS (26.746s) [411.716720] Starting dynamic subtest: pipe-D [435.755058] Dynamic subtest pipe-D: SUCCESS (24.045s) [435.757272] Subtest extended-pageflip-hang-newfb: SUCCESS (50.796s) [436.616360] [015/132] (580s left) syncobj_timeline (etime-single-wait-for-submit-submitted) [436.683302] Starting subtest: etime-single-wait-for-submit-submitted [436.792044] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.106s) [436.877153] [016/132] (580s left) sysfs_heartbeat_interval (mixed) [436.939993] Starting subtest: mixed [436.942235] Starting dynamic subtest: vecs0 [442.238523] Dynamic subtest vecs0: SUCCESS (5.297s) [442.249770] Starting dynamic subtest: ccs0 [447.445806] Dynamic subtest ccs0: SUCCESS (5.205s) [447.455622] Starting dynamic subtest: vcs0 [452.688459] Dynamic subtest vcs0: SUCCESS (5.240s) [452.699286] Starting dynamic subtest: bcs0 [457.872437] Dynamic subtest bcs0: SUCCESS (5.181s) [457.881107] Starting dynamic subtest: rcs0 [463.063917] Dynamic subtest rcs0: SUCCESS (5.190s) [463.074954] Starting dynamic subtest: vcs1 [468.285595] Dynamic subtest vcs1: SUCCESS (5.220s) [468.288442] Subtest mixed: SUCCESS (31.345s) [468.373149] [017/132] (549s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move) [468.475316] Starting subtest: psr-2p-scndscrn-spr-indfb-move [468.479420] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [468.610437] [018/132] (549s left) i915_pm_freq_api (freq-suspend) [468.673234] Starting subtest: freq-suspend [468.675578] Starting dynamic subtest: gt0 [484.582982] Dynamic subtest gt0: SUCCESS (1.308s) [484.599181] Starting dynamic subtest: gt1 [500.522917] Dynamic subtest gt1: SUCCESS (1.132s) [500.525771] Subtest freq-suspend: SUCCESS (2.443s) [501.628484] [019/132] (517s left) gem_create (create-valid-nonaligned) [501.687478] Starting subtest: create-valid-nonaligned [501.689623] Subtest create-valid-nonaligned: SUCCESS (0.000s) [501.885232] [020/132] (516s left) gem_mmap_offset (basic-uaf) [501.937786] Starting subtest: basic-uaf [501.939683] Subtest basic-uaf: SUCCESS (0.001s) [502.037509] [021/132] (516s left) gen9_exec_parse (batch-zero-length) [502.095145] Subtest batch-zero-length: SKIP (0.000s) [502.161361] [022/132] (516s left) kms_psr (psr2-sprite-blt) [502.258636] Starting subtest: psr2-sprite-blt [502.260927] Starting dynamic subtest: eDP-1 [503.989777] Dynamic subtest eDP-1: SUCCESS (1.764s) [503.992037] Subtest psr2-sprite-blt: SUCCESS (1.765s) [504.853203] [023/132] (514s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt) [504.952766] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt [504.956897] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [505.079263] [024/132] (513s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt) [505.180786] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt [505.184784] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [505.324832] [025/132] (513s left) gem_fence_thrash (bo-write-verify-none) [505.367649] Starting subtest: bo-write-verify-none [505.390549] Subtest bo-write-verify-none: SKIP (0.025s) [505.454284] [026/132] (513s left) kms_cursor_crc (cursor-rapid-movement-128x42) [505.673442] Starting subtest: cursor-rapid-movement-128x42 [505.716869] Subtest cursor-rapid-movement-128x42: SKIP (0.042s) [505.966560] [027/132] (513s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu) [506.055100] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu [512.466762] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.471s) [512.649859] [028/132] (506s left) gem_mmap_gtt (basic-short) [512.709893] Subtest basic-short: SKIP (0.000s) [512.779209] [029/132] (506s left) kms_addfb_basic (addfb25-y-tiled-legacy) [512.877430] Starting subtest: addfb25-y-tiled-legacy [512.879259] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [513.003412] [030/132] (506s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling) [513.102681] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling [513.104971] Starting dynamic subtest: pipe-A-default-mode [513.407476] Dynamic subtest pipe-A-default-mode: SKIP (0.304s) [513.412240] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.305s) [514.240426] [031/132] (505s left) kms_psr (fbc-psr2-cursor-render) [514.338299] Starting subtest: fbc-psr2-cursor-render [514.340577] Starting dynamic subtest: eDP-1 [514.344907] Dynamic subtest eDP-1: SKIP (0.000s) [514.349370] Subtest fbc-psr2-cursor-render: SKIP (0.001s) [514.434088] [032/132] (504s left) gem_render_copy (y-tiled-to-vebox-linear) [514.501370] Starting subtest: y-tiled-to-vebox-linear [514.505736] Subtest y-tiled-to-vebox-linear: SKIP (0.000s) [514.708497] [033/132] (504s left) dmabuf_sync_file (export-before-signal) [514.747938] Starting subtest: export-before-signal [514.750240] Subtest export-before-signal: SUCCESS (0.001s) [514.815430] [034/132] (504s left) syncobj_wait (invalid-signal-illegal-handle) [514.861016] Starting subtest: invalid-signal-illegal-handle [514.863033] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [515.006742] [035/132] (504s left) gem_exec_fence (basic-await) [515.193919] Starting subtest: basic-await [515.196297] Starting dynamic subtest: rcs0 [515.273139] Dynamic subtest rcs0: SUCCESS (0.079s) [515.283478] Starting dynamic subtest: bcs0 [515.345565] Dynamic subtest bcs0: SUCCESS (0.071s) [515.356608] Starting dynamic subtest: vcs0 [515.417083] Dynamic subtest vcs0: SUCCESS (0.071s) [515.429369] Starting dynamic subtest: vcs1 [515.488763] Dynamic subtest vcs1: SUCCESS (0.071s) [515.500278] Starting dynamic subtest: vecs0 [515.562045] Dynamic subtest vecs0: SUCCESS (0.071s) [515.574637] Starting dynamic subtest: ccs0 [515.632937] Dynamic subtest ccs0: SUCCESS (0.070s) [515.635510] Subtest basic-await: SUCCESS (0.442s) [517.426226] [036/132] (502s left) gem_ppgtt (shrink-vs-evict-pinned) [517.492136] Starting subtest: shrink-vs-evict-pinned [523.281363] Subtest shrink-vs-evict-pinned: SUCCESS (5.802s) [523.370569] [037/132] (496s left) kms_big_fb (yf-tiled-addfb) [523.475450] Starting subtest: yf-tiled-addfb [523.479296] Subtest yf-tiled-addfb: SKIP (0.000s) [523.583187] [038/132] (495s left) gem_userptr_blits (set-cache-level) [523.648227] Starting subtest: set-cache-level [523.652480] Subtest set-cache-level: SKIP (0.000s) [523.795479] [039/132] (495s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc) [523.891847] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc [527.904530] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (4.021s) [529.111420] [040/132] (490s left) kms_universal_plane (cursor-fb-leak) [529.214518] Starting subtest: cursor-fb-leak [529.216917] Starting dynamic subtest: pipe-A-eDP-1 [529.516917] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.305s) [529.530465] Starting dynamic subtest: pipe-B-eDP-1 [530.869563] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.352s) [530.882572] Starting dynamic subtest: pipe-C-eDP-1 [532.195105] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.322s) [532.205622] Starting dynamic subtest: pipe-D-eDP-1 [533.515856] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.317s) [533.518264] Subtest cursor-fb-leak: SUCCESS (4.304s) [534.725128] [041/132] (484s left) gem_exercise_blt (fast-copy-emit) [534.781031] Starting subtest: fast-copy-emit [534.783274] Starting dynamic subtest: linear-smem-smem-emit [534.808234] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.027s) [534.819269] Starting dynamic subtest: xmajor-smem-smem-emit [534.825064] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.016s) [534.834329] Starting dynamic subtest: tile4-smem-smem-emit [534.842011] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.016s) [534.851360] Starting dynamic subtest: tile64-smem-smem-emit [534.859477] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.017s) [534.861782] Subtest fast-copy-emit: SUCCESS (0.079s) [535.018080] [042/132] (484s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [535.112643] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu [535.116825] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [535.260455] [043/132] (484s left) gem_exec_reloc (basic-active) [535.327282] Subtest basic-active: SKIP (0.000s) [535.425608] [044/132] (484s left) kms_big_fb (y-tiled-16bpp-rotate-270) [535.534288] Starting subtest: y-tiled-16bpp-rotate-270 [535.538753] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s) [535.665841] [045/132] (484s left) gem_mmap_gtt (cpuset-big-copy-odd) [535.718378] Subtest cpuset-big-copy-odd: SKIP (0.000s) [535.780308] [046/132] (484s left) gem_userptr_blits (stress-mm) [535.845059] Starting subtest: stress-mm [541.217811] Subtest stress-mm: SUCCESS (5.369s) [541.363498] [047/132] (478s left) kms_plane_multiple (2x-tiling-4) [541.457120] Starting subtest: 2x-tiling-4 [541.461464] Subtest 2x-tiling-4: SKIP (0.000s) [541.553738] [048/132] (478s left) gem_softpin (evict-prime) [541.616984] Starting subtest: evict-prime [541.619113] Starting dynamic subtest: rcs0 [542.799175] Dynamic subtest rcs0: SUCCESS (1.184s) [542.812511] Starting dynamic subtest: bcs0 [543.964980] Dynamic subtest bcs0: SUCCESS (1.163s) [543.977371] Starting dynamic subtest: vcs0 [545.353518] Dynamic subtest vcs0: SUCCESS (1.385s) [545.366743] Starting dynamic subtest: vcs1 [547.336018] Dynamic subtest vcs1: SUCCESS (1.979s) [547.349872] Starting dynamic subtest: vecs0 [549.297459] Dynamic subtest vecs0: SUCCESS (1.960s) [549.307804] Starting dynamic subtest: ccs0 [550.450218] Dynamic subtest ccs0: SUCCESS (1.151s) [550.462731] Starting dynamic subtest: all [552.323268] Dynamic subtest all: SUCCESS (1.869s) [552.326191] Subtest evict-prime: SUCCESS (10.707s) [552.427996] [049/132] (467s left) kms_cursor_crc (cursor-onscreen-32x32) [552.581723] Starting subtest: cursor-onscreen-32x32 [552.626283] Subtest cursor-onscreen-32x32: SKIP (0.040s) [552.893960] [050/132] (467s left) gem_ctx_exec (basic-close-race) [552.943959] Starting subtest: basic-close-race [558.502747] Subtest basic-close-race: SUCCESS (5.557s) [558.676587] [051/132] (461s left) kms_big_fb (linear-8bpp-rotate-90) [558.773509] Starting subtest: linear-8bpp-rotate-90 [558.795533] Subtest linear-8bpp-rotate-90: SKIP (0.021s) [558.946259] [052/132] (461s left) api_intel_bb (object-reloc-keep-cache) [559.005337] Starting subtest: object-reloc-keep-cache [559.012321] Subtest object-reloc-keep-cache: SKIP (0.005s) [559.169052] [053/132] (461s left) kms_pipe_stress (stress-xrgb8888-4tiled) [559.267863] Starting subtest: stress-xrgb8888-4tiled [565.201912] Subtest stress-xrgb8888-4tiled: SUCCESS (5.936s) [565.258547] [054/132] (454s left) gem_workarounds (suspend-resume-context) [565.335957] Starting subtest: suspend-resume-context [581.595699] Subtest suspend-resume-context: SUCCESS (1.187s) [581.736087] [055/132] (438s left) gem_exec_gttfill (basic) [581.803006] Starting subtest: basic [584.228069] Subtest basic: SUCCESS (2.469s) [584.428561] [056/132] (435s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render) [584.589572] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render [584.594729] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [584.715197] [057/132] (435s left) perf_pmu (all-busy-idle-check-all) [584.756876] Starting subtest: all-busy-idle-check-all [586.382622] Subtest all-busy-idle-check-all: SUCCESS (1.648s) [586.520826] [058/132] (433s left) kms_chamelium_color (ctm-max) [586.623583] Subtest ctm-max: SKIP (0.000s) [586.673888] [059/132] (433s left) kms_flip (blocking-absolute-wf_vblank) [586.774280] Starting subtest: blocking-absolute-wf_vblank [586.776828] Starting dynamic subtest: A-eDP1 [595.456736] Dynamic subtest A-eDP1: SUCCESS (8.752s) [595.473625] Starting dynamic subtest: B-eDP1 [604.155373] Dynamic subtest B-eDP1: SUCCESS (8.720s) [604.167266] Starting dynamic subtest: C-eDP1 [612.860992] Dynamic subtest C-eDP1: SUCCESS (8.715s) [612.873675] Starting dynamic subtest: D-eDP1 [621.594807] Dynamic subtest D-eDP1: SUCCESS (8.730s) [621.601446] Subtest blocking-absolute-wf_vblank: SUCCESS (34.930s) [622.827311] [060/132] (397s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf) [627.899388] Starting subtest: pr-overlay-plane-update-continuous-sf [627.904833] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.002s) [628.765700] [061/132] (391s left) gem_eio (create-ext) [628.998662] Starting subtest: create-ext [629.316872] Subtest create-ext: SUCCESS (0.317s) [629.470449] [062/132] (391s left) gem_pxp (reject-modify-context-protection-off-1) [629.593412] Starting subtest: reject-modify-context-protection-off-1 [629.596508] Subtest reject-modify-context-protection-off-1: SUCCESS (0.001s) [629.710243] [063/132] (390s left) syncobj_basic (bad-destroy-pad) [629.758500] Starting subtest: bad-destroy-pad [629.760854] Subtest bad-destroy-pad: SUCCESS (0.000s) [629.873301] [064/132] (390s left) perf_pmu (rc6-suspend) [629.909718] Starting subtest: rc6-suspend [652.745822] Subtest rc6-suspend: SUCCESS (7.598s) [653.626992] [065/132] (367s left) kms_hdr (brightness-with-hdr) [653.740884] Starting subtest: brightness-with-hdr [653.747190] Subtest brightness-with-hdr: SKIP (0.000s) [653.825753] [066/132] (366s left) kms_lease (atomic-implicit-crtc) [653.909354] Starting subtest: atomic-implicit-crtc [653.911265] Starting dynamic subtest: pipe-A-eDP-1 [653.921151] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [653.934298] Starting dynamic subtest: pipe-B-eDP-1 [653.943303] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.008s) [653.952928] Starting dynamic subtest: pipe-C-eDP-1 [653.961759] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.008s) [653.971122] Starting dynamic subtest: pipe-D-eDP-1 [653.979906] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.008s) [653.981742] Subtest atomic-implicit-crtc: SUCCESS (0.031s) [654.080285] [067/132] (366s left) syncobj_eventfd (invalid-bad-flags) [654.142222] Starting subtest: invalid-bad-flags [654.144323] Subtest invalid-bad-flags: SUCCESS (0.000s) [654.260038] [068/132] (366s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc) [654.354381] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc [654.357710] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [654.480355] [069/132] (366s left) gem_exec_whisper (basic-fds-all) [654.544065] Starting subtest: basic-fds-all [664.770214] Subtest basic-fds-all: SUCCESS (10.289s) [664.981153] [070/132] (355s left) api_intel_allocator (reopen) [665.029917] Starting subtest: reopen [665.035515] Subtest reopen: SUCCESS (0.007s) [665.177887] [071/132] (355s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt) [665.277187] Starting subtest: psr-1p-primscrn-indfb-msflip-blt [672.526436] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.266s) [672.686512] [072/132] (348s left) syncobj_timeline (reset-multiple-signaled) [672.747926] Starting subtest: reset-multiple-signaled [672.749903] Subtest reset-multiple-signaled: SUCCESS (0.001s) [672.862393] [073/132] (348s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy) [672.969522] Starting subtest: 2x-long-flip-vs-cursor-legacy [672.974093] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s) [673.141511] [074/132] (347s left) perf_pmu (busy-check-all) [673.180346] Starting subtest: busy-check-all [673.182225] Starting dynamic subtest: rcs0 [673.764363] Dynamic subtest rcs0: SUCCESS (0.586s) [673.782236] Starting dynamic subtest: bcs0 [674.314477] Dynamic subtest bcs0: SUCCESS (0.549s) [674.329914] Starting dynamic subtest: vcs0 [675.700919] Dynamic subtest vcs0: SUCCESS (1.355s) [675.716002] Starting dynamic subtest: vcs1 [677.658312] Dynamic subtest vcs1: SUCCESS (1.985s) [677.671318] Starting dynamic subtest: vecs0 [679.703339] Dynamic subtest vecs0: SUCCESS (2.046s) [679.716491] Starting dynamic subtest: ccs0 [680.257011] Dynamic subtest ccs0: SUCCESS (0.552s) [680.259398] Subtest busy-check-all: SUCCESS (7.087s) [680.401070] [075/132] (340s left) kms_psr (psr2-cursor-mmap-gtt) [680.520300] Starting subtest: psr2-cursor-mmap-gtt [680.522711] Starting dynamic subtest: eDP-1 [682.252885] Dynamic subtest eDP-1: SUCCESS (1.732s) [682.255123] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.734s) [683.063792] [076/132] (338s left) kms_vblank (query-busy-hang) [683.154066] Starting subtest: query-busy-hang [683.155885] Starting dynamic subtest: pipe-A-eDP-1 [709.466279] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.307s) [709.484301] Starting dynamic subtest: pipe-D-eDP-1 [734.432689] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.971s) [734.434891] Subtest query-busy-hang: SUCCESS (51.283s) [735.338444] [077/132] (285s left) gem_exec_reloc (basic-gtt-wc-active) [735.415131] Subtest basic-gtt-wc-active: SKIP (0.000s) [735.510405] [078/132] (285s left) kms_hdr (bpc-switch-suspend) [735.606709] Starting subtest: bpc-switch-suspend [736.695097] Starting dynamic subtest: pipe-A-eDP-1 [756.734811] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.620s) [756.737120] Subtest bpc-switch-suspend: SUCCESS (5.711s) [756.873205] [079/132] (264s left) gem_exec_schedule (u-semaphore-resolve) [756.955772] Starting subtest: u-semaphore-resolve [756.992543] Subtest u-semaphore-resolve: SUCCESS (0.042s) [757.371879] [080/132] (263s left) gem_eio (in-flight-contexts-immediate) [757.570510] Starting subtest: in-flight-contexts-immediate [764.702628] Subtest in-flight-contexts-immediate: SUCCESS (7.125s) [764.897349] [081/132] (256s left) prime_mmap (test_dup) [764.959433] Starting subtest: test_dup [764.961298] Starting dynamic subtest: test_dup-smem [764.990381] Dynamic subtest test_dup-smem: SUCCESS (0.032s) [764.992823] Subtest test_dup: SUCCESS (0.033s) [765.075298] [082/132] (256s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled) [765.139445] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled [765.248494] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.107s) [765.354779] [083/132] (256s left) kms_pm_rpm (dpms-mode-unset-lpsp) [767.286776] Starting subtest: dpms-mode-unset-lpsp [771.360603] Subtest dpms-mode-unset-lpsp: SUCCESS (4.077s) [771.752241] [084/132] (249s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled) [771.819085] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled [771.821340] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.001s) [771.963997] [085/132] (249s left) gem_mmap_gtt (basic-write-read-distinct) [772.031296] Subtest basic-write-read-distinct: SKIP (0.000s) [772.098218] [086/132] (249s left) gem_flink_basic (double-flink) [772.164838] Starting subtest: double-flink [772.167154] Subtest double-flink: SUCCESS (0.000s) [772.290663] [087/132] (249s left) kms_flip (basic-flip-vs-modeset) [772.386292] Starting subtest: basic-flip-vs-modeset [772.388602] Starting dynamic subtest: A-eDP1 [774.917496] Dynamic subtest A-eDP1: SUCCESS (2.530s) [774.929143] Starting dynamic subtest: B-eDP1 [777.091868] Dynamic subtest B-eDP1: SUCCESS (2.175s) [777.102925] Starting dynamic subtest: C-eDP1 [779.249870] Dynamic subtest C-eDP1: SUCCESS (2.158s) [779.262274] Starting dynamic subtest: D-eDP1 [781.430186] Dynamic subtest D-eDP1: SUCCESS (2.177s) [781.432384] Subtest basic-flip-vs-modeset: SUCCESS (9.047s) [782.244718] [088/132] (239s left) kms_color (ctm-red-to-blue) [782.342932] Starting subtest: ctm-red-to-blue [782.345201] Starting dynamic subtest: pipe-A-eDP-1 [783.050019] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.708s) [783.061576] Starting dynamic subtest: pipe-B-eDP-1 [784.431010] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.379s) [784.442589] Starting dynamic subtest: pipe-C-eDP-1 [785.808500] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.378s) [785.819535] Starting dynamic subtest: pipe-D-eDP-1 [787.133653] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.324s) [787.136060] Subtest ctm-red-to-blue: SUCCESS (4.793s) [787.970531] [089/132] (233s left) kms_selftest (drm_framebuffer) [788.018688] Starting subtest: drm_framebuffer [788.085179] Starting dynamic subtest: drm_test_framebuffer_check_src_coords [788.237615] Dynamic subtest drm_test_framebuffer_check_src_coords: SUCCESS (0.152s) [788.255375] Starting dynamic subtest: drm_test_framebuffer_cleanup [788.376964] Dynamic subtest drm_test_framebuffer_cleanup: SUCCESS (0.138s) [788.387568] Starting dynamic subtest: drm_test_framebuffer_create [788.603712] Dynamic subtest drm_test_framebuffer_create: SUCCESS (0.225s) [788.615250] Starting dynamic subtest: drm_test_framebuffer_free [788.859942] Dynamic subtest drm_test_framebuffer_free: FAIL (0.208s) [788.864527] Subtest drm_framebuffer: FAIL (0.793s) [788.990781] Aborting: Kernel badly tainted (0x40244, 0x200) (check dmesg for details): TAINT_WARN: WARN_ON has happened. [789.008118] [FACT kms_selftest (drm_framebuffer)] new: kernel.is_tainted.taint_warn: true [789.008978] Closing watchdogs results: parsing output: 0/ for test: syncobj_wait results: parsing output: 1/ for test: i915_drm_fdinfo results: parsing output: 2/ for test: kms_flip results: parsing output: 3/ for test: kms_big_fb results: parsing output: 4/ for test: i915_selftest results: parsing output: 5/ for test: kms_vrr results: parsing output: 6/ for test: i915_pm_rpm results: parsing output: 7/ for test: kms_setmode results: parsing output: 8/ for test: kms_plane_scaling results: parsing output: 9/ for test: gem_ppgtt results: parsing output: 10/ for test: kms_ccs results: parsing output: 11/ for test: gem_ccs results: parsing output: 12/ for test: vgem_basic results: parsing output: 13/ for test: kms_busy results: parsing output: 14/ for test: syncobj_timeline results: parsing output: 15/ for test: sysfs_heartbeat_interval results: parsing output: 16/ for test: kms_frontbuffer_tracking results: parsing output: 17/ for test: i915_pm_freq_api results: parsing output: 18/ for test: gem_create results: parsing output: 19/ for test: gem_mmap_offset results: parsing output: 20/ for test: gen9_exec_parse results: parsing output: 21/ for test: kms_psr results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: kms_frontbuffer_tracking results: parsing output: 24/ for test: gem_fence_thrash results: parsing output: 25/ for test: kms_cursor_crc results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: gem_mmap_gtt results: parsing output: 28/ for test: kms_addfb_basic results: parsing output: 29/ for test: kms_flip_scaled_crc results: parsing output: 30/ for test: kms_psr results: parsing output: 31/ for test: gem_render_copy results: parsing output: 32/ for test: dmabuf_sync_file results: parsing output: 33/ for test: syncobj_wait results: parsing output: 34/ for test: gem_exec_fence results: parsing output: 35/ for test: gem_ppgtt results: parsing output: 36/ for test: kms_big_fb results: parsing output: 37/ for test: gem_userptr_blits results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: kms_universal_plane results: parsing output: 40/ for test: gem_exercise_blt results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: gem_exec_reloc results: parsing output: 43/ for test: kms_big_fb results: parsing output: 44/ for test: gem_mmap_gtt results: parsing output: 45/ for test: gem_userptr_blits results: parsing output: 46/ for test: kms_plane_multiple results: parsing output: 47/ for test: gem_softpin results: parsing output: 48/ for test: kms_cursor_crc results: parsing output: 49/ for test: gem_ctx_exec results: parsing output: 50/ for test: kms_big_fb results: parsing output: 51/ for test: api_intel_bb results: parsing output: 52/ for test: kms_pipe_stress results: parsing output: 53/ for test: gem_workarounds results: parsing output: 54/ for test: gem_exec_gttfill results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: perf_pmu results: parsing output: 57/ for test: kms_chamelium_color results: parsing output: 58/ for test: kms_flip results: parsing output: 59/ for test: kms_psr2_sf results: parsing output: 60/ for test: gem_eio results: parsing output: 61/ for test: gem_pxp results: parsing output: 62/ for test: syncobj_basic results: parsing output: 63/ for test: perf_pmu results: parsing output: 64/ for test: kms_hdr results: parsing output: 65/ for test: kms_lease results: parsing output: 66/ for test: syncobj_eventfd results: parsing output: 67/ for test: kms_frontbuffer_tracking results: parsing output: 68/ for test: gem_exec_whisper results: parsing output: 69/ for test: api_intel_allocator results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: syncobj_timeline results: parsing output: 72/ for test: kms_cursor_legacy results: parsing output: 73/ for test: perf_pmu results: parsing output: 74/ for test: kms_psr results: parsing output: 75/ for test: kms_vblank results: parsing output: 76/ for test: gem_exec_reloc results: parsing output: 77/ for test: kms_hdr results: parsing output: 78/ for test: gem_exec_schedule results: parsing output: 79/ for test: gem_eio results: parsing output: 80/ for test: prime_mmap results: parsing output: 81/ for test: syncobj_wait results: parsing output: 82/ for test: kms_pm_rpm results: parsing output: 83/ for test: syncobj_timeline results: parsing output: 84/ for test: gem_mmap_gtt results: parsing output: 85/ for test: gem_flink_basic results: parsing output: 86/ for test: kms_flip results: parsing output: 87/ for test: kms_color results: parsing output: 88/ for test: kms_selftest results: parsing output: 89/ for test: gem_exec_reloc results: no output, setting notrun results: parsing output: 90/ for test: kms_pm_backlight results: no output, setting notrun results: parsing output: 91/ for test: kms_ccs results: no output, setting notrun results: parsing output: 92/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 93/ for test: gem_mmap_gtt results: no output, setting notrun results: parsing output: 94/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 95/ for test: kms_flip results: no output, setting notrun results: parsing output: 96/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 97/ for test: gem_exec_fence results: no output, setting notrun results: parsing output: 98/ for test: kms_chamelium_hpd results: no output, setting notrun results: parsing output: 99/ for test: gem_ctx_isolation results: no output, setting notrun results: parsing output: 100/ for test: gem_eio results: no output, setting notrun results: parsing output: 101/ for test: kms_cursor_crc results: no output, setting notrun results: parsing output: 102/ for test: kms_psr2_su results: no output, setting notrun results: parsing output: 103/ for test: gem_exec_reloc results: no output, setting notrun results: parsing output: 104/ for test: kms_chamelium_edid results: no output, setting notrun results: parsing output: 105/ for test: kms_psr2_sf results: no output, setting notrun results: parsing output: 106/ for test: kms_ccs results: no output, setting notrun results: parsing output: 107/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 108/ for test: gem_exec_params results: no output, setting notrun results: parsing output: 109/ for test: kms_atomic_transition results: no output, setting notrun results: parsing output: 110/ for test: gem_mmap_wc results: no output, setting notrun results: parsing output: 111/ for test: kms_ccs results: no output, setting notrun results: parsing output: 112/ for test: prime_vgem 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: kms_atomic results: no output, setting notrun results: parsing output: 115/ for test: kms_flip_scaled_crc results: no output, setting notrun results: parsing output: 116/ for test: gem_exec_balancer results: no output, setting notrun results: parsing output: 117/ for test: gem_ctx_param results: no output, setting notrun results: parsing output: 118/ for test: kms_rotation_crc results: no output, setting notrun results: parsing output: 119/ for test: kms_draw_crc results: no output, setting notrun results: parsing output: 120/ for test: kms_dp_linktrain_fallback results: no output, setting notrun results: parsing output: 121/ for test: gem_tiled_partial_pwrite_pread results: no output, setting notrun results: parsing output: 122/ for test: syncobj_timeline results: no output, setting notrun results: parsing output: 123/ for test: kms_psr 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: gem_exec_schedule results: no output, setting notrun results: parsing output: 126/ for test: kms_cursor_legacy results: no output, setting notrun results: parsing output: 127/ for test: kms_flip results: no output, setting notrun results: parsing output: 128/ for test: kms_prime results: no output, setting notrun results: parsing output: 129/ for test: kms_big_fb results: no output, setting notrun results: parsing output: 130/ for test: gem_ctx_persistence results: no output, setting notrun results: parsing output: 131/ for test: kms_frontbuffer_tracking results: no output, setting notrun Done.