Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

[Core] Avoid metrics log noise when idle #8868

Open
wants to merge 1 commit into
base: main
Choose a base branch
from

Conversation

russellb
Copy link
Collaborator

@russellb russellb commented Sep 26, 2024

1a789ae [Core] Avoid metrics log noise when idle

commit 1a789ae
Author: Russell Bryant [email protected]
Date: Thu Sep 26 20:56:41 2024 +0000

[Core] Avoid metrics log noise when idle

Prior to this change, there was always a log message every 10 seconds,
even when the system is idle. The noise when the metrics are all zeros
doesn't seem very interesting, so this change makes it so the log
message is only emitted while active. It will log a message whenever
metrics are non-zero, or when returning to idle from non-idle.
Repeated messages during idle now go to DEBUG instead of INFO.

Signed-off-by: Russell Bryant <[email protected]>

Copy link

👋 Hi! Thank you for contributing to the vLLM project.
Just a reminder: PRs would not trigger full CI run by default. Instead, it would only run fastcheck CI which starts running only a small and essential subset of CI tests to quickly catch errors. You can run other CI tests on top of those by going to your fastcheck build on Buildkite UI (linked in the PR checks section) and unblock them. If you do not have permission to unblock, ping simon-mo or khluu to add you in our Buildkite org.

Once the PR is approved and ready to go, your PR reviewer(s) can run CI to test the changes comprehensively before merging.

To run CI, PR reviewers can do one of these:

  • Add ready label to the PR
  • Enable auto-merge.

🚀

@vrdn-23
Copy link
Contributor

vrdn-23 commented Oct 24, 2024

@russellb I think this is a great small QoL improvement. Is this still something get worked on?

@russellb
Copy link
Collaborator Author

@russellb I think this is a great small QoL improvement. Is this still something get worked on?

It's ready for review when someone has time.

Copy link

@stmcginnis stmcginnis left a comment

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

This would be great to have!

@vrdn-23
Copy link
Contributor

vrdn-23 commented Oct 24, 2024

@simon-mo @mgoin Is this something we can merge before the next release?

Copy link
Collaborator

@mgoin mgoin left a comment

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

I personally like keeping the log as a sort of "heartbeat" to let me know the server is functioning fine even if there is nothing running. So I'm okay with this but would like another committer who feels more strongly about this as an improvement

@vrdn-23
Copy link
Contributor

vrdn-23 commented Oct 24, 2024

I personally like keeping the log as a sort of "heartbeat" to let me know the server is functioning fine even if there is nothing running

I think the functionality of /health endpoint should be what indicates this rather than a log message showing idle numbers.

@russellb
Copy link
Collaborator Author

I personally like keeping the log as a sort of "heartbeat" to let me know the server is functioning fine even if there is nothing running

I think the functionality of /health endpoint should be what indicates this rather than a log message showing idle numbers.

A compromise could be to emit them as DEBUG instead of INFO once the system goes idle.

@vrdn-23
Copy link
Contributor

vrdn-23 commented Oct 25, 2024

A compromise could be to emit them as DEBUG instead of INFO once the system goes idle.

That sounds like a valid solution to me. Should also enable users who would prefer to have the logs enable it. Thoughts @mgoin ?

Prior to this change, there was always a log message every 10 seconds,
even when the system is idle. The noise when the metrics are all zeros
doesn't seem very interesting, so this change makes it so the log
message is only emitted while active. It will log a message whenever
metrics are non-zero, or when returning to idle from non-idle.
Repeated messages during idle now go to DEBUG instead of INFO.

Signed-off-by: Russell Bryant <[email protected]>
@russellb
Copy link
Collaborator Author

A compromise could be to emit them as DEBUG instead of INFO once the system goes idle.

That sounds like a valid solution to me. Should also enable users who would prefer to have the logs enable it. Thoughts @mgoin ?

I updated the PR to do this.

@vrdn-23
Copy link
Contributor

vrdn-23 commented Nov 15, 2024

@mgoin can we go ahead with this approach?

Copy link
Collaborator

@mgoin mgoin left a comment

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

Yeah let's go with this, thanks!

@mgoin mgoin added the ready ONLY add when PR is ready to merge/full CI is needed label Nov 15, 2024
@mgoin mgoin enabled auto-merge (squash) November 15, 2024 23:18
@comaniac
Copy link
Collaborator

Just to check, do we have other DEBUG logging? Like if I enabled DEBUG would I see lots of other logs and even slow the performance?

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
ready ONLY add when PR is ready to merge/full CI is needed
Projects
None yet
Development

Successfully merging this pull request may close these issues.

5 participants