By type
Project Build Version: 1.0.0
2022-03-21 03:36:52.624 INFO --- [ main] org.onap.aai.util.AAIConfig : Initializing AAIConfig
2022-03-21 03:36:52.648 DEBUG --- [ main] org.onap.aai.util.AAIConfig : Reloading config from /opt/app/aai-graphadmin/./resources/etc/appprops/aaiconfig.properties
2022-03-21 03:36:52.649 INFO --- [ main] org.onap.aai.util.AAIConfig : Found the aaiconfig.properties in the following location: /opt/app/aai-graphadmin/./resources/etc/appprops/aaiconfig.properties
2022-03-21 03:36:52.665 INFO --- [ main] org.onap.aai.util.AAIConfig : A&AI Server Node Name = aai.config.nodename
2022-03-21 03:36:56.565 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)
2022-03-21 03:36:57.699 INFO 1 --- [ main] org.onap.aai.GraphAdminApp : Starting GraphAdminApp on aai-graphadmin with PID 1 (/opt/app/aai-graphadmin/lib/aai-graphadmin-1.9.2.jar started by aaiadmin in /opt/app/aai-graphadmin)
2022-03-21 03:36:57.700 DEBUG 1 --- [ main] org.onap.aai.GraphAdminApp : Running with Spring Boot v2.1.12.RELEASE, Spring v5.1.13.RELEASE
2022-03-21 03:36:57.700 INFO 1 --- [ main] org.onap.aai.GraphAdminApp : The following profiles are active: dmaap,one-way-ssl
03:37:12,307 |-INFO in LogbackRequestLog - Will use configuration resource [/localhost-access-logback.xml]
03:37:12,330 |-INFO in ch.qos.logback.access.joran.action.ConfigurationAction - debug attribute not set
03:37:12,330 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
03:37:12,330 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [ACCESS]
03:37:12,332 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@1486726131 - No compression will be used
03:37:12,332 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@1486726131 - Will use the pattern /opt/app/aai-graphadmin/logs/ajsc-jetty/localhost_access.log.%d{yyyy-MM-dd} for the active file
03:37:12,333 |-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}'.
03:37:12,333 |-INFO in c.q.l.core.rolling.DefaultTimeBasedFileNamingAndTriggeringPolicy - Roll-over at midnight.
03:37:12,333 |-INFO in c.q.l.core.rolling.DefaultTimeBasedFileNamingAndTriggeringPolicy - Setting initial period to Mon Mar 21 03:37:12 GMT 2022
03:37:12,409 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[ACCESS] - Active log file name: /opt/app/aai-graphadmin/logs/ajsc-jetty/localhost_access.log
03:37:12,409 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[ACCESS] - File property is set to [/opt/app/aai-graphadmin/logs/ajsc-jetty/localhost_access.log]
03:37:12,410 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [ACCESS] to null
03:37:12,410 |-INFO in ch.qos.logback.access.joran.action.ConfigurationAction - End of configuration.
03:37:12,410 |-INFO in ch.qos.logback.access.joran.JoranConfigurator@39d76cb5 - Registering current configuration as safe fallback point
2022-03-21 03:37:13.235 DEBUG 1 --- [ main] org.reflections.Reflections : going to scan these urls:
jar:file:/opt/app/aai-graphadmin/lib/aai-graphadmin-1.9.2.jar!/BOOT-INF/lib/aai-els-onap-logging-1.9.2.jar!/
2022-03-21 03:37:13.424 INFO 1 --- [ main] org.reflections.Reflections : Reflections took 188 ms to scan 1 urls, producing 6 keys and 6 values
2022-03-21 03:37:13.442 DEBUG 1 --- [ main] org.reflections.Reflections : going to scan these urls:
jar:file:/opt/app/aai-graphadmin/lib/aai-graphadmin-1.9.2.jar!/BOOT-INF/classes!/
2022-03-21 03:37:13.502 INFO 1 --- [ main] org.reflections.Reflections : Reflections took 59 ms to scan 1 urls, producing 7 keys and 53 values
2022-03-21 03:37:13.610 DEBUG 1 --- [ main] org.reflections.Reflections : going to scan these urls:
jar:file:/opt/app/aai-graphadmin/lib/aai-graphadmin-1.9.2.jar!/BOOT-INF/lib/aai-els-onap-logging-1.9.2.jar!/
2022-03-21 03:37:13.630 INFO 1 --- [ main] org.reflections.Reflections : Reflections took 20 ms to scan 1 urls, producing 6 keys and 6 values
2022-03-21 03:37:13.644 DEBUG 1 --- [ main] org.reflections.Reflections : going to scan these urls:
jar:file:/opt/app/aai-graphadmin/lib/aai-graphadmin-1.9.2.jar!/BOOT-INF/classes!/
2022-03-21 03:37:13.743 INFO 1 --- [ main] org.reflections.Reflections : Reflections took 98 ms to scan 1 urls, producing 7 keys and 53 values
2022-03-21 03:37:13.782 DEBUG 1 --- [ main] org.reflections.Reflections : going to scan these urls:
jar:file:/opt/app/aai-graphadmin/lib/aai-graphadmin-1.9.2.jar!/BOOT-INF/lib/aai-els-onap-logging-1.9.2.jar!/
2022-03-21 03:37:13.801 INFO 1 --- [ main] org.reflections.Reflections : Reflections took 18 ms to scan 1 urls, producing 6 keys and 6 values
2022-03-21 03:37:13.822 DEBUG 1 --- [ main] org.reflections.Reflections : going to scan these urls:
jar:file:/opt/app/aai-graphadmin/lib/aai-graphadmin-1.9.2.jar!/BOOT-INF/classes!/
2022-03-21 03:37:13.895 INFO 1 --- [ main] org.reflections.Reflections : Reflections took 72 ms to scan 1 urls, producing 7 keys and 53 values
2022-03-21 03:37:14.712 DEBUG 1 --- [ main] i.m.c.u.i.logging.InternalLoggerFactory : Using SLF4J as the default logging framework
2022-03-21 03:37:17.817 INFO 1 --- [ main] org.onap.aai.config.NodesConfiguration : Translator is SchemaServiceTranslator
2022-03-21 03:37:19.257 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2022-03-21 03:37:19.258 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2022-03-21 03:37:19.259 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2022-03-21 03:37:19.262 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Request Headers: {}
2022-03-21 03:37:19.267 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : METHOD=GET, URL=https://aai-schema-service.onap:8452/aai/schema-service/v1/versions, BODY=
2022-03-21 03:37:19.538 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2022-03-21 03:37:19.538 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2022-03-21 03:37:19.538 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2022-03-21 03:37:19.540 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2022-03-21 03:37:21.308 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2022-03-21 03:37:21.879 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Processing the translator
2022-03-21 03:37:21.881 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Version being processedv11
2022-03-21 03:37:21.882 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Headers: {Accept=application/xml, Content-Type=application/xml}
2022-03-21 03:37:22.280 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2022-03-21 03:37:22.280 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2022-03-21 03:37:22.281 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2022-03-21 03:37:22.281 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2022-03-21 03:37:22.328 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2022-03-21 03:37:22.500 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2022-03-21 03:37:22.502 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Retrieved OXMs from SchemaService
2022-03-21 03:37:22.503 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Ingested the InputStream
2022-03-21 03:37:31.604 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Types size 222
2022-03-21 03:37:31.702 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Version being processedv12
2022-03-21 03:37:31.703 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Headers: {Accept=application/xml, Content-Type=application/xml}
2022-03-21 03:37:31.708 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2022-03-21 03:37:31.708 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2022-03-21 03:37:31.708 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2022-03-21 03:37:31.709 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2022-03-21 03:37:31.752 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2022-03-21 03:37:31.836 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2022-03-21 03:37:31.837 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Retrieved OXMs from SchemaService
2022-03-21 03:37:31.838 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Ingested the InputStream
2022-03-21 03:37:35.522 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Types size 235
2022-03-21 03:37:35.597 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Version being processedv13
2022-03-21 03:37:35.598 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Headers: {Accept=application/xml, Content-Type=application/xml}
2022-03-21 03:37:35.601 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2022-03-21 03:37:35.602 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2022-03-21 03:37:35.602 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2022-03-21 03:37:35.602 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2022-03-21 03:37:35.649 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2022-03-21 03:37:35.728 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2022-03-21 03:37:35.729 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Retrieved OXMs from SchemaService
2022-03-21 03:37:35.730 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Ingested the InputStream
2022-03-21 03:37:38.386 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Types size 237
2022-03-21 03:37:38.496 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Version being processedv14
2022-03-21 03:37:38.497 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Headers: {Accept=application/xml, Content-Type=application/xml}
2022-03-21 03:37:38.500 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2022-03-21 03:37:38.501 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2022-03-21 03:37:38.501 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2022-03-21 03:37:38.501 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2022-03-21 03:37:38.571 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2022-03-21 03:37:38.621 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2022-03-21 03:37:38.623 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Retrieved OXMs from SchemaService
2022-03-21 03:37:38.623 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Ingested the InputStream
2022-03-21 03:37:41.896 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Types size 272
2022-03-21 03:37:41.967 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Version being processedv15
2022-03-21 03:37:41.968 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Headers: {Accept=application/xml, Content-Type=application/xml}
2022-03-21 03:37:41.971 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2022-03-21 03:37:41.971 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2022-03-21 03:37:41.971 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2022-03-21 03:37:41.971 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2022-03-21 03:37:42.033 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2022-03-21 03:37:42.087 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2022-03-21 03:37:42.088 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Retrieved OXMs from SchemaService
2022-03-21 03:37:42.088 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Ingested the InputStream
2022-03-21 03:37:45.826 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Types size 279
2022-03-21 03:37:45.883 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Version being processedv16
2022-03-21 03:37:45.884 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Headers: {Accept=application/xml, Content-Type=application/xml}
2022-03-21 03:37:45.888 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2022-03-21 03:37:45.888 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2022-03-21 03:37:45.888 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2022-03-21 03:37:45.888 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2022-03-21 03:37:45.921 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2022-03-21 03:37:46.007 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2022-03-21 03:37:46.008 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Retrieved OXMs from SchemaService
2022-03-21 03:37:46.016 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Ingested the InputStream
2022-03-21 03:37:49.325 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Types size 281
2022-03-21 03:37:49.411 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Version being processedv17
2022-03-21 03:37:49.413 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Headers: {Accept=application/xml, Content-Type=application/xml}
2022-03-21 03:37:49.417 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2022-03-21 03:37:49.417 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2022-03-21 03:37:49.417 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2022-03-21 03:37:49.417 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2022-03-21 03:37:49.479 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2022-03-21 03:37:49.531 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2022-03-21 03:37:49.532 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Retrieved OXMs from SchemaService
2022-03-21 03:37:49.532 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Ingested the InputStream
2022-03-21 03:37:53.190 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Types size 281
2022-03-21 03:37:53.229 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Version being processedv18
2022-03-21 03:37:53.230 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Headers: {Accept=application/xml, Content-Type=application/xml}
2022-03-21 03:37:53.235 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2022-03-21 03:37:53.235 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2022-03-21 03:37:53.235 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2022-03-21 03:37:53.235 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2022-03-21 03:37:53.286 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2022-03-21 03:37:53.343 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2022-03-21 03:37:53.345 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Retrieved OXMs from SchemaService
2022-03-21 03:37:53.345 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Ingested the InputStream
2022-03-21 03:37:56.180 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Types size 281
2022-03-21 03:37:56.207 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Version being processedv19
2022-03-21 03:37:56.208 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Headers: {Accept=application/xml, Content-Type=application/xml}
2022-03-21 03:37:56.211 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2022-03-21 03:37:56.211 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2022-03-21 03:37:56.211 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2022-03-21 03:37:56.211 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2022-03-21 03:37:56.256 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2022-03-21 03:37:56.297 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2022-03-21 03:37:56.299 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Retrieved OXMs from SchemaService
2022-03-21 03:37:56.299 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Ingested the InputStream
2022-03-21 03:37:59.549 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Types size 301
2022-03-21 03:37:59.590 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Version being processedv20
2022-03-21 03:37:59.592 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Headers: {Accept=application/xml, Content-Type=application/xml}
2022-03-21 03:37:59.600 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2022-03-21 03:37:59.600 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2022-03-21 03:37:59.600 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2022-03-21 03:37:59.600 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2022-03-21 03:37:59.665 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2022-03-21 03:37:59.772 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2022-03-21 03:37:59.773 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Retrieved OXMs from SchemaService
2022-03-21 03:37:59.774 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Ingested the InputStream
2022-03-21 03:38:03.203 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Types size 305
2022-03-21 03:38:03.227 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Version being processedv21
2022-03-21 03:38:03.228 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Headers: {Accept=application/xml, Content-Type=application/xml}
2022-03-21 03:38:03.232 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2022-03-21 03:38:03.232 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2022-03-21 03:38:03.232 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2022-03-21 03:38:03.232 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2022-03-21 03:38:03.282 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2022-03-21 03:38:03.350 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2022-03-21 03:38:03.351 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Retrieved OXMs from SchemaService
2022-03-21 03:38:03.352 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Ingested the InputStream
2022-03-21 03:38:06.723 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Types size 371
2022-03-21 03:38:06.752 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Version being processedv22
2022-03-21 03:38:06.753 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Headers: {Accept=application/xml, Content-Type=application/xml}
2022-03-21 03:38:06.757 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2022-03-21 03:38:06.757 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2022-03-21 03:38:06.757 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2022-03-21 03:38:06.758 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2022-03-21 03:38:06.799 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2022-03-21 03:38:06.918 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2022-03-21 03:38:06.919 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Retrieved OXMs from SchemaService
2022-03-21 03:38:06.921 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Ingested the InputStream
2022-03-21 03:38:10.726 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Types size 378
2022-03-21 03:38:10.813 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Version being processedv23
2022-03-21 03:38:10.814 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Headers: {Accept=application/xml, Content-Type=application/xml}
2022-03-21 03:38:10.818 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2022-03-21 03:38:10.819 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2022-03-21 03:38:10.819 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2022-03-21 03:38:10.819 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2022-03-21 03:38:10.891 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2022-03-21 03:38:11.023 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2022-03-21 03:38:11.030 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Retrieved OXMs from SchemaService
2022-03-21 03:38:11.031 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Ingested the InputStream
2022-03-21 03:38:14.242 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Types size 378
2022-03-21 03:38:14.277 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Version being processedv24
2022-03-21 03:38:14.278 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Headers: {Accept=application/xml, Content-Type=application/xml}
2022-03-21 03:38:14.283 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2022-03-21 03:38:14.285 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2022-03-21 03:38:14.287 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2022-03-21 03:38:14.288 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2022-03-21 03:38:14.327 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2022-03-21 03:38:14.395 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2022-03-21 03:38:14.396 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Retrieved OXMs from SchemaService
2022-03-21 03:38:14.397 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Ingested the InputStream
2022-03-21 03:38:18.268 DEBUG 1 --- [ main] org.onap.aai.nodes.NodeIngestor : Types size 406
2022-03-21 03:38:18.622 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2022-03-21 03:38:18.622 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2022-03-21 03:38:18.622 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2022-03-21 03:38:18.627 INFO 1 --- [ main] o.onap.aai.rest.client.ApertureService : Successfully initialized the aperture service
2022-03-21 03:38:18.719 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Processing the translator
2022-03-21 03:38:18.722 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Version being processedv11
2022-03-21 03:38:18.723 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Request Headers: {}
2022-03-21 03:38:18.732 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=
2022-03-21 03:38:18.736 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2022-03-21 03:38:18.736 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2022-03-21 03:38:18.736 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2022-03-21 03:38:18.736 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2022-03-21 03:38:18.769 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2022-03-21 03:38:18.772 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2022-03-21 03:38:18.772 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Retrieved json from SchemaService
2022-03-21 03:38:18.773 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Version being processedv12
2022-03-21 03:38:18.773 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Request Headers: {}
2022-03-21 03:38:18.774 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=
2022-03-21 03:38:18.796 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2022-03-21 03:38:18.796 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2022-03-21 03:38:18.796 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2022-03-21 03:38:18.796 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2022-03-21 03:38:18.815 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2022-03-21 03:38:18.818 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2022-03-21 03:38:18.819 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Retrieved json from SchemaService
2022-03-21 03:38:18.820 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Version being processedv13
2022-03-21 03:38:18.830 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Request Headers: {}
2022-03-21 03:38:18.834 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=
2022-03-21 03:38:18.845 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2022-03-21 03:38:18.845 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2022-03-21 03:38:18.845 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2022-03-21 03:38:18.845 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2022-03-21 03:38:18.885 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2022-03-21 03:38:18.890 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2022-03-21 03:38:18.891 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Retrieved json from SchemaService
2022-03-21 03:38:18.892 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Version being processedv14
2022-03-21 03:38:18.892 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Request Headers: {}
2022-03-21 03:38:18.893 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=
2022-03-21 03:38:18.895 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2022-03-21 03:38:18.896 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2022-03-21 03:38:18.896 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2022-03-21 03:38:18.896 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2022-03-21 03:38:18.924 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2022-03-21 03:38:18.954 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2022-03-21 03:38:18.955 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Retrieved json from SchemaService
2022-03-21 03:38:18.955 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Version being processedv15
2022-03-21 03:38:18.956 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Request Headers: {}
2022-03-21 03:38:18.957 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=
2022-03-21 03:38:18.959 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2022-03-21 03:38:18.959 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2022-03-21 03:38:18.959 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2022-03-21 03:38:18.960 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2022-03-21 03:38:18.978 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2022-03-21 03:38:18.984 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2022-03-21 03:38:18.985 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Retrieved json from SchemaService
2022-03-21 03:38:18.985 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Version being processedv16
2022-03-21 03:38:18.987 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Request Headers: {}
2022-03-21 03:38:18.988 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=
2022-03-21 03:38:18.991 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2022-03-21 03:38:18.991 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2022-03-21 03:38:18.991 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2022-03-21 03:38:18.991 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2022-03-21 03:38:19.020 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2022-03-21 03:38:19.033 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2022-03-21 03:38:19.043 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Retrieved json from SchemaService
2022-03-21 03:38:19.043 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Version being processedv17
2022-03-21 03:38:19.044 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Request Headers: {}
2022-03-21 03:38:19.045 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=
2022-03-21 03:38:19.063 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2022-03-21 03:38:19.063 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2022-03-21 03:38:19.063 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2022-03-21 03:38:19.064 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2022-03-21 03:38:19.100 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2022-03-21 03:38:19.110 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2022-03-21 03:38:19.111 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Retrieved json from SchemaService
2022-03-21 03:38:19.111 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Version being processedv18
2022-03-21 03:38:19.112 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Request Headers: {}
2022-03-21 03:38:19.113 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=
2022-03-21 03:38:19.116 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2022-03-21 03:38:19.116 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2022-03-21 03:38:19.116 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2022-03-21 03:38:19.116 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2022-03-21 03:38:19.157 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2022-03-21 03:38:19.171 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2022-03-21 03:38:19.172 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Retrieved json from SchemaService
2022-03-21 03:38:19.172 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Version being processedv19
2022-03-21 03:38:19.173 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Request Headers: {}
2022-03-21 03:38:19.173 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=
2022-03-21 03:38:19.178 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2022-03-21 03:38:19.179 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2022-03-21 03:38:19.179 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2022-03-21 03:38:19.179 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2022-03-21 03:38:19.205 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2022-03-21 03:38:19.212 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2022-03-21 03:38:19.213 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Retrieved json from SchemaService
2022-03-21 03:38:19.213 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Version being processedv20
2022-03-21 03:38:19.214 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Request Headers: {}
2022-03-21 03:38:19.215 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=
2022-03-21 03:38:19.217 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2022-03-21 03:38:19.217 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2022-03-21 03:38:19.217 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2022-03-21 03:38:19.217 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2022-03-21 03:38:19.244 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2022-03-21 03:38:19.250 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2022-03-21 03:38:19.251 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Retrieved json from SchemaService
2022-03-21 03:38:19.251 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Version being processedv21
2022-03-21 03:38:19.252 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Request Headers: {}
2022-03-21 03:38:19.253 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=
2022-03-21 03:38:19.255 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2022-03-21 03:38:19.256 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2022-03-21 03:38:19.256 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2022-03-21 03:38:19.256 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2022-03-21 03:38:19.288 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2022-03-21 03:38:19.313 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2022-03-21 03:38:19.314 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Retrieved json from SchemaService
2022-03-21 03:38:19.314 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Version being processedv22
2022-03-21 03:38:19.315 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Request Headers: {}
2022-03-21 03:38:19.315 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=
2022-03-21 03:38:19.323 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2022-03-21 03:38:19.324 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2022-03-21 03:38:19.324 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2022-03-21 03:38:19.324 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2022-03-21 03:38:19.348 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2022-03-21 03:38:19.385 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2022-03-21 03:38:19.386 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Retrieved json from SchemaService
2022-03-21 03:38:19.387 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Version being processedv23
2022-03-21 03:38:19.387 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Request Headers: {}
2022-03-21 03:38:19.388 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=
2022-03-21 03:38:19.390 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2022-03-21 03:38:19.390 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2022-03-21 03:38:19.390 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2022-03-21 03:38:19.390 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2022-03-21 03:38:19.416 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2022-03-21 03:38:19.438 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2022-03-21 03:38:19.439 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Retrieved json from SchemaService
2022-03-21 03:38:19.439 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Version being processedv24
2022-03-21 03:38:19.439 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : Request Headers: {}
2022-03-21 03:38:19.440 DEBUG 1 --- [ main] org.onap.aai.restclient.RestClient : METHOD=GET, URL=https://aai-schema-service.onap:8452/aai/schema-service/v1/edgerules?version=v24, BODY=
2022-03-21 03:38:19.444 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Checking for system property [partnerName]
2022-03-21 03:38:19.444 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : System property was null or empty. Checking environment variable for: partnerName
2022-03-21 03:38:19.444 INFO 1 --- [ main] org.onap.logging.filter.base.MDCSetup : Environment variable: partnerName was null or empty
2022-03-21 03:38:19.444 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : Invoke
2022-03-21 03:38:19.476 INFO 1 --- [ main] o.o.l.f.base.AbstractMetricLogFilter : InvokeReturn
2022-03-21 03:38:19.488 DEBUG 1 --- [ main] o.o.aai.setup.SchemaServiceTranslator : SchemaResponse Status code200 OK
2022-03-21 03:38:19.489 DEBUG 1 --- [ main] org.onap.aai.edges.EdgeIngestor : Retrieved json from SchemaService
2022-03-21 03:38:20.762 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
2022-03-21 03:38:24.155 INFO 1 --- [ main] com.datastax.driver.core : DataStax Java driver 3.6.0 for Apache Cassandra
2022-03-21 03:38:24.192 INFO 1 --- [ main] c.d.driver.core.GuavaCompatibility : Detected Guava >= 19 in the classpath, using modern compatibility layer
2022-03-21 03:38:24.199 DEBUG 1 --- [ main] c.datastax.driver.core.SystemProperties : com.datastax.driver.NEW_NODE_DELAY_SECONDS is undefined, using default value 1
2022-03-21 03:38:24.199 DEBUG 1 --- [ main] c.datastax.driver.core.SystemProperties : com.datastax.driver.NOTIF_LOCK_TIMEOUT_SECONDS is undefined, using default value 60
2022-03-21 03:38:24.346 DEBUG 1 --- [ main] c.datastax.driver.core.SystemProperties : com.datastax.driver.USE_NATIVE_CLOCK is undefined, using default value true
2022-03-21 03:38:25.415 INFO 1 --- [ main] com.datastax.driver.core.ClockFactory : Using native clock to generate timestamps.
2022-03-21 03:38:25.419 DEBUG 1 --- [ main] c.datastax.driver.core.SystemProperties : com.datastax.driver.NON_BLOCKING_EXECUTOR_SIZE is undefined, using default value 2
2022-03-21 03:38:25.662 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)
2022-03-21 03:38:28.477 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 03:38:28.511 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 03:38:32.466 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.
2022-03-21 03:38:32.707 INFO 1 --- [ main] org.onap.aai.GraphAdminApp : Started GraphAdminApp in 99.095 seconds (JVM running for 104.462)
2022-03-21 03:38:32.719 INFO 1 --- [ main] org.onap.aai.GraphAdminApp : Application 'aai-graphadmin' is running on 8449!
2022-03-21 03:38:33.625 DEBUG 1 --- [ main] c.datastax.driver.core.SystemProperties : com.datastax.driver.USE_NATIVE_CLOCK is undefined, using default value true
2022-03-21 03:38:33.625 INFO 1 --- [ main] com.datastax.driver.core.ClockFactory : Using native clock to generate timestamps.
2022-03-21 03:38:33.626 DEBUG 1 --- [ main] com.datastax.driver.core.Cluster : Starting new cluster with contact points [cassandra/10.233.69.27:9042]
2022-03-21 03:38:33.742 DEBUG 1 --- [ main] i.n.u.i.logging.InternalLoggerFactory : Using SLF4J as the default logging framework
2022-03-21 03:38:33.843 DEBUG 1 --- [ main] i.n.u.internal.InternalThreadLocalMap : -Dio.netty.threadLocalMap.stringBuilder.initialSize: 1024
2022-03-21 03:38:33.843 DEBUG 1 --- [ main] i.n.u.internal.InternalThreadLocalMap : -Dio.netty.threadLocalMap.stringBuilder.maxSize: 4096
2022-03-21 03:38:34.027 DEBUG 1 --- [ main] i.n.util.internal.PlatformDependent0 : -Dio.netty.noUnsafe: false
2022-03-21 03:38:34.027 DEBUG 1 --- [ main] i.n.util.internal.PlatformDependent0 : Java version: 8
2022-03-21 03:38:34.033 DEBUG 1 --- [ main] i.n.util.internal.PlatformDependent0 : sun.misc.Unsafe.theUnsafe: available
2022-03-21 03:38:34.035 DEBUG 1 --- [ main] i.n.util.internal.PlatformDependent0 : sun.misc.Unsafe.copyMemory: available
2022-03-21 03:38:34.117 DEBUG 1 --- [ main] i.n.util.internal.PlatformDependent0 : java.nio.Buffer.address: available
2022-03-21 03:38:34.124 DEBUG 1 --- [ main] i.n.util.internal.PlatformDependent0 : direct buffer constructor: available
2022-03-21 03:38:34.129 DEBUG 1 --- [ main] i.n.util.internal.PlatformDependent0 : java.nio.Bits.unaligned: available, true
2022-03-21 03:38:34.129 DEBUG 1 --- [ main] i.n.util.internal.PlatformDependent0 : jdk.internal.misc.Unsafe.allocateUninitializedArray(int): unavailable prior to Java9
2022-03-21 03:38:34.130 DEBUG 1 --- [ main] i.n.util.internal.PlatformDependent0 : java.nio.DirectByteBuffer.(long, int): available
2022-03-21 03:38:34.130 DEBUG 1 --- [ main] i.netty.util.internal.PlatformDependent : sun.misc.Unsafe: available
2022-03-21 03:38:34.131 DEBUG 1 --- [ main] i.netty.util.internal.PlatformDependent : -Dio.netty.tmpdir: /tmp (java.io.tmpdir)
2022-03-21 03:38:34.132 DEBUG 1 --- [ main] i.netty.util.internal.PlatformDependent : -Dio.netty.bitMode: 64 (sun.arch.data.model)
2022-03-21 03:38:34.136 DEBUG 1 --- [ main] i.netty.util.internal.PlatformDependent : -Dio.netty.maxDirectMemory: 1020067840 bytes
2022-03-21 03:38:34.137 DEBUG 1 --- [ main] i.netty.util.internal.PlatformDependent : -Dio.netty.uninitializedArrayAllocationThreshold: -1
2022-03-21 03:38:34.164 DEBUG 1 --- [ main] io.netty.util.internal.CleanerJava6 : java.nio.ByteBuffer.cleaner(): available
2022-03-21 03:38:34.164 DEBUG 1 --- [ main] i.netty.util.internal.PlatformDependent : -Dio.netty.noPreferDirect: false
2022-03-21 03:38:34.189 DEBUG 1 --- [ main] c.datastax.driver.core.SystemProperties : com.datastax.driver.FORCE_NIO is undefined, using default value false
2022-03-21 03:38:34.203 DEBUG 1 --- [ main] i.n.util.internal.NativeLibraryLoader : -Dio.netty.native.workdir: /tmp (io.netty.tmpdir)
2022-03-21 03:38:34.204 DEBUG 1 --- [ main] i.n.util.internal.NativeLibraryLoader : -Dio.netty.native.deleteLibAfterLoading: true
2022-03-21 03:38:34.204 DEBUG 1 --- [ main] i.n.util.internal.NativeLibraryLoader : -Dio.netty.native.tryPatchShadedId: true
2022-03-21 03:38:34.263 DEBUG 1 --- [ main] i.n.util.internal.NativeLibraryLoader : Successfully loaded the library /tmp/libnetty_transport_native_epoll_x86_646344602424093795613.so
2022-03-21 03:38:34.284 DEBUG 1 --- [ main] io.netty.util.NetUtil : -Djava.net.preferIPv4Stack: false
2022-03-21 03:38:34.285 DEBUG 1 --- [ main] io.netty.util.NetUtil : -Djava.net.preferIPv6Addresses: false
2022-03-21 03:38:34.294 DEBUG 1 --- [ main] io.netty.util.NetUtilInitializations : Loopback interface: lo (lo, 127.0.0.1)
2022-03-21 03:38:34.299 DEBUG 1 --- [ main] io.netty.util.NetUtil : /proc/sys/net/core/somaxconn: 4096
2022-03-21 03:38:34.300 INFO 1 --- [ main] com.datastax.driver.core.NettyUtil : Found Netty's native epoll transport in the classpath, using it
2022-03-21 03:38:34.409 DEBUG 1 --- [ main] i.n.channel.MultithreadEventLoopGroup : -Dio.netty.eventLoopThreads: 4
2022-03-21 03:38:34.557 DEBUG 1 --- [ main] i.netty.util.internal.PlatformDependent : org.jctools-core.MpscChunkedArrayQueue: available
2022-03-21 03:38:34.619 DEBUG 1 --- [ main] io.netty.util.ResourceLeakDetector : -Dio.netty.leakDetection.level: simple
2022-03-21 03:38:34.620 DEBUG 1 --- [ main] io.netty.util.ResourceLeakDetector : -Dio.netty.leakDetection.targetRecords: 4
2022-03-21 03:38:34.629 DEBUG 1 --- [ main] i.n.util.ResourceLeakDetectorFactory : Loaded default ResourceLeakDetector: io.netty.util.ResourceLeakDetector@4390b78f
2022-03-21 03:38:34.660 DEBUG 1 --- [ main] c.datastax.driver.core.SystemProperties : com.datastax.driver.EXTENDED_PEER_CHECK is undefined, using default value true
2022-03-21 03:38:34.826 DEBUG 1 --- [ main] com.datastax.driver.core.Host.STATES : [cassandra/10.233.69.27:9042] preparing to open 1 new connections, total = 1
2022-03-21 03:38:34.838 DEBUG 1 --- [ main] c.datastax.driver.core.SystemProperties : com.datastax.driver.DISABLE_COALESCING is undefined, using default value false
2022-03-21 03:38:34.839 DEBUG 1 --- [ main] c.datastax.driver.core.SystemProperties : com.datastax.driver.FLUSHER_SCHEDULE_PERIOD_NS is undefined, using default value 10000
2022-03-21 03:38:34.839 DEBUG 1 --- [ main] c.datastax.driver.core.SystemProperties : com.datastax.driver.FLUSHER_RUN_WITHOUT_WORK_TIMES is undefined, using default value 5
2022-03-21 03:38:35.027 DEBUG 1 --- [ main] io.netty.buffer.PooledByteBufAllocator : -Dio.netty.allocator.numHeapArenas: 4
2022-03-21 03:38:35.027 DEBUG 1 --- [ main] io.netty.buffer.PooledByteBufAllocator : -Dio.netty.allocator.numDirectArenas: 4
2022-03-21 03:38:35.027 DEBUG 1 --- [ main] io.netty.buffer.PooledByteBufAllocator : -Dio.netty.allocator.pageSize: 8192
2022-03-21 03:38:35.027 DEBUG 1 --- [ main] io.netty.buffer.PooledByteBufAllocator : -Dio.netty.allocator.maxOrder: 11
2022-03-21 03:38:35.028 DEBUG 1 --- [ main] io.netty.buffer.PooledByteBufAllocator : -Dio.netty.allocator.chunkSize: 16777216
2022-03-21 03:38:35.028 DEBUG 1 --- [ main] io.netty.buffer.PooledByteBufAllocator : -Dio.netty.allocator.smallCacheSize: 256
2022-03-21 03:38:35.028 DEBUG 1 --- [ main] io.netty.buffer.PooledByteBufAllocator : -Dio.netty.allocator.normalCacheSize: 64
2022-03-21 03:38:35.028 DEBUG 1 --- [ main] io.netty.buffer.PooledByteBufAllocator : -Dio.netty.allocator.maxCachedBufferCapacity: 32768
2022-03-21 03:38:35.028 DEBUG 1 --- [ main] io.netty.buffer.PooledByteBufAllocator : -Dio.netty.allocator.cacheTrimInterval: 8192
2022-03-21 03:38:35.028 DEBUG 1 --- [ main] io.netty.buffer.PooledByteBufAllocator : -Dio.netty.allocator.cacheTrimIntervalMillis: 0
2022-03-21 03:38:35.029 DEBUG 1 --- [ main] io.netty.buffer.PooledByteBufAllocator : -Dio.netty.allocator.useCacheForAllThreads: true
2022-03-21 03:38:35.029 DEBUG 1 --- [ main] io.netty.buffer.PooledByteBufAllocator : -Dio.netty.allocator.maxCachedByteBuffersPerChunk: 1023
2022-03-21 03:38:35.132 DEBUG 1 --- [ main] io.netty.channel.DefaultChannelId : -Dio.netty.processId: 1 (auto-detected)
2022-03-21 03:38:35.138 DEBUG 1 --- [ main] io.netty.channel.DefaultChannelId : -Dio.netty.machineId: 1e:77:67:ff:fe:5f:3c:d3 (auto-detected)
2022-03-21 03:38:35.257 DEBUG 1 --- [ main] io.netty.buffer.ByteBufUtil : -Dio.netty.allocator.type: pooled
2022-03-21 03:38:35.257 DEBUG 1 --- [ main] io.netty.buffer.ByteBufUtil : -Dio.netty.threadLocalDirectBufferSize: 0
2022-03-21 03:38:35.257 DEBUG 1 --- [ main] io.netty.buffer.ByteBufUtil : -Dio.netty.maxThreadLocalCharBufferSize: 16384
2022-03-21 03:38:35.462 DEBUG 1 --- [er-nio-worker-0] com.datastax.driver.core.Connection : Connection[cassandra/10.233.69.27:9042-1, inFlight=0, closed=false] Connection established, initializing transport
2022-03-21 03:38:35.558 DEBUG 1 --- [er-nio-worker-0] io.netty.util.Recycler : -Dio.netty.recycler.maxCapacityPerThread: 4096
2022-03-21 03:38:35.559 DEBUG 1 --- [er-nio-worker-0] io.netty.util.Recycler : -Dio.netty.recycler.maxSharedCapacityFactor: 2
2022-03-21 03:38:35.559 DEBUG 1 --- [er-nio-worker-0] io.netty.util.Recycler : -Dio.netty.recycler.linkCapacity: 16
2022-03-21 03:38:35.559 DEBUG 1 --- [er-nio-worker-0] io.netty.util.Recycler : -Dio.netty.recycler.ratio: 8
2022-03-21 03:38:35.560 DEBUG 1 --- [er-nio-worker-0] io.netty.util.Recycler : -Dio.netty.recycler.delayedQueue.ratio: 8
2022-03-21 03:38:35.599 DEBUG 1 --- [er-nio-worker-0] io.netty.buffer.AbstractByteBuf : -Dio.netty.buffer.checkAccessible: true
2022-03-21 03:38:35.600 DEBUG 1 --- [er-nio-worker-0] io.netty.buffer.AbstractByteBuf : -Dio.netty.buffer.checkBounds: true
2022-03-21 03:38:35.600 DEBUG 1 --- [er-nio-worker-0] i.n.util.ResourceLeakDetectorFactory : Loaded default ResourceLeakDetector: io.netty.util.ResourceLeakDetector@43e741f8
2022-03-21 03:38:35.701 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
2022-03-21 03:38:35.739 DEBUG 1 --- [er-nio-worker-0] com.datastax.driver.core.Host.STATES : Defuncting Connection[cassandra/10.233.69.27:9042-1, inFlight=0, closed=false] because: Authentication error on host cassandra/10.233.69.27:9042: Error during authentication of user cassandra : org.apache.cassandra.exceptions.UnavailableException: Cannot achieve consistency level QUORUM
2022-03-21 03:38:35.741 DEBUG 1 --- [er-nio-worker-0] com.datastax.driver.core.Host.STATES : [cassandra/10.233.69.27:9042] preventing new connections for the next 1000 ms
2022-03-21 03:38:35.743 DEBUG 1 --- [er-nio-worker-0] com.datastax.driver.core.Host.STATES : [cassandra/10.233.69.27:9042] Connection[cassandra/10.233.69.27:9042-1, inFlight=0, closed=false] failed, remaining = 0
2022-03-21 03:38:35.745 DEBUG 1 --- [er-nio-worker-0] com.datastax.driver.core.Connection : Connection[cassandra/10.233.69.27:9042-1, inFlight=0, closed=true] closing connection
2022-03-21 03:38:35.758 DEBUG 1 --- [ main] com.datastax.driver.core.Cluster : Shutting down
2022-03-21 03:38:35.758 DEBUG 1 --- [er-nio-worker-0] com.datastax.driver.core.Connection : Connection[cassandra/10.233.69.27: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.233.69.27:9042: Error during authentication of user cassandra : org.apache.cassandra.exceptions.UnavailableException: Cannot achieve consistency level QUORUM
at com.datastax.driver.core.Connection$8.apply(Connection.java:503)
at com.datastax.driver.core.Connection$8.apply(Connection.java:465)
at com.google.common.util.concurrent.Futures$AsyncChainingFuture.doTransform(Futures.java:1442)
at com.google.common.util.concurrent.Futures$AsyncChainingFuture.doTransform(Futures.java:1433)
at com.google.common.util.concurrent.Futures$AbstractChainingFuture.run(Futures.java:1408)
at com.google.common.util.concurrent.MoreExecutors$DirectExecutor.execute(MoreExecutors.java:456)
at com.google.common.util.concurrent.AbstractFuture.executeListener(AbstractFuture.java:817)
at com.google.common.util.concurrent.AbstractFuture.complete(AbstractFuture.java:753)
at com.google.common.util.concurrent.AbstractFuture.set(AbstractFuture.java:613)
at com.datastax.driver.core.Connection$Future.onSet(Connection.java:1479)
at com.datastax.driver.core.Connection$Dispatcher.channelRead0(Connection.java:1233)
at com.datastax.driver.core.Connection$Dispatcher.channelRead0(Connection.java:1151)
at io.netty.channel.SimpleChannelInboundHandler.channelRead(SimpleChannelInboundHandler.java:99)
at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:379)
at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:365)
at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:357)
at io.netty.handler.timeout.IdleStateHandler.channelRead(IdleStateHandler.java:286)
at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:379)
at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:365)
at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:357)
at io.netty.handler.codec.MessageToMessageDecoder.channelRead(MessageToMessageDecoder.java:103)
at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:379)
at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:365)
at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:357)
at io.netty.handler.codec.ByteToMessageDecoder.fireChannelRead(ByteToMessageDecoder.java:324)
at io.netty.handler.codec.ByteToMessageDecoder.channelRead(ByteToMessageDecoder.java:296)
at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:379)
at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:365)
at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:357)
at io.netty.channel.ChannelInboundHandlerAdapter.channelRead(ChannelInboundHandlerAdapter.java:93)
at com.datastax.driver.core.InboundTrafficMeter.channelRead(InboundTrafficMeter.java:38)
at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:379)
at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:365)
at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:357)
at io.netty.channel.DefaultChannelPipeline$HeadContext.channelRead(DefaultChannelPipeline.java:1410)
at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:379)
at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:365)
at io.netty.channel.DefaultChannelPipeline.fireChannelRead(DefaultChannelPipeline.java:919)
at io.netty.channel.epoll.AbstractEpollStreamChannel$EpollStreamUnsafe.epollInReady(AbstractEpollStreamChannel.java:795)
at io.netty.channel.epoll.EpollEventLoop.processReady(EpollEventLoop.java:480)
at io.netty.channel.epoll.EpollEventLoop.run(EpollEventLoop.java:378)
at io.netty.util.concurrent.SingleThreadEventExecutor$4.run(SingleThreadEventExecutor.java:989)
at io.netty.util.internal.ThreadExecutorMap$2.run(ThreadExecutorMap.java:74)
at io.netty.util.concurrent.FastThreadLocalRunnable.run(FastThreadLocalRunnable.java:30)
at java.lang.Thread.run(Thread.java:748)
2022-03-21 03:38:37.832 DEBUG 1 --- [er-nio-worker-0] io.netty.buffer.PoolThreadCache : Freed 4 thread-local buffer(s) from thread: JanusGraph Cluster-nio-worker-0
2022-03-21 03:39:28.474 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 03:39:28.476 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 03:40:28.476 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 03:40:28.483 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 03:41:28.475 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 03:41:28.477 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 03:42:28.474 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 03:42:28.476 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 03:43:28.473 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 03:43:28.475 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 03:44:28.478 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 03:44:28.497 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 03:45:00.003 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 03:45:00.066 DEBUG 1 --- [ scheduling-1] o.o.aai.datasnapshot.DataSnapshotTasks : Exit value of the dataSnapshot check process: 1
2022-03-21 03:45:00.067 DEBUG 1 --- [ scheduling-1] o.o.aai.datasnapshot.DataSnapshotTasks : Started cron job dataSnapshot @ 03:45:00
2022-03-21 03:45:00.068 DEBUG 1 --- [ scheduling-1] o.o.aai.datasnapshot.DataSnapshotTasks : DataSnapshot Params [-c, JUST_TAKE_SNAPSHOT]
2022-03-21 03:45:00.098 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
2022-03-21 03:45:00.099 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
2022-03-21 03:45:00.099 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
2022-03-21 03:45:00.099 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
2022-03-21 03:45:00.099 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
2022-03-21 03:45:00.100 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
2022-03-21 03:45:00.100 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
2022-03-21 03:45:00.100 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
2022-03-21 03:45:00.100 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
2022-03-21 03:45:00.396 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : DataSnapshot command is [JUST_TAKE_SNAPSHOT]
2022-03-21 03:45:00.397 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : File name to reload snapshot []
2022-03-21 03:45:00.397 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : snapshotType is [graphson]
2022-03-21 03:45:00.397 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : Thread count is [15]
2022-03-21 03:45:00.397 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : Max Nodes Per File is [120000]
2022-03-21 03:45:00.398 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : Debug Flag is []
2022-03-21 03:45:00.398 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : DebugAddDelayTimer is [1]
2022-03-21 03:45:00.398 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : VertAddDelayMs is [1]
2022-03-21 03:45:00.398 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : FailureDelayMs is [50]
2022-03-21 03:45:00.399 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : RetryDelayMs is [50]
2022-03-21 03:45:00.399 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : MaxErrorsPerThread is [25]
2022-03-21 03:45:00.399 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : VertToEdgeProcDelay is [9000]
2022-03-21 03:45:00.399 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : StaggerThreadDelay is [5000]
2022-03-21 03:45:00.399 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : Caller process is []
2022-03-21 03:45:00.400 INFO 1 --- [ scheduling-1] org.onap.aai.util.AAIConfig : Initializing AAIConfig
2022-03-21 03:45:00.400 DEBUG 1 --- [ scheduling-1] org.onap.aai.util.AAIConfig : Reloading config from /opt/app/aai-graphadmin/./resources/etc/appprops/aaiconfig.properties
2022-03-21 03:45:00.401 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
2022-03-21 03:45:00.401 INFO 1 --- [ scheduling-1] org.onap.aai.util.AAIConfig : A&AI Server Node Name = aai.config.nodename
2022-03-21 03:45:00.410 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : Command = JUST_TAKE_SNAPSHOT, oldSnapshotFileName = [].
2022-03-21 03:45:00.412 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : ---- NOTE --- about to open graph (takes a little while)
2022-03-21 03:45:00.412 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : Command = JUST_TAKE_SNAPSHOT
2022-03-21 03:45:00.416 DEBUG 1 --- [ scheduling-1] o.o.aai.datasnapshot.DataSnapshotTasks : Ended cron job dataSnapshot @ 03:45:00
2022-03-21 03:45:00.428 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)
2022-03-21 03:45:28.474 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 03:45:28.476 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 03:46:28.489 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 03:46:28.492 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 03:47:28.474 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 03:47:28.475 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 03:48:28.476 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 03:48:28.478 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 03:49:28.488 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 03:49:28.491 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 03:50:28.474 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 03:50:28.476 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 03:51:28.473 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 03:51:28.475 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 03:52:28.477 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 03:52:28.481 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 03:53:28.493 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 03:53:28.496 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 03:54:28.474 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 03:54:28.477 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 03:55:28.473 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 03:55:28.476 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 03:56:28.474 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 03:56:28.476 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 03:57:28.476 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 03:57:28.480 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 03:58:28.474 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 03:58:28.476 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 03:59:28.473 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 03:59:28.476 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:00:28.475 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:00:28.478 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:01:28.479 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:01:28.482 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:02:28.474 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:02:28.476 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:03:28.477 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:03:28.478 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:04:28.474 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:04:28.478 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:05:28.485 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:05:28.488 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:06:28.476 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:06:28.480 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:07:28.488 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:07:28.491 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:08:28.476 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:08:28.478 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:09:28.473 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:09:28.475 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:10:28.474 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:10:28.477 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:11:28.474 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:11:28.480 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:12:28.474 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:12:28.477 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:13:28.485 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:13:28.487 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:14:28.474 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:14:28.476 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:15:28.474 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:15:28.476 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:16:28.474 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:16:28.478 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:17:28.474 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:17:28.478 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:18:28.477 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:18:28.483 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:19:28.476 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:19:28.478 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:20:28.475 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:20:28.478 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:21:28.474 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:21:28.476 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:22:28.476 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:22:28.485 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:23:28.474 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:23:28.477 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:24:28.474 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:24:28.477 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:25:28.474 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:25:28.477 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:26:28.474 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:26:28.477 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:27:28.474 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:27:28.476 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:28:28.473 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:28:28.476 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:29:28.474 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:29:28.479 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:30:28.474 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:30:28.477 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:31:28.475 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:31:28.477 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:32:28.480 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:32:28.492 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:33:28.474 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:33:28.477 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:34:28.480 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:34:28.484 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:35:28.474 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:35:28.477 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:36:28.497 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:36:28.499 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:37:28.475 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:37:28.478 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:38:28.476 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:38:28.478 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:39:28.476 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:39:28.479 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:40:28.475 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:40:28.477 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:41:28.475 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:41:28.476 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:42:28.473 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:42:28.476 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:43:28.473 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:43:28.475 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:44:28.475 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:44:28.479 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:45:00.001 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:45:00.039 DEBUG 1 --- [ scheduling-1] o.o.aai.datasnapshot.DataSnapshotTasks : Exit value of the dataSnapshot check process: 1
2022-03-21 04:45:00.040 DEBUG 1 --- [ scheduling-1] o.o.aai.datasnapshot.DataSnapshotTasks : Started cron job dataSnapshot @ 04:45:00
2022-03-21 04:45:00.040 DEBUG 1 --- [ scheduling-1] o.o.aai.datasnapshot.DataSnapshotTasks : DataSnapshot Params [-c, JUST_TAKE_SNAPSHOT]
2022-03-21 04:45:00.043 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
2022-03-21 04:45:00.043 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
2022-03-21 04:45:00.044 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
2022-03-21 04:45:00.044 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
2022-03-21 04:45:00.044 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
2022-03-21 04:45:00.045 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
2022-03-21 04:45:00.045 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
2022-03-21 04:45:00.046 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
2022-03-21 04:45:00.046 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
2022-03-21 04:45:00.050 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : DataSnapshot command is [JUST_TAKE_SNAPSHOT]
2022-03-21 04:45:00.051 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : File name to reload snapshot []
2022-03-21 04:45:00.051 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : snapshotType is [graphson]
2022-03-21 04:45:00.051 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : Thread count is [15]
2022-03-21 04:45:00.052 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : Max Nodes Per File is [120000]
2022-03-21 04:45:00.052 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : Debug Flag is []
2022-03-21 04:45:00.053 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : DebugAddDelayTimer is [1]
2022-03-21 04:45:00.053 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : VertAddDelayMs is [1]
2022-03-21 04:45:00.053 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : FailureDelayMs is [50]
2022-03-21 04:45:00.054 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : RetryDelayMs is [50]
2022-03-21 04:45:00.054 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : MaxErrorsPerThread is [25]
2022-03-21 04:45:00.055 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : VertToEdgeProcDelay is [9000]
2022-03-21 04:45:00.055 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : StaggerThreadDelay is [5000]
2022-03-21 04:45:00.056 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : Caller process is []
2022-03-21 04:45:00.056 INFO 1 --- [ scheduling-1] org.onap.aai.util.AAIConfig : Initializing AAIConfig
2022-03-21 04:45:00.057 DEBUG 1 --- [ scheduling-1] org.onap.aai.util.AAIConfig : Reloading config from /opt/app/aai-graphadmin/./resources/etc/appprops/aaiconfig.properties
2022-03-21 04:45:00.057 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
2022-03-21 04:45:00.058 INFO 1 --- [ scheduling-1] org.onap.aai.util.AAIConfig : A&AI Server Node Name = aai.config.nodename
2022-03-21 04:45:00.064 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : Command = JUST_TAKE_SNAPSHOT, oldSnapshotFileName = [].
2022-03-21 04:45:00.065 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : ---- NOTE --- about to open graph (takes a little while)
2022-03-21 04:45:00.065 DEBUG 1 --- [ scheduling-1] org.onap.aai.datasnapshot.DataSnapshot : Command = JUST_TAKE_SNAPSHOT
2022-03-21 04:45:00.066 DEBUG 1 --- [ scheduling-1] o.o.aai.datasnapshot.DataSnapshotTasks : Ended cron job dataSnapshot @ 04:45:00
2022-03-21 04:45:00.067 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)
2022-03-21 04:45:28.474 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:45:28.478 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:46:28.476 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:46:28.480 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:47:28.475 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:47:28.484 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:48:28.485 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:48:28.487 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:49:28.475 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:49:28.478 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:50:28.473 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:50:28.479 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:51:28.474 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:51:28.476 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:52:28.473 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:52:28.475 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:53:28.473 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:53:28.475 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:54:28.473 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:54:28.475 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:55:28.475 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:55:28.478 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:56:28.474 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:56:28.476 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:57:28.474 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:57:28.476 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:58:28.479 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:58:28.483 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 04:59:28.474 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 04:59:28.489 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 05:00:28.488 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 05:00:28.494 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 05:01:28.474 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 05:01:28.479 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 05:02:28.477 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 05:02:28.479 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 05:03:28.474 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 05:03:28.476 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 05:04:28.475 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 05:04:28.477 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 05:05:28.474 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 05:05:28.476 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 05:06:28.474 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 05:06:28.477 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 05:07:28.474 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 05:07:28.475 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 05:08:28.474 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 05:08:28.482 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 05:09:28.486 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 05:09:28.489 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 05:10:00.003 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 05:10:00.033 DEBUG 1 --- [ scheduling-1] o.o.aai.datagrooming.DataGroomingTasks : Exit value of the dataGrooming check process: 1
2022-03-21 05:10:00.033 DEBUG 1 --- [ scheduling-1] o.o.aai.datagrooming.DataGroomingTasks : Started cron job dataGrooming @ 05:10:00
2022-03-21 05:10:00.036 ERROR 1 --- [ scheduling-1] o.s.s.s.TaskUtils$LoggingErrorHandler : Unexpected error occurred in scheduled task.
org.onap.aai.exceptions.AAIException: Property key aai.datagrooming.enableskipindexupdatefix cannot be found
at org.onap.aai.util.AAIConfig.get(AAIConfig.java:157)
at org.onap.aai.datagrooming.DataGroomingTasks.groomingScheduleTask(DataGroomingTasks.java:89)
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)
2022-03-21 05:10:28.475 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 05:10:28.479 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 05:11:28.476 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 05:11:28.487 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 05:12:28.473 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 05:12:28.476 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 05:13:28.474 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 05:13:28.476 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 05:14:28.475 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 05:14:28.479 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 05:15:28.477 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 05:15:28.481 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 05:16:28.474 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 05:16:28.476 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 05:17:28.474 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 05:17:28.475 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 05:18:28.476 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 05:18:28.478 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 05:19:28.473 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 05:19:28.476 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 05:20:28.473 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 05:20:28.479 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 05:21:28.474 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 05:21:28.480 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 05:22:28.473 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 05:22:28.475 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 05:23:28.476 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 05:23:28.481 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 05:24:28.474 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 05:24:28.477 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.
2022-03-21 05:25:28.474 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Entering
2022-03-21 05:25:28.476 INFO 1 --- [ scheduling-1] o.o.a.a.logs.AaiScheduledTaskAuditLog : Exiting.