bazel test flake: //test/core/client_channel/resolvers:dns_resolver_cooldown_test #16585
Description
Failing ~7% of builds, mostly grpc/core/master/linux/bazel_rbe/remote_bazel_tests_tsan.
The culprit is dns_resolver_cooldown_test.cc:75] assertion failed: now - last_resolution_time >= kMinResolutionPeriodForCheckMs
https://source.cloud.google.com/results/invocations/3bb2bc0f-2e1f-4e31-9b16-7742ee9c5b52/targets/%2F%2Ftest%2Fcore%2Fclient_channel%2Fresolvers:dns_resolver_cooldown_test@poller%3Dpoll/log
https://source.cloud.google.com/results/invocations/8771a49c-a936-4f7c-8fea-394590e4d5c5/targets/%2F%2Ftest%2Fcore%2Fclient_channel%2Fresolvers:dns_resolver_cooldown_test@poller%3Depollsig/log
https://source.cloud.google.com/results/invocations/85591c30-57e6-4f0b-b251-49035fc1faa7/targets/%2F%2Ftest%2Fcore%2Fclient_channel%2Fresolvers:dns_resolver_cooldown_test@poller%3Depoll1/log
https://source.cloud.google.com/results/invocations/8e881680-1485-4ab1-842b-8d05a8c27767/targets/%2F%2Ftest%2Fcore%2Fclient_channel%2Fresolvers:dns_resolver_cooldown_test@poller%3Dpoll/log
All recent failures have the same error message:
exec ${PAGER:-/usr/bin/less} "$0" || exit 1
Executing tests from //test/core/client_channel/resolvers:dns_resolver_cooldown_test@poller=poll
-----------------------------------------------------------------------------
+ export GRPC_POLL_STRATEGY=poll
+ shift
+ test/core/client_channel/resolvers/dns_resolver_cooldown_test
D0829 19:22:45.072182603 19 test_config.cc:391] test slowdown factor: sanitizer=5, fixture=1, poller=1, total=5
D0829 19:22:45.112478707 19 ev_posix.cc:170] Using polling engine: poll
D0829 19:22:45.136781861 19 dns_resolver.cc:338] Using native dns resolver
D0829 19:22:45.150923992 19 dns_resolver_cooldown_test.cc:222] test: 'dns:127.0.0.1' should be valid for 'dns'
D0829 19:22:45.157799198 19 dns_resolver.cc:279] Start resolving.
D0829 19:22:45.165990550 19 dns_resolver_cooldown_test.cc:157] done=0, time_left=50001
I0829 19:22:45.191333465 22 dns_resolver_cooldown_test.cc:200] 1st: g_resolution_count: 1
D0829 19:22:45.191422655 22 dns_resolver.cc:259] In cooldown from last resolution (from 25 ms ago). Will resolve again in 975 ms
D0829 19:22:45.192685223 19 dns_resolver_cooldown_test.cc:157] done=0, time_left=49974
D0829 19:22:46.062702582 23 dns_resolver.cc:279] Start resolving.
E0829 19:22:46.063563363 23 dns_resolver_cooldown_test.cc:75] assertion failed: now - last_resolution_time >= kMinResolutionPeriodForCheckMs
*******************************
Caught signal SIGABRT