10/01/2020 TEST logs 1) VES Event receipt vv770d@pod-onap-01-vjhost:~$ curl -i -u 'sample1:sample1' -X POST -d @f5-cl.txt --header "Content-Type: application/json" https://10.12.6.10:30417/eventListener/v5 -k HTTP/1.1 202 X-LatestVersion: 7.2 X-MinorVersion: 4 X-PatchVersion: 1 Content-Type: application/json Content-Length: 8 Date: Thu, 01 Oct 2020 13:19:40 GMT Accepted Collector o/p vv770d@pod-onap-01-vjhost:~$ curl https://10.12.6.10:30226/events/unauthenticated.VES_MEASUREMENT_OUTPUT/vv/1 -k ["{\"event\":{\"commonEventHeader\":{\"startEpochMicrosec\":1507750704126521,\"sourceId\":\"4c32fa09-83e7-43cf-8bba-c72557afe408\",\"eventId\":\"TrafficStats_1.2.3.4\",\"nfcNamingCode\":\"vVNF\",\"reportingEntityId\":\"No UUID available\",\"internalHeaderFields\":{\"collectorTimeStamp\":\"Thu, 10 01 2020 01:19:40 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}]}}}"] curl https://10.12.6.10:30226/events/unauthenticated.DCAE_CL_OUTPUT/vv/1 -k {"mrstatus":3001,"helpURL":"http://onap.readthedocs.io","message":"No such topic exists.-[unauthenticated.DCAE_CL_OUTPUT]","status":404}vv770d@pod-onap-01-vjhost:~$ 2) TCAgen2 processing 2020-10-01 13:57:26.829 DEBUG 1 --- [ask-scheduler-4] o.o.d.a.w.d.MrSubscriberPollingAdvice : Request Id: 2a8e0ab0-6deb-4763-8e10-8899fb304b7f, Transaction Id: W6N9N, Messages Present: true, Next Polling Interval will be: 30000 2020-10-01 13:57:26.829 DEBUG 1 --- [ask-scheduler-4] 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\":\"Thu, 10 01 2020 01:55:39 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=2a8e0ab0-6deb-4763-8e10-8899fb304b7f, X-ECOMP-TransactionID=W6N9N, X-Begin-Timestamp=2020-10-01T13:57:26.214+0000, Pragma=no-cache, id=c6f3c85e-47fe-a995-76b8-1109b500a358, Content-Length=1100, contentType=application/json, http_statusCode=200, Date=1601560646000, timestamp=1601560646829}] 2020-10-01T13:57:26.214+0000|2020-10-01T13:57:26.853+0000|2a8e0ab0-6deb-4763-8e10-8899fb304b7f|UNKNOWN_INSTANCE_ID|task-scheduler-4||dcae-tcagen2|tca-gen2|COMPLETE|0|||INFO|0|10.1.83.60|639|dcae-tcagen2||org.onap.dcae.analytics.web.dmaap.MrMessageSplitter|||||||Request Id: 2a8e0ab0-6deb-4763-8e10-8899fb304b7f, Transaction Id: W6N9N, 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":"Thu, 10 01 2020 01:55:39 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-01 13:57:26.855 INFO 1 --- [ask-scheduler-4] o.o.d.a.web.dmaap.MrMessageSplitter : Request Id: 2a8e0ab0-6deb-4763-8e10-8899fb304b7f, Transaction Id: W6N9N, 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":"Thu, 10 01 2020 01:55:39 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-01T13:57:26.214+0000|2020-10-01T13:57:26.853+0000|2a8e0ab0-6deb-4763-8e10-8899fb304b7f|UNKNOWN_INSTANCE_ID|task-scheduler-4||dcae-tcagen2|tca-gen2|COMPLETE|0|||INFO|0|10.1.83.60|639|dcae-tcagen2||org.onap.dcae.analytics.web.dmaap.MrMessageSplitter|||||||Request Id: 2a8e0ab0-6deb-4763-8e10-8899fb304b7f, Transaction Id: W6N9N, Max allowed messages per batch: 10000. No of batches created: 1 2020-10-01 13:57:26.856 INFO 1 --- [ask-scheduler-4] o.o.d.a.web.dmaap.MrMessageSplitter : Request Id: 2a8e0ab0-6deb-4763-8e10-8899fb304b7f, Transaction Id: W6N9N, Max allowed messages per batch: 10000. No of batches created: 1 2020-10-01T13:57:27.180+0000|2a8e0ab0-6deb-4763-8e10-8899fb304b7f:0:0|Request Id: 2a8e0ab0-6deb-4763-8e10-8899fb304b7f:0:0. Alert ClosedLoop Status is ONSET. Saving abatement Entity to repository with lookupKey: vFirewallBroadcastPackets:zdfw1fwl01fwl01:fwll:ControlLoop-vFirewall-d0a1dfc6-94f5-4fd4-a5b5-4630b438850a:$.event.measurementsForVfScalingFields.vNicPerformanceArray[*].receivedTotalPacketsDelta 2020-10-01 13:57:27.180 DEBUG 1 --- [ask-scheduler-2] o.o.d.a.t.c.u.f.c.TcaAbatementCalculator : Request Id: 2a8e0ab0-6deb-4763-8e10-8899fb304b7f:0:0. Alert ClosedLoop Status is ONSET. Saving abatement Entity to repository with lookupKey: vFirewallBroadcastPackets:zdfw1fwl01fwl01:fwll:ControlLoop-vFirewall-d0a1dfc6-94f5-4fd4-a5b5-4630b438850a:$.event.measurementsForVfScalingFields.vNicPerformanceArray[*].receivedTotalPacketsDelta 2020-10-01 13:57:27.240 DEBUG 1 --- [ask-scheduler-2] .d.a.w.h.HttpClientPreferencesCustomizer : Customizing Rest Template for Http Client Id: aai-rest-client 2020-10-01 13:57:27.240 INFO 1 --- [ask-scheduler-2] .d.a.w.h.HttpClientPreferencesCustomizer : Setting basic Authentication credentials for Http Client Id: aai-rest-client with username: DCAE 2020-10-01 13:57:27.242 DEBUG 1 --- [ask-scheduler-2] .d.a.w.h.HttpClientPreferencesCustomizer : Proxy not Enabled - bypassing setting Proxy settings for Http Client Id: aai-rest-client 2020-10-01 13:57:27.242 INFO 1 --- [ask-scheduler-2] .d.a.w.h.HttpClientPreferencesCustomizer : Ignore SSL Certificate Errors attributed is set to: false for Http Client Id: aai-rest-client 2020-10-01 13:57:27.242 INFO 1 --- [ask-scheduler-2] .d.a.w.h.HttpClientPreferencesCustomizer : SSL Validation will be enforced for Http Client Id: aai-rest-client 2020-10-01 13:57:45.728 DEBUG 1 --- [ parallel-1] o.o.d.s.s.r.s.c.c.impl.CbsClientImpl : Calling https://config-binding-service:10443/service_component_all/dcae-tcagen2 for configuration 2020-10-01 13:57:45.734 DEBUG 1 --- [ctor-http-nio-4] r.n.resources.PooledConnectionProvider : [id: 0xb41731ba, L:/10.1.83.60:43696 - R:config-binding-service/10.152.183.193:10443] Channel acquired, now 1 active connections and 0 inactive connections 2020-10-01 13:57:45.734 DEBUG 1 --- [ctor-http-nio-4] o.o.d.s.s.r.s.a.http.RxHttpClient : Request: GET / DefaultHttpHeaders[] 2020-10-01 13:57:45.734 DEBUG 1 --- [ctor-http-nio-4] r.netty.http.client.HttpClientConnect : [id: 0xb41731ba, L:/10.1.83.60:43696 - R:config-binding-service/10.152.183.193:10443] Handler is being applied: {uri=https://config-binding-service:10443/service_component_all/dcae-tcagen2, method=GET} 2020-10-01 13:57:45.735 DEBUG 1 --- [ctor-http-nio-4] r.n.resources.PooledConnectionProvider : [id: 0xb41731ba, L:/10.1.83.60:43696 - R:config-binding-service/10.152.183.193:10443] onStateChange(GET{uri=/service_component_all/dcae-tcagen2, connection=PooledConnection{channel=[id: 0xb41731ba, L:/10.1.83.60:43696 - R:config-binding-service/10.152.183.193:10443]}}, [request_sent]) 2020-10-01 13:57:45.749 DEBUG 1 --- [ctor-http-nio-4] r.n.http.client.HttpClientOperations : [id: 0xb41731ba, L:/10.1.83.60:43696 - R:config-binding-service/10.152.183.193:10443] Received response (auto-read:false) : [x-onap-requestid=fd742eb0-4f1c-4185-9980-1af7ccefd620, Content-Type=application/json, Content-Length=3732, Date=Thu, 01 Oct 2020 13:57:45 GMT] 2020-10-01 13:57:45.750 DEBUG 1 --- [ctor-http-nio-4] r.n.resources.PooledConnectionProvider : [id: 0xb41731ba, L:/10.1.83.60:43696 - R:config-binding-service/10.152.183.193:10443] onStateChange(GET{uri=/service_component_all/dcae-tcagen2, connection=PooledConnection{channel=[id: 0xb41731ba, L:/10.1.83.60:43696 - R:config-binding-service/10.152.183.193:10443]}}, [response_received]) 2020-10-01 13:57:45.750 DEBUG 1 --- [ctor-http-nio-4] reactor.netty.channel.FluxReceive : [id: 0xb41731ba, L:/10.1.83.60:43696 - R:config-binding-service/10.152.183.193:10443] Subscribing inbound receiver [pending: 0, cancelled:false, inboundDone: false] 2020-10-01 13:57:45.750 DEBUG 1 --- [ctor-http-nio-4] o.o.d.s.s.r.s.a.http.RxHttpClient : Response status: 200 OK 2020-10-01 13:57:45.751 DEBUG 1 --- [ctor-http-nio-4] r.n.http.client.HttpClientOperations : [id: 0xb41731ba, L:/10.1.83.60:43696 - R:config-binding-service/10.152.183.193:10443] Received last HTTP packet 2020-10-01 13:57:45.752 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-01 13:57:45.753 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","streams_subscribes":{"tca_handle_in":{"type":"message_router","dmaap_info":{"topic_url":"http://message-router: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","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: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"}} 2020-10-01 13:57:45.753 DEBUG 1 --- [ctor-http-nio-4] r.n.resources.PooledConnectionProvider : [id: 0xb41731ba, L:/10.1.83.60:43696 - R:config-binding-service/10.152.183.193:10443] onStateChange(GET{uri=/service_component_all/dcae-tcagen2, connection=PooledConnection{channel=[id: 0xb41731ba, L:/10.1.83.60:43696 - R:config-binding-service/10.152.183.193:10443]}}, [disconnecting]) 2020-10-01 13:57:45.753 DEBUG 1 --- [ctor-http-nio-4] r.n.resources.PooledConnectionProvider : [id: 0xb41731ba, L:/10.1.83.60:43696 - R:config-binding-service/10.152.183.193:10443] Releasing channel 2020-10-01 13:57:45.754 DEBUG 1 --- [ctor-http-nio-4] r.n.resources.PooledConnectionProvider : [id: 0xb41731ba, L:/10.1.83.60:43696 - R:config-binding-service/10.152.183.193:10443] Channel cleaned, now 0 active connections and 1 inactive connections 2020-10-01T13:57:56.218+0000|c90b006e-fd0b-4c21-ab1c-a92c1d7bf919|Request Id: c90b006e-fd0b-4c21-ab1c-a92c1d7bf919. Transaction Id: GGC0E. Begin TS: 2020-10-01T13:57:56.218+0000. Starting new DMaaP MR Subscriber poll. 2020-10-01 13:57:56.218 DEBUG 1 --- [sk-scheduler-10] o.o.d.a.w.d.MrTriggerMessageProvider : Request Id: c90b006e-fd0b-4c21-ab1c-a92c1d7bf919. Transaction Id: GGC0E. Begin TS: 2020-10-01T13:57:56.218+0000. Starting new DMaaP MR Subscriber poll. 2020-10-01T13:57:56.219+0000|2020-10-01T13:58:05.770+0000|c90b006e-fd0b-4c21-ab1c-a92c1d7bf919|UNKNOWN_INSTANCE_ID|task-scheduler-10||dcae-tcagen2||DMAAP_MR_SUBSCRIBER|GET-/events/unauthenticated.VES_MEASUREMENT_OUTPUT/cg1/c0|COMPLETE|0|OK||INFO|0|10.1.83.60|9551|dcae-tcagen2||org.onap.dcae.analytics.web.http.EelfAuditLogInterceptor|||message-router:3904|||||Request Id: c90b006e-fd0b-4c21-ab1c-a92c1d7bf919, Transaction Id: GGC0E, Elapsed Time: 9551 ms, REST Endpoint Call: OK-GET-/events/unauthenticated.VES_MEASUREMENT_OUTPUT/cg1/c0 2020-10-01 13:58:05.770 INFO 1 --- [sk-scheduler-10] o.o.d.a.w.http.EelfAuditLogInterceptor : Request Id: c90b006e-fd0b-4c21-ab1c-a92c1d7bf919, Transaction Id: GGC0E, Elapsed Time: 9551 ms, REST Endpoint Call: OK-GET-/events/unauthenticated.VES_MEASUREMENT_OUTPUT/cg1/c0 2020-10-01T13:58:05.773+0000|c90b006e-fd0b-4c21-ab1c-a92c1d7bf919|Request Id: c90b006e-fd0b-4c21-ab1c-a92c1d7bf919, Transaction Id: GGC0E, Messages Present: false, Next Polling Interval will be: 40000 2020-10-01 13:58:05.773 DEBUG 1 --- [sk-scheduler-10] o.o.d.a.w.d.MrSubscriberPollingAdvice : Request Id: c90b006e-fd0b-4c21-ab1c-a92c1d7bf919, Transaction Id: GGC0E, Messages Present: false, Next Polling Interval will be: 40000 2020-10-01T13:58:05.773+0000|c90b006e-fd0b-4c21-ab1c-a92c1d7bf919|Request Id: c90b006e-fd0b-4c21-ab1c-a92c1d7bf919, Transaction Id: GGC0E, No new messages found in DMaaP MR Response. No further processing required 2020-10-01 13:58:05.773 DEBUG 1 --- [sk-scheduler-10] o.o.d.a.w.d.MrSubscriberPollingAdvice : Request Id: c90b006e-fd0b-4c21-ab1c-a92c1d7bf919, Transaction Id: GGC0E, No new messages found in DMaaP MR Response. No further processing required 2020-10-01T13:58:36.215+0000|5698433a-0b7a-4699-b49b-338b28201353|Request Id: 5698433a-0b7a-4699-b49b-338b28201353. Transaction Id: DZLPZ. Begin TS: 2020-10-01T13:58:36.215+0000. Starting new DMaaP MR Subscriber poll. 2020-10-01 13:58:36.215 DEBUG 1 --- [sk-scheduler-10] o.o.d.a.w.d.MrTriggerMessageProvider : Request Id: 5698433a-0b7a-4699-b49b-338b28201353. Transaction Id: DZLPZ. Begin TS: 2020-10-01T13:58:36.215+0000. Starting new DMaaP MR Subscriber poll. 2020-10-01 13:58:45.728 DEBUG 1 --- [ parallel-1] o.o.d.s.s.r.s.c.c.impl.CbsClientImpl : Calling https://config-binding-service:10443/service_component_all/dcae-tcagen2 for configuration 2020-10-01 13:58:45.729 DEBUG 1 --- [ctor-http-nio-4] r.n.resources.PooledConnectionProvider : [id: 0xb41731ba, L:/10.1.83.60:43696 - R:config-binding-service/10.152.183.193:10443] Channel acquired, now 1 active connections and 0 inactive connections 2020-10-01 13:58:45.729 DEBUG 1 --- [ctor-http-nio-4] o.o.d.s.s.r.s.a.http.RxHttpClient : Request: GET / DefaultHttpHeaders[] 2020-10-01 13:58:45.729 DEBUG 1 --- [ctor-http-nio-4] r.netty.http.client.HttpClientConnect : [id: 0xb41731ba, L:/10.1.83.60:43696 - R:config-binding-service/10.152.183.193:10443] Handler is being applied: {uri=https://config-binding-service:10443/service_component_all/dcae-tcagen2, method=GET} 2020-10-01 13:58:45.731 DEBUG 1 --- [ctor-http-nio-4] r.n.resources.PooledConnectionProvider : [id: 0xb41731ba, L:/10.1.83.60:43696 - R:config-binding-service/10.152.183.193:10443] onStateChange(GET{uri=/service_component_all/dcae-tcagen2, connection=PooledConnection{channel=[id: 0xb41731ba, L:/10.1.83.60:43696 - R:config-binding-service/10.152.183.193:10443]}}, [request_sent]) 2020-10-01 13:58:45.744 DEBUG 1 --- [ctor-http-nio-4] r.n.http.client.HttpClientOperations : [id: 0xb41731ba, L:/10.1.83.60:43696 - R:config-binding-service/10.152.183.193:10443] Received response (auto-read:false) : [x-onap-requestid=17d04d53-2fa9-46e4-b620-ceb14372312c, Content-Type=application/json, Content-Length=3732, Date=Thu, 01 Oct 2020 13:58:45 GMT] 2020-10-01 13:58:45.744 DEBUG 1 --- [ctor-http-nio-4] r.n.resources.PooledConnectionProvider : [id: 0xb41731ba, L:/10.1.83.60:43696 - R:config-binding-service/10.152.183.193:10443] onStateChange(GET{uri=/service_component_all/dcae-tcagen2, connection=PooledConnection{channel=[id: 0xb41731ba, L:/10.1.83.60:43696 - R:config-binding-service/10.152.183.193:10443]}}, [response_received]) 2020-10-01 13:58:45.744 DEBUG 1 --- [ctor-http-nio-4] reactor.netty.channel.FluxReceive : [id: 0xb41731ba, L:/10.1.83.60:43696 - R:config-binding-service/10.152.183.193:10443] Subscribing inbound receiver [pending: 0, cancelled:false, inboundDone: false] 2020-10-01 13:58:45.744 DEBUG 1 --- [ctor-http-nio-4] o.o.d.s.s.r.s.a.http.RxHttpClient : Response status: 200 OK 2020-10-01 13:58:45.745 DEBUG 1 --- [ctor-http-nio-4] r.n.http.client.HttpClientOperations : [id: 0xb41731ba, L:/10.1.83.60:43696 - R:config-binding-service/10.152.183.193:10443] Received last HTTP packet 2020-10-01 13:58:45.746 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-01 13:58:45.746 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","streams_subscribes":{"tca_handle_in":{"type":"message_router","dmaap_info":{"topic_url":"http://message-router: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","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: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"}} 2020-10-01 13:58:45.746 DEBUG 1 --- [ctor-http-nio-4] r.n.resources.PooledConnectionProvider : [id: 0xb41731ba, L:/10.1.83.60:43696 - R:config-binding-service/10.152.183.193:10443] onStateChange(GET{uri=/service_component_all/dcae-tcagen2, connection=PooledConnection{channel=[id: 0xb41731ba, L:/10.1.83.60:43696 - R:config-binding-service/10.152.183.193:10443]}}, [disconnecting]) 2020-10-01 13:58:45.746 DEBUG 1 --- [ctor-http-nio-4] r.n.resources.PooledConnectionProvider : [id: 0xb41731ba, L:/10.1.83.60:43696 - R:config-binding-service/10.152.183.193:10443] Releasing channel 2020-10-01 13:58:45.746 DEBUG 1 --- [ctor-http-nio-4] r.n.resources.PooledConnectionProvider : [id: 0xb41731ba, L:/10.1.83.60:43696 - R:config-binding-service/10.152.183.193:10443] Channel cleaned, now 0 active connections and 1 inactive connections 2020-10-01T13:58:36.216+0000|2020-10-01T13:58:45.774+0000|5698433a-0b7a-4699-b49b-338b28201353|UNKNOWN_INSTANCE_ID|task-scheduler-10||dcae-tcagen2||DMAAP_MR_SUBSCRIBER|GET-/events/unauthenticated.VES_MEASUREMENT_OUTPUT/cg1/c1|COMPLETE|0|OK||INFO|0|10.1.83.60|9558|dcae-tcagen2||org.onap.dcae.analytics.web.http.EelfAuditLogInterceptor|||message-router:3904|||||Request Id: 5698433a-0b7a-4699-b49b-338b28201353, Transaction Id: DZLPZ, Elapsed Time: 9558 ms, REST Endpoint Call: OK-GET-/events/unauthenticated.VES_MEASUREMENT_OUTPUT/cg1/c1 2020-10-01 13:58:45.774 INFO 1 --- [sk-scheduler-10] o.o.d.a.w.http.EelfAuditLogInterceptor : Request Id: 5698433a-0b7a-4699-b49b-338b28201353, Transaction Id: DZLPZ, Elapsed Time: 9558 ms, REST Endpoint Call: OK-GET-/events/unauthenticated.VES_MEASUREMENT_OUTPUT/cg1/c1 2020-10-01T13:58:45.776+0000|5698433a-0b7a-4699-b49b-338b28201353|Request Id: 5698433a-0b7a-4699-b49b-338b28201353, Transaction Id: DZLPZ, Messages Present: false, Next Polling Interval will be: 50000 2020-10-01 13:58:45.776 DEBUG 1 --- [sk-scheduler-10] o.o.d.a.w.d.MrSubscriberPollingAdvice : Request Id: 5698433a-0b7a-4699-b49b-338b28201353, Transaction Id: DZLPZ, Messages Present: false, Next Polling Interval will be: 50000 2020-10-01T13:58:45.776+0000|5698433a-0b7a-4699-b49b-338b28201353|Request Id: 5698433a-0b7a-4699-b49b-338b28201353, Transaction Id: DZLPZ, No new messages found in DMaaP MR Response. No further processing required 2020-10-01 13:58:45.776 DEBUG 1 --- [sk-scheduler-10] o.o.d.a.w.d.MrSubscriberPollingAdvice : Request Id: 5698433a-0b7a-4699-b49b-338b28201353, Transaction Id: DZLPZ, No new messages found in DMaaP MR Response. No further processing required 2020-10-01T13:59:26.214+0000|e2f2ecd6-0414-4888-8444-ecb266bcbd51|Request Id: e2f2ecd6-0414-4888-8444-ecb266bcbd51. Transaction Id: QM7G2. Begin TS: 2020-10-01T13:59:26.214+0000. Starting new DMaaP MR Subscriber poll. 2020-10-01 13:59:26.214 DEBUG 1 --- [sk-scheduler-10] o.o.d.a.w.d.MrTriggerMessageProvider : Request Id: e2f2ecd6-0414-4888-8444-ecb266bcbd51. Transaction Id: QM7G2. Begin TS: 2020-10-01T13:59:26.214+0000. Starting new DMaaP MR Subscriber poll. 2020-10-01T13:59:26.216+0000|2020-10-01T13:59:35.772+0000|e2f2ecd6-0414-4888-8444-ecb266bcbd51|UNKNOWN_INSTANCE_ID|task-scheduler-10||dcae-tcagen2||DMAAP_MR_SUBSCRIBER|GET-/events/unauthenticated.VES_MEASUREMENT_OUTPUT/cg1/c0|COMPLETE|0|OK||INFO|0|10.1.83.60|9556|dcae-tcagen2||org.onap.dcae.analytics.web.http.EelfAuditLogInterceptor|||message-router:3904|||||Request Id: e2f2ecd6-0414-4888-8444-ecb266bcbd51, Transaction Id: QM7G2, Elapsed Time: 9556 ms, REST Endpoint Call: OK-GET-/events/unauthenticated.VES_MEASUREMENT_OUTPUT/cg1/c0 2020-10-01 13:59:35.772 INFO 1 --- [sk-scheduler-10] o.o.d.a.w.http.EelfAuditLogInterceptor : Request Id: e2f2ecd6-0414-4888-8444-ecb266bcbd51, Transaction Id: QM7G2, Elapsed Time: 9556 ms, REST Endpoint Call: OK-GET-/events/unauthenticated.VES_MEASUREMENT_OUTPUT/cg1/c0 2020-10-01T13:59:35.774+0000|e2f2ecd6-0414-4888-8444-ecb266bcbd51|Request Id: e2f2ecd6-0414-4888-8444-ecb266bcbd51, Transaction Id: QM7G2, Messages Present: false, Next Polling Interval will be: 60000 2020-10-01 13:59:35.774 DEBUG 1 --- [sk-scheduler-10] o.o.d.a.w.d.MrSubscriberPollingAdvice : Request Id: e2f2ecd6-0414-4888-8444-ecb266bcbd51, Transaction Id: QM7G2, Messages Present: false, Next Polling Interval will be: 60000 2020-10-01T13:59:35.774+0000|e2f2ecd6-0414-4888-8444-ecb266bcbd51|Request Id: e2f2ecd6-0414-4888-8444-ecb266bcbd51, Transaction Id: QM7G2, No new messages found in DMaaP MR Response. No further processing required 2020-10-01 13:59:35.774 DEBUG 1 --- [sk-scheduler-10] o.o.d.a.w.d.MrSubscriberPollingAdvice : Request Id: e2f2ecd6-0414-4888-8444-ecb266bcbd51, Transaction Id: QM7G2, No new messages found in DMaaP MR Response. No further processing required 2020-10-01T13:57:27.254+0000|2020-10-01T13:59:36.491+0000|2a8e0ab0-6deb-4763-8e10-8899fb304b7f:0:0|UNKNOWN_INSTANCE_ID|task-scheduler-2||dcae-tcagen2|DCAE|AAI_ENRICHMENT|GET-/aai/v11/search/nodes-query|ERROR|200|Timeout Error||ERROR|2|10.1.83.60|129237|dcae-tcagen2||org.onap.dcae.analytics.web.http.EelfAuditLogInterceptor|||aai.onap.svc.cluster.local|||||Request Id: 2a8e0ab0-6deb-4763-8e10-8899fb304b7f:0:0, Transaction Id: W6N9N, Elapsed Time: 129237 ms, Error Message: org.apache.http.conn.HttpHostConnectException: Connect to aai.onap.svc.cluster.local:80 [aai.onap.svc.cluster.local/10.152.183.135] failed: Connection timed out (Connection timed out) 2020-10-01 13:59:36.491 ERROR 1 --- [ask-scheduler-2] o.o.d.a.w.http.EelfAuditLogInterceptor : Request Id: 2a8e0ab0-6deb-4763-8e10-8899fb304b7f:0:0, Transaction Id: W6N9N, Elapsed Time: 129237 ms, Error Message: org.apache.http.conn.HttpHostConnectException: Connect to aai.onap.svc.cluster.local:80 [aai.onap.svc.cluster.local/10.152.183.135] failed: Connection timed out (Connection timed out) 2020-10-01T13:59:36.499+0000|2a8e0ab0-6deb-4763-8e10-8899fb304b7f:0:0|task-scheduler-2|dcae-tcagen2|tca-gen2|DCAE-TCA|dcae-tcagen2|ERROR|400|Schema Error|Request id: 2a8e0ab0-6deb-4763-8e10-8899fb304b7f:0:0. Unable to get A&AI enrichment details 2020-10-01 13:59:36.498 ERROR 1 --- [ask-scheduler-2] .o.d.a.t.w.a.TcaAaiEnrichmentServiceImpl : Request id: 2a8e0ab0-6deb-4763-8e10-8899fb304b7f:0:0. Unable to get A&AI enrichment details 2020-10-01T13:57:26.214+0000|2020-10-01T13:59:36.502+0000|2a8e0ab0-6deb-4763-8e10-8899fb304b7f:0|UNKNOWN_INSTANCE_ID|task-scheduler-2||dcae-tcagen2|tca-gen2|COMPLETE|0|||INFO|0|10.1.83.60|130288|dcae-tcagen2||org.onap.dcae.analytics.tca.web.integration.TcaAlertTransformer|||||||Request Id: 2a8e0ab0-6deb-4763-8e10-8899fb304b7f:0, Transaction Id: W6N9N, Message counts - Received: 1, Errors: 0, Terminated Early: 0, Abated: [TcaAlert(aai=Aai(genericVNFName=null, genericServerName=zdfw1fwl01fwl01), closedLoopAlarmEnd=null, closedLoopAlarmStart=1507750704126521, closedLoopControlName=ControlLoop-vFirewall-d0a1dfc6-94f5-4fd4-a5b5-4630b438850a, closedLoopEventClient=dcae-tcagen2, closedLoopEventStatus=ONSET, from=DCAE, policyName=DCAE.Config_tca-hi-lo, policyScope=DCAE, policyVersion=v0.0.1, requestId=2a8e0ab0-6deb-4763-8e10-8899fb304b7f:0:0, target=vserver.vserver-name, targetType=VM, version=1.0.2)], Alerts: 0, Alerts size: 1 2020-10-01 13:59:36.545 INFO 1 --- [ask-scheduler-2] o.o.d.a.t.w.i.TcaAlertTransformer : Request Id: 2a8e0ab0-6deb-4763-8e10-8899fb304b7f:0, Transaction Id: W6N9N, Message counts - Received: 1, Errors: 0, Terminated Early: 0, Abated: [TcaAlert(aai=Aai(genericVNFName=null, genericServerName=zdfw1fwl01fwl01), closedLoopAlarmEnd=null, closedLoopAlarmStart=1507750704126521, closedLoopControlName=ControlLoop-vFirewall-d0a1dfc6-94f5-4fd4-a5b5-4630b438850a, closedLoopEventClient=dcae-tcagen2, closedLoopEventStatus=ONSET, from=DCAE, policyName=DCAE.Config_tca-hi-lo, policyScope=DCAE, policyVersion=v0.0.1, requestId=2a8e0ab0-6deb-4763-8e10-8899fb304b7f:0:0, target=vserver.vserver-name, targetType=VM, version=1.0.2)], Alerts: 0, Alerts size: 1 2020-10-01T13:59:36.555+0000|2020-10-01T13:59:36.726+0000|2a8e0ab0-6deb-4763-8e10-8899fb304b7f:0|UNKNOWN_INSTANCE_ID|task-scheduler-2||dcae-tcagen2||DMAAP_MR_PUBLISHER|POST-/events/unauthenticated.DCAE_CL_OUTPUT/|COMPLETE|0|OK||INFO|0|10.1.83.60|171|dcae-tcagen2||org.onap.dcae.analytics.web.http.EelfAuditLogInterceptor|||message-router:3904|||||Request Id: 2a8e0ab0-6deb-4763-8e10-8899fb304b7f:0, Transaction Id: W6N9N, Elapsed Time: 171 ms, REST Endpoint Call: OK-POST-/events/unauthenticated.DCAE_CL_OUTPUT/ 2020-10-01 13:59:36.726 INFO 1 --- [ask-scheduler-2] o.o.d.a.w.http.EelfAuditLogInterceptor : Request Id: 2a8e0ab0-6deb-4763-8e10-8899fb304b7f:0, Transaction Id: W6N9N, Elapsed Time: 171 ms, REST Endpoint Call: OK-POST-/events/unauthenticated.DCAE_CL_OUTPUT/ 2020-10-01T13:57:26.214+0000|2020-10-01T13:59:36.728+0000|2a8e0ab0-6deb-4763-8e10-8899fb304b7f:0|UNKNOWN_INSTANCE_ID|task-scheduler-2||dcae-tcagen2|tca-gen2|COMPLETE|0|||INFO|0|10.1.83.60|130514|dcae-tcagen2||org.onap.dcae.analytics.tca.web.integration.TcaPublisherResponseHandler|||||||Request Id: 2a8e0ab0-6deb-4763-8e10-8899fb304b7f:0, Transaction Id: W6N9N, Transaction completion Time: 130514 ms, DMaaP MR Publisher Response: { "serverTimeMs": 164, "count": 1 } 2020-10-01 13:59:36.741 INFO 1 --- [ask-scheduler-2] .o.d.a.t.w.i.TcaPublisherResponseHandler : Request Id: 2a8e0ab0-6deb-4763-8e10-8899fb304b7f:0, Transaction Id: W6N9N, Transaction completion Time: 130514 ms, DMaaP MR Publisher Response: { "serverTimeMs": 164, "count": 1 } 2020-10-01 13:59:45.728 DEBUG 1 --- [ parallel-1] o.o.d.s.s.r.s.c.c.impl.CbsClientImpl : Calling https://config-binding-service:10443/service_component_all/dcae-tcagen2 for configuration DMAAP o/p curl https://10.12.6.10:30226/events/unauthenticated.DCAE_CL_OUTPUT/vv/1 ["{\"closedLoopEventClient\":\"dcae-tcagen2\",\"policyVersion\":\"v0.0.1\",\"policyName\":\"DCAE.Config_tca-hi-lo\",\"policyScope\":\"DCAE\",\"target_type\":\"VM\",\"AAI\":{\"vserver.vserver-name\":\"zdfw1fwl01fwl01\"},\"closedLoopAlarmStart\":1507750704126521,\"closedLoopEventStatus\":\"ONSET\",\"closedLoopControlName\":\"ControlLoop-vFirewall-d0a1dfc6-94f5-4fd4-a5b5-4630b438850a\",\"version\":\"1.0.2\",\"target\":\"vserver.vserver-name\",\"requestID\":\"f2286906-1400-49fd-85fa-18eaab9880c7:0:0\",\"from\":\"DCAE\"}"] ============================= Policy - DCAE/Policy Handler Flow Updated blueprint to change servicename and dmaap consumer group # ============LICENSE_START==================================================== # ============================================================================= # Copyright (C) 2019-2020 AT&T Intellectual Property. All rights reserved. # ============================================================================= # Licensed under the Apache License, Version 2.0 (the "License"); # you may not use this file except in compliance with the License. # You may obtain a copy of the License at # # http://www.apache.org/licenses/LICENSE-2.0 # # Unless required by applicable law or agreed to in writing, software # distributed under the License is distributed on an "AS IS" BASIS, # WITHOUT WARRANTIES OR CONDITIONS OF ANY KIND, either express or implied. # See the License for the specific language governing permissions and # limitations under the License. # ============LICENSE_END====================================================== #k8s-tca-gen2-v3.yaml tosca_definitions_version: cloudify_dsl_1_3 imports: - https://www.getcloudify.org/spec/cloudify/4.5.5/types.yaml - plugin:k8splugin?version=3.4.2 - plugin:clamppolicyplugin?version=1.1.0 inputs: service_name: type: string default: 'dcae-tcagen2-policy' log_directory: type: string default: "/opt/logs/dcae-analytics-tca" replicas: type: integer description: number of instances default: 1 spring.data.mongodb.uri: type: string default: "mongodb://dcae-mongohost/dcae-tcagen2-policy" tag_version: type: string default: "nexus3.onap.org:10001/onap/org.onap.dcaegen2.analytics.tca-gen2.dcae-analytics-tca-web:1.2.0" tca.aai.password: type: string default: "DCAE" tca.aai.url: type: string default: "http://aai.onap.svc.cluster.local" tca.aai.username: type: string default: "DCAE" tca_handle_in_subscribe_url: type: string default: "http://message-router.onap.svc.cluster.local:3904/events/unauthenticated.VES_MEASUREMENT_OUTPUT" tca_handle_out_publish_url: type: string default: "http://message-router.onap.svc.cluster.local:3904/events/unauthenticated.DCAE_CL_OUTPUT" tca_consumer_group: type: string default: "cg1-policy" policy_model_id: type: string default: "onap.policies.monitoring.tcagen2" policy_id: type: string default: "onap.vfirewall.tca" node_templates: docker.tca: type: dcae.nodes.ContainerizedServiceComponent relationships: - target: tcagen2_policy type: cloudify.relationships.depends_on interfaces: cloudify.interfaces.lifecycle: start: inputs: ports: - concat: ["9091:", "0"] properties: application_config: service_calls: [] streams_publishes: tca_handle_out: dmaap_info: topic_url: get_input: tca_handle_out_publish_url type: message_router streams_subscribes: tca_handle_in: dmaap_info: topic_url: get_input: tca_handle_in_subscribe_url type: message_router spring.data.mongodb.uri: get_input: spring.data.mongodb.uri streams_subscribes.tca_handle_in.consumer_group: get_input: tca_consumer_group streams_subscribes.tca_handle_in.consumer_ids[0]: c0 streams_subscribes.tca_handle_in.consumer_ids[1]: c1 streams_subscribes.tca_handle_in.message_limit: 50000 streams_subscribes.tca_handle_in.polling.auto_adjusting.max: 60000 streams_subscribes.tca_handle_in.polling.auto_adjusting.min: 30000 streams_subscribes.tca_handle_in.polling.auto_adjusting.step_down: 30000 streams_subscribes.tca_handle_in.polling.auto_adjusting.step_up: 10000 streams_subscribes.tca_handle_in.polling.fixed_rate: 0 streams_subscribes.tca_handle_in.timeout: -1 tca.aai.enable_enrichment: true tca.aai.generic_vnf_path: aai/v11/network/generic-vnfs/generic-vnf tca.aai.node_query_path: aai/v11/search/nodes-query tca.aai.password: get_input: tca.aai.password tca.aai.url: get_input: tca.aai.url tca.aai.username: get_input: tca.aai.username 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 tca.enable_abatement: true tca.enable_ecomp_logging: true docker_config: healthcheck: endpoint: /actuator/health interval: 30s timeout: 10s type: http image: get_input: tag_version log_info: log_directory: get_input: log_directory tls_info: use_tls: true cert_directory: '/etc/tca-gen2/ssl' replicas: get_input: replicas service_component_type: { get_input: service_name } tcagen2_policy: type: clamp.nodes.policy properties: policy_id: get_input: policy_id policy_model_id: get_input: policy_model_id sh-4.2$ cfy install -b tcagen2-policy -d tcagen2-policy /blueprints/k8s-tcagen2-clampnode.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-clampnode.yaml... k8s-tcagen2-clamp... |################################################| 100.0% Blueprint uploaded. The blueprint's id is tcagen2-policy Creating new deployment from blueprint tcagen2-policy... Deployment created. The deployment's id is tcagen2-policy Executing workflow `install` on deployment `tcagen2-policy` [timeout=900 seconds] Deployment environment creation is pending... 2020-10-02 14:31:46.896 CFY Starting 'create_deployment_environment' workflow execution 2020-10-02 14:31:46.903 CFY Installing deployment and workflow plugins 2020-10-02 14:31:47.001 CFY Sending task 'cloudify_agent.operations.install_plugins' 2020-10-02 14:31:47.017 CFY Task started 'cloudify_agent.operations.install_plugins' 2020-10-02 14:31:48.038 LOG INFO: Installing plugin: k8s 2020-10-02 14:31:49.060 LOG INFO: Using existing installation of managed plugin: a8549e93-b225-4e27-8046-80eec5e256be [package_name: k8splugin, package_version: 3.4.2, supported_platform: linux_x86_64, distribution: centos, distribution_release: core] 2020-10-02 14:31:49.061 LOG INFO: Installing plugin: dcaepolicy 2020-10-02 14:31:50.022 LOG INFO: Using existing installation of managed plugin: 8d853775-3cc6-4841-bef8-744c11e41e8f [package_name: dcaepolicyplugin, package_version: 2.4.0, supported_platform: linux_x86_64, distribution: centos, distribution_release: core] 2020-10-02 14:31:50.023 CFY Task succeeded 'cloudify_agent.operations.install_plugins' 2020-10-02 14:31:50.055 CFY Creating deployment work directory 2020-10-02 14:31:50.377 CFY 'create_deployment_environment' workflow execution succeeded 2020-10-02 14:31:53.912 CFY Starting 'install' workflow execution 2020-10-02 14:31:54.410 CFY [tcagen2_policy_lzwty2] Validating node instance before creation: nothing to do 2020-10-02 14:31:54.526 CFY [tcagen2_policy_lzwty2] Precreating node instance: nothing to do 2020-10-02 14:31:54.606 CFY [tcagen2_policy_lzwty2] Creating node instance 2020-10-02 14:31:54.887 CFY [tcagen2_policy_lzwty2.create] Sending task 'dcaepolicyplugin.policy_get' 2020-10-02 14:31:56.540 LOG [tcagen2_policy_lzwty2.create] INFO: getting service_url at http://consul:8500/v1/catalog/service/policy_handler 2020-10-02 14:31:56.546 LOG [tcagen2_policy_lzwty2.create] INFO: got 200 for service_url at http://consul:8500/v1/catalog/service/policy_handler response: [] 2020-10-02 14:31:56.547 LOG [tcagen2_policy_lzwty2.create] INFO: getting kv at http://consul:8500/v1/kv/dcaepolicyplugin 2020-10-02 14:31:56.553 LOG [tcagen2_policy_lzwty2.create] INFO: got 404 for kv at http://consul:8500/v1/kv/dcaepolicyplugin response: 2020-10-02 14:31:56.554 LOG [tcagen2_policy_lzwty2.create] INFO: getting latest policy from http://policy-handler/policy_latest/onap.vfirewall.tca headers={"X-ECOMP-RequestID": "d008015d-9038-4c7a-8db3-1c3320868455"} 2020-10-02 14:31:56.911 LOG [tcagen2_policy_lzwty2.create] INFO: latest policy for policy_id(onap.vfirewall.tca) status(200) response: {"policy_id": "onap.vfirewall.tca", "policy_body": {"type": "onap.policies.monitoring.tcagen2", "type_version": "1.0.0", "name": "onap.vfirewall.tca", "version": "1.0.0", "metadata": {"policy-id": "onap.vfirewall.tca", "policy-version": "1.0.0"}, "policyName": "onap.vfirewall.tca.1-0-0.xml", "policyVersion": "1.0.0", "config": {"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"}]}]}}}} 2020-10-02 14:31:56.912 LOG [tcagen2_policy_lzwty2.create] INFO: found policy onap.vfirewall.tca: {"policy_body": {"policyName": "onap.vfirewall.tca.1-0-0.xml", "name": "onap.vfirewall.tca", "config": {"tca.policy": {"domain": "measurementsForVfScaling", "metricsPerEventName": [{"policyName": "DCAE.Config_tca-hi-lo", "policyScope": "DCAE", "thresholds": [{"direction": "LESS_OR_EQUAL", "severity": "MAJOR", "closedLoopControlName": "ControlLoop-vFirewall-d0a1dfc6-94f5-4fd4-a5b5-4630b438850a", "fieldPath": "$.event.measurementsForVfScalingFields.vNicPerformanceArray[*].receivedTotalPacketsDelta", "version": "1.0.2", "closedLoopEventStatus": "ONSET", "thresholdValue": 300}, {"direction": "GREATER_OR_EQUAL", "severity": "CRITICAL", "closedLoopControlName": "ControlLoop-vFirewall-d0a1dfc6-94f5-4fd4-a5b5-4630b438850a", "fieldPath": "$.event.measurementsForVfScalingFields.vNicPerformanceArray[*].receivedTotalPacketsDelta", "version": "1.0.2", "closedLoopEventStatus": "ONSET", "thresholdValue": 700}], "eventName": "vFirewallBroadcastPackets", "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": "onap.vfirewall.tca", "policy-version": "1.0.0"}}, "policy_id": "onap.vfirewall.tca"} 2020-10-02 14:31:56.960 LOG [tcagen2_policy_lzwty2.create] INFO: exit policy_get 2020-10-02 14:31:57.679 CFY [tcagen2_policy_lzwty2.create] Task succeeded 'dcaepolicyplugin.policy_get' 2020-10-02 14:31:57.803 CFY [tcagen2_policy_lzwty2] Node instance created 2020-10-02 14:31:57.904 CFY [tcagen2_policy_lzwty2] Configuring node instance: nothing to do 2020-10-02 14:31:58.005 CFY [tcagen2_policy_lzwty2] Starting node instance: nothing to do 2020-10-02 14:31:58.104 CFY [tcagen2_policy_lzwty2] Poststarting node instance: nothing to do 2020-10-02 14:31:58.202 CFY [tcagen2_policy_lzwty2] Node instance started 2020-10-02 14:31:58.830 CFY [docker.tca_l1ysxk] Validating node instance before creation: nothing to do 2020-10-02 14:31:58.921 CFY [docker.tca_l1ysxk] Precreating node instance: nothing to do 2020-10-02 14:31:59.176 CFY [docker.tca_l1ysxk] Creating node instance 2020-10-02 14:31:59.431 CFY [docker.tca_l1ysxk.create] Sending task 'k8splugin.create_for_components' 2020-10-02 14:32:01.999 LOG [docker.tca_l1ysxk.create] INFO: Added config for s933aeace3b17437aaf56a316f9430659-dcae-tcagen2-policy 2020-10-02 14:32:02.000 LOG [docker.tca_l1ysxk.create] INFO: Done setting up: s933aeace3b17437aaf56a316f9430659-dcae-tcagen2-policy 2020-10-02 14:32:02.022 LOG [docker.tca_l1ysxk.create] INFO: response 200 for store_policies http://consul:8500/v1/txn: text={"Results":[{"KV":{"LockIndex":0,"Key":"s933aeace3b17437aaf56a316f9430659-dcae-tcagen2-policy:policies/event","Flags":0,"Value":null,"CreateIndex":29449,"ModifyIndex":29449}},{"KV":{"LockIndex":0,"Key":"s933aeace3b17437aaf56a316f9430659-dcae-tcagen2-policy:policies/items/onap.vfirewall.tca","Flags":0,"Value":null,"CreateIndex":29449,"ModifyIndex":29449}}],"Errors":null} txn=[{"KV": {"Verb": "delete-tree", "Key": "s933aeace3b17437aaf56a316f9430659-dcae-tcagen2-policy:policies/"}}, {"KV": {"Verb": "set", "Value": "eyJhY3Rpb24iOiAiZ2F0aGVyZWQiLCAidGltZXN0YW1wIjogIjIwMjAtMTAtMDJUMTQ6MzI6MDIuMDAwWiIsICJ1cGRhdGVfaWQiOiAiNTRkYTkzZjUtZmYzZi00NGMxLWExNGYtNjRiNTQ5Nzk0NzI3IiwgInBvbGljaWVzX2NvdW50IjogMX0=", "Key": "s933aeace3b17437aaf56a316f9430659-dcae-tcagen2-policy:policies/event"}}, {"KV": {"Verb": "set", "Value": "eyJwb2xpY3lOYW1lIjogIm9uYXAudmZpcmV3YWxsLnRjYS4xLTAtMC54bWwiLCAibmFtZSI6ICJvbmFwLnZmaXJld2FsbC50Y2EiLCAiY29uZmlnIjogeyJ0Y2EucG9saWN5IjogeyJkb21haW4iOiAibWVhc3VyZW1lbnRzRm9yVmZTY2FsaW5nIiwgIm1ldHJpY3NQZXJFdmVudE5hbWUiOiBbeyJwb2xpY3lOYW1lIjogIkRDQUUuQ29uZmlnX3RjYS1oaS1sbyIsICJwb2xpY3lTY29wZSI6ICJEQ0FFIiwgInRocmVzaG9sZHMiOiBbeyJkaXJlY3Rpb24iOiAiTEVTU19PUl9FUVVBTCIsICJzZXZlcml0eSI6ICJNQUpPUiIsICJjbG9zZWRMb29wQ29udHJvbE5hbWUiOiAiQ29udHJvbExvb3AtdkZpcmV3YWxsLWQwYTFkZmM2LTk0ZjUtNGZkNC1hNWI1LTQ2MzBiNDM4ODUwYSIsICJmaWVsZFBhdGgiOiAiJC5ldmVudC5tZWFzdXJlbWVudHNGb3JWZlNjYWxpbmdGaWVsZHMudk5pY1BlcmZvcm1hbmNlQXJyYXlbKl0ucmVjZWl2ZWRUb3RhbFBhY2tldHNEZWx0YSIsICJ2ZXJzaW9uIjogIjEuMC4yIiwgImNsb3NlZExvb3BFdmVudFN0YXR1cyI6ICJPTlNFVCIsICJ0aHJlc2hvbGRWYWx1ZSI6IDMwMH0sIHsiZGlyZWN0aW9uIjogIkdSRUFURVJfT1JfRVFVQUwiLCAic2V2ZXJpdHkiOiAiQ1JJVElDQUwiLCAiY2xvc2VkTG9vcENvbnRyb2xOYW1lIjogIkNvbnRyb2xMb29wLXZGaXJld2FsbC1kMGExZGZjNi05NGY1LTRmZDQtYTViNS00NjMwYjQzODg1MGEiLCAiZmllbGRQYXRoIjogIiQuZXZlbnQubWVhc3VyZW1lbnRzRm9yVmZTY2FsaW5nRmllbGRzLnZOaWNQZXJmb3JtYW5jZUFycmF5WypdLnJlY2VpdmVkVG90YWxQYWNrZXRzRGVsdGEiLCAidmVyc2lvbiI6ICIxLjAuMiIsICJjbG9zZWRMb29wRXZlbnRTdGF0dXMiOiAiT05TRVQiLCAidGhyZXNob2xkVmFsdWUiOiA3MDB9XSwgImV2ZW50TmFtZSI6ICJ2RmlyZXdhbGxCcm9hZGNhc3RQYWNrZXRzIiwgImNvbnRyb2xMb29wU2NoZW1hVHlwZSI6ICJWTSIsICJwb2xpY3lWZXJzaW9uIjogInYwLjAuMSJ9XX19LCAidHlwZV92ZXJzaW9uIjogIjEuMC4wIiwgInZlcnNpb24iOiAiMS4wLjAiLCAicG9saWN5VmVyc2lvbiI6ICIxLjAuMCIsICJ0eXBlIjogIm9uYXAucG9saWNpZXMubW9uaXRvcmluZy50Y2FnZW4yIiwgIm1ldGFkYXRhIjogeyJwb2xpY3ktaWQiOiAib25hcC52ZmlyZXdhbGwudGNhIiwgInBvbGljeS12ZXJzaW9uIjogIjEuMC4wIn19", "Key": "s933aeace3b17437aaf56a316f9430659-dcae-tcagen2-policy:policies/items/onap.vfirewall.tca"}}] 2020-10-02 14:32:02.625 CFY [docker.tca_l1ysxk.create] Task succeeded 'k8splugin.create_for_components' 2020-10-02 14:32:02.910 CFY [docker.tca_l1ysxk] Node instance created 2020-10-02 14:32:03.065 CFY [docker.tca_l1ysxk] Configuring node instance: nothing to do 2020-10-02 14:32:03.251 CFY [docker.tca_l1ysxk] Starting node instance 2020-10-02 14:32:03.387 CFY [docker.tca_l1ysxk.start] Sending task 'k8splugin.create_and_start_container_for_components' 2020-10-02 14:32:05.712 LOG [docker.tca_l1ysxk.start] INFO: Starting k8s deployment for s933aeace3b17437aaf56a316f9430659-dcae-tcagen2-policy, image: nexus3.onap.org:10001/onap/org.onap.dcaegen2.analytics.tca-gen2.dcae-analytics-tca-web:1.2.0, 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/s933aeace3b17437aaf56a316f9430659-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'tcagen2-policy', 'cfynodeinstance': u'docker.tca_l1ysxk', 'cfynode': u'docker.tca'}, 'external_cert': {u'ca_name': u'RA', 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'use_external_tls': False}, 'resource_config': {}, 'volumes': [], 'log_info': {u'log_directory': u'/opt/logs/dcae-analytics-tca'}, 'ports': [u'9091:0'], 'k8s_location': u'central'} 2020-10-02 14:32:05.713 LOG [docker.tca_l1ysxk.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': {'image_tag': 'nexus3.onap.org:10001/onap/org.onap.dcae.truststore-merger:1.2.0'}, 'cbs': {'base_url': 'https://config-binding-service:10443/service_component_all'}, 'external_cert': {u'country': u'US', u'truststore_password': u'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.0.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-02 14:32:05.722 LOG [docker.tca_l1ysxk.start] INFO: Creating init container: TLS * [nexus3.onap.org:10001/onap/org.onap.dcaegen2.deployments.tls-init-container:2.1.0] 2020-10-02 14:32:05.782 LOG [docker.tca_l1ysxk.start] INFO: k8s deployment initiated successfully for s933aeace3b17437aaf56a316f9430659-dcae-tcagen2-policy: {'services': ['s933aeace3b17437aaf56a316f9430659-dcae-tcagen2-policy'], 'namespace': u'onap', 'location': u'central', 'deployment': 'dep-s933aeace3b17437aaf56a316f9430659-dcae-tcagen2-policy'} 2020-10-02 14:32:05.782 LOG [docker.tca_l1ysxk.start] INFO: Waiting up to 1800 secs for s933aeace3b17437aaf56a316f9430659-dcae-tcagen2-policy to become ready PH Logs ------- 10.1.83.1 - - [02/Oct/2020:14:31:17] "GET /healthcheck HTTP/1.1" 200 8498 "" "kube-probe/1.15" 10.1.83.1 - - [02/Oct/2020:14:31:56] "GET /policy_latest/onap.vfirewall.tca HTTP/1.1" 200 1240 "" "python-requests/2.21.0" 20201002_143143.531 INFO policy_listener policy_handler.pdp_api.dmaap_mr.get_policy_updates: get from dmaap_mr at https://message-router:3905/events/POLICY-NOTIFICA TION/policy-handler/ph1 with params={"timeout": 15000}, headers={"Content-Type": "application/json", "X-ONAP-RequestID": "1f60a7a3-846f-49de-b332-efc0982c44d8", "X-ECOM P-RequestID": "1f60a7a3-846f-49de-b332-efc0982c44d8"}, custom_kwargs({"verify": "/opt/app/policy_handler/etc/tls/certs/cacert.pem"}) timeout_in_secs(60) 20201002_143156.558 INFO CP Server Thread-13 policy_handler.web_server.policy_latest: GET /policy_latest/onap.vfirewall.tca policy_id=onap.vfirewall.tca headers={"R emote-Addr": "10.1.83.1", "Host": "policy-handler", "Connection": "keep-alive", "Accept-Encoding": "gzip, deflate", "Accept": "*/*", "User-Agent": "python-requests/2.21 .0", "X-Ecomp-Requestid": "d008015d-9038-4c7a-8db3-1c3320868455"} 20201002_143156.559 INFO CP Server Thread-13 policy_handler.pdp_api.policy_rest._init: PDP(policy_engine) url(https://policy-xacml-pdp:6969/policy/pdpx/v1/decision) headers({"Accept": "application/json", "Content-Type": "application/json", "Authorization": "***(82f7a0779dcb9ea261b3e4a5fc60ad6935abe01840c739f05ef0ba4dfedc88dc)***", "Environment": "TEST"}) tls_ca_mode(cert_directory) timeout_in_secs(60) custom_kwargs({"verify": "/opt/app/policy_handler/etc/tls/certs/cacert.pem"}): {"config_keys": ["policy_engine", "pool_connections", "thread_pool_size", "policy_retry_count", "policy_retry_sleep"], "changed": true, "config": {"thread_pool_size": 4, "pool_connecti ons": 20, "policy_retry_count": 5, "policy_retry_sleep": 5, "policy_engine": {"url": "https://policy-xacml-pdp:6969", "path_decision": "/policy/pdpx/v1/decision", "head ers": {"Accept": "application/json", "Content-Type": "application/json", "Authorization": "***(82f7a0779dcb9ea261b3e4a5fc60ad6935abe01840c739f05ef0ba4dfedc88dc)***", "E nvironment": "TEST"}, "target_entity": "policy_engine", "tls_ca_mode": "cert_directory", "timeout_in_secs": 60}}, "prev_config": null} 20201002_143156.559 DEBUG CP Server Thread-13 policy_handler.pdp_api.policy_rest._get_latest_policy: try(1) retry_get_config(None): policy_id(onap.vfirewall.tca), ex pected_versions(null) ignore_policy_names(null) 20201002_143156.559 INFO CP Server Thread-13 policy_handler.pdp_api.policy_rest._pdp_get_decision: post to policy_engine at https://policy-xacml-pdp:6969/policy/pdp x/v1/decision msg={"ONAPName": "DCAE", "ONAPComponent": "policy_handler", "ONAPInstance": "f92e471b-4810-4216-8637-ed5636f841a1", "action": "configure", "resource": {"p olicy-id": ["onap.vfirewall.tca"]}} headers={"Accept": "application/json", "Content-Type": "application/json", "Authorization": "***(82f7a0779dcb9ea261b3e4a5fc60ad6935a be01840c739f05ef0ba4dfedc88dc)***", "Environment": "TEST", "X-ONAP-RequestID": "d008015d-9038-4c7a-8db3-1c3320868455", "X-ECOMP-RequestID": "d008015d-9038-4c7a-8db3-1c3 320868455"}, custom_kwargs({"verify": "/opt/app/policy_handler/etc/tls/certs/cacert.pem"}) timeout_in_secs(60) 20201002_143156.570 DEBUG CP Server Thread-13 urllib3.connectionpool._new_conn: Starting new HTTPS connection (1): policy-xacml-pdp:6969 20201002_143156.906 DEBUG CP Server Thread-13 urllib3.connectionpool._make_request: https://policy-xacml-pdp:6969 "POST /policy/pdpx/v1/decision HTTP/1.1" 200 1100 20201002_143156.906 INFO CP Server Thread-13 policy_handler.pdp_api.policy_rest._pdp_get_decision: response 200 from post to policy_engine at https://policy-xacml-p dp:6969/policy/pdpx/v1/decision msg={"ONAPName": "DCAE", "ONAPComponent": "policy_handler", "ONAPInstance": "f92e471b-4810-4216-8637-ed5636f841a1", "action": "configure ", "resource": {"policy-id": ["onap.vfirewall.tca"]}} headers={"Accept": "application/json", "Content-Type": "application/json", "Authorization": "***(82f7a0779dcb9ea26 1b3e4a5fc60ad6935abe01840c739f05ef0ba4dfedc88dc)***", "Environment": "TEST", "X-ONAP-RequestID": "d008015d-9038-4c7a-8db3-1c3320868455", "X-ECOMP-RequestID": "d008015d- 9038-4c7a-8db3-1c3320868455"}, custom_kwargs({"verify": "/opt/app/policy_handler/etc/tls/certs/cacert.pem"}) timeout_in_secs(60): text={"policies":{"onap.vfirewall.tca" :{"type":"onap.policies.monitoring.tcagen2","type_version":"1.0.0","properties":{"tca.policy":{"domain":"measurementsForVfScaling","metricsPerEventName":[{"eventName":" vFirewallBroadcastPackets","controlLoopSchemaType":"VM","policyScope":"DCAE","policyName":"DCAE.Config_tca-hi-lo","policyVersion":"v0.0.1","thresholds":[{"closedLoopCon trolName":"ControlLoop-vFirewall-d0a1dfc6-94f5-4fd4-a5b5-4630b438850a","version":"1.0.2","fieldPath":"$.event.measurementsForVfScalingFields.vNicPerformanceArray[*].rec eivedTotalPacketsDelta","thresholdValue":300,"direction":"LESS_OR_EQUAL","severity":"MAJOR","closedLoopEventStatus":"ONSET"},{"closedLoopControlName":"ControlLoop-vFire wall-d0a1dfc6-94f5-4fd4-a5b5-4630b438850a","version":"1.0.2","fieldPath":"$.event.measurementsForVfScalingFields.vNicPerformanceArray[*].receivedTotalPacketsDelta","thr esholdValue":700,"direction":"GREATER_OR_EQUAL","severity":"CRITICAL","closedLoopEventStatus":"ONSET"}]}]}},"name":"onap.vfirewall.tca","version":"1.0.0","metadata":{"p olicy-id":"onap.vfirewall.tca","policy-version":"1.0.0"}}}} headers={"User-Agent": "python-requests/2.23.0", "Accept-Encoding": "gzip, deflate", "Accept": "application/ json", "Connection": "keep-alive", "Content-Type": "application/json", "Authorization": "***(82f7a0779dcb9ea261b3e4a5fc60ad6935abe01840c739f05ef0ba4dfedc88dc)***", "Env ironment": "TEST", "X-ONAP-RequestID": "d008015d-9038-4c7a-8db3-1c3320868455", "X-ECOMP-RequestID": "d008015d-9038-4c7a-8db3-1c3320868455", "Content-Length": "185"} 20201002_143156.907 INFO CP Server Thread-13 policy_handler.pdp_api.policy_rest._get_latest_policy_once: 200 looking for policy_id(onap.vfirewall.tca) in latest_pol icies: {"onap.vfirewall.tca": {"policy_id": "onap.vfirewall.tca", "policy_body": {"type": "onap.policies.monitoring.tcagen2", "type_version": "1.0.0", "name": "onap.vfi rewall.tca", "version": "1.0.0", "metadata": {"policy-id": "onap.vfirewall.tca", "policy-version": "1.0.0"}, "policyName": "onap.vfirewall.tca.1-0-0.xml", "policyVersio n": "1.0.0", "config": {"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", "thresholdVa lue": 300, "direction": "LESS_OR_EQUAL", "severity": "MAJOR", "closedLoopEventStatus": "ONSET"}, {"closedLoopControlName": "ControlLoop-vFirewall-d0a1dfc6-94f5-4fd4-a5b 5-4630b438850a", "version": "1.0.2", "fieldPath": "$.event.measurementsForVfScalingFields.vNicPerformanceArray[*].receivedTotalPacketsDelta", "thresholdValue": 700, "di rection": "GREATER_OR_EQUAL", "severity": "CRITICAL", "closedLoopEventStatus": "ONSET"}]}]}}}}} 20201002_143156.908 INFO CP Server Thread-13 policy_handler.web_server.policy_latest: res GET /policy_latest/onap.vfirewall.tca policy_id=onap.vfirewall.tca latest_ policy={"policy_id": "onap.vfirewall.tca", "policy_body": {"type": "onap.policies.monitoring.tcagen2", "type_version": "1.0.0", "name": "onap.vfirewall.tca", "version": "1.0.0", "metadata": {"policy-id": "onap.vfirewall.tca", "policy-version": "1.0.0"}, "policyName": "onap.vfirewall.tca.1-0-0.xml", "policyVersion": "1.0.0", "config": {"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-4630b43 8850a", "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", "versi on": "1.0.2", "fieldPath": "$.event.measurementsForVfScalingFields.vNicPerformanceArray[*].receivedTotalPacketsDelta", "thresholdValue": 700, "direction": "GREATER_OR_E QUAL", "severity": "CRITICAL", "closedLoopEventStatus": "ONSET"}]}]}}}} 10.1.83.1 - - [02/Oct/2020:14:31:56] "GET /policy_latest/onap.vfirewall.tca HTTP/1.1" 200 1240 "" "python-requests/2.21.0" 20201002_143156.909 INFO CP Server Thread-13 cherrypy.access.139939000727368.access: 10.1.83.1 - - [02/Oct/2020:14:31:56] "GET /policy_latest/onap.vfirewall.tca HTT P/1.1" 200 1240 "" "python-requests/2.21.0" 20201002_143158.540 DEBUG policy_listener urllib3.connectionpool._make_request: https://message-router:3905 "GET /events/POLICY-NOTIFICATION/policy-handler/ph1?timeo ut=15000 HTTP/1.1" 200 2 20201002_143158.541 INFO policy_listener policy_handler.pdp_api.dmaap_mr.get_policy_updates: response 200 from get from dmaap_mr at https://message-router:3905/even ts/POLICY-NOTIFICATION/policy-handler/ph1 with params={"timeout": 15000}, headers={"Content-Type": "application/json", "X-ONAP-RequestID": "1f60a7a3-846f-49de-b332-efc0 982c44d8", "X-ECOMP-RequestID": "1f60a7a3-846f-49de-b332-efc0982c44d8"}, custom_kwargs({"verify": "/opt/app/policy_handler/etc/tls/certs/cacert.pem"}) timeout_in_secs(6 0): text=[] headers={"Date": "Fri, 02 Oct 2020 14:31:43 GMT", "Cache-Control": "no-store, no-cache, must-revalidate", "Pragma": "no-cache", "Expires": "0", "Content-Typ e": "application/json", "Accept": "*/*", "Accept-Encoding": "gzip, deflate", "breadcrumbId": "ID-onap-message-router-0-1601480928352-0-909938", "timeout": "15000", "Use r-Agent": "python-requests/2.23.0", "X-CSI-Internal-WriteableRequest": "true", "X-ECOMP-RequestID": "1f60a7a3-846f-49de-b332-efc0982c44d8", "X-ONAP-RequestID": "1f60a7a 3-846f-49de-b332-efc0982c44d8", "Content-Length": "2", "Server": "Jetty(9.4.z-SNAPSHOT)"} 20201002_143158.543 INFO policy_listener policy_handler.pdp_api.policy_listener.run: no policy-updates: [] 20201002_143158.544 INFO policy_listener policy_handler.pdp_api.dmaap_mr.get_policy_updates: get from dmaap_mr at https://message-router:3905/events/POLICY-NOTIFICA TION/policy-handler/ph1 with params={"timeout": 15000}, headers={"Content-Type": "application/json", "X-ONAP-RequestID": "258e82a2-ff30-4fe7-8ffa-591d9c0c8a5e", "X-ECOM P-RequestID": "258e82a2-ff30-4fe7-8ffa-591d9c0c8a5e"}, custom_kwargs({"verify": "/opt/app/policy_handler/etc/tls/certs/cacert.pem"}) timeout_in_secs(60) 20201002_143213.581 DEBUG policy_listener urllib3.connectionpool._make_request: https://message-router:3905 "GET /events/POLICY-NOTIFICATION/policy-handler/ph1?timeo ut=15000 HTTP/1.1" 200 2 20201002_143213.582 INFO policy_listener policy_handler.pdp_api.dmaap_mr.get_policy_updates: response 200 from get from dmaap_mr at https://message-router:3905/even ts/POLICY-NOTIFICATION/policy-handler/ph1 with params={"timeout": 15000}, headers={"Content-Type": "application/json", "X-ONAP-RequestID": "258e82a2-ff30-4fe7-8ffa-591d 9c0c8a5e", "X-ECOMP-RequestID": "258e82a2-ff30-4fe7-8ffa-591d9c0c8a5e"}, custom_kwargs({"verify": "/opt/app/policy_handler/etc/tls/certs/cacert.pem"}) timeout_in_secs(6 0): text=[] headers={"Date": "Fri, 02 Oct 2020 14:31:58 GMT", "Cache-Control": "no-store, no-cache, must-revalidate", "Pragma": "no-cache", "Expires": "0", "Content-Typ e": "application/json", "Accept": "*/*", "Accept-Encoding": "gzip, deflate", "breadcrumbId": "ID-onap-message-router-0-1601480928352-0-910016", "timeout": "15000", "Use r-Agent": "python-requests/2.23.0", "X-CSI-Internal-WriteableRequest": "true", "X-ECOMP-RequestID": "258e82a2-ff30-4fe7-8ffa-591d9c0c8a5e", "X-ONAP-RequestID": "258e82a 2-ff30-4fe7-8ffa-591d9c0c8a5e", "Content-Length": "2", "Server": "Jetty(9.4.z-SNAPSHOT)"} 20201002_143213.583 INFO policy_listener policy_handler.pdp_api.policy_listener.run: no policy-updates: [] TCA Logs ------- 2020-10-02 14:34:47.173 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-02 14:34:47.173 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-02T14:32:02.000Z","update_id":"54da93f5-ff3f-44c1-a14f-64b549794727","policies_count":1},"items":[{"policyName":"onap.vfirewall.tca.1-0-0.xml","name":"onap.vfirewall.tca","config":{"tca.policy":{"domain":"measurementsForVfScaling","metricsPerEventName":[{"policyName":"DCAE.Config_tca-hi-lo","policyScope":"DCAE","thresholds":[{"direction":"LESS_OR_EQUAL","severity":"MAJOR","closedLoopControlName":"ControlLoop-vFirewall-d0a1dfc6-94f5-4fd4-a5b5-4630b438850a","fieldPath":"$.event.measurementsForVfScalingFields.vNicPerformanceArray[*].receivedTotalPacketsDelta","version":"1.0.2","closedLoopEventStatus":"ONSET","thresholdValue":300},{"direction":"GREATER_OR_EQUAL","severity":"CRITICAL","closedLoopControlName":"ControlLoop-vFirewall-d0a1dfc6-94f5-4fd4-a5b5-4630b438850a","fieldPath":"$.event.measurementsForVfScalingFields.vNicPerformanceArray[*].receivedTotalPacketsDelta","version":"1.0.2","closedLoopEventStatus":"ONSET","thresholdValue":700}],"eventName":"vFirewallBroadcastPackets","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":"onap.vfirewall.tca","policy-version":"1.0.0"}}]}} ERROR ubuntu@sdc-clamp:~$ kubectl logs -f -n onap dep-s933aeace3b17437aaf56a316f9430659-dcae-tcagen2-policy-79grd s933aeace3b17437aaf56a316f9430659-dcae-tcagen2-policy 2020-10-02 14:34:47.042 DEBUG 1 --- [ctor-http-nio-4] io.netty.handler.ssl.SslHandler : [id: 0x339fae79, L:/10.1.83.63:48088 - R:config-binding-service/10.152.183.193:10443] HANDSHAKEN: TLS_ECDHE_RSA_WITH_AES_128_GCM_SHA256 2020-10-02 14:34:47.046 DEBUG 1 --- [ctor-http-nio-4] r.n.resources.PooledConnectionProvider : [id: 0x339fae79, L:/10.1.83.63:48088 - R:config-binding-service/10.152.183.193:10443] onStateChange(PooledConnection{channel=[id: 0x339fae79, L:/10.1.83.63:48088 - R:config-binding-service/10.152.183.193:10443]}, [connected]) 2020-10-02 14:34:47.055 DEBUG 1 --- [ctor-http-nio-4] r.n.resources.PooledConnectionProvider : [id: 0x339fae79, L:/10.1.83.63:48088 - R:config-binding-service/10.152.183.193:10443] onStateChange(GET{uri=/, connection=PooledConnection{channel=[id: 0x339fae79, L:/10.1.83.63:48088 - R:config-binding-service/10.152.183.193:10443]}}, [configured]) 2020-10-02 14:34:47.059 DEBUG 1 --- [ctor-http-nio-4] o.o.d.s.s.r.s.a.http.RxHttpClient : Request: GET / DefaultHttpHeaders[] 2020-10-02 14:34:47.060 DEBUG 1 --- [ctor-http-nio-4] r.netty.http.client.HttpClientConnect : [id: 0x339fae79, L:/10.1.83.63:48088 - R:config-binding-service/10.152.183.193:10443] Handler is being applied: {uri=https://config-binding-service:10443/service_component_all/s933aeace3b17437aaf56a316f9430659-dcae-tcagen2-policy, method=GET} 2020-10-02 14:34:47.070 DEBUG 1 --- [ctor-http-nio-4] r.n.resources.PooledConnectionProvider : [id: 0x339fae79, L:/10.1.83.63:48088 - R:config-binding-service/10.152.183.193:10443] onStateChange(GET{uri=/service_component_all/s933aeace3b17437aaf56a316f9430659-dcae-tcagen2-policy, connection=PooledConnection{channel=[id: 0x339fae79, L:/10.1.83.63:48088 - R:config-binding-service/10.152.183.193:10443]}}, [request_sent]) 2020-10-02 14:34:47.099 DEBUG 1 --- [ctor-http-nio-4] r.n.http.client.HttpClientOperations : [id: 0x339fae79, L:/10.1.83.63:48088 - R:config-binding-service/10.152.183.193:10443] Received response (auto-read:false) : [x-onap-requestid=8fc300cc-5dce-4487-887b-ab13db2d6657, Content-Type=application/json, Content-Length=5153, Date=Fri, 02 Oct 2020 14:34:47 GMT] 2020-10-02 14:34:47.100 DEBUG 1 --- [ctor-http-nio-4] r.n.resources.PooledConnectionProvider : [id: 0x339fae79, L:/10.1.83.63:48088 - R:config-binding-service/10.152.183.193:10443] onStateChange(GET{uri=/service_component_all/s933aeace3b17437aaf56a316f9430659-dcae-tcagen2-policy, connection=PooledConnection{channel=[id: 0x339fae79, L:/10.1.83.63:48088 - R:config-binding-service/10.152.183.193:10443]}}, [response_received]) 2020-10-02 14:34:47.112 DEBUG 1 --- [ctor-http-nio-4] reactor.netty.channel.FluxReceive : [id: 0x339fae79, L:/10.1.83.63:48088 - R:config-binding-service/10.152.183.193:10443] Subscribing inbound receiver [pending: 0, cancelled:false, inboundDone: false] 2020-10-02 14:34:47.113 DEBUG 1 --- [ctor-http-nio-4] o.o.d.s.s.r.s.a.http.RxHttpClient : Response status: 200 OK 2020-10-02 14:34:47.122 DEBUG 1 --- [ctor-http-nio-4] r.n.http.client.HttpClientOperations : [id: 0x339fae79, L:/10.1.83.63:48088 - R:config-binding-service/10.152.183.193:10443] Received last HTTP packet 2020-10-02 14:34:47.173 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-02 14:34:47.173 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-02T14:32:02.000Z","update_id":"54da93f5-ff3f-44c1-a14f-64b549794727","policies_count":1},"items":[{"policyName":"onap.vfirewall.tca.1-0-0.xml","name":"onap.vfirewall.tca","config":{"tca.policy":{"domain":"measurementsForVfScaling","metricsPerEventName":[{"policyName":"DCAE.Config_tca-hi-lo","policyScope":"DCAE","thresholds":[{"direction":"LESS_OR_EQUAL","severity":"MAJOR","closedLoopControlName":"ControlLoop-vFirewall-d0a1dfc6-94f5-4fd4-a5b5-4630b438850a","fieldPath":"$.event.measurementsForVfScalingFields.vNicPerformanceArray[*].receivedTotalPacketsDelta","version":"1.0.2","closedLoopEventStatus":"ONSET","thresholdValue":300},{"direction":"GREATER_OR_EQUAL","severity":"CRITICAL","closedLoopControlName":"ControlLoop-vFirewall-d0a1dfc6-94f5-4fd4-a5b5-4630b438850a","fieldPath":"$.event.measurementsForVfScalingFields.vNicPerformanceArray[*].receivedTotalPacketsDelta","version":"1.0.2","closedLoopEventStatus":"ONSET","thresholdValue":700}],"eventName":"vFirewallBroadcastPackets","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":"onap.vfirewall.tca","policy-version":"1.0.0"}}]}} 2020-10-02 14:34:47.182 ERROR 1 --- [ctor-http-nio-4] igBindingServiceEnvironmentPostProcessor : Could not refresh application configuration java.lang.NullPointerException 2020-10-02 14:34:47.183 ERROR 1 --- [ctor-http-nio-4] igBindingServiceEnvironmentPostProcessor : Configuration refresh terminated 2020-10-02 14:34:47.184 DEBUG 1 --- [ctor-http-nio-4] r.n.resources.PooledConnectionProvider : [id: 0x339fae79, L:/10.1.83.63:48088 - R:config-binding-service/10.152.183.193:10443] onStateChange(GET{uri=/service_component_all/s933aeace3b17437aaf56a316f9430659-dcae-tcagen2-policy, connection=PooledConnection{channel=[id: 0x339fae79, L:/10.1.83.63:48088 - R:config-binding-service/10.152.183.193:10443]}}, [disconnecting]) 2020-10-02 14:34:47.184 DEBUG 1 --- [ctor-http-nio-4] r.n.resources.PooledConnectionProvider : [id: 0x339fae79, L:/10.1.83.63:48088 - R:config-binding-service/10.152.183.193:10443] Releasing channel 2020-10-02 14:34:47.185 DEBUG 1 --- [ctor-http-nio-4] r.n.resources.PooledConnectionProvider : [id: 0x339fae79, L:/10.1.83.63:48088 - R:config-binding-service/10.152.183.193:10443] Channel cleaned, now 0 active connections and 1 inactive connections 2020-10-02 14:34:47.194 INFO 1 --- [ main] o.o.dcae.analytics.tca.web.TcaAppMain : Starting TcaAppMain v1.2.0 on s933aeace3b17437aaf56a316f9430659-dcae-tcagen2-policy with PID 1 (/opt/dcae-analytics-tca-web-1.2.0.jar started by tca-gen2 in /opt) 2020-10-02 14:34:47.196 DEBUG 1 --- [ main] o.o.dcae.analytics.tca.web.TcaAppMain : Running with Spring Boot v2.0.9.RELEASE, Spring v5.0.13.RELEASE 2020-10-02 14:34:47.197 INFO 1 --- [ main] o.o.dcae.analytics.tca.web.TcaAppMain : The following profiles are active: configBindingService,dmaap,mongo 2020-10-02 14:34:47.241 INFO 1 --- [ main] ConfigServletWebServerApplicationContext : Refreshing org.springframework.boot.web.servlet.context.AnnotationConfigServletWebServerApplicationContext@275bf9b3: startup date [Fri Oct 02 14:34:47 UTC 2020]; root of context hierarchy 2020-10-02 14:34:48.623 INFO 1 --- [ main] o.s.i.config.IntegrationRegistrar : No bean named 'integrationHeaderChannelRegistry' has been explicitly defined. Therefore, a default DefaultHeaderChannelRegistry will be created. 2020-10-02 14:34:49.925 INFO 1 --- [ main] faultConfiguringBeanFactoryPostProcessor : No bean named 'taskScheduler' has been explicitly defined. Therefore, a default ThreadPoolTaskScheduler will be created. 2020-10-02 14:34:50.032 INFO 1 --- [ main] trationDelegate$BeanPostProcessorChecker : Bean 'configurationPropertiesValidator' of type [org.onap.dcae.analytics.tca.web.validation.TcaAppPropertiesValidator] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2020-10-02 14:34:50.557 INFO 1 --- [ main] trationDelegate$BeanPostProcessorChecker : Bean 'org.springframework.integration.config.IntegrationManagementConfiguration' of type [org.springframework.integration.config.IntegrationManagementConfiguration$$EnhancerBySpringCGLIB$$9999d492] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2020-10-02 14:34:51.354 INFO 1 --- [ main] io.undertow.servlet : Initializing Spring embedded WebApplicationContext 2020-10-02 14:34:51.354 INFO 1 --- [ main] o.s.web.context.ContextLoader : Root WebApplicationContext: initialization completed in 4113 ms 2020-10-02 14:34:52.307 INFO 1 --- [ main] o.s.b.w.servlet.FilterRegistrationBean : Mapping filter: 'characterEncodingFilter' to: [/*] 2020-10-02 14:34:52.309 INFO 1 --- [ main] o.s.b.w.servlet.FilterRegistrationBean : Mapping filter: 'webMvcMetricsFilter' to: [/*] 2020-10-02 14:34:52.309 INFO 1 --- [ main] o.s.b.w.servlet.FilterRegistrationBean : Mapping filter: 'hiddenHttpMethodFilter' to: [/*] 2020-10-02 14:34:52.309 INFO 1 --- [ main] o.s.b.w.servlet.FilterRegistrationBean : Mapping filter: 'httpPutFormContentFilter' to: [/*] 2020-10-02 14:34:52.309 INFO 1 --- [ main] o.s.b.w.servlet.FilterRegistrationBean : Mapping filter: 'requestContextFilter' to: [/*] 2020-10-02 14:34:52.309 INFO 1 --- [ main] o.s.b.w.servlet.FilterRegistrationBean : Mapping filter: 'httpTraceFilter' to: [/*] 2020-10-02 14:34:52.310 INFO 1 --- [ main] o.s.b.w.servlet.ServletRegistrationBean : Servlet dispatcherServlet mapped to [/] 2020-10-02 14:34:53.023 INFO 1 --- [ main] org.mongodb.driver.cluster : Cluster created with settings {hosts=[localhost:27017], mode=SINGLE, requiredClusterType=UNKNOWN, serverSelectionTimeout='30000 ms', maxWaitQueueSize=500} 2020-10-02 14:34:53.287 INFO 1 --- [localhost:27017] org.mongodb.driver.cluster : Exception in monitor thread while connecting to server localhost:27017 com.mongodb.MongoSocketOpenException: Exception opening socket at com.mongodb.connection.SocketStream.open(SocketStream.java:62) at com.mongodb.connection.InternalStreamConnection.open(InternalStreamConnection.java:126) at com.mongodb.connection.DefaultServerMonitor$ServerMonitorRunnable.run(DefaultServerMonitor.java:114) at java.base/java.lang.Thread.run(Unknown Source) Caused by: java.net.ConnectException: Connection refused (Connection refused) at java.base/java.net.PlainSocketImpl.socketConnect(Native Method) at java.base/java.net.AbstractPlainSocketImpl.doConnect(Unknown Source) at java.base/java.net.AbstractPlainSocketImpl.connectToAddress(Unknown Source) at java.base/java.net.AbstractPlainSocketImpl.connect(Unknown Source) at java.base/java.net.SocksSocketImpl.connect(Unknown Source) at java.base/java.net.Socket.connect(Unknown Source) at com.mongodb.connection.SocketStreamHelper.initialize(SocketStreamHelper.java:59) at com.mongodb.connection.SocketStream.open(SocketStream.java:57) ... 3 common frames omitted 2020-10-02 14:34:53.714 INFO 1 --- [ main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/swagger-resources/configuration/security]}" onto public org.springframework.http.ResponseEntity springfox.documentation.swagger.web.ApiResourceController.securityConfiguration() 2020-10-02 14:34:53.716 INFO 1 --- [ main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/swagger-resources]}" onto public org.springframework.http.ResponseEntity> springfox.documentation.swagger.web.ApiResourceController.swaggerResources() 2020-10-02 14:34:53.717 INFO 1 --- [ main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/swagger-resources/configuration/ui]}" onto public org.springframework.http.ResponseEntity springfox.documentation.swagger.web.ApiResourceController.uiConfiguration() 2020-10-02 14:34:53.730 INFO 1 --- [ main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/api/v1/tca/policy],methods=[GET],produces=[application/json]}" onto public org.springframework.http.ResponseEntity org.onap.dcae.analytics.tca.web.controller.TcaRestController.getTcaPolicy() 2020-10-02 14:34:53.731 INFO 1 --- [ main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/api/v1/tca/policy],methods=[POST],consumes=[application/json],produces=[application/json]}" onto public org.springframework.http.ResponseEntity org.onap.dcae.analytics.tca.web.controller.TcaRestController.setTcaPolicy(org.onap.dcae.analytics.tca.model.policy.TcaPolicy) 2020-10-02 14:34:53.731 INFO 1 --- [ main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/api/v1/tca/execute],methods=[POST],consumes=[application/json],produces=[application/json]}" onto public org.springframework.http.ResponseEntity> org.onap.dcae.analytics.tca.web.controller.TcaRestController.execute(org.onap.dcae.analytics.tca.model.restapi.TcaExecutionRequest) 2020-10-02 14:34:53.736 INFO 1 --- [ main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/error],produces=[text/html]}" onto public org.springframework.web.servlet.ModelAndView org.springframework.boot.autoconfigure.web.servlet.error.BasicErrorController.errorHtml(javax.servlet.http.HttpServletRequest,javax.servlet.http.HttpServletResponse) 2020-10-02 14:34:53.736 INFO 1 --- [ main] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped "{[/error]}" onto public org.springframework.http.ResponseEntity> org.springframework.boot.autoconfigure.web.servlet.error.BasicErrorController.error(javax.servlet.http.HttpServletRequest) 2020-10-02 14:34:53.842 INFO 1 --- [ main] o.s.b.a.e.web.EndpointLinksResolver : Exposing 16 endpoint(s) beneath base path '/actuator' 2020-10-02 14:34:53.859 INFO 1 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/auditevents],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map) 2020-10-02 14:34:53.860 INFO 1 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/beans],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map) 2020-10-02 14:34:53.860 INFO 1 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/health],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map) 2020-10-02 14:34:53.861 INFO 1 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/conditions],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map) 2020-10-02 14:34:53.861 INFO 1 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/shutdown],methods=[POST],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map) 2020-10-02 14:34:53.862 INFO 1 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/configprops],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map) 2020-10-02 14:34:53.862 INFO 1 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/env/{toMatch}],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map) 2020-10-02 14:34:53.862 INFO 1 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/env],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map) 2020-10-02 14:34:53.863 INFO 1 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/info],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map) 2020-10-02 14:34:53.863 INFO 1 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/loggers],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map) 2020-10-02 14:34:53.863 INFO 1 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/loggers/{name}],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map) 2020-10-02 14:34:53.864 INFO 1 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/loggers/{name}],methods=[POST],consumes=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map) 2020-10-02 14:34:53.864 INFO 1 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/heapdump],methods=[GET],produces=[application/octet-stream]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map) 2020-10-02 14:34:53.864 INFO 1 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/threaddump],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map) 2020-10-02 14:34:53.865 INFO 1 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/prometheus],methods=[GET],produces=[text/plain;version=0.0.4;charset=utf-8]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map) 2020-10-02 14:34:53.865 INFO 1 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/metrics/{requiredMetricName}],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map) 2020-10-02 14:34:53.865 INFO 1 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/metrics],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map) 2020-10-02 14:34:53.866 INFO 1 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/scheduledtasks],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map) 2020-10-02 14:34:53.866 INFO 1 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/httptrace],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map) 2020-10-02 14:34:53.866 INFO 1 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator/mappings],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto public java.lang.Object org.springframework.boot.actuate.endpoint.web.servlet.AbstractWebMvcEndpointHandlerMapping$OperationHandler.handle(javax.servlet.http.HttpServletRequest,java.util.Map) 2020-10-02 14:34:53.867 INFO 1 --- [ main] s.b.a.e.w.s.WebMvcEndpointHandlerMapping : Mapped "{[/actuator],methods=[GET],produces=[application/vnd.spring-boot.actuator.v2+json || application/json]}" onto protected java.util.Map> org.springframework.boot.actuate.endpoint.web.servlet.WebMvcEndpointHandlerMapping.links(javax.servlet.http.HttpServletRequest,javax.servlet.http.HttpServletResponse) 2020-10-02 14:34:54.065 WARN 1 --- [ main] ConfigServletWebServerApplicationContext : Exception encountered during context initialization - cancelling refresh attempt: org.springframework.beans.factory.UnsatisfiedDependencyException: Error creating bean with name 'mrSubscriberPollingAdvice' defined in org.onap.dcae.analytics.web.config.DmaapPollerConfig: Unsatisfied dependency expressed through method 'mrSubscriberPollingAdvice' parameter 0; nested exception is org.springframework.beans.factory.UnsatisfiedDependencyException: Error creating bean with name 'dynamicPeriodicTrigger' defined in org.onap.dcae.analytics.web.config.DmaapPollerConfig: Unsatisfied dependency expressed through method 'dynamicPeriodicTrigger' parameter 0; nested exception is org.springframework.beans.factory.BeanCreationException: Error creating bean with name 'mrSubscriberPreferences' defined in org.onap.dcae.analytics.tca.web.config.TcaMrConfig: Bean instantiation via factory method failed; nested exception is org.springframework.beans.BeanInstantiationException: Failed to instantiate [org.onap.dcae.analytics.web.dmaap.MrSubscriberPreferences]: Factory method 'mrSubscriberPreferences' threw exception; nested exception is java.lang.IndexOutOfBoundsException: Index 0 out of bounds for length 0 2020-10-02 14:34:54.079 INFO 1 --- [ main] ConditionEvaluationReportLoggingListener : Error starting ApplicationContext. To display the conditions report re-run your application with 'debug' enabled. 2020-10-02 14:34:54.081 ERROR 1 --- [ main] o.s.boot.SpringApplication : Application run failed org.springframework.beans.factory.UnsatisfiedDependencyException: Error creating bean with name 'mrSubscriberPollingAdvice' defined in org.onap.dcae.analytics.web.config.DmaapPollerConfig: Unsatisfied dependency expressed through method 'mrSubscriberPollingAdvice' parameter 0; nested exception is org.springframework.beans.factory.UnsatisfiedDependencyException: Error creating bean with name 'dynamicPeriodicTrigger' defined in org.onap.dcae.analytics.web.config.DmaapPollerConfig: Unsatisfied dependency expressed through method 'dynamicPeriodicTrigger' parameter 0; nested exception is org.springframework.beans.factory.BeanCreationException: Error creating bean with name 'mrSubscriberPreferences' defined in org.onap.dcae.analytics.tca.web.config.TcaMrConfig: Bean instantiation via factory method failed; nested exception is org.springframework.beans.BeanInstantiationException: Failed to instantiate [org.onap.dcae.analytics.web.dmaap.MrSubscriberPreferences]: Factory method 'mrSubscriberPreferences' threw exception; nested exception is java.lang.IndexOutOfBoundsException: Index 0 out of bounds for length 0 at org.springframework.beans.factory.support.ConstructorResolver.createArgumentArray(ConstructorResolver.java:733) at org.springframework.beans.factory.support.ConstructorResolver.instantiateUsingFactoryMethod(ConstructorResolver.java:475) at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.instantiateUsingFactoryMethod(AbstractAutowireCapableBeanFactory.java:1246) at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBeanInstance(AbstractAutowireCapableBeanFactory.java:1096) at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.doCreateBean(AbstractAutowireCapableBeanFactory.java:535) at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:495) at org.springframework.beans.factory.support.AbstractBeanFactory.lambda$doGetBean$0(AbstractBeanFactory.java:317) at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:222) at org.springframework.beans.factory.support.AbstractBeanFactory.doGetBean(AbstractBeanFactory.java:315) at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:199) at org.springframework.beans.factory.support.DefaultListableBeanFactory.preInstantiateSingletons(DefaultListableBeanFactory.java:762) at org.springframework.context.support.AbstractApplicationContext.finishBeanFactoryInitialization(AbstractApplicationContext.java:881) at org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:551) at org.springframework.boot.web.servlet.context.ServletWebServerApplicationContext.refresh(ServletWebServerApplicationContext.java:142) at org.springframework.boot.SpringApplication.refresh(SpringApplication.java:754) at org.springframework.boot.SpringApplication.refreshContext(SpringApplication.java:386) at org.springframework.boot.SpringApplication.run(SpringApplication.java:307) at org.springframework.boot.SpringApplication.run(SpringApplication.java:1242) at org.springframework.boot.SpringApplication.run(SpringApplication.java:1230) at org.onap.dcae.analytics.tca.web.TcaAppMain.main(TcaAppMain.java:39) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(Unknown Source) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source) at java.base/java.lang.reflect.Method.invoke(Unknown Source) at org.springframework.boot.loader.MainMethodRunner.run(MainMethodRunner.java:48) at org.springframework.boot.loader.Launcher.launch(Launcher.java:87) at org.springframework.boot.loader.Launcher.launch(Launcher.java:50) at org.springframework.boot.loader.JarLauncher.main(JarLauncher.java:51) Caused by: org.springframework.beans.factory.UnsatisfiedDependencyException: Error creating bean with name 'dynamicPeriodicTrigger' defined in org.onap.dcae.analytics.web.config.DmaapPollerConfig: Unsatisfied dependency expressed through method 'dynamicPeriodicTrigger' parameter 0; nested exception is org.springframework.beans.factory.BeanCreationException: Error creating bean with name 'mrSubscriberPreferences' defined in org.onap.dcae.analytics.tca.web.config.TcaMrConfig: Bean instantiation via factory method failed; nested exception is org.springframework.beans.BeanInstantiationException: Failed to instantiate [org.onap.dcae.analytics.web.dmaap.MrSubscriberPreferences]: Factory method 'mrSubscriberPreferences' threw exception; nested exception is java.lang.IndexOutOfBoundsException: Index 0 out of bounds for length 0 at org.springframework.beans.factory.support.ConstructorResolver.createArgumentArray(ConstructorResolver.java:733) at org.springframework.beans.factory.support.ConstructorResolver.instantiateUsingFactoryMethod(ConstructorResolver.java:475) at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.instantiateUsingFactoryMethod(AbstractAutowireCapableBeanFactory.java:1246) at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBeanInstance(AbstractAutowireCapableBeanFactory.java:1096) at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.doCreateBean(AbstractAutowireCapableBeanFactory.java:535) at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:495) at org.springframework.beans.factory.support.AbstractBeanFactory.lambda$doGetBean$0(AbstractBeanFactory.java:317) at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:222) at org.springframework.beans.factory.support.AbstractBeanFactory.doGetBean(AbstractBeanFactory.java:315) at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:199) at org.springframework.beans.factory.config.DependencyDescriptor.resolveCandidate(DependencyDescriptor.java:251) at org.springframework.beans.factory.support.DefaultListableBeanFactory.doResolveDependency(DefaultListableBeanFactory.java:1138) at org.springframework.beans.factory.support.DefaultListableBeanFactory.resolveDependency(DefaultListableBeanFactory.java:1065) at org.springframework.beans.factory.support.ConstructorResolver.resolveAutowiredArgument(ConstructorResolver.java:819) at org.springframework.beans.factory.support.ConstructorResolver.createArgumentArray(ConstructorResolver.java:725) ... 27 common frames omitted Caused by: org.springframework.beans.factory.BeanCreationException: Error creating bean with name 'mrSubscriberPreferences' defined in org.onap.dcae.analytics.tca.web.config.TcaMrConfig: Bean instantiation via factory method failed; nested exception is org.springframework.beans.BeanInstantiationException: Failed to instantiate [org.onap.dcae.analytics.web.dmaap.MrSubscriberPreferences]: Factory method 'mrSubscriberPreferences' threw exception; nested exception is java.lang.IndexOutOfBoundsException: Index 0 out of bounds for length 0 at org.springframework.beans.factory.support.ConstructorResolver.instantiateUsingFactoryMethod(ConstructorResolver.java:591) at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.instantiateUsingFactoryMethod(AbstractAutowireCapableBeanFactory.java:1246) at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBeanInstance(AbstractAutowireCapableBeanFactory.java:1096) at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.doCreateBean(AbstractAutowireCapableBeanFactory.java:535) at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:495) at org.springframework.beans.factory.support.AbstractBeanFactory.lambda$doGetBean$0(AbstractBeanFactory.java:317) at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:222) at org.springframework.beans.factory.support.AbstractBeanFactory.doGetBean(AbstractBeanFactory.java:315) at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:199) at org.springframework.beans.factory.config.DependencyDescriptor.resolveCandidate(DependencyDescriptor.java:251) at org.springframework.beans.factory.support.DefaultListableBeanFactory.doResolveDependency(DefaultListableBeanFactory.java:1138) at org.springframework.beans.factory.support.DefaultListableBeanFactory.resolveDependency(DefaultListableBeanFactory.java:1065) at org.springframework.beans.factory.support.ConstructorResolver.resolveAutowiredArgument(ConstructorResolver.java:819) at org.springframework.beans.factory.support.ConstructorResolver.createArgumentArray(ConstructorResolver.java:725) ... 41 common frames omitted Caused by: org.springframework.beans.BeanInstantiationException: Failed to instantiate [org.onap.dcae.analytics.web.dmaap.MrSubscriberPreferences]: Factory method 'mrSubscriberPreferences' threw exception; nested exception is java.lang.IndexOutOfBoundsException: Index 0 out of bounds for length 0 at org.springframework.beans.factory.support.SimpleInstantiationStrategy.instantiate(SimpleInstantiationStrategy.java:185) at org.springframework.beans.factory.support.ConstructorResolver.instantiateUsingFactoryMethod(ConstructorResolver.java:583) ... 54 common frames omitted Caused by: java.lang.IndexOutOfBoundsException: Index 0 out of bounds for length 0 at java.base/jdk.internal.util.Preconditions.outOfBounds(Unknown Source) at java.base/jdk.internal.util.Preconditions.outOfBoundsCheckIndex(Unknown Source) at java.base/jdk.internal.util.Preconditions.checkIndex(Unknown Source) at java.base/java.util.Objects.checkIndex(Unknown Source) at java.base/java.util.ArrayList.get(Unknown Source) at org.onap.dcae.analytics.tca.web.util.function.TcaAppPropsToMrSubscriberPrefsFunction.apply(TcaAppPropsToMrSubscriberPrefsFunction.java:59) at org.onap.dcae.analytics.tca.web.config.TcaMrConfig.mrSubscriberPreferences(TcaMrConfig.java:58) at org.onap.dcae.analytics.tca.web.config.TcaMrConfig$$EnhancerBySpringCGLIB$$791e4be8.CGLIB$mrSubscriberPreferences$1() at org.onap.dcae.analytics.tca.web.config.TcaMrConfig$$EnhancerBySpringCGLIB$$791e4be8$$FastClassBySpringCGLIB$$473dc670.invoke() at org.springframework.cglib.proxy.MethodProxy.invokeSuper(MethodProxy.java:244) at org.springframework.context.annotation.ConfigurationClassEnhancer$BeanMethodInterceptor.intercept(ConfigurationClassEnhancer.java:365) at org.onap.dcae.analytics.tca.web.config.TcaMrConfig$$EnhancerBySpringCGLIB$$791e4be8.mrSubscriberPreferences() at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(Unknown Source) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source) at java.base/java.lang.reflect.Method.invoke(Unknown Source) at org.springframework.beans.factory.support.SimpleInstantiationStrategy.instantiate(SimpleInstantiationStrategy.java:154) ... 55 common frames omitted Policy in consul {"policyName": "onap.vfirewall.tca.1-0-0.xml", "name": "onap.vfirewall.tca", "type": "onap.policies.monitoring.tcagen2", "type_version": "1.0.0", "version": "1.0.0", "metadata": {"policy-id": "onap.vfirewall.tca", "policy-version": "1.0.0"}, "config": {"tca.policy": {"domain": "measurementsForVfScaling", "metricsPerEventName": [{"policyName": "DCAE.Config_tca-hi-lo", "policyScope": "DCAE", "thresholds": [{"direction": "LESS_OR_EQUAL", "severity": "MAJOR", "closedLoopControlName": "ControlLoop-vFirewall-d0a1dfc6-94f5-4fd4-a5b5-4630b438850a", "fieldPath": "$.event.measurementsForVfScalingFields.vNicPerformanceArray[*].receivedTotalPacketsDelta", "version": "1.0.2", "closedLoopEventStatus": "ONSET", "thresholdValue": 300}, {"direction": "GREATER_OR_EQUAL", "severity": "CRITICAL", "closedLoopControlName": "ControlLoop-vFirewall-d0a1dfc6-94f5-4fd4-a5b5-4630b438850a", "fieldPath": "$.event.measurementsForVfScalingFields.vNicPerformanceArray[*].receivedTotalPacketsDelta", "version": "1.0.2", "closedLoopEventStatus": "ONSET", "thresholdValue": 650}], "eventName": "vFirewallBroadcastPackets", "controlLoopSchemaType": "VM", "policyVersion": "v0.0.1"}]}}, "policyVersion": "1.0.0"}