2022-10-12T06:02:56,202 Created temporary directory: /tmp/pip-ephem-wheel-cache-z6i8anta
2022-10-12T06:02:56,208 Created temporary directory: /tmp/pip-build-tracker-6rvxd9yk
2022-10-12T06:02:56,209 Initialized build tracking at /tmp/pip-build-tracker-6rvxd9yk
2022-10-12T06:02:56,209 Created build tracker: /tmp/pip-build-tracker-6rvxd9yk
2022-10-12T06:02:56,209 Entered build tracker: /tmp/pip-build-tracker-6rvxd9yk
2022-10-12T06:02:56,211 Created temporary directory: /tmp/pip-wheel-f785wnkj
2022-10-12T06:02:56,274 Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple
2022-10-12T06:02:56,282 2 location(s) to search for versions of plenary:
2022-10-12T06:02:56,282 * https://pypi.org/simple/plenary/
2022-10-12T06:02:56,282 * https://www.piwheels.org/simple/plenary/
2022-10-12T06:02:56,283 Fetching project page and analyzing links: https://pypi.org/simple/plenary/
2022-10-12T06:02:56,284 Getting page https://pypi.org/simple/plenary/
2022-10-12T06:02:56,288 Found index url https://pypi.org/simple
2022-10-12T06:02:56,486   Skipping link: No binaries permitted for plenary: https://files.pythonhosted.org/packages/00/55/7d7292086d5c5f7fde35aa656c1e4e7baeefaf50aa25050280c945123292/plenary-1.3.3-py3-none-any.whl#sha256=5cd0a4cddbec8d6445c1a120b02cb3774722e02af9542fcc6a12fe9c56dc5da9 (from https://pypi.org/simple/plenary/) (requires-python:>=3.7,<4.0)
2022-10-12T06:02:56,488   Found link https://files.pythonhosted.org/packages/cd/a6/807f688d6c2b9a1d0b89c7bf4ed0fad5ec4f813671cd33f0fddb10916eb6/plenary-1.3.3.tar.gz#sha256=c8b5408aad742c368d3087214cde0a85d1c41c4b192126e19a4ff942e8d4d629 (from https://pypi.org/simple/plenary/) (requires-python:>=3.7,<4.0), version: 1.3.3
2022-10-12T06:02:56,489   Skipping link: No binaries permitted for plenary: https://files.pythonhosted.org/packages/07/88/126198708f290d4ca8995eced325885888b1d69eba3f05d789d611ce326e/plenary-1.4.1-py3-none-any.whl#sha256=538af107f6f50f5bf00966ceb08a1a3de380e1444e841d0193aa0e6f04bd1bc3 (from https://pypi.org/simple/plenary/) (requires-python:>=3.7,<4.0)
2022-10-12T06:02:56,490   Found link https://files.pythonhosted.org/packages/ea/67/b335c83c1911dee0f256f00c38a323fea1353ec6c9139895d5a49e9dd352/plenary-1.4.1.tar.gz#sha256=d3e973f4e341c3f588a9ea47117ce5fba9091cc86ce6ac467a9b26b9101c8171 (from https://pypi.org/simple/plenary/) (requires-python:>=3.7,<4.0), version: 1.4.1
2022-10-12T06:02:56,491   Skipping link: No binaries permitted for plenary: https://files.pythonhosted.org/packages/f0/28/20e57ff43ffb2f48ce1c3b39c88c000781b8f079e4cbfd3110d45971ee2e/plenary-1.4.2-py3-none-any.whl#sha256=99c626428580c98cbf555c0f0df3ff77fd9bf32e5836dc66d2c524e0e578342d (from https://pypi.org/simple/plenary/) (requires-python:>=3.7,<4.0)
2022-10-12T06:02:56,493   Found link https://files.pythonhosted.org/packages/60/0b/09563fc5868c4209f5be649d93df85952e783aac26fbfc501473d00284a1/plenary-1.4.2.tar.gz#sha256=6882ec8baf4a6fafafd9f83c72737ee6afae5f476aa8dc950fa0f01af6cecef3 (from https://pypi.org/simple/plenary/) (requires-python:>=3.7,<4.0), version: 1.4.2
2022-10-12T06:02:56,493   Skipping link: No binaries permitted for plenary: https://files.pythonhosted.org/packages/a4/69/428faf4a6af76ae4c5ff51f0e019f7d9e76cc3771d8dffbd0b14d24f8498/plenary-1.4.3-py3-none-any.whl#sha256=15273e0a98fa72cd044bc712a02cccc437ef08e62e442b3278a4c5063b12d452 (from https://pypi.org/simple/plenary/) (requires-python:>=3.7,<4.0)
2022-10-12T06:02:56,495   Found link https://files.pythonhosted.org/packages/cd/b9/5f00961991890778718c156909fa5d76bb0a70eb94162f56c428dbb09a4f/plenary-1.4.3.tar.gz#sha256=1b623ac475d5c685dec6b8ce745bf007c003a9f8eb13fb5de67390ad66f8d875 (from https://pypi.org/simple/plenary/) (requires-python:>=3.7,<4.0), version: 1.4.3
2022-10-12T06:02:56,496   Skipping link: No binaries permitted for plenary: https://files.pythonhosted.org/packages/b6/db/442a00a074add230f7f264f98d2f9897c8fafcc19ca7f36f1b21a683b6e2/plenary-1.5.0-py3-none-any.whl#sha256=8a374a258322afe29b0ea0625e3a6c3b1d6a0b1ecdd0e95780da11a0c93002eb (from https://pypi.org/simple/plenary/) (requires-python:>=3.7,<4.0)
2022-10-12T06:02:56,497   Found link https://files.pythonhosted.org/packages/cc/c4/1d5bab2da425a73397754e98919565074ca54a8f749ff74e73053b3ae43a/plenary-1.5.0.tar.gz#sha256=4688aac6a5c7d72866debd9f2cb0ba1c10cbc6558e7a0b5a9d932e0b7768c6bb (from https://pypi.org/simple/plenary/) (requires-python:>=3.7,<4.0), version: 1.5.0
2022-10-12T06:02:56,498   Skipping link: No binaries permitted for plenary: https://files.pythonhosted.org/packages/72/ea/752a55d2c67d6cea2d5dd3d92844389b858a47d1b13837dfa7abc87baa1a/plenary-1.5.1-py3-none-any.whl#sha256=26cb708cdec8b3b7e4280059aa834f8b768dcdbd4cf89680789ff375b756477f (from https://pypi.org/simple/plenary/) (requires-python:>=3.7,<4.0)
2022-10-12T06:02:56,500   Found link https://files.pythonhosted.org/packages/a7/86/6ff497a0f626a5a5a71a656f4c5feaa4db7e91ef9b8e0e77316c592012f7/plenary-1.5.1.tar.gz#sha256=6e26782cdb5f8863c8cb3a1242e2243ccab7428f09fc87eda8a4ea41c77c74ca (from https://pypi.org/simple/plenary/) (requires-python:>=3.7,<4.0), version: 1.5.1
2022-10-12T06:02:56,501   Skipping link: No binaries permitted for plenary: https://files.pythonhosted.org/packages/fe/c8/cb7511aaa6fb2dd5f955fb7d2b20cefd8546b598bc6679fbfc2ee2fb306f/plenary-1.5.2-py3-none-any.whl#sha256=9a54abab9859299a36533222b640ab721d7b6d5c818715c624adddadffdec41d (from https://pypi.org/simple/plenary/) (requires-python:>=3.7,<4.0)
2022-10-12T06:02:56,502   Found link https://files.pythonhosted.org/packages/16/03/be1587bd8f9c7095961c9fba17201c838d932ddab4eb7b8c37312d61abaf/plenary-1.5.2.tar.gz#sha256=4ea2bd478e95dc0fab7a1ee79e904d19a6a64804bbec489db496847cb15e69b2 (from https://pypi.org/simple/plenary/) (requires-python:>=3.7,<4.0), version: 1.5.2
2022-10-12T06:02:56,503   Skipping link: No binaries permitted for plenary: https://files.pythonhosted.org/packages/93/49/8b3650ac88606c31f66f6b00af97f6d7a874d7d78a93d4d9088fe5e1f42f/plenary-1.6.0-py3-none-any.whl#sha256=a3805775824c63f58e8d5a14d9cb56e12382522836e10b02e3dbe09af27b4a4d (from https://pypi.org/simple/plenary/) (requires-python:>=3.7,<4.0)
2022-10-12T06:02:56,505   Found link https://files.pythonhosted.org/packages/b2/96/db6eb2b5a79a83bd8f6f916f11772664b607c4afaa6354a42fe270f827de/plenary-1.6.0.tar.gz#sha256=30402170ebbfcc2aed8dab2928a05f6e7f6a6e0123a19e52f99d5ce8abb36287 (from https://pypi.org/simple/plenary/) (requires-python:>=3.7,<4.0), version: 1.6.0
2022-10-12T06:02:56,505 Fetching project page and analyzing links: https://www.piwheels.org/simple/plenary/
2022-10-12T06:02:56,506 Getting page https://www.piwheels.org/simple/plenary/
2022-10-12T06:02:56,508 Found index url https://www.piwheels.org/simple
2022-10-12T06:02:56,753   Skipping link: No binaries permitted for plenary: https://www.piwheels.org/simple/plenary/plenary-1.5.2-py3-none-any.whl#sha256=d66681b10471d46f957a912e74466dd9e43358d9da53949def2e1de06c4f0136 (from https://www.piwheels.org/simple/plenary/) (requires-python:>=3.7,<4.0)
2022-10-12T06:02:56,754   Skipping link: No binaries permitted for plenary: https://www.piwheels.org/simple/plenary/plenary-1.5.1-py3-none-any.whl#sha256=e1d5fdba6732bab35835adb7527361aa1555fe598a1021821fc1a73c89b69895 (from https://www.piwheels.org/simple/plenary/) (requires-python:>=3.7,<4.0)
2022-10-12T06:02:56,754   Skipping link: No binaries permitted for plenary: https://www.piwheels.org/simple/plenary/plenary-1.5.0-py3-none-any.whl#sha256=fcacc6f60eac96f21f12128b350f786258d98f0936fca1530ae317fb9a66c13f (from https://www.piwheels.org/simple/plenary/) (requires-python:>=3.7,<4.0)
2022-10-12T06:02:56,755   Skipping link: No binaries permitted for plenary: https://www.piwheels.org/simple/plenary/plenary-1.4.3-py3-none-any.whl#sha256=15273e0a98fa72cd044bc712a02cccc437ef08e62e442b3278a4c5063b12d452 (from https://www.piwheels.org/simple/plenary/) (requires-python:>=3.7,<4.0)
2022-10-12T06:02:56,755   Skipping link: No binaries permitted for plenary: https://www.piwheels.org/simple/plenary/plenary-1.4.2-py3-none-any.whl#sha256=99c626428580c98cbf555c0f0df3ff77fd9bf32e5836dc66d2c524e0e578342d (from https://www.piwheels.org/simple/plenary/) (requires-python:>=3.7,<4.0)
2022-10-12T06:02:56,756   Skipping link: No binaries permitted for plenary: https://www.piwheels.org/simple/plenary/plenary-1.4.1-py3-none-any.whl#sha256=538af107f6f50f5bf00966ceb08a1a3de380e1444e841d0193aa0e6f04bd1bc3 (from https://www.piwheels.org/simple/plenary/) (requires-python:>=3.7,<4.0)
2022-10-12T06:02:56,756   Skipping link: No binaries permitted for plenary: https://www.piwheels.org/simple/plenary/plenary-1.3.3-py3-none-any.whl#sha256=5cd0a4cddbec8d6445c1a120b02cb3774722e02af9542fcc6a12fe9c56dc5da9 (from https://www.piwheels.org/simple/plenary/) (requires-python:>=3.7,<4.0)
2022-10-12T06:02:56,757 Skipping link: not a file: https://www.piwheels.org/simple/plenary/
2022-10-12T06:02:56,757 Skipping link: not a file: https://pypi.org/simple/plenary/
2022-10-12T06:02:56,794 Given no hashes to check 1 links for project 'plenary': discarding no candidates
2022-10-12T06:02:56,825 Collecting plenary==1.6.0
2022-10-12T06:02:56,830   Created temporary directory: /tmp/pip-unpack-sbicx5t8
2022-10-12T06:02:57,318   Downloading plenary-1.6.0.tar.gz (25 kB)
2022-10-12T06:02:57,448   Added plenary==1.6.0 from https://files.pythonhosted.org/packages/b2/96/db6eb2b5a79a83bd8f6f916f11772664b607c4afaa6354a42fe270f827de/plenary-1.6.0.tar.gz#sha256=30402170ebbfcc2aed8dab2928a05f6e7f6a6e0123a19e52f99d5ce8abb36287 to build tracker '/tmp/pip-build-tracker-6rvxd9yk'
2022-10-12T06:02:57,464   Created temporary directory: /tmp/pip-build-env-m3xc53_q
2022-10-12T06:02:57,479   Created temporary directory: /tmp/pip-standalone-pip-s0i3lb_7
2022-10-12T06:02:59,886   Installing build dependencies: started
2022-10-12T06:02:59,888   Running command pip subprocess to install build dependencies
2022-10-12T06:03:09,532   Using pip 22.1.2 from /tmp/pip-standalone-pip-s0i3lb_7/__env_pip__.zip/pip (python 3.7)
2022-10-12T06:03:11,664   Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple
2022-10-12T06:03:12,606   Collecting poetry-core>=1.0.0
2022-10-12T06:03:12,846     Using cached https://www.piwheels.org/simple/poetry-core/poetry_core-1.3.2-py3-none-any.whl (531 kB)
2022-10-12T06:03:14,061   Collecting importlib-metadata>=1.7.0
2022-10-12T06:03:14,188     Using cached https://www.piwheels.org/simple/importlib-metadata/importlib_metadata-5.0.0-py3-none-any.whl (21 kB)
2022-10-12T06:03:14,757   Collecting typing-extensions>=3.6.4
2022-10-12T06:03:14,797     Using cached https://www.piwheels.org/simple/typing-extensions/typing_extensions-4.4.0-py3-none-any.whl (26 kB)
2022-10-12T06:03:15,278   Collecting zipp>=0.5
2022-10-12T06:03:15,315     Using cached https://www.piwheels.org/simple/zipp/zipp-3.9.0-py3-none-any.whl (5.8 kB)
2022-10-12T06:03:27,418   Installing collected packages: zipp, typing-extensions, importlib-metadata, poetry-core
2022-10-12T06:03:31,580   Successfully installed importlib-metadata-5.0.0 poetry-core-1.3.2 typing-extensions-4.4.0 zipp-3.9.0
2022-10-12T06:03:31,842   --- Logging error ---
2022-10-12T06:03:31,842   Traceback (most recent call last):
2022-10-12T06:03:31,843     File "/tmp/pip-standalone-pip-s0i3lb_7/__env_pip__.zip/pip/_internal/utils/logging.py", line 177, in emit
2022-10-12T06:03:31,843       self.console.print(renderable, overflow="ignore", crop=False, style=style)
2022-10-12T06:03:31,843     File "/tmp/pip-standalone-pip-s0i3lb_7/__env_pip__.zip/pip/_vendor/rich/console.py", line 1752, in print
2022-10-12T06:03:31,844       extend(render(renderable, render_options))
2022-10-12T06:03:31,844     File "/tmp/pip-standalone-pip-s0i3lb_7/__env_pip__.zip/pip/_vendor/rich/console.py", line 1390, in render
2022-10-12T06:03:31,844       for render_output in iter_render:
2022-10-12T06:03:31,845     File "/tmp/pip-standalone-pip-s0i3lb_7/__env_pip__.zip/pip/_internal/utils/logging.py", line 134, in __rich_console__
2022-10-12T06:03:31,845       for line in lines:
2022-10-12T06:03:31,845     File "/tmp/pip-standalone-pip-s0i3lb_7/__env_pip__.zip/pip/_vendor/rich/segment.py", line 245, in split_lines
2022-10-12T06:03:31,845       for segment in segments:
2022-10-12T06:03:31,846     File "/tmp/pip-standalone-pip-s0i3lb_7/__env_pip__.zip/pip/_vendor/rich/console.py", line 1368, in render
2022-10-12T06:03:31,846       renderable = rich_cast(renderable)
2022-10-12T06:03:31,846     File "/tmp/pip-standalone-pip-s0i3lb_7/__env_pip__.zip/pip/_vendor/rich/protocol.py", line 36, in rich_cast
2022-10-12T06:03:31,847       renderable = cast_method()
2022-10-12T06:03:31,847     File "/tmp/pip-standalone-pip-s0i3lb_7/__env_pip__.zip/pip/_internal/self_outdated_check.py", line 130, in __rich__
2022-10-12T06:03:31,847       pip_cmd = get_best_invocation_for_this_pip()
2022-10-12T06:03:31,848     File "/tmp/pip-standalone-pip-s0i3lb_7/__env_pip__.zip/pip/_internal/utils/entrypoints.py", line 60, in get_best_invocation_for_this_pip
2022-10-12T06:03:31,848       os.path.join(binary_prefix, exe_name),
2022-10-12T06:03:31,848     File "/usr/lib/python3.7/genericpath.py", line 97, in samefile
2022-10-12T06:03:31,849       s2 = os.stat(f2)
2022-10-12T06:03:31,849   FileNotFoundError: [Errno 2] No such file or directory: '/usr/bin/pip3.7'
2022-10-12T06:03:31,849   Call stack:
2022-10-12T06:03:31,850     File "/usr/lib/python3.7/runpy.py", line 193, in _run_module_as_main
2022-10-12T06:03:31,850       "__main__", mod_spec)
2022-10-12T06:03:31,850     File "/usr/lib/python3.7/runpy.py", line 85, in _run_code
2022-10-12T06:03:31,851       exec(code, run_globals)
2022-10-12T06:03:31,851     File "/tmp/pip-standalone-pip-s0i3lb_7/__env_pip__.zip/pip/__main__.py", line 31, in <module>
2022-10-12T06:03:31,851       sys.exit(_main())
2022-10-12T06:03:31,852     File "/tmp/pip-standalone-pip-s0i3lb_7/__env_pip__.zip/pip/_internal/cli/main.py", line 70, in main
2022-10-12T06:03:31,852       return command.main(cmd_args)
2022-10-12T06:03:31,852     File "/tmp/pip-standalone-pip-s0i3lb_7/__env_pip__.zip/pip/_internal/cli/base_command.py", line 101, in main
2022-10-12T06:03:31,852       return self._main(args)
2022-10-12T06:03:31,853     File "/tmp/pip-standalone-pip-s0i3lb_7/__env_pip__.zip/pip/_internal/cli/base_command.py", line 223, in _main
2022-10-12T06:03:31,853       self.handle_pip_version_check(options)
2022-10-12T06:03:31,853     File "/tmp/pip-standalone-pip-s0i3lb_7/__env_pip__.zip/pip/_internal/cli/req_command.py", line 148, in handle_pip_version_check
2022-10-12T06:03:31,854       pip_self_version_check(session, options)
2022-10-12T06:03:31,854     File "/tmp/pip-standalone-pip-s0i3lb_7/__env_pip__.zip/pip/_internal/self_outdated_check.py", line 237, in pip_self_version_check
2022-10-12T06:03:31,854       logger.info("[present-rich] %s", upgrade_prompt)
2022-10-12T06:03:31,855     File "/usr/lib/python3.7/logging/__init__.py", line 1383, in info
2022-10-12T06:03:31,855       self._log(INFO, msg, args, **kwargs)
2022-10-12T06:03:31,855     File "/usr/lib/python3.7/logging/__init__.py", line 1519, in _log
2022-10-12T06:03:31,855       self.handle(record)
2022-10-12T06:03:31,856     File "/usr/lib/python3.7/logging/__init__.py", line 1529, in handle
2022-10-12T06:03:31,856       self.callHandlers(record)
2022-10-12T06:03:31,856     File "/usr/lib/python3.7/logging/__init__.py", line 1591, in callHandlers
2022-10-12T06:03:31,857       hdlr.handle(record)
2022-10-12T06:03:31,857     File "/usr/lib/python3.7/logging/__init__.py", line 905, in handle
2022-10-12T06:03:31,857       self.emit(record)
2022-10-12T06:03:31,858     File "/tmp/pip-standalone-pip-s0i3lb_7/__env_pip__.zip/pip/_internal/utils/logging.py", line 179, in emit
2022-10-12T06:03:31,858       self.handleError(record)
2022-10-12T06:03:31,858   Message: '[present-rich] %s'
2022-10-12T06:03:31,859   Arguments: (UpgradePrompt(old='22.1.2', new='22.2.2'),)
2022-10-12T06:03:32,306   Installing build dependencies: finished with status 'done'
2022-10-12T06:03:32,333   Getting requirements to build wheel: started
2022-10-12T06:03:32,335   Running command Getting requirements to build wheel
2022-10-12T06:03:33,077   Getting requirements to build wheel: finished with status 'done'
2022-10-12T06:03:33,089   Created temporary directory: /tmp/pip-modern-metadata-lf1vs1_p
2022-10-12T06:03:33,095   Preparing metadata (pyproject.toml): started
2022-10-12T06:03:33,097   Running command Preparing metadata (pyproject.toml)
2022-10-12T06:03:35,149   Preparing metadata (pyproject.toml): finished with status 'done'
2022-10-12T06:03:35,164   Source in /tmp/pip-wheel-f785wnkj/plenary_f9fbe77fbca14415bb1bbc606f39bf66 has version 1.6.0, which satisfies requirement plenary==1.6.0 from https://files.pythonhosted.org/packages/b2/96/db6eb2b5a79a83bd8f6f916f11772664b607c4afaa6354a42fe270f827de/plenary-1.6.0.tar.gz#sha256=30402170ebbfcc2aed8dab2928a05f6e7f6a6e0123a19e52f99d5ce8abb36287
2022-10-12T06:03:35,166   Removed plenary==1.6.0 from https://files.pythonhosted.org/packages/b2/96/db6eb2b5a79a83bd8f6f916f11772664b607c4afaa6354a42fe270f827de/plenary-1.6.0.tar.gz#sha256=30402170ebbfcc2aed8dab2928a05f6e7f6a6e0123a19e52f99d5ce8abb36287 from build tracker '/tmp/pip-build-tracker-6rvxd9yk'
2022-10-12T06:03:35,180 Created temporary directory: /tmp/pip-unpack-9_r7b5ja
2022-10-12T06:03:35,181 Building wheels for collected packages: plenary
2022-10-12T06:03:35,191   Created temporary directory: /tmp/pip-wheel-he4jd5r5
2022-10-12T06:03:35,191   Destination directory: /tmp/pip-wheel-he4jd5r5
2022-10-12T06:03:35,196   Building wheel for plenary (pyproject.toml): started
2022-10-12T06:03:35,198   Running command Building wheel for plenary (pyproject.toml)
2022-10-12T06:03:37,388   Building wheel for plenary (pyproject.toml): finished with status 'done'
2022-10-12T06:03:37,402   Created wheel for plenary: filename=plenary-1.6.0-py3-none-any.whl size=28644 sha256=a3805775824c63f58e8d5a14d9cb56e12382522836e10b02e3dbe09af27b4a4d
2022-10-12T06:03:37,404   Stored in directory: /tmp/pip-ephem-wheel-cache-z6i8anta/wheels/d0/58/82/a2bd803d703347ca711169da2aa59661055e72131d41c7af69
2022-10-12T06:03:37,429 Successfully built plenary
2022-10-12T06:03:37,439 Removed build tracker: '/tmp/pip-build-tracker-6rvxd9yk'