2023-03-26T20:51:14,999 Created temporary directory: /tmp/pip-ephem-wheel-cache-udhwf3z8
2023-03-26T20:51:15,002 Created temporary directory: /tmp/pip-build-tracker-8wt_mke8
2023-03-26T20:51:15,003 Initialized build tracking at /tmp/pip-build-tracker-8wt_mke8
2023-03-26T20:51:15,003 Created build tracker: /tmp/pip-build-tracker-8wt_mke8
2023-03-26T20:51:15,003 Entered build tracker: /tmp/pip-build-tracker-8wt_mke8
2023-03-26T20:51:15,004 Created temporary directory: /tmp/pip-wheel-bafcl13e
2023-03-26T20:51:15,008 DEPRECATION: --no-binary currently disables reading from the cache of locally built wheels. In the future --no-binary will not influence the wheel cache. pip 23.1 will enforce this behaviour change. A possible replacement is to use the --no-cache-dir option. You can use the flag --use-feature=no-binary-enable-wheel-cache to test the upcoming behaviour. Discussion can be found at https://github.com/pypa/pip/issues/11453
2023-03-26T20:51:15,011 Created temporary directory: /tmp/pip-ephem-wheel-cache-jmrbt7ld
2023-03-26T20:51:15,042 Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple
2023-03-26T20:51:15,045 2 location(s) to search for versions of opf:
2023-03-26T20:51:15,045 * https://pypi.org/simple/opf/
2023-03-26T20:51:15,045 * https://www.piwheels.org/simple/opf/
2023-03-26T20:51:15,046 Fetching project page and analyzing links: https://pypi.org/simple/opf/
2023-03-26T20:51:15,046 Getting page https://pypi.org/simple/opf/
2023-03-26T20:51:15,048 Found index url https://pypi.org/simple
2023-03-26T20:51:15,099 Fetched page https://pypi.org/simple/opf/ as application/vnd.pypi.simple.v1+json
2023-03-26T20:51:15,101   Skipping link: No binaries permitted for opf: https://files.pythonhosted.org/packages/d0/19/f88a91321e76479254c691855ea62461ec692c7fb61b7e7edf0442c53cfe/opf-0.1.0-py3-none-any.whl (from https://pypi.org/simple/opf/) (requires-python:>=3.9)
2023-03-26T20:51:15,101   Found link https://files.pythonhosted.org/packages/c3/e9/6f0f9b71e40cb819828892267264cc607c2d16dd684bbcd66fc0ca434f44/opf-0.1.0.tar.gz (from https://pypi.org/simple/opf/) (requires-python:>=3.9), version: 0.1.0
2023-03-26T20:51:15,102   Skipping link: No binaries permitted for opf: https://files.pythonhosted.org/packages/f3/e5/85ae634dc68e06ce6497b4f9c34aa7f87453164442c7bdee1c7873593c82/opf-0.2.0-py3-none-any.whl (from https://pypi.org/simple/opf/) (requires-python:>=3.8)
2023-03-26T20:51:15,102   Found link https://files.pythonhosted.org/packages/bb/5f/c81d13a2e45db69b5dc6249a78971c4bfe76ce20d9939e76d7bea73d8bfd/opf-0.2.0.tar.gz (from https://pypi.org/simple/opf/) (requires-python:>=3.8), version: 0.2.0
2023-03-26T20:51:15,103 Fetching project page and analyzing links: https://www.piwheels.org/simple/opf/
2023-03-26T20:51:15,103 Getting page https://www.piwheels.org/simple/opf/
2023-03-26T20:51:15,104 Found index url https://www.piwheels.org/simple
2023-03-26T20:51:15,303 Fetched page https://www.piwheels.org/simple/opf/ as text/html
2023-03-26T20:51:15,304 Skipping link: not a file: https://www.piwheels.org/simple/opf/
2023-03-26T20:51:15,304 Skipping link: not a file: https://pypi.org/simple/opf/
2023-03-26T20:51:15,322 Given no hashes to check 1 links for project 'opf': discarding no candidates
2023-03-26T20:51:15,339 Collecting opf==0.2.0
2023-03-26T20:51:15,342   Created temporary directory: /tmp/pip-unpack-u7b0uoqs
2023-03-26T20:51:15,534   Downloading opf-0.2.0.tar.gz (20 kB)
2023-03-26T20:51:15,613   Added opf==0.2.0 from https://files.pythonhosted.org/packages/bb/5f/c81d13a2e45db69b5dc6249a78971c4bfe76ce20d9939e76d7bea73d8bfd/opf-0.2.0.tar.gz to build tracker '/tmp/pip-build-tracker-8wt_mke8'
2023-03-26T20:51:15,615   Running setup.py (path:/tmp/pip-wheel-bafcl13e/opf_86984ccdb9f24ccd8c18cff323954884/setup.py) egg_info for package opf
2023-03-26T20:51:15,615   Created temporary directory: /tmp/pip-pip-egg-info-bg5ic9yq
2023-03-26T20:51:15,616   Preparing metadata (setup.py): started
2023-03-26T20:51:15,616   Running command python setup.py egg_info
2023-03-26T20:51:16,175   Traceback (most recent call last):
2023-03-26T20:51:16,175     File "<string>", line 2, in <module>
2023-03-26T20:51:16,176     File "<pip-setuptools-caller>", line 34, in <module>
2023-03-26T20:51:16,177     File "/tmp/pip-wheel-bafcl13e/opf_86984ccdb9f24ccd8c18cff323954884/setup.py", line 8, in <module>
2023-03-26T20:51:16,178       import opf
2023-03-26T20:51:16,178     File "/tmp/pip-wheel-bafcl13e/opf_86984ccdb9f24ccd8c18cff323954884/opf/__init__.py", line 2, in <module>
2023-03-26T20:51:16,179       from .core import build_model, compute_ptdf
2023-03-26T20:51:16,179     File "/tmp/pip-wheel-bafcl13e/opf_86984ccdb9f24ccd8c18cff323954884/opf/core/__init__.py", line 1, in <module>
2023-03-26T20:51:16,180       from .func import build_model
2023-03-26T20:51:16,180     File "/tmp/pip-wheel-bafcl13e/opf_86984ccdb9f24ccd8c18cff323954884/opf/core/func.py", line 1, in <module>
2023-03-26T20:51:16,181       from .acopf import ACOPFModel
2023-03-26T20:51:16,181     File "/tmp/pip-wheel-bafcl13e/opf_86984ccdb9f24ccd8c18cff323954884/opf/core/acopf.py", line 2, in <module>
2023-03-26T20:51:16,182       import pyomo.environ as pyo
2023-03-26T20:51:16,182   ModuleNotFoundError: No module named 'pyomo'
2023-03-26T20:51:16,232   ERROR: [present-rich] python setup.py egg_info exited with 1
2023-03-26T20:51:16,253   [bold magenta]full command[/]: [blue]/usr/bin/python3 -c '
2023-03-26T20:51:16,253   exec(compile('"'"''"'"''"'"'
2023-03-26T20:51:16,253   # This is <pip-setuptools-caller> -- a caller that pip uses to run setup.py
2023-03-26T20:51:16,253   #
2023-03-26T20:51:16,253   # - It imports setuptools before invoking setup.py, to enable projects that directly
2023-03-26T20:51:16,253   #   import from `distutils.core` to work with newer packaging standards.
2023-03-26T20:51:16,253   # - It provides a clear error message when setuptools is not installed.
2023-03-26T20:51:16,253   # - It sets `sys.argv[0]` to the underlying `setup.py`, when invoking `setup.py` so
2023-03-26T20:51:16,253   #   setuptools doesn'"'"'t think the script is `-c`. This avoids the following warning:
2023-03-26T20:51:16,253   #     manifest_maker: standard file '"'"'-c'"'"' not found".
2023-03-26T20:51:16,253   # - It generates a shim setup.py, for handling setup.cfg-only projects.
2023-03-26T20:51:16,253   import os, sys, tokenize
2023-03-26T20:51:16,253   
2023-03-26T20:51:16,253   try:
2023-03-26T20:51:16,253       import setuptools
2023-03-26T20:51:16,253   except ImportError as error:
2023-03-26T20:51:16,253       print(
2023-03-26T20:51:16,253           "ERROR: Can not execute `setup.py` since setuptools is not available in "
2023-03-26T20:51:16,253           "the build environment.",
2023-03-26T20:51:16,253           file=sys.stderr,
2023-03-26T20:51:16,253       )
2023-03-26T20:51:16,253       sys.exit(1)
2023-03-26T20:51:16,253   
2023-03-26T20:51:16,253   __file__ = %r
2023-03-26T20:51:16,253   sys.argv[0] = __file__
2023-03-26T20:51:16,253   
2023-03-26T20:51:16,253   if os.path.exists(__file__):
2023-03-26T20:51:16,253       filename = __file__
2023-03-26T20:51:16,253       with tokenize.open(__file__) as f:
2023-03-26T20:51:16,253           setup_py_code = f.read()
2023-03-26T20:51:16,253   else:
2023-03-26T20:51:16,253       filename = "<auto-generated setuptools caller>"
2023-03-26T20:51:16,253       setup_py_code = "from setuptools import setup; setup()"
2023-03-26T20:51:16,253   
2023-03-26T20:51:16,253   exec(compile(setup_py_code, filename, "exec"))
2023-03-26T20:51:16,253   '"'"''"'"''"'"' % ('"'"'/tmp/pip-wheel-bafcl13e/opf_86984ccdb9f24ccd8c18cff323954884/setup.py'"'"',), "<pip-setuptools-caller>", "exec"))' egg_info --egg-base /tmp/pip-pip-egg-info-bg5ic9yq[/]
2023-03-26T20:51:16,253   [bold magenta]cwd[/]: /tmp/pip-wheel-bafcl13e/opf_86984ccdb9f24ccd8c18cff323954884/
2023-03-26T20:51:16,253   Preparing metadata (setup.py): finished with status 'error'
2023-03-26T20:51:16,254 ERROR: [present-rich] metadata generation failed
2023-03-26T20:51:16,260 Exception information:
2023-03-26T20:51:16,260 Traceback (most recent call last):
2023-03-26T20:51:16,260   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_internal/operations/build/metadata_legacy.py", line 64, in generate_metadata
2023-03-26T20:51:16,260     call_subprocess(
2023-03-26T20:51:16,260   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_internal/utils/subprocess.py", line 224, in call_subprocess
2023-03-26T20:51:16,260     raise error
2023-03-26T20:51:16,260 pip._internal.exceptions.InstallationSubprocessError: python setup.py egg_info exited with 1
2023-03-26T20:51:16,260 
2023-03-26T20:51:16,260 The above exception was the direct cause of the following exception:
2023-03-26T20:51:16,260 
2023-03-26T20:51:16,260 Traceback (most recent call last):
2023-03-26T20:51:16,260   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_internal/cli/base_command.py", line 160, in exc_logging_wrapper
2023-03-26T20:51:16,260     status = run_func(*args)
2023-03-26T20:51:16,260   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_internal/cli/req_command.py", line 247, in wrapper
2023-03-26T20:51:16,260     return func(self, options, args)
2023-03-26T20:51:16,260   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_internal/commands/wheel.py", line 170, in run
2023-03-26T20:51:16,260     requirement_set = resolver.resolve(reqs, check_supported_wheels=True)
2023-03-26T20:51:16,260   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_internal/resolution/resolvelib/resolver.py", line 92, in resolve
2023-03-26T20:51:16,260     result = self._result = resolver.resolve(
2023-03-26T20:51:16,260   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_vendor/resolvelib/resolvers.py", line 481, in resolve
2023-03-26T20:51:16,260     state = resolution.resolve(requirements, max_rounds=max_rounds)
2023-03-26T20:51:16,260   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_vendor/resolvelib/resolvers.py", line 348, in resolve
2023-03-26T20:51:16,260     self._add_to_criteria(self.state.criteria, r, parent=None)
2023-03-26T20:51:16,260   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_vendor/resolvelib/resolvers.py", line 172, in _add_to_criteria
2023-03-26T20:51:16,260     if not criterion.candidates:
2023-03-26T20:51:16,260   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_vendor/resolvelib/structs.py", line 151, in __bool__
2023-03-26T20:51:16,260     return bool(self._sequence)
2023-03-26T20:51:16,260   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_internal/resolution/resolvelib/found_candidates.py", line 155, in __bool__
2023-03-26T20:51:16,260     return any(self)
2023-03-26T20:51:16,260   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_internal/resolution/resolvelib/found_candidates.py", line 143, in <genexpr>
2023-03-26T20:51:16,260     return (c for c in iterator if id(c) not in self._incompatible_ids)
2023-03-26T20:51:16,260   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_internal/resolution/resolvelib/found_candidates.py", line 47, in _iter_built
2023-03-26T20:51:16,260     candidate = func()
2023-03-26T20:51:16,260   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_internal/resolution/resolvelib/factory.py", line 206, in _make_candidate_from_link
2023-03-26T20:51:16,260     self._link_candidate_cache[link] = LinkCandidate(
2023-03-26T20:51:16,260   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_internal/resolution/resolvelib/candidates.py", line 297, in __init__
2023-03-26T20:51:16,260     super().__init__(
2023-03-26T20:51:16,260   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_internal/resolution/resolvelib/candidates.py", line 162, in __init__
2023-03-26T20:51:16,260     self.dist = self._prepare()
2023-03-26T20:51:16,260   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_internal/resolution/resolvelib/candidates.py", line 231, in _prepare
2023-03-26T20:51:16,260     dist = self._prepare_distribution()
2023-03-26T20:51:16,260   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_internal/resolution/resolvelib/candidates.py", line 308, in _prepare_distribution
2023-03-26T20:51:16,260     return preparer.prepare_linked_requirement(self._ireq, parallel_builds=True)
2023-03-26T20:51:16,260   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_internal/operations/prepare.py", line 491, in prepare_linked_requirement
2023-03-26T20:51:16,260     return self._prepare_linked_requirement(req, parallel_builds)
2023-03-26T20:51:16,260   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_internal/operations/prepare.py", line 577, in _prepare_linked_requirement
2023-03-26T20:51:16,260     dist = _get_prepared_distribution(
2023-03-26T20:51:16,260   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_internal/operations/prepare.py", line 69, in _get_prepared_distribution
2023-03-26T20:51:16,260     abstract_dist.prepare_distribution_metadata(
2023-03-26T20:51:16,260   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_internal/distributions/sdist.py", line 61, in prepare_distribution_metadata
2023-03-26T20:51:16,260     self.req.prepare_metadata()
2023-03-26T20:51:16,260   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_internal/req/req_install.py", line 545, in prepare_metadata
2023-03-26T20:51:16,260     self.metadata_directory = generate_metadata_legacy(
2023-03-26T20:51:16,260   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_internal/operations/build/metadata_legacy.py", line 71, in generate_metadata
2023-03-26T20:51:16,260     raise MetadataGenerationFailed(package_details=details) from error
2023-03-26T20:51:16,260 pip._internal.exceptions.MetadataGenerationFailed: metadata generation failed
2023-03-26T20:51:16,271 Removed opf==0.2.0 from https://files.pythonhosted.org/packages/bb/5f/c81d13a2e45db69b5dc6249a78971c4bfe76ce20d9939e76d7bea73d8bfd/opf-0.2.0.tar.gz from build tracker '/tmp/pip-build-tracker-8wt_mke8'
2023-03-26T20:51:16,271 Removed build tracker: '/tmp/pip-build-tracker-8wt_mke8'