By type
2022/03/14 04:34:40.349596 beat.go:285: INFO Home path: [/usr/share/filebeat] Config path: [/usr/share/filebeat] Data path: [/usr/share/filebeat/data] Logs path: [/usr/share/filebeat/logs] 2022/03/14 04:34:40.349656 beat.go:186: INFO Setup Beat: filebeat; Version: 5.5.0 2022/03/14 04:34:40.349670 processor.go:44: DBG Processors: 2022/03/14 04:34:40.349684 beat.go:192: DBG Initializing output plugins 2022/03/14 04:34:40.349803 metrics.go:23: INFO Metrics logging every 30s 2022/03/14 04:34:40.349820 logstash.go:90: INFO Max Retries set to: 3 2022/03/14 04:34:40.350020 outputs.go:108: INFO Activated logstash as output plugin. 2022/03/14 04:34:40.350085 publish.go:238: DBG Create output worker 2022/03/14 04:34:40.350234 publish.go:280: DBG No output is defined to store the topology. The server fields might not be filled. 2022/03/14 04:34:40.350327 publish.go:295: INFO Publisher name: dcae-pm-mapper 2022/03/14 04:34:40.350742 async.go:63: INFO Flush Interval set to: 1s 2022/03/14 04:34:40.350768 async.go:64: INFO Max Bulk Size set to: 2048 2022/03/14 04:34:40.350787 async.go:72: DBG create bulk processing worker (interval=1s, bulk size=2048) 2022/03/14 04:34:40.351478 beat.go:221: INFO filebeat start running. 2022/03/14 04:34:40.351593 registrar.go:68: INFO No registry file found under: /usr/share/filebeat/data/registry. Creating a new registry file. 2022/03/14 04:34:40.351617 registrar.go:298: DBG Write registry file: /usr/share/filebeat/data/registry 2022/03/14 04:34:40.356677 registrar.go:323: DBG Registry file updated. 0 states written. 2022/03/14 04:34:40.356816 registrar.go:106: INFO Loading registrar data from /usr/share/filebeat/data/registry 2022/03/14 04:34:40.356901 registrar.go:123: INFO States Loaded from registrar: 0 2022/03/14 04:34:40.356959 crawler.go:38: INFO Loading Prospectors: 1 2022/03/14 04:34:40.357017 registrar.go:236: INFO Starting Registrar 2022/03/14 04:34:40.357166 spooler.go:63: INFO Starting spooler: spool_size: 2048; idle_timeout: 5s 2022/03/14 04:34:40.357190 prospector.go:83: DBG File Configs: [/var/log/onap/*/*/*/*.log /var/log/onap/*/*/*.log /var/log/onap/*/*.log] 2022/03/14 04:34:40.357233 prospector_log.go:44: DBG exclude_files: [] 2022/03/14 04:34:40.357250 prospector_log.go:65: INFO Prospector with previous states loaded: 0 2022/03/14 04:34:40.357093 sync.go:41: INFO Start sending events to output 2022/03/14 04:34:40.357390 prospector.go:124: INFO Starting prospector of type: log; id: 12576369028753478767 2022/03/14 04:34:40.357434 crawler.go:58: INFO Loading and starting Prospectors completed. Enabled prospectors: 1 2022/03/14 04:34:40.357513 prospector_log.go:70: DBG Start next scan 2022/03/14 04:34:40.357819 prospector_log.go:91: DBG Prospector states cleaned up. Before: 0, After: 0 2022/03/14 04:34:45.357526 spooler.go:89: DBG Flushing spooler because of timeout. Events flushed: 0 2022/03/14 04:34:50.357969 spooler.go:89: DBG Flushing spooler because of timeout. Events flushed: 0 2022/03/14 04:34:50.358188 prospector.go:183: DBG Run prospector 2022/03/14 04:34:50.358336 prospector_log.go:70: DBG Start next scan 2022/03/14 04:34:50.358854 prospector_log.go:226: DBG Check file for harvesting: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log 2022/03/14 04:34:50.358875 prospector_log.go:245: DBG Start harvester for new file: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log 2022/03/14 04:34:50.359025 state.go:64: DBG New state added for /var/log/onap/dcae-pm-mapper/pm-mapper_output.log 2022/03/14 04:34:50.359071 log.go:288: DBG Setting offset for file based on seek: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log 2022/03/14 04:34:50.359096 log.go:273: DBG Setting offset for file: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log. Offset: 0 2022/03/14 04:34:50.359158 prospector_log.go:226: DBG Check file for harvesting: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log 2022/03/14 04:34:50.359175 prospector_log.go:245: DBG Start harvester for new file: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log 2022/03/14 04:34:50.359280 state.go:64: DBG New state added for /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log 2022/03/14 04:34:50.359319 log.go:288: DBG Setting offset for file based on seek: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log 2022/03/14 04:34:50.359328 log.go:273: DBG Setting offset for file: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log. Offset: 0 2022/03/14 04:34:50.359358 prospector_log.go:91: DBG Prospector states cleaned up. Before: 2, After: 2 2022/03/14 04:34:50.359423 log.go:91: INFO Harvester started for file: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log 2022/03/14 04:34:50.359620 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log; Backoff now. 2022/03/14 04:34:50.359662 log.go:91: INFO Harvester started for file: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log 2022/03/14 04:34:50.359802 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log; Backoff now. 2022/03/14 04:34:51.360171 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log; Backoff now. 2022/03/14 04:34:51.360474 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log; Backoff now. 2022/03/14 04:34:52.360661 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log; Backoff now. 2022/03/14 04:34:52.360842 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log; Backoff now. 2022/03/14 04:34:54.361228 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log; Backoff now. 2022/03/14 04:34:54.361304 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log; Backoff now. 2022/03/14 04:34:55.358675 spooler.go:89: DBG Flushing spooler because of timeout. Events flushed: 40 2022/03/14 04:34:55.359303 client.go:214: DBG Publish: { "@timestamp": "2022-03-14T04:34:50.359Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-03-14T04:34:41.789Z | INFO | Fetching pm-mapper configuration from Configbinding Service", "offset": 94, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log", "type": "log" } 2022/03/14 04:34:55.359414 client.go:214: DBG Publish: { "@timestamp": "2022-03-14T04:34:50.359Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-03-14T04:34:41.965Z | INFO | e1ae76a0-5077-4d8b-9a31-50cc64806072", "offset": 165, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log", "type": "log" } 2022/03/14 04:34:55.359507 client.go:214: DBG Publish: { "@timestamp": "2022-03-14T04:34:50.359Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-03-14T04:34:41.968Z | INFO | Sending GET request to http://10.233.31.100:10000/service_component/dcae-pm-mapper.", "offset": 283, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log", "type": "log" } 2022/03/14 04:34:55.359697 client.go:214: DBG Publish: { "@timestamp": "2022-03-14T04:34:50.359Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-03-14T04:34:42.039Z | INFO | Response code: 200, Server Response Received:\\n{\"trust_store_path\": \"/opt/app/pm-mapper/etc/cert/trust.jks\", \"trust_store_pass_path\": \"/opt/app/pm-mapper/etc/cert/trust.pass\", \"key_store_path\": \"/opt/app/pm-mapper/etc/cert/cert.jks\", \"key_store_pass_path\": \"/opt/app/pm-mapper/etc/cert/jks.pass\", \"pm-mapper-filter\": \"{ \\\"filters\\\":[] }\", \"enable_http\": false, \"dmaap_dr_delete_endpoint\": \"https://dmaap-dr-node:8443/delete\", \"aaf_identity\": \"dcae@dcae.onap.org\", \"aaf_password\": *****, \"streams_subscribes\": {\"dmaap_subscriber\": {\"type\": \"data_router\", \"dmaap_info\": {\"subscriber_id\": \"3\", \"location\": \"san-francisco\", \"delivery_url\": \"https://dcae-pm-mapper:8443/delivery\", \"username\": \"username\", \"password\": *****, \"decompress\": true, \"privilegedSubscriber\": true}}}, \"streams_publishes\": {\"dmaap_publisher\": {\"type\": \"message_router\", \"dmaap_info\": {\"topic_url\": \"http://message-router:3904/events/org.onap.dmaap.mr.PERFORMANCE_MEASUREMENTS\", \"client_id\": \"1647232455492\", \"location\": \"san-francisco\", \"client_role\": \"org.onap.dcae.pmPublisher\"}}}}", "offset": 1371, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log", "type": "log" } 2022/03/14 04:34:55.359826 client.go:214: DBG Publish: { "@timestamp": "2022-03-14T04:34:50.359Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-03-14T04:34:42.374Z | INFO | Received pm-mapper configuration from ConfigBinding Service", "offset": 1465, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log", "type": "log" } 2022/03/14 04:34:55.359906 client.go:214: DBG Publish: { "@timestamp": "2022-03-14T04:34:50.359Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-03-14T04:34:44.164Z | INFO | Attempt to read threads configuration", "offset": 1537, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log", "type": "log" } 2022/03/14 04:34:55.359966 client.go:214: DBG Publish: { "@timestamp": "2022-03-14T04:34:50.359Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-03-14T04:34:44.166Z | INFO | PROCESSING_THREADS_COUNT env not present. Setting threads count to available cores: 1", "offset": 1657, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log", "type": "log" } 2022/03/14 04:34:55.360058 client.go:214: DBG Publish: { "@timestamp": "2022-03-14T04:34:50.359Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-03-14T04:34:44.167Z | INFO | THREADS_MULTIPLIER env not present. Setting multiplier to default value: 1", "offset": 1766, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log", "type": "log" } 2022/03/14 04:34:55.360145 client.go:214: DBG Publish: { "@timestamp": "2022-03-14T04:34:50.359Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-03-14T04:34:44.168Z | INFO | Processing threads configuration: Processing threads count - 1, Processing threads multiplier - 1 ", "offset": 1899, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log", "type": "log" } 2022/03/14 04:34:55.360231 client.go:214: DBG Publish: { "@timestamp": "2022-03-14T04:34:50.359Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-03-14T04:34:44.169Z | INFO | Amount of files processing threads: 1 ", "offset": 1972, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log", "type": "log" } 2022/03/14 04:34:55.360303 client.go:214: DBG Publish: { "@timestamp": "2022-03-14T04:34:50.359Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-03-14T04:34:44.172Z | INFO | Trying to read PROCESSING_LIMIT_RATE env.", "offset": 2048, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log", "type": "log" } 2022/03/14 04:34:55.360391 client.go:214: DBG Publish: { "@timestamp": "2022-03-14T04:34:50.359Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-03-14T04:34:44.173Z | INFO | PROCESSING_LIMIT_RATE env not present. Setting limit rate to default value: 1", "offset": 2160, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log", "type": "log" } 2022/03/14 04:34:55.360457 client.go:214: DBG Publish: { "@timestamp": "2022-03-14T04:34:50.359Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-03-14T04:34:44.778Z | INFO | starting server: Undertow - 2.2.9.Final", "offset": 2234, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log", "type": "log" } 2022/03/14 04:34:55.360532 client.go:214: DBG Publish: { "@timestamp": "2022-03-14T04:34:50.359Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-03-14T04:34:44.795Z | INFO | XNIO version 3.8.4.Final", "offset": 2293, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log", "type": "log" } 2022/03/14 04:34:55.360612 client.go:214: DBG Publish: { "@timestamp": "2022-03-14T04:34:50.359Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-03-14T04:34:44.868Z | INFO | XNIO NIO Implementation Version 3.8.4.Final", "offset": 2371, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log", "type": "log" } 2022/03/14 04:34:55.360710 client.go:214: DBG Publish: { "@timestamp": "2022-03-14T04:34:50.359Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-03-14T04:34:45.266Z | INFO | JBoss Threads version 3.1.0.Final", "offset": 2439, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log", "type": "log" } 2022/03/14 04:34:55.360789 client.go:214: DBG Publish: { "@timestamp": "2022-03-14T04:34:50.359Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-03-14T04:34:41.789Z\tmain\tINFO\torg.onap.dcaegen2.services.pmmapper.config.ConfigHandler\t\tFetching pm-mapper configuration from Configbinding Service\t\t\t", "offset": 156, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output.log", "type": "log" } 2022/03/14 04:34:55.360857 client.go:214: DBG Publish: { "@timestamp": "2022-03-14T04:34:50.359Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-03-14T04:34:41.965Z\tmain\tINFO\torg.onap.dcaegen2.services.pmmapper.utils.RequestSender\t\te1ae76a0-5077-4d8b-9a31-50cc64806072\t\tINVOKE [ SYNCHRONOUS ]\t", "offset": 310, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output.log", "type": "log" } 2022/03/14 04:34:55.360944 client.go:214: DBG Publish: { "@timestamp": "2022-03-14T04:34:50.359Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-03-14T04:34:41.968Z\tmain\tINFO\torg.onap.dcaegen2.services.pmmapper.utils.RequestSender\t\tSending GET request to http://10.233.31.100:10000/service_component/dcae-pm-mapper.\t\t\t", "offset": 489, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output.log", "type": "log" } 2022/03/14 04:34:55.361116 client.go:214: DBG Publish: { "@timestamp": "2022-03-14T04:34:50.359Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-03-14T04:34:42.039Z\tmain\tINFO\torg.onap.dcaegen2.services.pmmapper.utils.RequestSender\t\tResponse code: 200, Server Response Received:\\n{\"trust_store_path\": \"/opt/app/pm-mapper/etc/cert/trust.jks\", \"trust_store_pass_path\": \"/opt/app/pm-mapper/etc/cert/trust.pass\", \"key_store_path\": \"/opt/app/pm-mapper/etc/cert/cert.jks\", \"key_store_pass_path\": \"/opt/app/pm-mapper/etc/cert/jks.pass\", \"pm-mapper-filter\": \"{ \\\"filters\\\":[] }\", \"enable_http\": false, \"dmaap_dr_delete_endpoint\": \"https://dmaap-dr-node:8443/delete\", \"aaf_identity\": \"dcae@dcae.onap.org\", \"aaf_password\": *****, \"streams_subscribes\": {\"dmaap_subscriber\": {\"type\": \"data_router\", \"dmaap_info\": {\"subscriber_id\": \"3\", \"location\": \"san-francisco\", \"delivery_url\": \"https://dcae-pm-mapper:8443/delivery\", \"username\": \"username\", \"password\": *****, \"decompress\": true, \"privilegedSubscriber\": true}}}, \"streams_publishes\": {\"dmaap_publisher\": {\"type\": \"message_router\", \"dmaap_info\": {\"topic_url\": \"http://message-router:3904/events/org.onap.dmaap.mr.PERFORMANCE_MEASUREMENTS\", \"client_id\": \"1647232455492\", \"location\": \"san-francisco\", \"client_role\": \"org.onap.dcae.pmPublisher\"}}}}\t\t\t", "offset": 1638, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output.log", "type": "log" } 2022/03/14 04:34:55.361199 client.go:214: DBG Publish: { "@timestamp": "2022-03-14T04:34:50.359Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-03-14T04:34:42.374Z\tmain\tINFO\torg.onap.dcaegen2.services.pmmapper.config.ConfigHandler\t\tReceived pm-mapper configuration from ConfigBinding Service\t\t\t", "offset": 1794, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output.log", "type": "log" } 2022/03/14 04:34:55.361274 client.go:214: DBG Publish: { "@timestamp": "2022-03-14T04:34:50.359Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-03-14T04:34:44.164Z\tmain\tINFO\torg.onap.dcaegen2.services.pmmapper.config.FilesProcessingConfig\t\tAttempt to read threads configuration\t\t\t", "offset": 1936, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output.log", "type": "log" } 2022/03/14 04:34:55.361373 client.go:214: DBG Publish: { "@timestamp": "2022-03-14T04:34:50.359Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-03-14T04:34:44.166Z\tmain\tINFO\torg.onap.dcaegen2.services.pmmapper.config.FilesProcessingConfig\t\tPROCESSING_THREADS_COUNT env not present. Setting threads count to available cores: 1\t\t\t", "offset": 2126, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output.log", "type": "log" } 2022/03/14 04:34:55.361454 client.go:214: DBG Publish: { "@timestamp": "2022-03-14T04:34:50.359Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-03-14T04:34:44.167Z\tmain\tINFO\torg.onap.dcaegen2.services.pmmapper.config.FilesProcessingConfig\t\tTHREADS_MULTIPLIER env not present. Setting multiplier to default value: 1\t\t\t", "offset": 2305, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output.log", "type": "log" } 2022/03/14 04:34:55.361530 client.go:214: DBG Publish: { "@timestamp": "2022-03-14T04:34:50.359Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-03-14T04:34:44.168Z\tmain\tINFO\torg.onap.dcaegen2.services.pmmapper.config.FilesProcessingConfig\t\tProcessing threads configuration: Processing threads count - 1, Processing threads multiplier - 1 \t\t\t", "offset": 2508, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output.log", "type": "log" } 2022/03/14 04:34:55.361612 client.go:214: DBG Publish: { "@timestamp": "2022-03-14T04:34:50.359Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-03-14T04:34:44.169Z\tmain\tINFO\torg.onap.dcaegen2.services.pmmapper.config.FilesProcessingConfig\t\tAmount of files processing threads: 1 \t\t\t", "offset": 2651, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output.log", "type": "log" } 2022/03/14 04:34:55.361685 client.go:214: DBG Publish: { "@timestamp": "2022-03-14T04:34:50.359Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-03-14T04:34:44.172Z\tmain\tINFO\torg.onap.dcaegen2.services.pmmapper.config.FilesProcessingConfig\t\tTrying to read PROCESSING_LIMIT_RATE env.\t\t\t", "offset": 2797, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output.log", "type": "log" } 2022/03/14 04:34:55.361773 client.go:214: DBG Publish: { "@timestamp": "2022-03-14T04:34:50.359Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-03-14T04:34:44.173Z\tmain\tINFO\torg.onap.dcaegen2.services.pmmapper.config.FilesProcessingConfig\t\tPROCESSING_LIMIT_RATE env not present. Setting limit rate to default value: 1\t\t\t", "offset": 2979, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output.log", "type": "log" } 2022/03/14 04:34:55.361849 client.go:214: DBG Publish: { "@timestamp": "2022-03-14T04:34:50.359Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-03-14T04:34:44.778Z\tmain\tINFO\tio.undertow\t\tstarting server: Undertow - 2.2.9.Final\t\t\t", "offset": 3070, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output.log", "type": "log" } 2022/03/14 04:34:55.361929 client.go:214: DBG Publish: { "@timestamp": "2022-03-14T04:34:50.359Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-03-14T04:34:44.795Z\tmain\tINFO\torg.xnio\t\tXNIO version 3.8.4.Final\t\t\t", "offset": 3143, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output.log", "type": "log" } 2022/03/14 04:34:55.362062 client.go:214: DBG Publish: { "@timestamp": "2022-03-14T04:34:50.359Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-03-14T04:34:44.868Z\tmain\tINFO\torg.xnio.nio\t\tXNIO NIO Implementation Version 3.8.4.Final\t\t\t", "offset": 3239, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output.log", "type": "log" } 2022/03/14 04:34:55.362144 client.go:214: DBG Publish: { "@timestamp": "2022-03-14T04:34:50.359Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-03-14T04:34:45.266Z\tmain\tINFO\torg.jboss.threads\t\tJBoss Threads version 3.1.0.Final\t\t\t", "offset": 3330, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output.log", "type": "log" } 2022/03/14 04:34:55.362240 client.go:214: DBG Publish: { "@timestamp": "2022-03-14T04:34:51.360Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-03-14T04:34:51.205Z\tXNIO-1 I/O-1\tINFO\torg.onap.dcaegen2.services.pmmapper.healthcheck.HealthCheckHandler\tInstanceUUID=d344bf16-7102-4f73-8ac3-22b7377cb68d, RequestID=99f8b80a-2b1b-4f07-8b8d-cb1fb3f5701c, ServiceName=/healthcheck, InvocationID=83229dcf-9e82-4a10-b7d6-c7c5158dbbe4, InvokeTimestamp=2022-03-14T04:34:51.190868Z, PartnerName=, ClientIPAddress=/10.233.67.49, ServerFQDN=10.233.67.212\t\t\tENTRY\t", "offset": 3740, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output.log", "type": "log" } 2022/03/14 04:34:55.362336 client.go:214: DBG Publish: { "@timestamp": "2022-03-14T04:34:51.360Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-03-14T04:34:51.238Z\tXNIO-1 I/O-1\tINFO\torg.onap.dcaegen2.services.pmmapper.healthcheck.HealthCheckHandler\tInstanceUUID=d344bf16-7102-4f73-8ac3-22b7377cb68d, RequestID=99f8b80a-2b1b-4f07-8b8d-cb1fb3f5701c, ServiceName=/healthcheck, InvocationID=83229dcf-9e82-4a10-b7d6-c7c5158dbbe4, InvokeTimestamp=2022-03-14T04:34:51.190868Z, PartnerName=, ClientIPAddress=/10.233.67.49, ServerFQDN=10.233.67.212\tHealthcheck request successful\t\t\t", "offset": 4175, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output.log", "type": "log" } 2022/03/14 04:34:55.362445 client.go:214: DBG Publish: { "@timestamp": "2022-03-14T04:34:51.360Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-03-14T04:34:51.239Z\tXNIO-1 I/O-1\tINFO\torg.onap.dcaegen2.services.pmmapper.healthcheck.HealthCheckHandler\tResponseCode=, InstanceUUID=d344bf16-7102-4f73-8ac3-22b7377cb68d, RequestID=99f8b80a-2b1b-4f07-8b8d-cb1fb3f5701c, ServiceName=/healthcheck, ResponseDescription=, InvocationID=83229dcf-9e82-4a10-b7d6-c7c5158dbbe4, Severity=, InvokeTimestamp=2022-03-14T04:34:51.190868Z, PartnerName=, ClientIPAddress=/10.233.67.49, ServerFQDN=10.233.67.212, StatusCode=\t\t\tEXIT\t", "offset": 4645, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output.log", "type": "log" } 2022/03/14 04:34:55.362540 client.go:214: DBG Publish: { "@timestamp": "2022-03-14T04:34:51.360Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-03-14T04:34:51.205Z | INFO | ", "offset": 2474, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log", "type": "log" } 2022/03/14 04:34:55.362629 client.go:214: DBG Publish: { "@timestamp": "2022-03-14T04:34:51.360Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-03-14T04:34:51.238Z | INFO | Healthcheck request successful", "offset": 2539, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log", "type": "log" } 2022/03/14 04:34:55.362694 client.go:214: DBG Publish: { "@timestamp": "2022-03-14T04:34:51.360Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-03-14T04:34:51.239Z | INFO | ", "offset": 2574, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log", "type": "log" } 2022/03/14 04:34:55.362755 output.go:109: DBG output worker: publish 38 events 2022/03/14 04:34:55.362779 sync.go:53: DBG connect 2022/03/14 04:34:55.370551 tcp.go:26: WARN DNS lookup failure "log-ls.onap": lookup log-ls.onap on 169.254.25.10:53: no such host 2022/03/14 04:34:55.370594 single.go:140: ERR Connecting error publishing events (retrying): lookup log-ls.onap on 169.254.25.10:53: no such host 2022/03/14 04:34:55.370607 single.go:156: DBG send fail 2022/03/14 04:34:56.370904 sync.go:53: DBG connect 2022/03/14 04:34:56.375099 tcp.go:26: WARN DNS lookup failure "log-ls.onap": lookup log-ls.onap on 169.254.25.10:53: no such host 2022/03/14 04:34:56.375141 single.go:140: ERR Connecting error publishing events (retrying): lookup log-ls.onap on 169.254.25.10:53: no such host 2022/03/14 04:34:56.375150 single.go:156: DBG send fail 2022/03/14 04:34:58.362649 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log; Backoff now. 2022/03/14 04:34:58.362706 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log; Backoff now. 2022/03/14 04:34:58.375436 sync.go:53: DBG connect 2022/03/14 04:34:58.379782 tcp.go:26: WARN DNS lookup failure "log-ls.onap": lookup log-ls.onap on 169.254.25.10:53: no such host 2022/03/14 04:34:58.379833 single.go:140: ERR Connecting error publishing events (retrying): lookup log-ls.onap on 169.254.25.10:53: no such host 2022/03/14 04:34:58.379850 single.go:156: DBG send fail 2022/03/14 04:35:00.359218 spooler.go:89: DBG Flushing spooler because of timeout. Events flushed: 0 2022/03/14 04:35:00.359670 prospector.go:183: DBG Run prospector 2022/03/14 04:35:00.359711 prospector_log.go:70: DBG Start next scan 2022/03/14 04:35:00.360316 prospector_log.go:226: DBG Check file for harvesting: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log 2022/03/14 04:35:00.360348 prospector_log.go:259: DBG Update existing file for harvesting: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log, offset: 4645 2022/03/14 04:35:00.360357 prospector_log.go:311: DBG Harvester for file is still running: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log 2022/03/14 04:35:00.360364 prospector_log.go:226: DBG Check file for harvesting: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log 2022/03/14 04:35:00.360371 prospector_log.go:259: DBG Update existing file for harvesting: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log, offset: 2574 2022/03/14 04:35:00.360377 prospector_log.go:311: DBG Harvester for file is still running: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log 2022/03/14 04:35:00.360386 prospector_log.go:91: DBG Prospector states cleaned up. Before: 2, After: 2 2022/03/14 04:35:02.380217 sync.go:53: DBG connect 2022/03/14 04:35:02.383832 tcp.go:26: WARN DNS lookup failure "log-ls.onap": lookup log-ls.onap on 169.254.25.10:53: no such host 2022/03/14 04:35:02.383876 single.go:140: ERR Connecting error publishing events (retrying): lookup log-ls.onap on 169.254.25.10:53: no such host 2022/03/14 04:35:02.383889 single.go:156: DBG send fail 2022/03/14 04:35:05.359647 spooler.go:89: DBG Flushing spooler because of timeout. Events flushed: 0 2022/03/14 04:35:06.363397 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log; Backoff now. 2022/03/14 04:35:06.363396 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log; Backoff now. 2022/03/14 04:35:07.363807 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log; Backoff now. 2022/03/14 04:35:07.363806 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log; Backoff now. 2022/03/14 04:35:09.364238 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log; Backoff now. 2022/03/14 04:35:09.364238 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log; Backoff now. 2022/03/14 04:35:10.350328 metrics.go:39: INFO Non-zero metrics in the last 30s: filebeat.harvester.open_files=2 filebeat.harvester.running=2 filebeat.harvester.started=2 libbeat.publisher.published_events=38 registrar.writes=1 2022/03/14 04:35:10.359940 spooler.go:89: DBG Flushing spooler because of timeout. Events flushed: 6 2022/03/14 04:35:10.360626 prospector.go:183: DBG Run prospector 2022/03/14 04:35:10.360651 prospector_log.go:70: DBG Start next scan 2022/03/14 04:35:10.361176 prospector_log.go:226: DBG Check file for harvesting: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log 2022/03/14 04:35:10.361201 prospector_log.go:259: DBG Update existing file for harvesting: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log, offset: 5960 2022/03/14 04:35:10.361209 prospector_log.go:311: DBG Harvester for file is still running: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log 2022/03/14 04:35:10.361216 prospector_log.go:226: DBG Check file for harvesting: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log 2022/03/14 04:35:10.361223 prospector_log.go:259: DBG Update existing file for harvesting: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log, offset: 2709 2022/03/14 04:35:10.361236 prospector_log.go:311: DBG Harvester for file is still running: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log 2022/03/14 04:35:10.361245 prospector_log.go:91: DBG Prospector states cleaned up. Before: 2, After: 2 2022/03/14 04:35:10.384343 sync.go:53: DBG connect 2022/03/14 04:35:10.388464 tcp.go:26: WARN DNS lookup failure "log-ls.onap": lookup log-ls.onap on 169.254.25.10:53: no such host 2022/03/14 04:35:10.388500 single.go:140: ERR Connecting error publishing events (retrying): lookup log-ls.onap on 169.254.25.10:53: no such host 2022/03/14 04:35:10.388509 single.go:156: DBG send fail 2022/03/14 04:35:13.364671 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log; Backoff now. 2022/03/14 04:35:13.364671 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log; Backoff now. 2022/03/14 04:35:15.365161 spooler.go:89: DBG Flushing spooler because of timeout. Events flushed: 0 2022/03/14 04:35:20.361639 prospector.go:183: DBG Run prospector 2022/03/14 04:35:20.361706 prospector_log.go:70: DBG Start next scan 2022/03/14 04:35:20.362248 prospector_log.go:226: DBG Check file for harvesting: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log 2022/03/14 04:35:20.362280 prospector_log.go:259: DBG Update existing file for harvesting: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log, offset: 5960 2022/03/14 04:35:20.362298 prospector_log.go:311: DBG Harvester for file is still running: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log 2022/03/14 04:35:20.362314 prospector_log.go:226: DBG Check file for harvesting: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log 2022/03/14 04:35:20.362328 prospector_log.go:259: DBG Update existing file for harvesting: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log, offset: 2709 2022/03/14 04:35:20.362376 prospector_log.go:311: DBG Harvester for file is still running: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log 2022/03/14 04:35:20.362394 prospector_log.go:91: DBG Prospector states cleaned up. Before: 2, After: 2 2022/03/14 04:35:20.365550 spooler.go:89: DBG Flushing spooler because of timeout. Events flushed: 0 2022/03/14 04:35:21.365360 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log; Backoff now. 2022/03/14 04:35:21.365399 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log; Backoff now. 2022/03/14 04:35:22.365876 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log; Backoff now. 2022/03/14 04:35:22.365901 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log; Backoff now. 2022/03/14 04:35:24.366431 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log; Backoff now. 2022/03/14 04:35:24.366431 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log; Backoff now. 2022/03/14 04:35:25.365928 spooler.go:89: DBG Flushing spooler because of timeout. Events flushed: 6 2022/03/14 04:35:26.389135 sync.go:53: DBG connect 2022/03/14 04:35:26.399590 tcp.go:26: WARN DNS lookup failure "log-ls.onap": lookup log-ls.onap on 169.254.25.10:53: no such host 2022/03/14 04:35:26.399637 single.go:140: ERR Connecting error publishing events (retrying): lookup log-ls.onap on 169.254.25.10:53: no such host 2022/03/14 04:35:26.399651 single.go:156: DBG send fail 2022/03/14 04:35:28.366824 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log; Backoff now. 2022/03/14 04:35:28.366889 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log; Backoff now. 2022/03/14 04:35:30.362689 prospector.go:183: DBG Run prospector 2022/03/14 04:35:30.362768 prospector_log.go:70: DBG Start next scan 2022/03/14 04:35:30.363737 prospector_log.go:226: DBG Check file for harvesting: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log 2022/03/14 04:35:30.363783 prospector_log.go:259: DBG Update existing file for harvesting: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log, offset: 7275 2022/03/14 04:35:30.363798 prospector_log.go:311: DBG Harvester for file is still running: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log 2022/03/14 04:35:30.363812 prospector_log.go:226: DBG Check file for harvesting: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log 2022/03/14 04:35:30.363825 prospector_log.go:259: DBG Update existing file for harvesting: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log, offset: 2844 2022/03/14 04:35:30.363850 prospector_log.go:311: DBG Harvester for file is still running: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log 2022/03/14 04:35:30.363864 prospector_log.go:91: DBG Prospector states cleaned up. Before: 2, After: 2