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.

Sign up for GitHub

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

Jump to bottom

Update Envoy #2639

Closed
wants to merge 4 commits into from
Closed

Update Envoy #2639

wants to merge 4 commits into from

Conversation

envoy-bot
Copy link
Contributor

Automated changes by create-pull-request GitHub action

@jpsim @web-flow
Update Envoy
210bd8d 
Signed-off-by: GitHub Action <noreply@github.com>
@envoy-bot envoy-bot requested a review from Augustyniak October 31, 2022 14:10
@jpsim
Merge remote-tracking branch 'origin/main' into update-envoy-1667225437
bbea12b 
* origin/main:
  python: Pin requirement hashes (#2643)
  Disable flaky TestConfig.StringAccessors (#2642)

Signed-off-by: JP Simard <jp@jpsim.com>
@Augustyniak
Copy link
Contributor

/retest

@jpsim
Copy link
Contributor

jpsim commented Nov 2, 2022

There's a legitimate breakage here that I haven't fully thought through how to handle:

envoy bug failure: false. Details: Using a removed guard envoy.reloadable_features.override_request_timeout_by_gateway_timeout. In future version of Enovy this will be treated as invalid configuration

@Augustyniak
Copy link
Contributor

Augustyniak commented Nov 2, 2022 •
edited
Loading

It seems to be used in tests only but I have some recollection of this feature flag. I am sure that at some point it was used in config.cc but it does not seem to be used in there anymore.

I found that Lyft internal discussion related to that runtime flag https://lyft.slack.com/archives/CLJGGN2JJ/p1647436776083709. Its usage was introduced in #2105

@Augustyniak
Copy link
Contributor

Augustyniak commented Nov 2, 2022 •
edited
Loading

I found a PR that removed override_request_timeout_by_gateway_timeout from config.cc #2296.

It looks that it should be safe to remove the usage of that runtime flags from our tests - that should make the PR green.

@Augustyniak
remove the usage of override_request_timeout_by_gateway_timeout
b54adf9 
Signed-off-by: Rafal Augustyniak <raugustyniak@lyft.com>
@Augustyniak Augustyniak requested a review from jpsim November 2, 2022 17:15
@Augustyniak
Copy link
Contributor

/retest

@Augustyniak
Copy link
Contributor

After a little bit more of an investigation.

We removed override_request_timeout_by_gateway_timeout runtime value from our main config.cc as part of #2296 months ago. It introduced a bug. Our tests did not catch the bug as they were not updated and they continue to use override_request_timeout_by_gateway_timeout runtime value - that's an issue with our tests in general as we have multiple copies of Envoy config and tests are not guaranteed to use the whatever config the main Envoy Mobile engine builder uses.

Back to the failures in here.

After the removal of override_request_timeout_by_gateway_timeout from IdleTimeoutTest test:

@Augustyniak
Copy link
Contributor

Augustyniak commented Nov 2, 2022 •
edited
Loading

Envoy Mobile Logs from a failing test 
DEBUG: /private/var/tmp/_bazel_raugustyniak/a158a547bfde3b26514338a0e440f25b/external/rules_python/python/pip.bzl:46:10: pip_install is deprecated. Please switch to pip_parse. pip_install will be removed in a future release.
WARNING: /Users/raugustyniak/src/envoy-mobile/library/common/jni/BUILD:91:27: target 'libndk_envoy_jni.jnilib' is both a rule and a file; please choose another name for the rule
INFO: Analyzed target //test/swift/integration:test (0 packages loaded, 0 targets configured).
INFO: Found 1 test target...
FAIL: //test/swift/integration:test (see /private/var/tmp/_bazel_raugustyniak/a158a547bfde3b26514338a0e440f25b/execroot/envoy_mobile/bazel-out/darwin_arm64-fastbuild/testlogs/test/swift/integration/test/test.log)
INFO: From Testing //test/swift/integration:test:
==================== Test output for //test/swift/integration:test:
2022-11-02 20:13:57,226 Creating a new simulator:
Name: New-iPhone 13-16.0
OS: iOS 16.0
Type: iPhone 13
2022-11-02 20:13:58,074 Created new simulator D7D45025-7A82-4C32-9002-BD4F9D80F943.
2022-11-02 20:13:58,074 Will consider the test as test type Logic Test to run. Because the app under test is not given.
Test Suite 'All tests' started at 2022-11-02 16:14:00.429
Test Suite 'test.xctest' started at 2022-11-02 16:14:00.430
Test Suite 'IdleTimeoutTests' started at 2022-11-02 16:14:00.430
Test Case '-[test_swift_integration_test_lib.IdleTimeoutTests testIdleTimeout]' started.
2022-11-02 16:14:00.461 xctest[49669:4459311] [Envoy] setting preferred network to 1
2022-11-02 16:14:00.461 xctest[49669:4459309] [Envoy] debug: config:
!ignore platform_defs:
- &connect_timeout 30s
- &dns_fail_base_interval 2s
- &dns_fail_max_interval 10s
- &dns_query_timeout 25s
- &dns_min_refresh_rate 60s
- &dns_preresolve_hostnames []
- &dns_lookup_family ALL
- &dns_multiple_addresses true
- &h2_delay_keepalive_timeout false
- &dns_refresh_rate 60s
- &enable_drain_post_dns_refresh false
- &enable_interface_binding false
- &trust_chain_verification VERIFY_TRUST_CHAIN
- &force_ipv6 false
- &h2_connection_keepalive_idle_interval 0.001s
- &h2_connection_keepalive_timeout 10s
- &max_connections_per_host 7
- &stream_idle_timeout 15s
- &per_try_idle_timeout 15s
- &metadata { device_os: iOS, app_version: unspecified, app_id: unspecified }
- &virtual_clusters []
- &stats_flush_interval 60s

- &validation_context
  trusted_ca:
    inline_string: *tls_root_certs
  trust_chain_verification: *trust_chain_verification

static_resources:
  listeners:
  - name: fake_remote_listener
    address:
      socket_address: { protocol: TCP, address: 127.0.0.1, port_value: 10240 }
    filter_chains:
    - filters:
      - name: envoy.filters.network.http_connection_manager
        typed_config:
          "@type": type.googleapis.com/envoy.extensions.filters.network.http_connection_manager.v3.HttpConnectionManager
          stat_prefix: remote_hcm
          route_config:
            name: remote_route
            virtual_hosts:
            - name: remote_service
              domains: ["*"]
              routes:
              - match: { prefix: "/" }
                direct_response: { status: 200 }
          http_filters:
          - name: envoy.router
            typed_config:
              "@type": type.googleapis.com/envoy.extensions.filters.http.router.v3.Router
  - name: base_api_listener
    address:
      socket_address: { protocol: TCP, address: 0.0.0.0, port_value: 10000 }
    api_listener:
      api_listener:
        "@type": type.googleapis.com/envoy.extensions.filters.network.http_connection_manager.v3.EnvoyMobileHttpConnectionManager
        config:
          stat_prefix: api_hcm
          stream_idle_timeout: 0.5s
          route_config:
            name: api_router
            virtual_hosts:
            - name: api
              domains: ["*"]
              routes:
              - match: { prefix: "/" }
                route: { cluster: fake_remote }
          http_filters:
          - name: envoy.filters.http.platform_bridge
            typed_config:
              "@type": type.googleapis.com/envoymobile.extensions.filters.http.platform_bridge.PlatformBridge
              platform_filter_name: reset_idle_test_filter
          - name: envoy.filters.http.local_error
            typed_config:
              "@type": type.googleapis.com/envoymobile.extensions.filters.http.local_error.LocalError
          - name: envoy.router
            typed_config:
              "@type": type.googleapis.com/envoy.extensions.filters.http.router.v3.Router
  clusters:
  - name: fake_remote
    connect_timeout: 0.25s
    type: STATIC
    lb_policy: ROUND_ROBIN
    load_assignment:
      cluster_name: fake_remote
      endpoints:
      - lb_endpoints:
        - endpoint:
            address:
              socket_address: { address: 127.0.0.1, port_value: 10240 }
[2022-11-02 16:14:00.462][4459311][debug][upstream] [library/common/network/connectivity_manager.cc:95] 1
[2022-11-02 16:14:00.474][4459372][info][main] [external/envoy/source/server/server.cc:390] initializing epoch 0 (base id=0, hot restart version=disabled)
[2022-11-02 16:14:00.474][4459372][info][main] [external/envoy/source/server/server.cc:392] statically linked extensions:
[2022-11-02 16:14:00.474][4459372][info][main] [external/envoy/source/server/server.cc:394]   envoy.filters.http.upstream: envoy.buffer, envoy.filters.http.buffer, envoy.filters.http.upstream_codec
[2022-11-02 16:14:00.474][4459372][info][main] [external/envoy/source/server/server.cc:394]   envoy.retry_options_predicates: envoy.retry_options_predicates.network_configuration
[2022-11-02 16:14:00.474][4459372][info][main] [external/envoy/source/server/server.cc:394]   envoy.path.rewrite: envoy.path.rewrite.uri_template.uri_template_rewriter
[2022-11-02 16:14:00.474][4459372][info][main] [external/envoy/source/server/server.cc:394]   envoy.quic.proof_source: envoy.quic.proof_source.filter_chain
[2022-11-02 16:14:00.474][4459372][info][main] [external/envoy/source/server/server.cc:394]   envoy.resolvers: envoy.ip
[2022-11-02 16:14:00.474][4459372][info][main] [external/envoy/source/server/server.cc:394]   envoy.bootstrap: envoy.extensions.network.socket_interface.default_socket_interface
[2022-11-02 16:14:00.474][4459372][info][main] [external/envoy/source/server/server.cc:394]   envoy.http.stateful_header_formatters: envoy.http.stateful_header_formatters.preserve_case, preserve_case
[2022-11-02 16:14:00.474][4459372][info][main] [external/envoy/source/server/server.cc:394]   envoy.path.match: envoy.path.match.uri_template.uri_template_matcher
[2022-11-02 16:14:00.474][4459372][info][main] [external/envoy/source/server/server.cc:394]   envoy.regex_engines: envoy.regex_engines.google_re2
[2022-11-02 16:14:00.474][4459372][info][main] [external/envoy/source/server/server.cc:394]   envoy.udp_packet_writer: envoy.udp_packet_writer.default
[2022-11-02 16:14:00.474][4459372][info][main] [external/envoy/source/server/server.cc:394]   envoy.http.original_ip_detection: envoy.http.original_ip_detection.xff
[2022-11-02 16:14:00.474][4459372][info][main] [external/envoy/source/server/server.cc:394]   envoy.stats_sinks: envoy.metrics_service, envoy.stat_sinks.metrics_service, envoy.stat_sinks.statsd, envoy.statsd
[2022-11-02 16:14:00.474][4459372][info][main] [external/envoy/source/server/server.cc:394]   envoy.common.key_value: envoy.key_value.platform
[2022-11-02 16:14:00.474][4459372][info][main] [external/envoy/source/server/server.cc:394]   envoy.matching.network.input: envoy.matching.inputs.application_protocol, envoy.matching.inputs.destination_ip, envoy.matching.inputs.destination_port, envoy.matching.inputs.direct_source_ip, envoy.matching.inputs.server_name, envoy.matching.inputs.source_ip, envoy.matching.inputs.source_port, envoy.matching.inputs.source_type, envoy.matching.inputs.transport_protocol
[2022-11-02 16:14:00.474][4459372][info][main] [external/envoy/source/server/server.cc:394]   envoy.http.header_validators: envoy.http.header_validators.envoy_default
[2022-11-02 16:14:00.474][4459372][info][main] [external/envoy/source/server/server.cc:394]   envoy.transport_sockets.downstream: envoy.transport_sockets.quic, envoy.transport_sockets.raw_buffer, envoy.transport_sockets.tls, raw_buffer, tls
[2022-11-02 16:14:00.474][4459372][info][main] [external/envoy/source/server/server.cc:394]   envoy.request_id: envoy.request_id.uuid
[2022-11-02 16:14:00.474][4459372][info][main] [external/envoy/source/server/server.cc:394]   envoy.upstreams: envoy.filters.connection_pools.http.generic
[2022-11-02 16:14:00.474][4459372][info][main] [external/envoy/source/server/server.cc:394]   envoy.filters.http: assertion, envoy.buffer, envoy.filters.http.alternate_protocols_cache, envoy.filters.http.buffer, envoy.filters.http.decompressor, envoy.filters.http.dynamic_forward_proxy, envoy.filters.http.match_delegate, envoy.filters.http.router, envoy.router, local_error, network_configuration, platform_bridge, route_cache_reset, socket_tag, test_accessor, test_event_tracker, test_kv_store, test_logger, test_read
[2022-11-02 16:14:00.474][4459372][info][main] [external/envoy/source/server/server.cc:394]   envoy.quic.server.crypto_stream: envoy.quic.crypto_stream.server.quiche
[2022-11-02 16:14:00.474][4459372][info][main] [external/envoy/source/server/server.cc:394]   envoy.compression.decompressor: envoy.compression.brotli.decompressor, envoy.compression.gzip.decompressor
[2022-11-02 16:14:00.474][4459372][info][main] [external/envoy/source/server/server.cc:394]   envoy.route.early_data_policy: envoy.route.early_data_policy.default
[2022-11-02 16:14:00.474][4459372][info][main] [external/envoy/source/server/server.cc:394]   envoy.upstream_options: envoy.extensions.upstreams.http.v3.HttpProtocolOptions, envoy.upstreams.http.http_protocol_options
[2022-11-02 16:14:00.474][4459372][info][main] [external/envoy/source/server/server.cc:394]   envoy.matching.http.input: envoy.matching.inputs.destination_ip, envoy.matching.inputs.destination_port, envoy.matching.inputs.direct_source_ip, envoy.matching.inputs.request_headers, envoy.matching.inputs.request_trailers, envoy.matching.inputs.response_headers, envoy.matching.inputs.response_trailers, envoy.matching.inputs.server_name, envoy.matching.inputs.source_ip, envoy.matching.inputs.source_port, envoy.matching.inputs.source_type
[2022-11-02 16:14:00.474][4459372][info][main] [external/envoy/source/server/server.cc:394]   envoy.matching.action: filter-chain-name
[2022-11-02 16:14:00.474][4459372][info][main] [external/envoy/source/server/server.cc:394]   envoy.filters.network: envoy.filters.network.http_connection_manager, envoy.http_connection_manager
[2022-11-02 16:14:00.474][4459372][info][main] [external/envoy/source/server/server.cc:394]   envoy.clusters: envoy.cluster.eds, envoy.cluster.logical_dns, envoy.cluster.original_dst, envoy.cluster.static, envoy.cluster.strict_dns, envoy.clusters.dynamic_forward_proxy
[2022-11-02 16:14:00.474][4459372][info][main] [external/envoy/source/server/server.cc:394]   network.connection.client: default
[2022-11-02 16:14:00.474][4459372][info][main] [external/envoy/source/server/server.cc:394]   envoy.quic.connection_id_generator: envoy.quic.deterministic_connection_id_generator
[2022-11-02 16:14:00.474][4459372][info][main] [external/envoy/source/server/server.cc:394]   envoy.transport_sockets.upstream: envoy.transport_sockets.http_11_proxy, envoy.transport_sockets.quic, envoy.transport_sockets.raw_buffer, envoy.transport_sockets.tls, raw_buffer, tls
[2022-11-02 16:14:00.474][4459372][info][main] [external/envoy/source/server/server.cc:394]   envoy.guarddog_actions: envoy.watchdog.abort_action
[2022-11-02 16:14:00.474][4459372][info][main] [external/envoy/source/server/server.cc:394]   envoy.tls.cert_validator: envoy.tls.cert_validator.default, envoy_mobile.cert_validator.platform_bridge_cert_validator
[2022-11-02 16:14:00.474][4459372][info][main] [external/envoy/source/server/server.cc:394]   envoy.network.dns_resolver: envoy.network.dns_resolver.apple, envoy.network.dns_resolver.cares, envoy.network.dns_resolver.getaddrinfo
[2022-11-02 16:14:00.584][4459372][info][main] [external/envoy/source/server/server.cc:442] HTTP header map info:
[2022-11-02 16:14:00.586][4459372][info][main] [external/envoy/source/server/server.cc:445]   request header map: 520 bytes: :authority,:method,:path,:protocol,:scheme,accept-encoding,cache-control,connection,content-encoding,content-length,content-type,expect,grpc-timeout,keep-alive,proxy-connection,proxy-status,te,transfer-encoding,upgrade,user-agent,via,x-client-trace-id,x-envoy-attempt-count,x-envoy-decorator-operation,x-envoy-downstream-service-cluster,x-envoy-downstream-service-node,x-envoy-expected-rq-timeout-ms,x-envoy-external-address,x-envoy-force-trace,x-envoy-hedge-on-per-try-timeout,x-envoy-internal,x-envoy-ip-tags,x-envoy-max-retries,x-envoy-original-path,x-envoy-original-url,x-envoy-retriable-header-names,x-envoy-retriable-status-codes,x-envoy-retry-grpc-on,x-envoy-retry-on,x-envoy-upstream-alt-stat-name,x-envoy-upstream-rq-per-try-timeout-ms,x-envoy-upstream-rq-timeout-alt-response,x-envoy-upstream-rq-timeout-ms,x-envoy-upstream-stream-duration-ms,x-forwarded-client-cert,x-forwarded-for,x-forwarded-host,x-forwarded-proto,x-request-id
[2022-11-02 16:14:00.586][4459372][info][main] [external/envoy/source/server/server.cc:445]   request trailer map: 120 bytes: 
[2022-11-02 16:14:00.586][4459372][info][main] [external/envoy/source/server/server.cc:445]   response header map: 336 bytes: :status,cache-control,connection,content-encoding,content-length,content-type,date,grpc-message,grpc-status,keep-alive,location,proxy-connection,proxy-status,server,transfer-encoding,upgrade,via,x-envoy-attempt-count,x-envoy-decorator-operation,x-envoy-degraded,x-envoy-immediate-health-check-fail,x-envoy-ratelimited,x-envoy-upstream-canary,x-envoy-upstream-healthchecked-cluster,x-envoy-upstream-service-time,x-request-id
[2022-11-02 16:14:00.586][4459372][info][main] [external/envoy/source/server/server.cc:445]   response trailer map: 144 bytes: grpc-message,grpc-status
[2022-11-02 16:14:00.603][4459372][debug][main] [external/envoy/source/server/overload_manager_impl.cc:448] No overload action is configured for envoy.overload_actions.shrink_heap.
[2022-11-02 16:14:00.603][4459372][debug][main] [external/envoy/source/server/overload_manager_impl.cc:448] No overload action is configured for envoy.overload_actions.reduce_timeouts.
[2022-11-02 16:14:00.603][4459372][debug][main] [external/envoy/source/server/overload_manager_impl.cc:448] No overload action is configured for envoy.overload_actions.stop_accepting_connections.
[2022-11-02 16:14:00.603][4459372][debug][main] [external/envoy/source/server/overload_manager_impl.cc:448] No overload action is configured for envoy.overload_actions.reject_incoming_connections.
[2022-11-02 16:14:00.603][4459372][debug][main] [external/envoy/source/server/overload_manager_impl.cc:448] No overload action is configured for envoy.overload_actions.reset_high_memory_stream.
[2022-11-02 16:14:00.604][4459372][info][main] [external/envoy/source/server/server.cc:811] runtime: {}
[2022-11-02 16:14:00.605][4459372][warning][main] [external/envoy/source/server/server.cc:671] No admin address given, so no admin HTTP server started.
[2022-11-02 16:14:00.605][4459372][debug][misc] [external/envoy/source/common/network/dns_resolver/dns_factory_util.cc:42] create Apple DNS resolver type: envoy.network.dns_resolver.apple in MacOS.
[2022-11-02 16:14:00.605][4459372][debug][misc] [external/envoy/source/common/network/dns_resolver/dns_factory_util.cc:81] create DNS resolver type: envoy.network.dns_resolver.apple
[2022-11-02 16:14:00.606][4459372][info][config] [external/envoy/source/server/configuration_impl.cc:131] loading tracing configuration
[2022-11-02 16:14:00.606][4459372][info][config] [external/envoy/source/server/configuration_impl.cc:91] loading 0 static secret(s)
[2022-11-02 16:14:00.606][4459372][info][config] [external/envoy/source/server/configuration_impl.cc:97] loading 1 cluster(s)
[2022-11-02 16:14:00.614][4459372][debug][config] [external/envoy/source/common/http/filter_chain_helper.h:88]     upstream http filter #0
[2022-11-02 16:14:00.614][4459372][debug][config] [external/envoy/source/common/http/filter_chain_helper.h:118]       name: envoy.filters.http.upstream_codec
[2022-11-02 16:14:00.614][4459372][debug][config] [external/envoy/source/common/http/filter_chain_helper.h:121]     config: {"@type":"type.googleapis.com/envoy.extensions.filters.http.upstream_codec.v3.UpstreamCodec"}
[2022-11-02 16:14:00.614][4459372][debug][upstream] [external/envoy/source/common/upstream/upstream_impl.cc:438] transport socket match, socket default selected for host with address 127.0.0.1:10240
[2022-11-02 16:14:00.614][4459372][trace][upstream] [external/envoy/source/common/upstream/upstream_impl.cc:1742] Local locality: 
[2022-11-02 16:14:00.614][4459372][debug][upstream] [external/envoy/source/common/upstream/upstream_impl.cc:1414] initializing Primary cluster fake_remote completed
[2022-11-02 16:14:00.614][4459372][debug][init] [external/envoy/source/common/init/manager_impl.cc:49] init manager Cluster fake_remote contains no targets
[2022-11-02 16:14:00.614][4459372][debug][init] [external/envoy/source/common/init/watcher_impl.cc:14] init manager Cluster fake_remote initialized, notifying ClusterImplBase
[2022-11-02 16:14:00.615][4459372][debug][upstream] [external/envoy/source/common/upstream/cluster_manager_impl.cc:1100] adding TLS cluster fake_remote
[2022-11-02 16:14:00.615][4459372][debug][upstream] [external/envoy/source/common/upstream/cluster_manager_impl.cc:1178] membership update for TLS cluster fake_remote added 1 removed 0
[2022-11-02 16:14:00.615][4459372][trace][upstream] [external/envoy/source/common/upstream/cluster_discovery_manager.cc:35] cm cdm: starting processing cluster name fake_remote (status 2) from cluster lifecycle callback in main_thread
[2022-11-02 16:14:00.615][4459372][trace][upstream] [external/envoy/source/common/upstream/cluster_discovery_manager.cc:45] cm cdm: no callbacks for the cluster name fake_remote in main_thread
[2022-11-02 16:14:00.615][4459372][debug][upstream] [external/envoy/source/common/upstream/cluster_manager_impl.cc:149] cm init: init complete: cluster=fake_remote primary=0 secondary=0
[2022-11-02 16:14:00.615][4459372][debug][upstream] [external/envoy/source/common/upstream/cluster_manager_impl.cc:169] maybe finish initialize state: 0
[2022-11-02 16:14:00.615][4459372][debug][upstream] [external/envoy/source/common/upstream/cluster_manager_impl.cc:115] cm init: adding: cluster=fake_remote primary=0 secondary=0
[2022-11-02 16:14:00.615][4459372][debug][upstream] [external/envoy/source/common/upstream/cluster_manager_impl.cc:169] maybe finish initialize state: 1
[2022-11-02 16:14:00.615][4459372][debug][upstream] [external/envoy/source/common/upstream/cluster_manager_impl.cc:178] maybe finish initialize primary init clusters empty: true
[2022-11-02 16:14:00.615][4459372][info][config] [external/envoy/source/server/configuration_impl.cc:101] loading 2 listener(s)
[2022-11-02 16:14:00.615][4459372][debug][config] [external/envoy/source/server/configuration_impl.cc:103] listener #0:
[2022-11-02 16:14:00.617][4459372][debug][config] [external/envoy/source/server/listener_manager_impl.cc:439] begin add/update listener: name=fake_remote_listener hash=2249913797158891970
[2022-11-02 16:14:00.617][4459372][debug][config] [external/envoy/source/server/listener_manager_impl.cc:476] use full listener update path for listener name=fake_remote_listener hash=2249913797158891970
[2022-11-02 16:14:00.617][4459372][warning][config] [external/envoy/source/server/listener_impl.cc:1051] reuse_port was configured for TCP listener 'fake_remote_listener' and is being force disabled because Envoy is not running on Linux. See the documentation for more information.
[2022-11-02 16:14:00.617][4459372][debug][config] [external/envoy/source/server/listener_manager_impl.cc:88]   filter #0:
[2022-11-02 16:14:00.617][4459372][debug][config] [external/envoy/source/server/listener_manager_impl.cc:89]     name: envoy.filters.network.http_connection_manager
[2022-11-02 16:14:00.618][4459372][debug][config] [external/envoy/source/server/listener_manager_impl.cc:92]   config: {"@type":"type.googleapis.com/envoy.extensions.filters.network.http_connection_manager.v3.HttpConnectionManager","stat_prefix":"remote_hcm","http_filters":[{"typed_config":{"@type":"type.googleapis.com/envoy.extensions.filters.http.router.v3.Router"},"name":"envoy.router"}],"route_config":{"virtual_hosts":[{"routes":[{"direct_response":{"status":200},"match":{"prefix":"/"}}],"name":"remote_service","domains":["*"]}],"name":"remote_route"}}
[2022-11-02 16:14:00.625][4459372][debug][config] [external/envoy/source/common/http/filter_chain_helper.h:88]     http filter #0
[2022-11-02 16:14:00.627][4459372][debug][config] [external/envoy/source/common/http/filter_chain_helper.h:118]       name: envoy.router
[2022-11-02 16:14:00.627][4459372][debug][config] [external/envoy/source/common/http/filter_chain_helper.h:121]     config: {"@type":"type.googleapis.com/envoy.extensions.filters.http.router.v3.Router"}
[2022-11-02 16:14:00.628][4459372][debug][config] [external/envoy/source/server/filter_chain_manager_impl.cc:321] new fc_contexts has 1 filter chains, including 1 newly built
[2022-11-02 16:14:00.628][4459372][debug][init] [external/envoy/source/common/init/manager_impl.cc:24] added target Listener-init-target fake_remote_listener to init manager Server
[2022-11-02 16:14:00.628][4459372][debug][config] [external/envoy/source/server/listener_impl.cc:154] Create listen socket for listener fake_remote_listener on address 127.0.0.1:10240
[2022-11-02 16:14:00.628][4459372][debug][config] [external/envoy/source/server/listener_impl.cc:164] fake_remote_listener: Setting socket options succeeded
[2022-11-02 16:14:00.628][4459372][debug][config] [external/envoy/source/server/listener_impl.cc:107] Set listener fake_remote_listener socket factory local address to 127.0.0.1:10240
[2022-11-02 16:14:00.628][4459372][debug][config] [external/envoy/source/server/listener_impl.cc:933] add active listener: name=fake_remote_listener, hash=2249913797158891970, tag=1, address=127.0.0.1:10240
[2022-11-02 16:14:00.628][4459372][debug][config] [external/envoy/source/server/configuration_impl.cc:103] listener #1:
[2022-11-02 16:14:00.634][4459372][debug][config] [external/envoy/source/common/http/filter_chain_helper.h:88]     http filter #0
[2022-11-02 16:14:00.635][4459372][debug][config] [external/envoy/source/common/http/filter_chain_helper.h:118]       name: envoy.filters.http.platform_bridge
[2022-11-02 16:14:00.635][4459372][debug][config] [external/envoy/source/common/http/filter_chain_helper.h:121]     config: {"@type":"type.googleapis.com/envoymobile.extensions.filters.http.platform_bridge.PlatformBridge","platform_filter_name":"reset_idle_test_filter"}
[2022-11-02 16:14:00.635][4459372][debug][config] [external/envoy/source/common/http/filter_chain_helper.h:88]     http filter #1
[2022-11-02 16:14:00.635][4459372][debug][config] [external/envoy/source/common/http/filter_chain_helper.h:118]       name: envoy.filters.http.local_error
[2022-11-02 16:14:00.635][4459372][debug][config] [external/envoy/source/common/http/filter_chain_helper.h:121]     config: {"@type":"type.googleapis.com/envoymobile.extensions.filters.http.local_error.LocalError"}
[2022-11-02 16:14:00.635][4459372][debug][config] [external/envoy/source/common/http/filter_chain_helper.h:88]     http filter #2
[2022-11-02 16:14:00.636][4459372][debug][config] [external/envoy/source/common/http/filter_chain_helper.h:118]       name: envoy.router
[2022-11-02 16:14:00.637][4459372][debug][config] [external/envoy/source/common/http/filter_chain_helper.h:121]     config: {"@type":"type.googleapis.com/envoy.extensions.filters.http.router.v3.Router"}
[2022-11-02 16:14:00.637][4459372][info][config] [external/envoy/source/server/configuration_impl.cc:113] loading stats configuration
[2022-11-02 16:14:00.637][4459372][debug][init] [external/envoy/source/common/init/manager_impl.cc:49] init manager RTDS contains no targets
[2022-11-02 16:14:00.637][4459372][debug][init] [external/envoy/source/common/init/watcher_impl.cc:14] init manager RTDS initialized, notifying RTDS
[2022-11-02 16:14:00.637][4459372][info][runtime] [external/envoy/source/common/runtime/runtime_impl.cc:463] RTDS has finished initialization
[2022-11-02 16:14:00.637][4459372][debug][upstream] [external/envoy/source/common/upstream/cluster_manager_impl.cc:244] continue initializing secondary clusters
[2022-11-02 16:14:00.637][4459372][debug][upstream] [external/envoy/source/common/upstream/cluster_manager_impl.cc:169] maybe finish initialize state: 2
[2022-11-02 16:14:00.637][4459372][debug][upstream] [external/envoy/source/common/upstream/cluster_manager_impl.cc:178] maybe finish initialize primary init clusters empty: true
[2022-11-02 16:14:00.637][4459372][debug][upstream] [external/envoy/source/common/upstream/cluster_manager_impl.cc:193] maybe finish initialize secondary init clusters empty: true
[2022-11-02 16:14:00.637][4459372][debug][upstream] [external/envoy/source/common/upstream/cluster_manager_impl.cc:220] maybe finish initialize cds api ready: false
[2022-11-02 16:14:00.637][4459372][info][upstream] [external/envoy/source/common/upstream/cluster_manager_impl.cc:226] cm init: all clusters initialized
[2022-11-02 16:14:00.637][4459372][warning][main] [external/envoy/source/server/server.cc:786] there is no configured limit to the number of allowed active connections. Set a limit via the runtime key overload.global_downstream_max_connections
[2022-11-02 16:14:00.637][4459372][info][main] [external/envoy/source/server/server.cc:888] all clusters initialized. initializing init manager
[2022-11-02 16:14:00.637][4459372][debug][init] [external/envoy/source/common/init/manager_impl.cc:53] init manager Server initializing
[2022-11-02 16:14:00.637][4459372][debug][init] [external/envoy/source/common/init/target_impl.cc:15] init manager Server initializing target Listener-init-target fake_remote_listener
[2022-11-02 16:14:00.637][4459372][debug][init] [external/envoy/source/common/init/manager_impl.cc:49] init manager Listener-local-init-manager fake_remote_listener 2249913797158891970 contains no targets
[2022-11-02 16:14:00.637][4459372][debug][init] [external/envoy/source/common/init/watcher_impl.cc:14] init manager Listener-local-init-manager fake_remote_listener 2249913797158891970 initialized, notifying Listener-local-init-watcher fake_remote_listener
[2022-11-02 16:14:00.637][4459372][debug][init] [external/envoy/source/common/init/watcher_impl.cc:14] target Listener-init-target fake_remote_listener initialized, notifying init manager Server
[2022-11-02 16:14:00.637][4459372][debug][init] [external/envoy/source/common/init/watcher_impl.cc:14] init manager Server initialized, notifying RunHelper
[2022-11-02 16:14:00.638][4459372][debug][main] [library/common/engine.cc:325] lo0,en0,utun10
[2022-11-02 16:14:00.638][4459372][debug][main] [library/common/engine.cc:325] lo0,anpi2,anpi0,anpi1,en0,awdl0,llw0,utun0,utun1,utun2,utun3,utun4,utun5,utun6,utun7,utun8,utun9
[2022-11-02 16:14:00.638][4459372][trace][misc] [external/envoy/source/common/event/scaled_range_timer_manager_impl.cc:60] enableTimer called on 0x600003c6d030 for 3600000ms, min is 3600000ms
[2022-11-02 16:14:00.639][4459372][info][config] [external/envoy/source/server/listener_manager_impl.cc:831] all dependencies initialized. starting workers
[2022-11-02 16:14:00.639][4459372][debug][config] [external/envoy/source/server/listener_manager_impl.cc:868] starting worker 0
[2022-11-02 16:14:00.639][4459399][debug][main] [external/envoy/source/server/worker_impl.cc:124] worker entering dispatch loop
[2022-11-02 16:14:00.639][4459399][debug][upstream] [external/envoy/source/common/upstream/cluster_manager_impl.cc:1100] adding TLS cluster fake_remote
[2022-11-02 16:14:00.640][4459399][debug][upstream] [external/envoy/source/common/upstream/cluster_manager_impl.cc:1178] membership update for TLS cluster fake_remote added 1 removed 0
[2022-11-02 16:14:00.640][4459399][trace][upstream] [external/envoy/source/common/upstream/cluster_discovery_manager.cc:35] cm cdm: starting processing cluster name fake_remote (status 2) from cluster lifecycle callback in worker_0
[2022-11-02 16:14:00.640][4459399][trace][upstream] [external/envoy/source/common/upstream/cluster_discovery_manager.cc:45] cm cdm: no callbacks for the cluster name fake_remote in worker_0
[2022-11-02 16:14:00.641][4459372][info][main] [external/envoy/source/server/server.cc:907] starting main dispatch loop
[2022-11-02 16:14:00.642][4459372][debug][http] [external/envoy/source/common/http/conn_manager_impl.cc:306] [C12345] new stream
[2022-11-02 16:14:00.642][4459372][trace][misc] [external/envoy/source/common/event/scaled_range_timer_manager_impl.cc:60] enableTimer called on 0x600003c65960 for 500ms, min is 500ms
[2022-11-02 16:14:00.642][4459372][debug][http] [library/common/http/client.cc:466] [S0] start stream
[2022-11-02 16:14:00.642][4459372][debug][http] [library/common/http/client.cc:509] [S0] request headers for stream (end_stream=true):
':method', 'GET'
':scheme', 'https'
':path', '/test'
':authority', 'example.com'
'x-envoy-mobile-cluster', 'base_h2'
'x-forwarded-proto', 'https'

[2022-11-02 16:14:00.642][4459372][debug][http] [external/envoy/source/common/http/conn_manager_impl.cc:903] [C12345][S321636442676802358] request headers complete (end_stream=true):
':method', 'GET'
':scheme', 'https'
':path', '/test'
':authority', 'example.com'
'x-envoy-mobile-cluster', 'base_h2'
'x-forwarded-proto', 'https'

[2022-11-02 16:14:00.642][4459372][debug][http] [external/envoy/source/common/http/conn_manager_impl.cc:886] [C12345][S321636442676802358] request end stream
[2022-11-02 16:14:00.642][4459372][trace][filter] [library/common/extensions/filters/http/platform_bridge/filter.cc:89] PlatformBridgeFilter(reset_idle_test_filter)::PlatformBridgeFilter
[2022-11-02 16:14:00.642][4459372][trace][filter] [library/common/extensions/filters/http/platform_bridge/filter.cc:94] PlatformBridgeFilter(reset_idle_test_filter)->init_filter
[2022-11-02 16:14:00.643][4459372][trace][filter] [library/common/extensions/filters/http/platform_bridge/filter.cc:124] PlatformBridgeFilter(reset_idle_test_filter)::setDecoderCallbacks
[2022-11-02 16:14:00.643][4459372][trace][filter] [library/common/extensions/filters/http/platform_bridge/filter.cc:146] PlatformBridgeFilter(reset_idle_test_filter)::setEncoderCallbacks
[2022-11-02 16:14:00.643][4459372][trace][filter] [library/common/extensions/filters/http/platform_bridge/filter.cc:160] PlatformBridgeFilter(reset_idle_test_filter)->set_response_callbacks
[2022-11-02 16:14:00.643][4459372][trace][filter] [library/common/extensions/filters/http/platform_bridge/filter.cc:522] PlatformBridgeFilter(reset_idle_test_filter)::decodeHeaders(end_stream:true)
[2022-11-02 16:14:00.643][4459372][trace][http] [external/envoy/source/common/http/filter_manager.cc:537] [C12345][S321636442676802358] decode headers called: filter=envoy.filters.http.platform_bridge status=0
[2022-11-02 16:14:00.643][4459372][trace][http] [external/envoy/source/common/http/filter_manager.cc:537] [C12345][S321636442676802358] decode headers called: filter=envoy.filters.http.local_error status=0
[2022-11-02 16:14:00.643][4459372][debug][router] [external/envoy/source/common/router/router.cc:470] [C12345][S321636442676802358] cluster 'fake_remote' match for URL '/test'
[2022-11-02 16:14:00.643][4459372][debug][router] [external/envoy/source/common/router/router.cc:678] [C12345][S321636442676802358] router decoding headers:
':method', 'GET'
':scheme', 'https'
':path', '/test'
':authority', 'example.com'
'x-envoy-mobile-cluster', 'base_h2'
'x-forwarded-proto', 'https'
'x-envoy-expected-rq-timeout-ms', '15000'

[2022-11-02 16:14:00.644][4459372][debug][pool] [external/envoy/source/common/http/conn_pool_base.cc:78] queueing stream due to no available connections (ready=0 busy=0 connecting=0)
[2022-11-02 16:14:00.644][4459372][debug][pool] [external/envoy/source/common/conn_pool/conn_pool_base.cc:290] trying to create new connection
[2022-11-02 16:14:00.644][4459372][trace][pool] [external/envoy/source/common/conn_pool/conn_pool_base.cc:291] ConnPoolImplBase 0x124d38a40, ready_clients_.size(): 0, busy_clients_.size(): 0, connecting_clients_.size(): 0, connecting_stream_capacity_: 0, num_active_streams_: 0, pending_streams_.size(): 1 per upstream preconnect ratio: 1
[2022-11-02 16:14:00.644][4459372][debug][pool] [external/envoy/source/common/conn_pool/conn_pool_base.cc:145] creating a new connection (connecting=0)
[2022-11-02 16:14:00.644][4459372][debug][connection] [external/envoy/source/common/network/connection_impl.h:92] [C0] current connecting state: true
[2022-11-02 16:14:00.644][4459372][debug][client] [external/envoy/source/common/http/codec_client.cc:57] [C0] connecting
[2022-11-02 16:14:00.644][4459372][debug][connection] [external/envoy/source/common/network/connection_impl.cc:924] [C0] connecting to 127.0.0.1:10240
[2022-11-02 16:14:00.644][4459372][debug][connection] [external/envoy/source/common/network/connection_impl.cc:943] [C0] connection in progress
[2022-11-02 16:14:00.644][4459372][trace][pool] [external/envoy/source/common/conn_pool/conn_pool_base.cc:131] not creating a new connection, shouldCreateNewConnection returned false.
[2022-11-02 16:14:00.644][4459372][trace][http] [external/envoy/source/common/http/filter_manager.cc:537] [C12345][S321636442676802358] decode headers called: filter=envoy.filters.http.upstream_codec status=4
[2022-11-02 16:14:00.644][4459372][trace][http] [external/envoy/source/common/http/filter_manager.cc:537] [C12345][S321636442676802358] decode headers called: filter=envoy.router status=1
[2022-11-02 16:14:00.644][4459372][trace][misc] [external/envoy/source/common/event/scaled_range_timer_manager_impl.cc:60] enableTimer called on 0x600003c65960 for 500ms, min is 500ms
[2022-11-02 16:14:00.644][4459372][warning][upstream] [library/common/network/connectivity_manager.cc:278] base_dns_cache
[2022-11-02 16:14:00.644][4459372][trace][connection] [external/envoy/source/common/network/connection_impl.cc:563] [C0] socket event: 2
[2022-11-02 16:14:00.644][4459372][trace][connection] [external/envoy/source/common/network/connection_impl.cc:674] [C0] write ready
[2022-11-02 16:14:00.645][4459372][debug][connection] [external/envoy/source/common/network/connection_impl.cc:683] [C0] connected
[2022-11-02 16:14:00.645][4459372][trace][connection] [external/envoy/source/common/network/connection_impl.cc:418] [C0] raising connection event 2
[2022-11-02 16:14:00.645][4459399][trace][misc] [external/envoy/source/common/event/scaled_range_timer_manager_impl.cc:60] enableTimer called on 0x600003c68460 for 3600000ms, min is 3600000ms
[2022-11-02 16:14:00.645][4459372][debug][client] [external/envoy/source/common/http/codec_client.cc:88] [C0] connected
[2022-11-02 16:14:00.645][4459399][debug][conn_handler] [external/envoy/source/server/active_tcp_listener.cc:147] [C1] new connection from 127.0.0.1:53650
[2022-11-02 16:14:00.645][4459399][trace][connection] [external/envoy/source/common/network/connection_impl.cc:563] [C1] socket event: 2
[2022-11-02 16:14:00.645][4459399][trace][connection] [external/envoy/source/common/network/connection_impl.cc:674] [C1] write ready
[2022-11-02 16:14:00.645][4459372][debug][pool] [external/envoy/source/common/conn_pool/conn_pool_base.cc:327] [C0] attaching to next stream
[2022-11-02 16:14:00.645][4459372][debug][pool] [external/envoy/source/common/conn_pool/conn_pool_base.cc:181] [C0] creating stream
[2022-11-02 16:14:00.645][4459372][debug][router] [external/envoy/source/common/router/upstream_request.cc:564] [C12345][S321636442676802358] pool ready
[2022-11-02 16:14:00.645][4459372][trace][router] [external/envoy/source/common/router/upstream_codec_filter.cc:61] [C12345][S321636442676802358] proxying headers
[2022-11-02 16:14:00.645][4459372][trace][connection] [external/envoy/source/common/network/connection_impl.cc:478] [C0] writing 139 bytes, end_stream false
[2022-11-02 16:14:00.645][4459372][debug][client] [external/envoy/source/common/http/codec_client.cc:139] [C0] encode complete
[2022-11-02 16:14:00.645][4459372][trace][http] [external/envoy/source/common/http/filter_manager.cc:69] [C12345][S321636442676802358] continuing filter chain: filter=0x600002564870
[2022-11-02 16:14:00.645][4459372][trace][connection] [external/envoy/source/common/network/connection_impl.cc:674] [C0] write ready
[2022-11-02 16:14:00.645][4459399][trace][connection] [external/envoy/source/common/network/connection_impl.cc:563] [C1] socket event: 1
[2022-11-02 16:14:00.645][4459399][trace][connection] [external/envoy/source/common/network/connection_impl.cc:603] [C1] read ready. dispatch_buffered_data=0
[2022-11-02 16:14:00.645][4459372][trace][connection] [external/envoy/source/common/network/raw_buffer_socket.cc:67] [C0] write returns: 139
[2022-11-02 16:14:00.645][4459372][trace][connection] [external/envoy/source/common/network/connection_impl.cc:563] [C0] socket event: 2
[2022-11-02 16:14:00.645][4459372][trace][connection] [external/envoy/source/common/network/connection_impl.cc:674] [C0] write ready
[2022-11-02 16:14:00.645][4459399][trace][connection] [external/envoy/source/common/network/raw_buffer_socket.cc:24] [C1] read returns: 139
[2022-11-02 16:14:00.645][4459399][trace][connection] [external/envoy/source/common/network/raw_buffer_socket.cc:38] [C1] read error: Resource temporarily unavailable
[2022-11-02 16:14:00.645][4459399][trace][http] [external/envoy/source/common/http/http1/codec_impl.cc:624] [C1] parsing 139 bytes
[2022-11-02 16:14:00.645][4459399][trace][http] [external/envoy/source/common/http/http1/codec_impl.cc:566] [C1] message begin
[2022-11-02 16:14:00.645][4459399][debug][http] [external/envoy/source/common/http/conn_manager_impl.cc:306] [C1] new stream
[2022-11-02 16:14:00.645][4459399][trace][misc] [external/envoy/source/common/event/scaled_range_timer_manager_impl.cc:60] enableTimer called on 0x600003c6cf50 for 300000ms, min is 300000ms
[2022-11-02 16:14:00.645][4459399][trace][http] [external/envoy/source/common/http/http1/codec_impl.cc:523] [C1] completed header: key=host value=example.com
[2022-11-02 16:14:00.645][4459399][trace][http] [external/envoy/source/common/http/http1/codec_impl.cc:523] [C1] completed header: key=x-envoy-mobile-cluster value=base_h2
[2022-11-02 16:14:00.645][4459399][trace][http] [external/envoy/source/common/http/http1/codec_impl.cc:523] [C1] completed header: key=x-forwarded-proto value=https
[2022-11-02 16:14:00.645][4459399][trace][http] [external/envoy/source/common/http/http1/codec_impl.cc:816] [C1] onHeadersCompleteBase
[2022-11-02 16:14:00.645][4459399][trace][http] [external/envoy/source/common/http/http1/codec_impl.cc:523] [C1] completed header: key=x-envoy-expected-rq-timeout-ms value=15000
[2022-11-02 16:14:00.645][4459399][trace][http] [external/envoy/source/common/http/http1/codec_impl.cc:1133] [C1] Server: onHeadersComplete size=4
[2022-11-02 16:14:00.645][4459399][trace][http] [external/envoy/source/common/http/http1/codec_impl.cc:920] [C1] message complete
[2022-11-02 16:14:00.645][4459399][debug][http] [external/envoy/source/common/http/conn_manager_impl.cc:903] [C1][S215271032749052718] request headers complete (end_stream=true):
':authority', 'example.com'
':path', '/test'
':method', 'GET'
'x-envoy-mobile-cluster', 'base_h2'
'x-forwarded-proto', 'https'
'x-envoy-expected-rq-timeout-ms', '15000'

[2022-11-02 16:14:00.645][4459399][debug][http] [external/envoy/source/common/http/conn_manager_impl.cc:886] [C1][S215271032749052718] request end stream
[2022-11-02 16:14:00.646][4459399][debug][connection] [external/envoy/source/common/network/connection_impl.h:92] [C1] current connecting state: false
[2022-11-02 16:14:00.646][4459399][debug][http] [external/envoy/source/common/http/filter_manager.cc:905] [C1][S215271032749052718] Sending local reply with details direct_response
[2022-11-02 16:14:00.646][4459399][trace][misc] [external/envoy/source/common/event/scaled_range_timer_manager_impl.cc:60] enableTimer called on 0x600003c6cf50 for 300000ms, min is 300000ms
[2022-11-02 16:14:00.646][4459399][debug][http] [external/envoy/source/common/http/conn_manager_impl.cc:1524] [C1][S215271032749052718] encoding headers via codec (end_stream=true):
':status', '200'
'date', 'Wed, 02 Nov 2022 20:14:00 GMT'
'server', 'envoy'

[2022-11-02 16:14:00.646][4459399][trace][connection] [external/envoy/source/common/network/connection_impl.cc:478] [C1] writing 90 bytes, end_stream false
[2022-11-02 16:14:00.646][4459399][trace][main] [external/envoy/source/common/event/dispatcher_impl.cc:250] item added to deferred deletion list (size=1)
[2022-11-02 16:14:00.646][4459399][trace][main] [external/envoy/source/common/event/dispatcher_impl.cc:250] item added to deferred deletion list (size=2)
[2022-11-02 16:14:00.646][4459399][trace][misc] [external/envoy/source/common/event/scaled_range_timer_manager_impl.cc:60] enableTimer called on 0x600003c68460 for 3600000ms, min is 3600000ms
[2022-11-02 16:14:00.646][4459399][trace][http] [external/envoy/source/common/http/filter_manager.cc:527] [C1][S215271032749052718] decodeHeaders filter iteration aborted due to local reply: filter=envoy.router
[2022-11-02 16:14:00.646][4459399][trace][http] [external/envoy/source/common/http/filter_manager.cc:537] [C1][S215271032749052718] decode headers called: filter=envoy.router status=1
[2022-11-02 16:14:00.646][4459399][trace][http] [external/envoy/source/common/http/http1/codec_impl.cc:674] [C1] parsed 139 bytes
[2022-11-02 16:14:00.646][4459399][trace][main] [external/envoy/source/common/event/dispatcher_impl.cc:125] clearing deferred deletion list (size=2)
[2022-11-02 16:14:00.646][4459399][trace][connection] [external/envoy/source/common/network/connection_impl.cc:563] [C1] socket event: 2
[2022-11-02 16:14:00.646][4459399][trace][connection] [external/envoy/source/common/network/connection_impl.cc:674] [C1] write ready
[2022-11-02 16:14:00.646][4459399][trace][connection] [external/envoy/source/common/network/raw_buffer_socket.cc:67] [C1] write returns: 90
[2022-11-02 16:14:00.646][4459372][trace][connection] [external/envoy/source/common/network/connection_impl.cc:563] [C0] socket event: 1
[2022-11-02 16:14:00.646][4459399][trace][connection] [external/envoy/source/common/network/connection_impl.cc:563] [C1] socket event: 2
[2022-11-02 16:14:00.646][4459372][trace][connection] [external/envoy/source/common/network/connection_impl.cc:603] [C0] read ready. dispatch_buffered_data=0
[2022-11-02 16:14:00.646][4459399][trace][connection] [external/envoy/source/common/network/connection_impl.cc:674] [C1] write ready
[2022-11-02 16:14:00.646][4459372][trace][connection] [external/envoy/source/common/network/raw_buffer_socket.cc:24] [C0] read returns: 90
[2022-11-02 16:14:00.646][4459372][trace][connection] [external/envoy/source/common/network/raw_buffer_socket.cc:38] [C0] read error: Resource temporarily unavailable
[2022-11-02 16:14:00.646][4459372][trace][http] [external/envoy/source/common/http/http1/codec_impl.cc:624] [C0] parsing 90 bytes
[2022-11-02 16:14:00.646][4459372][trace][http] [external/envoy/source/common/http/http1/codec_impl.cc:566] [C0] message begin
[2022-11-02 16:14:00.646][4459372][trace][http] [external/envoy/source/common/http/http1/codec_impl.cc:523] [C0] completed header: key=date value=Wed, 02 Nov 2022 20:14:00 GMT
[2022-11-02 16:14:00.646][4459372][trace][http] [external/envoy/source/common/http/http1/codec_impl.cc:523] [C0] completed header: key=server value=envoy
[2022-11-02 16:14:00.646][4459372][trace][http] [external/envoy/source/common/http/http1/codec_impl.cc:816] [C0] onHeadersCompleteBase
[2022-11-02 16:14:00.646][4459372][trace][http] [external/envoy/source/common/http/http1/codec_impl.cc:523] [C0] completed header: key=content-length value=0
[2022-11-02 16:14:00.646][4459372][trace][http] [external/envoy/source/common/http/http1/codec_impl.cc:1399] [C0] status_code 200
[2022-11-02 16:14:00.646][4459372][trace][http] [external/envoy/source/common/http/http1/codec_impl.cc:1409] [C0] Client: onHeadersComplete size=3
[2022-11-02 16:14:00.646][4459372][trace][http] [external/envoy/source/common/http/http1/codec_impl.cc:920] [C0] message complete
[2022-11-02 16:14:00.646][4459372][trace][http] [external/envoy/source/common/http/http1/codec_impl.cc:1480] [C0] message complete
[2022-11-02 16:14:00.646][4459372][debug][client] [external/envoy/source/common/http/codec_client.cc:126] [C0] response complete
[2022-11-02 16:14:00.646][4459372][trace][main] [external/envoy/source/common/event/dispatcher_impl.cc:250] item added to deferred deletion list (size=1)
[2022-11-02 16:14:00.646][4459372][trace][router] [external/envoy/source/common/router/upstream_request.cc:221] [C12345][S321636442676802358] upstream response headers:
':status', '200'
'date', 'Wed, 02 Nov 2022 20:14:00 GMT'
'server', 'envoy'
'content-length', '0'

[2022-11-02 16:14:00.646][4459372][debug][router] [external/envoy/source/common/router/router.cc:1365] [C12345][S321636442676802358] upstream headers complete: end_stream=true
[2022-11-02 16:14:00.647][4459372][trace][main] [external/envoy/source/common/event/dispatcher_impl.cc:250] item added to deferred deletion list (size=2)
[2022-11-02 16:14:00.647][4459372][trace][main] [external/envoy/source/common/event/dispatcher_impl.cc:250] item added to deferred deletion list (size=3)
[2022-11-02 16:14:00.647][4459372][trace][misc] [external/envoy/source/common/event/scaled_range_timer_manager_impl.cc:60] enableTimer called on 0x600003c65960 for 500ms, min is 500ms
[2022-11-02 16:14:00.647][4459372][trace][http] [external/envoy/source/common/http/filter_manager.cc:1065] [C12345][S321636442676802358] encode headers called: filter=envoy.filters.http.local_error status=0
[2022-11-02 16:14:00.647][4459372][trace][filter] [library/common/extensions/filters/http/platform_bridge/filter.cc:531] PlatformBridgeFilter(reset_idle_test_filter)::encodeHeaders(end_stream:true)
[2022-11-02 16:14:00.647][4459372][trace][filter] [library/common/extensions/filters/http/platform_bridge/filter.cc:298] PlatformBridgeFilter(reset_idle_test_filter)->on_response_headers
[2022-11-02 16:14:00.647][4459372][trace][http] [external/envoy/source/common/http/filter_manager.cc:1065] [C12345][S321636442676802358] encode headers called: filter=envoy.filters.http.platform_bridge status=1
[2022-11-02 16:14:00.647][4459372][debug][pool] [external/envoy/source/common/http/http1/conn_pool.cc:53] [C0] response complete
[2022-11-02 16:14:00.647][4459372][debug][pool] [external/envoy/source/common/conn_pool/conn_pool_base.cc:214] [C0] destroying stream: 0 remaining
[2022-11-02 16:14:00.647][4459372][trace][http] [external/envoy/source/common/http/http1/codec_impl.cc:674] [C0] parsed 90 bytes
[2022-11-02 16:14:00.647][4459372][trace][main] [external/envoy/source/common/event/dispatcher_impl.cc:125] clearing deferred deletion list (size=3)
[2022-11-02 16:14:01.148][4459372][trace][misc] [external/envoy/source/common/event/scaled_range_timer_manager_impl.cc:119] min timer complete for 0x600003c65960
[2022-11-02 16:14:01.148][4459372][trace][misc] [external/envoy/source/common/event/scaled_range_timer_manager_impl.cc:82] RangeTimerImpl triggered: 0x600003c65960
[2022-11-02 16:14:01.148][4459372][trace][filter] [library/common/extensions/filters/http/platform_bridge/filter.cc:222] PlatformBridgeFilter(reset_idle_test_filter)::onLocalReply
[2022-11-02 16:14:01.149][4459372][trace][filter] [library/common/extensions/filters/http/local_error/filter.cc:12] LocalErrorFilter::onLocalReply(504, stream_idle_timeout)
[2022-11-02 16:14:01.149][4459372][debug][http] [external/envoy/source/common/http/filter_manager.cc:871] [C12345][S321636442676802358] Resetting stream due to stream_idle_timeout. onLocalReply requested reset.
[2022-11-02 16:14:01.149][4459372][debug][http] [external/envoy/source/common/http/conn_manager_impl.cc:212] [C12345][S321636442676802358] doEndStream() resetting stream
[2022-11-02 16:14:01.149][4459372][debug][http] [external/envoy/source/common/http/conn_manager_impl.cc:1577] [C12345][S321636442676802358] stream reset
[2022-11-02 16:14:01.149][4459372][trace][filter] [library/common/extensions/filters/http/platform_bridge/filter.cc:167] PlatformBridgeFilter(reset_idle_test_filter)::onDestroy
[2022-11-02 16:14:01.149][4459372][trace][filter] [library/common/extensions/filters/http/platform_bridge/filter.cc:174] PlatformBridgeFilter(reset_idle_test_filter)->on_error
2022-11-02 16:14:01.149 xctest[49669:4459372] *** Assertion failure in -[XCTestExpectation fulfill], XCTestExpectation.m:98
[2022-11-02 16:14:01.149][4459372][critical][main] [external/envoy/source/exe/terminate_handler.cc:12] std::terminate called! (possible uncaught exception, see trace)
[2022-11-02 16:14:01.149][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:91] Backtrace (use tools/stack_decode.py to get line numbers):
[2022-11-02 16:14:01.149][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:92] Envoy version: b54adf9717759b92e4e734118d2fed3102e3a36b/1.25.0-dev/Library/DEBUG/BoringSSL
[2022-11-02 16:14:01.151][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #0: Envoy::TerminateHandler::logOnTerminate()::$_0::operator()() [0x1488383c0]
[2022-11-02 16:14:01.152][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #1: Envoy::TerminateHandler::logOnTerminate()::$_0::__invoke() [0x14883821c]
[2022-11-02 16:14:01.152][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #2: std::__terminate() [0x18023a570]
[2022-11-02 16:14:01.152][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #3: __cxa_get_exception_ptr [0x18023cd48]
[2022-11-02 16:14:01.152][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #4: __cxxabiv1::exception_cleanup_func() [0x18023cd08]
[2022-11-02 16:14:01.152][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #5: objc_exception_throw [0x18005144c]
[2022-11-02 16:14:01.152][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #6: _userInfoForFileAndLine [0x180b11f88]
[2022-11-02 16:14:01.152][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #7: -[XCTestExpectation fulfill] [0x104ec5198]
[2022-11-02 16:14:01.153][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #8: $s023test_swift_integration_A4_lib16IdleTimeoutTestsC0aeF0yyF0eF16ValidationFilterL_C7onError_11streamIntely5Envoy0nK0C_AI011FinalStreamM0CtF [0x14b20366c]
[2022-11-02 16:14:01.154][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #9: $s023test_swift_integration_A4_lib16IdleTimeoutTestsC0aeF0yyF0eF16ValidationFilterL_C5Envoy08ResponseI0AagHP7onError_11streamIntelyAG0jM0C_AG011FinalStreamO0CtFTW [0x14b2038fc]
[2022-11-02 16:14:01.156][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #10: $sSo15EnvoyHTTPFilterC0A0E6filterAbC6Filter_p_tcfcys6UInt64V_SSs5Int32VSo18envoy_stream_intelaSo0g7_final_h1_I0atcfU5_ [0x14b246138]
[2022-11-02 16:14:01.157][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #11: $sSo15EnvoyHTTPFilterC0A0E6filterAbC6Filter_p_tcfcys6UInt64V_SSs5Int32VSo18envoy_stream_intelaSo0g7_final_h1_I0atcfU5_TA [0x14b247d14]
[2022-11-02 16:14:01.158][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #12: $ss6UInt64VSSs5Int32VSo18envoy_stream_intelaSo0c7_final_d1_E0aIegygyyy_ABSo8NSStringCAdfHIeyByyyyy_TR [0x14b23eda8]
[2022-11-02 16:14:01.159][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #13: ios_http_filter_on_error [0x14c0b7f98]
[2022-11-02 16:14:01.160][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #14: Envoy::Extensions::HttpFilters::PlatformBridge::PlatformBridgeFilter::onDestroy() [0x14a2799d8]
[2022-11-02 16:14:01.162][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #15: Envoy::Http::FilterManager::destroyFilters() [0x148c32728]
[2022-11-02 16:14:01.163][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #16: Envoy::Http::ConnectionManagerImpl::doDeferredStreamDestroy() [0x148c31f4c]
[2022-11-02 16:14:01.164][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #17: Envoy::Http::ConnectionManagerImpl::ActiveStream::onResetStream() [0x148c38594]
[2022-11-02 16:14:01.165][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #18: Envoy::Http::StreamCallbackHelper::runResetCallbacks() [0x14884c714]
[2022-11-02 16:14:01.166][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #19: Envoy::Http::Client::DirectStream::resetStream() [0x14884c5f4]
[2022-11-02 16:14:01.168][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #20: Envoy::Http::ConnectionManagerImpl::doEndStream() [0x148c31ad8]
[2022-11-02 16:14:01.169][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #21: Envoy::Http::ConnectionManagerImpl::ActiveStream::resetStream() [0x148c4b6a0]
[2022-11-02 16:14:01.170][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #22: Envoy::Http::DownstreamFilterManager::sendLocalReply() [0x149e4c574]
[2022-11-02 16:14:01.172][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #23: Envoy::Http::ConnectionManagerImpl::ActiveStream::sendLocalReply() [0x148c3cc20]
[2022-11-02 16:14:01.173][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #24: Envoy::Http::ConnectionManagerImpl::ActiveStream::onIdleTimeout() [0x148c3cb40]
[2022-11-02 16:14:01.174][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #25: Envoy::Http::ConnectionManagerImpl::ActiveStream::ActiveStream()::$_3::operator()() [0x148c7673c]
[2022-11-02 16:14:01.176][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #26: _ZNSt3__1L8__invokeIRZN5Envoy4Http21ConnectionManagerImpl12ActiveStreamC1ERS3_jNS_10shared_ptrINS1_6Buffer19BufferMemoryAccountEEEE3$_3JEEEDTclscT_fp_spscT0_fp0_EEOSC_DpOSD_ [0x148c76700]
[2022-11-02 16:14:01.177][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #27: std::__1::__invoke_void_return_wrapper<>::__call<>() [0x148c766b8]
[2022-11-02 16:14:01.179][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #28: std::__1::__function::__alloc_func<>::operator()() [0x148c76690]
[2022-11-02 16:14:01.180][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #29: std::__1::__function::__func<>::operator()() [0x148c7523c]
[2022-11-02 16:14:01.181][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #30: std::__1::__function::__value_func<>::operator()() [0x147bc4f90]
Invalid connection: com.apple.coresymbolicationd
[2022-11-02 16:14:01.182][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #31: std::__1::function<>::operator()() [0x147bc4f24]
[2022-11-02 16:14:01.184][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #32: Envoy::Event::ScaledRangeTimerManagerImpl::RangeTimerImpl::trigger() [0x149a77f1c]
[2022-11-02 16:14:01.185][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #33: Envoy::Event::ScaledRangeTimerManagerImpl::onQueueTimerFired() [0x149a77460]
[2022-11-02 16:14:01.186][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #34: Envoy::Event::ScaledRangeTimerManagerImpl::Queue::Queue()::$_0::operator()() [0x149a848fc]
[2022-11-02 16:14:01.187][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #35: _ZNSt3__1L8__invokeIRZN5Envoy5Event27ScaledRangeTimerManagerImpl5QueueC1ENS_6chrono8durationIxNS_5ratioILl1ELl1000EEEEERS3_RNS2_10DispatcherEE3$_0JEEEDTclscT_fp_spscT0_fp0_EEOSF_DpOSG_ [0x149a848bc]
[2022-11-02 16:14:01.189][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #36: std::__1::__invoke_void_return_wrapper<>::__call<>() [0x149a84874]
[2022-11-02 16:14:01.190][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #37: std::__1::__function::__alloc_func<>::operator()() [0x149a8484c]
[2022-11-02 16:14:01.191][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #38: std::__1::__function::__func<>::operator()() [0x149a833ec]
[2022-11-02 16:14:01.192][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #39: std::__1::__function::__value_func<>::operator()() [0x147bc4f90]
[2022-11-02 16:14:01.193][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #40: std::__1::function<>::operator()() [0x147bc4f24]
[2022-11-02 16:14:01.194][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #41: Envoy::Event::DispatcherImpl::createTimerInternal()::$_7::operator()() [0x149a67cbc]
[2022-11-02 16:14:01.196][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #42: _ZNSt3__1L8__invokeIRZN5Envoy5Event14DispatcherImpl19createTimerInternalENS_8functionIFvvEEEE3$_7JEEEDTclscT_fp_spscT0_fp0_EEOS9_DpOSA_ [0x149a67c70]
[2022-11-02 16:14:01.197][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #43: std::__1::__invoke_void_return_wrapper<>::__call<>() [0x149a67c28]
[2022-11-02 16:14:01.198][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #44: std::__1::__function::__alloc_func<>::operator()() [0x149a67c00]
[2022-11-02 16:14:01.199][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #45: std::__1::__function::__func<>::operator()() [0x149a66778]
[2022-11-02 16:14:01.200][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #46: std::__1::__function::__value_func<>::operator()() [0x147bc4f90]
[2022-11-02 16:14:01.201][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #47: std::__1::function<>::operator()() [0x147bc4f24]
[2022-11-02 16:14:01.202][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #48: Envoy::Event::TimerImpl::TimerImpl()::$_0::operator()() [0x14a6d4374]
[2022-11-02 16:14:01.203][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #49: Envoy::Event::TimerImpl::TimerImpl()::$_0::__invoke() [0x14a6d4324]
[2022-11-02 16:14:01.204][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #50: event_process_active_single_queue [0x14b3e2d88]
[2022-11-02 16:14:01.205][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #51: event_process_active [0x14b3dd048]
[2022-11-02 16:14:01.206][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #52: event_base_loop [0x14b3dbe88]
[2022-11-02 16:14:01.207][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #53: Envoy::Event::LibeventScheduler::run() [0x14a6cbc60]
[2022-11-02 16:14:01.209][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #54: Envoy::Event::DispatcherImpl::run() [0x149a42b74]
[2022-11-02 16:14:01.209][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #55: Envoy::Server::InstanceImpl::run() [0x147c4e728]
[2022-11-02 16:14:01.210][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #56: Envoy::MainCommonBase::run() [0x147a99900]
[2022-11-02 16:14:01.211][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #57: Envoy::EngineCommon::run() [0x147a04b2c]
[2022-11-02 16:14:01.212][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #58: Envoy::Engine::main() [0x147a03e78]
[2022-11-02 16:14:01.213][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #59: _ZNSt3__1L8__invokeIMN5Envoy6EngineEF14envoy_status_tNS_12basic_stringIcNS_11char_traitsIcEENS_9allocatorIcEEEES9_S9_EPS2_JS9_S9_S9_EvEEDTcldsdescT0_fp0_fp_spscT1_fp1_EEOT_OSD_DpOSE_ [0x147a52310]
[2022-11-02 16:14:01.214][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #60: std::__1::__thread_execute<>() [0x147a52208]
[2022-11-02 16:14:01.214][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:104] Caught Abort trap: 6, suspect faulting address 0x1ae50fe60
[2022-11-02 16:14:01.214][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:91] Backtrace (use tools/stack_decode.py to get line numbers):
[2022-11-02 16:14:01.214][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:92] Envoy version: b54adf9717759b92e4e734118d2fed3102e3a36b/1.25.0-dev/Library/DEBUG/BoringSSL
[2022-11-02 16:14:01.215][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #0: Envoy::SignalAction::sigHandler() [0x14a6d7128]
[2022-11-02 16:14:01.215][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #1: _sigtramp [0x1ae557760]
[2022-11-02 16:14:01.215][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #2: pthread_kill [0x1ae5623c0]
[2022-11-02 16:14:01.215][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #3: abort [0x180129e38]
[2022-11-02 16:14:01.216][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #4: Envoy::TerminateHandler::logOnTerminate()::$_0::operator()() [0x1488383d0]
[2022-11-02 16:14:01.217][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #5: Envoy::TerminateHandler::logOnTerminate()::$_0::__invoke() [0x14883821c]
[2022-11-02 16:14:01.217][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #6: std::__terminate() [0x18023a570]
[2022-11-02 16:14:01.217][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #7: __cxa_get_exception_ptr [0x18023cd48]
[2022-11-02 16:14:01.217][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #8: __cxxabiv1::exception_cleanup_func() [0x18023cd08]
[2022-11-02 16:14:01.217][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #9: objc_exception_throw [0x18005144c]
[2022-11-02 16:14:01.217][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #10: _userInfoForFileAndLine [0x180b11f88]
[2022-11-02 16:14:01.217][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #11: -[XCTestExpectation fulfill] [0x104ec5198]
[2022-11-02 16:14:01.218][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #12: $s023test_swift_integration_A4_lib16IdleTimeoutTestsC0aeF0yyF0eF16ValidationFilterL_C7onError_11streamIntely5Envoy0nK0C_AI011FinalStreamM0CtF [0x14b20366c]
[2022-11-02 16:14:01.219][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #13: $s023test_swift_integration_A4_lib16IdleTimeoutTestsC0aeF0yyF0eF16ValidationFilterL_C5Envoy08ResponseI0AagHP7onError_11streamIntelyAG0jM0C_AG011FinalStreamO0CtFTW [0x14b2038fc]
[2022-11-02 16:14:01.220][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #14: $sSo15EnvoyHTTPFilterC0A0E6filterAbC6Filter_p_tcfcys6UInt64V_SSs5Int32VSo18envoy_stream_intelaSo0g7_final_h1_I0atcfU5_ [0x14b246138]
[2022-11-02 16:14:01.221][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #15: $sSo15EnvoyHTTPFilterC0A0E6filterAbC6Filter_p_tcfcys6UInt64V_SSs5Int32VSo18envoy_stream_intelaSo0g7_final_h1_I0atcfU5_TA [0x14b247d14]
[2022-11-02 16:14:01.222][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #16: $ss6UInt64VSSs5Int32VSo18envoy_stream_intelaSo0c7_final_d1_E0aIegygyyy_ABSo8NSStringCAdfHIeyByyyyy_TR [0x14b23eda8]
[2022-11-02 16:14:01.223][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #17: ios_http_filter_on_error [0x14c0b7f98]
[2022-11-02 16:14:01.224][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #18: Envoy::Extensions::HttpFilters::PlatformBridge::PlatformBridgeFilter::onDestroy() [0x14a2799d8]
[2022-11-02 16:14:01.225][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #19: Envoy::Http::FilterManager::destroyFilters() [0x148c32728]
[2022-11-02 16:14:01.225][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #20: Envoy::Http::ConnectionManagerImpl::doDeferredStreamDestroy() [0x148c31f4c]
[2022-11-02 16:14:01.226][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #21: Envoy::Http::ConnectionManagerImpl::ActiveStream::onResetStream() [0x148c38594]
[2022-11-02 16:14:01.227][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #22: Envoy::Http::StreamCallbackHelper::runResetCallbacks() [0x14884c714]
[2022-11-02 16:14:01.228][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #23: Envoy::Http::Client::DirectStream::resetStream() [0x14884c5f4]
[2022-11-02 16:14:01.229][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #24: Envoy::Http::ConnectionManagerImpl::doEndStream() [0x148c31ad8]
[2022-11-02 16:14:01.230][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #25: Envoy::Http::ConnectionManagerImpl::ActiveStream::resetStream() [0x148c4b6a0]
[2022-11-02 16:14:01.231][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #26: Envoy::Http::DownstreamFilterManager::sendLocalReply() [0x149e4c574]
[2022-11-02 16:14:01.232][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #27: Envoy::Http::ConnectionManagerImpl::ActiveStream::sendLocalReply() [0x148c3cc20]
[2022-11-02 16:14:01.233][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #28: Envoy::Http::ConnectionManagerImpl::ActiveStream::onIdleTimeout() [0x148c3cb40]
[2022-11-02 16:14:01.233][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #29: Envoy::Http::ConnectionManagerImpl::ActiveStream::ActiveStream()::$_3::operator()() [0x148c7673c]
[2022-11-02 16:14:01.234][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #30: _ZNSt3__1L8__invokeIRZN5Envoy4Http21ConnectionManagerImpl12ActiveStreamC1ERS3_jNS_10shared_ptrINS1_6Buffer19BufferMemoryAccountEEEE3$_3JEEEDTclscT_fp_spscT0_fp0_EEOSC_DpOSD_ [0x148c76700]
[2022-11-02 16:14:01.235][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #31: std::__1::__invoke_void_return_wrapper<>::__call<>() [0x148c766b8]
[2022-11-02 16:14:01.236][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #32: std::__1::__function::__alloc_func<>::operator()() [0x148c76690]
[2022-11-02 16:14:01.237][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #33: std::__1::__function::__func<>::operator()() [0x148c7523c]
[2022-11-02 16:14:01.238][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #34: std::__1::__function::__value_func<>::operator()() [0x147bc4f90]
[2022-11-02 16:14:01.239][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #35: std::__1::function<>::operator()() [0x147bc4f24]
[2022-11-02 16:14:01.239][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #36: Envoy::Event::ScaledRangeTimerManagerImpl::RangeTimerImpl::trigger() [0x149a77f1c]
[2022-11-02 16:14:01.240][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #37: Envoy::Event::ScaledRangeTimerManagerImpl::onQueueTimerFired() [0x149a77460]
[2022-11-02 16:14:01.241][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #38: Envoy::Event::ScaledRangeTimerManagerImpl::Queue::Queue()::$_0::operator()() [0x149a848fc]
[2022-11-02 16:14:01.242][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #39: _ZNSt3__1L8__invokeIRZN5Envoy5Event27ScaledRangeTimerManagerImpl5QueueC1ENS_6chrono8durationIxNS_5ratioILl1ELl1000EEEEERS3_RNS2_10DispatcherEE3$_0JEEEDTclscT_fp_spscT0_fp0_EEOSF_DpOSG_ [0x149a848bc]
[2022-11-02 16:14:01.243][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #40: std::__1::__invoke_void_return_wrapper<>::__call<>() [0x149a84874]
[2022-11-02 16:14:01.244][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #41: std::__1::__function::__alloc_func<>::operator()() [0x149a8484c]
[2022-11-02 16:14:01.245][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #42: std::__1::__function::__func<>::operator()() [0x149a833ec]
[2022-11-02 16:14:01.246][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #43: std::__1::__function::__value_func<>::operator()() [0x147bc4f90]
[2022-11-02 16:14:01.246][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #44: std::__1::function<>::operator()() [0x147bc4f24]
[2022-11-02 16:14:01.247][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #45: Envoy::Event::DispatcherImpl::createTimerInternal()::$_7::operator()() [0x149a67cbc]
[2022-11-02 16:14:01.248][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #46: _ZNSt3__1L8__invokeIRZN5Envoy5Event14DispatcherImpl19createTimerInternalENS_8functionIFvvEEEE3$_7JEEEDTclscT_fp_spscT0_fp0_EEOS9_DpOSA_ [0x149a67c70]
[2022-11-02 16:14:01.249][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #47: std::__1::__invoke_void_return_wrapper<>::__call<>() [0x149a67c28]
[2022-11-02 16:14:01.250][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #48: std::__1::__function::__alloc_func<>::operator()() [0x149a67c00]
[2022-11-02 16:14:01.251][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #49: std::__1::__function::__func<>::operator()() [0x149a66778]
[2022-11-02 16:14:01.252][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #50: std::__1::__function::__value_func<>::operator()() [0x147bc4f90]
[2022-11-02 16:14:01.253][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #51: std::__1::function<>::operator()() [0x147bc4f24]
[2022-11-02 16:14:01.254][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #52: Envoy::Event::TimerImpl::TimerImpl()::$_0::operator()() [0x14a6d4374]
[2022-11-02 16:14:01.254][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #53: Envoy::Event::TimerImpl::TimerImpl()::$_0::__invoke() [0x14a6d4324]
[2022-11-02 16:14:01.255][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #54: event_process_active_single_queue [0x14b3e2d88]
[2022-11-02 16:14:01.256][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #55: event_process_active [0x14b3dd048]
[2022-11-02 16:14:01.257][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #56: event_base_loop [0x14b3dbe88]
[2022-11-02 16:14:01.258][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #57: Envoy::Event::LibeventScheduler::run() [0x14a6cbc60]
[2022-11-02 16:14:01.259][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #58: Envoy::Event::DispatcherImpl::run() [0x149a42b74]
[2022-11-02 16:14:01.260][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #59: Envoy::Server::InstanceImpl::run() [0x147c4e728]
[2022-11-02 16:14:01.261][4459372][critical][backtrace] [external/envoy/source/server/backtrace.h:96] #60: Envoy::MainCommonBase::run() [0x147a99900]
Child process terminated with signal 6: Abort trap
2022-11-02 20:14:01,347 Deleting simulator D7D45025-7A82-4C32-9002-BD4F9D80F943 asynchronously.
2022-11-02 20:14:01,351 Done.

@Augustyniak
Copy-paste Alyssa's fix
4fc0f22 
Signed-off-by: Rafal Augustyniak <raugustyniak@lyft.com>
@Augustyniak
Copy link
Contributor

Copy-pasted @alyssawilk's fix from #2657 in 4fc0f22

alyssawilk
alyssawilk approved these changes Nov 2, 2022
View reviewed changes
Copy link
Contributor

@alyssawilk alyssawilk left a comment

Choose a reason for hiding this comment

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

LGTM ci willing

@Augustyniak Augustyniak mentioned this pull request Nov 3, 2022
Merged
alyssawilk pushed a commit that referenced this pull request Nov 3, 2022
@Augustyniak
remove the use of deprecated flag (#2658)
b22710b 
Description: Remove the use of removed override_request_timeout_by_gateway_timeout upstream Envoy flag from Swift tests. The flag was removed from the main config.cc as part of #2296 file months ago. The original removal introduced a bug as filter's onError callback started being called twice - this PR fixes this issue. Update EM code to correctly handle stream idle. See #2639 for more details. Fixes #2108.
Risk Level: Medium, touches stream onDestroy code.
Testing: Unit/Integration tests.
Docs Changes: N/A
Release Notes: N/A

Signed-off-by: Rafal Augustyniak <raugustyniak@lyft.com>
@Augustyniak
Copy link
Contributor

Closing as #2659 was merged.

@Augustyniak Augustyniak closed this Nov 8, 2022
@Augustyniak Augustyniak deleted the update-envoy-1667225437 branch November 8, 2022 16:38
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Reviewers

@alyssawilk alyssawilk alyssawilk approved these changes

@Augustyniak Augustyniak Awaiting requested review from Augustyniak

@jpsim jpsim Awaiting requested review from jpsim

Assignees
No one assigned
Labels
None yet
Projects
None yet
Milestone
No milestone
Development

Successfully merging this pull request may close these issues.
4 participants
@envoy-bot @Augustyniak @jpsim @alyssawilk