Rust SDK Doc additions

[markmandel]

• Include Rust in the list of SDKs
• Also put a development warning on the SDK

[agones-bot]

Build Failed 😱

Build Id: 28b8e1a3-f2f6-4810-bf9a-5ae271006c4a

Build Logs

starting build "28b8e1a3-f2f6-4810-bf9a-5ae271006c4a"

FETCHSOURCE
Initialized empty Git repository in /workspace/.git/
From https://source.developers.google.com/p/agones-images/r/agones
 * branch            1660327ee9116d32501d341385b863dfb1b6d973 -> FETCH_HEAD
HEAD is now at 1660327 Rust SDK Doc additions
BUILD
Starting Step #0
Step #0: Already have image (with digest): ubuntu
Finished Step #0
Starting Step #1
Step #1: Already have image (with digest): gcr.io/cloud-builders/docker
Step #1: Sending build context to Docker daemon  131.2MB

Step #1: Step 1/3 : FROM gcr.io/cloud-builders/docker
Step #1:  ---> 2adb1cfa9b75
Step #1: Step 2/3 : RUN apt-get install make
Step #1:  ---> Running in 4228460d615b
Step #1: Reading package lists...
Step #1: Building dependency tree...
Step #1: Reading state information...
Step #1: Suggested packages:
Step #1:   make-doc
Step #1: The following NEW packages will be installed:
Step #1:   make
Step #1: 0 upgraded, 1 newly installed, 0 to remove and 4 not upgraded.
Step #1: Need to get 151 kB of archives.
Step #1: After this operation, 365 kB of additional disk space will be used.
Step #1: Get:1 http://archive.ubuntu.com/ubuntu xenial/main amd64 make amd64 4.1-6 [151 kB]
Step #1: Fetched 151 kB in 0s (249 kB/s)
Step #1: Selecting previously unselected package make.
Step #1: (Reading database ... 
(Reading database ... 5%
(Reading database ... 10%
(Reading database ... 15%
(Reading database ... 20%
(Reading database ... 25%
(Reading database ... 30%
(Reading database ... 35%
(Reading database ... 40%
(Reading database ... 45%
(Reading database ... 50%
(Reading database ... 55%
(Reading database ... 60%
(Reading database ... 65%
(Reading database ... 70%
(Reading database ... 75%
(Reading database ... 80%
(Reading database ... 85%
(Reading database ... 90%
(Reading database ... 95%
(Reading database ... 100%
(Reading database ... 11239 files and directories currently installed.)
Step #1: Preparing to unpack .../archives/make_4.1-6_amd64.deb ...
Step #1: Unpacking make (4.1-6) ...
Step #1: Setting up make (4.1-6) ...
Step #1: Removing intermediate container 4228460d615b
Step #1:  ---> 44be78e8e16a
Step #1: Step 3/3 : ENTRYPOINT ["/usr/bin/make"]
Step #1:  ---> Running in 8af35a4ac937
Step #1: Removing intermediate container 8af35a4ac937
Step #1:  ---> ef08917485fb
Step #1: Successfully built ef08917485fb
Step #1: Successfully tagged make-docker:latest
Finished Step #1
Starting Step #2 - "pull-build-image"
Step #2 - "pull-build-image": Already have image: make-docker
Step #2 - "pull-build-image": docker pull gcr.io/agones-images/agones-build:fedaab1c9e && docker tag gcr.io/agones-images/agones-build:fedaab1c9e agones-build:fedaab1c9e
Step #2 - "pull-build-image": fedaab1c9e: Pulling from agones-images/agones-build
Step #2 - "pull-build-image": c73ab1c6897b: Pulling fs layer
Step #2 - "pull-build-image": 3091fac74ac3: Pulling fs layer
Step #2 - "pull-build-image": 32ec8f15f1df: Pulling fs layer
Step #2 - "pull-build-image": 05316ce21a25: Pulling fs layer
Step #2 - "pull-build-image": 2f0627691b79: Pulling fs layer
Step #2 - "pull-build-image": 316bb68da5df: Pulling fs layer
Step #2 - "pull-build-image": b732691c3989: Pulling fs layer
Step #2 - "pull-build-image": b39b15d9388e: Pulling fs layer
Step #2 - "pull-build-image": 468aee6ffa02: Pulling fs layer
Step #2 - "pull-build-image": 705bdc3637a7: Pulling fs layer
Step #2 - "pull-build-image": d743f6c65281: Pulling fs layer
Step #2 - "pull-build-image": 009752464ced: Pulling fs layer
Step #2 - "pull-build-image": d88f6e80263a: Pulling fs layer
Step #2 - "pull-build-image": 51ba8e2a1e14: Pulling fs layer
Step #2 - "pull-build-image": 7c5c59a90f21: Pulling fs layer
Step #2 - "pull-build-image": 7970d81f9703: Pulling fs layer
Step #2 - "pull-build-image": 00a4302f048d: Pulling fs layer
Step #2 - "pull-build-image": bc85b5b9fdab: Pulling fs layer
Step #2 - "pull-build-image": 05316ce21a25: Waiting
Step #2 - "pull-build-image": 8df4e9268837: Pulling fs layer
Step #2 - "pull-build-image": fbf4eab1fe93: Pulling fs layer
Step #2 - "pull-build-image": 316bb68da5df: Waiting
Step #2 - "pull-build-image": d88f6e80263a: Waiting
Step #2 - "pull-build-image": b732691c3989: Waiting
Step #2 - "pull-build-image": b39b15d9388e: Waiting
Step #2 - "pull-build-image": 51ba8e2a1e14: Waiting
Step #2 - "pull-build-image": 7c5c59a90f21: Waiting
Step #2 - "pull-build-image": 7970d81f9703: Waiting
Step #2 - "pull-build-image": 468aee6ffa02: Waiting
Step #2 - "pull-build-image": 705bdc3637a7: Waiting
Step #2 - "pull-build-image": 00a4302f048d: Waiting
Step #2 - "pull-build-image": bc85b5b9fdab: Waiting
Step #2 - "pull-build-image": d743f6c65281: Waiting
Step #2 - "pull-build-image": 8df4e9268837: Waiting
Step #2 - "pull-build-image": 009752464ced: Waiting
Step #2 - "pull-build-image": 2f0627691b79: Waiting
Step #2 - "pull-build-image": fbf4eab1fe93: Waiting
Step #2 - "pull-build-image": c73ab1c6897b: Verifying Checksum
Step #2 - "pull-build-image": c73ab1c6897b: Download complete
Step #2 - "pull-build-image": 05316ce21a25: Verifying Checksum
Step #2 - "pull-build-image": 05316ce21a25: Download complete
Step #2 - "pull-build-image": 3091fac74ac3: Verifying Checksum
Step #2 - "pull-build-image": 3091fac74ac3: Download complete
Step #2 - "pull-build-image": 316bb68da5df: Download complete
Step #2 - "pull-build-image": 2f0627691b79: Verifying Checksum
Step #2 - "pull-build-image": 2f0627691b79: Download complete
Step #2 - "pull-build-image": b39b15d9388e: Download complete
Step #2 - "pull-build-image": c73ab1c6897b: Pull complete
Step #2 - "pull-build-image": 468aee6ffa02: Verifying Checksum
Step #2 - "pull-build-image": 468aee6ffa02: Download complete
Step #2 - "pull-build-image": 705bdc3637a7: Download complete
Step #2 - "pull-build-image": d743f6c65281: Verifying Checksum
Step #2 - "pull-build-image": d743f6c65281: Download complete
Step #2 - "pull-build-image": b732691c3989: Verifying Checksum
Step #2 - "pull-build-image": b732691c3989: Download complete
Step #2 - "pull-build-image": d88f6e80263a: Verifying Checksum
Step #2 - "pull-build-image": d88f6e80263a: Download complete
Step #2 - "pull-build-image": 32ec8f15f1df: Verifying Checksum
Step #2 - "pull-build-image": 32ec8f15f1df: Download complete
Step #2 - "pull-build-image": 009752464ced: Verifying Checksum
Step #2 - "pull-build-image": 009752464ced: Download complete
Step #2 - "pull-build-image": 7970d81f9703: Verifying Checksum
Step #2 - "pull-build-image": 7970d81f9703: Download complete
Step #2 - "pull-build-image": 00a4302f048d: Download complete
Step #2 - "pull-build-image": bc85b5b9fdab: Verifying Checksum
Step #2 - "pull-build-image": bc85b5b9fdab: Download complete
Step #2 - "pull-build-image": 8df4e9268837: Download complete
Step #2 - "pull-build-image": fbf4eab1fe93: Download complete
Step #2 - "pull-build-image": 7c5c59a90f21: Verifying Checksum
Step #2 - "pull-build-image": 7c5c59a90f21: Download complete
Step #2 - "pull-build-image": 51ba8e2a1e14: Download complete
Step #2 - "pull-build-image": 3091fac74ac3: Pull complete
Step #2 - "pull-build-image": 32ec8f15f1df: Pull complete
Step #2 - "pull-build-image": 05316ce21a25: Pull complete
Step #2 - "pull-build-image": 2f0627691b79: Pull complete
Step #2 - "pull-build-image": 316bb68da5df: Pull complete
Step #2 - "pull-build-image": b732691c3989: Pull complete
Step #2 - "pull-build-image": b39b15d9388e: Pull complete
Step #2 - "pull-build-image": 468aee6ffa02: Pull complete
Step #2 - "pull-build-image": 705bdc3637a7: Pull complete
Step #2 - "pull-build-image": d743f6c65281: Pull complete
Step #2 - "pull-build-image": 009752464ced: Pull complete
Step #2 - "pull-build-image": d88f6e80263a: Pull complete
Step #2 - "pull-build-image": 51ba8e2a1e14: Pull complete
Step #2 - "pull-build-image": 7c5c59a90f21: Pull complete
Step #2 - "pull-build-image": 7970d81f9703: Pull complete
Step #2 - "pull-build-image": 00a4302f048d: Pull complete
Step #2 - "pull-build-image": bc85b5b9fdab: Pull complete
Step #2 - "pull-build-image": 8df4e9268837: Pull complete
Step #2 - "pull-build-image": fbf4eab1fe93: Pull complete
Step #2 - "pull-build-image": Digest: sha256:186e0d1648954edfc3e2e2cc4c05089a82ec408f18ce0795a92779ac060e8ee2
Step #2 - "pull-build-image": Status: Downloaded newer image for gcr.io/agones-images/agones-build:fedaab1c9e
Finished Step #2 - "pull-build-image"
Starting Step #3 - "tests"
Starting Step #4 - "build"
Step #3 - "tests": Already have image: make-docker
Step #4 - "build": Already have image: make-docker
Step #3 - "tests": mkdir -p ~/.kube
Step #3 - "tests": mkdir -p /workspace/build//.config/gcloud
Step #3 - "tests": docker run --rm -v /workspace/build//.config/gcloud:/root/.config/gcloud -v ~/.kube:/root/.kube -v /workspace:/go/src/agones.dev/agones -w /go/src/agones.dev/agones  agones-build:fedaab1c9e bash -c \
Step #3 - "tests": 	"/root/gen-lint-exclude.sh && gometalinter --config .exclude.gometalinter.json --deadline=5m -t --skip vendor ./..."
Step #4 - "build": mkdir -p ~/.kube
Step #4 - "build": mkdir -p /workspace/build//.config/gcloud
Step #4 - "build": docker run --rm -e "CGO_ENABLED=0" -v /workspace/build//.config/gcloud:/root/.config/gcloud -v ~/.kube:/root/.kube -v /workspace:/go/src/agones.dev/agones agones-build:fedaab1c9e go build \
Step #4 - "build": 	-o /go/src/agones.dev/agones/cmd/controller/bin/controller -a -ldflags "-X agones.dev/agones/pkg.Version=0.3.0-1660327" -installsuffix cgo agones.dev/agones/cmd/controller
Step #4 - "build": docker build /workspace/cmd/controller/ --tag=gcr.io/agones-images/agones-controller:0.3.0-1660327 
Step #4 - "build": Sending build context to Docker daemon  40.08MB

Step #4 - "build": Step 1/6 : FROM alpine:3.7
Step #4 - "build": 3.7: Pulling from library/alpine
Step #4 - "build": Digest: sha256:8c03bb07a531c53ad7d0f6e7041b64d81f99c6e493cb39abba56d956b40eacbc
Step #4 - "build": Status: Downloaded newer image for alpine:3.7
Step #4 - "build":  ---> 3fd9065eaf02
Step #4 - "build": Step 2/6 : RUN apk --update add ca-certificates &&     adduser -D agones
Step #4 - "build":  ---> Running in 2b8661328830
Step #4 - "build": fetch http://dl-cdn.alpinelinux.org/alpine/v3.7/main/x86_64/APKINDEX.tar.gz
Step #4 - "build": fetch http://dl-cdn.alpinelinux.org/alpine/v3.7/community/x86_64/APKINDEX.tar.gz
Step #4 - "build": (1/1) Installing ca-certificates (20171114-r0)
Step #4 - "build": Executing busybox-1.27.2-r7.trigger
Step #4 - "build": Executing ca-certificates-20171114-r0.trigger
Step #4 - "build": OK: 5 MiB in 12 packages
Step #4 - "build": Removing intermediate container 2b8661328830
Step #4 - "build":  ---> e6864f0ee881
Step #4 - "build": Step 3/6 : COPY ./bin/controller /home/agones/controller
Step #4 - "build":  ---> c3717be12aa2
Step #4 - "build": Step 4/6 : RUN chown -R agones /home/agones &&     chmod o+x /home/agones/controller
Step #4 - "build":  ---> Running in 7ba0999134f6
Step #4 - "build": Removing intermediate container 7ba0999134f6
Step #4 - "build":  ---> 2f4fca5374fd
Step #4 - "build": Step 5/6 : USER agones
Step #4 - "build":  ---> Running in a5931f2729ff
Step #4 - "build": Removing intermediate container a5931f2729ff
Step #4 - "build":  ---> 94e9578e2811
Step #4 - "build": Step 6/6 : ENTRYPOINT ["/home/agones/controller"]
Step #4 - "build":  ---> Running in 980bed2fdf75
Step #4 - "build": Removing intermediate container 980bed2fdf75
Step #4 - "build":  ---> d32d19704de1
Step #4 - "build": Successfully built d32d19704de1
Step #4 - "build": Successfully tagged gcr.io/agones-images/agones-controller:0.3.0-1660327
Step #4 - "build": docker run --rm -e "CGO_ENABLED=0" -v /workspace/build//.config/gcloud:/root/.config/gcloud -v ~/.kube:/root/.kube -v /workspace:/go/src/agones.dev/agones agones-build:fedaab1c9e go build \
Step #4 - "build": 	-o /go/src/agones.dev/agones/cmd/sdk-server/bin/sdk-server.linux.amd64 -a -ldflags "-X agones.dev/agones/pkg.Version=0.3.0-1660327" -installsuffix cgo agones.dev/agones/cmd/sdk-server
Step #3 - "tests": docker run --rm -v /workspace/build//.config/gcloud:/root/.config/gcloud -v ~/.kube:/root/.kube -v /workspace:/go/src/agones.dev/agones agones-build:fedaab1c9e go test -race agones.dev/agones/...
Step #3 - "tests": warning: ignoring symlink /go/src/agones.dev/agones/vendor/github.com/prometheus/procfs/fixtures/self
Step #3 - "tests": ?   	agones.dev/agones	[no test files]
Step #4 - "build": docker run --rm -e "GOOS=darwin" -e "GOARCH=amd64" -v /workspace/build//.config/gcloud:/root/.config/gcloud -v ~/.kube:/root/.kube -v /workspace:/go/src/agones.dev/agones agones-build:fedaab1c9e go build \
Step #4 - "build": 	-o /go/src/agones.dev/agones/cmd/sdk-server/bin/sdk-server.darwin.amd64 -ldflags "-X agones.dev/agones/pkg.Version=0.3.0-1660327" agones.dev/agones/cmd/sdk-server
Step #3 - "tests": ?   	agones.dev/agones/cmd/controller	[no test files]
Step #3 - "tests": ?   	agones.dev/agones/cmd/sdk-server	[no test files]
Step #3 - "tests": ?   	agones.dev/agones/examples/simple-udp/client	[no test files]
Step #3 - "tests": ?   	agones.dev/agones/examples/simple-udp/server	[no test files]
Step #3 - "tests": ?   	agones.dev/agones/examples/xonotic	[no test files]
Step #3 - "tests": ?   	agones.dev/agones/pkg	[no test files]
Step #3 - "tests": ?   	agones.dev/agones/pkg/apis	[no test files]
Step #3 - "tests": ?   	agones.dev/agones/pkg/apis/stable	[no test files]
Step #3 - "tests": ok  	agones.dev/agones/pkg/apis/stable/v1alpha1	2.897s
Step #3 - "tests": ?   	agones.dev/agones/pkg/client	[no test files]
Step #3 - "tests": ?   	agones.dev/agones/pkg/client/clientset/versioned	[no test files]
Step #3 - "tests": ?   	agones.dev/agones/pkg/client/clientset/versioned/fake	[no test files]
Step #3 - "tests": ?   	agones.dev/agones/pkg/client/clientset/versioned/scheme	[no test files]
Step #3 - "tests": ?   	agones.dev/agones/pkg/client/clientset/versioned/typed/stable/v1alpha1	[no test files]
Step #3 - "tests": ?   	agones.dev/agones/pkg/client/clientset/versioned/typed/stable/v1alpha1/fake	[no test files]
Step #3 - "tests": ?   	agones.dev/agones/pkg/client/informers/externalversions	[no test files]
Step #3 - "tests": ?   	agones.dev/agones/pkg/client/informers/externalversions/internalinterfaces	[no test files]
Step #3 - "tests": ?   	agones.dev/agones/pkg/client/informers/externalversions/stable	[no test files]
Step #3 - "tests": ?   	agones.dev/agones/pkg/client/informers/externalversions/stable/v1alpha1	[no test files]
Step #3 - "tests": ?   	agones.dev/agones/pkg/client/listers/stable/v1alpha1	[no test files]
Step #4 - "build": docker run --rm -e "GOOS=windows" -e "GOARCH=amd64" -v /workspace/build//.config/gcloud:/root/.config/gcloud -v ~/.kube:/root/.kube -v /workspace:/go/src/agones.dev/agones agones-build:fedaab1c9e go build \
Step #4 - "build": 	-o /go/src/agones.dev/agones/cmd/sdk-server/bin/sdk-server.windows.amd64.exe -ldflags "-X agones.dev/agones/pkg.Version=0.3.0-1660327" agones.dev/agones/cmd/sdk-server
Step #3 - "tests": ok  	agones.dev/agones/pkg/fleetallocation	12.442s
Step #3 - "tests": ok  	agones.dev/agones/pkg/fleets	3.121s
Step #3 - "tests": {"level":"info","maxPort":20,"minPort":10,"msg":"Starting","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:47Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/mutate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:47Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/validate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:47Z"}
Step #3 - "tests": {"level":"info","msg":"Wait for cache sync","time":"2018-06-08T17:06:47Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/vendor/k8s.io/client-go/informers/factory.go:86: Failed to watch *v1.Node: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"\", Version:\"v1\", Resource:\"nodes\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:47Z"}
Step #3 - "tests": {"level":"info","msg":"Adding first fixture","time":"2018-06-08T17:06:47Z"}
Step #3 - "tests": {"crd":"","level":"info","msg":"custom resource definition established","source":"*gameservers.Controller","time":"2018-06-08T17:06:47Z"}
Step #3 - "tests": {"level":"info","msg":"Wait for cache sync","source":"*gameservers.Controller","time":"2018-06-08T17:06:47Z"}
Step #3 - "tests": {"key":"default/test","level":"info","msg":"Enqueuing key","queue":"stable.agones.dev.GameServerController","source":"*gameservers.Controller","time":"2018-06-08T17:06:47Z"}
Step #3 - "tests": {"level":"info","msg":"Running","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:47Z"}
Step #3 - "tests": {"level":"info","msg":"Resetting Port Allocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:47Z"}
Step #3 - "tests": {"level":"info","msg":"Starting workers...","queue":"stable.agones.dev.GameServerController","source":"*gameservers.Controller","time":"2018-06-08T17:06:47Z","workers":1}
Step #3 - "tests": {"level":"info","msg":"Starting workers...","queue":"stable.agones.dev.HealthController","source":"*gameservers.HealthController","time":"2018-06-08T17:06:47Z","workers":1}
Step #3 - "tests": {"level":"info","msg":"Processing obj","obj":"default/test","queue":"stable.agones.dev.GameServerController","source":"*gameservers.Controller","time":"2018-06-08T17:06:47Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/vendor/k8s.io/client-go/informers/factory.go:86: Failed to watch *v1.Node: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"\", Version:\"v1\", Resource:\"nodes\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:48Z"}
Step #3 - "tests": {"level":"info","msg":"modify copyFixture","time":"2018-06-08T17:06:48Z"}
Step #3 - "tests": {"key":"default/test","level":"info","msg":"Enqueuing key","queue":"stable.agones.dev.GameServerController","source":"*gameservers.Controller","time":"2018-06-08T17:06:48Z"}
Step #3 - "tests": {"level":"info","msg":"Processing obj","obj":"default/test","queue":"stable.agones.dev.GameServerController","source":"*gameservers.Controller","time":"2018-06-08T17:06:48Z"}
Step #3 - "tests": {"key":"default/test","level":"info","msg":"Enqueuing key","queue":"stable.agones.dev.GameServerController","source":"*gameservers.Controller","time":"2018-06-08T17:06:48Z"}
Step #3 - "tests": {"level":"info","msg":"Processing obj","obj":"default/test","queue":"stable.agones.dev.GameServerController","source":"*gameservers.Controller","time":"2018-06-08T17:06:48Z"}
Step #3 - "tests": {"level":"info","msg":"...shutting down workers","queue":"stable.agones.dev.HealthController","source":"*gameservers.HealthController","time":"2018-06-08T17:06:48Z"}
Step #3 - "tests": {"level":"info","msg":"...shutting down workers","queue":"stable.agones.dev.GameServerController","source":"*gameservers.Controller","time":"2018-06-08T17:06:48Z"}
Step #3 - "tests": {"level":"info","maxPort":20,"minPort":10,"msg":"Starting","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:48Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/mutate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:48Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/validate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:48Z"}
Step #3 - "tests": {"gs":{"metadata":{"name":"test","namespace":"default","creationTimestamp":null,"finalizers":["stable.agones.dev"]},"spec":{"container":"container","portPolicy":"static","containerPort":7777,"hostPort":9999,"protocol":"UDP","health":{"periodSeconds":5,"failureThreshold":3,"initialDelaySeconds":5},"template":{"metadata":{"creationTimestamp":null},"spec":{"containers":[{"name":"container","image":"container/image","resources":{}}]}}},"status":{"state":"Creating","port":0,"address":"","nodeName":""}},"level":"info","msg":"Syncing Create State","source":"*gameservers.Controller","time":"2018-06-08T17:06:48Z"}
Step #3 - "tests": {"level":"info","msg":"creating Pod for GameServer","pod":{"metadata":{"generateName":"test-","namespace":"default","creationTimestamp":null,"labels":{"stable.agones.dev/gameserver":"test","stable.agones.dev/role":"gameserver"},"annotations":{"stable.agones.dev/container":"container"},"ownerReferences":[{"apiVersion":"stable.agones.dev/v1alpha1","kind":"GameServer","name":"test","uid":"","controller":true,"blockOwnerDeletion":true}]},"spec":{"containers":[{"name":"container","image":"container/image","ports":[{"hostPort":9999,"containerPort":7777,"protocol":"UDP"}],"resources":{},"livenessProbe":{"httpGet":{"path":"/gshealthz","port":8080},"initialDelaySeconds":5,"periodSeconds":5,"failureThreshold":3}},{"name":"agones-gameserver-sidecar","image":"sidecar:dev","env":[{"name":"GAMESERVER_NAME","value":"test"},{"name":"POD_NAMESPACE","valueFrom":{"fieldRef":{"fieldPath":"metadata.namespace"}}}],"resources":{},"livenessProbe":{"httpGet":{"path":"/healthz","port":8080},"initialDelaySeconds":3,"periodSeconds":3}}],"serviceAccountName":"agones-sdk"},"status":{}},"source":"*gameservers.Controller","time":"2018-06-08T17:06:48Z"}
Step #3 - "tests": {"level":"info","maxPort":20,"minPort":10,"msg":"Starting","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:48Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/mutate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:48Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/validate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:48Z"}
Step #3 - "tests": {"level":"info","msg":"Wait for cache sync","time":"2018-06-08T17:06:48Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/vendor/k8s.io/client-go/informers/factory.go:86: Failed to watch *v1.Pod: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"\", Version:\"v1\", Resource:\"pods\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:48Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/pkg/client/informers/externalversions/factory.go:74: Failed to watch *v1alpha1.GameServer: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"stable.agones.dev\", Version:\"v1alpha1\", Resource:\"gameservers\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:48Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/vendor/k8s.io/client-go/informers/factory.go:86: Failed to watch *v1.Node: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"\", Version:\"v1\", Resource:\"nodes\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:48Z"}
Step #3 - "tests": {"gs":{"metadata":{"name":"test","namespace":"default","creationTimestamp":null,"finalizers":["stable.agones.dev"]},"spec":{"container":"container","portPolicy":"static","containerPort":7777,"hostPort":9999,"protocol":"UDP","health":{"periodSeconds":5,"failureThreshold":3,"initialDelaySeconds":5},"template":{"metadata":{"creationTimestamp":null},"spec":{"containers":[{"name":"container","image":"container/image","resources":{}}]}}},"status":{"state":"Creating","port":0,"address":"","nodeName":""}},"level":"info","msg":"Syncing Create State","source":"*gameservers.Controller","time":"2018-06-08T17:06:48Z"}
Step #3 - "tests": {"level":"info","maxPort":20,"minPort":10,"msg":"Starting","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:48Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/mutate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:48Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/validate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:48Z"}
Step #3 - "tests": {"level":"info","msg":"Wait for cache sync","time":"2018-06-08T17:06:48Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/vendor/k8s.io/client-go/informers/factory.go:86: Failed to watch *v1.Node: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"\", Version:\"v1\", Resource:\"nodes\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:48Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/vendor/k8s.io/client-go/informers/factory.go:86: Failed to watch *v1.Pod: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"\", Version:\"v1\", Resource:\"pods\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:48Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/pkg/client/informers/externalversions/factory.go:74: Failed to watch *v1alpha1.GameServer: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"stable.agones.dev\", Version:\"v1alpha1\", Resource:\"gameservers\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:48Z"}
Step #3 - "tests": {"gs":{"metadata":{"name":"test","namespace":"default","creationTimestamp":null,"finalizers":["stable.agones.dev"]},"spec":{"container":"container","portPolicy":"static","containerPort":7777,"hostPort":9999,"protocol":"UDP","health":{"periodSeconds":5,"failureThreshold":3,"initialDelaySeconds":5},"template":{"metadata":{"creationTimestamp":null},"spec":{"containers":[{"name":"container","image":"container/image","resources":{}}]}}},"status":{"state":"Creating","port":0,"address":"","nodeName":""}},"level":"info","msg":"Syncing Create State","source":"*gameservers.Controller","time":"2018-06-08T17:06:48Z"}
Step #3 - "tests": {"level":"info","msg":"creating Pod for GameServer","pod":{"metadata":{"generateName":"test-","namespace":"default","creationTimestamp":null,"labels":{"stable.agones.dev/gameserver":"test","stable.agones.dev/role":"gameserver"},"annotations":{"stable.agones.dev/container":"container"},"ownerReferences":[{"apiVersion":"stable.agones.dev/v1alpha1","kind":"GameServer","name":"test","uid":"","controller":true,"blockOwnerDeletion":true}]},"spec":{"containers":[{"name":"container","image":"container/image","ports":[{"hostPort":9999,"containerPort":7777,"protocol":"UDP"}],"resources":{},"livenessProbe":{"httpGet":{"path":"/gshealthz","port":8080},"initialDelaySeconds":5,"periodSeconds":5,"failureThreshold":3}},{"name":"agones-gameserver-sidecar","image":"sidecar:dev","env":[{"name":"GAMESERVER_NAME","value":"test"},{"name":"POD_NAMESPACE","valueFrom":{"fieldRef":{"fieldPath":"metadata.namespace"}}}],"resources":{},"livenessProbe":{"httpGet":{"path":"/healthz","port":8080},"initialDelaySeconds":3,"periodSeconds":3}}],"serviceAccountName":"agones-sdk"},"status":{}},"source":"*gameservers.Controller","time":"2018-06-08T17:06:48Z"}
Step #3 - "tests": {"gameserver":{"metadata":{"name":"test","namespace":"default","creationTimestamp":null,"finalizers":["stable.agones.dev"]},"spec":{"container":"container","portPolicy":"static","containerPort":7777,"hostPort":9999,"protocol":"UDP","health":{"periodSeconds":5,"failureThreshold":3,"initialDelaySeconds":5},"template":{"metadata":{"creationTimestamp":null},"spec":{"containers":[{"name":"container","image":"container/image","resources":{}}]}}},"status":{"state":"Creating","port":0,"address":"","nodeName":""}},"level":"error","msg":"Pod created is invalid","pod":null,"source":"*gameservers.Controller","time":"2018-06-08T17:06:48Z"}
Step #3 - "tests": {"level":"info","maxPort":20,"minPort":10,"msg":"Starting","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:48Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/mutate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:48Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/validate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:48Z"}
Step #3 - "tests": {"level":"info","maxPort":20,"minPort":10,"msg":"Starting","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:48Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/mutate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:48Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/validate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:48Z"}
Step #3 - "tests": {"level":"info","maxPort":20,"minPort":10,"msg":"Starting","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:48Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/mutate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:48Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/validate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:48Z"}
Step #3 - "tests": {"level":"info","msg":"Wait for cache sync","time":"2018-06-08T17:06:48Z"}
Step #3 - "tests": {"level":"info","msg":"Starting workers...","queue":"stable.agones.dev.HealthController","source":"*gameservers.HealthController","time":"2018-06-08T17:06:49Z","workers":1}
Step #3 - "tests": {"key":"default/test","level":"info","msg":"GameServer container has terminated","source":"*gameservers.HealthController","time":"2018-06-08T17:06:49Z"}
Step #3 - "tests": {"key":"default/test","level":"info","msg":"Enqueuing key","queue":"stable.agones.dev.HealthController","source":"*gameservers.HealthController","time":"2018-06-08T17:06:49Z"}
Step #3 - "tests": {"level":"info","msg":"Processing obj","obj":"default/test","queue":"stable.agones.dev.HealthController","source":"*gameservers.HealthController","time":"2018-06-08T17:06:49Z"}
Step #3 - "tests": {"key":"default/test","level":"info","msg":"Synchronising","source":"*gameservers.HealthController","time":"2018-06-08T17:06:49Z"}
Step #3 - "tests": {"gs":{"metadata":{"name":"test","namespace":"default","creationTimestamp":null,"finalizers":["stable.agones.dev"]},"spec":{"container":"container","portPolicy":"static","containerPort":7777,"hostPort":9999,"protocol":"UDP","health":{"periodSeconds":5,"failureThreshold":3,"initialDelaySeconds":5},"template":{"metadata":{"creationTimestamp":null},"spec":{"containers":[{"name":"container","image":"container/image","resources":{}}]}}},"status":{"state":"Ready","port":0,"address":"","nodeName":""}},"level":"info","msg":"Marking GameServer as Unhealthy","source":"*gameservers.HealthController","time":"2018-06-08T17:06:49Z"}
Step #3 - "tests": {"level":"info","msg":"...shutting down workers","queue":"stable.agones.dev.HealthController","source":"*gameservers.HealthController","time":"2018-06-08T17:06:49Z"}
Step #3 - "tests": {"level":"info","msg":"Ready request has been received!","time":"2018-06-08T17:06:49Z"}
Step #3 - "tests": {"level":"info","msg":"Shutdown request has been received!","time":"2018-06-08T17:06:49Z"}
Step #3 - "tests": {"level":"info","msg":"Health Ping Received!","time":"2018-06-08T17:06:49Z"}
Step #3 - "tests": {"level":"info","msg":"Health stream closed.","time":"2018-06-08T17:06:49Z"}
Step #3 - "tests": {"level":"info","maxPort":110,"minPort":10,"msg":"Starting","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:49Z"}
Step #3 - "tests": {"level":"info","msg":"Wait for cache sync","time":"2018-06-08T17:06:49Z"}
Step #3 - "tests": {"level":"info","msg":"Adding Node to port allocations","node":"node1","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:49Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/pkg/client/informers/externalversions/factory.go:74: Failed to watch *v1alpha1.GameServer: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"stable.agones.dev\", Version:\"v1alpha1\", Resource:\"gameservers\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:49Z"}
Step #3 - "tests": {"level":"info","msg":"Adding Node to port allocations","node":"node2","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:49Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/vendor/k8s.io/client-go/informers/factory.go:86: Failed to watch *v1.Node: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"\", Version:\"v1\", Resource:\"nodes\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:49Z"}
Step #3 - "tests": {"level":"info","msg":"Running","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:49Z"}
Step #3 - "tests": {"level":"info","msg":"Resetting Port Allocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:49Z"}
Step #3 - "tests": {"i":0,"level":"info","msg":"allocating!","time":"2018-06-08T17:06:49Z","x":0}
Step #3 - "tests": {"i":1,"level":"info","msg":"allocating!","time":"2018-06-08T17:06:49Z","x":0}
Step #3 - "tests": {"i":0,"level":"info","msg":"allocating!","time":"2018-06-08T17:06:49Z","x":1}
Step #3 - "tests": {"i":2,"level":"info","msg":"allocating!","time":"2018-06-08T17:06:49Z","x":0}
Step #3 - "tests": {"i":0,"level":"info","msg":"allocating!","time":"2018-06-08T17:06:49Z","x":2}
Step #3 - "tests": {"i":2,"level":"info","msg":"allocating!","time":"2018-06-08T17:06:49Z","x":1}
Step #3 - "tests": {"i":1,"level":"info","msg":"allocating!","time":"2018-06-08T17:06:49Z","x":1}
Step #3 - "tests": {"i":0,"level":"info","msg":"allocating!","time":"2018-06-08T17:06:49Z","x":3}
Step #3 - "tests": {"i":2,"level":"info","msg":"allocating!","time":"2018-06-08T17:06:49Z","x":2}
Step #3 - "tests": {"i":1,"level":"info","msg":"allocating!","time":"2018-06-08T17:06:49Z","x":2}
Step #3 - "tests": {"i":0,"level":"info","msg":"allocating!","time":"2018-06-08T17:06:49Z","x":4}
Step #3 - "tests": {"i":1,"level":"info","msg":"allocating!","time":"2018-06-08T17:06:49Z","x":3}
Step #3 - "tests": {"i":2,"level":"info","msg":"allocating!","time":"2018-06-08T17:06:49Z","x":3}
Step #3 - "tests": {"i":0,"level":"info","msg":"allocating!","time":"2018-06-08T17:06:49Z","x":5}
Step #3 - "tests": {"i":1,"level":"info","msg":"allocating!","time":"2018-06-08T17:06:49Z","x":4}
Step #3 - "tests": {"i":2,"level":"info","msg":"allocating!","time":"2018-06-08T17:06:49Z","x":4}
Step #3 - "tests": {"i":1,"level":"info","msg":"allocating!","time":"2018-06-08T17:06:49Z","x":5}
Step #3 - "tests": {"i":2,"level":"info","msg":"allocating!","time":"2018-06-08T17:06:49Z","x":5}
Step #3 - "tests": {"i":1,"level":"info","msg":"allocating!","time":"2018-06-08T17:06:49Z","x":6}
Step #3 - "tests": {"i":2,"level":"info","msg":"allocating!","time":"2018-06-08T17:06:49Z","x":6}
Step #3 - "tests": {"i":1,"level":"info","msg":"allocating!","time":"2018-06-08T17:06:49Z","x":7}
Step #3 - "tests": {"i":2,"level":"info","msg":"allocating!","time":"2018-06-08T17:06:49Z","x":7}
Step #3 - "tests": {"i":1,"level":"info","msg":"allocating!","time":"2018-06-08T17:06:49Z","x":8}
Step #3 - "tests": {"i":2,"level":"info","msg":"allocating!","time":"2018-06-08T17:06:49Z","x":8}
Step #3 - "tests": {"i":1,"level":"info","msg":"allocating!","time":"2018-06-08T17:06:49Z","x":9}
Step #3 - "tests": {"i":2,"level":"info","msg":"allocating!","time":"2018-06-08T17:06:49Z","x":9}
Step #3 - "tests": {"i":0,"level":"info","msg":"allocating!","time":"2018-06-08T17:06:49Z","x":6}
Step #3 - "tests": {"i":0,"level":"info","msg":"allocating!","time":"2018-06-08T17:06:49Z","x":7}
Step #3 - "tests": {"i":0,"level":"info","msg":"allocating!","time":"2018-06-08T17:06:49Z","x":8}
Step #3 - "tests": {"i":0,"level":"info","msg":"allocating!","time":"2018-06-08T17:06:49Z","x":9}
Step #3 - "tests": {"level":"info","maxPort":20,"minPort":10,"msg":"Starting","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:49Z"}
Step #3 - "tests": {"level":"info","msg":"Wait for cache sync","time":"2018-06-08T17:06:49Z"}
Step #3 - "tests": {"level":"info","msg":"Running","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:49Z"}
Step #3 - "tests": {"level":"info","msg":"Adding Node to port allocations","node":"node1","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:49Z"}
Step #3 - "tests": {"level":"info","msg":"Adding Node to port allocations","node":"node2","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:49Z"}
Step #3 - "tests": {"level":"info","msg":"Resetting Port Allocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:49Z"}
Step #3 - "tests": {"level":"info","msg":"adding n3","time":"2018-06-08T17:06:49Z"}
Step #3 - "tests": {"level":"info","msg":"Adding Node to port allocations","node":"node3","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:49Z"}
Step #3 - "tests": {"level":"info","msg":"unscheduling n3","time":"2018-06-08T17:06:49Z"}
Step #3 - "tests": {"level":"info","msg":"Resetting Port Allocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:49Z"}
Step #3 - "tests": {"level":"info","msg":"scheduling n3","time":"2018-06-08T17:06:49Z"}
Step #3 - "tests": {"level":"info","msg":"Resetting Port Allocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:49Z"}
Step #3 - "tests": {"level":"info","msg":"deleting n3","time":"2018-06-08T17:06:49Z"}
Step #3 - "tests": {"level":"info","msg":"Resetting Port Allocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:49Z"}
Step #3 - "tests": {"gameServerName":"test","level":"info","msg":"created GameServer sidecar","namespace":"default","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:49Z"}
Step #3 - "tests": {"level":"info","msg":"Starting SDKServer http health check...","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:49Z"}
Step #3 - "tests": {"level":"info","msg":"Starting GameServer health checking","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:49Z"}
Step #3 - "tests": {"level":"info","msg":"Starting workers...","queue":"stable.agones.dev.default.test","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:49Z","workers":1}
Step #3 - "tests": {"failureCount":1,"level":"info","msg":"GameServer Health Check failed","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:50Z"}
Step #3 - "tests": {"gameServerName":"test","level":"info","msg":"being marked as not healthy","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:50Z"}
Step #3 - "tests": {"key":"Unhealthy","level":"info","msg":"Enqueuing key","queue":"stable.agones.dev.default.test","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:50Z"}
Step #3 - "tests": {"level":"info","msg":"Processing obj","obj":"Unhealthy","queue":"stable.agones.dev.default.test","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:50Z"}
Step #3 - "tests": {"level":"info","msg":"Updating state","source":"*gameservers.SDKServer","state":"Unhealthy","time":"2018-06-08T17:06:50Z"}
Step #3 - "tests": {"level":"info","msg":"...shutting down workers","queue":"stable.agones.dev.default.test","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:51Z"}
Step #3 - "tests": {"error":"http: Server closed","level":"info","msg":"health check: http server closed","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:51Z"}
Step #3 - "tests": {"gameServerName":"test","level":"info","msg":"created GameServer sidecar","namespace":"default","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:51Z"}
Step #3 - "tests": {"level":"info","msg":"Received Ready request, adding to queue","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:51Z"}
Step #3 - "tests": {"key":"RequestReady","level":"info","msg":"Enqueuing key","queue":"stable.agones.dev.default.test","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:51Z"}
Step #3 - "tests": {"level":"info","msg":"Starting SDKServer http health check...","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:51Z"}
Step #3 - "tests": {"level":"info","msg":"Starting GameServer health checking","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:51Z"}
Step #3 - "tests": {"level":"info","msg":"Starting workers...","queue":"stable.agones.dev.default.test","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:51Z","workers":1}
Step #3 - "tests": {"level":"info","msg":"Processing obj","obj":"RequestReady","queue":"stable.agones.dev.default.test","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:51Z"}
Step #3 - "tests": {"level":"info","msg":"Updating state","source":"*gameservers.SDKServer","state":"RequestReady","time":"2018-06-08T17:06:51Z"}
Step #3 - "tests": {"level":"info","msg":"...shutting down workers","queue":"stable.agones.dev.default.test","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:51Z"}
Step #3 - "tests": {"error":"http: Server closed","level":"info","msg":"health check: http server closed","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:51Z"}
Step #3 - "tests": {"gameServerName":"test","level":"info","msg":"created GameServer sidecar","namespace":"default","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:51Z"}
Step #3 - "tests": {"level":"info","msg":"Received Shutdown request, adding to queue","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:51Z"}
Step #3 - "tests": {"key":"Shutdown","level":"info","msg":"Enqueuing key","queue":"stable.agones.dev.default.test","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:51Z"}
Step #3 - "tests": {"level":"info","msg":"Starting SDKServer http health check...","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:51Z"}
Step #3 - "tests": {"level":"info","msg":"Starting GameServer health checking","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:51Z"}
Step #3 - "tests": {"level":"info","msg":"Starting workers...","queue":"stable.agones.dev.default.test","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:51Z","workers":1}
Step #3 - "tests": {"level":"info","msg":"Processing obj","obj":"Shutdown","queue":"stable.agones.dev.default.test","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:51Z"}
Step #3 - "tests": {"level":"info","msg":"Updating state","source":"*gameservers.SDKServer","state":"Shutdown","time":"2018-06-08T17:06:51Z"}
Step #3 - "tests": {"level":"info","msg":"...shutting down workers","queue":"stable.agones.dev.default.test","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:51Z"}
Step #3 - "tests": {"gameServerName":"test","level":"info","msg":"created GameServer sidecar","namespace":"default","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:51Z"}
Step #3 - "tests": {"level":"info","msg":"Starting SDKServer http health check...","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:51Z"}
Step #3 - "tests": {"level":"info","msg":"Starting GameServer health checking","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:51Z"}
Step #3 - "tests": {"level":"info","msg":"Starting workers...","queue":"stable.agones.dev.default.test","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:51Z","workers":1}
Step #3 - "tests": {"error":"Could not listen on :8080: listen tcp :8080: bind: address already in use","level":"error","msg":"","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:51Z"}
Step #3 - "tests": {"level":"error","msg":"Could not listen on :8080: listen tcp :8080: bind: address already in use","stack":["agones.dev/agones/pkg/gameservers.(*SDKServer).Run.func1\n\t/go/src/agones.dev/agones/pkg/gameservers/sdkserver.go:144","runtime.goexit\n\t/usr/local/go/src/runtime/asm_amd64.s:2361"],"time":"2018-06-08T17:06:51Z"}
Step #3 - "tests": {"error":"http: Server closed","level":"info","msg":"health check: http server closed","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:51Z"}
Step #3 - "tests": {"failureCount":1,"level":"info","msg":"GameServer Health Check failed","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:52Z"}
Step #3 - "tests": {"gameServerName":"test","level":"info","msg":"being marked as not healthy","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:52Z"}
Step #3 - "tests": {"key":"Unhealthy","level":"info","msg":"Enqueuing key","queue":"stable.agones.dev.default.test","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:52Z"}
Step #3 - "tests": {"level":"info","msg":"Processing obj","obj":"Unhealthy","queue":"stable.agones.dev.default.test","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:52Z"}
Step #3 - "tests": {"level":"info","msg":"Updating state","source":"*gameservers.SDKServer","state":"Unhealthy","time":"2018-06-08T17:06:52Z"}
Step #3 - "tests": E0608 17:06:52.954844    4276 event.go:260] Could not construct reference to: '&v1alpha1.GameServer{TypeMeta:v1.TypeMeta{Kind:"", APIVersion:""}, ObjectMeta:v1.ObjectMeta{Name:"", GenerateName:"", Namespace:"", SelfLink:"", UID:"", ResourceVersion:"", Generation:0, CreationTimestamp:v1.Time{Time:time.Time{wall:0x0, ext:0, loc:(*time.Location)(nil)}}, DeletionTimestamp:(*v1.Time)(nil), DeletionGracePeriodSeconds:(*int64)(nil), Labels:map[string]string(nil), Annotations:map[string]string(nil), OwnerReferences:[]v1.OwnerReference(nil), Initializers:(*v1.Initializers)(nil), Finalizers:[]string(nil), ClusterName:""}, Spec:v1alpha1.GameServerSpec{Container:"", PortPolicy:"", ContainerPort:0, HostPort:0, Protocol:"", Health:v1alpha1.Health{Disabled:false, PeriodSeconds:0, FailureThreshold:0, InitialDelaySeconds:0}, Template:v1.PodTemplateSpec{ObjectMeta:v1.ObjectMeta{Name:"", GenerateName:"", Namespace:"", SelfLink:"", UID:"", ResourceVersion:"", Generation:0, CreationTimestamp:v1.Time{Time:time.Time{wall:0x0, ext:0, loc:(*time.Location)(nil)}}, DeletionTimestamp:(*v1.Time)(nil), DeletionGracePeriodSeconds:(*int64)(nil), Labels:map[string]string(nil), Annotations:map[string]string(nil), OwnerReferences:[]v1.OwnerReference(nil), Initializers:(*v1.Initializers)(nil), Finalizers:[]string(nil), ClusterName:""}, Spec:v1.PodSpec{Volumes:[]v1.Volume(nil), InitContainers:[]v1.Container(nil), Containers:[]v1.Container(nil), RestartPolicy:"", TerminationGracePeriodSeconds:(*int64)(nil), ActiveDeadlineSeconds:(*int64)(nil), DNSPolicy:"", NodeSelector:map[string]string(nil), ServiceAccountName:"", DeprecatedServiceAccount:"", AutomountServiceAccountToken:(*bool)(nil), NodeName:"", HostNetwork:false, HostPID:false, HostIPC:false, SecurityContext:(*v1.PodSecurityContext)(nil), ImagePullSecrets:[]v1.LocalObjectReference(nil), Hostname:"", Subdomain:"", Affinity:(*v1.Affinity)(nil), SchedulerName:"", Tolerations:[]v1.Toleration(nil), HostAliases:[]v1.HostAlias(nil), PriorityClassName:"", Priority:(*int32)(nil), DNSConfig:(*v1.PodDNSConfig)(nil)}}}, Status:v1alpha1.GameServerStatus{State:"Unhealthy", Port:0, Address:"", NodeName:""}}' due to: 'selfLink was empty, can't make reference'. Will not report event: 'Warning' 'Unhealthy' 'No longer healthy'
Step #3 - "tests": {"failureCount":2,"level":"info","msg":"GameServer Health Check failed","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:53Z"}
Step #3 - "tests": {"gameServerName":"test","level":"info","msg":"being marked as not healthy","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:53Z"}
Step #3 - "tests": {"key":"Unhealthy","level":"info","msg":"Enqueuing key","queue":"stable.agones.dev.default.test","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:53Z"}
Step #3 - "tests": {"level":"info","msg":"Processing obj","obj":"Unhealthy","queue":"stable.agones.dev.default.test","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:53Z"}
Step #3 - "tests": {"level":"info","msg":"Updating state","source":"*gameservers.SDKServer","state":"Unhealthy","time":"2018-06-08T17:06:53Z"}
Step #3 - "tests": E0608 17:06:53.955257    4276 event.go:260] Could not construct reference to: '&v1alpha1.GameServer{TypeMeta:v1.TypeMeta{Kind:"", APIVersion:""}, ObjectMeta:v1.ObjectMeta{Name:"", GenerateName:"", Namespace:"", SelfLink:"", UID:"", ResourceVersion:"", Generation:0, CreationTimestamp:v1.Time{Time:time.Time{wall:0x0, ext:0, loc:(*time.Location)(nil)}}, DeletionTimestamp:(*v1.Time)(nil), DeletionGracePeriodSeconds:(*int64)(nil), Labels:map[string]string(nil), Annotations:map[string]string(nil), OwnerReferences:[]v1.OwnerReference(nil), Initializers:(*v1.Initializers)(nil), Finalizers:[]string(nil), ClusterName:""}, Spec:v1alpha1.GameServerSpec{Container:"", PortPolicy:"", ContainerPort:0, HostPort:0, Protocol:"", Health:v1alpha1.Health{Disabled:false, PeriodSeconds:0, FailureThreshold:0, InitialDelaySeconds:0}, Template:v1.PodTemplateSpec{ObjectMeta:v1.ObjectMeta{Name:"", GenerateName:"", Namespace:"", SelfLink:"", UID:"", ResourceVersion:"", Generation:0, CreationTimestamp:v1.Time{Time:time.Time{wall:0x0, ext:0, loc:(*time.Location)(nil)}}, DeletionTimestamp:(*v1.Time)(nil), DeletionGracePeriodSeconds:(*int64)(nil), Labels:map[string]string(nil), Annotations:map[string]string(nil), OwnerReferences:[]v1.OwnerReference(nil), Initializers:(*v1.Initializers)(nil), Finalizers:[]string(nil), ClusterName:""}, Spec:v1.PodSpec{Volumes:[]v1.Volume(nil), InitContainers:[]v1.Container(nil), Containers:[]v1.Container(nil), RestartPolicy:"", TerminationGracePeriodSeconds:(*int64)(nil), ActiveDeadlineSeconds:(*int64)(nil), DNSPolicy:"", NodeSelector:map[string]string(nil), ServiceAccountName:"", DeprecatedServiceAccount:"", AutomountServiceAccountToken:(*bool)(nil), NodeName:"", HostNetwork:false, HostPID:false, HostIPC:false, SecurityContext:(*v1.PodSecurityContext)(nil), ImagePullSecrets:[]v1.LocalObjectReference(nil), Hostname:"", Subdomain:"", Affinity:(*v1.Affinity)(nil), SchedulerName:"", Tolerations:[]v1.Toleration(nil), HostAliases:[]v1.HostAlias(nil), PriorityClassName:"", Priority:(*int32)(nil), DNSConfig:(*v1.PodDNSConfig)(nil)}}}, Status:v1alpha1.GameServerStatus{State:"Unhealthy", Port:0, Address:"", NodeName:""}}' due to: 'selfLink was empty, can't make reference'. Will not report event: 'Warning' 'Unhealthy' 'No longer healthy'
Step #3 - "tests": --- FAIL: TestSidecarHTTPHealthCheck (2.01s)
Step #3 - "tests": 	assertions.go:229: 
                        
	Error Trace:	helper_test.go:106
Step #3 - "tests": 		
			wait.go:245
Step #3 - "tests": 		
			wait.go:241
Step #3 - "tests": 		
			helper_test.go:94
Step #3 - "tests": 		
			sdkserver_test.go:308
Step #3 - "tests": 		
	Error:		Not equal: 500 (expected)
Step #3 - "tests": 			        != 200 (actual)
Step #3 - "tests": 		
	Messages:	url: http://localhost:8080/gshealthz
Step #3 - "tests": 		
Step #3 - "tests": 	assertions.go:229: 
                        
	Error Trace:	helper_test.go:107
Step #3 - "tests": 		
			wait.go:245
Step #3 - "tests": 		
			wait.go:241
Step #3 - "tests": 		
			helper_test.go:94
Step #3 - "tests": 		
			sdkserver_test.go:308
Step #3 - "tests": 		
	Error:		Not equal: []byte{} (expected)
Step #3 - "tests": 			        != []byte{0x6f, 0x6b} (actual)
Step #3 - "tests": 			
Step #3 - "tests": 			Diff:
Step #3 - "tests": 			--- Expected
Step #3 - "tests": 			+++ Actual
Step #3 - "tests": 			@@ -1,2 +1,3 @@
Step #3 - "tests": 			-([]uint8) {
Step #3 - "tests": 			+([]uint8) (len=2 cap=512) {
Step #3 - "tests": 			+ 00000000  6f 6b                                             |ok|
Step #3 - "tests": 			 }
Step #3 - "tests": 		
	Messages:	(http://localhost:8080/gshealthz) response body should be ''
Step #3 - "tests": 		
Step #3 - "tests": {"level":"info","msg":"...shutting down workers","queue":"stable.agones.dev.default.test","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:53Z"}
Step #3 - "tests": {"level":"info","maxPort":20,"minPort":10,"msg":"Starting","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:53Z"}
Step #3 - "tests": {"level":"info","maxPort":20,"minPort":10,"msg":"Starting","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:53Z"}
Step #3 - "tests": {"level":"info","maxPort":20,"minPort":10,"msg":"Starting","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:53Z"}
Step #3 - "tests": {"level":"info","maxPort":20,"minPort":10,"msg":"Starting","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:53Z"}
Step #3 - "tests": {"level":"info","maxPort":20,"minPort":10,"msg":"Starting","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:53Z"}
Step #3 - "tests": {"gameServerName":"test","level":"info","msg":"created GameServer sidecar","namespace":"default","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:53Z"}
Step #3 - "tests": {"level":"info","msg":"Wait for cache sync","time":"2018-06-08T17:06:53Z"}
Step #3 - "tests": {"level":"info","maxPort":20,"minPort":10,"msg":"Starting","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:53Z"}
Step #3 - "tests": {"level":"info","msg":"Test Running","test":"enabled, over timeout","time":"2018-06-08T17:06:53Z"}
Step #3 - "tests": {"level":"info","msg":"Health Ping Received","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:53Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/mutate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:53Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/validate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:53Z"}
Step #3 - "tests": {"level":"info","msg":"Wait for cache sync","time":"2018-06-08T17:06:53Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/mutate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:53Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/validate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:53Z"}
Step #3 - "tests": {"level":"info","msg":"Wait for cache sync","time":"2018-06-08T17:06:53Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/mutate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:53Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/validate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:53Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/mutate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:53Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/validate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:53Z"}
Step #3 - "tests": {"level":"info","msg":"creationMutationHandler","review":{"request":{"uid":"","kind":{"group":"stable.agones.dev","version":"v1alpha1","kind":"GameServer"},"resource":{"group":"","version":"","resource":""},"operation":"CREATE","userInfo":{},"object":{"metadata":{"name":"test","namespace":"default","creationTimestamp":null},"spec":{"portPolicy":"static","containerPort":7777,"hostPort":9999,"health":{},"template":{"metadata":{"creationTimestamp":null},"spec":{"containers":[{"name":"container","image":"container/image","resources":{}}]}}},"status":{"state":"","port":0,"address":"","nodeName":""}},"oldObject":null},"response":{"uid":"","allowed":true}},"source":"*gameservers.Controller","time":"2018-06-08T17:06:53Z"}
Step #3 - "tests": {"level":"info","msg":"creationValidationHandler","review":{"request":{"uid":"","kind":{"group":"stable.agones.dev","version":"v1alpha1","kind":"GameServer"},"resource":{"group":"","version":"","resource":""},"operation":"CREATE","userInfo":{},"object":{"metadata":{"name":"test","namespace":"default","creationTimestamp":null,"finalizers":["stable.agones.dev"]},"spec":{"container":"container","portPolicy":"static","containerPort":7777,"hostPort":9999,"protocol":"UDP","health":{"periodSeconds":5,"failureThreshold":3,"initialDelaySeconds":5},"template":{"metadata":{"creationTimestamp":null},"spec":{"containers":[{"name":"container","image":"container/image","resources":{}}]}}},"status":{"state":"Creating","port":0,"address":"","nodeName":""}},"oldObject":null},"response":{"uid":"","allowed":true}},"source":"*gameservers.Controller","time":"2018-06-08T17:06:53Z"}
Step #3 - "tests": {"level":"info","msg":"Wait for cache sync","time":"2018-06-08T17:06:53Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/mutate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:53Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/validate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:53Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/vendor/k8s.io/client-go/informers/factory.go:86: Failed to watch *v1.Pod: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"\", Version:\"v1\", Resource:\"pods\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"test","level":"info","msg":"patch created!","patch":"[{\"op\":\"add\",\"path\":\"/spec/protocol\",\"value\":\"UDP\"},{\"op\":\"add\",\"path\":\"/spec/health/periodSeconds\",\"value\":5},{\"op\":\"add\",\"path\":\"/spec/health/failureThreshold\",\"value\":3},{\"op\":\"add\",\"path\":\"/spec/health/initialDelaySeconds\",\"value\":5},{\"op\":\"add\",\"path\":\"/spec/container\",\"value\":\"container\"},{\"op\":\"replace\",\"path\":\"/status/state\",\"value\":\"Creating\"},{\"op\":\"add\",\"path\":\"/metadata/finalizers\",\"value\":[\"stable.agones.dev\"]}]","source":"*gameservers.Controller","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Wait for cache sync","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/pkg/client/informers/externalversions/factory.go:74: Failed to watch *v1alpha1.GameServer: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"stable.agones.dev\", Version:\"v1alpha1\", Resource:\"gameservers\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/pkg/client/informers/externalversions/factory.go:74: Failed to watch *v1alpha1.GameServer: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"stable.agones.dev\", Version:\"v1alpha1\", Resource:\"gameservers\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/pkg/client/informers/externalversions/factory.go:74: Failed to watch *v1alpha1.GameServer: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"stable.agones.dev\", Version:\"v1alpha1\", Resource:\"gameservers\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gameServerName":"test","level":"info","msg":"created GameServer sidecar","namespace":"default","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Health Ping Received","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"creationValidationHandler","review":{"request":{"uid":"","kind":{"group":"stable.agones.dev","version":"v1alpha1","kind":"GameServer"},"resource":{"group":"","version":"","resource":""},"operation":"CREATE","userInfo":{},"object":{"metadata":{"name":"test","namespace":"default","creationTimestamp":null},"spec":{"container":"NOPE!","containerPort":7777,"health":{},"template":{"metadata":{"creationTimestamp":null},"spec":{"containers":[{"name":"container","image":"container/image","resources":{}},{"name":"container2","image":"container/image","resources":{}}]}}},"status":{"state":"","port":0,"address":"","nodeName":""}},"oldObject":null},"response":{"uid":"","allowed":true}},"source":"*gameservers.Controller","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Health Ping Received","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Invalid GameServer","review":{"request":{"uid":"","kind":{"group":"stable.agones.dev","version":"v1alpha1","kind":"GameServer"},"resource":{"group":"","version":"","resource":""},"operation":"CREATE","userInfo":{},"object":{"metadata":{"name":"test","namespace":"default","creationTimestamp":null},"spec":{"container":"NOPE!","containerPort":7777,"health":{},"template":{"metadata":{"creationTimestamp":null},"spec":{"containers":[{"name":"container","image":"container/image","resources":{}},{"name":"container2","image":"container/image","resources":{}}]}}},"status":{"state":"","port":0,"address":"","nodeName":""}},"oldObject":null},"response":{"uid":"","allowed":false,"status":{"metadata":{},"status":"Failure","message":"GameServer configuration is invalid","reason":"Invalid","details":{"group":"stable.agones.dev","kind":"GameServer","causes":[{"reason":"FieldValueInvalid","message":"Could not find a container named NOPE!","field":"container"}]}}}},"source":"*gameservers.Controller","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/vendor/k8s.io/client-go/informers/factory.go:86: Failed to watch *v1.Pod: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"\", Version:\"v1\", Resource:\"pods\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/vendor/k8s.io/client-go/informers/factory.go:86: Failed to watch *v1.Pod: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"\", Version:\"v1\", Resource:\"pods\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"key":"default/test","level":"info","msg":"Enqueuing key","queue":"stable.agones.dev.GameServerController","source":"*gameservers.Controller","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/pkg/client/informers/externalversions/factory.go:74: Failed to watch *v1alpha1.GameServer: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"stable.agones.dev\", Version:\"v1alpha1\", Resource:\"gameservers\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Adding Node to port allocations","node":"node1","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Adding Node to port allocations","node":"node1","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gameServerName":"test","level":"info","msg":"created GameServer sidecar","namespace":"default","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/vendor/k8s.io/client-go/informers/factory.go:86: Failed to watch *v1.Node: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"\", Version:\"v1\", Resource:\"nodes\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Updating state","source":"*gameservers.SDKServer","state":"Ready","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"State already unhealthy. Skipping update.","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/vendor/k8s.io/client-go/informers/factory.go:86: Failed to watch *v1.Node: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"\", Version:\"v1\", Resource:\"nodes\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","maxPort":20,"minPort":10,"msg":"Starting","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Wait for cache sync","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/pkg/client/informers/externalversions/factory.go:74: Failed to watch *v1alpha1.GameServer: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"stable.agones.dev\", Version:\"v1alpha1\", Resource:\"gameservers\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/vendor/k8s.io/client-go/informers/factory.go:86: Failed to watch *v1.Node: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"\", Version:\"v1\", Resource:\"nodes\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/vendor/k8s.io/client-go/informers/factory.go:86: Failed to watch *v1.Node: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"\", Version:\"v1\", Resource:\"nodes\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Adding Node to port allocations","node":"node1","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Adding Node to port allocations","node":"node2","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Adding Node to port allocations","node":"node3","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/pkg/client/informers/externalversions/factory.go:74: Failed to watch *v1alpha1.GameServer: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"stable.agones.dev\", Version:\"v1alpha1\", Resource:\"gameservers\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"key":"default/test","level":"info","msg":"Synchronising","source":"*gameservers.HealthController","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Wait for cache sync","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/vendor/k8s.io/client-go/informers/factory.go:86: Failed to watch *v1.Pod: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"\", Version:\"v1\", Resource:\"pods\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/pkg/client/informers/externalversions/factory.go:74: Failed to watch *v1alpha1.GameServer: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"stable.agones.dev\", Version:\"v1alpha1\", Resource:\"gameservers\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Running","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Adding Node to port allocations","node":"node1","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Adding Node to port allocations","node":"node2","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Running","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","maxPort":20,"minPort":10,"msg":"Starting","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/mutate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/validate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Wait for cache sync","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Adding Node to port allocations","node":"node1","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/vendor/k8s.io/client-go/informers/factory.go:86: Failed to watch *v1.Pod: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"\", Version:\"v1\", Resource:\"pods\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/vendor/k8s.io/client-go/informers/factory.go:86: Failed to watch *v1.Node: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"\", Version:\"v1\", Resource:\"nodes\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/pkg/client/informers/externalversions/factory.go:74: Failed to watch *v1alpha1.GameServer: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"stable.agones.dev\", Version:\"v1alpha1\", Resource:\"gameservers\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Running","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"key":"default/test","level":"info","msg":"Synchronising","source":"*gameservers.HealthController","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":{"metadata":{"name":"test","namespace":"default","creationTimestamp":null,"finalizers":["stable.agones.dev"]},"spec":{"container":"container","portPolicy":"static","containerPort":7777,"hostPort":9999,"protocol":"UDP","health":{"periodSeconds":5,"failureThreshold":3,"initialDelaySeconds":5},"template":{"metadata":{"creationTimestamp":null},"spec":{"containers":[{"name":"container","image":"container/image","resources":{}}]}}},"status":{"state":"Ready","port":0,"address":"","nodeName":""}},"level":"info","msg":"Marking GameServer as Unhealthy","source":"*gameservers.HealthController","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": E0608 17:06:54.182699    4276 event.go:260] Could not construct reference to: '&v1alpha1.GameServer{TypeMeta:v1.TypeMeta{Kind:"", APIVersion:""}, ObjectMeta:v1.ObjectMeta{Name:"test", GenerateName:"", Namespace:"default", SelfLink:"", UID:"", ResourceVersion:"", Generation:0, CreationTimestamp:v1.Time{Time:time.Time{wall:0x0, ext:0, loc:(*time.Location)(nil)}}, DeletionTimestamp:(*v1.Time)(nil), DeletionGracePeriodSeconds:(*int64)(nil), Labels:map[string]string(nil), Annotations:map[string]string(nil), OwnerReferences:[]v1.OwnerReference(nil), Initializers:(*v1.Initializers)(nil), Finalizers:[]string{"stable.agones.dev"}, ClusterName:""}, Spec:v1alpha1.GameServerSpec{Container:"container", PortPolicy:"static", ContainerPort:7777, HostPort:9999, Protocol:"UDP", Health:v1alpha1.Health{Disabled:false, PeriodSeconds:5, FailureThreshold:3, InitialDelaySeconds:5}, Template:v1.PodTemplateSpec{ObjectMeta:v1.ObjectMeta{Name:"", GenerateName:"", Namespace:"", SelfLink:"", UID:"", ResourceVersion:"", Generation:0, CreationTimestamp:v1.Time{Time:time.Time{wall:0x0, ext:0, loc:(*time.Location)(nil)}}, DeletionTimestamp:(*v1.Time)(nil), DeletionGracePeriodSeconds:(*int64)(nil), Labels:map[string]string(nil), Annotations:map[string]string(nil), OwnerReferences:[]v1.OwnerReference(nil), Initializers:(*v1.Initializers)(nil), Finalizers:[]string(nil), ClusterName:""}, Spec:v1.PodSpec{Volumes:[]v1.Volume(nil), InitContainers:[]v1.Container(nil), Containers:[]v1.Container{v1.Container{Name:"container", Image:"container/image", Command:[]string(nil), Args:[]string(nil), WorkingDir:"", Ports:[]v1.ContainerPort(nil), EnvFrom:[]v1.EnvFromSource(nil), Env:[]v1.EnvVar(nil), Resources:v1.ResourceRequirements{Limits:v1.ResourceList(nil), Requests:v1.ResourceList(nil)}, VolumeMounts:[]v1.VolumeMount(nil), VolumeDevices:[]v1.VolumeDevice(nil), LivenessProbe:(*v1.Probe)(nil), ReadinessProbe:(*v1.Probe)(nil), Lifecycle:(*v1.Lifecycle)(nil), TerminationMessagePath:"", TerminationMessagePolicy:"", ImagePullPolicy:"", SecurityContext:(*v1.SecurityContext)(nil), Stdin:false, StdinOnce:false, TTY:false}}, RestartPolicy:"", TerminationGracePeriodSeconds:(*int64)(nil), ActiveDeadlineSeconds:(*int64)(nil), DNSPolicy:"", NodeSelector:map[string]string(nil), ServiceAccountName:"", DeprecatedServiceAccount:"", AutomountServiceAccountToken:(*bool)(nil), NodeName:"", HostNetwork:false, HostPID:false, HostIPC:false, SecurityContext:(*v1.PodSecurityContext)(nil), ImagePullSecrets:[]v1.LocalObjectReference(nil), Hostname:"", Subdomain:"", Affinity:(*v1.Affinity)(nil), SchedulerName:"", Tolerations:[]v1.Toleration(nil), HostAliases:[]v1.HostAlias(nil), PriorityClassName:"", Priority:(*int32)(nil), DNSConfig:(*v1.PodDNSConfig)(nil)}}}, Status:v1alpha1.GameServerStatus{State:"Ready", Port:0, Address:"", NodeName:""}}' due to: 'selfLink was empty, can't make reference'. Will not report event: 'Warning' 'Unhealthy' 'GameServer container terminated'
Step #3 - "tests": {"level":"info","maxPort":20,"minPort":10,"msg":"Starting","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Wait for cache sync","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Resetting Port Allocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/vendor/k8s.io/client-go/informers/factory.go:86: Failed to watch *v1.Node: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"\", Version:\"v1\", Resource:\"nodes\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","maxPort":20,"minPort":10,"msg":"Starting","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Adding Node to port allocations","node":"node1","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Adding Node to port allocations","node":"node2","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Wait for cache sync","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Adding Node to port allocations","node":"node3","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/vendor/k8s.io/client-go/informers/factory.go:86: Failed to watch *v1.Node: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"\", Version:\"v1\", Resource:\"nodes\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/pkg/client/informers/externalversions/factory.go:74: Failed to watch *v1alpha1.GameServer: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"stable.agones.dev\", Version:\"v1alpha1\", Resource:\"gameservers\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Adding Node to port allocations","node":"node1","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Resetting Port Allocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"key":"default/test","level":"info","msg":"Synchronising","source":"*gameservers.Controller","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":{"metadata":{"name":"test","namespace":"default","creationTimestamp":null,"finalizers":["stable.agones.dev"]},"spec":{"container":"container","portPolicy":"dynamic","containerPort":7777,"hostPort":12,"protocol":"UDP","health":{"periodSeconds":5,"failureThreshold":3,"initialDelaySeconds":5},"template":{"metadata":{"creationTimestamp":null},"spec":{"containers":[{"name":"container","image":"container/image","resources":{}}]}}},"status":{"state":"Creating","port":0,"address":"","nodeName":""}},"level":"info","msg":"Syncing Port Allocation State","source":"*gameservers.Controller","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":{"metadata":{"name":"test","namespace":"default","creationTimestamp":null,"finalizers":["stable.agones.dev"]},"spec":{"container":"container","portPolicy":"dynamic","containerPort":7777,"hostPort":12,"protocol":"UDP","health":{"periodSeconds":5,"failureThreshold":3,"initialDelaySeconds":5},"template":{"metadata":{"creationTimestamp":null},"spec":{"containers":[{"name":"container","image":"container/image","resources":{}}]}}},"status":{"state":"Creating","port":0,"address":"","nodeName":""}},"level":"info","msg":"Syncing Create State","source":"*gameservers.Controller","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"creating Pod for GameServer","pod":{"metadata":{"generateName":"test-","namespace":"default","creationTimestamp":null,"labels":{"stable.agones.dev/gameserver":"test","stable.agones.dev/role":"gameserver"},"annotations":{"stable.agones.dev/container":"container"},"ownerReferences":[{"apiVersion":"stable.agones.dev/v1alpha1","kind":"GameServer","name":"test","uid":"","controller":true,"blockOwnerDeletion":true}]},"spec":{"containers":[{"name":"container","image":"container/image","ports":[{"hostPort":12,"containerPort":7777,"protocol":"UDP"}],"resources":{},"livenessProbe":{"httpGet":{"path":"/gshealthz","port":8080},"initialDelaySeconds":5,"periodSeconds":5,"failureThreshold":3}},{"name":"agones-gameserver-sidecar","image":"sidecar:dev","env":[{"name":"GAMESERVER_NAME","value":"test"},{"name":"POD_NAMESPACE","valueFrom":{"fieldRef":{"fieldPath":"metadata.namespace"}}}],"resources":{},"livenessProbe":{"httpGet":{"path":"/healthz","port":8080},"initialDelaySeconds":3,"periodSeconds":3}}],"serviceAccountName":"agones-sdk"},"status":{}},"source":"*gameservers.Controller","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","maxPort":20,"minPort":10,"msg":"Starting","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"warning","msg":"Could not find ExternalIP. Falling back to Internal","node":"node1","source":"*gameservers.Controller","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","maxPort":20,"minPort":10,"msg":"Starting","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/mutate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/validate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Wait for cache sync","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/mutate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/validate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/vendor/k8s.io/client-go/informers/factory.go:86: Failed to watch *v1.Pod: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"\", Version:\"v1\", Resource:\"pods\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Wait for cache sync","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Adding Node to port allocations","node":"node1","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/vendor/k8s.io/client-go/informers/factory.go:86: Failed to watch *v1.Node: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"\", Version:\"v1\", Resource:\"nodes\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/vendor/k8s.io/client-go/informers/factory.go:86: Failed to watch *v1.Pod: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"\", Version:\"v1\", Resource:\"pods\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/vendor/k8s.io/client-go/informers/factory.go:86: Failed to watch *v1.Node: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"\", Version:\"v1\", Resource:\"nodes\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/pkg/client/informers/externalversions/factory.go:74: Failed to watch *v1alpha1.GameServer: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"stable.agones.dev\", Version:\"v1alpha1\", Resource:\"gameservers\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Resetting Port Allocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","maxPort":20,"minPort":10,"msg":"Starting","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/mutate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/validate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","maxPort":20,"minPort":10,"msg":"Starting","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/mutate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/validate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","maxPort":20,"minPort":10,"msg":"Starting","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/mutate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/validate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Wait for cache sync","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/vendor/k8s.io/client-go/informers/factory.go:86: Failed to watch *v1.Pod: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"\", Version:\"v1\", Resource:\"pods\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/pkg/client/informers/externalversions/factory.go:74: Failed to watch *v1alpha1.GameServer: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"stable.agones.dev\", Version:\"v1alpha1\", Resource:\"gameservers\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/vendor/k8s.io/client-go/informers/factory.go:86: Failed to watch *v1.Node: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"\", Version:\"v1\", Resource:\"nodes\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Running","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Running","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","maxPort":20,"minPort":10,"msg":"Starting","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/mutate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/validate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Wait for cache sync","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"key":"default/test","level":"info","msg":"Synchronising","source":"*gameservers.Controller","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"key":"default/test","level":"info","msg":"GameServer is no longer available for syncing","source":"*gameservers.Controller","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","maxPort":20,"minPort":10,"msg":"Starting","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/vendor/k8s.io/client-go/informers/factory.go:86: Failed to watch *v1.Pod: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"\", Version:\"v1\", Resource:\"pods\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/vendor/k8s.io/client-go/informers/factory.go:86: Failed to watch *v1.Node: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"\", Version:\"v1\", Resource:\"nodes\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Wait for cache sync","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/pkg/client/informers/externalversions/factory.go:74: Failed to watch *v1alpha1.GameServer: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"stable.agones.dev\", Version:\"v1alpha1\", Resource:\"gameservers\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Adding Node to port allocations","node":"node1","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/vendor/k8s.io/client-go/informers/factory.go:86: Failed to watch *v1.Node: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"\", Version:\"v1\", Resource:\"nodes\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Adding Node to port allocations","node":"node2","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Adding Node to port allocations","node":"node3","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/pkg/client/informers/externalversions/factory.go:74: Failed to watch *v1alpha1.GameServer: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"stable.agones.dev\", Version:\"v1alpha1\", Resource:\"gameservers\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":{"metadata":{"name":"test","namespace":"default","creationTimestamp":null,"deletionTimestamp":"2018-06-08T17:06:54Z","finalizers":["stable.agones.dev"]},"spec":{"container":"container","portPolicy":"static","containerPort":7777,"hostPort":9999,"protocol":"UDP","health":{"periodSeconds":5,"failureThreshold":3,"initialDelaySeconds":5},"template":{"metadata":{"creationTimestamp":null},"spec":{"containers":[{"name":"container","image":"container/image","resources":{}}]}}},"status":{"state":"Creating","port":0,"address":"","nodeName":""}},"level":"info","msg":"Syncing with Deletion Timestamp","source":"*gameservers.Controller","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gsName":"test","level":"info","msg":"Found pods, deleting","pods":[{"metadata":{"name":"test-","generateName":"test-","namespace":"default","creationTimestamp":null,"labels":{"stable.agones.dev/gameserver":"test","stable.agones.dev/role":"gameserver"},"annotations":{"stable.agones.dev/container":"container"},"ownerReferences":[{"apiVersion":"stable.agones.dev/v1alpha1","kind":"GameServer","name":"test","uid":"","controller":true,"blockOwnerDeletion":true}]},"spec":{"containers":[{"name":"container","image":"container/image","ports":[{"hostPort":9999,"containerPort":7777,"protocol":"UDP"}],"resources":{}}],"serviceAccountName":"agones-sdk"},"status":{}}],"source":"*gameservers.Controller","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","maxPort":20,"minPort":10,"msg":"Starting","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/mutate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/validate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Wait for cache sync","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/vendor/k8s.io/client-go/informers/factory.go:86: Failed to watch *v1.Pod: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"\", Version:\"v1\", Resource:\"pods\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/vendor/k8s.io/client-go/informers/factory.go:86: Failed to watch *v1.Node: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"\", Version:\"v1\", Resource:\"nodes\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/pkg/client/informers/externalversions/factory.go:74: Failed to watch *v1alpha1.GameServer: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"stable.agones.dev\", Version:\"v1alpha1\", Resource:\"gameservers\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Resetting Port Allocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":{"metadata":{"name":"gs3","uid":"3","creationTimestamp":null},"spec":{"portPolicy":"dynamic","containerPort":0,"hostPort":10,"health":{},"template":{"metadata":{"creationTimestamp":null},"spec":{"containers":null}}},"status":{"state":"Ready","port":10,"address":"","nodeName":"node2"}},"level":"info","msg":"syncing deleted GameServer","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Resetting Port Allocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","maxPort":20,"minPort":10,"msg":"Starting","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","maxPort":20,"minPort":10,"msg":"Starting","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/mutate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/validate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Wait for cache sync","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":{"metadata":{"name":"test","namespace":"default","creationTimestamp":null,"finalizers":["stable.agones.dev"]},"spec":{"container":"container","portPolicy":"static","containerPort":7777,"hostPort":9999,"protocol":"UDP","health":{"periodSeconds":5,"failureThreshold":3,"initialDelaySeconds":5},"template":{"metadata":{"creationTimestamp":null},"spec":{"containers":[{"name":"container","image":"container/image","resources":{}}]}}},"status":{"state":"Shutdown","port":0,"address":"","nodeName":""}},"level":"info","msg":"Syncing Shutdown State","source":"*gameservers.Controller","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/vendor/k8s.io/client-go/informers/factory.go:86: Failed to watch *v1.Node: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"\", Version:\"v1\", Resource:\"nodes\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","maxPort":20,"minPort":10,"msg":"Starting","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/pkg/client/informers/externalversions/factory.go:74: Failed to watch *v1alpha1.GameServer: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"stable.agones.dev\", Version:\"v1alpha1\", Resource:\"gameservers\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Adding Node to port allocations","node":"node1","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Running","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/mutate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/validate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","maxPort":20,"minPort":10,"msg":"Starting","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/vendor/k8s.io/client-go/informers/factory.go:86: Failed to watch *v1.Pod: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"\", Version:\"v1\", Resource:\"pods\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/mutate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/validate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","maxPort":20,"minPort":10,"msg":"Starting","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/mutate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/validate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Wait for cache sync","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/vendor/k8s.io/client-go/informers/factory.go:86: Failed to watch *v1.Pod: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"\", Version:\"v1\", Resource:\"pods\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/pkg/client/informers/externalversions/factory.go:74: Failed to watch *v1alpha1.GameServer: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"stable.agones.dev\", Version:\"v1alpha1\", Resource:\"gameservers\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"error","msg":"agones.dev/agones/vendor/k8s.io/client-go/informers/factory.go:86: Failed to watch *v1.Node: unhandled watch: testing.WatchActionImpl{ActionImpl:testing.ActionImpl{Namespace:\"\", Verb:\"watch\", Resource:schema.GroupVersionResource{Group:\"\", Version:\"v1\", Resource:\"nodes\"}, Subresource:\"\"}, WatchRestrictions:testing.WatchRestrictions{Labels:labels.internalSelector(nil), Fields:fields.andTerm{}, ResourceVersion:\"\"}}","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Adding Node to port allocations","node":"node1","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":{"metadata":{"name":"test","namespace":"default","creationTimestamp":null,"deletionTimestamp":"2018-06-08T17:06:54Z","finalizers":["stable.agones.dev"]},"spec":{"container":"container","portPolicy":"static","containerPort":7777,"hostPort":9999,"protocol":"UDP","health":{"periodSeconds":5,"failureThreshold":3,"initialDelaySeconds":5},"template":{"metadata":{"creationTimestamp":null},"spec":{"containers":[{"name":"container","image":"container/image","resources":{}}]}}},"status":{"state":"Creating","port":0,"address":"","nodeName":""}},"level":"info","msg":"Syncing with Deletion Timestamp","source":"*gameservers.Controller","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":{"metadata":{"name":"test","namespace":"default","creationTimestamp":null,"deletionTimestamp":"2018-06-08T17:06:54Z"},"spec":{"container":"container","portPolicy":"static","containerPort":7777,"hostPort":9999,"protocol":"UDP","health":{"periodSeconds":5,"failureThreshold":3,"initialDelaySeconds":5},"template":{"metadata":{"creationTimestamp":null},"spec":{"containers":[{"name":"container","image":"container/image","resources":{}}]}}},"status":{"state":"Creating","port":0,"address":"","nodeName":""}},"level":"info","msg":"No pods found, removing finalizer stable.agones.dev","source":"*gameservers.Controller","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":{"metadata":{"name":"test","namespace":"default","creationTimestamp":null,"finalizers":["stable.agones.dev"]},"spec":{"container":"container","portPolicy":"static","containerPort":7777,"hostPort":9999,"protocol":"UDP","health":{"periodSeconds":5,"failureThreshold":3,"initialDelaySeconds":5},"template":{"metadata":{"creationTimestamp":null},"spec":{"containers":[{"name":"container","image":"container/image","resources":{}}]}}},"status":{"state":"RequestReady","port":0,"address":"","nodeName":""}},"level":"info","msg":"Syncing RequestReady State","source":"*gameservers.Controller","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","maxPort":20,"minPort":10,"msg":"Starting","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Resetting Port Allocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/mutate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/validate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","maxPort":20,"minPort":10,"msg":"Starting","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/mutate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/validate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","maxPort":20,"minPort":10,"msg":"Starting","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Running","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/mutate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"groupKind":{"Group":"stable.agones.dev","Kind":"GameServer"},"level":"info","msg":"Added webhook handler","op":"CREATE","path":"/validate","source":"*webhooks.WebHook","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":"no","level":"info","msg":"Did not allocate this GameServer. Ignoring for DeAllocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Resetting Port Allocation","source":"*gameservers.PortAllocator","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"gs":{"metadata":{"name":"test","namespace":"default","creationTimestamp":null,"finalizers":["stable.agones.dev"]},"spec":{"container":"container","portPolicy":"dynamic","containerPort":7777,"hostPort":20,"protocol":"UDP","health":{"periodSeconds":5,"failureThreshold":3,"initialDelaySeconds":5},"template":{"metadata":{"creationTimestamp":null},"spec":{"containers":[{"name":"container","image":"container/image","resources":{}}]}}},"status":{"state":"Creating","port":0,"address":"","nodeName":""}},"level":"info","msg":"Syncing Port Allocation State","source":"*gameservers.Controller","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"failureCount":1,"level":"info","msg":"GameServer Health Check failed","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Test Running","test":"disabled, under timeout","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Health Ping Received","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:54Z"}
Step #3 - "tests": {"level":"info","msg":"Health stream closed.","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:55Z"}
Step #3 - "tests": {"level":"info","msg":"Test Running","test":"disabled, over timeout","time":"2018-06-08T17:06:55Z"}
Step #3 - "tests": {"level":"info","msg":"Health Ping Received","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:55Z"}
Step #3 - "tests": {"failureCount":1,"level":"info","msg":"GameServer Health Check failed","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:56Z"}
Step #3 - "tests": {"level":"info","msg":"Test Running","test":"enabled, under timeout","time":"2018-06-08T17:06:56Z"}
Step #3 - "tests": {"level":"info","msg":"Health Ping Received","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:56Z"}
Step #3 - "tests": {"failureCount":1,"level":"info","msg":"GameServer Health Check failed","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:57Z"}
Step #3 - "tests": {"failureCount":1,"level":"info","msg":"GameServer Health Check failed","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:57Z"}
Step #3 - "tests": {"failureCount":2,"level":"info","msg":"GameServer Health Check failed","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:57Z"}
Step #3 - "tests": {"failureCount":3,"level":"info","msg":"GameServer Health Check failed","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:57Z"}
Step #3 - "tests": {"level":"info","msg":"Health Ping Received","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:57Z"}
Step #3 - "tests": {"level":"info","msg":"Health stream closed.","source":"*gameservers.SDKServer","time":"2018-06-08T17:06:58Z"}
Step #3 - "tests": FAIL
Step #3 - "tests": FAIL	agones.dev/agones/pkg/gameservers	12.246s
Step #3 - "tests": ok  	agones.dev/agones/pkg/gameserversets	3.522s
Step #3 - "tests": ?   	agones.dev/agones/pkg/sdk	[no test files]
Step #3 - "tests": ?   	agones.dev/agones/pkg/testing	[no test files]
Step #3 - "tests": ?   	agones.dev/agones/pkg/util	[no test files]
Step #3 - "tests": ok  	agones.dev/agones/pkg/util/crd	5.655s
Step #3 - "tests": ?   	agones.dev/agones/pkg/util/runtime	[no test files]
Step #3 - "tests": ?   	agones.dev/agones/pkg/util/signals	[no test files]
Step #3 - "tests": ok  	agones.dev/agones/pkg/util/webhooks	2.068s
Step #3 - "tests": ok  	agones.dev/agones/pkg/util/workerqueue	3.654s
Step #3 - "tests": ok  	agones.dev/agones/sdks/go	1.033s
Step #3 - "tests": make: *** [test-go] Error 1
Step #3 - "tests": Makefile:109: recipe for target 'test-go' failed
Finished Step #3 - "tests"
Finished Step #4 - "build"
ERROR
ERROR: build step 3 "make-docker" failed: exit status 2

[agones-bot]

Build Succeeded 👏

Build Id: cbe2f7e1-2706-40f6-8597-50b3755bbd1e

The following development artifacts have been built, and will exist for the next 30 days:

• image: gcr.io/agones-images/agones-controller:0.3.0-1660327
• image: gcr.io/agones-images/agones-sdk:0.3.0-1660327
• Linux C++ SDK (build: dev): agonessdk-0.3.0-1660327-dev-linux-arch_64.tar.gz
• Linux C++ SDK (build: runtime): agonessdk-0.3.0-1660327-runtime-linux-arch_64.tar.gz
• Linux C++ SDK (source): agonessdk-0.3.0-1660327-src.zip
• SDK Server: agonessdk-server-0.3.0-1660327.zip