log4j2를 이용하여 BasicDataSource를 이용하여 DB에 접근 시, log4jdbc 같은 추가 라이브러리 없이 로깅이 가능한가요?

Question

log4j2를 이용하여 로깅을 하고 있는데요,BasicDataSource를 이용하여 DB에 접근하는 기본 소스를 작성하였습니다. 예를 들어 jdbc url이 잘못 되었다던지의 이유로 BasicDataSource 생성 시, 오류가 발생할 경우log4j2를 이용하여 로깅을 하고 싶습니다. 작성한 내용들은 아래와 같습니다. 실제 아래와 같이 작성하고, 테스트 코드를 수행하면, 잘못된 jdbc url로 일부로 설정 했기 때문에 제일 하단의 에러와 같이 console창에 에러가 발생합니다. 콘솔창에 표시되는 이 에러를 log4j2를 이용하여 로깅을 하였으면 합니다.설정이나 다른 방법을 통해 가능한지 궁금합니다. 아래와 같이 log4j2.xml을 설정하였습니다. log4j2.xml Spring 설정에서 Datasource는 아래와 같이 설정하였습니다. context-datasource.xml DB 접속과 테스트를 위한 코드는 아래와 같이 작성하였습니다. DBConnector.javapackage com.mamoru.common.database; import org.apache.commons.dbcp.BasicDataSource; import org.apache.logging.log4j.LogManager; import org.apache.logging.log4j.Logger; import org.springframework.beans.factory.annotation.Autowired; import org.springframework.context.ApplicationContext; import javax.annotation.PostConstruct; import java.sql.Connection; import java.sql.SQLException; public class DBConnector { private static Logger LOGGER = LogManager.getLogger(DBConnector.class); @Autowired protected ApplicationContext applicationContext; private BasicDataSource basicDataSource = null; private static DBConnector dbConnector = new DBConnector(); private DBConnector() { LOGGER.debug("[DBConnector constructor load]"); } public static DBConnector getInstance() { return dbConnector; } @PostConstruct public void init() { LOGGER.debug("[Init DB Connector] START ==========================================================="); basicDataSource = (BasicDataSource) applicationContext.getBean("basicDataSource"); LOGGER.debug("[Init DB Connector] END ============================================================= "); } public synchronized Connection getConnection() throws SQLException { return basicDataSource.getConnection(); } } DBConnectTest.javapackage com.mamoru.common.database; import org.apache.logging.log4j.LogManager; import org.apache.logging.log4j.Logger; import org.junit.Test; import org.junit.runner.RunWith; import org.springframework.test.context.ContextConfiguration; import org.springframework.test.context.junit4.SpringJUnit4ClassRunner; import java.sql.Connection; import java.sql.PreparedStatement; import java.sql.ResultSet; import java.sql.SQLException; // 테스트를 위한 설정 (with spring-test) @RunWith(SpringJUnit4ClassRunner.class) @ContextConfiguration(locations={ "classpath*:spring/root-context.xml", "classpath*:spring/springwebServlet/servlet-context-common.xml", "classpath*:spring/springwebServlet/servlet-context-datasource.xml"}) public class DBConnectorTest { private static Logger LOGGER = LogManager.getLogger(DBConnectorTest.class); @Test public void selectTable() throws SQLException { Connection connection = null; PreparedStatement pstmt = null; connection = DBConnector.getInstance().getConnection(); String sql = "SELECT COLUMN_NAME " + "FROM COLS " + "WHERE TABLE_NAME = 'LINKS'"; pstmt =connection.prepareStatement(sql); ResultSet rs = pstmt.executeQuery(); while ( rs.next() ) { LOGGER.debug("[Data List] " + rs.getString("COLUMN_NAME")); } connection.close(); pstmt.close(); } } 콘솔 로그 2016-03-15 17:26:23,539 INFO [org.springframework.test.context.support.DefaultTestContextBootstrapper] Loaded default TestExecutionListener class names from location [META-INF/spring.factories]: [org.springframework.test.context.web.ServletTestExecutionListener, org.springframework.test.context.support.DirtiesContextBeforeModesTestExecutionListener, org.springframework.test.context.support.DependencyInjectionTestExecutionListener, org.springframework.test.context.support.DirtiesContextTestExecutionListener, org.springframework.test.context.transaction.TransactionalTestExecutionListener, org.springframework.test.context.jdbc.SqlScriptsTestExecutionListener] 2016-03-15 17:26:23,549 INFO [org.springframework.test.context.support.DefaultTestContextBootstrapper] Could not instantiate TestExecutionListener [org.springframework.test.context.transaction.TransactionalTestExecutionListener]. Specify custom listener classes or make the default listener classes (and their required dependencies) available. Offending class: [org/springframework/transaction/interceptor/TransactionAttributeSource] 2016-03-15 17:26:23,556 INFO [org.springframework.test.context.support.DefaultTestContextBootstrapper] Could not instantiate TestExecutionListener [org.springframework.test.context.jdbc.SqlScriptsTestExecutionListener]. Specify custom listener classes or make the default listener classes (and their required dependencies) available. Offending class: [org/springframework/transaction/interceptor/TransactionAttribute] 2016-03-15 17:26:23,560 INFO [org.springframework.test.context.support.DefaultTestContextBootstrapper] Using TestExecutionListeners: [org.springframework.test.context.web.ServletTestExecutionListener@4ebf837a, org.springframework.test.context.support.DirtiesContextBeforeModesTestExecutionListener@7f50e6f9, org.springframework.test.context.support.DependencyInjectionTestExecutionListener@186c26bc, org.springframework.test.context.support.DirtiesContextTestExecutionListener@64630d2a]2016-03-15 17:26:23,871 INFO [org.springframework.beans.factory.xml.XmlBeanDefinitionReader] Loading XML bean definitions from URL [file:/C:/mamoru/github/spring/springweb/target/classes/spring/root-context.xml] 2016-03-15 17:26:24,181 INFO [org.springframework.beans.factory.xml.XmlBeanDefinitionReader] Loading XML bean definitions from URL [file:/C:/mamoru/github/spring/springweb/target/classes/spring/springwebServlet/servlet-context-common.xml] 2016-03-15 17:26:25,039 INFO [org.springframework.beans.factory.xml.XmlBeanDefinitionReader] Loading XML bean definitions from URL [file:/C:/mamoru/github/spring/springweb/target/classes/spring/springwebServlet/servlet-context-datasource.xml] 2016-03-15 17:26:25,109 INFO [org.springframework.context.support.GenericApplicationContext] Refreshing org.springframework.context.support.GenericApplicationContext@57b7a9: startup date [Tue Mar 15 17:26:25 KST 2016]; root of context hierarchy 2016-03-15 17:26:25,618 INFO [org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerMapping] Mapped "{[/helloSpring]}" onto public org.springframework.web.servlet.ModelAndView com.mamoru.webapp.hellospring.controller.HelloSpringController.hello() 2016-03-15 17:26:25,826 INFO [org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter] Looking for @ControllerAdvice: org.springframework.context.support.GenericApplicationContext@57b7a9: startup date [Tue Mar 15 17:26:25 KST 2016]; root of context hierarchy 2016-03-15 17:26:25,926 INFO [org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter] Looking for @ControllerAdvice: org.springframework.context.support.GenericApplicationContext@57b7a9: startup date [Tue Mar 15 17:26:25 KST 2016]; root of context hierarchy 2016-03-15 17:26:26,063 INFO [org.springframework.web.servlet.handler.SimpleUrlHandlerMapping] Mapped URL path [/resources/**] onto handler 'org.springframework.web.servlet.resource.ResourceHttpRequestHandler#0' [MAMORU] (2016-03-15 17:26:26,101) [DEBUG] [com.mamoru.common.database.DBConnector] [DBConnector constructor load] [MAMORU] (2016-03-15 17:26:26,115) [DEBUG] [com.mamoru.common.database.DBConnector] [Init DB Connector] START =========================================================== [MAMORU] (2016-03-15 17:26:26,209) [DEBUG] [com.mamoru.common.database.DBConnector] [Init DB Connector] END ============================================================= org.apache.commons.dbcp.SQLNestedException: Cannot create PoolableConnectionFactory (Listener refused the connection with the following error: ORA-12514, TNS:listener does not currently know of service requested in connect descriptor ) at org.apache.commons.dbcp.BasicDataSource.createPoolableConnectionFactory(BasicDataSource.java:1549) at org.apache.commons.dbcp.BasicDataSource.createDataSource(BasicDataSource.java:1388) at org.apache.commons.dbcp.BasicDataSource.getConnection(BasicDataSource.java:1044) at com.mamoru.common.database.DBConnector.getConnection(DBConnector.java:59) at com.mamoru.common.database.DBConnectorTest.selectTable(DBConnectorTest.java:31) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:606) at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50) at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12) at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47) at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17) at org.springframework.test.context.junit4.statements.RunBeforeTestMethodCallbacks.evaluate(RunBeforeTestMethodCallbacks.java:75) at org.springframework.test.context.junit4.statements.RunAfterTestMethodCallbacks.evaluate(RunAfterTestMethodCallbacks.java:86) at org.springframework.test.context.junit4.statements.SpringRepeat.evaluate(SpringRepeat.java:84) at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325) at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.runChild(SpringJUnit4ClassRunner.java:254) at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.runChild(SpringJUnit4ClassRunner.java:89) at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290) at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71) at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288) at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58) at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268) at org.springframework.test.context.junit4.statements.RunBeforeTestClassCallbacks.evaluate(RunBeforeTestClassCallbacks.java:61) at org.springframework.test.context.junit4.statements.RunAfterTestClassCallbacks.evaluate(RunAfterTestClassCallbacks.java:70) at org.junit.runners.ParentRunner.run(ParentRunner.java:363) at org.springframework.test.context.junit4.SpringJUnit4ClassRunner.run(SpringJUnit4ClassRunner.java:193) at org.junit.runner.JUnitCore.run(JUnitCore.java:137) at com.intellij.junit4.JUnit4IdeaTestRunner.startRunnerWithArgs(JUnit4IdeaTestRunner.java:69) at com.intellij.rt.execution.junit.JUnitStarter.prepareStreamsAndStart(JUnitStarter.java:234) at com.intellij.rt.execution.junit.JUnitStarter.main(JUnitStarter.java:74) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:606) at com.intellij.rt.execution.application.AppMain.main(AppMain.java:144) Caused by: java.sql.SQLException: Listener refused the connection with the following error: ORA-12514, TNS:listener does not currently know of service requested in connect descriptor at oracle.jdbc.driver.T4CConnection.logon(T4CConnection.java:489) at oracle.jdbc.driver.PhysicalConnection.(PhysicalConnection.java:553) at oracle.jdbc.driver.T4CConnection.(T4CConnection.java:254) at oracle.jdbc.driver.T4CDriverExtension.getConnection(T4CDriverExtension.java:32) at oracle.jdbc.driver.OracleDriver.connect(OracleDriver.java:528) at org.apache.commons.dbcp.DriverConnectionFactory.createConnection(DriverConnectionFactory.java:38) at org.apache.commons.dbcp.PoolableConnectionFactory.makeObject(PoolableConnectionFactory.java:582) at org.apache.commons.dbcp.BasicDataSource.validateConnectionFactory(BasicDataSource.java:1556) at org.apache.commons.dbcp.BasicDataSource.createPoolableConnectionFactory(BasicDataSource.java:1545) ... 36 more Caused by: oracle.net.ns.NetException: Listener refused the connection with the following error: ORA-12514, TNS:listener does not currently know of service requested in connect descriptor at oracle.net.ns.NSProtocol.connect(NSProtocol.java:399) at oracle.jdbc.driver.T4CConnection.connect(T4CConnection.java:1140) at oracle.jdbc.driver.T4CConnection.logon(T4CConnection.java:340) ... 44 more 2016-03-15 17:26:26,506 INFO [org.springframework.context.support.GenericApplicationContext] Closing org.springframework.context.support.GenericApplicationContext@57b7a9: startup date [Tue Mar 15 17:26:25 KST 2016]; root of context hierarchy Process finished with exit code -1

제타건담 · Answer

지금 이 로그를 찍는거 자체가 log4j2를 이용하고 있는 겁니다. 콘솔에 찍는거라 해도 log4j2.xml의 출력을 console로 정했기 때문에 나오는거죠,.정확하게 무엇을 원하시는건지를 모르겠네요..log4jdbc는 사용되는 쿼리문을 로그로 출력할 때 사용하는겁니다..물론 쿼리문을 출력하는것도 log4j2를 사용합니다. 그러나 log4j2를 사용하여 쿼리를 출력하는 경우 쿼리에서 사용되는 바인딩 되는 값들은 출력이 되지 않고 ?로 나오는 상태로 출력하지만 log4jdbc를 사용하면 쿼리문에 값들을 바인딩 시킨채로 해서 쿼리문을 출력하기 때문에 한결 보기가 좋죠

파이팅마모루 · Answer

&#64;제타건담오류가 발생한 부분은 log4j2가 아닌 익셉션이 그대로 콘솔에 찍혔습니다. log4j2 패턴을 지정해 두었고, log4j2를 통해 로그가 기록되어야 겠지요. 제가 궁금해 하는 부분이 바로 위에서 말한 부분입니다. log4j2.xml 에서 org.apache.common.dbcp 를 Logger로 등록해 두었는데 오류 발생시에 log4j2를 거친것이 아닌 곧바로 콘솔에 찍혔기 때문에 이부분을 어떻게 설정해야 하는 것인지, 아니면 설정이 불가능 한 것인지 등이 궁금한 것이에요.

제타건담 · Answer

여기서 보면 appenderRef를 console로 지정했으니까 당연 콘솔로 나오는거자너요.. 여기서 보면 target을 SYSTEM_OUT으로 두었으니까 당연 콘솔로 그냥 나와버리는거죠..log4j2에서 출력쪽을 console로 했으니까 당연 console로 나오는거죠..log4j2를 거친거 맞습니다..log4j2에 대한 레퍼런스를 보세요..

파이팅마모루 · Answer

&#64;제타건담저의 질문 의도가 제대로 전달되지 못한거 같습니다.콘솔로 나온 것이 문제가 아니구요, console 출력 시 패턴을 설정에 등록해 두었습니다. 그래서 올려둔 로그를 보면 스프링 관련 로그와 logger 를 직접 선언하여 호출한 경우 각각의 패턴에 맞게 &#34;날짜 시간 로그레벨 [클래스] 로그내용&#34; 과 같은 형태로 출력이 되고 있습니다.하지만 에러의 경우에는 패턴에 맞게 출력이 되는 것이 아니라 단순히 익셉션 내용이 곧 바로 표시되고 있죠. 이 지점을 이야기 하는 것입니다. 단순히 콘솔에 찍힌다고 해서 질문을 올린게 아니라는 것이에요.

제타건담 · Answer

아..내용이 먼지 알겠네요..그러면 하나 물어볼께요..지금 예외 로그를 보면 BasicDataSource 관련 부분에서는 SQLException만 던지고 있습니다..그러면 마모루님이 작성한 DBConnector 클래스에서도 예외를 던지고 있어요..그리고 Test용도로 만든 클래스에서도 받은 예외를 그대로 던지고 있습니다..그러면 그렇게 던져지는 예외는 최종적으로 어디에서 받고 있으신가요?Spring에서는 예외를 받았을때 해당 예외를 처리하는 Bean을 작성할 수 있습니다..웹이라면 &#64;ControllerAdvice 어노테이션 붙은 클래스가 대표적인거죠..만약 정해진 로그 패턴대로 나오게 하고 싶으면 Spring에서 그런 예외처리용 클래스에서 해줘야 합니다..그런곳이 없으면 로거로 출력하는게 아니라 그냥 System 출력으로 갈꺼에요..흔히 콘솔인거죠..

log4j2를 이용하여 BasicDataSource를 이용하여 DB에 접근 시, log4jdbc 같은 추가 라이브러리 없이 로깅이 가능한가요?

5개의 답변

#basicdatasource 목록