Verbose Output

gistfile1.txt

gcloud --verbosity debug preview app run ./app.yaml
DEBUG: Running gcloud.preview.app.run with Namespace(admin_host=None, allow_skipped_files=False, api_host=None, appidentity_email_address=None, appidentity_private_key_path=None, auth_domain='gmail.com', blobstore_path=None, clear_datastore=False, cmd_func=<bound method Command.Run of <googlecloudsdk.calliope.backend.Command object at 0x10aae2610>>, command_path=['gcloud', 'preview', 'app', 'run'], datastore_consistency_policy='time', datastore_path=None, default_gcs_bucket_name=None, enable_cloud_datastore=False, enable_mvm_logs=False, enable_sendmail=False, format=None, h=None, help=None, host=None, jvm_flag=None, log_http=None, log_level=None, logs_path=None, markdown=None, max_module_instances=None, modules=['./app.yaml'], php_executable_path=None, project=None, python_startup_script=None, quiet=None, require_indexes=False, show_mail_body=False, smtp_allow_tls=False, smtp_host=None, smtp_password=None, smtp_user=None, storage_path=None, trace_token=None, use_mtime_file_watcher=False, user_output_enabled=None, verbosity='debug', version=None).
DEBUG: Found Cloud SDK root: /Users/markhayden/google-cloud-sdk
DEBUG: Found App Engine SDK root: /Users/markhayden/google-cloud-sdk/platform/google_appengine
DEBUG: Command sys.path: ['/Users/markhayden/google-cloud-sdk/platform/google_appengine/lib/antlr3', '/Users/markhayden/google-cloud-sdk/platform/google_appengine/lib/fancy_urllib', '/Users/markhayden/google-cloud-sdk/platform/google_appengine/lib/ipaddr', '/Users/markhayden/google-cloud-sdk/platform/google_appengine/lib/yaml-3.10', '/Users/markhayden/google-cloud-sdk/platform/google_appengine/lib/rsa', '/Users/markhayden/google-cloud-sdk/platform/google_appengine/lib/pyasn1', '/Users/markhayden/google-cloud-sdk/platform/google_appengine/lib/pyasn1_modules', '/Users/markhayden/google-cloud-sdk/platform/google_appengine/lib/httplib2', '/Users/markhayden/google-cloud-sdk/platform/google_appengine/lib/oauth2client', '/Users/markhayden/google-cloud-sdk/platform/google_appengine', '/Users/markhayden/google-cloud-sdk/platform/google_appengine/lib/concurrent', '/Users/markhayden/google-cloud-sdk/platform/google_appengine/lib/cherrypy', '/Users/markhayden/google-cloud-sdk/platform/google_appengine/lib/distutils', '/Users/markhayden/google-cloud-sdk/platform/google_appengine/lib/requests', '/Users/markhayden/google-cloud-sdk/platform/google_appengine/lib/six', '/Users/markhayden/google-cloud-sdk/platform/google_appengine/lib/websocket', '/Users/markhayden/google-cloud-sdk/platform/google_appengine/lib/jinja2-2.6', '/Users/markhayden/google-cloud-sdk/platform/google_appengine/lib/webob-1.2.3', '/Users/markhayden/google-cloud-sdk/platform/google_appengine/lib/webapp2-2.5.1', '/Users/markhayden/google-cloud-sdk/./lib', '/Users/markhayden/google-cloud-sdk/lib/googlecloudsdk/gcloud', '/Users/markhayden/google-cloud-sdk/lib', '/System/Library/Frameworks/Python.framework/Versions/2.7/lib/python27.zip', '/System/Library/Frameworks/Python.framework/Versions/2.7/lib/python2.7/', '/System/Library/Frameworks/Python.framework/Versions/2.7/lib/python2.7/plat-darwin', '/System/Library/Frameworks/Python.framework/Versions/2.7/lib/python2.7/plat-mac', '/System/Library/Frameworks/Python.framework/Versions/2.7/lib/python2.7/plat-mac/lib-scriptpackages', '/System/Library/Frameworks/Python.framework/Versions/2.7/lib/python2.7/../../Extras/lib/python', '/System/Library/Frameworks/Python.framework/Versions/2.7/lib/python2.7/lib-tk', '/System/Library/Frameworks/Python.framework/Versions/2.7/lib/python2.7/lib-old', '/System/Library/Frameworks/Python.framework/Versions/2.7/lib/python2.7/lib-dynload']
DEBUG: Found Cloud SDK root: /Users/markhayden/google-cloud-sdk
Module [default] found in file [/Users/markhayden/google-cloud-sdk/platform/google_appengine/goroot/src/appengine-try-go/app.yaml]
INFO: Looking for the Dockerfile in /Users/markhayden/google-cloud-sdk/platform/google_appengine/goroot/src/appengine-try-go
INFO: Using Dockerfile found in /Users/markhayden/google-cloud-sdk/platform/google_appengine/goroot/src/appengine-try-go
DEBUG: Found Cloud SDK root: /Users/markhayden/google-cloud-sdk
DEBUG: Detected docker environment variables: DOCKER_HOST=tcp://192.168.59.103:2376, DOCKER_CERT_PATH=/Users/markhayden/.boot2docker/certs/boot2docker-vm, DOCKER_TLS_VERIFY=1
DEBUG: Found images: [u'<none>:<none>', u'<none>:<none>', u'<none>:<none>', u'<none>:<none>', u'<none>:<none>', u'<none>:<none>', u'<none>:<none>', u'<none>:<none>', u'<none>:<none>', u'<none>:<none>', u'<none>:<none>', u'<none>:<none>', u'<none>:<none>', u'<none>:<none>', u'<none>:<none>', u'<none>:<none>', u'<none>:<none>', u'<none>:<none>', u'<none>:<none>', u'<none>:<none>', u'<none>:<none>', u'<none>:<none>', u'<none>:<none>', u'<none>:<none>', u'<none>:<none>', u'<none>:<none>', u'<none>:<none>', u'<none>:<none>', u'<none>:<none>', u'<none>:<none>', u'<none>:<none>', u'<none>:<none>', u'<none>:<none>', u'<none>:<none>', u'<none>:<none>', u'<none>:<none>', u'<none>:<none>', u'<none>:<none>', u'<none>:<none>', u'<none>:<none>', u'gcloud-credentials-image:latest', u'<none>:<none>', u'<none>:<none>', u'<none>:<none>', u'google/appengine-log-server:latest', u'google/appengine-log-processor:latest', u'google/appengine-go:latest', u'hello-world:latest', u'busybox:latest', u'google/docker-registry:latest']
DEBUG: Found image: google/appengine-go
DEBUG: Running [dev_appserver.py] with: --allow_skipped_files=False --application=genuine-octagon-713 --auth_domain=gmail.com --clear_datastore=False --datastore_consistency_policy=time --dev_appserver_log_level=debug --enable_cloud_datastore=False --enable_mvm_logs=False --enable_sendmail=False --log_level=debug --php_executable_path=/Users/markhayden/google-cloud-sdk/bin/bootstrapping/php-cgi --require_indexes=False --show_mail_body=False --skip_sdk_update_check=True --smtp_allow_tls=False --use_mtime_file_watcher=False /Users/markhayden/google-cloud-sdk/platform/google_appengine/goroot/src/appengine-try-go/app.yaml
INFO     2015-03-05 22:28:29,031 devappserver2.py:726] Skipping SDK update check.
DEBUG    2015-03-05 22:28:29,100 app_identity_stub.py:196] Successfully loaded Application Default Credentials.
DEBUG    2015-03-05 22:28:29,108 wsgi_server.py:384] Failed to bind "fe80::1%lo0:63723": ('Unable to bind fe80::1%lo0:63723', error(49, "Can't assign requested address"))
INFO     2015-03-05 22:28:29,108 api_server.py:172] Starting API server at: http://localhost:63723
DEBUG    2015-03-05 22:28:29,109 containers.py:669] Detected docker environment variables: DOCKER_HOST=tcp://192.168.59.103:2376, DOCKER_CERT_PATH=/Users/markhayden/.boot2docker/certs/boot2docker-vm, DOCKER_TLS_VERIFY=1
DEBUG    2015-03-05 22:28:29,157 wsgi_server.py:346] Failed to bind "fe80::1%lo0:8080": ('Unable to bind fe80::1%lo0:8080', error(49, "Can't assign requested address"))
DEBUG    2015-03-05 22:28:29,159 wsgi_server.py:384] Failed to bind "fe80::1%lo0:63725": ('Unable to bind fe80::1%lo0:63725', error(49, "Can't assign requested address"))
INFO     2015-03-05 22:28:29,160 vm_runtime_proxy_go.py:107] Starting Go VM Deployment process
INFO     2015-03-05 22:28:29,160 dispatcher.py:186] Starting module "default" running at: http://localhost:8080
DEBUG    2015-03-05 22:28:29,163 wsgi_server.py:346] Failed to bind "fe80::1%lo0:8000": ('Unable to bind fe80::1%lo0:8000', error(49, "Can't assign requested address"))
INFO     2015-03-05 22:28:29,163 admin_server.py:118] Starting admin server at: http://localhost:8000
DEBUG    2015-03-05 22:28:29,165 safe_subprocess.py:60] Starting process ['/Users/markhayden/google-cloud-sdk/platform/google_appengine/goroot/bin/go-app-builder', '-app_base', '/Users/markhayden/google-cloud-sdk/platform/google_appengine/goroot/src/appengine-try-go', '-arch', '6', '-dynamic', '-goroot', '/Users/markhayden/google-cloud-sdk/platform/google_appengine/goroot', '-nobuild_files', '^^$', '-unsafe', '-gopath', '/Users/markhayden/go', '-print_extras', '-vm', 'hello/hello.go'] with input='', env={'GOARCH': 'amd64', 'GOOS': 'linux'}, cwd=None
INFO     2015-03-05 22:28:29,230 containers.py:259] Building docker image genuine-octagon-713.default.1 from /var/folders/lv/9hzw2s5d25v17j4wph5pl46c0000gn/T/tmpHWExOwgo_deployment_dir/Dockerfile:
INFO     2015-03-05 22:28:29,230 containers.py:261] --------------------  DOCKER BUILD  --------------------
INFO     2015-03-05 22:28:29,592 containers.py:280] ---> 3b6b889b2273
INFO     2015-03-05 22:28:29,592 containers.py:280] Step 1 : ADD . /app
INFO     2015-03-05 22:28:29,883 containers.py:280] ---> 9e27ca7ac37a
INFO     2015-03-05 22:28:29,883 containers.py:280] Removing intermediate container 284e8c701c9f
INFO     2015-03-05 22:28:29,883 containers.py:280] Step 2 : RUN /bin/bash /app/_ah/build.sh
INFO     2015-03-05 22:28:29,997 containers.py:280] ---> Running in 5797a681e58e
INFO     2015-03-05 22:28:30,253 containers.py:280] b02fde1ce30965d84e52f461de37655580e16956  /app/_ah/gab
INFO     2015-03-05 22:28:30,265 containers.py:280] /goroot/pkg/tool/linux_amd64/6g: unknown flag -trimpath

INFO     2015-03-05 22:28:30,265 containers.py:280] 2015/03/05 22:28:30 go-app-builder: build timing: 1×6g (0 total), 0×gopack (0 total), 0×6l (0 total)

INFO     2015-03-05 22:28:30,266 containers.py:280] 2015/03/05 22:28:30 go-app-builder: failed running 6g: exit status 1

ERROR    2015-03-05 22:28:30,470 containers.py:283] The command [/bin/sh -c /bin/bash /app/_ah/build.sh] returned a non-zero code: 1
INFO     2015-03-05 22:28:30,470 containers.py:292] --------------------------------------------------------
INFO     2015-03-05 22:28:30,471 vm_runtime_proxy_go.py:133] Go VM Deployment process failed: Docker build aborted: The command [/bin/sh -c /bin/bash /app/_ah/build.sh] returned a non-zero code: 1
ERROR    2015-03-05 22:28:30,471 instance.py:279] Docker build aborted: The command [/bin/sh -c /bin/bash /app/_ah/build.sh] returned a non-zero code: 1
Traceback (most recent call last):
  File "/Users/markhayden/google-cloud-sdk/platform/google_appengine/google/appengine/tools/devappserver2/instance.py", line 275, in start
    self._runtime_proxy.start()
  File "/Users/markhayden/google-cloud-sdk/platform/google_appengine/google/appengine/tools/devappserver2/vm_runtime_proxy_go.py", line 121, in start
    request_id_header_name=REQUEST_ID_HEADER_NAME)
  File "/Users/markhayden/google-cloud-sdk/platform/google_appengine/google/appengine/tools/devappserver2/vm_runtime_proxy.py", line 286, in start
    self._container.Start()
  File "/Users/markhayden/google-cloud-sdk/platform/google_appengine/google/appengine/tools/docker/containers.py", line 532, in Start
    self._image.Build()
  File "/Users/markhayden/google-cloud-sdk/platform/google_appengine/google/appengine/tools/docker/containers.py", line 309, in Build
    raise ImageError(msg)
ImageError: Docker build aborted: The command [/bin/sh -c /bin/bash /app/_ah/build.sh] returned a non-zero code: 1
ERROR    2015-03-05 22:28:30,473 instance.py:280] Docker build aborted: The command [/bin/sh -c /bin/bash /app/_ah/build.sh] returned a non-zero code: 1
INFO     2015-03-05 22:28:30,473 health_check_service.py:101] Health checks starting for instance 0.
DEBUG    2015-03-05 22:28:30,474 health_check_service.py:115] Performing health check for instance 0.
DEBUG    2015-03-05 22:28:30,475 module.py:1563] Dispatching request to <Instance 0: 0/1, total: 0 [not started handling ready request]> after 0.0000s pending
DEBUG    2015-03-05 22:28:50,479 module.py:737] default: "GET /_ah/health?IsLastSuccessful=no HTTP/1.1" 503 -
DEBUG    2015-03-05 22:28:50,479 health_check_service.py:160] Health check response [''] and status 503 Service Unavailable for instance 0.
DEBUG    2015-03-05 22:28:50,480 health_check_service.py:118] Health check state for instance: 0: 1 consecutive UNHEALTHY responses.
DEBUG    2015-03-05 22:28:55,484 health_check_service.py:115] Performing health check for instance 0.
DEBUG    2015-03-05 22:28:55,486 module.py:1563] Dispatching request to <Instance 0: 0/1, total: 0 [not started handling ready request]> after 0.0000s pending
DEBUG    2015-03-05 22:29:15,492 module.py:737] default: "GET /_ah/health?IsLastSuccessful=no HTTP/1.1" 503 -
DEBUG    2015-03-05 22:29:15,492 health_check_service.py:160] Health check response [''] and status 503 Service Unavailable for instance 0.
DEBUG    2015-03-05 22:29:15,492 health_check_service.py:118] Health check state for instance: 0: 2 consecutive UNHEALTHY responses.
DEBUG    2015-03-05 22:29:20,497 health_check_service.py:115] Performing health check for instance 0.
DEBUG    2015-03-05 22:29:20,499 module.py:1563] Dispatching request to <Instance 0: 0/1, total: 0 [not started handling ready request]> after 0.0000s pending