2023-09-10T18:59:13,464 Created temporary directory: /tmp/pip-build-tracker-0sfeb8td
2023-09-10T18:59:13,465 Initialized build tracking at /tmp/pip-build-tracker-0sfeb8td
2023-09-10T18:59:13,466 Created build tracker: /tmp/pip-build-tracker-0sfeb8td
2023-09-10T18:59:13,466 Entered build tracker: /tmp/pip-build-tracker-0sfeb8td
2023-09-10T18:59:13,468 Created temporary directory: /tmp/pip-wheel-vqs16tq5
2023-09-10T18:59:13,471 Created temporary directory: /tmp/pip-ephem-wheel-cache-uwug9dpt
2023-09-10T18:59:13,495 Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple
2023-09-10T18:59:13,499 2 location(s) to search for versions of middleware-test:
2023-09-10T18:59:13,499 * https://pypi.org/simple/middleware-test/
2023-09-10T18:59:13,499 * https://www.piwheels.org/simple/middleware-test/
2023-09-10T18:59:13,499 Fetching project page and analyzing links: https://pypi.org/simple/middleware-test/
2023-09-10T18:59:13,500 Getting page https://pypi.org/simple/middleware-test/
2023-09-10T18:59:13,502 Found index url https://pypi.org/simple/
2023-09-10T18:59:13,643 Fetched page https://pypi.org/simple/middleware-test/ as application/vnd.pypi.simple.v1+json
2023-09-10T18:59:13,648   Found link https://files.pythonhosted.org/packages/37/2d/fd48ac9c1bfdc6b0028a12124561683b4f237b3a59f02730a3966000e50c/middleware_test-1.1.2.tar.gz (from https://pypi.org/simple/middleware-test/), version: 1.1.2
2023-09-10T18:59:13,648   Found link https://files.pythonhosted.org/packages/2c/e8/798de99e3bd1e8ba2a5625d9181a427ab3a16d2b9bb45e5375e5328aca62/middleware_test-1.1.3.tar.gz (from https://pypi.org/simple/middleware-test/), version: 1.1.3
2023-09-10T18:59:13,649   Found link https://files.pythonhosted.org/packages/a3/14/0648a1da05212d232821f9dc02ab3000fe39cd8aabc920abe0459ae2bf87/middleware_test-1.1.4.tar.gz (from https://pypi.org/simple/middleware-test/), version: 1.1.4
2023-09-10T18:59:13,650   Found link https://files.pythonhosted.org/packages/d4/10/4ec68c8a2b231f20b9734355fb9eac55b1b5c9cd81719d5441b32ef8f104/middleware_test-1.1.5.tar.gz (from https://pypi.org/simple/middleware-test/), version: 1.1.5
2023-09-10T18:59:13,651   Found link https://files.pythonhosted.org/packages/3c/ec/6e0d09496314d0bb97795f2145063525b26feb73b98755f67265b9ff5c1b/middleware_test-1.1.6.tar.gz (from https://pypi.org/simple/middleware-test/), version: 1.1.6
2023-09-10T18:59:13,651   Found link https://files.pythonhosted.org/packages/66/c9/ee7615246a791c0e3435788db12f58d023414cb57081461329bf2ae30cf8/middleware_test-1.1.7.tar.gz (from https://pypi.org/simple/middleware-test/), version: 1.1.7
2023-09-10T18:59:13,652   Found link https://files.pythonhosted.org/packages/27/75/88a030dc18161d199cd5f354f28f6a4799f75cb01664d9eb5b17315b935a/middleware_test-1.1.8.tar.gz (from https://pypi.org/simple/middleware-test/), version: 1.1.8
2023-09-10T18:59:13,653   Found link https://files.pythonhosted.org/packages/a9/f1/272f864eb235a57ecb8d238adb6bad7aabcaa85c5dd5c94a5ef6feee337a/middleware_test-1.1.9.tar.gz (from https://pypi.org/simple/middleware-test/), version: 1.1.9
2023-09-10T18:59:13,654   Found link https://files.pythonhosted.org/packages/06/3a/bea50eb112e41b89e8fc2599593a8d8a8e615407a8036f5d52a695514806/middleware_test-1.1.10.tar.gz (from https://pypi.org/simple/middleware-test/), version: 1.1.10
2023-09-10T18:59:13,654   Found link https://files.pythonhosted.org/packages/35/a8/a834237738b8a7414278a3688a7403fad9722af23818da52af06970e97b4/middleware_test-1.1.11.tar.gz (from https://pypi.org/simple/middleware-test/), version: 1.1.11
2023-09-10T18:59:13,655   Found link https://files.pythonhosted.org/packages/db/0d/442828f2937733d35b030e98494dfb10e79e796cc93b37ec327883acd116/middleware_test-1.1.12.tar.gz (from https://pypi.org/simple/middleware-test/), version: 1.1.12
2023-09-10T18:59:13,656   Found link https://files.pythonhosted.org/packages/de/a6/3e6b50b494a8c45613ea265c1acd72ee28d4a08dbfa3c1f0a86c77d3fa60/middleware_test-1.1.13.tar.gz (from https://pypi.org/simple/middleware-test/), version: 1.1.13
2023-09-10T18:59:13,656   Found link https://files.pythonhosted.org/packages/b8/d1/1a4f2c5b02841814138c78d9f366621ad258f9429cf1b4f45b60aa1b2c1c/middleware_test-1.1.14.tar.gz (from https://pypi.org/simple/middleware-test/), version: 1.1.14
2023-09-10T18:59:13,657   Found link https://files.pythonhosted.org/packages/9f/ea/3f1b17dcd2702da7d6820862ddce7ba997ba89cf0e0b20cbd862ce5b93a9/middleware_test-1.1.15.tar.gz (from https://pypi.org/simple/middleware-test/), version: 1.1.15
2023-09-10T18:59:13,658   Found link https://files.pythonhosted.org/packages/59/12/ef873b54e97834974db1b2fac41a8281fcae32a9df2807447ace1f8d224f/middleware_test-1.2.tar.gz (from https://pypi.org/simple/middleware-test/), version: 1.2
2023-09-10T18:59:13,659   Found link https://files.pythonhosted.org/packages/20/48/ba23f5eb3963d09b0220c8056c71c67f1253d0501bc0180b21eae79a9683/middleware_test-1.2.1.tar.gz (from https://pypi.org/simple/middleware-test/), version: 1.2.1
2023-09-10T18:59:13,659   Found link https://files.pythonhosted.org/packages/40/63/e0ba6b73de0145b93a355a20e987ad6f42c9d30009dc9be60f42801f785e/middleware_test-1.2.2.tar.gz (from https://pypi.org/simple/middleware-test/), version: 1.2.2
2023-09-10T18:59:13,660   Found link https://files.pythonhosted.org/packages/76/34/5cf5f937facd627ff825887798ffd4f09af821682accc6dd602005ed354f/middleware_test-1.2.3.tar.gz (from https://pypi.org/simple/middleware-test/), version: 1.2.3
2023-09-10T18:59:13,660   Found link https://files.pythonhosted.org/packages/4f/3b/98e812673b8695f169c389ec6100ad8d272b2f45138e7f23b2069a804cb0/middleware_test-2.0.tar.gz (from https://pypi.org/simple/middleware-test/), version: 2.0
2023-09-10T18:59:13,661   Found link https://files.pythonhosted.org/packages/42/c5/dde4f32ea09d4f000527aab7b1b0076c887d0aa98d129f0616a4dff1ce54/middleware_test-2.1.tar.gz (from https://pypi.org/simple/middleware-test/), version: 2.1
2023-09-10T18:59:13,662 Fetching project page and analyzing links: https://www.piwheels.org/simple/middleware-test/
2023-09-10T18:59:13,662 Getting page https://www.piwheels.org/simple/middleware-test/
2023-09-10T18:59:13,663 Found index url https://www.piwheels.org/simple/
2023-09-10T18:59:13,983 Fetched page https://www.piwheels.org/simple/middleware-test/ as text/html
2023-09-10T18:59:13,986   Skipping link: No binaries permitted for middleware-test: https://www.piwheels.org/simple/middleware-test/middleware_test-1.1.10-py3-none-any.whl#sha256=da9177eb8a61b9635b44bb4a2a48013a1204a42d161d4cb1b86a1c4915efb0fb (from https://www.piwheels.org/simple/middleware-test/)
2023-09-10T18:59:13,987   Skipping link: No binaries permitted for middleware-test: https://www.piwheels.org/simple/middleware-test/middleware_test-1.1.11-py3-none-any.whl#sha256=85174815e8abc04ed92319d3650db25ca0c13bcf958b43e5f571e97c06ffeb03 (from https://www.piwheels.org/simple/middleware-test/)
2023-09-10T18:59:13,987   Skipping link: No binaries permitted for middleware-test: https://www.piwheels.org/simple/middleware-test/middleware_test-1.1.12-py3-none-any.whl#sha256=a42b81137896f8d8fb6ef866fe08e873988eedbd40aa9cb24e8596ce037c6864 (from https://www.piwheels.org/simple/middleware-test/)
2023-09-10T18:59:13,988   Skipping link: No binaries permitted for middleware-test: https://www.piwheels.org/simple/middleware-test/middleware_test-1.1.13-py3-none-any.whl#sha256=41cff76ec411c9a367299c6a3c217145f35ac7801aa39fc8005cc3cb70a0aa47 (from https://www.piwheels.org/simple/middleware-test/)
2023-09-10T18:59:13,989   Skipping link: No binaries permitted for middleware-test: https://www.piwheels.org/simple/middleware-test/middleware_test-1.1.7-py3-none-any.whl#sha256=7496006606210d85833c43f8b55984e092b7358ff20e554c9d745005a8afd0e2 (from https://www.piwheels.org/simple/middleware-test/)
2023-09-10T18:59:13,989   Skipping link: No binaries permitted for middleware-test: https://www.piwheels.org/simple/middleware-test/middleware_test-1.1.8-py3-none-any.whl#sha256=860169ef42937789c91919868504f9382b6014c586521d9827a981466e0cffe4 (from https://www.piwheels.org/simple/middleware-test/)
2023-09-10T18:59:13,990   Skipping link: No binaries permitted for middleware-test: https://www.piwheels.org/simple/middleware-test/middleware_test-1.1.9-py3-none-any.whl#sha256=d49d3ddba0a8909fccdd3dd9bdf003edc1531099e9cd6f487d1b4b04ec2174b6 (from https://www.piwheels.org/simple/middleware-test/)
2023-09-10T18:59:13,990 Skipping link: not a file: https://www.piwheels.org/simple/middleware-test/
2023-09-10T18:59:13,991 Skipping link: not a file: https://pypi.org/simple/middleware-test/
2023-09-10T18:59:14,012 Given no hashes to check 1 links for project 'middleware-test': discarding no candidates
2023-09-10T18:59:14,030 Collecting middleware-test==1.2.2
2023-09-10T18:59:14,032   Created temporary directory: /tmp/pip-unpack-y2c3mfa4
2023-09-10T18:59:14,778   Downloading middleware_test-1.2.2.tar.gz (23 kB)
2023-09-10T18:59:14,886   Added middleware-test==1.2.2 from https://files.pythonhosted.org/packages/40/63/e0ba6b73de0145b93a355a20e987ad6f42c9d30009dc9be60f42801f785e/middleware_test-1.2.2.tar.gz to build tracker '/tmp/pip-build-tracker-0sfeb8td'
2023-09-10T18:59:14,888   Running setup.py (path:/tmp/pip-wheel-vqs16tq5/middleware-test_2f7034a0838443b0b5a2f6040ddb198e/setup.py) egg_info for package middleware-test
2023-09-10T18:59:14,888   Created temporary directory: /tmp/pip-pip-egg-info-ld3sdumj
2023-09-10T18:59:14,889   Preparing metadata (setup.py): started
2023-09-10T18:59:14,890   Running command python setup.py egg_info
2023-09-10T18:59:15,302   Traceback (most recent call last):
2023-09-10T18:59:15,303     File "<string>", line 2, in <module>
2023-09-10T18:59:15,303     File "<pip-setuptools-caller>", line 34, in <module>
2023-09-10T18:59:15,304     File "/tmp/pip-wheel-vqs16tq5/middleware-test_2f7034a0838443b0b5a2f6040ddb198e/setup.py", line 9, in <module>
2023-09-10T18:59:15,304       from middleware import config
2023-09-10T18:59:15,305     File "/tmp/pip-wheel-vqs16tq5/middleware-test_2f7034a0838443b0b5a2f6040ddb198e/middleware/config.py", line 12, in <module>
2023-09-10T18:59:15,306       from tornado.options import (
2023-09-10T18:59:15,307   ModuleNotFoundError: No module named 'tornado'
2023-09-10T18:59:15,372   ERROR: [present-rich] python setup.py egg_info exited with 1
2023-09-10T18:59:15,385   [bold magenta]full command[/]: [blue]/usr/bin/python3 -c '
2023-09-10T18:59:15,385   exec(compile('"'"''"'"''"'"'
2023-09-10T18:59:15,385   # This is <pip-setuptools-caller> -- a caller that pip uses to run setup.py
2023-09-10T18:59:15,385   #
2023-09-10T18:59:15,385   # - It imports setuptools before invoking setup.py, to enable projects that directly
2023-09-10T18:59:15,385   #   import from `distutils.core` to work with newer packaging standards.
2023-09-10T18:59:15,385   # - It provides a clear error message when setuptools is not installed.
2023-09-10T18:59:15,385   # - It sets `sys.argv[0]` to the underlying `setup.py`, when invoking `setup.py` so
2023-09-10T18:59:15,385   #   setuptools doesn'"'"'t think the script is `-c`. This avoids the following warning:
2023-09-10T18:59:15,385   #     manifest_maker: standard file '"'"'-c'"'"' not found".
2023-09-10T18:59:15,385   # - It generates a shim setup.py, for handling setup.cfg-only projects.
2023-09-10T18:59:15,385   import os, sys, tokenize
2023-09-10T18:59:15,385   
2023-09-10T18:59:15,385   try:
2023-09-10T18:59:15,385       import setuptools
2023-09-10T18:59:15,385   except ImportError as error:
2023-09-10T18:59:15,385       print(
2023-09-10T18:59:15,385           "ERROR: Can not execute `setup.py` since setuptools is not available in "
2023-09-10T18:59:15,385           "the build environment.",
2023-09-10T18:59:15,385           file=sys.stderr,
2023-09-10T18:59:15,385       )
2023-09-10T18:59:15,385       sys.exit(1)
2023-09-10T18:59:15,385   
2023-09-10T18:59:15,385   __file__ = %r
2023-09-10T18:59:15,385   sys.argv[0] = __file__
2023-09-10T18:59:15,385   
2023-09-10T18:59:15,385   if os.path.exists(__file__):
2023-09-10T18:59:15,385       filename = __file__
2023-09-10T18:59:15,385       with tokenize.open(__file__) as f:
2023-09-10T18:59:15,385           setup_py_code = f.read()
2023-09-10T18:59:15,385   else:
2023-09-10T18:59:15,385       filename = "<auto-generated setuptools caller>"
2023-09-10T18:59:15,385       setup_py_code = "from setuptools import setup; setup()"
2023-09-10T18:59:15,385   
2023-09-10T18:59:15,385   exec(compile(setup_py_code, filename, "exec"))
2023-09-10T18:59:15,385   '"'"''"'"''"'"' % ('"'"'/tmp/pip-wheel-vqs16tq5/middleware-test_2f7034a0838443b0b5a2f6040ddb198e/setup.py'"'"',), "<pip-setuptools-caller>", "exec"))' egg_info --egg-base /tmp/pip-pip-egg-info-ld3sdumj[/]
2023-09-10T18:59:15,386   [bold magenta]cwd[/]: /tmp/pip-wheel-vqs16tq5/middleware-test_2f7034a0838443b0b5a2f6040ddb198e/
2023-09-10T18:59:15,387   Preparing metadata (setup.py): finished with status 'error'
2023-09-10T18:59:15,388 ERROR: [present-rich] metadata generation failed
2023-09-10T18:59:15,393 Exception information:
2023-09-10T18:59:15,393 Traceback (most recent call last):
2023-09-10T18:59:15,393   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/operations/build/metadata_legacy.py", line 64, in generate_metadata
2023-09-10T18:59:15,393     call_subprocess(
2023-09-10T18:59:15,393   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/utils/subprocess.py", line 224, in call_subprocess
2023-09-10T18:59:15,393     raise error
2023-09-10T18:59:15,393 pip._internal.exceptions.InstallationSubprocessError: python setup.py egg_info exited with 1
2023-09-10T18:59:15,393 
2023-09-10T18:59:15,393 The above exception was the direct cause of the following exception:
2023-09-10T18:59:15,393 
2023-09-10T18:59:15,393 Traceback (most recent call last):
2023-09-10T18:59:15,393   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/cli/base_command.py", line 180, in exc_logging_wrapper
2023-09-10T18:59:15,393     status = run_func(*args)
2023-09-10T18:59:15,393              ^^^^^^^^^^^^^^^
2023-09-10T18:59:15,393   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/cli/req_command.py", line 248, in wrapper
2023-09-10T18:59:15,393     return func(self, options, args)
2023-09-10T18:59:15,393            ^^^^^^^^^^^^^^^^^^^^^^^^^
2023-09-10T18:59:15,393   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/commands/wheel.py", line 147, in run
2023-09-10T18:59:15,393     requirement_set = resolver.resolve(reqs, check_supported_wheels=True)
2023-09-10T18:59:15,393                       ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2023-09-10T18:59:15,393   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/resolution/resolvelib/resolver.py", line 92, in resolve
2023-09-10T18:59:15,393     result = self._result = resolver.resolve(
2023-09-10T18:59:15,393                             ^^^^^^^^^^^^^^^^^
2023-09-10T18:59:15,393   File "/usr/local/lib/python3.11/dist-packages/pip/_vendor/resolvelib/resolvers.py", line 546, in resolve
2023-09-10T18:59:15,393     state = resolution.resolve(requirements, max_rounds=max_rounds)
2023-09-10T18:59:15,393             ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2023-09-10T18:59:15,393   File "/usr/local/lib/python3.11/dist-packages/pip/_vendor/resolvelib/resolvers.py", line 397, in resolve
2023-09-10T18:59:15,393     self._add_to_criteria(self.state.criteria, r, parent=None)
2023-09-10T18:59:15,393   File "/usr/local/lib/python3.11/dist-packages/pip/_vendor/resolvelib/resolvers.py", line 173, in _add_to_criteria
2023-09-10T18:59:15,393     if not criterion.candidates:
2023-09-10T18:59:15,393   File "/usr/local/lib/python3.11/dist-packages/pip/_vendor/resolvelib/structs.py", line 156, in __bool__
2023-09-10T18:59:15,393     return bool(self._sequence)
2023-09-10T18:59:15,393            ^^^^^^^^^^^^^^^^^^^^
2023-09-10T18:59:15,393   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/resolution/resolvelib/found_candidates.py", line 155, in __bool__
2023-09-10T18:59:15,393     return any(self)
2023-09-10T18:59:15,393            ^^^^^^^^^
2023-09-10T18:59:15,393   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/resolution/resolvelib/found_candidates.py", line 143, in <genexpr>
2023-09-10T18:59:15,393     return (c for c in iterator if id(c) not in self._incompatible_ids)
2023-09-10T18:59:15,393            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2023-09-10T18:59:15,393   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/resolution/resolvelib/found_candidates.py", line 47, in _iter_built
2023-09-10T18:59:15,393     candidate = func()
2023-09-10T18:59:15,393                 ^^^^^^
2023-09-10T18:59:15,393   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/resolution/resolvelib/factory.py", line 206, in _make_candidate_from_link
2023-09-10T18:59:15,393     self._link_candidate_cache[link] = LinkCandidate(
2023-09-10T18:59:15,393                                        ^^^^^^^^^^^^^^
2023-09-10T18:59:15,393   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/resolution/resolvelib/candidates.py", line 293, in __init__
2023-09-10T18:59:15,393     super().__init__(
2023-09-10T18:59:15,393   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/resolution/resolvelib/candidates.py", line 156, in __init__
2023-09-10T18:59:15,393     self.dist = self._prepare()
2023-09-10T18:59:15,393                 ^^^^^^^^^^^^^^^
2023-09-10T18:59:15,393   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/resolution/resolvelib/candidates.py", line 225, in _prepare
2023-09-10T18:59:15,393     dist = self._prepare_distribution()
2023-09-10T18:59:15,393            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2023-09-10T18:59:15,393   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/resolution/resolvelib/candidates.py", line 304, in _prepare_distribution
2023-09-10T18:59:15,393     return preparer.prepare_linked_requirement(self._ireq, parallel_builds=True)
2023-09-10T18:59:15,393            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2023-09-10T18:59:15,393   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/operations/prepare.py", line 538, in prepare_linked_requirement
2023-09-10T18:59:15,393     return self._prepare_linked_requirement(req, parallel_builds)
2023-09-10T18:59:15,393            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2023-09-10T18:59:15,393   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/operations/prepare.py", line 653, in _prepare_linked_requirement
2023-09-10T18:59:15,393     dist = _get_prepared_distribution(
2023-09-10T18:59:15,393            ^^^^^^^^^^^^^^^^^^^^^^^^^^^
2023-09-10T18:59:15,393   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/operations/prepare.py", line 69, in _get_prepared_distribution
2023-09-10T18:59:15,393     abstract_dist.prepare_distribution_metadata(
2023-09-10T18:59:15,393   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/distributions/sdist.py", line 61, in prepare_distribution_metadata
2023-09-10T18:59:15,393     self.req.prepare_metadata()
2023-09-10T18:59:15,393   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/req/req_install.py", line 568, in prepare_metadata
2023-09-10T18:59:15,393     self.metadata_directory = generate_metadata_legacy(
2023-09-10T18:59:15,393                               ^^^^^^^^^^^^^^^^^^^^^^^^^
2023-09-10T18:59:15,393   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/operations/build/metadata_legacy.py", line 71, in generate_metadata
2023-09-10T18:59:15,393     raise MetadataGenerationFailed(package_details=details) from error
2023-09-10T18:59:15,393 pip._internal.exceptions.MetadataGenerationFailed: metadata generation failed
2023-09-10T18:59:15,406 Removed middleware-test==1.2.2 from https://files.pythonhosted.org/packages/40/63/e0ba6b73de0145b93a355a20e987ad6f42c9d30009dc9be60f42801f785e/middleware_test-1.2.2.tar.gz from build tracker '/tmp/pip-build-tracker-0sfeb8td'
2023-09-10T18:59:15,407 Removed build tracker: '/tmp/pip-build-tracker-0sfeb8td'