By type
Project Build Version: 1.0.0 2021-05-21 11:57:53.636 INFO --- [ main] org.onap.aai.util.AAIConfig : Initializing AAIConfig 2021-05-21 11:57:53.644 DEBUG --- [ main] org.onap.aai.util.AAIConfig : Reloading config from /opt/app/aai-graphadmin/./resources/etc/appprops/aaiconfig.properties 2021-05-21 11:57:53.644 INFO --- [ main] org.onap.aai.util.AAIConfig : Found the aaiconfig.properties in the following location: /opt/app/aai-graphadmin/./resources/etc/appprops/aaiconfig.properties 2021-05-21 11:57:53.647 INFO --- [ main] org.onap.aai.util.AAIConfig : A&AI Server Node Name = aai.config.nodename 2021-05-21 11:57:55.299 WARN 1 --- [ main] o.s.b.l.logback.LogbackLoggingSystem : Ignoring 'logback.configurationFile' system property. Please use 'logging.config' instead. . ____ _ __ _ _ /\\ / ___'_ __ _ _(_)_ __ __ _ \ \ \ \ ( ( )\___ | '_ | '_| | '_ \/ _` | \ \ \ \ \\/ ___)| |_)| | | | | || (_| | ) ) ) ) ' |____| .__|_| |_|_| |_\__, | / / / / =========|_|==============|___/=/_/_/_/ :: Spring Boot :: (v2.1.12.RELEASE) 2021-05-21 11:57:55.909 INFO 1 --- [ main] org.onap.aai.GraphAdminApp : Starting GraphAdminApp on aai-graphadmin with PID 1 (/opt/app/aai-graphadmin/lib/aai-graphadmin-1.8.0.jar started by aaiadmin in /opt/app/aai-graphadmin) 2021-05-21 11:57:55.909 DEBUG 1 --- [ main] org.onap.aai.GraphAdminApp : Running with Spring Boot v2.1.12.RELEASE, Spring v5.1.13.RELEASE 2021-05-21 11:57:55.910 INFO 1 --- [ main] org.onap.aai.GraphAdminApp : The following profiles are active: dmaap,one-way-ssl 11:58:01,074 |-INFO in LogbackRequestLog - Will use configuration resource [/localhost-access-logback.xml] 11:58:01,089 |-INFO in ch.qos.logback.access.joran.action.ConfigurationAction - debug attribute not set 11:58:01,089 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender] 11:58:01,089 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [ACCESS] 11:58:01,090 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@1208203046 - No compression will be used 11:58:01,090 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@1208203046 - Will use the pattern /opt/app/aai-graphadmin/logs/ajsc-jetty/localhost_access.log.%d{yyyy-MM-dd} for the active file 11:58:01,091 |-INFO in c.q.l.core.rolling.DefaultTimeBasedFileNamingAndTriggeringPolicy - The date pattern is 'yyyy-MM-dd' from file name pattern '/opt/app/aai-graphadmin/logs/ajsc-jetty/localhost_access.log.%d{yyyy-MM-dd}'. 11:58:01,091 |-INFO in c.q.l.core.rolling.DefaultTimeBasedFileNamingAndTriggeringPolicy - Roll-over at midnight. 11:58:01,091 |-INFO in c.q.l.core.rolling.DefaultTimeBasedFileNamingAndTriggeringPolicy - Setting initial period to Fri May 21 11:58:01 GMT 2021 11:58:01,116 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[ACCESS] - Active log file name: /opt/app/aai-graphadmin/logs/ajsc-jetty/localhost_access.log 11:58:01,116 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[ACCESS] - File property is set to [/opt/app/aai-graphadmin/logs/ajsc-jetty/localhost_access.log] 11:58:01,117 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [ACCESS] to null 11:58:01,117 |-INFO in ch.qos.logback.access.joran.action.ConfigurationAction - End of configuration. 11:58:01,117 |-INFO in ch.qos.logback.access.joran.JoranConfigurator@ffaa6af - Registering current configuration as safe fallback point 2021-05-21 11:58:01.416 DEBUG 1 --- [ main] org.reflections.Reflections : going to scan these urls: jar:file:/opt/app/aai-graphadmin/lib/aai-graphadmin-1.8.0.jar!/BOOT-INF/lib/aai-els-onap-logging-1.8.1.jar!/ 2021-05-21 11:58:01.492 INFO 1 --- [ main] org.reflections.Reflections : Reflections took 75 ms to scan 1 urls, producing 6 keys and 6 values 2021-05-21 11:58:01.497 DEBUG 1 --- [ main] org.reflections.Reflections : going to scan these urls: jar:file:/opt/app/aai-graphadmin/lib/aai-graphadmin-1.8.0.jar!/BOOT-INF/classes!/ 2021-05-21 11:58:01.523 INFO 1 --- [ main] org.reflections.Reflections : Reflections took 25 ms to scan 1 urls, producing 7 keys and 53 values 2021-05-21 11:58:01.572 DEBUG 1 --- [ main] org.reflections.Reflections : going to scan these urls: jar:file:/opt/app/aai-graphadmin/lib/aai-graphadmin-1.8.0.jar!/BOOT-INF/lib/aai-els-onap-logging-1.8.1.jar!/ 2021-05-21 11:58:01.586 INFO 1 --- [ main] org.reflections.Reflections : Reflections took 13 ms to scan 1 urls, producing 6 keys and 6 values 2021-05-21 11:58:01.592 DEBUG 1 --- [ main] org.reflections.Reflections : going to scan these urls: jar:file:/opt/app/aai-graphadmin/lib/aai-graphadmin-1.8.0.jar!/BOOT-INF/classes!/ 2021-05-21 11:58:01.609 INFO 1 --- [ main] org.reflections.Reflections : Reflections took 16 ms to scan 1 urls, producing 7 keys and 53 values 2021-05-21 11:58:01.618 DEBUG 1 --- [ main] org.reflections.Reflections : going to scan these urls: jar:file:/opt/app/aai-graphadmin/lib/aai-graphadmin-1.8.0.jar!/BOOT-INF/lib/aai-els-onap-logging-1.8.1.jar!/ 2021-05-21 11:58:01.623 INFO 1 --- [ main] org.reflections.Reflections : Reflections took 5 ms to scan 1 urls, producing 6 keys and 6 values 2021-05-21 11:58:01.628 DEBUG 1 --- [ main] org.reflections.Reflections : going to scan these urls: jar:file:/opt/app/aai-graphadmin/lib/aai-graphadmin-1.8.0.jar!/BOOT-INF/classes!/ 2021-05-21 11:58:01.643 INFO 1 --- [ main] org.reflections.Reflections : Reflections took 15 ms to scan 1 urls, producing 7 keys and 53 values 2021-05-21 11:58:02.186 INFO 1 --- [ main] org.onap.aai.config.NodesConfiguration : Translator is SchemaServiceTranslator 2021-05-21 11:58:02.648 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName] 2021-05-21 11:58:02.648 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName 2021-05-21 11:58:02.649 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty 2021-05-21 11:58:02.651 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Request Headers: {} 2021-05-21 11:58:02.664 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : METHOD=GET, URL=https://aai-schema-service.onap:8452/aai/schema-service/v1/versions, BODY= 2021-05-21 11:58:02.787 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName] 2021-05-21 11:58:02.788 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName 2021-05-21 11:58:02.788 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty 2021-05-21 11:58:02.788 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke 2021-05-21 11:58:03.162 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn 2021-05-21 11:58:03.298 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Processing the translator 2021-05-21 11:58:03.299 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Version being processedv11 2021-05-21 11:58:03.299 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Headers: {Accept=application/xml, Content-Type=application/xml} 2021-05-21 11:58:03.403 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName] 2021-05-21 11:58:03.403 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName 2021-05-21 11:58:03.403 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty 2021-05-21 11:58:03.403 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke 2021-05-21 11:58:03.434 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn 2021-05-21 11:58:03.509 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK 2021-05-21 11:58:03.509 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Retrieved OXMs from SchemaService 2021-05-21 11:58:03.510 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Ingested the InputStream 2021-05-21 11:58:07.505 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Types size 222 2021-05-21 11:58:07.527 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Version being processedv12 2021-05-21 11:58:07.527 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Headers: {Accept=application/xml, Content-Type=application/xml} 2021-05-21 11:58:07.530 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName] 2021-05-21 11:58:07.530 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName 2021-05-21 11:58:07.530 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty 2021-05-21 11:58:07.530 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke 2021-05-21 11:58:07.572 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn 2021-05-21 11:58:07.608 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK 2021-05-21 11:58:07.608 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Retrieved OXMs from SchemaService 2021-05-21 11:58:07.609 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Ingested the InputStream 2021-05-21 11:58:09.313 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Types size 235 2021-05-21 11:58:09.329 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Version being processedv13 2021-05-21 11:58:09.329 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Headers: {Accept=application/xml, Content-Type=application/xml} 2021-05-21 11:58:09.331 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName] 2021-05-21 11:58:09.332 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName 2021-05-21 11:58:09.332 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty 2021-05-21 11:58:09.332 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke 2021-05-21 11:58:09.382 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn 2021-05-21 11:58:09.404 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK 2021-05-21 11:58:09.404 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Retrieved OXMs from SchemaService 2021-05-21 11:58:09.405 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Ingested the InputStream 2021-05-21 11:58:11.396 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Types size 237 2021-05-21 11:58:11.412 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Version being processedv14 2021-05-21 11:58:11.413 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Headers: {Accept=application/xml, Content-Type=application/xml} 2021-05-21 11:58:11.415 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName] 2021-05-21 11:58:11.415 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName 2021-05-21 11:58:11.415 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty 2021-05-21 11:58:11.415 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke 2021-05-21 11:58:11.464 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn 2021-05-21 11:58:11.497 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK 2021-05-21 11:58:11.498 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Retrieved OXMs from SchemaService 2021-05-21 11:58:11.498 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Ingested the InputStream 2021-05-21 11:58:13.711 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Types size 272 2021-05-21 11:58:13.733 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Version being processedv15 2021-05-21 11:58:13.734 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Headers: {Accept=application/xml, Content-Type=application/xml} 2021-05-21 11:58:13.737 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName] 2021-05-21 11:58:13.737 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName 2021-05-21 11:58:13.737 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty 2021-05-21 11:58:13.737 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke 2021-05-21 11:58:13.815 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn 2021-05-21 11:58:13.833 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK 2021-05-21 11:58:13.833 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Retrieved OXMs from SchemaService 2021-05-21 11:58:13.834 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Ingested the InputStream 2021-05-21 11:58:15.816 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Types size 279 2021-05-21 11:58:15.834 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Version being processedv16 2021-05-21 11:58:15.837 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Headers: {Accept=application/xml, Content-Type=application/xml} 2021-05-21 11:58:15.843 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName] 2021-05-21 11:58:15.843 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName 2021-05-21 11:58:15.843 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty 2021-05-21 11:58:15.843 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke 2021-05-21 11:58:15.873 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn 2021-05-21 11:58:15.890 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK 2021-05-21 11:58:15.891 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Retrieved OXMs from SchemaService 2021-05-21 11:58:15.891 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Ingested the InputStream 2021-05-21 11:58:17.628 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Types size 281 2021-05-21 11:58:17.645 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Version being processedv17 2021-05-21 11:58:17.646 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Headers: {Accept=application/xml, Content-Type=application/xml} 2021-05-21 11:58:17.648 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName] 2021-05-21 11:58:17.648 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName 2021-05-21 11:58:17.648 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty 2021-05-21 11:58:17.648 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke 2021-05-21 11:58:17.681 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn 2021-05-21 11:58:17.717 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK 2021-05-21 11:58:17.718 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Retrieved OXMs from SchemaService 2021-05-21 11:58:17.718 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Ingested the InputStream 2021-05-21 11:58:19.507 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Types size 281 2021-05-21 11:58:19.519 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Version being processedv18 2021-05-21 11:58:19.520 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Headers: {Accept=application/xml, Content-Type=application/xml} 2021-05-21 11:58:19.521 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName] 2021-05-21 11:58:19.521 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName 2021-05-21 11:58:19.522 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty 2021-05-21 11:58:19.522 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke 2021-05-21 11:58:19.550 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn 2021-05-21 11:58:19.568 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK 2021-05-21 11:58:19.569 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Retrieved OXMs from SchemaService 2021-05-21 11:58:19.569 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Ingested the InputStream 2021-05-21 11:58:21.065 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Types size 281 2021-05-21 11:58:21.079 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Version being processedv19 2021-05-21 11:58:21.080 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Headers: {Accept=application/xml, Content-Type=application/xml} 2021-05-21 11:58:21.082 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName] 2021-05-21 11:58:21.082 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName 2021-05-21 11:58:21.082 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty 2021-05-21 11:58:21.082 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke 2021-05-21 11:58:21.115 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn 2021-05-21 11:58:21.137 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK 2021-05-21 11:58:21.137 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Retrieved OXMs from SchemaService 2021-05-21 11:58:21.137 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Ingested the InputStream 2021-05-21 11:58:22.729 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Types size 301 2021-05-21 11:58:22.743 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Version being processedv20 2021-05-21 11:58:22.744 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Headers: {Accept=application/xml, Content-Type=application/xml} 2021-05-21 11:58:22.746 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName] 2021-05-21 11:58:22.746 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName 2021-05-21 11:58:22.746 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty 2021-05-21 11:58:22.746 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke 2021-05-21 11:58:22.822 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn 2021-05-21 11:58:22.891 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK 2021-05-21 11:58:22.892 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Retrieved OXMs from SchemaService 2021-05-21 11:58:22.893 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Ingested the InputStream 2021-05-21 11:58:25.009 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Types size 305 2021-05-21 11:58:25.024 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Version being processedv21 2021-05-21 11:58:25.025 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Headers: {Accept=application/xml, Content-Type=application/xml} 2021-05-21 11:58:25.027 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName] 2021-05-21 11:58:25.027 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName 2021-05-21 11:58:25.027 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty 2021-05-21 11:58:25.027 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke 2021-05-21 11:58:25.067 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn 2021-05-21 11:58:25.091 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK 2021-05-21 11:58:25.112 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Retrieved OXMs from SchemaService 2021-05-21 11:58:25.113 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Ingested the InputStream 2021-05-21 11:58:27.325 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Types size 371 2021-05-21 11:58:27.345 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Version being processedv22 2021-05-21 11:58:27.345 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Headers: {Accept=application/xml, Content-Type=application/xml} 2021-05-21 11:58:27.348 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName] 2021-05-21 11:58:27.348 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName 2021-05-21 11:58:27.348 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty 2021-05-21 11:58:27.348 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke 2021-05-21 11:58:27.392 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn 2021-05-21 11:58:27.439 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK 2021-05-21 11:58:27.440 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Retrieved OXMs from SchemaService 2021-05-21 11:58:27.440 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Ingested the InputStream 2021-05-21 11:58:29.695 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Types size 378 2021-05-21 11:58:29.712 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Version being processedv23 2021-05-21 11:58:29.712 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Headers: {Accept=application/xml, Content-Type=application/xml} 2021-05-21 11:58:29.714 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName] 2021-05-21 11:58:29.714 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName 2021-05-21 11:58:29.714 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty 2021-05-21 11:58:29.714 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke 2021-05-21 11:58:29.757 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn 2021-05-21 11:58:29.796 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK 2021-05-21 11:58:29.797 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Retrieved OXMs from SchemaService 2021-05-21 11:58:29.797 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Ingested the InputStream 2021-05-21 11:58:32.074 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Types size 378 2021-05-21 11:58:32.216 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName] 2021-05-21 11:58:32.216 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName 2021-05-21 11:58:32.216 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty 2021-05-21 11:58:32.219 INFO 1 --- [ main] o.onap.aai.rest.client.ApertureService : Successfully initialized the aperture service 2021-05-21 11:58:32.415 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Processing the translator 2021-05-21 11:58:32.416 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Version being processedv11 2021-05-21 11:58:32.417 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Request Headers: {} 2021-05-21 11:58:32.418 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : METHOD=GET, URL=https://aai-schema-service.onap:8452/aai/schema-service/v1/edgerules?version=v11, BODY= 2021-05-21 11:58:32.419 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName] 2021-05-21 11:58:32.420 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName 2021-05-21 11:58:32.420 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty 2021-05-21 11:58:32.420 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke 2021-05-21 11:58:32.434 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn 2021-05-21 11:58:32.437 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK 2021-05-21 11:58:32.437 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Retrieved json from SchemaService 2021-05-21 11:58:32.438 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Version being processedv12 2021-05-21 11:58:32.438 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Request Headers: {} 2021-05-21 11:58:32.439 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : METHOD=GET, URL=https://aai-schema-service.onap:8452/aai/schema-service/v1/edgerules?version=v12, BODY= 2021-05-21 11:58:32.441 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName] 2021-05-21 11:58:32.441 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName 2021-05-21 11:58:32.441 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty 2021-05-21 11:58:32.442 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke 2021-05-21 11:58:32.453 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn 2021-05-21 11:58:32.455 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK 2021-05-21 11:58:32.456 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Retrieved json from SchemaService 2021-05-21 11:58:32.456 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Version being processedv13 2021-05-21 11:58:32.456 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Request Headers: {} 2021-05-21 11:58:32.457 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : METHOD=GET, URL=https://aai-schema-service.onap:8452/aai/schema-service/v1/edgerules?version=v13, BODY= 2021-05-21 11:58:32.458 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName] 2021-05-21 11:58:32.458 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName 2021-05-21 11:58:32.458 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty 2021-05-21 11:58:32.459 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke 2021-05-21 11:58:32.468 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn 2021-05-21 11:58:32.470 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK 2021-05-21 11:58:32.471 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Retrieved json from SchemaService 2021-05-21 11:58:32.471 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Version being processedv14 2021-05-21 11:58:32.472 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Request Headers: {} 2021-05-21 11:58:32.472 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : METHOD=GET, URL=https://aai-schema-service.onap:8452/aai/schema-service/v1/edgerules?version=v14, BODY= 2021-05-21 11:58:32.474 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName] 2021-05-21 11:58:32.474 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName 2021-05-21 11:58:32.474 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty 2021-05-21 11:58:32.474 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke 2021-05-21 11:58:32.484 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn 2021-05-21 11:58:32.487 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK 2021-05-21 11:58:32.487 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Retrieved json from SchemaService 2021-05-21 11:58:32.488 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Version being processedv15 2021-05-21 11:58:32.488 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Request Headers: {} 2021-05-21 11:58:32.489 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : METHOD=GET, URL=https://aai-schema-service.onap:8452/aai/schema-service/v1/edgerules?version=v15, BODY= 2021-05-21 11:58:32.490 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName] 2021-05-21 11:58:32.490 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName 2021-05-21 11:58:32.490 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty 2021-05-21 11:58:32.490 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke 2021-05-21 11:58:32.499 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn 2021-05-21 11:58:32.502 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK 2021-05-21 11:58:32.502 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Retrieved json from SchemaService 2021-05-21 11:58:32.502 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Version being processedv16 2021-05-21 11:58:32.503 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Request Headers: {} 2021-05-21 11:58:32.503 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : METHOD=GET, URL=https://aai-schema-service.onap:8452/aai/schema-service/v1/edgerules?version=v16, BODY= 2021-05-21 11:58:32.504 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName] 2021-05-21 11:58:32.504 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName 2021-05-21 11:58:32.505 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty 2021-05-21 11:58:32.505 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke 2021-05-21 11:58:32.513 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn 2021-05-21 11:58:32.515 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK 2021-05-21 11:58:32.516 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Retrieved json from SchemaService 2021-05-21 11:58:32.516 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Version being processedv17 2021-05-21 11:58:32.516 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Request Headers: {} 2021-05-21 11:58:32.517 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : METHOD=GET, URL=https://aai-schema-service.onap:8452/aai/schema-service/v1/edgerules?version=v17, BODY= 2021-05-21 11:58:32.518 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName] 2021-05-21 11:58:32.518 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName 2021-05-21 11:58:32.518 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty 2021-05-21 11:58:32.518 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke 2021-05-21 11:58:32.525 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn 2021-05-21 11:58:32.528 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK 2021-05-21 11:58:32.529 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Retrieved json from SchemaService 2021-05-21 11:58:32.529 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Version being processedv18 2021-05-21 11:58:32.529 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Request Headers: {} 2021-05-21 11:58:32.530 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : METHOD=GET, URL=https://aai-schema-service.onap:8452/aai/schema-service/v1/edgerules?version=v18, BODY= 2021-05-21 11:58:32.531 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName] 2021-05-21 11:58:32.531 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName 2021-05-21 11:58:32.531 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty 2021-05-21 11:58:32.531 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke 2021-05-21 11:58:32.542 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn 2021-05-21 11:58:32.545 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK 2021-05-21 11:58:32.545 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Retrieved json from SchemaService 2021-05-21 11:58:32.546 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Version being processedv19 2021-05-21 11:58:32.546 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Request Headers: {} 2021-05-21 11:58:32.546 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : METHOD=GET, URL=https://aai-schema-service.onap:8452/aai/schema-service/v1/edgerules?version=v19, BODY= 2021-05-21 11:58:32.547 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName] 2021-05-21 11:58:32.547 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName 2021-05-21 11:58:32.547 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty 2021-05-21 11:58:32.547 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke 2021-05-21 11:58:32.556 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn 2021-05-21 11:58:32.559 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK 2021-05-21 11:58:32.560 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Retrieved json from SchemaService 2021-05-21 11:58:32.560 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Version being processedv20 2021-05-21 11:58:32.560 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Request Headers: {} 2021-05-21 11:58:32.561 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : METHOD=GET, URL=https://aai-schema-service.onap:8452/aai/schema-service/v1/edgerules?version=v20, BODY= 2021-05-21 11:58:32.569 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName] 2021-05-21 11:58:32.569 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName 2021-05-21 11:58:32.569 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty 2021-05-21 11:58:32.569 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke 2021-05-21 11:58:32.580 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn 2021-05-21 11:58:32.583 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK 2021-05-21 11:58:32.583 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Retrieved json from SchemaService 2021-05-21 11:58:32.583 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Version being processedv21 2021-05-21 11:58:32.584 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Request Headers: {} 2021-05-21 11:58:32.584 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : METHOD=GET, URL=https://aai-schema-service.onap:8452/aai/schema-service/v1/edgerules?version=v21, BODY= 2021-05-21 11:58:32.585 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName] 2021-05-21 11:58:32.585 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName 2021-05-21 11:58:32.585 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty 2021-05-21 11:58:32.585 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke 2021-05-21 11:58:32.596 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn 2021-05-21 11:58:32.600 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK 2021-05-21 11:58:32.601 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Retrieved json from SchemaService 2021-05-21 11:58:32.601 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Version being processedv22 2021-05-21 11:58:32.601 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Request Headers: {} 2021-05-21 11:58:32.602 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : METHOD=GET, URL=https://aai-schema-service.onap:8452/aai/schema-service/v1/edgerules?version=v22, BODY= 2021-05-21 11:58:32.603 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName] 2021-05-21 11:58:32.603 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName 2021-05-21 11:58:32.603 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty 2021-05-21 11:58:32.603 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke 2021-05-21 11:58:32.615 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn 2021-05-21 11:58:32.620 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK 2021-05-21 11:58:32.621 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Retrieved json from SchemaService 2021-05-21 11:58:32.621 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Version being processedv23 2021-05-21 11:58:32.622 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Request Headers: {} 2021-05-21 11:58:32.622 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : METHOD=GET, URL=https://aai-schema-service.onap:8452/aai/schema-service/v1/edgerules?version=v23, BODY= 2021-05-21 11:58:32.623 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName] 2021-05-21 11:58:32.623 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName 2021-05-21 11:58:32.623 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty 2021-05-21 11:58:32.623 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke 2021-05-21 11:58:32.634 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn 2021-05-21 11:58:32.640 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK 2021-05-21 11:58:32.640 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Retrieved json from SchemaService 2021-05-21 11:58:33.014 WARN 1 --- [ main] o.apache.activemq.broker.BrokerService : Memory Usage for the Broker (1024mb) is more than the maximum available for the JVM: 972 mb - resetting to 70% of maximum available: 680 mb 2021-05-21 11:58:34.350 INFO 1 --- [ main] com.datastax.driver.core : DataStax Java driver 3.6.0 for Apache Cassandra 2021-05-21 11:58:34.367 INFO 1 --- [ main] c.d.driver.core.GuavaCompatibility : Detected Guava >= 19 in the classpath, using modern compatibility layer 2021-05-21 11:58:34.369 DEBUG 1 --- [ main] c.datastax.driver.core.SystemProperties : com.datastax.driver.NEW_NODE_DELAY_SECONDS is undefined, using default value 1 2021-05-21 11:58:34.381 DEBUG 1 --- [ main] c.datastax.driver.core.SystemProperties : com.datastax.driver.NOTIF_LOCK_TIMEOUT_SECONDS is undefined, using default value 60 2021-05-21 11:58:34.458 DEBUG 1 --- [ main] c.datastax.driver.core.SystemProperties : com.datastax.driver.USE_NATIVE_CLOCK is undefined, using default value true 2021-05-21 11:58:34.879 INFO 1 --- [ main] com.datastax.driver.core.ClockFactory : Using native clock to generate timestamps. 2021-05-21 11:58:34.883 DEBUG 1 --- [ main] c.datastax.driver.core.SystemProperties : com.datastax.driver.NON_BLOCKING_EXECUTOR_SIZE is undefined, using default value 2 2021-05-21 11:58:34.983 WARN 1 --- [ main] .b.a.g.t.GroovyTemplateAutoConfiguration : Cannot find template location: classpath:/templates/ (please add some templates, check your Groovy configuration, or set spring.groovy.template.check-template-location=false) 2021-05-21 11:58:36.206 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering 2021-05-21 11:58:36.211 DEBUG 1 --- [ scheduling-1] org.onap.aai.util.AAIConfig : Reloading config from /opt/app/aai-graphadmin/./resources/etc/appprops/aaiconfig.properties 2021-05-21 11:58:36.214 INFO 1 --- [ scheduling-1] org.onap.aai.util.AAIConfig : Found the aaiconfig.properties in the following location: /opt/app/aai-graphadmin/./resources/etc/appprops/aaiconfig.properties 2021-05-21 11:58:36.215 DEBUG 1 --- [ scheduling-1] org.onap.aai.tasks.ScheduledTasks : reloaded from aaiconfig.properties 2021-05-21 11:58:36.215 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting. 2021-05-21 11:58:38.583 WARN 1 --- [ main] org.glassfish.jersey.internal.Errors : The following warnings have been detected: WARNING: A HTTP GET method, public javax.ws.rs.core.Response org.onap.aai.rest.AuditSqlDbConsumer.executeAudit(java.lang.String,java.lang.String,javax.ws.rs.core.HttpHeaders,javax.ws.rs.core.UriInfo), should not consume any entity. 2021-05-21 11:58:38.678 INFO 1 --- [ main] org.onap.aai.GraphAdminApp : Started GraphAdminApp in 44.73 seconds (JVM running for 46.617) 2021-05-21 11:58:38.681 INFO 1 --- [ main] org.onap.aai.GraphAdminApp : Application 'aai-graphadmin' is running on 8449! 2021-05-21 11:58:39.049 DEBUG 1 --- [ main] c.datastax.driver.core.SystemProperties : com.datastax.driver.USE_NATIVE_CLOCK is undefined, using default value true 2021-05-21 11:58:39.049 INFO 1 --- [ main] com.datastax.driver.core.ClockFactory : Using native clock to generate timestamps. 2021-05-21 11:58:39.050 DEBUG 1 --- [ main] com.datastax.driver.core.Cluster : Starting new cluster with contact points [cassandra/10.242.131.197:9042] 2021-05-21 11:58:39.095 DEBUG 1 --- [ main] i.n.u.i.logging.InternalLoggerFactory : Using SLF4J as the default logging framework 2021-05-21 11:58:39.232 DEBUG 1 --- [ main] i.n.util.internal.PlatformDependent0 : -Dio.netty.noUnsafe: false 2021-05-21 11:58:39.232 DEBUG 1 --- [ main] i.n.util.internal.PlatformDependent0 : Java version: 8 2021-05-21 11:58:39.235 DEBUG 1 --- [ main] i.n.util.internal.PlatformDependent0 : sun.misc.Unsafe.theUnsafe: available 2021-05-21 11:58:39.236 DEBUG 1 --- [ main] i.n.util.internal.PlatformDependent0 : sun.misc.Unsafe.copyMemory: available 2021-05-21 11:58:39.237 DEBUG 1 --- [ main] i.n.util.internal.PlatformDependent0 : java.nio.Buffer.address: available 2021-05-21 11:58:39.238 DEBUG 1 --- [ main] i.n.util.internal.PlatformDependent0 : direct buffer constructor: available 2021-05-21 11:58:39.239 DEBUG 1 --- [ main] i.n.util.internal.PlatformDependent0 : java.nio.Bits.unaligned: available, true 2021-05-21 11:58:39.239 DEBUG 1 --- [ main] i.n.util.internal.PlatformDependent0 : jdk.internal.misc.Unsafe.allocateUninitializedArray(int): unavailable prior to Java9 2021-05-21 11:58:39.239 DEBUG 1 --- [ main] i.n.util.internal.PlatformDependent0 : java.nio.DirectByteBuffer.
(long, int): available 2021-05-21 11:58:39.239 DEBUG 1 --- [ main] i.netty.util.internal.PlatformDependent : sun.misc.Unsafe: available 2021-05-21 11:58:39.240 DEBUG 1 --- [ main] i.netty.util.internal.PlatformDependent : -Dio.netty.tmpdir: /tmp (java.io.tmpdir) 2021-05-21 11:58:39.240 DEBUG 1 --- [ main] i.netty.util.internal.PlatformDependent : -Dio.netty.bitMode: 64 (sun.arch.data.model) 2021-05-21 11:58:39.242 DEBUG 1 --- [ main] i.netty.util.internal.PlatformDependent : -Dio.netty.noPreferDirect: false 2021-05-21 11:58:39.243 DEBUG 1 --- [ main] i.netty.util.internal.PlatformDependent : -Dio.netty.maxDirectMemory: 1020067840 bytes 2021-05-21 11:58:39.243 DEBUG 1 --- [ main] i.netty.util.internal.PlatformDependent : -Dio.netty.uninitializedArrayAllocationThreshold: -1 2021-05-21 11:58:39.244 DEBUG 1 --- [ main] io.netty.util.internal.CleanerJava6 : java.nio.ByteBuffer.cleaner(): available 2021-05-21 11:58:39.257 DEBUG 1 --- [ main] c.datastax.driver.core.SystemProperties : com.datastax.driver.FORCE_NIO is undefined, using default value false 2021-05-21 11:58:39.263 DEBUG 1 --- [ main] i.n.util.internal.NativeLibraryLoader : -Dio.netty.native.workdir: /tmp (io.netty.tmpdir) 2021-05-21 11:58:39.269 DEBUG 1 --- [ main] i.n.util.internal.NativeLibraryLoader : Unable to load the library 'netty_transport_native_epoll_x86_64', trying other loading mechanism. java.lang.UnsatisfiedLinkError: no netty_transport_native_epoll_x86_64 in java.library.path at java.lang.ClassLoader.loadLibrary(ClassLoader.java:1867) at java.lang.Runtime.loadLibrary0(Runtime.java:870) at java.lang.System.loadLibrary(System.java:1122) at io.netty.util.internal.NativeLibraryUtil.loadLibrary(NativeLibraryUtil.java:38) 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 io.netty.util.internal.NativeLibraryLoader$1.run(NativeLibraryLoader.java:263) at java.security.AccessController.doPrivileged(Native Method) at io.netty.util.internal.NativeLibraryLoader.loadLibraryByHelper(NativeLibraryLoader.java:255) at io.netty.util.internal.NativeLibraryLoader.loadLibrary(NativeLibraryLoader.java:233) at io.netty.util.internal.NativeLibraryLoader.load(NativeLibraryLoader.java:124) at io.netty.channel.epoll.Native.loadNativeLibrary(Native.java:287) at io.netty.channel.epoll.Native. (Native.java:69) at io.netty.channel.epoll.Epoll. (Epoll.java:33) at java.lang.Class.forName0(Native Method) at java.lang.Class.forName(Class.java:264) at com.datastax.driver.core.NettyUtil. (NettyUtil.java:57) at com.datastax.driver.core.NettyOptions.eventLoopGroup(NettyOptions.java:95) at com.datastax.driver.core.Connection$Factory. (Connection.java:926) at com.datastax.driver.core.Cluster$Manager.init(Cluster.java:1499) at com.datastax.driver.core.Cluster.init(Cluster.java:208) at com.datastax.driver.core.Cluster.connectAsync(Cluster.java:376) at com.datastax.driver.core.Cluster.connectAsync(Cluster.java:355) at com.datastax.driver.core.Cluster.connect(Cluster.java:305) at org.janusgraph.diskstorage.cql.CQLStoreManager.initializeSession(CQLStoreManager.java:272) at org.janusgraph.diskstorage.cql.CQLStoreManager. (CQLStoreManager.java:165) at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62) at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) at java.lang.reflect.Constructor.newInstance(Constructor.java:423) at org.janusgraph.util.system.ConfigurationUtil.instantiate(ConfigurationUtil.java:58) at org.janusgraph.diskstorage.Backend.getImplementationClass(Backend.java:477) at org.janusgraph.diskstorage.Backend.getStorageManager(Backend.java:409) at org.janusgraph.graphdb.configuration.GraphDatabaseConfiguration. (GraphDatabaseConfiguration.java:1382) at org.janusgraph.core.JanusGraphFactory.open(JanusGraphFactory.java:164) at org.janusgraph.core.JanusGraphFactory.open(JanusGraphFactory.java:133) at org.janusgraph.core.JanusGraphFactory.open(JanusGraphFactory.java:113) at org.onap.aai.dbmap.AAIGraph.loadGraph(AAIGraph.java:107) at org.onap.aai.dbmap.AAIGraph. (AAIGraph.java:73) at org.onap.aai.dbmap.AAIGraph. (AAIGraph.java:54) at org.onap.aai.dbmap.AAIGraph$Helper. (AAIGraph.java:80) at org.onap.aai.dbmap.AAIGraph.getInstance(AAIGraph.java:94) at org.onap.aai.GraphAdminApp.main(GraphAdminApp.java:135) 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.springframework.boot.loader.MainMethodRunner.run(MainMethodRunner.java:48) at org.springframework.boot.loader.Launcher.launch(Launcher.java:87) at org.springframework.boot.loader.Launcher.launch(Launcher.java:50) at org.springframework.boot.loader.PropertiesLauncher.main(PropertiesLauncher.java:595) 2021-05-21 11:58:39.270 DEBUG 1 --- [ main] i.n.util.internal.NativeLibraryLoader : netty_transport_native_epoll_x86_64 cannot be loaded from java.libary.path, now trying export to -Dio.netty.native.workdir: /tmp java.lang.UnsatisfiedLinkError: no netty_transport_native_epoll_x86_64 in java.library.path at java.lang.ClassLoader.loadLibrary(ClassLoader.java:1867) at java.lang.Runtime.loadLibrary0(Runtime.java:870) at java.lang.System.loadLibrary(System.java:1122) at io.netty.util.internal.NativeLibraryUtil.loadLibrary(NativeLibraryUtil.java:38) at io.netty.util.internal.NativeLibraryLoader.loadLibrary(NativeLibraryLoader.java:243) at io.netty.util.internal.NativeLibraryLoader.load(NativeLibraryLoader.java:124) at io.netty.channel.epoll.Native.loadNativeLibrary(Native.java:287) at io.netty.channel.epoll.Native. (Native.java:69) at io.netty.channel.epoll.Epoll. (Epoll.java:33) at java.lang.Class.forName0(Native Method) at java.lang.Class.forName(Class.java:264) at com.datastax.driver.core.NettyUtil. (NettyUtil.java:57) at com.datastax.driver.core.NettyOptions.eventLoopGroup(NettyOptions.java:95) at com.datastax.driver.core.Connection$Factory. (Connection.java:926) at com.datastax.driver.core.Cluster$Manager.init(Cluster.java:1499) at com.datastax.driver.core.Cluster.init(Cluster.java:208) at com.datastax.driver.core.Cluster.connectAsync(Cluster.java:376) at com.datastax.driver.core.Cluster.connectAsync(Cluster.java:355) at com.datastax.driver.core.Cluster.connect(Cluster.java:305) at org.janusgraph.diskstorage.cql.CQLStoreManager.initializeSession(CQLStoreManager.java:272) at org.janusgraph.diskstorage.cql.CQLStoreManager. (CQLStoreManager.java:165) at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62) at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) at java.lang.reflect.Constructor.newInstance(Constructor.java:423) at org.janusgraph.util.system.ConfigurationUtil.instantiate(ConfigurationUtil.java:58) at org.janusgraph.diskstorage.Backend.getImplementationClass(Backend.java:477) at org.janusgraph.diskstorage.Backend.getStorageManager(Backend.java:409) at org.janusgraph.graphdb.configuration.GraphDatabaseConfiguration. (GraphDatabaseConfiguration.java:1382) at org.janusgraph.core.JanusGraphFactory.open(JanusGraphFactory.java:164) at org.janusgraph.core.JanusGraphFactory.open(JanusGraphFactory.java:133) at org.janusgraph.core.JanusGraphFactory.open(JanusGraphFactory.java:113) at org.onap.aai.dbmap.AAIGraph.loadGraph(AAIGraph.java:107) at org.onap.aai.dbmap.AAIGraph. (AAIGraph.java:73) at org.onap.aai.dbmap.AAIGraph. (AAIGraph.java:54) at org.onap.aai.dbmap.AAIGraph$Helper. (AAIGraph.java:80) at org.onap.aai.dbmap.AAIGraph.getInstance(AAIGraph.java:94) at org.onap.aai.GraphAdminApp.main(GraphAdminApp.java:135) 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.springframework.boot.loader.MainMethodRunner.run(MainMethodRunner.java:48) at org.springframework.boot.loader.Launcher.launch(Launcher.java:87) at org.springframework.boot.loader.Launcher.launch(Launcher.java:50) at org.springframework.boot.loader.PropertiesLauncher.main(PropertiesLauncher.java:595) Suppressed: java.lang.UnsatisfiedLinkError: no netty_transport_native_epoll_x86_64 in java.library.path at java.lang.ClassLoader.loadLibrary(ClassLoader.java:1867) at java.lang.Runtime.loadLibrary0(Runtime.java:870) at java.lang.System.loadLibrary(System.java:1122) at io.netty.util.internal.NativeLibraryUtil.loadLibrary(NativeLibraryUtil.java:38) 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 io.netty.util.internal.NativeLibraryLoader$1.run(NativeLibraryLoader.java:263) at java.security.AccessController.doPrivileged(Native Method) at io.netty.util.internal.NativeLibraryLoader.loadLibraryByHelper(NativeLibraryLoader.java:255) at io.netty.util.internal.NativeLibraryLoader.loadLibrary(NativeLibraryLoader.java:233) ... 41 common frames omitted 2021-05-21 11:58:39.293 DEBUG 1 --- [ main] i.n.util.internal.NativeLibraryLoader : Successfully loaded the library /tmp/libnetty_transport_native_epoll_x86_645727068470671230020.so 2021-05-21 11:58:39.298 DEBUG 1 --- [ main] io.netty.util.NetUtil : Loopback interface: lo (lo, 0:0:0:0:0:0:0:1%lo) 2021-05-21 11:58:39.300 DEBUG 1 --- [ main] io.netty.util.NetUtil : /proc/sys/net/core/somaxconn: 128 2021-05-21 11:58:39.300 INFO 1 --- [ main] com.datastax.driver.core.NettyUtil : Found Netty's native epoll transport in the classpath, using it 2021-05-21 11:58:39.345 DEBUG 1 --- [ main] i.n.channel.MultithreadEventLoopGroup : -Dio.netty.eventLoopThreads: 4 2021-05-21 11:58:39.393 DEBUG 1 --- [ main] i.netty.util.internal.PlatformDependent : org.jctools-core.MpscChunkedArrayQueue: available 2021-05-21 11:58:39.410 DEBUG 1 --- [ main] io.netty.util.ResourceLeakDetector : -Dio.netty.leakDetection.level: simple 2021-05-21 11:58:39.410 DEBUG 1 --- [ main] io.netty.util.ResourceLeakDetector : -Dio.netty.leakDetection.targetRecords: 4 2021-05-21 11:58:39.410 DEBUG 1 --- [ main] i.n.util.ResourceLeakDetectorFactory : Loaded default ResourceLeakDetector: io.netty.util.ResourceLeakDetector@5d3a147f 2021-05-21 11:58:39.425 DEBUG 1 --- [ main] c.datastax.driver.core.SystemProperties : com.datastax.driver.EXTENDED_PEER_CHECK is undefined, using default value true 2021-05-21 11:58:39.502 DEBUG 1 --- [ main] com.datastax.driver.core.Host.STATES : [cassandra/10.242.131.197:9042] preparing to open 1 new connections, total = 1 2021-05-21 11:58:39.511 DEBUG 1 --- [ main] c.datastax.driver.core.SystemProperties : com.datastax.driver.DISABLE_COALESCING is undefined, using default value false 2021-05-21 11:58:39.512 DEBUG 1 --- [ main] c.datastax.driver.core.SystemProperties : com.datastax.driver.FLUSHER_SCHEDULE_PERIOD_NS is undefined, using default value 10000 2021-05-21 11:58:39.512 DEBUG 1 --- [ main] c.datastax.driver.core.SystemProperties : com.datastax.driver.FLUSHER_RUN_WITHOUT_WORK_TIMES is undefined, using default value 5 2021-05-21 11:58:39.532 DEBUG 1 --- [ main] i.n.u.internal.InternalThreadLocalMap : -Dio.netty.threadLocalMap.stringBuilder.initialSize: 1024 2021-05-21 11:58:39.532 DEBUG 1 --- [ main] i.n.u.internal.InternalThreadLocalMap : -Dio.netty.threadLocalMap.stringBuilder.maxSize: 4096 2021-05-21 11:58:39.580 DEBUG 1 --- [ main] io.netty.buffer.PooledByteBufAllocator : -Dio.netty.allocator.numHeapArenas: 4 2021-05-21 11:58:39.580 DEBUG 1 --- [ main] io.netty.buffer.PooledByteBufAllocator : -Dio.netty.allocator.numDirectArenas: 4 2021-05-21 11:58:39.580 DEBUG 1 --- [ main] io.netty.buffer.PooledByteBufAllocator : -Dio.netty.allocator.pageSize: 8192 2021-05-21 11:58:39.580 DEBUG 1 --- [ main] io.netty.buffer.PooledByteBufAllocator : -Dio.netty.allocator.maxOrder: 11 2021-05-21 11:58:39.580 DEBUG 1 --- [ main] io.netty.buffer.PooledByteBufAllocator : -Dio.netty.allocator.chunkSize: 16777216 2021-05-21 11:58:39.580 DEBUG 1 --- [ main] io.netty.buffer.PooledByteBufAllocator : -Dio.netty.allocator.tinyCacheSize: 512 2021-05-21 11:58:39.580 DEBUG 1 --- [ main] io.netty.buffer.PooledByteBufAllocator : -Dio.netty.allocator.smallCacheSize: 256 2021-05-21 11:58:39.580 DEBUG 1 --- [ main] io.netty.buffer.PooledByteBufAllocator : -Dio.netty.allocator.normalCacheSize: 64 2021-05-21 11:58:39.580 DEBUG 1 --- [ main] io.netty.buffer.PooledByteBufAllocator : -Dio.netty.allocator.maxCachedBufferCapacity: 32768 2021-05-21 11:58:39.580 DEBUG 1 --- [ main] io.netty.buffer.PooledByteBufAllocator : -Dio.netty.allocator.cacheTrimInterval: 8192 2021-05-21 11:58:39.580 DEBUG 1 --- [ main] io.netty.buffer.PooledByteBufAllocator : -Dio.netty.allocator.useCacheForAllThreads: true 2021-05-21 11:58:39.683 DEBUG 1 --- [ main] io.netty.buffer.ByteBufUtil : -Dio.netty.allocator.type: unpooled 2021-05-21 11:58:39.683 DEBUG 1 --- [ main] io.netty.buffer.ByteBufUtil : -Dio.netty.threadLocalDirectBufferSize: 65536 2021-05-21 11:58:39.683 DEBUG 1 --- [ main] io.netty.buffer.ByteBufUtil : -Dio.netty.maxThreadLocalCharBufferSize: 16384 2021-05-21 11:58:39.760 DEBUG 1 --- [er-nio-worker-0] com.datastax.driver.core.Connection : Connection[cassandra/10.242.131.197:9042-1, inFlight=0, closed=false] Connection established, initializing transport 2021-05-21 11:58:39.806 DEBUG 1 --- [er-nio-worker-0] io.netty.util.Recycler : -Dio.netty.recycler.maxCapacity.default: 32768 2021-05-21 11:58:39.806 DEBUG 1 --- [er-nio-worker-0] io.netty.util.Recycler : -Dio.netty.recycler.maxSharedCapacityFactor: 2 2021-05-21 11:58:39.806 DEBUG 1 --- [er-nio-worker-0] io.netty.util.Recycler : -Dio.netty.recycler.linkCapacity: 16 2021-05-21 11:58:39.806 DEBUG 1 --- [er-nio-worker-0] io.netty.util.Recycler : -Dio.netty.recycler.ratio: 8 2021-05-21 11:58:39.820 DEBUG 1 --- [er-nio-worker-0] io.netty.buffer.AbstractByteBuf : -Dio.netty.buffer.bytebuf.checkAccessible: true 2021-05-21 11:58:39.820 DEBUG 1 --- [er-nio-worker-0] i.n.util.ResourceLeakDetectorFactory : Loaded default ResourceLeakDetector: io.netty.util.ResourceLeakDetector@5c29720e 2021-05-21 11:58:39.843 DEBUG 1 --- [er-nio-worker-0] c.datastax.driver.core.SystemProperties : com.datastax.driver.NATIVE_TRANSPORT_MAX_FRAME_SIZE_IN_MB is undefined, using default value 256 2021-05-21 11:58:39.855 DEBUG 1 --- [er-nio-worker-0] com.datastax.driver.core.Host.STATES : Defuncting Connection[cassandra/10.242.131.197:9042-1, inFlight=0, closed=false] because: Authentication error on host cassandra/10.242.131.197:9042: Error during authentication of user cassandra : org.apache.cassandra.exceptions.UnavailableException: Cannot achieve consistency level QUORUM 2021-05-21 11:58:39.857 DEBUG 1 --- [er-nio-worker-0] com.datastax.driver.core.Host.STATES : [cassandra/10.242.131.197:9042] preventing new connections for the next 1000 ms 2021-05-21 11:58:39.857 DEBUG 1 --- [er-nio-worker-0] com.datastax.driver.core.Host.STATES : [cassandra/10.242.131.197:9042] Connection[cassandra/10.242.131.197:9042-1, inFlight=0, closed=false] failed, remaining = 0 2021-05-21 11:58:39.858 DEBUG 1 --- [er-nio-worker-0] com.datastax.driver.core.Connection : Connection[cassandra/10.242.131.197:9042-1, inFlight=0, closed=true] closing connection 2021-05-21 11:58:39.861 DEBUG 1 --- [er-nio-worker-0] com.datastax.driver.core.Connection : Connection[cassandra/10.242.131.197:9042-1, inFlight=0, closed=true] has already terminated 2021-05-21 11:58:39.861 DEBUG 1 --- [ main] com.datastax.driver.core.Cluster : Shutting down Exception in thread "main" java.lang.reflect.InvocationTargetException 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.springframework.boot.loader.MainMethodRunner.run(MainMethodRunner.java:48) at org.springframework.boot.loader.Launcher.launch(Launcher.java:87) at org.springframework.boot.loader.Launcher.launch(Launcher.java:50) at org.springframework.boot.loader.PropertiesLauncher.main(PropertiesLauncher.java:595) Caused by: java.lang.ExceptionInInitializerError at org.onap.aai.dbmap.AAIGraph.getInstance(AAIGraph.java:94) at org.onap.aai.GraphAdminApp.main(GraphAdminApp.java:135) ... 8 more Caused by: java.lang.RuntimeException: Failed to instantiate graphs at org.onap.aai.dbmap.AAIGraph. (AAIGraph.java:75) at org.onap.aai.dbmap.AAIGraph. (AAIGraph.java:54) at org.onap.aai.dbmap.AAIGraph$Helper. (AAIGraph.java:80) ... 10 more Caused by: java.lang.IllegalArgumentException: Could not instantiate implementation: org.janusgraph.diskstorage.cql.CQLStoreManager at org.janusgraph.util.system.ConfigurationUtil.instantiate(ConfigurationUtil.java:69) at org.janusgraph.diskstorage.Backend.getImplementationClass(Backend.java:477) at org.janusgraph.diskstorage.Backend.getStorageManager(Backend.java:409) at org.janusgraph.graphdb.configuration.GraphDatabaseConfiguration. (GraphDatabaseConfiguration.java:1382) at org.janusgraph.core.JanusGraphFactory.open(JanusGraphFactory.java:164) at org.janusgraph.core.JanusGraphFactory.open(JanusGraphFactory.java:133) at org.janusgraph.core.JanusGraphFactory.open(JanusGraphFactory.java:113) at org.onap.aai.dbmap.AAIGraph.loadGraph(AAIGraph.java:107) at org.onap.aai.dbmap.AAIGraph. (AAIGraph.java:73) ... 12 more Caused by: java.lang.reflect.InvocationTargetException at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62) at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) at java.lang.reflect.Constructor.newInstance(Constructor.java:423) at org.janusgraph.util.system.ConfigurationUtil.instantiate(ConfigurationUtil.java:58) ... 20 more Caused by: com.datastax.driver.core.exceptions.AuthenticationException: Authentication error on host cassandra/10.242.131.197:9042: Error during authentication of user cassandra : org.apache.cassandra.exceptions.UnavailableException: Cannot achieve consistency level QUORUM at com.datastax.driver.core.Connection$8.apply(Connection.java:503) at com.datastax.driver.core.Connection$8.apply(Connection.java:465) at com.google.common.util.concurrent.Futures$AsyncChainingFuture.doTransform(Futures.java:1442) at com.google.common.util.concurrent.Futures$AsyncChainingFuture.doTransform(Futures.java:1433) at com.google.common.util.concurrent.Futures$AbstractChainingFuture.run(Futures.java:1408) at com.google.common.util.concurrent.MoreExecutors$DirectExecutor.execute(MoreExecutors.java:456) at com.google.common.util.concurrent.AbstractFuture.executeListener(AbstractFuture.java:817) at com.google.common.util.concurrent.AbstractFuture.complete(AbstractFuture.java:753) at com.google.common.util.concurrent.AbstractFuture.set(AbstractFuture.java:613) at com.datastax.driver.core.Connection$Future.onSet(Connection.java:1479) at com.datastax.driver.core.Connection$Dispatcher.channelRead0(Connection.java:1233) at com.datastax.driver.core.Connection$Dispatcher.channelRead0(Connection.java:1151) at io.netty.channel.SimpleChannelInboundHandler.channelRead(SimpleChannelInboundHandler.java:105) at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:356) at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:342) at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:335) at io.netty.handler.timeout.IdleStateHandler.channelRead(IdleStateHandler.java:286) at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:356) at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:342) at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:335) at io.netty.handler.codec.MessageToMessageDecoder.channelRead(MessageToMessageDecoder.java:102) at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:356) at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:342) at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:335) at io.netty.handler.codec.ByteToMessageDecoder.fireChannelRead(ByteToMessageDecoder.java:312) at io.netty.handler.codec.ByteToMessageDecoder.channelRead(ByteToMessageDecoder.java:286) at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:356) at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:342) at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:335) at io.netty.channel.ChannelInboundHandlerAdapter.channelRead(ChannelInboundHandlerAdapter.java:86) at com.datastax.driver.core.InboundTrafficMeter.channelRead(InboundTrafficMeter.java:38) at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:356) at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:342) at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:335) at io.netty.channel.DefaultChannelPipeline$HeadContext.channelRead(DefaultChannelPipeline.java:1304) at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:356) at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:342) at io.netty.channel.DefaultChannelPipeline.fireChannelRead(DefaultChannelPipeline.java:921) at io.netty.channel.epoll.AbstractEpollStreamChannel$EpollStreamUnsafe.epollInReady(AbstractEpollStreamChannel.java:725) at io.netty.channel.epoll.EpollEventLoop.processReady(EpollEventLoop.java:400) at io.netty.channel.epoll.EpollEventLoop.run(EpollEventLoop.java:300) at io.netty.util.concurrent.SingleThreadEventExecutor$2.run(SingleThreadEventExecutor.java:131) at io.netty.util.concurrent.FastThreadLocalRunnable.run(FastThreadLocalRunnable.java:30) at java.lang.Thread.run(Thread.java:748) 2021-05-21 11:58:42.092 DEBUG 1 --- [er-nio-worker-0] io.netty.buffer.PoolThreadCache : Freed 4 thread-local buffer(s) from thread: JanusGraph Cluster-nio-worker-0 2021-05-21 11:59:36.207 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering 2021-05-21 11:59:36.209 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting. 2021-05-21 12:00:36.208 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering 2021-05-21 12:00:36.213 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting. 2021-05-21 12:01:36.208 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering 2021-05-21 12:01:36.211 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting. 2021-05-21 12:02:36.208 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering 2021-05-21 12:02:36.211 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting. 2021-05-21 12:03:36.209 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering 2021-05-21 12:03:36.213 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting. 2021-05-21 12:04:36.209 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering 2021-05-21 12:04:36.213 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting. 2021-05-21 12:05:36.208 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering 2021-05-21 12:05:36.212 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting. 2021-05-21 12:06:36.208 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering 2021-05-21 12:06:36.210 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting. 2021-05-21 12:07:36.210 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering 2021-05-21 12:07:36.215 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting. 2021-05-21 12:08:36.206 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering 2021-05-21 12:08:36.209 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting. 2021-05-21 12:09:36.208 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering 2021-05-21 12:09:36.212 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting. 2021-05-21 12:10:36.210 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering 2021-05-21 12:10:36.215 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting. 2021-05-21 12:11:36.209 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering 2021-05-21 12:11:36.213 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting. 2021-05-21 12:12:36.208 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering 2021-05-21 12:12:36.211 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting. 2021-05-21 12:13:36.210 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering 2021-05-21 12:13:36.212 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting. 2021-05-21 12:14:36.209 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering 2021-05-21 12:14:36.212 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting. 2021-05-21 12:15:36.208 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering 2021-05-21 12:15:36.212 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting. 2021-05-21 12:16:36.206 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering 2021-05-21 12:16:36.208 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting. 2021-05-21 12:17:36.210 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering 2021-05-21 12:17:36.215 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting. 2021-05-21 12:18:36.209 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering 2021-05-21 12:18:36.214 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting. 2021-05-21 12:19:36.207 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering 2021-05-21 12:19:36.209 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting. 2021-05-21 12:20:36.207 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering 2021-05-21 12:20:36.210 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting. 2021-05-21 12:21:36.209 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering 2021-05-21 12:21:36.213 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting. 2021-05-21 12:22:36.207 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering 2021-05-21 12:22:36.209 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting. 2021-05-21 12:23:36.207 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering 2021-05-21 12:23:36.209 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting. 2021-05-21 12:24:36.210 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering 2021-05-21 12:24:36.214 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting. 2021-05-21 12:25:36.207 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering 2021-05-21 12:25:36.209 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting. 2021-05-21 12:26:36.207 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering 2021-05-21 12:26:36.210 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting. 2021-05-21 12:27:36.208 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering 2021-05-21 12:27:36.211 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting. 2021-05-21 12:28:36.207 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering 2021-05-21 12:28:36.208 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting. 2021-05-21 12:29:36.208 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering 2021-05-21 12:29:36.212 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting. 2021-05-21 12:30:36.207 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering 2021-05-21 12:30:36.210 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.