debug_log

 packer build test_5417.json
2017/10/12 12:17:03 [INFO] Packer version: 1.1.1-dev (ce01e198)
2017/10/12 12:17:03 Packer Target OS/Arch: darwin amd64
2017/10/12 12:17:03 Built with Go Version: go1.8.1
2017/10/12 12:17:03 Detected home directory from env var: /Users/mmarsh
2017/10/12 12:17:03 Using internal plugin for lxc
2017/10/12 12:17:03 Using internal plugin for profitbricks
2017/10/12 12:17:03 Using internal plugin for vmware-vmx
2017/10/12 12:17:03 Using internal plugin for amazon-ebsvolume
2017/10/12 12:17:03 Using internal plugin for cloudstack
2017/10/12 12:17:03 Using internal plugin for googlecompute
2017/10/12 12:17:03 Using internal plugin for azure-arm
2017/10/12 12:17:03 Using internal plugin for amazon-instance
2017/10/12 12:17:03 Using internal plugin for amazon-chroot
2017/10/12 12:17:03 Using internal plugin for amazon-ebssurrogate
2017/10/12 12:17:03 Using internal plugin for openstack
2017/10/12 12:17:03 Using internal plugin for qemu
2017/10/12 12:17:03 Using internal plugin for vmware-iso
2017/10/12 12:17:03 Using internal plugin for alicloud-ecs
2017/10/12 12:17:03 Using internal plugin for docker
2017/10/12 12:17:03 Using internal plugin for hyperv-iso
2017/10/12 12:17:03 Using internal plugin for null
2017/10/12 12:17:03 Using internal plugin for oneandone
2017/10/12 12:17:03 Using internal plugin for amazon-ebs
2017/10/12 12:17:03 Using internal plugin for triton
2017/10/12 12:17:03 Using internal plugin for parallels-pvm
2017/10/12 12:17:03 Using internal plugin for virtualbox-iso
2017/10/12 12:17:03 Using internal plugin for virtualbox-ovf
2017/10/12 12:17:03 Using internal plugin for digitalocean
2017/10/12 12:17:03 Using internal plugin for file
2017/10/12 12:17:03 Using internal plugin for lxd
2017/10/12 12:17:03 Using internal plugin for oracle-oci
2017/10/12 12:17:03 Using internal plugin for parallels-iso
2017/10/12 12:17:03 Using internal plugin for powershell
2017/10/12 12:17:03 Using internal plugin for shell-local
2017/10/12 12:17:03 Using internal plugin for windows-restart
2017/10/12 12:17:03 Using internal plugin for converge
2017/10/12 12:17:03 Using internal plugin for file
2017/10/12 12:17:03 Using internal plugin for puppet-masterless
2017/10/12 12:17:03 Using internal plugin for salt-masterless
2017/10/12 12:17:03 Using internal plugin for shell
2017/10/12 12:17:03 Using internal plugin for windows-shell
2017/10/12 12:17:03 Using internal plugin for ansible
2017/10/12 12:17:03 Using internal plugin for ansible-local
2017/10/12 12:17:03 Using internal plugin for chef-client
2017/10/12 12:17:03 Using internal plugin for chef-solo
2017/10/12 12:17:03 Using internal plugin for puppet-server
2017/10/12 12:17:03 Using internal plugin for checksum
2017/10/12 12:17:03 Using internal plugin for docker-import
2017/10/12 12:17:03 Using internal plugin for docker-tag
2017/10/12 12:17:03 Using internal plugin for vagrant-cloud
2017/10/12 12:17:03 Using internal plugin for atlas
2017/10/12 12:17:03 Using internal plugin for docker-save
2017/10/12 12:17:03 Using internal plugin for googlecompute-export
2017/10/12 12:17:03 Using internal plugin for alicloud-import
2017/10/12 12:17:03 Using internal plugin for amazon-import
2017/10/12 12:17:03 Using internal plugin for artifice
2017/10/12 12:17:03 Using internal plugin for compress
2017/10/12 12:17:03 Using internal plugin for docker-push
2017/10/12 12:17:03 Using internal plugin for manifest
2017/10/12 12:17:03 Using internal plugin for shell-local
2017/10/12 12:17:03 Using internal plugin for vagrant
2017/10/12 12:17:03 Using internal plugin for vsphere
2017/10/12 12:17:03 Using internal plugin for vsphere-template
2017/10/12 12:17:03 Detected home directory from env var: /Users/mmarsh
2017/10/12 12:17:03 Attempting to open config file: /Users/mmarsh/.packerconfig
2017/10/12 12:17:03 [WARN] Config file doesn't exist: /Users/mmarsh/.packerconfig
2017/10/12 12:17:03 Packer config: &{DisableCheckpoint:false DisableCheckpointSignature:false PluginMinPort:10000 PluginMaxPort:25000 Builders:map[azure-arm:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-azure-arm amazon-ebssurrogate:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-amazon-ebssurrogate virtualbox-iso:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-virtualbox-iso googlecompute:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-googlecompute docker:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-docker digitalocean:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-digitalocean profitbricks:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-profitbricks vmware-vmx:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-vmware-vmx alicloud-ecs:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-alicloud-ecs parallels-iso:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-parallels-iso amazon-ebsvolume:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-amazon-ebsvolume oracle-oci:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-oracle-oci openstack:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-openstack qemu:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-qemu hyperv-iso:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-hyperv-iso triton:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-triton oneandone:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-oneandone parallels-pvm:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-parallels-pvm virtualbox-ovf:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-virtualbox-ovf lxd:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-lxd amazon-instance:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-amazon-instance amazon-chroot:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-amazon-chroot lxc:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-lxc cloudstack:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-cloudstack vmware-iso:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-vmware-iso null:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-null amazon-ebs:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-amazon-ebs file:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-builder-file] PostProcessors:map[amazon-import:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-amazon-import artifice:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-artifice shell-local:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-shell-local vsphere:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-vsphere checksum:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-checksum vagrant-cloud:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-vagrant-cloud docker-push:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-docker-push vagrant:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-vagrant vsphere-template:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-vsphere-template docker-tag:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-docker-tag googlecompute-export:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-googlecompute-export manifest:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-manifest docker-save:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-docker-save alicloud-import:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-alicloud-import compress:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-compress docker-import:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-docker-import atlas:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-post-processor-atlas] Provisioners:map[ansible-local:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-provisioner-ansible-local chef-solo:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-provisioner-chef-solo puppet-server:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-provisioner-puppet-server powershell:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-provisioner-powershell puppet-masterless:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-provisioner-puppet-masterless windows-shell:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-provisioner-windows-shell ansible:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-provisioner-ansible salt-masterless:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-provisioner-salt-masterless shell:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-provisioner-shell chef-client:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-provisioner-chef-client shell-local:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-provisioner-shell-local windows-restart:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-provisioner-windows-restart converge:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-provisioner-converge file:/Users/mmarsh/go/bin/packer-PACKERSPACE-plugin-PACKERSPACE-packer-provisioner-file]}
2017/10/12 12:17:03 Detected home directory from env var: /Users/mmarsh
2017/10/12 12:17:03 Setting cache directory: /Users/mmarsh/dev/repro_cases/packer_cache
2017/10/12 12:17:03 Detected home directory from env var: /Users/mmarsh
2017/10/12 12:17:03 Loading builder: amazon-ebs
2017/10/12 12:17:03 Plugin could not be found. Checking same directory as executable.
2017/10/12 12:17:03 Current exe path: /Users/mmarsh/go/bin/packer
2017/10/12 12:17:03 Creating plugin client for path: /Users/mmarsh/go/bin/packer
2017/10/12 12:17:03 Starting plugin: /Users/mmarsh/go/bin/packer []string{"/Users/mmarsh/go/bin/packer", "plugin", "packer-builder-amazon-ebs"}
2017/10/12 12:17:03 Waiting for RPC address for: /Users/mmarsh/go/bin/packer
2017/10/12 12:17:03 packer: 2017/10/12 12:17:03 [INFO] Packer version: 1.1.1-dev (ce01e198)
2017/10/12 12:17:03 packer: 2017/10/12 12:17:03 Packer Target OS/Arch: darwin amd64
2017/10/12 12:17:03 packer: 2017/10/12 12:17:03 Built with Go Version: go1.8.1
2017/10/12 12:17:03 packer: 2017/10/12 12:17:03 Detected home directory from env var: /Users/mmarsh
2017/10/12 12:17:03 packer: 2017/10/12 12:17:03 Attempting to open config file: /Users/mmarsh/.packerconfig
2017/10/12 12:17:03 packer: 2017/10/12 12:17:03 [WARN] Config file doesn't exist: /Users/mmarsh/.packerconfig
2017/10/12 12:17:03 packer: 2017/10/12 12:17:03 Packer config: &{DisableCheckpoint:false DisableCheckpointSignature:false PluginMinPort:10000 PluginMaxPort:25000 Builders:map[] PostProcessors:map[] Provisioners:map[]}
2017/10/12 12:17:03 packer: 2017/10/12 12:17:03 Detected home directory from env var: /Users/mmarsh
2017/10/12 12:17:03 packer: 2017/10/12 12:17:03 Setting cache directory: /Users/mmarsh/dev/repro_cases/packer_cache
2017/10/12 12:17:03 packer: 2017/10/12 12:17:03 args: []string{"packer-builder-amazon-ebs"}
2017/10/12 12:17:03 packer: 2017/10/12 12:17:03 Detected home directory from env var: /Users/mmarsh
2017/10/12 12:17:03 packer: 2017/10/12 12:17:03 Plugin minimum port: 10000
2017/10/12 12:17:03 packer: 2017/10/12 12:17:03 Plugin maximum port: 25000
2017/10/12 12:17:03 packer: 2017/10/12 12:17:03 Plugin address: unix /var/folders/8t/0yb5q0_x6mb2jldqq_vjn3lr0000gn/T/packer-plugin902014063
2017/10/12 12:17:03 packer: 2017/10/12 12:17:03 Waiting for connection...
2017/10/12 12:17:03 packer: 2017/10/12 12:17:03 Serving a plugin connection...
2017/10/12 12:17:03 ui: amazon-ebs output will be in this color.
2017/10/12 12:17:03 ui:
2017/10/12 12:17:03 Build debug mode: false
2017/10/12 12:17:03 Force build: false
2017/10/12 12:17:03 On error:
2017/10/12 12:17:03 Preparing build: amazon-ebs
amazon-ebs output will be in this color.

2017/10/12 12:17:03 packer: 2017/10/12 12:17:03 Config: {PackerConfig:{PackerBuildName:amazon-ebs PackerBuilderType:amazon-ebs PackerDebug:false PackerForce:false PackerOnError: PackerUserVars:map[aws_secret_key:<Filtered> aws_access_key:<Filtered>]} AccessConfig:{AccessKey:<Filtered> CustomEndpointEc2: MFACode: ProfileName: RawRegion:us-east-1 SecretKey:<Filtered> SkipValidation:false Token: session:<nil>} AMIConfig:{AMIName:packer-5417 AMIDescription: AMIVirtType: AMIUsers:[] AMIGroups:[] AMIProductCodes:[] AMIRegions:[] AMISkipRegionValidation:false AMITags:map[] AMIENASupport:false AMISriovNetSupport:false AMIForceDeregister:true AMIForceDeleteSnapshot:false AMIEncryptBootVolume:false AMIKmsKeyId: AMIRegionKMSKeyIDs:map[] SnapshotTags:map[] SnapshotUsers:[] SnapshotGroups:[]} BlockDevices:{AMIBlockDevices:{AMIMappings:[]} LaunchBlockDevices:{LaunchMappings:[]}} RunConfig:{AssociatePublicIpAddress:false AvailabilityZone: EbsOptimized:false IamInstanceProfile: InstanceType:m3.medium RunTags:map[] SourceAmi: SourceAmiFilter:{Filters:map[0xc42045aab0:0xc42045aad0 0xc42045aaf0:0xc42045ab10 0xc42045ab30:0xc42045ab50] Owners:[0xc42045abd0] MostRecent:true} SpotPrice:auto SpotPriceAutoProduct:Linux/UNIX DisableStopInstance:false SecurityGroupId: SecurityGroupIds:[] SubnetId: TemporaryKeyPairName:packer_59dfbfaf-e22d-9de2-67dd-9d70aa6400e8 UserData: UserDataFile: WindowsPasswordTimeout:20m0s VpcId: InstanceInitiatedShutdownBehavior:stop Comm:{Type:ssh SSHHost: SSHPort:22 SSHUsername:ubuntu SSHPassword: SSHPrivateKey: SSHPty:false SSHTimeout:5m0s SSHAgentAuth:false SSHDisableAgentForwarding:false SSHHandshakeAttempts:10 SSHBastionHost: SSHBastionPort:0 SSHBastionAgentAuth:false SSHBastionUsername: SSHBastionPassword: SSHBastionPrivateKey: SSHFileTransferMethod:scp WinRMUser: WinRMPassword: WinRMHost: WinRMPort:0 WinRMTimeout:0s WinRMUseSSL:false WinRMInsecure:false WinRMUseNTLM:false WinRMTransportDecorator:<nil>} SSHKeyPairName: SSHPrivateIp:false} VolumeRunTags:map[Name:Packer Test 5417 Project:testytesttest5417] ctx:{Data:<nil> Funcs:map[clean_ami_name:0x18a0f00] UserVariables:map[aws_secret_key:<Filtered> aws_access_key:<Filtered>] EnableEnv:false BuildName:amazon-ebs BuildType:amazon-ebs TemplatePath:/Users/mmarsh/dev/repro_cases/test_5417.json}}
2017/10/12 12:17:03 Waiting on builds to complete...
2017/10/12 12:17:03 Starting build run: amazon-ebs
2017/10/12 12:17:03 Running builder: amazon-ebs
2017/10/12 12:17:03 [INFO] (telemetry) Starting builder amazon-ebs
2017/10/12 12:17:03 ui: ==> amazon-ebs: Force Deregister flag found, skipping prevalidating AMI Name
==> amazon-ebs: Force Deregister flag found, skipping prevalidating AMI Name
2017/10/12 12:17:03 packer: 2017/10/12 12:17:03 Using AMI Filters {
2017/10/12 12:17:03 packer:   Filters: [{
2017/10/12 12:17:03 packer:       Name: "name",
2017/10/12 12:17:03 packer:       Values: ["ubuntu/images/*ubuntu-xenial-16.04-amd64-server-*"]
2017/10/12 12:17:03 packer:     },{
2017/10/12 12:17:03 packer:       Name: "root-device-type",
2017/10/12 12:17:03 packer:       Values: ["ebs"]
2017/10/12 12:17:03 packer:     },{
2017/10/12 12:17:03 packer:       Name: "virtualization-type",
2017/10/12 12:17:03 packer:       Values: ["hvm"]
2017/10/12 12:17:03 packer:     }],
2017/10/12 12:17:03 packer:   Owners: ["099720109477"]
2017/10/12 12:17:03 packer: }
2017/10/12 12:17:07 ui:     amazon-ebs: Found Image ID: ami-d651b8ac
    amazon-ebs: Found Image ID: ami-d651b8ac
2017/10/12 12:17:07 ui: ==> amazon-ebs: Creating temporary keypair: packer_59dfbfaf-e22d-9de2-67dd-9d70aa6400e8
==> amazon-ebs: Creating temporary keypair: packer_59dfbfaf-e22d-9de2-67dd-9d70aa6400e8
2017/10/12 12:17:07 ui: ==> amazon-ebs: Creating temporary security group for this instance: packer_59dfbfb3-fdc1-19ae-54a4-94bd4cfbae7b
==> amazon-ebs: Creating temporary security group for this instance: packer_59dfbfb3-fdc1-19ae-54a4-94bd4cfbae7b
2017/10/12 12:17:07 ui: ==> amazon-ebs: Authorizing access to port 22 on the temporary security group...
==> amazon-ebs: Authorizing access to port 22 on the temporary security group...
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [DEBUG] Waiting for temporary security group: sg-65b16417
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [DEBUG] Found security group sg-65b16417
2017/10/12 12:17:08 ui: ==> amazon-ebs: Launching a source AWS instance...
==> amazon-ebs: Launching a source AWS instance...
2017/10/12 12:17:08 ui:     amazon-ebs: Finding spot price for Linux/UNIX m3.medium...
    amazon-ebs: Finding spot price for Linux/UNIX m3.medium...
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009400
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009500
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009400
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009600
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009300
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009400
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009500
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009600
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009700
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009800
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009900
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009800
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009700
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009500
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009700
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009800
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009800
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009900
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009800
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009700
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009700
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009900
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009400
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009500
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009800
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009700
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009800
==> amazon-ebs: Adding tags to source instance
    amazon-ebs: Adding tag: "Name": "Packer Builder"
    amazon-ebs: Requesting spot instance 'm3.medium' for: 0.0143
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009700
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009800
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009800
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009700
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009600
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009900
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009700
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009800
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009600
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009900
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009700
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009800
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009900
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009800
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009900
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009800
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009600
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009700
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009600
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009700
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009600
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009700
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009900
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009600
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009600
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.009600
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.700000
2017/10/12 12:17:08 packer: 2017/10/12 12:17:08 [INFO] Candidate spot price: 0.700000
2017/10/12 12:17:08 ui: ==> amazon-ebs: Adding tags to source instance
2017/10/12 12:17:08 ui:     amazon-ebs: Adding tag: "Name": "Packer Builder"
2017/10/12 12:17:08 ui:     amazon-ebs: Requesting spot instance 'm3.medium' for: 0.0143
2017/10/12 12:17:09 ui:     amazon-ebs: Waiting for spot request (sir-mfdi4h5h) to become active...
2017/10/12 12:17:09 packer: 2017/10/12 12:17:09 Waiting for state to become: active
2017/10/12 12:17:09 packer: 2017/10/12 12:17:09 Using 2s as polling delay (change with AWS_POLL_DELAY_SECONDS)
2017/10/12 12:17:09 packer: 2017/10/12 12:17:09 Allowing 300s to complete (change with AWS_TIMEOUT_SECONDS)
    amazon-ebs: Waiting for spot request (sir-mfdi4h5h) to become active...
2017/10/12 12:17:16 ui:     amazon-ebs: Instance ID: i-0144597d653205c87
2017/10/12 12:17:16 ui: ==> amazon-ebs: Waiting for instance (i-0144597d653205c87) to become ready...
    amazon-ebs: Instance ID: i-0144597d653205c87
2017/10/12 12:17:16 packer: 2017/10/12 12:17:16 Waiting for state to become: running
2017/10/12 12:17:16 packer: 2017/10/12 12:17:16 Using 2s as polling delay (change with AWS_POLL_DELAY_SECONDS)
2017/10/12 12:17:16 packer: 2017/10/12 12:17:16 Allowing 300s to complete (change with AWS_TIMEOUT_SECONDS)
==> amazon-ebs: Waiting for instance (i-0144597d653205c87) to become ready...
2017/10/12 12:17:30 ui: ==> amazon-ebs: Adding tags to source EBS Volumes
==> amazon-ebs: Adding tags to source EBS Volumes
2017/10/12 12:17:30 ui:     amazon-ebs: Adding tag: "Name": "Packer Test 5417"
    amazon-ebs: Adding tag: "Name": "Packer Test 5417"
2017/10/12 12:17:30 ui:     amazon-ebs: Adding tag: "Project": "testytesttest5417"
    amazon-ebs: Adding tag: "Project": "testytesttest5417"
2017/10/12 12:17:30 packer: 2017/10/12 12:17:30 [INFO] Not using winrm communicator, skipping get password...
2017/10/12 12:17:30 packer: 2017/10/12 12:17:30 [INFO] Waiting for SSH, up to timeout: 5m0s
2017/10/12 12:17:30 ui: ==> amazon-ebs: Waiting for SSH to become available...
==> amazon-ebs: Waiting for SSH to become available...
2017/10/12 12:17:30 packer: Build 'amazon-ebs' errored: unexpected EOF

==> Some builds didn't complete successfully and had errors:
--> amazon-ebs: unexpected EOF

==> Builds finished but no artifacts were created.
panic: interface conversion: interface {} is nil, not *ec2.Instance
2017/10/12 12:17:30 packer:
2017/10/12 12:17:30 packer: goroutine 13 [running]:
2017/10/12 12:17:30 packer: github.com/hashicorp/packer/builder/amazon/common.SSHHost.func1(0x3c583a0, 0xc42044f980, 0xc42001e000, 0x2d65780, 0xc420042d28, 0xc42002adc0)
2017/10/12 12:17:30 packer: 	/Users/mmarsh/go/src/github.com/hashicorp/packer/builder/amazon/common/ssh.go:34 +0x501
2017/10/12 12:17:30 packer: github.com/hashicorp/packer/helper/communicator.(*StepConnectSSH).waitForSSH(0xc4201d3f60, 0x3c583a0, 0xc42044f980, 0xc42079b7a0, 0x0, 0x1, 0xc42002afa0, 0x0)
2017/10/12 12:17:30 packer: 	/Users/mmarsh/go/src/github.com/hashicorp/packer/helper/communicator/step_connect_ssh.go:121 +0xb8
2017/10/12 12:17:30 packer: github.com/hashicorp/packer/helper/communicator.(*StepConnectSSH).Run.func1(0x3c5b340, 0xc420465a80, 0xc420412f20, 0xc420412f30, 0xc4201d3f60, 0x3c583a0, 0xc42044f980, 0xc42079b7a0, 0xc42001a8c0)
2017/10/12 12:17:30 packer: 	/Users/mmarsh/go/src/github.com/hashicorp/packer/helper/communicator/step_connect_ssh.go:41 +0x82
2017/10/12 12:17:30 packer: created by github.com/hashicorp/packer/helper/communicator.(*StepConnectSSH).Run
2017/10/12 12:17:30 packer: 	/Users/mmarsh/go/src/github.com/hashicorp/packer/helper/communicator/step_connect_ssh.go:43 +0x1b9
2017/10/12 12:17:30 [INFO] (telemetry) ending amazon-ebs
2017/10/12 12:17:30 [INFO] (telemetry) found error: unexpected EOF
2017/10/12 12:17:30 ui error: Build 'amazon-ebs' errored: unexpected EOF
2017/10/12 12:17:30 Builds completed. Waiting on interrupt barrier...
2017/10/12 12:17:30 machine readable: error-count []string{"1"}
2017/10/12 12:17:30 ui error:
==> Some builds didn't complete successfully and had errors:
2017/10/12 12:17:30 machine readable: amazon-ebs,error []string{"unexpected EOF"}
2017/10/12 12:17:30 ui error: --> amazon-ebs: unexpected EOF
2017/10/12 12:17:30 ui:
==> Builds finished but no artifacts were created.
2017/10/12 12:17:30 waiting for all plugin processes to complete...
2017/10/12 12:17:30 /Users/mmarsh/go/bin/packer: plugin process exited
panic: interface conversion: interface {} is nil, not *ec2.Instance
2017/10/12 12:17:30 packer:
2017/10/12 12:17:30 packer: goroutine 13 [running]:
2017/10/12 12:17:30 packer: github.com/hashicorp/packer/builder/amazon/common.SSHHost.func1(0x3c583a0, 0xc42044f980, 0xc42001e000, 0x2d65780, 0xc420042d28, 0xc42002adc0)
2017/10/12 12:17:30 packer: 	/Users/mmarsh/go/src/github.com/hashicorp/packer/builder/amazon/common/ssh.go:34 +0x501
2017/10/12 12:17:30 packer: github.com/hashicorp/packer/helper/communicator.(*StepConnectSSH).waitForSSH(0xc4201d3f60, 0x3c583a0, 0xc42044f980, 0xc42079b7a0, 0x0, 0x1, 0xc42002afa0, 0x0)
2017/10/12 12:17:30 packer: 	/Users/mmarsh/go/src/github.com/hashicorp/packer/helper/communicator/step_connect_ssh.go:121 +0xb8
2017/10/12 12:17:30 packer: github.com/hashicorp/packer/helper/communicator.(*StepConnectSSH).Run.func1(0x3c5b340, 0xc420465a80, 0xc420412f20, 0xc420412f30, 0xc4201d3f60, 0x3c583a0, 0xc42044f980, 0xc42079b7a0, 0xc42001a8c0)
2017/10/12 12:17:30 packer: 	/Users/mmarsh/go/src/github.com/hashicorp/packer/helper/communicator/step_connect_ssh.go:41 +0x82
2017/10/12 12:17:30 packer: created by github.com/hashicorp/packer/helper/communicator.(*StepConnectSSH).Run
2017/10/12 12:17:30 packer: 	/Users/mmarsh/go/src/github.com/hashicorp/packer/helper/communicator/step_connect_ssh.go:43 +0x1b9
2017/10/12 12:17:30 [INFO] (telemetry) ending amazon-ebs
2017/10/12 12:17:30 [INFO] (telemetry) found error: unexpected EOF
2017/10/12 12:17:30 ui error: Build 'amazon-ebs' errored: unexpected EOF
2017/10/12 12:17:30 Builds completed. Waiting on interrupt barrier...
2017/10/12 12:17:30 machine readable: error-count []string{"1"}
2017/10/12 12:17:30 ui error:
==> Some builds didn't complete successfully and had errors:
2017/10/12 12:17:30 machine readable: amazon-ebs,error []string{"unexpected EOF"}
2017/10/12 12:17:30 ui error: --> amazon-ebs: unexpected EOF
2017/10/12 12:17:30 ui:
==> Builds finished but no artifacts were created.
2017/10/12 12:17:30 waiting for all plugin processes to complete...
2017/10/12 12:17:30 /Users/mmarsh/go/bin/packer: plugin process exited



!!!!!!!!!!!!!!!!!!!!!!!!!!! PACKER CRASH !!!!!!!!!!!!!!!!!!!!!!!!!!!!

Packer crashed! This is always indicative of a bug within Packer.
A crash log has been placed at "crash.log" relative to your current
working directory. It would be immensely helpful if you could please
report the crash with Packer[1] so that we can fix this.

[1]: https://github.com/hashicorp/packer/issues

!!!!!!!!!!!!!!!!!!!!!!!!!!! PACKER CRASH !!!!!!!!!!!!!!!!!!!!!!!!!!!!

repro.json

{
 "variables": {
        "aws_access_key": "{{env `AWS_ACCESS_KEY_ID`}}",
        "aws_secret_key": "{{env `AWS_SECRET_ACCESS_KEY`}}"
    },
    "builders": [
        {
            "access_key": "{{user `aws_access_key`}}",
            "ami_name": "packer-5417",
            "force_deregister": true,
            "instance_type": "m3.medium",
            "region": "us-east-1",
            "secret_key": "{{user `aws_secret_key`}}",
            "source_ami_filter": {
                "filters": {
                    "virtualization-type": "hvm",
                    "name": "ubuntu/images/*ubuntu-xenial-16.04-amd64-server-*",
                    "root-device-type": "ebs"
                },
                "owners": ["099720109477"],
                "most_recent": true
            },
            "ssh_username": "ubuntu",
            "type": "amazon-ebs",
            "spot_price": "auto",
            "spot_price_auto_product": "Linux/UNIX",
            "run_volume_tags": {
                "Name": "Packer Test 5417",
                "Project": "testytesttest5417"
            }            
        }
    ]
}