Performance-analyzer-agent-cli spamming syslog in OD 1.3.0

Has anyone been seeing the following messages every 5 second in your syslog after installing Open Distro for Elasticsearch version 1.3.0?

I have installed OD 1.3.0 on 3 x Ubuntu 16.04.6 LTS hosts to create a 3 node cluster.
Everyone one of my nodes has the performance-analyzer-agent-cli task filling up /var/log/syslog with the SAME identical message generated every 5 seconds.

Any insights how to resolve?

Dec 20 21:07:37 my performance-analyzer-agent-cli[13112]: Dec 20, 2019 9:07:37 PM org.jooq.tools.JooqLogger info
Dec 20 21:07:37 my performance-analyzer-agent-cli[13112]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Dec 20 21:07:37 my performance-analyzer-agent-cli[13112]: Dec 20, 2019 9:07:37 PM org.jooq.tools.JooqLogger info
Dec 20 21:07:37 my performance-analyzer-agent-cli[13112]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Dec 20 21:07:42 my performance-analyzer-agent-cli[13112]: Dec 20, 2019 9:07:42 PM org.jooq.tools.JooqLogger info
Dec 20 21:07:42 my performance-analyzer-agent-cli[13112]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Dec 20 21:07:42 my performance-analyzer-agent-cli[13112]: Dec 20, 2019 9:07:42 PM org.jooq.tools.JooqLogger info
Dec 20 21:07:42 my performance-analyzer-agent-cli[13112]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Dec 20 21:07:47 my performance-analyzer-agent-cli[13112]: Dec 20, 2019 9:07:47 PM org.jooq.tools.JooqLogger info
Dec 20 21:07:47 my performance-analyzer-agent-cli[13112]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Dec 20 21:07:47 my performance-analyzer-agent-cli[13112]: Dec 20, 2019 9:07:47 PM org.jooq.tools.JooqLogger info
Dec 20 21:07:47 my performance-analyzer-agent-cli[13112]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Dec 20 21:07:52 my performance-analyzer-agent-cli[13112]: Dec 20, 2019 9:07:52 PM org.jooq.tools.JooqLogger info
Dec 20 21:07:52 my performance-analyzer-agent-cli[13112]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Dec 20 21:07:52 my performance-analyzer-agent-cli[13112]: Dec 20, 2019 9:07:52 PM org.jooq.tools.JooqLogger info
Dec 20 21:07:52 my performance-analyzer-agent-cli[13112]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Dec 20 21:07:57 my performance-analyzer-agent-cli[13112]: Dec 20, 2019 9:07:57 PM org.jooq.tools.JooqLogger info
Dec 20 21:07:57 my performance-analyzer-agent-cli[13112]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Dec 20 21:07:57 my performance-analyzer-agent-cli[13112]: Dec 20, 2019 9:07:57 PM org.jooq.tools.JooqLogger info
Dec 20 21:07:57 my performance-analyzer-agent-cli[13112]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Dec 20 21:08:02 my performance-analyzer-agent-cli[13112]: Dec 20, 2019 9:08:02 PM org.jooq.tools.JooqLogger info
Dec 20 21:08:02 my performance-analyzer-agent-cli[13112]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Dec 20 21:08:02 my performance-analyzer-agent-cli[13112]: Dec 20, 2019 9:08:02 PM org.jooq.tools.JooqLogger info
Dec 20 21:08:02 my performance-analyzer-agent-cli[13112]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Dec 20 21:08:07 my performance-analyzer-agent-cli[13112]: Dec 20, 2019 9:08:07 PM org.jooq.tools.JooqLogger info
Dec 20 21:08:07 my performance-analyzer-agent-cli[13112]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Dec 20 21:08:07 my performance-analyzer-agent-cli[13112]: Dec 20, 2019 9:08:07 PM org.jooq.tools.JooqLogger info
Dec 20 21:08:07 my performance-analyzer-agent-cli[13112]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Dec 20 21:08:12 my performance-analyzer-agent-cli[13112]: Dec 20, 2019 9:08:12 PM org.jooq.tools.JooqLogger info
Dec 20 21:08:12 my performance-analyzer-agent-cli[13112]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Dec 20 21:08:12 my performance-analyzer-agent-cli[13112]: Dec 20, 2019 9:08:12 PM org.jooq.tools.JooqLogger info
Dec 20 21:08:12 my performance-analyzer-agent-cli[13112]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Dec 20 21:08:17 my performance-analyzer-agent-cli[13112]: Dec 20, 2019 9:08:17 PM org.jooq.tools.JooqLogger info
Dec 20 21:08:17 my performance-analyzer-agent-cli[13112]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Dec 20 21:08:17 my performance-analyzer-agent-cli[13112]: Dec 20, 2019 9:08:17 PM org.jooq.tools.JooqLogger info
Dec 20 21:08:17 my performance-analyzer-agent-cli[13112]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Dec 20 21:08:22 my performance-analyzer-agent-cli[13112]: Dec 20, 2019 9:08:22 PM org.jooq.tools.JooqLogger info
Dec 20 21:08:22 my performance-analyzer-agent-cli[13112]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Dec 20 21:08:22 my performance-analyzer-agent-cli[13112]: Dec 20, 2019 9:08:22 PM org.jooq.tools.JooqLogger info
Dec 20 21:08:22 my performance-analyzer-agent-cli[13112]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Dec 20 21:08:27 my performance-analyzer-agent-cli[13112]: Dec 20, 2019 9:08:27 PM org.jooq.tools.JooqLogger info
Dec 20 21:08:27 my performance-analyzer-agent-cli[13112]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Dec 20 21:08:27 my performance-analyzer-agent-cli[13112]: Dec 20, 2019 9:08:27 PM org.jooq.tools.JooqLogger info
Dec 20 21:08:27 my performance-analyzer-agent-cli[13112]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Dec 20 21:08:32 my performance-analyzer-agent-cli[13112]: Dec 20, 2019 9:08:32 PM org.jooq.tools.JooqLogger info
Dec 20 21:08:32 my performance-analyzer-agent-cli[13112]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Dec 20 21:08:32 my performance-analyzer-agent-cli[13112]: Dec 20, 2019 9:08:32 PM org.jooq.tools.JooqLogger info
Dec 20 21:08:32 my performance-analyzer-agent-cli[13112]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Dec 20 21:08:37 my performance-analyzer-agent-cli[13112]: Dec 20, 2019 9:08:37 PM org.jooq.tools.JooqLogger info
Dec 20 21:08:37 my performance-analyzer-agent-cli[13112]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Dec 20 21:08:37 my performance-analyzer-agent-cli[13112]: Dec 20, 2019 9:08:37 PM org.jooq.tools.JooqLogger info
Dec 20 21:08:37 my performance-analyzer-agent-cli[13112]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Dec 20 21:08:42 my performance-analyzer-agent-cli[13112]: Dec 20, 2019 9:08:42 PM org.jooq.tools.JooqLogger info
Dec 20 21:08:42 my performance-analyzer-agent-cli[13112]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Dec 20 21:08:42 my performance-analyzer-agent-cli[13112]: Dec 20, 2019 9:08:42 PM org.jooq.tools.JooqLogger info
Dec 20 21:08:42 my performance-analyzer-agent-cli[13112]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Dec 20 21:08:47 my performance-analyzer-agent-cli[13112]: Dec 20, 2019 9:08:47 PM org.jooq.tools.JooqLogger info
Dec 20 21:08:47 my performance-analyzer-agent-cli[13112]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Dec 20 21:08:47 my performance-analyzer-agent-cli[13112]: Dec 20, 2019 9:08:47 PM org.jooq.tools.JooqLogger info
Dec 20 21:08:47 my performance-analyzer-agent-cli[13112]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Dec 20 21:08:52 my performance-analyzer-agent-cli[13112]: Dec 20, 2019 9:08:52 PM org.jooq.tools.JooqLogger info
Dec 20 21:08:52 my performance-analyzer-agent-cli[13112]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Dec 20 21:08:52 my performance-analyzer-agent-cli[13112]: Dec 20, 2019 9:08:52 PM org.jooq.tools.JooqLogger info
Dec 20 21:08:52 my performance-analyzer-agent-cli[13112]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Dec 20 21:08:57 my performance-analyzer-agent-cli[13112]: Dec 20, 2019 9:08:57 PM org.jooq.tools.JooqLogger info
Dec 20 21:08:57 my performance-analyzer-agent-cli[13112]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Dec 20 21:08:57 my performance-analyzer-agent-cli[13112]: Dec 20, 2019 9:08:57 PM org.jooq.tools.JooqLogger info
Dec 20 21:08:57 my performance-analyzer-agent-cli[13112]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Dec 20 21:09:02 my performance-analyzer-agent-cli[13112]: Dec 20, 2019 9:09:02 PM org.jooq.tools.JooqLogger info
Dec 20 21:09:02 my performance-analyzer-agent-cli[13112]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Dec 20 21:09:02 my performance-analyzer-agent-cli[13112]: Dec 20, 2019 9:09:02 PM org.jooq.tools.JooqLogger info
Dec 20 21:09:02 my performance-analyzer-agent-cli[13112]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Dec 20 21:09:07 my performance-analyzer-agent-cli[13112]: Dec 20, 2019 9:09:07 PM org.jooq.tools.JooqLogger info
Dec 20 21:09:07 my performance-analyzer-agent-cli[13112]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Dec 20 21:09:07 my performance-analyzer-agent-cli[13112]: Dec 20, 2019 9:09:07 PM org.jooq.tools.JooqLogger info
Dec 20 21:09:07 my performance-analyzer-agent-cli[13112]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Dec 20 21:09:12 my performance-analyzer-agent-cli[13112]: Dec 20, 2019 9:09:12 PM org.jooq.tools.JooqLogger info
Dec 20 21:09:12 my performance-analyzer-agent-cli[13112]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Dec 20 21:09:12 my performance-analyzer-agent-cli[13112]: Dec 20, 2019 9:09:12 PM org.jooq.tools.JooqLogger info
Dec 20 21:09:12 my performance-analyzer-agent-cli[13112]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Dec 20 21:09:17 my performance-analyzer-agent-cli[13112]: Dec 20, 2019 9:09:17 PM org.jooq.tools.JooqLogger info
Dec 20 21:09:17 my performance-analyzer-agent-cli[13112]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Dec 20 21:09:17 my performance-analyzer-agent-cli[13112]: Dec 20, 2019 9:09:17 PM org.jooq.tools.JooqLogger info
Dec 20 21:09:17 my performance-analyzer-agent-cli[13112]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse

Pretty sure I am not the only one experiencing this

Thanks in advance

I think the service logs this to stdout by default; I have added a fix to the systemd unit file for now

eg in /usr/lib/systemd/system/opendistro-performance-analyzer.service

under [Service] add StandardOutput=null

Ahhhh, Thank you.

What does this error mean? Does it signify an error in my cluster configuration?

I don’t want to just hide the error if it represents a deeper issue

Hey Simonc,

The suggested configuration in /usr/lib/systemd/system/opendistro-performance-analyzer.service does not seem to make a difference

[Unit]
Description=Opendistro for Elasticsearch Performance Analyzer
PartOf=elasticsearch.service

[Service]
ExecStart=/usr/share/elasticsearch/bin/performance-analyzer-agent-cli
Restart=on-failure
User=elasticsearch
Group=elasticsearch
Environment=ES_HOME=/usr/share/elasticsearch
WorkingDirectory=/usr/share/elasticsearch
StandardOutput=/dev/null

[Install]
WantedBy=elasticsearch.service

I tried StandardOutput=/dev/null and StandardOutput=null with the same result

My Syslog file /var/log/syslog is still spammed with the following after restart

Jan  3 00:45:37 mistral-rustam performance-analyzer-agent-cli[30234]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Jan  3 00:45:42 mistral-rustam performance-analyzer-agent-cli[30234]: Jan 03, 2020 12:45:42 AM org.jooq.tools.JooqLogger info
Jan  3 00:45:42 mistral-rustam performance-analyzer-agent-cli[30234]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Jan  3 00:45:42 mistral-rustam performance-analyzer-agent-cli[30234]: Jan 03, 2020 12:45:42 AM org.jooq.tools.JooqLogger info
Jan  3 00:45:42 mistral-rustam performance-analyzer-agent-cli[30234]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Jan  3 00:45:47 mistral-rustam performance-analyzer-agent-cli[30234]: Jan 03, 2020 12:45:47 AM org.jooq.tools.JooqLogger info
Jan  3 00:45:47 mistral-rustam performance-analyzer-agent-cli[30234]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Jan  3 00:45:47 mistral-rustam performance-analyzer-agent-cli[30234]: Jan 03, 2020 12:45:47 AM org.jooq.tools.JooqLogger info
Jan  3 00:45:47 mistral-rustam performance-analyzer-agent-cli[30234]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Jan  3 00:45:52 mistral-rustam performance-analyzer-agent-cli[30234]: Jan 03, 2020 12:45:52 AM org.jooq.tools.JooqLogger info
Jan  3 00:45:52 mistral-rustam performance-analyzer-agent-cli[30234]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Jan  3 00:45:52 mistral-rustam performance-analyzer-agent-cli[30234]: Jan 03, 2020 12:45:52 AM org.jooq.tools.JooqLogger info
Jan  3 00:45:52 mistral-rustam performance-analyzer-agent-cli[30234]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Jan  3 00:45:57 mistral-rustam performance-analyzer-agent-cli[30234]: Jan 03, 2020 12:45:57 AM org.jooq.tools.JooqLogger info
Jan  3 00:45:57 mistral-rustam performance-analyzer-agent-cli[30234]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Jan  3 00:45:57 mistral-rustam performance-analyzer-agent-cli[30234]: Jan 03, 2020 12:45:57 AM org.jooq.tools.JooqLogger info
Jan  3 00:45:57 mistral-rustam performance-analyzer-agent-cli[30234]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Jan  3 00:46:02 mistral-rustam performance-analyzer-agent-cli[30234]: Jan 03, 2020 12:46:02 AM org.jooq.tools.JooqLogger info
Jan  3 00:46:02 mistral-rustam performance-analyzer-agent-cli[30234]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse
Jan  3 00:46:02 mistral-rustam performance-analyzer-agent-cli[30234]: Jan 03, 2020 12:46:02 AM org.jooq.tools.JooqLogger info
Jan  3 00:46:02 mistral-rustam performance-analyzer-agent-cli[30234]: INFO: Single batch             : No bind variables have been provided with a single statement batch execution. This may be due to accidental API misuse

Sorry should have also added you would need to reload systemd via ‘/bin/systemctl daemon-reload’ for it to take affect

Thank you! That worked!

1 Like

So This error is of no concern?

Hi,

Yes, these logs should not impact elasticsearch in any way. The log is being emitted by the PerformanceAnalyzer side car process that reads events generated by Elasticsearch and creates fine-grained resource usage metrics. The error message is being generated when bulk-loading event data into sqlite, as the bulk load is empty.

Have you run perf-top on your installation and checked if PerformanceAnalyzer metrics are available? That will give us a better idea of whether there is some issue in generating Performance Analyzer metrics.

1 Like

Thank you for educating me on the meaning of the error message.
I too wanted to know if the Agent was working, so I installed perf-top on a peripheral host

These are the dashboard screenshots

  1. ClusterOverview
  2. ClusterNetworkMemoryAnalysis
  3. ClusterThreadAnalysis
  4. NodeAnalysis

Thanks again for all your support

Great! I created a new issue here - https://github.com/opendistro-for-elasticsearch/performance-analyzer-rca/issues/39. We will investigate and try to root cause what is causing empty uploads.

2 Likes