Policy based deployment for TCAgen2 ----------------------------------- bash-4.2$ cfy install -b tcapolicy -d tcapolicy /blueprints/k8s-tcagen2-policy.yaml /usr/lib/python2.7/site-packages/paramiko/transport.py:33: CryptographyDeprecationWarning: Python 2 is no longer supported by the Python core team. Support for it is now deprecated in cryptography, and will be removed in a future release. from cryptography.hazmat.backends import default_backend Uploading blueprint /blueprints/k8s-tcagen2-policy.yaml... k8s-tcagen2-polic... |################################################| 100.0% Blueprint uploaded. The blueprint's id is tcapolicy Creating new deployment from blueprint tcapolicy... Deployment created. The deployment's id is tcapolicy Executing workflow `install` on deployment `tcapolicy` [timeout=900 seconds] Deployment environment creation is pending... 2020-10-12 18:04:25.567 CFY Starting 'create_deployment_environment' workflow execution 2020-10-12 18:04:25.574 CFY Installing deployment and workflow plugins 2020-10-12 18:04:25.672 CFY Sending task 'cloudify_agent.operations.install_plugins' 2020-10-12 18:04:25.692 CFY Task started 'cloudify_agent.operations.install_plugins' 2020-10-12 18:04:26.920 LOG INFO: Installing plugin: k8s 2020-10-12 18:04:27.769 LOG INFO: Using existing installation of managed plugin: 2591d3b6-f2aa-4c7b-b153-9030fc674e8e [package_name: k8splugin, package_version: 3.4.2, supported_platform: linux_x86_64, distribution: centos, distribution_release: core] 2020-10-12 18:04:27.770 LOG INFO: Installing plugin: dcaepolicy 2020-10-12 18:04:28.498 LOG INFO: Using existing installation of managed plugin: 0e1893cc-36c8-45c9-a550-69d162f73ccd [package_name: dcaepolicyplugin, package_version: 2.4.0, supported_platform: linux_x86_64, distribution: centos, distribution_release: core] 2020-10-12 18:04:28.499 CFY Task succeeded 'cloudify_agent.operations.install_plugins' 2020-10-12 18:04:28.564 CFY Creating deployment work directory 2020-10-12 18:04:28.829 CFY 'create_deployment_environment' workflow execution succeeded 2020-10-12 18:04:32.705 CFY Starting 'install' workflow execution 2020-10-12 18:04:33.326 CFY [tcagen2_policy_6z1ftt] Validating node instance before creation: nothing to do 2020-10-12 18:04:33.500 CFY [tcagen2_policy_6z1ftt] Precreating node instance: nothing to do 2020-10-12 18:04:33.592 CFY [tcagen2_policy_6z1ftt] Creating node instance 2020-10-12 18:04:33.957 CFY [tcagen2_policy_6z1ftt.create] Sending task 'dcaepolicyplugin.policy_get' 2020-10-12 18:04:35.758 LOG [tcagen2_policy_6z1ftt.create] INFO: getting service_url at http://consul:8500/v1/catalog/service/policy_handler 2020-10-12 18:04:35.765 LOG [tcagen2_policy_6z1ftt.create] INFO: got 200 for service_url at http://consul:8500/v1/catalog/service/policy_handler response: [] 2020-10-12 18:04:35.765 LOG [tcagen2_policy_6z1ftt.create] INFO: getting kv at http://consul:8500/v1/kv/dcaepolicyplugin 2020-10-12 18:04:35.771 LOG [tcagen2_policy_6z1ftt.create] INFO: got 404 for kv at http://consul:8500/v1/kv/dcaepolicyplugin response: 2020-10-12 18:04:35.771 LOG [tcagen2_policy_6z1ftt.create] INFO: getting latest policy from http://policy-handler/policy_latest/MICROSERVICE_test-latest-tca_v1_0_tcagen2_1_0_0_lOw headers={"X-ECOMP-RequestID": "9f44d3e9-27cb-450c-8b81-c0aef967aa7d"} 2020-10-12 18:04:35.865 LOG [tcagen2_policy_6z1ftt.create] INFO: latest policy for policy_id(MICROSERVICE_test-latest-tca_v1_0_tcagen2_1_0_0_lOw) status(200) response: {"policy_id": "MICROSERVICE_test-latest-tca_v1_0_tcagen2_1_0_0_lOw", "policy_body": {"type": "onap.policies.monitoring.tcagen2", "type_version": "1.0.0", "name": "MICROSERVICE_test-latest-tca_v1_0_tcagen2_1_0_0_lOw", "version": "1.0.0", "metadata": {"policy-id": "MICROSERVICE_test-latest-tca_v1_0_tcagen2_1_0_0_lOw", "policy-version": "1.0.0"}, "policyName": "MICROSERVICE_test-latest-tca_v1_0_tcagen2_1_0_0_lOw.1-0-0.xml", "policyVersion": "1.0.0", "config": {"tca.policy": {"domain": "measurementsForVfScaling", "metricsPerEventName": [{"policyScope": "DCAE", "thresholds": [{"version": "1.0.2", "severity": "MAJOR", "thresholdValue": 200, "closedLoopEventStatus": "ONSET", "closedLoopControlName": "LOOP_latest-tca-test", "direction": "LESS_OR_EQUAL", "fieldPath": "$.event.measurementsForVfScalingFields.vNicPerformanceArray[*].receivedTotalPacketsDelta"}], "eventName": "vLoadBalancer", "policyVersion": "v0.0.1", "controlLoopSchemaType": "VM", "policyName": "DCAE.Config_tca-hi-lo"}]}}}} 2020-10-12 18:04:35.866 LOG [tcagen2_policy_6z1ftt.create] INFO: found policy MICROSERVICE_test-latest-tca_v1_0_tcagen2_1_0_0_lOw: {"policy_body": {"policyName": "MICROSERVICE_test-latest-tca_v1_0_tcagen2_1_0_0_lOw.1-0-0.xml", "name": "MICROSERVICE_test-latest-tca_v1_0_tcagen2_1_0_0_lOw", "config": {"tca.policy": {"domain": "measurementsForVfScaling", "metricsPerEventName": [{"policyScope": "DCAE", "policyName": "DCAE.Config_tca-hi-lo", "thresholds": [{"direction": "LESS_OR_EQUAL", "severity": "MAJOR", "closedLoopControlName": "LOOP_latest-tca-test", "fieldPath": "$.event.measurementsForVfScalingFields.vNicPerformanceArray[*].receivedTotalPacketsDelta", "version": "1.0.2", "closedLoopEventStatus": "ONSET", "thresholdValue": 200}], "eventName": "vLoadBalancer", "controlLoopSchemaType": "VM", "policyVersion": "v0.0.1"}]}}, "type_version": "1.0.0", "version": "1.0.0", "policyVersion": "1.0.0", "type": "onap.policies.monitoring.tcagen2", "metadata": {"policy-id": "MICROSERVICE_test-latest-tca_v1_0_tcagen2_1_0_0_lOw", "policy-version": "1.0.0"}}, "policy_id": "MICROSERVICE_test-latest-tca_v1_0_tcagen2_1_0_0_lOw"} 2020-10-12 18:04:35.910 LOG [tcagen2_policy_6z1ftt.create] INFO: exit policy_get 2020-10-12 18:04:36.570 CFY [tcagen2_policy_6z1ftt.create] Task succeeded 'dcaepolicyplugin.policy_get' 2020-10-12 18:04:36.597 CFY [tcagen2_policy_6z1ftt] Node instance created 2020-10-12 18:04:36.784 CFY [tcagen2_policy_6z1ftt] Configuring node instance: nothing to do 2020-10-12 18:04:36.895 CFY [tcagen2_policy_6z1ftt] Starting node instance: nothing to do 2020-10-12 18:04:36.997 CFY [tcagen2_policy_6z1ftt] Poststarting node instance: nothing to do 2020-10-12 18:04:37.208 CFY [tcagen2_policy_6z1ftt] Node instance started 2020-10-12 18:04:37.693 CFY [docker.tca_6mvos3] Validating node instance before creation: nothing to do 2020-10-12 18:04:37.879 CFY [docker.tca_6mvos3] Precreating node instance: nothing to do 2020-10-12 18:04:38.124 CFY [docker.tca_6mvos3] Creating node instance 2020-10-12 18:04:38.324 CFY [docker.tca_6mvos3.create] Sending task 'k8splugin.create_for_components' 2020-10-12 18:04:40.233 LOG [docker.tca_6mvos3.create] INFO: Added config for s14f647e71ce24916a555f66a0533590b-dcae-tcagen2-policy 2020-10-12 18:04:40.235 LOG [docker.tca_6mvos3.create] INFO: Done setting up: s14f647e71ce24916a555f66a0533590b-dcae-tcagen2-policy 2020-10-12 18:04:40.243 LOG [docker.tca_6mvos3.create] INFO: response 200 for store_policies http://consul:8500/v1/txn: text={"Results":[{"KV":{"LockIndex":0,"Key":"s14f647e71ce24916a555f66a0533590b-dcae-tcagen2-policy:policies/event","Flags":0,"Value":null,"CreateIndex":76893,"ModifyIndex":76893}},{"KV":{"LockIndex":0,"Key":"s14f647e71ce24916a555f66a0533590b-dcae-tcagen2-policy:policies/items/MICROSERVICE_test-latest-tca_v1_0_tcagen2_1_0_0_lOw","Flags":0,"Value":null,"CreateIndex":76893,"ModifyIndex":76893}}],"Errors":null} txn=[{"KV": {"Verb": "delete-tree", "Key": "s14f647e71ce24916a555f66a0533590b-dcae-tcagen2-policy:policies/"}}, {"KV": {"Verb": "set", "Value": "eyJhY3Rpb24iOiAiZ2F0aGVyZWQiLCAidGltZXN0YW1wIjogIjIwMjAtMTAtMTJUMTg6MDQ6NDAuMjM1WiIsICJ1cGRhdGVfaWQiOiAiMjkwY2Y2YTUtMzNmMi00ZjU2LTkzMzAtMmY0ZWVjYTFjYjBiIiwgInBvbGljaWVzX2NvdW50IjogMX0=", "Key": "s14f647e71ce24916a555f66a0533590b-dcae-tcagen2-policy:policies/event"}}, {"KV": {"Verb": "set", "Value": "eyJwb2xpY3lOYW1lIjogIk1JQ1JPU0VSVklDRV90ZXN0LWxhdGVzdC10Y2FfdjFfMF90Y2FnZW4yXzFfMF8wX2xPdy4xLTAtMC54bWwiLCAibmFtZSI6ICJNSUNST1NFUlZJQ0VfdGVzdC1sYXRlc3QtdGNhX3YxXzBfdGNhZ2VuMl8xXzBfMF9sT3ciLCAiY29uZmlnIjogeyJ0Y2EucG9saWN5IjogeyJkb21haW4iOiAibWVhc3VyZW1lbnRzRm9yVmZTY2FsaW5nIiwgIm1ldHJpY3NQZXJFdmVudE5hbWUiOiBbeyJwb2xpY3lTY29wZSI6ICJEQ0FFIiwgInBvbGljeU5hbWUiOiAiRENBRS5Db25maWdfdGNhLWhpLWxvIiwgInRocmVzaG9sZHMiOiBbeyJkaXJlY3Rpb24iOiAiTEVTU19PUl9FUVVBTCIsICJzZXZlcml0eSI6ICJNQUpPUiIsICJjbG9zZWRMb29wQ29udHJvbE5hbWUiOiAiTE9PUF9sYXRlc3QtdGNhLXRlc3QiLCAiZmllbGRQYXRoIjogIiQuZXZlbnQubWVhc3VyZW1lbnRzRm9yVmZTY2FsaW5nRmllbGRzLnZOaWNQZXJmb3JtYW5jZUFycmF5WypdLnJlY2VpdmVkVG90YWxQYWNrZXRzRGVsdGEiLCAidmVyc2lvbiI6ICIxLjAuMiIsICJjbG9zZWRMb29wRXZlbnRTdGF0dXMiOiAiT05TRVQiLCAidGhyZXNob2xkVmFsdWUiOiAyMDB9XSwgImV2ZW50TmFtZSI6ICJ2TG9hZEJhbGFuY2VyIiwgImNvbnRyb2xMb29wU2NoZW1hVHlwZSI6ICJWTSIsICJwb2xpY3lWZXJzaW9uIjogInYwLjAuMSJ9XX19LCAidHlwZV92ZXJzaW9uIjogIjEuMC4wIiwgInZlcnNpb24iOiAiMS4wLjAiLCAicG9saWN5VmVyc2lvbiI6ICIxLjAuMCIsICJ0eXBlIjogIm9uYXAucG9saWNpZXMubW9uaXRvcmluZy50Y2FnZW4yIiwgIm1ldGFkYXRhIjogeyJwb2xpY3ktaWQiOiAiTUlDUk9TRVJWSUNFX3Rlc3QtbGF0ZXN0LXRjYV92MV8wX3RjYWdlbjJfMV8wXzBfbE93IiwgInBvbGljeS12ZXJzaW9uIjogIjEuMC4wIn19", "Key": "s14f647e71ce24916a555f66a0533590b-dcae-tcagen2-policy:policies/items/MICROSERVICE_test-latest-tca_v1_0_tcagen2_1_0_0_lOw"}}] 2020-10-12 18:04:40.928 CFY [docker.tca_6mvos3.create] Task succeeded 'k8splugin.create_for_components' 2020-10-12 18:04:41.035 CFY [docker.tca_6mvos3] Node instance created 2020-10-12 18:04:41.255 CFY [docker.tca_6mvos3] Configuring node instance: nothing to do 2020-10-12 18:04:41.355 CFY [docker.tca_6mvos3] Starting node instance 2020-10-12 18:04:41.691 CFY [docker.tca_6mvos3.start] Sending task 'k8splugin.create_and_start_container_for_components' 2020-10-12 18:04:44.455 LOG [docker.tca_6mvos3.start] INFO: Starting k8s deployment for s14f647e71ce24916a555f66a0533590b-dcae-tcagen2-policy, image: nexus3.onap.org:10001/onap/org.onap.dcaegen2.analytics.tca-gen2.dcae-analytics-tca-web:1.2.1-20201012T113241Z, env: {'DCAE_CA_CERTPATH': '/etc/tca-gen2/ssl/cacert.pem', 'CONSUL_HOST': u'consul-server.onap', 'CONFIG_BINDING_SERVICE': 'config-binding-service', 'CBS_CONFIG_URL': 'https://config-binding-service:10443/service_component_all/s14f647e71ce24916a555f66a0533590b-dcae-tcagen2-policy'}, kwargs: {'readiness': {u'endpoint': u'/actuator/health', u'type': u'http', u'timeout': u'10s', u'interval': u'30s'}, 'liveness': {}, 'tls_info': {u'use_tls': True, u'cert_directory': u'/etc/tca-gen2/ssl'}, 'envs': {}, 'labels': {'cfydeployment': u'tcapolicy', 'cfynodeinstance': u'docker.tca_6mvos3', 'cfynode': u'docker.tca'}, 'external_cert': {u'use_external_tls': False, u'external_certificate_parameters': {u'common_name': u'', u'sans': u''}, u'cert_type': u'P12', u'external_cert_directory': u'/opt/app/dcae-certificate/external', u'ca_name': u'RA'}, 'resource_config': {}, 'volumes': [], 'log_info': {u'log_directory': u'/opt/logs/dcae-analytics-tca'}, 'ports': [u'9091:0'], 'k8s_location': u'central'} 2020-10-12 18:04:44.458 LOG [docker.tca_6mvos3.start] INFO: Passing k8sconfig: {'filebeat': {u'config_map': u'onap-dcae-filebeat-configmap', u'config_path': u'/usr/share/filebeat/filebeat.yml', u'log_path': u'/var/log/onap', u'image': u'docker.elastic.co/beats/filebeat:5.5.0', u'data_path': u'/usr/share/filebeat/data', u'config_subpath': u'filebeat.yml'}, 'truststore_merger': {u'image_tag': u'nexus3.onap.org:10001/onap/org.onap.oom.platform.cert-service.oom-certservice-post-processor:2.1.0'}, 'cbs': {'base_url': 'https://config-binding-service:10443/service_component_all'}, 'external_cert': {u'country': u'US', u'truststore_password': u'secret', u'cert_secret_name': u'oom-cert-service-client-tls-secret', u'state': u'California', u'organizational_unit': u'ONAP', u'location': u'San-Francisco', u'timeout': u'30000', u'keystore_password': u'secret', u'organization': u'Linux-Foundation', u'request_url': u'https://oom-cert-service:8443/v1/certificate/', u'image_tag': u'nexus3.onap.org:10001/onap/org.onap.oom.platform.cert-service.oom-certservice-client:2.1.0'}, 'default_k8s_location': u'central', 'tls': {u'component_cert_dir': u'/opt/dcae/cacert', u'cert_path': u'/opt/app/osaaf', u'image': u'nexus3.onap.org:10001/onap/org.onap.dcaegen2.deployments.tls-init-container:2.1.0', u'ca_cert_configmap': u'onap-dcae-bootstrap-dcae-cacert', u'component_ca_cert_path': u'/opt/dcae/cacert/cacert.pem'}, 'consul_host': 'consul-server:8500', 'consul_dns_name': u'consul-server.onap', 'max_wait': 1800, 'image_pull_secrets': [u'onap-docker-registry-key'], 'namespace': u'onap'} 2020-10-12 18:04:44.479 LOG [docker.tca_6mvos3.start] INFO: Creating init container: TLS * [nexus3.onap.org:10001/onap/org.onap.dcaegen2.deployments.tls-init-container:2.1.0] 2020-10-12 18:04:44.702 LOG [docker.tca_6mvos3.start] INFO: k8s deployment initiated successfully for s14f647e71ce24916a555f66a0533590b-dcae-tcagen2-policy: {'services': ['s14f647e71ce24916a555f66a0533590b-dcae-tcagen2-policy'], 'namespace': u'onap', 'location': u'central', 'deployment': 'dep-s14f647e71ce24916a555f66a0533590b-dcae-tcagen2-policy'} 2020-10-12 18:04:44.702 LOG [docker.tca_6mvos3.start] INFO: Waiting up to 1800 secs for s14f647e71ce24916a555f66a0533590b-dcae-tcagen2-policy to become ready 2020-10-12 18:05:21.039 LOG [docker.tca_6mvos3.start] INFO: k8s deployment is ready for: s14f647e71ce24916a555f66a0533590b-dcae-tcagen2-policy 2020-10-12 18:05:21.039 LOG [docker.tca_6mvos3.start] INFO: Done starting: s14f647e71ce24916a555f66a0533590b-dcae-tcagen2-policy 2020-10-12 18:05:21.785 CFY [docker.tca_6mvos3.start] Task succeeded 'k8splugin.create_and_start_container_for_components' 2020-10-12 18:05:21.820 CFY [docker.tca_6mvos3] Poststarting node instance: nothing to do 2020-10-12 18:05:21.925 CFY [docker.tca_6mvos3] Node instance started 2020-10-12 18:05:22.362 CFY 'install' workflow execution succeeded Finished executing workflow install on deployment tcapolicy * Run 'cfy events list 3a4eb4e1-7335-49f7-a6af-51e53760b98d' to retrieve the execution's events/logs TCAgen2 logs ------------ 2020-10-12 18:27:03.147 DEBUG 1 --- [ctor-http-nio-4] r.n.resources.PooledConnectionProvider : [id: 0x4190b4d4, L:/10.1.1.249:40194 - R:config-binding-service/10.152.183.196:10443] Channel cleaned, now 0 active connections and 1 inactive connections 2020-10-12T18:27:44.826+0000|fbd7f87c-7a82-40ce-b246-c6d96df62d3f|Request Id: fbd7f87c-7a82-40ce-b246-c6d96df62d3f. Transaction Id: HMSIB. Begin TS: 2020-10-12T18:27:44.826+0000. Starting new DMaaP MR Subscriber poll. 2020-10-12 18:27:44.826 DEBUG 1 --- [ask-scheduler-9] o.o.d.a.w.d.MrTriggerMessageProvider : Request Id: fbd7f87c-7a82-40ce-b246-c6d96df62d3f. Transaction Id: HMSIB. Begin TS: 2020-10-12T18:27:44.826+0000. Starting new DMaaP MR Subscriber poll. 2020-10-12T18:27:44.829+0000|2020-10-12T18:27:45.481+0000|fbd7f87c-7a82-40ce-b246-c6d96df62d3f|UNKNOWN_INSTANCE_ID|task-scheduler-9||s14f647e71ce24916a555f66a0533590b-dcae-tcagen2-policy||DMAAP_MR_SUBSCRIBER|GET-/events/unauthenticated.VES_MEASUREMENT_OUTPUT/cg1-policy/c1|COMPLETE|0|OK||INFO|0|10.1.1.249|652|s14f647e71ce24916a555f66a0533590b-dcae-tcagen2-policy||org.onap.dcae.analytics.web.http.EelfAuditLogInterceptor|||message-router.onap.svc.cluster.local:3904|||||Request Id: fbd7f87c-7a82-40ce-b246-c6d96df62d3f, Transaction Id: HMSIB, Elapsed Time: 652 ms, REST Endpoint Call: OK-GET-/events/unauthenticated.VES_MEASUREMENT_OUTPUT/cg1-policy/c1 2020-10-12 18:27:45.481 INFO 1 --- [ask-scheduler-9] o.o.d.a.w.http.EelfAuditLogInterceptor : Request Id: fbd7f87c-7a82-40ce-b246-c6d96df62d3f, Transaction Id: HMSIB, Elapsed Time: 652 ms, REST Endpoint Call: OK-GET-/events/unauthenticated.VES_MEASUREMENT_OUTPUT/cg1-policy/c1 2020-10-12T18:27:45.485+0000|fbd7f87c-7a82-40ce-b246-c6d96df62d3f|Request Id: fbd7f87c-7a82-40ce-b246-c6d96df62d3f, Transaction Id: HMSIB, Messages Present: true, Next Polling Interval will be: 30000 2020-10-12 18:27:45.484 DEBUG 1 --- [ask-scheduler-9] o.o.d.a.w.d.MrSubscriberPollingAdvice : Request Id: fbd7f87c-7a82-40ce-b246-c6d96df62d3f, Transaction Id: HMSIB, Messages Present: true, Next Polling Interval will be: 30000 2020-10-12 18:27:45.485 DEBUG 1 --- [ask-scheduler-9] o.o.d.a.web.dmaap.MrMessageSplitter : mrMessageSplitter received message: GenericMessage [payload=["{\"event\":{\"commonEventHeader\":{\"startEpochMicrosec\":1507750704126521,\"sourceId\":\"4c32fa09-83e7-43cf-8bba-c72557afe408\",\"eventId\":\"TrafficStats_1.2.3.4\",\"nfcNamingCode\":\"vVNF\",\"reportingEntityId\":\"No UUID available\",\"internalHeaderFields\":{\"collectorTimeStamp\":\"Mon, 10 12 2020 06:26:16 UTC\"},\"eventType\":\"HTTP request rate\",\"priority\":\"Normal\",\"version\":1.2,\"reportingEntityName\":\"fwll\",\"sequence\":85,\"domain\":\"measurementsForVfScaling\",\"lastEpochMicrosec\":1507750714317473,\"eventName\":\"vFirewallBroadcastPackets\",\"sourceName\":\"zdfw1fwl01fwl01\",\"nfNamingCode\":\"vVNF\"},\"measurementsForVfScalingFields\":{\"cpuUsageArray\":[{\"percentUsage\":0,\"cpuIdentifier\":\"cpu1\",\"cpuIdle\":100,\"cpuUsageSystem\":0,\"cpuUsageUser\":0}],\"measurementInterval\":10,\"requestRate\":2256,\"measurementsForVfScalingVersion\":2.1,\"vNicPerformanceArray\":[{\"transmittedOctetsDelta\":0,\"receivedTotalPacketsDelta\":1002,\"vNicIdentifier\":\"eth0\",\"valuesAreSuspect\":\"true\",\"transmittedTotalPacketsDelta\":0,\"receivedOctetsDelta\":61200}]}}}"], headers={Cache-Control=no-store, no-cache, must-revalidate, Server=Jetty(9.4.z-SNAPSHOT), X-ECOMP-RequestID=fbd7f87c-7a82-40ce-b246-c6d96df62d3f, X-ECOMP-TransactionID=HMSIB, X-Begin-Timestamp=2020-10-12T18:27:44.826+0000, Pragma=no-cache, id=3acffdcd-f86a-ffe8-2590-36700a17aed3, Content-Length=1100, contentType=application/json, http_statusCode=200, Date=1602527264000, timestamp=1602527265485}] 2020-10-12T18:27:44.826+0000|2020-10-12T18:27:45.488+0000|fbd7f87c-7a82-40ce-b246-c6d96df62d3f|UNKNOWN_INSTANCE_ID|task-scheduler-9||s14f647e71ce24916a555f66a0533590b-dcae-tcagen2-policy|tca-gen2|COMPLETE|0|||INFO|0|10.1.1.249|662|s14f647e71ce24916a555f66a0533590b-dcae-tcagen2-policy||org.onap.dcae.analytics.web.dmaap.MrMessageSplitter|||||||Request Id: fbd7f87c-7a82-40ce-b246-c6d96df62d3f, Transaction Id: HMSIB, dmaapMessages: [{"event":{"commonEventHeader":{"startEpochMicrosec":1507750704126521,"sourceId":"4c32fa09-83e7-43cf-8bba-c72557afe408","eventId":"TrafficStats_1.2.3.4","nfcNamingCode":"vVNF","reportingEntityId":"No UUID available","internalHeaderFields":{"collectorTimeStamp":"Mon, 10 12 2020 06:26:16 UTC"},"eventType":"HTTP request rate","priority":"Normal","version":1.2,"reportingEntityName":"fwll","sequence":85,"domain":"measurementsForVfScaling","lastEpochMicrosec":1507750714317473,"eventName":"vFirewallBroadcastPackets","sourceName":"zdfw1fwl01fwl01","nfNamingCode":"vVNF"},"measurementsForVfScalingFields":{"cpuUsageArray":[{"percentUsage":0,"cpuIdentifier":"cpu1","cpuIdle":100,"cpuUsageSystem":0,"cpuUsageUser":0}],"measurementInterval":10,"requestRate":2256,"measurementsForVfScalingVersion":2.1,"vNicPerformanceArray":[{"transmittedOctetsDelta":0,"receivedTotalPacketsDelta":1002,"vNicIdentifier":"eth0","valuesAreSuspect":"true","transmittedTotalPacketsDelta":0,"receivedOctetsDelta":61200}]}}}], Received new messages from DMaaP MR. Count: 1 2020-10-12 18:27:45.488 INFO 1 --- [ask-scheduler-9] o.o.d.a.web.dmaap.MrMessageSplitter : Request Id: fbd7f87c-7a82-40ce-b246-c6d96df62d3f, Transaction Id: HMSIB, dmaapMessages: [{"event":{"commonEventHeader":{"startEpochMicrosec":1507750704126521,"sourceId":"4c32fa09-83e7-43cf-8bba-c72557afe408","eventId":"TrafficStats_1.2.3.4","nfcNamingCode":"vVNF","reportingEntityId":"No UUID available","internalHeaderFields":{"collectorTimeStamp":"Mon, 10 12 2020 06:26:16 UTC"},"eventType":"HTTP request rate","priority":"Normal","version":1.2,"reportingEntityName":"fwll","sequence":85,"domain":"measurementsForVfScaling","lastEpochMicrosec":1507750714317473,"eventName":"vFirewallBroadcastPackets","sourceName":"zdfw1fwl01fwl01","nfNamingCode":"vVNF"},"measurementsForVfScalingFields":{"cpuUsageArray":[{"percentUsage":0,"cpuIdentifier":"cpu1","cpuIdle":100,"cpuUsageSystem":0,"cpuUsageUser":0}],"measurementInterval":10,"requestRate":2256,"measurementsForVfScalingVersion":2.1,"vNicPerformanceArray":[{"transmittedOctetsDelta":0,"receivedTotalPacketsDelta":1002,"vNicIdentifier":"eth0","valuesAreSuspect":"true","transmittedTotalPacketsDelta":0,"receivedOctetsDelta":61200}]}}}], Received new messages from DMaaP MR. Count: 1 2020-10-12T18:27:44.826+0000|2020-10-12T18:27:45.488+0000|fbd7f87c-7a82-40ce-b246-c6d96df62d3f|UNKNOWN_INSTANCE_ID|task-scheduler-9||s14f647e71ce24916a555f66a0533590b-dcae-tcagen2-policy|tca-gen2|COMPLETE|0|||INFO|0|10.1.1.249|662|s14f647e71ce24916a555f66a0533590b-dcae-tcagen2-policy||org.onap.dcae.analytics.web.dmaap.MrMessageSplitter|||||||Request Id: fbd7f87c-7a82-40ce-b246-c6d96df62d3f, Transaction Id: HMSIB, Max allowed messages per batch: 10000. No of batches created: 1 2020-10-12 18:27:45.488 INFO 1 --- [ask-scheduler-9] o.o.d.a.web.dmaap.MrMessageSplitter : Request Id: fbd7f87c-7a82-40ce-b246-c6d96df62d3f, Transaction Id: HMSIB, Max allowed messages per batch: 10000. No of batches created: 1 2020-10-12T18:27:45.506+0000|fbd7f87c-7a82-40ce-b246-c6d96df62d3f|Request Id: fbd7f87c-7a82-40ce-b246-c6d96df62d3f. Early Termination Message: CEF Message Event name does not match any Policy Event Names. Message EventName: vFirewallBroadcastPackets, Policy Event Names: [vLoadBalancer] 2020-10-12 18:27:45.505 DEBUG 1 --- [ask-scheduler-1] o.o.d.a.t.c.u.f.c.TcaCalculationFunction : Request Id: fbd7f87c-7a82-40ce-b246-c6d96df62d3f. Early Termination Message: CEF Message Event name does not match any Policy Event Names. Message EventName: vFirewallBroadcastPackets, Policy Event Names: [vLoadBalancer] 2020-10-12T18:27:44.826+0000|2020-10-12T18:27:45.508+0000|fbd7f87c-7a82-40ce-b246-c6d96df62d3f|UNKNOWN_INSTANCE_ID|task-scheduler-1||s14f647e71ce24916a555f66a0533590b-dcae-tcagen2-policy|tca-gen2|COMPLETE|0|||INFO|0|10.1.1.249|682|s14f647e71ce24916a555f66a0533590b-dcae-tcagen2-policy||org.onap.dcae.analytics.tca.web.integration.TcaAlertTransformer|||||||Request Id: fbd7f87c-7a82-40ce-b246-c6d96df62d3f, Transaction Id: HMSIB, Message counts - Received: 1, Errors: 0, Terminated Early: 1, Abated: [], Alerts: 0, Alerts size: 0 2020-10-12 18:27:45.508 INFO 1 --- [ask-scheduler-1] o.o.d.a.t.w.i.TcaAlertTransformer : Request Id: fbd7f87c-7a82-40ce-b246-c6d96df62d3f, Transaction Id: HMSIB, Message counts - Received: 1, Errors: 0, Terminated Early: 1, Abated: [], Alerts: 0, Alerts size: 0 2020-10-12 18:28:03.116 DEBUG 1 --- [ parallel-1] o.o.d.s.s.r.s.c.c.impl.CbsClientImpl : Calling https://config-binding-service:10443/service_component_all/s14f647e71ce24916a555f66a0533590b-dcae-tcagen2-policy for configuration 2020-10-12 18:28:03.118 DEBUG 1 --- [ctor-http-nio-4] r.n.resources.PooledConnectionProvider : [id: 0x4190b4d4, L:/10.1.1.249:40194 - R:config-binding-service/10.152.183.196:10443] Channel acquired, now 1 active connections and 0 inactive connections 2020-10-12 18:28:03.118 DEBUG 1 --- [ctor-http-nio-4] o.o.d.s.s.r.s.a.http.RxHttpClient : Request: GET / DefaultHttpHeaders[] 2020-10-12 18:28:03.119 DEBUG 1 --- [ctor-http-nio-4] r.netty.http.client.HttpClientConnect : [id: 0x4190b4d4, L:/10.1.1.249:40194 - R:config-binding-service/10.152.183.196:10443] Handler is being applied: {uri=https://config-binding-service:10443/service_component_all/s14f647e71ce24916a555f66a0533590b-dcae-tcagen2-policy, method=GET} 2020-10-12 18:28:03.120 DEBUG 1 --- [ctor-http-nio-4] r.n.resources.PooledConnectionProvider : [id: 0x4190b4d4, L:/10.1.1.249:40194 - R:config-binding-service/10.152.183.196:10443] onStateChange(GET{uri=/service_component_all/s14f647e71ce24916a555f66a0533590b-dcae-tcagen2-policy, connection=PooledConnection{channel=[id: 0x4190b4d4, L:/10.1.1.249:40194 - R:config-binding-service/10.152.183.196:10443]}}, [request_sent]) 2020-10-12 18:28:03.140 DEBUG 1 --- [ctor-http-nio-4] r.n.http.client.HttpClientOperations : [id: 0x4190b4d4, L:/10.1.1.249:40194 - R:config-binding-service/10.152.183.196:10443] Received response (auto-read:false) : [x-onap-requestid=eb84e79b-203f-44a0-886b-a64059121de5, Content-Type=application/json, Content-Length=4874, Date=Mon, 12 Oct 2020 18:28:03 GMT] 2020-10-12 18:28:03.140 DEBUG 1 --- [ctor-http-nio-4] r.n.resources.PooledConnectionProvider : [id: 0x4190b4d4, L:/10.1.1.249:40194 - R:config-binding-service/10.152.183.196:10443] onStateChange(GET{uri=/service_component_all/s14f647e71ce24916a555f66a0533590b-dcae-tcagen2-policy, connection=PooledConnection{channel=[id: 0x4190b4d4, L:/10.1.1.249:40194 - R:config-binding-service/10.152.183.196:10443]}}, [response_received]) 2020-10-12 18:28:03.141 DEBUG 1 --- [ctor-http-nio-4] reactor.netty.channel.FluxReceive : [id: 0x4190b4d4, L:/10.1.1.249:40194 - R:config-binding-service/10.152.183.196:10443] Subscribing inbound receiver [pending: 0, cancelled:false, inboundDone: false] 2020-10-12 18:28:03.141 DEBUG 1 --- [ctor-http-nio-4] o.o.d.s.s.r.s.a.http.RxHttpClient : Response status: 200 OK 2020-10-12 18:28:03.142 DEBUG 1 --- [ctor-http-nio-4] r.n.http.client.HttpClientOperations : [id: 0x4190b4d4, L:/10.1.1.249:40194 - R:config-binding-service/10.152.183.196:10443] Received last HTTP packet 2020-10-12 18:28:03.143 INFO 1 --- [ctor-http-nio-4] o.o.d.s.s.r.s.c.c.impl.CbsClientImpl : Got successful response from Config Binding Service 2020-10-12 18:28:03.143 DEBUG 1 --- [ctor-http-nio-4] o.o.d.s.s.r.s.c.c.impl.CbsClientImpl : CBS response: {"config":{"spring.data.mongodb.uri":"mongodb://dcae-mongohost/dcae-tcagen2-policy","streams_subscribes":{"tca_handle_in":{"type":"message_router","dmaap_info":{"topic_url":"http://message-router.onap.svc.cluster.local:3904/events/unauthenticated.VES_MEASUREMENT_OUTPUT"}}},"tca.enable_ecomp_logging":true,"tca.enable_abatement":true,"tca.aai.password":"DCAE","streams_subscribes.tca_handle_in.consumer_group":"cg1-policy","streams_subscribes.tca_handle_in.polling.auto_adjusting.step_up":10000,"tca.aai.node_query_path":"aai/v11/search/nodes-query","streams_publishes":{"tca_handle_out":{"type":"message_router","dmaap_info":{"topic_url":"http://message-router.onap.svc.cluster.local:3904/events/unauthenticated.DCAE_CL_OUTPUT"}}},"streams_subscribes.tca_handle_in.consumer_ids[1]":"c1","tca.aai.generic_vnf_path":"aai/v11/network/generic-vnfs/generic-vnf","streams_subscribes.tca_handle_in.polling.auto_adjusting.step_down":30000,"streams_subscribes.tca_handle_in.polling.auto_adjusting.max":60000,"tca.aai.username":"DCAE","streams_subscribes.tca_handle_in.polling.auto_adjusting.min":30000,"tca.aai.url":"http://aai.onap.svc.cluster.local","streams_subscribes.tca_handle_in.timeout":-1,"tca.aai.enable_enrichment":true,"tca.policy":"{\"domain\":\"measurementsForVfScaling\",\"metricsPerEventName\":[{\"eventName\":\"vFirewallBroadcastPackets\",\"controlLoopSchemaType\":\"VM\",\"policyScope\":\"DCAE\",\"policyName\":\"DCAE.Config_tca-hi-lo\",\"policyVersion\":\"v0.0.1\",\"thresholds\":[{\"closedLoopControlName\":\"ControlLoop-vFirewall-d0a1dfc6-94f5-4fd4-a5b5-4630b438850a\",\"version\":\"1.0.2\",\"fieldPath\":\"$.event.measurementsForVfScalingFields.vNicPerformanceArray[*].receivedTotalPacketsDelta\",\"thresholdValue\":300,\"direction\":\"LESS_OR_EQUAL\",\"severity\":\"MAJOR\",\"closedLoopEventStatus\":\"ONSET\"},{\"closedLoopControlName\":\"ControlLoop-vFirewall-d0a1dfc6-94f5-4fd4-a5b5-4630b438850a\",\"version\":\"1.0.2\",\"fieldPath\":\"$.event.measurementsForVfScalingFields.vNicPerformanceArray[*].receivedTotalPacketsDelta\",\"thresholdValue\":700,\"direction\":\"GREATER_OR_EQUAL\",\"severity\":\"CRITICAL\",\"closedLoopEventStatus\":\"ONSET\"}]},{\"eventName\":\"vLoadBalancer\",\"controlLoopSchemaType\":\"VM\",\"policyScope\":\"DCAE\",\"policyName\":\"DCAE.Config_tca-hi-lo\",\"policyVersion\":\"v0.0.1\",\"thresholds\":[{\"closedLoopControlName\":\"ControlLoop-vDNS-6f37f56d-a87d-4b85-b6a9-cc953cf779b3\",\"version\":\"1.0.2\",\"fieldPath\":\"$.event.measurementsForVfScalingFields.vNicPerformanceArray[*].receivedTotalPacketsDelta\",\"thresholdValue\":300,\"direction\":\"GREATER_OR_EQUAL\",\"severity\":\"CRITICAL\",\"closedLoopEventStatus\":\"ONSET\"}]},{\"eventName\":\"Measurement_vGMUX\",\"controlLoopSchemaType\":\"VNF\",\"policyScope\":\"DCAE\",\"policyName\":\"DCAE.Config_tca-hi-lo\",\"policyVersion\":\"v0.0.1\",\"thresholds\":[{\"closedLoopControlName\":\"ControlLoop-vCPE-48f0c2c3-a172-4192-9ae3-052274181b6e\",\"version\":\"1.0.2\",\"fieldPath\":\"$.event.measurementsForVfScalingFields.additionalMeasurements[*].arrayOfFields[0].value\",\"thresholdValue\":0,\"direction\":\"EQUAL\",\"severity\":\"MAJOR\",\"closedLoopEventStatus\":\"ABATED\"},{\"closedLoopControlName\":\"ControlLoop-vCPE-48f0c2c3-a172-4192-9ae3-052274181b6e\",\"version\":\"1.0.2\",\"fieldPath\":\"$.event.measurementsForVfScalingFields.additionalMeasurements[*].arrayOfFields[0].value\",\"thresholdValue\":0,\"direction\":\"GREATER\",\"severity\":\"CRITICAL\",\"closedLoopEventStatus\":\"ONSET\"}]}]}","tca.processing_batch_size":10000,"streams_subscribes.tca_handle_in.polling.fixed_rate":0,"streams_subscribes.tca_handle_in.message_limit":50000,"service_calls":[],"streams_subscribes.tca_handle_in.consumer_ids[0]":"c0"},"policies":{"event":{"action":"gathered","timestamp":"2020-10-12T18:04:40.235Z","update_id":"290cf6a5-33f2-4f56-9330-2f4eeca1cb0b","policies_count":1},"items":[{"policyName":"MICROSERVICE_test-latest-tca_v1_0_tcagen2_1_0_0_lOw.1-0-0.xml","name":"MICROSERVICE_test-latest-tca_v1_0_tcagen2_1_0_0_lOw","config":{"tca.policy":{"domain":"measurementsForVfScaling","metricsPerEventName":[{"policyScope":"DCAE","policyName":"DCAE.Config_tca-hi-lo","thresholds":[{"direction":"LESS_OR_EQUAL","severity":"MAJOR","closedLoopControlName":"LOOP_latest-tca-test","fieldPath":"$.event.measurementsForVfScalingFields.vNicPerformanceArray[*].receivedTotalPacketsDelta","version":"1.0.2","closedLoopEventStatus":"ONSET","thresholdValue":200}],"eventName":"vLoadBalancer","controlLoopSchemaType":"VM","policyVersion":"v0.0.1"}]}},"type_version":"1.0.0","version":"1.0.0","policyVersion":"1.0.0","type":"onap.policies.monitoring.tcagen2","metadata":{"policy-id":"MICROSERVICE_test-latest-tca_v1_0_tcagen2_1_0_0_lOw","policy-version":"1.0.0"}}]}} 2020-10-12 18:28:03.143 DEBUG 1 --- [ctor-http-nio-4] r.n.resources.PooledConnectionProvider : [id: 0x4190b4d4, L:/10.1.1.249:40194 - R:config-binding-service/10.152.183.196:10443] onStateChange(GET{uri=/service_component_all/s14f647e71ce24916a555f66a0533590b-dcae-tcagen2-policy, connection=PooledConnection{channel=[id: 0x4190b4d4, L:/10.1.1.249:40194 - R:config-binding-service/10.152.183.196:10443]}}, [disconnecting]) 2020-10-12 18:28:03.143 DEBUG 1 --- [ctor-http-nio-4] r.n.resources.PooledConnectionProvider : [id: 0x4190b4d4, L:/10.1.1.249:40194 - R:config-binding-service/10.152.183.196:10443] Releasing channel 2020-10-12 18:28:03.144 DEBUG 1 --- [ctor-http-nio-4] r.n.resources.PooledConnectionProvider : [id: 0x4190b4d4, L:/10.1.1.249:40194 - R:config-binding-service/10.152.183.196:10443] Channel cleaned, now 0 active connections and 1 inactive connections 2020-10-12T18:28:14.826+0000|7a45fb34-5368-4dfa-b0c9-734e867152bb|Request Id: 7a45fb34-5368-4dfa-b0c9-734e867152bb. Transaction Id: E4QT2. Begin TS: 2020-10-12T18:28:14.825+0000. Starting new DMaaP MR Subscriber poll. 2020-10-12 18:28:14.825 DEBUG 1 --- [sk-scheduler-10] o.o.d.a.w.d.MrTriggerMessageProvider : Request Id: 7a45fb34-5368-4dfa-b0c9-734e867152bb. Transaction Id: E4QT2. Begin TS: 2020-10-12T18:28:14.825+0000. Starting new DMaaP MR Subscriber poll. 2020-10-12T18:28:14.826+0000|2020-10-12T18:28:24.406+0000|7a45fb34-5368-4dfa-b0c9-734e867152bb|UNKNOWN_INSTANCE_ID|task-scheduler-10||s14f647e71ce24916a555f66a0533590b-dcae-tcagen2-policy||DMAAP_MR_SUBSCRIBER|GET-/events/unauthenticated.VES_MEASUREMENT_OUTPUT/cg1-policy/c0|COMPLETE|0|OK||INFO|0|10.1.1.249|9580|s14f647e71ce24916a555f66a0533590b-dcae-tcagen2-policy||org.onap.dcae.analytics.web.http.EelfAuditLogInterceptor|||message-router.onap.svc.cluster.local:3904|||||Request Id: 7a45fb34-5368-4dfa-b0c9-734e867152bb, Transaction Id: E4QT2, Elapsed Time: 9580 ms, REST Endpoint Call: OK-GET-/events/unauthenticated.VES_MEASUREMENT_OUTPUT/cg1-policy/c0 2020-10-12 18:28:24.406 INFO 1 --- [sk-scheduler-10] o.o.d.a.w.http.EelfAuditLogInterceptor : Request Id: 7a45fb34-5368-4dfa-b0c9-734e867152bb, Transaction Id: E4QT2, Elapsed Time: 9580 ms, REST Endpoint Call: OK-GET-/events/unauthenticated.VES_MEASUREMENT_OUTPUT/cg1-policy/c0 2020-10-12T18:28:24.408+0000|7a45fb34-5368-4dfa-b0c9-734e867152bb|Request Id: 7a45fb34-5368-4dfa-b0c9-734e867152bb, Transaction Id: E4QT2, Messages Present: false, Next Polling Interval will be: 40000 2020-10-12 18:28:24.407 DEBUG 1 --- [sk-scheduler-10] o.o.d.a.w.d.MrSubscriberPollingAdvice : Request Id: 7a45fb34-5368-4dfa-b0c9-734e867152bb, Transaction Id: E4QT2, Messages Present: false, Next Polling Interval will be: 40000 2020-10-12T18:28:24.408+0000|7a45fb34-5368-4dfa-b0c9-734e867152bb|Request Id: 7a45fb34-5368-4dfa-b0c9-734e867152bb, Transaction Id: E4QT2, No new messages found in DMaaP MR Response. No further processing required 2020-10-12 18:28:24.408 DEBUG 1 --- [sk-scheduler-10] o.o.d.a.w.d.MrSubscriberPollingAdvice : Request Id: 7a45fb34-5368-4dfa-b0c9-734e867152bb, Transaction Id: E4QT2, No new messages found in DMaaP MR Response. No further processing required 2020-10-12T18:28:54.825+0000|dd21b2a8-27d4-4c3e-b8a7-1e493e9c74b4|Request Id: dd21b2a8-27d4-4c3e-b8a7-1e493e9c74b4. Transaction Id: MCYBH. Begin TS: 2020-10-12T18:28:54.825+0000. Starting new DMaaP MR Subscriber poll. 2020-10-12 18:28:54.825 DEBUG 1 --- [ask-scheduler-6] o.o.d.a.w.d.MrTriggerMessageProvider : Request Id: dd21b2a8-27d4-4c3e-b8a7-1e493e9c74b4. Transaction Id: MCYBH. Begin TS: 2020-10-12T18:28:54.825+0000. Starting new DMaaP MR Subscriber poll. 2020-10-12 18:29:03.116 DEBUG 1 --- [ parallel-1] o.o.d.s.s.r.s.c.c.impl.CbsClientImpl : Calling https://config-binding-service:10443/service_component_all/s14f647e71ce24916a555f66a0533590b-dcae-tcagen2-policy for configuration 2020-10-12 18:29:03.121 DEBUG 1 --- [ctor-http-nio-4] r.n.resources.PooledConnectionProvider : [id: 0x4190b4d4, L:/10.1.1.249:40194 - R:config-binding-service/10.152.183.196:10443] Channel acquired, now 1 active connections and 0 inactive connections 2020-10-12 18:29:03.121 DEBUG 1 --- [ctor-http-nio-4] o.o.d.s.s.r.s.a.http.RxHttpClient : Request: GET / DefaultHttpHeaders[] 2020-10-12 18:29:03.121 DEBUG 1 --- [ctor-http-nio-4] r.netty.http.client.HttpClientConnect : [id: 0x4190b4d4, L:/10.1.1.249:40194 - R:config-binding-service/10.152.183.196:10443] Handler is being applied: {uri=https://config-binding-service:10443/service_component_all/s14f647e71ce24916a555f66a0533590b-dcae-tcagen2-policy, method=GET} 2020-10-12 18:29:03.122 DEBUG 1 --- [ctor-http-nio-4] r.n.resources.PooledConnectionProvider : [id: 0x4190b4d4, L:/10.1.1.249:40194 - R:config-binding-service/10.152.183.196:10443] onStateChange(GET{uri=/service_component_all/s14f647e71ce24916a555f66a0533590b-dcae-tcagen2-policy, connection=PooledConnection{channel=[id: 0x4190b4d4, L:/10.1.1.249:40194 - R:config-binding-service/10.152.183.196:10443]}}, [request_sent]) 2020-10-12 18:29:03.167 DEBUG 1 --- [ctor-http-nio-4] r.n.http.client.HttpClientOperations : [id: 0x4190b4d4, L:/10.1.1.249:40194 - R:config-binding-service/10.152.183.196:10443] Received response (auto-read:false) : [x-onap-requestid=d80d7372-b03b-43a9-831b-e07f60eb395b, Content-Type=application/json, Content-Length=4874, Date=Mon, 12 Oct 2020 18:29:03 GMT] 2020-10-12 18:29:03.167 DEBUG 1 --- [ctor-http-nio-4] r.n.resources.PooledConnectionProvider : [id: 0x4190b4d4, L:/10.1.1.249:40194 - R:config-binding-service/10.152.183.196:10443] onStateChange(GET{uri=/service_component_all/s14f647e71ce24916a555f66a0533590b-dcae-tcagen2-policy, connection=PooledConnection{channel=[id: 0x4190b4d4, L:/10.1.1.249:40194 - R:config-binding-service/10.152.183.196:10443]}}, [response_received]) 2020-10-12 18:29:03.167 DEBUG 1 --- [ctor-http-nio-4] reactor.netty.channel.FluxReceive : [id: 0x4190b4d4, L:/10.1.1.249:40194 - R:config-binding-service/10.152.183.196:10443] Subscribing inbound receiver [pending: 0, cancelled:false, inboundDone: false] 2020-10-12 18:29:03.167 DEBUG 1 --- [ctor-http-nio-4] o.o.d.s.s.r.s.a.http.RxHttpClient : Response status: 200 OK 2020-10-12 18:29:03.168 DEBUG 1 --- [ctor-http-nio-4] r.n.http.client.HttpClientOperations : [id: 0x4190b4d4, L:/10.1.1.249:40194 - R:config-binding-service/10.152.183.196:10443] Received last HTTP packet 2020-10-12 18:29:03.168 INFO 1 --- [ctor-http-nio-4] o.o.d.s.s.r.s.c.c.impl.CbsClientImpl : Got successful response from Config Binding Service 2020-10-12 18:29:03.168 DEBUG 1 --- [ctor-http-nio-4] o.o.d.s.s.r.s.c.c.impl.CbsClientImpl : CBS response: {"config":{"spring.data.mongodb.uri":"mongodb://dcae-mongohost/dcae-tcagen2-policy","streams_subscribes":{"tca_handle_in":{"type":"message_router","dmaap_info":{"topic_url":"http://message-router.onap.svc.cluster.local:3904/events/unauthenticated.VES_MEASUREMENT_OUTPUT"}}},"tca.enable_ecomp_logging":true,"tca.enable_abatement":true,"tca.aai.password":"DCAE","streams_subscribes.tca_handle_in.consumer_group":"cg1-policy","streams_subscribes.tca_handle_in.polling.auto_adjusting.step_up":10000,"tca.aai.node_query_path":"aai/v11/search/nodes-query","streams_publishes":{"tca_handle_out":{"type":"message_router","dmaap_info":{"topic_url":"http://message-router.onap.svc.cluster.local:3904/events/unauthenticated.DCAE_CL_OUTPUT"}}},"streams_subscribes.tca_handle_in.consumer_ids[1]":"c1","tca.aai.generic_vnf_path":"aai/v11/network/generic-vnfs/generic-vnf","streams_subscribes.tca_handle_in.polling.auto_adjusting.step_down":30000,"streams_subscribes.tca_handle_in.polling.auto_adjusting.max":60000,"tca.aai.username":"DCAE","streams_subscribes.tca_handle_in.polling.auto_adjusting.min":30000,"tca.aai.url":"http://aai.onap.svc.cluster.local","streams_subscribes.tca_handle_in.timeout":-1,"tca.aai.enable_enrichment":true,"tca.policy":"{\"domain\":\"measurementsForVfScaling\",\"metricsPerEventName\":[{\"eventName\":\"vFirewallBroadcastPackets\",\"controlLoopSchemaType\":\"VM\",\"policyScope\":\"DCAE\",\"policyName\":\"DCAE.Config_tca-hi-lo\",\"policyVersion\":\"v0.0.1\",\"thresholds\":[{\"closedLoopControlName\":\"ControlLoop-vFirewall-d0a1dfc6-94f5-4fd4-a5b5-4630b438850a\",\"version\":\"1.0.2\",\"fieldPath\":\"$.event.measurementsForVfScalingFields.vNicPerformanceArray[*].receivedTotalPacketsDelta\",\"thresholdValue\":300,\"direction\":\"LESS_OR_EQUAL\",\"severity\":\"MAJOR\",\"closedLoopEventStatus\":\"ONSET\"},{\"closedLoopControlName\":\"ControlLoop-vFirewall-d0a1dfc6-94f5-4fd4-a5b5-4630b438850a\",\"version\":\"1.0.2\",\"fieldPath\":\"$.event.measurementsForVfScalingFields.vNicPerformanceArray[*].receivedTotalPacketsDelta\",\"thresholdValue\":700,\"direction\":\"GREATER_OR_EQUAL\",\"severity\":\"CRITICAL\",\"closedLoopEventStatus\":\"ONSET\"}]},{\"eventName\":\"vLoadBalancer\",\"controlLoopSchemaType\":\"VM\",\"policyScope\":\"DCAE\",\"policyName\":\"DCAE.Config_tca-hi-lo\",\"policyVersion\":\"v0.0.1\",\"thresholds\":[{\"closedLoopControlName\":\"ControlLoop-vDNS-6f37f56d-a87d-4b85-b6a9-cc953cf779b3\",\"version\":\"1.0.2\",\"fieldPath\":\"$.event.measurementsForVfScalingFields.vNicPerformanceArray[*].receivedTotalPacketsDelta\",\"thresholdValue\":300,\"direction\":\"GREATER_OR_EQUAL\",\"severity\":\"CRITICAL\",\"closedLoopEventStatus\":\"ONSET\"}]},{\"eventName\":\"Measurement_vGMUX\",\"controlLoopSchemaType\":\"VNF\",\"policyScope\":\"DCAE\",\"policyName\":\"DCAE.Config_tca-hi-lo\",\"policyVersion\":\"v0.0.1\",\"thresholds\":[{\"closedLoopControlName\":\"ControlLoop-vCPE-48f0c2c3-a172-4192-9ae3-052274181b6e\",\"version\":\"1.0.2\",\"fieldPath\":\"$.event.measurementsForVfScalingFields.additionalMeasurements[*].arrayOfFields[0].value\",\"thresholdValue\":0,\"direction\":\"EQUAL\",\"severity\":\"MAJOR\",\"closedLoopEventStatus\":\"ABATED\"},{\"closedLoopControlName\":\"ControlLoop-vCPE-48f0c2c3-a172-4192-9ae3-052274181b6e\",\"version\":\"1.0.2\",\"fieldPath\":\"$.event.measurementsForVfScalingFields.additionalMeasurements[*].arrayOfFields[0].value\",\"thresholdValue\":0,\"direction\":\"GREATER\",\"severity\":\"CRITICAL\",\"closedLoopEventStatus\":\"ONSET\"}]}]}","tca.processing_batch_size":10000,"streams_subscribes.tca_handle_in.polling.fixed_rate":0,"streams_subscribes.tca_handle_in.message_limit":50000,"service_calls":[],"streams_subscribes.tca_handle_in.consumer_ids[0]":"c0"},"policies":{"event":{"action":"gathered","timestamp":"2020-10-12T18:04:40.235Z","update_id":"290cf6a5-33f2-4f56-9330-2f4eeca1cb0b","policies_count":1},"items":[{"policyName":"MICROSERVICE_test-latest-tca_v1_0_tcagen2_1_0_0_lOw.1-0-0.xml","name":"MICROSERVICE_test-latest-tca_v1_0_tcagen2_1_0_0_lOw","config":{"tca.policy":{"domain":"measurementsForVfScaling","metricsPerEventName":[{"policyScope":"DCAE","policyName":"DCAE.Config_tca-hi-lo","thresholds":[{"direction":"LESS_OR_EQUAL","severity":"MAJOR","closedLoopControlName":"LOOP_latest-tca-test","fieldPath":"$.event.measurementsForVfScalingFields.vNicPerformanceArray[*].receivedTotalPacketsDelta","version":"1.0.2","closedLoopEventStatus":"ONSET","thresholdValue":200}],"eventName":"vLoadBalancer","controlLoopSchemaType":"VM","policyVersion":"v0.0.1"}]}},"type_version":"1.0.0","version":"1.0.0","policyVersion":"1.0.0","type":"onap.policies.monitoring.tcagen2","metadata":{"policy-id":"MICROSERVICE_test-latest-tca_v1_0_tcagen2_1_0_0_lOw","policy-version":"1.0.0"}}]}} 2020-10-12 18:29:03.169 DEBUG 1 --- [ctor-http-nio-4] r.n.resources.PooledConnectionProvider : [id: 0x4190b4d4, L:/10.1.1.249:40194 - R:config-binding-service/10.152.183.196:10443] onStateChange(GET{uri=/service_component_all/s14f647e71ce24916a555f66a0533590b-dcae-tcagen2-policy, connection=PooledConnection{channel=[id: 0x4190b4d4, L:/10.1.1.249:40194 - R:config-binding-service/10.152.183.196:10443]}}, [disconnecting]) 2020-10-12 18:29:03.169 DEBUG 1 --- [ctor-http-nio-4] r.n.resources.PooledConnectionProvider : [id: 0x4190b4d4, L:/10.1.1.249:40194 - R:config-binding-service/10.152.183.196:10443] Releasing channel 2020-10-12 18:29:03.169 DEBUG 1 --- [ctor-http-nio-4] r.n.resources.PooledConnectionProvider : [id: 0x4190b4d4, L:/10.1.1.249:40194 - R:config-binding-service/10.152.183.196:10443] Channel cleaned, now 0 active connections and 1 inactive connections 2020-10-12T18:28:54.827+0000|2020-10-12T18:29:04.406+0000|dd21b2a8-27d4-4c3e-b8a7-1e493e9c74b4|UNKNOWN_INSTANCE_ID|task-scheduler-6||s14f647e71ce24916a555f66a0533590b-dcae-tcagen2-policy||DMAAP_MR_SUBSCRIBER|GET-/events/unauthenticated.VES_MEASUREMENT_OUTPUT/cg1-policy/c1|COMPLETE|0|OK||INFO|0|10.1.1.249|9579|s14f647e71ce24916a555f66a0533590b-dcae-tcagen2-policy||org.onap.dcae.analytics.web.http.EelfAuditLogInterceptor|||message-router.onap.svc.cluster.local:3904|||||Request Id: dd21b2a8-27d4-4c3e-b8a7-1e493e9c74b4, Transaction Id: MCYBH, Elapsed Time: 9579 ms, REST Endpoint Call: OK-GET-/events/unauthenticated.VES_MEASUREMENT_OUTPUT/cg1-policy/c1 2020-10-12 18:29:04.406 INFO 1 --- [ask-scheduler-6] o.o.d.a.w.http.EelfAuditLogInterceptor : Request Id: dd21b2a8-27d4-4c3e-b8a7-1e493e9c74b4, Transaction Id: MCYBH, Elapsed Time: 9579 ms, REST Endpoint Call: OK-GET-/events/unauthenticated.VES_MEASUREMENT_OUTPUT/cg1-policy/c1 2020-10-12T18:29:04.408+0000|dd21b2a8-27d4-4c3e-b8a7-1e493e9c74b4|Request Id: dd21b2a8-27d4-4c3e-b8a7-1e493e9c74b4, Transaction Id: MCYBH, Messages Present: false, Next Polling Interval will be: 50000 2020-10-12 18:29:04.408 DEBUG 1 --- [ask-scheduler-6] o.o.d.a.w.d.MrSubscriberPollingAdvice : Request Id: dd21b2a8-27d4-4c3e-b8a7-1e493e9c74b4, Transaction Id: MCYBH, Messages Present: false, Next Polling Interval will be: 50000 2020-10-12T18:29:04.408+0000|dd21b2a8-27d4-4c3e-b8a7-1e493e9c74b4|Request Id: dd21b2a8-27d4-4c3e-b8a7-1e493e9c74b4, Transaction Id: MCYBH, No new messages found in DMaaP MR Response. No further processing required 2020-10-12 18:29:04.408 DEBUG 1 --- [ask-scheduler-6] o.o.d.a.w.d.MrSubscriberPollingAdvice : Request Id: dd21b2a8-27d4-4c3e-b8a7-1e493e9c74b4, Transaction Id: MCYBH, No new messages found in DMaaP MR Response. No further processing required ^C CL o/p from TCA using latest policy ----------------------------------- vv770d@pod-onap-01-vjhost:~$ curl https://10.12.6.10:30226/events/unauthenticated.DCAE_CL_OUTPUT/vv/1 -k ["{\"closedLoopEventClient\":\"s14f647e71ce24916a555f66a0533590b-dcae-tcagen2-policy\",\"policyVersion\":\"v0.0.1\",\"policyName\":\"DCAE.Config_tca-hi-lo\",\"policyScope\":\"DCAE\",\"target_type\":\"VM\",\"AAI\":{\"vserver.vserver-name\":\"regionone-onap-nf-20200613t164814996z-vlb-001\"},\"closedLoopAlarmStart\":1592429133812888,\"closedLoopEventStatus\":\"ONSET\",\"closedLoopControlName\":\"LOOP_latest-tca-test\",\"version\":\"1.0.2\",\"target\":\"vserver.vserver-name\",\"requestID\":\"561bfdbd-f328-4e35-86d3-437d85aae403\",\"from\":\"DCAE\"}"] ----------------------------------- ubuntu@sdc-clamp:~$ kubectl -n onap apply -f /tmp/ph-service ubuntu@sdc-clamp:~$ cat /tmp/ph-service apiVersion: v1 kind: Service metadata: name: policy-handler namespace: onap labels: app: dcae-policy-handler chart: dcae-policy-handler-6.0.0 release: onap heritage: Tiller spec: type: ClusterIP ports: - port: 80 targetPort: 25577 name: policy-handler selector: app: dcae-policy-handler release: onap