Skip to content
This repository has been archived by the owner on Jun 18, 2019. It is now read-only.

python_runtime does not install pip on CentOS/RHEL 7 #35

Closed
tduzan-te opened this issue Jan 23, 2016 · 31 comments
Closed

python_runtime does not install pip on CentOS/RHEL 7 #35

tduzan-te opened this issue Jan 23, 2016 · 31 comments

Comments

@tduzan-te
Copy link

Test-case recipe only has the following inside

Berksfile

cookbook 'poise'
cookbook 'poise-languages'
cookbook 'poise-python'

metadata.rb

depends 'poise-python'

recipes/default.rb

python_runtime '2.7'

Logging in after a "kitchen converge" results in the following

[vagrant@default-centos-71 ~]$ which pip
/usr/bin/which: no pip in (/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/home/vagrant/.local/bin:/home/vagrant/bin)

This causes a subsequent python_package call to fail, but it is a silent failure which results in the recipe continuing and failing at a later point in time because the expected python tool was never installed so its command was unavailable.

Let me know if there's any additional info you need from me to help replicate this issue to resolve it. Thanks.

@gene1wood
Copy link

This also causes trying to install packages with the python_package resource to fail with this type of error message

  * python_package[requests] action install

    ================================================================================
    Error executing action `install` on resource 'python_package[requests]'
    ================================================================================

    Mixlib::ShellOut::ShellCommandFailed
    ------------------------------------
    Expected process to exit with [0], but received '1'
    ---- Begin output of ["/bin/python", "-m", "pip.__main__", "list"] ----
    STDOUT: 
    STDERR: /bin/python: No module named pip
    ---- End output of ["/bin/python", "-m", "pip.__main__", "list"] ----
    Ran ["/bin/python", "-m", "pip.__main__", "list"] returned 1

    Cookbook Trace:
    ---------------
    /root/.chef/local-mode-cache/cache/cookbooks/poise-languages/files/halite_gem/poise_languages/command/mixin.rb:201:in `tap'
    /root/.chef/local-mode-cache/cache/cookbooks/poise-languages/files/halite_gem/poise_languages/command/mixin.rb:201:in `language_command_shell_out!'
    /root/.chef/local-mode-cache/cache/cookbooks/poise-languages/files/halite_gem/poise_languages/command/mixin.rb:216:in `block in language_command_mixin'
    /root/.chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/resources/python_package.rb:263:in `pip_command'
    /root/.chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/resources/python_package.rb:158:in `check_package_versions'
    /root/.chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/resources/python_package.rb:144:in `load_current_resource'

    Resource Declaration:
    ---------------------
    # In /root/.chef/local-mode-cache/cache/cookbooks/example/recipes/media.rb

     14: python_package 'requests'
     15: 

    Compiled Resource:
    ------------------
    # Declared in /root/.chef/local-mode-cache/cache/cookbooks/example/recipes/media.rb:14:in `from_file'

    python_package("requests") do
      action [:install]
      retries 0
      retry_delay 2
      default_guard_interpreter :default
      package_name "requests"
      declared_type :python_package
      cookbook_name "example"
      recipe_name "media"
      parent_python nil
    end


Running handlers:
Running handlers complete
Chef Client failed. 1 resources updated in 16 seconds

@coderanger
Copy link
Member

What versions of poise-python and poise-languages are being used?

@gene1wood
Copy link

poise-python : 1.2.1
poise-languages: 1.3.2

@coderanger
Copy link
Member

If you run with -l debug you should see some output related to a python_runtime_pip resources, specifically where it says it is running /usr/bin/python -m pip.__main__ --version. Is there any output there and/or does it run other commands (like the get-pip.py script) after that? I should definitely add a smattering of debug output to that process in the morning.

@et304383
Copy link

Encountering the exact same issue. This is a blocker. Happens on Amazon Linux.

@coderanger
Copy link
Member

@eric-tucker Same question, what debugging output do you see?

@et304383
Copy link

A lot. You're going to have to be more specific in what you're looking for.

@gene1wood
Copy link

I'll try to assemble the debug output today (haven't had time yet)

@coderanger
Copy link
Member

As mentioned above, look for output related to the python_runtime_pip resource and the after that you should see it running /usr/bin/python -m pip.__main__ --version as a command, and the output will be echo'd to the terminal. I need that as well as whatever other commands it runs after that.

@et304383
Copy link

Recipe: poise-python::default
  * python_runtime[2] action install[2016-01-27T15:56:46-04:00] INFO: Processing python_runtime[2] action install (poise-python::default line 20)
[2016-01-27T15:56:46-04:00] DEBUG: Providers for generic python_runtime resource enabled on node include: [PoisePython::PythonProviders::System]
[2016-01-27T15:56:46-04:00] DEBUG: Provider for action install on resource python_runtime[2] is PoisePython::PythonProviders::System
[2016-01-27T15:56:46-04:00] DEBUG: Caught InvalidVersionConstraint. This means that a key in value_for_platform cannot be interpreted as a Chef::VersionConstraint.
[2016-01-27T15:56:46-04:00] DEBUG: 'default' (Chef::Exceptions::InvalidVersionConstraint)
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/version_constraint.rb:113:in `parse'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/version_constraint.rb:36:in `initialize'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/dsl/platform_introspection.rb:79:in `new'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/dsl/platform_introspection.rb:79:in `block in match_versions'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/dsl/platform_introspection.rb:77:in `each'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/dsl/platform_introspection.rb:77:in `match_versions'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/dsl/platform_introspection.rb:54:in `value_for_node'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/dsl/platform_introspection.rb:149:in `value_for_platform'
/etc/chef/local-mode-cache/cache/cookbooks/poise-languages/files/halite_gem/poise_languages/system/mixin.rb:72:in `system_package_name'
/etc/chef/local-mode-cache/cache/cookbooks/poise-languages/files/halite_gem/poise_languages/system/mixin.rb:32:in `install_system_packages'
/etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/python_providers/system.rb:55:in `install_python'
/etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/python_providers/base.rb:45:in `block in action_install'
/etc/chef/local-mode-cache/cache/cookbooks/poise/files/halite_gem/poise/helpers/subcontext_block.rb:54:in `instance_eval'
/etc/chef/local-mode-cache/cache/cookbooks/poise/files/halite_gem/poise/helpers/subcontext_block.rb:54:in `subcontext_block'
/etc/chef/local-mode-cache/cache/cookbooks/poise/files/halite_gem/poise/helpers/notifying_block.rb:67:in `notifying_block'
/etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/python_providers/base.rb:44:in `action_install'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/provider.rb:144:in `run_action'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource.rb:585:in `run_action'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:49:in `run_action'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:81:in `block (2 levels) in converge'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:81:in `each'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:81:in `block in converge'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/resource_list.rb:83:in `block in execute_each_resource'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:116:in `call'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:116:in `call_iterator_block'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:85:in `step'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:104:in `iterate'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:55:in `each_with_index'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/resource_list.rb:81:in `execute_each_resource'
/opt/chefdk/embedded/lib/ruby/2.1.0/forwardable.rb:183:in `execute_each_resource'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:80:in `converge'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/client.rb:653:in `block in converge'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/client.rb:648:in `catch'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/client.rb:648:in `converge'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/client.rb:687:in `converge_and_save'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/client.rb:269:in `run'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:270:in `block in fork_chef_client'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:258:in `fork'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:258:in `fork_chef_client'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:224:in `block in run_chef_client'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/local_mode.rb:44:in `with_server_connectivity'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:212:in `run_chef_client'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application/client.rb:408:in `block in interval_run_chef_client'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application/client.rb:398:in `loop'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application/client.rb:398:in `interval_run_chef_client'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application/client.rb:388:in `run_application'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:60:in `run'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/bin/chef-client:26:in `<top (required)>'
/usr/bin/chef-client:54:in `load'
/usr/bin/chef-client:54:in `<main>'
[2016-01-27T15:56:46-04:00] DEBUG: Resources for generic poise_languages_system resource enabled on node include: [PoiseLanguages::System::Resource]
[2016-01-27T15:56:46-04:00] DEBUG: Resource for poise_languages_system is PoiseLanguages::System::Resource

    * poise_languages_system[python27] action install[2016-01-27T15:56:46-04:00] INFO: Processing poise_languages_system[python27] action install (/etc/chef/local-mode-cache/cache/cookbooks/poise-languages/files/halite_gem/poise_languages/system/mixin.rb line 32)
[2016-01-27T15:56:46-04:00] DEBUG: Providers for generic poise_languages_system resource enabled on node include: [PoiseLanguages::System::Provider]
[2016-01-27T15:56:46-04:00] DEBUG: Provider for action install on resource poise_languages_system[python27] is PoiseLanguages::System::Provider
[2016-01-27T15:56:46-04:00] DEBUG: [python_runtime[2]] Building package resource using {"python27"=>nil, "python27-devel"=>nil}.
[2016-01-27T15:56:46-04:00] DEBUG: Providers for generic package resource enabled on node include: [Chef::Provider::Package::Yum]
[2016-01-27T15:56:46-04:00] DEBUG: Provider for action install on resource package[python27] is Chef::Provider::Package::Yum
[2016-01-27T15:56:46-04:00] DEBUG: [python_runtime[2]] Running #<Chef::Provider::Package::Yum:0x00000009a45728> with install
[2016-01-27T15:56:46-04:00] DEBUG: package[python27] checking yum info for python27
[2016-01-27T15:56:46-04:00] DEBUG: package[python27] installed version: ["2.7.10-4.120.amzn1"] candidate version: 2.7.10-4.120.amzn1
[2016-01-27T15:56:46-04:00] DEBUG: package[python27] python27 2.7.10-4.120.amzn1 already installed
[2016-01-27T15:56:46-04:00] DEBUG: package[python27] is already installed - nothing to do

       (up to date)
[2016-01-27T15:56:46-04:00] DEBUG: Providers for generic package resource enabled on node include: [Chef::Provider::Package::Yum]
[2016-01-27T15:56:46-04:00] DEBUG: Provider for action install on resource package[python27-devel] is Chef::Provider::Package::Yum
[2016-01-27T15:56:46-04:00] DEBUG: [python_runtime[2]] Running #<Chef::Provider::Package::Yum:0x00000009a59958> with install
[2016-01-27T15:56:46-04:00] DEBUG: package[python27-devel] checking yum info for python27-devel
[2016-01-27T15:56:46-04:00] DEBUG: package[python27-devel] installed version: ["2.7.10-4.120.amzn1"] candidate version: 2.7.10-4.120.amzn1
[2016-01-27T15:56:46-04:00] DEBUG: package[python27-devel] python27-devel 2.7.10-4.120.amzn1 already installed
[2016-01-27T15:56:46-04:00] DEBUG: package[python27-devel] is already installed - nothing to do
     (up to date)
   (up to date)
[2016-01-27T15:56:46-04:00] DEBUG: [python_runtime[2]] Installing pip true
[2016-01-27T15:56:46-04:00] DEBUG: Resources for generic python_runtime_pip resource enabled on node include: [PoisePython::Resources::PythonRuntimePip::Resource]
[2016-01-27T15:56:46-04:00] DEBUG: Resource for python_runtime_pip is PoisePython::Resources::PythonRuntimePip::Resource
[2016-01-27T15:56:46-04:00] DEBUG: Resources for generic python_runtime resource enabled on node include: [PoisePython::Resources::PythonRuntime::Resource]
[2016-01-27T15:56:46-04:00] DEBUG: Resource for python_runtime is PoisePython::Resources::PythonRuntime::Resource
[2016-01-27T15:56:46-04:00] DEBUG: Resources for generic python_runtime resource enabled on node include: [PoisePython::Resources::PythonRuntime::Resource]
[2016-01-27T15:56:46-04:00] DEBUG: Resource for python_runtime is PoisePython::Resources::PythonRuntime::Resource
[2016-01-27T15:56:46-04:00] DEBUG: [python_runtime[2]] Adding python_runtime_pip[2] to subresources
[2016-01-27T15:56:46-04:00] DEBUG: [python_runtime[2]] Installing setuptools latest
[2016-01-27T15:56:46-04:00] DEBUG: Resources for generic python_package resource enabled on node include: [PoisePython::Resources::PythonPackage::Resource]
[2016-01-27T15:56:46-04:00] DEBUG: Resource for python_package is PoisePython::Resources::PythonPackage::Resource
[2016-01-27T15:56:46-04:00] DEBUG: Resources for generic python_runtime resource enabled on node include: [PoisePython::Resources::PythonRuntime::Resource]
[2016-01-27T15:56:46-04:00] DEBUG: Resource for python_runtime is PoisePython::Resources::PythonRuntime::Resource
[2016-01-27T15:56:46-04:00] DEBUG: Resources for generic python_runtime resource enabled on node include: [PoisePython::Resources::PythonRuntime::Resource]
[2016-01-27T15:56:46-04:00] DEBUG: Resource for python_runtime is PoisePython::Resources::PythonRuntime::Resource
[2016-01-27T15:56:46-04:00] DEBUG: [python_runtime[2]] Adding python_package[setuptools] to subresources
[2016-01-27T15:56:46-04:00] DEBUG: [python_runtime[2]] Installing setuptools latest
[2016-01-27T15:56:46-04:00] DEBUG: Resources for generic python_package resource enabled on node include: [PoisePython::Resources::PythonPackage::Resource]
[2016-01-27T15:56:46-04:00] DEBUG: Resource for python_package is PoisePython::Resources::PythonPackage::Resource
[2016-01-27T15:56:46-04:00] DEBUG: Resources for generic python_runtime resource enabled on node include: [PoisePython::Resources::PythonRuntime::Resource]
[2016-01-27T15:56:46-04:00] DEBUG: Resource for python_runtime is PoisePython::Resources::PythonRuntime::Resource
[2016-01-27T15:56:46-04:00] DEBUG: Resources for generic python_runtime resource enabled on node include: [PoisePython::Resources::PythonRuntime::Resource]
[2016-01-27T15:56:46-04:00] DEBUG: Resource for python_runtime is PoisePython::Resources::PythonRuntime::Resource
[2016-01-27T15:56:46-04:00] DEBUG: [python_runtime[2]] Adding python_package[wheel] to subresources
[2016-01-27T15:56:46-04:00] DEBUG: Caught InvalidVersionConstraint. This means that a key in value_for_platform cannot be interpreted as a Chef::VersionConstraint.
[2016-01-27T15:56:46-04:00] DEBUG: 'default' (Chef::Exceptions::InvalidVersionConstraint)
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/version_constraint.rb:113:in `parse'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/version_constraint.rb:36:in `initialize'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/dsl/platform_introspection.rb:79:in `new'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/dsl/platform_introspection.rb:79:in `block in match_versions'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/dsl/platform_introspection.rb:77:in `each'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/dsl/platform_introspection.rb:77:in `match_versions'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/dsl/platform_introspection.rb:54:in `value_for_node'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/dsl/platform_introspection.rb:149:in `value_for_platform'
/etc/chef/local-mode-cache/cache/cookbooks/poise-languages/files/halite_gem/poise_languages/system/mixin.rb:72:in `system_package_name'
/etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/python_providers/system.rb:49:in `python_binary'
/etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/python_providers/base.rb:165:in `install_virtualenv'
/etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/python_providers/base.rb:53:in `block in action_install'
/etc/chef/local-mode-cache/cache/cookbooks/poise/files/halite_gem/poise/helpers/subcontext_block.rb:54:in `instance_eval'
/etc/chef/local-mode-cache/cache/cookbooks/poise/files/halite_gem/poise/helpers/subcontext_block.rb:54:in `subcontext_block'
/etc/chef/local-mode-cache/cache/cookbooks/poise/files/halite_gem/poise/helpers/notifying_block.rb:67:in `notifying_block'
/etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/python_providers/base.rb:49:in `action_install'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/provider.rb:144:in `run_action'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource.rb:585:in `run_action'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:49:in `run_action'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:81:in `block (2 levels) in converge'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:81:in `each'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:81:in `block in converge'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/resource_list.rb:83:in `block in execute_each_resource'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:116:in `call'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:116:in `call_iterator_block'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:85:in `step'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:104:in `iterate'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:55:in `each_with_index'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/resource_list.rb:81:in `execute_each_resource'
/opt/chefdk/embedded/lib/ruby/2.1.0/forwardable.rb:183:in `execute_each_resource'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:80:in `converge'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/client.rb:653:in `block in converge'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/client.rb:648:in `catch'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/client.rb:648:in `converge'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/client.rb:687:in `converge_and_save'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/client.rb:269:in `run'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:270:in `block in fork_chef_client'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:258:in `fork'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:258:in `fork_chef_client'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:224:in `block in run_chef_client'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/local_mode.rb:44:in `with_server_connectivity'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:212:in `run_chef_client'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application/client.rb:408:in `block in interval_run_chef_client'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application/client.rb:398:in `loop'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application/client.rb:398:in `interval_run_chef_client'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application/client.rb:388:in `run_application'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:60:in `run'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/bin/chef-client:26:in `<top (required)>'
/usr/bin/chef-client:54:in `load'
/usr/bin/chef-client:54:in `<main>'
/usr/bin/python27: No module named venv
[2016-01-27T15:56:46-04:00] DEBUG: [python_runtime[2]] Installing virtualenv latest
[2016-01-27T15:56:46-04:00] DEBUG: Resources for generic python_package resource enabled on node include: [PoisePython::Resources::PythonPackage::Resource]
[2016-01-27T15:56:46-04:00] DEBUG: Resource for python_package is PoisePython::Resources::PythonPackage::Resource
[2016-01-27T15:56:46-04:00] DEBUG: Resources for generic python_runtime resource enabled on node include: [PoisePython::Resources::PythonRuntime::Resource]
[2016-01-27T15:56:46-04:00] DEBUG: Resource for python_runtime is PoisePython::Resources::PythonRuntime::Resource
[2016-01-27T15:56:46-04:00] DEBUG: Resources for generic python_runtime resource enabled on node include: [PoisePython::Resources::PythonRuntime::Resource]
[2016-01-27T15:56:46-04:00] DEBUG: Resource for python_runtime is PoisePython::Resources::PythonRuntime::Resource
* python_runtime_pip[2] action install[2016-01-27T15:56:46-04:00] INFO: Processing python_runtime_pip[2] action install (/etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/python_providers/base.rb line 116)
[2016-01-27T15:56:46-04:00] DEBUG: Providers for generic python_runtime_pip resource enabled on node include: [PoisePython::Resources::PythonRuntimePip::Provider]
[2016-01-27T15:56:46-04:00] DEBUG: Provider for action install on resource python_runtime_pip[2] is PoisePython::Resources::PythonRuntimePip::Provider
[2016-01-27T15:56:46-04:00] DEBUG: Resources for generic python_runtime resource enabled on node include: [PoisePython::Resources::PythonRuntime::Resource]
[2016-01-27T15:56:46-04:00] DEBUG: Resource for python_runtime is PoisePython::Resources::PythonRuntime::Resource
[2016-01-27T15:56:46-04:00] DEBUG: Providers for generic python_runtime resource enabled on node include: [PoisePython::PythonProviders::System]
[2016-01-27T15:56:46-04:00] DEBUG: Provider for action python_binary on resource python_runtime[2] is PoisePython::PythonProviders::System
[2016-01-27T15:56:46-04:00] DEBUG: Caught InvalidVersionConstraint. This means that a key in value_for_platform cannot be interpreted as a Chef::VersionConstraint.
[2016-01-27T15:56:46-04:00] DEBUG: 'default' (Chef::Exceptions::InvalidVersionConstraint)
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/version_constraint.rb:113:in `parse'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/version_constraint.rb:36:in `initialize'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/dsl/platform_introspection.rb:79:in `new'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/dsl/platform_introspection.rb:79:in `block in match_versions'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/dsl/platform_introspection.rb:77:in `each'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/dsl/platform_introspection.rb:77:in `match_versions'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/dsl/platform_introspection.rb:54:in `value_for_node'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/dsl/platform_introspection.rb:149:in `value_for_platform'
/etc/chef/local-mode-cache/cache/cookbooks/poise-languages/files/halite_gem/poise_languages/system/mixin.rb:72:in `system_package_name'
/etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/python_providers/system.rb:49:in `python_binary'
/etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/resources/python_runtime.rb:95:in `python_binary'
/etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/resources/python_runtime_pip.rb:158:in `pip_version'
/etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/resources/python_runtime_pip.rb:67:in `block in load_current_resource'
/etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/resources/python_runtime_pip.rb:65:in `tap'
/etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/resources/python_runtime_pip.rb:65:in `load_current_resource'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/provider.rb:127:in `run_action'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource.rb:585:in `run_action'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:49:in `run_action'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:81:in `block (2 levels) in converge'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:81:in `each'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:81:in `block in converge'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/resource_list.rb:83:in `block in execute_each_resource'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:116:in `call'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:116:in `call_iterator_block'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:85:in `step'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:104:in `iterate'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:55:in `each_with_index'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/resource_list.rb:81:in `execute_each_resource'
/opt/chefdk/embedded/lib/ruby/2.1.0/forwardable.rb:183:in `execute_each_resource'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:80:in `converge'
/etc/chef/local-mode-cache/cache/cookbooks/poise/files/halite_gem/poise/helpers/notifying_block.rb:69:in `notifying_block'
/etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/python_providers/base.rb:49:in `action_install'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/provider.rb:144:in `run_action'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource.rb:585:in `run_action'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:49:in `run_action'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:81:in `block (2 levels) in converge'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:81:in `each'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:81:in `block in converge'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/resource_list.rb:83:in `block in execute_each_resource'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:116:in `call'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:116:in `call_iterator_block'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:85:in `step'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:104:in `iterate'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:55:in `each_with_index'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/resource_list.rb:81:in `execute_each_resource'
/opt/chefdk/embedded/lib/ruby/2.1.0/forwardable.rb:183:in `execute_each_resource'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:80:in `converge'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/client.rb:653:in `block in converge'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/client.rb:648:in `catch'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/client.rb:648:in `converge'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/client.rb:687:in `converge_and_save'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/client.rb:269:in `run'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:270:in `block in fork_chef_client'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:258:in `fork'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:258:in `fork_chef_client'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:224:in `block in run_chef_client'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/local_mode.rb:44:in `with_server_connectivity'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:212:in `run_chef_client'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application/client.rb:408:in `block in interval_run_chef_client'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application/client.rb:398:in `loop'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application/client.rb:398:in `interval_run_chef_client'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application/client.rb:388:in `run_application'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:60:in `run'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/bin/chef-client:26:in `<top (required)>'
/usr/bin/chef-client:54:in `load'
/usr/bin/chef-client:54:in `<main>'
[2016-01-27T15:56:46-04:00] DEBUG: Resources for generic python_runtime resource enabled on node include: [PoisePython::Resources::PythonRuntime::Resource]
[2016-01-27T15:56:46-04:00] DEBUG: Resource for python_runtime is PoisePython::Resources::PythonRuntime::Resource
[2016-01-27T15:56:46-04:00] DEBUG: Providers for generic python_runtime resource enabled on node include: [PoisePython::PythonProviders::System]
[2016-01-27T15:56:46-04:00] DEBUG: Provider for action python_environment on resource python_runtime[2] is PoisePython::PythonProviders::System
/usr/bin/python27: No module named pip
[2016-01-27T15:56:46-04:00] DEBUG: Initiating GET to https://bootstrap.pypa.io/get-pip.py
[2016-01-27T15:56:46-04:00] DEBUG: ---- HTTP Request Header Data: ----
[2016-01-27T15:56:46-04:00] DEBUG: ---- End HTTP Request Header Data ----
[2016-01-27T15:56:46-04:00] DEBUG: ---- HTTP Status and Header Data: ----
[2016-01-27T15:56:46-04:00] DEBUG: HTTP 1.1 200 OK
[2016-01-27T15:56:46-04:00] DEBUG: server: nginx
[2016-01-27T15:56:46-04:00] DEBUG: content-type: text/x-python
[2016-01-27T15:56:46-04:00] DEBUG: last-modified: Fri, 22 Jan 2016 00:00:31 GMT
[2016-01-27T15:56:46-04:00] DEBUG: etag: "56a1711f-1711bb"
[2016-01-27T15:56:46-04:00] DEBUG: x-clacks-overhead: GNU Terry Pratchett
[2016-01-27T15:56:46-04:00] DEBUG: strict-transport-security: max-age=315360000; includeSubDomains; preload
[2016-01-27T15:56:46-04:00] DEBUG: public-key-pins: max-age=2592000; includeSubDomains; pin-sha256="WoiWRyIOVNa9ihaBciRSC7XHjliYS9VwUGOIud4PB18="; pin-sha256="5C8kvU039KouVrl52D0eZSGf4Onjo4Khs8tmyTlV3nU="; pin-sha256="5C8kvU039KouVrl52D0eZSGf4Onjo4Khs8tmyTlV3nU="; pin-sha256="lCppFqbkrlJ3EcVFAkeip0+44VaoJUymbnOaEUk7tEU="; pin-sha256="TUDnr0MEoJ3of7+YliBMBVFB4/gJsv5zO7IxD9+YoWI="; pin-sha256="x4QzPSC810K5/cMjb05Qm4k3Bw5zBn4lTdO/nEW/Td4=";
[2016-01-27T15:56:46-04:00] DEBUG: via: 1.1 varnish, 1.1 varnish
[2016-01-27T15:56:46-04:00] DEBUG: content-length: 1511867
[2016-01-27T15:56:46-04:00] DEBUG: accept-ranges: bytes
[2016-01-27T15:56:46-04:00] DEBUG: date: Wed, 27 Jan 2016 19:56:46 GMT
[2016-01-27T15:56:46-04:00] DEBUG: age: 3253
[2016-01-27T15:56:46-04:00] DEBUG: connection: close
[2016-01-27T15:56:46-04:00] DEBUG: x-served-by: cache-iad2149-IAD, cache-atl6226-ATL
[2016-01-27T15:56:46-04:00] DEBUG: x-cache: HIT, HIT
[2016-01-27T15:56:46-04:00] DEBUG: x-cache-hits: 1, 153
[2016-01-27T15:56:46-04:00] DEBUG: ---- End HTTP Status/Header Data ----
[2016-01-27T15:56:46-04:00] DEBUG: Resources for generic python_runtime resource enabled on node include: [PoisePython::Resources::PythonRuntime::Resource]
[2016-01-27T15:56:46-04:00] DEBUG: Resource for python_runtime is PoisePython::Resources::PythonRuntime::Resource
[2016-01-27T15:56:46-04:00] DEBUG: Providers for generic python_runtime resource enabled on node include: [PoisePython::PythonProviders::System]
[2016-01-27T15:56:46-04:00] DEBUG: Provider for action python_binary on resource python_runtime[2] is PoisePython::PythonProviders::System
[2016-01-27T15:56:46-04:00] DEBUG: Caught InvalidVersionConstraint. This means that a key in value_for_platform cannot be interpreted as a Chef::VersionConstraint.
[2016-01-27T15:56:46-04:00] DEBUG: 'default' (Chef::Exceptions::InvalidVersionConstraint)
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/version_constraint.rb:113:in `parse'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/version_constraint.rb:36:in `initialize'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/dsl/platform_introspection.rb:79:in `new'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/dsl/platform_introspection.rb:79:in `block in match_versions'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/dsl/platform_introspection.rb:77:in `each'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/dsl/platform_introspection.rb:77:in `match_versions'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/dsl/platform_introspection.rb:54:in `value_for_node'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/dsl/platform_introspection.rb:149:in `value_for_platform'
/etc/chef/local-mode-cache/cache/cookbooks/poise-languages/files/halite_gem/poise_languages/system/mixin.rb:72:in `system_package_name'
/etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/python_providers/system.rb:49:in `python_binary'
/etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/resources/python_runtime.rb:95:in `python_binary'
/etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/resources/python_runtime_pip.rb:119:in `block in bootstrap_pip'
/opt/chefdk/embedded/lib/ruby/2.1.0/tempfile.rb:371:in `create'
/etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/resources/python_runtime_pip.rb:108:in `bootstrap_pip'
/etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/resources/python_runtime_pip.rb:79:in `action_install'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/provider.rb:144:in `run_action'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource.rb:585:in `run_action'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:49:in `run_action'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:81:in `block (2 levels) in converge'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:81:in `each'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:81:in `block in converge'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/resource_list.rb:83:in `block in execute_each_resource'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:116:in `call'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:116:in `call_iterator_block'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:85:in `step'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:104:in `iterate'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:55:in `each_with_index'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/resource_list.rb:81:in `execute_each_resource'
/opt/chefdk/embedded/lib/ruby/2.1.0/forwardable.rb:183:in `execute_each_resource'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:80:in `converge'
/etc/chef/local-mode-cache/cache/cookbooks/poise/files/halite_gem/poise/helpers/notifying_block.rb:69:in `notifying_block'
/etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/python_providers/base.rb:49:in `action_install'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/provider.rb:144:in `run_action'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource.rb:585:in `run_action'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:49:in `run_action'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:81:in `block (2 levels) in converge'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:81:in `each'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:81:in `block in converge'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/resource_list.rb:83:in `block in execute_each_resource'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:116:in `call'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:116:in `call_iterator_block'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:85:in `step'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:104:in `iterate'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:55:in `each_with_index'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/resource_list.rb:81:in `execute_each_resource'
/opt/chefdk/embedded/lib/ruby/2.1.0/forwardable.rb:183:in `execute_each_resource'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:80:in `converge'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/client.rb:653:in `block in converge'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/client.rb:648:in `catch'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/client.rb:648:in `converge'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/client.rb:687:in `converge_and_save'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/client.rb:269:in `run'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:270:in `block in fork_chef_client'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:258:in `fork'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:258:in `fork_chef_client'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:224:in `block in run_chef_client'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/local_mode.rb:44:in `with_server_connectivity'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:212:in `run_chef_client'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application/client.rb:408:in `block in interval_run_chef_client'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application/client.rb:398:in `loop'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application/client.rb:398:in `interval_run_chef_client'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application/client.rb:388:in `run_application'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:60:in `run'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/bin/chef-client:26:in `<top (required)>'
/usr/bin/chef-client:54:in `load'
/usr/bin/chef-client:54:in `<main>'
[2016-01-27T15:56:46-04:00] DEBUG: Resources for generic python_runtime resource enabled on node include: [PoisePython::Resources::PythonRuntime::Resource]
[2016-01-27T15:56:46-04:00] DEBUG: Resource for python_runtime is PoisePython::Resources::PythonRuntime::Resource
[2016-01-27T15:56:46-04:00] DEBUG: Providers for generic python_runtime resource enabled on node include: [PoisePython::PythonProviders::System]
[2016-01-27T15:56:46-04:00] DEBUG: Provider for action python_environment on resource python_runtime[2] is PoisePython::PythonProviders::System
Requirement already up-to-date: pip in /usr/lib/python2.7/dist-packages
[2016-01-27T15:56:47-04:00] DEBUG: Resources for generic python_runtime resource enabled on node include: [PoisePython::Resources::PythonRuntime::Resource]
[2016-01-27T15:56:47-04:00] DEBUG: Resource for python_runtime is PoisePython::Resources::PythonRuntime::Resource
[2016-01-27T15:56:47-04:00] DEBUG: Providers for generic python_runtime resource enabled on node include: [PoisePython::PythonProviders::System]
[2016-01-27T15:56:47-04:00] DEBUG: Provider for action python_binary on resource python_runtime[2] is PoisePython::PythonProviders::System
[2016-01-27T15:56:47-04:00] DEBUG: Caught InvalidVersionConstraint. This means that a key in value_for_platform cannot be interpreted as a Chef::VersionConstraint.
[2016-01-27T15:56:47-04:00] DEBUG: 'default' (Chef::Exceptions::InvalidVersionConstraint)
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/version_constraint.rb:113:in `parse'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/version_constraint.rb:36:in `initialize'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/dsl/platform_introspection.rb:79:in `new'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/dsl/platform_introspection.rb:79:in `block in match_versions'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/dsl/platform_introspection.rb:77:in `each'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/dsl/platform_introspection.rb:77:in `match_versions'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/dsl/platform_introspection.rb:54:in `value_for_node'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/dsl/platform_introspection.rb:149:in `value_for_platform'
/etc/chef/local-mode-cache/cache/cookbooks/poise-languages/files/halite_gem/poise_languages/system/mixin.rb:72:in `system_package_name'
/etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/python_providers/system.rb:49:in `python_binary'
/etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/resources/python_runtime.rb:95:in `python_binary'
/etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/resources/python_runtime_pip.rb:158:in `pip_version'
/etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/resources/python_runtime_pip.rb:121:in `bootstrap_pip'
/etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/resources/python_runtime_pip.rb:79:in `action_install'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/provider.rb:144:in `run_action'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource.rb:585:in `run_action'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:49:in `run_action'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:81:in `block (2 levels) in converge'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:81:in `each'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:81:in `block in converge'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/resource_list.rb:83:in `block in execute_each_resource'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:116:in `call'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:116:in `call_iterator_block'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:85:in `step'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:104:in `iterate'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:55:in `each_with_index'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/resource_list.rb:81:in `execute_each_resource'
/opt/chefdk/embedded/lib/ruby/2.1.0/forwardable.rb:183:in `execute_each_resource'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:80:in `converge'
/etc/chef/local-mode-cache/cache/cookbooks/poise/files/halite_gem/poise/helpers/notifying_block.rb:69:in `notifying_block'
/etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/python_providers/base.rb:49:in `action_install'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/provider.rb:144:in `run_action'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource.rb:585:in `run_action'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:49:in `run_action'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:81:in `block (2 levels) in converge'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:81:in `each'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:81:in `block in converge'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/resource_list.rb:83:in `block in execute_each_resource'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:116:in `call'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:116:in `call_iterator_block'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:85:in `step'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:104:in `iterate'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:55:in `each_with_index'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/resource_list.rb:81:in `execute_each_resource'
/opt/chefdk/embedded/lib/ruby/2.1.0/forwardable.rb:183:in `execute_each_resource'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:80:in `converge'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/client.rb:653:in `block in converge'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/client.rb:648:in `catch'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/client.rb:648:in `converge'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/client.rb:687:in `converge_and_save'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/client.rb:269:in `run'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:270:in `block in fork_chef_client'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:258:in `fork'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:258:in `fork_chef_client'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:224:in `block in run_chef_client'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/local_mode.rb:44:in `with_server_connectivity'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:212:in `run_chef_client'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application/client.rb:408:in `block in interval_run_chef_client'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application/client.rb:398:in `loop'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application/client.rb:398:in `interval_run_chef_client'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application/client.rb:388:in `run_application'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:60:in `run'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/bin/chef-client:26:in `<top (required)>'
/usr/bin/chef-client:54:in `load'
/usr/bin/chef-client:54:in `<main>'
[2016-01-27T15:56:47-04:00] DEBUG: Resources for generic python_runtime resource enabled on node include: [PoisePython::Resources::PythonRuntime::Resource]
[2016-01-27T15:56:47-04:00] DEBUG: Resource for python_runtime is PoisePython::Resources::PythonRuntime::Resource
[2016-01-27T15:56:47-04:00] DEBUG: Providers for generic python_runtime resource enabled on node include: [PoisePython::PythonProviders::System]
[2016-01-27T15:56:47-04:00] DEBUG: Provider for action python_environment on resource python_runtime[2] is PoisePython::PythonProviders::System
/usr/bin/python27: No module named pip


* python_package[setuptools] action install[2016-01-27T15:56:47-04:00] INFO: Processing python_package[setuptools] action install (/etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/python_providers/base.rb line 136)
[2016-01-27T15:56:47-04:00] DEBUG: Providers for generic python_package resource enabled on node include: [PoisePython::Resources::PythonPackage::Provider]
[2016-01-27T15:56:47-04:00] DEBUG: Provider for action install on resource python_package[setuptools] is PoisePython::Resources::PythonPackage::Provider
[2016-01-27T15:56:47-04:00] DEBUG: Resources for generic python_runtime resource enabled on node include: [PoisePython::Resources::PythonRuntime::Resource]
[2016-01-27T15:56:47-04:00] DEBUG: Resource for python_runtime is PoisePython::Resources::PythonRuntime::Resource
[2016-01-27T15:56:47-04:00] DEBUG: Providers for generic python_runtime resource enabled on node include: [PoisePython::PythonProviders::System]
[2016-01-27T15:56:47-04:00] DEBUG: Provider for action python_environment on resource python_runtime[2] is PoisePython::PythonProviders::System
[2016-01-27T15:56:47-04:00] DEBUG: Resources for generic python_runtime resource enabled on node include: [PoisePython::Resources::PythonRuntime::Resource]
[2016-01-27T15:56:47-04:00] DEBUG: Resource for python_runtime is PoisePython::Resources::PythonRuntime::Resource
[2016-01-27T15:56:47-04:00] DEBUG: Providers for generic python_runtime resource enabled on node include: [PoisePython::PythonProviders::System]
[2016-01-27T15:56:47-04:00] DEBUG: Provider for action python_binary on resource python_runtime[2] is PoisePython::PythonProviders::System
[2016-01-27T15:56:47-04:00] DEBUG: Caught InvalidVersionConstraint. This means that a key in value_for_platform cannot be interpreted as a Chef::VersionConstraint.
[2016-01-27T15:56:47-04:00] DEBUG: 'default' (Chef::Exceptions::InvalidVersionConstraint)
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/version_constraint.rb:113:in `parse'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/version_constraint.rb:36:in `initialize'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/dsl/platform_introspection.rb:79:in `new'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/dsl/platform_introspection.rb:79:in `block in match_versions'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/dsl/platform_introspection.rb:77:in `each'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/dsl/platform_introspection.rb:77:in `match_versions'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/dsl/platform_introspection.rb:54:in `value_for_node'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/dsl/platform_introspection.rb:149:in `value_for_platform'
/etc/chef/local-mode-cache/cache/cookbooks/poise-languages/files/halite_gem/poise_languages/system/mixin.rb:72:in `system_package_name'
/etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/python_providers/system.rb:49:in `python_binary'
/etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/resources/python_runtime.rb:95:in `python_binary'
/etc/chef/local-mode-cache/cache/cookbooks/poise-languages/files/halite_gem/poise_languages/command/mixin.rb:94:in `default_language_command_runtime'
/etc/chef/local-mode-cache/cache/cookbooks/poise-languages/files/halite_gem/poise_languages/command/mixin.rb:82:in `language_command_runtime'
/etc/chef/local-mode-cache/cache/cookbooks/poise-languages/files/halite_gem/poise_languages/command/mixin.rb:135:in `block in language_command_mixin'
/etc/chef/local-mode-cache/cache/cookbooks/poise-languages/files/halite_gem/poise_languages/command/mixin.rb:187:in `language_command_shell_out'
/etc/chef/local-mode-cache/cache/cookbooks/poise-languages/files/halite_gem/poise_languages/command/mixin.rb:211:in `block in language_command_mixin'
/etc/chef/local-mode-cache/cache/cookbooks/poise-languages/files/halite_gem/poise_languages/command/mixin.rb:201:in `language_command_shell_out!'
/etc/chef/local-mode-cache/cache/cookbooks/poise-languages/files/halite_gem/poise_languages/command/mixin.rb:216:in `block in language_command_mixin'
/etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/resources/python_package.rb:263:in `pip_command'
/etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/resources/python_package.rb:158:in `check_package_versions'
/etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/resources/python_package.rb:144:in `load_current_resource'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/provider.rb:127:in `run_action'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource.rb:585:in `run_action'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:49:in `run_action'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:81:in `block (2 levels) in converge'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:81:in `each'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:81:in `block in converge'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/resource_list.rb:83:in `block in execute_each_resource'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:116:in `call'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:116:in `call_iterator_block'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:85:in `step'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:104:in `iterate'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:55:in `each_with_index'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/resource_list.rb:81:in `execute_each_resource'
/opt/chefdk/embedded/lib/ruby/2.1.0/forwardable.rb:183:in `execute_each_resource'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:80:in `converge'
/etc/chef/local-mode-cache/cache/cookbooks/poise/files/halite_gem/poise/helpers/notifying_block.rb:69:in `notifying_block'
/etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/python_providers/base.rb:49:in `action_install'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/provider.rb:144:in `run_action'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource.rb:585:in `run_action'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:49:in `run_action'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:81:in `block (2 levels) in converge'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:81:in `each'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:81:in `block in converge'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/resource_list.rb:83:in `block in execute_each_resource'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:116:in `call'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:116:in `call_iterator_block'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:85:in `step'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:104:in `iterate'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:55:in `each_with_index'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/resource_list.rb:81:in `execute_each_resource'
/opt/chefdk/embedded/lib/ruby/2.1.0/forwardable.rb:183:in `execute_each_resource'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:80:in `converge'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/client.rb:653:in `block in converge'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/client.rb:648:in `catch'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/client.rb:648:in `converge'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/client.rb:687:in `converge_and_save'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/client.rb:269:in `run'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:270:in `block in fork_chef_client'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:258:in `fork'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:258:in `fork_chef_client'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:224:in `block in run_chef_client'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/local_mode.rb:44:in `with_server_connectivity'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:212:in `run_chef_client'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application/client.rb:408:in `block in interval_run_chef_client'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application/client.rb:398:in `loop'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application/client.rb:398:in `interval_run_chef_client'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application/client.rb:388:in `run_application'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:60:in `run'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/bin/chef-client:26:in `<top (required)>'
/usr/bin/chef-client:54:in `load'
/usr/bin/chef-client:54:in `<main>'
[2016-01-27T15:56:47-04:00] DEBUG: [python_package[setuptools]] Running python command: /usr/bin/python27 -m pip.__main__ list
/usr/bin/python27: No module named pip


  ================================================================================
  Error executing action `install` on resource 'python_package[setuptools]'
  ================================================================================

  Mixlib::ShellOut::ShellCommandFailed
  ------------------------------------
  Expected process to exit with [0], but received '1'
  ---- Begin output of ["/usr/bin/python27", "-m", "pip.__main__", "list"] ----
  STDOUT: 
  STDERR: /usr/bin/python27: No module named pip
  ---- End output of ["/usr/bin/python27", "-m", "pip.__main__", "list"] ----
  Ran ["/usr/bin/python27", "-m", "pip.__main__", "list"] returned 1

  Cookbook Trace:
  ---------------
  /etc/chef/local-mode-cache/cache/cookbooks/poise-languages/files/halite_gem/poise_languages/command/mixin.rb:201:in `tap'
  /etc/chef/local-mode-cache/cache/cookbooks/poise-languages/files/halite_gem/poise_languages/command/mixin.rb:201:in `language_command_shell_out!'
  /etc/chef/local-mode-cache/cache/cookbooks/poise-languages/files/halite_gem/poise_languages/command/mixin.rb:216:in `block in language_command_mixin'
  /etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/resources/python_package.rb:263:in `pip_command'
  /etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/resources/python_package.rb:158:in `check_package_versions'
  /etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/resources/python_package.rb:144:in `load_current_resource'
  /etc/chef/local-mode-cache/cache/cookbooks/poise/files/halite_gem/poise/helpers/notifying_block.rb:69:in `notifying_block'
  /etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/python_providers/base.rb:49:in `action_install'

  Resource Declaration:
  ---------------------
  # In /etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/python_providers/base.rb

  136:         python_package 'setuptools' do
  137:           parent_python new_resource
  138:           version setuptools_version if setuptools_version.is_a?(String)
  139:         end
  140:       end

  Compiled Resource:
  ------------------
  # Declared in /etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/python_providers/base.rb:136:in `install_setuptools'

  python_package("setuptools") do
    action [:install]
    retries 0
    retry_delay 2
    default_guard_interpreter :default
    package_name "setuptools"
    declared_type :python_package
    cookbook_name "poise-python"
    parent_python python_runtime[2]
  end

[2016-01-27T15:56:47-04:00] INFO: Running queued delayed notifications before re-raising exception

================================================================================
Error executing action `install` on resource 'python_runtime[2]'
================================================================================

Mixlib::ShellOut::ShellCommandFailed
------------------------------------
python_package[setuptools] (/etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/python_providers/base.rb line 136) had an error: Mixlib::ShellOut::ShellCommandFailed: Expected process to exit with [0], but received '1'
---- Begin output of ["/usr/bin/python27", "-m", "pip.__main__", "list"] ----
STDOUT: 
STDERR: /usr/bin/python27: No module named pip
---- End output of ["/usr/bin/python27", "-m", "pip.__main__", "list"] ----
Ran ["/usr/bin/python27", "-m", "pip.__main__", "list"] returned 1

Cookbook Trace:
---------------
/etc/chef/local-mode-cache/cache/cookbooks/poise-languages/files/halite_gem/poise_languages/command/mixin.rb:201:in `tap'
/etc/chef/local-mode-cache/cache/cookbooks/poise-languages/files/halite_gem/poise_languages/command/mixin.rb:201:in `language_command_shell_out!'
/etc/chef/local-mode-cache/cache/cookbooks/poise-languages/files/halite_gem/poise_languages/command/mixin.rb:216:in `block in language_command_mixin'
/etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/resources/python_package.rb:263:in `pip_command'
/etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/resources/python_package.rb:158:in `check_package_versions'
/etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/resources/python_package.rb:144:in `load_current_resource'
/etc/chef/local-mode-cache/cache/cookbooks/poise/files/halite_gem/poise/helpers/notifying_block.rb:69:in `notifying_block'
/etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/python_providers/base.rb:49:in `action_install'

Resource Declaration:
---------------------
# In /etc/chef/local-mode-cache/cache/cookbooks/poise-python/recipes/default.rb

 20: python_runtime '2' if node['poise-python']['install_python2']

Compiled Resource:
------------------
# Declared in /etc/chef/local-mode-cache/cache/cookbooks/poise-python/recipes/default.rb:20:in `from_file'

python_runtime("2") do
  action [:install]
  updated true
  updated_by_last_action true
  retries 0
  retry_delay 2
  default_guard_interpreter :default
  subresources [python_package[boto3], python_package[pip], python_package[virtualenv], python_runtime_pip[2], python_package[setuptools], python_package[wheel]]
  declared_type :python_runtime
  cookbook_name "poise-python"
  recipe_name "default"
  pip_version true
  setuptools_version true
  version "2"
  virtualenv_version true
  wheel_version true
end

[2016-01-27T15:56:47-04:00] INFO: Running queued delayed notifications before re-raising exception
[2016-01-27T15:56:47-04:00] DEBUG: Re-raising exception: Mixlib::ShellOut::ShellCommandFailed - python_runtime[2] (poise-python::default line 20) had an error: Mixlib::ShellOut::ShellCommandFailed: python_package[setuptools] (/etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/python_providers/base.rb line 136) had an error: Mixlib::ShellOut::ShellCommandFailed: Expected process to exit with [0], but received '1'
---- Begin output of ["/usr/bin/python27", "-m", "pip.__main__", "list"] ----
STDOUT: 
STDERR: /usr/bin/python27: No module named pip
---- End output of ["/usr/bin/python27", "-m", "pip.__main__", "list"] ----
Ran ["/usr/bin/python27", "-m", "pip.__main__", "list"] returned 1
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/mixlib-shellout-2.2.3/lib/mixlib/shellout.rb:289:in `invalid!'
  /opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/mixlib-shellout-2.2.3/lib/mixlib/shellout.rb:276:in `error!'
  /etc/chef/local-mode-cache/cache/cookbooks/poise-languages/files/halite_gem/poise_languages/command/mixin.rb:201:in `tap'
  /etc/chef/local-mode-cache/cache/cookbooks/poise-languages/files/halite_gem/poise_languages/command/mixin.rb:201:in `language_command_shell_out!'
  /etc/chef/local-mode-cache/cache/cookbooks/poise-languages/files/halite_gem/poise_languages/command/mixin.rb:216:in `block in language_command_mixin'
  /etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/resources/python_package.rb:263:in `pip_command'
  /etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/resources/python_package.rb:158:in `check_package_versions'
  /etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/resources/python_package.rb:144:in `load_current_resource'
  /opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/provider.rb:127:in `run_action'
  /opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource.rb:585:in `run_action'
  /opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:49:in `run_action'
  /opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:81:in `block (2 levels) in converge'
  /opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:81:in `each'
  /opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:81:in `block in converge'
  /opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/resource_list.rb:83:in `block in execute_each_resource'
  /opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:116:in `call'
  /opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:116:in `call_iterator_block'
  /opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:85:in `step'
  /opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:104:in `iterate'
  /opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:55:in `each_with_index'
  /opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/resource_list.rb:81:in `execute_each_resource'
  /opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:80:in `converge'
  /etc/chef/local-mode-cache/cache/cookbooks/poise/files/halite_gem/poise/helpers/notifying_block.rb:69:in `notifying_block'
  /etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/python_providers/base.rb:49:in `action_install'
  /opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/provider.rb:144:in `run_action'
  /opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource.rb:585:in `run_action'
  /opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:49:in `run_action'
  /opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:81:in `block (2 levels) in converge'
  /opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:81:in `each'
  /opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:81:in `block in converge'
  /opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/resource_list.rb:83:in `block in execute_each_resource'
  /opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:116:in `call'
  /opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:116:in `call_iterator_block'
  /opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:85:in `step'
  /opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:104:in `iterate'
  /opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:55:in `each_with_index'
  /opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/resource_list.rb:81:in `execute_each_resource'
  /opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:80:in `converge'
  /opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/client.rb:653:in `block in converge'
  /opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/client.rb:648:in `catch'
  /opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/client.rb:648:in `converge'
  /opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/client.rb:687:in `converge_and_save'
  /opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/client.rb:269:in `run'
  /opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:270:in `block in fork_chef_client'
  /opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:258:in `fork'
  /opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:258:in `fork_chef_client'
  /opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:224:in `block in run_chef_client'
  /opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/local_mode.rb:44:in `with_server_connectivity'
  /opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:212:in `run_chef_client'
  /opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application/client.rb:408:in `block in interval_run_chef_client'
  /opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application/client.rb:398:in `loop'
  /opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application/client.rb:398:in `interval_run_chef_client'
  /opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application/client.rb:388:in `run_application'
  /opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:60:in `run'
  /opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/bin/chef-client:26:in `<top (required)>'
  /usr/bin/chef-client:54:in `load'
  /usr/bin/chef-client:54:in `<main>'

Running handlers:
[2016-01-27T15:56:47-04:00] ERROR: Running exception handlers
Running handlers complete
[2016-01-27T15:56:47-04:00] ERROR: Exception handlers complete
Chef Client failed. 8 resources updated in 20 seconds
[2016-01-27T15:56:47-04:00] DEBUG: Server doesn't support resource history, skipping resource report.
[2016-01-27T15:56:47-04:00] DEBUG: Audit Reports are disabled. Skipping sending reports.
[2016-01-27T15:56:47-04:00] FATAL: Stacktrace dumped to /etc/chef/local-mode-cache/cache/chef-stacktrace.out
[2016-01-27T15:56:47-04:00] DEBUG: Mixlib::ShellOut::ShellCommandFailed: python_runtime[2] (poise-python::default line 20) had an error: Mixlib::ShellOut::ShellCommandFailed: python_package[setuptools] (/etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/python_providers/base.rb line 136) had an error: Mixlib::ShellOut::ShellCommandFailed: Expected process to exit with [0], but received '1'
---- Begin output of ["/usr/bin/python27", "-m", "pip.__main__", "list"] ----
STDOUT: 
STDERR: /usr/bin/python27: No module named pip
---- End output of ["/usr/bin/python27", "-m", "pip.__main__", "list"] ----
Ran ["/usr/bin/python27", "-m", "pip.__main__", "list"] returned 1
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/mixlib-shellout-2.2.3/lib/mixlib/shellout.rb:289:in `invalid!'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/mixlib-shellout-2.2.3/lib/mixlib/shellout.rb:276:in `error!'
/etc/chef/local-mode-cache/cache/cookbooks/poise-languages/files/halite_gem/poise_languages/command/mixin.rb:201:in `tap'
/etc/chef/local-mode-cache/cache/cookbooks/poise-languages/files/halite_gem/poise_languages/command/mixin.rb:201:in `language_command_shell_out!'
/etc/chef/local-mode-cache/cache/cookbooks/poise-languages/files/halite_gem/poise_languages/command/mixin.rb:216:in `block in language_command_mixin'
/etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/resources/python_package.rb:263:in `pip_command'
/etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/resources/python_package.rb:158:in `check_package_versions'
/etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/resources/python_package.rb:144:in `load_current_resource'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/provider.rb:127:in `run_action'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource.rb:585:in `run_action'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:49:in `run_action'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:81:in `block (2 levels) in converge'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:81:in `each'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:81:in `block in converge'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/resource_list.rb:83:in `block in execute_each_resource'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:116:in `call'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:116:in `call_iterator_block'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:85:in `step'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:104:in `iterate'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:55:in `each_with_index'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/resource_list.rb:81:in `execute_each_resource'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:80:in `converge'
/etc/chef/local-mode-cache/cache/cookbooks/poise/files/halite_gem/poise/helpers/notifying_block.rb:69:in `notifying_block'
/etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/python_providers/base.rb:49:in `action_install'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/provider.rb:144:in `run_action'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource.rb:585:in `run_action'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:49:in `run_action'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:81:in `block (2 levels) in converge'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:81:in `each'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:81:in `block in converge'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/resource_list.rb:83:in `block in execute_each_resource'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:116:in `call'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:116:in `call_iterator_block'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:85:in `step'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:104:in `iterate'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/stepable_iterator.rb:55:in `each_with_index'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/resource_collection/resource_list.rb:81:in `execute_each_resource'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/runner.rb:80:in `converge'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/client.rb:653:in `block in converge'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/client.rb:648:in `catch'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/client.rb:648:in `converge'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/client.rb:687:in `converge_and_save'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/client.rb:269:in `run'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:270:in `block in fork_chef_client'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:258:in `fork'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:258:in `fork_chef_client'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:224:in `block in run_chef_client'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/local_mode.rb:44:in `with_server_connectivity'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:212:in `run_chef_client'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application/client.rb:408:in `block in interval_run_chef_client'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application/client.rb:398:in `loop'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application/client.rb:398:in `interval_run_chef_client'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application/client.rb:388:in `run_application'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/lib/chef/application.rb:60:in `run'
/opt/chefdk/embedded/lib/ruby/gems/2.1.0/gems/chef-12.5.1/bin/chef-client:26:in `<top (required)>'
/usr/bin/chef-client:54:in `load'
/usr/bin/chef-client:54:in `<main>'
[2016-01-27T15:56:47-04:00] ERROR: python_runtime[2] (poise-python::default line 20) had an error: Mixlib::ShellOut::ShellCommandFailed: python_package[setuptools] (/etc/chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/python_providers/base.rb line 136) had an error: Mixlib::ShellOut::ShellCommandFailed: Expected process to exit with [0], but received '1'
---- Begin output of ["/usr/bin/python27", "-m", "pip.__main__", "list"] ----
STDOUT:
STDERR: /usr/bin/python27: No module named pip
---- End output of ["/usr/bin/python27", "-m", "pip.__main__", "list"] ----
Ran ["/usr/bin/python27", "-m", "pip.__main__", "list"] returned 1
[2016-01-27T15:56:49-04:00] FATAL: Chef::Exceptions::ChildConvergeError: Chef run process exited unsuccessfully (exit code 1)

@et304383
Copy link

That's all output after the first hit to poise-python::default.

@coderanger
Copy link
Member

Okay, so here is the problem: Requirement already up-to-date: pip in /usr/lib/python2.7/dist-packages

The bootstrap script thinks pip is already installed. Above that you can see it downloading the bootstrap script Initiating GET to https://bootstrap.pypa.io/get-pip.py so we know it is hitting that code path correctly. Guessing this is a difference between the CentOS 7 docker images and "real" EL7?

@gene1wood
Copy link

@coderanger in my environment, the only place in the debug out put that python_runtime_pip shows up is in the files being pulled down. It looks like it doesn't end up executing the python_runtime_pip.rb just fetching it. I have the full debug output from the run but it's very large, let me know if you'd like me to get it to you somehow.

[2016-01-27T15:13:30-05:00] DEBUG: #<ChefZero::RestRequest:0x00000003c11238 @env={"SCRIPT_NAME"=>"", "SERVER_NAME"=>"localhost", "REQUEST_METHOD"=>"POST", "PATH_INFO"=>"/environments/_default/cookbook_versions", "QUERY_STRING"=>nil, "SERVER_PORT"=>8889, "HTTP_HOST"=>"localhost:8889", "rack.url_scheme"=>"chefzero", "rack.input"=>#<StringIO:0x00000003c113c8>}, @rest_base_prefix=["organizations", "chef"]>
[2016-01-27T15:13:30-05:00] DEBUG: {"run_list":["myhost"]}
[2016-01-27T15:13:33-05:00] DEBUG: 
--- RESPONSE (200) ---
{
  "myhost": {
...
    "files": [
...
      {
        "name": "python_runtime_pip.rb",
        "path": "files/halite_gem/poise_python/resources/python_runtime_pip.rb",
        "checksum": "a4686fdaaa0fea0a17f6d6f94132f928",
        "specificity": "halite_gem",
        "url": "chefzero://localhost:8889/file_store/repo/cookbooks/poise-python/files/halite_gem/poise_python/resources/python_runtime_pip.rb"
      },
...
ESC[0m
================================================================================ESC[0m
ESC[31mError executing action `install` on resource 'python_package[requests]'ESC[0m
================================================================================ESC[0m

ESC[0mMixlib::ShellOut::ShellCommandFailedESC[0m
------------------------------------ESC[0m
Expected process to exit with [0], but received '1'
ESC[0m---- Begin output of ["/bin/python", "-m", "pip.__main__", "list"] ----
ESC[0mSTDOUT: 
ESC[0mSTDERR: /bin/python: No module named pip
ESC[0m---- End output of ["/bin/python", "-m", "pip.__main__", "list"] ----
ESC[0mRan ["/bin/python", "-m", "pip.__main__", "list"] returned 1ESC[0m

ESC[0mCookbook Trace:ESC[0m
---------------ESC[0m
/root/.chef/local-mode-cache/cache/cookbooks/poise-languages/files/halite_gem/poise_languages/command/mixin.rb:201:in `tap'
ESC[0m/root/.chef/local-mode-cache/cache/cookbooks/poise-languages/files/halite_gem/poise_languages/command/mixin.rb:201:in `language_command_shell_out!'
ESC[0m/root/.chef/local-mode-cache/cache/cookbooks/poise-languages/files/halite_gem/poise_languages/command/mixin.rb:216:in `block in language_command_mixin'
ESC[0m/root/.chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/resources/python_package.rb:263:in `pip_command'
ESC[0m/root/.chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/resources/python_package.rb:158:in `check_package_versions'
ESC[0m/root/.chef/local-mode-cache/cache/cookbooks/poise-python/files/halite_gem/poise_python/resources/python_package.rb:144:in `load_current_resource'ESC[0m

ESC[0mResource Declaration:ESC[0m
---------------------ESC[0m
# In /root/.chef/local-mode-cache/cache/cookbooks/myhost/recipes/media.rb
ESC[0m
ESC[0m 17: python_package 'requests'
ESC[0m 18: 
ESC[0m
ESC[0mCompiled Resource:ESC[0m
------------------ESC[0m
# Declared in /root/.chef/local-mode-cache/cache/cookbooks/myhost/recipes/media.rb:17:in `from_file'
ESC[0m
ESC[0mpython_package("requests") do
ESC[0m  action [:install]
ESC[0m  retries 0
ESC[0m  retry_delay 2
ESC[0m  default_guard_interpreter :default
ESC[0m  package_name "requests"
ESC[0m  declared_type :python_package
ESC[0m  cookbook_name "myhost"
ESC[0m  recipe_name "media"
ESC[0m  parent_python nil
ESC[0mend
ESC[0m
ESC[0m

@et304383
Copy link

Amazon Linux uses EPEL 6.

I have had to do some hackin to get Amazon Linux to stop being stupid with regards to pip versions. As a result I've been uninstalling the yum packages python26-pip and python27-pip and trying to let your cookbook install. The server I'm working on apparently got into some state where those packages got reinstalled, then uninstalled, then the binaries were removed yet the dist-packages weren't removed.

coderanger added a commit that referenced this issue Jan 27, 2016
@coderanger
Copy link
Member

@gene1wood If you want to post the whole thing after python_runtime to a gist somewhere I can take a look.

@eric-tucker I don't actually test on Amazon Linux so I'm happy to take patches but I don't have much first-hand experience. I added the package names based on the published lists of packages for the latest version.

@coderanger
Copy link
Member

@eric-tucker Also it's odd that the bootstrap script would see pip but it wouldn't actually be available. I don't use the binaries in favor of python -m pip to reduce the chances of a misfire, so that would mean the pip code itself was uninstalled but the egg info data was left behind?

@et304383
Copy link

I'm not sure - Amazon Linux is a clusterf**k with regards to Python setup. I've managed to work around the issue by manually removing the dist-packages for pip then letting your cookbook reinstall (at which point get-pip.py succeeded).

@gene1wood
Copy link

@coderanger ok, I've simplified this a whole bunch and got the output. I created a brand new cookbook. I added a "depends 'poise-python'" to metadata.rb and a single line to the default recipe of python_package 'requests'

The output is here : https://gist.github.com/gene1wood/a7f4fb4555f8d25a4db1

@coderanger
Copy link
Member

@gene1wood That doesn't actually show the debug output from the Chef run, it's the output from chef zero.

@gene1wood
Copy link

@coderanger good point. I'll do some googling to see if I can figure out how to make chef-client show debug output.

@coderanger
Copy link
Member

@gene1wood Just using chef-solo instead of chef-client -z is probably enough.

@gene1wood
Copy link

Ok, here's what's going on. I think that poise-python assumes that the user will be running either the poise-python::default recipe or will have the python_runtime resource in their recipe prior to using the python_package resource. The execution flow for python_package has no code to trigger any of the logic that installs pip (In lib/poise_python/python_providers/base.rb it looks like action_install notifies install_pip which in turn calls python_runtime_pip), however none of this is triggered by python_package

If I add python_runtime "2" before my python_package "requests" line, then the cookbook installs SCL, a python27 environment in SCL and requests in the SCL environment.

Problem is, Centos 7 comes with python 2.7 natively and I have no need to use SCL or create a software collection.

Is there any way for the python_package resource to not assume that the recipe has the python_runtime resource in it and already executed? Maybe just check for the existence of the pip binary before trying to run pip and if it's missing install the distributions pip package (package 'python-pip')?

@coderanger
Copy link
Member

@gene1wood Yes you need to get a python_runtime resource in the mix somehow (either via the included recipe or yourself) or you need to be responsible for installing pip et al. You can install distro packages instead of SCL using the system provider, as outlined in the README:

python_runtime '2.7' do
  provider :system
end

(or set it via node attributes, python_runtime_options, etc).

Sounds like we have two unrelated bugs here. One is that the pip install is broken on Amazon Linux and the other was not having a python_runtime resource to handle the pip (and other support libs) install.

@gene1wood
Copy link

Yes, I think the Amazon Linux issue is probably best moved to a new issue (based on the title of this issue).

Ok, I'll probably just continue with a package 'python-pip' line before my python_package 'requests'. Maybe just add a check in python_package to output a clearer error message? I can imagine a user using this cookbook to install a python package, it failing and being confused.

Thanks for your help on this coderanger.

@coderanger
Copy link
Member

I mean the error seems pretty clear to me, pip wasn't installed because you weren't installing it. I set things up to allow not using python_runtime specifically for people that want to use distro packages or whatever to install pip/setuptools. If a python_runtime resource is present in the system, it uses that to find the path to the python binary, otherwise it does a normal $PATH lookup, and if all else fails it uses 'python'. This is consistent between all the poise language cookbooks.

@coderanger
Copy link
Member

Neither case explains @tduzan's original report though, so still need to figure that one out :)

@coderanger
Copy link
Member

Oh actually on closer reading, that is because of the SCL issue too, on CentOS 7 the pip binary would end up in /opt/rh/python27 somewhere, but poise-python never uses it so not actually important. Sounds like that covers all three issues, going to close this out.

@gene1wood
Copy link

Sounds good. Thanks!

@tduzan-te
Copy link
Author

I can confirm that adding :system to use the non-SCL provider does result in a working pip environment. However, I'm not sure why this is the case, because my python packages failed to install as well. If as you say, it's an issue merely with pathing, why would my python_package resource fail to complete afterwards.

Either way, I had refactored the cookbook using this to use poise/python instead and that worked fine for my needs. I'll consider refactoring back at some point in the near future.

Thanks.

@coderanger
Copy link
Member

@tduzan It probably wasn't failing, you were likely just later on using the wrong python binary/environment.

@tduzan-te
Copy link
Author

That's unlikely. The item being installed via pip was a service that installs to /usr/bin/, it was not present despite the python_package not reporting a failure.

Sign up for free to subscribe to this conversation on GitHub. Already have an account? Sign in.
Labels
None yet
Projects
None yet
Development

No branches or pull requests

4 participants