packer log

2016/11/03 13:40:51 [INFO] Packer version: 0.11.1.dev (ed3c6f29effb32bec300d3e9b72472cac5d0fd06)
2016/11/03 13:40:51 Packer Target OS/Arch: linux amd64
2016/11/03 13:40:51 Built with Go Version: go1.7.3
2016/11/03 13:40:51 Detected home directory from env var: /home/jev
2016/11/03 13:40:51 Using internal plugin for null
2016/11/03 13:40:51 Using internal plugin for qemu
2016/11/03 13:40:51 Using internal plugin for virtualbox-iso
2016/11/03 13:40:51 Using internal plugin for docker
2016/11/03 13:40:51 Using internal plugin for file
2016/11/03 13:40:51 Using internal plugin for parallels-pvm
2016/11/03 13:40:51 Using internal plugin for vmware-vmx
2016/11/03 13:40:51 Using internal plugin for amazon-chroot
2016/11/03 13:40:51 Using internal plugin for parallels-iso
2016/11/03 13:40:51 Using internal plugin for azure-arm
2016/11/03 13:40:51 Using internal plugin for cloudstack
2016/11/03 13:40:51 Using internal plugin for amazon-ebs
2016/11/03 13:40:51 Using internal plugin for amazon-instance
2016/11/03 13:40:51 Using internal plugin for googlecompute
2016/11/03 13:40:51 Using internal plugin for openstack
2016/11/03 13:40:51 Using internal plugin for profitbricks
2016/11/03 13:40:51 Using internal plugin for virtualbox-ovf
2016/11/03 13:40:51 Using internal plugin for vmware-iso
2016/11/03 13:40:51 Using internal plugin for amazon-ebsvolume
2016/11/03 13:40:51 Using internal plugin for digitalocean
2016/11/03 13:40:51 Using internal plugin for ansible-local
2016/11/03 13:40:51 Using internal plugin for puppet-masterless
2016/11/03 13:40:51 Using internal plugin for shell-local
2016/11/03 13:40:51 Using internal plugin for ansible
2016/11/03 13:40:51 Using internal plugin for chef-solo
2016/11/03 13:40:51 Using internal plugin for file
2016/11/03 13:40:51 Using internal plugin for powershell
2016/11/03 13:40:51 Using internal plugin for puppet-server
2016/11/03 13:40:51 Using internal plugin for salt-masterless
2016/11/03 13:40:51 Using internal plugin for shell
2016/11/03 13:40:51 Using internal plugin for windows-restart
2016/11/03 13:40:51 Using internal plugin for chef-client
2016/11/03 13:40:51 Using internal plugin for windows-shell
2016/11/03 13:40:51 Using internal plugin for compress
2016/11/03 13:40:51 Using internal plugin for docker-save
2016/11/03 13:40:51 Using internal plugin for shell-local
2016/11/03 13:40:51 Using internal plugin for vagrant-cloud
2016/11/03 13:40:51 Using internal plugin for amazon-import
2016/11/03 13:40:51 Using internal plugin for checksum
2016/11/03 13:40:51 Using internal plugin for manifest
2016/11/03 13:40:51 Using internal plugin for vagrant
2016/11/03 13:40:51 Using internal plugin for vsphere
2016/11/03 13:40:51 Using internal plugin for artifice
2016/11/03 13:40:51 Using internal plugin for docker-import
2016/11/03 13:40:51 Using internal plugin for docker-tag
2016/11/03 13:40:51 Using internal plugin for atlas
2016/11/03 13:40:51 Using internal plugin for googlecompute-export
2016/11/03 13:40:51 Using internal plugin for docker-push
2016/11/03 13:40:51 Detected home directory from env var: /home/jev
2016/11/03 13:40:51 Attempting to open config file: /home/jev/.packerconfig
2016/11/03 13:40:51 [WARN] Config file doesn't exist: /home/jev/.packerconfig
2016/11/03 13:40:51 Packer config: &{DisableCheckpoint:false DisableCheckpointSignature:false PluginMinPort:10000 PluginMaxPort:25000 Builders:map[openstack:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-openstack virtualbox-iso:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-virtualbox-iso file:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-file vmware-vmx:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-vmware-vmx parallels-iso:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-parallels-iso cloudstack:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-cloudstack amazon-ebs:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-amazon-ebs amazon-instance:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-amazon-instance virtualbox-ovf:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-virtualbox-ovf docker:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-docker parallels-pvm:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-parallels-pvm vmware-iso:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-vmware-iso profitbricks:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-profitbricks amazon-ebsvolume:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-amazon-ebsvolume digitalocean:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-digitalocean azure-arm:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-azure-arm googlecompute:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-googlecompute amazon-chroot:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-amazon-chroot null:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-null qemu:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-qemu] PostProcessors:map[docker-import:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-docker-import shell-local:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-shell-local vagrant-cloud:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-vagrant-cloud manifest:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-manifest vagrant:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-vagrant docker-save:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-docker-save checksum:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-checksum vsphere:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-vsphere docker-tag:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-docker-tag compress:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-compress atlas:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-atlas googlecompute-export:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-googlecompute-export docker-push:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-docker-push amazon-import:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-amazon-import artifice:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-artifice] Provisioners:map[chef-client:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-provisioner-chef-client ansible-local:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-provisioner-ansible-local puppet-masterless:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-provisioner-puppet-masterless shell-local:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-provisioner-shell-local chef-solo:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-provisioner-chef-solo puppet-server:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-provisioner-puppet-server salt-masterless:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-provisioner-salt-masterless windows-restart:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-provisioner-windows-restart ansible:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-provisioner-ansible file:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-provisioner-file powershell:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-provisioner-powershell shell:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-provisioner-shell windows-shell:/home/jev/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-provisioner-windows-shell]}
2016/11/03 13:40:51 Setting cache directory: /home/jev/projects/foo/infrastructure/packer/packer_cache
2016/11/03 13:40:51 Detected home directory from env var: /home/jev
2016/11/03 13:40:51 Loading builder: googlecompute
2016/11/03 13:40:51 Plugin could not be found. Checking same directory as executable.
2016/11/03 13:40:51 Current exe path: /home/jev/go/bin/packer
2016/11/03 13:40:51 Creating plugin client for path: /home/jev/go/bin/packer
2016/11/03 13:40:51 Starting plugin: /home/jev/go/bin/packer []string{"/home/jev/go/bin/packer", "plugin", "packer-builder-googlecompute"}
2016/11/03 13:40:51 Waiting for RPC address for: /home/jev/go/bin/packer
2016/11/03 13:40:51 packer: 2016/11/03 13:40:51 [INFO] Packer version: 0.11.1.dev (ed3c6f29effb32bec300d3e9b72472cac5d0fd06)
2016/11/03 13:40:51 packer: 2016/11/03 13:40:51 Packer Target OS/Arch: linux amd64
2016/11/03 13:40:51 packer: 2016/11/03 13:40:51 Built with Go Version: go1.7.3
2016/11/03 13:40:51 packer: 2016/11/03 13:40:51 Detected home directory from env var: /home/jev
2016/11/03 13:40:51 packer: 2016/11/03 13:40:51 Attempting to open config file: /home/jev/.packerconfig
2016/11/03 13:40:51 packer: 2016/11/03 13:40:51 [WARN] Config file doesn't exist: /home/jev/.packerconfig
2016/11/03 13:40:51 packer: 2016/11/03 13:40:51 Packer config: &{DisableCheckpoint:false DisableCheckpointSignature:false PluginMinPort:10000 PluginMaxPort:25000 Builders:map[] PostProcessors:map[] Provisioners:map[]}
2016/11/03 13:40:51 packer: 2016/11/03 13:40:51 Setting cache directory: /home/jev/projects/foo/infrastructure/packer/packer_cache
2016/11/03 13:40:51 packer: 2016/11/03 13:40:51 args: []string{"packer-builder-googlecompute"}
2016/11/03 13:40:51 packer: 2016/11/03 13:40:51 Plugin minimum port: 10000
2016/11/03 13:40:51 packer: 2016/11/03 13:40:51 Plugin maximum port: 25000
2016/11/03 13:40:51 packer: 2016/11/03 13:40:51 Detected home directory from env var: /home/jev
2016/11/03 13:40:51 packer: 2016/11/03 13:40:51 Plugin address: unix /tmp/packer-plugin273091801
2016/11/03 13:40:51 packer: 2016/11/03 13:40:51 Waiting for connection...
2016/11/03 13:40:51 packer: 2016/11/03 13:40:51 Serving a plugin connection...
2016/11/03 13:40:51 ui: foo-base-gcp-freebsd11 output will be in this color.
2016/11/03 13:40:51 ui: 
2016/11/03 13:40:51 Build debug mode: false
2016/11/03 13:40:51 Force build: false
2016/11/03 13:40:51 On error: 
2016/11/03 13:40:51 Preparing build: foo-base-gcp-freebsd11
foo-base-gcp-freebsd11 output will be in this color.

2016/11/03 13:40:51 Waiting on builds to complete...
2016/11/03 13:40:51 Starting build run: foo-base-gcp-freebsd11
2016/11/03 13:40:51 Running builder: googlecompute
2016/11/03 13:40:51 packer: 2016/11/03 13:40:51 [INFO] Requesting Google token via AccountFile...
2016/11/03 13:40:51 packer: 2016/11/03 13:40:51 [INFO]   -- Email: 1059733243903-compute@developer.gserviceaccount.com
2016/11/03 13:40:51 packer: 2016/11/03 13:40:51 [INFO]   -- Scopes: [https://www.googleapis.com/auth/compute https://www.googleapis.com/auth/devstorage.full_control]
2016/11/03 13:40:51 packer: 2016/11/03 13:40:51 [INFO]   -- Private Key Length: 1704
2016/11/03 13:40:51 packer: 2016/11/03 13:40:51 [INFO] Instantiating GCE client...
2016/11/03 13:40:51 ui: ==> foo-base-gcp-freebsd11: Checking image does not exist...
==> foo-base-gcp-freebsd11: Checking image does not exist...
2016/11/03 13:40:52 ui: ==> foo-base-gcp-freebsd11: Creating temporary SSH key for instance...
==> foo-base-gcp-freebsd11: Creating temporary SSH key for instance...
2016/11/03 13:40:52 ui: ==> foo-base-gcp-freebsd11: Creating instance...
==> foo-base-gcp-freebsd11: Creating instance...
2016/11/03 13:40:52 ui:     foo-base-gcp-freebsd11: Loading zone: us-west1-a
    foo-base-gcp-freebsd11: Loading zone: us-west1-a
2016/11/03 13:40:52 ui:     foo-base-gcp-freebsd11: Loading machine type: n1-standard-1
    foo-base-gcp-freebsd11: Loading machine type: n1-standard-1
2016/11/03 13:40:52 ui:     foo-base-gcp-freebsd11: Loading network: default
    foo-base-gcp-freebsd11: Loading network: default
2016/11/03 13:40:52 ui:     foo-base-gcp-freebsd11: Requesting instance creation...
    foo-base-gcp-freebsd11: Requesting instance creation...
2016/11/03 13:40:53 ui:     foo-base-gcp-freebsd11: Waiting for creation operation to complete...
    foo-base-gcp-freebsd11: Waiting for creation operation to complete...
2016/11/03 13:41:17 ui:     foo-base-gcp-freebsd11: Instance has been created!
2016/11/03 13:41:17 ui: ==> foo-base-gcp-freebsd11: Waiting for the instance to become running...
    foo-base-gcp-freebsd11: Instance has been created!
==> foo-base-gcp-freebsd11: Waiting for the instance to become running...
2016/11/03 13:41:18 ui:     foo-base-gcp-freebsd11: IP: 104.196.229.158
2016/11/03 13:41:18 packer: 2016/11/03 13:41:18 [INFO] Waiting for SSH, up to timeout: 5m0s
    foo-base-gcp-freebsd11: IP: 104.196.229.158
2016/11/03 13:41:18 ui: ==> foo-base-gcp-freebsd11: Waiting for SSH to become available...
==> foo-base-gcp-freebsd11: Waiting for SSH to become available...
2016/11/03 13:41:33 packer: 2016/11/03 13:41:33 [DEBUG] TCP connection to SSH ip/port failed: dial tcp 104.196.229.158:22: i/o timeout
2016/11/03 13:41:53 packer: 2016/11/03 13:41:53 [DEBUG] TCP connection to SSH ip/port failed: dial tcp 104.196.229.158:22: i/o timeout
2016/11/03 13:42:13 packer: 2016/11/03 13:42:13 [DEBUG] TCP connection to SSH ip/port failed: dial tcp 104.196.229.158:22: i/o timeout
2016/11/03 13:42:25 packer: 2016/11/03 13:42:25 [INFO] Attempting SSH connection...
2016/11/03 13:42:25 packer: 2016/11/03 13:42:25 reconnecting to TCP connection for SSH
2016/11/03 13:42:25 packer: 2016/11/03 13:42:25 handshaking with SSH
2016/11/03 13:42:25 packer: 2016/11/03 13:42:25 handshake complete!
2016/11/03 13:42:25 packer: 2016/11/03 13:42:25 opening new ssh session
2016/11/03 13:42:25 packer: 2016/11/03 13:42:25 [ERROR] RequestAgentForwarding: &errors.errorString{s:"forwarding request denied"}
2016/11/03 13:42:25 ui: ==> foo-base-gcp-freebsd11: Connected to SSH!
2016/11/03 13:42:25 packer: 2016/11/03 13:42:25 Running the provision hook
==> foo-base-gcp-freebsd11: Connected to SSH!
2016/11/03 13:42:25 ui: ==> foo-base-gcp-freebsd11: Waiting for any running startup script to finish...
==> foo-base-gcp-freebsd11: Waiting for any running startup script to finish...
2016/11/03 13:42:25 ui: ==> foo-base-gcp-freebsd11: Startup script not finished yet. Waiting...
==> foo-base-gcp-freebsd11: Startup script not finished yet. Waiting...
2016/11/03 13:42:35 ui: ==> foo-base-gcp-freebsd11: Startup script not finished yet. Waiting...
==> foo-base-gcp-freebsd11: Startup script not finished yet. Waiting...
2016/11/03 13:42:56 ui: ==> foo-base-gcp-freebsd11: Startup script not finished yet. Waiting...
==> foo-base-gcp-freebsd11: Startup script not finished yet. Waiting...
2016/11/03 13:43:12 Closing stdin because interrupt received.
2016/11/03 13:43:12 Stopping build: foo-base-gcp-freebsd11
2016/11/03 13:43:12 packer: 2016/11/03 13:43:12 Received interrupt signal (count: 1). Ignoring.
2016/11/03 13:43:12 packer: 2016/11/03 13:43:12 Cancelling the step runner...