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