Login
[x]
Log in using an account from:
Fedora Account System
Red Hat Associate
Red Hat Customer
Or login using a Red Hat Bugzilla account
Forgot Password
Login:
Hide Forgot
Create an Account
Red Hat Bugzilla – Attachment 828554 Details for
Bug 1025108
hot-plug of USB device fails when only the vendor id and product id are specified
[?]
New
Simple Search
Advanced Search
My Links
Browse
Requests
Reports
Current State
Search
Tabular reports
Graphical reports
Duplicates
Other Reports
User Changes
Plotly Reports
Bug Status
Bug Severity
Non-Defaults
|
Product Dashboard
Help
Page Help!
Bug Writing Guidelines
What's new
Browser Support Policy
5.0.4.rh83 Release notes
FAQ
Guides index
User guide
Web Services
Contact
Legal
This site requires JavaScript to be enabled to function correctly, please enable it.
libvirtd log
libvirtd_debug.log (text/plain), 123.74 KB, created by
hongming
on 2013-11-25 08:27:55 UTC
(
hide
)
Description:
libvirtd log
Filename:
MIME Type:
Creator:
hongming
Created:
2013-11-25 08:27:55 UTC
Size:
123.74 KB
patch
obsolete
>2013-11-25 08:26:02.001+0000: 3913: debug : virEventPollRunOnce:638 : Poll got 1 event(s) >2013-11-25 08:26:02.001+0000: 3913: debug : virEventPollDispatchTimeouts:423 : Dispatch 1 >2013-11-25 08:26:02.001+0000: 3913: debug : virEventPollDispatchHandles:468 : Dispatch 9 >2013-11-25 08:26:02.001+0000: 3913: debug : virEventPollDispatchHandles:482 : i=0 w=1 >2013-11-25 08:26:02.001+0000: 3913: debug : virEventPollDispatchHandles:482 : i=1 w=2 >2013-11-25 08:26:02.001+0000: 3913: debug : virEventPollDispatchHandles:482 : i=2 w=3 >2013-11-25 08:26:02.001+0000: 3913: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=3 events=1 >2013-11-25 08:26:02.002+0000: 3913: debug : virNetSocketNew:155 : localAddr=0x7fffe44a6ce0 remoteAddr=0x7fffe44a6d70 fd=22 errfd=-1 pid=0 >2013-11-25 08:26:02.002+0000: 3913: debug : virObjectNew:199 : OBJECT_NEW: obj=0x7fefbfeb4fd0 classname=virNetSocket >2013-11-25 08:26:02.002+0000: 3913: debug : virNetSocketNew:205 : RPC_SOCKET_NEW: sock=0x7fefbfeb4fd0 fd=22 errfd=-1 pid=0 localAddr=127.0.0.1;0, remoteAddr=127.0.0.1;0 >2013-11-25 08:26:02.002+0000: 3913: debug : virNetServerClientNew:414 : sock=0x7fefbfeb4fd0 auth=2 tls=(nil) >2013-11-25 08:26:02.002+0000: 3913: debug : virObjectNew:199 : OBJECT_NEW: obj=0x7fefbfeb5710 classname=virNetServerClient >2013-11-25 08:26:02.002+0000: 3913: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fefbfeb4fd0 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140667668162688 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollAddTimeout:248 : EVENT_POLL_ADD_TIMEOUT: timer=5 frequency=-1 cb=0x7fefbdd0e260 opaque=0x7fefbfeb5710 ff=(nil) >2013-11-25 08:26:02.002+0000: 3913: debug : virNetMessageNew:44 : msg=0x7fefbfeb5800 tracked=1 >2013-11-25 08:26:02.002+0000: 3913: debug : virNetServerClientNewInternal:384 : RPC_SERVER_CLIENT_NEW: client=0x7fefbfeb5710 sock=0x7fefbfeb4fd0 >2013-11-25 08:26:02.002+0000: 3913: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7fefbfeb5800 tx=(nil) >2013-11-25 08:26:02.002+0000: 3913: debug : virNetServerClientCalculateHandleMode:188 : mode=1 >2013-11-25 08:26:02.002+0000: 3913: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fefbfeb5710 >2013-11-25 08:26:02.002+0000: 3913: debug : virNetServerClientRegisterEvent:204 : Registering client event callback 1 >2013-11-25 08:26:02.002+0000: 3913: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fefbfeb4fd0 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140667668162688 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollAddHandle:136 : EVENT_POLL_ADD_HANDLE: watch=14 fd=22 events=1 cb=0x7fefbdd15f00 opaque=0x7fefbfeb4fd0 ff=0x7fefbdd15eb0 >2013-11-25 08:26:02.002+0000: 3913: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fefbfeb5710 >2013-11-25 08:26:02.002+0000: 3913: debug : virKeepAliveNew:196 : client=0x7fefbfeb5710, interval=5, count=5 >2013-11-25 08:26:02.002+0000: 3913: debug : virObjectNew:199 : OBJECT_NEW: obj=0x7fefbfeb45a0 classname=virKeepAlive >2013-11-25 08:26:02.002+0000: 3913: debug : virKeepAliveNew:215 : RPC_KEEPALIVE_NEW: ka=0x7fefbfeb45a0 client=0x7fefbfeb5710 >2013-11-25 08:26:02.002+0000: 3913: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fefbfeb5710 >2013-11-25 08:26:02.002+0000: 3913: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fefbfeb5710 >2013-11-25 08:26:02.002+0000: 3913: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fefbfeb4fd0 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollDispatchHandles:482 : i=3 w=4 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollDispatchHandles:482 : i=4 w=5 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollDispatchHandles:482 : i=5 w=6 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollDispatchHandles:482 : i=7 w=8 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollDispatchHandles:482 : i=8 w=9 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollDispatchHandles:482 : i=9 w=11 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollCleanupTimeouts:514 : Cleanup 2 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollCleanupTimeouts:527 : EVENT_POLL_PURGE_TIMEOUT: timer=3 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollCleanupHandles:562 : Cleanup 11 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventRunDefaultImpl:270 : running default event implementation >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollCleanupTimeouts:514 : Cleanup 1 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollCleanupHandles:562 : Cleanup 11 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=6 e=1 d=0 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=8 e=1 d=0 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=2 w=3, f=11 e=1 d=0 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=3 w=4, f=12 e=1 d=0 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=4 w=5, f=13 e=1 d=0 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=5 w=6, f=14 e=1 d=0 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=6 w=7, f=15 e=0 d=0 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=7 w=8, f=15 e=1 d=0 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=8 w=9, f=17 e=1 d=0 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=9 w=11, f=21 e=25 d=0 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=10 w=14, f=22 e=1 d=0 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 1 timers >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=10 timeout=-1 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollRunOnce:638 : Poll got 1 event(s) >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollDispatchTimeouts:423 : Dispatch 1 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollDispatchHandles:468 : Dispatch 10 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollDispatchHandles:482 : i=0 w=1 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollDispatchHandles:482 : i=1 w=2 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollDispatchHandles:482 : i=2 w=3 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollDispatchHandles:482 : i=3 w=4 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollDispatchHandles:482 : i=4 w=5 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollDispatchHandles:482 : i=5 w=6 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollDispatchHandles:482 : i=7 w=8 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollDispatchHandles:482 : i=8 w=9 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollDispatchHandles:482 : i=9 w=11 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollDispatchHandles:482 : i=10 w=14 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=14 events=1 >2013-11-25 08:26:02.002+0000: 3913: debug : virNetMessageDecodeLength:149 : Got length, now need 28 total (24 more) >2013-11-25 08:26:02.002+0000: 3913: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7fefbfeb5800 tx=(nil) >2013-11-25 08:26:02.002+0000: 3913: debug : virNetServerClientCalculateHandleMode:188 : mode=1 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=14 events=1 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140667668162688 >2013-11-25 08:26:02.002+0000: 3913: debug : virNetServerClientDispatchRead:1202 : RPC_SERVER_CLIENT_MSG_RX: client=0x7fefbfeb5710 len=28 prog=536903814 vers=1 proc=66 type=0 status=0 serial=0 >2013-11-25 08:26:02.002+0000: 3913: debug : virKeepAliveCheckMessage:374 : ka=0x7fefbfeb45a0, client=0x7fefbfeb5710, msg=0x7fefbfeb5800 >2013-11-25 08:26:02.002+0000: 3913: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fefbfeb5710 >2013-11-25 08:26:02.002+0000: 3913: debug : virNetServerDispatchNewMessage:213 : server=0x7fefbfea6430 client=0x7fefbfeb5710 message=0x7fefbfeb5800 >2013-11-25 08:26:02.002+0000: 3913: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fefbfeafc60 >2013-11-25 08:26:02.002+0000: 3913: debug : virNetMessageNew:44 : msg=0x7fefbfeb6660 tracked=1 >2013-11-25 08:26:02.002+0000: 3913: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7fefbfeb6660 tx=(nil) >2013-11-25 08:26:02.002+0000: 3913: debug : virNetServerClientCalculateHandleMode:188 : mode=1 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=14 events=1 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140667668162688 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollCleanupTimeouts:514 : Cleanup 1 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollCleanupHandles:562 : Cleanup 11 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventRunDefaultImpl:270 : running default event implementation >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollCleanupTimeouts:514 : Cleanup 1 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollCleanupHandles:562 : Cleanup 11 >2013-11-25 08:26:02.002+0000: 3918: debug : virNetServerHandleJob:184 : server=0x7fefbfea6430 client=0x7fefbfeb5710 message=0x7fefbfeb5800 prog=0x7fefbfeafc60 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=6 e=1 d=0 >2013-11-25 08:26:02.002+0000: 3918: debug : virNetServerProgramDispatch:285 : prog=536903814 ver=1 type=0 status=0 serial=0 proc=66 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=8 e=1 d=0 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=2 w=3, f=11 e=1 d=0 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=3 w=4, f=12 e=1 d=0 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=4 w=5, f=13 e=1 d=0 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=5 w=6, f=14 e=1 d=0 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=6 w=7, f=15 e=0 d=0 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=7 w=8, f=15 e=1 d=0 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=8 w=9, f=17 e=1 d=0 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=9 w=11, f=21 e=25 d=0 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=10 w=14, f=22 e=1 d=0 >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 1 timers >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms >2013-11-25 08:26:02.002+0000: 3913: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=10 timeout=-1 >2013-11-25 08:26:02.004+0000: 3918: debug : virFileClose:90 : Closed fd 23 >2013-11-25 08:26:02.005+0000: 3918: debug : virObjectNew:199 : OBJECT_NEW: obj=0x7fef94000940 classname=virIdentity >2013-11-25 08:26:02.005+0000: 3918: debug : virIdentitySetAttr:282 : ident=0x7fef94000940 attribute=0 value=root >2013-11-25 08:26:02.005+0000: 3918: debug : virIdentitySetAttr:282 : ident=0x7fef94000940 attribute=1 value=0 >2013-11-25 08:26:02.005+0000: 3918: debug : virIdentitySetAttr:282 : ident=0x7fef94000940 attribute=2 value=root >2013-11-25 08:26:02.005+0000: 3918: debug : virIdentitySetAttr:282 : ident=0x7fef94000940 attribute=3 value=0 >2013-11-25 08:26:02.005+0000: 3918: debug : virIdentitySetAttr:282 : ident=0x7fef94000940 attribute=4 value=4213 >2013-11-25 08:26:02.005+0000: 3918: debug : virIdentitySetAttr:282 : ident=0x7fef94000940 attribute=5 value=178337 >2013-11-25 08:26:02.005+0000: 3918: debug : virIdentitySetAttr:282 : ident=0x7fef94000940 attribute=8 value=unconfined_u:unconfined_r:unconfined_t:s0-s0:c0.c1023 >2013-11-25 08:26:02.005+0000: 3918: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fef94000940 >2013-11-25 08:26:02.005+0000: 3918: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fef94000940 >2013-11-25 08:26:02.005+0000: 3918: debug : remoteDispatchAuthListHelper:18 : server=0x7fefbfea6430 client=0x7fefbfeb5710 msg=0x7fefbfeb5800 rerr=0x7fefad5a5c90 args=0x7fef94000c80 ret=0x7fef94000ca0 >2013-11-25 08:26:02.005+0000: 3918: debug : virFileClose:90 : Closed fd 23 >2013-11-25 08:26:02.005+0000: 3918: info : remoteDispatchAuthList:2329 : Bypass polkit auth for privileged client pid:4213,uid:0 >2013-11-25 08:26:02.005+0000: 3918: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fef94000940 >2013-11-25 08:26:02.005+0000: 3918: debug : virNetMessageEncodePayload:374 : Encode length as 36 >2013-11-25 08:26:02.005+0000: 3918: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fef94000940 >2013-11-25 08:26:02.005+0000: 3918: debug : virNetServerClientSendMessageLocked:1451 : msg=0x7fefbfeb5800 proc=66 len=36 offset=0 >2013-11-25 08:26:02.005+0000: 3918: debug : virNetServerClientSendMessageLocked:1459 : RPC_SERVER_CLIENT_MSG_TX_QUEUE: client=0x7fefbfeb5710 len=36 prog=536903814 vers=1 proc=66 type=1 status=0 serial=0 >2013-11-25 08:26:02.005+0000: 3918: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7fefbfeb6660 tx=0x7fefbfeb5800 >2013-11-25 08:26:02.005+0000: 3918: debug : virNetServerClientCalculateHandleMode:188 : mode=3 >2013-11-25 08:26:02.005+0000: 3918: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=14 events=3 >2013-11-25 08:26:02.005+0000: 3918: debug : virEventPollInterruptLocked:714 : Interrupting >2013-11-25 08:26:02.006+0000: 3918: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fefbfeafc60 >2013-11-25 08:26:02.006+0000: 3918: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fefbfeb5710 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollRunOnce:638 : Poll got 1 event(s) >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollDispatchTimeouts:423 : Dispatch 1 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollDispatchHandles:468 : Dispatch 10 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollDispatchHandles:482 : i=0 w=1 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollDispatchHandles:482 : i=1 w=2 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollDispatchHandles:482 : i=2 w=3 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollDispatchHandles:482 : i=3 w=4 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollDispatchHandles:482 : i=4 w=5 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollDispatchHandles:482 : i=5 w=6 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollDispatchHandles:482 : i=7 w=8 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollDispatchHandles:482 : i=8 w=9 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollDispatchHandles:482 : i=9 w=11 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollDispatchHandles:482 : i=10 w=14 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollCleanupTimeouts:514 : Cleanup 1 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollCleanupHandles:562 : Cleanup 11 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventRunDefaultImpl:270 : running default event implementation >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollCleanupTimeouts:514 : Cleanup 1 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollCleanupHandles:562 : Cleanup 11 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=6 e=1 d=0 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=8 e=1 d=0 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=2 w=3, f=11 e=1 d=0 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=3 w=4, f=12 e=1 d=0 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=4 w=5, f=13 e=1 d=0 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=5 w=6, f=14 e=1 d=0 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=6 w=7, f=15 e=0 d=0 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=7 w=8, f=15 e=1 d=0 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=8 w=9, f=17 e=1 d=0 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=9 w=11, f=21 e=25 d=0 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=10 w=14, f=22 e=5 d=0 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 1 timers >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=10 timeout=-1 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollRunOnce:638 : Poll got 1 event(s) >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollDispatchTimeouts:423 : Dispatch 1 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollDispatchHandles:468 : Dispatch 10 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollDispatchHandles:482 : i=0 w=1 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollDispatchHandles:482 : i=1 w=2 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollDispatchHandles:482 : i=2 w=3 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollDispatchHandles:482 : i=3 w=4 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollDispatchHandles:482 : i=4 w=5 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollDispatchHandles:482 : i=5 w=6 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollDispatchHandles:482 : i=7 w=8 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollDispatchHandles:482 : i=8 w=9 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollDispatchHandles:482 : i=9 w=11 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollDispatchHandles:482 : i=10 w=14 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=14 events=2 >2013-11-25 08:26:02.006+0000: 3913: debug : virNetMessageFree:72 : msg=0x7fefbfeb5800 nfds=0 cb=(nil) >2013-11-25 08:26:02.006+0000: 3913: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7fefbfeb6660 tx=(nil) >2013-11-25 08:26:02.006+0000: 3913: debug : virNetServerClientCalculateHandleMode:188 : mode=1 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=14 events=1 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140667668162688 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollCleanupTimeouts:514 : Cleanup 1 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollCleanupHandles:562 : Cleanup 11 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventRunDefaultImpl:270 : running default event implementation >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollCleanupTimeouts:514 : Cleanup 1 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollCleanupHandles:562 : Cleanup 11 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=6 e=1 d=0 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=8 e=1 d=0 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=2 w=3, f=11 e=1 d=0 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=3 w=4, f=12 e=1 d=0 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=4 w=5, f=13 e=1 d=0 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=5 w=6, f=14 e=1 d=0 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=6 w=7, f=15 e=0 d=0 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=7 w=8, f=15 e=1 d=0 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=8 w=9, f=17 e=1 d=0 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=9 w=11, f=21 e=25 d=0 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=10 w=14, f=22 e=1 d=0 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 1 timers >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=10 timeout=-1 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollRunOnce:638 : Poll got 1 event(s) >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollDispatchTimeouts:423 : Dispatch 1 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollDispatchHandles:468 : Dispatch 10 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollDispatchHandles:482 : i=0 w=1 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollDispatchHandles:482 : i=1 w=2 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollDispatchHandles:482 : i=2 w=3 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollDispatchHandles:482 : i=3 w=4 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollDispatchHandles:482 : i=4 w=5 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollDispatchHandles:482 : i=5 w=6 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollDispatchHandles:482 : i=7 w=8 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollDispatchHandles:482 : i=8 w=9 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollDispatchHandles:482 : i=9 w=11 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollDispatchHandles:482 : i=10 w=14 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=14 events=1 >2013-11-25 08:26:02.006+0000: 3913: debug : virNetMessageDecodeLength:149 : Got length, now need 32 total (28 more) >2013-11-25 08:26:02.006+0000: 3913: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7fefbfeb6660 tx=(nil) >2013-11-25 08:26:02.006+0000: 3913: debug : virNetServerClientCalculateHandleMode:188 : mode=1 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=14 events=1 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140667668162688 >2013-11-25 08:26:02.006+0000: 3913: debug : virNetServerClientDispatchRead:1202 : RPC_SERVER_CLIENT_MSG_RX: client=0x7fefbfeb5710 len=32 prog=536903814 vers=1 proc=60 type=0 status=0 serial=1 >2013-11-25 08:26:02.006+0000: 3913: debug : virKeepAliveCheckMessage:374 : ka=0x7fefbfeb45a0, client=0x7fefbfeb5710, msg=0x7fefbfeb6660 >2013-11-25 08:26:02.006+0000: 3913: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fefbfeb5710 >2013-11-25 08:26:02.006+0000: 3913: debug : virNetServerDispatchNewMessage:213 : server=0x7fefbfea6430 client=0x7fefbfeb5710 message=0x7fefbfeb6660 >2013-11-25 08:26:02.006+0000: 3913: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fefbfeafc60 >2013-11-25 08:26:02.006+0000: 3913: debug : virNetMessageNew:44 : msg=0x7fefbfeb4130 tracked=1 >2013-11-25 08:26:02.006+0000: 3913: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7fefbfeb4130 tx=(nil) >2013-11-25 08:26:02.006+0000: 3913: debug : virNetServerClientCalculateHandleMode:188 : mode=1 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=14 events=1 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140667668162688 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollCleanupTimeouts:514 : Cleanup 1 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollCleanupHandles:562 : Cleanup 11 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventRunDefaultImpl:270 : running default event implementation >2013-11-25 08:26:02.006+0000: 3917: debug : virNetServerHandleJob:184 : server=0x7fefbfea6430 client=0x7fefbfeb5710 message=0x7fefbfeb6660 prog=0x7fefbfeafc60 >2013-11-25 08:26:02.006+0000: 3917: debug : virNetServerProgramDispatch:285 : prog=536903814 ver=1 type=0 status=0 serial=1 proc=60 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollCleanupTimeouts:514 : Cleanup 1 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollCleanupHandles:562 : Cleanup 11 >2013-11-25 08:26:02.006+0000: 3917: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fef94000940 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=6 e=1 d=0 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=8 e=1 d=0 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=2 w=3, f=11 e=1 d=0 >2013-11-25 08:26:02.006+0000: 3917: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fef94000940 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=3 w=4, f=12 e=1 d=0 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=4 w=5, f=13 e=1 d=0 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=5 w=6, f=14 e=1 d=0 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=6 w=7, f=15 e=0 d=0 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=7 w=8, f=15 e=1 d=0 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=8 w=9, f=17 e=1 d=0 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=9 w=11, f=21 e=25 d=0 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=10 w=14, f=22 e=1 d=0 >2013-11-25 08:26:02.006+0000: 3913: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 1 timers >2013-11-25 08:26:02.006+0000: 3917: debug : remoteDispatchConnectSupportsFeatureHelper:2200 : server=0x7fefbfea6430 client=0x7fefbfeb5710 msg=0x7fefbfeb6660 rerr=0x7fefadda6c90 args=0x7fef88000ae0 ret=0x7fef88001a90 >2013-11-25 08:26:02.007+0000: 3917: debug : virKeepAliveStart:276 : RPC_KEEPALIVE_START: ka=0x7fefbfeb45a0 client=0x7fefbfeb5710 interval=0 count=0 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=10 timeout=-1 >2013-11-25 08:26:02.007+0000: 3917: debug : virEventPollInterruptLocked:714 : Interrupting >2013-11-25 08:26:02.007+0000: 3917: debug : virEventPollAddTimeout:248 : EVENT_POLL_ADD_TIMEOUT: timer=6 frequency=5000 cb=0x7fefbdd124a0 opaque=0x7fefbfeb45a0 ff=0x7fefbdc25680 >2013-11-25 08:26:02.007+0000: 3917: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fefbfeb45a0 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollRunOnce:638 : Poll got 1 event(s) >2013-11-25 08:26:02.007+0000: 3917: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fef94000940 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollDispatchTimeouts:423 : Dispatch 2 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollDispatchHandles:468 : Dispatch 10 >2013-11-25 08:26:02.007+0000: 3917: debug : virNetMessageEncodePayload:374 : Encode length as 32 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollDispatchHandles:482 : i=0 w=1 >2013-11-25 08:26:02.007+0000: 3917: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fef94000940 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1 >2013-11-25 08:26:02.007+0000: 3917: debug : virNetServerClientSendMessageLocked:1451 : msg=0x7fefbfeb6660 proc=60 len=32 offset=0 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollDispatchHandles:482 : i=1 w=2 >2013-11-25 08:26:02.007+0000: 3917: debug : virNetServerClientSendMessageLocked:1459 : RPC_SERVER_CLIENT_MSG_TX_QUEUE: client=0x7fefbfeb5710 len=32 prog=536903814 vers=1 proc=60 type=1 status=0 serial=1 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollDispatchHandles:482 : i=2 w=3 >2013-11-25 08:26:02.007+0000: 3917: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7fefbfeb4130 tx=0x7fefbfeb6660 >2013-11-25 08:26:02.007+0000: 3917: debug : virNetServerClientCalculateHandleMode:188 : mode=3 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollDispatchHandles:482 : i=3 w=4 >2013-11-25 08:26:02.007+0000: 3917: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=14 events=3 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollDispatchHandles:482 : i=4 w=5 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollDispatchHandles:482 : i=5 w=6 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollDispatchHandles:482 : i=7 w=8 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollDispatchHandles:482 : i=8 w=9 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollDispatchHandles:482 : i=9 w=11 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollDispatchHandles:482 : i=10 w=14 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollCleanupTimeouts:514 : Cleanup 2 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollCleanupHandles:562 : Cleanup 11 >2013-11-25 08:26:02.007+0000: 3917: debug : virEventPollInterruptLocked:710 : Skip interrupt, 0 140667668162688 >2013-11-25 08:26:02.007+0000: 3917: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fefbfeafc60 >2013-11-25 08:26:02.007+0000: 3917: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fefbfeb5710 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventRunDefaultImpl:270 : running default event implementation >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollCleanupTimeouts:514 : Cleanup 2 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollCleanupHandles:562 : Cleanup 11 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=6 e=1 d=0 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=8 e=1 d=0 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=2 w=3, f=11 e=1 d=0 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=3 w=4, f=12 e=1 d=0 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=4 w=5, f=13 e=1 d=0 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=5 w=6, f=14 e=1 d=0 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=6 w=7, f=15 e=0 d=0 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=7 w=8, f=15 e=1 d=0 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=8 w=9, f=17 e=1 d=0 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=9 w=11, f=21 e=25 d=0 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=10 w=14, f=22 e=5 d=0 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 2 timers >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1385367967007 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollCalculateTimeout:353 : Schedule timeout then=1385367967007 now=1385367962007 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollCalculateTimeout:361 : Timeout at 1385367967007 due in 5000 ms >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=10 timeout=5000 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollRunOnce:638 : Poll got 1 event(s) >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollDispatchTimeouts:423 : Dispatch 2 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollDispatchHandles:468 : Dispatch 10 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollDispatchHandles:482 : i=0 w=1 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollDispatchHandles:482 : i=1 w=2 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollDispatchHandles:482 : i=2 w=3 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollDispatchHandles:482 : i=3 w=4 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollDispatchHandles:482 : i=4 w=5 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollDispatchHandles:482 : i=5 w=6 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollDispatchHandles:482 : i=7 w=8 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollDispatchHandles:482 : i=8 w=9 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollDispatchHandles:482 : i=9 w=11 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollDispatchHandles:482 : i=10 w=14 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=14 events=2 >2013-11-25 08:26:02.007+0000: 3913: debug : virNetMessageFree:72 : msg=0x7fefbfeb6660 nfds=0 cb=(nil) >2013-11-25 08:26:02.007+0000: 3913: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7fefbfeb4130 tx=(nil) >2013-11-25 08:26:02.007+0000: 3913: debug : virNetServerClientCalculateHandleMode:188 : mode=1 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=14 events=1 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140667668162688 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollCleanupTimeouts:514 : Cleanup 2 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollCleanupHandles:562 : Cleanup 11 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventRunDefaultImpl:270 : running default event implementation >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollCleanupTimeouts:514 : Cleanup 2 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollCleanupHandles:562 : Cleanup 11 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=6 e=1 d=0 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=8 e=1 d=0 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=2 w=3, f=11 e=1 d=0 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=3 w=4, f=12 e=1 d=0 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=4 w=5, f=13 e=1 d=0 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=5 w=6, f=14 e=1 d=0 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=6 w=7, f=15 e=0 d=0 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=7 w=8, f=15 e=1 d=0 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=8 w=9, f=17 e=1 d=0 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=9 w=11, f=21 e=25 d=0 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=10 w=14, f=22 e=1 d=0 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 2 timers >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1385367967007 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollCalculateTimeout:353 : Schedule timeout then=1385367967007 now=1385367962007 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollCalculateTimeout:361 : Timeout at 1385367967007 due in 5000 ms >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=10 timeout=5000 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollRunOnce:638 : Poll got 1 event(s) >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollDispatchTimeouts:423 : Dispatch 2 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollDispatchHandles:468 : Dispatch 10 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollDispatchHandles:482 : i=0 w=1 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollDispatchHandles:482 : i=1 w=2 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollDispatchHandles:482 : i=2 w=3 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollDispatchHandles:482 : i=3 w=4 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollDispatchHandles:482 : i=4 w=5 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollDispatchHandles:482 : i=5 w=6 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollDispatchHandles:482 : i=7 w=8 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollDispatchHandles:482 : i=8 w=9 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollDispatchHandles:482 : i=9 w=11 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollDispatchHandles:482 : i=10 w=14 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=14 events=1 >2013-11-25 08:26:02.007+0000: 3913: debug : virNetMessageDecodeLength:149 : Got length, now need 40 total (36 more) >2013-11-25 08:26:02.007+0000: 3913: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7fefbfeb4130 tx=(nil) >2013-11-25 08:26:02.007+0000: 3913: debug : virNetServerClientCalculateHandleMode:188 : mode=1 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=14 events=1 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140667668162688 >2013-11-25 08:26:02.007+0000: 3913: debug : virNetServerClientDispatchRead:1202 : RPC_SERVER_CLIENT_MSG_RX: client=0x7fefbfeb5710 len=40 prog=536903814 vers=1 proc=1 type=0 status=0 serial=2 >2013-11-25 08:26:02.007+0000: 3913: debug : virKeepAliveCheckMessage:374 : ka=0x7fefbfeb45a0, client=0x7fefbfeb5710, msg=0x7fefbfeb4130 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollUpdateTimeout:260 : EVENT_POLL_UPDATE_TIMEOUT: timer=6 frequency=5000 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollUpdateTimeout:278 : Set timer freq=5000 expires=1385367967007 >2013-11-25 08:26:02.007+0000: 3913: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140667668162688 >2013-11-25 08:26:02.007+0000: 3913: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fefbfeb5710 >2013-11-25 08:26:02.007+0000: 3913: debug : virNetServerDispatchNewMessage:213 : server=0x7fefbfea6430 client=0x7fefbfeb5710 message=0x7fefbfeb4130 >2013-11-25 08:26:02.007+0000: 3913: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fefbfeafc60 >2013-11-25 08:26:02.007+0000: 3913: debug : virNetMessageNew:44 : msg=0x7fefbfeb52f0 tracked=1 >2013-11-25 08:26:02.007+0000: 3914: debug : virNetServerHandleJob:184 : server=0x7fefbfea6430 client=0x7fefbfeb5710 message=0x7fefbfeb4130 prog=0x7fefbfeafc60 >2013-11-25 08:26:02.007+0000: 3913: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7fefbfeb52f0 tx=(nil) >2013-11-25 08:26:02.007+0000: 3914: debug : virNetServerProgramDispatch:285 : prog=536903814 ver=1 type=0 status=0 serial=2 proc=1 >2013-11-25 08:26:02.007+0000: 3913: debug : virNetServerClientCalculateHandleMode:188 : mode=1 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=14 events=1 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140667668162688 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollCleanupTimeouts:514 : Cleanup 2 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollCleanupHandles:562 : Cleanup 11 >2013-11-25 08:26:02.008+0000: 3914: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fef94000940 >2013-11-25 08:26:02.008+0000: 3914: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fef94000940 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventRunDefaultImpl:270 : running default event implementation >2013-11-25 08:26:02.008+0000: 3914: debug : remoteDispatchConnectOpenHelper:2178 : server=0x7fefbfea6430 client=0x7fefbfeb5710 msg=0x7fefbfeb4130 rerr=0x7fefaf5a9c90 args=0x7fef98001890 ret=0x7fef98001820 >2013-11-25 08:26:02.008+0000: 3914: debug : remoteDispatchConnectOpen:737 : priv=0x7fefbfeb4210 conn=(nil) >2013-11-25 08:26:02.008+0000: 3914: debug : virConnectOpen:1405 : name= >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollCleanupTimeouts:514 : Cleanup 2 >2013-11-25 08:26:02.008+0000: 3914: debug : virObjectNew:199 : OBJECT_NEW: obj=0x7fef98001b30 classname=virConnect >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollCleanupHandles:562 : Cleanup 11 >2013-11-25 08:26:02.008+0000: 3914: debug : virObjectNew:199 : OBJECT_NEW: obj=0x7fef98001580 classname=virConnectCloseCallbackData >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=6 e=1 d=0 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=8 e=1 d=0 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=2 w=3, f=11 e=1 d=0 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=3 w=4, f=12 e=1 d=0 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=4 w=5, f=13 e=1 d=0 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=5 w=6, f=14 e=1 d=0 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=6 w=7, f=15 e=0 d=0 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=7 w=8, f=15 e=1 d=0 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=8 w=9, f=17 e=1 d=0 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=9 w=11, f=21 e=25 d=0 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=10 w=14, f=22 e=1 d=0 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 2 timers >2013-11-25 08:26:02.008+0000: 3914: debug : virConnectGetConfigFile:1014 : Loading config file '/etc/libvirt/libvirt.conf' >2013-11-25 08:26:02.008+0000: 3914: debug : virConfReadFile:745 : filename=/etc/libvirt/libvirt.conf >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1385367967007 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollCalculateTimeout:353 : Schedule timeout then=1385367967007 now=1385367962008 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollCalculateTimeout:361 : Timeout at 1385367967007 due in 4999 ms >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=10 timeout=4999 >2013-11-25 08:26:02.008+0000: 3914: debug : virFileClose:90 : Closed fd 23 >2013-11-25 08:26:02.008+0000: 3914: debug : do_open:1195 : no name, allowing driver auto-select >2013-11-25 08:26:02.008+0000: 3914: debug : do_open:1237 : trying driver 0 (Test) ... >2013-11-25 08:26:02.008+0000: 3914: debug : do_open:1244 : driver 0 Test returned DECLINED >2013-11-25 08:26:02.008+0000: 3914: debug : do_open:1237 : trying driver 1 (ESX) ... >2013-11-25 08:26:02.008+0000: 3914: debug : do_open:1244 : driver 1 ESX returned DECLINED >2013-11-25 08:26:02.008+0000: 3914: debug : do_open:1237 : trying driver 2 (remote) ... >2013-11-25 08:26:02.008+0000: 3914: debug : do_open:1244 : driver 2 remote returned DECLINED >2013-11-25 08:26:02.008+0000: 3914: debug : do_open:1237 : trying driver 3 (QEMU) ... >2013-11-25 08:26:02.008+0000: 3914: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fefa0146010 >2013-11-25 08:26:02.008+0000: 3914: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fefbfeb1aa0 >2013-11-25 08:26:02.008+0000: 3914: debug : virAccessManagerCheckConnect:215 : manager=0x7fefbfeb1aa0(name=stack) driver=QEMU perm=0 >2013-11-25 08:26:02.008+0000: 3914: debug : virAccessManagerCheckConnect:215 : manager=0x7fefbfea60a0(name=none) driver=QEMU perm=0 >2013-11-25 08:26:02.008+0000: 3914: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fefbfeb1aa0 >2013-11-25 08:26:02.008+0000: 3914: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fefa0146010 >2013-11-25 08:26:02.008+0000: 3914: debug : do_open:1244 : driver 3 QEMU returned SUCCESS >2013-11-25 08:26:02.008+0000: 3914: debug : do_open:1270 : network driver 0 Test returned DECLINED >2013-11-25 08:26:02.008+0000: 3914: debug : do_open:1270 : network driver 1 ESX returned DECLINED >2013-11-25 08:26:02.008+0000: 3914: debug : do_open:1270 : network driver 2 remote returned DECLINED >2013-11-25 08:26:02.008+0000: 3914: debug : do_open:1270 : network driver 3 Network returned SUCCESS >2013-11-25 08:26:02.008+0000: 3914: debug : do_open:1286 : interface driver 0 Test returned DECLINED >2013-11-25 08:26:02.008+0000: 3914: debug : do_open:1286 : interface driver 1 ESX returned DECLINED >2013-11-25 08:26:02.008+0000: 3914: debug : do_open:1286 : interface driver 2 remote returned DECLINED >2013-11-25 08:26:02.008+0000: 3914: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fefa000f370 >2013-11-25 08:26:02.008+0000: 3914: debug : do_open:1286 : interface driver 3 netcf returned SUCCESS >2013-11-25 08:26:02.008+0000: 3914: debug : do_open:1303 : storage driver 0 Test returned DECLINED >2013-11-25 08:26:02.008+0000: 3914: debug : do_open:1303 : storage driver 1 ESX returned DECLINED >2013-11-25 08:26:02.008+0000: 3914: debug : do_open:1303 : storage driver 2 remote returned DECLINED >2013-11-25 08:26:02.008+0000: 3914: debug : do_open:1303 : storage driver 3 storage returned SUCCESS >2013-11-25 08:26:02.008+0000: 3914: debug : do_open:1320 : node driver 0 Test returned DECLINED >2013-11-25 08:26:02.008+0000: 3914: debug : do_open:1320 : node driver 1 ESX returned DECLINED >2013-11-25 08:26:02.008+0000: 3914: debug : do_open:1320 : node driver 2 remote returned DECLINED >2013-11-25 08:26:02.008+0000: 3914: debug : do_open:1320 : node driver 3 udevNodeDeviceDriver returned SUCCESS >2013-11-25 08:26:02.008+0000: 3914: debug : do_open:1337 : secret driver 0 Test returned DECLINED >2013-11-25 08:26:02.008+0000: 3914: debug : do_open:1337 : secret driver 1 ESX returned DECLINED >2013-11-25 08:26:02.008+0000: 3914: debug : do_open:1337 : secret driver 2 remote returned DECLINED >2013-11-25 08:26:02.008+0000: 3914: debug : do_open:1337 : secret driver 3 secret returned SUCCESS >2013-11-25 08:26:02.008+0000: 3914: debug : do_open:1354 : nwfilter driver 0 Test returned DECLINED >2013-11-25 08:26:02.008+0000: 3914: debug : do_open:1354 : nwfilter driver 1 ESX returned DECLINED >2013-11-25 08:26:02.008+0000: 3914: debug : do_open:1354 : nwfilter driver 2 remote returned DECLINED >2013-11-25 08:26:02.008+0000: 3914: debug : do_open:1354 : nwfilter driver 3 nwfilter returned SUCCESS >2013-11-25 08:26:02.008+0000: 3914: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fef94000940 >2013-11-25 08:26:02.008+0000: 3914: debug : virNetMessageEncodePayload:374 : Encode length as 28 >2013-11-25 08:26:02.008+0000: 3914: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fef94000940 >2013-11-25 08:26:02.008+0000: 3914: debug : virNetServerClientSendMessageLocked:1451 : msg=0x7fefbfeb4130 proc=1 len=28 offset=0 >2013-11-25 08:26:02.008+0000: 3914: debug : virNetServerClientSendMessageLocked:1459 : RPC_SERVER_CLIENT_MSG_TX_QUEUE: client=0x7fefbfeb5710 len=28 prog=536903814 vers=1 proc=1 type=1 status=0 serial=2 >2013-11-25 08:26:02.008+0000: 3914: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7fefbfeb52f0 tx=0x7fefbfeb4130 >2013-11-25 08:26:02.008+0000: 3914: debug : virNetServerClientCalculateHandleMode:188 : mode=3 >2013-11-25 08:26:02.008+0000: 3914: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=14 events=3 >2013-11-25 08:26:02.008+0000: 3914: debug : virEventPollInterruptLocked:714 : Interrupting >2013-11-25 08:26:02.008+0000: 3914: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fefbfeafc60 >2013-11-25 08:26:02.008+0000: 3914: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fefbfeb5710 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollRunOnce:638 : Poll got 1 event(s) >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollDispatchTimeouts:423 : Dispatch 2 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollDispatchHandles:468 : Dispatch 10 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollDispatchHandles:482 : i=0 w=1 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollDispatchHandles:482 : i=1 w=2 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollDispatchHandles:482 : i=2 w=3 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollDispatchHandles:482 : i=3 w=4 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollDispatchHandles:482 : i=4 w=5 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollDispatchHandles:482 : i=5 w=6 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollDispatchHandles:482 : i=7 w=8 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollDispatchHandles:482 : i=8 w=9 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollDispatchHandles:482 : i=9 w=11 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollDispatchHandles:482 : i=10 w=14 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollCleanupTimeouts:514 : Cleanup 2 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollCleanupHandles:562 : Cleanup 11 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventRunDefaultImpl:270 : running default event implementation >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollCleanupTimeouts:514 : Cleanup 2 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollCleanupHandles:562 : Cleanup 11 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=6 e=1 d=0 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=8 e=1 d=0 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=2 w=3, f=11 e=1 d=0 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=3 w=4, f=12 e=1 d=0 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=4 w=5, f=13 e=1 d=0 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=5 w=6, f=14 e=1 d=0 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=6 w=7, f=15 e=0 d=0 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=7 w=8, f=15 e=1 d=0 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=8 w=9, f=17 e=1 d=0 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=9 w=11, f=21 e=25 d=0 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=10 w=14, f=22 e=5 d=0 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 2 timers >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1385367967007 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollCalculateTimeout:353 : Schedule timeout then=1385367967007 now=1385367962008 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollCalculateTimeout:361 : Timeout at 1385367967007 due in 4999 ms >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=10 timeout=4999 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollRunOnce:638 : Poll got 1 event(s) >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollDispatchTimeouts:423 : Dispatch 2 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollDispatchHandles:468 : Dispatch 10 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollDispatchHandles:482 : i=0 w=1 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollDispatchHandles:482 : i=1 w=2 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollDispatchHandles:482 : i=2 w=3 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollDispatchHandles:482 : i=3 w=4 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollDispatchHandles:482 : i=4 w=5 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollDispatchHandles:482 : i=5 w=6 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollDispatchHandles:482 : i=7 w=8 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollDispatchHandles:482 : i=8 w=9 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollDispatchHandles:482 : i=9 w=11 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollDispatchHandles:482 : i=10 w=14 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=14 events=2 >2013-11-25 08:26:02.008+0000: 3913: debug : virNetMessageFree:72 : msg=0x7fefbfeb4130 nfds=0 cb=(nil) >2013-11-25 08:26:02.008+0000: 3913: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7fefbfeb52f0 tx=(nil) >2013-11-25 08:26:02.008+0000: 3913: debug : virNetServerClientCalculateHandleMode:188 : mode=1 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=14 events=1 >2013-11-25 08:26:02.008+0000: 3913: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140667668162688 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollCleanupTimeouts:514 : Cleanup 2 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollCleanupHandles:562 : Cleanup 11 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventRunDefaultImpl:270 : running default event implementation >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollCleanupTimeouts:514 : Cleanup 2 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollCleanupHandles:562 : Cleanup 11 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=6 e=1 d=0 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=8 e=1 d=0 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=2 w=3, f=11 e=1 d=0 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=3 w=4, f=12 e=1 d=0 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=4 w=5, f=13 e=1 d=0 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=5 w=6, f=14 e=1 d=0 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=6 w=7, f=15 e=0 d=0 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=7 w=8, f=15 e=1 d=0 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=8 w=9, f=17 e=1 d=0 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=9 w=11, f=21 e=25 d=0 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=10 w=14, f=22 e=1 d=0 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 2 timers >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1385367967007 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollCalculateTimeout:353 : Schedule timeout then=1385367967007 now=1385367962009 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollCalculateTimeout:361 : Timeout at 1385367967007 due in 4998 ms >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=10 timeout=4998 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollRunOnce:638 : Poll got 1 event(s) >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollDispatchTimeouts:423 : Dispatch 2 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollDispatchHandles:468 : Dispatch 10 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollDispatchHandles:482 : i=0 w=1 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollDispatchHandles:482 : i=1 w=2 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollDispatchHandles:482 : i=2 w=3 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollDispatchHandles:482 : i=3 w=4 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollDispatchHandles:482 : i=4 w=5 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollDispatchHandles:482 : i=5 w=6 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollDispatchHandles:482 : i=7 w=8 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollDispatchHandles:482 : i=8 w=9 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollDispatchHandles:482 : i=9 w=11 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollDispatchHandles:482 : i=10 w=14 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=14 events=1 >2013-11-25 08:26:02.009+0000: 3913: debug : virNetMessageDecodeLength:149 : Got length, now need 28 total (24 more) >2013-11-25 08:26:02.009+0000: 3913: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7fefbfeb52f0 tx=(nil) >2013-11-25 08:26:02.009+0000: 3913: debug : virNetServerClientCalculateHandleMode:188 : mode=1 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=14 events=1 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140667668162688 >2013-11-25 08:26:02.009+0000: 3913: debug : virNetServerClientDispatchRead:1202 : RPC_SERVER_CLIENT_MSG_RX: client=0x7fefbfeb5710 len=28 prog=536903814 vers=1 proc=110 type=0 status=0 serial=3 >2013-11-25 08:26:02.009+0000: 3913: debug : virKeepAliveCheckMessage:374 : ka=0x7fefbfeb45a0, client=0x7fefbfeb5710, msg=0x7fefbfeb52f0 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollUpdateTimeout:260 : EVENT_POLL_UPDATE_TIMEOUT: timer=6 frequency=5000 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollUpdateTimeout:278 : Set timer freq=5000 expires=1385367967009 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140667668162688 >2013-11-25 08:26:02.009+0000: 3913: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fefbfeb5710 >2013-11-25 08:26:02.009+0000: 3913: debug : virNetServerDispatchNewMessage:213 : server=0x7fefbfea6430 client=0x7fefbfeb5710 message=0x7fefbfeb52f0 >2013-11-25 08:26:02.009+0000: 3913: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fefbfeafc60 >2013-11-25 08:26:02.009+0000: 3913: debug : virNetMessageNew:44 : msg=0x7fefbfeb43f0 tracked=1 >2013-11-25 08:26:02.009+0000: 3913: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7fefbfeb43f0 tx=(nil) >2013-11-25 08:26:02.009+0000: 3913: debug : virNetServerClientCalculateHandleMode:188 : mode=1 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=14 events=1 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140667668162688 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollCleanupTimeouts:514 : Cleanup 2 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollCleanupHandles:562 : Cleanup 11 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventRunDefaultImpl:270 : running default event implementation >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollCleanupTimeouts:514 : Cleanup 2 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollCleanupHandles:562 : Cleanup 11 >2013-11-25 08:26:02.009+0000: 3919: debug : virNetServerHandleJob:184 : server=0x7fefbfea6430 client=0x7fefbfeb5710 message=0x7fefbfeb52f0 prog=0x7fefbfeafc60 >2013-11-25 08:26:02.009+0000: 3919: debug : virNetServerProgramDispatch:285 : prog=536903814 ver=1 type=0 status=0 serial=3 proc=110 >2013-11-25 08:26:02.009+0000: 3919: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fef94000940 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=6 e=1 d=0 >2013-11-25 08:26:02.009+0000: 3919: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fef94000940 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=8 e=1 d=0 >2013-11-25 08:26:02.009+0000: 3919: debug : remoteDispatchConnectGetURIHelper:780 : server=0x7fefbfea6430 client=0x7fefbfeb5710 msg=0x7fefbfeb52f0 rerr=0x7fefacda4c90 args=0x7fefa041be20 ret=0x7fefa041bdb0 >2013-11-25 08:26:02.009+0000: 3919: debug : virConnectGetURI:1774 : conn=0x7fef98001b30 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=2 w=3, f=11 e=1 d=0 >2013-11-25 08:26:02.009+0000: 3919: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fef94000940 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=3 w=4, f=12 e=1 d=0 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=4 w=5, f=13 e=1 d=0 >2013-11-25 08:26:02.009+0000: 3919: debug : virNetMessageEncodePayload:374 : Encode length as 48 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=5 w=6, f=14 e=1 d=0 >2013-11-25 08:26:02.009+0000: 3919: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fef94000940 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=6 w=7, f=15 e=0 d=0 >2013-11-25 08:26:02.009+0000: 3919: debug : virNetServerClientSendMessageLocked:1451 : msg=0x7fefbfeb52f0 proc=110 len=48 offset=0 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=7 w=8, f=15 e=1 d=0 >2013-11-25 08:26:02.009+0000: 3919: debug : virNetServerClientSendMessageLocked:1459 : RPC_SERVER_CLIENT_MSG_TX_QUEUE: client=0x7fefbfeb5710 len=48 prog=536903814 vers=1 proc=110 type=1 status=0 serial=3 >2013-11-25 08:26:02.009+0000: 3919: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7fefbfeb43f0 tx=0x7fefbfeb52f0 >2013-11-25 08:26:02.009+0000: 3919: debug : virNetServerClientCalculateHandleMode:188 : mode=3 >2013-11-25 08:26:02.009+0000: 3919: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=14 events=3 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=8 w=9, f=17 e=1 d=0 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=9 w=11, f=21 e=25 d=0 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=10 w=14, f=22 e=1 d=0 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 2 timers >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1385367967009 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollCalculateTimeout:353 : Schedule timeout then=1385367967009 now=1385367962009 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollCalculateTimeout:361 : Timeout at 1385367967009 due in 5000 ms >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=10 timeout=5000 >2013-11-25 08:26:02.009+0000: 3919: debug : virEventPollInterruptLocked:714 : Interrupting >2013-11-25 08:26:02.009+0000: 3919: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fefbfeafc60 >2013-11-25 08:26:02.009+0000: 3919: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fefbfeb5710 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollRunOnce:638 : Poll got 1 event(s) >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollDispatchTimeouts:423 : Dispatch 2 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollDispatchHandles:468 : Dispatch 10 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollDispatchHandles:482 : i=0 w=1 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollDispatchHandles:482 : i=1 w=2 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollDispatchHandles:482 : i=2 w=3 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollDispatchHandles:482 : i=3 w=4 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollDispatchHandles:482 : i=4 w=5 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollDispatchHandles:482 : i=5 w=6 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollDispatchHandles:482 : i=7 w=8 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollDispatchHandles:482 : i=8 w=9 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollDispatchHandles:482 : i=9 w=11 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollDispatchHandles:482 : i=10 w=14 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollCleanupTimeouts:514 : Cleanup 2 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollCleanupHandles:562 : Cleanup 11 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventRunDefaultImpl:270 : running default event implementation >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollCleanupTimeouts:514 : Cleanup 2 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollCleanupHandles:562 : Cleanup 11 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=6 e=1 d=0 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=8 e=1 d=0 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=2 w=3, f=11 e=1 d=0 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=3 w=4, f=12 e=1 d=0 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=4 w=5, f=13 e=1 d=0 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=5 w=6, f=14 e=1 d=0 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=6 w=7, f=15 e=0 d=0 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=7 w=8, f=15 e=1 d=0 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=8 w=9, f=17 e=1 d=0 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=9 w=11, f=21 e=25 d=0 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=10 w=14, f=22 e=5 d=0 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 2 timers >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1385367967009 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollCalculateTimeout:353 : Schedule timeout then=1385367967009 now=1385367962009 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollCalculateTimeout:361 : Timeout at 1385367967009 due in 5000 ms >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=10 timeout=5000 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollRunOnce:638 : Poll got 1 event(s) >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollDispatchTimeouts:423 : Dispatch 2 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollDispatchHandles:468 : Dispatch 10 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollDispatchHandles:482 : i=0 w=1 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollDispatchHandles:482 : i=1 w=2 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollDispatchHandles:482 : i=2 w=3 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollDispatchHandles:482 : i=3 w=4 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollDispatchHandles:482 : i=4 w=5 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollDispatchHandles:482 : i=5 w=6 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollDispatchHandles:482 : i=7 w=8 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollDispatchHandles:482 : i=8 w=9 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollDispatchHandles:482 : i=9 w=11 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollDispatchHandles:482 : i=10 w=14 >2013-11-25 08:26:02.009+0000: 3913: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=14 events=2 >2013-11-25 08:26:02.010+0000: 3913: debug : virNetMessageFree:72 : msg=0x7fefbfeb52f0 nfds=0 cb=(nil) >2013-11-25 08:26:02.010+0000: 3913: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7fefbfeb43f0 tx=(nil) >2013-11-25 08:26:02.010+0000: 3913: debug : virNetServerClientCalculateHandleMode:188 : mode=1 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=14 events=1 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140667668162688 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollCleanupTimeouts:514 : Cleanup 2 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollCleanupHandles:562 : Cleanup 11 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventRunDefaultImpl:270 : running default event implementation >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollCleanupTimeouts:514 : Cleanup 2 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollCleanupHandles:562 : Cleanup 11 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=6 e=1 d=0 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=8 e=1 d=0 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=2 w=3, f=11 e=1 d=0 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=3 w=4, f=12 e=1 d=0 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=4 w=5, f=13 e=1 d=0 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=5 w=6, f=14 e=1 d=0 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=6 w=7, f=15 e=0 d=0 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=7 w=8, f=15 e=1 d=0 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=8 w=9, f=17 e=1 d=0 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=9 w=11, f=21 e=25 d=0 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=10 w=14, f=22 e=1 d=0 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 2 timers >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1385367967009 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollCalculateTimeout:353 : Schedule timeout then=1385367967009 now=1385367962010 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollCalculateTimeout:361 : Timeout at 1385367967009 due in 4999 ms >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=10 timeout=4999 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollRunOnce:638 : Poll got 1 event(s) >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollDispatchTimeouts:423 : Dispatch 2 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollDispatchHandles:468 : Dispatch 10 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollDispatchHandles:482 : i=0 w=1 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollDispatchHandles:482 : i=1 w=2 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollDispatchHandles:482 : i=2 w=3 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollDispatchHandles:482 : i=3 w=4 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollDispatchHandles:482 : i=4 w=5 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollDispatchHandles:482 : i=5 w=6 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollDispatchHandles:482 : i=7 w=8 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollDispatchHandles:482 : i=8 w=9 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollDispatchHandles:482 : i=9 w=11 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollDispatchHandles:482 : i=10 w=14 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=14 events=1 >2013-11-25 08:26:02.010+0000: 3913: debug : virNetMessageDecodeLength:149 : Got length, now need 36 total (32 more) >2013-11-25 08:26:02.010+0000: 3913: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7fefbfeb43f0 tx=(nil) >2013-11-25 08:26:02.010+0000: 3913: debug : virNetServerClientCalculateHandleMode:188 : mode=1 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=14 events=1 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140667668162688 >2013-11-25 08:26:02.010+0000: 3913: debug : virNetServerClientDispatchRead:1202 : RPC_SERVER_CLIENT_MSG_RX: client=0x7fefbfeb5710 len=36 prog=536903814 vers=1 proc=23 type=0 status=0 serial=4 >2013-11-25 08:26:02.010+0000: 3913: debug : virKeepAliveCheckMessage:374 : ka=0x7fefbfeb45a0, client=0x7fefbfeb5710, msg=0x7fefbfeb43f0 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollUpdateTimeout:260 : EVENT_POLL_UPDATE_TIMEOUT: timer=6 frequency=5000 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollUpdateTimeout:278 : Set timer freq=5000 expires=1385367967010 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140667668162688 >2013-11-25 08:26:02.010+0000: 3913: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fefbfeb5710 >2013-11-25 08:26:02.010+0000: 3913: debug : virNetServerDispatchNewMessage:213 : server=0x7fefbfea6430 client=0x7fefbfeb5710 message=0x7fefbfeb43f0 >2013-11-25 08:26:02.010+0000: 3913: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fefbfeafc60 >2013-11-25 08:26:02.010+0000: 3913: debug : virNetMessageNew:44 : msg=0x7fefbfeb4100 tracked=1 >2013-11-25 08:26:02.010+0000: 3913: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7fefbfeb4100 tx=(nil) >2013-11-25 08:26:02.010+0000: 3913: debug : virNetServerClientCalculateHandleMode:188 : mode=1 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=14 events=1 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140667668162688 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollCleanupTimeouts:514 : Cleanup 2 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollCleanupHandles:562 : Cleanup 11 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventRunDefaultImpl:270 : running default event implementation >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollCleanupTimeouts:514 : Cleanup 2 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollCleanupHandles:562 : Cleanup 11 >2013-11-25 08:26:02.010+0000: 3916: debug : virNetServerHandleJob:184 : server=0x7fefbfea6430 client=0x7fefbfeb5710 message=0x7fefbfeb43f0 prog=0x7fefbfeafc60 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=6 e=1 d=0 >2013-11-25 08:26:02.010+0000: 3916: debug : virNetServerProgramDispatch:285 : prog=536903814 ver=1 type=0 status=0 serial=4 proc=23 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=8 e=1 d=0 >2013-11-25 08:26:02.010+0000: 3916: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fef94000940 >2013-11-25 08:26:02.010+0000: 3916: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fef94000940 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=2 w=3, f=11 e=1 d=0 >2013-11-25 08:26:02.010+0000: 3916: debug : remoteDispatchDomainLookupByNameHelper:4943 : server=0x7fefbfea6430 client=0x7fefbfeb5710 msg=0x7fefbfeb43f0 rerr=0x7fefae5a7c90 args=0x7fef78000900 ret=0x7fef780009a0 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=3 w=4, f=12 e=1 d=0 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=4 w=5, f=13 e=1 d=0 >2013-11-25 08:26:02.010+0000: 3916: debug : virDomainLookupByName:2264 : conn=0x7fef98001b30, name=r6.4 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=5 w=6, f=14 e=1 d=0 >2013-11-25 08:26:02.010+0000: 3916: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fefbfeb1aa0 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=6 w=7, f=15 e=0 d=0 >2013-11-25 08:26:02.010+0000: 3916: debug : virAccessManagerCheckDomain:231 : manager=0x7fefbfeb1aa0(name=stack) driver=QEMU domain=0x7fefa02ef920 perm=0 >2013-11-25 08:26:02.010+0000: 3916: debug : virAccessManagerCheckDomain:231 : manager=0x7fefbfea60a0(name=none) driver=QEMU domain=0x7fefa02ef920 perm=0 >2013-11-25 08:26:02.010+0000: 3916: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fefbfeb1aa0 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=7 w=8, f=15 e=1 d=0 >2013-11-25 08:26:02.010+0000: 3916: debug : virObjectNew:199 : OBJECT_NEW: obj=0x7fef780008c0 classname=virDomain >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=8 w=9, f=17 e=1 d=0 >2013-11-25 08:26:02.010+0000: 3916: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fef98001b30 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=9 w=11, f=21 e=25 d=0 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=10 w=14, f=22 e=1 d=0 >2013-11-25 08:26:02.010+0000: 3916: debug : virDomainFree:2428 : dom=0x7fef780008c0, (VM: name=r6.4, uuid=a3559509-df36-4001-a4a2-f7f79ac049d2) >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 2 timers >2013-11-25 08:26:02.010+0000: 3916: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fef780008c0 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1385367967010 >2013-11-25 08:26:02.010+0000: 3916: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7fef780008c0 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollCalculateTimeout:353 : Schedule timeout then=1385367967010 now=1385367962010 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollCalculateTimeout:361 : Timeout at 1385367967010 due in 5000 ms >2013-11-25 08:26:02.010+0000: 3916: debug : virDomainDispose:262 : release domain 0x7fef780008c0 r6.4 a3559509-df36-4001-a4a2-f7f79ac049d2 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=10 timeout=5000 >2013-11-25 08:26:02.010+0000: 3916: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fef98001b30 >2013-11-25 08:26:02.010+0000: 3916: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fef94000940 >2013-11-25 08:26:02.010+0000: 3916: debug : virNetMessageEncodePayload:374 : Encode length as 56 >2013-11-25 08:26:02.010+0000: 3916: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fef94000940 >2013-11-25 08:26:02.010+0000: 3916: debug : virNetServerClientSendMessageLocked:1451 : msg=0x7fefbfeb43f0 proc=23 len=56 offset=0 >2013-11-25 08:26:02.010+0000: 3916: debug : virNetServerClientSendMessageLocked:1459 : RPC_SERVER_CLIENT_MSG_TX_QUEUE: client=0x7fefbfeb5710 len=56 prog=536903814 vers=1 proc=23 type=1 status=0 serial=4 >2013-11-25 08:26:02.010+0000: 3916: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7fefbfeb4100 tx=0x7fefbfeb43f0 >2013-11-25 08:26:02.010+0000: 3916: debug : virNetServerClientCalculateHandleMode:188 : mode=3 >2013-11-25 08:26:02.010+0000: 3916: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=14 events=3 >2013-11-25 08:26:02.010+0000: 3916: debug : virEventPollInterruptLocked:714 : Interrupting >2013-11-25 08:26:02.010+0000: 3916: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fefbfeafc60 >2013-11-25 08:26:02.010+0000: 3916: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fefbfeb5710 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollRunOnce:638 : Poll got 1 event(s) >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollDispatchTimeouts:423 : Dispatch 2 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollDispatchHandles:468 : Dispatch 10 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollDispatchHandles:482 : i=0 w=1 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollDispatchHandles:482 : i=1 w=2 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollDispatchHandles:482 : i=2 w=3 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollDispatchHandles:482 : i=3 w=4 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollDispatchHandles:482 : i=4 w=5 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollDispatchHandles:482 : i=5 w=6 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollDispatchHandles:482 : i=7 w=8 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollDispatchHandles:482 : i=8 w=9 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollDispatchHandles:482 : i=9 w=11 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollDispatchHandles:482 : i=10 w=14 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollCleanupTimeouts:514 : Cleanup 2 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollCleanupHandles:562 : Cleanup 11 >2013-11-25 08:26:02.010+0000: 3913: debug : virEventRunDefaultImpl:270 : running default event implementation >2013-11-25 08:26:02.010+0000: 3913: debug : virEventPollCleanupTimeouts:514 : Cleanup 2 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollCleanupHandles:562 : Cleanup 11 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=6 e=1 d=0 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=8 e=1 d=0 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=2 w=3, f=11 e=1 d=0 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=3 w=4, f=12 e=1 d=0 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=4 w=5, f=13 e=1 d=0 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=5 w=6, f=14 e=1 d=0 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=6 w=7, f=15 e=0 d=0 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=7 w=8, f=15 e=1 d=0 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=8 w=9, f=17 e=1 d=0 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=9 w=11, f=21 e=25 d=0 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=10 w=14, f=22 e=5 d=0 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 2 timers >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1385367967010 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollCalculateTimeout:353 : Schedule timeout then=1385367967010 now=1385367962011 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollCalculateTimeout:361 : Timeout at 1385367967010 due in 4999 ms >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=10 timeout=4999 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollRunOnce:638 : Poll got 1 event(s) >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollDispatchTimeouts:423 : Dispatch 2 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollDispatchHandles:468 : Dispatch 10 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollDispatchHandles:482 : i=0 w=1 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollDispatchHandles:482 : i=1 w=2 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollDispatchHandles:482 : i=2 w=3 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollDispatchHandles:482 : i=3 w=4 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollDispatchHandles:482 : i=4 w=5 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollDispatchHandles:482 : i=5 w=6 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollDispatchHandles:482 : i=7 w=8 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollDispatchHandles:482 : i=8 w=9 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollDispatchHandles:482 : i=9 w=11 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollDispatchHandles:482 : i=10 w=14 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=14 events=2 >2013-11-25 08:26:02.011+0000: 3913: debug : virNetMessageFree:72 : msg=0x7fefbfeb43f0 nfds=0 cb=(nil) >2013-11-25 08:26:02.011+0000: 3913: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7fefbfeb4100 tx=(nil) >2013-11-25 08:26:02.011+0000: 3913: debug : virNetServerClientCalculateHandleMode:188 : mode=1 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=14 events=1 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140667668162688 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollCleanupTimeouts:514 : Cleanup 2 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollCleanupHandles:562 : Cleanup 11 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventRunDefaultImpl:270 : running default event implementation >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollCleanupTimeouts:514 : Cleanup 2 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollCleanupHandles:562 : Cleanup 11 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=6 e=1 d=0 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=8 e=1 d=0 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=2 w=3, f=11 e=1 d=0 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=3 w=4, f=12 e=1 d=0 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=4 w=5, f=13 e=1 d=0 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=5 w=6, f=14 e=1 d=0 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=6 w=7, f=15 e=0 d=0 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=7 w=8, f=15 e=1 d=0 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=8 w=9, f=17 e=1 d=0 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=9 w=11, f=21 e=25 d=0 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=10 w=14, f=22 e=1 d=0 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 2 timers >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1385367967010 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollCalculateTimeout:353 : Schedule timeout then=1385367967010 now=1385367962011 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollCalculateTimeout:361 : Timeout at 1385367967010 due in 4999 ms >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=10 timeout=4999 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollRunOnce:638 : Poll got 1 event(s) >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollDispatchTimeouts:423 : Dispatch 2 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollDispatchHandles:468 : Dispatch 10 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollDispatchHandles:482 : i=0 w=1 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollDispatchHandles:482 : i=1 w=2 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollDispatchHandles:482 : i=2 w=3 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollDispatchHandles:482 : i=3 w=4 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollDispatchHandles:482 : i=4 w=5 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollDispatchHandles:482 : i=5 w=6 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollDispatchHandles:482 : i=7 w=8 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollDispatchHandles:482 : i=8 w=9 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollDispatchHandles:482 : i=9 w=11 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollDispatchHandles:482 : i=10 w=14 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=14 events=1 >2013-11-25 08:26:02.011+0000: 3913: debug : virNetMessageDecodeLength:149 : Got length, now need 220 total (216 more) >2013-11-25 08:26:02.011+0000: 3913: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7fefbfeb4100 tx=(nil) >2013-11-25 08:26:02.011+0000: 3913: debug : virNetServerClientCalculateHandleMode:188 : mode=1 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=14 events=1 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140667668162688 >2013-11-25 08:26:02.011+0000: 3913: debug : virNetServerClientDispatchRead:1202 : RPC_SERVER_CLIENT_MSG_RX: client=0x7fefbfeb5710 len=220 prog=536903814 vers=1 proc=8 type=0 status=0 serial=5 >2013-11-25 08:26:02.011+0000: 3913: debug : virKeepAliveCheckMessage:374 : ka=0x7fefbfeb45a0, client=0x7fefbfeb5710, msg=0x7fefbfeb4100 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollUpdateTimeout:260 : EVENT_POLL_UPDATE_TIMEOUT: timer=6 frequency=5000 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollUpdateTimeout:278 : Set timer freq=5000 expires=1385367967011 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140667668162688 >2013-11-25 08:26:02.011+0000: 3913: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fefbfeb5710 >2013-11-25 08:26:02.011+0000: 3913: debug : virNetServerDispatchNewMessage:213 : server=0x7fefbfea6430 client=0x7fefbfeb5710 message=0x7fefbfeb4100 >2013-11-25 08:26:02.011+0000: 3913: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fefbfeafc60 >2013-11-25 08:26:02.011+0000: 3913: debug : virNetMessageNew:44 : msg=0x7fefbfeb52f0 tracked=1 >2013-11-25 08:26:02.011+0000: 3913: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7fefbfeb52f0 tx=(nil) >2013-11-25 08:26:02.011+0000: 3913: debug : virNetServerClientCalculateHandleMode:188 : mode=1 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=14 events=1 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140667668162688 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollCleanupTimeouts:514 : Cleanup 2 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollCleanupHandles:562 : Cleanup 11 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventRunDefaultImpl:270 : running default event implementation >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollCleanupTimeouts:514 : Cleanup 2 >2013-11-25 08:26:02.011+0000: 3918: debug : virNetServerHandleJob:184 : server=0x7fefbfea6430 client=0x7fefbfeb5710 message=0x7fefbfeb4100 prog=0x7fefbfeafc60 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollCleanupHandles:562 : Cleanup 11 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=6 e=1 d=0 >2013-11-25 08:26:02.011+0000: 3918: debug : virNetServerProgramDispatch:285 : prog=536903814 ver=1 type=0 status=0 serial=5 proc=8 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=8 e=1 d=0 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=2 w=3, f=11 e=1 d=0 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=3 w=4, f=12 e=1 d=0 >2013-11-25 08:26:02.011+0000: 3918: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fef94000940 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=4 w=5, f=13 e=1 d=0 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=5 w=6, f=14 e=1 d=0 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=6 w=7, f=15 e=0 d=0 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=7 w=8, f=15 e=1 d=0 >2013-11-25 08:26:02.011+0000: 3918: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fef94000940 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=8 w=9, f=17 e=1 d=0 >2013-11-25 08:26:02.011+0000: 3918: debug : remoteDispatchDomainAttachDeviceHelper:2273 : server=0x7fefbfea6430 client=0x7fefbfeb5710 msg=0x7fefbfeb4100 rerr=0x7fefad5a5c90 args=0x7fef94000b10 ret=0x7fef940009e0 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=9 w=11, f=21 e=25 d=0 >2013-11-25 08:26:02.011+0000: 3918: debug : virObjectNew:199 : OBJECT_NEW: obj=0x7fef940009a0 classname=virDomain >2013-11-25 08:26:02.011+0000: 3918: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fef98001b30 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=10 w=14, f=22 e=1 d=0 >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 2 timers >2013-11-25 08:26:02.011+0000: 3918: debug : virDomainAttachDevice:10918 : dom=0x7fef940009a0, (VM: name=r6.4, uuid=a3559509-df36-4001-a4a2-f7f79ac049d2), xml=<hostdev mode='subsystem' type='usb' managed='yes'> > <source> > <product id='0x090c'/> > <vendor id='0x1000'/> > </source> > </hostdev> > >2013-11-25 08:26:02.011+0000: 3913: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1385367967011 >2013-11-25 08:26:02.011+0000: 3918: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fefa0146010 >2013-11-25 08:26:02.012+0000: 3913: debug : virEventPollCalculateTimeout:353 : Schedule timeout then=1385367967011 now=1385367962012 >2013-11-25 08:26:02.012+0000: 3913: debug : virEventPollCalculateTimeout:361 : Timeout at 1385367967011 due in 4999 ms >2013-11-25 08:26:02.012+0000: 3913: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=10 timeout=4999 >2013-11-25 08:26:02.012+0000: 3918: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fefa02de0a0 >2013-11-25 08:26:02.012+0000: 3918: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fefbfeb1aa0 >2013-11-25 08:26:02.012+0000: 3918: debug : virAccessManagerCheckDomain:231 : manager=0x7fefbfeb1aa0(name=stack) driver=QEMU domain=0x7fefa02ef920 perm=2 >2013-11-25 08:26:02.012+0000: 3918: debug : virAccessManagerCheckDomain:231 : manager=0x7fefbfea60a0(name=none) driver=QEMU domain=0x7fefa02ef920 perm=2 >2013-11-25 08:26:02.012+0000: 3918: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fefbfeb1aa0 >2013-11-25 08:26:02.012+0000: 3918: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fefa0146010 >2013-11-25 08:26:02.012+0000: 3918: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fefa02e2620 >2013-11-25 08:26:02.012+0000: 3918: debug : qemuDomainObjBeginJobInternal:1038 : Starting job: modify (async=none) >2013-11-25 08:26:02.012+0000: 3918: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fefa0146010 >2013-11-25 08:26:02.012+0000: 3918: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fefa02f0b10 >2013-11-25 08:26:02.012+0000: 3918: debug : virUSBDeviceNew:366 : 0 0 000:000: initialized >2013-11-25 08:26:02.012+0000: 3918: info : virSecuritySELinuxSetFileconHelper:887 : Setting SELinux context on '/dev/bus/usb/000/000' to 'system_u:object_r:svirt_image_t:s0:c387,c595' >2013-11-25 08:26:02.012+0000: 3918: error : virSecuritySELinuxSetFileconHelper:910 : unable to set security context 'system_u:object_r:svirt_image_t:s0:c387,c595' on '/dev/bus/usb/000/000': No such file or directory >2013-11-25 08:26:02.012+0000: 3918: debug : virUSBDeviceFree:376 : 0 0 000:000: freeing >2013-11-25 08:26:02.012+0000: 3918: debug : virUSBDeviceNew:366 : 0 0 000:000: initialized >2013-11-25 08:26:02.012+0000: 3918: debug : virSecurityDACParseIds:89 : DAC seclabel for domain 'r6.4' wasn't found >2013-11-25 08:26:02.012+0000: 3918: info : virSecurityDACSetOwnership:255 : Setting DAC user and group on '/dev/bus/usb/000/000' to '107:107' >2013-11-25 08:26:02.012+0000: 3918: error : virSecurityDACSetOwnership:285 : unable to set user and group to '107:107' on '/dev/bus/usb/000/000': No such file or directory >2013-11-25 08:26:02.012+0000: 3918: debug : virUSBDeviceFree:376 : 0 0 000:000: freeing >2013-11-25 08:26:02.012+0000: 3918: debug : qemuDomainObjEndJob:1150 : Stopping job: modify (async=none) >2013-11-25 08:26:02.012+0000: 3918: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fefa02e2620 >2013-11-25 08:26:02.012+0000: 3918: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fefa02f0b10 >2013-11-25 08:26:02.012+0000: 3918: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fefa02de0a0 >2013-11-25 08:26:02.012+0000: 3918: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fefa0146010 >2013-11-25 08:26:02.012+0000: 3918: debug : virDomainFree:2428 : dom=0x7fef940009a0, (VM: name=r6.4, uuid=a3559509-df36-4001-a4a2-f7f79ac049d2) >2013-11-25 08:26:02.012+0000: 3918: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fef940009a0 >2013-11-25 08:26:02.012+0000: 3918: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7fef940009a0 >2013-11-25 08:26:02.012+0000: 3918: debug : virDomainDispose:262 : release domain 0x7fef940009a0 r6.4 a3559509-df36-4001-a4a2-f7f79ac049d2 >2013-11-25 08:26:02.012+0000: 3918: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fef98001b30 >2013-11-25 08:26:02.012+0000: 3918: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fef94000940 >2013-11-25 08:26:02.012+0000: 3918: debug : virNetServerProgramSendError:151 : prog=536903814 ver=1 proc=8 type=1 serial=5 msg=0x7fefbfeb4100 rerr=0x7fefad5a5c90 >2013-11-25 08:26:02.012+0000: 3918: debug : virNetMessageEncodePayload:374 : Encode length as 280 >2013-11-25 08:26:02.012+0000: 3918: debug : virNetServerClientSendMessageLocked:1451 : msg=0x7fefbfeb4100 proc=8 len=280 offset=0 >2013-11-25 08:26:02.012+0000: 3918: debug : virNetServerClientSendMessageLocked:1459 : RPC_SERVER_CLIENT_MSG_TX_QUEUE: client=0x7fefbfeb5710 len=280 prog=536903814 vers=1 proc=8 type=1 status=1 serial=5 >2013-11-25 08:26:02.012+0000: 3918: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7fefbfeb52f0 tx=0x7fefbfeb4100 >2013-11-25 08:26:02.012+0000: 3918: debug : virNetServerClientCalculateHandleMode:188 : mode=3 >2013-11-25 08:26:02.012+0000: 3918: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=14 events=3 >2013-11-25 08:26:02.012+0000: 3918: debug : virEventPollInterruptLocked:714 : Interrupting >2013-11-25 08:26:02.012+0000: 3918: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fef94000940 >2013-11-25 08:26:02.012+0000: 3918: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fefbfeafc60 >2013-11-25 08:26:02.012+0000: 3918: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fefbfeb5710 >2013-11-25 08:26:02.012+0000: 3913: debug : virEventPollRunOnce:638 : Poll got 1 event(s) >2013-11-25 08:26:02.012+0000: 3913: debug : virEventPollDispatchTimeouts:423 : Dispatch 2 >2013-11-25 08:26:02.012+0000: 3913: debug : virEventPollDispatchHandles:468 : Dispatch 10 >2013-11-25 08:26:02.012+0000: 3913: debug : virEventPollDispatchHandles:482 : i=0 w=1 >2013-11-25 08:26:02.012+0000: 3913: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1 >2013-11-25 08:26:02.012+0000: 3913: debug : virEventPollDispatchHandles:482 : i=1 w=2 >2013-11-25 08:26:02.012+0000: 3913: debug : virEventPollDispatchHandles:482 : i=2 w=3 >2013-11-25 08:26:02.012+0000: 3913: debug : virEventPollDispatchHandles:482 : i=3 w=4 >2013-11-25 08:26:02.012+0000: 3913: debug : virEventPollDispatchHandles:482 : i=4 w=5 >2013-11-25 08:26:02.012+0000: 3913: debug : virEventPollDispatchHandles:482 : i=5 w=6 >2013-11-25 08:26:02.012+0000: 3913: debug : virEventPollDispatchHandles:482 : i=7 w=8 >2013-11-25 08:26:02.012+0000: 3913: debug : virEventPollDispatchHandles:482 : i=8 w=9 >2013-11-25 08:26:02.012+0000: 3913: debug : virEventPollDispatchHandles:482 : i=9 w=11 >2013-11-25 08:26:02.012+0000: 3913: debug : virEventPollDispatchHandles:482 : i=10 w=14 >2013-11-25 08:26:02.012+0000: 3913: debug : virEventPollCleanupTimeouts:514 : Cleanup 2 >2013-11-25 08:26:02.012+0000: 3913: debug : virEventPollCleanupHandles:562 : Cleanup 11 >2013-11-25 08:26:02.012+0000: 3913: debug : virEventRunDefaultImpl:270 : running default event implementation >2013-11-25 08:26:02.012+0000: 3913: debug : virEventPollCleanupTimeouts:514 : Cleanup 2 >2013-11-25 08:26:02.012+0000: 3913: debug : virEventPollCleanupHandles:562 : Cleanup 11 >2013-11-25 08:26:02.012+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=6 e=1 d=0 >2013-11-25 08:26:02.012+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=8 e=1 d=0 >2013-11-25 08:26:02.012+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=2 w=3, f=11 e=1 d=0 >2013-11-25 08:26:02.012+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=3 w=4, f=12 e=1 d=0 >2013-11-25 08:26:02.012+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=4 w=5, f=13 e=1 d=0 >2013-11-25 08:26:02.012+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=5 w=6, f=14 e=1 d=0 >2013-11-25 08:26:02.012+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=6 w=7, f=15 e=0 d=0 >2013-11-25 08:26:02.012+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=7 w=8, f=15 e=1 d=0 >2013-11-25 08:26:02.012+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=8 w=9, f=17 e=1 d=0 >2013-11-25 08:26:02.012+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=9 w=11, f=21 e=25 d=0 >2013-11-25 08:26:02.012+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=10 w=14, f=22 e=5 d=0 >2013-11-25 08:26:02.012+0000: 3913: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 2 timers >2013-11-25 08:26:02.012+0000: 3913: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1385367967011 >2013-11-25 08:26:02.012+0000: 3913: debug : virEventPollCalculateTimeout:353 : Schedule timeout then=1385367967011 now=1385367962012 >2013-11-25 08:26:02.012+0000: 3913: debug : virEventPollCalculateTimeout:361 : Timeout at 1385367967011 due in 4999 ms >2013-11-25 08:26:02.012+0000: 3913: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=10 timeout=4999 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollRunOnce:638 : Poll got 1 event(s) >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollDispatchTimeouts:423 : Dispatch 2 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollDispatchHandles:468 : Dispatch 10 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollDispatchHandles:482 : i=0 w=1 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollDispatchHandles:482 : i=1 w=2 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollDispatchHandles:482 : i=2 w=3 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollDispatchHandles:482 : i=3 w=4 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollDispatchHandles:482 : i=4 w=5 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollDispatchHandles:482 : i=5 w=6 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollDispatchHandles:482 : i=7 w=8 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollDispatchHandles:482 : i=8 w=9 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollDispatchHandles:482 : i=9 w=11 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollDispatchHandles:482 : i=10 w=14 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=14 events=2 >2013-11-25 08:26:02.013+0000: 3913: debug : virNetMessageFree:72 : msg=0x7fefbfeb4100 nfds=0 cb=(nil) >2013-11-25 08:26:02.013+0000: 3913: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7fefbfeb52f0 tx=(nil) >2013-11-25 08:26:02.013+0000: 3913: debug : virNetServerClientCalculateHandleMode:188 : mode=1 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=14 events=1 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140667668162688 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollCleanupTimeouts:514 : Cleanup 2 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollCleanupHandles:562 : Cleanup 11 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventRunDefaultImpl:270 : running default event implementation >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollCleanupTimeouts:514 : Cleanup 2 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollCleanupHandles:562 : Cleanup 11 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=6 e=1 d=0 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=8 e=1 d=0 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=2 w=3, f=11 e=1 d=0 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=3 w=4, f=12 e=1 d=0 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=4 w=5, f=13 e=1 d=0 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=5 w=6, f=14 e=1 d=0 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=6 w=7, f=15 e=0 d=0 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=7 w=8, f=15 e=1 d=0 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=8 w=9, f=17 e=1 d=0 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=9 w=11, f=21 e=25 d=0 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=10 w=14, f=22 e=1 d=0 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 2 timers >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1385367967011 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollCalculateTimeout:353 : Schedule timeout then=1385367967011 now=1385367962013 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollCalculateTimeout:361 : Timeout at 1385367967011 due in 4998 ms >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=10 timeout=4998 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollRunOnce:638 : Poll got 1 event(s) >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollDispatchTimeouts:423 : Dispatch 2 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollDispatchHandles:468 : Dispatch 10 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollDispatchHandles:482 : i=0 w=1 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollDispatchHandles:482 : i=1 w=2 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollDispatchHandles:482 : i=2 w=3 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollDispatchHandles:482 : i=3 w=4 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollDispatchHandles:482 : i=4 w=5 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollDispatchHandles:482 : i=5 w=6 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollDispatchHandles:482 : i=7 w=8 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollDispatchHandles:482 : i=8 w=9 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollDispatchHandles:482 : i=9 w=11 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollDispatchHandles:482 : i=10 w=14 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=14 events=1 >2013-11-25 08:26:02.013+0000: 3913: debug : virNetMessageDecodeLength:149 : Got length, now need 28 total (24 more) >2013-11-25 08:26:02.013+0000: 3913: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7fefbfeb52f0 tx=(nil) >2013-11-25 08:26:02.013+0000: 3913: debug : virNetServerClientCalculateHandleMode:188 : mode=1 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=14 events=1 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140667668162688 >2013-11-25 08:26:02.013+0000: 3913: debug : virNetServerClientDispatchRead:1202 : RPC_SERVER_CLIENT_MSG_RX: client=0x7fefbfeb5710 len=28 prog=536903814 vers=1 proc=2 type=0 status=0 serial=6 >2013-11-25 08:26:02.013+0000: 3913: debug : virKeepAliveCheckMessage:374 : ka=0x7fefbfeb45a0, client=0x7fefbfeb5710, msg=0x7fefbfeb52f0 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollUpdateTimeout:260 : EVENT_POLL_UPDATE_TIMEOUT: timer=6 frequency=5000 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollUpdateTimeout:278 : Set timer freq=5000 expires=1385367967013 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140667668162688 >2013-11-25 08:26:02.013+0000: 3913: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fefbfeb5710 >2013-11-25 08:26:02.013+0000: 3913: debug : virNetServerDispatchNewMessage:213 : server=0x7fefbfea6430 client=0x7fefbfeb5710 message=0x7fefbfeb52f0 >2013-11-25 08:26:02.013+0000: 3913: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fefbfeafc60 >2013-11-25 08:26:02.013+0000: 3913: debug : virNetMessageNew:44 : msg=0x7fefbfea7580 tracked=1 >2013-11-25 08:26:02.013+0000: 3913: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7fefbfea7580 tx=(nil) >2013-11-25 08:26:02.013+0000: 3913: debug : virNetServerClientCalculateHandleMode:188 : mode=1 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=14 events=1 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140667668162688 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollCleanupTimeouts:514 : Cleanup 2 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollCleanupHandles:562 : Cleanup 11 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventRunDefaultImpl:270 : running default event implementation >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollCleanupTimeouts:514 : Cleanup 2 >2013-11-25 08:26:02.013+0000: 3917: debug : virNetServerHandleJob:184 : server=0x7fefbfea6430 client=0x7fefbfeb5710 message=0x7fefbfeb52f0 prog=0x7fefbfeafc60 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollCleanupHandles:562 : Cleanup 11 >2013-11-25 08:26:02.013+0000: 3917: debug : virNetServerProgramDispatch:285 : prog=536903814 ver=1 type=0 status=0 serial=6 proc=2 >2013-11-25 08:26:02.013+0000: 3917: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fef94000940 >2013-11-25 08:26:02.013+0000: 3917: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fef94000940 >2013-11-25 08:26:02.013+0000: 3917: debug : remoteDispatchConnectCloseHelper:174 : server=0x7fefbfea6430 client=0x7fefbfeb5710 msg=0x7fefbfeb52f0 rerr=0x7fefadda6c90 args=0x7fef880021e0 ret=0x7fef880020a0 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=6 e=1 d=0 >2013-11-25 08:26:02.013+0000: 3917: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fef94000940 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=8 e=1 d=0 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=2 w=3, f=11 e=1 d=0 >2013-11-25 08:26:02.013+0000: 3917: debug : virNetMessageEncodePayload:374 : Encode length as 28 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=3 w=4, f=12 e=1 d=0 >2013-11-25 08:26:02.013+0000: 3917: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fef94000940 >2013-11-25 08:26:02.013+0000: 3917: debug : virNetServerClientSendMessageLocked:1451 : msg=0x7fefbfeb52f0 proc=2 len=28 offset=0 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=4 w=5, f=13 e=1 d=0 >2013-11-25 08:26:02.013+0000: 3917: debug : virNetServerClientSendMessageLocked:1459 : RPC_SERVER_CLIENT_MSG_TX_QUEUE: client=0x7fefbfeb5710 len=28 prog=536903814 vers=1 proc=2 type=1 status=0 serial=6 >2013-11-25 08:26:02.013+0000: 3917: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7fefbfea7580 tx=0x7fefbfeb52f0 >2013-11-25 08:26:02.013+0000: 3917: debug : virNetServerClientCalculateHandleMode:188 : mode=2 >2013-11-25 08:26:02.013+0000: 3917: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=14 events=2 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=5 w=6, f=14 e=1 d=0 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=6 w=7, f=15 e=0 d=0 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=7 w=8, f=15 e=1 d=0 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=8 w=9, f=17 e=1 d=0 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=9 w=11, f=21 e=25 d=0 >2013-11-25 08:26:02.013+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=10 w=14, f=22 e=1 d=0 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 2 timers >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1385367967013 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollCalculateTimeout:353 : Schedule timeout then=1385367967013 now=1385367962014 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollCalculateTimeout:361 : Timeout at 1385367967013 due in 4999 ms >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=10 timeout=4999 >2013-11-25 08:26:02.014+0000: 3917: debug : virEventPollInterruptLocked:714 : Interrupting >2013-11-25 08:26:02.014+0000: 3917: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fefbfeafc60 >2013-11-25 08:26:02.014+0000: 3917: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fefbfeb5710 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollRunOnce:638 : Poll got 1 event(s) >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollDispatchTimeouts:423 : Dispatch 2 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollDispatchHandles:468 : Dispatch 10 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollDispatchHandles:482 : i=0 w=1 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollDispatchHandles:482 : i=1 w=2 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollDispatchHandles:482 : i=2 w=3 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollDispatchHandles:482 : i=3 w=4 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollDispatchHandles:482 : i=4 w=5 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollDispatchHandles:482 : i=5 w=6 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollDispatchHandles:482 : i=7 w=8 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollDispatchHandles:482 : i=8 w=9 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollDispatchHandles:482 : i=9 w=11 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollDispatchHandles:482 : i=10 w=14 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollCleanupTimeouts:514 : Cleanup 2 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollCleanupHandles:562 : Cleanup 11 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventRunDefaultImpl:270 : running default event implementation >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollCleanupTimeouts:514 : Cleanup 2 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollCleanupHandles:562 : Cleanup 11 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=6 e=1 d=0 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=8 e=1 d=0 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=2 w=3, f=11 e=1 d=0 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=3 w=4, f=12 e=1 d=0 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=4 w=5, f=13 e=1 d=0 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=5 w=6, f=14 e=1 d=0 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=6 w=7, f=15 e=0 d=0 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=7 w=8, f=15 e=1 d=0 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=8 w=9, f=17 e=1 d=0 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=9 w=11, f=21 e=25 d=0 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=10 w=14, f=22 e=4 d=0 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 2 timers >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1385367967013 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollCalculateTimeout:353 : Schedule timeout then=1385367967013 now=1385367962014 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollCalculateTimeout:361 : Timeout at 1385367967013 due in 4999 ms >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=10 timeout=4999 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollRunOnce:638 : Poll got 1 event(s) >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollDispatchTimeouts:423 : Dispatch 2 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollDispatchHandles:468 : Dispatch 10 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollDispatchHandles:482 : i=0 w=1 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollDispatchHandles:482 : i=1 w=2 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollDispatchHandles:482 : i=2 w=3 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollDispatchHandles:482 : i=3 w=4 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollDispatchHandles:482 : i=4 w=5 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollDispatchHandles:482 : i=5 w=6 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollDispatchHandles:482 : i=7 w=8 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollDispatchHandles:482 : i=8 w=9 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollDispatchHandles:482 : i=9 w=11 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollDispatchHandles:482 : i=10 w=14 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollDispatchHandles:496 : EVENT_POLL_DISPATCH_HANDLE: watch=14 events=2 >2013-11-25 08:26:02.014+0000: 3913: debug : virNetMessageFree:72 : msg=0x7fefbfeb52f0 nfds=0 cb=(nil) >2013-11-25 08:26:02.014+0000: 3913: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7fefbfea7580 tx=(nil) >2013-11-25 08:26:02.014+0000: 3913: debug : virNetServerClientCalculateHandleMode:188 : mode=0 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=14 events=0 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140667668162688 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollCleanupTimeouts:514 : Cleanup 2 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollCleanupHandles:562 : Cleanup 11 >2013-11-25 08:26:02.014+0000: 3913: debug : virNetServerClientClose:941 : client=0x7fefbfeb5710 >2013-11-25 08:26:02.014+0000: 3913: debug : virKeepAliveStop:307 : RPC_KEEPALIVE_STOP: ka=0x7fefbfeb45a0 client=0x7fefbfeb5710 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollRemoveTimeout:300 : EVENT_POLL_REMOVE_TIMEOUT: timer=6 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollInterruptLocked:710 : Skip interrupt, 0 140667668162688 >2013-11-25 08:26:02.014+0000: 3913: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fefbfeb5710 >2013-11-25 08:26:02.014+0000: 3913: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fefbfeb45a0 >2013-11-25 08:26:02.014+0000: 3913: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fefbfeb5710 >2013-11-25 08:26:02.014+0000: 3913: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fefbfeb5710 >2013-11-25 08:26:02.014+0000: 3913: debug : daemonRemoveAllClientStreams:486 : stream=(nil) >2013-11-25 08:26:02.014+0000: 3913: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fefbfeb5710 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollRemoveHandle:180 : EVENT_POLL_REMOVE_HANDLE: watch=14 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollRemoveHandle:193 : mark delete 10 22 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollInterruptLocked:710 : Skip interrupt, 0 140667668162688 >2013-11-25 08:26:02.014+0000: 3913: debug : virNetMessageFree:72 : msg=0x7fefbfea7580 nfds=0 cb=(nil) >2013-11-25 08:26:02.014+0000: 3913: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fefbfeb4fd0 >2013-11-25 08:26:02.014+0000: 3913: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fefbfeb5710 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventRunDefaultImpl:270 : running default event implementation >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollCleanupTimeouts:514 : Cleanup 2 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollCleanupTimeouts:527 : EVENT_POLL_PURGE_TIMEOUT: timer=6 >2013-11-25 08:26:02.014+0000: 3913: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fefbfeb45a0 >2013-11-25 08:26:02.014+0000: 3913: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7fefbfeb45a0 >2013-11-25 08:26:02.014+0000: 3913: debug : virKeepAliveDispose:227 : RPC_KEEPALIVE_DISPOSE: ka=0x7fefbfeb45a0 >2013-11-25 08:26:02.014+0000: 3913: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fefbfeb5710 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollCleanupHandles:562 : Cleanup 11 >2013-11-25 08:26:02.014+0000: 3913: debug : virEventPollCleanupHandles:575 : EVENT_POLL_PURGE_HANDLE: watch=14 >2013-11-25 08:26:02.014+0000: 3913: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fefbfeb5710 >2013-11-25 08:26:02.014+0000: 3913: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7fefbfeb5710 >2013-11-25 08:26:02.014+0000: 3913: debug : virNetServerClientDispose:905 : RPC_SERVER_CLIENT_DISPOSE: client=0x7fefbfeb5710 >2013-11-25 08:26:02.014+0000: 3913: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fef94000940 >2013-11-25 08:26:02.014+0000: 3913: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7fef94000940 >2013-11-25 08:26:02.015+0000: 3913: debug : virFileClose:90 : Closed fd 23 >2013-11-25 08:26:02.016+0000: 3913: debug : virObjectNew:199 : OBJECT_NEW: obj=0x7fefbfeb56a0 classname=virIdentity >2013-11-25 08:26:02.016+0000: 3913: debug : virIdentitySetAttr:282 : ident=0x7fefbfeb56a0 attribute=0 value=root >2013-11-25 08:26:02.016+0000: 3913: debug : virIdentitySetAttr:282 : ident=0x7fefbfeb56a0 attribute=1 value=0 >2013-11-25 08:26:02.016+0000: 3913: debug : virIdentitySetAttr:282 : ident=0x7fefbfeb56a0 attribute=2 value=root >2013-11-25 08:26:02.016+0000: 3913: debug : virIdentitySetAttr:282 : ident=0x7fefbfeb56a0 attribute=3 value=0 >2013-11-25 08:26:02.016+0000: 3913: debug : virIdentitySetAttr:282 : ident=0x7fefbfeb56a0 attribute=8 value=system_u:system_r:virtd_t:s0-s0:c0.c1023 >2013-11-25 08:26:02.016+0000: 3913: debug : virIdentitySetAttr:282 : ident=0x7fefbfeb56a0 attribute=4 value=3913 >2013-11-25 08:26:02.016+0000: 3913: debug : virIdentitySetAttr:282 : ident=0x7fefbfeb56a0 attribute=5 value=131294 >2013-11-25 08:26:02.016+0000: 3913: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fefbfeb56a0 >2013-11-25 08:26:02.016+0000: 3913: debug : virConnectClose:1523 : conn=0x7fef98001b30 >2013-11-25 08:26:02.016+0000: 3913: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fef98001b30 >2013-11-25 08:26:02.016+0000: 3913: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7fef98001b30 >2013-11-25 08:26:02.016+0000: 3913: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fefa000f370 >2013-11-25 08:26:02.016+0000: 3913: debug : virCloseCallbacksRun:321 : conn=0x7fef98001b30 >2013-11-25 08:26:02.016+0000: 3913: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fef98001580 >2013-11-25 08:26:02.016+0000: 3913: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7fef98001580 >2013-11-25 08:26:02.016+0000: 3913: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fefbfeb56a0 >2013-11-25 08:26:02.016+0000: 3913: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fefbfeb56a0 >2013-11-25 08:26:02.016+0000: 3913: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7fefbfeb56a0 >2013-11-25 08:26:02.016+0000: 3913: debug : virEventPollRemoveTimeout:300 : EVENT_POLL_REMOVE_TIMEOUT: timer=5 >2013-11-25 08:26:02.016+0000: 3913: debug : virEventPollInterruptLocked:710 : Skip interrupt, 1 140667668162688 >2013-11-25 08:26:02.016+0000: 3913: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fefbfeb4fd0 >2013-11-25 08:26:02.016+0000: 3913: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7fefbfeb4fd0 >2013-11-25 08:26:02.016+0000: 3913: debug : virNetSocketDispose:1002 : RPC_SOCKET_DISPOSE: sock=0x7fefbfeb4fd0 >2013-11-25 08:26:02.016+0000: 3913: debug : virEventPollRemoveHandle:180 : EVENT_POLL_REMOVE_HANDLE: watch=14 >2013-11-25 08:26:02.016+0000: 3913: debug : virFileClose:90 : Closed fd 22 >2013-11-25 08:26:02.016+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=0 w=1, f=6 e=1 d=0 >2013-11-25 08:26:02.016+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=1 w=2, f=8 e=1 d=0 >2013-11-25 08:26:02.016+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=2 w=3, f=11 e=1 d=0 >2013-11-25 08:26:02.016+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=3 w=4, f=12 e=1 d=0 >2013-11-25 08:26:02.016+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=4 w=5, f=13 e=1 d=0 >2013-11-25 08:26:02.016+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=5 w=6, f=14 e=1 d=0 >2013-11-25 08:26:02.016+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=6 w=7, f=15 e=0 d=0 >2013-11-25 08:26:02.016+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=7 w=8, f=15 e=1 d=0 >2013-11-25 08:26:02.016+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=8 w=9, f=17 e=1 d=0 >2013-11-25 08:26:02.016+0000: 3913: debug : virEventPollMakePollFDs:391 : Prepare n=9 w=11, f=21 e=25 d=0 >2013-11-25 08:26:02.016+0000: 3913: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 1 timers >2013-11-25 08:26:02.016+0000: 3913: debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms >2013-11-25 08:26:02.016+0000: 3913: debug : virEventPollRunOnce:627 : EVENT_POLL_RUN: nhandles=9 timeout=-1
You cannot view the attachment while viewing its details because your browser does not support IFRAMEs.
View the attachment on a separate page
.
View Attachment As Raw
Actions:
View
Attachments on
bug 1025108
: 828554