By type
JVM Arguments: -Dspring.profiles.active=basic -Djava.security.egd=file:/dev/./urandom -Dlogs_dir=./logs/so-etsi-nfvo-ns-lcm/ -Dlogging.config=/app/logback-spring.xml -Djavax.net.ssl.trustStore=/opt/app/osaaf/local/truststoreONAPall.jks -Djavax.net.ssl.trustStorePassword=changeit -Dspring.config.additional-location=/app/config/override.yaml
____ _ ____ ____ __ __
/ ___| __ _ _ __ ___ _ _ _ __ __| | __ _ | __ )| _ \| \/ |
| | / _` | '_ ` _ \| | | | '_ \ / _` |/ _` | | _ \| |_) | |\/| |
| |__| (_| | | | | | | |_| | | | | (_| | (_| | | |_) | __/| | | |
\____/\__,_|_| |_| |_|\__,_|_| |_|\__,_|\__,_| |____/|_| |_| |_|
Spring-Boot: (v2.3.7.RELEASE)
Camunda BPM: (v7.14.0)
Camunda BPM Spring Boot Starter: (v7.14.0)
2022-09-22T02:50:10.593Z||main|||||INFO|500||Starting Application on onap-so-etsi-nfvo-ns-lcm-67d9754f95-ql8xj with PID 17 (/app/app.jar started by so in /app)
2022-09-22T02:50:10.601Z||main|||||DEBUG|500||Running with Spring Boot v2.3.7.RELEASE, Spring v5.2.12.RELEASE
2022-09-22T02:50:10.602Z||main|||||INFO|500||The following profiles are active: basic
2022-09-22T02:50:24.137Z||main|||||INFO|500||Starting service [Tomcat]
2022-09-22T02:50:24.138Z||main|||||INFO|500||Starting Servlet engine: [Apache Tomcat/9.0.41]
2022-09-22T02:50:24.495Z||main|||||INFO|500||Initializing Spring embedded WebApplicationContext
2022-09-22T02:50:24.650Z||main|||||INFO|500||Configuring camunda rest api.
2022-09-22T02:50:24.859Z||main|||||INFO|500||Finished configuring camunda rest api.
2022-09-22T02:50:28.101Z||main|||||DEBUG|500||Creating NFVO HikariDataSource bean ...
2022-09-22T02:50:28.105Z||main|||||DEBUG|500||Creating NFVO HikariConfig bean ...
2022-09-22T02:50:28.294Z||main|||||INFO|500||nfvo-pool - Starting...
2022-09-22T02:50:28.663Z||main|||||INFO|500||nfvo-pool - Start completed.
2022-09-22T02:50:28.843Z||main|||||INFO|500||Flyway Community Edition 6.5.7 by Redgate
2022-09-22T02:50:28.995Z||main|||||INFO|500||Database: jdbc:mariadb://mariadb-galera:3306/nfvo (MariaDB 10.5)
2022-09-22T02:50:29.075Z||main|||||WARN|500||Flyway upgrade recommended: MariaDB 10.5 is newer than this version of Flyway and support has not been tested. The latest supported version of MariaDB is 10.4.
2022-09-22T02:50:29.145Z||main|||||INFO|500||Successfully validated 1 migration (execution time 00:00.042s)
2022-09-22T02:50:29.215Z||main|||||INFO|500||Creating Schema History table `nfvo`.`flyway_schema_history` ...
2022-09-22T02:50:29.328Z||main|||||WARN|500||DB: Name 'flyway_schema_history_pk' ignored for PRIMARY key. (SQL State: - Error Code: 1280)
2022-09-22T02:50:29.390Z||main|||||INFO|500||Current version of schema `nfvo`: << Empty Schema >>
2022-09-22T02:50:29.435Z||main|||||INFO|500||Migrating schema `nfvo` to version 1.1 - create nfvo tables
2022-09-22T02:50:29.673Z||main|||||INFO|500||Successfully applied 1 migration to schema `nfvo` (execution time 00:00.305s)
2022-09-22T02:50:30.327Z||main|||||INFO|500||HHH000204: Processing PersistenceUnitInfo [name: nfvo]
2022-09-22T02:50:31.283Z||main|||||INFO|500||HHH000412: Hibernate ORM core version 5.4.25.Final
2022-09-22T02:50:33.327Z||main|||||INFO|500||HCANN000001: Hibernate Commons Annotations {5.1.2.Final}
2022-09-22T02:50:36.711Z||main|||||INFO|500||HHH000400: Using dialect: org.hibernate.dialect.MariaDB103Dialect
2022-09-22T02:50:40.917Z||main|||||INFO|500||HHH000490: Using JtaPlatform implementation: [org.hibernate.engine.transaction.jta.platform.internal.NoJtaPlatform]
2022-09-22T02:50:44.902Z||main|||||DEBUG|500||Creating Camunda HikariDataSource bean ...
2022-09-22T02:50:44.905Z||main|||||DEBUG|500||Creating Camunda HikariConfig bean ...
2022-09-22T02:50:45.235Z||main|||||INFO|500||bpmn-pool - Starting...
2022-09-22T02:50:45.326Z||main|||||INFO|500||bpmn-pool - Start completed.
2022-09-22T02:50:45.454Z||main|||||INFO|500||STARTER-SB040 Setting up jobExecutor with corePoolSize=3, maxPoolSize:30
2022-09-22T02:50:45.880Z||main|||||INFO|500||ENGINE-12003 Plugin 'CompositeProcessEnginePlugin[genericPropertiesConfiguration, camundaProcessEngineConfiguration, camundaDatasourceConfiguration, camundaJpaConfiguration, camundaJobConfiguration, camundaHistoryConfiguration, camundaMetricsConfiguration, camundaAuthorizationConfiguration, camundaDeploymentConfiguration, CreateAdminUserConfiguration[adminUser=AdminUserProperty[id=admin, firstName=Admin, lastName=Admin, email=admin@localhost, password=******]], failedJobConfiguration, CamundaCustomConfiguration, transactionManagerProcessEnginePlugin, eventPublisherPlugin]' activated on process engine 'default'
2022-09-22T02:50:54.582Z||main|||||WARN|500||unable to determine if resource URL [jar:file:/app/app.jar!/BOOT-INF/lib/camunda-engine-dmn-7.14.0.jar!/META-INF/maven/org.camunda.bpm.dmn/] is a deployable resource
2022-09-22T02:50:54.584Z||main|||||WARN|500||unable to determine if resource URL [jar:file:/app/app.jar!/BOOT-INF/lib/camunda-engine-feel-api-7.14.0.jar!/META-INF/maven/org.camunda.bpm.dmn/] is a deployable resource
2022-09-22T02:50:54.584Z||main|||||WARN|500||unable to determine if resource URL [jar:file:/app/app.jar!/BOOT-INF/lib/camunda-engine-feel-juel-7.14.0.jar!/META-INF/maven/org.camunda.bpm.dmn/] is a deployable resource
2022-09-22T02:50:54.585Z||main|||||WARN|500||unable to determine if resource URL [jar:file:/app/app.jar!/BOOT-INF/lib/camunda-engine-feel-scala-7.14.0.jar!/META-INF/maven/org.camunda.bpm.dmn/] is a deployable resource
2022-09-22T02:50:54.586Z||main|||||INFO|500||STARTER-SB021 Auto-Deploying resources: [URL [jar:file:/app/app.jar!/BOOT-INF/lib/so-etsi-nfvo-ns-lcm-bpmn-flows-1.8.2.jar!/TerminateNs.bpmn], URL [jar:file:/app/app.jar!/BOOT-INF/lib/so-etsi-nfvo-ns-lcm-bpmn-flows-1.8.2.jar!/MonitorSol003AdapterCreateNodeStatus.bpmn], URL [jar:file:/app/app.jar!/BOOT-INF/lib/so-etsi-nfvo-ns-lcm-bpmn-flows-1.8.2.jar!/TerminateVnf.bpmn], URL [jar:file:/app/app.jar!/BOOT-INF/lib/so-etsi-nfvo-ns-lcm-bpmn-flows-1.8.2.jar!/DeleteNs.bpmn], URL [jar:file:/app/app.jar!/BOOT-INF/lib/so-etsi-nfvo-ns-lcm-bpmn-flows-1.8.2.jar!/InstantiateNs.bpmn], URL [jar:file:/app/app.jar!/BOOT-INF/lib/so-etsi-nfvo-ns-lcm-bpmn-flows-1.8.2.jar!/MonitorSol003AdapterCreateJob.bpmn], URL [jar:file:/app/app.jar!/BOOT-INF/lib/so-etsi-nfvo-ns-lcm-bpmn-flows-1.8.2.jar!/MonitorSol003AdapterTerminateNodeStatus.bpmn], URL [jar:file:/app/app.jar!/BOOT-INF/lib/so-etsi-nfvo-ns-lcm-bpmn-flows-1.8.2.jar!/CreateNs.bpmn], URL [jar:file:/app/app.jar!/BOOT-INF/lib/so-etsi-nfvo-ns-lcm-bpmn-flows-1.8.2.jar!/CreateInstantiateVnf.bpmn], URL [jar:file:/app/app.jar!/BOOT-INF/lib/so-etsi-nfvo-ns-lcm-bpmn-flows-1.8.2.jar!/MonitorSol003AdapterTerminateJob.bpmn]]
2022-09-22T02:50:54.596Z||main|||||INFO|500||Setting DeploymentTenantId to ns-workflow-engine-tenant and DeploymentName to NS-WORKFLOW-ENGINE
2022-09-22T02:50:54.597Z||main|||||INFO|500||Setting Camunda TransactionManager ...
2022-09-22T02:50:54.600Z||main|||||INFO|500||EVENTING-001: Initialized Camunda Spring Boot Eventing Engine Plugin.
2022-09-22T02:50:54.601Z||main|||||INFO|500||EVENTING-003: Task events will be published as Spring Events.
2022-09-22T02:50:54.602Z||main|||||INFO|500||EVENTING-005: Execution events will be published as Spring Events.
2022-09-22T02:50:54.618Z||main|||||INFO|500||EVENTING-007: History events will be published as Spring events.
2022-09-22T02:50:55.572Z||main|||||INFO|500||Engine created. [value-mapper: CompositeValueMapper(List(org.camunda.feel.impl.JavaValueMapper@69ba3f4e)), function-provider: org.camunda.bpm.dmn.feel.impl.scala.function.CustomFunctionTransformer@752973de, clock: SystemClock, configuration: Configuration(false)]
2022-09-22T02:51:04.487Z||main|||||INFO|500||CNCT-01004 Discovered provider for connector id 'http-connector' and class 'org.camunda.connect.httpclient.impl.HttpConnectorImpl': 'org.camunda.connect.httpclient.impl.HttpConnectorProviderImpl'
2022-09-22T02:51:04.495Z||main|||||INFO|500||CNCT-01004 Discovered provider for connector id 'soap-http-connector' and class 'org.camunda.connect.httpclient.soap.impl.SoapHttpConnectorImpl': 'org.camunda.connect.httpclient.soap.impl.SoapHttpConnectorProviderImpl'
2022-09-22T02:51:04.787Z||main|||||INFO|500||ENGINE-03067 No history level property found in database
2022-09-22T02:51:04.788Z||main|||||INFO|500||ENGINE-03065 Creating historyLevel property in database for level: HistoryLevelFull(name=full, id=3)
2022-09-22T02:51:05.026Z||main|||||INFO|500||ENGINE-00001 Process Engine default created.
2022-09-22T02:51:06.162Z||main|||||INFO|500||STARTER-SB010 creating initial Admin User: AdminUserProperty[id=admin, firstName=Admin, lastName=Admin, email=admin@localhost, password=******]
2022-09-22T02:51:31.035Z||main|||||DEBUG|500||Setting up HttpComponentsClientHttpRequestFactory with SSL Context
2022-09-22T02:51:31.037Z||main|||||DEBUG|500||Setting client trust-store: file:/opt/app/osaaf/local/truststoreONAPall.jks
2022-09-22T02:51:31.038Z||main|||||DEBUG|500||Creating SSLConnectionSocketFactory with AllowAllHostsVerifier ...
2022-09-22T02:51:31.980Z||main|||||WARN|500||spring.jpa.open-in-view is enabled by default. Therefore, database queries may be performed during view rendering. Explicitly configure spring.jpa.open-in-view to disable this warning
2022-09-22T02:51:32.212Z||main|||||INFO|500||Setting ThreadPoolTaskExecutor for async calls ...
2022-09-22T02:51:32.885Z||main|||||DEBUG|500||Injecting class org.onap.so.security.SoBasicHttpSecurityConfigurer configuration ...
2022-09-22T02:51:35.102Z||main|||||INFO|500||Started Application in 87.375 seconds (JVM running for 90.652)
2022-09-22T02:51:35.122Z||main|||||INFO|500||ENGINE-14014 Starting up the JobExecutor[org.camunda.bpm.engine.spring.components.jobexecutor.SpringJobExecutor].
2022-09-22T02:51:35.131Z||JobExecutor[org.camunda.bpm.engine.spring.components.jobexecutor.SpringJobExecutor]|||||INFO|500||ENGINE-14018 JobExecutor[org.camunda.bpm.engine.spring.components.jobexecutor.SpringJobExecutor] starting to acquire jobs
2022-09-22T02:51:35.133Z||main|||||INFO|500||SO ETSI NFVO NS LCM Application started successfully!
2022-09-22T05:51:05.792Z||Camunda BPM Runtime Telemetry Reporter|||||ERROR|500||ENGINE-16004 Exception while closing command context: An exception occurred in the persistence layer. Please check the server logs for a detailed message and the entire exception stack trace.
org.camunda.bpm.engine.ProcessEngineException: An exception occurred in the persistence layer. Please check the server logs for a detailed message and the entire exception stack trace.
at org.camunda.bpm.engine.impl.util.ExceptionUtil.wrapPersistenceException(ExceptionUtil.java:263)
at org.camunda.bpm.engine.impl.db.EnginePersistenceLogger.flushDbOperationException(EnginePersistenceLogger.java:132)
at org.camunda.bpm.engine.impl.db.entitymanager.DbEntityManager.flushDbOperations(DbEntityManager.java:364)
at org.camunda.bpm.engine.impl.db.entitymanager.DbEntityManager.flushDbOperationManager(DbEntityManager.java:323)
at org.camunda.bpm.engine.impl.db.entitymanager.DbEntityManager.flush(DbEntityManager.java:295)
at org.camunda.bpm.engine.impl.interceptor.CommandContext.flushSessions(CommandContext.java:272)
at org.camunda.bpm.engine.impl.interceptor.CommandContext.close(CommandContext.java:188)
at org.camunda.bpm.engine.impl.interceptor.CommandContextInterceptor.execute(CommandContextInterceptor.java:119)
at org.camunda.bpm.engine.spring.SpringTransactionInterceptor$1.doInTransaction(SpringTransactionInterceptor.java:46)
at org.springframework.transaction.support.TransactionTemplate.execute(TransactionTemplate.java:140)
at org.camunda.bpm.engine.spring.SpringTransactionInterceptor.execute(SpringTransactionInterceptor.java:44)
at org.camunda.bpm.engine.impl.interceptor.ProcessApplicationContextInterceptor.execute(ProcessApplicationContextInterceptor.java:70)
at org.camunda.bpm.engine.impl.interceptor.CommandCounterInterceptor.execute(CommandCounterInterceptor.java:35)
at org.camunda.bpm.engine.impl.interceptor.LogInterceptor.execute(LogInterceptor.java:33)
at org.camunda.bpm.engine.impl.telemetry.reporter.TelemetrySendingTask.sendInitialMessage(TelemetrySendingTask.java:154)
at org.camunda.bpm.engine.impl.telemetry.reporter.TelemetrySendingTask.run(TelemetrySendingTask.java:115)
at java.base/java.util.TimerThread.mainLoop(Unknown Source)
at java.base/java.util.TimerThread.run(Unknown Source)
Caused by: org.camunda.bpm.engine.ProcessEngineException: ENGINE-03004 Exception while executing Database Operation 'INSERT PropertyEntity[camunda.telemetry.initial.message.sent]' with message '
### Error flushing statements. Cause: org.apache.ibatis.executor.BatchExecutorException: org.camunda.bpm.engine.impl.persistence.entity.PropertyEntity.insertProperty (batch index #1) failed. Cause: java.sql.BatchUpdateException: (conn=5831) Duplicate entry 'camunda.telemetry.initial.message.sent' for key 'PRIMARY'
### Cause: org.apache.ibatis.executor.BatchExecutorException: org.camunda.bpm.engine.impl.persistence.entity.PropertyEntity.insertProperty (batch index #1) failed. Cause: java.sql.BatchUpdateException: (conn=5831) Duplicate entry 'camunda.telemetry.initial.message.sent' for key 'PRIMARY'
java.sql.BatchUpdateException: (conn=5831) Duplicate entry 'camunda.telemetry.initial.message.sent' for key 'PRIMARY'
java.sql.SQLIntegrityConstraintViolationException: (conn=5831) Duplicate entry 'camunda.telemetry.initial.message.sent' for key 'PRIMARY'
org.mariadb.jdbc.internal.util.exceptions.MariaDbSqlException: Duplicate entry 'camunda.telemetry.initial.message.sent' for key 'PRIMARY'
java.sql.SQLException: Duplicate entry 'camunda.telemetry.initial.message.sent' for key 'PRIMARY'
'. Flush summary:
[
INSERT PropertyEntity[camunda.telemetry.initial.message.sent]
]
at org.camunda.bpm.engine.impl.db.EnginePersistenceLogger.flushDbOperationException(EnginePersistenceLogger.java:131)
... 16 common frames omitted
Caused by: org.apache.ibatis.exceptions.PersistenceException:
### Error flushing statements. Cause: org.apache.ibatis.executor.BatchExecutorException: org.camunda.bpm.engine.impl.persistence.entity.PropertyEntity.insertProperty (batch index #1) failed. Cause: java.sql.BatchUpdateException: (conn=5831) Duplicate entry 'camunda.telemetry.initial.message.sent' for key 'PRIMARY'
### Cause: org.apache.ibatis.executor.BatchExecutorException: org.camunda.bpm.engine.impl.persistence.entity.PropertyEntity.insertProperty (batch index #1) failed. Cause: java.sql.BatchUpdateException: (conn=5831) Duplicate entry 'camunda.telemetry.initial.message.sent' for key 'PRIMARY'
at org.apache.ibatis.exceptions.ExceptionFactory.wrapException(ExceptionFactory.java:30)
at org.apache.ibatis.session.defaults.DefaultSqlSession.flushStatements(DefaultSqlSession.java:254)
at org.camunda.bpm.engine.impl.db.sql.DbSqlSession.flushBatchOperations(DbSqlSession.java:411)
at org.camunda.bpm.engine.impl.db.sql.BatchDbSqlSession.executeDbOperations(BatchDbSqlSession.java:74)
at org.camunda.bpm.engine.impl.db.entitymanager.DbEntityManager.flushDbOperations(DbEntityManager.java:341)
... 15 common frames omitted
Caused by: org.apache.ibatis.executor.BatchExecutorException: org.camunda.bpm.engine.impl.persistence.entity.PropertyEntity.insertProperty (batch index #1) failed. Cause: java.sql.BatchUpdateException: (conn=5831) Duplicate entry 'camunda.telemetry.initial.message.sent' for key 'PRIMARY'
at org.apache.ibatis.executor.BatchExecutor.doFlushStatements(BatchExecutor.java:149)
at org.apache.ibatis.executor.BaseExecutor.flushStatements(BaseExecutor.java:129)
at org.apache.ibatis.executor.BaseExecutor.flushStatements(BaseExecutor.java:122)
at org.apache.ibatis.executor.CachingExecutor.flushStatements(CachingExecutor.java:114)
at org.apache.ibatis.session.defaults.DefaultSqlSession.flushStatements(DefaultSqlSession.java:252)
... 18 common frames omitted
Caused by: java.sql.BatchUpdateException: (conn=5831) Duplicate entry 'camunda.telemetry.initial.message.sent' for key 'PRIMARY'
at org.mariadb.jdbc.MariaDbStatement.executeBatchExceptionEpilogue(MariaDbStatement.java:324)
at org.mariadb.jdbc.ClientSidePreparedStatement.executeBatch(ClientSidePreparedStatement.java:301)
at com.zaxxer.hikari.pool.ProxyStatement.executeBatch(ProxyStatement.java:128)
at com.zaxxer.hikari.pool.HikariProxyPreparedStatement.executeBatch(HikariProxyPreparedStatement.java)
at org.apache.ibatis.executor.BatchExecutor.doFlushStatements(BatchExecutor.java:123)
... 22 common frames omitted
Caused by: java.sql.SQLIntegrityConstraintViolationException: (conn=5831) Duplicate entry 'camunda.telemetry.initial.message.sent' for key 'PRIMARY'
at org.mariadb.jdbc.internal.util.exceptions.ExceptionFactory.createException(ExceptionFactory.java:70)
at org.mariadb.jdbc.internal.util.exceptions.ExceptionFactory.create(ExceptionFactory.java:153)
at org.mariadb.jdbc.MariaDbStatement.executeBatchExceptionEpilogue(MariaDbStatement.java:320)
... 26 common frames omitted
Caused by: org.mariadb.jdbc.internal.util.exceptions.MariaDbSqlException: Duplicate entry 'camunda.telemetry.initial.message.sent' for key 'PRIMARY'
at org.mariadb.jdbc.internal.util.exceptions.MariaDbSqlException.of(MariaDbSqlException.java:34)
at org.mariadb.jdbc.internal.protocol.AbstractQueryProtocol.exceptionWithQuery(AbstractQueryProtocol.java:194)
at org.mariadb.jdbc.internal.protocol.AbstractQueryProtocol.access$000(AbstractQueryProtocol.java:108)
at org.mariadb.jdbc.internal.protocol.AbstractQueryProtocol$1.handleResultException(AbstractQueryProtocol.java:687)
at org.mariadb.jdbc.internal.protocol.AsyncMultiRead.call(AsyncMultiRead.java:159)
at org.mariadb.jdbc.internal.protocol.AsyncMultiRead.call(AsyncMultiRead.java:68)
at java.base/java.util.concurrent.FutureTask.run(Unknown Source)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
at java.base/java.lang.Thread.run(Unknown Source)
Caused by: java.sql.SQLException: Duplicate entry 'camunda.telemetry.initial.message.sent' for key 'PRIMARY'
at org.mariadb.jdbc.internal.protocol.AbstractQueryProtocol.readErrorPacket(AbstractQueryProtocol.java:1688)
at org.mariadb.jdbc.internal.protocol.AbstractQueryProtocol.readPacket(AbstractQueryProtocol.java:1550)
at org.mariadb.jdbc.internal.protocol.AbstractQueryProtocol.getResult(AbstractQueryProtocol.java:1513)
at org.mariadb.jdbc.internal.protocol.AsyncMultiRead.call(AsyncMultiRead.java:150)
... 5 common frames omitted