Log file

packer.log

2018/02/23 11:39:03 packer: 2018/02/23 11:39:03 starting remote command: esxcli --formatter csv system version get
2018/02/23 11:39:03 packer: 2018/02/23 11:39:03 Connected to VMware ESXi 6.5.0 Releasebuild-4887370
2018/02/23 11:39:03 packer: 2018/02/23 11:39:03 opening new ssh session
2018/02/23 11:39:03 packer: 2018/02/23 11:39:03 starting remote command: esxcli --formatter csv system settings advanced list -o /Net/GuestIPHack
2018/02/23 11:39:04 ui: ==> ubuntu-1604-server: Downloading or copying ISO
2018/02/23 11:39:04 packer: 2018/02/23 11:39:04 Acquiring lock to download: file://isos/ubuntu-16.04.3-server-amd64.iso
2018/02/23 11:39:04 ui:     ubuntu-1604-server: Downloading or copying: file://isos/ubuntu-16.04.3-server-amd64.iso
2018/02/23 11:39:04 packer: 2018/02/23 11:39:04 Parsed URL: &url.URL{Scheme:"file", Opaque:"", User:(*url.Userinfo)(nil), Host:"", Path:"isos/ubuntu-16.04.3-server-amd64.iso", RawPath:"", ForceQ
uery:false, RawQuery:"", Fragment:""}
2018/02/23 11:39:04 packer: 2018/02/23 11:39:04 [DEBUG] Using local file: ubuntu-16.04.3-server-amd64.iso
2018/02/23 11:39:04 packer: 2018/02/23 11:39:04 Verifying checksum of /home/aurelien/dev/packer-esxi/isos/ubuntu-16.04.3-server-amd64.iso                                                                               [62/1288]
2018/02/23 11:39:07 packer: 2018/02/23 11:39:07 opening new ssh session
2018/02/23 11:39:07 packer: 2018/02/23 11:39:07 starting remote command: test -e /vmfs/volumes/datastore1/ISO/output-ubuntu-1604-server
2018/02/23 11:39:07 packer: 2018/02/23 11:39:07 Remote command exited with '1': test -e /vmfs/volumes/datastore1/ISO/output-ubuntu-1604-server
2018/02/23 11:39:07 packer: 2018/02/23 11:39:07 opening new ssh session
2018/02/23 11:39:07 packer: 2018/02/23 11:39:07 starting remote command: mkdir -p /vmfs/volumes/datastore1/ISO/output-ubuntu-1604-server
2018/02/23 11:39:07 ui: ==> ubuntu-1604-server: Creating floppy disk...
2018/02/23 11:39:07 packer: 2018/02/23 11:39:07 Floppy path: /tmp/packer710591806
2018/02/23 11:39:07 packer: 2018/02/23 11:39:07 Initializing block device backed by temporary file
2018/02/23 11:39:07 packer: 2018/02/23 11:39:07 Formatting the block device with a FAT filesystem...
2018/02/23 11:39:07 packer: 2018/02/23 11:39:07 Initializing FAT filesystem on block device
2018/02/23 11:39:07 packer: 2018/02/23 11:39:07 Reading the root directory from the filesystem
2018/02/23 11:39:07 ui:     ubuntu-1604-server: Copying files flatly from floppy_files
2018/02/23 11:39:07 ui:     ubuntu-1604-server: Copying file: preseed/ubuntu.cfg
2018/02/23 11:39:07 ui:     ubuntu-1604-server: Done copying files from floppy_files
2018/02/23 11:39:07 ui:     ubuntu-1604-server: Collecting paths from floppy_dirs
2018/02/23 11:39:07 ui:     ubuntu-1604-server: Resulting paths from floppy_dirs : []
2018/02/23 11:39:07 ui:     ubuntu-1604-server: Done copying paths from floppy_dirs
2018/02/23 11:39:07 ui: ==> ubuntu-1604-server: Uploading Floppy to remote machine...
2018/02/23 11:39:07 packer: 2018/02/23 11:39:07 Remote uploading: /tmp/packer710591806
2018/02/23 11:39:07 packer: 2018/02/23 11:39:07 opening new ssh session
2018/02/23 11:39:07 packer: 2018/02/23 11:39:07 starting remote command: mkdir -p /vmfs/volumes/datastore1/ISO/packer_cache
2018/02/23 11:39:08 packer: 2018/02/23 11:39:08 Verifying checksum of /vmfs/volumes/datastore1/ISO/packer_cache/packer710591806
2018/02/23 11:39:08 packer: 2018/02/23 11:39:08 opening new ssh session
2018/02/23 11:39:08 packer: 2018/02/23 11:39:08 starting remote command: sha256sum -c
2018/02/23 11:39:08 packer: 2018/02/23 11:39:08 Remote command exited with '1': sha256sum -c
2018/02/23 11:39:08 packer: 2018/02/23 11:39:08 opening new ssh session
2018/02/23 11:39:08 packer: 2018/02/23 11:39:08 starting remote command: test -d "/vmfs/volumes/datastore1/ISO/packer_cache/packer710591806"
2018/02/23 11:39:08 packer: 2018/02/23 11:39:08 Remote command exited with '1': test -d "/vmfs/volumes/datastore1/ISO/packer_cache/packer710591806"
2018/02/23 11:39:08 packer: 2018/02/23 11:39:08 opening new ssh session
2018/02/23 11:39:08 packer: 2018/02/23 11:39:08 Starting remote scp process:  scp -vt /vmfs/volumes/datastore1/ISO/packer_cache
2018/02/23 11:39:08 packer: 2018/02/23 11:39:08 Started SCP session, beginning transfers...
2018/02/23 11:39:08 packer: 2018/02/23 11:39:08 Copying input data into temporary file so we can read the length
2018/02/23 11:39:08 packer: 2018/02/23 11:39:08 [DEBUG] scp: Uploading packer710591806: perms=C0644 size=1474560
2018/02/23 11:39:08 packer: 2018/02/23 11:39:08 SCP session complete, closing stdin pipe.
2018/02/23 11:39:08 packer: 2018/02/23 11:39:08 Waiting for SSH session to complete.
2018/02/23 11:39:08 packer: 2018/02/23 11:39:08 scp stderr (length 36): Sink: C0644 1474560 packer710591806
2018/02/23 11:39:08 ui: ==> ubuntu-1604-server: Uploading ISO to remote machine...
2018/02/23 11:39:08 packer: 2018/02/23 11:39:08 Remote uploading: isos/ubuntu-16.04.3-server-amd64.iso
2018/02/23 11:39:08 packer: 2018/02/23 11:39:08 opening new ssh session
2018/02/23 11:39:08 packer: 2018/02/23 11:39:08 starting remote command: mkdir -p /vmfs/volumes/datastore1/ISO/packer_cache
2018/02/23 11:39:08 packer: 2018/02/23 11:39:08 Verifying checksum of /vmfs/volumes/datastore1/ISO/packer_cache/ubuntu-16.04.3-server-amd64.iso
2018/02/23 11:39:08 packer: 2018/02/23 11:39:08 opening new ssh session
2018/02/23 11:39:08 packer: 2018/02/23 11:39:08 starting remote command: sha256sum -c
2018/02/23 11:39:35 packer: 2018/02/23 11:39:35 Initial checksum matched, no upload needed.
2018/02/23 11:39:35 ui: ==> ubuntu-1604-server: Creating virtual machine disk
2018/02/23 11:39:35 packer: 2018/02/23 11:39:35 opening new ssh session
2018/02/23 11:39:35 packer: 2018/02/23 11:39:35 starting remote command: vmkfstools -c 40000M -d thin -a lsilogic /vmfs/volumes/datastore1/ISO/output-ubuntu-1604-server/disk.vmdk
2018/02/23 11:39:36 ui: ==> ubuntu-1604-server: Building and writing VMX file
2018/02/23 11:39:36 packer: 2018/02/23 11:39:36 Writing VMX to: /tmp/packer-vmx879557920/ubuntu-1604-server.vmx
2018/02/23 11:39:36 packer: 2018/02/23 11:39:36 Setting VMX: 'RemoteDisplay.vnc.enabled' = 'true'
2018/02/23 11:39:36 packer: 2018/02/23 11:39:36 Setting VMX: 'RemoteDisplay.vnc.port' = '5902'
2018/02/23 11:39:36 packer: 2018/02/23 11:39:36 Setting VMX: 'ethernet0.networkName' = 'VM Network'
2018/02/23 11:39:36 packer: 2018/02/23 11:39:36 Floppy path present, setting in VMX
2018/02/23 11:39:36 packer: 2018/02/23 11:39:36 Writing VMX to: /tmp/packer-vmx879557920/ubuntu-1604-server.vmx
2018/02/23 11:39:36 packer: 2018/02/23 11:39:36 Suppressing messages in VMX
2018/02/23 11:39:36 packer: 2018/02/23 11:39:36 Looking for available port between 5900 and 6000
2018/02/23 11:39:36 packer: 2018/02/23 11:39:36 opening new ssh session
2018/02/23 11:39:36 packer: 2018/02/23 11:39:36 starting remote command: esxcli --formatter csv network ip connection list
2018/02/23 11:39:36 packer: 2018/02/23 11:39:36 ESXi listening on address fe80:2::21d:9ff:fe71:556d:427, port 427 unavailable for VNC
2018/02/23 11:39:36 packer: 2018/02/23 11:39:36 ESXi listening on address 192.168.1.10:427, port 427 unavailable for VNC
2018/02/23 11:39:36 packer: 2018/02/23 11:39:36 ESXi listening on address 0.0.0.0:443, port 443 unavailable for VNC
2018/02/23 11:39:36 packer: 2018/02/23 11:39:36 ESXi listening on address :::443, port 443 unavailable for VNC
2018/02/23 11:39:36 packer: 2018/02/23 11:39:36 ESXi listening on address 0.0.0.0:80, port 80 unavailable for VNC
2018/02/23 11:39:36 packer: 2018/02/23 11:39:36 ESXi listening on address :::80, port 80 unavailable for VNC
2018/02/23 11:39:36 packer: 2018/02/23 11:39:36 ESXi listening on address :::9080, port 9080 unavailable for VNC
2018/02/23 11:39:36 packer: 2018/02/23 11:39:36 ESXi listening on address :::22, port 22 unavailable for VNC
2018/02/23 11:39:36 packer: 2018/02/23 11:39:36 ESXi listening on address 0.0.0.0:22, port 22 unavailable for VNC
2018/02/23 11:39:36 packer: 2018/02/23 11:39:36 ESXi listening on address :::8000, port 8000 unavailable for VNC
2018/02/23 11:39:36 packer: 2018/02/23 11:39:36 ESXi listening on address :::902, port 902 unavailable for VNC
2018/02/23 11:39:36 packer: 2018/02/23 11:39:36 ESXi listening on address 0.0.0.0:902, port 902 unavailable for VNC
2018/02/23 11:39:36 packer: 2018/02/23 11:39:36 ESXi listening on address :::8300, port 8300 unavailable for VNC
2018/02/23 11:39:36 packer: 2018/02/23 11:39:36 Trying address: 192.168.1.10:5900...
2018/02/23 11:39:51 packer: 2018/02/23 11:39:51 Timeout connecting to: 192.168.1.10:5900 (check firewall rules)
2018/02/23 11:39:51 packer: 2018/02/23 11:39:51 Trying address: 192.168.1.10:5901...
2018/02/23 11:39:51 packer: 2018/02/23 11:39:51 Found available VNC port: 5901
2018/02/23 11:39:51 packer: 2018/02/23 11:39:51 Writing VMX to: /tmp/packer-vmx879557920/ubuntu-1604-server.vmx
2018/02/23 11:39:51 ui: ==> ubuntu-1604-server: Registering remote VM...
2018/02/23 11:39:51 packer: 2018/02/23 11:39:51 opening new ssh session
2018/02/23 11:39:51 packer: 2018/02/23 11:39:51 starting remote command: test -d "/vmfs/volumes/datastore1/ISO/output-ubuntu-1604-server/ubuntu-1604-server.vmx"
2018/02/23 11:39:52 packer: 2018/02/23 11:39:52 Remote command exited with '1': test -d "/vmfs/volumes/datastore1/ISO/output-ubuntu-1604-server/ubuntu-1604-server.vmx"
2018/02/23 11:39:52 packer: 2018/02/23 11:39:52 opening new ssh session
2018/02/23 11:39:52 packer: 2018/02/23 11:39:52 Starting remote scp process:  scp -vt /vmfs/volumes/datastore1/ISO/output-ubuntu-1604-server
2018/02/23 11:39:52 packer: 2018/02/23 11:39:52 Started SCP session, beginning transfers...
2018/02/23 11:39:52 packer: 2018/02/23 11:39:52 Copying input data into temporary file so we can read the length
2018/02/23 11:39:52 packer: 2018/02/23 11:39:52 [DEBUG] scp: Uploading ubuntu-1604-server.vmx: perms=C0644 size=3007
2018/02/23 11:39:52 packer: 2018/02/23 11:39:52 SCP session complete, closing stdin pipe.
2018/02/23 11:39:52 packer: 2018/02/23 11:39:52 Waiting for SSH session to complete.
2018/02/23 11:39:52 packer: 2018/02/23 11:39:52 scp stderr (length 40): Sink: C0644 3007 ubuntu-1604-server.vmx
2018/02/23 11:39:52 packer: 2018/02/23 11:39:52 opening new ssh session
2018/02/23 11:39:52 packer: 2018/02/23 11:39:52 starting remote command: vim-cmd solo/registervm /vmfs/volumes/datastore1/ISO/output-ubuntu-1604-server/ubuntu-1604-server.vmx
2018/02/23 11:39:53 ui: ==> ubuntu-1604-server: Starting virtual machine...
2018/02/23 11:39:53 ui:     ubuntu-1604-server: The VM will be run headless, without a GUI. If you want to
    ubuntu-1604-server: view the screen of the VM, connect via VNC with the password "3rKOcYZ9" to
    ubuntu-1604-server: vnc://192.168.1.10:5901
2018/02/23 11:39:53 packer: 2018/02/23 11:39:53 opening new ssh session
2018/02/23 11:39:53 packer: 2018/02/23 11:39:53 starting remote command: vim-cmd vmsvc/power.on 40
2018/02/23 11:39:57 packer: 2018/02/23 11:39:57 opening new ssh session
2018/02/23 11:39:57 packer: 2018/02/23 11:39:57 starting remote command: vim-cmd vmsvc/power.getstate 40
2018/02/23 11:39:57 ui: ==> ubuntu-1604-server: Waiting 10s for boot...
2018/02/23 11:40:07 ui: ==> ubuntu-1604-server: Connecting to VM via VNC (192.168.1.10:5901)
2018/02/23 11:40:07 ui error: ==> ubuntu-1604-server: Error handshaking with VNC: no suitable auth schemes found. server supported: []byte{0x1}
2018/02/23 11:40:07 packer: 2018/02/23 11:40:07 opening new ssh session
2018/02/23 11:40:07 packer: 2018/02/23 11:40:07 starting remote command: vim-cmd vmsvc/power.getstate 40
2018/02/23 11:40:07 ui: ==> ubuntu-1604-server: Stopping virtual machine...
2018/02/23 11:40:07 packer: 2018/02/23 11:40:07 opening new ssh session
2018/02/23 11:40:07 packer: 2018/02/23 11:40:07 starting remote command: vim-cmd vmsvc/power.off 40
2018/02/23 11:40:10 ui: ==> ubuntu-1604-server: Unregistering virtual machine...
2018/02/23 11:40:10 packer: 2018/02/23 11:40:10 opening new ssh session
2018/02/23 11:40:10 packer: 2018/02/23 11:40:10 starting remote command: vim-cmd vmsvc/unregister 40
2018/02/23 11:40:10 packer: 2018/02/23 11:40:10 Deleting floppy disk: /tmp/packer710591806
2018/02/23 11:40:10 packer: 2018/02/23 11:40:10 opening new ssh session
2018/02/23 11:40:10 packer: 2018/02/23 11:40:10 starting remote command: test -e /vmfs/volumes/datastore1/ISO/output-ubuntu-1604-server
2018/02/23 11:40:10 ui: ==> ubuntu-1604-server: Deleting output directory...
2018/02/23 11:40:10 packer: 2018/02/23 11:40:10 opening new ssh session
2018/02/23 11:40:10 packer: 2018/02/23 11:40:10 starting remote command: rm -rf /vmfs/volumes/datastore1/ISO/output-ubuntu-1604-server
2018/02/23 11:40:10 [INFO] (telemetry) ending vmware-iso
2018/02/23 11:40:10 ui error: Build 'ubuntu-1604-server' errored: Error handshaking with VNC: no suitable auth schemes found. server supported: []byte{0x1}
2018/02/23 11:40:10 Builds completed. Waiting on interrupt barrier...
2018/02/23 11:40:10 machine readable: error-count []string{"1"}
2018/02/23 11:40:10 ui error: 
==> Some builds didn't complete successfully and had errors:
2018/02/23 11:40:10 machine readable: ubuntu-1604-server,error []string{"Error handshaking with VNC: no suitable auth schemes found. server supported: []byte{0x1}"}
2018/02/23 11:40:10 ui error: --> ubuntu-1604-server: Error handshaking with VNC: no suitable auth schemes found. server supported: []byte{0x1}
2018/02/23 11:40:10 ui: 
==> Builds finished but no artifacts were created.
2018/02/23 11:40:10 [INFO] (telemetry) Finalizing.
2018/02/23 11:40:11 waiting for all plugin processes to complete...
2018/02/23 11:40:11 /home/aurelien/godev/bin/packer: plugin process exited
2018/02/23 11:40:11 /home/aurelien/godev/bin/packer: plugin process exited