✔ Container envoy-internal Started 0.1s [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:428] initializing epoch 0 (base id=0, hot restart version=11.120) [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:430] statically linked extensions: [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.http.stateful_header_formatters: envoy.http.stateful_header_formatters.preserve_case, preserve_case [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.transport_sockets.upstream: envoy.transport_sockets.alts, envoy.transport_sockets.http_11_proxy, envoy.transport_sockets.internal_upstream, envoy.transport_sockets.quic, envoy.transport_sockets.raw_buffer, envoy.transport_sockets.starttls, envoy.transport_sockets.tap, envoy.transport_sockets.tcp_stats, envoy.transport_sockets.tls, envoy.transport_sockets.upstream_proxy_protocol, raw_buffer, starttls, tls [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.thrift_proxy.filters: envoy.filters.thrift.header_to_metadata, envoy.filters.thrift.payload_to_metadata, envoy.filters.thrift.rate_limit, envoy.filters.thrift.router [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.network.dns_resolver: envoy.network.dns_resolver.cares, envoy.network.dns_resolver.getaddrinfo [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.tls.cert_validator: envoy.tls.cert_validator.default, envoy.tls.cert_validator.spiffe [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.http.header_validators: envoy.http.header_validators.envoy_default [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.filters.network: envoy.echo, envoy.ext_authz, envoy.filters.network.connection_limit, envoy.filters.network.direct_response, envoy.filters.network.dubbo_proxy, envoy.filters.network.echo, envoy.filters.network.ext_authz, envoy.filters.network.http_connection_manager, envoy.filters.network.local_ratelimit, envoy.filters.network.mongo_proxy, envoy.filters.network.ratelimit, envoy.filters.network.rbac, envoy.filters.network.redis_proxy, envoy.filters.network.set_filter_state, envoy.filters.network.sni_cluster, envoy.filters.network.sni_dynamic_forward_proxy, envoy.filters.network.tcp_proxy, envoy.filters.network.thrift_proxy, envoy.filters.network.wasm, envoy.filters.network.zookeeper_proxy, envoy.http_connection_manager, envoy.mongo_proxy, envoy.ratelimit, envoy.redis_proxy, envoy.tcp_proxy [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.config.validators: envoy.config.validators.minimum_clusters, envoy.config.validators.minimum_clusters_validator [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.thrift_proxy.transports: auto, framed, header, unframed [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.internal_redirect_predicates: envoy.internal_redirect_predicates.allow_listed_routes, envoy.internal_redirect_predicates.previous_routes, envoy.internal_redirect_predicates.safe_cross_scheme [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.request_id: envoy.request_id.uuid [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.matching.action: envoy.matching.actions.format_string, filter-chain-name [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.quic.server.crypto_stream: envoy.quic.crypto_stream.server.quiche [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.route_config_update_requester: envoy.route_config_update_requester.default [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.transport_sockets.downstream: envoy.transport_sockets.alts, envoy.transport_sockets.quic, envoy.transport_sockets.raw_buffer, envoy.transport_sockets.starttls, envoy.transport_sockets.tap, envoy.transport_sockets.tcp_stats, envoy.transport_sockets.tls, raw_buffer, starttls, tls [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.common.key_value: envoy.key_value.file_based [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.path.rewrite: envoy.path.rewrite.uri_template.uri_template_rewriter [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.access_loggers.extension_filters: envoy.access_loggers.extension_filters.cel [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.wasm.runtime: envoy.wasm.runtime.null, envoy.wasm.runtime.v8 [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.matching.input_matchers: envoy.matching.matchers.cel_matcher, envoy.matching.matchers.consistent_hashing, envoy.matching.matchers.ip, envoy.matching.matchers.runtime_fraction [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.quic.server_preferred_address: quic.server_preferred_address.fixed [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.path.match: envoy.path.match.uri_template.uri_template_matcher [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.rate_limit_descriptors: envoy.rate_limit_descriptors.expr [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.clusters: envoy.cluster.eds, envoy.cluster.logical_dns, envoy.cluster.original_dst, envoy.cluster.static, envoy.cluster.strict_dns, envoy.clusters.aggregate, envoy.clusters.dynamic_forward_proxy, envoy.clusters.redis [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.dubbo_proxy.protocols: dubbo [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.thrift_proxy.protocols: auto, binary, binary/non-strict, compact, twitter [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.tracers.opentelemetry.resource_detectors: envoy.tracers.opentelemetry.resource_detectors.dynatrace, envoy.tracers.opentelemetry.resource_detectors.environment [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.rbac.matchers: envoy.rbac.matchers.upstream_ip_port [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.guarddog_actions: envoy.watchdog.abort_action, envoy.watchdog.profile_action [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.upstream.local_address_selector: envoy.upstream.local_address_selector.default_local_address_selector [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.filters.http.upstream: envoy.buffer, envoy.ext_proc, envoy.filters.http.admission_control, envoy.filters.http.aws_lambda, envoy.filters.http.aws_request_signing, envoy.filters.http.buffer, envoy.filters.http.composite, envoy.filters.http.ext_proc, envoy.filters.http.header_mutation, envoy.filters.http.match_delegate, envoy.filters.http.upstream_codec [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] filter_state.object: envoy.filters.listener.original_dst.local_ip, envoy.filters.listener.original_dst.remote_ip, envoy.network.application_protocols, envoy.network.transport_socket.original_dst_address, envoy.network.upstream_server_name, envoy.network.upstream_subject_alt_names, envoy.string, envoy.tcp_proxy.cluster, envoy.tcp_proxy.disable_tunneling, envoy.tcp_proxy.per_connection_idle_timeout_ms, envoy.upstream.dynamic_host, envoy.upstream.dynamic_port [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.matching.network.custom_matchers: envoy.matching.custom_matchers.trie_matcher [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.upstream_options: envoy.extensions.upstreams.http.v3.HttpProtocolOptions, envoy.extensions.upstreams.tcp.v3.TcpProtocolOptions, envoy.upstreams.http.http_protocol_options, envoy.upstreams.tcp.tcp_protocol_options [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.http.stateful_session: envoy.http.stateful_session.cookie, envoy.http.stateful_session.header [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.http.injected_credentials: envoy.http.injected_credentials.generic [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.access_loggers: envoy.access_loggers.file, envoy.access_loggers.fluentd, envoy.access_loggers.http_grpc, envoy.access_loggers.open_telemetry, envoy.access_loggers.stderr, envoy.access_loggers.stdout, envoy.access_loggers.tcp_grpc, envoy.access_loggers.wasm, envoy.file_access_log, envoy.fluentd_access_log, envoy.http_grpc_access_log, envoy.open_telemetry_access_log, envoy.stderr_access_log, envoy.stdout_access_log, envoy.tcp_grpc_access_log, envoy.wasm_access_log [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.connection_handler: envoy.connection_handler.default [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.resolvers: envoy.ip [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.listener_manager_impl: envoy.listener_manager_impl.default, envoy.listener_manager_impl.validation [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.filters.http: envoy.bandwidth_limit, envoy.buffer, envoy.cors, envoy.csrf, envoy.ext_authz, envoy.ext_proc, envoy.fault, envoy.filters.http.adaptive_concurrency, envoy.filters.http.admission_control, envoy.filters.http.alternate_protocols_cache, envoy.filters.http.aws_lambda, envoy.filters.http.aws_request_signing, envoy.filters.http.bandwidth_limit, envoy.filters.http.basic_auth, envoy.filters.http.buffer, envoy.filters.http.cache, envoy.filters.http.cdn_loop, envoy.filters.http.composite, envoy.filters.http.compressor, envoy.filters.http.connect_grpc_bridge, envoy.filters.http.cors, envoy.filters.http.credential_injector, envoy.filters.http.csrf, envoy.filters.http.custom_response, envoy.filters.http.decompressor, envoy.filters.http.dynamic_forward_proxy, envoy.filters.http.ext_authz, envoy.filters.http.ext_proc, envoy.filters.http.fault, envoy.filters.http.file_system_buffer, envoy.filters.http.gcp_authn, envoy.filters.http.geoip, envoy.filters.http.grpc_field_extraction, envoy.filters.http.grpc_http1_bridge, envoy.filters.http.grpc_http1_reverse_bridge, envoy.filters.http.grpc_json_transcoder, envoy.filters.http.grpc_stats, envoy.filters.http.grpc_web, envoy.filters.http.header_mutation, envoy.filters.http.header_to_metadata, envoy.filters.http.health_check, envoy.filters.http.ip_tagging, envoy.filters.http.json_to_metadata, envoy.filters.http.jwt_authn, envoy.filters.http.local_ratelimit, envoy.filters.http.lua, envoy.filters.http.match_delegate, envoy.filters.http.oauth2, envoy.filters.http.on_demand, envoy.filters.http.original_src, envoy.filters.http.rate_limit_quota, envoy.filters.http.ratelimit, envoy.filters.http.rbac, envoy.filters.http.router, envoy.filters.http.set_filter_state, envoy.filters.http.set_metadata, envoy.filters.http.stateful_session, envoy.filters.http.tap, envoy.filters.http.wasm, envoy.geoip, envoy.grpc_http1_bridge, envoy.grpc_json_transcoder, envoy.grpc_web, envoy.health_check, envoy.ip_tagging, envoy.local_rate_limit, envoy.lua, envoy.rate_limit, envoy.router [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.dubbo_proxy.filters: envoy.filters.dubbo.router [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.geoip_providers: envoy.geoip_providers.maxmind [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.http.original_ip_detection: envoy.http.original_ip_detection.custom_header, envoy.http.original_ip_detection.xff [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.resource_monitors: envoy.resource_monitors.fixed_heap, envoy.resource_monitors.injected_resource [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.tracers.opentelemetry.samplers: envoy.tracers.opentelemetry.samplers.always_on, envoy.tracers.opentelemetry.samplers.dynatrace [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.retry_priorities: envoy.retry_priorities.previous_priorities [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.compression.decompressor: envoy.compression.brotli.decompressor, envoy.compression.gzip.decompressor, envoy.compression.zstd.decompressor [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.udp_packet_writer: envoy.udp_packet_writer.default, envoy.udp_packet_writer.gso [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.stats_sinks: envoy.dog_statsd, envoy.graphite_statsd, envoy.metrics_service, envoy.open_telemetry_stat_sink, envoy.stat_sinks.dog_statsd, envoy.stat_sinks.graphite_statsd, envoy.stat_sinks.hystrix, envoy.stat_sinks.metrics_service, envoy.stat_sinks.open_telemetry, envoy.stat_sinks.statsd, envoy.stat_sinks.wasm, envoy.statsd [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.quic.proof_source: envoy.quic.proof_source.filter_chain [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.quic.connection_id_generator: envoy.quic.deterministic_connection_id_generator [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.health_check.event_sinks: envoy.health_check.event_sink.file [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.router.cluster_specifier_plugin: envoy.router.cluster_specifier_plugin.lua [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] 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.dns_san, envoy.matching.inputs.filter_state, envoy.matching.inputs.server_name, envoy.matching.inputs.source_ip, envoy.matching.inputs.source_port, envoy.matching.inputs.source_type, envoy.matching.inputs.subject, envoy.matching.inputs.transport_protocol, envoy.matching.inputs.uri_san [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.filters.listener: envoy.filters.listener.http_inspector, envoy.filters.listener.local_ratelimit, envoy.filters.listener.original_dst, envoy.filters.listener.original_src, envoy.filters.listener.proxy_protocol, envoy.filters.listener.tls_inspector, envoy.listener.http_inspector, envoy.listener.original_dst, envoy.listener.original_src, envoy.listener.proxy_protocol, envoy.listener.tls_inspector [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.bootstrap: envoy.bootstrap.internal_listener, envoy.bootstrap.wasm, envoy.extensions.network.socket_interface.default_socket_interface [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.config_subscription: envoy.config_subscription.ads, envoy.config_subscription.ads_collection, envoy.config_subscription.aggregated_grpc_collection, envoy.config_subscription.delta_grpc, envoy.config_subscription.delta_grpc_collection, envoy.config_subscription.filesystem, envoy.config_subscription.filesystem_collection, envoy.config_subscription.grpc, envoy.config_subscription.rest [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.compression.compressor: envoy.compression.brotli.compressor, envoy.compression.gzip.compressor, envoy.compression.zstd.compressor [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.matching.http.input: envoy.matching.inputs.cel_data_input, envoy.matching.inputs.destination_ip, envoy.matching.inputs.destination_port, envoy.matching.inputs.direct_source_ip, envoy.matching.inputs.dns_san, 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, envoy.matching.inputs.status_code_class_input, envoy.matching.inputs.status_code_input, envoy.matching.inputs.subject, envoy.matching.inputs.uri_san, query_params [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.http.cache: envoy.extensions.http.cache.file_system_http_cache, envoy.extensions.http.cache.simple [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.config_mux: envoy.config_mux.delta_grpc_mux_factory, envoy.config_mux.grpc_mux_factory, envoy.config_mux.new_grpc_mux_factory, envoy.config_mux.sotw_grpc_mux_factory [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.regex_engines: envoy.regex_engines.google_re2 [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.http.custom_response: envoy.extensions.http.custom_response.local_response_policy, envoy.extensions.http.custom_response.redirect_policy [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.string_matcher: envoy.string_matcher.lua [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.route.early_data_policy: envoy.route.early_data_policy.default [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] quic.http_server_connection: quic.http_server_connection.default [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.filters.udp_listener: envoy.filters.udp.dns_filter, envoy.filters.udp_listener.udp_proxy [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.health_checkers: envoy.health_checkers.grpc, envoy.health_checkers.http, envoy.health_checkers.redis, envoy.health_checkers.tcp, envoy.health_checkers.thrift [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.formatter: envoy.formatter.cel, envoy.formatter.metadata, envoy.formatter.req_without_query [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.retry_host_predicates: envoy.retry_host_predicates.omit_canary_hosts, envoy.retry_host_predicates.omit_host_metadata, envoy.retry_host_predicates.previous_hosts [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.load_balancing_policies: envoy.load_balancing_policies.cluster_provided, envoy.load_balancing_policies.least_request, envoy.load_balancing_policies.maglev, envoy.load_balancing_policies.random, envoy.load_balancing_policies.ring_hash, envoy.load_balancing_policies.round_robin, envoy.load_balancing_policies.subset [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.matching.common_inputs: envoy.matching.common_inputs.environment_variable [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.http.early_header_mutation: envoy.http.early_header_mutation.header_mutation [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.tracers: envoy.dynamic.ot, envoy.tracers.datadog, envoy.tracers.dynamic_ot, envoy.tracers.opencensus, envoy.tracers.opentelemetry, envoy.tracers.skywalking, envoy.tracers.xray, envoy.tracers.zipkin, envoy.zipkin [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.matching.http.custom_matchers: envoy.matching.custom_matchers.trie_matcher [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.upstreams: envoy.filters.connection_pools.tcp.generic [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.filters.udp.session: envoy.filters.udp.session.dynamic_forward_proxy, envoy.filters.udp.session.http_capsule [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.grpc_credentials: envoy.grpc_credentials.aws_iam, envoy.grpc_credentials.default, envoy.grpc_credentials.file_based_metadata [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] envoy.dubbo_proxy.serializers: dubbo.hessian2 [2024-04-25 22:21:16.412][1][info][main] [source/server/server.cc:432] network.connection.client: default, envoy_internal [2024-04-25 22:21:16.413][1][warning][misc] [source/common/protobuf/message_validator_impl.cc:21] Deprecated field: type envoy.config.core.v3.ConfigSource Using the default now-deprecated value AUTO for enum 'envoy.config.core.v3.ConfigSource.resource_api_version' from file config_source.proto. This enum value will be removed from Envoy soon so a non-default value must now be explicitly set. Please see https://www.envoyproxy.io/docs/envoy/latest/version_history/version_history for details. If continued use of this field is absolutely necessary, see https://www.envoyproxy.io/docs/envoy/latest/configuration/operations/runtime#using-runtime-overrides-for-deprecated-features for how to apply a temporary and highly discouraged override. [2024-04-25 22:21:16.413][1][warning][misc] [source/common/protobuf/message_validator_impl.cc:21] Deprecated field: type envoy.config.core.v3.ConfigSource Using the default now-deprecated value AUTO for enum 'envoy.config.core.v3.ConfigSource.resource_api_version' from file config_source.proto. This enum value will be removed from Envoy soon so a non-default value must now be explicitly set. Please see https://www.envoyproxy.io/docs/envoy/latest/version_history/version_history for details. If continued use of this field is absolutely necessary, see https://www.envoyproxy.io/docs/envoy/latest/configuration/operations/runtime#using-runtime-overrides-for-deprecated-features for how to apply a temporary and highly discouraged override. [2024-04-25 22:21:16.413][1][info][main] [source/server/server.cc:492] HTTP header map info: [2024-04-25 22:21:16.414][1][info][main] [source/server/server.cc:495] request header map: 664 bytes: :authority,:method,:path,:protocol,:scheme,accept,accept-encoding,access-control-request-headers,access-control-request-method,access-control-request-private-network,authentication,authorization,cache-control,cdn-loop,connection,content-encoding,content-length,content-type,expect,grpc-accept-encoding,grpc-timeout,if-match,if-modified-since,if-none-match,if-range,if-unmodified-since,keep-alive,origin,pragma,proxy-connection,proxy-status,referer,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-is-timeout-retry,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-port,x-forwarded-proto,x-ot-span-context,x-request-id [2024-04-25 22:21:16.414][1][info][main] [source/server/server.cc:495] request trailer map: 120 bytes: [2024-04-25 22:21:16.414][1][info][main] [source/server/server.cc:495] response header map: 432 bytes: :status,access-control-allow-credentials,access-control-allow-headers,access-control-allow-methods,access-control-allow-origin,access-control-allow-private-network,access-control-expose-headers,access-control-max-age,age,cache-control,connection,content-encoding,content-length,content-type,date,etag,expires,grpc-message,grpc-status,keep-alive,last-modified,location,proxy-connection,proxy-status,server,transfer-encoding,upgrade,vary,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 [2024-04-25 22:21:16.414][1][info][main] [source/server/server.cc:495] response trailer map: 144 bytes: grpc-message,grpc-status [2024-04-25 22:21:16.417][1][debug][main] [source/server/overload_manager_impl.cc:394] Evaluating resource envoy.resource_monitors.fixed_heap [2024-04-25 22:21:16.417][1][debug][main] [source/server/overload_manager_impl.cc:410] Adding resource monitor for envoy.resource_monitors.fixed_heap [2024-04-25 22:21:16.417][1][debug][main] [source/server/overload_manager_impl.cc:426] Adding overload action envoy.overload_actions.shrink_heap [2024-04-25 22:21:16.417][1][debug][main] [source/server/overload_manager_impl.cc:426] Adding overload action envoy.overload_actions.stop_accepting_requests [2024-04-25 22:21:16.417][1][debug][main] [source/server/overload_manager_impl.cc:552] No overload action is configured for envoy.overload_actions.reduce_timeouts. [2024-04-25 22:21:16.418][1][debug][main] [source/server/overload_manager_impl.cc:552] No overload action is configured for envoy.overload_actions.stop_accepting_connections. [2024-04-25 22:21:16.418][1][debug][main] [source/server/overload_manager_impl.cc:552] No overload action is configured for envoy.overload_actions.reject_incoming_connections. [2024-04-25 22:21:16.418][1][debug][main] [source/server/overload_manager_impl.cc:552] No overload action is configured for envoy.overload_actions.reset_high_memory_stream. [2024-04-25 22:21:16.418][1][info][main] [source/server/server.cc:863] runtime: layers: - name: static_layer_0 static_layer: envoy: resource_limits: listener: example_listener_name: connection_limit: 1000 overload: global_downstream_max_connections: 5000 [2024-04-25 22:21:16.418][1][info][admin] [source/server/admin/admin.cc:66] admin address: 0.0.0.0:9901 [2024-04-25 22:21:16.418][1][info][config] [source/server/configuration_impl.cc:168] loading tracing configuration [2024-04-25 22:21:16.418][1][info][config] [source/server/configuration_impl.cc:124] loading 0 static secret(s) [2024-04-25 22:21:16.418][1][info][config] [source/server/configuration_impl.cc:130] loading 0 cluster(s) [2024-04-25 22:21:16.418][12][debug][grpc] [source/common/grpc/google_async_client_impl.cc:54] completionThread running [2024-04-25 22:21:16.419][1][debug][file] [source/common/filesystem/inotify/watcher_impl.cc:50] added watch for directory: '/var/lib/envoy' file: 'cds.yaml' fd: 1 [2024-04-25 22:21:16.419][1][debug][upstream] [source/common/upstream/cluster_manager_impl.cc:187] maybe finish initialize state: 1 [2024-04-25 22:21:16.419][1][debug][upstream] [source/common/upstream/cluster_manager_impl.cc:196] maybe finish initialize primary init clusters empty: true [2024-04-25 22:21:16.419][1][info][config] [source/server/configuration_impl.cc:138] loading 0 listener(s) [2024-04-25 22:21:16.419][1][info][config] [source/server/configuration_impl.cc:154] loading stats configuration [2024-04-25 22:21:16.419][1][debug][file] [source/common/filesystem/inotify/watcher_impl.cc:50] added watch for directory: '/var/lib/envoy' file: 'lds.yaml' fd: 1 [2024-04-25 22:21:16.419][1][debug][init] [source/common/init/manager_impl.cc:24] added target LDS to init manager Server [2024-04-25 22:21:16.419][1][debug][init] [source/common/init/manager_impl.cc:49] init manager RTDS contains no targets [2024-04-25 22:21:16.419][1][debug][init] [source/common/init/watcher_impl.cc:14] init manager RTDS initialized, notifying RTDS [2024-04-25 22:21:16.419][1][info][runtime] [source/common/runtime/runtime_impl.cc:614] RTDS has finished initialization [2024-04-25 22:21:16.419][1][debug][upstream] [source/common/upstream/cluster_manager_impl.cc:258] continue initializing secondary clusters [2024-04-25 22:21:16.419][1][debug][upstream] [source/common/upstream/cluster_manager_impl.cc:187] maybe finish initialize state: 2 [2024-04-25 22:21:16.419][1][debug][upstream] [source/common/upstream/cluster_manager_impl.cc:196] maybe finish initialize primary init clusters empty: true [2024-04-25 22:21:16.419][1][debug][upstream] [source/common/upstream/cluster_manager_impl.cc:211] maybe finish initialize secondary init clusters empty: true [2024-04-25 22:21:16.419][1][debug][upstream] [source/common/upstream/cluster_manager_impl.cc:234] maybe finish initialize cds api ready: true [2024-04-25 22:21:16.419][1][info][upstream] [source/common/upstream/cluster_manager_impl.cc:236] cm init: initializing cds [2024-04-25 22:21:16.419][1][debug][config] [source/extensions/config_subscription/filesystem/filesystem_subscription_impl.cc:81] Filesystem config refresh for /var/lib/envoy/cds.yaml [2024-04-25 22:21:16.420][1][info][upstream] [source/common/upstream/cds_api_helper.cc:32] cds: add 2 cluster(s), remove 0 cluster(s) [2024-04-25 22:21:16.420][1][debug][misc] [source/common/network/dns_resolver/dns_factory_util.cc:75] create DNS resolver type: envoy.network.dns_resolver.cares [2024-04-25 22:21:16.420][1][debug][dns] [source/extensions/network/dns_resolver/cares/dns_impl.cc:576] c-ares library initialized. [2024-04-25 22:21:16.421][1][debug][config] [./source/common/http/filter_chain_helper.h:111] upstream http filter #0 [2024-04-25 22:21:16.421][1][debug][config] [./source/common/http/filter_chain_helper.h:158] name: envoy.filters.http.upstream_codec [2024-04-25 22:21:16.421][1][debug][config] [./source/common/http/filter_chain_helper.h:161] config: {"@type":"type.googleapis.com/envoy.extensions.filters.http.upstream_codec.v3.UpstreamCodec"} [2024-04-25 22:21:16.421][1][debug][upstream] [source/common/upstream/cluster_manager_impl.cc:822] add/update cluster ext-service_authz_cluster during init [2024-04-25 22:21:16.421][1][debug][dns] [source/extensions/network/dns_resolver/cares/dns_impl.cc:369] dns resolution for host.docker.internal started [2024-04-25 22:21:16.421][1][debug][upstream] [source/common/upstream/cluster_manager_impl.cc:133] cm init: adding: cluster=ext-service_authz_cluster primary=1 secondary=0 [2024-04-25 22:21:16.421][1][debug][upstream] [source/common/upstream/cds_api_helper.cc:51] cds: add/update cluster 'ext-service_authz_cluster' [2024-04-25 22:21:16.421][1][debug][config] [./source/common/http/filter_chain_helper.h:111] upstream http filter #0 [2024-04-25 22:21:16.421][1][debug][config] [./source/common/http/filter_chain_helper.h:158] name: envoy.filters.http.upstream_codec [2024-04-25 22:21:16.421][1][debug][config] [./source/common/http/filter_chain_helper.h:161] config: {"@type":"type.googleapis.com/envoy.extensions.filters.http.upstream_codec.v3.UpstreamCodec"} [2024-04-25 22:21:16.421][1][debug][upstream] [source/common/upstream/cluster_manager_impl.cc:822] add/update cluster new_api_grpc_cluster during init [2024-04-25 22:21:16.421][1][debug][dns] [source/extensions/network/dns_resolver/cares/dns_impl.cc:369] dns resolution for host.docker.internal started [2024-04-25 22:21:16.421][1][debug][upstream] [source/common/upstream/cluster_manager_impl.cc:133] cm init: adding: cluster=new_api_grpc_cluster primary=2 secondary=0 [2024-04-25 22:21:16.421][1][debug][upstream] [source/common/upstream/cds_api_helper.cc:51] cds: add/update cluster 'new_api_grpc_cluster' [2024-04-25 22:21:16.421][1][info][upstream] [source/common/upstream/cds_api_helper.cc:71] cds: added/updated 2 cluster(s), skipped 0 unmodified cluster(s) [2024-04-25 22:21:16.421][1][debug][upstream] [source/common/upstream/cluster_manager_impl.cc:187] maybe finish initialize state: 4 [2024-04-25 22:21:16.421][1][debug][upstream] [source/common/upstream/cluster_manager_impl.cc:196] maybe finish initialize primary init clusters empty: false [2024-04-25 22:21:16.422][1][debug][config] [source/extensions/config_subscription/filesystem/filesystem_subscription_impl.cc:91] Filesystem config update accepted for /var/lib/envoy/cds.yaml: resources { [type.googleapis.com/envoy.config.cluster.v3.Cluster] { name: "ext-service_authz_cluster" type: STRICT_DNS connect_timeout { seconds: 30 } dns_lookup_family: V4_ONLY load_assignment { cluster_name: "ext-service_authz_cluster" endpoints { lb_endpoints { endpoint { address { socket_address { address: "host.docker.internal" port_value: 8893 } } } } } } typed_extension_protocol_options { key: "envoy.extensions.upstreams.http.v3.HttpProtocolOptions" value { [type.googleapis.com/envoy.extensions.upstreams.http.v3.HttpProtocolOptions] { explicit_http_config { http2_protocol_options { } } } } } } } resources { [type.googleapis.com/envoy.config.cluster.v3.Cluster] { name: "new_api_grpc_cluster" type: LOGICAL_DNS dns_lookup_family: V4_ONLY load_assignment { cluster_name: "new_api_grpc_cluster" endpoints { lb_endpoints { endpoint { address { socket_address { address: "host.docker.internal" port_value: 8897 } } } } } } typed_extension_protocol_options { key: "envoy.extensions.upstreams.http.v3.HttpProtocolOptions" value { [type.googleapis.com/envoy.extensions.upstreams.http.v3.HttpProtocolOptions] { explicit_http_config { http2_protocol_options { } } } } } } } [2024-04-25 22:21:16.422][1][warning][main] [source/server/server.cc:837] Usage of the deprecated runtime key overload.global_downstream_max_connections, consider switching to `envoy.resource_monitors.downstream_connections` instead.This runtime key will be removed in future. [2024-04-25 22:21:16.422][1][warning][main] [source/server/server.cc:930] There is no configured limit to the number of allowed active downstream connections. Configure a limit in `envoy.resource_monitors.downstream_connections` resource monitor. [2024-04-25 22:21:16.422][1][info][main] [source/server/server.cc:971] starting main dispatch loop [2024-04-25 22:21:16.424][1][debug][dns] [source/extensions/network/dns_resolver/cares/dns_impl.cc:289] dns resolution for host.docker.internal completed with status 0 [2024-04-25 22:21:16.424][1][debug][upstream] [source/common/upstream/upstream_impl.cc:458] transport socket match, socket default selected for host with address 192.168.65.254:8897 [2024-04-25 22:21:16.424][1][debug][upstream] [source/extensions/clusters/logical_dns/logical_dns_cluster.cc:152] DNS refresh rate reset for host.docker.internal, refresh rate 5000 ms [2024-04-25 22:21:16.424][1][debug][upstream] [source/common/upstream/upstream_impl.cc:1689] initializing Primary cluster new_api_grpc_cluster completed [2024-04-25 22:21:16.424][1][debug][init] [source/common/init/manager_impl.cc:49] init manager Cluster new_api_grpc_cluster contains no targets [2024-04-25 22:21:16.424][1][debug][init] [source/common/init/watcher_impl.cc:14] init manager Cluster new_api_grpc_cluster initialized, notifying ClusterImplBase [2024-04-25 22:21:16.424][1][debug][upstream] [source/common/upstream/cluster_manager_impl.cc:1285] adding TLS cluster new_api_grpc_cluster [2024-04-25 22:21:16.424][1][debug][upstream] [source/common/upstream/cluster_manager_impl.cc:1542] membership update for TLS cluster new_api_grpc_cluster added 1 removed 0 [2024-04-25 22:21:16.424][1][debug][upstream] [source/common/upstream/cluster_manager_impl.cc:167] cm init: init complete: cluster=new_api_grpc_cluster primary=1 secondary=0 [2024-04-25 22:21:16.424][1][debug][upstream] [source/common/upstream/cluster_manager_impl.cc:187] maybe finish initialize state: 4 [2024-04-25 22:21:16.424][1][debug][upstream] [source/common/upstream/cluster_manager_impl.cc:196] maybe finish initialize primary init clusters empty: false [2024-04-25 22:21:16.424][1][debug][dns] [source/extensions/network/dns_resolver/cares/dns_impl.cc:289] dns resolution for host.docker.internal completed with status 0 [2024-04-25 22:21:16.424][1][debug][upstream] [source/common/upstream/upstream_impl.cc:458] transport socket match, socket default selected for host with address 192.168.65.254:8893 [2024-04-25 22:21:16.424][1][debug][upstream] [source/extensions/clusters/strict_dns/strict_dns_cluster.cc:149] DNS hosts have changed for host.docker.internal [2024-04-25 22:21:16.424][1][debug][upstream] [source/extensions/clusters/strict_dns/strict_dns_cluster.cc:177] DNS refresh rate reset for host.docker.internal, refresh rate 5000 ms [2024-04-25 22:21:16.424][1][debug][upstream] [source/common/upstream/upstream_impl.cc:1689] initializing Primary cluster ext-service_authz_cluster completed [2024-04-25 22:21:16.424][1][debug][init] [source/common/init/manager_impl.cc:49] init manager Cluster ext-service_authz_cluster contains no targets [2024-04-25 22:21:16.424][1][debug][init] [source/common/init/watcher_impl.cc:14] init manager Cluster ext-service_authz_cluster initialized, notifying ClusterImplBase [2024-04-25 22:21:16.424][1][debug][upstream] [source/common/upstream/cluster_manager_impl.cc:1285] adding TLS cluster ext-service_authz_cluster [2024-04-25 22:21:16.424][1][debug][upstream] [source/common/upstream/cluster_manager_impl.cc:1542] membership update for TLS cluster ext-service_authz_cluster added 1 removed 0 [2024-04-25 22:21:16.424][1][debug][upstream] [source/common/upstream/cluster_manager_impl.cc:167] cm init: init complete: cluster=ext-service_authz_cluster primary=0 secondary=0 [2024-04-25 22:21:16.424][1][debug][upstream] [source/common/upstream/cluster_manager_impl.cc:187] maybe finish initialize state: 4 [2024-04-25 22:21:16.424][1][debug][upstream] [source/common/upstream/cluster_manager_impl.cc:196] maybe finish initialize primary init clusters empty: true [2024-04-25 22:21:16.424][1][debug][upstream] [source/common/upstream/cluster_manager_impl.cc:211] maybe finish initialize secondary init clusters empty: true [2024-04-25 22:21:16.424][1][debug][upstream] [source/common/upstream/cluster_manager_impl.cc:234] maybe finish initialize cds api ready: true [2024-04-25 22:21:16.424][1][info][upstream] [source/common/upstream/cluster_manager_impl.cc:240] cm init: all clusters initialized [2024-04-25 22:21:16.424][1][info][main] [source/server/server.cc:952] all clusters initialized. initializing init manager [2024-04-25 22:21:16.424][1][debug][init] [source/common/init/manager_impl.cc:53] init manager Server initializing [2024-04-25 22:21:16.424][1][debug][init] [source/common/init/target_impl.cc:15] init manager Server initializing target LDS [2024-04-25 22:21:16.424][1][debug][config] [source/extensions/config_subscription/filesystem/filesystem_subscription_impl.cc:81] Filesystem config refresh for /var/lib/envoy/lds.yaml [2024-04-25 22:21:16.426][1][debug][config] [source/common/listener_manager/listener_manager_impl.cc:546] begin add/update listener: name=listener_web hash=10509624129060079268 [2024-04-25 22:21:16.426][1][debug][config] [source/common/listener_manager/listener_manager_impl.cc:583] use full listener update path for listener name=listener_web hash=10509624129060079268 [2024-04-25 22:21:16.426][1][debug][config] [source/common/listener_manager/listener_manager_impl.cc:89] filter #0: [2024-04-25 22:21:16.426][1][debug][config] [source/common/listener_manager/listener_manager_impl.cc:102] name: envoy.filters.network.http_connection_manager [2024-04-25 22:21:16.426][1][debug][config] [source/common/listener_manager/listener_manager_impl.cc:105] config: {"@type":"type.googleapis.com/envoy.extensions.filters.network.http_connection_manager.v3.HttpConnectionManager","stat_prefix":"ingress_http","route_config":{"name":"api_service_route_config","virtual_hosts":[{"name":"api_service_route","domains":["*"],"routes":[{"match":{"prefix":"/edugo.api.services.sms.v1.SmsApiService/SendSmsExternalGETV1","grpc":{}},"route":{"cluster":"new_api_grpc_cluster","timeout":"60s"}}]}]},"http_filters":[{"name":"envoy.filters.http.grpc_json_transcoder","typed_config":{"@type":"type.googleapis.com/envoy.extensions.filters.http.grpc_json_transcoder.v3.GrpcJsonTranscoder","proto_descriptor":"/var/lib/envoy/descriptors.binp","services":["edugo.api.services.sms.v1.SmsApiService"],"print_options":{"add_whitespace":true,"always_print_primitive_fields":true},"auto_mapping":true,"convert_grpc_status":true}},{"name":"envoy.filters.http.ext_authz","typed_config":{"@type":"type.googleapis.com/envoy.extensions.filters.http.ext_authz.v3.ExtAuthz","grpc_service":{"envoy_grpc":{"cluster_name":"ext-service_authz_cluster"},"timeout":"5s"},"with_request_body":{"max_request_bytes":819200,"allow_partial_message":true,"pack_as_bytes":true},"status_on_error":{"code":"ServiceUnavailable"},"transport_api_version":"V3","stat_prefix":"ext_authz"}},{"name":"envoy.filters.http.lua","typed_config":{"@type":"type.googleapis.com/envoy.extensions.filters.http.lua.v3.Lua","default_source_code":{"inline_string":"-- Called on the request path.\nfunction envoy_on_request(request_handle)\n local meta = request_handle:streamInfo():dynamicMetadata():get(\"envoy.filters.http.ext_authz\")\n local orgId = meta[\"x-edu-org-id\"]\n local uri = request_handle:headers():get(\":path\")\n request_handle:logCritical(\" request: \"..uri)\n request_handle:logCritical(\" orgId: \"..orgId)\nend\n\nfunction envoy_on_response(response_handle)\n response_handle:logCritical(\"Before reading response body\")\n local bufferResp = response_handle:body()\n response_handle:logCritical(\"After reading response body\") \nend\n"}}},{"name":"envoy.filters.http.router","typed_config":{"@type":"type.googleapis.com/envoy.extensions.filters.http.router.v3.Router"}}],"http2_protocol_options":{"max_concurrent_streams":100,"initial_stream_window_size":65536,"initial_connection_window_size":1048576},"drain_timeout":"30s","access_log":[{"name":"envoy.access_loggers.stdout","typed_config":{"@type":"type.googleapis.com/envoy.extensions.access_loggers.stream.v3.StdoutAccessLog","log_format":{"json_format":{"service.name":"envoy","host.hostname":"%HOSTNAME%","http.request.start_time":"%START_TIME%","http.request.duration":"%DURATION%","x-request-id":"%REQ(X-REQUEST-ID)%","http.response.response_flag":"%RESPONSE_FLAGS%","http.request.body.bytes":"%BYTES_RECEIVED%","http.request.headers.traceparent":"%REQ(TRACEPARENT)%","@timestamp":"%START_TIME%","http.request.method":"%REQ(:METHOD)%","envoy.route.name":"%ROUTE_NAME%","http.request.headers.x_forwarded_proto":"%REQ(X-FORWARDED-PROTO)%","http.request.path":"%REQ(X-ENVOY-ORIGINAL-PATH?:PATH)%","http.request.headers.authority":"%REQ(:AUTHORITY)%","client.local.address":"%DOWNSTREAM_LOCAL_ADDRESS%","client.address":"%DOWNSTREAM_REMOTE_ADDRESS%","http.response.body.bytes":"%BYTES_SENT%","service.version":"1.28","envoy.upstream.cluster":"%UPSTREAM_CLUSTER%","http.response.response_code":"%RESPONSE_CODE%","http.request.headers.x_forwarded_for":"%REQ(X-FORWARDED-FOR)%","http.request.headers.id":"%REQ(X-REQUEST-ID)%","http.request.protocol":"%PROTOCOL%","http.request.headers.accept":"%REQ(ACCEPT)%"}}}}],"generate_request_id":true,"stream_idle_timeout":"30s","delayed_close_timeout":"30s","request_timeout":"30s","normalize_path":true,"merge_slashes":true,"common_http_protocol_options":{"idle_timeout":"3600s"},"always_set_request_id_in_response":true,"stream_error_on_invalid_http_message":true,"request_headers_timeout":"30s","path_with_escaped_slashes_action":"UNESCAPE_AND_REDIRECT"} [2024-04-25 22:21:16.427][1][debug][config] [./source/common/http/filter_chain_helper.h:111] http filter #0 [2024-04-25 22:21:16.432][1][debug][config] [./source/common/http/filter_chain_helper.h:158] name: envoy.filters.http.grpc_json_transcoder [2024-04-25 22:21:16.432][1][debug][config] [./source/common/http/filter_chain_helper.h:161] config: {"@type":"type.googleapis.com/envoy.extensions.filters.http.grpc_json_transcoder.v3.GrpcJsonTranscoder","proto_descriptor":"/var/lib/envoy/descriptors.binp","services":["edugo.api.services.sms.v1.SmsApiService"],"print_options":{"add_whitespace":true,"always_print_primitive_fields":true},"auto_mapping":true,"convert_grpc_status":true} [2024-04-25 22:21:16.432][1][debug][config] [./source/common/http/filter_chain_helper.h:111] http filter #1 [2024-04-25 22:21:16.432][1][debug][config] [./source/common/http/filter_chain_helper.h:158] name: envoy.filters.http.ext_authz [2024-04-25 22:21:16.432][1][debug][config] [./source/common/http/filter_chain_helper.h:161] config: {"@type":"type.googleapis.com/envoy.extensions.filters.http.ext_authz.v3.ExtAuthz","grpc_service":{"envoy_grpc":{"cluster_name":"ext-service_authz_cluster"},"timeout":"5s"},"with_request_body":{"max_request_bytes":819200,"allow_partial_message":true,"pack_as_bytes":true},"status_on_error":{"code":"ServiceUnavailable"},"transport_api_version":"V3","stat_prefix":"ext_authz"} [2024-04-25 22:21:16.432][1][debug][config] [./source/common/http/filter_chain_helper.h:111] http filter #2 [2024-04-25 22:21:16.433][1][debug][lua] [./source/extensions/filters/common/lua/lua.h:182] registering new type: N5Envoy10Extensions7Filters6Common3Lua13BufferWrapperE [2024-04-25 22:21:16.433][1][debug][lua] [./source/extensions/filters/common/lua/lua.h:182] registering new type: N5Envoy10Extensions7Filters6Common3Lua18MetadataMapWrapperE [2024-04-25 22:21:16.433][1][debug][lua] [./source/extensions/filters/common/lua/lua.h:182] registering new type: N5Envoy10Extensions7Filters6Common3Lua19MetadataMapIteratorE [2024-04-25 22:21:16.433][1][debug][lua] [./source/extensions/filters/common/lua/lua.h:182] registering new type: N5Envoy10Extensions7Filters6Common3Lua17ConnectionWrapperE [2024-04-25 22:21:16.433][1][debug][lua] [./source/extensions/filters/common/lua/lua.h:182] registering new type: N5Envoy10Extensions7Filters6Common3Lua20SslConnectionWrapperE [2024-04-25 22:21:16.433][1][debug][lua] [./source/extensions/filters/common/lua/lua.h:182] registering new type: N5Envoy10Extensions11HttpFilters3Lua16HeaderMapWrapperE [2024-04-25 22:21:16.433][1][debug][lua] [./source/extensions/filters/common/lua/lua.h:182] registering new type: N5Envoy10Extensions11HttpFilters3Lua17HeaderMapIteratorE [2024-04-25 22:21:16.433][1][debug][lua] [./source/extensions/filters/common/lua/lua.h:182] registering new type: N5Envoy10Extensions11HttpFilters3Lua17StreamInfoWrapperE [2024-04-25 22:21:16.433][1][debug][lua] [./source/extensions/filters/common/lua/lua.h:182] registering new type: N5Envoy10Extensions11HttpFilters3Lua25DynamicMetadataMapWrapperE [2024-04-25 22:21:16.433][1][debug][lua] [./source/extensions/filters/common/lua/lua.h:182] registering new type: N5Envoy10Extensions11HttpFilters3Lua26DynamicMetadataMapIteratorE [2024-04-25 22:21:16.433][1][debug][lua] [./source/extensions/filters/common/lua/lua.h:182] registering new type: N5Envoy10Extensions11HttpFilters3Lua19StreamHandleWrapperE [2024-04-25 22:21:16.433][1][debug][lua] [./source/extensions/filters/common/lua/lua.h:182] registering new type: N5Envoy10Extensions11HttpFilters3Lua16PublicKeyWrapperE [2024-04-25 22:21:16.433][1][debug][lua] [./source/extensions/filters/common/lua/lua.h:182] registering new type: N5Envoy10Extensions11HttpFilters3Lua27ConnectionStreamInfoWrapperE [2024-04-25 22:21:16.433][1][debug][lua] [./source/extensions/filters/common/lua/lua.h:182] registering new type: N5Envoy10Extensions11HttpFilters3Lua35ConnectionDynamicMetadataMapWrapperE [2024-04-25 22:21:16.433][1][debug][lua] [./source/extensions/filters/common/lua/lua.h:182] registering new type: N5Envoy10Extensions11HttpFilters3Lua36ConnectionDynamicMetadataMapIteratorE [2024-04-25 22:21:16.433][1][debug][config] [./source/common/http/filter_chain_helper.h:158] name: envoy.filters.http.lua [2024-04-25 22:21:16.433][1][debug][config] [./source/common/http/filter_chain_helper.h:161] config: {"@type":"type.googleapis.com/envoy.extensions.filters.http.lua.v3.Lua","default_source_code":{"inline_string":"-- Called on the request path.\nfunction envoy_on_request(request_handle)\n local meta = request_handle:streamInfo():dynamicMetadata():get(\"envoy.filters.http.ext_authz\")\n local orgId = meta[\"x-edu-org-id\"]\n local uri = request_handle:headers():get(\":path\")\n request_handle:logCritical(\" request: \"..uri)\n request_handle:logCritical(\" orgId: \"..orgId)\nend\n\nfunction envoy_on_response(response_handle)\n response_handle:logCritical(\"Before reading response body\")\n local bufferResp = response_handle:body()\n response_handle:logCritical(\"After reading response body\") \nend\n"}} [2024-04-25 22:21:16.433][1][debug][config] [./source/common/http/filter_chain_helper.h:111] http filter #3 [2024-04-25 22:21:16.433][1][debug][config] [./source/common/http/filter_chain_helper.h:158] name: envoy.filters.http.router [2024-04-25 22:21:16.433][1][debug][config] [./source/common/http/filter_chain_helper.h:161] config: {"@type":"type.googleapis.com/envoy.extensions.filters.http.router.v3.Router"} [2024-04-25 22:21:16.433][1][debug][config] [source/common/listener_manager/filter_chain_manager_impl.cc:247] new fc_contexts has 1 filter chains, including 1 newly built [2024-04-25 22:21:16.433][1][debug][init] [source/common/init/target_impl.cc:15] init manager Server initializing target Listener-init-target listener_web [2024-04-25 22:21:16.433][1][debug][init] [source/common/init/manager_impl.cc:49] init manager Listener-local-init-manager listener_web 10509624129060079268 contains no targets [2024-04-25 22:21:16.433][1][debug][init] [source/common/init/watcher_impl.cc:14] init manager Listener-local-init-manager listener_web 10509624129060079268 initialized, notifying Listener-local-init-watcher listener_web [2024-04-25 22:21:16.433][1][debug][init] [source/common/init/watcher_impl.cc:14] target Listener-init-target listener_web initialized, notifying init manager Server [2024-04-25 22:21:16.433][1][debug][config] [source/common/listener_manager/listener_impl.cc:156] Create listen socket for listener listener_web on address 0.0.0.0:80 [2024-04-25 22:21:16.433][1][debug][config] [source/common/listener_manager/listener_impl.cc:166] listener_web: Setting socket options succeeded [2024-04-25 22:21:16.433][1][debug][config] [source/common/listener_manager/listener_impl.cc:109] Set listener listener_web socket factory local address to 0.0.0.0:80 [2024-04-25 22:21:16.433][1][debug][config] [source/common/listener_manager/listener_impl.cc:907] add active listener: name=listener_web, hash=10509624129060079268, tag=1, address=0.0.0.0:80 [2024-04-25 22:21:16.433][1][info][upstream] [source/common/listener_manager/lds_api.cc:102] lds: add/update listener 'listener_web' [2024-04-25 22:21:16.433][1][debug][init] [source/common/init/watcher_impl.cc:14] target LDS initialized, notifying init manager Server [2024-04-25 22:21:16.433][1][debug][init] [source/common/init/watcher_impl.cc:14] init manager Server initialized, notifying RunHelper [2024-04-25 22:21:16.433][1][info][config] [source/common/listener_manager/listener_manager_impl.cc:930] all dependencies initialized. starting workers [2024-04-25 22:21:16.433][1][debug][config] [source/common/listener_manager/listener_manager_impl.cc:967] starting worker 0 [2024-04-25 22:21:16.433][15][debug][main] [source/server/worker_impl.cc:143] worker entering dispatch loop [2024-04-25 22:21:16.433][15][debug][upstream] [source/common/upstream/cluster_manager_impl.cc:1285] adding TLS cluster new_api_grpc_cluster [2024-04-25 22:21:16.433][15][debug][upstream] [source/common/upstream/cluster_manager_impl.cc:1542] membership update for TLS cluster new_api_grpc_cluster added 1 removed 0 [2024-04-25 22:21:16.433][16][debug][grpc] [source/common/grpc/google_async_client_impl.cc:54] completionThread running [2024-04-25 22:21:16.433][15][debug][upstream] [source/common/upstream/cluster_manager_impl.cc:1285] adding TLS cluster ext-service_authz_cluster [2024-04-25 22:21:16.433][15][debug][upstream] [source/common/upstream/cluster_manager_impl.cc:1542] membership update for TLS cluster ext-service_authz_cluster added 1 removed 0 [2024-04-25 22:21:16.433][15][debug][lua] [./source/extensions/filters/common/lua/lua.h:182] registering new type: N5Envoy10Extensions7Filters6Common3Lua13BufferWrapperE [2024-04-25 22:21:16.433][15][debug][lua] [./source/extensions/filters/common/lua/lua.h:182] registering new type: N5Envoy10Extensions7Filters6Common3Lua18MetadataMapWrapperE [2024-04-25 22:21:16.433][15][debug][lua] [./source/extensions/filters/common/lua/lua.h:182] registering new type: N5Envoy10Extensions7Filters6Common3Lua19MetadataMapIteratorE [2024-04-25 22:21:16.433][15][debug][lua] [./source/extensions/filters/common/lua/lua.h:182] registering new type: N5Envoy10Extensions7Filters6Common3Lua17ConnectionWrapperE [2024-04-25 22:21:16.433][15][debug][lua] [./source/extensions/filters/common/lua/lua.h:182] registering new type: N5Envoy10Extensions7Filters6Common3Lua20SslConnectionWrapperE [2024-04-25 22:21:16.433][15][debug][lua] [./source/extensions/filters/common/lua/lua.h:182] registering new type: N5Envoy10Extensions11HttpFilters3Lua16HeaderMapWrapperE [2024-04-25 22:21:16.433][15][debug][lua] [./source/extensions/filters/common/lua/lua.h:182] registering new type: N5Envoy10Extensions11HttpFilters3Lua17HeaderMapIteratorE [2024-04-25 22:21:16.433][15][debug][lua] [./source/extensions/filters/common/lua/lua.h:182] registering new type: N5Envoy10Extensions11HttpFilters3Lua17StreamInfoWrapperE [2024-04-25 22:21:16.433][15][debug][lua] [./source/extensions/filters/common/lua/lua.h:182] registering new type: N5Envoy10Extensions11HttpFilters3Lua25DynamicMetadataMapWrapperE [2024-04-25 22:21:16.433][15][debug][lua] [./source/extensions/filters/common/lua/lua.h:182] registering new type: N5Envoy10Extensions11HttpFilters3Lua26DynamicMetadataMapIteratorE [2024-04-25 22:21:16.433][15][debug][lua] [./source/extensions/filters/common/lua/lua.h:182] registering new type: N5Envoy10Extensions11HttpFilters3Lua19StreamHandleWrapperE [2024-04-25 22:21:16.433][15][debug][lua] [./source/extensions/filters/common/lua/lua.h:182] registering new type: N5Envoy10Extensions11HttpFilters3Lua16PublicKeyWrapperE [2024-04-25 22:21:16.433][15][debug][lua] [./source/extensions/filters/common/lua/lua.h:182] registering new type: N5Envoy10Extensions11HttpFilters3Lua27ConnectionStreamInfoWrapperE [2024-04-25 22:21:16.434][15][debug][lua] [./source/extensions/filters/common/lua/lua.h:182] registering new type: N5Envoy10Extensions11HttpFilters3Lua35ConnectionDynamicMetadataMapWrapperE [2024-04-25 22:21:16.434][15][debug][lua] [./source/extensions/filters/common/lua/lua.h:182] registering new type: N5Envoy10Extensions11HttpFilters3Lua36ConnectionDynamicMetadataMapIteratorE [2024-04-25 22:21:16.434][1][debug][config] [source/extensions/config_subscription/filesystem/filesystem_subscription_impl.cc:91] Filesystem config update accepted for /var/lib/envoy/lds.yaml: resources { [type.googleapis.com/envoy.config.listener.v3.Listener] { name: "listener_web" address { socket_address { address: "0.0.0.0" port_value: 80 } } filter_chains { filters { name: "envoy.filters.network.http_connection_manager" typed_config { [type.googleapis.com/envoy.extensions.filters.network.http_connection_manager.v3.HttpConnectionManager] { stat_prefix: "ingress_http" route_config { name: "api_service_route_config" virtual_hosts { name: "api_service_route" domains: "*" routes { match { prefix: "/edugo.api.services.sms.v1.SmsApiService/SendSmsExternalGETV1" grpc { } } route { cluster: "new_api_grpc_cluster" timeout { seconds: 60 } } } } } http_filters { name: "envoy.filters.http.grpc_json_transcoder" typed_config { [type.googleapis.com/envoy.extensions.filters.http.grpc_json_transcoder.v3.GrpcJsonTranscoder] { proto_descriptor: "/var/lib/envoy/descriptors.binp" services: "edugo.api.services.sms.v1.SmsApiService" print_options { add_whitespace: true always_print_primitive_fields: true } auto_mapping: true convert_grpc_status: true } } } http_filters { name: "envoy.filters.http.ext_authz" typed_config { [type.googleapis.com/envoy.extensions.filters.http.ext_authz.v3.ExtAuthz] { grpc_service { envoy_grpc { cluster_name: "ext-service_authz_cluster" } timeout { seconds: 5 } } with_request_body { max_request_bytes: 819200 allow_partial_message: true pack_as_bytes: true } status_on_error { code: ServiceUnavailable } transport_api_version: V3 stat_prefix: "ext_authz" } } } http_filters { name: "envoy.filters.http.lua" typed_config { [type.googleapis.com/envoy.extensions.filters.http.lua.v3.Lua] { default_source_code { inline_string: "-- Called on the request path.\nfunction envoy_on_request(request_handle)\n local meta = request_handle:streamInfo():dynamicMetadata():get(\"envoy.filters.http.ext_authz\")\n local orgId = meta[\"x-edu-org-id\"]\n local uri = request_handle:headers():get(\":path\")\n request_handle:logCritical(\" request: \"..uri)\n request_handle:logCritical(\" orgId: \"..orgId)\nend\n\nfunction envoy_on_response(response_handle)\n response_handle:logCritical(\"Before reading response body\")\n local bufferResp = response_handle:body()\n response_handle:logCritical(\"After reading response body\") \nend\n" } } } } http_filters { name: "envoy.filters.http.router" typed_config { [type.googleapis.com/envoy.extensions.filters.http.router.v3.Router] { } } } http2_protocol_options { max_concurrent_streams { value: 100 } initial_stream_window_size { value: 65536 } initial_connection_window_size { value: 1048576 } } drain_timeout { seconds: 30 } access_log { name: "envoy.access_loggers.stdout" typed_config { [type.googleapis.com/envoy.extensions.access_loggers.stream.v3.StdoutAccessLog] { log_format { json_format { fields { key: "@timestamp" value { string_value: "%START_TIME%" } } fields { key: "client.address" value { string_value: "%DOWNSTREAM_REMOTE_ADDRESS%" } } fields { key: "client.local.address" value { string_value: "%DOWNSTREAM_LOCAL_ADDRESS%" } } fields { key: "envoy.route.name" value { string_value: "%ROUTE_NAME%" } } fields { key: "envoy.upstream.cluster" value { string_value: "%UPSTREAM_CLUSTER%" } } fields { key: "host.hostname" value { string_value: "%HOSTNAME%" } } fields { key: "http.request.body.bytes" value { string_value: "%BYTES_RECEIVED%" } } fields { key: "http.request.duration" value { string_value: "%DURATION%" } } fields { key: "http.request.headers.accept" value { string_value: "%REQ(ACCEPT)%" } } fields { key: "http.request.headers.authority" value { string_value: "%REQ(:AUTHORITY)%" } } fields { key: "http.request.headers.id" value { string_value: "%REQ(X-REQUEST-ID)%" } } fields { key: "http.request.headers.traceparent" value { string_value: "%REQ(TRACEPARENT)%" } } fields { key: "http.request.headers.x_forwarded_for" value { string_value: "%REQ(X-FORWARDED-FOR)%" } } fields { key: "http.request.headers.x_forwarded_proto" value { string_value: "%REQ(X-FORWARDED-PROTO)%" } } fields { key: "http.request.method" value { string_value: "%REQ(:METHOD)%" } } fields { key: "http.request.path" value { string_value: "%REQ(X-ENVOY-ORIGINAL-PATH?:PATH)%" } } fields { key: "http.request.protocol" value { string_value: "%PROTOCOL%" } } fields { key: "http.request.start_time" value { string_value: "%START_TIME%" } } fields { key: "http.response.body.bytes" value { string_value: "%BYTES_SENT%" } } fields { key: "http.response.response_code" value { string_value: "%RESPONSE_CODE%" } } fields { key: "http.response.response_flag" value { string_value: "%RESPONSE_FLAGS%" } } fields { key: "service.name" value { string_value: "envoy" } } fields { key: "service.version" value { string_value: "1.28" } } fields { key: "x-request-id" value { string_value: "%REQ(X-REQUEST-ID)%" } } } } } } } generate_request_id { value: true } stream_idle_timeout { seconds: 30 } delayed_close_timeout { seconds: 30 } request_timeout { seconds: 30 } normalize_path { value: true } merge_slashes: true common_http_protocol_options { idle_timeout { seconds: 3600 } } always_set_request_id_in_response: true stream_error_on_invalid_http_message { value: true } request_headers_timeout { seconds: 30 } path_with_escaped_slashes_action: UNESCAPE_AND_REDIRECT } } } } } } [2024-04-25 22:21:21.423][1][debug][main] [source/server/server.cc:241] flushing stats [2024-04-25 22:21:21.424][1][debug][dns] [source/extensions/network/dns_resolver/cares/dns_impl.cc:369] dns resolution for host.docker.internal started [2024-04-25 22:21:21.425][1][debug][dns] [source/extensions/network/dns_resolver/cares/dns_impl.cc:369] dns resolution for host.docker.internal started [2024-04-25 22:21:21.426][1][debug][dns] [source/extensions/network/dns_resolver/cares/dns_impl.cc:289] dns resolution for host.docker.internal completed with status 0 [2024-04-25 22:21:21.426][1][debug][upstream] [source/common/upstream/upstream_impl.cc:458] transport socket match, socket default selected for host with address 192.168.65.254:8893 [2024-04-25 22:21:21.426][1][debug][upstream] [source/extensions/clusters/strict_dns/strict_dns_cluster.cc:177] DNS refresh rate reset for host.docker.internal, refresh rate 5000 ms [2024-04-25 22:21:21.426][1][debug][dns] [source/extensions/network/dns_resolver/cares/dns_impl.cc:289] dns resolution for host.docker.internal completed with status 0 [2024-04-25 22:21:21.426][1][debug][upstream] [source/extensions/clusters/logical_dns/logical_dns_cluster.cc:152] DNS refresh rate reset for host.docker.internal, refresh rate 5000 ms [2024-04-25 22:21:26.423][1][debug][main] [source/server/server.cc:241] flushing stats [2024-04-25 22:21:26.426][1][debug][dns] [source/extensions/network/dns_resolver/cares/dns_impl.cc:369] dns resolution for host.docker.internal started [2024-04-25 22:21:26.427][1][debug][dns] [source/extensions/network/dns_resolver/cares/dns_impl.cc:369] dns resolution for host.docker.internal started [2024-04-25 22:21:26.428][1][debug][dns] [source/extensions/network/dns_resolver/cares/dns_impl.cc:289] dns resolution for host.docker.internal completed with status 0 [2024-04-25 22:21:26.428][1][debug][upstream] [source/common/upstream/upstream_impl.cc:458] transport socket match, socket default selected for host with address 192.168.65.254:8893 [2024-04-25 22:21:26.428][1][debug][upstream] [source/extensions/clusters/strict_dns/strict_dns_cluster.cc:177] DNS refresh rate reset for host.docker.internal, refresh rate 5000 ms [2024-04-25 22:21:26.428][1][debug][dns] [source/extensions/network/dns_resolver/cares/dns_impl.cc:289] dns resolution for host.docker.internal completed with status 0 [2024-04-25 22:21:26.428][1][debug][upstream] [source/extensions/clusters/logical_dns/logical_dns_cluster.cc:152] DNS refresh rate reset for host.docker.internal, refresh rate 5000 ms [2024-04-25 22:21:31.424][1][debug][main] [source/server/server.cc:241] flushing stats [2024-04-25 22:21:31.429][1][debug][dns] [source/extensions/network/dns_resolver/cares/dns_impl.cc:369] dns resolution for host.docker.internal started [2024-04-25 22:21:31.429][1][debug][dns] [source/extensions/network/dns_resolver/cares/dns_impl.cc:369] dns resolution for host.docker.internal started [2024-04-25 22:21:31.430][1][debug][dns] [source/extensions/network/dns_resolver/cares/dns_impl.cc:289] dns resolution for host.docker.internal completed with status 0 [2024-04-25 22:21:31.430][1][debug][upstream] [source/common/upstream/upstream_impl.cc:458] transport socket match, socket default selected for host with address 192.168.65.254:8893 [2024-04-25 22:21:31.430][1][debug][upstream] [source/extensions/clusters/strict_dns/strict_dns_cluster.cc:177] DNS refresh rate reset for host.docker.internal, refresh rate 5000 ms [2024-04-25 22:21:31.430][1][debug][dns] [source/extensions/network/dns_resolver/cares/dns_impl.cc:289] dns resolution for host.docker.internal completed with status 0 [2024-04-25 22:21:31.430][1][debug][upstream] [source/extensions/clusters/logical_dns/logical_dns_cluster.cc:152] DNS refresh rate reset for host.docker.internal, refresh rate 5000 ms [2024-04-25 22:21:36.426][1][debug][main] [source/server/server.cc:241] flushing stats [2024-04-25 22:21:36.430][1][debug][dns] [source/extensions/network/dns_resolver/cares/dns_impl.cc:369] dns resolution for host.docker.internal started [2024-04-25 22:21:36.431][1][debug][dns] [source/extensions/network/dns_resolver/cares/dns_impl.cc:369] dns resolution for host.docker.internal started [2024-04-25 22:21:36.431][1][debug][dns] [source/extensions/network/dns_resolver/cares/dns_impl.cc:289] dns resolution for host.docker.internal completed with status 0 [2024-04-25 22:21:36.432][1][debug][upstream] [source/common/upstream/upstream_impl.cc:458] transport socket match, socket default selected for host with address 192.168.65.254:8893 [2024-04-25 22:21:36.432][1][debug][upstream] [source/extensions/clusters/strict_dns/strict_dns_cluster.cc:177] DNS refresh rate reset for host.docker.internal, refresh rate 5000 ms [2024-04-25 22:21:36.432][1][debug][dns] [source/extensions/network/dns_resolver/cares/dns_impl.cc:289] dns resolution for host.docker.internal completed with status 0 [2024-04-25 22:21:36.432][1][debug][upstream] [source/extensions/clusters/logical_dns/logical_dns_cluster.cc:152] DNS refresh rate reset for host.docker.internal, refresh rate 5000 ms [2024-04-25 22:21:41.428][1][debug][main] [source/server/server.cc:241] flushing stats [2024-04-25 22:21:41.432][1][debug][dns] [source/extensions/network/dns_resolver/cares/dns_impl.cc:369] dns resolution for host.docker.internal started [2024-04-25 22:21:41.433][1][debug][dns] [source/extensions/network/dns_resolver/cares/dns_impl.cc:369] dns resolution for host.docker.internal started [2024-04-25 22:21:41.433][1][debug][dns] [source/extensions/network/dns_resolver/cares/dns_impl.cc:289] dns resolution for host.docker.internal completed with status 0 [2024-04-25 22:21:41.433][1][debug][upstream] [source/extensions/clusters/logical_dns/logical_dns_cluster.cc:152] DNS refresh rate reset for host.docker.internal, refresh rate 5000 ms [2024-04-25 22:21:41.433][1][debug][dns] [source/extensions/network/dns_resolver/cares/dns_impl.cc:289] dns resolution for host.docker.internal completed with status 0 [2024-04-25 22:21:41.433][1][debug][upstream] [source/common/upstream/upstream_impl.cc:458] transport socket match, socket default selected for host with address 192.168.65.254:8893 [2024-04-25 22:21:41.433][1][debug][upstream] [source/extensions/clusters/strict_dns/strict_dns_cluster.cc:177] DNS refresh rate reset for host.docker.internal, refresh rate 5000 ms [2024-04-25 22:21:46.427][1][debug][main] [source/server/server.cc:241] flushing stats [2024-04-25 22:21:46.434][1][debug][dns] [source/extensions/network/dns_resolver/cares/dns_impl.cc:369] dns resolution for host.docker.internal started [2024-04-25 22:21:46.435][1][debug][dns] [source/extensions/network/dns_resolver/cares/dns_impl.cc:369] dns resolution for host.docker.internal started [2024-04-25 22:21:46.435][1][debug][dns] [source/extensions/network/dns_resolver/cares/dns_impl.cc:289] dns resolution for host.docker.internal completed with status 0 [2024-04-25 22:21:46.435][1][debug][upstream] [source/common/upstream/upstream_impl.cc:458] transport socket match, socket default selected for host with address 192.168.65.254:8893 [2024-04-25 22:21:46.435][1][debug][upstream] [source/extensions/clusters/strict_dns/strict_dns_cluster.cc:177] DNS refresh rate reset for host.docker.internal, refresh rate 5000 ms [2024-04-25 22:21:46.436][1][debug][dns] [source/extensions/network/dns_resolver/cares/dns_impl.cc:289] dns resolution for host.docker.internal completed with status 0 [2024-04-25 22:21:46.436][1][debug][upstream] [source/extensions/clusters/logical_dns/logical_dns_cluster.cc:152] DNS refresh rate reset for host.docker.internal, refresh rate 5000 ms [2024-04-25 22:21:48.956][15][debug][conn_handler] [source/common/listener_manager/active_tcp_listener.cc:160] [Tags: "ConnectionId":"0"] new connection from 192.168.65.1:29555 [2024-04-25 22:21:48.956][15][debug][http] [source/common/http/conn_manager_impl.cc:398] [Tags: "ConnectionId":"0"] new stream [2024-04-25 22:21:48.957][15][debug][http] [source/common/http/conn_manager_impl.cc:1147] [Tags: "ConnectionId":"0","StreamId":"18191014628947526340"] request headers complete (end_stream=true): ':authority', 'local.api.com' ':path', '/sms_grpc/v1/sms/v1/api/v1/org/sendsms?message=hello&senderId=fg&number=6778&templateId=123' ':method', 'GET' 'x-api-key', 'abcdefgh' 'postman-token', 'ec105acf-c79b-4ffd-930d-4a07d9480a79' [2024-04-25 22:21:48.957][15][debug][http] [source/common/http/conn_manager_impl.cc:1130] [Tags: "ConnectionId":"0","StreamId":"18191014628947526340"] request end stream [2024-04-25 22:21:48.957][15][debug][connection] [./source/common/network/connection_impl.h:98] [Tags: "ConnectionId":"0"] current connecting state: false [2024-04-25 22:21:48.957][15][debug][router] [source/common/router/config_impl.cc:1896] route was resolved but final route list did not match incoming request [2024-04-25 22:21:48.957][15][debug][http2] [source/extensions/filters/http/grpc_json_transcoder/json_transcoder_filter.cc:556] [Tags: "ConnectionId":"0","StreamId":"18191014628947526340"] adding initial data during decodeHeaders, transcoded data size=27 [2024-04-25 22:21:48.957][15][debug][ext_authz] [source/extensions/filters/http/ext_authz/ext_authz.cc:157] [Tags: "ConnectionId":"0","StreamId":"18191014628947526340"] ext_authz filter is buffering the request [2024-04-25 22:21:48.957][15][debug][ext_authz] [source/extensions/filters/http/ext_authz/ext_authz.cc:183] [Tags: "ConnectionId":"0","StreamId":"18191014628947526340"] ext_authz filter finished buffering the request since stream is ended [2024-04-25 22:21:48.957][15][trace][ext_authz] [source/extensions/filters/http/ext_authz/ext_authz.cc:111] [Tags: "ConnectionId":"0","StreamId":"18191014628947526340"] ext_authz filter calling authorization server [2024-04-25 22:21:48.957][15][trace][ext_authz] [source/extensions/filters/common/ext_authz/ext_authz_grpc_impl.cc:42] Sending CheckRequest: attributes { source { address { socket_address { address: "192.168.65.1" port_value: 29555 } } } destination { address { socket_address { address: "172.18.0.5" port_value: 80 } } } request { time { seconds: 1714083708 nanos: 956982000 } http { id: "18191014628947526340" method: "POST" headers { key: ":authority" value: "local.api.com" } headers { key: ":method" value: "POST" } headers { key: ":path" value: "/edugo.api.services.sms.v1.SmsApiService/SendSmsExternalGETV1" } headers { key: ":scheme" value: "http" } headers { key: "content-type" value: "application/grpc" } headers { key: "postman-token" value: "ec105acf-c79b-4ffd-930d-4a07d9480a79" } headers { key: "te" value: "trailers" } headers { key: "x-api-key" value: "abcdefgh" } headers { key: "x-envoy-auth-partial-body" value: "false" } headers { key: "x-envoy-original-method" value: "GET" } headers { key: "x-envoy-original-path" value: "/sms_grpc/v1/sms/v1/api/v1/org/sendsms?message=hello&senderId=fg&number=6778&templateId=123" } headers { key: "x-forwarded-proto" value: "http" } headers { key: "x-request-id" value: "3241b8e0-c1eb-46d8-8f1d-fce751fbad69" } path: "/edugo.api.services.sms.v1.SmsApiService/SendSmsExternalGETV1" host: "local.api.com" scheme: "http" protocol: "HTTP/1.1" raw_body: "\000\000\000\000\026\032\005hello\n\002fg\022\0046778*\003123" } } metadata_context { } route_metadata_context { } } [2024-04-25 22:21:48.957][15][debug][router] [source/common/router/router.cc:515] [Tags: "ConnectionId":"0","StreamId":"771224898757391252"] cluster 'ext-service_authz_cluster' match for URL '/envoy.service.auth.v3.Authorization/Check' [2024-04-25 22:21:48.957][15][debug][router] [source/common/router/router.cc:738] [Tags: "ConnectionId":"0","StreamId":"771224898757391252"] router decoding headers: ':method', 'POST' ':path', '/envoy.service.auth.v3.Authorization/Check' ':authority', 'ext-service_authz_cluster' ':scheme', 'http' 'te', 'trailers' 'grpc-timeout', '5000m' 'content-type', 'application/grpc' 'x-envoy-internal', 'true' 'x-forwarded-for', '172.18.0.5' 'x-envoy-expected-rq-timeout-ms', '5000' [2024-04-25 22:21:48.957][15][debug][pool] [source/common/http/conn_pool_base.cc:78] queueing stream due to no available connections (ready=0 busy=0 connecting=0) [2024-04-25 22:21:48.957][15][debug][pool] [source/common/conn_pool/conn_pool_base.cc:291] trying to create new connection [2024-04-25 22:21:48.957][15][debug][pool] [source/common/conn_pool/conn_pool_base.cc:145] creating a new connection (connecting=0) [2024-04-25 22:21:48.958][15][debug][http2] [source/common/http/http2/codec_impl.cc:1720] [Tags: "ConnectionId":"1"] updating connection-level initial window size to 268435456 [2024-04-25 22:21:48.958][15][debug][connection] [./source/common/network/connection_impl.h:98] [Tags: "ConnectionId":"1"] current connecting state: true [2024-04-25 22:21:48.958][15][debug][client] [source/common/http/codec_client.cc:57] [Tags: "ConnectionId":"1"] connecting [2024-04-25 22:21:48.958][15][debug][connection] [source/common/network/connection_impl.cc:1012] [Tags: "ConnectionId":"1"] connecting to 192.168.65.254:8893 [2024-04-25 22:21:48.958][15][debug][connection] [source/common/network/connection_impl.cc:1031] [Tags: "ConnectionId":"1"] connection in progress [2024-04-25 22:21:48.958][15][debug][connection] [source/common/network/connection_impl.cc:742] [Tags: "ConnectionId":"1"] connected [2024-04-25 22:21:48.959][15][debug][client] [source/common/http/codec_client.cc:88] [Tags: "ConnectionId":"1"] connected [2024-04-25 22:21:48.959][15][debug][pool] [source/common/conn_pool/conn_pool_base.cc:328] [Tags: "ConnectionId":"1"] attaching to next stream [2024-04-25 22:21:48.959][15][debug][pool] [source/common/conn_pool/conn_pool_base.cc:182] [Tags: "ConnectionId":"1"] creating stream [2024-04-25 22:21:48.959][15][debug][router] [source/common/router/upstream_request.cc:587] [Tags: "ConnectionId":"0","StreamId":"771224898757391252"] pool ready [2024-04-25 22:21:48.959][15][debug][client] [source/common/http/codec_client.cc:142] [Tags: "ConnectionId":"1"] encode complete [2024-04-25 22:21:48.959][15][debug][http2] [source/common/http/http2/codec_impl.cc:1898] [Tags: "ConnectionId":"1"] Http2Visitor::OnFrameHeader(0, 0, 4, 0) [2024-04-25 22:21:48.959][15][debug][http2] [source/common/http/http2/codec_impl.cc:1898] [Tags: "ConnectionId":"1"] Http2Visitor::OnFrameHeader(0, 6, 4, 0) [2024-04-25 22:21:48.959][15][debug][http2] [source/common/http/http2/codec_impl.cc:1898] [Tags: "ConnectionId":"1"] Http2Visitor::OnFrameHeader(0, 0, 4, 1) [2024-04-25 22:21:48.959][15][debug][http2] [source/common/http/http2/codec_impl.cc:1898] [Tags: "ConnectionId":"1"] Http2Visitor::OnFrameHeader(0, 4, 8, 0) [2024-04-25 22:21:48.959][15][debug][http2] [source/common/http/http2/codec_impl.cc:1898] [Tags: "ConnectionId":"1"] Http2Visitor::OnFrameHeader(0, 8, 6, 0) [2024-04-25 22:21:48.960][15][debug][http2] [source/common/http/http2/codec_impl.cc:1898] [Tags: "ConnectionId":"1"] Http2Visitor::OnFrameHeader(1, 14, 1, 4) [2024-04-25 22:21:48.960][15][debug][http2] [source/common/http/http2/codec_impl.cc:1942] [Tags: "ConnectionId":"1"] Http2Visitor::OnEndHeadersForStream(1) [2024-04-25 22:21:48.960][15][debug][router] [source/common/router/router.cc:1528] [Tags: "ConnectionId":"0","StreamId":"771224898757391252"] upstream headers complete: end_stream=false [2024-04-25 22:21:48.960][15][debug][http] [source/common/http/async_client_impl.cc:125] async http request response headers (end_stream=false): ':status', '200' 'content-type', 'application/grpc' 'x-envoy-upstream-service-time', '1' [2024-04-25 22:21:48.960][15][debug][http2] [source/common/http/http2/codec_impl.cc:1898] [Tags: "ConnectionId":"1"] Http2Visitor::OnFrameHeader(1, 695, 0, 0) [2024-04-25 22:21:48.960][15][debug][http2] [source/common/http/http2/codec_impl.cc:1950] [Tags: "ConnectionId":"1"] Http2Visitor::OnBeginDataForStream(1, 695) [2024-04-25 22:21:48.960][15][debug][http2] [source/common/http/http2/codec_impl.cc:1962] [Tags: "ConnectionId":"1"] Http2Visitor: remaining data payload: 695, end_stream: false [2024-04-25 22:21:48.960][15][debug][http2] [source/common/http/http2/codec_impl.cc:1991] [Tags: "ConnectionId":"1"] Http2Visitor dispatching DATA for stream 1 [2024-04-25 22:21:48.960][15][debug][http2] [source/common/http/http2/codec_impl.cc:1898] [Tags: "ConnectionId":"1"] Http2Visitor::OnFrameHeader(1, 24, 1, 5) [2024-04-25 22:21:48.960][15][debug][http2] [source/common/http/http2/codec_impl.cc:1942] [Tags: "ConnectionId":"1"] Http2Visitor::OnEndHeadersForStream(1) [2024-04-25 22:21:48.960][15][debug][client] [source/common/http/codec_client.cc:129] [Tags: "ConnectionId":"1"] response complete [2024-04-25 22:21:48.960][15][debug][pool] [source/common/conn_pool/conn_pool_base.cc:215] [Tags: "ConnectionId":"1"] destroying stream: 0 remaining [2024-04-25 22:21:48.960][15][debug][http] [source/common/http/async_client_impl.cc:152] async http request response trailers: 'grpc-status', '0' 'grpc-message', '' [2024-04-25 22:21:48.960][15][trace][ext_authz] [source/extensions/filters/common/ext_authz/ext_authz_grpc_impl.cc:48] Received CheckResponse: status { } ok_response { headers { header { key: "X-ORG-ID" value: "5b00abbab9" } } headers { header { key: ":scheme" value: "http" } keep_empty_value: true } headers { header { key: ":method" value: "POST" } keep_empty_value: true } headers { header { key: ":path" value: "/edugo.api.services.sms.v1.SmsApiService/SendSmsExternalGETV1" } keep_empty_value: true } headers { header { key: "x-forwarded-proto" value: "http" } keep_empty_value: true } headers { header { key: "postman-token" value: "ec105acf-c79b-4ffd-930d-4a07d9480a79" } keep_empty_value: true } headers { header { key: "te" value: "trailers" } keep_empty_value: true } headers { header { key: "x-envoy-auth-partial-body" value: "false" } keep_empty_value: true } headers { header { key: ":authority" value: "local.api.com" } keep_empty_value: true } headers { header { key: "x-envoy-original-method" value: "GET" } keep_empty_value: true } headers { header { key: "x-envoy-original-path" value: "/sms_grpc/v1/sms/v1/api/v1/org/sendsms?message=hello&senderId=fg&number=6778&templateId=123" } keep_empty_value: true } headers { header { key: "x-request-id" value: "3241b8e0-c1eb-46d8-8f1d-fce751fbad69" } keep_empty_value: true } headers { header { key: "content-type" value: "application/grpc" } keep_empty_value: true } headers_to_remove: "apikey" query_parameters_to_set { key: "org_id" value: "5b00abbab9" } } dynamic_metadata { fields { key: "x-edu-org-id" value { string_value: "5b00abbab9" } } } [2024-04-25 22:21:48.960][15][trace][ext_authz] [source/extensions/filters/http/ext_authz/ext_authz.cc:303] [Tags: "ConnectionId":"0","StreamId":"18191014628947526340"] ext_authz filter added header(s) to the request: [2024-04-25 22:21:48.960][15][trace][ext_authz] [source/extensions/filters/http/ext_authz/ext_authz.cc:305] [Tags: "ConnectionId":"0","StreamId":"18191014628947526340"] 'x-org-id':'5b00abbab9' [2024-04-25 22:21:48.960][15][trace][ext_authz] [source/extensions/filters/http/ext_authz/ext_authz.cc:305] [Tags: "ConnectionId":"0","StreamId":"18191014628947526340"] ':scheme':'http' [2024-04-25 22:21:48.960][15][trace][ext_authz] [source/extensions/filters/http/ext_authz/ext_authz.cc:305] [Tags: "ConnectionId":"0","StreamId":"18191014628947526340"] ':method':'POST' [2024-04-25 22:21:48.960][15][trace][ext_authz] [source/extensions/filters/http/ext_authz/ext_authz.cc:305] [Tags: "ConnectionId":"0","StreamId":"18191014628947526340"] ':path':'/edugo.api.services.sms.v1.SmsApiService/SendSmsExternalGETV1' [2024-04-25 22:21:48.960][15][trace][ext_authz] [source/extensions/filters/http/ext_authz/ext_authz.cc:305] [Tags: "ConnectionId":"0","StreamId":"18191014628947526340"] 'x-forwarded-proto':'http' [2024-04-25 22:21:48.960][15][trace][ext_authz] [source/extensions/filters/http/ext_authz/ext_authz.cc:305] [Tags: "ConnectionId":"0","StreamId":"18191014628947526340"] 'postman-token':'ec105acf-c79b-4ffd-930d-4a07d9480a79' [2024-04-25 22:21:48.960][15][trace][ext_authz] [source/extensions/filters/http/ext_authz/ext_authz.cc:305] [Tags: "ConnectionId":"0","StreamId":"18191014628947526340"] 'te':'trailers' [2024-04-25 22:21:48.960][15][trace][ext_authz] [source/extensions/filters/http/ext_authz/ext_authz.cc:305] [Tags: "ConnectionId":"0","StreamId":"18191014628947526340"] 'x-envoy-auth-partial-body':'false' [2024-04-25 22:21:48.960][15][trace][ext_authz] [source/extensions/filters/http/ext_authz/ext_authz.cc:305] [Tags: "ConnectionId":"0","StreamId":"18191014628947526340"] ':authority':'local.api.com' [2024-04-25 22:21:48.960][15][trace][ext_authz] [source/extensions/filters/http/ext_authz/ext_authz.cc:305] [Tags: "ConnectionId":"0","StreamId":"18191014628947526340"] 'x-envoy-original-method':'GET' [2024-04-25 22:21:48.960][15][trace][ext_authz] [source/extensions/filters/http/ext_authz/ext_authz.cc:305] [Tags: "ConnectionId":"0","StreamId":"18191014628947526340"] 'x-envoy-original-path':'/sms_grpc/v1/sms/v1/api/v1/org/sendsms?message=hello&senderId=fg&number=6778&templateId=123' [2024-04-25 22:21:48.960][15][trace][ext_authz] [source/extensions/filters/http/ext_authz/ext_authz.cc:305] [Tags: "ConnectionId":"0","StreamId":"18191014628947526340"] 'x-request-id':'3241b8e0-c1eb-46d8-8f1d-fce751fbad69' [2024-04-25 22:21:48.960][15][trace][ext_authz] [source/extensions/filters/http/ext_authz/ext_authz.cc:305] [Tags: "ConnectionId":"0","StreamId":"18191014628947526340"] 'content-type':'application/grpc' [2024-04-25 22:21:48.960][15][trace][ext_authz] [source/extensions/filters/http/ext_authz/ext_authz.cc:333] [Tags: "ConnectionId":"0","StreamId":"18191014628947526340"] ext_authz filter removed header(s) from the request: [2024-04-25 22:21:48.960][15][trace][ext_authz] [source/extensions/filters/http/ext_authz/ext_authz.cc:340] [Tags: "ConnectionId":"0","StreamId":"18191014628947526340"] 'apikey' [2024-04-25 22:21:48.960][15][trace][ext_authz] [source/extensions/filters/http/ext_authz/ext_authz.cc:361] [Tags: "ConnectionId":"0","StreamId":"18191014628947526340"] ext_authz filter set query parameter(s) on the request: [2024-04-25 22:21:48.960][15][trace][ext_authz] [source/extensions/filters/http/ext_authz/ext_authz.cc:363] [Tags: "ConnectionId":"0","StreamId":"18191014628947526340"] 'org_id=5b00abbab9' [2024-04-25 22:21:48.960][15][trace][ext_authz] [source/extensions/filters/http/ext_authz/ext_authz.cc:388] [Tags: "ConnectionId":"0","StreamId":"18191014628947526340"] ext_authz filter modified query parameter(s), using new path for request: /edugo.api.services.sms.v1.SmsApiService/SendSmsExternalGETV1?org_id=5b00abbab9 [2024-04-25 22:21:48.960][15][critical][lua] [source/extensions/filters/http/lua/lua_filter.cc:950] script log: request: /edugo.api.services.sms.v1.SmsApiService/SendSmsExternalGETV1?org_id=5b00abbab9 [2024-04-25 22:21:48.960][15][critical][lua] [source/extensions/filters/http/lua/lua_filter.cc:950] script log: orgId: 5b00abbab9 [2024-04-25 22:21:48.960][15][debug][lua] [source/extensions/filters/common/lua/lua.cc:39] coroutine finished [2024-04-25 22:21:48.960][15][debug][router] [source/common/router/router.cc:515] [Tags: "ConnectionId":"0","StreamId":"18191014628947526340"] cluster 'new_api_grpc_cluster' match for URL '/edugo.api.services.sms.v1.SmsApiService/SendSmsExternalGETV1?org_id=5b00abbab9' [2024-04-25 22:21:48.960][15][debug][router] [source/common/router/router.cc:738] [Tags: "ConnectionId":"0","StreamId":"18191014628947526340"] router decoding headers: ':scheme', 'http' ':method', 'POST' ':path', '/edugo.api.services.sms.v1.SmsApiService/SendSmsExternalGETV1?org_id=5b00abbab9' ':authority', 'local.api.com' 'x-api-key', 'abcdefgh' 'x-org-id', '5b00abbab9' 'x-forwarded-proto', 'http' 'postman-token', 'ec105acf-c79b-4ffd-930d-4a07d9480a79' 'te', 'trailers' 'x-envoy-auth-partial-body', 'false' 'x-envoy-original-method', 'GET' 'x-envoy-original-path', '/sms_grpc/v1/sms/v1/api/v1/org/sendsms?message=hello&senderId=fg&number=6778&templateId=123' 'x-request-id', '3241b8e0-c1eb-46d8-8f1d-fce751fbad69' 'content-type', 'application/grpc' 'x-envoy-expected-rq-timeout-ms', '60000' [2024-04-25 22:21:48.960][15][debug][pool] [source/common/http/conn_pool_base.cc:78] queueing stream due to no available connections (ready=0 busy=0 connecting=0) [2024-04-25 22:21:48.960][15][debug][pool] [source/common/conn_pool/conn_pool_base.cc:291] trying to create new connection [2024-04-25 22:21:48.960][15][debug][pool] [source/common/conn_pool/conn_pool_base.cc:145] creating a new connection (connecting=0) [2024-04-25 22:21:48.960][15][debug][http2] [source/common/http/http2/codec_impl.cc:1720] [Tags: "ConnectionId":"2"] updating connection-level initial window size to 268435456 [2024-04-25 22:21:48.960][15][debug][connection] [./source/common/network/connection_impl.h:98] [Tags: "ConnectionId":"2"] current connecting state: true [2024-04-25 22:21:48.960][15][debug][client] [source/common/http/codec_client.cc:57] [Tags: "ConnectionId":"2"] connecting [2024-04-25 22:21:48.960][15][debug][connection] [source/common/network/connection_impl.cc:1012] [Tags: "ConnectionId":"2"] connecting to 192.168.65.254:8897 [2024-04-25 22:21:48.960][15][debug][connection] [source/common/network/connection_impl.cc:1031] [Tags: "ConnectionId":"2"] connection in progress [2024-04-25 22:21:48.960][15][debug][http2] [source/common/http/http2/codec_impl.cc:2003] [Tags: "ConnectionId":"1"] Http2Visitor::OnEndStream(1) [2024-04-25 22:21:48.960][15][debug][http2] [source/common/http/http2/codec_impl.cc:1467] [Tags: "ConnectionId":"1"] stream 1 closed: 0 [2024-04-25 22:21:48.960][15][debug][http2] [source/common/http/http2/codec_impl.cc:1530] [Tags: "ConnectionId":"1"] Recouping 0 bytes of flow control window for stream 1. [2024-04-25 22:21:48.960][15][debug][http2] [source/common/http/http2/codec_impl.cc:2025] [Tags: "ConnectionId":"1"] Http2Visitor invoking stream close listener for 1 [2024-04-25 22:21:48.961][15][debug][connection] [source/common/network/connection_impl.cc:742] [Tags: "ConnectionId":"2"] connected [2024-04-25 22:21:48.961][15][debug][client] [source/common/http/codec_client.cc:88] [Tags: "ConnectionId":"2"] connected [2024-04-25 22:21:48.961][15][debug][pool] [source/common/conn_pool/conn_pool_base.cc:328] [Tags: "ConnectionId":"2"] attaching to next stream [2024-04-25 22:21:48.961][15][debug][pool] [source/common/conn_pool/conn_pool_base.cc:182] [Tags: "ConnectionId":"2"] creating stream [2024-04-25 22:21:48.961][15][debug][router] [source/common/router/upstream_request.cc:587] [Tags: "ConnectionId":"0","StreamId":"18191014628947526340"] pool ready [2024-04-25 22:21:48.961][15][debug][client] [source/common/http/codec_client.cc:142] [Tags: "ConnectionId":"2"] encode complete [2024-04-25 22:21:48.961][15][debug][http2] [source/common/http/http2/codec_impl.cc:1898] [Tags: "ConnectionId":"2"] Http2Visitor::OnFrameHeader(0, 0, 4, 0) [2024-04-25 22:21:48.961][15][debug][http2] [source/common/http/http2/codec_impl.cc:1898] [Tags: "ConnectionId":"2"] Http2Visitor::OnFrameHeader(0, 6, 4, 0) [2024-04-25 22:21:48.961][15][debug][http2] [source/common/http/http2/codec_impl.cc:1898] [Tags: "ConnectionId":"2"] Http2Visitor::OnFrameHeader(0, 0, 4, 1) [2024-04-25 22:21:48.961][15][debug][http2] [source/common/http/http2/codec_impl.cc:1898] [Tags: "ConnectionId":"2"] Http2Visitor::OnFrameHeader(0, 4, 8, 0) [2024-04-25 22:21:48.961][15][debug][http2] [source/common/http/http2/codec_impl.cc:1898] [Tags: "ConnectionId":"2"] Http2Visitor::OnFrameHeader(0, 8, 6, 0) [2024-04-25 22:21:48.961][15][debug][http2] [source/common/http/http2/codec_impl.cc:1898] [Tags: "ConnectionId":"2"] Http2Visitor::OnFrameHeader(1, 125, 1, 5) [2024-04-25 22:21:48.961][15][debug][http2] [source/common/http/http2/codec_impl.cc:1942] [Tags: "ConnectionId":"2"] Http2Visitor::OnEndHeadersForStream(1) [2024-04-25 22:21:48.961][15][debug][client] [source/common/http/codec_client.cc:129] [Tags: "ConnectionId":"2"] response complete [2024-04-25 22:21:48.961][15][debug][pool] [source/common/conn_pool/conn_pool_base.cc:215] [Tags: "ConnectionId":"2"] destroying stream: 0 remaining [2024-04-25 22:21:48.961][15][debug][router] [source/common/router/router.cc:1528] [Tags: "ConnectionId":"0","StreamId":"18191014628947526340"] upstream headers complete: end_stream=true [2024-04-25 22:21:48.961][15][critical][lua] [source/extensions/filters/http/lua/lua_filter.cc:950] script log: Before reading response body [2024-04-25 22:21:48.961][15][debug][lua] [source/extensions/filters/http/lua/lua_filter.cc:538] end stream. no body [2024-04-25 22:21:48.961][15][critical][lua] [source/extensions/filters/http/lua/lua_filter.cc:950] script log: After reading response body [2024-04-25 22:21:48.961][15][debug][lua] [source/extensions/filters/common/lua/lua.cc:39] coroutine finished [2024-04-25 22:21:48.961][15][trace][ext_authz] [source/extensions/filters/http/ext_authz/ext_authz.cc:221] [Tags: "ConnectionId":"0","StreamId":"18191014628947526340"] ext_authz filter has 0 response header(s) to add and 0 response header(s) to set to the encoded response: [2024-04-25 22:21:48.961][15][debug][http] [source/common/http/conn_manager_impl.cc:1838] [Tags: "ConnectionId":"0","StreamId":"18191014628947526340"] encoding headers via codec (end_stream=false): ':status', '501' 'content-type', 'application/json' 'x-envoy-upstream-service-time', '1' 'content-length', '167' 'date', 'Thu, 25 Apr 2024 22:21:48 GMT' 'server', 'envoy' 'x-request-id', '3241b8e0-c1eb-46d8-8f1d-fce751fbad69' [2024-04-25 22:21:48.961][15][debug][http] [source/common/http/conn_manager_impl.cc:1950] [Tags: "ConnectionId":"0","StreamId":"18191014628947526340"] Codec completed encoding stream. [2024-04-25 22:21:48.962][15][debug][http2] [source/common/http/http2/codec_impl.cc:2003] [Tags: "ConnectionId":"2"] Http2Visitor::OnEndStream(1) [2024-04-25 22:21:48.962][15][debug][http2] [source/common/http/http2/codec_impl.cc:1467] [Tags: "ConnectionId":"2"] stream 1 closed: 0 [2024-04-25 22:21:48.962][15][debug][http2] [source/common/http/http2/codec_impl.cc:1530] [Tags: "ConnectionId":"2"] Recouping 0 bytes of flow control window for stream 1. [2024-04-25 22:21:48.962][15][debug][http2] [source/common/http/http2/codec_impl.cc:2025] [Tags: "ConnectionId":"2"] Http2Visitor invoking stream close listener for 1 {"x-request-id":"3241b8e0-c1eb-46d8-8f1d-fce751fbad69","http.request.path":"/sms_grpc/v1/sms/v1/api/v1/org/sendsms?message=hello&senderId=fg&number=6778&templateId=123","client.address":"192.168.65.1:29555","service.name":"envoy","envoy.route.name":null,"host.hostname":"1dedda576632","http.request.headers.x_forwarded_proto":"http","http.response.response_flag":"-","http.response.body.bytes":167,"http.request.body.bytes":0,"http.request.headers.authority":"local.api.com","service.version":"1.28","@timestamp":"2024-04-25T22:21:48.956Z","client.local.address":"172.18.0.5:80","http.request.duration":4,"http.request.headers.x_forwarded_for":null,"http.request.method":"POST","http.response.response_code":501,"envoy.upstream.cluster":"new_api_grpc_cluster","http.request.headers.traceparent":null,"http.request.start_time":"2024-04-25T22:21:48.956Z","http.request.protocol":"HTTP/1.1","http.request.headers.id":"3241b8e0-c1eb-46d8-8f1d-fce751fbad69","http.request.headers.accept":null} [2024-04-25 22:21:48.964][15][debug][connection] [source/common/network/connection_impl.cc:710] [Tags: "ConnectionId":"0"] remote close [2024-04-25 22:21:48.964][15][debug][connection] [source/common/network/connection_impl.cc:272] [Tags: "ConnectionId":"0"] closing socket: 0 [2024-04-25 22:21:48.964][15][debug][conn_handler] [source/common/listener_manager/active_stream_listener_base.cc:136] [Tags: "ConnectionId":"0"] adding to cleanup list [2024-04-25 22:21:51.427][1][debug][main] [source/server/server.cc:241] flushing stats [2024-04-25 22:21:51.436][1][debug][dns] [source/extensions/network/dns_resolver/cares/dns_impl.cc:369] dns resolution for host.docker.internal started [2024-04-25 22:21:51.437][1][debug][dns] [source/extensions/network/dns_resolver/cares/dns_impl.cc:369] dns resolution for host.docker.internal started [2024-04-25 22:21:51.441][1][debug][dns] [source/extensions/network/dns_resolver/cares/dns_impl.cc:289] dns resolution for host.docker.internal completed with status 0 [2024-04-25 22:21:51.441][1][debug][upstream] [source/extensions/clusters/logical_dns/logical_dns_cluster.cc:152] DNS refresh rate reset for host.docker.internal, refresh rate 5000 ms [2024-04-25 22:21:51.442][1][debug][dns] [source/extensions/network/dns_resolver/cares/dns_impl.cc:289] dns resolution for host.docker.internal completed with status 0 [2024-04-25 22:21:51.442][1][debug][upstream] [source/common/upstream/upstream_impl.cc:458] transport socket match, socket default selected for host with address 192.168.65.254:8893 [2024-04-25 22:21:51.442][1][debug][upstream] [source/extensions/clusters/strict_dns/strict_dns_cluster.cc:177] DNS refresh rate reset for host.docker.internal, refresh rate 5000 ms [2024-04-25 22:21:53.960][15][debug][http2] [source/common/http/http2/codec_impl.cc:1898] [Tags: "ConnectionId":"1"] Http2Visitor::OnFrameHeader(0, 8, 6, 0) [2024-04-25 22:21:53.962][15][debug][http2] [source/common/http/http2/codec_impl.cc:1898] [Tags: "ConnectionId":"2"] Http2Visitor::OnFrameHeader(0, 8, 6, 0) [2024-04-25 22:21:56.428][1][debug][main] [source/server/server.cc:241] flushing stats [2024-04-25 22:21:56.441][1][debug][dns] [source/extensions/network/dns_resolver/cares/dns_impl.cc:369] dns resolution for host.docker.internal started [2024-04-25 22:21:56.442][1][debug][dns] [source/extensions/network/dns_resolver/cares/dns_impl.cc:369] dns resolution for host.docker.internal started [2024-04-25 22:21:56.443][1][debug][dns] [source/extensions/network/dns_resolver/cares/dns_impl.cc:289] dns resolution for host.docker.internal completed with status 0 [2024-04-25 22:21:56.444][1][debug][upstream] [source/common/upstream/upstream_impl.cc:458] transport socket match, socket default selected for host with address 192.168.65.254:8893 [2024-04-25 22:21:56.444][1][debug][upstream] [source/extensions/clusters/strict_dns/strict_dns_cluster.cc:177] DNS refresh rate reset for host.docker.internal, refresh rate 5000 ms [2024-04-25 22:21:56.444][1][debug][dns] [source/extensions/network/dns_resolver/cares/dns_impl.cc:289] dns resolution for host.docker.internal completed with status 0 [2024-04-25 22:21:56.444][1][debug][upstream] [source/extensions/clusters/logical_dns/logical_dns_cluster.cc:152] DNS refresh rate reset for host.docker.internal, refresh rate 5000 ms [2024-04-25 22:21:58.962][15][debug][http2] [source/common/http/http2/codec_impl.cc:1898] [Tags: "ConnectionId":"1"] Http2Visitor::OnFrameHeader(0, 8, 6, 0) [2024-04-25 22:21:58.964][15][debug][http2] [source/common/http/http2/codec_impl.cc:1898] [Tags: "ConnectionId":"2"] Http2Visitor::OnFrameHeader(0, 8, 6, 0) [2024-04-25 22:22:01.429][1][debug][main] [source/server/server.cc:241] flushing stats