Hi,
I have attached the log of both virsh -c ssh://[email protected] & virsh
-c xen+ssh://[email protected]
Hope this helps to debug.
--
Thanks & Regards,
Anantha Raghava
Do not print this e-mail unless required. Save Paper & trees.
On Thursday 11 August 2016 04:01 PM, Shahar Havivi wrote:
On 11.08.16 14:14, Anantha Raghava wrote:
Hi,
Tested this with different combinations:
a. from VDSM host, both "ssh [email protected]" and "sudo -u vdsm ssh
[email protected]" commands are logging in without asking for password and I
can run all xe commands without any glitch without modifications to default
xen server firewall or SELinux rules.
b. With firewall enabled and SELinux set to enforcing or permissive or
disabled, I run "virsh -c ssh://[email protected]". And the command is
resulting in two errors:
error: filed to connect to the hypervisor
error: unable to connect to the server at '192.168.1.40:16514' : No
route to the host.
c. With firewall disabled and SELinux set to Enforcing or permissive or
disabled, I run "virsh -c ssh://192.168.1.40". And the command is resulting
in two errors
error: filed to connect to the hypervisor
error: unable to connect to the server at '192.168.1.40:16514' :
Connection refused
Good tests,
We need to figure out why libvirt refuse the connection,
try to debug virsh by running:
$ export LIBVIRT_LOG_OUTPUTS="1:file:/tmp/libvirt_client.log"
$ export LIBVIRT_DEBUG=1
$ virsh -c virsh -c ssh://192.168.1.40
and examing /tmp/libvirt_client.log file
--
Thanks & Regards,
Anantha Raghava
eXza Technology Consulting & Services
Ph: +91-9538849179, E-mail: [email protected]
<mailto:[email protected]>
URL: http://www.exzatechconsulting.com <http://www.exzatechconsulting.com/>
/*Support No.: +91-7829774584 */
DISCLAIMER:
This e-mail communication and any attachments may be privileged and
confidential to eXza Technology Consulting & Services, and are intended only
for the use of the recipients named above If you are not the addressee you
may not copy, forward, disclose or use any part of it. If you have received
this message in error, please delete it and all copies from your system and
notify the sender immediately by return e-mail. Internet communications
cannot be guaranteed to be timely, secure, error or virus-free. The sender
does not accept liability for any errors or omissions.
Do not print this e-mail unless required. Save Paper & trees.
On Thursday 11 August 2016 12:20 PM, Shahar Havivi wrote:
On 10.08.16 19:40, Anantha Raghava wrote:
Hello Richard / Shahar,
I installed and enabled nc on Xen Server host. Now the " ...... sh: nc:
command not found: Input/output error" is gone. Communication is
established. However I am still getting two specific errors:
VDSM ovirt_engine command failed: End of file while reading data: :
Input/Output error
&
Failed to retrieve VMs Information from the external server
xen+ssh://[email protected]
I am receiving the same error when I run virsh -c
xen+ssh://[email protected]
Screen shot is attached for quick reference.
Is it something to do with firewall / ip tables on xen server or libvirtd
host?
Hi,
You don't need to try it on oVirt when 'virsh -c' doesn't work since oVirt try
to connect via libvirt libraries (same as virsh) before it called virt-v2v.
Did you follow all the steps in the wiki?
Are you able to ssh to the Xen server from the vdsm machine that you try to
run virsh without password? (ssh [email protected])
--
Thanks & Regards,
Anantha Raghava
Do not print this e-mail unless required. Save Paper & trees.
On Wednesday 10 August 2016 06:04 PM, Anantha Raghava wrote:
Hi,
Let me try this and post the results here.
Regards,
Ananth
On 10 Aug 2016 15:28, "Richard W.M. Jones" <[email protected]
<mailto:[email protected]>> wrote:
On Wed, Aug 10, 2016 at 09:45:52AM +0300, Shahar Havivi wrote:
> On 10.08.16 06:45, Anantha Raghava wrote:
> > Hi,
> >
> > I even attempted to run command virsh -c
xen+ssh://root@xenhost and I get
> > error "/*error: End of file reading data: sh: nc: command not
found:
> > Input/output error"*/
> First you need to be able to login via virsh (before trying to
import via
> oVirt).
>
> I never encounter this error before,
> I guess that nc is netcat...,
> try to install nmap-ncat:
> $ dnf info nmap-ncat
>
> Adding Richard which may have more input.
Yes, you need to install 'nc' on the *target* (Xen) machine.
This is because libvirt's ssh transport uses nc:
https://libvirt.org/guide/html/Application_Development_Guide-Architecture-Transports.html
<https://libvirt.org/guide/html/Application_Development_Guide-Architecture-Transports.html>
Rich.
--
Richard Jones, Virtualization Group, Red Hat
http://people.redhat.com/~rjones <http://people.redhat.com/%7Erjones>
Read my programming and virtualization blog: http://rwmj.wordpress.com
virt-builder quickly builds VMs from scratch
http://libguestfs.org/virt-builder.1.html
<http://libguestfs.org/virt-builder.1.html>
------ from here you can see the debug log of command virsh -c ssh://[email protected] ---------
2016-08-11 12:15:24.011+0000: 43283: info : libvirt version: 1.2.17, package: 13.el7_2.5 (CentOS BuildSystem <http://bugs.centos.org>, 2016-06-23-14:23:27, worker1.bsys.centos.org)
2016-08-11 12:15:24.011+0000: 43283: debug : virGlobalInit:389 : register drivers
2016-08-11 12:15:24.011+0000: 43283: debug : virRegisterConnectDriver:691 : driver=0x7f975826a640 name=Test
2016-08-11 12:15:24.011+0000: 43283: debug : virRegisterConnectDriver:702 : registering Test as driver 0
2016-08-11 12:15:24.011+0000: 43283: debug : virRegisterConnectDriver:691 : driver=0x7f975826c260 name=ESX
2016-08-11 12:15:24.011+0000: 43283: debug : virRegisterConnectDriver:702 : registering ESX as driver 1
2016-08-11 12:15:24.011+0000: 43283: debug : virRegisterConnectDriver:691 : driver=0x7f975826b0c0 name=remote
2016-08-11 12:15:24.011+0000: 43283: debug : virRegisterConnectDriver:702 : registering remote as driver 2
2016-08-11 12:15:24.011+0000: 43283: debug : virEventRegisterDefaultImpl:261 : registering default event implementation
2016-08-11 12:15:24.011+0000: 43283: debug : virEventPollAddHandle:115 : Used 0 handle slots, adding at least 10 more
2016-08-11 12:15:24.011+0000: 43283: debug : virEventPollInterruptLocked:723 : Skip interrupt, 0 0
2016-08-11 12:15:24.011+0000: 43283: info : virEventPollAddHandle:140 : EVENT_POLL_ADD_HANDLE: watch=1 fd=5 events=1 cb=0x7f9757da9920 opaque=(nil) ff=(nil)
2016-08-11 12:15:24.011+0000: 43283: debug : virEventRegisterImpl:231 : addHandle=0x7f9757daa080 updateHandle=0x7f9757daa3e0 removeHandle=0x7f9757da9980 addTimeout=0x7f9757da9b00 updateTimeout=0x7f9757da9d20 removeTimeout=0x7f9757da9ef0
2016-08-11 12:15:24.011+0000: 43283: debug : virEventPollAddTimeout:230 : Used 0 timeout slots, adding at least 10 more
2016-08-11 12:15:24.011+0000: 43283: debug : virEventPollInterruptLocked:723 : Skip interrupt, 0 0
2016-08-11 12:15:24.011+0000: 43283: info : virEventPollAddTimeout:253 : EVENT_POLL_ADD_TIMEOUT: timer=1 frequency=-1 cb=0x7f97584b7c10 opaque=0x7ffe0aa3bc30 ff=(nil)
2016-08-11 12:15:24.011+0000: 43283: debug : virConnectOpenAuth:1339 : name=ssh://[email protected], auth=0x7f975826a400, flags=0
2016-08-11 12:15:24.011+0000: 43283: info : virObjectNew:202 : OBJECT_NEW: obj=0x7f97587985e0 classname=virConnect
2016-08-11 12:15:24.011+0000: 43283: info : virObjectNew:202 : OBJECT_NEW: obj=0x7f9758797f20 classname=virConnectCloseCallbackData
2016-08-11 12:15:24.011+0000: 43283: debug : virConnectGetConfigFile:953 : Loading config file '/etc/libvirt/libvirt.conf'
2016-08-11 12:15:24.011+0000: 43283: debug : virConfReadFile:769 : filename=/etc/libvirt/libvirt.conf
2016-08-11 12:15:24.011+0000: 43284: debug : virThreadJobSet:99 : Thread 43284 is now running job vshEventLoop
2016-08-11 12:15:24.011+0000: 43283: debug : virFileClose:102 : Closed fd 7
2016-08-11 12:15:24.011+0000: 43284: debug : virEventRunDefaultImpl:305 : running default event implementation
2016-08-11 12:15:24.011+0000: 43284: debug : virEventPollCleanupTimeouts:526 : Cleanup 1
2016-08-11 12:15:24.011+0000: 43284: debug : virEventPollCleanupHandles:575 : Cleanup 1
2016-08-11 12:15:24.011+0000: 43284: debug : virEventPollMakePollFDs:401 : Prepare n=0 w=1, f=5 e=1 d=0
2016-08-11 12:15:24.011+0000: 43284: debug : virEventPollCalculateTimeout:338 : Calculate expiry of 1 timers
2016-08-11 12:15:24.011+0000: 43284: debug : virEventPollCalculateTimeout:371 : No timeout is pending
2016-08-11 12:15:24.011+0000: 43284: info : virEventPollRunOnce:641 : EVENT_POLL_RUN: nhandles=1 timeout=-1
2016-08-11 12:15:24.011+0000: 43283: debug : do_open:1132 : name "ssh://[email protected]" to URI components:
scheme ssh
server 192.168.1.40
user root
port 0
path <null>
2016-08-11 12:15:24.011+0000: 43283: debug : do_open:1179 : trying driver 0 (Test) ...
2016-08-11 12:15:24.011+0000: 43283: debug : do_open:1194 : driver 0 Test returned DECLINED
2016-08-11 12:15:24.011+0000: 43283: debug : do_open:1179 : trying driver 1 (ESX) ...
2016-08-11 12:15:24.011+0000: 43283: debug : do_open:1194 : driver 1 ESX returned DECLINED
2016-08-11 12:15:24.011+0000: 43283: debug : do_open:1179 : trying driver 2 (remote) ...
2016-08-11 12:15:24.011+0000: 43283: debug : doRemoteOpen:792 : proceeding with name = ssh://
2016-08-11 12:15:24.011+0000: 43283: debug : doRemoteOpen:801 : Connecting with transport 0
2016-08-11 12:15:24.011+0000: 43283: debug : virNetTLSContextLocateCredentials:813 : pkipath=(null) isServer=0 tryUserPkiPath=0
2016-08-11 12:15:24.011+0000: 43283: debug : virNetTLSContextLocateCredentials:885 : Using default TLS CA certificate path
2016-08-11 12:15:24.011+0000: 43283: debug : virNetTLSContextLocateCredentials:891 : Using default TLS CA revocation list path
2016-08-11 12:15:24.011+0000: 43283: debug : virNetTLSContextLocateCredentials:897 : Using default TLS key/certificate path
2016-08-11 12:15:24.011+0000: 43283: info : virObjectNew:202 : OBJECT_NEW: obj=0x7f975879a9c0 classname=virNetTLSContext
2016-08-11 12:15:24.012+0000: 43283: debug : virNetTLSContextLoadCertFromFile:516 : isServer 0 certFile /etc/pki/libvirt/clientcert.pem
2016-08-11 12:15:24.012+0000: 43283: debug : virFileClose:102 : Closed fd 7
2016-08-11 12:15:24.012+0000: 43283: debug : virNetTLSContextLoadCACertListFromFile:560 : certFile /etc/pki/CA/cacert.pem
2016-08-11 12:15:24.012+0000: 43283: debug : virFileClose:102 : Closed fd 7
2016-08-11 12:15:24.012+0000: 43283: debug : virNetTLSContextCheckCertBasicConstraints:189 : Cert /etc/pki/libvirt/clientcert.pem basic constraints 0
2016-08-11 12:15:24.012+0000: 43283: debug : virNetTLSContextCheckCertKeyUsage:235 : Cert /etc/pki/libvirt/clientcert.pem key usage status 0 usage 160 critical 1
2016-08-11 12:15:24.012+0000: 43283: debug : virNetTLSContextCheckCertKeyPurpose:335 : Key purpose 0 1.3.6.1.5.5.7.3.1 critical 1
2016-08-11 12:15:24.012+0000: 43283: debug : virNetTLSContextCheckCertKeyPurpose:335 : Key purpose 0 1.3.6.1.5.5.7.3.2 critical 1
2016-08-11 12:15:24.012+0000: 43283: debug : virNetTLSContextCheckCertKeyPurpose:307 : No key purpose data available at slot 2
2016-08-11 12:15:24.012+0000: 43283: debug : virNetTLSContextCheckCertBasicConstraints:189 : Cert /etc/pki/CA/cacert.pem basic constraints 1
2016-08-11 12:15:24.012+0000: 43283: debug : virNetTLSContextCheckCertKeyUsage:235 : Cert /etc/pki/CA/cacert.pem key usage status 0 usage 6 critical 1
2016-08-11 12:15:24.012+0000: 43283: debug : virNetTLSContextLoadCredentials:642 : loading CA cert from /etc/pki/CA/cacert.pem
2016-08-11 12:15:24.013+0000: 43283: debug : virNetTLSContextLoadCredentials:671 : Skipping non-existent CA CRL /etc/pki/CA/cacrl.pem
2016-08-11 12:15:24.013+0000: 43283: debug : virNetTLSContextLoadCredentials:684 : loading cert and key from /etc/pki/libvirt/clientcert.pem and /etc/pki/libvirt/private/clientkey.pem
2016-08-11 12:15:24.014+0000: 43283: info : virNetTLSContextNew:783 : RPC_TLS_CONTEXT_NEW: ctxt=0x7f975879a9c0 cacert=/etc/pki/CA/cacert.pem cacrl=/etc/pki/CA/cacrl.pem cert=/etc/pki/libvirt/clientcert.pem key=/etc/pki/libvirt/private/clientkey.pem sanityCheckCert=1 requireValidCert=1 isServer=0
2016-08-11 12:15:24.016+0000: 43283: debug : virFileClose:102 : Closed fd 7
2016-08-11 12:15:24.016+0000: 43283: error : virNetSocketNewConnectTCP:577 : unable to connect to server at '192.168.1.40:16514': Connection refused
2016-08-11 12:15:24.016+0000: 43283: debug : virNetClientCloseInternal:695 : client=(nil) wantclose=0
2016-08-11 12:15:24.016+0000: 43283: info : virObjectUnref:259 : OBJECT_UNREF: obj=0x7f975879a9c0
2016-08-11 12:15:24.016+0000: 43283: info : virObjectUnref:261 : OBJECT_DISPOSE: obj=0x7f975879a9c0
2016-08-11 12:15:24.016+0000: 43283: info : virNetTLSContextDispose:1169 : RPC_TLS_CONTEXT_DISPOSE: ctxt=0x7f975879a9c0
2016-08-11 12:15:24.016+0000: 43283: debug : do_open:1194 : driver 2 remote returned ERROR
2016-08-11 12:15:24.016+0000: 43283: info : virObjectUnref:259 : OBJECT_UNREF: obj=0x7f97587985e0
2016-08-11 12:15:24.016+0000: 43283: info : virObjectUnref:261 : OBJECT_DISPOSE: obj=0x7f97587985e0
2016-08-11 12:15:24.016+0000: 43283: info : virObjectUnref:259 : OBJECT_UNREF: obj=0x7f9758797f20
2016-08-11 12:15:24.016+0000: 43283: info : virObjectUnref:261 : OBJECT_DISPOSE: obj=0x7f9758797f20
2016-08-11 12:15:24.016+0000: 43283: debug : virEventPollInterruptLocked:727 : Interrupting
2016-08-11 12:15:24.016+0000: 43283: info : virEventPollAddTimeout:253 : EVENT_POLL_ADD_TIMEOUT: timer=2 frequency=0 cb=0x7f97584b7ae0 opaque=(nil) ff=(nil)
2016-08-11 12:15:24.016+0000: 43284: debug : virEventPollRunOnce:651 : Poll got 1 event(s)
2016-08-11 12:15:24.016+0000: 43284: debug : virEventPollDispatchTimeouts:433 : Dispatch 2
2016-08-11 12:15:24.016+0000: 43284: info : virEventPollDispatchTimeouts:456 : EVENT_POLL_DISPATCH_TIMEOUT: timer=2
2016-08-11 12:15:24.016+0000: 43284: debug : virEventPollDispatchHandles:479 : Dispatch 1
2016-08-11 12:15:24.016+0000: 43284: debug : virEventPollDispatchHandles:493 : i=0 w=1
2016-08-11 12:15:24.016+0000: 43284: info : virEventPollDispatchHandles:507 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1
2016-08-11 12:15:24.016+0000: 43284: debug : virEventPollCleanupTimeouts:526 : Cleanup 2
2016-08-11 12:15:24.016+0000: 43284: debug : virEventPollCleanupHandles:575 : Cleanup 1
2016-08-11 12:15:24.016+0000: 43284: debug : virThreadJobClear:124 : Thread 43284 finished job vshEventLoop with ret=0
2016-08-11 12:15:24.016+0000: 43283: info : virEventPollRemoveTimeout:305 : EVENT_POLL_REMOVE_TIMEOUT: timer=2
2016-08-11 12:15:24.016+0000: 43283: debug : virEventPollInterruptLocked:723 : Skip interrupt, 0 140287726221056
2016-08-11 12:15:24.016+0000: 43283: info : virEventPollRemoveTimeout:305 : EVENT_POLL_REMOVE_TIMEOUT: timer=1
2016-08-11 12:15:24.016+0000: 43283: debug : virEventPollInterruptLocked:723 : Skip interrupt, 0 140287726221056
-------- from here you can see debug log of command virsh -c xen+ssh://[email protected] -----------
2016-08-11 12:17:34.366+0000: 43669: info : libvirt version: 1.2.17, package: 13.el7_2.5 (CentOS BuildSystem <http://bugs.centos.org>, 2016-06-23-14:23:27, worker1.bsys.centos.org)
2016-08-11 12:17:34.366+0000: 43669: debug : virGlobalInit:389 : register drivers
2016-08-11 12:17:34.367+0000: 43669: debug : virRegisterConnectDriver:691 : driver=0x7f9661e6a640 name=Test
2016-08-11 12:17:34.367+0000: 43669: debug : virRegisterConnectDriver:702 : registering Test as driver 0
2016-08-11 12:17:34.367+0000: 43669: debug : virRegisterConnectDriver:691 : driver=0x7f9661e6c260 name=ESX
2016-08-11 12:17:34.367+0000: 43669: debug : virRegisterConnectDriver:702 : registering ESX as driver 1
2016-08-11 12:17:34.367+0000: 43669: debug : virRegisterConnectDriver:691 : driver=0x7f9661e6b0c0 name=remote
2016-08-11 12:17:34.367+0000: 43669: debug : virRegisterConnectDriver:702 : registering remote as driver 2
2016-08-11 12:17:34.367+0000: 43669: debug : virEventRegisterDefaultImpl:261 : registering default event implementation
2016-08-11 12:17:34.367+0000: 43669: debug : virEventPollAddHandle:115 : Used 0 handle slots, adding at least 10 more
2016-08-11 12:17:34.367+0000: 43669: debug : virEventPollInterruptLocked:723 : Skip interrupt, 0 0
2016-08-11 12:17:34.367+0000: 43669: info : virEventPollAddHandle:140 : EVENT_POLL_ADD_HANDLE: watch=1 fd=5 events=1 cb=0x7f96619a9920 opaque=(nil) ff=(nil)
2016-08-11 12:17:34.367+0000: 43669: debug : virEventRegisterImpl:231 : addHandle=0x7f96619aa080 updateHandle=0x7f96619aa3e0 removeHandle=0x7f96619a9980 addTimeout=0x7f96619a9b00 updateTimeout=0x7f96619a9d20 removeTimeout=0x7f96619a9ef0
2016-08-11 12:17:34.367+0000: 43669: debug : virEventPollAddTimeout:230 : Used 0 timeout slots, adding at least 10 more
2016-08-11 12:17:34.367+0000: 43669: debug : virEventPollInterruptLocked:723 : Skip interrupt, 0 0
2016-08-11 12:17:34.367+0000: 43669: info : virEventPollAddTimeout:253 : EVENT_POLL_ADD_TIMEOUT: timer=1 frequency=-1 cb=0x7f96620b7c10 opaque=0x7ffef5e35180 ff=(nil)
2016-08-11 12:17:34.367+0000: 43669: debug : virConnectOpenAuth:1339 : name=xen+ssh://[email protected], auth=0x7f9661e6a400, flags=0
2016-08-11 12:17:34.367+0000: 43669: info : virObjectNew:202 : OBJECT_NEW: obj=0x7f9663423ec0 classname=virConnect
2016-08-11 12:17:34.367+0000: 43669: info : virObjectNew:202 : OBJECT_NEW: obj=0x7f9663421f20 classname=virConnectCloseCallbackData
2016-08-11 12:17:34.367+0000: 43670: debug : virThreadJobSet:99 : Thread 43670 is now running job vshEventLoop
2016-08-11 12:17:34.367+0000: 43670: debug : virEventRunDefaultImpl:305 : running default event implementation
2016-08-11 12:17:34.367+0000: 43670: debug : virEventPollCleanupTimeouts:526 : Cleanup 1
2016-08-11 12:17:34.367+0000: 43670: debug : virEventPollCleanupHandles:575 : Cleanup 1
2016-08-11 12:17:34.367+0000: 43670: debug : virEventPollMakePollFDs:401 : Prepare n=0 w=1, f=5 e=1 d=0
2016-08-11 12:17:34.367+0000: 43669: debug : virConnectGetConfigFile:953 : Loading config file '/etc/libvirt/libvirt.conf'
2016-08-11 12:17:34.367+0000: 43670: debug : virEventPollCalculateTimeout:338 : Calculate expiry of 1 timers
2016-08-11 12:17:34.367+0000: 43670: debug : virEventPollCalculateTimeout:371 : No timeout is pending
2016-08-11 12:17:34.367+0000: 43669: debug : virConfReadFile:769 : filename=/etc/libvirt/libvirt.conf
2016-08-11 12:17:34.367+0000: 43670: info : virEventPollRunOnce:641 : EVENT_POLL_RUN: nhandles=1 timeout=-1
2016-08-11 12:17:34.367+0000: 43669: debug : virFileClose:102 : Closed fd 7
2016-08-11 12:17:34.367+0000: 43669: debug : do_open:1132 : name "xen+ssh://[email protected]" to URI components:
scheme xen+ssh
server 192.168.1.40
user root
port 0
path <null>
2016-08-11 12:17:34.367+0000: 43669: debug : do_open:1179 : trying driver 0 (Test) ...
2016-08-11 12:17:34.367+0000: 43669: debug : do_open:1194 : driver 0 Test returned DECLINED
2016-08-11 12:17:34.367+0000: 43669: debug : do_open:1179 : trying driver 1 (ESX) ...
2016-08-11 12:17:34.367+0000: 43669: debug : do_open:1194 : driver 1 ESX returned DECLINED
2016-08-11 12:17:34.367+0000: 43669: debug : do_open:1179 : trying driver 2 (remote) ...
2016-08-11 12:17:34.367+0000: 43669: debug : doRemoteOpen:792 : proceeding with name = xen://
2016-08-11 12:17:34.367+0000: 43669: debug : doRemoteOpen:801 : Connecting with transport 2
2016-08-11 12:17:34.368+0000: 43669: debug : virCommandRunAsync:2428 : About to run LC_ALL=C PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/root/bin HOME=/root USER=root LOGNAME=root ssh -l root 192.168.1.40 sh -c ''\''if '\''nc'\'' -q 2>&1 | grep "requires an argument" >/dev/null 2>&1; then ARG=-q0;else ARG=;fi;'\''nc'\'' $ARG -U /var/run/libvirt/libvirt-sock'\'''
2016-08-11 12:17:34.368+0000: 43669: debug : virCommandRunAsync:2431 : Command result 0, with PID 43671
2016-08-11 12:17:34.368+0000: 43669: debug : virFileClose:102 : Closed fd 8
2016-08-11 12:17:34.368+0000: 43669: debug : virFileClose:102 : Closed fd 10
2016-08-11 12:17:34.368+0000: 43669: debug : virNetSocketNew:225 : localAddr=(nil) remoteAddr=(nil) fd=7 errfd=9 pid=43671
2016-08-11 12:17:34.368+0000: 43669: info : virObjectNew:202 : OBJECT_NEW: obj=0x7f9663424d90 classname=virNetSocket
2016-08-11 12:17:34.368+0000: 43669: info : virNetSocketNew:276 : RPC_SOCKET_NEW: sock=0x7f9663424d90 fd=7 errfd=9 pid=43671 localAddr=<null>, remoteAddr=<null>
2016-08-11 12:17:34.368+0000: 43669: info : virObjectNew:202 : OBJECT_NEW: obj=0x7f9663424fd0 classname=virNetClient
2016-08-11 12:17:34.368+0000: 43669: info : virNetClientNew:327 : RPC_CLIENT_NEW: client=0x7f9663424fd0 sock=0x7f9663424d90
2016-08-11 12:17:34.368+0000: 43669: info : virObjectRef:296 : OBJECT_REF: obj=0x7f9663424fd0
2016-08-11 12:17:34.368+0000: 43669: info : virObjectRef:296 : OBJECT_REF: obj=0x7f9663424d90
2016-08-11 12:17:34.368+0000: 43669: debug : virEventPollInterruptLocked:727 : Interrupting
2016-08-11 12:17:34.368+0000: 43669: info : virEventPollAddHandle:140 : EVENT_POLL_ADD_HANDLE: watch=2 fd=7 events=1 cb=0x7f9661afbfb0 opaque=0x7f9663424d90 ff=0x7f9661afbf60
2016-08-11 12:17:34.368+0000: 43669: debug : virKeepAliveNew:199 : client=0x7f9663424fd0, interval=-1, count=0
2016-08-11 12:17:34.368+0000: 43669: info : virObjectNew:202 : OBJECT_NEW: obj=0x7f9663424c10 classname=virKeepAlive
2016-08-11 12:17:34.368+0000: 43669: info : virKeepAliveNew:218 : RPC_KEEPALIVE_NEW: ka=0x7f9663424c10 client=0x7f9663424fd0
2016-08-11 12:17:34.368+0000: 43669: info : virObjectRef:296 : OBJECT_REF: obj=0x7f9663424fd0
2016-08-11 12:17:34.368+0000: 43669: info : virObjectRef:296 : OBJECT_REF: obj=0x7f9663421f20
2016-08-11 12:17:34.368+0000: 43670: debug : virEventPollRunOnce:651 : Poll got 1 event(s)
2016-08-11 12:17:34.368+0000: 43670: debug : virEventPollDispatchTimeouts:433 : Dispatch 1
2016-08-11 12:17:34.368+0000: 43669: info : virObjectNew:202 : OBJECT_NEW: obj=0x7f96634249f0 classname=virNetClientProgram
2016-08-11 12:17:34.368+0000: 43670: debug : virEventPollDispatchHandles:479 : Dispatch 1
2016-08-11 12:17:34.368+0000: 43670: debug : virEventPollDispatchHandles:493 : i=0 w=1
2016-08-11 12:17:34.368+0000: 43669: info : virObjectNew:202 : OBJECT_NEW: obj=0x7f9663424ba0 classname=virNetClientProgram
2016-08-11 12:17:34.368+0000: 43669: info : virObjectNew:202 : OBJECT_NEW: obj=0x7f9663424950 classname=virNetClientProgram
2016-08-11 12:17:34.368+0000: 43670: info : virEventPollDispatchHandles:507 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1
2016-08-11 12:17:34.368+0000: 43669: info : virObjectRef:296 : OBJECT_REF: obj=0x7f96634249f0
2016-08-11 12:17:34.368+0000: 43670: debug : virEventPollCleanupTimeouts:526 : Cleanup 1
2016-08-11 12:17:34.368+0000: 43669: info : virObjectRef:296 : OBJECT_REF: obj=0x7f9663424ba0
2016-08-11 12:17:34.368+0000: 43669: info : virObjectRef:296 : OBJECT_REF: obj=0x7f9663424950
2016-08-11 12:17:34.368+0000: 43670: debug : virEventPollCleanupHandles:575 : Cleanup 2
2016-08-11 12:17:34.368+0000: 43669: debug : doRemoteOpen:1010 : Trying authentication
2016-08-11 12:17:34.368+0000: 43670: debug : virEventRunDefaultImpl:305 : running default event implementation
2016-08-11 12:17:34.368+0000: 43670: debug : virEventPollCleanupTimeouts:526 : Cleanup 1
2016-08-11 12:17:34.368+0000: 43669: debug : virNetMessageNew:46 : msg=0x7f96634251e0 tracked=0
2016-08-11 12:17:34.368+0000: 43670: debug : virEventPollCleanupHandles:575 : Cleanup 2
2016-08-11 12:17:34.368+0000: 43670: debug : virEventPollMakePollFDs:401 : Prepare n=0 w=1, f=5 e=1 d=0
2016-08-11 12:17:34.368+0000: 43670: debug : virEventPollMakePollFDs:401 : Prepare n=1 w=2, f=7 e=1 d=0
2016-08-11 12:17:34.368+0000: 43669: debug : virNetMessageEncodePayload:376 : Encode length as 28
2016-08-11 12:17:34.368+0000: 43670: debug : virEventPollCalculateTimeout:338 : Calculate expiry of 1 timers
2016-08-11 12:17:34.368+0000: 43669: info : virNetClientSendInternal:1950 : RPC_CLIENT_MSG_TX_QUEUE: client=0x7f9663424fd0 len=28 prog=536903814 vers=1 proc=66 type=0 status=0 serial=0
2016-08-11 12:17:34.368+0000: 43670: debug : virEventPollCalculateTimeout:371 : No timeout is pending
2016-08-11 12:17:34.368+0000: 43669: debug : virNetClientCallNew:1903 : New call 0x7f9663425100: msg=0x7f96634251e0, expectReply=1, nonBlock=0
2016-08-11 12:17:34.368+0000: 43670: info : virEventPollRunOnce:641 : EVENT_POLL_RUN: nhandles=2 timeout=-1
2016-08-11 12:17:34.368+0000: 43669: debug : virNetClientIO:1712 : Outgoing message prog=536903814 version=1 serial=0 proc=66 type=0 length=28 dispatch=(nil)
2016-08-11 12:17:34.368+0000: 43669: debug : virNetClientIO:1771 : We have the buck head=0x7f9663425100 call=0x7f9663425100
2016-08-11 12:17:34.368+0000: 43669: info : virEventPollUpdateHandle:152 : EVENT_POLL_UPDATE_HANDLE: watch=2 events=0
2016-08-11 12:17:34.368+0000: 43669: debug : virEventPollInterruptLocked:727 : Interrupting
2016-08-11 12:17:34.368+0000: 43670: debug : virEventPollRunOnce:651 : Poll got 1 event(s)
2016-08-11 12:17:34.368+0000: 43670: debug : virEventPollDispatchTimeouts:433 : Dispatch 1
2016-08-11 12:17:34.368+0000: 43670: debug : virEventPollDispatchHandles:479 : Dispatch 2
2016-08-11 12:17:34.368+0000: 43670: debug : virEventPollDispatchHandles:493 : i=0 w=1
2016-08-11 12:17:34.368+0000: 43670: info : virEventPollDispatchHandles:507 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1
2016-08-11 12:17:34.368+0000: 43670: debug : virEventPollCleanupTimeouts:526 : Cleanup 1
2016-08-11 12:17:34.368+0000: 43670: debug : virEventPollCleanupHandles:575 : Cleanup 2
2016-08-11 12:17:34.368+0000: 43670: debug : virEventRunDefaultImpl:305 : running default event implementation
2016-08-11 12:17:34.368+0000: 43670: debug : virEventPollCleanupTimeouts:526 : Cleanup 1
2016-08-11 12:17:34.368+0000: 43671: info : libvirt version: 1.2.17, package: 13.el7_2.5 (CentOS BuildSystem <http://bugs.centos.org>, 2016-06-23-14:23:27, worker1.bsys.centos.org)
2016-08-11 12:17:34.368+0000: 43670: debug : virEventPollCleanupHandles:575 : Cleanup 2
2016-08-11 12:17:34.368+0000: 43671: debug : virExec:730 : Setting child uid:gid to -1:-1 with caps 0
2016-08-11 12:17:34.368+0000: 43670: debug : virEventPollMakePollFDs:401 : Prepare n=0 w=1, f=5 e=1 d=0
2016-08-11 12:17:34.368+0000: 43670: debug : virEventPollMakePollFDs:401 : Prepare n=1 w=2, f=7 e=0 d=0
2016-08-11 12:17:34.368+0000: 43670: debug : virEventPollCalculateTimeout:338 : Calculate expiry of 1 timers
2016-08-11 12:17:34.368+0000: 43670: debug : virEventPollCalculateTimeout:371 : No timeout is pending
2016-08-11 12:17:34.368+0000: 43670: info : virEventPollRunOnce:641 : EVENT_POLL_RUN: nhandles=1 timeout=-1
2016-08-11 12:17:34.632+0000: 43669: error : virNetSocketReadWire:1590 : End of file while reading data: 2016-08-11 12:17:34.368+0000: 43671: debug : virFileClose:102 : Closed fd 8
2016-08-11 12:17:34.368+0000: 43671: debug : virFileClose:102 : Closed fd 10
2016-08-11 12:17:34.368+0000: 43671: debug : virLogParseOutputs:1091 : outputs=1:file:/tmp/libvirt_client.log: Input/output error
2016-08-11 12:17:34.632+0000: 43669: debug : virNetClientMarkClose:638 : client=0x7f9663424fd0, reason=0
2016-08-11 12:17:34.632+0000: 43669: info : virEventPollRemoveHandle:186 : EVENT_POLL_REMOVE_HANDLE: watch=2
2016-08-11 12:17:34.632+0000: 43669: debug : virEventPollRemoveHandle:199 : mark delete 1 7
2016-08-11 12:17:34.632+0000: 43669: debug : virEventPollInterruptLocked:727 : Interrupting
2016-08-11 12:17:34.632+0000: 43669: debug : virNetClientIOEventLoopPassTheBuck:1419 : Giving up the buck 0x7f9663425100
2016-08-11 12:17:34.632+0000: 43669: debug : virNetClientIOEventLoopPassTheBuck:1433 : No thread to pass the buck to
2016-08-11 12:17:34.632+0000: 43669: debug : virNetClientCloseLocked:654 : client=0x7f9663424fd0, sock=0x7f9663424d90, reason=0
2016-08-11 12:17:34.632+0000: 43669: info : virObjectUnref:259 : OBJECT_UNREF: obj=0x7f9663424d90
2016-08-11 12:17:34.632+0000: 43670: debug : virEventPollRunOnce:651 : Poll got 1 event(s)
2016-08-11 12:17:34.632+0000: 43669: info : virObjectRef:296 : OBJECT_REF: obj=0x7f9663424fd0
2016-08-11 12:17:34.632+0000: 43670: debug : virEventPollDispatchTimeouts:433 : Dispatch 1
2016-08-11 12:17:34.632+0000: 43669: info : virKeepAliveStop:310 : RPC_KEEPALIVE_STOP: ka=0x7f9663424c10 client=0x7f9663424fd0
2016-08-11 12:17:34.632+0000: 43669: info : virObjectUnref:259 : OBJECT_UNREF: obj=0x7f9663424c10
2016-08-11 12:17:34.632+0000: 43670: debug : virEventPollDispatchHandles:479 : Dispatch 1
2016-08-11 12:17:34.632+0000: 43669: info : virObjectUnref:261 : OBJECT_DISPOSE: obj=0x7f9663424c10
2016-08-11 12:17:34.632+0000: 43670: debug : virEventPollDispatchHandles:493 : i=0 w=1
2016-08-11 12:17:34.632+0000: 43669: info : virKeepAliveDispose:230 : RPC_KEEPALIVE_DISPOSE: ka=0x7f9663424c10
2016-08-11 12:17:34.632+0000: 43670: info : virEventPollDispatchHandles:507 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1
2016-08-11 12:17:34.632+0000: 43669: info : virObjectUnref:259 : OBJECT_UNREF: obj=0x7f9663424fd0
2016-08-11 12:17:34.632+0000: 43670: debug : virEventPollCleanupTimeouts:526 : Cleanup 1
2016-08-11 12:17:34.632+0000: 43669: info : virObjectUnref:259 : OBJECT_UNREF: obj=0x7f9663424fd0
2016-08-11 12:17:34.632+0000: 43670: debug : virEventPollCleanupHandles:575 : Cleanup 2
2016-08-11 12:17:34.632+0000: 43669: debug : virNetClientIO:1801 : All done with our call head=(nil) call=0x7f9663425100 rv=-1
2016-08-11 12:17:34.632+0000: 43670: info : virEventPollCleanupHandles:588 : EVENT_POLL_PURGE_HANDLE: watch=2
2016-08-11 12:17:34.632+0000: 43669: debug : virNetMessageFree:74 : msg=0x7f96634251e0 nfds=0 cb=(nil)
2016-08-11 12:17:34.632+0000: 43670: info : virObjectUnref:259 : OBJECT_UNREF: obj=0x7f9663424fd0
2016-08-11 12:17:34.632+0000: 43669: info : virObjectUnref:259 : OBJECT_UNREF: obj=0x7f96634249f0
2016-08-11 12:17:34.632+0000: 43670: info : virObjectUnref:259 : OBJECT_UNREF: obj=0x7f9663424d90
2016-08-11 12:17:34.632+0000: 43669: info : virObjectUnref:259 : OBJECT_UNREF: obj=0x7f9663424ba0
2016-08-11 12:17:34.632+0000: 43670: info : virObjectUnref:261 : OBJECT_DISPOSE: obj=0x7f9663424d90
2016-08-11 12:17:34.632+0000: 43669: info : virObjectUnref:259 : OBJECT_UNREF: obj=0x7f9663424950
2016-08-11 12:17:34.632+0000: 43670: info : virNetSocketDispose:1155 : RPC_SOCKET_DISPOSE: sock=0x7f9663424d90
2016-08-11 12:17:34.632+0000: 43669: debug : virNetClientCloseInternal:695 : client=0x7f9663424fd0 wantclose=0
2016-08-11 12:17:34.632+0000: 43669: info : virObjectUnref:259 : OBJECT_UNREF: obj=0x7f9663424fd0
2016-08-11 12:17:34.632+0000: 43669: info : virObjectUnref:261 : OBJECT_DISPOSE: obj=0x7f9663424fd0
2016-08-11 12:17:34.632+0000: 43669: info : virNetClientDispose:606 : RPC_CLIENT_DISPOSE: client=0x7f9663424fd0
2016-08-11 12:17:34.632+0000: 43670: debug : virFileClose:102 : Closed fd 7
2016-08-11 12:17:34.632+0000: 43669: info : virObjectUnref:259 : OBJECT_UNREF: obj=0x7f9663421f20
2016-08-11 12:17:34.632+0000: 43669: info : virObjectUnref:259 : OBJECT_UNREF: obj=0x7f96634249f0
2016-08-11 12:17:34.632+0000: 43669: info : virObjectUnref:261 : OBJECT_DISPOSE: obj=0x7f96634249f0
2016-08-11 12:17:34.632+0000: 43670: debug : virFileClose:102 : Closed fd 9
2016-08-11 12:17:34.632+0000: 43669: info : virObjectUnref:259 : OBJECT_UNREF: obj=0x7f9663424ba0
2016-08-11 12:17:34.632+0000: 43669: info : virObjectUnref:261 : OBJECT_DISPOSE: obj=0x7f9663424ba0
2016-08-11 12:17:34.632+0000: 43669: info : virObjectUnref:259 : OBJECT_UNREF: obj=0x7f9663424950
2016-08-11 12:17:34.632+0000: 43669: info : virObjectUnref:261 : OBJECT_DISPOSE: obj=0x7f9663424950
2016-08-11 12:17:34.632+0000: 43670: debug : virProcessAbort:167 : aborting child process 43671
2016-08-11 12:17:34.632+0000: 43669: debug : virFileClose:102 : Closed fd 10
2016-08-11 12:17:34.632+0000: 43669: debug : virFileClose:102 : Closed fd 8
2016-08-11 12:17:34.632+0000: 43669: debug : virNetMessageClear:57 : msg=0x7f9663425038 nfds=0
2016-08-11 12:17:34.632+0000: 43669: debug : do_open:1194 : driver 2 remote returned ERROR
2016-08-11 12:17:34.632+0000: 43669: info : virObjectUnref:259 : OBJECT_UNREF: obj=0x7f9663423ec0
2016-08-11 12:17:34.632+0000: 43670: debug : virProcessAbort:172 : process has ended: exit status 1
2016-08-11 12:17:34.632+0000: 43669: info : virObjectUnref:261 : OBJECT_DISPOSE: obj=0x7f9663423ec0
2016-08-11 12:17:34.632+0000: 43670: debug : virEventRunDefaultImpl:305 : running default event implementation
2016-08-11 12:17:34.632+0000: 43669: info : virObjectUnref:259 : OBJECT_UNREF: obj=0x7f9663421f20
2016-08-11 12:17:34.632+0000: 43670: debug : virEventPollCleanupTimeouts:526 : Cleanup 1
2016-08-11 12:17:34.632+0000: 43669: info : virObjectUnref:261 : OBJECT_DISPOSE: obj=0x7f9663421f20
2016-08-11 12:17:34.632+0000: 43670: debug : virEventPollCleanupHandles:575 : Cleanup 1
2016-08-11 12:17:34.632+0000: 43670: debug : virEventPollMakePollFDs:401 : Prepare n=0 w=1, f=5 e=1 d=0
2016-08-11 12:17:34.632+0000: 43670: debug : virEventPollCalculateTimeout:338 : Calculate expiry of 1 timers
2016-08-11 12:17:34.632+0000: 43670: debug : virEventPollCalculateTimeout:371 : No timeout is pending
2016-08-11 12:17:34.632+0000: 43670: info : virEventPollRunOnce:641 : EVENT_POLL_RUN: nhandles=1 timeout=-1
2016-08-11 12:17:34.632+0000: 43669: debug : virEventPollInterruptLocked:727 : Interrupting
2016-08-11 12:17:34.632+0000: 43669: info : virEventPollAddTimeout:253 : EVENT_POLL_ADD_TIMEOUT: timer=2 frequency=0 cb=0x7f96620b7ae0 opaque=(nil) ff=(nil)
2016-08-11 12:17:34.632+0000: 43670: debug : virEventPollRunOnce:651 : Poll got 1 event(s)
2016-08-11 12:17:34.632+0000: 43670: debug : virEventPollDispatchTimeouts:433 : Dispatch 2
2016-08-11 12:17:34.632+0000: 43670: info : virEventPollDispatchTimeouts:456 : EVENT_POLL_DISPATCH_TIMEOUT: timer=2
2016-08-11 12:17:34.632+0000: 43670: debug : virEventPollDispatchHandles:479 : Dispatch 1
2016-08-11 12:17:34.632+0000: 43670: debug : virEventPollDispatchHandles:493 : i=0 w=1
2016-08-11 12:17:34.632+0000: 43670: info : virEventPollDispatchHandles:507 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1
2016-08-11 12:17:34.632+0000: 43670: debug : virEventPollCleanupTimeouts:526 : Cleanup 2
2016-08-11 12:17:34.632+0000: 43670: debug : virEventPollCleanupHandles:575 : Cleanup 1
2016-08-11 12:17:34.632+0000: 43670: debug : virThreadJobClear:124 : Thread 43670 finished job vshEventLoop with ret=0
2016-08-11 12:17:34.632+0000: 43669: info : virEventPollRemoveTimeout:305 : EVENT_POLL_REMOVE_TIMEOUT: timer=2
2016-08-11 12:17:34.632+0000: 43669: debug : virEventPollInterruptLocked:723 : Skip interrupt, 0 140283594831616
2016-08-11 12:17:34.632+0000: 43669: info : virEventPollRemoveTimeout:305 : EVENT_POLL_REMOVE_TIMEOUT: timer=1
2016-08-11 12:17:34.632+0000: 43669: debug : virEventPollInterruptLocked:723 : Skip interrupt, 0 140283594831616
_______________________________________________
Users mailing list
[email protected]
http://lists.ovirt.org/mailman/listinfo/users
