October 2015 - Users - libvirt List Archives

[libvirt-users] Setting a VM's vnetX qlen in the XML file
by Digimer 09 Oct '15

09 Oct '15

Hi all, I have a two-node HA RHEL 6 setup hosting VMs. These use static/standard bridges and all has worked wonderfully. Now though, I need to adjust the qlen value of the vnetX devices for a given guest VM, which I can do with: ip link set dev vnet0 qlen 6000 The problem with this approach is two-fold though; 1. I need to determine which vnetX is connected to a VM. 2. If the VM live-migrates, the qlen of the vnetX on the new host needs to be updated. This causes an issue where network traffic is impacted until the command is (re)ran. So I am hoping there is a way I can define the qlen right in the VM's XML definition file so that it is set when the vnetX device is created. Is this possible? Thanks! -- Digimer Papers and Projects: https://alteeve.ca/w/ What if the cure for cancer is trapped in the mind of a person without access to education?

1 0

[libvirt-users] ceph vs gluster as libvirt backend
by Patrick F. Marques 09 Oct '15

09 Oct '15

Hi Hi, I looking for some info about using ceph or gluster as VMs disk backend, anyone has some experience on this? I never used any of them. If someone could share some issues or strengths on integration or even some performance details/stories, I appreciate. Regards, Patrick Marques

1 0

[libvirt-users] autpfs + nfs stuck on stat() inside libvirt lxc 1.2.18
by mxs kolo 08 Oct '15

08 Oct '15

Hi all. Has someone success story with using autofs + nfs inside libvirt LXC container ? In my case nfs client and server in lxc work just fine, but with autofs hang on system call state(). I use CE7_64 on nodes and inside container with libvirt 1.2.18 May be I must set some of capabilities in <feature> (http://man7.org/linux/man-pages/man7/capabilities.7.html) ? I try only CAP_SYS_ADMIN and it's no solve problem. b.r. Maxim Kozin

1 2

[libvirt-users] Libvirt fails to build with sasl
by Jonny Schlag 08 Oct '15

08 Oct '15

Description of problem: I try to build a libvirt package for the IPFire project (http://www.ipfire.org/) Without sasl libvirt build fine but with sasl libvirt fails to build with the following message: CC rpc/libvirt_net_rpc_la-virnetsaslcontext.lo In file included from rpc/virnetsaslcontext.h:25, from rpc/virnetsaslcontext.c:26: /usr/include/sasl/sasl.h:230: error: expected declaration specifiers or '...' before 'size_t' Makefile:7023: recipe for target 'rpc/libvirt_net_rpc_la-virnetsaslcontext.lo' failed make[3]: *** [rpc/libvirt_net_rpc_la-virnetsaslcontext.lo] Error 1 make[3]: Leaving directory '/libvirt-1.2.20/src' Makefile:5119: recipe for target 'all' failed make[2]: *** [all] Error 2 make[2]: Leaving directory '/libvirt-1.2.20/src' Makefile:1999: recipe for target 'all-recursive' failed make[1]: *** [all-recursive] Error 1 make[1]: Leaving directory '/libvirt-1.2.20' Makefile:1896: recipe for target 'all' failed make: *** [all] Error 2 Version-Release number of selected component (if applicable): 1.2.20 How reproducible: Build libvirt with: 1. ./configure --prefix=/usr --localstatedir=/var --sysconfdir=/etc --with-openssl --with-sasl --without-uml --without-vbox --without-lxc --without-esx --without-vmware --without-openvz --without-firewalld --without-storage-scsi --without-storage-mpath --without-avahi --with-test-suite -without-dbus --without-storage-lvm --without-pm-utils 2. make 3. the error occurs Additional info: Cyrus sasl (2.1.26) is build with ./configure --prefix=/usr --sysconfdir=/etc \ --with-dbpath=/var/lib/sasl/sasldb2 \ --with-saslauthd=/var/run/saslauthd \ --with-des=no --with-rc4=no I attached the whole terminal output. Sincerely Jonatan Schlag PS.: Sorry for my bad english, i hope you could understand me.

2 2

[libvirt-users] libvirt 1.19: could not open drive file (permission denied)
by crequill 06 Oct '15

06 Oct '15

Hi, With libvrit 1.18 all is working fine: I can open my win7 VM on Archlinux without problem. But I cannot use it with libvirt 1.19: it could not open drive file (permission denied). In /etc/libvirt/qemu.conf, I have: - user: root - group: root And the drive file has root:root as owner. Why this configuration is running with libvirt 1.18 and not with libvirt 1.19 ? Many thanks for your reply. Christophe

2 6

[libvirt-users] Placing tls client certificates
by Dmitry Skorobogatiy 06 Oct '15

06 Oct '15

After reading you guide about configuring qemu + tls (http://wiki.libvirt.org/page/TLSSetup) i face with fact, that i can't move client certificate. After all, it's useful to configure all pki hosts similar: place certs in, for example, /etc/pki/libvirt/cert.pem and use it as client certs in one case and as server cert in other case. So, the question is: how can i configure location of the client certificate files? One way is to set variables in /etc/libvirt/libvirtd.conf on using client cert location. But it can be cause of confusing later. PS: Sorry for my English. -- Best regards, Skorobogatiy Dmitry

1 0

[libvirt-users] Storage statistics
by Giuseppe Civitella 05 Oct '15

05 Oct '15

Hi all, I'd like to get a few storage statistics from a running vm. I'd like to know read and write data about QCOW2 devices and about RBD volumes. I did try to execute a command similar to this: virsh qemu-monitor-command vm-vnc '{ "execute": "query-block"}' as described here: https://www.berrange.com/posts/2011/12/19/using-command-line-arg-monitor-co… and implemented here: https://github.com/cernceph/ceph-scripts/blob/master/tools/virsh-throttle-r… But I do not get any live data. As example, I get this values about RBD volumes whether I do or I don't read data from the volume inside the vm: { "device": "drive-virtio-disk1", "inserted": { "backing_file_depth": 0, "bps": 0, "bps_rd": 0, "bps_wr": 0, "drv": "raw", "encrypted": false, "encryption_key_missing": false, "file": "rbd:volumes/volume-791f56d7-d115-4889-ba6c-85f7795b84db:id=cinder:key=AQCxLlxTYI2gHBAAWztETyuM1Nkgu6+0ANkl1w==:auth_supported=cephx\\;none:mon_host=10.19.24.127\\:6789\\;10.19.24.128\\:6789\\;10.19.24.129\\:6789", "image": { "cluster-size": 4194304, "dirty-flag": false, "filename": "rbd:volumes/volume-791f56d7-d115-4889-ba6c-85f7795b84db:id=cinder:key=AQCxLlxTYI2gHBAAWztETyuM1Nkgu6+0ANkl1w==:auth_supported=cephx\\;none:mon_host=10.19.24.127\\:6789\\;10.19.24.128\\:6789\\;10.19.24.129\\:6789", "format": "raw", "virtual-size": 5368709120 }, "iops": 0, "iops_rd": 50, "iops_rd_max": 5, "iops_wr": 50, "iops_wr_max": 5, "ro": false }, "io-status": "ok", "locked": false, "removable": false, "type": "unknown" } ] Do I need to enable the statistics collection in a specific way? Is there a better way of doing this? My system is an Ubuntu 14.04.2 with libvirtd (libvirt) 1.2.2, kernel 3.13.0-55, ceph version 0.80.9. Thanks Giuseppe -- Giuseppe Civitella gcivitella(a)entermail.it

1 0

[libvirt-users] hvc - hypervisor virtual console & virsh
by poma 03 Oct '15

03 Oct '15

Hi Fi, cmdline: console=hvc0 systemd.wants=getty@hvc0 Connect via virt-manager - View / Text Consoles / Text Console no.: Fedora 24 (Rawhide) Kernel 4.3.0-0.rc3.git2.4.fc24.x86_64 on an x86_64 (hvc0) localhost login: root Last login: Fri Oct 2 17:28:36 on hvc0 # tty /dev/hvc0 # systemctl status getty(a)hvc0.service ● getty(a)hvc0.service - Getty on hvc0 Loaded: loaded (/usr/lib/systemd/system/getty@.service; enabled; vendor preset: enabled) Active: active (running) since Fri 2015-10-02 17:28:39 EDT; 26s ago Docs: man:agetty(8) man:systemd-getty-generator(8) http://0pointer.de/blog/projects/serial-console.html Main PID: 2034 (login) CGroup: /system.slice/system-getty.slice/getty(a)hvc0.service ‣ 2034 login -- root Oct 02 17:28:39 localhost systemd[1]: Started Getty on hvc0. It obviously works. Connect via virsh: # virsh console <domain> console1 Connected to domain <domain> Escape character is ^] error: operation failed: Active console session exists for this domain # virsh console --devname console1 <domain> Connected to domain <domain> Escape character is ^] error: operation failed: Active console session exists for this domain Obviously does not work. Is it possible to connect hvc via virsh, if domain/guest is started with the virt-manager? Is it possible at all, to connect hypervisor virtual console via virsh?

1 1

[libvirt-users] virsh with OSX and virtualbox
by Ben Greene 02 Oct '15

02 Oct '15

I have freshly installed Virtualbox (5.04) and have installed libvirt (1.2.19) using brew. When i attempt to run virsh it does not work with the following outputs. # virsh -c vbox:///session error: failed to connect to the hypervisor error: internal error: unable to initialize VirtualBox driver API Any pointers on what to try next or where to investigate to get more info. Has anyone got virsh working successfully with OSX and Virtualbox. I also ran the same command with more logging: Foyil:~ bengreene$ LIBVIRT_DEBUG=1 virsh -c vbox:///session 2015-10-02 08:52:11.874+0000: 18446744073709551615: info : libvirt version: 1.2.19 2015-10-02 08:52:11.874+0000: 18446744073709551615: debug : virGlobalInit:389 : register drivers 2015-10-02 08:52:11.874+0000: 18446744073709551615: debug : virRegisterConnectDriver:691 : driver=0x1007121d8 name=Test 2015-10-02 08:52:11.874+0000: 18446744073709551615: debug : virRegisterConnectDriver:702 : registering Test as driver 0 2015-10-02 08:52:11.874+0000: 18446744073709551615: debug : virRegisterConnectDriver:691 : driver=0x100713e00 name=VMWARE 2015-10-02 08:52:11.874+0000: 18446744073709551615: debug : virRegisterConnectDriver:702 : registering VMWARE as driver 1 2015-10-02 08:52:11.874+0000: 18446744073709551615: debug : virRegisterConnectDriver:691 : driver=0x1007144f8 name=ESX 2015-10-02 08:52:11.874+0000: 18446744073709551615: debug : virRegisterConnectDriver:702 : registering ESX as driver 2 2015-10-02 08:52:11.874+0000: 18446744073709551615: debug : virRegisterConnectDriver:691 : driver=0x100712c10 name=remote 2015-10-02 08:52:11.874+0000: 18446744073709551615: debug : virRegisterConnectDriver:702 : registering remote as driver 3 2015-10-02 08:52:11.876+0000: 18446744073709551615: debug : virEventRegisterDefaultImpl:261 : registering default event implementation 2015-10-02 08:52:11.876+0000: 18446744073709551615: debug : virEventPollAddHandle:115 : Used 0 handle slots, adding at least 10 more 2015-10-02 08:52:11.876+0000: 18446744073709551615: debug : virEventPollInterruptLocked:723 : Skip interrupt, 0 0 2015-10-02 08:52:11.876+0000: 18446744073709551615: info : virEventPollAddHandle:140 : EVENT_POLL_ADD_HANDLE: watch=1 fd=4 events=1 cb=0x10050c74e opaque=0x0 ff=0x0 2015-10-02 08:52:11.876+0000: 18446744073709551615: debug : virEventRegisterImpl:231 : addHandle=0x10050afa3 updateHandle=0x10050b296 removeHandle=0x10050b3da addTimeout=0x10050b528 updateTimeout=0x10050b6f6 removeTimeout=0x10050b879 2015-10-02 08:52:11.876+0000: 18446744073709551615: debug : virEventPollAddTimeout:230 : Used 0 timeout slots, adding at least 10 more 2015-10-02 08:52:11.876+0000: 18446744073709551615: debug : virEventPollInterruptLocked:723 : Skip interrupt, 0 0 2015-10-02 08:52:11.876+0000: 18446744073709551615: info : virEventPollAddTimeout:253 : EVENT_POLL_ADD_TIMEOUT: timer=1 frequency=-1 cb=0x100490c0c opaque=0x7fff5f774900 ff=0x0 2015-10-02 08:52:11.876+0000: 18446744073709551615: debug : virConnectOpenAuth:1339 : name=vbox:///session, auth=0x100711ff0, flags=0 2015-10-02 08:52:11.876+0000: 18446744073709551615: debug : virThreadJobSet:99 : Thread 18446744073709551615 is now running job vshEventLoop 2015-10-02 08:52:11.876+0000: 18446744073709551615: info : virObjectNew:202 : OBJECT_NEW: obj=0x7f9cda600b10 classname=virConnect 2015-10-02 08:52:11.876+0000: 18446744073709551615: info : virObjectNew:202 : OBJECT_NEW: obj=0x7f9cda600c20 classname=virConnectCloseCallbackData 2015-10-02 08:52:11.876+0000: 18446744073709551615: debug : virEventRunDefaultImpl:305 : running default event implementation 2015-10-02 08:52:11.876+0000: 18446744073709551615: debug : virEventPollCleanupTimeouts:526 : Cleanup 1 2015-10-02 08:52:11.876+0000: 18446744073709551615: debug : virEventPollCleanupHandles:575 : Cleanup 1 2015-10-02 08:52:11.876+0000: 18446744073709551615: debug : virEventPollMakePollFDs:401 : Prepare n=0 w=1, f=4 e=1 d=0 2015-10-02 08:52:11.876+0000: 18446744073709551615: debug : virEventPollCalculateTimeout:338 : Calculate expiry of 1 timers 2015-10-02 08:52:11.876+0000: 18446744073709551615: debug : virEventPollCalculateTimeout:371 : No timeout is pending 2015-10-02 08:52:11.876+0000: 18446744073709551615: debug : do_open:1132 : name "vbox:///session" to URI components: scheme vbox server <null> user <null> port -1 path /session 2015-10-02 08:52:11.876+0000: 18446744073709551615: info : virEventPollRunOnce:641 : EVENT_POLL_RUN: nhandles=1 timeout=-1 2015-10-02 08:52:11.876+0000: 18446744073709551615: debug : do_open:1179 : trying driver 0 (Test) ... 2015-10-02 08:52:11.876+0000: 18446744073709551615: debug : do_open:1194 : driver 0 Test returned DECLINED 2015-10-02 08:52:11.876+0000: 18446744073709551615: debug : do_open:1179 : trying driver 1 (VMWARE) ... 2015-10-02 08:52:11.876+0000: 18446744073709551615: debug : do_open:1194 : driver 1 VMWARE returned DECLINED 2015-10-02 08:52:11.876+0000: 18446744073709551615: debug : do_open:1179 : trying driver 2 (ESX) ... 2015-10-02 08:52:11.876+0000: 18446744073709551615: debug : do_open:1194 : driver 2 ESX returned DECLINED 2015-10-02 08:52:11.876+0000: 18446744073709551615: debug : do_open:1179 : trying driver 3 (remote) ... 2015-10-02 08:52:11.876+0000: 18446744073709551615: debug : remoteConnectOpen:1176 : Auto-spawn user daemon instance 2015-10-02 08:52:11.876+0000: 18446744073709551615: debug : doRemoteOpen:792 : proceeding with name = vbox:///session 2015-10-02 08:52:11.876+0000: 18446744073709551615: debug : doRemoteOpen:801 : Connecting with transport 1 2015-10-02 08:52:11.876+0000: 18446744073709551615: debug : doRemoteOpen:893 : Proceeding with sockname /Users/bengreene/.cache/libvirt/libvirt-sock 2015-10-02 08:52:11.876+0000: 18446744073709551615: debug : virFileFindResourceFull:1692 : Resolved 'libvirtd' to '/usr/local/Cellar/libvirt/1.2.19/sbin/libvirtd' 2015-10-02 08:52:11.876+0000: 18446744073709551615: debug : virFileMakePathHelper:2571 : path=/Users/bengreene/.cache/libvirt mode=0700 2015-10-02 08:52:11.876+0000: 18446744073709551615: debug : virNetSocketNew:226 : localAddr=0x7fff5f774330 remoteAddr=0x7fff5f7742a0 fd=7 errfd=-1 pid=0 2015-10-02 08:52:11.876+0000: 18446744073709551615: info : virObjectNew:202 : OBJECT_NEW: obj=0x7f9cda700730 classname=virNetSocket 2015-10-02 08:52:11.876+0000: 18446744073709551615: info : virNetSocketNew:277 : RPC_SOCKET_NEW: sock=0x7f9cda700730 fd=7 errfd=-1 pid=0 localAddr=127.0.0.1;0, remoteAddr=127.0.0.1;0 2015-10-02 08:52:11.876+0000: 18446744073709551615: debug : virFileClose:103 : Closed fd 6 2015-10-02 08:52:11.876+0000: 18446744073709551615: info : virObjectNew:202 : OBJECT_NEW: obj=0x7f9cda7005c0 classname=virNetClient 2015-10-02 08:52:11.876+0000: 18446744073709551615: info : virNetClientNew:327 : RPC_CLIENT_NEW: client=0x7f9cda7005c0 sock=0x7f9cda700730 2015-10-02 08:52:11.876+0000: 18446744073709551615: info : virObjectRef:296 : OBJECT_REF: obj=0x7f9cda7005c0 2015-10-02 08:52:11.876+0000: 18446744073709551615: info : virObjectRef:296 : OBJECT_REF: obj=0x7f9cda700730 2015-10-02 08:52:11.876+0000: 18446744073709551615: debug : virEventPollInterruptLocked:727 : Interrupting 2015-10-02 08:52:11.876+0000: 18446744073709551615: info : virEventPollAddHandle:140 : EVENT_POLL_ADD_HANDLE: watch=2 fd=7 events=1 cb=0x10062471b opaque=0x7f9cda700730 ff=0x100624768 2015-10-02 08:52:11.876+0000: 18446744073709551615: debug : virKeepAliveNew:199 : client=0x7f9cda7005c0, interval=-1, count=0 2015-10-02 08:52:11.876+0000: 18446744073709551615: info : virObjectNew:202 : OBJECT_NEW: obj=0x7f9cda700910 classname=virKeepAlive 2015-10-02 08:52:11.876+0000: 18446744073709551615: debug : virEventPollRunOnce:651 : Poll got 1 event(s) 2015-10-02 08:52:11.877+0000: 18446744073709551615: info : virKeepAliveNew:218 : RPC_KEEPALIVE_NEW: ka=0x7f9cda700910 client=0x7f9cda7005c0 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollDispatchTimeouts:433 : Dispatch 1 2015-10-02 08:52:11.877+0000: 18446744073709551615: info : virObjectRef:296 : OBJECT_REF: obj=0x7f9cda7005c0 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollDispatchHandles:479 : Dispatch 1 2015-10-02 08:52:11.877+0000: 18446744073709551615: info : virObjectRef:296 : OBJECT_REF: obj=0x7f9cda600c20 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollDispatchHandles:493 : i=0 w=1 2015-10-02 08:52:11.877+0000: 18446744073709551615: info : virObjectNew:202 : OBJECT_NEW: obj=0x7f9cda600ed0 classname=virNetClientProgram 2015-10-02 08:52:11.877+0000: 18446744073709551615: info : virEventPollDispatchHandles:507 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1 2015-10-02 08:52:11.877+0000: 18446744073709551615: info : virObjectNew:202 : OBJECT_NEW: obj=0x7f9cda600e00 classname=virNetClientProgram 2015-10-02 08:52:11.877+0000: 18446744073709551615: info : virObjectNew:202 : OBJECT_NEW: obj=0x7f9cda600e30 classname=virNetClientProgram 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollCleanupTimeouts:526 : Cleanup 1 2015-10-02 08:52:11.877+0000: 18446744073709551615: info : virObjectRef:296 : OBJECT_REF: obj=0x7f9cda600ed0 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollCleanupHandles:575 : Cleanup 2 2015-10-02 08:52:11.877+0000: 18446744073709551615: info : virObjectRef:296 : OBJECT_REF: obj=0x7f9cda600e00 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventRunDefaultImpl:305 : running default event implementation 2015-10-02 08:52:11.877+0000: 18446744073709551615: info : virObjectRef:296 : OBJECT_REF: obj=0x7f9cda600e30 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollCleanupTimeouts:526 : Cleanup 1 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : doRemoteOpen:1010 : Trying authentication 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollCleanupHandles:575 : Cleanup 2 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollMakePollFDs:401 : Prepare n=0 w=1, f=4 e=1 d=0 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virNetMessageNew:46 : msg=0x7f9cda600d10 tracked=0 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollMakePollFDs:401 : Prepare n=1 w=2, f=7 e=1 d=0 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollCalculateTimeout:338 : Calculate expiry of 1 timers 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollCalculateTimeout:371 : No timeout is pending 2015-10-02 08:52:11.877+0000: 18446744073709551615: info : virEventPollRunOnce:641 : EVENT_POLL_RUN: nhandles=2 timeout=-1 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virNetMessageEncodePayload:376 : Encode length as 28 2015-10-02 08:52:11.877+0000: 18446744073709551615: info : virNetClientSendInternal:1950 : RPC_CLIENT_MSG_TX_QUEUE: client=0x7f9cda7005c0 len=28 prog=536903814 vers=1 proc=66 type=0 status=0 serial=0 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virNetClientCallNew:1903 : New call 0x7f9cda600f00: msg=0x7f9cda600d10, expectReply=1, nonBlock=0 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virNetClientIO:1712 : Outgoing message prog=536903814 version=1 serial=0 proc=66 type=0 length=28 dispatch=0x0 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virNetClientIO:1771 : We have the buck head=0x7f9cda600f00 call=0x7f9cda600f00 2015-10-02 08:52:11.877+0000: 18446744073709551615: info : virEventPollUpdateHandle:152 : EVENT_POLL_UPDATE_HANDLE: watch=2 events=0 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollInterruptLocked:727 : Interrupting 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollRunOnce:651 : Poll got 1 event(s) 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollDispatchTimeouts:433 : Dispatch 1 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollDispatchHandles:479 : Dispatch 2 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollDispatchHandles:493 : i=0 w=1 2015-10-02 08:52:11.877+0000: 18446744073709551615: info : virEventPollDispatchHandles:507 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollCleanupTimeouts:526 : Cleanup 1 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollCleanupHandles:575 : Cleanup 2 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventRunDefaultImpl:305 : running default event implementation 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollCleanupTimeouts:526 : Cleanup 1 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollCleanupHandles:575 : Cleanup 2 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollMakePollFDs:401 : Prepare n=0 w=1, f=4 e=1 d=0 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollMakePollFDs:401 : Prepare n=1 w=2, f=7 e=0 d=0 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollCalculateTimeout:338 : Calculate expiry of 1 timers 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollCalculateTimeout:371 : No timeout is pending 2015-10-02 08:52:11.877+0000: 18446744073709551615: info : virEventPollRunOnce:641 : EVENT_POLL_RUN: nhandles=1 timeout=-1 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virNetMessageDecodeLength:151 : Got length, now need 36 total (32 more) 2015-10-02 08:52:11.877+0000: 18446744073709551615: info : virNetClientCallDispatch:1122 : RPC_CLIENT_MSG_RX: client=0x7f9cda7005c0 len=36 prog=536903814 vers=1 proc=66 type=1 status=0 serial=0 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virKeepAliveCheckMessage:377 : ka=0x7f9cda700910, client=0x7f9cda7005c0, msg=0x7f9cda700640 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virNetMessageClear:57 : msg=0x7f9cda700640 nfds=0 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virNetClientIOEventLoopPassTheBuck:1419 : Giving up the buck 0x7f9cda600f00 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virNetClientIOEventLoopPassTheBuck:1433 : No thread to pass the buck to 2015-10-02 08:52:11.877+0000: 18446744073709551615: info : virEventPollUpdateHandle:152 : EVENT_POLL_UPDATE_HANDLE: watch=2 events=1 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollInterruptLocked:727 : Interrupting 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virNetClientIO:1801 : All done with our call head=0x0 call=0x7f9cda600f00 rv=0 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollRunOnce:651 : Poll got 1 event(s) 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollDispatchTimeouts:433 : Dispatch 1 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollDispatchHandles:479 : Dispatch 1 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virNetMessageFree:74 : msg=0x7f9cda600d10 nfds=0 cb=0x0 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollDispatchHandles:493 : i=0 w=1 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virNetMessageNew:46 : msg=0x7f9cda500170 tracked=0 2015-10-02 08:52:11.877+0000: 18446744073709551615: info : virEventPollDispatchHandles:507 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollCleanupTimeouts:526 : Cleanup 1 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virNetMessageEncodePayload:376 : Encode length as 32 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollCleanupHandles:575 : Cleanup 2 2015-10-02 08:52:11.877+0000: 18446744073709551615: info : virNetClientSendInternal:1950 : RPC_CLIENT_MSG_TX_QUEUE: client=0x7f9cda7005c0 len=32 prog=536903814 vers=1 proc=60 type=0 status=0 serial=1 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventRunDefaultImpl:305 : running default event implementation 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virNetClientCallNew:1903 : New call 0x7f9cda500260: msg=0x7f9cda500170, expectReply=1, nonBlock=0 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollCleanupTimeouts:526 : Cleanup 1 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virNetClientIO:1712 : Outgoing message prog=536903814 version=1 serial=1 proc=60 type=0 length=32 dispatch=0x0 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollCleanupHandles:575 : Cleanup 2 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virNetClientIO:1771 : We have the buck head=0x7f9cda500260 call=0x7f9cda500260 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollMakePollFDs:401 : Prepare n=0 w=1, f=4 e=1 d=0 2015-10-02 08:52:11.877+0000: 18446744073709551615: info : virEventPollUpdateHandle:152 : EVENT_POLL_UPDATE_HANDLE: watch=2 events=0 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollMakePollFDs:401 : Prepare n=1 w=2, f=7 e=1 d=0 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollCalculateTimeout:338 : Calculate expiry of 1 timers 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollCalculateTimeout:371 : No timeout is pending 2015-10-02 08:52:11.877+0000: 18446744073709551615: info : virEventPollRunOnce:641 : EVENT_POLL_RUN: nhandles=2 timeout=-1 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollInterruptLocked:727 : Interrupting 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollRunOnce:651 : Poll got 1 event(s) 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollDispatchTimeouts:433 : Dispatch 1 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollDispatchHandles:479 : Dispatch 2 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollDispatchHandles:493 : i=0 w=1 2015-10-02 08:52:11.877+0000: 18446744073709551615: info : virEventPollDispatchHandles:507 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollCleanupTimeouts:526 : Cleanup 1 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollCleanupHandles:575 : Cleanup 2 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventRunDefaultImpl:305 : running default event implementation 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollCleanupTimeouts:526 : Cleanup 1 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollCleanupHandles:575 : Cleanup 2 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollMakePollFDs:401 : Prepare n=0 w=1, f=4 e=1 d=0 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollMakePollFDs:401 : Prepare n=1 w=2, f=7 e=0 d=0 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollCalculateTimeout:338 : Calculate expiry of 1 timers 2015-10-02 08:52:11.877+0000: 18446744073709551615: debug : virEventPollCalculateTimeout:371 : No timeout is pending 2015-10-02 08:52:11.877+0000: 18446744073709551615: info : virEventPollRunOnce:641 : EVENT_POLL_RUN: nhandles=1 timeout=-1 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virNetMessageDecodeLength:151 : Got length, now need 32 total (28 more) 2015-10-02 08:52:11.878+0000: 18446744073709551615: info : virNetClientCallDispatch:1122 : RPC_CLIENT_MSG_RX: client=0x7f9cda7005c0 len=32 prog=536903814 vers=1 proc=60 type=1 status=0 serial=1 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virKeepAliveCheckMessage:377 : ka=0x7f9cda700910, client=0x7f9cda7005c0, msg=0x7f9cda700640 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virNetMessageClear:57 : msg=0x7f9cda700640 nfds=0 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virNetClientIOEventLoopPassTheBuck:1419 : Giving up the buck 0x7f9cda500260 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virNetClientIOEventLoopPassTheBuck:1433 : No thread to pass the buck to 2015-10-02 08:52:11.878+0000: 18446744073709551615: info : virEventPollUpdateHandle:152 : EVENT_POLL_UPDATE_HANDLE: watch=2 events=1 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollInterruptLocked:727 : Interrupting 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virNetClientIO:1801 : All done with our call head=0x0 call=0x7f9cda500260 rv=0 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virNetMessageFree:74 : msg=0x7f9cda500170 nfds=0 cb=0x0 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : doRemoteOpen:1036 : Trying to open URI vbox:///session 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollRunOnce:651 : Poll got 1 event(s) 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virNetMessageNew:46 : msg=0x7f9cda500150 tracked=0 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollDispatchTimeouts:433 : Dispatch 1 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollDispatchHandles:479 : Dispatch 1 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virNetMessageEncodePayload:376 : Encode length as 56 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollDispatchHandles:493 : i=0 w=1 2015-10-02 08:52:11.878+0000: 18446744073709551615: info : virNetClientSendInternal:1950 : RPC_CLIENT_MSG_TX_QUEUE: client=0x7f9cda7005c0 len=56 prog=536903814 vers=1 proc=1 type=0 status=0 serial=2 2015-10-02 08:52:11.878+0000: 18446744073709551615: info : virEventPollDispatchHandles:507 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virNetClientCallNew:1903 : New call 0x7f9cda700440: msg=0x7f9cda500150, expectReply=1, nonBlock=0 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollCleanupTimeouts:526 : Cleanup 1 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virNetClientIO:1712 : Outgoing message prog=536903814 version=1 serial=2 proc=1 type=0 length=56 dispatch=0x0 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollCleanupHandles:575 : Cleanup 2 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virNetClientIO:1771 : We have the buck head=0x7f9cda700440 call=0x7f9cda700440 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventRunDefaultImpl:305 : running default event implementation 2015-10-02 08:52:11.878+0000: 18446744073709551615: info : virEventPollUpdateHandle:152 : EVENT_POLL_UPDATE_HANDLE: watch=2 events=0 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollCleanupTimeouts:526 : Cleanup 1 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollCleanupHandles:575 : Cleanup 2 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollMakePollFDs:401 : Prepare n=0 w=1, f=4 e=1 d=0 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollMakePollFDs:401 : Prepare n=1 w=2, f=7 e=1 d=0 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollCalculateTimeout:338 : Calculate expiry of 1 timers 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollCalculateTimeout:371 : No timeout is pending 2015-10-02 08:52:11.878+0000: 18446744073709551615: info : virEventPollRunOnce:641 : EVENT_POLL_RUN: nhandles=2 timeout=-1 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollInterruptLocked:727 : Interrupting 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollRunOnce:651 : Poll got 1 event(s) 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollDispatchTimeouts:433 : Dispatch 1 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollDispatchHandles:479 : Dispatch 2 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollDispatchHandles:493 : i=0 w=1 2015-10-02 08:52:11.878+0000: 18446744073709551615: info : virEventPollDispatchHandles:507 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollCleanupTimeouts:526 : Cleanup 1 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollCleanupHandles:575 : Cleanup 2 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventRunDefaultImpl:305 : running default event implementation 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollCleanupTimeouts:526 : Cleanup 1 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollCleanupHandles:575 : Cleanup 2 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollMakePollFDs:401 : Prepare n=0 w=1, f=4 e=1 d=0 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollMakePollFDs:401 : Prepare n=1 w=2, f=7 e=0 d=0 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollCalculateTimeout:338 : Calculate expiry of 1 timers 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollCalculateTimeout:371 : No timeout is pending 2015-10-02 08:52:11.878+0000: 18446744073709551615: info : virEventPollRunOnce:641 : EVENT_POLL_RUN: nhandles=1 timeout=-1 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virNetMessageDecodeLength:151 : Got length, now need 208 total (204 more) 2015-10-02 08:52:11.878+0000: 18446744073709551615: info : virNetClientCallDispatch:1122 : RPC_CLIENT_MSG_RX: client=0x7f9cda7005c0 len=208 prog=536903814 vers=1 proc=1 type=1 status=1 serial=2 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virKeepAliveCheckMessage:377 : ka=0x7f9cda700910, client=0x7f9cda7005c0, msg=0x7f9cda700640 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virNetMessageClear:57 : msg=0x7f9cda700640 nfds=0 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virNetClientIOEventLoopPassTheBuck:1419 : Giving up the buck 0x7f9cda700440 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virNetClientIOEventLoopPassTheBuck:1433 : No thread to pass the buck to 2015-10-02 08:52:11.878+0000: 18446744073709551615: info : virEventPollUpdateHandle:152 : EVENT_POLL_UPDATE_HANDLE: watch=2 events=1 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollInterruptLocked:727 : Interrupting 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virNetClientIO:1801 : All done with our call head=0x0 call=0x7f9cda700440 rv=0 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollRunOnce:651 : Poll got 1 event(s) 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollDispatchTimeouts:433 : Dispatch 1 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virNetMessageFree:74 : msg=0x7f9cda500150 nfds=0 cb=0x0 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollDispatchHandles:479 : Dispatch 1 2015-10-02 08:52:11.878+0000: 18446744073709551615: info : virObjectUnref:259 : OBJECT_UNREF: obj=0x7f9cda600ed0 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollDispatchHandles:493 : i=0 w=1 2015-10-02 08:52:11.878+0000: 18446744073709551615: info : virObjectUnref:259 : OBJECT_UNREF: obj=0x7f9cda600e00 2015-10-02 08:52:11.878+0000: 18446744073709551615: info : virEventPollDispatchHandles:507 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1 2015-10-02 08:52:11.878+0000: 18446744073709551615: info : virObjectUnref:259 : OBJECT_UNREF: obj=0x7f9cda600e30 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollCleanupTimeouts:526 : Cleanup 1 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virNetClientCloseInternal:695 : client=0x7f9cda7005c0 wantclose=0 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollCleanupHandles:575 : Cleanup 2 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virNetClientMarkClose:638 : client=0x7f9cda7005c0, reason=3 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventRunDefaultImpl:305 : running default event implementation 2015-10-02 08:52:11.878+0000: 18446744073709551615: info : virEventPollRemoveHandle:186 : EVENT_POLL_REMOVE_HANDLE: watch=2 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollCleanupTimeouts:526 : Cleanup 1 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollCleanupHandles:575 : Cleanup 2 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollMakePollFDs:401 : Prepare n=0 w=1, f=4 e=1 d=0 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollMakePollFDs:401 : Prepare n=1 w=2, f=7 e=1 d=0 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollCalculateTimeout:338 : Calculate expiry of 1 timers 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollCalculateTimeout:371 : No timeout is pending 2015-10-02 08:52:11.878+0000: 18446744073709551615: info : virEventPollRunOnce:641 : EVENT_POLL_RUN: nhandles=2 timeout=-1 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollRemoveHandle:199 : mark delete 1 7 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollInterruptLocked:727 : Interrupting 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virNetClientIOEventLoopPassTheBuck:1419 : Giving up the buck 0x0 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollRunOnce:651 : Poll got 1 event(s) 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virNetClientIOEventLoopPassTheBuck:1433 : No thread to pass the buck to 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollDispatchTimeouts:433 : Dispatch 1 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virNetClientCloseLocked:654 : client=0x7f9cda7005c0, sock=0x7f9cda700730, reason=3 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollDispatchHandles:479 : Dispatch 2 2015-10-02 08:52:11.878+0000: 18446744073709551615: info : virObjectUnref:259 : OBJECT_UNREF: obj=0x7f9cda700730 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollDispatchHandles:493 : i=0 w=1 2015-10-02 08:52:11.878+0000: 18446744073709551615: info : virObjectRef:296 : OBJECT_REF: obj=0x7f9cda7005c0 2015-10-02 08:52:11.878+0000: 18446744073709551615: info : virEventPollDispatchHandles:507 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1 2015-10-02 08:52:11.878+0000: 18446744073709551615: info : virKeepAliveStop:310 : RPC_KEEPALIVE_STOP: ka=0x7f9cda700910 client=0x7f9cda7005c0 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollDispatchHandles:493 : i=1 w=2 2015-10-02 08:52:11.878+0000: 18446744073709551615: info : virObjectUnref:259 : OBJECT_UNREF: obj=0x7f9cda700910 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollDispatchHandles:496 : Skip deleted n=1 w=2 f=7 2015-10-02 08:52:11.878+0000: 18446744073709551615: info : virObjectUnref:261 : OBJECT_DISPOSE: obj=0x7f9cda700910 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollCleanupTimeouts:526 : Cleanup 1 2015-10-02 08:52:11.878+0000: 18446744073709551615: info : virKeepAliveDispose:230 : RPC_KEEPALIVE_DISPOSE: ka=0x7f9cda700910 2015-10-02 08:52:11.878+0000: 18446744073709551615: debug : virEventPollCleanupHandles:575 : Cleanup 2 2015-10-02 08:52:11.879+0000: 18446744073709551615: info : virObjectUnref:259 : OBJECT_UNREF: obj=0x7f9cda7005c0 2015-10-02 08:52:11.879+0000: 18446744073709551615: info : virEventPollCleanupHandles:588 : EVENT_POLL_PURGE_HANDLE: watch=2 2015-10-02 08:52:11.879+0000: 18446744073709551615: info : virObjectUnref:259 : OBJECT_UNREF: obj=0x7f9cda7005c0 2015-10-02 08:52:11.879+0000: 18446744073709551615: info : virObjectUnref:259 : OBJECT_UNREF: obj=0x7f9cda700730 2015-10-02 08:52:11.879+0000: 18446744073709551615: info : virObjectUnref:259 : OBJECT_UNREF: obj=0x7f9cda7005c0 2015-10-02 08:52:11.879+0000: 18446744073709551615: info : virObjectUnref:261 : OBJECT_DISPOSE: obj=0x7f9cda700730 2015-10-02 08:52:11.879+0000: 18446744073709551615: info : virObjectUnref:259 : OBJECT_UNREF: obj=0x7f9cda7005c0 2015-10-02 08:52:11.879+0000: 18446744073709551615: info : virNetSocketDispose:1157 : RPC_SOCKET_DISPOSE: sock=0x7f9cda700730 2015-10-02 08:52:11.879+0000: 18446744073709551615: info : virObjectUnref:261 : OBJECT_DISPOSE: obj=0x7f9cda7005c0 2015-10-02 08:52:11.879+0000: 18446744073709551615: info : virNetClientDispose:606 : RPC_CLIENT_DISPOSE: client=0x7f9cda7005c0 2015-10-02 08:52:11.879+0000: 18446744073709551615: info : virObjectUnref:259 : OBJECT_UNREF: obj=0x7f9cda600c20 2015-10-02 08:52:11.879+0000: 18446744073709551615: info : virObjectUnref:259 : OBJECT_UNREF: obj=0x7f9cda600ed0 2015-10-02 08:52:11.879+0000: 18446744073709551615: info : virObjectUnref:261 : OBJECT_DISPOSE: obj=0x7f9cda600ed0 2015-10-02 08:52:11.879+0000: 18446744073709551615: info : virObjectUnref:259 : OBJECT_UNREF: obj=0x7f9cda600e00 2015-10-02 08:52:11.879+0000: 18446744073709551615: info : virObjectUnref:261 : OBJECT_DISPOSE: obj=0x7f9cda600e00 2015-10-02 08:52:11.879+0000: 18446744073709551615: info : virObjectUnref:259 : OBJECT_UNREF: obj=0x7f9cda600e30 2015-10-02 08:52:11.879+0000: 18446744073709551615: info : virObjectUnref:261 : OBJECT_DISPOSE: obj=0x7f9cda600e30 2015-10-02 08:52:11.879+0000: 18446744073709551615: debug : virFileClose:103 : Closed fd 8 2015-10-02 08:52:11.879+0000: 18446744073709551615: debug : virFileClose:103 : Closed fd 6 2015-10-02 08:52:11.879+0000: 18446744073709551615: debug : virNetMessageClear:57 : msg=0x7f9cda700640 nfds=0 2015-10-02 08:52:11.879+0000: 18446744073709551615: debug : do_open:1194 : driver 3 remote returned ERROR 2015-10-02 08:52:11.879+0000: 18446744073709551615: info : virObjectUnref:259 : OBJECT_UNREF: obj=0x7f9cda600b10 2015-10-02 08:52:11.879+0000: 18446744073709551615: debug : virFileClose:103 : Closed fd 7 2015-10-02 08:52:11.879+0000: 18446744073709551615: info : virObjectUnref:261 : OBJECT_DISPOSE: obj=0x7f9cda600b10 2015-10-02 08:52:11.879+0000: 18446744073709551615: debug : virEventRunDefaultImpl:305 : running default event implementation 2015-10-02 08:52:11.879+0000: 18446744073709551615: info : virObjectUnref:259 : OBJECT_UNREF: obj=0x7f9cda600c20 2015-10-02 08:52:11.879+0000: 18446744073709551615: debug : virEventPollCleanupTimeouts:526 : Cleanup 1 2015-10-02 08:52:11.879+0000: 18446744073709551615: info : virObjectUnref:261 : OBJECT_DISPOSE: obj=0x7f9cda600c20 2015-10-02 08:52:11.879+0000: 18446744073709551615: debug : virEventPollCleanupHandles:575 : Cleanup 1 2015-10-02 08:52:11.879+0000: 18446744073709551615: debug : virEventPollMakePollFDs:401 : Prepare n=0 w=1, f=4 e=1 d=0 2015-10-02 08:52:11.879+0000: 18446744073709551615: debug : virEventPollCalculateTimeout:338 : Calculate expiry of 1 timers 2015-10-02 08:52:11.879+0000: 18446744073709551615: debug : virEventPollCalculateTimeout:371 : No timeout is pending error: 2015-10-02 08:52:11.879+0000: 18446744073709551615: info : virEventPollRunOnce:641 : EVENT_POLL_RUN: nhandles=1 timeout=-1 failed to connect to the hypervisor error: internal error: unable to initialize VirtualBox driver API 2015-10-02 08:52:11.879+0000: 18446744073709551615: debug : virFileMakePathHelper:2571 : path=/Users/bengreene/.cache/libvirt/virsh mode=0755 2015-10-02 08:52:11.879+0000: 18446744073709551615: debug : virEventPollInterruptLocked:727 : Interrupting 2015-10-02 08:52:11.879+0000: 18446744073709551615: info : virEventPollAddTimeout:253 : EVENT_POLL_ADD_TIMEOUT: timer=2 frequency=0 cb=0x100493620 opaque=0x0 ff=0x0 2015-10-02 08:52:11.879+0000: 18446744073709551615: debug : virEventPollRunOnce:651 : Poll got 1 event(s) 2015-10-02 08:52:11.879+0000: 18446744073709551615: debug : virEventPollDispatchTimeouts:433 : Dispatch 2 2015-10-02 08:52:11.879+0000: 18446744073709551615: info : virEventPollDispatchTimeouts:456 : EVENT_POLL_DISPATCH_TIMEOUT: timer=2 2015-10-02 08:52:11.879+0000: 18446744073709551615: debug : virEventPollDispatchHandles:479 : Dispatch 1 2015-10-02 08:52:11.879+0000: 18446744073709551615: debug : virEventPollDispatchHandles:493 : i=0 w=1 2015-10-02 08:52:11.879+0000: 18446744073709551615: info : virEventPollDispatchHandles:507 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1 2015-10-02 08:52:11.879+0000: 18446744073709551615: debug : virEventPollCleanupTimeouts:526 : Cleanup 2 2015-10-02 08:52:11.879+0000: 18446744073709551615: debug : virEventPollCleanupHandles:575 : Cleanup 1 2015-10-02 08:52:11.879+0000: 18446744073709551615: debug : virThreadJobClear:124 : Thread 18446744073709551615 finished job vshEventLoop with ret=0 2015-10-02 08:52:11.879+0000: 18446744073709551615: info : virEventPollRemoveTimeout:305 : EVENT_POLL_REMOVE_TIMEOUT: timer=2 2015-10-02 08:52:11.879+0000: 18446744073709551615: debug : virEventPollInterruptLocked:723 : Skip interrupt, 0 123145302839296 2015-10-02 08:52:11.879+0000: 18446744073709551615: info : virEventPollRemoveTimeout:305 : EVENT_POLL_REMOVE_TIMEOUT: timer=1 2015-10-02 08:52:11.879+0000: 18446744073709551615: debug : virEventPollInterruptLocked:723 : Skip interrupt, 0 123145302839296 Foyil:~ bengreene$

1 0