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

Reduce log noise from next run being in past #15670

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

Conversation

AlanCoding
Copy link
Member

@AlanCoding AlanCoding commented Nov 26, 2024

SUMMARY

We have a very low-value log about the next run of something being in the past.

awx.main.dispatch.periodic PID:9493 Scheduler next run of task_manager is -0.0418314150082 seconds in the past

I believe this should (in theory) address this issue. I will see about verifying this with SOS reports. I know this comes up a lot, and I believe it's because "control" tasks can take a non-trivial amount of time. And that is a big issue, which we probably want to add some other logging for, in a more specific and actionable form.

EDIT:

Specifically, I'd like to generalize the log_excess_runtime decorator and use it on the cleanup task.

That action is done in #15675, so if this behavior is observed in the future, we will not get logs about schedule misses, but will instead get logs that say "method xyz too 2.3 seconds, which is bad", assuming we merge both patches. That is the format of feedback we want.

ISSUE TYPE
  • Bug, Docs Fix or other nominal change
COMPONENT NAME
  • API

@chrismeyersfsu
Copy link
Member

Yes to calling time once and passing it around. Makes unit/functional testing involving time sane too.

Copy link

sonarcloud bot commented Dec 2, 2024

@AlanCoding AlanCoding marked this pull request as ready for review December 2, 2024 20:05
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Projects
None yet
Development

Successfully merging this pull request may close these issues.

2 participants