2022-09-29T17:47:37,471 Created temporary directory: /tmp/pip-ephem-wheel-cache-z6co9a52
2022-09-29T17:47:37,476 Created temporary directory: /tmp/pip-build-tracker-nmsb7251
2022-09-29T17:47:37,477 Initialized build tracking at /tmp/pip-build-tracker-nmsb7251
2022-09-29T17:47:37,478 Created build tracker: /tmp/pip-build-tracker-nmsb7251
2022-09-29T17:47:37,478 Entered build tracker: /tmp/pip-build-tracker-nmsb7251
2022-09-29T17:47:37,479 Created temporary directory: /tmp/pip-wheel-bz9nrank
2022-09-29T17:47:37,574 Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple
2022-09-29T17:47:37,583 2 location(s) to search for versions of utr:
2022-09-29T17:47:37,583 * https://pypi.org/simple/utr/
2022-09-29T17:47:37,583 * https://www.piwheels.org/simple/utr/
2022-09-29T17:47:37,584 Fetching project page and analyzing links: https://pypi.org/simple/utr/
2022-09-29T17:47:37,585 Getting page https://pypi.org/simple/utr/
2022-09-29T17:47:37,589 Found index url https://pypi.org/simple
2022-09-29T17:47:37,789   Skipping link: No binaries permitted for utr: https://files.pythonhosted.org/packages/dc/b4/4250d1ee01495836fe76333400f8b846900eac08891627f887b2409c81b3/utr-1.1.0-py3-none-any.whl#sha256=4f420c879d081a0d426f5c8e8c218bc4e779c95a623dfb00800feee408bc6377 (from https://pypi.org/simple/utr/) (requires-python:>=3.9,<4.0)
2022-09-29T17:47:37,791   Found link https://files.pythonhosted.org/packages/0e/3e/1df4eb6ee822990e1048b37dc435ebb139a9c1cb1e33113445a67daf85bb/utr-1.1.0.tar.gz#sha256=56442f74084ccf91b1efd0ec17f610d10089d1d95cbec51853ec2110b0faf3fe (from https://pypi.org/simple/utr/) (requires-python:>=3.9,<4.0), version: 1.1.0
2022-09-29T17:47:37,791   Skipping link: No binaries permitted for utr: https://files.pythonhosted.org/packages/e5/ca/e34598d7cb10b937b70f66afd1a2a9b76d1ada932dd56cbf751ecfcdaef0/utr-1.1.1-py3-none-any.whl#sha256=5f19dbd4fecf0fe200f6d89daf9278c8a6b20052ace62b7f3ea2f5d4a6ee2215 (from https://pypi.org/simple/utr/) (requires-python:>=3.9,<4.0)
2022-09-29T17:47:37,793   Found link https://files.pythonhosted.org/packages/05/d6/3735e7038698f8ae9527aab4025839e618c3c1d1d84818bbd90708f01428/utr-1.1.1.tar.gz#sha256=42cc76c554fb4f70fe7d41326a04ba43bec50b716279fb7d370029e3c4608808 (from https://pypi.org/simple/utr/) (requires-python:>=3.9,<4.0), version: 1.1.1
2022-09-29T17:47:37,794 Fetching project page and analyzing links: https://www.piwheels.org/simple/utr/
2022-09-29T17:47:37,794 Getting page https://www.piwheels.org/simple/utr/
2022-09-29T17:47:37,796 Found index url https://www.piwheels.org/simple
2022-09-29T17:47:38,018   Skipping link: No binaries permitted for utr: https://www.piwheels.org/simple/utr/utr-1.1.0-py3-none-any.whl#sha256=4f420c879d081a0d426f5c8e8c218bc4e779c95a623dfb00800feee408bc6377 (from https://www.piwheels.org/simple/utr/) (requires-python:>=3.9,<4.0)
2022-09-29T17:47:38,019 Skipping link: not a file: https://www.piwheels.org/simple/utr/
2022-09-29T17:47:38,019 Skipping link: not a file: https://pypi.org/simple/utr/
2022-09-29T17:47:38,064 Given no hashes to check 1 links for project 'utr': discarding no candidates
2022-09-29T17:47:38,107 Collecting utr==1.1.1
2022-09-29T17:47:38,111   Created temporary directory: /tmp/pip-unpack-yuqvc_4n
2022-09-29T17:47:38,353   Downloading utr-1.1.1.tar.gz (23 kB)
2022-09-29T17:47:38,467   Added utr==1.1.1 from https://files.pythonhosted.org/packages/05/d6/3735e7038698f8ae9527aab4025839e618c3c1d1d84818bbd90708f01428/utr-1.1.1.tar.gz#sha256=42cc76c554fb4f70fe7d41326a04ba43bec50b716279fb7d370029e3c4608808 to build tracker '/tmp/pip-build-tracker-nmsb7251'
2022-09-29T17:47:38,479   Created temporary directory: /tmp/pip-build-env-tkdlbbxd
2022-09-29T17:47:38,499   Created temporary directory: /tmp/pip-standalone-pip-22ev6esw
2022-09-29T17:47:43,441   Installing build dependencies: started
2022-09-29T17:47:43,443   Running command pip subprocess to install build dependencies
2022-09-29T17:47:54,790   Using pip 22.1.2 from /tmp/pip-standalone-pip-22ev6esw/__env_pip__.zip/pip (python 3.9)
2022-09-29T17:47:56,879   Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple
2022-09-29T17:47:57,706   Collecting poetry-core>=1.0.8
2022-09-29T17:47:57,836     Using cached https://www.piwheels.org/simple/poetry-core/poetry_core-1.2.0-py3-none-any.whl (525 kB)
2022-09-29T17:48:07,343   Installing collected packages: poetry-core
2022-09-29T17:48:11,531   Successfully installed poetry-core-1.2.0
2022-09-29T17:48:12,152   --- Logging error ---
2022-09-29T17:48:12,188   Traceback (most recent call last):
2022-09-29T17:48:12,188     File "/tmp/pip-standalone-pip-22ev6esw/__env_pip__.zip/pip/_internal/utils/logging.py", line 177, in emit
2022-09-29T17:48:12,188       self.console.print(renderable, overflow="ignore", crop=False, style=style)
2022-09-29T17:48:12,189     File "/tmp/pip-standalone-pip-22ev6esw/__env_pip__.zip/pip/_vendor/rich/console.py", line 1752, in print
2022-09-29T17:48:12,189       extend(render(renderable, render_options))
2022-09-29T17:48:12,189     File "/tmp/pip-standalone-pip-22ev6esw/__env_pip__.zip/pip/_vendor/rich/console.py", line 1390, in render
2022-09-29T17:48:12,190       for render_output in iter_render:
2022-09-29T17:48:12,190     File "/tmp/pip-standalone-pip-22ev6esw/__env_pip__.zip/pip/_internal/utils/logging.py", line 134, in __rich_console__
2022-09-29T17:48:12,190       for line in lines:
2022-09-29T17:48:12,191     File "/tmp/pip-standalone-pip-22ev6esw/__env_pip__.zip/pip/_vendor/rich/segment.py", line 245, in split_lines
2022-09-29T17:48:12,191       for segment in segments:
2022-09-29T17:48:12,191     File "/tmp/pip-standalone-pip-22ev6esw/__env_pip__.zip/pip/_vendor/rich/console.py", line 1368, in render
2022-09-29T17:48:12,192       renderable = rich_cast(renderable)
2022-09-29T17:48:12,192     File "/tmp/pip-standalone-pip-22ev6esw/__env_pip__.zip/pip/_vendor/rich/protocol.py", line 36, in rich_cast
2022-09-29T17:48:12,192       renderable = cast_method()
2022-09-29T17:48:12,193     File "/tmp/pip-standalone-pip-22ev6esw/__env_pip__.zip/pip/_internal/self_outdated_check.py", line 130, in __rich__
2022-09-29T17:48:12,193       pip_cmd = get_best_invocation_for_this_pip()
2022-09-29T17:48:12,193     File "/tmp/pip-standalone-pip-22ev6esw/__env_pip__.zip/pip/_internal/utils/entrypoints.py", line 58, in get_best_invocation_for_this_pip
2022-09-29T17:48:12,194       if found_executable and os.path.samefile(
2022-09-29T17:48:12,194     File "/usr/lib/python3.9/genericpath.py", line 101, in samefile
2022-09-29T17:48:12,194       s2 = os.stat(f2)
2022-09-29T17:48:12,195   FileNotFoundError: [Errno 2] No such file or directory: '/usr/bin/pip3.9'
2022-09-29T17:48:12,195   Call stack:
2022-09-29T17:48:12,200     File "/usr/lib/python3.9/runpy.py", line 197, in _run_module_as_main
2022-09-29T17:48:12,200       return _run_code(code, main_globals, None,
2022-09-29T17:48:12,200     File "/usr/lib/python3.9/runpy.py", line 87, in _run_code
2022-09-29T17:48:12,201       exec(code, run_globals)
2022-09-29T17:48:12,201     File "/tmp/pip-standalone-pip-22ev6esw/__env_pip__.zip/pip/__main__.py", line 31, in <module>
2022-09-29T17:48:12,201       sys.exit(_main())
2022-09-29T17:48:12,202     File "/tmp/pip-standalone-pip-22ev6esw/__env_pip__.zip/pip/_internal/cli/main.py", line 70, in main
2022-09-29T17:48:12,202       return command.main(cmd_args)
2022-09-29T17:48:12,202     File "/tmp/pip-standalone-pip-22ev6esw/__env_pip__.zip/pip/_internal/cli/base_command.py", line 101, in main
2022-09-29T17:48:12,203       return self._main(args)
2022-09-29T17:48:12,203     File "/tmp/pip-standalone-pip-22ev6esw/__env_pip__.zip/pip/_internal/cli/base_command.py", line 223, in _main
2022-09-29T17:48:12,203       self.handle_pip_version_check(options)
2022-09-29T17:48:12,204     File "/tmp/pip-standalone-pip-22ev6esw/__env_pip__.zip/pip/_internal/cli/req_command.py", line 148, in handle_pip_version_check
2022-09-29T17:48:12,204       pip_self_version_check(session, options)
2022-09-29T17:48:12,204     File "/tmp/pip-standalone-pip-22ev6esw/__env_pip__.zip/pip/_internal/self_outdated_check.py", line 237, in pip_self_version_check
2022-09-29T17:48:12,205       logger.info("[present-rich] %s", upgrade_prompt)
2022-09-29T17:48:12,205     File "/usr/lib/python3.9/logging/__init__.py", line 1442, in info
2022-09-29T17:48:12,205       self._log(INFO, msg, args, **kwargs)
2022-09-29T17:48:12,206     File "/usr/lib/python3.9/logging/__init__.py", line 1585, in _log
2022-09-29T17:48:12,206       self.handle(record)
2022-09-29T17:48:12,206     File "/usr/lib/python3.9/logging/__init__.py", line 1595, in handle
2022-09-29T17:48:12,206       self.callHandlers(record)
2022-09-29T17:48:12,207     File "/usr/lib/python3.9/logging/__init__.py", line 1657, in callHandlers
2022-09-29T17:48:12,207       hdlr.handle(record)
2022-09-29T17:48:12,207     File "/usr/lib/python3.9/logging/__init__.py", line 948, in handle
2022-09-29T17:48:12,208       self.emit(record)
2022-09-29T17:48:12,208     File "/tmp/pip-standalone-pip-22ev6esw/__env_pip__.zip/pip/_internal/utils/logging.py", line 179, in emit
2022-09-29T17:48:12,208       self.handleError(record)
2022-09-29T17:48:12,208   Message: '[present-rich] %s'
2022-09-29T17:48:12,209   Arguments: (UpgradePrompt(old='22.1.2', new='22.2.2'),)
2022-09-29T17:48:12,660   Installing build dependencies: finished with status 'done'
2022-09-29T17:48:12,689   Getting requirements to build wheel: started
2022-09-29T17:48:12,691   Running command Getting requirements to build wheel
2022-09-29T17:48:13,445   Getting requirements to build wheel: finished with status 'done'
2022-09-29T17:48:13,456   Created temporary directory: /tmp/pip-modern-metadata-y0j5j9t7
2022-09-29T17:48:13,462   Preparing metadata (pyproject.toml): started
2022-09-29T17:48:13,464   Running command Preparing metadata (pyproject.toml)
2022-09-29T17:48:15,670   Preparing metadata (pyproject.toml): finished with status 'done'
2022-09-29T17:48:15,686   Source in /tmp/pip-wheel-bz9nrank/utr_da77131f16394e548d36013cd700212d has version 1.1.1, which satisfies requirement utr==1.1.1 from https://files.pythonhosted.org/packages/05/d6/3735e7038698f8ae9527aab4025839e618c3c1d1d84818bbd90708f01428/utr-1.1.1.tar.gz#sha256=42cc76c554fb4f70fe7d41326a04ba43bec50b716279fb7d370029e3c4608808
2022-09-29T17:48:15,688   Removed utr==1.1.1 from https://files.pythonhosted.org/packages/05/d6/3735e7038698f8ae9527aab4025839e618c3c1d1d84818bbd90708f01428/utr-1.1.1.tar.gz#sha256=42cc76c554fb4f70fe7d41326a04ba43bec50b716279fb7d370029e3c4608808 from build tracker '/tmp/pip-build-tracker-nmsb7251'
2022-09-29T17:48:15,703 Created temporary directory: /tmp/pip-unpack-m3hm51p_
2022-09-29T17:48:15,704 Building wheels for collected packages: utr
2022-09-29T17:48:15,714   Created temporary directory: /tmp/pip-wheel-o3k8kz8i
2022-09-29T17:48:15,714   Destination directory: /tmp/pip-wheel-o3k8kz8i
2022-09-29T17:48:15,720   Building wheel for utr (pyproject.toml): started
2022-09-29T17:48:15,721   Running command Building wheel for utr (pyproject.toml)
2022-09-29T17:48:18,270   Building wheel for utr (pyproject.toml): finished with status 'done'
2022-09-29T17:48:18,283   Created wheel for utr: filename=utr-1.1.1-py3-none-any.whl size=37938 sha256=5f19dbd4fecf0fe200f6d89daf9278c8a6b20052ace62b7f3ea2f5d4a6ee2215
2022-09-29T17:48:18,285   Stored in directory: /tmp/pip-ephem-wheel-cache-z6co9a52/wheels/41/3a/b7/caee752d519644e4d6a68ab0575fc9a4d9abfa4c03c24cde41
2022-09-29T17:48:18,312 Successfully built utr
2022-09-29T17:48:18,322 Removed build tracker: '/tmp/pip-build-tracker-nmsb7251'