Hi all, I discover app engine using the tutorials, starting with the "hello world" node one. All deployments fail with a cryptic token exchange error:
starting build "e47858c0-6cbc-4c73-bbbc-bf6b78cf4f8f" FETCHSOURCE BUILD Starting Step #0 - "fetcher" Step #0 - "fetcher": Already have image (with digest): gcr.io/cloud-builders/gcs-fetcher Step #0 - "fetcher": Fetching manifest gs://staging.lp-sandbox-254814.appspot.com/ae/5b39e792-2ec1-481e-86e3-ebd979ffb6e4/manifest.json. Step #0 - "fetcher": Processing 6 files. Step #0 - "fetcher": ****************************************************** Step #0 - "fetcher": Status: SUCCESS Step #0 - "fetcher": Started: 2019-10-04T12:25:48Z Step #0 - "fetcher": Completed: 2019-10-04T12:25:52Z Step #0 - "fetcher": Requested workers: 200 Step #0 - "fetcher": Actual workers: 6 Step #0 - "fetcher": Total files: 6 Step #0 - "fetcher": Total retries: 1 Step #0 - "fetcher": GCS timeouts: 1 Step #0 - "fetcher": MiB downloaded: 0.00 MiB Step #0 - "fetcher": MiB/s throughput: 0.00 MiB/s Step #0 - "fetcher": Time for manifest: 649.10 ms Step #0 - "fetcher": Total time: 3.88 s Step #0 - "fetcher": ****************************************************** Finished Step #0 - "fetcher" Starting Step #1 - "builder" Step #1 - "builder": Pulling image: gcr.io/gae-runtimes/nodejs10_app_builder:nodejs10_20190827_10_16_2_RC00 Step #1 - "builder": nodejs10_20190827_10_16_2_RC00: Pulling from gae-runtimes/nodejs10_app_builder Step #1 - "builder": Digest: sha256:c780ff233bda5bf40cb5c19ee8476b2965015f882c62d5cbd4bd3f28a30ec3eb Step #1 - "builder": Status: Downloaded newer image for gcr.io/gae-runtimes/nodejs10_app_builder:nodejs10_20190827_10_16_2_RC00 Step #1 - "builder": gcr.io/gae-runtimes/nodejs10_app_builder:nodejs10_20190827_10_16_2_RC00 Step #1 - "builder": 2019/10/04 12:25:56 Starting commonbuild with args [commonbuild --runtime=nodejs10 --entrypoint= --src=/workspace --config-file=/.gaeconfig/app_start.json -- ftl.par --name=eu.gcr.io/lp-sandbox-254814/app-engine-tmp/app/ttl-2h:5b39e792-2ec1-481e-86e3-ebd979ffb6e4 --directory=/workspace --destination=/srv --cache-repository=eu.gcr.io/lp-sandbox-254814/app-engine-tmp/build-cache/ttl-7d --cache --additional-directory=/.gaeconfig --builder-output-path="" --base=eu.gcr.io/gae-runtimes/nodejs10:nodejs10_20190827_10_16_2_RC00]. Step #1 - "builder": 2019/10/04 12:25:56 No start command generator found for nodejs10, using default app start command "serve". Step #1 - "builder": 2019/10/04 12:25:56 Writing configuration file "/.gaeconfig/app_start.json". Step #1 - "builder": 2019/10/04 12:25:56 Invoking build command "ftl.par --name=eu.gcr.io/lp-sandbox-254814/app-engine-tmp/app/ttl-2h:5b39e792-2ec1-481e-86e3-ebd979ffb6e4 --directory=/workspace --destination=/srv --cache-repository=eu.gcr.io/lp-sandbox-254814/app-engine-tmp/build-cache/ttl-7d --cache --additional-directory=/.gaeconfig --builder-output-path=\"\" --base=eu.gcr.io/gae-runtimes/nodejs10:nodejs10_20190827_10_16_2_RC00". Step #1 - "builder": INFO FTL version node-v0.17.0 Step #1 - "builder": INFO Beginning FTL build for node Step #1 - "builder": INFO FTL arg passed: exposed_ports None Step #1 - "builder": INFO FTL arg passed: cache_repository eu.gcr.io/lp-sandbox-254814/app-engine-tmp/build-cache/ttl-7d Step #1 - "builder": INFO FTL arg passed: tar_base_image_path None Step #1 - "builder": INFO FTL arg passed: export_cache_stats False Step #1 - "builder": INFO FTL arg passed: builder_output_path "" Step #1 - "builder": INFO FTL arg passed: name eu.gcr.io/lp-sandbox-254814/app-engine-tmp/app/ttl-2h:5b39e792-2ec1-481e-86e3-ebd979ffb6e4 Step #1 - "builder": INFO FTL arg passed: ttl 168 Step #1 - "builder": INFO FTL arg passed: global_cache False Step #1 - "builder": INFO FTL arg passed: cache True Step #1 - "builder": INFO FTL arg passed: upload True Step #1 - "builder": INFO FTL arg passed: sh_c_prefix False Step #1 - "builder": INFO FTL arg passed: fail_on_error True Step #1 - "builder": INFO FTL arg passed: base eu.gcr.io/gae-runtimes/nodejs10:nodejs10_20190827_10_16_2_RC00 Step #1 - "builder": INFO FTL arg passed: output_path None Step #1 - "builder": INFO FTL arg passed: cache_key_version v0.17.0 Step #1 - "builder": INFO FTL arg passed: cache_salt Step #1 - "builder": INFO FTL arg passed: directory /workspace Step #1 - "builder": INFO FTL arg passed: entrypoint None Step #1 - "builder": INFO FTL arg passed: additional_directory /.gaeconfig Step #1 - "builder": INFO FTL arg passed: destination_path /srv Step #1 - "builder": INFO FTL arg passed: verbosity NOTSET Step #1 - "builder": INFO starting: full build Step #1 - "builder": INFO starting: builder initialization Step #1 - "builder": INFO Loading Docker credentials for repository 'eu.gcr.io/gae-runtimes/nodejs10:nodejs10_20190827_10_16_2_RC00' Step #1 - "builder": INFO Loading Docker credentials for repository 'eu.gcr.io/lp-sandbox-254814/app-engine-tmp/app/ttl-2h:5b39e792-2ec1-481e-86e3-ebd979ffb6e4' Step #1 - "builder": INFO Found neither yarn.lock or package-lock.json,generating package-lock.json from package.json Step #1 - "builder": INFO starting: gen_package_lock Step #1 - "builder": INFO gen_package_lock npm install --package-lock-only Step #1 - "builder": INFO `gen_package_lock` stdout: Step #1 - "builder": added 159 packages and audited 333 packages in 5.665s Step #1 - "builder": found 0 vulnerabilities Step #1 - "builder": Step #1 - "builder": Step #1 - "builder": INFO `gen_package_lock` had stderr output: Step #1 - "builder": npm WARN deprecated [email protected]: Please note that v5.0.1+ of superagent removes User-Agent header by default, therefore you may need to add it yourself (e.g. GitHub blocks requests without a User-Agent header). This notice will go away with v5.0.2+ once it is released. Step #1 - "builder": npm notice created a lockfile as package-lock.json. You should commit this file. Step #1 - "builder": Step #1 - "builder": INFO gen_package_lock took 7 seconds Step #1 - "builder": INFO builder initialization took 7 seconds Step #1 - "builder": INFO starting: build process for FTL image Step #1 - "builder": INFO starting: rm_node_modules Step #1 - "builder": INFO rm_node_modules rm -rf /workspace/node_modules Step #1 - "builder": INFO `rm_node_modules` stdout: Step #1 - "builder": Step #1 - "builder": INFO rm_node_modules took 0 seconds Step #1 - "builder": INFO using descriptor:package-lock.json Step #1 - "builder": INFO using descriptor:package.json Step #1 - "builder": INFO starting: checking_cached_packages_json_layer Step #1 - "builder": DEBUG Checking cache for cache_key bc967823696f8875025eaf1f5c60f87795d5e53158acf0f2dd510681eb7cb633 Step #1 - "builder": INFO No cached base image found for entry: eu.gcr.io/lp-sandbox-254814/app-engine-tmp/build-cache/ttl-7d/node-cache:bc967823696f8875025eaf1f5c60f87795d5e53158acf0f2dd510681eb7cb633. Step #1 - "builder": INFO Cache miss on local cache for eu.gcr.io/lp-sandbox-254814/app-engine-tmp/build-cache/ttl-7d/node-cache:bc967823696f8875025eaf1f5c60f87795d5e53158acf0f2dd510681eb7cb633 Step #1 - "builder": INFO No cached dependency layer for bc967823696f8875025eaf1f5c60f87795d5e53158acf0f2dd510681eb7cb633 Step #1 - "builder": INFO [CACHE][MISS] v0.17.0:NODE->bc967823696f8875025eaf1f5c60f87795d5e53158acf0f2dd510681eb7cb633 Step #1 - "builder": INFO checking_cached_packages_json_layer took 0 seconds Step #1 - "builder": INFO starting: building_packages_json_layer Step #1 - "builder": INFO starting: npm_install Step #1 - "builder": INFO npm_install npm install --production Step #1 - "builder": INFO `npm_install` stdout: Step #1 - "builder": added 50 packages from 37 contributors and audited 333 packages in 3.386s Step #1 - "builder": found 0 vulnerabilities Step #1 - "builder": Step #1 - "builder": Step #1 - "builder": INFO npm_install took 4 seconds Step #1 - "builder": INFO starting: tar_runtime_package Step #1 - "builder": INFO tar_runtime_package tar -pcf /tmp/tmp9ogASw.tar --hard-dereference --transform flags=r;s,^,/srv/node_modules/, --exclude *.pyc . Step #1 - "builder": INFO `tar_runtime_package` stdout: Step #1 - "builder": Step #1 - "builder": INFO tar_runtime_package took 0 seconds Step #1 - "builder": INFO starting: gzip_tar_runtime_package Step #1 - "builder": INFO gzip_tar_runtime_package gzip /tmp/tmp9ogASw.tar -1 Step #1 - "builder": INFO `gzip_tar_runtime_package` stdout: Step #1 - "builder": Step #1 - "builder": INFO gzip_tar_runtime_package took 0 seconds Step #1 - "builder": INFO starting: rm_node_modules Step #1 - "builder": INFO rm_node_modules rm -rf /workspace/node_modules Step #1 - "builder": INFO `rm_node_modules` stdout: Step #1 - "builder": Step #1 - "builder": INFO rm_node_modules took 0 seconds Step #1 - "builder": INFO building_packages_json_layer took 4 seconds Step #1 - "builder": INFO starting: uploading_packages_json_layer Step #1 - "builder": INFO uploading_packages_json_layer took 0 seconds Step #1 - "builder": INFO build process for FTL image took 5 seconds Step #1 - "builder": INFO full build took 13 seconds Step #1 - "builder": Traceback (most recent call last): Step #1 - "builder": File "/usr/lib/python2.7/runpy.py", line 174, in _run_module_as_main Step #1 - "builder": "__main__", fname, loader, pkg_name) Step #1 - "builder": File "/usr/lib/python2.7/runpy.py", line 72, in _run_code Step #1 - "builder": exec code in run_globals Step #1 - "builder": File "/usr/local/bin/ftl.par/__main__.py", line 65, in <module> Step #1 - "builder": File "/usr/local/bin/ftl.par/__main__.py", line 54, in main Step #1 - "builder": File "/usr/local/bin/ftl.par/__main__/ftl/node/builder.py", line 81, in Build Step #1 - "builder": File "/usr/local/bin/ftl.par/__main__/ftl/node/layer_builder.py", line 85, in BuildLayer Step #1 - "builder": File "/usr/local/bin/ftl.par/__main__/ftl/common/cache.py", line 211, in Set Step #1 - "builder": File "/usr/local/bin/ftl.par/containerregistry/client/v2_2/docker_session_.py", line 71, in __init__ Step #1 - "builder": File "/usr/local/bin/ftl.par/containerregistry/client/v2_2/docker_http_.py", line 194, in __init__ Step #1 - "builder": File "/usr/local/bin/ftl.par/containerregistry/client/v2_2/docker_http_.py", line 288, in _Refresh Step #1 - "builder": File "/usr/local/bin/ftl.par/containerregistry/client/v2_2/docker_http_.py", line 140, in _CheckState Step #1 - "builder": containerregistry.client.v2_2.docker_http_.BadStateException: Bad status during token exchange: 400 Step #1 - "builder": {"errors":[{"code":"UNKNOWN","message":"Token exchange failed for project 'lp-sandbox-254814'. Bad Request."}]} Step #1 - "builder": 2019/10/04 12:26:10 INFO FTL version node-v0.17.0 Step #1 - "builder": INFO Beginning FTL build for node Step #1 - "builder": INFO FTL arg passed: exposed_ports None Step #1 - "builder": INFO FTL arg passed: cache_repository eu.gcr.io/lp-sandbox-254814/app-engine-tmp/build-cache/ttl-7d Step #1 - "builder": INFO FTL arg passed: tar_base_image_path None Step #1 - "builder": INFO FTL arg passed: export_cache_stats False Step #1 - "builder": INFO FTL arg passed: builder_output_path "" Step #1 - "builder": INFO FTL arg passed: name eu.gcr.io/lp-sandbox-254814/app-engine-tmp/app/ttl-2h:5b39e792-2ec1-481e-86e3-ebd979ffb6e4 Step #1 - "builder": INFO FTL arg passed: ttl 168 Step #1 - "builder": INFO FTL arg passed: global_cache False Step #1 - "builder": INFO FTL arg passed: cache True Step #1 - "builder": INFO FTL arg passed: upload True Step #1 - "builder": INFO FTL arg passed: sh_c_prefix False Step #1 - "builder": INFO FTL arg passed: fail_on_error True Step #1 - "builder": INFO FTL arg passed: base eu.gcr.io/gae-runtimes/nodejs10:nodejs10_20190827_10_16_2_RC00 Step #1 - "builder": INFO FTL arg passed: output_path None Step #1 - "builder": INFO FTL arg passed: cache_key_version v0.17.0 Step #1 - "builder": INFO FTL arg passed: cache_salt Step #1 - "builder": INFO FTL arg passed: directory /workspace Step #1 - "builder": INFO FTL arg passed: entrypoint None Step #1 - "builder": INFO FTL arg passed: additional_directory /.gaeconfig Step #1 - "builder": INFO FTL arg passed: destination_path /srv Step #1 - "builder": INFO FTL arg passed: verbosity NOTSET Step #1 - "builder": INFO starting: full build Step #1 - "builder": INFO starting: builder initialization Step #1 - "builder": INFO Loading Docker credentials for repository 'eu.gcr.io/gae-runtimes/nodejs10:nodejs10_20190827_10_16_2_RC00' Step #1 - "builder": INFO Loading Docker credentials for repository 'eu.gcr.io/lp-sandbox-254814/app-engine-tmp/app/ttl-2h:5b39e792-2ec1-481e-86e3-ebd979ffb6e4' Step #1 - "builder": INFO Found neither yarn.lock or package-lock.json,generating package-lock.json from package.json Step #1 - "builder": INFO starting: gen_package_lock Step #1 - "builder": INFO gen_package_lock npm install --package-lock-only Step #1 - "builder": INFO `gen_package_lock` stdout: Step #1 - "builder": added 159 packages and audited 333 packages in 5.665s Step #1 - "builder": found 0 vulnerabilities Step #1 - "builder": Step #1 - "builder": Step #1 - "builder": INFO `gen_package_lock` had stderr output: Step #1 - "builder": npm WARN deprecated [email protected]: Please note that v5.0.1+ of superagent removes User-Agent header by default, therefore you may need to add it yourself (e.g. GitHub blocks requests without a User-Agent header). This notice will go away with v5.0.2+ once it is released. Step #1 - "builder": npm notice created a lockfile as package-lock.json. You should commit this file. Step #1 - "builder": Step #1 - "builder": INFO gen_package_lock took 7 seconds Step #1 - "builder": INFO builder initialization took 7 seconds Step #1 - "builder": INFO starting: build process for FTL image Step #1 - "builder": INFO starting: rm_node_modules Step #1 - "builder": INFO rm_node_modules rm -rf /workspace/node_modules Step #1 - "builder": INFO `rm_node_modules` stdout: Step #1 - "builder": Step #1 - "builder": INFO rm_node_modules took 0 seconds Step #1 - "builder": INFO using descriptor:package-lock.json Step #1 - "builder": INFO using descriptor:package.json Step #1 - "builder": INFO starting: checking_cached_packages_json_layer Step #1 - "builder": DEBUG Checking cache for cache_key bc967823696f8875025eaf1f5c60f87795d5e53158acf0f2dd510681eb7cb633 Step #1 - "builder": INFO No cached base image found for entry: eu.gcr.io/lp-sandbox-254814/app-engine-tmp/build-cache/ttl-7d/node-cache:bc967823696f8875025eaf1f5c60f87795d5e53158acf0f2dd510681eb7cb633. Step #1 - "builder": INFO Cache miss on local cache for eu.gcr.io/lp-sandbox-254814/app-engine-tmp/build-cache/ttl-7d/node-cache:bc967823696f8875025eaf1f5c60f87795d5e53158acf0f2dd510681eb7cb633 Step #1 - "builder": INFO No cached dependency layer for bc967823696f8875025eaf1f5c60f87795d5e53158acf0f2dd510681eb7cb633 Step #1 - "builder": INFO [CACHE][MISS] v0.17.0:NODE->bc967823696f8875025eaf1f5c60f87795d5e53158acf0f2dd510681eb7cb633 Step #1 - "builder": INFO checking_cached_packages_json_layer took 0 seconds Step #1 - "builder": INFO starting: building_packages_json_layer Step #1 - "builder": INFO starting: npm_install Step #1 - "builder": INFO npm_install npm install --production Step #1 - "builder": INFO `npm_install` stdout: Step #1 - "builder": added 50 packages from 37 contributors and audited 333 packages in 3.386s Step #1 - "builder": found 0 vulnerabilities Step #1 - "builder": Step #1 - "builder": Step #1 - "builder": INFO npm_install took 4 seconds Step #1 - "builder": INFO starting: tar_runtime_package Step #1 - "builder": INFO tar_runtime_package tar -pcf /tmp/tmp9ogASw.tar --hard-dereference --transform flags=r;s,^,/srv/node_modules/, --exclude *.pyc . Step #1 - "builder": INFO `tar_runtime_package` stdout: Step #1 - "builder": Step #1 - "builder": INFO tar_runtime_package took 0 seconds Step #1 - "builder": INFO starting: gzip_tar_runtime_package Step #1 - "builder": INFO gzip_tar_runtime_package gzip /tmp/tmp9ogASw.tar -1 Step #1 - "builder": INFO `gzip_tar_runtime_package` stdout: Step #1 - "builder": Step #1 - "builder": INFO gzip_tar_runtime_package took 0 seconds Step #1 - "builder": INFO starting: rm_node_modules Step #1 - "builder": INFO rm_node_modules rm -rf /workspace/node_modules Step #1 - "builder": INFO `rm_node_modules` stdout: Step #1 - "builder": Step #1 - "builder": INFO rm_node_modules took 0 seconds Step #1 - "builder": INFO building_packages_json_layer took 4 seconds Step #1 - "builder": INFO starting: uploading_packages_json_layer Step #1 - "builder": INFO uploading_packages_json_layer took 0 seconds Step #1 - "builder": INFO build process for FTL image took 5 seconds Step #1 - "builder": INFO full build took 13 seconds Step #1 - "builder": Traceback (most recent call last): Step #1 - "builder": File "/usr/lib/python2.7/runpy.py", line 174, in _run_module_as_main Step #1 - "builder": "__main__", fname, loader, pkg_name) Step #1 - "builder": File "/usr/lib/python2.7/runpy.py", line 72, in _run_code Step #1 - "builder": exec code in run_globals Step #1 - "builder": File "/usr/local/bin/ftl.par/__main__.py", line 65, in <module> Step #1 - "builder": File "/usr/local/bin/ftl.par/__main__.py", line 54, in main Step #1 - "builder": File "/usr/local/bin/ftl.par/__main__/ftl/node/builder.py", line 81, in Build Step #1 - "builder": File "/usr/local/bin/ftl.par/__main__/ftl/node/layer_builder.py", line 85, in BuildLayer Step #1 - "builder": File "/usr/local/bin/ftl.par/__main__/ftl/common/cache.py", line 211, in Set Step #1 - "builder": File "/usr/local/bin/ftl.par/containerregistry/client/v2_2/docker_session_.py", line 71, in __init__ Step #1 - "builder": File "/usr/local/bin/ftl.par/containerregistry/client/v2_2/docker_http_.py", line 194, in __init__ Step #1 - "builder": File "/usr/local/bin/ftl.par/containerregistry/client/v2_2/docker_http_.py", line 288, in _Refresh Step #1 - "builder": File "/usr/local/bin/ftl.par/containerregistry/client/v2_2/docker_http_.py", line 140, in _CheckState Step #1 - "builder": containerregistry.client.v2_2.docker_http_.BadStateException: Bad status during token exchange: 400 Step #1 - "builder": {"errors":[{"code":"UNKNOWN","message":"Token exchange failed for project 'lp-sandbox-254814'. Bad Request."}]} Finished Step #1 - "builder" ERROR ERROR: build step 1 "gcr.io/gae-runtimes/nodejs10_app_builder:nodejs10_20190827_10_16_2_RC00" failed: exit status 1 I own the project, and I use my user account for the gcloud configuration. Looked for the error on SO and here, not a single hit. What do I do wrong ? Thanks -- You received this message because you are subscribed to the Google Groups "Google App Engine" group. To unsubscribe from this group and stop receiving emails from it, send an email to [email protected]. To view this discussion on the web visit https://groups.google.com/d/msgid/google-appengine/f03fd78d-5318-4ba9-8a99-a79df0f2387b%40googlegroups.com.
