search

ptwobrussell / Mining-the-Social-Web-2nd-Edition

The official online compendium for Mining the Social Web, 2nd Edition (O'Reilly, 2013)
http://bit.ly/135dHfs
Other
2.9k stars 1.49k forks source link

problem Installing Virtual Machine : "Chef never successfully completed!" #259

Open tanguy0807 opened 9 years ago

tanguy0807 commented 9 years ago

Hi,

Sorry for contacting you via Amazon. I am new to programming, and that includes Github where I am discovering all the threads! Anyway, thank you very much for your quick answer and for showing yourself so available.

I tried to follow thoroughly all the advice in the Appendix A (including the video), but, despite several hours spent on it, I still can not manage to install the Ipython Notebook. As mentioned on Amazon, I first had a Git connection problem with my 10.6.8 Mac OS (after installing git-2.2.1), but it seems OK now I have installed git-1.8.4.2. .

Before launching Vagrant, I previously changed the "precise32" to "precise64" in the Vagrantfile in my user folder (as I have a 64 bits system). At this point, it is not clear if I have to launch Vagrant in my user folder, where I have a Vagrantfile, or in the "Mining-the-the-Social-Web-2nd-Edition" from which I connected (in the Appendix, it says "Run the following command from within the top level directory - which I understand as my user folder - that contains your Vagrantfile: vagrant up"). Anyway, I tried both. If I try in the "Mining-the-the-Social-Web-2nd-Edition" file (after typing vagrant destroy), a whole bunch of text appears, but It eventually stops with this message error :

==> default: [2015-02-09T17:18:38+00:00] FATAL: Chef::Exceptions::ChildConvergeError: Chef run process exited unsuccessfully (exit code 1) Chef never successfully completed! Any errors should be visible in the output above. Please fix your recipes so that they properly complete.

Here is the full output (colors are not the same in my bash): http://pastebin.com/bnFegqcH

I would really appreciate your help, since I was expecting to finish this in less than an hour, and I am craving to learn the real stuff!

tanguy0807 commented 9 years ago

Problem is fixed following issue #255 !

here's a recap of my system and the steps that I followed to solve the Chef problem :

Then, in the "Mining-the-Social-Web-2nd-Edition" folder, I entered in the following order:

ezehalac commented 9 years ago

I keep running into this issue... "Chef never successfully completed! " I have read every post here.. tried every combination of vagrant ssh commands, halts, reloads, destroys, downgraded to vagrant 171, etc etc! I have a macbook pro, running Yosemite 10.10.1, Vagrant 1.7.1, Virtualbox 4.3.20.. I followed the instructions on the video STEP by STEP. Please help! I have spent several hours trying to troubleshoot this. See below:

Bringing machine 'default' up with 'virtualbox' provider... ==> default: Importing base box 'precise64'... ==> default: Matching MAC address for NAT networking... ==> default: Setting the name of the VM: Mining-the-Social-Web-2nd-Edition_default_1423603782195_61233 ==> default: Clearing any previously set network interfaces... ==> default: Preparing network interfaces based on configuration... default: Adapter 1: nat ==> default: Forwarding ports... default: 8888 => 8888 (adapter 1) default: 5000 => 5000 (adapter 1) default: 27017 => 27017 (adapter 1) default: 27018 => 27018 (adapter 1) default: 27019 => 27019 (adapter 1) default: 28017 => 28017 (adapter 1) default: 22 => 2222 (adapter 1) ==> default: Running 'pre-boot' VM customizations... ==> default: Booting VM... ==> default: Waiting for machine to boot. This may take a few minutes... default: SSH address: 127.0.0.1:2222 default: SSH username: vagrant default: SSH auth method: private key default: default: Vagrant insecure key detected. Vagrant will automatically replace default: this with a newly generated keypair for better security. default: default: Inserting generated public key within guest... default: Removing insecure key from the guest if its present... default: Key inserted! Disconnecting and reconnecting using new SSH key... ==> default: Machine booted and ready! ==> default: Checking for guest additions in VM... default: The guest additions on this VM do not match the installed version of default: VirtualBox! In most cases this is fine, but in rare cases it can default: prevent things such as shared folders from working properly. If you see default: shared folder errors, please make sure the guest additions within the default: virtual machine match the version of VirtualBox you have installed on default: your host and reload your VM. default: default: Guest Additions Version: 4.2.0 default: VirtualBox Version: 4.3 ==> default: Mounting shared folders... default: /vagrant => /Users/ezehalac/Mining-the-Social-Web-2nd-Edition default: /tmp/vagrant-chef-6/chef-solo-1/cookbooks => /Users/ezehalac/Mining-the-Social-Web-2nd-Edition/deploy/cookbooks ==> default: Running provisioner: chef_solo... default: Installing Chef (latest)... Generating chef JSON and uploading... ==> default: Running chef-solo... ==> default: stdin: is not a tty ==> default: [2015-02-10T21:30:22+00:00] INFO: Forking chef instance to converge... ==> default: [2015-02-10T21:30:22+00:00] DEBUG: Fork successful. Waiting for new chef pid: 1632 ==> default: [2015-02-10T21:30:22+00:00] DEBUG: Forked instance now converging ==> default: [2015-02-10T21:30:22+00:00] INFO: * Chef 12.0.3 * ==> default: [2015-02-10T21:30:22+00:00] INFO: Chef-client pid: 1632 ==> default: [2015-02-10T21:30:22+00:00] DEBUG: Chef-client request_id: 747455c4-1e8b-45b9-84fd-b43bb5a83f78 ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Building node object for precise64 ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Extracting run list from JSON attributes provided on command line ==> default: [2015-02-10T21:30:23+00:00] INFO: Setting the run_list to ["recipe[mtsw2e::default]"] from CLI options ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Applying attributes from json file ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Platform is ubuntu version 12.04 ==> default: [2015-02-10T21:30:23+00:00] INFO: Run List is [recipe[mtsw2e::default]] ==> default: [2015-02-10T21:30:23+00:00] INFO: Run List expands to [mtsw2e::default] ==> default: [2015-02-10T21:30:23+00:00] INFO: Starting Chef Run for precise64 ==> default: [2015-02-10T21:30:23+00:00] INFO: Running start handlers ==> default: [2015-02-10T21:30:23+00:00] INFO: Start handlers complete. ==> default: [2015-02-10T21:30:23+00:00] DEBUG: No chefignore file found at /tmp/vagrant-chef-6/chef-solo-1/chefignore no files will be ignored ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Cookbooks to compile: [:apt, :"build-essential", :yum, :python, :runit, :mtsw2e] ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Loading cookbook runit's library file: /tmp/vagrant-chef-6/chef-solo-1/cookbooks/runit/libraries/default.rb ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Loading cookbook runit's library file: /tmp/vagrant-chef-6/chef-solo-1/cookbooks/runit/libraries/provider_runit_service.rb ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Loading cookbook runit's library file: /tmp/vagrant-chef-6/chef-solo-1/cookbooks/runit/libraries/resource_runit_service.rb ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Node precise64 loading cookbook apt's attribute file /tmp/vagrant-chef-6/chef-solo-1/cookbooks/apt/attributes/default.rb ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Loading Attribute apt::default ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Node precise64 loading cookbook build-essential's attribute file /tmp/vagrant-chef-6/chef-solo-1/cookbooks/build-essential/attributes/default.rb ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Loading Attribute build-essential::default ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Node precise64 loading cookbook yum's attribute file /tmp/vagrant-chef-6/chef-solo-1/cookbooks/yum/attributes/default.rb ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Loading Attribute yum::default ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Node precise64 loading cookbook yum's attribute file /tmp/vagrant-chef-6/chef-solo-1/cookbooks/yum/attributes/elrepo.rb ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Loading Attribute yum::elrepo ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Node precise64 loading cookbook yum's attribute file /tmp/vagrant-chef-6/chef-solo-1/cookbooks/yum/attributes/epel.rb ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Loading Attribute yum::epel ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Node precise64 loading cookbook yum's attribute file /tmp/vagrant-chef-6/chef-solo-1/cookbooks/yum/attributes/remi.rb ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Loading Attribute yum::remi ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Node precise64 loading cookbook python's attribute file /tmp/vagrant-chef-6/chef-solo-1/cookbooks/python/attributes/default.rb ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Loading Attribute python::default ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Node precise64 loading cookbook runit's attribute file /tmp/vagrant-chef-6/chef-solo-1/cookbooks/runit/attributes/default.rb ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Loading Attribute runit::default ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Loading cookbook apt's providers from /tmp/vagrant-chef-6/chef-solo-1/cookbooks/apt/providers/preference.rb ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Loaded contents of /tmp/vagrant-chef-6/chef-solo-1/cookbooks/apt/providers/preference.rb into a provider named apt_preference defined in Chef::Provider::AptPreference ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Loading cookbook apt's providers from /tmp/vagrant-chef-6/chef-solo-1/cookbooks/apt/providers/repository.rb ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Loaded contents of /tmp/vagrant-chef-6/chef-solo-1/cookbooks/apt/providers/repository.rb into a provider named apt_repository defined in Chef::Provider::AptRepository ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Loading cookbook apt's resources from /tmp/vagrant-chef-6/chef-solo-1/cookbooks/apt/resources/preference.rb ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Loaded contents of /tmp/vagrant-chef-6/chef-solo-1/cookbooks/apt/resources/preference.rb into a resource named apt_preference defined in Chef::Resource::AptPreference ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Loading cookbook apt's resources from /tmp/vagrant-chef-6/chef-solo-1/cookbooks/apt/resources/repository.rb ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Loaded contents of /tmp/vagrant-chef-6/chef-solo-1/cookbooks/apt/resources/repository.rb into a resource named apt_repository defined in Chef::Resource::AptRepository ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Loading cookbook yum's providers from /tmp/vagrant-chef-6/chef-solo-1/cookbooks/yum/providers/key.rb ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Loaded contents of /tmp/vagrant-chef-6/chef-solo-1/cookbooks/yum/providers/key.rb into a provider named yum_key defined in Chef::Provider::YumKey ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Loading cookbook yum's providers from /tmp/vagrant-chef-6/chef-solo-1/cookbooks/yum/providers/repository.rb ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Loaded contents of /tmp/vagrant-chef-6/chef-solo-1/cookbooks/yum/providers/repository.rb into a provider named yum_repository defined in Chef::Provider::YumRepository ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Loading cookbook yum's resources from /tmp/vagrant-chef-6/chef-solo-1/cookbooks/yum/resources/key.rb ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Loaded contents of /tmp/vagrant-chef-6/chef-solo-1/cookbooks/yum/resources/key.rb into a resource named yum_key defined in Chef::Resource::YumKey ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Loading cookbook yum's resources from /tmp/vagrant-chef-6/chef-solo-1/cookbooks/yum/resources/repository.rb ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Loaded contents of /tmp/vagrant-chef-6/chef-solo-1/cookbooks/yum/resources/repository.rb into a resource named yum_repository defined in Chef::Resource::YumRepository ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Loading cookbook python's providers from /tmp/vagrant-chef-6/chef-solo-1/cookbooks/python/providers/pip.rb ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Loaded contents of /tmp/vagrant-chef-6/chef-solo-1/cookbooks/python/providers/pip.rb into a provider named python_pip defined in Chef::Provider::PythonPip ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Loading cookbook python's providers from /tmp/vagrant-chef-6/chef-solo-1/cookbooks/python/providers/virtualenv.rb ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Loaded contents of /tmp/vagrant-chef-6/chef-solo-1/cookbooks/python/providers/virtualenv.rb into a provider named python_virtualenv defined in Chef::Provider::PythonVirtualenv ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Loading cookbook python's resources from /tmp/vagrant-chef-6/chef-solo-1/cookbooks/python/resources/pip.rb ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Loaded contents of /tmp/vagrant-chef-6/chef-solo-1/cookbooks/python/resources/pip.rb into a resource named python_pip defined in Chef::Resource::PythonPip ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Loading cookbook python's resources from /tmp/vagrant-chef-6/chef-solo-1/cookbooks/python/resources/virtualenv.rb ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Loaded contents of /tmp/vagrant-chef-6/chef-solo-1/cookbooks/python/resources/virtualenv.rb into a resource named python_virtualenv defined in Chef::Resource::PythonVirtualenv ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Loading Recipe mtsw2e::default via include_recipe ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Found recipe default in cookbook mtsw2e ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Loading Recipe apt via include_recipe ==> default: [2015-02-10T21:30:23+00:00] DEBUG: Found recipe default in cookbook apt ==> default: [2015-02-10T21:30:24+00:00] DEBUG: Loading Recipe runit via include_recipe ==> default: [2015-02-10T21:30:24+00:00] DEBUG: Found recipe default in cookbook runit ==> default: [2015-02-10T21:30:24+00:00] DEBUG: Caught InvalidVersionConstraint. This means that a key in value_for_platform cannot be interpreted as a Chef::VersionConstraint. ==> default: [2015-02-10T21:30:24+00:00] DEBUG: 'default' (Chef::Exceptions::InvalidVersionConstraint) ==> default: /opt/chef/embedded/apps/chef/lib/chef/version_constraint.rb:113:in parse' ==> default: /opt/chef/embedded/apps/chef/lib/chef/version_constraint.rb:36:ininitialize' ==> default: /opt/chef/embedded/apps/chef/lib/chef/dsl/platform_introspection.rb:79:in new' ==> default: /opt/chef/embedded/apps/chef/lib/chef/dsl/platform_introspection.rb:79:inblock in match_versions' ==> default: /opt/chef/embedded/apps/chef/lib/chef/dsl/platform_introspection.rb:77:in each' ==> default: /opt/chef/embedded/apps/chef/lib/chef/dsl/platform_introspection.rb:77:inmatch_versions' ==> default: /opt/chef/embedded/apps/chef/lib/chef/dsl/platform_introspection.rb:54:in value_for_node' ==> default: /opt/chef/embedded/apps/chef/lib/chef/dsl/platform_introspection.rb:149:invalue_for_platform' ==> default: /tmp/vagrant-chef-6/chef-solo-1/cookbooks/runit/recipes/default.rb:25:in block in from_file' ==> default: /opt/chef/embedded/apps/chef/lib/chef/dsl/recipe.rb:120:ininstance_eval' ==> default: /opt/chef/embedded/apps/chef/lib/chef/dsl/recipe.rb:120:in build_resource' ==> default: /opt/chef/embedded/apps/chef/lib/chef/dsl/recipe.rb:82:indeclare_resource' ==> default: /opt/chef/embedded/apps/chef/lib/chef/dsl/recipe.rb:42:in method_missing' ==> default: /tmp/vagrant-chef-6/chef-solo-1/cookbooks/runit/recipes/default.rb:24:infrom_file' ==> default: /opt/chef/embedded/apps/chef/lib/chef/mixin/from_file.rb:30:in instance_eval' ==> default: /opt/chef/embedded/apps/chef/lib/chef/mixin/from_file.rb:30:infrom_file' ==> default: /opt/chef/embedded/apps/chef/lib/chef/cookbook_version.rb:245:in load_recipe' ==> default: /opt/chef/embedded/apps/chef/lib/chef/run_context.rb:169:inload_recipe' ==> default: /opt/chef/embedded/apps/chef/lib/chef/run_context.rb:138:in block in include_recipe' ==> default: /opt/chef/embedded/apps/chef/lib/chef/run_context.rb:137:ineach' ==> default: /opt/chef/embedded/apps/chef/lib/chef/run_context.rb:137:in include_recipe' ==> default: /opt/chef/embedded/apps/chef/lib/chef/dsl/include_recipe.rb:26:ininclude_recipe' ==> default: /tmp/vagrant-chef-6/chef-solo-1/cookbooks/mtsw2e/recipes/default.rb:3:in from_file' ==> default: /opt/chef/embedded/apps/chef/lib/chef/mixin/from_file.rb:30:ininstance_eval' ==> default: /opt/chef/embedded/apps/chef/lib/chef/mixin/from_file.rb:30:in from_file' ==> default: /opt/chef/embedded/apps/chef/lib/chef/cookbook_version.rb:245:inload_recipe' ==> default: /opt/chef/embedded/apps/chef/lib/chef/run_context.rb:169:in load_recipe' ==> default: /opt/chef/embedded/apps/chef/lib/chef/run_context/cookbook_compiler.rb:140:inblock in compile_recipes' ==> default: /opt/chef/embedded/apps/chef/lib/chef/run_context/cookbook_compiler.rb:138:in each' ==> default: /opt/chef/embedded/apps/chef/lib/chef/run_context/cookbook_compiler.rb:138:incompile_recipes' ==> default: /opt/chef/embedded/apps/chef/lib/chef/run_context/cookbook_compiler.rb:75:in compile' ==> default: /opt/chef/embedded/apps/chef/lib/chef/run_context.rb:92:inload' ==> default: /opt/chef/embedded/apps/chef/lib/chef/policy_builder/expand_node_object.rb:73:in setup_run_context' ==> default: /opt/chef/embedded/apps/chef/lib/chef/client.rb:235:insetup_run_context' ==> default: /opt/chef/embedded/apps/chef/lib/chef/client.rb:397:in run' ==> default: /opt/chef/embedded/apps/chef/lib/chef/application.rb:261:inblock in fork_chef_client' ==> default: /opt/chef/embedded/apps/chef/lib/chef/application.rb:249:in fork' ==> default: /opt/chef/embedded/apps/chef/lib/chef/application.rb:249:infork_chef_client' ==> default: /opt/chef/embedded/apps/chef/lib/chef/application.rb:215:in block in run_chef_client' ==> default: /opt/chef/embedded/apps/chef/lib/chef/local_mode.rb:38:inwith_server_connectivity' ==> default: /opt/chef/embedded/apps/chef/lib/chef/application.rb:201:in run_chef_client' ==> default: /opt/chef/embedded/apps/chef/lib/chef/application/solo.rb:245:inblock in interval_run_chef_client' ==> default: /opt/chef/embedded/apps/chef/lib/chef/application/solo.rb:234:in loop' ==> default: /opt/chef/embedded/apps/chef/lib/chef/application/solo.rb:234:ininterval_run_chef_client' ==> default: /opt/chef/embedded/apps/chef/lib/chef/application/solo.rb:224:in run_application' ==> default: /opt/chef/embedded/apps/chef/lib/chef/application.rb:58:inrun' ==> default: /opt/chef/embedded/apps/chef/bin/chef-solo:25:in <top (required)>' ==> default: /usr/bin/chef-solo:40:inload' ==> default: /usr/bin/chef-solo:40:in <main>' ==> default: [2015-02-10T21:30:24+00:00] DEBUG: Caught InvalidVersionConstraint. This means that a key in value_for_platform cannot be interpreted as a Chef::VersionConstraint. ==> default: [2015-02-10T21:30:24+00:00] DEBUG: 'default' (Chef::Exceptions::InvalidVersionConstraint) ==> default: /opt/chef/embedded/apps/chef/lib/chef/version_constraint.rb:113:inparse' ==> default: /opt/chef/embedded/apps/chef/lib/chef/version_constraint.rb:36:in initialize' ==> default: /opt/chef/embedded/apps/chef/lib/chef/dsl/platform_introspection.rb:79:innew' ==> default: /opt/chef/embedded/apps/chef/lib/chef/dsl/platform_introspection.rb:79:in block in match_versions' ==> default: /opt/chef/embedded/apps/chef/lib/chef/dsl/platform_introspection.rb:77:ineach' ==> default: /opt/chef/embedded/apps/chef/lib/chef/dsl/platform_introspection.rb:77:in match_versions' ==> default: /opt/chef/embedded/apps/chef/lib/chef/dsl/platform_introspection.rb:54:invalue_for_node' ==> default: /opt/chef/embedded/apps/chef/lib/chef/dsl/platform_introspection.rb:149:in value_for_platform' ==> default: /tmp/vagrant-chef-6/chef-solo-1/cookbooks/runit/recipes/default.rb:85:inblock in from_file' ==> default: /opt/chef/embedded/apps/chef/lib/chef/dsl/recipe.rb:120:in instance_eval' ==> default: /opt/chef/embedded/apps/chef/lib/chef/dsl/recipe.rb:120:inbuild_resource' ==> default: /opt/chef/embedded/apps/chef/lib/chef/dsl/recipe.rb:82:in declare_resource' ==> default: /opt/chef/embedded/apps/chef/lib/chef/dsl/recipe.rb:42:inmethod_missing' ==> default: /tmp/vagrant-chef-6/chef-solo-1/cookbooks/runit/recipes/default.rb:80:in from_file' ==> default: /opt/chef/embedded/apps/chef/lib/chef/mixin/from_file.rb:30:ininstance_eval' ==> default: /opt/chef/embedded/apps/chef/lib/chef/mixin/from_file.rb:30:in from_file' ==> default: /opt/chef/embedded/apps/chef/lib/chef/cookbook_version.rb:245:inload_recipe' ==> default: /opt/chef/embedded/apps/chef/lib/chef/run_context.rb:169:in load_recipe' ==> default: /opt/chef/embedded/apps/chef/lib/chef/run_context.rb:138:inblock in include_recipe' ==> default: /opt/chef/embedded/apps/chef/lib/chef/run_context.rb:137:in each' ==> default: /opt/chef/embedded/apps/chef/lib/chef/run_context.rb:137:ininclude_recipe' ==> default: /opt/chef/embedded/apps/chef/lib/chef/dsl/include_recipe.rb:26:in include_recipe' ==> default: /tmp/vagrant-chef-6/chef-solo-1/cookbooks/mtsw2e/recipes/default.rb:3:infrom_file' ==> default: /opt/chef/embedded/apps/chef/lib/chef/mixin/from_file.rb:30:in instance_eval' ==> default: /opt/chef/embedded/apps/chef/lib/chef/mixin/from_file.rb:30:infrom_file' ==> default: /opt/chef/embedded/apps/chef/lib/chef/cookbook_version.rb:245:in load_recipe' ==> default: /opt/chef/embedded/apps/chef/lib/chef/run_context.rb:169:inload_recipe' ==> default: /opt/chef/embedded/apps/chef/lib/chef/run_context/cookbook_compiler.rb:140:in block in compile_recipes' ==> default: /opt/chef/embedded/apps/chef/lib/chef/run_context/cookbook_compiler.rb:138:ineach' ==> default: /opt/chef/embedded/apps/chef/lib/chef/run_context/cookbook_compiler.rb:138:in compile_recipes' ==> default: /opt/chef/embedded/apps/chef/lib/chef/run_context/cookbook_compiler.rb:75:incompile' ==> default: /opt/chef/embedded/apps/chef/lib/chef/run_context.rb:92:in load' ==> default: /opt/chef/embedded/apps/chef/lib/chef/policy_builder/expand_node_object.rb:73:insetup_run_context' ==> default: /opt/chef/embedded/apps/chef/lib/chef/client.rb:235:in setup_run_context' ==> default: /opt/chef/embedded/apps/chef/lib/chef/client.rb:397:inrun' ==> default: /opt/chef/embedded/apps/chef/lib/chef/application.rb:261:in block in fork_chef_client' ==> default: /opt/chef/embedded/apps/chef/lib/chef/application.rb:249:infork' ==> default: /opt/chef/embedded/apps/chef/lib/chef/application.rb:249:in fork_chef_client' ==> default: /opt/chef/embedded/apps/chef/lib/chef/application.rb:215:inblock in run_chef_client' ==> default: /opt/chef/embedded/apps/chef/lib/chef/local_mode.rb:38:in with_server_connectivity' ==> default: /opt/chef/embedded/apps/chef/lib/chef/application.rb:201:inrun_chef_client' ==> default: /opt/chef/embedded/apps/chef/lib/chef/application/solo.rb:245:in block in interval_run_chef_client' ==> default: /opt/chef/embedded/apps/chef/lib/chef/application/solo.rb:234:inloop' ==> default: /opt/chef/embedded/apps/chef/lib/chef/application/solo.rb:234:in interval_run_chef_client' ==> default: /opt/chef/embedded/apps/chef/lib/chef/application/solo.rb:224:inrun_application' ==> default: /opt/chef/embedded/apps/chef/lib/chef/application.rb:58:in run' ==> default: /opt/chef/embedded/apps/chef/bin/chef-solo:25:in<top (required)>' ==> default: /usr/bin/chef-solo:40:in load' ==> default: /usr/bin/chef-solo:40:in

' ==> default: [2015-02-10T21:30:24+00:00] DEBUG: Loading Recipe python via include_recipe ==> default: [2015-02-10T21:30:24+00:00] DEBUG: Found recipe default in cookbook python ==> default: [2015-02-10T21:30:24+00:00] DEBUG: Loading Recipe python::package via include_recipe ==> default: [2015-02-10T21:30:24+00:00] DEBUG: Found recipe package in cookbook python ==> default: [2015-02-10T21:30:24+00:00] DEBUG: Loading Recipe python::pip via include_recipe ==> default: [2015-02-10T21:30:24+00:00] DEBUG: Found recipe pip in cookbook python ==> default: [2015-02-10T21:30:24+00:00] DEBUG: Loading Recipe python::virtualenv via include_recipe ==> default: [2015-02-10T21:30:24+00:00] DEBUG: Found recipe virtualenv in cookbook python ==> default: [2015-02-10T21:30:24+00:00] DEBUG: Loading Recipe python::pip via include_recipe ==> default: [2015-02-10T21:30:24+00:00] DEBUG: I am not loading python::pip, because I have already seen it. ==> default: [2015-02-10T21:30:24+00:00] DEBUG: Loading from cookbook_path: /tmp/vagrant-chef-6/chef-solo-1/cookbooks ==> default: [2015-02-10T21:30:24+00:00] DEBUG: Converging node precise64 ==> default: [2015-02-10T21:30:24+00:00] INFO: Processing execute[apt-get-update] action run (apt::default line 22) ==> default: [2015-02-10T21:30:24+00:00] DEBUG: providers for generic execute resource enabled on node include: [Chef::Provider::Execute] ==> default: [2015-02-10T21:30:24+00:00] DEBUG: providers that refused resource execute[apt-get-update] were: [] ==> default: [2015-02-10T21:30:24+00:00] DEBUG: providers that support resource execute[apt-get-update] include: [Chef::Provider::Execute] ==> default: [2015-02-10T21:30:24+00:00] DEBUG: providers that survived replacement include: [Chef::Provider::Execute] ==> default: [2015-02-10T21:30:27+00:00] INFO: execute[apt-get-update] ran successfully ==> default: [2015-02-10T21:30:27+00:00] INFO: Processing execute[apt-get update] action nothing (apt::default line 29) ==> default: [2015-02-10T21:30:27+00:00] DEBUG: Skipping execute[apt-get update] due to action :nothing ==> default: [2015-02-10T21:30:27+00:00] INFO: Processing execute[apt-get autoremove] action nothing (apt::default line 36) ==> default: [2015-02-10T21:30:27+00:00] DEBUG: Skipping execute[apt-get autoremove] due to action :nothing ==> default: [2015-02-10T21:30:27+00:00] INFO: Processing execute[apt-get autoclean] action nothing (apt::default line 42) ==> default: [2015-02-10T21:30:27+00:00] DEBUG: Skipping execute[apt-get autoclean] due to action :nothing ==> default: [2015-02-10T21:30:27+00:00] INFO: Processing apt_package[update-notifier-common] action install (apt::default line 48) ==> default: [2015-02-10T21:30:27+00:00] DEBUG: providers for generic apt_package resource enabled on node include: [Chef::Provider::Package::Apt] ==> default: [2015-02-10T21:30:27+00:00] DEBUG: providers that refused resource apt_package[update-notifier-common] were: [] ==> default: [2015-02-10T21:30:27+00:00] DEBUG: providers that support resource apt_package[update-notifier-common] include: [Chef::Provider::Package::Apt] ==> default: [2015-02-10T21:30:27+00:00] DEBUG: providers that survived replacement include: [Chef::Provider::Package::Apt] ==> default: [2015-02-10T21:30:27+00:00] DEBUG: apt_package[update-notifier-common] checking package status for update-notifier-common ==> default: [2015-02-10T21:30:27+00:00] DEBUG: apt_package[update-notifier-common] current version is nil ==> default: [2015-02-10T21:30:27+00:00] DEBUG: apt_package[update-notifier-common] candidate version is 0.119ubuntu8.7 ==> default: [2015-02-10T21:30:34+00:00] INFO: apt_package[update-notifier-common] sending run action to executeapt-get-update ==> default: [2015-02-10T21:30:34+00:00] INFO: Processing execute[apt-get-update] action run (apt::default line 22) ==> default: [2015-02-10T21:30:34+00:00] DEBUG: providers for generic execute resource enabled on node include: [Chef::Provider::Execute] ==> default: [2015-02-10T21:30:34+00:00] DEBUG: providers that refused resource execute[apt-get-update] were: [] ==> default: [2015-02-10T21:30:34+00:00] DEBUG: providers that support resource execute[apt-get-update] include: [Chef::Provider::Execute] ==> default: [2015-02-10T21:30:34+00:00] DEBUG: providers that survived replacement include: [Chef::Provider::Execute] ==> default: [2015-02-10T21:30:37+00:00] INFO: execute[apt-get-update] ran successfully ==> default: [2015-02-10T21:30:37+00:00] INFO: Processing execute[apt-get-update-periodic] action run (apt::default line 52) ==> default: [2015-02-10T21:30:37+00:00] DEBUG: Skipping execute[apt-get-update-periodic] due to only_if ruby block ==> default: [2015-02-10T21:30:37+00:00] INFO: Processing directory[/var/cache/local] action create (apt::default line 62) ==> default: [2015-02-10T21:30:37+00:00] DEBUG: providers for generic directory resource enabled on node include: [Chef::Provider::Directory] ==> default: [2015-02-10T21:30:37+00:00] DEBUG: providers that refused resource directory[/var/cache/local] were: [] ==> default: [2015-02-10T21:30:37+00:00] DEBUG: providers that support resource directory[/var/cache/local] include: [Chef::Provider::Directory] ==> default: [2015-02-10T21:30:37+00:00] DEBUG: providers that survived replacement include: [Chef::Provider::Directory] ==> default: [2015-02-10T21:30:37+00:00] INFO: directory[/var/cache/local] created directory /var/cache/local ==> default: [2015-02-10T21:30:37+00:00] DEBUG: found current_mode == nil, so we are creating a new file, updating mode ==> default: [2015-02-10T21:30:37+00:00] DEBUG: found current_mode == nil, so we are creating a new file, updating mode ==> default: [2015-02-10T21:30:37+00:00] DEBUG: found current_uid == nil, so we are creating a new file, updating owner ==> default: [2015-02-10T21:30:37+00:00] DEBUG: found current_gid == nil, so we are creating a new file, updating group ==> default: [2015-02-10T21:30:37+00:00] DEBUG: found current_uid == nil, so we are creating a new file, updating owner ==> default: [2015-02-10T21:30:37+00:00] INFO: directory[/var/cache/local] owner changed to 0 ==> default: [2015-02-10T21:30:37+00:00] DEBUG: found current_gid == nil, so we are creating a new file, updating group ==> default: [2015-02-10T21:30:37+00:00] INFO: directory[/var/cache/local] group changed to 0 ==> default: [2015-02-10T21:30:37+00:00] DEBUG: found current_mode == nil, so we are creating a new file, updating mode ==> default: [2015-02-10T21:30:37+00:00] INFO: directory[/var/cache/local] mode changed to 755 ==> default: [2015-02-10T21:30:37+00:00] DEBUG: selinux utilities can not be found. Skipping selinux permission fixup. ==> default: [2015-02-10T21:30:37+00:00] INFO: Processing directory[/var/cache/local/preseeding] action create (apt::default line 62) ==> default: [2015-02-10T21:30:37+00:00] DEBUG: providers for generic directory resource enabled on node include: [Chef::Provider::Directory] ==> default: [2015-02-10T21:30:37+00:00] DEBUG: providers that refused resource directory[/var/cache/local/preseeding] were: [] ==> default: [2015-02-10T21:30:37+00:00] DEBUG: providers that support resource directory[/var/cache/local/preseeding] include: [Chef::Provider::Directory] ==> default: [2015-02-10T21:30:37+00:00] DEBUG: providers that survived replacement include: [Chef::Provider::Directory] ==> default: [2015-02-10T21:30:37+00:00] INFO: directory[/var/cache/local/preseeding] created directory /var/cache/local/preseeding ==> default: [2015-02-10T21:30:37+00:00] DEBUG: found current_mode == nil, so we are creating a new file, updating mode ==> default: [2015-02-10T21:30:37+00:00] DEBUG: found current_mode == nil, so we are creating a new file, updating mode ==> default: [2015-02-10T21:30:37+00:00] DEBUG: found current_uid == nil, so we are creating a new file, updating owner ==> default: [2015-02-10T21:30:37+00:00] DEBUG: found current_gid == nil, so we are creating a new file, updating group ==> default: [2015-02-10T21:30:37+00:00] DEBUG: found current_uid == nil, so we are creating a new file, updating owner ==> default: [2015-02-10T21:30:37+00:00] INFO: directory[/var/cache/local/preseeding] owner changed to 0 ==> default: [2015-02-10T21:30:37+00:00] DEBUG: found current_gid == nil, so we are creating a new file, updating group ==> default: [2015-02-10T21:30:37+00:00] INFO: directory[/var/cache/local/preseeding] group changed to 0 ==> default: [2015-02-10T21:30:37+00:00] DEBUG: found current_mode == nil, so we are creating a new file, updating mode ==> default: [2015-02-10T21:30:37+00:00] INFO: directory[/var/cache/local/preseeding] mode changed to 755 ==> default: [2015-02-10T21:30:37+00:00] DEBUG: selinux utilities can not be found. Skipping selinux permission fixup. ==> default: [2015-02-10T21:30:37+00:00] INFO: Processing service[runit] action nothing (runit::default line 20) ==> default: [2015-02-10T21:30:37+00:00] DEBUG: Skipping service[runit] due to action :nothing ==> default: [2015-02-10T21:30:37+00:00] INFO: Processing execute[start-runsvdir] action nothing (runit::default line 24) ==> default: [2015-02-10T21:30:37+00:00] DEBUG: Skipping execute[start-runsvdir] due to action :nothing ==> default: [2015-02-10T21:30:37+00:00] INFO: Processing execute[runit-hup-init] action nothing (runit::default line 33) ==> default: [2015-02-10T21:30:37+00:00] DEBUG: Skipping execute[runit-hup-init] due to action :nothing ==> default: [2015-02-10T21:30:37+00:00] INFO: Processing apt_package[runit] action install (runit::default line 80) ==> default: [2015-02-10T21:30:37+00:00] DEBUG: providers for generic apt_package resource enabled on node include: [Chef::Provider::Package::Apt] ==> default: [2015-02-10T21:30:37+00:00] DEBUG: providers that refused resource apt_package[runit] were: [] ==> default: [2015-02-10T21:30:37+00:00] DEBUG: providers that support resource apt_package[runit] include: [Chef::Provider::Package::Apt] ==> default: [2015-02-10T21:30:37+00:00] DEBUG: providers that survived replacement include: [Chef::Provider::Package::Apt] ==> default: [2015-02-10T21:30:37+00:00] DEBUG: apt_package[runit] checking package status for runit ==> default: [2015-02-10T21:30:37+00:00] DEBUG: apt_package[runit] current version is nil ==> default: [2015-02-10T21:30:37+00:00] DEBUG: apt_package[runit] candidate version is 2.1.1-6.2ubuntu2.1 ==> default: [2015-02-10T21:30:37+00:00] DEBUG: Creating directory /var/chef/cache/preseed ==> default: [2015-02-10T21:30:37+00:00] DEBUG: Creating directory /var/chef/cache/preseed/runit ==> default: [2015-02-10T21:30:37+00:00] DEBUG: apt_package[runit] fetching preseed file to /var/chef/cache/preseed/runit/runit-2.1.1-6.2ubuntu2.1.seed ==> default: [2015-02-10T21:30:37+00:00] DEBUG: apt_package[runit] fetching preseed file via cookbook_file ==> default: [2015-02-10T21:30:37+00:00] INFO: Processing cookbook_file[/var/chef/cache/preseed/runit/runit-2.1.1-6.2ubuntu2.1.seed] action create (dynamically defined) ==> default: [2015-02-10T21:30:37+00:00] DEBUG: cookbook_file[/var/chef/cache/preseed/runit/runit-2.1.1-6.2ubuntu2.1.seed] staging /tmp/vagrant-chef-6/chef-solo-1/cookbooks/runit/files/default/runit.seed to /var/chef/cache/preseed/runit/.runit-2.1.1-6.2ubuntu2.1.seed20150210-1632-tqv74r ==> default: [2015-02-10T21:30:37+00:00] DEBUG: touching /var/chef/cache/preseed/runit/runit-2.1.1-6.2ubuntu2.1.seed to create it ==> default: [2015-02-10T21:30:37+00:00] INFO: cookbook_file[/var/chef/cache/preseed/runit/runit-2.1.1-6.2ubuntu2.1.seed] created file /var/chef/cache/preseed/runit/runit-2.1.1-6.2ubuntu2.1.seed ==> default: [2015-02-10T21:30:37+00:00] DEBUG: calculating checksum of /var/chef/cache/preseed/runit/.runit-2.1.1-6.2ubuntu2.1.seed20150210-1632-tqv74r to compare with ==> default: [2015-02-10T21:30:37+00:00] DEBUG: running: diff -u /var/chef/cache/preseed/runit/runit-2.1.1-6.2ubuntu2.1.seed /var/chef/cache/preseed/runit/.runit-2.1.1-6.2ubuntu2.1.seed20150210-1632-tqv74r ==> default: [2015-02-10T21:30:37+00:00] DEBUG: reading modes from /var/chef/cache/preseed/runit/runit-2.1.1-6.2ubuntu2.1.seed file ==> default: [2015-02-10T21:30:37+00:00] DEBUG: applying mode = 644, uid = 0, gid = 0 to /var/chef/cache/preseed/runit/.runit-2.1.1-6.2ubuntu2.1.seed20150210-1632-tqv74r ==> default: [2015-02-10T21:30:37+00:00] DEBUG: moving temporary file /var/chef/cache/preseed/runit/.runit-2.1.1-6.2ubuntu2.1.seed20150210-1632-tqv74r into place at /var/chef/cache/preseed/runit/runit-2.1.1-6.2ubuntu2.1.seed ==> default: [2015-02-10T21:30:37+00:00] INFO: cookbook_file[/var/chef/cache/preseed/runit/runit-2.1.1-6.2ubuntu2.1.seed] updated file contents /var/chef/cache/preseed/runit/runit-2.1.1-6.2ubuntu2.1.seed ==> default: [2015-02-10T21:30:37+00:00] DEBUG: found target_mode == nil, so no mode was specified on resource, not managing mode ==> default: [2015-02-10T21:30:37+00:00] DEBUG: found target_uid == nil, so no owner was specified on resource, not managing owner ==> default: [2015-02-10T21:30:37+00:00] DEBUG: found target_gid == nil, so no group was specified on resource, not managing group ==> default: [2015-02-10T21:30:37+00:00] DEBUG: selinux utilities can not be found. Skipping selinux permission fixup. ==> default: [2015-02-10T21:30:37+00:00] DEBUG: apt_package[runit] fetched preseed file to /var/chef/cache/preseed/runit/runit-2.1.1-6.2ubuntu2.1.seed ==> default: [2015-02-10T21:30:37+00:00] INFO: apt_package[runit] pre-seeding package installation instructions ==> default: [2015-02-10T21:30:40+00:00] INFO: apt_package[runit] sending nothing action to executestart-runsvdir ==> default: [2015-02-10T21:30:40+00:00] INFO: Processing execute[start-runsvdir] action nothing (runit::default line 24) ==> default: [2015-02-10T21:30:40+00:00] DEBUG: Skipping execute[start-runsvdir] due to action :nothing ==> default: [2015-02-10T21:30:40+00:00] INFO: apt_package[runit] sending nothing action to executerunit-hup-init ==> default: [2015-02-10T21:30:40+00:00] INFO: Processing execute[runit-hup-init] action nothing (runit::default line 33) ==> default: [2015-02-10T21:30:40+00:00] DEBUG: Skipping execute[runit-hup-init] due to action :nothing ==> default: [2015-02-10T21:30:40+00:00] INFO: Processing apt_package[python] action install (python::package line 40) ==> default: [2015-02-10T21:30:40+00:00] DEBUG: providers for generic apt_package resource enabled on node include: [Chef::Provider::Package::Apt] ==> default: [2015-02-10T21:30:40+00:00] DEBUG: providers that refused resource apt_package[python] were: [] ==> default: [2015-02-10T21:30:40+00:00] DEBUG: providers that support resource apt_package[python] include: [Chef::Provider::Package::Apt] ==> default: [2015-02-10T21:30:40+00:00] DEBUG: providers that survived replacement include: [Chef::Provider::Package::Apt] ==> default: [2015-02-10T21:30:40+00:00] DEBUG: apt_package[python] checking package status for python ==> default: [2015-02-10T21:30:40+00:00] DEBUG: apt_package[python] current version is 2.7.3-0ubuntu2 ==> default: [2015-02-10T21:30:40+00:00] DEBUG: apt_package[python] candidate version is 2.7.3-0ubuntu2.2 ==> default: [2015-02-10T21:30:40+00:00] DEBUG: apt_package[python] is already installed - nothing to do ==> default: [2015-02-10T21:30:40+00:00] INFO: Processing apt_package[python-dev] action install (python::package line 40) ==> default: [2015-02-10T21:30:40+00:00] DEBUG: providers for generic apt_package resource enabled on node include: [Chef::Provider::Package::Apt] ==> default: [2015-02-10T21:30:40+00:00] DEBUG: providers that refused resource apt_package[python-dev] were: [] ==> default: [2015-02-10T21:30:40+00:00] DEBUG: providers that support resource apt_package[python-dev] include: [Chef::Provider::Package::Apt] ==> default: [2015-02-10T21:30:40+00:00] DEBUG: providers that survived replacement include: [Chef::Provider::Package::Apt] ==> default: [2015-02-10T21:30:40+00:00] DEBUG: apt_package[python-dev] checking package status for python-dev ==> default: [2015-02-10T21:30:40+00:00] DEBUG: apt_package[python-dev] current version is nil ==> default: [2015-02-10T21:30:40+00:00] DEBUG: apt_package[python-dev] candidate version is 2.7.3-0ubuntu2.2 ==> default: [2015-02-10T21:30:52+00:00] INFO: Processing remote_file[/var/chef/cache/ez_setup.py] action create (python::pip line 36) ==> default: [2015-02-10T21:30:52+00:00] DEBUG: remote_file[/var/chef/cache/ez_setup.py] checking for changes ==> default: [2015-02-10T21:30:52+00:00] DEBUG: Cache control headers: {} ==> default: [2015-02-10T21:30:52+00:00] DEBUG: Chef::HTTP calling Chef::HTTP::Decompressor#handle_request ==> default: [2015-02-10T21:30:52+00:00] DEBUG: Chef::HTTP calling Chef::HTTP::CookieManager#handle_request ==> default: [2015-02-10T21:30:52+00:00] DEBUG: Chef::HTTP calling Chef::HTTP::ValidateContentLength#handle_request ==> default: [2015-02-10T21:30:52+00:00] DEBUG: Initiating GET to https://bitbucket.org/pypa/setuptools/raw/0.8/ez_setup.py ==> default: [2015-02-10T21:30:52+00:00] DEBUG: ---- HTTP Request Header Data: ---- ==> default: [2015-02-10T21:30:52+00:00] DEBUG: Accept-Encoding: gzip;q=1.0,deflate;q=0.6,identity;q=0.3 ==> default: [2015-02-10T21:30:52+00:00] DEBUG: ---- End HTTP Request Header Data ---- ==> default: [2015-02-10T21:30:52+00:00] DEBUG: ---- HTTP Status and Header Data: ---- ==> default: [2015-02-10T21:30:52+00:00] DEBUG: HTTP 1.1 200 OK ==> default: [2015-02-10T21:30:52+00:00] DEBUG: server: nginx/1.5.10 ==> default: [2015-02-10T21:30:52+00:00] DEBUG: date: Tue, 10 Feb 2015 21:30:53 GMT ==> default: [2015-02-10T21:30:52+00:00] DEBUG: content-type: text/plain ==> default: [2015-02-10T21:30:52+00:00] DEBUG: transfer-encoding: chunked ==> default: [2015-02-10T21:30:52+00:00] DEBUG: connection: close ==> default: [2015-02-10T21:30:52+00:00] DEBUG: vary: Accept-Language, Cookie ==> default: [2015-02-10T21:30:52+00:00] DEBUG: x-served-by: app16 ==> default: [2015-02-10T21:30:52+00:00] DEBUG: x-render-time: 0.0463080406189 ==> default: [2015-02-10T21:30:52+00:00] DEBUG: content-language: en ==> default: [2015-02-10T21:30:52+00:00] DEBUG: cache-control: max-age=0 ==> default: [2015-02-10T21:30:52+00:00] DEBUG: x-request-count: 70 ==> default: [2015-02-10T21:30:52+00:00] DEBUG: expires: Tue, 10 Feb 2015 21:30:53 GMT ==> default: [2015-02-10T21:30:52+00:00] DEBUG: x-frame-options: SAMEORIGIN ==> default: [2015-02-10T21:30:52+00:00] DEBUG: last-modified: Tue, 10 Feb 2015 21:30:53 GMT ==> default: [2015-02-10T21:30:52+00:00] DEBUG: x-static-version: dac75071f136 ==> default: [2015-02-10T21:30:52+00:00] DEBUG: x-version: dac75071f136 ==> default: [2015-02-10T21:30:52+00:00] DEBUG: strict-transport-security: max-age=31536000 ==> default: [2015-02-10T21:30:52+00:00] DEBUG: x-content-type-options: nosniff ==> default: [2015-02-10T21:30:52+00:00] DEBUG: content-encoding: gzip ==> default: [2015-02-10T21:30:52+00:00] DEBUG: ---- End HTTP Status/Header Data ---- ==> default: [2015-02-10T21:30:52+00:00] DEBUG: Streaming download from https://bitbucket.org/pypa/setuptools/raw/0.8/ez_setup.py to tempfile /tmp/chef-rest20150210-1632-rtulqr ==> default: [2015-02-10T21:30:52+00:00] DEBUG: Initializing gzip stream deflator ==> default: [2015-02-10T21:30:52+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:52+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:52+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:52+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:52+00:00] DEBUG: Chef::HTTP calling Chef::HTTP::ValidateContentLength#handle_stream_complete ==> default: [2015-02-10T21:30:52+00:00] DEBUG: HTTP server did not include a Content-Length header in response, cannot identify truncated downloads. ==> default: [2015-02-10T21:30:52+00:00] DEBUG: Chef::HTTP calling Chef::HTTP::CookieManager#handle_stream_complete ==> default: [2015-02-10T21:30:52+00:00] DEBUG: Chef::HTTP calling Chef::HTTP::Decompressor#handle_stream_complete ==> default: [2015-02-10T21:30:52+00:00] DEBUG: Creating directory /var/chef/cache/remote_file ==> default: [2015-02-10T21:30:52+00:00] DEBUG: touching /var/chef/cache/ez_setup.py to create it ==> default: [2015-02-10T21:30:52+00:00] INFO: remote_file[/var/chef/cache/ez_setup.py] created file /var/chef/cache/ez_setup.py ==> default: [2015-02-10T21:30:52+00:00] DEBUG: calculating checksum of /tmp/chef-rest20150210-1632-rtulqr to compare with ==> default: [2015-02-10T21:30:52+00:00] DEBUG: running: diff -u /var/chef/cache/ez_setup.py /tmp/chef-rest20150210-1632-rtulqr ==> default: [2015-02-10T21:30:52+00:00] DEBUG: reading modes from /var/chef/cache/ez_setup.py file ==> default: [2015-02-10T21:30:52+00:00] DEBUG: applying mode = 644, uid = 0, gid = 0 to /tmp/chef-rest20150210-1632-rtulqr ==> default: [2015-02-10T21:30:52+00:00] DEBUG: moving temporary file /tmp/chef-rest20150210-1632-rtulqr into place at /var/chef/cache/ez_setup.py ==> default: [2015-02-10T21:30:52+00:00] INFO: remote_file[/var/chef/cache/ez_setup.py] updated file contents /var/chef/cache/ez_setup.py ==> default: [2015-02-10T21:30:52+00:00] DEBUG: found current_mode == nil, so we are creating a new file, updating mode ==> default: [2015-02-10T21:30:52+00:00] DEBUG: found current_mode == nil, so we are creating a new file, updating mode ==> default: [2015-02-10T21:30:52+00:00] DEBUG: found target_uid == nil, so no owner was specified on resource, not managing owner ==> default: [2015-02-10T21:30:52+00:00] DEBUG: found target_gid == nil, so no group was specified on resource, not managing group ==> default: [2015-02-10T21:30:52+00:00] DEBUG: found target_uid == nil, so no owner was specified on resource, not managing owner ==> default: [2015-02-10T21:30:52+00:00] DEBUG: found target_gid == nil, so no group was specified on resource, not managing group ==> default: [2015-02-10T21:30:52+00:00] DEBUG: found current_mode == nil, so we are creating a new file, updating mode ==> default: [2015-02-10T21:30:52+00:00] INFO: remote_file[/var/chef/cache/ez_setup.py] mode changed to 644 ==> default: [2015-02-10T21:30:52+00:00] DEBUG: selinux utilities can not be found. Skipping selinux permission fixup. ==> default: [2015-02-10T21:30:52+00:00] INFO: Processing remote_file[/var/chef/cache/get-pip.py] action create (python::pip line 42) ==> default: [2015-02-10T21:30:52+00:00] DEBUG: remote_file[/var/chef/cache/get-pip.py] checking for changes ==> default: [2015-02-10T21:30:52+00:00] DEBUG: Cache control headers: {} ==> default: [2015-02-10T21:30:52+00:00] DEBUG: Chef::HTTP calling Chef::HTTP::Decompressor#handle_request ==> default: [2015-02-10T21:30:52+00:00] DEBUG: Chef::HTTP calling Chef::HTTP::CookieManager#handle_request ==> default: [2015-02-10T21:30:52+00:00] DEBUG: Chef::HTTP calling Chef::HTTP::ValidateContentLength#handle_request ==> default: [2015-02-10T21:30:52+00:00] DEBUG: Initiating GET to https://raw.github.com/pypa/pip/master/contrib/get-pip.py ==> default: [2015-02-10T21:30:52+00:00] DEBUG: ---- HTTP Request Header Data: ---- ==> default: [2015-02-10T21:30:52+00:00] DEBUG: Accept-Encoding: gzip;q=1.0,deflate;q=0.6,identity;q=0.3 ==> default: [2015-02-10T21:30:52+00:00] DEBUG: ---- End HTTP Request Header Data ---- ==> default: [2015-02-10T21:30:53+00:00] DEBUG: ---- HTTP Status and Header Data: ---- ==> default: [2015-02-10T21:30:53+00:00] DEBUG: HTTP 1.1 301 Moved Permanently ==> default: [2015-02-10T21:30:53+00:00] DEBUG: date: Tue, 10 Feb 2015 21:30:54 GMT ==> default: [2015-02-10T21:30:53+00:00] DEBUG: server: Apache ==> default: [2015-02-10T21:30:53+00:00] DEBUG: location: https://raw.githubusercontent.com/pypa/pip/master/contrib/get-pip.py ==> default: [2015-02-10T21:30:53+00:00] DEBUG: content-length: 0 ==> default: [2015-02-10T21:30:53+00:00] DEBUG: accept-ranges: bytes ==> default: [2015-02-10T21:30:53+00:00] DEBUG: via: 1.1 varnish ==> default: [2015-02-10T21:30:53+00:00] DEBUG: age: 0 ==> default: [2015-02-10T21:30:53+00:00] DEBUG: x-served-by: cache-dfw1824-DFW ==> default: [2015-02-10T21:30:53+00:00] DEBUG: x-cache: MISS ==> default: [2015-02-10T21:30:53+00:00] DEBUG: x-cache-hits: 0 ==> default: [2015-02-10T21:30:53+00:00] DEBUG: vary: Accept-Encoding ==> default: [2015-02-10T21:30:53+00:00] DEBUG: connection: close ==> default: [2015-02-10T21:30:53+00:00] DEBUG: ---- End HTTP Status/Header Data ---- ==> default: [2015-02-10T21:30:53+00:00] DEBUG: ---- HTTP Response Body ---- ==> default: [2015-02-10T21:30:53+00:00] DEBUG: ==> default: [2015-02-10T21:30:53+00:00] DEBUG: ---- End HTTP Response Body ----- ==> default: [2015-02-10T21:30:53+00:00] DEBUG: Chef::HTTP calling Chef::HTTP::ValidateContentLength#handle_stream_complete ==> default: [2015-02-10T21:30:53+00:00] DEBUG: No content-length information collected for the streamed download, cannot identify streamed download. ==> default: [2015-02-10T21:30:53+00:00] DEBUG: Chef::HTTP calling Chef::HTTP::CookieManager#handle_stream_complete ==> default: [2015-02-10T21:30:53+00:00] DEBUG: Chef::HTTP calling Chef::HTTP::Decompressor#handle_stream_complete ==> default: [2015-02-10T21:30:53+00:00] DEBUG: Following redirect 1/10 ==> default: [2015-02-10T21:30:53+00:00] DEBUG: Initiating GET to https://raw.githubusercontent.com/pypa/pip/master/contrib/get-pip.py ==> default: [2015-02-10T21:30:53+00:00] DEBUG: ---- HTTP Request Header Data: ---- ==> default: [2015-02-10T21:30:53+00:00] DEBUG: Accept-Encoding: gzip;q=1.0,deflate;q=0.6,identity;q=0.3 ==> default: [2015-02-10T21:30:53+00:00] DEBUG: ---- End HTTP Request Header Data ---- ==> default: [2015-02-10T21:30:54+00:00] DEBUG: ---- HTTP Status and Header Data: ---- ==> default: [2015-02-10T21:30:54+00:00] DEBUG: HTTP 1.1 200 OK ==> default: [2015-02-10T21:30:54+00:00] DEBUG: date: Tue, 10 Feb 2015 21:30:55 GMT ==> default: [2015-02-10T21:30:54+00:00] DEBUG: server: Apache ==> default: [2015-02-10T21:30:54+00:00] DEBUG: access-control-allow-origin: https://render.githubusercontent.com ==> default: [2015-02-10T21:30:54+00:00] DEBUG: content-security-policy: default-src 'none' ==> default: [2015-02-10T21:30:54+00:00] DEBUG: x-xss-protection: 1; mode=block ==> default: [2015-02-10T21:30:54+00:00] DEBUG: x-frame-options: deny ==> default: [2015-02-10T21:30:54+00:00] DEBUG: x-content-type-options: nosniff ==> default: [2015-02-10T21:30:54+00:00] DEBUG: strict-transport-security: max-age=31536000 ==> default: [2015-02-10T21:30:54+00:00] DEBUG: etag: "ace0eaab94f9b0d07fe7b6bbdf01b9ff7ff1efbc" ==> default: [2015-02-10T21:30:54+00:00] DEBUG: content-type: text/plain; charset=utf-8 ==> default: [2015-02-10T21:30:54+00:00] DEBUG: cache-control: max-age=300 ==> default: [2015-02-10T21:30:54+00:00] DEBUG: content-encoding: gzip ==> default: [2015-02-10T21:30:54+00:00] DEBUG: content-length: 1288630 ==> default: [2015-02-10T21:30:54+00:00] DEBUG: accept-ranges: bytes ==> default: [2015-02-10T21:30:54+00:00] DEBUG: via: 1.1 varnish ==> default: [2015-02-10T21:30:54+00:00] DEBUG: x-served-by: cache-dfw1835-DFW ==> default: [2015-02-10T21:30:54+00:00] DEBUG: x-cache: MISS ==> default: [2015-02-10T21:30:54+00:00] DEBUG: x-cache-hits: 0 ==> default: [2015-02-10T21:30:54+00:00] DEBUG: vary: Authorization,Accept-Encoding ==> default: [2015-02-10T21:30:54+00:00] DEBUG: expires: Tue, 10 Feb 2015 21:35:55 GMT ==> default: [2015-02-10T21:30:54+00:00] DEBUG: source-age: 0 ==> default: [2015-02-10T21:30:54+00:00] DEBUG: connection: close ==> default: [2015-02-10T21:30:54+00:00] DEBUG: ---- End HTTP Status/Header Data ---- ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Streaming download from https://raw.github.com/pypa/pip/master/contrib/get-pip.py to tempfile /tmp/chef-rest20150210-1632-1tpcbxq ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Initializing gzip stream deflator ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:54+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::ValidateContentLength::ContentLengthCounter#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP::StreamHandler calling Chef::HTTP::Decompressor::GzipInflater#handle_chunk ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP calling Chef::HTTP::ValidateContentLength#handle_stream_complete ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Content-Length validated correctly. ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP calling Chef::HTTP::CookieManager#handle_stream_complete ==> default: [2015-02-10T21:30:55+00:00] DEBUG: Chef::HTTP calling Chef::HTTP::Decompressor#handle_stream_complete ==> default: [2015-02-10T21:30:55+00:00] DEBUG: touching /var/chef/cache/get-pip.py to create it ==> default: [2015-02-10T21:30:55+00:00] INFO: remote_file[/var/chef/cache/get-pip.py] created file /var/chef/cache/get-pip.py ==> default: [2015-02-10T21:30:55+00:00] DEBUG: calculating checksum of /tmp/chef-rest20150210-1632-1tpcbxq to compare with ==> default: [2015-02-10T21:30:56+00:00] DEBUG: running: diff -u /var/chef/cache/get-pip.py /tmp/chef-rest20150210-1632-1tpcbxq ==> default: [2015-02-10T21:30:56+00:00] DEBUG: reading modes from /var/chef/cache/get-pip.py file ==> default: [2015-02-10T21:30:56+00:00] DEBUG: applying mode = 644, uid = 0, gid = 0 to /tmp/chef-rest20150210-1632-1tpcbxq ==> default: [2015-02-10T21:30:56+00:00] DEBUG: moving temporary file /tmp/chef-rest20150210-1632-1tpcbxq into place at /var/chef/cache/get-pip.py ==> default: [2015-02-10T21:30:56+00:00] INFO: remote_file[/var/chef/cache/get-pip.py] updated file contents /var/chef/cache/get-pip.py ==> default: [2015-02-10T21:30:56+00:00] DEBUG: found current_mode == nil, so we are creating a new file, updating mode ==> default: [2015-02-10T21:30:56+00:00] DEBUG: found current_mode == nil, so we are creating a new file, updating mode ==> default: [2015-02-10T21:30:56+00:00] DEBUG: found target_uid == nil, so no owner was specified on resource, not managing owner ==> default: [2015-02-10T21:30:56+00:00] DEBUG: found target_gid == nil, so no group was specified on resource, not managing group ==> default: [2015-02-10T21:30:56+00:00] DEBUG: found target_uid == nil, so no owner was specified on resource, not managing owner ==> default: [2015-02-10T21:30:56+00:00] DEBUG: found target_gid == nil, so no group was specified on resource, not managing group ==> default: [2015-02-10T21:30:56+00:00] DEBUG: found current_mode == nil, so we are creating a new file, updating mode ==> default: [2015-02-10T21:30:56+00:00] INFO: remote_file[/var/chef/cache/get-pip.py] mode changed to 644 ==> default: [2015-02-10T21:30:56+00:00] DEBUG: selinux utilities can not be found. Skipping selinux permission fixup. ==> default: [2015-02-10T21:30:56+00:00] INFO: Processing execute[install-setuptools] action run (python::pip line 48) ==> default: [2015-02-10T21:30:56+00:00] INFO: Processing execute[Guard resource] action run (dynamically defined) ==> default: [2015-02-10T21:30:56+00:00] DEBUG: providers for generic execute resource enabled on node include: [Chef::Provider::Execute] ==> default: [2015-02-10T21:30:56+00:00] DEBUG: providers that refused resource execute[Guard resource] were: [] ==> default: [2015-02-10T21:30:56+00:00] DEBUG: providers that support resource execute[Guard resource] include: [Chef::Provider::Execute] ==> default: [2015-02-10T21:30:56+00:00] DEBUG: providers that survived replacement include: [Chef::Provider::Execute] ==> default: [2015-02-10T21:30:56+00:00] DEBUG: providers for generic execute resource enabled on node include: [Chef::Provider::Execute] ==> default: [2015-02-10T21:30:56+00:00] DEBUG: providers that refused resource execute[install-setuptools] were: [] ==> default: [2015-02-10T21:30:56+00:00] DEBUG: providers that support resource execute[install-setuptools] include: [Chef::Provider::Execute] ==> default: [2015-02-10T21:30:56+00:00] DEBUG: providers that survived replacement include: [Chef::Provider::Execute] ==> default: ==> default: ================================================================================ ==> default: Error executing action run on resource 'execute[install-setuptools]' ==> default: ================================================================================ ==> default: ==> default: ==> default: Mixlib::ShellOut::ShellCommandFailed ==> default: ------------------------------------ ==> default: Expected process to exit with [0], but received '127' ==> default: ---- Begin output of /bin/python ez_setup.py ==> default: ---- ==> default: STDOUT: ==> default: STDERR: sh: 1: /bin/python: not found ==> default: ---- End output of /bin/python ez_setup.py ==> default: ---- ==> default: Ran /bin/python ez_setup.py ==> default: returned 127 ==> default: ==> default: ==> default: Resource Declaration: ==> default: --------------------- ==> default: # In /tmp/vagrant-chef-6/chef-solo-1/cookbooks/python/recipes/pip.rb ==> default: ==> default: 48: execute "install-setuptools" do ==> default: ==> default: 49: cwd Chef::Config[:file_cache_path] ==> default: 50: command <<-EOF ==> default: 51: #{node['python']['binary']} ez_setup.py ==> default: ==> default: 52: EOF ==> default: 53: not_if "#{node['python']['binary']} -c 'import setuptools'" ==> default: 54: end ==> default: 55: ==> default: ==> default: ==> default: ==> default: Compiled Resource: ==> default: ------------------ ==> default: # Declared in /tmp/vagrant-chef-6/chef-solo-1/cookbooks/python/recipes/pip.rb:48:in from_file' ==> default: ==> default: ==> default: execute("install-setuptools") do ==> default: action "run" ==> default: retries 0 ==> default: ==> default: retry_delay 2 ==> default: default_guard_interpreter :execute ==> default: command " /bin/python ez_setup.py\n" ==> default: backup 5 ==> default: cwd "/var/chef/cache" ==> default: ==> default: returns 0 ==> default: ==> default: declared_type :execute ==> default: cookbook_name :python ==> default: recipe_name "pip" ==> default: not_if "/bin/python -c 'import setuptools'" ==> default: end ==> default: ==> default: ==> default: ==> default: [2015-02-10T21:30:56+00:00] INFO: Running queued delayed notifications before re-raising exception ==> default: [2015-02-10T21:30:56+00:00] DEBUG: Re-raising exception: Mixlib::ShellOut::ShellCommandFailed - execute[install-setuptools] (python::pip line 48) had an error: Mixlib::ShellOut::ShellCommandFailed: Expected process to exit with [0], but received '127' ==> default: ---- Begin output of /bin/python ez_setup.py ==> default: ---- ==> default: STDOUT: ==> default: STDERR: sh: 1: /bin/python: not found ==> default: ---- End output of /bin/python ez_setup.py ==> default: ---- ==> default: Ran /bin/python ez_setup.py ==> default: returned 127 ==> default: /opt/chef/embedded/lib/ruby/gems/2.1.0/gems/mixlib-shellout-2.0.0/lib/mixlib/shellout.rb:267:ininvalid!' ==> default: /opt/chef/embedded/lib/ruby/gems/2.1.0/gems/mixlib-shellout-2.0.0/lib/mixlib/shellout.rb:254:in error!' ==> default: /opt/chef/embedded/apps/chef/lib/chef/mixin/shell_out.rb:50:inshell_out!' ==> default: /opt/chef/embedded/apps/chef/lib/chef/provider/execute.rb:60:in block in action_run' ==> default: /opt/chef/embedded/apps/chef/lib/chef/mixin/why_run.rb:52:incall' ==> default: /opt/chef/embedded/apps/chef/lib/chef/mixin/why_run.rb:52:in add_action' ==> default: /opt/chef/embedded/apps/chef/lib/chef/provider.rb:180:inconverge_by' ==> default: /opt/chef/embedded/apps/chef/lib/chef/provider/execute.rb:59:in action_run' ==> default: /opt/chef/embedded/apps/chef/lib/chef/provider.rb:145:inrun_action' ==> default: /opt/chef/embedded/apps/chef/lib/chef/resource.rb:582:in run_action' ==> default: /opt/chef/embedded/apps/chef/lib/chef/runner.rb:49:inrun_action' ==> default: /opt/chef/embedded/apps/chef/lib/chef/runner.rb:81:in block (2 levels) in converge' ==> default: /opt/chef/embedded/apps/chef/lib/chef/runner.rb:81:ineach' ==> default: /opt/chef/embedded/apps/chef/lib/chef/runner.rb:81:in block in converge' ==> default: /opt/chef/embedded/apps/chef/lib/chef/resource_collection/resource_list.rb:83:inblock in execute_each_resource' ==> default: /opt/chef/embedded/apps/chef/lib/chef/resource_collection/stepable_iterator.rb:116:in call' ==> default: /opt/chef/embedded/apps/chef/lib/chef/resource_collection/stepable_iterator.rb:116:incall_iterator_block' ==> default: /opt/chef/embedded/apps/chef/lib/chef/resource_collection/stepable_iterator.rb:85:in step' ==> default: /opt/chef/embedded/apps/chef/lib/chef/resource_collection/stepable_iterator.rb:104:initerate' ==> default: /opt/chef/embedded/apps/chef/lib/chef/resource_collection/stepable_iterator.rb:55:in each_with_index' ==> default: /opt/chef/embedded/apps/chef/lib/chef/resource_collection/resource_list.rb:81:inexecute_each_resource' ==> default: /opt/chef/embedded/apps/chef/lib/chef/runner.rb:80:in converge' ==> default: /opt/chef/embedded/apps/chef/lib/chef/client.rb:315:inconverge' ==> default: /opt/chef/embedded/apps/chef/lib/chef/client.rb:400:in block in run' ==> default: /opt/chef/embedded/apps/chef/lib/chef/client.rb:399:incatch' ==> default: /opt/chef/embedded/apps/chef/lib/chef/client.rb:399:in run' ==> default: /opt/chef/embedded/apps/chef/lib/chef/application.rb:261:inblock in fork_chef_client' ==> default: /opt/chef/embedded/apps/chef/lib/chef/application.rb:249:in fork' ==> default: /opt/chef/embedded/apps/chef/lib/chef/application.rb:249:infork_chef_client' ==> default: /opt/chef/embedded/apps/chef/lib/chef/application.rb:215:in block in run_chef_client' ==> default: /opt/chef/embedded/apps/chef/lib/chef/local_mode.rb:38:inwith_server_connectivity' ==> default: /opt/chef/embedded/apps/chef/lib/chef/application.rb:201:in run_chef_client' ==> default: /opt/chef/embedded/apps/chef/lib/chef/application/solo.rb:245:inblock in interval_run_chef_client' ==> default: /opt/chef/embedded/apps/chef/lib/chef/application/solo.rb:234:in loop' ==> default: /opt/chef/embedded/apps/chef/lib/chef/application/solo.rb:234:ininterval_run_chef_client' ==> default: /opt/chef/embedded/apps/chef/lib/chef/application/solo.rb:224:in run_application' ==> default: /opt/chef/embedded/apps/chef/lib/chef/application.rb:58:inrun' ==> default: /opt/chef/embedded/apps/chef/bin/chef-solo:25:in <top (required)>' ==> default: /usr/bin/chef-solo:40:inload' ==> default: /usr/bin/chef-solo:40:in <main>' ==> default: [2015-02-10T21:30:56+00:00] ERROR: Running exception handlers ==> default: [2015-02-10T21:30:56+00:00] ERROR: Exception handlers complete ==> default: [2015-02-10T21:30:56+00:00] FATAL: Stacktrace dumped to /var/chef/cache/chef-stacktrace.out ==> default: [2015-02-10T21:30:56+00:00] DEBUG: Mixlib::ShellOut::ShellCommandFailed: execute[install-setuptools] (python::pip line 48) had an error: Mixlib::ShellOut::ShellCommandFailed: Expected process to exit with [0], but received '127' ==> default: ---- Begin output of /bin/python ez_setup.py ==> default: ---- ==> default: STDOUT: ==> default: STDERR: sh: 1: /bin/python: not found ==> default: ---- End output of /bin/python ez_setup.py ==> default: ---- ==> default: Ran /bin/python ez_setup.py ==> default: returned 127 ==> default: /opt/chef/embedded/lib/ruby/gems/2.1.0/gems/mixlib-shellout-2.0.0/lib/mixlib/shellout.rb:267:ininvalid!' ==> default: /opt/chef/embedded/lib/ruby/gems/2.1.0/gems/mixlib-shellout-2.0.0/lib/mixlib/shellout.rb:254:in error!' ==> default: /opt/chef/embedded/apps/chef/lib/chef/mixin/shell_out.rb:50:inshell_out!' ==> default: /opt/chef/embedded/apps/chef/lib/chef/provider/execute.rb:60:in block in action_run' ==> default: /opt/chef/embedded/apps/chef/lib/chef/mixin/why_run.rb:52:incall' ==> default: /opt/chef/embedded/apps/chef/lib/chef/mixin/why_run.rb:52:in add_action' ==> default: /opt/chef/embedded/apps/chef/lib/chef/provider.rb:180:inconverge_by' ==> default: /opt/chef/embedded/apps/chef/lib/chef/provider/execute.rb:59:in action_run' ==> default: /opt/chef/embedded/apps/chef/lib/chef/provider.rb:145:inrun_action' ==> default: /opt/chef/embedded/apps/chef/lib/chef/resource.rb:582:in run_action' ==> default: /opt/chef/embedded/apps/chef/lib/chef/runner.rb:49:inrun_action' ==> default: /opt/chef/embedded/apps/chef/lib/chef/runner.rb:81:in block (2 levels) in converge' ==> default: /opt/chef/embedded/apps/chef/lib/chef/runner.rb:81:ineach' ==> default: /opt/chef/embedded/apps/chef/lib/chef/runner.rb:81:in block in converge' ==> default: /opt/chef/embedded/apps/chef/lib/chef/resource_collection/resource_list.rb:83:inblock in execute_each_resource' ==> default: /opt/chef/embedded/apps/chef/lib/chef/resource_collection/stepable_iterator.rb:116:in call' ==> default: /opt/chef/embedded/apps/chef/lib/chef/resource_collection/stepable_iterator.rb:116:incall_iterator_block' ==> default: /opt/chef/embedded/apps/chef/lib/chef/resource_collection/stepable_iterator.rb:85:in step' ==> default: /opt/chef/embedded/apps/chef/lib/chef/resource_collection/stepable_iterator.rb:104:initerate' ==> default: /opt/chef/embedded/apps/chef/lib/chef/resource_collection/stepable_iterator.rb:55:in each_with_index' ==> default: /opt/chef/embedded/apps/chef/lib/chef/resource_collection/resource_list.rb:81:inexecute_each_resource' ==> default: /opt/chef/embedded/apps/chef/lib/chef/runner.rb:80:in converge' ==> default: /opt/chef/embedded/apps/chef/lib/chef/client.rb:315:inconverge' ==> default: /opt/chef/embedded/apps/chef/lib/chef/client.rb:400:in block in run' ==> default: /opt/chef/embedded/apps/chef/lib/chef/client.rb:399:incatch' ==> default: /opt/chef/embedded/apps/chef/lib/chef/client.rb:399:in run' ==> default: /opt/chef/embedded/apps/chef/lib/chef/application.rb:261:inblock in fork_chef_client' ==> default: /opt/chef/embedded/apps/chef/lib/chef/application.rb:249:in fork' ==> default: /opt/chef/embedded/apps/chef/lib/chef/application.rb:249:infork_chef_client' ==> default: /opt/chef/embedded/apps/chef/lib/chef/application.rb:215:in block in run_chef_client' ==> default: /opt/chef/embedded/apps/chef/lib/chef/local_mode.rb:38:inwith_server_connectivity' ==> default: /opt/chef/embedded/apps/chef/lib/chef/application.rb:201:in run_chef_client' ==> default: /opt/chef/embedded/apps/chef/lib/chef/application/solo.rb:245:inblock in interval_run_chef_client' ==> default: /opt/chef/embedded/apps/chef/lib/chef/application/solo.rb:234:in loop' ==> default: /opt/chef/embedded/apps/chef/lib/chef/application/solo.rb:234:ininterval_run_chef_client' ==> default: /opt/chef/embedded/apps/chef/lib/chef/application/solo.rb:224:in run_application' ==> default: /opt/chef/embedded/apps/chef/lib/chef/application.rb:58:inrun' ==> default: /opt/chef/embedded/apps/chef/bin/chef-solo:25:in <top (required)>' ==> default: /usr/bin/chef-solo:40:inload' ==> default: /usr/bin/chef-solo:40:in `
' ==> default: [2015-02-10T21:30:56+00:00] ERROR: execute[install-setuptools](python::pip line 48) had an error: Mixlib::ShellOut::ShellCommandFailed: Expected process to exit with [0], but received '127' ==> default: ---- Begin output of /bin/python ez_setup.py ==> default: ---- ==> default: STDOUT: ==> default: STDERR: sh: 1: /bin/python: not found ==> default: ---- End output of /bin/python ez_setup.py ==> default: ---- ==> default: Ran /bin/python ez_setup.py ==> default: returned 127 ==> default: [2015-02-10T21:30:56+00:00] FATAL: Chef::Exceptions::ChildConvergeError: Chef run process exited unsuccessfully (exit code 1) Chef never successfully completed! Any errors should be visible in the output above. Please fix your recipes so that they properly complete.

oddnoc commented 9 years ago

Confirmed. The provisioning is looking for /bin/python, but the correct path is /usr/bin/python. Just tried this on Mac OS X 10.10.2 (Yosemite) with Vagrant 1.7.2 and VirtualBox 4.3.20.

marco-ortega commented 9 years ago

Hi I have the same problem but on Win 7 / Vagrant 1.7.1 / Virtualbox 4.3.20 I have tred a lot of times but isn't possible (https://github.com/ptwobrussell/Mining-the-Social-Web-2nd-Edition/issues/243#issuecomment-70579483). This is the error output ... any help please

==> default: [2015-03-13T14:04:03+00:00] INFO: Running queued delayed notificati ons before re-raising exception ==> default: [2015-03-13T14:04:03+00:00] ERROR: Converge failed with error messa ge apt_repository[mongodb-10gen](mtsw2e::default line 6) had an error: Mixlib:: ShellOut::ShellCommandFailed: execute[install-key 7F0CEB10](/tmp/vagrant-chef-5 /chef-solo-1/cookbooks/apt/providers/repository.rb line 28) had an error: Mixlib ::ShellOut::ShellCommandFailed: Expected process to exit with [0], but received '2' ==> default: ---- Begin output of apt-key adv --keyserver keyserver.ubuntu.com - -recv 7F0CEB10 ---- ==> default: STDOUT: Executing: gpg --ignore-time-conflict --no-options --no-def ault-keyring --secret-keyring /tmp/tmp.vFhiOeb1q4 --trustdb-name /etc/apt/trustd b.gpg --keyring /etc/apt/trusted.gpg --primary-keyring /etc/apt/trusted.gpg --ke yserver keyserver.ubuntu.com --recv 7F0CEB10 ==> default: STDERR: gpg: requesting key 7F0CEB10 from hkp server keyserver.ubun tu.com ==> default: gpg: keyserver timed out ==> default: gpg: keyserver receive failed: keyserver error ==> default: ---- End output of apt-key adv --keyserver keyserver.ubuntu.com --r ecv 7F0CEB10 ---- ==> default: Ran apt-key adv --keyserver keyserver.ubuntu.com --recv 7F0CEB10 re turned 2 ==> default: [2015-03-13T14:04:03+00:00] DEBUG: Re-raising exception: Chef::Exce ptions::RunFailedWrappingError - Found 1 errors, they are stored in the backtrac e ==> default: 1) Mixlib::ShellOut::ShellCommandFailed - apt_repository[mongodb-1 0gen](mtsw2e::default line 6) had an error: Mixlib::ShellOut::ShellCommandFaile d: execute[install-key 7F0CEB10](/tmp/vagrant-chef-5/chef-solo-1/cookbooks/apt/ providers/repository.rb line 28) had an error: Mixlib::ShellOut::ShellCommandFai led: Expected process to exit with [0], but received '2' ==> default: ---- Begin output of apt-key adv --keyserver keyserver.ubuntu.com - -recv 7F0CEB10 ---- ==> default: STDOUT: Executing: gpg --ignore-time-conflict --no-options --no-def ault-keyring --secret-keyring /tmp/tmp.vFhiOeb1q4 --trustdb-name /etc/apt/trustd b.gpg --keyring /etc/apt/trusted.gpg --primary-keyring /etc/apt/trusted.gpg --ke yserver keyserver.ubuntu.com --recv 7F0CEB10 ==> default: STDERR: gpg: requesting key 7F0CEB10 from hkp server keyserver.ubun tu.com ==> default: gpg: keyserver timed out ==> default: gpg: keyserver receive failed: keyserver error ==> default: ---- End output of apt-key adv --keyserver keyserver.ubuntu.com --r ecv 7F0CEB10 ----

==> default: /usr/bin/chef-solo:52:in load' ==> default: /usr/bin/chef-solo:52:in

' ==> default: ==> default: [2015-03-13T14:04:03+00:00] ERROR: Running exception handlers ==> default: [2015-03-13T14:04:03+00:00] ERROR: Exception handlers complete ==> default: [2015-03-13T14:04:03+00:00] FATAL: Stacktrace dumped to /var/chef/c ache/chef-stacktrace.out ==> default: [2015-03-13T14:04:03+00:00] DEBUG: Chef::Exceptions::RunFailedWrapp ingError: Found 1 errors, they are stored in the backtrace ==> default: 1) Mixlib::ShellOut::ShellCommandFailed - apt_repository[mongodb-1 0gen](mtsw2e::default line 6) had an error: Mixlib::ShellOut::ShellCommandFaile d: execute[install-key 7F0CEB10](/tmp/vagrant-chef-5/chef-solo-1/cookbooks/apt/ providers/repository.rb line 28) had an error: Mixlib::ShellOut::ShellCommandFai led: Expected process to exit with [0], but received '2'

==> default: /usr/bin/chef-solo:52:in load' ==> default: /usr/bin/chef-solo:52:in

' ==> default: [2015-03-13T14:04:03+00:00] ERROR: Found 1 errors, they are stored in the backtrace ==> default: [2015-03-13T14:04:03+00:00] FATAL: Chef::Exceptions::ChildConvergeE rror: Chef run process exited unsuccessfully (exit code 1) Chef never successfully completed! Any errors should be visible in the output above. Please fix your recipes so that they properly complete.

ptwobrussell commented 9 years ago

I've seen errors like this a few times and have never fully understood why some people aren't able to connect to the keyserver for MongoDB without issue. If you aren't immediately planning to use MongoDB for anything (most notably the chapter on Mining Mailboxes or any Twitter Recipes from Chapter 9 that involve using it for persistent storage), you could simply comment out the portions of the Chef recipe that reference it in the cookbook at https://github.com/ptwobrussell/Mining-the-Social-Web-2nd-Edition/blob/master/deploy/cookbooks/mtsw2e/recipes/default.rb and you should be just fine. If you need to use MongoDB later, you can very likely just use apt-get to install it manually if/when needed without issue.

I'm not confident in my abilities to help you track down something that I can't readily reproduce, so that's really my best suggestion for the moment.

Apologies for the delayed response.

On Fri, Mar 13, 2015 at 10:30 AM, marco-ortega notifications@github.com wrote:

Hi I have the same problem but on Win 7 / Vagrant 1.7.1 / Virtualbox 4.3.20 I have tred a lot of times but isn't possible (#243 (comment) https://github.com/ptwobrussell/Mining-the-Social-Web-2nd-Edition/issues/243#issuecomment-70579483).

This is the error output ... any help please

==> default: [2015-03-13T14:04:03+00:00] INFO: Running queued delayed notificati ons before re-raising exception ==> default: [2015-03-13T14:04:03+00:00] ERROR: Converge failed with error messa ge apt_repositorymongodb-10gen had an error: Mixlib:: ShellOut::ShellCommandFailed: executeinstall-key 7F0CEB10 http:///tmp/vagrant-chef-5%0A/chef-solo-1/cookbooks/apt/providers/repository.rb%20line%2028 had an error: Mixlib ::ShellOut::ShellCommandFailed: Expected process to exit with [0], but received '2' ==> default: ---- Begin output of apt-key adv --keyserver keyserver.ubuntu.com - -recv 7F0CEB10 ---- ==> default: STDOUT: Executing: gpg --ignore-time-conflict --no-options --no-def ault-keyring --secret-keyring /tmp/tmp.vFhiOeb1q4 --trustdb-name /etc/apt/trustd b.gpg --keyring /etc/apt/trusted.gpg --primary-keyring /etc/apt/trusted.gpg --ke yserver keyserver.ubuntu.com --recv 7F0CEB10 ==> default: STDERR: gpg: requesting key 7F0CEB10 from hkp server keyserver.ubun tu.com ==> default: gpg: keyserver timed out ==> default: gpg: keyserver receive failed: keyserver error ==> default: ---- End output of apt-key adv --keyserver keyserver.ubuntu.com --r ecv 7F0CEB10 ---- ==> default: Ran apt-key adv --keyserver keyserver.ubuntu.com --recv 7F0CEB10 re turned 2 ==> default: [2015-03-13T14:04:03+00:00] DEBUG: Re-raising exception: Chef::Exce ptions::RunFailedWrappingError - Found 1 errors, they are stored in the backtrac e ==> default: 1) Mixlib::ShellOut::ShellCommandFailed - apt_repositorymongodb-1 0gen had an error: Mixlib::ShellOut::ShellCommandFaile d: executeinstall-key 7F0CEB10 http:///tmp/vagrant-chef-5/chef-solo-1/cookbooks/apt/%0Aproviders/repository.rb%20line%2028 had an error: Mixlib::ShellOut::ShellCommandFai led: Expected process to exit with [0], but received '2' ==> default: ---- Begin output of apt-key adv --keyserver keyserver.ubuntu.com - -recv 7F0CEB10 ---- ==> default: STDOUT: Executing: gpg --ignore-time-conflict --no-options --no-def ault-keyring --secret-keyring /tmp/tmp.vFhiOeb1q4 --trustdb-name /etc/apt/trustd b.gpg --keyring /etc/apt/trusted.gpg --primary-keyring /etc/apt/trusted.gpg --ke yserver keyserver.ubuntu.com --recv 7F0CEB10 ==> default: STDERR: gpg: requesting key 7F0CEB10 from hkp server keyserver.ubun tu.com ==> default: gpg: keyserver timed out ==> default: gpg: keyserver receive failed: keyserver error ==> default: ---- End output of apt-key adv --keyserver keyserver.ubuntu.com --r ecv 7F0CEB10 ----

==> default: /usr/bin/chef-solo:52:in load' ==> default: /usr/bin/chef-solo:52:in' ==> default: ==> default: [2015-03-13T14:04:03+00:00] ERROR: Running exception handlers ==> default: [2015-03-13T14:04:03+00:00] ERROR: Exception handlers complete ==> default: [2015-03-13T14:04:03+00:00] FATAL: Stacktrace dumped to /var/chef/c ache/chef-stacktrace.out ==> default: [2015-03-13T14:04:03+00:00] DEBUG: Chef::Exceptions::RunFailedWrapp ingError: Found 1 errors, they are stored in the backtrace ==> default: 1) Mixlib::ShellOut::ShellCommandFailed - apt_repositorymongodb-1 0gen had an error: Mixlib::ShellOut::ShellCommandFaile d: executeinstall-key 7F0CEB10 http:///tmp/vagrant-chef-5/chef-solo-1/cookbooks/apt/%0Aproviders/repository.rb%20line%2028 had an error: Mixlib::ShellOut::ShellCommandFai led: Expected process to exit with [0], but received '2'

==> default: /usr/bin/chef-solo:52:in load' ==> default: /usr/bin/chef-solo:52:in' ==> default: [2015-03-13T14:04:03+00:00] ERROR: Found 1 errors, they are stored in the backtrace ==> default: [2015-03-13T14:04:03+00:00] FATAL: Chef::Exceptions::ChildConvergeE rror: Chef run process exited unsuccessfully (exit code 1) Chef never successfully completed! Any errors should be visible in the output above. Please fix your recipes so that they properly complete.

— Reply to this email directly or view it on GitHub https://github.com/ptwobrussell/Mining-the-Social-Web-2nd-Edition/issues/259#issuecomment-78996999 .

michaelreinhard commented 8 years ago

Hi,

I have been having trouble at the 'vagrant up' point in the instructions.

I have a Mac running Yosemite 10.10.5. Here is the warning message I get: http://pastebin.com/D0rYjeGt

I have tried uninstalling and destroying and starting from scratch but no luck. I am willing to try anything you suggest even it is just to go read another manual.

UPDATE: I did a more complete uninstall after finding some websites that showed how to delete some hidden files, the ones with the . before them. Then, after reinstalling by following your video more closely, it worked. Thanks for the videos!

LINGLUOJUN commented 8 years ago

Hi， I have have the same problem but on Win 7(64bit) / Vagrant 1.7.1 / Virtualbox 4.2.2 and the error output as follow: ==> default: [2015-03-13T14:04:03+00:00] FATAL: Chef::Exceptions::ChildConvergeE rror: Chef run process exited unsuccessfully (exit code 1) Chef never successfully completed! Any errors should be visible in the output above. Please fix your recipes so that they properly complete.

I don't know how to do with it, Anyone can help? Thank you