By type
Project Build Version: 1.0.0
2021-05-27 23:28:50.397 INFO --- [ main] org.onap.aai.util.AAIConfig : Initializing AAIConfig
2021-05-27 23:28:50.607 DEBUG --- [ main] org.onap.aai.util.AAIConfig : Reloading config from /opt/app/aai-graphadmin/./resources/etc/appprops/aaiconfig.properties
2021-05-27 23:28:50.608 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-27 23:28:50.617 INFO --- [ main] org.onap.aai.util.AAIConfig : A&AI Server Node Name = aai.config.nodename
2021-05-27 23:28:53.305 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-27 23:28:53.923 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-27 23:28:53.923 DEBUG 1 --- [ main] org.onap.aai.GraphAdminApp : Running with Spring Boot v2.1.12.RELEASE, Spring v5.1.13.RELEASE
2021-05-27 23:28:53.924 INFO 1 --- [ main] org.onap.aai.GraphAdminApp : The following profiles are active: dmaap,one-way-ssl
23:28:59,159 |-INFO in LogbackRequestLog - Will use configuration resource [/localhost-access-logback.xml]
23:28:59,169 |-INFO in ch.qos.logback.access.joran.action.ConfigurationAction - debug attribute not set
23:28:59,169 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
23:28:59,169 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [ACCESS]
23:28:59,170 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@1055096410 - No compression will be used
23:28:59,170 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@1055096410 - Will use the pattern /opt/app/aai-graphadmin/logs/ajsc-jetty/localhost_access.log.%d{yyyy-MM-dd} for the active file
23:28:59,170 |-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}'.
23:28:59,170 |-INFO in c.q.l.core.rolling.DefaultTimeBasedFileNamingAndTriggeringPolicy - Roll-over at midnight.
23:28:59,170 |-INFO in c.q.l.core.rolling.DefaultTimeBasedFileNamingAndTriggeringPolicy - Setting initial period to Thu May 27 23:28:59 GMT 2021
23:28:59,190 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[ACCESS] - Active log file name: /opt/app/aai-graphadmin/logs/ajsc-jetty/localhost_access.log
23:28:59,190 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[ACCESS] - File property is set to [/opt/app/aai-graphadmin/logs/ajsc-jetty/localhost_access.log]
23:28:59,191 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [ACCESS] to null
23:28:59,191 |-INFO in ch.qos.logback.access.joran.action.ConfigurationAction - End of configuration.
23:28:59,191 |-INFO in ch.qos.logback.access.joran.JoranConfigurator@2ea41516 - Registering current configuration as safe fallback point
2021-05-27 23:28:59.433 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-27 23:28:59.504 INFO 1 --- [ main] org.reflections.Reflections : Reflections took 70 ms to scan 1 urls, producing 6 keys and 6 values
2021-05-27 23:28:59.508 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-27 23:28:59.526 INFO 1 --- [ main] org.reflections.Reflections : Reflections took 16 ms to scan 1 urls, producing 7 keys and 53 values
2021-05-27 23:28:59.557 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-27 23:28:59.563 INFO 1 --- [ main] org.reflections.Reflections : Reflections took 6 ms to scan 1 urls, producing 6 keys and 6 values
2021-05-27 23:28:59.567 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-27 23:28:59.583 INFO 1 --- [ main] org.reflections.Reflections : Reflections took 16 ms to scan 1 urls, producing 7 keys and 53 values
2021-05-27 23:28:59.600 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-27 23:28:59.605 INFO 1 --- [ main] org.reflections.Reflections : Reflections took 5 ms to scan 1 urls, producing 6 keys and 6 values
2021-05-27 23:28:59.610 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-27 23:28:59.627 INFO 1 --- [ main] org.reflections.Reflections : Reflections took 16 ms to scan 1 urls, producing 7 keys and 53 values
2021-05-27 23:29:00.148 INFO 1 --- [ main] org.onap.aai.config.NodesConfiguration : Translator is SchemaServiceTranslator
2021-05-27 23:29:00.744 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2021-05-27 23:29:00.744 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2021-05-27 23:29:00.744 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2021-05-27 23:29:00.746 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Request Headers: {}
2021-05-27 23:29:00.812 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-27 23:29:01.335 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2021-05-27 23:29:01.335 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2021-05-27 23:29:01.335 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2021-05-27 23:29:01.336 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2021-05-27 23:29:02.454 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2021-05-27 23:29:02.576 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Processing the translator
2021-05-27 23:29:02.577 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Version being processedv11
2021-05-27 23:29:02.577 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Headers: {Accept=application/xml, Content-Type=application/xml}
2021-05-27 23:29:02.665 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2021-05-27 23:29:02.665 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2021-05-27 23:29:02.665 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2021-05-27 23:29:02.665 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2021-05-27 23:29:02.695 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2021-05-27 23:29:02.772 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2021-05-27 23:29:02.773 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Retrieved OXMs from SchemaService
2021-05-27 23:29:02.774 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Ingested the InputStream
2021-05-27 23:29:10.331 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Types size 222
2021-05-27 23:29:10.354 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Version being processedv12
2021-05-27 23:29:10.355 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Headers: {Accept=application/xml, Content-Type=application/xml}
2021-05-27 23:29:10.358 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2021-05-27 23:29:10.359 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2021-05-27 23:29:10.359 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2021-05-27 23:29:10.359 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2021-05-27 23:29:10.422 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2021-05-27 23:29:10.465 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2021-05-27 23:29:10.466 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Retrieved OXMs from SchemaService
2021-05-27 23:29:10.466 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Ingested the InputStream
2021-05-27 23:29:12.201 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Types size 235
2021-05-27 23:29:12.218 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Version being processedv13
2021-05-27 23:29:12.218 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Headers: {Accept=application/xml, Content-Type=application/xml}
2021-05-27 23:29:12.220 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2021-05-27 23:29:12.220 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2021-05-27 23:29:12.221 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2021-05-27 23:29:12.221 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2021-05-27 23:29:12.241 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2021-05-27 23:29:12.259 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2021-05-27 23:29:12.260 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Retrieved OXMs from SchemaService
2021-05-27 23:29:12.260 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Ingested the InputStream
2021-05-27 23:29:13.666 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Types size 237
2021-05-27 23:29:13.680 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Version being processedv14
2021-05-27 23:29:13.681 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Headers: {Accept=application/xml, Content-Type=application/xml}
2021-05-27 23:29:13.683 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2021-05-27 23:29:13.683 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2021-05-27 23:29:13.683 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2021-05-27 23:29:13.683 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2021-05-27 23:29:13.705 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2021-05-27 23:29:13.722 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2021-05-27 23:29:13.723 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Retrieved OXMs from SchemaService
2021-05-27 23:29:13.723 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Ingested the InputStream
2021-05-27 23:29:15.262 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Types size 272
2021-05-27 23:29:15.276 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Version being processedv15
2021-05-27 23:29:15.277 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Headers: {Accept=application/xml, Content-Type=application/xml}
2021-05-27 23:29:15.279 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2021-05-27 23:29:15.279 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2021-05-27 23:29:15.280 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2021-05-27 23:29:15.280 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2021-05-27 23:29:15.302 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2021-05-27 23:29:15.321 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2021-05-27 23:29:15.321 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Retrieved OXMs from SchemaService
2021-05-27 23:29:15.321 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Ingested the InputStream
2021-05-27 23:29:16.901 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Types size 279
2021-05-27 23:29:16.914 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Version being processedv16
2021-05-27 23:29:16.914 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Headers: {Accept=application/xml, Content-Type=application/xml}
2021-05-27 23:29:16.917 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2021-05-27 23:29:16.917 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2021-05-27 23:29:16.918 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2021-05-27 23:29:16.918 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2021-05-27 23:29:17.009 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2021-05-27 23:29:17.026 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2021-05-27 23:29:17.027 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Retrieved OXMs from SchemaService
2021-05-27 23:29:17.028 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Ingested the InputStream
2021-05-27 23:29:18.748 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Types size 281
2021-05-27 23:29:18.798 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Version being processedv17
2021-05-27 23:29:18.799 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Headers: {Accept=application/xml, Content-Type=application/xml}
2021-05-27 23:29:18.803 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2021-05-27 23:29:18.803 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2021-05-27 23:29:18.803 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2021-05-27 23:29:18.803 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2021-05-27 23:29:18.835 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2021-05-27 23:29:18.861 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2021-05-27 23:29:18.862 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Retrieved OXMs from SchemaService
2021-05-27 23:29:18.862 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Ingested the InputStream
2021-05-27 23:29:20.493 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Types size 281
2021-05-27 23:29:20.504 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Version being processedv18
2021-05-27 23:29:20.505 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Headers: {Accept=application/xml, Content-Type=application/xml}
2021-05-27 23:29:20.507 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2021-05-27 23:29:20.507 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2021-05-27 23:29:20.507 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2021-05-27 23:29:20.507 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2021-05-27 23:29:20.531 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2021-05-27 23:29:20.550 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2021-05-27 23:29:20.551 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Retrieved OXMs from SchemaService
2021-05-27 23:29:20.551 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Ingested the InputStream
2021-05-27 23:29:21.951 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Types size 281
2021-05-27 23:29:22.011 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Version being processedv19
2021-05-27 23:29:22.011 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Headers: {Accept=application/xml, Content-Type=application/xml}
2021-05-27 23:29:22.013 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2021-05-27 23:29:22.014 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2021-05-27 23:29:22.014 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2021-05-27 23:29:22.014 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2021-05-27 23:29:22.035 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2021-05-27 23:29:22.057 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2021-05-27 23:29:22.057 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Retrieved OXMs from SchemaService
2021-05-27 23:29:22.058 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Ingested the InputStream
2021-05-27 23:29:23.757 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Types size 301
2021-05-27 23:29:23.770 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Version being processedv20
2021-05-27 23:29:23.771 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Headers: {Accept=application/xml, Content-Type=application/xml}
2021-05-27 23:29:23.772 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2021-05-27 23:29:23.772 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2021-05-27 23:29:23.773 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2021-05-27 23:29:23.773 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2021-05-27 23:29:23.815 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2021-05-27 23:29:23.837 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2021-05-27 23:29:23.837 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Retrieved OXMs from SchemaService
2021-05-27 23:29:23.837 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Ingested the InputStream
2021-05-27 23:29:25.518 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Types size 305
2021-05-27 23:29:25.531 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Version being processedv21
2021-05-27 23:29:25.531 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Headers: {Accept=application/xml, Content-Type=application/xml}
2021-05-27 23:29:25.533 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2021-05-27 23:29:25.533 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2021-05-27 23:29:25.533 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2021-05-27 23:29:25.533 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2021-05-27 23:29:25.573 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2021-05-27 23:29:25.596 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2021-05-27 23:29:25.597 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Retrieved OXMs from SchemaService
2021-05-27 23:29:25.597 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Ingested the InputStream
2021-05-27 23:29:27.325 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Types size 371
2021-05-27 23:29:27.339 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Version being processedv22
2021-05-27 23:29:27.340 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Headers: {Accept=application/xml, Content-Type=application/xml}
2021-05-27 23:29:27.342 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2021-05-27 23:29:27.342 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2021-05-27 23:29:27.342 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2021-05-27 23:29:27.342 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2021-05-27 23:29:27.435 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2021-05-27 23:29:27.474 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2021-05-27 23:29:27.475 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Retrieved OXMs from SchemaService
2021-05-27 23:29:27.475 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Ingested the InputStream
2021-05-27 23:29:29.439 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Types size 378
2021-05-27 23:29:29.463 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Version being processedv23
2021-05-27 23:29:29.464 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Headers: {Accept=application/xml, Content-Type=application/xml}
2021-05-27 23:29:29.466 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2021-05-27 23:29:29.466 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2021-05-27 23:29:29.466 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2021-05-27 23:29:29.466 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2021-05-27 23:29:29.497 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2021-05-27 23:29:29.526 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2021-05-27 23:29:29.526 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Retrieved OXMs from SchemaService
2021-05-27 23:29:29.526 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Ingested the InputStream
2021-05-27 23:29:31.440 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Types size 378
2021-05-27 23:29:31.613 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2021-05-27 23:29:31.613 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2021-05-27 23:29:31.613 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2021-05-27 23:29:31.616 INFO 1 --- [ main] o.onap.aai.rest.client.ApertureService : Successfully initialized the aperture service
2021-05-27 23:29:31.906 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Processing the translator
2021-05-27 23:29:31.908 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Version being processedv11
2021-05-27 23:29:31.908 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Request Headers: {}
2021-05-27 23:29:31.909 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-27 23:29:31.910 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2021-05-27 23:29:31.910 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2021-05-27 23:29:31.910 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2021-05-27 23:29:31.910 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2021-05-27 23:29:31.938 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2021-05-27 23:29:31.940 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2021-05-27 23:29:31.941 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Retrieved json from SchemaService
2021-05-27 23:29:31.941 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Version being processedv12
2021-05-27 23:29:31.942 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Request Headers: {}
2021-05-27 23:29:31.942 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-27 23:29:31.943 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2021-05-27 23:29:31.943 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2021-05-27 23:29:31.943 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2021-05-27 23:29:31.943 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2021-05-27 23:29:31.955 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2021-05-27 23:29:31.957 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2021-05-27 23:29:31.957 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Retrieved json from SchemaService
2021-05-27 23:29:31.958 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Version being processedv13
2021-05-27 23:29:31.958 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Request Headers: {}
2021-05-27 23:29:31.958 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-27 23:29:31.960 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2021-05-27 23:29:31.960 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2021-05-27 23:29:31.960 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2021-05-27 23:29:31.960 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2021-05-27 23:29:31.969 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2021-05-27 23:29:31.972 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2021-05-27 23:29:31.973 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Retrieved json from SchemaService
2021-05-27 23:29:31.973 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Version being processedv14
2021-05-27 23:29:31.974 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Request Headers: {}
2021-05-27 23:29:31.975 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-27 23:29:31.977 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2021-05-27 23:29:31.977 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2021-05-27 23:29:31.977 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2021-05-27 23:29:31.977 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2021-05-27 23:29:31.993 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2021-05-27 23:29:31.996 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2021-05-27 23:29:31.996 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Retrieved json from SchemaService
2021-05-27 23:29:31.996 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Version being processedv15
2021-05-27 23:29:31.997 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Request Headers: {}
2021-05-27 23:29:31.997 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-27 23:29:31.999 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2021-05-27 23:29:31.999 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2021-05-27 23:29:31.999 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2021-05-27 23:29:31.999 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2021-05-27 23:29:32.011 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2021-05-27 23:29:32.014 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2021-05-27 23:29:32.015 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Retrieved json from SchemaService
2021-05-27 23:29:32.015 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Version being processedv16
2021-05-27 23:29:32.015 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Request Headers: {}
2021-05-27 23:29:32.016 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-27 23:29:32.017 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2021-05-27 23:29:32.017 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2021-05-27 23:29:32.017 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2021-05-27 23:29:32.017 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2021-05-27 23:29:32.029 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2021-05-27 23:29:32.033 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2021-05-27 23:29:32.033 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Retrieved json from SchemaService
2021-05-27 23:29:32.034 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Version being processedv17
2021-05-27 23:29:32.034 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Request Headers: {}
2021-05-27 23:29:32.034 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-27 23:29:32.036 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2021-05-27 23:29:32.036 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2021-05-27 23:29:32.036 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2021-05-27 23:29:32.036 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2021-05-27 23:29:32.046 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2021-05-27 23:29:32.050 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2021-05-27 23:29:32.050 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Retrieved json from SchemaService
2021-05-27 23:29:32.050 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Version being processedv18
2021-05-27 23:29:32.051 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Request Headers: {}
2021-05-27 23:29:32.051 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-27 23:29:32.052 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2021-05-27 23:29:32.052 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2021-05-27 23:29:32.052 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2021-05-27 23:29:32.052 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2021-05-27 23:29:32.065 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2021-05-27 23:29:32.068 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2021-05-27 23:29:32.068 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Retrieved json from SchemaService
2021-05-27 23:29:32.069 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Version being processedv19
2021-05-27 23:29:32.069 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Request Headers: {}
2021-05-27 23:29:32.069 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-27 23:29:32.070 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2021-05-27 23:29:32.071 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2021-05-27 23:29:32.071 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2021-05-27 23:29:32.071 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2021-05-27 23:29:32.085 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2021-05-27 23:29:32.089 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2021-05-27 23:29:32.089 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Retrieved json from SchemaService
2021-05-27 23:29:32.089 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Version being processedv20
2021-05-27 23:29:32.090 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Request Headers: {}
2021-05-27 23:29:32.090 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-27 23:29:32.091 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2021-05-27 23:29:32.092 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2021-05-27 23:29:32.092 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2021-05-27 23:29:32.092 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2021-05-27 23:29:32.107 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2021-05-27 23:29:32.111 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2021-05-27 23:29:32.111 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Retrieved json from SchemaService
2021-05-27 23:29:32.111 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Version being processedv21
2021-05-27 23:29:32.112 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Request Headers: {}
2021-05-27 23:29:32.112 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-27 23:29:32.113 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2021-05-27 23:29:32.113 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2021-05-27 23:29:32.113 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2021-05-27 23:29:32.114 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2021-05-27 23:29:32.125 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2021-05-27 23:29:32.131 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2021-05-27 23:29:32.131 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Retrieved json from SchemaService
2021-05-27 23:29:32.132 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Version being processedv22
2021-05-27 23:29:32.132 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Request Headers: {}
2021-05-27 23:29:32.133 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-27 23:29:32.134 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2021-05-27 23:29:32.134 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2021-05-27 23:29:32.134 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2021-05-27 23:29:32.134 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2021-05-27 23:29:32.153 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2021-05-27 23:29:32.158 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2021-05-27 23:29:32.159 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Retrieved json from SchemaService
2021-05-27 23:29:32.159 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Version being processedv23
2021-05-27 23:29:32.159 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Request Headers: {}
2021-05-27 23:29:32.160 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-27 23:29:32.161 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2021-05-27 23:29:32.161 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2021-05-27 23:29:32.161 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2021-05-27 23:29:32.161 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2021-05-27 23:29:32.179 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2021-05-27 23:29:32.184 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2021-05-27 23:29:32.185 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Retrieved json from SchemaService
2021-05-27 23:29:32.523 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-27 23:29:34.226 INFO 1 --- [ main] com.datastax.driver.core : DataStax Java driver 3.6.0 for Apache Cassandra
2021-05-27 23:29:34.246 INFO 1 --- [ main] c.d.driver.core.GuavaCompatibility : Detected Guava >= 19 in the classpath, using modern compatibility layer
2021-05-27 23:29:34.247 DEBUG 1 --- [ main] c.datastax.driver.core.SystemProperties : com.datastax.driver.NEW_NODE_DELAY_SECONDS is undefined, using default value 1
2021-05-27 23:29:34.247 DEBUG 1 --- [ main] c.datastax.driver.core.SystemProperties : com.datastax.driver.NOTIF_LOCK_TIMEOUT_SECONDS is undefined, using default value 60
2021-05-27 23:29:34.323 DEBUG 1 --- [ main] c.datastax.driver.core.SystemProperties : com.datastax.driver.USE_NATIVE_CLOCK is undefined, using default value true
2021-05-27 23:29:34.701 INFO 1 --- [ main] com.datastax.driver.core.ClockFactory : Using native clock to generate timestamps.
2021-05-27 23:29:34.705 DEBUG 1 --- [ main] c.datastax.driver.core.SystemProperties : com.datastax.driver.NON_BLOCKING_EXECUTOR_SIZE is undefined, using default value 2
2021-05-27 23:29:34.806 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-27 23:29:35.705 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-27 23:29:35.715 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-27 23:29:38.064 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-27 23:29:38.641 INFO 1 --- [ main] org.onap.aai.GraphAdminApp : Started GraphAdminApp in 47.371 seconds (JVM running for 62.884)
2021-05-27 23:29:38.644 INFO 1 --- [ main] org.onap.aai.GraphAdminApp : Application 'aai-graphadmin' is running on 8449!
2021-05-27 23:29:39.267 DEBUG 1 --- [ main] c.datastax.driver.core.SystemProperties : com.datastax.driver.USE_NATIVE_CLOCK is undefined, using default value true
2021-05-27 23:29:39.268 INFO 1 --- [ main] com.datastax.driver.core.ClockFactory : Using native clock to generate timestamps.
2021-05-27 23:29:39.268 DEBUG 1 --- [ main] com.datastax.driver.core.Cluster : Starting new cluster with contact points [cassandra/10.242.140.16:9042]
2021-05-27 23:29:39.324 DEBUG 1 --- [ main] i.n.u.i.logging.InternalLoggerFactory : Using SLF4J as the default logging framework
2021-05-27 23:29:39.406 DEBUG 1 --- [ main] i.n.util.internal.PlatformDependent0 : -Dio.netty.noUnsafe: false
2021-05-27 23:29:39.406 DEBUG 1 --- [ main] i.n.util.internal.PlatformDependent0 : Java version: 8
2021-05-27 23:29:39.409 DEBUG 1 --- [ main] i.n.util.internal.PlatformDependent0 : sun.misc.Unsafe.theUnsafe: available
2021-05-27 23:29:39.410 DEBUG 1 --- [ main] i.n.util.internal.PlatformDependent0 : sun.misc.Unsafe.copyMemory: available
2021-05-27 23:29:39.411 DEBUG 1 --- [ main] i.n.util.internal.PlatformDependent0 : java.nio.Buffer.address: available
2021-05-27 23:29:39.412 DEBUG 1 --- [ main] i.n.util.internal.PlatformDependent0 : direct buffer constructor: available
2021-05-27 23:29:39.414 DEBUG 1 --- [ main] i.n.util.internal.PlatformDependent0 : java.nio.Bits.unaligned: available, true
2021-05-27 23:29:39.414 DEBUG 1 --- [ main] i.n.util.internal.PlatformDependent0 : jdk.internal.misc.Unsafe.allocateUninitializedArray(int): unavailable prior to Java9
2021-05-27 23:29:39.414 DEBUG 1 --- [ main] i.n.util.internal.PlatformDependent0 : java.nio.DirectByteBuffer.(long, int): available
2021-05-27 23:29:39.414 DEBUG 1 --- [ main] i.netty.util.internal.PlatformDependent : sun.misc.Unsafe: available
2021-05-27 23:29:39.414 DEBUG 1 --- [ main] i.netty.util.internal.PlatformDependent : -Dio.netty.tmpdir: /tmp (java.io.tmpdir)
2021-05-27 23:29:39.415 DEBUG 1 --- [ main] i.netty.util.internal.PlatformDependent : -Dio.netty.bitMode: 64 (sun.arch.data.model)
2021-05-27 23:29:39.419 DEBUG 1 --- [ main] i.netty.util.internal.PlatformDependent : -Dio.netty.noPreferDirect: false
2021-05-27 23:29:39.419 DEBUG 1 --- [ main] i.netty.util.internal.PlatformDependent : -Dio.netty.maxDirectMemory: 1020067840 bytes
2021-05-27 23:29:39.419 DEBUG 1 --- [ main] i.netty.util.internal.PlatformDependent : -Dio.netty.uninitializedArrayAllocationThreshold: -1
2021-05-27 23:29:39.420 DEBUG 1 --- [ main] io.netty.util.internal.CleanerJava6 : java.nio.ByteBuffer.cleaner(): available
2021-05-27 23:29:39.433 DEBUG 1 --- [ main] c.datastax.driver.core.SystemProperties : com.datastax.driver.FORCE_NIO is undefined, using default value false
2021-05-27 23:29:39.440 DEBUG 1 --- [ main] i.n.util.internal.NativeLibraryLoader : -Dio.netty.native.workdir: /tmp (io.netty.tmpdir)
2021-05-27 23:29:39.447 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-27 23:29:39.448 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-27 23:29:39.487 DEBUG 1 --- [ main] i.n.util.internal.NativeLibraryLoader : Successfully loaded the library /tmp/libnetty_transport_native_epoll_x86_644252488421048507726.so
2021-05-27 23:29:39.492 DEBUG 1 --- [ main] io.netty.util.NetUtil : Loopback interface: lo (lo, 0:0:0:0:0:0:0:1%lo)
2021-05-27 23:29:39.493 DEBUG 1 --- [ main] io.netty.util.NetUtil : /proc/sys/net/core/somaxconn: 128
2021-05-27 23:29:39.494 INFO 1 --- [ main] com.datastax.driver.core.NettyUtil : Found Netty's native epoll transport in the classpath, using it
2021-05-27 23:29:39.534 DEBUG 1 --- [ main] i.n.channel.MultithreadEventLoopGroup : -Dio.netty.eventLoopThreads: 4
2021-05-27 23:29:39.591 DEBUG 1 --- [ main] i.netty.util.internal.PlatformDependent : org.jctools-core.MpscChunkedArrayQueue: available
2021-05-27 23:29:39.609 DEBUG 1 --- [ main] io.netty.util.ResourceLeakDetector : -Dio.netty.leakDetection.level: simple
2021-05-27 23:29:39.610 DEBUG 1 --- [ main] io.netty.util.ResourceLeakDetector : -Dio.netty.leakDetection.targetRecords: 4
2021-05-27 23:29:39.610 DEBUG 1 --- [ main] i.n.util.ResourceLeakDetectorFactory : Loaded default ResourceLeakDetector: io.netty.util.ResourceLeakDetector@345f4e0d
2021-05-27 23:29:39.623 DEBUG 1 --- [ main] c.datastax.driver.core.SystemProperties : com.datastax.driver.EXTENDED_PEER_CHECK is undefined, using default value true
2021-05-27 23:29:39.742 DEBUG 1 --- [ main] com.datastax.driver.core.Host.STATES : [cassandra/10.242.140.16:9042] preparing to open 1 new connections, total = 1
2021-05-27 23:29:39.750 DEBUG 1 --- [ main] c.datastax.driver.core.SystemProperties : com.datastax.driver.DISABLE_COALESCING is undefined, using default value false
2021-05-27 23:29:39.751 DEBUG 1 --- [ main] c.datastax.driver.core.SystemProperties : com.datastax.driver.FLUSHER_SCHEDULE_PERIOD_NS is undefined, using default value 10000
2021-05-27 23:29:39.751 DEBUG 1 --- [ main] c.datastax.driver.core.SystemProperties : com.datastax.driver.FLUSHER_RUN_WITHOUT_WORK_TIMES is undefined, using default value 5
2021-05-27 23:29:39.769 DEBUG 1 --- [ main] i.n.u.internal.InternalThreadLocalMap : -Dio.netty.threadLocalMap.stringBuilder.initialSize: 1024
2021-05-27 23:29:39.770 DEBUG 1 --- [ main] i.n.u.internal.InternalThreadLocalMap : -Dio.netty.threadLocalMap.stringBuilder.maxSize: 4096
2021-05-27 23:29:39.833 DEBUG 1 --- [ main] io.netty.buffer.PooledByteBufAllocator : -Dio.netty.allocator.numHeapArenas: 4
2021-05-27 23:29:39.833 DEBUG 1 --- [ main] io.netty.buffer.PooledByteBufAllocator : -Dio.netty.allocator.numDirectArenas: 4
2021-05-27 23:29:39.833 DEBUG 1 --- [ main] io.netty.buffer.PooledByteBufAllocator : -Dio.netty.allocator.pageSize: 8192
2021-05-27 23:29:39.833 DEBUG 1 --- [ main] io.netty.buffer.PooledByteBufAllocator : -Dio.netty.allocator.maxOrder: 11
2021-05-27 23:29:39.833 DEBUG 1 --- [ main] io.netty.buffer.PooledByteBufAllocator : -Dio.netty.allocator.chunkSize: 16777216
2021-05-27 23:29:39.833 DEBUG 1 --- [ main] io.netty.buffer.PooledByteBufAllocator : -Dio.netty.allocator.tinyCacheSize: 512
2021-05-27 23:29:39.833 DEBUG 1 --- [ main] io.netty.buffer.PooledByteBufAllocator : -Dio.netty.allocator.smallCacheSize: 256
2021-05-27 23:29:39.834 DEBUG 1 --- [ main] io.netty.buffer.PooledByteBufAllocator : -Dio.netty.allocator.normalCacheSize: 64
2021-05-27 23:29:39.834 DEBUG 1 --- [ main] io.netty.buffer.PooledByteBufAllocator : -Dio.netty.allocator.maxCachedBufferCapacity: 32768
2021-05-27 23:29:39.834 DEBUG 1 --- [ main] io.netty.buffer.PooledByteBufAllocator : -Dio.netty.allocator.cacheTrimInterval: 8192
2021-05-27 23:29:39.834 DEBUG 1 --- [ main] io.netty.buffer.PooledByteBufAllocator : -Dio.netty.allocator.useCacheForAllThreads: true
2021-05-27 23:29:39.968 DEBUG 1 --- [ main] io.netty.buffer.ByteBufUtil : -Dio.netty.allocator.type: unpooled
2021-05-27 23:29:39.969 DEBUG 1 --- [ main] io.netty.buffer.ByteBufUtil : -Dio.netty.threadLocalDirectBufferSize: 65536
2021-05-27 23:29:39.969 DEBUG 1 --- [ main] io.netty.buffer.ByteBufUtil : -Dio.netty.maxThreadLocalCharBufferSize: 16384
2021-05-27 23:29:40.046 DEBUG 1 --- [er-nio-worker-0] com.datastax.driver.core.Connection : Connection[cassandra/10.242.140.16:9042-1, inFlight=0, closed=false] Connection established, initializing transport
2021-05-27 23:29:40.092 DEBUG 1 --- [er-nio-worker-0] io.netty.util.Recycler : -Dio.netty.recycler.maxCapacity.default: 32768
2021-05-27 23:29:40.092 DEBUG 1 --- [er-nio-worker-0] io.netty.util.Recycler : -Dio.netty.recycler.maxSharedCapacityFactor: 2
2021-05-27 23:29:40.093 DEBUG 1 --- [er-nio-worker-0] io.netty.util.Recycler : -Dio.netty.recycler.linkCapacity: 16
2021-05-27 23:29:40.094 DEBUG 1 --- [er-nio-worker-0] io.netty.util.Recycler : -Dio.netty.recycler.ratio: 8
2021-05-27 23:29:40.109 DEBUG 1 --- [er-nio-worker-0] io.netty.buffer.AbstractByteBuf : -Dio.netty.buffer.bytebuf.checkAccessible: true
2021-05-27 23:29:40.109 DEBUG 1 --- [er-nio-worker-0] i.n.util.ResourceLeakDetectorFactory : Loaded default ResourceLeakDetector: io.netty.util.ResourceLeakDetector@60794e5e
2021-05-27 23:29:49.957 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-27 23:29:59.846 DEBUG 1 --- [er-nio-worker-0] com.datastax.driver.core.Host.STATES : Defuncting Connection[cassandra/10.242.140.16:9042-1, inFlight=0, closed=false] because: Authentication error on host cassandra/10.242.140.16:9042: Error during authentication of user cassandra : org.apache.cassandra.exceptions.ReadTimeoutException: Operation timed out - received only 0 responses.
2021-05-27 23:29:59.847 DEBUG 1 --- [er-nio-worker-0] com.datastax.driver.core.Host.STATES : [cassandra/10.242.140.16:9042] preventing new connections for the next 1000 ms
2021-05-27 23:29:59.848 DEBUG 1 --- [er-nio-worker-0] com.datastax.driver.core.Host.STATES : [cassandra/10.242.140.16:9042] Connection[cassandra/10.242.140.16:9042-1, inFlight=0, closed=false] failed, remaining = 0
2021-05-27 23:29:59.849 DEBUG 1 --- [er-nio-worker-0] com.datastax.driver.core.Connection : Connection[cassandra/10.242.140.16:9042-1, inFlight=0, closed=true] closing connection
2021-05-27 23:29:59.852 DEBUG 1 --- [ main] com.datastax.driver.core.Cluster : Shutting down
2021-05-27 23:29:59.852 DEBUG 1 --- [er-nio-worker-0] com.datastax.driver.core.Connection : Connection[cassandra/10.242.140.16:9042-1, inFlight=0, closed=true] has already terminated
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.140.16:9042: Error during authentication of user cassandra : org.apache.cassandra.exceptions.ReadTimeoutException: Operation timed out - received only 0 responses.
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-27 23:30:02.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-27 23:30:35.703 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-27 23:30:35.705 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-27 23:31:35.704 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-27 23:31:35.706 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-27 23:32:35.704 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-27 23:32:35.707 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-27 23:33:35.703 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-27 23:33:35.706 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-27 23:34:35.704 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-27 23:34:35.707 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-27 23:35:35.704 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-27 23:35:35.706 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-27 23:36:35.703 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-27 23:36:35.705 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-27 23:37:35.704 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-27 23:37:35.708 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-27 23:38:35.705 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-27 23:38:35.711 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-27 23:39:35.703 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-27 23:39:35.707 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-27 23:40:35.703 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-27 23:40:35.705 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-27 23:41:35.703 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-27 23:41:35.705 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-27 23:42:35.706 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-27 23:42:35.709 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-27 23:43:35.703 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-27 23:43:35.705 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-27 23:44:35.707 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-27 23:44:35.709 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-27 23:45:00.002 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-27 23:45:00.043 DEBUG 1 --- [ scheduling-1] o.o.aai.datasnapshot.DataSnapshotTasks : Exit value of the dataSnapshot check process: 1
2021-05-27 23:45:00.044 DEBUG 1 --- [ scheduling-1] o.o.aai.datasnapshot.DataSnapshotTasks : Started cron job dataSnapshot @ 23:45:00
2021-05-27 23:45:00.044 DEBUG 1 --- [ scheduling-1] o.o.aai.datasnapshot.DataSnapshotTasks : DataSnapshot Params [-c, JUST_TAKE_SNAPSHOT]
2021-05-27 23:45:00.064 WARN 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : WARNING - could not get [aai.datasnapshot.threads.for.create] value from aaiconfig.properties file. Property key aai.datasnapshot.threads.for.create cannot be found
2021-05-27 23:45:00.065 WARN 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : WARNING - could not get [aai.datasnapshot.max.nodes.per.file.for.create] value from aaiconfig.properties file. Property key aai.datasnapshot.max.nodes.per.file.for.create cannot be found
2021-05-27 23:45:00.065 WARN 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : WARNING - could not get [aai.datasnapshot.vertex.add.delay.ms] value from aaiconfig.properties file. Property key aai.datasnapshot.vertex.add.delay.ms cannot be found
2021-05-27 23:45:00.065 WARN 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : WARNING - could not get [aai.datasnapshot.edge.add.delay.ms] value from aaiconfig.properties file. Property key aai.datasnapshot.edge.add.delay.ms cannot be found
2021-05-27 23:45:00.065 WARN 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : WARNING - could not get [aai.datasnapshot.failure.delay.ms] value from aaiconfig.properties file. Property key aai.datasnapshot.failure.delay.ms cannot be found
2021-05-27 23:45:00.065 WARN 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : WARNING - could not get [aai.datasnapshot.retry.delay.ms] value from aaiconfig.properties file. Property key aai.datasnapshot.retry.delay.ms cannot be found
2021-05-27 23:45:00.065 WARN 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : WARNING - could not get [aai.datasnapshot.max.errors.per.thread] value from aaiconfig.properties file. Property key aai.datasnapshot.max.errors.per.thread cannot be found
2021-05-27 23:45:00.065 WARN 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : WARNING - could not get [aai.datasnapshot.vertex.to.edge.proc.delay.ms] value from aaiconfig.properties file. Property key aai.datasnapshot.vertex.to.edge.proc.delay.ms cannot be found
2021-05-27 23:45:00.065 WARN 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : WARNING - could not get [aai.datasnapshot.stagger.thread.delay.ms] value from aaiconfig.properties file. Property key aai.datasnapshot.stagger.thread.delay.ms cannot be found
2021-05-27 23:45:00.125 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : DataSnapshot command is [JUST_TAKE_SNAPSHOT]
2021-05-27 23:45:00.125 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : File name to reload snapshot []
2021-05-27 23:45:00.125 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : snapshotType is [graphson]
2021-05-27 23:45:00.125 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : Thread count is [15]
2021-05-27 23:45:00.125 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : Max Nodes Per File is [120000]
2021-05-27 23:45:00.125 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : Debug Flag is []
2021-05-27 23:45:00.125 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : DebugAddDelayTimer is [1]
2021-05-27 23:45:00.125 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : VertAddDelayMs is [1]
2021-05-27 23:45:00.125 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : FailureDelayMs is [50]
2021-05-27 23:45:00.126 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : RetryDelayMs is [50]
2021-05-27 23:45:00.126 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : MaxErrorsPerThread is [25]
2021-05-27 23:45:00.126 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : VertToEdgeProcDelay is [9000]
2021-05-27 23:45:00.128 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : StaggerThreadDelay is [5000]
2021-05-27 23:45:00.128 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : Caller process is []
2021-05-27 23:45:00.130 INFO 1 --- [ scheduling-1] org.onap.aai.util.AAIConfig : Initializing AAIConfig
2021-05-27 23:45:00.130 DEBUG 1 --- [ scheduling-1] org.onap.aai.util.AAIConfig : Reloading config from /opt/app/aai-graphadmin/./resources/etc/appprops/aaiconfig.properties
2021-05-27 23:45:00.130 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-27 23:45:00.131 INFO 1 --- [ scheduling-1] org.onap.aai.util.AAIConfig : A&AI Server Node Name = aai.config.nodename
2021-05-27 23:45:00.135 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : Command = JUST_TAKE_SNAPSHOT, oldSnapshotFileName = [].
2021-05-27 23:45:00.136 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : ---- NOTE --- about to open graph (takes a little while)
2021-05-27 23:45:00.136 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : Command = JUST_TAKE_SNAPSHOT
2021-05-27 23:45:00.139 DEBUG 1 --- [ scheduling-1] o.o.aai.datasnapshot.DataSnapshotTasks : Ended cron job dataSnapshot @ 23:45:00
2021-05-27 23:45:00.140 ERROR 1 --- [ scheduling-1] o.s.s.s.TaskUtils$LoggingErrorHandler : Unexpected error occurred in scheduled task.
java.lang.NoClassDefFoundError: Could not initialize class org.onap.aai.dbmap.AAIGraph$Helper
at org.onap.aai.dbmap.AAIGraph.getInstance(AAIGraph.java:94)
at org.onap.aai.datasnapshot.DataSnapshot.executeCommand(DataSnapshot.java:448)
at org.onap.aai.datasnapshot.DataSnapshot.main(DataSnapshot.java:102)
at org.onap.aai.datasnapshot.DataSnapshotTasks.snapshotScheduleTask(DataSnapshotTasks.java:70)
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.scheduling.support.ScheduledMethodRunnable.run(ScheduledMethodRunnable.java:84)
at org.springframework.scheduling.support.DelegatingErrorHandlingRunnable.run(DelegatingErrorHandlingRunnable.java:54)
at org.springframework.scheduling.concurrent.ReschedulingRunnable.run(ReschedulingRunnable.java:93)
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)
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)
2021-05-27 23:45:35.703 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-27 23:45:35.705 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-27 23:46:35.704 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-27 23:46:35.707 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-27 23:47:35.705 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-27 23:47:35.708 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-27 23:48:35.703 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-27 23:48:35.705 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-27 23:49:35.704 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-27 23:49:35.707 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-27 23:50:35.703 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-27 23:50:35.706 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-27 23:51:35.705 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-27 23:51:35.709 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-27 23:52:35.704 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-27 23:52:35.706 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-27 23:53:35.703 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-27 23:53:35.706 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-27 23:54:35.704 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-27 23:54:35.706 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-27 23:55:35.704 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-27 23:55:35.708 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-27 23:56:35.703 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-27 23:56:35.706 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-27 23:57:35.704 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-27 23:57:35.706 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-27 23:58:35.704 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-27 23:58:35.706 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-27 23:59:35.704 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-27 23:59:35.707 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-28 00:00:35.706 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-28 00:00:35.710 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-28 00:01:35.703 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-28 00:01:35.705 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-28 00:02:35.703 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-28 00:02:35.705 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-28 00:03:35.707 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-28 00:03:35.713 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-28 00:04:35.703 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-28 00:04:35.704 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-28 00:05:35.704 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-28 00:05:35.706 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-28 00:06:00.001 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-28 00:06:00.003 DEBUG 1 --- [ scheduling-1] o.onap.aai.datacleanup.DataCleanupTasks : Started cron job dataGroomingCleanup @ 20210528
2021-05-28 00:06:00.008 DEBUG 1 --- [ scheduling-1] o.onap.aai.datacleanup.DataCleanupTasks : The logDir is /opt/app/aai-graphadmin/logs
2021-05-28 00:06:00.008 DEBUG 1 --- [ scheduling-1] o.onap.aai.datacleanup.DataCleanupTasks : The dataGroomingDir is /opt/app/aai-graphadmin/logs/data/dataGrooming
2021-05-28 00:06:00.008 DEBUG 1 --- [ scheduling-1] o.onap.aai.datacleanup.DataCleanupTasks : The archiveDir is /opt/app/aai-graphadmin/logs/data/dataGrooming/ARCHIVE
2021-05-28 00:06:00.009 DEBUG 1 --- [ scheduling-1] o.onap.aai.datacleanup.DataCleanupTasks : The dataGroomingArcDir is /opt/app/aai-graphadmin/logs/data/dataGrooming/ARCHIVE/dataGrooming
2021-05-28 00:06:00.009 DEBUG 1 --- [ scheduling-1] o.onap.aai.datacleanup.DataCleanupTasks : Directory/opt/app/aai-graphadmin/logsexists: true
2021-05-28 00:06:00.010 DEBUG 1 --- [ scheduling-1] o.onap.aai.datacleanup.DataCleanupTasks : The current date is Fri May 28 00:06:00 GMT 2021
2021-05-28 00:06:00.010 DEBUG 1 --- [ scheduling-1] o.onap.aai.datacleanup.DataCleanupTasks : The newAgeDate is Sun May 23 00:06:00 GMT 2021
2021-05-28 00:06:00.010 DEBUG 1 --- [ scheduling-1] o.onap.aai.datacleanup.DataCleanupTasks : The current date is Fri May 28 00:06:00 GMT 2021
2021-05-28 00:06:00.011 DEBUG 1 --- [ scheduling-1] o.onap.aai.datacleanup.DataCleanupTasks : The newAgeDate is Wed Apr 28 00:06:00 GMT 2021
2021-05-28 00:06:00.011 DEBUG 1 --- [ scheduling-1] o.onap.aai.datacleanup.DataCleanupTasks : Ended cron job dataGroomingCleanup @ 20210528
2021-05-28 00:06:00.011 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-28 00:06:35.704 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-28 00:06:35.706 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-28 00:07:35.704 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-28 00:07:35.706 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-28 00:08:35.703 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-28 00:08:35.705 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-28 00:09:35.704 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-28 00:09:35.707 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-28 00:10:35.703 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-28 00:10:35.705 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-28 00:11:35.704 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-28 00:11:35.708 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-28 00:12:35.703 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-28 00:12:35.705 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-28 00:13:35.707 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-28 00:13:35.710 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-28 00:14:35.704 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-28 00:14:35.707 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-28 00:15:35.706 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-28 00:15:35.710 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-28 00:16:35.704 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-28 00:16:35.707 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-28 00:17:00.003 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-28 00:17:00.004 DEBUG 1 --- [ scheduling-1] o.onap.aai.datacleanup.DataCleanupTasks : Started cron job dataSnapshotCleanup @ 20210528
2021-05-28 00:17:00.004 DEBUG 1 --- [ scheduling-1] o.onap.aai.datacleanup.DataCleanupTasks : The logDir is /opt/app/aai-graphadmin/logs
2021-05-28 00:17:00.004 DEBUG 1 --- [ scheduling-1] o.onap.aai.datacleanup.DataCleanupTasks : The dataSnapshotDir is /opt/app/aai-graphadmin/logs/data/dataSnapshots
2021-05-28 00:17:00.005 DEBUG 1 --- [ scheduling-1] o.onap.aai.datacleanup.DataCleanupTasks : The archiveDir is /opt/app/aai-graphadmin/logs/data/dataSnapshots/ARCHIVE
2021-05-28 00:17:00.005 DEBUG 1 --- [ scheduling-1] o.onap.aai.datacleanup.DataCleanupTasks : The dataSnapshotArcDir is /opt/app/aai-graphadmin/logs/data/dataSnapshots/ARCHIVE/dataSnapshots
2021-05-28 00:17:00.005 DEBUG 1 --- [ scheduling-1] o.onap.aai.datacleanup.DataCleanupTasks : Directory/opt/app/aai-graphadmin/logsexists: true
2021-05-28 00:17:00.006 DEBUG 1 --- [ scheduling-1] o.onap.aai.datacleanup.DataCleanupTasks : The current date is Fri May 28 00:17:00 GMT 2021
2021-05-28 00:17:00.006 DEBUG 1 --- [ scheduling-1] o.onap.aai.datacleanup.DataCleanupTasks : The newAgeDate is Sun May 23 00:17:00 GMT 2021
2021-05-28 00:17:00.006 DEBUG 1 --- [ scheduling-1] o.onap.aai.datacleanup.DataCleanupTasks : The current date is Fri May 28 00:17:00 GMT 2021
2021-05-28 00:17:00.007 DEBUG 1 --- [ scheduling-1] o.onap.aai.datacleanup.DataCleanupTasks : The newAgeDate is Wed Apr 28 00:17:00 GMT 2021
2021-05-28 00:17:00.007 DEBUG 1 --- [ scheduling-1] o.onap.aai.datacleanup.DataCleanupTasks : Started dmaapEventsDataCleanup @ 20210528
2021-05-28 00:17:00.007 DEBUG 1 --- [ scheduling-1] o.onap.aai.datacleanup.DataCleanupTasks : The logDir is /opt/app/aai-graphadmin/logs
2021-05-28 00:17:00.007 DEBUG 1 --- [ scheduling-1] o.onap.aai.datacleanup.DataCleanupTasks : The dmaapEventsDataDir is /opt/app/aai-graphadmin/logs/data/dmaapEvents
2021-05-28 00:17:00.007 DEBUG 1 --- [ scheduling-1] o.onap.aai.datacleanup.DataCleanupTasks : Ended cron dmaapEventsDataCleanup @ 20210528
2021-05-28 00:17:00.034 ERROR 1 --- [ scheduling-1] org.onap.aai.logging.ErrorLogHelper : ERR.5.4.4000 ex=org.onap.aai.exceptions.AAIException: Exception running cron job for DataCleanupex=org.onap.aai.exceptions.AAIException: Property key aai.datamigration.agedelete cannot be found ClassName- org.onap.aai.util.AAIConfig :LineNumber- 157 :MethodName- get ClassName- org.onap.aai.util.AAIConfig :LineNumber- 175 :MethodName- getInt ClassName- org.onap.aai.datacleanup.DataCleanupTasks :LineNumber- 343 :MethodName- dataMigrationCleanup ClassName- org.onap.aai.datacleanup.DataCleanupTasks :LineNumber- 297 :MethodName- dataSnapshotCleanup ClassName- sun.reflect.NativeMethodAccessorImpl :LineNumber- -2 :MethodName- invoke0 ClassName- sun.reflect.NativeMethodAccessorImpl :LineNumber- 62 :MethodName- invoke ClassName- sun.reflect.DelegatingMethodAccessorImpl :LineNumber- 43 :MethodName- invoke ClassName- java.lang.reflect.Method :LineNumber- 498 :MethodName- invoke ClassName- org.springframework.scheduling.support.ScheduledMethodRunnable :LineNumber- 84 :MethodName- run ClassName- org.springframework.scheduling.support.DelegatingErrorHandlingRunnable :LineNumber- 54 :MethodName- run ClassName- org.onap.aai.logging.ErrorLogHelper :LineNumber- 616 :MethodName- logError ClassName- org.onap.aai.datacleanup.DataCleanupTasks :LineNumber- 300 :MethodName- dataSnapshotCleanup ClassName- sun.reflect.NativeMethodAccessorImpl :LineNumber- -2 :MethodName- invoke0 ClassName- sun.reflect.NativeMethodAccessorImpl :LineNumber- 62 :MethodName- invoke ClassName- sun.reflect.DelegatingMethodAccessorImpl :LineNumber- 43 :MethodName- invoke ClassName- java.lang.reflect.Method :LineNumber- 498 :MethodName- invoke ClassName- org.springframework.scheduling.support.ScheduledMethodRunnable :LineNumber- 84 :MethodName- run ClassName- org.springframework.scheduling.support.DelegatingErrorHandlingRunnable :LineNumber- 54 :MethodName- run ClassName- org.springframework.scheduling.concurrent.ReschedulingRunnable :LineNumber- 93 :MethodName- run ClassName- java.util.concurrent.Executors$RunnableAdapter :LineNumber- 511 :MethodName- call
2021-05-28 00:17:00.034 DEBUG 1 --- [ scheduling-1] o.onap.aai.datacleanup.DataCleanupTasks : AAI_4000
2021-05-28 00:17:00.035 DEBUG 1 --- [ scheduling-1] o.onap.aai.datacleanup.DataCleanupTasks : Ended cron job dataSnapshotCleanup @ 20210528
2021-05-28 00:17:00.035 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-28 00:17:35.703 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-28 00:17:35.704 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-28 00:18:35.705 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-28 00:18:35.709 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-28 00:19:35.704 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-28 00:19:35.707 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-28 00:20:35.703 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-28 00:20:35.706 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-28 00:21:35.703 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-28 00:21:35.705 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-28 00:22:35.704 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-28 00:22:35.707 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-28 00:23:35.703 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-28 00:23:35.706 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2021-05-28 00:24:35.703 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2021-05-28 00:24:35.706 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.