fusionauth - Fusion auth 应用程序无法以有限的日志记录启动，是否有将日志记录从 INFO 更改为 DEBUG 的配置？

Question

我们确实在我们的自动化测试环境中启动并运行了 fusionauth。但是现在它无法启动。在我们的其他环境中，我们运行着完全相同的设置。通常我的首选是 fusionauthapp_stdout 日志。然而奇怪的是，日志似乎在早期启动阶段停止发出。

在正常工作的环境中，日志看起来像我期望的正常启动，如第一个示例所示：

工作环境：

Using CATALINA_BASE:   "C:\Users\administrator\fusionauth\fusionauth-app\apache-tomcat"
Using CATALINA_HOME:   "C:\Users\administrator\fusionauth\fusionauth-app\apache-tomcat"
Using CATALINA_TMPDIR: "C:\Users\administrator\fusionauth\fusionauth-app\apache-tomcat\temp"
Using JRE_HOME:        "C:\Users\administrator\fusionauth\fusionauth-app\apache-tomcat\..\..\java\jre1.8.0_171"
Using CLASSPATH:       "C:\Users\administrator\fusionauth\fusionauth-app\apache-tomcat\bin\bootstrap.jar;C:\Users\administrator\fusionauth\fusionauth-app\apache-tomcat\bin\tomcat-juli.jar"
Jul 10, 2019 10:41:11.414 AM INFO  io.fusionauth.api.configuration.PropertiesFileFusionAuthConfiguration - Loading FusionAuth configuration file [C:\Users\administrator\fusionauth\fusionauth-app\apache-tomcat\..\..\config\fusionauth.properties]
Jul 10, 2019 10:41:11.478 AM INFO  io.fusionauth.api.configuration.PropertiesFileFusionAuthConfiguration - Dynamically set property [fusionauth-app.public-url] set to [http://192.168.XX.XX:XXXX]
Jul 10, 2019 10:41:11.479 AM INFO  io.fusionauth.api.configuration.PropertiesFileFusionAuthConfiguration - FusionAuth Runtime Mode [Production]
Jul 10, 2019 10:41:11.599 AM INFO  io.fusionauth.api.configuration.PropertiesFileFusionAuthConfiguration - Loading FusionAuth configuration file [C:\Users\administrator\fusionauth\fusionauth-app\apache-tomcat\..\..\config\fusionauth.properties]
Jul 10, 2019 10:41:11.664 AM INFO  io.fusionauth.api.configuration.PropertiesFileFusionAuthConfiguration - Dynamically set property [fusionauth-app.public-url] set to [http://192.168.XX.XX:XXXX
Jul 10, 2019 10:41:11.665 AM INFO  io.fusionauth.api.configuration.PropertiesFileFusionAuthConfiguration - FusionAuth Runtime Mode [Production]
Jul 10, 2019 10:41:11.925 AM INFO  com.inversoft.maintenance.db.JDBCMaintenanceModeDatabaseService - Database Version [1.3.1]
Jul 10, 2019 10:41:11.927 AM INFO  com.inversoft.maintenance.db.JDBCMaintenanceModeDatabaseService - Latest Migration Version [1.1.0]
Jul 10, 2019 10:41:11.929 AM INFO  io.fusionauth.app.maintenance.FusionAuthMaintenanceModeWorkflow - Determine database status : ACTIVE
Jul 10, 2019 10:41:12.113 AM INFO  io.fusionauth.app.maintenance.FusionAuthMaintenanceModeWorkflow - Determine search status : ACTIVE]
Jul 10, 2019 10:41:12.115 AM INFO  org.primeframework.mvc.servlet.PrimeServletContextListener - Initializing Prime
Jul 10, 2019 10:41:12.118 AM INFO  io.fusionauth.app.guice.FusionAuthModule - 


--------- Starting FusionAuth version [1.3.1] -------
logs continue

失败环境：

Using CATALINA_BASE:   "C:\fusionauth\fusionauth-app\apache-tomcat"
Using CATALINA_HOME:   "C:\fusionauth\fusionauth-app\apache-tomcat"
Using CATALINA_TMPDIR: "C:\fusionauth\fusionauth-app\apache-tomcat\temp"
Using JRE_HOME:        "C:\fusionauth\fusionauth-app\apache-tomcat\..\..\java\jre1.8.0_171"
Using CLASSPATH:       "C:\fusionauth\fusionauth-app\apache-tomcat\bin\bootstrap.jar;C:\fusionauth\fusionauth-app\apache-tomcat\bin\tomcat-juli.jar"
Jul 10, 2019 10:57:41.944 AM INFO  io.fusionauth.api.configuration.PropertiesFileFusionAuthConfiguration - Loading FusionAuth configuration file [C:\fusionauth\fusionauth-app\apache-tomcat\..\..\config\fusionauth.properties]
Jul 10, 2019 10:57:41.993 AM INFO  io.fusionauth.api.configuration.PropertiesFileFusionAuthConfiguration - Dynamically set property [fusionauth-app.public-url] set to [http://192.168.XX.XX:XXXX]
Jul 10, 2019 10:57:41.994 AM INFO  io.fusionauth.api.configuration.PropertiesFileFusionAuthConfiguration - FusionAuth Runtime Mode [Production]
Jul 10, 2019 10:57:42.164 AM INFO  io.fusionauth.api.configuration.PropertiesFileFusionAuthConfiguration - Loading FusionAuth configuration file [C:\fusionauth\fusionauth-app\apache-tomcat\..\..\config\fusionauth.properties]
Jul 10, 2019 10:57:42.208 AM INFO  io.fusionauth.api.configuration.PropertiesFileFusionAuthConfiguration - Dynamically set property [fusionauth-app.public-url] set to [http://192.168.XX.XX:XXXX]
Jul 10, 2019 10:57:42.209 AM INFO  io.fusionauth.api.configuration.PropertiesFileFusionAuthConfiguration - FusionAuth Runtime Mode [Production]

属性配置后日志突然停止...

我很欣赏这可能是没有环境的问题，但是没有日志我很困惑。

当前日志级别为 INFO。无论如何将日志级别设置为较低，例如调试，以便我可以进一步了解发生了什么？

我已经尝试重新启动服务器。

重新启动了 fusion auth 应用程序和 fusion auth 搜索服务

尝试手动运行 fusion auth app 和 fusion auth search，即不作为服务

12/07/2019 使用 logback.xml 更新日志

Using CATALINA_BASE:   "C:\fusionauth\fusionauth-app\apache-tomcat"
Using CATALINA_HOME:   "C:\fusionauth\fusionauth-app\apache-tomcat"
Using CATALINA_TMPDIR: "C:\fusionauth\fusionauth-app\apache-tomcat\temp"
Using JRE_HOME:        "C:\fusionauth\fusionauth-app\apache-tomcat\..\..\java\jre1.8.0_171"
Using CLASSPATH:       "C:\fusionauth\fusionauth-app\apache-tomcat\bin\bootstrap.jar;C:\fusionauth\fusionauth-app\apache-tomcat\bin\tomcat-juli.jar"
08:03:37,104 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.groovy]
08:03:37,104 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
08:03:37,105 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [file:/C:/fusionauth/fusionauth-app/web/WEB-INF/classes/logback.xml]
08:03:37,105 |-WARN in ch.qos.logback.classic.LoggerContext[default] - Resource [logback.xml] occurs multiple times on the classpath.
08:03:37,105 |-WARN in ch.qos.logback.classic.LoggerContext[default] - Resource [logback.xml] occurs at [jar:file:/C:/fusionauth/fusionauth-app/web/WEB-INF/lib/fusionauth-app-1.3.1.jar!/logback.xml]
08:03:37,105 |-WARN in ch.qos.logback.classic.LoggerContext[default] - Resource [logback.xml] occurs at [file:/C:/fusionauth/fusionauth-app/web/WEB-INF/classes/logback.xml]
08:03:37,140 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - debug attribute not set
08:03:37,147 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - Setting ReconfigureOnChangeFilter scanning period to 1 minutes
08:03:37,147 |-INFO in ReconfigureOnChangeFilter{invocationCounter=0} - Will scan for changes in [[C:\fusionauth\fusionauth-app\web\WEB-INF\classes\logback.xml]] every 60 seconds. 
08:03:37,147 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - Adding ReconfigureOnChangeFilter as a turbo filter
08:03:37,152 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.ConsoleAppender]
08:03:37,155 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [STDOUT]
08:03:37,170 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
08:03:37,204 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [io.fusionauth] to DEBUG
08:03:37,204 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting additivity of logger [io.fusionauth] to false
08:03:37,204 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [STDOUT] to Logger[io.fusionauth]
08:03:37,205 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [org.primeframework] to DEBUG
08:03:37,205 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting additivity of logger [org.primeframework] to false
08:03:37,205 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [STDOUT] to Logger[org.primeframework]
08:03:37,205 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.inversoft.migration] to DEBUG
08:03:37,205 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting additivity of logger [com.inversoft.migration] to false
08:03:37,205 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [STDOUT] to Logger[com.inversoft.migration]
08:03:37,205 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.inversoft.maintenance] to DEBUG
08:03:37,205 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting additivity of logger [com.inversoft.maintenance] to false
08:03:37,205 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [STDOUT] to Logger[com.inversoft.maintenance]
08:03:37,205 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [org.apache.kafka.common.utils.AppInfoParser] to DEBUG
08:03:37,205 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting additivity of logger [org.apache.kafka.common.utils.AppInfoParser] to false
08:03:37,205 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [STDOUT] to Logger[org.apache.kafka.common.utils.AppInfoParser]
08:03:37,205 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [org.apache.kafka.clients.consumer.ConsumerConfig] to DEBUG
08:03:37,205 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting additivity of logger [org.apache.kafka.clients.consumer.ConsumerConfig] to false
08:03:37,205 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [STDOUT] to Logger[org.apache.kafka.clients.consumer.ConsumerConfig]
08:03:37,205 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [org.apache.kafka.clients.producer.ProducerConfig] to DEBUG
08:03:37,205 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting additivity of logger [org.apache.kafka.clients.producer.ProducerConfig] to false
08:03:37,205 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [STDOUT] to Logger[org.apache.kafka.clients.producer.ProducerConfig]
08:03:37,205 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [org.apache.kafka.clients.producer.KafkaProducer] to DEBUG
08:03:37,205 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting additivity of logger [org.apache.kafka.clients.producer.KafkaProducer] to false
08:03:37,205 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [STDOUT] to Logger[org.apache.kafka.clients.producer.KafkaProducer]
08:03:37,205 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [org.apache.kafka.clients.NetworkClient] to DEBUG
08:03:37,205 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting additivity of logger [org.apache.kafka.clients.NetworkClient] to false
08:03:37,205 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [STDOUT] to Logger[org.apache.kafka.clients.NetworkClient]
08:03:37,205 |-INFO in ch.qos.logback.classic.joran.action.RootLoggerAction - Setting level of ROOT logger to DEBUG
08:03:37,205 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [STDOUT] to Logger[ROOT]
08:03:37,205 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - End of configuration.
08:03:37,206 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@18a29fef - Registering current configuration as safe fallback point

Jul 12, 2019 8:03:37.218 AM DEBUG org.primeframework.mvc.guice.GuiceBootstrap - Initializing Guice
Jul 12, 2019 8:03:37.800 AM INFO  io.fusionauth.api.configuration.PropertiesFileFusionAuthConfiguration - Loading FusionAuth configuration file [C:\fusionauth\fusionauth-app\apache-tomcat\..\..\config\fusionauth.properties]
Jul 12, 2019 8:03:37.840 AM INFO  io.fusionauth.api.configuration.PropertiesFileFusionAuthConfiguration - Dynamically set property [fusionauth-app.public-url] set to [http://192.168.XX.XX:XXXX]
Jul 12, 2019 8:03:37.841 AM INFO  io.fusionauth.api.configuration.PropertiesFileFusionAuthConfiguration - FusionAuth Runtime Mode [Production]
Jul 12, 2019 8:03:37.965 AM DEBUG org.primeframework.mvc.guice.GuiceBootstrap - Initializing Guice
Jul 12, 2019 8:03:37.969 AM INFO  io.fusionauth.api.configuration.PropertiesFileFusionAuthConfiguration - Loading FusionAuth configuration file [C:\fusionauth\fusionauth-app\apache-tomcat\..\..\config\fusionauth.properties]
Jul 12, 2019 8:03:38.008 AM INFO  io.fusionauth.api.configuration.PropertiesFileFusionAuthConfiguration - Dynamically set property [fusionauth-app.public-url] set to [http://192.168.XX.XX:XXXX]
Jul 12, 2019 8:03:38.009 AM INFO  io.fusionauth.api.configuration.PropertiesFileFusionAuthConfiguration - FusionAuth Runtime Mode [Production]
Jul 12, 2019 8:03:38.061 AM DEBUG com.inversoft.maintenance.db.JDBCMaintenanceModeDatabaseService - Connection established to [192.168.XX.XX:XXXX]

score 1 · Accepted Answer

要在启动期间提高日志级别，您可以执行以下步骤：

放入logback.xml文件，fusionauth\fusionauth-app\web\WEB-INF\classes然后重新启动服务。

这是启用了调试的示例配置。

<configuration scan="true" scanPeriod="60 seconds">
  <appender name="STDOUT" class="ch.qos.logback.core.ConsoleAppender">
    <!-- encoders are assigned the type
         ch.qos.logback.classic.encoder.PatternLayoutEncoder by default -->
    <encoder>
      <pattern>%d{"MMM dd, yyyy h:mm:ss.SSS a"} %-5level %logger{75} - %msg%n</pattern>
    </encoder>
  </appender>

  <!-- DEBUG enabled -->
  <logger name="io.fusionauth" level="DEBUG" additivity="false">
    <appender-ref ref="STDOUT"/>
  </logger>

  <logger name="org.primeframework" level="INFO" additivity="false">
    <appender-ref ref="STDOUT"/>
  </logger>

  <logger name="com.inversoft.migration" level="INFO" additivity="false">
    <appender-ref ref="STDOUT"/>
  </logger>

  <logger name="com.inversoft.maintenance" level="INFO" additivity="false">
    <appender-ref ref="STDOUT"/>
  </logger>

  <!-- Kafka logging is chatty -->
  <logger name="org.apache.kafka.common.utils.AppInfoParser" level="ERROR" additivity="false">
    <appender-ref ref="STDOUT"/>
  </logger>
  <logger name="org.apache.kafka.clients.consumer.ConsumerConfig" level="ERROR" additivity="false">
    <appender-ref ref="STDOUT"/>
  </logger>
  <logger name="org.apache.kafka.clients.producer.ProducerConfig" level="ERROR" additivity="false">
    <appender-ref ref="STDOUT"/>
  </logger>
  <logger name="org.apache.kafka.clients.producer.KafkaProducer" level="ERROR" additivity="false">
    <appender-ref ref="STDOUT"/>
  </logger>
  <logger name="org.apache.kafka.clients.NetworkClient" level="ERROR" additivity="false">
    <appender-ref ref="STDOUT"/>
  </logger>

  <root level="INFO">
    <appender-ref ref="STDOUT" />
  </root>
</configuration>

https://gist.github.com/robotdan/422904ddf9381233b0ac73654fd8d243

fusionauth - Fusion auth 应用程序无法以有限的日志记录启动，是否有将日志记录从 INFO 更改为 DEBUG 的配置？

工作环境：

失败环境：

12/07/2019 使用 logback.xml 更新日志

1 回答 1

Related

Reference