Results

By type

          05:06:22,725 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
05:06:22,727 |-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]
05:06:22,728 |-WARN in ch.qos.logback.classic.LoggerContext[default] - Resource [logback.xml] occurs multiple times on the classpath.
05:06:22,728 |-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]
05:06:22,728 |-WARN in ch.qos.logback.classic.LoggerContext[default] - Resource [logback.xml] occurs at [file:/opt/app/onap/config/logback.xml]
05:06:22,744 |-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
05:06:22,890 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - debug attribute not set
05:06:22,900 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.ConsoleAppender]
05:06:22,903 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [STDOUT]
05:06:22,911 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
05:06:22,993 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [org.springframework] to INFO
05:06:22,993 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [org.springframework.web] to INFO
05:06:22,993 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [org.hibernate] to ERROR
05:06:22,993 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.hazelcast] to ERROR
05:06:22,993 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [org.onap.ccsdk.cds] to INFO
05:06:22,993 |-INFO in ch.qos.logback.classic.joran.action.RootLoggerAction - Setting level of ROOT logger to INFO
05:06:22,993 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [STDOUT] to Logger[ROOT]
05:06:22,994 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - End of configuration.
05:06:22,996 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@291caca8 - Registering current configuration as safe fallback point


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

2023-01-03 05:06:24,151|||main||||INFO||||||| Starting BlueprintProcessorApplicationKt v1.4.2 using Java 11.0.9.1 on onap-cds-blueprints-processor-6ccf86f86d-wbb48 with PID 1 (/opt/app/onap/lib/org.onap.ccsdk.cds.blueprintsprocessor-blueprintsprocessor-application-1.4.2.jar started by onap in /app)
2023-01-03 05:06:24,154|||main||||INFO||||||| No active profile set, falling back to 1 default profile: "default"
2023-01-03 05:06:26,955|||main||||INFO||||||| Bootstrapping Spring Data JPA repositories in DEFAULT mode.
2023-01-03 05:06:27,526|||main||||INFO||||||| Finished Spring Data repository scanning in 558 ms. Found 11 JPA repository interfaces.
2023-01-03 05:06:29,686|||main||||INFO||||||| HHH000204: Processing PersistenceUnitInfo [name: default]
2023-01-03 05:06:29,766|||main||||INFO||||||| HHH000412: Hibernate ORM core version 5.6.10.Final
2023-01-03 05:06:30,001|||main||||INFO||||||| HCANN000001: Hibernate Commons Annotations {5.1.2.Final}
2023-01-03 05:06:30,512|||main||||INFO||||||| HHH000400: Using dialect: org.hibernate.dialect.MySQL5InnoDBDialect
2023-01-03 05:06:30,855|||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-01-03 05:06:30,857|||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-01-03 05:06:31,246|||main||||INFO||||||| HV000001: Hibernate Validator 6.2.4.Final
2023-01-03 05:06:32,649|||main||||INFO||||||| HHH000490: Using JtaPlatform implementation: [org.hibernate.engine.transaction.jta.platform.internal.NoJtaPlatform]
2023-01-03 05:06:32,663|||main||||INFO||||||| Initialized JPA EntityManagerFactory for persistence unit 'default'
2023-01-03 05:06:32,742|||main||||INFO||||||| Application ID: cds > Initializing error catalog message from properties...
2023-01-03 05:06:34,183|||main||||INFO||||||| Audit service is disabled
2023-01-03 05:06:34,320|||main||||INFO||||||| Workflow Audit store is disabled
2023-01-03 05:06:36,144|||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-01-03 05:06:36,187|||main||||INFO||||||| Dependency Management module created...
2023-01-03 05:06:37,231|||main||||INFO||||||| Exposing 14 endpoint(s) beneath base path '/actuator'
2023-01-03 05:06:37,695|||main||||INFO||||||| Initialised Primary Transaction Manager for url jdbc:mysql://cds-db:3306/sdnctl
2023-01-03 05:06:38,930|||main||||INFO||||||| Netty started on port 8080
2023-01-03 05:06:40,432|||main||||INFO||||||| Starting Blueprint Processor GRPC Starting..
2023-01-03 05:06:40,986|||main||||INFO||||||| Blueprint Processor GRPC server started and ready to serve on port(9111)...
2023-01-03 05:06:40,992|||main||||INFO||||||| Started BlueprintProcessorApplicationKt in 17.785 seconds (JVM running for 18.825)
2023-01-03 05:06:41,012|||DefaultDispatcher-worker-1||||INFO||||||| Cluster is disabled, to enable cluster set the environment CLUSTER_* properties.
2023-01-03 06:30:06,002|afbc54f4-523d-4118-8e99-ea72b79584d3||reactor-http-epoll-4||/api/v1/blueprint-model/bootstrap||INFO|||onap-cds-blueprints-processor-6ccf86f86d-wbb48|||| Bootstrap request with type load(true), resource dictionary load(true) and cba load(false)
2023-01-03 06:30:06,005|afbc54f4-523d-4118-8e99-ea72b79584d3||reactor-http-epoll-4||/api/v1/blueprint-model/bootstrap||INFO|||onap-cds-blueprints-processor-6ccf86f86d-wbb48|||| model types load from paths(/opt/app/onap/model-catalog/definition-type/starter-type)
2023-01-03 06:30:06,007|afbc54f4-523d-4118-8e99-ea72b79584d3||reactor-http-epoll-4||/api/v1/blueprint-model/bootstrap||INFO|||onap-cds-blueprints-processor-6ccf86f86d-wbb48||||  ****** loadModelType(/opt/app/onap/model-catalog/definition-type/starter-type) ********
2023-01-03 06:30:06,407|afbc54f4-523d-4118-8e99-ea72b79584d3||DefaultDispatcher-worker-13||/api/v1/blueprint-model/bootstrap||INFO|||onap-cds-blueprints-processor-6ccf86f86d-wbb48|||| resource dictionary load from paths(/opt/app/onap/model-catalog/resource-dictionary/starter-dictionary)
2023-01-03 06:30:06,411|afbc54f4-523d-4118-8e99-ea72b79584d3||DefaultDispatcher-worker-13||/api/v1/blueprint-model/bootstrap||INFO|||onap-cds-blueprints-processor-6ccf86f86d-wbb48||||  ******* loadResourceDictionary(/opt/app/onap/model-catalog/resource-dictionary/starter-dictionary) ********
2023-01-03 06:30:07,708|e1b04cd9-ce75-4020-930e-bf3b15e698a2||Thread-27||/api/v1/blueprint-model/enrich||INFO|||onap-cds-blueprints-processor-6ccf86f86d-wbb48|||| Enhancing blueprint(/opt/app/onap/blueprints/working/1e4d5205-a3f4-49b5-8886-53c48844c264)
2023-01-03 06:30:07,729|e1b04cd9-ce75-4020-930e-bf3b15e698a2||DefaultDispatcher-worker-13||/api/v1/blueprint-model/enrich||INFO|||onap-cds-blueprints-processor-6ccf86f86d-wbb48|||| deleting definition types under : /opt/app/onap/blueprints/working/1e4d5205-a3f4-49b5-8886-53c48844c264/Definitions
2023-01-03 06:30:07,856|e1b04cd9-ce75-4020-930e-bf3b15e698a2||DefaultDispatcher-worker-13||/api/v1/blueprint-model/enrich||INFO|||onap-cds-blueprints-processor-6ccf86f86d-wbb48|||| reinitialized all type definitions
2023-01-03 06:30:07,865|e1b04cd9-ce75-4020-930e-bf3b15e698a2||DefaultDispatcher-worker-13||/api/v1/blueprint-model/enrich||INFO|||onap-cds-blueprints-processor-6ccf86f86d-wbb48|||| ***** Enhancing NodeTemplate(helloworld)
2023-01-03 06:30:07,904|e1b04cd9-ce75-4020-930e-bf3b15e698a2||DefaultDispatcher-worker-13||/api/v1/blueprint-model/enrich||INFO|||onap-cds-blueprints-processor-6ccf86f86d-wbb48|||| enhancing ArtifactDefinition(helloworld-template)
2023-01-03 06:30:07,909|e1b04cd9-ce75-4020-930e-bf3b15e698a2||DefaultDispatcher-worker-13||/api/v1/blueprint-model/enrich||INFO|||onap-cds-blueprints-processor-6ccf86f86d-wbb48|||| enhancing ArtifactDefinition(helloworld-mapping)
2023-01-03 06:30:07,919|e1b04cd9-ce75-4020-930e-bf3b15e698a2||DefaultDispatcher-worker-13||/api/v1/blueprint-model/enrich||INFO|||onap-cds-blueprints-processor-6ccf86f86d-wbb48|||| enhancing resource mapping file(Templates/hello-world-mapping.json) already enhanced(false)
2023-01-03 06:30:07,961|e1b04cd9-ce75-4020-930e-bf3b15e698a2||DefaultDispatcher-worker-13||/api/v1/blueprint-model/enrich||INFO|||onap-cds-blueprints-processor-6ccf86f86d-wbb48|||| ##### Enhancing Workflow(helloworld)
2023-01-03 06:30:07,963|e1b04cd9-ce75-4020-930e-bf3b15e698a2||DefaultDispatcher-worker-13||/api/v1/blueprint-model/enrich||INFO|||onap-cds-blueprints-processor-6ccf86f86d-wbb48|||| workflow(helloworld) dependent component NodeTemplates([helloworld])
2023-01-03 06:30:07,963|e1b04cd9-ce75-4020-930e-bf3b15e698a2||DefaultDispatcher-worker-13||/api/v1/blueprint-model/enrich||INFO|||onap-cds-blueprints-processor-6ccf86f86d-wbb48|||| identified workflow(helloworld) targets(helloworld)
2023-01-03 06:30:07,964|e1b04cd9-ce75-4020-930e-bf3b15e698a2||DefaultDispatcher-worker-13||/api/v1/blueprint-model/enrich||INFO|||onap-cds-blueprints-processor-6ccf86f86d-wbb48|||| resource assignment artifacts(helloworld-mapping) for NodeType(helloworld)
2023-01-03 06:30:07,964|e1b04cd9-ce75-4020-930e-bf3b15e698a2||DefaultDispatcher-worker-13||/api/v1/blueprint-model/enrich||INFO|||onap-cds-blueprints-processor-6ccf86f86d-wbb48|||| workflow(helloworld) resource assignment files([Templates/hello-world-mapping.json]
2023-01-03 06:30:07,965|e1b04cd9-ce75-4020-930e-bf3b15e698a2||DefaultDispatcher-worker-13||/api/v1/blueprint-model/enrich||INFO|||onap-cds-blueprints-processor-6ccf86f86d-wbb48|||| enriching artifacts file(/opt/app/onap/blueprints/working/1e4d5205-a3f4-49b5-8886-53c48844c264/Templates/hello-world-mapping.json
2023-01-03 06:30:07,977|e1b04cd9-ce75-4020-930e-bf3b15e698a2||DefaultDispatcher-worker-13||/api/v1/blueprint-model/enrich||INFO|||onap-cds-blueprints-processor-6ccf86f86d-wbb48|||| enhancing workflow resource mapping file(Templates/hello-world-mapping.json) already enhanced(true)
2023-01-03 06:30:07,977|e1b04cd9-ce75-4020-930e-bf3b15e698a2||DefaultDispatcher-worker-13||/api/v1/blueprint-model/enrich||INFO|||onap-cds-blueprints-processor-6ccf86f86d-wbb48|||| dataType not present for the recipe(dt-helloworld-properties)
2023-01-03 06:30:07,978|e1b04cd9-ce75-4020-930e-bf3b15e698a2||DefaultDispatcher-worker-13||/api/v1/blueprint-model/enrich||INFO|||onap-cds-blueprints-processor-6ccf86f86d-wbb48|||| ##### Enhancing blueprint Resource Definitions
2023-01-03 06:30:07,978|e1b04cd9-ce75-4020-930e-bf3b15e698a2||DefaultDispatcher-worker-13||/api/v1/blueprint-model/enrich||INFO|||onap-cds-blueprints-processor-6ccf86f86d-wbb48|||| resources assignment files ([Templates/hello-world-mapping.json])
2023-01-03 06:30:07,980|e1b04cd9-ce75-4020-930e-bf3b15e698a2||DefaultDispatcher-worker-13||/api/v1/blueprint-model/enrich||INFO|||onap-cds-blueprints-processor-6ccf86f86d-wbb48|||| processing file (Templates/hello-world-mapping.json)
2023-01-03 06:30:07,999|e1b04cd9-ce75-4020-930e-bf3b15e698a2||DefaultDispatcher-worker-13||/api/v1/blueprint-model/enrich||INFO|||onap-cds-blueprints-processor-6ccf86f86d-wbb48|||| distinct resource keys ([])
2023-01-03 06:30:08,000|e1b04cd9-ce75-4020-930e-bf3b15e698a2||DefaultDispatcher-worker-13||/api/v1/blueprint-model/enrich||INFO|||onap-cds-blueprints-processor-6ccf86f86d-wbb48|||| Enriching Resource Definition sources Node Template: []
2023-01-03 06:30:08,333|3e080593-f043-4fc5-9fcc-2a2950fc79dd||Thread-27||/api/v1/blueprint-model/publish||INFO|||onap-cds-blueprints-processor-6ccf86f86d-wbb48|||| Save processing(6305f3e6-2665-4d0b-9127-e28095328785) CBA(/opt/app/onap/blueprints/archive/6305f3e6-2665-4d0b-9127-e28095328785/cba.zip)
2023-01-03 06:30:08,350|3e080593-f043-4fc5-9fcc-2a2950fc79dd||DefaultDispatcher-worker-13||/api/v1/blueprint-model/publish||INFO|||onap-cds-blueprints-processor-6ccf86f86d-wbb48|||| Reading blueprint type(DEFAULT) path(/opt/app/onap/blueprints/working/6305f3e6-2665-4d0b-9127-e28095328785) and entry definition file (Definitions/blueprint.json)
2023-01-03 06:30:08,411|3e080593-f043-4fc5-9fcc-2a2950fc79dd||DefaultDispatcher-worker-13||/api/v1/blueprint-model/publish||INFO|||onap-cds-blueprints-processor-6ccf86f86d-wbb48|||| Validating Workflow(helloworld)
2023-01-03 06:30:08,426|3e080593-f043-4fc5-9fcc-2a2950fc79dd||DefaultDispatcher-worker-13||/api/v1/blueprint-model/publish||INFO|||onap-cds-blueprints-processor-6ccf86f86d-wbb48|||| Reading blueprint type(DEFAULT) path(/opt/app/onap/blueprints/working/6305f3e6-2665-4d0b-9127-e28095328785) and entry definition file (Definitions/blueprint.json)
2023-01-03 06:30:08,602|3e080593-f043-4fc5-9fcc-2a2950fc79dd||DefaultDispatcher-worker-13||/api/v1/blueprint-model/publish||WARN|||onap-cds-blueprints-processor-6ccf86f86d-wbb48|||| No compiled cache(/opt/app/onap/blueprints/working/6305f3e6-2665-4d0b-9127-e28095328785) present to clean.
2023-01-03 06:30:08,842|654321||reactor-http-epoll-4||||INFO||||||| processing request id 654321
2023-01-03 06:30:08,842|654321||reactor-http-epoll-4||||INFO||||||| storeExecutionInput called not to store the Workflow action input details 
2023-01-03 06:30:08,846|654321||reactor-http-epoll-4||||INFO||||||| StoreAuditService ID  -1
2023-01-03 06:30:08,853|654321||DefaultDispatcher-worker-13||||INFO||||||| getting cba file name(test101), version(1.0.1) from db
2023-01-03 06:30:08,981|654321||DefaultDispatcher-worker-13||||INFO||||||| cba file name(test101), version(1.0.1) saved in (/opt/app/onap/blueprints/deploy/test101/1.0.1)
2023-01-03 06:30:08,984|654321||DefaultDispatcher-worker-13||||INFO||||||| blueprint base path /opt/app/onap/blueprints/deploy/test101/1.0.1
2023-01-03 06:30:08,986|654321||DefaultDispatcher-worker-13||||INFO||||||| Reading blueprint type(DEFAULT) path(/opt/app/onap/blueprints/deploy/test101/1.0.1) and entry definition file (Definitions/blueprint.json)
2023-01-03 06:30:09,003|654321||DefaultDispatcher-worker-13||||INFO||||||| Deriving input data for workflow: (helloworld)
2023-01-03 06:30:09,004|654321||DefaultDispatcher-worker-13||||INFO||||||| Executing workflow(helloworld) NodeTemplate(helloworld), derived from(tosca.nodes.Component)
2023-01-03 06:30:09,022|654321||DefaultDispatcher-worker-13||||INFO||||||| executing node template(helloworld) component(component-resource-resolution) interface(ResourceResolutionComponent) operation(process) on host (SELF) with timeout(180) sec.
2023-01-03 06:30:09,031|654321||DefaultDispatcher-worker-13||||INFO||||||| preparing request id(654321) for workflow(helloworld) step(helloworld)
2023-01-03 06:30:09,032|654321||DefaultDispatcher-worker-13||||INFO||||||| resolveNodeTemplateInterfaceOperationInputs for node template (helloworld), interface name(ResourceResolutionComponent), operationName(process)
2023-01-03 06:30:09,033|654321||DefaultDispatcher-worker-13||||INFO||||||| input definition for node template (helloworld), values ({artifact-prefix-names=["helloworld"]})
2023-01-03 06:30:09,056|654321||DefaultDispatcher-worker-13||||INFO||||||| Resolving resource with resource assignment artifact(helloworld-mapping)
2023-01-03 06:30:09,088|654321||DefaultDispatcher-worker-13||||INFO||||||| Batched Sequence : ([])
2023-01-03 06:30:09,091|654321||DefaultDispatcher-worker-13||||INFO||||||| Generated Resource Param Data ({ })
2023-01-03 06:30:09,192|654321||DefaultDispatcher-worker-13||||INFO||||||| Preparing Response...
2023-01-03 06:30:09,195|654321||DefaultDispatcher-worker-13||||INFO||||||| resolveNodeTemplateInterfaceOperationOutputs for node template (helloworld),interface name (ResourceResolutionComponent), operationName(process)
2023-01-03 06:30:09,195|654321||DefaultDispatcher-worker-13||||INFO||||||| resolveWorkflowOutputs for workflow(helloworld)
2023-01-03 06:30:09,203|654321||DefaultDispatcher-worker-13||||INFO||||||| storeExecutionOutput called not to store the Workflow action output details correlationUUID bd463d50-d383-403a-9312-7e8173562f79 auditStoreId -1