Skip to content

FLAKE: h2_http_proxy_nosec_test@max_connection_age@poller=poll-cv #17399

@apolcyn

Description

@apolcyn

https://source.cloud.google.com/results/invocations/ffdbbe38-dfb8-46ea-b300-bd87e2f8c23e/targets/%2F%2Ftest%2Fcore%2Fend2end:h2_http_proxy_nosec_test@max_connection_age@poller%3Dpoll-cv/log

PR on 1.17.x branch: #17382

Seen on both ubsan and Debug c/C++ bazel suites

exec ${PAGER:-/usr/bin/less} "$0" || exit 1
Executing tests from //test/core/end2end:h2_http_proxy_nosec_test@max_connection_age@poller=poll-cv
-----------------------------------------------------------------------------
D1203 20:49:06.813697180      20 test_config.cc:391]         test slowdown factor: sanitizer=1, fixture=1, poller=5, total=5
D1203 20:49:06.814248786      20 ev_posix.cc:169]            Using polling engine: poll-cv
D1203 20:49:06.814381997      20 dns_resolver.cc:338]        Using native dns resolver
I1203 20:49:06.814509824      20 http_proxy_fixture.cc:536]  Proxy address: localhost:14643
D1203 20:49:06.815316304      20 dns_resolver.cc:279]        Start resolving.
I1203 20:49:06.816352410      20 http_connect_handshaker.cc:300] Connecting to server localhost:14642 via HTTP proxy ipv6:[::1]:14643
D1203 20:49:06.816611664      24 http_proxy_fixture.cc:384]  on_read_request_done: 0x7f5e14001620 "No Error"
I1203 20:49:06.817275162      20 subchannel.cc:841]          New connected subchannel at 0x1018c80 for subchannel 0x7f5e08002c70
D1203 20:49:07.340445299      20 dns_resolver.cc:259]        In cooldown from last resolution (from 525 ms ago). Will resolve again in 475 ms
D1203 20:49:07.340493604      20 dns_resolver.cc:279]        Start resolving.
I1203 20:49:08.340386587      24 http_proxy_fixture.cc:162]  HTTP proxy server read: {"created":"@1543870148.340362074","description":"Socket closed","fd":8,"file":"src/core/lib/iomgr/tcp_posix.cc","file_line":465,"grpc_status":14,"target_address":"ipv6:[::1]:14642"}
I1203 20:49:08.340454319      24 http_proxy_fixture.cc:162]  HTTP proxy client read: {"created":"@1543870148.340432724","description":"FD shutdown","file":"src/core/lib/iomgr/ev_poll_posix.cc","file_line":532,"grpc_status":14,"referenced_errors":[{"created":"@1543870148.340362074","description":"Socket closed","fd":8,"file":"src/core/lib/iomgr/tcp_posix.cc","file_line":465,"grpc_status":14,"target_address":"ipv6:[::1]:14642"}]}
D1203 20:49:08.340543663      24 http_proxy_fixture.cc:130]  endpoints: 0x7f5e14000fd0 0x7f5e14005ec0
I1203 20:49:09.340844280      20 http_proxy_fixture.cc:536]  Proxy address: localhost:14645
D1203 20:49:09.341306856      20 dns_resolver.cc:279]        Start resolving.
I1203 20:49:09.341781833      20 http_connect_handshaker.cc:300] Connecting to server localhost:14644 via HTTP proxy ipv6:[::1]:14645
I1203 20:49:29.341388363      23 subchannel.cc:878]          Connect failed: {"created":"@1543870169.341286005","description":"FD shutdown","file":"src/core/lib/iomgr/ev_poll_posix.cc","file_line":532,"grpc_status":14,"referenced_errors":[{"created":"@1543870169.341196438","description":"Handshake timed out","file":"src/core/lib/channel/handshaker.cc","file_line":290}]}
I1203 20:49:29.341742915      20 http_connect_handshaker.cc:300] Connecting to server localhost:14644 via HTTP proxy ipv4:127.0.0.1:14645
I1203 20:49:49.341383661      28 subchannel.cc:878]          Connect failed: {"created":"@1543870189.341292414","description":"FD shutdown","file":"src/core/lib/iomgr/ev_poll_posix.cc","file_line":532,"grpc_status":14,"referenced_errors":[{"created":"@1543870189.341193244","description":"Handshake timed out","file":"src/core/lib/channel/handshaker.cc","file_line":290}]}
I1203 20:49:49.341463939      28 subchannel.cc:758]          Subchannel 0x7f5e08002c70: Retry immediately
I1203 20:49:49.341474264      28 subchannel.cc:719]          Failed to connect to channel, retrying
D1203 20:49:49.341627337      28 dns_resolver.cc:279]        Start resolving.
E1203 20:49:49.341784683      20 cq_verifier.cc:273]         cq returned unexpected event: OP_COMPLETE: tag:0x1 OK
E1203 20:49:49.341803342      20 cq_verifier.cc:280]         expected tags:
tag(101) GRPC_OP_COMPLETE success=1 test/core/end2end/tests/max_connection_age.cc:296
*******************************
Caught signal SIGABRT
test/core/end2end/h2_http_proxy_nosec_test[0x5a2018]
/lib/x86_64-linux-gnu/libpthread.so.0(+0x11390)[0x7f5e1bb77390]
/lib/x86_64-linux-gnu/libc.so.6(gsignal+0x38)[0x7f5e1af30428]
/lib/x86_64-linux-gnu/libc.so.6(abort+0x16a)[0x7f5e1af3202a]
test/core/end2end/h2_http_proxy_nosec_test[0x474650]
test/core/end2end/h2_http_proxy_nosec_test[0x44a47e]
test/core/end2end/h2_http_proxy_nosec_test[0x449211]
test/core/end2end/h2_http_proxy_nosec_test[0x407ba2]
test/core/end2end/h2_http_proxy_nosec_test[0x405040]
/lib/x86_64-linux-gnu/libc.so.6(__libc_start_main+0xf0)[0x7f5e1af1b830]
test/core/end2end/h2_http_proxy_nosec_test[0x404c79]
Aborted (core dumped)

Metadata

Metadata

Assignees

Type

No type

Projects

No projects

Milestone

No milestone

Relationships

None yet

Development

No branches or pull requests

Issue actions