2022-08-25T08:53:15,437 Created temporary directory: /tmp/pip-ephem-wheel-cache-_x8bh7v6 2022-08-25T08:53:15,443 Created temporary directory: /tmp/pip-build-tracker-k634z3k7 2022-08-25T08:53:15,443 Initialized build tracking at /tmp/pip-build-tracker-k634z3k7 2022-08-25T08:53:15,444 Created build tracker: /tmp/pip-build-tracker-k634z3k7 2022-08-25T08:53:15,444 Entered build tracker: /tmp/pip-build-tracker-k634z3k7 2022-08-25T08:53:15,445 Created temporary directory: /tmp/pip-wheel-w54ee19u 2022-08-25T08:53:15,510 Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple 2022-08-25T08:53:15,519 2 location(s) to search for versions of lsst-utils: 2022-08-25T08:53:15,519 * https://pypi.org/simple/lsst-utils/ 2022-08-25T08:53:15,519 * https://www.piwheels.org/simple/lsst-utils/ 2022-08-25T08:53:15,520 Fetching project page and analyzing links: https://pypi.org/simple/lsst-utils/ 2022-08-25T08:53:15,521 Getting page https://pypi.org/simple/lsst-utils/ 2022-08-25T08:53:15,525 Found index url https://pypi.org/simple 2022-08-25T08:53:15,649 Found link https://files.pythonhosted.org/packages/54/2f/f7acd2965c7fea21879571044247cfb69b9baad6d454e45a354286466967/lsst-utils-24.0.0a20222402.tar.gz#sha256=53c00fee0b62f1c434ec6cb02a00e31b1bc0909a91b97a3063aa0c886353b572 (from https://pypi.org/simple/lsst-utils/), version: 24.0.0a20222402 2022-08-25T08:53:15,650 Skipping link: No binaries permitted for lsst-utils: https://files.pythonhosted.org/packages/92/07/be6cbefd961eeb40aa6f111fa1f9074b6cedadc4b24ae6de55be5565e101/lsst_utils-24.0.0a20222402-py3-none-any.whl#sha256=86262feffcc0a3420148cd2561764336dc6df2ea07c5609b5fd21eb4bc727187 (from https://pypi.org/simple/lsst-utils/) 2022-08-25T08:53:15,651 Found link https://files.pythonhosted.org/packages/0f/e1/1fe03fa2539e6393b440126656ae65d7fb6ddaefc98049051df43f3f0412/lsst-utils-24.0.0a20222500.tar.gz#sha256=94895f8a85ce5295128a823cf7c3a72b0a827d62442725be14decaf09f6bb654 (from https://pypi.org/simple/lsst-utils/), version: 24.0.0a20222500 2022-08-25T08:53:15,652 Skipping link: No binaries permitted for lsst-utils: https://files.pythonhosted.org/packages/d8/c6/d88c747b7e0057b4414ac0392029568748a51e3f013d5295294db5cb9570/lsst_utils-24.0.0a20222500-py3-none-any.whl#sha256=b7e79685e71d8b46a366857dc91a1e1d9fe91b7fbd00f79df13f96f63247f686 (from https://pypi.org/simple/lsst-utils/) 2022-08-25T08:53:15,652 Found link https://files.pythonhosted.org/packages/71/54/4310f99fd1c5eef821edcc154c2c65666d112d3958cf493f60724abed6ed/lsst-utils-24.0.0a20222600.tar.gz#sha256=e0238c0430e82219d80177b4db03701312873bec73786939c265a69873d52de7 (from https://pypi.org/simple/lsst-utils/), version: 24.0.0a20222600 2022-08-25T08:53:15,653 Skipping link: No binaries permitted for lsst-utils: https://files.pythonhosted.org/packages/5d/93/3f781d0a5ed26f7d27d1ba928c1e83c95230ab1df4c41bcd14718601f765/lsst_utils-24.0.0a20222600-py3-none-any.whl#sha256=513b67ea435a9b6190fd3f74b8dfd523ee94ea03e5b9a60a3ef7c05ef6b557b7 (from https://pypi.org/simple/lsst-utils/) 2022-08-25T08:53:15,654 Found link https://files.pythonhosted.org/packages/ac/e6/307172a935a9c1ef511cb605ee47496e28144e93ffd750a3d2026a62c60a/lsst-utils-24.0.0a20222700.tar.gz#sha256=909f696282f71c637df7606e33eaa2e777994fdb67b5eb0fcc634b89cd50f6c2 (from https://pypi.org/simple/lsst-utils/), version: 24.0.0a20222700 2022-08-25T08:53:15,654 Skipping link: No binaries permitted for lsst-utils: https://files.pythonhosted.org/packages/81/1f/9aa4186ba5e76bbd67dc310f8dbf465cf14fa4d0fc1e3ad6cb3702d45a6d/lsst_utils-24.0.0a20222700-py3-none-any.whl#sha256=8ce60b65ad2ea5631ff805a4fd582e3043dc92dd3cbe1af854ac65e4845d13d8 (from https://pypi.org/simple/lsst-utils/) 2022-08-25T08:53:15,655 Found link https://files.pythonhosted.org/packages/28/ea/9a0e737c1ee8ed3d02c59585658ef2aca2cfe9ca7e52b5d8f6bc21d8dc4e/lsst-utils-24.0.0a20222800.tar.gz#sha256=f56a253e9c58db92c8105e60bfff6d4e4c73c912cd1c9b09cc252f23ef958417 (from https://pypi.org/simple/lsst-utils/), version: 24.0.0a20222800 2022-08-25T08:53:15,656 Skipping link: No binaries permitted for lsst-utils: https://files.pythonhosted.org/packages/3e/cf/2642431a391a2ad5194d225c82cb6eb9ea5108faa3b4ce284e2d8b77bd14/lsst_utils-24.0.0a20222800-py3-none-any.whl#sha256=11f134a0f3abfb400922060c3c6c8ace1df5372a2bcc44f3071f229339a26634 (from https://pypi.org/simple/lsst-utils/) 2022-08-25T08:53:15,656 Found link https://files.pythonhosted.org/packages/fd/68/b32d68463a3b6ca5d188293a73dbb21c83a270604426fbf222ee73e596af/lsst-utils-24.0.0a20222900.tar.gz#sha256=523d38b296c5b016bc7df5c43990cf12ab5c66613494e4a17c8bb4d54b149e3d (from https://pypi.org/simple/lsst-utils/), version: 24.0.0a20222900 2022-08-25T08:53:15,657 Skipping link: No binaries permitted for lsst-utils: https://files.pythonhosted.org/packages/76/a0/1abbc2b84044aa11f2134206d2506a500b8807c72f800628ad71f1af4fb5/lsst_utils-24.0.0a20222900-py3-none-any.whl#sha256=897d02fbefe91e0271a2e796c9b4517112265b8e97f96115fffc08050fa1bca1 (from https://pypi.org/simple/lsst-utils/) 2022-08-25T08:53:15,657 Found link https://files.pythonhosted.org/packages/a8/a4/373500c0bf2cc93853985abdc798b665fe5d5dad024735e7fd3e8f11d830/lsst-utils-24.0.0a20223000.tar.gz#sha256=ff88d9d676b8178ec3f0d8667333631cf90bafd16cec43b10021ffc764f5f777 (from https://pypi.org/simple/lsst-utils/), version: 24.0.0a20223000 2022-08-25T08:53:15,658 Skipping link: No binaries permitted for lsst-utils: https://files.pythonhosted.org/packages/b8/f5/59305bc338acbff3eeb15df67e6131418d820e8b399e5cef187d8d7ea459/lsst_utils-24.0.0a20223000-py3-none-any.whl#sha256=f069acd6cb23390a9068f0b53b581855d828c1ccc582fa872763154dd2187c5e (from https://pypi.org/simple/lsst-utils/) 2022-08-25T08:53:15,659 Found link https://files.pythonhosted.org/packages/02/d8/15601ff0b31d96bc93e6dd44e700bb30387f2f1198b4265899ebd6054cae/lsst-utils-24.0.0a20223100.tar.gz#sha256=29bc4f140eb95bf45a5e7a7c64f039fd63b78b9c8064e65ce1f0cf2e81b2b359 (from https://pypi.org/simple/lsst-utils/), version: 24.0.0a20223100 2022-08-25T08:53:15,659 Skipping link: No binaries permitted for lsst-utils: https://files.pythonhosted.org/packages/ed/b2/85a0b2d4ddbee1edddf31cc8ed22323b472ed27e2df8c0dc835e7cb36ab0/lsst_utils-24.0.0a20223100-py3-none-any.whl#sha256=bbe22e3d25d1953b1b4deb91385ecbf77c53caa098f603c354f5104851aba261 (from https://pypi.org/simple/lsst-utils/) 2022-08-25T08:53:15,660 Found link https://files.pythonhosted.org/packages/09/4b/ce6b54f31e492021cd024072c3e49d0d636340e5767dac0ea8b45825c3c8/lsst-utils-25.0.0a20223400.tar.gz#sha256=bd2f01a9c122455e75b6e88bec674b929518f744e7918c22bc950480d19930d9 (from https://pypi.org/simple/lsst-utils/), version: 25.0.0a20223400 2022-08-25T08:53:15,661 Skipping link: No binaries permitted for lsst-utils: https://files.pythonhosted.org/packages/84/0d/16d685257868193347499b5bbc949a4ee983b6efe2d6ef60f59c59b894dc/lsst_utils-25.0.0a20223400-py3-none-any.whl#sha256=d6d7aacb08e0c00bd880a75a5a8545b30b9ccc6c9874c586d6dbc3fc1cc94958 (from https://pypi.org/simple/lsst-utils/) 2022-08-25T08:53:15,661 Found link https://files.pythonhosted.org/packages/0d/24/1ef3cd31c341886680d4053b7359b84f8fa42fd5dc141d5c9a0e72ed50c1/lsst-utils-25.0.0a20223500.tar.gz#sha256=9ab1519ff29d4a9efbc15e2c9d4e30e6513d45ddb4cad703461d986d06597fd2 (from https://pypi.org/simple/lsst-utils/), version: 25.0.0a20223500 2022-08-25T08:53:15,662 Skipping link: No binaries permitted for lsst-utils: https://files.pythonhosted.org/packages/cf/95/e63b7f18eae895c77533b7b92495f101e377bac5aa632278c7297c319dd8/lsst_utils-25.0.0a20223500-py3-none-any.whl#sha256=1554b18cf3c6e95fd69dbfc08bc7b0dfeb430f2a52a327a6cb6693ba8ec8788d (from https://pypi.org/simple/lsst-utils/) 2022-08-25T08:53:15,663 Fetching project page and analyzing links: https://www.piwheels.org/simple/lsst-utils/ 2022-08-25T08:53:15,663 Getting page https://www.piwheels.org/simple/lsst-utils/ 2022-08-25T08:53:15,665 Found index url https://www.piwheels.org/simple 2022-08-25T08:53:15,883 Skipping link: No binaries permitted for lsst-utils: https://www.piwheels.org/simple/lsst-utils/lsst_utils-25.0.0a20223400-py3-none-any.whl#sha256=ffdf5164acdb1b1baad7c9094189b4a33ee2bc0982bb61e1c9a8cea4a3037724 (from https://www.piwheels.org/simple/lsst-utils/) 2022-08-25T08:53:15,884 Skipping link: No binaries permitted for lsst-utils: https://www.piwheels.org/simple/lsst-utils/lsst_utils-24.0.0a20223100-py3-none-any.whl#sha256=df3afdbaa95be444c2b29fbb40d94999106a78b334e3ed6aad99007dee803b3d (from https://www.piwheels.org/simple/lsst-utils/) 2022-08-25T08:53:15,885 Skipping link: No binaries permitted for lsst-utils: https://www.piwheels.org/simple/lsst-utils/lsst_utils-24.0.0a20223000-py3-none-any.whl#sha256=d0943ead4557fefdc5f584cf5699c8e35176346d300e93b8fcf8deded9f0cca6 (from https://www.piwheels.org/simple/lsst-utils/) 2022-08-25T08:53:15,885 Skipping link: No binaries permitted for lsst-utils: https://www.piwheels.org/simple/lsst-utils/lsst_utils-24.0.0a20222900-py3-none-any.whl#sha256=5ff5aed146012763b6b088507a123731445a1abc72d575fab3aa5562b9744d33 (from https://www.piwheels.org/simple/lsst-utils/) 2022-08-25T08:53:15,886 Skipping link: No binaries permitted for lsst-utils: https://www.piwheels.org/simple/lsst-utils/lsst_utils-24.0.0a20222800-py3-none-any.whl#sha256=1a73bf6e8aac15f1ea0324b91309283ab8c59428610d27b292f4d69db59184bb (from https://www.piwheels.org/simple/lsst-utils/) 2022-08-25T08:53:15,886 Skipping link: No binaries permitted for lsst-utils: https://www.piwheels.org/simple/lsst-utils/lsst_utils-24.0.0a20222700-py3-none-any.whl#sha256=f90c601703873006cd880a2fdf592a7e4012c68f20e32e49edd49da1081d4f2a (from https://www.piwheels.org/simple/lsst-utils/) 2022-08-25T08:53:15,887 Skipping link: not a file: https://www.piwheels.org/simple/lsst-utils/ 2022-08-25T08:53:15,887 Skipping link: not a file: https://pypi.org/simple/lsst-utils/ 2022-08-25T08:53:15,936 Given no hashes to check 1 links for project 'lsst-utils': discarding no candidates 2022-08-25T08:53:15,977 Collecting lsst-utils==25.0.0a20223500 2022-08-25T08:53:15,982 Created temporary directory: /tmp/pip-unpack-l5_sv1p1 2022-08-25T08:53:16,074 Downloading lsst-utils-25.0.0a20223500.tar.gz (43 kB) 2022-08-25T08:53:16,292 Added lsst-utils==25.0.0a20223500 from https://files.pythonhosted.org/packages/0d/24/1ef3cd31c341886680d4053b7359b84f8fa42fd5dc141d5c9a0e72ed50c1/lsst-utils-25.0.0a20223500.tar.gz#sha256=9ab1519ff29d4a9efbc15e2c9d4e30e6513d45ddb4cad703461d986d06597fd2 to build tracker '/tmp/pip-build-tracker-k634z3k7' 2022-08-25T08:53:16,311 Created temporary directory: /tmp/pip-build-env-hhw9ji9s 2022-08-25T08:53:16,332 Created temporary directory: /tmp/pip-standalone-pip-mwcikskw 2022-08-25T08:53:18,740 Installing build dependencies: started 2022-08-25T08:53:18,742 Running command pip subprocess to install build dependencies 2022-08-25T08:53:30,118 Using pip 22.1.2 from /tmp/pip-standalone-pip-mwcikskw/__env_pip__.zip/pip (python 3.9) 2022-08-25T08:53:32,185 Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple 2022-08-25T08:53:36,529 Collecting setuptools 2022-08-25T08:53:36,805 Using cached https://www.piwheels.org/simple/setuptools/setuptools-65.3.0-py3-none-any.whl (1.2 MB) 2022-08-25T08:53:37,097 Collecting lsst-versions>=1.3.0 2022-08-25T08:53:37,128 Using cached https://www.piwheels.org/simple/lsst-versions/lsst_versions-1.3.0-py3-none-any.whl (10 kB) 2022-08-25T08:53:37,617 Collecting packaging 2022-08-25T08:53:37,650 Using cached https://www.piwheels.org/simple/packaging/packaging-21.3-py3-none-any.whl (40 kB) 2022-08-25T08:53:38,273 Collecting GitPython>=3.1 2022-08-25T08:53:38,317 Using cached https://www.piwheels.org/simple/gitpython/GitPython-3.1.27-py3-none-any.whl (181 kB) 2022-08-25T08:53:39,430 Collecting tomli>1.0.0 2022-08-25T08:53:39,462 Using cached https://www.piwheels.org/simple/tomli/tomli-2.0.1-py3-none-any.whl (12 kB) 2022-08-25T08:53:39,751 Collecting gitdb<5,>=4.0.1 2022-08-25T08:53:39,819 Using cached https://www.piwheels.org/simple/gitdb/gitdb-4.0.9-py3-none-any.whl (63 kB) 2022-08-25T08:53:40,527 Collecting pyparsing!=3.0.5,>=2.0.2 2022-08-25T08:53:40,569 Using cached https://www.piwheels.org/simple/pyparsing/pyparsing-3.0.9-py3-none-any.whl (98 kB) 2022-08-25T08:53:40,809 Collecting smmap<6,>=3.0.1 2022-08-25T08:53:40,843 Using cached https://www.piwheels.org/simple/smmap/smmap-5.0.0-py3-none-any.whl (24 kB) 2022-08-25T08:53:51,894 Installing collected packages: tomli, smmap, setuptools, pyparsing, packaging, gitdb, GitPython, lsst-versions 2022-08-25T08:54:00,028 Creating /tmp/pip-build-env-hhw9ji9s/overlay/bin 2022-08-25T08:54:00,033 changing mode of /tmp/pip-build-env-hhw9ji9s/overlay/bin/lsst-version to 755 2022-08-25T08:54:00,083 Successfully installed GitPython-3.1.27 gitdb-4.0.9 lsst-versions-1.3.0 packaging-21.3 pyparsing-3.0.9 setuptools-65.3.0 smmap-5.0.0 tomli-2.0.1 2022-08-25T08:54:00,298 --- Logging error --- 2022-08-25T08:54:00,314 Traceback (most recent call last): 2022-08-25T08:54:00,315 File "/tmp/pip-standalone-pip-mwcikskw/__env_pip__.zip/pip/_internal/utils/logging.py", line 177, in emit 2022-08-25T08:54:00,315 self.console.print(renderable, overflow="ignore", crop=False, style=style) 2022-08-25T08:54:00,315 File "/tmp/pip-standalone-pip-mwcikskw/__env_pip__.zip/pip/_vendor/rich/console.py", line 1752, in print 2022-08-25T08:54:00,316 extend(render(renderable, render_options)) 2022-08-25T08:54:00,316 File "/tmp/pip-standalone-pip-mwcikskw/__env_pip__.zip/pip/_vendor/rich/console.py", line 1390, in render 2022-08-25T08:54:00,316 for render_output in iter_render: 2022-08-25T08:54:00,317 File "/tmp/pip-standalone-pip-mwcikskw/__env_pip__.zip/pip/_internal/utils/logging.py", line 134, in __rich_console__ 2022-08-25T08:54:00,317 for line in lines: 2022-08-25T08:54:00,317 File "/tmp/pip-standalone-pip-mwcikskw/__env_pip__.zip/pip/_vendor/rich/segment.py", line 245, in split_lines 2022-08-25T08:54:00,318 for segment in segments: 2022-08-25T08:54:00,318 File "/tmp/pip-standalone-pip-mwcikskw/__env_pip__.zip/pip/_vendor/rich/console.py", line 1368, in render 2022-08-25T08:54:00,318 renderable = rich_cast(renderable) 2022-08-25T08:54:00,319 File "/tmp/pip-standalone-pip-mwcikskw/__env_pip__.zip/pip/_vendor/rich/protocol.py", line 36, in rich_cast 2022-08-25T08:54:00,319 renderable = cast_method() 2022-08-25T08:54:00,319 File "/tmp/pip-standalone-pip-mwcikskw/__env_pip__.zip/pip/_internal/self_outdated_check.py", line 130, in __rich__ 2022-08-25T08:54:00,320 pip_cmd = get_best_invocation_for_this_pip() 2022-08-25T08:54:00,320 File "/tmp/pip-standalone-pip-mwcikskw/__env_pip__.zip/pip/_internal/utils/entrypoints.py", line 58, in get_best_invocation_for_this_pip 2022-08-25T08:54:00,320 if found_executable and os.path.samefile( 2022-08-25T08:54:00,321 File "/usr/lib/python3.9/genericpath.py", line 101, in samefile 2022-08-25T08:54:00,321 s2 = os.stat(f2) 2022-08-25T08:54:00,321 FileNotFoundError: [Errno 2] No such file or directory: '/usr/bin/pip3.9' 2022-08-25T08:54:00,321 Call stack: 2022-08-25T08:54:00,326 File "/usr/lib/python3.9/runpy.py", line 197, in _run_module_as_main 2022-08-25T08:54:00,327 return _run_code(code, main_globals, None, 2022-08-25T08:54:00,327 File "/usr/lib/python3.9/runpy.py", line 87, in _run_code 2022-08-25T08:54:00,327 exec(code, run_globals) 2022-08-25T08:54:00,328 File "/tmp/pip-standalone-pip-mwcikskw/__env_pip__.zip/pip/__main__.py", line 31, in 2022-08-25T08:54:00,328 sys.exit(_main()) 2022-08-25T08:54:00,328 File "/tmp/pip-standalone-pip-mwcikskw/__env_pip__.zip/pip/_internal/cli/main.py", line 70, in main 2022-08-25T08:54:00,329 return command.main(cmd_args) 2022-08-25T08:54:00,329 File "/tmp/pip-standalone-pip-mwcikskw/__env_pip__.zip/pip/_internal/cli/base_command.py", line 101, in main 2022-08-25T08:54:00,329 return self._main(args) 2022-08-25T08:54:00,329 File "/tmp/pip-standalone-pip-mwcikskw/__env_pip__.zip/pip/_internal/cli/base_command.py", line 223, in _main 2022-08-25T08:54:00,330 self.handle_pip_version_check(options) 2022-08-25T08:54:00,330 File "/tmp/pip-standalone-pip-mwcikskw/__env_pip__.zip/pip/_internal/cli/req_command.py", line 148, in handle_pip_version_check 2022-08-25T08:54:00,330 pip_self_version_check(session, options) 2022-08-25T08:54:00,331 File "/tmp/pip-standalone-pip-mwcikskw/__env_pip__.zip/pip/_internal/self_outdated_check.py", line 237, in pip_self_version_check 2022-08-25T08:54:00,331 logger.info("[present-rich] %s", upgrade_prompt) 2022-08-25T08:54:00,331 File "/usr/lib/python3.9/logging/__init__.py", line 1442, in info 2022-08-25T08:54:00,332 self._log(INFO, msg, args, **kwargs) 2022-08-25T08:54:00,332 File "/usr/lib/python3.9/logging/__init__.py", line 1585, in _log 2022-08-25T08:54:00,332 self.handle(record) 2022-08-25T08:54:00,332 File "/usr/lib/python3.9/logging/__init__.py", line 1595, in handle 2022-08-25T08:54:00,333 self.callHandlers(record) 2022-08-25T08:54:00,333 File "/usr/lib/python3.9/logging/__init__.py", line 1657, in callHandlers 2022-08-25T08:54:00,333 hdlr.handle(record) 2022-08-25T08:54:00,333 File "/usr/lib/python3.9/logging/__init__.py", line 948, in handle 2022-08-25T08:54:00,334 self.emit(record) 2022-08-25T08:54:00,334 File "/tmp/pip-standalone-pip-mwcikskw/__env_pip__.zip/pip/_internal/utils/logging.py", line 179, in emit 2022-08-25T08:54:00,334 self.handleError(record) 2022-08-25T08:54:00,335 Message: '[present-rich] %s' 2022-08-25T08:54:00,335 Arguments: (UpgradePrompt(old='22.1.2', new='22.2.2'),) 2022-08-25T08:54:00,924 Installing build dependencies: finished with status 'done' 2022-08-25T08:54:00,952 Getting requirements to build wheel: started 2022-08-25T08:54:00,955 Running command Getting requirements to build wheel 2022-08-25T08:54:03,241 Popen(['git', 'version'], cwd=/tmp/pip-wheel-w54ee19u/lsst-utils_1f1de5f51e83472dafe90eb3c91d54a9, universal_newlines=False, shell=None, istream=None) 2022-08-25T08:54:03,268 Popen(['git', 'version'], cwd=/tmp/pip-wheel-w54ee19u/lsst-utils_1f1de5f51e83472dafe90eb3c91d54a9, universal_newlines=False, shell=None, istream=None) 2022-08-25T08:54:05,144 /usr/local/lib/python3.9/dist-packages/setuptools/config/pyprojecttoml.py:102: _ExperimentalProjectMetadata: Support for project metadata in `pyproject.toml` is still experimental and may be removed (or change) in future releases. 2022-08-25T08:54:05,144 warnings.warn(msg, _ExperimentalProjectMetadata) 2022-08-25T08:54:07,219 running egg_info 2022-08-25T08:54:07,821 writing python/lsst_utils.egg-info/PKG-INFO 2022-08-25T08:54:08,391 writing dependency_links to python/lsst_utils.egg-info/dependency_links.txt 2022-08-25T08:54:11,200 writing requirements to python/lsst_utils.egg-info/requires.txt 2022-08-25T08:54:11,767 writing top-level names to python/lsst_utils.egg-info/top_level.txt 2022-08-25T08:54:12,450 reading manifest file 'python/lsst_utils.egg-info/SOURCES.txt' 2022-08-25T08:54:12,457 reading manifest template 'MANIFEST.in' 2022-08-25T08:54:12,461 adding license file 'COPYRIGHT' 2022-08-25T08:54:12,461 adding license file 'LICENSE' 2022-08-25T08:54:12,468 writing manifest file 'python/lsst_utils.egg-info/SOURCES.txt' 2022-08-25T08:54:12,822 Getting requirements to build wheel: finished with status 'done' 2022-08-25T08:54:12,866 Created temporary directory: /tmp/pip-standalone-pip-egnn9pw8 2022-08-25T08:54:15,064 Installing backend dependencies: started 2022-08-25T08:54:15,066 Running command pip subprocess to install backend dependencies 2022-08-25T08:54:26,466 Using pip 22.1.2 from /tmp/pip-standalone-pip-egnn9pw8/__env_pip__.zip/pip (python 3.9) 2022-08-25T08:54:28,484 Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple 2022-08-25T08:54:29,374 Collecting wheel 2022-08-25T08:54:29,409 Using cached https://www.piwheels.org/simple/wheel/wheel-0.37.1-py2.py3-none-any.whl (35 kB) 2022-08-25T08:54:39,512 Installing collected packages: wheel 2022-08-25T08:54:39,814 Creating /tmp/pip-build-env-hhw9ji9s/normal/bin 2022-08-25T08:54:39,818 changing mode of /tmp/pip-build-env-hhw9ji9s/normal/bin/wheel to 755 2022-08-25T08:54:39,846 Successfully installed wheel-0.37.1 2022-08-25T08:54:40,056 --- Logging error --- 2022-08-25T08:54:40,072 Traceback (most recent call last): 2022-08-25T08:54:40,073 File "/tmp/pip-standalone-pip-egnn9pw8/__env_pip__.zip/pip/_internal/utils/logging.py", line 177, in emit 2022-08-25T08:54:40,073 self.console.print(renderable, overflow="ignore", crop=False, style=style) 2022-08-25T08:54:40,074 File "/tmp/pip-standalone-pip-egnn9pw8/__env_pip__.zip/pip/_vendor/rich/console.py", line 1752, in print 2022-08-25T08:54:40,074 extend(render(renderable, render_options)) 2022-08-25T08:54:40,074 File "/tmp/pip-standalone-pip-egnn9pw8/__env_pip__.zip/pip/_vendor/rich/console.py", line 1390, in render 2022-08-25T08:54:40,075 for render_output in iter_render: 2022-08-25T08:54:40,075 File "/tmp/pip-standalone-pip-egnn9pw8/__env_pip__.zip/pip/_internal/utils/logging.py", line 134, in __rich_console__ 2022-08-25T08:54:40,075 for line in lines: 2022-08-25T08:54:40,076 File "/tmp/pip-standalone-pip-egnn9pw8/__env_pip__.zip/pip/_vendor/rich/segment.py", line 245, in split_lines 2022-08-25T08:54:40,076 for segment in segments: 2022-08-25T08:54:40,076 File "/tmp/pip-standalone-pip-egnn9pw8/__env_pip__.zip/pip/_vendor/rich/console.py", line 1368, in render 2022-08-25T08:54:40,076 renderable = rich_cast(renderable) 2022-08-25T08:54:40,077 File "/tmp/pip-standalone-pip-egnn9pw8/__env_pip__.zip/pip/_vendor/rich/protocol.py", line 36, in rich_cast 2022-08-25T08:54:40,077 renderable = cast_method() 2022-08-25T08:54:40,077 File "/tmp/pip-standalone-pip-egnn9pw8/__env_pip__.zip/pip/_internal/self_outdated_check.py", line 130, in __rich__ 2022-08-25T08:54:40,078 pip_cmd = get_best_invocation_for_this_pip() 2022-08-25T08:54:40,078 File "/tmp/pip-standalone-pip-egnn9pw8/__env_pip__.zip/pip/_internal/utils/entrypoints.py", line 58, in get_best_invocation_for_this_pip 2022-08-25T08:54:40,078 if found_executable and os.path.samefile( 2022-08-25T08:54:40,079 File "/usr/lib/python3.9/genericpath.py", line 101, in samefile 2022-08-25T08:54:40,079 s2 = os.stat(f2) 2022-08-25T08:54:40,079 FileNotFoundError: [Errno 2] No such file or directory: '/usr/bin/pip3.9' 2022-08-25T08:54:40,080 Call stack: 2022-08-25T08:54:40,084 File "/usr/lib/python3.9/runpy.py", line 197, in _run_module_as_main 2022-08-25T08:54:40,085 return _run_code(code, main_globals, None, 2022-08-25T08:54:40,085 File "/usr/lib/python3.9/runpy.py", line 87, in _run_code 2022-08-25T08:54:40,085 exec(code, run_globals) 2022-08-25T08:54:40,086 File "/tmp/pip-standalone-pip-egnn9pw8/__env_pip__.zip/pip/__main__.py", line 31, in 2022-08-25T08:54:40,086 sys.exit(_main()) 2022-08-25T08:54:40,086 File "/tmp/pip-standalone-pip-egnn9pw8/__env_pip__.zip/pip/_internal/cli/main.py", line 70, in main 2022-08-25T08:54:40,086 return command.main(cmd_args) 2022-08-25T08:54:40,087 File "/tmp/pip-standalone-pip-egnn9pw8/__env_pip__.zip/pip/_internal/cli/base_command.py", line 101, in main 2022-08-25T08:54:40,087 return self._main(args) 2022-08-25T08:54:40,087 File "/tmp/pip-standalone-pip-egnn9pw8/__env_pip__.zip/pip/_internal/cli/base_command.py", line 223, in _main 2022-08-25T08:54:40,088 self.handle_pip_version_check(options) 2022-08-25T08:54:40,088 File "/tmp/pip-standalone-pip-egnn9pw8/__env_pip__.zip/pip/_internal/cli/req_command.py", line 148, in handle_pip_version_check 2022-08-25T08:54:40,088 pip_self_version_check(session, options) 2022-08-25T08:54:40,089 File "/tmp/pip-standalone-pip-egnn9pw8/__env_pip__.zip/pip/_internal/self_outdated_check.py", line 237, in pip_self_version_check 2022-08-25T08:54:40,089 logger.info("[present-rich] %s", upgrade_prompt) 2022-08-25T08:54:40,089 File "/usr/lib/python3.9/logging/__init__.py", line 1442, in info 2022-08-25T08:54:40,090 self._log(INFO, msg, args, **kwargs) 2022-08-25T08:54:40,090 File "/usr/lib/python3.9/logging/__init__.py", line 1585, in _log 2022-08-25T08:54:40,090 self.handle(record) 2022-08-25T08:54:40,090 File "/usr/lib/python3.9/logging/__init__.py", line 1595, in handle 2022-08-25T08:54:40,091 self.callHandlers(record) 2022-08-25T08:54:40,091 File "/usr/lib/python3.9/logging/__init__.py", line 1657, in callHandlers 2022-08-25T08:54:40,091 hdlr.handle(record) 2022-08-25T08:54:40,092 File "/usr/lib/python3.9/logging/__init__.py", line 948, in handle 2022-08-25T08:54:40,092 self.emit(record) 2022-08-25T08:54:40,092 File "/tmp/pip-standalone-pip-egnn9pw8/__env_pip__.zip/pip/_internal/utils/logging.py", line 179, in emit 2022-08-25T08:54:40,092 self.handleError(record) 2022-08-25T08:54:40,093 Message: '[present-rich] %s' 2022-08-25T08:54:40,093 Arguments: (UpgradePrompt(old='22.1.2', new='22.2.2'),) 2022-08-25T08:54:40,568 Installing backend dependencies: finished with status 'done' 2022-08-25T08:54:40,592 Created temporary directory: /tmp/pip-modern-metadata-me3ignos 2022-08-25T08:54:40,598 Preparing metadata (pyproject.toml): started 2022-08-25T08:54:40,600 Running command Preparing metadata (pyproject.toml) 2022-08-25T08:54:42,887 Popen(['git', 'version'], cwd=/tmp/pip-wheel-w54ee19u/lsst-utils_1f1de5f51e83472dafe90eb3c91d54a9, universal_newlines=False, shell=None, istream=None) 2022-08-25T08:54:42,913 Popen(['git', 'version'], cwd=/tmp/pip-wheel-w54ee19u/lsst-utils_1f1de5f51e83472dafe90eb3c91d54a9, universal_newlines=False, shell=None, istream=None) 2022-08-25T08:54:44,812 /usr/local/lib/python3.9/dist-packages/setuptools/config/pyprojecttoml.py:102: _ExperimentalProjectMetadata: Support for project metadata in `pyproject.toml` is still experimental and may be removed (or change) in future releases. 2022-08-25T08:54:44,812 warnings.warn(msg, _ExperimentalProjectMetadata) 2022-08-25T08:54:46,890 running dist_info 2022-08-25T08:54:47,503 creating /tmp/pip-modern-metadata-me3ignos/lsst_utils.egg-info 2022-08-25T08:54:48,111 writing /tmp/pip-modern-metadata-me3ignos/lsst_utils.egg-info/PKG-INFO 2022-08-25T08:54:48,685 writing dependency_links to /tmp/pip-modern-metadata-me3ignos/lsst_utils.egg-info/dependency_links.txt 2022-08-25T08:54:51,525 writing requirements to /tmp/pip-modern-metadata-me3ignos/lsst_utils.egg-info/requires.txt 2022-08-25T08:54:52,090 writing top-level names to /tmp/pip-modern-metadata-me3ignos/lsst_utils.egg-info/top_level.txt 2022-08-25T08:54:52,093 writing manifest file '/tmp/pip-modern-metadata-me3ignos/lsst_utils.egg-info/SOURCES.txt' 2022-08-25T08:54:52,784 reading manifest file '/tmp/pip-modern-metadata-me3ignos/lsst_utils.egg-info/SOURCES.txt' 2022-08-25T08:54:52,787 reading manifest template 'MANIFEST.in' 2022-08-25T08:54:52,790 adding license file 'COPYRIGHT' 2022-08-25T08:54:52,791 adding license file 'LICENSE' 2022-08-25T08:54:52,797 writing manifest file '/tmp/pip-modern-metadata-me3ignos/lsst_utils.egg-info/SOURCES.txt' 2022-08-25T08:54:52,799 creating '/tmp/pip-modern-metadata-me3ignos/lsst_utils-25.0.0a20223500.dist-info' 2022-08-25T08:54:52,968 adding license file "LICENSE" (matched pattern "LICEN[CS]E*") 2022-08-25T08:54:53,338 Preparing metadata (pyproject.toml): finished with status 'done' 2022-08-25T08:54:53,353 Source in /tmp/pip-wheel-w54ee19u/lsst-utils_1f1de5f51e83472dafe90eb3c91d54a9 has version 25.0.0a20223500, which satisfies requirement lsst-utils==25.0.0a20223500 from https://files.pythonhosted.org/packages/0d/24/1ef3cd31c341886680d4053b7359b84f8fa42fd5dc141d5c9a0e72ed50c1/lsst-utils-25.0.0a20223500.tar.gz#sha256=9ab1519ff29d4a9efbc15e2c9d4e30e6513d45ddb4cad703461d986d06597fd2 2022-08-25T08:54:53,355 Removed lsst-utils==25.0.0a20223500 from https://files.pythonhosted.org/packages/0d/24/1ef3cd31c341886680d4053b7359b84f8fa42fd5dc141d5c9a0e72ed50c1/lsst-utils-25.0.0a20223500.tar.gz#sha256=9ab1519ff29d4a9efbc15e2c9d4e30e6513d45ddb4cad703461d986d06597fd2 from build tracker '/tmp/pip-build-tracker-k634z3k7' 2022-08-25T08:54:53,365 Created temporary directory: /tmp/pip-unpack-jo2gzexu 2022-08-25T08:54:53,366 Building wheels for collected packages: lsst-utils 2022-08-25T08:54:53,376 Created temporary directory: /tmp/pip-wheel-b9bure_4 2022-08-25T08:54:53,377 Destination directory: /tmp/pip-wheel-b9bure_4 2022-08-25T08:54:53,382 Building wheel for lsst-utils (pyproject.toml): started 2022-08-25T08:54:53,384 Running command Building wheel for lsst-utils (pyproject.toml) 2022-08-25T08:54:55,588 Popen(['git', 'version'], cwd=/tmp/pip-wheel-w54ee19u/lsst-utils_1f1de5f51e83472dafe90eb3c91d54a9, universal_newlines=False, shell=None, istream=None) 2022-08-25T08:54:55,613 Popen(['git', 'version'], cwd=/tmp/pip-wheel-w54ee19u/lsst-utils_1f1de5f51e83472dafe90eb3c91d54a9, universal_newlines=False, shell=None, istream=None) 2022-08-25T08:54:57,469 /usr/local/lib/python3.9/dist-packages/setuptools/config/pyprojecttoml.py:102: _ExperimentalProjectMetadata: Support for project metadata in `pyproject.toml` is still experimental and may be removed (or change) in future releases. 2022-08-25T08:54:57,470 warnings.warn(msg, _ExperimentalProjectMetadata) 2022-08-25T08:54:58,972 running bdist_wheel 2022-08-25T08:54:59,663 running build 2022-08-25T08:54:59,663 running build_py 2022-08-25T08:55:00,253 creating build 2022-08-25T08:55:00,254 creating build/lib 2022-08-25T08:55:00,255 creating build/lib/lsst 2022-08-25T08:55:00,258 copying python/lsst/__init__.py -> build/lib/lsst 2022-08-25T08:55:00,264 creating build/lib/lsst/utils 2022-08-25T08:55:00,266 copying python/lsst/utils/deprecated.py -> build/lib/lsst/utils 2022-08-25T08:55:00,270 copying python/lsst/utils/doImport.py -> build/lib/lsst/utils 2022-08-25T08:55:00,274 copying python/lsst/utils/timer.py -> build/lib/lsst/utils 2022-08-25T08:55:00,279 copying python/lsst/utils/tests.py -> build/lib/lsst/utils 2022-08-25T08:55:00,286 copying python/lsst/utils/logging.py -> build/lib/lsst/utils 2022-08-25T08:55:00,290 copying python/lsst/utils/inheritDoc.py -> build/lib/lsst/utils 2022-08-25T08:55:00,294 copying python/lsst/utils/introspection.py -> build/lib/lsst/utils 2022-08-25T08:55:00,298 copying python/lsst/utils/threads.py -> build/lib/lsst/utils 2022-08-25T08:55:00,301 copying python/lsst/utils/usage.py -> build/lib/lsst/utils 2022-08-25T08:55:00,305 copying python/lsst/utils/packages.py -> build/lib/lsst/utils 2022-08-25T08:55:00,310 copying python/lsst/utils/_packaging.py -> build/lib/lsst/utils 2022-08-25T08:55:00,313 copying python/lsst/utils/get_caller_name.py -> build/lib/lsst/utils 2022-08-25T08:55:00,317 copying python/lsst/utils/__init__.py -> build/lib/lsst/utils 2022-08-25T08:55:00,320 copying python/lsst/utils/wrappers.py -> build/lib/lsst/utils 2022-08-25T08:55:00,325 copying python/lsst/utils/_forwarded.py -> build/lib/lsst/utils 2022-08-25T08:55:00,329 copying python/lsst/utils/version.py -> build/lib/lsst/utils 2022-08-25T08:55:00,332 copying python/lsst/utils/classes.py -> build/lib/lsst/utils 2022-08-25T08:55:00,337 copying python/lsst/utils/iteration.py -> build/lib/lsst/utils 2022-08-25T08:55:00,342 creating build/lib/lsst/utils/backtrace 2022-08-25T08:55:00,344 copying python/lsst/utils/backtrace/__init__.py -> build/lib/lsst/utils/backtrace 2022-08-25T08:55:00,348 running egg_info 2022-08-25T08:55:01,528 writing python/lsst_utils.egg-info/PKG-INFO 2022-08-25T08:55:02,082 writing dependency_links to python/lsst_utils.egg-info/dependency_links.txt 2022-08-25T08:55:04,833 writing requirements to python/lsst_utils.egg-info/requires.txt 2022-08-25T08:55:05,386 writing top-level names to python/lsst_utils.egg-info/top_level.txt 2022-08-25T08:55:05,435 reading manifest file 'python/lsst_utils.egg-info/SOURCES.txt' 2022-08-25T08:55:05,441 reading manifest template 'MANIFEST.in' 2022-08-25T08:55:05,443 adding license file 'COPYRIGHT' 2022-08-25T08:55:05,444 adding license file 'LICENSE' 2022-08-25T08:55:05,451 writing manifest file 'python/lsst_utils.egg-info/SOURCES.txt' 2022-08-25T08:55:05,455 copying python/lsst/utils/py.typed -> build/lib/lsst/utils 2022-08-25T08:55:06,631 installing to build/bdist.linux-armv7l/wheel 2022-08-25T08:55:06,632 running install 2022-08-25T08:55:06,693 running install_lib 2022-08-25T08:55:07,279 creating build/bdist.linux-armv7l 2022-08-25T08:55:07,280 creating build/bdist.linux-armv7l/wheel 2022-08-25T08:55:07,283 creating build/bdist.linux-armv7l/wheel/lsst 2022-08-25T08:55:07,285 copying build/lib/lsst/__init__.py -> build/bdist.linux-armv7l/wheel/lsst 2022-08-25T08:55:07,290 creating build/bdist.linux-armv7l/wheel/lsst/utils 2022-08-25T08:55:07,291 copying build/lib/lsst/utils/deprecated.py -> build/bdist.linux-armv7l/wheel/lsst/utils 2022-08-25T08:55:07,295 copying build/lib/lsst/utils/doImport.py -> build/bdist.linux-armv7l/wheel/lsst/utils 2022-08-25T08:55:07,299 copying build/lib/lsst/utils/timer.py -> build/bdist.linux-armv7l/wheel/lsst/utils 2022-08-25T08:55:07,304 copying build/lib/lsst/utils/tests.py -> build/bdist.linux-armv7l/wheel/lsst/utils 2022-08-25T08:55:07,310 copying build/lib/lsst/utils/logging.py -> build/bdist.linux-armv7l/wheel/lsst/utils 2022-08-25T08:55:07,315 copying build/lib/lsst/utils/inheritDoc.py -> build/bdist.linux-armv7l/wheel/lsst/utils 2022-08-25T08:55:07,319 copying build/lib/lsst/utils/introspection.py -> build/bdist.linux-armv7l/wheel/lsst/utils 2022-08-25T08:55:07,323 copying build/lib/lsst/utils/threads.py -> build/bdist.linux-armv7l/wheel/lsst/utils 2022-08-25T08:55:07,326 copying build/lib/lsst/utils/usage.py -> build/bdist.linux-armv7l/wheel/lsst/utils 2022-08-25T08:55:07,330 copying build/lib/lsst/utils/packages.py -> build/bdist.linux-armv7l/wheel/lsst/utils 2022-08-25T08:55:07,335 copying build/lib/lsst/utils/_packaging.py -> build/bdist.linux-armv7l/wheel/lsst/utils 2022-08-25T08:55:07,338 copying build/lib/lsst/utils/get_caller_name.py -> build/bdist.linux-armv7l/wheel/lsst/utils 2022-08-25T08:55:07,342 copying build/lib/lsst/utils/__init__.py -> build/bdist.linux-armv7l/wheel/lsst/utils 2022-08-25T08:55:07,346 creating build/bdist.linux-armv7l/wheel/lsst/utils/backtrace 2022-08-25T08:55:07,347 copying build/lib/lsst/utils/backtrace/__init__.py -> build/bdist.linux-armv7l/wheel/lsst/utils/backtrace 2022-08-25T08:55:07,351 copying build/lib/lsst/utils/wrappers.py -> build/bdist.linux-armv7l/wheel/lsst/utils 2022-08-25T08:55:07,356 copying build/lib/lsst/utils/_forwarded.py -> build/bdist.linux-armv7l/wheel/lsst/utils 2022-08-25T08:55:07,360 copying build/lib/lsst/utils/py.typed -> build/bdist.linux-armv7l/wheel/lsst/utils 2022-08-25T08:55:07,362 copying build/lib/lsst/utils/version.py -> build/bdist.linux-armv7l/wheel/lsst/utils 2022-08-25T08:55:07,365 copying build/lib/lsst/utils/classes.py -> build/bdist.linux-armv7l/wheel/lsst/utils 2022-08-25T08:55:07,369 copying build/lib/lsst/utils/iteration.py -> build/bdist.linux-armv7l/wheel/lsst/utils 2022-08-25T08:55:07,372 running install_egg_info 2022-08-25T08:55:07,957 Copying python/lsst_utils.egg-info to build/bdist.linux-armv7l/wheel/lsst_utils-25.0.0a20223500-py3.9.egg-info 2022-08-25T08:55:07,985 running install_scripts 2022-08-25T08:55:08,056 adding license file "LICENSE" (matched pattern "LICEN[CS]E*") 2022-08-25T08:55:08,069 creating build/bdist.linux-armv7l/wheel/lsst_utils-25.0.0a20223500.dist-info/WHEEL 2022-08-25T08:55:08,074 creating '/tmp/pip-wheel-b9bure_4/tmpixsougk1/lsst_utils-25.0.0a20223500-py3-none-any.whl' and adding 'build/bdist.linux-armv7l/wheel' to it 2022-08-25T08:55:08,079 adding 'lsst/__init__.py' 2022-08-25T08:55:08,083 adding 'lsst/utils/__init__.py' 2022-08-25T08:55:08,086 adding 'lsst/utils/_forwarded.py' 2022-08-25T08:55:08,088 adding 'lsst/utils/_packaging.py' 2022-08-25T08:55:08,091 adding 'lsst/utils/classes.py' 2022-08-25T08:55:08,094 adding 'lsst/utils/deprecated.py' 2022-08-25T08:55:08,097 adding 'lsst/utils/doImport.py' 2022-08-25T08:55:08,100 adding 'lsst/utils/get_caller_name.py' 2022-08-25T08:55:08,103 adding 'lsst/utils/inheritDoc.py' 2022-08-25T08:55:08,106 adding 'lsst/utils/introspection.py' 2022-08-25T08:55:08,109 adding 'lsst/utils/iteration.py' 2022-08-25T08:55:08,114 adding 'lsst/utils/logging.py' 2022-08-25T08:55:08,121 adding 'lsst/utils/packages.py' 2022-08-25T08:55:08,124 adding 'lsst/utils/py.typed' 2022-08-25T08:55:08,134 adding 'lsst/utils/tests.py' 2022-08-25T08:55:08,138 adding 'lsst/utils/threads.py' 2022-08-25T08:55:08,144 adding 'lsst/utils/timer.py' 2022-08-25T08:55:08,147 adding 'lsst/utils/usage.py' 2022-08-25T08:55:08,149 adding 'lsst/utils/version.py' 2022-08-25T08:55:08,155 adding 'lsst/utils/wrappers.py' 2022-08-25T08:55:08,159 adding 'lsst/utils/backtrace/__init__.py' 2022-08-25T08:55:08,164 adding 'lsst_utils-25.0.0a20223500.dist-info/LICENSE' 2022-08-25T08:55:08,166 adding 'lsst_utils-25.0.0a20223500.dist-info/METADATA' 2022-08-25T08:55:08,167 adding 'lsst_utils-25.0.0a20223500.dist-info/WHEEL' 2022-08-25T08:55:08,169 adding 'lsst_utils-25.0.0a20223500.dist-info/top_level.txt' 2022-08-25T08:55:08,171 adding 'lsst_utils-25.0.0a20223500.dist-info/zip-safe' 2022-08-25T08:55:08,173 adding 'lsst_utils-25.0.0a20223500.dist-info/RECORD' 2022-08-25T08:55:08,177 removing build/bdist.linux-armv7l/wheel 2022-08-25T08:55:08,556 Building wheel for lsst-utils (pyproject.toml): finished with status 'done' 2022-08-25T08:55:08,571 Created wheel for lsst-utils: filename=lsst_utils-25.0.0a20223500-py3-none-any.whl size=52417 sha256=755cdf7aeb840bc794f27e2bfc7028f07fecd60b011755179cb54296bae539d2 2022-08-25T08:55:08,573 Stored in directory: /tmp/pip-ephem-wheel-cache-_x8bh7v6/wheels/67/8a/8c/ef32157392b5f26afe25764abf71132505f52979827495e427 2022-08-25T08:55:08,596 Successfully built lsst-utils 2022-08-25T08:55:08,607 Removed build tracker: '/tmp/pip-build-tracker-k634z3k7'