----- Original Message -----
From: "Mikola Rose" <mrose(a)power-soft.com>
To: "Yedidyah Bar David" <didi(a)redhat.com>
Cc: users(a)ovirt.org
Sent: Thursday, January 8, 2015 9:24:51 PM
Subject: Re: Failing to connect to console via vnc (was: HostedEngine Deployment Woes)
Hi again Didi,
I decided to try a bare metal install and migrate to a self hosted. The bare
metal install worked great but same issue conencting to the VM via VNC.
Just prompts for password seems to connect then auto closes any vnc client
I use. From the logs it sasys authentication cancelled. The password to
connect was in the hosted-engine —deploy at the end so I didn’t think I
needed to set it again.
This is a temporary password, by default valid for 3 hours.
The one you set with 'hosted-engine --add-console-password' is temporary
too, valid for 2 minutes.
Did vnc console connection work during deploy?
Do you have engine up and running? If so, can you get the console through
the web admin?
The VDSM logs for this session;
Thread-60::DEBUG::2015-01-08
11:14:53,712::domainMonitor::192::Storage.DomainMonitorThread::(_monitorDomain)
Refreshing domain ac1ae7f8-cb48-4251-a246-e68efa9772f0
Thread-60::DEBUG::2015-01-08
11:14:53,718::fileSD::152::Storage.StorageDomain::(__init__) Reading domain
in path
/rhev/data-center/mnt/192.168.1.32:_Volumes_Raid1/ac1ae7f8-cb48-4251-a246-e68efa9772f0
Thread-60::DEBUG::2015-01-08
11:14:53,719::persistentDict::192::Storage.PersistentDict::(__init__)
Created a persistent dict with FileMetadataRW backend
Thread-60::DEBUG::2015-01-08
11:14:53,721::persistentDict::234::Storage.PersistentDict::(refresh) read
lines (FileMetadataRW)=['CLASS=Data', 'DESCRIPTION=hosted_storage',
'IOOPTIMEOUTSEC=10', 'LEASERETRIES=3', 'LEASETIMESEC=60',
'LOCKPOLICY=ON',
'LOCKRENEWALINTERVALSEC=5', 'MASTER_VERSION=1',
'POOL_DESCRIPTION=hosted_datacenter',
'POOL_DOMAINS=ac1ae7f8-cb48-4251-a246-e68efa9772f0:Active',
'POOL_SPM_ID=-1', 'POOL_SPM_LVER=0',
'POOL_UUID=c4a7ea33-d530-492c-a7fa-13418b6c6f0a',
'REMOTE_PATH=192.168.1.32:/Volumes/Raid1', 'ROLE=Master',
'SDUUID=ac1ae7f8-cb48-4251-a246-e68efa9772f0', 'TYPE=NFS',
'VERSION=3',
'_SHA_CKSUM=78daa16373d371fb33ae30943059b955b3d3ebdb']
Thread-60::DEBUG::2015-01-08
11:14:53,723::fileSD::611::Storage.StorageDomain::(imageGarbageCollector)
Removing remnants of deleted images []
Thread-60::INFO::2015-01-08
11:14:53,724::sd::384::Storage.StorageDomain::(_registerResourceNamespaces)
Resource namespace ac1ae7f8-cb48-4251-a246-e68efa9772f0_imageNS already
registered
Thread-60::INFO::2015-01-08
11:14:53,724::sd::392::Storage.StorageDomain::(_registerResourceNamespaces)
Resource namespace ac1ae7f8-cb48-4251-a246-e68efa9772f0_volumeNS already
registered
Thread-60::DEBUG::2015-01-08
11:14:53,728::fileSD::261::Storage.Misc.excCmd::(getReadDelay) '/bin/dd
if=/rhev/data-center/mnt/192.168.1.32:_Volumes_Raid1/ac1ae7f8-cb48-4251-a246-e68efa9772f0/dom_md/metadata
iflag=direct of=/dev/null bs=4096 count=1' (cwd None)
Thread-60::DEBUG::2015-01-08
11:14:53,736::fileSD::261::Storage.Misc.excCmd::(getReadDelay) SUCCESS:
<err> = '0+1 records in\n0+1 records out\n480 bytes (480 B) copied,
0.000292092 s, 1.6 MB/s\n'; <rc> = 0
VM Channels Listener::DEBUG::2015-01-08
11:14:59,682::vmChannels::95::vds::(_handle_timeouts) Timeout on fileno 12.
Thread-60::DEBUG::2015-01-08
11:15:03,744::fileSD::261::Storage.Misc.excCmd::(getReadDelay) '/bin/dd
if=/rhev/data-center/mnt/192.168.1.32:_Volumes_Raid1/ac1ae7f8-cb48-4251-a246-e68efa9772f0/dom_md/metadata
iflag=direct of=/dev/null bs=4096 count=1' (cwd None)
Thread-60::DEBUG::2015-01-08
11:15:03,753::fileSD::261::Storage.Misc.excCmd::(getReadDelay) SUCCESS:
<err> = '0+1 records in\n0+1 records out\n480 bytes (480 B) copied,
0.00036382 s, 1.3 MB/s\n'; <rc> = 0
Thread-60::DEBUG::2015-01-08
11:15:13,762::fileSD::261::Storage.Misc.excCmd::(getReadDelay) '/bin/dd
if=/rhev/data-center/mnt/192.168.1.32:_Volumes_Raid1/ac1ae7f8-cb48-4251-a246-e68efa9772f0/dom_md/metadata
iflag=direct of=/dev/null bs=4096 count=1' (cwd None)
Thread-60::DEBUG::2015-01-08
11:15:13,770::fileSD::261::Storage.Misc.excCmd::(getReadDelay) SUCCESS:
<err> = '0+1 records in\n0+1 records out\n480 bytes (480 B) copied,
0.000338997 s, 1.4 MB/s\n'; <rc> = 0
This all seems unrelated, result of some monitoring.
When I try to login with an invalid password, I get in vdsm.log:
libvirtEventLoop::DEBUG::2015-01-11
10:04:41,423::clientIF::555::vm.Vm::(dispatchLibvirtEvents)
vmId=`7d43e8bd-7b09-4bd1-9254-6780da07da5a`::graphics event phase 0 localAddr
{'node': '0.0.0.0', 'service': '5900', 'family':
0} remoteAddr {'node': '10.36.4.232', 'service': '50218',
'family': 0}authScheme vnc subject []
libvirtEventLoop::DEBUG::2015-01-11
10:04:42,150::clientIF::555::vm.Vm::(dispatchLibvirtEvents)
vmId=`7d43e8bd-7b09-4bd1-9254-6780da07da5a`::graphics event phase 1 localAddr
{'node': '0.0.0.0', 'service': '5900', 'family':
0} remoteAddr {'node': '10.36.4.232', 'service': '50218',
'family': 0}authScheme vnc subject []
libvirtEventLoop::DEBUG::2015-01-11
10:04:47,476::clientIF::555::vm.Vm::(dispatchLibvirtEvents)
vmId=`7d43e8bd-7b09-4bd1-9254-6780da07da5a`::graphics event phase 2 localAddr
{'node': '0.0.0.0', 'service': '5900', 'family':
0} remoteAddr {'node': '10.36.4.232', 'service': '50218',
'family': 0}authScheme vnc subject []
Thread-530134::DEBUG::2015-01-11 10:04:49,477::guestagent::356::vm.Vm::(desktopLock)
vmId=`7d43e8bd-7b09-4bd1-9254-6780da07da5a`::desktopLock called
If you do not see something similar, you might have some problem earlier.
Best,
--
Didi