#3882 closed defect (fixed)

Flaky hypothesis test in test_storage_http

Reported by: itamarst Owned by: GitHub <noreply@…>
Priority: normal Milestone: HTTP Storage Protocol
Component: unknown Version: n/a
Keywords: Cc:
Launchpad Bug:

Description (last modified by itamarst)

[ERROR]
Traceback (most recent call last):
Failure: testtools.testresult.real._StringException: Traceback (most recent call last):
  File "/nix/store/qqsbr90v1ag6maa1pn0qnfzr2v6lx1p4-python3-3.7.11-env/lib/python3.7/site-packages/twisted/internet/defer.py", line 191, in maybeDeferred
    result = f(*args, **kwargs)
  File "/nix/store/qqsbr90v1ag6maa1pn0qnfzr2v6lx1p4-python3-3.7.11-env/lib/python3.7/site-packages/testtools/testcase.py", line 702, in _run_test_method
    return self._get_test_method()()
  File "/nix/store/qqsbr90v1ag6maa1pn0qnfzr2v6lx1p4-python3-3.7.11-env/lib/python3.7/site-packages/allmydata/test/eliotutil.py", line 171, in run_with_logging
    return test_method(*args, **kwargs)
  File "/nix/store/qqsbr90v1ag6maa1pn0qnfzr2v6lx1p4-python3-3.7.11-env/lib/python3.7/site-packages/allmydata/test/test_storage_http.py", line 852, in test_read_with_no_range
    def test_read_with_no_range(self, data_length):
  File "/nix/store/qqsbr90v1ag6maa1pn0qnfzr2v6lx1p4-python3-3.7.11-env/lib/python3.7/site-packages/hypothesis/core.py", line 1190, in wrapped_test
    raise the_error_hypothesis_found
  File "/nix/store/qqsbr90v1ag6maa1pn0qnfzr2v6lx1p4-python3-3.7.11-env/lib/python3.7/site-packages/hypothesis/core.py", line 886, in __flaky
    raise Flaky(message)
hypothesis.errors.Flaky: Hypothesis test_read_with_no_range(self=<allmydata.test.test_storage_http.ImmutableHTTPAPITests.test_read_with_no_range id=0x7fcaf2949550>, data_length=77788) produces unreliable results: Falsified on the first call but did not on a subsequent one


allmydata.test.test_storage_http.ImmutableHTTPAPITests.test_read_with_no_range

Update: After some digging (see comments) the issue seems to be that the CI Hypothesis profile is not being enabled in the Nix builders. This may be an issue in other builders as well.

Change History (10)

comment:2 Changed at 2022-03-15T14:43:04Z by itamarst

It seems like on large lengths, the first call can be quite slow, so it hits hypothesis timeout and is marked as failed. Later calls (strangely) are not as slow, so they pass, thus the flaky error warning.

comment:3 Changed at 2022-03-15T14:46:15Z by itamarst

Running directly on large lengths does _not_ cause it to hit the timeout. So... maybe urandom() is running out randomness if enough examples are called?

comment:4 Changed at 2022-03-15T15:12:30Z by itamarst

Supposedly urandom() doesn't block? And switching to Python's random generator causes issues, strangely (not random enough when run in bulk?).

comment:5 Changed at 2022-03-15T15:13:33Z by itamarst

Going to take a break, but for future reference, just adding @hypothesis.settings(max_examples=50000) to the test makes it fail fairly consistently on my computer.

comment:6 Changed at 2022-03-15T15:14:26Z by itamarst

Maybe it's GC?

comment:7 Changed at 2022-03-18T14:36:12Z by itamarst

  • Running a manual test of just urandom(), I can't make it block (which matches documented behavior), so that suggests it probably is not the issue.
  • Adding @hypothesis.settings(max_examples=5000) makes tests fail pretty consistently. Disabling GC makes them start passing again.

So it's probably GC.

comment:8 Changed at 2022-03-18T14:52:21Z by itamarst

All that being said: in theory Tahoe is disabling the 200ms deadline that GC is hitting in CI profile. So maybe it's that CI profile isn't being enabled in all cases.

comment:9 Changed at 2022-03-18T14:59:20Z by itamarst

  • Description modified (diff)

comment:10 Changed at 2022-03-21T14:57:27Z by GitHub <noreply@…>

  • Owner set to GitHub <noreply@…>
  • Resolution set to fixed
  • Status changed from new to closed

In 971f01f/trunk:

Merge pull request #1187 from tahoe-lafs/3882-flaky-tests

Fix flaky tests on Nix

Fixes ticket:3882

Note: See TracTickets for help on using tickets.