starting build "565c6caf-f20d-423c-9f35-f6a916310918"

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/google/certificate-transparency-go
 * branch            c2681021d4021d95181d80587086aed857a1176b -> FETCH_HEAD
HEAD is now at c268102 Merge branch 'master' into master
BUILD
Starting Step #0
Step #0: Already have image (with digest): gcr.io/cloud-builders/docker
Step #0: latest: Pulling from trillian-opensource-ci/ct_testbase
Step #0: fdf894e782a2: Already exists
Step #0: 5bd71677db44: Already exists
Step #0: 551df7f94f9c: Already exists
Step #0: 12b0926ac042: Already exists
Step #0: 06f05ace1117: Already exists
Step #0: f931ef26d283: Already exists
Step #0: 4f4fb700ef54: Already exists
Step #0: 99ed65b40a0a: Pulling fs layer
Step #0: adae0732152e: Pulling fs layer
Step #0: 006185240bf7: Pulling fs layer
Step #0: 87b7ef2db5d1: Pulling fs layer
Step #0: e05d8c9e72c2: Pulling fs layer
Step #0: a0d80690c2c2: Pulling fs layer
Step #0: 87b7ef2db5d1: Waiting
Step #0: a0d80690c2c2: Waiting
Step #0: e05d8c9e72c2: Waiting
Step #0: 99ed65b40a0a: Verifying Checksum
Step #0: 99ed65b40a0a: Download complete
Step #0: 99ed65b40a0a: Pull complete
Step #0: 006185240bf7: Verifying Checksum
Step #0: 006185240bf7: Download complete
Step #0: e05d8c9e72c2: Verifying Checksum
Step #0: e05d8c9e72c2: Download complete
Step #0: 87b7ef2db5d1: Verifying Checksum
Step #0: a0d80690c2c2: Verifying Checksum
Step #0: a0d80690c2c2: Download complete
Step #0: adae0732152e: Verifying Checksum
Step #0: adae0732152e: Download complete
Step #0: adae0732152e: Pull complete
Step #0: 006185240bf7: Pull complete
Step #0: 87b7ef2db5d1: Pull complete
Step #0: e05d8c9e72c2: Pull complete
Step #0: a0d80690c2c2: Pull complete
Step #0: Digest: sha256:36888bb8b66799716f881c62a0482ce7ae445197bf2fe56b3531ac06253ea243
Step #0: Status: Downloaded newer image for gcr.io/trillian-opensource-ci/ct_testbase:latest
Step #0: gcr.io/trillian-opensource-ci/ct_testbase:latest
Finished Step #0
Starting Step #1
Step #1: Already have image (with digest): gcr.io/cloud-builders/docker
Step #1: Sending build context to Docker daemon  5.599MB

Step #1: Step 1/13 : FROM golang:1.23.4-bookworm@sha256:ef30001eeadd12890c7737c26f3be5b3a8479ccdcdc553b999c84879875a27ce as ct_testbase
Step #1: docker.io/library/golang:1.23.4-bookworm@sha256:ef30001eeadd12890c7737c26f3be5b3a8479ccdcdc553b999c84879875a27ce: Pulling from library/golang
Step #1: Digest: sha256:ef30001eeadd12890c7737c26f3be5b3a8479ccdcdc553b999c84879875a27ce
Step #1: Status: Downloaded newer image for golang:1.23.4-bookworm@sha256:ef30001eeadd12890c7737c26f3be5b3a8479ccdcdc553b999c84879875a27ce
Step #1:  ---> 1983e5a25166
Step #1: Step 2/13 : WORKDIR /testbase
Step #1:  ---> Using cache
Step #1:  ---> eeb43fb1e7c5
Step #1: Step 3/13 : ARG GOFLAGS=""
Step #1:  ---> Using cache
Step #1:  ---> 673dbf1cc37f
Step #1: Step 4/13 : ENV GOFLAGS=$GOFLAGS
Step #1:  ---> Using cache
Step #1:  ---> ab0e079e860f
Step #1: Step 5/13 : RUN apt-get update && apt-get -y install build-essential curl docker-compose lsof mariadb-client netcat-openbsd postgresql-client unzip wget xxd
Step #1:  ---> Using cache
Step #1:  ---> 4e0d5653f9a2
Step #1: Step 6/13 : RUN cd /usr/bin && curl -L -O https://github.com/jqlang/jq/releases/download/jq-1.7/jq-linux64 && mv jq-linux64 /usr/bin/jq && chmod +x /usr/bin/jq
Step #1:  ---> Using cache
Step #1:  ---> 5017f02a6155
Step #1: Step 7/13 : RUN curl -sSfL https://raw.githubusercontent.com/golangci/golangci-lint/master/install.sh | sh -s -- -b $(go env GOPATH)/bin v1.55.1
Step #1:  ---> Using cache
Step #1:  ---> 830088d98c64
Step #1: Step 8/13 : RUN mkdir protoc &&     (cd protoc &&     PROTOC_VERSION=3.20.1 &&     PROTOC_ZIP="protoc-${PROTOC_VERSION}-linux-x86_64.zip" &&     wget "https://github.com/google/protobuf/releases/download/v${PROTOC_VERSION}/${PROTOC_ZIP}" &&     unzip -o ${PROTOC_ZIP} -d /usr/local bin/protoc &&     unzip -o ${PROTOC_ZIP} -d /usr/local 'include/*'     )
Step #1:  ---> Using cache
Step #1:  ---> d0cf61a08ee7
Step #1: Step 9/13 : ENV PATH /usr/local/bin:$PATH
Step #1:  ---> Using cache
Step #1:  ---> 6f4bfa39cc32
Step #1: Step 10/13 : COPY ./integration/test-runner.sh /testbase/
Step #1:  ---> Using cache
Step #1:  ---> f4d13726cdeb
Step #1: Step 11/13 : ENV GOPATH /go
Step #1:  ---> Using cache
Step #1:  ---> 3cb6dc1fceff
Step #1: Step 12/13 : ENV PATH $GOPATH/bin:/testbase/protoc/bin:$PATH
Step #1:  ---> Using cache
Step #1:  ---> 7faa23643208
Step #1: Step 13/13 : CMD /bin/bash -exc /testbase/test-runner.sh
Step #1:  ---> Using cache
Step #1:  ---> 47d2524123ec
Step #1: Successfully built 47d2524123ec
Step #1: Successfully tagged gcr.io/trillian-opensource-ci/ct_testbase:latest
Finished Step #1
Starting Step #2 - "prepare"
Step #2 - "prepare": Already have image (with digest): gcr.io/trillian-opensource-ci/ct_testbase
Step #2 - "prepare": + docker pull gcr.io/trillian-opensource-ci/log_server:latest
Step #2 - "prepare": latest: Pulling from trillian-opensource-ci/log_server
Step #2 - "prepare": 0baecf37abee: Already exists
Step #2 - "prepare": bfb59b82a9b6: Already exists
Step #2 - "prepare": efa9d1d5d3a2: Already exists
Step #2 - "prepare": a62778643d56: Already exists
Step #2 - "prepare": 7c12895b777b: Already exists
Step #2 - "prepare": 3214acf345c0: Already exists
Step #2 - "prepare": 5664b15f108b: Already exists
Step #2 - "prepare": 0bab15eea81d: Already exists
Step #2 - "prepare": 4aa0ea1413d3: Already exists
Step #2 - "prepare": da7816fa955e: Already exists
Step #2 - "prepare": 9aee425378d2: Already exists
Step #2 - "prepare": 701c983262e9: Already exists
Step #2 - "prepare": 221438ca359c: Already exists
Step #2 - "prepare": 99e0dae7d871: Pulling fs layer
Step #2 - "prepare": 407ed948d041: Pulling fs layer
Step #2 - "prepare": 407ed948d041: Verifying Checksum
Step #2 - "prepare": 407ed948d041: Download complete
Step #2 - "prepare": 99e0dae7d871: Verifying Checksum
Step #2 - "prepare": 99e0dae7d871: Download complete
Step #2 - "prepare": 99e0dae7d871: Pull complete
Step #2 - "prepare": 407ed948d041: Pull complete
Step #2 - "prepare": Digest: sha256:cdcb70919af27bb23b960a0668e69e8c57b245aab92cd2aff3b5f38ed6589bfd
Step #2 - "prepare": Status: Downloaded newer image for gcr.io/trillian-opensource-ci/log_server:latest
Step #2 - "prepare": gcr.io/trillian-opensource-ci/log_server:latest
Step #2 - "prepare": + docker tag gcr.io/trillian-opensource-ci/log_server:latest postgresql_trillian-log-server
Step #2 - "prepare": + docker pull gcr.io/trillian-opensource-ci/log_signer:latest
Step #2 - "prepare": latest: Pulling from trillian-opensource-ci/log_signer
Step #2 - "prepare": 0baecf37abee: Already exists
Step #2 - "prepare": bfb59b82a9b6: Already exists
Step #2 - "prepare": efa9d1d5d3a2: Already exists
Step #2 - "prepare": a62778643d56: Already exists
Step #2 - "prepare": 7c12895b777b: Already exists
Step #2 - "prepare": 3214acf345c0: Already exists
Step #2 - "prepare": 5664b15f108b: Already exists
Step #2 - "prepare": 0bab15eea81d: Already exists
Step #2 - "prepare": 4aa0ea1413d3: Already exists
Step #2 - "prepare": da7816fa955e: Already exists
Step #2 - "prepare": 9aee425378d2: Already exists
Step #2 - "prepare": 701c983262e9: Already exists
Step #2 - "prepare": 221438ca359c: Already exists
Step #2 - "prepare": 51b9a9195c0c: Pulling fs layer
Step #2 - "prepare": a6e7f99d40b0: Pulling fs layer
Step #2 - "prepare": a6e7f99d40b0: Verifying Checksum
Step #2 - "prepare": a6e7f99d40b0: Download complete
Step #2 - "prepare": 51b9a9195c0c: Verifying Checksum
Step #2 - "prepare": 51b9a9195c0c: Download complete
Step #2 - "prepare": 51b9a9195c0c: Pull complete
Step #2 - "prepare": a6e7f99d40b0: Pull complete
Step #2 - "prepare": Digest: sha256:50e889823f6b2d8d2b2b0cf5dc4563c08ebc04d9eb18949c75d4d9a0cc54db05
Step #2 - "prepare": Status: Downloaded newer image for gcr.io/trillian-opensource-ci/log_signer:latest
Step #2 - "prepare": gcr.io/trillian-opensource-ci/log_signer:latest
Step #2 - "prepare": + docker tag gcr.io/trillian-opensource-ci/log_signer:latest postgresql_trillian-log-signer
Step #2 - "prepare": ++ go list -f '{{.Dir}}' github.com/google/trillian
Step #2 - "prepare": go: downloading github.com/google/trillian v1.7.0
Step #2 - "prepare": go: downloading google.golang.org/grpc v1.68.1
Step #2 - "prepare": go: downloading google.golang.org/protobuf v1.35.2
Step #2 - "prepare": go: downloading google.golang.org/genproto/googleapis/rpc v0.0.0-20241113202542-65e8d215514f
Step #2 - "prepare": go: downloading google.golang.org/genproto v0.0.0-20241113202542-65e8d215514f
Step #2 - "prepare": go: downloading golang.org/x/sys v0.28.0
Step #2 - "prepare": go: downloading golang.org/x/net v0.32.0
Step #2 - "prepare": go: downloading golang.org/x/text v0.21.0
Step #2 - "prepare": + export TRILLIAN_LOCATION=/go/pkg/mod/github.com/google/trillian@v1.7.0
Step #2 - "prepare": + TRILLIAN_LOCATION=/go/pkg/mod/github.com/google/trillian@v1.7.0
Step #2 - "prepare": + echo -e 'networks:\n      default:\n        external:\n          name: cloudbuild'
Step #2 - "prepare": + docker-compose -f /go/pkg/mod/github.com/google/trillian@v1.7.0/examples/deployment/postgresql/docker-compose.yml pull postgresql trillian-log-server trillian-log-signer
Step #2 - "prepare": Pulling postgresql          ... 
Step #2 - "prepare": Pulling trillian-log-server ... 
Step #2 - "prepare": Pulling trillian-log-signer ... 
Step #2 - "prepare": Pulling postgresql          ... done
Step #2 - "prepare": Pulling trillian-log-signer ... done
Step #2 - "prepare": Pulling trillian-log-server ... done
Step #2 - "prepare": + docker-compose -f /go/pkg/mod/github.com/google/trillian@v1.7.0/examples/deployment/postgresql/docker-compose.yml up -d postgresql trillian-log-server trillian-log-signer
Step #2 - "prepare": Building postgresql
Step #2 - "prepare": Sending build context to Docker daemon  5.531MB

Step #2 - "prepare": Step 1/3 : FROM postgres:17.1@sha256:163763c8afd28cae69035ce84b12d8180179559c747c0701b3cad17818a0dbc5
Step #2 - "prepare": docker.io/library/postgres:17.1@sha256:163763c8afd28cae69035ce84b12d8180179559c747c0701b3cad17818a0dbc5: Pulling from library/postgres
Step #2 - "prepare": 2d429b9e73a6: Pulling fs layer
Step #2 - "prepare": e8429bf8c751: Pulling fs layer
Step #2 - "prepare": 6f797120cf60: Pulling fs layer
Step #2 - "prepare": 6d3d16629482: Pulling fs layer
Step #2 - "prepare": 5eaadf8c0964: Pulling fs layer
Step #2 - "prepare": 9f868a0e1b86: Pulling fs layer
Step #2 - "prepare": 63e9527d3d4d: Pulling fs layer
Step #2 - "prepare": 08b0635ec300: Pulling fs layer
Step #2 - "prepare": fae0bc27f45a: Pulling fs layer
Step #2 - "prepare": 637539a522b5: Pulling fs layer
Step #2 - "prepare": a46125241e83: Pulling fs layer
Step #2 - "prepare": c58210073ea0: Pulling fs layer
Step #2 - "prepare": 55a824e2a83b: Pulling fs layer
Step #2 - "prepare": bc5e9b7132d3: Pulling fs layer
Step #2 - "prepare": 5eaadf8c0964: Waiting
Step #2 - "prepare": fae0bc27f45a: Waiting
Step #2 - "prepare": 9f868a0e1b86: Waiting
Step #2 - "prepare": a46125241e83: Waiting
Step #2 - "prepare": 637539a522b5: Waiting
Step #2 - "prepare": c58210073ea0: Waiting
Step #2 - "prepare": 08b0635ec300: Waiting
Step #2 - "prepare": 55a824e2a83b: Waiting
Step #2 - "prepare": 63e9527d3d4d: Waiting
Step #2 - "prepare": bc5e9b7132d3: Waiting
Step #2 - "prepare": 6d3d16629482: Waiting
Step #2 - "prepare": e8429bf8c751: Verifying Checksum
Step #2 - "prepare": e8429bf8c751: Download complete
Step #2 - "prepare": 6f797120cf60: Verifying Checksum
Step #2 - "prepare": 6f797120cf60: Download complete
Step #2 - "prepare": 2d429b9e73a6: Verifying Checksum
Step #2 - "prepare": 2d429b9e73a6: Download complete
Step #2 - "prepare": 6d3d16629482: Verifying Checksum
Step #2 - "prepare": 6d3d16629482: Download complete
Step #2 - "prepare": 9f868a0e1b86: Verifying Checksum
Step #2 - "prepare": 9f868a0e1b86: Download complete
Step #2 - "prepare": 2d429b9e73a6: Pull complete
Step #2 - "prepare": 5eaadf8c0964: Verifying Checksum
Step #2 - "prepare": 5eaadf8c0964: Download complete
Step #2 - "prepare": e8429bf8c751: Pull complete
Step #2 - "prepare": 63e9527d3d4d: Verifying Checksum
Step #2 - "prepare": 63e9527d3d4d: Download complete
Step #2 - "prepare": 6f797120cf60: Pull complete
Step #2 - "prepare": 6d3d16629482: Pull complete
Step #2 - "prepare": 08b0635ec300: Verifying Checksum
Step #2 - "prepare": 08b0635ec300: Download complete
Step #2 - "prepare": 637539a522b5: Verifying Checksum
Step #2 - "prepare": 637539a522b5: Download complete
Step #2 - "prepare": 5eaadf8c0964: Pull complete
Step #2 - "prepare": 9f868a0e1b86: Pull complete
Step #2 - "prepare": 63e9527d3d4d: Pull complete
Step #2 - "prepare": 08b0635ec300: Pull complete
Step #2 - "prepare": a46125241e83: Verifying Checksum
Step #2 - "prepare": a46125241e83: Download complete
Step #2 - "prepare": c58210073ea0: Verifying Checksum
Step #2 - "prepare": c58210073ea0: Download complete
Step #2 - "prepare": 55a824e2a83b: Verifying Checksum
Step #2 - "prepare": 55a824e2a83b: Download complete
Step #2 - "prepare": bc5e9b7132d3: Verifying Checksum
Step #2 - "prepare": bc5e9b7132d3: Download complete
Step #2 - "prepare": fae0bc27f45a: Verifying Checksum
Step #2 - "prepare": fae0bc27f45a: Download complete
Step #2 - "prepare": fae0bc27f45a: Pull complete
Step #2 - "prepare": 637539a522b5: Pull complete
Step #2 - "prepare": a46125241e83: Pull complete
Step #2 - "prepare": c58210073ea0: Pull complete
Step #2 - "prepare": 55a824e2a83b: Pull complete
Step #2 - "prepare": bc5e9b7132d3: Pull complete
Step #2 - "prepare": Digest: sha256:163763c8afd28cae69035ce84b12d8180179559c747c0701b3cad17818a0dbc5
Step #2 - "prepare": Status: Downloaded newer image for postgres:17.1@sha256:163763c8afd28cae69035ce84b12d8180179559c747c0701b3cad17818a0dbc5
Step #2 - "prepare":  ---> 813dc60d83aa
Step #2 - "prepare": Step 2/3 : COPY storage/postgresql/schema/storage.sql /docker-entrypoint-initdb.d/storage.sql
Step #2 - "prepare":  ---> edb74b138906
Step #2 - "prepare": Step 3/3 : RUN chmod -R 775 /docker-entrypoint-initdb.d
Step #2 - "prepare":  ---> Running in 5fb7c9d70c5c
Step #2 - "prepare": Removing intermediate container 5fb7c9d70c5c
Step #2 - "prepare":  ---> c6c45c64203c
Step #2 - "prepare": Successfully built c6c45c64203c
Step #2 - "prepare": Successfully tagged postgresql_postgresql:latest
Step #2 - "prepare": Image for service postgresql was built because it did not already exist. To rebuild this image you must use `docker-compose build` or `docker-compose up --build`.
Step #2 - "prepare": Creating postgresql_postgresql_1 ... 
Step #2 - "prepare": Creating postgresql_postgresql_1 ... done
Step #2 - "prepare": Creating postgresql_trillian-log-signer_1 ... 
Step #2 - "prepare": Creating postgresql_trillian-log-server_1 ... 
Step #2 - "prepare": Creating postgresql_trillian-log-signer_1 ... done
Step #2 - "prepare": Creating postgresql_trillian-log-server_1 ... done
Finished Step #2 - "prepare"
Starting Step #3 - "ci-ready"
Step #3 - "ci-ready": Already have image (with digest): gcr.io/trillian-opensource-ci/ct_testbase
Step #3 - "ci-ready": go: downloading github.com/fullstorydev/grpcurl v1.9.2
Step #3 - "ci-ready": go: downloading github.com/golang/protobuf v1.5.4
Step #3 - "ci-ready": go: downloading github.com/golang/mock v1.6.0
Step #3 - "ci-ready": go: downloading go.etcd.io/etcd/etcdctl/v3 v3.5.17
Step #3 - "ci-ready": go: downloading go.etcd.io/etcd/v3 v3.5.17
Step #3 - "ci-ready": go: downloading github.com/jhump/protoreflect v1.16.0
Step #3 - "ci-ready": go: downloading github.com/envoyproxy/go-control-plane v0.13.0
Step #3 - "ci-ready": go: downloading golang.org/x/sync v0.10.0
Step #3 - "ci-ready": go: downloading github.com/cespare/xxhash/v2 v2.3.0
Step #3 - "ci-ready": go: downloading github.com/cncf/xds/go v0.0.0-20240905190251-b4127c9b8d78
Step #3 - "ci-ready": go: downloading golang.org/x/mod v0.22.0
Step #3 - "ci-ready": go: downloading golang.org/x/tools v0.27.0
Step #3 - "ci-ready": go: downloading cel.dev/expr v0.16.1
Step #3 - "ci-ready": go: downloading github.com/envoyproxy/protoc-gen-validate v1.1.0
Step #3 - "ci-ready": go: downloading google.golang.org/genproto/googleapis/api v0.0.0-20241104194629-dd2ea8efbc28
Step #3 - "ci-ready": go: downloading go.etcd.io/etcd/client/v2 v2.305.17
Step #3 - "ci-ready": go: downloading go.etcd.io/etcd/etcdutl/v3 v3.5.17
Step #3 - "ci-ready": go: downloading go.etcd.io/etcd/tests/v3 v3.5.17
Step #3 - "ci-ready": go: downloading github.com/bufbuild/protocompile v0.10.0
Step #3 - "ci-ready": go: downloading github.com/urfave/cli v1.22.14
Step #3 - "ci-ready": go: downloading go.etcd.io/etcd/api/v3 v3.5.17
Step #3 - "ci-ready": go: downloading github.com/spf13/cobra v1.8.1
Step #3 - "ci-ready": go: downloading go.etcd.io/etcd/pkg/v3 v3.5.17
Step #3 - "ci-ready": go: downloading github.com/json-iterator/go v1.1.12
Step #3 - "ci-ready": go: downloading github.com/modern-go/reflect2 v1.0.2
Step #3 - "ci-ready": go: downloading go.etcd.io/etcd/client/pkg/v3 v3.5.17
Step #3 - "ci-ready": go: downloading github.com/bgentry/speakeasy v0.1.0
Step #3 - "ci-ready": go: downloading github.com/dustin/go-humanize v1.0.1
Step #3 - "ci-ready": go: downloading github.com/olekukonko/tablewriter v0.0.5
Step #3 - "ci-ready": go: downloading github.com/spf13/pflag v1.0.5
Step #3 - "ci-ready": go: downloading go.etcd.io/etcd/client/v3 v3.5.17
Step #3 - "ci-ready": go: downloading go.uber.org/zap v1.27.0
Step #3 - "ci-ready": go: downloading golang.org/x/time v0.8.0
Step #3 - "ci-ready": go: downloading gopkg.in/cheggaaa/pb.v1 v1.0.28
Step #3 - "ci-ready": go: downloading golang.org/x/oauth2 v0.24.0
Step #3 - "ci-ready": go: downloading go.etcd.io/bbolt v1.3.11
Step #3 - "ci-ready": go: downloading go.etcd.io/etcd/raft/v3 v3.5.17
Step #3 - "ci-ready": go: downloading go.etcd.io/etcd/server/v3 v3.5.17
Step #3 - "ci-ready": go: downloading github.com/cpuguy83/go-md2man/v2 v2.0.4
Step #3 - "ci-ready": go: downloading github.com/coreos/go-semver v0.3.1
Step #3 - "ci-ready": go: downloading github.com/modern-go/concurrent v0.0.0-20180306012644-bacd9c7ef1dd
Step #3 - "ci-ready": go: downloading github.com/grpc-ecosystem/go-grpc-middleware v1.4.0
Step #3 - "ci-ready": go: downloading github.com/soheilhy/cmux v0.1.5
Step #3 - "ci-ready": go: downloading golang.org/x/crypto v0.31.0
Step #3 - "ci-ready": go: downloading github.com/gogo/protobuf v1.3.2
Step #3 - "ci-ready": go: downloading github.com/coreos/go-systemd/v22 v22.5.0
Step #3 - "ci-ready": go: downloading github.com/mattn/go-runewidth v0.0.13
Step #3 - "ci-ready": go: downloading cloud.google.com/go/compute/metadata v0.5.2
Step #3 - "ci-ready": go: downloading go.uber.org/multierr v1.11.0
Step #3 - "ci-ready": go: downloading github.com/prometheus/client_golang v1.20.5
Step #3 - "ci-ready": go: downloading github.com/jonboulle/clockwork v0.4.0
Step #3 - "ci-ready": go: downloading go.opentelemetry.io/contrib/instrumentation/google.golang.org/grpc/otelgrpc v0.54.0
Step #3 - "ci-ready": go: downloading github.com/grpc-ecosystem/go-grpc-prometheus v1.2.0
Step #3 - "ci-ready": go: downloading github.com/grpc-ecosystem/grpc-gateway v1.16.0
Step #3 - "ci-ready": go: downloading github.com/tmc/grpc-websocket-proxy v0.0.0-20220101234140-673ab2c3ae75
Step #3 - "ci-ready": go: downloading go.opentelemetry.io/otel/exporters/otlp/otlptrace/otlptracegrpc v1.24.0
Step #3 - "ci-ready": go: downloading go.opentelemetry.io/otel v1.29.0
Step #3 - "ci-ready": go: downloading go.opentelemetry.io/otel/exporters/otlp/otlptrace v1.24.0
Step #3 - "ci-ready": go: downloading go.opentelemetry.io/otel/sdk v1.29.0
Step #3 - "ci-ready": go: downloading gopkg.in/natefinch/lumberjack.v2 v2.2.1
Step #3 - "ci-ready": go: downloading sigs.k8s.io/yaml v1.4.0
Step #3 - "ci-ready": go: downloading github.com/xiang90/probing v0.0.0-20221125231312-a49e3df8f510
Step #3 - "ci-ready": go: downloading github.com/russross/blackfriday/v2 v2.1.0
Step #3 - "ci-ready": go: downloading github.com/rivo/uniseg v0.4.4
Step #3 - "ci-ready": go: downloading github.com/google/btree v1.1.3
Step #3 - "ci-ready": go: downloading go.opentelemetry.io/otel/metric v1.29.0
Step #3 - "ci-ready": go: downloading go.opentelemetry.io/otel/trace v1.29.0
Step #3 - "ci-ready": go: downloading github.com/gorilla/websocket v1.5.1
Step #3 - "ci-ready": go: downloading github.com/sirupsen/logrus v1.9.3
Step #3 - "ci-ready": go: downloading github.com/beorn7/perks v1.0.1
Step #3 - "ci-ready": go: downloading github.com/prometheus/client_model v0.6.1
Step #3 - "ci-ready": go: downloading github.com/prometheus/common v0.55.0
Step #3 - "ci-ready": go: downloading github.com/prometheus/procfs v0.15.1
Step #3 - "ci-ready": go: downloading go.opentelemetry.io/proto/otlp v1.1.0
Step #3 - "ci-ready": go: downloading github.com/google/uuid v1.6.0
Step #3 - "ci-ready": go: downloading github.com/golang-jwt/jwt/v4 v4.5.1
Step #3 - "ci-ready": go: downloading github.com/klauspost/compress v1.17.9
Step #3 - "ci-ready": go: downloading github.com/go-logr/logr v1.4.2
Step #3 - "ci-ready": go: downloading github.com/cenkalti/backoff/v4 v4.3.0
Step #3 - "ci-ready": go: downloading github.com/go-logr/stdr v1.2.2
Step #3 - "ci-ready": go: downloading github.com/census-instrumentation/opencensus-proto v0.4.1
Step #3 - "ci-ready": go: downloading github.com/grpc-ecosystem/grpc-gateway/v2 v2.19.1
Step #3 - "ci-ready": go: downloading github.com/munnerz/goautoneg v0.0.0-20191010083416-a7dc8b61c822
Step #3 - "ci-ready": go: downloading github.com/gorilla/mux v1.8.1
Step #3 - "ci-ready": go: downloading k8s.io/klog/v2 v2.130.1
Step #3 - "ci-ready": go: downloading github.com/transparency-dev/merkle v0.0.2
Step #3 - "ci-ready": go: downloading github.com/kylelemons/godebug v1.1.0
Step #3 - "ci-ready": go: downloading gopkg.in/yaml.v3 v3.0.1
Step #3 - "ci-ready": go: downloading github.com/hashicorp/golang-lru/v2 v2.0.7
Step #3 - "ci-ready": go: downloading github.com/jackc/pgx/v5 v5.7.1
Step #3 - "ci-ready": go: downloading github.com/go-sql-driver/mysql v1.8.1
Step #3 - "ci-ready": go: downloading github.com/jackc/pgerrcode v0.0.0-20240316143900-6e2875d9b438
Step #3 - "ci-ready": go: downloading github.com/mattn/go-sqlite3 v1.14.24
Step #3 - "ci-ready": go: downloading github.com/rs/cors v1.11.1
Step #3 - "ci-ready": go: downloading github.com/tomasen/realip v0.0.0-20180522021738-f0c99a92ddce
Step #3 - "ci-ready": go: downloading github.com/google/go-cmp v0.6.0
Step #3 - "ci-ready": go: downloading contrib.go.opencensus.io/exporter/stackdriver v0.13.14
Step #3 - "ci-ready": go: downloading go.opencensus.io v0.24.0
Step #3 - "ci-ready": go: downloading github.com/lib/pq v1.10.9
Step #3 - "ci-ready": go: downloading filippo.io/edwards25519 v1.1.0
Step #3 - "ci-ready": go: downloading github.com/prometheus/prometheus v0.51.0
Step #3 - "ci-ready": go: downloading cloud.google.com/go/monitoring v1.21.2
Step #3 - "ci-ready": go: downloading cloud.google.com/go/trace v1.11.2
Step #3 - "ci-ready": go: downloading google.golang.org/api v0.207.0
Step #3 - "ci-ready": go: downloading github.com/aws/aws-sdk-go v1.51.8
Step #3 - "ci-ready": go: downloading github.com/googleapis/gax-go/v2 v2.14.0
Step #3 - "ci-ready": go: downloading github.com/golang/groupcache v0.0.0-20210331224755-41bb18bfe9da
Step #3 - "ci-ready": go: downloading github.com/jackc/pgpassfile v1.0.0
Step #3 - "ci-ready": go: downloading github.com/jackc/pgservicefile v0.0.0-20240606120523-5a60cdf6a761
Step #3 - "ci-ready": go: downloading github.com/jackc/puddle/v2 v2.2.2
Step #3 - "ci-ready": go: downloading cloud.google.com/go/auth v0.10.2
Step #3 - "ci-ready": go: downloading github.com/googleapis/enterprise-certificate-proxy v0.3.4
Step #3 - "ci-ready": go: downloading go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp v0.54.0
Step #3 - "ci-ready": go: downloading github.com/google/s2a-go v0.1.8
Step #3 - "ci-ready": go: downloading cloud.google.com/go/auth/oauth2adapt v0.2.5
Step #3 - "ci-ready": go: downloading github.com/felixge/httpsnoop v1.0.4
Step #3 - "ci-ready": go: downloading github.com/jmespath/go-jmespath v0.4.1-0.20220621161143-b0104c826a24
Step #3 - "ci-ready": ?   	github.com/google/certificate-transparency-go/client/configpb	[no test files]
Step #3 - "ci-ready": ?   	github.com/google/certificate-transparency-go/client/ctclient	[no test files]
Step #3 - "ci-ready": ?   	github.com/google/certificate-transparency-go/client/ctclient/cmd	[no test files]
Step #3 - "ci-ready": ?   	github.com/google/certificate-transparency-go/ctutil/sctcheck	[no test files]
Step #3 - "ci-ready": ?   	github.com/google/certificate-transparency-go/ctutil/sctscan	[no test files]
Step #3 - "ci-ready": ?   	github.com/google/certificate-transparency-go/fixchain/chainfix	[no test files]
Step #3 - "ci-ready": ?   	github.com/google/certificate-transparency-go/internal/witness/api	[no test files]
Step #3 - "ci-ready": ?   	github.com/google/certificate-transparency-go/internal/witness/client/http	[no test files]
Step #3 - "ci-ready": ?   	github.com/google/certificate-transparency-go/internal/witness/cmd/client	[no test files]
Step #3 - "ci-ready": ?   	github.com/google/certificate-transparency-go/internal/witness/cmd/feeder	[no test files]
Step #3 - "ci-ready": ok  	github.com/google/certificate-transparency-go	0.845s
Step #3 - "ci-ready": ok  	github.com/google/certificate-transparency-go/asn1	0.007s
Step #3 - "ci-ready": ok  	github.com/google/certificate-transparency-go/client	22.771s
Step #3 - "ci-ready": ok  	github.com/google/certificate-transparency-go/ctpolicy	0.009s
Step #3 - "ci-ready": ok  	github.com/google/certificate-transparency-go/ctutil	0.017s
Step #3 - "ci-ready": ok  	github.com/google/certificate-transparency-go/fixchain	0.096s
Step #3 - "ci-ready": ok  	github.com/google/certificate-transparency-go/gossip/minimal/x509ext	0.005s
Step #3 - "ci-ready": ?   	github.com/google/certificate-transparency-go/internal/witness/cmd/witness	[no test files]
Step #3 - "ci-ready": ?   	github.com/google/certificate-transparency-go/internal/witness/cmd/witness/config	[no test files]
Step #3 - "ci-ready": ?   	github.com/google/certificate-transparency-go/internal/witness/cmd/witness/impl	[no test files]
Step #3 - "ci-ready": ok  	github.com/google/certificate-transparency-go/internal/witness/cmd/witness/internal/http	0.019s
Step #3 - "ci-ready": ?   	github.com/google/certificate-transparency-go/internal/witness/verifier	[no test files]
Step #3 - "ci-ready": ?   	github.com/google/certificate-transparency-go/preload	[no test files]
Step #3 - "ci-ready": ?   	github.com/google/certificate-transparency-go/preload/dumpscts	[no test files]
Step #3 - "ci-ready": ?   	github.com/google/certificate-transparency-go/preload/preloader	[no test files]
Step #3 - "ci-ready": ?   	github.com/google/certificate-transparency-go/scanner/scanlog	[no test files]
Step #3 - "ci-ready": ?   	github.com/google/certificate-transparency-go/trillian/ctfe/cache	[no test files]
Step #3 - "ci-ready": ?   	github.com/google/certificate-transparency-go/trillian/ctfe/cache/noop	[no test files]
Step #3 - "ci-ready": ?   	github.com/google/certificate-transparency-go/trillian/ctfe/configpb	[no test files]
Step #3 - "ci-ready": ?   	github.com/google/certificate-transparency-go/submission/hammer	[no test files]
Step #3 - "ci-ready": ?   	github.com/google/certificate-transparency-go/submission/server	[no test files]
Step #3 - "ci-ready": ok  	github.com/google/certificate-transparency-go/internal/witness/cmd/witness/internal/witness	0.017s
Step #3 - "ci-ready": ok  	github.com/google/certificate-transparency-go/jsonclient	0.014s
Step #3 - "ci-ready": ok  	github.com/google/certificate-transparency-go/logid	0.003s
Step #3 - "ci-ready": ok  	github.com/google/certificate-transparency-go/loglist3	0.012s
Step #3 - "ci-ready": ok  	github.com/google/certificate-transparency-go/scanner	0.009s
Step #3 - "ci-ready": ok  	github.com/google/certificate-transparency-go/schedule	0.254s
Step #3 - "ci-ready": ?   	github.com/google/certificate-transparency-go/trillian/ctfe/ct_server	[no test files]
Step #3 - "ci-ready": ?   	github.com/google/certificate-transparency-go/trillian/ctfe/storage	[no test files]
Step #3 - "ci-ready": ?   	github.com/google/certificate-transparency-go/trillian/ctfe/testonly	[no test files]
Step #3 - "ci-ready": ?   	github.com/google/certificate-transparency-go/trillian/integration/ct_hammer	[no test files]
Step #3 - "ci-ready": ?   	github.com/google/certificate-transparency-go/trillian/migrillian	[no test files]
Step #3 - "ci-ready": ?   	github.com/google/certificate-transparency-go/trillian/migrillian/configpb	[no test files]
Step #3 - "ci-ready": ?   	github.com/google/certificate-transparency-go/trillian/mockclient	[no test files]
Step #3 - "ci-ready": ?   	github.com/google/certificate-transparency-go/trillian/util	[no test files]
Step #3 - "ci-ready": ?   	github.com/google/certificate-transparency-go/x509/pkix	[no test files]
Step #3 - "ci-ready": ?   	github.com/google/certificate-transparency-go/x509util/certcheck	[no test files]
Step #3 - "ci-ready": ?   	github.com/google/certificate-transparency-go/x509util/crlcheck	[no test files]
Step #3 - "ci-ready": ok  	github.com/google/certificate-transparency-go/submission	6.240s
Step #3 - "ci-ready": ok  	github.com/google/certificate-transparency-go/tls	0.012s
Step #3 - "ci-ready": ok  	github.com/google/certificate-transparency-go/trillian/ctfe	0.089s
Step #3 - "ci-ready": ok  	github.com/google/certificate-transparency-go/trillian/ctfe/cache/lru	0.003s
Step #3 - "ci-ready": ok  	github.com/google/certificate-transparency-go/trillian/ctfe/storage/mysql	0.005s
Step #3 - "ci-ready": ok  	github.com/google/certificate-transparency-go/trillian/ctfe/storage/postgresql	0.005s
Step #3 - "ci-ready": ok  	github.com/google/certificate-transparency-go/trillian/integration	0.020s
Step #3 - "ci-ready": ok  	github.com/google/certificate-transparency-go/trillian/migrillian/core	0.006s
Step #3 - "ci-ready": ok  	github.com/google/certificate-transparency-go/x509	0.246s
Step #3 - "ci-ready": ok  	github.com/google/certificate-transparency-go/x509util	0.005s
Step #3 - "ci-ready": - Using PostgreSQL Flags: -U postgres --host postgresql --port 5432 --echo-all
Step #3 - "ci-ready": Warning: about to destroy and reset database 'defaultctdb'
Step #3 - "ci-ready": 
Step #3 - "ci-ready": Resetting DB...
Step #3 - "ci-ready": + psql -U postgres --
...
[Logs truncated due to log size limitations. For full logs, see https://storage.cloud.google.com/trillian-cloudbuild-logs/log-565c6caf-f20d-423c-9f35-f6a916310918.txt.]
...
ace": W1218 10:24:36.120096   31683 handlers.go:206] aramis{7219511787988393522}: AddPreChain handler error: aramis{7219511787988393522}: failed to parse add-chain body: cert chain was empty
Step #8 - "with_pkcs11_and_race": W1218 10:24:36.157747   31683 handlers.go:206] aramis{7219511787988393522}: GetEntries handler error: need tree size: 1000001445 to get leaves but only got: 1492
Step #8 - "with_pkcs11_and_race": W1218 10:24:36.278451   31683 handlers.go:206] aramis{7219511787988393522}: AddPreChain handler error: aramis{7219511787988393522}: failed to parse add-chain body: cert chain was empty
Step #8 - "with_pkcs11_and_race": W1218 10:24:36.300023   31683 handlers.go:206] aramis{7219511787988393522}: AddChain handler error: failed to verify add-chain contents: chain failed to verify: asn1: structure error: tags don't match (16 vs {class:0 tag:0 length:624 isCompound:false}) {optional:false explicit:false application:false private:false defaultValue:<nil> tag:<nil> stringType:0 timeType:0 set:false omitEmpty:false lax:true name:} certificate @4
Step #8 - "with_pkcs11_and_race": W1218 10:24:36.582208   31683 handlers.go:206] aramis{7219511787988393522}: AddPreChain handler error: failed to verify add-chain contents: chain failed to verify: x509: certificate signed by unknown authority
Step #5 - "race_detection": Stopping CT HTTP servers (pids 30403)
Step #5 - "race_detection": W1218 10:24:36.687661   30403 main.go:379] Signal received: interrupt
Step #5 - "race_detection": I1218 10:24:36.687745   30403 main.go:349] Shutting down HTTP server...
Step #5 - "race_detection": I1218 10:24:36.687879   30403 main.go:353] HTTP server shutdown
Step #8 - "with_pkcs11_and_race": W1218 10:24:36.841353   31683 handlers.go:951] aramis{7219511787988393522}: Cert (or precert with invalid CT ext) submitted as precert chain: ["0\x82\x02o0\x82\x02\x15\xa0\x03\x02\x01\x02\x02\x05\x00ޭ\xbe\xef0\n\x06\b*\x86H\xce=\x04\x03\x020r1\v0\t\x06\x03U\x04\x06\x13\x02GB1\x0f0\r\x06\x03U\x04\b\x13\x06London1\x0f0\r\x06\x03U\x04\a\x13\x06London1\x0f0\r\x06\x03U\x04\n\x13\x06Google1\f0\n\x06\x03U\x04\v\x13\x03Eng1\"0 \x06\x03U\x04\x03\x13\x19FakeIntermediateAuthority0\x1e\x17\r180329170511Z\x17\r241219102337Z0V1\v0\t\x06\x03U\x04\x06\x13\x02GB1\x0f0\r\x06\x03U\x04\b\f\x06London1\x0f0\r\x06\x03U\x04\n\f\x06Google1\f0\n\x06\x03U\x04\v\f\x03Eng1\x170\x15\x06\x03U\x04\x03\f\x0eleaf01.csr.pem0Y0\x13\x06\a*\x86H\xce=\x02\x01\x06\b*\x86H\xce=\x03\x01\a\x03B\x00\x04\xeb7NRE\x9cFը\xb8\xc5\xedX\xb90)\xa6p\x8ai\xa0&\\\x9e/n\xb8k#l\x84\xe1F:\x986\x82D\xa5\x8a\x17\x8bA\x822\xf4-\xe0\b[~\a8R\xfcGV('\x9b\xed`\x8b\xac\xa3\x81\xb30\x81\xb00\x0f\x06\x03U\x1d\x0f\x01\x01\xff\x04\x05\x03\x03\a\xf9\x800\x81\x8b\x06\x03U\x1d\x0e\x04\x81\x83\x04\x81\x80\xb3zTL\x0fE\x9d\x8b5\x8e\x18\xd1'\xa9\x17j\x15\x11\xa6\x00F\x87\x85\xbf\xe2\xb8j\x11I\x1781K\x1aA\x0fu\x9cN\x9d^*ڎ\xe1h\x1cPz\xb7\x93z\x7f)vH9\xed\xe1Y\x8a\x7f\x8fq<\xeaODؙ\n\xfe\xd8?\xdfF-$ZdK@n\xbf\x98&W\xc0E\xee\xa2\xf7t\xb2\x1e&\xa4\x8dAkkJ\x8d\xf9$\xa9w\x99\xd7\xc9\xf5\xbbB\xbe\x1bA\x8e\xc0֍\x93\x11\x94\x85\xfa\xf2\xbfP0\x0f\x06\x03U\x1d#\x04\b0\x06\x80\x04\x05\x06\a\b0\n\x06\b*\x86H\xce=\x04\x03\x02\x03H\x000E\x02 `\x18\x85\xd4$H\xfa'+\af\xa2$\x1e\xa4\xc3\x01\xab\xe79\tI[\x9c\x8cP0\xf2H_\xb3\xe9\x02!\x00\xdf\x15\xa5N\xcdq\x92\x88\xf9ͅuX\xb4\xf3M3u\xb5H\xbb9\xb3\x9a5\xa5\x9f\xe5\x01\xa5\x04~" "0\x82\x02<0\x82\x01\xe1\xa0\x03\x02\x01\x02\x02\x04BBBB0\n\x06\b*\x86H\xce=\x04\x03\x020q1\v0\t\x06\x03U\x04\x06\x13\x02GB1\x0f0\r\x06\x03U\x04\b\x13\x06London1\x0f0\r\x06\x03U\x04\a\x13\x06London1\x0f0\r\x06\x03U\x04\n\x13\x06Google1\f0\n\x06\x03U\x04\v\x13\x03Eng1!0\x1f\x06\x03U\x04\x03\x13\x18FakeCertificateAuthority0\x1e\x17\r180329170511Z\x17\r280205170511Z0r1\v0\t\x06\x03U\x04\x06\x13\x02GB1\x0f0\r\x06\x03U\x04\b\x13\x06London1\x0f0\r\x06\x03U\x04\a\x13\x06London1\x0f0\r\x06\x03U\x04\n\x13\x06Google1\f0\n\x06\x03U\x04\v\x13\x03Eng1\"0 \x06\x03U\x04\x03\x13\x19FakeIntermediateAuthority0Y0\x13\x06\a*\x86H\xce=\x02\x01\x06\b*\x86H\xce=\x03\x01\a\x03B\x00\x04\xf1\xbf-\xe8\x8cf@\xe3\xa8\xd1T\xe0BI\x02\xcb\xddG\b\x85\xc2gAL\xeb\xf7\x87͍\xa3\t\xc8\x18\xcc.0S\x162\xaa՜\bs\xc6v\xfa\xfa:8\xe945\x9cQ\xd1\xee\x12\x81]\x98_]]\xa3f0d0\r\x06\x03U\x1d\x0e\x04\x06\x04\x04\x05\x06\a\b0\x0f\x06\x03U\x1d#\x04\b0\x06\x80\x04\x01\x02\x03\x040\x12\x06\x03U\x1d\x13\x01\x01\xff\x04\b0\x06\x01\x01\xff\x02\x01\x000\x0f\x06\x03U\x1d\x0f\x01\x01\xff\x04\x05\x03\x03\a\xff\x800\x1d\x06\x03U\x1d%\x04\x160\x14\x06\b+\x06\x01\x05\x05\a\x03\x01\x06\b+\x06\x01\x05\x05\a\x03\x020\n\x06\b*\x86H\xce=\x04\x03\x02\x03I\x000F\x02!\x00\x95\xbfH\xb3\xc7k9\xbd\x8e\x97k\xbfK&\u07b5\x82\bE\xd1D(\x03P\xaa\nش\"\xf7\xa1\xe0\x02!\x00\xfbd\x18\xc8\xc08\x12\xaa\x9c^\xd9.\xcar\xb2Ɔ\xe8\xe0\x8by\xb4+\xcfw3\xeca߰\xc6\xdc"]
Step #8 - "with_pkcs11_and_race": W1218 10:24:36.841781   31683 handlers.go:206] aramis{7219511787988393522}: AddPreChain handler error: failed to verify add-chain contents: cert / precert mismatch: bool
Step #8 - "with_pkcs11_and_race": W1218 10:24:36.942396   31683 handlers.go:206] aramis{7219511787988393522}: GetSTHConsistency handler error: need tree size: 1000001548 for proof but only got: 1538
Step #8 - "with_pkcs11_and_race": W1218 10:24:37.185799   31683 handlers.go:953] aramis{7219511787988393522}: Precert (or cert with invalid CT ext) submitted as cert chain: ["0\x82\x02\x850\x82\x02*\xa0\x03\x02\x01\x02\x02\x05\x00ޭ\xbe\xef0\n\x06\b*\x86H\xce=\x04\x03\x020r1\v0\t\x06\x03U\x04\x06\x13\x02GB1\x0f0\r\x06\x03U\x04\b\x13\x06London1\x0f0\r\x06\x03U\x04\a\x13\x06London1\x0f0\r\x06\x03U\x04\n\x13\x06Google1\f0\n\x06\x03U\x04\v\x13\x03Eng1\"0 \x06\x03U\x04\x03\x13\x19FakeIntermediateAuthority0\x1e\x17\r180329170511Z\x17\r241219102337Z0V1\v0\t\x06\x03U\x04\x06\x13\x02GB1\x0f0\r\x06\x03U\x04\b\f\x06London1\x0f0\r\x06\x03U\x04\n\f\x06Google1\f0\n\x06\x03U\x04\v\f\x03Eng1\x170\x15\x06\x03U\x04\x03\f\x0eleaf01.csr.pem0Y0\x13\x06\a*\x86H\xce=\x02\x01\x06\b*\x86H\xce=\x03\x01\a\x03B\x00\x04\xeb7NRE\x9cFը\xb8\xc5\xedX\xb90)\xa6p\x8ai\xa0&\\\x9e/n\xb8k#l\x84\xe1F:\x986\x82D\xa5\x8a\x17\x8bA\x822\xf4-\xe0\b[~\a8R\xfcGV('\x9b\xed`\x8b\xac\xa3\x81\xc80\x81\xc50\x0f\x06\x03U\x1d\x0f\x01\x01\xff\x04\x05\x03\x03\a\xf9\x800\x81\x8b\x06\x03U\x1d\x0e\x04\x81\x83\x04\x81\x80V\xcb}\xea\xdf/X.Ң\xd7m<\t\xc1\xce\xc3$\x86\xac\xc4\xcc\xf1okI\x85\x83H\x11_)?2\x84y\x92\xafp+`\x12b\xf9\xb0\xed\xacɡ\xa16ܥ\"GoEk݉\xd3\xfcJ\x02y2\n\xe8\x05\x177\x80\xfc\xf1K\f\xea^\xcb!\xb2\x92$\x1d$\x1a\x986\x9d\x8f\xa7ib\xdc,\xac{\xbf$\x186\a9EX\x1b\x01g2\xd00.\x89\xb7@\x8f\xbe\x1ah5\xa4\x03\x9e\x8e`\xf2(\v0\x0f\x06\x03U\x1d#\x04\b0\x06\x80\x04\x05\x06\a\b0\x13\x06\n+\x06\x01\x04\x01\xd6y\x02\x04\x03\x01\x01\xff\x04\x02\x05\x000\n\x06\b*\x86H\xce=\x04\x03\x02\x03I\x000F\x02!\x00뻘\x88\x9b\xa9\xfa\xf9\xf41\x12.\xe2\xa3\xea\x1e\xf8&C\xf1\x1dW\xd3|\xba\xbe\x88n\a\b\xca\xe6\x02!\x00\xb5\xdd\xd6%\x17\xc1\xda6\xe8\x18\x9e\x80\x8b\x95)\xde]\xf8\xfe]\x9a\a\x910uV\xc7L\x83D\tV" "0\x82\x02<0\x82\x01\xe1\xa0\x03\x02\x01\x02\x02\x04BBBB0\n\x06\b*\x86H\xce=\x04\x03\x020q1\v0\t\x06\x03U\x04\x06\x13\x02GB1\x0f0\r\x06\x03U\x04\b\x13\x06London1\x0f0\r\x06\x03U\x04\a\x13\x06London1\x0f0\r\x06\x03U\x04\n\x13\x06Google1\f0\n\x06\x03U\x04\v\x13\x03Eng1!0\x1f\x06\x03U\x04\x03\x13\x18FakeCertificateAuthority0\x1e\x17\r180329170511Z\x17\r280205170511Z0r1\v0\t\x06\x03U\x04\x06\x13\x02GB1\x0f0\r\x06\x03U\x04\b\x13\x06London1\x0f0\r\x06\x03U\x04\a\x13\x06London1\x0f0\r\x06\x03U\x04\n\x13\x06Google1\f0\n\x06\x03U\x04\v\x13\x03Eng1\"0 \x06\x03U\x04\x03\x13\x19FakeIntermediateAuthority0Y0\x13\x06\a*\x86H\xce=\x02\x01\x06\b*\x86H\xce=\x03\x01\a\x03B\x00\x04\xf1\xbf-\xe8\x8cf@\xe3\xa8\xd1T\xe0BI\x02\xcb\xddG\b\x85\xc2gAL\xeb\xf7\x87͍\xa3\t\xc8\x18\xcc.0S\x162\xaa՜\bs\xc6v\xfa\xfa:8\xe945\x9cQ\xd1\xee\x12\x81]\x98_]]\xa3f0d0\r\x06\x03U\x1d\x0e\x04\x06\x04\x04\x05\x06\a\b0\x0f\x06\x03U\x1d#\x04\b0\x06\x80\x04\x01\x02\x03\x040\x12\x06\x03U\x1d\x13\x01\x01\xff\x04\b0\x06\x01\x01\xff\x02\x01\x000\x0f\x06\x03U\x1d\x0f\x01\x01\xff\x04\x05\x03\x03\a\xff\x800\x1d\x06\x03U\x1d%\x04\x160\x14\x06\b+\x06\x01\x05\x05\a\x03\x01\x06\b+\x06\x01\x05\x05\a\x03\x020\n\x06\b*\x86H\xce=\x04\x03\x02\x03I\x000F\x02!\x00\x95\xbfH\xb3\xc7k9\xbd\x8e\x97k\xbfK&\u07b5\x82\bE\xd1D(\x03P\xaa\nش\"\xf7\xa1\xe0\x02!\x00\xfbd\x18\xc8\xc08\x12\xaa\x9c^\xd9.\xcar\xb2Ɔ\xe8\xe0\x8by\xb4+\xcfw3\xeca߰\xc6\xdc"]
Step #8 - "with_pkcs11_and_race": W1218 10:24:37.186105   31683 handlers.go:206] aramis{7219511787988393522}: AddChain handler error: failed to verify add-chain contents: cert / precert mismatch: bool
Step #8 - "with_pkcs11_and_race": W1218 10:24:37.186949   31683 handlers.go:206] aramis{7219511787988393522}: AddPreChain handler error: aramis{7219511787988393522}: failed to parse add-chain body: cert chain was empty
Step #8 - "with_pkcs11_and_race": W1218 10:24:37.293291   31683 handlers.go:206] aramis{7219511787988393522}: AddChain handler error: failed to verify add-chain contents: chain failed to verify: asn1: structure error: tags don't match (16 vs {class:0 tag:0 length:623 isCompound:false}) {optional:false explicit:false application:false private:false defaultValue:<nil> tag:<nil> stringType:0 timeType:0 set:false omitEmpty:false lax:true name:} certificate @4
Step #8 - "with_pkcs11_and_race": W1218 10:24:37.314213   31683 handlers.go:951] aramis{7219511787988393522}: Cert (or precert with invalid CT ext) submitted as precert chain: ["0\x82\x02o0\x82\x02\x15\xa0\x03\x02\x01\x02\x02\x05\x00ޭ\xbe\xef0\n\x06\b*\x86H\xce=\x04\x03\x020r1\v0\t\x06\x03U\x04\x06\x13\x02GB1\x0f0\r\x06\x03U\x04\b\x13\x06London1\x0f0\r\x06\x03U\x04\a\x13\x06London1\x0f0\r\x06\x03U\x04\n\x13\x06Google1\f0\n\x06\x03U\x04\v\x13\x03Eng1\"0 \x06\x03U\x04\x03\x13\x19FakeIntermediateAuthority0\x1e\x17\r180329170511Z\x17\r241219102337Z0V1\v0\t\x06\x03U\x04\x06\x13\x02GB1\x0f0\r\x06\x03U\x04\b\f\x06London1\x0f0\r\x06\x03U\x04\n\f\x06Google1\f0\n\x06\x03U\x04\v\f\x03Eng1\x170\x15\x06\x03U\x04\x03\f\x0eleaf01.csr.pem0Y0\x13\x06\a*\x86H\xce=\x02\x01\x06\b*\x86H\xce=\x03\x01\a\x03B\x00\x04\xeb7NRE\x9cFը\xb8\xc5\xedX\xb90)\xa6p\x8ai\xa0&\\\x9e/n\xb8k#l\x84\xe1F:\x986\x82D\xa5\x8a\x17\x8bA\x822\xf4-\xe0\b[~\a8R\xfcGV('\x9b\xed`\x8b\xac\xa3\x81\xb30\x81\xb00\x0f\x06\x03U\x1d\x0f\x01\x01\xff\x04\x05\x03\x03\a\xf9\x800\x81\x8b\x06\x03U\x1d\x0e\x04\x81\x83\x04\x81\x80+9%\x18\xc0\x1e\x1ez\xa5\xf5\x16%\x86\xb8\xb9\xd4or\x1b\x99\xc2J\xa5\x9f\xb1\x17fQl\x1f]2\xf7\f]\x18\"^\xe84\x0334\xccK\xf94\x88kϓ7S翙\x887\x83VI\xa2bd\\\xa80\xf2w\x14E\x7f\x87\xafZ\x81\x1f\xf9=\x15\x9c`\xbd[\x18F\\tӌ\xb3\x1b\xc92\xe1\xe0\x8f\xa4̠\xc5\x1d\xf3\x98D\xf1\xa5|ܪD\x03=p\xd36\x9c0\x1f\xbdD\xf7\x95\xa6\xf9\xf7\xc6C0\x0f\x06\x03U\x1d#\x04\b0\x06\x80\x04\x05\x06\a\b0\n\x06\b*\x86H\xce=\x04\x03\x02\x03H\x000E\x02 P\xb7\xee\xe1\xeck,Rb\xa6f\xfb\xf8\xe0v\xca\xe8hX\xf0,\xe5C,\x8cV\xe4`D\x9c;I\x02!\x00\xa6\x11\x8e\x1e:D\x91\x82(\x17b\xebH\n\x1d\xfbb\xd5d\xe9Q\xbc\x1b\xec\x1bAa\x8d\xd9%g\x7f" "0\x82\x02<0\x82\x01\xe1\xa0\x03\x02\x01\x02\x02\x04BBBB0\n\x06\b*\x86H\xce=\x04\x03\x020q1\v0\t\x06\x03U\x04\x06\x13\x02GB1\x0f0\r\x06\x03U\x04\b\x13\x06London1\x0f0\r\x06\x03U\x04\a\x13\x06London1\x0f0\r\x06\x03U\x04\n\x13\x06Google1\f0\n\x06\x03U\x04\v\x13\x03Eng1!0\x1f\x06\x03U\x04\x03\x13\x18FakeCertificateAuthority0\x1e\x17\r180329170511Z\x17\r280205170511Z0r1\v0\t\x06\x03U\x04\x06\x13\x02GB1\x0f0\r\x06\x03U\x04\b\x13\x06London1\x0f0\r\x06\x03U\x04\a\x13\x06London1\x0f0\r\x06\x03U\x04\n\x13\x06Google1\f0\n\x06\x03U\x04\v\x13\x03Eng1\"0 \x06\x03U\x04\x03\x13\x19FakeIntermediateAuthority0Y0\x13\x06\a*\x86H\xce=\x02\x01\x06\b*\x86H\xce=\x03\x01\a\x03B\x00\x04\xf1\xbf-\xe8\x8cf@\xe3\xa8\xd1T\xe0BI\x02\xcb\xddG\b\x85\xc2gAL\xeb\xf7\x87͍\xa3\t\xc8\x18\xcc.0S\x162\xaa՜\bs\xc6v\xfa\xfa:8\xe945\x9cQ\xd1\xee\x12\x81]\x98_]]\xa3f0d0\r\x06\x03U\x1d\x0e\x04\x06\x04\x04\x05\x06\a\b0\x0f\x06\x03U\x1d#\x04\b0\x06\x80\x04\x01\x02\x03\x040\x12\x06\x03U\x1d\x13\x01\x01\xff\x04\b0\x06\x01\x01\xff\x02\x01\x000\x0f\x06\x03U\x1d\x0f\x01\x01\xff\x04\x05\x03\x03\a\xff\x800\x1d\x06\x03U\x1d%\x04\x160\x14\x06\b+\x06\x01\x05\x05\a\x03\x01\x06\b+\x06\x01\x05\x05\a\x03\x020\n\x06\b*\x86H\xce=\x04\x03\x02\x03I\x000F\x02!\x00\x95\xbfH\xb3\xc7k9\xbd\x8e\x97k\xbfK&\u07b5\x82\bE\xd1D(\x03P\xaa\nش\"\xf7\xa1\xe0\x02!\x00\xfbd\x18\xc8\xc08\x12\xaa\x9c^\xd9.\xcar\xb2Ɔ\xe8\xe0\x8by\xb4+\xcfw3\xeca߰\xc6\xdc"]
Step #8 - "with_pkcs11_and_race": W1218 10:24:37.314506   31683 handlers.go:206] aramis{7219511787988393522}: AddPreChain handler error: failed to verify add-chain contents: cert / precert mismatch: bool
Step #8 - "with_pkcs11_and_race": W1218 10:24:37.446896   31683 handlers.go:206] aramis{7219511787988393522}: AddChain handler error: aramis{7219511787988393522}: failed to parse add-chain body: cert chain was empty
Step #7 - "etcd_with_race": W1218 10:24:37.470715   30017 handlers.go:953] aramis{3321192773040586535}: Precert (or cert with invalid CT ext) submitted as cert chain: ["0\x82\x02\x840\x82\x02*\xa0\x03\x02\x01\x02\x02\x05\x00ޭ\xbe\xef0\n\x06\b*\x86H\xce=\x04\x03\x020r1\v0\t\x06\x03U\x04\x06\x13\x02GB1\x0f0\r\x06\x03U\x04\b\x13\x06London1\x0f0\r\x06\x03U\x04\a\x13\x06London1\x0f0\r\x06\x03U\x04\n\x13\x06Google1\f0\n\x06\x03U\x04\v\x13\x03Eng1\"0 \x06\x03U\x04\x03\x13\x19FakeIntermediateAuthority0\x1e\x17\r180329170511Z\x17\r241219102331Z0V1\v0\t\x06\x03U\x04\x06\x13\x02GB1\x0f0\r\x06\x03U\x04\b\f\x06London1\x0f0\r\x06\x03U\x04\n\f\x06Google1\f0\n\x06\x03U\x04\v\f\x03Eng1\x170\x15\x06\x03U\x04\x03\f\x0eleaf01.csr.pem0Y0\x13\x06\a*\x86H\xce=\x02\x01\x06\b*\x86H\xce=\x03\x01\a\x03B\x00\x04\xeb7NRE\x9cFը\xb8\xc5\xedX\xb90)\xa6p\x8ai\xa0&\\\x9e/n\xb8k#l\x84\xe1F:\x986\x82D\xa5\x8a\x17\x8bA\x822\xf4-\xe0\b[~\a8R\xfcGV('\x9b\xed`\x8b\xac\xa3\x81\xc80\x81\xc50\x0f\x06\x03U\x1d\x0f\x01\x01\xff\x04\x05\x03\x03\a\xf9\x800\x81\x8b\x06\x03U\x1d\x0e\x04\x81\x83\x04\x81\x800\x8c\xf4\x82\x92V\xa3\xdc\xe8,_JźU\xe9\xe0ړ\x035\x16\xc2W\xe8df\x0e\xc7d\x7f>厀v\xb9\xb6%\xad\xd4\xfe\x92\x87\xd5\xc0e\x17\xdd\x01\r\xb0\xbfZ\xad\x1d^\xd38\xa3\x8bk^\xaf\xff\x1aU\nv\x8a)\x1c\x84\xac\x85\x0e\xd1V\xe7\x1e\x97\x87\xf7E\xfb\xe6\x9a37\x86\xa1G\xbb\xaf41u\xf7G\xa4\x93\x83\xc4\xdeY\x92\x06\x14\xbf >hMZ\xae\xa6\xf3\u07b2^\\s\xc5\"\xba\xe8_\x030\x0f\x06\x03U\x1d#\x04\b0\x06\x80\x04\x05\x06\a\b0\x13\x06\n+\x06\x01\x04\x01\xd6y\x02\x04\x03\x01\x01\xff\x04\x02\x05\x000\n\x06\b*\x86H\xce=\x04\x03\x02\x03H\x000E\x02 \x04DA\x93\x1d\xb6\xb7\xad\xf71\xf8\xec\xcd$\rP\xb3\xef\xed\xbe\xf6Z\xa9k\xf8\xc7\xe3\xb9/w\x9f\xef\x02!\x00\x91\x90\x9c\xe6w\nDyԀ3\xb8\x01\xd6\x11\n\x90\f\xc3\x7f\xcc8\xad\x93\xa0=]\x98\xc1\x0f\xd3\xd8" "0\x82\x02<0\x82\x01\xe1\xa0\x03\x02\x01\x02\x02\x04BBBB0\n\x06\b*\x86H\xce=\x04\x03\x020q1\v0\t\x06\x03U\x04\x06\x13\x02GB1\x0f0\r\x06\x03U\x04\b\x13\x06London1\x0f0\r\x06\x03U\x04\a\x13\x06London1\x0f0\r\x06\x03U\x04\n\x13\x06Google1\f0\n\x06\x03U\x04\v\x13\x03Eng1!0\x1f\x06\x03U\x04\x03\x13\x18FakeCertificateAuthority0\x1e\x17\r180329170511Z\x17\r280205170511Z0r1\v0\t\x06\x03U\x04\x06\x13\x02GB1\x0f0\r\x06\x03U\x04\b\x13\x06London1\x0f0\r\x06\x03U\x04\a\x13\x06London1\x0f0\r\x06\x03U\x04\n\x13\x06Google1\f0\n\x06\x03U\x04\v\x13\x03Eng1\"0 \x06\x03U\x04\x03\x13\x19FakeIntermediateAuthority0Y0\x13\x06\a*\x86H\xce=\x02\x01\x06\b*\x86H\xce=\x03\x01\a\x03B\x00\x04\xf1\xbf-\xe8\x8cf@\xe3\xa8\xd1T\xe0BI\x02\xcb\xddG\b\x85\xc2gAL\xeb\xf7\x87͍\xa3\t\xc8\x18\xcc.0S\x162\xaa՜\bs\xc6v\xfa\xfa:8\xe945\x9cQ\xd1\xee\x12\x81]\x98_]]\xa3f0d0\r\x06\x03U\x1d\x0e\x04\x06\x04\x04\x05\x06\a\b0\x0f\x06\x03U\x1d#\x04\b0\x06\x80\x04\x01\x02\x03\x040\x12\x06\x03U\x1d\x13\x01\x01\xff\x04\b0\x06\x01\x01\xff\x02\x01\x000\x0f\x06\x03U\x1d\x0f\x01\x01\xff\x04\x05\x03\x03\a\xff\x800\x1d\x06\x03U\x1d%\x04\x160\x14\x06\b+\x06\x01\x05\x05\a\x03\x01\x06\b+\x06\x01\x05\x05\a\x03\x020\n\x06\b*\x86H\xce=\x04\x03\x02\x03I\x000F\x02!\x00\x95\xbfH\xb3\xc7k9\xbd\x8e\x97k\xbfK&\u07b5\x82\bE\xd1D(\x03P\xaa\nش\"\xf7\xa1\xe0\x02!\x00\xfbd\x18\xc8\xc08\x12\xaa\x9c^\xd9.\xcar\xb2Ɔ\xe8\xe0\x8by\xb4+\xcfw3\xeca߰\xc6\xdc"]
Step #7 - "etcd_with_race": W1218 10:24:37.471007   30017 handlers.go:206] aramis{3321192773040586535}: AddChain handler error: failed to verify add-chain contents: cert / precert mismatch: bool
Step #8 - "with_pkcs11_and_race": W1218 10:24:37.483275   31683 handlers.go:206] aramis{7219511787988393522}: AddPreChain handler error: failed to verify add-chain contents: chain failed to verify: asn1: structure error: tags don't match (16 vs {class:0 tag:0 length:643 isCompound:false}) {optional:false explicit:false application:false private:false defaultValue:<nil> tag:<nil> stringType:0 timeType:0 set:false omitEmpty:false lax:true name:} certificate @4
Step #7 - "etcd_with_race": W1218 10:24:37.537649   30017 handlers.go:206] aramis{3321192773040586535}: AddPreChain handler error: failed to verify add-chain contents: chain failed to verify: asn1: structure error: tags don't match (16 vs {class:0 tag:0 length:645 isCompound:false}) {optional:false explicit:false application:false private:false defaultValue:<nil> tag:<nil> stringType:0 timeType:0 set:false omitEmpty:false lax:true name:} certificate @4
Step #5 - "race_detection": Retry kill -INT  30403
Step #7 - "etcd_with_race": W1218 10:24:37.729772   30017 handlers.go:951] aramis{3321192773040586535}: Cert (or precert with invalid CT ext) submitted as precert chain: ["0\x82\x02o0\x82\x02\x15\xa0\x03\x02\x01\x02\x02\x05\x00ޭ\xbe\xef0\n\x06\b*\x86H\xce=\x04\x03\x020r1\v0\t\x06\x03U\x04\x06\x13\x02GB1\x0f0\r\x06\x03U\x04\b\x13\x06London1\x0f0\r\x06\x03U\x04\a\x13\x06London1\x0f0\r\x06\x03U\x04\n\x13\x06Google1\f0\n\x06\x03U\x04\v\x13\x03Eng1\"0 \x06\x03U\x04\x03\x13\x19FakeIntermediateAuthority0\x1e\x17\r180329170511Z\x17\r241219102331Z0V1\v0\t\x06\x03U\x04\x06\x13\x02GB1\x0f0\r\x06\x03U\x04\b\f\x06London1\x0f0\r\x06\x03U\x04\n\f\x06Google1\f0\n\x06\x03U\x04\v\f\x03Eng1\x170\x15\x06\x03U\x04\x03\f\x0eleaf01.csr.pem0Y0\x13\x06\a*\x86H\xce=\x02\x01\x06\b*\x86H\xce=\x03\x01\a\x03B\x00\x04\xeb7NRE\x9cFը\xb8\xc5\xedX\xb90)\xa6p\x8ai\xa0&\\\x9e/n\xb8k#l\x84\xe1F:\x986\x82D\xa5\x8a\x17\x8bA\x822\xf4-\xe0\b[~\a8R\xfcGV('\x9b\xed`\x8b\xac\xa3\x81\xb30\x81\xb00\x0f\x06\x03U\x1d\x0f\x01\x01\xff\x04\x05\x03\x03\a\xf9\x800\x81\x8b\x06\x03U\x1d\x0e\x04\x81\x83\x04\x81\x80\xc3*\x18\x83\x8a\x97Oxg<2Z\x13\xa5׀\xdfS\f\xff\xa5\xd5I&\xbd>y\x8b-$\xfb\xb3\xf4\xb0r\x1e\xe4ʝ\x12F\x10IWmѧP\x19\xe4I\x94v\xbb\xfd\x1b\xd8\xe7\x0e\x96\xf7i}%\x8b\x92\xa0\x1d\xc1\xd0֧PH\xf6\x95\xe3\x06;^&U\xc2u\xbc\x8bu1\x92g\xf7\x14\xaf\v\xbdn^\x02}\x9d\x9doD\xe85Aʓs\n/0\aT~\xe6#\xb9\xea\xf0\x16\nd\u0083\xdcQo0\x0f\x06\x03U\x1d#\x04\b0\x06\x80\x04\x05\x06\a\b0\n\x06\b*\x86H\xce=\x04\x03\x02\x03H\x000E\x02!\x00\xff\xa1]&\x1d\xe2\x96\x19eG\xfd\xeb\x9e\xe5\xe5w\x0e\xcc=xJ4\xa9\xbc&ٛX\b\xb7Sc\x02 \x16_\xd1\xcct\x96\xa5#\xa4\x04cmG\xbe\xaaؚ\xea<\x98\x1b\x85\xf8_\xa6?\xad\xed\x02\xf7U\xa2" "0\x82\x02<0\x82\x01\xe1\xa0\x03\x02\x01\x02\x02\x04BBBB0\n\x06\b*\x86H\xce=\x04\x03\x020q1\v0\t\x06\x03U\x04\x06\x13\x02GB1\x0f0\r\x06\x03U\x04\b\x13\x06London1\x0f0\r\x06\x03U\x04\a\x13\x06London1\x0f0\r\x06\x03U\x04\n\x13\x06Google1\f0\n\x06\x03U\x04\v\x13\x03Eng1!0\x1f\x06\x03U\x04\x03\x13\x18FakeCertificateAuthority0\x1e\x17\r180329170511Z\x17\r280205170511Z0r1\v0\t\x06\x03U\x04\x06\x13\x02GB1\x0f0\r\x06\x03U\x04\b\x13\x06London1\x0f0\r\x06\x03U\x04\a\x13\x06London1\x0f0\r\x06\x03U\x04\n\x13\x06Google1\f0\n\x06\x03U\x04\v\x13\x03Eng1\"0 \x06\x03U\x04\x03\x13\x19FakeIntermediateAuthority0Y0\x13\x06\a*\x86H\xce=\x02\x01\x06\b*\x86H\xce=\x03\x01\a\x03B\x00\x04\xf1\xbf-\xe8\x8cf@\xe3\xa8\xd1T\xe0BI\x02\xcb\xddG\b\x85\xc2gAL\xeb\xf7\x87͍\xa3\t\xc8\x18\xcc.0S\x162\xaa՜\bs\xc6v\xfa\xfa:8\xe945\x9cQ\xd1\xee\x12\x81]\x98_]]\xa3f0d0\r\x06\x03U\x1d\x0e\x04\x06\x04\x04\x05\x06\a\b0\x0f\x06\x03U\x1d#\x04\b0\x06\x80\x04\x01\x02\x03\x040\x12\x06\x03U\x1d\x13\x01\x01\xff\x04\b0\x06\x01\x01\xff\x02\x01\x000\x0f\x06\x03U\x1d\x0f\x01\x01\xff\x04\x05\x03\x03\a\xff\x800\x1d\x06\x03U\x1d%\x04\x160\x14\x06\b+\x06\x01\x05\x05\a\x03\x01\x06\b+\x06\x01\x05\x05\a\x03\x020\n\x06\b*\x86H\xce=\x04\x03\x02\x03I\x000F\x02!\x00\x95\xbfH\xb3\xc7k9\xbd\x8e\x97k\xbfK&\u07b5\x82\bE\xd1D(\x03P\xaa\nش\"\xf7\xa1\xe0\x02!\x00\xfbd\x18\xc8\xc08\x12\xaa\x9c^\xd9.\xcar\xb2Ɔ\xe8\xe0\x8by\xb4+\xcfw3\xeca߰\xc6\xdc"]
Step #7 - "etcd_with_race": W1218 10:24:37.730052   30017 handlers.go:206] aramis{3321192773040586535}: AddPreChain handler error: failed to verify add-chain contents: cert / precert mismatch: bool
Step #7 - "etcd_with_race": I1218 10:24:37.843119   30063 hammer.go:1134] aramis: completed 1500 operations on log
Step #7 - "etcd_with_race": I1218 10:24:37.843215   30063 main.go:317] completed tests on all 3 logs:
Step #7 - "etcd_with_race": I1218 10:24:37.843254   30063 main.go:329]   no errors; done
Step #8 - "with_pkcs11_and_race": I1218 10:24:38.035625   31724 hammer.go:1122]     aramis: lastSTH.size=1554 ops: total=1283 invalid=154 errs=0 AddChain=566/566 AddPreChain=505/505 GetSTH=52/52 GetSTHConsistency=43/47 GetProofByHash=0/44 GetEntries=51/51 GetRoots=18/18
Step #8 - "with_pkcs11_and_race": W1218 10:24:38.201216   31683 handlers.go:206] aramis{7219511787988393522}: AddChain handler error: aramis{7219511787988393522}: failed to parse add-chain body: cert chain was empty
Step #8 - "with_pkcs11_and_race": W1218 10:24:38.223656   31683 handlers.go:206] aramis{7219511787988393522}: GetEntries handler error: bad range on get-entries request: start (-2) and end (10) parameters must be >= 0
Step #8 - "with_pkcs11_and_race": W1218 10:24:38.226690   31683 handlers.go:206] aramis{7219511787988393522}: AddPreChain handler error: failed to verify add-chain contents: chain failed to verify: x509: certificate signed by unknown authority
Step #8 - "with_pkcs11_and_race": W1218 10:24:38.281104   31683 handlers.go:206] aramis{7219511787988393522}: AddPreChain handler error: failed to verify add-chain contents: chain failed to verify: x509: certificate signed by unknown authority
Step #8 - "with_pkcs11_and_race": W1218 10:24:38.417666   31683 handlers.go:953] aramis{7219511787988393522}: Precert (or cert with invalid CT ext) submitted as cert chain: ["0\x82\x02\x840\x82\x02*\xa0\x03\x02\x01\x02\x02\x05\x00ޭ\xbe\xef0\n\x06\b*\x86H\xce=\x04\x03\x020r1\v0\t\x06\x03U\x04\x06\x13\x02GB1\x0f0\r\x06\x03U\x04\b\x13\x06London1\x0f0\r\x06\x03U\x04\a\x13\x06London1\x0f0\r\x06\x03U\x04\n\x13\x06Google1\f0\n\x06\x03U\x04\v\x13\x03Eng1\"0 \x06\x03U\x04\x03\x13\x19FakeIntermediateAuthority0\x1e\x17\r180329170511Z\x17\r241219102337Z0V1\v0\t\x06\x03U\x04\x06\x13\x02GB1\x0f0\r\x06\x03U\x04\b\f\x06London1\x0f0\r\x06\x03U\x04\n\f\x06Google1\f0\n\x06\x03U\x04\v\f\x03Eng1\x170\x15\x06\x03U\x04\x03\f\x0eleaf01.csr.pem0Y0\x13\x06\a*\x86H\xce=\x02\x01\x06\b*\x86H\xce=\x03\x01\a\x03B\x00\x04\xeb7NRE\x9cFը\xb8\xc5\xedX\xb90)\xa6p\x8ai\xa0&\\\x9e/n\xb8k#l\x84\xe1F:\x986\x82D\xa5\x8a\x17\x8bA\x822\xf4-\xe0\b[~\a8R\xfcGV('\x9b\xed`\x8b\xac\xa3\x81\xc80\x81\xc50\x0f\x06\x03U\x1d\x0f\x01\x01\xff\x04\x05\x03\x03\a\xf9\x800\x81\x8b\x06\x03U\x1d\x0e\x04\x81\x83\x04\x81\x80\x1f\x90\xc4p\xb8\aVh-c?2\x9e\x1d2\x81\xb7\xc2\t\xa3[3\x81J\x98G\xa3\xa2\x80\x81Ҵ\x1ca\x8c\xd7F/\xc0v\xd1\x1epJ\xa2\x82e3\x82\x8a\xdf\xfc1\xd0\xde\x14\xceЈ\x18\x0e\x1ftZ\xde\xef\x15\x00\\1\x80\x01~\x7f\xde\xfc?KG+\x1f\xba5n\x8cF\x84\t\xe0\xf8\xac-\xe7 /\xdd\xf8m렭^\\m#\xf4 \x90\xf0\x1eAD[\xe9Y\b\xe1\x1aT\x81\x8e\x1a\x03\"\xebo5\xce0\x0f\x06\x03U\x1d#\x04\b0\x06\x80\x04\x05\x06\a\b0\x13\x06\n+\x06\x01\x04\x01\xd6y\x02\x04\x03\x01\x01\xff\x04\x02\x05\x000\n\x06\b*\x86H\xce=\x04\x03\x02\x03H\x000E\x02!\x00\xf0\xe7_T\x03\x17\xaeb\xf2\xa3\xf8O\x85\x05\xe9JD\x9b\x87\xa3\f\x9c\"\x8eV*\x17\xc5\xdeĻ\xe2\x02 \r\xa1#\x94|\xe7E\x19@\xfbpte\xf2Q@\x956\x810\\\xbf\x88L\xd7\x10\xb2c'\xf7\xda\x14" "0\x82\x02<0\x82\x01\xe1\xa0\x03\x02\x01\x02\x02\x04BBBB0\n\x06\b*\x86H\xce=\x04\x03\x020q1\v0\t\x06\x03U\x04\x06\x13\x02GB1\x0f0\r\x06\x03U\x04\b\x13\x06London1\x0f0\r\x06\x03U\x04\a\x13\x06London1\x0f0\r\x06\x03U\x04\n\x13\x06Google1\f0\n\x06\x03U\x04\v\x13\x03Eng1!0\x1f\x06\x03U\x04\x03\x13\x18FakeCertificateAuthority0\x1e\x17\r180329170511Z\x17\r280205170511Z0r1\v0\t\x06\x03U\x04\x06\x13\x02GB1\x0f0\r\x06\x03U\x04\b\x13\x06London1\x0f0\r\x06\x03U\x04\a\x13\x06London1\x0f0\r\x06\x03U\x04\n\x13\x06Google1\f0\n\x06\x03U\x04\v\x13\x03Eng1\"0 \x06\x03U\x04\x03\x13\x19FakeIntermediateAuthority0Y0\x13\x06\a*\x86H\xce=\x02\x01\x06\b*\x86H\xce=\x03\x01\a\x03B\x00\x04\xf1\xbf-\xe8\x8cf@\xe3\xa8\xd1T\xe0BI\x02\xcb\xddG\b\x85\xc2gAL\xeb\xf7\x87͍\xa3\t\xc8\x18\xcc.0S\x162\xaa՜\bs\xc6v\xfa\xfa:8\xe945\x9cQ\xd1\xee\x12\x81]\x98_]]\xa3f0d0\r\x06\x03U\x1d\x0e\x04\x06\x04\x04\x05\x06\a\b0\x0f\x06\x03U\x1d#\x04\b0\x06\x80\x04\x01\x02\x03\x040\x12\x06\x03U\x1d\x13\x01\x01\xff\x04\b0\x06\x01\x01\xff\x02\x01\x000\x0f\x06\x03U\x1d\x0f\x01\x01\xff\x04\x05\x03\x03\a\xff\x800\x1d\x06\x03U\x1d%\x04\x160\x14\x06\b+\x06\x01\x05\x05\a\x03\x01\x06\b+\x06\x01\x05\x05\a\x03\x020\n\x06\b*\x86H\xce=\x04\x03\x02\x03I\x000F\x02!\x00\x95\xbfH\xb3\xc7k9\xbd\x8e\x97k\xbfK&\u07b5\x82\bE\xd1D(\x03P\xaa\nش\"\xf7\xa1\xe0\x02!\x00\xfbd\x18\xc8\xc08\x12\xaa\x9c^\xd9.\xcar\xb2Ɔ\xe8\xe0\x8by\xb4+\xcfw3\xeca߰\xc6\xdc"]
Step #8 - "with_pkcs11_and_race": W1218 10:24:38.418074   31683 handlers.go:206] aramis{7219511787988393522}: AddChain handler error: failed to verify add-chain contents: cert / precert mismatch: bool
Step #5 - "race_detection": Deleting  /tmp/ct-3729GV on exit
Step #7 - "etcd_with_race": Stopping CT HTTP servers (pids 30017)
Step #7 - "etcd_with_race": W1218 10:24:38.856541   30017 main.go:379] Signal received: interrupt
Step #7 - "etcd_with_race": I1218 10:24:38.856642   30017 main.go:349] Shutting down HTTP server...
Step #7 - "etcd_with_race": I1218 10:24:38.856828   30017 main.go:353] HTTP server shutdown
Finished Step #5 - "race_detection"
Step #8 - "with_pkcs11_and_race": W1218 10:24:39.135854   31683 handlers.go:951] aramis{7219511787988393522}: Cert (or precert with invalid CT ext) submitted as precert chain: ["0\x82\x02p0\x82\x02\x15\xa0\x03\x02\x01\x02\x02\x05\x00ޭ\xbe\xef0\n\x06\b*\x86H\xce=\x04\x03\x020r1\v0\t\x06\x03U\x04\x06\x13\x02GB1\x0f0\r\x06\x03U\x04\b\x13\x06London1\x0f0\r\x06\x03U\x04\a\x13\x06London1\x0f0\r\x06\x03U\x04\n\x13\x06Google1\f0\n\x06\x03U\x04\v\x13\x03Eng1\"0 \x06\x03U\x04\x03\x13\x19FakeIntermediateAuthority0\x1e\x17\r180329170511Z\x17\r241219102337Z0V1\v0\t\x06\x03U\x04\x06\x13\x02GB1\x0f0\r\x06\x03U\x04\b\f\x06London1\x0f0\r\x06\x03U\x04\n\f\x06Google1\f0\n\x06\x03U\x04\v\f\x03Eng1\x170\x15\x06\x03U\x04\x03\f\x0eleaf01.csr.pem0Y0\x13\x06\a*\x86H\xce=\x02\x01\x06\b*\x86H\xce=\x03\x01\a\x03B\x00\x04\xeb7NRE\x9cFը\xb8\xc5\xedX\xb90)\xa6p\x8ai\xa0&\\\x9e/n\xb8k#l\x84\xe1F:\x986\x82D\xa5\x8a\x17\x8bA\x822\xf4-\xe0\b[~\a8R\xfcGV('\x9b\xed`\x8b\xac\xa3\x81\xb30\x81\xb00\x0f\x06\x03U\x1d\x0f\x01\x01\xff\x04\x05\x03\x03\a\xf9\x800\x81\x8b\x06\x03U\x1d\x0e\x04\x81\x83\x04\x81\x80\\\xae\xe8\xee\xf3\x13\xfb\x9e\xf8}\x90?\x12\xe5\xd6\xf8yB\x89ߏ\xafL\x03\xb4\xa4\xf17\xa7\x8aJT\xfd\xab\xb3)\xbc\xe6\xa5ۜ\x9d\x8a\xa2\x93\a\xd6)y30\xffg\xb1\xa2\x0e\x91\xaaد5\xf5*#\xae>\xda\xe1\xdcJ?\bJ'\\-\x92\x0fG,\xceG\xf6\xb3\x89<Fv\xf3>S\xf3\xe5\x11\xba#I1\x92{9\np\x93\xad )\xab\\\xd1\xca\x15\x99M\x88L#wPH\x05\x9e\xc9\xe2\xad\xeew=0\x0f\x06\x03U\x1d#\x04\b0\x06\x80\x04\x05\x06\a\b0\n\x06\b*\x86H\xce=\x04\x03\x02\x03I\x000F\x02!\x00\x94s&ь\x11/k$\xaa\xedT\xd2\x14\xce\x01\x99B\xfc\xb9\x92)\xbdw\xa9\n\xa9ZW@<\x7f\x02!\x00\xe5\x06\xcbмG\xec\vsAx\xa9LXRQ\x144\a\xfd~\x86\x9d\xae\xf7Q\x19\xcc5(\xe3\x13" "0\x82\x02<0\x82\x01\xe1\xa0\x03\x02\x01\x02\x02\x04BBBB0\n\x06\b*\x86H\xce=\x04\x03\x020q1\v0\t\x06\x03U\x04\x06\x13\x02GB1\x0f0\r\x06\x03U\x04\b\x13\x06London1\x0f0\r\x06\x03U\x04\a\x13\x06London1\x0f0\r\x06\x03U\x04\n\x13\x06Google1\f0\n\x06\x03U\x04\v\x13\x03Eng1!0\x1f\x06\x03U\x04\x03\x13\x18FakeCertificateAuthority0\x1e\x17\r180329170511Z\x17\r280205170511Z0r1\v0\t\x06\x03U\x04\x06\x13\x02GB1\x0f0\r\x06\x03U\x04\b\x13\x06London1\x0f0\r\x06\x03U\x04\a\x13\x06London1\x0f0\r\x06\x03U\x04\n\x13\x06Google1\f0\n\x06\x03U\x04\v\x13\x03Eng1\"0 \x06\x03U\x04\x03\x13\x19FakeIntermediateAuthority0Y0\x13\x06\a*\x86H\xce=\x02\x01\x06\b*\x86H\xce=\x03\x01\a\x03B\x00\x04\xf1\xbf-\xe8\x8cf@\xe3\xa8\xd1T\xe0BI\x02\xcb\xddG\b\x85\xc2gAL\xeb\xf7\x87͍\xa3\t\xc8\x18\xcc.0S\x162\xaa՜\bs\xc6v\xfa\xfa:8\xe945\x9cQ\xd1\xee\x12\x81]\x98_]]\xa3f0d0\r\x06\x03U\x1d\x0e\x04\x06\x04\x04\x05\x06\a\b0\x0f\x06\x03U\x1d#\x04\b0\x06\x80\x04\x01\x02\x03\x040\x12\x06\x03U\x1d\x13\x01\x01\xff\x04\b0\x06\x01\x01\xff\x02\x01\x000\x0f\x06\x03U\x1d\x0f\x01\x01\xff\x04\x05\x03\x03\a\xff\x800\x1d\x06\x03U\x1d%\x04\x160\x14\x06\b+\x06\x01\x05\x05\a\x03\x01\x06\b+\x06\x01\x05\x05\a\x03\x020\n\x06\b*\x86H\xce=\x04\x03\x02\x03I\x000F\x02!\x00\x95\xbfH\xb3\xc7k9\xbd\x8e\x97k\xbfK&\u07b5\x82\bE\xd1D(\x03P\xaa\nش\"\xf7\xa1\xe0\x02!\x00\xfbd\x18\xc8\xc08\x12\xaa\x9c^\xd9.\xcar\xb2Ɔ\xe8\xe0\x8by\xb4+\xcfw3\xeca߰\xc6\xdc"]
Step #8 - "with_pkcs11_and_race": W1218 10:24:39.136133   31683 handlers.go:206] aramis{7219511787988393522}: AddPreChain handler error: failed to verify add-chain contents: cert / precert mismatch: bool
Step #8 - "with_pkcs11_and_race": W1218 10:24:39.173443   31683 handlers.go:206] aramis{7219511787988393522}: GetProofByHash handler error: get-proof-by-hash: invalid base64 hash: illegal base64 data at input byte 0
Step #8 - "with_pkcs11_and_race": W1218 10:24:39.358467   31683 handlers.go:206] aramis{7219511787988393522}: GetEntries handler error: bad range on get-entries request: start (-2) and end (10) parameters must be >= 0
Step #8 - "with_pkcs11_and_race": W1218 10:24:39.587388   31683 handlers.go:206] aramis{7219511787988393522}: AddPreChain handler error: aramis{7219511787988393522}: failed to parse add-chain body: cert chain was empty
Step #8 - "with_pkcs11_and_race": W1218 10:24:39.593921   31683 handlers.go:206] aramis{7219511787988393522}: AddChain handler error: aramis{7219511787988393522}: failed to parse add-chain body: cert chain was empty
Step #8 - "with_pkcs11_and_race": I1218 10:24:39.594302   31724 hammer.go:1134] aramis: completed 1500 operations on log
Step #8 - "with_pkcs11_and_race": I1218 10:24:39.594388   31724 main.go:317] completed tests on all 3 logs:
Step #8 - "with_pkcs11_and_race": I1218 10:24:39.594432   31724 main.go:329]   no errors; done
Step #7 - "etcd_with_race": Retry kill -INT  30017
Step #8 - "with_pkcs11_and_race": Stopping CT HTTP servers (pids 31683)
Step #8 - "with_pkcs11_and_race": W1218 10:24:40.607328   31683 main.go:379] Signal received: interrupt
Step #8 - "with_pkcs11_and_race": I1218 10:24:40.607413   31683 main.go:349] Shutting down HTTP server...
Step #8 - "with_pkcs11_and_race": I1218 10:24:40.607588   31683 main.go:353] HTTP server shutdown
Step #7 - "etcd_with_race": Deleting  /tmp/ct-znroBV on exit
Finished Step #7 - "etcd_with_race"
Step #8 - "with_pkcs11_and_race": Retry kill -INT  31683
Step #8 - "with_pkcs11_and_race": Deleting  /tmp/ct-Y2t5SQ on exit
Finished Step #8 - "with_pkcs11_and_race"
Starting Step #10 - "ci_complete"
Step #10 - "ci_complete": Already have image (with digest): gcr.io/trillian-opensource-ci/ct_testbase
Finished Step #10 - "ci_complete"
PUSH
DONE