pants_package_debug.txt

14:49 $ ./pants -ldebug package src/python/gh/web:dist
14:49:40.61 [DEBUG] acquiring lock: <pants.pantsd.lock.OwnerPrintingInterProcessFileLock object at 0x102dd2310>
14:49:40.62 [DEBUG] releasing lock: <pants.pantsd.lock.OwnerPrintingInterProcessFileLock object at 0x102dd2310>
14:49:40.62 [DEBUG] Connecting to pantsd on port 61838
14:49:40.62 [DEBUG] Connecting to pantsd on port 61838 attempt 1/3
14:49:40.62 [DEBUG] Connected to pantsd
14:49:40.65 [INFO] initialization options changed: reinitializing scheduler...
14:49:40.65 [DEBUG] terminating pantsd service: <pants.pantsd.service.scheduler_service.SchedulerService object at 0x87266e2f10>
14:49:41.11 [DEBUG] terminating pantsd service: <pants.pantsd.service.store_gc_service.StoreGCService object at 0x8726700340>
14:49:41.11 [DEBUG] Launching 1 roots (poll=false).
14:49:41.15 [DEBUG] computed 1 nodes in 0.038748 seconds. there are 7 total nodes.
14:49:41.19 [DEBUG] File handle limit is: 10000
14:49:41.59 [DEBUG] Changes to /Users/dmistry/.cache/pants/setup/bootstrap-Darwin-x86_64/pants.H8s5UC/install/bin, outside of the buildroot, will not be invalidated.
14:49:41.59 [DEBUG] Changes to /Users/dmistry/.cache/pants/setup/bootstrap-Darwin-x86_64/pants.H8s5UC/install/bin, outside of the buildroot, will not be invalidated.
14:49:41.59 [DEBUG] Changes to /Users/dmistry/.cache/pants/setup/bootstrap-Darwin-x86_64/2.4.1_py38/lib/python38.zip, outside of the buildroot, will not be invalidated.
14:49:41.59 [DEBUG] Changes to /Users/dmistry/.cache/pants/setup/bootstrap-Darwin-x86_64/2.4.1_py38/lib/python3.8, outside of the buildroot, will not be invalidated.
14:49:41.59 [DEBUG] Changes to /Users/dmistry/.cache/pants/setup/bootstrap-Darwin-x86_64/2.4.1_py38/lib/python3.8/lib-dynload, outside of the buildroot, will not be invalidated.
14:49:41.59 [DEBUG] Changes to /Users/dmistry/.pyenv/versions/3.8.5/lib/python3.8, outside of the buildroot, will not be invalidated.
14:49:41.59 [DEBUG] Changes to /Users/dmistry/.cache/pants/setup/bootstrap-Darwin-x86_64/2.4.1_py38/lib/python3.8/site-packages, outside of the buildroot, will not be invalidated.
14:49:41.59 [DEBUG] setting up service <pants.pantsd.service.scheduler_service.SchedulerService object at 0xca34aed040>
14:49:41.59 [DEBUG] setting up service <pants.pantsd.service.store_gc_service.StoreGCService object at 0xca34aed5b0>
14:49:41.59 [DEBUG] starting service <pants.pantsd.service.scheduler_service.SchedulerService object at 0xca34aed040>
14:49:41.59 [DEBUG] starting service <pants.pantsd.service.store_gc_service.StoreGCService object at 0xca34aed5b0>
14:49:41.59 [INFO] scheduler initialized.
14:49:41.59 [DEBUG] Launching 1 roots (poll=false).
14:49:41.59 [DEBUG] computed 1 nodes in 0.000190 seconds. there are 7 total nodes.
14:49:41.62 [DEBUG] specs are: Specs(address_specs=AddressSpecs(literals=(AddressLiteralSpec(path_component='src/python/gh/web', target_component='dist'),), globs=(), filter_by_global_options=True), filesystem_specs=FilesystemSpecs(includes=(), ignores=()))
14:49:41.62 [DEBUG] changed_options are: ChangedOptions(since=None, diffspec=None, dependees=<DependeesOption.NONE: 'none'>)
14:49:41.62 [DEBUG] Launching 1 roots (poll=false).
14:49:41.62 [DEBUG] computed 1 nodes in 0.001821 seconds. there are 35 total nodes.
14:49:41.62 [DEBUG] requesting <class 'pants.core.goals.package.Package'> to satisfy execution of `package` goal
14:49:41.62 [DEBUG] Launching 1 roots (poll=false).
14:49:41.62 [DEBUG] Completed: Find targets from input specs
14:49:41.63 [DEBUG] Completed: Find all code to be published in the distribution
14:49:41.63 [DEBUG] Completed: pants.backend.python.util_rules.python_sources.prepare_python_sources
14:49:41.63 [DEBUG] Completed: pants.backend.python.util_rules.python_sources.prepare_python_sources
14:49:41.64 [DEBUG] Completed: pants.backend.python.util_rules.python_sources.strip_python_sources
14:49:41.64 [DEBUG] Completed: pants.backend.python.util_rules.python_sources.strip_python_sources
14:49:41.64 [DEBUG] Running Get git tags under semaphore with concurrency id: 1
14:49:41.64 [DEBUG] spawned local process as Some(65314) for Process { argv: ["/usr/bin/git", "tag", "-l", "gh-web*", "--sort=-v:refname"], env: {"GIT_DIR": "/Users/dmistry/repos/src/github.com/foo/python-libs/.git", "GIT_WORK_TREE": "/Users/dmistry/repos/src/github.com/foo/python-libs", "LANG": "en_US.UTF-8"}, working_directory: None, input_files: Digest { hash: Fingerprint<e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855>, size_bytes: 0 }, output_files: {}, output_directories: {}, timeout: None, execution_slot_variable: None, description: "Get git tags", level: Trace, append_only_caches: {}, jdk_home: None, platform_constraint: None, is_nailgunnable: false, cache_scope: Never }
14:49:41.65 [DEBUG] Completed: (Waiting) Get git tags
14:49:41.65 [DEBUG] Running Searching for `bash` on PATH=/usr/bin:/bin:/usr/local/bin under semaphore with concurrency id: 2
14:49:41.65 [DEBUG] Obtaining exclusive spawn lock for process with argv ["./find_binary.sh", "bash"] since we materialized its executable RelativePath("find_binary.sh").
14:49:41.65 [DEBUG] spawned local process as Some(65315) for Process { argv: ["./find_binary.sh", "bash"], env: {"PATH": "/usr/bin:/bin:/usr/local/bin"}, working_directory: None, input_files: Digest { hash: Fingerprint<124495cfdd1160d88a797da1b5de65f0b9d57642b553d7ff5195d5375411b492>, size_bytes: 91 }, output_files: {}, output_directories: {}, timeout: None, execution_slot_variable: None, description: "Searching for `bash` on PATH=/usr/bin:/bin:/usr/local/bin", level: Debug, append_only_caches: {}, jdk_home: None, platform_constraint: None, is_nailgunnable: false, cache_scope: PerRestart }
14:49:41.73 [DEBUG] Completed: Searching for `bash` on PATH=/usr/bin:/bin:/usr/local/bin
14:49:41.73 [DEBUG] Completed: (Waiting) Searching for `bash` on PATH=/usr/bin:/bin:/usr/local/bin
14:49:41.73 [DEBUG] Running Test binary /bin/bash. under semaphore with concurrency id: 3
14:49:41.73 [DEBUG] spawned local process as Some(65317) for Process { argv: ["/bin/bash", "--version"], env: {}, working_directory: None, input_files: Digest { hash: Fingerprint<e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855>, size_bytes: 0 }, output_files: {}, output_directories: {}, timeout: None, execution_slot_variable: None, description: "Test binary /bin/bash.", level: Debug, append_only_caches: {}, jdk_home: None, platform_constraint: None, is_nailgunnable: false, cache_scope: PerRestart }
14:49:41.73 [DEBUG] Completed: Test binary /bin/bash.
14:49:41.73 [DEBUG] Completed: (Waiting) Test binary /bin/bash.
14:49:41.74 [DEBUG] Completed: Finding the `bash` binary
14:49:41.74 [DEBUG] Completed: Finding the `bash` binary
14:49:41.74 [DEBUG] Running Searching for `python2` on PATH=/usr/local/bin:/usr/local/Cellar/pyenv-virtualenv/1.1.5/shims:/Users/dmistry/.pyenv/shims:/usr/local/opt/openssl/bin:/usr/local/bin/aws_completer:/usr/bin:/bin:/usr/sbin:/sbin:/usr/local/munki:/Users/dmistry/repos//bin:/Library/Java/JavaVirtualMachines/adoptopenjdk-8.jdk/Contents/Home/bin:/Users/dmistry/repos/src/github.com/foo/dockhub/bin under semaphore with concurrency id: 4
14:49:41.74 [DEBUG] Running Searching for `python` on PATH=/usr/local/bin:/usr/local/Cellar/pyenv-virtualenv/1.1.5/shims:/Users/dmistry/.pyenv/shims:/usr/local/opt/openssl/bin:/usr/local/bin/aws_completer:/usr/bin:/bin:/usr/sbin:/sbin:/usr/local/munki:/Users/dmistry/repos//bin:/Library/Java/JavaVirtualMachines/adoptopenjdk-8.jdk/Contents/Home/bin:/Users/dmistry/repos/src/github.com/foo/dockhub/bin under semaphore with concurrency id: 5
14:49:41.74 [DEBUG] Running Searching for `python3` on PATH=/usr/local/bin:/usr/local/Cellar/pyenv-virtualenv/1.1.5/shims:/Users/dmistry/.pyenv/shims:/usr/local/opt/openssl/bin:/usr/local/bin/aws_completer:/usr/bin:/bin:/usr/sbin:/sbin:/usr/local/munki:/Users/dmistry/repos//bin:/Library/Java/JavaVirtualMachines/adoptopenjdk-8.jdk/Contents/Home/bin:/Users/dmistry/repos/src/github.com/foo/dockhub/bin under semaphore with concurrency id: 6
14:49:41.74 [DEBUG] Obtaining exclusive spawn lock for process with argv ["./find_binary.sh", "python3"] since we materialized its executable RelativePath("find_binary.sh").
14:49:41.74 [DEBUG] Obtaining exclusive spawn lock for process with argv ["./find_binary.sh", "python2"] since we materialized its executable RelativePath("find_binary.sh").
14:49:41.74 [DEBUG] Obtaining exclusive spawn lock for process with argv ["./find_binary.sh", "python"] since we materialized its executable RelativePath("find_binary.sh").
14:49:41.74 [DEBUG] spawned local process as Some(65318) for Process { argv: ["./find_binary.sh", "python3"], env: {"PATH": "/usr/local/bin:/usr/local/Cellar/pyenv-virtualenv/1.1.5/shims:/Users/dmistry/.pyenv/shims:/usr/local/opt/openssl/bin:/usr/local/bin/aws_completer:/usr/bin:/bin:/usr/sbin:/sbin:/usr/local/munki:/Users/dmistry/repos//bin:/Library/Java/JavaVirtualMachines/adoptopenjdk-8.jdk/Contents/Home/bin:/Users/dmistry/repos/src/github.com/foo/dockhub/bin"}, working_directory: None, input_files: Digest { hash: Fingerprint<3730f33b117aecdf01511ba805e9a7ebd4123e9beff52dff5d42fb0463d957c2>, size_bytes: 91 }, output_files: {}, output_directories: {}, timeout: None, execution_slot_variable: None, description: "Searching for `python3` on PATH=/usr/local/bin:/usr/local/Cellar/pyenv-virtualenv/1.1.5/shims:/Users/dmistry/.pyenv/shims:/usr/local/opt/openssl/bin:/usr/local/bin/aws_completer:/usr/bin:/bin:/usr/sbin:/sbin:/usr/local/munki:/Users/dmistry/repos//bin:/Library/Java/JavaVirtualMachines/adoptopenjdk-8.jdk/Contents/Home/bin:/Users/dmistry/repos/src/github.com/foo/dockhub/bin", level: Debug, append_only_caches: {}, jdk_home: None, platform_constraint: None, is_nailgunnable: false, cache_scope: PerRestart }
14:49:41.74 [DEBUG] spawned local process as Some(65319) for Process { argv: ["./find_binary.sh", "python2"], env: {"PATH": "/usr/local/bin:/usr/local/Cellar/pyenv-virtualenv/1.1.5/shims:/Users/dmistry/.pyenv/shims:/usr/local/opt/openssl/bin:/usr/local/bin/aws_completer:/usr/bin:/bin:/usr/sbin:/sbin:/usr/local/munki:/Users/dmistry/repos//bin:/Library/Java/JavaVirtualMachines/adoptopenjdk-8.jdk/Contents/Home/bin:/Users/dmistry/repos/src/github.com/foo/dockhub/bin"}, working_directory: None, input_files: Digest { hash: Fingerprint<3730f33b117aecdf01511ba805e9a7ebd4123e9beff52dff5d42fb0463d957c2>, size_bytes: 91 }, output_files: {}, output_directories: {}, timeout: None, execution_slot_variable: None, description: "Searching for `python2` on PATH=/usr/local/bin:/usr/local/Cellar/pyenv-virtualenv/1.1.5/shims:/Users/dmistry/.pyenv/shims:/usr/local/opt/openssl/bin:/usr/local/bin/aws_completer:/usr/bin:/bin:/usr/sbin:/sbin:/usr/local/munki:/Users/dmistry/repos//bin:/Library/Java/JavaVirtualMachines/adoptopenjdk-8.jdk/Contents/Home/bin:/Users/dmistry/repos/src/github.com/foo/dockhub/bin", level: Debug, append_only_caches: {}, jdk_home: None, platform_constraint: None, is_nailgunnable: false, cache_scope: PerRestart }
14:49:41.74 [DEBUG] spawned local process as Some(65320) for Process { argv: ["./find_binary.sh", "python"], env: {"PATH": "/usr/local/bin:/usr/local/Cellar/pyenv-virtualenv/1.1.5/shims:/Users/dmistry/.pyenv/shims:/usr/local/opt/openssl/bin:/usr/local/bin/aws_completer:/usr/bin:/bin:/usr/sbin:/sbin:/usr/local/munki:/Users/dmistry/repos//bin:/Library/Java/JavaVirtualMachines/adoptopenjdk-8.jdk/Contents/Home/bin:/Users/dmistry/repos/src/github.com/foo/dockhub/bin"}, working_directory: None, input_files: Digest { hash: Fingerprint<3730f33b117aecdf01511ba805e9a7ebd4123e9beff52dff5d42fb0463d957c2>, size_bytes: 91 }, output_files: {}, output_directories: {}, timeout: None, execution_slot_variable: None, description: "Searching for `python` on PATH=/usr/local/bin:/usr/local/Cellar/pyenv-virtualenv/1.1.5/shims:/Users/dmistry/.pyenv/shims:/usr/local/opt/openssl/bin:/usr/local/bin/aws_completer:/usr/bin:/bin:/usr/sbin:/sbin:/usr/local/munki:/Users/dmistry/repos//bin:/Library/Java/JavaVirtualMachines/adoptopenjdk-8.jdk/Contents/Home/bin:/Users/dmistry/repos/src/github.com/foo/dockhub/bin", level: Debug, append_only_caches: {}, jdk_home: None, platform_constraint: None, is_nailgunnable: false, cache_scope: PerRestart }
14:49:41.79 [DEBUG] Completed: Searching for `python3` on PATH=/usr/local/bin:/usr/local/Cellar/pyenv-virtualenv/1.1.5/shims:/Users/dmistry/.pyenv/shims:/usr/local/opt/openssl/bin:/usr/local/bin/aws_completer:/usr/bin:/bin:/usr/sbi... (181 characters truncated)
14:49:41.79 [DEBUG] Completed: (Waiting) Searching for `python3` on PATH=/usr/local/bin:/usr/local/Cellar/pyenv-virtualenv/1.1.5/shims:/Users/dmistry/.pyenv/shims:/usr/local/opt/openssl/bin:/usr/local/bin/aws_completer:/usr/bin:/bi... (191 characters truncated)
14:49:41.79 [DEBUG] Running Test binary /usr/local/bin/python3. under semaphore with concurrency id: 7
14:49:41.79 [DEBUG] Running Test binary /usr/bin/python3. under semaphore with concurrency id: 8
14:49:41.79 [DEBUG] Running Test binary /Users/dmistry/.pyenv/shims/python3. under semaphore with concurrency id: 9
14:49:41.79 [DEBUG] spawned local process as Some(65322) for Process { argv: ["/usr/local/bin/python3", "-c", "import sys\n\nmajor, minor = sys.version_info[:2]\nif (major, minor) != (2, 7) and not (major == 3 and minor >= 5):\n    sys.exit(1)\n\nimport hashlib\nhasher = hashlib.sha256()\nwith open(sys.executable, \"rb\") as fp:\n    for chunk in iter(lambda: fp.read(8192), b\"\"):\n        hasher.update(chunk)\nsys.stdout.write(hasher.hexdigest())\n"], env: {}, working_directory: None, input_files: Digest { hash: Fingerprint<e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855>, size_bytes: 0 }, output_files: {}, output_directories: {}, timeout: None, execution_slot_variable: None, description: "Test binary /usr/local/bin/python3.", level: Debug, append_only_caches: {}, jdk_home: None, platform_constraint: None, is_nailgunnable: false, cache_scope: PerRestart }
14:49:41.79 [DEBUG] spawned local process as Some(65323) for Process { argv: ["/usr/bin/python3", "-c", "import sys\n\nmajor, minor = sys.version_info[:2]\nif (major, minor) != (2, 7) and not (major == 3 and minor >= 5):\n    sys.exit(1)\n\nimport hashlib\nhasher = hashlib.sha256()\nwith open(sys.executable, \"rb\") as fp:\n    for chunk in iter(lambda: fp.read(8192), b\"\"):\n        hasher.update(chunk)\nsys.stdout.write(hasher.hexdigest())\n"], env: {}, working_directory: None, input_files: Digest { hash: Fingerprint<e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855>, size_bytes: 0 }, output_files: {}, output_directories: {}, timeout: None, execution_slot_variable: None, description: "Test binary /usr/bin/python3.", level: Debug, append_only_caches: {}, jdk_home: None, platform_constraint: None, is_nailgunnable: false, cache_scope: PerRestart }
14:49:41.79 [DEBUG] spawned local process as Some(65324) for Process { argv: ["/Users/dmistry/.pyenv/shims/python3", "-c", "import sys\n\nmajor, minor = sys.version_info[:2]\nif (major, minor) != (2, 7) and not (major == 3 and minor >= 5):\n    sys.exit(1)\n\nimport hashlib\nhasher = hashlib.sha256()\nwith open(sys.executable, \"rb\") as fp:\n    for chunk in iter(lambda: fp.read(8192), b\"\"):\n        hasher.update(chunk)\nsys.stdout.write(hasher.hexdigest())\n"], env: {}, working_directory: None, input_files: Digest { hash: Fingerprint<e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855>, size_bytes: 0 }, output_files: {}, output_directories: {}, timeout: None, execution_slot_variable: None, description: "Test binary /Users/dmistry/.pyenv/shims/python3.", level: Debug, append_only_caches: {}, jdk_home: None, platform_constraint: None, is_nailgunnable: false, cache_scope: PerRestart }
14:49:41.80 [DEBUG] Completed: Test binary /Users/dmistry/.pyenv/shims/python3.
14:49:41.80 [DEBUG] Completed: (Waiting) Test binary /Users/dmistry/.pyenv/shims/python3.
14:49:41.82 [DEBUG] Completed: Searching for `python2` on PATH=/usr/local/bin:/usr/local/Cellar/pyenv-virtualenv/1.1.5/shims:/Users/dmistry/.pyenv/shims:/usr/local/opt/openssl/bin:/usr/local/bin/aws_completer:/usr/bin:/bin:/usr/sbi... (181 characters truncated)
14:49:41.82 [DEBUG] Completed: (Waiting) Searching for `python2` on PATH=/usr/local/bin:/usr/local/Cellar/pyenv-virtualenv/1.1.5/shims:/Users/dmistry/.pyenv/shims:/usr/local/opt/openssl/bin:/usr/local/bin/aws_completer:/usr/bin:/bi... (191 characters truncated)
14:49:41.82 [DEBUG] Running Test binary /Users/dmistry/.pyenv/shims/python2. under semaphore with concurrency id: 11
14:49:41.82 [DEBUG] Running Test binary /usr/bin/python2. under semaphore with concurrency id: 10
14:49:41.82 [DEBUG] spawned local process as Some(65326) for Process { argv: ["/Users/dmistry/.pyenv/shims/python2", "-c", "import sys\n\nmajor, minor = sys.version_info[:2]\nif (major, minor) != (2, 7) and not (major == 3 and minor >= 5):\n    sys.exit(1)\n\nimport hashlib\nhasher = hashlib.sha256()\nwith open(sys.executable, \"rb\") as fp:\n    for chunk in iter(lambda: fp.read(8192), b\"\"):\n        hasher.update(chunk)\nsys.stdout.write(hasher.hexdigest())\n"], env: {}, working_directory: None, input_files: Digest { hash: Fingerprint<e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855>, size_bytes: 0 }, output_files: {}, output_directories: {}, timeout: None, execution_slot_variable: None, description: "Test binary /Users/dmistry/.pyenv/shims/python2.", level: Debug, append_only_caches: {}, jdk_home: None, platform_constraint: None, is_nailgunnable: false, cache_scope: PerRestart }
14:49:41.82 [DEBUG] spawned local process as Some(65327) for Process { argv: ["/usr/bin/python2", "-c", "import sys\n\nmajor, minor = sys.version_info[:2]\nif (major, minor) != (2, 7) and not (major == 3 and minor >= 5):\n    sys.exit(1)\n\nimport hashlib\nhasher = hashlib.sha256()\nwith open(sys.executable, \"rb\") as fp:\n    for chunk in iter(lambda: fp.read(8192), b\"\"):\n        hasher.update(chunk)\nsys.stdout.write(hasher.hexdigest())\n"], env: {}, working_directory: None, input_files: Digest { hash: Fingerprint<e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855>, size_bytes: 0 }, output_files: {}, output_directories: {}, timeout: None, execution_slot_variable: None, description: "Test binary /usr/bin/python2.", level: Debug, append_only_caches: {}, jdk_home: None, platform_constraint: None, is_nailgunnable: false, cache_scope: PerRestart }
14:49:41.82 [DEBUG] Completed: Test binary /Users/dmistry/.pyenv/shims/python2.
14:49:41.82 [DEBUG] Completed: (Waiting) Test binary /Users/dmistry/.pyenv/shims/python2.
14:49:41.85 [DEBUG] Completed: Test binary /usr/local/bin/python3.
14:49:41.85 [DEBUG] Completed: (Waiting) Test binary /usr/local/bin/python3.
14:49:41.85 [DEBUG] Completed: Searching for `python` on PATH=/usr/local/bin:/usr/local/Cellar/pyenv-virtualenv/1.1.5/shims:/Users/dmistry/.pyenv/shims:/usr/local/opt/openssl/bin:/usr/local/bin/aws_completer:/usr/bin:/bin:/usr/sbin... (180 characters truncated)
14:49:41.85 [DEBUG] Completed: (Waiting) Searching for `python` on PATH=/usr/local/bin:/usr/local/Cellar/pyenv-virtualenv/1.1.5/shims:/Users/dmistry/.pyenv/shims:/usr/local/opt/openssl/bin:/usr/local/bin/aws_completer:/usr/bin:/bin... (190 characters truncated)
14:49:41.85 [DEBUG] Running Test binary /usr/bin/python. under semaphore with concurrency id: 12
14:49:41.85 [DEBUG] Running Test binary /Users/dmistry/.pyenv/shims/python. under semaphore with concurrency id: 1
14:49:41.85 [DEBUG] spawned local process as Some(65329) for Process { argv: ["/usr/bin/python", "-c", "import sys\n\nmajor, minor = sys.version_info[:2]\nif (major, minor) != (2, 7) and not (major == 3 and minor >= 5):\n    sys.exit(1)\n\nimport hashlib\nhasher = hashlib.sha256()\nwith open(sys.executable, \"rb\") as fp:\n    for chunk in iter(lambda: fp.read(8192), b\"\"):\n        hasher.update(chunk)\nsys.stdout.write(hasher.hexdigest())\n"], env: {}, working_directory: None, input_files: Digest { hash: Fingerprint<e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855>, size_bytes: 0 }, output_files: {}, output_directories: {}, timeout: None, execution_slot_variable: None, description: "Test binary /usr/bin/python.", level: Debug, append_only_caches: {}, jdk_home: None, platform_constraint: None, is_nailgunnable: false, cache_scope: PerRestart }
14:49:41.86 [DEBUG] spawned local process as Some(65330) for Process { argv: ["/Users/dmistry/.pyenv/shims/python", "-c", "import sys\n\nmajor, minor = sys.version_info[:2]\nif (major, minor) != (2, 7) and not (major == 3 and minor >= 5):\n    sys.exit(1)\n\nimport hashlib\nhasher = hashlib.sha256()\nwith open(sys.executable, \"rb\") as fp:\n    for chunk in iter(lambda: fp.read(8192), b\"\"):\n        hasher.update(chunk)\nsys.stdout.write(hasher.hexdigest())\n"], env: {}, working_directory: None, input_files: Digest { hash: Fingerprint<e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855>, size_bytes: 0 }, output_files: {}, output_directories: {}, timeout: None, execution_slot_variable: None, description: "Test binary /Users/dmistry/.pyenv/shims/python.", level: Debug, append_only_caches: {}, jdk_home: None, platform_constraint: None, is_nailgunnable: false, cache_scope: PerRestart }
14:49:41.86 [DEBUG] Completed: Test binary /Users/dmistry/.pyenv/shims/python.
14:49:41.86 [DEBUG] Completed: (Waiting) Test binary /Users/dmistry/.pyenv/shims/python.
14:49:41.88 [DEBUG] Completed: Test binary /usr/bin/python3.
14:49:41.88 [DEBUG] Completed: (Waiting) Test binary /usr/bin/python3.
14:49:42.06 [DEBUG] Completed: Test binary /usr/bin/python2.
14:49:42.06 [DEBUG] Completed: (Waiting) Test binary /usr/bin/python2.
14:49:42.08 [DEBUG] Completed: Test binary /usr/bin/python.
14:49:42.08 [DEBUG] Completed: (Waiting) Test binary /usr/bin/python.
14:49:42.08 [DEBUG] Completed: Find Python interpreter to bootstrap PEX - Selected /usr/bin/python to bootstrap PEXes with.
14:49:42.08 [DEBUG] Completed: Downloading: DownloadFile(url='https://github.com/pantsbuild/pex/releases/download/v2.1.35/pex', expected_digest=FileDigest(fingerprint='3b1c97ebd79a8b650c81f0afbdbefef17c3d1a128219a8e95b5f35c2c9dfd53... (37 characters truncated)
14:49:42.09 [DEBUG] Running Searching for `unzip` on PATH=/usr/bin:/bin:/usr/local/bin under semaphore with concurrency id: 2
14:49:42.09 [DEBUG] Running Searching for `tar` on PATH=/usr/bin:/bin:/usr/local/bin under semaphore with concurrency id: 3
14:49:42.09 [DEBUG] Obtaining exclusive spawn lock for process with argv ["./find_binary.sh", "unzip"] since we materialized its executable RelativePath("find_binary.sh").
14:49:42.09 [DEBUG] Obtaining exclusive spawn lock for process with argv ["./find_binary.sh", "tar"] since we materialized its executable RelativePath("find_binary.sh").
14:49:42.09 [DEBUG] spawned local process as Some(65331) for Process { argv: ["./find_binary.sh", "unzip"], env: {"PATH": "/usr/bin:/bin:/usr/local/bin"}, working_directory: None, input_files: Digest { hash: Fingerprint<3730f33b117aecdf01511ba805e9a7ebd4123e9beff52dff5d42fb0463d957c2>, size_bytes: 91 }, output_files: {}, output_directories: {}, timeout: None, execution_slot_variable: None, description: "Searching for `unzip` on PATH=/usr/bin:/bin:/usr/local/bin", level: Debug, append_only_caches: {}, jdk_home: None, platform_constraint: None, is_nailgunnable: false, cache_scope: PerRestart }
14:49:42.09 [DEBUG] spawned local process as Some(65332) for Process { argv: ["./find_binary.sh", "tar"], env: {"PATH": "/usr/bin:/bin:/usr/local/bin"}, working_directory: None, input_files: Digest { hash: Fingerprint<3730f33b117aecdf01511ba805e9a7ebd4123e9beff52dff5d42fb0463d957c2>, size_bytes: 91 }, output_files: {}, output_directories: {}, timeout: None, execution_slot_variable: None, description: "Searching for `tar` on PATH=/usr/bin:/bin:/usr/local/bin", level: Debug, append_only_caches: {}, jdk_home: None, platform_constraint: None, is_nailgunnable: false, cache_scope: PerRestart }
14:49:42.14 [DEBUG] Completed: Searching for `unzip` on PATH=/usr/bin:/bin:/usr/local/bin
14:49:42.14 [DEBUG] Completed: (Waiting) Searching for `unzip` on PATH=/usr/bin:/bin:/usr/local/bin
14:49:42.14 [DEBUG] Running Test binary /usr/bin/unzip. under semaphore with concurrency id: 6
14:49:42.14 [DEBUG] spawned local process as Some(65334) for Process { argv: ["/usr/bin/unzip", "-v"], env: {}, working_directory: None, input_files: Digest { hash: Fingerprint<e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855>, size_bytes: 0 }, output_files: {}, output_directories: {}, timeout: None, execution_slot_variable: None, description: "Test binary /usr/bin/unzip.", level: Debug, append_only_caches: {}, jdk_home: None, platform_constraint: None, is_nailgunnable: false, cache_scope: PerRestart }
14:49:42.14 [DEBUG] Completed: Test binary /usr/bin/unzip.
14:49:42.14 [DEBUG] Completed: (Waiting) Test binary /usr/bin/unzip.
14:49:42.14 [DEBUG] Completed: Finding the `unzip` binary
14:49:42.16 [DEBUG] Completed: Searching for `tar` on PATH=/usr/bin:/bin:/usr/local/bin
14:49:42.16 [DEBUG] Completed: (Waiting) Searching for `tar` on PATH=/usr/bin:/bin:/usr/local/bin
14:49:42.16 [DEBUG] Running Test binary /usr/bin/tar. under semaphore with concurrency id: 9
14:49:42.16 [DEBUG] spawned local process as Some(65336) for Process { argv: ["/usr/bin/tar", "--version"], env: {}, working_directory: None, input_files: Digest { hash: Fingerprint<e3b0c44298fc1c149afbf4c8996fb92427ae41e4649b934ca495991b7852b855>, size_bytes: 0 }, output_files: {}, output_directories: {}, timeout: None, execution_slot_variable: None, description: "Test binary /usr/bin/tar.", level: Debug, append_only_caches: {}, jdk_home: None, platform_constraint: None, is_nailgunnable: false, cache_scope: PerRestart }
14:49:42.16 [DEBUG] Completed: Test binary /usr/bin/tar.
14:49:42.16 [DEBUG] Completed: (Waiting) Test binary /usr/bin/tar.
14:49:42.16 [DEBUG] Completed: Finding the `tar` binary
14:49:42.16 [DEBUG] Completed: Extracting an archive file
14:49:42.16 [DEBUG] Completed: pants.core.util_rules.external_tool.download_external_tool
14:49:42.16 [DEBUG] Running Find interpreter for constraints:  under semaphore with concurrency id: 4
14:49:42.17 [DEBUG] spawned local process as Some(65337) for Process { argv: ["/usr/bin/python", "./pex", "--python-path", "/usr/local/bin:/usr/local/Cellar/pyenv-virtualenv/1.1.5/shims:/Users/dmistry/.pyenv/shims:/usr/local/opt/openssl/bin:/usr/local/opt/openssl/bin:/usr/local/bin/aws_completer:/usr/local/bin:/usr/bin:/bin:/usr/sbin:/sbin:/usr/local/munki:/usr/local/Cellar/pyenv-virtualenv/1.1.5/shims:/Users/dmistry/.pyenv/shims:/usr/local/opt/openssl/bin:/usr/local/bin/aws_completer:/Users/dmistry/repos//bin:/Library/Java/JavaVirtualMachines/adoptopenjdk-8.jdk/Contents/Home/bin:/Users/dmistry/repos/src/github.com/foo/dockhub/bin:/Users/dmistry/repos//bin:/Library/Java/JavaVirtualMachines/adoptopenjdk-8.jdk/Contents/Home/bin:/Users/dmistry/repos/src/github.com/foo/dockhub/bin", "--tmpdir", ".tmp", "--", "-c", "import hashlib, os, sys\n\npython = os.path.realpath(sys.executable)\nprint(python)\n\nhasher = hashlib.sha256()\nwith open(python, \"rb\") as fp:\n  for chunk in iter(lambda: fp.read(8192), b\"\"):\n      hasher.update(chunk)\nprint(hasher.hexdigest())\n"], env: {"CPPFLAGS": "", "LANG": "en_US.UTF-8", "LDFLAGS": "", "PATH": "/usr/local/bin:/usr/local/Cellar/pyenv-virtualenv/1.1.5/shims:/Users/dmistry/.pyenv/shims:/usr/local/opt/openssl/bin:/usr/local/bin/aws_completer:/usr/bin:/bin:/usr/sbin:/sbin:/usr/local/munki:/Users/dmistry/repos//bin:/Library/Java/JavaVirtualMachines/adoptopenjdk-8.jdk/Contents/Home/bin:/Users/dmistry/repos/src/github.com/foo/dockhub/bin", "PEX_IGNORE_RCFILES": "true", "PEX_INHERIT_PATH": "false", "PEX_PYTHON_PATH": "/usr/local/bin:/usr/local/Cellar/pyenv-virtualenv/1.1.5/shims:/Users/dmistry/.pyenv/shims:/usr/local/opt/openssl/bin:/usr/local/opt/openssl/bin:/usr/local/bin/aws_completer:/usr/local/bin:/usr/bin:/bin:/usr/sbin:/sbin:/usr/local/munki:/usr/local/Cellar/pyenv-virtualenv/1.1.5/shims:/Users/dmistry/.pyenv/shims:/usr/local/opt/openssl/bin:/usr/local/bin/aws_completer:/Users/dmistry/repos//bin:/Library/Java/JavaVirtualMachines/adoptopenjdk-8.jdk/Contents/Home/bin:/Users/dmistry/repos/src/github.com/foo/dockhub/bin:/Users/dmistry/repos//bin:/Library/Java/JavaVirtualMachines/adoptopenjdk-8.jdk/Contents/Home/bin:/Users/dmistry/repos/src/github.com/foo/dockhub/bin", "PEX_ROOT": ".cache/pex_root"}, working_directory: None, input_files: Digest { hash: Fingerprint<074053d775ea7bf2d0ab41993d1e47d8819e70c562b3bfabc15a0a6080b07ee0>, size_bytes: 158 }, output_files: {}, output_directories: {}, timeout: None, execution_slot_variable: None, description: "Find interpreter for constraints: ", level: Debug, append_only_caches: {CacheName("pex_root"): CacheDest(".cache/pex_root")}, jdk_home: None, platform_constraint: None, is_nailgunnable: false, cache_scope: PerRestart }
14:49:47.76 [DEBUG] Completed: Find interpreter for constraints:
14:49:47.76 [DEBUG] Completed: (Waiting) Find interpreter for constraints:
14:49:47.76 [DEBUG] Completed: Find Python interpreter for constraints - Selected /System/Library/Frameworks/Python.framework/Versions/2.7/Resources/Python.app/Contents/MacOS/Python to run PEXes with.
14:49:47.76 [DEBUG] Running Building setuptools.pex with 2 requirements: setuptools>=50.3.0,<54.0, wheel>=0.35.1,<0.37 under semaphore with concurrency id: 11
14:49:47.76 [DEBUG] spawned local process as Some(65828) for Process { argv: ["/System/Library/Frameworks/Python.framework/Versions/2.7/Resources/Python.app/Contents/MacOS/Python", "./pex", "--python-path", "/usr/local/bin:/usr/local/Cellar/pyenv-virtualenv/1.1.5/shims:/Users/dmistry/.pyenv/shims:/usr/local/opt/openssl/bin:/usr/local/opt/openssl/bin:/usr/local/bin/aws_completer:/usr/local/bin:/usr/bin:/bin:/usr/sbin:/sbin:/usr/local/munki:/usr/local/Cellar/pyenv-virtualenv/1.1.5/shims:/Users/dmistry/.pyenv/shims:/usr/local/opt/openssl/bin:/usr/local/bin/aws_completer:/Users/dmistry/repos//bin:/Library/Java/JavaVirtualMachines/adoptopenjdk-8.jdk/Contents/Home/bin:/Users/dmistry/repos/src/github.com/foo/dockhub/bin:/Users/dmistry/repos//bin:/Library/Java/JavaVirtualMachines/adoptopenjdk-8.jdk/Contents/Home/bin:/Users/dmistry/repos/src/github.com/foo/dockhub/bin", "--tmpdir", ".tmp", "--output-file", "setuptools.pex", "--no-pypi", "--index=https://pypi.org/simple/", "--resolver-version", "pip-2020-resolver", "--venv", "--seed", "--no-emit-warnings", "--jobs", "6", "--manylinux", "manylinux2014", "--sources-directory=source_files", "setuptools>=50.3.0,<54.0", "wheel>=0.35.1,<0.37"], env: {"CPPFLAGS": "", "LANG": "en_US.UTF-8", "LDFLAGS": "", "PATH": "/usr/local/bin:/usr/local/Cellar/pyenv-virtualenv/1.1.5/shims:/Users/dmistry/.pyenv/shims:/usr/local/opt/openssl/bin:/usr/local/bin/aws_completer:/usr/bin:/bin:/usr/sbin:/sbin:/usr/local/munki:/Users/dmistry/repos//bin:/Library/Java/JavaVirtualMachines/adoptopenjdk-8.jdk/Contents/Home/bin:/Users/dmistry/repos/src/github.com/foo/dockhub/bin", "PEX_IGNORE_RCFILES": "true", "PEX_INHERIT_PATH": "false", "PEX_ROOT": ".cache/pex_root"}, working_directory: None, input_files: Digest { hash: Fingerprint<2baba93c1865f618410beb18dfa4d31668336afd2e3cb479d7386f8c4caa894a>, size_bytes: 242 }, output_files: {RelativePath("setuptools.pex")}, output_directories: {}, timeout: None, execution_slot_variable: None, description: "Building setuptools.pex with 2 requirements: setuptools>=50.3.0,<54.0, wheel>=0.35.1,<0.37", level: Info, append_only_caches: {CacheName("pex_root"): CacheDest(".cache/pex_root")}, jdk_home: None, platform_constraint: Some(Darwin), is_nailgunnable: false, cache_scope: Successful }
14:49:50.42 [INFO] Completed: Building setuptools.pex with 2 requirements: setuptools>=50.3.0,<54.0, wheel>=0.35.1,<0.37
14:49:50.42 [DEBUG] Completed: (Waiting) Building setuptools.pex with 2 requirements: setuptools>=50.3.0,<54.0, wheel>=0.35.1,<0.37
14:49:50.42 [DEBUG] Completed: pants.backend.python.util_rules.pex.build_pex
14:49:50.42 [DEBUG] Completed: `package` goal
14:49:50.42 [DEBUG] computed 1 nodes in 8.804784 seconds. there are 236 total nodes.
14:49:50.42 [ERROR] Exception caught: (pants.engine.internals.scheduler.ExecutionError)
  File "/Users/dmistry/.cache/pants/setup/bootstrap-Darwin-x86_64/2.4.1_py38/lib/python3.8/site-packages/pants/bin/local_pants_runner.py", line 229, in _run_inner
    return self._perform_run(goals)
  File "/Users/dmistry/.cache/pants/setup/bootstrap-Darwin-x86_64/2.4.1_py38/lib/python3.8/site-packages/pants/bin/local_pants_runner.py", line 168, in _perform_run
    return self._perform_run_body(goals, poll=False)
  File "/Users/dmistry/.cache/pants/setup/bootstrap-Darwin-x86_64/2.4.1_py38/lib/python3.8/site-packages/pants/bin/local_pants_runner.py", line 185, in _perform_run_body
    return self.graph_session.run_goal_rules(
  File "/Users/dmistry/.cache/pants/setup/bootstrap-Darwin-x86_64/2.4.1_py38/lib/python3.8/site-packages/pants/init/engine_initializer.py", line 135, in run_goal_rules
    exit_code = self.scheduler_session.run_goal_rule(
  File "/Users/dmistry/.cache/pants/setup/bootstrap-Darwin-x86_64/2.4.1_py38/lib/python3.8/site-packages/pants/engine/internals/scheduler.py", line 530, in run_goal_rule
    self._raise_on_error([t for _, t in throws])
  File "/Users/dmistry/.cache/pants/setup/bootstrap-Darwin-x86_64/2.4.1_py38/lib/python3.8/site-packages/pants/engine/internals/scheduler.py", line 498, in _raise_on_error
    raise ExecutionError(

Exception message: 1 Exception encountered:

  ProcessExecutionFailure: Process 'Building setuptools.pex with 2 requirements: setuptools>=50.3.0,<54.0, wheel>=0.35.1,<0.37' failed with exit code 1.
stdout:

stderr:
ERROR: Could not find a version that satisfies the requirement setuptools<54.0,>=50.3.0
ERROR: No matching distribution found for setuptools<54.0,>=50.3.0
pid 65833 -> /System/Library/Frameworks/Python.framework/Versions/2.7/Resources/Python.app/Contents/MacOS/Python /Users/dmistry/.cache/pants/named_caches/pex_root/pip.pex/cf4106b4c7898b462f7c172dde686a9747103f1a --disable-pip-version-check --no-python-version-warning --exists-action a --use-feature 2020-resolver --isolated -q --cache-dir /Users/dmistry/.cache/pants/named_caches/pex_root --log /private/var/folders/z1/8_j4n7t17h15skx5y6h69whh0000gp/T/process-executionk4csgb/.tmp/tmprqwQBr/pip.log download --dest /private/var/folders/z1/8_j4n7t17h15skx5y6h69whh0000gp/T/process-executionk4csgb/.tmp/tmp1XJRCe/System.Library.Frameworks.Python.framework.Versions.2.7.Resources.Python.app.Contents.MacOS.Python setuptools>=50.3.0,<54.0 wheel>=0.35.1,<0.37 --index-url https://pypi.org/simple/ --retries 5 --timeout 15 exited with 1 and STDERR:
None



(Use --print-stacktrace to see more error details.)