github.com/verrazzano/verrazzano@v1.7.1/tools/vz/pkg/internal/test/cluster/image-pull-case1/cluster-snapshot/bobs-books/bobbys-helidon-stock-application-7965cf98f5-kfdmx/logs.txt (about) 1 # Copyright (c) 2021, 2024, Oracle and/or its affiliates. 2 # Licensed under the Universal Permissive License v 1.0 as shown at https://oss.oracle.com/licenses/upl. 3 4 ==== START logs for container istio-init of pod bobs-books/bobbys-helidon-stock-application-7965cf98f5-kfdmx ==== 5 Environment: 6 ------------ 7 ENVOY_PORT= 8 INBOUND_CAPTURE_PORT= 9 ISTIO_INBOUND_INTERCEPTION_MODE= 10 ISTIO_INBOUND_TPROXY_MARK= 11 ISTIO_INBOUND_TPROXY_ROUTE_TABLE= 12 ISTIO_INBOUND_PORTS= 13 ISTIO_OUTBOUND_PORTS= 14 ISTIO_LOCAL_EXCLUDE_PORTS= 15 ISTIO_SERVICE_CIDR= 16 ISTIO_SERVICE_EXCLUDE_CIDR= 17 18 Variables: 19 ---------- 20 PROXY_PORT=15001 21 PROXY_INBOUND_CAPTURE_PORT=15006 22 PROXY_TUNNEL_PORT=15008 23 PROXY_UID=1337 24 PROXY_GID=1337 25 INBOUND_INTERCEPTION_MODE=REDIRECT 26 INBOUND_TPROXY_MARK=1337 27 INBOUND_TPROXY_ROUTE_TABLE=133 28 INBOUND_PORTS_INCLUDE=* 29 INBOUND_PORTS_EXCLUDE=15090,15021,15020 30 OUTBOUND_IP_RANGES_INCLUDE=* 31 OUTBOUND_IP_RANGES_EXCLUDE= 32 OUTBOUND_PORTS_INCLUDE= 33 OUTBOUND_PORTS_EXCLUDE= 34 KUBEVIRT_INTERFACES= 35 ENABLE_INBOUND_IPV6=false 36 37 Writing following contents to rules file: /tmp/iptables-rules-1615834927333905066.txt141461451 38 * nat 39 -N ISTIO_INBOUND 40 -N ISTIO_REDIRECT 41 -N ISTIO_IN_REDIRECT 42 -N ISTIO_OUTPUT 43 -A ISTIO_INBOUND -p tcp --dport 15008 -j RETURN 44 -A ISTIO_REDIRECT -p tcp -j REDIRECT --to-ports 15001 45 -A ISTIO_IN_REDIRECT -p tcp -j REDIRECT --to-ports 15006 46 -A PREROUTING -p tcp -j ISTIO_INBOUND 47 -A ISTIO_INBOUND -p tcp --dport 22 -j RETURN 48 -A ISTIO_INBOUND -p tcp --dport 15090 -j RETURN 49 -A ISTIO_INBOUND -p tcp --dport 15021 -j RETURN 50 -A ISTIO_INBOUND -p tcp --dport 15020 -j RETURN 51 -A ISTIO_INBOUND -p tcp -j ISTIO_IN_REDIRECT 52 -A OUTPUT -p tcp -j ISTIO_OUTPUT 53 -A ISTIO_OUTPUT -o lo -s REDACTED-IP4-ADDRESS/32 -j RETURN 54 -A ISTIO_OUTPUT -o lo ! -d REDACTED-IP4-ADDRESS/32 -m owner --uid-owner 1337 -j ISTIO_IN_REDIRECT 55 -A ISTIO_OUTPUT -o lo -m owner ! --uid-owner 1337 -j RETURN 56 -A ISTIO_OUTPUT -m owner --uid-owner 1337 -j RETURN 57 -A ISTIO_OUTPUT -o lo ! -d REDACTED-IP4-ADDRESS/32 -m owner --gid-owner 1337 -j ISTIO_IN_REDIRECT 58 -A ISTIO_OUTPUT -o lo -m owner ! --gid-owner 1337 -j RETURN 59 -A ISTIO_OUTPUT -m owner --gid-owner 1337 -j RETURN 60 -A ISTIO_OUTPUT -d REDACTED-IP4-ADDRESS/32 -j RETURN 61 -A ISTIO_OUTPUT -j ISTIO_REDIRECT 62 COMMIT 63 64 iptables-restore --noflush /tmp/iptables-rules-1615834927333905066.txt141461451 65 Writing following contents to rules file: /tmp/ip6tables-rules-1615834927357435162.txt891629230 66 67 ip6tables-restore --noflush /tmp/ip6tables-rules-1615834927357435162.txt891629230 68 iptables-save 69 # Generated by iptables-save v1.8.4 on Mon Mar 15 19:02:07 2021 70 *nat 71 :PREROUTING ACCEPT [0:0] 72 :INPUT ACCEPT [0:0] 73 :POSTROUTING ACCEPT [0:0] 74 :OUTPUT ACCEPT [0:0] 75 :ISTIO_INBOUND - [0:0] 76 :ISTIO_REDIRECT - [0:0] 77 :ISTIO_IN_REDIRECT - [0:0] 78 :ISTIO_OUTPUT - [0:0] 79 -A PREROUTING -p tcp -j ISTIO_INBOUND 80 -A OUTPUT -p tcp -j ISTIO_OUTPUT 81 -A ISTIO_INBOUND -p tcp -m tcp --dport 15008 -j RETURN 82 -A ISTIO_INBOUND -p tcp -m tcp --dport 22 -j RETURN 83 -A ISTIO_INBOUND -p tcp -m tcp --dport 15090 -j RETURN 84 -A ISTIO_INBOUND -p tcp -m tcp --dport 15021 -j RETURN 85 -A ISTIO_INBOUND -p tcp -m tcp --dport 15020 -j RETURN 86 -A ISTIO_INBOUND -p tcp -j ISTIO_IN_REDIRECT 87 -A ISTIO_REDIRECT -p tcp -j REDIRECT --to-ports 15001 88 -A ISTIO_IN_REDIRECT -p tcp -j REDIRECT --to-ports 15006 89 -A ISTIO_OUTPUT -s REDACTED-IP4-ADDRESS/32 -o lo -j RETURN 90 -A ISTIO_OUTPUT ! -d REDACTED-IP4-ADDRESS/32 -o lo -m owner --uid-owner 1337 -j ISTIO_IN_REDIRECT 91 -A ISTIO_OUTPUT -o lo -m owner ! --uid-owner 1337 -j RETURN 92 -A ISTIO_OUTPUT -m owner --uid-owner 1337 -j RETURN 93 -A ISTIO_OUTPUT ! -d REDACTED-IP4-ADDRESS/32 -o lo -m owner --gid-owner 1337 -j ISTIO_IN_REDIRECT 94 -A ISTIO_OUTPUT -o lo -m owner ! --gid-owner 1337 -j RETURN 95 -A ISTIO_OUTPUT -m owner --gid-owner 1337 -j RETURN 96 -A ISTIO_OUTPUT -d REDACTED-IP4-ADDRESS/32 -j RETURN 97 -A ISTIO_OUTPUT -j ISTIO_REDIRECT 98 COMMIT 99 # Completed on Mon Mar 15 19:02:07 2021 100 ==== END logs for container istio-init of pod bobs-books/bobbys-helidon-stock-application-7965cf98f5-kfdmx ==== 101 ==== START logs for container bobbys-helidon-stock-application of pod bobs-books/bobbys-helidon-stock-application-7965cf98f5-kfdmx ==== 102 2021.03.15 19:02:15 INFO org.jboss.weld.Version !thread!: WELD-000900: 3.1.1 (Final) 103 2021.03.15 19:02:16 INFO org.jboss.weld.Bootstrap !thread!: WELD-ENV-000020: Using jandex for bean discovery 104 WARNING: An illegal reflective access operation has occurred 105 WARNING: Illegal reflective access by org.jboss.weld.util.bytecode.ClassFileUtils$1 (file:/app/libs/weld-core-impl-3.1.1.Final.jar) to method java.lang.ClassLoader.defineClass(java.lang.String,byte[],int,int) 106 WARNING: Please consider reporting this to the maintainers of org.jboss.weld.util.bytecode.ClassFileUtils$1 107 WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations 108 WARNING: All illegal access operations will be denied in a future release 109 2021.03.15 19:02:16 INFO org.jboss.weld.Bootstrap !thread!: WELD-000101: Transactional services not available. Injection of @Inject UserTransaction not available. Transactional observers will be invoked synchronously. 110 2021.03.15 19:02:17 INFO org.jboss.weld.Event !thread!: WELD-000411: Observer method [BackedAnnotatedMethod] private io.helidon.microprofile.openapi.IndexBuilder.processAnnotatedType(@Observes ProcessAnnotatedType<X>) receives events for all annotated types. Consider restricting events using @WithAnnotations or a generic type with bounds. 111 2021.03.15 19:02:17 INFO org.jboss.weld.Event !thread!: WELD-000411: Observer method [BackedAnnotatedMethod] public org.glassfish.jersey.ext.cdi1x.internal.ProcessAllAnnotatedTypes.processAnnotatedType(@Observes ProcessAnnotatedType<?>, BeanManager) receives events for all annotated types. Consider restricting events using @WithAnnotations or a generic type with bounds. 112 2021.03.15 19:02:19 INFO org.jboss.weld.Bootstrap !thread!: WELD-ENV-002003: Weld SE container 73cc4232-6051-4215-91a4-cd0be44226d8 initialized 113 2021.03.15 19:02:19 INFO io.helidon.microprofile.security.SecurityMpService !thread!: Security extension for microprofile is enabled, yet security configuration is missing from config (requires providers configuration at key security.providers). Security will not have any valid provider. 114 2021.03.15 19:02:22 INFO io.helidon.webserver.NettyWebServer !thread!: Version: 1.4.4 115 2021.03.15 19:02:22 INFO io.helidon.webserver.NettyWebServer !thread!: Channel '@default' started: [id: 0xfc765951, L:/[0:0:0:0:0:0:0:0]:8080] 116 2021.03.15 19:02:22 INFO io.helidon.microprofile.server.ServerImpl !thread!: Server initialized on http://localhost:8080 (and all other host addresses) in 9948 milliseconds. 117 2021.03.15 19:02:22 INFO org.books.bobby.Main !thread!: http://localhost:8080/books 118 2021.03.15 19:22:24 INFO org.books.bobby.BookStore !thread!: initializing caches 119 2021-03-15 19:22:25.628/1213.738 Oracle Coherence 20.12 <Info> (thread=helidon-1, member=n/a): Loaded operational configuration from "jar:file:/app/libs/coherence-20.12.jar!/tangosol-coherence.xml" 120 2021-03-15 19:22:25.680/1213.789 Oracle Coherence 20.12 <Info> (thread=helidon-1, member=n/a): Loaded operational overrides from "jar:file:/app/libs/coherence-20.12.jar!/tangosol-coherence-override-dev.xml" 121 2021-03-15 19:22:25.682/1213.790 Oracle Coherence 20.12 <Info> (thread=helidon-1, member=n/a): Optional configuration override "/tangosol-coherence-override.xml" is not specified 122 2021-03-15 19:22:25.685/1213.794 Oracle Coherence 20.12 <Info> (thread=helidon-1, member=n/a): Optional configuration override "cache-factory-config.xml" is not specified 123 2021-03-15 19:22:25.686/1213.794 Oracle Coherence 20.12 <Info> (thread=helidon-1, member=n/a): Optional configuration override "cache-factory-builder-config.xml" is not specified 124 2021-03-15 19:22:25.687/1213.795 Oracle Coherence 20.12 <Info> (thread=helidon-1, member=n/a): Optional configuration override "/custom-mbeans.xml" is not specified 125 126 Oracle Coherence Version 20.12 Build 83712 127 Community Edition: Development mode 128 Copyright (c) 2000, 2020, Oracle and/or its affiliates. All rights reserved. 129 130 2021-03-15 19:22:25.909/1214.017 Oracle Coherence CE 20.12 <Info> (thread=helidon-1, member=n/a): Loaded cache configuration from "jar:file:/app/bobbys-helidon-stock-application.jar!/coherence-cache-config.xml" 131 2021-03-15 19:22:26.354/1214.462 Oracle Coherence CE 20.12 <Info> (thread=helidon-1, member=n/a): The cluster name has not been configured, a value of "root's cluster" has been automatically generated 132 2021-03-15 19:22:26.408/1214.517 Oracle Coherence CE 20.12 <D5> (thread=helidon-1, member=n/a): Created cache factory com.tangosol.net.ExtensibleConfigurableCacheFactory 133 2021-03-15 19:22:26.565/1214.674 Oracle Coherence CE 20.12 <Info> (thread=bobbys-proxy-service:TcpInitiator, member=n/a): Loaded POF configuration from "jar:file:/app/bobbys-helidon-stock-application.jar!/pof-config.xml" 134 2021-03-15 19:22:26.602/1214.711 Oracle Coherence CE 20.12 <Info> (thread=bobbys-proxy-service:TcpInitiator, member=n/a): Loaded included POF configuration from "jar:file:/app/libs/coherence-20.12.jar!/coherence-pof-config.xml" 135 2021.03.15 19:22:32 INFO org.books.bobby.BookStore !thread!: Coherence is ready to be used 136 ==== END logs for container bobbys-helidon-stock-application of pod bobs-books/bobbys-helidon-stock-application-7965cf98f5-kfdmx ==== 137 ==== START logs for container istio-proxy of pod bobs-books/bobbys-helidon-stock-application-7965cf98f5-kfdmx ==== 138 2021-03-15T19:02:31.381531Z info FLAG: --concurrency="2" 139 2021-03-15T19:02:31.381581Z info FLAG: --disableInternalTelemetry="false" 140 2021-03-15T19:02:31.381591Z info FLAG: --domain="bobs-books.svc.cluster.local" 141 2021-03-15T19:02:31.381597Z info FLAG: --help="false" 142 2021-03-15T19:02:31.381603Z info FLAG: --id="" 143 2021-03-15T19:02:31.381609Z info FLAG: --ip="" 144 2021-03-15T19:02:31.381615Z info FLAG: --log_as_json="false" 145 2021-03-15T19:02:31.381620Z info FLAG: --log_caller="" 146 2021-03-15T19:02:31.381627Z info FLAG: --log_output_level="default:info" 147 2021-03-15T19:02:31.381634Z info FLAG: --log_rotate="" 148 2021-03-15T19:02:31.381640Z info FLAG: --log_rotate_max_age="30" 149 2021-03-15T19:02:31.381647Z info FLAG: --log_rotate_max_backups="1000" 150 2021-03-15T19:02:31.381653Z info FLAG: --log_rotate_max_size="104857600" 151 2021-03-15T19:02:31.381660Z info FLAG: --log_stacktrace_level="default:none" 152 2021-03-15T19:02:31.381671Z info FLAG: --log_target="[stdout]" 153 2021-03-15T19:02:31.381679Z info FLAG: --meshConfig="./etc/istio/config/mesh" 154 2021-03-15T19:02:31.381685Z info FLAG: --mixerIdentity="" 155 2021-03-15T19:02:31.381691Z info FLAG: --outlierLogPath="" 156 2021-03-15T19:02:31.381698Z info FLAG: --proxyComponentLogLevel="misc:error" 157 2021-03-15T19:02:31.381705Z info FLAG: --proxyLogLevel="warning" 158 2021-03-15T19:02:31.381711Z info FLAG: --serviceCluster="bobbys-helidon-stock-application.bobs-books" 159 2021-03-15T19:02:31.381717Z info FLAG: --serviceregistry="Kubernetes" 160 2021-03-15T19:02:31.381722Z info FLAG: --stsPort="0" 161 2021-03-15T19:02:31.381728Z info FLAG: --templateFile="" 162 2021-03-15T19:02:31.381733Z info FLAG: --tokenManagerPlugin="GoogleTokenExchange" 163 2021-03-15T19:02:31.381739Z info FLAG: --trust-domain="cluster.local" 164 2021-03-15T19:02:31.381779Z info Version 1.7.3-16752a61bc5f95e8fa8c1e439d2c7271c54fa5a1-dirty-Modified 165 2021-03-15T19:02:31.382017Z info Obtained private IP [REDACTED-FOR-TEST REDACTED-FOR-TEST] 166 2021-03-15T19:02:31.382125Z info Apply proxy config from env {"proxyMetadata":{"DNS_AGENT":""}} 167 168 2021-03-15T19:02:31.383678Z info Effective config: binaryPath: /usr/local/bin/envoy 169 concurrency: 2 170 configPath: ./etc/istio/proxy 171 controlPlaneAuthPolicy: MUTUAL_TLS 172 discoveryAddress: istiod.istio-system.svc:15012 173 drainDuration: 45s 174 envoyAccessLogService: {} 175 envoyMetricsService: {} 176 parentShutdownDuration: 60s 177 proxyAdminPort: 15000 178 proxyMetadata: 179 DNS_AGENT: "" 180 serviceCluster: bobbys-helidon-stock-application.bobs-books 181 statNameLength: 189 182 statusPort: 15020 183 terminationDrainDuration: 5s 184 tracing: 185 zipkin: 186 address: zipkin.istio-system:9411 187 188 2021-03-15T19:02:31.383742Z info Proxy role: &model.Proxy{Type:"sidecar", IPAddresses:[]string{"REDACTED-FOR-TEST", "REDACTED-FOR-TEST"}, ID:"bobbys-helidon-stock-application-7965cf98f5-kfdmx.bobs-books", Locality:(*envoy_config_core_v3.Locality)(nil), DNSDomain:"bobs-books.svc.cluster.local", ConfigNamespace:"", Metadata:(*model.NodeMetadata)(nil), SidecarScope:(*model.SidecarScope)(nil), PrevSidecarScope:(*model.SidecarScope)(nil), MergedGateway:(*model.MergedGateway)(nil), ServiceInstances:[]*model.ServiceInstance(nil), IstioVersion:(*model.IstioVersion)(nil), ipv6Support:false, ipv4Support:false, GlobalUnicastIP:"", XdsResourceGenerator:model.XdsResourceGenerator(nil), Active:map[string]*model.WatchedResource(nil), ActiveExperimental:map[string]*model.WatchedResource(nil), RequestedTypes:struct { CDS string; EDS string; RDS string; LDS string }{CDS:"", EDS:"", RDS:"", LDS:""}} 189 2021-03-15T19:02:31.383749Z info JWT policy is third-party-jwt 190 2021-03-15T19:02:31.383798Z info PilotSAN []string{"istiod.istio-system.svc"} 191 2021-03-15T19:02:31.383806Z info MixerSAN []string{"spiffe://cluster.local/ns/istio-system/sa/istio-mixer-service-account"} 192 2021-03-15T19:02:31.383893Z info sa.serverOptions.CAEndpoint == istiod.istio-system.svc:15012 193 2021-03-15T19:02:31.383899Z info Using user-configured CA istiod.istio-system.svc:15012 194 2021-03-15T19:02:31.383904Z info istiod uses self-issued certificate 195 2021-03-15T19:02:31.384015Z info the CA cert of istiod is: -----BEGIN CERTIFICATE----- 196 REDACTED-FOR-TEST 197 -----END CERTIFICATE----- 198 199 2021-03-15T19:02:31.444720Z info sds SDS gRPC server for workload UDS starts, listening on "./etc/istio/proxy/SDS" 200 201 2021-03-15T19:02:31.444909Z info Starting proxy agent 202 2021-03-15T19:02:31.444802Z info sds Start SDS grpc server 203 2021-03-15T19:02:31.445000Z info Opening status port 15020 204 205 2021-03-15T19:02:31.445090Z info Received new config, creating new Envoy epoch 0 206 2021-03-15T19:02:31.445105Z info Epoch 0 starting 207 2021-03-15T19:02:31.452370Z info Envoy command: [-c etc/istio/proxy/envoy-rev0.json --restart-epoch 0 --drain-time-s 45 --parent-shutdown-time-s 60 --service-cluster bobbys-helidon-stock-application.bobs-books --service-node sidecar~REDACTED-FOR-TEST~bobbys-helidon-stock-application-7965cf98f5-kfdmx.bobs-books~bobs-books.svc.cluster.local --local-address-ip-version v4 --log-format-prefix-with-location 0 --log-format %Y-%m-%dT%T.%fZ %l envoy %n %v -l warning --component-log-level misc:error --concurrency 2] 208 2021-03-15T19:02:32.244942Z warning envoy runtime Unable to use runtime singleton for feature envoy.reloadable_features.activate_fds_next_event_loop 209 2021-03-15T19:02:32.710317Z warning envoy config StreamAggregatedResources gRPC config stream closed: 14, no healthy upstream 210 2021-03-15T19:02:32.710405Z warning envoy config Unable to establish new stream 211 2021-03-15T19:02:32.832032Z info sds resource:default new connection 212 2021-03-15T19:02:32.832168Z info sds Skipping waiting for gateway secret 213 2021-03-15T19:02:33.455910Z info cache Root cert has changed, start rotating root cert for SDS clients 214 2021-03-15T19:02:33.455987Z info cache GenerateSecret default 215 2021-03-15T19:02:33.457454Z info sds resource:default pushed key/cert pair to proxy 216 2021-03-15T19:02:33.483672Z warning envoy main there is no configured limit to the number of allowed active connections. Set a limit via the runtime key overload.global_downstream_max_connections 217 2021-03-15T19:02:34.613291Z info sds resource:ROOTCA new connection 218 2021-03-15T19:02:34.613400Z info sds Skipping waiting for gateway secret 219 2021-03-15T19:02:34.613433Z info cache Loaded root cert from certificate ROOTCA 220 2021-03-15T19:02:34.613646Z info sds resource:ROOTCA pushed root cert to proxy 221 2021-03-15T19:02:40.527404Z info Envoy proxy is ready 222 2021-03-15T19:30:38.012375Z warning envoy config StreamAggregatedResources gRPC config stream closed: 13, 223 ==== END logs for container istio-proxy of pod bobs-books/bobbys-helidon-stock-application-7965cf98f5-kfdmx ====