vagrant debug log.log

 INFO guest: Autodetecting host type for [#<Vagrant::Machine: aem (VagrantPlugins::ProviderVirtualBox::Provider)>]
DEBUG guest: Trying: atomic
 INFO ssh: Connection errored, not re-using. Will reconnect.
DEBUG ssh: #<Timeout::Error: execution expired>
 INFO subprocess: Starting process: ["C:/Program Files/Oracle/VirtualBox/VBoxManage.exe", "showvminfo", "8fb5c87b-1a3c-435e-8660-4efac27fd04f", "--machinereadable"]
 INFO subprocess: Command not in installer, restoring original environment...
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: name="{CLIENT}"
groups="/"
ostype="Red Hat (64-bit)"
UUID="8fb5c87b-1a3c-435e-8660-4efac27fd04f"
CfgFile="{HOMEDIR}\\VirtualBox VMs\\{CLIENT}\\{CLIENT}.vbox"
SnapFldr="{HOMEDIR}\\VirtualBox VMs\\{CLIENT}\\Snapshots"
LogFldr="{HOMEDIR}\\VirtualBox VMs\\{CLIENT}\\Logs"
hardwareuuid="8fb5c87b-1a3c-435e-8660-4efac27fd04f"
memory=8192
pagefusion="off"
vram=8
cpuexecutioncap=90
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=2
pae="on"
longmode="on"
triplefaultreset="off"
apic="on"
x2apic="on"
cpuid-portability-level=0
bootmenu="messageandmenu"
boot1="disk"
boot2="dvd"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
biosapic="apic"
biossystemtimeoffset=0
rtcuseutc="on"
hwvirtex="on"
nestedpaging="on"
largepages="on"
vtxvpid="on"
vtxux="on"
paravirtprovider="default"
effparavirtprovider="kvm"
VMState="running"
VMStateChangeTime="2017-07-11T19:12:38.999000000"
monitorcount=1
accelerate3d="off"
accelerate2dvideo="off"
teleporterenabled="off"
teleporterport=0
teleporteraddress=""
teleporterpassword=""
tracing-enabled="off"
tracing-allow-vm-access="off"
tracing-config=""
autostart-enabled="off"
autostart-delay=0
defaultfrontend=""
storagecontrollername0="IDE Controller"
storagecontrollertype0="PIIX4"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="2"
storagecontrollerportcount0="2"
storagecontrollerbootable0="on"
"IDE Controller-0-0"="{HOMEDIR}\VirtualBox VMs\{CLIENT}\Snapshots\{d60e1cd8-b069-4de1-8be5-b0e345172bb5}.vmdk"
"IDE Controller-ImageUUID-0-0"="d60e1cd8-b069-4de1-8be5-b0e345172bb5"
"IDE Controller-0-1"="none"
"IDE Controller-1-0"="none"
"IDE Controller-1-1"="none"
natnet1="nat"
macaddress1="080027DB3827"
cableconnected1="on"
nic1="nat"
nictype1="82540EM"
nicspeed1="0"
mtu="0"
sockSnd="64"
sockRcv="64"
tcpWndSnd="64"
tcpWndRcv="64"
Forwarding(0)="ssh,tcp,127.0.0.1,2222,,22"
Forwarding(1)="tcp4502,tcp,,4502,,4502"
Forwarding(2)="tcp4503,tcp,,4503,,4503"
Forwarding(3)="tcp4512,tcp,,4512,,4512"
Forwarding(4)="tcp4513,tcp,,4513,,4513"
Forwarding(5)="tcp4592,tcp,,4592,,4592"
Forwarding(6)="tcp4593,tcp,,4593,,4593"
Forwarding(7)="tcp80,tcp,,80,,80"
hostonlyadapter2="VirtualBox Host-Only Ethernet Adapter #2"
macaddress2="080027E33CE9"
cableconnected2="on"
nic2="hostonly"
nictype2="82540EM"
nicspeed2="0"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
uart3="off"
uart4="off"
lpt1="off"
lpt2="off"
audio="dsound"
clipboard="disabled"
draganddrop="disabled"
SessionName="GUI/Qt"
VideoMode="720,400,0"@0,0 1
vrde="on"
vrdeport=-1
vrdeports="5993"
vrdeaddress="127.0.0.1"
vrdeauthtype="null"
vrdemulticon="off"
vrdereusecon="off"
vrdevideochannel="off"
usb="off"
ehci="off"
xhci="off"
SharedFolderNameMachineMapping1="opt_install_files_.m2"
SharedFolderPathMachineMapping1="\\?\{PATH}\.m2"
SharedFolderNameMachineMapping2="vagrant"
SharedFolderPathMachineMapping2="\\?\{PATH}"
SharedFolderNameMachineMapping3="tmp_vagrant-puppet_manifests-c42ae094895da5204ae8ca79060e21be"
SharedFolderPathMachineMapping3="\\?\{PATH}\{cl}\manifests"
SharedFolderNameMachineMapping4="tmp_vagrant-puppet_modules-8aacd06f3b51f2d5a279df0bc5bad14c"
SharedFolderPathMachineMapping4="\\?\{PATH}\aem\modules"
SharedFolderNameMachineMapping5="tmp_vagrant-puppet_modules-314ccd1cdb56ec0df1fdca485ce2b133"
SharedFolderPathMachineMapping5="\\?\{PATH}\{co}\modules"
SharedFolderNameMachineMapping6="tmp_vagrant-puppet_modules-d67d2193e39b036974d2702de8a29251"
SharedFolderPathMachineMapping6="\\?\{PATH}\{cl}\modules"
VRDEActiveConnection="off"
VRDEClients=0
vcpenabled="off"
vcpscreens=0
vcpfile="{HOMEDIR}\VirtualBox VMs\{CLIENT}\{CLIENT}.webm"
vcpwidth=1024
vcpheight=768
vcprate=512
vcpfps=25
GuestMemoryBalloon=0
GuestOSType="Linux26_64"
GuestAdditionsRunLevel=2
GuestAdditionsVersion="5.1.22 r115126"
GuestAdditionsFacility_VirtualBox Base Driver=50,1499800369660
GuestAdditionsFacility_VirtualBox System Service=50,1499800371231
GuestAdditionsFacility_Seamless Mode=0,1499800369659
GuestAdditionsFacility_Graphics Mode=0,1499800369659
SnapshotName="provisioned"
SnapshotUUID="be827bcf-71a0-4fb1-902d-7e5e9db7f626"
SnapshotName-1="up-working"
SnapshotUUID-1="9185f063-c82b-4b37-a591-f64ab8fee94f"
CurrentSnapshotName="up-working"
CurrentSnapshotUUID="9185f063-c82b-4b37-a591-f64ab8fee94f"
CurrentSnapshotNode="SnapshotName-1"
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 31999
DEBUG subprocess: Exit status: 0
DEBUG virtualbox_5_1: Searching for SSH port: 22
DEBUG virtualbox_5_1: read_forward_ports: uuid=8fb5c87b-1a3c-435e-8660-4efac27fd04f active_only=false
 INFO subprocess: Starting process: ["C:/Program Files/Oracle/VirtualBox/VBoxManage.exe", "showvminfo", "8fb5c87b-1a3c-435e-8660-4efac27fd04f", "--machinereadable"]
 INFO subprocess: Command not in installer, restoring original environment...
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: name="{CLIENT}"
groups="/"
ostype="Red Hat (64-bit)"
UUID="8fb5c87b-1a3c-435e-8660-4efac27fd04f"
CfgFile="{HOMEDIR}\\VirtualBox VMs\\{CLIENT}\\{CLIENT}.vbox"
SnapFldr="{HOMEDIR}\\VirtualBox VMs\\{CLIENT}\\Snapshots"
LogFldr="{HOMEDIR}\\VirtualBox VMs\\{CLIENT}\\Logs"
hardwareuuid="8fb5c87b-1a3c-435e-8660-4efac27fd04f"
memory=8192
pagefusion="off"
vram=8
cpuexecutioncap=90
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=2
pae="on"
longmode="on"
triplefaultreset="off"
apic="on"
x2apic="on"
cpuid-portability-level=0
bootmenu="messageandmenu"
boot1="disk"
boot2="dvd"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
biosapic="apic"
biossystemtimeoffset=0
rtcuseutc="on"
hwvirtex="on"
nestedpaging="on"
largepages="on"
vtxvpid="on"
vtxux="on"
paravirtprovider="default"
effparavirtprovider="kvm"
VMState="running"
VMStateChangeTime="2017-07-11T19:12:38.999000000"
monitorcount=1
accelerate3d="off"
accelerate2dvideo="off"
teleporterenabled="off"
teleporterport=0
teleporteraddress=""
teleporterpassword=""
tracing-enabled="off"
tracing-allow-vm-access="off"
tracing-config=""
autostart-enabled="off"
autostart-delay=0
defaultfrontend=""
storagecontrollername0="IDE Controller"
storagecontrollertype0="PIIX4"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="2"
storagecontrollerportcount0="2"
storagecontrollerbootable0="on"
"IDE Controller-0-0"="{HOMEDIR}\VirtualBox VMs\{CLIENT}\Snapshots\{d60e1cd8-b069-4de1-8be5-b0e345172bb5}.vmdk"
"IDE Controller-ImageUUID-0-0"="d60e1cd8-b069-4de1-8be5-b0e345172bb5"
"IDE Controller-0-1"="none"
"IDE Controller-1-0"="none"
"IDE Controller-1-1"="none"
natnet1="nat"
macaddress1="080027DB3827"
cableconnected1="on"
nic1="nat"
nictype1="82540EM"
nicspeed1="0"
mtu="0"
sockSnd="64"
sockRcv="64"
tcpWndSnd="64"
tcpWndRcv="64"
Forwarding(0)="ssh,tcp,127.0.0.1,2222,,22"
Forwarding(1)="tcp4502,tcp,,4502,,4502"
Forwarding(2)="tcp4503,tcp,,4503,,4503"
Forwarding(3)="tcp4512,tcp,,4512,,4512"
Forwarding(4)="tcp4513,tcp,,4513,,4513"
Forwarding(5)="tcp4592,tcp,,4592,,4592"
Forwarding(6)="tcp4593,tcp,,4593,,4593"
Forwarding(7)="tcp80,tcp,,80,,80"
hostonlyadapter2="VirtualBox Host-Only Ethernet Adapter #2"
macaddress2="080027E33CE9"
cableconnected2="on"
nic2="hostonly"
nictype2="82540EM"
nicspeed2="0"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
uart3="off"
uart4="off"
lpt1="off"
lpt2="off"
audio="dsound"
clipboard="disabled"
draganddrop="disabled"
SessionName="GUI/Qt"
VideoMode="720,400,0"@0,0 1
vrde="on"
vrdeport=-1
vrdeports="5993"
vrdeaddress="127.0.0.1"
vrdeauthtype="null"
vrdemulticon="off"
vrdereusecon="off"
vrdevideochannel="off"
usb="off"
ehci="off"
xhci="off"
SharedFolderNameMachineMapping1="opt_install_files_.m2"
SharedFolderPathMachineMapping1="\\?\{PATH}\.m2"
SharedFolderNameMachineMapping2="vagrant"
SharedFolderPathMachineMapping2="\\?\{PATH}"
SharedFolderNameMachineMapping3="tmp_vagrant-puppet_manifests-c42ae094895da5204ae8ca79060e21be"
SharedFolderPathMachineMapping3="\\?\{PATH}\{cl}\manifests"
SharedFolderNameMachineMapping4="tmp_vagrant-puppet_modules-8aacd06f3b51f2d5a279df0bc5bad14c"
SharedFolderPathMachineMapping4="\\?\{PATH}\aem\modules"
SharedFolderNameMachineMapping5="tmp_vagrant-puppet_modules-314ccd1cdb56ec0df1fdca485ce2b133"
SharedFolderPathMachineMapping5="\\?\{PATH}\{co}\modules"
SharedFolderNameMachineMapping6="tmp_vagrant-puppet_modules-d67d2193e39b036974d2702de8a29251"
SharedFolderPathMachineMapping6="\\?\{PATH}\{cl}\modules"
VRDEActiveConnection="off"
VRDEClients=0
vcpenabled="off"
vcpscreens=0
vcpfile="{HOMEDIR}\VirtualBox VMs\{CLIENT}\{CLIENT}.webm"
vcpwidth=1024
vcpheight=768
vcprate=512
vcpfps=25
GuestMemoryBalloon=0
GuestOSType="Linux26_64"
GuestAdditionsRunLevel=2
GuestAdditionsVersion="5.1.22 r115126"
GuestAdditionsFacility_VirtualBox Base Driver=50,1499800369660
GuestAdditionsFacility_VirtualBox System Service=50,1499800371231
GuestAdditionsFacility_Seamless Mode=0,1499800369659
GuestAdditionsFacility_Graphics Mode=0,1499800369659
SnapshotName="provisioned"
SnapshotUUID="be827bcf-71a0-4fb1-902d-7e5e9db7f626"
SnapshotName-1="up-working"
SnapshotUUID-1="9185f063-c82b-4b37-a591-f64ab8fee94f"
CurrentSnapshotName="up-working"
CurrentSnapshotUUID="9185f063-c82b-4b37-a591-f64ab8fee94f"
CurrentSnapshotNode="SnapshotName-1"
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 31998
DEBUG subprocess: Exit status: 0
DEBUG virtualbox_5_1:   - [1, "ssh", 2222, 22, "127.0.0.1"]
DEBUG virtualbox_5_1:   - [1, "tcp4502", 4502, 4502, ""]
DEBUG virtualbox_5_1:   - [1, "tcp4503", 4503, 4503, ""]
DEBUG virtualbox_5_1:   - [1, "tcp4512", 4512, 4512, ""]
DEBUG virtualbox_5_1:   - [1, "tcp4513", 4513, 4513, ""]
DEBUG virtualbox_5_1:   - [1, "tcp4592", 4592, 4592, ""]
DEBUG virtualbox_5_1:   - [1, "tcp4593", 4593, 4593, ""]
DEBUG virtualbox_5_1:   - [1, "tcp80", 80, 80, ""]
 INFO ssh: Attempting SSH connection...
 INFO ssh: Attempting to connect to SSH...
 INFO ssh:   - Host: 127.0.0.1
 INFO ssh:   - Port: 2222
 INFO ssh:   - Username: vagrant
 INFO ssh:   - Password? false
 INFO ssh:   - Key Path: ["{PATH}/.vagrant/machines/aem/virtualbox/private_key"]
DEBUG ssh:   - connect_opts: {:auth_methods=>["none", "hostbased", "publickey"], :config=>false, :forward_agent=>false, :send_env=>false, :keys_only=>true, :paranoid=>false, :password=>nil, :port=>2222, :timeout=>15, :user_known_hosts_file=>[], :verbose=>:debug, :encryption=>["aes128-cbc", "3des-cbc", "blowfish-cbc", "cast128-cbc", "aes192-cbc", "aes256-cbc", "[email protected]", "idea-cbc", "arcfour128", "arcfour256", "arcfour", "aes128-ctr", "aes192-ctr", "aes256-ctr", "cast128-ctr", "blowfish-ctr", "3des-ctr", "none"], :logger=>#<Logger:0x0000000687d5d8 @progname=nil, @level=0, @default_formatter=#<Logger::Formatter:0x0000000687d5b0 @datetime_format=nil>, @formatter=nil, @logdev=#<Logger::LogDevice:0x0000000687d560 @shift_size=nil, @shift_age=nil, @filename=nil, @dev=#<StringIO:0x0000000687d628>, @mon_owner=nil, @mon_count=0, @mon_mutex=#<Thread::Mutex:0x0000000687d538>>>, :keys=>["{PATH}/.vagrant/machines/aem/virtualbox/private_key"]}
DEBUG ssh: == Net-SSH connection debug-level log START ==
DEBUG ssh: D, [2017-07-11T21:48:41.046871 #6860] DEBUG -- net.ssh.transport.session[27ddc58]: establishing connection to 127.0.0.1:2222
D, [2017-07-11T21:48:41.047853 #6860] DEBUG -- net.ssh.transport.session[27ddc58]: connection established
I, [2017-07-11T21:48:41.047853 #6860]  INFO -- net.ssh.transport.server_version[27dce48]: negotiating protocol version
D, [2017-07-11T21:48:41.047853 #6860] DEBUG -- net.ssh.transport.server_version[27dce48]: local is `SSH-2.0-Ruby/Net::SSH_4.1.0 x64-mingw32'
D, [2017-07-11T21:48:41.059631 #6860] DEBUG -- net.ssh.transport.server_version[27dce48]: remote is `SSH-2.0-OpenSSH_6.6.1'
I, [2017-07-11T21:48:41.059631 #6860]  INFO -- net.ssh.transport.algorithms[3443efc]: sending KEXINIT
D, [2017-07-11T21:48:41.061607 #6860] DEBUG -- socket[27dd6e0]: queueing packet nr 0 type 20 len 1156
D, [2017-07-11T21:48:41.061607 #6860] DEBUG -- socket[27dd6e0]: sent 1160 bytes
D, [2017-07-11T21:48:41.063556 #6860] DEBUG -- socket[27dd6e0]: read 1640 bytes
D, [2017-07-11T21:48:41.063556 #6860] DEBUG -- socket[27dd6e0]: received packet nr 0 type 20 len 1636
I, [2017-07-11T21:48:41.063556 #6860]  INFO -- net.ssh.transport.algorithms[3443efc]: got KEXINIT from server
I, [2017-07-11T21:48:41.064536 #6860]  INFO -- net.ssh.transport.algorithms[3443efc]: negotiating algorithms
D, [2017-07-11T21:48:41.064536 #6860] DEBUG -- net.ssh.transport.algorithms[3443efc]: negotiated:
* kex: diffie-hellman-group-exchange-sha1
* host_key: ssh-rsa
* encryption_server: aes128-cbc
* encryption_client: aes128-cbc
* hmac_client: hmac-sha1
* hmac_server: hmac-sha1
* compression_client: none
* compression_server: none
* language_client:
* language_server:
D, [2017-07-11T21:48:41.064536 #6860] DEBUG -- net.ssh.transport.algorithms[3443efc]: exchanging keys
D, [2017-07-11T21:48:41.064536 #6860] DEBUG -- socket[27dd6e0]: queueing packet nr 1 type 34 len 20
D, [2017-07-11T21:48:41.064536 #6860] DEBUG -- socket[27dd6e0]: sent 24 bytes
D, [2017-07-11T21:48:41.075376 #6860] DEBUG -- socket[27dd6e0]: read 152 bytes
D, [2017-07-11T21:48:41.076325 #6860] DEBUG -- socket[27dd6e0]: received packet nr 1 type 31 len 148
D, [2017-07-11T21:48:41.077327 #6860] DEBUG -- socket[27dd6e0]: queueing packet nr 2 type 32 len 140
D, [2017-07-11T21:48:41.077327 #6860] DEBUG -- socket[27dd6e0]: sent 144 bytes
D, [2017-07-11T21:48:41.088698 #6860] DEBUG -- socket[27dd6e0]: read 720 bytes
D, [2017-07-11T21:48:41.088698 #6860] DEBUG -- socket[27dd6e0]: received packet nr 2 type 33 len 700
D, [2017-07-11T21:48:41.089698 #6860] DEBUG -- socket[27dd6e0]: queueing packet nr 3 type 21 len 20
D, [2017-07-11T21:48:41.089698 #6860] DEBUG -- socket[27dd6e0]: sent 24 bytes
D, [2017-07-11T21:48:41.089698 #6860] DEBUG -- socket[27dd6e0]: received packet nr 3 type 21 len 12
D, [2017-07-11T21:48:41.090162 #6860] DEBUG -- net.ssh.authentication.session[3468d74]: beginning authentication of `vagrant'
D, [2017-07-11T21:48:41.090162 #6860] DEBUG -- socket[27dd6e0]: queueing packet nr 4 type 5 len 28
D, [2017-07-11T21:48:41.090661 #6860] DEBUG -- socket[27dd6e0]: sent 52 bytes
D, [2017-07-11T21:48:41.101031 #6860] DEBUG -- socket[27dd6e0]: read 52 bytes
D, [2017-07-11T21:48:41.101186 #6860] DEBUG -- socket[27dd6e0]: received packet nr 4 type 6 len 28
D, [2017-07-11T21:48:41.101734 #6860] DEBUG -- net.ssh.authentication.session[3468d74]: trying none
D, [2017-07-11T21:48:41.101734 #6860] DEBUG -- socket[27dd6e0]: queueing packet nr 5 type 50 len 44
D, [2017-07-11T21:48:41.102202 #6860] DEBUG -- socket[27dd6e0]: sent 68 bytes
D, [2017-07-11T21:49:01.058284 #6860] DEBUG -- socket[27dd6e0]: read 84 bytes
D, [2017-07-11T21:49:01.058284 #6860] DEBUG -- socket[27dd6e0]: received packet nr 5 type 51 len 60
D, [2017-07-11T21:49:01.058284 #6860] DEBUG -- net.ssh.authentication.session[3468d74]: allowed methods: publickey,gssapi-keyex,gssapi-with-mic,password
D, [2017-07-11T21:49:01.058284 #6860] DEBUG -- net.ssh.authentication.methods.none[27bbd74]: none failed
D, [2017-07-11T21:49:01.058284 #6860] DEBUG -- net.ssh.authentication.session[3468d74]: trying publickey
D, [2017-07-11T21:49:01.059233 #6860] DEBUG -- net.ssh.authentication.agent[346d770]: connecting to ssh-agent
D, [2017-07-11T21:49:01.059233 #6860] DEBUG -- net.ssh.authentication.agent[346d770]: sending agent request 1 len 43
D, [2017-07-11T21:49:01.059233 #6860] DEBUG -- net.ssh.authentication.agent[346d770]: received agent packet 2 len 5
D, [2017-07-11T21:49:01.059233 #6860] DEBUG -- net.ssh.authentication.agent[346d770]: sending agent request 11 len 0
D, [2017-07-11T21:49:01.059233 #6860] DEBUG -- net.ssh.authentication.agent[346d770]: received agent packet 12 len 306
D, [2017-07-11T21:49:01.060214 #6860] DEBUG -- net.ssh.authentication.methods.publickey[346da54]: trying publickey (c4:cd:b6:43:ef:8d:27:8a:78:10:23:1a:b3:e0:f0:9e)
D, [2017-07-11T21:49:01.060214 #6860] DEBUG -- socket[27dd6e0]: queueing packet nr 6 type 50 len 348
D, [2017-07-11T21:49:01.060214 #6860] DEBUG -- socket[27dd6e0]: sent 372 bytes
D, [2017-07-11T21:49:01.071008 #6860] DEBUG -- socket[27dd6e0]: read 324 bytes
D, [2017-07-11T21:49:01.071008 #6860] DEBUG -- socket[27dd6e0]: received packet nr 6 type 60 len 300
D, [2017-07-11T21:49:01.071990 #6860] DEBUG -- socket[27dd6e0]: queueing packet nr 7 type 50 len 620
D, [2017-07-11T21:49:01.071990 #6860] DEBUG -- socket[27dd6e0]: sent 644 bytes
D, [2017-07-11T21:49:10.073922 #6860] DEBUG -- socket[27dd6e0]: read 36 bytes
D, [2017-07-11T21:49:10.073922 #6860] DEBUG -- socket[27dd6e0]: received packet nr 7 type 52 len 12
D, [2017-07-11T21:49:10.073922 #6860] DEBUG -- net.ssh.authentication.methods.publickey[346da54]: publickey succeeded (c4:cd:b6:43:ef:8d:27:8a:78:10:23:1a:b3:e0:f0:9e)

DEBUG ssh: == Net-SSH connection debug-level log END ==
 INFO ssh: Execute: grep 'ostree=' /proc/cmdline (sudo=false)
DEBUG ssh: Sending SSH keep-alive...
DEBUG ssh: Sending SSH keep-alive...
DEBUG ssh: Sending SSH keep-alive...
DEBUG ssh: Sending SSH keep-alive...
DEBUG ssh: stderr: 41e57d38-b4f7-4e46-9c38-13873d338b86-vagrant-ssh
DEBUG ssh: Exit status: 1
DEBUG guest: Trying: elementary
 INFO ssh: Connection errored, not re-using. Will reconnect.
DEBUG ssh: #<Timeout::Error: execution expired>
 INFO subprocess: Starting process: ["C:/Program Files/Oracle/VirtualBox/VBoxManage.exe", "showvminfo", "8fb5c87b-1a3c-435e-8660-4efac27fd04f", "--machinereadable"]
 INFO subprocess: Command not in installer, restoring original environment...
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: name="{CLIENT}"
groups="/"
ostype="Red Hat (64-bit)"
UUID="8fb5c87b-1a3c-435e-8660-4efac27fd04f"
CfgFile="{HOMEDIR}\\VirtualBox VMs\\{CLIENT}\\{CLIENT}.vbox"
SnapFldr="{HOMEDIR}\\VirtualBox VMs\\{CLIENT}\\Snapshots"
LogFldr="{HOMEDIR}\\VirtualBox VMs\\{CLIENT}\\Logs"
hardwareuuid="8fb5c87b-1a3c-435e-8660-4efac27fd04f"
memory=8192
pagefusion="off"
vram=8
cpuexecutioncap=90
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=2
pae="on"
longmode="on"
triplefaultreset="off"
apic="on"
x2apic="on"
cpuid-portability-level=0
bootmenu="messageandmenu"
boot1="disk"
boot2="dvd"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
biosapic="apic"
biossystemtimeoffset=0
rtcuseutc="on"
hwvirtex="on"
nestedpaging="on"
largepages="on"
vtxvpid="on"
vtxux="on"
paravirtprovider="default"
effparavirtprovider="kvm"
VMState="running"
VMStateChangeTime="2017-07-11T19:12:38.999000000"
monitorcount=1
accelerate3d="off"
accelerate2dvideo="off"
teleporterenabled="off"
teleporterport=0
teleporteraddress=""
teleporterpassword=""
tracing-enabled="off"
tracing-allow-vm-access="off"
tracing-config=""
autostart-enabled="off"
autostart-delay=0
defaultfrontend=""
storagecontrollername0="IDE Controller"
storagecontrollertype0="PIIX4"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="2"
storagecontrollerportcount0="2"
storagecontrollerbootable0="on"
"IDE Controller-0-0"="{HOMEDIR}\VirtualBox VMs\{CLIENT}\Snapshots\{d60e1cd8-b069-4de1-8be5-b0e345172bb5}.vmdk"
"IDE Controller-ImageUUID-0-0"="d60e1cd8-b069-4de1-8be5-b0e345172bb5"
"IDE Controller-0-1"="none"
"IDE Controller-1-0"="none"
"IDE Controller-1-1"="none"
natnet1="nat"
macaddress1="080027DB3827"
cableconnected1="on"
nic1="nat"
nictype1="82540EM"
nicspeed1="0"
mtu="0"
sockSnd="64"
sockRcv="64"
tcpWndSnd="64"
tcpWndRcv="64"
Forwarding(0)="ssh,tcp,127.0.0.1,2222,,22"
Forwarding(1)="tcp4502,tcp,,4502,,4502"
Forwarding(2)="tcp4503,tcp,,4503,,4503"
Forwarding(3)="tcp4512,tcp,,4512,,4512"
Forwarding(4)="tcp4513,tcp,,4513,,4513"
Forwarding(5)="tcp4592,tcp,,4592,,4592"
Forwarding(6)="tcp4593,tcp,,4593,,4593"
Forwarding(7)="tcp80,tcp,,80,,80"
hostonlyadapter2="VirtualBox Host-Only Ethernet Adapter #2"
macaddress2="080027E33CE9"
cableconnected2="on"
nic2="hostonly"
nictype2="82540EM"
nicspeed2="0"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
uart3="off"
uart4="off"
lpt1="off"
lpt2="off"
audio="dsound"
clipboard="disabled"
draganddrop="disabled"
SessionName="GUI/Qt"
VideoMode="720,400,0"@0,0 1
vrde="on"
vrdeport=-1
vrdeports="5993"
vrdeaddress="127.0.0.1"
vrdeauthtype="null"
vrdemulticon="off"
vrdereusecon="off"
vrdevideochannel="off"
usb="off"
ehci="off"
xhci="off"
SharedFolderNameMachineMapping1="opt_install_files_.m2"
SharedFolderPathMachineMapping1="\\?\{PATH}\.m2"
SharedFolderNameMachineMapping2="vagrant"
SharedFolderPathMachineMapping2="\\?\{PATH}"
SharedFolderNameMachineMapping3="tmp_vagrant-puppet_manifests-c42ae094895da5204ae8ca79060e21be"
SharedFolderPathMachineMapping3="\\?\{PATH}\{cl}\manifests"
SharedFolderNameMachineMapping4="tmp_vagrant-puppet_modules-8aacd06f3b51f2d5a279df0bc5bad14c"
SharedFolderPathMachineMapping4="\\?\{PATH}\aem\modules"
SharedFolderNameMachineMapping5="tmp_vagrant-puppet_modules-314ccd1cdb56ec0df1fdca485ce2b133"
SharedFolderPathMachineMapping5="\\?\{PATH}\{co}\modules"
SharedFolderNameMachineMapping6="tmp_vagrant-puppet_modules-d67d2193e39b036974d2702de8a29251"
SharedFolderPathMachineMapping6="\\?\{PATH}\{cl}\modules"
VRDEActiveConnection="off"
VRDEClients=0
vcpenabled="off"
vcpscreens=0
vcpfile="{HOMEDIR}\VirtualBox VMs\{CLIENT}\{CLIENT}.webm"
vcpwidth=1024
vcpheight=768
vcprate=512
vcpfps=25
GuestMemoryBalloon=0
GuestOSType="Linux26_64"
GuestAdditionsRunLevel=2
GuestAdditionsVersion="5.1.22 r115126"
GuestAdditionsFacility_VirtualBox Base Driver=50,1499800369660
GuestAdditionsFacility_VirtualBox System Service=50,1499800371231
GuestAdditionsFacility_Seamless Mode=0,1499800369659
GuestAdditionsFacility_Graphics Mode=0,1499800369659
SnapshotName="provisioned"
SnapshotUUID="be827bcf-71a0-4fb1-902d-7e5e9db7f626"
SnapshotName-1="up-working"
SnapshotUUID-1="9185f063-c82b-4b37-a591-f64ab8fee94f"
CurrentSnapshotName="up-working"
CurrentSnapshotUUID="9185f063-c82b-4b37-a591-f64ab8fee94f"
CurrentSnapshotNode="SnapshotName-1"
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 31999
DEBUG subprocess: Exit status: 0
DEBUG virtualbox_5_1: Searching for SSH port: 22
DEBUG virtualbox_5_1: read_forward_ports: uuid=8fb5c87b-1a3c-435e-8660-4efac27fd04f active_only=false
 INFO subprocess: Starting process: ["C:/Program Files/Oracle/VirtualBox/VBoxManage.exe", "showvminfo", "8fb5c87b-1a3c-435e-8660-4efac27fd04f", "--machinereadable"]
 INFO subprocess: Command not in installer, restoring original environment...
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: name="{CLIENT}"
groups="/"
ostype="Red Hat (64-bit)"
UUID="8fb5c87b-1a3c-435e-8660-4efac27fd04f"
CfgFile="{HOMEDIR}\\VirtualBox VMs\\{CLIENT}\\{CLIENT}.vbox"
SnapFldr="{HOMEDIR}\\VirtualBox VMs\\{CLIENT}\\Snapshots"
LogFldr="{HOMEDIR}\\VirtualBox VMs\\{CLIENT}\\Logs"
hardwareuuid="8fb5c87b-1a3c-435e-8660-4efac27fd04f"
memory=8192
pagefusion="off"
vram=8
cpuexecutioncap=90
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=2
pae="on"
longmode="on"
triplefaultreset="off"
apic="on"
x2apic="on"
cpuid-portability-level=0
bootmenu="messageandmenu"
boot1="disk"
boot2="dvd"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
biosapic="apic"
biossystemtimeoffset=0
rtcuseutc="on"
hwvirtex="on"
nestedpaging="on"
largepages="on"
vtxvpid="on"
vtxux="on"
paravirtprovider="default"
effparavirtprovider="kvm"
VMState="running"
VMStateChangeTime="2017-07-11T19:12:38.999000000"
monitorcount=1
accelerate3d="off"
accelerate2dvideo="off"
teleporterenabled="off"
teleporterport=0
teleporteraddress=""
teleporterpassword=""
tracing-enabled="off"
tracing-allow-vm-access="off"
tracing-config=""
autostart-enabled="off"
autostart-delay=0
defaultfrontend=""
storagecontrollername0="IDE Controller"
storagecontrollertype0="PIIX4"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="2"
storagecontrollerportcount0="2"
storagecontrollerbootable0="on"
"IDE Controller-0-0"="{HOMEDIR}\VirtualBox VMs\{CLIENT}\Snapshots\{d60e1cd8-b069-4de1-8be5-b0e345172bb5}.vmdk"
"IDE Controller-ImageUUID-0-0"="d60e1cd8-b069-4de1-8be5-b0e345172bb5"
"IDE Controller-0-1"="none"
"IDE Controller-1-0"="none"
"IDE Controller-1-1"="none"
natnet1="nat"
macaddress1="080027DB3827"
cableconnected1="on"
nic1="nat"
nictype1="82540EM"
nicspeed1="0"
mtu="0"
sockSnd="64"
sockRcv="64"
tcpWndSnd="64"
tcpWndRcv="64"
Forwarding(0)="ssh,tcp,127.0.0.1,2222,,22"
Forwarding(1)="tcp4502,tcp,,4502,,4502"
Forwarding(2)="tcp4503,tcp,,4503,,4503"
Forwarding(3)="tcp4512,tcp,,4512,,4512"
Forwarding(4)="tcp4513,tcp,,4513,,4513"
Forwarding(5)="tcp4592,tcp,,4592,,4592"
Forwarding(6)="tcp4593,tcp,,4593,,4593"
Forwarding(7)="tcp80,tcp,,80,,80"
hostonlyadapter2="VirtualBox Host-Only Ethernet Adapter #2"
macaddress2="080027E33CE9"
cableconnected2="on"
nic2="hostonly"
nictype2="82540EM"
nicspeed2="0"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
uart3="off"
uart4="off"
lpt1="off"
lpt2="off"
audio="dsound"
clipboard="disabled"
draganddrop="disabled"
SessionName="GUI/Qt"
VideoMode="720,400,0"@0,0 1
vrde="on"
vrdeport=-1
vrdeports="5993"
vrdeaddress="127.0.0.1"
vrdeauthtype="null"
vrdemulticon="off"
vrdereusecon="off"
vrdevideochannel="off"
usb="off"
ehci="off"
xhci="off"
SharedFolderNameMachineMapping1="opt_install_files_.m2"
SharedFolderPathMachineMapping1="\\?\{PATH}\.m2"
SharedFolderNameMachineMapping2="vagrant"
SharedFolderPathMachineMapping2="\\?\{PATH}"
SharedFolderNameMachineMapping3="tmp_vagrant-puppet_manifests-c42ae094895da5204ae8ca79060e21be"
SharedFolderPathMachineMapping3="\\?\{PATH}\{cl}\manifests"
SharedFolderNameMachineMapping4="tmp_vagrant-puppet_modules-8aacd06f3b51f2d5a279df0bc5bad14c"
SharedFolderPathMachineMapping4="\\?\{PATH}\aem\modules"
SharedFolderNameMachineMapping5="tmp_vagrant-puppet_modules-314ccd1cdb56ec0df1fdca485ce2b133"
SharedFolderPathMachineMapping5="\\?\{PATH}\{co}\modules"
SharedFolderNameMachineMapping6="tmp_vagrant-puppet_modules-d67d2193e39b036974d2702de8a29251"
SharedFolderPathMachineMapping6="\\?\{PATH}\{cl}\modules"
VRDEActiveConnection="off"
VRDEClients=0
vcpenabled="off"
vcpscreens=0
vcpfile="{HOMEDIR}\VirtualBox VMs\{CLIENT}\{CLIENT}.webm"
vcpwidth=1024
vcpheight=768
vcprate=512
vcpfps=25
GuestMemoryBalloon=0
GuestOSType="Linux26_64"
GuestAdditionsRunLevel=2
GuestAdditionsVersion="5.1.22 r115126"
GuestAdditionsFacility_VirtualBox Base Driver=50,1499800369660
GuestAdditionsFacility_VirtualBox System Service=50,1499800371231
GuestAdditionsFacility_Seamless Mode=0,1499800369659
GuestAdditionsFacility_Graphics Mode=0,1499800369659
SnapshotName="provisioned"
SnapshotUUID="be827bcf-71a0-4fb1-902d-7e5e9db7f626"
SnapshotName-1="up-working"
SnapshotUUID-1="9185f063-c82b-4b37-a591-f64ab8fee94f"
CurrentSnapshotName="up-working"
CurrentSnapshotUUID="9185f063-c82b-4b37-a591-f64ab8fee94f"
CurrentSnapshotNode="SnapshotName-1"
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 31999
DEBUG subprocess: Exit status: 0
DEBUG virtualbox_5_1:   - [1, "ssh", 2222, 22, "127.0.0.1"]
DEBUG virtualbox_5_1:   - [1, "tcp4502", 4502, 4502, ""]
DEBUG virtualbox_5_1:   - [1, "tcp4503", 4503, 4503, ""]
DEBUG virtualbox_5_1:   - [1, "tcp4512", 4512, 4512, ""]
DEBUG virtualbox_5_1:   - [1, "tcp4513", 4513, 4513, ""]
DEBUG virtualbox_5_1:   - [1, "tcp4592", 4592, 4592, ""]
DEBUG virtualbox_5_1:   - [1, "tcp4593", 4593, 4593, ""]
DEBUG virtualbox_5_1:   - [1, "tcp80", 80, 80, ""]
 INFO ssh: Attempting SSH connection...
 INFO ssh: Attempting to connect to SSH...
 INFO ssh:   - Host: 127.0.0.1
 INFO ssh:   - Port: 2222
 INFO ssh:   - Username: vagrant
 INFO ssh:   - Password? false
 INFO ssh:   - Key Path: ["{PATH}/.vagrant/machines/aem/virtualbox/private_key"]
DEBUG ssh:   - connect_opts: {:auth_methods=>["none", "hostbased", "publickey"], :config=>false, :forward_agent=>false, :send_env=>false, :keys_only=>true, :paranoid=>false, :password=>nil, :port=>2222, :timeout=>15, :user_known_hosts_file=>[], :verbose=>:debug, :encryption=>["aes128-cbc", "3des-cbc", "blowfish-cbc", "cast128-cbc", "aes192-cbc", "aes256-cbc", "[email protected]", "idea-cbc", "arcfour128", "arcfour256", "arcfour", "aes128-ctr", "aes192-ctr", "aes256-ctr", "cast128-ctr", "blowfish-ctr", "3des-ctr", "none"], :logger=>#<Logger:0x00000006a970f8 @progname=nil, @level=0, @default_formatter=#<Logger::Formatter:0x00000006a970d0 @datetime_format=nil>, @formatter=nil, @logdev=#<Logger::LogDevice:0x00000006a97080 @shift_size=nil, @shift_age=nil, @filename=nil, @dev=#<StringIO:0x00000006a97148>, @mon_owner=nil, @mon_count=0, @mon_mutex=#<Thread::Mutex:0x00000006a97058>>>, :keys=>["{PATH}/.vagrant/machines/aem/virtualbox/private_key"]}
DEBUG ssh: == Net-SSH connection debug-level log START ==
DEBUG ssh: D, [2017-07-11T21:49:37.745479 #6860] DEBUG -- net.ssh.transport.session[354abe8]: establishing connection to 127.0.0.1:2222
D, [2017-07-11T21:49:37.747448 #6860] DEBUG -- net.ssh.transport.session[354abe8]: connection established
I, [2017-07-11T21:49:37.747448 #6860]  INFO -- net.ssh.transport.server_version[354a4f4]: negotiating protocol version
D, [2017-07-11T21:49:37.747448 #6860] DEBUG -- net.ssh.transport.server_version[354a4f4]: local is `SSH-2.0-Ruby/Net::SSH_4.1.0 x64-mingw32'
D, [2017-07-11T21:49:37.759216 #6860] DEBUG -- net.ssh.transport.server_version[354a4f4]: remote is `SSH-2.0-OpenSSH_6.6.1'
I, [2017-07-11T21:49:37.759216 #6860]  INFO -- net.ssh.transport.algorithms[27240dc]: sending KEXINIT
D, [2017-07-11T21:49:37.759216 #6860] DEBUG -- socket[354a954]: queueing packet nr 0 type 20 len 1156
D, [2017-07-11T21:49:37.759216 #6860] DEBUG -- socket[354a954]: sent 1160 bytes
D, [2017-07-11T21:49:37.768552 #6860] DEBUG -- socket[354a954]: read 1640 bytes
D, [2017-07-11T21:49:37.769061 #6860] DEBUG -- socket[354a954]: received packet nr 0 type 20 len 1636
I, [2017-07-11T21:49:37.769061 #6860]  INFO -- net.ssh.transport.algorithms[27240dc]: got KEXINIT from server
I, [2017-07-11T21:49:37.769061 #6860]  INFO -- net.ssh.transport.algorithms[27240dc]: negotiating algorithms
D, [2017-07-11T21:49:37.769061 #6860] DEBUG -- net.ssh.transport.algorithms[27240dc]: negotiated:
* kex: diffie-hellman-group-exchange-sha1
* host_key: ssh-rsa
* encryption_server: aes128-cbc
* encryption_client: aes128-cbc
* hmac_client: hmac-sha1
* hmac_server: hmac-sha1
* compression_client: none
* compression_server: none
* language_client:
* language_server:
D, [2017-07-11T21:49:37.769061 #6860] DEBUG -- net.ssh.transport.algorithms[27240dc]: exchanging keys
D, [2017-07-11T21:49:37.769555 #6860] DEBUG -- socket[354a954]: queueing packet nr 1 type 34 len 20
D, [2017-07-11T21:49:37.769555 #6860] DEBUG -- socket[354a954]: sent 24 bytes
D, [2017-07-11T21:49:37.780118 #6860] DEBUG -- socket[354a954]: read 152 bytes
D, [2017-07-11T21:49:37.780118 #6860] DEBUG -- socket[354a954]: received packet nr 1 type 31 len 148
D, [2017-07-11T21:49:37.781111 #6860] DEBUG -- socket[354a954]: queueing packet nr 2 type 32 len 140
D, [2017-07-11T21:49:37.781587 #6860] DEBUG -- socket[354a954]: sent 144 bytes
D, [2017-07-11T21:49:37.792022 #6860] DEBUG -- socket[354a954]: read 720 bytes
D, [2017-07-11T21:49:37.792022 #6860] DEBUG -- socket[354a954]: received packet nr 2 type 33 len 700
D, [2017-07-11T21:49:37.792961 #6860] DEBUG -- socket[354a954]: queueing packet nr 3 type 21 len 20
D, [2017-07-11T21:49:37.792961 #6860] DEBUG -- socket[354a954]: sent 24 bytes
D, [2017-07-11T21:49:37.792961 #6860] DEBUG -- socket[354a954]: received packet nr 3 type 21 len 12
D, [2017-07-11T21:49:37.792961 #6860] DEBUG -- net.ssh.authentication.session[358ce58]: beginning authentication of `vagrant'
D, [2017-07-11T21:49:37.792961 #6860] DEBUG -- socket[354a954]: queueing packet nr 4 type 5 len 28
D, [2017-07-11T21:49:37.793943 #6860] DEBUG -- socket[354a954]: sent 52 bytes
D, [2017-07-11T21:49:37.804780 #6860] DEBUG -- socket[354a954]: read 52 bytes
D, [2017-07-11T21:49:37.804780 #6860] DEBUG -- socket[354a954]: received packet nr 4 type 6 len 28
D, [2017-07-11T21:49:37.804780 #6860] DEBUG -- net.ssh.authentication.session[358ce58]: trying none
D, [2017-07-11T21:49:37.804780 #6860] DEBUG -- socket[354a954]: queueing packet nr 5 type 50 len 44
D, [2017-07-11T21:49:37.805718 #6860] DEBUG -- socket[354a954]: sent 68 bytes
D, [2017-07-11T21:49:59.895205 #6860] DEBUG -- socket[354a954]: read 84 bytes
D, [2017-07-11T21:49:59.895205 #6860] DEBUG -- socket[354a954]: received packet nr 5 type 51 len 60
D, [2017-07-11T21:49:59.895205 #6860] DEBUG -- net.ssh.authentication.session[358ce58]: allowed methods: publickey,gssapi-keyex,gssapi-with-mic,password
D, [2017-07-11T21:49:59.895205 #6860] DEBUG -- net.ssh.authentication.methods.none[26ddd58]: none failed
D, [2017-07-11T21:49:59.895205 #6860] DEBUG -- net.ssh.authentication.session[358ce58]: trying publickey
D, [2017-07-11T21:49:59.896186 #6860] DEBUG -- net.ssh.authentication.agent[3592f9c]: connecting to ssh-agent
D, [2017-07-11T21:49:59.896186 #6860] DEBUG -- net.ssh.authentication.agent[3592f9c]: sending agent request 1 len 43
D, [2017-07-11T21:49:59.897203 #6860] DEBUG -- net.ssh.authentication.agent[3592f9c]: received agent packet 2 len 5
D, [2017-07-11T21:49:59.897203 #6860] DEBUG -- net.ssh.authentication.agent[3592f9c]: sending agent request 11 len 0
D, [2017-07-11T21:49:59.898148 #6860] DEBUG -- net.ssh.authentication.agent[3592f9c]: received agent packet 12 len 306
D, [2017-07-11T21:49:59.898148 #6860] DEBUG -- net.ssh.authentication.methods.publickey[3593280]: trying publickey (c4:cd:b6:43:ef:8d:27:8a:78:10:23:1a:b3:e0:f0:9e)
D, [2017-07-11T21:49:59.898652 #6860] DEBUG -- socket[354a954]: queueing packet nr 6 type 50 len 348
D, [2017-07-11T21:49:59.898652 #6860] DEBUG -- socket[354a954]: sent 372 bytes
D, [2017-07-11T21:49:59.910191 #6860] DEBUG -- socket[354a954]: read 324 bytes
D, [2017-07-11T21:49:59.910191 #6860] DEBUG -- socket[354a954]: received packet nr 6 type 60 len 300
D, [2017-07-11T21:49:59.911686 #6860] DEBUG -- socket[354a954]: queueing packet nr 7 type 50 len 620
D, [2017-07-11T21:49:59.912204 #6860] DEBUG -- socket[354a954]: sent 644 bytes
D, [2017-07-11T21:50:08.907706 #6860] DEBUG -- socket[354a954]: read 36 bytes
D, [2017-07-11T21:50:08.907706 #6860] DEBUG -- socket[354a954]: received packet nr 7 type 52 len 12
D, [2017-07-11T21:50:08.908206 #6860] DEBUG -- net.ssh.authentication.methods.publickey[3593280]: publickey succeeded (c4:cd:b6:43:ef:8d:27:8a:78:10:23:1a:b3:e0:f0:9e)

DEBUG ssh: == Net-SSH connection debug-level log END ==
 INFO ssh: Execute: if test -r /etc/os-release; then
source /etc/os-release && test 'xelementary' = "x$ID" && exit
fi
if test -x /usr/bin/lsb_release; then
/usr/bin/lsb_release -i 2>/dev/null | grep -qi 'elementary' && exit
fi
if test -r /etc/issue; then
cat /etc/issue | grep -qi 'elementary' && exit
fi
exit 1
 (sudo=false)
DEBUG ssh: Sending SSH keep-alive...
DEBUG ssh: Sending SSH keep-alive...
DEBUG ssh: Sending SSH keep-alive...
DEBUG ssh: Sending SSH keep-alive...
DEBUG ssh: stderr: 41e57d38-b4f7-4e46-9c38-13873d338b86-vagrant-ssh
DEBUG ssh: Exit status: 1
DEBUG guest: Trying: mint
 INFO ssh: Connection errored, not re-using. Will reconnect.
DEBUG ssh: #<Timeout::Error: execution expired>
 INFO subprocess: Starting process: ["C:/Program Files/Oracle/VirtualBox/VBoxManage.exe", "showvminfo", "8fb5c87b-1a3c-435e-8660-4efac27fd04f", "--machinereadable"]
 INFO subprocess: Command not in installer, restoring original environment...
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: name="{CLIENT}"
groups="/"
ostype="Red Hat (64-bit)"
UUID="8fb5c87b-1a3c-435e-8660-4efac27fd04f"
CfgFile="{HOMEDIR}\\VirtualBox VMs\\{CLIENT}\\{CLIENT}.vbox"
SnapFldr="{HOMEDIR}\\VirtualBox VMs\\{CLIENT}\\Snapshots"
LogFldr="{HOMEDIR}\\VirtualBox VMs\\{CLIENT}\\Logs"
hardwareuuid="8fb5c87b-1a3c-435e-8660-4efac27fd04f"
memory=8192
pagefusion="off"
vram=8
cpuexecutioncap=90
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=2
pae="on"
longmode="on"
triplefaultreset="off"
apic="on"
x2apic="on"
cpuid-portability-level=0
bootmenu="messageandmenu"
boot1="disk"
boot2="dvd"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
biosapic="apic"
biossystemtimeoffset=0
rtcuseutc="on"
hwvirtex="on"
nestedpaging="on"
largepages="on"
vtxvpid="on"
vtxux="on"
paravirtprovider="default"
effparavirtprovider="kvm"
VMState="running"
VMStateChangeTime="2017-07-11T19:12:38.999000000"
monitorcount=1
accelerate3d="off"
accelerate2dvideo="off"
teleporterenabled="off"
teleporterport=0
teleporteraddress=""
teleporterpassword=""
tracing-enabled="off"
tracing-allow-vm-access="off"
tracing-config=""
autostart-enabled="off"
autostart-delay=0
defaultfrontend=""
storagecontrollername0="IDE Controller"
storagecontrollertype0="PIIX4"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="2"
storagecontrollerportcount0="2"
storagecontrollerbootable0="on"
"IDE Controller-0-0"="{HOMEDIR}\VirtualBox VMs\{CLIENT}\Snapshots\{d60e1cd8-b069-4de1-8be5-b0e345172bb5}.vmdk"
"IDE Controller-ImageUUID-0-0"="d60e1cd8-b069-4de1-8be5-b0e345172bb5"
"IDE Controller-0-1"="none"
"IDE Controller-1-0"="none"
"IDE Controller-1-1"="none"
natnet1="nat"
macaddress1="080027DB3827"
cableconnected1="on"
nic1="nat"
nictype1="82540EM"
nicspeed1="0"
mtu="0"
sockSnd="64"
sockRcv="64"
tcpWndSnd="64"
tcpWndRcv="64"
Forwarding(0)="ssh,tcp,127.0.0.1,2222,,22"
Forwarding(1)="tcp4502,tcp,,4502,,4502"
Forwarding(2)="tcp4503,tcp,,4503,,4503"
Forwarding(3)="tcp4512,tcp,,4512,,4512"
Forwarding(4)="tcp4513,tcp,,4513,,4513"
Forwarding(5)="tcp4592,tcp,,4592,,4592"
Forwarding(6)="tcp4593,tcp,,4593,,4593"
Forwarding(7)="tcp80,tcp,,80,,80"
hostonlyadapter2="VirtualBox Host-Only Ethernet Adapter #2"
macaddress2="080027E33CE9"
cableconnected2="on"
nic2="hostonly"
nictype2="82540EM"
nicspeed2="0"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
uart3="off"
uart4="off"
lpt1="off"
lpt2="off"
audio="dsound"
clipboard="disabled"
draganddrop="disabled"
SessionName="GUI/Qt"
VideoMode="720,400,0"@0,0 1
vrde="on"
vrdeport=-1
vrdeports="5993"
vrdeaddress="127.0.0.1"
vrdeauthtype="null"
vrdemulticon="off"
vrdereusecon="off"
vrdevideochannel="off"
usb="off"
ehci="off"
xhci="off"
SharedFolderNameMachineMapping1="opt_install_files_.m2"
SharedFolderPathMachineMapping1="\\?\{PATH}\.m2"
SharedFolderNameMachineMapping2="vagrant"
SharedFolderPathMachineMapping2="\\?\{PATH}"
SharedFolderNameMachineMapping3="tmp_vagrant-puppet_manifests-c42ae094895da5204ae8ca79060e21be"
SharedFolderPathMachineMapping3="\\?\{PATH}\{cl}\manifests"
SharedFolderNameMachineMapping4="tmp_vagrant-puppet_modules-8aacd06f3b51f2d5a279df0bc5bad14c"
SharedFolderPathMachineMapping4="\\?\{PATH}\aem\modules"
SharedFolderNameMachineMapping5="tmp_vagrant-puppet_modules-314ccd1cdb56ec0df1fdca485ce2b133"
SharedFolderPathMachineMapping5="\\?\{PATH}\{co}\modules"
SharedFolderNameMachineMapping6="tmp_vagrant-puppet_modules-d67d2193e39b036974d2702de8a29251"
SharedFolderPathMachineMapping6="\\?\{PATH}\{cl}\modules"
VRDEActiveConnection="off"
VRDEClients=0
vcpenabled="off"
vcpscreens=0
vcpfile="{HOMEDIR}\VirtualBox VMs\{CLIENT}\{CLIENT}.webm"
vcpwidth=1024
vcpheight=768
vcprate=512
vcpfps=25
GuestMemoryBalloon=0
GuestOSType="Linux26_64"
GuestAdditionsRunLevel=2
GuestAdditionsVersion="5.1.22 r115126"
GuestAdditionsFacility_VirtualBox Base Driver=50,1499800369660
GuestAdditionsFacility_VirtualBox System Service=50,1499800371231
GuestAdditionsFacility_Seamless Mode=0,1499800369659
GuestAdditionsFacility_Graphics Mode=0,1499800369659
SnapshotName="provisioned"
SnapshotUUID="be827bcf-71a0-4fb1-902d-7e5e9db7f626"
SnapshotName-1="up-working"
SnapshotUUID-1="9185f063-c82b-4b37-a591-f64ab8fee94f"
CurrentSnapshotName="up-working"
CurrentSnapshotUUID="9185f063-c82b-4b37-a591-f64ab8fee94f"
CurrentSnapshotNode="SnapshotName-1"
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 31999
DEBUG subprocess: Exit status: 0
DEBUG virtualbox_5_1: Searching for SSH port: 22
DEBUG virtualbox_5_1: read_forward_ports: uuid=8fb5c87b-1a3c-435e-8660-4efac27fd04f active_only=false
 INFO subprocess: Starting process: ["C:/Program Files/Oracle/VirtualBox/VBoxManage.exe", "showvminfo", "8fb5c87b-1a3c-435e-8660-4efac27fd04f", "--machinereadable"]
 INFO subprocess: Command not in installer, restoring original environment...
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: name="{CLIENT}"
groups="/"
ostype="Red Hat (64-bit)"
UUID="8fb5c87b-1a3c-435e-8660-4efac27fd04f"
CfgFile="{HOMEDIR}\\VirtualBox VMs\\{CLIENT}\\{CLIENT}.vbox"
SnapFldr="{HOMEDIR}\\VirtualBox VMs\\{CLIENT}\\Snapshots"
LogFldr="{HOMEDIR}\\VirtualBox VMs\\{CLIENT}\\Logs"
hardwareuuid="8fb5c87b-1a3c-435e-8660-4efac27fd04f"
memory=8192
pagefusion="off"
vram=8
cpuexecutioncap=90
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=2
pae="on"
longmode="on"
triplefaultreset="off"
apic="on"
x2apic="on"
cpuid-portability-level=0
bootmenu="messageandmenu"
boot1="disk"
boot2="dvd"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
biosapic="apic"
biossystemtimeoffset=0
rtcuseutc="on"
hwvirtex="on"
nestedpaging="on"
largepages="on"
vtxvpid="on"
vtxux="on"
paravirtprovider="default"
effparavirtprovider="kvm"
VMState="running"
VMStateChangeTime="2017-07-11T19:12:38.999000000"
monitorcount=1
accelerate3d="off"
accelerate2dvideo="off"
teleporterenabled="off"
teleporterport=0
teleporteraddress=""
teleporterpassword=""
tracing-enabled="off"
tracing-allow-vm-access="off"
tracing-config=""
autostart-enabled="off"
autostart-delay=0
defaultfrontend=""
storagecontrollername0="IDE Controller"
storagecontrollertype0="PIIX4"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="2"
storagecontrollerportcount0="2"
storagecontrollerbootable0="on"
"IDE Controller-0-0"="{HOMEDIR}\VirtualBox VMs\{CLIENT}\Snapshots\{d60e1cd8-b069-4de1-8be5-b0e345172bb5}.vmdk"
"IDE Controller-ImageUUID-0-0"="d60e1cd8-b069-4de1-8be5-b0e345172bb5"
"IDE Controller-0-1"="none"
"IDE Controller-1-0"="none"
"IDE Controller-1-1"="none"
natnet1="nat"
macaddress1="080027DB3827"
cableconnected1="on"
nic1="nat"
nictype1="82540EM"
nicspeed1="0"
mtu="0"
sockSnd="64"
sockRcv="64"
tcpWndSnd="64"
tcpWndRcv="64"
Forwarding(0)="ssh,tcp,127.0.0.1,2222,,22"
Forwarding(1)="tcp4502,tcp,,4502,,4502"
Forwarding(2)="tcp4503,tcp,,4503,,4503"
Forwarding(3)="tcp4512,tcp,,4512,,4512"
Forwarding(4)="tcp4513,tcp,,4513,,4513"
Forwarding(5)="tcp4592,tcp,,4592,,4592"
Forwarding(6)="tcp4593,tcp,,4593,,4593"
Forwarding(7)="tcp80,tcp,,80,,80"
hostonlyadapter2="VirtualBox Host-Only Ethernet Adapter #2"
macaddress2="080027E33CE9"
cableconnected2="on"
nic2="hostonly"
nictype2="82540EM"
nicspeed2="0"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
uart3="off"
uart4="off"
lpt1="off"
lpt2="off"
audio="dsound"
clipboard="disabled"
draganddrop="disabled"
SessionName="GUI/Qt"
VideoMode="720,400,0"@0,0 1
vrde="on"
vrdeport=-1
vrdeports="5993"
vrdeaddress="127.0.0.1"
vrdeauthtype="null"
vrdemulticon="off"
vrdereusecon="off"
vrdevideochannel="off"
usb="off"
ehci="off"
xhci="off"
SharedFolderNameMachineMapping1="opt_install_files_.m2"
SharedFolderPathMachineMapping1="\\?\{PATH}\.m2"
SharedFolderNameMachineMapping2="vagrant"
SharedFolderPathMachineMapping2="\\?\{PATH}"
SharedFolderNameMachineMapping3="tmp_vagrant-puppet_manifests-c42ae094895da5204ae8ca79060e21be"
SharedFolderPathMachineMapping3="\\?\{PATH}\{cl}\manifests"
SharedFolderNameMachineMapping4="tmp_vagrant-puppet_modules-8aacd06f3b51f2d5a279df0bc5bad14c"
SharedFolderPathMachineMapping4="\\?\{PATH}\aem\modules"
SharedFolderNameMachineMapping5="tmp_vagrant-puppet_modules-314ccd1cdb56ec0df1fdca485ce2b133"
SharedFolderPathMachineMapping5="\\?\{PATH}\{co}\modules"
SharedFolderNameMachineMapping6="tmp_vagrant-puppet_modules-d67d2193e39b036974d2702de8a29251"
SharedFolderPathMachineMapping6="\\?\{PATH}\{cl}\modules"
VRDEActiveConnection="off"
VRDEClients=0
vcpenabled="off"
vcpscreens=0
vcpfile="{HOMEDIR}\VirtualBox VMs\{CLIENT}\{CLIENT}.webm"
vcpwidth=1024
vcpheight=768
vcprate=512
vcpfps=25
GuestMemoryBalloon=0
GuestOSType="Linux26_64"
GuestAdditionsRunLevel=2
GuestAdditionsVersion="5.1.22 r115126"
GuestAdditionsFacility_VirtualBox Base Driver=50,1499800369660
GuestAdditionsFacility_VirtualBox System Service=50,1499800371231
GuestAdditionsFacility_Seamless Mode=0,1499800369659
GuestAdditionsFacility_Graphics Mode=0,1499800369659
SnapshotName="provisioned"
SnapshotUUID="be827bcf-71a0-4fb1-902d-7e5e9db7f626"
SnapshotName-1="up-working"
SnapshotUUID-1="9185f063-c82b-4b37-a591-f64ab8fee94f"
CurrentSnapshotName="up-working"
CurrentSnapshotUUID="9185f063-c82b-4b37-a591-f64ab8fee94f"
CurrentSnapshotNode="SnapshotName-1"
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 31999
DEBUG subprocess: Exit status: 0
DEBUG virtualbox_5_1:   - [1, "ssh", 2222, 22, "127.0.0.1"]
DEBUG virtualbox_5_1:   - [1, "tcp4502", 4502, 4502, ""]
DEBUG virtualbox_5_1:   - [1, "tcp4503", 4503, 4503, ""]
DEBUG virtualbox_5_1:   - [1, "tcp4512", 4512, 4512, ""]
DEBUG virtualbox_5_1:   - [1, "tcp4513", 4513, 4513, ""]
DEBUG virtualbox_5_1:   - [1, "tcp4592", 4592, 4592, ""]
DEBUG virtualbox_5_1:   - [1, "tcp4593", 4593, 4593, ""]
DEBUG virtualbox_5_1:   - [1, "tcp80", 80, 80, ""]
 INFO ssh: Attempting SSH connection...
 INFO ssh: Attempting to connect to SSH...
 INFO ssh:   - Host: 127.0.0.1
 INFO ssh:   - Port: 2222
 INFO ssh:   - Username: vagrant
 INFO ssh:   - Password? false
 INFO ssh:   - Key Path: ["{PATH}/.vagrant/machines/aem/virtualbox/private_key"]
DEBUG ssh:   - connect_opts: {:auth_methods=>["none", "hostbased", "publickey"], :config=>false, :forward_agent=>false, :send_env=>false, :keys_only=>true, :paranoid=>false, :password=>nil, :port=>2222, :timeout=>15, :user_known_hosts_file=>[], :verbose=>:debug, :encryption=>["aes128-cbc", "3des-cbc", "blowfish-cbc", "cast128-cbc", "aes192-cbc", "aes256-cbc", "[email protected]", "idea-cbc", "arcfour128", "arcfour256", "arcfour", "aes128-ctr", "aes192-ctr", "aes256-ctr", "cast128-ctr", "blowfish-ctr", "3des-ctr", "none"], :logger=>#<Logger:0x00000006d33280 @progname=nil, @level=0, @default_formatter=#<Logger::Formatter:0x00000006d33258 @datetime_format=nil>, @formatter=nil, @logdev=#<Logger::LogDevice:0x00000006d33208 @shift_size=nil, @shift_age=nil, @filename=nil, @dev=#<StringIO:0x00000006d332d0>, @mon_owner=nil, @mon_count=0, @mon_mutex=#<Thread::Mutex:0x00000006d331e0>>>, :keys=>["{PATH}/.vagrant/machines/aem/virtualbox/private_key"]}
DEBUG ssh: == Net-SSH connection debug-level log START ==
DEBUG ssh: D, [2017-07-11T21:50:36.588238 #6860] DEBUG -- net.ssh.transport.session[3698cac]: establishing connection to 127.0.0.1:2222
D, [2017-07-11T21:50:36.590212 #6860] DEBUG -- net.ssh.transport.session[3698cac]: connection established
I, [2017-07-11T21:50:36.591199 #6860]  INFO -- net.ssh.transport.server_version[36985b8]: negotiating protocol version
D, [2017-07-11T21:50:36.591199 #6860] DEBUG -- net.ssh.transport.server_version[36985b8]: local is `SSH-2.0-Ruby/Net::SSH_4.1.0 x64-mingw32'
D, [2017-07-11T21:50:36.613792 #6860] DEBUG -- net.ssh.transport.server_version[36985b8]: remote is `SSH-2.0-OpenSSH_6.6.1'
I, [2017-07-11T21:50:36.613792 #6860]  INFO -- net.ssh.transport.algorithms[369de28]: sending KEXINIT
D, [2017-07-11T21:50:36.613792 #6860] DEBUG -- socket[3698a18]: queueing packet nr 0 type 20 len 1156
D, [2017-07-11T21:50:36.614732 #6860] DEBUG -- socket[3698a18]: sent 1160 bytes
D, [2017-07-11T21:50:36.614732 #6860] DEBUG -- socket[3698a18]: read 1640 bytes
D, [2017-07-11T21:50:36.614732 #6860] DEBUG -- socket[3698a18]: received packet nr 0 type 20 len 1636
I, [2017-07-11T21:50:36.614732 #6860]  INFO -- net.ssh.transport.algorithms[369de28]: got KEXINIT from server
I, [2017-07-11T21:50:36.614732 #6860]  INFO -- net.ssh.transport.algorithms[369de28]: negotiating algorithms
D, [2017-07-11T21:50:36.614732 #6860] DEBUG -- net.ssh.transport.algorithms[369de28]: negotiated:
* kex: diffie-hellman-group-exchange-sha1
* host_key: ssh-rsa
* encryption_server: aes128-cbc
* encryption_client: aes128-cbc
* hmac_client: hmac-sha1
* hmac_server: hmac-sha1
* compression_client: none
* compression_server: none
* language_client:
* language_server:
D, [2017-07-11T21:50:36.614732 #6860] DEBUG -- net.ssh.transport.algorithms[369de28]: exchanging keys
D, [2017-07-11T21:50:36.614732 #6860] DEBUG -- socket[3698a18]: queueing packet nr 1 type 34 len 20
D, [2017-07-11T21:50:36.614732 #6860] DEBUG -- socket[3698a18]: sent 24 bytes
D, [2017-07-11T21:50:36.626549 #6860] DEBUG -- socket[3698a18]: read 152 bytes
D, [2017-07-11T21:50:36.626549 #6860] DEBUG -- socket[3698a18]: received packet nr 1 type 31 len 148
D, [2017-07-11T21:50:36.627489 #6860] DEBUG -- socket[3698a18]: queueing packet nr 2 type 32 len 140
D, [2017-07-11T21:50:36.627489 #6860] DEBUG -- socket[3698a18]: sent 144 bytes
D, [2017-07-11T21:50:36.638297 #6860] DEBUG -- socket[3698a18]: read 720 bytes
D, [2017-07-11T21:50:36.638297 #6860] DEBUG -- socket[3698a18]: received packet nr 2 type 33 len 700
D, [2017-07-11T21:50:36.638297 #6860] DEBUG -- socket[3698a18]: queueing packet nr 3 type 21 len 20
D, [2017-07-11T21:50:36.639265 #6860] DEBUG -- socket[3698a18]: sent 24 bytes
D, [2017-07-11T21:50:36.639265 #6860] DEBUG -- socket[3698a18]: received packet nr 3 type 21 len 12
D, [2017-07-11T21:50:36.639265 #6860] DEBUG -- net.ssh.authentication.session[36bbd10]: beginning authentication of `vagrant'
D, [2017-07-11T21:50:36.639265 #6860] DEBUG -- socket[3698a18]: queueing packet nr 4 type 5 len 28
D, [2017-07-11T21:50:36.640248 #6860] DEBUG -- socket[3698a18]: sent 52 bytes
D, [2017-07-11T21:50:36.650844 #6860] DEBUG -- socket[3698a18]: read 52 bytes
D, [2017-07-11T21:50:36.651068 #6860] DEBUG -- socket[3698a18]: received packet nr 4 type 6 len 28
D, [2017-07-11T21:50:36.651310 #6860] DEBUG -- net.ssh.authentication.session[36bbd10]: trying none
D, [2017-07-11T21:50:36.651617 #6860] DEBUG -- socket[3698a18]: queueing packet nr 5 type 50 len 44
D, [2017-07-11T21:50:36.651840 #6860] DEBUG -- socket[3698a18]: sent 68 bytes
D, [2017-07-11T21:51:00.967671 #6860] DEBUG -- socket[3698a18]: read 84 bytes
D, [2017-07-11T21:51:00.967671 #6860] DEBUG -- socket[3698a18]: received packet nr 5 type 51 len 60
D, [2017-07-11T21:51:00.967671 #6860] DEBUG -- net.ssh.authentication.session[36bbd10]: allowed methods: publickey,gssapi-keyex,gssapi-with-mic,password
D, [2017-07-11T21:51:00.967671 #6860] DEBUG -- net.ssh.authentication.methods.none[36bae74]: none failed
D, [2017-07-11T21:51:00.967671 #6860] DEBUG -- net.ssh.authentication.session[36bbd10]: trying publickey
D, [2017-07-11T21:51:00.968673 #6860] DEBUG -- net.ssh.authentication.agent[36bfbb8]: connecting to ssh-agent
D, [2017-07-11T21:51:00.968673 #6860] DEBUG -- net.ssh.authentication.agent[36bfbb8]: sending agent request 1 len 43
D, [2017-07-11T21:51:00.969177 #6860] DEBUG -- net.ssh.authentication.agent[36bfbb8]: received agent packet 2 len 5
D, [2017-07-11T21:51:00.969177 #6860] DEBUG -- net.ssh.authentication.agent[36bfbb8]: sending agent request 11 len 0
D, [2017-07-11T21:51:00.969678 #6860] DEBUG -- net.ssh.authentication.agent[36bfbb8]: received agent packet 12 len 306
D, [2017-07-11T21:51:00.969678 #6860] DEBUG -- net.ssh.authentication.methods.publickey[36bfe9c]: trying publickey (c4:cd:b6:43:ef:8d:27:8a:78:10:23:1a:b3:e0:f0:9e)
D, [2017-07-11T21:51:00.969678 #6860] DEBUG -- socket[3698a18]: queueing packet nr 6 type 50 len 348
D, [2017-07-11T21:51:00.970180 #6860] DEBUG -- socket[3698a18]: sent 372 bytes
D, [2017-07-11T21:51:00.980687 #6860] DEBUG -- socket[3698a18]: read 324 bytes
D, [2017-07-11T21:51:00.980687 #6860] DEBUG -- socket[3698a18]: received packet nr 6 type 60 len 300
D, [2017-07-11T21:51:00.982649 #6860] DEBUG -- socket[3698a18]: queueing packet nr 7 type 50 len 620
D, [2017-07-11T21:51:00.982649 #6860] DEBUG -- socket[3698a18]: sent 644 bytes
D, [2017-07-11T21:51:07.731045 #6860] DEBUG -- socket[3698a18]: read 36 bytes
D, [2017-07-11T21:51:07.731045 #6860] DEBUG -- socket[3698a18]: received packet nr 7 type 52 len 12
D, [2017-07-11T21:51:07.731045 #6860] DEBUG -- net.ssh.authentication.methods.publickey[36bfe9c]: publickey succeeded (c4:cd:b6:43:ef:8d:27:8a:78:10:23:1a:b3:e0:f0:9e)

DEBUG ssh: == Net-SSH connection debug-level log END ==
 INFO ssh: Execute: if test -r /etc/os-release; then
source /etc/os-release && test 'xLinux Mint' = "x$ID" && exit
fi
if test -x /usr/bin/lsb_release; then
/usr/bin/lsb_release -i 2>/dev/null | grep -qi 'Linux Mint' && exit
fi
if test -r /etc/issue; then
cat /etc/issue | grep -qi 'Linux Mint' && exit
fi
exit 1
 (sudo=false)
DEBUG ssh: Sending SSH keep-alive...
DEBUG ssh: Sending SSH keep-alive...
DEBUG ssh: Sending SSH keep-alive...
DEBUG ssh: Sending SSH keep-alive...
DEBUG ssh: stderr: 41e57d38-b4f7-4e46-9c38-13873d338b86-vagrant-ssh
DEBUG ssh: Exit status: 1
DEBUG guest: Trying: trisquel
 INFO ssh: Connection errored, not re-using. Will reconnect.
DEBUG ssh: #<Timeout::Error: execution expired>
 INFO subprocess: Starting process: ["C:/Program Files/Oracle/VirtualBox/VBoxManage.exe", "showvminfo", "8fb5c87b-1a3c-435e-8660-4efac27fd04f", "--machinereadable"]
 INFO subprocess: Command not in installer, restoring original environment...
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: name="{CLIENT}"
groups="/"
ostype="Red Hat (64-bit)"
UUID="8fb5c87b-1a3c-435e-8660-4efac27fd04f"
CfgFile="{HOMEDIR}\\VirtualBox VMs\\{CLIENT}\\{CLIENT}.vbox"
SnapFldr="{HOMEDIR}\\VirtualBox VMs\\{CLIENT}\\Snapshots"
LogFldr="{HOMEDIR}\\VirtualBox VMs\\{CLIENT}\\Logs"
hardwareuuid="8fb5c87b-1a3c-435e-8660-4efac27fd04f"
memory=8192
pagefusion="off"
vram=8
cpuexecutioncap=90
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=2
pae="on"
longmode="on"
triplefaultreset="off"
apic="on"
x2apic="on"
cpuid-portability-level=0
bootmenu="messageandmenu"
boot1="disk"
boot2="dvd"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
biosapic="apic"
biossystemtimeoffset=0
rtcuseutc="on"
hwvirtex="on"
nestedpaging="on"
largepages="on"
vtxvpid="on"
vtxux="on"
paravirtprovider="default"
effparavirtprovider="kvm"
VMState="running"
VMStateChangeTime="2017-07-11T19:12:38.999000000"
monitorcount=1
accelerate3d="off"
accelerate2dvideo="off"
teleporterenabled="off"
teleporterport=0
teleporteraddress=""
teleporterpassword=""
tracing-enabled="off"
tracing-allow-vm-access="off"
tracing-config=""
autostart-enabled="off"
autostart-delay=0
defaultfrontend=""
storagecontrollername0="IDE Controller"
storagecontrollertype0="PIIX4"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="2"
storagecontrollerportcount0="2"
storagecontrollerbootable0="on"
"IDE Controller-0-0"="{HOMEDIR}\VirtualBox VMs\{CLIENT}\Snapshots\{d60e1cd8-b069-4de1-8be5-b0e345172bb5}.vmdk"
"IDE Controller-ImageUUID-0-0"="d60e1cd8-b069-4de1-8be5-b0e345172bb5"
"IDE Controller-0-1"="none"
"IDE Controller-1-0"="none"
"IDE Controller-1-1"="none"
natnet1="nat"
macaddress1="080027DB3827"
cableconnected1="on"
nic1="nat"
nictype1="82540EM"
nicspeed1="0"
mtu="0"
sockSnd="64"
sockRcv="64"
tcpWndSnd="64"
tcpWndRcv="64"
Forwarding(0)="ssh,tcp,127.0.0.1,2222,,22"
Forwarding(1)="tcp4502,tcp,,4502,,4502"
Forwarding(2)="tcp4503,tcp,,4503,,4503"
Forwarding(3)="tcp4512,tcp,,4512,,4512"
Forwarding(4)="tcp4513,tcp,,4513,,4513"
Forwarding(5)="tcp4592,tcp,,4592,,4592"
Forwarding(6)="tcp4593,tcp,,4593,,4593"
Forwarding(7)="tcp80,tcp,,80,,80"
hostonlyadapter2="VirtualBox Host-Only Ethernet Adapter #2"
macaddress2="080027E33CE9"
cableconnected2="on"
nic2="hostonly"
nictype2="82540EM"
nicspeed2="0"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
uart3="off"
uart4="off"
lpt1="off"
lpt2="off"
audio="dsound"
clipboard="disabled"
draganddrop="disabled"
SessionName="GUI/Qt"
VideoMode="720,400,0"@0,0 1
vrde="on"
vrdeport=-1
vrdeports="5993"
vrdeaddress="127.0.0.1"
vrdeauthtype="null"
vrdemulticon="off"
vrdereusecon="off"
vrdevideochannel="off"
usb="off"
ehci="off"
xhci="off"
SharedFolderNameMachineMapping1="opt_install_files_.m2"
SharedFolderPathMachineMapping1="\\?\{PATH}\.m2"
SharedFolderNameMachineMapping2="vagrant"
SharedFolderPathMachineMapping2="\\?\{PATH}"
SharedFolderNameMachineMapping3="tmp_vagrant-puppet_manifests-c42ae094895da5204ae8ca79060e21be"
SharedFolderPathMachineMapping3="\\?\{PATH}\{cl}\manifests"
SharedFolderNameMachineMapping4="tmp_vagrant-puppet_modules-8aacd06f3b51f2d5a279df0bc5bad14c"
SharedFolderPathMachineMapping4="\\?\{PATH}\aem\modules"
SharedFolderNameMachineMapping5="tmp_vagrant-puppet_modules-314ccd1cdb56ec0df1fdca485ce2b133"
SharedFolderPathMachineMapping5="\\?\{PATH}\{co}\modules"
SharedFolderNameMachineMapping6="tmp_vagrant-puppet_modules-d67d2193e39b036974d2702de8a29251"
SharedFolderPathMachineMapping6="\\?\{PATH}\{cl}\modules"
VRDEActiveConnection="off"
VRDEClients=0
vcpenabled="off"
vcpscreens=0
vcpfile="{HOMEDIR}\VirtualBox VMs\{CLIENT}\{CLIENT}.webm"
vcpwidth=1024
vcpheight=768
vcprate=512
vcpfps=25
GuestMemoryBalloon=0
GuestOSType="Linux26_64"
GuestAdditionsRunLevel=2
GuestAdditionsVersion="5.1.22 r115126"
GuestAdditionsFacility_VirtualBox Base Driver=50,1499800369660
GuestAdditionsFacility_VirtualBox System Service=50,1499800371231
GuestAdditionsFacility_Seamless Mode=0,1499800369659
GuestAdditionsFacility_Graphics Mode=0,1499800369659
SnapshotName="provisioned"
SnapshotUUID="be827bcf-71a0-4fb1-902d-7e5e9db7f626"
SnapshotName-1="up-working"
SnapshotUUID-1="9185f063-c82b-4b37-a591-f64ab8fee94f"
CurrentSnapshotName="up-working"
CurrentSnapshotUUID="9185f063-c82b-4b37-a591-f64ab8fee94f"
CurrentSnapshotNode="SnapshotName-1"
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 31999
DEBUG subprocess: Exit status: 0
DEBUG virtualbox_5_1: Searching for SSH port: 22
DEBUG virtualbox_5_1: read_forward_ports: uuid=8fb5c87b-1a3c-435e-8660-4efac27fd04f active_only=false
 INFO subprocess: Starting process: ["C:/Program Files/Oracle/VirtualBox/VBoxManage.exe", "showvminfo", "8fb5c87b-1a3c-435e-8660-4efac27fd04f", "--machinereadable"]
 INFO subprocess: Command not in installer, restoring original environment...
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: name="{CLIENT}"
groups="/"
ostype="Red Hat (64-bit)"
UUID="8fb5c87b-1a3c-435e-8660-4efac27fd04f"
CfgFile="{HOMEDIR}\\VirtualBox VMs\\{CLIENT}\\{CLIENT}.vbox"
SnapFldr="{HOMEDIR}\\VirtualBox VMs\\{CLIENT}\\Snapshots"
LogFldr="{HOMEDIR}\\VirtualBox VMs\\{CLIENT}\\Logs"
hardwareuuid="8fb5c87b-1a3c-435e-8660-4efac27fd04f"
memory=8192
pagefusion="off"
vram=8
cpuexecutioncap=90
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=2
pae="on"
longmode="on"
triplefaultreset="off"
apic="on"
x2apic="on"
cpuid-portability-level=0
bootmenu="messageandmenu"
boot1="disk"
boot2="dvd"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
biosapic="apic"
biossystemtimeoffset=0
rtcuseutc="on"
hwvirtex="on"
nestedpaging="on"
largepages="on"
vtxvpid="on"
vtxux="on"
paravirtprovider="default"
effparavirtprovider="kvm"
VMState="running"
VMStateChangeTime="2017-07-11T19:12:38.999000000"
monitorcount=1
accelerate3d="off"
accelerate2dvideo="off"
teleporterenabled="off"
teleporterport=0
teleporteraddress=""
teleporterpassword=""
tracing-enabled="off"
tracing-allow-vm-access="off"
tracing-config=""
autostart-enabled="off"
autostart-delay=0
defaultfrontend=""
storagecontrollername0="IDE Controller"
storagecontrollertype0="PIIX4"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="2"
storagecontrollerportcount0="2"
storagecontrollerbootable0="on"
"IDE Controller-0-0"="{HOMEDIR}\VirtualBox VMs\{CLIENT}\Snapshots\{d60e1cd8-b069-4de1-8be5-b0e345172bb5}.vmdk"
"IDE Controller-ImageUUID-0-0"="d60e1cd8-b069-4de1-8be5-b0e345172bb5"
"IDE Controller-0-1"="none"
"IDE Controller-1-0"="none"
"IDE Controller-1-1"="none"
natnet1="nat"
macaddress1="080027DB3827"
cableconnected1="on"
nic1="nat"
nictype1="82540EM"
nicspeed1="0"
mtu="0"
sockSnd="64"
sockRcv="64"
tcpWndSnd="64"
tcpWndRcv="64"
Forwarding(0)="ssh,tcp,127.0.0.1,2222,,22"
Forwarding(1)="tcp4502,tcp,,4502,,4502"
Forwarding(2)="tcp4503,tcp,,4503,,4503"
Forwarding(3)="tcp4512,tcp,,4512,,4512"
Forwarding(4)="tcp4513,tcp,,4513,,4513"
Forwarding(5)="tcp4592,tcp,,4592,,4592"
Forwarding(6)="tcp4593,tcp,,4593,,4593"
Forwarding(7)="tcp80,tcp,,80,,80"
hostonlyadapter2="VirtualBox Host-Only Ethernet Adapter #2"
macaddress2="080027E33CE9"
cableconnected2="on"
nic2="hostonly"
nictype2="82540EM"
nicspeed2="0"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
uart3="off"
uart4="off"
lpt1="off"
lpt2="off"
audio="dsound"
clipboard="disabled"
draganddrop="disabled"
SessionName="GUI/Qt"
VideoMode="720,400,0"@0,0 1
vrde="on"
vrdeport=-1
vrdeports="5993"
vrdeaddress="127.0.0.1"
vrdeauthtype="null"
vrdemulticon="off"
vrdereusecon="off"
vrdevideochannel="off"
usb="off"
ehci="off"
xhci="off"
SharedFolderNameMachineMapping1="opt_install_files_.m2"
SharedFolderPathMachineMapping1="\\?\{PATH}\.m2"
SharedFolderNameMachineMapping2="vagrant"
SharedFolderPathMachineMapping2="\\?\{PATH}"
SharedFolderNameMachineMapping3="tmp_vagrant-puppet_manifests-c42ae094895da5204ae8ca79060e21be"
SharedFolderPathMachineMapping3="\\?\{PATH}\{cl}\manifests"
SharedFolderNameMachineMapping4="tmp_vagrant-puppet_modules-8aacd06f3b51f2d5a279df0bc5bad14c"
SharedFolderPathMachineMapping4="\\?\{PATH}\aem\modules"
SharedFolderNameMachineMapping5="tmp_vagrant-puppet_modules-314ccd1cdb56ec0df1fdca485ce2b133"
SharedFolderPathMachineMapping5="\\?\{PATH}\{co}\modules"
SharedFolderNameMachineMapping6="tmp_vagrant-puppet_modules-d67d2193e39b036974d2702de8a29251"
SharedFolderPathMachineMapping6="\\?\{PATH}\{cl}\modules"
VRDEActiveConnection="off"
VRDEClients=0
vcpenabled="off"
vcpscreens=0
vcpfile="{HOMEDIR}\VirtualBox VMs\{CLIENT}\{CLIENT}.webm"
vcpwidth=1024
vcpheight=768
vcprate=512
vcpfps=25
GuestMemoryBalloon=0
GuestOSType="Linux26_64"
GuestAdditionsRunLevel=2
GuestAdditionsVersion="5.1.22 r115126"
GuestAdditionsFacility_VirtualBox Base Driver=50,1499800369660
GuestAdditionsFacility_VirtualBox System Service=50,1499800371231
GuestAdditionsFacility_Seamless Mode=0,1499800369659
GuestAdditionsFacility_Graphics Mode=0,1499800369659
SnapshotName="provisioned"
SnapshotUUID="be827bcf-71a0-4fb1-902d-7e5e9db7f626"
SnapshotName-1="up-working"
SnapshotUUID-1="9185f063-c82b-4b37-a591-f64ab8fee94f"
CurrentSnapshotName="up-working"
CurrentSnapshotUUID="9185f063-c82b-4b37-a591-f64ab8fee94f"
CurrentSnapshotNode="SnapshotName-1"
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 31999
DEBUG subprocess: Exit status: 0
DEBUG virtualbox_5_1:   - [1, "ssh", 2222, 22, "127.0.0.1"]
DEBUG virtualbox_5_1:   - [1, "tcp4502", 4502, 4502, ""]
DEBUG virtualbox_5_1:   - [1, "tcp4503", 4503, 4503, ""]
DEBUG virtualbox_5_1:   - [1, "tcp4512", 4512, 4512, ""]
DEBUG virtualbox_5_1:   - [1, "tcp4513", 4513, 4513, ""]
DEBUG virtualbox_5_1:   - [1, "tcp4592", 4592, 4592, ""]
DEBUG virtualbox_5_1:   - [1, "tcp4593", 4593, 4593, ""]
DEBUG virtualbox_5_1:   - [1, "tcp80", 80, 80, ""]
 INFO ssh: Attempting SSH connection...
 INFO ssh: Attempting to connect to SSH...
 INFO ssh:   - Host: 127.0.0.1
 INFO ssh:   - Port: 2222
 INFO ssh:   - Username: vagrant
 INFO ssh:   - Password? false
 INFO ssh:   - Key Path: ["{PATH}/.vagrant/machines/aem/virtualbox/private_key"]
DEBUG ssh:   - connect_opts: {:auth_methods=>["none", "hostbased", "publickey"], :config=>false, :forward_agent=>false, :send_env=>false, :keys_only=>true, :paranoid=>false, :password=>nil, :port=>2222, :timeout=>15, :user_known_hosts_file=>[], :verbose=>:debug, :encryption=>["aes128-cbc", "3des-cbc", "blowfish-cbc", "cast128-cbc", "aes192-cbc", "aes256-cbc", "[email protected]", "idea-cbc", "arcfour128", "arcfour256", "arcfour", "aes128-ctr", "aes192-ctr", "aes256-ctr", "cast128-ctr", "blowfish-ctr", "3des-ctr", "none"], :logger=>#<Logger:0x00000006f17588 @progname=nil, @level=0, @default_formatter=#<Logger::Formatter:0x00000006f17560 @datetime_format=nil>, @formatter=nil, @logdev=#<Logger::LogDevice:0x00000006f17510 @shift_size=nil, @shift_age=nil, @filename=nil, @dev=#<StringIO:0x00000006f175d8>, @mon_owner=nil, @mon_count=0, @mon_mutex=#<Thread::Mutex:0x00000006f174e8>>>, :keys=>["{PATH}/.vagrant/machines/aem/virtualbox/private_key"]}
DEBUG ssh: == Net-SSH connection debug-level log START ==
DEBUG ssh: D, [2017-07-11T21:51:35.428207 #6860] DEBUG -- net.ssh.transport.session[378ae30]: establishing connection to 127.0.0.1:2222
D, [2017-07-11T21:51:35.429191 #6860] DEBUG -- net.ssh.transport.session[378ae30]: connection established
I, [2017-07-11T21:51:35.430178 #6860]  INFO -- net.ssh.transport.server_version[378a73c]: negotiating protocol version
D, [2017-07-11T21:51:35.430178 #6860] DEBUG -- net.ssh.transport.server_version[378a73c]: local is `SSH-2.0-Ruby/Net::SSH_4.1.0 x64-mingw32'
D, [2017-07-11T21:51:35.441946 #6860] DEBUG -- net.ssh.transport.server_version[378a73c]: remote is `SSH-2.0-OpenSSH_6.6.1'
I, [2017-07-11T21:51:35.441946 #6860]  INFO -- net.ssh.transport.algorithms[210537c]: sending KEXINIT
D, [2017-07-11T21:51:35.441946 #6860] DEBUG -- socket[378ab9c]: queueing packet nr 0 type 20 len 1156
D, [2017-07-11T21:51:35.441946 #6860] DEBUG -- socket[378ab9c]: sent 1160 bytes
D, [2017-07-11T21:51:35.442927 #6860] DEBUG -- socket[378ab9c]: read 1640 bytes
D, [2017-07-11T21:51:35.442927 #6860] DEBUG -- socket[378ab9c]: received packet nr 0 type 20 len 1636
I, [2017-07-11T21:51:35.442927 #6860]  INFO -- net.ssh.transport.algorithms[210537c]: got KEXINIT from server
I, [2017-07-11T21:51:35.442927 #6860]  INFO -- net.ssh.transport.algorithms[210537c]: negotiating algorithms
D, [2017-07-11T21:51:35.443911 #6860] DEBUG -- net.ssh.transport.algorithms[210537c]: negotiated:
* kex: diffie-hellman-group-exchange-sha1
* host_key: ssh-rsa
* encryption_server: aes128-cbc
* encryption_client: aes128-cbc
* hmac_client: hmac-sha1
* hmac_server: hmac-sha1
* compression_client: none
* compression_server: none
* language_client:
* language_server:
D, [2017-07-11T21:51:35.443911 #6860] DEBUG -- net.ssh.transport.algorithms[210537c]: exchanging keys
D, [2017-07-11T21:51:35.443911 #6860] DEBUG -- socket[378ab9c]: queueing packet nr 1 type 34 len 20
D, [2017-07-11T21:51:35.443911 #6860] DEBUG -- socket[378ab9c]: sent 24 bytes
D, [2017-07-11T21:51:35.454876 #6860] DEBUG -- socket[378ab9c]: read 152 bytes
D, [2017-07-11T21:51:35.454876 #6860] DEBUG -- socket[378ab9c]: received packet nr 1 type 31 len 148
D, [2017-07-11T21:51:35.455859 #6860] DEBUG -- socket[378ab9c]: queueing packet nr 2 type 32 len 140
D, [2017-07-11T21:51:35.455859 #6860] DEBUG -- socket[378ab9c]: sent 144 bytes
D, [2017-07-11T21:51:35.466699 #6860] DEBUG -- socket[378ab9c]: read 720 bytes
D, [2017-07-11T21:51:35.466699 #6860] DEBUG -- socket[378ab9c]: received packet nr 2 type 33 len 700
D, [2017-07-11T21:51:35.467634 #6860] DEBUG -- socket[378ab9c]: queueing packet nr 3 type 21 len 20
D, [2017-07-11T21:51:35.467634 #6860] DEBUG -- socket[378ab9c]: sent 24 bytes
D, [2017-07-11T21:51:35.467634 #6860] DEBUG -- socket[378ab9c]: received packet nr 3 type 21 len 12
D, [2017-07-11T21:51:35.467634 #6860] DEBUG -- net.ssh.authentication.session[37c18b8]: beginning authentication of `vagrant'
D, [2017-07-11T21:51:35.468617 #6860] DEBUG -- socket[378ab9c]: queueing packet nr 4 type 5 len 28
D, [2017-07-11T21:51:35.468617 #6860] DEBUG -- socket[378ab9c]: sent 52 bytes
D, [2017-07-11T21:51:35.479445 #6860] DEBUG -- socket[378ab9c]: read 52 bytes
D, [2017-07-11T21:51:35.479445 #6860] DEBUG -- socket[378ab9c]: received packet nr 4 type 6 len 28
D, [2017-07-11T21:51:35.479445 #6860] DEBUG -- net.ssh.authentication.session[37c18b8]: trying none
D, [2017-07-11T21:51:35.480381 #6860] DEBUG -- socket[378ab9c]: queueing packet nr 5 type 50 len 44
D, [2017-07-11T21:51:35.480381 #6860] DEBUG -- socket[378ab9c]: sent 68 bytes
D, [2017-07-11T21:51:55.291734 #6860] DEBUG -- socket[378ab9c]: read 84 bytes
D, [2017-07-11T21:51:55.291734 #6860] DEBUG -- socket[378ab9c]: received packet nr 5 type 51 len 60
D, [2017-07-11T21:51:55.291734 #6860] DEBUG -- net.ssh.authentication.session[37c18b8]: allowed methods: publickey,gssapi-keyex,gssapi-with-mic,password
D, [2017-07-11T21:51:55.291734 #6860] DEBUG -- net.ssh.authentication.methods.none[37c0a1c]: none failed
D, [2017-07-11T21:51:55.292670 #6860] DEBUG -- net.ssh.authentication.session[37c18b8]: trying publickey
D, [2017-07-11T21:51:55.292670 #6860] DEBUG -- net.ssh.authentication.agent[37c58dc]: connecting to ssh-agent
D, [2017-07-11T21:51:55.293652 #6860] DEBUG -- net.ssh.authentication.agent[37c58dc]: sending agent request 1 len 43
D, [2017-07-11T21:51:55.293652 #6860] DEBUG -- net.ssh.authentication.agent[37c58dc]: received agent packet 2 len 5
D, [2017-07-11T21:51:55.294642 #6860] DEBUG -- net.ssh.authentication.agent[37c58dc]: sending agent request 11 len 0
D, [2017-07-11T21:51:55.294642 #6860] DEBUG -- net.ssh.authentication.agent[37c58dc]: received agent packet 12 len 306
D, [2017-07-11T21:51:55.294642 #6860] DEBUG -- net.ssh.authentication.methods.publickey[37c5bc0]: trying publickey (c4:cd:b6:43:ef:8d:27:8a:78:10:23:1a:b3:e0:f0:9e)
D, [2017-07-11T21:51:55.295615 #6860] DEBUG -- socket[378ab9c]: queueing packet nr 6 type 50 len 348
D, [2017-07-11T21:51:55.295615 #6860] DEBUG -- socket[378ab9c]: sent 372 bytes
D, [2017-07-11T21:51:55.306454 #6860] DEBUG -- socket[378ab9c]: read 324 bytes
D, [2017-07-11T21:51:55.306454 #6860] DEBUG -- socket[378ab9c]: received packet nr 6 type 60 len 300
D, [2017-07-11T21:51:55.307391 #6860] DEBUG -- socket[378ab9c]: queueing packet nr 7 type 50 len 620
D, [2017-07-11T21:51:55.308372 #6860] DEBUG -- socket[378ab9c]: sent 644 bytes
D, [2017-07-11T21:52:02.093727 #6860] DEBUG -- socket[378ab9c]: read 36 bytes
D, [2017-07-11T21:52:02.093727 #6860] DEBUG -- socket[378ab9c]: received packet nr 7 type 52 len 12
D, [2017-07-11T21:52:02.093727 #6860] DEBUG -- net.ssh.authentication.methods.publickey[37c5bc0]: publickey succeeded (c4:cd:b6:43:ef:8d:27:8a:78:10:23:1a:b3:e0:f0:9e)

DEBUG ssh: == Net-SSH connection debug-level log END ==
 INFO ssh: Execute: [ -x /usr/bin/lsb_release ] && /usr/bin/lsb_release -i 2>/dev/null | grep Trisquel (sudo=false)
DEBUG ssh: Sending SSH keep-alive...
DEBUG ssh: Sending SSH keep-alive...
DEBUG ssh: Sending SSH keep-alive...
DEBUG ssh: Sending SSH keep-alive...
DEBUG ssh: stderr: 41e57d38-b4f7-4e46-9c38-13873d338b86-vagrant-ssh
DEBUG ssh: Exit status: 1
DEBUG guest: Trying: amazon
 INFO ssh: Connection errored, not re-using. Will reconnect.
DEBUG ssh: #<Timeout::Error: execution expired>
 INFO subprocess: Starting process: ["C:/Program Files/Oracle/VirtualBox/VBoxManage.exe", "showvminfo", "8fb5c87b-1a3c-435e-8660-4efac27fd04f", "--machinereadable"]
 INFO subprocess: Command not in installer, restoring original environment...
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: name="{CLIENT}"
groups="/"
ostype="Red Hat (64-bit)"
UUID="8fb5c87b-1a3c-435e-8660-4efac27fd04f"
CfgFile="{HOMEDIR}\\VirtualBox VMs\\{CLIENT}\\{CLIENT}.vbox"
SnapFldr="{HOMEDIR}\\VirtualBox VMs\\{CLIENT}\\Snapshots"
LogFldr="{HOMEDIR}\\VirtualBox VMs\\{CLIENT}\\Logs"
hardwareuuid="8fb5c87b-1a3c-435e-8660-4efac27fd04f"
memory=8192
pagefusion="off"
vram=8
cpuexecutioncap=90
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=2
pae="on"
longmode="on"
triplefaultreset="off"
apic="on"
x2apic="on"
cpuid-portability-level=0
bootmenu="messageandmenu"
boot1="disk"
boot2="dvd"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
biosapic="apic"
biossystemtimeoffset=0
rtcuseutc="on"
hwvirtex="on"
nestedpaging="on"
largepages="on"
vtxvpid="on"
vtxux="on"
paravirtprovider="default"
effparavirtprovider="kvm"
VMState="running"
VMStateChangeTime="2017-07-11T19:12:38.999000000"
monitorcount=1
accelerate3d="off"
accelerate2dvideo="off"
teleporterenabled="off"
teleporterport=0
teleporteraddress=""
teleporterpassword=""
tracing-enabled="off"
tracing-allow-vm-access="off"
tracing-config=""
autostart-enabled="off"
autostart-delay=0
defaultfrontend=""
storagecontrollername0="IDE Controller"
storagecontrollertype0="PIIX4"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="2"
storagecontrollerportcount0="2"
storagecontrollerbootable0="on"
"IDE Controller-0-0"="{HOMEDIR}\VirtualBox VMs\{CLIENT}\Snapshots\{d60e1cd8-b069-4de1-8be5-b0e345172bb5}.vmdk"
"IDE Controller-ImageUUID-0-0"="d60e1cd8-b069-4de1-8be5-b0e345172bb5"
"IDE Controller-0-1"="none"
"IDE Controller-1-0"="none"
"IDE Controller-1-1"="none"
natnet1="nat"
macaddress1="080027DB3827"
cableconnected1="on"
nic1="nat"
nictype1="82540EM"
nicspeed1="0"
mtu="0"
sockSnd="64"
sockRcv="64"
tcpWndSnd="64"
tcpWndRcv="64"
Forwarding(0)="ssh,tcp,127.0.0.1,2222,,22"
Forwarding(1)="tcp4502,tcp,,4502,,4502"
Forwarding(2)="tcp4503,tcp,,4503,,4503"
Forwarding(3)="tcp4512,tcp,,4512,,4512"
Forwarding(4)="tcp4513,tcp,,4513,,4513"
Forwarding(5)="tcp4592,tcp,,4592,,4592"
Forwarding(6)="tcp4593,tcp,,4593,,4593"
Forwarding(7)="tcp80,tcp,,80,,80"
hostonlyadapter2="VirtualBox Host-Only Ethernet Adapter #2"
macaddress2="080027E33CE9"
cableconnected2="on"
nic2="hostonly"
nictype2="82540EM"
nicspeed2="0"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
uart3="off"
uart4="off"
lpt1="off"
lpt2="off"
audio="dsound"
clipboard="disabled"
draganddrop="disabled"
SessionName="GUI/Qt"
VideoMode="720,400,0"@0,0 1
vrde="on"
vrdeport=-1
vrdeports="5993"
vrdeaddress="127.0.0.1"
vrdeauthtype="null"
vrdemulticon="off"
vrdereusecon="off"
vrdevideochannel="off"
usb="off"
ehci="off"
xhci="off"
SharedFolderNameMachineMapping1="opt_install_files_.m2"
SharedFolderPathMachineMapping1="\\?\{PATH}\.m2"
SharedFolderNameMachineMapping2="vagrant"
SharedFolderPathMachineMapping2="\\?\{PATH}"
SharedFolderNameMachineMapping3="tmp_vagrant-puppet_manifests-c42ae094895da5204ae8ca79060e21be"
SharedFolderPathMachineMapping3="\\?\{PATH}\{cl}\manifests"
SharedFolderNameMachineMapping4="tmp_vagrant-puppet_modules-8aacd06f3b51f2d5a279df0bc5bad14c"
SharedFolderPathMachineMapping4="\\?\{PATH}\aem\modules"
SharedFolderNameMachineMapping5="tmp_vagrant-puppet_modules-314ccd1cdb56ec0df1fdca485ce2b133"
SharedFolderPathMachineMapping5="\\?\{PATH}\{co}\modules"
SharedFolderNameMachineMapping6="tmp_vagrant-puppet_modules-d67d2193e39b036974d2702de8a29251"
SharedFolderPathMachineMapping6="\\?\{PATH}\{cl}\modules"
VRDEActiveConnection="off"
VRDEClients=0
vcpenabled="off"
vcpscreens=0
vcpfile="{HOMEDIR}\VirtualBox VMs\{CLIENT}\{CLIENT}.webm"
vcpwidth=1024
vcpheight=768
vcprate=512
vcpfps=25
GuestMemoryBalloon=0
GuestOSType="Linux26_64"
GuestAdditionsRunLevel=2
GuestAdditionsVersion="5.1.22 r115126"
GuestAdditionsFacility_VirtualBox Base Driver=50,1499800369660
GuestAdditionsFacility_VirtualBox System Service=50,1499800371231
GuestAdditionsFacility_Seamless Mode=0,1499800369659
GuestAdditionsFacility_Graphics Mode=0,1499800369659
SnapshotName="provisioned"
SnapshotUUID="be827bcf-71a0-4fb1-902d-7e5e9db7f626"
SnapshotName-1="up-working"
SnapshotUUID-1="9185f063-c82b-4b37-a591-f64ab8fee94f"
CurrentSnapshotName="up-working"
CurrentSnapshotUUID="9185f063-c82b-4b37-a591-f64ab8fee94f"
CurrentSnapshotNode="SnapshotName-1"
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 31999
DEBUG subprocess: Exit status: 0
DEBUG virtualbox_5_1: Searching for SSH port: 22
DEBUG virtualbox_5_1: read_forward_ports: uuid=8fb5c87b-1a3c-435e-8660-4efac27fd04f active_only=false
 INFO subprocess: Starting process: ["C:/Program Files/Oracle/VirtualBox/VBoxManage.exe", "showvminfo", "8fb5c87b-1a3c-435e-8660-4efac27fd04f", "--machinereadable"]
 INFO subprocess: Command not in installer, restoring original environment...
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: name="{CLIENT}"
groups="/"
ostype="Red Hat (64-bit)"
UUID="8fb5c87b-1a3c-435e-8660-4efac27fd04f"
CfgFile="{HOMEDIR}\\VirtualBox VMs\\{CLIENT}\\{CLIENT}.vbox"
SnapFldr="{HOMEDIR}\\VirtualBox VMs\\{CLIENT}\\Snapshots"
LogFldr="{HOMEDIR}\\VirtualBox VMs\\{CLIENT}\\Logs"
hardwareuuid="8fb5c87b-1a3c-435e-8660-4efac27fd04f"
memory=8192
pagefusion="off"
vram=8
cpuexecutioncap=90
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=2
pae="on"
longmode="on"
triplefaultreset="off"
apic="on"
x2apic="on"
cpuid-portability-level=0
bootmenu="messageandmenu"
boot1="disk"
boot2="dvd"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
biosapic="apic"
biossystemtimeoffset=0
rtcuseutc="on"
hwvirtex="on"
nestedpaging="on"
largepages="on"
vtxvpid="on"
vtxux="on"
paravirtprovider="default"
effparavirtprovider="kvm"
VMState="running"
VMStateChangeTime="2017-07-11T19:12:38.999000000"
monitorcount=1
accelerate3d="off"
accelerate2dvideo="off"
teleporterenabled="off"
teleporterport=0
teleporteraddress=""
teleporterpassword=""
tracing-enabled="off"
tracing-allow-vm-access="off"
tracing-config=""
autostart-enabled="off"
autostart-delay=0
defaultfrontend=""
storagecontrollername0="IDE Controller"
storagecontrollertype0="PIIX4"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="2"
storagecontrollerportcount0="2"
storagecontrollerbootable0="on"
"IDE Controller-0-0"="{HOMEDIR}\VirtualBox VMs\{CLIENT}\Snapshots\{d60e1cd8-b069-4de1-8be5-b0e345172bb5}.vmdk"
"IDE Controller-ImageUUID-0-0"="d60e1cd8-b069-4de1-8be5-b0e345172bb5"
"IDE Controller-0-1"="none"
"IDE Controller-1-0"="none"
"IDE Controller-1-1"="none"
natnet1="nat"
macaddress1="080027DB3827"
cableconnected1="on"
nic1="nat"
nictype1="82540EM"
nicspeed1="0"
mtu="0"
sockSnd="64"
sockRcv="64"
tcpWndSnd="64"
tcpWndRcv="64"
Forwarding(0)="ssh,tcp,127.0.0.1,2222,,22"
Forwarding(1)="tcp4502,tcp,,4502,,4502"
Forwarding(2)="tcp4503,tcp,,4503,,4503"
Forwarding(3)="tcp4512,tcp,,4512,,4512"
Forwarding(4)="tcp4513,tcp,,4513,,4513"
Forwarding(5)="tcp4592,tcp,,4592,,4592"
Forwarding(6)="tcp4593,tcp,,4593,,4593"
Forwarding(7)="tcp80,tcp,,80,,80"
hostonlyadapter2="VirtualBox Host-Only Ethernet Adapter #2"
macaddress2="080027E33CE9"
cableconnected2="on"
nic2="hostonly"
nictype2="82540EM"
nicspeed2="0"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
uart3="off"
uart4="off"
lpt1="off"
lpt2="off"
audio="dsound"
clipboard="disabled"
draganddrop="disabled"
SessionName="GUI/Qt"
VideoMode="720,400,0"@0,0 1
vrde="on"
vrdeport=-1
vrdeports="5993"
vrdeaddress="127.0.0.1"
vrdeauthtype="null"
vrdemulticon="off"
vrdereusecon="off"
vrdevideochannel="off"
usb="off"
ehci="off"
xhci="off"
SharedFolderNameMachineMapping1="opt_install_files_.m2"
SharedFolderPathMachineMapping1="\\?\{PATH}\.m2"
SharedFolderNameMachineMapping2="vagrant"
SharedFolderPathMachineMapping2="\\?\{PATH}"
SharedFolderNameMachineMapping3="tmp_vagrant-puppet_manifests-c42ae094895da5204ae8ca79060e21be"
SharedFolderPathMachineMapping3="\\?\{PATH}\{cl}\manifests"
SharedFolderNameMachineMapping4="tmp_vagrant-puppet_modules-8aacd06f3b51f2d5a279df0bc5bad14c"
SharedFolderPathMachineMapping4="\\?\{PATH}\aem\modules"
SharedFolderNameMachineMapping5="tmp_vagrant-puppet_modules-314ccd1cdb56ec0df1fdca485ce2b133"
SharedFolderPathMachineMapping5="\\?\{PATH}\{co}\modules"
SharedFolderNameMachineMapping6="tmp_vagrant-puppet_modules-d67d2193e39b036974d2702de8a29251"
SharedFolderPathMachineMapping6="\\?\{PATH}\{cl}\modules"
VRDEActiveConnection="off"
VRDEClients=0
vcpenabled="off"
vcpscreens=0
vcpfile="{HOMEDIR}\VirtualBox VMs\{CLIENT}\{CLIENT}.webm"
vcpwidth=1024
vcpheight=768
vcprate=512
vcpfps=25
GuestMemoryBalloon=0
GuestOSType="Linux26_64"
GuestAdditionsRunLevel=2
GuestAdditionsVersion="5.1.22 r115126"
GuestAdditionsFacility_VirtualBox Base Driver=50,1499800369660
GuestAdditionsFacility_VirtualBox System Service=50,1499800371231
GuestAdditionsFacility_Seamless Mode=0,1499800369659
GuestAdditionsFacility_Graphics Mode=0,1499800369659
SnapshotName="provisioned"
SnapshotUUID="be827bcf-71a0-4fb1-902d-7e5e9db7f626"
SnapshotName-1="up-working"
SnapshotUUID-1="9185f063-c82b-4b37-a591-f64ab8fee94f"
CurrentSnapshotName="up-working"
CurrentSnapshotUUID="9185f063-c82b-4b37-a591-f64ab8fee94f"
CurrentSnapshotNode="SnapshotName-1"
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 31999
DEBUG subprocess: Exit status: 0
DEBUG virtualbox_5_1:   - [1, "ssh", 2222, 22, "127.0.0.1"]
DEBUG virtualbox_5_1:   - [1, "tcp4502", 4502, 4502, ""]
DEBUG virtualbox_5_1:   - [1, "tcp4503", 4503, 4503, ""]
DEBUG virtualbox_5_1:   - [1, "tcp4512", 4512, 4512, ""]
DEBUG virtualbox_5_1:   - [1, "tcp4513", 4513, 4513, ""]
DEBUG virtualbox_5_1:   - [1, "tcp4592", 4592, 4592, ""]
DEBUG virtualbox_5_1:   - [1, "tcp4593", 4593, 4593, ""]
DEBUG virtualbox_5_1:   - [1, "tcp80", 80, 80, ""]
 INFO ssh: Attempting SSH connection...
 INFO ssh: Attempting to connect to SSH...
 INFO ssh:   - Host: 127.0.0.1
 INFO ssh:   - Port: 2222
 INFO ssh:   - Username: vagrant
 INFO ssh:   - Password? false
 INFO ssh:   - Key Path: ["{PATH}/.vagrant/machines/aem/virtualbox/private_key"]
DEBUG ssh:   - connect_opts: {:auth_methods=>["none", "hostbased", "publickey"], :config=>false, :forward_agent=>false, :send_env=>false, :keys_only=>true, :paranoid=>false, :password=>nil, :port=>2222, :timeout=>15, :user_known_hosts_file=>[], :verbose=>:debug, :encryption=>["aes128-cbc", "3des-cbc", "blowfish-cbc", "cast128-cbc", "aes192-cbc", "aes256-cbc", "[email protected]", "idea-cbc", "arcfour128", "arcfour256", "arcfour", "aes128-ctr", "aes192-ctr", "aes256-ctr", "cast128-ctr", "blowfish-ctr", "3des-ctr", "none"], :logger=>#<Logger:0x0000000716bbb8 @progname=nil, @level=0, @default_formatter=#<Logger::Formatter:0x0000000716bb90 @datetime_format=nil>, @formatter=nil, @logdev=#<Logger::LogDevice:0x0000000716bb40 @shift_size=nil, @shift_age=nil, @filename=nil, @dev=#<StringIO:0x0000000716bc08>, @mon_owner=nil, @mon_count=0, @mon_mutex=#<Thread::Mutex:0x0000000716bb18>>>, :keys=>["{PATH}/.vagrant/machines/aem/virtualbox/private_key"]}
DEBUG ssh: == Net-SSH connection debug-level log START ==
DEBUG ssh: D, [2017-07-11T21:52:29.786812 #6860] DEBUG -- net.ssh.transport.session[38b5148]: establishing connection to 127.0.0.1:2222
D, [2017-07-11T21:52:29.788822 #6860] DEBUG -- net.ssh.transport.session[38b5148]: connection established
I, [2017-07-11T21:52:29.793829 #6860]  INFO -- net.ssh.transport.server_version[38b4a54]: negotiating protocol version
D, [2017-07-11T21:52:29.793829 #6860] DEBUG -- net.ssh.transport.server_version[38b4a54]: local is `SSH-2.0-Ruby/Net::SSH_4.1.0 x64-mingw32'
D, [2017-07-11T21:52:29.805203 #6860] DEBUG -- net.ssh.transport.server_version[38b4a54]: remote is `SSH-2.0-OpenSSH_6.6.1'
I, [2017-07-11T21:52:29.806221 #6860]  INFO -- net.ssh.transport.algorithms[38b41bc]: sending KEXINIT
D, [2017-07-11T21:52:29.806221 #6860] DEBUG -- socket[38b4eb4]: queueing packet nr 0 type 20 len 1156
D, [2017-07-11T21:52:29.807181 #6860] DEBUG -- socket[38b4eb4]: sent 1160 bytes
D, [2017-07-11T21:52:29.807181 #6860] DEBUG -- socket[38b4eb4]: read 1640 bytes
D, [2017-07-11T21:52:29.807181 #6860] DEBUG -- socket[38b4eb4]: received packet nr 0 type 20 len 1636
I, [2017-07-11T21:52:29.807181 #6860]  INFO -- net.ssh.transport.algorithms[38b41bc]: got KEXINIT from server
I, [2017-07-11T21:52:29.807181 #6860]  INFO -- net.ssh.transport.algorithms[38b41bc]: negotiating algorithms
D, [2017-07-11T21:52:29.807181 #6860] DEBUG -- net.ssh.transport.algorithms[38b41bc]: negotiated:
* kex: diffie-hellman-group-exchange-sha1
* host_key: ssh-rsa
* encryption_server: aes128-cbc
* encryption_client: aes128-cbc
* hmac_client: hmac-sha1
* hmac_server: hmac-sha1
* compression_client: none
* compression_server: none
* language_client:
* language_server:
D, [2017-07-11T21:52:29.807181 #6860] DEBUG -- net.ssh.transport.algorithms[38b41bc]: exchanging keys
D, [2017-07-11T21:52:29.807181 #6860] DEBUG -- socket[38b4eb4]: queueing packet nr 1 type 34 len 20
D, [2017-07-11T21:52:29.808146 #6860] DEBUG -- socket[38b4eb4]: sent 24 bytes
D, [2017-07-11T21:52:29.818980 #6860] DEBUG -- socket[38b4eb4]: read 152 bytes
D, [2017-07-11T21:52:29.818980 #6860] DEBUG -- socket[38b4eb4]: received packet nr 1 type 31 len 148
D, [2017-07-11T21:52:29.819921 #6860] DEBUG -- socket[38b4eb4]: queueing packet nr 2 type 32 len 140
D, [2017-07-11T21:52:29.819921 #6860] DEBUG -- socket[38b4eb4]: sent 144 bytes
D, [2017-07-11T21:52:29.830758 #6860] DEBUG -- socket[38b4eb4]: read 720 bytes
D, [2017-07-11T21:52:29.830758 #6860] DEBUG -- socket[38b4eb4]: received packet nr 2 type 33 len 700
D, [2017-07-11T21:52:29.831697 #6860] DEBUG -- socket[38b4eb4]: queueing packet nr 3 type 21 len 20
D, [2017-07-11T21:52:29.831697 #6860] DEBUG -- socket[38b4eb4]: sent 24 bytes
D, [2017-07-11T21:52:29.831697 #6860] DEBUG -- socket[38b4eb4]: received packet nr 3 type 21 len 12
D, [2017-07-11T21:52:29.831697 #6860] DEBUG -- net.ssh.authentication.session[1f8bce4]: beginning authentication of `vagrant'
D, [2017-07-11T21:52:29.831697 #6860] DEBUG -- socket[38b4eb4]: queueing packet nr 4 type 5 len 28
D, [2017-07-11T21:52:29.832678 #6860] DEBUG -- socket[38b4eb4]: sent 52 bytes
D, [2017-07-11T21:52:29.843615 #6860] DEBUG -- socket[38b4eb4]: read 52 bytes
D, [2017-07-11T21:52:29.843615 #6860] DEBUG -- socket[38b4eb4]: received packet nr 4 type 6 len 28
D, [2017-07-11T21:52:29.843615 #6860] DEBUG -- net.ssh.authentication.session[1f8bce4]: trying none
D, [2017-07-11T21:52:29.844551 #6860] DEBUG -- socket[38b4eb4]: queueing packet nr 5 type 50 len 44
D, [2017-07-11T21:52:29.844551 #6860] DEBUG -- socket[38b4eb4]: sent 68 bytes
D, [2017-07-11T21:52:51.849659 #6860] DEBUG -- socket[38b4eb4]: read 84 bytes
D, [2017-07-11T21:52:51.849659 #6860] DEBUG -- socket[38b4eb4]: received packet nr 5 type 51 len 60
D, [2017-07-11T21:52:51.849659 #6860] DEBUG -- net.ssh.authentication.session[1f8bce4]: allowed methods: publickey,gssapi-keyex,gssapi-with-mic,password
D, [2017-07-11T21:52:51.849659 #6860] DEBUG -- net.ssh.authentication.methods.none[1f8a8d0]: none failed
D, [2017-07-11T21:52:51.850599 #6860] DEBUG -- net.ssh.authentication.session[1f8bce4]: trying publickey
D, [2017-07-11T21:52:51.850599 #6860] DEBUG -- net.ssh.authentication.agent[38ecf94]: connecting to ssh-agent
D, [2017-07-11T21:52:51.851581 #6860] DEBUG -- net.ssh.authentication.agent[38ecf94]: sending agent request 1 len 43
D, [2017-07-11T21:52:51.851581 #6860] DEBUG -- net.ssh.authentication.agent[38ecf94]: received agent packet 2 len 5
D, [2017-07-11T21:52:51.851581 #6860] DEBUG -- net.ssh.authentication.agent[38ecf94]: sending agent request 11 len 0
D, [2017-07-11T21:52:51.852577 #6860] DEBUG -- net.ssh.authentication.agent[38ecf94]: received agent packet 12 len 306
D, [2017-07-11T21:52:51.852577 #6860] DEBUG -- net.ssh.authentication.methods.publickey[38ed278]: trying publickey (c4:cd:b6:43:ef:8d:27:8a:78:10:23:1a:b3:e0:f0:9e)
D, [2017-07-11T21:52:51.852577 #6860] DEBUG -- socket[38b4eb4]: queueing packet nr 6 type 50 len 348
D, [2017-07-11T21:52:51.853543 #6860] DEBUG -- socket[38b4eb4]: sent 372 bytes
D, [2017-07-11T21:52:51.864379 #6860] DEBUG -- socket[38b4eb4]: read 324 bytes
D, [2017-07-11T21:52:51.864379 #6860] DEBUG -- socket[38b4eb4]: received packet nr 6 type 60 len 300
D, [2017-07-11T21:52:51.865319 #6860] DEBUG -- socket[38b4eb4]: queueing packet nr 7 type 50 len 620
D, [2017-07-11T21:52:51.866300 #6860] DEBUG -- socket[38b4eb4]: sent 644 bytes
D, [2017-07-11T21:52:56.355255 #6860] DEBUG -- socket[38b4eb4]: read 36 bytes
D, [2017-07-11T21:52:56.355255 #6860] DEBUG -- socket[38b4eb4]: received packet nr 7 type 52 len 12
D, [2017-07-11T21:52:56.355255 #6860] DEBUG -- net.ssh.authentication.methods.publickey[38ed278]: publickey succeeded (c4:cd:b6:43:ef:8d:27:8a:78:10:23:1a:b3:e0:f0:9e)

DEBUG ssh: == Net-SSH connection debug-level log END ==
 INFO ssh: Execute: grep 'Amazon Linux AMI' /etc/os-release (sudo=false)
DEBUG ssh: Sending SSH keep-alive...
DEBUG ssh: Sending SSH keep-alive...
DEBUG ssh: Sending SSH keep-alive...
DEBUG ssh: Sending SSH keep-alive...
DEBUG ssh: stderr: 41e57d38-b4f7-4e46-9c38-13873d338b86-vagrant-ssh
DEBUG ssh: Exit status: 1
DEBUG guest: Trying: fedora
 INFO ssh: Connection errored, not re-using. Will reconnect.
DEBUG ssh: #<Timeout::Error: execution expired>
 INFO subprocess: Starting process: ["C:/Program Files/Oracle/VirtualBox/VBoxManage.exe", "showvminfo", "8fb5c87b-1a3c-435e-8660-4efac27fd04f", "--machinereadable"]
 INFO subprocess: Command not in installer, restoring original environment...
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: name="{CLIENT}"
groups="/"
ostype="Red Hat (64-bit)"
UUID="8fb5c87b-1a3c-435e-8660-4efac27fd04f"
CfgFile="{HOMEDIR}\\VirtualBox VMs\\{CLIENT}\\{CLIENT}.vbox"
SnapFldr="{HOMEDIR}\\VirtualBox VMs\\{CLIENT}\\Snapshots"
LogFldr="{HOMEDIR}\\VirtualBox VMs\\{CLIENT}\\Logs"
hardwareuuid="8fb5c87b-1a3c-435e-8660-4efac27fd04f"
memory=8192
pagefusion="off"
vram=8
cpuexecutioncap=90
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=2
pae="on"
longmode="on"
triplefaultreset="off"
apic="on"
x2apic="on"
cpuid-portability-level=0
bootmenu="messageandmenu"
boot1="disk"
boot2="dvd"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
biosapic="apic"
biossystemtimeoffset=0
rtcuseutc="on"
hwvirtex="on"
nestedpaging="on"
largepages="on"
vtxvpid="on"
vtxux="on"
paravirtprovider="default"
effparavirtprovider="kvm"
VMState="running"
VMStateChangeTime="2017-07-11T19:12:38.999000000"
monitorcount=1
accelerate3d="off"
accelerate2dvideo="off"
teleporterenabled="off"
teleporterport=0
teleporteraddress=""
teleporterpassword=""
tracing-enabled="off"
tracing-allow-vm-access="off"
tracing-config=""
autostart-enabled="off"
autostart-delay=0
defaultfrontend=""
storagecontrollername0="IDE Controller"
storagecontrollertype0="PIIX4"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="2"
storagecontrollerportcount0="2"
storagecontrollerbootable0="on"
"IDE Controller-0-0"="{HOMEDIR}\VirtualBox VMs\{CLIENT}\Snapshots\{d60e1cd8-b069-4de1-8be5-b0e345172bb5}.vmdk"
"IDE Controller-ImageUUID-0-0"="d60e1cd8-b069-4de1-8be5-b0e345172bb5"
"IDE Controller-0-1"="none"
"IDE Controller-1-0"="none"
"IDE Controller-1-1"="none"
natnet1="nat"
macaddress1="080027DB3827"
cableconnected1="on"
nic1="nat"
nictype1="82540EM"
nicspeed1="0"
mtu="0"
sockSnd="64"
sockRcv="64"
tcpWndSnd="64"
tcpWndRcv="64"
Forwarding(0)="ssh,tcp,127.0.0.1,2222,,22"
Forwarding(1)="tcp4502,tcp,,4502,,4502"
Forwarding(2)="tcp4503,tcp,,4503,,4503"
Forwarding(3)="tcp4512,tcp,,4512,,4512"
Forwarding(4)="tcp4513,tcp,,4513,,4513"
Forwarding(5)="tcp4592,tcp,,4592,,4592"
Forwarding(6)="tcp4593,tcp,,4593,,4593"
Forwarding(7)="tcp80,tcp,,80,,80"
hostonlyadapter2="VirtualBox Host-Only Ethernet Adapter #2"
macaddress2="080027E33CE9"
cableconnected2="on"
nic2="hostonly"
nictype2="82540EM"
nicspeed2="0"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
uart3="off"
uart4="off"
lpt1="off"
lpt2="off"
audio="dsound"
clipboard="disabled"
draganddrop="disabled"
SessionName="GUI/Qt"
VideoMode="720,400,0"@0,0 1
vrde="on"
vrdeport=-1
vrdeports="5993"
vrdeaddress="127.0.0.1"
vrdeauthtype="null"
vrdemulticon="off"
vrdereusecon="off"
vrdevideochannel="off"
usb="off"
ehci="off"
xhci="off"
SharedFolderNameMachineMapping1="opt_install_files_.m2"
SharedFolderPathMachineMapping1="\\?\{PATH}\.m2"
SharedFolderNameMachineMapping2="vagrant"
SharedFolderPathMachineMapping2="\\?\{PATH}"
SharedFolderNameMachineMapping3="tmp_vagrant-puppet_manifests-c42ae094895da5204ae8ca79060e21be"
SharedFolderPathMachineMapping3="\\?\{PATH}\{cl}\manifests"
SharedFolderNameMachineMapping4="tmp_vagrant-puppet_modules-8aacd06f3b51f2d5a279df0bc5bad14c"
SharedFolderPathMachineMapping4="\\?\{PATH}\aem\modules"
SharedFolderNameMachineMapping5="tmp_vagrant-puppet_modules-314ccd1cdb56ec0df1fdca485ce2b133"
SharedFolderPathMachineMapping5="\\?\{PATH}\{co}\modules"
SharedFolderNameMachineMapping6="tmp_vagrant-puppet_modules-d67d2193e39b036974d2702de8a29251"
SharedFolderPathMachineMapping6="\\?\{PATH}\{cl}\modules"
VRDEActiveConnection="off"
VRDEClients=0
vcpenabled="off"
vcpscreens=0
vcpfile="{HOMEDIR}\VirtualBox VMs\{CLIENT}\{CLIENT}.webm"
vcpwidth=1024
vcpheight=768
vcprate=512
vcpfps=25
GuestMemoryBalloon=0
GuestOSType="Linux26_64"
GuestAdditionsRunLevel=2
GuestAdditionsVersion="5.1.22 r115126"
GuestAdditionsFacility_VirtualBox Base Driver=50,1499800369660
GuestAdditionsFacility_VirtualBox System Service=50,1499800371231
GuestAdditionsFacility_Seamless Mode=0,1499800369659
GuestAdditionsFacility_Graphics Mode=0,1499800369659
SnapshotName="provisioned"
SnapshotUUID="be827bcf-71a0-4fb1-902d-7e5e9db7f626"
SnapshotName-1="up-working"
SnapshotUUID-1="9185f063-c82b-4b37-a591-f64ab8fee94f"
CurrentSnapshotName="up-working"
CurrentSnapshotUUID="9185f063-c82b-4b37-a591-f64ab8fee94f"
CurrentSnapshotNode="SnapshotName-1"
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 31999
DEBUG subprocess: Exit status: 0
DEBUG virtualbox_5_1: Searching for SSH port: 22
DEBUG virtualbox_5_1: read_forward_ports: uuid=8fb5c87b-1a3c-435e-8660-4efac27fd04f active_only=false
 INFO subprocess: Starting process: ["C:/Program Files/Oracle/VirtualBox/VBoxManage.exe", "showvminfo", "8fb5c87b-1a3c-435e-8660-4efac27fd04f", "--machinereadable"]
 INFO subprocess: Command not in installer, restoring original environment...
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: name="{CLIENT}"
groups="/"
ostype="Red Hat (64-bit)"
UUID="8fb5c87b-1a3c-435e-8660-4efac27fd04f"
CfgFile="{HOMEDIR}\\VirtualBox VMs\\{CLIENT}\\{CLIENT}.vbox"
SnapFldr="{HOMEDIR}\\VirtualBox VMs\\{CLIENT}\\Snapshots"
LogFldr="{HOMEDIR}\\VirtualBox VMs\\{CLIENT}\\Logs"
hardwareuuid="8fb5c87b-1a3c-435e-8660-4efac27fd04f"
memory=8192
pagefusion="off"
vram=8
cpuexecutioncap=90
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=2
pae="on"
longmode="on"
triplefaultreset="off"
apic="on"
x2apic="on"
cpuid-portability-level=0
bootmenu="messageandmenu"
boot1="disk"
boot2="dvd"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
biosapic="apic"
biossystemtimeoffset=0
rtcuseutc="on"
hwvirtex="on"
nestedpaging="on"
largepages="on"
vtxvpid="on"
vtxux="on"
paravirtprovider="default"
effparavirtprovider="kvm"
VMState="running"
VMStateChangeTime="2017-07-11T19:12:38.999000000"
monitorcount=1
accelerate3d="off"
accelerate2dvideo="off"
teleporterenabled="off"
teleporterport=0
teleporteraddress=""
teleporterpassword=""
tracing-enabled="off"
tracing-allow-vm-access="off"
tracing-config=""
autostart-enabled="off"
autostart-delay=0
defaultfrontend=""
storagecontrollername0="IDE Controller"
storagecontrollertype0="PIIX4"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="2"
storagecontrollerportcount0="2"
storagecontrollerbootable0="on"
"IDE Controller-0-0"="{HOMEDIR}\VirtualBox VMs\{CLIENT}\Snapshots\{d60e1cd8-b069-4de1-8be5-b0e345172bb5}.vmdk"
"IDE Controller-ImageUUID-0-0"="d60e1cd8-b069-4de1-8be5-b0e345172bb5"
"IDE Controller-0-1"="none"
"IDE Controller-1-0"="none"
"IDE Controller-1-1"="none"
natnet1="nat"
macaddress1="080027DB3827"
cableconnected1="on"
nic1="nat"
nictype1="82540EM"
nicspeed1="0"
mtu="0"
sockSnd="64"
sockRcv="64"
tcpWndSnd="64"
tcpWndRcv="64"
Forwarding(0)="ssh,tcp,127.0.0.1,2222,,22"
Forwarding(1)="tcp4502,tcp,,4502,,4502"
Forwarding(2)="tcp4503,tcp,,4503,,4503"
Forwarding(3)="tcp4512,tcp,,4512,,4512"
Forwarding(4)="tcp4513,tcp,,4513,,4513"
Forwarding(5)="tcp4592,tcp,,4592,,4592"
Forwarding(6)="tcp4593,tcp,,4593,,4593"
Forwarding(7)="tcp80,tcp,,80,,80"
hostonlyadapter2="VirtualBox Host-Only Ethernet Adapter #2"
macaddress2="080027E33CE9"
cableconnected2="on"
nic2="hostonly"
nictype2="82540EM"
nicspeed2="0"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
uart3="off"
uart4="off"
lpt1="off"
lpt2="off"
audio="dsound"
clipboard="disabled"
draganddrop="disabled"
SessionName="GUI/Qt"
VideoMode="720,400,0"@0,0 1
vrde="on"
vrdeport=-1
vrdeports="5993"
vrdeaddress="127.0.0.1"
vrdeauthtype="null"
vrdemulticon="off"
vrdereusecon="off"
vrdevideochannel="off"
usb="off"
ehci="off"
xhci="off"
SharedFolderNameMachineMapping1="opt_install_files_.m2"
SharedFolderPathMachineMapping1="\\?\{PATH}\.m2"
SharedFolderNameMachineMapping2="vagrant"
SharedFolderPathMachineMapping2="\\?\{PATH}"
SharedFolderNameMachineMapping3="tmp_vagrant-puppet_manifests-c42ae094895da5204ae8ca79060e21be"
SharedFolderPathMachineMapping3="\\?\{PATH}\{cl}\manifests"
SharedFolderNameMachineMapping4="tmp_vagrant-puppet_modules-8aacd06f3b51f2d5a279df0bc5bad14c"
SharedFolderPathMachineMapping4="\\?\{PATH}\aem\modules"
SharedFolderNameMachineMapping5="tmp_vagrant-puppet_modules-314ccd1cdb56ec0df1fdca485ce2b133"
SharedFolderPathMachineMapping5="\\?\{PATH}\{co}\modules"
SharedFolderNameMachineMapping6="tmp_vagrant-puppet_modules-d67d2193e39b036974d2702de8a29251"
SharedFolderPathMachineMapping6="\\?\{PATH}\{cl}\modules"
VRDEActiveConnection="off"
VRDEClients=0
vcpenabled="off"
vcpscreens=0
vcpfile="{HOMEDIR}\VirtualBox VMs\{CLIENT}\{CLIENT}.webm"
vcpwidth=1024
vcpheight=768
vcprate=512
vcpfps=25
GuestMemoryBalloon=0
GuestOSType="Linux26_64"
GuestAdditionsRunLevel=2
GuestAdditionsVersion="5.1.22 r115126"
GuestAdditionsFacility_VirtualBox Base Driver=50,1499800369660
GuestAdditionsFacility_VirtualBox System Service=50,1499800371231
GuestAdditionsFacility_Seamless Mode=0,1499800369659
GuestAdditionsFacility_Graphics Mode=0,1499800369659
SnapshotName="provisioned"
SnapshotUUID="be827bcf-71a0-4fb1-902d-7e5e9db7f626"
SnapshotName-1="up-working"
SnapshotUUID-1="9185f063-c82b-4b37-a591-f64ab8fee94f"
CurrentSnapshotName="up-working"
CurrentSnapshotUUID="9185f063-c82b-4b37-a591-f64ab8fee94f"
CurrentSnapshotNode="SnapshotName-1"
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 31999
DEBUG subprocess: Exit status: 0
DEBUG virtualbox_5_1:   - [1, "ssh", 2222, 22, "127.0.0.1"]
DEBUG virtualbox_5_1:   - [1, "tcp4502", 4502, 4502, ""]
DEBUG virtualbox_5_1:   - [1, "tcp4503", 4503, 4503, ""]
DEBUG virtualbox_5_1:   - [1, "tcp4512", 4512, 4512, ""]
DEBUG virtualbox_5_1:   - [1, "tcp4513", 4513, 4513, ""]
DEBUG virtualbox_5_1:   - [1, "tcp4592", 4592, 4592, ""]
DEBUG virtualbox_5_1:   - [1, "tcp4593", 4593, 4593, ""]
DEBUG virtualbox_5_1:   - [1, "tcp80", 80, 80, ""]
 INFO ssh: Attempting SSH connection...
 INFO ssh: Attempting to connect to SSH...
 INFO ssh:   - Host: 127.0.0.1
 INFO ssh:   - Port: 2222
 INFO ssh:   - Username: vagrant
 INFO ssh:   - Password? false
 INFO ssh:   - Key Path: ["{PATH}/.vagrant/machines/aem/virtualbox/private_key"]
DEBUG ssh:   - connect_opts: {:auth_methods=>["none", "hostbased", "publickey"], :config=>false, :forward_agent=>false, :send_env=>false, :keys_only=>true, :paranoid=>false, :password=>nil, :port=>2222, :timeout=>15, :user_known_hosts_file=>[], :verbose=>:debug, :encryption=>["aes128-cbc", "3des-cbc", "blowfish-cbc", "cast128-cbc", "aes192-cbc", "aes256-cbc", "[email protected]", "idea-cbc", "arcfour128", "arcfour256", "arcfour", "aes128-ctr", "aes192-ctr", "aes256-ctr", "cast128-ctr", "blowfish-ctr", "3des-ctr", "none"], :logger=>#<Logger:0x000000073bc958 @progname=nil, @level=0, @default_formatter=#<Logger::Formatter:0x000000073bc930 @datetime_format=nil>, @formatter=nil, @logdev=#<Logger::LogDevice:0x000000073bc8e0 @shift_size=nil, @shift_age=nil, @filename=nil, @dev=#<StringIO:0x000000073bc9a8>, @mon_owner=nil, @mon_count=0, @mon_mutex=#<Thread::Mutex:0x000000073bc8b8>>>, :keys=>["{PATH}/.vagrant/machines/aem/virtualbox/private_key"]}
DEBUG ssh: == Net-SSH connection debug-level log START ==
DEBUG ssh: D, [2017-07-11T21:53:24.114946 #6860] DEBUG -- net.ssh.transport.session[39e38bc]: establishing connection to 127.0.0.1:2222
D, [2017-07-11T21:53:24.115923 #6860] DEBUG -- net.ssh.transport.session[39e38bc]: connection established
I, [2017-07-11T21:53:24.115923 #6860]  INFO -- net.ssh.transport.server_version[39e31c8]: negotiating protocol version
D, [2017-07-11T21:53:24.116902 #6860] DEBUG -- net.ssh.transport.server_version[39e31c8]: local is `SSH-2.0-Ruby/Net::SSH_4.1.0 x64-mingw32'
D, [2017-07-11T21:53:24.138492 #6860] DEBUG -- net.ssh.transport.server_version[39e31c8]: remote is `SSH-2.0-OpenSSH_6.6.1'
I, [2017-07-11T21:53:24.138492 #6860]  INFO -- net.ssh.transport.algorithms[39e2930]: sending KEXINIT
D, [2017-07-11T21:53:24.138492 #6860] DEBUG -- socket[39e3628]: queueing packet nr 0 type 20 len 1156
D, [2017-07-11T21:53:24.138492 #6860] DEBUG -- socket[39e3628]: sent 1160 bytes
D, [2017-07-11T21:53:24.139477 #6860] DEBUG -- socket[39e3628]: read 1640 bytes
D, [2017-07-11T21:53:24.139477 #6860] DEBUG -- socket[39e3628]: received packet nr 0 type 20 len 1636
I, [2017-07-11T21:53:24.139477 #6860]  INFO -- net.ssh.transport.algorithms[39e2930]: got KEXINIT from server
I, [2017-07-11T21:53:24.139477 #6860]  INFO -- net.ssh.transport.algorithms[39e2930]: negotiating algorithms
D, [2017-07-11T21:53:24.139477 #6860] DEBUG -- net.ssh.transport.algorithms[39e2930]: negotiated:
* kex: diffie-hellman-group-exchange-sha1
* host_key: ssh-rsa
* encryption_server: aes128-cbc
* encryption_client: aes128-cbc
* hmac_client: hmac-sha1
* hmac_server: hmac-sha1
* compression_client: none
* compression_server: none
* language_client:
* language_server:
D, [2017-07-11T21:53:24.139477 #6860] DEBUG -- net.ssh.transport.algorithms[39e2930]: exchanging keys
D, [2017-07-11T21:53:24.140455 #6860] DEBUG -- socket[39e3628]: queueing packet nr 1 type 34 len 20
D, [2017-07-11T21:53:24.140455 #6860] DEBUG -- socket[39e3628]: sent 24 bytes
D, [2017-07-11T21:53:24.150835 #6860] DEBUG -- socket[39e3628]: read 152 bytes
D, [2017-07-11T21:53:24.151337 #6860] DEBUG -- socket[39e3628]: received packet nr 1 type 31 len 148
D, [2017-07-11T21:53:24.153345 #6860] DEBUG -- socket[39e3628]: queueing packet nr 2 type 32 len 140
D, [2017-07-11T21:53:24.153863 #6860] DEBUG -- socket[39e3628]: sent 144 bytes
D, [2017-07-11T21:53:24.164434 #6860] DEBUG -- socket[39e3628]: read 720 bytes
D, [2017-07-11T21:53:24.164894 #6860] DEBUG -- socket[39e3628]: received packet nr 2 type 33 len 700
D, [2017-07-11T21:53:24.164894 #6860] DEBUG -- socket[39e3628]: queueing packet nr 3 type 21 len 20
D, [2017-07-11T21:53:24.164894 #6860] DEBUG -- socket[39e3628]: sent 24 bytes
D, [2017-07-11T21:53:24.165878 #6860] DEBUG -- socket[39e3628]: received packet nr 3 type 21 len 12
D, [2017-07-11T21:53:24.165878 #6860] DEBUG -- net.ssh.authentication.session[3a39320]: beginning authentication of `vagrant'
D, [2017-07-11T21:53:24.166860 #6860] DEBUG -- socket[39e3628]: queueing packet nr 4 type 5 len 28
D, [2017-07-11T21:53:24.166860 #6860] DEBUG -- socket[39e3628]: sent 52 bytes
D, [2017-07-11T21:53:24.177696 #6860] DEBUG -- socket[39e3628]: read 52 bytes
D, [2017-07-11T21:53:24.177696 #6860] DEBUG -- socket[39e3628]: received packet nr 4 type 6 len 28
D, [2017-07-11T21:53:24.177696 #6860] DEBUG -- net.ssh.authentication.session[3a39320]: trying none
D, [2017-07-11T21:53:24.178635 #6860] DEBUG -- socket[39e3628]: queueing packet nr 5 type 50 len 44
D, [2017-07-11T21:53:24.178635 #6860] DEBUG -- socket[39e3628]: sent 68 bytes
D, [2017-07-11T21:53:48.464826 #6860] DEBUG -- socket[39e3628]: read 84 bytes
D, [2017-07-11T21:53:48.464826 #6860] DEBUG -- socket[39e3628]: received packet nr 5 type 51 len 60
D, [2017-07-11T21:53:48.464826 #6860] DEBUG -- net.ssh.authentication.session[3a39320]: allowed methods: publickey,gssapi-keyex,gssapi-with-mic,password
D, [2017-07-11T21:53:48.465650 #6860] DEBUG -- net.ssh.authentication.methods.none[3a38484]: none failed
D, [2017-07-11T21:53:48.465650 #6860] DEBUG -- net.ssh.authentication.session[3a39320]: trying publickey
D, [2017-07-11T21:53:48.466661 #6860] DEBUG -- net.ssh.authentication.agent[3a3d0ec]: connecting to ssh-agent
D, [2017-07-11T21:53:48.466661 #6860] DEBUG -- net.ssh.authentication.agent[3a3d0ec]: sending agent request 1 len 43
D, [2017-07-11T21:53:48.467601 #6860] DEBUG -- net.ssh.authentication.agent[3a3d0ec]: received agent packet 2 len 5
D, [2017-07-11T21:53:48.467601 #6860] DEBUG -- net.ssh.authentication.agent[3a3d0ec]: sending agent request 11 len 0
D, [2017-07-11T21:53:48.467601 #6860] DEBUG -- net.ssh.authentication.agent[3a3d0ec]: received agent packet 12 len 306
D, [2017-07-11T21:53:48.467601 #6860] DEBUG -- net.ssh.authentication.methods.publickey[3a3d3d0]: trying publickey (c4:cd:b6:43:ef:8d:27:8a:78:10:23:1a:b3:e0:f0:9e)
D, [2017-07-11T21:53:48.468583 #6860] DEBUG -- socket[39e3628]: queueing packet nr 6 type 50 len 348
D, [2017-07-11T21:53:48.468583 #6860] DEBUG -- socket[39e3628]: sent 372 bytes
D, [2017-07-11T21:53:48.479376 #6860] DEBUG -- socket[39e3628]: read 324 bytes
D, [2017-07-11T21:53:48.479376 #6860] DEBUG -- socket[39e3628]: received packet nr 6 type 60 len 300
D, [2017-07-11T21:53:48.481339 #6860] DEBUG -- socket[39e3628]: queueing packet nr 7 type 50 len 620
D, [2017-07-11T21:53:48.481339 #6860] DEBUG -- socket[39e3628]: sent 644 bytes
D, [2017-07-11T21:53:55.213964 #6860] DEBUG -- socket[39e3628]: read 36 bytes
D, [2017-07-11T21:53:55.213964 #6860] DEBUG -- socket[39e3628]: received packet nr 7 type 52 len 12
D, [2017-07-11T21:53:55.213964 #6860] DEBUG -- net.ssh.authentication.methods.publickey[3a3d3d0]: publickey succeeded (c4:cd:b6:43:ef:8d:27:8a:78:10:23:1a:b3:e0:f0:9e)

DEBUG ssh: == Net-SSH connection debug-level log END ==
 INFO ssh: Execute: grep 'Fedora release' /etc/redhat-release (sudo=false)
DEBUG ssh: Sending SSH keep-alive...
DEBUG ssh: Sending SSH keep-alive...
DEBUG ssh: Sending SSH keep-alive...
DEBUG ssh: Sending SSH keep-alive...
DEBUG ssh: stderr: 41e57d38-b4f7-4e46-9c38-13873d338b86-vagrant-ssh
DEBUG ssh: Exit status: 1
DEBUG guest: Trying: funtoo
 INFO ssh: Connection errored, not re-using. Will reconnect.
DEBUG ssh: #<Timeout::Error: execution expired>
 INFO subprocess: Starting process: ["C:/Program Files/Oracle/VirtualBox/VBoxManage.exe", "showvminfo", "8fb5c87b-1a3c-435e-8660-4efac27fd04f", "--machinereadable"]
 INFO subprocess: Command not in installer, restoring original environment...
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: name="{CLIENT}"
groups="/"
ostype="Red Hat (64-bit)"
UUID="8fb5c87b-1a3c-435e-8660-4efac27fd04f"
CfgFile="{HOMEDIR}\\VirtualBox VMs\\{CLIENT}\\{CLIENT}.vbox"
SnapFldr="{HOMEDIR}\\VirtualBox VMs\\{CLIENT}\\Snapshots"
LogFldr="{HOMEDIR}\\VirtualBox VMs\\{CLIENT}\\Logs"
hardwareuuid="8fb5c87b-1a3c-435e-8660-4efac27fd04f"
memory=8192
pagefusion="off"
vram=8
cpuexecutioncap=90
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=2
pae="on"
longmode="on"
triplefaultreset="off"
apic="on"
x2apic="on"
cpuid-portability-level=0
bootmenu="messageandmenu"
boot1="disk"
boot2="dvd"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
biosapic="apic"
biossystemtimeoffset=0
rtcuseutc="on"
hwvirtex="on"
nestedpaging="on"
largepages="on"
vtxvpid="on"
vtxux="on"
paravirtprovider="default"
effparavirtprovider="kvm"
VMState="running"
VMStateChangeTime="2017-07-11T19:12:38.999000000"
monitorcount=1
accelerate3d="off"
accelerate2dvideo="off"
teleporterenabled="off"
teleporterport=0
teleporteraddress=""
teleporterpassword=""
tracing-enabled="off"
tracing-allow-vm-access="off"
tracing-config=""
autostart-enabled="off"
autostart-delay=0
defaultfrontend=""
storagecontrollername0="IDE Controller"
storagecontrollertype0="PIIX4"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="2"
storagecontrollerportcount0="2"
storagecontrollerbootable0="on"
"IDE Controller-0-0"="{HOMEDIR}\VirtualBox VMs\{CLIENT}\Snapshots\{d60e1cd8-b069-4de1-8be5-b0e345172bb5}.vmdk"
"IDE Controller-ImageUUID-0-0"="d60e1cd8-b069-4de1-8be5-b0e345172bb5"
"IDE Controller-0-1"="none"
"IDE Controller-1-0"="none"
"IDE Controller-1-1"="none"
natnet1="nat"
macaddress1="080027DB3827"
cableconnected1="on"
nic1="nat"
nictype1="82540EM"
nicspeed1="0"
mtu="0"
sockSnd="64"
sockRcv="64"
tcpWndSnd="64"
tcpWndRcv="64"
Forwarding(0)="ssh,tcp,127.0.0.1,2222,,22"
Forwarding(1)="tcp4502,tcp,,4502,,4502"
Forwarding(2)="tcp4503,tcp,,4503,,4503"
Forwarding(3)="tcp4512,tcp,,4512,,4512"
Forwarding(4)="tcp4513,tcp,,4513,,4513"
Forwarding(5)="tcp4592,tcp,,4592,,4592"
Forwarding(6)="tcp4593,tcp,,4593,,4593"
Forwarding(7)="tcp80,tcp,,80,,80"
hostonlyadapter2="VirtualBox Host-Only Ethernet Adapter #2"
macaddress2="080027E33CE9"
cableconnected2="on"
nic2="hostonly"
nictype2="82540EM"
nicspeed2="0"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
uart3="off"
uart4="off"
lpt1="off"
lpt2="off"
audio="dsound"
clipboard="disabled"
draganddrop="disabled"
SessionName="GUI/Qt"
VideoMode="720,400,0"@0,0 1
vrde="on"
vrdeport=-1
vrdeports="5993"
vrdeaddress="127.0.0.1"
vrdeauthtype="null"
vrdemulticon="off"
vrdereusecon="off"
vrdevideochannel="off"
usb="off"
ehci="off"
xhci="off"
SharedFolderNameMachineMapping1="opt_install_files_.m2"
SharedFolderPathMachineMapping1="\\?\{PATH}\.m2"
SharedFolderNameMachineMapping2="vagrant"
SharedFolderPathMachineMapping2="\\?\{PATH}"
SharedFolderNameMachineMapping3="tmp_vagrant-puppet_manifests-c42ae094895da5204ae8ca79060e21be"
SharedFolderPathMachineMapping3="\\?\{PATH}\{cl}\manifests"
SharedFolderNameMachineMapping4="tmp_vagrant-puppet_modules-8aacd06f3b51f2d5a279df0bc5bad14c"
SharedFolderPathMachineMapping4="\\?\{PATH}\aem\modules"
SharedFolderNameMachineMapping5="tmp_vagrant-puppet_modules-314ccd1cdb56ec0df1fdca485ce2b133"
SharedFolderPathMachineMapping5="\\?\{PATH}\{co}\modules"
SharedFolderNameMachineMapping6="tmp_vagrant-puppet_modules-d67d2193e39b036974d2702de8a29251"
SharedFolderPathMachineMapping6="\\?\{PATH}\{cl}\modules"
VRDEActiveConnection="off"
VRDEClients=0
vcpenabled="off"
vcpscreens=0
vcpfile="{HOMEDIR}\VirtualBox VMs\{CLIENT}\{CLIENT}.webm"
vcpwidth=1024
vcpheight=768
vcprate=512
vcpfps=25
GuestMemoryBalloon=0
GuestOSType="Linux26_64"
GuestAdditionsRunLevel=2
GuestAdditionsVersion="5.1.22 r115126"
GuestAdditionsFacility_VirtualBox Base Driver=50,1499800369660
GuestAdditionsFacility_VirtualBox System Service=50,1499800371231
GuestAdditionsFacility_Seamless Mode=0,1499800369659
GuestAdditionsFacility_Graphics Mode=0,1499800369659
SnapshotName="provisioned"
SnapshotUUID="be827bcf-71a0-4fb1-902d-7e5e9db7f626"
SnapshotName-1="up-working"
SnapshotUUID-1="9185f063-c82b-4b37-a591-f64ab8fee94f"
CurrentSnapshotName="up-working"
CurrentSnapshotUUID="9185f063-c82b-4b37-a591-f64ab8fee94f"
CurrentSnapshotNode="SnapshotName-1"
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 31999
DEBUG subprocess: Exit status: 0
DEBUG virtualbox_5_1: Searching for SSH port: 22
DEBUG virtualbox_5_1: read_forward_ports: uuid=8fb5c87b-1a3c-435e-8660-4efac27fd04f active_only=false
 INFO subprocess: Starting process: ["C:/Program Files/Oracle/VirtualBox/VBoxManage.exe", "showvminfo", "8fb5c87b-1a3c-435e-8660-4efac27fd04f", "--machinereadable"]
 INFO subprocess: Command not in installer, restoring original environment...
DEBUG subprocess: Selecting on IO
DEBUG subprocess: stdout: name="{CLIENT}"
groups="/"
ostype="Red Hat (64-bit)"
UUID="8fb5c87b-1a3c-435e-8660-4efac27fd04f"
CfgFile="{HOMEDIR}\\VirtualBox VMs\\{CLIENT}\\{CLIENT}.vbox"
SnapFldr="{HOMEDIR}\\VirtualBox VMs\\{CLIENT}\\Snapshots"
LogFldr="{HOMEDIR}\\VirtualBox VMs\\{CLIENT}\\Logs"
hardwareuuid="8fb5c87b-1a3c-435e-8660-4efac27fd04f"
memory=8192
pagefusion="off"
vram=8
cpuexecutioncap=90
hpet="off"
chipset="piix3"
firmware="BIOS"
cpus=2
pae="on"
longmode="on"
triplefaultreset="off"
apic="on"
x2apic="on"
cpuid-portability-level=0
bootmenu="messageandmenu"
boot1="disk"
boot2="dvd"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
biosapic="apic"
biossystemtimeoffset=0
rtcuseutc="on"
hwvirtex="on"
nestedpaging="on"
largepages="on"
vtxvpid="on"
vtxux="on"
paravirtprovider="default"
effparavirtprovider="kvm"
VMState="running"
VMStateChangeTime="2017-07-11T19:12:38.999000000"
monitorcount=1
accelerate3d="off"
accelerate2dvideo="off"
teleporterenabled="off"
teleporterport=0
teleporteraddress=""
teleporterpassword=""
tracing-enabled="off"
tracing-allow-vm-access="off"
tracing-config=""
autostart-enabled="off"
autostart-delay=0
defaultfrontend=""
storagecontrollername0="IDE Controller"
storagecontrollertype0="PIIX4"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="2"
storagecontrollerportcount0="2"
storagecontrollerbootable0="on"
"IDE Controller-0-0"="{HOMEDIR}\VirtualBox VMs\{CLIENT}\Snapshots\{d60e1cd8-b069-4de1-8be5-b0e345172bb5}.vmdk"
"IDE Controller-ImageUUID-0-0"="d60e1cd8-b069-4de1-8be5-b0e345172bb5"
"IDE Controller-0-1"="none"
"IDE Controller-1-0"="none"
"IDE Controller-1-1"="none"
natnet1="nat"
macaddress1="080027DB3827"
cableconnected1="on"
nic1="nat"
nictype1="82540EM"
nicspeed1="0"
mtu="0"
sockSnd="64"
sockRcv="64"
tcpWndSnd="64"
tcpWndRcv="64"
Forwarding(0)="ssh,tcp,127.0.0.1,2222,,22"
Forwarding(1)="tcp4502,tcp,,4502,,4502"
Forwarding(2)="tcp4503,tcp,,4503,,4503"
Forwarding(3)="tcp4512,tcp,,4512,,4512"
Forwarding(4)="tcp4513,tcp,,4513,,4513"
Forwarding(5)="tcp4592,tcp,,4592,,4592"
Forwarding(6)="tcp4593,tcp,,4593,,4593"
Forwarding(7)="tcp80,tcp,,80,,80"
hostonlyadapter2="VirtualBox Host-Only Ethernet Adapter #2"
macaddress2="080027E33CE9"
cableconnected2="on"
nic2="hostonly"
nictype2="82540EM"
nicspeed2="0"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
uart3="off"
uart4="off"
lpt1="off"
lpt2="off"
audio="dsound"
clipboard="disabled"
draganddrop="disabled"
SessionName="GUI/Qt"
VideoMode="720,400,0"@0,0 1
vrde="on"
vrdeport=-1
vrdeports="5993"
vrdeaddress="127.0.0.1"
vrdeauthtype="null"
vrdemulticon="off"
vrdereusecon="off"
vrdevideochannel="off"
usb="off"
ehci="off"
xhci="off"
SharedFolderNameMachineMapping1="opt_install_files_.m2"
SharedFolderPathMachineMapping1="\\?\{PATH}\.m2"
SharedFolderNameMachineMapping2="vagrant"
SharedFolderPathMachineMapping2="\\?\{PATH}"
SharedFolderNameMachineMapping3="tmp_vagrant-puppet_manifests-c42ae094895da5204ae8ca79060e21be"
SharedFolderPathMachineMapping3="\\?\{PATH}\{cl}\manifests"
SharedFolderNameMachineMapping4="tmp_vagrant-puppet_modules-8aacd06f3b51f2d5a279df0bc5bad14c"
SharedFolderPathMachineMapping4="\\?\{PATH}\aem\modules"
SharedFolderNameMachineMapping5="tmp_vagrant-puppet_modules-314ccd1cdb56ec0df1fdca485ce2b133"
SharedFolderPathMachineMapping5="\\?\{PATH}\{co}\modules"
SharedFolderNameMachineMapping6="tmp_vagrant-puppet_modules-d67d2193e39b036974d2702de8a29251"
SharedFolderPathMachineMapping6="\\?\{PATH}\{cl}\modules"
VRDEActiveConnection="off"
VRDEClients=0
vcpenabled="off"
vcpscreens=0
vcpfile="{HOMEDIR}\VirtualBox VMs\{CLIENT}\{CLIENT}.webm"
vcpwidth=1024
vcpheight=768
vcprate=512
vcpfps=25
GuestMemoryBalloon=0
GuestOSType="Linux26_64"
GuestAdditionsRunLevel=2
GuestAdditionsVersion="5.1.22 r115126"
GuestAdditionsFacility_VirtualBox Base Driver=50,1499800369660
GuestAdditionsFacility_VirtualBox System Service=50,1499800371231
GuestAdditionsFacility_Seamless Mode=0,1499800369659
GuestAdditionsFacility_Graphics Mode=0,1499800369659
SnapshotName="provisioned"
SnapshotUUID="be827bcf-71a0-4fb1-902d-7e5e9db7f626"
SnapshotName-1="up-working"
SnapshotUUID-1="9185f063-c82b-4b37-a591-f64ab8fee94f"
CurrentSnapshotName="up-working"
CurrentSnapshotUUID="9185f063-c82b-4b37-a591-f64ab8fee94f"
CurrentSnapshotNode="SnapshotName-1"
DEBUG subprocess: Waiting for process to exit. Remaining to timeout: 31999
DEBUG subprocess: Exit status: 0
DEBUG virtualbox_5_1:   - [1, "ssh", 2222, 22, "127.0.0.1"]
DEBUG virtualbox_5_1:   - [1, "tcp4502", 4502, 4502, ""]
DEBUG virtualbox_5_1:   - [1, "tcp4503", 4503, 4503, ""]
DEBUG virtualbox_5_1:   - [1, "tcp4512", 4512, 4512, ""]
DEBUG virtualbox_5_1:   - [1, "tcp4513", 4513, 4513, ""]
DEBUG virtualbox_5_1:   - [1, "tcp4592", 4592, 4592, ""]
DEBUG virtualbox_5_1:   - [1, "tcp4593", 4593, 4593, ""]
DEBUG virtualbox_5_1:   - [1, "tcp80", 80, 80, ""]
 INFO ssh: Attempting SSH connection...
 INFO ssh: Attempting to connect to SSH...
 INFO ssh:   - Host: 127.0.0.1
 INFO ssh:   - Port: 2222
 INFO ssh:   - Username: vagrant
 INFO ssh:   - Password? false
 INFO ssh:   - Key Path: ["{PATH}/.vagrant/machines/aem/virtualbox/private_key"]
DEBUG ssh:   - connect_opts: {:auth_methods=>["none", "hostbased", "publickey"], :config=>false, :forward_agent=>false, :send_env=>false, :keys_only=>true, :paranoid=>false, :password=>nil, :port=>2222, :timeout=>15, :user_known_hosts_file=>[], :verbose=>:debug, :encryption=>["aes128-cbc", "3des-cbc", "blowfish-cbc", "cast128-cbc", "aes192-cbc", "aes256-cbc", "[email protected]", "idea-cbc", "arcfour128", "arcfour256", "arcfour", "aes128-ctr", "aes192-ctr", "aes256-ctr", "cast128-ctr", "blowfish-ctr", "3des-ctr", "none"], :logger=>#<Logger:0x0000000731cca0 @progname=nil, @level=0, @default_formatter=#<Logger::Formatter:0x0000000731cc78 @datetime_format=nil>, @formatter=nil, @logdev=#<Logger::LogDevice:0x0000000731cc28 @shift_size=nil, @shift_age=nil, @filename=nil, @dev=#<StringIO:0x0000000731ccf0>, @mon_owner=nil, @mon_count=0, @mon_mutex=#<Thread::Mutex:0x0000000731cc00>>>, :keys=>["{PATH}/.vagrant/machines/aem/virtualbox/private_key"]}
DEBUG ssh: == Net-SSH connection debug-level log START ==
DEBUG ssh: D, [2017-07-11T21:54:22.890072 #6860] DEBUG -- net.ssh.transport.session[3973990]: establishing connection to 127.0.0.1:2222
D, [2017-07-11T21:54:22.893017 #6860] DEBUG -- net.ssh.transport.session[3973990]: connection established
I, [2017-07-11T21:54:22.896944 #6860]  INFO -- net.ssh.transport.server_version[3973184]: negotiating protocol version
D, [2017-07-11T21:54:22.896944 #6860] DEBUG -- net.ssh.transport.server_version[3973184]: local is `SSH-2.0-Ruby/Net::SSH_4.1.0 x64-mingw32'
D, [2017-07-11T21:54:22.908718 #6860] DEBUG -- net.ssh.transport.server_version[3973184]: remote is `SSH-2.0-OpenSSH_6.6.1'
I, [2017-07-11T21:54:22.909708 #6860]  INFO -- net.ssh.transport.algorithms[39728d8]: sending KEXINIT
D, [2017-07-11T21:54:22.910680 #6860] DEBUG -- socket[39736fc]: queueing packet nr 0 type 20 len 1156
D, [2017-07-11T21:54:22.910680 #6860] DEBUG -- socket[39736fc]: sent 1160 bytes
D, [2017-07-11T21:54:22.914606 #6860] DEBUG -- socket[39736fc]: read 1640 bytes
D, [2017-07-11T21:54:22.914606 #6860] DEBUG -- socket[39736fc]: received packet nr 0 type 20 len 1636
I, [2017-07-11T21:54:22.914606 #6860]  INFO -- net.ssh.transport.algorithms[39728d8]: got KEXINIT from server
I, [2017-07-11T21:54:22.914606 #6860]  INFO -- net.ssh.transport.algorithms[39728d8]: negotiating algorithms
D, [2017-07-11T21:54:22.914606 #6860] DEBUG -- net.ssh.transport.algorithms[39728d8]: negotiated:
* kex: diffie-hellman-group-exchange-sha1
* host_key: ssh-rsa
* encryption_server: aes128-cbc
* encryption_client: aes128-cbc
* hmac_client: hmac-sha1
* hmac_server: hmac-sha1
* compression_client: none
* compression_server: none
* language_client:
* language_server:
D, [2017-07-11T21:54:22.914606 #6860] DEBUG -- net.ssh.transport.algorithms[39728d8]: exchanging keys
D, [2017-07-11T21:54:22.915588 #6860] DEBUG -- socket[39736fc]: queueing packet nr 1 type 34 len 20
D, [2017-07-11T21:54:22.915588 #6860] DEBUG -- socket[39736fc]: sent 24 bytes
D, [2017-07-11T21:54:22.926470 #6860] DEBUG -- socket[39736fc]: read 152 bytes
D, [2017-07-11T21:54:22.926470 #6860] DEBUG -- socket[39736fc]: received packet nr 1 type 31 len 148
D, [2017-07-11T21:54:22.928346 #6860] DEBUG -- socket[39736fc]: queueing packet nr 2 type 32 len 140
D, [2017-07-11T21:54:22.928346 #6860] DEBUG -- socket[39736fc]: sent 144 bytes
D, [2017-07-11T21:54:22.939138 #6860] DEBUG -- socket[39736fc]: read 720 bytes
D, [2017-07-11T21:54:22.939138 #6860] DEBUG -- socket[39736fc]: received packet nr 2 type 33 len 700
D, [2017-07-11T21:54:22.939138 #6860] DEBUG -- socket[39736fc]: queueing packet nr 3 type 21 len 20
D, [2017-07-11T21:54:22.940120 #6860] DEBUG -- socket[39736fc]: sent 24 bytes
D, [2017-07-11T21:54:22.940120 #6860] DEBUG -- socket[39736fc]: received packet nr 3 type 21 len 12
D, [2017-07-11T21:54:22.941103 #6860] DEBUG -- net.ssh.authentication.session[38392dc]: beginning authentication of `vagrant'
D, [2017-07-11T21:54:22.942084 #6860] DEBUG -- socket[39736fc]: queueing packet nr 4 type 5 len 28
D, [2017-07-11T21:54:22.942084 #6860] DEBUG -- socket[39736fc]: sent 52 bytes
D, [2017-07-11T21:54:22.952994 #6860] DEBUG -- socket[39736fc]: read 52 bytes
D, [2017-07-11T21:54:22.953531 #6860] DEBUG -- socket[39736fc]: received packet nr 4 type 6 len 28
D, [2017-07-11T21:54:22.954504 #6860] DEBUG -- net.ssh.authentication.session[38392dc]: trying none
D, [2017-07-11T21:54:22.954999 #6860] DEBUG -- socket[39736fc]: queueing packet nr 5 type 50 len 44
D, [2017-07-11T21:54:22.954999 #6860] DEBUG -- socket[39736fc]: sent 68 bytes
D, [2017-07-11T21:54:52.759314 #6860] DEBUG -- socket[39736fc]: read 84 bytes
D, [2017-07-11T21:54:52.759314 #6860] DEBUG -- socket[39736fc]: received packet nr 5 type 51 len 60
D, [2017-07-11T21:54:52.759314 #6860] DEBUG -- net.ssh.authentication.session[38392dc]: allowed methods: publickey,gssapi-keyex,gssapi-with-mic,password
D, [2017-07-11T21:54:52.759314 #6860] DEBUG -- net.ssh.authentication.methods.none[383842c]: none failed
D, [2017-07-11T21:54:52.760294 #6860] DEBUG -- net.ssh.authentication.session[38392dc]: trying publickey
D, [2017-07-11T21:54:52.760294 #6860] DEBUG -- net.ssh.authentication.agent[380eeec]: connecting to ssh-agent
D, [2017-07-11T21:54:52.761265 #6860] DEBUG -- net.ssh.authentication.agent[380eeec]: sending agent request 1 len 43
D, [2017-07-11T21:54:52.761265 #6860] DEBUG -- net.ssh.authentication.agent[380eeec]: received agent packet 2 len 5
D, [2017-07-11T21:54:52.762247 #6860] DEBUG -- net.ssh.authentication.agent[380eeec]: sending agent request 11 len 0
D, [2017-07-11T21:54:52.762247 #6860] DEBUG -- net.ssh.authentication.agent[380eeec]: received agent packet 12 len 306
D, [2017-07-11T21:54:52.762247 #6860] DEBUG -- net.ssh.authentication.methods.publickey[380f1d0]: trying publickey (c4:cd:b6:43:ef:8d:27:8a:78:10:23:1a:b3:e0:f0:9e)
D, [2017-07-11T21:54:52.763236 #6860] DEBUG -- socket[39736fc]: queueing packet nr 6 type 50 len 348
D, [2017-07-11T21:54:52.763236 #6860] DEBUG -- socket[39736fc]: sent 372 bytes
D, [2017-07-11T21:54:52.774186 #6860] DEBUG -- socket[39736fc]: read 324 bytes
D, [2017-07-11T21:54:52.774186 #6860] DEBUG -- socket[39736fc]: received packet nr 6 type 60 len 300
D, [2017-07-11T21:54:52.775987 #6860] DEBUG -- socket[39736fc]: queueing packet nr 7 type 50 len 620
D, [2017-07-11T21:54:52.775987 #6860] DEBUG -- socket[39736fc]: sent 644 bytes
D, [2017-07-11T21:55:10.792913 #6860] DEBUG -- socket[39736fc]: read 36 bytes
D, [2017-07-11T21:55:10.792913 #6860] DEBUG -- socket[39736fc]: received packet nr 7 type 52 len 12
D, [2017-07-11T21:55:10.792913 #6860] DEBUG -- net.ssh.authentication.methods.publickey[380f1d0]: publickey succeeded (c4:cd:b6:43:ef:8d:27:8a:78:10:23:1a:b3:e0:f0:9e)

DEBUG ssh: == Net-SSH connection debug-level log END ==
 INFO ssh: Execute: grep Funtoo /etc/gentoo-release (sudo=false)
DEBUG ssh: Sending SSH keep-alive...
DEBUG ssh: Sending SSH keep-alive...
DEBUG ssh: Sending SSH keep-alive...
DEBUG ssh: Sending SSH keep-alive...
DEBUG ssh: Sending SSH keep-alive...
DEBUG ssh: Sending SSH keep-alive...
DEBUG ssh: Sending SSH keep-alive...
DEBUG ssh: Sending SSH keep-alive...
DEBUG ssh: Sending SSH keep-alive...
DEBUG ssh: Sending SSH keep-alive...
DEBUG ssh: Sending SSH keep-alive...