2023-09-10T23:27:30,041 Created temporary directory: /tmp/pip-build-tracker-vxgbyjw1
2023-09-10T23:27:30,042 Initialized build tracking at /tmp/pip-build-tracker-vxgbyjw1
2023-09-10T23:27:30,043 Created build tracker: /tmp/pip-build-tracker-vxgbyjw1
2023-09-10T23:27:30,043 Entered build tracker: /tmp/pip-build-tracker-vxgbyjw1
2023-09-10T23:27:30,044 Created temporary directory: /tmp/pip-wheel-jyjs78qk
2023-09-10T23:27:30,047 Created temporary directory: /tmp/pip-ephem-wheel-cache-f7zf5xfk
2023-09-10T23:27:30,073 Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple
2023-09-10T23:27:30,076 2 location(s) to search for versions of bob-hobpad2-chapter19:
2023-09-10T23:27:30,076 * https://pypi.org/simple/bob-hobpad2-chapter19/
2023-09-10T23:27:30,076 * https://www.piwheels.org/simple/bob-hobpad2-chapter19/
2023-09-10T23:27:30,078 Fetching project page and analyzing links: https://pypi.org/simple/bob-hobpad2-chapter19/
2023-09-10T23:27:30,079 Getting page https://pypi.org/simple/bob-hobpad2-chapter19/
2023-09-10T23:27:30,080 Found index url https://pypi.org/simple/
2023-09-10T23:27:30,333 Fetched page https://pypi.org/simple/bob-hobpad2-chapter19/ as application/vnd.pypi.simple.v1+json
2023-09-10T23:27:30,335   Found link https://files.pythonhosted.org/packages/b6/9d/f97e434f818a0819680735f18f13117cad72cb13369570a16ff1332669b0/bob.hobpad2.chapter19-1.0.1.zip (from https://pypi.org/simple/bob-hobpad2-chapter19/), version: 1.0.1
2023-09-10T23:27:30,335 Fetching project page and analyzing links: https://www.piwheels.org/simple/bob-hobpad2-chapter19/
2023-09-10T23:27:30,336 Getting page https://www.piwheels.org/simple/bob-hobpad2-chapter19/
2023-09-10T23:27:30,337 Found index url https://www.piwheels.org/simple/
2023-09-10T23:27:30,613 Fetched page https://www.piwheels.org/simple/bob-hobpad2-chapter19/ as text/html
2023-09-10T23:27:30,614 Skipping link: not a file: https://www.piwheels.org/simple/bob-hobpad2-chapter19/
2023-09-10T23:27:30,615 Skipping link: not a file: https://pypi.org/simple/bob-hobpad2-chapter19/
2023-09-10T23:27:30,633 Given no hashes to check 1 links for project 'bob-hobpad2-chapter19': discarding no candidates
2023-09-10T23:27:30,651 Collecting bob-hobpad2-chapter19==1.0.1
2023-09-10T23:27:30,653   Created temporary directory: /tmp/pip-unpack-ayyomzjh
2023-09-10T23:27:30,877   Downloading bob.hobpad2.chapter19-1.0.1.zip (29 kB)
2023-09-10T23:27:30,920   Added bob-hobpad2-chapter19==1.0.1 from https://files.pythonhosted.org/packages/b6/9d/f97e434f818a0819680735f18f13117cad72cb13369570a16ff1332669b0/bob.hobpad2.chapter19-1.0.1.zip to build tracker '/tmp/pip-build-tracker-vxgbyjw1'
2023-09-10T23:27:30,922   Running setup.py (path:/tmp/pip-wheel-jyjs78qk/bob-hobpad2-chapter19_71792bc0e0f747e6a9b54074070cf46b/setup.py) egg_info for package bob-hobpad2-chapter19
2023-09-10T23:27:30,923   Created temporary directory: /tmp/pip-pip-egg-info-gbsf119_
2023-09-10T23:27:30,924   Preparing metadata (setup.py): started
2023-09-10T23:27:30,925   Running command python setup.py egg_info
2023-09-10T23:27:31,425   Traceback (most recent call last):
2023-09-10T23:27:31,425     File "<string>", line 2, in <module>
2023-09-10T23:27:31,426     File "<pip-setuptools-caller>", line 34, in <module>
2023-09-10T23:27:31,427     File "/tmp/pip-wheel-jyjs78qk/bob-hobpad2-chapter19_71792bc0e0f747e6a9b54074070cf46b/setup.py", line 8, in <module>
2023-09-10T23:27:31,428       from bob.extension.utils import load_requirements, find_packages
2023-09-10T23:27:31,429   ModuleNotFoundError: No module named 'bob.extension'
2023-09-10T23:27:31,495   ERROR: [present-rich] python setup.py egg_info exited with 1
2023-09-10T23:27:31,508   [bold magenta]full command[/]: [blue]/usr/bin/python3 -c '
2023-09-10T23:27:31,508   exec(compile('"'"''"'"''"'"'
2023-09-10T23:27:31,508   # This is <pip-setuptools-caller> -- a caller that pip uses to run setup.py
2023-09-10T23:27:31,508   #
2023-09-10T23:27:31,508   # - It imports setuptools before invoking setup.py, to enable projects that directly
2023-09-10T23:27:31,508   #   import from `distutils.core` to work with newer packaging standards.
2023-09-10T23:27:31,508   # - It provides a clear error message when setuptools is not installed.
2023-09-10T23:27:31,508   # - It sets `sys.argv[0]` to the underlying `setup.py`, when invoking `setup.py` so
2023-09-10T23:27:31,508   #   setuptools doesn'"'"'t think the script is `-c`. This avoids the following warning:
2023-09-10T23:27:31,508   #     manifest_maker: standard file '"'"'-c'"'"' not found".
2023-09-10T23:27:31,508   # - It generates a shim setup.py, for handling setup.cfg-only projects.
2023-09-10T23:27:31,508   import os, sys, tokenize
2023-09-10T23:27:31,508   
2023-09-10T23:27:31,508   try:
2023-09-10T23:27:31,508       import setuptools
2023-09-10T23:27:31,508   except ImportError as error:
2023-09-10T23:27:31,508       print(
2023-09-10T23:27:31,508           "ERROR: Can not execute `setup.py` since setuptools is not available in "
2023-09-10T23:27:31,508           "the build environment.",
2023-09-10T23:27:31,508           file=sys.stderr,
2023-09-10T23:27:31,508       )
2023-09-10T23:27:31,508       sys.exit(1)
2023-09-10T23:27:31,508   
2023-09-10T23:27:31,508   __file__ = %r
2023-09-10T23:27:31,508   sys.argv[0] = __file__
2023-09-10T23:27:31,508   
2023-09-10T23:27:31,508   if os.path.exists(__file__):
2023-09-10T23:27:31,508       filename = __file__
2023-09-10T23:27:31,508       with tokenize.open(__file__) as f:
2023-09-10T23:27:31,508           setup_py_code = f.read()
2023-09-10T23:27:31,508   else:
2023-09-10T23:27:31,508       filename = "<auto-generated setuptools caller>"
2023-09-10T23:27:31,508       setup_py_code = "from setuptools import setup; setup()"
2023-09-10T23:27:31,508   
2023-09-10T23:27:31,508   exec(compile(setup_py_code, filename, "exec"))
2023-09-10T23:27:31,508   '"'"''"'"''"'"' % ('"'"'/tmp/pip-wheel-jyjs78qk/bob-hobpad2-chapter19_71792bc0e0f747e6a9b54074070cf46b/setup.py'"'"',), "<pip-setuptools-caller>", "exec"))' egg_info --egg-base /tmp/pip-pip-egg-info-gbsf119_[/]
2023-09-10T23:27:31,509   [bold magenta]cwd[/]: /tmp/pip-wheel-jyjs78qk/bob-hobpad2-chapter19_71792bc0e0f747e6a9b54074070cf46b/
2023-09-10T23:27:31,509   Preparing metadata (setup.py): finished with status 'error'
2023-09-10T23:27:31,511 ERROR: [present-rich] metadata generation failed
2023-09-10T23:27:31,516 Exception information:
2023-09-10T23:27:31,516 Traceback (most recent call last):
2023-09-10T23:27:31,516   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/operations/build/metadata_legacy.py", line 64, in generate_metadata
2023-09-10T23:27:31,516     call_subprocess(
2023-09-10T23:27:31,516   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/utils/subprocess.py", line 224, in call_subprocess
2023-09-10T23:27:31,516     raise error
2023-09-10T23:27:31,516 pip._internal.exceptions.InstallationSubprocessError: python setup.py egg_info exited with 1
2023-09-10T23:27:31,516 
2023-09-10T23:27:31,516 The above exception was the direct cause of the following exception:
2023-09-10T23:27:31,516 
2023-09-10T23:27:31,516 Traceback (most recent call last):
2023-09-10T23:27:31,516   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/cli/base_command.py", line 180, in exc_logging_wrapper
2023-09-10T23:27:31,516     status = run_func(*args)
2023-09-10T23:27:31,516              ^^^^^^^^^^^^^^^
2023-09-10T23:27:31,516   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/cli/req_command.py", line 248, in wrapper
2023-09-10T23:27:31,516     return func(self, options, args)
2023-09-10T23:27:31,516            ^^^^^^^^^^^^^^^^^^^^^^^^^
2023-09-10T23:27:31,516   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/commands/wheel.py", line 147, in run
2023-09-10T23:27:31,516     requirement_set = resolver.resolve(reqs, check_supported_wheels=True)
2023-09-10T23:27:31,516                       ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2023-09-10T23:27:31,516   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/resolution/resolvelib/resolver.py", line 92, in resolve
2023-09-10T23:27:31,516     result = self._result = resolver.resolve(
2023-09-10T23:27:31,516                             ^^^^^^^^^^^^^^^^^
2023-09-10T23:27:31,516   File "/usr/local/lib/python3.11/dist-packages/pip/_vendor/resolvelib/resolvers.py", line 546, in resolve
2023-09-10T23:27:31,516     state = resolution.resolve(requirements, max_rounds=max_rounds)
2023-09-10T23:27:31,516             ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2023-09-10T23:27:31,516   File "/usr/local/lib/python3.11/dist-packages/pip/_vendor/resolvelib/resolvers.py", line 397, in resolve
2023-09-10T23:27:31,516     self._add_to_criteria(self.state.criteria, r, parent=None)
2023-09-10T23:27:31,516   File "/usr/local/lib/python3.11/dist-packages/pip/_vendor/resolvelib/resolvers.py", line 173, in _add_to_criteria
2023-09-10T23:27:31,516     if not criterion.candidates:
2023-09-10T23:27:31,516   File "/usr/local/lib/python3.11/dist-packages/pip/_vendor/resolvelib/structs.py", line 156, in __bool__
2023-09-10T23:27:31,516     return bool(self._sequence)
2023-09-10T23:27:31,516            ^^^^^^^^^^^^^^^^^^^^
2023-09-10T23:27:31,516   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/resolution/resolvelib/found_candidates.py", line 155, in __bool__
2023-09-10T23:27:31,516     return any(self)
2023-09-10T23:27:31,516            ^^^^^^^^^
2023-09-10T23:27:31,516   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/resolution/resolvelib/found_candidates.py", line 143, in <genexpr>
2023-09-10T23:27:31,516     return (c for c in iterator if id(c) not in self._incompatible_ids)
2023-09-10T23:27:31,516            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2023-09-10T23:27:31,516   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/resolution/resolvelib/found_candidates.py", line 47, in _iter_built
2023-09-10T23:27:31,516     candidate = func()
2023-09-10T23:27:31,516                 ^^^^^^
2023-09-10T23:27:31,516   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/resolution/resolvelib/factory.py", line 206, in _make_candidate_from_link
2023-09-10T23:27:31,516     self._link_candidate_cache[link] = LinkCandidate(
2023-09-10T23:27:31,516                                        ^^^^^^^^^^^^^^
2023-09-10T23:27:31,516   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/resolution/resolvelib/candidates.py", line 293, in __init__
2023-09-10T23:27:31,516     super().__init__(
2023-09-10T23:27:31,516   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/resolution/resolvelib/candidates.py", line 156, in __init__
2023-09-10T23:27:31,516     self.dist = self._prepare()
2023-09-10T23:27:31,516                 ^^^^^^^^^^^^^^^
2023-09-10T23:27:31,516   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/resolution/resolvelib/candidates.py", line 225, in _prepare
2023-09-10T23:27:31,516     dist = self._prepare_distribution()
2023-09-10T23:27:31,516            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2023-09-10T23:27:31,516   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/resolution/resolvelib/candidates.py", line 304, in _prepare_distribution
2023-09-10T23:27:31,516     return preparer.prepare_linked_requirement(self._ireq, parallel_builds=True)
2023-09-10T23:27:31,516            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2023-09-10T23:27:31,516   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/operations/prepare.py", line 538, in prepare_linked_requirement
2023-09-10T23:27:31,516     return self._prepare_linked_requirement(req, parallel_builds)
2023-09-10T23:27:31,516            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2023-09-10T23:27:31,516   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/operations/prepare.py", line 653, in _prepare_linked_requirement
2023-09-10T23:27:31,516     dist = _get_prepared_distribution(
2023-09-10T23:27:31,516            ^^^^^^^^^^^^^^^^^^^^^^^^^^^
2023-09-10T23:27:31,516   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/operations/prepare.py", line 69, in _get_prepared_distribution
2023-09-10T23:27:31,516     abstract_dist.prepare_distribution_metadata(
2023-09-10T23:27:31,516   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/distributions/sdist.py", line 61, in prepare_distribution_metadata
2023-09-10T23:27:31,516     self.req.prepare_metadata()
2023-09-10T23:27:31,516   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/req/req_install.py", line 568, in prepare_metadata
2023-09-10T23:27:31,516     self.metadata_directory = generate_metadata_legacy(
2023-09-10T23:27:31,516                               ^^^^^^^^^^^^^^^^^^^^^^^^^
2023-09-10T23:27:31,516   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/operations/build/metadata_legacy.py", line 71, in generate_metadata
2023-09-10T23:27:31,516     raise MetadataGenerationFailed(package_details=details) from error
2023-09-10T23:27:31,516 pip._internal.exceptions.MetadataGenerationFailed: metadata generation failed
2023-09-10T23:27:31,530 Removed bob-hobpad2-chapter19==1.0.1 from https://files.pythonhosted.org/packages/b6/9d/f97e434f818a0819680735f18f13117cad72cb13369570a16ff1332669b0/bob.hobpad2.chapter19-1.0.1.zip from build tracker '/tmp/pip-build-tracker-vxgbyjw1'
2023-09-10T23:27:31,530 Removed build tracker: '/tmp/pip-build-tracker-vxgbyjw1'