fusionauth - 制限されたログで Fusion 認証アプリを起動できません。ログを 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 です。何が起こっているのかをさらに理解できるように、DEBUG などのログレベルを低く設定する方法はありますか?

私はすでにサーバーを再起動しようとしました。

Fusion Auth アプリと Fusion Auth 検索サービスの両方を再起動しました

Fusion Auth アプリと Fusion Auth 検索を手動で、つまりサービスとしてではなく実行しようとしました

2019 年 12 月 7 日 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てから、サービスを再起動します。

DEBUG を有効にした構成の例を次に示します。

<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 認証アプリを起動できません。ログを INFO から DEBUG に変更する構成はありますか?

作業環境：

失敗した環境:

2019 年 12 月 7 日 logback.xml でログを更新

1 に答える 1

Related

Reference