2023-09-08T16:47:51,207 Created temporary directory: /tmp/pip-build-tracker-5vulf735
2023-09-08T16:47:51,208 Initialized build tracking at /tmp/pip-build-tracker-5vulf735
2023-09-08T16:47:51,209 Created build tracker: /tmp/pip-build-tracker-5vulf735
2023-09-08T16:47:51,209 Entered build tracker: /tmp/pip-build-tracker-5vulf735
2023-09-08T16:47:51,210 Created temporary directory: /tmp/pip-wheel-jcn6f7ii
2023-09-08T16:47:51,213 Created temporary directory: /tmp/pip-ephem-wheel-cache-l53omaep
2023-09-08T16:47:51,234 Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple
2023-09-08T16:47:51,238 2 location(s) to search for versions of bookkeeper:
2023-09-08T16:47:51,238 * https://pypi.org/simple/bookkeeper/
2023-09-08T16:47:51,238 * https://www.piwheels.org/simple/bookkeeper/
2023-09-08T16:47:51,239 Fetching project page and analyzing links: https://pypi.org/simple/bookkeeper/
2023-09-08T16:47:51,240 Getting page https://pypi.org/simple/bookkeeper/
2023-09-08T16:47:51,241 Found index url https://pypi.org/simple/
2023-09-08T16:47:51,457 Fetched page https://pypi.org/simple/bookkeeper/ as application/vnd.pypi.simple.v1+json
2023-09-08T16:47:51,458   Found link https://files.pythonhosted.org/packages/b9/7b/037f8da4a5f716fca6f19271b05dbd7a6e01a1b0f1b9d70a99fb6e99313e/Bookkeeper-0.0.1.tar.gz (from https://pypi.org/simple/bookkeeper/), version: 0.0.1
2023-09-08T16:47:51,459   Found link https://files.pythonhosted.org/packages/01/a5/94ce4491cdfcacac437f68f202b6b8435566f738e2e56183bd390a99193c/Bookkeeper-0.0.2.tar.gz (from https://pypi.org/simple/bookkeeper/), version: 0.0.2
2023-09-08T16:47:51,459 Fetching project page and analyzing links: https://www.piwheels.org/simple/bookkeeper/
2023-09-08T16:47:51,460 Getting page https://www.piwheels.org/simple/bookkeeper/
2023-09-08T16:47:51,461 Found index url https://www.piwheels.org/simple/
2023-09-08T16:47:51,715 Fetched page https://www.piwheels.org/simple/bookkeeper/ as text/html
2023-09-08T16:47:51,717   Skipping link: No binaries permitted for bookkeeper: https://www.piwheels.org/simple/bookkeeper/Bookkeeper-0.0.2-py3-none-any.whl#sha256=52d2f2d5db571ba616bb2893954e78b364ab6124691017ac2824b5e22f0f5347 (from https://www.piwheels.org/simple/bookkeeper/)
2023-09-08T16:47:51,717 Skipping link: not a file: https://www.piwheels.org/simple/bookkeeper/
2023-09-08T16:47:51,718 Skipping link: not a file: https://pypi.org/simple/bookkeeper/
2023-09-08T16:47:51,737 Given no hashes to check 1 links for project 'bookkeeper': discarding no candidates
2023-09-08T16:47:51,755 Collecting bookkeeper==0.0.1
2023-09-08T16:47:51,757   Created temporary directory: /tmp/pip-unpack-nzw7wmk8
2023-09-08T16:47:51,977   Downloading Bookkeeper-0.0.1.tar.gz (895 bytes)
2023-09-08T16:47:51,989   Added bookkeeper==0.0.1 from https://files.pythonhosted.org/packages/b9/7b/037f8da4a5f716fca6f19271b05dbd7a6e01a1b0f1b9d70a99fb6e99313e/Bookkeeper-0.0.1.tar.gz to build tracker '/tmp/pip-build-tracker-5vulf735'
2023-09-08T16:47:51,990   Running setup.py (path:/tmp/pip-wheel-jcn6f7ii/bookkeeper_174ca01aff214d3eb4aebf681ea643e1/setup.py) egg_info for package bookkeeper
2023-09-08T16:47:51,991   Created temporary directory: /tmp/pip-pip-egg-info-b4kfr9aj
2023-09-08T16:47:51,992   Preparing metadata (setup.py): started
2023-09-08T16:47:51,993   Running command python setup.py egg_info
2023-09-08T16:47:52,422   Traceback (most recent call last):
2023-09-08T16:47:52,422     File "<string>", line 2, in <module>
2023-09-08T16:47:52,423     File "<pip-setuptools-caller>", line 34, in <module>
2023-09-08T16:47:52,424     File "/tmp/pip-wheel-jcn6f7ii/bookkeeper_174ca01aff214d3eb4aebf681ea643e1/setup.py", line 4, in <module>
2023-09-08T16:47:52,425       import bookkeeper
2023-09-08T16:47:52,426   ModuleNotFoundError: No module named 'bookkeeper'
2023-09-08T16:47:52,494   ERROR: [present-rich] python setup.py egg_info exited with 1
2023-09-08T16:47:52,507   [bold magenta]full command[/]: [blue]/usr/bin/python3 -c '
2023-09-08T16:47:52,507   exec(compile('"'"''"'"''"'"'
2023-09-08T16:47:52,507   # This is <pip-setuptools-caller> -- a caller that pip uses to run setup.py
2023-09-08T16:47:52,507   #
2023-09-08T16:47:52,507   # - It imports setuptools before invoking setup.py, to enable projects that directly
2023-09-08T16:47:52,507   #   import from `distutils.core` to work with newer packaging standards.
2023-09-08T16:47:52,507   # - It provides a clear error message when setuptools is not installed.
2023-09-08T16:47:52,507   # - It sets `sys.argv[0]` to the underlying `setup.py`, when invoking `setup.py` so
2023-09-08T16:47:52,507   #   setuptools doesn'"'"'t think the script is `-c`. This avoids the following warning:
2023-09-08T16:47:52,507   #     manifest_maker: standard file '"'"'-c'"'"' not found".
2023-09-08T16:47:52,507   # - It generates a shim setup.py, for handling setup.cfg-only projects.
2023-09-08T16:47:52,507   import os, sys, tokenize
2023-09-08T16:47:52,507   
2023-09-08T16:47:52,507   try:
2023-09-08T16:47:52,507       import setuptools
2023-09-08T16:47:52,507   except ImportError as error:
2023-09-08T16:47:52,507       print(
2023-09-08T16:47:52,507           "ERROR: Can not execute `setup.py` since setuptools is not available in "
2023-09-08T16:47:52,507           "the build environment.",
2023-09-08T16:47:52,507           file=sys.stderr,
2023-09-08T16:47:52,507       )
2023-09-08T16:47:52,507       sys.exit(1)
2023-09-08T16:47:52,507   
2023-09-08T16:47:52,507   __file__ = %r
2023-09-08T16:47:52,507   sys.argv[0] = __file__
2023-09-08T16:47:52,507   
2023-09-08T16:47:52,507   if os.path.exists(__file__):
2023-09-08T16:47:52,507       filename = __file__
2023-09-08T16:47:52,507       with tokenize.open(__file__) as f:
2023-09-08T16:47:52,507           setup_py_code = f.read()
2023-09-08T16:47:52,507   else:
2023-09-08T16:47:52,507       filename = "<auto-generated setuptools caller>"
2023-09-08T16:47:52,507       setup_py_code = "from setuptools import setup; setup()"
2023-09-08T16:47:52,507   
2023-09-08T16:47:52,507   exec(compile(setup_py_code, filename, "exec"))
2023-09-08T16:47:52,507   '"'"''"'"''"'"' % ('"'"'/tmp/pip-wheel-jcn6f7ii/bookkeeper_174ca01aff214d3eb4aebf681ea643e1/setup.py'"'"',), "<pip-setuptools-caller>", "exec"))' egg_info --egg-base /tmp/pip-pip-egg-info-b4kfr9aj[/]
2023-09-08T16:47:52,508   [bold magenta]cwd[/]: /tmp/pip-wheel-jcn6f7ii/bookkeeper_174ca01aff214d3eb4aebf681ea643e1/
2023-09-08T16:47:52,509   Preparing metadata (setup.py): finished with status 'error'
2023-09-08T16:47:52,510 ERROR: [present-rich] metadata generation failed
2023-09-08T16:47:52,516 Exception information:
2023-09-08T16:47:52,516 Traceback (most recent call last):
2023-09-08T16:47:52,516   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/operations/build/metadata_legacy.py", line 64, in generate_metadata
2023-09-08T16:47:52,516     call_subprocess(
2023-09-08T16:47:52,516   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/utils/subprocess.py", line 224, in call_subprocess
2023-09-08T16:47:52,516     raise error
2023-09-08T16:47:52,516 pip._internal.exceptions.InstallationSubprocessError: python setup.py egg_info exited with 1
2023-09-08T16:47:52,516 
2023-09-08T16:47:52,516 The above exception was the direct cause of the following exception:
2023-09-08T16:47:52,516 
2023-09-08T16:47:52,516 Traceback (most recent call last):
2023-09-08T16:47:52,516   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/cli/base_command.py", line 180, in exc_logging_wrapper
2023-09-08T16:47:52,516     status = run_func(*args)
2023-09-08T16:47:52,516              ^^^^^^^^^^^^^^^
2023-09-08T16:47:52,516   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/cli/req_command.py", line 248, in wrapper
2023-09-08T16:47:52,516     return func(self, options, args)
2023-09-08T16:47:52,516            ^^^^^^^^^^^^^^^^^^^^^^^^^
2023-09-08T16:47:52,516   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/commands/wheel.py", line 147, in run
2023-09-08T16:47:52,516     requirement_set = resolver.resolve(reqs, check_supported_wheels=True)
2023-09-08T16:47:52,516                       ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2023-09-08T16:47:52,516   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/resolution/resolvelib/resolver.py", line 92, in resolve
2023-09-08T16:47:52,516     result = self._result = resolver.resolve(
2023-09-08T16:47:52,516                             ^^^^^^^^^^^^^^^^^
2023-09-08T16:47:52,516   File "/usr/local/lib/python3.11/dist-packages/pip/_vendor/resolvelib/resolvers.py", line 546, in resolve
2023-09-08T16:47:52,516     state = resolution.resolve(requirements, max_rounds=max_rounds)
2023-09-08T16:47:52,516             ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2023-09-08T16:47:52,516   File "/usr/local/lib/python3.11/dist-packages/pip/_vendor/resolvelib/resolvers.py", line 397, in resolve
2023-09-08T16:47:52,516     self._add_to_criteria(self.state.criteria, r, parent=None)
2023-09-08T16:47:52,516   File "/usr/local/lib/python3.11/dist-packages/pip/_vendor/resolvelib/resolvers.py", line 173, in _add_to_criteria
2023-09-08T16:47:52,516     if not criterion.candidates:
2023-09-08T16:47:52,516   File "/usr/local/lib/python3.11/dist-packages/pip/_vendor/resolvelib/structs.py", line 156, in __bool__
2023-09-08T16:47:52,516     return bool(self._sequence)
2023-09-08T16:47:52,516            ^^^^^^^^^^^^^^^^^^^^
2023-09-08T16:47:52,516   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/resolution/resolvelib/found_candidates.py", line 155, in __bool__
2023-09-08T16:47:52,516     return any(self)
2023-09-08T16:47:52,516            ^^^^^^^^^
2023-09-08T16:47:52,516   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/resolution/resolvelib/found_candidates.py", line 143, in <genexpr>
2023-09-08T16:47:52,516     return (c for c in iterator if id(c) not in self._incompatible_ids)
2023-09-08T16:47:52,516            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2023-09-08T16:47:52,516   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/resolution/resolvelib/found_candidates.py", line 47, in _iter_built
2023-09-08T16:47:52,516     candidate = func()
2023-09-08T16:47:52,516                 ^^^^^^
2023-09-08T16:47:52,516   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/resolution/resolvelib/factory.py", line 206, in _make_candidate_from_link
2023-09-08T16:47:52,516     self._link_candidate_cache[link] = LinkCandidate(
2023-09-08T16:47:52,516                                        ^^^^^^^^^^^^^^
2023-09-08T16:47:52,516   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/resolution/resolvelib/candidates.py", line 293, in __init__
2023-09-08T16:47:52,516     super().__init__(
2023-09-08T16:47:52,516   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/resolution/resolvelib/candidates.py", line 156, in __init__
2023-09-08T16:47:52,516     self.dist = self._prepare()
2023-09-08T16:47:52,516                 ^^^^^^^^^^^^^^^
2023-09-08T16:47:52,516   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/resolution/resolvelib/candidates.py", line 225, in _prepare
2023-09-08T16:47:52,516     dist = self._prepare_distribution()
2023-09-08T16:47:52,516            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2023-09-08T16:47:52,516   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/resolution/resolvelib/candidates.py", line 304, in _prepare_distribution
2023-09-08T16:47:52,516     return preparer.prepare_linked_requirement(self._ireq, parallel_builds=True)
2023-09-08T16:47:52,516            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2023-09-08T16:47:52,516   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/operations/prepare.py", line 538, in prepare_linked_requirement
2023-09-08T16:47:52,516     return self._prepare_linked_requirement(req, parallel_builds)
2023-09-08T16:47:52,516            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2023-09-08T16:47:52,516   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/operations/prepare.py", line 653, in _prepare_linked_requirement
2023-09-08T16:47:52,516     dist = _get_prepared_distribution(
2023-09-08T16:47:52,516            ^^^^^^^^^^^^^^^^^^^^^^^^^^^
2023-09-08T16:47:52,516   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/operations/prepare.py", line 69, in _get_prepared_distribution
2023-09-08T16:47:52,516     abstract_dist.prepare_distribution_metadata(
2023-09-08T16:47:52,516   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/distributions/sdist.py", line 61, in prepare_distribution_metadata
2023-09-08T16:47:52,516     self.req.prepare_metadata()
2023-09-08T16:47:52,516   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/req/req_install.py", line 568, in prepare_metadata
2023-09-08T16:47:52,516     self.metadata_directory = generate_metadata_legacy(
2023-09-08T16:47:52,516                               ^^^^^^^^^^^^^^^^^^^^^^^^^
2023-09-08T16:47:52,516   File "/usr/local/lib/python3.11/dist-packages/pip/_internal/operations/build/metadata_legacy.py", line 71, in generate_metadata
2023-09-08T16:47:52,516     raise MetadataGenerationFailed(package_details=details) from error
2023-09-08T16:47:52,516 pip._internal.exceptions.MetadataGenerationFailed: metadata generation failed
2023-09-08T16:47:52,528 Removed bookkeeper==0.0.1 from https://files.pythonhosted.org/packages/b9/7b/037f8da4a5f716fca6f19271b05dbd7a6e01a1b0f1b9d70a99fb6e99313e/Bookkeeper-0.0.1.tar.gz from build tracker '/tmp/pip-build-tracker-5vulf735'
2023-09-08T16:47:52,529 Removed build tracker: '/tmp/pip-build-tracker-5vulf735'