Skip to content

Optimized getStatVarSummaries query

a01cded
Select commit
Loading
Failed to load commit list.
Draft

Optimized getStatVarSummaries query #1530

Optimized getStatVarSummaries query
a01cded
Select commit
Loading
Failed to load commit list.
Google Cloud Build / mixer-pull-request (datcom-ci) failed Feb 28, 2025 in 4m 2s

Summary

Build Information

Trigger mixer-pull-request
Build 96ac6f29-a759-4c74-86af-1fb9894f4007
Start 2025-02-28T13:37:25-08:00
Duration 3m14.225s
Status FAILURE

Steps

Step Status Duration
lint SUCCESS 1m3.909s
build-proto SUCCESS 831ms
test FAILURE 2m4.216s

Details

starting build "96ac6f29-a759-4c74-86af-1fb9894f4007"

FETCHSOURCE
hint: Using 'master' as the name for the initial branch. This default branch name
hint: is subject to change. To configure the initial branch name to use in all
hint: of your new repositories, which will suppress this warning, call:
hint:
hint: 	git config --global init.defaultBranch <name>
hint:
hint: Names commonly chosen instead of 'master' are 'main', 'trunk' and
hint: 'development'. The just-created branch can be renamed via this command:
hint:
hint: 	git branch -m <name>
Initialized empty Git repository in /workspace/.git/
From https://github.com/datacommonsorg/mixer
 * branch            a01cded3f80b982a90bc621de2a90e5d14a94c0d -> FETCH_HEAD
HEAD is now at a01cded Optimized getStatVarSummaries query
GitCommit:
a01cded3f80b982a90bc621de2a90e5d14a94c0d
BUILD
Starting Step #0 - "lint"
Step #0 - "lint": Pulling image: gcr.io/datcom-ci/go-protoc
Step #0 - "lint": Using default tag: latest
Step #0 - "lint": latest: Pulling from datcom-ci/go-protoc
Step #0 - "lint": 7264a8db6415: Already exists
Step #0 - "lint": c4d48a809fc2: Pulling fs layer
Step #0 - "lint": 1e790db58572: Pulling fs layer
Step #0 - "lint": 727f4e1a48a6: Pulling fs layer
Step #0 - "lint": 3d4090b7fbdb: Pulling fs layer
Step #0 - "lint": 4e4a357a6813: Pulling fs layer
Step #0 - "lint": 6b3aefe48186: Pulling fs layer
Step #0 - "lint": d46c60bd447c: Pulling fs layer
Step #0 - "lint": d59646244fc6: Pulling fs layer
Step #0 - "lint": 4e4a357a6813: Waiting
Step #0 - "lint": 6b3aefe48186: Waiting
Step #0 - "lint": d46c60bd447c: Waiting
Step #0 - "lint": 3d4090b7fbdb: Waiting
Step #0 - "lint": 727f4e1a48a6: Download complete
Step #0 - "lint": c4d48a809fc2: Verifying Checksum
Step #0 - "lint": c4d48a809fc2: Download complete
Step #0 - "lint": c4d48a809fc2: Pull complete
Step #0 - "lint": 3d4090b7fbdb: Download complete
Step #0 - "lint": 4e4a357a6813: Download complete
Step #0 - "lint": 1e790db58572: Verifying Checksum
Step #0 - "lint": 1e790db58572: Download complete
Step #0 - "lint": 6b3aefe48186: Verifying Checksum
Step #0 - "lint": 6b3aefe48186: Download complete
Step #0 - "lint": d46c60bd447c: Verifying Checksum
Step #0 - "lint": d46c60bd447c: Download complete
Step #0 - "lint": d59646244fc6: Verifying Checksum
Step #0 - "lint": d59646244fc6: Download complete
Step #0 - "lint": 1e790db58572: Pull complete
Step #0 - "lint": 727f4e1a48a6: Pull complete
Step #0 - "lint": 3d4090b7fbdb: Pull complete
Step #0 - "lint": 4e4a357a6813: Pull complete
Step #0 - "lint": 6b3aefe48186: Pull complete
Step #0 - "lint": d46c60bd447c: Pull complete
Step #0 - "lint": d59646244fc6: Pull complete
Step #0 - "lint": Digest: sha256:2cbd01d1912f21decf2bac7a3013525782d1e7cc884dfc3f86825bcd8b7f7bce
Step #0 - "lint": Status: Downloaded newer image for gcr.io/datcom-ci/go-protoc:latest
Step #0 - "lint": gcr.io/datcom-ci/go-protoc:latest
Step #0 - "lint": Connecting to raw.githubusercontent.com (185.199.108.133:443)
Step #0 - "lint": writing to stdout
Step #0 - "lint": -                    100% |********************************| 11589  0:00:00 ETA
Step #0 - "lint": written to stdout
Step #0 - "lint": golangci/golangci-lint info checking GitHub for tag 'v1.52.2'
Step #0 - "lint": golangci/golangci-lint info found version: 1.52.2 for v1.52.2/linux/amd64
Step #0 - "lint": golangci/golangci-lint info installed ./bin/golangci-lint
Finished Step #0 - "lint"
Starting Step #1 - "build-proto"
Step #1 - "build-proto": Already have image (with digest): gcr.io/datcom-ci/go-protoc
Finished Step #1 - "build-proto"
Starting Step #2 - "test"
Step #2 - "test": Pulling image: golang
Step #2 - "test": Using default tag: latest
Step #2 - "test": latest: Pulling from library/golang
Step #2 - "test": 155ad54a8b28: Pulling fs layer
Step #2 - "test": 8031108f3cda: Pulling fs layer
Step #2 - "test": 1d281e50d3e4: Pulling fs layer
Step #2 - "test": 9760da4e8f07: Pulling fs layer
Step #2 - "test": a2a60326dddc: Pulling fs layer
Step #2 - "test": 8985a99e1ce3: Pulling fs layer
Step #2 - "test": 4f4fb700ef54: Pulling fs layer
Step #2 - "test": 8985a99e1ce3: Waiting
Step #2 - "test": 9760da4e8f07: Waiting
Step #2 - "test": a2a60326dddc: Waiting
Step #2 - "test": 8031108f3cda: Verifying Checksum
Step #2 - "test": 8031108f3cda: Download complete
Step #2 - "test": 1d281e50d3e4: Verifying Checksum
Step #2 - "test": 1d281e50d3e4: Download complete
Step #2 - "test": 155ad54a8b28: Verifying Checksum
Step #2 - "test": 155ad54a8b28: Download complete
Step #2 - "test": 8985a99e1ce3: Download complete
Step #2 - "test": 9760da4e8f07: Verifying Checksum
Step #2 - "test": 9760da4e8f07: Download complete
Step #2 - "test": 4f4fb700ef54: Verifying Checksum
Step #2 - "test": 4f4fb700ef54: Download complete
Step #2 - "test": a2a60326dddc: Verifying Checksum
Step #2 - "test": a2a60326dddc: Download complete
Step #2 - "test": 155ad54a8b28: Pull complete
Step #2 - "test": 8031108f3cda: Pull complete
Step #2 - "test": 1d281e50d3e4: Pull complete
Step #2 - "test": 9760da4e8f07: Pull complete
Step #2 - "test": a2a60326dddc: Pull complete
Step #2 - "test": 8985a99e1ce3: Pull complete
Step #2 - "test": 4f4fb700ef54: Pull complete
Step #2 - "test": Digest: sha256:3f7444391c51a11a039bf0359ee81cc64e663c17d787ad0e637a4de1a3f62a71
Step #2 - "test": Status: Downloaded newer image for golang:latest
Step #2 - "test": docker.io/library/golang:latest
Step #2 - "test": ?   	github.com/datacommonsorg/mixer/cmd	[no test files]
Step #2 - "test": ?   	github.com/datacommonsorg/mixer/examples/api	[no test files]
Step #2 - "test": === RUN   TestMergeResolve
Step #2 - "test": --- PASS: TestMergeResolve (0.00s)
Step #2 - "test": === RUN   TestMergeNode
Step #2 - "test": --- PASS: TestMergeNode (0.01s)
Step #2 - "test": === RUN   TestMergeEvent
Step #2 - "test": --- PASS: TestMergeEvent (0.00s)
Step #2 - "test": === RUN   TestMergeObservation
Step #2 - "test": --- PASS: TestMergeObservation (0.00s)
Step #2 - "test": === RUN   TestMergeMultiObservation
Step #2 - "test": --- PASS: TestMergeMultiObservation (0.00s)
Step #2 - "test": === RUN   TestMergeBulkVariableInfoResponse
Step #2 - "test": --- PASS: TestMergeBulkVariableInfoResponse (0.00s)
Step #2 - "test": === RUN   TestMergeSearchStatVarResponse
Step #2 - "test": --- PASS: TestMergeSearchStatVarResponse (0.00s)
Step #2 - "test": === RUN   TestMergeMultiNodeSearch
Step #2 - "test": --- PASS: TestMergeMultiNodeSearch (0.00s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/internal/merger	0.026s
Step #2 - "test": === RUN   TestParseMapping
Step #2 - "test": --- PASS: TestParseMapping (0.00s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/internal/parser/mcf	0.006s
Step #2 - "test": === RUN   TestParseComplexValue
Step #2 - "test": --- PASS: TestParseComplexValue (0.00s)
Step #2 - "test": === RUN   TestParseMcf
Step #2 - "test": --- PASS: TestParseMcf (0.00s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/internal/parser/tmcf	0.005s
Step #2 - "test": ?   	github.com/datacommonsorg/mixer/internal/proto	[no test files]
Step #2 - "test": ?   	github.com/datacommonsorg/mixer/internal/proto/service	[no test files]
Step #2 - "test": ?   	github.com/datacommonsorg/mixer/internal/proto/v1	[no test files]
Step #2 - "test": ?   	github.com/datacommonsorg/mixer/internal/proto/v2	[no test files]
Step #2 - "test": ?   	github.com/datacommonsorg/mixer/internal/proto/v3	[no test files]
Step #2 - "test": ?   	github.com/datacommonsorg/mixer/internal/pubsub	[no test files]
Step #2 - "test": === RUN   TestBulkVariableInfo
Step #2 - "test": === PAUSE TestBulkVariableInfo
Step #2 - "test": === CONT  TestBulkVariableInfo
Step #2 - "test": --- PASS: TestBulkVariableInfo (0.00s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/internal/server	0.028s
Step #2 - "test": ?   	github.com/datacommonsorg/mixer/internal/server/biopage	[no test files]
Step #2 - "test": ?   	github.com/datacommonsorg/mixer/internal/server/cache	[no test files]
Step #2 - "test": ?   	github.com/datacommonsorg/mixer/internal/server/convert	[no test files]
Step #2 - "test": ?   	github.com/datacommonsorg/mixer/internal/server/count	[no test files]
Step #2 - "test": ?   	github.com/datacommonsorg/mixer/internal/server/datasource	[no test files]
Step #2 - "test": ?   	github.com/datacommonsorg/mixer/internal/server/datasources	[no test files]
Step #2 - "test": ?   	github.com/datacommonsorg/mixer/internal/server/dispatcher	[no test files]
Step #2 - "test": ?   	github.com/datacommonsorg/mixer/internal/server/healthcheck	[no test files]
Step #2 - "test": ?   	github.com/datacommonsorg/mixer/internal/server/model	[no test files]
Step #2 - "test": ?   	github.com/datacommonsorg/mixer/internal/server/node	[no test files]
Step #2 - "test": === RUN   TestDecode
Step #2 - "test": --- PASS: TestDecode (0.00s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/pagination	0.012s
Step #2 - "test": ?   	github.com/datacommonsorg/mixer/internal/server/place	[no test files]
Step #2 - "test": === RUN   TestGetLocationsRankings
Step #2 - "test": === PAUSE TestGetLocationsRankings
Step #2 - "test": === RUN   TestGetPlaceStatDateWithinPlace
Step #2 - "test": === PAUSE TestGetPlaceStatDateWithinPlace
Step #2 - "test": === RUN   TestGetRelatedLocations
Step #2 - "test": === PAUSE TestGetRelatedLocations
Step #2 - "test": === CONT  TestGetLocationsRankings
Step #2 - "test": === CONT  TestGetRelatedLocations
Step #2 - "test": === CONT  TestGetPlaceStatDateWithinPlace
Step #2 - "test": --- PASS: TestGetRelatedLocations (4.44s)
Step #2 - "test": --- PASS: TestGetPlaceStatDateWithinPlace (4.46s)
Step #2 - "test": --- PASS: TestGetLocationsRankings (4.63s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/place/golden	4.743s
Step #2 - "test": ?   	github.com/datacommonsorg/mixer/internal/server/placein	[no test files]
Step #2 - "test": === RUN   TestGetPlacesIn
Step #2 - "test": === PAUSE TestGetPlacesIn
Step #2 - "test": === CONT  TestGetPlacesIn
Step #2 - "test": --- PASS: TestGetPlacesIn (3.60s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/placein/golden	3.644s
Step #2 - "test": === RUN   TestGetScorePb
Step #2 - "test": --- PASS: TestGetScorePb (0.00s)
Step #2 - "test": === RUN   TestSeriesByRank
Step #2 - "test": --- PASS: TestSeriesByRank (0.00s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/ranking	0.009s
Step #2 - "test": === RUN   TestIsContainedIn
Step #2 - "test": --- PASS: TestIsContainedIn (0.12s)
Step #2 - "test": === RUN   TestTokenize
Step #2 - "test": --- PASS: TestTokenize (0.00s)
Step #2 - "test": === RUN   TestFindPlaceCandidates
Step #2 - "test": --- PASS: TestFindPlaceCandidates (0.00s)
Step #2 - "test": === RUN   TestReplaceTokensWithCandidates
Step #2 - "test": --- PASS: TestReplaceTokensWithCandidates (0.00s)
Step #2 - "test": === RUN   TestCombineContainedIn
Step #2 - "test": --- PASS: TestCombineContainedIn (0.00s)
Step #2 - "test": === RUN   TestRankAndTrimCandidates
Step #2 - "test": --- PASS: TestRankAndTrimCandidates (0.00s)
Step #2 - "test": === RUN   TestGetId2Span
Step #2 - "test": --- PASS: TestGetId2Span (0.00s)
Step #2 - "test": === RUN   TestSplitQueryBySpan
Step #2 - "test": --- PASS: TestSplitQueryBySpan (0.00s)
Step #2 - "test": === RUN   TestGetItemsForSpans
Step #2 - "test": --- PASS: TestGetItemsForSpans (0.00s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/recon	0.162s
Step #2 - "test": === RUN   TestFindEntities
Step #2 - "test": === PAUSE TestFindEntities
Step #2 - "test": === RUN   TestRecognizeEntities
Step #2 - "test": === PAUSE TestRecognizeEntities
Step #2 - "test": === RUN   TestRecognizePlaces
Step #2 - "test": === PAUSE TestRecognizePlaces
Step #2 - "test": === RUN   TestResolveCoordinates
Step #2 - "test": === PAUSE TestResolveCoordinates
Step #2 - "test": === RUN   TestResolveEntities
Step #2 - "test": === PAUSE TestResolveEntities
Step #2 - "test": === RUN   TestResolveIds
Step #2 - "test": === PAUSE TestResolveIds
Step #2 - "test": === CONT  TestFindEntities
Step #2 - "test": === CONT  TestRecognizePlaces
Step #2 - "test": === CONT  TestResolveCoordinates
Step #2 - "test": === CONT  TestRecognizeEntities
Step #2 - "test": === CONT  TestResolveIds
Step #2 - "test": === CONT  TestResolveEntities
Step #2 - "test": --- PASS: TestRecognizePlaces (8.64s)
Step #2 - "test": --- PASS: TestResolveEntities (8.75s)
Step #2 - "test": --- PASS: TestResolveIds (8.83s)
Step #2 - "test": --- PASS: TestFindEntities (9.03s)
Step #2 - "test": --- PASS: TestRecognizeEntities (9.19s)
Step #2 - "test": --- PASS: TestResolveCoordinates (10.35s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/recon/golden	10.504s
Step #2 - "test": === RUN   TestCacheClient
Step #2 - "test": redis: 2025/02/28 21:39:26 commands.go:25: specified duration is 1ns, but minimal supported value is 1ms - truncating to 1ms
Step #2 - "test": redis: 2025/02/28 21:39:26 commands.go:25: specified duration is 1ns, but minimal supported value is 1ms - truncating to 1ms
Step #2 - "test": --- PASS: TestCacheClient (0.01s)
Step #2 - "test": === RUN   TestGetRedisAddress
Step #2 - "test": === RUN   TestGetRedisAddress/us-central1
Step #2 - "test": === RUN   TestGetRedisAddress/us-east1
Step #2 - "test": === RUN   TestGetRedisAddress/default
Step #2 - "test": === RUN   TestGetRedisAddress/unconfigured_region
Step #2 - "test": --- PASS: TestGetRedisAddress (0.00s)
Step #2 - "test":     --- PASS: TestGetRedisAddress/us-central1 (0.00s)
Step #2 - "test":     --- PASS: TestGetRedisAddress/us-east1 (0.00s)
Step #2 - "test":     --- PASS: TestGetRedisAddress/default (0.00s)
Step #2 - "test":     --- PASS: TestGetRedisAddress/unconfigured_region (0.00s)
Step #2 - "test": === RUN   TestCacheProcessorPreProcess
Step #2 - "test": === RUN   TestCacheProcessorPreProcess/Cache_Hit
Step #2 - "test": 2025/02/28 21:39:26 Cache hit: *v2.NodeRequest
Step #2 - "test": === RUN   TestCacheProcessorPreProcess/Cache_Miss
Step #2 - "test": === RUN   TestCacheProcessorPreProcess/Cache_Error
Step #2 - "test": 2025/02/28 21:39:26 Error getting cached response: failed to get from Redis: redis error
Step #2 - "test": --- PASS: TestCacheProcessorPreProcess (0.00s)
Step #2 - "test":     --- PASS: TestCacheProcessorPreProcess/Cache_Hit (0.00s)
Step #2 - "test":     --- PASS: TestCacheProcessorPreProcess/Cache_Miss (0.00s)
Step #2 - "test":     --- PASS: TestCacheProcessorPreProcess/Cache_Error (0.00s)
Step #2 - "test": === RUN   TestCacheProcessorPostProcess
Step #2 - "test": === RUN   TestCacheProcessorPostProcess/Cache_Success
Step #2 - "test": === RUN   TestCacheProcessorPostProcess/Cache_Error
Step #2 - "test": 2025/02/28 21:39:26 Error caching response: failed to set in Redis: redis error
Step #2 - "test": === RUN   TestCacheProcessorPostProcess/No_Response
Step #2 - "test": --- PASS: TestCacheProcessorPostProcess (0.00s)
Step #2 - "test":     --- PASS: TestCacheProcessorPostProcess/Cache_Success (0.00s)
Step #2 - "test":     --- PASS: TestCacheProcessorPostProcess/Cache_Error (0.00s)
Step #2 - "test":     --- PASS: TestCacheProcessorPostProcess/No_Response (0.00s)
Step #2 - "test": === RUN   TestNewEmptyResponse
Step #2 - "test": === RUN   TestNewEmptyResponse/Node
Step #2 - "test": === RUN   TestNewEmptyResponse/Observation
Step #2 - "test": === RUN   TestNewEmptyResponse/NodeSearch
Step #2 - "test": === RUN   TestNewEmptyResponse/Resolve
Step #2 - "test": --- PASS: TestNewEmptyResponse (0.00s)
Step #2 - "test":     --- PASS: TestNewEmptyResponse/Node (0.00s)
Step #2 - "test":     --- PASS: TestNewEmptyResponse/Observation (0.00s)
Step #2 - "test":     --- PASS: TestNewEmptyResponse/NodeSearch (0.00s)
Step #2 - "test":     --- PASS: TestNewEmptyResponse/Resolve (0.00s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/redis	0.026s
Step #2 - "test": ?   	github.com/datacommonsorg/mixer/internal/server/remote	[no test files]
Step #2 - "test": ?   	github.com/datacommonsorg/mixer/internal/server/resource	[no test files]
Step #2 - "test": ?   	github.com/datacommonsorg/mixer/internal/server/search	[no test files]
Step #2 - "test": ?   	github.com/datacommonsorg/mixer/internal/server/spanner	[no test files]
Step #2 - "test": === RUN   TestNode
Step #2 - "test": 2025/02/28 21:39:26 Spanner graph not enabled.
Step #2 - "test": --- PASS: TestNode (0.00s)
Step #2 - "test": === RUN   TestGetNodeProps
Step #2 - "test": 2025/02/28 21:39:26 Spanner graph not enabled.
Step #2 - "test": --- PASS: TestGetNodeProps (0.00s)
Step #2 - "test": === RUN   TestGetNodeEdgesByID
Step #2 - "test": 2025/02/28 21:39:26 Spanner graph not enabled.
Step #2 - "test": --- PASS: TestGetNodeEdgesByID (0.00s)
Step #2 - "test": === RUN   TestGetObservations
Step #2 - "test": 2025/02/28 21:39:26 Spanner graph not enabled.
Step #2 - "test": --- PASS: TestGetObservations (0.00s)
Step #2 - "test": === RUN   TestSearchNodes
Step #2 - "test": 2025/02/28 21:39:26 Spanner graph not enabled.
Step #2 - "test": --- PASS: TestSearchNodes (0.00s)
Step #2 - "test": === RUN   TestSearchObjectValues
Step #2 - "test": 2025/02/28 21:39:26 Spanner graph not enabled.
Step #2 - "test": --- PASS: TestSearchObjectValues (0.00s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/spanner/golden	0.026s
Step #2 - "test": === RUN   TestFilterAndRank
Step #2 - "test": --- PASS: TestFilterAndRank (0.00s)
Step #2 - "test": === RUN   TestByRank
Step #2 - "test": --- PASS: TestByRank (0.00s)
Step #2 - "test": === RUN   TestGetLatest
Step #2 - "test": --- PASS: TestGetLatest (0.00s)
Step #2 - "test": === RUN   TestGetValueFromBestSourcePb
Step #2 - "test": --- PASS: TestGetValueFromBestSourcePb (0.00s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/stat	0.027s
Step #2 - "test": === RUN   TestGetStatAll
Step #2 - "test": === PAUSE TestGetStatAll
Step #2 - "test": === RUN   TestGetStatDateWithinPlace
Step #2 - "test": === PAUSE TestGetStatDateWithinPlace
Step #2 - "test": === RUN   TestGetStatSeries
Step #2 - "test": === PAUSE TestGetStatSeries
Step #2 - "test": === RUN   TestGetStats
Step #2 - "test": === PAUSE TestGetStats
Step #2 - "test": === CONT  TestGetStatAll
Step #2 - "test": === CONT  TestGetStats
Step #2 - "test": === CONT  TestGetStatDateWithinPlace
Step #2 - "test": === CONT  TestGetStatSeries
Step #2 - "test": --- PASS: TestGetStatDateWithinPlace (7.07s)
Step #2 - "test": --- PASS: TestGetStatSeries (7.19s)
Step #2 - "test": --- PASS: TestGetStatAll (7.24s)
Step #2 - "test": --- PASS: TestGetStats (7.30s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/stat/golden	7.431s
Step #2 - "test": ?   	github.com/datacommonsorg/mixer/internal/server/statvar	[no test files]
Step #2 - "test": ?   	github.com/datacommonsorg/mixer/internal/server/statvar/fetcher	[no test files]
Step #2 - "test": === RUN   TestParseNodeString
Step #2 - "test": --- PASS: TestParseNodeString (0.00s)
Step #2 - "test": === RUN   TestVariableFormulaParseFormula
Step #2 - "test": --- PASS: TestVariableFormulaParseFormula (0.00s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/statvar/formula	0.029s
Step #2 - "test": === RUN   TestGetEntityStatVarsUnionV1
Step #2 - "test": === PAUSE TestGetEntityStatVarsUnionV1
Step #2 - "test": === RUN   TestGetPlaceStatsVar
Step #2 - "test": === PAUSE TestGetPlaceStatsVar
Step #2 - "test": === RUN   TestSearchStatVar
Step #2 - "test": 2025/02/28 21:39:27 Connected to sqlite db: /workspace/test/datacommons.db
Step #2 - "test": 2025/02/28 21:39:27 SQL tables check succeeded.
Step #2 - "test": 2025/02/28 21:39:27 SQL schema check succeeded.
Step #2 - "test": 2025/02/28 21:39:31 Could not read blocklist svg file. Use empty blocklist svg list.
Step #2 - "test": 2025/02/28 21:39:44 SQL: GetKeyValue: 392.106µs
Step #2 - "test": 2025/02/28 21:39:44 SQL: GetStatVarGroups: 745.745µs
Step #2 - "test": 2025/02/28 21:39:44 SQL: GetAllStatisticalVariables: 568.327µs
Step #2 - "test": 2025/02/28 21:40:14 BuildStatVarSearchIndex: 8.54530335s
Step #2 - "test": 2025/02/28 21:40:14 SQL: GetAllProvenances: 548.242µs
Step #2 - "test": 2025/02/28 21:40:14 SQL: GetAllEntitiesAndVariables: 303.646µs
Step #2 - "test": 2025/02/28 21:40:15 SQL: GetExistingStatVarGroups: 20.212389ms
Step #2 - "test": 2025/02/28 21:40:15 SQL: GetExistingStatVarGroups: 19.454466ms
Step #2 - "test": 2025/02/28 21:40:15 SQL: GetExistingStatVarGroups: 738.359µs
Step #2 - "test": 2025/02/28 21:40:17 SQL: GetExistingStatVarGroups: 7.294633ms
Step #2 - "test": --- PASS: TestSearchStatVar (50.65s)
Step #2 - "test": === CONT  TestGetEntityStatVarsUnionV1
Step #2 - "test": === CONT  TestGetPlaceStatsVar
Step #2 - "test": --- PASS: TestGetEntityStatVarsUnionV1 (2.92s)
Step #2 - "test": --- PASS: TestGetPlaceStatsVar (3.02s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/statvar/golden	53.816s
Step #2 - "test": === RUN   TestGetParentMapping
Step #2 - "test": --- PASS: TestGetParentMapping (0.00s)
Step #2 - "test": === RUN   TestRemoveSvg
Step #2 - "test": --- PASS: TestRemoveSvg (0.01s)
Step #2 - "test": === RUN   TestBuildStatVarSearchIndex
Step #2 - "test": 2025/02/28 21:39:26 BuildStatVarSearchIndex: 57.14µs
Step #2 - "test": 2025/02/28 21:39:26 BuildStatVarSearchIndex: 46.444µs
Step #2 - "test": --- PASS: TestBuildStatVarSearchIndex (0.00s)
Step #2 - "test": === RUN   TestFilter
Step #2 - "test": --- PASS: TestFilter (0.00s)
Step #2 - "test": === RUN   TestMergeCustomSVG
Step #2 - "test": --- PASS: TestMergeCustomSVG (0.00s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/statvar/hierarchy	0.024s
Step #2 - "test": === RUN   TestSearchTokens
Step #2 - "test": --- PASS: TestSearchTokens (0.00s)
Step #2 - "test": === RUN   TestCompareRankingInfo
Step #2 - "test": --- PASS: TestCompareRankingInfo (0.00s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/statvar/search	0.046s
Step #2 - "test": ?   	github.com/datacommonsorg/mixer/internal/server/translator	[no test files]
Step #2 - "test": === RUN   TestSparql
Step #2 - "test": === PAUSE TestSparql
Step #2 - "test": === RUN   TestQuery
Step #2 - "test": === PAUSE TestQuery
Step #2 - "test": === CONT  TestSparql
Step #2 - "test": === CONT  TestQuery
Step #2 - "test": --- PASS: TestSparql (6.01s)
Step #2 - "test": --- PASS: TestQuery (7.25s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/translator/golden	7.352s
Step #2 - "test": ?   	github.com/datacommonsorg/mixer/internal/server/v0/internalbio	[no test files]
Step #2 - "test": === RUN   TestGetBioPageData
Step #2 - "test": === PAUSE TestGetBioPageData
Step #2 - "test": === CONT  TestGetBioPageData
Step #2 - "test": --- PASS: TestGetBioPageData (4.63s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/v0/internalbio/golden	4.718s
Step #2 - "test": ?   	github.com/datacommonsorg/mixer/internal/server/v0/placestatvar	[no test files]
Step #2 - "test": === RUN   TestGetPlaceStatVars
Step #2 - "test": === PAUSE TestGetPlaceStatVars
Step #2 - "test": === CONT  TestGetPlaceStatVars
Step #2 - "test": --- PASS: TestGetPlaceStatVars (7.16s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/v0/placestatvar/golden	7.268s
Step #2 - "test": === RUN   TestMerge
Step #2 - "test": --- PASS: TestMerge (9.40s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/v0/propertylabel	9.486s
Step #2 - "test": === RUN   TestGetPropertyLabels
Step #2 - "test": === PAUSE TestGetPropertyLabels
Step #2 - "test": === CONT  TestGetPropertyLabels
Step #2 - "test": --- PASS: TestGetPropertyLabels (4.83s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/v0/propertylabel/golden	4.934s
Step #2 - "test": === RUN   TestFilterEntities
Step #2 - "test": --- PASS: TestFilterEntities (0.00s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/v0/propertyvalue	0.100s
Step #2 - "test": === RUN   TestGetPropertyValues
Step #2 - "test": === PAUSE TestGetPropertyValues
Step #2 - "test": === CONT  TestGetPropertyValues
Step #2 - "test": --- PASS: TestGetPropertyValues (5.25s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/v0/propertyvalue/golden	5.318s
Step #2 - "test": ?   	github.com/datacommonsorg/mixer/internal/server/v0/statpoint	[no test files]
Step #2 - "test": === RUN   TestGetStatValue
Step #2 - "test": === PAUSE TestGetStatValue
Step #2 - "test": === CONT  TestGetStatValue
Step #2 - "test": --- PASS: TestGetStatValue (5.15s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/v0/statpoint/golden	5.267s
Step #2 - "test": ?   	github.com/datacommonsorg/mixer/internal/server/v0/triple	[no test files]
Step #2 - "test": === RUN   TestGetTriples
Step #2 - "test": === PAUSE TestGetTriples
Step #2 - "test": === CONT  TestGetTriples
Step #2 - "test": --- PASS: TestGetTriples (6.84s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/v0/triple/golden	6.927s
Step #2 - "test": ?   	github.com/datacommonsorg/mixer/internal/server/v1/event	[no test files]
Step #2 - "test": === RUN   TestEventCollectionDate
Step #2 - "test": === PAUSE TestEventCollectionDate
Step #2 - "test": === RUN   TestEventCollection
Step #2 - "test": === PAUSE TestEventCollection
Step #2 - "test": === CONT  TestEventCollectionDate
Step #2 - "test": === CONT  TestEventCollection
Step #2 - "test": --- PASS: TestEventCollectionDate (6.03s)
Step #2 - "test": --- PASS: TestEventCollection (6.35s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/v1/event/golden	6.501s
Step #2 - "test": ?   	github.com/datacommonsorg/mixer/internal/server/v1/info	[no test files]
Step #2 - "test": === RUN   TestBulkPlaceInfo
Step #2 - "test": === PAUSE TestBulkPlaceInfo
Step #2 - "test": === RUN   TestBulkVariableGroupInfo
Step #2 - "test": 2025/02/28 21:39:30 Connected to sqlite db: /workspace/test/datacommons.db
Step #2 - "test": 2025/02/28 21:39:30 SQL tables check succeeded.
Step #2 - "test": 2025/02/28 21:39:30 SQL schema check succeeded.
Step #2 - "test": 2025/02/28 21:39:35 Could not read blocklist svg file. Use empty blocklist svg list.
Step #2 - "test": 2025/02/28 21:39:48 SQL: GetKeyValue: 479.873µs
Step #2 - "test": 2025/02/28 21:39:48 SQL: GetStatVarGroups: 541.762µs
Step #2 - "test": 2025/02/28 21:39:48 SQL: GetAllStatisticalVariables: 536.506µs
Step #2 - "test": 2025/02/28 21:40:08 SQL: GetAllProvenances: 549.547µs
Step #2 - "test": 2025/02/28 21:40:08 SQL: GetAllEntitiesAndVariables: 349.283µs
Step #2 - "test": 2025/02/28 21:40:08 SQL: GetExistingStatVarGroups: 509.571µs
Step #2 - "test": 2025/02/28 21:40:08 SQL: GetExistingStatVarGroups: 199.757µs
Step #2 - "test": 2025/02/28 21:40:08 SQL: GetExistingStatVarGroups: 415.065µs
Step #2 - "test": 2025/02/28 21:40:08 SQL: GetExistingStatVarGroups: 378.719µs
Step #2 - "test": 2025/02/28 21:40:08 SQL: GetExistingStatVarGroups: 646.36µs
Step #2 - "test": 2025/02/28 21:40:08 SQL: GetExistingStatVarGroups: 377.65µs
Step #2 - "test": 2025/02/28 21:40:08 SQL: GetExistingStatVarGroups: 755.491µs
Step #2 - "test": --- PASS: TestBulkVariableGroupInfo (37.91s)
Step #2 - "test": === RUN   TestBulkVariableInfo
Step #2 - "test": === PAUSE TestBulkVariableInfo
Step #2 - "test": === RUN   TestPlaceInfo
Step #2 - "test": === PAUSE TestPlaceInfo
Step #2 - "test": === RUN   TestVariableGroupInfo
Step #2 - "test": 2025/02/28 21:40:10 Could not read blocklist svg file. Use empty blocklist svg list.
Step #2 - "test": --- PASS: TestVariableGroupInfo (27.15s)
Step #2 - "test": === RUN   TestVariableInfo
Step #2 - "test": === PAUSE TestVariableInfo
Step #2 - "test": === CONT  TestBulkPlaceInfo
Step #2 - "test": === CONT  TestPlaceInfo
Step #2 - "test": === CONT  TestBulkVariableInfo
Step #2 - "test": === CONT  TestVariableInfo
Step #2 - "test": 2025/02/28 21:40:35 Connected to sqlite db: /workspace/test/datacommons.db
Step #2 - "test": 2025/02/28 21:40:35 SQL tables check succeeded.
Step #2 - "test": 2025/02/28 21:40:35 SQL schema check succeeded.
Step #2 - "test": 2025/02/28 21:40:37 SQL: GetAllProvenances: 633.767µs
Step #2 - "test": 2025/02/28 21:40:37 SQL: GetAllEntitiesAndVariables: 267.458µs
Step #2 - "test": 2025/02/28 21:40:37 SQL: GetSVSummaries: 1.226656ms
Step #2 - "test": 2025/02/28 21:40:37 SQL: GetStatVarSummaries (Count_Person_Female, FertilityRate_Person_Female): 1.259384ms
Step #2 - "test": --- PASS: TestVariableInfo (2.41s)
Step #2 - "test": --- PASS: TestBulkPlaceInfo (2.43s)
Step #2 - "test": --- PASS: TestPlaceInfo (2.48s)
Step #2 - "test": 2025/02/28 21:40:38 SQL: GetSVSummaries: 2.108942ms
Step #2 - "test": 2025/02/28 21:40:38 SQL: GetStatVarSummaries (Count_Person_Female, test_var_1): 2.158933ms
Step #2 - "test": --- PASS: TestBulkVariableInfo (2.67s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/v1/info/golden	67.805s
Step #2 - "test": ?   	github.com/datacommonsorg/mixer/internal/server/v1/observationdates	[no test files]
Step #2 - "test": === RUN   TestBulkObservationDatesLinked
Step #2 - "test": === PAUSE TestBulkObservationDatesLinked
Step #2 - "test": === CONT  TestBulkObservationDatesLinked
Step #2 - "test": 2025/02/28 21:39:30 Connected to sqlite db: /workspace/test/datacommons.db
Step #2 - "test": 2025/02/28 21:39:30 SQL tables check succeeded.
Step #2 - "test": 2025/02/28 21:39:30 SQL schema check succeeded.
Step #2 - "test": 2025/02/28 21:39:34 SQL: GetAllProvenances: 862.97µs
Step #2 - "test": 2025/02/28 21:39:34 SQL: GetAllEntitiesAndVariables: 448.564µs
Step #2 - "test": 2025/02/28 21:39:35 SQL: GetContainedInPlace: 462.791µs
Step #2 - "test": 2025/02/28 21:39:35 SQL: GetEntityCount: 759.571µs
Step #2 - "test": 2025/02/28 21:39:35 SQL: DateEntityCount: 778.747µs
Step #2 - "test": 2025/02/28 21:39:35 SQL: GetContainedInPlace: 448.012µs
Step #2 - "test": 2025/02/28 21:39:35 SQL: GetEntityCount: 927.963µs
Step #2 - "test": 2025/02/28 21:39:35 SQL: DateEntityCount: 966.384µs
Step #2 - "test": 2025/02/28 21:39:35 SQL: GetContainedInPlace: 448.018µs
Step #2 - "test": 2025/02/28 21:39:35 SQL: GetEntityCount: 1.327115ms
Step #2 - "test": 2025/02/28 21:39:35 SQL: DateEntityCount: 1.340953ms
Step #2 - "test": --- PASS: TestBulkObservationDatesLinked (5.34s)
Step #2
...
[Logs truncated due to log size limitations. For full logs, see https://console.cloud.google.com/cloud-build/builds/96ac6f29-a759-4c74-86af-1fb9894f4007?project=879489846695.]
...
: 553.21µs
Step #2 - "test": 2025/02/28 21:39:52 SQL: GetObservations: 414.427µs
Step #2 - "test": 2025/02/28 21:39:52 SQL: GetObservations: 1.043513ms
Step #2 - "test": 2025/02/28 21:39:52 SQL: GetContainedInPlace: 500.919µs
Step #2 - "test": 2025/02/28 21:39:52 SQL: GetObservations: 3.826016ms
Step #2 - "test": 2025/02/28 21:39:52 SQL: GetObservations: 2.595595ms
Step #2 - "test": 2025/02/28 21:39:52 SQL: GetObservations: 2.536157ms
Step #2 - "test": 2025/02/28 21:39:52 SQL: GetObservations: 12.626058ms
Step #2 - "test": --- PASS: TestFetchDirect (12.72s)
Step #2 - "test": 2025/02/28 21:39:52 SQL: GetContainedInPlace: 448.789µs
Step #2 - "test": 2025/02/28 21:39:52 SQL: GetObservations: 7.119281ms
Step #2 - "test": 2025/02/28 21:39:52 SQL: GetObservationsByEntityType: 6.231666ms
Step #2 - "test": --- PASS: TestFetchContainIn (12.93s)
Step #2 - "test": 2025/02/28 21:39:52 SQL: getNodeChunkTriples: 6.098641ms
Step #2 - "test": 2025/02/28 21:39:52 SQL: getNodeChunkTriples: 11.000133ms
Step #2 - "test": 2025/02/28 21:39:52 SQL: getNodeChunkTriples: 12.034416ms
Step #2 - "test": 2025/02/28 21:39:52 SQL: GetNodeTriples: 12.191796ms
Step #2 - "test": 2025/02/28 21:39:52 SQL: GetEntityInfoTriples: 248.288µs
Step #2 - "test": 2025/02/28 21:39:52 SQL: GetObservations: 974.572µs
Step #2 - "test": 2025/02/28 21:39:52 SQL: GetObservations: 777.64µs
Step #2 - "test": 2025/02/28 21:39:53 SQL: GetObservations: 543.389µs
Step #2 - "test": 2025/02/28 21:39:53 SQL: getNodeChunkTriples: 8.844694ms
Step #2 - "test": 2025/02/28 21:39:53 SQL: getNodeChunkTriples: 13.973077ms
Step #2 - "test": 2025/02/28 21:39:53 SQL: getNodeChunkTriples: 16.295314ms
Step #2 - "test": 2025/02/28 21:39:53 SQL: GetNodeTriples: 16.536452ms
Step #2 - "test": 2025/02/28 21:39:53 SQL: GetEntityInfoTriples: 393.768µs
Step #2 - "test": 2025/02/28 21:39:53 SQL: GetObservations: 682.234µs
Step #2 - "test": 2025/02/28 21:39:53 SQL: GetObservations: 503.365µs
Step #2 - "test": 2025/02/28 21:39:53 SQL: GetObservations: 421.405µs
Step #2 - "test": 2025/02/28 21:39:53 SQL: GetObservations: 396.987µs
Step #2 - "test": 2025/02/28 21:39:53 SQL: GetContainedInPlace: 331.165µs
Step #2 - "test": 2025/02/28 21:39:53 SQL: GetObservations: 483.916µs
Step #2 - "test": 2025/02/28 21:39:53 SQL: GetObservations: 350.197µs
Step #2 - "test": 2025/02/28 21:39:53 SQL: GetContainedInPlace: 293.834µs
Step #2 - "test": 2025/02/28 21:39:53 Fetch series cache in contained-in observation query
Step #2 - "test": 2025/02/28 21:39:53 SQL: GetObservations: 408.344µs
Step #2 - "test": 2025/02/28 21:39:53 SQL: GetContainedInPlace: 421.37µs
Step #2 - "test": 2025/02/28 21:39:53 SQL: GetObservations: 647.96µs
Step #2 - "test": 2025/02/28 21:39:53 SQL: GetObservations: 393.784µs
Step #2 - "test": 2025/02/28 21:39:53 SQL: GetObservations: 510.394µs
Step #2 - "test": --- PASS: TestCalculation (13.55s)
Step #2 - "test": 2025/02/28 21:39:53 SQL: GetContainedInPlace: 328.654µs
Step #2 - "test": 2025/02/28 21:39:53 SQL: GetObservations: 467.423µs
Step #2 - "test": 2025/02/28 21:39:53 SQL: GetContainedInPlace: 315.322µs
Step #2 - "test": 2025/02/28 21:39:53 SQL: GetObservations: 992.689µs
Step #2 - "test": 2025/02/28 21:39:53 SQL: GetContainedInPlace: 374.998µs
Step #2 - "test": 2025/02/28 21:39:53 SQL: GetObservations: 542.596µs
Step #2 - "test": 2025/02/28 21:39:53 SQL: GetObservations: 7.55107ms
Step #2 - "test": 2025/02/28 21:39:53 SQL: GetContainedInPlace: 330.192µs
Step #2 - "test": 2025/02/28 21:39:53 SQL: GetObservations: 1.376117ms
Step #2 - "test": 2025/02/28 21:39:53 SQL: GetContainedInPlace: 302.052µs
Step #2 - "test": 2025/02/28 21:39:53 SQL: GetObservations: 481.391µs
Step #2 - "test": 2025/02/28 21:39:53 SQL: GetContainedInPlace: 334.417µs
Step #2 - "test": 2025/02/28 21:39:53 SQL: GetObservations: 1.122894ms
Step #2 - "test": --- PASS: TestCalculationForObsCollection (13.79s)
Step #2 - "test": 2025/02/28 21:39:53 SQL: GetContainedInPlace: 347.227µs
Step #2 - "test": 2025/02/28 21:39:53 SQL: GetObservations: 980.796µs
Step #2 - "test": 2025/02/28 21:39:53 SQL: GetContainedInPlace: 275.834µs
Step #2 - "test": 2025/02/28 21:39:53 SQL: GetObservations: 440.121µs
Step #2 - "test": 2025/02/28 21:39:53 SQL: GetContainedInPlace: 364.988µs
Step #2 - "test": 2025/02/28 21:39:53 SQL: GetObservations: 2.739923ms
Step #2 - "test": 2025/02/28 21:39:53 SQL: GetContainedInPlace: 384.371µs
Step #2 - "test": 2025/02/28 21:39:53 Fetch series cache in contained-in observation query
Step #2 - "test": 2025/02/28 21:39:54 SQL: GetObservations: 1.989431ms
Step #2 - "test": 2025/02/28 21:39:54 SQL: GetContainedInPlace: 331.425µs
Step #2 - "test": 2025/02/28 21:39:54 SQL: GetObservations: 275ns
Step #2 - "test": 2025/02/28 21:39:54 SQL: GetObservationsByEntityType: 595.467µs
Step #2 - "test": --- PASS: TestFetchContainInLatest (14.48s)
Step #2 - "test": 2025/02/28 21:39:54 SQL: GetContainedInPlace: 437.384µs
Step #2 - "test": 2025/02/28 21:39:54 Fetch series cache in contained-in observation query
Step #2 - "test": 2025/02/28 21:39:54 SQL: GetObservations: 1.919233ms
Step #2 - "test": 2025/02/28 21:39:54 SQL: GetContainedInPlace: 314.724µs
Step #2 - "test": 2025/02/28 21:39:54 Fetch series cache in contained-in observation query
Step #2 - "test": 2025/02/28 21:39:54 SQL: GetObservations: 2.402079ms
Step #2 - "test": 2025/02/28 21:39:55 SQL: GetContainedInPlace: 263.574µs
Step #2 - "test": 2025/02/28 21:39:55 Fetch series cache in contained-in observation query
Step #2 - "test": 2025/02/28 21:39:55 SQL: GetObservations: 3.632023ms
Step #2 - "test": 2025/02/28 21:39:55 SQL: GetAllEntitiesOfType: 242.639µs
Step #2 - "test": 2025/02/28 21:39:55 Fetch series cache in contained-in observation query
Step #2 - "test": 2025/02/28 21:39:55 SQL: GetObservationsByEntityType: 703.686µs
Step #2 - "test": --- PASS: TestFetchContainInAll (15.71s)
Step #2 - "test": 2025/02/28 21:39:59 SQL: GetKeyValue: 243.66µs
Step #2 - "test": 2025/02/28 21:39:59 SQL: GetStatVarGroups: 371.845µs
Step #2 - "test": 2025/02/28 21:39:59 SQL: GetAllStatisticalVariables: 324.305µs
Step #2 - "test": 2025/02/28 21:40:19 SQL: GetAllProvenances: 410.518µs
Step #2 - "test": 2025/02/28 21:40:19 SQL: GetAllEntitiesAndVariables: 260.08µs
Step #2 - "test": 2025/02/28 21:40:19 SQL: GetNodePredicates: 283.376µs
Step #2 - "test": 2025/02/28 21:40:19 SQL: getNodeChunkTriples: 726.016µs
Step #2 - "test": 2025/02/28 21:40:19 SQL: GetNodeTriples: 789.514µs
Step #2 - "test": 2025/02/28 21:40:19 SQL: GetEntityInfoTriples: 253.519µs
Step #2 - "test": 2025/02/28 21:40:19 SQL: GetNodePredicates: 259.754µs
Step #2 - "test": 2025/02/28 21:40:19 SQL: GetNodePredicates: 245.698µs
Step #2 - "test": 2025/02/28 21:40:19 SQL: GetNodePredicates: 5.540903ms
Step #2 - "test": 2025/02/28 21:40:20 SQL: getNodeChunkTriples: 14.820759ms
Step #2 - "test": 2025/02/28 21:40:20 SQL: getNodeChunkTriples: 24.067525ms
Step #2 - "test": 2025/02/28 21:40:20 SQL: getNodeChunkTriples: 30.539988ms
Step #2 - "test": 2025/02/28 21:40:20 SQL: GetNodeTriples: 30.629042ms
Step #2 - "test": 2025/02/28 21:40:20 SQL: GetEntityInfoTriples: 500.102µs
Step #2 - "test": 2025/02/28 21:40:20 SQL: GetExistingStatVarGroups: 414.634µs
Step #2 - "test": 2025/02/28 21:40:20 SQL: GetExistingStatVarGroups: 270.443µs
Step #2 - "test": 2025/02/28 21:40:20 SQL: GetExistingStatVarGroups: 390.599µs
Step #2 - "test": 2025/02/28 21:40:20 SQL: GetExistingStatVarGroups: 320.211µs
Step #2 - "test": 2025/02/28 21:40:20 SQL: GetExistingStatVarGroups: 296.584µs
Step #2 - "test": 2025/02/28 21:40:20 SQL: GetExistingStatVarGroups: 239.237µs
Step #2 - "test": 2025/02/28 21:40:20 SQL: GetExistingStatVarGroups: 249.606µs
Step #2 - "test": 2025/02/28 21:40:20 SQL: GetExistingStatVarGroups: 298.844µs
Step #2 - "test": 2025/02/28 21:40:20 SQL: GetExistingStatVarGroups: 241.156µs
Step #2 - "test": 2025/02/28 21:40:20 SQL: GetExistingStatVarGroups: 246.199µs
Step #2 - "test": 2025/02/28 21:40:20 SQL: GetExistingStatVarGroups: 443.132µs
Step #2 - "test": 2025/02/28 21:40:20 SQL: GetExistingStatVarGroups: 252.987µs
Step #2 - "test": 2025/02/28 21:40:20 SQL: GetExistingStatVarGroups: 251.404µs
Step #2 - "test": --- PASS: TestExistence (41.06s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/v2/observation/golden	41.397s
Step #2 - "test": ?   	github.com/datacommonsorg/mixer/internal/server/v2/properties	[no test files]
Step #2 - "test": === RUN   TestPropertiesV2
Step #2 - "test": === PAUSE TestPropertiesV2
Step #2 - "test": === CONT  TestPropertiesV2
Step #2 - "test": 2025/02/28 21:39:39 Connected to sqlite db: /workspace/test/datacommons.db
Step #2 - "test": 2025/02/28 21:39:39 SQL tables check succeeded.
Step #2 - "test": 2025/02/28 21:39:39 SQL schema check succeeded.
Step #2 - "test": 2025/02/28 21:39:45 SQL: GetAllProvenances: 611.298µs
Step #2 - "test": 2025/02/28 21:39:45 SQL: GetAllEntitiesAndVariables: 445.322µs
Step #2 - "test": 2025/02/28 21:39:45 SQL: GetNodePredicates: 704.372µs
Step #2 - "test": 2025/02/28 21:39:45 SQL: GetNodePredicates: 608.894µs
Step #2 - "test": --- PASS: TestPropertiesV2 (5.94s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/v2/properties/golden	6.044s
Step #2 - "test": ?   	github.com/datacommonsorg/mixer/internal/server/v2/propertyvalues	[no test files]
Step #2 - "test": === RUN   TestContainedInPlace
Step #2 - "test": === PAUSE TestContainedInPlace
Step #2 - "test": === RUN   TestSimplePropertyValues
Step #2 - "test": === PAUSE TestSimplePropertyValues
Step #2 - "test": === RUN   TestSpecializationOf
Step #2 - "test": === PAUSE TestSpecializationOf
Step #2 - "test": === RUN   TestTripleIn
Step #2 - "test": === PAUSE TestTripleIn
Step #2 - "test": === RUN   TestTripleOut
Step #2 - "test": === PAUSE TestTripleOut
Step #2 - "test": === CONT  TestContainedInPlace
Step #2 - "test": === CONT  TestTripleIn
Step #2 - "test": === CONT  TestTripleOut
Step #2 - "test": === CONT  TestSpecializationOf
Step #2 - "test": === CONT  TestSimplePropertyValues
Step #2 - "test": 2025/02/28 21:39:40 Connected to sqlite db: /workspace/test/datacommons.db
Step #2 - "test": 2025/02/28 21:39:40 Connected to sqlite db: /workspace/test/datacommons.db
Step #2 - "test": 2025/02/28 21:39:40 Connected to sqlite db: /workspace/test/datacommons.db
Step #2 - "test": 2025/02/28 21:39:40 Connected to sqlite db: /workspace/test/datacommons.db
Step #2 - "test": 2025/02/28 21:39:40 SQL tables check succeeded.
Step #2 - "test": 2025/02/28 21:39:40 SQL schema check succeeded.
Step #2 - "test": 2025/02/28 21:39:40 SQL tables check succeeded.
Step #2 - "test": 2025/02/28 21:39:40 SQL schema check succeeded.
Step #2 - "test": 2025/02/28 21:39:40 SQL tables check succeeded.
Step #2 - "test": 2025/02/28 21:39:40 SQL tables check succeeded.
Step #2 - "test": 2025/02/28 21:39:40 SQL schema check succeeded.
Step #2 - "test": 2025/02/28 21:39:40 SQL schema check succeeded.
Step #2 - "test": 2025/02/28 21:39:49 SQL: GetAllProvenances: 1.586866ms
Step #2 - "test": 2025/02/28 21:39:49 SQL: GetAllEntitiesAndVariables: 684.832µs
Step #2 - "test": 2025/02/28 21:39:49 SQL: GetAllProvenances: 446.709µs
Step #2 - "test": 2025/02/28 21:39:49 SQL: GetAllEntitiesAndVariables: 319.571µs
Step #2 - "test": 2025/02/28 21:39:49 SQL: GetAllProvenances: 863.394µs
Step #2 - "test": 2025/02/28 21:39:49 SQL: GetAllEntitiesAndVariables: 523.114µs
Step #2 - "test": 2025/02/28 21:39:49 SQL: GetAllProvenances: 560.258µs
Step #2 - "test": 2025/02/28 21:39:49 SQL: GetAllEntitiesAndVariables: 311.011µs
Step #2 - "test": 2025/02/28 21:39:49 Could not read blocklist svg file. Use empty blocklist svg list.
Step #2 - "test": 2025/02/28 21:39:49 SQL: GetNodePredicates: 412.975µs
Step #2 - "test": 2025/02/28 21:39:49 SQL: GetContainedInPlace: 421.704µs
Step #2 - "test": 2025/02/28 21:39:49 SQL: getNodeChunkTriples: 3.506329ms
Step #2 - "test": 2025/02/28 21:39:49 SQL: GetNodeTriples: 3.567525ms
Step #2 - "test": 2025/02/28 21:39:49 SQL: GetEntityInfoTriples: 293.368µs
Step #2 - "test": 2025/02/28 21:39:49 SQL: getNodeChunkTriples: 813.673µs
Step #2 - "test": 2025/02/28 21:39:49 SQL: GetNodeTriples: 859.268µs
Step #2 - "test": 2025/02/28 21:39:49 SQL: GetEntityInfoTriples: 267.421µs
Step #2 - "test": 2025/02/28 21:39:49 SQL: getNodeChunkTriples: 696.26µs
Step #2 - "test": 2025/02/28 21:39:49 SQL: GetNodeTriples: 735.982µs
Step #2 - "test": 2025/02/28 21:39:49 SQL: getNodeChunkTriples: 943.785µs
Step #2 - "test": 2025/02/28 21:39:49 SQL: GetNodeTriples: 978.633µs
Step #2 - "test": 2025/02/28 21:39:49 SQL: GetNodePredicates: 408.737µs
Step #2 - "test": 2025/02/28 21:39:49 SQL: GetNodePredicates: 701.027µs
Step #2 - "test": 2025/02/28 21:39:49 SQL: getNodeChunkTriples: 1.025204ms
Step #2 - "test": 2025/02/28 21:39:49 SQL: GetNodeTriples: 1.09576ms
Step #2 - "test": 2025/02/28 21:39:49 SQL: getNodeChunkTriples: 1.782885ms
Step #2 - "test": 2025/02/28 21:39:49 SQL: GetNodeTriples: 1.827443ms
Step #2 - "test": 2025/02/28 21:39:49 SQL: GetEntityInfoTriples: 278.576µs
Step #2 - "test": --- PASS: TestTripleOut (9.38s)
Step #2 - "test": 2025/02/28 21:39:50 SQL: getNodeChunkTriples: 831.085µs
Step #2 - "test": 2025/02/28 21:39:50 SQL: GetNodeTriples: 900.891µs
Step #2 - "test": 2025/02/28 21:39:50 SQL: getNodeChunkTriples: 1.208682ms
Step #2 - "test": 2025/02/28 21:39:50 SQL: GetNodeTriples: 1.36156ms
Step #2 - "test": --- PASS: TestTripleIn (9.73s)
Step #2 - "test": 2025/02/28 21:39:50 SQL: getNodeChunkTriples: 7.492167ms
Step #2 - "test": 2025/02/28 21:39:50 SQL: getNodeChunkTriples: 15.960232ms
Step #2 - "test": 2025/02/28 21:39:50 SQL: getNodeChunkTriples: 27.343557ms
Step #2 - "test": 2025/02/28 21:39:50 SQL: getNodeChunkTriples: 35.863448ms
Step #2 - "test": 2025/02/28 21:39:50 SQL: getNodeChunkTriples: 41.943592ms
Step #2 - "test": 2025/02/28 21:39:50 SQL: getNodeChunkTriples: 49.921474ms
Step #2 - "test": 2025/02/28 21:39:50 SQL: getNodeChunkTriples: 50.14429ms
Step #2 - "test": 2025/02/28 21:39:50 SQL: GetNodeTriples: 57.012938ms
Step #2 - "test": 2025/02/28 21:39:50 SQL: getNodeChunkTriples: 688.628µs
Step #2 - "test": 2025/02/28 21:39:50 SQL: GetNodeTriples: 834.722µs
Step #2 - "test": 2025/02/28 21:39:50 SQL: GetContainedInPlace: 330.563µs
Step #2 - "test": 2025/02/28 21:39:50 SQL: getNodeChunkTriples: 1.753219ms
Step #2 - "test": 2025/02/28 21:39:50 SQL: GetNodeTriples: 1.826493ms
Step #2 - "test": 2025/02/28 21:39:50 SQL: GetContainedInPlace: 476.159µs
Step #2 - "test": 2025/02/28 21:39:50 SQL: getNodeChunkTriples: 5.320508ms
Step #2 - "test": 2025/02/28 21:39:50 SQL: GetNodeTriples: 5.399523ms
Step #2 - "test": --- PASS: TestContainedInPlace (10.33s)
Step #2 - "test": 2025/02/28 21:39:52 SQL: getNodeChunkTriples: 980.86µs
Step #2 - "test": 2025/02/28 21:39:52 SQL: GetNodeTriples: 1.061443ms
Step #2 - "test": 2025/02/28 21:39:52 SQL: getNodeChunkTriples: 626.486µs
Step #2 - "test": 2025/02/28 21:39:52 SQL: GetNodeTriples: 669.093µs
Step #2 - "test": 2025/02/28 21:39:52 SQL: getNodeChunkTriples: 490.34µs
Step #2 - "test": 2025/02/28 21:39:52 SQL: GetNodeTriples: 524.143µs
Step #2 - "test": 2025/02/28 21:39:52 SQL: GetEntityInfoTriples: 163.921µs
Step #2 - "test": 2025/02/28 21:39:52 SQL: GetNodePredicates: 308.368µs
Step #2 - "test": 2025/02/28 21:39:52 SQL: getNodeChunkTriples: 995.323µs
Step #2 - "test": 2025/02/28 21:39:52 SQL: GetNodeTriples: 1.029791ms
Step #2 - "test": 2025/02/28 21:39:52 SQL: GetEntityInfoTriples: 177.57µs
Step #2 - "test": 2025/02/28 21:39:52 SQL: GetNodePredicates: 424.475µs
Step #2 - "test": 2025/02/28 21:39:52 SQL: getNodeChunkTriples: 1.173663ms
Step #2 - "test": 2025/02/28 21:39:52 SQL: GetNodeTriples: 1.221352ms
Step #2 - "test": 2025/02/28 21:39:52 SQL: GetEntityInfoTriples: 183.882µs
Step #2 - "test": --- PASS: TestSimplePropertyValues (12.29s)
Step #2 - "test": --- PASS: TestSpecializationOf (36.91s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/v2/propertyvalues/golden	37.093s
Step #2 - "test": === RUN   TestParseCoordinate
Step #2 - "test": --- PASS: TestParseCoordinate (0.00s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/v2/resolve	0.082s
Step #2 - "test": === RUN   TestResolveCoordinate
Step #2 - "test": === PAUSE TestResolveCoordinate
Step #2 - "test": === RUN   TestResolveDescription
Step #2 - "test": === PAUSE TestResolveDescription
Step #2 - "test": === RUN   TestResolveID
Step #2 - "test": === PAUSE TestResolveID
Step #2 - "test": === CONT  TestResolveCoordinate
Step #2 - "test": === CONT  TestResolveDescription
Step #2 - "test": === CONT  TestResolveID
Step #2 - "test": --- PASS: TestResolveID (7.72s)
Step #2 - "test": --- PASS: TestResolveCoordinate (8.57s)
Step #2 - "test": --- PASS: TestResolveDescription (8.75s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/v2/resolve/golden	8.989s
Step #2 - "test": === RUN   TestFetchChildPlaces
Step #2 - "test": === PAUSE TestFetchChildPlaces
Step #2 - "test": === CONT  TestFetchChildPlaces
Step #2 - "test": --- PASS: TestFetchChildPlaces (0.00s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/v2/shared	0.159s
Step #2 - "test": === RUN   TestV3Node
Step #2 - "test": --- PASS: TestV3Node (0.00s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/v3/node/golden	0.077s
Step #2 - "test": === RUN   TestV3NodeSearch
Step #2 - "test": --- PASS: TestV3NodeSearch (0.00s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/v3/nodesearch/golden	0.127s
Step #2 - "test": ?   	github.com/datacommonsorg/mixer/internal/server/v3/observation	[no test files]
Step #2 - "test": === RUN   TestV3Observation
Step #2 - "test": --- PASS: TestV3Observation (0.00s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/internal/server/v3/observation/golden	0.141s
Step #2 - "test": === RUN   TestGetKeyValue
Step #2 - "test": 2025/02/28 21:39:43 Connected to sqlite db: ../../test/sqlquery/key_value/datacommons.db
Step #2 - "test": 2025/02/28 21:39:43 SQL: GetKeyValue: 5.734792ms
Step #2 - "test": --- PASS: TestGetKeyValue (0.01s)
Step #2 - "test": === RUN   TestGenerateCTESelectStatement
Step #2 - "test": --- PASS: TestGenerateCTESelectStatement (0.00s)
Step #2 - "test": === RUN   TestChunkSlice
Step #2 - "test": --- PASS: TestChunkSlice (0.00s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/internal/sqldb	0.072s
Step #2 - "test": === RUN   TestCountObservation
Step #2 - "test": 2025/02/28 21:39:43 Connected to sqlite db: ../../../test/datacommons.db
Step #2 - "test": 2025/02/28 21:39:43 SQL: GetObservationCount: 1.345301ms
Step #2 - "test": 2025/02/28 21:39:43 SQL: GetObservationCount: 568.249µs
Step #2 - "test": --- PASS: TestCountObservation (0.00s)
Step #2 - "test": === RUN   TestGetImportTableData
Step #2 - "test": 2025/02/28 21:39:43 Connected to sqlite db: ../../../test/test_get_import_table_data.db
Step #2 - "test": 2025/02/28 21:39:43 SQL: GetAllImports: 798.724µs
Step #2 - "test": --- PASS: TestGetImportTableData (0.00s)
Step #2 - "test": === RUN   TestGetStatVarSummaries
Step #2 - "test": 2025/02/28 21:39:43 Connected to sqlite db: ../../../test/sqlquery/statvar_summary/datacommons.db
Step #2 - "test": 2025/02/28 21:39:43 SQL tables check succeeded.
Step #2 - "test": 2025/02/28 21:39:43 SQL schema check succeeded.
Step #2 - "test": 2025/02/28 21:39:43 SQL: GetSVSummaries: 1.461884ms
Step #2 - "test": 2025/02/28 21:39:43 SQL: GetStatVarSummaries (var1, var2): 8.128939ms
Step #2 - "test":     statvar_summary_test.go:91: Unexpected diff: [map[var1].PlaceTypeSummary.map[Country].TopPlaces.slice[0].Dcid: country/CHN != country/USA map[var1].PlaceTypeSummary.map[Country].TopPlaces.slice[0].Name: country/CHN != country/USA map[var1].PlaceTypeSummary.map[Country].TopPlaces.slice[1].Dcid: country/USA != country/CHN map[var1].PlaceTypeSummary.map[Country].TopPlaces.slice[1].Name: country/USA != country/CHN map[var1].PlaceTypeSummary.map[Country].TopPlaces.slice[2]: dcid:"country/USA"  name:"country/USA" != <no value> map[var1].PlaceTypeSummary.map[State].TopPlaces.slice[1].Dcid: geoId/01 != geoId/02 map[var1].PlaceTypeSummary.map[State].TopPlaces.slice[1].Name: geoId/01 != geoId/02 map[var1].PlaceTypeSummary.map[State].TopPlaces.slice[2]: dcid:"geoId/02"  name:"geoId/02" != <no value> map[var2].PlaceTypeSummary.map[Country].TopPlaces.slice[0].Dcid: country/CHN != country/USA map[var2].PlaceTypeSummary.map[Country].TopPlaces.slice[0].Name: country/CHN != country/USA]
Step #2 - "test": --- FAIL: TestGetStatVarSummaries (0.01s)
Step #2 - "test": FAIL
Step #2 - "test": FAIL	github.com/datacommonsorg/mixer/internal/sqldb/sqlquery	0.129s
Step #2 - "test": ?   	github.com/datacommonsorg/mixer/internal/store	[no test files]
Step #2 - "test": === RUN   TestReadOneTable
Step #2 - "test": --- PASS: TestReadOneTable (0.05s)
Step #2 - "test": === RUN   TestReadTwoTables
Step #2 - "test": --- PASS: TestReadTwoTables (0.01s)
Step #2 - "test": === RUN   TestSortTables
Step #2 - "test": --- PASS: TestSortTables (0.00s)
Step #2 - "test": === RUN   TestBuildRowList
Step #2 - "test": --- PASS: TestBuildRowList (0.00s)
Step #2 - "test": === RUN   TestParseTableInfo
Step #2 - "test": --- PASS: TestParseTableInfo (0.00s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/internal/store/bigtable	0.151s
Step #2 - "test": === RUN   TestLoadRecogPlaceStore
Step #2 - "test": --- PASS: TestLoadRecogPlaceStore (5.20s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/internal/store/files	5.248s
Step #2 - "test": === RUN   TestBind
Step #2 - "test": --- PASS: TestBind (0.00s)
Step #2 - "test": === RUN   TestGetBindings
Step #2 - "test": --- PASS: TestGetBindings (0.00s)
Step #2 - "test": === RUN   TestGetGraph
Step #2 - "test": --- PASS: TestGetGraph (0.00s)
Step #2 - "test": === RUN   TestGetConstraint
Step #2 - "test": --- PASS: TestGetConstraint (0.00s)
Step #2 - "test": === RUN   TestGetSQL
Step #2 - "test": --- PASS: TestGetSQL (0.00s)
Step #2 - "test": === RUN   TestTranslate
Step #2 - "test": --- PASS: TestTranslate (0.04s)
Step #2 - "test": === RUN   TestDcidSimplified
Step #2 - "test": --- PASS: TestDcidSimplified (0.01s)
Step #2 - "test": === RUN   TestTranslateIOCountyBQ
Step #2 - "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 #2 - "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 #2 - "test": --- PASS: TestTranslateIOCountyBQ (0.00s)
Step #2 - "test": === RUN   TestTranslateWeather
Step #2 - "test": Multiple functional deps: `dc_v3.MonthlyWeather`->E1 => map[observationDate:`dc_v3.MonthlyWeather`->observation_date observationPeriod:P1M observedNode:`dc_v3.MonthlyWeather`->E2]
Step #2 - "test": Multiple functional deps: `dc_v3.MonthlyWeather`->E1 => map[observationDate:`dc_v3.MonthlyWeather`->observation_date observationPeriod:P1M observedNode:`dc_v3.MonthlyWeather`->E2]
Step #2 - "test": Multiple functional deps: `dc_v3.MonthlyWeather`->E1 => map[observationDate:`dc_v3.MonthlyWeather`->observation_date observationPeriod:P1M observedNode:`dc_v3.MonthlyWeather`->E2]
Step #2 - "test": Multiple functional deps: `dc_v3.MonthlyWeather`->E1 => map[observationDate:`dc_v3.MonthlyWeather`->observation_date observationPeriod:P1M observedNode:`dc_v3.MonthlyWeather`->E2]
Step #2 - "test": --- PASS: TestTranslateWeather (0.00s)
Step #2 - "test": === RUN   TestTranslateWeatherSparql
Step #2 - "test": Multiple functional deps: `dc_v3.MonthlyWeather`->E1 => map[observationDate:`dc_v3.MonthlyWeather`->observation_date observationPeriod:P1M observedNode:`dc_v3.MonthlyWeather`->E2]
Step #2 - "test": Multiple functional deps: `dc_v3.MonthlyWeather`->E1 => map[observationDate:`dc_v3.MonthlyWeather`->observation_date observationPeriod:P1M observedNode:`dc_v3.MonthlyWeather`->E2]
Step #2 - "test": --- PASS: TestTranslateWeatherSparql (0.00s)
Step #2 - "test": === RUN   TestTranslatePew
Step #2 - "test": --- PASS: TestTranslatePew (0.00s)
Step #2 - "test": === RUN   TestSparql
Step #2 - "test": --- PASS: TestSparql (0.00s)
Step #2 - "test": === RUN   TestStatVarObs
Step #2 - "test": --- PASS: TestStatVarObs (0.01s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/internal/translator	0.209s
Step #2 - "test": === RUN   TestSplit
Step #2 - "test": --- PASS: TestSplit (0.00s)
Step #2 - "test": === RUN   TestParseQuery
Step #2 - "test": --- PASS: TestParseQuery (0.00s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/internal/translator/datalog	0.080s
Step #2 - "test": === RUN   TestGetNodeType
Step #2 - "test": --- PASS: TestGetNodeType (0.00s)
Step #2 - "test": === RUN   TestGetEntityType
Step #2 - "test": --- PASS: TestGetEntityType (0.00s)
Step #2 - "test": === RUN   TestGetExplicitTypeProp
Step #2 - "test": --- PASS: TestGetExplicitTypeProp (0.00s)
Step #2 - "test": === RUN   TestGetQueryID
Step #2 - "test": --- PASS: TestGetQueryID (0.00s)
Step #2 - "test": === RUN   TestMatchTriple
Step #2 - "test": --- PASS: TestMatchTriple (0.00s)
Step #2 - "test": === RUN   TestGetFuncDeps
Step #2 - "test": --- PASS: TestGetFuncDeps (0.00s)
Step #2 - "test": === RUN   TestGetFuncDepsWithEntity
Step #2 - "test": --- PASS: TestGetFuncDepsWithEntity (0.00s)
Step #2 - "test": === RUN   TestGetProvColumn
Step #2 - "test": --- PASS: TestGetProvColumn (0.00s)
Step #2 - "test": === RUN   TestRewriteQuery
Step #2 - "test": --- PASS: TestRewriteQuery (0.00s)
Step #2 - "test": === RUN   TestGetOutArcInfo
Step #2 - "test": --- PASS: TestGetOutArcInfo (0.03s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/internal/translator/solver	0.085s
Step #2 - "test": === RUN   TestParsePrologue
Step #2 - "test": --- PASS: TestParsePrologue (0.00s)
Step #2 - "test": === RUN   TestParseSelect
Step #2 - "test": --- PASS: TestParseSelect (0.00s)
Step #2 - "test": === RUN   TestParseWhere
Step #2 - "test": --- PASS: TestParseWhere (0.00s)
Step #2 - "test": === RUN   TestParseOrderBy
Step #2 - "test": --- PASS: TestParseOrderBy (0.00s)
Step #2 - "test": === RUN   TestParseLimit
Step #2 - "test": --- PASS: TestParseLimit (0.00s)
Step #2 - "test": === RUN   TestParseTree
Step #2 - "test": --- PASS: TestParseTree (0.00s)
Step #2 - "test": === RUN   TestReader
Step #2 - "test": --- PASS: TestReader (0.00s)
Step #2 - "test": === RUN   TestScanSimple
Step #2 - "test": --- PASS: TestScanSimple (0.00s)
Step #2 - "test": === RUN   TestMulti
Step #2 - "test": --- PASS: TestMulti (0.00s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/internal/translator/sparql	0.046s
Step #2 - "test": ?   	github.com/datacommonsorg/mixer/internal/translator/testutil	[no test files]
Step #2 - "test": === RUN   TestQuery
Step #2 - "test": --- PASS: TestQuery (0.00s)
Step #2 - "test": === RUN   TestEntity
Step #2 - "test": --- PASS: TestEntity (0.00s)
Step #2 - "test": === RUN   TestColumn
Step #2 - "test": --- PASS: TestColumn (0.00s)
Step #2 - "test": === RUN   TestMapping
Step #2 - "test": --- PASS: TestMapping (0.00s)
Step #2 - "test": === RUN   TestTableAlias
Step #2 - "test": --- PASS: TestTableAlias (0.00s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/internal/translator/types	0.104s
Step #2 - "test": === RUN   TestZipAndEndocde
Step #2 - "test": --- PASS: TestZipAndEndocde (0.05s)
Step #2 - "test": === RUN   TestSnakeToCamel
Step #2 - "test": --- PASS: TestSnakeToCamel (0.00s)
Step #2 - "test": === RUN   TestCheckValidDCIDs
Step #2 - "test": --- PASS: TestCheckValidDCIDs (0.00s)
Step #2 - "test": === RUN   TestMergeDedupe
Step #2 - "test": --- PASS: TestMergeDedupe (0.00s)
Step #2 - "test": === RUN   TestSample
Step #2 - "test": --- PASS: TestSample (0.00s)
Step #2 - "test": === RUN   TestKeysToSlice
Step #2 - "test": --- PASS: TestKeysToSlice (0.00s)
Step #2 - "test": === RUN   TestEncode
Step #2 - "test": --- PASS: TestEncode (0.00s)
Step #2 - "test": === RUN   TestStringListIntersection
Step #2 - "test": --- PASS: TestStringListIntersection (0.00s)
Step #2 - "test": === RUN   TestGetFacetID
Step #2 - "test": --- PASS: TestGetFacetID (0.00s)
Step #2 - "test": === RUN   TestShouldIncludeFacet
Step #2 - "test": --- PASS: TestShouldIncludeFacet (0.01s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/internal/util	0.148s
Step #2 - "test": === RUN   TestChartConfigRankings
Step #2 - "test": === PAUSE TestChartConfigRankings
Step #2 - "test": === CONT  TestChartConfigRankings
Step #2 - "test": === RUN   TestChartConfigRankings/missing_Earth_country_rankings.json
Step #2 - "test": === PAUSE TestChartConfigRankings/missing_Earth_country_rankings.json
Step #2 - "test": === RUN   TestChartConfigRankings/missing_USA_state_rankings.json
Step #2 - "test": === PAUSE TestChartConfigRankings/missing_USA_state_rankings.json
Step #2 - "test": === RUN   TestChartConfigRankings/missing_USA_county_rankings.json
Step #2 - "test": === PAUSE TestChartConfigRankings/missing_USA_county_rankings.json
Step #2 - "test": === RUN   TestChartConfigRankings/missing_USA_city_rankings.json
Step #2 - "test": === PAUSE TestChartConfigRankings/missing_USA_city_rankings.json
Step #2 - "test": === CONT  TestChartConfigRankings/missing_Earth_country_rankings.json
Step #2 - "test": === CONT  TestChartConfigRankings/missing_USA_city_rankings.json
Step #2 - "test": === CONT  TestChartConfigRankings/missing_USA_county_rankings.json
Step #2 - "test": === CONT  TestChartConfigRankings/missing_USA_state_rankings.json
Step #2 - "test": --- PASS: TestChartConfigRankings (5.03s)
Step #2 - "test":     --- PASS: TestChartConfigRankings/missing_USA_state_rankings.json (1.54s)
Step #2 - "test":     --- PASS: TestChartConfigRankings/missing_USA_city_rankings.json (1.55s)
Step #2 - "test":     --- PASS: TestChartConfigRankings/missing_USA_county_rankings.json (1.55s)
Step #2 - "test":     --- PASS: TestChartConfigRankings/missing_Earth_country_rankings.json (1.57s)
Step #2 - "test": PASS
Step #2 - "test": ok  	github.com/datacommonsorg/mixer/test	6.673s
Step #2 - "test": ?   	github.com/datacommonsorg/mixer/test/http_memprof	[no test files]
Step #2 - "test": ?   	github.com/datacommonsorg/mixer/tools/send_email	[no test files]
Step #2 - "test": FAIL
Finished Step #2 - "test"
ERROR
ERROR: build step 2 "golang" failed: step exited with non-zero status: 1

Build Log: https://console.cloud.google.com/cloud-build/builds/96ac6f29-a759-4c74-86af-1fb9894f4007?project=879489846695