Results

By type

          09:35:53,733 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
09:35:53,735 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [jar:file:/opt/app/onap/lib/org.onap.ccsdk.cds.blueprintsprocessor-blueprintsprocessor-application-1.4.2.jar!/logback.xml]
09:35:53,737 |-WARN in ch.qos.logback.classic.LoggerContext[default] - Resource [logback.xml] occurs multiple times on the classpath.
09:35:53,737 |-WARN in ch.qos.logback.classic.LoggerContext[default] - Resource [logback.xml] occurs at [jar:file:/opt/app/onap/lib/org.onap.ccsdk.cds.blueprintsprocessor-blueprintsprocessor-application-1.4.2.jar!/logback.xml]
09:35:53,737 |-WARN in ch.qos.logback.classic.LoggerContext[default] - Resource [logback.xml] occurs at [file:/opt/app/onap/config/logback.xml]
09:35:53,766 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@399c4be1 - URL [jar:file:/opt/app/onap/lib/org.onap.ccsdk.cds.blueprintsprocessor-blueprintsprocessor-application-1.4.2.jar!/logback.xml] is not of type file
09:35:53,896 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - debug attribute not set
09:35:53,905 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.ConsoleAppender]
09:35:53,907 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [STDOUT]
09:35:53,915 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
09:35:53,986 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [org.springframework] to INFO
09:35:53,986 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [org.springframework.web] to INFO
09:35:53,986 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [org.hibernate] to ERROR
09:35:53,986 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.hazelcast] to ERROR
09:35:53,986 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [org.onap.ccsdk.cds] to INFO
09:35:53,987 |-INFO in ch.qos.logback.classic.joran.action.RootLoggerAction - Setting level of ROOT logger to INFO
09:35:53,987 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [STDOUT] to Logger[ROOT]
09:35:53,987 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - End of configuration.
09:35:54,006 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@291caca8 - Registering current configuration as safe fallback point


  .   ____          _            __ _ _
 /\\ / ___'_ __ _ _(_)_ __  __ _ \ \ \ \
( ( )\___ | '_ | '_| | '_ \/ _` | \ \ \ \
 \\/  ___)| |_)| | | | | || (_| |  ) ) ) )
  '  |____| .__|_| |_|_| |_\__, | / / / /
 =========|_|==============|___/=/_/_/_/
 :: Spring Boot ::               (v2.6.11)

2023-02-03 09:35:56,148|||main||||INFO||||||| Starting BlueprintProcessorApplicationKt v1.4.2 using Java 11.0.9.1 on onap-cds-blueprints-processor-79799b686-h945v with PID 1 (/opt/app/onap/lib/org.onap.ccsdk.cds.blueprintsprocessor-blueprintsprocessor-application-1.4.2.jar started by onap in /app)
2023-02-03 09:35:56,155|||main||||INFO||||||| No active profile set, falling back to 1 default profile: "default"
2023-02-03 09:36:01,634|||main||||INFO||||||| Bootstrapping Spring Data JPA repositories in DEFAULT mode.
2023-02-03 09:36:02,462|||main||||INFO||||||| Finished Spring Data repository scanning in 809 ms. Found 11 JPA repository interfaces.
2023-02-03 09:36:06,255|||main||||INFO||||||| HHH000204: Processing PersistenceUnitInfo [name: default]
2023-02-03 09:36:06,359|||main||||INFO||||||| HHH000412: Hibernate ORM core version 5.6.10.Final
2023-02-03 09:36:06,616|||main||||INFO||||||| HCANN000001: Hibernate Commons Annotations {5.1.2.Final}
2023-02-03 09:36:07,591|||main||||INFO||||||| HHH000400: Using dialect: org.hibernate.dialect.MySQL5InnoDBDialect
2023-02-03 09:36:08,168|||main||||WARN||||||| HHH000481: Encountered Java type [class com.fasterxml.jackson.databind.JsonNode] for which we could not locate a JavaTypeDescriptor and which does not appear to implement equals and/or hashCode.  This can lead to significant performance problems when performing equality/dirty checking involving this Java type.  Consider registering a custom JavaTypeDescriptor or at least implementing equals/hashCode.
2023-02-03 09:36:08,170|||main||||WARN||||||| HHH000481: Encountered Java type [class org.onap.ccsdk.cds.controllerblueprints.resource.dict.ResourceDefinition] for which we could not locate a JavaTypeDescriptor and which does not appear to implement equals and/or hashCode.  This can lead to significant performance problems when performing equality/dirty checking involving this Java type.  Consider registering a custom JavaTypeDescriptor or at least implementing equals/hashCode.
2023-02-03 09:36:08,666|||main||||INFO||||||| HV000001: Hibernate Validator 6.2.4.Final
2023-02-03 09:36:10,786|||main||||INFO||||||| HHH000490: Using JtaPlatform implementation: [org.hibernate.engine.transaction.jta.platform.internal.NoJtaPlatform]
2023-02-03 09:36:10,879|||main||||INFO||||||| Initialized JPA EntityManagerFactory for persistence unit 'default'
2023-02-03 09:36:11,204|||main||||INFO||||||| Application ID: cds > Initializing error catalog message from properties...
2023-02-03 09:36:15,205|||main||||INFO||||||| Audit service is disabled
2023-02-03 09:36:15,513|||main||||INFO||||||| Workflow Audit store is disabled
2023-02-03 09:36:20,839|||main||||INFO||||||| Registering Dictionary Sources : [processor-db=source-db, input=source-input, default=source-default, sdnc=source-rest, aai-data=source-rest, capability=source-capability, rest=source-rest, vault-data=source-rest, script=source-capability, cps-data=source-rest]
2023-02-03 09:36:21,069|||main||||INFO||||||| Dependency Management module created...
2023-02-03 09:36:25,063|||main||||INFO||||||| Exposing 14 endpoint(s) beneath base path '/actuator'
2023-02-03 09:36:26,307|||main||||INFO||||||| Initialised Primary Transaction Manager for url jdbc:mysql://cds-db:3306/sdnctl
2023-02-03 09:36:29,111|||main||||INFO||||||| Netty started on port 8080
2023-02-03 09:36:31,547|||main||||INFO||||||| Starting Blueprint Processor GRPC Starting..
2023-02-03 09:36:32,556|||main||||INFO||||||| Blueprint Processor GRPC server started and ready to serve on port(9111)...
2023-02-03 09:36:32,565|||main||||INFO||||||| Started BlueprintProcessorApplicationKt in 38.242 seconds (JVM running for 39.458)
2023-02-03 09:36:32,630|||DefaultDispatcher-worker-1||||INFO||||||| Cluster is disabled, to enable cluster set the environment CLUSTER_* properties.
2023-02-03 11:39:13,140|e605de88-2b65-4c96-a838-a56c5c6eb076||reactor-http-epoll-2||/api/v1/blueprint-model/bootstrap||INFO|||onap-cds-blueprints-processor-79799b686-h945v|||| Bootstrap request with type load(true), resource dictionary load(true) and cba load(false)
2023-02-03 11:39:13,142|e605de88-2b65-4c96-a838-a56c5c6eb076||reactor-http-epoll-2||/api/v1/blueprint-model/bootstrap||INFO|||onap-cds-blueprints-processor-79799b686-h945v|||| model types load from paths(/opt/app/onap/model-catalog/definition-type/starter-type)
2023-02-03 11:39:13,144|e605de88-2b65-4c96-a838-a56c5c6eb076||reactor-http-epoll-2||/api/v1/blueprint-model/bootstrap||INFO|||onap-cds-blueprints-processor-79799b686-h945v||||  ****** loadModelType(/opt/app/onap/model-catalog/definition-type/starter-type) ********
2023-02-03 11:39:13,558|e605de88-2b65-4c96-a838-a56c5c6eb076||DefaultDispatcher-worker-3||/api/v1/blueprint-model/bootstrap||INFO|||onap-cds-blueprints-processor-79799b686-h945v|||| resource dictionary load from paths(/opt/app/onap/model-catalog/resource-dictionary/starter-dictionary)
2023-02-03 11:39:13,562|e605de88-2b65-4c96-a838-a56c5c6eb076||DefaultDispatcher-worker-3||/api/v1/blueprint-model/bootstrap||INFO|||onap-cds-blueprints-processor-79799b686-h945v||||  ******* loadResourceDictionary(/opt/app/onap/model-catalog/resource-dictionary/starter-dictionary) ********
2023-02-03 11:39:14,822|39c80492-9286-4bb4-a3e6-748db4a1b167||Thread-44||/api/v1/blueprint-model/enrich||INFO|||onap-cds-blueprints-processor-79799b686-h945v|||| Enhancing blueprint(/opt/app/onap/blueprints/working/dd9c6cb7-ba91-4800-a35f-5416c2bc2b75)
2023-02-03 11:39:14,845|39c80492-9286-4bb4-a3e6-748db4a1b167||DefaultDispatcher-worker-30||/api/v1/blueprint-model/enrich||INFO|||onap-cds-blueprints-processor-79799b686-h945v|||| deleting definition types under : /opt/app/onap/blueprints/working/dd9c6cb7-ba91-4800-a35f-5416c2bc2b75/Definitions
2023-02-03 11:39:14,928|39c80492-9286-4bb4-a3e6-748db4a1b167||DefaultDispatcher-worker-30||/api/v1/blueprint-model/enrich||INFO|||onap-cds-blueprints-processor-79799b686-h945v|||| reinitialized all type definitions
2023-02-03 11:39:14,937|39c80492-9286-4bb4-a3e6-748db4a1b167||DefaultDispatcher-worker-30||/api/v1/blueprint-model/enrich||INFO|||onap-cds-blueprints-processor-79799b686-h945v|||| ***** Enhancing NodeTemplate(helloworld)
2023-02-03 11:39:15,028|39c80492-9286-4bb4-a3e6-748db4a1b167||DefaultDispatcher-worker-30||/api/v1/blueprint-model/enrich||INFO|||onap-cds-blueprints-processor-79799b686-h945v|||| enhancing ArtifactDefinition(helloworld-template)
2023-02-03 11:39:15,042|39c80492-9286-4bb4-a3e6-748db4a1b167||DefaultDispatcher-worker-30||/api/v1/blueprint-model/enrich||INFO|||onap-cds-blueprints-processor-79799b686-h945v|||| enhancing ArtifactDefinition(helloworld-mapping)
2023-02-03 11:39:15,058|39c80492-9286-4bb4-a3e6-748db4a1b167||DefaultDispatcher-worker-30||/api/v1/blueprint-model/enrich||INFO|||onap-cds-blueprints-processor-79799b686-h945v|||| enhancing resource mapping file(Templates/hello-world-mapping.json) already enhanced(false)
2023-02-03 11:39:15,108|39c80492-9286-4bb4-a3e6-748db4a1b167||DefaultDispatcher-worker-30||/api/v1/blueprint-model/enrich||INFO|||onap-cds-blueprints-processor-79799b686-h945v|||| ##### Enhancing Workflow(helloworld)
2023-02-03 11:39:15,110|39c80492-9286-4bb4-a3e6-748db4a1b167||DefaultDispatcher-worker-30||/api/v1/blueprint-model/enrich||INFO|||onap-cds-blueprints-processor-79799b686-h945v|||| workflow(helloworld) dependent component NodeTemplates([helloworld])
2023-02-03 11:39:15,111|39c80492-9286-4bb4-a3e6-748db4a1b167||DefaultDispatcher-worker-30||/api/v1/blueprint-model/enrich||INFO|||onap-cds-blueprints-processor-79799b686-h945v|||| identified workflow(helloworld) targets(helloworld)
2023-02-03 11:39:15,111|39c80492-9286-4bb4-a3e6-748db4a1b167||DefaultDispatcher-worker-30||/api/v1/blueprint-model/enrich||INFO|||onap-cds-blueprints-processor-79799b686-h945v|||| resource assignment artifacts(helloworld-mapping) for NodeType(helloworld)
2023-02-03 11:39:15,111|39c80492-9286-4bb4-a3e6-748db4a1b167||DefaultDispatcher-worker-30||/api/v1/blueprint-model/enrich||INFO|||onap-cds-blueprints-processor-79799b686-h945v|||| workflow(helloworld) resource assignment files([Templates/hello-world-mapping.json]
2023-02-03 11:39:15,112|39c80492-9286-4bb4-a3e6-748db4a1b167||DefaultDispatcher-worker-30||/api/v1/blueprint-model/enrich||INFO|||onap-cds-blueprints-processor-79799b686-h945v|||| enriching artifacts file(/opt/app/onap/blueprints/working/dd9c6cb7-ba91-4800-a35f-5416c2bc2b75/Templates/hello-world-mapping.json
2023-02-03 11:39:15,122|39c80492-9286-4bb4-a3e6-748db4a1b167||DefaultDispatcher-worker-30||/api/v1/blueprint-model/enrich||INFO|||onap-cds-blueprints-processor-79799b686-h945v|||| enhancing workflow resource mapping file(Templates/hello-world-mapping.json) already enhanced(true)
2023-02-03 11:39:15,122|39c80492-9286-4bb4-a3e6-748db4a1b167||DefaultDispatcher-worker-30||/api/v1/blueprint-model/enrich||INFO|||onap-cds-blueprints-processor-79799b686-h945v|||| dataType not present for the recipe(dt-helloworld-properties)
2023-02-03 11:39:15,122|39c80492-9286-4bb4-a3e6-748db4a1b167||DefaultDispatcher-worker-30||/api/v1/blueprint-model/enrich||INFO|||onap-cds-blueprints-processor-79799b686-h945v|||| ##### Enhancing blueprint Resource Definitions
2023-02-03 11:39:15,123|39c80492-9286-4bb4-a3e6-748db4a1b167||DefaultDispatcher-worker-30||/api/v1/blueprint-model/enrich||INFO|||onap-cds-blueprints-processor-79799b686-h945v|||| resources assignment files ([Templates/hello-world-mapping.json])
2023-02-03 11:39:15,125|39c80492-9286-4bb4-a3e6-748db4a1b167||DefaultDispatcher-worker-30||/api/v1/blueprint-model/enrich||INFO|||onap-cds-blueprints-processor-79799b686-h945v|||| processing file (Templates/hello-world-mapping.json)
2023-02-03 11:39:15,140|39c80492-9286-4bb4-a3e6-748db4a1b167||DefaultDispatcher-worker-30||/api/v1/blueprint-model/enrich||INFO|||onap-cds-blueprints-processor-79799b686-h945v|||| distinct resource keys ([])
2023-02-03 11:39:15,141|39c80492-9286-4bb4-a3e6-748db4a1b167||DefaultDispatcher-worker-30||/api/v1/blueprint-model/enrich||INFO|||onap-cds-blueprints-processor-79799b686-h945v|||| Enriching Resource Definition sources Node Template: []
2023-02-03 11:39:15,386|86ef6786-ec5f-4c72-a1fc-47dbe1a55ede||Thread-44||/api/v1/blueprint-model/publish||INFO|||onap-cds-blueprints-processor-79799b686-h945v|||| Save processing(c87e5f73-fd90-4869-9d46-6ad8e4de2227) CBA(/opt/app/onap/blueprints/archive/c87e5f73-fd90-4869-9d46-6ad8e4de2227/cba.zip)
2023-02-03 11:39:15,399|86ef6786-ec5f-4c72-a1fc-47dbe1a55ede||DefaultDispatcher-worker-30||/api/v1/blueprint-model/publish||INFO|||onap-cds-blueprints-processor-79799b686-h945v|||| Reading blueprint type(DEFAULT) path(/opt/app/onap/blueprints/working/c87e5f73-fd90-4869-9d46-6ad8e4de2227) and entry definition file (Definitions/blueprint.json)
2023-02-03 11:39:15,463|86ef6786-ec5f-4c72-a1fc-47dbe1a55ede||DefaultDispatcher-worker-30||/api/v1/blueprint-model/publish||INFO|||onap-cds-blueprints-processor-79799b686-h945v|||| Validating Workflow(helloworld)
2023-02-03 11:39:15,476|86ef6786-ec5f-4c72-a1fc-47dbe1a55ede||DefaultDispatcher-worker-30||/api/v1/blueprint-model/publish||INFO|||onap-cds-blueprints-processor-79799b686-h945v|||| Reading blueprint type(DEFAULT) path(/opt/app/onap/blueprints/working/c87e5f73-fd90-4869-9d46-6ad8e4de2227) and entry definition file (Definitions/blueprint.json)
2023-02-03 11:39:15,683|86ef6786-ec5f-4c72-a1fc-47dbe1a55ede||DefaultDispatcher-worker-30||/api/v1/blueprint-model/publish||WARN|||onap-cds-blueprints-processor-79799b686-h945v|||| No compiled cache(/opt/app/onap/blueprints/working/c87e5f73-fd90-4869-9d46-6ad8e4de2227) present to clean.
2023-02-03 11:39:15,839|654321||reactor-http-epoll-1||||INFO||||||| processing request id 654321
2023-02-03 11:39:15,839|654321||reactor-http-epoll-1||||INFO||||||| storeExecutionInput called not to store the Workflow action input details 
2023-02-03 11:39:15,842|654321||reactor-http-epoll-1||||INFO||||||| StoreAuditService ID  -1
2023-02-03 11:39:15,849|654321||DefaultDispatcher-worker-30||||INFO||||||| getting cba file name(test101), version(1.0.1) from db
2023-02-03 11:39:15,923|654321||DefaultDispatcher-worker-30||||INFO||||||| cba file name(test101), version(1.0.1) saved in (/opt/app/onap/blueprints/deploy/test101/1.0.1)
2023-02-03 11:39:15,927|654321||DefaultDispatcher-worker-30||||INFO||||||| blueprint base path /opt/app/onap/blueprints/deploy/test101/1.0.1
2023-02-03 11:39:15,929|654321||DefaultDispatcher-worker-30||||INFO||||||| Reading blueprint type(DEFAULT) path(/opt/app/onap/blueprints/deploy/test101/1.0.1) and entry definition file (Definitions/blueprint.json)
2023-02-03 11:39:15,947|654321||DefaultDispatcher-worker-30||||INFO||||||| Deriving input data for workflow: (helloworld)
2023-02-03 11:39:15,948|654321||DefaultDispatcher-worker-30||||INFO||||||| Executing workflow(helloworld) NodeTemplate(helloworld), derived from(tosca.nodes.Component)
2023-02-03 11:39:15,958|654321||DefaultDispatcher-worker-30||||INFO||||||| executing node template(helloworld) component(component-resource-resolution) interface(ResourceResolutionComponent) operation(process) on host (SELF) with timeout(180) sec.
2023-02-03 11:39:15,965|654321||DefaultDispatcher-worker-30||||INFO||||||| preparing request id(654321) for workflow(helloworld) step(helloworld)
2023-02-03 11:39:15,966|654321||DefaultDispatcher-worker-30||||INFO||||||| resolveNodeTemplateInterfaceOperationInputs for node template (helloworld), interface name(ResourceResolutionComponent), operationName(process)
2023-02-03 11:39:15,967|654321||DefaultDispatcher-worker-30||||INFO||||||| input definition for node template (helloworld), values ({artifact-prefix-names=["helloworld"]})
2023-02-03 11:39:15,991|654321||DefaultDispatcher-worker-30||||INFO||||||| Resolving resource with resource assignment artifact(helloworld-mapping)
2023-02-03 11:39:16,015|654321||DefaultDispatcher-worker-30||||INFO||||||| Batched Sequence : ([])
2023-02-03 11:39:16,018|654321||DefaultDispatcher-worker-30||||INFO||||||| Generated Resource Param Data ({ })
2023-02-03 11:39:16,152|654321||DefaultDispatcher-worker-30||||INFO||||||| Preparing Response...
2023-02-03 11:39:16,155|654321||DefaultDispatcher-worker-30||||INFO||||||| resolveNodeTemplateInterfaceOperationOutputs for node template (helloworld),interface name (ResourceResolutionComponent), operationName(process)
2023-02-03 11:39:16,156|654321||DefaultDispatcher-worker-30||||INFO||||||| resolveWorkflowOutputs for workflow(helloworld)
2023-02-03 11:39:16,169|654321||DefaultDispatcher-worker-30||||INFO||||||| storeExecutionOutput called not to store the Workflow action output details correlationUUID a1e94b11-4251-49dd-baf0-a7f5a89a3999 auditStoreId -1