starting build "f365477c-7080-4281-961a-25a5e5af0f9e"

FETCHSOURCE
hint: Using 'master' as the name for the initial branch. This default branch name
hint: is subject to change. To configure the initial branch name to use in all
hint: of your new repositories, which will suppress this warning, call:
hint: 
hint: 	git config --global init.defaultBranch <name>
hint: 
hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and
hint: 'development'. The just-created branch can be renamed via this command:
hint: 
hint: 	git branch -m <name>
Initialized empty Git repository in /workspace/.git/
From https://github.com/googleapis/google-cloud-cpp
 * branch              0f072d0535711034660453161ad588c5d51194db -> FETCH_HEAD
Updating files:   5% (1032/18214)
Updating files:   6% (1093/18214)
Updating files:   7% (1275/18214)
Updating files:   8% (1458/18214)
Updating files:   9% (1640/18214)
Updating files:  10% (1822/18214)
Updating files:  11% (2004/18214)
Updating files:  12% (2186/18214)
Updating files:  13% (2368/18214)
Updating files:  14% (2550/18214)
Updating files:  15% (2733/18214)
Updating files:  16% (2915/18214)
Updating files:  17% (3097/18214)
Updating files:  18% (3279/18214)
Updating files:  19% (3461/18214)
Updating files:  20% (3643/18214)
Updating files:  21% (3825/18214)
Updating files:  22% (4008/18214)
Updating files:  23% (4190/18214)
Updating files:  24% (4372/18214)
Updating files:  25% (4554/18214)
Updating files:  26% (4736/18214)
Updating files:  27% (4918/18214)
Updating files:  28% (5100/18214)
Updating files:  29% (5283/18214)
Updating files:  30% (5465/18214)
Updating files:  31% (5647/18214)
Updating files:  32% (5829/18214)
Updating files:  33% (6011/18214)
Updating files:  34% (6193/18214)
Updating files:  35% (6375/18214)
Updating files:  36% (6558/18214)
Updating files:  37% (6740/18214)
Updating files:  38% (6922/18214)
Updating files:  39% (7104/18214)
Updating files:  40% (7286/18214)
Updating files:  41% (7468/18214)
Updating files:  42% (7650/18214)
Updating files:  43% (7833/18214)
Updating files:  44% (8015/18214)
Updating files:  45% (8197/18214)
Updating files:  46% (8379/18214)
Updating files:  47% (8561/18214)
Updating files:  48% (8743/18214)
Updating files:  49% (8925/18214)
Updating files:  50% (9107/18214)
Updating files:  51% (9290/18214)
Updating files:  52% (9472/18214)
Updating files:  53% (9654/18214)
Updating files:  54% (9836/18214)
Updating files:  55% (10018/18214)
Updating files:  56% (10200/18214)
Updating files:  57% (10382/18214)
Updating files:  58% (10565/18214)
Updating files:  59% (10747/18214)
Updating files:  60% (10929/18214)
Updating files:  61% (11111/18214)
Updating files:  62% (11293/18214)
Updating files:  63% (11475/18214)
Updating files:  64% (11657/18214)
Updating files:  65% (11840/18214)
Updating files:  66% (12022/18214)
Updating files:  67% (12204/18214)
Updating files:  68% (12386/18214)
Updating files:  69% (12568/18214)
Updating files:  70% (12750/18214)
Updating files:  71% (12932/18214)
Updating files:  72% (13115/18214)
Updating files:  73% (13297/18214)
Updating files:  74% (13479/18214)
Updating files:  75% (13661/18214)
Updating files:  76% (13843/18214)
Updating files:  77% (14025/18214)
Updating files:  78% (14207/18214)
Updating files:  79% (14390/18214)
Updating files:  80% (14572/18214)
Updating files:  81% (14754/18214)
Updating files:  82% (14936/18214)
Updating files:  83% (15118/18214)
Updating files:  84% (15300/18214)
Updating files:  85% (15482/18214)
Updating files:  86% (15665/18214)
Updating files:  87% (15847/18214)
Updating files:  88% (16029/18214)
Updating files:  89% (16211/18214)
Updating files:  90% (16393/18214)
Updating files:  91% (16575/18214)
Updating files:  92% (16757/18214)
Updating files:  93% (16940/18214)
Updating files:  94% (17122/18214)
Updating files:  95% (17304/18214)
Updating files:  96% (17486/18214)
Updating files:  97% (17668/18214)
Updating files:  98% (17850/18214)
Updating files:  99% (18032/18214)
Updating files: 100% (18214/18214)
Updating files: 100% (18214/18214), done.
HEAD is now at 0f072d05 Update google/cloud/pubsub/integration_tests/subscriber_integration_test.cc
BUILD
Starting Step #10
Starting Step #4
Starting Step #8
Starting Step #9
Starting Step #0 - "kaniko-attempt-1"
Step #8: Pulling image: gcr.io/google.com/cloudsdktool/cloud-sdk
Step #9: Pulling image: gcr.io/google.com/cloudsdktool/cloud-sdk
Step #4: Pulling image: gcr.io/google.com/cloudsdktool/cloud-sdk
Step #10: Pulling image: gcr.io/google.com/cloudsdktool/cloud-sdk
Step #0 - "kaniko-attempt-1": Pulling image: gcr.io/kaniko-project/executor:v1.20.1
Step #9: Using default tag: latest
Step #4: Using default tag: latest
Step #10: Using default tag: latest
Step #8: Using default tag: latest
Step #9: latest: Pulling from google.com/cloudsdktool/cloud-sdk
Step #9: 09e2bc8a597c: Already exists
Step #9: 891be8d8ac77: Pulling fs layer
Step #9: 4d8ded865428: Pulling fs layer
Step #9: 014fe87a7221: Pulling fs layer
Step #9: c17aee4b301f: Pulling fs layer
Step #9: 2f8dc7f55f5a: Pulling fs layer
Step #9: 9a6449201939: Pulling fs layer
Step #9: c17aee4b301f: Waiting
Step #9: 2f8dc7f55f5a: Waiting
Step #9: 9a6449201939: Waiting
Step #9: 014fe87a7221: Verifying Checksum
Step #9: 014fe87a7221: Download complete
Step #9: 891be8d8ac77: Verifying Checksum
Step #9: 891be8d8ac77: Download complete
Step #9: 4d8ded865428: Verifying Checksum
Step #9: 4d8ded865428: Download complete
Step #4: latest: Pulling from google.com/cloudsdktool/cloud-sdk
Step #4: 09e2bc8a597c: Already exists
Step #4: 891be8d8ac77: Pulling fs layer
Step #4: 4d8ded865428: Pulling fs layer
Step #4: 014fe87a7221: Pulling fs layer
Step #4: c17aee4b301f: Pulling fs layer
Step #4: 2f8dc7f55f5a: Pulling fs layer
Step #4: 9a6449201939: Pulling fs layer
Step #4: 9a6449201939: Waiting
Step #4: 014fe87a7221: Download complete
Step #4: 4d8ded865428: Download complete
Step #4: 2f8dc7f55f5a: Waiting
Step #0 - "kaniko-attempt-1": v1.20.1: Pulling from kaniko-project/executor
Step #0 - "kaniko-attempt-1": Digest: sha256:c71116ee36be17b14026f853103f7fb695042a9b6a4b4ad9b70de0e65c5c94a1
Step #0 - "kaniko-attempt-1": Status: Downloaded newer image for gcr.io/kaniko-project/executor:v1.20.1
Step #0 - "kaniko-attempt-1": gcr.io/kaniko-project/executor:v1.20.1
Step #4: 9a6449201939: Download complete
Step #9: 9a6449201939: Verifying Checksum
Step #9: 9a6449201939: Download complete
Step #10: latest: Pulling from google.com/cloudsdktool/cloud-sdk
Step #10: 09e2bc8a597c: Already exists
Step #10: 891be8d8ac77: Pulling fs layer
Step #10: 4d8ded865428: Pulling fs layer
Step #10: 014fe87a7221: Pulling fs layer
Step #10: c17aee4b301f: Pulling fs layer
Step #10: 2f8dc7f55f5a: Pulling fs layer
Step #10: 9a6449201939: Pulling fs layer
Step #10: 9a6449201939: Download complete
Step #10: 4d8ded865428: Download complete
Step #10: 014fe87a7221: Download complete
Step #8: latest: Pulling from google.com/cloudsdktool/cloud-sdk
Step #8: 09e2bc8a597c: Already exists
Step #8: 891be8d8ac77: Pulling fs layer
Step #8: 4d8ded865428: Pulling fs layer
Step #8: 014fe87a7221: Pulling fs layer
Step #8: c17aee4b301f: Pulling fs layer
Step #8: 2f8dc7f55f5a: Pulling fs layer
Step #8: 9a6449201939: Pulling fs layer
Step #8: 9a6449201939: Download complete
Step #8: 014fe87a7221: Download complete
Step #8: 4d8ded865428: Download complete
Step #8: 891be8d8ac77: Pull complete
Step #9: 891be8d8ac77: Pull complete
Step #4: 891be8d8ac77: Pull complete
Step #10: 891be8d8ac77: Pull complete
Step #4: 2f8dc7f55f5a: Verifying Checksum
Step #4: 2f8dc7f55f5a: Download complete
Step #9: 2f8dc7f55f5a: Verifying Checksum
Step #9: 2f8dc7f55f5a: Download complete
Step #8: 2f8dc7f55f5a: Verifying Checksum
Step #8: 2f8dc7f55f5a: Download complete
Step #10: 2f8dc7f55f5a: Verifying Checksum
Step #10: 2f8dc7f55f5a: Download complete
Step #8: 4d8ded865428: Pull complete
Step #10: 4d8ded865428: Pull complete
Step #9: 4d8ded865428: Pull complete
Step #4: 4d8ded865428: Pull complete
Step #9: 014fe87a7221: Pull complete
Step #4: 014fe87a7221: Pull complete
Step #8: 014fe87a7221: Pull complete
Step #10: 014fe87a7221: Pull complete
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:13:12Z" level=info msg="Using dockerignore file: /workspace/ci/.dockerignore"
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:13:12Z" level=info msg="Retrieving image manifest ubuntu:focal"
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:13:12Z" level=info msg="Retrieving image ubuntu:focal from registry index.docker.io"
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:13:12Z" level=info msg="Retrieving image manifest ubuntu:focal"
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:13:12Z" level=info msg="Returning cached image manifest"
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:13:12Z" level=info msg="Built cross stage deps: map[]"
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:13:12Z" level=info msg="Retrieving image manifest ubuntu:focal"
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:13:12Z" level=info msg="Returning cached image manifest"
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:13:12Z" level=info msg="Retrieving image manifest ubuntu:focal"
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:13:12Z" level=info msg="Returning cached image manifest"
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:13:12Z" level=info msg="Executing 0 build triggers"
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:13:12Z" level=info msg="Building stage 'ubuntu:focal' [idx: '0', base-idx: '-1']"
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:13:12Z" level=info msg="Checking for cached layer gcr.io/cloud-cpp-testing-resources/cloudbuild/ubuntu-focal/cache:7756d15d65d2db331a67650c56f8afb9da1d156a2893f1348c9ab41b829f99cf..."
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:13:13Z" level=info msg="Using caching version of cmd: RUN apt-get update &&     apt-get --no-install-recommends install -y         automake         build-essential         clang         clang-9         cmake         ctags         curl         gawk         git         gcc         g++         cmake         libcurl4-openssl-dev         libssl-dev         libtool         llvm-9         lsb-release         make         ninja-build         patch         pkg-config         python3         python3-dev         python3-pip         tar         unzip         zip         wget         zlib1g-dev         apt-utils         ca-certificates         apt-transport-https"
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:13:13Z" level=info msg="Checking for cached layer gcr.io/cloud-cpp-testing-resources/cloudbuild/ubuntu-focal/cache:f0e5a3db819946302d490dff91f1f83f48026b1ad5685faa6c7faa140d99d798..."
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:13:13Z" level=info msg="Using caching version of cmd: RUN update-alternatives --install /usr/bin/python python $(which python3) 10"
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:13:13Z" level=info msg="Checking for cached layer gcr.io/cloud-cpp-testing-resources/cloudbuild/ubuntu-focal/cache:53c3d07ef1b43cb4931bab291a79d909e0235029730aa4170eccd18a7ce06d3f..."
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:13:13Z" level=info msg="Using caching version of cmd: RUN pip3 install setuptools wheel"
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:13:13Z" level=info msg="Checking for cached layer gcr.io/cloud-cpp-testing-resources/cloudbuild/ubuntu-focal/cache:da4da71711d909b1a618cc8bffb2e7015fe53abaa5e6b603a43d7bd7049d0192..."
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:13:13Z" level=info msg="Using caching version of cmd: RUN apt update && (apt install -y openjdk-11-jre || apt install -y openjdk-9-jre)"
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:13:13Z" level=info msg="Checking for cached layer gcr.io/cloud-cpp-testing-resources/cloudbuild/ubuntu-focal/cache:00e8b1a896a74f5163d96b79a9ede40f3dc1a13e0b5ed99e8f3b43154126b33d..."
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:13:13Z" level=info msg="Using caching version of cmd: RUN /var/tmp/ci/install-cloud-sdk.sh"
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:13:13Z" level=info msg="Checking for cached layer gcr.io/cloud-cpp-testing-resources/cloudbuild/ubuntu-focal/cache:de0365a290083b88dac787a62fc4b9b08c08c50f98c672d5395233d1510b050f..."
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:13:13Z" level=info msg="Cache entry expired: gcr.io/cloud-cpp-testing-resources/cloudbuild/ubuntu-focal/cache:de0365a290083b88dac787a62fc4b9b08c08c50f98c672d5395233d1510b050f"
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:13:13Z" level=info msg="No cached layer found for cmd RUN curl -o /usr/bin/bazelisk -sSL \"https://github.com/bazelbuild/bazelisk/releases/download/v1.19.0/bazelisk-linux-${ARCH}\" &&     chmod +x /usr/bin/bazelisk &&     ln -s /usr/bin/bazelisk /usr/bin/bazel"
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:13:13Z" level=info msg="Unpacking rootfs as cmd COPY . /var/tmp/ci requires it."
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:13:15Z" level=info msg="ARG NCPU=4"
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:13:15Z" level=info msg="No files changed in this command, skipping snapshotting."
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:13:15Z" level=info msg="ARG ARCH=amd64"
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:13:15Z" level=info msg="No files changed in this command, skipping snapshotting."
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:13:15Z" level=info msg="ENV DEBIAN_FRONTEND=noninteractive"
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:13:15Z" level=info msg="No files changed in this command, skipping snapshotting."
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:13:15Z" level=info msg="RUN apt-get update &&     apt-get --no-install-recommends install -y         automake         build-essential         clang         clang-9         cmake         ctags         curl         gawk         git         gcc         g++         cmake         libcurl4-openssl-dev         libssl-dev         libtool         llvm-9         lsb-release         make         ninja-build         patch         pkg-config         python3         python3-dev         python3-pip         tar         unzip         zip         wget         zlib1g-dev         apt-utils         ca-certificates         apt-transport-https"
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:13:15Z" level=info msg="Found cached layer, extracting to filesystem"
Step #4: c17aee4b301f: Verifying Checksum
Step #4: c17aee4b301f: Download complete
Step #9: c17aee4b301f: Verifying Checksum
Step #9: c17aee4b301f: Download complete
Step #10: c17aee4b301f: Verifying Checksum
Step #8: c17aee4b301f: Verifying Checksum
Step #8: c17aee4b301f: Download complete
Step #10: c17aee4b301f: Download complete
Step #4: c17aee4b301f: Pull complete
Step #10: c17aee4b301f: Pull complete
Step #9: c17aee4b301f: Pull complete
Step #8: c17aee4b301f: Pull complete
Step #4: 2f8dc7f55f5a: Pull complete
Step #10: 2f8dc7f55f5a: Pull complete
Step #8: 2f8dc7f55f5a: Pull complete
Step #9: 2f8dc7f55f5a: Pull complete
Step #9: 9a6449201939: Pull complete
Step #10: 9a6449201939: Pull complete
Step #4: 9a6449201939: Pull complete
Step #8: 9a6449201939: Pull complete
Step #9: Digest: sha256:6c8b1d35cb5774b36276d8f93a57d4a2084bb328a03ee8609f10de5afa404b7d
Step #4: Digest: sha256:6c8b1d35cb5774b36276d8f93a57d4a2084bb328a03ee8609f10de5afa404b7d
Step #8: Digest: sha256:6c8b1d35cb5774b36276d8f93a57d4a2084bb328a03ee8609f10de5afa404b7d
Step #10: Digest: sha256:6c8b1d35cb5774b36276d8f93a57d4a2084bb328a03ee8609f10de5afa404b7d
Step #8: Status: Image is up to date for gcr.io/google.com/cloudsdktool/cloud-sdk:latest
Step #9: Status: Downloaded newer image for gcr.io/google.com/cloudsdktool/cloud-sdk:latest
Step #4: Status: Downloaded newer image for gcr.io/google.com/cloudsdktool/cloud-sdk:latest
Step #10: Status: Image is up to date for gcr.io/google.com/cloudsdktool/cloud-sdk:latest
Step #8: gcr.io/google.com/cloudsdktool/cloud-sdk:latest
Step #9: gcr.io/google.com/cloudsdktool/cloud-sdk:latest
Step #4: gcr.io/google.com/cloudsdktool/cloud-sdk:latest
Step #10: gcr.io/google.com/cloudsdktool/cloud-sdk:latest
Step #9: + test -z 13701
Step #9: ++ gcloud builds describe --region us-east1 --format 'value(create_time)' f365477c-7080-4281-961a-25a5e5af0f9e
Step #10: + test -z 13701
Step #10: ++ gcloud builds describe --region us-east1 --format 'value(create_time)' f365477c-7080-4281-961a-25a5e5af0f9e
Step #4: 2024-03-05T19:14:00Z (+0s): Running:
Step #4: env -C '/h' /workspace/ci/cloudbuild/cache.sh restore --bucket_url=gs://cloud-cpp-testing-resources_cloudbuild/build-cache/google-cloud-cpp --key=13701/ubuntu-focal/cmake-oldest-deps/__default__/h --fallback_key=main/ubuntu-focal/cmake-oldest-deps/__default__/h
Step #4: 2024-03-05T19:14:00Z (+0s): ====> cache.sh: restore
Step #10: + ctime=2024-03-05T19:11:11.438325Z
Step #10: + query=tags=pr
Step #10: + query+=' AND tags=13701'
Step #10: + query+=' AND substitutions.COMMIT_SHA != 0f072d0535711034660453161ad588c5d51194db'
Step #10: + query+=' AND create_time < 2024-03-05T19:11:11.438325Z'
Step #10: + gcloud builds list --region us-east1 --ongoing '--format=value(id)' --filter 'tags=pr AND tags=13701 AND substitutions.COMMIT_SHA != 0f072d0535711034660453161ad588c5d51194db AND create_time < 2024-03-05T19:11:11.438325Z'
Step #10: + xargs -r -t gcloud builds cancel --region us-east1
Step #9: + ctime=2024-03-05T19:11:11.438325Z
Step #9: + query=tags=pr
Step #9: + query+=' AND tags=13701'
Step #9: + query+=' AND tags=cmake-oldest-deps'
Step #9: + query+=' AND substitutions.COMMIT_SHA != 0f072d0535711034660453161ad588c5d51194db'
Step #9: + query+=' AND create_time > 2024-03-05T19:11:11.438325Z'
Step #9: + gcloud builds list --region us-east1 --limit 1 '--format=value(id)' --filter 'tags=pr AND tags=13701 AND tags=cmake-oldest-deps AND substitutions.COMMIT_SHA != 0f072d0535711034660453161ad588c5d51194db AND create_time > 2024-03-05T19:11:11.438325Z'
Step #9: + grep .
Step #4: gs://cloud-cpp-testing-resources_cloudbuild/build-cache/google-cloud-cpp/13701/ubuntu-focal/cmake-oldest-deps/__default__/h/cache.tar.gz:
Step #4:     Creation time:          Thu, 29 Feb 2024 21:39:56 GMT
Step #4:     Update time:            Thu, 29 Feb 2024 21:39:56 GMT
Step #4:     Storage class:          STANDARD
Step #4:     Content-Length:         8774906
Step #4:     Content-Type:           application/x-tar
Step #4:     Hash (crc32c):          rBWcCA==
Step #4:     Hash (md5):             naRl3yEIaF1g22o1Jd6tYA==
Step #4:     ETag:                   CJyt683B0YQDEAE=
Step #4:     Generation:             1709242796660380
Step #4:     Metageneration:         1
Step #4: 2024-03-05T19:14:02Z (+2s): Fetching cache url gs://cloud-cpp-testing-resources_cloudbuild/build-cache/google-cloud-cpp/13701/ubuntu-focal/cmake-oldest-deps/__default__/h/cache.tar.gz
Step #10: WARNING: The following filter keys were not present in any resource : create_time, substitutions.COMMIT_SHA, tags
Finished Step #8
Step #9: WARNING: The following filter keys were not present in any resource : create_time, substitutions.COMMIT_SHA, tags
Finished Step #10
Finished Step #9
ERROR: step exited with non-zero status: 1
Step #4: Copying gs://cloud-cpp-testing-resources_cloudbuild/build-cache/google-cloud-cpp/13701/ubuntu-focal/cmake-oldest-deps/__default__/h/cache.tar.gz to file:///tmp/tmp.xyMaEGEaxY/cache.tar.gz
Step #4:   
Step #4: .
Step #4: 
Step #4: Average throughput: 87.2MiB/s
Step #4: ==> 🕑 cache.sh completed in 3.861 seconds
Finished Step #4
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:14:11Z" level=info msg="RUN update-alternatives --install /usr/bin/python python $(which python3) 10"
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:14:11Z" level=info msg="Found cached layer, extracting to filesystem"
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:14:11Z" level=info msg="RUN pip3 install setuptools wheel"
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:14:11Z" level=info msg="Found cached layer, extracting to filesystem"
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:14:11Z" level=info msg="RUN apt update && (apt install -y openjdk-11-jre || apt install -y openjdk-9-jre)"
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:14:11Z" level=info msg="Found cached layer, extracting to filesystem"
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:14:34Z" level=info msg="COPY . /var/tmp/ci"
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:14:34Z" level=info msg="Taking snapshot of files..."
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:14:34Z" level=info msg="WORKDIR /var/tmp/downloads"
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:14:34Z" level=info msg="Cmd: workdir"
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:14:34Z" level=info msg="Changed working directory to /var/tmp/downloads"
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:14:34Z" level=info msg="Creating directory /var/tmp/downloads with uid -1 and gid -1"
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:14:34Z" level=info msg="Taking snapshot of files..."
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:14:34Z" level=info msg="RUN /var/tmp/ci/install-cloud-sdk.sh"
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:14:34Z" level=info msg="Found cached layer, extracting to filesystem"
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:16:09Z" level=info msg="ENV CLOUD_SDK_LOCATION=/usr/local/google-cloud-sdk"
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:16:09Z" level=info msg="No files changed in this command, skipping snapshotting."
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:16:09Z" level=info msg="ENV PATH=${CLOUD_SDK_LOCATION}/bin:${PATH}"
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:16:09Z" level=info msg="No files changed in this command, skipping snapshotting."
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:16:09Z" level=info msg="RUN curl -o /usr/bin/bazelisk -sSL \"https://github.com/bazelbuild/bazelisk/releases/download/v1.19.0/bazelisk-linux-${ARCH}\" &&     chmod +x /usr/bin/bazelisk &&     ln -s /usr/bin/bazelisk /usr/bin/bazel"
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:16:09Z" level=info msg="Initializing snapshotter ..."
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:16:09Z" level=info msg="Taking snapshot of full filesystem..."
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:16:19Z" level=info msg="Cmd: /bin/sh"
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:16:19Z" level=info msg="Args: [-c curl -o /usr/bin/bazelisk -sSL \"https://github.com/bazelbuild/bazelisk/releases/download/v1.19.0/bazelisk-linux-${ARCH}\" &&     chmod +x /usr/bin/bazelisk &&     ln -s /usr/bin/bazelisk /usr/bin/bazel]"
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:16:19Z" level=info msg="Running: [/bin/sh -c curl -o /usr/bin/bazelisk -sSL \"https://github.com/bazelbuild/bazelisk/releases/download/v1.19.0/bazelisk-linux-${ARCH}\" &&     chmod +x /usr/bin/bazelisk &&     ln -s /usr/bin/bazelisk /usr/bin/bazel]"
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:16:19Z" level=info msg="Taking snapshot of full filesystem..."
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:16:23Z" level=info msg="Pushing layer gcr.io/cloud-cpp-testing-resources/cloudbuild/ubuntu-focal/cache:de0365a290083b88dac787a62fc4b9b08c08c50f98c672d5395233d1510b050f to cache now"
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:16:23Z" level=info msg="Pushing image to gcr.io/cloud-cpp-testing-resources/cloudbuild/ubuntu-focal/cache:de0365a290083b88dac787a62fc4b9b08c08c50f98c672d5395233d1510b050f"
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:16:24Z" level=info msg="Pushed gcr.io/cloud-cpp-testing-resources/cloudbuild/ubuntu-focal/cache@sha256:dae68f9d8a7d953f1abb17aca86a4e2a957c9468c5524d59a28436fee371f6f7"
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:16:24Z" level=info msg="Pushing image to gcr.io/cloud-cpp-testing-resources/cloudbuild/ubuntu-focal:f365477c-7080-4281-961a-25a5e5af0f9e"
Step #0 - "kaniko-attempt-1": time="2024-03-05T19:16:26Z" level=info msg="Pushed gcr.io/cloud-cpp-testing-resources/cloudbuild/ubuntu-focal@sha256:211e432483e965e87835b6c7b41ce9c3be1be2b69023700372c6d53b33d8e267"
Finished Step #0 - "kaniko-attempt-1"
Starting Step #1 - "download-runner-image-attempt-1"
Starting Step #2 - "kaniko-attempt-2"
Step #1 - "download-runner-image-attempt-1": Pulling image: gcr.io/cloud-cpp-testing-resources/cloudbuild/ubuntu-focal:f365477c-7080-4281-961a-25a5e5af0f9e
Step #2 - "kaniko-attempt-2": Already have image (with digest): gcr.io/kaniko-project/executor:v1.20.1
Step #2 - "kaniko-attempt-2": time="2024-03-05T19:16:29Z" level=info msg="Using dockerignore file: /workspace/ci/.dockerignore"
Step #2 - "kaniko-attempt-2": time="2024-03-05T19:16:29Z" level=info msg="Retrieving image manifest ubuntu:focal"
Step #2 - "kaniko-attempt-2": time="2024-03-05T19:16:29Z" level=info msg="Retrieving image ubuntu:focal from registry index.docker.io"
Step #1 - "download-runner-image-attempt-1": f365477c-7080-4281-961a-25a5e5af0f9e: Pulling from cloud-cpp-testing-resources/cloudbuild/ubuntu-focal
Step #1 - "download-runner-image-attempt-1": 8ee087424735: Pulling fs layer
Step #1 - "download-runner-image-attempt-1": ed0deb05e4f4: Pulling fs layer
Step #1 - "download-runner-image-attempt-1": 418e7c60ef03: Pulling fs layer
Step #1 - "download-runner-image-attempt-1": a1008894fe5a: Pulling fs layer
Step #1 - "download-runner-image-attempt-1": 6de9b7c2acfc: Pulling fs layer
Step #1 - "download-runner-image-attempt-1": 1a88a45a0bd3: Pulling fs layer
Step #1 - "download-runner-image-attempt-1": af340be1e516: Pulling fs layer
Step #1 - "download-runner-image-attempt-1": 5356fdf34fb7: Pulling fs layer
Step #1 - "download-runner-image-attempt-1": c9b53c166492: Pulling fs layer
Step #1 - "download-runner-image-attempt-1": af340be1e516: Waiting
Step #1 - "download-runner-image-attempt-1": a1008894fe5a: Waiting
Step #1 - "download-runner-image-attempt-1": 1a88a45a0bd3: Waiting
Step #1 - "download-runner-image-attempt-1": 6de9b7c2acfc: Waiting
Step #1 - "download-runner-image-attempt-1": 5356fdf34fb7: Waiting
Step #1 - "download-runner-image-attempt-1": c9b53c166492: Waiting
Step #1 - "download-runner-image-attempt-1": 418e7c60ef03: Download complete
Step #1 - "download-runner-image-attempt-1": a1008894fe5a: Verifying Checksum
Step #1 - "download-runner-image-attempt-1": a1008894fe5a: Download complete
Step #2 - "kaniko-attempt-2": time="2024-03-05T19:16:29Z" level=info msg="Retrieving image manifest ubuntu:focal"
Step #2 - "kaniko-attempt-2": time="2024-03-05T19:16:29Z" level=info msg="Returning cached image manifest"
Step #1 - "download-runner-image-attempt-1": 8ee087424735: Verifying Checksum
Step #1 - "download-runner-image-attempt-1": 8ee087424735: Download complete
Step #1 - "download-runner-image-attempt-1": 1a88a45a0bd3: Download complete
Step #2 - "kaniko-attempt-2": time="2024-03-05T19:16:29Z" level=info msg="Built cross stage deps: map[]"
Step #2 - "kaniko-attempt-2": time="2024-03-05T19:16:29Z" level=info msg="Retrieving image manifest ubuntu:focal"
Step #2 - "kaniko-attempt-2": time="2024-03-05T19:16:29Z" level=info msg="Returning cached image manifest"
Step #2 - "kaniko-attempt-2": time="2024-03-05T19:16:29Z" level=info msg="Retrieving image manifest ubuntu:focal"
Step #2 - "kaniko-attempt-2": time="2024-03-05T19:16:29Z" level=info msg="Returning cached image manifest"
Step #2 - "kaniko-attempt-2": time="2024-03-05T19:16:29Z" level=info msg="Executing 0 build triggers"
Step #2 - "kaniko-attempt-2": time="2024-03-05T19:16:29Z" level=info msg="Building stage 'ubuntu:focal' [idx: '0', base-idx: '-1']"
Step #2 - "kaniko-attempt-2": time="2024-03-05T19:16:29Z" level=info msg="Checking for cached layer gcr.io/cloud-cpp-testing-resources/cloudbuild/ubuntu-focal/cache:7756d15d65d2db331a67650c56f8afb9da1d156a2893f1348c9ab41b829f99cf..."
Step #1 - "download-runner-image-attempt-1": af340be1e516: Download complete
Step #2 - "kaniko-attempt-2": time="2024-03-05T19:16:29Z" level=info msg="Using caching version of cmd: RUN apt-get update &&     apt-get --no-install-recommends install -y         automake         build-essential         clang         clang-9         cmake         ctags         curl         gawk         git         gcc         g++         cmake         libcurl4-openssl-dev         libssl-dev         libtool         llvm-9         lsb-release         make         ninja-build         patch         pkg-config         python3         python3-dev         python3-pip         tar         unzip         zip         wget         zlib1g-dev         apt-utils         ca-certificates         apt-transport-https"
Step #2 - "kaniko-attempt-2": time="2024-03-05T19:16:29Z" level=info msg="Checking for cached layer gcr.io/cloud-cpp-testing-resources/cloudbuild/ubuntu-focal/cache:f0e5a3db819946302d490dff91f1f83f48026b1ad5685faa6c7faa140d99d798..."
Step #2 - "kaniko-attempt-2": time="2024-03-05T19:16:29Z" level=info msg="Using caching version of cmd: RUN update-alternatives --install /usr/bin/python python $(which python3) 10"
Step #2 - "kaniko-attempt-2": time="2024-03-05T19:16:29Z" level=info msg="Checking for cached layer gcr.io/cloud-cpp-testing-resources/cloudbuild/ubuntu-focal/cache:53c3d07ef1b43cb4931bab291a79d909e0235029730aa4170eccd18a7ce06d3f..."
Step #2 - "kaniko-attempt-2": time="2024-03-05T19:16:29Z" level=info msg="Using caching version of cmd: RUN pip3 install setuptools wheel"
Step #2 - "kaniko-attempt-2": time="2024-03-05T19:16:29Z" level=info msg="Checking for cached layer gcr.io/cloud-cpp-testing-resources/cloudbuild/ubuntu-focal/cache:da4da71711d909b1a618cc8bffb2e7015fe53abaa5e6b603a43d7bd7049d0192..."
Step #2 - "kaniko-attempt-2": time="2024-03-05T19:16:29Z" level=info msg="Using caching version of cmd: RUN apt update && (apt install -y openjdk-11-jre || apt install -y openjdk-9-jre)"
Step #2 - "kaniko-attempt-2": time="2024-03-05T19:16:29Z" level=info msg="Checking for cached layer gcr.io/cloud-cpp-testing-resources/cloudbuild/ubuntu-focal/cache:00e8b1a896a74f5163d96b79a9ede40f3dc1a13e0b5ed99e8f3b43154126b33d..."
Step #2 - "kaniko-attempt-2": time="2024-03-05T19:16:30Z" level=info msg="Using caching version of cmd: RUN /var/tmp/ci/install-cloud-sdk.sh"
Step #2 - "kaniko-attempt-2": time="2024-03-05T19:16:30Z" level=info msg="Checking for cached layer gcr.io/cloud-cpp-testing-resources/cloudbuild/ubuntu-focal/cache:de0365a290083b88dac787a62fc4b9b08c08c50f98c672d5395233d1510b050f..."
Step #1 - "download-runner-image-attempt-1": 8ee087424735: Pull complete
Step #2 - "kaniko-attempt-2": time="2024-03-05T19:16:30Z" level=info msg="Using caching version of cmd: RUN curl -o /usr/bin/bazelisk -sSL \"https://github.com/bazelbuild/bazelisk/releases/download/v1.19.0/bazelisk-linux-${ARCH}\" &&     chmod +x /usr/bin/bazelisk &&     ln -s /usr/bin/bazelisk /usr/bin/bazel"
Step #2 - "kaniko-attempt-2": time="2024-03-05T19:16:30Z" level=info msg="Unpacking rootfs as cmd COPY . /var/
...
[Logs truncated due to log size limitations. For full logs, see https://storage.cloud.google.com/cloud-cpp-community-publiclogs/logs/google-cloud-cpp/13701/0f072d0535711034660453161ad588c5d51194db/ubuntu-focal-cmake-oldest-deps-__default__/log-f365477c-7080-4281-961a-25a5e5af0f9e.txt.]
...
...............   Passed    0.04 sec
Step #5:         Start 524: bigtable_internal_data_tracing_connection_test
Step #5: 395/548 Test #517: bigtable_internal_async_streaming_read_test ...............................   Passed    0.02 sec
Step #5:         Start 525: bigtable_internal_default_row_reader_test
Step #5: 396/548 Test #494: bigtable_async_read_stream_test ...........................................   Passed    0.09 sec
Step #5:         Start 526: bigtable_internal_defaults_test
Step #5: 397/548 Test #518: bigtable_internal_bigtable_channel_refresh_test ...........................   Passed    0.02 sec
Step #5:         Start 527: bigtable_internal_google_bytes_traits_test
Step #5: 398/548 Test #522: bigtable_internal_convert_policies_test ...................................   Passed    0.01 sec
Step #5:         Start 528: bigtable_internal_legacy_async_bulk_apply_test
Step #5: 399/548 Test #497: bigtable_client_options_test ..............................................   Passed    0.09 sec
Step #5:         Start 529: bigtable_internal_legacy_async_row_reader_test
Step #5: 400/548 Test #527: bigtable_internal_google_bytes_traits_test ................................   Passed    0.00 sec
Step #5:         Start 530: bigtable_internal_legacy_async_row_sampler_test
Step #5: 401/548 Test #524: bigtable_internal_data_tracing_connection_test ............................   Passed    0.02 sec
Step #5:         Start 531: bigtable_internal_legacy_bulk_mutator_test
Step #5: 402/548 Test #519: bigtable_internal_bigtable_stub_factory_test ..............................   Passed    0.04 sec
Step #5:         Start 532: bigtable_internal_legacy_row_reader_test
Step #5: 403/548 Test #521: bigtable_internal_connection_refresh_state_test ...........................   Passed    0.04 sec
Step #5:         Start 533: bigtable_internal_logging_data_client_test
Step #5: 404/548 Test #520: bigtable_internal_bulk_mutator_test .......................................   Passed    0.04 sec
Step #5:         Start 534: bigtable_internal_mutate_rows_limiter_test
Step #5: 405/548 Test #516: bigtable_internal_async_row_sampler_test ..................................   Passed    0.06 sec
Step #5:         Start 535: bigtable_internal_prefix_range_end_test
Step #5: 406/548 Test #514: bigtable_internal_async_bulk_apply_test ...................................   Passed    0.07 sec
Step #5:         Start 536: bigtable_internal_rate_limiter_test
Step #5: 407/548 Test #530: bigtable_internal_legacy_async_row_sampler_test ...........................   Passed    0.03 sec
Step #5:         Start 537: bigtable_internal_retry_context_test
Step #5: 408/548 Test #533: bigtable_internal_logging_data_client_test ................................   Passed    0.02 sec
Step #5:         Start 538: bigtable_internal_retry_info_helper_test
Step #5: 409/548 Test #535: bigtable_internal_prefix_range_end_test ...................................   Passed    0.01 sec
Step #5:         Start 539: bigtable_internal_retry_traits_test
Step #5: 410/548 Test #528: bigtable_internal_legacy_async_bulk_apply_test ............................   Passed    0.04 sec
Step #5:         Start 540: bigtable_internal_traced_row_reader_test
Step #5: 411/548 Test #536: bigtable_internal_rate_limiter_test .......................................   Passed    0.01 sec
Step #5:         Start 541: bigtable_legacy_table_test
Step #5: 412/548 Test #538: bigtable_internal_retry_info_helper_test ..................................   Passed    0.01 sec
Step #5:         Start 542: bigtable_metadata_update_policy_test
Step #5: 413/548 Test #531: bigtable_internal_legacy_bulk_mutator_test ................................   Passed    0.04 sec
Step #5:         Start 543: bigtable_mocks_mock_row_reader_test
Step #5: 414/548 Test #537: bigtable_internal_retry_context_test ......................................   Passed    0.02 sec
Step #5:         Start 544: bigtable_mutation_batcher_test
Step #5: 415/548 Test #539: bigtable_internal_retry_traits_test .......................................   Passed    0.01 sec
Step #5:         Start 545: bigtable_mutations_test
Step #5: 416/548 Test #540: bigtable_internal_traced_row_reader_test ..................................   Passed    0.01 sec
Step #5:         Start 546: bigtable_polling_policy_test
Step #5: 417/548 Test #515: bigtable_internal_async_row_reader_test ...................................   Passed    0.10 sec
Step #5:         Start 547: bigtable_read_modify_write_rule_test
Step #5: 418/548 Test #543: bigtable_mocks_mock_row_reader_test .......................................   Passed    0.01 sec
Step #5:         Start 548: bigtable_row_range_test
Step #5: 419/548 Test #526: bigtable_internal_defaults_test ...........................................   Passed    0.08 sec
Step #5:         Start 549: bigtable_row_reader_test
Step #5: 420/548 Test #545: bigtable_mutations_test ...................................................   Passed    0.01 sec
Step #5:         Start 550: bigtable_row_set_test
Step #5: 421/548 Test #465: pubsub_subscription_admin_connection_test .................................   Passed    0.21 sec
Step #5:         Start 551: bigtable_row_test
Step #5: 422/548 Test #469: pubsub_topic_admin_connection_test ........................................   Passed    0.19 sec
Step #5:         Start 552: bigtable_rpc_backoff_policy_test
Step #5: 423/548 Test #525: bigtable_internal_default_row_reader_test .................................   Passed    0.09 sec
Step #5:         Start 553: bigtable_rpc_retry_policy_test
Step #5: 424/548 Test #547: bigtable_read_modify_write_rule_test ......................................   Passed    0.02 sec
Step #5:         Start 554: bigtable_table_admin_test
Step #5: 425/548 Test #548: bigtable_row_range_test ...................................................   Passed    0.01 sec
Step #5:         Start 555: bigtable_table_apply_test
Step #5: 426/548 Test #549: bigtable_row_reader_test ..................................................   Passed    0.01 sec
Step #5:         Start 556: bigtable_table_bulk_apply_test
Step #5: 427/548 Test #550: bigtable_row_set_test .....................................................   Passed    0.01 sec
Step #5:         Start 557: bigtable_table_check_and_mutate_row_test
Step #5: 428/548 Test #551: bigtable_row_test .........................................................   Passed    0.01 sec
Step #5:         Start 558: bigtable_table_config_test
Step #5: 429/548 Test #428: pubsub_internal_flow_controlled_publisher_connection_test .................   Passed    0.34 sec
Step #5:         Start 559: bigtable_table_readmodifywriterow_test
Step #5: 430/548 Test #542: bigtable_metadata_update_policy_test ......................................   Passed    0.05 sec
Step #5:         Start 560: bigtable_table_readrow_test
Step #5: 431/548 Test #544: bigtable_mutation_batcher_test ............................................   Passed    0.05 sec
Step #5:         Start 561: bigtable_table_readrows_test
Step #5: 432/548 Test #552: bigtable_rpc_backoff_policy_test ..........................................   Passed    0.03 sec
Step #5:         Start 562: bigtable_table_resource_test
Step #5: 433/548 Test #558: bigtable_table_config_test ................................................   Passed    0.01 sec
Step #5:         Start 563: bigtable_table_sample_row_keys_test
Step #5: 434/548 Test #562: bigtable_table_resource_test ..............................................   Passed    0.01 sec
Step #5:         Start 564: bigtable_table_test
Step #5: 435/548 Test #541: bigtable_legacy_table_test ................................................   Passed    0.08 sec
Step #5:         Start 565: bigtable_testing_cleanup_stale_resources_test
Step #5: 436/548 Test #560: bigtable_table_readrow_test ...............................................   Passed    0.02 sec
Step #5:         Start 566: bigtable_testing_random_names_test
Step #5: 437/548 Test #532: bigtable_internal_legacy_row_reader_test ..................................   Passed    0.11 sec
Step #5:         Start 567: bigtable_wait_for_consistency_test
Step #5: 438/548 Test #559: bigtable_table_readmodifywriterow_test ....................................   Passed    0.03 sec
Step #5:         Start 568: bigtable_internal_readrowsparser_test
Step #5: 439/548 Test #564: bigtable_table_test .......................................................   Passed    0.02 sec
Step #5:         Start 571: bigtable_benchmark_options_test
Step #5: 440/548 Test #565: bigtable_testing_cleanup_stale_resources_test .............................   Passed    0.01 sec
Step #5:         Start 572: bigtable_bigtable_benchmark_test
Step #5: 441/548 Test #566: bigtable_testing_random_names_test ........................................   Passed    0.01 sec
Step #5:         Start 573: bigtable_embedded_server_test
Step #5: 442/548 Test #571: bigtable_benchmark_options_test ...........................................   Passed    0.01 sec
Step #5:         Start 574: bigtable_format_duration_test
Step #5: 443/548 Test #568: bigtable_internal_readrowsparser_test .....................................   Passed    0.01 sec
Step #5:         Start 575: bigtable_mutation_batcher_throughput_options_test
Step #5: 444/548 Test #574: bigtable_format_duration_test .............................................   Passed    0.01 sec
Step #5:         Start 576: bigtable_random_mutation_test
Step #5: 445/548 Test #575: bigtable_mutation_batcher_throughput_options_test .........................   Passed    0.01 sec
Step #5:         Start 596: opentelemetry_internal_monitored_resource_test
Step #5: 446/548 Test #529: bigtable_internal_legacy_async_row_reader_test ............................   Passed    0.15 sec
Step #5:         Start 597: opentelemetry_internal_recordable_test
Step #5: 447/548 Test #576: bigtable_random_mutation_test .............................................   Passed    0.01 sec
Step #5:         Start 598: opentelemetry_internal_resource_detector_impl_test
Step #5: 448/548 Test #596: opentelemetry_internal_monitored_resource_test ............................   Passed    0.01 sec
Step #5:         Start 599: opentelemetry_trace_exporter_test
Step #5: 449/548 Test #554: bigtable_table_admin_test .................................................   Passed    0.08 sec
Step #5:         Start 603: pubsublite_endpoint_test
Step #5: 450/548 Test #567: bigtable_wait_for_consistency_test ........................................   Passed    0.04 sec
Step #5:         Start 604: pubsublite_internal_alarm_registry_impl_test
Step #5: 451/548 Test #599: opentelemetry_trace_exporter_test .........................................   Passed    0.01 sec
Step #5:         Start 605: pubsublite_internal_default_publish_message_transformer_test
Step #5: 452/548 Test #603: pubsublite_endpoint_test ..................................................   Passed    0.01 sec
Step #5:         Start 606: pubsublite_internal_default_routing_policy_test
Step #5: 453/548 Test #597: opentelemetry_internal_recordable_test ....................................   Passed    0.02 sec
Step #5:         Start 607: pubsublite_internal_location_test
Step #5: 454/548 Test #598: opentelemetry_internal_resource_detector_impl_test ........................   Passed    0.02 sec
Step #5:         Start 608: pubsublite_internal_multipartition_publisher_test
Step #5: 455/548 Test #605: pubsublite_internal_default_publish_message_transformer_test ..............   Passed    0.01 sec
Step #5:         Start 609: pubsublite_internal_partition_publisher_test
Step #5: 456/548 Test #606: pubsublite_internal_default_routing_policy_test ...........................   Passed    0.01 sec
Step #5:         Start 610: pubsublite_internal_publisher_connection_impl_test
Step #5: 457/548 Test #607: pubsublite_internal_location_test .........................................   Passed    0.01 sec
Step #5:         Start 611: pubsublite_internal_resumable_async_streaming_read_write_rpc_test
Step #5: 458/548 Test #610: pubsublite_internal_publisher_connection_impl_test ........................   Passed    0.01 sec
Step #5:         Start 612: pubsublite_internal_service_composite_test
Step #5: 459/548 Test #523: bigtable_internal_data_connection_impl_test ...............................   Passed    0.21 sec
Step #5:         Start 613: pubsublite_internal_stream_factory_test
Step #5: 460/548 Test #563: bigtable_table_sample_row_keys_test .......................................   Passed    0.09 sec
Step #5:         Start 614: pubsublite_internal_stream_retry_policy_test
Step #5: 461/548 Test #612: pubsublite_internal_service_composite_test ................................   Passed    0.01 sec
Step #5:         Start 615: pubsublite_message_metadata_test
Step #5: 462/548 Test #609: pubsublite_internal_partition_publisher_test ..............................   Passed    0.02 sec
Step #5:         Start 616: pubsublite_topic_test
Step #5: 463/548 Test #557: bigtable_table_check_and_mutate_row_test ..................................   Passed    0.12 sec
Step #5:         Start 618: spanner_backup_test
Step #5: 464/548 Test #613: pubsublite_internal_stream_factory_test ...................................   Passed    0.01 sec
Step #5:         Start 619: spanner_bytes_test
Step #5: 465/548 Test #614: pubsublite_internal_stream_retry_policy_test ..............................   Passed    0.01 sec
Step #5:         Start 620: spanner_client_options_test
Step #5: 466/548 Test #615: pubsublite_message_metadata_test ..........................................   Passed    0.01 sec
Step #5:         Start 621: spanner_client_test
Step #5: 467/548 Test #561: bigtable_table_readrows_test ..............................................   Passed    0.12 sec
Step #5:         Start 622: spanner_commit_options_test
Step #5: 468/548 Test #454: pubsub_publisher_connection_test ..........................................   Passed    0.39 sec
Step #5:         Start 623: spanner_connection_options_test
Step #5: 469/548 Test #616: pubsublite_topic_test .....................................................   Passed    0.01 sec
Step #5:         Start 624: spanner_create_instance_request_builder_test
Step #5: 470/548 Test #618: spanner_backup_test .......................................................   Passed    0.01 sec
Step #5:         Start 625: spanner_database_admin_client_test
Step #5: 471/548 Test #620: spanner_client_options_test ...............................................   Passed    0.00 sec
Step #5:         Start 626: spanner_database_admin_connection_test
Step #5: 472/548 Test #622: spanner_commit_options_test ...............................................   Passed    0.02 sec
Step #5:         Start 627: spanner_database_test
Step #5: 473/548 Test #623: spanner_connection_options_test ...........................................   Passed    0.02 sec
Step #5:         Start 628: spanner_instance_admin_client_test
Step #5: 474/548 Test #624: spanner_create_instance_request_builder_test ..............................   Passed    0.01 sec
Step #5:         Start 629: spanner_instance_admin_connection_test
Step #5: 475/548 Test #625: spanner_database_admin_client_test ........................................   Passed    0.02 sec
Step #5:         Start 630: spanner_instance_test
Step #5: 476/548 Test #627: spanner_database_test .....................................................   Passed    0.01 sec
Step #5:         Start 631: spanner_internal_connection_impl_test
Step #5: 477/548 Test #628: spanner_instance_admin_client_test ........................................   Passed    0.01 sec
Step #5:         Start 632: spanner_internal_database_admin_logging_test
Step #5: 478/548 Test #630: spanner_instance_test .....................................................   Passed    0.01 sec
Step #5:         Start 633: spanner_internal_database_admin_metadata_test
Step #5: 479/548 Test #632: spanner_internal_database_admin_logging_test ..............................   Passed    0.04 sec
Step #5:         Start 634: spanner_internal_defaults_test
Step #5: 480/548 Test #546: bigtable_polling_policy_test ..............................................   Passed    0.25 sec
Step #5:         Start 635: spanner_internal_instance_admin_logging_test
Step #5: 481/548 Test #634: spanner_internal_defaults_test ............................................   Passed    0.02 sec
Step #5:         Start 636: spanner_internal_instance_admin_metadata_test
Step #5: 482/548 Test #635: spanner_internal_instance_admin_logging_test ..............................   Passed    0.02 sec
Step #5:         Start 637: spanner_internal_logging_result_set_reader_test
Step #5: 483/548 Test #629: spanner_instance_admin_connection_test ....................................   Passed    0.10 sec
Step #5:         Start 638: spanner_internal_merge_chunk_test
Step #5: 484/548 Test #637: spanner_internal_logging_result_set_reader_test ...........................   Passed    0.01 sec
Step #5:         Start 639: spanner_internal_partial_result_set_resume_test
Step #5: 485/548 Test #638: spanner_internal_merge_chunk_test .........................................   Passed    0.01 sec
Step #5:         Start 640: spanner_internal_partial_result_set_source_test
Step #5: 486/548 Test #639: spanner_internal_partial_result_set_resume_test ...........................   Passed    0.02 sec
Step #5:         Start 641: spanner_internal_route_to_leader_test
Step #5: 487/548 Test #556: bigtable_table_bulk_apply_test ............................................   Passed    0.28 sec
Step #5:         Start 642: spanner_internal_session_pool_test
Step #5: 488/548 Test #633: spanner_internal_database_admin_metadata_test .............................   Passed    0.11 sec
Step #5:         Start 643: spanner_internal_spanner_stub_factory_test
Step #5: 489/548 Test #640: spanner_internal_partial_result_set_source_test ...........................   Passed    0.02 sec
Step #5:         Start 644: spanner_internal_status_utils_test
Step #5: 490/548 Test #641: spanner_internal_route_to_leader_test .....................................   Passed    0.01 sec
Step #5:         Start 645: spanner_internal_transaction_impl_test
Step #5: 491/548 Test #636: spanner_internal_instance_admin_metadata_test .............................   Passed    0.07 sec
Step #5:         Start 646: spanner_internal_tuple_utils_test
Step #5: 492/548 Test #573: bigtable_embedded_server_test .............................................   Passed    0.25 sec
Step #5:         Start 647: spanner_json_test
Step #5: 493/548 Test #644: spanner_internal_status_utils_test ........................................   Passed    0.01 sec
Step #5:         Start 648: spanner_keys_test
Step #5: 494/548 Test #646: spanner_internal_tuple_utils_test .........................................   Passed    0.01 sec
Step #5:         Start 649: spanner_mutations_test
Step #5: 495/548 Test #647: spanner_json_test .........................................................   Passed    0.01 sec
Step #5:         Start 650: spanner_numeric_test
Step #5: 496/548 Test #648: spanner_keys_test .........................................................   Passed    0.01 sec
Step #5:         Start 651: spanner_partition_options_test
Step #5: 497/548 Test #643: spanner_internal_spanner_stub_factory_test ................................   Passed    0.03 sec
Step #5:         Start 652: spanner_query_options_test
Step #5: 498/548 Test #649: spanner_mutations_test ....................................................   Passed    0.02 sec
Step #5:         Start 653: spanner_query_partition_test
Step #5: 499/548 Test #650: spanner_numeric_test ......................................................   Passed    0.01 sec
Step #5:         Start 654: spanner_read_options_test
Step #5: 500/548 Test #651: spanner_partition_options_test ............................................   Passed    0.01 sec
Step #5:         Start 655: spanner_read_partition_test
Step #5: 501/548 Test #652: spanner_query_options_test ................................................   Passed    0.01 sec
Step #5:         Start 656: spanner_results_test
Step #5: 502/548 Test #626: spanner_database_admin_connection_test ....................................   Passed    0.19 sec
Step #5:         Start 657: spanner_retry_policy_test
Step #5: 503/548 Test #654: spanner_read_options_test .................................................   Passed    0.01 sec
Step #5:         Start 658: spanner_row_test
Step #5: 504/548 Test #653: spanner_query_partition_test ..............................................   Passed    0.02 sec
Step #5:         Start 659: spanner_session_pool_options_test
Step #5: 505/548 Test #655: spanner_read_partition_test ...............................................   Passed    0.01 sec
Step #5:         Start 660: spanner_spanner_version_test
Step #5: 506/548 Test #657: spanner_retry_policy_test .................................................   Passed    0.01 sec
Step #5:         Start 661: spanner_sql_statement_test
Step #5: 507/548 Test #656: spanner_results_test ......................................................   Passed    0.02 sec
Step #5:         Start 662: spanner_testing_cleanup_stale_databases_test
Step #5: 508/548 Test #659: spanner_session_pool_options_test .........................................   Passed    0.01 sec
Step #5:         Start 663: spanner_testing_random_database_name_test
Step #5: 509/548 Test #660: spanner_spanner_version_test ..............................................   Passed    0.00 sec
Step #5:         Start 664: spanner_timestamp_test
Step #5: 510/548 Test #658: spanner_row_test ..........................................................   Passed    0.02 sec
Step #5:         Start 665: spanner_transaction_test
Step #5: 511/548 Test #663: spanner_testing_random_database_name_test .................................   Passed    0.01 sec
Step #5:         Start 666: spanner_update_instance_request_builder_test
Step #5: 512/548 Test #661: spanner_sql_statement_test ................................................   Passed    0.02 sec
Step #5:         Start 667: spanner_value_test
Step #5: 513/548 Test #664: spanner_timestamp_test ....................................................   Passed    0.01 sec
Step #5:         Start 668: spanner_bytes_benchmark
Step #5: 514/548 Test #642: spanner_internal_session_pool_test ........................................   Passed    0.09 sec
Step #5:         Start 669: spanner_internal_merge_chunk_benchmark
Step #5: 515/548 Test #665: spanner_transaction_test ..................................................   Passed    0.01 sec
Step #5:         Start 670: spanner_numeric_benchmark
Step #5: 516/548 Test #666: spanner_update_instance_request_builder_test ..............................   Passed    0.02 sec
Step #5:         Start 671: spanner_row_benchmark
Step #5: 517/548 Test #662: spanner_testing_cleanup_stale_databases_test ..............................   Passed    0.03 sec
Step #5: 518/548 Test #667: spanner_value_test ........................................................   Passed    0.07 sec
Step #5: 519/548 Test #534: bigtable_internal_mutate_rows_limiter_test ................................   Passed    0.52 sec
Step #5: 520/548 Test #553: bigtable_rpc_retry_policy_test ............................................   Passed    0.49 sec
Step #5: 521/548 Test #447: pubsub_internal_subscription_session_test .................................   Passed    0.78 sec
Step #5: 522/548 Test #645: spanner_internal_transaction_impl_test ....................................   Passed    0.24 sec
Step #5: 523/548 Test #555: bigtable_table_apply_test .................................................   Passed    0.56 sec
Step #5: 524/548 Test #194: storage_client_bucket_test ................................................   Passed    1.37 sec
Step #5: 525/548 Test #298: storage_internal_async_insert_object_test .................................   Passed    1.14 sec
Step #5: 526/548 Test #611: pubsublite_internal_resumable_async_streaming_read_write_rpc_test .........   Passed    0.58 sec
Step #5: 527/548 Test #572: bigtable_bigtable_benchmark_test ..........................................   Passed    0.65 sec
Step #5: 528/548 Test #619: spanner_bytes_test ........................................................   Passed    0.68 sec
Step #5: 529/548 Test #621: spanner_client_test .......................................................   Passed    0.75 sec
Step #5: 530/548 Test  #73: common_internal_async_connection_ready_test ...............................   Passed    2.02 sec
Step #5: 531/548 Test #631: spanner_internal_connection_impl_test .....................................   Passed    0.82 sec
Step #5: 532/548 Test #299: storage_internal_async_partial_upload_test ................................   Passed    2.07 sec
Step #5: 533/548 Test #668: spanner_bytes_benchmark ...................................................   Passed    1.53 sec
Step #5: 534/548 Test #604: pubsublite_internal_alarm_registry_impl_test ..............................   Passed    2.01 sec
Step #5: 535/548 Test #608: pubsublite_internal_multipartition_publisher_test .........................   Passed    2.02 sec
Step #5: 536/548 Test #446: pubsub_internal_subscription_message_queue_test ...........................   Passed    2.39 sec
Step #5: 537/548 Test #671: spanner_row_benchmark .....................................................   Passed    1.74 sec
Step #5: 538/548 Test #204: storage_client_test .......................................................   Passed    3.10 sec
Step #5: 539/548 Test #287: storage_internal_crc32c_benchmark .........................................   Passed    3.24 sec
Step #5: 540/548 Test #328: storage_internal_grpc_split_write_object_data_test ........................   Passed    3.75 sec
Step #5: 541/548 Test #318: storage_internal_grpc_make_cord_test ......................................   Passed    3.85 sec
Step #5: 542/548 Test #669: spanner_internal_merge_chunk_benchmark ....................................   Passed    3.77 sec
Step #5: 543/548 Test  #67: common_options_benchmark ..................................................   Passed    6.14 sec
Step #5: 544/548 Test #141: common_internal_oauth2_compute_engine_credentials_test ....................   Passed    6.39 sec
Step #5: 545/548 Test  #69: common_completion_queue_test ..............................................   Passed    7.71 sec
Step #5: 546/548 Test #670: spanner_numeric_benchmark .................................................   Passed    8.81 sec
Step #5: 547/548 Test #117: common_completion_queue_benchmark .........................................   Passed   11.47 sec
Step #5: 548/548 Test #167: common_internal_curl_handle_factory_benchmark .............................   Passed   18.76 sec
Step #5: 
Step #5: 100% tests passed, 0 tests failed out of 548
Step #5: 
Step #5: Total Test time (real) =  19.13 sec
Step #5: 
Step #5: 2024-03-05T19:29:26Z (+599s)
Step #5: ---------------------------------------------------------
Step #5: |   Running Pub/Sub integration tests (with emulator)   |
Step #5: ---------------------------------------------------------
Step #5: 
Step #5: 2024-03-05T19:29:26Z (+599s)
Step #5: ---------------------------------------------------------
Step #5: |   Running Storage integration tests (with emulator)   |
Step #5: ---------------------------------------------------------
Step #5: 
Step #5: 2024-03-05T19:29:26Z (+599s)
Step #5: ---------------------------------------------------------
Step #5: |   Running Spanner integration tests (with emulator)   |
Step #5: ---------------------------------------------------------
Step #5: 
Step #5: 2024-03-05T19:29:26Z (+599s)
Step #5: ----------------------------------------------------------
Step #5: |   Running Bigtable integration tests (with emulator)   |
Step #5: ----------------------------------------------------------
Step #5: 
Step #5: 2024-03-05T19:29:26Z (+599s)
Step #5: ------------------------------------------------------
Step #5: |   Running REST integration tests (with emulator)   |
Step #5: ------------------------------------------------------
Step #5: ==> 🕑 cmake-oldest-deps completed in 599.560 seconds
Finished Step #5
Starting Step #6
Step #6: Already have image (with digest): gcr.io/google.com/cloudsdktool/cloud-sdk
Step #6: 2024-03-05T19:29:31Z (+0s): Running:
Step #6: env -C '/h' /workspace/ci/cloudbuild/cache.sh save --bucket_url=gs://cloud-cpp-testing-resources_cloudbuild/build-cache/google-cloud-cpp --key=13701/ubuntu-focal/cmake-oldest-deps/__default__/h --path=.cache/bazelisk --path=.cache/ctcache --path=.cache/vcpkg --path=.cache/google-cloud-cpp --path=.local
Step #6: 2024-03-05T19:29:31Z (+0s): ====> cache.sh: save
Step #6: 2024-03-05T19:29:31Z (+0s): Saving ( .local ) to gs://cloud-cpp-testing-resources_cloudbuild/build-cache/google-cloud-cpp/13701/ubuntu-focal/cmake-oldest-deps/__default__/h/cache.tar.gz
Step #6: 27M	.local
Step #6: Copying file:///tmp/tmp.A3WhR0BJLl/cache.tar.gz to gs://cloud-cpp-testing-resources_cloudbuild/build-cache/google-cloud-cpp/13701/ubuntu-focal/cmake-oldest-deps/__default__/h/cache.tar.gz
Step #6:   
Step #6: ..
Step #6: gs://cloud-cpp-testing-resources_cloudbuild/build-cache/google-cloud-cpp/13701/ubuntu-focal/cmake-oldest-deps/__default__/h/cache.tar.gz:
Step #6:     Creation time:          Tue, 05 Mar 2024 19:29:34 GMT
Step #6:     Update time:            Tue, 05 Mar 2024 19:29:34 GMT
Step #6:     Storage class:          STANDARD
Step #6:     Content-Length:         8774881
Step #6:     Content-Type:           application/x-tar
Step #6:     Hash (crc32c):          e71+iw==
Step #6:     Hash (md5):             yaBlNJ5RqvlRyiyPfJER0Q==
Step #6:     ETag:                   CK7as+Xt3YQDEAE=
Step #6:     Generation:             1709666974100782
Step #6:     Metageneration:         1
Step #6: ==> 🕑 cache.sh completed in 5.003 seconds
Finished Step #6
Starting Step #7
Step #7: Already have image (with digest): gcr.io/google.com/cloudsdktool/cloud-sdk
Step #7: WARNING: Successfully resolved tag to sha256, but it is recommended to use sha256 directly.
Step #7: Digests:
Step #7: - gcr.io/cloud-cpp-testing-resources/cloudbuild/ubuntu-focal@sha256:4c10a711d582dff490344f5d3384150e43102fea5556be49bd5ae5001b78b79b
Step #7:   Associated tags:
Step #7:  - f365477c-7080-4281-961a-25a5e5af0f9e
Step #7: Tags:
Step #7: - gcr.io/cloud-cpp-testing-resources/cloudbuild/ubuntu-focal:f365477c-7080-4281-961a-25a5e5af0f9e
Step #7: Deleted [gcr.io/cloud-cpp-testing-resources/cloudbuild/ubuntu-focal:f365477c-7080-4281-961a-25a5e5af0f9e].
Step #7: Deleted [gcr.io/cloud-cpp-testing-resources/cloudbuild/ubuntu-focal@sha256:4c10a711d582dff490344f5d3384150e43102fea5556be49bd5ae5001b78b79b].
Finished Step #7
PUSH
DONE