Race Condition in Frontend tests. #205
Milestone
Comments
|
https://pantheon.corp.google.com/cloud-build/builds/18397ccb-1fe9-4969-b41f-c0c672474087?project=open-match-build is also pointing to a data race in the Already have image: open-match-build
fatal: Not a git repository (or any parent up to mount point /workspace)
Stopping at filesystem boundary (GIT_DISCOVERY_ACROSS_FILESYSTEM not set).
GO111MODULE=on GOPROXY=off go test ./... -race -test.count 10 -cover
? github.com/GoogleCloudPlatform/open-match [no test files]
? github.com/GoogleCloudPlatform/open-match/cmd/backendapi [no test files]
? github.com/GoogleCloudPlatform/open-match/cmd/frontendapi [no test files]
? github.com/GoogleCloudPlatform/open-match/cmd/minimatch [no test files]
? github.com/GoogleCloudPlatform/open-match/cmd/mmforc [no test files]
? github.com/GoogleCloudPlatform/open-match/cmd/mmlogicapi [no test files]
ok github.com/GoogleCloudPlatform/open-match/config 1.505s coverage: 81.8% of statements
? github.com/GoogleCloudPlatform/open-match/examples/backendclient [no test files]
? github.com/GoogleCloudPlatform/open-match/examples/evaluators/golang/simple [no test files]
? github.com/GoogleCloudPlatform/open-match/examples/functions/golang/manual-simple [no test files]
? github.com/GoogleCloudPlatform/open-match/internal/app/backendapi [no test files]
? github.com/GoogleCloudPlatform/open-match/internal/app/backendapi/apisrv [no test files]
? github.com/GoogleCloudPlatform/open-match/internal/app/frontendapi [no test files]
? github.com/GoogleCloudPlatform/open-match/internal/app/frontendapi/apisrv [no test files]
? github.com/GoogleCloudPlatform/open-match/internal/app/minimatch [no test files]
? github.com/GoogleCloudPlatform/open-match/internal/app/mmforc [no test files]
? github.com/GoogleCloudPlatform/open-match/internal/app/mmlogicapi [no test files]
? github.com/GoogleCloudPlatform/open-match/internal/app/mmlogicapi/apisrv [no test files]
ok github.com/GoogleCloudPlatform/open-match/internal/expbo 1.127s coverage: 73.1% of statements
? github.com/GoogleCloudPlatform/open-match/internal/logging [no test files]
? github.com/GoogleCloudPlatform/open-match/internal/metrics [no test files]
? github.com/GoogleCloudPlatform/open-match/internal/pb [no test files]
? github.com/GoogleCloudPlatform/open-match/internal/serving [no test files]
ok github.com/GoogleCloudPlatform/open-match/internal/serving/testing 14.250s coverage: 70.2% of statements
ok github.com/GoogleCloudPlatform/open-match/internal/set 1.168s coverage: 100.0% of statements
ok github.com/GoogleCloudPlatform/open-match/internal/signal 4.225s coverage: 100.0% of statements
? github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis [no test files]
ok github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis/ignorelist 1.079s coverage: 21.6% of statements
? github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis/playerindices [no test files]
? github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis/redispb [no test files]
ok github.com/GoogleCloudPlatform/open-match/site 1.882s coverage: 67.2% of statements
? github.com/GoogleCloudPlatform/open-match/site/redirect [no test files]
? github.com/GoogleCloudPlatform/open-match/test/cmd/clientloadgen [no test files]
? github.com/GoogleCloudPlatform/open-match/test/cmd/clientloadgen/player [no test files]
? github.com/GoogleCloudPlatform/open-match/test/cmd/clientloadgen/redis/playerq [no test files]
? github.com/GoogleCloudPlatform/open-match/test/cmd/frontendclient [no test files]
? github.com/GoogleCloudPlatform/open-match/test/cmd/frontendclient/player [no test files]
ok github.com/GoogleCloudPlatform/open-match/test/e2e 1.357s coverage: 0.0% of statements
time="2019-04-12T23:26:43Z" level=warning msg="Debug logging level configured. Not recommended for production!" func=github.com/GoogleCloudPlatform/open-match/internal/logging.ConfigureLogging file="/workspace/internal/logging/helper.go:27"
time="2019-04-12T23:26:43Z" level=info msg="Loaded OpenCensus views" func=github.com/GoogleCloudPlatform/open-match/internal/serving/testing.createOpenMatchServer file="/workspace/internal/serving/testing/minimatch.go:118" app=openmatch component=frontend viewscount=13
time="2019-04-12T23:26:43Z" level=info msg="OpenCensus exporter to Promethus initialized" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:62" app=openmatch component=metrics
time="2019-04-12T23:26:43Z" level=info msg="Opencensus views registered" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:70" app=openmatch component=metrics
time="2019-04-12T23:26:43Z" level=info msg="Opencensus measurement serving to Prometheus configured" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:78" app=openmatch component=metrics endpoint=/metrics port=10002 retentionPeriod=0
time="2019-04-12T23:26:43Z" level=debug msg="Attempting to connect to Redis" func=github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis.ConnectionPool file="/workspace/internal/statestorage/redis/redishelpers.go:58" app=openmatch component=redishelpers redisURL="redis://127.0.0.1:35357"
time="2019-04-12T23:26:43Z" level=info msg="Attempting to start http server for OpenCensus metrics on localhost" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter.func1 file="/workspace/internal/metrics/helper.go:87" app=openmatch component=metrics endpoint=/metrics port=10002
time="2019-04-12T23:26:43Z" level=info msg="Connected to Redis" func=github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis.ConnectionPool file="/workspace/internal/statestorage/redis/redishelpers.go:80" app=openmatch component=redishelpers
time="2019-04-12T23:26:43Z" level=info msg="Attempting to start gRPC server" func=github.com/GoogleCloudPlatform/open-match/internal/serving/testing.createOpenMatchServer file="/workspace/internal/serving/testing/minimatch.go:165" app=openmatch component=frontend
time="2019-04-12T23:26:43Z" level=info msg="TCP net listener initialized" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start" file="/workspace/internal/serving/grpcserver.go:52" app=openmatch component=frontend port=10003
time="2019-04-12T23:26:43Z" level=info msg="Serving gRPC on :10003" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start.func1" file="/workspace/internal/serving/grpcserver.go:62" app=openmatch component=frontend
time="2019-04-12T23:26:43Z" level=warning msg="Debug logging level configured. Not recommended for production!" func=github.com/GoogleCloudPlatform/open-match/internal/logging.ConfigureLogging file="/workspace/internal/logging/helper.go:27"
time="2019-04-12T23:26:43Z" level=info msg="Loaded OpenCensus views" func=github.com/GoogleCloudPlatform/open-match/internal/serving/testing.createOpenMatchServer file="/workspace/internal/serving/testing/minimatch.go:118" app=openmatch component=frontend viewscount=13
time="2019-04-12T23:26:43Z" level=info msg="OpenCensus exporter to Promethus initialized" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:62" app=openmatch component=metrics
time="2019-04-12T23:26:43Z" level=info msg="Opencensus views registered" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:70" app=openmatch component=metrics
time="2019-04-12T23:26:43Z" level=info msg="Opencensus measurement serving to Prometheus configured" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:78" app=openmatch component=metrics endpoint=/metrics port=10004 retentionPeriod=0
time="2019-04-12T23:26:43Z" level=debug msg="Attempting to connect to Redis" func=github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis.ConnectionPool file="/workspace/internal/statestorage/redis/redishelpers.go:58" app=openmatch component=redishelpers redisURL="redis://127.0.0.1:38801"
time="2019-04-12T23:26:43Z" level=info msg="Attempting to start http server for OpenCensus metrics on localhost" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter.func1 file="/workspace/internal/metrics/helper.go:87" app=openmatch component=metrics endpoint=/metrics port=10004
time="2019-04-12T23:26:43Z" level=info msg="Connected to Redis" func=github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis.ConnectionPool file="/workspace/internal/statestorage/redis/redishelpers.go:80" app=openmatch component=redishelpers
time="2019-04-12T23:26:43Z" level=info msg="Attempting to start gRPC server" func=github.com/GoogleCloudPlatform/open-match/internal/serving/testing.createOpenMatchServer file="/workspace/internal/serving/testing/minimatch.go:165" app=openmatch component=frontend
time="2019-04-12T23:26:43Z" level=info msg="TCP net listener initialized" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start" file="/workspace/internal/serving/grpcserver.go:52" app=openmatch component=frontend port=10005
time="2019-04-12T23:26:43Z" level=info msg="Serving gRPC on :10005" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start.func1" file="/workspace/internal/serving/grpcserver.go:62" app=openmatch component=frontend
time="2019-04-12T23:26:43Z" level=warning msg="Debug logging level configured. Not recommended for production!" func=github.com/GoogleCloudPlatform/open-match/internal/logging.ConfigureLogging file="/workspace/internal/logging/helper.go:27"
time="2019-04-12T23:26:43Z" level=info msg="Loaded OpenCensus views" func=github.com/GoogleCloudPlatform/open-match/internal/serving/testing.createOpenMatchServer file="/workspace/internal/serving/testing/minimatch.go:118" app=openmatch component=frontend viewscount=13
time="2019-04-12T23:26:43Z" level=info msg="OpenCensus exporter to Promethus initialized" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:62" app=openmatch component=metrics
time="2019-04-12T23:26:43Z" level=info msg="Opencensus views registered" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:70" app=openmatch component=metrics
time="2019-04-12T23:26:43Z" level=info msg="Opencensus measurement serving to Prometheus configured" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:78" app=openmatch component=metrics endpoint=/metrics port=10006 retentionPeriod=0
time="2019-04-12T23:26:43Z" level=debug msg="Attempting to connect to Redis" func=github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis.ConnectionPool file="/workspace/internal/statestorage/redis/redishelpers.go:58" app=openmatch component=redishelpers redisURL="redis://127.0.0.1:46241"
time="2019-04-12T23:26:43Z" level=info msg="Attempting to start http server for OpenCensus metrics on localhost" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter.func1 file="/workspace/internal/metrics/helper.go:87" app=openmatch component=metrics endpoint=/metrics port=10006
time="2019-04-12T23:26:43Z" level=info msg="Connected to Redis" func=github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis.ConnectionPool file="/workspace/internal/statestorage/redis/redishelpers.go:80" app=openmatch component=redishelpers
time="2019-04-12T23:26:43Z" level=info msg="Attempting to start gRPC server" func=github.com/GoogleCloudPlatform/open-match/internal/serving/testing.createOpenMatchServer file="/workspace/internal/serving/testing/minimatch.go:165" app=openmatch component=frontend
time="2019-04-12T23:26:43Z" level=info msg="TCP net listener initialized" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start" file="/workspace/internal/serving/grpcserver.go:52" app=openmatch component=frontend port=10007
time="2019-04-12T23:26:43Z" level=info msg="Serving gRPC on :10007" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start.func1" file="/workspace/internal/serving/grpcserver.go:62" app=openmatch component=frontend
time="2019-04-12T23:26:43Z" level=warning msg="Debug logging level configured. Not recommended for production!" func=github.com/GoogleCloudPlatform/open-match/internal/logging.ConfigureLogging file="/workspace/internal/logging/helper.go:27"
time="2019-04-12T23:26:43Z" level=info msg="Loaded OpenCensus views" func=github.com/GoogleCloudPlatform/open-match/internal/serving/testing.createOpenMatchServer file="/workspace/internal/serving/testing/minimatch.go:118" app=openmatch component=frontend viewscount=13
time="2019-04-12T23:26:43Z" level=info msg="OpenCensus exporter to Promethus initialized" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:62" app=openmatch component=metrics
time="2019-04-12T23:26:43Z" level=info msg="Opencensus views registered" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:70" app=openmatch component=metrics
time="2019-04-12T23:26:43Z" level=info msg="Opencensus measurement serving to Prometheus configured" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:78" app=openmatch component=metrics endpoint=/metrics port=10008 retentionPeriod=0
time="2019-04-12T23:26:43Z" level=debug msg="Attempting to connect to Redis" func=github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis.ConnectionPool file="/workspace/internal/statestorage/redis/redishelpers.go:58" app=openmatch component=redishelpers redisURL="redis://127.0.0.1:39573"
time="2019-04-12T23:26:43Z" level=info msg="Connected to Redis" func=github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis.ConnectionPool file="/workspace/internal/statestorage/redis/redishelpers.go:80" app=openmatch component=redishelpers
time="2019-04-12T23:26:43Z" level=info msg="Attempting to start gRPC server" func=github.com/GoogleCloudPlatform/open-match/internal/serving/testing.createOpenMatchServer file="/workspace/internal/serving/testing/minimatch.go:165" app=openmatch component=frontend
time="2019-04-12T23:26:43Z" level=info msg="TCP net listener initialized" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start" file="/workspace/internal/serving/grpcserver.go:52" app=openmatch component=frontend port=10009
time="2019-04-12T23:26:43Z" level=info msg="Serving gRPC on :10009" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start.func1" file="/workspace/internal/serving/grpcserver.go:62" app=openmatch component=frontend
time="2019-04-12T23:26:43Z" level=error msg="gRPC serve() error" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start.func1" file="/workspace/internal/serving/grpcserver.go:66" app=openmatch component=frontend error="grpc: the server has been stopped"
time="2019-04-12T23:26:43Z" level=warning msg="Debug logging level configured. Not recommended for production!" func=github.com/GoogleCloudPlatform/open-match/internal/logging.ConfigureLogging file="/workspace/internal/logging/helper.go:27"
time="2019-04-12T23:26:43Z" level=info msg="Loaded OpenCensus views" func=github.com/GoogleCloudPlatform/open-match/internal/serving/testing.createOpenMatchServer file="/workspace/internal/serving/testing/minimatch.go:118" app=openmatch component=frontend viewscount=13
time="2019-04-12T23:26:43Z" level=info msg="OpenCensus exporter to Promethus initialized" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:62" app=openmatch component=metrics
time="2019-04-12T23:26:43Z" level=info msg="Opencensus views registered" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:70" app=openmatch component=metrics
time="2019-04-12T23:26:43Z" level=info msg="Opencensus measurement serving to Prometheus configured" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:78" app=openmatch component=metrics endpoint=/metrics port=10010 retentionPeriod=0
time="2019-04-12T23:26:43Z" level=info msg="Attempting to start http server for OpenCensus metrics on localhost" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter.func1 file="/workspace/internal/metrics/helper.go:87" app=openmatch component=metrics endpoint=/metrics port=10010
==================
WARNING: DATA RACE
Read at 0x00c000086208 by goroutine 70:
github.com/sirupsen/logrus.Entry.log()
/go/pkg/mod/github.com/sirupsen/logrus@v1.4.1/entry.go:220 +0x1c2
github.com/sirupsen/logrus.(*Entry).Log()
/go/pkg/mod/github.com/sirupsen/logrus@v1.4.1/entry.go:268 +0x160
github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter.func1()
/go/pkg/mod/github.com/sirupsen/logrus@v1.4.1/entry.go:285 +0x2b4
Previous write at 0x00c000086208 by goroutine 78:
github.com/sirupsen/logrus.(*Logger).SetReportCaller()
/go/pkg/mod/github.com/sirupsen/logrus@v1.4.1/logger.go:341 +0x85
github.com/GoogleCloudPlatform/open-match/internal/logging.ConfigureLogging()
/go/pkg/mod/github.com/sirupsen/logrus@v1.4.1/exported.go:31 +0x139
github.com/GoogleCloudPlatform/open-match/internal/serving/testing.createOpenMatchServer()
/workspace/internal/serving/testing/minimatch.go:103 +0x73c
github.com/GoogleCloudPlatform/open-match/internal/serving/testing.NewMiniMatch()
/workspace/internal/serving/testing/minimatch.go:65 +0x6d
github.com/GoogleCloudPlatform/open-match/test/e2e/frontend.TestFrontendStartup()
/workspace/test/e2e/frontend/frontendapi_test.go:13 +0x76
testing.tRunner()
/usr/local/go/src/testing/testing.go:865 +0x163
Goroutine 70 (running) created at:
github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter()
/workspace/internal/metrics/helper.go:81 +0x876
github.com/GoogleCloudPlatform/open-match/internal/serving/testing.createOpenMatchServer()
/workspace/internal/serving/testing/minimatch.go:119 +0xb36
github.com/GoogleCloudPlatform/open-match/internal/serving/testing.NewMiniMatch()
/workspace/internal/serving/testing/minimatch.go:65 +0x6d
github.com/GoogleCloudPlatform/open-match/test/e2e/frontend.TestFrontendStartup()
/workspace/test/e2e/frontend/frontendapi_test.go:13 +0x76
testing.tRunner()
/usr/local/go/src/testing/testing.go:865 +0x163
Goroutine 78 (running) created at:
testing.(*T).Run()
/usr/local/go/src/testing/testing.go:916 +0x65a
testing.runTests.func1()
/usr/local/go/src/testing/testing.go:1157 +0xa8
testing.tRunner()
/usr/local/go/src/testing/testing.go:865 +0x163
testing.runTests()
/usr/local/go/src/testing/testing.go:1155 +0x523
testing.(*M).Run()
/usr/local/go/src/testing/testing.go:1072 +0x2eb
main.main()
_testmain.go:84 +0x334
==================
time="2019-04-12T23:26:43Z" level=debug msg="Attempting to connect to Redis" func=github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis.ConnectionPool file="/workspace/internal/statestorage/redis/redishelpers.go:58" app=openmatch component=redishelpers redisURL="redis://127.0.0.1:42377"
time="2019-04-12T23:26:43Z" level=info msg="Attempting to start http server for OpenCensus metrics on localhost" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter.func1 file="/workspace/internal/metrics/helper.go:87" app=openmatch component=metrics endpoint=/metrics port=10008
time="2019-04-12T23:26:43Z" level=info msg="Connected to Redis" func=github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis.ConnectionPool file="/workspace/internal/statestorage/redis/redishelpers.go:80" app=openmatch component=redishelpers
time="2019-04-12T23:26:43Z" level=info msg="Attempting to start gRPC server" func=github.com/GoogleCloudPlatform/open-match/internal/serving/testing.createOpenMatchServer file="/workspace/internal/serving/testing/minimatch.go:165" app=openmatch component=frontend
time="2019-04-12T23:26:43Z" level=info msg="TCP net listener initialized" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start" file="/workspace/internal/serving/grpcserver.go:52" app=openmatch component=frontend port=10012
time="2019-04-12T23:26:43Z" level=info msg="Serving gRPC on :10012" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start.func1" file="/workspace/internal/serving/grpcserver.go:62" app=openmatch component=frontend
time="2019-04-12T23:26:43Z" level=error msg="gRPC serve() error" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start.func1" file="/workspace/internal/serving/grpcserver.go:66" app=openmatch component=frontend error="grpc: the server has been stopped"
--- FAIL: TestFrontendStartup (0.02s)
testing.go:809: race detected during execution of test
time="2019-04-12T23:26:43Z" level=warning msg="Debug logging level configured. Not recommended for production!" func=github.com/GoogleCloudPlatform/open-match/internal/logging.ConfigureLogging file="/workspace/internal/logging/helper.go:27"
time="2019-04-12T23:26:43Z" level=info msg="Loaded OpenCensus views" func=github.com/GoogleCloudPlatform/open-match/internal/serving/testing.createOpenMatchServer file="/workspace/internal/serving/testing/minimatch.go:118" app=openmatch component=frontend viewscount=13
time="2019-04-12T23:26:43Z" level=info msg="OpenCensus exporter to Promethus initialized" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:62" app=openmatch component=metrics
time="2019-04-12T23:26:43Z" level=info msg="Opencensus views registered" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:70" app=openmatch component=metrics
time="2019-04-12T23:26:43Z" level=info msg="Opencensus measurement serving to Prometheus configured" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:78" app=openmatch component=metrics endpoint=/metrics port=10014 retentionPeriod=0
time="2019-04-12T23:26:43Z" level=debug msg="Attempting to connect to Redis" func=github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis.ConnectionPool file="/workspace/internal/statestorage/redis/redishelpers.go:58" app=openmatch component=redishelpers redisURL="redis://127.0.0.1:44155"
time="2019-04-12T23:26:43Z" level=info msg="Attempting to start http server for OpenCensus metrics on localhost" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter.func1 file="/workspace/internal/metrics/helper.go:87" app=openmatch component=metrics endpoint=/metrics port=10014
time="2019-04-12T23:26:43Z" level=info msg="Connected to Redis" func=github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis.ConnectionPool file="/workspace/internal/statestorage/redis/redishelpers.go:80" app=openmatch component=redishelpers
time="2019-04-12T23:26:43Z" level=info msg="Attempting to start gRPC server" func=github.com/GoogleCloudPlatform/open-match/internal/serving/testing.createOpenMatchServer file="/workspace/internal/serving/testing/minimatch.go:165" app=openmatch component=frontend
time="2019-04-12T23:26:43Z" level=info msg="TCP net listener initialized" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start" file="/workspace/internal/serving/grpcserver.go:52" app=openmatch component=frontend port=10016
time="2019-04-12T23:26:43Z" level=info msg="Serving gRPC on :10016" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start.func1" file="/workspace/internal/serving/grpcserver.go:62" app=openmatch component=frontend
time="2019-04-12T23:26:43Z" level=error msg="gRPC serve() error" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start.func1" file="/workspace/internal/serving/grpcserver.go:66" app=openmatch component=frontend error="grpc: the server has been stopped"
time="2019-04-12T23:26:43Z" level=warning msg="Debug logging level configured. Not recommended for production!" func=github.com/GoogleCloudPlatform/open-match/internal/logging.ConfigureLogging file="/workspace/internal/logging/helper.go:27"
time="2019-04-12T23:26:43Z" level=info msg="Loaded OpenCensus views" func=github.com/GoogleCloudPlatform/open-match/internal/serving/testing.createOpenMatchServer file="/workspace/internal/serving/testing/minimatch.go:118" app=openmatch component=frontend viewscount=13
time="2019-04-12T23:26:43Z" level=info msg="OpenCensus exporter to Promethus initialized" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:62" app=openmatch component=metrics
time="2019-04-12T23:26:43Z" level=info msg="Opencensus views registered" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:70" app=openmatch component=metrics
time="2019-04-12T23:26:43Z" level=info msg="Opencensus measurement serving to Prometheus configured" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:78" app=openmatch component=metrics endpoint=/metrics port=10018 retentionPeriod=0
time="2019-04-12T23:26:43Z" level=debug msg="Attempting to connect to Redis" func=github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis.ConnectionPool file="/workspace/internal/statestorage/redis/redishelpers.go:58" app=openmatch component=redishelpers redisURL="redis://127.0.0.1:39793"
time="2019-04-12T23:26:43Z" level=info msg="Attempting to start http server for OpenCensus metrics on localhost" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter.func1 file="/workspace/internal/metrics/helper.go:87" app=openmatch component=metrics endpoint=/metrics port=10018
time="2019-04-12T23:26:43Z" level=info msg="Connected to Redis" func=github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis.ConnectionPool file="/workspace/internal/statestorage/redis/redishelpers.go:80" app=openmatch component=redishelpers
time="2019-04-12T23:26:43Z" level=info msg="Attempting to start gRPC server" func=github.com/GoogleCloudPlatform/open-match/internal/serving/testing.createOpenMatchServer file="/workspace/internal/serving/testing/minimatch.go:165" app=openmatch component=frontend
time="2019-04-12T23:26:43Z" level=info msg="TCP net listener initialized" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start" file="/workspace/internal/serving/grpcserver.go:52" app=openmatch component=frontend port=10020
time="2019-04-12T23:26:43Z" level=info msg="Serving gRPC on :10020" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start.func1" file="/workspace/internal/serving/grpcserver.go:62" app=openmatch component=frontend
time="2019-04-12T23:26:43Z" level=warning msg="Debug logging level configured. Not recommended for production!" func=github.com/GoogleCloudPlatform/open-match/internal/logging.ConfigureLogging file="/workspace/internal/logging/helper.go:27"
time="2019-04-12T23:26:43Z" level=info msg="Loaded OpenCensus views" func=github.com/GoogleCloudPlatform/open-match/internal/serving/testing.createOpenMatchServer file="/workspace/internal/serving/testing/minimatch.go:118" app=openmatch component=frontend viewscount=13
time="2019-04-12T23:26:43Z" level=info msg="OpenCensus exporter to Promethus initialized" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:62" app=openmatch component=metrics
time="2019-04-12T23:26:43Z" level=info msg="Opencensus views registered" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:70" app=openmatch component=metrics
time="2019-04-12T23:26:43Z" level=info msg="Opencensus measurement serving to Prometheus configured" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:78" app=openmatch component=metrics endpoint=/metrics port=10022 retentionPeriod=0
time="2019-04-12T23:26:43Z" level=info msg="Attempting to start http server for OpenCensus metrics on localhost" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter.func1 file="/workspace/internal/metrics/helper.go:87" app=openmatch component=metrics endpoint=/metrics port=10022
time="2019-04-12T23:26:43Z" level=debug msg="Attempting to connect to Redis" func=github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis.ConnectionPool file="/workspace/internal/statestorage/redis/redishelpers.go:58" app=openmatch component=redishelpers redisURL="redis://127.0.0.1:36247"
time="2019-04-12T23:26:43Z" level=info msg="Connected to Redis" func=github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis.ConnectionPool file="/workspace/internal/statestorage/redis/redishelpers.go:80" app=openmatch component=redishelpers
time="2019-04-12T23:26:43Z" level=info msg="Attempting to start gRPC server" func=github.com/GoogleCloudPlatform/open-match/internal/serving/testing.createOpenMatchServer file="/workspace/internal/serving/testing/minimatch.go:165" app=openmatch component=frontend
time="2019-04-12T23:26:43Z" level=info msg="TCP net listener initialized" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start" file="/workspace/internal/serving/grpcserver.go:52" app=openmatch component=frontend port=10023
time="2019-04-12T23:26:43Z" level=info msg="Serving gRPC on :10023" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start.func1" file="/workspace/internal/serving/grpcserver.go:62" app=openmatch component=frontend
time="2019-04-12T23:26:43Z" level=warning msg="Debug logging level configured. Not recommended for production!" func=github.com/GoogleCloudPlatform/open-match/internal/logging.ConfigureLogging file="/workspace/internal/logging/helper.go:27"
time="2019-04-12T23:26:43Z" level=info msg="Loaded OpenCensus views" func=github.com/GoogleCloudPlatform/open-match/internal/serving/testing.createOpenMatchServer file="/workspace/internal/serving/testing/minimatch.go:118" app=openmatch component=frontend viewscount=13
time="2019-04-12T23:26:43Z" level=info msg="OpenCensus exporter to Promethus initialized" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:62" app=openmatch component=metrics
time="2019-04-12T23:26:43Z" level=info msg="Opencensus views registered" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:70" app=openmatch component=metrics
time="2019-04-12T23:26:43Z" level=info msg="Opencensus measurement serving to Prometheus configured" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:78" app=openmatch component=metrics endpoint=/metrics port=10024 retentionPeriod=0
time="2019-04-12T23:26:43Z" level=info msg="Attempting to start http server for OpenCensus metrics on localhost" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter.func1 file="/workspace/internal/metrics/helper.go:87" app=openmatch component=metrics endpoint=/metrics port=10024
time="2019-04-12T23:26:43Z" level=debug msg="Attempting to connect to Redis" func=github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis.ConnectionPool file="/workspace/internal/statestorage/redis/redishelpers.go:58" app=openmatch component=redishelpers redisURL="redis://127.0.0.1:42179"
time="2019-04-12T23:26:43Z" level=info msg="Connected to Redis" func=github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis.ConnectionPool file="/workspace/internal/statestorage/redis/redishelpers.go:80" app=openmatch component=redishelpers
time="2019-04-12T23:26:43Z" level=info msg="Attempting to start gRPC server" func=github.com/GoogleCloudPlatform/open-match/internal/serving/testing.createOpenMatchServer file="/workspace/internal/serving/testing/minimatch.go:165" app=openmatch component=frontend
time="2019-04-12T23:26:43Z" level=info msg="TCP net listener initialized" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start" file="/workspace/internal/serving/grpcserver.go:52" app=openmatch component=frontend port=10025
time="2019-04-12T23:26:43Z" level=info msg="Serving gRPC on :10025" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start.func1" file="/workspace/internal/serving/grpcserver.go:62" app=openmatch component=frontend
time="2019-04-12T23:26:43Z" level=warning msg="Debug logging level configured. Not recommended for production!" func=github.com/GoogleCloudPlatform/open-match/internal/logging.ConfigureLogging file="/workspace/internal/logging/helper.go:27"
time="2019-04-12T23:26:43Z" level=info msg="Loaded OpenCensus views" func=github.com/GoogleCloudPlatform/open-match/internal/serving/testing.createOpenMatchServer file="/workspace/internal/serving/testing/minimatch.go:118" app=openmatch component=frontend viewscount=13
time="2019-04-12T23:26:43Z" level=info msg="OpenCensus exporter to Promethus initialized" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:62" app=openmatch component=metrics
time="2019-04-12T23:26:43Z" level=info msg="Opencensus views registered" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:70" app=openmatch component=metrics
time="2019-04-12T23:26:43Z" level=info msg="Opencensus measurement serving to Prometheus configured" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:78" app=openmatch component=metrics endpoint=/metrics port=10026 retentionPeriod=0
time="2019-04-12T23:26:43Z" level=info msg="Attempting to start http server for OpenCensus metrics on localhost" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter.func1 file="/workspace/internal/metrics/helper.go:87" app=openmatch component=metrics endpoint=/metrics port=10026
time="2019-04-12T23:26:43Z" level=debug msg="Attempting to connect to Redis" func=github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis.ConnectionPool file="/workspace/internal/statestorage/redis/redishelpers.go:58" app=openmatch component=redishelpers redisURL="redis://127.0.0.1:45431"
time="2019-04-12T23:26:43Z" level=info msg="Connected to Redis" func=github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis.ConnectionPool file="/workspace/internal/statestorage/redis/redishelpers.go:80" app=openmatch component=redishelpers
time="2019-04-12T23:26:43Z" level=info msg="Attempting to start gRPC server" func=github.com/GoogleCloudPlatform/open-match/internal/serving/testing.createOpenMatchServer file="/workspace/internal/serving/testing/minimatch.go:165" app=openmatch component=frontend
time="2019-04-12T23:26:43Z" level=info msg="TCP net listener initialized" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start" file="/workspace/internal/serving/grpcserver.go:52" app=openmatch component=frontend port=10027
time="2019-04-12T23:26:43Z" level=info msg="Serving gRPC on :10027" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start.func1" file="/workspace/internal/serving/grpcserver.go:62" app=openmatch component=frontend
FAIL
coverage: 0.0% of statements
FAIL github.com/GoogleCloudPlatform/open-match/test/e2e/frontend 0.383s
ok github.com/GoogleCloudPlatform/open-match/test/e2e/minimatch 1.885s coverage: 0.0% of statements
Makefile:577: recipe for target 'test-10' failed
make: *** [test-10] Error 1 |
|
nextport races because there are multiple processes created during go test this is very problematic since the port numbers are provisioned sequentially. I could randomize them but that just masks the issue. |
|
Hit another race condition. Step #12 - "Build: Website": Makefile:628: recipe for target 'build/site/' failed
Step #12 - "Build: Website": make: [build/site/] Error 1 (ignored)
Step #12 - "Build: Website": #cd /workspace/build/site && "SERVICE=default envsubst < app.yaml > .app.yaml"
Step #12 - "Build: Website": cp /workspace/build/site/app.yaml /workspace/build/site/.app.yaml
Finished Step #12 - "Build: Website"
2019/04/17 09:11:04 Step Step #12 - "Build: Website" finished
Starting Step #13 - "Test: Website"
Step #13 - "Test: Website": Already have image: open-match-build
Step #13 - "Test: Website": rm -rf /tmp/open-match-site
Step #13 - "Test: Website": mkdir -p /tmp/open-match-site/site/
Step #13 - "Test: Website": cp -rf /workspace/build/site/public/* /tmp/open-match-site/site/
Step #13 - "Test: Website": /workspace/build/toolchain/bin/htmltest --conf /workspace/site/htmltest.yaml /tmp/open-match-site
Step #13 - "Test: Website": htmltest started at 04:11:07 on /tmp/open-match-site
Step #13 - "Test: Website": ========================================================================
Step #7 - "Build: Binaries": cd cmd/backendapi; CGO_ENABLED=0 GO111MODULE=on go build -a -installsuffix cgo .
Step #8 - "Build: Test": ? github.com/GoogleCloudPlatform/open-match/cmd/backendapi [no test files]
Step #8 - "Build: Test": ? github.com/GoogleCloudPlatform/open-match/cmd/frontendapi [no test files]
Step #8 - "Build: Test": ? github.com/GoogleCloudPlatform/open-match/cmd/minimatch [no test files]
Finished Step #6 - "Lint: Vet"
2019/04/17 09:11:18 Step Step #6 - "Lint: Vet" finished
Step #9 - "Build: Docker Images": Sending build context to Docker daemon 76.32MB
Step #9 - "Build: Docker Images": Step 1/5 : FROM golang:latest
Step #9 - "Build: Docker Images": ---> 1d14d4efd0a2
Step #9 - "Build: Docker Images": Step 2/5 : ENV GO111MODULE=on
Step #9 - "Build: Docker Images": ---> Using cache
Step #9 - "Build: Docker Images": ---> 52766f84dba8
Step #9 - "Build: Docker Images": Step 3/5 : WORKDIR /go/src/github.com/GoogleCloudPlatform/open-match
Step #9 - "Build: Docker Images": ---> Using cache
Step #9 - "Build: Docker Images": ---> aa2cf83edb37
Step #9 - "Build: Docker Images": Step 4/5 : COPY . .
Step #9 - "Build: Docker Images": Sending build context to Docker daemon 76.32MB
Step #9 - "Build: Docker Images": Step 1/6 : FROM python:3.5.3
Step #9 - "Build: Docker Images": ---> 56b15234ac1d
Step #9 - "Build: Docker Images": Step 2/6 : WORKDIR /usr/src/open-match
Step #9 - "Build: Docker Images": ---> Using cache
Step #9 - "Build: Docker Images": ---> 9a0362c00131
Step #9 - "Build: Docker Images": Step 3/6 : COPY examples/functions/python3/mmlogic-simple examples/functions/python3/mmlogic-simple
Step #9 - "Build: Docker Images": ---> 66d391b15ed6
Step #9 - "Build: Docker Images": Step 4/6 : WORKDIR /usr/src/open-match/examples/functions/python3/mmlogic-simple
Step #9 - "Build: Docker Images": ---> Running in 6e1c2f67ef96
Step #9 - "Build: Docker Images": Removing intermediate container 6e1c2f67ef96
Step #9 - "Build: Docker Images": ---> b45d46ed7ece
Step #9 - "Build: Docker Images": Step 5/6 : RUN pip install --no-cache-dir -r requirements.txt
Step #9 - "Build: Docker Images": ---> Running in dcd5347272de
Step #8 - "Build: Test": ? github.com/GoogleCloudPlatform/open-match/cmd/mmforc [no test files]
Step #8 - "Build: Test": ? github.com/GoogleCloudPlatform/open-match/cmd/mmlogicapi [no test files]
Step #8 - "Build: Test": ok github.com/GoogleCloudPlatform/open-match/config 1.517s coverage: 81.8% of statements
Step #8 - "Build: Test": ? github.com/GoogleCloudPlatform/open-match/examples/backendclient [no test files]
Step #8 - "Build: Test": ? github.com/GoogleCloudPlatform/open-match/examples/evaluators/golang/simple [no test files]
Step #8 - "Build: Test": ? github.com/GoogleCloudPlatform/open-match/examples/functions/golang/manual-simple [no test files]
Step #8 - "Build: Test": ? github.com/GoogleCloudPlatform/open-match/internal/app/backendapi [no test files]
Step #8 - "Build: Test": ? github.com/GoogleCloudPlatform/open-match/internal/app/backendapi/apisrv [no test files]
Step #8 - "Build: Test": ? github.com/GoogleCloudPlatform/open-match/internal/app/frontendapi [no test files]
Step #8 - "Build: Test": ? github.com/GoogleCloudPlatform/open-match/internal/app/frontendapi/apisrv [no test files]
Step #8 - "Build: Test": ? github.com/GoogleCloudPlatform/open-match/internal/app/minimatch [no test files]
Step #8 - "Build: Test": ? github.com/GoogleCloudPlatform/open-match/internal/app/mmforc [no test files]
Step #8 - "Build: Test": ? github.com/GoogleCloudPlatform/open-match/internal/app/mmlogicapi [no test files]
Step #8 - "Build: Test": ? github.com/GoogleCloudPlatform/open-match/internal/app/mmlogicapi/apisrv [no test files]
Step #8 - "Build: Test": ok github.com/GoogleCloudPlatform/open-match/internal/expbo 1.213s coverage: 73.1% of statements
Step #8 - "Build: Test": ? github.com/GoogleCloudPlatform/open-match/internal/logging [no test files]
Step #8 - "Build: Test": ? github.com/GoogleCloudPlatform/open-match/internal/metrics [no test files]
Step #8 - "Build: Test": ? github.com/GoogleCloudPlatform/open-match/internal/pb [no test files]
Step #8 - "Build: Test": ? github.com/GoogleCloudPlatform/open-match/internal/serving [no test files]
Step #8 - "Build: Test": ok github.com/GoogleCloudPlatform/open-match/internal/serving/testing 7.262s coverage: 69.1% of statements
Step #8 - "Build: Test": ok github.com/GoogleCloudPlatform/open-match/internal/set 1.133s coverage: 100.0% of statements
Step #8 - "Build: Test": ok github.com/GoogleCloudPlatform/open-match/internal/signal 4.215s coverage: 100.0% of statements
Step #8 - "Build: Test": ? github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis [no test files]
Step #8 - "Build: Test": ok github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis/ignorelist 1.263s coverage: 21.6% of statements
Step #8 - "Build: Test": ? github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis/playerindices [no test files]
Step #8 - "Build: Test": ? github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis/redispb [no test files]
Step #8 - "Build: Test": ok github.com/GoogleCloudPlatform/open-match/site 1.900s coverage: 67.2% of statements
Step #8 - "Build: Test": ? github.com/GoogleCloudPlatform/open-match/site/redirect [no test files]
Step #8 - "Build: Test": ? github.com/GoogleCloudPlatform/open-match/test/cmd/clientloadgen [no test files]
Step #8 - "Build: Test": ? github.com/GoogleCloudPlatform/open-match/test/cmd/clientloadgen/player [no test files]
Step #8 - "Build: Test": ? github.com/GoogleCloudPlatform/open-match/test/cmd/clientloadgen/redis/playerq [no test files]
Step #8 - "Build: Test": ? github.com/GoogleCloudPlatform/open-match/test/cmd/frontendclient [no test files]
Step #8 - "Build: Test": ? github.com/GoogleCloudPlatform/open-match/test/cmd/frontendclient/player [no test files]
Step #8 - "Build: Test": ok github.com/GoogleCloudPlatform/open-match/test/e2e 1.352s coverage: 0.0% of statements
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=warning msg="Debug logging level configured. Not recommended for production!" func=github.com/GoogleCloudPlatform/open-match/internal/logging.ConfigureLogging file="/workspace/internal/logging/helper.go:27"
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Loaded OpenCensus views" func=github.com/GoogleCloudPlatform/open-match/internal/serving/testing.createOpenMatchServer file="/workspace/internal/serving/testing/minimatch.go:118" app=openmatch component=frontend viewscount=13
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="OpenCensus exporter to Promethus initialized" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:62" app=openmatch component=metrics
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Opencensus views registered" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:70" app=openmatch component=metrics
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Opencensus measurement serving to Prometheus configured" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:78" app=openmatch component=metrics endpoint=/metrics port=10003 retentionPeriod=0
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Attempting to start http server for OpenCensus metrics on localhost" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter.func1 file="/workspace/internal/metrics/helper.go:87" app=openmatch component=metrics endpoint=/metrics port=10003
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=debug msg="Attempting to connect to Redis" func=github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis.ConnectionPool file="/workspace/internal/statestorage/redis/redishelpers.go:58" app=openmatch component=redishelpers redisURL="redis://127.0.0.1:37311"
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Connected to Redis" func=github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis.ConnectionPool file="/workspace/internal/statestorage/redis/redishelpers.go:80" app=openmatch component=redishelpers
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Attempting to start gRPC server" func=github.com/GoogleCloudPlatform/open-match/internal/serving/testing.createOpenMatchServer file="/workspace/internal/serving/testing/minimatch.go:165" app=openmatch component=frontend
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="TCP net listener initialized" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start" file="/workspace/internal/serving/grpcserver.go:52" app=openmatch component=frontend port=10005
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Serving gRPC on :10005" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start.func1" file="/workspace/internal/serving/grpcserver.go:62" app=openmatch component=frontend
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=error msg="gRPC serve() error" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start.func1" file="/workspace/internal/serving/grpcserver.go:66" app=openmatch component=frontend error="grpc: the server has been stopped"
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=warning msg="Debug logging level configured. Not recommended for production!" func=github.com/GoogleCloudPlatform/open-match/internal/logging.ConfigureLogging file="/workspace/internal/logging/helper.go:27"
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Loaded OpenCensus views" func=github.com/GoogleCloudPlatform/open-match/internal/serving/testing.createOpenMatchServer file="/workspace/internal/serving/testing/minimatch.go:118" app=openmatch component=frontend viewscount=13
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="OpenCensus exporter to Promethus initialized" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:62" app=openmatch component=metrics
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Opencensus views registered" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:70" app=openmatch component=metrics
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Opencensus measurement serving to Prometheus configured" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:78" app=openmatch component=metrics endpoint=/metrics port=10013 retentionPeriod=0
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Attempting to start http server for OpenCensus metrics on localhost" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter.func1 file="/workspace/internal/metrics/helper.go:87" app=openmatch component=metrics endpoint=/metrics port=10013
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=debug msg="Attempting to connect to Redis" func=github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis.ConnectionPool file="/workspace/internal/statestorage/redis/redishelpers.go:58" app=openmatch component=redishelpers redisURL="redis://127.0.0.1:45133"
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Connected to Redis" func=github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis.ConnectionPool file="/workspace/internal/statestorage/redis/redishelpers.go:80" app=openmatch component=redishelpers
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Attempting to start gRPC server" func=github.com/GoogleCloudPlatform/open-match/internal/serving/testing.createOpenMatchServer file="/workspace/internal/serving/testing/minimatch.go:165" app=openmatch component=frontend
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="TCP net listener initialized" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start" file="/workspace/internal/serving/grpcserver.go:52" app=openmatch component=frontend port=10015
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Serving gRPC on :10015" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start.func1" file="/workspace/internal/serving/grpcserver.go:62" app=openmatch component=frontend
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=error msg="gRPC serve() error" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start.func1" file="/workspace/internal/serving/grpcserver.go:66" app=openmatch component=frontend error="grpc: the server has been stopped"
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=warning msg="Debug logging level configured. Not recommended for production!" func=github.com/GoogleCloudPlatform/open-match/internal/logging.ConfigureLogging file="/workspace/internal/logging/helper.go:27"
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Loaded OpenCensus views" func=github.com/GoogleCloudPlatform/open-match/internal/serving/testing.createOpenMatchServer file="/workspace/internal/serving/testing/minimatch.go:118" app=openmatch component=frontend viewscount=13
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="OpenCensus exporter to Promethus initialized" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:62" app=openmatch component=metrics
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Opencensus views registered" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:70" app=openmatch component=metrics
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Opencensus measurement serving to Prometheus configured" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:78" app=openmatch component=metrics endpoint=/metrics port=10017 retentionPeriod=0
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=debug msg="Attempting to connect to Redis" func=github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis.ConnectionPool file="/workspace/internal/statestorage/redis/redishelpers.go:58" app=openmatch component=redishelpers redisURL="redis://127.0.0.1:43103"
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Attempting to start http server for OpenCensus metrics on localhost" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter.func1 file="/workspace/internal/metrics/helper.go:87" app=openmatch component=metrics endpoint=/metrics port=10017
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Connected to Redis" func=github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis.ConnectionPool file="/workspace/internal/statestorage/redis/redishelpers.go:80" app=openmatch component=redishelpers
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Attempting to start gRPC server" func=github.com/GoogleCloudPlatform/open-match/internal/serving/testing.createOpenMatchServer file="/workspace/internal/serving/testing/minimatch.go:165" app=openmatch component=frontend
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="TCP net listener initialized" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start" file="/workspace/internal/serving/grpcserver.go:52" app=openmatch component=frontend port=10020
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Serving gRPC on :10020" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start.func1" file="/workspace/internal/serving/grpcserver.go:62" app=openmatch component=frontend
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=error msg="gRPC serve() error" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start.func1" file="/workspace/internal/serving/grpcserver.go:66" app=openmatch component=frontend error="grpc: the server has been stopped"
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=warning msg="Debug logging level configured. Not recommended for production!" func=github.com/GoogleCloudPlatform/open-match/internal/logging.ConfigureLogging file="/workspace/internal/logging/helper.go:27"
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Loaded OpenCensus views" func=github.com/GoogleCloudPlatform/open-match/internal/serving/testing.createOpenMatchServer file="/workspace/internal/serving/testing/minimatch.go:118" app=openmatch component=frontend viewscount=13
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="OpenCensus exporter to Promethus initialized" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:62" app=openmatch component=metrics
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Opencensus views registered" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:70" app=openmatch component=metrics
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Opencensus measurement serving to Prometheus configured" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:78" app=openmatch component=metrics endpoint=/metrics port=10021 retentionPeriod=0
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Attempting to start http server for OpenCensus metrics on localhost" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter.func1 file="/workspace/internal/metrics/helper.go:87" app=openmatch component=metrics endpoint=/metrics port=10021
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=debug msg="Attempting to connect to Redis" func=github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis.ConnectionPool file="/workspace/internal/statestorage/redis/redishelpers.go:58" app=openmatch component=redishelpers redisURL="redis://127.0.0.1:43677"
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Connected to Redis" func=github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis.ConnectionPool file="/workspace/internal/statestorage/redis/redishelpers.go:80" app=openmatch component=redishelpers
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Attempting to start gRPC server" func=github.com/GoogleCloudPlatform/open-match/internal/serving/testing.createOpenMatchServer file="/workspace/internal/serving/testing/minimatch.go:165" app=openmatch component=frontend
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="TCP net listener initialized" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start" file="/workspace/internal/serving/grpcserver.go:52" app=openmatch component=frontend port=10022
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Serving gRPC on :10022" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start.func1" file="/workspace/internal/serving/grpcserver.go:62" app=openmatch component=frontend
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=error msg="gRPC serve() error" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start.func1" file="/workspace/internal/serving/grpcserver.go:66" app=openmatch component=frontend error="grpc: the server has been stopped"
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=warning msg="Debug logging level configured. Not recommended for production!" func=github.com/GoogleCloudPlatform/open-match/internal/logging.ConfigureLogging file="/workspace/internal/logging/helper.go:27"
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Loaded OpenCensus views" func=github.com/GoogleCloudPlatform/open-match/internal/serving/testing.createOpenMatchServer file="/workspace/internal/serving/testing/minimatch.go:118" app=openmatch component=frontend viewscount=13
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="OpenCensus exporter to Promethus initialized" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:62" app=openmatch component=metrics
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Opencensus views registered" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:70" app=openmatch component=metrics
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Opencensus measurement serving to Prometheus configured" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:78" app=openmatch component=metrics endpoint=/metrics port=10023 retentionPeriod=0
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=debug msg="Attempting to connect to Redis" func=github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis.ConnectionPool file="/workspace/internal/statestorage/redis/redishelpers.go:58" app=openmatch component=redishelpers redisURL="redis://127.0.0.1:46685"
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Attempting to start http server for OpenCensus metrics on localhost" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter.func1 file="/workspace/internal/metrics/helper.go:87" app=openmatch component=metrics endpoint=/metrics port=10023
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Connected to Redis" func=github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis.ConnectionPool file="/workspace/internal/statestorage/redis/redishelpers.go:80" app=openmatch component=redishelpers
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Attempting to start gRPC server" func=github.com/GoogleCloudPlatform/open-match/internal/serving/testing.createOpenMatchServer file="/workspace/internal/serving/testing/minimatch.go:165" app=openmatch component=frontend
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="TCP net listener initialized" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start" file="/workspace/internal/serving/grpcserver.go:52" app=openmatch component=frontend port=10024
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Serving gRPC on :10024" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start.func1" file="/workspace/internal/serving/grpcserver.go:62" app=openmatch component=frontend
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=error msg="gRPC serve() error" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start.func1" file="/workspace/internal/serving/grpcserver.go:66" app=openmatch component=frontend error="grpc: the server has been stopped"
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=warning msg="Debug logging level configured. Not recommended for production!" func=github.com/GoogleCloudPlatform/open-match/internal/logging.ConfigureLogging file="/workspace/internal/logging/helper.go:27"
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Loaded OpenCensus views" func=github.com/GoogleCloudPlatform/open-match/internal/serving/testing.createOpenMatchServer file="/workspace/internal/serving/testing/minimatch.go:118" app=openmatch component=frontend viewscount=13
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="OpenCensus exporter to Promethus initialized" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:62" app=openmatch component=metrics
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Opencensus views registered" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:70" app=openmatch component=metrics
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Opencensus measurement serving to Prometheus configured" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:78" app=openmatch component=metrics endpoint=/metrics port=10025 retentionPeriod=0
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=debug msg="Attempting to connect to Redis" func=github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis.ConnectionPool file="/workspace/internal/statestorage/redis/redishelpers.go:58" app=openmatch component=redishelpers redisURL="redis://127.0.0.1:43029"
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Attempting to start http server for OpenCensus metrics on localhost" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter.func1 file="/workspace/internal/metrics/helper.go:87" app=openmatch component=metrics endpoint=/metrics port=10025
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Connected to Redis" func=github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis.ConnectionPool file="/workspace/internal/statestorage/redis/redishelpers.go:80" app=openmatch component=redishelpers
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Attempting to start gRPC server" func=github.com/GoogleCloudPlatform/open-match/internal/serving/testing.createOpenMatchServer file="/workspace/internal/serving/testing/minimatch.go:165" app=openmatch component=frontend
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="TCP net listener initialized" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start" file="/workspace/internal/serving/grpcserver.go:52" app=openmatch component=frontend port=10026
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Serving gRPC on :10026" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start.func1" file="/workspace/internal/serving/grpcserver.go:62" app=openmatch component=frontend
Step #8 - "Build: Test": ==================
Step #8 - "Build: Test": WARNING: DATA RACE
Step #8 - "Build: Test": Write at 0x00c00003c208 by goroutine 67:
Step #8 - "Build: Test": github.com/sirupsen/logrus.(*Logger).SetReportCaller()
Step #8 - "Build: Test": /go/pkg/mod/github.com/sirupsen/logrus@v1.4.1/logger.go:341 +0x85
Step #8 - "Build: Test": github.com/GoogleCloudPlatform/open-match/internal/serving/testing.createOpenMatchServer()
Step #8 - "Build: Test": /go/pkg/mod/github.com/sirupsen/logrus@v1.4.1/exported.go:31 +0xf6
Step #8 - "Build: Test": github.com/GoogleCloudPlatform/open-match/internal/serving/testing.NewMiniMatch()
Step #8 - "Build: Test": /workspace/internal/serving/testing/minimatch.go:65 +0x6d
Step #8 - "Build: Test": github.com/GoogleCloudPlatform/open-match/test/e2e/frontend.TestFrontendStartup()
Step #8 - "Build: Test": /workspace/test/e2e/frontend/frontendapi_test.go:13 +0x76
Step #8 - "Build: Test": testing.tRunner()
Step #8 - "Build: Test": /usr/local/go/src/testing/testing.go:865 +0x163
Step #8 - "Build: Test":
Step #8 - "Build: Test": Previous read at 0x00c00003c208 by goroutine 62:
Step #8 - "Build: Test": github.com/sirupsen/logrus.Entry.log()
Step #8 - "Build: Test": /go/pkg/mod/github.com/sirupsen/logrus@v1.4.1/entry.go:220 +0x1c2
Step #8 - "Build: Test": github.com/sirupsen/logrus.(*Entry).Log()
Step #8 - "Build: Test": /go/pkg/mod/github.com/sirupsen/logrus@v1.4.1/entry.go:268 +0x160
Step #8 - "Build: Test": github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start.func1()
Step #8 - "Build: Test": /go/pkg/mod/github.com/sirupsen/logrus@v1.4.1/entry.go:297 +0x359
Step #8 - "Build: Test":
Step #8 - "Build: Test": Goroutine 67 (running) created at:
Step #8 - "Build: Test": testing.(*T).Run()
Step #8 - "Build: Test": /usr/local/go/src/testing/testing.go:916 +0x65a
Step #8 - "Build: Test": testing.runTests.func1()
Step #8 - "Build: Test": /usr/local/go/src/testing/testing.go:1157 +0xa8
Step #8 - "Build: Test": testing.tRunner()
Step #8 - "Build: Test": /usr/local/go/src/testing/testing.go:865 +0x163
Step #8 - "Build: Test": testing.runTests()
Step #8 - "Build: Test": /usr/local/go/src/testing/testing.go:1155 +0x523
Step #8 - "Build: Test": testing.(*M).Run()
Step #8 - "Build: Test": /usr/local/go/src/testing/testing.go:1072 +0x2eb
Step #8 - "Build: Test": main.main()
Step #8 - "Build: Test": _testmain.go:84 +0x334
Step #8 - "Build: Test":
Step #8 - "Build: Test": Goroutine 62 (running) created at:
Step #8 - "Build: Test": github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start()
Step #8 - "Build: Test": /workspace/internal/serving/grpcserver.go:61 +0x581
Step #8 - "Build: Test": github.com/GoogleCloudPlatform/open-match/internal/serving/testing.NewMiniMatch()
Step #8 - "Build: Test": /workspace/internal/serving/omserver.go:28 +0xfd
Step #8 - "Build: Test": github.com/GoogleCloudPlatform/open-match/test/e2e/frontend.TestFrontendStartup()
Step #8 - "Build: Test": /workspace/test/e2e/frontend/frontendapi_test.go:13 +0x76
Step #8 - "Build: Test": testing.tRunner()
Step #8 - "Build: Test": /usr/local/go/src/testing/testing.go:865 +0x163
Step #8 - "Build: Test": ==================
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=warning msg="Debug logging level configured. Not recommended for production!" func=github.com/GoogleCloudPlatform/open-match/internal/logging.ConfigureLogging file="/workspace/internal/logging/helper.go:27"
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Loaded OpenCensus views" func=github.com/GoogleCloudPlatform/open-match/internal/serving/testing.createOpenMatchServer file="/workspace/internal/serving/testing/minimatch.go:118" app=openmatch component=frontend viewscount=13
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="OpenCensus exporter to Promethus initialized" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:62" app=openmatch component=metrics
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Opencensus views registered" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:70" app=openmatch component=metrics
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Opencensus measurement serving to Prometheus configured" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:78" app=openmatch component=metrics endpoint=/metrics port=10027 retentionPeriod=0
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=debug msg="Attempting to connect to Redis" func=github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis.ConnectionPool file="/workspace/internal/statestorage/redis/redishelpers.go:58" app=openmatch component=redishelpers redisURL="redis://127.0.0.1:46243"
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=error msg="gRPC serve() error" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start.func1" file="/workspace/internal/serving/grpcserver.go:66" app=openmatch component=frontend error="grpc: the server has been stopped"
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Attempting to start http server for OpenCensus metrics on localhost" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter.func1 file="/workspace/internal/metrics/helper.go:87" app=openmatch component=metrics endpoint=/metrics port=10027
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Connected to Redis" func=github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis.ConnectionPool file="/workspace/internal/statestorage/redis/redishelpers.go:80" app=openmatch component=redishelpers
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Attempting to start gRPC server" func=github.com/GoogleCloudPlatform/open-match/internal/serving/testing.createOpenMatchServer file="/workspace/internal/serving/testing/minimatch.go:165" app=openmatch component=frontend
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="TCP net listener initialized" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start" file="/workspace/internal/serving/grpcserver.go:52" app=openmatch component=frontend port=10028
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Serving gRPC on :10028" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start.func1" file="/workspace/internal/serving/grpcserver.go:62" app=openmatch component=frontend
Step #8 - "Build: Test": --- FAIL: TestFrontendStartup (0.02s)
Step #8 - "Build: Test": testing.go:809: race detected during execution of test
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=warning msg="Debug logging level configured. Not recommended for production!" func=github.com/GoogleCloudPlatform/open-match/internal/logging.ConfigureLogging file="/workspace/internal/logging/helper.go:27"
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Loaded OpenCensus views" func=github.com/GoogleCloudPlatform/open-match/internal/serving/testing.createOpenMatchServer file="/workspace/internal/serving/testing/minimatch.go:118" app=openmatch component=frontend viewscount=13
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="OpenCensus exporter to Promethus initialized" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:62" app=openmatch component=metrics
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Opencensus views registered" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:70" app=openmatch component=metrics
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Opencensus measurement serving to Prometheus configured" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:78" app=openmatch component=metrics endpoint=/metrics port=10029 retentionPeriod=0
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=debug msg="Attempting to connect to Redis" func=github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis.ConnectionPool file="/workspace/internal/statestorage/redis/redishelpers.go:58" app=openmatch component=redishelpers redisURL="redis://127.0.0.1:43663"
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Attempting to start http server for OpenCensus metrics on localhost" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter.func1 file="/workspace/internal/metrics/helper.go:87" app=openmatch component=metrics endpoint=/metrics port=10029
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Connected to Redis" func=github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis.ConnectionPool file="/workspace/internal/statestorage/redis/redishelpers.go:80" app=openmatch component=redishelpers
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Attempting to start gRPC server" func=github.com/GoogleCloudPlatform/open-match/internal/serving/testing.createOpenMatchServer file="/workspace/internal/serving/testing/minimatch.go:165" app=openmatch component=frontend
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="TCP net listener initialized" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start" file="/workspace/internal/serving/grpcserver.go:52" app=openmatch component=frontend port=10031
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Serving gRPC on :10031" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start.func1" file="/workspace/internal/serving/grpcserver.go:62" app=openmatch component=frontend
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=warning msg="Debug logging level configured. Not recommended for production!" func=github.com/GoogleCloudPlatform/open-match/internal/logging.ConfigureLogging file="/workspace/internal/logging/helper.go:27"
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Loaded OpenCensus views" func=github.com/GoogleCloudPlatform/open-match/internal/serving/testing.createOpenMatchServer file="/workspace/internal/serving/testing/minimatch.go:118" app=openmatch component=frontend viewscount=13
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="OpenCensus exporter to Promethus initialized" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:62" app=openmatch component=metrics
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Opencensus views registered" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:70" app=openmatch component=metrics
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Opencensus measurement serving to Prometheus configured" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:78" app=openmatch component=metrics endpoint=/metrics port=10033 retentionPeriod=0
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=debug msg="Attempting to connect to Redis" func=github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis.ConnectionPool file="/workspace/internal/statestorage/redis/redishelpers.go:58" app=openmatch component=redishelpers redisURL="redis://127.0.0.1:46565"
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Attempting to start http server for OpenCensus metrics on localhost" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter.func1 file="/workspace/internal/metrics/helper.go:87" app=openmatch component=metrics endpoint=/metrics port=10033
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Connected to Redis" func=github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis.ConnectionPool file="/workspace/internal/statestorage/redis/redishelpers.go:80" app=openmatch component=redishelpers
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Attempting to start gRPC server" func=github.com/GoogleCloudPlatform/open-match/internal/serving/testing.createOpenMatchServer file="/workspace/internal/serving/testing/minimatch.go:165" app=openmatch component=frontend
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="TCP net listener initialized" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start" file="/workspace/internal/serving/grpcserver.go:52" app=openmatch component=frontend port=10034
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Serving gRPC on :10034" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start.func1" file="/workspace/internal/serving/grpcserver.go:62" app=openmatch component=frontend
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=warning msg="Debug logging level configured. Not recommended for production!" func=github.com/GoogleCloudPlatform/open-match/internal/logging.ConfigureLogging file="/workspace/internal/logging/helper.go:27"
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Loaded OpenCensus views" func=github.com/GoogleCloudPlatform/open-match/internal/serving/testing.createOpenMatchServer file="/workspace/internal/serving/testing/minimatch.go:118" app=openmatch component=frontend viewscount=13
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="OpenCensus exporter to Promethus initialized" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:62" app=openmatch component=metrics
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Opencensus views registered" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:70" app=openmatch component=metrics
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Opencensus measurement serving to Prometheus configured" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter file="/workspace/internal/metrics/helper.go:78" app=openmatch component=metrics endpoint=/metrics port=10035 retentionPeriod=0
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=debug msg="Attempting to connect to Redis" func=github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis.ConnectionPo
Step #8 - "Build: Test": ol file="/workspace/internal/statestorage/redis/redishelpers.go:58" app=openmatch component=redishelpers redisURL="redis://127.0.0.1:39833"
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Attempting to start http server for OpenCensus metrics on localhost" func=github.com/GoogleCloudPlatform/open-match/internal/metrics.ConfigureOpenCensusPrometheusExporter.func1 file="/workspace/internal/metrics/helper.go:87" app=openmatch component=metrics endpoint=/metrics port=10035
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Connected to Redis" func=github.com/GoogleCloudPlatform/open-match/internal/statestorage/redis.ConnectionPool file="/workspace/internal/statestorage/redis/redishelpers.go:80" app=openmatch component=redishelpers
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Attempting to start gRPC server" func=github.com/GoogleCloudPlatform/open-match/internal/serving/testing.createOpenMatchServer file="/workspace/internal/serving/testing/minimatch.go:165" app=openmatch component=frontend
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="TCP net listener initialized" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start" file="/workspace/internal/serving/grpcserver.go:52" app=openmatch component=frontend port=10036
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=info msg="Serving gRPC on :10036" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start.func1" file="/workspace/internal/serving/grpcserver.go:62" app=openmatch component=frontend
Step #8 - "Build: Test": time="2019-04-17T16:11:17Z" level=error msg="gRPC serve() error" func="github.com/GoogleCloudPlatform/open-match/internal/serving.(*GrpcWrapper).Start.func1" file="/workspace/internal/serving/grpcserver.go:66" app=openmatch component=frontend error="grpc: the server has been stopped"
Step #8 - "Build: Test": FAIL
Step #8 - "Build: Test": coverage: 0.0% of statements
Step #8 - "Build: Test": FAIL github.com/GoogleCloudPlatform/open-match/test/e2e/frontend 0.541s
Step #8 - "Build: Test": ok github.com/GoogleCloudPlatform/open-match/test/e2e/minimatch 1.780s coverage: 0.0% of statements
Step #8 - "Build: Test": make: *** [test-10] Error 1
Step #8 - "Build: Test": Makefile:574: recipe for target 'test-10' failed
Step #9 - "Build: Docker Images": ---> ea3351caaea4
Step #9 - "Build: Docker Images": Step 5/5 : RUN go mod download
Step #7 - "Build: Binaries": cd cmd/frontendapi; CGO_ENABLED=0 GO111MODULE=on go build -a -installsuffix cgo .
Step #9 - "Build: Docker Images": ---> Running in e0a7b43d7475
Finished Step #8 - "Build: Test"
2019/04/17 09:11:27 Step Step #8 - "Build: Test" finished
Finished Step #7 - "Build: Binaries"
2019/04/17 09:11:27 Step Step #7 - "Build: Binaries" finished
Finished Step #13 - "Test: Website"
2019/04/17 09:11:27 Step Step #13 - "Test: Website" finished
Finished Step #9 - "Build: Docker Images"
2019/04/17 09:11:27 Step Step #9 - "Build: Docker Images" finished
2019/04/17 09:11:29 status changed to "ERROR"
ERROR
ERROR: build step 8 "open-match-build" failed: exit status 2
2019/04/17 09:11:31 Build finished with ERROR status
Makefile:172: recipe for target 'local-cloud-build' failed
make: *** [local-cloud-build] Error 1 |
|
The previous race condition has been reported to logsrus, sirupsen/logrus#954. |
Sign up for free
to join this conversation on GitHub.
Already have an account?
Sign in to comment
There's a difficult to reproduce race condition in github.com/GoogleCloudPlatform/open-match/test/e2e/frontend.
The text was updated successfully, but these errors were encountered: