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

HPCC-32947 Capture and report lookahead timings for project #19275

Open
wants to merge 2 commits into
base: master
Choose a base branch
from

Conversation

shamser
Copy link
Contributor

@shamser shamser commented Nov 5, 2024

The modification records time spent in the strands as lookahead timing. This is necessary to ensure the local execute timings for project and upstream activities are correct.

Ideally, this lookahead timings would be recorded a separate statistic such as "background activity". However, a new statistic will not be created at this time to avoid complicating the statistics.

Type of change:

  • This change is a bug fix (non-breaking change which fixes an issue).
  • This change is a new feature (non-breaking change which adds functionality).
  • This change improves the code (refactor or other change that does not change the functionality)
  • This change fixes warnings (the fix does not alter the functionality or the generated code)
  • This change is a breaking change (fix or feature that will cause existing behavior to change).
  • This change alters the query API (existing queries will have to be recompiled)

Checklist:

  • My code follows the code style of this project.
    • My code does not create any new warnings from compiler, build system, or lint.
  • The commit message is properly formatted and free of typos.
    • The commit message title makes sense in a changelog, by itself.
    • The commit is signed.
  • My change requires a change to the documentation.
    • I have updated the documentation accordingly, or...
    • I have created a JIRA ticket to update the documentation.
    • Any new interfaces or exported functions are appropriately commented.
  • I have read the CONTRIBUTORS document.
  • The change has been fully tested:
    • I have added tests to cover my changes.
    • All new and existing tests passed.
    • I have checked that this change does not introduce memory leaks.
    • I have used Valgrind or similar tools to check for potential issues.
  • I have given due consideration to all of the following potential concerns:
    • Scalability
    • Performance
    • Security
    • Thread-safety
    • Cloud-compatibility
    • Premature optimization
    • Existing deployed queries will not be broken
    • This change fixes the problem, not just the symptom
    • The target branch of this pull request is appropriate for such a change.
  • There are no similar instances of the same problem that should be addressed
    • I have addressed them here
    • I have raised JIRA issues to address them separately
  • This is a user interface / front-end modification
    • I have tested my changes in multiple modern browsers
    • The component(s) render as expected

Smoketest:

  • Send notifications about my Pull Request position in Smoketest queue.
  • Test my draft Pull Request.

Testing:

The modification records time spent in the strands as lookahead
timing.  This is necessary to ensure the local execute timings
for project and upstream activities are correct.

Ideally, this lookahead timings would be recorded a separate
statistic such as "background activity".  However, a new
statistic will not be created at this time to avoid complicating
the statistics.

Signed-off-by: Shamser Ahmed <[email protected]>
Copy link

github-actions bot commented Nov 5, 2024

Jira Issue: https://hpccsystems.atlassian.net//browse/HPCC-32947

Jirabot Action Result:
Workflow Transition To: Merge Pending
Updated PR

@shamser shamser requested a review from jakesmith November 5, 2024 15:32
Copy link
Member

@jakesmith jakesmith left a comment

Choose a reason for hiding this comment

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

@shamser - needs further discussion.

@@ -35,7 +35,7 @@ class CProjecStrandProcessor : public CThorStrandProcessor
}
STRAND_CATCH_NEXTROW()
{
ActivityTimer t(slaveTimerStats, timeActivities);
LookAheadTimer t(parent.slaveTimerStats, timeActivities);
Copy link
Member

Choose a reason for hiding this comment

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

as discussed, this will cause threading problems. I don't think any of the other uses of LookAheadTimer (in pending PR's are thread unsafe?).

If it were to do this, it could collect the timing in the local lookahead member of slaveTimerStats, and then aggregate in the activity, in the same way CThorStrandedActivity::queryTotalCycles() const is currently aggregating totalCycles

BUT, this aggregated lookahead time is going to mess up the timing afaict. e.g. 4 strands, each taking 1 sec, will be seen as 4 secs total, but they are concurrent. The time spent in the project act. will not be 4 seconds, it will be however long it spent gettings rows out of the strands as a whole.

I'm not sure where the correct place to time is, and will depend when the strands are being combined, but I think think this is will be correct (or was)

Copy link
Contributor Author

Choose a reason for hiding this comment

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

I am addressing the threading LookAhead timing update issue.

However, I believe strands correct timing would be the LookAheadCycles. Because recording as TotalCycles cause problem: if we were to record the strand execute time as TotalCycles (as opposed to LookAheadCycles), it causes problems with downstream local execute time calculation (because aggregation of the strand time as TotalCycles is likely to cause the upstream activity's total time to be less.

Copy link
Member

Choose a reason for hiding this comment

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

I think you can accurately accumulate lookahead time here, but the placement of the ActivityTimer is capturing lookahead time and the project time at the moment. Imagine time to read from input is negligible, but the transform if relatively slow, this will now be seen a large lookahead time - which is incorrect.

I am still not sure how you accurately capture the total time the project (not the input) spent, because they are all overlapping and you do not want the aggregate total, but the time spent getting the rows out, which will depend on how they are combined etc.

@shamser shamser requested a review from jakesmith November 8, 2024 10:15
Copy link
Member

@jakesmith jakesmith left a comment

Choose a reason for hiding this comment

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

@shamser - see comment.

@jakesmith
Copy link
Member

@shamser - notes from discussion we had today with Gavin.

The stranded variety of project is little used. Fixing the timing problem relating to it therefore have a much lower priority.
But it is worth capturing the approach that would be needed in a new JIRA in case we circle back to it. Can you open the new JIRA and document the approach and link it to this JIRA? Thanks.
And this PR should be change to remove changes to the Stranded code.

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
None yet
Projects
None yet
Development

Successfully merging this pull request may close these issues.

2 participants