Python线程性能分析方法咨询：PyGame游戏帧率卡顿排查

DevOps 小满

2026-7-17

问题描述

我是Python线程开发新手，正在使用PyGame开发一款游戏，将CPU密集型函数update_world放入独立线程运行，主线程循环执行处理用户输入与画面渲染的input_output函数。目前线程运行基本符合预期（帧率较快），但存在帧率卡顿现象：部分帧仅需数毫秒完成，部分帧耗时却超过200ms，而CPU密集线程的总耗时约1000ms。

游戏循环代码如下：

def update_world():
    # lots of CPU heavy stuff

def input_output():
    # read user input, and display the game to the screen

def run():
    exit_flag = False
    while not exit_flag:
        LOGGER.info("Start of loop")
        LOGGER.info("Create update_world thread")
        t = Thread(target=update_world)
        LOGGER.info("Start update_world thread")
        t.start()
        LOGGER.info("Loop while thread is alive")
        while t.is_alive():
            LOGGER.info("Start input/output routine")
            exit_flag = input_output()
        LOGGER.info("End of loop")

日志输出显示存在明显延迟（已标注）：

2023-07-06 09:20:30,375 - run - INFO - Start of loop
2023-07-06 09:20:30,376 - run - INFO - Create update_world thread
2023-07-06 09:20:30,376 - run - INFO - Start update_world thread
2023-07-06 09:20:30,376 - run - INFO - Loop while thread is alive
2023-07-06 09:20:30,376 - run - INFO - Start input/output routine
2023-07-06 09:20:30,382 - run - INFO - Start input/output routine
2023-07-06 09:20:30,389 - run - INFO - Start input/output routine
2023-07-06 09:20:30,699 - run - INFO - Start input/output routine <-- 此处延迟超200ms
2023-07-06 09:20:30,751 - run - INFO - Start input/output routine
2023-07-06 09:20:30,759 - run - INFO - Start input/output routine
2023-07-06 09:20:30,766 - run - INFO - Start input/output routine
2023-07-06 09:20:30,773 - run - INFO - Start input/output routine
2023-07-06 09:20:30,780 - run - INFO - Start input/output routine
2023-07-06 09:20:30,789 - run - INFO - Start input/output routine
2023-07-06 09:20:30,798 - run - INFO - Start input/output routine
2023-07-06 09:20:30,805 - run - INFO - Start input/output routine
2023-07-06 09:20:30,813 - run - INFO - Start input/output routine
2023-07-06 09:20:30,821 - run - INFO - Start input/output routine
2023-07-06 09:20:30,828 - run - INFO - Start input/output routine
2023-07-06 09:20:30,855 - run - INFO - Start input/output routine
2023-07-06 09:20:30,863 - run - INFO - Start input/output routine
2023-07-06 09:20:30,872 - run - INFO - Start input/output routine
2023-07-06 09:20:30,878 - run - INFO - Start input/output routine
2023-07-06 09:20:30,886 - run - INFO - Start input/output routine
2023-07-06 09:20:30,895 - run - INFO - Start input/output routine
2023-07-06 09:20:30,903 - run - INFO - Start input/output routine
2023-07-06 09:20:30,914 - run - INFO - Start input/output routine
2023-07-06 09:20:30,922 - run - INFO - Start input/output routine
2023-07-06 09:20:30,932 - run - INFO - Start input/output routine
2023-07-06 09:20:30,975 - run - INFO - Start input/output routine
2023-07-06 09:20:30,990 - run - INFO - Start input/output routine
2023-07-06 09:20:31,005 - run - INFO - Start input/output routine
2023-07-06 09:20:31,025 - run - INFO - Start input/output routine
2023-07-06 09:20:31,043 - run - INFO - Start input/output routine
2023-07-06 09:20:31,071 - run - INFO - Start input/output routine
2023-07-06 09:20:31,080 - run - INFO - Start input/output routine
2023-07-06 09:20:31,092 - run - INFO - Start input/output routine
2023-07-06 09:20:31,101 - run - INFO - Start input/output routine
2023-07-06 09:20:31,108 - run - INFO - Start input/output routine
2023-07-06 09:20:31,118 - run - INFO - Start input/output routine
2023-07-06 09:20:31,126 - run - INFO - Start input/output routine
2023-07-06 09:20:31,219 - run - INFO - Start input/output routine <-- 再次出现延迟
2023-07-06 09:20:31,273 - run - INFO - End of loop

为排查卡顿原因，我尝试使用cProfile分析耗时最长的调用，但常规分析无法定位哪些调用会“锁定”主线程。请问是否有可靠的方法来排查此类问题？

排查与解决方法

给input_output添加细粒度计时：在input_output内部的关键步骤（事件处理、输入读取、渲染逻辑、屏幕更新）前后记录时间，打印每个步骤的耗时，直接定位哪一步突然变长。示例代码：

import time
import pygame

def input_output():
    start = time.perf_counter()
    # 事件处理
    for event in pygame.event.get():
        if event.type == pygame.QUIT:
            return True
    event_end = time.perf_counter()
    print(f"事件处理耗时: {(event_end - start)*1000:.2f}ms")
    
    # 输入读取
    keys = pygame.key.get_pressed()
    input_end = time.perf_counter()
    print(f"输入读取耗时: {(input_end - event_end)*1000:.2f}ms")
    
    # 渲染逻辑（替换为你的实际渲染代码）
    screen = pygame.display.get_surface()
    screen.fill((0,0,0))
    render_end = time.perf_counter()
    print(f"渲染耗时: {(render_end - input_end)*1000:.2f}ms")
    
    # 屏幕更新
    pygame.display.flip()
    flip_end = time.perf_counter()
    print(f"屏幕更新耗时: {(flip_end - render_end)*1000:.2f}ms")
    
    return False

检查线程资源竞争问题：PyGame大部分API并非线程安全，若子线程update_world直接修改主线程使用的共享资源（如Sprite、Surface），会触发GIL锁争夺或线程安全问题。解决方案：
- 给共享资源加threading.Lock，确保同一时间只有一个线程操作资源；
- 让子线程只计算游戏状态，将结果存入线程安全队列（如queue.Queue），主线程定期从队列取结果更新游戏对象，避免直接操作共享资源。

采样式捕获卡顿帧的调用栈：当检测到帧耗时超过阈值时，打印主线程当前的调用栈，直接定位卡顿瞬间的执行代码。示例代码：

import traceback
import time
import threading

def run():
    exit_flag = False
    last_frame_time = time.perf_counter()
    while not exit_flag:
        t = threading.Thread(target=update_world)
        t.start()
        while t.is_alive():
            current_start = time.perf_counter()
            frame_duration = (current_start - last_frame_time)*1000
            # 当帧耗时超过50ms时触发采样
            if frame_duration > 50:
                print(f"检测到长帧: {frame_duration:.2f}ms")
                print("主线程调用栈:")
                traceback.print_stack()
            exit_flag = input_output()
            last_frame_time = current_start
        t.join()

优化GIL占用情况：CPU密集型子线程会长时间持有GIL，导致主线程无法及时获得执行权。可以：
- 在update_world的循环中加入time.sleep(0.001)，强制子线程让出GIL；
- 若update_world完全是CPU密集型任务，改用multiprocessing替代threading，绕过GIL限制（需注意进程间通信的处理）。
排查系统级干扰：卡顿可能来自系统后台进程（如杀毒软件、系统更新）抢占CPU资源。卡顿发生时查看任务管理器的CPU、内存占用情况，确认是否有其他进程占用大量资源。

内容的提问来源于stack exchange，提问作者keepitwiel