starting build "bc38caad-d4d2-42cd-90a8-1d161dfbf817"

FETCHSOURCE
From https://github.com/datacommonsorg/mixer
 * branch            9fc6f4878ad08cab2f4582209c90a49cf17fdf2c -> FETCH_HEAD
HEAD is now at 9fc6f48 Update golden files for 2026-03-10 data release
GitCommit:
9fc6f4878ad08cab2f4582209c90a49cf17fdf2c
BUILD
Starting Step #0 - "lint"
Step #0 - "lint": Pulling image: gcr.io/datcom-ci/full-env:mixer-only-2026-02-20
Step #0 - "lint": mixer-only-2026-02-20: Pulling from datcom-ci/full-env
Step #0 - "lint": 4831516dd0cb: Pulling fs layer
Step #0 - "lint": eca621ed31da: Pulling fs layer
Step #0 - "lint": ea9918785904: Pulling fs layer
Step #0 - "lint": 4e61b9e01774: Pulling fs layer
Step #0 - "lint": 71b0f9d5b525: Pulling fs layer
Step #0 - "lint": 96221a5ca3b0: Pulling fs layer
Step #0 - "lint": e6ce5089d906: Pulling fs layer
Step #0 - "lint": dd5ab1f34322: Pulling fs layer
Step #0 - "lint": 511f0c43c2f4: Pulling fs layer
Step #0 - "lint": 5f8a573e5a03: Pulling fs layer
Step #0 - "lint": f2ff01b34a28: Pulling fs layer
Step #0 - "lint": dd5ab1f34322: Waiting
Step #0 - "lint": 511f0c43c2f4: Waiting
Step #0 - "lint": f2ff01b34a28: Waiting
Step #0 - "lint": 5f8a573e5a03: Waiting
Step #0 - "lint": e6ce5089d906: Waiting
Step #0 - "lint": 96221a5ca3b0: Verifying Checksum
Step #0 - "lint": 96221a5ca3b0: Download complete
Step #0 - "lint": eca621ed31da: Download complete
Step #0 - "lint": 4831516dd0cb: Verifying Checksum
Step #0 - "lint": 4831516dd0cb: Download complete
Step #0 - "lint": ea9918785904: Verifying Checksum
Step #0 - "lint": ea9918785904: Download complete
Step #0 - "lint": 71b0f9d5b525: Verifying Checksum
Step #0 - "lint": 71b0f9d5b525: Download complete
Step #0 - "lint": 4e61b9e01774: Verifying Checksum
Step #0 - "lint": 4e61b9e01774: Download complete
Step #0 - "lint": 4831516dd0cb: Pull complete
Step #0 - "lint": dd5ab1f34322: Verifying Checksum
Step #0 - "lint": dd5ab1f34322: Download complete
Step #0 - "lint": eca621ed31da: Pull complete
Step #0 - "lint": 5f8a573e5a03: Verifying Checksum
Step #0 - "lint": 5f8a573e5a03: Download complete
Step #0 - "lint": 511f0c43c2f4: Verifying Checksum
Step #0 - "lint": 511f0c43c2f4: Download complete
Step #0 - "lint": ea9918785904: Pull complete
Step #0 - "lint": 4e61b9e01774: Pull complete
Step #0 - "lint": 71b0f9d5b525: Pull complete
Step #0 - "lint": 96221a5ca3b0: Pull complete
Step #0 - "lint": e6ce5089d906: Verifying Checksum
Step #0 - "lint": e6ce5089d906: Download complete
Step #0 - "lint": f2ff01b34a28: Verifying Checksum
Step #0 - "lint": f2ff01b34a28: Download complete
Step #0 - "lint": e6ce5089d906: Pull complete
Step #0 - "lint": dd5ab1f34322: Pull complete
Step #0 - "lint": 511f0c43c2f4: Pull complete
Step #0 - "lint": 5f8a573e5a03: Pull complete
Step #0 - "lint": f2ff01b34a28: Pull complete
Step #0 - "lint": Digest: sha256:748a5cbd59ddca050ae4b02cbb4696aad3a7cfc03066df8609ba9565ab6c20ee
Step #0 - "lint": Status: Downloaded newer image for gcr.io/datcom-ci/full-env:mixer-only-2026-02-20
Step #0 - "lint": gcr.io/datcom-ci/full-env:mixer-only-2026-02-20
Step #0 - "lint": level=info msg="golangci-lint has version 2.3.0 built with go1.24.4 from 364a4bbe on 2025-07-21T14:49:16Z"
Step #0 - "lint": level=info msg="[config_reader] Config search paths: [./ /workspace / /builder/home]"
Step #0 - "lint": level=info msg="[config_reader] Used config file .golangci.yml"
Step #0 - "lint": level=info msg="[config_reader] Module name \"github.com/datacommonsorg/mixer\""
Step #0 - "lint": level=info msg="maxprocs: Leaving GOMAXPROCS=32: CPU quota undefined"
Step #0 - "lint": level=info msg="[goenv] Read go env for 3.509864ms: map[string]string{\"GOCACHE\":\"/builder/home/.cache/go-build\", \"GOROOT\":\"/usr/local/go\"}"
Step #0 - "lint": level=info msg="[lintersdb] Active 5 linters: [errcheck govet ineffassign staticcheck unused]"
Step #0 - "lint": level=info msg="[loader] Go packages loading at mode 8767 (deps|compiled_files|exports_file|files|imports|name|types_sizes) took 35.287539146s"
Step #0 - "lint": level=info msg="[runner/filename_unadjuster] Pre-built 0 adjustments in 45.137276ms"
Step #0 - "lint": level=info msg="[linters_context/goanalysis] analyzers took 3m18.378277673s with top 10 stages: buildir: 1m58.373941271s, inspect: 3.820580678s, fact_deprecated: 3.336597723s, printf: 2.634062717s, nilness: 2.488667174s, ctrlflow: 2.3474355s, fact_purity: 2.25098323s, unused: 1.49454461s, isgenerated: 1.137444709s, typedness: 1.126864709s"
Step #0 - "lint": level=info msg="[runner/exclusion_paths] Skipped 252 issues by pattern \"internal/proto\""
Step #0 - "lint": level=info msg="[runner] Issues before processing: 270, after processing: 0"
Step #0 - "lint": level=info msg="[runner] Processors filtering stat (in/out): filename_unadjuster: 270/270, path_relativity: 270/270, path_absoluter: 270/270, cgo: 270/270, exclusion_paths: 270/18, exclusion_rules: 18/18, nolint_filter: 18/0, generated_file_filter: 18/18, invalid_issue: 270/270"
Step #0 - "lint": level=info msg="[runner] processing took 5.774599ms with stages: nolint_filter: 5.260215ms, generated_file_filter: 250.259µs, path_relativity: 121.474µs, exclusion_paths: 111.379µs, invalid_issue: 9.499µs, cgo: 7.505µs, path_absoluter: 5.227µs, sort_results: 2.529µs, filename_unadjuster: 2.299µs, max_same_issues: 1.082µs, exclusion_rules: 544ns, fixer: 535ns, uniq_by_line: 351ns, diff: 325ns, max_from_linter: 295ns, path_shortener: 270ns, path_prettifier: 225ns, source_code: 211ns, severity-rules: 207ns, max_per_file_from_linter: 168ns"
Step #0 - "lint": level=info msg="[runner] linters took 16.055097783s with stages: goanalysis_metalinter: 16.049242316s"
Step #0 - "lint": level=info msg="File cache stats: 0 entries of total size 0B"
Step #0 - "lint": 0 issues.
Step #0 - "lint": level=info msg="Memory: 515 samples, avg is 694.1MB, max is 2950.4MB"
Step #0 - "lint": level=info msg="Execution took 51.393194202s"
Finished Step #0 - "lint"
Starting Step #2 - "build-proto"
Starting Step #1 - "validate-feature-flags"
Step #2 - "build-proto": Already have image (with digest): gcr.io/datcom-ci/full-env:mixer-only-2026-02-20
Step #1 - "validate-feature-flags": Already have image (with digest): gcr.io/datcom-ci/full-env:mixer-only-2026-02-20
Step #1 - "validate-feature-flags": HEAD: Checking flags against mixer server at current HEAD.
Step #1 - "validate-feature-flags": Checking feature flag parsing for all envs in /workspace/deploy/featureflags...
Step #1 - "validate-feature-flags": Checking feature flag parsing for /workspace/deploy/featureflags/dev_website.yaml...
Step #1 - "validate-feature-flags": 2026/03/13 11:03:59 INFO Feature flags initialized from file path=/workspace/deploy/featureflags/dev_website.yaml flags="\nEnableV3: true\nV3MirrorFraction: 1\nUseSpannerGraph: true\nSpannerGraphDatabase: dc_graph_2026_01_27\nUseStaleReads: true\nEnableEmbeddingsResolver: true\nV2DivertFraction: 1\n"
Step #1 - "validate-feature-flags": Successfully validated /workspace/deploy/featureflags/dev_website.yaml
Step #1 - "validate-feature-flags": Checking feature flag parsing for /workspace/deploy/featureflags/prod_website.yaml...
Step #1 - "validate-feature-flags": Successfully validated /workspace/deploy/featureflags/prod_website.yaml
Step #1 - "validate-feature-flags": 2026/03/13 11:03:59 INFO Feature flags initialized from file path=/workspace/deploy/featureflags/prod_website.yaml flags="\nEnableV3: true\nV3MirrorFraction: 0.6\nUseSpannerGraph: true\nSpannerGraphDatabase: dc_graph_2026_01_27\nUseStaleReads: true\nEnableEmbeddingsResolver: true\nV2DivertFraction: 0\n"
Step #1 - "validate-feature-flags": Checking feature flag parsing for /workspace/deploy/featureflags/prod.yaml...
Step #1 - "validate-feature-flags": 2026/03/13 11:04:00 INFO Feature flags initialized from file path=/workspace/deploy/featureflags/prod.yaml flags="\nEnableV3: true\nV3MirrorFraction: 0.6\nUseSpannerGraph: true\nSpannerGraphDatabase: dc_graph_2026_01_27\nUseStaleReads: true\nEnableEmbeddingsResolver: true\nV2DivertFraction: 0\n"
Step #1 - "validate-feature-flags": Successfully validated /workspace/deploy/featureflags/prod.yaml
Step #1 - "validate-feature-flags": Checking feature flag parsing for /workspace/deploy/featureflags/dev.yaml...
Step #1 - "validate-feature-flags": 2026/03/13 11:04:00 INFO Feature flags initialized from file path=/workspace/deploy/featureflags/dev.yaml flags="\nEnableV3: true\nV3MirrorFraction: 1\nUseSpannerGraph: true\nSpannerGraphDatabase: dc_graph_2026_01_27\nUseStaleReads: true\nEnableEmbeddingsResolver: true\nV2DivertFraction: 1\n"
Step #1 - "validate-feature-flags": Successfully validated /workspace/deploy/featureflags/dev.yaml
Step #1 - "validate-feature-flags": Checking feature flag parsing for /workspace/deploy/featureflags/staging_website.yaml...
Step #1 - "validate-feature-flags": Successfully validated /workspace/deploy/featureflags/staging_website.yaml
Step #1 - "validate-feature-flags": 2026/03/13 11:04:00 INFO Feature flags initialized from file path=/workspace/deploy/featureflags/staging_website.yaml flags="\nEnableV3: true\nV3MirrorFraction: 1\nUseSpannerGraph: true\nSpannerGraphDatabase: dc_graph_2026_01_27\nUseStaleReads: true\nEnableEmbeddingsResolver: true\nV2DivertFraction: 0\n"
Step #1 - "validate-feature-flags": Checking feature flag parsing for /workspace/deploy/featureflags/local.yaml...
Finished Step #2 - "build-proto"
Starting Step #3 - "test"
Step #3 - "test": Already have image (with digest): gcr.io/datcom-ci/full-env:mixer-only-2026-02-20
Step #1 - "validate-feature-flags": Successfully validated /workspace/deploy/featureflags/local.yaml
Step #1 - "validate-feature-flags": 2026/03/13 11:04:00 INFO Feature flags initialized from file path=/workspace/deploy/featureflags/local.yaml flags="\nEnableV3: true\nV3MirrorFraction: 1\nUseSpannerGraph: true\nSpannerGraphDatabase: \"\"\nUseStaleReads: true\nEnableEmbeddingsResolver: true\nV2DivertFraction: 1\n"
Step #1 - "validate-feature-flags": Checking feature flag parsing for /workspace/deploy/featureflags/autopush_website.yaml...
Step #1 - "validate-feature-flags": Successfully validated /workspace/deploy/featureflags/autopush_website.yaml
Step #1 - "validate-feature-flags": 2026/03/13 11:04:00 INFO Feature flags initialized from file path=/workspace/deploy/featureflags/autopush_website.yaml flags="\nEnableV3: false\nV3MirrorFraction: 0\nUseSpannerGraph: false\nSpannerGraphDatabase: \"\"\nUseStaleReads: false\nEnableEmbeddingsResolver: true\nV2DivertFraction: 0\n"
Step #1 - "validate-feature-flags": Checking feature flag parsing for /workspace/deploy/featureflags/staging.yaml...
Step #1 - "validate-feature-flags": Successfully validated /workspace/deploy/featureflags/staging.yaml
Step #1 - "validate-feature-flags": 2026/03/13 11:04:00 INFO Feature flags initialized from file path=/workspace/deploy/featureflags/staging.yaml flags="\nEnableV3: true\nV3MirrorFraction: 1\nUseSpannerGraph: true\nSpannerGraphDatabase: dc_graph_2026_01_27\nUseStaleReads: true\nEnableEmbeddingsResolver: true\nV2DivertFraction: 0\n"
Step #1 - "validate-feature-flags": Checking feature flag parsing for /workspace/deploy/featureflags/autopush.yaml...
Step #1 - "validate-feature-flags": 2026/03/13 11:04:00 INFO Feature flags initialized from file path=/workspace/deploy/featureflags/autopush.yaml flags="\nEnableV3: false\nV3MirrorFraction: 0\nUseSpannerGraph: false\nSpannerGraphDatabase: \"\"\nUseStaleReads: false\nEnableEmbeddingsResolver: true\nV2DivertFraction: 0\n"
Step #1 - "validate-feature-flags": Successfully validated /workspace/deploy/featureflags/autopush.yaml
Finished Step #1 - "validate-feature-flags"
Step #3 - "test": ?   	github.com/datacommonsorg/mixer/cmd	[no test files]
Step #3 - "test": ?   	github.com/datacommonsorg/mixer/cmd/tools	[no test files]
Step #3 - "test": ?   	github.com/datacommonsorg/mixer/examples/api	[no test files]
Step #3 - "test": === RUN   TestNewFlags
Step #3 - "test": === RUN   TestNewFlags/file_not_found
Step #3 - "test": 2026/03/13 11:04:12 WARN Feature flags file not found. Using default flag values. path=/tmp/TestNewFlagsfile_not_found2144597980/001/non_existent_file.yaml flags="\nEnableV3: false\nV3MirrorFraction: 0\nUseSpannerGraph: false\nSpannerGraphDatabase: \"\"\nUseStaleReads: false\nEnableEmbeddingsResolver: true\nV2DivertFraction: 0\n"
Step #3 - "test": === RUN   TestNewFlags/invalid_yaml
Step #3 - "test": === RUN   TestNewFlags/partial_flags
Step #3 - "test": 2026/03/13 11:04:12 INFO Feature flags initialized from file path=/tmp/TestNewFlagspartial_flags1310055834/001/featureflags-1677731493.yaml flags="\nEnableV3: true\nV3MirrorFraction: 0\nUseSpannerGraph: false\nSpannerGraphDatabase: \"\"\nUseStaleReads: false\nEnableEmbeddingsResolver: true\nV2DivertFraction: 0\n"
Step #3 - "test": === RUN   TestNewFlags/all_flags
Step #3 - "test": 2026/03/13 11:04:12 INFO Feature flags initialized from file path=/tmp/TestNewFlagsall_flags509780500/001/featureflags-3897952229.yaml flags="\nEnableV3: true\nV3MirrorFraction: 0.7\nUseSpannerGraph: false\nSpannerGraphDatabase: \"\"\nUseStaleReads: false\nEnableEmbeddingsResolver: true\nV2DivertFraction: 0\n"
Step #3 - "test": === RUN   TestNewFlags/cluster_details_with_flag_values
Step #3 - "test": 2026/03/13 11:04:12 INFO Feature flags initialized from file path=/tmp/TestNewFlagscluster_details_with_flag_values3750002357/001/featureflags-1769656924.yaml flags="\nEnableV3: true\nV3MirrorFraction: 0.7\nUseSpannerGraph: false\nSpannerGraphDatabase: \"\"\nUseStaleReads: false\nEnableEmbeddingsResolver: true\nV2DivertFraction: 0\n"
Step #3 - "test": === RUN   TestNewFlags/cluster_details_without_flag_values
Step #3 - "test": 2026/03/13 11:04:12 INFO Feature flags initialized from file path=/tmp/TestNewFlagscluster_details_without_flag_values2881836151/001/featureflags-3247967145.yaml flags="\nEnableV3: false\nV3MirrorFraction: 0\nUseSpannerGraph: false\nSpannerGraphDatabase: \"\"\nUseStaleReads: false\nEnableEmbeddingsResolver: true\nV2DivertFraction: 0\n"
Step #3 - "test": === RUN   TestNewFlags/validation_error_-_fraction_too_high
Step #3 - "test": === RUN   TestNewFlags/validation_error_-_fraction_too_low
Step #3 - "test": === RUN   TestNewFlags/validation_error_-_mirror_without_v3
Step #3 - "test": --- PASS: TestNewFlags (0.01s)
Step #3 - "test":     --- PASS: TestNewFlags/file_not_found (0.00s)
Step #3 - "test":     --- PASS: TestNewFlags/invalid_yaml (0.00s)
Step #3 - "test":     --- PASS: TestNewFlags/partial_flags (0.00s)
Step #3 - "test":     --- PASS: TestNewFlags/all_flags (0.00s)
Step #3 - "test":     --- PASS: TestNewFlags/cluster_details_with_flag_values (0.00s)
Step #3 - "test":     --- PASS: TestNewFlags/cluster_details_without_flag_values (0.00s)
Step #3 - "test":     --- PASS: TestNewFlags/validation_error_-_fraction_too_high (0.00s)
Step #3 - "test":     --- PASS: TestNewFlags/validation_error_-_fraction_too_low (0.00s)
Step #3 - "test":     --- PASS: TestNewFlags/validation_error_-_mirror_without_v3 (0.00s)
Step #3 - "test": PASS
Step #3 - "test": ok  	github.com/datacommonsorg/mixer/internal/featureflags	0.011s
Step #3 - "test": ?   	github.com/datacommonsorg/mixer/internal/log	[no test files]
Step #3 - "test": ?   	github.com/datacommonsorg/mixer/internal/maps	[no test files]
Step #3 - "test": === RUN   TestMergeResolve
Step #3 - "test": === RUN   TestMergeResolve/Basic_merge_with_overlapping_nodes_and_new_candidates
Step #3 - "test": === RUN   TestMergeResolve/Merge_with_score-based_sorting_and_isolated_nodes
Step #3 - "test": --- PASS: TestMergeResolve (0.00s)
Step #3 - "test":     --- PASS: TestMergeResolve/Basic_merge_with_overlapping_nodes_and_new_candidates (0.00s)
Step #3 - "test":     --- PASS: TestMergeResolve/Merge_with_score-based_sorting_and_isolated_nodes (0.00s)
Step #3 - "test": === RUN   TestMergeLinkedGraph
Step #3 - "test": --- PASS: TestMergeLinkedGraph (0.00s)
Step #3 - "test": === RUN   TestMergeNode
Step #3 - "test": --- PASS: TestMergeNode (0.01s)
Step #3 - "test": === RUN   TestMergeMultiNode
Step #3 - "test": --- PASS: TestMergeMultiNode (0.01s)
Step #3 - "test": === RUN   TestMergeEvent
Step #3 - "test": --- PASS: TestMergeEvent (0.00s)
Step #3 - "test": === RUN   TestMergeObservation
Step #3 - "test": --- PASS: TestMergeObservation (0.00s)
Step #3 - "test": === RUN   TestMergeMultiObservation
Step #3 - "test": --- PASS: TestMergeMultiObservation (0.00s)
Step #3 - "test": === RUN   TestMergeBulkVariableInfoResponse
Step #3 - "test": --- PASS: TestMergeBulkVariableInfoResponse (0.00s)
Step #3 - "test": === RUN   TestMergeSearchStatVarResponse
Step #3 - "test": --- PASS: TestMergeSearchStatVarResponse (0.00s)
Step #3 - "test": === RUN   TestMergeFilterStatVarsByEntityResponse
Step #3 - "test": --- PASS: TestMergeFilterStatVarsByEntityResponse (0.00s)
Step #3 - "test": === RUN   TestMergeMultiNodeSearch
Step #3 - "test": --- PASS: TestMergeMultiNodeSearch (0.00s)
Step #3 - "test": === RUN   TestMergeMultiQueryResponse
Step #3 - "test": --- PASS: TestMergeMultiQueryResponse (0.00s)
Step #3 - "test": PASS
Step #3 - "test": ok  	github.com/datacommonsorg/mixer/internal/merger	0.039s
Step #3 - "test": ?   	github.com/datacommonsorg/mixer/internal/metrics	[no test files]
Step #3 - "test": === RUN   TestParseMapping
Step #3 - "test": --- PASS: TestParseMapping (0.00s)
Step #3 - "test": PASS
Step #3 - "test": ok  	github.com/datacommonsorg/mixer/internal/parser/mcf	0.004s
Step #3 - "test": === RUN   TestParseComplexValue
Step #3 - "test": --- PASS: TestParseComplexValue (0.00s)
Step #3 - "test": === RUN   TestParseMcf
Step #3 - "test": --- PASS: TestParseMcf (0.00s)
Step #3 - "test": PASS
Step #3 - "test": ok  	github.com/datacommonsorg/mixer/internal/parser/tmcf	0.005s
Step #3 - "test": ?   	github.com/datacommonsorg/mixer/internal/proto	[no test files]
Step #3 - "test": ?   	github.com/datacommonsorg/mixer/internal/proto/service	[no test files]
Step #3 - "test": ?   	github.com/datacommonsorg/mixer/internal/proto/v1	[no test files]
Step #3 - "test": ?   	github.com/datacommonsorg/mixer/internal/proto/v2	[no test files]
Step #3 - "test": ?   	github.com/datacommonsorg/mixer/internal/proto/v3	[no test files]
Step #3 - "test": ?   	github.com/datacommonsorg/mixer/internal/pubsub	[no test files]
Step #3 - "test": === RUN   TestBulkVariableInfo
Step #3 - "test": === PAUSE TestBulkVariableInfo
Step #3 - "test": === RUN   TestUseMetadata
Step #3 - "test": 2026/03/13 11:04:12 WARN Error: There was a problem accessing the request's metadata err=false
Step #3 - "test": --- PASS: TestUseMetadata (0.00s)
Step #3 - "test": === RUN   TestObservationInternal
Step #3 - "test": --- PASS: TestObservationInternal (0.00s)
Step #3 - "test": === RUN   TestV2Observation_UsageLog
Step #3 - "test": --- PASS: TestV2Observation_UsageLog (0.00s)
Step #3 - "test": === RUN   TestResolveRouting
Step #3 - "test": === RUN   TestResolveRouting/Base_instance_(empty_remote_domain)
Step #3 - "test": === RUN   TestResolveRouting/Custom_instance,_target_base_only
Step #3 - "test": === RUN   TestResolveRouting/Custom_instance,_target_custom_only
Step #3 - "test": === RUN   TestResolveRouting/Custom_instance,_target_base_and_custom
Step #3 - "test": --- PASS: TestResolveRouting (0.00s)
Step #3 - "test":     --- PASS: TestResolveRouting/Base_instance_(empty_remote_domain) (0.00s)
Step #3 - "test":     --- PASS: TestResolveRouting/Custom_instance,_target_base_only (0.00s)
Step #3 - "test":     --- PASS: TestResolveRouting/Custom_instance,_target_custom_only (0.00s)
Step #3 - "test":     --- PASS: TestResolveRouting/Custom_instance,_target_base_and_custom (0.00s)
Step #3 - "test": === RUN   TestValidateAndParseResolveInputs
Step #3 - "test": === RUN   TestValidateAndParseResolveInputs/all_empty
Step #3 - "test": === RUN   TestValidateAndParseResolveInputs/partial_set_-_target
Step #3 - "test": === RUN   TestValidateAndParseResolveInputs/partial_set_-_resolver
Step #3 - "test": === RUN   TestValidateAndParseResolveInputs/fully_set
Step #3 - "test": === RUN   TestValidateAndParseResolveInputs/typeOf_filter
Step #3 - "test": === RUN   TestValidateAndParseResolveInputs/invalid_target
Step #3 - "test": === RUN   TestValidateAndParseResolveInputs/invalid_resolver
Step #3 - "test": === RUN   TestValidateAndParseResolveInputs/invalid_target_and_resolver
Step #3 - "test": === RUN   TestValidateAndParseResolveInputs/invalid_property_expression
Step #3 - "test": === RUN   TestValidateAndParseResolveInputs/unknown_property_for_place_resolver
Step #3 - "test": === RUN   TestValidateAndParseResolveInputs/invalid_property_for_indicator_resolver_(inProp)
Step #3 - "test": === RUN   TestValidateAndParseResolveInputs/invalid_property_for_indicator_resolver_(outProp)
Step #3 - "test": === RUN   TestValidateAndParseResolveInputs/invalid_target_+_valid_unknown_property
Step #3 - "test": === RUN   TestValidateAndParseResolveInputs/invalid_output_property_for_place_(description)
Step #3 - "test": --- PASS: TestValidateAndParseResolveInputs (0.00s)
Step #3 - "test":     --- PASS: TestValidateAndParseResolveInputs/all_empty (0.00s)
Step #3 - "test":     --- PASS: TestValidateAndParseResolveInputs/partial_set_-_target (0.00s)
Step #3 - "test":     --- PASS: TestValidateAndParseResolveInputs/partial_set_-_resolver (0.00s)
Step #3 - "test":     --- PASS: TestValidateAndParseResolveInputs/fully_set (0.00s)
Step #3 - "test":     --- PASS: TestValidateAndParseResolveInputs/typeOf_filter (0.00s)
Step #3 - "test":     --- PASS: TestValidateAndParseResolveInputs/invalid_target (0.00s)
Step #3 - "test":     --- PASS: TestValidateAndParseResolveInputs/invalid_resolver (0.00s)
Step #3 - "test":     --- PASS: TestValidateAndParseResolveInputs/invalid_target_and_resolver (0.00s)
Step #3 - "test":     --- PASS: TestValidateAndParseResolveInputs/invalid_property_expression (0.00s)
Step #3 - "test":     --- PASS: TestValidateAndParseResolveInputs/unknown_property_for_place_resolver (0.00s)
Step #3 - "test":     --- PASS: TestValidateAndParseResolveInputs/invalid_property_for_indicator_resolver_(inProp) (0.00s)
Step #3 - "test":     --- PASS: TestValidateAndParseResolveInputs/invalid_property_for_indicator_resolver_(outProp) (0.00s)
Step #3 - "test":     --- PASS: TestValidateAndParseResolveInputs/invalid_target_+_valid_unknown_property (0.00s)
Step #3 - "test":     --- PASS: TestValidateAndParseResolveInputs/invalid_output_property_for_place_(description) (0.00s)
Step #3 - "test": === RUN   TestMaybeMirrorV3_Percentage
Step #3 - "test": === RUN   TestMaybeMirrorV3_Percentage/0_percent
Step #3 - "test": === RUN   TestMaybeMirrorV3_Percentage/100_percent
Step #3 - "test": --- PASS: TestMaybeMirrorV3_Percentage (0.10s)
Step #3 - "test":     --- PASS: TestMaybeMirrorV3_Percentage/0_percent (0.10s)
Step #3 - "test":     --- PASS: TestMaybeMirrorV3_Percentage/100_percent (0.00s)
Step #3 - "test": === RUN   TestMaybeMirrorV3_IgnoreSubsequentPages
Step #3 - "test": --- PASS: TestMaybeMirrorV3_IgnoreSubsequentPages (0.00s)
Step #3 - "test": === RUN   TestMaybeMirrorV3_LatencyMetric
Step #3 - "test": --- PASS: TestMaybeMirrorV3_LatencyMetric (0.00s)
Step #3 - "test": === RUN   TestMaybeMirrorV3_ObservationResponseMismatch
Step #3 - "test": --- PASS: TestMaybeMirrorV3_ObservationResponseMismatch (0.01s)
Step #3 - "test": === RUN   TestMaybeMirrorV3_NodeResponseMismatch
Step #3 - "test": --- PASS: TestMaybeMirrorV3_NodeResponseMismatch (0.00s)
Step #3 - "test": === RUN   TestMaybeMirrorV3_ResponseMatch
Step #3 - "test": --- PASS: TestMaybeMirrorV3_ResponseMatch (0.00s)
Step #3 - "test": === RUN   TestMaybeMirrorV3_V3Error
Step #3 - "test": --- PASS: TestMaybeMirrorV3_V3Error (0.00s)
Step #3 - "test": === RUN   TestMaybeMirrorV3_NodeIgnoresNextTokenMismatch
Step #3 - "test": --- PASS: TestMaybeMirrorV3_NodeIgnoresNextTokenMismatch (0.00s)
Step #3 - "test": === RUN   TestMaybeMirrorV3_ObservationIgnoresFacetIdsAndMapOrder
Step #3 - "test": --- PASS: TestMaybeMirrorV3_ObservationIgnoresFacetIdsAndMapOrder (0.01s)
Step #3 - "test": === RUN   TestMaybeMirrorV3_SlowQueryLogging
Step #3 - "test": --- PASS: TestMaybeMirrorV3_SlowQueryLogging (0.00s)
Step #3 - "test": === RUN   TestV2ResolveCore_EmbeddingsFlag
Step #3 - "test": --- PASS: TestV2ResolveCore_EmbeddingsFlag (0.00s)
Step #3 - "test": === CONT  TestBulkVariableInfo
Step #3 - "test": --- PASS: TestBulkVariableInfo (0.00s)
Step #3 - "test": PASS
Step #3 - "test": ok  	github.com/datacommonsorg/mixer/internal/server	0.164s
Step #3 - "test": ?   	github.com/datacommonsorg/mixer/internal/server/cache	[no test files]
Step #3 - "test": ?   	github.com/datacommonsorg/mixer/internal/server/convert	[no test files]
Step #3 - "test": ?   	github.com/datacommonsorg/mixer/internal/server/count	[no test files]
Step #3 - "test": ?   	github.com/datacommonsorg/mixer/internal/server/datasource	[no test files]
Step #3 - "test": ?   	github.com/datacommonsorg/mixer/internal/server/datasources	[no test files]
Step #3 - "test": ?   	github.com/datacommonsorg/mixer/internal/server/dispatcher	[no test files]
Step #3 - "test": ?   	github.com/datacommonsorg/mixer/internal/server/healthcheck	[no test files]
Step #3 - "test": ?   	github.com/datacommonsorg/mixer/internal/server/model	[no test files]
Step #3 - "test": ?   	github.com/datacommonsorg/mixer/internal/server/node	[no test files]
Step #3 - "test": === RUN   TestDecode
Step #3 - "test": --- PASS: TestDecode (0.00s)
Step #3 - "test": === RUN   TestDecodeNextToken
Step #3 - "test": --- PASS: TestDecodeNextToken (0.00s)
Step #3 - "test": PASS
Step #3 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/pagination	0.015s
Step #3 - "test": ?   	github.com/datacommonsorg/mixer/internal/server/place	[no test files]
Step #3 - "test": === RUN   TestGetLocationsRankings
Step #3 - "test": === PAUSE TestGetLocationsRankings
Step #3 - "test": === RUN   TestGetRelatedLocations
Step #3 - "test": === PAUSE TestGetRelatedLocations
Step #3 - "test": === CONT  TestGetLocationsRankings
Step #3 - "test": === CONT  TestGetRelatedLocations
Step #3 - "test": 2026/03/13 11:04:21 INFO No feature flag path specified. Using default flag values. flags="\nEnableV3: false\nV3MirrorFraction: 0\nUseSpannerGraph: false\nSpannerGraphDatabase: \"\"\nUseStaleReads: false\nEnableEmbeddingsResolver: true\nV2DivertFraction: 0\n"
Step #3 - "test": 2026/03/13 11:04:22 INFO No feature flag path specified. Using default flag values. flags="\nEnableV3: false\nV3MirrorFraction: 0\nUseSpannerGraph: false\nSpannerGraphDatabase: \"\"\nUseStaleReads: false\nEnableEmbeddingsResolver: true\nV2DivertFraction: 0\n"
Step #3 - "test": --- PASS: TestGetRelatedLocations (10.01s)
Step #3 - "test": --- PASS: TestGetLocationsRankings (10.16s)
Step #3 - "test": PASS
Step #3 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/place/golden	10.292s
Step #3 - "test": ?   	github.com/datacommonsorg/mixer/internal/server/placein	[no test files]
Step #3 - "test": === RUN   TestGetPlacesIn
Step #3 - "test": === PAUSE TestGetPlacesIn
Step #3 - "test": === CONT  TestGetPlacesIn
Step #3 - "test": 2026/03/13 11:04:19 INFO No feature flag path specified. Using default flag values. flags="\nEnableV3: false\nV3MirrorFraction: 0\nUseSpannerGraph: false\nSpannerGraphDatabase: \"\"\nUseStaleReads: false\nEnableEmbeddingsResolver: true\nV2DivertFraction: 0\n"
Step #3 - "test": --- PASS: TestGetPlacesIn (7.09s)
Step #3 - "test": PASS
Step #3 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/placein/golden	7.133s
Step #3 - "test": === RUN   TestGetScorePb
Step #3 - "test": --- PASS: TestGetScorePb (0.00s)
Step #3 - "test": === RUN   TestSeriesByRank
Step #3 - "test": --- PASS: TestSeriesByRank (0.00s)
Step #3 - "test": PASS
Step #3 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/ranking	0.007s
Step #3 - "test": === RUN   TestIsContainedIn
Step #3 - "test": --- PASS: TestIsContainedIn (0.20s)
Step #3 - "test": === RUN   TestFindEntities
Step #3 - "test": === RUN   TestFindEntities/FromStore
Step #3 - "test": === RUN   TestFindEntities/EmptyResponse
Step #3 - "test": --- PASS: TestFindEntities (0.00s)
Step #3 - "test":     --- PASS: TestFindEntities/FromStore (0.00s)
Step #3 - "test":     --- PASS: TestFindEntities/EmptyResponse (0.00s)
Step #3 - "test": === RUN   TestFindEntitiesFromMapsApi
Step #3 - "test": --- PASS: TestFindEntitiesFromMapsApi (0.03s)
Step #3 - "test": === RUN   TestTokenize
Step #3 - "test": --- PASS: TestTokenize (0.00s)
Step #3 - "test": === RUN   TestFindPlaceCandidates
Step #3 - "test": --- PASS: TestFindPlaceCandidates (0.00s)
Step #3 - "test": === RUN   TestReplaceTokensWithCandidates
Step #3 - "test": --- PASS: TestReplaceTokensWithCandidates (0.00s)
Step #3 - "test": === RUN   TestCombineContainedIn
Step #3 - "test": --- PASS: TestCombineContainedIn (0.00s)
Step #3 - "test": === RUN   TestRankAndTrimCandidates
Step #3 - "test": --- PASS: TestRankAndTrimCandidates (0.00s)
Step #3 - "test": === RUN   TestGetId2Span
Step #3 - "test": --- PASS: TestGetId2Span (0.00s)
Step #3 - "test": === RUN   TestSplitQueryBySpan
Step #3 - "test": --- PASS: TestSplitQueryBySpan (0.00s)
Step #3 - "test": === RUN   TestGetItemsForSpans
Step #3 - "test": --- PASS: TestGetItemsForSpans (0.00s)
Step #3 - "test": PASS
Step #3 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/recon	0.286s
Step #3 - "test": === RUN   TestFindEntities
Step #3 - "test": === PAUSE TestFindEntities
Step #3 - "test": === RUN   TestRecognizeEntities
Step #3 - "test": === PAUSE TestRecognizeEntities
Step #3 - "test": === RUN   TestRecognizePlaces
Step #3 - "test": === PAUSE TestRecognizePlaces
Step #3 - "test": === RUN   TestResolveCoordinates
Step #3 - "test": === PAUSE TestResolveCoordinates
Step #3 - "test": === RUN   TestResolveEntities
Step #3 - "test": === PAUSE TestResolveEntities
Step #3 - "test": === RUN   TestResolveIds
Step #3 - "test": === PAUSE TestResolveIds
Step #3 - "test": === CONT  TestFindEntities
Step #3 - "test": === CONT  TestResolveCoordinates
Step #3 - "test": === CONT  TestResolveIds
Step #3 - "test": === CONT  TestRecognizePlaces
Step #3 - "test": === CONT  TestResolveEntities
Step #3 - "test": === CONT  TestRecognizeEntities
Step #3 - "test": 2026/03/13 11:04:26 INFO No feature flag path specified. Using default flag values. flags="\nEnableV3: false\nV3MirrorFraction: 0\nUseSpannerGraph: false\nSpannerGraphDatabase: \"\"\nUseStaleReads: false\nEnableEmbeddingsResolver: true\nV2DivertFraction: 0\n"
Step #3 - "test": --- PASS: TestRecognizePlaces (13.82s)
Step #3 - "test": 2026/03/13 11:04:26 INFO No feature flag path specified. Using default flag values. flags="\nEnableV3: false\nV3MirrorFraction: 0\nUseSpannerGraph: false\nSpannerGraphDatabase: \"\"\nUseStaleReads: false\nEnableEmbeddingsResolver: true\nV2DivertFraction: 0\n"
Step #3 - "test": 2026/03/13 11:04:26 INFO No feature flag path specified. Using default flag values. flags="\nEnableV3: false\nV3MirrorFraction: 0\nUseSpannerG
...
[Logs truncated due to log size limitations. For full logs, see https://console.cloud.google.com/cloud-build/builds/bc38caad-d4d2-42cd-90a8-1d161dfbf817?project=879489846695.]
...
 - "test": 2026/03/13 11:04:18 INFO Connected to sqlite db path=/workspace/test/datacommons.db
Step #3 - "test": 2026/03/13 11:04:18 INFO SQL tables check succeeded.
Step #3 - "test": 2026/03/13 11:04:18 INFO SQL schema check succeeded.
Step #3 - "test": 2026/03/13 11:04:25 INFO Tracked function execution time name="SQL: GetAllProvenances" duration=671.891µs
Step #3 - "test": 2026/03/13 11:04:25 INFO Tracked function execution time name="SQL: GetAllEntitiesAndVariables" duration=353.551µs
Step #3 - "test": 2026/03/13 11:04:25 INFO No feature flag path specified. Using default flag values. flags="\nEnableV3: false\nV3MirrorFraction: 0\nUseSpannerGraph: false\nSpannerGraphDatabase: \"\"\nUseStaleReads: false\nEnableEmbeddingsResolver: true\nV2DivertFraction: 0\n"
Step #3 - "test": 2026/03/13 11:04:25 INFO Tracked function execution time name="SQL: GetNodePredicates" duration=474.174µs
Step #3 - "test": 2026/03/13 11:04:25 INFO Tracked function execution time name="SQL: GetNodePredicates" duration=361.839µs
Step #3 - "test": --- PASS: TestPropertiesV2 (6.89s)
Step #3 - "test": PASS
Step #3 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/v2/properties/golden	7.127s
Step #3 - "test": ?   	github.com/datacommonsorg/mixer/internal/server/v2/propertyvalues	[no test files]
Step #3 - "test": === RUN   TestContainedInPlace
Step #3 - "test": === PAUSE TestContainedInPlace
Step #3 - "test": === RUN   TestSimplePropertyValues
Step #3 - "test": === PAUSE TestSimplePropertyValues
Step #3 - "test": === RUN   TestSpecializationOf
Step #3 - "test": === PAUSE TestSpecializationOf
Step #3 - "test": === RUN   TestTripleIn
Step #3 - "test": === PAUSE TestTripleIn
Step #3 - "test": === RUN   TestTripleOut
Step #3 - "test": === PAUSE TestTripleOut
Step #3 - "test": === CONT  TestContainedInPlace
Step #3 - "test": === CONT  TestTripleOut
Step #3 - "test": === CONT  TestTripleIn
Step #3 - "test": === CONT  TestSpecializationOf
Step #3 - "test": === CONT  TestSimplePropertyValues
Step #3 - "test": 2026/03/13 11:04:19 INFO Connected to sqlite db path=/workspace/test/datacommons.db
Step #3 - "test": 2026/03/13 11:04:19 INFO SQL tables check succeeded.
Step #3 - "test": 2026/03/13 11:04:19 INFO SQL schema check succeeded.
Step #3 - "test": 2026/03/13 11:04:19 INFO Connected to sqlite db path=/workspace/test/datacommons.db
Step #3 - "test": 2026/03/13 11:04:19 INFO SQL tables check succeeded.
Step #3 - "test": 2026/03/13 11:04:19 INFO SQL schema check succeeded.
Step #3 - "test": 2026/03/13 11:04:19 INFO Connected to sqlite db path=/workspace/test/datacommons.db
Step #3 - "test": 2026/03/13 11:04:19 INFO Connected to sqlite db path=/workspace/test/datacommons.db
Step #3 - "test": 2026/03/13 11:04:19 INFO SQL tables check succeeded.
Step #3 - "test": 2026/03/13 11:04:19 INFO SQL schema check succeeded.
Step #3 - "test": 2026/03/13 11:04:19 INFO SQL tables check succeeded.
Step #3 - "test": 2026/03/13 11:04:19 INFO SQL schema check succeeded.
Step #3 - "test": 2026/03/13 11:04:28 INFO Tracked function execution time name="SQL: GetAllProvenances" duration=806.565µs
Step #3 - "test": 2026/03/13 11:04:28 INFO Tracked function execution time name="SQL: GetAllEntitiesAndVariables" duration=447.509µs
Step #3 - "test": 2026/03/13 11:04:28 INFO No feature flag path specified. Using default flag values. flags="\nEnableV3: false\nV3MirrorFraction: 0\nUseSpannerGraph: false\nSpannerGraphDatabase: \"\"\nUseStaleReads: false\nEnableEmbeddingsResolver: true\nV2DivertFraction: 0\n"
Step #3 - "test": 2026/03/13 11:04:28 INFO Tracked function execution time name="SQL: GetAllProvenances" duration=1.272846ms
Step #3 - "test": 2026/03/13 11:04:28 INFO Tracked function execution time name="SQL: GetAllEntitiesAndVariables" duration=454.267µs
Step #3 - "test": 2026/03/13 11:04:28 INFO No feature flag path specified. Using default flag values. flags="\nEnableV3: false\nV3MirrorFraction: 0\nUseSpannerGraph: false\nSpannerGraphDatabase: \"\"\nUseStaleReads: false\nEnableEmbeddingsResolver: true\nV2DivertFraction: 0\n"
Step #3 - "test": 2026/03/13 11:04:28 INFO Tracked function execution time name="SQL: GetAllProvenances" duration=683.481µs
Step #3 - "test": 2026/03/13 11:04:28 INFO Tracked function execution time name="SQL: GetAllEntitiesAndVariables" duration=395.03µs
Step #3 - "test": 2026/03/13 11:04:28 INFO No feature flag path specified. Using default flag values. flags="\nEnableV3: false\nV3MirrorFraction: 0\nUseSpannerGraph: false\nSpannerGraphDatabase: \"\"\nUseStaleReads: false\nEnableEmbeddingsResolver: true\nV2DivertFraction: 0\n"
Step #3 - "test": 2026/03/13 11:04:28 WARN Could not read blocklist svg file. Use empty blocklist svg list.
Step #3 - "test": 2026/03/13 11:04:28 INFO Tracked function execution time name="SQL: GetContainedInPlace" duration=355.578µs
Step #3 - "test": 2026/03/13 11:04:29 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=869.881µs
Step #3 - "test": 2026/03/13 11:04:29 INFO Tracked function execution time name="SQL: GetNodeTriples" duration=1.227219ms
Step #3 - "test": 2026/03/13 11:04:29 INFO Tracked function execution time name="SQL: GetEntityInfoTriples" duration=258.431µs
Step #3 - "test": 2026/03/13 11:04:29 INFO Tracked function execution time name="SQL: GetAllProvenances" duration=571.219µs
Step #3 - "test": 2026/03/13 11:04:29 INFO Tracked function execution time name="SQL: GetAllEntitiesAndVariables" duration=360.032µs
Step #3 - "test": 2026/03/13 11:04:29 INFO No feature flag path specified. Using default flag values. flags="\nEnableV3: false\nV3MirrorFraction: 0\nUseSpannerGraph: false\nSpannerGraphDatabase: \"\"\nUseStaleReads: false\nEnableEmbeddingsResolver: true\nV2DivertFraction: 0\n"
Step #3 - "test": 2026/03/13 11:04:29 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=26.396616ms
Step #3 - "test": 2026/03/13 11:04:29 INFO Tracked function execution time name="SQL: GetNodeTriples" duration=26.48795ms
Step #3 - "test": 2026/03/13 11:04:29 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=538.81µs
Step #3 - "test": 2026/03/13 11:04:29 INFO Tracked function execution time name="SQL: GetNodeTriples" duration=587.735µs
Step #3 - "test": 2026/03/13 11:04:29 INFO Tracked function execution time name="SQL: GetNodePredicates" duration=485.352µs
Step #3 - "test": 2026/03/13 11:04:29 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=606.337µs
Step #3 - "test": 2026/03/13 11:04:29 INFO Tracked function execution time name="SQL: GetNodeTriples" duration=676.154µs
Step #3 - "test": 2026/03/13 11:04:29 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=53.681996ms
Step #3 - "test": 2026/03/13 11:04:29 INFO Tracked function execution time name="SQL: GetNodeTriples" duration=53.842938ms
Step #3 - "test": 2026/03/13 11:04:29 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=52.168864ms
Step #3 - "test": 2026/03/13 11:04:29 INFO Tracked function execution time name="SQL: GetNodeTriples" duration=52.25316ms
Step #3 - "test": 2026/03/13 11:04:29 INFO Tracked function execution time name="SQL: GetEntityInfoTriples" duration=338.114µs
Step #3 - "test": 2026/03/13 11:04:29 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=15.793011ms
Step #3 - "test": 2026/03/13 11:04:29 INFO Tracked function execution time name="SQL: GetNodeTriples" duration=15.92485ms
Step #3 - "test": 2026/03/13 11:04:29 INFO Tracked function execution time name="SQL: GetNodePredicates" duration=451.617µs
Step #3 - "test": 2026/03/13 11:04:29 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=17.537716ms
Step #3 - "test": 2026/03/13 11:04:29 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=34.359022ms
Step #3 - "test": 2026/03/13 11:04:29 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=36.46183ms
Step #3 - "test": 2026/03/13 11:04:29 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=38.198119ms
Step #3 - "test": 2026/03/13 11:04:29 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=39.115295ms
Step #3 - "test": 2026/03/13 11:04:29 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=40.496027ms
Step #3 - "test": 2026/03/13 11:04:29 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=41.350027ms
Step #3 - "test": 2026/03/13 11:04:29 INFO Tracked function execution time name="SQL: GetNodeTriples" duration=41.644662ms
Step #3 - "test": 2026/03/13 11:04:29 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=1.008758ms
Step #3 - "test": 2026/03/13 11:04:29 INFO Tracked function execution time name="SQL: GetNodeTriples" duration=1.068397ms
Step #3 - "test": 2026/03/13 11:04:29 INFO Tracked function execution time name="SQL: GetEntityInfoTriples" duration=218.733µs
Step #3 - "test": --- PASS: TestTripleOut (10.40s)
Step #3 - "test": 2026/03/13 11:04:29 INFO Tracked function execution time name="SQL: GetNodePredicates" duration=335.599µs
Step #3 - "test": 2026/03/13 11:04:29 INFO Tracked function execution time name="SQL: GetContainedInPlace" duration=243.916µs
Step #3 - "test": 2026/03/13 11:04:30 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=607.386µs
Step #3 - "test": 2026/03/13 11:04:30 INFO Tracked function execution time name="SQL: GetNodeTriples" duration=679.563µs
Step #3 - "test": --- PASS: TestTripleIn (10.60s)
Step #3 - "test": 2026/03/13 11:04:30 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=1.491912ms
Step #3 - "test": 2026/03/13 11:04:30 INFO Tracked function execution time name="SQL: GetNodeTriples" duration=1.549954ms
Step #3 - "test": 2026/03/13 11:04:30 INFO Tracked function execution time name="SQL: GetContainedInPlace" duration=298.842µs
Step #3 - "test": 2026/03/13 11:04:30 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=2.673421ms
Step #3 - "test": 2026/03/13 11:04:30 INFO Tracked function execution time name="SQL: GetNodeTriples" duration=2.736943ms
Step #3 - "test": --- PASS: TestContainedInPlace (10.82s)
Step #3 - "test": 2026/03/13 11:04:31 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=726.284µs
Step #3 - "test": 2026/03/13 11:04:31 INFO Tracked function execution time name="SQL: GetNodeTriples" duration=794.352µs
Step #3 - "test": 2026/03/13 11:04:31 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=431.336µs
Step #3 - "test": 2026/03/13 11:04:31 INFO Tracked function execution time name="SQL: GetNodeTriples" duration=472.254µs
Step #3 - "test": 2026/03/13 11:04:31 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=494.762µs
Step #3 - "test": 2026/03/13 11:04:31 INFO Tracked function execution time name="SQL: GetNodeTriples" duration=549.471µs
Step #3 - "test": 2026/03/13 11:04:31 INFO Tracked function execution time name="SQL: GetEntityInfoTriples" duration=136.071µs
Step #3 - "test": 2026/03/13 11:04:32 INFO Tracked function execution time name="SQL: GetNodePredicates" duration=321.019µs
Step #3 - "test": 2026/03/13 11:04:32 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=574.564µs
Step #3 - "test": 2026/03/13 11:04:32 INFO Tracked function execution time name="SQL: GetNodeTriples" duration=612.886µs
Step #3 - "test": 2026/03/13 11:04:32 INFO Tracked function execution time name="SQL: GetEntityInfoTriples" duration=159.166µs
Step #3 - "test": 2026/03/13 11:04:32 INFO Tracked function execution time name="SQL: GetNodePredicates" duration=310.249µs
Step #3 - "test": 2026/03/13 11:04:32 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=462.7µs
Step #3 - "test": 2026/03/13 11:04:32 INFO Tracked function execution time name="SQL: GetNodeTriples" duration=505.501µs
Step #3 - "test": 2026/03/13 11:04:32 INFO Tracked function execution time name="SQL: GetEntityInfoTriples" duration=121.202µs
Step #3 - "test": --- PASS: TestSimplePropertyValues (12.74s)
Step #3 - "test": 2026/03/13 11:04:57 INFO No feature flag path specified. Using default flag values. flags="\nEnableV3: false\nV3MirrorFraction: 0\nUseSpannerGraph: false\nSpannerGraphDatabase: \"\"\nUseStaleReads: false\nEnableEmbeddingsResolver: true\nV2DivertFraction: 0\n"
Step #3 - "test": --- PASS: TestSpecializationOf (38.39s)
Step #3 - "test": PASS
Step #3 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/v2/propertyvalues/golden	38.642s
Step #3 - "test": === RUN   TestResolveUsingEmbeddings
Step #3 - "test": --- PASS: TestResolveUsingEmbeddings (0.02s)
Step #3 - "test": === RUN   TestResolveUsingEmbeddings_Errors
Step #3 - "test": === RUN   TestResolveUsingEmbeddings_Errors/Server_Error
Step #3 - "test": 2026/03/13 11:04:19 ERROR Embeddings server returned non-200 status status_code=500 body="internal error" url=http://127.0.0.1:43429 queries=[query]
Step #3 - "test": === RUN   TestResolveUsingEmbeddings_Errors/Malformed_JSON
Step #3 - "test": 2026/03/13 11:04:19 ERROR Failed to decode embeddings server response error="invalid character 'i' looking for beginning of object key string" url=http://127.0.0.1:40965
Step #3 - "test": === RUN   TestResolveUsingEmbeddings_Errors/Empty_Server_URL
Step #3 - "test": 2026/03/13 11:04:19 ERROR resolver=indicator requested, but the embeddings server is not configured for this deployment
Step #3 - "test": --- PASS: TestResolveUsingEmbeddings_Errors (0.00s)
Step #3 - "test":     --- PASS: TestResolveUsingEmbeddings_Errors/Server_Error (0.00s)
Step #3 - "test":     --- PASS: TestResolveUsingEmbeddings_Errors/Malformed_JSON (0.00s)
Step #3 - "test":     --- PASS: TestResolveUsingEmbeddings_Errors/Empty_Server_URL (0.00s)
Step #3 - "test": === RUN   TestResolveUsingEmbeddings_InconsistentSearchVarsResponse
Step #3 - "test": --- PASS: TestResolveUsingEmbeddings_InconsistentSearchVarsResponse (0.00s)
Step #3 - "test": === RUN   TestResolveUsingEmbeddings_IdxParameter
Step #3 - "test": === RUN   TestResolveUsingEmbeddings_IdxParameter/With_Custom_Indexes
Step #3 - "test": === RUN   TestResolveUsingEmbeddings_IdxParameter/With_Empty_Index
Step #3 - "test": --- PASS: TestResolveUsingEmbeddings_IdxParameter (0.00s)
Step #3 - "test":     --- PASS: TestResolveUsingEmbeddings_IdxParameter/With_Custom_Indexes (0.00s)
Step #3 - "test":     --- PASS: TestResolveUsingEmbeddings_IdxParameter/With_Empty_Index (0.00s)
Step #3 - "test": === RUN   TestResolveUsingEmbeddings_Filter
Step #3 - "test": --- PASS: TestResolveUsingEmbeddings_Filter (0.00s)
Step #3 - "test": === RUN   TestParseCoordinate
Step #3 - "test": --- PASS: TestParseCoordinate (0.00s)
Step #3 - "test": PASS
Step #3 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/v2/resolve	0.122s
Step #3 - "test": === RUN   TestResolveCoordinate
Step #3 - "test": === PAUSE TestResolveCoordinate
Step #3 - "test": === RUN   TestResolveDescription
Step #3 - "test": === PAUSE TestResolveDescription
Step #3 - "test": === RUN   TestResolveID
Step #3 - "test": === PAUSE TestResolveID
Step #3 - "test": === CONT  TestResolveCoordinate
Step #3 - "test": === CONT  TestResolveID
Step #3 - "test": === CONT  TestResolveDescription
Step #3 - "test": 2026/03/13 11:04:27 INFO No feature flag path specified. Using default flag values. flags="\nEnableV3: false\nV3MirrorFraction: 0\nUseSpannerGraph: false\nSpannerGraphDatabase: \"\"\nUseStaleReads: false\nEnableEmbeddingsResolver: true\nV2DivertFraction: 0\n"
Step #3 - "test": 2026/03/13 11:04:27 INFO No feature flag path specified. Using default flag values. flags="\nEnableV3: false\nV3MirrorFraction: 0\nUseSpannerGraph: false\nSpannerGraphDatabase: \"\"\nUseStaleReads: false\nEnableEmbeddingsResolver: true\nV2DivertFraction: 0\n"
Step #3 - "test": 2026/03/13 11:04:27 INFO No feature flag path specified. Using default flag values. flags="\nEnableV3: false\nV3MirrorFraction: 0\nUseSpannerGraph: false\nSpannerGraphDatabase: \"\"\nUseStaleReads: false\nEnableEmbeddingsResolver: true\nV2DivertFraction: 0\n"
Step #3 - "test": --- PASS: TestResolveID (8.20s)
Step #3 - "test": --- PASS: TestResolveDescription (8.93s)
Step #3 - "test": --- PASS: TestResolveCoordinate (9.57s)
Step #3 - "test": PASS
Step #3 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/v2/resolve/golden	9.845s
Step #3 - "test": === RUN   TestFetchChildPlaces
Step #3 - "test": === PAUSE TestFetchChildPlaces
Step #3 - "test": === CONT  TestFetchChildPlaces
Step #3 - "test": --- PASS: TestFetchChildPlaces (0.00s)
Step #3 - "test": PASS
Step #3 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/v2/shared	0.222s
Step #3 - "test": ?   	github.com/datacommonsorg/mixer/internal/server/v3	[no test files]
Step #3 - "test": === RUN   TestV3Node
Step #3 - "test": --- PASS: TestV3Node (0.00s)
Step #3 - "test": === RUN   TestV3NodePagination
Step #3 - "test": --- PASS: TestV3NodePagination (0.00s)
Step #3 - "test": PASS
Step #3 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/v3/node/golden	0.232s
Step #3 - "test": === RUN   TestV3NodeSearch
Step #3 - "test": --- PASS: TestV3NodeSearch (0.00s)
Step #3 - "test": PASS
Step #3 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/v3/nodesearch/golden	0.134s
Step #3 - "test": ?   	github.com/datacommonsorg/mixer/internal/server/v3/observation	[no test files]
Step #3 - "test": === RUN   TestV3Observation
Step #3 - "test": --- PASS: TestV3Observation (0.00s)
Step #3 - "test": PASS
Step #3 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/v3/observation/golden	0.134s
Step #3 - "test": === RUN   TestV3Resolve
Step #3 - "test": --- PASS: TestV3Resolve (0.00s)
Step #3 - "test": PASS
Step #3 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/v3/resolve/golden	0.108s
Step #3 - "test": === RUN   TestV3Sparql
Step #3 - "test": --- PASS: TestV3Sparql (0.00s)
Step #3 - "test": PASS
Step #3 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/v3/sparql/golden	0.144s
Step #3 - "test": === RUN   TestId
Step #3 - "test": 2026/03/13 11:04:25 INFO Connected to sqlite db path=../../test/sqlquery/key_value/datacommons.db
Step #3 - "test": --- PASS: TestId (0.00s)
Step #3 - "test": === RUN   TestGetKeyValue
Step #3 - "test": 2026/03/13 11:04:25 INFO Connected to sqlite db path=../../test/sqlquery/key_value/datacommons.db
Step #3 - "test": 2026/03/13 11:04:25 INFO Tracked function execution time name="SQL: GetKeyValue" duration=2.169845ms
Step #3 - "test": --- PASS: TestGetKeyValue (0.00s)
Step #3 - "test": === RUN   TestGenerateCTESelectStatement
Step #3 - "test": --- PASS: TestGenerateCTESelectStatement (0.00s)
Step #3 - "test": === RUN   TestChunkSlice
Step #3 - "test": --- PASS: TestChunkSlice (0.00s)
Step #3 - "test": PASS
Step #3 - "test": ok  	github.com/datacommonsorg/mixer/internal/sqldb	0.047s
Step #3 - "test": === RUN   TestCountObservation
Step #3 - "test": 2026/03/13 11:04:25 INFO Connected to sqlite db path=../../../test/datacommons.db
Step #3 - "test": 2026/03/13 11:04:25 INFO Tracked function execution time name="SQL: GetObservationCount" duration=2.123178ms
Step #3 - "test": 2026/03/13 11:04:25 INFO Tracked function execution time name="SQL: GetObservationCount" duration=719.696µs
Step #3 - "test": --- PASS: TestCountObservation (0.00s)
Step #3 - "test": === RUN   TestGetImportTableData
Step #3 - "test": 2026/03/13 11:04:25 INFO Connected to sqlite db path=../../../test/test_get_import_table_data.db
Step #3 - "test": 2026/03/13 11:04:25 INFO Tracked function execution time name="SQL: GetAllImports" duration=953.445µs
Step #3 - "test": --- PASS: TestGetImportTableData (0.00s)
Step #3 - "test": === RUN   TestGetStatVarSummaries
Step #3 - "test": 2026/03/13 11:04:25 INFO Connected to sqlite db path=../../../test/sqlquery/statvar_summary/datacommons.db
Step #3 - "test": 2026/03/13 11:04:25 INFO SQL tables check succeeded.
Step #3 - "test": 2026/03/13 11:04:25 INFO SQL schema check succeeded.
Step #3 - "test": 2026/03/13 11:04:25 INFO Tracked function execution time name="SQL: GetSVSummaries" duration=2.700835ms
Step #3 - "test": 2026/03/13 11:04:25 INFO Tracked function execution time name="SQL: GetStatVarSummaries (var1, var2)" duration=2.775795ms
Step #3 - "test": --- PASS: TestGetStatVarSummaries (0.00s)
Step #3 - "test": PASS
Step #3 - "test": ok  	github.com/datacommonsorg/mixer/internal/sqldb/sqlquery	0.112s
Step #3 - "test": ?   	github.com/datacommonsorg/mixer/internal/store	[no test files]
Step #3 - "test": === RUN   TestReadOneTable
Step #3 - "test": --- PASS: TestReadOneTable (0.03s)
Step #3 - "test": === RUN   TestReadTwoTables
Step #3 - "test": --- PASS: TestReadTwoTables (0.03s)
Step #3 - "test": === RUN   TestSortTables
Step #3 - "test": --- PASS: TestSortTables (0.00s)
Step #3 - "test": === RUN   TestBuildRowList
Step #3 - "test": --- PASS: TestBuildRowList (0.00s)
Step #3 - "test": === RUN   TestParseTableInfo
Step #3 - "test": --- PASS: TestParseTableInfo (0.01s)
Step #3 - "test": PASS
Step #3 - "test": ok  	github.com/datacommonsorg/mixer/internal/store/bigtable	0.131s
Step #3 - "test": === RUN   TestLoadRecogPlaceStore
Step #3 - "test": --- PASS: TestLoadRecogPlaceStore (4.40s)
Step #3 - "test": PASS
Step #3 - "test": ok  	github.com/datacommonsorg/mixer/internal/store/files	4.420s
Step #3 - "test": === RUN   TestBind
Step #3 - "test": --- PASS: TestBind (0.00s)
Step #3 - "test": === RUN   TestGetBindings
Step #3 - "test": --- PASS: TestGetBindings (0.00s)
Step #3 - "test": === RUN   TestGetGraph
Step #3 - "test": --- PASS: TestGetGraph (0.00s)
Step #3 - "test": === RUN   TestGetConstraint
Step #3 - "test": --- PASS: TestGetConstraint (0.05s)
Step #3 - "test": === RUN   TestGetSQL
Step #3 - "test": --- PASS: TestGetSQL (0.00s)
Step #3 - "test": === RUN   TestTranslate
Step #3 - "test": --- PASS: TestTranslate (0.10s)
Step #3 - "test": === RUN   TestDcidSimplified
Step #3 - "test": --- PASS: TestDcidSimplified (0.04s)
Step #3 - "test": === RUN   TestTranslateIOCountyBQ
Step #3 - "test": Multiple functional deps: `dc_v3.bq_county_outcomes`->E2 => map[gender:`dc_v3.bq_county_outcomes`->gender location:`dc_v3.bq_county_outcomes`->E1 outcome:`dc_v3.bq_county_outcomes`->outcome percentile:`dc_v3.bq_county_outcomes`->percentile race:`dc_v3.bq_county_outcomes`->race]
Step #3 - "test": Multiple functional deps: `dc_v3.bq_county_outcomes`->E2 => map[gender:`dc_v3.bq_county_outcomes`->gender location:`dc_v3.bq_county_outcomes`->E1 outcome:`dc_v3.bq_county_outcomes`->outcome percentile:`dc_v3.bq_county_outcomes`->percentile race:`dc_v3.bq_county_outcomes`->race]
Step #3 - "test": --- PASS: TestTranslateIOCountyBQ (0.00s)
Step #3 - "test": === RUN   TestTranslateWeather
Step #3 - "test": Multiple functional deps: `dc_v3.MonthlyWeather`->E1 => map[observationDate:`dc_v3.MonthlyWeather`->observation_date observationPeriod:P1M observedNode:`dc_v3.MonthlyWeather`->E2]
Step #3 - "test": Multiple functional deps: `dc_v3.MonthlyWeather`->E1 => map[observationDate:`dc_v3.MonthlyWeather`->observation_date observationPeriod:P1M observedNode:`dc_v3.MonthlyWeather`->E2]
Step #3 - "test": Multiple functional deps: `dc_v3.MonthlyWeather`->E1 => map[observationDate:`dc_v3.MonthlyWeather`->observation_date observationPeriod:P1M observedNode:`dc_v3.MonthlyWeather`->E2]
Step #3 - "test": Multiple functional deps: `dc_v3.MonthlyWeather`->E1 => map[observationDate:`dc_v3.MonthlyWeather`->observation_date observationPeriod:P1M observedNode:`dc_v3.MonthlyWeather`->E2]
Step #3 - "test": --- PASS: TestTranslateWeather (0.00s)
Step #3 - "test": === RUN   TestTranslateWeatherSparql
Step #3 - "test": Multiple functional deps: `dc_v3.MonthlyWeather`->E1 => map[observationDate:`dc_v3.MonthlyWeather`->observation_date observationPeriod:P1M observedNode:`dc_v3.MonthlyWeather`->E2]
Step #3 - "test": Multiple functional deps: `dc_v3.MonthlyWeather`->E1 => map[observationDate:`dc_v3.MonthlyWeather`->observation_date observationPeriod:P1M observedNode:`dc_v3.MonthlyWeather`->E2]
Step #3 - "test": --- PASS: TestTranslateWeatherSparql (0.00s)
Step #3 - "test": === RUN   TestTranslatePew
Step #3 - "test": --- PASS: TestTranslatePew (0.00s)
Step #3 - "test": === RUN   TestSparql
Step #3 - "test": --- PASS: TestSparql (0.00s)
Step #3 - "test": === RUN   TestStatVarObs
Step #3 - "test": --- PASS: TestStatVarObs (0.00s)
Step #3 - "test": PASS
Step #3 - "test": ok  	github.com/datacommonsorg/mixer/internal/translator	0.282s
Step #3 - "test": === RUN   TestSplit
Step #3 - "test": --- PASS: TestSplit (0.00s)
Step #3 - "test": === RUN   TestParseQuery
Step #3 - "test": --- PASS: TestParseQuery (0.00s)
Step #3 - "test": PASS
Step #3 - "test": ok  	github.com/datacommonsorg/mixer/internal/translator/datalog	0.060s
Step #3 - "test": === RUN   TestGetNodeType
Step #3 - "test": --- PASS: TestGetNodeType (0.00s)
Step #3 - "test": === RUN   TestGetEntityType
Step #3 - "test": --- PASS: TestGetEntityType (0.00s)
Step #3 - "test": === RUN   TestGetExplicitTypeProp
Step #3 - "test": --- PASS: TestGetExplicitTypeProp (0.00s)
Step #3 - "test": === RUN   TestGetQueryID
Step #3 - "test": --- PASS: TestGetQueryID (0.00s)
Step #3 - "test": === RUN   TestMatchTriple
Step #3 - "test": --- PASS: TestMatchTriple (0.00s)
Step #3 - "test": === RUN   TestGetFuncDeps
Step #3 - "test": --- PASS: TestGetFuncDeps (0.00s)
Step #3 - "test": === RUN   TestGetFuncDepsWithEntity
Step #3 - "test": --- PASS: TestGetFuncDepsWithEntity (0.00s)
Step #3 - "test": === RUN   TestGetProvColumn
Step #3 - "test": --- PASS: TestGetProvColumn (0.00s)
Step #3 - "test": === RUN   TestRewriteQuery
Step #3 - "test": --- PASS: TestRewriteQuery (0.00s)
Step #3 - "test": === RUN   TestGetOutArcInfo
Step #3 - "test": --- PASS: TestGetOutArcInfo (0.00s)
Step #3 - "test": PASS
Step #3 - "test": ok  	github.com/datacommonsorg/mixer/internal/translator/solver	0.045s
Step #3 - "test": === RUN   TestParsePrologue
Step #3 - "test": --- PASS: TestParsePrologue (0.00s)
Step #3 - "test": === RUN   TestParseSelect
Step #3 - "test": --- PASS: TestParseSelect (0.00s)
Step #3 - "test": === RUN   TestParseWhere
Step #3 - "test": --- PASS: TestParseWhere (0.00s)
Step #3 - "test": === RUN   TestParseOrderBy
Step #3 - "test": --- PASS: TestParseOrderBy (0.00s)
Step #3 - "test": === RUN   TestParseLimit
Step #3 - "test": --- PASS: TestParseLimit (0.00s)
Step #3 - "test": === RUN   TestParseTree
Step #3 - "test": --- PASS: TestParseTree (0.00s)
Step #3 - "test": === RUN   TestReader
Step #3 - "test": --- PASS: TestReader (0.00s)
Step #3 - "test": === RUN   TestScanSimple
Step #3 - "test": --- PASS: TestScanSimple (0.00s)
Step #3 - "test": === RUN   TestMulti
Step #3 - "test": --- PASS: TestMulti (0.00s)
Step #3 - "test": PASS
Step #3 - "test": ok  	github.com/datacommonsorg/mixer/internal/translator/sparql	0.029s
Step #3 - "test": ?   	github.com/datacommonsorg/mixer/internal/translator/testutil	[no test files]
Step #3 - "test": === RUN   TestQuery
Step #3 - "test": --- PASS: TestQuery (0.00s)
Step #3 - "test": === RUN   TestEntity
Step #3 - "test": --- PASS: TestEntity (0.00s)
Step #3 - "test": === RUN   TestColumn
Step #3 - "test": --- PASS: TestColumn (0.00s)
Step #3 - "test": === RUN   TestMapping
Step #3 - "test": --- PASS: TestMapping (0.00s)
Step #3 - "test": === RUN   TestTableAlias
Step #3 - "test": --- PASS: TestTableAlias (0.00s)
Step #3 - "test": PASS
Step #3 - "test": ok  	github.com/datacommonsorg/mixer/internal/translator/types	0.061s
Step #3 - "test": === RUN   TestZipAndEndocde
Step #3 - "test": --- PASS: TestZipAndEndocde (0.02s)
Step #3 - "test": === RUN   TestSnakeToCamel
Step #3 - "test": --- PASS: TestSnakeToCamel (0.00s)
Step #3 - "test": === RUN   TestCheckValidDCIDs
Step #3 - "test": --- PASS: TestCheckValidDCIDs (0.00s)
Step #3 - "test": === RUN   TestMergeDedupe
Step #3 - "test": --- PASS: TestMergeDedupe (0.00s)
Step #3 - "test": === RUN   TestSample
Step #3 - "test": --- PASS: TestSample (0.01s)
Step #3 - "test": === RUN   TestKeysToSlice
Step #3 - "test": --- PASS: TestKeysToSlice (0.00s)
Step #3 - "test": === RUN   TestEncode
Step #3 - "test": --- PASS: TestEncode (0.00s)
Step #3 - "test": === RUN   TestStringListIntersection
Step #3 - "test": --- PASS: TestStringListIntersection (0.00s)
Step #3 - "test": === RUN   TestGetFacetID
Step #3 - "test": --- PASS: TestGetFacetID (0.00s)
Step #3 - "test": === RUN   TestShouldIncludeFacet
Step #3 - "test": --- PASS: TestShouldIncludeFacet (0.00s)
Step #3 - "test": PASS
Step #3 - "test": ok  	github.com/datacommonsorg/mixer/internal/util	0.098s
Step #3 - "test": ?   	github.com/datacommonsorg/mixer/scripts	[no test files]
Step #3 - "test": === RUN   TestChartConfigRankings
Step #3 - "test": === PAUSE TestChartConfigRankings
Step #3 - "test": === CONT  TestChartConfigRankings
Step #3 - "test": 2026/03/13 11:04:31 INFO No feature flag path specified. Using default flag values. flags="\nEnableV3: false\nV3MirrorFraction: 0\nUseSpannerGraph: false\nSpannerGraphDatabase: \"\"\nUseStaleReads: false\nEnableEmbeddingsResolver: true\nV2DivertFraction: 0\n"
Step #3 - "test": === RUN   TestChartConfigRankings/missing_Earth_country_rankings.json
Step #3 - "test": === PAUSE TestChartConfigRankings/missing_Earth_country_rankings.json
Step #3 - "test": === RUN   TestChartConfigRankings/missing_USA_state_rankings.json
Step #3 - "test": === PAUSE TestChartConfigRankings/missing_USA_state_rankings.json
Step #3 - "test": === RUN   TestChartConfigRankings/missing_USA_county_rankings.json
Step #3 - "test": === PAUSE TestChartConfigRankings/missing_USA_county_rankings.json
Step #3 - "test": === RUN   TestChartConfigRankings/missing_USA_city_rankings.json
Step #3 - "test": === PAUSE TestChartConfigRankings/missing_USA_city_rankings.json
Step #3 - "test": === CONT  TestChartConfigRankings/missing_Earth_country_rankings.json
Step #3 - "test": === CONT  TestChartConfigRankings/missing_USA_county_rankings.json
Step #3 - "test": === CONT  TestChartConfigRankings/missing_USA_city_rankings.json
Step #3 - "test": === CONT  TestChartConfigRankings/missing_USA_state_rankings.json
Step #3 - "test": --- PASS: TestChartConfigRankings (3.95s)
Step #3 - "test":     --- PASS: TestChartConfigRankings/missing_USA_state_rankings.json (1.93s)
Step #3 - "test":     --- PASS: TestChartConfigRankings/missing_USA_county_rankings.json (1.94s)
Step #3 - "test":     --- PASS: TestChartConfigRankings/missing_USA_city_rankings.json (1.94s)
Step #3 - "test":     --- PASS: TestChartConfigRankings/missing_Earth_country_rankings.json (1.97s)
Step #3 - "test": PASS
Step #3 - "test": ok  	github.com/datacommonsorg/mixer/test	5.980s
Step #3 - "test": ?   	github.com/datacommonsorg/mixer/test/http_memprof	[no test files]
Step #3 - "test": ?   	github.com/datacommonsorg/mixer/tools/send_email	[no test files]
Finished Step #3 - "test"
PUSH
DONE