2023-07-06T20:00:02,877 Created temporary directory: /tmp/pip-build-tracker-st9_xpzu
2023-07-06T20:00:02,878 Initialized build tracking at /tmp/pip-build-tracker-st9_xpzu
2023-07-06T20:00:02,878 Created build tracker: /tmp/pip-build-tracker-st9_xpzu
2023-07-06T20:00:02,878 Entered build tracker: /tmp/pip-build-tracker-st9_xpzu
2023-07-06T20:00:02,879 Created temporary directory: /tmp/pip-wheel-p6wiyk_g
2023-07-06T20:00:02,882 Created temporary directory: /tmp/pip-ephem-wheel-cache-rd0wudp2
2023-07-06T20:00:02,909 Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple
2023-07-06T20:00:02,912 2 location(s) to search for versions of nhs-context-logging:
2023-07-06T20:00:02,912 * https://pypi.org/simple/nhs-context-logging/
2023-07-06T20:00:02,912 * https://www.piwheels.org/simple/nhs-context-logging/
2023-07-06T20:00:02,912 Fetching project page and analyzing links: https://pypi.org/simple/nhs-context-logging/
2023-07-06T20:00:02,913 Getting page https://pypi.org/simple/nhs-context-logging/
2023-07-06T20:00:02,915 Found index url https://pypi.org/simple/
2023-07-06T20:00:02,991 Fetched page https://pypi.org/simple/nhs-context-logging/ as application/vnd.pypi.simple.v1+json
2023-07-06T20:00:02,993   Skipping link: No binaries permitted for nhs-context-logging: https://files.pythonhosted.org/packages/ab/9d/537da583d670c1f12a9f359d6258906ec3b8506a99dfb447d49824b5ee40/nhs_context_logging-0.2.3-py3-none-any.whl (from https://pypi.org/simple/nhs-context-logging/) (requires-python:>=3.8.1)
2023-07-06T20:00:02,993   Found link https://files.pythonhosted.org/packages/79/b9/3855eb04422c21c0d7000979f7c858dd8fb259d5c51ffda7d52890c1b6e6/nhs_context_logging-0.2.3.tar.gz (from https://pypi.org/simple/nhs-context-logging/) (requires-python:>=3.8.1), version: 0.2.3
2023-07-06T20:00:02,994   Skipping link: No binaries permitted for nhs-context-logging: https://files.pythonhosted.org/packages/68/33/bddff5fd66e449902f0d8a6ab906a15a9758788fe488e76380daa657595a/nhs_context_logging-0.2.4-py3-none-any.whl (from https://pypi.org/simple/nhs-context-logging/) (requires-python:>=3.8.1)
2023-07-06T20:00:02,994   Found link https://files.pythonhosted.org/packages/0f/5d/59c8a4a7504423067213dc08c0b37e604675278dbf47c5b6de61d879361e/nhs_context_logging-0.2.4.tar.gz (from https://pypi.org/simple/nhs-context-logging/) (requires-python:>=3.8.1), version: 0.2.4
2023-07-06T20:00:02,994   Skipping link: No binaries permitted for nhs-context-logging: https://files.pythonhosted.org/packages/54/29/0f2fc31c0648850b8a7b22f158c9f04d51dd9565f99509ebc7004910002d/nhs_context_logging-0.2.5-py3-none-any.whl (from https://pypi.org/simple/nhs-context-logging/) (requires-python:>=3.8.1)
2023-07-06T20:00:02,995   Found link https://files.pythonhosted.org/packages/be/ce/2003452632732cfab9ed88440deea77551c78f2bd09532beb12b4db2db21/nhs_context_logging-0.2.5.tar.gz (from https://pypi.org/simple/nhs-context-logging/) (requires-python:>=3.8.1), version: 0.2.5
2023-07-06T20:00:02,995 Fetching project page and analyzing links: https://www.piwheels.org/simple/nhs-context-logging/
2023-07-06T20:00:02,996 Getting page https://www.piwheels.org/simple/nhs-context-logging/
2023-07-06T20:00:02,997 Found index url https://www.piwheels.org/simple/
2023-07-06T20:00:03,146 Fetched page https://www.piwheels.org/simple/nhs-context-logging/ as text/html
2023-07-06T20:00:03,147   Skipping link: No binaries permitted for nhs-context-logging: https://www.piwheels.org/simple/nhs-context-logging/nhs_context_logging-0.2.4-py3-none-any.whl#sha256=acf6b2d2ef2b6ac39e5c232339ad41f58c6e5fc0f21905d1b245c4366d547c56 (from https://www.piwheels.org/simple/nhs-context-logging/) (requires-python:>=3.8.1)
2023-07-06T20:00:03,148   Skipping link: No binaries permitted for nhs-context-logging: https://www.piwheels.org/simple/nhs-context-logging/nhs_context_logging-0.2.3-py3-none-any.whl#sha256=3df0d368854cdd42c8cc74c4291c8318444c08e6bee537303b8e2523150fc486 (from https://www.piwheels.org/simple/nhs-context-logging/) (requires-python:>=3.8.1)
2023-07-06T20:00:03,148 Skipping link: not a file: https://www.piwheels.org/simple/nhs-context-logging/
2023-07-06T20:00:03,148 Skipping link: not a file: https://pypi.org/simple/nhs-context-logging/
2023-07-06T20:00:03,166 Given no hashes to check 1 links for project 'nhs-context-logging': discarding no candidates
2023-07-06T20:00:03,183 Collecting nhs-context-logging==0.2.5
2023-07-06T20:00:03,185   Created temporary directory: /tmp/pip-unpack-mnvbtugk
2023-07-06T20:00:03,309   Downloading nhs_context_logging-0.2.5.tar.gz (25 kB)
2023-07-06T20:00:03,352   Added nhs-context-logging==0.2.5 from https://files.pythonhosted.org/packages/be/ce/2003452632732cfab9ed88440deea77551c78f2bd09532beb12b4db2db21/nhs_context_logging-0.2.5.tar.gz to build tracker '/tmp/pip-build-tracker-st9_xpzu'
2023-07-06T20:00:03,359   Created temporary directory: /tmp/pip-build-env-3q52ki09
2023-07-06T20:00:03,369   Installing build dependencies: started
2023-07-06T20:00:03,370   Running command pip subprocess to install build dependencies
2023-07-06T20:00:04,570   Using pip 23.1.2 from /home/piwheels/.local/lib/python3.9/site-packages/pip (python 3.9)
2023-07-06T20:00:04,935   Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple
2023-07-06T20:00:05,840   Collecting poetry>=1.2
2023-07-06T20:00:05,872     Using cached https://www.piwheels.org/simple/poetry/poetry-1.5.1-py3-none-any.whl (225 kB)
2023-07-06T20:00:06,164   Collecting poetry-dynamic-versioning
2023-07-06T20:00:06,181     Using cached https://www.piwheels.org/simple/poetry-dynamic-versioning/poetry_dynamic_versioning-0.24.0-py3-none-any.whl (16 kB)
2023-07-06T20:00:06,416   Collecting build<0.11.0,>=0.10.0 (from poetry>=1.2)
2023-07-06T20:00:06,433     Using cached https://www.piwheels.org/simple/build/build-0.10.0-py3-none-any.whl (17 kB)
2023-07-06T20:00:06,579   Collecting cachecontrol[filecache]<0.13.0,>=0.12.9 (from poetry>=1.2)
2023-07-06T20:00:06,597     Using cached https://www.piwheels.org/simple/cachecontrol/CacheControl-0.12.14-py2.py3-none-any.whl (21 kB)
2023-07-06T20:00:06,638     Link requires a different Python (3.9.2 not in: '>=2.7.0.0,<2.8.0.0,>=3.4.0.0,<4.0.0.0'): https://files.pythonhosted.org/packages/3d/53/4eaeead9a3564955a66ad25d99ddac161e9abc67646384019255afd2e0ce/cleo-0.6.2-py2.py3-none-any.whl (from https://pypi.org/simple/cleo/) (requires-python:>=2.7.0.0,<2.8.0.0,>=3.4.0.0,<4.0.0.0)
2023-07-06T20:00:06,640     Link requires a different Python (3.9.2 not in: '>=2.7.0.0,<2.8.0.0,>=3.4.0.0,<4.0.0.0'): https://files.pythonhosted.org/packages/57/af/a17f5e4184a872e8916d0fd84d77513c74cd055585c1936181d9f9a8c69e/cleo-0.6.2.tar.gz (from https://pypi.org/simple/cleo/) (requires-python:>=2.7.0.0,<2.8.0.0,>=3.4.0.0,<4.0.0.0)
2023-07-06T20:00:06,642     Link requires a different Python (3.9.2 not in: '>=2.7.0.0,<2.8.0.0,>=3.4.0.0,<4.0.0.0'): https://files.pythonhosted.org/packages/f6/be/f92c1221bd2acd9bb170d8097ce62ea2905e3bd8a0061ecbe76db99d8e8d/cleo-0.6.3-py2.py3-none-any.whl (from https://pypi.org/simple/cleo/) (requires-python:>=2.7.0.0,<2.8.0.0,>=3.4.0.0,<4.0.0.0)
2023-07-06T20:00:06,643     Link requires a different Python (3.9.2 not in: '>=2.7.0.0,<2.8.0.0,>=3.4.0.0,<4.0.0.0'): https://files.pythonhosted.org/packages/69/49/f23c30b41eee47d3f9032c427f18616a8ff83c64d7210cad5ab5ff9ef8b4/cleo-0.6.3.tar.gz (from https://pypi.org/simple/cleo/) (requires-python:>=2.7.0.0,<2.8.0.0,>=3.4.0.0,<4.0.0.0)
2023-07-06T20:00:06,765   Collecting cleo<3.0.0,>=2.0.0 (from poetry>=1.2)
2023-07-06T20:00:06,784     Using cached https://www.piwheels.org/simple/cleo/cleo-2.0.1-py3-none-any.whl (77 kB)
2023-07-06T20:00:06,865   Collecting crashtest<0.5.0,>=0.4.1 (from poetry>=1.2)
2023-07-06T20:00:06,881     Using cached https://www.piwheels.org/simple/crashtest/crashtest-0.4.1-py3-none-any.whl (7.6 kB)
2023-07-06T20:00:07,893   Collecting dulwich<0.22.0,>=0.21.2 (from poetry>=1.2)
2023-07-06T20:00:07,942     Using cached https://www.piwheels.org/simple/dulwich/dulwich-0.21.5-cp39-cp39-linux_armv7l.whl (507 kB)
2023-07-06T20:00:08,148   Collecting filelock<4.0.0,>=3.8.0 (from poetry>=1.2)
2023-07-06T20:00:08,166     Using cached https://www.piwheels.org/simple/filelock/filelock-3.12.2-py3-none-any.whl (10 kB)
2023-07-06T20:00:08,267   Collecting html5lib<2.0,>=1.0 (from poetry>=1.2)
2023-07-06T20:00:08,288     Using cached https://www.piwheels.org/simple/html5lib/html5lib-1.1-py2.py3-none-any.whl (117 kB)
2023-07-06T20:00:08,707   Collecting importlib-metadata>=4.4 (from poetry>=1.2)
2023-07-06T20:00:08,725     Using cached https://www.piwheels.org/simple/importlib-metadata/importlib_metadata-6.7.0-py3-none-any.whl (22 kB)
2023-07-06T20:00:08,857   Collecting installer<0.8.0,>=0.7.0 (from poetry>=1.2)
2023-07-06T20:00:08,900     Using cached https://www.piwheels.org/simple/installer/installer-0.7.0-py3-none-any.whl (453 kB)
2023-07-06T20:00:09,163   Collecting jsonschema<5.0.0,>=4.10.0 (from poetry>=1.2)
2023-07-06T20:00:09,183     Using cached https://www.piwheels.org/simple/jsonschema/jsonschema-4.18.0-py3-none-any.whl (81 kB)
2023-07-06T20:00:09,586   Collecting keyring<24.0.0,>=23.9.0 (from poetry>=1.2)
2023-07-06T20:00:09,604     Using cached https://www.piwheels.org/simple/keyring/keyring-23.13.1-py3-none-any.whl (37 kB)
2023-07-06T20:00:09,677   Collecting lockfile<0.13.0,>=0.12.2 (from poetry>=1.2)
2023-07-06T20:00:09,693     Using cached https://www.piwheels.org/simple/lockfile/lockfile-0.12.2-py2.py3-none-any.whl (13 kB)
2023-07-06T20:00:09,871   Collecting packaging>=20.4 (from poetry>=1.2)
2023-07-06T20:00:09,897     Using cached https://www.piwheels.org/simple/packaging/packaging-23.1-py3-none-any.whl (48 kB)
2023-07-06T20:00:09,987   Collecting pexpect<5.0.0,>=4.7.0 (from poetry>=1.2)
2023-07-06T20:00:10,007     Using cached https://www.piwheels.org/simple/pexpect/pexpect-4.8.0-py2.py3-none-any.whl (59 kB)
2023-07-06T20:00:10,231   Collecting pkginfo<2.0.0,>=1.9.4 (from poetry>=1.2)
2023-07-06T20:00:10,247     Using cached https://www.piwheels.org/simple/pkginfo/pkginfo-1.9.6-py3-none-any.whl (30 kB)
2023-07-06T20:00:10,416   Collecting platformdirs<4.0.0,>=3.0.0 (from poetry>=1.2)
2023-07-06T20:00:10,435     Using cached https://www.piwheels.org/simple/platformdirs/platformdirs-3.8.0-py3-none-any.whl (16 kB)
2023-07-06T20:00:10,660   Collecting poetry-core==1.6.1 (from poetry>=1.2)
2023-07-06T20:00:10,701     Using cached https://www.piwheels.org/simple/poetry-core/poetry_core-1.6.1-py3-none-any.whl (450 kB)
2023-07-06T20:00:10,839   Collecting poetry-plugin-export<2.0.0,>=1.4.0 (from poetry>=1.2)
2023-07-06T20:00:10,855     Using cached https://www.piwheels.org/simple/poetry-plugin-export/poetry_plugin_export-1.4.0-py3-none-any.whl (10 kB)
2023-07-06T20:00:10,924   Collecting pyproject-hooks<2.0.0,>=1.0.0 (from poetry>=1.2)
2023-07-06T20:00:10,944     Using cached https://www.piwheels.org/simple/pyproject-hooks/pyproject_hooks-1.0.0-py3-none-any.whl (9.3 kB)
2023-07-06T20:00:11,250   Collecting requests<3.0,>=2.18 (from poetry>=1.2)
2023-07-06T20:00:11,268     Using cached https://www.piwheels.org/simple/requests/requests-2.31.0-py3-none-any.whl (62 kB)
2023-07-06T20:00:11,456   Collecting requests-toolbelt<2,>=0.9.1 (from poetry>=1.2)
2023-07-06T20:00:11,474     Using cached https://www.piwheels.org/simple/requests-toolbelt/requests_toolbelt-1.0.0-py2.py3-none-any.whl (51 kB)
2023-07-06T20:00:11,698   Collecting shellingham<2.0,>=1.5 (from poetry>=1.2)
2023-07-06T20:00:11,714     Using cached https://www.piwheels.org/simple/shellingham/shellingham-1.5.0.post1-py2.py3-none-any.whl (9.4 kB)
2023-07-06T20:00:11,842   Collecting tomli<3.0.0,>=2.0.1 (from poetry>=1.2)
2023-07-06T20:00:11,857     Using cached https://www.piwheels.org/simple/tomli/tomli-2.0.1-py3-none-any.whl (12 kB)
2023-07-06T20:00:12,072   Collecting tomlkit<1.0.0,>=0.11.4 (from poetry>=1.2)
2023-07-06T20:00:12,090     Using cached https://www.piwheels.org/simple/tomlkit/tomlkit-0.11.8-py3-none-any.whl (35 kB)
2023-07-06T20:00:12,275   Collecting trove-classifiers>=2022.5.19 (from poetry>=1.2)
2023-07-06T20:00:12,294     Using cached https://www.piwheels.org/simple/trove-classifiers/trove_classifiers-2023.7.6-py3-none-any.whl (13 kB)
2023-07-06T20:00:12,643   Collecting urllib3<2.0.0,>=1.26.0 (from poetry>=1.2)
2023-07-06T20:00:12,669     Using cached https://www.piwheels.org/simple/urllib3/urllib3-1.26.16-py2.py3-none-any.whl (143 kB)
2023-07-06T20:00:13,285   Collecting virtualenv<21.0.0,>=20.22.0 (from poetry>=1.2)
2023-07-06T20:00:13,544     Using cached https://www.piwheels.org/simple/virtualenv/virtualenv-20.23.1-py3-none-any.whl (3.3 MB)
2023-07-06T20:00:13,921   Collecting dunamai<2.0.0,>=1.17.0 (from poetry-dynamic-versioning)
2023-07-06T20:00:13,938     Using cached https://www.piwheels.org/simple/dunamai/dunamai-1.17.0-py3-none-any.whl (24 kB)
2023-07-06T20:00:14,091   Collecting jinja2<4,>=2.11.1 (from poetry-dynamic-versioning)
2023-07-06T20:00:14,110     Using cached https://www.piwheels.org/simple/jinja2/Jinja2-3.1.2-py3-none-any.whl (133 kB)
2023-07-06T20:00:14,677   Collecting msgpack>=0.5.2 (from cachecontrol[filecache]<0.13.0,>=0.12.9->poetry>=1.2)
2023-07-06T20:00:14,711     Using cached https://www.piwheels.org/simple/msgpack/msgpack-1.0.5-cp39-cp39-linux_armv7l.whl (282 kB)
2023-07-06T20:00:18,236   Collecting rapidfuzz<3.0.0,>=2.2.0 (from cleo<3.0.0,>=2.0.0->poetry>=1.2)
2023-07-06T20:00:18,390     Using cached https://www.piwheels.org/simple/rapidfuzz/rapidfuzz-2.15.0-cp39-cp39-linux_armv7l.whl (1.7 MB)
2023-07-06T20:00:18,839   Collecting six>=1.9 (from html5lib<2.0,>=1.0->poetry>=1.2)
2023-07-06T20:00:18,854     Using cached https://www.piwheels.org/simple/six/six-1.16.0-py2.py3-none-any.whl (11 kB)
2023-07-06T20:00:18,920   Collecting webencodings (from html5lib<2.0,>=1.0->poetry>=1.2)
2023-07-06T20:00:18,935     Using cached https://www.piwheels.org/simple/webencodings/webencodings-0.5.1-py2.py3-none-any.whl (11 kB)
2023-07-06T20:00:19,202   Collecting zipp>=0.5 (from importlib-metadata>=4.4->poetry>=1.2)
2023-07-06T20:00:19,217     Using cached https://www.piwheels.org/simple/zipp/zipp-3.15.0-py3-none-any.whl (6.8 kB)
2023-07-06T20:00:19,590   Collecting MarkupSafe>=2.0 (from jinja2<4,>=2.11.1->poetry-dynamic-versioning)
2023-07-06T20:00:19,607     Using cached https://www.piwheels.org/simple/markupsafe/MarkupSafe-2.1.3-cp39-cp39-linux_armv7l.whl (23 kB)
2023-07-06T20:00:19,816   Collecting attrs>=22.2.0 (from jsonschema<5.0.0,>=4.10.0->poetry>=1.2)
2023-07-06T20:00:19,840     Using cached https://www.piwheels.org/simple/attrs/attrs-23.1.0-py3-none-any.whl (61 kB)
2023-07-06T20:00:19,952   Collecting jsonschema-specifications>=2023.03.6 (from jsonschema<5.0.0,>=4.10.0->poetry>=1.2)
2023-07-06T20:00:19,968     Using cached https://www.piwheels.org/simple/jsonschema-specifications/jsonschema_specifications-2023.6.1-py3-none-any.whl (17 kB)
2023-07-06T20:00:20,257   Collecting referencing>=0.28.4 (from jsonschema<5.0.0,>=4.10.0->poetry>=1.2)
2023-07-06T20:00:20,275     Using cached https://www.piwheels.org/simple/referencing/referencing-0.29.1-py3-none-any.whl (25 kB)
2023-07-06T20:00:20,661   Collecting rpds-py>=0.7.1 (from jsonschema<5.0.0,>=4.10.0->poetry>=1.2)
2023-07-06T20:00:20,699     Using cached rpds_py-0.8.8-cp39-cp39-manylinux_2_17_armv7l.manylinux2014_armv7l.whl (1.1 MB)
2023-07-06T20:00:20,922   Collecting jaraco.classes (from keyring<24.0.0,>=23.9.0->poetry>=1.2)
2023-07-06T20:00:20,939     Using cached https://www.piwheels.org/simple/jaraco-classes/jaraco.classes-3.2.3-py3-none-any.whl (6.0 kB)
2023-07-06T20:00:21,103   Collecting SecretStorage>=3.2 (from keyring<24.0.0,>=23.9.0->poetry>=1.2)
2023-07-06T20:00:21,119     Using cached https://www.piwheels.org/simple/secretstorage/SecretStorage-3.3.3-py3-none-any.whl (15 kB)
2023-07-06T20:00:21,308   Collecting jeepney>=0.4.2 (from keyring<24.0.0,>=23.9.0->poetry>=1.2)
2023-07-06T20:00:21,326     Using cached https://www.piwheels.org/simple/jeepney/jeepney-0.8.0-py3-none-any.whl (48 kB)
2023-07-06T20:00:21,455   Collecting ptyprocess>=0.5 (from pexpect<5.0.0,>=4.7.0->poetry>=1.2)
2023-07-06T20:00:21,473     Using cached https://www.piwheels.org/simple/ptyprocess/ptyprocess-0.7.0-py2.py3-none-any.whl (13 kB)
2023-07-06T20:00:22,118   Collecting charset-normalizer<4,>=2 (from requests<3.0,>=2.18->poetry>=1.2)
2023-07-06T20:00:22,125     Using cached charset_normalizer-3.1.0-py3-none-any.whl (46 kB)
2023-07-06T20:00:22,242   Collecting idna<4,>=2.5 (from requests<3.0,>=2.18->poetry>=1.2)
2023-07-06T20:00:22,260     Using cached https://www.piwheels.org/simple/idna/idna-3.4-py3-none-any.whl (61 kB)
2023-07-06T20:00:22,484   Collecting certifi>=2017.4.17 (from requests<3.0,>=2.18->poetry>=1.2)
2023-07-06T20:00:22,504     Using cached https://www.piwheels.org/simple/certifi/certifi-2023.5.7-py3-none-any.whl (156 kB)
2023-07-06T20:00:23,122   Collecting distlib<1,>=0.3.6 (from virtualenv<21.0.0,>=20.22.0->poetry>=1.2)
2023-07-06T20:00:23,167     Using cached https://www.piwheels.org/simple/distlib/distlib-0.3.6-py2.py3-none-any.whl (468 kB)
2023-07-06T20:00:25,188   Collecting cryptography>=2.0 (from SecretStorage>=3.2->keyring<24.0.0,>=23.9.0->poetry>=1.2)
2023-07-06T20:00:25,337     Using cached https://www.piwheels.org/simple/cryptography/cryptography-40.0.1-cp39-cp39-linux_armv7l.whl (1.5 MB)
2023-07-06T20:00:25,819   Collecting more-itertools (from jaraco.classes->keyring<24.0.0,>=23.9.0->poetry>=1.2)
2023-07-06T20:00:25,837     Using cached https://www.piwheels.org/simple/more-itertools/more_itertools-9.1.0-py3-none-any.whl (54 kB)
2023-07-06T20:00:26,858   Collecting cffi>=1.12 (from cryptography>=2.0->SecretStorage>=3.2->keyring<24.0.0,>=23.9.0->poetry>=1.2)
2023-07-06T20:00:27,656     Using cached https://www.piwheels.org/simple/cffi/cffi-1.15.1-cp39-cp39-linux_armv7l.whl (364 kB)
2023-07-06T20:00:27,888   Collecting pycparser (from cffi>=1.12->cryptography>=2.0->SecretStorage>=3.2->keyring<24.0.0,>=23.9.0->poetry>=1.2)
2023-07-06T20:00:27,908     Using cached https://www.piwheels.org/simple/pycparser/pycparser-2.21-py2.py3-none-any.whl (119 kB)
2023-07-06T20:00:30,548   Installing collected packages: webencodings, trove-classifiers, ptyprocess, msgpack, lockfile, distlib, zipp, urllib3, tomlkit, tomli, six, shellingham, rpds-py, rapidfuzz, pycparser, poetry-core, platformdirs, pkginfo, pexpect, packaging, more-itertools, MarkupSafe, jeepney, installer, idna, filelock, crashtest, charset-normalizer, certifi, attrs, virtualenv, requests, referencing, pyproject-hooks, jinja2, jaraco.classes, importlib-metadata, html5lib, dunamai, dulwich, cleo, cffi, requests-toolbelt, poetry-dynamic-versioning, jsonschema-specifications, cryptography, cachecontrol, build, SecretStorage, jsonschema, keyring, poetry-plugin-export, poetry
2023-07-06T20:00:34,730     Creating /tmp/pip-build-env-3q52ki09/overlay/bin
2023-07-06T20:00:34,733     changing mode of /tmp/pip-build-env-3q52ki09/overlay/bin/pkginfo to 755
2023-07-06T20:00:36,057     changing mode of /tmp/pip-build-env-3q52ki09/overlay/bin/normalizer to 755
2023-07-06T20:00:36,930     changing mode of /tmp/pip-build-env-3q52ki09/overlay/bin/virtualenv to 755
2023-07-06T20:00:38,218     changing mode of /tmp/pip-build-env-3q52ki09/overlay/bin/dunamai to 755
2023-07-06T20:00:39,609     changing mode of /tmp/pip-build-env-3q52ki09/overlay/bin/dulwich to 755
2023-07-06T20:00:40,603     changing mode of /tmp/pip-build-env-3q52ki09/overlay/bin/poetry-dynamic-versioning to 755
2023-07-06T20:00:41,584     changing mode of /tmp/pip-build-env-3q52ki09/overlay/bin/doesitcache to 755
2023-07-06T20:00:41,647     changing mode of /tmp/pip-build-env-3q52ki09/overlay/bin/pyproject-build to 755
2023-07-06T20:00:42,020     changing mode of /tmp/pip-build-env-3q52ki09/overlay/bin/jsonschema to 755
2023-07-06T20:00:42,211     changing mode of /tmp/pip-build-env-3q52ki09/overlay/bin/keyring to 755
2023-07-06T20:00:43,343     changing mode of /tmp/pip-build-env-3q52ki09/overlay/bin/poetry to 755
2023-07-06T20:00:43,462   Successfully installed MarkupSafe-2.1.3 SecretStorage-3.3.3 attrs-23.1.0 build-0.10.0 cachecontrol-0.12.14 certifi-2023.5.7 cffi-1.15.1 charset-normalizer-3.1.0 cleo-2.0.1 crashtest-0.4.1 cryptography-40.0.1 distlib-0.3.6 dulwich-0.21.5 dunamai-1.17.0 filelock-3.12.2 html5lib-1.1 idna-3.4 importlib-metadata-6.7.0 installer-0.7.0 jaraco.classes-3.2.3 jeepney-0.8.0 jinja2-3.1.2 jsonschema-4.18.0 jsonschema-specifications-2023.6.1 keyring-23.13.1 lockfile-0.12.2 more-itertools-9.1.0 msgpack-1.0.5 packaging-23.1 pexpect-4.8.0 pkginfo-1.9.6 platformdirs-3.8.0 poetry-1.5.1 poetry-core-1.6.1 poetry-dynamic-versioning-0.24.0 poetry-plugin-export-1.4.0 ptyprocess-0.7.0 pycparser-2.21 pyproject-hooks-1.0.0 rapidfuzz-2.15.0 referencing-0.29.1 requests-2.31.0 requests-toolbelt-1.0.0 rpds-py-0.8.8 shellingham-1.5.0.post1 six-1.16.0 tomli-2.0.1 tomlkit-0.11.8 trove-classifiers-2023.7.6 urllib3-1.26.16 virtualenv-20.23.1 webencodings-0.5.1 zipp-3.15.0
2023-07-06T20:00:44,267   Installing build dependencies: finished with status 'done'
2023-07-06T20:00:44,272   Getting requirements to build wheel: started
2023-07-06T20:00:44,273   Running command Getting requirements to build wheel
2023-07-06T20:00:44,882   Getting requirements to build wheel: finished with status 'done'
2023-07-06T20:00:44,888   Created temporary directory: /tmp/pip-modern-metadata-w6dl6xsq
2023-07-06T20:00:44,890   Preparing metadata (pyproject.toml): started
2023-07-06T20:00:44,891   Running command Preparing metadata (pyproject.toml)
2023-07-06T20:00:46,076   Traceback (most recent call last):
2023-07-06T20:00:46,077     File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_vendor/pyproject_hooks/_in_process/_in_process.py", line 353, in <module>
2023-07-06T20:00:46,077       main()
2023-07-06T20:00:46,077     File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_vendor/pyproject_hooks/_in_process/_in_process.py", line 335, in main
2023-07-06T20:00:46,078       json_out['return_val'] = hook(**hook_input['kwargs'])
2023-07-06T20:00:46,078     File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_vendor/pyproject_hooks/_in_process/_in_process.py", line 149, in prepare_metadata_for_build_wheel
2023-07-06T20:00:46,078       return hook(metadata_directory, config_settings)
2023-07-06T20:00:46,079     File "/tmp/pip-build-env-3q52ki09/overlay/lib/python3.9/site-packages/poetry/core/masonry/api.py", line 41, in prepare_metadata_for_build_wheel
2023-07-06T20:00:46,079       poetry = Factory().create_poetry(Path(".").resolve(), with_groups=False)
2023-07-06T20:00:46,079     File "/tmp/pip-build-env-3q52ki09/overlay/lib/python3.9/site-packages/poetry_dynamic_versioning/patch.py", line 23, in alt_poetry_create
2023-07-06T20:00:46,079       name = _get_and_apply_version(
2023-07-06T20:00:46,079     File "/tmp/pip-build-env-3q52ki09/overlay/lib/python3.9/site-packages/poetry_dynamic_versioning/__init__.py", line 436, in _get_and_apply_version
2023-07-06T20:00:46,080       version = _get_version(config, name)
2023-07-06T20:00:46,080     File "/tmp/pip-build-env-3q52ki09/overlay/lib/python3.9/site-packages/poetry_dynamic_versioning/__init__.py", line 262, in _get_version
2023-07-06T20:00:46,080       version = Version.from_vcs(
2023-07-06T20:00:46,081     File "/tmp/pip-build-env-3q52ki09/overlay/lib/python3.9/site-packages/dunamai/__init__.py", line 1793, in from_vcs
2023-07-06T20:00:46,082       return cls._do_vcs_callback(
2023-07-06T20:00:46,082     File "/tmp/pip-build-env-3q52ki09/overlay/lib/python3.9/site-packages/dunamai/__init__.py", line 1827, in _do_vcs_callback
2023-07-06T20:00:46,083       return callback(**kwargs)
2023-07-06T20:00:46,083     File "/tmp/pip-build-env-3q52ki09/overlay/lib/python3.9/site-packages/dunamai/__init__.py", line 988, in from_git
2023-07-06T20:00:46,084       _detect_vcs(Vcs.Git)
2023-07-06T20:00:46,085     File "/tmp/pip-build-env-3q52ki09/overlay/lib/python3.9/site-packages/dunamai/__init__.py", line 314, in _detect_vcs
2023-07-06T20:00:46,085       raise RuntimeError(
2023-07-06T20:00:46,085   RuntimeError: This does not appear to be a Git project
2023-07-06T20:00:46,182   ERROR: [present-rich] Preparing metadata (pyproject.toml) exited with 1
2023-07-06T20:00:46,200   [bold magenta]full command[/]: [blue]/usr/bin/python3 /home/piwheels/.local/lib/python3.9/site-packages/pip/_vendor/pyproject_hooks/_in_process/_in_process.py prepare_metadata_for_build_wheel /tmp/tmpcd4j6tvk[/]
2023-07-06T20:00:46,200   [bold magenta]cwd[/]: /tmp/pip-wheel-p6wiyk_g/nhs-context-logging_2acce31158924e5b80fbfb78c322f1cb
2023-07-06T20:00:46,200   Preparing metadata (pyproject.toml): finished with status 'error'
2023-07-06T20:00:46,202 ERROR: [present-rich] metadata generation failed
2023-07-06T20:00:46,209 Exception information:
2023-07-06T20:00:46,209 Traceback (most recent call last):
2023-07-06T20:00:46,209   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_internal/operations/build/metadata.py", line 35, in generate_metadata
2023-07-06T20:00:46,209     distinfo_dir = backend.prepare_metadata_for_build_wheel(metadata_dir)
2023-07-06T20:00:46,209   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_internal/utils/misc.py", line 713, in prepare_metadata_for_build_wheel
2023-07-06T20:00:46,209     return super().prepare_metadata_for_build_wheel(
2023-07-06T20:00:46,209   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_vendor/pyproject_hooks/_impl.py", line 186, in prepare_metadata_for_build_wheel
2023-07-06T20:00:46,209     return self._call_hook('prepare_metadata_for_build_wheel', {
2023-07-06T20:00:46,209   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_vendor/pyproject_hooks/_impl.py", line 311, in _call_hook
2023-07-06T20:00:46,209     self._subprocess_runner(
2023-07-06T20:00:46,209   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_internal/utils/subprocess.py", line 252, in runner
2023-07-06T20:00:46,209     call_subprocess(
2023-07-06T20:00:46,209   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_internal/utils/subprocess.py", line 224, in call_subprocess
2023-07-06T20:00:46,209     raise error
2023-07-06T20:00:46,209 pip._internal.exceptions.InstallationSubprocessError: Preparing metadata (pyproject.toml) exited with 1
2023-07-06T20:00:46,209 
2023-07-06T20:00:46,209 The above exception was the direct cause of the following exception:
2023-07-06T20:00:46,209 
2023-07-06T20:00:46,209 Traceback (most recent call last):
2023-07-06T20:00:46,209   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_internal/cli/base_command.py", line 169, in exc_logging_wrapper
2023-07-06T20:00:46,209     status = run_func(*args)
2023-07-06T20:00:46,209   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_internal/cli/req_command.py", line 248, in wrapper
2023-07-06T20:00:46,209     return func(self, options, args)
2023-07-06T20:00:46,209   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_internal/commands/wheel.py", line 147, in run
2023-07-06T20:00:46,209     requirement_set = resolver.resolve(reqs, check_supported_wheels=True)
2023-07-06T20:00:46,209   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_internal/resolution/resolvelib/resolver.py", line 92, in resolve
2023-07-06T20:00:46,209     result = self._result = resolver.resolve(
2023-07-06T20:00:46,209   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_vendor/resolvelib/resolvers.py", line 546, in resolve
2023-07-06T20:00:46,209     state = resolution.resolve(requirements, max_rounds=max_rounds)
2023-07-06T20:00:46,209   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_vendor/resolvelib/resolvers.py", line 397, in resolve
2023-07-06T20:00:46,209     self._add_to_criteria(self.state.criteria, r, parent=None)
2023-07-06T20:00:46,209   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_vendor/resolvelib/resolvers.py", line 173, in _add_to_criteria
2023-07-06T20:00:46,209     if not criterion.candidates:
2023-07-06T20:00:46,209   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_vendor/resolvelib/structs.py", line 156, in __bool__
2023-07-06T20:00:46,209     return bool(self._sequence)
2023-07-06T20:00:46,209   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_internal/resolution/resolvelib/found_candidates.py", line 155, in __bool__
2023-07-06T20:00:46,209     return any(self)
2023-07-06T20:00:46,209   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_internal/resolution/resolvelib/found_candidates.py", line 143, in <genexpr>
2023-07-06T20:00:46,209     return (c for c in iterator if id(c) not in self._incompatible_ids)
2023-07-06T20:00:46,209   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_internal/resolution/resolvelib/found_candidates.py", line 47, in _iter_built
2023-07-06T20:00:46,209     candidate = func()
2023-07-06T20:00:46,209   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_internal/resolution/resolvelib/factory.py", line 206, in _make_candidate_from_link
2023-07-06T20:00:46,209     self._link_candidate_cache[link] = LinkCandidate(
2023-07-06T20:00:46,209   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_internal/resolution/resolvelib/candidates.py", line 293, in __init__
2023-07-06T20:00:46,209     super().__init__(
2023-07-06T20:00:46,209   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_internal/resolution/resolvelib/candidates.py", line 156, in __init__
2023-07-06T20:00:46,209     self.dist = self._prepare()
2023-07-06T20:00:46,209   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_internal/resolution/resolvelib/candidates.py", line 225, in _prepare
2023-07-06T20:00:46,209     dist = self._prepare_distribution()
2023-07-06T20:00:46,209   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_internal/resolution/resolvelib/candidates.py", line 304, in _prepare_distribution
2023-07-06T20:00:46,209     return preparer.prepare_linked_requirement(self._ireq, parallel_builds=True)
2023-07-06T20:00:46,209   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_internal/operations/prepare.py", line 516, in prepare_linked_requirement
2023-07-06T20:00:46,209     return self._prepare_linked_requirement(req, parallel_builds)
2023-07-06T20:00:46,209   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_internal/operations/prepare.py", line 631, in _prepare_linked_requirement
2023-07-06T20:00:46,209     dist = _get_prepared_distribution(
2023-07-06T20:00:46,209   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_internal/operations/prepare.py", line 69, in _get_prepared_distribution
2023-07-06T20:00:46,209     abstract_dist.prepare_distribution_metadata(
2023-07-06T20:00:46,209   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_internal/distributions/sdist.py", line 61, in prepare_distribution_metadata
2023-07-06T20:00:46,209     self.req.prepare_metadata()
2023-07-06T20:00:46,209   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_internal/req/req_install.py", line 555, in prepare_metadata
2023-07-06T20:00:46,209     self.metadata_directory = generate_metadata(
2023-07-06T20:00:46,209   File "/home/piwheels/.local/lib/python3.9/site-packages/pip/_internal/operations/build/metadata.py", line 37, in generate_metadata
2023-07-06T20:00:46,209     raise MetadataGenerationFailed(package_details=details) from error
2023-07-06T20:00:46,209 pip._internal.exceptions.MetadataGenerationFailed: metadata generation failed
2023-07-06T20:00:46,219 Removed nhs-context-logging==0.2.5 from https://files.pythonhosted.org/packages/be/ce/2003452632732cfab9ed88440deea77551c78f2bd09532beb12b4db2db21/nhs_context_logging-0.2.5.tar.gz from build tracker '/tmp/pip-build-tracker-st9_xpzu'
2023-07-06T20:00:46,220 Removed build tracker: '/tmp/pip-build-tracker-st9_xpzu'