Commit: 9ba58a8759820e096b31360627f67ca7782ea859 - LogConfigTester (hg)

ログ出力先に全レベルのログを出力して、設定ファイルが期待通りかを確認するツール

Commit MetaInfo

• Revision: 9ba58a8759820e096b31360627f67ca7782ea859 (tree)
• Time: 2022-05-28 20:28:58
• Author: kemono7h
• Commiter: kemono7h

Log Message

いろいろ問題があって現在改修中。構造を変える前に念のため現状を保存する。

Change Summary

• modified: .classpath
• modified: build.gradle
• modified: build/libs/LogConfigTester-1.0.0.jar
• modified: build/resources/main/logback.xml
• modified: src/main/java/jp/nanah/logconfchk/LogConfigTester.java
• modified: src/main/java/jp/nanah/logconfchk/output/BaseLogger.java
• modified: src/main/java/jp/nanah/logconfchk/output/Log4jLogger.java
• modified: src/main/java/jp/nanah/logconfchk/output/LogbackLogger.java
• modified: src/main/resources/logback.xml

Incremental Difference

diff -r 2df57ad74576 -r 9ba58a875982 .classpath
--- a/.classpath	Tue Jan 25 08:40:42 2022 +0900
+++ b/.classpath	Sat May 28 20:28:58 2022 +0900
@@ -14,9 +14,9 @@
 	</classpathentry>
 	<classpathentry kind="src" output="bin/test" path="src/test/java">
 		<attributes>
+			<attribute name="test" value="true"/>
 			<attribute name="gradle_scope" value="test"/>
 			<attribute name="gradle_used_by_scope" value="test"/>
-			<attribute name="test" value="true"/>
 		</attributes>
 	</classpathentry>
 	<classpathentry kind="con" path="org.eclipse.jdt.launching.JRE_CONTAINER/org.eclipse.jdt.internal.debug.ui.launcher.StandardVMType/JavaSE-1.8/"/>

diff -r 2df57ad74576 -r 9ba58a875982 build.gradle
--- a/build.gradle	Tue Jan 25 08:40:42 2022 +0900
+++ b/build.gradle	Sat May 28 20:28:58 2022 +0900
@@ -23,10 +23,11 @@
 }
 
 dependencies {
-	implementation 'org.slf4j:slf4j-api:1.7.33'
-	implementation 'ch.qos.logback:logback-core:1.2.10'
-	implementation 'ch.qos.logback:logback-classic:1.2.10'
+	implementation 'org.slf4j:slf4j-api:1.7.36'
+	implementation 'ch.qos.logback:logback-core:1.2.11'
+	implementation 'ch.qos.logback:logback-classic:1.2.11'
 	implementation 'log4j:log4j:1.2.17'
+	testImplementation 'org.junit.jupiter:junit-jupiter-api:5.6.3'
 }
 
 test {

diff -r 2df57ad74576 -r 9ba58a875982 build/libs/LogConfigTester-1.0.0.jar
Binary file build/libs/LogConfigTester-1.0.0.jar has changed

diff -r 2df57ad74576 -r 9ba58a875982 build/resources/main/logback.xml
--- a/build/resources/main/logback.xml	Tue Jan 25 08:40:42 2022 +0900
+++ b/build/resources/main/logback.xml	Sat May 28 20:28:58 2022 +0900
@@ -2,8 +2,9 @@
 <!DOCTYPE logback>
 <configuration>
 	<appender name="STDOUT" class="ch.qos.logback.core.ConsoleAppender">
+		<target>System.out</target>
 		<encoder>
-			<pattern>%d{yyyy/MM/dd HH:mm:ss.SSS} %-5level %logger{36} - %m%n</pattern>
+			<pattern>★%d{yyyy/MM/dd HH:mm:ss.SSS} %-5level %logger{36} - %m%n</pattern>
 		</encoder>
 	</appender>
 

diff -r 2df57ad74576 -r 9ba58a875982 src/main/java/jp/nanah/logconfchk/LogConfigTester.java
--- a/src/main/java/jp/nanah/logconfchk/LogConfigTester.java	Tue Jan 25 08:40:42 2022 +0900
+++ b/src/main/java/jp/nanah/logconfchk/LogConfigTester.java	Sat May 28 20:28:58 2022 +0900
@@ -18,16 +18,16 @@
 public class LogConfigTester {
 
 	private static final Logger logger = LoggerFactory.getLogger(LogConfigTester.class);
-	
+
 	/**
 	 * 指定のファイルまたはフォルダに含まれるloggerの設定ファイルを１つずつ読み込んで
 	 * その出力先に全レベルのログを出力する。
-	 * 
+	 *
 	 * @param path ロガの設定ファイルまたはフォルダ。フォルダはその階層のみ。
 	 * @param count ログ出力する件数。一定サイズでローテーションする場合に利用。
 	 * @param interval ログ１件を出した後に待つ秒数。指定時間になったらローテーションする場合、件数と組み合わせて使用。
 	 */
-	public void logoutAll(String path, int count, int interval){
+	public void logoutAll(String path, int count, double interval){
 		File[] files = null;
 
 		File file = new File(path);
@@ -36,50 +36,62 @@
 		} else {
 			files = new File[]{file};
 		}
-		
+
 		List<BaseLogger> loggerList = new ArrayList<BaseLogger>();
-		loggerList.add(new LogbackLogger());	
-		loggerList.add(new Log4jLogger());	
-		
+		loggerList.add(new LogbackLogger());
+		loggerList.add(new Log4jLogger());
+
+		File prevFile = null;
+
+		// １回ごとにログ出力設定ファイルを設定する方法だと
+		// ch.qos.logback.core.rolling.SizeBasedTriggeringPolicyのローテートが機能しない。
+		// なぜならSizeBasedTriggeringPolicyが毎回サイズ超えを数回に１回判断しているため
+		// ログ出力設定を毎回設定すると毎回１回目となり、ローテートが走らなくなる。
+		// そのため、ログファイル１つに対しＮ下位ループする、という方式に変更する。
+
 		for (int i=0; i<count; i++) {
-			logger.info("*** {} 回目 ***", i);
+			logger.info("*** {} 回目 ***", i+1);
 			if (i > 0) {
 				try {
-					Thread.sleep(interval * 1000);
+					Thread.sleep((int)(interval * 1000));
 				} catch (InterruptedException e) {
 					//ignore
 				}
 			}
-			
+
 			for (File f : files) {
 				try {
 					//ループ中に書き換えた設定ファイルが反映されるように毎回読み込む
 					Document doc = loadXmlFile(f);
-
 					if (doc == null) {
 						continue;
 					}
-					
+
 					for (BaseLogger bl : loggerList) {
 						if (bl.isTarget(doc)) {
+							logger.info("【全ログ出力】{}:{}", bl.getDocType(), f.getAbsolutePath());
 							try {
-								bl.setConfigure(f);
+								if (prevFile != f) {
+									System.out.println("ロガー設定 [" + f.getAbsolutePath() + "]");
+									bl.setConfigure(f);
+								}
+								prevFile = f;
 								bl.logging(f, doc, i);
 							} catch (Throwable th) {
 								continue;
 							} finally {
-								BaseLogger.setConfigureForLogback(null);
+								//BaseLogger.setConfigureForLogback(null);
 							}
 						}
 					}
-					
+
 				} catch (Throwable th) {
 					logger.warn("処理異常発生", th);
 				}
 			}
 		}
 	}
-	
+
 	/**
 	 * ログ出力設定ファイル(XML)を読み込んで返す。
 	 * @param file
@@ -92,7 +104,7 @@
 		if (file.getName().endsWith(".xml") == false) {
 			return null;
 		}
-		
+
 		DocumentBuilderFactory dbf = DocumentBuilderFactory.newInstance();
 		try {
 			dbf.setFeature("http://apache.org/xml/features/nonvalidating/load-external-dtd", false); //DTDを無視する
@@ -104,10 +116,10 @@
 			logger.error("設定ファイル読み込み異常 (path=" + file.getAbsolutePath() + ")");
 			th.printStackTrace();
 		}
-		
+
 		return null;
 	}
-	
+
 	/**
 	 * 起動引数
 	 * [0] ログ設定ファイルのあるフォルダまたはファイル
@@ -126,10 +138,10 @@
 		logger.info("=== START ===");
 		String path = args[0];
 		int count = (args.length > 1) ? Integer.parseInt(args[1]) : 1;
-		int interval = (args.length > 2) ? Integer.parseInt(args[2]) : 0;
-		
+		double interval = (args.length > 2) ? Double.parseDouble(args[2]) : 0;
+
 		LogConfigTester app = new LogConfigTester();
-		app.logoutAll(path, count, interval);	
+		app.logoutAll(path, count, interval);
 	}
 
 }

diff -r 2df57ad74576 -r 9ba58a875982 src/main/java/jp/nanah/logconfchk/output/BaseLogger.java
--- a/src/main/java/jp/nanah/logconfchk/output/BaseLogger.java	Tue Jan 25 08:40:42 2022 +0900
+++ b/src/main/java/jp/nanah/logconfchk/output/BaseLogger.java	Sat May 28 20:28:58 2022 +0900
@@ -20,19 +20,52 @@
 
 	private static final Logger logger = LoggerFactory.getLogger(BaseLogger.class);
 
+	protected String docType;
+
 	public boolean isTarget(Document doc) {
 		return false;
 	}
-	
+
+	public void outputLine(String msg) {
+	}
+
 	public void setConfigure(File file) {
 	}
-	
+
 	public void logging(File file, Document doc, int count) {
 	}
-	
+
+	public String getDocType() {
+		return docType;
+	}
+
+	/**
+	 * 全Documentから%X{n}または%mdc{n}の場所を探して
+	 * nに相当する文字列を返す。
+	 */
+	public List<String[]> getMdcList(Document doc) {
+		List<String[]> mdcList = new ArrayList<String[]>();
+		// %X{key}
+		// %10X{key}
+		// %-10X{key}
+
+		// %mdc{key}
+		// %10mdc{key}
+		// %-10mdc{key}
+
+		//		Pattern p = Pattern.compile("%[-]*\\d*(X|mdc){.+}");
+		//		String str = doc.get  //"%-10X{key}";
+		//		Matcher m = p.matcher(str);
+		//		if(m.find()){
+		//			System.out.println(str + ":一致！ [" + m.group() + "]");
+		//		}
+
+		return mdcList;
+	}
+
 	//以下はユーティリティメソッド的に使う。
-	
-	
+
+
 	protected List<String> getLoggerNames(Document doc, String logNameTag){
 		List<String> loggerNames = new ArrayList<String>();
 
@@ -43,28 +76,29 @@
 			Element loggereElem = (Element) loggerNodes.item(i);
 			loggerNames.add( loggereElem.getAttribute("name") );
 		}
-		
+
 		return loggerNames;
 	}
 
-	
+
 	public static void setConfigureForLogback(File file) throws JoranException {
 		LoggerContext context = (LoggerContext) LoggerFactory.getILoggerFactory();
-        context.reset();
-        JoranConfigurator configurator = new JoranConfigurator();
-        configurator.setContext(context);
+		context.reset();
+		JoranConfigurator configurator = new JoranConfigurator();
+		configurator.setContext(context);
 
-        if (file != null) {
-//                URL configUrl = new URL("file:" + file.getAbsolutePath());
-//                logger.info("logconffile: {}", "file:" + file.getAbsolutePath() );
-//                configurator.doConfigure(configUrl);
-            configurator.doConfigure(file.getAbsolutePath());
-        } else {
-        	URL url = BaseLogger.class.getResource("/logback.xml");
-            configurator.doConfigure(url);
-        }
-            	
-    }
+		if (file != null) {
+			//                URL configUrl = new URL("file:" + file.getAbsolutePath());
+			//                logger.info("logconffile: {}", "file:" + file.getAbsolutePath() );
+			//                configurator.doConfigure(configUrl);
+			configurator.doConfigure(file.getAbsolutePath());
+			System.out.println("ロガー設定 : "+ file.getAbsolutePath());
+		} else {
+			URL url = BaseLogger.class.getResource("/logback.xml");
+			configurator.doConfigure(url);
+		}
+
+	}
 
 	public static void setConfigureForLog4j(File file) {
 		DOMConfigurator.configure(file.getAbsolutePath());

diff -r 2df57ad74576 -r 9ba58a875982 src/main/java/jp/nanah/logconfchk/output/Log4jLogger.java
--- a/src/main/java/jp/nanah/logconfchk/output/Log4jLogger.java	Tue Jan 25 08:40:42 2022 +0900
+++ b/src/main/java/jp/nanah/logconfchk/output/Log4jLogger.java	Sat May 28 20:28:58 2022 +0900
@@ -8,21 +8,32 @@
 
 public class Log4jLogger extends BaseLogger{
 
+	@Override
 	public boolean isTarget(Document doc) {
 		boolean b = doc.getDoctype().getName().contains("log4j");
 		return b;
 	}
-	
+
+	public void outputLine() {
+	}
+
+	@Override
 	public void setConfigure(File file) {
 		setConfigureForLog4j(file);
 	}
-	
+
+	@Override
+	public String getDocType() {
+		return "log4j";
+	}
+
+	@Override
 	public void logging(File file, Document doc, int count) {
 		Exception warnEx = new RuntimeException("警告時の例外情報です。");
 		Exception errorEx = new RuntimeException("異常時の例外情報です。");
 		List<String> names = getLoggerNames(doc, "logger");
 		String configPath = "[" + file.getName() + "]";
-		
+
 		for (String name : names) {
 			if (name == null) {
 				name = this.getClass().getCanonicalName();
@@ -37,5 +48,5 @@
 			log.fatal("ログメッセージを出力します [" + configPath + "][ERROR][" + count + "][" + name + "]", errorEx);
 		}
 	}
-	
+
 }

diff -r 2df57ad74576 -r 9ba58a875982 src/main/java/jp/nanah/logconfchk/output/LogbackLogger.java
--- a/src/main/java/jp/nanah/logconfchk/output/LogbackLogger.java	Tue Jan 25 08:40:42 2022 +0900
+++ b/src/main/java/jp/nanah/logconfchk/output/LogbackLogger.java	Sat May 28 20:28:58 2022 +0900
@@ -7,15 +7,36 @@
 import org.slf4j.LoggerFactory;
 import org.w3c.dom.Document;
 
-public class LogbackLogger extends BaseLogger{
+import ch.qos.logback.classic.LoggerContext;
+import ch.qos.logback.classic.encoder.PatternLayoutEncoder;
+import ch.qos.logback.core.ConsoleAppender;
+
+public class LogbackLogger extends BaseLogger {
 
 	private static final Logger logger = LoggerFactory.getLogger(LogbackLogger.class);
 
+	@Override
 	public boolean isTarget(Document doc) {
-		boolean b = doc.getDoctype().getName().contains("logback");
+		boolean b = doc.getDoctype().getName().contains(getDocType());
 		return b;
 	}
 
+	@Override
+	public void outputLine(String msg) {
+		LoggerContext loggerContext = (LoggerContext) LoggerFactory.getILoggerFactory();
+
+		//Pattern - MessageOnly
+		PatternLayoutEncoder encoder = new PatternLayoutEncoder();
+		encoder.setContext(loggerContext);
+		encoder.setPattern("%%m%n");
+		encoder.start();
+
+		//sg
+		ConsoleAppender appender = new ConsoleAppender();
+		appender.setContext(loggerContext);
+	}
+
+	@Override
 	public void setConfigure(File file){
 		try {
 			setConfigureForLogback(file);
@@ -23,24 +44,31 @@
 			throw new RuntimeException(ex);
 		}
 	}
-	
+
+	@Override
+	public String getDocType() {
+		return "logback";
+	}
+
+	@Override
 	public void logging(File file, Document doc, int count) {
 		Exception warnEx = new RuntimeException("警告時の例外情報です。");
 		Exception errorEx = new RuntimeException("異常時の例外情報です。");
 		List<String> names = getLoggerNames(doc, "logger");
 		String configPath = "[" + file.getName() + "]";
-		
+
 		for (String name : names) {
 			if (name == null) {
 				name = this.getClass().getCanonicalName();
 			}
+			System.out.println("カテゴリ名[" + name + "]");
 			Logger log = LoggerFactory.getLogger(name);
 			//         ログメッセージを出力します [logback.xml][DEBUG][0][org.commons.lang3]
-			log.trace("ログメッセージを出力します [{}][TRACE][{}][{}]", configPath, count, name);
-			log.debug("ログメッセージを出力します [{}][DEBUG][{}][{}]", configPath, count, name);
-			log.info ("ログメッセージを出力します [{}][INFO ][{}][{}]", configPath, count, name);
-			log.warn ("ログメッセージを出力します [{}][WARN ][{}][{}]", configPath, count, name, warnEx);
-			log.error("ログメッセージを出力します [{}][ERROR][{}][{}]", configPath, count, name, errorEx);
+			log.trace("ログメッセージを出力します [{}][{}][TRACE][{}]", count, name, configPath);
+			log.debug("ログメッセージを出力します [{}][{}][DEBUG][{}]", count, name, configPath);
+			log.info ("ログメッセージを出力します [{}][{}][INFO ][{}]", count, name, configPath);
+			log.warn ("ログメッセージを出力します [{}][{}][WARN ][{}]", count, name, configPath, warnEx);
+			log.error("ログメッセージを出力します [{}][{}][ERROR][{}]", count, name, configPath, errorEx);
 		}
 	}
 

diff -r 2df57ad74576 -r 9ba58a875982 src/main/resources/logback.xml
--- a/src/main/resources/logback.xml	Tue Jan 25 08:40:42 2022 +0900
+++ b/src/main/resources/logback.xml	Sat May 28 20:28:58 2022 +0900
@@ -2,8 +2,9 @@
 <!DOCTYPE logback>
 <configuration>
 	<appender name="STDOUT" class="ch.qos.logback.core.ConsoleAppender">
+		<target>System.out</target>
 		<encoder>
-			<pattern>%d{yyyy/MM/dd HH:mm:ss.SSS} %-5level %logger{36} - %m%n</pattern>
+			<pattern>★%d{yyyy/MM/dd HH:mm:ss.SSS} %-5level %logger{36} - %m%n</pattern>
 		</encoder>
 	</appender>