Pythonでprint()デバッグは卒業！loggingの基本設定と使い方

# logging_basic_minimal.py
import logging

# 最小構成: INFO以上を表示
logging.basicConfig(level=logging.INFO)

logging.debug("これは表示されません(DEBUGは非表示)")  # レベルがINFOなので出ない
logging.info("アプリ起動")  # これは出る
logging.warning("注意: 設定値がデフォルトです")

# logging_levels_demo.py
import logging

logging.basicConfig(level=logging.WARNING)  # WARNING以上だけ表示

logging.debug("DEBUG: 詳細")
logging.info("INFO: 情報")
logging.warning("WARNING: 警告")
logging.error("ERROR: エラー")
logging.critical("CRITICAL: 致命的")

# mylib.py (ライブラリ側: 設定はしない)
import logging
logger = logging.getLogger(__name__)  # __name__でモジュール名付きロガーを取得

def run():
    logger.info("mylib.run() を開始")
    logger.debug("内部状態 x=42")

# main.py (エントリポイント)
import logging
from mylib import run

def main():
    logging.basicConfig(
        level=logging.INFO,  # 入口で1回だけ設定
        format="%(asctime)s [%(levelname)s] %(name)s: %(message)s",
        datefmt="%H:%M:%S",
    )
    run()

if __name__ == "__main__":
    main()

# logger_getting.py
import logging

# 入口で一度だけ設定
logging.basicConfig(level=logging.INFO)

# 名前付きロガーを取得
app_logger = logging.getLogger("myapp")
db_logger = logging.getLogger("myapp.db")

app_logger.info("アプリの情報ログ")
db_logger.warning("DB接続が遅延しています")

# console_default.py
import logging

logging.basicConfig(level=logging.INFO)  # デフォルトはStreamHandler(stderr)
logging.info("コンソールに出力されます")

# file_logging.py
import logging

logging.basicConfig(
    level=logging.INFO,
    filename="app.log",          # ログファイル名
    filemode="w",                # "a"なら追記、"w"なら毎回上書き
    encoding="utf-8",            # 日本語を安全に保存
    format="%(asctime)s [%(levelname)s] %(name)s: %(message)s",
    datefmt="%Y-%m-%d %H:%M:%S",
)

logging.info("ファイルに保存されました")
logging.warning("警告もファイルに残ります")

2025-01-01 12:00:00 [INFO] root: ファイルに保存されました
2025-01-01 12:00:00 [WARNING] root: 警告もファイルに残ります

# format_basic.py
import logging

logging.basicConfig(
    level=logging.INFO,
    format="%(asctime)s [%(levelname)s] %(name)s - %(message)s",
    datefmt="%H:%M:%S",
)

logging.info("書式付きのログ")

# multi_output.py
import logging

console = logging.StreamHandler()  # コンソール
file = logging.FileHandler("app.log", encoding="utf-8")  # ファイル

logging.basicConfig(
    level=logging.INFO,
    handlers=[console, file],  # 複数ハンドラ
    format="%(asctime)s [%(levelname)s] %(name)s: %(message)s",
    datefmt="%H:%M:%S",
)

logging.info("コンソールとファイルに同時出力")

12:00:00 [INFO] root: コンソールとファイルに同時出力

12:00:00 [INFO] root: コンソールとファイルに同時出力

# before_print.py
def process(items):
    print("処理を開始します")  # 情報
    for i, x in enumerate(items):
        print(f"{i}番目: x={x}")  # 詳細
    print("処理が完了しました")  # 情報

# after_logging_basic.py
import logging
logger = logging.getLogger(__name__)

def process(items):
    logger.info("処理を開始します")  # 情報レベル
    for i, x in enumerate(items):
        logger.debug("index=%d, x=%s", i, x)  # 文字列整形は引数で渡すのが基本
    logger.info("処理が完了しました")

# run_process.py
import logging
from after_logging_basic import process

logging.basicConfig(level=logging.INFO)
process([10, 20])

# DEBUGは見えないが、INFOは出る

# log_exception.py
import logging
logger = logging.getLogger(__name__)

def divide(a, b):
    try:
        return a / b
    except ZeroDivisionError:
        logger.exception("0除算が発生しました")  # 例外情報付きでERRORレベル出力
        return None

if __name__ == "__main__":
    logging.basicConfig(level=logging.INFO)
    divide(1, 0)

# toggle_level.py
import argparse
import logging

logger = logging.getLogger(__name__)

def main():
    parser = argparse.ArgumentParser()
    parser.add_argument("--debug", action="store_true", help="DEBUGログを有効化")
    args = parser.parse_args()

    level = logging.DEBUG if args.debug else logging.INFO
    logging.basicConfig(level=level, format="%(levelname)s:%(message)s")

    logger.debug("詳細: 初期化パラメータ x=42")
    logger.info("アプリ開始")

if __name__ == "__main__":
    main()

# check_handlers.py
import logging
root = logging.getLogger()  # ルートロガー
print("hasHandlers:", root.hasHandlers())
print("handlers:", root.handlers)

# reconfigure.py
import logging

# 既存ハンドラを強制的に置き換え(Python 3.8+)
logging.basicConfig(
    level=logging.DEBUG,
    format="%(levelname)s:%(message)s",
    force=True,  # これがポイント
)

logging.debug("再設定後はDEBUGも表示されます")