Differentiating the types of existence checks in v2/observation and including them in usage logger #1686
Google Cloud Build / mixer-pull-request (datcom-ci)
failed
Nov 21, 2025 in 4m 6s
Summary
Build Information
| Trigger | mixer-pull-request |
| Build | ba9e19b7-bdbe-435c-80f3-e352a10864d4 |
| Start | 2025-11-21T08:24:33-08:00 |
| Duration | 2m58.802s |
| Status | FAILURE |
Steps
| Step | Status | Duration |
|---|---|---|
| lint | SUCCESS | 1m19.729s |
| validate-feature-flags | SUCCESS | 3.215s |
| build-proto | SUCCESS | 1.158s |
| test | FAILURE | 1m18.887s |
Details
starting build "ba9e19b7-bdbe-435c-80f3-e352a10864d4"
FETCHSOURCE
From https://github.com/datacommonsorg/mixer
* branch 2ff2b5b01c06ed5170baa28c2e84fbc42efbcfcc -> FETCH_HEAD
HEAD is now at 2ff2b5b draft
GitCommit:
2ff2b5b01c06ed5170baa28c2e84fbc42efbcfcc
BUILD
Starting Step #0 - "lint"
Step #0 - "lint": Pulling image: gcr.io/datcom-ci/full-env:mixer-only-2025-10-02
Step #0 - "lint": mixer-only-2025-10-02: Pulling from datcom-ci/full-env
Step #0 - "lint": 5c32499ab806: Pulling fs layer
Step #0 - "lint": 2e2090506371: Pulling fs layer
Step #0 - "lint": 866aa19740ba: Pulling fs layer
Step #0 - "lint": 4998cc0012ec: Pulling fs layer
Step #0 - "lint": 8a18277e1cb9: Pulling fs layer
Step #0 - "lint": ebe4f67599f7: Pulling fs layer
Step #0 - "lint": fdf996182a4b: Pulling fs layer
Step #0 - "lint": c72cdcf96df0: Pulling fs layer
Step #0 - "lint": dc036fb92b3d: Pulling fs layer
Step #0 - "lint": 43191234a89f: Pulling fs layer
Step #0 - "lint": 20e1655a1adc: Pulling fs layer
Step #0 - "lint": fdf996182a4b: Waiting
Step #0 - "lint": c72cdcf96df0: Waiting
Step #0 - "lint": dc036fb92b3d: Waiting
Step #0 - "lint": 43191234a89f: Waiting
Step #0 - "lint": 2e2090506371: Verifying Checksum
Step #0 - "lint": 2e2090506371: Download complete
Step #0 - "lint": ebe4f67599f7: Verifying Checksum
Step #0 - "lint": ebe4f67599f7: Download complete
Step #0 - "lint": 8a18277e1cb9: Verifying Checksum
Step #0 - "lint": 8a18277e1cb9: Download complete
Step #0 - "lint": 5c32499ab806: Verifying Checksum
Step #0 - "lint": 5c32499ab806: Download complete
Step #0 - "lint": 866aa19740ba: Verifying Checksum
Step #0 - "lint": 866aa19740ba: Download complete
Step #0 - "lint": c72cdcf96df0: Verifying Checksum
Step #0 - "lint": c72cdcf96df0: Download complete
Step #0 - "lint": dc036fb92b3d: Verifying Checksum
Step #0 - "lint": dc036fb92b3d: Download complete
Step #0 - "lint": 4998cc0012ec: Verifying Checksum
Step #0 - "lint": 4998cc0012ec: Download complete
Step #0 - "lint": 5c32499ab806: Pull complete
Step #0 - "lint": 43191234a89f: Verifying Checksum
Step #0 - "lint": 43191234a89f: Download complete
Step #0 - "lint": 2e2090506371: Pull complete
Step #0 - "lint": 866aa19740ba: Pull complete
Step #0 - "lint": 20e1655a1adc: Verifying Checksum
Step #0 - "lint": 20e1655a1adc: Download complete
Step #0 - "lint": fdf996182a4b: Verifying Checksum
Step #0 - "lint": fdf996182a4b: Download complete
Step #0 - "lint": 4998cc0012ec: Pull complete
Step #0 - "lint": 8a18277e1cb9: Pull complete
Step #0 - "lint": ebe4f67599f7: Pull complete
Step #0 - "lint": fdf996182a4b: Pull complete
Step #0 - "lint": c72cdcf96df0: Pull complete
Step #0 - "lint": dc036fb92b3d: Pull complete
Step #0 - "lint": 43191234a89f: Pull complete
Step #0 - "lint": 20e1655a1adc: Pull complete
Step #0 - "lint": Digest: sha256:17edc421fe50bc372480f4e7f06166496b8a0a1f2ebdd9b7491d82148076348a
Step #0 - "lint": Status: Downloaded newer image for gcr.io/datcom-ci/full-env:mixer-only-2025-10-02
Step #0 - "lint": gcr.io/datcom-ci/full-env:mixer-only-2025-10-02
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 4.14507ms: 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 (compiled_files|exports_file|types_sizes|deps|files|imports|name) took 35.156716354s"
Step #0 - "lint": level=info msg="[runner/filename_unadjuster] Pre-built 0 adjustments in 47.438919ms"
Step #0 - "lint": level=info msg="[linters_context/goanalysis] analyzers took 2m34.289200696s with top 10 stages: buildir: 1m58.135112295s, inspect: 3.451414665s, fact_deprecated: 2.48570937s, nilness: 2.470171694s, printf: 2.277164523s, fact_purity: 2.031364364s, ctrlflow: 1.869968606s, typedness: 1.147303305s, SA5012: 913.674906ms, unused: 827.082372ms"
Step #0 - "lint": level=info msg="[runner/exclusion_paths] Skipped 271 issues by pattern \"internal/proto\""
Step #0 - "lint": level=info msg="[runner] Issues before processing: 289, after processing: 0"
Step #0 - "lint": level=info msg="[runner] Processors filtering stat (in/out): path_absoluter: 289/289, invalid_issue: 289/289, cgo: 289/289, filename_unadjuster: 289/289, generated_file_filter: 18/18, nolint_filter: 18/0, path_relativity: 289/289, exclusion_rules: 18/18, exclusion_paths: 289/18"
Step #0 - "lint": level=info msg="[runner] processing took 5.905503ms with stages: nolint_filter: 5.364158ms, generated_file_filter: 251.941µs, path_relativity: 133.527µs, exclusion_paths: 120.14µs, invalid_issue: 9.945µs, cgo: 8.882µs, path_absoluter: 7.479µs, filename_unadjuster: 3.44µs, sort_results: 1.741µs, max_same_issues: 935ns, fixer: 524ns, exclusion_rules: 488ns, source_code: 374ns, diff: 359ns, uniq_by_line: 334ns, max_from_linter: 331ns, path_shortener: 314ns, path_prettifier: 242ns, severity-rules: 197ns, max_per_file_from_linter: 152ns"
Step #0 - "lint": level=info msg="[runner] linters took 16.179605963s with stages: goanalysis_metalinter: 16.173616018s"
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 744.7MB, max is 3091.6MB"
Step #0 - "lint": level=info msg="Execution took 51.389953907s"
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-2025-10-02
Step #1 - "validate-feature-flags": Already have image (with digest): gcr.io/datcom-ci/full-env:mixer-only-2025-10-02
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": 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": Checking feature flag parsing for /workspace/deploy/featureflags/prod.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-2025-10-02
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": 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": Checking feature flag parsing for /workspace/deploy/featureflags/local.yaml...
Step #1 - "validate-feature-flags": Successfully validated /workspace/deploy/featureflags/local.yaml
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": 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": Checking feature flag parsing for /workspace/deploy/featureflags/autopush.yaml...
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": ? github.com/datacommonsorg/mixer/internal/log [no test files]
Step #3 - "test": ? github.com/datacommonsorg/mixer/internal/metrics [no test files]
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 TestNewFlags
Step #3 - "test": === RUN TestNewFlags/file_not_found
Step #3 - "test": 2025/11/21 16:26:13 WARN Feature flags file not found. Using default values. path=/tmp/TestNewFlagsfile_not_found280084437/001/non_existent_file.yaml
Step #3 - "test": === RUN TestNewFlags/invalid_yaml
Step #3 - "test": === RUN TestNewFlags/partial_flags
Step #3 - "test": === RUN TestNewFlags/all_flags
Step #3 - "test": === RUN TestNewFlags/cluster_details_with_flag_values
Step #3 - "test": === RUN TestNewFlags/cluster_details_without_flag_values
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.00s)
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.007s
Step #3 - "test": === RUN TestMergeResolve
Step #3 - "test": --- PASS: TestMergeResolve (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": PASS
Step #3 - "test": ok github.com/datacommonsorg/mixer/internal/merger 0.033s
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.004s
Step #3 - "test": ? github.com/datacommonsorg/mixer/internal/server/biopage [no test files]
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": ? github.com/datacommonsorg/mixer/internal/server/place [no test files]
Step #3 - "test": ? github.com/datacommonsorg/mixer/internal/server/placein [no test files]
Step #3 - "test": ? github.com/datacommonsorg/mixer/internal/server/resource [no test files]
Step #3 - "test": ? github.com/datacommonsorg/mixer/internal/server/search [no test files]
Step #3 - "test": ? github.com/datacommonsorg/mixer/internal/server/statvar [no test files]
Step #3 - "test": ? github.com/datacommonsorg/mixer/internal/server/statvar/fetcher [no test files]
Step #3 - "test": ? github.com/datacommonsorg/mixer/internal/server/translator [no test files]
Step #3 - "test": ? github.com/datacommonsorg/mixer/internal/server/v0/internalbio [no test files]
Step #3 - "test": ? github.com/datacommonsorg/mixer/internal/server/v0/placestatvar [no test files]
Step #3 - "test": ? github.com/datacommonsorg/mixer/internal/server/v0/statpoint [no test files]
Step #3 - "test": === RUN TestBulkVariableInfo
Step #3 - "test": === PAUSE TestBulkVariableInfo
Step #3 - "test": === RUN TestUseMetadata
Step #3 - "test": 2025/11/21 16:26:14 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": handler_v2_test.go:198: existence: unexpected queryType diff shared.QueryType(
Step #3 - "test": - "existence-var",
Step #3 - "test": + "existence-entity",
Step #3 - "test": )
Step #3 - "test": --- FAIL: TestObservationInternal (0.00s)
Step #3 - "test": === RUN TestV2Observation_UsageLog
Step #3 - "test": --- PASS: TestV2Observation_UsageLog (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.00s)
Step #3 - "test": === CONT TestBulkVariableInfo
Step #3 - "test": --- PASS: TestBulkVariableInfo (0.00s)
Step #3 - "test": FAIL
Step #3 - "test": FAIL github.com/datacommonsorg/mixer/internal/server 0.163s
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.016s
Step #3 - "test": ? github.com/datacommonsorg/mixer/internal/server/v0/triple [no test files]
Step #3 - "test": ? github.com/datacommonsorg/mixer/internal/server/v1/info [no test files]
Step #3 - "test": ? github.com/datacommonsorg/mixer/internal/server/v1/event [no test files]
Step #3 - "test": ? github.com/datacommonsorg/mixer/internal/server/v1/observationdates [no test files]
Step #3 - "test": ? github.com/datacommonsorg/mixer/internal/server/v1/observationexistence [no test files]
Step #3 - "test": ? github.com/datacommonsorg/mixer/internal/server/v1/properties [no test files]
Step #3 - "test": ? github.com/datacommonsorg/mixer/internal/server/v1/propertyvalues [no test files]
Step #3 - "test": ? github.com/datacommonsorg/mixer/internal/server/v1/triples [no test files]
Step #3 - "test": ? github.com/datacommonsorg/mixer/internal/server/v1/variables [no test files]
Step #3 - "test": ? github.com/datacommonsorg/mixer/internal/server/v1/variable [no test files]
Step #3 - "test": ? github.com/datacommonsorg/mixer/internal/server/v2/facet [no test files]
Step #3 - "test": ? github.com/datacommonsorg/mixer/internal/server/v2/observation/helper [no test files]
Step #3 - "test": ? github.com/datacommonsorg/mixer/internal/server/v2/properties [no test files]
Step #3 - "test": === RUN TestGetLocationsRankings
Step #3 - "test": === PAUSE TestGetLocationsRankings
Step #3 - "test": === RUN TestGetPlaceStatDateWithinPlace
Step #3 - "test": === PAUSE TestGetPlaceStatDateWithinPlace
Step #3 - "test": === RUN TestGetRelatedLocations
Step #3 - "test": === PAUSE TestGetRelatedLocations
Step #3 - "test": === CONT TestGetLocationsRankings
Step #3 - "test": === CONT TestGetPlaceStatDateWithinPlace
Step #3 - "test": === CONT TestGetRelatedLocations
Step #3 - "test": --- PASS: TestGetRelatedLocations (9.95s)
Step #3 - "test": --- PASS: TestGetLocationsRankings (11.53s)
Step #3 - "test": --- PASS: TestGetPlaceStatDateWithinPlace (11.79s)
Step #3 - "test": PASS
Step #3 - "test": ok github.com/datacommonsorg/mixer/internal/server/place/golden 11.889s
Step #3 - "test": === RUN TestGetPlacesIn
Step #3 - "test": === PAUSE TestGetPlacesIn
Step #3 - "test": === CONT TestGetPlacesIn
Step #3 - "test": --- PASS: TestGetPlacesIn (7.74s)
Step #3 - "test": PASS
Step #3 - "test": ok github.com/datacommonsorg/mixer/internal/server/placein/golden 7.801s
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.008s
Step #3 - "test": === RUN TestIsContainedIn
Step #3 - "test": --- PASS: TestIsContainedIn (0.18s)
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.03s)
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.258s
Step #3 - "test": ? github.com/datacommonsorg/mixer/internal/server/v2/propertyvalues [no test files]
Step #3 - "test": ? github.com/datacommonsorg/mixer/internal/server/v3 [no test files]
Step #3 - "test": ? github.com/datacommonsorg/mixer/internal/server/v3/observation [no test files]
Step #3 - "test": ? github.com/datacommonsorg/mixer/internal/store [no test files]
Step #3 - "test": ? github.com/datacommonsorg/mixer/internal/translator/testutil [no test files]
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 TestResolveEntities
Step #3 - "test": === CONT TestRecognizeEntities
Step #3 - "test": === CONT TestRecognizePlaces
Step #3 - "test": --- PASS: TestResolveEntities (14.96s)
Step #3 - "test": --- PASS: TestRecognizeEntities (15.08s)
Step #3 - "test": --- PASS: TestResolveIds (15.26s)
Step #3 - "test": --- PASS: TestFindEntities (15.40s)
Step #3 - "test": --- PASS: TestRecognizePlaces (15.48s)
Step #3 - "test": --- PASS: TestResolveCoordinates (16.34s)
Step #3 - "test": PASS
Step #3 - "test": ok github.com/datacommonsorg/mixer/internal/server/recon/golden 16.494s
Step #3 - "test": === RUN TestCacheClient
Step #3 - "test": redis: 2025/11/21 16:26:14 commands.go:25: specified duration is 1ns, but minimal supported value is 1ms - truncating to 1ms
Step #3 - "test": redis: 2025/11/21 16:26:14 commands.go:25: specified duration is 1ns, but minimal supported value is 1ms - truncating to 1ms
Step #3 - "test": --- PASS: TestCacheClient (0.02s)
Step #3 - "test": === RUN TestCompressionSize
Step #3 - "test": === RUN TestCompressionSize/small
Step #3 - "test": === RUN TestCompressionSize/medium
Step #3 - "test": === RUN TestCompressionSize/large
Step #3 - "test": --- PASS: TestCompressionSize (0.01s)
Step #3 - "test": --- PASS: TestCompressionSize/small (0.00s)
Step #3 - "test": --- PASS: TestCompressionSize/medium (0.00s)
Step #3 - "test": --- PASS: TestCompressionSize/large (0.01s)
Step #3 - "test": === RUN TestGetRedisAddress
Step #3 - "test": === RUN TestGetRedisAddress/us-central1
Step #3 - "test": === RUN TestGetRedisAddress/us-east1
Step #3 - "test": === RUN TestGetRedisAddress/default
Step #3 - "test": === RUN TestGetRedisAddress/unconfigured_region
Step #3 - "test": --- PASS: TestGetRedisAddress (0.00s)
Step #3 - "test": --- PASS: TestGetRedisAddress/us-central1 (0.00s)
Step #3 - "test": --- PASS: TestGetRedisAddress/us-east1 (0.00s)
Step #3 - "test": --- PASS: TestGetRedisAddress/default (0.00s)
Step #3 - "test": --- PASS: TestGetRedisAddress/unconfigured_region (0.00s)
Step #3 - "test": === RUN TestCacheProcessorPreProcess
Step #3 - "test": === RUN TestCacheProcessorPreProcess/Cache_Hit
Step #3 - "test": 2025/11/21 16:26:14 INFO Cache hit originalRequest="nodes:\"testNode\""
Step #3 - "test": === RUN TestCacheProcessorPreProcess/Cache_Miss
Step #3 - "test": === RUN TestCacheProcessorPreProcess/Cache_Error
Step #3 - "test": 2025/11/21 16:26:14 ERROR Error getting cached response error="failed to get from Redis: redis error"
Step #3 - "test": --- PASS: TestCacheProcessorPreProcess (0.00s)
Step #3 - "test": --- PASS: TestCacheProcessorPreProcess/Cache_Hit (0.00s)
Step #3 - "test": --- PASS: TestCacheProcessorPreProcess/Cache_Miss (0.00s)
Step #3 - "test": --- PASS: TestCacheProcessorPreProcess/Cache_Error (0.00s)
Step #3 - "test": === RUN TestCacheProcessorPostProcess
Step #3 - "test": === RUN TestCacheProcessorPostProcess/Cache_Success
Step #3 - "test": === RUN TestCacheProcessorPostProcess/Cache_Error
Step #3 - "test": 2025/11/21 16:26:14 ERROR Error caching response error="failed to set in Redis: redis error"
Step #3 - "test": === RUN TestCacheProcessorPostProcess/No_Response
Step #3 - "test": --- PASS: TestCacheProcessorPostProcess (0.00s)
Step #3 - "test": --- PASS: TestCacheProcessorPostProcess/Cache_Success (0.00s)
Step #3 - "test": --- PASS: TestCacheProcessorPostProcess/Cache_Error (0.00s)
Step #3 - "test": --- PASS: TestCacheProcessorPostProcess/No_Response (0.00s)
Step #3 - "test": === RUN TestNewEmptyResponse
Step #3 - "test": === RUN TestNewEmptyResponse/Node
Step #3 - "test": === RUN TestNewEmptyResponse/Observation
Step #3 - "test": === RUN TestNewEmptyResponse/NodeSearch
Step #3 - "test": === RUN TestNewEmptyResponse/Resolve
Step #3 - "test": --- PASS: TestNewEmptyResponse (0.00s)
Step #3 - "test": --- PASS: TestNewEmptyResponse/Node (0.00s)
Step #3 - "test": --- PASS: TestNewEmptyResponse/Observation (0.00s)
Step #3 - "test": --- PASS: TestNewEmptyResponse/NodeSearch (0.00s)
Step #3 - "test": --- PASS: TestNewEmptyResponse/Resolve (0.00s)
Step #3 - "test": === RUN TestSkipCache
Step #3 - "test": === RUN TestSkipCache/Don't_Skip_Cache
Step #3 - "test": 2025/11/21 16:26:14 INFO Cache hit originalRequest="nodes:\"testNode\""
Step #3 - "test": === RUN TestSkipCache/Skip_Cache
Step #3 - "test": --- PASS: TestSkipCache (0.00s)
Step #3 - "test": --- PASS: TestSkipCache/Don't_Skip_Cache (0.00s)
Step #3 - "test": --- PASS: TestSkipCache/Skip_Cache (0.00s)
Step #3 - "test": PASS
Step #3 - "test": ok github.com/datacommonsorg/mixer/internal/server/redis 0.047s
Step #3 - "test": === RUN TestUpdateNodeRequestNextToken
Step #3 - "test": --- PASS: TestUpdateNodeRequestNextToken (0.00s)
Step #3 - "test": === RUN TestUpdateNodeResponseNextToken
Step #3 - "test": --- PASS: TestUpdateNodeResponseNextToken (0.00s)
Step #3 - "test": PASS
Step #3 - "test": ok github.com/datacommonsorg/mixer/internal/server/remote 0.012s
Step #3 - "test": === RUN TestAddOptimizationsToNodeRequest
Step #3 - "test": --- PASS: TestAddOptimizationsToNodeRequest (0.00s)
Step #3 - "test": === RUN TestRemoveOptimizationsFromNodeResponse
Step #3 - "test": --- PASS: TestRemoveOptimizationsFromNodeResponse (0.00s)
Step #3 - "test": PASS
Step #3 - "test": ok github.com/datacommonsorg/mixer/internal/server/spanner 0.039s
Step #3 - "test": === RUN TestNode
Step #3 - "test": 2025/11/21 16:26:14 Spanner graph not enabled.
Step #3 - "test": --- PASS: TestNode (0.00s)
Step #3 - "test": === RUN TestGetNodePropsQuery
Step #3 - "test": === PAUSE TestGetNodePropsQuery
Step #3 - "test": === RUN TestGetNodeOutEdgesByIDQuery
Step #3 - "test": === PAUSE TestGetNodeOutEdgesByIDQuery
Step #3 - "test": === RUN TestGetNodeInEdgesByIDQuery
Step #3 - "test": === PAUSE TestGetNodeInEdgesByIDQuery
Step #3 - "test": === RUN TestGetObservationsQuery
Step #3 - "test": === PAUSE TestGetObservationsQuery
Step #3 - "test": === RUN TestGetObservationsContainedInPlaceQuery
Step #3 - "test": === PAUSE TestGetObservationsContainedInPlaceQuery
Step #3 - "test": === RUN TestSearchNodesQuery
Step #3 - "test": === PAUSE TestSearchNodesQuery
Step #3 - "test": === RUN TestResolveByIDQuery
Step #3 - "test": === PAUSE TestResolveByIDQuery
Step #3 - "test": === RUN TestGetNodeProps
Step #3 - "test": 2025/11/21 16:26:14 Spanner graph not enabled.
Step #3 - "test": --- PASS: TestGetNodeProps (0.00s)
Step #3 - "test": === RUN TestGetNodeOutEdgesByID
Step #3 - "test": 2025/11/21 16:26:14 Spanner graph not enabled.
Step #3 - "test": --- PASS: TestGetNodeOutEdgesByID (0.00s)
Step #3 - "test": === RUN TestGetNodeInEdgesByID
Step #3 - "test": 2025/11/21 16:26:14 Spanner graph not enabled.
Step #3 - "test": --- PASS: TestGetNodeInEdgesByID (0.00s)
Step #3 - "test": === RUN TestGetObservations
Step #3 - "test": 2025/11/21 16:26:14 Spanner graph not enabled.
Step #3 - "test": --- PASS: TestGetObservations (0.00s)
Step #3 - "test": === RUN TestGetObservationsContainedInPlace
Step #3 - "test": 2025/11/21 16:26:14 Spanner graph not enabled.
Step #3 - "test": --- PASS: TestGetObservationsContainedInPlace (0.00s)
Step #3 - "test": === RUN TestSearchNodes
Step #3 - "test": 2025/11/21 16:26:14 Spanner graph not enabled.
Step #3 - "test": --- PASS: TestSearchNodes (0.00s)
Step #3 - "test": === RUN TestResolveByID
Step #3 - "test": 2025/11/21 16:26:14 Spanner graph not enabled.
Step #3 - "test": --- PASS: TestResolveByID (0.00s)
Step #3 - "test": === CONT TestGetNodePropsQuery
Step #3 - "test": === CONT TestResolveByIDQuery
Step #3 - "test": --- PASS: TestGetNodePropsQuery (0.00s)
Step #3 - "test": === CONT TestSearchNodesQuery
Step #3 - "test": --- PASS: TestSearchNodesQuery (0.00s)
Step #3 - "test": === CONT TestGetObservationsContainedInPlaceQuery
Step #3 - "test": --- PASS: TestGetObservationsContainedInPlaceQuery (0.00s)
Step #3 - "test": === CONT TestGetObservationsQuery
Step #3 - "test": --- PASS: TestResolveByIDQuery (0.00s)
Step #3 - "test": === CONT TestGetNodeInEdgesByIDQuery
Step #3
...
[Logs truncated due to log size limitations. For full logs, see https://console.cloud.google.com/cloud-build/builds/ba9e19b7-bdbe-435c-80f3-e352a10864d4?project=879489846695.]
...
59µs
Step #3 - "test": --- PASS: TestFetchContainInLatest (15.93s)
Step #3 - "test": 2025/11/21 16:26:37 INFO Tracked function execution time name="SQL: GetContainedInPlace" duration=324.933µs
Step #3 - "test": 2025/11/21 16:26:37 INFO Fetch series cache in contained-in observation query
Step #3 - "test": 2025/11/21 16:26:37 INFO Tracked function execution time name="SQL: GetObservations" duration=1.812246ms
Step #3 - "test": 2025/11/21 16:26:37 INFO Tracked function execution time name="SQL: GetContainedInPlace" duration=241.451µs
Step #3 - "test": 2025/11/21 16:26:37 INFO Fetch series cache in contained-in observation query
Step #3 - "test": 2025/11/21 16:26:38 INFO Tracked function execution time name="SQL: GetObservations" duration=1.913721ms
Step #3 - "test": 2025/11/21 16:26:38 INFO Tracked function execution time name="SQL: GetContainedInPlace" duration=262.797µs
Step #3 - "test": 2025/11/21 16:26:38 INFO Fetch series cache in contained-in observation query
Step #3 - "test": 2025/11/21 16:26:39 INFO Tracked function execution time name="SQL: GetObservations" duration=2.609171ms
Step #3 - "test": 2025/11/21 16:26:39 INFO Tracked function execution time name="SQL: GetAllEntitiesOfType" duration=229.453µs
Step #3 - "test": 2025/11/21 16:26:39 INFO Fetch series cache in contained-in observation query
Step #3 - "test": 2025/11/21 16:26:39 INFO Tracked function execution time name="SQL: GetObservationsByEntityType" duration=445.105µs
Step #3 - "test": --- PASS: TestFetchContainInAll (18.18s)
Step #3 - "test": 2025/11/21 16:26:41 INFO Tracked function execution time name="SQL: GetKeyValue" duration=187.555µs
Step #3 - "test": 2025/11/21 16:26:41 INFO Tracked function execution time name="SQL: GetStatVarGroups" duration=295.144µs
Step #3 - "test": 2025/11/21 16:26:41 INFO Tracked function execution time name="SQL: GetAllStatisticalVariables" duration=376.335µs
Step #3 - "test": 2025/11/21 16:27:01 INFO Tracked function execution time name="SQL: GetAllProvenances" duration=400.837µs
Step #3 - "test": 2025/11/21 16:27:01 INFO Tracked function execution time name="SQL: GetAllEntitiesAndVariables" duration=207.106µs
Step #3 - "test": 2025/11/21 16:27:01 INFO Tracked function execution time name="SQL: GetNodePredicates" duration=338.545µs
Step #3 - "test": 2025/11/21 16:27:01 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=512.489µs
Step #3 - "test": 2025/11/21 16:27:01 INFO Tracked function execution time name="SQL: GetNodeTriples" duration=564.508µs
Step #3 - "test": 2025/11/21 16:27:01 INFO Tracked function execution time name="SQL: GetEntityInfoTriples" duration=161.645µs
Step #3 - "test": 2025/11/21 16:27:01 INFO Tracked function execution time name="SQL: GetNodePredicates" duration=234.559µs
Step #3 - "test": 2025/11/21 16:27:01 INFO Tracked function execution time name="SQL: GetNodePredicates" duration=304.264µs
Step #3 - "test": 2025/11/21 16:27:01 INFO Tracked function execution time name="SQL: GetNodePredicates" duration=5.506581ms
Step #3 - "test": 2025/11/21 16:27:01 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=5.569439ms
Step #3 - "test": 2025/11/21 16:27:01 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=11.903271ms
Step #3 - "test": 2025/11/21 16:27:01 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=13.348912ms
Step #3 - "test": 2025/11/21 16:27:01 INFO Tracked function execution time name="SQL: GetNodeTriples" duration=13.503829ms
Step #3 - "test": 2025/11/21 16:27:01 INFO Tracked function execution time name="SQL: GetEntityInfoTriples" duration=350.877µs
Step #3 - "test": 2025/11/21 16:27:02 INFO Tracked function execution time name="SQL: GetExistingStatVarGroups" duration=310.943µs
Step #3 - "test": 2025/11/21 16:27:02 INFO Tracked function execution time name="SQL: GetExistingStatVarGroups" duration=238.497µs
Step #3 - "test": 2025/11/21 16:27:02 INFO Tracked function execution time name="SQL: GetExistingStatVarGroups" duration=265.409µs
Step #3 - "test": 2025/11/21 16:27:02 INFO Tracked function execution time name="SQL: GetExistingStatVarGroups" duration=235.84µs
Step #3 - "test": 2025/11/21 16:27:02 INFO Tracked function execution time name="SQL: GetExistingStatVarGroups" duration=243.776µs
Step #3 - "test": 2025/11/21 16:27:02 INFO Tracked function execution time name="SQL: GetExistingStatVarGroups" duration=224.922µs
Step #3 - "test": 2025/11/21 16:27:02 INFO Tracked function execution time name="SQL: GetExistingStatVarGroups" duration=228.885µs
Step #3 - "test": 2025/11/21 16:27:02 INFO Tracked function execution time name="SQL: GetExistingStatVarGroups" duration=248.419µs
Step #3 - "test": 2025/11/21 16:27:02 INFO Tracked function execution time name="SQL: GetExistingStatVarGroups" duration=245.207µs
Step #3 - "test": 2025/11/21 16:27:02 INFO Tracked function execution time name="SQL: GetExistingStatVarGroups" duration=211.407µs
Step #3 - "test": 2025/11/21 16:27:02 INFO Tracked function execution time name="SQL: GetExistingStatVarGroups" duration=201.669µs
Step #3 - "test": 2025/11/21 16:27:02 INFO Tracked function execution time name="SQL: GetExistingStatVarGroups" duration=250.302µs
Step #3 - "test": 2025/11/21 16:27:02 INFO Tracked function execution time name="SQL: GetExistingStatVarGroups" duration=231.224µs
Step #3 - "test": --- PASS: TestExistence (41.07s)
Step #3 - "test": PASS
Step #3 - "test": ok github.com/datacommonsorg/mixer/internal/server/v2/observation/golden 41.626s
Step #3 - "test": === RUN TestPropertiesV2
Step #3 - "test": === PAUSE TestPropertiesV2
Step #3 - "test": === CONT TestPropertiesV2
Step #3 - "test": 2025/11/21 16:26:27 INFO Connected to sqlite db path=/workspace/test/datacommons.db
Step #3 - "test": 2025/11/21 16:26:27 INFO SQL tables check succeeded.
Step #3 - "test": 2025/11/21 16:26:27 INFO SQL schema check succeeded.
Step #3 - "test": 2025/11/21 16:26:33 INFO Tracked function execution time name="SQL: GetAllProvenances" duration=740.462µs
Step #3 - "test": 2025/11/21 16:26:33 INFO Tracked function execution time name="SQL: GetAllEntitiesAndVariables" duration=394.528µs
Step #3 - "test": 2025/11/21 16:26:33 INFO Tracked function execution time name="SQL: GetNodePredicates" duration=466.685µs
Step #3 - "test": 2025/11/21 16:26:33 INFO Tracked function execution time name="SQL: GetNodePredicates" duration=411.369µs
Step #3 - "test": --- PASS: TestPropertiesV2 (6.27s)
Step #3 - "test": PASS
Step #3 - "test": ok github.com/datacommonsorg/mixer/internal/server/v2/properties/golden 6.425s
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 TestTripleIn
Step #3 - "test": === CONT TestTripleOut
Step #3 - "test": === CONT TestSpecializationOf
Step #3 - "test": === CONT TestSimplePropertyValues
Step #3 - "test": 2025/11/21 16:26:27 INFO Connected to sqlite db path=/workspace/test/datacommons.db
Step #3 - "test": 2025/11/21 16:26:27 INFO SQL tables check succeeded.
Step #3 - "test": 2025/11/21 16:26:27 INFO SQL schema check succeeded.
Step #3 - "test": 2025/11/21 16:26:27 INFO Connected to sqlite db path=/workspace/test/datacommons.db
Step #3 - "test": 2025/11/21 16:26:27 INFO Connected to sqlite db path=/workspace/test/datacommons.db
Step #3 - "test": 2025/11/21 16:26:27 INFO SQL tables check succeeded.
Step #3 - "test": 2025/11/21 16:26:27 INFO SQL tables check succeeded.
Step #3 - "test": 2025/11/21 16:26:27 INFO SQL schema check succeeded.
Step #3 - "test": 2025/11/21 16:26:27 INFO SQL schema check succeeded.
Step #3 - "test": 2025/11/21 16:26:27 INFO Connected to sqlite db path=/workspace/test/datacommons.db
Step #3 - "test": 2025/11/21 16:26:27 INFO SQL tables check succeeded.
Step #3 - "test": 2025/11/21 16:26:27 INFO SQL schema check succeeded.
Step #3 - "test": 2025/11/21 16:26:34 INFO Tracked function execution time name="SQL: GetAllProvenances" duration=764.318µs
Step #3 - "test": 2025/11/21 16:26:34 INFO Tracked function execution time name="SQL: GetAllEntitiesAndVariables" duration=412.283µs
Step #3 - "test": 2025/11/21 16:26:34 INFO Tracked function execution time name="SQL: GetAllProvenances" duration=668.296µs
Step #3 - "test": 2025/11/21 16:26:34 INFO Tracked function execution time name="SQL: GetAllEntitiesAndVariables" duration=387.931µs
Step #3 - "test": 2025/11/21 16:26:34 INFO Tracked function execution time name="SQL: GetAllProvenances" duration=953.168µs
Step #3 - "test": 2025/11/21 16:26:34 INFO Tracked function execution time name="SQL: GetAllEntitiesAndVariables" duration=415.98µs
Step #3 - "test": 2025/11/21 16:26:35 WARN Could not read blocklist svg file. Use empty blocklist svg list.
Step #3 - "test": 2025/11/21 16:26:35 INFO Tracked function execution time name="SQL: GetContainedInPlace" duration=420.832µs
Step #3 - "test": 2025/11/21 16:26:35 INFO Tracked function execution time name="SQL: GetNodePredicates" duration=443.425µs
Step #3 - "test": 2025/11/21 16:26:35 INFO Tracked function execution time name="SQL: GetAllProvenances" duration=415.439µs
Step #3 - "test": 2025/11/21 16:26:35 INFO Tracked function execution time name="SQL: GetAllEntitiesAndVariables" duration=217.687µs
Step #3 - "test": 2025/11/21 16:26:35 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=1.13317ms
Step #3 - "test": 2025/11/21 16:26:35 INFO Tracked function execution time name="SQL: GetNodeTriples" duration=1.193245ms
Step #3 - "test": 2025/11/21 16:26:35 INFO Tracked function execution time name="SQL: GetEntityInfoTriples" duration=346.73µs
Step #3 - "test": 2025/11/21 16:26:35 INFO Tracked function execution time name="SQL: GetNodePredicates" duration=510.744µs
Step #3 - "test": 2025/11/21 16:26:35 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=1.784925ms
Step #3 - "test": 2025/11/21 16:26:35 INFO Tracked function execution time name="SQL: GetNodeTriples" duration=1.856906ms
Step #3 - "test": 2025/11/21 16:26:35 INFO Tracked function execution time name="SQL: GetEntityInfoTriples" duration=348.621µs
Step #3 - "test": --- PASS: TestTripleIn (8.25s)
Step #3 - "test": 2025/11/21 16:26:35 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=1.332218ms
Step #3 - "test": 2025/11/21 16:26:35 INFO Tracked function execution time name="SQL: GetNodeTriples" duration=1.382465ms
Step #3 - "test": 2025/11/21 16:26:35 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=25.624136ms
Step #3 - "test": 2025/11/21 16:26:35 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=41.009138ms
Step #3 - "test": 2025/11/21 16:26:35 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=43.882182ms
Step #3 - "test": 2025/11/21 16:26:35 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=44.877387ms
Step #3 - "test": 2025/11/21 16:26:35 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=47.118141ms
Step #3 - "test": 2025/11/21 16:26:35 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=47.941715ms
Step #3 - "test": 2025/11/21 16:26:35 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=49.688182ms
Step #3 - "test": 2025/11/21 16:26:35 INFO Tracked function execution time name="SQL: GetNodeTriples" duration=49.782223ms
Step #3 - "test": 2025/11/21 16:26:35 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=526.688µs
Step #3 - "test": 2025/11/21 16:26:35 INFO Tracked function execution time name="SQL: GetNodeTriples" duration=571.563µs
Step #3 - "test": 2025/11/21 16:26:35 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=450.607µs
Step #3 - "test": 2025/11/21 16:26:35 INFO Tracked function execution time name="SQL: GetNodeTriples" duration=492.981µs
Step #3 - "test": 2025/11/21 16:26:35 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=444.252µs
Step #3 - "test": 2025/11/21 16:26:35 INFO Tracked function execution time name="SQL: GetNodeTriples" duration=498.171µs
Step #3 - "test": 2025/11/21 16:26:35 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=1.100073ms
Step #3 - "test": 2025/11/21 16:26:35 INFO Tracked function execution time name="SQL: GetNodeTriples" duration=1.155677ms
Step #3 - "test": 2025/11/21 16:26:35 INFO Tracked function execution time name="SQL: GetNodePredicates" duration=300.745µs
Step #3 - "test": 2025/11/21 16:26:35 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=1.024988ms
Step #3 - "test": 2025/11/21 16:26:35 INFO Tracked function execution time name="SQL: GetNodeTriples" duration=1.085828ms
Step #3 - "test": 2025/11/21 16:26:35 INFO Tracked function execution time name="SQL: GetEntityInfoTriples" duration=341.406µs
Step #3 - "test": --- PASS: TestTripleOut (8.48s)
Step #3 - "test": 2025/11/21 16:26:35 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=617.896µs
Step #3 - "test": 2025/11/21 16:26:35 INFO Tracked function execution time name="SQL: GetNodeTriples" duration=687.046µs
Step #3 - "test": 2025/11/21 16:26:35 INFO Tracked function execution time name="SQL: GetContainedInPlace" duration=373.938µs
Step #3 - "test": 2025/11/21 16:26:35 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=2.079805ms
Step #3 - "test": 2025/11/21 16:26:35 INFO Tracked function execution time name="SQL: GetNodeTriples" duration=2.165588ms
Step #3 - "test": 2025/11/21 16:26:35 INFO Tracked function execution time name="SQL: GetContainedInPlace" duration=343.801µs
Step #3 - "test": 2025/11/21 16:26:35 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=5.212856ms
Step #3 - "test": 2025/11/21 16:26:35 INFO Tracked function execution time name="SQL: GetNodeTriples" duration=5.295959ms
Step #3 - "test": --- PASS: TestContainedInPlace (8.67s)
Step #3 - "test": 2025/11/21 16:26:37 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=530.863µs
Step #3 - "test": 2025/11/21 16:26:37 INFO Tracked function execution time name="SQL: GetNodeTriples" duration=589.187µs
Step #3 - "test": 2025/11/21 16:26:37 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=986.986µs
Step #3 - "test": 2025/11/21 16:26:37 INFO Tracked function execution time name="SQL: GetNodeTriples" duration=1.038404ms
Step #3 - "test": 2025/11/21 16:26:37 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=476.993µs
Step #3 - "test": 2025/11/21 16:26:37 INFO Tracked function execution time name="SQL: GetNodeTriples" duration=522.245µs
Step #3 - "test": 2025/11/21 16:26:37 INFO Tracked function execution time name="SQL: GetEntityInfoTriples" duration=292.721µs
Step #3 - "test": 2025/11/21 16:26:37 INFO Tracked function execution time name="SQL: GetNodePredicates" duration=309.969µs
Step #3 - "test": 2025/11/21 16:26:37 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=599.773µs
Step #3 - "test": 2025/11/21 16:26:37 INFO Tracked function execution time name="SQL: GetNodeTriples" duration=645.147µs
Step #3 - "test": 2025/11/21 16:26:37 INFO Tracked function execution time name="SQL: GetEntityInfoTriples" duration=211.775µs
Step #3 - "test": 2025/11/21 16:26:37 INFO Tracked function execution time name="SQL: GetNodePredicates" duration=242.907µs
Step #3 - "test": 2025/11/21 16:26:37 INFO Tracked function execution time name="SQL: getNodeChunkTriples" duration=669.6µs
Step #3 - "test": 2025/11/21 16:26:37 INFO Tracked function execution time name="SQL: GetNodeTriples" duration=740.794µs
Step #3 - "test": 2025/11/21 16:26:37 INFO Tracked function execution time name="SQL: GetEntityInfoTriples" duration=206.994µs
Step #3 - "test": --- PASS: TestSimplePropertyValues (10.26s)
Step #3 - "test": --- PASS: TestSpecializationOf (33.51s)
Step #3 - "test": PASS
Step #3 - "test": ok github.com/datacommonsorg/mixer/internal/server/v2/propertyvalues/golden 33.838s
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.193s
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 TestResolveDescription
Step #3 - "test": === CONT TestResolveID
Step #3 - "test": --- PASS: TestResolveID (6.27s)
Step #3 - "test": --- PASS: TestResolveCoordinate (7.08s)
Step #3 - "test": --- PASS: TestResolveDescription (7.34s)
Step #3 - "test": PASS
Step #3 - "test": ok github.com/datacommonsorg/mixer/internal/server/v2/resolve/golden 7.603s
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.118s
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.166s
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.106s
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.160s
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.088s
Step #3 - "test": === RUN TestId
Step #3 - "test": 2025/11/21 16:26:29 INFO Connected to sqlite db path=../../test/sqlquery/key_value/datacommons.db
Step #3 - "test": --- PASS: TestId (0.01s)
Step #3 - "test": === RUN TestGetKeyValue
Step #3 - "test": 2025/11/21 16:26:29 INFO Connected to sqlite db path=../../test/sqlquery/key_value/datacommons.db
Step #3 - "test": 2025/11/21 16:26:29 INFO Tracked function execution time name="SQL: GetKeyValue" duration=1.752999ms
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.073s
Step #3 - "test": === RUN TestCountObservation
Step #3 - "test": 2025/11/21 16:26:29 INFO Connected to sqlite db path=../../../test/datacommons.db
Step #3 - "test": 2025/11/21 16:26:29 INFO Tracked function execution time name="SQL: GetObservationCount" duration=1.621291ms
Step #3 - "test": 2025/11/21 16:26:29 INFO Tracked function execution time name="SQL: GetObservationCount" duration=648.46µs
Step #3 - "test": --- PASS: TestCountObservation (0.00s)
Step #3 - "test": === RUN TestGetImportTableData
Step #3 - "test": 2025/11/21 16:26:29 INFO Connected to sqlite db path=../../../test/test_get_import_table_data.db
Step #3 - "test": 2025/11/21 16:26:29 INFO Tracked function execution time name="SQL: GetAllImports" duration=872.444µs
Step #3 - "test": --- PASS: TestGetImportTableData (0.00s)
Step #3 - "test": === RUN TestGetStatVarSummaries
Step #3 - "test": 2025/11/21 16:26:29 INFO Connected to sqlite db path=../../../test/sqlquery/statvar_summary/datacommons.db
Step #3 - "test": 2025/11/21 16:26:29 INFO SQL tables check succeeded.
Step #3 - "test": 2025/11/21 16:26:29 INFO SQL schema check succeeded.
Step #3 - "test": 2025/11/21 16:26:29 INFO Tracked function execution time name="SQL: GetSVSummaries" duration=7.141478ms
Step #3 - "test": 2025/11/21 16:26:29 INFO Tracked function execution time name="SQL: GetStatVarSummaries (var1, var2)" duration=7.19237ms
Step #3 - "test": --- PASS: TestGetStatVarSummaries (0.01s)
Step #3 - "test": PASS
Step #3 - "test": ok github.com/datacommonsorg/mixer/internal/sqldb/sqlquery 0.095s
Step #3 - "test": === RUN TestReadOneTable
Step #3 - "test": --- PASS: TestReadOneTable (0.01s)
Step #3 - "test": === RUN TestReadTwoTables
Step #3 - "test": --- PASS: TestReadTwoTables (0.01s)
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.00s)
Step #3 - "test": PASS
Step #3 - "test": ok github.com/datacommonsorg/mixer/internal/store/bigtable 0.070s
Step #3 - "test": === RUN TestLoadRecogPlaceStore
Step #3 - "test": --- PASS: TestLoadRecogPlaceStore (4.51s)
Step #3 - "test": PASS
Step #3 - "test": ok github.com/datacommonsorg/mixer/internal/store/files 4.570s
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.00s)
Step #3 - "test": === RUN TestGetSQL
Step #3 - "test": --- PASS: TestGetSQL (0.00s)
Step #3 - "test": === RUN TestTranslate
Step #3 - "test": --- PASS: TestTranslate (0.07s)
Step #3 - "test": === RUN TestDcidSimplified
Step #3 - "test": --- PASS: TestDcidSimplified (0.00s)
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.02s)
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.131s
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.035s
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.062s
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.024s
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.047s
Step #3 - "test": === RUN TestZipAndEndocde
Step #3 - "test": --- PASS: TestZipAndEndocde (0.04s)
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.00s)
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.070s
Step #3 - "test": === RUN TestChartConfigRankings
Step #3 - "test": === PAUSE TestChartConfigRankings
Step #3 - "test": === CONT TestChartConfigRankings
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_city_rankings.json
Step #3 - "test": === CONT TestChartConfigRankings/missing_USA_county_rankings.json
Step #3 - "test": === CONT TestChartConfigRankings/missing_USA_state_rankings.json
Step #3 - "test": --- PASS: TestChartConfigRankings (4.24s)
Step #3 - "test": --- PASS: TestChartConfigRankings/missing_USA_county_rankings.json (2.10s)
Step #3 - "test": --- PASS: TestChartConfigRankings/missing_USA_state_rankings.json (2.10s)
Step #3 - "test": --- PASS: TestChartConfigRankings/missing_Earth_country_rankings.json (2.11s)
Step #3 - "test": --- PASS: TestChartConfigRankings/missing_USA_city_rankings.json (2.12s)
Step #3 - "test": PASS
Step #3 - "test": ok github.com/datacommonsorg/mixer/test 6.442s
Step #3 - "test": FAIL
Finished Step #3 - "test"
ERROR
ERROR: build step 3 "gcr.io/datcom-ci/full-env:mixer-only-2025-10-02" failed: step exited with non-zero status: 1
Loading