-
Bug
-
Resolution: Done
-
Highest
-
None
-
None
-
None
Env
OOM release-1.1.0 up to commit f730de57d22ecd618a71b6efa7e1558ccc0771da
HEAT as per as http://onap.readthedocs.io/en/latest/guides/onap-developer/settingup/fullonap.html#deployment
Assumption
In the bellow defect, "atcual" refers to the OOM setup, "excepted" refers to the HEAT setup. Assumption is made that HEAT holds the truth wrt the expected behaviour.
Defects
MySQL
Actual:
MariaDB [mso_catalog]> select * from service; 3 rows in set (0.00 sec)
MariaDB [mso_catalog]> select * from service_recipe; 4 rows in set (0.01 sec)
MariaDB [mso_catalog]> select * from vnf_components_recipe; 15 rows in set (0.00 sec)
Expected
MariaDB [mso_catalog]> select * from service; 4 rows in set (0.01 sec)
MariaDB [mso_catalog]> select * from service_recipe; 6 rows in set (0.00 sec)
MariaDB [mso_catalog]> select * from vnf_components_recipe; 12 rows in set (0.00 sec)
mso-docker.json
Some mso-docker.json paramaters (most notably adaptersOpenecompDbEndpoint) as expected to be there, but are missing, hence the Chef Recipe fails early.
This results in no overidden configuration in MSO, hence unusable.
================================================================================ Recipe Compile Error in /var/berks-cookbooks/chef-repo/local-mode-cache/cache/cookbooks/mso-config/attributes/topology.rb ================================================================================ URI::BadURIError ---------------- both URI are relative Cookbook Trace: --------------- /var/berks-cookbooks/chef-repo/local-mode-cache/cache/cookbooks/mso-config/attributes/topology.rb:5:in `from_file' Relevant File Content: ---------------------- /var/berks-cookbooks/chef-repo/local-mode-cache/cache/cookbooks/mso-config/attributes/topology.rb: 1: require 'uri' 2: ###################### 3: # MSO Config Path 4: ########## 5>> node.default["mso-config"]["topology"]["apih-load-balancer"] = URI.join(node["mso-bpmn-urn-config"]["adaptersOpenecompDbEndpoint"], "/").to_s 6: node.default["mso-config"]["topology"]["jra-load-balancer"] = URI.join(node["mso-bpmn-urn-config"]["adaptersSdncEndpoint"], "/").to_s 7: node.default["mso-config"]["topology"]["camunda-load-balancer"] = URI.join(node["mso-api-handler-infra-config"]["camundaURL"], "/").to_s 8: 9: node.default["mso-config"]["topology"]["site-name"] = node.chef_environment 10: node.default["mso-config"]["topology"]["server-port"] = "8080" 11: node.default["mso-config"]["topology"]["ssl-enable"] = "false" 12: node.default["mso-config"]["topology"]["msb-server-ip"] = "127.0.0.1" 13: node.default["mso-config"]["topology"]["msb-server-port"] = "8080" 14: node.default["mso-config"]["topology"]["sdnc-server-ip"] = "172.30.3.38"
ASDC
mso-docker.json provides two ASDC configs, where in reality, only one is accurate, the other one is bogus, this results in ASDC error.log being spam as follow:
2017-11-27T13:44:30.063Z|trace-#|EJB default - 10|InitASDC||ASDC||WARN|BusinessProcesssError|ASDCControllerException in checkInStoppedState|MSO-ASDC-5314W ASDControllerException caught during the Init/closing of ASDC Client with address Unknown and environment Unknown 2017-11-27T13:44:30.063Z|trace-#|EJB default - 10|InitASDC||ASDC||WARN|BusinessProcesssError|ASDCControllerException in checkInStoppedState|Exception raised: org.openecomp.mso.asdc.client.exceptions.ASDCControllerException: Initialization of the ASDC Controller failed with reason: configuration is invalid: CONF_INVALID_ASDC_FQDN - at org.openecomp.mso.asdc.client.ASDCController.initASDC(ASDCController.java:237) - at org.openecomp.mso.asdc.client.ASDCGlobalController.checkInStoppedState(ASDCGlobalController.java:130) - at org.openecomp.mso.asdc.ASDCControllerSingleton.periodicControllerTask(ASDCControllerSingleton.java:63) - at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) - at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) - at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) - at java.lang.reflect.Method.invoke(Method.java:498) - at org.jboss.as.ee.component.ManagedReferenceMethodInterceptor.processInvocation(ManagedReferenceMethodInterceptor.java:52) - at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:340) - at org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:57) - at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:61) - at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:340) - at org.jboss.invocation.InterceptorContext$Invocation.proceed(InterceptorContext.java:437) - at org.jboss.as.weld.ejb.Jsr299BindingsInterceptor.doMethodInterception(Jsr299BindingsInterceptor.java:82) - at org.jboss.as.weld.ejb.Jsr299BindingsInterceptor.processInvocation(Jsr299BindingsInterceptor.java:95) - at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:61) - at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:340) - at org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:57) - at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:61) - at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:340) - at org.jboss.as.ejb3.component.invocationmetrics.ExecutionTimeInterceptor.processInvocation(ExecutionTimeInterceptor.java:43) - at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:340) - at org.jboss.invocation.InterceptorContext$Invocation.proceed(InterceptorContext.java:437) - at org.jboss.weld.ejb.AbstractEJBRequestScopeActivationInterceptor.aroundInvoke(AbstractEJBRequestScopeActivationInterceptor.java:73) - at org.jboss.as.weld.ejb.EjbRequestScopeActivationInterceptor.processInvocation(EjbRequestScopeActivationInterceptor.java:83) - at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:340) - at org.jboss.as.ee.concurrent.ConcurrentContextInterceptor.processInvocation(ConcurrentContextInterceptor.java:45) - at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:340) - at org.jboss.invocation.InitialInterceptor.processInvocation(InitialInterceptor.java:21) - at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:340) - at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61) - at org.jboss.as.ee.component.interceptors.ComponentDispatcherInterceptor.processInvocation(ComponentDispatcherInterceptor.java:52) - at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:340) - at org.jboss.as.ejb3.component.singleton.SingletonComponentInstanceAssociationInterceptor.processInvocation(SingletonComponentInstanceAssociationInterceptor.java:53) - at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:340) - at org.jboss.as.ejb3.tx.CMTTxInterceptor.invokeInOurTx(CMTTxInterceptor.java:275) - at org.jboss.as.ejb3.tx.CMTTxInterceptor.required(CMTTxInterceptor.java:327) - at org.jboss.as.ejb3.tx.CMTTxInterceptor.processInvocation(CMTTxInterceptor.java:239) - at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:340) - at org.jboss.as.ejb3.component.interceptors.CurrentInvocationContextInterceptor.processInvocation(CurrentInvocationContextInterceptor.java:41) - at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:340) - at org.jboss.as.ejb3.security.SecurityContextInterceptor.processInvocation(SecurityContextInterceptor.java:100) - at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:340) - at org.jboss.invocation.InterceptorContext$Invocation.proceed(InterceptorContext.java:437) - at org.jboss.as.ejb3.concurrency.ContainerManagedConcurrencyInterceptor.processInvocation(ContainerManagedConcurrencyInterceptor.java:110) - at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:340) - at org.jboss.as.ejb3.component.interceptors.ShutDownInterceptorFactory$1.processInvocation(ShutDownInterceptorFactory.java:64) - at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:340) - at org.jboss.as.ee.component.NamespaceContextInterceptor.processInvocation(NamespaceContextInterceptor.java:50) - at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:340) - at org.jboss.as.ejb3.component.interceptors.AdditionalSetupInterceptor.processInvocation(AdditionalSetupInterceptor.java:54) - at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:340) - at org.jboss.invocation.ContextClassLoaderInterceptor.processInvocation(ContextClassLoaderInterceptor.java:64) - at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:340) - at org.jboss.invocation.InterceptorContext.run(InterceptorContext.java:356) - at org.wildfly.security.manager.WildFlySecurityManager.doChecked(WildFlySecurityManager.java:636) - at org.jboss.invocation.AccessCheckingInterceptor.processInvocation(AccessCheckingInterceptor.java:61) - at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:340) - at org.jboss.invocation.InterceptorContext.run(InterceptorContext.java:356) - at org.jboss.invocation.PrivilegedWithCombinerInterceptor.processInvocation(PrivilegedWithCombinerInterceptor.java:80) - at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:340) - at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61) - at org.jboss.as.ejb3.timerservice.TimedObjectInvokerImpl.callTimeout(TimedObjectInvokerImpl.java:99) - at org.jboss.as.ejb3.timerservice.CalendarTimerTask.invokeBeanMethod(CalendarTimerTask.java:64) - at org.jboss.as.ejb3.timerservice.CalendarTimerTask.callTimeout(CalendarTimerTask.java:53) - at org.jboss.as.ejb3.timerservice.TimerTask.run(TimerTask.java:157) - at org.jboss.as.ejb3.timerservice.TimerServiceImpl$Task$1.run(TimerServiceImpl.java:1215) - at org.wildfly.extension.requestcontroller.RequestController$QueuedTask$1.run(RequestController.java:497) - at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) - at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) - at java.lang.Thread.run(Thread.java:748) - at org.jboss.threads.JBossThread.run(JBossThread.java:320) -
Removing the unwanted ASDC configuration fixes this.
Logging
Considering all of the above is fixed, we're facing this issue:
13:48:48,989 INFO [stdout] (ServerService Thread Pool -- 91) at java.lang.IllegalArgumentException: Illegal pattern character 'q' 13:48:48,992 INFO [stdout] (ServerService Thread Pool -- 91) at at java.text.SimpleDateFormat.compile(SimpleDateFormat.java:826) 13:48:49,000 INFO [stdout] (ServerService Thread Pool -- 91) at at java.text.SimpleDateFormat.initialize(SimpleDateFormat.java:634) 13:48:49,000 INFO [stdout] (ServerService Thread Pool -- 91) at at java.text.SimpleDateFormat.<init>(SimpleDateFormat.java:605) 13:48:49,000 INFO [stdout] (ServerService Thread Pool -- 91) at at java.text.SimpleDateFormat.<init>(SimpleDateFormat.java:580) 13:48:49,000 INFO [stdout] (ServerService Thread Pool -- 91) at at ch.qos.logback.core.util.CachingDateFormatter.<init>(CachingDateFormatter.java:34) 13:48:49,001 INFO [stdout] (ServerService Thread Pool -- 91) at at ch.qos.logback.classic.pattern.DateConverter.start(DateConverter.java:42) 13:48:49,001 INFO [stdout] (ServerService Thread Pool -- 91) at at ch.qos.logback.core.pattern.ConverterUtil.startConverters(ConverterUtil.java:37) 13:48:49,001 INFO [stdout] (ServerService Thread Pool -- 91) at at ch.qos.logback.core.pattern.PatternLayoutBase.start(PatternLayoutBase.java:91) 13:48:49,001 INFO [stdout] (ServerService Thread Pool -- 91) at at ch.qos.logback.classic.encoder.PatternLayoutEncoder.start(PatternLayoutEncoder.java:28) 13:48:49,001 INFO [stdout] (ServerService Thread Pool -- 91) at at ch.qos.logback.core.joran.action.NestedComplexPropertyIA.end(NestedComplexPropertyIA.java:167) 13:48:49,001 INFO [stdout] (ServerService Thread Pool -- 91) at at ch.qos.logback.core.joran.spi.Interpreter.callEndAction(Interpreter.java:317) 13:48:49,001 INFO [stdout] (ServerService Thread Pool -- 91) at at ch.qos.logback.core.joran.spi.Interpreter.endElement(Interpreter.java:196) 13:48:49,001 INFO [stdout] (ServerService Thread Pool -- 91) at at ch.qos.logback.core.joran.spi.Interpreter.endElement(Interpreter.java:182) 13:48:49,002 INFO [stdout] (ServerService Thread Pool -- 91) at at ch.qos.logback.core.joran.spi.EventPlayer.play(EventPlayer.java:62) 13:48:49,002 INFO [stdout] (ServerService Thread Pool -- 91) at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:149) 13:48:49,002 INFO [stdout] (ServerService Thread Pool -- 91) at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:135) 13:48:49,002 INFO [stdout] (ServerService Thread Pool -- 91) at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:99) 13:48:49,002 INFO [stdout] (ServerService Thread Pool -- 91) at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:76) 13:48:49,002 INFO [stdout] (ServerService Thread Pool -- 91) at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:68) 13:48:49,010 INFO [stdout] (ServerService Thread Pool -- 91) at at org.openecomp.mso.logger.MsoLogInitializer.contextInitialized(MsoLogInitializer.java:91) 13:48:49,010 INFO [stdout] (ServerService Thread Pool -- 91) at at io.undertow.servlet.core.ApplicationListeners.contextInitialized(ApplicationListeners.java:187) 13:48:49,010 INFO [stdout] (ServerService Thread Pool -- 91) at at io.undertow.servlet.core.DeploymentManagerImpl$1.call(DeploymentManagerImpl.java:200) 13:48:49,010 INFO [stdout] (ServerService Thread Pool -- 91) at at io.undertow.servlet.core.DeploymentManagerImpl$1.call(DeploymentManagerImpl.java:171) 13:48:49,010 INFO [stdout] (ServerService Thread Pool -- 91) at at io.undertow.servlet.core.ServletRequestContextThreadSetupAction$1.call(ServletRequestContextThreadSetupAction.java:42) 13:48:49,010 INFO [stdout] (ServerService Thread Pool -- 91) at at io.undertow.servlet.core.ContextClassLoaderSetupAction$1.call(ContextClassLoaderSetupAction.java:43) 13:48:49,010 INFO [stdout] (ServerService Thread Pool -- 91) at at io.undertow.servlet.api.LegacyThreadSetupActionWrapper$1.call(LegacyThreadSetupActionWrapper.java:44) 13:48:49,011 INFO [stdout] (ServerService Thread Pool -- 91) at at io.undertow.servlet.api.LegacyThreadSetupActionWrapper$1.call(LegacyThreadSetupActionWrapper.java:44) 13:48:49,011 INFO [stdout] (ServerService Thread Pool -- 91) at at io.undertow.servlet.api.LegacyThreadSetupActionWrapper$1.call(LegacyThreadSetupActionWrapper.java:44) 13:48:49,011 INFO [stdout] (ServerService Thread Pool -- 91) at at io.undertow.servlet.api.LegacyThreadSetupActionWrapper$1.call(LegacyThreadSetupActionWrapper.java:44) 13:48:49,011 INFO [stdout] (ServerService Thread Pool -- 91) at at io.undertow.servlet.api.LegacyThreadSetupActionWrapper$1.call(LegacyThreadSetupActionWrapper.java:44) 13:48:49,011 INFO [stdout] (ServerService Thread Pool -- 91) at at io.undertow.servlet.core.DeploymentManagerImpl.deploy(DeploymentManagerImpl.java:234) 13:48:49,011 INFO [stdout] (ServerService Thread Pool -- 91) at at org.wildfly.extension.undertow.deployment.UndertowDeploymentService.startContext(UndertowDeploymentService.java:100) 13:48:49,011 INFO [stdout] (ServerService Thread Pool -- 91) at at org.wildfly.extension.undertow.deployment.UndertowDeploymentService$1.run(UndertowDeploymentService.java:82) 13:48:49,012 INFO [stdout] (ServerService Thread Pool -- 91) at at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) 13:48:49,012 INFO [stdout] (ServerService Thread Pool -- 91) at at java.util.concurrent.FutureTask.run(FutureTask.java:266) 13:48:49,002 INFO [org.jboss.weld.Bootstrap] (Weld Thread Pool -- 4) WELD-001125: Illegal bean type org.jboss.resteasy.plugins.providers.jaxb.AbstractJAXBProvider<javax.xml.bind.JAXBElement<?>> ignored on [EnhancedAnnotatedTypeImpl] public @Produces @Consumes @Provider @ApplicationScoped class org.jboss.resteasy.plugins.providers.jaxb.JAXBElementProvider 13:48:49,012 INFO [stdout] (ServerService Thread Pool -- 91) at at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) 13:48:49,013 INFO [stdout] (ServerService Thread Pool -- 91) at at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) 13:48:49,013 INFO [stdout] (ServerService Thread Pool -- 91) at at java.lang.Thread.run(Thread.java:748) 13:48:49,013 INFO [stdout] (ServerService Thread Pool -- 91) at at org.jboss.threads.JBossThread.run(JBossThread.java:320) 13:48:49,012 INFO [org.jboss.weld.Bootstrap] (Weld Thread Pool -- 4) WELD-001125: Illegal bean type class org.jboss.resteasy.plugins.providers.AbstractEntityProvider<javax.xml.bind.JAXBElement<?>> ignored on [EnhancedAnnotatedTypeImpl] public @Produces @Consumes @Provider @ApplicationScoped class org.jboss.resteasy.plugins.providers.jaxb.JAXBElementProvider 13:48:49,013 INFO [stdout] (ServerService Thread Pool -- 80) 13:48:48,953 |-WARN in ch.qos.logback.classic.pattern.DateConverter@6fa21556 - Could not instantiate SimpleDateFormat with pattern "yyyy-MM-dd'T'HH:mm:ss.SSSXXX" java.lang.IllegalArgumentException: Illegal pattern character 'q' 13:48:49,013 INFO [stdout] (ServerService Thread Pool -- 80) at java.lang.IllegalArgumentException: Illegal pattern character 'q' 13:48:49,013 INFO [stdout] (ServerService Thread Pool -- 80) at at java.text.SimpleDateFormat.compile(SimpleDateFormat.java:826) 13:48:49,013 INFO [stdout] (ServerService Thread Pool -- 80) at at java.text.SimpleDateFormat.initialize(SimpleDateFormat.java:634) 13:48:49,014 INFO [stdout] (ServerService Thread Pool -- 80) at at java.text.SimpleDateFormat.<init>(SimpleDateFormat.java:605) 13:48:49,014 INFO [stdout] (ServerService Thread Pool -- 80) at at java.text.SimpleDateFormat.<init>(SimpleDateFormat.java:580) 13:48:49,014 INFO [org.jboss.weld.Bootstrap] (Weld Thread Pool -- 4) WELD-001125: Illegal bean type interface javax.ws.rs.ext.MessageBodyReader<javax.xml.bind.JAXBElement<?>> ignored on [EnhancedAnnotatedTypeImpl] public @Produces @Consumes @Provider @ApplicationScoped class org.jboss.resteasy.plugins.providers.jaxb.JAXBElementProvider 13:48:49,014 INFO [stdout] (ServerService Thread Pool -- 80) at at ch.qos.logback.core.util.CachingDateFormatter.<init>(CachingDateFormatter.java:34) 13:48:49,014 INFO [stdout] (ServerService Thread Pool -- 80) at at ch.qos.logback.classic.pattern.DateConverter.start(DateConverter.java:42) 13:48:49,014 INFO [stdout] (ServerService Thread Pool -- 80) at at ch.qos.logback.core.pattern.ConverterUtil.startConverters(ConverterUtil.java:37) 13:48:49,014 INFO [stdout] (ServerService Thread Pool -- 80) at at ch.qos.logback.core.pattern.PatternLayoutBase.start(PatternLayoutBase.java:91) 13:48:49,014 INFO [stdout] (ServerService Thread Pool -- 80) at at ch.qos.logback.classic.encoder.PatternLayoutEncoder.start(PatternLayoutEncoder.java:28) 13:48:49,014 INFO [stdout] (ServerService Thread Pool -- 80) at at ch.qos.logback.core.joran.action.NestedComplexPropertyIA.end(NestedComplexPropertyIA.java:167) 13:48:49,014 INFO [org.jboss.weld.Bootstrap] (Weld Thread Pool -- 4) WELD-001125: Illegal bean type interface javax.ws.rs.ext.MessageBodyWriter<javax.xml.bind.JAXBElement<?>> ignored on [EnhancedAnnotatedTypeImpl] public @Produces @Consumes @Provider @ApplicationScoped class org.jboss.resteasy.plugins.providers.jaxb.JAXBElementProvider 13:48:49,014 INFO [stdout] (ServerService Thread Pool -- 80) at at ch.qos.logback.core.joran.spi.Interpreter.callEndAction(Interpreter.java:317) 13:48:49,015 INFO [stdout] (ServerService Thread Pool -- 80) at at ch.qos.logback.core.joran.spi.Interpreter.endElement(Interpreter.java:196) 13:48:49,015 INFO [stdout] (ServerService Thread Pool -- 80) at at ch.qos.logback.core.joran.spi.Interpreter.endElement(Interpreter.java:182) 13:48:49,015 INFO [stdout] (ServerService Thread Pool -- 80) at at ch.qos.logback.core.joran.spi.EventPlayer.play(EventPlayer.java:62) 13:48:49,015 INFO [stdout] (ServerService Thread Pool -- 80) at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:149) 13:48:49,015 INFO [stdout] (ServerService Thread Pool -- 80) at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:135) 13:48:49,015 INFO [stdout] (ServerService Thread Pool -- 80) at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:99) 13:48:49,015 INFO [stdout] (ServerService Thread Pool -- 80) at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:76) 13:48:49,016 INFO [stdout] (ServerService Thread Pool -- 80) at at ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:68) 13:48:49,016 INFO [stdout] (ServerService Thread Pool -- 80) at at org.openecomp.mso.logger.MsoLogInitializer.contextInitialized(MsoLogInitializer.java:91) 13:48:49,016 INFO [stdout] (ServerService Thread Pool -- 80) at at io.undertow.servlet.core.ApplicationListeners.contextInitialized(ApplicationListeners.java:187) 13:48:49,016 INFO [stdout] (ServerService Thread Pool -- 80) at at io.undertow.servlet.core.DeploymentManagerImpl$1.call(DeploymentManagerImpl.java:200) 13:48:49,016 INFO [stdout] (ServerService Thread Pool -- 80) at at io.undertow.servlet.core.DeploymentManagerImpl$1.call(DeploymentManagerImpl.java:171) 13:48:49,016 INFO [stdout] (ServerService Thread Pool -- 80) at at io.undertow.servlet.core.ServletRequestContextThreadSetupAction$1.call(ServletRequestContextThreadSetupAction.java:42) 13:48:49,016 INFO [stdout] (ServerService Thread Pool -- 80) at at io.undertow.servlet.core.ContextClassLoaderSetupAction$1.call(ContextClassLoaderSetupAction.java:43) 13:48:49,016 INFO [stdout] (ServerService Thread Pool -- 80) at at io.undertow.servlet.api.LegacyThreadSetupActionWrapper$1.call(LegacyThreadSetupActionWrapper.java:44) 13:48:49,016 INFO [stdout] (ServerService Thread Pool -- 80) at at io.undertow.servlet.api.LegacyThreadSetupActionWrapper$1.call(LegacyThreadSetupActionWrapper.java:44) 13:48:49,016 INFO [stdout] (ServerService Thread Pool -- 80) at at io.undertow.servlet.api.LegacyThreadSetupActionWrapper$1.call(LegacyThreadSetupActionWrapper.java:44) 13:48:49,016 INFO [stdout] (ServerService Thread Pool -- 80) at at io.undertow.servlet.api.LegacyThreadSetupActionWrapper$1.call(LegacyThreadSetupActionWrapper.java:44) 13:48:49,016 INFO [stdout] (ServerService Thread Pool -- 80) at at io.undertow.servlet.api.LegacyThreadSetupActionWrapper$1.call(LegacyThreadSetupActionWrapper.java:44) 13:48:49,016 INFO [stdout] (ServerService Thread Pool -- 80) at at io.undertow.servlet.core.DeploymentManagerImpl.deploy(DeploymentManagerImpl.java:234) 13:48:49,016 INFO [stdout] (ServerService Thread Pool -- 80) at at org.wildfly.extension.undertow.deployment.UndertowDeploymentService.startContext(UndertowDeploymentService.java:100) 13:48:49,017 INFO [stdout] (ServerService Thread Pool -- 80) at at org.wildfly.extension.undertow.deployment.UndertowDeploymentService$1.run(UndertowDeploymentService.java:82) 13:48:49,017 INFO [stdout] (ServerService Thread Pool -- 80) at at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) 13:48:49,017 INFO [stdout] (ServerService Thread Pool -- 80) at at java.util.concurrent.FutureTask.run(FutureTask.java:266) 13:48:49,017 INFO [stdout] (ServerService Thread Pool -- 80) at at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) 13:48:49,017 INFO [stdout] (ServerService Thread Pool -- 80) at at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) 13:48:49,017 INFO [stdout] (ServerService Thread Pool -- 80) at at java.lang.Thread.run(Thread.java:748) 13:48:49,017 INFO [stdout] (ServerService Thread Pool -- 80) at at org.jboss.threads.JBossThread.run(JBossThread.java:320) 13:48:49,018 INFO [stdout] (ServerService Thread Pool -- 83) 13:48:48,989 |-INFO in c.q.l.core.rolling.DefaultTimeBasedFileNamingAndTriggeringPolicy - Roll-over at midnight. 13:48:49,018 INFO [stdout] (ServerService Thread Pool -- 83) 13:48:49,018 |-INFO in c.q.l.core.rolling.DefaultTimeBasedFileNamingAndTriggeringPolicy - Setting initial period to Mon Nov 27 13:48:49 UTC 2017 13:48:49,020 INFO [stdout] (ServerService Thread Pool -- 83) 13:48:49,020 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property 13:48:49,021 INFO [stdout] (ServerService Thread Pool -- 83) 13:48:49,021 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[EELFDebug] - Active log file name: /var/log/ecomp/MSO/vfcadapter/debugmso-821928192-lc37g.log 13:48:49,021 INFO [stdout] (ServerService Thread Pool -- 83) 13:48:49,021 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[EELFDebug] - File property is set to [/var/log/ecomp/MSO/vfcadapter/debugmso-821928192-lc37g.log] 13:48:49,021 INFO [stdout] (ServerService Thread Pool -- 83) 13:48:49,021 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.classic.AsyncAppender] 13:48:49,021 INFO [stdout] (ServerService Thread Pool -- 83) 13:48:49,021 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [asyncEELFDebug] 13:48:49,023 INFO [stdout] (ServerService Thread Pool -- 80) 13:48:49,022 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[EELFAudit] - Active log file name: /var/log/onap/mso/requestDB/audit.log 13:48:49,023 INFO [stdout] (ServerService Thread Pool -- 80) 13:48:49,023 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[EELFAudit] - File property is set to [/var/log/onap/mso/requestDB/audit.log] 13:48:49,023 INFO [stdout] (ServerService Thread Pool -- 80) 13:48:49,023 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.classic.AsyncAppender] 13:48:49,024 INFO [stdout] (ServerService Thread Pool -- 80) 13:48:49,024 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [asyncEELFAudit] 13:48:49,024 INFO [stdout] (ServerService Thread Pool -- 91) 13:48:49,024 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[EELFAudit] - Active log file name: /var/log/onap/mso/tenantAdapter/audit.log 13:48:49,028 INFO [stdout] (ServerService Thread Pool -- 91) 13:48:49,028 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[EELFAudit] - File property is set to [/var/log/onap/mso/tenantAdapter/audit.log] 13:48:49,028 INFO [stdout] (ServerService Thread Pool -- 91) 13:48:49,028 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.classic.AsyncAppender] 13:48:49,032 INFO [stdout] (ServerService Thread Pool -- 80) 13:48:49,026 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [EELFAudit] to ch.qos.logback.classic.AsyncAppender[asyncEELFAudit] 13:48:49,035 INFO [stdout] (ServerService Thread Pool -- 80) 13:48:49,032 |-INFO in ch.qos.logback.classic.AsyncAppender[asyncEELFAudit] - Attaching appender named [EELFAudit] to AsyncAppender. 13:48:49,036 INFO [stdout] (ServerService Thread Pool -- 80) 13:48:49,035 |-INFO in ch.qos.logback.classic.AsyncAppender[asyncEELFAudit] - Setting discardingThreshold to 51 13:48:49,041 INFO [stdout] (ServerService Thread Pool -- 83) 13:48:49,025 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [EELFDebug] to ch.qos.logback.classic.AsyncAppender[asyncEELFDebug] 13:48:49,041 INFO [stdout] (ServerService Thread Pool -- 83) 13:48:49,041 |-INFO in ch.qos.logback.classic.AsyncAppender[asyncEELFDebug] - Attaching appender named [EELFDebug] to AsyncAppender. 13:48:49,058 INFO [stdout] (ServerService Thread Pool -- 80) 13:48:49,058 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender] 13:48:49,059 INFO [stdout] (ServerService Thread Pool -- 91) 13:48:49,058 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [asyncEELFAudit] 13:48:49,063 INFO [stdout] (ServerService Thread Pool -- 80) 13:48:49,058 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [EELFMetrics] 13:48:49,064 INFO [stdout] (ServerService Thread Pool -- 80) 13:48:49,064 |-ERROR in ch.qos.logback.core.joran.spi.Interpreter@44:24 - no applicable action for [totalSizeCap], current ElementPath is [[configuration][appender][rollingPolicy][totalSizeCap]] 13:48:49,064 INFO [stdout] (ServerService Thread Pool -- 80) 13:48:49,064 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy - No compression will be used 13:48:49,074 INFO [stdout] (ServerService Thread Pool -- 80) 13:48:49,074 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy - Will use the pattern /var/log/onap/mso/requestDB/metrics.%d{yyyy-MM-dd}.%i.log for the active file 13:48:49,074 INFO [stdout] (ServerService Thread Pool -- 80) 13:48:49,074 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@42c1c407 - The date pattern is 'yyyy-MM-dd' from file name pattern '/var/log/onap/mso/requestDB/metrics.%d{yyyy-MM-dd}.%i.log'. 13:48:49,074 INFO [stdout] (ServerService Thread Pool -- 80) 13:48:49,074 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@42c1c407 - Roll-over at midnight. 13:48:49,075 INFO [stdout] (ServerService Thread Pool -- 80) 13:48:49,075 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@42c1c407 - Setting initial period to Mon Nov 27 13:48:49 UTC 2017 13:48:49,076 INFO [stdout] (ServerService Thread Pool -- 80) 13:48:49,076 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property 13:48:49,078 INFO [stdout] (ServerService Thread Pool -- 80) 13:48:49,077 |-WARN in ch.qos.logback.classic.pattern.DateConverter@47e64890 - Could not instantiate SimpleDateFormat with pattern "yyyy-MM-dd'T'HH:mm:ss.SSSXXX" java.lang.IllegalArgumentException: Illegal pattern character 'q'