hashicorp / packer

Packer is a tool for creating identical machine images for multiple platforms from a single source configuration.
http://www.packer.io
Other
15.12k stars 3.33k forks source link

Crash log #6759

Closed mfriedman-upchain closed 6 years ago

mfriedman-upchain commented 6 years ago

I'm uploading a crash log for you.

2018/09/21 21:59:30 [INFO] Packer version: 1.3.1 2018/09/21 21:59:30 Packer Target OS/Arch: darwin amd64 2018/09/21 21:59:30 Built with Go Version: go1.11 2018/09/21 21:59:30 Detected home directory from env var: /Users/mattfriedman 2018/09/21 21:59:30 Using internal plugin for amazon-ebssurrogate 2018/09/21 21:59:30 Using internal plugin for parallels-iso 2018/09/21 21:59:30 Using internal plugin for vmware-iso 2018/09/21 21:59:30 Using internal plugin for alicloud-ecs 2018/09/21 21:59:30 Using internal plugin for cloudstack 2018/09/21 21:59:30 Using internal plugin for lxc 2018/09/21 21:59:30 Using internal plugin for triton 2018/09/21 21:59:30 Using internal plugin for amazon-instance 2018/09/21 21:59:30 Using internal plugin for digitalocean 2018/09/21 21:59:30 Using internal plugin for parallels-pvm 2018/09/21 21:59:30 Using internal plugin for qemu 2018/09/21 21:59:30 Using internal plugin for amazon-ebsvolume 2018/09/21 21:59:30 Using internal plugin for docker 2018/09/21 21:59:30 Using internal plugin for hyperv-iso 2018/09/21 21:59:30 Using internal plugin for hyperv-vmcx 2018/09/21 21:59:30 Using internal plugin for null 2018/09/21 21:59:30 Using internal plugin for scaleway 2018/09/21 21:59:30 Using internal plugin for amazon-ebs 2018/09/21 21:59:30 Using internal plugin for azure-arm 2018/09/21 21:59:30 Using internal plugin for openstack 2018/09/21 21:59:30 Using internal plugin for virtualbox-ovf 2018/09/21 21:59:30 Using internal plugin for amazon-chroot 2018/09/21 21:59:30 Using internal plugin for ncloud 2018/09/21 21:59:30 Using internal plugin for lxd 2018/09/21 21:59:30 Using internal plugin for oneandone 2018/09/21 21:59:30 Using internal plugin for oracle-classic 2018/09/21 21:59:30 Using internal plugin for file 2018/09/21 21:59:30 Using internal plugin for googlecompute 2018/09/21 21:59:30 Using internal plugin for oracle-oci 2018/09/21 21:59:30 Using internal plugin for profitbricks 2018/09/21 21:59:30 Using internal plugin for virtualbox-iso 2018/09/21 21:59:30 Using internal plugin for vmware-vmx 2018/09/21 21:59:30 Using internal plugin for ansible 2018/09/21 21:59:30 Using internal plugin for chef-solo 2018/09/21 21:59:30 Using internal plugin for file 2018/09/21 21:59:30 Using internal plugin for powershell 2018/09/21 21:59:30 Using internal plugin for shell 2018/09/21 21:59:30 Using internal plugin for salt-masterless 2018/09/21 21:59:30 Using internal plugin for windows-shell 2018/09/21 21:59:30 Using internal plugin for ansible-local 2018/09/21 21:59:30 Using internal plugin for windows-restart 2018/09/21 21:59:30 Using internal plugin for chef-client 2018/09/21 21:59:30 Using internal plugin for converge 2018/09/21 21:59:30 Using internal plugin for puppet-masterless 2018/09/21 21:59:30 Using internal plugin for puppet-server 2018/09/21 21:59:30 Using internal plugin for shell-local 2018/09/21 21:59:30 Using internal plugin for vagrant-cloud 2018/09/21 21:59:30 Using internal plugin for compress 2018/09/21 21:59:30 Using internal plugin for docker-import 2018/09/21 21:59:30 Using internal plugin for docker-push 2018/09/21 21:59:30 Using internal plugin for docker-tag 2018/09/21 21:59:30 Using internal plugin for manifest 2018/09/21 21:59:30 Using internal plugin for amazon-import 2018/09/21 21:59:30 Using internal plugin for googlecompute-import 2018/09/21 21:59:30 Using internal plugin for shell-local 2018/09/21 21:59:30 Using internal plugin for vsphere-template 2018/09/21 21:59:30 Using internal plugin for checksum 2018/09/21 21:59:30 Using internal plugin for googlecompute-export 2018/09/21 21:59:30 Using internal plugin for alicloud-import 2018/09/21 21:59:30 Using internal plugin for artifice 2018/09/21 21:59:30 Using internal plugin for docker-save 2018/09/21 21:59:30 Using internal plugin for vagrant 2018/09/21 21:59:30 Using internal plugin for vsphere 2018/09/21 21:59:30 Detected home directory from env var: /Users/mattfriedman 2018/09/21 21:59:30 Attempting to open config file: /Users/mattfriedman/.packerconfig 2018/09/21 21:59:30 [WARN] Config file doesn't exist: /Users/mattfriedman/.packerconfig 2018/09/21 21:59:30 Packer config: &{DisableCheckpoint:false DisableCheckpointSignature:false PluginMinPort:10000 PluginMaxPort:25000 Builders:map[digitalocean:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-digitalocean scaleway:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-scaleway amazon-ebssurrogate:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-amazon-ebssurrogate alicloud-ecs:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-alicloud-ecs triton:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-triton amazon-chroot:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-amazon-chroot virtualbox-ovf:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-virtualbox-ovf oracle-classic:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-oracle-classic file:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-file hyperv-iso:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-hyperv-iso azure-arm:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-azure-arm virtualbox-iso:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-virtualbox-iso docker:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-docker profitbricks:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-profitbricks qemu:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-qemu null:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-null oneandone:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-oneandone oracle-oci:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-oracle-oci parallels-iso:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-parallels-iso lxc:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-lxc openstack:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-openstack vmware-vmx:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-vmware-vmx vmware-iso:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-vmware-iso amazon-ebsvolume:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-amazon-ebsvolume amazon-ebs:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-amazon-ebs cloudstack:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-cloudstack hyperv-vmcx:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-hyperv-vmcx ncloud:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-ncloud lxd:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-lxd googlecompute:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-googlecompute amazon-instance:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-amazon-instance parallels-pvm:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-parallels-pvm] PostProcessors:map[googlecompute-import:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-googlecompute-import googlecompute-export:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-googlecompute-export alicloud-import:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-alicloud-import artifice:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-artifice docker-save:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-docker-save vagrant-cloud:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-vagrant-cloud docker-push:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-docker-push docker-import:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-docker-import shell-local:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-shell-local vsphere-template:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-vsphere-template checksum:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-checksum vagrant:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-vagrant docker-tag:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-docker-tag amazon-import:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-amazon-import vsphere:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-vsphere compress:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-compress manifest:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-manifest] Provisioners:map[windows-restart:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-provisioner-windows-restart puppet-masterless:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-provisioner-puppet-masterless shell-local:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-provisioner-shell-local powershell:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-provisioner-powershell windows-shell:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-provisioner-windows-shell ansible-local:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-provisioner-ansible-local converge:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-provisioner-converge salt-masterless:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-provisioner-salt-masterless chef-solo:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-provisioner-chef-solo ansible:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-provisioner-ansible shell:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-provisioner-shell chef-client:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-provisioner-chef-client puppet-server:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-provisioner-puppet-server file:/Users/mattfriedman/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-provisioner-file]} 2018/09/21 21:59:30 Detected home directory from env var: /Users/mattfriedman 2018/09/21 21:59:30 Setting cache directory: /Users/mattfriedman/workspace/authorization-server/packer/packer_cache 2018/09/21 21:59:30 Detected home directory from env var: /Users/mattfriedman 2018/09/21 21:59:30 Loading builder: amazon-ebs 2018/09/21 21:59:30 Plugin could not be found. Checking same directory as executable. 2018/09/21 21:59:30 Current exe path: /Users/mattfriedman/bin/packer 2018/09/21 21:59:30 Creating plugin client for path: /Users/mattfriedman/bin/packer 2018/09/21 21:59:30 Starting plugin: /Users/mattfriedman/bin/packer []string{"/Users/mattfriedman/bin/packer", "plugin", "packer-builder-amazon-ebs"} 2018/09/21 21:59:30 Waiting for RPC address for: /Users/mattfriedman/bin/packer 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 [INFO] Packer version: 1.3.1 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Packer Target OS/Arch: darwin amd64 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Built with Go Version: go1.11 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Detected home directory from env var: /Users/mattfriedman 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Attempting to open config file: /Users/mattfriedman/.packerconfig 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 [WARN] Config file doesn't exist: /Users/mattfriedman/.packerconfig 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Packer config: &{DisableCheckpoint:false DisableCheckpointSignature:false PluginMinPort:10000 PluginMaxPort:25000 Builders:map[] PostProcessors:map[] Provisioners:map[]} 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Detected home directory from env var: /Users/mattfriedman 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Setting cache directory: /Users/mattfriedman/workspace/authorization-server/packer/packer_cache 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Detected home directory from env var: /Users/mattfriedman 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 args: []string{"packer-builder-amazon-ebs"} 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Plugin minimum port: 10000 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Plugin maximum port: 25000 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Plugin address: unix /var/folders/2k/n57qclfd2pqg9hn02550vb180000gn/T/packer-plugin224955073 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Waiting for connection... 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Serving a plugin connection... 2018/09/21 21:59:30 Loading provisioner: shell 2018/09/21 21:59:30 Plugin could not be found. Checking same directory as executable. 2018/09/21 21:59:30 Current exe path: /Users/mattfriedman/bin/packer 2018/09/21 21:59:30 Creating plugin client for path: /Users/mattfriedman/bin/packer 2018/09/21 21:59:30 Starting plugin: /Users/mattfriedman/bin/packer []string{"/Users/mattfriedman/bin/packer", "plugin", "packer-provisioner-shell"} 2018/09/21 21:59:30 Waiting for RPC address for: /Users/mattfriedman/bin/packer 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 [INFO] Packer version: 1.3.1 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Packer Target OS/Arch: darwin amd64 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Built with Go Version: go1.11 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Detected home directory from env var: /Users/mattfriedman 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Attempting to open config file: /Users/mattfriedman/.packerconfig 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 [WARN] Config file doesn't exist: /Users/mattfriedman/.packerconfig 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Packer config: &{DisableCheckpoint:false DisableCheckpointSignature:false PluginMinPort:10000 PluginMaxPort:25000 Builders:map[] PostProcessors:map[] Provisioners:map[]} 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Detected home directory from env var: /Users/mattfriedman 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Setting cache directory: /Users/mattfriedman/workspace/authorization-server/packer/packer_cache 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Detected home directory from env var: /Users/mattfriedman 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 args: []string{"packer-provisioner-shell"} 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Plugin minimum port: 10000 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Plugin maximum port: 25000 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Plugin address: unix /var/folders/2k/n57qclfd2pqg9hn02550vb180000gn/T/packer-plugin397024261 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Waiting for connection... 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Serving a plugin connection... 2018/09/21 21:59:30 Loading provisioner: shell 2018/09/21 21:59:30 Plugin could not be found. Checking same directory as executable. 2018/09/21 21:59:30 Current exe path: /Users/mattfriedman/bin/packer 2018/09/21 21:59:30 Creating plugin client for path: /Users/mattfriedman/bin/packer 2018/09/21 21:59:30 Starting plugin: /Users/mattfriedman/bin/packer []string{"/Users/mattfriedman/bin/packer", "plugin", "packer-provisioner-shell"} 2018/09/21 21:59:30 Waiting for RPC address for: /Users/mattfriedman/bin/packer 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 [INFO] Packer version: 1.3.1 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Packer Target OS/Arch: darwin amd64 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Built with Go Version: go1.11 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Detected home directory from env var: /Users/mattfriedman 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Attempting to open config file: /Users/mattfriedman/.packerconfig 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 [WARN] Config file doesn't exist: /Users/mattfriedman/.packerconfig 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Packer config: &{DisableCheckpoint:false DisableCheckpointSignature:false PluginMinPort:10000 PluginMaxPort:25000 Builders:map[] PostProcessors:map[] Provisioners:map[]} 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Detected home directory from env var: /Users/mattfriedman 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Setting cache directory: /Users/mattfriedman/workspace/authorization-server/packer/packer_cache 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Detected home directory from env var: /Users/mattfriedman 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 args: []string{"packer-provisioner-shell"} 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Plugin minimum port: 10000 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Plugin maximum port: 25000 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Plugin address: unix /var/folders/2k/n57qclfd2pqg9hn02550vb180000gn/T/packer-plugin719790721 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Waiting for connection... 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Serving a plugin connection... 2018/09/21 21:59:30 Loading provisioner: ansible 2018/09/21 21:59:30 Plugin could not be found. Checking same directory as executable. 2018/09/21 21:59:30 Current exe path: /Users/mattfriedman/bin/packer 2018/09/21 21:59:30 Creating plugin client for path: /Users/mattfriedman/bin/packer 2018/09/21 21:59:30 Starting plugin: /Users/mattfriedman/bin/packer []string{"/Users/mattfriedman/bin/packer", "plugin", "packer-provisioner-ansible"} 2018/09/21 21:59:30 Waiting for RPC address for: /Users/mattfriedman/bin/packer 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 [INFO] Packer version: 1.3.1 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Packer Target OS/Arch: darwin amd64 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Built with Go Version: go1.11 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Detected home directory from env var: /Users/mattfriedman 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Attempting to open config file: /Users/mattfriedman/.packerconfig 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 [WARN] Config file doesn't exist: /Users/mattfriedman/.packerconfig 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Packer config: &{DisableCheckpoint:false DisableCheckpointSignature:false PluginMinPort:10000 PluginMaxPort:25000 Builders:map[] PostProcessors:map[] Provisioners:map[]} 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Detected home directory from env var: /Users/mattfriedman 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Setting cache directory: /Users/mattfriedman/workspace/authorization-server/packer/packer_cache 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Detected home directory from env var: /Users/mattfriedman 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 args: []string{"packer-provisioner-ansible"} 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Plugin minimum port: 10000 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Plugin maximum port: 25000 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Plugin address: unix /var/folders/2k/n57qclfd2pqg9hn02550vb180000gn/T/packer-plugin866428965 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Waiting for connection... 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Serving a plugin connection... 2018/09/21 21:59:30 Loading provisioner: file 2018/09/21 21:59:30 Plugin could not be found. Checking same directory as executable. 2018/09/21 21:59:30 Current exe path: /Users/mattfriedman/bin/packer 2018/09/21 21:59:30 Creating plugin client for path: /Users/mattfriedman/bin/packer 2018/09/21 21:59:30 Starting plugin: /Users/mattfriedman/bin/packer []string{"/Users/mattfriedman/bin/packer", "plugin", "packer-provisioner-file"} 2018/09/21 21:59:30 Waiting for RPC address for: /Users/mattfriedman/bin/packer 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 [INFO] Packer version: 1.3.1 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Packer Target OS/Arch: darwin amd64 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Built with Go Version: go1.11 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Detected home directory from env var: /Users/mattfriedman 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Attempting to open config file: /Users/mattfriedman/.packerconfig 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 [WARN] Config file doesn't exist: /Users/mattfriedman/.packerconfig 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Packer config: &{DisableCheckpoint:false DisableCheckpointSignature:false PluginMinPort:10000 PluginMaxPort:25000 Builders:map[] PostProcessors:map[] Provisioners:map[]} 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Detected home directory from env var: /Users/mattfriedman 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Setting cache directory: /Users/mattfriedman/workspace/authorization-server/packer/packer_cache 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Detected home directory from env var: /Users/mattfriedman 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 args: []string{"packer-provisioner-file"} 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Plugin minimum port: 10000 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Plugin maximum port: 25000 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Plugin address: unix /var/folders/2k/n57qclfd2pqg9hn02550vb180000gn/T/packer-plugin697269161 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Waiting for connection... 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Serving a plugin connection... 2018/09/21 21:59:30 Loading post-processor: manifest 2018/09/21 21:59:30 Plugin could not be found. Checking same directory as executable. 2018/09/21 21:59:30 Current exe path: /Users/mattfriedman/bin/packer 2018/09/21 21:59:30 Creating plugin client for path: /Users/mattfriedman/bin/packer 2018/09/21 21:59:30 Starting plugin: /Users/mattfriedman/bin/packer []string{"/Users/mattfriedman/bin/packer", "plugin", "packer-post-processor-manifest"} 2018/09/21 21:59:30 Waiting for RPC address for: /Users/mattfriedman/bin/packer 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 [INFO] Packer version: 1.3.1 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Packer Target OS/Arch: darwin amd64 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Built with Go Version: go1.11 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Detected home directory from env var: /Users/mattfriedman 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Attempting to open config file: /Users/mattfriedman/.packerconfig 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 [WARN] Config file doesn't exist: /Users/mattfriedman/.packerconfig 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Packer config: &{DisableCheckpoint:false DisableCheckpointSignature:false PluginMinPort:10000 PluginMaxPort:25000 Builders:map[] PostProcessors:map[] Provisioners:map[]} 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Detected home directory from env var: /Users/mattfriedman 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Setting cache directory: /Users/mattfriedman/workspace/authorization-server/packer/packer_cache 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Detected home directory from env var: /Users/mattfriedman 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 args: []string{"packer-post-processor-manifest"} 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Plugin minimum port: 10000 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Plugin maximum port: 25000 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Plugin address: unix /var/folders/2k/n57qclfd2pqg9hn02550vb180000gn/T/packer-plugin262624573 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Waiting for connection... 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 Serving a plugin connection... 2018/09/21 21:59:30 ui: amazon-ebs output will be in this color. 2018/09/21 21:59:30 ui: 2018/09/21 21:59:30 Build debug mode: false 2018/09/21 21:59:30 Force build: false 2018/09/21 21:59:30 On error: 2018/09/21 21:59:30 Preparing build: amazon-ebs 2018/09/21 21:59:30 packer: 2018/09/21 21:59:30 {{amazon-ebs amazon-ebs false false map[aws_secret_key: instance_type:t2.micro ssh_keypair: ssh_private_key_path: output_file: aws_region:us-east-1 aws_access_key:] []} { false us-east-1 false false } {Authorization Server [] [] [] [] false map[Name:Authorization Server {{timestamp}} Purpose:Oauth2 Authn OS_Version:Ubuntu Release:Latest Base_AMI_Name:{{ .SourceAMIName }} Extra:{{ .SourceAMITags.TagName }}] false false true true false map[] map[] [] []} {{[]} {[]}} {false 0 false false false stop t2.micro map[Name:AuthN Server {{timestamp}}] [] {map[0xc0002e0a60:0xc0002e0a80] [0xc0002e0b20] true} map[] 0.0.0.0/0 20m0s {ssh 22 ubuntu [] [] packer_5ba5a202-e3f1-0efc-2813-0e4b075ca0ac false false 5m0s false false 10 0 false scp 0 5s 0s 0 0s false false false }} map[] { map[clean_ami_name:0x1945920] map[aws_secret_key: instance_type:t2.micro ssh_keypair: ssh_private_key_path: output_file: aws_region:us-east-1 aws_access_key:] [] false amazon-ebs amazon-ebs /Users/mattfriedman/workspace/authorization-server/packer/packer.json}} 2018/09/21 21:59:31 packer: 2018/09/21 21:59:31 ansible-playbook version: 2.5.1 2018/09/21 21:59:31 Waiting on builds to complete... 2018/09/21 21:59:31 Starting build run: amazon-ebs 2018/09/21 21:59:31 Running builder: amazon-ebs 2018/09/21 21:59:31 [INFO] (telemetry) Starting builder amazon-ebs 2018/09/21 21:59:31 packer: 2018/09/21 21:59:31 Found region us-east-1 2018/09/21 21:59:31 packer: 2018/09/21 21:59:31 [INFO] AWS Auth provider used: "StaticProvider" 2018/09/21 21:59:31 ui: ==> amazon-ebs: Force Deregister flag found, skipping prevalidating AMI Name 2018/09/21 21:59:31 packer: 2018/09/21 21:59:31 Using AMI Filters { 2018/09/21 21:59:31 packer: Filters: [{ 2018/09/21 21:59:31 packer: Name: "name", 2018/09/21 21:59:31 packer: Values: ["upchain/java-base-image-1.8"] 2018/09/21 21:59:31 packer: }], 2018/09/21 21:59:31 packer: Owners: ["647550476977"] 2018/09/21 21:59:31 packer: } 2018/09/21 21:59:31 ui:  amazon-ebs: Found Image ID: ami-01fbfc28e17360bc0 2018/09/21 21:59:31 ui: ==> amazon-ebs: Creating temporary keypair: packer_5ba5a202-e3f1-0efc-2813-0e4b075ca0ac 2018/09/21 21:59:32 ui: ==> amazon-ebs: Creating temporary security group for this instance: packer_5ba5a204-c3a4-51dd-c725-9d3daf8c5736 2018/09/21 21:59:32 ui: ==> amazon-ebs: Authorizing access to port 22 from 0.0.0.0/0 in the temporary security group... 2018/09/21 21:59:33 packer: 2018/09/21 21:59:33 [DEBUG] Waiting for temporary security group: sg-03cf05fbfc9460dc8 2018/09/21 21:59:33 packer: 2018/09/21 21:59:33 [DEBUG] Found security group sg-03cf05fbfc9460dc8 2018/09/21 21:59:33 ui: ==> amazon-ebs: Launching a source AWS instance... 2018/09/21 21:59:33 ui: ==> amazon-ebs: Adding tags to source instance 2018/09/21 21:59:33 ui:  amazon-ebs: Adding tag: "Name": "AuthN Server 1537581570" 2018/09/21 21:59:34 ui:  amazon-ebs: Instance ID: i-08850945bbe2d96d7 2018/09/21 21:59:34 ui: ==> amazon-ebs: Waiting for instance (i-08850945bbe2d96d7) to become ready... 2018/09/21 22:00:05 packer: 2018/09/21 22:00:05 [INFO] Not using winrm communicator, skipping get password... 2018/09/21 22:00:05 ui: ==> amazon-ebs: Using ssh communicator to connect: 54.89.213.181 2018/09/21 22:00:05 packer: 2018/09/21 22:00:05 [INFO] Waiting for SSH, up to timeout: 5m0s 2018/09/21 22:00:05 ui: ==> amazon-ebs: Waiting for SSH to become available... 2018/09/21 22:00:05 packer: 2018/09/21 22:00:05 [DEBUG] TCP connection to SSH ip/port failed: dial tcp 54.89.213.181:22: connect: connection refused 2018/09/21 22:00:11 packer: 2018/09/21 22:00:11 [INFO] Attempting SSH connection... 2018/09/21 22:00:11 packer: 2018/09/21 22:00:11 [DEBUG] reconnecting to TCP connection for SSH 2018/09/21 22:00:11 packer: 2018/09/21 22:00:11 [DEBUG] handshaking with SSH 2018/09/21 22:00:11 packer: 2018/09/21 22:00:11 [DEBUG] handshake complete! 2018/09/21 22:00:11 packer: 2018/09/21 22:00:11 [DEBUG] Opening new ssh session 2018/09/21 22:00:12 packer: 2018/09/21 22:00:12 [INFO] agent forwarding enabled 2018/09/21 22:00:12 ui: ==> amazon-ebs: Connected to SSH! 2018/09/21 22:00:12 packer: 2018/09/21 22:00:12 Running the provision hook 2018/09/21 22:00:12 [INFO] (telemetry) Starting provisioner shell 2018/09/21 22:00:12 ui: ==> amazon-ebs: Provisioning with shell script: /var/folders/2k/n57qclfd2pqg9hn02550vb180000gn/T/packer-shell002578848 2018/09/21 22:00:12 packer: 2018/09/21 22:00:12 Opening /var/folders/2k/n57qclfd2pqg9hn02550vb180000gn/T/packer-shell002578848 for reading 2018/09/21 22:00:12 packer: 2018/09/21 22:00:12 [INFO] 68 bytes written for 'uploadData' 2018/09/21 22:00:12 [INFO] 68 bytes written for 'uploadData' 2018/09/21 22:00:12 packer: 2018/09/21 22:00:12 [DEBUG] Opening new ssh session 2018/09/21 22:00:12 packer: 2018/09/21 22:00:12 [DEBUG] Starting remote scp process: scp -vt /tmp 2018/09/21 22:00:12 packer: 2018/09/21 22:00:12 [DEBUG] Started SCP session, beginning transfers... 2018/09/21 22:00:12 packer: 2018/09/21 22:00:12 [DEBUG] Copying input data into temporary file so we can read the length 2018/09/21 22:00:12 packer: 2018/09/21 22:00:12 [DEBUG] scp: Uploading script_9752.sh: perms=C0644 size=68 2018/09/21 22:00:12 packer: 2018/09/21 22:00:12 [DEBUG] SCP session complete, closing stdin pipe. 2018/09/21 22:00:12 packer: 2018/09/21 22:00:12 [DEBUG] Waiting for SSH session to complete. 2018/09/21 22:00:12 packer: 2018/09/21 22:00:12 [DEBUG] scp stderr (length 30): Sink: C0644 68 script_9752.sh 2018/09/21 22:00:12 packer: 2018/09/21 22:00:12 [DEBUG] Opening new ssh session 2018/09/21 22:00:12 packer: 2018/09/21 22:00:12 [DEBUG] starting remote command: chmod 0755 /tmp/script_9752.sh 2018/09/21 22:00:12 packer: 2018/09/21 22:00:12 [INFO] RPC endpoint: Communicator ended with: 0 2018/09/21 22:00:12 [INFO] RPC client: Communicator ended with: 0 2018/09/21 22:00:12 [INFO] RPC endpoint: Communicator ended with: 0 2018/09/21 22:00:12 packer: 2018/09/21 22:00:12 [INFO] RPC client: Communicator ended with: 0 2018/09/21 22:00:12 packer: 2018/09/21 22:00:12 [DEBUG] Opening new ssh session 2018/09/21 22:00:12 packer: 2018/09/21 22:00:12 [DEBUG] starting remote command: chmod +x /tmp/script_9752.sh; PACKER_BUILDER_TYPE='amazon-ebs' PACKER_BUILD_NAME='amazon-ebs' /tmp/script_9752.sh 2018/09/21 22:00:32 ui:  amazon-ebs: Ready to start provisioning... 2018/09/21 22:00:33 packer: 2018/09/21 22:00:33 [INFO] RPC endpoint: Communicator ended with: 0 2018/09/21 22:00:33 [INFO] 31 bytes written for 'stdout' 2018/09/21 22:00:33 [INFO] 0 bytes written for 'stderr' 2018/09/21 22:00:33 [INFO] RPC client: Communicator ended with: 0 2018/09/21 22:00:33 [INFO] RPC endpoint: Communicator ended with: 0 2018/09/21 22:00:33 packer: 2018/09/21 22:00:33 [INFO] 31 bytes written for 'stdout' 2018/09/21 22:00:33 packer: 2018/09/21 22:00:33 [INFO] 0 bytes written for 'stderr' 2018/09/21 22:00:33 packer: 2018/09/21 22:00:33 [INFO] RPC client: Communicator ended with: 0 2018/09/21 22:00:33 packer: 2018/09/21 22:00:33 [DEBUG] Opening new ssh session 2018/09/21 22:00:33 packer: 2018/09/21 22:00:33 [DEBUG] starting remote command: rm -f /tmp/script_9752.sh 2018/09/21 22:00:33 packer: 2018/09/21 22:00:33 [INFO] RPC endpoint: Communicator ended with: 0 2018/09/21 22:00:33 [INFO] RPC client: Communicator ended with: 0 2018/09/21 22:00:33 [INFO] RPC endpoint: Communicator ended with: 0 2018/09/21 22:00:33 packer: 2018/09/21 22:00:33 [INFO] RPC client: Communicator ended with: 0 2018/09/21 22:00:33 packer: 2018/09/21 22:00:33 [DEBUG] Opening new ssh session 2018/09/21 22:00:33 packer: 2018/09/21 22:00:33 [DEBUG] starting remote command: rm -f 2018/09/21 22:00:33 packer: 2018/09/21 22:00:33 [INFO] RPC endpoint: Communicator ended with: 0 2018/09/21 22:00:33 [INFO] RPC client: Communicator ended with: 0 2018/09/21 22:00:33 [INFO] RPC endpoint: Communicator ended with: 0 2018/09/21 22:00:33 packer: 2018/09/21 22:00:33 [INFO] RPC client: Communicator ended with: 0 2018/09/21 22:00:33 [INFO] (telemetry) ending shell 2018/09/21 22:00:33 [INFO] (telemetry) Starting provisioner shell 2018/09/21 22:00:33 ui: ==> amazon-ebs: Provisioning with shell script: ./provision.sh 2018/09/21 22:00:33 packer: 2018/09/21 22:00:33 Opening ./provision.sh for reading 2018/09/21 22:00:33 packer: 2018/09/21 22:00:33 [DEBUG] Opening new ssh session 2018/09/21 22:00:33 packer: 2018/09/21 22:00:33 [INFO] 230 bytes written for 'uploadData' 2018/09/21 22:00:33 [INFO] 230 bytes written for 'uploadData' 2018/09/21 22:00:33 packer: 2018/09/21 22:00:33 [DEBUG] Starting remote scp process: scp -vt /tmp 2018/09/21 22:00:33 packer: 2018/09/21 22:00:33 [DEBUG] Started SCP session, beginning transfers... 2018/09/21 22:00:33 packer: 2018/09/21 22:00:33 [DEBUG] Copying input data into temporary file so we can read the length 2018/09/21 22:00:33 packer: 2018/09/21 22:00:33 [DEBUG] scp: Uploading script_7897.sh: perms=C0644 size=230 2018/09/21 22:00:34 packer: 2018/09/21 22:00:34 [DEBUG] SCP session complete, closing stdin pipe. 2018/09/21 22:00:34 packer: 2018/09/21 22:00:34 [DEBUG] Waiting for SSH session to complete. 2018/09/21 22:00:34 packer: 2018/09/21 22:00:34 [DEBUG] scp stderr (length 31): Sink: C0644 230 script_7897.sh 2018/09/21 22:00:34 packer: 2018/09/21 22:00:34 [DEBUG] Opening new ssh session 2018/09/21 22:00:34 packer: 2018/09/21 22:00:34 [DEBUG] starting remote command: chmod 0755 /tmp/script_7897.sh 2018/09/21 22:00:34 packer: 2018/09/21 22:00:34 [INFO] RPC endpoint: Communicator ended with: 0 2018/09/21 22:00:34 [INFO] RPC client: Communicator ended with: 0 2018/09/21 22:00:34 [INFO] RPC endpoint: Communicator ended with: 0 2018/09/21 22:00:34 packer: 2018/09/21 22:00:34 [INFO] RPC client: Communicator ended with: 0 2018/09/21 22:00:34 packer: 2018/09/21 22:00:34 [DEBUG] Opening new ssh session 2018/09/21 22:00:34 packer: 2018/09/21 22:00:34 [DEBUG] starting remote command: chmod +x /tmp/script_7897.sh; PACKER_BUILDER_TYPE='amazon-ebs' PACKER_BUILD_NAME='amazon-ebs' /tmp/script_7897.sh 2018/09/21 22:00:34 ui:  amazon-ebs: Hit:1 http://us-east-1.ec2.archive.ubuntu.com/ubuntu xenial InRelease 2018/09/21 22:00:34 ui:  amazon-ebs: Hit:2 http://us-east-1.ec2.archive.ubuntu.com/ubuntu xenial-updates InRelease 2018/09/21 22:00:34 ui:  amazon-ebs: Hit:3 http://us-east-1.ec2.archive.ubuntu.com/ubuntu xenial-backports InRelease 2018/09/21 22:00:34 ui:  amazon-ebs: Hit:4 http://security.ubuntu.com/ubuntu xenial-security InRelease 2018/09/21 22:00:34 ui:  amazon-ebs: Hit:5 http://ppa.launchpad.net/webupd8team/java/ubuntu xenial InRelease 2018/09/21 22:00:35 ui:  amazon-ebs: Reading package lists... 2018/09/21 22:00:35 ui:  amazon-ebs: Reading package lists... 2018/09/21 22:00:35 ui:  amazon-ebs: Building dependency tree... 2018/09/21 22:00:35 ui:  amazon-ebs: Reading state information... 2018/09/21 22:00:35 ui:  amazon-ebs: Calculating upgrade... 2018/09/21 22:00:35 ui:  amazon-ebs: 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 2018/09/21 22:00:35 ui:  amazon-ebs: Reading package lists... 2018/09/21 22:00:36 ui:  amazon-ebs: Building dependency tree... 2018/09/21 22:00:36 ui:  amazon-ebs: Reading state information... 2018/09/21 22:00:36 ui:  amazon-ebs: unzip is already the newest version (6.0-20ubuntu1). 2018/09/21 22:00:36 ui:  amazon-ebs: python-minimal is already the newest version (2.7.12-1~16.04). 2018/09/21 22:00:36 ui:  amazon-ebs: 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 2018/09/21 22:00:36 ui:  amazon-ebs: ubuntu 2018/09/21 22:00:36 packer: 2018/09/21 22:00:36 [INFO] RPC endpoint: Communicator ended with: 0 2018/09/21 22:00:36 [INFO] 840 bytes written for 'stdout' 2018/09/21 22:00:36 [INFO] 0 bytes written for 'stderr' 2018/09/21 22:00:36 ui:  amazon-ebs: /home/ubuntu 2018/09/21 22:00:36 [INFO] RPC client: Communicator ended with: 0 2018/09/21 22:00:36 [INFO] RPC endpoint: Communicator ended with: 0 2018/09/21 22:00:36 packer: 2018/09/21 22:00:36 [INFO] 0 bytes written for 'stderr' 2018/09/21 22:00:36 packer: 2018/09/21 22:00:36 [INFO] 840 bytes written for 'stdout' 2018/09/21 22:00:36 packer: 2018/09/21 22:00:36 [INFO] RPC client: Communicator ended with: 0 2018/09/21 22:00:36 packer: 2018/09/21 22:00:36 [DEBUG] Opening new ssh session 2018/09/21 22:00:36 packer: 2018/09/21 22:00:36 [DEBUG] starting remote command: rm -f /tmp/script_7897.sh 2018/09/21 22:00:36 packer: 2018/09/21 22:00:36 [INFO] RPC endpoint: Communicator ended with: 0 2018/09/21 22:00:36 [INFO] RPC client: Communicator ended with: 0 2018/09/21 22:00:36 [INFO] RPC endpoint: Communicator ended with: 0 2018/09/21 22:00:36 packer: 2018/09/21 22:00:36 [INFO] RPC client: Communicator ended with: 0 2018/09/21 22:00:36 packer: 2018/09/21 22:00:36 [DEBUG] Opening new ssh session 2018/09/21 22:00:36 packer: 2018/09/21 22:00:36 [DEBUG] starting remote command: rm -f 2018/09/21 22:00:36 packer: 2018/09/21 22:00:36 [INFO] RPC endpoint: Communicator ended with: 0 2018/09/21 22:00:36 [INFO] RPC client: Communicator ended with: 0 2018/09/21 22:00:36 [INFO] RPC endpoint: Communicator ended with: 0 2018/09/21 22:00:36 packer: 2018/09/21 22:00:36 [INFO] RPC client: Communicator ended with: 0 2018/09/21 22:00:36 [INFO] (telemetry) ending shell 2018/09/21 22:00:36 [INFO] (telemetry) Starting provisioner ansible 2018/09/21 22:00:36 ui: ==> amazon-ebs: Provisioning with Ansible... 2018/09/21 22:00:36 packer: 2018/09/21 22:00:36 SSH proxy: serving on 127.0.0.1:63589 2018/09/21 22:00:36 ui: ==> amazon-ebs: Executing Ansible: ansible-playbook --extra-vars packer_build_name=amazon-ebs packer_builder_type=amazon-ebs -i /var/folders/2k/n57qclfd2pqg9hn02550vb180000gn/T/packer-provisioner-ansible601785247 /Users/mattfriedman/workspace/authorization-server/packer/tasks.yml -e ansible_ssh_private_key_file=/var/folders/2k/n57qclfd2pqg9hn02550vb180000gn/T/ansible-key711983424 2018/09/21 22:00:38 ui:  amazon-ebs: 2018/09/21 22:00:38 ui:  amazon-ebs: PLAY [Base Java AMI Image] * 2018/09/21 22:00:38 ui:  amazon-ebs: 2018/09/21 22:00:38 ui:  amazon-ebs: TASK [Install locale pack so Ubuntu doesn't complain] ** 2018/09/21 22:00:38 packer: 2018/09/21 22:00:38 SSH proxy: accepted connection 2018/09/21 22:00:38 packer: 2018/09/21 22:00:38 authentication attempt from 127.0.0.1:63591 to 127.0.0.1:63589 as mattfriedman using none 2018/09/21 22:00:38 packer: 2018/09/21 22:00:38 authentication attempt from 127.0.0.1:63591 to 127.0.0.1:63589 as mattfriedman using publickey 2018/09/21 22:00:38 packer: 2018/09/21 22:00:38 new env request: LANG=en_CA.UTF-8 2018/09/21 22:00:38 packer: 2018/09/21 22:00:38 new env request: LC_CTYPE=en_CA.UTF-8 2018/09/21 22:00:38 packer: 2018/09/21 22:00:38 new exec request: /bin/sh -c 'echo ~ && sleep 0' 2018/09/21 22:00:38 packer: 2018/09/21 22:00:38 [DEBUG] Opening new ssh session 2018/09/21 22:00:38 packer: 2018/09/21 22:00:38 [DEBUG] starting remote command: /bin/sh -c 'echo ~ && sleep 0' 2018/09/21 22:00:38 packer: 2018/09/21 22:00:38 [INFO] RPC endpoint: Communicator ended with: 0 2018/09/21 22:00:38 [INFO] 13 bytes written for 'stdout' 2018/09/21 22:00:38 [INFO] 0 bytes written for 'stderr' 2018/09/21 22:00:38 [INFO] RPC client: Communicator ended with: 0 2018/09/21 22:00:38 [INFO] RPC endpoint: Communicator ended with: 0 2018/09/21 22:00:38 [INFO] 0 bytes written for 'stdin' 2018/09/21 22:00:38 packer: 2018/09/21 22:00:38 [INFO] 13 bytes written for 'stdout' 2018/09/21 22:00:38 packer: 2018/09/21 22:00:38 [INFO] 0 bytes written for 'stderr' 2018/09/21 22:00:38 packer: 2018/09/21 22:00:38 [INFO] RPC client: Communicator ended with: 0 2018/09/21 22:00:38 packer: 2018/09/21 22:00:38 [INFO] 0 bytes written for 'stdin' 2018/09/21 22:00:38 packer: 2018/09/21 22:00:38 new env request: LANG=en_CA.UTF-8 2018/09/21 22:00:38 packer: 2018/09/21 22:00:38 new env request: LC_CTYPE=en_CA.UTF-8 2018/09/21 22:00:38 packer: 2018/09/21 22:00:38 new exec request: /bin/sh -c '( umask 77 && mkdir -p "echo /home/ubuntu/.ansible/tmp/ansible-tmp-1537581638.33-103620219320378" && echo ansible-tmp-1537581638.33-103620219320378="echo /home/ubuntu/.ansible/tmp/ansible-tmp-1537581638.33-103620219320378" ) && sleep 0' 2018/09/21 22:00:38 packer: 2018/09/21 22:00:38 [DEBUG] Opening new ssh session 2018/09/21 22:00:38 packer: 2018/09/21 22:00:38 [DEBUG] starting remote command: /bin/sh -c '( umask 77 && mkdir -p "echo /home/ubuntu/.ansible/tmp/ansible-tmp-1537581638.33-103620219320378" && echo ansible-tmp-1537581638.33-103620219320378="echo /home/ubuntu/.ansible/tmp/ansible-tmp-1537581638.33-103620219320378" ) && sleep 0' 2018/09/21 22:00:38 packer: 2018/09/21 22:00:38 [INFO] RPC endpoint: Communicator ended with: 0 2018/09/21 22:00:38 [INFO] 110 bytes written for 'stdout' 2018/09/21 22:00:38 [INFO] 0 bytes written for 'stderr' 2018/09/21 22:00:38 [INFO] RPC client: Communicator ended with: 0 2018/09/21 22:00:38 [INFO] RPC endpoint: Communicator ended with: 0 2018/09/21 22:00:38 [INFO] 0 bytes written for 'stdin' 2018/09/21 22:00:38 packer: 2018/09/21 22:00:38 [INFO] 110 bytes written for 'stdout' 2018/09/21 22:00:38 packer: 2018/09/21 22:00:38 [INFO] 0 bytes written for 'stderr' 2018/09/21 22:00:38 packer: 2018/09/21 22:00:38 [INFO] RPC client: Communicator ended with: 0 2018/09/21 22:00:38 packer: 2018/09/21 22:00:38 [INFO] 0 bytes written for 'stdin' 2018/09/21 22:00:38 packer: 2018/09/21 22:00:38 new env request: LANG=en_CA.UTF-8 2018/09/21 22:00:38 packer: 2018/09/21 22:00:38 new env request: LC_CTYPE=en_CA.UTF-8 2018/09/21 22:00:38 packer: 2018/09/21 22:00:38 new exec request: scp -t /home/ubuntu/.ansible/tmp/ansible-tmp-1537581638.33-103620219320378/apt.py 2018/09/21 22:00:38 packer: 2018/09/21 22:00:38 [DEBUG] Opening new ssh session 2018/09/21 22:00:38 packer: 2018/09/21 22:00:38 [INFO] 94929 bytes written for 'uploadData' 2018/09/21 22:00:38 [INFO] 94929 bytes written for 'uploadData' 2018/09/21 22:00:38 packer: 2018/09/21 22:00:38 [DEBUG] Starting remote scp process: scp -vt /home/ubuntu/.ansible/tmp/ansible-tmp-1537581638.33-103620219320378 2018/09/21 22:00:38 packer: 2018/09/21 22:00:38 [DEBUG] Started SCP session, beginning transfers... 2018/09/21 22:00:38 packer: 2018/09/21 22:00:38 [DEBUG] scp: Uploading apt.py: perms=C0600 size=94929 2018/09/21 22:00:38 packer: 2018/09/21 22:00:38 [DEBUG] SCP session complete, closing stdin pipe. 2018/09/21 22:00:38 packer: 2018/09/21 22:00:38 [DEBUG] Waiting for SSH session to complete. 2018/09/21 22:00:39 packer: 2018/09/21 22:00:39 [DEBUG] scp stderr (length 25): Sink: C0600 94929 apt.py 2018/09/21 22:00:39 packer: 2018/09/21 22:00:39 new env request: LANG=en_CA.UTF-8 2018/09/21 22:00:39 packer: 2018/09/21 22:00:39 new env request: LC_CTYPE=en_CA.UTF-8 2018/09/21 22:00:39 packer: 2018/09/21 22:00:39 new exec request: /bin/sh -c 'chmod u+x /home/ubuntu/.ansible/tmp/ansible-tmp-1537581638.33-103620219320378/ /home/ubuntu/.ansible/tmp/ansible-tmp-1537581638.33-103620219320378/apt.py && sleep 0' 2018/09/21 22:00:39 packer: 2018/09/21 22:00:39 [DEBUG] Opening new ssh session 2018/09/21 22:00:39 packer: 2018/09/21 22:00:39 [DEBUG] starting remote command: /bin/sh -c 'chmod u+x /home/ubuntu/.ansible/tmp/ansible-tmp-1537581638.33-103620219320378/ /home/ubuntu/.ansible/tmp/ansible-tmp-1537581638.33-103620219320378/apt.py && sleep 0' 2018/09/21 22:00:39 packer: 2018/09/21 22:00:39 [INFO] RPC endpoint: Communicator ended with: 0 2018/09/21 22:00:39 [INFO] 0 bytes written for 'stdout' 2018/09/21 22:00:39 [INFO] 0 bytes written for 'stderr' 2018/09/21 22:00:39 [INFO] RPC client: Communicator ended with: 0 2018/09/21 22:00:39 [INFO] RPC endpoint: Communicator ended with: 0 2018/09/21 22:00:39 [INFO] 0 bytes written for 'stdin' 2018/09/21 22:00:39 packer: 2018/09/21 22:00:39 [INFO] 0 bytes written for 'stdout' 2018/09/21 22:00:39 packer: 2018/09/21 22:00:39 [INFO] 0 bytes written for 'stderr' 2018/09/21 22:00:39 packer: 2018/09/21 22:00:39 [INFO] RPC client: Communicator ended with: 0 2018/09/21 22:00:39 packer: 2018/09/21 22:00:39 [INFO] 0 bytes written for 'stdin' 2018/09/21 22:00:39 packer: 2018/09/21 22:00:39 ansible provisioner pty-req request 2018/09/21 22:00:39 packer: 2018/09/21 22:00:39 new env request: LANG=en_CA.UTF-8 2018/09/21 22:00:39 packer: 2018/09/21 22:00:39 new env request: LC_CTYPE=en_CA.UTF-8 2018/09/21 22:00:39 packer: 2018/09/21 22:00:39 new exec request: /bin/sh -c 'sudo -H -S -n -u root /bin/sh -c '"'"'echo BECOME-SUCCESS-cvkkhmoydzeigxvvcacbmmvxqpozddpm; /usr/bin/python /home/ubuntu/.ansible/tmp/ansible-tmp-1537581638.33-103620219320378/apt.py'"'"' && sleep 0' 2018/09/21 22:00:39 packer: 2018/09/21 22:00:39 [DEBUG] Opening new ssh session 2018/09/21 22:00:39 packer: 2018/09/21 22:00:39 [DEBUG] starting remote command: /bin/sh -c 'sudo -H -S -n -u root /bin/sh -c '"'"'echo BECOME-SUCCESS-cvkkhmoydzeigxvvcacbmmvxqpozddpm; /usr/bin/python /home/ubuntu/.ansible/tmp/ansible-tmp-1537581638.33-103620219320378/apt.py'"'"' && sleep 0' 2018/09/21 22:00:40 packer: 2018/09/21 22:00:40 [INFO] RPC endpoint: Communicator ended with: 0 2018/09/21 22:00:40 [INFO] 566 bytes written for 'stdout' 2018/09/21 22:00:40 [INFO] 0 bytes written for 'stderr' 2018/09/21 22:00:40 [INFO] RPC client: Communicator ended with: 0 2018/09/21 22:00:40 [INFO] RPC endpoint: Communicator ended with: 0 2018/09/21 22:00:40 [INFO] 0 bytes written for 'stdin' 2018/09/21 22:00:40 packer: 2018/09/21 22:00:40 [INFO] 566 bytes written for 'stdout' 2018/09/21 22:00:40 packer: 2018/09/21 22:00:40 [INFO] 0 bytes written for 'stderr' 2018/09/21 22:00:40 packer: 2018/09/21 22:00:40 [INFO] RPC client: Communicator ended with: 0 2018/09/21 22:00:40 packer: 2018/09/21 22:00:40 [INFO] 0 bytes written for 'stdin' 2018/09/21 22:00:40 packer: 2018/09/21 22:00:40 new env request: LANG=en_CA.UTF-8 2018/09/21 22:00:40 packer: 2018/09/21 22:00:40 new env request: LC_CTYPE=en_CA.UTF-8 2018/09/21 22:00:40 packer: 2018/09/21 22:00:40 new exec request: /bin/sh -c 'rm -f -r /home/ubuntu/.ansible/tmp/ansible-tmp-1537581638.33-103620219320378/ > /dev/null 2>&1 && sleep 0' 2018/09/21 22:00:40 packer: 2018/09/21 22:00:40 [DEBUG] Opening new ssh session 2018/09/21 22:00:40 packer: 2018/09/21 22:00:40 [DEBUG] starting remote command: /bin/sh -c 'rm -f -r /home/ubuntu/.ansible/tmp/ansible-tmp-1537581638.33-103620219320378/ > /dev/null 2>&1 && sleep 0' 2018/09/21 22:00:40 packer: 2018/09/21 22:00:40 [INFO] RPC endpoint: Communicator ended with: 0 2018/09/21 22:00:40 [INFO] 0 bytes written for 'stdout' 2018/09/21 22:00:40 [INFO] 0 bytes written for 'stderr' 2018/09/21 22:00:40 [INFO] RPC client: Communicator ended with: 0 2018/09/21 22:00:40 [INFO] RPC endpoint: Communicator ended with: 0 2018/09/21 22:00:40 [INFO] 0 bytes written for 'stdin' 2018/09/21 22:00:40 packer: 2018/09/21 22:00:40 [INFO] 0 bytes written for 'stdout' 2018/09/21 22:00:40 packer: 2018/09/21 22:00:40 [INFO] 0 bytes written for 'stderr' 2018/09/21 22:00:40 packer: 2018/09/21 22:00:40 [INFO] RPC client: Communicator ended with: 0 2018/09/21 22:00:40 packer: 2018/09/21 22:00:40 [INFO] 0 bytes written for 'stdin' 2018/09/21 22:00:40 ui:  amazon-ebs: ok: [default] 2018/09/21 22:00:40 ui:  amazon-ebs: 2018/09/21 22:00:40 ui:  amazon-ebs: PLAY RECAP ***** 2018/09/21 22:00:40 ui:  amazon-ebs: default : ok=1 changed=0 unreachable=0 failed=0 2018/09/21 22:00:40 ui:  amazon-ebs: 2018/09/21 22:00:40 packer: 2018/09/21 22:00:40 shutting down the SSH proxy 2018/09/21 22:00:40 [INFO] (telemetry) ending ansible 2018/09/21 22:00:40 [INFO] (telemetry) Starting provisioner file 2018/09/21 22:00:40 ui: ==> amazon-ebs: Uploading ../target/authorization-server-0.0.1-SNAPSHOT.jar => /opt/authorization-server.jar 2018/09/21 22:00:40 packer: 2018/09/21 22:00:40 [DEBUG] Opening new ssh session 2018/09/21 22:00:40 packer: 2018/09/21 22:00:40 [DEBUG] Starting remote scp process: scp -vt /opt 2018/09/21 22:00:40 packer: 2018/09/21 22:00:40 [DEBUG] Started SCP session, beginning transfers... 2018/09/21 22:00:40 packer: 2018/09/21 22:00:40 [DEBUG] scp: Uploading authorization-server.jar: perms=C0644 size=28376647 2018/09/21 22:00:40 packer: 2018/09/21 22:00:40 [DEBUG] SCP session complete, closing stdin pipe. 2018/09/21 22:00:40 packer: 2018/09/21 22:00:40 [DEBUG] Waiting for SSH session to complete. 2018/09/21 22:00:40 packer: 2018/09/21 22:00:40 [DEBUG] non-zero exit status: 1 2018/09/21 22:00:40 packer: 2018/09/21 22:00:40 [DEBUG] scp output: scp: /opt/authorization-server.jar: Permission denied 2018/09/21 22:00:40 packer: scp: protocol error: expected control record 2018/09/21 22:00:40 ui error: ==> amazon-ebs: Upload failed: Process exited with status 1 2018/09/21 22:00:40 [INFO] 1474560 bytes written for 'uploadData' 2018/09/21 22:00:40 [INFO] (telemetry) ending file 2018/09/21 22:00:40 packer: 2018/09/21 22:00:40 [INFO] 1540096 bytes written for 'uploadData' 2018/09/21 22:00:40 packer: 2018/09/21 22:00:40 [ERR] 'uploadData' copy error: read ../target/authorization-server-0.0.1-SNAPSHOT.jar: file already closed 2018/09/21 22:00:40 ui: ==> amazon-ebs: Terminating the source AWS instance... panic: runtime error: invalid memory address or nil pointer dereference [signal SIGSEGV: segmentation violation code=0x1 addr=0x0 pc=0x14084ed]

goroutine 555 [running]: github.com/hashicorp/packer/vendor/github.com/cheggaaa/pb.(ProgressBar).Add64(...) /Users/azr/go/src/github.com/hashicorp/packer/vendor/github.com/cheggaaa/pb/pb.go:157 github.com/hashicorp/packer/packer.(BasicProgressBar).Add(0xc00012a050, 0x8000) /Users/azr/go/src/github.com/hashicorp/packer/packer/progressbar.go:101 +0xd github.com/hashicorp/packer/packer/rpc.(UiServer).Add(0xc0001b6700, 0x8000, 0xc00018f790, 0x0, 0x0) /Users/azr/go/src/github.com/hashicorp/packer/packer/rpc/ui.go:143 +0x51 reflect.Value.call(0xc0001af920, 0xc0005281a0, 0x13, 0x314c1b0, 0x4, 0xc00012ef18, 0x3, 0x3, 0xc0001de780, 0x1015207, ...) /usr/local/Cellar/go/1.11/libexec/src/reflect/value.go:447 +0x449 reflect.Value.Call(0xc0001af920, 0xc0005281a0, 0x13, 0xc00037ff18, 0x3, 0x3, 0x12a05f200, 0xc00037ff10, 0xc00037ffb8) /usr/local/Cellar/go/1.11/libexec/src/reflect/value.go:308 +0xa4 net/rpc.(service).call(0xc0001aa5c0, 0xc0005266e0, 0xc0001bc178, 0xc0001bc180, 0xc000562980, 0xc0001b68e0, 0x2a90560, 0xc00049e938, 0x186, 0x2a04240, ...) /usr/local/Cellar/go/1.11/libexec/src/net/rpc/server.go:384 +0x14e created by net/rpc.(*Server).ServeCodec /usr/local/Cellar/go/1.11/libexec/src/net/rpc/server.go:481 +0x47e

azr commented 6 years ago

Thanks for reporting @mfriedman-upchain, seems like this happens when we try to update the progress bar after it is stopped because of an upload error.

Will try to reproduce and fix 🙂

azr commented 6 years ago

@mfriedman-upchain, I wasn't able to reproduce with what I expected to reproduce it. Could you please give me a simplified build file that will reproduce so that I can fix it ?

mfriedman-upchain commented 6 years ago

Hi Adrien,

The only difference in the packer json was that it crashed when I tried to upload a jar into the ami via the packer json. It didn't crash when I instead uploaded that same jar via the ansible provisioner.

Sorry, I don't have the exact file available atm.

On Thu, Sep 27, 2018 at 5:08 AM Adrien Delorme notifications@github.com wrote:

@mfriedman-upchain https://github.com/mfriedman-upchain, I wasn't able to reproduce with what I expected to reproduce it. Could you please give me a simplified build file that will reproduce so that I can fix it ?

— You are receiving this because you were mentioned. Reply to this email directly, view it on GitHub https://github.com/hashicorp/packer/issues/6759#issuecomment-425017416, or mute the thread https://github.com/notifications/unsubscribe-auth/Ake1e7wnq768nWgoejkfpteiro91uxKwks5ufJWegaJpZM4W1Eky .

azr commented 6 years ago

Hello Matt,

I think #6788 should fix it, TLDR: there could be a race condition.

Here's a binary that should fix it for you:

darwin_amd64.zip

Please tell me if that fixed it 🙂

mfriedman-upchain commented 6 years ago

Hi Adrien, I'll try next time I get around to that part of the project. Thank you for this. :) will let you know

On Tue, Oct 2, 2018 at 10:51 AM Adrien Delorme notifications@github.com wrote:

Hello Matt,

I think #6788 https://github.com/hashicorp/packer/pull/6788 should fix it, TLDR: there could be a race condition.

Here's a binary that should fix it for you:

darwin_amd64.zip https://github.com/hashicorp/packer/files/2438356/packer.zip

Please tell me if that fixed it for you 🙂

— You are receiving this because you were mentioned. Reply to this email directly, view it on GitHub https://github.com/hashicorp/packer/issues/6759#issuecomment-426303243, or mute the thread https://github.com/notifications/unsubscribe-auth/Ake1ewZW98lDGzw20_w4ELMX0WP_OydFks5ug31VgaJpZM4W1Eky .

SwampDragons commented 6 years ago

@mfriedman-upchain any update on whether this build solved your crash?

mfriedman-upchain commented 6 years ago

I'd like to help but I'm not working on that part of the project atm. We ended up just using ansible to upload. I'm sorry I can't be more helpful atm.

On Fri, Oct 12, 2018 at 2:32 PM Megan Marsh notifications@github.com wrote:

@mfriedman-upchain https://github.com/mfriedman-upchain any update on whether this build solved your crash?

— You are receiving this because you were mentioned. Reply to this email directly, view it on GitHub https://github.com/hashicorp/packer/issues/6759#issuecomment-429418596, or mute the thread https://github.com/notifications/unsubscribe-auth/Ake1e-kr8qBX5gemiLainnmMNecYtxxCks5ukOAfgaJpZM4W1Eky .

SwampDragons commented 6 years ago

That's fine. If you aren't planning to come back to this yourself, we can just merge that PR and close, and if you still have problems in the future we can reopen this issue or open a new one.

ghost commented 4 years ago

I'm going to lock this issue because it has been closed for 30 days ⏳. This helps our maintainers find and focus on the active issues.

If you have found a problem that seems similar to this, please open a new issue and complete the issue template so we can capture all the details necessary to investigate further.