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

Fix: Race condition in DockerContainerTestCase (#6587) #6594

Merged

Conversation

achave11-ucsc
Copy link
Member

@achave11-ucsc achave11-ucsc commented Sep 24, 2024

Connected issues: #6587

Checklist

Author

  • PR is a draft
  • Target branch is develop
  • Name of PR branch matches issues/<GitHub handle of author>/<issue#>-<slug>
  • On ZenHub, PR is connected to all issues it (partially) resolves
  • PR description links to connected issues
  • PR title matches1 that of a connected issue or comment in PR explains why they're different
  • PR title references all connected issues
  • For each connected issue, there is at least one commit whose title references that issue

1 when the issue title describes a problem, the corresponding PR
title is Fix: followed by the issue title

Author (partiality)

  • Added p tag to titles of partial commits
  • This PR is labeled partial or completely resolves all connected issues
  • This PR partially resolves each of the connected issues or does not have the partial label

Author (chains)

  • This PR is blocked by previous PR in the chain or is not chained to another PR
  • The blocking PR is labeled base or this PR is not chained to another PR
  • This PR is labeled chained or is not chained to another PR

Author (reindex, API changes)

  • Added r tag to commit title or the changes introduced by this PR will not require reindexing of any deployment
  • This PR is labeled reindex:dev or the changes introduced by it will not require reindexing of dev
  • This PR is labeled reindex:anvildev or the changes introduced by it will not require reindexing of anvildev
  • This PR is labeled reindex:anvilprod or the changes introduced by it will not require reindexing of anvilprod
  • This PR is labeled reindex:prod or the changes introduced by it will not require reindexing of prod
  • This PR is labeled reindex:partial and its description documents the specific reindexing procedure for dev, anvildev, anvilprod and prod or requires a full reindex or carries none of the labels reindex:dev, reindex:anvildev, reindex:anvilprod and reindex:prod
  • This PR and its connected issues are labeled API or this PR does not modify a REST API
  • Added a (A) tag to commit title for backwards (in)compatible changes or this PR does not modify a REST API
  • Updated REST API version number in app.py or this PR does not modify a REST API

Author (upgrading deployments)

  • Ran make docker_images.json and committed the resulting changes or this PR does not modify azul_docker_images, or any other variables referenced in the definition of that variable
  • Documented upgrading of deployments in UPGRADING.rst or this PR does not require upgrading deployments
  • Added u tag to commit title or this PR does not require upgrading deployments
  • This PR is labeled upgrade or does not require upgrading deployments
  • This PR is labeled deploy:shared or does not modify docker_images.json, and does not require deploying the shared component for any other reason
  • This PR is labeled deploy:gitlab or does not require deploying the gitlab component
  • This PR is labeled deploy:runner or does not require deploying the runner image

Author (hotfixes)

  • Added F tag to main commit title or this PR does not include permanent fix for a temporary hotfix
  • Reverted the temporary hotfixes for any connected issues or the none of the stable branches (anvilprod and prod) have temporary hotfixes for any of the issues connected to this PR

Author (before every review)

  • Rebased PR branch on develop, squashed old fixups
  • Ran make requirements_update or this PR does not modify requirements*.txt, common.mk, Makefile and Dockerfile
  • Added R tag to commit title or this PR does not modify requirements*.txt
  • This PR is labeled reqs or does not modify requirements*.txt
  • make integration_test passes in personal deployment or this PR does not modify functionality that could affect the IT outcome

Peer reviewer (after approval)

  • PR is not a draft
  • Ticket is in Review requested column
  • PR is awaiting requested review from system administrator
  • PR is assigned to only the system administrator

System administrator (after approval)

  • Actually approved the PR
  • Labeled connected issues as demo or no demo
  • Commented on connected issues about demo expectations or all connected issues are labeled no demo
  • Decided if PR can be labeled no sandbox
  • A comment to this PR details the completed security design review
  • PR title is appropriate as title of merge commit
  • N reviews label is accurate
  • Moved connected issues to Approved column
  • PR is assigned to only the operator

Operator (before pushing merge the commit)

  • Checked reindex:… labels and r commit title tag
  • Checked that demo expectations are clear or all connected issues are labeled no demo
  • Squashed PR branch and rebased onto develop
  • Sanity-checked history
  • Pushed PR branch to GitHub
  • Ran _select dev.shared && CI_COMMIT_REF_NAME=develop make -C terraform/shared apply_keep_unused or this PR is not labeled deploy:shared
  • Ran _select dev.gitlab && CI_COMMIT_REF_NAME=develop make -C terraform/gitlab apply or this PR is not labeled deploy:gitlab
  • Ran _select anvildev.shared && CI_COMMIT_REF_NAME=develop make -C terraform/shared apply_keep_unused or this PR is not labeled deploy:shared
  • Ran _select anvildev.gitlab && CI_COMMIT_REF_NAME=develop make -C terraform/gitlab apply or this PR is not labeled deploy:gitlab
  • Checked the items in the next section or this PR is labeled deploy:gitlab
  • PR is assigned to only the system administrator or this PR is not labeled deploy:gitlab

System administrator

  • Background migrations for dev.gitlab are complete or this PR is not labeled deploy:gitlab
  • Background migrations for anvildev.gitlab are complete or this PR is not labeled deploy:gitlab
  • PR is assigned to only the operator

Operator (before pushing merge the commit)

  • Ran _select dev.gitlab && make -C terraform/gitlab/runner or this PR is not labeled deploy:runner
  • Ran _select anvildev.gitlab && make -C terraform/gitlab/runner or this PR is not labeled deploy:runner
  • Added sandbox label or PR is labeled no sandbox
  • Pushed PR branch to GitLab dev or PR is labeled no sandbox
  • Pushed PR branch to GitLab anvildev or PR is labeled no sandbox
  • Build passes in sandbox deployment or PR is labeled no sandbox
  • Build passes in anvilbox deployment or PR is labeled no sandbox
  • Reviewed build logs for anomalies in sandbox deployment or PR is labeled no sandbox
  • Reviewed build logs for anomalies in anvilbox deployment or PR is labeled no sandbox
  • Deleted unreferenced indices in sandbox or this PR does not remove catalogs or otherwise causes unreferenced indices in dev
  • Deleted unreferenced indices in anvilbox or this PR does not remove catalogs or otherwise causes unreferenced indices in anvildev
  • Started reindex in sandbox or this PR is not labeled reindex:dev
  • Started reindex in anvilbox or this PR is not labeled reindex:anvildev
  • Checked for failures in sandbox or this PR is not labeled reindex:dev
  • Checked for failures in anvilbox or this PR is not labeled reindex:anvildev
  • The title of the merge commit starts with the title of this PR
  • Added PR # reference to merge commit title
  • Collected commit title tags in merge commit title but only included p if the PR is also labeled partial
  • Moved connected issues to Merged lower column in ZenHub
  • Moved blocked issues to Triage or no issues are blocked on the connected issues
  • Pushed merge commit to GitHub

Operator (chain shortening)

  • Changed the target branch of the blocked PR to develop or this PR is not labeled base
  • Removed the chained label from the blocked PR or this PR is not labeled base
  • Removed the blocking relationship from the blocked PR or this PR is not labeled base
  • Removed the base label from this PR or this PR is not labeled base

Operator (after pushing the merge commit)

  • Pushed merge commit to GitLab dev
  • Pushed merge commit to GitLab anvildev
  • Build passes on GitLab dev
  • Reviewed build logs for anomalies on GitLab dev
  • Build passes on GitLab anvildev
  • Reviewed build logs for anomalies on GitLab anvildev
  • Ran _select dev.shared && make -C terraform/shared apply or this PR is not labeled deploy:shared
  • Ran _select anvildev.shared && make -C terraform/shared apply or this PR is not labeled deploy:shared
  • Deleted PR branch from GitHub
  • Deleted PR branch from GitLab dev
  • Deleted PR branch from GitLab anvildev

Operator (reindex)

  • Deindexed all unreferenced catalogs in dev or this PR is neither labeled reindex:partial nor reindex:dev
  • Deindexed all unreferenced catalogs in anvildev or this PR is neither labeled reindex:partial nor reindex:anvildev
  • Deindexed specific sources in dev or this PR is neither labeled reindex:partial nor reindex:dev
  • Deindexed specific sources in anvildev or this PR is neither labeled reindex:partial nor reindex:anvildev
  • Indexed specific sources in dev or this PR is neither labeled reindex:partial nor reindex:dev
  • Indexed specific sources in anvildev or this PR is neither labeled reindex:partial nor reindex:anvildev
  • Started reindex in dev or this PR does not require reindexing dev
  • Started reindex in anvildev or this PR does not require reindexing anvildev
  • Checked for, triaged and possibly requeued messages in both fail queues in dev or this PR does not require reindexing dev
  • Checked for, triaged and possibly requeued messages in both fail queues in anvildev or this PR does not require reindexing anvildev
  • Emptied fail queues in dev or this PR does not require reindexing dev
  • Emptied fail queues in anvildev or this PR does not require reindexing anvildev

Operator

  • Propagated the deploy:shared, deploy:gitlab, deploy:runner, API, reindex:partial, reindex:anvilprod and reindex:prod labels to the next promotion PRs or this PR carries none of these labels
  • Propagated any specific instructions related to the deploy:shared, deploy:gitlab, deploy:runner, API, reindex:partial, reindex:anvilprod and reindex:prod labels, from the description of this PR to that of the next promotion PRs or this PR carries none of these labels
  • PR is assigned to no one

Shorthand for review comments

  • L line is too long
  • W line wrapping is wrong
  • Q bad quotes
  • F other formatting problem

@github-actions github-actions bot added the orange [process] Done by the Azul team label Sep 24, 2024
@achave11-ucsc achave11-ucsc changed the title Race condition in DockerContainerTestCase (#6587) Fix: Race condition in DockerContainerTestCase (#6587) Sep 24, 2024
@achave11-ucsc achave11-ucsc force-pushed the issues/achave11-ucsc/6587-fix-docker-img-race branch from 7e66b4f to 35c9c8a Compare September 24, 2024 22:03
Copy link

codecov bot commented Sep 24, 2024

Codecov Report

Attention: Patch coverage is 71.42857% with 4 lines in your changes missing coverage. Please review.

Project coverage is 85.41%. Comparing base (456fdc8) to head (dde1540).
Report is 2 commits behind head on develop.

Files with missing lines Patch % Lines
test/docker_container_test_case.py 71.42% 4 Missing ⚠️
Additional details and impacted files
@@             Coverage Diff             @@
##           develop    #6594      +/-   ##
===========================================
- Coverage    85.42%   85.41%   -0.02%     
===========================================
  Files          155      155              
  Lines        20750    20760      +10     
===========================================
+ Hits         17726    17732       +6     
- Misses        3024     3028       +4     
Flag Coverage Δ
85.41% <71.42%> (-0.02%) ⬇️

Flags with carried forward coverage won't be shown. Click here to find out more.

☔ View full report in Codecov by Sentry.
📢 Have feedback on the report? Share it here.

@coveralls
Copy link

coveralls commented Sep 24, 2024

Coverage Status

coverage: 85.431% (-0.01%) from 85.443%
when pulling dde1540 on issues/achave11-ucsc/6587-fix-docker-img-race
into 456fdc8 on develop.

Copy link
Contributor

@nadove-ucsc nadove-ucsc left a comment

Choose a reason for hiding this comment

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

Cleaned up some repetitive bits by restructuring the loop

Subject: [PATCH] REVIEW
---
Index: test/docker_container_test_case.py
IDEA additional info:
Subsystem: com.intellij.openapi.diff.impl.patch.CharsetEP
<+>UTF-8
===================================================================
diff --git a/test/docker_container_test_case.py b/test/docker_container_test_case.py
--- a/test/docker_container_test_case.py	(revision 35c9c8a9594d993cd3cc088fdb97ec9478efa9e2)
+++ b/test/docker_container_test_case.py	(date 1727224805142)
@@ -87,34 +87,31 @@
         try:
             time_it = datetime.now()
             container_info = cls._docker.api.inspect_container(container.id)
-            network_settings = container_info['NetworkSettings']
             if is_sibling:  # no coverage
-                container_ip = network_settings['IPAddress']
+                container_ip = container_info['NetworkSettings']['IPAddress']
                 assert isinstance(container_ip, str)
                 endpoint = (container_ip, container_port)
                 log.info('Launched sibling container %s from image %s, listening on %s:%i',
                          container.name, image, container_ip, container_port)
             else:
-                retries = 0
-                ports = network_settings['Ports']
-                while len(ports[f'{container_port}/tcp']) < 1:
-                    if (datetime.now() - time_it).seconds > 3:
-                        # Wait for the published ports of the container that's
-                        # supposedly running, otherwise giveup (let it fail).
-                        log.error('Unreachable TCP port %s for container %s',
-                                  container_port, container.name)
+                retries, seconds = 0, 0.0
+                while True:
+                    ports = container_info['NetworkSettings']['Ports'][f'{container_port}/tcp']
+                    if len(ports) > 0:
                         break
-                    time.sleep(.33)
-                    container_info = cls._docker.api.inspect_container(container.id)
-                    ports = container_info['NetworkSettings']['Ports']
-                    retries += 1
-                milisecs = (datetime.now() - time_it).microseconds / 1000
-                port = one(ports[f'{container_port}/tcp'])
+                    elif seconds > 3:
+                        raise RuntimeError('Unreachable TCP port', container_port, container.name)
+                    else:
+                        time.sleep(.33)
+                        container_info = cls._docker.api.inspect_container(container.id)
+                        retries += 1
+                        seconds = (datetime.now() - time_it).total_seconds()
+                port = one(ports)
                 host_ip = port['HostIp']
                 host_port = int(port['HostPort'])
-                log.info('Launched container %s from image %s after %dms (retries %d), '
+                log.info('Launched container %s from image %s after %.3fs and %d retries, '
                          'with container port %s mapped to %s:%i on the host',
-                         container.name, image, milisecs, retries, container_port, host_ip, host_port)
+                         container.name, image, seconds, retries, container_port, host_ip, host_port)
                 endpoint = (host_ip, host_port)
         except BaseException:  # no coverage
             container.kill()

container_info = cls._docker.api.inspect_container(container.id)
ports = container_info['NetworkSettings']['Ports']
retries += 1
milisecs = (datetime.now() - time_it).microseconds / 1000
Copy link
Contributor

Choose a reason for hiding this comment

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

"milliseconds" has 2 L's

Suggested change
milisecs = (datetime.now() - time_it).microseconds / 1000
millisecs = (datetime.now() - time_it).microseconds / 1000

Copy link
Contributor

Choose a reason for hiding this comment

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

I don't think this is doing what you want:

>>> from datetime import timedelta
>>> timedelta(seconds=3).microseconds
0

Copy link
Member Author

Choose a reason for hiding this comment

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

ty

Comment on lines 102 to 101
# Wait for the published ports of the container that's
# supposedly running, otherwise giveup (let it fail).
log.error('Unreachable TCP port %s for container %s',
container_port, container.name)
break
Copy link
Contributor

Choose a reason for hiding this comment

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

Why postpone the failure? Raising an exception here makes both the source code and the resulting stack trace easier to understand.

container_port, container.name)
break
time.sleep(.33)
container_info = cls._docker.api.inspect_container(container.id)
Copy link
Contributor

Choose a reason for hiding this comment

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

Is inspect_container an expensive (i.e. time-consuming) operation? If not, then it seems redundant to track both milliseconds and retries in the loop.

@nadove-ucsc nadove-ucsc removed their assignment Sep 25, 2024
@achave11-ucsc achave11-ucsc force-pushed the issues/achave11-ucsc/6587-fix-docker-img-race branch from 35c9c8a to 5009f13 Compare September 25, 2024 22:17
@achave11-ucsc
Copy link
Member Author

Requested peer review from @dsotirho-ucsc since @nadove-ucsc is now code owner / sys-admin.

@@ -81,22 +85,32 @@ def _create_container(cls, image: str, container_port: int, **kwargs) -> Netloc:
ports=ports,
**kwargs)
try:
time_it = datetime.now()
Copy link
Contributor

Choose a reason for hiding this comment

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

Suggested change
time_it = datetime.now()
start = datetime.now()

This should be moved above the call to cls._docker.containers.run() so that even if sleep() is not called in the while loop, a time greater than 0.00 will be reported.

Comment on lines 97 to 99
seconds = 0.0
while True:
ports = container_info['NetworkSettings']['Ports'][f'{container_port}/tcp']
Copy link
Contributor

Choose a reason for hiding this comment

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

Suggested change
seconds = 0.0
while True:
ports = container_info['NetworkSettings']['Ports'][f'{container_port}/tcp']
while True:
seconds = (datetime.now() - time_it).total_seconds()
ports = container_info['NetworkSettings']['Ports'][f'{container_port}/tcp']

Moving the time calculation to the start of the while loop will let seconds reflect the total time taken even if sleep() is not called.

else:
time.sleep(.33)
container_info = cls._docker.api.inspect_container(container.id)
seconds = (datetime.now() - time_it).total_seconds()
Copy link
Contributor

Choose a reason for hiding this comment

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

Suggested change
seconds = (datetime.now() - time_it).total_seconds()

@dsotirho-ucsc dsotirho-ucsc removed their assignment Sep 26, 2024
@achave11-ucsc achave11-ucsc force-pushed the issues/achave11-ucsc/6587-fix-docker-img-race branch from 5009f13 to ac51467 Compare September 27, 2024 18:18
Copy link
Contributor

@dsotirho-ucsc dsotirho-ucsc left a comment

Choose a reason for hiding this comment

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

Approved

@dsotirho-ucsc dsotirho-ucsc marked this pull request as ready for review September 30, 2024 22:35
@nadove-ucsc
Copy link
Contributor

Security design review

  • Security design review completed; this PR does not
    • … affect authentication; for example:
      • OAuth 2.0 with the application (API or Swagger UI)
      • Authentication of developers with Google Cloud APIs
      • Authentication of developers with AWS APIs
      • Authentication with a GitLab instance in the system
      • Password and 2FA authentication with GitHub
      • API access token authentication with GitHub
      • Authentication with Terra
    • … affect the permissions of internal users like access to
      • Cloud resources on AWS and GCP
      • GitLab repositories, projects and groups, administration
      • an EC2 instance via SSH
      • GitHub issues, pull requests, commits, commit statuses, wikis, repositories, organizations
    • … affect the permissions of external users like access to
      • TDR snapshots
    • … affect permissions of service or bot accounts
      • Cloud resources on AWS and GCP
    • … affect audit logging in the system, like
      • adding, removing or changing a log message that represents an auditable event
      • changing the routing of log messages through the system
    • … affect monitoring of the system
    • … introduce a new software dependency like
      • Python packages on PYPI
      • Command-line utilities
      • Docker images
      • Terraform providers
    • … add an interface that exposes sensitive or confidential data at the security boundary
    • … affect the encryption of data at rest
    • … require persistence of sensitive or confidential data that might require encryption at rest
    • … require unencrypted transmission of data within the security boundary
    • … affect the network security layer; for example by
      • modifying, adding or removing firewall rules
      • modifying, adding or removing security groups
      • changing or adding a port a service, proxy or load balancer listens on
  • Documentation on any unchecked boxes is provided in comments below

@nadove-ucsc nadove-ucsc added the 1 review [process] Lead requested changes once label Oct 1, 2024
@achave11-ucsc achave11-ucsc force-pushed the issues/achave11-ucsc/6587-fix-docker-img-race branch from 841f1e6 to dde1540 Compare October 1, 2024 03:55
@achave11-ucsc achave11-ucsc added the sandbox [process] Resolution is being verified in sandbox deployment label Oct 1, 2024
@achave11-ucsc achave11-ucsc merged commit af05032 into develop Oct 1, 2024
11 checks passed
@achave11-ucsc achave11-ucsc deleted the issues/achave11-ucsc/6587-fix-docker-img-race branch October 1, 2024 16:09
@achave11-ucsc achave11-ucsc removed their assignment Oct 1, 2024
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
1 review [process] Lead requested changes once orange [process] Done by the Azul team sandbox [process] Resolution is being verified in sandbox deployment
Projects
None yet
Development

Successfully merging this pull request may close these issues.

4 participants