Skip to content

fix: debug logging statements#1828

Merged
averikitsch merged 3 commits into
mainfrom
fix-logging
Nov 3, 2025
Merged

fix: debug logging statements#1828
averikitsch merged 3 commits into
mainfrom
fix-logging

Merge branch 'main' into fix-logging

8e7ee8b
Select commit
Loading
Failed to load commit list.
Google Cloud Build / integration-test-pr (toolbox-testing-438616) succeeded Nov 3, 2025 in 9m 6s

Summary

Build Information

Trigger integration-test-pr
Build 47f6650e-b9c0-4482-adfa-2a6f1697417a
Start 2025-11-03T11:16:07-08:00
Duration 6m55.663s
Status SUCCESS

Steps

Step Status Duration
install-dependencies SUCCESS 14.894s
compile-test-binary SUCCESS 57.995s
cloud-sql-pg SUCCESS 17.08s
alloydb SUCCESS 7.981s
alloydb-pg SUCCESS 18.232s
alloydb-ai-nl SUCCESS 14.392s
bigtable SUCCESS 25.643s
bigquery SUCCESS 5m36.025s
dataplex SUCCESS 2m18.761s
dataform SUCCESS 1m1.247s
postgres SUCCESS 20.631s
spanner SUCCESS 46.693s
neo4j SUCCESS 4.576s
cloud-sql-mssql SUCCESS 16.094s
cloud-sql-mysql SUCCESS 25.645s
mysql SUCCESS 26.166s
mssql SUCCESS 8.209s
http SUCCESS 5.06s
sqlite SUCCESS 4.678s
couchbase SUCCESS 33.392s
redis SUCCESS 6.189s
valkey SUCCESS 4.901s
oceanbase SUCCESS 10.987s
firestore SUCCESS 6.02s
looker SUCCESS 1m27.096s
cloud-sql SUCCESS 5.861s
tidb SUCCESS 7.259s
firebird SUCCESS 1m9.742s
clickhouse SUCCESS 8.971s
trino SUCCESS 8.531s
yugabytedb SUCCESS 11.796s
cassandra SUCCESS 12.399s
oracle SUCCESS 9.676s
serverless-spark SUCCESS 4.779s

Details

starting build "47f6650e-b9c0-4482-adfa-2a6f1697417a"

FETCHSOURCE
From https://github.com/googleapis/genai-toolbox
 * branch            8e7ee8b3cea416ba135797779bbcda3c8e8c017d -> FETCH_HEAD
HEAD is now at 8e7ee8b Merge branch 'main' into fix-logging
GitCommit:
8e7ee8b3cea416ba135797779bbcda3c8e8c017d
SETUPBUILD
BUILD
Starting Step #0 - "install-dependencies"
Step #0 - "install-dependencies": Pulling image: golang:1
Step #0 - "install-dependencies": 1: Pulling from library/golang
Step #0 - "install-dependencies": Digest: sha256:6bac879c5b77e0fc9c556a5ed8920e89dab1709bd510a854903509c828f67f96
Step #0 - "install-dependencies": Status: Downloaded newer image for golang:1
Step #0 - "install-dependencies": docker.io/library/golang:1
Step #0 - "install-dependencies": go: -d flag is deprecated. -d=true is a no-op
Step #0 - "install-dependencies": go: downloading golang.org/x/oauth2 v0.32.0
Step #0 - "install-dependencies": go: downloading google.golang.org/api v0.251.0
Step #0 - "install-dependencies": go: downloading github.com/goccy/go-yaml v1.18.0
Step #0 - "install-dependencies": go: downloading go.opentelemetry.io/otel/trace v1.38.0
Step #0 - "install-dependencies": go: downloading github.com/fsnotify/fsnotify v1.9.0
Step #0 - "install-dependencies": go: downloading github.com/spf13/cobra v1.10.1
Step #0 - "install-dependencies": go: downloading github.com/jackc/pgx/v5 v5.7.6
Step #0 - "install-dependencies": go: downloading cloud.google.com/go/bigquery v1.72.0
Step #0 - "install-dependencies": go: downloading github.com/google/uuid v1.6.0
Step #0 - "install-dependencies": go: downloading cloud.google.com/go/bigtable v1.40.1
Step #0 - "install-dependencies": go: downloading cloud.google.com/go/dataplex v1.27.1
Step #0 - "install-dependencies": go: downloading github.com/gocql/gocql v1.7.0
Step #0 - "install-dependencies": go: downloading github.com/redis/go-redis/v9 v9.16.0
Step #0 - "install-dependencies": go: downloading cloud.google.com/go/firestore v1.20.0
Step #0 - "install-dependencies": go: downloading cloud.google.com/go/cloudsqlconn v1.18.1
Step #0 - "install-dependencies": go: downloading github.com/ClickHouse/clickhouse-go/v2 v2.40.3
Step #0 - "install-dependencies": go: downloading github.com/microsoft/go-mssqldb v1.9.3
Step #0 - "install-dependencies": go: downloading github.com/sijms/go-ora/v2 v2.9.0
Step #0 - "install-dependencies": go: downloading github.com/GoogleCloudPlatform/opentelemetry-operations-go/exporter/metric v0.53.0
Step #0 - "install-dependencies": go: downloading cloud.google.com/go/geminidataanalytics v0.2.1
Step #0 - "install-dependencies": go: downloading go.mongodb.org/mongo-driver v1.17.4
Step #0 - "install-dependencies": go: downloading cloud.google.com/go/dataproc/v2 v2.15.0
Step #0 - "install-dependencies": go: downloading github.com/go-chi/chi/v5 v5.2.3
Step #0 - "install-dependencies": go: downloading github.com/go-playground/validator/v10 v10.28.0
Step #0 - "install-dependencies": go: downloading cloud.google.com/go/alloydbconn v1.15.5
Step #0 - "install-dependencies": go: downloading cloud.google.com/go/spanner v1.86.1
Step #0 - "install-dependencies": go: downloading github.com/go-sql-driver/mysql v1.9.3
Step #0 - "install-dependencies": go: downloading modernc.org/sqlite v1.39.1
Step #0 - "install-dependencies": go: downloading github.com/valkey-io/valkey-go v1.0.67
Step #0 - "install-dependencies": go: downloading github.com/yugabyte/pgx/v5 v5.5.3-yb-5
Step #0 - "install-dependencies": go: downloading github.com/trinodb/trino-go-client v0.329.0
Step #0 - "install-dependencies": go: downloading github.com/neo4j/neo4j-go-driver/v5 v5.28.4
Step #0 - "install-dependencies": go: downloading github.com/couchbase/gocb/v2 v2.11.1
Step #0 - "install-dependencies": go: downloading github.com/GoogleCloudPlatform/opentelemetry-operations-go/exporter/trace v1.29.0
Step #0 - "install-dependencies": go: downloading github.com/looker-open-source/sdk-codegen/go v0.25.18
Step #0 - "install-dependencies": go: downloading go.opentelemetry.io/otel v1.38.0
Step #0 - "install-dependencies": go: downloading github.com/cenkalti/backoff/v5 v5.0.3
Step #0 - "install-dependencies": go: downloading github.com/couchbase/tools-common/http v1.0.9
Step #0 - "install-dependencies": go: downloading go.opentelemetry.io/contrib/propagators/autoprop v0.62.0
Step #0 - "install-dependencies": go: downloading github.com/go-chi/httplog/v2 v2.1.1
Step #0 - "install-dependencies": go: downloading github.com/thlib/go-timezone-local v0.0.7
Step #0 - "install-dependencies": go: downloading github.com/go-chi/render v1.0.3
Step #0 - "install-dependencies": go: downloading google.golang.org/genproto v0.0.0-20251022142026-3a174f9686a8
Step #0 - "install-dependencies": go: downloading go.opentelemetry.io/otel/exporters/otlp/otlpmetric/otlpmetrichttp v1.37.0
Step #0 - "install-dependencies": go: downloading github.com/json-iterator/go v1.1.12
Step #0 - "install-dependencies": go: downloading go.opentelemetry.io/otel/exporters/otlp/otlptrace/otlptracehttp v1.37.0
Step #0 - "install-dependencies": go: downloading google.golang.org/protobuf v1.36.10
Step #0 - "install-dependencies": go: downloading go.opentelemetry.io/otel/metric v1.38.0
Step #0 - "install-dependencies": go: downloading go.opentelemetry.io/otel/sdk/metric v1.37.0
Step #0 - "install-dependencies": go: downloading go.opentelemetry.io/otel/sdk v1.37.0
Step #0 - "install-dependencies": go: downloading cloud.google.com/go v0.121.6
Step #0 - "install-dependencies": go: downloading go.opentelemetry.io/otel/exporters/otlp/otlptrace v1.37.0
Step #0 - "install-dependencies": go: downloading golang.org/x/sys v0.36.0
Step #0 - "install-dependencies": go: downloading github.com/google/go-cmp v0.7.0
Step #0 - "install-dependencies": go: downloading cloud.google.com/go/compute/metadata v0.9.0
Step #0 - "install-dependencies": go: downloading cloud.google.com/go/monitoring v1.24.3
Step #0 - "install-dependencies": go: downloading github.com/GoogleCloudPlatform/opentelemetry-operations-go/internal/resourcemapping v0.53.0
Step #0 - "install-dependencies": go: downloading github.com/googleapis/gax-go/v2 v2.15.0
Step #0 - "install-dependencies": go: downloading google.golang.org/genproto/googleapis/api v0.0.0-20251014184007-4626949a642f
Step #0 - "install-dependencies": go: downloading google.golang.org/grpc v1.75.1
Step #0 - "install-dependencies": go: downloading github.com/ClickHouse/ch-go v0.68.0
Step #0 - "install-dependencies": go: downloading github.com/andybalholm/brotli v1.2.0
Step #0 - "install-dependencies": go: downloading cloud.google.com/go/trace v1.11.7
Step #0 - "install-dependencies": go: downloading google.golang.org/genproto/googleapis/rpc v0.0.0-20251014184007-4626949a642f
Step #0 - "install-dependencies": go: downloading github.com/ajg/form v1.5.1
Step #0 - "install-dependencies": go: downloading github.com/inconshreveable/mousetrap v1.1.0
Step #0 - "install-dependencies": go: downloading github.com/spf13/pflag v1.0.9
Step #0 - "install-dependencies": go: downloading go.opentelemetry.io/contrib/propagators/aws v1.37.0
Step #0 - "install-dependencies": go: downloading go.opentelemetry.io/contrib/propagators/b3 v1.37.0
Step #0 - "install-dependencies": go: downloading go.opentelemetry.io/contrib/propagators/jaeger v1.37.0
Step #0 - "install-dependencies": go: downloading go.opentelemetry.io/contrib/propagators/ot v1.37.0
Step #0 - "install-dependencies": go: downloading github.com/couchbase/tools-common/errors v1.0.0
Step #0 - "install-dependencies": go: downloading github.com/youmark/pkcs8 v0.0.0-20240726163527-a2c0da244d78
Step #0 - "install-dependencies": go: downloading golang.org/x/crypto v0.42.0
Step #0 - "install-dependencies": go: downloading github.com/jcmturner/gokrb5/v8 v8.4.4
Step #0 - "install-dependencies": go: downloading github.com/klauspost/compress v1.18.0
Step #0 - "install-dependencies": go: downloading github.com/pierrec/lz4 v2.6.1+incompatible
Step #0 - "install-dependencies": go: downloading filippo.io/edwards25519 v1.1.0
Step #0 - "install-dependencies": go: downloading gopkg.in/ini.v1 v1.67.0
Step #0 - "install-dependencies": go: downloading github.com/modern-go/concurrent v0.0.0-20180306012644-bacd9c7ef1dd
Step #0 - "install-dependencies": go: downloading github.com/modern-go/reflect2 v1.0.2
Step #0 - "install-dependencies": go: downloading cloud.google.com/go/iam v1.5.3
Step #0 - "install-dependencies": go: downloading github.com/apache/arrow/go/v15 v15.0.2
Step #0 - "install-dependencies": go: downloading golang.org/x/sync v0.17.0
Step #0 - "install-dependencies": go: downloading cloud.google.com/go/longrunning v0.7.0
Step #0 - "install-dependencies": go: downloading github.com/golang/snappy v1.0.0
Step #0 - "install-dependencies": go: downloading github.com/hailocab/go-hostpool v0.0.0-20160125115350-e80d13ce29ed
Step #0 - "install-dependencies": go: downloading gopkg.in/inf.v0 v0.9.1
Step #0 - "install-dependencies": go: downloading github.com/gabriel-vasile/mimetype v1.4.10
Step #0 - "install-dependencies": go: downloading github.com/go-playground/universal-translator v0.18.1
Step #0 - "install-dependencies": go: downloading github.com/leodido/go-urn v1.4.0
Step #0 - "install-dependencies": go: downloading golang.org/x/text v0.29.0
Step #0 - "install-dependencies": go: downloading cloud.google.com/go/alloydb v1.18.0
Step #0 - "install-dependencies": go: downloading golang.org/x/net v0.44.0
Step #0 - "install-dependencies": go: downloading github.com/paulmach/orb v0.11.1
Step #0 - "install-dependencies": go: downloading github.com/shopspring/decimal v1.4.0
Step #0 - "install-dependencies": go: downloading go.yaml.in/yaml/v3 v3.0.4
Step #0 - "install-dependencies": go: downloading cloud.google.com/go/auth v0.16.5
Step #0 - "install-dependencies": go: downloading cloud.google.com/go/auth/oauth2adapt v0.2.8
Step #0 - "install-dependencies": go: downloading go.opentelemetry.io/contrib/detectors/gcp v1.36.0
Step #0 - "install-dependencies": go: downloading go.uber.org/multierr v1.11.0
Step #0 - "install-dependencies": go: downloading github.com/couchbase/gocbcore/v10 v10.8.1
Step #0 - "install-dependencies": go: downloading github.com/couchbase/gocbcoreps v0.1.4
Step #0 - "install-dependencies": go: downloading github.com/couchbase/goprotostellar v1.0.2
Step #0 - "install-dependencies": go: downloading github.com/couchbaselabs/gocbconnstr/v2 v2.0.0
Step #0 - "install-dependencies": go: downloading go.uber.org/zap v1.27.0
Step #0 - "install-dependencies": go: downloading golang.org/x/time v0.13.0
Step #0 - "install-dependencies": go: downloading github.com/golang-sql/civil v0.0.0-20220223132316-b832511892a9
Step #0 - "install-dependencies": go: downloading github.com/golang-sql/sqlexp v0.1.0
Step #0 - "install-dependencies": go: downloading github.com/dgryski/go-rendezvous v0.0.0-20200823014737-9f7001d12a5f
Step #0 - "install-dependencies": go: downloading github.com/cespare/xxhash/v2 v2.3.0
Step #0 - "install-dependencies": go: downloading github.com/jackc/puddle/v2 v2.2.2
Step #0 - "install-dependencies": go: downloading github.com/GoogleCloudPlatform/grpc-gcp-go/grpcgcp v1.5.3
Step #0 - "install-dependencies": go: downloading go.opencensus.io v0.24.0
Step #0 - "install-dependencies": go: downloading github.com/jcmturner/dnsutils/v2 v2.0.0
Step #0 - "install-dependencies": go: downloading github.com/jcmturner/gofork v1.7.6
Step #0 - "install-dependencies": go: downloading github.com/jcmturner/goidentity/v6 v6.0.1
Step #0 - "install-dependencies": go: downloading github.com/go-faster/city v1.0.1
Step #0 - "install-dependencies": go: downloading github.com/go-faster/errors v0.7.1
Step #0 - "install-dependencies": go: downloading github.com/pierrec/lz4/v4 v4.1.22
Step #0 - "install-dependencies": go: downloading github.com/segmentio/asm v1.2.0
Step #0 - "install-dependencies": go: downloading github.com/go-playground/locales v0.14.1
Step #0 - "install-dependencies": go: downloading github.com/go-logr/logr v1.4.3
Step #0 - "install-dependencies": go: downloading go.opentelemetry.io/proto/otlp v1.7.0
Step #0 - "install-dependencies": go: downloading github.com/GoogleCloudPlatform/opentelemetry-operations-go/detectors/gcp v1.29.0
Step #0 - "install-dependencies": go: downloading github.com/grpc-ecosystem/go-grpc-middleware v1.4.0
Step #0 - "install-dependencies": go: downloading go.opentelemetry.io/contrib/instrumentation/google.golang.org/grpc/otelgrpc v0.62.0
Step #0 - "install-dependencies": go: downloading go.opentelemetry.io/contrib/instrumentation/net/http/otelhttp v0.62.0
Step #0 - "install-dependencies": go: downloading github.com/jackc/pgpassfile v1.0.0
Step #0 - "install-dependencies": go: downloading github.com/jackc/pgservicefile v0.0.0-20240606120523-5a60cdf6a761
Step #0 - "install-dependencies": go: downloading github.com/hashicorp/go-uuid v1.0.3
Step #0 - "install-dependencies": go: downloading github.com/go-logr/stdr v1.2.2
Step #0 - "install-dependencies": go: downloading go.opentelemetry.io/auto/sdk v1.1.0
Step #0 - "install-dependencies": go: downloading github.com/gorilla/websocket v1.5.3
Step #0 - "install-dependencies": go: downloading github.com/google/s2a-go v0.1.9
Step #0 - "install-dependencies": go: downloading github.com/googleapis/enterprise-certificate-proxy v0.3.6
Step #0 - "install-dependencies": go: downloading github.com/grpc-ecosystem/grpc-gateway/v2 v2.27.1
Step #0 - "install-dependencies": go: downloading github.com/jcmturner/aescts/v2 v2.0.0
Step #0 - "install-dependencies": go: downloading github.com/envoyproxy/go-control-plane/envoy v1.32.4
Step #0 - "install-dependencies": go: downloading github.com/jcmturner/rpc/v2 v2.0.3
Step #0 - "install-dependencies": go: downloading github.com/felixge/httpsnoop v1.0.4
Step #0 - "install-dependencies": go: downloading github.com/spiffe/go-spiffe/v2 v2.5.0
Step #0 - "install-dependencies": go: downloading github.com/golang/groupcache v0.0.0-20241129210726-2c02b8208cf8
Step #0 - "install-dependencies": go: downloading github.com/cncf/xds/go v0.0.0-20250501225837-2ac532fd4443
Step #0 - "install-dependencies": go: downloading github.com/xdg-go/scram v1.1.2
Step #0 - "install-dependencies": go: downloading github.com/xdg-go/stringprep v1.0.4
Step #0 - "install-dependencies": go: downloading github.com/montanaflynn/stats v0.7.1
Step #0 - "install-dependencies": go: downloading cel.dev/expr v0.24.0
Step #0 - "install-dependencies": go: downloading github.com/envoyproxy/protoc-gen-validate v1.2.1
Step #0 - "install-dependencies": go: downloading github.com/go-jose/go-jose/v4 v4.1.1
Step #0 - "install-dependencies": go: downloading github.com/zeebo/errs v1.4.0
Step #0 - "install-dependencies": go: downloading golang.org/x/tools v0.36.0
Step #0 - "install-dependencies": go: downloading golang.org/x/xerrors v0.0.0-20240903120638-7835f813f4da
Step #0 - "install-dependencies": go: downloading golang.org/x/exp v0.0.0-20250620022241-b7579e27df2b
Step #0 - "install-dependencies": go: downloading github.com/google/flatbuffers v25.2.10+incompatible
Step #0 - "install-dependencies": go: downloading github.com/goccy/go-json v0.10.5
Step #0 - "install-dependencies": go: downloading github.com/zeebo/xxh3 v1.0.2
Step #0 - "install-dependencies": go: downloading github.com/xdg-go/pbkdf2 v1.0.0
Step #0 - "install-dependencies": go: downloading github.com/klauspost/cpuid/v2 v2.2.11
Step #0 - "install-dependencies": go: downloading github.com/planetscale/vtprotobuf v0.6.1-0.20240319094008-0393e58bdf10
Step #0 - "install-dependencies": go: downloading golang.org/x/mod v0.27.0
Step #0 - "install-dependencies": go: downloading modernc.org/libc v1.66.10
Step #0 - "install-dependencies": go: downloading modernc.org/memory v1.11.0
Step #0 - "install-dependencies": go: downloading github.com/dustin/go-humanize v1.0.1
Step #0 - "install-dependencies": go: downloading github.com/ncruces/go-strftime v0.1.9
Step #0 - "install-dependencies": go: downloading github.com/mattn/go-isatty v0.0.20
Step #0 - "install-dependencies": go: downloading modernc.org/mathutil v1.7.1
Step #0 - "install-dependencies": go: downloading github.com/remyoudompheng/bigfft v0.0.0-20230129092748-24d4a6f8daec
Finished Step #0 - "install-dependencies"
Starting Step #1 - "compile-test-binary"
Step #1 - "compile-test-binary": Already have image (with digest): golang:1
Step #1 - "compile-test-binary": go: downloading github.com/nakagami/firebirdsql v0.9.15
Step #1 - "compile-test-binary": go: downloading github.com/kardianos/osext v0.0.0-20190222173326-2bc1f35cddc0
Step #1 - "compile-test-binary": go: downloading github.com/nakagami/chacha20 v0.1.0
Step #1 - "compile-test-binary": go: downloading gitlab.com/nyarla/go-crypt v0.0.0-20160106005555-d9a5dc2b789b
Step #1 - "compile-test-binary": ?   	github.com/googleapis/genai-toolbox/tests	[no test files]
Finished Step #1 - "compile-test-binary"
Starting Step #33 - "serverless-spark"
Starting Step #14 - "cloud-sql-mysql"
Starting Step #15 - "mysql"
Starting Step #22 - "oceanbase"
Starting Step #21 - "valkey"
Starting Step #20 - "redis"
Starting Step #19 - "couchbase"
Starting Step #18 - "sqlite"
Starting Step #17 - "http"
Starting Step #16 - "mssql"
Starting Step #27 - "firebird"
Step #33 - "serverless-spark": Already have image (with digest): golang:1
Starting Step #10 - "postgres"
Starting Step #2 - "cloud-sql-pg"
Starting Step #4 - "alloydb-pg"
Starting Step #31 - "cassandra"
Starting Step #3 - "alloydb"
Step #14 - "cloud-sql-mysql": Already have image (with digest): golang:1
Starting Step #32 - "oracle"
Step #19 - "couchbase": Already have image (with digest): golang:1
Step #21 - "valkey": Already have image (with digest): golang:1
Step #22 - "oceanbase": Already have image (with digest): golang:1
Starting Step #26 - "tidb"
Starting Step #25 - "cloud-sql"
Starting Step #29 - "trino"
Step #16 - "mssql": Already have image (with digest): golang:1
Step #20 - "redis": Already have image (with digest): golang:1
Starting Step #28 - "clickhouse"
Step #15 - "mysql": Already have image (with digest): golang:1
Starting Step #12 - "neo4j"
Step #17 - "http": Already have image (with digest): golang:1
Starting Step #30 - "yugabytedb"
Starting Step #9 - "dataform"
Starting Step #24 - "looker"
Starting Step #8 - "dataplex"
Starting Step #6 - "bigtable"
Step #18 - "sqlite": Already have image (with digest): golang:1
Starting Step #23 - "firestore"
Starting Step #7 - "bigquery"
Starting Step #11 - "spanner"
Starting Step #5 - "alloydb-ai-nl"
Starting Step #13 - "cloud-sql-mssql"
Step #2 - "cloud-sql-pg": Already have image (with digest): golang:1
Step #4 - "alloydb-pg": Already have image (with digest): golang:1
Step #30 - "yugabytedb": Already have image (with digest): golang:1
Step #27 - "firebird": Already have image (with digest): golang:1
Step #28 - "clickhouse": Already have image (with digest): golang:1
Step #31 - "cassandra": Already have image (with digest): golang:1
Step #32 - "oracle": Already have image (with digest): golang:1
Step #6 - "bigtable": Already have image (with digest): golang:1
Step #10 - "postgres": Already have image (with digest): golang:1
Step #3 - "alloydb": Already have image (with digest): golang:1
Step #23 - "firestore": Already have image (with digest): golang:1
Step #9 - "dataform": Already have image (with digest): golang:1
Step #7 - "bigquery": Already have image (with digest): golang:1
Step #25 - "cloud-sql": Already have image (with digest): golang:1
Step #24 - "looker": Already have image (with digest): golang:1
Step #11 - "spanner": Already have image (with digest): golang:1
Step #29 - "trino": Already have image (with digest): golang:1
Step #5 - "alloydb-ai-nl": Already have image (with digest): golang:1
Step #12 - "neo4j": Already have image (with digest): golang:1
Step #8 - "dataplex": Already have image (with digest): golang:1
Step #13 - "cloud-sql-mssql": Already have image (with digest): golang:1
Step #26 - "tidb": Already have image (with digest): golang:1
Step #11 - "spanner": === RUN   TestSpannerToolEndpoints
Step #33 - "serverless-spark": === RUN   TestServerlessSparkToolEndpoints
Step #33 - "serverless-spark": === RUN   TestServerlessSparkToolEndpoints/list-batches_one_page
Step #33 - "serverless-spark": 2025-11-03T19:17:27.742092954Z INFO Response: 200 OK service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/api/tool/list-batches/invoke" method: "POST" path: "/api/tool/list-batches/invoke" remoteIP: "127.0.0.1:39160" proto: "HTTP/1.1" requestID: "0c0b956b8b3a/gTGZjgPE1d-000001"} httpResponse: {status: 200 bytes: 697 elapsed: 77.846712} 
Step #33 - "serverless-spark": === RUN   TestServerlessSparkToolEndpoints/list-batches_two_pages
Step #33 - "serverless-spark": 2025-11-03T19:17:27.806844154Z INFO Response: 200 OK service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/api/tool/list-batches/invoke" method: "POST" path: "/api/tool/list-batches/invoke" remoteIP: "127.0.0.1:39160" proto: "HTTP/1.1" requestID: "0c0b956b8b3a/gTGZjgPE1d-000002"} httpResponse: {status: 200 bytes: 428 elapsed: 63.745210} 
Step #12 - "neo4j": === RUN   TestNeo4jToolEndpoints
Step #12 - "neo4j": === RUN   TestNeo4jToolEndpoints/get_my-simple-cypher-tool
Step #33 - "serverless-spark": 2025-11-03T19:17:27.8936842Z INFO Response: 200 OK service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/api/tool/list-batches/invoke" method: "POST" path: "/api/tool/list-batches/invoke" remoteIP: "127.0.0.1:39160" proto: "HTTP/1.1" requestID: "0c0b956b8b3a/gTGZjgPE1d-000003"} httpResponse: {status: 200 bytes: 389 elapsed: 86.011224} 
Step #33 - "serverless-spark": === RUN   TestServerlessSparkToolEndpoints/list-batches_20_batches
Step #12 - "neo4j": 2025-11-03T19:17:27.895468317Z INFO Response: 200 OK service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/api/tool/my-simple-cypher-tool/" method: "GET" path: "/api/tool/my-simple-cypher-tool/" remoteIP: "127.0.0.1:39172" proto: "HTTP/1.1" requestID: "a34930c37a4b/a1OKv1w8ur-000001"} httpResponse: {status: 200 bytes: 175 elapsed: 0.654835} 
Step #12 - "neo4j": === RUN   TestNeo4jToolEndpoints/get_my-simple-execute-cypher-tool
Step #12 - "neo4j": 2025-11-03T19:17:27.896535474Z INFO Response: 200 OK service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/api/tool/my-simple-execute-cypher-tool/" method: "GET" path: "/api/tool/my-simple-execute-cypher-tool/" remoteIP: "127.0.0.1:39172" proto: "HTTP/1.1" requestID: "a34930c37a4b/a1OKv1w8ur-000002"} httpResponse: {status: 200 bytes: 517 elapsed: 0.160936} 
Step #12 - "neo4j": === RUN   TestNeo4jToolEndpoints/get_my-schema-tool
Step #12 - "neo4j": 2025-11-03T19:17:27.897629123Z INFO Response: 200 OK service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/api/tool/my-schema-tool/" method: "GET" path: "/api/tool/my-schema-tool/" remoteIP: "127.0.0.1:39172" proto: "HTTP/1.1" requestID: "a34930c37a4b/a1OKv1w8ur-000003"} httpResponse: {status: 200 bytes: 154 elapsed: 0.142114} 
Step #12 - "neo4j": === RUN   TestNeo4jToolEndpoints/get_my-schema-tool-with-cache
Step #12 - "neo4j": 2025-11-03T19:17:27.898680297Z INFO Response: 200 OK service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/api/tool/my-schema-tool-with-cache/" method: "GET" path: "/api/tool/my-schema-tool-with-cache/" remoteIP: "127.0.0.1:39172" proto: "HTTP/1.1" requestID: "a34930c37a4b/a1OKv1w8ur-000004"} httpResponse: {status: 200 bytes: 179 elapsed: 0.125252} 
Step #12 - "neo4j": === RUN   TestNeo4jToolEndpoints/invoke_my-simple-cypher-tool
Step #9 - "dataform": Get:1 http://deb.debian.org/debian trixie InRelease [140 kB]
Step #12 - "neo4j": 2025-11-03T19:17:27.919244902Z INFO Response: 200 OK service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/api/tool/my-simple-cypher-tool/invoke" method: "POST" path: "/api/tool/my-simple-cypher-tool/invoke" remoteIP: "127.0.0.1:39172" proto: "HTTP/1.1" requestID: "a34930c37a4b/a1OKv1w8ur-000005"} httpResponse: {status: 200 bytes: 25 elapsed: 19.613050} 
Step #12 - "neo4j": === RUN   TestNeo4jToolEndpoints/invoke_my-simple-execute-cypher-tool
Step #12 - "neo4j": 2025-11-03T19:17:27.924386713Z INFO Response: 200 OK service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/api/tool/my-simple-execute-cypher-tool/invoke" method: "POST" path: "/api/tool/my-simple-execute-cypher-tool/invoke" remoteIP: "127.0.0.1:39172" proto: "HTTP/1.1" requestID: "a34930c37a4b/a1OKv1w8ur-000006"} httpResponse: {status: 200 bytes: 25 elapsed: 4.226200} 
Step #12 - "neo4j": === RUN   TestNeo4jToolEndpoints/invoke_my-simple-execute-cypher-tool_with_dry_run
Step #9 - "dataform": Get:2 http://deb.debian.org/debian trixie-updates InRelease [47.3 kB]
Step #12 - "neo4j": 2025-11-03T19:17:27.943133988Z INFO Response: 200 OK service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/api/tool/my-simple-execute-cypher-tool/invoke" method: "POST" path: "/api/tool/my-simple-execute-cypher-tool/invoke" remoteIP: "127.0.0.1:39172" proto: "HTTP/1.1" requestID: "a34930c37a4b/a1OKv1w8ur-000007"} httpResponse: {status: 200 bytes: 1078 elapsed: 17.699900} 
Step #12 - "neo4j": === RUN   TestNeo4jToolEndpoints/invoke_my-simple-execute-cypher-tool_with_dry_run_and_invalid_syntax
Step #9 - "dataform": Get:3 http://deb.debian.org/debian-security trixie-security InRelease [43.4 kB]
Step #12 - "neo4j": 2025-11-03T19:17:27.952764106Z INFO Response: 400 Client Error service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/api/tool/my-simple-execute-cypher-tool/invoke" method: "POST" path: "/api/tool/my-simple-execute-cypher-tool/invoke" remoteIP: "127.0.0.1:39172" proto: "HTTP/1.1" requestID: "a34930c37a4b/a1OKv1w8ur-000008"} httpResponse: {status: 400 bytes: 636 elapsed: 8.399225} 
Step #12 - "neo4j": === RUN   TestNeo4jToolEndpoints/invoke_readonly_tool_with_write_query
Step #12 - "neo4j": 2025-11-03T19:17:27.954238932Z INFO Response: 400 Client Error service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/api/tool/my-readonly-execute-cypher-tool/invoke" method: "POST" path: "/api/tool/my-readonly-execute-cypher-tool/invoke" remoteIP: "127.0.0.1:39172" proto: "HTTP/1.1" requestID: "a34930c37a4b/a1OKv1w8ur-000009"} httpResponse: {status: 400 bytes: 118 elapsed: 0.594169} 
Step #12 - "neo4j": === RUN   TestNeo4jToolEndpoints/invoke_readonly_tool_with_write_query_and_dry_run
Step #12 - "neo4j": 2025-11-03T19:17:27.955515129Z INFO Response: 400 Client Error service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/api/tool/my-readonly-execute-cypher-tool/invoke" method: "POST" path: "/api/tool/my-readonly-execute-cypher-tool/invoke" remoteIP: "127.0.0.1:39172" proto: "HTTP/1.1" requestID: "a34930c37a4b/a1OKv1w8ur-000010"} httpResponse: {status: 400 bytes: 118 elapsed: 0.514681} 
Step #12 - "neo4j": === RUN   TestNeo4jToolEndpoints/invoke_my-schema-tool
Step #23 - "firestore": === RUN   TestFirestoreToolEndpoints
Step #18 - "sqlite": === RUN   TestSQLiteToolEndpoint
Step #9 - "dataform": Get:4 http://deb.debian.org/debian trixie/main amd64 Packages [9669 kB]
Step #33 - "serverless-spark": 2025-11-03T19:17:27.984915993Z INFO Response: 200 OK service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/api/tool/list-batches/invoke" method: "POST" path: "/api/tool/list-batches/invoke" remoteIP: "127.0.0.1:39160" proto: "HTTP/1.1" requestID: "0c0b956b8b3a/gTGZjgPE1d-000004"} httpResponse: {status: 200 bytes: 5442 elapsed: 90.055657} 
Step #33 - "serverless-spark": === RUN   TestServerlessSparkToolEndpoints/list-batches_omit_page_size
Step #33 - "serverless-spark": 2025-11-03T19:17:28.027102599Z INFO Response: 200 OK service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/api/tool/list-batches/invoke" method: "POST" path: "/api/tool/list-batches/invoke" remoteIP: "127.0.0.1:39160" proto: "HTTP/1.1" requestID: "0c0b956b8b3a/gTGZjgPE1d-000005"} httpResponse: {status: 200 bytes: 5442 elapsed: 40.374075} 
Step #33 - "serverless-spark": === RUN   TestServerlessSparkToolEndpoints/list-batches_filtered
Step #12 - "neo4j": 2025-11-03T19:17:28.057961148Z INFO Response: 200 OK service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/api/tool/my-schema-tool/invoke" method: "POST" path: "/api/tool/my-schema-tool/invoke" remoteIP: "127.0.0.1:39172" proto: "HTTP/1.1" requestID: "a34930c37a4b/a1OKv1w8ur-000011"} httpResponse: {status: 200 bytes: 613 elapsed: 101.503465} 
Step #12 - "neo4j": === RUN   TestNeo4jToolEndpoints/invoke_my-schema-tool-with-cache
Step #33 - "serverless-spark": 2025-11-03T19:17:28.061075498Z INFO Response: 200 OK service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/api/tool/list-batches/invoke" method: "POST" path: "/api/tool/list-batches/invoke" remoteIP: "127.0.0.1:39160" proto: "HTTP/1.1" requestID: "0c0b956b8b3a/gTGZjgPE1d-000006"} httpResponse: {status: 200 bytes: 654 elapsed: 31.804013} 
Step #33 - "serverless-spark": === RUN   TestServerlessSparkToolEndpoints/list-batches_empty
Step #12 - "neo4j": 2025-11-03T19:17:28.064176196Z INFO Response: 200 OK service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/api/tool/my-schema-tool-with-cache/invoke" method: "POST" path: "/api/tool/my-schema-tool-with-cache/invoke" remoteIP: "127.0.0.1:39172" proto: "HTTP/1.1" requestID: "a34930c37a4b/a1OKv1w8ur-000012"} httpResponse: {status: 200 bytes: 613 elapsed: 4.927930} 
Step #12 - "neo4j": === RUN   TestNeo4jToolEndpoints/invoke_my-schema-tool_with_populated_data
Step #18 - "sqlite": === RUN   TestSQLiteToolEndpoint/get_my-simple-tool
Step #18 - "sqlite": 2025-11-03T19:17:28.074590202Z INFO Response: 200 OK service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/api/tool/my-simple-tool/" method: "GET" path: "/api/tool/my-simple-tool/" remoteIP: "127.0.0.1:39184" proto: "HTTP/1.1" requestID: "8045ef35f0cd/P4dZEshJYu-000001"} httpResponse: {status: 200 bytes: 168 elapsed: 0.457525} 
Step #9 - "dataform": Get:5 http://deb.debian.org/debian trixie-updates/main amd64 Packages [5412 B]
Step #9 - "dataform": Get:6 http://deb.debian.org/debian-security trixie-security/main amd64 Packages [69.0 kB]
Step #33 - "serverless-spark": 2025-11-03T19:17:28.1391254Z INFO Response: 200 OK service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/api/tool/list-batches/invoke" method: "POST" path: "/api/tool/list-batches/invoke" remoteIP: "127.0.0.1:39160" proto: "HTTP/1.1" requestID: "0c0b956b8b3a/gTGZjgPE1d-000007"} httpResponse: {status: 200 bytes: 53 elapsed: 77.051333} 
Step #18 - "sqlite": === RUN   TestSQLiteToolEndpoint/invoke_my-simple-tool
Step #18 - "sqlite": 2025-11-03T19:17:28.153067666Z INFO Response: 200 OK service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/api/tool/my-simple-tool/invoke" method: "POST" path: "/api/tool/my-simple-tool/invoke" remoteIP: "127.0.0.1:39184" proto: "HTTP/1.1" requestID: "8045ef35f0cd/P4dZEshJYu-000002"} httpResponse: {status: 200 bytes: 25 elapsed: 0.703810} 
Step #18 - "sqlite": === RUN   TestSQLiteToolEndpoint/invoke_my-tool
Step #18 - "sqlite": 2025-11-03T19:17:28.155648083Z INFO Response: 200 OK service: "http
...
[Logs truncated due to log size limitations. For full logs, see https://console.cloud.google.com/logs/viewer?advancedFilter=resource.type%3D%22build%22+AND+resource.labels.build_id%3D%2247f6650e-b9c0-4482-adfa-2a6f1697417a%22+AND+resource.labels.build_trigger_id%3D%22785da918-06f1-47bb-860c-fbabc80b5977%22&project=toolbox-testing-438616.]
...
reviously unselected package libsharpyuv0:amd64.
Step #9 - "dataform": Preparing to unpack .../172-libsharpyuv0_1.5.0-0.1_amd64.deb ...
Step #9 - "dataform": Unpacking libsharpyuv0:amd64 (1.5.0-0.1) ...
Step #9 - "dataform": Selecting previously unselected package libwebp7:amd64.
Step #9 - "dataform": Preparing to unpack .../173-libwebp7_1.5.0-0.1_amd64.deb ...
Step #9 - "dataform": Unpacking libwebp7:amd64 (1.5.0-0.1) ...
Finished Step #6 - "bigtable"
Finished Step #14 - "cloud-sql-mysql"
Step #9 - "dataform": Selecting previously unselected package libtiff6:amd64.
Step #9 - "dataform": Preparing to unpack .../174-libtiff6_4.7.0-3+deb13u1_amd64.deb ...
Step #9 - "dataform": Unpacking libtiff6:amd64 (4.7.0-3+deb13u1) ...
Step #9 - "dataform": Selecting previously unselected package libgdk-pixbuf-2.0-0:amd64.
Step #9 - "dataform": Preparing to unpack .../175-libgdk-pixbuf-2.0-0_2.42.12+dfsg-4_amd64.deb ...
Step #9 - "dataform": Unpacking libgdk-pixbuf-2.0-0:amd64 (2.42.12+dfsg-4) ...
Step #15 - "mysql": Calculating coverage for MySQL...
Step #9 - "dataform": Selecting previously unselected package libgdk-pixbuf2.0-bin.
Step #9 - "dataform": Preparing to unpack .../176-libgdk-pixbuf2.0-bin_2.42.12+dfsg-4_amd64.deb ...
Step #9 - "dataform": Unpacking libgdk-pixbuf2.0-bin (2.42.12+dfsg-4) ...
Step #9 - "dataform": Selecting previously unselected package libglvnd0:amd64.
Step #9 - "dataform": Preparing to unpack .../177-libglvnd0_1.7.0-1+b2_amd64.deb ...
Step #9 - "dataform": Unpacking libglvnd0:amd64 (1.7.0-1+b2) ...
Step #9 - "dataform": Selecting previously unselected package libxcb-glx0:amd64.
Step #9 - "dataform": Preparing to unpack .../178-libxcb-glx0_1.17.0-2+b1_amd64.deb ...
Step #9 - "dataform": Unpacking libxcb-glx0:amd64 (1.17.0-2+b1) ...
Step #9 - "dataform": Selecting previously unselected package libxext6:amd64.
Step #9 - "dataform": Preparing to unpack .../179-libxext6_2%3a1.3.4-1+b3_amd64.deb ...
Step #9 - "dataform": Unpacking libxext6:amd64 (2:1.3.4-1+b3) ...
Step #9 - "dataform": Selecting previously unselected package libxxf86vm1:amd64.
Step #9 - "dataform": Preparing to unpack .../180-libxxf86vm1_1%3a1.1.4-1+b4_amd64.deb ...
Step #9 - "dataform": Unpacking libxxf86vm1:amd64 (1:1.1.4-1+b4) ...
Step #15 - "mysql": MySQL total coverage: 76.4%
Step #15 - "mysql": Coverage for MySQL is sufficient.
Step #9 - "dataform": Selecting previously unselected package libvulkan1:amd64.
Step #9 - "dataform": Preparing to unpack .../181-libvulkan1_1.4.309.0-1_amd64.deb ...
Step #9 - "dataform": Unpacking libvulkan1:amd64 (1.4.309.0-1) ...
Step #9 - "dataform": Selecting previously unselected package libgl1-mesa-dri:amd64.
Step #9 - "dataform": Preparing to unpack .../182-libgl1-mesa-dri_25.0.7-2_amd64.deb ...
Step #9 - "dataform": Unpacking libgl1-mesa-dri:amd64 (25.0.7-2) ...
Step #9 - "dataform": Selecting previously unselected package libglx-mesa0:amd64.
Step #9 - "dataform": Preparing to unpack .../183-libglx-mesa0_25.0.7-2_amd64.deb ...
Step #9 - "dataform": Unpacking libglx-mesa0:amd64 (25.0.7-2) ...
Step #9 - "dataform": Selecting previously unselected package libglx0:amd64.
Step #9 - "dataform": Preparing to unpack .../184-libglx0_1.7.0-1+b2_amd64.deb ...
Step #9 - "dataform": Unpacking libglx0:amd64 (1.7.0-1+b2) ...
Step #9 - "dataform": Selecting previously unselected package libgl1:amd64.
Step #9 - "dataform": Preparing to unpack .../185-libgl1_1.7.0-1+b2_amd64.deb ...
Step #9 - "dataform": Unpacking libgl1:amd64 (1.7.0-1+b2) ...
Step #9 - "dataform": Selecting previously unselected package libgles2:amd64.
Step #9 - "dataform": Preparing to unpack .../186-libgles2_1.7.0-1+b2_amd64.deb ...
Step #7 - "bigquery": 2025-11-03T19:17:52.391627351Z INFO Response: 200 OK service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/mcp" method: "POST" path: "/mcp" remoteIP: "127.0.0.1:59172" proto: "HTTP/1.1" requestID: "637438ff2d7f/5L5R5CBVdT-000024"} httpResponse: {status: 200 bytes: 112 elapsed: 625.730631} 
Step #7 - "bigquery": === RUN   TestBigQueryToolEndpoints/MCP_Invoke_my-client-auth-tool_without_access_token
Step #9 - "dataform": Unpacking libgles2:amd64 (1.7.0-1+b2) ...
Step #7 - "bigquery": 2025-11-03T19:17:52.39282327Z INFO Response: 401 Client Error service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/mcp" method: "POST" path: "/mcp" remoteIP: "127.0.0.1:59172" proto: "HTTP/1.1" requestID: "637438ff2d7f/5L5R5CBVdT-000025"} httpResponse: {status: 401 bytes: 139 elapsed: 0.315741} 
Step #7 - "bigquery": === RUN   TestBigQueryToolEndpoints/MCP_Invoke_my-client-auth-tool_with_invalid_access_token
Step #9 - "dataform": Selecting previously unselected package libglib2.0-data.
Step #7 - "bigquery": 2025-11-03T19:17:52.422832984Z INFO Response: 401 Client Error service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/mcp" method: "POST" path: "/mcp" remoteIP: "127.0.0.1:59172" proto: "HTTP/1.1" requestID: "637438ff2d7f/5L5R5CBVdT-000026"} httpResponse: {status: 401 bytes: 440 elapsed: 29.237598} 
Step #7 - "bigquery": === RUN   TestBigQueryToolEndpoints/MCP_Invoke_my-fail-tool
Step #9 - "dataform": Preparing to unpack .../187-libglib2.0-data_2.84.4-3~deb13u1_all.deb ...
Step #9 - "dataform": Unpacking libglib2.0-data (2.84.4-3~deb13u1) ...
Finished Step #15 - "mysql"
Step #7 - "bigquery": 2025-11-03T19:17:52.476133305Z INFO Response: 200 OK service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/mcp" method: "POST" path: "/mcp" remoteIP: "127.0.0.1:59172" proto: "HTTP/1.1" requestID: "637438ff2d7f/5L5R5CBVdT-000027"} httpResponse: {status: 200 bytes: 251 elapsed: 52.549466} 
Step #7 - "bigquery": === RUN   TestBigQueryToolEndpoints/invoke_create-table-templateParams-tool
Step #7 - "bigquery": === RUN   TestBigQueryToolEndpoints/invoke_insert-table-templateParams-tool
Step #7 - "bigquery": === RUN   TestBigQueryToolEndpoints/invoke_insert-table-templateParams-tool#01
Step #7 - "bigquery": === RUN   TestBigQueryToolEndpoints/invoke_select-templateParams-tool
Step #7 - "bigquery": === RUN   TestBigQueryToolEndpoints/invoke_select-templateParams-combined-tool
Step #7 - "bigquery": === RUN   TestBigQueryToolEndpoints/invoke_select-templateParams-combined-tool_with_no_results
Step #7 - "bigquery": === RUN   TestBigQueryToolEndpoints/invoke_select-fields-templateParams-tool
Step #7 - "bigquery": === RUN   TestBigQueryToolEndpoints/invoke_select-filter-templateParams-combined-tool
Step #7 - "bigquery": === RUN   TestBigQueryToolEndpoints/invoke_drop-table-templateParams-tool
Step #7 - "bigquery": === RUN   TestBigQueryToolEndpoints/invoke_my-exec-sql-tool_without_body
Step #7 - "bigquery": 2025-11-03T19:17:52.479709181Z INFO Response: 400 Client Error service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/api/tool/my-exec-sql-tool/invoke" method: "POST" path: "/api/tool/my-exec-sql-tool/invoke" remoteIP: "127.0.0.1:59172" proto: "HTTP/1.1" requestID: "637438ff2d7f/5L5R5CBVdT-000028"} httpResponse: {status: 400 bytes: 99 elapsed: 0.227313} 
Step #7 - "bigquery": === RUN   TestBigQueryToolEndpoints/invoke_my-exec-sql-tool
Step #9 - "dataform": Selecting previously unselected package libhtml-tagset-perl.
Step #9 - "dataform": Preparing to unpack .../188-libhtml-tagset-perl_3.24-1_all.deb ...
Step #9 - "dataform": Unpacking libhtml-tagset-perl (3.24-1) ...
Step #9 - "dataform": Selecting previously unselected package libhtml-parser-perl:amd64.
Step #9 - "dataform": Preparing to unpack .../189-libhtml-parser-perl_3.83-1+b2_amd64.deb ...
Step #9 - "dataform": Unpacking libhtml-parser-perl:amd64 (3.83-1+b2) ...
Step #9 - "dataform": Selecting previously unselected package libio-html-perl.
Step #9 - "dataform": Preparing to unpack .../190-libio-html-perl_1.004-3_all.deb ...
Step #9 - "dataform": Unpacking libio-html-perl (1.004-3) ...
Step #9 - "dataform": Selecting previously unselected package liblwp-mediatypes-perl.
Step #9 - "dataform": Preparing to unpack .../191-liblwp-mediatypes-perl_6.04-2_all.deb ...
Step #9 - "dataform": Unpacking liblwp-mediatypes-perl (6.04-2) ...
Step #9 - "dataform": Selecting previously unselected package libhttp-message-perl.
Step #9 - "dataform": Preparing to unpack .../192-libhttp-message-perl_7.00-2_all.deb ...
Step #9 - "dataform": Unpacking libhttp-message-perl (7.00-2) ...
Step #9 - "dataform": Selecting previously unselected package libhtml-form-perl.
Step #9 - "dataform": Preparing to unpack .../193-libhtml-form-perl_6.12-1_all.deb ...
Step #9 - "dataform": Unpacking libhtml-form-perl (6.12-1) ...
Step #9 - "dataform": Selecting previously unselected package libhtml-tree-perl.
Step #9 - "dataform": Preparing to unpack .../194-libhtml-tree-perl_5.07-3_all.deb ...
Step #9 - "dataform": Unpacking libhtml-tree-perl (5.07-3) ...
Step #9 - "dataform": Selecting previously unselected package libhtml-format-perl.
Step #9 - "dataform": Preparing to unpack .../195-libhtml-format-perl_2.16-2_all.deb ...
Step #9 - "dataform": Unpacking libhtml-format-perl (2.16-2) ...
Step #9 - "dataform": Selecting previously unselected package libhttp-cookies-perl.
Step #9 - "dataform": Preparing to unpack .../196-libhttp-cookies-perl_6.11-1_all.deb ...
Step #9 - "dataform": Unpacking libhttp-cookies-perl (6.11-1) ...
Step #9 - "dataform": Selecting previously unselected package libhttp-daemon-perl.
Step #9 - "dataform": Preparing to unpack .../197-libhttp-daemon-perl_6.16-1_all.deb ...
Step #9 - "dataform": Unpacking libhttp-daemon-perl (6.16-1) ...
Step #9 - "dataform": Selecting previously unselected package libhttp-negotiate-perl.
Step #9 - "dataform": Preparing to unpack .../198-libhttp-negotiate-perl_6.01-2_all.deb ...
Step #9 - "dataform": Unpacking libhttp-negotiate-perl (6.01-2) ...
Step #9 - "dataform": Selecting previously unselected package x11-common.
Step #9 - "dataform": Preparing to unpack .../199-x11-common_1%3a7.7+24_all.deb ...
Step #9 - "dataform": Unpacking x11-common (1:7.7+24) ...
Step #9 - "dataform": Selecting previously unselected package libice6:amd64.
Step #9 - "dataform": Preparing to unpack .../200-libice6_2%3a1.1.1-1_amd64.deb ...
Step #9 - "dataform": Unpacking libice6:amd64 (2:1.1.1-1) ...
Step #9 - "dataform": Selecting previously unselected package libio-compress-brotli-perl.
Step #9 - "dataform": Preparing to unpack .../201-libio-compress-brotli-perl_0.004001-2+b3_amd64.deb ...
Step #9 - "dataform": Unpacking libio-compress-brotli-perl (0.004001-2+b3) ...
Step #9 - "dataform": Selecting previously unselected package perl-openssl-defaults:amd64.
Step #9 - "dataform": Preparing to unpack .../202-perl-openssl-defaults_7+b2_amd64.deb ...
Step #9 - "dataform": Unpacking perl-openssl-defaults:amd64 (7+b2) ...
Step #9 - "dataform": Selecting previously unselected package libnet-ssleay-perl:amd64.
Step #9 - "dataform": Preparing to unpack .../203-libnet-ssleay-perl_1.94-3_amd64.deb ...
Step #9 - "dataform": Unpacking libnet-ssleay-perl:amd64 (1.94-3) ...
Step #9 - "dataform": Selecting previously unselected package libio-socket-ssl-perl.
Step #9 - "dataform": Preparing to unpack .../204-libio-socket-ssl-perl_2.089-1_all.deb ...
Step #9 - "dataform": Unpacking libio-socket-ssl-perl (2.089-1) ...
Step #9 - "dataform": Selecting previously unselected package libio-stringy-perl.
Step #9 - "dataform": Preparing to unpack .../205-libio-stringy-perl_2.113-2_all.deb ...
Step #9 - "dataform": Unpacking libio-stringy-perl (2.113-2) ...
Step #7 - "bigquery": 2025-11-03T19:17:53.047665975Z INFO Response: 200 OK service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/api/tool/my-exec-sql-tool/invoke" method: "POST" path: "/api/tool/my-exec-sql-tool/invoke" remoteIP: "127.0.0.1:59186" proto: "HTTP/1.1" requestID: "637438ff2d7f/5L5R5CBVdT-000029"} httpResponse: {status: 200 bytes: 27 elapsed: 567.072027} 
Step #7 - "bigquery": === RUN   TestBigQueryToolEndpoints/invoke_my-exec-sql-tool_create_table
Step #9 - "dataform": Selecting previously unselected package libjs-events.
Step #9 - "dataform": Preparing to unpack .../206-libjs-events_3.3.0+~3.0.0-3_all.deb ...
Step #9 - "dataform": Unpacking libjs-events (3.3.0+~3.0.0-3) ...
Step #9 - "dataform": Selecting previously unselected package libjs-is-typedarray.
Step #9 - "dataform": Preparing to unpack .../207-libjs-is-typedarray_1.0.0-4_all.deb ...
Step #9 - "dataform": Unpacking libjs-is-typedarray (1.0.0-4) ...
Step #9 - "dataform": Selecting previously unselected package libjs-prettify.
Step #9 - "dataform": Preparing to unpack .../208-libjs-prettify_2015.12.04+dfsg-1.1_all.deb ...
Step #9 - "dataform": Unpacking libjs-prettify (2015.12.04+dfsg-1.1) ...
Step #9 - "dataform": Selecting previously unselected package libjs-sprintf-js.
Step #9 - "dataform": Preparing to unpack .../209-libjs-sprintf-js_1.1.2+ds1+~1.1.2-1_all.deb ...
Step #9 - "dataform": Unpacking libjs-sprintf-js (1.1.2+ds1+~1.1.2-1) ...
Step #7 - "bigquery": 2025-11-03T19:17:53.145512816Z INFO Response: 400 Client Error service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/api/tool/my-exec-sql-tool/invoke" method: "POST" path: "/api/tool/my-exec-sql-tool/invoke" remoteIP: "127.0.0.1:59186" proto: "HTTP/1.1" requestID: "637438ff2d7f/5L5R5CBVdT-000030"} httpResponse: {status: 400 bytes: 215 elapsed: 96.995007} 
Step #7 - "bigquery": === RUN   TestBigQueryToolEndpoints/invoke_my-exec-sql-tool_with_data_present_in_table
Step #9 - "dataform": Selecting previously unselected package libjs-typedarray-to-buffer.
Step #9 - "dataform": Preparing to unpack .../210-libjs-typedarray-to-buffer_4.0.0-2_all.deb ...
Step #9 - "dataform": Unpacking libjs-typedarray-to-buffer (4.0.0-2) ...
Step #9 - "dataform": Selecting previously unselected package node-lodash-packages.
Step #9 - "dataform": Preparing to unpack .../211-node-lodash-packages_4.17.21+dfsg+~cs8.31.198.20210220-9_all.deb ...
Step #9 - "dataform": Unpacking node-lodash-packages (4.17.21+dfsg+~cs8.31.198.20210220-9) ...
Step #11 - "spanner": === RUN   TestSpannerToolEndpoints/get_my-simple-tool
Step #11 - "spanner": 2025-11-03T19:17:53.229561485Z INFO Response: 200 OK service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/api/tool/my-simple-tool/" method: "GET" path: "/api/tool/my-simple-tool/" remoteIP: "127.0.0.1:59196" proto: "HTTP/1.1" requestID: "38bed45dd365/MFG8IyewWY-000001"} httpResponse: {status: 200 bytes: 168 elapsed: 0.398590} 
Step #11 - "spanner": === RUN   TestSpannerToolEndpoints/invoke_my-simple-tool
Step #9 - "dataform": Selecting previously unselected package node-function-bind.
Step #9 - "dataform": Preparing to unpack .../212-node-function-bind_1.1.2+~cs2.1.14-1_all.deb ...
Step #9 - "dataform": Unpacking node-function-bind (1.1.2+~cs2.1.14-1) ...
Step #9 - "dataform": Selecting previously unselected package node-object-inspect.
Step #9 - "dataform": Preparing to unpack .../213-node-object-inspect_1.12.2+~cs1.8.1-1_all.deb ...
Step #9 - "dataform": Unpacking node-object-inspect (1.12.2+~cs1.8.1-1) ...
Step #9 - "dataform": Selecting previously unselected package node-es-abstract.
Step #9 - "dataform": Preparing to unpack .../214-node-es-abstract_1.20.4+~cs26.27.47-2_all.deb ...
Step #9 - "dataform": Unpacking node-es-abstract (1.20.4+~cs26.27.47-2) ...
Step #11 - "spanner": 2025-11-03T19:17:53.719300061Z INFO Response: 200 OK service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/api/tool/my-simple-tool/invoke" method: "POST" path: "/api/tool/my-simple-tool/invoke" remoteIP: "127.0.0.1:59196" proto: "HTTP/1.1" requestID: "38bed45dd365/MFG8IyewWY-000002"} httpResponse: {status: 200 bytes: 28 elapsed: 486.975831} 
Step #11 - "spanner": === RUN   TestSpannerToolEndpoints/invoke_my-tool
Step #9 - "dataform": Selecting previously unselected package node-resolve.
Step #9 - "dataform": Preparing to unpack .../215-node-resolve_1.22.8+~cs5.34.15-2_all.deb ...
Step #9 - "dataform": Unpacking node-resolve (1.22.8+~cs5.34.15-2) ...
Step #9 - "dataform": Selecting previously unselected package node-define-properties.
Step #9 - "dataform": Preparing to unpack .../216-node-define-properties_1.2.1+~cs2.2.3-1_all.deb ...
Step #9 - "dataform": Unpacking node-define-properties (1.2.1+~cs2.2.3-1) ...
Step #9 - "dataform": Selecting previously unselected package node-debbundle-es-to-primitive.
Step #9 - "dataform": Preparing to unpack .../217-node-debbundle-es-to-primitive_1.2.1+~cs9.7.25-2_all.deb ...
Step #9 - "dataform": Unpacking node-debbundle-es-to-primitive (1.2.1+~cs9.7.25-2) ...
Step #9 - "dataform": Selecting previously unselected package node-isobject.
Step #9 - "dataform": Preparing to unpack .../218-node-isobject_4.0.0-2_all.deb ...
Step #9 - "dataform": Unpacking node-isobject (4.0.0-2) ...
Step #9 - "dataform": Selecting previously unselected package node-is-descriptor.
Step #9 - "dataform": Preparing to unpack .../219-node-is-descriptor_3.0.0-2_all.deb ...
Step #9 - "dataform": Unpacking node-is-descriptor (3.0.0-2) ...
Step #11 - "spanner": 2025-11-03T19:17:53.890859013Z INFO Response: 200 OK service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/api/tool/my-tool/invoke" method: "POST" path: "/api/tool/my-tool/invoke" remoteIP: "127.0.0.1:59196" proto: "HTTP/1.1" requestID: "38bed45dd365/MFG8IyewWY-000003"} httpResponse: {status: 200 bytes: 81 elapsed: 170.645771} 
Step #11 - "spanner": === RUN   TestSpannerToolEndpoints/invoke_my-tool-by-id_with_nil_response
Step #9 - "dataform": Selecting previously unselected package node-define-property.
Step #9 - "dataform": Preparing to unpack .../220-node-define-property_2.0.2+really+2.0.2-3_all.deb ...
Step #9 - "dataform": Unpacking node-define-property (2.0.2+really+2.0.2-3) ...
Step #9 - "dataform": Selecting previously unselected package node-defined.
Step #9 - "dataform": Preparing to unpack .../221-node-defined_1.0.1+~1.0.0-1_all.deb ...
Step #9 - "dataform": Unpacking node-defined (1.0.1+~1.0.0-1) ...
Step #9 - "dataform": Selecting previously unselected package node-abbrev.
Step #9 - "dataform": Preparing to unpack .../222-node-abbrev_1.1.1+~1.1.2-1_all.deb ...
Step #9 - "dataform": Unpacking node-abbrev (1.1.1+~1.1.2-1) ...
Step #9 - "dataform": Selecting previously unselected package node-archy.
Step #9 - "dataform": Preparing to unpack .../223-node-archy_1.0.0-6_all.deb ...
Step #9 - "dataform": Unpacking node-archy (1.0.0-6) ...
Step #9 - "dataform": Selecting previously unselected package node-async.
Step #9 - "dataform": Preparing to unpack .../224-node-async_3.2.6+dfsg-2_all.deb ...
Step #9 - "dataform": Unpacking node-async (3.2.6+dfsg-2) ...
Step #11 - "spanner": 2025-11-03T19:17:54.057566722Z INFO Response: 200 OK service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/api/tool/my-tool-by-id/invoke" method: "POST" path: "/api/tool/my-tool-by-id/invoke" remoteIP: "127.0.0.1:59196" proto: "HTTP/1.1" requestID: "38bed45dd365/MFG8IyewWY-000004"} httpResponse: {status: 200 bytes: 44 elapsed: 165.809501} 
Step #11 - "spanner": === RUN   TestSpannerToolEndpoints/invoke_my-tool-by-name_with_nil_response
Step #9 - "dataform": Selecting previously unselected package node-convert-source-map.
Step #9 - "dataform": Preparing to unpack .../225-node-convert-source-map_1.9.0+~1.5.2-1_all.deb ...
Step #9 - "dataform": Unpacking node-convert-source-map (1.9.0+~1.5.2-1) ...
Step #9 - "dataform": Selecting previously unselected package node-decamelize.
Step #9 - "dataform": Preparing to unpack .../226-node-decamelize_4.0.0-2_all.deb ...
Step #9 - "dataform": Unpacking node-decamelize (4.0.0-2) ...
Step #9 - "dataform": Selecting previously unselected package node-es6-error.
Step #9 - "dataform": Preparing to unpack .../227-node-es6-error_4.1.1-5_all.deb ...
Step #9 - "dataform": Unpacking node-es6-error (4.1.1-5) ...
Step #11 - "spanner": 2025-11-03T19:17:54.121811812Z INFO Response: 200 OK service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/api/tool/my-tool-by-name/invoke" method: "POST" path: "/api/tool/my-tool-by-name/invoke" remoteIP: "127.0.0.1:59196" proto: "HTTP/1.1" requestID: "38bed45dd365/MFG8IyewWY-000005"} httpResponse: {status: 200 bytes: 18 elapsed: 63.362301} 
Step #11 - "spanner": === RUN   TestSpannerToolEndpoints/Invoke_my-tool_without_parameters
Step #11 - "spanner": 2025-11-03T19:17:54.122746265Z INFO Response: 400 Client Error service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/api/tool/my-tool/invoke" method: "POST" path: "/api/tool/my-tool/invoke" remoteIP: "127.0.0.1:59196" proto: "HTTP/1.1" requestID: "38bed45dd365/MFG8IyewWY-000006"} httpResponse: {status: 400 bytes: 98 elapsed: 0.215931} 
Step #11 - "spanner": === RUN   TestSpannerToolEndpoints/Invoke_my-tool_with_insufficient_parameters
Step #11 - "spanner": 2025-11-03T19:17:54.12390565Z INFO Response: 400 Client Error service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/api/tool/my-tool/invoke" method: "POST" path: "/api/tool/my-tool/invoke" remoteIP: "127.0.0.1:59204" proto: "HTTP/1.1" requestID: "38bed45dd365/MFG8IyewWY-000007"} httpResponse: {status: 400 bytes: 100 elapsed: 0.224702} 
Step #11 - "spanner": === RUN   TestSpannerToolEndpoints/invoke_my-array-tool
Step #11 - "spanner": 2025-11-03T19:17:54.141739224Z INFO Response: 200 OK service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/api/tool/my-array-tool/invoke" method: "POST" path: "/api/tool/my-array-tool/invoke" remoteIP: "127.0.0.1:59214" proto: "HTTP/1.1" requestID: "38bed45dd365/MFG8IyewWY-000008"} httpResponse: {status: 200 bytes: 81 elapsed: 17.019523} 
Step #11 - "spanner": === RUN   TestSpannerToolEndpoints/Invoke_my-auth-tool_with_auth_token
Step #9 - "dataform": Selecting previously unselected package node-esprima.
Step #9 - "dataform": Preparing to unpack .../228-node-esprima_4.0.1+ds+~4.0.3-2_all.deb ...
Step #9 - "dataform": Unpacking node-esprima (4.0.1+ds+~4.0.3-2) ...
Step #11 - "spanner": 2025-11-03T19:17:54.188632797Z INFO Response: 200 OK service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/api/tool/my-auth-tool/invoke" method: "POST" path: "/api/tool/my-auth-tool/invoke" remoteIP: "127.0.0.1:59214" proto: "HTTP/1.1" requestID: "38bed45dd365/MFG8IyewWY-000009"} httpResponse: {status: 200 bytes: 36 elapsed: 46.000225} 
Step #11 - "spanner": === RUN   TestSpannerToolEndpoints/Invoke_my-auth-tool_with_invalid_auth_token
Step #11 - "spanner": 2025-11-03T19:17:54.189576841Z INFO Response: 401 Client Error service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/api/tool/my-auth-tool/invoke" method: "POST" path: "/api/tool/my-auth-tool/invoke" remoteIP: "127.0.0.1:59214" proto: "HTTP/1.1" requestID: "38bed45dd365/MFG8IyewWY-000010"} httpResponse: {status: 401 bytes: 140 elapsed: 0.176788} 
Step #11 - "spanner": === RUN   TestSpannerToolEndpoints/Invoke_my-auth-tool_without_auth_token
Step #9 - "dataform": Selecting previously unselected package node-escodegen.
Step #11 - "spanner": 2025-11-03T19:17:54.190618725Z INFO Response: 401 Client Error service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/api/tool/my-auth-tool/invoke" method: "POST" path: "/api/tool/my-auth-tool/invoke" remoteIP: "127.0.0.1:59222" proto: "HTTP/1.1" requestID: "38bed45dd365/MFG8IyewWY-000011"} httpResponse: {status: 401 bytes: 140 elapsed: 0.176567} 
Step #11 - "spanner": === RUN   TestSpannerToolEndpoints/Invoke_my-auth-required-tool_with_auth_token
Step #9 - "dataform": Preparing to unpack .../229-node-escodegen_2.1.0+dfsg+~0.0.8-1_all.deb ...
Step #9 - "dataform": Unpacking node-escodegen (2.1.0+dfsg+~0.0.8-1) ...
Step #11 - "spanner": 2025-11-03T19:17:54.204338039Z INFO Response: 200 OK service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/api/tool/my-auth-required-tool/invoke" method: "POST" path: "/api/tool/my-auth-required-tool/invoke" remoteIP: "127.0.0.1:59232" proto: "HTTP/1.1" requestID: "38bed45dd365/MFG8IyewWY-000012"} httpResponse: {status: 200 bytes: 28 elapsed: 12.991351} 
Step #11 - "spanner": === RUN   TestSpannerToolEndpoints/Invoke_my-auth-required-tool_with_invalid_auth_token
Step #11 - "spanner": 2025-11-03T19:17:54.205238668Z INFO Response: 401 Client Error service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/api/tool/my-auth-required-tool/invoke" method: "POST" path: "/api/tool/my-auth-required-tool/invoke" remoteIP: "127.0.0.1:59232" proto: "HTTP/1.1" requestID: "38bed45dd365/MFG8IyewWY-000013"} httpResponse: {status: 401 bytes: 119 elapsed: 0.127152} 
Step #11 - "spanner": === RUN   TestSpannerToolEndpoints/Invoke_my-auth-required-tool_without_auth_token
Step #11 - "spanner": 2025-11-03T19:17:54.206191333Z INFO Response: 401 Client Error service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/api/tool/my-auth-tool/invoke" method: "POST" path: "/api/tool/my-auth-tool/invoke" remoteIP: "127.0.0.1:59248" proto: "HTTP/1.1" requestID: "38bed45dd365/MFG8IyewWY-000014"} httpResponse: {status: 401 bytes: 140 elapsed: 0.164967} 
Step #11 - "spanner": === RUN   TestSpannerToolEndpoints/Invoke_my-client-auth-tool_with_auth_token
Step #11 - "spanner": === RUN   TestSpannerToolEndpoints/Invoke_my-client-auth-tool_without_auth_token
Step #11 - "spanner": === RUN   TestSpannerToolEndpoints/Invoke_my-client-auth-tool_with_invalid_auth_token
Step #11 - "spanner": 2025-11-03T19:17:54.20766748Z INFO Response: 200 OK service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/mcp" method: "POST" path: "/mcp" remoteIP: "127.0.0.1:59250" proto: "HTTP/1.1" requestID: "38bed45dd365/MFG8IyewWY-000015"} httpResponse: {status: 200 bytes: 196 elapsed: 0.464636} 
Step #11 - "spanner": 2025-11-03T19:17:54.208455479Z INFO Response: 202 OK service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/mcp" method: "POST" path: "/mcp" remoteIP: "127.0.0.1:59250" proto: "HTTP/1.1" requestID: "38bed45dd365/MFG8IyewWY-000016"} httpResponse: {status: 202 bytes: 0 elapsed: 0.169967} 
Step #11 - "spanner": === RUN   TestSpannerToolEndpoints/MCP_Invoke_my-tool
Step #9 - "dataform": Selecting previously unselected package node-commondir.
Step #9 - "dataform": Preparing to unpack .../230-node-commondir_1.0.1+~1.0.0-1_all.deb ...
Step #11 - "spanner": 2025-11-03T19:17:54.225131007Z INFO Response: 200 OK service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/mcp" method: "POST" path: "/mcp" remoteIP: "127.0.0.1:59250" proto: "HTTP/1.1" requestID: "38bed45dd365/MFG8IyewWY-000017"} httpResponse: {status: 200 bytes: 172 elapsed: 13.827535} 
Step #11 - "spanner": === RUN   TestSpannerToolEndpoints/MCP_Invoke_invalid_tool
Step #11 - "spanner": 2025-11-03T19:17:54.226216105Z INFO Response: 200 OK service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/mcp" method: "POST" path: "/mcp" remoteIP: "127.0.0.1:59250" proto: "HTTP/1.1" requestID: "38bed45dd365/MFG8IyewWY-000018"} httpResponse: {status: 200 bytes: 131 elapsed: 0.252455} 
Step #9 - "dataform": Unpacking node-commondir (1.0.1+~1.0.0-1) ...
Step #11 - "spanner": === RUN   TestSpannerToolEndpoints/MCP_Invoke_my-tool_without_parameters
Step #11 - "spanner": 2025-11-03T19:17:54.227155008Z INFO Response: 200 OK service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/mcp" method: "POST" path: "/mcp" remoteIP: "127.0.0.1:59250" proto: "HTTP/1.1" requestID: "38bed45dd365/MFG8IyewWY-000019"} httpResponse: {status: 200 bytes: 149 elapsed: 0.224903} 
Step #11 - "spanner": === RUN   TestSpannerToolEndpoints/MCP_Invoke_my-tool_with_insufficient_parameters
Step #11 - "spanner": 2025-11-03T19:17:54.228052218Z INFO Response: 200 OK service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/mcp" method: "POST" path: "/mcp" remoteIP: "127.0.0.1:59250" proto: "HTTP/1.1" requestID: "38bed45dd365/MFG8IyewWY-000020"} httpResponse: {status: 200 bytes: 156 elapsed: 0.224262} 
Step #11 - "spanner": === RUN   TestSpannerToolEndpoints/MCP_Invoke_my-auth-required-tool
Step #11 - "spanner": 2025-11-03T19:17:54.236831941Z INFO Response: 200 OK service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/mcp" method: "POST" path: "/mcp" remoteIP: "127.0.0.1:59250" proto: "HTTP/1.1" requestID: "38bed45dd365/MFG8IyewWY-000021"} httpResponse: {status: 200 bytes: 115 elapsed: 8.074153} 
Step #11 - "spanner": === RUN   TestSpannerToolEndpoints/MCP_Invoke_my-auth-required-tool_with_invalid_auth_token
Step #11 - "spanner": === RUN   TestSpannerToolEndpoints/MCP_Invoke_my-auth-required-tool_without_auth_token
Step #11 - "spanner": === RUN   TestSpannerToolEndpoints/MCP_Invoke_my-client-auth-tool
Step #11 - "spanner": === RUN   TestSpannerToolEndpoints/MCP_Invoke_my-client-auth-tool_without_access_token
Step #11 - "spanner": === RUN   TestSpannerToolEndpoints/MCP_Invoke_my-client-auth-tool_with_invalid_access_token
Step #11 - "spanner": === RUN   TestSpannerToolEndpoints/MCP_Invoke_my-fail-tool
Step #11 - "spanner": 2025-11-03T19:17:54.246251607Z INFO Response: 200 OK service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/mcp" method: "POST" path: "/mcp" remoteIP: "127.0.0.1:59250" proto: "HTTP/1.1" requestID: "38bed45dd365/MFG8IyewWY-000022"} httpResponse: {status: 200 bytes: 331 elapsed: 8.054271} 
Step #11 - "spanner": === RUN   TestSpannerToolEndpoints/invoke_create-table-templateParams-tool
Step #11 - "spanner": === RUN   TestSpannerToolEndpoints/invoke_insert-table-templateParams-tool
Step #11 - "spanner": === RUN   TestSpannerToolEndpoints/invoke_insert-table-templateParams-tool#01
Step #11 - "spanner": === RUN   TestSpannerToolEndpoints/invoke_select-templateParams-tool
Step #11 - "spanner": === RUN   TestSpannerToolEndpoints/invoke_select-templateParams-combined-tool
Step #11 - "spanner": === RUN   TestSpannerToolEndpoints/invoke_select-templateParams-combined-tool_with_no_results
Step #11 - "spanner": === RUN   TestSpannerToolEndpoints/invoke_select-fields-templateParams-tool
Step #11 - "spanner": === RUN   TestSpannerToolEndpoints/invoke_select-filter-templateParams-combined-tool
Step #11 - "spanner": === RUN   TestSpannerToolEndpoints/invoke_drop-table-templateParams-tool
Step #11 - "spanner": === RUN   TestSpannerToolEndpoints/invoke_list-tables-read-only
Step #9 - "dataform": Selecting previously unselected package node-is-number.
Step #9 - "dataform": Preparing to unpack .../231-node-is-number_7.0.0-4_all.deb ...
Step #9 - "dataform": Unpacking node-is-number (7.0.0-4) ...
Step #9 - "dataform": Selecting previously unselected package node-repeat-string.
Step #9 - "dataform": Preparing to unpack .../232-node-repeat-string_1.6.1+repack-1_all.deb ...
Step #9 - "dataform": Unpacking node-repeat-string (1.6.1+repack-1) ...
Step #11 - "spanner": 2025-11-03T19:17:54.290497808Z INFO Response: 200 OK service: "httplog" httpRequest: {url: "http://127.0.0.1:5000/api/tool/access-schema-read-only/invoke" method: "POST" path: "/api/tool/access-schema-read-only/invoke" remoteIP: "127.0.0.1:59250" proto: "HTTP/1.1" requestID: "38bed45dd365/MFG8IyewWY-000023"} httpResponse: {status: 200 bytes: 56 elapsed: 42.811768} 

Build Log: https://console.cloud.google.com/logs/viewer?advancedFilter=resource.type%3D%22build%22+AND+resource.labels.build_id%3D%2247f6650e-b9c0-4482-adfa-2a6f1697417a%22+AND+resource.labels.build_trigger_id%3D%22785da918-06f1-47bb-860c-fbabc80b5977%22&project=toolbox-testing-438616