Build/Test Explorer

 TestFusion
Invocation status: Passed

Kokoro: grpc/node/master/xds_k8s_lb

3 targets evaluated on for 16 min, 15 sec
by sergiitk
3 Passed

Showing build.log

Download
Warning: Permanently added 'localhost' (ED25519) to the list of known hosts.
Warning: Permanently added 'localhost' (ED25519) to the list of known hosts.
Warning: Permanently added 'localhost' (ED25519) to the list of known hosts.
[16:39:26 PDT] Transferring environment variable script to build VM
[16:39:26 PDT] Transferring kokoro_log_reader.py to build VM
[16:39:26 PDT] Transferring source code to build VM
[16:39:27 PDT] Executing build script on build VM



[ID: 9361796] Executing command via SSH:
export KOKORO_BUILD_NUMBER="740"
export KOKORO_JOB_NAME="grpc/node/master/xds_k8s_lb"
source /tmpfs/kokoro-env_vars.sh; cd /tmpfs/src/ ; chmod 755 github/grpc-node/packages/grpc-js-xds/scripts/psm-interop-test-node.sh ; PYTHON_3_VERSION="$(pyenv which python3 2> /dev/null || which python3)" ; PYTHON_2_VERSION="$(pyenv which python2 2> /dev/null || which python2)" ; if "$PYTHON_3_VERSION" -c "import psutil" ; then KOKORO_PYTHON_COMMAND="$PYTHON_3_VERSION" ; else KOKORO_PYTHON_COMMAND="$PYTHON_2_VERSION" ; fi > /dev/null 2>&1 ; echo "export KOKORO_PYTHON_COMMAND="$KOKORO_PYTHON_COMMAND"" > "$HOME/.kokoro_python_vars" ; nohup bash -c "( rm -f /tmpfs/kokoro_build_exit_code ; github/grpc-node/packages/grpc-js-xds/scripts/psm-interop-test-node.sh ; echo \${PIPESTATUS[0]} > /tmpfs/kokoro_build_exit_code ) > /tmpfs/kokoro_build.log 2>&1" > /dev/null 2>&1 & echo $! > /tmpfs/kokoro_build.pid ; source "$HOME/.kokoro_python_vars" ; "$KOKORO_PYTHON_COMMAND" /tmpfs/kokoro_log_reader.py /tmpfs/kokoro_build.log /tmpfs/kokoro_build_exit_code /tmpfs/kokoro_build.pid /tmpfs/kokoro_log_reader.pid --start_byte 0

Sourcing test driver install script from: https://raw.githubusercontent.com/sergiitk/psm-interop/tests-in-shared-lib/.kokoro/psm_interop_kokoro_lib.sh
+ [23:39:27 UTC] Activated GKE cluster: GKE_CLUSTER_NAME=psm-interop-lb-primary GKE_CLUSTER_ZONE=us-central1-a
+ [23:39:27 UTC] Activated secondary GKE cluster: SECONDARY_GKE_CLUSTER_NAME=psm-interop-lb-secondary SECONDARY_GKE_CLUSTER_ZONE=us-west1-b
+ [23:39:27 UTC] Looking for docker image build script github/grpc-node/packages/grpc-js-xds/scripts/psm-interop-build-node.sh
+ [23:39:27 UTC] Sourcing docker image build script: github/grpc-node/packages/grpc-js-xds/scripts/psm-interop-build-node.sh
+ [23:39:27 UTC] Starting Kokoro provisioning
+ [23:39:27 UTC] Kokoro Ubuntu version:
No LSB modules are available.
Distributor ID: Ubuntu
Description: Ubuntu 22.04.4 LTS
Release: 22.04
Codename: jammy
Python 3.10.12
pip 22.0.2 from /usr/lib/python3/dist-packages/pip (python 3.10)
+ [23:39:28 UTC] Sponge properties:
TESTS_FORMAT_VERSION,2
TESTGRID_EXCLUDE,0
GIT_ORIGIN_URL,https://github.com/sergiitk/grpc-node.git
GIT_COMMIT_SHORT,9193654c
+ [23:39:28 UTC] Installing packages with apt, see install-apt.log
+ [23:39:57 UTC] Fetching GKE cluster credentials
Fetching cluster endpoint and auth data.
kubeconfig entry generated for psm-interop-lb-secondary.
Fetching cluster endpoint and auth data.
kubeconfig entry generated for psm-interop-lb-primary.
+ [23:40:01 UTC] Cloning driver to https://github.com/sergiitk/psm-interop.git branch tests-in-shared-lib to /tmp/tmp.Pt3Z0HGU0n/psm-interop
Cloning into '/tmp/tmp.Pt3Z0HGU0n/psm-interop'...
+ [23:40:01 UTC] Install python dependencies
+ [23:40:01 UTC] Creating python virtual environment: /tmp/tmp.Pt3Z0HGU0n/psm-interop/venv
+ [23:40:07 UTC] Installing Python packages with pip, see install-pip.log
+ [23:40:20 UTC] Generate python code from grpc.testing protos: protos/grpc/testing/test.proto protos/grpc/testing/messages.proto protos/grpc/testing/empty.proto
/tmp/tmp.Pt3Z0HGU0n/psm-interop/venv/lib/python3.10/site-packages/grpc_tools/protoc.py:21: DeprecationWarning: pkg_resources is deprecated as an API. See https://setuptools.pypa.io/en/latest/pkg_resources.html
import pkg_resources
+ [23:40:20 UTC] Generated files /tmp/tmp.Pt3Z0HGU0n/psm-interop/protos/grpc/testing:
aeb88eca9055a90fd455d0c827d758ad /tmp/tmp.Pt3Z0HGU0n/psm-interop/protos/grpc/testing/empty.proto
5bd0e7d5133f7a49db66cd21fd79c5d4 /tmp/tmp.Pt3Z0HGU0n/psm-interop/protos/grpc/testing/empty_pb2.py
ce917aac905fc9a068f94c56cee6254e /tmp/tmp.Pt3Z0HGU0n/psm-interop/protos/grpc/testing/empty_pb2_grpc.py
ce917aac905fc9a068f94c56cee6254e /tmp/tmp.Pt3Z0HGU0n/psm-interop/protos/grpc/testing/messages_pb2_grpc.py
49acea8357c9f95888df31ff792fe763 /tmp/tmp.Pt3Z0HGU0n/psm-interop/protos/grpc/testing/messages_pb2.py
00c93e1a827becae41887f181054f831 /tmp/tmp.Pt3Z0HGU0n/psm-interop/protos/grpc/testing/test_pb2_grpc.py
ae79f339133520c1984f8f001b62f73e /tmp/tmp.Pt3Z0HGU0n/psm-interop/protos/grpc/testing/messages.proto
f998d8e2f016c7602bc96ab94cfbab3f /tmp/tmp.Pt3Z0HGU0n/psm-interop/protos/grpc/testing/test_pb2.py
a66fc3966b6bc5e28ccaaadc6044d9a9 /tmp/tmp.Pt3Z0HGU0n/psm-interop/protos/grpc/testing/test.proto
+ [23:40:21 UTC] Client image: us-docker.pkg.dev/grpc-testing/psm-interop/node-client:9193654c1fe47ccbfecfd50c588c23572cd01049
Client image not found
+ [23:40:21 UTC] Building xDS interop test app Docker images
Adding credentials for: us-docker.pkg.dev
Docker configuration file updated.
+ [23:40:22 UTC] git submodule update --init --recursive
Submodule 'packages/grpc-js-xds/deps/envoy-api' (https://github.com/envoyproxy/data-plane-api.git) registered for path 'packages/grpc-js-xds/deps/envoy-api'
Submodule 'packages/grpc-js-xds/deps/googleapis' (https://github.com/googleapis/googleapis.git) registered for path 'packages/grpc-js-xds/deps/googleapis'
Submodule 'packages/grpc-js-xds/deps/protoc-gen-validate' (https://github.com/envoyproxy/protoc-gen-validate.git) registered for path 'packages/grpc-js-xds/deps/protoc-gen-validate'
Submodule 'packages/grpc-js-xds/deps/xds' (https://github.com/cncf/xds.git) registered for path 'packages/grpc-js-xds/deps/xds'
Submodule 'packages/grpc-tools/deps/protobuf' (https://github.com/protocolbuffers/protobuf) registered for path 'packages/grpc-tools/deps/protobuf'
Submodule 'packages/proto-loader/deps/gapic-showcase' (https://github.com/googleapis/gapic-showcase.git) registered for path 'packages/proto-loader/deps/gapic-showcase'
Submodule 'packages/proto-loader/deps/googleapis' (https://github.com/googleapis/googleapis.git) registered for path 'packages/proto-loader/deps/googleapis'
Cloning into '/tmpfs/src/github/grpc-node/packages/grpc-js-xds/deps/envoy-api'...
Cloning into '/tmpfs/src/github/grpc-node/packages/grpc-js-xds/deps/googleapis'...
Cloning into '/tmpfs/src/github/grpc-node/packages/grpc-js-xds/deps/protoc-gen-validate'...
Cloning into '/tmpfs/src/github/grpc-node/packages/grpc-js-xds/deps/xds'...
Cloning into '/tmpfs/src/github/grpc-node/packages/grpc-tools/deps/protobuf'...
Cloning into '/tmpfs/src/github/grpc-node/packages/proto-loader/deps/gapic-showcase'...
Cloning into '/tmpfs/src/github/grpc-node/packages/proto-loader/deps/googleapis'...
Submodule path 'packages/grpc-js-xds/deps/envoy-api': checked out '78f198cf96ecdc7120ef640406770aa01af775c4'
Submodule path 'packages/grpc-js-xds/deps/googleapis': checked out '8c53b2cb792234354c13336ac7daee61333deade'
Submodule path 'packages/grpc-js-xds/deps/protoc-gen-validate': checked out '0af61d9dc28712dc0e6f8e1a940855a2ee0cb9ed'
Submodule path 'packages/grpc-js-xds/deps/xds': checked out 'cb28da3451f158a947dfc45090fe92b07b243bc1'
Submodule path 'packages/grpc-tools/deps/protobuf': checked out '7c40b2df1fdf6f414c1c18c789715a9c948a0725'
Submodule 'third_party/benchmark' (https://github.com/google/benchmark.git) registered for path 'packages/grpc-tools/deps/protobuf/third_party/benchmark'
Submodule 'third_party/googletest' (https://github.com/google/googletest.git) registered for path 'packages/grpc-tools/deps/protobuf/third_party/googletest'
Cloning into '/tmpfs/src/github/grpc-node/packages/grpc-tools/deps/protobuf/third_party/benchmark'...
Cloning into '/tmpfs/src/github/grpc-node/packages/grpc-tools/deps/protobuf/third_party/googletest'...
Submodule path 'packages/grpc-tools/deps/protobuf/third_party/benchmark': checked out '5b7683f49e1e9223cf9927b24f6fd3d6bd82e3f8'
Submodule path 'packages/grpc-tools/deps/protobuf/third_party/googletest': checked out '5ec7f0c4a113e2f18ac2c6cc7df51ad6afc24081'
Submodule path 'packages/proto-loader/deps/gapic-showcase': checked out 'b09b3ba9a8db8aae7d5d7c3939853681cc97c293'
Submodule 'schema/api-common-protos' (https://github.com/googleapis/api-common-protos.git) registered for path 'packages/proto-loader/deps/gapic-showcase/schema/api-common-protos'
Cloning into '/tmpfs/src/github/grpc-node/packages/proto-loader/deps/gapic-showcase/schema/api-common-protos'...
Submodule path 'packages/proto-loader/deps/gapic-showcase/schema/api-common-protos': checked out '4c0a203e3658ae0e56d47c817c2c5904116c0ae0'
Submodule path 'packages/proto-loader/deps/googleapis': checked out '8f2eda119e11c8bd0c189b545da18bba9019c83e'
+ [23:40:55 UTC] Cmd finished: git
+ [23:40:55 UTC] git submodule status
78f198cf96ecdc7120ef640406770aa01af775c4 packages/grpc-js-xds/deps/envoy-api (78f198cf)
8c53b2cb792234354c13336ac7daee61333deade packages/grpc-js-xds/deps/googleapis (common-protos-1_3_1-2354-g8c53b2cb7)
0af61d9dc28712dc0e6f8e1a940855a2ee0cb9ed packages/grpc-js-xds/deps/protoc-gen-validate (v0.3.0-java-11-g0af61d9)
cb28da3451f158a947dfc45090fe92b07b243bc1 packages/grpc-js-xds/deps/xds (cb28da3)
7c40b2df1fdf6f414c1c18c789715a9c948a0725 packages/grpc-tools/deps/protobuf (v3.7.0-rc.2-2473-g7c40b2df1)
b09b3ba9a8db8aae7d5d7c3939853681cc97c293 packages/proto-loader/deps/gapic-showcase (v0.11.0-27-gb09b3ba)
8f2eda119e11c8bd0c189b545da18bba9019c83e packages/proto-loader/deps/googleapis (common-protos-1_3_1-2513-g8f2eda119)
+ [23:40:55 UTC] Cmd finished: git
/tmpfs/src/github/grpc-node /tmpfs/src/github/grpc-node
+ [23:40:55 UTC] Building node xDS interop test client
+ [23:40:55 UTC] docker build -f packages/grpc-js-xds/interop/Dockerfile -t us-docker.pkg.dev/grpc-testing/psm-interop/node-client:9193654c1fe47ccbfecfd50c588c23572cd01049 .
#0 building with "default" instance using docker driver

#1 [internal] load build definition from Dockerfile
#1 transferring dockerfile: 1.87kB done
#1 DONE 0.0s

#2 [internal] load metadata for docker.io/library/node:18-slim
#2 ...

#3 [internal] load metadata for gcr.io/distroless/nodejs18-debian11:latest
#3 DONE 0.4s

#2 [internal] load metadata for docker.io/library/node:18-slim
#2 DONE 1.0s

#4 [internal] load .dockerignore
#4 transferring context: 2B done
#4 DONE 0.0s

#5 [stage-1 1/5] FROM gcr.io/distroless/nodejs18-debian11:latest@sha256:b7ff3e27264fb11192b439ca435072226cec15289b7d9625c7633252e511bf66
#5 resolve gcr.io/distroless/nodejs18-debian11:latest@sha256:b7ff3e27264fb11192b439ca435072226cec15289b7d9625c7633252e511bf66 0.0s done
#5 extracting sha256:16100daf795a61c7588657ad2b6afc6eef7300de0c874b6c3d4def1796e28081
#5 extracting sha256:16100daf795a61c7588657ad2b6afc6eef7300de0c874b6c3d4def1796e28081 done
#5 sha256:445b5d53c01a86af627c11d23d760e8cf550481451ecff5638e7ad87b3c74721 2.28kB / 2.28kB done
#5 sha256:e33bce57de289fffd2380f73997dfb7e1ec193877904bed99f28c715d071fdc4 21.19kB / 21.19kB 0.1s done
#5 sha256:473d8557b1b27974f7dc7c4b4e1a209df0e27e8cae1e3e33b7bb45c969b6fc7e 755.28kB / 755.28kB 0.1s done
#5 sha256:f009006ff2dc99fe6ffa4d75c606f6c2b820c557545e0b1e73f0b12c0f372171 3.05kB / 3.05kB done
#5 sha256:16100daf795a61c7588657ad2b6afc6eef7300de0c874b6c3d4def1796e28081 103.77kB / 103.77kB 0.1s done
#5 sha256:b6824ed73363f94b3b2b44084c51c31bc32af77a96861d49e16f91e3ab6bed71 67B / 67B 0.1s done
#5 sha256:b7ff3e27264fb11192b439ca435072226cec15289b7d9625c7633252e511bf66 1.51kB / 1.51kB done
#5 extracting sha256:e33bce57de289fffd2380f73997dfb7e1ec193877904bed99f28c715d071fdc4 done
#5 extracting sha256:473d8557b1b27974f7dc7c4b4e1a209df0e27e8cae1e3e33b7bb45c969b6fc7e
#5 sha256:27be814a09ebd97fac6fb7b82d19f117185e90601009df3fbab6f442f85cd6b3 0B / 93B 0.2s
#5 sha256:33e068de264953dfdc9f9ada207e76b61159721fd64a4820b320d05133a55fb8 122B / 122B 0.2s done
#5 sha256:7c12895b777bcaa8ccae0605b4de635b68fc32d60fa08f421dc3818bf55ee212 188B / 188B 0.1s done
#5 sha256:5664b15f108bf9436ce3312090a767300800edbbfd4511aa1a6d64357024d5dd 0B / 168B 0.2s
#5 sha256:27be814a09ebd97fac6fb7b82d19f117185e90601009df3fbab6f442f85cd6b3 93B / 93B 0.2s done
#5 sha256:5664b15f108bf9436ce3312090a767300800edbbfd4511aa1a6d64357024d5dd 168B / 168B 0.2s done
#5 sha256:9ef7d74bdfdf3c517b28bd694a9159e94e5f53ff1ca87b39f8ca1ac0be2ed317 320B / 320B 0.3s done
#5 sha256:59e6e6563fee04c9590afd06f4a732b9af37f4804248e5ee49305b6e268de8e5 0B / 5.85MB 0.3s
#5 sha256:a4ba90834fb4abf3d80bbdaaaef36560ab1bb682f5279d44114d768e119639b9 0B / 2.06MB 0.3s
#5 sha256:4aa0ea1413d37a58615488592a0b827ea4b2e48fa5a77cf707d0e35f025e613f 385B / 385B 0.3s done
#5 sha256:9112d77ee5b16873acaa186b816c3c61f5f8eba40730e729e9614a27f40211e0 0B / 122.56kB 0.3s
#5 sha256:59e6e6563fee04c9590afd06f4a732b9af37f4804248e5ee49305b6e268de8e5 3.15MB / 5.85MB 0.4s
#5 sha256:9112d77ee5b16873acaa186b816c3c61f5f8eba40730e729e9614a27f40211e0 122.56kB / 122.56kB 0.4s done
#5 sha256:df368711b36276ed02b2040d3e3296b919042d2a05a2bbe9f758e708436c12cf 0B / 968.57kB 0.4s
#5 sha256:59e6e6563fee04c9590afd06f4a732b9af37f4804248e5ee49305b6e268de8e5 5.85MB / 5.85MB 0.4s done
#5 sha256:a4ba90834fb4abf3d80bbdaaaef36560ab1bb682f5279d44114d768e119639b9 2.06MB / 2.06MB 0.4s done
#5 sha256:df368711b36276ed02b2040d3e3296b919042d2a05a2bbe9f758e708436c12cf 968.57kB / 968.57kB 0.4s done
#5 sha256:e89169bec965f3b73bc8a6cf650d362a1da8ae571c5fdccccf7bab8194c03c47 0B / 131.15kB 0.5s
#5 sha256:88934a1bc18c35762f0009512e7a775aec9e1d9531a1781a0caf81013a67ab94 0B / 52.41kB 0.5s
#5 sha256:7f3501c931c2f262add9c59a46b7469c09f862cfcdb005d9187bc4f8f9964724 0B / 741.33kB 0.5s
#5 extracting sha256:473d8557b1b27974f7dc7c4b4e1a209df0e27e8cae1e3e33b7bb45c969b6fc7e 0.4s done
#5 sha256:e89169bec965f3b73bc8a6cf650d362a1da8ae571c5fdccccf7bab8194c03c47 131.15kB / 131.15kB 0.5s done
#5 sha256:88934a1bc18c35762f0009512e7a775aec9e1d9531a1781a0caf81013a67ab94 52.41kB / 52.41kB 0.5s done
#5 sha256:7f3501c931c2f262add9c59a46b7469c09f862cfcdb005d9187bc4f8f9964724 741.33kB / 741.33kB 0.5s done
#5 sha256:54cea410cc31410a8f31c124660c39df69da6068b9022bdd55a094b4601fbe30 0B / 50.18MB 0.6s
#5 extracting sha256:b6824ed73363f94b3b2b44084c51c31bc32af77a96861d49e16f91e3ab6bed71 done
#5 extracting sha256:7c12895b777bcaa8ccae0605b4de635b68fc32d60fa08f421dc3818bf55ee212
#5 sha256:54cea410cc31410a8f31c124660c39df69da6068b9022bdd55a094b4601fbe30 20.97MB / 50.18MB 0.8s
#5 extracting sha256:7c12895b777bcaa8ccae0605b4de635b68fc32d60fa08f421dc3818bf55ee212 done
#5 extracting sha256:33e068de264953dfdc9f9ada207e76b61159721fd64a4820b320d05133a55fb8 done
#5 extracting sha256:5664b15f108bf9436ce3312090a767300800edbbfd4511aa1a6d64357024d5dd done
#5 extracting sha256:27be814a09ebd97fac6fb7b82d19f117185e90601009df3fbab6f442f85cd6b3 done
#5 extracting sha256:4aa0ea1413d37a58615488592a0b827ea4b2e48fa5a77cf707d0e35f025e613f done
#5 extracting sha256:9ef7d74bdfdf3c517b28bd694a9159e94e5f53ff1ca87b39f8ca1ac0be2ed317
#5 sha256:54cea410cc31410a8f31c124660c39df69da6068b9022bdd55a094b4601fbe30 50.18MB / 50.18MB 1.0s
#5 extracting sha256:9ef7d74bdfdf3c517b28bd694a9159e94e5f53ff1ca87b39f8ca1ac0be2ed317 done
#5 extracting sha256:9112d77ee5b16873acaa186b816c3c61f5f8eba40730e729e9614a27f40211e0 done
#5 extracting sha256:59e6e6563fee04c9590afd06f4a732b9af37f4804248e5ee49305b6e268de8e5
#5 sha256:54cea410cc31410a8f31c124660c39df69da6068b9022bdd55a094b4601fbe30 50.18MB / 50.18MB 1.1s done
#5 extracting sha256:59e6e6563fee04c9590afd06f4a732b9af37f4804248e5ee49305b6e268de8e5 0.2s done
#5 extracting sha256:a4ba90834fb4abf3d80bbdaaaef36560ab1bb682f5279d44114d768e119639b9 0.0s done
#5 extracting sha256:df368711b36276ed02b2040d3e3296b919042d2a05a2bbe9f758e708436c12cf
#5 extracting sha256:df368711b36276ed02b2040d3e3296b919042d2a05a2bbe9f758e708436c12cf 0.0s done
#5 extracting sha256:e89169bec965f3b73bc8a6cf650d362a1da8ae571c5fdccccf7bab8194c03c47 done
#5 extracting sha256:7f3501c931c2f262add9c59a46b7469c09f862cfcdb005d9187bc4f8f9964724 0.0s done
#5 extracting sha256:88934a1bc18c35762f0009512e7a775aec9e1d9531a1781a0caf81013a67ab94 done
#5 extracting sha256:54cea410cc31410a8f31c124660c39df69da6068b9022bdd55a094b4601fbe30
#5 extracting sha256:54cea410cc31410a8f31c124660c39df69da6068b9022bdd55a094b4601fbe30 1.6s done
#5 DONE 3.3s

#6 [build 1/9] FROM docker.io/library/node:18-slim@sha256:cbfb3c9830932b7b1c2738abf47c66568fc7b06cf782d803e7ddff52b2fc835d
#6 resolve docker.io/library/node:18-slim@sha256:cbfb3c9830932b7b1c2738abf47c66568fc7b06cf782d803e7ddff52b2fc835d 0.0s done
#6 sha256:cbfb3c9830932b7b1c2738abf47c66568fc7b06cf782d803e7ddff52b2fc835d 1.21kB / 1.21kB done
#6 sha256:7aeb27e55a27ddb25ebd3bcd807e60c0ea554427a2207aa70dc3848e15ffd281 1.37kB / 1.37kB done
#6 sha256:193caab64472aba7619422cd3dab250ce4bf156de16f07256a78ec1827ba7c49 7.70kB / 7.70kB done
#6 sha256:b0a0cf830b12453b7e15359a804215a7bcccd3788e2bcecff2a03af64bbd4df7 29.15MB / 29.15MB 1.0s done
#6 sha256:a5130b24188f1639e1a9247630fb25fcf90114d659a45942ff54617a886c2475 3.36kB / 3.36kB 0.7s done
#6 sha256:54ccbbd95cdf1f593f9ca089d97f23eb0e7aaa862b99e4e40f34415389141304 38.15MB / 38.15MB 1.3s done
#6 extracting sha256:b0a0cf830b12453b7e15359a804215a7bcccd3788e2bcecff2a03af64bbd4df7 1.5s done
#6 sha256:311b11cc471ec585dff9e5761c5ec06cd5cc5632bdeb049a5ce0de1b674b1ba5 1.71MB / 1.71MB 1.2s done
#6 sha256:887f888f15077a011892481474c30a480ca6d30c992396e0b24b29cb9c817f6e 453B / 453B 1.3s done
#6 extracting sha256:a5130b24188f1639e1a9247630fb25fcf90114d659a45942ff54617a886c2475 done
#6 extracting sha256:54ccbbd95cdf1f593f9ca089d97f23eb0e7aaa862b99e4e40f34415389141304 0.7s
#6 ...

#7 [internal] load build context
#7 transferring context: 736.80MB 3.6s done
#7 DONE 3.8s

#6 [build 1/9] FROM docker.io/library/node:18-slim@sha256:cbfb3c9830932b7b1c2738abf47c66568fc7b06cf782d803e7ddff52b2fc835d
#6 extracting sha256:54ccbbd95cdf1f593f9ca089d97f23eb0e7aaa862b99e4e40f34415389141304 1.4s done
#6 extracting sha256:311b11cc471ec585dff9e5761c5ec06cd5cc5632bdeb049a5ce0de1b674b1ba5
#6 extracting sha256:311b11cc471ec585dff9e5761c5ec06cd5cc5632bdeb049a5ce0de1b674b1ba5 0.3s done
#6 extracting sha256:887f888f15077a011892481474c30a480ca6d30c992396e0b24b29cb9c817f6e
#6 extracting sha256:887f888f15077a011892481474c30a480ca6d30c992396e0b24b29cb9c817f6e done
#6 DONE 5.6s

#8 [stage-1 2/5] WORKDIR /node/src/grpc-node
#8 ...

#9 [build 2/9] WORKDIR /node/src/grpc-node
#9 DONE 0.6s

#8 [stage-1 2/5] WORKDIR /node/src/grpc-node
#8 DONE 3.0s

#10 [build 3/9] COPY . .
#10 DONE 4.4s

#11 [build 4/9] WORKDIR /node/src/grpc-node/packages/proto-loader
#11 DONE 0.0s

#12 [build 5/9] RUN npm install
#12 16.06
#12 16.06 > @grpc/proto-loader@0.7.12 prepare
#12 16.06 > npm run compile
#12 16.06
#12 16.33
#12 16.33 > @grpc/proto-loader@0.7.12 compile
#12 16.33 > tsc -p .
#12 16.33
#12 18.21
#12 18.21 added 302 packages, and audited 303 packages in 18s
#12 18.21
#12 18.21 49 packages are looking for funding
#12 18.21 run `npm fund` for details
#12 18.21
#12 18.21 found 0 vulnerabilities
#12 18.21 npm notice
#12 18.21 npm notice New minor version of npm available! 10.5.0 -> 10.6.0
#12 18.21 npm notice Changelog:
#12 18.21 npm notice Run `npm install -g npm@10.6.0` to update!
#12 18.21 npm notice
#12 DONE 19.3s

#13 [build 6/9] WORKDIR /node/src/grpc-node/packages/grpc-js
#13 DONE 0.0s

#14 [build 7/9] RUN npm install
#14 13.21 npm WARN deprecated flatten@1.0.3: flatten is deprecated in favor of utility frameworks such as lodash.
#14 13.25 npm WARN deprecated source-map-url@0.4.1: See https://github.com/lydell/source-map-url#deprecated
#14 13.25 npm WARN deprecated urix@0.1.0: Please see https://github.com/lydell/urix#deprecated
#14 13.25 npm WARN deprecated resolve-url@0.2.1: https://github.com/lydell/resolve-url#deprecated
#14 13.31 npm WARN deprecated source-map-resolve@0.5.3: See https://github.com/lydell/source-map-resolve#deprecated
#14 15.13 npm WARN deprecated chokidar@2.1.8: Chokidar 2 does not receive security updates since 2019. Upgrade to chokidar 3 with 15x fewer dependencies
#14 15.23 npm WARN deprecated mkdirp@0.5.1: Legacy versions of mkdirp are no longer supported. Please update to mkdirp 1.x. (Note that the API surface has changed to use Promises in 1.x.)
#14 19.21
#14 19.21 > @grpc/grpc-js@1.9.14 prepare
#14 19.21 > npm run generate-types && npm run compile
#14 19.21
#14 19.48
#14 19.48 > @grpc/grpc-js@1.9.14 generate-types
#14 19.48 > proto-loader-gen-types --keepCase --longs String --enums String --defaults --oneofs --includeComments --includeDirs proto/ --include-dirs test/fixtures/ -O src/generated/ --grpcLib ../index channelz.proto
#14 19.48
#14 19.88
#14 19.88 > @grpc/grpc-js@1.9.14 compile
#14 19.88 > tsc -p .
#14 19.88
#14 23.95
#14 23.95 added 706 packages, and audited 708 packages in 24s
#14 23.95
#14 23.95 81 packages are looking for funding
#14 23.95 run `npm fund` for details
#14 23.95
#14 23.95 11 vulnerabilities (1 moderate, 9 high, 1 critical)
#14 23.95
#14 23.95 To address issues that do not require attention, run:
#14 23.95 npm audit fix
#14 23.95
#14 23.95 To address all issues (including breaking changes), run:
#14 23.95 npm audit fix --force
#14 23.95
#14 23.95 Run `npm audit` for details.
#14 DONE 25.0s

#15 [build 8/9] WORKDIR /node/src/grpc-node/packages/grpc-js-xds
#15 DONE 0.0s

#16 [build 9/9] RUN npm install
#16 11.39
#16 11.39 > @grpc/grpc-js-xds@1.9.2 prepare
#16 11.39 > npm run generate-types && npm run compile
#16 11.39
#16 11.65
#16 11.65 > @grpc/grpc-js-xds@1.9.2 generate-types
#16 11.65 > proto-loader-gen-types --keepCase --longs String --enums String --defaults --oneofs --includeComments --includeDirs deps/envoy-api/ deps/xds/ deps/googleapis/ deps/protoc-gen-validate/ -O src/generated/ --grpcLib @grpc/grpc-js envoy/service/discovery/v3/ads.proto envoy/service/load_stats/v3/lrs.proto envoy/config/listener/v3/listener.proto envoy/config/route/v3/route.proto envoy/config/cluster/v3/cluster.proto envoy/config/endpoint/v3/endpoint.proto envoy/extensions/filters/network/http_connection_manager/v3/http_connection_manager.proto udpa/type/v1/typed_struct.proto xds/type/v3/typed_struct.proto envoy/extensions/filters/http/fault/v3/fault.proto envoy/service/status/v3/csds.proto envoy/extensions/load_balancing_policies/wrr_locality/v3/wrr_locality.proto envoy/extensions/load_balancing_policies/ring_hash/v3/ring_hash.proto envoy/extensions/load_balancing_policies/pick_first/v3/pick_first.proto
#16 11.65
#16 12.78
#16 12.78 > @grpc/grpc-js-xds@1.9.2 compile
#16 12.78 > tsc
#16 12.78
#16 16.62
#16 16.62 added 316 packages, and audited 319 packages in 16s
#16 16.62
#16 16.62 63 packages are looking for funding
#16 16.62 run `npm fund` for details
#16 16.63
#16 16.63 found 0 vulnerabilities
#16 DONE 17.0s

#17 [stage-1 3/5] COPY --from=build /node/src/grpc-node/packages/proto-loader ./packages/proto-loader/
#17 DONE 3.2s

#18 [stage-1 4/5] COPY --from=build /node/src/grpc-node/packages/grpc-js ./packages/grpc-js/
#18 DONE 2.8s

#19 [stage-1 5/5] COPY --from=build /node/src/grpc-node/packages/grpc-js-xds ./packages/grpc-js-xds/
#19 DONE 2.6s

#20 exporting to image
#20 exporting layers
#20 exporting layers 1.5s done
#20 writing image sha256:209200e345324475701aea4bc4edc7513d3e40aa6858618a12329b8162329d29 done
#20 naming to us-docker.pkg.dev/grpc-testing/psm-interop/node-client:9193654c1fe47ccbfecfd50c588c23572cd01049 done
#20 DONE 1.5s
+ [23:42:22 UTC] Cmd finished: docker
+ [23:42:22 UTC] docker push us-docker.pkg.dev/grpc-testing/psm-interop/node-client:9193654c1fe47ccbfecfd50c588c23572cd01049
The push refers to repository [us-docker.pkg.dev/grpc-testing/psm-interop/node-client]
4079cd1dc9b9: Preparing
ad9cd48e5250: Preparing
6dc73c7c3177: Preparing
1cc2f06b5f0c: Preparing
d92724d2b950: Preparing
f3aaf0cdb0a8: Preparing
6ea409d80cd8: Preparing
f63d186f6e7d: Preparing
6835249f577a: Preparing
24aacbf97031: Preparing
570759f468b1: Preparing
2388d21e8e2b: Preparing
c048279a7d9f: Preparing
1a73b54f556b: Preparing
2a92d6ac9e4f: Preparing
bbb6cacb8c82: Preparing
ac805962e479: Preparing
af5aa97ebe6c: Preparing
4d049f83d9cf: Preparing
9ed498e122b2: Preparing
577c8ee06f39: Preparing
32ae37dc07be: Preparing
f3aaf0cdb0a8: Waiting
6ea409d80cd8: Waiting
bbb6cacb8c82: Waiting
ac805962e479: Waiting
f63d186f6e7d: Waiting
af5aa97ebe6c: Waiting
6835249f577a: Waiting
4d049f83d9cf: Waiting
24aacbf97031: Waiting
570759f468b1: Waiting
9ed498e122b2: Waiting
2388d21e8e2b: Waiting
577c8ee06f39: Waiting
32ae37dc07be: Waiting
2a92d6ac9e4f: Waiting
c048279a7d9f: Waiting
1a73b54f556b: Waiting
d92724d2b950: Layer already exists
1cc2f06b5f0c: Pushed
f3aaf0cdb0a8: Layer already exists
6ea409d80cd8: Layer already exists
f63d186f6e7d: Layer already exists
6835249f577a: Layer already exists
570759f468b1: Layer already exists
24aacbf97031: Layer already exists
2388d21e8e2b: Layer already exists
1a73b54f556b: Layer already exists
c048279a7d9f: Layer already exists
2a92d6ac9e4f: Layer already exists
bbb6cacb8c82: Layer already exists
ac805962e479: Layer already exists
af5aa97ebe6c: Layer already exists
9ed498e122b2: Layer already exists
4d049f83d9cf: Layer already exists
577c8ee06f39: Layer already exists
32ae37dc07be: Layer already exists
4079cd1dc9b9: Pushed
6dc73c7c3177: Pushed
ad9cd48e5250: Pushed
9193654c1fe47ccbfecfd50c588c23572cd01049: digest: sha256:0cb44208938560bf996cf4d2016b4f4546fc677df14987de9c1ab70b14134166 size: 4919
+ [23:42:36 UTC] Cmd finished: docker
/tmpfs/src/github/grpc-node
+ [23:42:36 UTC] Finished xDS interop test app Docker images
+ [23:42:36 UTC] Tests in lb test suite:
- app_net_test
- baseline_test

+ [23:42:36 UTC] Running lb suite test: app_net_test
+ [23:42:36 UTC] Test driver flags for app_net_test:
--flagfile=config/grpc-testing.cfg
--kube_context=gke_grpc-testing_us-central1-a_psm-interop-lb-primary
--force_cleanup
--collect_app_logs
--log_dir=/tmpfs/src/artifacts/grpc/node/master/xds_k8s_lb/app_net_test
--xml_output_file=/tmpfs/src/artifacts/grpc/node/master/xds_k8s_lb/app_net_test/sponge_log.xml
--testing_version=dev-master
--client_image=us-docker.pkg.dev/grpc-testing/psm-interop/node-client:9193654c1fe47ccbfecfd50c588c23572cd01049
--server_image=us-docker.pkg.dev/grpc-testing/psm-interop/java-server:canonical
--secondary_kube_context=gke_grpc-testing_us-west1-b_psm-interop-lb-secondary

+ [23:42:36 UTC] python -m tests.app_net_test --flagfile=config/grpc-testing.cfg --kube_context=gke_grpc-testing_us-central1-a_psm-interop-lb-primary --force_cleanup --collect_app_logs --log_dir=/tmpfs/src/artifacts/grpc/node/master/xds_k8s_lb/app_net_test --xml_output_file=/tmpfs/src/artifacts/grpc/node/master/xds_k8s_lb/app_net_test/sponge_log.xml --testing_version=dev-master --client_image=us-docker.pkg.dev/grpc-testing/psm-interop/node-client:9193654c1fe47ccbfecfd50c588c23572cd01049 --server_image=us-docker.pkg.dev/grpc-testing/psm-interop/java-server:canonical --secondary_kube_context=gke_grpc-testing_us-west1-b_psm-interop-lb-secondary
Running tests under Python 3.10.12: /tmp/tmp.Pt3Z0HGU0n/psm-interop/venv/bin/python
I0426 23:42:37.574503 133913833844736 xds_k8s_testcase.py:162] ----- Testing AppNetTest -----
I0426 23:42:37.574615 133913833844736 xds_k8s_testcase.py:163] Logs timezone: UTC
I0426 23:42:37.574810 133913833844736 xds_k8s_testcase.py:111] Detected language and version: TestConfig(client_lang='node', server_lang='java', version='dev-master')
I0426 23:42:37.588007 133913833844736 k8s.py:243] Using kubernetes context "gke_grpc-testing_us-central1-a_psm-interop-lb-primary", active host: https://35.238.98.54
I0426 23:42:37.627963 133913833844736 k8s.py:243] Using kubernetes context "gke_grpc-testing_us-west1-b_psm-interop-lb-secondary", active host: https://35.227.140.120
[ RUN ] AppNetTest.test_ping_pong
I0426 23:42:37.796547 133913833844736 xds_k8s_testcase.py:736] Test run resource prefix: psm-interop, suffix: 20240426-2342-s6xfd
I0426 23:42:38.359797 133913833844736 logs.py:31] Log root dir: /tmpfs/src/artifacts/grpc/node/master/xds_k8s_lb/app_net_test
I0426 23:42:38.597977 133913833844736 xds_k8s_testcase.py:731] Found unused xds port: 58628
I0426 23:42:38.598250 133913833844736 xds_k8s_testcase.py:299] --- Starting subTest AppNetTest.test_ping_pong.0_create_health_check ---
I0426 23:42:38.598343 133913833844736 traffic_director.py:191] Creating GRPC Health Check "psm-interop-health-check-20240426-2342-s6xfd"
I0426 23:42:38.600773 133913833844736 compute.py:537] Creating compute resource:
---
grpcHealthCheck:
portSpecification: USE_SERVING_PORT
name: psm-interop-health-check-20240426-2342-s6xfd
type: GRPC
...

I0426 23:42:39.410037 133913833844736 compute.py:614] Waiting 600 sec for compute operation id: operation-1714174958673-61708757e9e7d-78f6ba65-11a0df88
I0426 23:42:41.721079 133913833844736 xds_k8s_testcase.py:304] --- Finished subTest AppNetTest.test_ping_pong.0_create_health_check ---
I0426 23:42:41.721242 133913833844736 xds_k8s_testcase.py:299] --- Starting subTest AppNetTest.test_ping_pong.1_create_backend_service ---
I0426 23:42:41.721313 133913833844736 traffic_director.py:218] Creating GRPC Backend Service "psm-interop-backend-service-20240426-2342-s6xfd"
I0426 23:42:41.726416 133913833844736 compute.py:537] Creating compute resource:
---
healthChecks:
- https://www.googleapis.com/compute/v1/projects/grpc-testing/global/healthChecks/psm-interop-health-check-20240426-2342-s6xfd
loadBalancingScheme: INTERNAL_SELF_MANAGED
name: psm-interop-backend-service-20240426-2342-s6xfd
protocol: GRPC
...

I0426 23:42:42.418491 133913833844736 compute.py:614] Waiting 600 sec for compute operation id: operation-1714174961728-6170875ad3c8d-56085a79-6972fee2
I0426 23:43:10.563595 133913833844736 xds_k8s_testcase.py:304] --- Finished subTest AppNetTest.test_ping_pong.1_create_backend_service ---
I0426 23:43:10.563735 133913833844736 xds_k8s_testcase.py:299] --- Starting subTest AppNetTest.test_ping_pong.2_create_mesh ---
I0426 23:43:10.563789 133913833844736 traffic_director.py:783] Creating Mesh psm-interop-mesh-20240426-2342-s6xfd
I0426 23:43:10.565182 133913833844736 api.py:490] Creating networkservices resource:
--- {}
...

I0426 23:43:11.060132 133913833844736 api.py:546] Waiting 600 sec for networkservices operation id: projects/grpc-testing/locations/global/operations/operation-1714174990648-6170877668389-a27e61b9-f8908db4
I0426 23:43:15.415630 133913833844736 api.py:512] Loaded projects/grpc-testing/locations/global/meshes/psm-interop-mesh-20240426-2342-s6xfd:
---
createTime: '2024-04-26T23:43:10.690535500Z'
name: projects/grpc-testing/locations/global/meshes/psm-interop-mesh-20240426-2342-s6xfd
selfLink: https://networkservices.googleapis.com/v1alpha1/projects/grpc-testing/locations/global/meshes/psm-interop-mesh-20240426-2342-s6xfd
updateTime: '2024-04-26T23:43:14.526752404Z'
...

I0426 23:43:15.415805 133913833844736 xds_k8s_testcase.py:304] --- Finished subTest AppNetTest.test_ping_pong.2_create_mesh ---
I0426 23:43:15.415866 133913833844736 xds_k8s_testcase.py:299] --- Starting subTest AppNetTest.test_ping_pong.3_create_grpc_route ---
I0426 23:43:15.415932 133913833844736 traffic_director.py:814] Creating GrpcRoute psm-interop-grpc-route-20240426-2342-s6xfd
I0426 23:43:15.417947 133913833844736 api.py:490] Creating networkservices resource:
---
hostnames: psm-grpc-server:58628
meshes:
- projects/grpc-testing/locations/global/meshes/psm-interop-mesh-20240426-2342-s6xfd
rules:
- action:
destinations:
- serviceName: projects/grpc-testing/locations/global/backendServices/psm-interop-backend-service-20240426-2342-s6xfd
...

I0426 23:43:15.940929 133913833844736 api.py:546] Waiting 600 sec for networkservices operation id: projects/grpc-testing/locations/global/operations/operation-1714174995464-6170877b0016c-5227ed39-2760a0e0
I0426 23:43:22.391562 133913833844736 api.py:512] Loaded projects/grpc-testing/locations/global/grpcRoutes/psm-interop-grpc-route-20240426-2342-s6xfd:
---
createTime: '2024-04-26T23:43:15.588349085Z'
hostnames:
- psm-grpc-server:58628
meshes:
- projects/grpc-testing/locations/global/meshes/psm-interop-mesh-20240426-2342-s6xfd
name: projects/grpc-testing/locations/global/grpcRoutes/psm-interop-grpc-route-20240426-2342-s6xfd
rules:
- action:
destinations:
- serviceName: projects/grpc-testing/locations/global/backendServices/psm-interop-backend-service-20240426-2342-s6xfd
selfLink: https://networkservices.googleapis.com/v1alpha1/projects/grpc-testing/locations/global/grpcRoutes/psm-interop-grpc-route-20240426-2342-s6xfd
updateTime: '2024-04-26T23:43:20.484398927Z'
...

I0426 23:43:22.391730 133913833844736 xds_k8s_testcase.py:304] --- Finished subTest AppNetTest.test_ping_pong.3_create_grpc_route ---
I0426 23:43:22.391792 133913833844736 xds_k8s_testcase.py:299] --- Starting subTest AppNetTest.test_ping_pong.4_start_test_server ---
I0426 23:43:22.391852 133913833844736 k8s_xds_server_runner.py:186] Deploying xDS test server "psm-grpc-server" to k8s namespace psm-interop-server-20240426-2342-s6xfd: test_port=8080 maintenance_port=8080 secure_mode=False replica_count=1
I0426 23:43:22.392035 133913833844736 k8s_base_runner.py:1152] GCP Logs Explorer link to psm-grpc-server:
https://console.cloud.google.com/logs/query;query=resource.type%3D%22k8s_container%22%0Aresource.labels.project_id%3D%22grpc-testing%22%0Aresource.labels.container_name%3D%22psm-grpc-server%22%0Aresource.labels.namespace_name%3D%22psm-interop-server-20240426-2342-s6xfd%22;timeRange=2024-04-26T23:43:22.391923Z%2F2024-04-27T00:13:22.391923Z?project=grpc-testing
I0426 23:43:22.395748 133913833844736 k8s_base_runner.py:347] Rendered template kubernetes-manifests/namespace.yaml:
---
apiVersion: v1
kind: Namespace
metadata:
name: psm-interop-server-20240426-2342-s6xfd
labels:
name: psm-interop-server-20240426-2342-s6xfd
owner: xds-k8s-interop-test
...

I0426 23:43:22.422321 133913833844736 k8s_base_runner.py:367] Namespace psm-interop-server-20240426-2342-s6xfd created
I0426 23:43:22.424362 133913833844736 k8s_base_runner.py:347] Rendered template kubernetes-manifests/server.service.yaml:
---
apiVersion: v1
kind: Service
metadata:
name: psm-grpc-server
namespace: psm-interop-server-20240426-2342-s6xfd
labels:
owner: xds-k8s-interop-test
annotations:
cloud.google.com/neg: '{"exposed_ports": {"8080":{"name":"psm-interop-server-20240426-2342-s6xfd-psm-grpc-server"}}}'
spec:
type: ClusterIP
selector:
app: psm-grpc-server
ports:
- port: 8080
protocol: TCP
targetPort: 8080
...

I0426 23:43:22.458122 133913833844736 k8s_base_runner.py:367] Service psm-grpc-server created
I0426 23:43:22.458305 133913833844736 k8s_base_runner.py:1054] Waiting for 'cloud.google.com/neg-status' annotation for a NEG at port 8080 to be assigned to Kubernetes Service psm-grpc-server in namespace psm-interop-server-20240426-2342-s6xfd
I0426 23:43:22.483975 133913833844736 k8s_base_runner.py:1068] Detected 'cloud.google.com/neg-status' annotation for Kubernetes Service psm-grpc-server, namespace psm-interop-server-20240426-2342-s6xfd: neg_name=psm-interop-server-20240426-2342-s6xfd-psm-grpc-server, port=8080, zones=['us-central1-a']
I0426 23:43:22.484101 133913833844736 k8s_base_runner.py:452] Granting roles/iam.workloadIdentityUser to serviceAccount:grpc-testing.svc.id.goog[psm-interop-server-20240426-2342-s6xfd/psm-grpc-server] for GCP Service Account xds-k8s-interop-tests@grpc-testing.iam.gserviceaccount.com
I0426 23:43:22.842766 133913833844736 k8s_base_runner.py:347] Rendered template kubernetes-manifests/service-account.yaml:
---
apiVersion: v1
kind: ServiceAccount
metadata:
name: psm-grpc-server
namespace: psm-interop-server-20240426-2342-s6xfd
labels:
owner: xds-k8s-interop-test
annotations:
iam.gke.io/gcp-service-account: xds-k8s-interop-tests@grpc-testing.iam.gserviceaccount.com
...

I0426 23:43:22.867915 133913833844736 k8s_base_runner.py:367] ServiceAccount psm-grpc-server created
I0426 23:43:22.879091 133913833844736 k8s_base_runner.py:347] Rendered template kubernetes-manifests/server.deployment.yaml:
---
apiVersion: apps/v1
kind: Deployment
metadata:
name: psm-grpc-server
namespace: psm-interop-server-20240426-2342-s6xfd
labels:
app: psm-grpc-server
deployment_id: psm-grpc-server-2j5zvudo
owner: xds-k8s-interop-test
spec:
replicas: 1
selector:
matchLabels:
app: psm-grpc-server
deployment_id: psm-grpc-server-2j5zvudo
template:
metadata:
labels:
app: psm-grpc-server
deployment_id: psm-grpc-server-2j5zvudo
owner: xds-k8s-interop-test
spec:
serviceAccountName: psm-grpc-server
containers:
- name: psm-grpc-server
image: us-docker.pkg.dev/grpc-testing/psm-interop/java-server:canonical
imagePullPolicy: Always
startupProbe:
tcpSocket:
port: 8080
periodSeconds: 3
failureThreshold: 1000

args:
- "--port=8080"
ports:
- containerPort: 8080
env:
- name: GRPC_XDS_BOOTSTRAP
value: "/tmp/grpc-xds/td-grpc-bootstrap.json"
- name: GRPC_XDS_EXPERIMENTAL_V3_SUPPORT
value: "true"
- name: GRPC_EXPERIMENTAL_XDS_ENABLE_OVERRIDE_HOST
value: "true"
volumeMounts:
- mountPath: /tmp/grpc-xds/
name: grpc-td-conf
readOnly: true

resources:
limits:
cpu: 800m
memory: 512Mi
requests:
cpu: 100m
memory: 512Mi
initContainers:
- name: grpc-td-init
image: us-docker.pkg.dev/grpc-testing/trafficdirector/td-grpc-bootstrap:2bf1b5ed00f852ffea8d24759c6fa673acc9ef10
imagePullPolicy: Always
args:
- "--output=/tmp/bootstrap/td-grpc-bootstrap.json"
- "--vpc-network-name=default-vpc"
- "--node-metadata=app=psm-interop-server-20240426-2342-s6xfd-psm-grpc-server"
resources:
limits:
cpu: 100m
memory: 100Mi
requests:
cpu: 10m
memory: 100Mi
volumeMounts:
- mountPath: /tmp/bootstrap/
name: grpc-td-conf

volumes:
- name: grpc-td-conf
emptyDir:
medium: Memory

...

I0426 23:43:22.925229 133913833844736 k8s_base_runner.py:367] Deployment psm-grpc-server created
I0426 23:43:22.925371 133913833844736 k8s_base_runner.py:962] Waiting for deployment psm-grpc-server to initialize 1 pod(s)
I0426 23:43:22.969769 133913833844736 k8s_base_runner.py:972] Deployment psm-grpc-server initialized 1 pod(s): ['psm-grpc-server-7f7f84ff6-kjr2q']
I0426 23:43:22.969921 133913833844736 k8s_base_runner.py:982] Waiting for pod psm-grpc-server-7f7f84ff6-kjr2q to start
I0426 23:43:27.054183 133913833844736 k8s_base_runner.py:985] Pod psm-grpc-server-7f7f84ff6-kjr2q ready, IP: 10.120.13.117
I0426 23:43:27.054370 133913833844736 k8s_base_runner.py:1030] Enabling log collection from pod psm-grpc-server-7f7f84ff6-kjr2q to app_net_test/test_app_logs/psm-interop-server-20240426-2342-s6xfd_psm-grpc-server-7f7f84ff6-kjr2q.log
I0426 23:43:27.054673 133912734963264 k8s_log_collector.py:71] [ns/psm-interop-server-20240426-2342-s6xfd] Starting log collection thread 133912734963264 for psm-grpc-server-7f7f84ff6-kjr2q
I0426 23:43:27.054775 133913833844736 k8s_base_runner.py:944] Waiting for deployment psm-grpc-server to report 1 available replica(s)
I0426 23:43:32.142331 133913833844736 k8s_base_runner.py:953] Deployment psm-grpc-server has 1 replicas available
I0426 23:43:32.142512 133913833844736 xds_k8s_testcase.py:304] --- Finished subTest AppNetTest.test_ping_pong.4_start_test_server ---
I0426 23:43:32.142570 133913833844736 xds_k8s_testcase.py:299] --- Starting subTest AppNetTest.test_ping_pong.5_setup_server_backends ---
I0426 23:43:32.146058 133913833844736 traffic_director.py:256] Waiting for Network Endpoint Groups to load endpoints.
I0426 23:43:32.220467 133913833844736 traffic_director.py:259] Loaded NEG "psm-interop-server-20240426-2342-s6xfd-psm-grpc-server" in zone us-central1-a
I0426 23:43:32.220618 133913833844736 traffic_director.py:277] Adding backends to Backend Service psm-interop-backend-service-20240426-2342-s6xfd: {ComputeV1.ZonalGcpResource(name='psm-interop-server-20240426-2342-s6xfd-psm-grpc-server', url='https://www.googleapis.com/compute/v1/projects/grpc-testing/zones/us-central1-a/networkEndpointGroups/psm-interop-server-20240426-2342-s6xfd-psm-grpc-server', zone='us-central1-a')}
I0426 23:43:32.223572 133913833844736 compute.py:544] Patching compute resource:
---
backends:
- balancingMode: RATE
group: https://www.googleapis.com/compute/v1/projects/grpc-testing/zones/us-central1-a/networkEndpointGroups/psm-interop-server-20240426-2342-s6xfd-psm-grpc-server
maxRatePerEndpoint: 5
...

I0426 23:43:32.905148 133913833844736 compute.py:614] Waiting 600 sec for compute operation id: operation-1714175012226-6170878afc518-69c17cdc-d3c4ac77
I0426 23:44:11.480543 133913833844736 traffic_director.py:294] Waiting for Backend Service psm-interop-backend-service-20240426-2342-s6xfd to report all backends healthy: ['psm-interop-server-20240426-2342-s6xfd-psm-grpc-server']
I0426 23:44:28.411499 133913833844736 compute.py:494] Backend psm-interop-server-20240426-2342-s6xfd-psm-grpc-server in zone us-central1-a reported healthy
I0426 23:44:32.416050 133913833844736 xds_k8s_testcase.py:304] --- Finished subTest AppNetTest.test_ping_pong.5_setup_server_backends ---
I0426 23:44:32.416216 133913833844736 xds_k8s_testcase.py:299] --- Starting subTest AppNetTest.test_ping_pong.6_start_test_client ---
I0426 23:44:32.416289 133913833844736 k8s_xds_client_runner.py:119] Deploying xDS test client "psm-grpc-client" to k8s namespace psm-interop-client-20240426-2342-s6xfd: server_target=xds:///psm-grpc-server:58628 rpc=UnaryCall qps=25 metadata='' secure_mode=False print_response=False
I0426 23:44:32.416491 133913833844736 k8s_base_runner.py:1152] GCP Logs Explorer link to psm-grpc-client:
https://console.cloud.google.com/logs/query;query=resource.type%3D%22k8s_container%22%0Aresource.labels.project_id%3D%22grpc-testing%22%0Aresource.labels.container_name%3D%22psm-grpc-client%22%0Aresource.labels.namespace_name%3D%22psm-interop-client-20240426-2342-s6xfd%22;timeRange=2024-04-26T23:44:32.416363Z%2F2024-04-27T00:14:32.416363Z?project=grpc-testing
I0426 23:44:32.417935 133913833844736 k8s_base_runner.py:347] Rendered template kubernetes-manifests/namespace.yaml:
---
apiVersion: v1
kind: Namespace
metadata:
name: psm-interop-client-20240426-2342-s6xfd
labels:
name: psm-interop-client-20240426-2342-s6xfd
owner: xds-k8s-interop-test
...

I0426 23:44:32.426832 133913833844736 k8s_base_runner.py:367] Namespace psm-interop-client-20240426-2342-s6xfd created
I0426 23:44:32.426938 133913833844736 k8s_base_runner.py:452] Granting roles/iam.workloadIdentityUser to serviceAccount:grpc-testing.svc.id.goog[psm-interop-client-20240426-2342-s6xfd/psm-grpc-client] for GCP Service Account xds-k8s-interop-tests@grpc-testing.iam.gserviceaccount.com
I0426 23:44:32.756421 133913833844736 k8s_base_runner.py:347] Rendered template kubernetes-manifests/service-account.yaml:
---
apiVersion: v1
kind: ServiceAccount
metadata:
name: psm-grpc-client
namespace: psm-interop-client-20240426-2342-s6xfd
labels:
owner: xds-k8s-interop-test
annotations:
iam.gke.io/gcp-service-account: xds-k8s-interop-tests@grpc-testing.iam.gserviceaccount.com
...

I0426 23:44:32.780473 133913833844736 k8s_base_runner.py:367] ServiceAccount psm-grpc-client created
I0426 23:44:32.787085 133913833844736 k8s_base_runner.py:347] Rendered template kubernetes-manifests/client.deployment.yaml:
---
apiVersion: apps/v1
kind: Deployment
metadata:
name: psm-grpc-client
namespace: psm-interop-client-20240426-2342-s6xfd
labels:
app: psm-grpc-client
deployment_id: psm-grpc-client-rg5vmqut
owner: xds-k8s-interop-test
spec:
replicas: 1
selector:
matchLabels:
app: psm-grpc-client
deployment_id: psm-grpc-client-rg5vmqut
template:
metadata:
labels:
app: psm-grpc-client
deployment_id: psm-grpc-client-rg5vmqut
owner: xds-k8s-interop-test
spec:
serviceAccountName: psm-grpc-client
containers:
- name: psm-grpc-client
image: us-docker.pkg.dev/grpc-testing/psm-interop/node-client:9193654c1fe47ccbfecfd50c588c23572cd01049
imagePullPolicy: Always
startupProbe:
tcpSocket:
port: 8079
periodSeconds: 3
failureThreshold: 1000
args:
- "--server=xds:///psm-grpc-server:58628"
- "--stats_port=8079"
- "--qps=25"
- "--rpc=UnaryCall"
- "--metadata="
- "--print_response=False"
ports:
- containerPort: 8079
env:
- name: GRPC_XDS_BOOTSTRAP
value: "/tmp/grpc-xds/td-grpc-bootstrap.json"
- name: GRPC_XDS_EXPERIMENTAL_ENABLE_RING_HASH
value: "true"
- name: GRPC_XDS_EXPERIMENTAL_ENABLE_RETRY
value: "true"
- name: GRPC_EXPERIMENTAL_ENABLE_OUTLIER_DETECTION
value: "true"
- name: GRPC_EXPERIMENTAL_XDS_CUSTOM_LB_CONFIG
value: "true"
- name: GRPC_EXPERIMENTAL_XDS_ENABLE_OVERRIDE_HOST
value: "true"
volumeMounts:
- mountPath: /tmp/grpc-xds/
name: grpc-td-conf
readOnly: true
resources:
limits:
cpu: 800m
memory: 512Mi
requests:
cpu: 100m
memory: 512Mi
initContainers:
- name: grpc-td-init
image: us-docker.pkg.dev/grpc-testing/trafficdirector/td-grpc-bootstrap:2bf1b5ed00f852ffea8d24759c6fa673acc9ef10
imagePullPolicy: Always
args:
- "--output=/tmp/bootstrap/td-grpc-bootstrap.json"
- "--vpc-network-name=default-vpc"
- "--config-mesh-experimental=psm-interop-mesh-20240426-2342-s6xfd"
resources:
limits:
cpu: 100m
memory: 100Mi
requests:
cpu: 10m
memory: 100Mi
volumeMounts:
- mountPath: /tmp/bootstrap/
name: grpc-td-conf
volumes:
- name: grpc-td-conf
emptyDir:
medium: Memory
...

I0426 23:44:32.827765 133913833844736 k8s_base_runner.py:367] Deployment psm-grpc-client created
I0426 23:44:32.827918 133913833844736 k8s_base_runner.py:962] Waiting for deployment psm-grpc-client to initialize 1 pod(s)
I0426 23:44:33.866030 133913833844736 k8s_base_runner.py:972] Deployment psm-grpc-client initialized 1 pod(s): ['psm-grpc-client-6845f79646-f9lsp']
I0426 23:44:33.866180 133913833844736 k8s_base_runner.py:982] Waiting for pod psm-grpc-client-6845f79646-f9lsp to start
I0426 23:44:51.093216 133913833844736 k8s_base_runner.py:985] Pod psm-grpc-client-6845f79646-f9lsp ready, IP: 10.120.11.143
I0426 23:44:51.093384 133913833844736 k8s_base_runner.py:1030] Enabling log collection from pod psm-grpc-client-6845f79646-f9lsp to app_net_test/test_app_logs/psm-interop-client-20240426-2342-s6xfd_psm-grpc-client-6845f79646-f9lsp.log
I0426 23:44:51.093769 133911980013120 k8s_log_collector.py:71] [ns/psm-interop-client-20240426-2342-s6xfd] Starting log collection thread 133911980013120 for psm-grpc-client-6845f79646-f9lsp
I0426 23:44:51.093938 133913833844736 k8s_base_runner.py:944] Waiting for deployment psm-grpc-client to report 1 available replica(s)
I0426 23:44:55.156868 133913833844736 k8s_base_runner.py:953] Deployment psm-grpc-client has 1 replicas available
I0426 23:44:55.157173 133913833844736 client_app.py:292] [psm-grpc-client-6845f79646-f9lsp] ADS: Waiting for active calls to xDS control plane to trafficdirector.googleapis.com:443
I0426 23:44:55.182726 133913833844736 client_app.py:320] [psm-grpc-client-6845f79646-f9lsp] xDS control plane channel:
I0426 23:45:05.202243 133913833844736 client_app.py:320] [psm-grpc-client-6845f79646-f9lsp] xDS control plane channel:
I0426 23:45:15.220662 133913833844736 client_app.py:320] [psm-grpc-client-6845f79646-f9lsp] xDS control plane channel:
I0426 23:45:25.238703 133913833844736 client_app.py:320] [psm-grpc-client-6845f79646-f9lsp] xDS control plane channel:
I0426 23:45:27.246675 133913833844736 client_app.py:331] [psm-grpc-client-6845f79646-f9lsp] Detected active calls to xDS control plane trafficdirector.googleapis.com:443, channel:
I0426 23:45:27.246869 133913833844736 client_app.py:302] [psm-grpc-client-6845f79646-f9lsp] ADS: Detected active calls to xDS control plane trafficdirector.googleapis.com:443
I0426 23:45:27.247064 133913833844736 client_app.py:252] [psm-grpc-client-6845f79646-f9lsp] Waiting to report a READY channel to xds:///psm-grpc-server:58628
I0426 23:45:27.250363 133913833844736 client_app.py:379] [psm-grpc-client-6845f79646-f9lsp] Server channel:
I0426 23:45:27.256742 133913833844736 client_app.py:392] [psm-grpc-client-6845f79646-f9lsp] Found subchannel in state READY:
I0426 23:45:27.257051 133913833844736 client_app.py:263] [psm-grpc-client-6845f79646-f9lsp] Channel to xds:///psm-grpc-server:58628 transitioned to state READY:
I0426 23:45:27.257163 133913833844736 xds_k8s_testcase.py:304] --- Finished subTest AppNetTest.test_ping_pong.6_start_test_client ---
I0426 23:45:27.257218 133913833844736 xds_k8s_testcase.py:299] --- Starting subTest AppNetTest.test_ping_pong.7_assert_xds_config_exists ---
I0426 23:45:27.257377 133913833844736 grpc.py:75] [psm-grpc-client-6845f79646-f9lsp:8079] >> RPC ClientStatusDiscoveryService.FetchClientStatus(request=ClientStatusRequest({}), timeout=30, wait_for_ready=True)
I0426 23:45:27.269193 133913833844736 xds_k8s_testcase.py:304] --- Finished subTest AppNetTest.test_ping_pong.7_assert_xds_config_exists ---
I0426 23:45:27.269285 133913833844736 xds_k8s_testcase.py:299] --- Starting subTest AppNetTest.test_ping_pong.8_assert_successful_rpcs ---
I0426 23:45:27.269426 133913833844736 grpc.py:75] [psm-grpc-client-6845f79646-f9lsp:8079] >> RPC LoadBalancerStatsService.GetClientStats(request=LoadBalancerStatsRequest({'numRpcs': 100, 'timeoutSec': 1200}), timeout=1200, wait_for_ready=True)
I0426 23:45:31.273852 133913833844736 xds_k8s_testcase.py:669] [psm-grpc-client-6845f79646-f9lsp] << Received LoadBalancerStatsResponse:
num_failures: 0
rpcs_by_peer:
psm-grpc-server-7f7f84ff6-kjr2q: 100
rpcs_by_method:
UnaryCall:
psm-grpc-server-7f7f84ff6-kjr2q: 100

I0426 23:45:31.274047 133913833844736 xds_k8s_testcase.py:304] --- Finished subTest AppNetTest.test_ping_pong.8_assert_successful_rpcs ---
I0426 23:45:31.274155 133913833844736 xds_k8s_testcase.py:755] ----- TestMethod AppNetTest.test_ping_pong teardown -----
I0426 23:45:31.331281 133913833844736 traffic_director.py:854] Deleting HttpRoute psm-interop-http-route-20240426-2342-s6xfd
I0426 23:45:31.412220 133913833844736 traffic_director.py:843] Deleting GrpcRoute psm-interop-grpc-route-20240426-2342-s6xfd
I0426 23:45:31.894854 133913833844736 api.py:546] Waiting 600 sec for networkservices operation id: projects/grpc-testing/locations/global/operations/operation-1714175131491-617087fcb9d27-167e74ef-3df96298
I0426 23:45:38.188641 133913833844736 traffic_director.py:797] Deleting Mesh psm-interop-mesh-20240426-2342-s6xfd
I0426 23:45:38.498466 133913833844736 api.py:546] Waiting 600 sec for networkservices operation id: projects/grpc-testing/locations/global/operations/operation-1714175138246-617088032aee4-b7d5bd94-9f77c723
I0426 23:45:42.796888 133913833844736 traffic_director.py:674] Deleting Forwarding rule "psm-interop-forwarding-rule-20240426-2342-s6xfd"
I0426 23:45:42.871337 133913833844736 traffic_director.py:713] Deleting alternative Forwarding rule "psm-interop-forwarding-rule-alt-20240426-2342-s6xfd"
I0426 23:45:43.032783 133913833844736 traffic_director.py:605] Deleting HTTP Target proxy "psm-interop-target-proxy-20240426-2342-s6xfd"
I0426 23:45:43.573431 133913833844736 traffic_director.py:593] Deleting Target GRPC proxy "psm-interop-target-proxy-20240426-2342-s6xfd"
I0426 23:45:43.871377 133913833844736 traffic_director.py:633] Deleting alternative Target GRPC proxy "psm-interop-target-proxy-alt-20240426-2342-s6xfd"
I0426 23:45:44.344694 133913833844736 traffic_director.py:525] Deleting URL Map "psm-interop-url-map-20240426-2342-s6xfd"
I0426 23:45:44.701587 133913833844736 traffic_director.py:561] Deleting alternative URL Map "psm-interop-url-map-alt-20240426-2342-s6xfd"
I0426 23:45:45.244831 133913833844736 traffic_director.py:243] Deleting Backend Service "psm-interop-backend-service-20240426-2342-s6xfd"
I0426 23:45:46.015117 133913833844736 compute.py:614] Waiting 600 sec for compute operation id: operation-1714175145249-61708809d8b0c-590aa6be-e599b519
I0426 23:46:07.685403 133913833844736 traffic_director.py:332] Deleting Alternative Backend Service "psm-interop-backend-service-alt-20240426-2342-s6xfd"
I0426 23:46:07.990028 133913833844736 traffic_director.py:405] Deleting Affinity Backend Service "psm-interop-backend-service-affinity-20240426-2342-s6xfd"
I0426 23:46:08.538723 133913833844736 traffic_director.py:202] Deleting Health Check "psm-interop-health-check-20240426-2342-s6xfd"
I0426 23:46:09.074958 133913833844736 compute.py:614] Waiting 600 sec for compute operation id: operation-1714175168601-617088201de8b-ee56675b-0b9a9e9e
I0426 23:46:13.530508 133913833844736 k8s_base_runner.py:873] Deleting deployment psm-grpc-client
I0426 23:46:53.683931 133913833844736 k8s_base_runner.py:888] Deployment psm-grpc-client deleted
I0426 23:46:53.684145 133913833844736 k8s_base_runner.py:471] Revoking roles/iam.workloadIdentityUser from serviceAccount:grpc-testing.svc.id.goog[psm-interop-client-20240426-2342-s6xfd/psm-grpc-client] for GCP Service Account xds-k8s-interop-tests@grpc-testing.iam.gserviceaccount.com
I0426 23:46:54.028904 133913833844736 k8s_base_runner.py:907] Deleting service account psm-grpc-client
I0426 23:46:55.073917 133913833844736 k8s_base_runner.py:921] Service account psm-grpc-client deleted
I0426 23:46:55.074057 133913833844736 k8s_base_runner.py:924] Deleting namespace psm-interop-client-20240426-2342-s6xfd
I0426 23:47:25.150775 133913833844736 k8s_base_runner.py:941] Namespace psm-interop-client-20240426-2342-s6xfd deleted
I0426 23:47:25.150956 133913833844736 k8s_base_runner.py:873] Deleting deployment psm-grpc-server
I0426 23:47:35.223839 133913833844736 k8s_base_runner.py:888] Deployment psm-grpc-server deleted
I0426 23:47:35.224037 133913833844736 k8s_base_runner.py:891] Deleting service psm-grpc-server
I0426 23:47:35.275660 133913833844736 k8s_base_runner.py:904] Service psm-grpc-server deleted
I0426 23:47:35.275802 133913833844736 k8s_base_runner.py:471] Revoking roles/iam.workloadIdentityUser from serviceAccount:grpc-testing.svc.id.goog[psm-interop-server-20240426-2342-s6xfd/psm-grpc-server] for GCP Service Account xds-k8s-interop-tests@grpc-testing.iam.gserviceaccount.com
I0426 23:47:35.669000 133913833844736 k8s_base_runner.py:907] Deleting service account psm-grpc-server
I0426 23:47:35.708604 133913833844736 k8s_base_runner.py:921] Service account psm-grpc-server deleted
I0426 23:47:35.708741 133913833844736 k8s_base_runner.py:924] Deleting namespace psm-interop-server-20240426-2342-s6xfd
I0426 23:48:05.782452 133913833844736 k8s_base_runner.py:941] Namespace psm-interop-server-20240426-2342-s6xfd deleted
I0426 23:48:05.782738 133913833844736 xds_k8s_testcase.py:779] ----- Test client/server logs -----
I0426 23:48:05.782939 133913833844736 k8s_base_runner.py:1152] GCP Logs Explorer link to psm-grpc-client-rg5vmqut:
https://console.cloud.google.com/logs/query;query=resource.type%3D%22k8s_container%22%0Aresource.labels.project_id%3D%22grpc-testing%22%0Aresource.labels.container_name%3D%22psm-grpc-client%22%0Aresource.labels.namespace_name%3D%22psm-interop-client-20240426-2342-s6xfd%22%0Alabels.%22k8s-pod%2Fdeployment_id%22%3D%22psm-grpc-client-rg5vmqut%22;timeRange=2024-04-26T23:44:32.416357Z%2F2024-04-26T23:47:25.150931Z;cursorTimestamp=2024-04-26T23:44:55.157023Z?project=grpc-testing
I0426 23:48:05.783052 133913833844736 k8s_base_runner.py:1152] GCP Logs Explorer link to psm-grpc-server-2j5zvudo:
https://console.cloud.google.com/logs/query;query=resource.type%3D%22k8s_container%22%0Aresource.labels.project_id%3D%22grpc-testing%22%0Aresource.labels.container_name%3D%22psm-grpc-server%22%0Aresource.labels.namespace_name%3D%22psm-interop-server-20240426-2342-s6xfd%22%0Alabels.%22k8s-pod%2Fdeployment_id%22%3D%22psm-grpc-server-2j5zvudo%22;timeRange=2024-04-26T23:43:22.391917Z%2F2024-04-26T23:48:05.782599Z;cursorTimestamp=2024-04-26T23:43:32.142466Z?project=grpc-testing
[ OK ] AppNetTest.test_ping_pong
I0426 23:48:05.783222 133913833844736 base_testcase.py:67] ----- PSM Test Case PASSED: AppNetTest.test_ping_pong -----

----------------------------------------------------------------------
Ran 1 test in 328.211s

OK
+ [23:48:06 UTC] Cmd finished: python
+ [23:48:06 UTC] Finished lb suite test: app_net_test

+ [23:48:06 UTC] Running lb suite test: baseline_test
+ [23:48:06 UTC] Test driver flags for baseline_test:
--flagfile=config/grpc-testing.cfg
--kube_context=gke_grpc-testing_us-central1-a_psm-interop-lb-primary
--force_cleanup
--collect_app_logs
--log_dir=/tmpfs/src/artifacts/grpc/node/master/xds_k8s_lb/baseline_test
--xml_output_file=/tmpfs/src/artifacts/grpc/node/master/xds_k8s_lb/baseline_test/sponge_log.xml
--testing_version=dev-master
--client_image=us-docker.pkg.dev/grpc-testing/psm-interop/node-client:9193654c1fe47ccbfecfd50c588c23572cd01049
--server_image=us-docker.pkg.dev/grpc-testing/psm-interop/java-server:canonical
--secondary_kube_context=gke_grpc-testing_us-west1-b_psm-interop-lb-secondary

+ [23:48:06 UTC] python -m tests.baseline_test --flagfile=config/grpc-testing.cfg --kube_context=gke_grpc-testing_us-central1-a_psm-interop-lb-primary --force_cleanup --collect_app_logs --log_dir=/tmpfs/src/artifacts/grpc/node/master/xds_k8s_lb/baseline_test --xml_output_file=/tmpfs/src/artifacts/grpc/node/master/xds_k8s_lb/baseline_test/sponge_log.xml --testing_version=dev-master --client_image=us-docker.pkg.dev/grpc-testing/psm-interop/node-client:9193654c1fe47ccbfecfd50c588c23572cd01049 --server_image=us-docker.pkg.dev/grpc-testing/psm-interop/java-server:canonical --secondary_kube_context=gke_grpc-testing_us-west1-b_psm-interop-lb-secondary
Running tests under Python 3.10.12: /tmp/tmp.Pt3Z0HGU0n/psm-interop/venv/bin/python
I0426 23:48:06.817881 126212424105984 xds_k8s_testcase.py:162] ----- Testing BaselineTest -----
I0426 23:48:06.817997 126212424105984 xds_k8s_testcase.py:163] Logs timezone: UTC
I0426 23:48:06.818174 126212424105984 xds_k8s_testcase.py:111] Detected language and version: TestConfig(client_lang='node', server_lang='java', version='dev-master')
I0426 23:48:06.830839 126212424105984 k8s.py:243] Using kubernetes context "gke_grpc-testing_us-central1-a_psm-interop-lb-primary", active host: https://35.238.98.54
I0426 23:48:06.842286 126212424105984 k8s.py:243] Using kubernetes context "gke_grpc-testing_us-west1-b_psm-interop-lb-secondary", active host: https://35.227.140.120
[ RUN ] BaselineTest.test_traffic_director_grpc_setup
I0426 23:48:06.845770 126212424105984 xds_k8s_testcase.py:736] Test run resource prefix: psm-interop, suffix: 20240426-2348-v3gyl
I0426 23:48:07.131452 126212424105984 logs.py:31] Log root dir: /tmpfs/src/artifacts/grpc/node/master/xds_k8s_lb/baseline_test
I0426 23:48:07.418573 126212424105984 xds_k8s_testcase.py:731] Found unused xds port: 65521
I0426 23:48:07.418857 126212424105984 xds_k8s_testcase.py:299] --- Starting subTest BaselineTest.test_traffic_director_grpc_setup.0_create_health_check ---
I0426 23:48:07.418958 126212424105984 traffic_director.py:191] Creating GRPC Health Check "psm-interop-health-check-20240426-2348-v3gyl"
I0426 23:48:07.421148 126212424105984 compute.py:537] Creating compute resource:
---
grpcHealthCheck:
portSpecification: USE_SERVING_PORT
name: psm-interop-health-check-20240426-2348-v3gyl
type: GRPC
...

I0426 23:48:08.139520 126212424105984 compute.py:614] Waiting 600 sec for compute operation id: operation-1714175287486-617088917e893-60be622d-0ce4f854
I0426 23:48:10.302876 126212424105984 xds_k8s_testcase.py:304] --- Finished subTest BaselineTest.test_traffic_director_grpc_setup.0_create_health_check ---
I0426 23:48:10.303038 126212424105984 xds_k8s_testcase.py:299] --- Starting subTest BaselineTest.test_traffic_director_grpc_setup.1_create_backend_service ---
I0426 23:48:10.303101 126212424105984 traffic_director.py:218] Creating GRPC Backend Service "psm-interop-backend-service-20240426-2348-v3gyl"
I0426 23:48:10.308236 126212424105984 compute.py:537] Creating compute resource:
---
healthChecks:
- https://www.googleapis.com/compute/v1/projects/grpc-testing/global/healthChecks/psm-interop-health-check-20240426-2348-v3gyl
loadBalancingScheme: INTERNAL_SELF_MANAGED
name: psm-interop-backend-service-20240426-2348-v3gyl
protocol: GRPC
...

I0426 23:48:11.081474 126212424105984 compute.py:614] Waiting 600 sec for compute operation id: operation-1714175290314-6170889430fdf-ef826d34-d872df76
I0426 23:48:26.228755 126212424105984 xds_k8s_testcase.py:304] --- Finished subTest BaselineTest.test_traffic_director_grpc_setup.1_create_backend_service ---
I0426 23:48:26.228906 126212424105984 xds_k8s_testcase.py:299] --- Starting subTest BaselineTest.test_traffic_director_grpc_setup.2_create_url_map ---
I0426 23:48:26.228970 126212424105984 traffic_director.py:479] Creating URL map "psm-interop-url-map-20240426-2348-v3gyl": psm-grpc-server:65521 -> psm-interop-backend-service-20240426-2348-v3gyl
I0426 23:48:26.236291 126212424105984 compute.py:537] Creating compute resource:
---
defaultService: https://www.googleapis.com/compute/v1/projects/grpc-testing/global/backendServices/psm-interop-backend-service-20240426-2348-v3gyl
hostRules:
- hosts:
- psm-grpc-server:65521
pathMatcher: psm-interop-path-matcher-20240426-2348-v3gyl
name: psm-interop-url-map-20240426-2348-v3gyl
pathMatchers:
- defaultService: https://www.googleapis.com/compute/v1/projects/grpc-testing/global/backendServices/psm-interop-backend-service-20240426-2348-v3gyl
name: psm-interop-path-matcher-20240426-2348-v3gyl
...

I0426 23:48:27.019146 126212424105984 compute.py:614] Waiting 600 sec for compute operation id: operation-1714175306242-617088a361b32-80e87b49-96d7836f
I0426 23:48:29.362100 126212424105984 xds_k8s_testcase.py:304] --- Finished subTest BaselineTest.test_traffic_director_grpc_setup.2_create_url_map ---
I0426 23:48:29.362245 126212424105984 xds_k8s_testcase.py:299] --- Starting subTest BaselineTest.test_traffic_director_grpc_setup.3_create_target_proxy ---
I0426 23:48:29.362333 126212424105984 traffic_director.py:578] Creating target psm-interop-target-proxy-20240426-2348-v3gyl proxy "GRPC" to URL map psm-interop-url-map-20240426-2348-v3gyl
I0426 23:48:29.363650 126212424105984 compute.py:537] Creating compute resource:
---
name: psm-interop-target-proxy-20240426-2348-v3gyl
url_map: https://www.googleapis.com/compute/v1/projects/grpc-testing/global/urlMaps/psm-interop-url-map-20240426-2348-v3gyl
validate_for_proxyless: true
...

I0426 23:48:29.941923 126212424105984 compute.py:614] Waiting 600 sec for compute operation id: operation-1714175309369-617088a65d285-ce896c8c-13654edb
I0426 23:48:32.173446 126212424105984 xds_k8s_testcase.py:304] --- Finished subTest BaselineTest.test_traffic_director_grpc_setup.3_create_target_proxy ---
I0426 23:48:32.173584 126212424105984 xds_k8s_testcase.py:299] --- Starting subTest BaselineTest.test_traffic_director_grpc_setup.4_create_forwarding_rule ---
I0426 23:48:32.173649 126212424105984 traffic_director.py:654] Creating forwarding rule "psm-interop-forwarding-rule-20240426-2348-v3gyl" in network "default-vpc": 0.0.0.0:65521 -> https://www.googleapis.com/compute/v1/projects/grpc-testing/global/targetGrpcProxies/psm-interop-target-proxy-20240426-2348-v3gyl
I0426 23:48:32.175559 126212424105984 compute.py:537] Creating compute resource:
---
IPAddress: 0.0.0.0
loadBalancingScheme: INTERNAL_SELF_MANAGED
name: psm-interop-forwarding-rule-20240426-2348-v3gyl
network: global/networks/default-vpc
portRange: 65521
target: https://www.googleapis.com/compute/v1/projects/grpc-testing/global/targetGrpcProxies/psm-interop-target-proxy-20240426-2348-v3gyl
...

I0426 23:48:33.118804 126212424105984 compute.py:614] Waiting 600 sec for compute operation id: operation-1714175312177-617088a90a982-ffbe7903-90cfcd7c
I0426 23:48:46.136555 126212424105984 xds_k8s_testcase.py:304] --- Finished subTest BaselineTest.test_traffic_director_grpc_setup.4_create_forwarding_rule ---
I0426 23:48:46.136688 126212424105984 xds_k8s_testcase.py:299] --- Starting subTest BaselineTest.test_traffic_director_grpc_setup.5_start_test_server ---
I0426 23:48:46.136751 126212424105984 k8s_xds_server_runner.py:186] Deploying xDS test server "psm-grpc-server" to k8s namespace psm-interop-server-20240426-2348-v3gyl: test_port=8080 maintenance_port=8080 secure_mode=False replica_count=1
I0426 23:48:46.136958 126212424105984 k8s_base_runner.py:1152] GCP Logs Explorer link to psm-grpc-server:
https://console.cloud.google.com/logs/query;query=resource.type%3D%22k8s_container%22%0Aresource.labels.project_id%3D%22grpc-testing%22%0Aresource.labels.container_name%3D%22psm-grpc-server%22%0Aresource.labels.namespace_name%3D%22psm-interop-server-20240426-2348-v3gyl%22;timeRange=2024-04-26T23:48:46.136821Z%2F2024-04-27T00:18:46.136821Z?project=grpc-testing
I0426 23:48:46.140671 126212424105984 k8s_base_runner.py:347] Rendered template kubernetes-manifests/namespace.yaml:
---
apiVersion: v1
kind: Namespace
metadata:
name: psm-interop-server-20240426-2348-v3gyl
labels:
name: psm-interop-server-20240426-2348-v3gyl
owner: xds-k8s-interop-test
...

I0426 23:48:46.186811 126212424105984 k8s_base_runner.py:367] Namespace psm-interop-server-20240426-2348-v3gyl created
I0426 23:48:46.188907 126212424105984 k8s_base_runner.py:347] Rendered template kubernetes-manifests/server.service.yaml:
---
apiVersion: v1
kind: Service
metadata:
name: psm-grpc-server
namespace: psm-interop-server-20240426-2348-v3gyl
labels:
owner: xds-k8s-interop-test
annotations:
cloud.google.com/neg: '{"exposed_ports": {"8080":{"name":"psm-interop-server-20240426-2348-v3gyl-psm-grpc-server"}}}'
spec:
type: ClusterIP
selector:
app: psm-grpc-server
ports:
- port: 8080
protocol: TCP
targetPort: 8080
...

I0426 23:48:46.216619 126212424105984 k8s_base_runner.py:367] Service psm-grpc-server created
I0426 23:48:46.216720 126212424105984 k8s_base_runner.py:1054] Waiting for 'cloud.google.com/neg-status' annotation for a NEG at port 8080 to be assigned to Kubernetes Service psm-grpc-server in namespace psm-interop-server-20240426-2348-v3gyl
I0426 23:48:46.246992 126212424105984 k8s_base_runner.py:1068] Detected 'cloud.google.com/neg-status' annotation for Kubernetes Service psm-grpc-server, namespace psm-interop-server-20240426-2348-v3gyl: neg_name=psm-interop-server-20240426-2348-v3gyl-psm-grpc-server, port=8080, zones=['us-central1-a']
I0426 23:48:46.247085 126212424105984 k8s_base_runner.py:452] Granting roles/iam.workloadIdentityUser to serviceAccount:grpc-testing.svc.id.goog[psm-interop-server-20240426-2348-v3gyl/psm-grpc-server] for GCP Service Account xds-k8s-interop-tests@grpc-testing.iam.gserviceaccount.com
I0426 23:48:46.721694 126212424105984 k8s_base_runner.py:347] Rendered template kubernetes-manifests/service-account.yaml:
---
apiVersion: v1
kind: ServiceAccount
metadata:
name: psm-grpc-server
namespace: psm-interop-server-20240426-2348-v3gyl
labels:
owner: xds-k8s-interop-test
annotations:
iam.gke.io/gcp-service-account: xds-k8s-interop-tests@grpc-testing.iam.gserviceaccount.com
...

I0426 23:48:46.747276 126212424105984 k8s_base_runner.py:367] ServiceAccount psm-grpc-server created
I0426 23:48:46.758746 126212424105984 k8s_base_runner.py:347] Rendered template kubernetes-manifests/server.deployment.yaml:
---
apiVersion: apps/v1
kind: Deployment
metadata:
name: psm-grpc-server
namespace: psm-interop-server-20240426-2348-v3gyl
labels:
app: psm-grpc-server
deployment_id: psm-grpc-server-w15ezqd4
owner: xds-k8s-interop-test
spec:
replicas: 1
selector:
matchLabels:
app: psm-grpc-server
deployment_id: psm-grpc-server-w15ezqd4
template:
metadata:
labels:
app: psm-grpc-server
deployment_id: psm-grpc-server-w15ezqd4
owner: xds-k8s-interop-test
spec:
serviceAccountName: psm-grpc-server
containers:
- name: psm-grpc-server
image: us-docker.pkg.dev/grpc-testing/psm-interop/java-server:canonical
imagePullPolicy: Always
startupProbe:
tcpSocket:
port: 8080
periodSeconds: 3
failureThreshold: 1000

args:
- "--port=8080"
ports:
- containerPort: 8080
env:
- name: GRPC_XDS_BOOTSTRAP
value: "/tmp/grpc-xds/td-grpc-bootstrap.json"
- name: GRPC_XDS_EXPERIMENTAL_V3_SUPPORT
value: "true"
- name: GRPC_EXPERIMENTAL_XDS_ENABLE_OVERRIDE_HOST
value: "true"
volumeMounts:
- mountPath: /tmp/grpc-xds/
name: grpc-td-conf
readOnly: true

resources:
limits:
cpu: 800m
memory: 512Mi
requests:
cpu: 100m
memory: 512Mi
initContainers:
- name: grpc-td-init
image: us-docker.pkg.dev/grpc-testing/trafficdirector/td-grpc-bootstrap:2bf1b5ed00f852ffea8d24759c6fa673acc9ef10
imagePullPolicy: Always
args:
- "--output=/tmp/bootstrap/td-grpc-bootstrap.json"
- "--vpc-network-name=default-vpc"
- "--node-metadata=app=psm-interop-server-20240426-2348-v3gyl-psm-grpc-server"
resources:
limits:
cpu: 100m
memory: 100Mi
requests:
cpu: 10m
memory: 100Mi
volumeMounts:
- mountPath: /tmp/bootstrap/
name: grpc-td-conf

volumes:
- name: grpc-td-conf
emptyDir:
medium: Memory

...

I0426 23:48:46.789307 126212424105984 k8s_base_runner.py:367] Deployment psm-grpc-server created
I0426 23:48:46.789463 126212424105984 k8s_base_runner.py:962] Waiting for deployment psm-grpc-server to initialize 1 pod(s)
I0426 23:48:46.821016 126212424105984 k8s_base_runner.py:972] Deployment psm-grpc-server initialized 1 pod(s): ['psm-grpc-server-ffd4fb874-lssvp']
I0426 23:48:46.821198 126212424105984 k8s_base_runner.py:982] Waiting for pod psm-grpc-server-ffd4fb874-lssvp to start
I0426 23:48:49.889451 126212424105984 k8s_base_runner.py:985] Pod psm-grpc-server-ffd4fb874-lssvp ready, IP: 10.120.11.144
I0426 23:48:49.889614 126212424105984 k8s_base_runner.py:1030] Enabling log collection from pod psm-grpc-server-ffd4fb874-lssvp to baseline_test/test_app_logs/psm-interop-server-20240426-2348-v3gyl_psm-grpc-server-ffd4fb874-lssvp.log
I0426 23:48:49.889926 126212327859776 k8s_log_collector.py:71] [ns/psm-interop-server-20240426-2348-v3gyl] Starting log collection thread 126212327859776 for psm-grpc-server-ffd4fb874-lssvp
I0426 23:48:49.890029 126212424105984 k8s_base_runner.py:944] Waiting for deployment psm-grpc-server to report 1 available replica(s)
I0426 23:48:54.954145 126212424105984 k8s_base_runner.py:953] Deployment psm-grpc-server has 1 replicas available
I0426 23:48:54.954364 126212424105984 xds_k8s_testcase.py:304] --- Finished subTest BaselineTest.test_traffic_director_grpc_setup.5_start_test_server ---
I0426 23:48:54.954423 126212424105984 xds_k8s_testcase.py:299] --- Starting subTest BaselineTest.test_traffic_director_grpc_setup.6_add_server_backends_to_backend_service ---
I0426 23:48:54.958426 126212424105984 traffic_director.py:256] Waiting for Network Endpoint Groups to load endpoints.
I0426 23:48:55.043873 126212424105984 traffic_director.py:259] Loaded NEG "psm-interop-server-20240426-2348-v3gyl-psm-grpc-server" in zone us-central1-a
I0426 23:48:55.044032 126212424105984 traffic_director.py:277] Adding backends to Backend Service psm-interop-backend-service-20240426-2348-v3gyl: {ComputeV1.ZonalGcpResource(name='psm-interop-server-20240426-2348-v3gyl-psm-grpc-server', url='https://www.googleapis.com/compute/v1/projects/grpc-testing/zones/us-central1-a/networkEndpointGroups/psm-interop-server-20240426-2348-v3gyl-psm-grpc-server', zone='us-central1-a')}
I0426 23:48:55.047070 126212424105984 compute.py:544] Patching compute resource:
---
backends:
- balancingMode: RATE
group: https://www.googleapis.com/compute/v1/projects/grpc-testing/zones/us-central1-a/networkEndpointGroups/psm-interop-server-20240426-2348-v3gyl-psm-grpc-server
maxRatePerEndpoint: 5
...

I0426 23:48:55.988631 126212424105984 compute.py:614] Waiting 600 sec for compute operation id: operation-1714175335053-617088bedb765-b3ff6af1-88c8e170
I0426 23:49:45.298385 126212424105984 traffic_director.py:294] Waiting for Backend Service psm-interop-backend-service-20240426-2348-v3gyl to report all backends healthy: ['psm-interop-server-20240426-2348-v3gyl-psm-grpc-server']
I0426 23:49:53.700398 126212424105984 compute.py:494] Backend psm-interop-server-20240426-2348-v3gyl-psm-grpc-server in zone us-central1-a reported healthy
I0426 23:49:57.704874 126212424105984 xds_k8s_testcase.py:304] --- Finished subTest BaselineTest.test_traffic_director_grpc_setup.6_add_server_backends_to_backend_service ---
I0426 23:49:57.705045 126212424105984 xds_k8s_testcase.py:299] --- Starting subTest BaselineTest.test_traffic_director_grpc_setup.7_start_test_client ---
I0426 23:49:57.705116 126212424105984 k8s_xds_client_runner.py:119] Deploying xDS test client "psm-grpc-client" to k8s namespace psm-interop-client-20240426-2348-v3gyl: server_target=xds:///psm-grpc-server:65521 rpc=UnaryCall qps=25 metadata='' secure_mode=False print_response=False
I0426 23:49:57.705298 126212424105984 k8s_base_runner.py:1152] GCP Logs Explorer link to psm-grpc-client:
https://console.cloud.google.com/logs/query;query=resource.type%3D%22k8s_container%22%0Aresource.labels.project_id%3D%22grpc-testing%22%0Aresource.labels.container_name%3D%22psm-grpc-client%22%0Aresource.labels.namespace_name%3D%22psm-interop-client-20240426-2348-v3gyl%22;timeRange=2024-04-26T23:49:57.705193Z%2F2024-04-27T00:19:57.705193Z?project=grpc-testing
I0426 23:49:57.706837 126212424105984 k8s_base_runner.py:347] Rendered template kubernetes-manifests/namespace.yaml:
---
apiVersion: v1
kind: Namespace
metadata:
name: psm-interop-client-20240426-2348-v3gyl
labels:
name: psm-interop-client-20240426-2348-v3gyl
owner: xds-k8s-interop-test
...

I0426 23:49:57.717140 126212424105984 k8s_base_runner.py:367] Namespace psm-interop-client-20240426-2348-v3gyl created
I0426 23:49:57.717223 126212424105984 k8s_base_runner.py:452] Granting roles/iam.workloadIdentityUser to serviceAccount:grpc-testing.svc.id.goog[psm-interop-client-20240426-2348-v3gyl/psm-grpc-client] for GCP Service Account xds-k8s-interop-tests@grpc-testing.iam.gserviceaccount.com
I0426 23:49:58.133295 126212424105984 k8s_base_runner.py:347] Rendered template kubernetes-manifests/service-account.yaml:
---
apiVersion: v1
kind: ServiceAccount
metadata:
name: psm-grpc-client
namespace: psm-interop-client-20240426-2348-v3gyl
labels:
owner: xds-k8s-interop-test
annotations:
iam.gke.io/gcp-service-account: xds-k8s-interop-tests@grpc-testing.iam.gserviceaccount.com
...

I0426 23:49:58.159793 126212424105984 k8s_base_runner.py:367] ServiceAccount psm-grpc-client created
I0426 23:49:58.166456 126212424105984 k8s_base_runner.py:347] Rendered template kubernetes-manifests/client.deployment.yaml:
---
apiVersion: apps/v1
kind: Deployment
metadata:
name: psm-grpc-client
namespace: psm-interop-client-20240426-2348-v3gyl
labels:
app: psm-grpc-client
deployment_id: psm-grpc-client-f6w8d3pj
owner: xds-k8s-interop-test
spec:
replicas: 1
selector:
matchLabels:
app: psm-grpc-client
deployment_id: psm-grpc-client-f6w8d3pj
template:
metadata:
labels:
app: psm-grpc-client
deployment_id: psm-grpc-client-f6w8d3pj
owner: xds-k8s-interop-test
spec:
serviceAccountName: psm-grpc-client
containers:
- name: psm-grpc-client
image: us-docker.pkg.dev/grpc-testing/psm-interop/node-client:9193654c1fe47ccbfecfd50c588c23572cd01049
imagePullPolicy: Always
startupProbe:
tcpSocket:
port: 8079
periodSeconds: 3
failureThreshold: 1000
args:
- "--server=xds:///psm-grpc-server:65521"
- "--stats_port=8079"
- "--qps=25"
- "--rpc=UnaryCall"
- "--metadata="
- "--print_response=False"
ports:
- containerPort: 8079
env:
- name: GRPC_XDS_BOOTSTRAP
value: "/tmp/grpc-xds/td-grpc-bootstrap.json"
- name: GRPC_XDS_EXPERIMENTAL_ENABLE_RING_HASH
value: "true"
- name: GRPC_XDS_EXPERIMENTAL_ENABLE_RETRY
value: "true"
- name: GRPC_EXPERIMENTAL_ENABLE_OUTLIER_DETECTION
value: "true"
- name: GRPC_EXPERIMENTAL_XDS_CUSTOM_LB_CONFIG
value: "true"
- name: GRPC_EXPERIMENTAL_XDS_ENABLE_OVERRIDE_HOST
value: "true"
volumeMounts:
- mountPath: /tmp/grpc-xds/
name: grpc-td-conf
readOnly: true
resources:
limits:
cpu: 800m
memory: 512Mi
requests:
cpu: 100m
memory: 512Mi
initContainers:
- name: grpc-td-init
image: us-docker.pkg.dev/grpc-testing/trafficdirector/td-grpc-bootstrap:2bf1b5ed00f852ffea8d24759c6fa673acc9ef10
imagePullPolicy: Always
args:
- "--output=/tmp/bootstrap/td-grpc-bootstrap.json"
- "--vpc-network-name=default-vpc"
resources:
limits:
cpu: 100m
memory: 100Mi
requests:
cpu: 10m
memory: 100Mi
volumeMounts:
- mountPath: /tmp/bootstrap/
name: grpc-td-conf
volumes:
- name: grpc-td-conf
emptyDir:
medium: Memory
...

I0426 23:49:58.206718 126212424105984 k8s_base_runner.py:367] Deployment psm-grpc-client created
I0426 23:49:58.206871 126212424105984 k8s_base_runner.py:962] Waiting for deployment psm-grpc-client to initialize 1 pod(s)
I0426 23:49:58.244354 126212424105984 k8s_base_runner.py:972] Deployment psm-grpc-client initialized 1 pod(s): ['psm-grpc-client-6f5c99c6f4-624tf']
I0426 23:49:58.244490 126212424105984 k8s_base_runner.py:982] Waiting for pod psm-grpc-client-6f5c99c6f4-624tf to start
I0426 23:50:23.509582 126212424105984 k8s_base_runner.py:985] Pod psm-grpc-client-6f5c99c6f4-624tf ready, IP: 10.120.14.99
I0426 23:50:23.509741 126212424105984 k8s_base_runner.py:1030] Enabling log collection from pod psm-grpc-client-6f5c99c6f4-624tf to baseline_test/test_app_logs/psm-interop-client-20240426-2348-v3gyl_psm-grpc-client-6f5c99c6f4-624tf.log
I0426 23:50:23.510042 126212244502080 k8s_log_collector.py:71] [ns/psm-interop-client-20240426-2348-v3gyl] Starting log collection thread 126212244502080 for psm-grpc-client-6f5c99c6f4-624tf
I0426 23:50:23.510187 126212424105984 k8s_base_runner.py:944] Waiting for deployment psm-grpc-client to report 1 available replica(s)
I0426 23:50:29.588403 126212424105984 k8s_base_runner.py:953] Deployment psm-grpc-client has 1 replicas available
I0426 23:50:29.588727 126212424105984 client_app.py:292] [psm-grpc-client-6f5c99c6f4-624tf] ADS: Waiting for active calls to xDS control plane to trafficdirector.googleapis.com:443
I0426 23:50:29.633000 126212424105984 client_app.py:320] [psm-grpc-client-6f5c99c6f4-624tf] xDS control plane channel:
I0426 23:50:39.656658 126212424105984 client_app.py:320] [psm-grpc-client-6f5c99c6f4-624tf] xDS control plane channel:
I0426 23:50:49.678140 126212424105984 client_app.py:320] [psm-grpc-client-6f5c99c6f4-624tf] xDS control plane channel:
I0426 23:50:59.700414 126212424105984 client_app.py:320] [psm-grpc-client-6f5c99c6f4-624tf] xDS control plane channel:
I0426 23:51:01.713507 126212424105984 client_app.py:331] [psm-grpc-client-6f5c99c6f4-624tf] Detected active calls to xDS control plane trafficdirector.googleapis.com:443, channel:
I0426 23:51:01.713699 126212424105984 client_app.py:302] [psm-grpc-client-6f5c99c6f4-624tf] ADS: Detected active calls to xDS control plane trafficdirector.googleapis.com:443
I0426 23:51:01.713871 126212424105984 client_app.py:252] [psm-grpc-client-6f5c99c6f4-624tf] Waiting to report a READY channel to xds:///psm-grpc-server:65521
I0426 23:51:01.720414 126212424105984 client_app.py:379] [psm-grpc-client-6f5c99c6f4-624tf] Server channel:
I0426 23:51:01.730554 126212424105984 client_app.py:392] [psm-grpc-client-6f5c99c6f4-624tf] Found subchannel in state READY:
I0426 23:51:01.730710 126212424105984 client_app.py:263] [psm-grpc-client-6f5c99c6f4-624tf] Channel to xds:///psm-grpc-server:65521 transitioned to state READY:
I0426 23:51:01.730793 126212424105984 xds_k8s_testcase.py:304] --- Finished subTest BaselineTest.test_traffic_director_grpc_setup.7_start_test_client ---
I0426 23:51:01.730844 126212424105984 xds_k8s_testcase.py:299] --- Starting subTest BaselineTest.test_traffic_director_grpc_setup.8_test_client_xds_config_exists ---
I0426 23:51:01.730996 126212424105984 grpc.py:75] [psm-grpc-client-6f5c99c6f4-624tf:8079] >> RPC ClientStatusDiscoveryService.FetchClientStatus(request=ClientStatusRequest({}), wait_for_ready=True, timeout=30)
I0426 23:51:01.746488 126212424105984 xds_k8s_testcase.py:304] --- Finished subTest BaselineTest.test_traffic_director_grpc_setup.8_test_client_xds_config_exists ---
I0426 23:51:01.746632 126212424105984 xds_k8s_testcase.py:299] --- Starting subTest BaselineTest.test_traffic_director_grpc_setup.9_test_server_received_rpcs_from_test_client ---
I0426 23:51:01.746799 126212424105984 grpc.py:75] [psm-grpc-client-6f5c99c6f4-624tf:8079] >> RPC LoadBalancerStatsService.GetClientStats(request=LoadBalancerStatsRequest({'numRpcs': 100, 'timeoutSec': 1200}), wait_for_ready=True, timeout=1200)
I0426 23:51:05.770459 126212424105984 xds_k8s_testcase.py:669] [psm-grpc-client-6f5c99c6f4-624tf] << Received LoadBalancerStatsResponse:
num_failures: 0
rpcs_by_peer:
psm-grpc-server-ffd4fb874-lssvp: 100
rpcs_by_method:
UnaryCall:
psm-grpc-server-ffd4fb874-lssvp: 100

I0426 23:51:05.770627 126212424105984 xds_k8s_testcase.py:304] --- Finished subTest BaselineTest.test_traffic_director_grpc_setup.9_test_server_received_rpcs_from_test_client ---
I0426 23:51:05.770708 126212424105984 xds_k8s_testcase.py:755] ----- TestMethod BaselineTest.test_traffic_director_grpc_setup teardown -----
I0426 23:51:05.848143 126212424105984 traffic_director.py:674] Deleting Forwarding rule "psm-interop-forwarding-rule-20240426-2348-v3gyl"
I0426 23:51:06.508563 126212424105984 compute.py:614] Waiting 600 sec for compute operation id: operation-1714175465856-6170893b99c92-aef2eadd-84ebb3f1
I0426 23:51:19.373444 126212424105984 traffic_director.py:713] Deleting alternative Forwarding rule "psm-interop-forwarding-rule-alt-20240426-2348-v3gyl"
I0426 23:51:19.486074 126212424105984 traffic_director.py:605] Deleting HTTP Target proxy "psm-interop-target-proxy-20240426-2348-v3gyl"
I0426 23:51:19.859814 126212424105984 traffic_director.py:593] Deleting Target GRPC proxy "psm-interop-target-proxy-20240426-2348-v3gyl"
I0426 23:51:20.510865 126212424105984 compute.py:614] Waiting 600 sec for compute operation id: operation-1714175479863-61708948f591e-d787edcd-daf2b01b
I0426 23:51:22.808612 126212424105984 traffic_director.py:633] Deleting alternative Target GRPC proxy "psm-interop-target-proxy-alt-20240426-2348-v3gyl"
I0426 23:51:23.142403 126212424105984 traffic_director.py:525] Deleting URL Map "psm-interop-url-map-20240426-2348-v3gyl"
I0426 23:51:23.751259 126212424105984 compute.py:614] Waiting 600 sec for compute operation id: operation-1714175483151-6170894c183ef-d76fe4db-ee924b3b
I0426 23:51:25.912200 126212424105984 traffic_director.py:561] Deleting alternative URL Map "psm-interop-url-map-alt-20240426-2348-v3gyl"
I0426 23:51:26.301715 126212424105984 traffic_director.py:243] Deleting Backend Service "psm-interop-backend-service-20240426-2348-v3gyl"
I0426 23:51:27.136968 126212424105984 compute.py:614] Waiting 600 sec for compute operation id: operation-1714175486310-6170894f1b8fe-2e56eefe-e437fb90
I0426 23:51:57.185073 126212424105984 traffic_director.py:332] Deleting Alternative Backend Service "psm-interop-backend-service-alt-20240426-2348-v3gyl"
I0426 23:51:57.646623 126212424105984 traffic_director.py:405] Deleting Affinity Backend Service "psm-interop-backend-service-affinity-20240426-2348-v3gyl"
I0426 23:51:58.002154 126212424105984 traffic_director.py:202] Deleting Health Check "psm-interop-health-check-20240426-2348-v3gyl"
I0426 23:51:58.544428 126212424105984 compute.py:614] Waiting 600 sec for compute operation id: operation-1714175518075-6170896d66899-a98d0b62-1cd8e3b8
I0426 23:52:02.977460 126212424105984 k8s_base_runner.py:873] Deleting deployment psm-grpc-client
I0426 23:52:43.105489 126212424105984 k8s_base_runner.py:888] Deployment psm-grpc-client deleted
I0426 23:52:43.105695 126212424105984 k8s_base_runner.py:471] Revoking roles/iam.workloadIdentityUser from serviceAccount:grpc-testing.svc.id.goog[psm-interop-client-20240426-2348-v3gyl/psm-grpc-client] for GCP Service Account xds-k8s-interop-tests@grpc-testing.iam.gserviceaccount.com
I0426 23:52:43.445398 126212424105984 k8s_base_runner.py:907] Deleting service account psm-grpc-client
I0426 23:52:43.505459 126212424105984 k8s_base_runner.py:921] Service account psm-grpc-client deleted
I0426 23:52:43.505623 126212424105984 k8s_base_runner.py:924] Deleting namespace psm-interop-client-20240426-2348-v3gyl
I0426 23:53:13.614779 126212424105984 k8s_base_runner.py:941] Namespace psm-interop-client-20240426-2348-v3gyl deleted
I0426 23:53:13.614941 126212424105984 k8s_base_runner.py:873] Deleting deployment psm-grpc-server
I0426 23:53:23.694515 126212424105984 k8s_base_runner.py:888] Deployment psm-grpc-server deleted
I0426 23:53:23.694698 126212424105984 k8s_base_runner.py:891] Deleting service psm-grpc-server
I0426 23:53:24.746650 126212424105984 k8s_base_runner.py:904] Service psm-grpc-server deleted
I0426 23:53:24.746810 126212424105984 k8s_base_runner.py:471] Revoking roles/iam.workloadIdentityUser from serviceAccount:grpc-testing.svc.id.goog[psm-interop-server-20240426-2348-v3gyl/psm-grpc-server] for GCP Service Account xds-k8s-interop-tests@grpc-testing.iam.gserviceaccount.com
I0426 23:53:25.149905 126212424105984 k8s_base_runner.py:907] Deleting service account psm-grpc-server
I0426 23:53:25.207969 126212424105984 k8s_base_runner.py:921] Service account psm-grpc-server deleted
I0426 23:53:25.208127 126212424105984 k8s_base_runner.py:924] Deleting namespace psm-interop-server-20240426-2348-v3gyl
I0426 23:54:25.329428 126212424105984 k8s_base_runner.py:941] Namespace psm-interop-server-20240426-2348-v3gyl deleted
I0426 23:54:25.329702 126212424105984 xds_k8s_testcase.py:779] ----- Test client/server logs -----
I0426 23:54:25.329882 126212424105984 k8s_base_runner.py:1152] GCP Logs Explorer link to psm-grpc-client-f6w8d3pj:
https://console.cloud.google.com/logs/query;query=resource.type%3D%22k8s_container%22%0Aresource.labels.project_id%3D%22grpc-testing%22%0Aresource.labels.container_name%3D%22psm-grpc-client%22%0Aresource.labels.namespace_name%3D%22psm-interop-client-20240426-2348-v3gyl%22%0Alabels.%22k8s-pod%2Fdeployment_id%22%3D%22psm-grpc-client-f6w8d3pj%22;timeRange=2024-04-26T23:49:57.705187Z%2F2024-04-26T23:53:13.614917Z;cursorTimestamp=2024-04-26T23:50:29.588565Z?project=grpc-testing
I0426 23:54:25.330017 126212424105984 k8s_base_runner.py:1152] GCP Logs Explorer link to psm-grpc-server-w15ezqd4:
https://console.cloud.google.com/logs/query;query=resource.type%3D%22k8s_container%22%0Aresource.labels.project_id%3D%22grpc-testing%22%0Aresource.labels.container_name%3D%22psm-grpc-server%22%0Aresource.labels.namespace_name%3D%22psm-interop-server-20240426-2348-v3gyl%22%0Alabels.%22k8s-pod%2Fdeployment_id%22%3D%22psm-grpc-server-w15ezqd4%22;timeRange=2024-04-26T23:48:46.136815Z%2F2024-04-26T23:54:25.329575Z;cursorTimestamp=2024-04-26T23:48:54.954316Z?project=grpc-testing
[ OK ] BaselineTest.test_traffic_director_grpc_setup
I0426 23:54:25.330192 126212424105984 base_testcase.py:67] ----- PSM Test Case PASSED: BaselineTest.test_traffic_director_grpc_setup -----

----------------------------------------------------------------------
Ran 1 test in 378.515s

OK
+ [23:54:25 UTC] Cmd finished: python
+ [23:54:25 UTC] Finished lb suite test: baseline_test

+ [23:54:25 UTC] Failed test suites: 0


[ID: 9361796] Command finished after 898 secs, exit value: 0


Warning: Permanently added 'localhost' (ED25519) to the list of known hosts.
[16:54:25 PDT] Collecting build artifacts from build VM
[16:54:29 PDT] Kokoro builder finished