2022-07-28T10:22:00,365 Created temporary directory: /tmp/pip-ephem-wheel-cache-fzx_7_9j
2022-07-28T10:22:00,370 Created temporary directory: /tmp/pip-build-tracker-ditwbm31
2022-07-28T10:22:00,371 Initialized build tracking at /tmp/pip-build-tracker-ditwbm31
2022-07-28T10:22:00,371 Created build tracker: /tmp/pip-build-tracker-ditwbm31
2022-07-28T10:22:00,372 Entered build tracker: /tmp/pip-build-tracker-ditwbm31
2022-07-28T10:22:00,373 Created temporary directory: /tmp/pip-wheel-m0jyfpuu
2022-07-28T10:22:00,440 Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple
2022-07-28T10:22:00,449 2 location(s) to search for versions of lsst-utils:
2022-07-28T10:22:00,449 * https://pypi.org/simple/lsst-utils/
2022-07-28T10:22:00,449 * https://www.piwheels.org/simple/lsst-utils/
2022-07-28T10:22:00,450 Fetching project page and analyzing links: https://pypi.org/simple/lsst-utils/
2022-07-28T10:22:00,451 Getting page https://pypi.org/simple/lsst-utils/
2022-07-28T10:22:00,454 Found index url https://pypi.org/simple
2022-07-28T10:22:00,578   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-07-28T10:22:00,579   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-07-28T10:22:00,580   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-07-28T10:22:00,580   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-07-28T10:22:00,581   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-07-28T10:22:00,582   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-07-28T10:22:00,582   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-07-28T10:22:00,583   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-07-28T10:22:00,583   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-07-28T10:22:00,584   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-07-28T10:22:00,585   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-07-28T10:22:00,586   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-07-28T10:22:00,586   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-07-28T10:22:00,587   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-07-28T10:22:00,587   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-07-28T10:22:00,588   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-07-28T10:22:00,589 Fetching project page and analyzing links: https://www.piwheels.org/simple/lsst-utils/
2022-07-28T10:22:00,589 Getting page https://www.piwheels.org/simple/lsst-utils/
2022-07-28T10:22:00,591 Found index url https://www.piwheels.org/simple
2022-07-28T10:22:00,814   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-07-28T10:22:00,815   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-07-28T10:22:00,815   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-07-28T10:22:00,816   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-07-28T10:22:00,816 Skipping link: not a file: https://www.piwheels.org/simple/lsst-utils/
2022-07-28T10:22:00,817 Skipping link: not a file: https://pypi.org/simple/lsst-utils/
2022-07-28T10:22:00,865 Given no hashes to check 1 links for project 'lsst-utils': discarding no candidates
2022-07-28T10:22:00,907 Collecting lsst-utils==24.0.0a20223100
2022-07-28T10:22:00,912   Created temporary directory: /tmp/pip-unpack-b9e4llzq
2022-07-28T10:22:01,003   Downloading lsst-utils-24.0.0a20223100.tar.gz (42 kB)
2022-07-28T10:22:01,212   Added lsst-utils==24.0.0a20223100 from https://files.pythonhosted.org/packages/02/d8/15601ff0b31d96bc93e6dd44e700bb30387f2f1198b4265899ebd6054cae/lsst-utils-24.0.0a20223100.tar.gz#sha256=29bc4f140eb95bf45a5e7a7c64f039fd63b78b9c8064e65ce1f0cf2e81b2b359 to build tracker '/tmp/pip-build-tracker-ditwbm31'
2022-07-28T10:22:01,231   Created temporary directory: /tmp/pip-build-env-vj6r92k0
2022-07-28T10:22:01,252   Created temporary directory: /tmp/pip-standalone-pip-c_1w6z07
2022-07-28T10:22:03,658   Installing build dependencies: started
2022-07-28T10:22:03,660   Running command pip subprocess to install build dependencies
2022-07-28T10:22:14,914   Using pip 22.1.2 from /tmp/pip-standalone-pip-c_1w6z07/__env_pip__.zip/pip (python 3.9)
2022-07-28T10:22:16,579   Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple
2022-07-28T10:22:20,785   Collecting setuptools
2022-07-28T10:22:21,059     Using cached https://www.piwheels.org/simple/setuptools/setuptools-63.2.0-py3-none-any.whl (1.2 MB)
2022-07-28T10:22:21,377   Collecting lsst-versions>=1.3.0
2022-07-28T10:22:21,408     Using cached https://www.piwheels.org/simple/lsst-versions/lsst_versions-1.3.0-py3-none-any.whl (10 kB)
2022-07-28T10:22:21,738   Collecting tomli>1.0.0
2022-07-28T10:22:21,769     Using cached https://www.piwheels.org/simple/tomli/tomli-2.0.1-py3-none-any.whl (12 kB)
2022-07-28T10:22:22,976   Collecting packaging
2022-07-28T10:22:23,009     Using cached https://www.piwheels.org/simple/packaging/packaging-21.3-py3-none-any.whl (40 kB)
2022-07-28T10:22:23,643   Collecting GitPython>=3.1
2022-07-28T10:22:23,687     Using cached https://www.piwheels.org/simple/gitpython/GitPython-3.1.27-py3-none-any.whl (181 kB)
2022-07-28T10:22:23,987   Collecting gitdb<5,>=4.0.1
2022-07-28T10:22:24,026     Using cached https://www.piwheels.org/simple/gitdb/gitdb-4.0.9-py3-none-any.whl (63 kB)
2022-07-28T10:22:24,723   Collecting pyparsing!=3.0.5,>=2.0.2
2022-07-28T10:22:24,764     Using cached https://www.piwheels.org/simple/pyparsing/pyparsing-3.0.9-py3-none-any.whl (98 kB)
2022-07-28T10:22:24,998   Collecting smmap<6,>=3.0.1
2022-07-28T10:22:25,030     Using cached https://www.piwheels.org/simple/smmap/smmap-5.0.0-py3-none-any.whl (24 kB)
2022-07-28T10:22:32,493   Installing collected packages: tomli, smmap, setuptools, pyparsing, packaging, gitdb, GitPython, lsst-versions
2022-07-28T10:22:40,254     Creating /tmp/pip-build-env-vj6r92k0/overlay/bin
2022-07-28T10:22:40,259     changing mode of /tmp/pip-build-env-vj6r92k0/overlay/bin/lsst-version to 755
2022-07-28T10:22:40,307   Successfully installed GitPython-3.1.27 gitdb-4.0.9 lsst-versions-1.3.0 packaging-21.3 pyparsing-3.0.9 setuptools-63.2.0 smmap-5.0.0 tomli-2.0.1
2022-07-28T10:22:40,513   --- Logging error ---
2022-07-28T10:22:40,530   Traceback (most recent call last):
2022-07-28T10:22:40,530     File "/tmp/pip-standalone-pip-c_1w6z07/__env_pip__.zip/pip/_internal/utils/logging.py", line 177, in emit
2022-07-28T10:22:40,531       self.console.print(renderable, overflow="ignore", crop=False, style=style)
2022-07-28T10:22:40,531     File "/tmp/pip-standalone-pip-c_1w6z07/__env_pip__.zip/pip/_vendor/rich/console.py", line 1752, in print
2022-07-28T10:22:40,531       extend(render(renderable, render_options))
2022-07-28T10:22:40,532     File "/tmp/pip-standalone-pip-c_1w6z07/__env_pip__.zip/pip/_vendor/rich/console.py", line 1390, in render
2022-07-28T10:22:40,532       for render_output in iter_render:
2022-07-28T10:22:40,532     File "/tmp/pip-standalone-pip-c_1w6z07/__env_pip__.zip/pip/_internal/utils/logging.py", line 134, in __rich_console__
2022-07-28T10:22:40,533       for line in lines:
2022-07-28T10:22:40,533     File "/tmp/pip-standalone-pip-c_1w6z07/__env_pip__.zip/pip/_vendor/rich/segment.py", line 245, in split_lines
2022-07-28T10:22:40,533       for segment in segments:
2022-07-28T10:22:40,533     File "/tmp/pip-standalone-pip-c_1w6z07/__env_pip__.zip/pip/_vendor/rich/console.py", line 1368, in render
2022-07-28T10:22:40,534       renderable = rich_cast(renderable)
2022-07-28T10:22:40,534     File "/tmp/pip-standalone-pip-c_1w6z07/__env_pip__.zip/pip/_vendor/rich/protocol.py", line 36, in rich_cast
2022-07-28T10:22:40,535       renderable = cast_method()
2022-07-28T10:22:40,535     File "/tmp/pip-standalone-pip-c_1w6z07/__env_pip__.zip/pip/_internal/self_outdated_check.py", line 130, in __rich__
2022-07-28T10:22:40,535       pip_cmd = get_best_invocation_for_this_pip()
2022-07-28T10:22:40,536     File "/tmp/pip-standalone-pip-c_1w6z07/__env_pip__.zip/pip/_internal/utils/entrypoints.py", line 58, in get_best_invocation_for_this_pip
2022-07-28T10:22:40,536       if found_executable and os.path.samefile(
2022-07-28T10:22:40,536     File "/usr/lib/python3.9/genericpath.py", line 101, in samefile
2022-07-28T10:22:40,537       s2 = os.stat(f2)
2022-07-28T10:22:40,537   FileNotFoundError: [Errno 2] No such file or directory: '/usr/bin/pip3.9'
2022-07-28T10:22:40,537   Call stack:
2022-07-28T10:22:40,541     File "/usr/lib/python3.9/runpy.py", line 197, in _run_module_as_main
2022-07-28T10:22:40,541       return _run_code(code, main_globals, None,
2022-07-28T10:22:40,542     File "/usr/lib/python3.9/runpy.py", line 87, in _run_code
2022-07-28T10:22:40,542       exec(code, run_globals)
2022-07-28T10:22:40,542     File "/tmp/pip-standalone-pip-c_1w6z07/__env_pip__.zip/pip/__main__.py", line 31, in <module>
2022-07-28T10:22:40,543       sys.exit(_main())
2022-07-28T10:22:40,543     File "/tmp/pip-standalone-pip-c_1w6z07/__env_pip__.zip/pip/_internal/cli/main.py", line 70, in main
2022-07-28T10:22:40,543       return command.main(cmd_args)
2022-07-28T10:22:40,544     File "/tmp/pip-standalone-pip-c_1w6z07/__env_pip__.zip/pip/_internal/cli/base_command.py", line 101, in main
2022-07-28T10:22:40,544       return self._main(args)
2022-07-28T10:22:40,544     File "/tmp/pip-standalone-pip-c_1w6z07/__env_pip__.zip/pip/_internal/cli/base_command.py", line 223, in _main
2022-07-28T10:22:40,545       self.handle_pip_version_check(options)
2022-07-28T10:22:40,545     File "/tmp/pip-standalone-pip-c_1w6z07/__env_pip__.zip/pip/_internal/cli/req_command.py", line 148, in handle_pip_version_check
2022-07-28T10:22:40,545       pip_self_version_check(session, options)
2022-07-28T10:22:40,546     File "/tmp/pip-standalone-pip-c_1w6z07/__env_pip__.zip/pip/_internal/self_outdated_check.py", line 237, in pip_self_version_check
2022-07-28T10:22:40,546       logger.info("[present-rich] %s", upgrade_prompt)
2022-07-28T10:22:40,546     File "/usr/lib/python3.9/logging/__init__.py", line 1442, in info
2022-07-28T10:22:40,546       self._log(INFO, msg, args, **kwargs)
2022-07-28T10:22:40,547     File "/usr/lib/python3.9/logging/__init__.py", line 1585, in _log
2022-07-28T10:22:40,547       self.handle(record)
2022-07-28T10:22:40,547     File "/usr/lib/python3.9/logging/__init__.py", line 1595, in handle
2022-07-28T10:22:40,548       self.callHandlers(record)
2022-07-28T10:22:40,548     File "/usr/lib/python3.9/logging/__init__.py", line 1657, in callHandlers
2022-07-28T10:22:40,548       hdlr.handle(record)
2022-07-28T10:22:40,549     File "/usr/lib/python3.9/logging/__init__.py", line 948, in handle
2022-07-28T10:22:40,549       self.emit(record)
2022-07-28T10:22:40,549     File "/tmp/pip-standalone-pip-c_1w6z07/__env_pip__.zip/pip/_internal/utils/logging.py", line 179, in emit
2022-07-28T10:22:40,549       self.handleError(record)
2022-07-28T10:22:40,550   Message: '[present-rich] %s'
2022-07-28T10:22:40,550   Arguments: (UpgradePrompt(old='22.1.2', new='22.2'),)
2022-07-28T10:22:41,116   Installing build dependencies: finished with status 'done'
2022-07-28T10:22:41,143   Getting requirements to build wheel: started
2022-07-28T10:22:41,146   Running command Getting requirements to build wheel
2022-07-28T10:22:43,508   Popen(['git', 'version'], cwd=/tmp/pip-wheel-m0jyfpuu/lsst-utils_cf91047a502842d3855c2d182604cf8f, universal_newlines=False, shell=None, istream=None)
2022-07-28T10:22:43,533   Popen(['git', 'version'], cwd=/tmp/pip-wheel-m0jyfpuu/lsst-utils_cf91047a502842d3855c2d182604cf8f, universal_newlines=False, shell=None, istream=None)
2022-07-28T10:22:45,423   /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-07-28T10:22:45,423     warnings.warn(msg, _ExperimentalProjectMetadata)
2022-07-28T10:22:47,404   running egg_info
2022-07-28T10:22:48,014   writing python/lsst_utils.egg-info/PKG-INFO
2022-07-28T10:22:48,579   writing dependency_links to python/lsst_utils.egg-info/dependency_links.txt
2022-07-28T10:22:51,408   writing requirements to python/lsst_utils.egg-info/requires.txt
2022-07-28T10:22:51,969   writing top-level names to python/lsst_utils.egg-info/top_level.txt
2022-07-28T10:22:52,658   reading manifest file 'python/lsst_utils.egg-info/SOURCES.txt'
2022-07-28T10:22:52,665   reading manifest template 'MANIFEST.in'
2022-07-28T10:22:52,669   adding license file 'COPYRIGHT'
2022-07-28T10:22:52,669   adding license file 'LICENSE'
2022-07-28T10:22:52,676   writing manifest file 'python/lsst_utils.egg-info/SOURCES.txt'
2022-07-28T10:22:53,025   Getting requirements to build wheel: finished with status 'done'
2022-07-28T10:22:53,069   Created temporary directory: /tmp/pip-standalone-pip-999qmtaz
2022-07-28T10:22:55,242   Installing backend dependencies: started
2022-07-28T10:22:55,245   Running command pip subprocess to install backend dependencies
2022-07-28T10:23:06,562   Using pip 22.1.2 from /tmp/pip-standalone-pip-999qmtaz/__env_pip__.zip/pip (python 3.9)
2022-07-28T10:23:08,243   Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple
2022-07-28T10:23:09,136   Collecting wheel
2022-07-28T10:23:09,172     Using cached https://www.piwheels.org/simple/wheel/wheel-0.37.1-py2.py3-none-any.whl (35 kB)
2022-07-28T10:23:15,823   Installing collected packages: wheel
2022-07-28T10:23:16,116     Creating /tmp/pip-build-env-vj6r92k0/normal/bin
2022-07-28T10:23:16,120     changing mode of /tmp/pip-build-env-vj6r92k0/normal/bin/wheel to 755
2022-07-28T10:23:16,147   Successfully installed wheel-0.37.1
2022-07-28T10:23:16,342   --- Logging error ---
2022-07-28T10:23:16,358   Traceback (most recent call last):
2022-07-28T10:23:16,359     File "/tmp/pip-standalone-pip-999qmtaz/__env_pip__.zip/pip/_internal/utils/logging.py", line 177, in emit
2022-07-28T10:23:16,359       self.console.print(renderable, overflow="ignore", crop=False, style=style)
2022-07-28T10:23:16,359     File "/tmp/pip-standalone-pip-999qmtaz/__env_pip__.zip/pip/_vendor/rich/console.py", line 1752, in print
2022-07-28T10:23:16,360       extend(render(renderable, render_options))
2022-07-28T10:23:16,360     File "/tmp/pip-standalone-pip-999qmtaz/__env_pip__.zip/pip/_vendor/rich/console.py", line 1390, in render
2022-07-28T10:23:16,360       for render_output in iter_render:
2022-07-28T10:23:16,361     File "/tmp/pip-standalone-pip-999qmtaz/__env_pip__.zip/pip/_internal/utils/logging.py", line 134, in __rich_console__
2022-07-28T10:23:16,361       for line in lines:
2022-07-28T10:23:16,361     File "/tmp/pip-standalone-pip-999qmtaz/__env_pip__.zip/pip/_vendor/rich/segment.py", line 245, in split_lines
2022-07-28T10:23:16,362       for segment in segments:
2022-07-28T10:23:16,362     File "/tmp/pip-standalone-pip-999qmtaz/__env_pip__.zip/pip/_vendor/rich/console.py", line 1368, in render
2022-07-28T10:23:16,362       renderable = rich_cast(renderable)
2022-07-28T10:23:16,362     File "/tmp/pip-standalone-pip-999qmtaz/__env_pip__.zip/pip/_vendor/rich/protocol.py", line 36, in rich_cast
2022-07-28T10:23:16,363       renderable = cast_method()
2022-07-28T10:23:16,363     File "/tmp/pip-standalone-pip-999qmtaz/__env_pip__.zip/pip/_internal/self_outdated_check.py", line 130, in __rich__
2022-07-28T10:23:16,363       pip_cmd = get_best_invocation_for_this_pip()
2022-07-28T10:23:16,364     File "/tmp/pip-standalone-pip-999qmtaz/__env_pip__.zip/pip/_internal/utils/entrypoints.py", line 58, in get_best_invocation_for_this_pip
2022-07-28T10:23:16,364       if found_executable and os.path.samefile(
2022-07-28T10:23:16,365     File "/usr/lib/python3.9/genericpath.py", line 101, in samefile
2022-07-28T10:23:16,365       s2 = os.stat(f2)
2022-07-28T10:23:16,365   FileNotFoundError: [Errno 2] No such file or directory: '/usr/bin/pip3.9'
2022-07-28T10:23:16,365   Call stack:
2022-07-28T10:23:16,389     File "/usr/lib/python3.9/runpy.py", line 197, in _run_module_as_main
2022-07-28T10:23:16,390       return _run_code(code, main_globals, None,
2022-07-28T10:23:16,390     File "/usr/lib/python3.9/runpy.py", line 87, in _run_code
2022-07-28T10:23:16,390       exec(code, run_globals)
2022-07-28T10:23:16,391     File "/tmp/pip-standalone-pip-999qmtaz/__env_pip__.zip/pip/__main__.py", line 31, in <module>
2022-07-28T10:23:16,391       sys.exit(_main())
2022-07-28T10:23:16,391     File "/tmp/pip-standalone-pip-999qmtaz/__env_pip__.zip/pip/_internal/cli/main.py", line 70, in main
2022-07-28T10:23:16,392       return command.main(cmd_args)
2022-07-28T10:23:16,392     File "/tmp/pip-standalone-pip-999qmtaz/__env_pip__.zip/pip/_internal/cli/base_command.py", line 101, in main
2022-07-28T10:23:16,392       return self._main(args)
2022-07-28T10:23:16,393     File "/tmp/pip-standalone-pip-999qmtaz/__env_pip__.zip/pip/_internal/cli/base_command.py", line 223, in _main
2022-07-28T10:23:16,393       self.handle_pip_version_check(options)
2022-07-28T10:23:16,393     File "/tmp/pip-standalone-pip-999qmtaz/__env_pip__.zip/pip/_internal/cli/req_command.py", line 148, in handle_pip_version_check
2022-07-28T10:23:16,394       pip_self_version_check(session, options)
2022-07-28T10:23:16,394     File "/tmp/pip-standalone-pip-999qmtaz/__env_pip__.zip/pip/_internal/self_outdated_check.py", line 237, in pip_self_version_check
2022-07-28T10:23:16,394       logger.info("[present-rich] %s", upgrade_prompt)
2022-07-28T10:23:16,394     File "/usr/lib/python3.9/logging/__init__.py", line 1442, in info
2022-07-28T10:23:16,395       self._log(INFO, msg, args, **kwargs)
2022-07-28T10:23:16,395     File "/usr/lib/python3.9/logging/__init__.py", line 1585, in _log
2022-07-28T10:23:16,395       self.handle(record)
2022-07-28T10:23:16,396     File "/usr/lib/python3.9/logging/__init__.py", line 1595, in handle
2022-07-28T10:23:16,396       self.callHandlers(record)
2022-07-28T10:23:16,396     File "/usr/lib/python3.9/logging/__init__.py", line 1657, in callHandlers
2022-07-28T10:23:16,397       hdlr.handle(record)
2022-07-28T10:23:16,397     File "/usr/lib/python3.9/logging/__init__.py", line 948, in handle
2022-07-28T10:23:16,397       self.emit(record)
2022-07-28T10:23:16,397     File "/tmp/pip-standalone-pip-999qmtaz/__env_pip__.zip/pip/_internal/utils/logging.py", line 179, in emit
2022-07-28T10:23:16,398       self.handleError(record)
2022-07-28T10:23:16,398   Message: '[present-rich] %s'
2022-07-28T10:23:16,398   Arguments: (UpgradePrompt(old='22.1.2', new='22.2'),)
2022-07-28T10:23:16,841   Installing backend dependencies: finished with status 'done'
2022-07-28T10:23:16,862   Created temporary directory: /tmp/pip-modern-metadata-7j1bdms6
2022-07-28T10:23:16,869   Preparing metadata (pyproject.toml): started
2022-07-28T10:23:16,871   Running command Preparing metadata (pyproject.toml)
2022-07-28T10:23:19,105   Popen(['git', 'version'], cwd=/tmp/pip-wheel-m0jyfpuu/lsst-utils_cf91047a502842d3855c2d182604cf8f, universal_newlines=False, shell=None, istream=None)
2022-07-28T10:23:19,130   Popen(['git', 'version'], cwd=/tmp/pip-wheel-m0jyfpuu/lsst-utils_cf91047a502842d3855c2d182604cf8f, universal_newlines=False, shell=None, istream=None)
2022-07-28T10:23:21,013   /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-07-28T10:23:21,014     warnings.warn(msg, _ExperimentalProjectMetadata)
2022-07-28T10:23:23,025   running dist_info
2022-07-28T10:23:23,636   creating /tmp/pip-modern-metadata-7j1bdms6/lsst_utils.egg-info
2022-07-28T10:23:24,234   writing /tmp/pip-modern-metadata-7j1bdms6/lsst_utils.egg-info/PKG-INFO
2022-07-28T10:23:24,800   writing dependency_links to /tmp/pip-modern-metadata-7j1bdms6/lsst_utils.egg-info/dependency_links.txt
2022-07-28T10:23:27,612   writing requirements to /tmp/pip-modern-metadata-7j1bdms6/lsst_utils.egg-info/requires.txt
2022-07-28T10:23:28,174   writing top-level names to /tmp/pip-modern-metadata-7j1bdms6/lsst_utils.egg-info/top_level.txt
2022-07-28T10:23:28,177   writing manifest file '/tmp/pip-modern-metadata-7j1bdms6/lsst_utils.egg-info/SOURCES.txt'
2022-07-28T10:23:28,860   reading manifest file '/tmp/pip-modern-metadata-7j1bdms6/lsst_utils.egg-info/SOURCES.txt'
2022-07-28T10:23:28,863   reading manifest template 'MANIFEST.in'
2022-07-28T10:23:28,867   adding license file 'COPYRIGHT'
2022-07-28T10:23:28,867   adding license file 'LICENSE'
2022-07-28T10:23:28,873   writing manifest file '/tmp/pip-modern-metadata-7j1bdms6/lsst_utils.egg-info/SOURCES.txt'
2022-07-28T10:23:28,876   creating '/tmp/pip-modern-metadata-7j1bdms6/lsst_utils-24.0.0a20223100.dist-info'
2022-07-28T10:23:29,041   adding license file "LICENSE" (matched pattern "LICEN[CS]E*")
2022-07-28T10:23:29,409   Preparing metadata (pyproject.toml): finished with status 'done'
2022-07-28T10:23:29,423   Source in /tmp/pip-wheel-m0jyfpuu/lsst-utils_cf91047a502842d3855c2d182604cf8f has version 24.0.0a20223100, which satisfies requirement lsst-utils==24.0.0a20223100 from https://files.pythonhosted.org/packages/02/d8/15601ff0b31d96bc93e6dd44e700bb30387f2f1198b4265899ebd6054cae/lsst-utils-24.0.0a20223100.tar.gz#sha256=29bc4f140eb95bf45a5e7a7c64f039fd63b78b9c8064e65ce1f0cf2e81b2b359
2022-07-28T10:23:29,425   Removed lsst-utils==24.0.0a20223100 from https://files.pythonhosted.org/packages/02/d8/15601ff0b31d96bc93e6dd44e700bb30387f2f1198b4265899ebd6054cae/lsst-utils-24.0.0a20223100.tar.gz#sha256=29bc4f140eb95bf45a5e7a7c64f039fd63b78b9c8064e65ce1f0cf2e81b2b359 from build tracker '/tmp/pip-build-tracker-ditwbm31'
2022-07-28T10:23:29,435 Created temporary directory: /tmp/pip-unpack-94cqc527
2022-07-28T10:23:29,436 Building wheels for collected packages: lsst-utils
2022-07-28T10:23:29,445   Created temporary directory: /tmp/pip-wheel-u6989b_n
2022-07-28T10:23:29,445   Destination directory: /tmp/pip-wheel-u6989b_n
2022-07-28T10:23:29,450   Building wheel for lsst-utils (pyproject.toml): started
2022-07-28T10:23:29,452   Running command Building wheel for lsst-utils (pyproject.toml)
2022-07-28T10:23:31,630   Popen(['git', 'version'], cwd=/tmp/pip-wheel-m0jyfpuu/lsst-utils_cf91047a502842d3855c2d182604cf8f, universal_newlines=False, shell=None, istream=None)
2022-07-28T10:23:31,654   Popen(['git', 'version'], cwd=/tmp/pip-wheel-m0jyfpuu/lsst-utils_cf91047a502842d3855c2d182604cf8f, universal_newlines=False, shell=None, istream=None)
2022-07-28T10:23:33,553   /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-07-28T10:23:33,553     warnings.warn(msg, _ExperimentalProjectMetadata)
2022-07-28T10:23:35,011   running bdist_wheel
2022-07-28T10:23:35,717   running build
2022-07-28T10:23:35,717   running build_py
2022-07-28T10:23:36,317   creating build
2022-07-28T10:23:36,317   creating build/lib
2022-07-28T10:23:36,318   creating build/lib/lsst
2022-07-28T10:23:36,320   copying python/lsst/__init__.py -> build/lib/lsst
2022-07-28T10:23:36,327   creating build/lib/lsst/utils
2022-07-28T10:23:36,329   copying python/lsst/utils/tests.py -> build/lib/lsst/utils
2022-07-28T10:23:36,336   copying python/lsst/utils/doImport.py -> build/lib/lsst/utils
2022-07-28T10:23:36,340   copying python/lsst/utils/timer.py -> build/lib/lsst/utils
2022-07-28T10:23:36,345   copying python/lsst/utils/iteration.py -> build/lib/lsst/utils
2022-07-28T10:23:36,348   copying python/lsst/utils/logging.py -> build/lib/lsst/utils
2022-07-28T10:23:36,353   copying python/lsst/utils/wrappers.py -> build/lib/lsst/utils
2022-07-28T10:23:36,358   copying python/lsst/utils/deprecated.py -> build/lib/lsst/utils
2022-07-28T10:23:36,362   copying python/lsst/utils/packages.py -> build/lib/lsst/utils
2022-07-28T10:23:36,367   copying python/lsst/utils/_packaging.py -> build/lib/lsst/utils
2022-07-28T10:23:36,371   copying python/lsst/utils/version.py -> build/lib/lsst/utils
2022-07-28T10:23:36,373   copying python/lsst/utils/usage.py -> build/lib/lsst/utils
2022-07-28T10:23:36,377   copying python/lsst/utils/classes.py -> build/lib/lsst/utils
2022-07-28T10:23:36,381   copying python/lsst/utils/get_caller_name.py -> build/lib/lsst/utils
2022-07-28T10:23:36,384   copying python/lsst/utils/_forwarded.py -> build/lib/lsst/utils
2022-07-28T10:23:36,387   copying python/lsst/utils/__init__.py -> build/lib/lsst/utils
2022-07-28T10:23:36,390   copying python/lsst/utils/introspection.py -> build/lib/lsst/utils
2022-07-28T10:23:36,394   copying python/lsst/utils/threads.py -> build/lib/lsst/utils
2022-07-28T10:23:36,398   copying python/lsst/utils/inheritDoc.py -> build/lib/lsst/utils
2022-07-28T10:23:36,403   creating build/lib/lsst/utils/backtrace
2022-07-28T10:23:36,405   copying python/lsst/utils/backtrace/__init__.py -> build/lib/lsst/utils/backtrace
2022-07-28T10:23:36,409   running egg_info
2022-07-28T10:23:37,609   writing python/lsst_utils.egg-info/PKG-INFO
2022-07-28T10:23:38,179   writing dependency_links to python/lsst_utils.egg-info/dependency_links.txt
2022-07-28T10:23:40,991   writing requirements to python/lsst_utils.egg-info/requires.txt
2022-07-28T10:23:41,555   writing top-level names to python/lsst_utils.egg-info/top_level.txt
2022-07-28T10:23:41,602   reading manifest file 'python/lsst_utils.egg-info/SOURCES.txt'
2022-07-28T10:23:41,607   reading manifest template 'MANIFEST.in'
2022-07-28T10:23:41,610   adding license file 'COPYRIGHT'
2022-07-28T10:23:41,611   adding license file 'LICENSE'
2022-07-28T10:23:41,618   writing manifest file 'python/lsst_utils.egg-info/SOURCES.txt'
2022-07-28T10:23:41,622   copying python/lsst/utils/py.typed -> build/lib/lsst/utils
2022-07-28T10:23:42,812   installing to build/bdist.linux-armv7l/wheel
2022-07-28T10:23:42,813   running install
2022-07-28T10:23:42,873   running install_lib
2022-07-28T10:23:43,466   creating build/bdist.linux-armv7l
2022-07-28T10:23:43,467   creating build/bdist.linux-armv7l/wheel
2022-07-28T10:23:43,470   creating build/bdist.linux-armv7l/wheel/lsst
2022-07-28T10:23:43,472   copying build/lib/lsst/__init__.py -> build/bdist.linux-armv7l/wheel/lsst
2022-07-28T10:23:43,477   creating build/bdist.linux-armv7l/wheel/lsst/utils
2022-07-28T10:23:43,478   copying build/lib/lsst/utils/tests.py -> build/bdist.linux-armv7l/wheel/lsst/utils
2022-07-28T10:23:43,484   copying build/lib/lsst/utils/py.typed -> build/bdist.linux-armv7l/wheel/lsst/utils
2022-07-28T10:23:43,487   copying build/lib/lsst/utils/doImport.py -> build/bdist.linux-armv7l/wheel/lsst/utils
2022-07-28T10:23:43,491   copying build/lib/lsst/utils/timer.py -> build/bdist.linux-armv7l/wheel/lsst/utils
2022-07-28T10:23:43,496   copying build/lib/lsst/utils/iteration.py -> build/bdist.linux-armv7l/wheel/lsst/utils
2022-07-28T10:23:43,500   creating build/bdist.linux-armv7l/wheel/lsst/utils/backtrace
2022-07-28T10:23:43,502   copying build/lib/lsst/utils/backtrace/__init__.py -> build/bdist.linux-armv7l/wheel/lsst/utils/backtrace
2022-07-28T10:23:43,505   copying build/lib/lsst/utils/logging.py -> build/bdist.linux-armv7l/wheel/lsst/utils
2022-07-28T10:23:43,510   copying build/lib/lsst/utils/wrappers.py -> build/bdist.linux-armv7l/wheel/lsst/utils
2022-07-28T10:23:43,515   copying build/lib/lsst/utils/deprecated.py -> build/bdist.linux-armv7l/wheel/lsst/utils
2022-07-28T10:23:43,518   copying build/lib/lsst/utils/packages.py -> build/bdist.linux-armv7l/wheel/lsst/utils
2022-07-28T10:23:43,523   copying build/lib/lsst/utils/_packaging.py -> build/bdist.linux-armv7l/wheel/lsst/utils
2022-07-28T10:23:43,527   copying build/lib/lsst/utils/version.py -> build/bdist.linux-armv7l/wheel/lsst/utils
2022-07-28T10:23:43,530   copying build/lib/lsst/utils/usage.py -> build/bdist.linux-armv7l/wheel/lsst/utils
2022-07-28T10:23:43,534   copying build/lib/lsst/utils/classes.py -> build/bdist.linux-armv7l/wheel/lsst/utils
2022-07-28T10:23:43,538   copying build/lib/lsst/utils/get_caller_name.py -> build/bdist.linux-armv7l/wheel/lsst/utils
2022-07-28T10:23:43,541   copying build/lib/lsst/utils/_forwarded.py -> build/bdist.linux-armv7l/wheel/lsst/utils
2022-07-28T10:23:43,545   copying build/lib/lsst/utils/__init__.py -> build/bdist.linux-armv7l/wheel/lsst/utils
2022-07-28T10:23:43,548   copying build/lib/lsst/utils/introspection.py -> build/bdist.linux-armv7l/wheel/lsst/utils
2022-07-28T10:23:43,552   copying build/lib/lsst/utils/threads.py -> build/bdist.linux-armv7l/wheel/lsst/utils
2022-07-28T10:23:43,556   copying build/lib/lsst/utils/inheritDoc.py -> build/bdist.linux-armv7l/wheel/lsst/utils
2022-07-28T10:23:43,558   running install_egg_info
2022-07-28T10:23:44,151   Copying python/lsst_utils.egg-info to build/bdist.linux-armv7l/wheel/lsst_utils-24.0.0a20223100-py3.9.egg-info
2022-07-28T10:23:44,176   running install_scripts
2022-07-28T10:23:44,243   adding license file "LICENSE" (matched pattern "LICEN[CS]E*")
2022-07-28T10:23:44,255   creating build/bdist.linux-armv7l/wheel/lsst_utils-24.0.0a20223100.dist-info/WHEEL
2022-07-28T10:23:44,259   creating '/tmp/pip-wheel-u6989b_n/tmp9816u4z5/lsst_utils-24.0.0a20223100-py3-none-any.whl' and adding 'build/bdist.linux-armv7l/wheel' to it
2022-07-28T10:23:44,264   adding 'lsst/__init__.py'
2022-07-28T10:23:44,268   adding 'lsst/utils/__init__.py'
2022-07-28T10:23:44,270   adding 'lsst/utils/_forwarded.py'
2022-07-28T10:23:44,273   adding 'lsst/utils/_packaging.py'
2022-07-28T10:23:44,276   adding 'lsst/utils/classes.py'
2022-07-28T10:23:44,279   adding 'lsst/utils/deprecated.py'
2022-07-28T10:23:44,282   adding 'lsst/utils/doImport.py'
2022-07-28T10:23:44,285   adding 'lsst/utils/get_caller_name.py'
2022-07-28T10:23:44,287   adding 'lsst/utils/inheritDoc.py'
2022-07-28T10:23:44,290   adding 'lsst/utils/introspection.py'
2022-07-28T10:23:44,293   adding 'lsst/utils/iteration.py'
2022-07-28T10:23:44,298   adding 'lsst/utils/logging.py'
2022-07-28T10:23:44,305   adding 'lsst/utils/packages.py'
2022-07-28T10:23:44,307   adding 'lsst/utils/py.typed'
2022-07-28T10:23:44,318   adding 'lsst/utils/tests.py'
2022-07-28T10:23:44,321   adding 'lsst/utils/threads.py'
2022-07-28T10:23:44,327   adding 'lsst/utils/timer.py'
2022-07-28T10:23:44,330   adding 'lsst/utils/usage.py'
2022-07-28T10:23:44,332   adding 'lsst/utils/version.py'
2022-07-28T10:23:44,338   adding 'lsst/utils/wrappers.py'
2022-07-28T10:23:44,342   adding 'lsst/utils/backtrace/__init__.py'
2022-07-28T10:23:44,347   adding 'lsst_utils-24.0.0a20223100.dist-info/LICENSE'
2022-07-28T10:23:44,349   adding 'lsst_utils-24.0.0a20223100.dist-info/METADATA'
2022-07-28T10:23:44,351   adding 'lsst_utils-24.0.0a20223100.dist-info/WHEEL'
2022-07-28T10:23:44,352   adding 'lsst_utils-24.0.0a20223100.dist-info/top_level.txt'
2022-07-28T10:23:44,354   adding 'lsst_utils-24.0.0a20223100.dist-info/zip-safe'
2022-07-28T10:23:44,356   adding 'lsst_utils-24.0.0a20223100.dist-info/RECORD'
2022-07-28T10:23:44,360   removing build/bdist.linux-armv7l/wheel
2022-07-28T10:23:44,739   Building wheel for lsst-utils (pyproject.toml): finished with status 'done'
2022-07-28T10:23:44,754   Created wheel for lsst-utils: filename=lsst_utils-24.0.0a20223100-py3-none-any.whl size=51938 sha256=df3afdbaa95be444c2b29fbb40d94999106a78b334e3ed6aad99007dee803b3d
2022-07-28T10:23:44,756   Stored in directory: /tmp/pip-ephem-wheel-cache-fzx_7_9j/wheels/1c/fa/d1/980db352bd6b6e1659ef7549457e15088fedca5358aac040a8
2022-07-28T10:23:44,779 Successfully built lsst-utils
2022-07-28T10:23:44,790 Removed build tracker: '/tmp/pip-build-tracker-ditwbm31'