Contributing: vagrant librarian-chef plugin installation error

1,360 views
Skip to first unread message

MatMan

unread,
Apr 21, 2014, 7:33:53 AM4/21/14
to db...@googlegroups.com
I've started setting up a dev environment as I finally think I have a little time to look at getting the Teradata adapter into the 2.x code base.
 
I've installed VirtualBox and Vagrant (x64, Windows 7).
 
When I come to install the first vagrant plugin, from the Windows command prompt, with: -

vagrant plugin install vagrant-librarian-chef
 I get the following error (I've tried this a few times): -
Installing the 'vagrant-librarian-chef' plugin. This can take a few minutes...
Bundler, the underlying system Vagrant uses to install plugins,
reported an error. The error is shown below. These errors are usually
caused by misconfigured plugin installations or transient network
issues. The error from Bundler is:
An error occurred while installing yajl-ruby (1.2.0), and Bundler cannot continue.
Make sure that `gem install yajl-ruby -v '1.2.0'` succeeds before bundling.

I'm definitely connected to the web, so no network issues.

Can anyone help me with this?

What the reference to the "gem" command?!

Cheers,

Mark 

MatMan

unread,
Apr 22, 2014, 6:08:40 PM4/22/14
to db...@googlegroups.com
Well, some meagre progress. I tried installing the plugins using the actual Administrator windows user and it worked. I think my win7 machine needs a rebuild...to Linux.

I can't even remove vagrant under my own (admin) user. :(

So, I'm following the instructions at https://github.com/dbfit/dbfit/blob/master/CONTRIBUTING.md and I'm at point (getting Oracle). I've downloaded the Oracle installation ZIP file and I'm supposed to put this in the git root directory. Where is this?? Where git is installed on my Windows machine or somewhere else?

Also, step 5 mentions the dir test_vm. Where will I find this?

Have other people worked through these instructions successfully? Help!

Cheers,

Mark

Jake Benilov

unread,
Apr 22, 2014, 6:23:07 PM4/22/14
to db...@googlegroups.com
Hi Mark,

Apologies for the radio silence.

The instructions that you've been following were written under OS X and work for Linux, but there are nuances there that might not be right for Windows, that you are probably hitting.

The git root directory refers to the root folder of dbfit (which you checked out). That is, the Oracle binary needs to sit next to the README, CONTRIBUTING etc

Jake



--
You received this message because you are subscribed to the Google Groups "dbfit" group.
To unsubscribe from this group and stop receiving emails from it, send an email to dbfit+un...@googlegroups.com.
To post to this group, send email to db...@googlegroups.com.
Visit this group at http://groups.google.com/group/dbfit.
For more options, visit https://groups.google.com/d/optout.

Jake Benilov

unread,
Apr 22, 2014, 6:30:15 PM4/22/14
to db...@googlegroups.com
Another point - the virtual machine is by no means a pre-requisite to doing the work that you plan to do. It was added as a means to simplify the dev process, by bundling the setup of Mysql, Postgres, Oracle, Java, gradle (the build tool) and other things, but in your case it might be complicating things. 

Obviously if you would be making changes to dbfit-core, you'd want to test those with all DB adapters, but if you only wish to work on the teradata adapter, it would be enough to have teradata and the basic java/gradle build working without the other things.

So, if you can get java, teradata and groovy working on your Windows installation, that ought to be enough and you can skip the rest.


On Tue, Apr 22, 2014 at 11:08 PM, MatMan <mark_...@hotmail.com> wrote:

--

MatMan

unread,
Apr 23, 2014, 4:01:01 AM4/23/14
to db...@googlegroups.com
Thanks Jake,
 
I remember having to make fixes to the core when creating the Teradata adapter so I might need to reapply these in 2.x. I'll persevere for a while at least to try to get the full dev env working and document issues on this thread.
 
Mark

MatMan

unread,
Apr 23, 2014, 4:03:41 AM4/23/14
to db...@googlegroups.com
I must admit to being a bit confused still!
 
Where will my git working copy be? On my Windows host machine, or on the Virtualbox VM? Is git pre installed on the VM image?
 
Also, when does the test_vm directory get created? Also is this on the host or guest (VM)?
 
Mark

Yavor Nikolov

unread,
Apr 23, 2014, 4:43:10 AM4/23/14
to db...@googlegroups.com
Hi,

git copy is on your host (Windows) machine but it's accessible from the VM too (as /var/dbfit) since this folder is mounted there (as defined in Vagrantfile: config.vm.synced_folder "..", "/var/dbfit" - where .. is the parent of test_vm folder).
(git is installed inside the VM by Vagrant when you run 'vagrant up').
 
Yavor

MatMan

unread,
Apr 23, 2014, 7:05:25 AM4/23/14
to db...@googlegroups.com
Thanks for this.
 
I've made a little more progress on downloading the vagrant plugins too.
 
I had to deal with the backslash char separating domain and user name in my proxy server AD user name by using hex notation (%5c to represent the "\" char). So, now they're downloaded ok.
 
Now another error starting up the vm: -
 
C:\dbfit\dbfit\test_vm>vagrant up
C:/HashiCorp/Vagrant/embedded/lib/ruby/2.0.0/net/http/response.rb:119:in `error!': 403 "Forbidden" (Net::HTTPServerException)
        from C:/HashiCorp/Vagrant/embedded/lib/ruby/2.0.0/net/http/response.rb:128:in `value'
        from C:/HashiCorp/Vagrant/embedded/lib/ruby/2.0.0/net/http.rb:913:in `connect'
        from C:/HashiCorp/Vagrant/embedded/lib/ruby/2.0.0/net/http.rb:862:in `do_start'
        from C:/HashiCorp/Vagrant/embedded/lib/ruby/2.0.0/net/http.rb:857:in `start'
        from C:/HashiCorp/Vagrant/embedded/lib/ruby/2.0.0/rubygems/remote_fetcher.rb:415:in `connection_for'
        from C:/HashiCorp/Vagrant/embedded/lib/ruby/2.0.0/rubygems/remote_fetcher.rb:495:in `request'
        from C:/HashiCorp/Vagrant/embedded/lib/ruby/2.0.0/rubygems/remote_fetcher.rb:236:in `fetch_http'
        from C:/HashiCorp/Vagrant/embedded/lib/ruby/2.0.0/rubygems/remote_fetcher.rb:271:in `fetch_path'
        from C:/HashiCorp/Vagrant/embedded/lib/ruby/2.0.0/rubygems/remote_fetcher.rb:301:in `cache_update_path'
        from C:/HashiCorp/Vagrant/embedded/lib/ruby/2.0.0/rubygems/source.rb:130:in `load_specs'
        from C:/HashiCorp/Vagrant/embedded/lib/ruby/2.0.0/rubygems/spec_fetcher.rb:230:in `tuples_for'
        from C:/HashiCorp/Vagrant/embedded/lib/ruby/2.0.0/rubygems/spec_fetcher.rb:199:in `block in available_specs'
        from C:/HashiCorp/Vagrant/embedded/lib/ruby/2.0.0/rubygems/source_list.rb:55:in `each'
        from C:/HashiCorp/Vagrant/embedded/lib/ruby/2.0.0/rubygems/source_list.rb:55:in `each_source'
        from C:/HashiCorp/Vagrant/embedded/lib/ruby/2.0.0/rubygems/spec_fetcher.rb:195:in `available_specs'
        from C:/HashiCorp/Vagrant/embedded/lib/ruby/2.0.0/rubygems/spec_fetcher.rb:81:in `search_for_dependency'
        from C:/HashiCorp/Vagrant/embedded/lib/ruby/2.0.0/rubygems/spec_fetcher.rb:139:in `spec_for_dependency'
        from C:/HashiCorp/Vagrant/embedded/lib/ruby/2.0.0/rubygems/dependency_installer.rb:156:in `find_gems_with_sources'
        from C:/Users/mattenm/.vagrant.d/gems/gems/vagrant-omnibus-1.3.1/lib/vagrant-omnibus/config.rb:80:in `retrieve_latest_chef_v
ersion'
        from C:/Users/mattenm/.vagrant.d/gems/gems/vagrant-omnibus-1.3.1/lib/vagrant-omnibus/config.rb:42:in `finalize!'
        from C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/config/v2/root.rb:50:in `block in finalize!'
        from C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/config/v2/root.rb:49:in `each'
        from C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/config/v2/root.rb:49:in `finalize!'
        from C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/config/v2/loader.rb:21:in `finalize'
        from C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/config/loader.rb:159:in `load'
        from C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/vagrantfile.rb:28:in `initialize'
        from C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/environment.rb:486:in `new'
        from C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/environment.rb:486:in `vagrantfile'
        from C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/environment.rb:317:in `host'
        from C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/environment.rb:168:in `block in action_runner'
        from C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/action/runner.rb:36:in `call'
        from C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/action/runner.rb:36:in `run'
        from C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/environment.rb:304:in `hook'
        from C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/environment.rb:148:in `initialize'
        from C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/bin/vagrant:155:in `new'
        from C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/bin/vagrant:155:in `<main>'
 
This might be a web site blocked by websense by the corporate proxy/firewall stuff but there's no clue on which URL :(
Not knowing any Ruby I can't even print the URI.
 
Any ideas!?
 
Cheers,
 
Mark

MatMan

unread,
Apr 24, 2014, 12:03:18 PM4/24/14
to db...@googlegroups.com
I've made some more progress...

-> I enabled virtualisation features in the PC BIOS, which helped :)
-> If I use VirtualBox 4.3.8 things seems to go ok else (using 4.3.10) I get complaints about the guest extensions being a different version to that on the guest.
-> If I remove the NFS bits from the Vagrantfile sync folder bit then I make some progress else the sync folders can't be mounted (no NFS in Windows).

I still can't explain the  403 "Forbidden" error above. If I run vagrant up again then sometimes this just goes away! It seems extremely variable on my environment.

Now my issue is that things seem to hang on a wget of some chef version metadata: -

Bringing machine 'default' up with 'virtualbox' provider...
==> default: Clearing any previously set forwarded ports...
==> default: Installing Chef cookbooks with Librarian-Chef...
==> default: Clearing any previously set network interfaces...
==> default: Preparing network interfaces based on configuration...
    default: Adapter 1: nat
    default: Adapter 2: hostonly
==> default: Forwarding ports...
    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: Warning: Connection timeout. Retrying...
==> default: Machine booted and ready!
GuestAdditions 4.3.8 running --- OK.
==> default: Checking for guest additions in VM...
==> default: Setting hostname...
==> default: Configuring and enabling network interfaces...
==> default: Mounting shared folders...
    default: /vagrant => C:/dbfit/dbfit/test_vm
    default: /var/dbfit => C:/dbfit/dbfit
    default: /tmp/vagrant-chef-1/chef-solo-1/cookbooks => C:/dbfit/dbfit/test_vm/cookbooks
==> default: Installing Chef 11.12.2 Omnibus package...
==> default: Downloading Chef 11.12.2 for el...
==> default:   to file /tmp/install.sh.2369/metadata.txt
==> default: trying wget...

I've tried using wireshark to find out what's it trying to do but I'm floundering! I'm not sure how close I am to getting the VM fully up either. 

Anyone recognise this latest issue?

Cheers,

Mark

MatMan

unread,
Apr 24, 2014, 12:25:04 PM4/24/14
to db...@googlegroups.com
As it turns out the wget call was being retried (20 times in all) before failing. I think wget is part of a python script running on the VM that's trying to download from the internet via my host's network connections. 

I wonder if the VM knows about the proxy server I have to use? I set it up for vagrant (http_proxy and https_proxy environment variables) but about stuff running on the VM....?

Here's the error log: -
 
==> default: trying wget...
==> default: trying curl...
==> default: grep:
==> default: /tmp/stderr: No such file or directory
==> default: trying python...
==> default: Unable to retrieve a valid package!
==> default: Please file a bug report at http://tickets.opscode.com
==> default: Project: Chef
==> default: Component: Packages
==> default: Label: Omnibus
==> default: Version: 11.12.2
==> default:
==> default: Please detail your operating system type, version and any other relevant details
==> default: \nDEBUG OUTPUT FOLLOWS:\n\nSTDERR from wget:\n\n--2014-04-24 15:40:24--  https://www.getchef.com/chef/metadata?v=11.12.
2&prerelease=false&nightlies=false&p=el&pv=6&m=x86_64
==> default: Resolving www.getchef.com... 184.106.28.82
==> default: Connecting to www.getchef.com|184.106.28.82|:443... failed: Connection timed out.
==> default: Retrying.
==> default:
l&pv=6&m=x86_64
==> default: Connecting to www.getchef.com|184.106.28.82|:443... failed: Connection timed out.
==> default: Retrying.
==> default:
l&pv=6&m=x86_64
==> default: Connecting to www.getchef.com|184.106.28.82|:443... failed: Connection timed out.
==> default: Retrying.
==> default:
l&pv=6&m=x86_64
==> default: Connecting to www.getchef.com|184.106.28.82|:443... failed: Connection timed out.
==> default: Retrying.
==> default:
l&pv=6&m=x86_64
==> default: Connecting to www.getchef.com|184.106.28.82|:443... failed: Connection timed out.
==> default: Retrying.
==> default:
l&pv=6&m=x86_64
==> default: Connecting to www.getchef.com|184.106.28.82|:443... failed: Connection timed out.
==> default: Retrying.
==> default:
l&pv=6&m=x86_64
==> default: Connecting to www.getchef.com|184.106.28.82|:443... failed: Connection timed out.
==> default: Retrying.
==> default:
l&pv=6&m=x86_64
==> default: Connecting to www.getchef.com|184.106.28.82|:443... failed: Connection timed out.
==> default: Retrying.
==> default:
l&pv=6&m=x86_64
==> default: Connecting to www.getchef.com|184.106.28.82|:443... failed: Connection timed out.
==> default: Retrying.
==> default:
l&pv=6&m=x86_64
==> default: Connecting to www.getchef.com|184.106.28.82|:443... failed: Connection timed out.
==> default: Retrying.
==> default:
l&pv=6&m=x86_64
==> default: Connecting to www.getchef.com|184.106.28.82|:443... failed: Connection timed out.
==> default: Retrying.
==> default:
l&pv=6&m=x86_64
==> default: Connecting to www.getchef.com|184.106.28.82|:443... failed: Connection timed out.
==> default: Retrying.
==> default:
l&pv=6&m=x86_64
==> default: Connecting to www.getchef.com|184.106.28.82|:443... failed: Connection timed out.
==> default: Retrying.
==> default:
l&pv=6&m=x86_64
==> default: Connecting to www.getchef.com|184.106.28.82|:443... failed: Connection timed out.
==> default: Retrying.
==> default:
l&pv=6&m=x86_64
==> default: Connecting to www.getchef.com|184.106.28.82|:443... failed: Connection timed out.
==> default: Retrying.
==> default:
l&pv=6&m=x86_64
==> default: Connecting to www.getchef.com|184.106.28.82|:443... failed: Connection timed out.
==> default: Retrying.
==> default:
l&pv=6&m=x86_64
==> default: Connecting to www.getchef.com|184.106.28.82|:443... failed: Connection timed out.
==> default: Retrying.
==> default:
l&pv=6&m=x86_64
==> default: Conn
==> default: ecting to www.getchef.com|184.106.28.82|:443... failed: Connection timed out.
==> default: Retrying.

l&pv=6&m=x86_64
==> default: Connecting to www.getchef.com|184.106.28.82|:443... failed: Connection timed out.
==> default: Retrying.

l&pv=6&m=x86_64
==> default: Connecting to www.getchef.com|184.106.28.82|:443... failed: Connection timed out.
==> default: Giving up.\n\nSTDERR from python:\n\nTraceback (most recent call last):
==> default:   File "<string>", line 1, in <module>
==> default:   File "/usr/lib64/python2.6/urllib2.py", line 126, in urlopen
==> default:     return _opener.open(url, data, timeout)
==> default:   File "/usr/lib64/python2.6/urllib2.py", line 391, in open
==> default:     response = self._open(req, data)
==> default:   File "/usr/lib64/python2.6/urllib2.py", line 409, in _open
==> default:     '_open', req)
==> default:   File "/usr/lib64/python2.6/urllib2.py", line 369, in _call_chain
==> default:     result = func(*args)
==> default:   File "/usr/lib64/python2.6/urllib2.py", line 1198, in https_open
==> default:     return self.do_open(httplib.HTTPSConnection, req)
==> default:   File "/usr/lib64/python2.6/urllib2.py", line 1165, in do_open
==> default:     raise URLError(err)
==> default: urllib2.URLError: <urlopen error [Errno 110] Connection timed out>\n
The following SSH command responded with a non-zero exit status.
Vagrant assumes that this means the command failed!

sh install.sh -v 11.12.2 2>&1

Stdout from the command:

Downloading Chef 11.12.2 for el...
  to file /tmp/install.sh.2369/metadata.txt
trying wget...
trying curl...
grep: /tmp/stderr: No such file or directory
trying python...
Unable to retrieve a valid package!
Please file a bug report at http://tickets.opscode.com
Project: Chef
Component: Packages
Label: Omnibus
Version: 11.12.2

Please detail your operating system type, version and any other relevant details
\nDEBUG OUTPUT FOLLOWS:\n\nSTDERR from wget:\n\n--2014-04-24 15:40:24--  https://www.getchef.com/chef/metadata?v=11.12.2&prerelease=
false&nightlies=false&p=el&pv=6&m=x86_64
Resolving www.getchef.com... 184.106.28.82
Connecting to www.getchef.com|184.106.28.82|:443... failed: Connection timed out.
Retrying.

64
Connecting to www.getchef.com|184.106.28.82|:443... failed: Connection timed out.
Retrying.

64
Connecting to www.getchef.com|184.106.28.82|:443... failed: Connection timed out.
Retrying.

64
Connecting to www.getchef.com|184.106.28.82|:443... failed: Connection timed out.
Retrying.

64
Connecting to www.getchef.com|184.106.28.82|:443... failed: Connection timed out.
Retrying.

64
Connecting to www.getchef.com|184.106.28.82|:443... failed: Connection timed out.
Retrying.

64
Connecting to www.getchef.com|184.106.28.82|:443... failed: Connection timed out.
Retrying.

64
Connecting to www.getchef.com|184.106.28.82|:443... failed: Connection timed out.
Retrying.

64
Connecting to www.getchef.com|184.106.28.82|:443... failed: Connection timed out.
Retrying.

64
Connecting to www.getchef.com|184.106.28.82|:443... failed: Connection timed out.
Retrying.

64
Connecting to www.getchef.com|184.106.28.82|:443... failed: Connection timed out.
Retrying.

64
Connecting to www.getchef.com|184.106.28.82|:443... failed: Connection timed out.
Retrying.

64
Connecting to www.getchef.com|184.106.28.82|:443... failed: Connection timed out.
Retrying.

64
Connecting to www.getchef.com|184.106.28.82|:443... failed: Connection timed out.
Retrying.

64
Connecting to www.getchef.com|184.106.28.82|:443... failed: Connection timed out.
Retrying.

64
Connecting to www.getchef.com|184.106.28.82|:443... failed: Connection timed out.
Retrying.

64
Connecting to www.getchef.com|184.106.28.82|:443... failed: Connection timed out.
Retrying.

64
Connecting to www.getchef.com|184.106.28.82|:443... failed: Connection timed out.
Retrying.

64
Connecting to www.getchef.com|184.106.28.82|:443... failed: Connection timed out.
Retrying.

64
Connecting to www.getchef.com|184.106.28.82|:443... failed: Connection timed out.
Giving up.\n\nSTDERR from python:\n\nTraceback (most recent call last):
  File "<string>", line 1, in <module>
  File "/usr/lib64/python2.6/urllib2.py", line 126, in urlopen
    return _opener.open(url, data, timeout)
  File "/usr/lib64/python2.6/urllib2.py", line 391, in open
    response = self._open(req, data)
  File "/usr/lib64/python2.6/urllib2.py", line 409, in _open
    '_open', req)
  File "/usr/lib64/python2.6/urllib2.py", line 369, in _call_chain
    result = func(*args)
  File "/usr/lib64/python2.6/urllib2.py", line 1198, in https_open
    return self.do_open(httplib.HTTPSConnection, req)
  File "/usr/lib64/python2.6/urllib2.py", line 1165, in do_open
    raise URLError(err)
urllib2.URLError: <urlopen error [Errno 110] Connection timed out>\n


Stderr from the command:

Yavor Nikolov

unread,
Apr 24, 2014, 1:22:07 PM4/24/14
to db...@googlegroups.com
Hi Mark,

* For the proxy:
Create a file in /etc/profile.d where you set the proxy variables: http://linuxpedia.net/how-to-set-global-environment-variables-on-centos-and-debian/

Then maybe best to restart and run provisioning again:
vagrant reload
vagrant provision

* VirtualBox version:
If your Virtualbox is 4.3.10 - vagrant-vbguest plugin is supposed to update it. If you have a problem with the plugin: you can install VirtualBox guest addons manually (as per Virtual Box instructions).


Regards,
Yavor


--

MatMan

unread,
Apr 25, 2014, 8:20:52 AM4/25/14
to db...@googlegroups.com
Thanks Yavor,

This helped. 

Also there is a bug in the Virtualbox 4.3.10 guest addtions that prevents sync folders working 

C:\dbfit\dbfit\test_vm>vagrant provision
==> default: Installing Chef cookbooks with Librarian-Chef...
==> default: Chef 11.12.2 Omnibus package is already installed.
==> default: Running provisioner: chef_solo...
Generating chef JSON and uploading...
Running chef-solo...
[2014-04-25T12:14:02+00:00] INFO: Forking chef instance to converge...
[2014-04-25T12:14:02+00:00] WARN:
* * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * *

SSL validation of HTTPS requests is disabled. HTTPS connections are still
encrypted, but chef is not able to detect forged replies or man in the middle
attacks.

To fix this issue add an entry like this to your configuration file:

```
  # Verify all HTTPS connections (recommended)
  ssl_verify_mode :verify_peer

  # OR, Verify only connections to chef-server
  verify_api_cert true
```

To check your SSL configuration, or troubleshoot errors, you can use the
`knife ssl check` command like so:

```
  knife ssl check -c /tmp/vagrant-chef-1/solo.rb
```

* * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * *


[2014-04-25T12:14:02+00:00] INFO: *** Chef 11.12.2 ***
[2014-04-25T12:14:02+00:00] INFO: Chef-client pid: 3572
/opt/chef/embedded/lib/ruby/gems/1.9.1/gems/chef-11.12.2/lib/chef/mixin/path_san
ity.rb:25: warning: Insecure world writable dir /var/dbfit in PATH, mode 040777
[2014-04-25T12:14:05+00:00] INFO: Setting the run_list to ["recipe[dbfit_test]"]
 from CLI options
[2014-04-25T12:14:05+00:00] INFO: Run List is [recipe[dbfit_test]]
[2014-04-25T12:14:05+00:00] INFO: Run List expands to [dbfit_test]
[2014-04-25T12:14:05+00:00] INFO: Starting Chef Run for dbfitvm
[2014-04-25T12:14:05+00:00] INFO: Running start handlers
[2014-04-25T12:14:05+00:00] INFO: Start handlers complete.
[2014-04-25T12:14:07+00:00] INFO: WindowsPackage light-weight resource already i
nitialized -- overriding!
[2014-04-25T12:14:08+00:00] WARN: Cloning resource attributes for mysql_database
_user[dftest] from prior resource (CHEF-3694)
[2014-04-25T12:14:08+00:00] WARN: Previous mysql_database_user[dftest]: /tmp/vag
rant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/mysql.rb:17:in `block in fr
om_file'
[2014-04-25T12:14:08+00:00] WARN: Current  mysql_database_user[dftest]: /tmp/vag
rant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/mysql.rb:24:in `block (2 le
vels) in from_file'
[2014-04-25T12:14:08+00:00] WARN: Cloning resource attributes for mysql_database
_user[dftest] from prior resource (CHEF-3694)
[2014-04-25T12:14:08+00:00] WARN: Previous mysql_database_user[dftest]: /tmp/vag
rant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/mysql.rb:24:in `block (2 le
vels) in from_file'
[2014-04-25T12:14:08+00:00] WARN: Current  mysql_database_user[dftest]: /tmp/vag
rant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/mysql.rb:24:in `block (2 le
vels) in from_file'
[2014-04-25T12:14:08+00:00] WARN: Cloning resource attributes for mysql_database
_user[dbfit_user] from prior resource (CHEF-3694)
[2014-04-25T12:14:08+00:00] WARN: Previous mysql_database_user[dbfit_user]: /tmp
/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/mysql.rb:17:in `block i
n from_file'
[2014-04-25T12:14:08+00:00] WARN: Current  mysql_database_user[dbfit_user]: /tmp
/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/mysql.rb:24:in `block (
2 levels) in from_file'
[2014-04-25T12:14:08+00:00] WARN: Cloning resource attributes for mysql_database
_user[dbfit_user] from prior resource (CHEF-3694)
[2014-04-25T12:14:08+00:00] WARN: Previous mysql_database_user[dbfit_user]: /tmp
/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/mysql.rb:24:in `block (
2 levels) in from_file'
[2014-04-25T12:14:08+00:00] WARN: Current  mysql_database_user[dbfit_user]: /tmp
/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/mysql.rb:24:in `block (
2 levels) in from_file'
[2014-04-25T12:14:08+00:00] WARN: Cloning resource attributes for mysql_database
_user[dbfit_user] from prior resource (CHEF-3694)
[2014-04-25T12:14:08+00:00] WARN: Previous mysql_database_user[dbfit_user]: /tmp
/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/mysql.rb:24:in `block (
2 levels) in from_file'
[2014-04-25T12:14:08+00:00] WARN: Current  mysql_database_user[dbfit_user]: /tmp
/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/mysql.rb:34:in `block i
n from_file'
[2014-04-25T12:14:08+00:00] WARN: Cloning resource attributes for mysql_database
_user[dbfit_user] from prior resource (CHEF-3694)
[2014-04-25T12:14:08+00:00] WARN: Previous mysql_database_user[dbfit_user]: /tmp
/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/mysql.rb:34:in `block i
n from_file'
[2014-04-25T12:14:08+00:00] WARN: Current  mysql_database_user[dbfit_user]: /tmp
/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/mysql.rb:34:in `block i
n from_file'
[2014-04-25T12:14:08+00:00] WARN: Cloning resource attributes for mysql_database
[dbfit] from prior resource (CHEF-3694)
[2014-04-25T12:14:08+00:00] WARN: Previous mysql_database[dbfit]: /tmp/vagrant-c
hef-1/chef-solo-1/cookbooks/dbfit_test/recipes/mysql.rb:11:in `from_file'
[2014-04-25T12:14:08+00:00] WARN: Current  mysql_database[dbfit]: /tmp/vagrant-c
hef-1/chef-solo-1/cookbooks/dbfit_test/recipes/mysql.rb:43:in `from_file'
[2014-04-25T12:14:08+00:00] WARN: Cloning resource attributes for postgresql_dat
abase_user[dbfit] from prior resource (CHEF-3694)
[2014-04-25T12:14:08+00:00] WARN: Previous postgresql_database_user[dbfit]: /tmp
/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/postgres.rb:17:in `from
_file'
[2014-04-25T12:14:08+00:00] WARN: Current  postgresql_database_user[dbfit]: /tmp
/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/postgres.rb:23:in `from
_file'
[2014-04-25T12:14:08+00:00] WARN: Cloning resource attributes for postgresql_dat
abase[dbfit] from prior resource (CHEF-3694)
[2014-04-25T12:14:08+00:00] WARN: Previous postgresql_database[dbfit]: /tmp/vagr
ant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/postgres.rb:12:in `from_file
'
[2014-04-25T12:14:08+00:00] WARN: Current  postgresql_database[dbfit]: /tmp/vagr
ant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/postgres.rb:31:in `from_file
'
[2014-04-25T12:14:15+00:00] INFO: execute[wait for mysql] ran successfully
[2014-04-25T12:14:15+00:00] INFO: mysql_database_user[dftest]: granting access w
ith statement [GRANT all ON `dbfit`.* TO `dftest`@`localhost` IDENTIFIED BY [FIL
TERED]]
[2014-04-25T12:14:15+00:00] INFO: mysql_database_user[dftest]: granting access w
ith statement [GRANT all ON `dbfit`.* TO `dftest`@`127.0.0.1` IDENTIFIED BY [FIL
TERED]]
[2014-04-25T12:14:15+00:00] INFO: mysql_database_user[dbfit_user]: granting acce
ss with statement [GRANT all ON `dbfit`.* TO `dbfit_user`@`localhost` IDENTIFIED
 BY [FILTERED]]
[2014-04-25T12:14:15+00:00] INFO: mysql_database_user[dbfit_user]: granting acce
ss with statement [GRANT all ON `dbfit`.* TO `dbfit_user`@`127.0.0.1` IDENTIFIED
 BY [FILTERED]]
[2014-04-25T12:14:15+00:00] INFO: mysql_database_user[dbfit_user]: granting acce
ss with statement [GRANT select ON `mysql`.* TO `dbfit_user`@`localhost` IDENTIF
IED BY [FILTERED]]
[2014-04-25T12:14:15+00:00] INFO: mysql_database_user[dbfit_user]: granting acce
ss with statement [GRANT select ON `mysql`.* TO `dbfit_user`@`127.0.0.1` IDENTIF
IED BY [FILTERED]]
[2014-04-25T12:14:17+00:00] INFO: bash[assign-postgres-password] ran successfull
y
[2014-04-25T12:14:17+00:00] INFO: postgresql_database_user[dbfit]: granting acce
ss with statement [GRANT all ON DATABASE "dbfit" TO "dbfit"]
NOTICE:  relation "changelog" already exists, skipping

================================================================================

Error executing action `run` on resource 'execute[install Oracle package if avai
lable]'
================================================================================


Mixlib::ShellOut::ShellCommandFailed
------------------------------------
Expected process to exit with [0, 2], but received '127'
---- Begin output of /var/dbfit/dbfit-java/oracle/src/test/resources/install_ora
cle.sh ----
STDOUT:
: No such file or directory
---- End output of /var/dbfit/dbfit-java/oracle/src/test/resources/install_oracl
e.sh ----
Ran /var/dbfit/dbfit-java/oracle/src/test/resources/install_oracle.sh returned 1
27

Resource Declaration:
---------------------
# In /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/oracle.rb

  7: execute 'install Oracle package if available' do
  8:   project_root = node['dbfit']['project_root']
  9:
 10:   user 'root'
 11:   command "#{project_root}/dbfit-java/oracle/src/test/resources/install_ora
cle.sh"
 12:   not_if "grep -q '^XE' /etc/oratab"
 13:   action :run
 14:   returns [0, 2]
 15: end
 16:

Compiled Resource:
------------------
# Declared in /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/oracl
e.rb:7:in `from_file'

execute("install Oracle package if available") do
  action [:run]
  retries 0
  retry_delay 2
  guard_interpreter :default
  command "/var/dbfit/dbfit-java/oracle/src/test/resources/install_oracle.sh"
  backup 5
  returns [0, 2]
  user "root"
  cookbook_name :dbfit_test
  recipe_name "oracle"
  not_if "grep -q '^XE' /etc/oratab"
end

[2014-04-25T12:14:17+00:00] INFO: Running queued delayed notifications before re
-raising exception
[2014-04-25T12:14:17+00:00] ERROR: Running exception handlers
[2014-04-25T12:14:17+00:00] ERROR: Exception handlers complete
[2014-04-25T12:14:17+00:00] FATAL: Stacktrace dumped to /var/chef/cache/chef-sta
cktrace.out
[2014-04-25T12:14:17+00:00] ERROR: execute[install Oracle package if available]
(dbfit_test::oracle line 7) had an error: Mixlib::ShellOut::ShellCommandFailed:
Expected process to exit with [0, 2], but received '127'
---- Begin output of /var/dbfit/dbfit-java/oracle/src/test/resources/install_ora
cle.sh ----
STDOUT:
: No such file or directory
---- End output of /var/dbfit/dbfit-java/oracle/src/test/resources/install_oracl
e.sh ----
Ran /var/dbfit/dbfit-java/oracle/src/test/resources/install_oracle.sh returned 1
27
[2014-04-25T12:14:17+00:00] FATAL: Chef::Exceptions::ChildConvergeError: Chef ru
n 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.

Yavor Nikolov

unread,
Apr 25, 2014, 2:34:36 PM4/25/14
to db...@googlegroups.com
Hi Mark,

Did you manage get the synced folder working? Inside the VM are you able to access the following file:
/var/dbfit/dbfit-java/oracle/src/test/resources/install_oracle.sh

At first glimpse seems the recipe which installs Oracle is not able to find that script. (Or maybe it's not visible as executable one...) In any case - in the output you get there is a tracefile mentioned, maybe it has more details:
FATAL: Stacktrace dumped to /var/chef/cache/chef-stacktrace.out

Regards,
Yavor

MatMan

unread,
Apr 25, 2014, 3:44:58 PM4/25/14
to db...@googlegroups.com
Hi Yavor,

Yes, by creating a symbolic link, as mentioned in the related pages, I've got synced folders working (after removing the nfs bit from the Vagrant file - does the is_windows bit in the Vagrantfile attempt to detect windows and not do NFS if so?).

Here's the contents of the trace file (recognise anything?): -

[vagrant@dbfitvm ~]$ sudo more /var/chef/cache/chef-stacktrace.out
Generated at 2014-04-25 19:36:33 +0000
Mixlib::ShellOut::ShellCommandFailed: execute[install Oracle package if available] (dbfit_test::oracle line 7) had an error: Mixlib:

:ShellOut::ShellCommandFailed: Expected process to exit with [0, 2], but received '127'
---- Begin output of /var/dbfit/dbfit-java/oracle/src/test/resources/install_oracle.sh ----

STDOUT:
: No such file or directory
---- End output of /var/dbfit/dbfit-java/oracle/src/test/resources/install_oracle.sh ----
Ran /var/dbfit/dbfit-java/oracle/src/test/resources/install_oracle.sh returned 127
/opt/chef/embedded/lib/ruby/gems/1.9.1/gems/mixlib-shellout-1.4.0/lib/mixlib/shellout.rb:257:in `invalid!'
/opt/chef/embedded/lib/ruby/gems/1.9.1/gems/mixlib-shellout-1.4.0/lib/mixlib/shellout.rb:244:in `error!'
/opt/chef/embedded/lib/ruby/gems/1.9.1/gems/chef-11.12.2/lib/chef/mixin/shell_out.rb:43:in `shell_out!'
/opt/chef/embedded/lib/ruby/gems/1.9.1/gems/chef-11.12.2/lib/chef/provider/execute.rb:60:in `block in action_run'
/opt/chef/embedded/lib/ruby/gems/1.9.1/gems/chef-11.12.2/lib/chef/mixin/why_run.rb:52:in `call'
/opt/chef/embedded/lib/ruby/gems/1.9.1/gems/chef-11.12.2/lib/chef/mixin/why_run.rb:52:in `add_action'
/opt/chef/embedded/lib/ruby/gems/1.9.1/gems/chef-11.12.2/lib/chef/provider.rb:155:in `converge_by'
/opt/chef/embedded/lib/ruby/gems/1.9.1/gems/chef-11.12.2/lib/chef/provider/execute.rb:59:in `action_run'
/opt/chef/embedded/lib/ruby/gems/1.9.1/gems/chef-11.12.2/lib/chef/provider.rb:120:in `run_action'
/opt/chef/embedded/lib/ruby/gems/1.9.1/gems/chef-11.12.2/lib/chef/resource.rb:637:in `run_action'
/opt/chef/embedded/lib/ruby/gems/1.9.1/gems/chef-11.12.2/lib/chef/runner.rb:49:in `run_action'
/opt/chef/embedded/lib/ruby/gems/1.9.1/gems/chef-11.12.2/lib/chef/runner.rb:81:in `block (2 levels) in converge'
/opt/chef/embedded/lib/ruby/gems/1.9.1/gems/chef-11.12.2/lib/chef/runner.rb:81:in `each'
/opt/chef/embedded/lib/ruby/gems/1.9.1/gems/chef-11.12.2/lib/chef/runner.rb:81:in `block in converge'
/opt/chef/embedded/lib/ruby/gems/1.9.1/gems/chef-11.12.2/lib/chef/resource_collection.rb:98:in `block in execute_each_resource'
/opt/chef/embedded/lib/ruby/gems/1.9.1/gems/chef-11.12.2/lib/chef/resource_collection/stepable_iterator.rb:116:in `call'
/opt/chef/embedded/lib/ruby/gems/1.9.1/gems/chef-11.12.2/lib/chef/resource_collection/stepable_iterator.rb:116:in `call_iterator_blo
ck'
/opt/chef/embedded/lib/ruby/gems/1.9.1/gems/chef-11.12.2/lib/chef/resource_collection/stepable_iterator.rb:85:in `step'
/opt/chef/embedded/lib/ruby/gems/1.9.1/gems/chef-11.12.2/lib/chef/resource_collection/stepable_iterator.rb:104:in `iterate'
/opt/chef/embedded/lib/ruby/gems/1.9.1/gems/chef-11.12.2/lib/chef/resource_collection/stepable_iterator.rb:55:in `each_with_index'
/opt/chef/embedded/lib/ruby/gems/1.9.1/gems/chef-11.12.2/lib/chef/resource_collection.rb:96:in `execute_each_resource'
/opt/chef/embedded/lib/ruby/gems/1.9.1/gems/chef-11.12.2/lib/chef/runner.rb:80:in `converge'
/opt/chef/embedded/lib/ruby/gems/1.9.1/gems/chef-11.12.2/lib/chef/client.rb:345:in `converge'
/opt/chef/embedded/lib/ruby/gems/1.9.1/gems/chef-11.12.2/lib/chef/client.rb:431:in `do_run'
/opt/chef/embedded/lib/ruby/gems/1.9.1/gems/chef-11.12.2/lib/chef/client.rb:213:in `block in run'
/opt/chef/embedded/lib/ruby/gems/1.9.1/gems/chef-11.12.2/lib/chef/client.rb:207:in `fork'
/opt/chef/embedded/lib/ruby/gems/1.9.1/gems/chef-11.12.2/lib/chef/client.rb:207:in `run'
/opt/chef/embedded/lib/ruby/gems/1.9.1/gems/chef-11.12.2/lib/chef/application.rb:217:in `run_chef_client'
/opt/chef/embedded/lib/ruby/gems/1.9.1/gems/chef-11.12.2/lib/chef/application/solo.rb:221:in `block in run_application'
/opt/chef/embedded/lib/ruby/gems/1.9.1/gems/chef-11.12.2/lib/chef/application/solo.rb:213:in `loop'
/opt/chef/embedded/lib/ruby/gems/1.9.1/gems/chef-11.12.2/lib/chef/application/solo.rb:213:in `run_application'
/opt/chef/embedded/lib/ruby/gems/1.9.1/gems/chef-11.12.2/lib/chef/application.rb:67:in `run'
/opt/chef/embedded/lib/ruby/gems/1.9.1/gems/chef-11.12.2/bin/chef-solo:25:in `<top (required)>'
/usr/bin/chef-solo:23:in `load'
/usr/bin/chef-solo:23:in `<main>'
[vagrant@dbfitvm ~]$

Yavor Nikolov

unread,
Apr 26, 2014, 6:04:59 AM4/26/14
to db...@googlegroups.com
Hi Mark,

What happens if you try to manually run that inside the VM:
set -x
sudo /var/dbfit/dbfit-java/oracle/src/test/resources/install_oracle.sh

(One thing I suspect that may have happened: if dbfit has been cloned from Github using git configured to convert line endings to CRLF: this may have messed up the .sh script. Best to fix git settings but a quick workaround: you may run inside the VM "dos2unix /var/dbfit/dbfit-java/oracle/src/test/resources/install_oracle.sh")


Yes, is_windows stuff attempts to detect whether it's running under windows. And in case of windows - it's not using infs. (I gave it a try: detection worked OK for me on winxp and on Windows 8 with current version of vagrant).

Regards,
Yavor

MatMan

unread,
Apr 26, 2014, 8:04:43 AM4/26/14
to db...@googlegroups.com
Thanks Yavor,

I've already been trying this in fact and you're right, the git checkout has created the file with CR/LF new line sequences so the env command couldn't be found as the shell was looking for env<CR>.

When running the shell script manually I have to modify the commands to run as a super user by using sudo. Which user will the shell script actually run as during the vagrant provisioning? Is it all done as root?

I think I'll remove all the bits and pieces and run it through from the top and post a final set of stuff I've encountered and what I needed to do to fix, etc.

Cheers,

Mark

Yavor Nikolov

unread,
Apr 26, 2014, 8:26:43 AM4/26/14
to db...@googlegroups.com
Yes, provisioning is running from root.

Yavor


MatMan

unread,
Apr 26, 2014, 4:03:48 PM4/26/14
to db...@googlegroups.com
Right, all looking good, for now at least.

The only error left was cleaning up the Oracle RPM files (rm -rf $RPM_PATH/Disk1): -


STDERR: ls: cannot access /var/dbfit/Disk1/oracle-xe-*.rpm: No such file or dire
ctory
error:  cannot delete old Disk1/upgrade/gen_inst.sql
        Operation not permitted
error:  cannot delete old Disk1/response/xe.rsp
        Operation not permitted
rm: cannot remove `/var/dbfit/Disk1/response/xe.rsp': Operation not permitted
rm: cannot remove `/var/dbfit/Disk1/upgrade/gen_inst.sql': Operation not permitted

---- End output of /var/dbfit/dbfit-java/oracle/src/test/resources/install_oracle.sh ----
Ran /var/dbfit/dbfit-java/oracle/src/test/resources/install_oracle.sh returned 1
[2014-04-26T17:45:59+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.


The xe.rsp file exists but I can't rm it when using "sudo rm -f xe.rsp". May that's related to the whole synced folders being dodgy in 4.3.10 of VB. Strangely, after destroying the VM and completely removing VB and vagrant before reinstalling and running the entire process again, I don't seem to be affected by the guest additions issue in VB 4.3.10. It's all very odd!

One point about the CONTRIBUTING.md doc - might be worth noting on point 4 ("If you want to provision Oracle database") that if you don't want to then expect to see a failure reported by chef.

Thanks for your help chaps on this. I'll start using the environment and report back any issues.

Yavor Nikolov

unread,
Apr 26, 2014, 4:26:13 PM4/26/14
to db...@googlegroups.com
Hi Mark,

Good to hear you managed to prepare your dev VM. Thanks a lot for sharing your feedback here!

Regarding the case when you don't want to provision Oracle - it's supposed to report a failure but just an info message like:
Go to http://www.oracle.com/technetwork/products/express-edition/downloads/index.html, download oracle-xe-*.rpm
and put it into $RPM_PATH (= root path of dbfit git repo)

Yavor

MatMan

unread,
Apr 27, 2014, 7:01:33 AM4/27/14
to db...@googlegroups.com
Yavor,

I've tested again. The syned folders part of the vagrant setup isn't working on my Win 7 Ultimate machine, unless I remove the code:

, :nfs => !is_windows,
    :nfs_version => 4, :mount_options => ["noatime", "nodiratime"]

I do still need to create the synlink also for the issue with guest additions too today!

This is the only issue when trying to build the vagrant vm from my own machine, from home.

I'll run again from my office in a couple of days, where I have firewalls and a proxy to get through and post my conclusion of that run too.

Cheers,

Mark


This was

Yavor Nikolov

unread,
Apr 28, 2014, 5:50:29 PM4/28/14
to db...@googlegroups.com
Hi Mark,

We just made some enhancements for the Vagrant settings (https://github.com/dbfit/dbfit/pull/279/files). You may give it a try (available on github master branch):
For synced folders:
 - it doesn't set the extra options nfs_version and mount_options in case of windows. (I suspect this was the thing which caused troubles in your case).
 - also support was added to allow customizing synced folders settings without touching Vagrantfile (via vagrant_config_custom.rb). But anyway - I hope defaults are working OK now.

> I do still need to create the synlink also for the issue with guest additions too today!
That's a pain for now but next VirtualBox version is supposed to fix it.

Regards,
Yavor

MatMan

unread,
Apr 29, 2014, 4:01:18 PM4/29/14
to db...@googlegroups.com
I've tested again over the last couple of days and something else seems to be, consistently, broken now. I've tried this from my home machine (no proxy) and office machine. Log follows.

I first removed all the .vagrant.d and .virtualbox files and got a completely fresh clone and wc of the dbfit github repo.

Can you guys get this working on your machines? Vagrant's supposed to remove this issue of course!

Here's the output from "vagrant up" (I'd first saved the .box file locally and modified the Vagrantfile to use the local .box file): -

C:\dbfit\dbfit\test_vm>vagrant up

Bringing machine 'default' up with 'virtualbox' provider...
==> default: Importing base box 'dbfitvm-test'...
==> default: Matching MAC address for NAT networking...
==> default: Setting the name of the VM: test_vm_default_1398800903020_68574

==> default: Installing Chef cookbooks with Librarian-Chef...
==> default:   to file /tmp/install.sh.2776/metadata.txt
==> default: trying wget...
==> default: url        https://opscode-omnibus-packages.s3.amazonaws.com/el/6/x86_64/chef-11.12.2-1.el6.x86_64.rpm
==> default: md5        b8ef6b908b42f1cf97ac7864a8587d9d
==> default: sha256     cc6bafac692a9b6db791310f46917a0c5857bd5b5e69c65daabf0beac3595cfc
==> default: downloaded metadata file looks valid...
==> default: downloading https://opscode-omnibus-packages.s3.amazonaws.com/el/6/x86_64/chef-11.12.2-1.el6.x86_64.rpm
==> default:   to file /tmp/install.sh.2776/chef-11.12.2-1.el6.x86_64.rpm
==> default: trying wget...
==> default: Comparing checksum with sha256sum...

==> default: Installing Chef 11.12.2
==> default: installing with rpm...
==> default: warning:
==> default: /tmp/install.sh.2776/chef-11.12.2-1.el6.x86_64.rpm: Header V4 DSA/SHA1 Signature, key ID 83ef826a: NOKEY
==> default: Preparing...
==> default: ##################################################
==> default: chef
==> default: #
==> default: #
==> default: #
==> default: #
==> default: #
==> default: #
==> default: #
==> default: #
==> default: #
==> default: #
==> default: #
==> default: #
==> default: #
==> default: #
==> default: #
==> default: #
==> default: #
==> default: #
==> default: #
==> default: #
==> default: #
==> default: #
==> default: #
==> default: #
==> default: #
==> default: #
==> default: #
==> default: #
==> default: #
==> default: #
==> default: #
==> default: #
==> default: #
==> default: #
==> default: #
==> default: #
==> default: #
==> default: #
==> default: #
==> default: #
==> default: #
==> default: #
==> default: #
==> default: #
==> default: #
==> default: #
==> default: #
==> default: #
==> default: #
==> default: #
==> default: Thank you for installing Chef!

==> default: Running provisioner: chef_solo...
Generating chef JSON and uploading...
Running chef-solo...
[2014-04-29T19:52:38+00:00] INFO: Forking chef instance to converge...
[2014-04-29T19:52:38+00:00] WARN:

* * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * *
SSL validation of HTTPS requests is disabled. HTTPS connections are still
encrypted, but chef is not able to detect forged replies or man in the middle
attacks.
To fix this issue add an entry like this to your configuration file:
```
  # Verify all HTTPS connections (recommended)
  ssl_verify_mode :verify_peer
  # OR, Verify only connections to chef-server
  verify_api_cert true
```
To check your SSL configuration, or troubleshoot errors, you can use the
`knife ssl check` command like so:
```
  knife ssl check -c /tmp/vagrant-chef-1/solo.rb
```
* * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * *
[2014-04-29T19:52:38+00:00] INFO: *** Chef 11.12.2 ***
[2014-04-29T19:52:38+00:00] INFO: Chef-client pid: 3083
[2014-04-29T19:52:41+00:00] INFO: Setting the run_list to ["recipe[dbfit_test]"] from CLI options
[2014-04-29T19:52:41+00:00] INFO: Run List is [recipe[dbfit_test]]
[2014-04-29T19:52:41+00:00] INFO: Run List expands to [dbfit_test]
[2014-04-29T19:52:41+00:00] INFO: Starting Chef Run for dbfitvm
[2014-04-29T19:52:41+00:00] INFO: Running start handlers
[2014-04-29T19:52:41+00:00] INFO: Start handlers complete.
[2014-04-29T19:52:44+00:00] INFO: WindowsPackage light-weight resource already initialized -- overriding!
[2014-04-29T19:52:44+00:00] WARN: Cloning resource attributes for mysql_database_user[dftest] from prior resource (CHEF-3694)
[2014-04-29T19:52:44+00:00] WARN: Previous mysql_database_user[dftest]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes

/mysql.rb:17:in `block in from_file'
[2014-04-29T19:52:44+00:00] WARN: Current  mysql_database_user[dftest]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes
/mysql.rb:24:in `block (2 levels) in from_file'
[2014-04-29T19:52:44+00:00] WARN: Cloning resource attributes for mysql_database_user[dftest] from prior resource (CHEF-3694)
[2014-04-29T19:52:44+00:00] WARN: Previous mysql_database_user[dftest]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes
/mysql.rb:24:in `block (2 levels) in from_file'
[2014-04-29T19:52:44+00:00] WARN: Current  mysql_database_user[dftest]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes
/mysql.rb:24:in `block (2 levels) in from_file'
[2014-04-29T19:52:44+00:00] WARN: Cloning resource attributes for mysql_database_user[dbfit_user] from prior resource (CHEF-3694)
[2014-04-29T19:52:44+00:00] WARN: Previous mysql_database_user[dbfit_user]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/rec

ipes/mysql.rb:17:in `block in from_file'
[2014-04-29T19:52:44+00:00] WARN: Current  mysql_database_user[dbfit_user]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/rec
ipes/mysql.rb:24:in `block (2 levels) in from_file'
[2014-04-29T19:52:44+00:00] WARN: Cloning resource attributes for mysql_database_user[dbfit_user] from prior resource (CHEF-3694)
[2014-04-29T19:52:44+00:00] WARN: Previous mysql_database_user[dbfit_user]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/rec
ipes/mysql.rb:24:in `block (2 levels) in from_file'
[2014-04-29T19:52:44+00:00] WARN: Current  mysql_database_user[dbfit_user]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/rec
ipes/mysql.rb:24:in `block (2 levels) in from_file'
[2014-04-29T19:52:44+00:00] WARN: Cloning resource attributes for mysql_database_user[dbfit_user] from prior resource (CHEF-3694)
[2014-04-29T19:52:44+00:00] WARN: Previous mysql_database_user[dbfit_user]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/rec
ipes/mysql.rb:24:in `block (2 levels) in from_file'
[2014-04-29T19:52:44+00:00] WARN: Current  mysql_database_user[dbfit_user]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/rec

ipes/mysql.rb:34:in `block in from_file'
[2014-04-29T19:52:44+00:00] WARN: Cloning resource attributes for mysql_database_user[dbfit_user] from prior resource (CHEF-3694)
[2014-04-29T19:52:44+00:00] WARN: Previous mysql_database_user[dbfit_user]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/rec

ipes/mysql.rb:34:in `block in from_file'
[2014-04-29T19:52:44+00:00] WARN: Current  mysql_database_user[dbfit_user]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/rec

ipes/mysql.rb:34:in `block in from_file'
[2014-04-29T19:52:44+00:00] WARN: Cloning resource attributes for mysql_database[dbfit] from prior resource (CHEF-3694)
[2014-04-29T19:52:44+00:00] WARN: Previous mysql_database[dbfit]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/mysql
.rb:11:in `from_file'
[2014-04-29T19:52:44+00:00] WARN: Current  mysql_database[dbfit]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/mysql
.rb:43:in `from_file'
[2014-04-29T19:52:44+00:00] INFO: remote_file[/var/chef/cache/pgdg-centos93-9.3-1.noarch.rpm] created file /var/chef/cache/pgdg-cent
os93-9.3-1.noarch.rpm
[2014-04-29T19:52:45+00:00] INFO: remote_file[/var/chef/cache/pgdg-centos93-9.3-1.noarch.rpm] updated file contents /var/chef/cache/
pgdg-centos93-9.3-1.noarch.rpm
[2014-04-29T19:52:45+00:00] INFO: remote_file[/var/chef/cache/pgdg-centos93-9.3-1.noarch.rpm] mode changed to 644
[2014-04-29T19:52:57+00:00] INFO: package[postgresql93-devel] installing postgresql93-devel-9.3.4-1PGDG.rhel6 from pgdg93 repository

================================================================================
Error executing action `install` on resource 'chef_gem[pg]'
================================================================================
Gem::Installer::ExtensionBuildError
-----------------------------------
ERROR: Failed to build gem native extension.
        /opt/chef/embedded/bin/ruby extconf.rb
checking for pg_config... yes
Using config values from /usr/pgsql-9.3/bin/pg_config
checking for libpq-fe.h... *** extconf.rb failed ***
Could not create Makefile due to some reason, probably lack of
necessary libraries and/or headers.  Check the mkmf.log file for more
details.  You may need configuration options.
Provided configuration options:
        --with-opt-dir
        --with-opt-include
        --without-opt-include=${opt-dir}/include
        --with-opt-lib
        --without-opt-lib=${opt-dir}/lib
        --with-make-prog
        --without-make-prog
        --srcdir=.
        --curdir
        --ruby=/opt/chef/embedded/bin/ruby
        --with-pg
        --without-pg
        --with-pg-config
        --without-pg-config
        --with-pg_config
        --without-pg_config
        --with-pg-dir
        --without-pg-dir
        --with-pg-include
        --without-pg-include=${pg-dir}/include
        --with-pg-lib
        --without-pg-lib=${pg-dir}/lib
/opt/chef/embedded/lib/ruby/1.9.1/mkmf.rb:381:in `try_do': The compiler failed to generate an executable file. (RuntimeError)
You have to install development tools first.
        from /opt/chef/embedded/lib/ruby/1.9.1/mkmf.rb:506:in `try_cpp'
        from /opt/chef/embedded/lib/ruby/1.9.1/mkmf.rb:983:in `block in find_header'
        from /opt/chef/embedded/lib/ruby/1.9.1/mkmf.rb:790:in `block in checking_for'
        from /opt/chef/embedded/lib/ruby/1.9.1/mkmf.rb:284:in `block (2 levels) in postpone'
        from /opt/chef/embedded/lib/ruby/1.9.1/mkmf.rb:254:in `open'
        from /opt/chef/embedded/lib/ruby/1.9.1/mkmf.rb:284:in `block in postpone'
        from /opt/chef/embedded/lib/ruby/1.9.1/mkmf.rb:254:in `open'
        from /opt/chef/embedded/lib/ruby/1.9.1/mkmf.rb:280:in `postpone'
        from /opt/chef/embedded/lib/ruby/1.9.1/mkmf.rb:789:in `checking_for'
        from /opt/chef/embedded/lib/ruby/1.9.1/mkmf.rb:982:in `find_header'
        from extconf.rb:48:in `<main>'

Gem files will remain installed in /opt/chef/embedded/lib/ruby/gems/1.9.1/gems/pg-0.17.1 for inspection.
Results logged to /opt/chef/embedded/lib/ruby/gems/1.9.1/gems/pg-0.17.1/ext/gem_make.out
Cookbook Trace:
---------------
/tmp/vagrant-chef-1/chef-solo-1/cookbooks/postgresql/recipes/ruby.rb:51:in `rescue in from_file'
/tmp/vagrant-chef-1/chef-solo-1/cookbooks/postgresql/recipes/ruby.rb:24:in `from_file'
/tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/postgres.rb:3:in `from_file'
/tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/default.rb:3:in `from_file'
Resource Declaration:
---------------------
# In /tmp/vagrant-chef-1/chef-solo-1/cookbooks/postgresql/recipes/ruby.rb
 51:     chef_gem "pg"
 52:   rescue Gem::Installer::ExtensionBuildError => e
Compiled Resource:
------------------
# Declared in /tmp/vagrant-chef-1/chef-solo-1/cookbooks/postgresql/recipes/ruby.rb:51:in `rescue in from_file'
chef_gem("pg") do
  provider Chef::Provider::Package::Rubygems
  action :install

  retries 0
  retry_delay 2
  guard_interpreter :default
  package_name "pg"
  version "0.17.1"
  cookbook_name :postgresql
  recipe_name "ruby"
end
[2014-04-29T19:53:20+00:00] WARN: Failed to properly build pg gem. Forcing properly linking and retrying (omnibus fix)
================================================================================
Error executing action `run` on resource 'execute[generate pg gem Makefile]'
================================================================================
Mixlib::ShellOut::ShellCommandFailed
------------------------------------
Expected process to exit with [0], but received '1'
---- Begin output of /opt/chef/embedded/bin/ruby extconf.rb --with-pg-config=/usr/pgsql-9.3/bin/pg_config ----
STDOUT:
STDERR: Using config values from /usr/pgsql-9.3/bin/pg_config
*** extconf.rb failed ***
Could not create Makefile due to some reason, probably lack of
necessary libraries and/or headers.  Check the mkmf.log file for more
details.  You may need configuration options.
Provided configuration options:
        --with-opt-dir
        --with-opt-include
        --without-opt-include=${opt-dir}/include
        --with-opt-lib
        --without-opt-lib=${opt-dir}/lib
        --with-make-prog
        --without-make-prog
        --srcdir=.
        --curdir
        --ruby=/opt/chef/embedded/bin/ruby
        --with-pg
        --without-pg
        --with-pg-config
        --with-pg-dir
        --without-pg-dir
        --with-pg-include
        --without-pg-include=${pg-dir}/include
        --with-pg-lib
        --without-pg-lib=${pg-dir}/lib
/opt/chef/embedded/lib/ruby/1.9.1/mkmf.rb:381:in `try_do': The compiler failed to generate an executable file. (RuntimeError)
You have to install development tools first.
        from /opt/chef/embedded/lib/ruby/1.9.1/mkmf.rb:461:in `try_link0'
        from /opt/chef/embedded/lib/ruby/1.9.1/mkmf.rb:476:in `try_link'
        from extconf.rb:52:in `<main>'
---- End output of /opt/chef/embedded/bin/ruby extconf.rb --with-pg-config=/usr/pgsql-9.3/bin/pg_config ----
Ran /opt/chef/embedded/bin/ruby extconf.rb --with-pg-config=/usr/pgsql-9.3/bin/pg_config returned 1
Cookbook Trace:
---------------
/tmp/vagrant-chef-1/chef-solo-1/cookbooks/postgresql/recipes/ruby.rb:92:in `rescue in rescue in from_file'
/tmp/vagrant-chef-1/chef-solo-1/cookbooks/postgresql/recipes/ruby.rb:50:in `rescue in from_file'
/tmp/vagrant-chef-1/chef-solo-1/cookbooks/postgresql/recipes/ruby.rb:24:in `from_file'
/tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/postgres.rb:3:in `from_file'
/tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/default.rb:3:in `from_file'
Resource Declaration:
---------------------
# In /tmp/vagrant-chef-1/chef-solo-1/cookbooks/postgresql/recipes/ruby.rb
 82:     lib_builder = execute 'generate pg gem Makefile' do
 83:       # [COOK-3490] pg gem install requires full path on RHEL
 84:       if node['platform_family'] == 'rhel'
 85:         command "#{RbConfig.ruby} extconf.rb --with-pg-config=/usr/pgsql-#{node['postgresql']['version']}/bin/pg_config"
 86:       else
 87:         command "#{RbConfig.ruby} extconf.rb"
 88:       end
 89:       cwd ext_dir
Compiled Resource:
------------------
# Declared in /tmp/vagrant-chef-1/chef-solo-1/cookbooks/postgresql/recipes/ruby.rb:82:in `rescue in rescue in from_file'
execute("generate pg gem Makefile") do
  action [:nothing]

  retries 0
  retry_delay 2
  guard_interpreter :default
  command "/opt/chef/embedded/bin/ruby extconf.rb --with-pg-config=/usr/pgsql-9.3/bin/pg_config"
  backup 5
  cwd "/opt/chef/embedded/lib/ruby/gems/1.9.1/gems/pg-0.17.1/ext"
  returns 0
  cookbook_name :postgresql
  recipe_name "ruby"
end

================================================================================
Recipe Compile Error in /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/default.rb
================================================================================
Mixlib::ShellOut::ShellCommandFailed
------------------------------------
execute[generate pg gem Makefile] (postgresql::ruby line 82) had an error: Mixlib::ShellOut::ShellCommandFailed: Expected process to
 exit with [0], but received '1'
---- Begin output of /opt/chef/embedded/bin/ruby extconf.rb --with-pg-config=/usr/pgsql-9.3/bin/pg_config ----
STDOUT:
STDERR: Using config values from /usr/pgsql-9.3/bin/pg_config
*** extconf.rb failed ***
Could not create Makefile due to some reason, probably lack of
necessary libraries and/or headers.  Check the mkmf.log file for more
details.  You may need configuration options.
Provided configuration options:
        --with-opt-dir
        --with-opt-include
        --without-opt-include=${opt-dir}/include
        --with-opt-lib
        --without-opt-lib=${opt-dir}/lib
        --with-make-prog
        --without-make-prog
        --srcdir=.
        --curdir
        --ruby=/opt/chef/embedded/bin/ruby
        --with-pg
        --without-pg
        --with-pg-config
        --with-pg-dir
        --without-pg-dir
        --with-pg-include
        --without-pg-include=${pg-dir}/include
        --with-pg-lib
        --without-pg-lib=${pg-dir}/lib
/opt/chef/embedded/lib/ruby/1.9.1/mkmf.rb:381:in `try_do': The compiler failed to generate an executable file. (RuntimeError)
You have to install development tools first.
        from /opt/chef/embedded/lib/ruby/1.9.1/mkmf.rb:461:in `try_link0'
        from /opt/chef/embedded/lib/ruby/1.9.1/mkmf.rb:476:in `try_link'
        from extconf.rb:52:in `<main>'
---- End output of /opt/chef/embedded/bin/ruby extconf.rb --with-pg-config=/usr/pgsql-9.3/bin/pg_config ----
Ran /opt/chef/embedded/bin/ruby extconf.rb --with-pg-config=/usr/pgsql-9.3/bin/pg_config returned 1
Cookbook Trace:
---------------
  /tmp/vagrant-chef-1/chef-solo-1/cookbooks/postgresql/recipes/ruby.rb:92:in `rescue in rescue in from_file'
  /tmp/vagrant-chef-1/chef-solo-1/cookbooks/postgresql/recipes/ruby.rb:50:in `rescue in from_file'
  /tmp/vagrant-chef-1/chef-solo-1/cookbooks/postgresql/recipes/ruby.rb:24:in `from_file'
  /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/postgres.rb:3:in `from_file'
  /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/default.rb:3:in `from_file'
Relevant File Content:
----------------------
/tmp/vagrant-chef-1/chef-solo-1/cookbooks/postgresql/recipes/ruby.rb:
 85:          command "#{RbConfig.ruby} extconf.rb --with-pg-config=/usr/pgsql-#{node['postgresql']['version']}/bin/pg_config"
 86:        else
 87:          command "#{RbConfig.ruby} extconf.rb"
 88:        end
 89:        cwd ext_dir
 90:        action :nothing
 91:      end
 92>>     lib_builder.run_action(:run)
 93:
 94:      lib_maker = execute 'make pg gem lib' do
 95:        command 'make'
 96:        cwd ext_dir
 97:        action :nothing
 98:      end
 99:      lib_maker.run_action(:run)
100:
101:      lib_installer = execute 'install pg gem lib' do
[2014-04-29T19:53:20+00:00] ERROR: Running exception handlers
[2014-04-29T19:53:20+00:00] ERROR: Exception handlers complete
[2014-04-29T19:53:20+00:00] FATAL: Stacktrace dumped to /var/chef/cache/chef-stacktrace.out
[2014-04-29T19:53:20+00:00] ERROR: execute[generate pg gem Makefile] (postgresql::ruby line 82) had an error: Mixlib::ShellOut::Shel
lCommandFailed: Expected process to exit with [0], but received '1'
---- Begin output of /opt/chef/embedded/bin/ruby extconf.rb --with-pg-config=/usr/pgsql-9.3/bin/pg_config ----
STDOUT:
STDERR: Using config values from /usr/pgsql-9.3/bin/pg_config
*** extconf.rb failed ***
Could not create Makefile due to some reason, probably lack of
necessary libraries and/or headers.  Check the mkmf.log file for more
details.  You may need configuration options.
Provided configuration options:
        --with-opt-dir
        --with-opt-include
        --without-opt-include=${opt-dir}/include
        --with-opt-lib
        --without-opt-lib=${opt-dir}/lib
        --with-make-prog
        --without-make-prog
        --srcdir=.
        --curdir
        --ruby=/opt/chef/embedded/bin/ruby
        --with-pg
        --without-pg
        --with-pg-config
        --with-pg-dir
        --without-pg-dir
        --with-pg-include
        --without-pg-include=${pg-dir}/include
        --with-pg-lib
        --without-pg-lib=${pg-dir}/lib
/opt/chef/embedded/lib/ruby/1.9.1/mkmf.rb:381:in `try_do': The compiler failed to generate an executable file. (RuntimeError)
You have to install development tools first.
        from /opt/chef/embedded/lib/ruby/1.9.1/mkmf.rb:461:in `try_link0'
        from /opt/chef/embedded/lib/ruby/1.9.1/mkmf.rb:476:in `try_link'
        from extconf.rb:52:in `<main>'
---- End output of /opt/chef/embedded/bin/ruby extconf.rb --with-pg-config=/usr/pgsql-9.3/bin/pg_config ----
Ran /opt/chef/embedded/bin/ruby extconf.rb --with-pg-config=/usr/pgsql-9.3/bin/pg_config returned 1
[2014-04-29T19:53:20+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.

Yavor Nikolov

unread,
Apr 29, 2014, 5:31:33 PM4/29/14
to db...@googlegroups.com
Hi,

It was working fine 24 hours ago but now I just tried it and it failed for me too: looks like the yum repository server for postgresql is down: http://yum.postgresql.org/ (I hope that's temporary).

Yavor


Yavor Nikolov

unread,
Apr 29, 2014, 5:41:47 PM4/29/14
to db...@googlegroups.com
postgresql doing some planned hardware upgrade:
"
This upgrade will happen on Tuesday, April 29th (today, for most of the world), between 2100-2200 UTC (5pm-6pm US/Eastern).  We hope the downtime will be minimal but the window allows for up to 1 hour."

Yavor

MatMan

unread,
Apr 30, 2014, 5:41:54 PM4/30/14
to db...@googlegroups.com
It still appears to be broken. I've tried it from 2 machines (one Win7 pro 32bit, one Win 7 ultimate 64 bit) both have the same result (error provisioning). I can see errors relating to compilations. How did you find the Postgresql error before amongst the mass of output? Can you tell if it's the same?

BTW I'm now using VB 4.3.8 (I downgraded because of the guest additions issue).

Mark

Log follows...

c:\dbfit\dbfit\test_vm>vagrant provision

==> default: Installing Chef cookbooks with Librarian-Chef...
==> default: Installing Chef 11.12.4 Omnibus package...
==> default: Downloading Chef 11.12.4 for el...
==> default: downloading https://www.getchef.com/chef/metadata?v=11.12.4&prerele
ase=false&nightlies=false&p=el&pv=6&m=x86_64
==> default:   to file /tmp/install.sh.2780/metadata.txt

==> default: trying wget...
==> default: url        https://opscode-omnibus-packages.s3.amazonaws.com/el/6/x
86_64/chef-11.12.4-1.el6.x86_64.rpm
==> default: md5        959acd5df77c25f4f69d1f786f3c7360
==> default: sha256     d4eacc6b16c448a628367e7201922a4c58997f68808c5f698676e8a5
eaf169b5

==> default: downloaded metadata file looks valid...
==> default: downloading https://opscode-omnibus-packages.s3.amazonaws.com/el/6/
x86_64/chef-11.12.4-1.el6.x86_64.rpm
==> default:   to file /tmp/install.sh.2780/chef-11.12.4-1.el6.x86_64.rpm

==> default: trying wget...
==> default: Comparing checksum with sha256sum...
==> default: Installing Chef 11.12.4

==> default: installing with rpm...
==> default: warning:
==> default: /tmp/install.sh.2780/chef-11.12.4-1.el6.x86_64.rpm: Header V4 DSA/SHA1 Signature, key ID 83ef826a: NOKEY
[2014-04-30T21:32:00+00:00] INFO: Forking chef instance to converge...
[2014-04-30T21:32:00+00:00] WARN:

* * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * *
SSL validation of HTTPS requests is disabled. HTTPS connections are still
encrypted, but chef is not able to detect forged replies or man in the middle
attacks.
To fix this issue add an entry like this to your configuration file:
```
  # Verify all HTTPS connections (recommended)
  ssl_verify_mode :verify_peer
  # OR, Verify only connections to chef-server
  verify_api_cert true
```
To check your SSL configuration, or troubleshoot errors, you can use the
`knife ssl check` command like so:
```
  knife ssl check -c /tmp/vagrant-chef-1/solo.rb
```
* * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * *
[2014-04-30T21:32:00+00:00] INFO: *** Chef 11.12.4 ***
[2014-04-30T21:32:00+00:00] INFO: Chef-client pid: 3087
[2014-04-30T21:32:08+00:00] INFO: Setting the run_list to ["recipe[dbfit_test]"] from CLI options
[2014-04-30T21:32:08+00:00] INFO: Run List is [recipe[dbfit_test]]
[2014-04-30T21:32:08+00:00] INFO: Run List expands to [dbfit_test]
[2014-04-30T21:32:08+00:00] INFO: Starting Chef Run for dbfitvm
[2014-04-30T21:32:08+00:00] INFO: Running start handlers
[2014-04-30T21:32:08+00:00] INFO: Start handlers complete.
[2014-04-30T21:32:17+00:00] INFO: WindowsPackage light-weight resource already initialized -- overriding!
[2014-04-30T21:32:19+00:00] WARN: Cloning resource attributes for mysql_database_user[dftest] from prior resource (CHEF-3694)
[2014-04-30T21:32:19+00:00] WARN: Previous mysql_database_user[dftest]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes

/mysql.rb:17:in `block in from_file'
[2014-04-30T21:32:19+00:00] WARN: Current  mysql_database_user[dftest]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes

/mysql.rb:24:in `block (2 levels) in from_file'
[2014-04-30T21:32:19+00:00] WARN: Cloning resource attributes for mysql_database_user[dftest] from prior resource (CHEF-3694)
[2014-04-30T21:32:19+00:00] WARN: Previous mysql_database_user[dftest]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes

/mysql.rb:24:in `block (2 levels) in from_file'
[2014-04-30T21:32:19+00:00] WARN: Current  mysql_database_user[dftest]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes

/mysql.rb:24:in `block (2 levels) in from_file'
[2014-04-30T21:32:19+00:00] WARN: Cloning resource attributes for mysql_database_user[dbfit_user] from prior resource (CHEF-3694)
[2014-04-30T21:32:19+00:00] WARN: Previous mysql_database_user[dbfit_user]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/rec

ipes/mysql.rb:17:in `block in from_file'
[2014-04-30T21:32:19+00:00] WARN: Current  mysql_database_user[dbfit_user]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/rec

ipes/mysql.rb:24:in `block (2 levels) in from_file'
[2014-04-30T21:32:19+00:00] WARN: Cloning resource attributes for mysql_database_user[dbfit_user] from prior resource (CHEF-3694)
[2014-04-30T21:32:19+00:00] WARN: Previous mysql_database_user[dbfit_user]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/rec

ipes/mysql.rb:24:in `block (2 levels) in from_file'
[2014-04-30T21:32:19+00:00] WARN: Current  mysql_database_user[dbfit_user]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/rec

ipes/mysql.rb:24:in `block (2 levels) in from_file'
[2014-04-30T21:32:19+00:00] WARN: Cloning resource attributes for mysql_database_user[dbfit_user] from prior resource (CHEF-3694)
[2014-04-30T21:32:19+00:00] WARN: Previous mysql_database_user[dbfit_user]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/rec

ipes/mysql.rb:24:in `block (2 levels) in from_file'
[2014-04-30T21:32:19+00:00] WARN: Current  mysql_database_user[dbfit_user]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/rec

ipes/mysql.rb:34:in `block in from_file'
[2014-04-30T21:32:19+00:00] WARN: Cloning resource attributes for mysql_database_user[dbfit_user] from prior resource (CHEF-3694)
[2014-04-30T21:32:19+00:00] WARN: Previous mysql_database_user[dbfit_user]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/rec

ipes/mysql.rb:34:in `block in from_file'
[2014-04-30T21:32:19+00:00] WARN: Current  mysql_database_user[dbfit_user]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/rec

ipes/mysql.rb:34:in `block in from_file'
[2014-04-30T21:32:19+00:00] WARN: Cloning resource attributes for mysql_database[dbfit] from prior resource (CHEF-3694)
[2014-04-30T21:32:19+00:00] WARN: Previous mysql_database[dbfit]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/mysql
.rb:11:in `from_file'
[2014-04-30T21:32:19+00:00] WARN: Current  mysql_database[dbfit]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/mysql
.rb:43:in `from_file'
[2014-04-30T21:32:19+00:00] INFO: remote_file[/var/chef/cache/pgdg-centos93-9.3-1.noarch.rpm] created file /var/chef/cache/pgdg-cent
os93-9.3-1.noarch.rpm
[2014-04-30T21:32:20+00:00] INFO: remote_file[/var/chef/cache/pgdg-centos93-9.3-1.noarch.rpm] updated file contents /var/chef/cache/
pgdg-centos93-9.3-1.noarch.rpm
[2014-04-30T21:32:20+00:00] INFO: remote_file[/var/chef/cache/pgdg-centos93-9.3-1.noarch.rpm] mode changed to 644
[2014-04-30T21:32:45+00:00] INFO: package[postgresql93-devel] installing postgresql93-devel-9.3.4-1PGDG.rhel6 from pgdg93 repository
[2014-04-30T21:33:37+00:00] WARN: Failed to properly build pg gem. Forcing properly linking and retrying (omnibus fix)
[2014-04-30T21:33:38+00:00] ERROR: Running exception handlers
[2014-04-30T21:33:38+00:00] ERROR: Exception handlers complete
[2014-04-30T21:33:38+00:00] FATAL: Stacktrace dumped to /var/chef/cache/chef-stacktrace.out
[2014-04-30T21:33:38+00:00] ERROR: execute[generate pg gem Makefile] (postgresql::ruby line 82) had an error: Mixlib::ShellOut::Shel
[2014-04-30T21:33:38+00:00] FATAL: Chef::Exceptions::ChildConvergeError: Chef run process exited unsuccessfully (exit code 1)

Yavor Nikolov

unread,
Apr 30, 2014, 6:11:52 PM4/30/14
to db...@googlegroups.com
postgresql yum server was down just for short time. In the meanwhile we also pushed a few more changes in dbfit master branch on Github (related to test vm cookbooks) - are you using the current version?

It's working fine for me at the moment. Can you try again?


Yavor


MatMan

unread,
May 1, 2014, 4:22:27 AM5/1/14
to db...@googlegroups.com
I've pulled the latest updates from the github master and it's still the same.
 
I've run the provisioning with VAGRANT_LOG=info to see if that helps diagnose the problem.
 
Have you tried zapping your .vagrant.d directory and running the process from the top?
 
Big log follows (I hope the forum can take posts this long!): -
 
c:\dbfit\dbfit\test_vm>vagrant provision
 INFO global: Vagrant version: 1.5.4
 INFO global: Ruby version: 2.0.0
 INFO global: RubyGems version: 2.0.14
 INFO global: VAGRANT_EXECUTABLE="C:\\HashiCorp\\Vagrant\\embedded\\gems\\gems\\vagrant-1.5.4\\bin\\vagrant"
 INFO global: VAGRANT_INSTALLER_EMBEDDED_DIR="C:\\HashiCorp\\Vagrant\\embedded"
 INFO global: VAGRANT_INSTALLER_ENV="1"
 INFO global: VAGRANT_INSTALLER_VERSION="2"
 INFO global: VAGRANT_INTERNAL_BUNDLERIZED="1"
 INFO global: VAGRANT_LOG="info"
 INFO global: Plugins:
 INFO global:   - archive-tar-minitar = 0.5.2
 INFO global:   - bundler = 1.5.3
 INFO global:   - erubis = 2.7.0
 INFO global:   - highline = 1.6.21
 INFO global:   - json = 1.7.7
 INFO global:   - mixlib-log = 1.6.0
 INFO global:   - mixlib-authentication = 1.3.0
 INFO global:   - mixlib-cli = 1.3.0
 INFO global:   - mixlib-config = 2.1.0
 INFO global:   - ffi = 1.9.3
 INFO global:   - win32-process = 0.7.4
 INFO global:   - win32-api = 1.5.1
 INFO global:   - windows-api = 0.4.2
 INFO global:   - windows-pr = 1.2.3
 INFO global:   - mixlib-shellout = 1.4.0
 INFO global:   - net-ssh = 2.7.0
 INFO global:   - net-ssh-gateway = 1.2.0
 INFO global:   - net-ssh-multi = 1.1
 INFO global:   - ipaddress = 0.8.0
 INFO global:   - systemu = 2.5.2
 INFO global:   - yajl-ruby = 1.2.0
 INFO global:   - ohai = 6.22.0
 INFO global:   - mime-types = 2.2
 INFO global:   - rest-client = 1.6.7
 INFO global:   - chef = 11.6.0
 INFO global:   - i18n = 0.6.9
 INFO global:   - thor = 0.19.1
 INFO global:   - librarian = 0.1.2
 INFO global:   - librarian-chef = 0.0.2
 INFO global:   - log4r = 1.1.10
 INFO global:   - micromachine = 1.1.0
 INFO global:   - vagrant-librarian-chef = 0.1.5
 INFO global:   - vagrant-login = 1.0.1
 INFO global:   - vagrant-omnibus = 1.4.1
 INFO global:   - vagrant-proxyconf = 1.2.0
 INFO global:   - vagrant-share = 1.0.1
 INFO global:   - vagrant-vbguest = 0.10.0
 INFO manager: Registered plugin: box command
 INFO manager: Registered plugin: destroy command
 INFO manager: Registered plugin: halt command
 INFO manager: Registered plugin: help command
 INFO manager: Registered plugin: init command
 INFO manager: Registered plugin: list-commands command
 INFO manager: Registered plugin: package command
 INFO manager: Registered plugin: plugin command
 INFO manager: Registered plugin: provision command
 INFO manager: Registered plugin: reload command
 INFO manager: Registered plugin: resume command
 INFO manager: Registered plugin: ssh command
 INFO manager: Registered plugin: ssh-config command
 INFO manager: Registered plugin: status command
 INFO manager: Registered plugin: suspend command
 INFO manager: Registered plugin: up command
 INFO manager: Registered plugin: ssh communicator
 INFO manager: Registered plugin: Arch guest
 INFO manager: Registered plugin: CoreOS guest
 INFO manager: Registered plugin: Darwin guest
 INFO manager: Registered plugin: Debian guest
 INFO manager: Registered plugin: ESXi guest.
 INFO manager: Registered plugin: Fedora guest
 INFO manager: Registered plugin: FreeBSD guest
 INFO manager: Registered plugin: Funtoo guest
 INFO manager: Registered plugin: Gentoo guest
 INFO manager: Registered plugin: Linux guest.
 INFO manager: Registered plugin: NetBSD guest
 INFO manager: Registered plugin: OmniOS guest.
 INFO manager: Registered plugin: OpenBSD guest
 INFO manager: Registered plugin: PLD Linux guest
 INFO manager: Registered plugin: RedHat guest
 INFO manager: Registered plugin: SmartOS guest.
 INFO manager: Registered plugin: Solaris guest.
 INFO manager: Registered plugin: Solaris 11 guest.
 INFO manager: Registered plugin: SUSE guest
 INFO manager: Registered plugin: TinyCore Linux guest.
 INFO manager: Registered plugin: Ubuntu guest
 INFO manager: Registered plugin: Arch host
 INFO manager: Registered plugin: BSD host
 INFO manager: Registered plugin: FreeBSD host
 INFO manager: Registered plugin: Gentoo host
 INFO manager: Registered plugin: Linux host
 INFO manager: Registered plugin: null host
 INFO manager: Registered plugin: OpenSUSE host
 INFO manager: Registered plugin: Red Hat host
 INFO manager: Registered plugin: Slackware host
 INFO manager: Registered plugin: Windows host
 INFO manager: Registered plugin: kernel
 INFO manager: Registered plugin: kernel
 INFO manager: Registered plugin: Hyper-V provider
 INFO manager: Registered plugin: VirtualBox provider
 INFO manager: Registered plugin: ansible
 INFO manager: Registered plugin: CFEngine Provisioner
 INFO manager: Registered plugin: chef
 INFO manager: Registered plugin: docker
 INFO manager: Registered plugin: file
 INFO manager: Registered plugin: puppet
 INFO manager: Registered plugin: salt
 INFO manager: Registered plugin: shell
 INFO manager: Registered plugin: NFS synced folders
 INFO manager: Registered plugin: RSync synced folders
 INFO manager: Registered plugin: SMB synced folders
 INFO global: Loading plugins!
 INFO manager: Registered plugin: vagrant-login
 INFO manager: Registered plugin: vagrant-share
 INFO manager: Registered plugin: vagrant-librarian-chef
 INFO manager: Registered plugin: vagrant-omnibus
 INFO manager: Registered plugin: vagrant-vbguest
 INFO proxyconf: Trying to load vagrant-aws
 INFO proxyconf: Failed to load vagrant-aws: #<LoadError: cannot load such file -- vagrant-aws>
 INFO proxyconf: Ignoring the error
 INFO proxyconf: Trying to load vagrant-omnibus
 INFO proxyconf: Trying to load vagrant-vbguest
 INFO manager: Registered plugin: vagrant-proxyconf
 INFO vagrant: `vagrant` invoked: ["provision"]
 INFO environment: Environment initialized (#<Vagrant::Environment:0x2efa730>)
 INFO environment:   - cwd: c:/dbfit/dbfit/test_vm
 INFO environment: Home path: C:/Users/mattenm/.vagrant.d
 INFO environment: Local data path: c:/dbfit/dbfit/test_vm/.vagrant
 INFO environment: Running hook: environment_plugins_loaded
 INFO runner: Preparing hooks for middleware sequence...
 INFO runner: 5 hooks defined.
 INFO runner: Running action: #<Vagrant::Action::Builder:0x13b9048>
 INFO environment: Running hook: environment_load
 INFO loader: Set :root = #<Pathname:c:/dbfit/dbfit/test_vm/Vagrantfile>
 INFO loader: Loading configuration in order: [:home, :root]
 INFO host: Autodetecting host type for [#<Vagrant::Environment: c:/dbfit/dbfit/test_vm>]
 INFO host: Detected: windows!
 INFO runner: Preparing hooks for middleware sequence...
 INFO runner: 5 hooks defined.
 INFO runner: Running action: #<Vagrant::Action::Builder:0x24e6ca0>
 INFO cli: CLI: [] "provision" ["--"]
 INFO command: Active machine found with name default. Using provider: virtualbox
 INFO environment: Getting machine: default (virtualbox)
 INFO environment: Uncached load of machine.
 INFO loader: Set "25078788_machine_default" = []
 INFO loader: Loading configuration in order: [:home, :root, "25078788_machine_default"]
 INFO box_collection: Box found: dbfitvm-test (virtualbox)
 INFO loader: Set :"24414720_dbfitvm-test_virtualbox" = #<Pathname:C:/Users/mattenm/.vagrant.d/boxes/dbfitvm-test/0/virtualbox/Vagra
ntfile>
 INFO loader: Loading configuration in order: [:"24414720_dbfitvm-test_virtualbox", :home, :root, "25078788_machine_default"]
 INFO machine: Initializing machine: default
 INFO machine:   - Provider: VagrantPlugins::ProviderVirtualBox::Provider
 INFO machine:   - Box: #<Vagrant::Box:0x535ea38>
 INFO machine:   - Data dir: c:/dbfit/dbfit/test_vm/.vagrant/machines/default/virtualbox
 INFO base: VBoxManage path: C:\Program Files\Oracle\VirtualBox\VBoxManage.exe
 INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "--version"]
 INFO meta: Using VirtualBox driver: VagrantPlugins::ProviderVirtualBox::Driver::Version_4_3
 INFO base: VBoxManage path: C:\Program Files\Oracle\VirtualBox\VBoxManage.exe
 INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "2a0f7b28-372c-411d-adc5
-8cb69886a07a"]
 INFO command: With machine: default (#<VagrantPlugins::ProviderVirtualBox::Provider:0x5267940 @logger=#<Log4r::Logger:0x5267910 @fu
llname="vagrant::provider::virtualbox", @outputters=[], @additive=true, @name="virtualbox", @path="vagrant::provider", @parent=#<Log
4r::Logger:0x3157380 @fullname="vagrant", @outputters=[#<Log4r::StderrOutputter:0x3127668 @mon_owner=nil, @mon_count=0, @mon_mutex=#
<Mutex:0x3127620>, @name="stderr", @level=0, @formatter=#<Log4r::DefaultFormatter:0x3124ce0 @depth=7>, @out=#<IO:<STDERR>>>], @addit
ive=true, @name="vagrant", @path="", @parent=#<Log4r::RootLogger:0x3157260 @level=0, @outputters=[]>, @level=2, @trace=false>, @leve
l=2, @trace=false>, @machine=#<Vagrant::Machine: default (VagrantPlugins::ProviderVirtualBox::Provider)>, @driver=#<VagrantPlugins::
ProviderVirtualBox::Driver::Meta:0x524f748 @logger=#<Log4r::Logger:0x523e4c8 @fullname="vagrant::provider::virtualbox::meta", @outpu
tters=[], @additive=true, @name="meta", @path="vagrant::provider::virtualbox", @parent=#<Log4r::Logger:0x5267910 @fullname="vagrant:
:provider::virtualbox", @outputters=[], @additive=true, @name="virtualbox", @path="vagrant::provider", @parent=#<Log4r::Logger:0x315
7380 @fullname="vagrant", @outputters=[#<Log4r::StderrOutputter:0x3127668 @mon_owner=nil, @mon_count=0, @mon_mutex=#<Mutex:0x3127620
>, @name="stderr", @level=0, @formatter=#<Log4r::DefaultFormatter:0x3124ce0 @depth=7>, @out=#<IO:<STDERR>>>], @additive=true, @name=
"vagrant", @path="", @parent=#<Log4r::RootLogger:0x3157260 @level=0, @outputters=[]>, @level=2, @trace=false>, @level=2, @trace=fals
e>, @level=2, @trace=false>, @interrupted=false, @vboxmanage_path="C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", @uuid="2a
0f7b28-372c-411d-adc5-8cb69886a07a", @version="4.3.8", @driver=#<VagrantPlugins::ProviderVirtualBox::Driver::Version_4_3:0x55d3da8 @
logger=#<Log4r::Logger:0x55ecab0 @fullname="vagrant::provider::virtualbox_4_3", @outputters=[], @additive=true, @name="virtualbox_4_
3", @path="vagrant::provider", @parent=#<Log4r::Logger:0x3157380 @fullname="vagrant", @outputters=[#<Log4r::StderrOutputter:0x312766
8 @mon_owner=nil, @mon_count=0, @mon_mutex=#<Mutex:0x3127620>, @name="stderr", @level=0, @formatter=#<Log4r::DefaultFormatter:0x3124
ce0 @depth=7>, @out=#<IO:<STDERR>>>], @additive=true, @name="vagrant", @path="", @parent=#<Log4r::RootLogger:0x3157260 @level=0, @ou
tputters=[]>, @level=2, @trace=false>, @level=2, @trace=false>, @interrupted=false, @vboxmanage_path="C:\\Program Files\\Oracle\\Vir
tualBox\\VBoxManage.exe", @uuid="2a0f7b28-372c-411d-adc5-8cb69886a07a">>, @cap_logger=#<Log4r::Logger:0x5675268 @fullname="vagrant::
capability_host::vagrantplugins::providervirtualbox::provider", @outputters=[], @additive=true, @name="provider", @path="vagrant::ca
pability_host::vagrantplugins::providervirtualbox", @parent=#<Log4r::Logger:0x3157380 @fullname="vagrant", @outputters=[#<Log4r::Std
errOutputter:0x3127668 @mon_owner=nil, @mon_count=0, @mon_mutex=#<Mutex:0x3127620>, @name="stderr", @level=0, @formatter=#<Log4r::De
faultFormatter:0x3124ce0 @depth=7>, @out=#<IO:<STDERR>>>], @additive=true, @name="vagrant", @path="", @parent=#<Log4r::RootLogger:0x
3157260 @level=0, @outputters=[]>, @level=2, @trace=false>, @level=2, @trace=false>, @cap_host_chain=[[:virtualbox, #<#<Class:0x5675
4c0>:0x56aa188>]], @cap_args=[#<Vagrant::Machine: default (VagrantPlugins::ProviderVirtualBox::Provider)>], @cap_caps={:hyperv=>#<Va
grant::Registry:0x56753e8 @items={:public_address=>#<Proc:0x313aa48@C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/plugins/pr
oviders/hyperv/plugin.rb:25>}, @results_cache={}>, :virtualbox=>#<Vagrant::Registry:0x5675370 @items={:forwarded_ports=>#<Proc:0x312
d6e0@C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/plugins/providers/virtualbox/plugin.rb:27>, :public_address=>#<Proc:0x13a
0178@C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-share-1.0.1/lib/vagrant-share.rb:39>}, @results_cache={}>}>)
 INFO machine: Calling action: provision on provider VirtualBox (2a0f7b28-372c-411d-adc5-8cb69886a07a)
 INFO runner: Preparing hooks for middleware sequence...
 INFO runner: 5 hooks defined.
 INFO runner: Running action: #<Vagrant::Action::Builder:0x56a8b08>
 INFO warden: Calling IN action: #<VagrantPlugins::ProviderVirtualBox::Action::CheckVirtualbox:0x56c9d18>
 INFO base: VBoxManage path: C:\Program Files\Oracle\VirtualBox\VBoxManage.exe
 INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "--version"]
 INFO meta: Using VirtualBox driver: VagrantPlugins::ProviderVirtualBox::Driver::Version_4_3
 INFO base: VBoxManage path: C:\Program Files\Oracle\VirtualBox\VBoxManage.exe
 INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "list", "hostonlyifs"]
 INFO warden: Calling IN action: #<Vagrant::Action::Builtin::ConfigValidate:0x56c9d00>
 INFO warden: Calling IN action: #<Vagrant::Action::Builtin::Call:0x56c9ce8>
 INFO runner: Preparing hooks for middleware sequence...
 INFO runner: 5 hooks defined.
 INFO runner: Running action: #<Vagrant::Action::Builder:0x2fbfc38>
 INFO warden: Calling IN action: #<VagrantPlugins::ProviderVirtualBox::Action::Created:0x3010590>
 INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "2a0f7b28-372c-411d-adc5
-8cb69886a07a", "--machinereadable"]
 INFO warden: Calling OUT action: #<VagrantPlugins::ProviderVirtualBox::Action::Created:0x3010590>
 INFO runner: Preparing hooks for middleware sequence...
 INFO runner: 5 hooks defined.
 INFO runner: Running action: #<Vagrant::Action::Warden:0x3c741f0>
 INFO warden: Calling IN action: #<Proc:0x3e9f820@C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/action/warden.rb
:94 (lambda)>
 INFO warden: Calling IN action: #<Vagrant::Action::Builtin::Call:0x3c74160>
 INFO runner: Preparing hooks for middleware sequence...
 INFO runner: 5 hooks defined.
 INFO runner: Running action: #<Vagrant::Action::Builder:0x3f3f408>
 INFO warden: Calling IN action: #<VagrantPlugins::ProviderVirtualBox::Action::IsRunning:0x3f469b0>
 INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "2a0f7b28-372c-411d-adc5
-8cb69886a07a", "--machinereadable"]
 INFO warden: Calling OUT action: #<VagrantPlugins::ProviderVirtualBox::Action::IsRunning:0x3f469b0>
 INFO runner: Preparing hooks for middleware sequence...
 INFO runner: 5 hooks defined.
 INFO runner: Running action: #<Vagrant::Action::Warden:0x4007478>
 INFO warden: Calling IN action: #<Proc:0x41060d0@C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/action/warden.rb
:94 (lambda)>
 INFO warden: Calling IN action: #<VagrantPlugins::ProviderVirtualBox::Action::CheckAccessible:0x40073e8>
 INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "2a0f7b28-372c-411d-adc5
-8cb69886a07a", "--machinereadable"]
 INFO warden: Calling IN action: #<VagrantPlugins::LibrarianChef::Action::Install:0x40073b8>
 INFO interface: info: Installing Chef cookbooks with Librarian-Chef...
 INFO interface: info: ==> default: Installing Chef cookbooks with Librarian-Chef...
==> default: Installing Chef cookbooks with Librarian-Chef...
 INFO warden: Calling IN action: #<Vagrant::Action::Builtin::Provision:0x4007358>
 INFO warden: Calling IN action: #<VagrantPlugins::ProxyConf::Action::OnlyOnce:0x403d280>
 INFO warden: Calling IN action: #<VagrantPlugins::Omnibus::Action::InstallChef:0x403d250>
 INFO warden: Calling IN action: #<VagrantPlugins::ProxyConf::Action::OnlyOnce:0x40acce8>
 INFO runner: Preparing hooks for middleware sequence...
 INFO runner: 5 hooks defined.
 INFO runner: Running action: #<Vagrant::Action::Warden:0x3f26fa0>
 INFO warden: Calling IN action: #<Proc:0x3fe78a0@C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/action/warden.rb
:94 (lambda)>
 INFO warden: Calling IN action: #<Vagrant::Action::Builtin::Call:0x3f26f10>
 INFO runner: Preparing hooks for middleware sequence...
 INFO runner: 5 hooks defined.
 INFO runner: Running action: #<Vagrant::Action::Builder:0x408c948>
 INFO warden: Calling IN action: #<VagrantPlugins::ProxyConf::Action::IsEnabled:0x40af718>
 INFO warden: Calling OUT action: #<VagrantPlugins::ProxyConf::Action::IsEnabled:0x40af718>
 INFO runner: Preparing hooks for middleware sequence...
 INFO runner: 5 hooks defined.
 INFO runner: Running action: #<Vagrant::Action::Warden:0x40fe510>
 INFO warden: Calling IN action: #<Proc:0x4154b98@C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/action/warden.rb
:94 (lambda)>
 INFO warden: Calling IN action: #<VagrantPlugins::ProxyConf::Action::ConfigureAptProxy:0x40fe480>
 INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "2a0f7b28-372c-411d-adc5
-8cb69886a07a", "--machinereadable"]
 INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "2a0f7b28-372c-411d-adc5
-8cb69886a07a", "--machinereadable"]
 INFO ssh: Attempting SSH connnection...
 INFO ssh: Attempting to connect to SSH...
 INFO ssh:   - Host: 127.0.0.1
 INFO ssh:   - Port: 2222
 INFO ssh:   - Username: vagrant
 INFO ssh:   - Password? false
 INFO ssh:   - Key Path: ["C:/Users/mattenm/.vagrant.d/insecure_private_key"]
 INFO ssh: SSH is ready!
 INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "2a0f7b28-372c-411d-adc5
-8cb69886a07a", "--machinereadable"]
 INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "2a0f7b28-372c-411d-adc5
-8cb69886a07a", "--machinereadable"]
 INFO guest: Autodetecting host type for [#<Vagrant::Machine: default (VagrantPlugins::ProviderVirtualBox::Provider)>]
 INFO ssh: Execute: grep 'Fedora release [12][67890]' /etc/redhat-release (sudo=false)
 INFO ssh: Execute: cat /etc/pld-release (sudo=false)
 INFO ssh: Execute: cat /etc/SuSE-release (sudo=false)
 INFO ssh: Execute: cat /etc/issue | grep 'Ubuntu' (sudo=false)
 INFO ssh: Execute: cat /etc/arch-release (sudo=false)
 INFO ssh: Execute: cat /etc/os-release | grep ID=coreos (sudo=false)
 INFO ssh: Execute: cat /etc/issue | grep 'Debian' (sudo=false)
 INFO ssh: Execute: grep Funtoo /etc/gentoo-release (sudo=false)
 INFO ssh: Execute: grep Gentoo /etc/gentoo-release (sudo=false)
 INFO ssh: Execute: cat /etc/release | grep -i OmniOS (sudo=false)
 INFO ssh: Execute: cat /etc/redhat-release (sudo=false)
 INFO guest: Detected: redhat!
 INFO proxyconf: Skipping Apt proxy config as the machine does not support it
 INFO warden: Calling IN action: #<VagrantPlugins::ProxyConf::Action::ConfigureChefProxy:0x40fe450>
 INFO interface: info: Configuring proxy for Chef provisioners...
 INFO interface: info: ==> default: Configuring proxy for Chef provisioners...
==> default: Configuring proxy for Chef provisioners...
 INFO warden: Calling IN action: #<VagrantPlugins::ProxyConf::Action::ConfigureEnvProxy:0x40fe420>
 INFO ssh: SSH is ready!
 INFO ssh: SSH is ready!
 INFO guest: Execute capability: env_proxy_conf [#<Vagrant::Machine: default (VagrantPlugins::ProviderVirtualBox::Provider)>] (redha
t)
 INFO interface: info: Configuring proxy environment variables...
 INFO interface: info: ==> default: Configuring proxy environment variables...
==> default: Configuring proxy environment variables...
 INFO ssh: SSH is ready!
 INFO guest: Execute capability: env_proxy_conf [#<Vagrant::Machine: default (VagrantPlugins::ProviderVirtualBox::Provider)>] (redha
t)
 INFO ssh: Execute: rm /tmp/vagrant-proxyconf (sudo=true)
 INFO ssh: Execute: chmod 0644 /tmp/vagrant-proxyconf (sudo=true)
 INFO ssh: Execute: chown root:root /tmp/vagrant-proxyconf (sudo=true)
 INFO ssh: Execute: mkdir -p /etc/profile.d (sudo=true)
 INFO ssh: Execute: mv /tmp/vagrant-proxyconf /etc/profile.d/proxy.sh (sudo=true)
 INFO ssh: Execute: rm /tmp/vagrant-proxyconf (sudo=true)
 INFO ssh: Execute: chmod 0440 /tmp/vagrant-proxyconf (sudo=true)
 INFO ssh: Execute: chown root:root /tmp/vagrant-proxyconf (sudo=true)
 INFO ssh: Execute: mkdir -p /etc/sudoers.d (sudo=true)
 INFO ssh: Execute: mv /tmp/vagrant-proxyconf /etc/sudoers.d/proxy (sudo=true)
 INFO warden: Calling IN action: #<VagrantPlugins::ProxyConf::Action::ConfigureGitProxy:0x40fe3f0>
 INFO proxyconf: git_proxy not enabled or configured
 INFO warden: Calling IN action: #<VagrantPlugins::ProxyConf::Action::ConfigureNpmProxy:0x40fe3c0>
 INFO ssh: SSH is ready!
 INFO ssh: SSH is ready!
 INFO guest: Execute capability: npm_proxy_conf [#<Vagrant::Machine: default (VagrantPlugins::ProviderVirtualBox::Provider)>] (redha
t)
 INFO ssh: Execute: which npm (sudo=false)
 INFO proxyconf: Skipping npm proxy config as `npm` is not found
 INFO warden: Calling IN action: #<VagrantPlugins::ProxyConf::Action::ConfigurePearProxy:0x40fe390>
 INFO ssh: SSH is ready!
 INFO ssh: SSH is ready!
 INFO guest: Execute capability: pear_proxy_conf [#<Vagrant::Machine: default (VagrantPlugins::ProviderVirtualBox::Provider)>] (redh
at)
 INFO ssh: Execute: which pear (sudo=false)
 INFO proxyconf: Skipping PEAR proxy config as `pear` is not found
 INFO warden: Calling IN action: #<VagrantPlugins::ProxyConf::Action::ConfigureSvnProxy:0x40fe360>
 INFO proxyconf: svn_proxy not enabled or configured
 INFO warden: Calling IN action: #<VagrantPlugins::ProxyConf::Action::ConfigureYumProxy:0x40fe330>
 INFO ssh: SSH is ready!
 INFO ssh: SSH is ready!
 INFO guest: Execute capability: yum_proxy_conf [#<Vagrant::Machine: default (VagrantPlugins::ProviderVirtualBox::Provider)>] (redha
t)
 INFO interface: info: Configuring proxy for Yum...
 INFO interface: info: ==> default: Configuring proxy for Yum...
==> default: Configuring proxy for Yum...
 INFO ssh: SSH is ready!
 INFO guest: Execute capability: yum_proxy_conf [#<Vagrant::Machine: default (VagrantPlugins::ProviderVirtualBox::Provider)>] (redha
t)
 INFO ssh: Execute: rm /tmp/vagrant-proxyconf (sudo=true)
 INFO ssh: Execute: touch /etc/yum.conf (sudo=true)
 INFO ssh: Execute: gawk -f /tmp/vagrant-proxyconf -v proxy=http://gbproxy.internal.bupa.co.uk:80 -v user=gbbupagroup\%5cmattenm -v
pass=Feb2013\%21 /etc/yum.conf > /etc/yum.conf.new (sudo=true)
 INFO ssh: Execute: chmod 0644 /etc/yum.conf.new (sudo=true)
 INFO ssh: Execute: chown root:root /etc/yum.conf.new (sudo=true)
 INFO ssh: Execute: mv /etc/yum.conf.new /etc/yum.conf (sudo=true)
 INFO ssh: Execute: rm /tmp/vagrant-proxyconf (sudo=true)
 INFO warden: Calling OUT action: #<VagrantPlugins::ProxyConf::Action::ConfigureYumProxy:0x40fe330>
 INFO warden: Calling OUT action: #<VagrantPlugins::ProxyConf::Action::ConfigureSvnProxy:0x40fe360>
 INFO warden: Calling OUT action: #<VagrantPlugins::ProxyConf::Action::ConfigurePearProxy:0x40fe390>
 INFO warden: Calling OUT action: #<VagrantPlugins::ProxyConf::Action::ConfigureNpmProxy:0x40fe3c0>
 INFO warden: Calling OUT action: #<VagrantPlugins::ProxyConf::Action::ConfigureGitProxy:0x40fe3f0>
 INFO warden: Calling OUT action: #<VagrantPlugins::ProxyConf::Action::ConfigureEnvProxy:0x40fe420>
 INFO warden: Calling OUT action: #<VagrantPlugins::ProxyConf::Action::ConfigureChefProxy:0x40fe450>
 INFO warden: Calling OUT action: #<VagrantPlugins::ProxyConf::Action::ConfigureAptProxy:0x40fe480>
 INFO warden: Calling OUT action: #<Proc:0x4154b98@C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/action/warden.r
b:94 (lambda)>
 INFO warden: Calling OUT action: #<Vagrant::Action::Builtin::Call:0x3f26f10>
 INFO warden: Calling OUT action: #<Proc:0x3fe78a0@C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/action/warden.r
b:94 (lambda)>
 INFO warden: Calling OUT action: #<VagrantPlugins::ProxyConf::Action::OnlyOnce:0x40acce8>
 INFO ssh: SSH is ready!
 INFO ssh: Execute: echo $(chef-solo -v) (sudo=true)
 INFO downloader: Downloader starting download:
 INFO downloader:   -- Source: https://www.getchef.com/chef/install.sh
 INFO downloader:   -- Destination: C:/Users/mattenm/.vagrant.d/tmp/1398931960-install.sh
 INFO subprocess: Starting process: ["C:\\HashiCorp\\Vagrant\\embedded\\bin/curl.EXE", "--fail", "--location", "--max-redirs", "10",
 "--user-agent", "Vagrant/1.5.4", "--output", "C:/Users/mattenm/.vagrant.d/tmp/1398931960-install.sh", "https://www.getchef.com/chef
/install.sh"]
 INFO interface: info: Installing Chef 11.12.4 Omnibus package...
 INFO interface: info: ==> default: Installing Chef 11.12.4 Omnibus package...

==> default: Installing Chef 11.12.4 Omnibus package...
 INFO ssh: Execute: sh install.sh -v 11.12.4 2>&1 (sudo=true)
 INFO interface: info: Downloading Chef 11.12.4 for el...
 
 INFO interface: info: ==> default: Downloading Chef 11.12.4 for el...

==> default: Downloading Chef 11.12.4 for el...
 INFO interface: info: downloading https://www.getchef.com/chef/metadata?v=11.12.4&prerelease=false&nightlies=false&p=el&pv=6&m=x86_
64
  to file /tmp/install.sh.4055/metadata.txt
trying wget...
 
 INFO interface: info: ==> default: downloading https://www.getchef.com/chef/metadata?v=11.12.4&prerelease=false&nightlies=false&p=e
l&pv=6&m=x86_64
==> default:   to file /tmp/install.sh.4055/metadata.txt
==> default: trying wget...
==> default: downloading https://www.getchef.com/chef/metadata?v=11.12.4&prerelease=false&nightlies=false&p=el&pv=6&m=x86_64
==> default:   to file /tmp/install.sh.4055/metadata.txt
==> default: trying wget...
 INFO interface: info: url      https://opscode-omnibus-packages.s3.amazonaws.com/el/6/x86_64/chef-11.12.4-1.el6.x86_64.rpm
md5     959acd5df77c25f4f69d1f786f3c7360
sha256  d4eacc6b16c448a628367e7201922a4c58997f68808c5f698676e8a5eaf169b5
 

==> default: md5        959acd5df77c25f4f69d1f786f3c7360
==> default: sha256     d4eacc6b16c448a628367e7201922a4c58997f68808c5f698676e8a5eaf169b5

==> default: md5        959acd5df77c25f4f69d1f786f3c7360
==> default: sha256     d4eacc6b16c448a628367e7201922a4c58997f68808c5f698676e8a5eaf169b5
 INFO interface: info: downloaded metadata file looks valid...
 
 INFO interface: info: ==> default: downloaded metadata file looks valid...

==> default: downloaded metadata file looks valid...
 INFO interface: info: downloading https://opscode-omnibus-packages.s3.amazonaws.com/el/6/x86_64/chef-11.12.4-1.el6.x86_64.rpm
  to file /tmp/install.sh.4055/chef-11.12.4-1.el6.x86_64.rpm
trying wget...
 
 INFO interface: info: ==> default: downloading https://opscode-omnibus-packages.s3.amazonaws.com/el/6/x86_64/chef-11.12.4-1.el6.x86
_64.rpm
==> default:   to file /tmp/install.sh.4055/chef-11.12.4-1.el6.x86_64.rpm
==> default: trying wget...
==> default: downloading https://opscode-omnibus-packages.s3.amazonaws.com/el/6/x86_64/chef-11.12.4-1.el6.x86_64.rpm
==> default:   to file /tmp/install.sh.4055/chef-11.12.4-1.el6.x86_64.rpm
==> default: trying wget...
 INFO interface: info: Comparing checksum with sha256sum...
 
 INFO interface: info: ==> default: Comparing checksum with sha256sum...
==> default: Comparing checksum with sha256sum...
 INFO interface: info: Installing Chef 11.12.4
installing with rpm...
 
 INFO interface: info: ==> default: Installing Chef 11.12.4

==> default: installing with rpm...
==> default: Installing Chef 11.12.4
==> default: installing with rpm...
 INFO interface: info: warning:
 INFO interface: info: ==> default: warning:
==> default: warning:
 INFO interface: info: /tmp/install.sh.4055/chef-11.12.4-1.el6.x86_64.rpm: Header V4 DSA/SHA1 Signature, key ID 83ef826a: NOKEY
 
 INFO interface: info: ==> default: /tmp/install.sh.4055/chef-11.12.4-1.el6.x86_64.rpm: Header V4 DSA/SHA1 Signature, key ID 83ef826
a: NOKEY
==> default: /tmp/install.sh.4055/chef-11.12.4-1.el6.x86_64.rpm: Header V4 DSA/SHA1 Signature, key ID 83ef826a: NOKEY
 INFO interface: info: Preparing...
 INFO interface: info: ==> default: Preparing...
==> default: Preparing...
 INFO interface: info: ##################################################
 INFO interface: info: ==> default: ##################################################
==> default: ##################################################
 INFO interface: info:
 
 INFO interface: info:
 
 INFO interface: info: chef
 INFO interface: info: ==> default: chef
==> default: chef
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info: #
 INFO interface: info: ==> default: #
==> default: #
 INFO interface: info:
 
 INFO interface: info:
 
 INFO interface: info: Thank you for installing Chef!
 
 INFO interface: info: ==> default: Thank you for installing Chef!

==> default: Thank you for installing Chef!
 INFO warden: Calling OUT action: #<VagrantPlugins::Omnibus::Action::InstallChef:0x403d250>
 INFO warden: Calling OUT action: #<VagrantPlugins::ProxyConf::Action::OnlyOnce:0x403d280>
 INFO interface: info: Running provisioner: chef_solo...
 INFO interface: info: ==> default: Running provisioner: chef_solo...

==> default: Running provisioner: chef_solo...
 INFO environment: Running hook: provisioner_run
 INFO runner: Preparing hooks for middleware sequence...
 INFO runner: 6 hooks defined.
 INFO runner: Running action: #<Method: Vagrant::Action::Builtin::Provision#run_provisioner>
 INFO warden: Calling IN action: #<Proc:0x2467008@C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/action/warden.rb
:94 (lambda)>
 INFO ssh: Execute: mkdir -p /tmp/vagrant-chef-1 (sudo=true)
 INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "2a0f7b28-372c-411d-adc5
-8cb69886a07a", "--machinereadable"]
 INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "2a0f7b28-372c-411d-adc5
-8cb69886a07a", "--machinereadable"]
 INFO ssh: Execute: chown -h vagrant /tmp/vagrant-chef-1 (sudo=true)
 INFO ssh: Execute: mkdir -p /var/chef/backup (sudo=true)
 INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "2a0f7b28-372c-411d-adc5
-8cb69886a07a", "--machinereadable"]
 INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "2a0f7b28-372c-411d-adc5
-8cb69886a07a", "--machinereadable"]
 INFO ssh: Execute: chown -h vagrant /var/chef/backup (sudo=true)
 INFO ssh: Execute: mkdir -p /var/chef/cache (sudo=true)
 INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "2a0f7b28-372c-411d-adc5
-8cb69886a07a", "--machinereadable"]
 INFO subprocess: Starting process: ["C:\\Program Files\\Oracle\\VirtualBox\\VBoxManage.exe", "showvminfo", "2a0f7b28-372c-411d-adc5
-8cb69886a07a", "--machinereadable"]
 INFO ssh: Execute: chown -h vagrant /var/chef/cache (sudo=true)
 INFO ssh: Execute: test -d /tmp/vagrant-chef-1/chef-solo-1/cookbooks (sudo=true)
 INFO ssh: Execute: which chef-solo (sudo=true)
 INFO interface: info: Generating chef JSON and uploading...

Generating chef JSON and uploading...
 INFO ssh: Execute: rm -f /tmp/vagrant-chef-1/dna.json (sudo=true)
 INFO ssh: Execute: rm -f /tmp/vagrant-chef-1/solo.rb (sudo=true)
 INFO interface: info: Running chef-solo...
Running chef-solo...
 INFO ssh: Execute: chef-solo -c /tmp/vagrant-chef-1/solo.rb -j /tmp/vagrant-chef-1/dna.json --no-color  (sudo=true)
 INFO interface: info: [2014-05-01T08:13:40+00:00] INFO: Forking chef instance to converge...
 
[2014-05-01T08:13:40+00:00] INFO: Forking chef instance to converge...
 INFO interface: info: [2014-05-01T08:13:40+00:00] WARN:

* * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * *
SSL validation of HTTPS requests is disabled. HTTPS connections are still
encrypted, but chef is not able to detect forged replies or man in the middle
attacks.
 
To fix this issue add an entry like this to your configuration file:
 
```
  # Verify all HTTPS connections (recommended)
  ssl_verify_mode :verify_peer
 
  # OR, Verify only connections to chef-server
  verify_api_cert true
```
 
To check your SSL configuration, or troubleshoot errors, you can use the
`knife ssl check` command like so:
 
```
  knife ssl check -c /tmp/vagrant-chef-1/solo.rb
```
 
* * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * *
 

[2014-05-01T08:13:40+00:00] WARN:

* * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * *
SSL validation of HTTPS requests is disabled. HTTPS connections are still
encrypted, but chef is not able to detect forged replies or man in the middle
attacks.
 
To fix this issue add an entry like this to your configuration file:
 
```
  # Verify all HTTPS connections (recommended)
  ssl_verify_mode :verify_peer
 
  # OR, Verify only connections to chef-server
  verify_api_cert true
```
 
To check your SSL configuration, or troubleshoot errors, you can use the
`knife ssl check` command like so:
 
```
  knife ssl check -c /tmp/vagrant-chef-1/solo.rb
```
 
* * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * *
 
 INFO interface: info: [2014-05-01T08:13:40+00:00] INFO: *** Chef 11.12.4 ***
 
[2014-05-01T08:13:40+00:00] INFO: *** Chef 11.12.4 ***
 INFO interface: info: [2014-05-01T08:13:40+00:00] INFO: Chef-client pid: 4362
 
[2014-05-01T08:13:40+00:00] INFO: Chef-client pid: 4362
 INFO interface: info: [2014-05-01T08:13:42+00:00] INFO: Setting the run_list to ["recipe[dbfit_test]"] from CLI options
 
[2014-05-01T08:13:42+00:00] INFO: Setting the run_list to ["recipe[dbfit_test]"] from CLI options
 INFO interface: info: [2014-05-01T08:13:42+00:00] INFO: Run List is [recipe[dbfit_test]]
 
[2014-05-01T08:13:42+00:00] INFO: Run List is [recipe[dbfit_test]]
 INFO interface: info: [2014-05-01T08:13:42+00:00] INFO: Run List expands to [dbfit_test]
 
[2014-05-01T08:13:42+00:00] INFO: Run List expands to [dbfit_test]
 INFO interface: info: [2014-05-01T08:13:42+00:00] INFO: Starting Chef Run for dbfitvm
 
[2014-05-01T08:13:42+00:00] INFO: Starting Chef Run for dbfitvm
 INFO interface: info: [2014-05-01T08:13:42+00:00] INFO: Running start handlers
 
[2014-05-01T08:13:42+00:00] INFO: Running start handlers
 INFO interface: info: [2014-05-01T08:13:42+00:00] INFO: Start handlers complete.
 
[2014-05-01T08:13:42+00:00] INFO: Start handlers complete.
 INFO interface: info: [2014-05-01T08:13:44+00:00] INFO: WindowsPackage light-weight resource already initialized -- overriding!
 
[2014-05-01T08:13:44+00:00] INFO: WindowsPackage light-weight resource already initialized -- overriding!
 INFO interface: info: [2014-05-01T08:13:44+00:00] WARN: Cloning resource attributes for mysql_database_user[dftest] from prior reso
urce (CHEF-3694)
 
[2014-05-01T08:13:44+00:00] WARN: Cloning resource attributes for mysql_database_user[dftest] from prior resource (CHEF-3694)
 INFO interface: info: [2014-05-01T08:13:44+00:00] WARN: Previous mysql_database_user[dftest]: /tmp/vagrant-chef-1/chef-solo-1/cookb

ooks/dbfit_test/recipes/mysql.rb:17:in `block in from_file'
 
[2014-05-01T08:13:44+00:00] WARN: Previous mysql_database_user[dftest]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes

/mysql.rb:17:in `block in from_file'
 INFO interface: info: [2014-05-01T08:13:44+00:00] WARN: Current  mysql_database_user[dftest]: /tmp/vagrant-chef-1/chef-solo-1/cookb

ooks/dbfit_test/recipes/mysql.rb:24:in `block (2 levels) in from_file'
 
[2014-05-01T08:13:44+00:00] WARN: Current  mysql_database_user[dftest]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes

/mysql.rb:24:in `block (2 levels) in from_file'
 INFO interface: info: [2014-05-01T08:13:44+00:00] WARN: Cloning resource attributes for mysql_database_user[dftest] from prior reso
urce (CHEF-3694)
 
[2014-05-01T08:13:44+00:00] WARN: Cloning resource attributes for mysql_database_user[dftest] from prior resource (CHEF-3694)
 INFO interface: info: [2014-05-01T08:13:44+00:00] WARN: Previous mysql_database_user[dftest]: /tmp/vagrant-chef-1/chef-solo-1/cookb

ooks/dbfit_test/recipes/mysql.rb:24:in `block (2 levels) in from_file'
 
[2014-05-01T08:13:44+00:00] WARN: Previous mysql_database_user[dftest]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes

/mysql.rb:24:in `block (2 levels) in from_file'
 INFO interface: info: [2014-05-01T08:13:44+00:00] WARN: Current  mysql_database_user[dftest]: /tmp/vagrant-chef-1/chef-solo-1/cookb

ooks/dbfit_test/recipes/mysql.rb:24:in `block (2 levels) in from_file'
 
[2014-05-01T08:13:44+00:00] WARN: Current  mysql_database_user[dftest]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes

/mysql.rb:24:in `block (2 levels) in from_file'
 INFO interface: info: [2014-05-01T08:13:44+00:00] WARN: Cloning resource attributes for mysql_database_user[dbfit_user] from prior
resource (CHEF-3694)
 
[2014-05-01T08:13:44+00:00] WARN: Cloning resource attributes for mysql_database_user[dbfit_user] from prior resource (CHEF-3694)
 INFO interface: info: [2014-05-01T08:13:44+00:00] WARN: Previous mysql_database_user[dbfit_user]: /tmp/vagrant-chef-1/chef-solo-1/c

ookbooks/dbfit_test/recipes/mysql.rb:17:in `block in from_file'
 
[2014-05-01T08:13:44+00:00] WARN: Previous mysql_database_user[dbfit_user]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/rec

ipes/mysql.rb:17:in `block in from_file'
 INFO interface: info: [2014-05-01T08:13:44+00:00] WARN: Current  mysql_database_user[dbfit_user]: /tmp/vagrant-chef-1/chef-solo-1/c

ookbooks/dbfit_test/recipes/mysql.rb:24:in `block (2 levels) in from_file'
 
[2014-05-01T08:13:44+00:00] WARN: Current  mysql_database_user[dbfit_user]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/rec

ipes/mysql.rb:24:in `block (2 levels) in from_file'
 INFO interface: info: [2014-05-01T08:13:44+00:00] WARN: Cloning resource attributes for mysql_database_user[dbfit_user] from prior
resource (CHEF-3694)
 
[2014-05-01T08:13:44+00:00] WARN: Cloning resource attributes for mysql_database_user[dbfit_user] from prior resource (CHEF-3694)
 INFO interface: info: [2014-05-01T08:13:44+00:00] WARN: Previous mysql_database_user[dbfit_user]: /tmp/vagrant-chef-1/chef-solo-1/c

ookbooks/dbfit_test/recipes/mysql.rb:24:in `block (2 levels) in from_file'
 
[2014-05-01T08:13:44+00:00] WARN: Previous mysql_database_user[dbfit_user]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/rec

ipes/mysql.rb:24:in `block (2 levels) in from_file'
 INFO interface: info: [2014-05-01T08:13:44+00:00] WARN: Current  mysql_database_user[dbfit_user]: /tmp/vagrant-chef-1/chef-solo-1/c

ookbooks/dbfit_test/recipes/mysql.rb:24:in `block (2 levels) in from_file'
 
[2014-05-01T08:13:44+00:00] WARN: Current  mysql_database_user[dbfit_user]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/rec

ipes/mysql.rb:24:in `block (2 levels) in from_file'
 INFO interface: info: [2014-05-01T08:13:44+00:00] WARN: Cloning resource attributes for mysql_database_user[dbfit_user] from prior
resource (CHEF-3694)
 
[2014-05-01T08:13:44+00:00] WARN: Cloning resource attributes for mysql_database_user[dbfit_user] from prior resource (CHEF-3694)
 INFO interface: info: [2014-05-01T08:13:44+00:00] WARN: Previous mysql_database_user[dbfit_user]: /tmp/vagrant-chef-1/chef-solo-1/c

ookbooks/dbfit_test/recipes/mysql.rb:24:in `block (2 levels) in from_file'
 
[2014-05-01T08:13:44+00:00] WARN: Previous mysql_database_user[dbfit_user]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/rec

ipes/mysql.rb:24:in `block (2 levels) in from_file'
 INFO interface: info: [2014-05-01T08:13:44+00:00] WARN: Current  mysql_database_user[dbfit_user]: /tmp/vagrant-chef-1/chef-solo-1/c

ookbooks/dbfit_test/recipes/mysql.rb:34:in `block in from_file'
 
[2014-05-01T08:13:44+00:00] WARN: Current  mysql_database_user[dbfit_user]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/rec

ipes/mysql.rb:34:in `block in from_file'
 INFO interface: info: [2014-05-01T08:13:44+00:00] WARN: Cloning resource attributes for mysql_database_user[dbfit_user] from prior
resource (CHEF-3694)
 
[2014-05-01T08:13:44+00:00] WARN: Cloning resource attributes for mysql_database_user[dbfit_user] from prior resource (CHEF-3694)
 INFO interface: info: [2014-05-01T08:13:44+00:00] WARN: Previous mysql_database_user[dbfit_user]: /tmp/vagrant-chef-1/chef-solo-1/c

ookbooks/dbfit_test/recipes/mysql.rb:34:in `block in from_file'
 
[2014-05-01T08:13:44+00:00] WARN: Previous mysql_database_user[dbfit_user]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/rec

ipes/mysql.rb:34:in `block in from_file'
 INFO interface: info: [2014-05-01T08:13:44+00:00] WARN: Current  mysql_database_user[dbfit_user]: /tmp/vagrant-chef-1/chef-solo-1/c

ookbooks/dbfit_test/recipes/mysql.rb:34:in `block in from_file'
 
[2014-05-01T08:13:44+00:00] WARN: Current  mysql_database_user[dbfit_user]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/rec

ipes/mysql.rb:34:in `block in from_file'
 INFO interface: info: [2014-05-01T08:13:44+00:00] WARN: Cloning resource attributes for mysql_database[dbfit] from prior resource (
CHEF-3694)
 
[2014-05-01T08:13:44+00:00] WARN: Cloning resource attributes for mysql_database[dbfit] from prior resource (CHEF-3694)
 INFO interface: info: [2014-05-01T08:13:44+00:00] WARN: Previous mysql_database[dbfit]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/d
bfit_test/recipes/mysql.rb:11:in `from_file'
 
[2014-05-01T08:13:44+00:00] WARN: Previous mysql_database[dbfit]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/mysql
.rb:11:in `from_file'
 INFO interface: info: [2014-05-01T08:13:44+00:00] WARN: Current  mysql_database[dbfit]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/d
bfit_test/recipes/mysql.rb:43:in `from_file'
 
[2014-05-01T08:13:44+00:00] WARN: Current  mysql_database[dbfit]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/mysql
.rb:43:in `from_file'
 INFO interface: info: [2014-05-01T08:13:44+00:00] INFO: remote_file[/var/chef/cache/pgdg-centos93-9.3-1.noarch.rpm] created file /v
ar/chef/cache/pgdg-centos93-9.3-1.noarch.rpm
 
[2014-05-01T08:13:44+00:00] INFO: remote_file[/var/chef/cache/pgdg-centos93-9.3-1.noarch.rpm] created file /var/chef/cache/pgdg-cent
os93-9.3-1.noarch.rpm
 INFO interface: info: [2014-05-01T08:13:44+00:00] INFO: remote_file[/var/chef/cache/pgdg-centos93-9.3-1.noarch.rpm] updated file co
ntents /var/chef/cache/pgdg-centos93-9.3-1.noarch.rpm
 
[2014-05-01T08:13:44+00:00] INFO: remote_file[/var/chef/cache/pgdg-centos93-9.3-1.noarch.rpm] updated file contents /var/chef/cache/
pgdg-centos93-9.3-1.noarch.rpm
 INFO interface: info: [2014-05-01T08:13:44+00:00] INFO: remote_file[/var/chef/cache/pgdg-centos93-9.3-1.noarch.rpm] mode changed to
 644
 
[2014-05-01T08:13:44+00:00] INFO: remote_file[/var/chef/cache/pgdg-centos93-9.3-1.noarch.rpm] mode changed to 644
 INFO interface: info: [2014-05-01T08:14:00+00:00] INFO: package[postgresql93-devel] installing postgresql93-devel-9.3.4-1PGDG.rhel6
 from pgdg93 repository
 
[2014-05-01T08:14:00+00:00] INFO: package[postgresql93-devel] installing postgresql93-devel-9.3.4-1PGDG.rhel6 from pgdg93 repository
 
 INFO interface: info:
 

 INFO interface: info: ================================================================================
Cookbook Trace:
---------------
/tmp/vagrant-chef-1/chef-solo-1/cookbooks/postgresql/recipes/ruby.rb:64:in `rescue in from_file'

/tmp/vagrant-chef-1/chef-solo-1/cookbooks/postgresql/recipes/ruby.rb:24:in `from_file'
/tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/postgres.rb:3:in `from_file'
/tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/default.rb:3:in `from_file'
 
Resource Declaration:
---------------------
# In /tmp/vagrant-chef-1/chef-solo-1/cookbooks/postgresql/recipes/ruby.rb
 
 64:     chef_gem "pg"
 65:   rescue Gem::Installer::ExtensionBuildError => e
 
Compiled Resource:
------------------
# Declared in /tmp/vagrant-chef-1/chef-solo-1/cookbooks/postgresql/recipes/ruby.rb:64:in `rescue in from_file'
 
chef_gem("pg") do
  provider Chef::Provider::Package::Rubygems
  action :install
  retries 0
  retry_delay 2
  guard_interpreter :default
  package_name "pg"
  version "0.17.1"
  cookbook_name :postgresql
  recipe_name "ruby"
end
 
[2014-05-01T08:14:08+00:00] WARN: Failed to properly build pg gem. Forcing properly linking and retrying (omnibus fix)
 
================================================================================
Cookbook Trace:
---------------
/tmp/vagrant-chef-1/chef-solo-1/cookbooks/postgresql/recipes/ruby.rb:64:in `rescue in from_file'

/tmp/vagrant-chef-1/chef-solo-1/cookbooks/postgresql/recipes/ruby.rb:24:in `from_file'
/tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/postgres.rb:3:in `from_file'
/tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/default.rb:3:in `from_file'
 
Resource Declaration:
---------------------
# In /tmp/vagrant-chef-1/chef-solo-1/cookbooks/postgresql/recipes/ruby.rb
 
 64:     chef_gem "pg"
 65:   rescue Gem::Installer::ExtensionBuildError => e
 
Compiled Resource:
------------------
# Declared in /tmp/vagrant-chef-1/chef-solo-1/cookbooks/postgresql/recipes/ruby.rb:64:in `rescue in from_file'
 
chef_gem("pg") do
  provider Chef::Provider::Package::Rubygems
  action :install
  retries 0
  retry_delay 2
  guard_interpreter :default
  package_name "pg"
  version "0.17.1"
  cookbook_name :postgresql
  recipe_name "ruby"
end
 
[2014-05-01T08:14:08+00:00] WARN: Failed to properly build pg gem. Forcing properly linking and retrying (omnibus fix)
 INFO interface: info:
Cookbook Trace:
---------------
/tmp/vagrant-chef-1/chef-solo-1/cookbooks/postgresql/recipes/ruby.rb:105:in `rescue in rescue in from_file'
/tmp/vagrant-chef-1/chef-solo-1/cookbooks/postgresql/recipes/ruby.rb:63:in `rescue in from_file'

/tmp/vagrant-chef-1/chef-solo-1/cookbooks/postgresql/recipes/ruby.rb:24:in `from_file'
/tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/postgres.rb:3:in `from_file'
/tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/default.rb:3:in `from_file'
 
Resource Declaration:
---------------------
# In /tmp/vagrant-chef-1/chef-solo-1/cookbooks/postgresql/recipes/ruby.rb
 
 95:     lib_builder = execute 'generate pg gem Makefile' do
 96:       # [COOK-3490] pg gem install requires full path on RHEL
 97:       if node['platform_family'] == 'rhel'
 98:         command "#{RbConfig.ruby} extconf.rb --with-pg-config=/usr/pgsql-#{node['postgresql']['version']}/bin/pg_config"
 99:       else
100:         command "#{RbConfig.ruby} extconf.rb"
101:       end
102:       cwd ext_dir
 
Compiled Resource:
------------------
# Declared in /tmp/vagrant-chef-1/chef-solo-1/cookbooks/postgresql/recipes/ruby.rb:95:in `rescue in rescue in from_file'
 
execute("generate pg gem Makefile") do
  action [:nothing]
  retries 0
  retry_delay 2
  guard_interpreter :default
  command "/opt/chef/embedded/bin/ruby extconf.rb --with-pg-config=/usr/pgsql-9.3/bin/pg_config"
  backup 5
  cwd "/opt/chef/embedded/lib/ruby/gems/1.9.1/gems/pg-0.17.1/ext"
  returns 0
  cookbook_name :postgresql
  recipe_name "ruby"
end
 
 
 
================================================================================
Cookbook Trace:
---------------
/tmp/vagrant-chef-1/chef-solo-1/cookbooks/postgresql/recipes/ruby.rb:105:in `rescue in rescue in from_file'
/tmp/vagrant-chef-1/chef-solo-1/cookbooks/postgresql/recipes/ruby.rb:63:in `rescue in from_file'

/tmp/vagrant-chef-1/chef-solo-1/cookbooks/postgresql/recipes/ruby.rb:24:in `from_file'
/tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/postgres.rb:3:in `from_file'
/tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/default.rb:3:in `from_file'
 
Resource Declaration:
---------------------
# In /tmp/vagrant-chef-1/chef-solo-1/cookbooks/postgresql/recipes/ruby.rb
 
 95:     lib_builder = execute 'generate pg gem Makefile' do
 96:       # [COOK-3490] pg gem install requires full path on RHEL
 97:       if node['platform_family'] == 'rhel'
 98:         command "#{RbConfig.ruby} extconf.rb --with-pg-config=/usr/pgsql-#{node['postgresql']['version']}/bin/pg_config"
 99:       else
100:         command "#{RbConfig.ruby} extconf.rb"
101:       end
102:       cwd ext_dir
 
Compiled Resource:
------------------
# Declared in /tmp/vagrant-chef-1/chef-solo-1/cookbooks/postgresql/recipes/ruby.rb:95:in `rescue in rescue in from_file'
 
execute("generate pg gem Makefile") do
  action [:nothing]
  retries 0
  retry_delay 2
  guard_interpreter :default
  command "/opt/chef/embedded/bin/ruby extconf.rb --with-pg-config=/usr/pgsql-9.3/bin/pg_config"
  backup 5
  cwd "/opt/chef/embedded/lib/ruby/gems/1.9.1/gems/pg-0.17.1/ext"
  returns 0
  cookbook_name :postgresql
  recipe_name "ruby"
end
 
 INFO interface: info:

================================================================================
Recipe Compile Error in /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/default.rb
================================================================================
 
Mixlib::ShellOut::ShellCommandFailed
------------------------------------
execute[generate pg gem Makefile] (postgresql::ruby line 95) had an error: Mixlib::ShellOut::ShellCommandFailed: Expected process to
Cookbook Trace:
---------------
  /tmp/vagrant-chef-1/chef-solo-1/cookbooks/postgresql/recipes/ruby.rb:105:in `rescue in rescue in from_file'
  /tmp/vagrant-chef-1/chef-solo-1/cookbooks/postgresql/recipes/ruby.rb:63:in `rescue in from_file'

  /tmp/vagrant-chef-1/chef-solo-1/cookbooks/postgresql/recipes/ruby.rb:24:in `from_file'
  /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/postgres.rb:3:in `from_file'
  /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/default.rb:3:in `from_file'
 
Relevant File Content:
----------------------
/tmp/vagrant-chef-1/chef-solo-1/cookbooks/postgresql/recipes/ruby.rb:
 
 98:          command "#{RbConfig.ruby} extconf.rb --with-pg-config=/usr/pgsql-#{node['postgresql']['version']}/bin/pg_config"
 99:        else
100:          command "#{RbConfig.ruby} extconf.rb"
101:        end
102:        cwd ext_dir
103:        action :nothing
104:      end
105>>     lib_builder.run_action(:run)
106:
107:      lib_maker = execute 'make pg gem lib' do
108:        command 'make'
109:        cwd ext_dir
110:        action :nothing
111:      end
112:      lib_maker.run_action(:run)
113:
114:      lib_installer = execute 'install pg gem lib' do
 
[2014-05-01T08:14:09+00:00] ERROR: Running exception handlers
[2014-05-01T08:14:09+00:00] ERROR: Exception handlers complete
[2014-05-01T08:14:09+00:00] FATAL: Stacktrace dumped to /var/chef/cache/chef-stacktrace.out
 

================================================================================
Recipe Compile Error in /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/default.rb
================================================================================
 
Mixlib::ShellOut::ShellCommandFailed
------------------------------------
execute[generate pg gem Makefile] (postgresql::ruby line 95) had an error: Mixlib::ShellOut::ShellCommandFailed: Expected process to
Cookbook Trace:
---------------
  /tmp/vagrant-chef-1/chef-solo-1/cookbooks/postgresql/recipes/ruby.rb:105:in `rescue in rescue in from_file'
  /tmp/vagrant-chef-1/chef-solo-1/cookbooks/postgresql/recipes/ruby.rb:63:in `rescue in from_file'

  /tmp/vagrant-chef-1/chef-solo-1/cookbooks/postgresql/recipes/ruby.rb:24:in `from_file'
  /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/postgres.rb:3:in `from_file'
  /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/default.rb:3:in `from_file'
 
Relevant File Content:
----------------------
/tmp/vagrant-chef-1/chef-solo-1/cookbooks/postgresql/recipes/ruby.rb:
 
 98:          command "#{RbConfig.ruby} extconf.rb --with-pg-config=/usr/pgsql-#{node['postgresql']['version']}/bin/pg_config"
 99:        else
100:          command "#{RbConfig.ruby} extconf.rb"
101:        end
102:        cwd ext_dir
103:        action :nothing
104:      end
105>>     lib_builder.run_action(:run)
106:
107:      lib_maker = execute 'make pg gem lib' do
108:        command 'make'
109:        cwd ext_dir
110:        action :nothing
111:      end
112:      lib_maker.run_action(:run)
113:
114:      lib_installer = execute 'install pg gem lib' do
 
[2014-05-01T08:14:09+00:00] ERROR: Running exception handlers
[2014-05-01T08:14:09+00:00] ERROR: Exception handlers complete
[2014-05-01T08:14:09+00:00] FATAL: Stacktrace dumped to /var/chef/cache/chef-stacktrace.out
 INFO interface: info: [2014-05-01T08:14:09+00:00] ERROR: execute[generate pg gem Makefile] (postgresql::ruby line 95) had an error:
[2014-05-01T08:14:09+00:00] ERROR: execute[generate pg gem Makefile] (postgresql::ruby line 95) had an error: Mixlib::ShellOut::Shel
 INFO interface: info: [2014-05-01T08:14:09+00:00] FATAL: Chef::Exceptions::ChildConvergeError: Chef run process exited unsuccessful
ly (exit code 1)
 
[2014-05-01T08:14:09+00:00] FATAL: Chef::Exceptions::ChildConvergeError: Chef run process exited unsuccessfully (exit code 1)
ERROR warden: Error occurred: Chef never successfully completed! Any errors should be visible in the

output above. Please fix your recipes so that they properly complete.
 INFO warden: Beginning recovery process...
 INFO warden: Recovery complete.
ERROR warden: Error occurred: Chef never successfully completed! Any errors should be visible in the

output above. Please fix your recipes so that they properly complete.
 INFO warden: Beginning recovery process...
 INFO warden: Calling recover: #<VagrantPlugins::ProxyConf::Action::OnlyOnce:0x40acce8>
 INFO warden: Beginning recovery process...
 INFO warden: Calling recover: #<Vagrant::Action::Builtin::Call:0x3f26f10>
 INFO warden: Beginning recovery process...
 INFO warden: Recovery complete.
 INFO warden: Recovery complete.
 INFO warden: Calling recover: #<VagrantPlugins::ProxyConf::Action::OnlyOnce:0x403d280>
 INFO warden: Recovery complete.
 INFO warden: Beginning recovery process...
 INFO warden: Recovery complete.
 INFO warden: Beginning recovery process...
 INFO warden: Recovery complete.
ERROR warden: Error occurred: Chef never successfully completed! Any errors should be visible in the

output above. Please fix your recipes so that they properly complete.
 INFO warden: Beginning recovery process...
 INFO warden: Recovery complete.
ERROR warden: Error occurred: Chef never successfully completed! Any errors should be visible in the

output above. Please fix your recipes so that they properly complete.
 INFO warden: Beginning recovery process...
 INFO warden: Calling recover: #<Vagrant::Action::Builtin::Call:0x3c74160>
 INFO warden: Beginning recovery process...
 INFO warden: Recovery complete.
 INFO warden: Recovery complete.
ERROR warden: Error occurred: Chef never successfully completed! Any errors should be visible in the

output above. Please fix your recipes so that they properly complete.
 INFO warden: Beginning recovery process...
 INFO warden: Recovery complete.
ERROR warden: Error occurred: Chef never successfully completed! Any errors should be visible in the

output above. Please fix your recipes so that they properly complete.
 INFO warden: Beginning recovery process...
 INFO warden: Calling recover: #<Vagrant::Action::Builtin::Call:0x56c9ce8>
 INFO warden: Beginning recovery process...
 INFO warden: Recovery complete.
 INFO warden: Recovery complete.
 INFO warden: Beginning recovery process...
 INFO warden: Recovery complete.
 INFO warden: Beginning recovery process...
 INFO warden: Recovery complete.
 INFO environment: Running hook: environment_unload
 INFO runner: Preparing hooks for middleware sequence...
 INFO runner: 5 hooks defined.
 INFO runner: Running action: #<Vagrant::Action::Builder:0x2475df8>
ERROR vagrant: Vagrant experienced an error! Details:
ERROR vagrant: #<VagrantPlugins::Chef::Provisioner::Base::ChefError: Chef never successfully completed! Any errors should be visible

 in the
output above. Please fix your recipes so that they properly complete.>
ERROR vagrant: Chef never successfully completed! Any errors should be visible in the

output above. Please fix your recipes so that they properly complete.
ERROR vagrant: C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/plugins/provisioners/chef/provisioner/chef_solo.rb:170:in `run_
chef_solo'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/plugins/provisioners/chef/provisioner/chef_solo.rb:54:in `provision'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/action/builtin/provision.rb:115:in `run_provisioner'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/action/warden.rb:95:in `call'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/action/warden.rb:95:in `block in finalize_action'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/action/warden.rb:34:in `call'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/action/warden.rb:34:in `call'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/action/builder.rb:116:in `call'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/action/runner.rb:69:in `block in run'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/util/busy.rb:19:in `busy'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/action/runner.rb:69:in `run'

C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/environment.rb:304:in `hook'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/action/builtin/provision.rb:100:in `call'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/action/builtin/provision.rb:100:in `block in call'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/action/builtin/provision.rb:91:in `each'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/action/builtin/provision.rb:91:in `call'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/action/warden.rb:34:in `call'
C:/Users/mattenm/.vagrant.d/gems/gems/vagrant-librarian-chef-0.1.5/lib/vagrant-librarian-chef/action/librarian_chef.rb:29:in `call'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/action/warden.rb:34:in `call'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/plugins/providers/virtualbox/action/check_accessible.rb:18:in `call'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/action/warden.rb:34:in `call'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/action/warden.rb:95:in `block in finalize_action'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/action/warden.rb:34:in `call'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/action/warden.rb:34:in `call'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/action/builder.rb:116:in `call'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/action/runner.rb:69:in `block in run'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/util/busy.rb:19:in `busy'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/action/runner.rb:69:in `run'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/action/builtin/call.rb:51:in `call'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/action/warden.rb:34:in `call'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/action/warden.rb:95:in `block in finalize_action'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/action/warden.rb:34:in `call'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/action/warden.rb:34:in `call'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/action/builder.rb:116:in `call'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/action/runner.rb:69:in `block in run'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/util/busy.rb:19:in `busy'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/action/runner.rb:69:in `run'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/action/builtin/call.rb:51:in `call'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/action/warden.rb:34:in `call'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/action/builtin/config_validate.rb:25:in `call'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/action/warden.rb:34:in `call'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/plugins/providers/virtualbox/action/check_virtualbox.rb:17:in `call'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/action/warden.rb:34:in `call'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/action/builder.rb:116:in `call'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/action/runner.rb:69:in `block in run'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/util/busy.rb:19:in `busy'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/action/runner.rb:69:in `run'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/machine.rb:157:in `action'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/plugins/commands/provision/command.rb:35:in `block in execute'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/plugin/v2/command.rb:200:in `block in with_target_vms'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/plugin/v2/command.rb:194:in `each'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/plugin/v2/command.rb:194:in `with_target_vms'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/plugins/commands/provision/command.rb:34:in `execute'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/cli.rb:42:in `execute'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/lib/vagrant/environment.rb:248:in `cli'
C:/HashiCorp/Vagrant/embedded/gems/gems/vagrant-1.5.4/bin/vagrant:164:in `<main>'
 INFO interface: error: Chef never successfully completed! Any errors should be visible in the

output above. Please fix your recipes so that they properly complete.
Chef never successfully completed! Any errors should be visible in the
output above. Please fix your recipes so that they properly complete.
 INFO interface: Machine: error-exit ["VagrantPlugins::Chef::Provisioner::Base::ChefError", "Chef never successfully completed! Any
errors should be visible in the\noutput above. Please fix your recipes so that they properly complete."]

Yavor Nikolov

unread,
May 1, 2014, 4:58:24 AM5/1/14
to db...@googlegroups.com
> Have you tried zapping your .vagrant.d
vagrant.d is for general vagrant settings (it's not under dbfit folders at all) - stores box images, plugins, etc. Perhaps you may purge it if you plan to re-install vagrant.
What I purge sometimes is: tmp, .vagrant, cookbooks

* One difference in my setup (in addition to using Linux as host OS): I'm using vbox 4.3.10. Can you try with 4.3.10 again? (It's not giving me the error any more. If it does for you - you may try to disable auto-update for now: https://github.com/dotless-de/vagrant-vbguest/issues/116 : perhaps it will be able to work with old vbox addons too).

Yavor

--

MatMan

unread,
May 1, 2014, 5:58:01 AM5/1/14
to db...@googlegroups.com
I'll give 4.3.10 a go again.
 
Also, I found 2 mkmf.log files on the VM. Contents follow...
 
The first file seems to contain a linker error
/usr/bin/ld: cannot find -lshadow
collect2: ld returned 1 exit status
File 1:
***********************************************************************************************************************************************************************************************
***********************************************************************************************************************************************************************************************
***********************************************************************************************************************************************************************************************
[vagrant@dbfitvm ~]$ cat /opt/chef/embedded/lib/ruby/gems/1.9.1/gems/ruby-shadow-2.3.4/mkmf.log
have_library: checking for getspent() in -lshadow... -------------------- no
"gcc -o conftest -I/opt/chef/embedded/include/ruby-1.9.1/x86_64-linux -I/opt/chef/embedded/include/ruby-1.9.1/ruby/backward -I/opt/c
hef/embedded/include/ruby-1.9.1 -I.    -I/opt/chef/embedded/include -DRUBY19 conftest.c  -L. -L/opt/chef/embedded/lib -Wl,-R/opt/che
f/embedded/lib -L/opt/chef/embedded/lib -Wl,-R/opt/chef/embedded/lib -L. -Wl,-rpath,/opt/chef/embedded/lib -L/opt/chef/embedded/lib
-rdynamic -Wl,-export-dynamic -L/opt/chef/embedded/lib  -Wl,-R/opt/chef/embedded/lib      -Wl,-R -Wl,/opt/chef/embedded/lib -L/opt/c
hef/embedded/lib -lruby  -lpthread -lrt -ldl -lcrypt -lm   -lc"
checked program was:
/* begin */
1: #include "ruby.h"
2:
3: int main(int argc, char **argv)
4: {
5:   return 0;
6: }
/* end */
"gcc -o conftest -I/opt/chef/embedded/include/ruby-1.9.1/x86_64-linux -I/opt/chef/embedded/include/ruby-1.9.1/ruby/backward -I/opt/c
hef/embedded/include/ruby-1.9.1 -I.    -I/opt/chef/embedded/include -DRUBY19 conftest.c  -L. -L/opt/chef/embedded/lib -Wl,-R/opt/che
f/embedded/lib -L/opt/chef/embedded/lib -Wl,-R/opt/chef/embedded/lib -L. -Wl,-rpath,/opt/chef/embedded/lib -L/opt/chef/embedded/lib
-rdynamic -Wl,-export-dynamic -L/opt/chef/embedded/lib  -Wl,-R/opt/chef/embedded/lib      -Wl,-R -Wl,/opt/chef/embedded/lib -L/opt/c
hef/embedded/lib -lruby -lshadow  -lpthread -lrt -ldl -lcrypt -lm   -lc"
conftest.c: In function 't':
conftest.c:4: error: 'getspent' undeclared (first use in this function)
conftest.c:4: error: (Each undeclared identifier is reported only once
conftest.c:4: error: for each function it appears in.)
checked program was:
/* begin */
 1: #include "ruby.h"
 2:
 3: /*top*/
 4: int t() { void ((*volatile p)()); p = (void ((*)()))getspent; return 0; }
 5: int main(int argc, char **argv)
 6: {
 7:   if (argc > 1000000) {
 8:     printf("%p", &t);
 9:   }
10:
11:   return 0;
12: }
/* end */
"gcc -o conftest -I/opt/chef/embedded/include/ruby-1.9.1/x86_64-linux -I/opt/chef/embedded/include/ruby-1.9.1/ruby/backward -I/opt/c
hef/embedded/include/ruby-1.9.1 -I.    -I/opt/chef/embedded/include -DRUBY19 conftest.c  -L. -L/opt/chef/embedded/lib -Wl,-R/opt/che
f/embedded/lib -L/opt/chef/embedded/lib -Wl,-R/opt/chef/embedded/lib -L. -Wl,-rpath,/opt/chef/embedded/lib -L/opt/chef/embedded/lib
-rdynamic -Wl,-export-dynamic -L/opt/chef/embedded/lib  -Wl,-R/opt/chef/embedded/lib      -Wl,-R -Wl,/opt/chef/embedded/lib -L/opt/c
hef/embedded/lib -lruby -lshadow  -lpthread -lrt -ldl -lcrypt -lm   -lc"
/usr/bin/ld: cannot find -lshadow
collect2: ld returned 1 exit status
checked program was:
/* begin */
 1: #include "ruby.h"
 2:
 3: /*top*/
 4: int t() { getspent(); return 0; }
 5: int main(int argc, char **argv)
 6: {
 7:   if (argc > 1000000) {
 8:     printf("%p", &t);
 9:   }
10:
11:   return 0;
12: }
/* end */
--------------------
have_func: checking for getspent()... -------------------- yes
"gcc -o conftest -I/opt/chef/embedded/include/ruby-1.9.1/x86_64-linux -I/opt/chef/embedded/include/ruby-1.9.1/ruby/backward -I/opt/c
hef/embedded/include/ruby-1.9.1 -I.    -I/opt/chef/embedded/include -DRUBY19 conftest.c  -L. -L/opt/chef/embedded/lib -Wl,-R/opt/che
f/embedded/lib -L/opt/chef/embedded/lib -Wl,-R/opt/chef/embedded/lib      -Wl,-R -Wl,/opt/chef/embedded/lib -L/opt/chef/embedded/lib
 -lruby  -lpthread -lrt -ldl -lcrypt -lm   -lc"
conftest.c: In function 't':
conftest.c:4: error: 'getspent' undeclared (first use in this function)
conftest.c:4: error: (Each undeclared identifier is reported only once
conftest.c:4: error: for each function it appears in.)
checked program was:
/* begin */
 1: #include "ruby.h"
 2:
 3: /*top*/
 4: int t() { void ((*volatile p)()); p = (void ((*)()))getspent; return 0; }
 5: int main(int argc, char **argv)
 6: {
 7:   if (argc > 1000000) {
 8:     printf("%p", &t);
 9:   }
10:
11:   return 0;
12: }
/* end */
"gcc -o conftest -I/opt/chef/embedded/include/ruby-1.9.1/x86_64-linux -I/opt/chef/embedded/include/ruby-1.9.1/ruby/backward -I/opt/c
hef/embedded/include/ruby-1.9.1 -I.    -I/opt/chef/embedded/include -DRUBY19 conftest.c  -L. -L/opt/chef/embedded/lib -Wl,-R/opt/che
f/embedded/lib -L/opt/chef/embedded/lib -Wl,-R/opt/chef/embedded/lib      -Wl,-R -Wl,/opt/chef/embedded/lib -L/opt/chef/embedded/lib
 -lruby  -lpthread -lrt -ldl -lcrypt -lm   -lc"
checked program was:
/* begin */
 1: #include "ruby.h"
 2:
 3: /*top*/
 4: int t() { getspent(); return 0; }
 5: int main(int argc, char **argv)
 6: {
 7:   if (argc > 1000000) {
 8:     printf("%p", &t);
 9:   }
10:
11:   return 0;
12: }
/* end */
--------------------
have_func: checking for fgetspent()... -------------------- yes
"gcc -o conftest -I/opt/chef/embedded/include/ruby-1.9.1/x86_64-linux -I/opt/chef/embedded/include/ruby-1.9.1/ruby/backward -I/opt/c
hef/embedded/include/ruby-1.9.1 -I.    -I/opt/chef/embedded/include -DRUBY19 conftest.c  -L. -L/opt/chef/embedded/lib -Wl,-R/opt/che
f/embedded/lib -L/opt/chef/embedded/lib -Wl,-R/opt/chef/embedded/lib      -Wl,-R -Wl,/opt/chef/embedded/lib -L/opt/chef/embedded/lib
 -lruby  -lpthread -lrt -ldl -lcrypt -lm   -lc"
conftest.c: In function 't':
conftest.c:4: error: 'fgetspent' undeclared (first use in this function)
conftest.c:4: error: (Each undeclared identifier is reported only once
conftest.c:4: error: for each function it appears in.)
checked program was:
/* begin */
 1: #include "ruby.h"
 2:
 3: /*top*/
 4: int t() { void ((*volatile p)()); p = (void ((*)()))fgetspent; return 0; }
 5: int main(int argc, char **argv)
 6: {
 7:   if (argc > 1000000) {
 8:     printf("%p", &t);
 9:   }
10:
11:   return 0;
12: }
/* end */
"gcc -o conftest -I/opt/chef/embedded/include/ruby-1.9.1/x86_64-linux -I/opt/chef/embedded/include/ruby-1.9.1/ruby/backward -I/opt/c
hef/embedded/include/ruby-1.9.1 -I.    -I/opt/chef/embedded/include -DRUBY19 conftest.c  -L. -L/opt/chef/embedded/lib -Wl,-R/opt/che
f/embedded/lib -L/opt/chef/embedded/lib -Wl,-R/opt/chef/embedded/lib      -Wl,-R -Wl,/opt/chef/embedded/lib -L/opt/chef/embedded/lib
 -lruby  -lpthread -lrt -ldl -lcrypt -lm   -lc"
checked program was:
/* begin */
 1: #include "ruby.h"
 2:
 3: /*top*/
 4: int t() { fgetspent(); return 0; }
 5: int main(int argc, char **argv)
 6: {
 7:   if (argc > 1000000) {
 8:     printf("%p", &t);
 9:   }
10:
11:   return 0;
12: }
/* end */
--------------------
have_func: checking for setspent()... -------------------- yes
"gcc -o conftest -I/opt/chef/embedded/include/ruby-1.9.1/x86_64-linux -I/opt/chef/embedded/include/ruby-1.9.1/ruby/backward -I/opt/c
hef/embedded/include/ruby-1.9.1 -I.    -I/opt/chef/embedded/include -DRUBY19 conftest.c  -L. -L/opt/chef/embedded/lib -Wl,-R/opt/che
f/embedded/lib -L/opt/chef/embedded/lib -Wl,-R/opt/chef/embedded/lib      -Wl,-R -Wl,/opt/chef/embedded/lib -L/opt/chef/embedded/lib
 -lruby  -lpthread -lrt -ldl -lcrypt -lm   -lc"
conftest.c: In function 't':
conftest.c:4: error: 'setspent' undeclared (first use in this function)
conftest.c:4: error: (Each undeclared identifier is reported only once
conftest.c:4: error: for each function it appears in.)
checked program was:
/* begin */
 1: #include "ruby.h"
 2:
 3: /*top*/
 4: int t() { void ((*volatile p)()); p = (void ((*)()))setspent; return 0; }
 5: int main(int argc, char **argv)
 6: {
 7:   if (argc > 1000000) {
 8:     printf("%p", &t);
 9:   }
10:
11:   return 0;
12: }
/* end */
"gcc -o conftest -I/opt/chef/embedded/include/ruby-1.9.1/x86_64-linux -I/opt/chef/embedded/include/ruby-1.9.1/ruby/backward -I/opt/c
hef/embedded/include/ruby-1.9.1 -I.    -I/opt/chef/embedded/include -DRUBY19 conftest.c  -L. -L/opt/chef/embedded/lib -Wl,-R/opt/che
f/embedded/lib -L/opt/chef/embedded/lib -Wl,-R/opt/chef/embedded/lib      -Wl,-R -Wl,/opt/chef/embedded/lib -L/opt/chef/embedded/lib
 -lruby  -lpthread -lrt -ldl -lcrypt -lm   -lc"
checked program was:
/* begin */
 1: #include "ruby.h"
 2:
 3: /*top*/
 4: int t() { setspent(); return 0; }
 5: int main(int argc, char **argv)
 6: {
 7:   if (argc > 1000000) {
 8:     printf("%p", &t);
 9:   }
10:
11:   return 0;
12: }
/* end */
--------------------
have_func: checking for endspent()... -------------------- yes
"gcc -o conftest -I/opt/chef/embedded/include/ruby-1.9.1/x86_64-linux -I/opt/chef/embedded/include/ruby-1.9.1/ruby/backward -I/opt/c
hef/embedded/include/ruby-1.9.1 -I.    -I/opt/chef/embedded/include -DRUBY19 conftest.c  -L. -L/opt/chef/embedded/lib -Wl,-R/opt/che
f/embedded/lib -L/opt/chef/embedded/lib -Wl,-R/opt/chef/embedded/lib      -Wl,-R -Wl,/opt/chef/embedded/lib -L/opt/chef/embedded/lib
 -lruby  -lpthread -lrt -ldl -lcrypt -lm   -lc"
conftest.c: In function 't':
conftest.c:4: error: 'endspent' undeclared (first use in this function)
conftest.c:4: error: (Each undeclared identifier is reported only once
conftest.c:4: error: for each function it appears in.)
checked program was:
/* begin */
 1: #include "ruby.h"
 2:
 3: /*top*/
 4: int t() { void ((*volatile p)()); p = (void ((*)()))endspent; return 0; }
 5: int main(int argc, char **argv)
 6: {
 7:   if (argc > 1000000) {
 8:     printf("%p", &t);
 9:   }
10:
11:   return 0;
12: }
/* end */
"gcc -o conftest -I/opt/chef/embedded/include/ruby-1.9.1/x86_64-linux -I/opt/chef/embedded/include/ruby-1.9.1/ruby/backward -I/opt/c
hef/embedded/include/ruby-1.9.1 -I.    -I/opt/chef/embedded/include -DRUBY19 conftest.c  -L. -L/opt/chef/embedded/lib -Wl,-R/opt/che
f/embedded/lib -L/opt/chef/embedded/lib -Wl,-R/opt/chef/embedded/lib      -Wl,-R -Wl,/opt/chef/embedded/lib -L/opt/chef/embedded/lib
 -lruby  -lpthread -lrt -ldl -lcrypt -lm   -lc"
checked program was:
/* begin */
 1: #include "ruby.h"
 2:
 3: /*top*/
 4: int t() { endspent(); return 0; }
 5: int main(int argc, char **argv)
 6: {
 7:   if (argc > 1000000) {
 8:     printf("%p", &t);
 9:   }
10:
11:   return 0;
12: }
/* end */
--------------------
have_func: checking for lckpwdf()... -------------------- yes
"gcc -o conftest -I/opt/chef/embedded/include/ruby-1.9.1/x86_64-linux -I/opt/chef/embedded/include/ruby-1.9.1/ruby/backward -I/opt/c
hef/embedded/include/ruby-1.9.1 -I.    -I/opt/chef/embedded/include -DRUBY19 conftest.c  -L. -L/opt/chef/embedded/lib -Wl,-R/opt/che
f/embedded/lib -L/opt/chef/embedded/lib -Wl,-R/opt/chef/embedded/lib      -Wl,-R -Wl,/opt/chef/embedded/lib -L/opt/chef/embedded/lib
 -lruby  -lpthread -lrt -ldl -lcrypt -lm   -lc"
conftest.c: In function 't':
conftest.c:4: error: 'lckpwdf' undeclared (first use in this function)
conftest.c:4: error: (Each undeclared identifier is reported only once
conftest.c:4: error: for each function it appears in.)
checked program was:
/* begin */
 1: #include "ruby.h"
 2:
 3: /*top*/
 4: int t() { void ((*volatile p)()); p = (void ((*)()))lckpwdf; return 0; }
 5: int main(int argc, char **argv)
 6: {
 7:   if (argc > 1000000) {
 8:     printf("%p", &t);
 9:   }
10:
11:   return 0;
12: }
/* end */
"gcc -o conftest -I/opt/chef/embedded/include/ruby-1.9.1/x86_64-linux -I/opt/chef/embedded/include/ruby-1.9.1/ruby/backward -I/opt/c
hef/embedded/include/ruby-1.9.1 -I.    -I/opt/chef/embedded/include -DRUBY19 conftest.c  -L. -L/opt/chef/embedded/lib -Wl,-R/opt/che
f/embedded/lib -L/opt/chef/embedded/lib -Wl,-R/opt/chef/embedded/lib      -Wl,-R -Wl,/opt/chef/embedded/lib -L/opt/chef/embedded/lib
 -lruby  -lpthread -lrt -ldl -lcrypt -lm   -lc"
checked program was:
/* begin */
 1: #include "ruby.h"
 2:
 3: /*top*/
 4: int t() { lckpwdf(); return 0; }
 5: int main(int argc, char **argv)
 6: {
 7:   if (argc > 1000000) {
 8:     printf("%p", &t);
 9:   }
10:
11:   return 0;
12: }
/* end */
--------------------
have_func: checking for ulckpwdf()... -------------------- yes
"gcc -o conftest -I/opt/chef/embedded/include/ruby-1.9.1/x86_64-linux -I/opt/chef/embedded/include/ruby-1.9.1/ruby/backward -I/opt/c
hef/embedded/include/ruby-1.9.1 -I.    -I/opt/chef/embedded/include -DRUBY19 conftest.c  -L. -L/opt/chef/embedded/lib -Wl,-R/opt/che
f/embedded/lib -L/opt/chef/embedded/lib -Wl,-R/opt/chef/embedded/lib      -Wl,-R -Wl,/opt/chef/embedded/lib -L/opt/chef/embedded/lib
 -lruby  -lpthread -lrt -ldl -lcrypt -lm   -lc"
conftest.c: In function 't':
conftest.c:4: error: 'ulckpwdf' undeclared (first use in this function)
conftest.c:4: error: (Each undeclared identifier is reported only once
conftest.c:4: error: for each function it appears in.)
checked program was:
/* begin */
 1: #include "ruby.h"
 2:
 3: /*top*/
 4: int t() { void ((*volatile p)()); p = (void ((*)()))ulckpwdf; return 0; }
 5: int main(int argc, char **argv)
 6: {
 7:   if (argc > 1000000) {
 8:     printf("%p", &t);
 9:   }
10:
11:   return 0;
12: }
/* end */
"gcc -o conftest -I/opt/chef/embedded/include/ruby-1.9.1/x86_64-linux -I/opt/chef/embedded/include/ruby-1.9.1/ruby/backward -I/opt/c
hef/embedded/include/ruby-1.9.1 -I.    -I/opt/chef/embedded/include -DRUBY19 conftest.c  -L. -L/opt/chef/embedded/lib -Wl,-R/opt/che
f/embedded/lib -L/opt/chef/embedded/lib -Wl,-R/opt/chef/embedded/lib      -Wl,-R -Wl,/opt/chef/embedded/lib -L/opt/chef/embedded/lib
 -lruby  -lpthread -lrt -ldl -lcrypt -lm   -lc"
checked program was:
/* begin */
 1: #include "ruby.h"
 2:
 3: /*top*/
 4: int t() { ulckpwdf(); return 0; }
 5: int main(int argc, char **argv)
 6: {
 7:   if (argc > 1000000) {
 8:     printf("%p", &t);
 9:   }
10:
11:   return 0;
12: }
/* end */
--------------------
have_func: checking for sgetspent()... -------------------- yes
"gcc -o conftest -I/opt/chef/embedded/include/ruby-1.9.1/x86_64-linux -I/opt/chef/embedded/include/ruby-1.9.1/ruby/backward -I/opt/c
hef/embedded/include/ruby-1.9.1 -I.    -I/opt/chef/embedded/include -DRUBY19 conftest.c  -L. -L/opt/chef/embedded/lib -Wl,-R/opt/che
f/embedded/lib -L/opt/chef/embedded/lib -Wl,-R/opt/chef/embedded/lib      -Wl,-R -Wl,/opt/chef/embedded/lib -L/opt/chef/embedded/lib
 -lruby  -lpthread -lrt -ldl -lcrypt -lm   -lc"
conftest.c: In function 't':
conftest.c:4: error: 'sgetspent' undeclared (first use in this function)
conftest.c:4: error: (Each undeclared identifier is reported only once
conftest.c:4: error: for each function it appears in.)
checked program was:
/* begin */
 1: #include "ruby.h"
 2:
 3: /*top*/
 4: int t() { void ((*volatile p)()); p = (void ((*)()))sgetspent; return 0; }
 5: int main(int argc, char **argv)
 6: {
 7:   if (argc > 1000000) {
 8:     printf("%p", &t);
 9:   }
10:
11:   return 0;
12: }
/* end */
"gcc -o conftest -I/opt/chef/embedded/include/ruby-1.9.1/x86_64-linux -I/opt/chef/embedded/include/ruby-1.9.1/ruby/backward -I/opt/c
hef/embedded/include/ruby-1.9.1 -I.    -I/opt/chef/embedded/include -DRUBY19 conftest.c  -L. -L/opt/chef/embedded/lib -Wl,-R/opt/che
f/embedded/lib -L/opt/chef/embedded/lib -Wl,-R/opt/chef/embedded/lib      -Wl,-R -Wl,/opt/chef/embedded/lib -L/opt/chef/embedded/lib
 -lruby  -lpthread -lrt -ldl -lcrypt -lm   -lc"
checked program was:
/* begin */
 1: #include "ruby.h"
 2:
 3: /*top*/
 4: int t() { sgetspent(); return 0; }
 5: int main(int argc, char **argv)
 6: {
 7:   if (argc > 1000000) {
 8:     printf("%p", &t);
 9:   }
10:
11:   return 0;
12: }
/* end */
--------------------
have_header: checking for ruby/io.h... -------------------- yes
"gcc -E -I/opt/chef/embedded/include/ruby-1.9.1/x86_64-linux -I/opt/chef/embedded/include/ruby-1.9.1/ruby/backward -I/opt/chef/embed
ded/include/ruby-1.9.1 -I.    -I/opt/chef/embedded/include -DRUBY19  conftest.c -o conftest.i"
checked program was:
/* begin */
1: #include "ruby.h"
2:
3: #include <ruby/io.h>
/* end */
--------------------
 
File 2:
***********************************************************************************************************************************************************************************************
***********************************************************************************************************************************************************************************************
***********************************************************************************************************************************************************************************************
[vagrant@dbfitvm ~]$ cat /opt/chef/embedded/lib/ruby/gems/1.9.1/gems/pg-0.17.1/ext/mkmf.log
"gcc -o conftest -I/opt/chef/embedded/include/ruby-1.9.1/x86_64-linux -I/opt/chef/embedded/include/ruby-1.9.1/ruby/backward -I/opt/c
hef/embedded/include/ruby-1.9.1 -I. -I/usr/pgsql-9.3/include    -I/opt/chef/embedded/include -I/opt/chef/embedded/include -O3 -g -pi
pe -fPIC conftest.c  -L. -L/opt/chef/embedded/lib -L/usr/pgsql-9.3/lib -L/opt/chef/embedded/lib -L.  -L/opt/chef/embedded/lib -rdyna
mic  -L/opt/chef/embedded/lib          -L/opt/chef/embedded/lib -lruby  -lpthread -lrt -ldl -lcrypt -lm   -lc"
checked program was:
/* begin */
1: #include "ruby.h"
2:
3: int main(int argc, char **argv)
4: {
5:   return 0;
6: }
/* end */

Yavor Nikolov

unread,
May 1, 2014, 6:08:26 AM5/1/14
to db...@googlegroups.com
Also - try to update your vagrant plugins (vagrant plugin update).

---
BTW, for posting log outputs you may consider gist: https://gist.github.com/


Yavor


--

MatMan

unread,
May 1, 2014, 6:20:19 AM5/1/14
to db...@googlegroups.com
Thanks, they should be bang up to date because I've been purging my .vagrant.d directory and getting the plugins on each attempt.
 
I'll let you know how the build with 4.3.10 goes.

MatMan

unread,
May 1, 2014, 11:38:06 AM5/1/14
to db...@googlegroups.com
Yavor,
 
Using the new windows detection / NFS changes you made the Windows dir now becomes available automatically (I don't need to create the symlink) although the upgrade to the 4.3.10 guest additions does still report an error:
An error occurred during installation of VirtualBox Guest Additions 4.3.10. Some functionality may not work as intended.
 With VB 4.3.10 the provisioning fails with: -
 
c:\dbfit\dbfit\test_vm>vagrant provision
==> default: Installing Chef cookbooks with Librarian-Chef...
==> default: Configuring proxy for Chef provisioners...
==> default: Configuring proxy environment variables...
==> default: Configuring proxy for Yum...

==> default: Installing Chef 11.12.4 Omnibus package...
==> default: Downloading Chef 11.12.4 for el...
==> default:   to file /tmp/install.sh.3385/metadata.txt
==> default: trying wget...

==> default: url        https://opscode-omnibus-packages.s3.amazonaws.com/el/6/x86_64/chef-11.12.4-1.el6.x86_64.rpm
==> default: md5        959acd5df77c25f4f69d1f786f3c7360
==> default: sha256     d4eacc6b16c448a628367e7201922a4c58997f68808c5f698676e8a5eaf169b5
==> default: downloaded metadata file looks valid...
==> default:   to file /tmp/install.sh.3385/chef-11.12.4-1.el6.x86_64.rpm
==> default: trying wget...

==> default: Comparing checksum with sha256sum...
==> default: Installing Chef 11.12.4
==> default: installing with rpm...
==> default: warning:
==> default: /tmp/install.sh.3385/chef-11.12.4-1.el6.x86_64.rpm: Header V4 DSA/SHA1 Signature, key ID 83ef826a: NOKEY
==> default: Preparing...
==> default: ##################################################
==> default: chef
==> default: #
==> default: Thank you for installing Chef!
==> default: Running provisioner: chef_solo...

Generating chef JSON and uploading...
Running chef-solo...
[2014-05-01T15:32:18+00:00] INFO: Forking chef instance to converge...
[2014-05-01T15:32:18+00:00] WARN:

* * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * *
SSL validation of HTTPS requests is disabled. HTTPS connections are still
encrypted, but chef is not able to detect forged replies or man in the middle
attacks.
To fix this issue add an entry like this to your configuration file:
```
  # Verify all HTTPS connections (recommended)
  ssl_verify_mode :verify_peer
  # OR, Verify only connections to chef-server
  verify_api_cert true
```
To check your SSL configuration, or troubleshoot errors, you can use the
`knife ssl check` command like so:
```
  knife ssl check -c /tmp/vagrant-chef-1/solo.rb
```
* * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * * *
[2014-05-01T15:32:18+00:00] INFO: *** Chef 11.12.4 ***
[2014-05-01T15:32:18+00:00] INFO: Chef-client pid: 3692
[2014-05-01T15:32:21+00:00] INFO: Setting the run_list to ["recipe[dbfit_test]"] from CLI options
[2014-05-01T15:32:21+00:00] INFO: Run List is [recipe[dbfit_test]]
[2014-05-01T15:32:21+00:00] INFO: Run List expands to [dbfit_test]
[2014-05-01T15:32:21+00:00] INFO: Starting Chef Run for dbfitvm
[2014-05-01T15:32:21+00:00] INFO: Running start handlers
[2014-05-01T15:32:21+00:00] INFO: Start handlers complete.
[2014-05-01T15:32:22+00:00] INFO: WindowsPackage light-weight resource already initialized -- overriding!
[2014-05-01T15:32:22+00:00] WARN: Cloning resource attributes for mysql_database_user[dftest] from prior resource (CHEF-3694)
[2014-05-01T15:32:22+00:00] WARN: Previous mysql_database_user[dftest]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes

/mysql.rb:17:in `block in from_file'
[2014-05-01T15:32:22+00:00] WARN: Current  mysql_database_user[dftest]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes

/mysql.rb:24:in `block (2 levels) in from_file'
[2014-05-01T15:32:22+00:00] WARN: Cloning resource attributes for mysql_database_user[dftest] from prior resource (CHEF-3694)
[2014-05-01T15:32:22+00:00] WARN: Previous mysql_database_user[dftest]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes

/mysql.rb:24:in `block (2 levels) in from_file'
[2014-05-01T15:32:22+00:00] WARN: Current  mysql_database_user[dftest]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes

/mysql.rb:24:in `block (2 levels) in from_file'
[2014-05-01T15:32:22+00:00] WARN: Cloning resource attributes for mysql_database_user[dbfit_user] from prior resource (CHEF-3694)
[2014-05-01T15:32:22+00:00] WARN: Previous mysql_database_user[dbfit_user]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/rec

ipes/mysql.rb:17:in `block in from_file'
[2014-05-01T15:32:22+00:00] WARN: Current  mysql_database_user[dbfit_user]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/rec

ipes/mysql.rb:24:in `block (2 levels) in from_file'
[2014-05-01T15:32:22+00:00] WARN: Cloning resource attributes for mysql_database_user[dbfit_user] from prior resource (CHEF-3694)
[2014-05-01T15:32:22+00:00] WARN: Previous mysql_database_user[dbfit_user]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/rec

ipes/mysql.rb:24:in `block (2 levels) in from_file'
[2014-05-01T15:32:22+00:00] WARN: Current  mysql_database_user[dbfit_user]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/rec

ipes/mysql.rb:24:in `block (2 levels) in from_file'
[2014-05-01T15:32:22+00:00] WARN: Cloning resource attributes for mysql_database_user[dbfit_user] from prior resource (CHEF-3694)
[2014-05-01T15:32:22+00:00] WARN: Previous mysql_database_user[dbfit_user]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/rec

ipes/mysql.rb:24:in `block (2 levels) in from_file'
[2014-05-01T15:32:22+00:00] WARN: Current  mysql_database_user[dbfit_user]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/rec

ipes/mysql.rb:34:in `block in from_file'
[2014-05-01T15:32:22+00:00] WARN: Cloning resource attributes for mysql_database_user[dbfit_user] from prior resource (CHEF-3694)
[2014-05-01T15:32:22+00:00] WARN: Previous mysql_database_user[dbfit_user]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/rec

ipes/mysql.rb:34:in `block in from_file'
[2014-05-01T15:32:22+00:00] WARN: Current  mysql_database_user[dbfit_user]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/rec

ipes/mysql.rb:34:in `block in from_file'
[2014-05-01T15:32:22+00:00] WARN: Cloning resource attributes for mysql_database[dbfit] from prior resource (CHEF-3694)
[2014-05-01T15:32:22+00:00] WARN: Previous mysql_database[dbfit]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/mysql
.rb:11:in `from_file'
[2014-05-01T15:32:22+00:00] WARN: Current  mysql_database[dbfit]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/mysql
.rb:43:in `from_file'
[2014-05-01T15:32:23+00:00] INFO: remote_file[/var/chef/cache/pgdg-centos93-9.3-1.noarch.rpm] created file /var/chef/cache/pgdg-cent
os93-9.3-1.noarch.rpm
[2014-05-01T15:32:23+00:00] INFO: remote_file[/var/chef/cache/pgdg-centos93-9.3-1.noarch.rpm] updated file contents /var/chef/cache/
pgdg-centos93-9.3-1.noarch.rpm
[2014-05-01T15:32:23+00:00] INFO: remote_file[/var/chef/cache/pgdg-centos93-9.3-1.noarch.rpm] mode changed to 644
[2014-05-01T15:32:27+00:00] INFO: package[postgresql93-devel] installing postgresql93-devel-9.3.4-1PGDG.rhel6 from pgdg93 repository
[2014-05-01T15:32:45+00:00] WARN: Cloning resource attributes for postgresql_database_user[dbfit] from prior resource (CHEF-3694)
[2014-05-01T15:32:45+00:00] WARN: Previous postgresql_database_user[dbfit]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/rec
ipes/postgres.rb:17:in `from_file'
[2014-05-01T15:32:45+00:00] WARN: Current  postgresql_database_user[dbfit]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/rec
ipes/postgres.rb:23:in `from_file'
[2014-05-01T15:32:45+00:00] WARN: Cloning resource attributes for postgresql_database[dbfit] from prior resource (CHEF-3694)
[2014-05-01T15:32:45+00:00] WARN: Previous postgresql_database[dbfit]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/
postgres.rb:12:in `from_file'
[2014-05-01T15:32:45+00:00] WARN: Current  postgresql_database[dbfit]: /tmp/vagrant-chef-1/chef-solo-1/cookbooks/dbfit_test/recipes/
postgres.rb:31:in `from_file'
[2014-05-01T15:32:45+00:00] INFO: template[/etc/profile.d/dbfit_env.sh] created file /etc/profile.d/dbfit_env.sh
[2014-05-01T15:32:45+00:00] INFO: template[/etc/profile.d/dbfit_env.sh] updated file contents /etc/profile.d/dbfit_env.sh
[2014-05-01T15:32:45+00:00] INFO: template[/etc/profile.d/dbfit_env.sh] mode changed to 755
[2014-05-01T15:32:45+00:00] INFO: ruby_block[set-env-java-home] called
[2014-05-01T15:32:45+00:00] INFO: file[/etc/profile.d/jdk.sh] created file /etc/profile.d/jdk.sh
[2014-05-01T15:32:45+00:00] INFO: file[/etc/profile.d/jdk.sh] updated file contents /etc/profile.d/jdk.sh
[2014-05-01T15:32:45+00:00] INFO: file[/etc/profile.d/jdk.sh] mode changed to 755
[2014-05-01T15:32:46+00:00] INFO: Adding jdk to /usr/lib/jvm/jdk1.7.0_51
[2014-05-01T15:34:16+00:00] INFO: package[autoconf] installing autoconf-2.63-5.1.el6 from base repository
================================================================================
Error executing action `install` on resource 'package[autoconf]'
================================================================================
Chef::Exceptions::Exec
----------------------
 returned 1, expected 0
Resource Declaration:
---------------------
# In /tmp/vagrant-chef-1/chef-solo-1/cookbooks/build-essential/recipes/_rhel.rb
 21:   package 'autoconf'
 22:   package 'bison'
Compiled Resource:
------------------
# Declared in /tmp/vagrant-chef-1/chef-solo-1/cookbooks/build-essential/recipes/_rhel.rb:21:in `block in from_file'
package("autoconf") do

  action :install
  retries 0
  retry_delay 2
  guard_interpreter :default
  package_name "autoconf"
  version "2.63-5.1.el6"
  cookbook_name :"build-essential"
  recipe_name "_rhel"
end
[2014-05-01T15:35:08+00:00] INFO: Running queued delayed notifications before re-raising exception
[2014-05-01T15:35:08+00:00] ERROR: Running exception handlers
[2014-05-01T15:35:08+00:00] ERROR: Exception handlers complete
[2014-05-01T15:35:08+00:00] FATAL: Stacktrace dumped to /var/chef/cache/chef-stacktrace.out
[2014-05-01T15:35:08+00:00] ERROR: package[autoconf] (build-essential::_rhel line 21) had an error: Chef::Exceptions::Exec:  returne
d 1, expected 0
[2014-05-01T15:35:08+00:00] FATAL: Chef::Exceptions::ChildConvergeError: Chef run process exited unsuccessfully (exit code 1)

Yavor Nikolov

unread,
May 1, 2014, 11:53:48 AM5/1/14
to db...@googlegroups.com
> An error occurred during installation of VirtualBox Guest Additions 4.3.10. Some functionality may not work as intended.
This is just a warning. Should be harmless.

The other one is true error though. It says something about /var/chef/cache/chef-
stacktrace.out - is there anything interested in that trace file?


I wonder what it could be failing at your site... I re-created my VM several times with no problem.
 - Is that still behind the proxy or fails with direct connection too?
 - Have you changed your git settings not to do end of line conversion. (Not only for the oracle setup script but for all the files).

Yavor


--

Yavor Nikolov

unread,
May 1, 2014, 12:46:07 PM5/1/14
to db...@googlegroups.com
May be useful to set chef output to DEBUG level. Here is an example how to do that: http://mlafeldt.github.io/blog/2013/10/debugging-chef-runs-with-chef-log/

Yavor Nikolov

unread,
May 1, 2014, 2:11:38 PM5/1/14
to db...@googlegroups.com
Hi Mark,
Here is the output of my `vagrant up`: https://gist.github.com/javornikolov/aa87dea7f3f7b80a0728
If you spot any difference with yours - may be helpful to identify what's going wrong in your environment.

Yavor

MatMan

unread,
May 1, 2014, 4:33:57 PM5/1/14
to db...@googlegroups.com
Thanks. One, possibly minor, difference - may be you're using an old base box image - my base has 4.3.8 guest additions on it to start with. I'll see if I can spot other stuff too.

Mark

Yavor Nikolov

unread,
May 1, 2014, 5:31:18 PM5/1/14
to db...@googlegroups.com
That came through my mind too and I already tested with freshly downloaded box: worked fine again. I updated the uploaded log: https://gist.github.com/javornikolov/aa87dea7f3f7b80a0728

Yavor


MatMan

unread,
May 2, 2014, 5:12:32 AM5/2/14
to db...@googlegroups.com
The Chef debugging output has been very useful.
 
There were some futher proxy issues that hadn't been solved by setting the environment variables in the VM (which I've ended up using the vagrant-proxyconf plugin to do) and add this to the Vagrantfile: -
 
  config.proxy.http = "http://my_ad_domain%5cmy_ad_user:my_ad_p...@myproxyserver.myorg.co.uk:80"
  config.proxy.https = "http://my_ad_domain%5cmy_ad_user:my_ad_p...@myproxyserver.myorg.co.uk:80"
  config.proxy.no_proxy = "localhost,127.0.0.1"
 
and so I also added Chef proxy setting too: -
 
 chef.http_proxy = "http://myproxyserver.myorg.co.uk:80"
 chef.http_proxy_user = "my_ad_domain\\my_ad_user"
 chef.http_proxy_pass = "my_ad_password"
 
 chef.https_proxy = "http://myproxyserver.myorg.co.uk:80"
 chef.https_proxy_user = "my_ad_domain\\my_ad_user"
 chef.https_proxy_pass = "my_ad_password"
 
It would be good to get support for these settings into the dbfit VM Vagrantfile and set them, conditionally, from environment variables if they're set.
 
The problem I can now see is in downloading Linux packages. E.g.
 
Error Downloading Packages:
  autoconf-2.63-5.1.el6.noarch: failure: Packages/autoconf-2.63-5.1.el6.noarch.rpm from base: [Errno 256] No more mirrors to try.
 
I've seen this with a bison package too and it seems it could be a different network issue on different attempts. I'll investigate more. I might be completely snookered at some point because of package sites being blocked my the company.
 
Is there a way of using local RPM, pacakges, etc, if I could get them downloaded?
 
Or I suppose provide a completed prebuilt VB VM image for dbfit developers?
 
Mark

Yavor Nikolov

unread,
May 2, 2014, 5:26:05 AM5/2/14
to db...@googlegroups.com
Hi Mark,


> Is there a way of using local RPM, pacakges, etc, if I could get them downloaded?
For yum repositories (RPM), yes: http://wiki.centos.org/HowTos/CreateLocalMirror
A few other things (chef, git) are not installed as RPM packages.


> Or I suppose provide a completed prebuilt VB VM image for dbfit developers?
You can do this locally - make your own box and host it locally - vagrant takes it from following settings:
config.vm.box
config.vm.box_url

Yavor



--

MatMan

unread,
May 3, 2014, 7:31:21 AM5/3/14
to db...@googlegroups.com
Ok, home my home network (no infernal corporate proxy, firewall, websense, etc) the only remaining issue appears to be deleting the Oracle installation response and SQL script: -

Disconnected from Oracle Database 11g Express Edition Release 11.2.0.2.0 - 64bit Production

STDERR: ls: cannot access /var/dbfit/Disk1/oracle-xe-*.rpm: No such file or directory
rm: cannot remove `/var/dbfit/Disk1/response/xe.rsp': Operation not permitted
rm: cannot remove `/var/dbfit/Disk1/upgrade/gen_inst.sql': Operation not permitted
---- End output of /var/dbfit/dbfit-java/oracle/src/test/resources/install_oracle.sh ----
Ran /var/dbfit/dbfit-java/oracle/src/test/resources/install_oracle.sh returned 1
[2014-05-03T11:20:41+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.

The unzipped directory has the read only attribute set when viewed from the host (Windows Explorer) and the files are 555 from the guest. So I think the Windows synced folder stuff isn't quite working for me in Win 7.

I think I'll try to avoid creating a local mirror of all the packages. It looks like I'll need a lot of disk space!

I might look into an enhancement to the Vagrantfile for the proxies and send you a pull request along with the Teradata stuff.

Thanks for the help on all the other stuff!

Cheers,

Mark

On Friday, 2 May 2014 10:26:05 UTC+1, Yavor Nikolov wrote:
Hi Mark,

> Is there a way of using local RPM, pacakges, etc, if I could get them downloaded?
For yum repositories (RPM), yes: http://wiki.centos.org/HowTos/CreateLocalMirror
A few other things (chef, git) are not installed as RPM packages.

> Or I suppose provide a completed prebuilt VB VM image for dbfit developers?
You can do this locally - make your own box and host it locally - vagrant takes it from following settings:
config.vm.box
config.vm.box_url

Yavor

On Fri, May 2, 2014 at 12:12 PM, MatMan <mark_...@hotmail.com> wrote:
The Chef debugging output has been very useful.
 
There were some futher proxy issues that hadn't been solved by setting the environment variables in the VM (which I've ended up using the vagrant-proxyconf plugin to do) and add this to the Vagrantfile: -
 
 
and so I also added Chef proxy setting too: -
 
 chef.http_proxy = "http://myproxyserver.myorg.co.uk:80"
 chef.http_proxy_user = "my_ad_domain\\my_ad_user"
 chef.http_proxy_pass = "my_ad_password"
 
 chef.https_proxy = "http://myproxyserver.myorg.co.uk:80"
 chef.https_proxy_user = "my_ad_domain\\my_ad_user"
 chef.https_proxy_pass = "my_ad_password"
 
It would be good to get support for these settings into the dbfit VM Vagrantfile and set them, conditionally, from environment variables if they're set.
 
The problem I can now see is in downloading Linux packages. E.g.
 
Error Downloading Packages:
  autoconf-2.63-5.1.el6.noarch: failure: Packages/autoconf-2.63-5.1.el6.noarch.rpm from base: [Errno 256] No more mirrors to try.
 
I've seen this with a bison package too and it seems it could be a different network issue on different attempts. I'll investigate more. I might be completely snookered at some point because of package sites being blocked my the company.
 
Is there a way of using local RPM, pacakges, etc, if I could get them downloaded?
 
Or I suppose provide a completed prebuilt VB VM image for dbfit developers?
 
Mark

MatMan

unread,
May 3, 2014, 7:39:01 AM5/3/14
to db...@googlegroups.com
...also...the only file I've found that does need LF newlines is the Oracle installation shell script so adding a pattern to the .gitattributes would be good too...

Mark

Yavor Nikolov

unread,
May 3, 2014, 8:58:41 AM5/3/14
to db...@googlegroups.com
also...the only file I've found that does need LF newlines is the Oracle installation shell script so adding a pattern to the .gitattributes would be good too...

Actually LF is the default end of line in dbfit. Normally - there should be no CR+LF sources in the dbfit source repository.
The issue in your case is that your git is configured to modify the line endings on checkout (perhaps autocrlf = auto). Maybe on Windows it's best to have for git autocrlf = input.


The unzipped directory has the read only attribute set when viewed from the host
 
I'm not sure but maybe this can be tweaked by some permissions inheritance settings in Windows. Anyway - deleting Oracle setup files is not something which would abort the setup. So I think this error message can be ignored.

Yavor

MatMan

unread,
May 3, 2014, 2:21:36 PM5/3/14
to db...@googlegroups.com
Yes, autocrlf = input looks like a good option. Where is this default set? Could it be set somewhere in the sources in GitHub? If not an update to the docs would be good.

The rm is the last statement in the shell script so the exit status will get passed back to the caller (chef?). It does appear to abort the build in my environment.

Yavor Nikolov

unread,
May 3, 2014, 4:26:41 PM5/3/14
to db...@googlegroups.com
Hi Mark,

Yes, autocrlf = input looks like a good option. Where is this default set?
 
As far as I remember - Git installer on Windows asks for this option and configures it depending on your answer:
http://stackoverflow.com/questions/1475252/when-you-set-a-global-configuration-option-for-git-on-windows-where-does-it-get
You can also use git config command to set that.


Could it be set somewhere in the sources in GitHub?
Well, I'm not sure. This is something environment specific. E.g. - on my environment I prefer git to not modify the files; and I have autocrlf=false.


If not an update to the docs would be good.

The rm is the last statement in the shell script so the exit status will get passed back to the caller (chef?). It does appear to abort the build in my environment.

This is supposed to fix that: https://github.com/dbfit/dbfit/pull/281

Yavor

MatMan

unread,
May 4, 2014, 4:53:17 AM5/4/14
to db...@googlegroups.com
Yavor,

I've pulled the updates and run through. All looking good now.

Cheers!

Yavor Nikolov

unread,
May 5, 2014, 3:24:51 PM5/5/14
to db...@googlegroups.com
Hi Mark,
We also added some support for customizing vagrant settings (e.g. proxy server): https://github.com/dbfit/dbfit/pull/283/files. I hope it would be helpful in situations like yours.

Regards,
Yavor

MatMan

unread,
May 5, 2014, 4:08:54 PM5/5/14
to db...@googlegroups.com
Great stuff!

I think a note about installing the vagrant-proxyconf plugin needs to be mentioned too if not already added.

Cheers,

Mark
Reply all
Reply to author
Forward
0 new messages