Details
-
Bug
-
Status: Closed
-
Critical
-
Resolution: Workaround
-
None
-
None
-
None
Description
A configuration in jetty app using log4j2.xml (use slf4j as logger)as below -
<JsonTemplateLayout eventTemplateUri="classpath:log4j2JSONLayout.json"/>
Throws following error during initialization -
main ERROR RollingRandomAccessFile contains an invalid element or attribute "JsonTemplateLayout"
dependencies added are:
slf4j-api - 1.7.32
jcl-over-slf4j - 1.7.32
log4j-api - 2.17.1
log4j-core - 2.17.1
log4j-layout-template-json - 2.17.1
log4j-slf4j-impl - 2.17.1
Any help/advise on this really appreciated, Thanks.
Find the entire log4j DEBUG log:
2022-01-06 14:35:44,536 main DEBUG null null initializing configuration XmlConfiguration[location=jar:file:/usr/local/xxx/appxx.jar!/log4j2.xml] 2022-01-06 14:35:44,545 main DEBUG Installed 1 script engine 2022-01-06 14:35:45,016 main DEBUG Oracle Nashorn version: 1.8.0_292, language: ECMAScript, threading: Not Thread Safe, compile: true, names: [nashorn, Nashorn, js, JS, JavaScript, javascript, ECMAScript, ecmascript], factory class: jdk.nashorn.api.scripting.NashornScriptEngineFactory 2022-01-06 14:35:45,017 main DEBUG PluginManager 'Core' found 127 plugins 2022-01-06 14:35:45,020 main DEBUG PluginManager 'Level' found 0 plugins 2022-01-06 14:35:45,036 main DEBUG Building Plugin[name=property, class=org.apache.logging.log4j.core.config.Property]. 2022-01-06 14:35:45,063 main DEBUG PluginManager 'TypeConverter' found 26 plugins 2022-01-06 14:35:45,086 main DEBUG createProperty(name="PULSAR_APP_NAME", value="ace") 2022-01-06 14:35:45,086 main DEBUG Building Plugin[name=property, class=org.apache.logging.log4j.core.config.Property]. 2022-01-06 14:35:45,088 main DEBUG createProperty(name="PULSAR_LOG_DIR", value="/pulsar-logs-root/ace") 2022-01-06 14:35:45,089 main DEBUG Building Plugin[name=property, class=org.apache.logging.log4j.core.config.Property]. 2022-01-06 14:35:45,090 main DEBUG createProperty(name="MESOS_TASK_ID", value="unknown-task.${env:PULSAR_APP_NAME}.20220106143545090") 2022-01-06 14:35:45,090 main DEBUG Building Plugin[name=properties, class=org.apache.logging.log4j.core.config.PropertiesPlugin]. 2022-01-06 14:35:45,098 main DEBUG configureSubstitutor(={PULSAR_APP_NAME=ace, PULSAR_LOG_DIR=/pulsar-logs-root/ace, MESOS_TASK_ID=unknown-task.${env:PULSAR_APP_NAME}.20220106143545090}, Configuration(jar:file:/usr/local/xxx/app.jar!/log4j2.xml)) 2022-01-06 14:35:45,100 main DEBUG PluginManager 'Lookup' found 16 plugins 2022-01-06 14:35:45,128 main DEBUG Building Plugin[name=layout, class=org.apache.logging.log4j.core.layout.PatternLayout]. 2022-01-06 14:35:45,135 main DEBUG PatternLayout$Builder(pattern="%d{HH:mm:ss.SSS} [%t] %-5level %logger{36} - %msg%n", PatternSelector=null, Configuration(jar:file:/usr/local/xxx/ace.jar!/log4j2.xml), Replace=null, charset="null", alwaysWriteExceptions="null", disableAnsi="null", noConsoleNoAnsi="null", header="null", footer="null") 2022-01-06 14:35:45,136 main DEBUG PluginManager 'Converter' found 45 plugins 2022-01-06 14:35:45,137 main DEBUG Building Plugin[name=appender, class=org.apache.logging.log4j.core.appender.ConsoleAppender]. 2022-01-06 14:35:45,149 main DEBUG ConsoleAppender$Builder(target="SYSTEM_OUT", follow="null", direct="null", bufferedIo="null", bufferSize="null", immediateFlush="null", ignoreExceptions="null", PatternLayout(%d{HH:mm:ss.SSS} [%t] %-5level %logger{36} - %msg%n), name="Console", Configuration(jar:file:/usr/local/xxx/ace.jar!/log4j2.xml), Filter=null, ={}) 2022-01-06 14:35:45,152 main DEBUG Starting OutputStreamManager SYSTEM_OUT.false.false 2022-01-06 14:35:45,152 main DEBUG Building Plugin[name=OnStartupTriggeringPolicy, class=org.apache.logging.log4j.core.appender.rolling.OnStartupTriggeringPolicy]. 2022-01-06 14:35:45,157 main DEBUG createPolicy(minSize="1") 2022-01-06 14:35:45,158 main DEBUG Building Plugin[name=SizeBasedTriggeringPolicy, class=org.apache.logging.log4j.core.appender.rolling.SizeBasedTriggeringPolicy]. 2022-01-06 14:35:45,159 main DEBUG createPolicy(size="10MB") 2022-01-06 14:35:45,163 main DEBUG Building Plugin[name=TimeBasedTriggeringPolicy, class=org.apache.logging.log4j.core.appender.rolling.TimeBasedTriggeringPolicy]. 2022-01-06 14:35:45,166 main DEBUG TimeBasedTriggeringPolicy$Builder(interval="null", modulate="null", maxRandomDelay="null") 2022-01-06 14:35:45,167 main DEBUG Building Plugin[name=Policies, class=org.apache.logging.log4j.core.appender.rolling.CompositeTriggeringPolicy]. 2022-01-06 14:35:45,167 main DEBUG createPolicy(={OnStartupTriggeringPolicy, SizeBasedTriggeringPolicy(size=10485760), TimeBasedTriggeringPolicy(nextRolloverMillis=0, interval=1, modulate=false)}) 2022-01-06 14:35:45,168 main DEBUG Building Plugin[name=DefaultRolloverStrategy, class=org.apache.logging.log4j.core.appender.rolling.DefaultRolloverStrategy]. 2022-01-06 14:35:45,175 main DEBUG DefaultRolloverStrategy$Builder(max="10000", min="null", fileIndex="null", compressionLevel="null", ={}, stopCustomActionsOnError="null", tempCompressedFilePattern="null", Configuration(jar:file:/usr/local/akamai/ace.jar!/log4j2.xml)) 2022-01-06 14:35:45,176 main DEBUG Building Plugin[name=appender, class=org.apache.logging.log4j.core.appender.RollingRandomAccessFileAppender]. 2022-01-06 14:35:45,180 main DEBUG RollingRandomAccessFileAppender$Builder(fileName="/pulsar-logs-root/ace/ace.jsonl", filePattern="/pulsar-logs-root/ace/ace-%d{yyyyMMddHHmm}.%i.jsonl", append="null", Policies(CompositeTriggeringPolicy(policies=[OnStartupTriggeringPolicy, SizeBasedTriggeringPolicy(size=10485760), TimeBasedTriggeringPolicy(nextRolloverMillis=0, interval=1, modulate=false)])), DefaultRolloverStrategy(DefaultRolloverStrategy(min=1, max=10000, useMax=true)), advertise="null", advertiseURI="null", filePermissions="null", fileOwner="null", fileGroup="null", bufferedIo="null", bufferSize="null", immediateFlush="false", ignoreExceptions="null", Layout=null, name="RollingFileJson", Configuration(jar:file:/usr/local/xxx/ace.jar!/log4j2.xml), Filter=null, ={}) 2022-01-06 14:35:45,181 main ERROR RollingRandomAccessFile contains an invalid element or attribute "JsonTemplateLayout" 2022-01-06 14:35:45,184 main DEBUG PluginManager 'Converter' found 45 plugins 2022-01-06 14:35:45,185 main DEBUG Starting OutputStreamManager SYSTEM_OUT.false.false-2 2022-01-06 14:35:45,203 main DEBUG Starting RollingRandomAccessFileManager /pulsar-logs-root/ace/ace.jsonl 2022-01-06 14:35:45,208 main DEBUG PluginManager 'FileConverter' found 2 plugins 2022-01-06 14:35:45,237 main DEBUG Setting prev file time to 2022-01-06T14:35:45.195+0000 2022-01-06 14:35:45,238 main DEBUG Initializing triggering policy CompositeTriggeringPolicy(policies=[OnStartupTriggeringPolicy, SizeBasedTriggeringPolicy(size=10485760), TimeBasedTriggeringPolicy(nextRolloverMillis=0, interval=1, modulate=false)]) 2022-01-06 14:35:45,238 main DEBUG Initializing triggering policy OnStartupTriggeringPolicy 2022-01-06 14:35:45,239 main DEBUG Initializing triggering policy SizeBasedTriggeringPolicy(size=10485760) 2022-01-06 14:35:45,239 main DEBUG Initializing triggering policy TimeBasedTriggeringPolicy(nextRolloverMillis=0, interval=1, modulate=false) 2022-01-06 14:35:45,241 main DEBUG Building Plugin[name=OnStartupTriggeringPolicy, class=org.apache.logging.log4j.core.appender.rolling.OnStartupTriggeringPolicy]. 2022-01-06 14:35:45,242 main DEBUG createPolicy(minSize="1") 2022-01-06 14:35:45,242 main DEBUG Building Plugin[name=SizeBasedTriggeringPolicy, class=org.apache.logging.log4j.core.appender.rolling.SizeBasedTriggeringPolicy]. 2022-01-06 14:35:45,243 main DEBUG createPolicy(size="10MB") 2022-01-06 14:35:45,243 main DEBUG Building Plugin[name=TimeBasedTriggeringPolicy, class=org.apache.logging.log4j.core.appender.rolling.TimeBasedTriggeringPolicy]. 2022-01-06 14:35:45,245 main DEBUG TimeBasedTriggeringPolicy$Builder(interval="null", modulate="null", maxRandomDelay="null") 2022-01-06 14:35:45,245 main DEBUG Building Plugin[name=Policies, class=org.apache.logging.log4j.core.appender.rolling.CompositeTriggeringPolicy]. 2022-01-06 14:35:45,246 main DEBUG createPolicy(={OnStartupTriggeringPolicy, SizeBasedTriggeringPolicy(size=10485760), TimeBasedTriggeringPolicy(nextRolloverMillis=0, interval=1, modulate=false)}) 2022-01-06 14:35:45,246 main DEBUG Building Plugin[name=DefaultRolloverStrategy, class=org.apache.logging.log4j.core.appender.rolling.DefaultRolloverStrategy]. 2022-01-06 14:35:45,247 main DEBUG DefaultRolloverStrategy$Builder(max="10000", min="null", fileIndex="null", compressionLevel="null", ={}, stopCustomActionsOnError="null", tempCompressedFilePattern="null", Configuration(jar:file:/usr/local/xxx/ace.jar!/log4j2.xml)) 2022-01-06 14:35:45,247 main DEBUG Building Plugin[name=layout, class=org.apache.logging.log4j.core.layout.PatternLayout]. 2022-01-06 14:35:45,249 main DEBUG PatternLayout$Builder(pattern="%msg%n", PatternSelector=null, Configuration(jar:file:/usr/local/xxx/ace.jar!/log4j2.xml), Replace=null, charset="null", alwaysWriteExceptions="null", disableAnsi="null", noConsoleNoAnsi="null", header="null", footer="null") 2022-01-06 14:35:45,249 main DEBUG Building Plugin[name=appender, class=org.apache.logging.log4j.core.appender.RollingRandomAccessFileAppender]. 2022-01-06 14:35:45,251 main DEBUG RollingRandomAccessFileAppender$Builder(fileName="/pulsar-logs-root/ace/ace-metrics.jsonl", filePattern="/pulsar-logs-root/ace/ace-metrics-%d{yyyyMMddHHmm}.%i.jsonl", append="null", Policies(CompositeTriggeringPolicy(policies=[OnStartupTriggeringPolicy, SizeBasedTriggeringPolicy(size=10485760), TimeBasedTriggeringPolicy(nextRolloverMillis=0, interval=1, modulate=false)])), DefaultRolloverStrategy(DefaultRolloverStrategy(min=1, max=10000, useMax=true)), advertise="null", advertiseURI="null", filePermissions="null", fileOwner="null", fileGroup="null", bufferedIo="null", bufferSize="null", immediateFlush="null", ignoreExceptions="null", PatternLayout(%msg%n), name="RollingFileMetrics", Configuration(jar:file:/usr/local/xxx/ace.jar!/log4j2.xml), Filter=null, ={}) 2022-01-06 14:35:45,258 main DEBUG Starting RollingRandomAccessFileManager /pulsar-logs-root/ace/ace-metrics.jsonl 2022-01-06 14:35:45,258 main DEBUG PluginManager 'FileConverter' found 2 plugins 2022-01-06 14:35:45,259 main DEBUG Setting prev file time to 2022-01-06T14:35:45.251+0000 2022-01-06 14:35:45,259 main DEBUG Initializing triggering policy CompositeTriggeringPolicy(policies=[OnStartupTriggeringPolicy, SizeBasedTriggeringPolicy(size=10485760), TimeBasedTriggeringPolicy(nextRolloverMillis=0, interval=1, modulate=false)]) 2022-01-06 14:35:45,260 main DEBUG Initializing triggering policy OnStartupTriggeringPolicy 2022-01-06 14:35:45,260 main DEBUG Initializing triggering policy SizeBasedTriggeringPolicy(size=10485760) 2022-01-06 14:35:45,260 main DEBUG Initializing triggering policy TimeBasedTriggeringPolicy(nextRolloverMillis=0, interval=1, modulate=false) 2022-01-06 14:35:45,262 main DEBUG Building Plugin[name=OnStartupTriggeringPolicy, class=org.apache.logging.log4j.core.appender.rolling.OnStartupTriggeringPolicy]. 2022-01-06 14:35:45,262 main DEBUG createPolicy(minSize="1") 2022-01-06 14:35:45,262 main DEBUG Building Plugin[name=SizeBasedTriggeringPolicy, class=org.apache.logging.log4j.core.appender.rolling.SizeBasedTriggeringPolicy]. 2022-01-06 14:35:45,263 main DEBUG createPolicy(size="10MB") 2022-01-06 14:35:45,263 main DEBUG Building Plugin[name=TimeBasedTriggeringPolicy, class=org.apache.logging.log4j.core.appender.rolling.TimeBasedTriggeringPolicy]. 2022-01-06 14:35:45,264 main DEBUG TimeBasedTriggeringPolicy$Builder(interval="null", modulate="null", maxRandomDelay="null") 2022-01-06 14:35:45,264 main DEBUG Building Plugin[name=Policies, class=org.apache.logging.log4j.core.appender.rolling.CompositeTriggeringPolicy]. 2022-01-06 14:35:45,265 main DEBUG createPolicy(={OnStartupTriggeringPolicy, SizeBasedTriggeringPolicy(size=10485760), TimeBasedTriggeringPolicy(nextRolloverMillis=0, interval=1, modulate=false)}) 2022-01-06 14:35:45,265 main DEBUG Building Plugin[name=DefaultRolloverStrategy, class=org.apache.logging.log4j.core.appender.rolling.DefaultRolloverStrategy]. 2022-01-06 14:35:45,266 main DEBUG DefaultRolloverStrategy$Builder(max="10000", min="null", fileIndex="null", compressionLevel="null", ={}, stopCustomActionsOnError="null", tempCompressedFilePattern="null", Configuration(jar:file:/usr/local/xxx/ace.jar!/log4j2.xml)) 2022-01-06 14:35:45,266 main DEBUG Building Plugin[name=layout, class=org.apache.logging.log4j.core.layout.PatternLayout]. 2022-01-06 14:35:45,268 main DEBUG PatternLayout$Builder(pattern="%msg%n", PatternSelector=null, Configuration(jar:file:/usr/local/xxx/ace.jar!/log4j2.xml), Replace=null, charset="null", alwaysWriteExceptions="null", disableAnsi="null", noConsoleNoAnsi="null", header="null", footer="null") 2022-01-06 14:35:45,268 main DEBUG Building Plugin[name=appender, class=org.apache.logging.log4j.core.appender.RollingFileAppender]. 2022-01-06 14:35:45,272 main DEBUG RollingFileAppender$Builder(fileName="/pulsar-logs-root/ace/ace-health.jsonl", filePattern="/pulsar-logs-root/ace/ace-health-%d{yyyyMMddHHmm}.%i.jsonl", append="null", locking="null", Policies(CompositeTriggeringPolicy(policies=[OnStartupTriggeringPolicy, SizeBasedTriggeringPolicy(size=10485760), TimeBasedTriggeringPolicy(nextRolloverMillis=0, interval=1, modulate=false)])), DefaultRolloverStrategy(DefaultRolloverStrategy(min=1, max=10000, useMax=true)), advertise="null", advertiseUri="null", createOnDemand="null", filePermissions="null", fileOwner="null", fileGroup="null", bufferedIo="null", bufferSize="null", immediateFlush="null", ignoreExceptions="null", PatternLayout(%msg%n), name="RollingFileHealth", Configuration(jar:file:/usr/local/xxx/ace.jar!/log4j2.xml), Filter=null, ={}) 2022-01-06 14:35:45,286 main DEBUG Returning file creation time for /pulsar-logs-root/ace/ace-health.jsonl 2022-01-06 14:35:45,288 main DEBUG Starting RollingFileManager /pulsar-logs-root/ace/ace-health.jsonl 2022-01-06 14:35:45,288 main DEBUG PluginManager 'FileConverter' found 2 plugins 2022-01-06 14:35:45,289 main DEBUG Setting prev file time to 2022-01-06T14:35:38.000+0000 2022-01-06 14:35:45,289 main DEBUG Initializing triggering policy CompositeTriggeringPolicy(policies=[OnStartupTriggeringPolicy, SizeBasedTriggeringPolicy(size=10485760), TimeBasedTriggeringPolicy(nextRolloverMillis=0, interval=1, modulate=false)]) 2022-01-06 14:35:45,290 main DEBUG Initializing triggering policy OnStartupTriggeringPolicy 2022-01-06 14:35:45,290 main DEBUG Initializing triggering policy SizeBasedTriggeringPolicy(size=10485760) 2022-01-06 14:35:45,291 main DEBUG Initializing triggering policy TimeBasedTriggeringPolicy(nextRolloverMillis=0, interval=1, modulate=false) 2022-01-06 14:35:45,292 main DEBUG Building Plugin[name=OnStartupTriggeringPolicy, class=org.apache.logging.log4j.core.appender.rolling.OnStartupTriggeringPolicy]. 2022-01-06 14:35:45,293 main DEBUG createPolicy(minSize="1") 2022-01-06 14:35:45,293 main DEBUG Building Plugin[name=SizeBasedTriggeringPolicy, class=org.apache.logging.log4j.core.appender.rolling.SizeBasedTriggeringPolicy]. 2022-01-06 14:35:45,294 main DEBUG createPolicy(size="10MB") 2022-01-06 14:35:45,294 main DEBUG Building Plugin[name=TimeBasedTriggeringPolicy, class=org.apache.logging.log4j.core.appender.rolling.TimeBasedTriggeringPolicy]. 2022-01-06 14:35:45,295 main DEBUG TimeBasedTriggeringPolicy$Builder(interval="null", modulate="null", maxRandomDelay="null") 2022-01-06 14:35:45,296 main DEBUG Building Plugin[name=Policies, class=org.apache.logging.log4j.core.appender.rolling.CompositeTriggeringPolicy]. 2022-01-06 14:35:45,296 main DEBUG createPolicy(={OnStartupTriggeringPolicy, SizeBasedTriggeringPolicy(size=10485760), TimeBasedTriggeringPolicy(nextRolloverMillis=0, interval=1, modulate=false)}) 2022-01-06 14:35:45,297 main DEBUG Building Plugin[name=DefaultRolloverStrategy, class=org.apache.logging.log4j.core.appender.rolling.DefaultRolloverStrategy]. 2022-01-06 14:35:45,297 main DEBUG DefaultRolloverStrategy$Builder(max="10000", min="null", fileIndex="null", compressionLevel="null", ={}, stopCustomActionsOnError="null", tempCompressedFilePattern="null", Configuration(jar:file:/usr/local/xxx/ace.jar!/log4j2.xml)) 2022-01-06 14:35:45,298 main DEBUG Building Plugin[name=layout, class=org.apache.logging.log4j.core.layout.PatternLayout]. 2022-01-06 14:35:45,299 main DEBUG PatternLayout$Builder(pattern="%msg%n", PatternSelector=null, Configuration(jar:file:/usr/local/xxx/ace.jar!/log4j2.xml), Replace=null, charset="null", alwaysWriteExceptions="null", disableAnsi="null", noConsoleNoAnsi="null", header="null", footer="null") 2022-01-06 14:35:45,299 main DEBUG Building Plugin[name=appender, class=org.apache.logging.log4j.core.appender.RollingRandomAccessFileAppender]. 2022-01-06 14:35:45,300 main DEBUG RollingRandomAccessFileAppender$Builder(fileName="/pulsar-logs-root/ace/zipkin.jsonl", filePattern="/pulsar-logs-root/ace/zipkin-%d{yyyyMMddHHmm}.%i.jsonl", append="null", Policies(CompositeTriggeringPolicy(policies=[OnStartupTriggeringPolicy, SizeBasedTriggeringPolicy(size=10485760), TimeBasedTriggeringPolicy(nextRolloverMillis=0, interval=1, modulate=false)])), DefaultRolloverStrategy(DefaultRolloverStrategy(min=1, max=10000, useMax=true)), advertise="null", advertiseURI="null", filePermissions="null", fileOwner="null", fileGroup="null", bufferedIo="null", bufferSize="null", immediateFlush="null", ignoreExceptions="null", PatternLayout(%msg%n), name="RollingFileTraces", Configuration(jar:file:/usr/local/xxx/ace.jar!/log4j2.xml), Filter=null, ={}) 2022-01-06 14:35:45,308 main DEBUG Starting RollingRandomAccessFileManager /pulsar-logs-root/ace/zipkin.jsonl 2022-01-06 14:35:45,309 main DEBUG PluginManager 'FileConverter' found 2 plugins 2022-01-06 14:35:45,310 main DEBUG Setting prev file time to 2022-01-06T14:35:45.301+0000 2022-01-06 14:35:45,310 main DEBUG Initializing triggering policy CompositeTriggeringPolicy(policies=[OnStartupTriggeringPolicy, SizeBasedTriggeringPolicy(size=10485760), TimeBasedTriggeringPolicy(nextRolloverMillis=0, interval=1, modulate=false)]) 2022-01-06 14:35:45,311 main DEBUG Initializing triggering policy OnStartupTriggeringPolicy 2022-01-06 14:35:45,311 main DEBUG Initializing triggering policy SizeBasedTriggeringPolicy(size=10485760) 2022-01-06 14:35:45,312 main DEBUG Initializing triggering policy TimeBasedTriggeringPolicy(nextRolloverMillis=0, interval=1, modulate=false) 2022-01-06 14:35:45,313 main DEBUG Building Plugin[name=appenders, class=org.apache.logging.log4j.core.config.AppendersPlugin]. 2022-01-06 14:35:45,314 main DEBUG createAppenders(={Console, RollingFileJson, RollingFileMetrics, RollingFileHealth, RollingFileTraces}) 2022-01-06 14:35:45,315 main DEBUG Building Plugin[name=AppenderRef, class=org.apache.logging.log4j.core.config.AppenderRef]. 2022-01-06 14:35:45,316 main DEBUG createAppenderRef(ref="RollingFileJson", level="null", Filter=null) 2022-01-06 14:35:45,316 main DEBUG Building Plugin[name=AppenderRef, class=org.apache.logging.log4j.core.config.AppenderRef]. 2022-01-06 14:35:45,317 main DEBUG createAppenderRef(ref="Console", level="null", Filter=null) 2022-01-06 14:35:45,317 main DEBUG Building Plugin[name=root, class=org.apache.logging.log4j.core.config.LoggerConfig$RootLogger]. 2022-01-06 14:35:45,320 main DEBUG createLogger(additivity="null", level="ERROR", includeLocation="null", ={RollingFileJson, Console}, ={}, Configuration(jar:file:/usr/local/xxx/ace.jar!/log4j2.xml), Filter=null) 2022-01-06 14:35:45,324 main DEBUG Building Plugin[name=AppenderRef, class=org.apache.logging.log4j.core.config.AppenderRef]. 2022-01-06 14:35:45,325 main DEBUG createAppenderRef(ref="RollingFileMetrics", level="null", Filter=null) 2022-01-06 14:35:45,325 main DEBUG Building Plugin[name=logger, class=org.apache.logging.log4j.core.config.LoggerConfig]. 2022-01-06 14:35:45,330 main DEBUG createLogger(additivity="false", level="INFO", name="metrics", includeLocation="null", ={RollingFileMetrics}, ={}, Configuration(jar:file:/usr/local/xxx/ace.jar!/log4j2.xml), Filter=null) 2022-01-06 14:35:45,330 main DEBUG Building Plugin[name=AppenderRef, class=org.apache.logging.log4j.core.config.AppenderRef]. 2022-01-06 14:35:45,331 main DEBUG createAppenderRef(ref="RollingFileHealth", level="null", Filter=null) 2022-01-06 14:35:45,331 main DEBUG Building Plugin[name=logger, class=org.apache.logging.log4j.core.config.LoggerConfig]. 2022-01-06 14:35:45,333 main DEBUG createLogger(additivity="false", level="INFO", name="health", includeLocation="null", ={RollingFileHealth}, ={}, Configuration(jar:file:/usr/local/xxx/ace.jar!/log4j2.xml), Filter=null) 2022-01-06 14:35:45,333 main DEBUG Building Plugin[name=logger, class=org.apache.logging.log4j.core.config.LoggerConfig]. 2022-01-06 14:35:45,334 main DEBUG createLogger(additivity="true", level="DEBUG", name="com.xxxx.portal.ace", includeLocation="null", ={}, ={}, Configuration(jar:file:/usr/local/xxx/ace.jar!/log4j2.xml), Filter=null) 2022-01-06 14:35:45,334 main DEBUG Building Plugin[name=logger, class=org.apache.logging.log4j.core.config.LoggerConfig]. 2022-01-06 14:35:45,336 main DEBUG createLogger(additivity="true", level="WARN", name="com.xxxx.ids", includeLocation="null", ={}, ={}, Configuration(jar:file:/usr/local/xxx/ace.jar!/log4j2.xml), Filter=null) 2022-01-06 14:35:45,336 main DEBUG Building Plugin[name=logger, class=org.apache.logging.log4j.core.config.LoggerConfig]. 2022-01-06 14:35:45,337 main DEBUG createLogger(additivity="true", level="DEBUG", name="org.apache.dbcp", includeLocation="null", ={}, ={}, Configuration(jar:file:/usr/local/xxx/ace.jar!/log4j2.xml), Filter=null) 2022-01-06 14:35:45,337 main DEBUG Building Plugin[name=logger, class=org.apache.logging.log4j.core.config.LoggerConfig]. 2022-01-06 14:35:45,339 main DEBUG createLogger(additivity="true", level="DEBUG", name="org.apache.commons.dbcp2", includeLocation="null", ={}, ={}, Configuration(jar:file:/usr/local/xxxx/ace.jar!/log4j2.xml), Filter=null) 2022-01-06 14:35:45,340 main DEBUG Building Plugin[name=logger, class=org.apache.logging.log4j.core.config.LoggerConfig]. 2022-01-06 14:35:45,341 main DEBUG createLogger(additivity="true", level="INFO", name="com.xxxx.provisioning.metrics.PtkTimer", includeLocation="null", ={}, ={}, Configuration(jar:file:/usr/local/xxxx/ace.jar!/log4j2.xml), Filter=null) 2022-01-06 14:35:45,341 main DEBUG Building Plugin[name=logger, class=org.apache.logging.log4j.core.config.LoggerConfig]. 2022-01-06 14:35:45,342 main DEBUG createLogger(additivity="true", level="TRACE", name="com.xxxx.portal.ace.dao.ActivationDAO", includeLocation="null", ={}, ={}, Configuration(jar:file:/usr/local/xxxx/ace.jar!/log4j2.xml), Filter=null) 2022-01-06 14:35:45,343 main DEBUG Building Plugin[name=loggers, class=org.apache.logging.log4j.core.config.LoggersPlugin]. 2022-01-06 14:35:45,344 main DEBUG createLoggers(={root, metrics, health, com.xxxx.portal.ace, com.xxxx.ids, org.apache.dbcp, org.apache.commons.dbcp2, com.xxxx.provisioning.metrics.PtkTimer, com.xxxx.portal.ace.dao.ActivationDAO}) 2022-01-06 14:35:45,355 main DEBUG Configuration XmlConfiguration[location=jar:file:/usr/local/xxxx/ace.jar!/log4j2.xml] initialized 2022-01-06 14:35:45,355 main DEBUG Starting configuration XmlConfiguration[location=jar:file:/usr/local/xxxx/ace.jar!/log4j2.xml] 2022-01-06 14:35:45,357 main DEBUG Log4j2 ConfigurationScheduler starting 1 threads 2022-01-06 14:35:45,362 main DEBUG Started configuration XmlConfiguration[location=jar:file:/usr/local/xxxxx/ace.jar!/log4j2.xml] OK. 2022-01-06 14:35:45,363 main DEBUG Shutting down OutputStreamManager SYSTEM_OUT.false.false-1 2022-01-06 14:35:45,363 main DEBUG OutputStream closed 2022-01-06 14:35:45,363 main DEBUG Shut down OutputStreamManager SYSTEM_OUT.false.false-1, all resources released: true 2022-01-06 14:35:45,364 main DEBUG Appender DefaultConsole-1 stopped with status true 2022-01-06 14:35:45,364 main DEBUG Stopped org.apache.logging.log4j.core.config.DefaultConfiguration@3bf7ca37 OK 2022-01-06 14:35:45,371 main DEBUG Registering MBean org.apache.logging.log4j2:type=18b4aac2 2022-01-06 14:35:45,376 main DEBUG Registering MBean org.apache.logging.log4j2:type=18b4aac2,component=StatusLogger 2022-01-06 14:35:45,379 main DEBUG Registering MBean org.apache.logging.log4j2:type=18b4aac2,component=ContextSelector 2022-01-06 14:35:45,381 main DEBUG Registering MBean org.apache.logging.log4j2:type=18b4aac2,component=Loggers,name= 2022-01-06 14:35:45,382 main DEBUG Registering MBean org.apache.logging.log4j2:type=18b4aac2,component=Loggers,name=org.apache.commons.dbcp2 2022-01-06 14:35:45,382 main DEBUG Registering MBean org.apache.logging.log4j2:type=18b4aac2,component=Loggers,name=health 2022-01-06 14:35:45,383 main DEBUG Registering MBean org.apache.logging.log4j2:type=18b4aac2,component=Loggers,name=com.xxxx.ids 2022-01-06 14:35:45,383 main DEBUG Registering MBean org.apache.logging.log4j2:type=18b4aac2,component=Loggers,name=com.xxxx.portal.ace.dao.ActivationDAO 2022-01-06 14:35:45,384 main DEBUG Registering MBean org.apache.logging.log4j2:type=18b4aac2,component=Loggers,name=com.xxxx.provisioning.metrics.PtkTimer 2022-01-06 14:35:45,384 main DEBUG Registering MBean org.apache.logging.log4j2:type=18b4aac2,component=Loggers,name=metrics 2022-01-06 14:35:45,385 main DEBUG Registering MBean org.apache.logging.log4j2:type=18b4aac2,component=Loggers,name=com.xxxx.portal.ace 2022-01-06 14:35:45,386 main DEBUG Registering MBean org.apache.logging.log4j2:type=18b4aac2,component=Loggers,name=org.apache.dbcp 2022-01-06 14:35:45,388 main DEBUG Registering MBean org.apache.logging.log4j2:type=18b4aac2,component=Appenders,name=Console 2022-01-06 14:35:45,389 main DEBUG Registering MBean org.apache.logging.log4j2:type=18b4aac2,component=Appenders,name=RollingFileHealth 2022-01-06 14:35:45,389 main DEBUG Registering MBean org.apache.logging.log4j2:type=18b4aac2,component=Appenders,name=RollingFileTraces 2022-01-06 14:35:45,390 main DEBUG Registering MBean org.apache.logging.log4j2:type=18b4aac2,component=Appenders,name=RollingFileMetrics 2022-01-06 14:35:45,390 main DEBUG Registering MBean org.apache.logging.log4j2:type=18b4aac2,component=Appenders,name=RollingFileJson 2022-01-06 14:35:45,395 main DEBUG org.apache.logging.log4j.core.util.SystemClock does not support precise timestamps. 2022-01-06 14:35:45,396 main DEBUG Reconfiguration complete for context[name=18b4aac2] at URI jar:file:/usr/local/xxxx/ace.jar!/log4j2.xml (org.apache.logging.log4j.core.LoggerContext@c35172e) with optional ClassLoader: null 2022-01-06 14:35:45,396 main DEBUG Shutdown hook enabled. Registering a new one. 2022-01-06 14:35:45,398 main DEBUG LoggerContext[name=18b4aac2, org.apache.logging.log4j.core.LoggerContext@c35172e] started OK.