Docker运行含Python脚本容器时日志重复乱序问题排查

1. Dockerfile命令配置冲突 #

先查你的Dockerfile，要是里面已经用ENTRYPOINT或者CMD指定了默认执行tsdm，那你直接跑docker run tsdm/test tsdm就等于触发了两次执行。举个实际场景：

• 如果Dockerfile写了ENTRYPOINT ["tsdm"]，你额外加的tsdm会被当成命令参数，变成tsdm tsdm执行；要是ENTRYPOINT用了bash -c "tsdm"这种写法，原本的ENTRYPOINT已经在运行tsdm，你手动输入的tsdm又会启动一次，直接导致两次运行。

排查：打开Dockerfile，确认是否已经指定tsdm作为默认启动命令。
解决：要是Dockerfile已经设了默认启动tsdm，直接用docker run tsdm/test启动就行；要是需要灵活切换命令，就把Dockerfile里的ENTRYPOINT/CMD改成空或者bash，再按需执行。

2. Python日志重复初始化 #

Docker直接跑是非交互式终端，和-it进入的交互式终端环境不一样，你的Python应用可能因为这个差异，导致日志handler被重复添加：

• 日志配置代码没检查handler是否存在，每次启动（或被导入）都重新加一遍handler，脚本被意外调用两次的话，日志就会重复输出。
• 非交互式环境下stdout/stderr的缓冲方式不同，也会让日志顺序乱掉。

排查：查看日志初始化代码，有没有多次调用logging.basicConfig()，或者重复添加handler的情况。
解决：初始化日志时先判断有没有handler，比如这么写：

import logging

def setup_logging():
    logger = logging.getLogger()
    if not logger.handlers:
        logging.basicConfig(level=logging.INFO, format='%(asctime)s - %(name)s - %(levelname)s - %(message)s')

3. setup.py的console script配置有问题 #

检查setup.py里的entry_points配置，要是console script的入口逻辑有问题，也会出现这种情况：

• 比如entry_point设成'console_scripts': ['tsdm = tsdm.main:main']，但main函数里不小心写了递归调用自身的代码，或者用了os.system("tsdm")这种逻辑，在Docker环境下就会触发循环调用。
• 还有可能是生成的console script脚本（比如容器里的/usr/local/bin/tsdm）在非交互式环境下的执行逻辑出问题，导致脚本被解析两次。

排查：查看setup.py的entry_points配置，再检查main函数代码，有没有重复启动自身的逻辑；也可以进入容器看/usr/local/bin/tsdm的内容，确认shebang和执行步骤正常。
解决：确保main函数里没有递归或者执行自身命令的代码；如果生成的脚本有问题，重新用setup.py安装一次。

4. Docker终端环境差异导致的逻辑分支问题 #

Docker直接run默认是非交互式、非TTY模式，-it是交互式TTY模式。你的应用要是有代码根据终端类型（比如sys.stdin.isatty()）触发不同逻辑，就可能在非TTY模式下误启动重复进程。

排查：在代码里加一行打印sys.stdin.isatty()的代码，对比两种启动方式的输出；或者直接用docker run -t tsdm/test tsdm启动，看日志还会不会重复。
解决：调整代码里依赖终端环境的逻辑，别因为是不是TTY就触发重复执行的分支。

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