By type
2022/04/18 05:00:36.763180 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/04/18 05:00:36.763241 beat.go:186: INFO Setup Beat: filebeat; Version: 5.5.0 2022/04/18 05:00:36.763264 processor.go:44: DBG Processors: 2022/04/18 05:00:36.763511 beat.go:192: DBG Initializing output plugins 2022/04/18 05:00:36.763349 metrics.go:23: INFO Metrics logging every 30s 2022/04/18 05:00:36.766577 logstash.go:90: INFO Max Retries set to: 3 2022/04/18 05:00:36.766707 outputs.go:108: INFO Activated logstash as output plugin. 2022/04/18 05:00:36.766734 publish.go:238: DBG Create output worker 2022/04/18 05:00:36.766876 publish.go:280: DBG No output is defined to store the topology. The server fields might not be filled. 2022/04/18 05:00:36.766995 publish.go:295: INFO Publisher name: dcae-pm-mapper 2022/04/18 05:00:36.767244 async.go:63: INFO Flush Interval set to: 1s 2022/04/18 05:00:36.767267 async.go:64: INFO Max Bulk Size set to: 2048 2022/04/18 05:00:36.767275 async.go:72: DBG create bulk processing worker (interval=1s, bulk size=2048) 2022/04/18 05:00:36.767854 beat.go:221: INFO filebeat start running. 2022/04/18 05:00:36.767934 registrar.go:68: INFO No registry file found under: /usr/share/filebeat/data/registry. Creating a new registry file. 2022/04/18 05:00:36.767950 registrar.go:298: DBG Write registry file: /usr/share/filebeat/data/registry 2022/04/18 05:00:36.774142 registrar.go:323: DBG Registry file updated. 0 states written. 2022/04/18 05:00:36.774201 registrar.go:106: INFO Loading registrar data from /usr/share/filebeat/data/registry 2022/04/18 05:00:36.774247 registrar.go:123: INFO States Loaded from registrar: 0 2022/04/18 05:00:36.774333 crawler.go:38: INFO Loading Prospectors: 1 2022/04/18 05:00:36.774358 registrar.go:236: INFO Starting Registrar 2022/04/18 05:00:36.774509 spooler.go:63: INFO Starting spooler: spool_size: 2048; idle_timeout: 5s 2022/04/18 05:00:36.774555 sync.go:41: INFO Start sending events to output 2022/04/18 05:00:36.774701 prospector.go:83: DBG File Configs: [/var/log/onap/*/*/*/*.log /var/log/onap/*/*/*.log /var/log/onap/*/*.log] 2022/04/18 05:00:36.774737 prospector_log.go:44: DBG exclude_files: [] 2022/04/18 05:00:36.774746 prospector_log.go:65: INFO Prospector with previous states loaded: 0 2022/04/18 05:00:36.774850 prospector.go:124: INFO Starting prospector of type: log; id: 12576369028753478767 2022/04/18 05:00:36.774910 crawler.go:58: INFO Loading and starting Prospectors completed. Enabled prospectors: 1 2022/04/18 05:00:36.775031 prospector_log.go:70: DBG Start next scan 2022/04/18 05:00:36.775381 prospector_log.go:91: DBG Prospector states cleaned up. Before: 0, After: 0 2022/04/18 05:00:41.774732 spooler.go:89: DBG Flushing spooler because of timeout. Events flushed: 0 2022/04/18 05:00:46.775046 spooler.go:89: DBG Flushing spooler because of timeout. Events flushed: 0 2022/04/18 05:00:46.775603 prospector.go:183: DBG Run prospector 2022/04/18 05:00:46.775644 prospector_log.go:70: DBG Start next scan 2022/04/18 05:00:46.776146 prospector_log.go:226: DBG Check file for harvesting: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log 2022/04/18 05:00:46.776172 prospector_log.go:245: DBG Start harvester for new file: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log 2022/04/18 05:00:46.776400 state.go:64: DBG New state added for /var/log/onap/dcae-pm-mapper/pm-mapper_output.log 2022/04/18 05:00:46.776452 log.go:288: DBG Setting offset for file based on seek: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log 2022/04/18 05:00:46.776586 log.go:273: DBG Setting offset for file: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log. Offset: 0 2022/04/18 05:00:46.776748 prospector_log.go:226: DBG Check file for harvesting: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log 2022/04/18 05:00:46.776767 prospector_log.go:245: DBG Start harvester for new file: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log 2022/04/18 05:00:46.776952 state.go:64: DBG New state added for /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log 2022/04/18 05:00:46.776994 log.go:288: DBG Setting offset for file based on seek: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log 2022/04/18 05:00:46.777161 log.go:273: DBG Setting offset for file: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log. Offset: 0 2022/04/18 05:00:46.777114 log.go:91: INFO Harvester started for file: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log 2022/04/18 05:00:46.777306 prospector_log.go:91: DBG Prospector states cleaned up. Before: 2, After: 2 2022/04/18 05:00:46.777368 log.go:91: INFO Harvester started for file: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log 2022/04/18 05:00:46.777429 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log; Backoff now. 2022/04/18 05:00:46.777724 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log; Backoff now. 2022/04/18 05:00:47.777825 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log; Backoff now. 2022/04/18 05:00:47.777998 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log; Backoff now. 2022/04/18 05:00:49.778246 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log; Backoff now. 2022/04/18 05:00:49.778403 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log; Backoff now. 2022/04/18 05:00:51.775278 spooler.go:89: DBG Flushing spooler because of timeout. Events flushed: 34 2022/04/18 05:00:51.775637 client.go:214: DBG Publish: { "@timestamp": "2022-04-18T05:00:46.777Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-04-18T05:00:37.910Z\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/04/18 05:00:51.775723 client.go:214: DBG Publish: { "@timestamp": "2022-04-18T05:00:46.777Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-04-18T05:00:38.017Z\tmain\tINFO\torg.onap.dcaegen2.services.pmmapper.utils.RequestSender\t\tfb192ef1-8644-4903-8cdb-3d5257eb194e\t\tINVOKE [ SYNCHRONOUS ]\t", "offset": 310, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output.log", "type": "log" } 2022/04/18 05:00:51.775781 client.go:214: DBG Publish: { "@timestamp": "2022-04-18T05:00:46.777Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-04-18T05:00:38.020Z\tmain\tINFO\torg.onap.dcaegen2.services.pmmapper.utils.RequestSender\t\tSending GET request to http://10.233.6.218:10000/service_component/dcae-pm-mapper.\t\t\t", "offset": 488, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output.log", "type": "log" } 2022/04/18 05:00:51.775899 client.go:214: DBG Publish: { "@timestamp": "2022-04-18T05:00:46.777Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-04-18T05:00:38.093Z\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\": \"1650258017520\", \"location\": \"san-francisco\", \"client_role\": \"org.onap.dcae.pmPublisher\"}}}}\t\t\t", "offset": 1637, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output.log", "type": "log" } 2022/04/18 05:00:51.775956 client.go:214: DBG Publish: { "@timestamp": "2022-04-18T05:00:46.777Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-04-18T05:00:38.314Z\tmain\tINFO\torg.onap.dcaegen2.services.pmmapper.config.ConfigHandler\t\tReceived pm-mapper configuration from ConfigBinding Service\t\t\t", "offset": 1793, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output.log", "type": "log" } 2022/04/18 05:00:51.776004 client.go:214: DBG Publish: { "@timestamp": "2022-04-18T05:00:46.777Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-04-18T05:00:39.743Z\tmain\tINFO\torg.onap.dcaegen2.services.pmmapper.config.FilesProcessingConfig\t\tAttempt to read threads configuration\t\t\t", "offset": 1935, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output.log", "type": "log" } 2022/04/18 05:00:51.776043 client.go:214: DBG Publish: { "@timestamp": "2022-04-18T05:00:46.777Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-04-18T05:00:39.745Z\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": 2125, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output.log", "type": "log" } 2022/04/18 05:00:51.776098 client.go:214: DBG Publish: { "@timestamp": "2022-04-18T05:00:46.777Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-04-18T05:00:39.746Z\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": 2304, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output.log", "type": "log" } 2022/04/18 05:00:51.776157 client.go:214: DBG Publish: { "@timestamp": "2022-04-18T05:00:46.777Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-04-18T05:00:39.747Z\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": 2507, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output.log", "type": "log" } 2022/04/18 05:00:51.776195 client.go:214: DBG Publish: { "@timestamp": "2022-04-18T05:00:46.777Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-04-18T05:00:39.747Z\tmain\tINFO\torg.onap.dcaegen2.services.pmmapper.config.FilesProcessingConfig\t\tAmount of files processing threads: 1 \t\t\t", "offset": 2650, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output.log", "type": "log" } 2022/04/18 05:00:51.776230 client.go:214: DBG Publish: { "@timestamp": "2022-04-18T05:00:46.777Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-04-18T05:00:39.749Z\tmain\tINFO\torg.onap.dcaegen2.services.pmmapper.config.FilesProcessingConfig\t\tTrying to read PROCESSING_LIMIT_RATE env.\t\t\t", "offset": 2796, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output.log", "type": "log" } 2022/04/18 05:00:51.776283 client.go:214: DBG Publish: { "@timestamp": "2022-04-18T05:00:46.777Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-04-18T05:00:39.793Z\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": 2978, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output.log", "type": "log" } 2022/04/18 05:00:51.776333 client.go:214: DBG Publish: { "@timestamp": "2022-04-18T05:00:46.777Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-04-18T05:00:40.221Z\tmain\tINFO\tio.undertow\t\tstarting server: Undertow - 2.2.9.Final\t\t\t", "offset": 3069, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output.log", "type": "log" } 2022/04/18 05:00:51.776387 client.go:214: DBG Publish: { "@timestamp": "2022-04-18T05:00:46.777Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-04-18T05:00:40.240Z\tmain\tINFO\torg.xnio\t\tXNIO version 3.8.4.Final\t\t\t", "offset": 3142, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output.log", "type": "log" } 2022/04/18 05:00:51.776497 client.go:214: DBG Publish: { "@timestamp": "2022-04-18T05:00:46.777Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-04-18T05:00:40.309Z\tmain\tINFO\torg.xnio.nio\t\tXNIO NIO Implementation Version 3.8.4.Final\t\t\t", "offset": 3238, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output.log", "type": "log" } 2022/04/18 05:00:51.776566 client.go:214: DBG Publish: { "@timestamp": "2022-04-18T05:00:46.777Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-04-18T05:00:40.634Z\tmain\tINFO\torg.jboss.threads\t\tJBoss Threads version 3.1.0.Final\t\t\t", "offset": 3329, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output.log", "type": "log" } 2022/04/18 05:00:51.776615 client.go:214: DBG Publish: { "@timestamp": "2022-04-18T05:00:46.777Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-04-18T05:00:37.910Z | 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/04/18 05:00:51.776649 client.go:214: DBG Publish: { "@timestamp": "2022-04-18T05:00:46.777Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-04-18T05:00:38.017Z | INFO | fb192ef1-8644-4903-8cdb-3d5257eb194e", "offset": 165, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log", "type": "log" } 2022/04/18 05:00:51.776699 client.go:214: DBG Publish: { "@timestamp": "2022-04-18T05:00:46.777Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-04-18T05:00:38.020Z | INFO | Sending GET request to http://10.233.6.218:10000/service_component/dcae-pm-mapper.", "offset": 282, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log", "type": "log" } 2022/04/18 05:00:51.776808 client.go:214: DBG Publish: { "@timestamp": "2022-04-18T05:00:46.777Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-04-18T05:00:38.093Z | 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\": \"1650258017520\", \"location\": \"san-francisco\", \"client_role\": \"org.onap.dcae.pmPublisher\"}}}}", "offset": 1370, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log", "type": "log" } 2022/04/18 05:00:51.776862 client.go:214: DBG Publish: { "@timestamp": "2022-04-18T05:00:46.777Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-04-18T05:00:38.314Z | INFO | Received pm-mapper configuration from ConfigBinding Service", "offset": 1464, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log", "type": "log" } 2022/04/18 05:00:51.776896 client.go:214: DBG Publish: { "@timestamp": "2022-04-18T05:00:46.777Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-04-18T05:00:39.743Z | INFO | Attempt to read threads configuration", "offset": 1536, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log", "type": "log" } 2022/04/18 05:00:51.776946 client.go:214: DBG Publish: { "@timestamp": "2022-04-18T05:00:46.777Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-04-18T05:00:39.745Z | INFO | PROCESSING_THREADS_COUNT env not present. Setting threads count to available cores: 1", "offset": 1656, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log", "type": "log" } 2022/04/18 05:00:51.776987 client.go:214: DBG Publish: { "@timestamp": "2022-04-18T05:00:46.777Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-04-18T05:00:39.746Z | INFO | THREADS_MULTIPLIER env not present. Setting multiplier to default value: 1", "offset": 1765, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log", "type": "log" } 2022/04/18 05:00:51.777028 client.go:214: DBG Publish: { "@timestamp": "2022-04-18T05:00:46.777Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-04-18T05:00:39.747Z | INFO | Processing threads configuration: Processing threads count - 1, Processing threads multiplier - 1 ", "offset": 1898, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log", "type": "log" } 2022/04/18 05:00:51.777096 client.go:214: DBG Publish: { "@timestamp": "2022-04-18T05:00:46.777Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-04-18T05:00:39.747Z | INFO | Amount of files processing threads: 1 ", "offset": 1971, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log", "type": "log" } 2022/04/18 05:00:51.777135 client.go:214: DBG Publish: { "@timestamp": "2022-04-18T05:00:46.777Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-04-18T05:00:39.749Z | INFO | Trying to read PROCESSING_LIMIT_RATE env.", "offset": 2047, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log", "type": "log" } 2022/04/18 05:00:51.777193 client.go:214: DBG Publish: { "@timestamp": "2022-04-18T05:00:46.777Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-04-18T05:00:39.793Z | INFO | PROCESSING_LIMIT_RATE env not present. Setting limit rate to default value: 1", "offset": 2159, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log", "type": "log" } 2022/04/18 05:00:51.777241 client.go:214: DBG Publish: { "@timestamp": "2022-04-18T05:00:46.777Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-04-18T05:00:40.221Z | INFO | starting server: Undertow - 2.2.9.Final", "offset": 2233, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log", "type": "log" } 2022/04/18 05:00:51.777301 client.go:214: DBG Publish: { "@timestamp": "2022-04-18T05:00:46.777Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-04-18T05:00:40.240Z | INFO | XNIO version 3.8.4.Final", "offset": 2292, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log", "type": "log" } 2022/04/18 05:00:51.777373 client.go:214: DBG Publish: { "@timestamp": "2022-04-18T05:00:46.777Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-04-18T05:00:40.309Z | INFO | XNIO NIO Implementation Version 3.8.4.Final", "offset": 2370, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log", "type": "log" } 2022/04/18 05:00:51.777425 client.go:214: DBG Publish: { "@timestamp": "2022-04-18T05:00:46.777Z", "beat": { "hostname": "dcae-pm-mapper", "name": "dcae-pm-mapper", "version": "5.5.0" }, "input_type": "log", "message": "2022-04-18T05:00:40.634Z | INFO | JBoss Threads version 3.1.0.Final", "offset": 2438, "source": "/var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log", "type": "log" } 2022/04/18 05:00:51.777464 output.go:109: DBG output worker: publish 32 events 2022/04/18 05:00:51.777480 sync.go:53: DBG connect 2022/04/18 05:00:51.780727 tcp.go:26: WARN DNS lookup failure "log-ls.onap": lookup log-ls.onap on 169.254.25.10:53: no such host 2022/04/18 05:00:51.780751 single.go:140: ERR Connecting error publishing events (retrying): lookup log-ls.onap on 169.254.25.10:53: no such host 2022/04/18 05:00:51.780780 single.go:156: DBG send fail 2022/04/18 05:00:52.780993 sync.go:53: DBG connect 2022/04/18 05:00:52.784345 tcp.go:26: WARN DNS lookup failure "log-ls.onap": lookup log-ls.onap on 169.254.25.10:53: no such host 2022/04/18 05:00:52.784370 single.go:140: ERR Connecting error publishing events (retrying): lookup log-ls.onap on 169.254.25.10:53: no such host 2022/04/18 05:00:52.784378 single.go:156: DBG send fail 2022/04/18 05:00:53.778824 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log; Backoff now. 2022/04/18 05:00:53.778924 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log; Backoff now. 2022/04/18 05:00:54.779182 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log; Backoff now. 2022/04/18 05:00:54.779170 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log; Backoff now. 2022/04/18 05:00:54.784632 sync.go:53: DBG connect 2022/04/18 05:00:54.788132 tcp.go:26: WARN DNS lookup failure "log-ls.onap": lookup log-ls.onap on 169.254.25.10:53: no such host 2022/04/18 05:00:54.788196 single.go:140: ERR Connecting error publishing events (retrying): lookup log-ls.onap on 169.254.25.10:53: no such host 2022/04/18 05:00:54.788218 single.go:156: DBG send fail 2022/04/18 05:00:56.775587 spooler.go:89: DBG Flushing spooler because of timeout. Events flushed: 6 2022/04/18 05:00:56.777513 prospector.go:183: DBG Run prospector 2022/04/18 05:00:56.777541 prospector_log.go:70: DBG Start next scan 2022/04/18 05:00:56.778202 prospector_log.go:226: DBG Check file for harvesting: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log 2022/04/18 05:00:56.778230 prospector_log.go:259: DBG Update existing file for harvesting: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log, offset: 4644 2022/04/18 05:00:56.778237 prospector_log.go:311: DBG Harvester for file is still running: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log 2022/04/18 05:00:56.778245 prospector_log.go:226: DBG Check file for harvesting: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log 2022/04/18 05:00:56.778276 prospector_log.go:259: DBG Update existing file for harvesting: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log, offset: 2573 2022/04/18 05:00:56.778281 prospector_log.go:311: DBG Harvester for file is still running: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log 2022/04/18 05:00:56.778291 prospector_log.go:91: DBG Prospector states cleaned up. Before: 2, After: 2 2022/04/18 05:00:56.779436 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log; Backoff now. 2022/04/18 05:00:56.779496 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log; Backoff now. 2022/04/18 05:00:58.788403 sync.go:53: DBG connect 2022/04/18 05:00:58.791783 tcp.go:26: WARN DNS lookup failure "log-ls.onap": lookup log-ls.onap on 169.254.25.10:53: no such host 2022/04/18 05:00:58.791805 single.go:140: ERR Connecting error publishing events (retrying): lookup log-ls.onap on 169.254.25.10:53: no such host 2022/04/18 05:00:58.791813 single.go:156: DBG send fail 2022/04/18 05:01:00.779740 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log; Backoff now. 2022/04/18 05:01:00.779739 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log; Backoff now. 2022/04/18 05:01:01.775898 spooler.go:89: DBG Flushing spooler because of timeout. Events flushed: 0 2022/04/18 05:01:06.763952 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=32 registrar.writes=1 2022/04/18 05:01:06.776178 spooler.go:89: DBG Flushing spooler because of timeout. Events flushed: 0 2022/04/18 05:01:06.778494 prospector.go:183: DBG Run prospector 2022/04/18 05:01:06.778519 prospector_log.go:70: DBG Start next scan 2022/04/18 05:01:06.779034 prospector_log.go:226: DBG Check file for harvesting: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log 2022/04/18 05:01:06.779083 prospector_log.go:259: DBG Update existing file for harvesting: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log, offset: 4644 2022/04/18 05:01:06.779091 prospector_log.go:311: DBG Harvester for file is still running: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log 2022/04/18 05:01:06.779099 prospector_log.go:226: DBG Check file for harvesting: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log 2022/04/18 05:01:06.779106 prospector_log.go:259: DBG Update existing file for harvesting: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log, offset: 2573 2022/04/18 05:01:06.779111 prospector_log.go:311: DBG Harvester for file is still running: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log 2022/04/18 05:01:06.779119 prospector_log.go:91: DBG Prospector states cleaned up. Before: 2, After: 2 2022/04/18 05:01:06.791988 sync.go:53: DBG connect 2022/04/18 05:01:06.799348 tcp.go:26: WARN DNS lookup failure "log-ls.onap": lookup log-ls.onap on 169.254.25.10:53: no such host 2022/04/18 05:01:06.799417 single.go:140: ERR Connecting error publishing events (retrying): lookup log-ls.onap on 169.254.25.10:53: no such host 2022/04/18 05:01:06.799433 single.go:156: DBG send fail 2022/04/18 05:01:08.780232 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log; Backoff now. 2022/04/18 05:01:08.780269 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log; Backoff now. 2022/04/18 05:01:09.780544 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log; Backoff now. 2022/04/18 05:01:09.780591 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log; Backoff now. 2022/04/18 05:01:11.776494 spooler.go:89: DBG Flushing spooler because of timeout. Events flushed: 6 2022/04/18 05:01:11.780837 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log; Backoff now. 2022/04/18 05:01:11.780860 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log; Backoff now. 2022/04/18 05:01:15.781190 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log; Backoff now. 2022/04/18 05:01:15.781239 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log; Backoff now. 2022/04/18 05:01:16.779368 prospector.go:183: DBG Run prospector 2022/04/18 05:01:16.779416 prospector_log.go:70: DBG Start next scan 2022/04/18 05:01:16.779815 prospector_log.go:226: DBG Check file for harvesting: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log 2022/04/18 05:01:16.779844 prospector_log.go:259: DBG Update existing file for harvesting: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log, offset: 5959 2022/04/18 05:01:16.779852 prospector_log.go:311: DBG Harvester for file is still running: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log 2022/04/18 05:01:16.779859 prospector_log.go:226: DBG Check file for harvesting: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log 2022/04/18 05:01:16.779866 prospector_log.go:259: DBG Update existing file for harvesting: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log, offset: 2708 2022/04/18 05:01:16.779871 prospector_log.go:311: DBG Harvester for file is still running: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log 2022/04/18 05:01:16.779879 prospector_log.go:91: DBG Prospector states cleaned up. Before: 2, After: 2 2022/04/18 05:01:22.799663 sync.go:53: DBG connect 2022/04/18 05:01:22.806412 tcp.go:26: WARN DNS lookup failure "log-ls.onap": lookup log-ls.onap on 169.254.25.10:53: no such host 2022/04/18 05:01:22.806491 single.go:140: ERR Connecting error publishing events (retrying): lookup log-ls.onap on 169.254.25.10:53: no such host 2022/04/18 05:01:22.806527 single.go:156: DBG send fail 2022/04/18 05:01:23.781782 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log; Backoff now. 2022/04/18 05:01:23.781792 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log; Backoff now. 2022/04/18 05:01:24.782059 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log; Backoff now. 2022/04/18 05:01:24.782086 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log; Backoff now. 2022/04/18 05:01:26.780124 prospector.go:183: DBG Run prospector 2022/04/18 05:01:26.780361 prospector_log.go:70: DBG Start next scan 2022/04/18 05:01:26.781126 prospector_log.go:226: DBG Check file for harvesting: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log 2022/04/18 05:01:26.781266 prospector_log.go:259: DBG Update existing file for harvesting: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log, offset: 7274 2022/04/18 05:01:26.781364 prospector_log.go:311: DBG Harvester for file is still running: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log 2022/04/18 05:01:26.781450 prospector_log.go:226: DBG Check file for harvesting: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log 2022/04/18 05:01:26.781567 prospector_log.go:259: DBG Update existing file for harvesting: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log, offset: 2843 2022/04/18 05:01:26.781609 prospector_log.go:311: DBG Harvester for file is still running: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log 2022/04/18 05:01:26.781709 prospector_log.go:91: DBG Prospector states cleaned up. Before: 2, After: 2 2022/04/18 05:01:26.782264 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log; Backoff now. 2022/04/18 05:01:26.782302 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log; Backoff now. 2022/04/18 05:01:30.782662 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log; Backoff now. 2022/04/18 05:01:30.782662 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log; Backoff now. 2022/04/18 05:01:36.763987 metrics.go:34: INFO No non-zero metrics in the last 30s 2022/04/18 05:01:36.782110 prospector.go:183: DBG Run prospector 2022/04/18 05:01:36.782142 prospector_log.go:70: DBG Start next scan 2022/04/18 05:01:36.782724 prospector_log.go:226: DBG Check file for harvesting: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log 2022/04/18 05:01:36.782757 prospector_log.go:259: DBG Update existing file for harvesting: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log, offset: 7274 2022/04/18 05:01:36.782769 prospector_log.go:311: DBG Harvester for file is still running: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log 2022/04/18 05:01:36.782796 prospector_log.go:226: DBG Check file for harvesting: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log 2022/04/18 05:01:36.782811 prospector_log.go:259: DBG Update existing file for harvesting: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log, offset: 2843 2022/04/18 05:01:36.782821 prospector_log.go:311: DBG Harvester for file is still running: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log 2022/04/18 05:01:36.782833 prospector_log.go:91: DBG Prospector states cleaned up. Before: 2, After: 2 2022/04/18 05:01:38.783175 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log; Backoff now. 2022/04/18 05:01:38.783230 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log; Backoff now. 2022/04/18 05:01:39.783473 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output.log; Backoff now. 2022/04/18 05:01:39.783473 log_file.go:84: DBG End of file reached: /var/log/onap/dcae-pm-mapper/pm-mapper_output_readable.log; Backoff now.