search

GoogleCloudPlatform / cloud-bigtable-examples

Examples of how to use Cloud Bigtable both with GCE map/reduce as well as stand alone applications.
https://cloud.google.com/bigtable/docs/samples
Apache License 2.0
229 stars 229 forks source link

mvm-gae sample broke #57

Closed lesv closed 9 years ago

lesv commented 9 years ago

http://stackoverflow.com/questions/31591974/cannot-deploy-gae-cloud-bigtable-to-managed-vm

And ... I tried to build and deploy the managed-vm-gae sample for Cloud Bigtable. However, I get an error when I run "gcloud preview app deploy app.yaml":

Traceback (most recent call last): File "/Users/jefesaurus/dev/google-cloud-sdk/./lib/googlecloudsdk/gcloud/gcloud.py", line 194, in main _cli.Execute() File "/Users/jefesaurus/dev/google-cloud-sdk/./lib/googlecloudsdk/calliope/cli.py", line 548, in Execute result = args.cmd_func(cli=self, args=args) File "/Users/jefesaurus/dev/google-cloud-sdk/./lib/googlecloudsdk/calliope/backend.py", line 1124, in Run result = command_instance.Run(args) File "/Users/jefesaurus/dev/google-cloud-sdk/lib/googlecloudsdk/appengine/app_commands/deploy.py", line 192, in Run args.remote) File "/Users/jefesaurus/dev/google-cloud-sdk/./lib/googlecloudsdk/appengine/lib/deploy_command_util.py", line 59, in BuildAndPushDockerImages remote) as docker_client: File "/Users/jefesaurus/dev/google-cloud-sdk/./lib/googlecloudsdk/appengine/lib/images/remote_docker.py", line 208, in enter return containers.NewDockerClient(**kwargs) File "/Users/jefesaurus/dev/google-cloud-sdk/./lib/googlecloudsdk/appengine/lib/docker/containers.py", line 294, in NewDockerClient client.ping() File "/Users/jefesaurus/dev/google-cloud-sdk/./lib/docker/docker/client.py", line 847, in ping return self._result(self._get(self._url('/_ping'))) File "/Users/jefesaurus/dev/google-cloud-sdk/./lib/docker/docker/client.py", line 126, in _result self._raise_for_status(response) File "/Users/jefesaurus/dev/google-cloud-sdk/./lib/docker/docker/client.py", line 122, in _raise_for_status raise errors.APIError(e, response, explanation=explanation)

APIError: 400 Client Error: Bad Request ("client is too old, minimum supported API version is 1.12, please upgrade your client to a newer version")

I already ran "gcloud components update," and everything is up to date. Also, "docker version" reports that its client API version is 1.19.

I was trying to use Kitematic. I'll test with boot2docker instead and see if I can get that working. bash-3.2$ gcloud preview app deploy app.yaml You are about to deploy the following modules:

Beginning deployment... Verifying that Managed VMs are enabled and ready.

Building and pushing image for module [default] Updating module [default]...done.

ERROR: (gcloud.preview.app.deploy) Not enough VMs ready (0/1 ready, 1 still deploying). Deployed Version: 20150722t152729.385903903014455024

I've gotten this error 4 of 4 times. Possibly of interest: The "Updating module" step takes a very long time (several minutes).

Google Cloud SDK [0.9.70]

Platform: [Mac OS X, x86_64] Python Version: [2.7.6 (default, Sep 9 2014, 15:04:36) [GCC 4.2.1 Compatible Apple LLVM 6.0 (clang-600.0.39)]] Site Packages: [Disabled]

@maxluebbe @hegemonic FYI

lesv commented 9 years ago

Ok, so I start doing my thing to replicate this problem -- I want to rebuild the Docker image that I start with.

managed-vm-gae 11:32:55(2240)$ cd docker; docker build -t gae-4bt .;cd ../gae-bigtable-hello Sending build context to Docker daemon An error occurred trying to connect: Post https://192.168.59.103:2376/v1.19/build?cgroupparent=&cpuperiod=0&cpuquota=0&cpusetcpus=&cpusetmems=&cpushares=0&dockerfile=Dockerfile&memory=0&memswap=0&rm=1&t=gae-4bt: x509: certificate is valid for 127.0.0.1, 10.0.2.15, not 192.168.59.103

Ok, that's new -- not entirely amusing.

lesv commented 9 years ago

Aparently there is more security in Docker 1.7 than before. You can recreate the cert with: boot2docker ssh 'sudo /etc/init.d/docker restart'

This is production software?

lesv commented 9 years ago

Aparently 1.7.1 fixes the issue, but we, for some reason aren't compatible w/ 1.7.1.

lesv commented 9 years ago

First part works, I been able to create my docker image. docker build -t gae-4bt .;cd ../gae-bigtable-hello

lesv commented 9 years ago

mvn clean compile process-resources war:exploded -- Works

lesv commented 9 years ago

Hangs for about a minute before printing anything. (not great UX)

gae-bigtable-hello 12:26:30(2250)$ gcloud preview app deploy app.yaml You are about to deploy the following modules:

Beginning deployment... Verifying that Managed VMs are enabled and ready.

lesv commented 9 years ago

If this is your first deployment, this may take a while...done.

Building and pushing image for module [default]

Took 5 minutes between those two lines. :( Nothing in the logs on Cloud Developers Console)

lesv commented 9 years ago

ERROR: (gcloud.preview.app.deploy) Not enough VMs ready (0/1 ready, 1 still deploying). Deployed Version: 20150723t122820.385924537062182967 lesv-macbookpro2 gae-bigtable-hello 13:00:50(2251)$

Wow - 34 minutes to an error. :(

My gcloud log -- nothing on GCE logs:

2015-07-23 12:28:19,784 DEBUG root Metrics collector initialized... 2015-07-23 12:28:19,790 DEBUG root Loaded Command Group: ['gcloud', 'preview', 'app'] 2015-07-23 12:28:20,661 DEBUG root Loaded Command Group: ['gcloud', 'preview', 'app', 'deploy'] 2015-07-23 12:28:20,662 DEBUG root Running gcloud.preview.app.deploy with Namespace(calliope_internal_deepestparser=ArgumentParser(prog='gcloud.preview.app.deploy', usage=None, description="(BETA)_ This command is used to deploy both code and configuration to the App Engine\nserver. As an input it takes one or more DEPLOYABLES'' that should be\nuploaded. ADEPLOYABLE'' can be a module's .yaml file or a configuration's\n.yaml file.", version=None, formatter_class=<class 'argparse.HelpFormatter'>, conflict_handler='error', add_help=False), bucket=None, cmd_func=<bound method Command.Run of <googlecloudsdk.calliope.backend.Command object at 0x10e980810>>, command_path=['gcloud', 'preview', 'app', 'deploy'], deployables=['app.yaml'], document=None, env_vars=None, force=False, format=None, h=None, help=None, http_timeout=None, log_http=None, markdown=None, project=None, quiet=None, remote=False, server=None, set_default=False, trace_token=None, user_output_enabled=None, verbosity=None, version=None). 2015-07-23 12:28:20,677 INFO oauth2client.client Refreshing access_token 2015-07-23 12:29:38,244 INFO ___FILEONLY You are about to deploy the following modules:

2015-07-23 12:29:38,245 INFO _FILEONLY - rugged-memory-819/default (from [/Users/lesv/github/cloud-bigtable-examples/java/managed-vm-gae/gae-bigtable-hello/app.yaml]) Deployed URL: [https://20150723t122820-dot-rugged-memory-819.appspot.com](add --set-default if you also want to make this module available from [https://rugged-memory-819.appspot.com])

2015-07-23 12:29:38,245 INFO _FILEONLY Beginning deployment...

2015-07-23 12:29:38,245 INFO _FILEONLY Verifying that Managed VMs are enabled and ready.

2015-07-23 12:29:38,245 DEBUG root Host: appengine.google.com 2015-07-23 12:29:38,245 DEBUG googlecloudsdk.appengine.lib.external.tools.appengine_rpc _Authenticate configuring auth; needs_auth=False 2015-07-23 12:29:38,246 DEBUG googlecloudsdk.appengine.lib.external.tools.appengine_rpc Sending request to https://appengine.google.com/api/vms/prepare?app_id=rugged-memory-819 headers={'X-appcfg-api-version': '1', 'content-length': '0', 'Content-Type': 'application/octet-stream'} body= 2015-07-23 12:29:38,246 INFO oauth2client.client Attempting refresh to obtain initial access_token 2015-07-23 12:29:38,246 INFO oauth2client.client Refreshing access_token 2015-07-23 12:29:53,750 INFO _FILE_ONLY_ If this is your first deployment, this may take a while... 2015-07-23 12:32:16,341 DEBUG root Got response: {bucket: vm-containers.rugged-memory-819.appspot.com, path: /containers}

2015-07-23 12:32:16,341 INFO _FILEONLY

2015-07-23 12:32:16,346 INFO oauth2client.client Refreshing access_token 2015-07-23 12:33:32,627 INFO oauth2client.client Refreshing access_token 2015-07-23 12:34:48,873 INFO oauth2client.client Refreshing access_token 2015-07-23 12:36:05,124 INFO oauth2client.client Refreshing access_token 2015-07-23 12:37:21,352 INFO oauth2client.client Refreshing access_token 2015-07-23 12:38:37,439 INFO oauth2client.client Refreshing access_token 2015-07-23 12:39:55,504 INFO oauth2client.client Refreshing access_token 2015-07-23 12:41:13,172 DEBUG root Detected docker environment variables: DOCKER_HOST=tcp://192.168.59.103:2376, DOCKER_CERT_PATH=/Users/lesv/.boot2docker/certs/boot2docker-vm, DOCKER_TLS_VERIFY=1 2015-07-23 12:41:13,189 INFO requests.packages.urllib3.connectionpool Starting new HTTPS connection (1): 192.168.59.103 2015-07-23 12:41:13,237 DEBUG requests.packages.urllib3.connectionpool "GET /v1.10/_ping HTTP/1.1" 200 2 2015-07-23 12:41:13,238 INFO _FILE_ONLY_ Building and pushing image for module [default]

2015-07-23 12:41:13,239 INFO root Looking for the Dockerfile in /Users/lesv/github/cloud-bigtable-examples/java/managed-vm-gae/gae-bigtable-hello 2015-07-23 12:41:13,239 INFO root Using Dockerfile found in /Users/lesv/github/cloud-bigtable-examples/java/managed-vm-gae/gae-bigtable-hello 2015-07-23 12:41:13,239 INFO root Building docker image rugged-memory-819.default.20150723t122820 from /Users/lesv/github/cloud-bigtable-examples/java/managed-vm-gae/gae-bigtable-hello/Dockerfile: 2015-07-23 12:41:13,239 INFO root -------------------------------- DOCKER OUTPUT --------------------------------- 2015-07-23 12:41:14,906 DEBUG requests.packages.urllib3.connectionpool "POST /v1.10/build?pull=True&nocache=False&q=False&t=rugged-memory-819.default.20150723t122820&forcerm=False&rm=True HTTP/1.1" 200 None 2015-07-23 12:41:14,918 INFO root Step 0 : FROM gae-4bt 2015-07-23 12:41:14,919 INFO root ---> a13e608eb3a3 2015-07-23 12:41:14,919 INFO root Step 1 : ADD target/bigtable-hello-SNAPSHOT/ /app 2015-07-23 12:41:15,336 INFO root ---> 532a357f2450 2015-07-23 12:41:15,347 INFO root Removing intermediate container 4ce36645e58b 2015-07-23 12:41:15,347 INFO root Successfully built 532a357f2450 2015-07-23 12:41:15,360 INFO root -------------------------------------------------------------------------------- 2015-07-23 12:41:15,360 INFO root Image rugged-memory-819.default.20150723t122820 built, id = 532a357f2450 2015-07-23 12:41:15,361 DEBUG root Configured access to appengine.gcr.io. 2015-07-23 12:41:15,503 DEBUG requests.packages.urllib3.connectionpool "POST /v1.10/images/532a357f2450/tag?repo=appengine.gcr.io%2Fgcloud%2Frugged-memory-819.default.20150723t122820&force=1 HTTP/1.1" 201 0 2015-07-23 12:41:15,503 INFO root Pushing image to Google Container Registry...

2015-07-23 12:41:15,596 INFO requests.packages.urllib3.connectionpool Starting new HTTPS connection (1): appengine.gcr.io 2015-07-23 12:41:19,442 DEBUG requests.packages.urllib3.connectionpool "GET /v2/ HTTP/1.1" 404 1428 2015-07-23 12:41:19,446 INFO requests.packages.urllib3.connectionpool Starting new HTTPS connection (1): appengine.gcr.io 2015-07-23 12:41:22,814 DEBUG requests.packages.urllib3.connectionpool "GET /v1/_ping HTTP/1.1" 200 None 2015-07-23 12:41:24,672 DEBUG requests.packages.urllib3.connectionpool "POST /v1.10/images/appengine.gcr.io/gcloud/rugged-memory-819.default.20150723t122820/push HTTP/1.1" 200 None 2015-07-23 12:41:24,672 INFO root The push refers to a repository [appengine.gcr.io/gcloud/rugged-memory-819.default.20150723t122820](len: 1)

2015-07-23 12:41:24,672 INFO root Sending image list

2015-07-23 12:41:26,003 INFO root Pushing repository appengine.gcr.io/gcloud/rugged-memory-819.default.20150723t122820 (1 tags)

2015-07-23 12:41:26,722 INFO root Image 541923dd11eb already pushed, skipping

2015-07-23 12:41:26,743 INFO root Image 433ec9fc872f already pushed, skipping

2015-07-23 12:41:26,762 INFO root Image 11971b6377ef already pushed, skipping

2015-07-23 12:41:26,764 INFO root Image 7dd8b8e18691 already pushed, skipping

2015-07-23 12:41:26,772 INFO root Image 511136ea3c5a already pushed, skipping

2015-07-23 12:41:27,415 INFO root Image 12c9949b2194 already pushed, skipping

2015-07-23 12:41:27,415 INFO root Image 62190f6c9f96 already pushed, skipping

2015-07-23 12:41:27,453 INFO root Image baf40f08f779 already pushed, skipping

2015-07-23 12:41:27,465 INFO root Image 013fdc769851 already pushed, skipping

2015-07-23 12:41:27,479 INFO root Image 662e1936a4d2 already pushed, skipping

2015-07-23 12:41:28,053 INFO root Image 5b37372f443b already pushed, skipping

2015-07-23 12:41:28,056 INFO root Image 56532d97c843 already pushed, skipping

2015-07-23 12:41:28,056 INFO root Image ff223348bd0b already pushed, skipping

2015-07-23 12:41:28,110 INFO root Image b78e0dccb156 already pushed, skipping

2015-07-23 12:41:28,123 INFO root Image a6c8d21e77d8 already pushed, skipping

2015-07-23 12:41:29,984 INFO root Image b4943e6e4389 already pushed, skipping

2015-07-23 12:41:29,984 INFO root Pushing

2015-07-23 12:41:31,331 INFO root Buffering to disk: 1.024 kB 2015-07-23 12:41:31,331 INFO root Buffering to disk

2015-07-23 12:41:31,609 INFO root Pushing: [=========================> ] 512 B/1.024 kB 2015-07-23 12:41:31,609 INFO root Pushing: [==================================================>] 1.024 kB/1.024 kB 2015-07-23 12:41:32,525 INFO root Pushing: [==================================================>] 1.024 kB/1.024 kB 2015-07-23 12:41:33,037 INFO root Image successfully pushed

2015-07-23 12:41:33,037 INFO root Pushing

2015-07-23 12:41:34,507 INFO root Buffering to disk: 9.216 kB 2015-07-23 12:41:34,508 INFO root Buffering to disk

2015-07-23 12:41:34,707 INFO root Pushing: [==> ] 512 B/9.216 kB 2015-07-23 12:41:34,710 INFO root Pushing: [=====> ] 1.024 kB/9.216 kB 2015-07-23 12:41:34,710 INFO root Pushing: [========> ] 1.536 kB/9.216 kB 2015-07-23 12:41:34,711 INFO root Pushing: [===========> ] 2.048 kB/9.216 kB 2015-07-23 12:41:34,711 INFO root Pushing: [====================> ] 3.77 kB/9.216 kB 2015-07-23 12:41:34,712 INFO root Pushing: [======================> ] 4.096 kB/9.216 kB 2015-07-23 12:41:34,712 INFO root Pushing: [=========================> ] 4.608 kB/9.216 kB 2015-07-23 12:41:34,712 INFO root Pushing: [===============================> ] 5.832 kB/9.216 kB 2015-07-23 12:41:34,713 INFO root Pushing: [=================================> ] 6.144 kB/9.216 kB 2015-07-23 12:41:34,713 INFO root Pushing: [====================================> ] 6.656 kB/9.216 kB 2015-07-23 12:41:34,713 INFO root Pushing: [======================================> ] 7.168 kB/9.216 kB 2015-07-23 12:41:34,714 INFO root Pushing: [============================================> ] 8.167 kB/9.216 kB 2015-07-23 12:41:34,714 INFO root Pushing: [===============================================> ] 8.704 kB/9.216 kB 2015-07-23 12:41:34,714 INFO root Pushing: [==================================================>] 9.216 kB/9.216 kB 2015-07-23 12:41:35,532 INFO root Pushing: [==================================================>] 9.216 kB/9.216 kB 2015-07-23 12:41:36,007 INFO root Image successfully pushed

2015-07-23 12:41:36,007 INFO root Pushing

2015-07-23 12:41:37,268 INFO root Buffering to disk: 1.024 kB 2015-07-23 12:41:37,268 INFO root Buffering to disk

2015-07-23 12:41:37,425 INFO root Pushing: [=========================> ] 512 B/1.024 kB 2015-07-23 12:41:37,425 INFO root Pushing: [==================================================>] 1.024 kB/1.024 kB 2015-07-23 12:41:38,225 INFO root Pushing: [==================================================>] 1.024 kB/1.024 kB 2015-07-23 12:41:38,826 INFO root Image successfully pushed

2015-07-23 12:41:38,826 INFO root Pushing

2015-07-23 12:41:40,505 INFO root Buffering to disk: 125.4 kB 2015-07-23 12:41:40,505 INFO root Buffering to disk

2015-07-23 12:41:40,673 INFO root Pushing: [> ] 1.536 kB/125.4 kB 2015-07-23 12:41:40,673 INFO root Pushing: [=> ] 3.072 kB/125.4 kB 2015-07-23 12:41:40,674 INFO root Pushing: [==============> ] 35.84 kB/125.4 kB 2015-07-23 12:41:40,680 INFO root Pushing: [==========================> ] 67.47 kB/125.4 kB 2015-07-23 12:41:40,686 INFO root Pushing: [========================================> ] 100.9 kB/125.4 kB 2015-07-23 12:41:40,687 INFO root Pushing: [================================================> ] 121.1 kB/125.4 kB 2015-07-23 12:41:40,692 INFO root Pushing: [=================================================> ] 123.1 kB/125.4 kB 2015-07-23 12:41:40,693 INFO root Pushing: [=================================================> ] 124.4 kB/125.4 kB 2015-07-23 12:41:41,542 INFO root Pushing: [==================================================>] 125.4 kB/125.4 kB 2015-07-23 12:41:42,058 INFO root Image successfully pushed

2015-07-23 12:41:42,058 INFO root Pushing

2015-07-23 12:41:43,551 INFO root Buffering to disk: 1.024 kB 2015-07-23 12:41:43,551 INFO root Buffering to disk

2015-07-23 12:41:43,715 INFO root Pushing: [=========================> ] 512 B/1.024 kB 2015-07-23 12:41:43,716 INFO root Pushing: [==================================================>] 1.024 kB/1.024 kB 2015-07-23 12:41:44,564 INFO root Pushing: [==================================================>] 1.024 kB/1.024 kB 2015-07-23 12:41:45,077 INFO root Image successfully pushed

2015-07-23 12:41:45,078 INFO root Pushing

2015-07-23 12:41:46,586 INFO root Buffering to disk: 557.1 kB 2015-07-23 12:41:46,587 INFO root Buffering to disk: 1.114 MB 2015-07-23 12:41:46,588 INFO root Buffering to disk: 1.671 MB 2015-07-23 12:41:46,588 INFO root Buffering to disk: 2.228 MB 2015-07-23 12:41:46,589 INFO root Buffering to disk: 2.785 MB 2015-07-23 12:41:46,589 INFO root Buffering to disk: 3.342 MB 2015-07-23 12:41:46,590 INFO root Buffering to disk: 3.899 MB 2015-07-23 12:41:46,591 INFO root Buffering to disk: 4.456 MB 2015-07-23 12:41:46,591 INFO root Buffering to disk: 5.014 MB 2015-07-23 12:41:46,592 INFO root Buffering to disk: 5.571 MB 2015-07-23 12:41:46,592 INFO root Buffering to disk: 6.128 MB 2015-07-23 12:41:46,593 INFO root Buffering to disk: 6.685 MB 2015-07-23 12:41:46,595 INFO root Buffering to disk: 7.242 MB 2015-07-23 12:41:46,595 INFO root Buffering to disk: 7.799 MB 2015-07-23 12:41:46,595 INFO root Buffering to disk: 8.356 MB 2015-07-23 12:41:46,598 INFO root Buffering to disk: 8.913 MB 2015-07-23 12:41:46,598 INFO root Buffering to disk: 9.47 MB 2015-07-23 12:41:46,598 INFO root Buffering to disk: 10.03 MB 2015-07-23 12:41:46,598 INFO root Buffering to disk: 10.58 MB 2015-07-23 12:41:46,598 INFO root Buffering to disk: 11.14 MB 2015-07-23 12:41:46,598 INFO root Buffering to disk: 11.7 MB 2015-07-23 12:41:46,602 INFO root Buffering to disk: 12.26 MB 2015-07-23 12:41:46,602 INFO root Buffering to disk: 12.81 MB 2015-07-23 12:41:46,602 INFO root Buffering to disk: 13.37 MB 2015-07-23 12:41:46,602 INFO root Buffering to disk: 13.93 MB 2015-07-23 12:41:46,602 INFO root Buffering to disk: 14.48 MB 2015-07-23 12:41:46,603 INFO root Buffering to disk: 15.04 MB 2015-07-23 12:41:46,603 INFO root Buffering to disk: 15.6 MB 2015-07-23 12:41:46,603 INFO root Buffering to disk: 16.15 MB 2015-07-23 12:41:46,603 INFO root Buffering to disk: 16.71 MB 2015-07-23 12:41:46,603 INFO root Buffering to disk: 17.27 MB 2015-07-23 12:41:46,603 INFO root Buffering to disk: 17.83 MB 2015-07-23 12:41:46,603 INFO root Buffering to disk: 18.38 MB 2015-07-23 12:41:46,611 INFO root Buffering to disk: 18.94 MB 2015-07-23 12:41:46,612 INFO root Buffering to disk: 19.5 MB 2015-07-23 12:41:46,612 INFO root Buffering to disk: 20.05 MB 2015-07-23 12:41:46,612 INFO root Buffering to disk: 20.61 MB 2015-07-23 12:41:46,612 INFO root Buffering to disk: 21.17 MB 2015-07-23 12:41:46,612 INFO root Buffering to disk: 21.73 MB 2015-07-23 12:41:46,612 INFO root Buffering to disk: 22.28 MB 2015-07-23 12:41:46,613 INFO root Buffering to disk: 22.84 MB 2015-07-23 12:41:46,613 INFO root Buffering to disk: 23.4 MB 2015-07-23 12:41:46,613 INFO root Buffering to disk: 23.95 MB 2015-07-23 12:41:46,613 INFO root Buffering to disk: 24.51 MB 2015-07-23 12:41:46,613 INFO root Buffering to disk: 25.07 MB 2015-07-23 12:41:46,613 INFO root Buffering to disk: 25.62 MB 2015-07-23 12:41:46,613 INFO root Buffering to disk: 26.18 MB 2015-07-23 12:41:46,614 INFO root Buffering to disk: 26.74 MB 2015-07-23 12:41:46,614 INFO root Buffering to disk: 27.3 MB 2015-07-23 12:41:46,614 INFO root Buffering to disk: 27.85 MB 2015-07-23 12:41:46,614 INFO root Buffering to disk: 28.41 MB 2015-07-23 12:41:46,614 INFO root Buffering to disk: 28.97 MB 2015-07-23 12:41:46,615 INFO root Buffering to disk: 29.52 MB 2015-07-23 12:41:46,615 INFO root Buffering to disk: 30.08 MB 2015-07-23 12:41:46,621 INFO root Buffering to disk: 30.64 MB 2015-07-23 12:41:46,622 INFO root Buffering to disk: 31.2 MB 2015-07-23 12:41:46,622 INFO root Buffering to disk: 31.75 MB 2015-07-23 12:41:46,622 INFO root Buffering to disk: 32.31 MB 2015-07-23 12:41:46,622 INFO root Buffering to disk: 32.87 MB 2015-07-23 12:41:46,623 INFO root Buffering to disk: 33.42 MB 2015-07-23 12:41:46,623 INFO root Buffering to disk: 33.98 MB 2015-07-23 12:41:46,623 INFO root Buffering to disk: 34.54 MB 2015-07-23 12:41:46,623 INFO root Buffering to disk: 35.09 MB 2015-07-23 12:41:46,624 INFO root Buffering to disk: 35.65 MB 2015-07-23 12:41:46,624 INFO root Buffering to disk: 36.21 MB 2015-07-23 12:41:46,624 INFO root Buffering to disk: 36.77 MB 2015-07-23 12:41:46,624 INFO root Buffering to disk: 37.32 MB 2015-07-23 12:41:46,624 INFO root Buffering to disk: 37.88 MB 2015-07-23 12:41:46,624 INFO root Buffering to disk: 38.44 MB 2015-07-23 12:41:46,625 INFO root Buffering to disk: 38.99 MB 2015-07-23 12:41:46,625 INFO root Buffering to disk: 39.55 MB 2015-07-23 12:41:46,632 INFO root Buffering to disk: 40.11 MB 2015-07-23 12:41:46,632 INFO root Buffering to disk: 40.67 MB 2015-07-23 12:41:46,632 INFO root Buffering to disk: 41.22 MB 2015-07-23 12:41:46,632 INFO root Buffering to disk: 41.78 MB 2015-07-23 12:41:46,632 INFO root Buffering to disk: 42.34 MB 2015-07-23 12:41:46,633 INFO root Buffering to disk: 42.89 MB 2015-07-23 12:41:46,633 INFO root Buffering to disk: 43.45 MB 2015-07-23 12:41:46,633 INFO root Buffering to disk: 44.01 MB 2015-07-23 12:41:46,633 INFO root Buffering to disk: 44.56 MB 2015-07-23 12:41:46,633 INFO root Buffering to disk: 45.12 MB 2015-07-23 12:41:46,633 INFO root Buffering to disk: 45.68 MB 2015-07-23 12:41:46,633 INFO root Buffering to disk: 46.24 MB 2015-07-23 12:41:46,633 INFO root Buffering to disk: 46.79 MB 2015-07-23 12:41:46,634 INFO root Buffering to disk: 47.35 MB 2015-07-23 12:41:46,636 INFO root Buffering to disk: 47.91 MB 2015-07-23 12:41:46,636 INFO root Buffering to disk: 48.46 MB 2015-07-23 12:41:46,636 INFO root Buffering to disk: 49.02 MB 2015-07-23 12:41:46,637 INFO root Buffering to disk: 49.44 MB 2015-07-23 12:41:46,637 INFO root Buffering to disk

2015-07-23 12:41:47,085 INFO root Pushing: [> ] 500.2 kB/49.44 MB 2015-07-23 12:41:47,242 INFO root Pushing: [=> ] 995.8 kB/49.44 MB 2015-07-23 12:41:47,432 INFO root Pushing: [=> ] 1.52 MB/49.44 MB 2015-07-23 12:41:47,961 INFO root Pushing: [==> ] 2.044 MB/49.44 MB 2015-07-23 12:41:48,292 INFO root Pushing: [==> ] 2.569 MB/49.44 MB 2015-07-23 12:41:48,712 INFO root Pushing: [===> ] 3.093 MB/49.44 MB 2015-07-23 12:41:49,013 INFO root Pushing: [===> ] 3.617 MB/49.44 MB 2015-07-23 12:41:49,483 INFO root Pushing: [====> ] 4.142 MB/49.44 MB 2015-07-23 12:41:49,941 INFO root Pushing: [====> ] 4.666 MB/49.44 MB 2015-07-23 12:41:50,362 INFO root Pushing: [=====> ] 5.19 MB/49.44 MB 2015-07-23 12:41:50,741 INFO root Pushing: [=====> ] 5.714 MB/49.44 MB 2015-07-23 12:41:51,243 INFO root Pushing: [======> ] 6.239 MB/49.44 MB 2015-07-23 12:41:51,573 INFO root Pushing: [======> ] 6.763 MB/49.44 MB 2015-07-23 12:41:52,042 INFO root Pushing: [=======> ] 7.287 MB/49.44 MB 2015-07-23 12:41:52,481 INFO root Pushing: [=======> ] 7.812 MB/49.44 MB 2015-07-23 12:41:52,940 INFO root Pushing: [========> ] 8.336 MB/49.44 MB 2015-07-23 12:41:53,434 INFO root Pushing: [========> ] 8.86 MB/49.44 MB 2015-07-23 12:41:53,806 INFO root Pushing: [=========> ] 9.384 MB/49.44 MB 2015-07-23 12:41:54,320 INFO root Pushing: [==========> ] 9.909 MB/49.44 MB 2015-07-23 12:41:54,681 INFO root Pushing: [==========> ] 10.43 MB/49.44 MB 2015-07-23 12:41:55,156 INFO root Pushing: [===========> ] 10.96 MB/49.44 MB 2015-07-23 12:41:55,587 INFO root Pushing: [===========> ] 11.48 MB/49.44 MB 2015-07-23 12:41:56,084 INFO root Pushing: [============> ] 12.01 MB/49.44 MB 2015-07-23 12:41:56,433 INFO root Pushing: [============> ] 12.53 MB/49.44 MB 2015-07-23 12:41:56,845 INFO root Pushing: [=============> ] 13.05 MB/49.44 MB 2015-07-23 12:41:57,354 INFO root Pushing: [=============> ] 13.58 MB/49.44 MB 2015-07-23 12:41:57,793 INFO root Pushing: [==============> ] 14.1 MB/49.44 MB 2015-07-23 12:41:58,255 INFO root Pushing: [==============> ] 14.63 MB/49.44 MB 2015-07-23 12:41:58,721 INFO root Pushing: [===============> ] 15.15 MB/49.44 MB 2015-07-23 12:41:59,102 INFO root Pushing: [===============> ] 15.68 MB/49.44 MB 2015-07-23 12:41:59,601 INFO root Pushing: [================> ] 16.2 MB/49.44 MB 2015-07-23 12:41:59,812 INFO root Pushing: [================> ] 16.72 MB/49.44 MB 2015-07-23 12:42:00,003 INFO root Pushing: [=================> ] 17.25 MB/49.44 MB 2015-07-23 12:42:00,034 INFO root Pushing: [=================> ] 17.76 MB/49.44 MB 2015-07-23 12:42:00,495 INFO root Pushing: [==================> ] 18.26 MB/49.44 MB 2015-07-23 12:42:00,965 INFO root Pushing: [==================> ] 18.79 MB/49.44 MB 2015-07-23 12:42:01,307 INFO root Pushing: [===================> ] 19.31 MB/49.44 MB 2015-07-23 12:42:01,839 INFO root Pushing: [====================> ] 19.84 MB/49.44 MB 2015-07-23 12:42:02,181 INFO root Pushing: [====================> ] 20.36 MB/49.44 MB 2015-07-23 12:42:02,607 INFO root Pushing: [=====================> ] 20.88 MB/49.44 MB 2015-07-23 12:42:03,051 INFO root Pushing: [=====================> ] 21.41 MB/49.44 MB 2015-07-23 12:42:03,476 INFO root Pushing: [======================> ] 21.93 MB/49.44 MB 2015-07-23 12:42:03,843 INFO root Pushing: [======================> ] 22.46 MB/49.44 MB 2015-07-23 12:42:04,347 INFO root Pushing: [=======================> ] 22.98 MB/49.44 MB 2015-07-23 12:42:04,844 INFO root Pushing: [=======================> ] 23.51 MB/49.44 MB 2015-07-23 12:42:05,218 INFO root Pushing: [========================> ] 24.03 MB/49.44 MB 2015-07-23 12:42:05,653 INFO root Pushing: [========================> ] 24.55 MB/49.44 MB 2015-07-23 12:42:06,116 INFO root Pushing: [=========================> ] 25.08 MB/49.44 MB 2015-07-23 12:42:06,487 INFO root Pushing: [=========================> ] 25.6 MB/49.44 MB 2015-07-23 12:42:06,521 INFO root Pushing: [==========================> ] 26.11 MB/49.44 MB 2015-07-23 12:42:06,894 INFO root Pushing: [==========================> ] 26.61 MB/49.44 MB 2015-07-23 12:42:07,374 INFO root Pushing: [===========================> ] 27.14 MB/49.44 MB 2015-07-23 12:42:07,714 INFO root Pushing: [===========================> ] 27.66 MB/49.44 MB 2015-07-23 12:42:08,152 INFO root Pushing: [============================> ] 28.19 MB/49.44 MB 2015-07-23 12:42:08,473 INFO root Pushing: [=============================> ] 28.71 MB/49.44 MB 2015-07-23 12:42:08,810 INFO root Pushing: [=============================> ] 29.22 MB/49.44 MB 2015-07-23 12:42:09,271 INFO root Pushing: [==============================> ] 29.75 MB/49.44 MB 2015-07-23 12:42:09,790 INFO root Pushing: [==============================> ] 30.27 MB/49.44 MB 2015-07-23 12:42:10,298 INFO root Pushing: [===============================> ] 30.79 MB/49.44 MB 2015-07-23 12:42:10,754 INFO root Pushing: [===============================> ] 31.29 MB/49.44 MB 2015-07-23 12:42:11,259 INFO root Pushing: [================================> ] 31.82 MB/49.44 MB 2015-07-23 12:42:11,713 INFO root Pushing: [================================> ] 32.34 MB/49.44 MB 2015-07-23 12:42:12,159 INFO root Pushing: [=================================> ] 32.86 MB/49.44 MB 2015-07-23 12:42:12,649 INFO root Pushing: [=================================> ] 33.39 MB/49.44 MB 2015-07-23 12:42:13,149 INFO root Pushing: [==================================> ] 33.91 MB/49.44 MB 2015-07-23 12:42:13,643 INFO root Pushing: [==================================> ] 34.44 MB/49.44 MB 2015-07-23 12:42:14,173 INFO root Pushing: [===================================> ] 34.96 MB/49.44 MB 2015-07-23 12:42:14,632 INFO root Pushing: [===================================> ] 35.49 MB/49.44 MB 2015-07-23 12:42:14,891 INFO root Pushing: [====================================> ] 35.98 MB/49.44 MB 2015-07-23 12:42:15,531 INFO root Pushing: [====================================> ] 36.51 MB/49.44 MB 2015-07-23 12:42:15,981 INFO root Pushing: [=====================================> ] 37.02 MB/49.44 MB 2015-07-23 12:42:16,432 INFO root Pushing: [=====================================> ] 37.55 MB/49.44 MB 2015-07-23 12:42:16,891 INFO root Pushing: [======================================> ] 38.07 MB/49.44 MB 2015-07-23 12:42:17,360 INFO root Pushing: [=======================================> ] 38.6 MB/49.44 MB 2015-07-23 12:42:18,051 INFO root Pushing: [=======================================> ] 39.12 MB/49.44 MB 2015-07-23 12:42:18,534 INFO root Pushing: [========================================> ] 39.65 MB/49.44 MB 2015-07-23 12:42:18,994 INFO root Pushing: [========================================> ] 40.17 MB/49.44 MB 2015-07-23 12:42:19,443 INFO root Pushing: [=========================================> ] 40.69 MB/49.44 MB 2015-07-23 12:42:19,961 INFO root Pushing: [=========================================> ] 41.22 MB/49.44 MB 2015-07-23 12:42:20,211 INFO root Pushing: [==========================================> ] 41.72 MB/49.44 MB 2015-07-23 12:42:20,693 INFO root Pushing: [==========================================> ] 42.24 MB/49.44 MB 2015-07-23 12:42:21,194 INFO root Pushing: [===========================================> ] 42.77 MB/49.44 MB 2015-07-23 12:42:21,683 INFO root Pushing: [===========================================> ] 43.29 MB/49.44 MB 2015-07-23 12:42:22,151 INFO root Pushing: [============================================> ] 43.79 MB/49.44 MB 2015-07-23 12:42:22,592 INFO root Pushing: [============================================> ] 44.32 MB/49.44 MB 2015-07-23 12:42:23,055 INFO root Pushing: [=============================================> ] 44.84 MB/49.44 MB 2015-07-23 12:42:23,502 INFO root Pushing: [=============================================> ] 45.35 MB/49.44 MB 2015-07-23 12:42:24,004 INFO root Pushing: [==============================================> ] 45.87 MB/49.44 MB 2015-07-23 12:42:24,464 INFO root Pushing: [==============================================> ] 46.39 MB/49.44 MB 2015-07-23 12:42:24,970 INFO root Pushing: [===============================================> ] 46.89 MB/49.44 MB 2015-07-23 12:42:25,441 INFO root Pushing: [===============================================> ] 47.41 MB/49.44 MB 2015-07-23 12:42:25,880 INFO root Pushing: [================================================> ] 47.93 MB/49.44 MB 2015-07-23 12:42:26,624 INFO root Pushing: [================================================> ] 48.45 MB/49.44 MB 2015-07-23 12:42:27,178 INFO root Pushing: [=================================================> ] 48.97 MB/49.44 MB 2015-07-23 12:42:29,711 INFO root Pushing: [==================================================>] 49.44 MB/49.44 MB 2015-07-23 12:42:30,156 INFO root Image successfully pushed

2015-07-23 12:42:30,156 INFO root Pushing tag for rev [532a357f2450] on {https://appengine.gcr.io/v1/repositories/gcloud/rugged-memory-819.default.20150723t122820/tags/latest}

2015-07-23 12:42:31,953 INFO _FILEONLY Updating module [default]... 2015-07-23 12:42:31,953 DEBUG root Host: appengine.google.com 2015-07-23 12:42:31,954 DEBUG root Host: appengine.google.com 2015-07-23 12:42:31,954 DEBUG root Getting current resource limits. 2015-07-23 12:42:31,955 DEBUG root Send: /api/appversion/getresourcelimits, params={'version': '20150723t122820', 'app_id': 'rugged-memory-819'} 2015-07-23 12:42:31,955 DEBUG googlecloudsdk.appengine.lib.external.tools.appengine_rpc _Authenticate configuring auth; needs_auth=False 2015-07-23 12:42:31,955 DEBUG googlecloudsdk.appengine.lib.external.tools.appengine_rpc Sending request to https://appengine.google.com/api/appversion/getresourcelimits?app_id=rugged-memory-819&version=20150723t122820 headers={'X-appcfg-api-version': '1', 'content-length': '0', 'Content-Type': 'application/octet-stream'} body= 2015-07-23 12:42:31,955 INFO oauth2client.client Attempting refresh to obtain initial access_token 2015-07-23 12:42:31,955 INFO oauth2client.client Refreshing access_token 2015-07-23 12:45:04,473 DEBUG root Got response: max_file_size: 32000000 max_blob_size: 32000000 max_files_to_clone: 2000 max_total_file_size: 9223372036854775807 max_file_count: 10000

2015-07-23 12:45:04,475 DEBUG root Using resource limits: {'max_file_size': 32000000, 'max_total_file_size': 9223372036854775807, 'max_blob_size': 32000000, 'max_files_to_clone': 2000, 'max_file_count': 10000} 2015-07-23 12:45:04,476 INFO root Reading app configuration. 2015-07-23 12:45:04,476 DEBUG root Starting update of app: rugged-memory-819, version: 20150723t122820 2015-07-23 12:45:04,476 DEBUG root Scanning files on local disk. 2015-07-23 12:45:04,477 INFO root Ignoring file [.dockerignore]: File matches ignore regex. 2015-07-23 12:45:04,477 INFO root Processing file [Dockerfile] 2015-07-23 12:45:04,477 INFO root Processing file [app.yaml] 2015-07-23 12:45:04,478 INFO root Processing file [pom.xml] 2015-07-23 12:45:04,479 INFO root Processing file [target/maven-status/maven-compiler-plugin/compile/default-compile/createdFiles.lst] 2015-07-23 12:45:04,479 INFO root Processing file [target/maven-status/maven-compiler-plugin/compile/default-compile/inputFiles.lst] 2015-07-23 12:45:04,480 INFO root Processing file [target/bigtable-hello-SNAPSHOT/favicon.ico] 2015-07-23 12:45:04,480 INFO root Ignoring file [target/bigtable-hello-SNAPSHOT/WEB-INF/.dockerignore]: File matches ignore regex. 2015-07-23 12:45:04,480 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/appengine-web.xml] 2015-07-23 12:45:04,481 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/logging.properties] 2015-07-23 12:45:04,481 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/web.xml] 2015-07-23 12:45:04,482 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/apacheds-i18n-2.0.0-M15.jar] 2015-07-23 12:45:04,483 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/apacheds-kerberos-codec-2.0.0-M15.jar] 2015-07-23 12:45:04,486 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/api-asn1-api-1.0.0-M20.jar] 2015-07-23 12:45:04,487 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/api-util-1.0.0-M20.jar] 2015-07-23 12:45:04,488 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/appengine-api-1.0-sdk-1.9.23.jar] 2015-07-23 12:45:04,546 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/avro-1.7.4.jar] 2015-07-23 12:45:04,549 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/bigtable-hbase-1.1-0.1.9-shaded.jar] 2015-07-23 12:45:04,577 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/commons-beanutils-1.7.0.jar] 2015-07-23 12:45:04,578 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/commons-beanutils-core-1.8.0.jar] 2015-07-23 12:45:04,580 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/commons-cli-1.2.jar] 2015-07-23 12:45:04,581 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/commons-codec-1.9.jar] 2015-07-23 12:45:04,583 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/commons-collections-3.2.1.jar] 2015-07-23 12:45:04,586 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/commons-compress-1.4.1.jar] 2015-07-23 12:45:04,587 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/commons-configuration-1.6.jar] 2015-07-23 12:45:04,589 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/commons-digester-1.8.jar] 2015-07-23 12:45:04,590 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/commons-el-1.0.jar] 2015-07-23 12:45:04,592 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/commons-httpclient-3.1.jar] 2015-07-23 12:45:04,594 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/commons-io-2.4.jar] 2015-07-23 12:45:04,595 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/commons-lang-2.6.jar] 2015-07-23 12:45:04,597 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/commons-logging-1.2.jar] 2015-07-23 12:45:04,599 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/commons-math3-3.1.1.jar] 2015-07-23 12:45:04,606 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/commons-net-3.1.jar] 2015-07-23 12:45:04,608 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/guava-12.0.1.jar] 2015-07-23 12:45:04,616 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/hadoop-annotations-2.5.1.jar] 2015-07-23 12:45:04,616 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/hadoop-auth-2.5.1.jar] 2015-07-23 12:45:04,617 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/hadoop-common-2.5.1.jar] 2015-07-23 12:45:04,628 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/hbase-annotations-1.1.0.jar] 2015-07-23 12:45:04,629 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/hbase-client-1.1.0.jar] 2015-07-23 12:45:04,634 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/hbase-common-1.1.0.jar] 2015-07-23 12:45:04,637 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/hbase-protocol-1.1.0.jar] 2015-07-23 12:45:04,651 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/htrace-core-3.1.0-incubating.jar] 2015-07-23 12:45:04,657 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/httpclient-4.2.5.jar] 2015-07-23 12:45:04,660 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/httpcore-4.2.4.jar] 2015-07-23 12:45:04,662 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/jackson-core-asl-1.9.13.jar] 2015-07-23 12:45:04,663 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/jackson-mapper-asl-1.9.13.jar] 2015-07-23 12:45:04,668 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/jcl-over-slf4j-1.7.12.jar] 2015-07-23 12:45:04,669 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/jcodings-1.0.8.jar] 2015-07-23 12:45:04,674 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/jetty-util-6.1.26.jar] 2015-07-23 12:45:04,676 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/joni-2.1.2.jar] 2015-07-23 12:45:04,677 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/jsch-0.1.42.jar] 2015-07-23 12:45:04,679 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/json-20140107.jar] 2015-07-23 12:45:04,680 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/jsr305-1.3.9.jar] 2015-07-23 12:45:04,681 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/log4j-over-slf4j-1.7.12.jar] 2015-07-23 12:45:04,682 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/paranamer-2.3.jar] 2015-07-23 12:45:04,683 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/protobuf-java-3.0.0-alpha-2.jar] 2015-07-23 12:45:04,687 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/slf4j-api-1.7.12.jar] 2015-07-23 12:45:04,688 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/slf4j-jdk14-1.7.12.jar] 2015-07-23 12:45:04,690 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/snappy-java-1.0.4.1.jar] 2015-07-23 12:45:04,694 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/xmlenc-0.52.jar] 2015-07-23 12:45:04,695 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/xz-1.0.jar] 2015-07-23 12:45:04,697 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/lib/zookeeper-3.4.6.jar] 2015-07-23 12:45:04,703 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/classes/com/example/cloud/bigtable/helloworld/BigtableHelper.class] 2015-07-23 12:45:04,704 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/classes/com/example/cloud/bigtable/helloworld/HelloServlet.class] 2015-07-23 12:45:04,704 INFO root Processing file [target/bigtable-hello-SNAPSHOT/WEB-INF/classes/com/example/cloud/bigtable/helloworld/JsonServlet.class] 2015-07-23 12:45:04,706 INFO root Processing file [src/main/webapp/favicon.ico] 2015-07-23 12:45:04,706 INFO root Ignoring file [src/main/webapp/WEB-INF/.dockerignore]: File matches ignore regex. 2015-07-23 12:45:04,707 INFO root Ignoring file [src/main/webapp/WEB-INF/.gitignore]: File matches ignore regex. 2015-07-23 12:45:04,707 INFO root Processing file [src/main/webapp/WEB-INF/appengine-web.xml] 2015-07-23 12:45:04,707 INFO root Processing file [src/main/webapp/WEB-INF/logging.properties] 2015-07-23 12:45:04,708 INFO root Processing file [src/main/webapp/WEB-INF/web.xml] 2015-07-23 12:45:04,708 INFO root Processing file [src/main/java/com.example.cloud.bigtable.helloworld/BigtableHelper.java] 2015-07-23 12:45:04,709 INFO root Processing file [src/main/java/com.example.cloud.bigtable.helloworld/HelloServlet.java] 2015-07-23 12:45:04,709 INFO root Processing file [src/main/java/com.example.cloud.bigtable.helloworld/JsonServlet.java] 2015-07-23 12:45:04,716 DEBUG root Send: /api/appversion/create, params={'version': '20150723t122820', 'app_id': 'rugged-memory-819', 'module': 'default'} 2015-07-23 12:45:04,716 DEBUG googlecloudsdk.appengine.lib.external.tools.appengine_rpc _Authenticate configuring auth; needs_auth=False 2015-07-23 12:45:04,716 DEBUG googlecloudsdk.appengine.lib.external.tools.appengine_rpc Sending request to https://appengine.google.com/api/appversion/create?app_id=rugged-memory-819&module=default&version=20150723t122820 headers={'X-appcfg-api-version': '1', 'content-length': '684', 'Content-Type': 'application/octet-stream'} body=api_version: '1' application: rugged-memory-819 auto_id_policy: default automatic_scaling: cool_down_period_sec: 330 cpu_utilization: target_utilization: 0.5 max_num_instances: 20 min_num_instances: 1 builtins:

2015-07-23 12:45:04,716 INFO oauth2client.client Attempting refresh to obtain initial access_token 2015-07-23 12:45:04,716 INFO oauth2client.client Refreshing access_token 2015-07-23 12:47:37,493 DEBUG root Got response: warnings: []

2015-07-23 12:47:37,495 DEBUG root Files to upload: {} 2015-07-23 12:47:37,495 DEBUG root Starting deployment. 2015-07-23 12:47:37,495 DEBUG root Send: /api/appversion/deploy, params={'version': '20150723t122820', 'app_id': 'rugged-memory-819', 'module': 'default'} 2015-07-23 12:47:37,495 DEBUG googlecloudsdk.appengine.lib.external.tools.appengine_rpc _Authenticate configuring auth; needs_auth=False 2015-07-23 12:47:37,495 DEBUG googlecloudsdk.appengine.lib.external.tools.appengine_rpc Sending request to https://appengine.google.com/api/appversion/deploy?app_id=rugged-memory-819&module=default&version=20150723t122820 headers={'X-appcfg-api-version': '1', 'content-length': '0', 'Content-Type': 'application/octet-stream'} body= 2015-07-23 12:48:55,353 DEBUG root Got response: application: s~rugged-memory-819 major_version: 20150723t122820 minor_version: 385924537062182967

2015-07-23 12:48:55,357 DEBUG root Checking if deployment succeeded. 2015-07-23 12:48:55,358 DEBUG root Send: /api/appversion/isready, params={'version': '20150723t122820', 'app_id': 'rugged-memory-819', 'module': 'default'} 2015-07-23 12:48:55,358 DEBUG googlecloudsdk.appengine.lib.external.tools.appengine_rpc _Authenticate configuring auth; needs_auth=False 2015-07-23 12:48:55,358 DEBUG googlecloudsdk.appengine.lib.external.tools.appengine_rpc Sending request to https://appengine.google.com/api/appversion/isready?app_id=rugged-memory-819&module=default&version=20150723t122820 headers={'X-appcfg-api-version': '1', 'content-length': '0', 'Content-Type': 'application/octet-stream'} body= 2015-07-23 12:50:11,719 DEBUG root Got response: 1 2015-07-23 12:50:11,719 DEBUG root Deployment successful. 2015-07-23 12:50:11,720 DEBUG root Send: /api/appversion/startserving, params={'willcheckserving': '1', 'version': '20150723t122820', 'app_id': 'rugged-memory-819', 'module': 'default'} 2015-07-23 12:50:11,720 DEBUG googlecloudsdk.appengine.lib.external.tools.appengine_rpc _Authenticate configuring auth; needs_auth=False 2015-07-23 12:50:11,720 DEBUG googlecloudsdk.appengine.lib.external.tools.appengine_rpc Sending request to https://appengine.google.com/api/appversion/startserving?app_id=rugged-memory-819&module=default&version=20150723t122820&willcheckserving=1 headers={'X-appcfg-api-version': '1', 'content-length': '0', 'Content-Type': 'application/octet-stream'} body= 2015-07-23 12:51:28,542 DEBUG root Got response: 1 2015-07-23 12:51:28,542 DEBUG root Checking if updated app version is serving. 2015-07-23 12:51:28,542 DEBUG root Send: /api/appversion/isserving, params={'new_serving_resp': '1', 'version': '20150723t122820', 'app_id': 'rugged-memory-819', 'module': 'default'} 2015-07-23 12:51:28,542 DEBUG googlecloudsdk.appengine.lib.external.tools.appengine_rpc _Authenticate configuring auth; needs_auth=False 2015-07-23 12:51:28,542 DEBUG googlecloudsdk.appengine.lib.external.tools.appengine_rpc Sending request to https://appengine.google.com/api/appversion/isserving?app_id=rugged-memory-819&module=default&new_serving_resp=1&version=20150723t122820 headers={'X-appcfg-api-version': '1', 'content-length': '0', 'Content-Type': 'application/octet-stream'} body= 2015-07-23 12:52:45,706 DEBUG root Got response: {check_endpoints_config: false, fatal: false, message: null, serving: false}

2015-07-23 12:52:45,709 DEBUG root Will check again in 5 seconds. 2015-07-23 12:52:50,713 DEBUG root Checking if updated app version is serving. 2015-07-23 12:52:50,713 DEBUG root Send: /api/appversion/isserving, params={'new_serving_resp': '1', 'version': '20150723t122820', 'app_id': 'rugged-memory-819', 'module': 'default'} 2015-07-23 12:52:50,713 DEBUG googlecloudsdk.appengine.lib.external.tools.appengine_rpc _Authenticate configuring auth; needs_auth=False 2015-07-23 12:52:50,713 DEBUG googlecloudsdk.appengine.lib.external.tools.appengine_rpc Sending request to https://appengine.google.com/api/appversion/isserving?app_id=rugged-memory-819&module=default&new_serving_resp=1&version=20150723t122820 headers={'X-appcfg-api-version': '1', 'content-length': '0', 'Content-Type': 'application/octet-stream'} body= 2015-07-23 12:54:07,053 DEBUG root Got response: {check_endpoints_config: false, fatal: false, message: null, serving: false}

2015-07-23 12:54:07,054 DEBUG root Will check again in 5 seconds. 2015-07-23 12:54:12,059 DEBUG root Checking if updated app version is serving. 2015-07-23 12:54:12,059 DEBUG root Send: /api/appversion/isserving, params={'new_serving_resp': '1', 'version': '20150723t122820', 'app_id': 'rugged-memory-819', 'module': 'default'} 2015-07-23 12:54:12,059 DEBUG googlecloudsdk.appengine.lib.external.tools.appengine_rpc _Authenticate configuring auth; needs_auth=False 2015-07-23 12:54:12,059 DEBUG googlecloudsdk.appengine.lib.external.tools.appengine_rpc Sending request to https://appengine.google.com/api/appversion/isserving?app_id=rugged-memory-819&module=default&new_serving_resp=1&version=20150723t122820 headers={'X-appcfg-api-version': '1', 'content-length': '0', 'Content-Type': 'application/octet-stream'} body= 2015-07-23 12:55:28,475 DEBUG root Got response: {check_endpoints_config: false, fatal: false, message: null, serving: false}

2015-07-23 12:55:28,476 DEBUG root Will check again in 5 seconds. 2015-07-23 12:55:33,479 DEBUG root Checking if updated app version is serving. 2015-07-23 12:55:33,480 DEBUG root Send: /api/appversion/isserving, params={'new_serving_resp': '1', 'version': '20150723t122820', 'app_id': 'rugged-memory-819', 'module': 'default'} 2015-07-23 12:55:33,480 DEBUG googlecloudsdk.appengine.lib.external.tools.appengine_rpc _Authenticate configuring auth; needs_auth=False 2015-07-23 12:55:33,480 DEBUG googlecloudsdk.appengine.lib.external.tools.appengine_rpc Sending request to https://appengine.google.com/api/appversion/isserving?app_id=rugged-memory-819&module=default&new_serving_resp=1&version=20150723t122820 headers={'X-appcfg-api-version': '1', 'content-length': '0', 'Content-Type': 'application/octet-stream'} body= 2015-07-23 12:56:51,094 DEBUG root Got response: {check_endpoints_config: false, fatal: false, message: null, serving: false}

2015-07-23 12:56:51,097 DEBUG root Will check again in 5 seconds. 2015-07-23 12:56:56,101 DEBUG root Checking if updated app version is serving. 2015-07-23 12:56:56,101 DEBUG root Send: /api/appversion/isserving, params={'new_serving_resp': '1', 'version': '20150723t122820', 'app_id': 'rugged-memory-819', 'module': 'default'} 2015-07-23 12:56:56,101 DEBUG googlecloudsdk.appengine.lib.external.tools.appengine_rpc _Authenticate configuring auth; needs_auth=False 2015-07-23 12:56:56,102 DEBUG googlecloudsdk.appengine.lib.external.tools.appengine_rpc Sending request to https://appengine.google.com/api/appversion/isserving?app_id=rugged-memory-819&module=default&new_serving_resp=1&version=20150723t122820 headers={'X-appcfg-api-version': '1', 'content-length': '0', 'Content-Type': 'application/octet-stream'} body= 2015-07-23 12:58:12,944 DEBUG root Got response: {check_endpoints_config: false, fatal: false, message: null, serving: false}

2015-07-23 12:58:12,946 DEBUG root Will check again in 5 seconds. 2015-07-23 12:58:17,948 DEBUG root Checking if updated app version is serving. 2015-07-23 12:58:17,949 DEBUG root Send: /api/appversion/isserving, params={'new_serving_resp': '1', 'version': '20150723t122820', 'app_id': 'rugged-memory-819', 'module': 'default'} 2015-07-23 12:58:17,949 DEBUG googlecloudsdk.appengine.lib.external.tools.appengine_rpc _Authenticate configuring auth; needs_auth=False 2015-07-23 12:58:17,949 DEBUG googlecloudsdk.appengine.lib.external.tools.appengine_rpc Sending request to https://appengine.google.com/api/appversion/isserving?app_id=rugged-memory-819&module=default&new_serving_resp=1&version=20150723t122820 headers={'X-appcfg-api-version': '1', 'content-length': '0', 'Content-Type': 'application/octet-stream'} body= 2015-07-23 12:59:34,232 DEBUG root Got response: {check_endpoints_config: false, fatal: true, message: 'Not enough VMs ready (0/1 ready, 1 still deploying). Deployed Version: 20150723t122820.385924537062182967', serving: false}

2015-07-23 12:59:34,234 DEBUG root Not enough VMs ready (0/1 ready, 1 still deploying). Deployed Version: 20150723t122820.385924537062182967 2015-07-23 12:59:34,234 DEBUG root Rolling back the update. This can sometimes take a while since a VM version is being rolled back. 2015-07-23 12:59:34,234 DEBUG root Send: /api/appversion/rollback, params={'version': '20150723t122820', 'app_id': 'rugged-memory-819', 'module': 'default'} 2015-07-23 12:59:34,234 DEBUG googlecloudsdk.appengine.lib.external.tools.appengine_rpc _Authenticate configuring auth; needs_auth=False 2015-07-23 12:59:34,234 DEBUG googlecloudsdk.appengine.lib.external.tools.appengine_rpc Sending request to https://appengine.google.com/api/appversion/rollback?app_id=rugged-memory-819&force_rollback=0&module=default&version=20150723t122820 headers={'X-appcfg-api-version': '1', 'content-length': '0', 'Content-Type': 'application/octet-stream'} body= 2015-07-23 13:00:50,296 DEBUG root Got response: 2015-07-23 13:00:50,298 INFO root Skipping usage reporting. 2015-07-23 13:00:50,298 DEBUG root (gcloud.preview.app.deploy) Not enough VMs ready (0/1 ready, 1 still deploying). Deployed Version: 20150723t122820.385924537062182967 Traceback (most recent call last): File "/Users/lesv/google-cloud-sdk/./lib/googlecloudsdk/calliope/cli.py", line 548, in Execute result = args.cmd_func(cli=self, args=args) File "/Users/lesv/google-cloud-sdk/./lib/googlecloudsdk/calliope/backend.py", line 1102, in Run result = command_instance.Run(args) File "/Users/lesv/google-cloud-sdk/lib/googlecloudsdk/appengine/app_commands/deploy.py", line 214, in Run client.DeployModule(module, version, info.parsed, info.file) File "/Users/lesv/google-cloud-sdk/./lib/googlecloudsdk/appengine/lib/appengine_client.py", line 276, in DeployModule return appversion.DoUpload() File "/Users/lesv/google-cloud-sdk/./lib/googlecloudsdk/appengine/lib/appengine_deployments.py", line 1042, in DoUpload app_summary = self.Commit() File "/Users/lesv/google-cloud-sdk/./lib/googlecloudsdk/appengine/lib/appengine_deployments.py", line 753, in Commit success, response = util.RetryNoBackoff(self.IsServing, PrintRetryMessage) File "/Users/lesv/google-cloud-sdk/./lib/googlecloudsdk/appengine/lib/util.py", line 225, in RetryNoBackoff max_tries) File "/Users/lesv/google-cloud-sdk/./lib/googlecloudsdk/appengine/lib/util.py", line 186, in RetryWithBackoff done, value = func() File "/Users/lesv/google-cloud-sdk/./lib/googlecloudsdk/appengine/lib/appengine_deployments.py", line 878, in IsServing raise CannotStartServingError(message or 'Unknown error.') CannotStartServingError: Not enough VMs ready (0/1 ready, 1 still deploying). Deployed Version: 20150723t122820.385924537062182967 2015-07-23 13:00:50,309 ERROR root (gcloud.preview.app.deploy) Not enough VMs ready (0/1 ready, 1 still deploying). Deployed Version: 20150723t122820.385924537062182967 2015-07-23 13:00:50,774 DEBUG root Metrics reporting process started...

lesv commented 9 years ago

Cool, found a Crash.log:

2015-07-23

Scanned: 2015-07-23 (12:52:24) - 2015-07-23 (13:03:33) View Options A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 ========= rebooting. ======================== A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 Container: e11694529295 A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 number of instances: 1 A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 Container: b22310eae8ab A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 exec: "${RUNTIME_DIR}/prerun.sh": stat ${RUNTIME_DIR}/prerun.sh: no such file or directory A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 Container: f55a76e029a2 A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 e11694529295 gcr.io/google_appengine/fluentd-logger:latest "/opt/google-fluentd 42 seconds ago Up 42 seconds focused_wilson A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 b22310eae8ab gcr.io/google_appengine/api-verifier:latest "./api_verifier.py" 2 seconds ago Exited (0) Less than a second ago sad_ptolemy A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 f55a76e029a2 gcr.io/_m_385924537062182967/rugged-memory-819.default.20150723t122820:latest "${RUNTIME_DIR}/prer 1 seconds ago gaeapp A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 CONTAINER ID IMAGE COMMAND CREATED STATUS PORTS NAMES A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 f55a76e029a2ff331169ad63a13782f97bc02d27772a7c782bdd3cd512af4e94 A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 Jul 23 20:03:32 vm_runtime_init: start 'run_app'. A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 Jul 23 20:03:32 vm_runtime_init: Done start 'memcache_proxy'. A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 Jul 23 20:03:32 Memcache proxy is disabled. A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 Jul 23 20:03:32 checking the status of memcache_proxy A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 Jul 23 20:03:32 Memcache proxy is disabled. A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 Jul 23 20:03:32 vm_runtime_init: start 'memcache_proxy'. A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 Jul 23 20:03:32 vm_runtime_init: Done start 'api_verifier'. A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 Jul 23 20:03:32 App Engine APIs are available. A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 number of instances: 1 A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 Jul 23 20:03:31 starting api_verifier A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 Jul 23 20:03:31 checking the status of api_verifier A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 Jul 23 20:03:31 vm_runtime_init: start 'api_verifier'. A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 Jul 23 20:03:31 vm_runtime_init: Done start 'build_app'. A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 Jul 23 20:03:31 vm_runtime_init: 'build_app': skipping for gcloud based deployment. A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 Jul 23 20:03:31 vm_runtime_init: start 'build_app'. A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 Jul 23 20:03:31 vm_runtime_init: Done start 'patch_dockerfile'. A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 Jul 23 20:03:31 vm_runtime_init: 'patch-dockerfile': skipping for empty patch. A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 Jul 23 20:03:31 vm_runtime_init: start 'patch_dockerfile'. A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 Jul 23 20:03:31 vm_runtime_init: Done start 'pull_app'. A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 Jul 23 20:03:31 Done pulling app container A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 Status: Downloaded newer image for gcr.io/_m_385924537062182967/rugged-memory-819.default.20150723t122820:latest A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 532a357f2450: Download complete A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 532a357f2450: Download complete A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 532a357f2450: Pulling fs layer A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 532a357f2450: Pulling metadata A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 a13e608eb3a3: Download complete A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 a13e608eb3a3: Pulling fs layer A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 a13e608eb3a3: Pulling metadata A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 43d5caaa9c85: Download complete A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 43d5caaa9c85: Pulling fs layer A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 43d5caaa9c85: Pulling metadata A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 4c33f5b38ada: Download complete A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 4c33f5b38ada: Pulling fs layer A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 4c33f5b38ada: Pulling metadata A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 b7728526f638: Download complete A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 b7728526f638: Pulling fs layer A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 b7728526f638: Pulling metadata A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 61bd0956c22d: Download complete A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 61bd0956c22d: Pulling fs layer A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 61bd0956c22d: Pulling metadata A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 b4943e6e4389: Download complete A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 ff223348bd0b: Download complete A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 5b37372f443b: Download complete A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 56532d97c843: Download complete A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 b78e0dccb156: Download complete A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 a6c8d21e77d8: Download complete A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 12c9949b2194: Download complete A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 baf40f08f779: Download complete A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 662e1936a4d2: Download complete A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 013fdc769851: Download complete A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 62190f6c9f96: Download complete A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 7dd8b8e18691: Download complete A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 433ec9fc872f: Download complete A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 11971b6377ef: Download complete A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 541923dd11eb: Download complete A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 511136ea3c5a: Download complete A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 532a357f2450: Pulling dependent layers A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 532a357f2450: Pulling image (latest) from gcr.io/_m_385924537062182967/rugged-memory-819.default.20150723t122820, endpoint: https://gcr.io/v1/ A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 532a357f2450: Pulling image (latest) from gcr.io/_m_385924537062182967/rugged-memory-819.default.20150723t122820 A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 Pulling repository gcr.io/_m_385924537062182967/rugged-memory-819.default.20150723t122820 A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 Jul 23 20:02:51 Pulling GAE_FULL_APP_CONTAINER: gcr.io/_m_385924537062182967/rugged-memory-819.default.20150723t122820 A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 Jul 23 20:02:51 vm_runtime_init: start 'pull_app'. A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 Jul 23 20:02:51 vm_runtime_init: Done start 'fluentd_logger'. A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 e11694529295fcd1a9711dbe457da0e5e74596c4f63def2d78b7f9dd9c9c8eb5 A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 Jul 23 20:02:51 vm_runtime_init: start 'fluentd_logger'. A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 Jul 23 20:02:51 vm_runtime_init: Done start 'docker'. A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 Jul 23 20:02:51 vm_runtime_init: start 'docker'. A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 Jul 23 20:02:51 vm_runtime_init: Done start 'unlocker'. A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 Jul 23 20:02:51 vm_runtime_init: start 'unlocker'. A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 Jul 23 20:02:51 vm_runtime_init: Done start 'allow_ssh'. A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 Jul 23 20:02:51 vm_runtime_init: start 'allow_ssh'. A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 Jul 23 20:02:51 Invoking all VM runtime components. /dev/fd/63 A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 time="2015-07-23T20:03:33Z" level=fatal msg="Error response from daemon: Cannot start container f55a76e029a2ff331169ad63a13782f97bc02d27772a7c782bdd3cd512af4e94: [8] System error: exec: \"${RUNTIME_DIR}/prerun.sh\": stat ${RUNTIME_DIR}/prerun.sh: no such file or directory" A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 vm_runtime_init: Jul 23 20:03:32 vm_runtime_init: start 'run_app'. A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 vm_runtime_init: Jul 23 20:03:32 vm_runtime_init: Done start 'memcache_proxy'. A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 vm_runtime_init: Jul 23 20:03:32 Memcache proxy is disabled. A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 vm_runtime_init: Jul 23 20:03:32 checking the status of memcache_proxy A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 vm_runtime_init: Jul 23 20:03:32 Memcache proxy is disabled. A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 vm_runtime_init: Jul 23 20:03:32 vm_runtime_init: start 'memcache_proxy'. A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 vm_runtime_init: Jul 23 20:03:32 vm_runtime_init: Done start 'api_verifier'. A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 vm_runtime_init: Jul 23 20:03:32 App Engine APIs are available. A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 vm_runtime_init: Jul 23 20:03:31 starting api_verifier A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 vm_runtime_init: Jul 23 20:03:31 checking the status of api_verifier A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 vm_runtime_init: Jul 23 20:03:31 vm_runtime_init: start 'api_verifier'. A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 vm_runtime_init: Jul 23 20:03:31 vm_runtime_init: Done start 'build_app'. A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 vm_runtime_init: Jul 23 20:03:31 vm_runtime_init: 'build_app': skipping for gcloud based deployment. A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 vm_runtime_init: Jul 23 20:03:31 vm_runtime_init: start 'build_app'. A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 vm_runtime_init: Jul 23 20:03:31 vm_runtime_init: Done start 'patch_dockerfile'. A gae-default-20150723t122820-rnwh 2015-07-2313:03:33.643 vm_runtime_init: Jul 23 20:03:31 vm_runtime_init: 'patch-dockerfile': skipping for empty patch. A 1438444386258842027 2015-07-2312:54:15.968 ========= rebooting. ======================== A 1438444386258842027 2015-07-2312:54:15.968 Container: 1d209a910fcb A 1438444386258842027 2015-07-2312:54:15.968 number of instances: 1 A 1438444386258842027 2015-07-2312:54:15.968 Container: 55646f380599 A 1438444386258842027 2015-07-2312:54:15.968 exec: "${RUNTIME_DIR}/prerun.sh": stat ${RUNTIME_DIR}/prerun.sh: no such file or directory A 1438444386258842027 2015-07-2312:54:15.968 Container: 9205b256b348 A 1438444386258842027 2015-07-2312:54:15.968 1d209a910fcb gcr.io/google_appengine/fluentd-logger:latest "/opt/google-fluentd 6 seconds ago Up 6 seconds distracted_lovelace A 1438444386258842027 2015-07-2312:54:15.968 55646f380599 gcr.io/google_appengine/api-verifier:latest "./api_verifier.py" 2 seconds ago Exited (0) Less than a second ago clever_pasteur A 1438444386258842027 2015-07-2312:54:15.968 9205b256b348 gcr.io/_m_385924537062182967/rugged-memory-819.default.20150723t122820:latest "${RUNTIME_DIR}/prer Less than a second ago gaeapp A 1438444386258842027 2015-07-2312:54:15.968 CONTAINER ID IMAGE COMMAND CREATED STATUS PORTS NAMES A 1438444386258842027 2015-07-2312:54:15.968 9205b256b34851855faf97a39688d555729ee95ef91b1428a1deda347fd608d6 A 1438444386258842027 2015-07-2312:54:15.968 Jul 23 19:54:15 vm_runtime_init: start 'run_app'. A 1438444386258842027 2015-07-2312:54:15.968 Jul 23 19:54:15 vm_runtime_init: Done start 'memcache_proxy'. A 1438444386258842027 2015-07-2312:54:15.968 Jul 23 19:54:15 Memcache proxy is disabled. A 1438444386258842027 2015-07-2312:54:15.968 Jul 23 19:54:15 checking the status of memcache_proxy A 1438444386258842027 2015-07-2312:54:15.968 Jul 23 19:54:15 Memcache proxy is disabled. A 1438444386258842027 2015-07-2312:54:15.968 Jul 23 19:54:15 vm_runtime_init: start 'memcache_proxy'. A 1438444386258842027 2015-07-2312:54:15.968 Jul 23 19:54:15 vm_runtime_init: Done start 'api_verifier'. A 1438444386258842027 2015-07-2312:54:15.968 Jul 23 19:54:15 App Engine APIs are available. A 1438444386258842027 2015-07-2312:54:15.968 number of instances: 1 A 1438444386258842027 2015-07-2312:54:15.968 Jul 23 19:54:13 starting api_verifier A 1438444386258842027 2015-07-2312:54:15.968 Jul 23 19:54:13 checking the status of api_verifier A 1438444386258842027 2015-07-2312:54:15.968 Jul 23 19:54:13 vm_runtime_init: start 'api_verifier'. A 1438444386258842027 2015-07-2312:54:15.968 Jul 23 19:54:13 vm_runtime_init: Done start 'build_app'. A 1438444386258842027 2015-07-2312:54:15.968 Jul 23 19:54:13 vm_runtime_init: 'build_app': skipping for gcloud based deployment. A 1438444386258842027 2015-07-2312:54:15.968 Jul 23 19:54:13 vm_runtime_init: start 'build_app'. A 1438444386258842027 2015-07-2312:54:15.968 Jul 23 19:54:13 vm_runtime_init: Done start 'patch_dockerfile'. A 1438444386258842027 2015-07-2312:54:15.968 Jul 23 19:54:13 vm_runtime_init: 'patch-dockerfile': skipping for empty patch. A 1438444386258842027 2015-07-2312:54:15.968 Jul 23 19:54:13 vm_runtime_init: start 'patch_dockerfile'. A 1438444386258842027 2015-07-2312:54:15.968 Jul 23 19:54:13 vm_runtime_init: Done start 'pull_app'. A 1438444386258842027 2015-07-2312:54:15.968 Jul 23 19:54:13 Done pulling app container A 1438444386258842027 2015-07-2312:54:15.968 Status: Downloaded newer image for gcr.io/_m_385924537062182967/rugged-memory-819.default.20150723t122820:latest A 1438444386258842027 2015-07-2312:54:15.968 532a357f2450: Download complete A 1438444386258842027 2015-07-2312:54:15.968 532a357f2450: Download complete A 1438444386258842027 2015-07-2312:54:15.968 532a357f2450: Pulling fs layer A 1438444386258842027 2015-07-2312:54:15.968 532a357f2450: Pulling metadata A 1438444386258842027 2015-07-2312:54:15.968 a13e608eb3a3: Download complete A 1438444386258842027 2015-07-2312:54:15.968 a13e608eb3a3: Pulling fs layer A 1438444386258842027 2015-07-2312:54:15.968 a13e608eb3a3: Pulling metadata A 1438444386258842027 2015-07-2312:54:15.968 43d5caaa9c85: Download complete A 1438444386258842027 2015-07-2312:54:15.968 43d5caaa9c85: Pulling fs layer A 1438444386258842027 2015-07-2312:54:15.968 43d5caaa9c85: Pulling metadata A 1438444386258842027 2015-07-2312:54:15.968 4c33f5b38ada: Download complete A 1438444386258842027 2015-07-2312:54:15.968 4c33f5b38ada: Pulling fs layer A 1438444386258842027 2015-07-2312:54:15.968 4c33f5b38ada: Pulling metadata A 1438444386258842027 2015-07-2312:54:15.968 b7728526f638: Download complete A 1438444386258842027 2015-07-2312:54:15.968 b7728526f638: Pulling fs layer A 1438444386258842027 2015-07-2312:54:15.968 b7728526f638: Pulling metadata A 1438444386258842027 2015-07-2312:54:15.968 61bd0956c22d: Download complete A 1438444386258842027 2015-07-2312:54:15.968 61bd0956c22d: Pulling fs layer A 1438444386258842027 2015-07-2312:54:15.968 61bd0956c22d: Pulling metadata A 1438444386258842027 2015-07-2312:54:15.968 b4943e6e4389: Download complete A 1438444386258842027 2015-07-2312:54:15.968 ff223348bd0b: Download complete A 1438444386258842027 2015-07-2312:54:15.968 5b37372f443b: Download complete A 1438444386258842027 2015-07-2312:54:15.968 56532d97c843: Download complete A 1438444386258842027 2015-07-2312:54:15.968 b78e0dccb156: Download complete A 1438444386258842027 2015-07-2312:54:15.968 a6c8d21e77d8: Download complete A 1438444386258842027 2015-07-2312:54:15.968 12c9949b2194: Download complete A 1438444386258842027 2015-07-2312:54:15.968 baf40f08f779: Download complete A 1438444386258842027 2015-07-2312:54:15.968 662e1936a4d2: Download complete A 1438444386258842027 2015-07-2312:54:15.968 013fdc769851: Download complete A 1438444386258842027 2015-07-2312:54:15.968 62190f6c9f96: Download complete A 1438444386258842027 2015-07-2312:54:15.968 7dd8b8e18691: Download complete A 1438444386258842027 2015-07-2312:54:15.968 433ec9fc872f: Download complete A 1438444386258842027 2015-07-2312:54:15.968 11971b6377ef: Download complete A 1438444386258842027 2015-07-2312:54:15.968 541923dd11eb: Download complete A 1438444386258842027 2015-07-2312:54:15.968 511136ea3c5a: Download complete A 1438444386258842027 2015-07-2312:54:15.968 532a357f2450: Pulling dependent layers A 1438444386258842027 2015-07-2312:54:15.968 532a357f2450: Pulling image (latest) from gcr.io/_m_385924537062182967/rugged-memory-819.default.20150723t122820, endpoint: https://gcr.io/v1/ A 1438444386258842027 2015-07-2312:54:15.968 532a357f2450: Pulling image (latest) from gcr.io/_m_385924537062182967/rugged-memory-819.default.20150723t122820 A 1438444386258842027 2015-07-2312:54:15.968 Pulling repository gcr.io/_m_385924537062182967/rugged-memory-819.default.20150723t122820 A 1438444386258842027 2015-07-2312:54:15.968 Jul 23 19:54:09 Pulling GAE_FULL_APP_CONTAINER: gcr.io/_m_385924537062182967/rugged-memory-819.default.20150723t122820 A 1438444386258842027 2015-07-2312:54:15.968 Jul 23 19:54:09 vm_runtime_init: start 'pull_app'. A 1438444386258842027 2015-07-2312:54:15.968 Jul 23 19:54:09 vm_runtime_init: Done start 'fluentd_logger'. A 1438444386258842027 2015-07-2312:54:15.968 1d209a910fcbd477338e763ea87ed4c1631412e3d86018bdf789e63d0b3386af A 1438444386258842027 2015-07-2312:54:15.968 Jul 23 19:54:08 vm_runtime_init: start 'fluentd_logger'. A 1438444386258842027 2015-07-2312:54:15.968 Jul 23 19:54:08 vm_runtime_init: Done start 'docker'. A 1438444386258842027 2015-07-2312:54:15.968 Jul 23 19:54:08 vm_runtime_init: start 'docker'. A 1438444386258842027 2015-07-2312:54:15.968 Jul 23 19:54:08 vm_runtime_init: Done start 'unlocker'. A 1438444386258842027 2015-07-2312:54:15.968 Jul 23 19:54:08 vm_runtime_init: start 'unlocker'. A 1438444386258842027 2015-07-2312:54:15.968 Jul 23 19:54:08 vm_runtime_init: Done start 'allow_ssh'. A 1438444386258842027 2015-07-2312:54:15.968 Jul 23 19:54:08 vm_runtime_init: start 'allow_ssh'. A 1438444386258842027 2015-07-2312:54:15.968 Jul 23 19:54:08 Invoking all VM runtime components. /dev/fd/63 A 1438444386258842027 2015-07-2312:54:15.968 time="2015-07-23T19:54:15Z" level=fatal msg="Error response from daemon: Cannot start container 9205b256b34851855faf97a39688d555729ee95ef91b1428a1deda347fd608d6: [8] System error: exec: \"${RUNTIME_DIR}/prerun.sh\": stat ${RUNTIME_DIR}/prerun.sh: no such file or directory" A 1438444386258842027 2015-07-2312:54:15.968 vm_runtime_init: Jul 23 19:54:15 vm_runtime_init: start 'run_app'. A 1438444386258842027 2015-07-2312:54:15.968 vm_runtime_init: Jul 23 19:54:15 vm_runtime_init: Done start 'memcache_proxy'. A 1438444386258842027 2015-07-2312:54:15.968 vm_runtime_init: Jul 23 19:54:15 Memcache proxy is disabled. A 1438444386258842027 2015-07-2312:54:15.968 vm_runtime_init: Jul 23 19:54:15 checking the status of memcache_proxy A 1438444386258842027 2015-07-2312:54:15.968 vm_runtime_init: Jul 23 19:54:15 Memcache proxy is disabled. A 1438444386258842027 2015-07-2312:54:15.968 vm_runtime_init: Jul 23 19:54:15 vm_runtime_init: start 'memcache_proxy'. A 1438444386258842027 2015-07-2312:54:15.968 vm_runtime_init: Jul 23 19:54:15 vm_runtime_init: Done start 'api_verifier'. A 1438444386258842027 2015-07-2312:54:15.968 vm_runtime_init: Jul 23 19:54:15 App Engine APIs are available. A 1438444386258842027 2015-07-2312:54:15.968 vm_runtime_init: Jul 23 19:54:13 starting api_verifier A 1438444386258842027 2015-07-2312:54:15.968 vm_runtime_init: Jul 23 19:54:13 checking the status of api_verifier A 1438444386258842027 2015-07-2312:54:15.968 vm_runtime_init: Jul 23 19:54:13 vm_runtime_init: start 'api_verifier'. A 1438444386258842027 2015-07-2312:54:15.968 vm_runtime_init: Jul 23 19:54:13 vm_runtime_init: Done start 'build_app'. A 1438444386258842027 2015-07-2312:54:15.968 vm_runtime_init: Jul 23 19:54:13 vm_runtime_init: 'build_app': skipping for gcloud based deployment. A 1438444386258842027 2015-07-2312:54:15.968 vm_runtime_init: Jul 23 19:54:13 vm_runtime_init: start 'build_app'. A 1438444386258842027 2015-07-2312:54:15.968 vm_runtime_init: Jul 23 19:54:13 vm_runtime_init: Done start 'patch_dockerfile'. A 1438444386258842027 2015-07-2312:54:15.968 vm_runtime_init: Jul 23 19:54:13 vm_runtime_init: 'patch-dockerfile': skipping for empty patch. A 8880013345550160665 2015-07-2312:52:24.743 ========= rebooting. ======================== A 8880013345550160665 2015-07-2312:52:24.743 Container: c9b34ee03877 A 8880013345550160665 2015-07-2312:52:24.743 number of instances: 1 A 8880013345550160665 2015-07-2312:52:24.743 Container: 4a3489128f0f A 8880013345550160665 2015-07-2312:52:24.743 exec: "${RUNTIME_DIR}/prerun.sh": stat ${RUNTIME_DIR}/prerun.sh: no such file or directory A 8880013345550160665 2015-07-2312:52:24.743 Container: 631f49a17afb A 8880013345550160665 2015-07-2312:52:24.743 c9b34ee03877 gcr.io/google_appengine/fluentd-logger:latest "/opt/google-fluentd 10 seconds ago Up 9 seconds happy_heisenberg A 8880013345550160665 2015-07-2312:52:24.743 4a3489128f0f gcr.io/google_appengine/api-verifier:latest "./api_verifier.py" 2 seconds ago Exited (0) Less than a second ago lonely_yonath A 8880013345550160665 2015-07-2312:52:24.743 631f49a17afb gcr.io/_m_385924537062182967/rugged-memory-819.default.20150723t122820:latest "${RUNTIME_DIR}/prer Less than a second ago gaeapp A 8880013345550160665 2015-07-2312:52:24.743 CONTAINER ID IMAGE COMMAND CREATED STATUS PORTS NAMES A 8880013345550160665 2015-07-2312:52:24.743 631f49a17afb847c2e197b967c2af2e00e046d79d3ac3aad5ae462065e3de9b2 A 8880013345550160665 2015-07-2312:52:24.743 Jul 23 19:52:24 vm_runtime_init: start 'run_app'. A 8880013345550160665 2015-07-2312:52:24.743 Jul 23 19:52:24 vm_runtime_init: Done start 'memcache_proxy'. A 8880013345550160665 2015-07-2312:52:24.743 Jul 23 19:52:23 Memcache proxy is disabled. A 8880013345550160665 2015-07-2312:52:24.743 Jul 23 19:52:23 checking the status of memcache_proxy A 8880013345550160665 2015-07-2312:52:24.743 Jul 23 19:52:23 Memcache proxy is disabled. A 8880013345550160665 2015-07-2312:52:24.743 Jul 23 19:52:23 vm_runtime_init: start 'memcache_proxy'. A 8880013345550160665 2015-07-2312:52:24.743 Jul 23 19:52:23 vm_runtime_init: Done start 'api_verifier'. A 8880013345550160665 2015-07-2312:52:24.743 Jul 23 19:52:23 App Engine APIs are available. A 8880013345550160665 2015-07-2312:52:24.743 number of instances: 1 A 8880013345550160665 2015-07-2312:52:24.743 Jul 23 19:52:22 starting api_verifier A 8880013345550160665 2015-07-2312:52:24.743 Jul 23 19:52:22 checking the status of api_verifier A 8880013345550160665 2015-07-2312:52:24.743 Jul 23 19:52:22 vm_runtime_init: start 'api_verifier'. A 8880013345550160665 2015-07-2312:52:24.743 Jul 23 19:52:22 vm_runtime_init: Done start 'build_app'. A 8880013345550160665 2015-07-2312:52:24.743 Jul 23 19:52:22 vm_runtime_init: 'build_app': skipping for gcloud based deployment. A 8880013345550160665 2015-07-2312:52:24.743 Jul 23 19:52:22 vm_runtime_init: start 'build_app'. A 8880013345550160665 2015-07-2312:52:24.743 Jul 23 19:52:22 vm_runtime_init: Done start 'patch_dockerfile'. A 8880013345550160665 2015-07-2312:52:24.743 Jul 23 19:52:22 vm_runtime_init: 'patch-dockerfile': skipping for empty patch. A 8880013345550160665 2015-07-2312:52:24.743 Jul 23 19:52:22 vm_runtime_init: start 'patch_dockerfile'. A 8880013345550160665 2015-07-2312:52:24.743 Jul 23 19:52:22 vm_runtime_init: Done start 'pull_app'. A 8880013345550160665 2015-07-2312:52:24.743 Jul 23 19:52:22 Done pulling app container A 8880013345550160665 2015-07-2312:52:24.743 Status: Downloaded newer image for gcr.io/_m_385924537062182967/rugged-memory-819.default.20150723t122820:latest A 8880013345550160665 2015-07-2312:52:24.743 532a357f2450: Download complete A 8880013345550160665 2015-07-2312:52:24.743 532a357f2450: Download complete A 8880013345550160665 2015-07-2312:52:24.743 532a357f2450: Pulling fs layer A 8880013345550160665 2015-07-2312:52:24.743 532a357f2450: Pulling metadata A 8880013345550160665 2015-07-2312:52:24.743 a13e608eb3a3: Download complete A 8880013345550160665 2015-07-2312:52:24.743 a13e608eb3a3: Pulling fs layer A 8880013345550160665 2015-07-2312:52:24.743 a13e608eb3a3: Pulling metadata A 8880013345550160665 2015-07-2312:52:24.743 43d5caaa9c85: Download complete A 8880013345550160665 2015-07-2312:52:24.743 43d5caaa9c85: Pulling fs layer A 8880013345550160665 2015-07-2312:52:24.743 43d5caaa9c85: Pulling metadata A 8880013345550160665 2015-07-2312:52:24.743 4c33f5b38ada: Download complete A 8880013345550160665 2015-07-2312:52:24.743 4c33f5b38ada: Pulling fs layer A 8880013345550160665 2015-07-2312:52:24.743 4c33f5b38ada: Pulling metadata A 8880013345550160665 2015-07-2312:52:24.743 b7728526f638: Download complete A 8880013345550160665 2015-07-2312:52:24.743 b7728526f638: Pulling fs layer A 8880013345550160665 2015-07-2312:52:24.743 b7728526f638: Pulling metadata A 8880013345550160665 2015-07-2312:52:24.743 61bd0956c22d: Download complete A 8880013345550160665 2015-07-2312:52:24.743 61bd0956c22d: Pulling fs layer A 8880013345550160665 2015-07-2312:52:24.743 61bd0956c22d: Pulling metadata A 8880013345550160665 2015-07-2312:52:24.743 b4943e6e4389: Download complete A 8880013345550160665 2015-07-2312:52:24.743 ff223348bd0b: Download complete A 8880013345550160665 2015-07-2312:52:24.743 5b37372f443b: Download complete A 8880013345550160665 2015-07-2312:52:24.743 56532d97c843: Download complete A 8880013345550160665 2015-07-2312:52:24.743 b78e0dccb156: Download complete A 8880013345550160665 2015-07-2312:52:24.743 a6c8d21e77d8: Download complete A 8880013345550160665 2015-07-2312:52:24.743 12c9949b2194: Download complete A 8880013345550160665 2015-07-2312:52:24.743 baf40f08f779: Download complete A 8880013345550160665 2015-07-2312:52:24.743 662e1936a4d2: Download complete A 8880013345550160665 2015-07-2312:52:24.743 013fdc769851: Download complete A 8880013345550160665 2015-07-2312:52:24.743 62190f6c9f96: Download complete A 8880013345550160665 2015-07-2312:52:24.743 7dd8b8e18691: Download complete A 8880013345550160665 2015-07-2312:52:24.743 433ec9fc872f: Download complete A 8880013345550160665 2015-07-2312:52:24.743 11971b6377ef: Download complete A 8880013345550160665 2015-07-2312:52:24.743 541923dd11eb: Download complete A 8880013345550160665 2015-07-2312:52:24.743 511136ea3c5a: Download complete A 8880013345550160665 2015-07-2312:52:24.743 532a357f2450: Pulling dependent layers A 8880013345550160665 2015-07-2312:52:24.743 532a357f2450: Pulling image (latest) from gcr.io/_m_385924537062182967/rugged-memory-819.default.20150723t122820, endpoint: https://gcr.io/v1/ A 8880013345550160665 2015-07-2312:52:24.743 532a357f2450: Pulling image (latest) from gcr.io/_m_385924537062182967/rugged-memory-819.default.20150723t122820 A 8880013345550160665 2015-07-2312:52:24.743 Pulling repository gcr.io/_m_385924537062182967/rugged-memory-819.default.20150723t122820 A 8880013345550160665 2015-07-2312:52:24.743 Jul 23 19:52:15 Pulling GAE_FULL_APP_CONTAINER: gcr.io/_m_385924537062182967/rugged-memory-819.default.20150723t122820 A 8880013345550160665 2015-07-2312:52:24.743 Jul 23 19:52:14 vm_runtime_init: start 'pull_app'. A 8880013345550160665 2015-07-2312:52:24.743 Jul 23 19:52:14 vm_runtime_init: Done start 'fluentd_logger'. A 8880013345550160665 2015-07-2312:52:24.743 c9b34ee0387719fa79e34ff00e45dba09389c7641b355c422a036bf53b757ea0 A 8880013345550160665 2015-07-2312:52:24.743 Jul 23 19:52:14 vm_runtime_init: start 'fluentd_logger'. A 8880013345550160665 2015-07-2312:52:24.743 Jul 23 19:52:14 vm_runtime_init: Done start 'docker'. A 8880013345550160665 2015-07-2312:52:24.743 Jul 23 19:52:14 vm_runtime_init: start 'docker'. A 8880013345550160665 2015-07-2312:52:24.743 Jul 23 19:52:14 vm_runtime_init: Done start 'unlocker'. A 8880013345550160665 2015-07-2312:52:24.743 Jul 23 19:52:14 vm_runtime_init: start 'unlocker'. A 8880013345550160665 2015-07-2312:52:24.743 Jul 23 19:52:14 vm_runtime_init: Done start 'allow_ssh'. A 8880013345550160665 2015-07-2312:52:24.743 Jul 23 19:52:14 vm_runtime_init: start 'allow_ssh'. A 8880013345550160665 2015-07-2312:52:24.743 Jul 23 19:52:14 Invoking all VM runtime components. /dev/fd/63 A 8880013345550160665 2015-07-2312:52:24.743 time="2015-07-23T19:52:24Z" level=fatal msg="Error response from daemon: Cannot start container 631f49a17afb847c2e197b967c2af2e00e046d79d3ac3aad5ae462065e3de9b2: [8] System error: exec: \"${RUNTIME_DIR}/prerun.sh\": stat ${RUNTIME_DIR}/prerun.sh: no such file or directory" A 8880013345550160665 2015-07-2312:52:24.743 vm_runtime_init: Jul 23 19:52:24 vm_runtime_init: start 'run_app'. A 8880013345550160665 2015-07-2312:52:24.743 vm_runtime_init: Jul 23 19:52:24 vm_runtime_init: Done start 'memcache_proxy'. A 8880013345550160665 2015-07-2312:52:24.743 vm_runtime_init: Jul 23 19:52:23 Memcache proxy is disabled. A 8880013345550160665 2015-07-2312:52:24.743 vm_runtime_init: Jul 23 19:52:23 checking the status of memcache_proxy A 8880013345550160665 2015-07-2312:52:24.743 vm_runtime_init: Jul 23 19:52:23 Memcache proxy is disabled. A 8880013345550160665 2015-07-2312:52:24.743 vm_runtime_init: Jul 23 19:52:23 vm_runtime_init: start 'memcache_proxy'. A 8880013345550160665 2015-07-2312:52:24.743 vm_runtime_init: Jul 23 19:52:23 vm_runtime_init: Done start 'api_verifier'. A 8880013345550160665 2015-07-2312:52:24.743 vm_runtime_init: Jul 23 19:52:23 App Engine APIs are available. A 8880013345550160665 2015-07-2312:52:24.743 vm_runtime_init: Jul 23 19:52:22 starting api_verifier A 8880013345550160665 2015-07-2312:52:24.743 vm_runtime_init: Jul 23 19:52:22 checking the status of api_verifier A 8880013345550160665 2015-07-2312:52:24.743 vm_runtime_init: Jul 23 19:52:22 vm_runtime_init: start 'api_verifier'. A 8880013345550160665 2015-07-2312:52:24.743 vm_runtime_init: Jul 23 19:52:22 vm_runtime_init: Done start 'build_app'. A 8880013345550160665 2015-07-2312:52:24.743 vm_runtime_init: Jul 23 19:52:22 vm_runtime_init: 'build_app': skipping for gcloud based deployment. A 8880013345550160665 2015-07-2312:52:24.743 vm_runtime_init: Jul 23 19:52:22 vm_runtime_init: start 'build_app'. A 8880013345550160665 2015-07-2312:52:24.743 vm_runtime_init: Jul 23 19:52:22 vm_runtime_init: Done start 'patch_dockerfile'. A 8880013345550160665 2015-07-2312:52:24.743 vm_runtime_init: Jul 23 19:52:22 vm_runtime_init: 'patch-dockerfile': skipping for empty patch.

lesv commented 9 years ago

That should be easy to fix, surprised it worked last time I tested it.

lesv commented 9 years ago

Ended up moving back to the open source runtime -- not sure what broke, but it was easier to fix.