Attachment 713588 Details for Bug 924054 – related libvirtd.log of auto suspend issue

related libvirtd.log of auto suspend issue

libvirtd-instance-00000002c-auto-suspend.log (text/x-log), 128.86 KB, created by Sam Stoelinga on 2013-03-21 04:10:10 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Sam Stoelinga

Created: 2013-03-21 04:10:10 UTC

Size: 128.86 KB

patch

obsolete

>2013-03-20 11:20:50.834+0000: 14424: debug : virDomainDispose:225 : release domain 0x7f67240fac30 instance-00000026 eafdab6f-7067-4b84-be5e-f3f381db0604
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=12 w=25, f=23 e=25 d=0
>2013-03-20 11:20:50.834+0000: 14424: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7f67300021f0
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=13 w=26, f=25 e=25 d=0
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=14 w=27, f=24 e=25 d=0
>2013-03-20 11:20:50.834+0000: 14424: debug : virNetMessageEncodePayload:358 : Encode length as 92
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=15 w=28, f=26 e=25 d=0
>2013-03-20 11:20:50.834+0000: 14424: debug : virNetServerClientSendMessageLocked:1251 : msg=0x1587e20 proc=65 len=92 offset=0
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=16 w=29, f=27 e=25 d=0
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=17 w=30, f=28 e=25 d=0
>2013-03-20 11:20:50.834+0000: 14424: debug : virNetServerClientSendMessageLocked:1259 : RPC_SERVER_CLIENT_MSG_TX_QUEUE: client=0x1586150 len=92 prog=536903814 vers=1 proc=65 type=1 status=0 serial=48001
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=18 w=31, f=29 e=25 d=0
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=19 w=32, f=30 e=1 d=0
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=20 w=34, f=19 e=1 d=0
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=21 w=68, f=40 e=25 d=0
>2013-03-20 11:20:50.834+0000: 14424: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x15870b0 tx=0x1587e20
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=22 w=85, f=41 e=25 d=0
>2013-03-20 11:20:50.834+0000: 14424: debug : virNetServerClientCalculateHandleMode:184 : mode=3
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=23 w=88, f=31 e=1 d=0
>2013-03-20 11:20:50.834+0000: 14424: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=34 events=3
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=24 w=90, f=35 e=1 d=0
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 3 timers
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollRunOnce:629 : EVENT_POLL_RUN: nhandles=24 timeout=-1
>2013-03-20 11:20:50.834+0000: 14424: debug : virEventPollInterruptLocked:716 : Interrupting
>2013-03-20 11:20:50.834+0000: 14424: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x15837a0
>2013-03-20 11:20:50.834+0000: 14424: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x1586150
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollRunOnce:640 : Poll got 1 event(s)
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchTimeouts:425 : Dispatch 3
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:470 : Dispatch 24
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:484 : i=0 w=1
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:498 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:484 : i=1 w=2
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:484 : i=2 w=3
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:484 : i=3 w=4
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:484 : i=4 w=5
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:484 : i=5 w=6
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:484 : i=6 w=7
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:484 : i=8 w=9
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:484 : i=9 w=10
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:484 : i=10 w=23
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:484 : i=11 w=24
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:484 : i=12 w=25
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:484 : i=13 w=26
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:484 : i=14 w=27
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:484 : i=15 w=28
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:484 : i=16 w=29
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:484 : i=17 w=30
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:484 : i=18 w=31
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:484 : i=19 w=32
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:484 : i=20 w=34
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:484 : i=21 w=68
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:484 : i=22 w=85
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:484 : i=23 w=88
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:484 : i=24 w=90
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollCleanupTimeouts:516 : Cleanup 3
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollCleanupHandles:564 : Cleanup 25
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventRunDefaultImpl:244 : running default event implementation
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollCleanupTimeouts:516 : Cleanup 3
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollCleanupHandles:564 : Cleanup 25
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=0 w=1, f=7 e=1 d=0
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=1 w=2, f=9 e=1 d=0
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=2 w=3, f=11 e=1 d=0
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=3 w=4, f=12 e=1 d=0
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=4 w=5, f=13 e=1 d=0
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=5 w=6, f=6 e=1 d=0
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=6 w=7, f=14 e=1 d=0
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=7 w=8, f=15 e=0 d=0
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=8 w=9, f=15 e=1 d=0
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=9 w=10, f=17 e=1 d=0
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=10 w=23, f=21 e=25 d=0
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=11 w=24, f=22 e=25 d=0
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=12 w=25, f=23 e=25 d=0
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=13 w=26, f=25 e=25 d=0
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=14 w=27, f=24 e=25 d=0
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=15 w=28, f=26 e=25 d=0
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=16 w=29, f=27 e=25 d=0
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=17 w=30, f=28 e=25 d=0
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=18 w=31, f=29 e=25 d=0
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=19 w=32, f=30 e=1 d=0
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=20 w=34, f=19 e=5 d=0
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=21 w=68, f=40 e=25 d=0
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=22 w=85, f=41 e=25 d=0
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=23 w=88, f=31 e=1 d=0
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=24 w=90, f=35 e=1 d=0
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 3 timers
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollRunOnce:629 : EVENT_POLL_RUN: nhandles=24 timeout=-1
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollRunOnce:640 : Poll got 1 event(s)
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchTimeouts:425 : Dispatch 3
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:470 : Dispatch 24
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:484 : i=0 w=1
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:484 : i=1 w=2
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:484 : i=2 w=3
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:484 : i=3 w=4
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:484 : i=4 w=5
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:484 : i=5 w=6
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:484 : i=6 w=7
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:484 : i=8 w=9
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:484 : i=9 w=10
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:484 : i=10 w=23
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:484 : i=11 w=24
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:484 : i=12 w=25
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:484 : i=13 w=26
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:484 : i=14 w=27
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:484 : i=15 w=28
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:484 : i=16 w=29
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:484 : i=17 w=30
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:484 : i=18 w=31
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:484 : i=19 w=32
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:484 : i=20 w=34
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollDispatchHandles:498 : EVENT_POLL_DISPATCH_HANDLE: watch=34 events=2
>2013-03-20 11:20:50.834+0000: 14417: debug : virNetMessageFree:73 : msg=0x1587e20 nfds=0 cb=(nil)
>2013-03-20 11:20:50.834+0000: 14417: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x15870b0 tx=(nil)
>2013-03-20 11:20:50.834+0000: 14417: debug : virNetServerClientCalculateHandleMode:184 : mode=1
>2013-03-20 11:20:50.834+0000: 14417: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=34 events=1
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollInterruptLocked:712 : Skip interrupt, 1 1269381120
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollDispatchHandles:484 : i=21 w=68
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollDispatchHandles:484 : i=22 w=85
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollDispatchHandles:484 : i=23 w=88
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollDispatchHandles:484 : i=24 w=90
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollCleanupTimeouts:516 : Cleanup 3
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollCleanupHandles:564 : Cleanup 25
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventRunDefaultImpl:244 : running default event implementation
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollCleanupTimeouts:516 : Cleanup 3
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollCleanupHandles:564 : Cleanup 25
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=0 w=1, f=7 e=1 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=1 w=2, f=9 e=1 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=2 w=3, f=11 e=1 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=3 w=4, f=12 e=1 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=4 w=5, f=13 e=1 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=5 w=6, f=6 e=1 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=6 w=7, f=14 e=1 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=7 w=8, f=15 e=0 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=8 w=9, f=15 e=1 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=9 w=10, f=17 e=1 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=10 w=23, f=21 e=25 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=11 w=24, f=22 e=25 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=12 w=25, f=23 e=25 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=13 w=26, f=25 e=25 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=14 w=27, f=24 e=25 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=15 w=28, f=26 e=25 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=16 w=29, f=27 e=25 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=17 w=30, f=28 e=25 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=18 w=31, f=29 e=25 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=19 w=32, f=30 e=1 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=20 w=34, f=19 e=1 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=21 w=68, f=40 e=25 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=22 w=85, f=41 e=25 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=23 w=88, f=31 e=1 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=24 w=90, f=35 e=1 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 3 timers
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollRunOnce:629 : EVENT_POLL_RUN: nhandles=24 timeout=-1
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollRunOnce:640 : Poll got 1 event(s)
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollDispatchTimeouts:425 : Dispatch 3
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollDispatchHandles:470 : Dispatch 24
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollDispatchHandles:484 : i=0 w=1
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollDispatchHandles:484 : i=1 w=2
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollDispatchHandles:484 : i=2 w=3
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollDispatchHandles:484 : i=3 w=4
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollDispatchHandles:484 : i=4 w=5
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollDispatchHandles:484 : i=5 w=6
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollDispatchHandles:484 : i=6 w=7
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollDispatchHandles:484 : i=8 w=9
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollDispatchHandles:484 : i=9 w=10
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollDispatchHandles:484 : i=10 w=23
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollDispatchHandles:484 : i=11 w=24
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollDispatchHandles:484 : i=12 w=25
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollDispatchHandles:484 : i=13 w=26
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollDispatchHandles:484 : i=14 w=27
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollDispatchHandles:484 : i=15 w=28
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollDispatchHandles:484 : i=16 w=29
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollDispatchHandles:484 : i=17 w=30
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollDispatchHandles:484 : i=18 w=31
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollDispatchHandles:484 : i=19 w=32
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollDispatchHandles:484 : i=20 w=34
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollDispatchHandles:498 : EVENT_POLL_DISPATCH_HANDLE: watch=34 events=1
>2013-03-20 11:20:50.835+0000: 14417: debug : virNetMessageDecodeLength:152 : Got length, now need 84 total (80 more)
>2013-03-20 11:20:50.835+0000: 14417: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x15870b0 tx=(nil)
>2013-03-20 11:20:50.835+0000: 14417: debug : virNetServerClientCalculateHandleMode:184 : mode=1
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=34 events=1
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollInterruptLocked:712 : Skip interrupt, 1 1269381120
>2013-03-20 11:20:50.835+0000: 14417: debug : virNetServerClientDispatchRead:1007 : RPC_SERVER_CLIENT_MSG_RX: client=0x1586150 len=84 prog=536903814 vers=1 proc=65 type=0 status=0 serial=48002
>2013-03-20 11:20:50.835+0000: 14417: debug : virKeepAliveCheckMessage:384 : ka=0x1587af0, client=0x1586150, msg=0x15870b0
>2013-03-20 11:20:50.835+0000: 14417: debug : virObjectRef:168 : OBJECT_REF: obj=0x1586150
>2013-03-20 11:20:50.835+0000: 14417: debug : virNetServerDispatchNewMessage:221 : server=0x1571e60 client=0x1586150 message=0x15870b0
>2013-03-20 11:20:50.835+0000: 14417: debug : virObjectRef:168 : OBJECT_REF: obj=0x15837a0
>2013-03-20 11:20:50.835+0000: 14417: debug : virNetMessageNew:45 : msg=0x158a2a0 tracked=1
>2013-03-20 11:20:50.835+0000: 14419: debug : virNetServerHandleJob:192 : server=0x1571e60 client=0x1586150 message=0x15870b0 prog=0x15837a0
>2013-03-20 11:20:50.835+0000: 14419: debug : virNetServerProgramDispatch:284 : prog=536903814 ver=1 type=0 status=0 serial=48002 proc=65
>2013-03-20 11:20:50.835+0000: 14417: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x158a2a0 tx=(nil)
>2013-03-20 11:20:50.835+0000: 14417: debug : virNetServerClientCalculateHandleMode:184 : mode=1
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=34 events=1
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollInterruptLocked:712 : Skip interrupt, 1 1269381120
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollDispatchHandles:484 : i=21 w=68
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollDispatchHandles:484 : i=22 w=85
>2013-03-20 11:20:50.835+0000: 14419: debug : remoteDispatchDomainInterfaceStatsHelper:2834 : server=0x1571e60 client=0x1586150 msg=0x15870b0 rerr=0x7f6746f21c40 args=0x7f673825f9b0 ret=0x7f67382e3ba0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollDispatchHandles:484 : i=23 w=88
>2013-03-20 11:20:50.835+0000: 14419: debug : virObjectNew:110 : OBJECT_NEW: obj=0x7f6738276ea0 classname=virDomain
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollDispatchHandles:484 : i=24 w=90
>2013-03-20 11:20:50.835+0000: 14419: debug : virObjectRef:168 : OBJECT_REF: obj=0x7f67300021f0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollCleanupTimeouts:516 : Cleanup 3
>2013-03-20 11:20:50.835+0000: 14419: debug : virDomainInterfaceStats:7410 : dom=0x7f6738276ea0, (VM: name=instance-00000021, uuid=8f2e7f00-1e02-4598-bb52-202086375605), path=vnet1, stats=0x7f6746f21b20, size=64
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollCleanupHandles:564 : Cleanup 25
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventRunDefaultImpl:244 : running default event implementation
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollCleanupTimeouts:516 : Cleanup 3
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollCleanupHandles:564 : Cleanup 25
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=0 w=1, f=7 e=1 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=1 w=2, f=9 e=1 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=2 w=3, f=11 e=1 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=3 w=4, f=12 e=1 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=4 w=5, f=13 e=1 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=5 w=6, f=6 e=1 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=6 w=7, f=14 e=1 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=7 w=8, f=15 e=0 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=8 w=9, f=15 e=1 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=9 w=10, f=17 e=1 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=10 w=23, f=21 e=25 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=11 w=24, f=22 e=25 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=12 w=25, f=23 e=25 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=13 w=26, f=25 e=25 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=14 w=27, f=24 e=25 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=15 w=28, f=26 e=25 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=16 w=29, f=27 e=25 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=17 w=30, f=28 e=25 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=18 w=31, f=29 e=25 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=19 w=32, f=30 e=1 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=20 w=34, f=19 e=1 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=21 w=68, f=40 e=25 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=22 w=85, f=41 e=25 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=23 w=88, f=31 e=1 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=24 w=90, f=35 e=1 d=0
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 3 timers
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollRunOnce:629 : EVENT_POLL_RUN: nhandles=24 timeout=-1
>2013-03-20 11:20:50.835+0000: 14419: debug : virDomainFree:2306 : dom=0x7f6738276ea0, (VM: name=instance-00000021, uuid=8f2e7f00-1e02-4598-bb52-202086375605)
>2013-03-20 11:20:50.835+0000: 14419: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7f6738276ea0
>2013-03-20 11:20:50.835+0000: 14419: debug : virObjectUnref:137 : OBJECT_DISPOSE: obj=0x7f6738276ea0
>2013-03-20 11:20:50.835+0000: 14419: debug : virDomainDispose:225 : release domain 0x7f6738276ea0 instance-00000021 8f2e7f00-1e02-4598-bb52-202086375605
>2013-03-20 11:20:50.835+0000: 14419: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7f67300021f0
>2013-03-20 11:20:50.835+0000: 14419: debug : virNetMessageEncodePayload:358 : Encode length as 92
>2013-03-20 11:20:50.835+0000: 14419: debug : virNetServerClientSendMessageLocked:1251 : msg=0x15870b0 proc=65 len=92 offset=0
>2013-03-20 11:20:50.835+0000: 14419: debug : virNetServerClientSendMessageLocked:1259 : RPC_SERVER_CLIENT_MSG_TX_QUEUE: client=0x1586150 len=92 prog=536903814 vers=1 proc=65 type=1 status=0 serial=48002
>2013-03-20 11:20:50.835+0000: 14419: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x158a2a0 tx=0x15870b0
>2013-03-20 11:20:50.835+0000: 14419: debug : virNetServerClientCalculateHandleMode:184 : mode=3
>2013-03-20 11:20:50.835+0000: 14419: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=34 events=3
>2013-03-20 11:20:50.835+0000: 14419: debug : virEventPollInterruptLocked:716 : Interrupting
>2013-03-20 11:20:50.835+0000: 14419: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x15837a0
>2013-03-20 11:20:50.835+0000: 14419: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x1586150
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollRunOnce:640 : Poll got 1 event(s)
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollDispatchTimeouts:425 : Dispatch 3
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollDispatchHandles:470 : Dispatch 24
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollDispatchHandles:484 : i=0 w=1
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollDispatchHandles:498 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1
>2013-03-20 11:20:50.835+0000: 14417: debug : virEventPollDispatchHandles:484 : i=1 w=2
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=2 w=3
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=3 w=4
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=4 w=5
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=5 w=6
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=6 w=7
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=8 w=9
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=9 w=10
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=10 w=23
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=11 w=24
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=12 w=25
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=13 w=26
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=14 w=27
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=15 w=28
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=16 w=29
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=17 w=30
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=18 w=31
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=19 w=32
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=20 w=34
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=21 w=68
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=22 w=85
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=23 w=88
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=24 w=90
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollCleanupTimeouts:516 : Cleanup 3
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollCleanupHandles:564 : Cleanup 25
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventRunDefaultImpl:244 : running default event implementation
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollCleanupTimeouts:516 : Cleanup 3
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollCleanupHandles:564 : Cleanup 25
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=0 w=1, f=7 e=1 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=1 w=2, f=9 e=1 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=2 w=3, f=11 e=1 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=3 w=4, f=12 e=1 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=4 w=5, f=13 e=1 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=5 w=6, f=6 e=1 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=6 w=7, f=14 e=1 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=7 w=8, f=15 e=0 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=8 w=9, f=15 e=1 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=9 w=10, f=17 e=1 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=10 w=23, f=21 e=25 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=11 w=24, f=22 e=25 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=12 w=25, f=23 e=25 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=13 w=26, f=25 e=25 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=14 w=27, f=24 e=25 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=15 w=28, f=26 e=25 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=16 w=29, f=27 e=25 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=17 w=30, f=28 e=25 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=18 w=31, f=29 e=25 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=19 w=32, f=30 e=1 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=20 w=34, f=19 e=5 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=21 w=68, f=40 e=25 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=22 w=85, f=41 e=25 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=23 w=88, f=31 e=1 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=24 w=90, f=35 e=1 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 3 timers
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollRunOnce:629 : EVENT_POLL_RUN: nhandles=24 timeout=-1
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollRunOnce:640 : Poll got 1 event(s)
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchTimeouts:425 : Dispatch 3
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:470 : Dispatch 24
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=0 w=1
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=1 w=2
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=2 w=3
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=3 w=4
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=4 w=5
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=5 w=6
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=6 w=7
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=8 w=9
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=9 w=10
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=10 w=23
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=11 w=24
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=12 w=25
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=13 w=26
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=14 w=27
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=15 w=28
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=16 w=29
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=17 w=30
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=18 w=31
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=19 w=32
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=20 w=34
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:498 : EVENT_POLL_DISPATCH_HANDLE: watch=34 events=2
>2013-03-20 11:20:50.836+0000: 14417: debug : virNetMessageFree:73 : msg=0x15870b0 nfds=0 cb=(nil)
>2013-03-20 11:20:50.836+0000: 14417: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x158a2a0 tx=(nil)
>2013-03-20 11:20:50.836+0000: 14417: debug : virNetServerClientCalculateHandleMode:184 : mode=1
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=34 events=1
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollInterruptLocked:712 : Skip interrupt, 1 1269381120
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=21 w=68
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=22 w=85
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=23 w=88
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=24 w=90
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollCleanupTimeouts:516 : Cleanup 3
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollCleanupHandles:564 : Cleanup 25
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventRunDefaultImpl:244 : running default event implementation
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollCleanupTimeouts:516 : Cleanup 3
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollCleanupHandles:564 : Cleanup 25
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=0 w=1, f=7 e=1 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=1 w=2, f=9 e=1 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=2 w=3, f=11 e=1 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=3 w=4, f=12 e=1 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=4 w=5, f=13 e=1 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=5 w=6, f=6 e=1 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=6 w=7, f=14 e=1 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=7 w=8, f=15 e=0 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=8 w=9, f=15 e=1 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=9 w=10, f=17 e=1 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=10 w=23, f=21 e=25 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=11 w=24, f=22 e=25 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=12 w=25, f=23 e=25 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=13 w=26, f=25 e=25 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=14 w=27, f=24 e=25 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=15 w=28, f=26 e=25 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=16 w=29, f=27 e=25 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=17 w=30, f=28 e=25 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=18 w=31, f=29 e=25 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=19 w=32, f=30 e=1 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=20 w=34, f=19 e=1 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=21 w=68, f=40 e=25 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=22 w=85, f=41 e=25 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=23 w=88, f=31 e=1 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=24 w=90, f=35 e=1 d=0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 3 timers
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollRunOnce:629 : EVENT_POLL_RUN: nhandles=24 timeout=-1
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollRunOnce:640 : Poll got 1 event(s)
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchTimeouts:425 : Dispatch 3
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:470 : Dispatch 24
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=0 w=1
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=1 w=2
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=2 w=3
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=3 w=4
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=4 w=5
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=5 w=6
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=6 w=7
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=8 w=9
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=9 w=10
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=10 w=23
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=11 w=24
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=12 w=25
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=13 w=26
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=14 w=27
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=15 w=28
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=16 w=29
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=17 w=30
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=18 w=31
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=19 w=32
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=20 w=34
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:498 : EVENT_POLL_DISPATCH_HANDLE: watch=34 events=1
>2013-03-20 11:20:50.836+0000: 14417: debug : virNetMessageDecodeLength:152 : Got length, now need 84 total (80 more)
>2013-03-20 11:20:50.836+0000: 14417: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x158a2a0 tx=(nil)
>2013-03-20 11:20:50.836+0000: 14417: debug : virNetServerClientCalculateHandleMode:184 : mode=1
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=34 events=1
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollInterruptLocked:712 : Skip interrupt, 1 1269381120
>2013-03-20 11:20:50.836+0000: 14417: debug : virNetServerClientDispatchRead:1007 : RPC_SERVER_CLIENT_MSG_RX: client=0x1586150 len=84 prog=536903814 vers=1 proc=65 type=0 status=0 serial=48003
>2013-03-20 11:20:50.836+0000: 14417: debug : virKeepAliveCheckMessage:384 : ka=0x1587af0, client=0x1586150, msg=0x158a2a0
>2013-03-20 11:20:50.836+0000: 14417: debug : virObjectRef:168 : OBJECT_REF: obj=0x1586150
>2013-03-20 11:20:50.836+0000: 14417: debug : virNetServerDispatchNewMessage:221 : server=0x1571e60 client=0x1586150 message=0x158a2a0
>2013-03-20 11:20:50.836+0000: 14417: debug : virObjectRef:168 : OBJECT_REF: obj=0x15837a0
>2013-03-20 11:20:50.836+0000: 14417: debug : virNetMessageNew:45 : msg=0x15891f0 tracked=1
>2013-03-20 11:20:50.836+0000: 14417: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x15891f0 tx=(nil)
>2013-03-20 11:20:50.836+0000: 14422: debug : virNetServerHandleJob:192 : server=0x1571e60 client=0x1586150 message=0x158a2a0 prog=0x15837a0
>2013-03-20 11:20:50.836+0000: 14417: debug : virNetServerClientCalculateHandleMode:184 : mode=1
>2013-03-20 11:20:50.836+0000: 14422: debug : virNetServerProgramDispatch:284 : prog=536903814 ver=1 type=0 status=0 serial=48003 proc=65
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=34 events=1
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollInterruptLocked:712 : Skip interrupt, 1 1269381120
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=21 w=68
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=22 w=85
>2013-03-20 11:20:50.836+0000: 14422: debug : remoteDispatchDomainInterfaceStatsHelper:2834 : server=0x1571e60 client=0x1586150 msg=0x158a2a0 rerr=0x7f674571ec40 args=0x7f6714065990 ret=0x7f6714012fc0
>2013-03-20 11:20:50.836+0000: 14417: debug : virEventPollDispatchHandles:484 : i=23 w=88
>2013-03-20 11:20:50.837+0000: 14422: debug : virObjectNew:110 : OBJECT_NEW: obj=0x7f671400c190 classname=virDomain
>2013-03-20 11:20:50.837+0000: 14422: debug : virObjectRef:168 : OBJECT_REF: obj=0x7f67300021f0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=24 w=90
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollCleanupTimeouts:516 : Cleanup 3
>2013-03-20 11:20:50.837+0000: 14422: debug : virDomainInterfaceStats:7410 : dom=0x7f671400c190, (VM: name=instance-00000027, uuid=44f6ae9a-61c4-4599-a986-0f4bf79fe142), path=vnet8, stats=0x7f674571eb20, size=64
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollCleanupHandles:564 : Cleanup 25
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventRunDefaultImpl:244 : running default event implementation
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollCleanupTimeouts:516 : Cleanup 3
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollCleanupHandles:564 : Cleanup 25
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=0 w=1, f=7 e=1 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=1 w=2, f=9 e=1 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=2 w=3, f=11 e=1 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=3 w=4, f=12 e=1 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=4 w=5, f=13 e=1 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=5 w=6, f=6 e=1 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=6 w=7, f=14 e=1 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=7 w=8, f=15 e=0 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=8 w=9, f=15 e=1 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=9 w=10, f=17 e=1 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=10 w=23, f=21 e=25 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=11 w=24, f=22 e=25 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=12 w=25, f=23 e=25 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=13 w=26, f=25 e=25 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=14 w=27, f=24 e=25 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=15 w=28, f=26 e=25 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=16 w=29, f=27 e=25 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=17 w=30, f=28 e=25 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=18 w=31, f=29 e=25 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=19 w=32, f=30 e=1 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=20 w=34, f=19 e=1 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=21 w=68, f=40 e=25 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=22 w=85, f=41 e=25 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=23 w=88, f=31 e=1 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=24 w=90, f=35 e=1 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 3 timers
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollRunOnce:629 : EVENT_POLL_RUN: nhandles=24 timeout=-1
>2013-03-20 11:20:50.837+0000: 14422: debug : virDomainFree:2306 : dom=0x7f671400c190, (VM: name=instance-00000027, uuid=44f6ae9a-61c4-4599-a986-0f4bf79fe142)
>2013-03-20 11:20:50.837+0000: 14422: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7f671400c190
>2013-03-20 11:20:50.837+0000: 14422: debug : virObjectUnref:137 : OBJECT_DISPOSE: obj=0x7f671400c190
>2013-03-20 11:20:50.837+0000: 14422: debug : virDomainDispose:225 : release domain 0x7f671400c190 instance-00000027 44f6ae9a-61c4-4599-a986-0f4bf79fe142
>2013-03-20 11:20:50.837+0000: 14422: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7f67300021f0
>2013-03-20 11:20:50.837+0000: 14422: debug : virNetMessageEncodePayload:358 : Encode length as 92
>2013-03-20 11:20:50.837+0000: 14422: debug : virNetServerClientSendMessageLocked:1251 : msg=0x158a2a0 proc=65 len=92 offset=0
>2013-03-20 11:20:50.837+0000: 14422: debug : virNetServerClientSendMessageLocked:1259 : RPC_SERVER_CLIENT_MSG_TX_QUEUE: client=0x1586150 len=92 prog=536903814 vers=1 proc=65 type=1 status=0 serial=48003
>2013-03-20 11:20:50.837+0000: 14422: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x15891f0 tx=0x158a2a0
>2013-03-20 11:20:50.837+0000: 14422: debug : virNetServerClientCalculateHandleMode:184 : mode=3
>2013-03-20 11:20:50.837+0000: 14422: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=34 events=3
>2013-03-20 11:20:50.837+0000: 14422: debug : virEventPollInterruptLocked:716 : Interrupting
>2013-03-20 11:20:50.837+0000: 14422: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x15837a0
>2013-03-20 11:20:50.837+0000: 14422: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x1586150
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollRunOnce:640 : Poll got 1 event(s)
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchTimeouts:425 : Dispatch 3
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:470 : Dispatch 24
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=0 w=1
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:498 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=1 w=2
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=2 w=3
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=3 w=4
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=4 w=5
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=5 w=6
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=6 w=7
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=8 w=9
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=9 w=10
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=10 w=23
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=11 w=24
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=12 w=25
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=13 w=26
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=14 w=27
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=15 w=28
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=16 w=29
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=17 w=30
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=18 w=31
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=19 w=32
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=20 w=34
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=21 w=68
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=22 w=85
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=23 w=88
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=24 w=90
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollCleanupTimeouts:516 : Cleanup 3
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollCleanupHandles:564 : Cleanup 25
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventRunDefaultImpl:244 : running default event implementation
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollCleanupTimeouts:516 : Cleanup 3
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollCleanupHandles:564 : Cleanup 25
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=0 w=1, f=7 e=1 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=1 w=2, f=9 e=1 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=2 w=3, f=11 e=1 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=3 w=4, f=12 e=1 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=4 w=5, f=13 e=1 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=5 w=6, f=6 e=1 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=6 w=7, f=14 e=1 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=7 w=8, f=15 e=0 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=8 w=9, f=15 e=1 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=9 w=10, f=17 e=1 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=10 w=23, f=21 e=25 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=11 w=24, f=22 e=25 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=12 w=25, f=23 e=25 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=13 w=26, f=25 e=25 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=14 w=27, f=24 e=25 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=15 w=28, f=26 e=25 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=16 w=29, f=27 e=25 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=17 w=30, f=28 e=25 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=18 w=31, f=29 e=25 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=19 w=32, f=30 e=1 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=20 w=34, f=19 e=5 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=21 w=68, f=40 e=25 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=22 w=85, f=41 e=25 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=23 w=88, f=31 e=1 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=24 w=90, f=35 e=1 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 3 timers
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollRunOnce:629 : EVENT_POLL_RUN: nhandles=24 timeout=-1
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollRunOnce:640 : Poll got 1 event(s)
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchTimeouts:425 : Dispatch 3
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:470 : Dispatch 24
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=0 w=1
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=1 w=2
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=2 w=3
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=3 w=4
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=4 w=5
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=5 w=6
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=6 w=7
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=8 w=9
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=9 w=10
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=10 w=23
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=11 w=24
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=12 w=25
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=13 w=26
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=14 w=27
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=15 w=28
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=16 w=29
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=17 w=30
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=18 w=31
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=19 w=32
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=20 w=34
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:498 : EVENT_POLL_DISPATCH_HANDLE: watch=34 events=2
>2013-03-20 11:20:50.837+0000: 14417: debug : virNetMessageFree:73 : msg=0x158a2a0 nfds=0 cb=(nil)
>2013-03-20 11:20:50.837+0000: 14417: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x15891f0 tx=(nil)
>2013-03-20 11:20:50.837+0000: 14417: debug : virNetServerClientCalculateHandleMode:184 : mode=1
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=34 events=1
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollInterruptLocked:712 : Skip interrupt, 1 1269381120
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=21 w=68
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=22 w=85
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=23 w=88
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollDispatchHandles:484 : i=24 w=90
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollCleanupTimeouts:516 : Cleanup 3
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollCleanupHandles:564 : Cleanup 25
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventRunDefaultImpl:244 : running default event implementation
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollCleanupTimeouts:516 : Cleanup 3
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollCleanupHandles:564 : Cleanup 25
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=0 w=1, f=7 e=1 d=0
>2013-03-20 11:20:50.837+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=1 w=2, f=9 e=1 d=0
>2013-03-20 11:20:50.838+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=2 w=3, f=11 e=1 d=0
>2013-03-20 11:20:50.838+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=3 w=4, f=12 e=1 d=0
>2013-03-20 11:20:50.838+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=4 w=5, f=13 e=1 d=0
>2013-03-20 11:20:50.838+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=5 w=6, f=6 e=1 d=0
>2013-03-20 11:20:50.838+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=6 w=7, f=14 e=1 d=0
>2013-03-20 11:20:50.838+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=7 w=8, f=15 e=0 d=0
>2013-03-20 11:20:50.838+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=8 w=9, f=15 e=1 d=0
>2013-03-20 11:20:50.838+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=9 w=10, f=17 e=1 d=0
>2013-03-20 11:20:50.838+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=10 w=23, f=21 e=25 d=0
>2013-03-20 11:20:50.838+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=11 w=24, f=22 e=25 d=0
>2013-03-20 11:20:50.838+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=12 w=25, f=23 e=25 d=0
>2013-03-20 11:20:50.838+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=13 w=26, f=25 e=25 d=0
>2013-03-20 11:20:50.838+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=14 w=27, f=24 e=25 d=0
>2013-03-20 11:20:50.838+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=15 w=28, f=26 e=25 d=0
>2013-03-20 11:20:50.838+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=16 w=29, f=27 e=25 d=0
>2013-03-20 11:20:50.838+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=17 w=30, f=28 e=25 d=0
>2013-03-20 11:20:50.838+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=18 w=31, f=29 e=25 d=0
>2013-03-20 11:20:50.838+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=19 w=32, f=30 e=1 d=0
>2013-03-20 11:20:50.838+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=20 w=34, f=19 e=1 d=0
>2013-03-20 11:20:50.838+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=21 w=68, f=40 e=25 d=0
>2013-03-20 11:20:50.838+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=22 w=85, f=41 e=25 d=0
>2013-03-20 11:20:50.838+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=23 w=88, f=31 e=1 d=0
>2013-03-20 11:20:50.838+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=24 w=90, f=35 e=1 d=0
>2013-03-20 11:20:50.838+0000: 14417: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 3 timers
>2013-03-20 11:20:50.838+0000: 14417: debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms
>2013-03-20 11:20:50.838+0000: 14417: debug : virEventPollRunOnce:629 : EVENT_POLL_RUN: nhandles=24 timeout=-1
>2013-03-20 11:20:53.286+0000: 14417: debug : virEventPollRunOnce:640 : Poll got 1 event(s)
>2013-03-20 11:20:53.286+0000: 14417: debug : virEventPollDispatchTimeouts:425 : Dispatch 3
>2013-03-20 11:20:53.286+0000: 14417: debug : virEventPollDispatchHandles:470 : Dispatch 24
>2013-03-20 11:20:53.286+0000: 14417: debug : virEventPollDispatchHandles:484 : i=0 w=1
>2013-03-20 11:20:53.286+0000: 14417: debug : virEventPollDispatchHandles:484 : i=1 w=2
>2013-03-20 11:20:53.286+0000: 14417: debug : virEventPollDispatchHandles:484 : i=2 w=3
>2013-03-20 11:20:53.286+0000: 14417: debug : virEventPollDispatchHandles:484 : i=3 w=4
>2013-03-20 11:20:53.286+0000: 14417: debug : virEventPollDispatchHandles:484 : i=4 w=5
>2013-03-20 11:20:53.286+0000: 14417: debug : virEventPollDispatchHandles:484 : i=5 w=6
>2013-03-20 11:20:53.286+0000: 14417: debug : virEventPollDispatchHandles:484 : i=6 w=7
>2013-03-20 11:20:53.286+0000: 14417: debug : virEventPollDispatchHandles:484 : i=8 w=9
>2013-03-20 11:20:53.286+0000: 14417: debug : virEventPollDispatchHandles:484 : i=9 w=10
>2013-03-20 11:20:53.286+0000: 14417: debug : virEventPollDispatchHandles:484 : i=10 w=23
>2013-03-20 11:20:53.286+0000: 14417: debug : virEventPollDispatchHandles:484 : i=11 w=24
>2013-03-20 11:20:53.286+0000: 14417: debug : virEventPollDispatchHandles:484 : i=12 w=25
>2013-03-20 11:20:53.286+0000: 14417: debug : virEventPollDispatchHandles:484 : i=13 w=26
>2013-03-20 11:20:53.286+0000: 14417: debug : virEventPollDispatchHandles:484 : i=14 w=27
>2013-03-20 11:20:53.286+0000: 14417: debug : virEventPollDispatchHandles:484 : i=15 w=28
>2013-03-20 11:20:53.286+0000: 14417: debug : virEventPollDispatchHandles:484 : i=16 w=29
>2013-03-20 11:20:53.286+0000: 14417: debug : virEventPollDispatchHandles:484 : i=17 w=30
>2013-03-20 11:20:53.286+0000: 14417: debug : virEventPollDispatchHandles:484 : i=18 w=31
>2013-03-20 11:20:53.286+0000: 14417: debug : virEventPollDispatchHandles:484 : i=19 w=32
>2013-03-20 11:20:53.286+0000: 14417: debug : virEventPollDispatchHandles:484 : i=20 w=34
>2013-03-20 11:20:53.286+0000: 14417: debug : virEventPollDispatchHandles:484 : i=21 w=68
>2013-03-20 11:20:53.286+0000: 14417: debug : virEventPollDispatchHandles:484 : i=22 w=85
>2013-03-20 11:20:53.286+0000: 14417: debug : virEventPollDispatchHandles:498 : EVENT_POLL_DISPATCH_HANDLE: watch=85 events=1
>2013-03-20 11:20:53.286+0000: 14417: debug : virObjectRef:168 : OBJECT_REF: obj=0x7f671400dfa0
>2013-03-20 11:20:53.286+0000: 14417: debug : qemuMonitorIOProcess:354 : QEMU_MONITOR_IO_PROCESS: mon=0x7f671400dfa0 buf={"timestamp": {"seconds": 1363778453, "microseconds": 286452}, "event": "SUSPEND"}
> len=84
>2013-03-20 11:20:53.287+0000: 14417: debug : qemuMonitorJSONIOProcessLine:150 : Line [{"timestamp": {"seconds": 1363778453, "microseconds": 286452}, "event": "SUSPEND"}]
>2013-03-20 11:20:53.287+0000: 14417: debug : virJSONValueFromString:944 : string={"timestamp": {"seconds": 1363778453, "microseconds": 286452}, "event": "SUSPEND"}
>2013-03-20 11:20:53.287+0000: 14417: debug : virJSONParserHandleStartMap:821 : parser=0x7fff87de45b0
>2013-03-20 11:20:53.287+0000: 14417: debug : virJSONParserHandleMapKey:802 : parser=0x7fff87de45b0 key=0x1589ff2
>2013-03-20 11:20:53.287+0000: 14417: debug : virJSONParserHandleStartMap:821 : parser=0x7fff87de45b0
>2013-03-20 11:20:53.287+0000: 14417: debug : virJSONParserHandleMapKey:802 : parser=0x7fff87de45b0 key=0x158a000
>2013-03-20 11:20:53.287+0000: 14417: debug : virJSONParserHandleNumber:761 : parser=0x7fff87de45b0 str=(null)
>2013-03-20 11:20:53.287+0000: 14417: debug : virJSONParserHandleMapKey:802 : parser=0x7fff87de45b0 key=0x158a017
>2013-03-20 11:20:53.287+0000: 14417: debug : virJSONParserHandleNumber:761 : parser=0x7fff87de45b0 str=(null)
>2013-03-20 11:20:53.287+0000: 14417: debug : virJSONParserHandleEndMap:850 : parser=0x7fff87de45b0
>2013-03-20 11:20:53.287+0000: 14417: debug : virJSONParserHandleMapKey:802 : parser=0x7fff87de45b0 key=0x158a030
>2013-03-20 11:20:53.287+0000: 14417: debug : virJSONParserHandleString:782 : parser=0x7fff87de45b0 str=0x158a039
>2013-03-20 11:20:53.287+0000: 14417: debug : virJSONParserHandleEndMap:850 : parser=0x7fff87de45b0
>2013-03-20 11:20:53.287+0000: 14417: debug : virJSONValueFromString:988 : result=0x1555120
>2013-03-20 11:20:53.287+0000: 14417: debug : qemuMonitorJSONIOProcessLine:165 : QEMU_MONITOR_RECV_EVENT: mon=0x7f671400dfa0 event={"timestamp": {"seconds": 1363778453, "microseconds": 286452}, "event": "SUSPEND"}
>2013-03-20 11:20:53.287+0000: 14417: debug : qemuMonitorJSONIOProcessEvent:122 : mon=0x7f671400dfa0 obj=0x1555120
>2013-03-20 11:20:53.287+0000: 14417: debug : qemuMonitorJSONIOProcessEvent:136 : handle SUSPEND handler=0x7f673dea5930 data=(nil)
>2013-03-20 11:20:53.287+0000: 14417: debug : qemuMonitorEmitPMSuspend:1117 : mon=0x7f671400dfa0
>2013-03-20 11:20:53.287+0000: 14417: debug : virObjectRef:168 : OBJECT_REF: obj=0x7f671400dfa0
>2013-03-20 11:20:53.287+0000: 14417: debug : qemuProcessHandlePMSuspend:1194 : Transitioned guest instance-0000002c to pmsuspended state due to QMP suspend event
>2013-03-20 11:20:53.287+0000: 14417: debug : virFileMakePathHelper:1264 : path=/var/run/libvirt/qemu mode=0777
>2013-03-20 11:20:53.287+0000: 14417: debug : virFileClose:72 : Closed fd 38
>2013-03-20 11:20:53.287+0000: 14417: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7f671400dfa0
>2013-03-20 11:20:53.287+0000: 14417: debug : qemuMonitorJSONIOProcess:221 : Total used 84 bytes out of 84 available in buffer
>2013-03-20 11:20:53.287+0000: 14417: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=85 events=13
>2013-03-20 11:20:53.287+0000: 14417: debug : virEventPollInterruptLocked:712 : Skip interrupt, 1 1269381120
>2013-03-20 11:20:53.287+0000: 14417: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7f671400dfa0
>2013-03-20 11:20:53.287+0000: 14417: debug : virEventPollDispatchHandles:484 : i=23 w=88
>2013-03-20 11:20:53.287+0000: 14417: debug : virEventPollDispatchHandles:484 : i=24 w=90
>2013-03-20 11:20:53.287+0000: 14417: debug : virEventPollCleanupTimeouts:516 : Cleanup 3
>2013-03-20 11:20:53.287+0000: 14417: debug : virEventPollCleanupHandles:564 : Cleanup 25
>2013-03-20 11:20:53.287+0000: 14417: debug : virEventRunDefaultImpl:244 : running default event implementation
>2013-03-20 11:20:53.287+0000: 14417: debug : virEventPollCleanupTimeouts:516 : Cleanup 3
>2013-03-20 11:20:53.287+0000: 14417: debug : virEventPollCleanupHandles:564 : Cleanup 25
>2013-03-20 11:20:53.287+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=0 w=1, f=7 e=1 d=0
>2013-03-20 11:20:53.287+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=1 w=2, f=9 e=1 d=0
>2013-03-20 11:20:53.287+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=2 w=3, f=11 e=1 d=0
>2013-03-20 11:20:53.287+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=3 w=4, f=12 e=1 d=0
>2013-03-20 11:20:53.287+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=4 w=5, f=13 e=1 d=0
>2013-03-20 11:20:53.287+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=5 w=6, f=6 e=1 d=0
>2013-03-20 11:20:53.287+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=6 w=7, f=14 e=1 d=0
>2013-03-20 11:20:53.287+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=7 w=8, f=15 e=0 d=0
>2013-03-20 11:20:53.287+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=8 w=9, f=15 e=1 d=0
>2013-03-20 11:20:53.287+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=9 w=10, f=17 e=1 d=0
>2013-03-20 11:20:53.287+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=10 w=23, f=21 e=25 d=0
>2013-03-20 11:20:53.287+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=11 w=24, f=22 e=25 d=0
>2013-03-20 11:20:53.287+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=12 w=25, f=23 e=25 d=0
>2013-03-20 11:20:53.287+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=13 w=26, f=25 e=25 d=0
>2013-03-20 11:20:53.287+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=14 w=27, f=24 e=25 d=0
>2013-03-20 11:20:53.287+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=15 w=28, f=26 e=25 d=0
>2013-03-20 11:20:53.287+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=16 w=29, f=27 e=25 d=0
>2013-03-20 11:20:53.287+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=17 w=30, f=28 e=25 d=0
>2013-03-20 11:20:53.287+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=18 w=31, f=29 e=25 d=0
>2013-03-20 11:20:53.287+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=19 w=32, f=30 e=1 d=0
>2013-03-20 11:20:53.287+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=20 w=34, f=19 e=1 d=0
>2013-03-20 11:20:53.287+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=21 w=68, f=40 e=25 d=0
>2013-03-20 11:20:53.287+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=22 w=85, f=41 e=25 d=0
>2013-03-20 11:20:53.287+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=23 w=88, f=31 e=1 d=0
>2013-03-20 11:20:53.287+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=24 w=90, f=35 e=1 d=0
>2013-03-20 11:20:53.287+0000: 14417: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 3 timers
>2013-03-20 11:20:53.287+0000: 14417: debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms
>2013-03-20 11:20:53.287+0000: 14417: debug : virEventPollRunOnce:629 : EVENT_POLL_RUN: nhandles=24 timeout=-1
>2013-03-20 11:21:00.659+0000: 14417: debug : virEventPollRunOnce:640 : Poll got 1 event(s)
>2013-03-20 11:21:00.659+0000: 14417: debug : virEventPollDispatchTimeouts:425 : Dispatch 3
>2013-03-20 11:21:00.659+0000: 14417: debug : virEventPollDispatchHandles:470 : Dispatch 24
>2013-03-20 11:21:00.659+0000: 14417: debug : virEventPollDispatchHandles:484 : i=0 w=1
>2013-03-20 11:21:00.659+0000: 14417: debug : virEventPollDispatchHandles:484 : i=1 w=2
>2013-03-20 11:21:00.659+0000: 14417: debug : virEventPollDispatchHandles:484 : i=2 w=3
>2013-03-20 11:21:00.659+0000: 14417: debug : virEventPollDispatchHandles:484 : i=3 w=4
>2013-03-20 11:21:00.659+0000: 14417: debug : virEventPollDispatchHandles:484 : i=4 w=5
>2013-03-20 11:21:00.659+0000: 14417: debug : virEventPollDispatchHandles:484 : i=5 w=6
>2013-03-20 11:21:00.659+0000: 14417: debug : virEventPollDispatchHandles:484 : i=6 w=7
>2013-03-20 11:21:00.659+0000: 14417: debug : virEventPollDispatchHandles:484 : i=8 w=9
>2013-03-20 11:21:00.659+0000: 14417: debug : virEventPollDispatchHandles:484 : i=9 w=10
>2013-03-20 11:21:00.659+0000: 14417: debug : virEventPollDispatchHandles:484 : i=10 w=23
>2013-03-20 11:21:00.659+0000: 14417: debug : virEventPollDispatchHandles:484 : i=11 w=24
>2013-03-20 11:21:00.659+0000: 14417: debug : virEventPollDispatchHandles:484 : i=12 w=25
>2013-03-20 11:21:00.659+0000: 14417: debug : virEventPollDispatchHandles:484 : i=13 w=26
>2013-03-20 11:21:00.659+0000: 14417: debug : virEventPollDispatchHandles:484 : i=14 w=27
>2013-03-20 11:21:00.659+0000: 14417: debug : virEventPollDispatchHandles:484 : i=15 w=28
>2013-03-20 11:21:00.659+0000: 14417: debug : virEventPollDispatchHandles:484 : i=16 w=29
>2013-03-20 11:21:00.659+0000: 14417: debug : virEventPollDispatchHandles:484 : i=17 w=30
>2013-03-20 11:21:00.659+0000: 14417: debug : virEventPollDispatchHandles:484 : i=18 w=31
>2013-03-20 11:21:00.659+0000: 14417: debug : virEventPollDispatchHandles:484 : i=19 w=32
>2013-03-20 11:21:00.659+0000: 14417: debug : virEventPollDispatchHandles:484 : i=20 w=34
>2013-03-20 11:21:00.659+0000: 14417: debug : virEventPollDispatchHandles:498 : EVENT_POLL_DISPATCH_HANDLE: watch=34 events=1
>2013-03-20 11:21:00.659+0000: 14417: debug : virNetMessageDecodeLength:152 : Got length, now need 72 total (68 more)
>2013-03-20 11:21:00.659+0000: 14417: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x15891f0 tx=(nil)
>2013-03-20 11:21:00.659+0000: 14417: debug : virNetServerClientCalculateHandleMode:184 : mode=1
>2013-03-20 11:21:00.659+0000: 14417: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=34 events=1
>2013-03-20 11:21:00.659+0000: 14417: debug : virEventPollInterruptLocked:712 : Skip interrupt, 1 1269381120
>2013-03-20 11:21:00.659+0000: 14417: debug : virNetServerClientDispatchRead:1007 : RPC_SERVER_CLIENT_MSG_RX: client=0x1586150 len=72 prog=536903814 vers=1 proc=16 type=0 status=0 serial=48004
>2013-03-20 11:21:00.659+0000: 14417: debug : virKeepAliveCheckMessage:384 : ka=0x1587af0, client=0x1586150, msg=0x15891f0
>2013-03-20 11:21:00.659+0000: 14417: debug : virObjectRef:168 : OBJECT_REF: obj=0x1586150
>2013-03-20 11:21:00.659+0000: 14417: debug : virNetServerDispatchNewMessage:221 : server=0x1571e60 client=0x1586150 message=0x15891f0
>2013-03-20 11:21:00.659+0000: 14417: debug : virObjectRef:168 : OBJECT_REF: obj=0x15837a0
>2013-03-20 11:21:00.659+0000: 14417: debug : virNetMessageNew:45 : msg=0x15894c0 tracked=1
>2013-03-20 11:21:00.659+0000: 14417: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x15894c0 tx=(nil)
>2013-03-20 11:21:00.659+0000: 14417: debug : virNetServerClientCalculateHandleMode:184 : mode=1
>2013-03-20 11:21:00.659+0000: 14417: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=34 events=1
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollInterruptLocked:712 : Skip interrupt, 1 1269381120
>2013-03-20 11:21:00.660+0000: 14418: debug : virNetServerHandleJob:192 : server=0x1571e60 client=0x1586150 message=0x15891f0 prog=0x15837a0
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollDispatchHandles:484 : i=21 w=68
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollDispatchHandles:484 : i=22 w=85
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollDispatchHandles:484 : i=23 w=88
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollDispatchHandles:484 : i=24 w=90
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollCleanupTimeouts:516 : Cleanup 3
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollCleanupHandles:564 : Cleanup 25
>2013-03-20 11:21:00.660+0000: 14418: debug : virNetServerProgramDispatch:284 : prog=536903814 ver=1 type=0 status=0 serial=48004 proc=16
>2013-03-20 11:21:00.660+0000: 14418: debug : remoteDispatchDomainGetInfoHelper:1962 : server=0x1571e60 client=0x1586150 msg=0x15891f0 rerr=0x7f6747722c40 args=0x7f672c0146a0 ret=0x7f672c002f00
>2013-03-20 11:21:00.660+0000: 14418: debug : virObjectNew:110 : OBJECT_NEW: obj=0x7f672c00e2f0 classname=virDomain
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventRunDefaultImpl:244 : running default event implementation
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollCleanupTimeouts:516 : Cleanup 3
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollCleanupHandles:564 : Cleanup 25
>2013-03-20 11:21:00.660+0000: 14418: debug : virObjectRef:168 : OBJECT_REF: obj=0x7f67300021f0
>2013-03-20 11:21:00.660+0000: 14418: debug : virDomainGetInfo:4214 : dom=0x7f672c00e2f0, (VM: name=instance-0000002c, uuid=1d97d662-3f38-4788-8d55-87ccff19e9b2), info=0x7f6747722b30
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=0 w=1, f=7 e=1 d=0
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=1 w=2, f=9 e=1 d=0
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=2 w=3, f=11 e=1 d=0
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=3 w=4, f=12 e=1 d=0
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=4 w=5, f=13 e=1 d=0
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=5 w=6, f=6 e=1 d=0
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=6 w=7, f=14 e=1 d=0
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=7 w=8, f=15 e=0 d=0
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=8 w=9, f=15 e=1 d=0
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=9 w=10, f=17 e=1 d=0
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=10 w=23, f=21 e=25 d=0
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=11 w=24, f=22 e=25 d=0
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=12 w=25, f=23 e=25 d=0
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=13 w=26, f=25 e=25 d=0
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=14 w=27, f=24 e=25 d=0
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=15 w=28, f=26 e=25 d=0
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=16 w=29, f=27 e=25 d=0
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=17 w=30, f=28 e=25 d=0
>2013-03-20 11:21:00.660+0000: 14418: debug : qemuGetProcessInfo:1430 : Got status for 25760/0 user=51960 sys=28711 cpu=16 rss=534625
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=18 w=31, f=29 e=25 d=0
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=19 w=32, f=30 e=1 d=0
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=20 w=34, f=19 e=1 d=0
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=21 w=68, f=40 e=25 d=0
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=22 w=85, f=41 e=25 d=0
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=23 w=88, f=31 e=1 d=0
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=24 w=90, f=35 e=1 d=0
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 3 timers
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms
>2013-03-20 11:21:00.660+0000: 14418: debug : virDomainFree:2306 : dom=0x7f672c00e2f0, (VM: name=instance-0000002c, uuid=1d97d662-3f38-4788-8d55-87ccff19e9b2)
>2013-03-20 11:21:00.660+0000: 14418: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7f672c00e2f0
>2013-03-20 11:21:00.660+0000: 14418: debug : virObjectUnref:137 : OBJECT_DISPOSE: obj=0x7f672c00e2f0
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollRunOnce:629 : EVENT_POLL_RUN: nhandles=24 timeout=-1
>2013-03-20 11:21:00.660+0000: 14418: debug : virDomainDispose:225 : release domain 0x7f672c00e2f0 instance-0000002c 1d97d662-3f38-4788-8d55-87ccff19e9b2
>2013-03-20 11:21:00.660+0000: 14418: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7f67300021f0
>2013-03-20 11:21:00.660+0000: 14418: debug : virNetMessageEncodePayload:358 : Encode length as 60
>2013-03-20 11:21:00.660+0000: 14418: debug : virNetServerClientSendMessageLocked:1251 : msg=0x15891f0 proc=16 len=60 offset=0
>2013-03-20 11:21:00.660+0000: 14418: debug : virNetServerClientSendMessageLocked:1259 : RPC_SERVER_CLIENT_MSG_TX_QUEUE: client=0x1586150 len=60 prog=536903814 vers=1 proc=16 type=1 status=0 serial=48004
>2013-03-20 11:21:00.660+0000: 14418: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x15894c0 tx=0x15891f0
>2013-03-20 11:21:00.660+0000: 14418: debug : virNetServerClientCalculateHandleMode:184 : mode=3
>2013-03-20 11:21:00.660+0000: 14418: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=34 events=3
>2013-03-20 11:21:00.660+0000: 14418: debug : virEventPollInterruptLocked:716 : Interrupting
>2013-03-20 11:21:00.660+0000: 14418: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x15837a0
>2013-03-20 11:21:00.660+0000: 14418: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x1586150
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollRunOnce:640 : Poll got 1 event(s)
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollDispatchTimeouts:425 : Dispatch 3
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollDispatchHandles:470 : Dispatch 24
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollDispatchHandles:484 : i=0 w=1
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollDispatchHandles:498 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollDispatchHandles:484 : i=1 w=2
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollDispatchHandles:484 : i=2 w=3
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollDispatchHandles:484 : i=3 w=4
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollDispatchHandles:484 : i=4 w=5
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollDispatchHandles:484 : i=5 w=6
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollDispatchHandles:484 : i=6 w=7
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollDispatchHandles:484 : i=8 w=9
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollDispatchHandles:484 : i=9 w=10
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollDispatchHandles:484 : i=10 w=23
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollDispatchHandles:484 : i=11 w=24
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollDispatchHandles:484 : i=12 w=25
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollDispatchHandles:484 : i=13 w=26
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollDispatchHandles:484 : i=14 w=27
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollDispatchHandles:484 : i=15 w=28
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollDispatchHandles:484 : i=16 w=29
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollDispatchHandles:484 : i=17 w=30
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollDispatchHandles:484 : i=18 w=31
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollDispatchHandles:484 : i=19 w=32
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollDispatchHandles:484 : i=20 w=34
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollDispatchHandles:484 : i=21 w=68
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollDispatchHandles:484 : i=22 w=85
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollDispatchHandles:484 : i=23 w=88
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollDispatchHandles:484 : i=24 w=90
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollCleanupTimeouts:516 : Cleanup 3
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollCleanupHandles:564 : Cleanup 25
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventRunDefaultImpl:244 : running default event implementation
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollCleanupTimeouts:516 : Cleanup 3
>2013-03-20 11:21:00.660+0000: 14417: debug : virEventPollCleanupHandles:564 : Cleanup 25
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=0 w=1, f=7 e=1 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=1 w=2, f=9 e=1 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=2 w=3, f=11 e=1 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=3 w=4, f=12 e=1 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=4 w=5, f=13 e=1 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=5 w=6, f=6 e=1 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=6 w=7, f=14 e=1 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=7 w=8, f=15 e=0 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=8 w=9, f=15 e=1 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=9 w=10, f=17 e=1 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=10 w=23, f=21 e=25 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=11 w=24, f=22 e=25 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=12 w=25, f=23 e=25 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=13 w=26, f=25 e=25 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=14 w=27, f=24 e=25 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=15 w=28, f=26 e=25 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=16 w=29, f=27 e=25 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=17 w=30, f=28 e=25 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=18 w=31, f=29 e=25 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=19 w=32, f=30 e=1 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=20 w=34, f=19 e=5 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=21 w=68, f=40 e=25 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=22 w=85, f=41 e=25 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=23 w=88, f=31 e=1 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=24 w=90, f=35 e=1 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 3 timers
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollRunOnce:629 : EVENT_POLL_RUN: nhandles=24 timeout=-1
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollRunOnce:640 : Poll got 1 event(s)
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchTimeouts:425 : Dispatch 3
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:470 : Dispatch 24
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=0 w=1
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=1 w=2
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=2 w=3
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=3 w=4
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=4 w=5
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=5 w=6
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=6 w=7
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=8 w=9
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=9 w=10
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=10 w=23
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=11 w=24
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=12 w=25
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=13 w=26
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=14 w=27
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=15 w=28
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=16 w=29
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=17 w=30
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=18 w=31
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=19 w=32
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=20 w=34
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:498 : EVENT_POLL_DISPATCH_HANDLE: watch=34 events=2
>2013-03-20 11:21:00.661+0000: 14417: debug : virNetMessageFree:73 : msg=0x15891f0 nfds=0 cb=(nil)
>2013-03-20 11:21:00.661+0000: 14417: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x15894c0 tx=(nil)
>2013-03-20 11:21:00.661+0000: 14417: debug : virNetServerClientCalculateHandleMode:184 : mode=1
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=34 events=1
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollInterruptLocked:712 : Skip interrupt, 1 1269381120
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=21 w=68
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=22 w=85
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=23 w=88
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=24 w=90
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollCleanupTimeouts:516 : Cleanup 3
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollCleanupHandles:564 : Cleanup 25
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventRunDefaultImpl:244 : running default event implementation
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollCleanupTimeouts:516 : Cleanup 3
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollCleanupHandles:564 : Cleanup 25
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=0 w=1, f=7 e=1 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=1 w=2, f=9 e=1 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=2 w=3, f=11 e=1 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=3 w=4, f=12 e=1 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=4 w=5, f=13 e=1 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=5 w=6, f=6 e=1 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=6 w=7, f=14 e=1 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=7 w=8, f=15 e=0 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=8 w=9, f=15 e=1 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=9 w=10, f=17 e=1 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=10 w=23, f=21 e=25 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=11 w=24, f=22 e=25 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=12 w=25, f=23 e=25 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=13 w=26, f=25 e=25 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=14 w=27, f=24 e=25 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=15 w=28, f=26 e=25 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=16 w=29, f=27 e=25 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=17 w=30, f=28 e=25 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=18 w=31, f=29 e=25 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=19 w=32, f=30 e=1 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=20 w=34, f=19 e=1 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=21 w=68, f=40 e=25 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=22 w=85, f=41 e=25 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=23 w=88, f=31 e=1 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=24 w=90, f=35 e=1 d=0
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 3 timers
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollRunOnce:629 : EVENT_POLL_RUN: nhandles=24 timeout=-1
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollRunOnce:640 : Poll got 1 event(s)
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchTimeouts:425 : Dispatch 3
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:470 : Dispatch 24
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=0 w=1
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=1 w=2
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=2 w=3
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=3 w=4
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=4 w=5
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=5 w=6
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=6 w=7
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=8 w=9
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=9 w=10
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=10 w=23
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=11 w=24
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=12 w=25
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=13 w=26
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=14 w=27
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=15 w=28
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=16 w=29
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=17 w=30
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=18 w=31
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=19 w=32
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=20 w=34
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:498 : EVENT_POLL_DISPATCH_HANDLE: watch=34 events=1
>2013-03-20 11:21:00.661+0000: 14417: debug : virNetMessageDecodeLength:152 : Got length, now need 80 total (76 more)
>2013-03-20 11:21:00.661+0000: 14417: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x15894c0 tx=(nil)
>2013-03-20 11:21:00.661+0000: 14417: debug : virNetServerClientCalculateHandleMode:184 : mode=1
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=34 events=1
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollInterruptLocked:712 : Skip interrupt, 1 1269381120
>2013-03-20 11:21:00.661+0000: 14417: debug : virNetServerClientDispatchRead:1007 : RPC_SERVER_CLIENT_MSG_RX: client=0x1586150 len=80 prog=536903814 vers=1 proc=20 type=0 status=0 serial=48005
>2013-03-20 11:21:00.661+0000: 14417: debug : virKeepAliveCheckMessage:384 : ka=0x1587af0, client=0x1586150, msg=0x15894c0
>2013-03-20 11:21:00.661+0000: 14417: debug : virObjectRef:168 : OBJECT_REF: obj=0x1586150
>2013-03-20 11:21:00.661+0000: 14417: debug : virNetServerDispatchNewMessage:221 : server=0x1571e60 client=0x1586150 message=0x15894c0
>2013-03-20 11:21:00.661+0000: 14417: debug : virObjectRef:168 : OBJECT_REF: obj=0x15837a0
>2013-03-20 11:21:00.661+0000: 14417: debug : virNetMessageNew:45 : msg=0x15893b0 tracked=1
>2013-03-20 11:21:00.661+0000: 14417: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x15893b0 tx=(nil)
>2013-03-20 11:21:00.661+0000: 14417: debug : virNetServerClientCalculateHandleMode:184 : mode=1
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=34 events=1
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollInterruptLocked:712 : Skip interrupt, 1 1269381120
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=21 w=68
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=22 w=85
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=23 w=88
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollDispatchHandles:484 : i=24 w=90
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollCleanupTimeouts:516 : Cleanup 3
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollCleanupHandles:564 : Cleanup 25
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventRunDefaultImpl:244 : running default event implementation
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollCleanupTimeouts:516 : Cleanup 3
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollCleanupHandles:564 : Cleanup 25
>2013-03-20 11:21:00.661+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=0 w=1, f=7 e=1 d=0
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=1 w=2, f=9 e=1 d=0
>2013-03-20 11:21:00.661+0000: 14425: debug : virNetServerHandleJob:192 : server=0x1571e60 client=0x1586150 message=0x15894c0 prog=0x15837a0
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=2 w=3, f=11 e=1 d=0
>2013-03-20 11:21:00.662+0000: 14425: debug : virNetServerProgramDispatch:284 : prog=536903814 ver=1 type=0 status=0 serial=48005 proc=20
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=3 w=4, f=12 e=1 d=0
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=4 w=5, f=13 e=1 d=0
>2013-03-20 11:21:00.662+0000: 14425: debug : remoteDispatchDomainGetVcpusHelper:2536 : server=0x1571e60 client=0x1586150 msg=0x15894c0 rerr=0x7f6743f1bc40 args=0x7f672800f9b0 ret=0x7f6728005c80
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=5 w=6, f=6 e=1 d=0
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=6 w=7, f=14 e=1 d=0
>2013-03-20 11:21:00.662+0000: 14425: debug : virObjectNew:110 : OBJECT_NEW: obj=0x7f6728014760 classname=virDomain
>2013-03-20 11:21:00.662+0000: 14425: debug : virObjectRef:168 : OBJECT_REF: obj=0x7f67300021f0
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=7 w=8, f=15 e=0 d=0
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=8 w=9, f=15 e=1 d=0
>2013-03-20 11:21:00.662+0000: 14425: debug : virDomainGetVcpus:9321 : dom=0x7f6728014760, (VM: name=instance-0000002c, uuid=1d97d662-3f38-4788-8d55-87ccff19e9b2), info=0x7f67280153d0, maxinfo=1, cpumaps=(nil), maplen=0
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=9 w=10, f=17 e=1 d=0
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=10 w=23, f=21 e=25 d=0
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=11 w=24, f=22 e=25 d=0
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=12 w=25, f=23 e=25 d=0
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=13 w=26, f=25 e=25 d=0
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=14 w=27, f=24 e=25 d=0
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=15 w=28, f=26 e=25 d=0
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=16 w=29, f=27 e=25 d=0
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=17 w=30, f=28 e=25 d=0
>2013-03-20 11:21:00.662+0000: 14425: debug : virFileClose:72 : Closed fd 38
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=18 w=31, f=29 e=25 d=0
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=19 w=32, f=30 e=1 d=0
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=20 w=34, f=19 e=1 d=0
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=21 w=68, f=40 e=25 d=0
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=22 w=85, f=41 e=25 d=0
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=23 w=88, f=31 e=1 d=0
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=24 w=90, f=35 e=1 d=0
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 3 timers
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollRunOnce:629 : EVENT_POLL_RUN: nhandles=24 timeout=-1
>2013-03-20 11:21:00.662+0000: 14425: debug : qemuGetProcessInfo:1430 : Got status for 25760/25861 user=25584 sys=4474 cpu=0 rss=534625
>2013-03-20 11:21:00.662+0000: 14425: debug : virDomainFree:2306 : dom=0x7f6728014760, (VM: name=instance-0000002c, uuid=1d97d662-3f38-4788-8d55-87ccff19e9b2)
>2013-03-20 11:21:00.662+0000: 14425: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7f6728014760
>2013-03-20 11:21:00.662+0000: 14425: debug : virObjectUnref:137 : OBJECT_DISPOSE: obj=0x7f6728014760
>2013-03-20 11:21:00.662+0000: 14425: debug : virDomainDispose:225 : release domain 0x7f6728014760 instance-0000002c 1d97d662-3f38-4788-8d55-87ccff19e9b2
>2013-03-20 11:21:00.662+0000: 14425: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7f67300021f0
>2013-03-20 11:21:00.662+0000: 14425: debug : virNetMessageEncodePayload:358 : Encode length as 56
>2013-03-20 11:21:00.662+0000: 14425: debug : virNetServerClientSendMessageLocked:1251 : msg=0x15894c0 proc=20 len=56 offset=0
>2013-03-20 11:21:00.662+0000: 14425: debug : virNetServerClientSendMessageLocked:1259 : RPC_SERVER_CLIENT_MSG_TX_QUEUE: client=0x1586150 len=56 prog=536903814 vers=1 proc=20 type=1 status=0 serial=48005
>2013-03-20 11:21:00.662+0000: 14425: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x15893b0 tx=0x15894c0
>2013-03-20 11:21:00.662+0000: 14425: debug : virNetServerClientCalculateHandleMode:184 : mode=3
>2013-03-20 11:21:00.662+0000: 14425: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=34 events=3
>2013-03-20 11:21:00.662+0000: 14425: debug : virEventPollInterruptLocked:716 : Interrupting
>2013-03-20 11:21:00.662+0000: 14425: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x15837a0
>2013-03-20 11:21:00.662+0000: 14425: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x1586150
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollRunOnce:640 : Poll got 1 event(s)
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollDispatchTimeouts:425 : Dispatch 3
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollDispatchHandles:470 : Dispatch 24
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollDispatchHandles:484 : i=0 w=1
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollDispatchHandles:498 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollDispatchHandles:484 : i=1 w=2
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollDispatchHandles:484 : i=2 w=3
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollDispatchHandles:484 : i=3 w=4
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollDispatchHandles:484 : i=4 w=5
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollDispatchHandles:484 : i=5 w=6
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollDispatchHandles:484 : i=6 w=7
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollDispatchHandles:484 : i=8 w=9
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollDispatchHandles:484 : i=9 w=10
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollDispatchHandles:484 : i=10 w=23
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollDispatchHandles:484 : i=11 w=24
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollDispatchHandles:484 : i=12 w=25
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollDispatchHandles:484 : i=13 w=26
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollDispatchHandles:484 : i=14 w=27
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollDispatchHandles:484 : i=15 w=28
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollDispatchHandles:484 : i=16 w=29
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollDispatchHandles:484 : i=17 w=30
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollDispatchHandles:484 : i=18 w=31
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollDispatchHandles:484 : i=19 w=32
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollDispatchHandles:484 : i=20 w=34
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollDispatchHandles:484 : i=21 w=68
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollDispatchHandles:484 : i=22 w=85
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollDispatchHandles:484 : i=23 w=88
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollDispatchHandles:484 : i=24 w=90
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollCleanupTimeouts:516 : Cleanup 3
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollCleanupHandles:564 : Cleanup 25
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventRunDefaultImpl:244 : running default event implementation
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollCleanupTimeouts:516 : Cleanup 3
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollCleanupHandles:564 : Cleanup 25
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=0 w=1, f=7 e=1 d=0
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=1 w=2, f=9 e=1 d=0
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=2 w=3, f=11 e=1 d=0
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=3 w=4, f=12 e=1 d=0
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=4 w=5, f=13 e=1 d=0
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=5 w=6, f=6 e=1 d=0
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=6 w=7, f=14 e=1 d=0
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=7 w=8, f=15 e=0 d=0
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=8 w=9, f=15 e=1 d=0
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=9 w=10, f=17 e=1 d=0
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=10 w=23, f=21 e=25 d=0
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=11 w=24, f=22 e=25 d=0
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=12 w=25, f=23 e=25 d=0
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=13 w=26, f=25 e=25 d=0
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=14 w=27, f=24 e=25 d=0
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=15 w=28, f=26 e=25 d=0
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=16 w=29, f=27 e=25 d=0
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=17 w=30, f=28 e=25 d=0
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=18 w=31, f=29 e=25 d=0
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=19 w=32, f=30 e=1 d=0
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=20 w=34, f=19 e=5 d=0
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=21 w=68, f=40 e=25 d=0
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=22 w=85, f=41 e=25 d=0
>2013-03-20 11:21:00.662+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=23 w=88, f=31 e=1 d=0
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=24 w=90, f=35 e=1 d=0
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 3 timers
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollRunOnce:629 : EVENT_POLL_RUN: nhandles=24 timeout=-1
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollRunOnce:640 : Poll got 1 event(s)
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchTimeouts:425 : Dispatch 3
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:470 : Dispatch 24
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=0 w=1
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=1 w=2
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=2 w=3
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=3 w=4
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=4 w=5
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=5 w=6
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=6 w=7
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=8 w=9
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=9 w=10
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=10 w=23
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=11 w=24
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=12 w=25
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=13 w=26
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=14 w=27
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=15 w=28
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=16 w=29
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=17 w=30
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=18 w=31
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=19 w=32
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=20 w=34
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:498 : EVENT_POLL_DISPATCH_HANDLE: watch=34 events=2
>2013-03-20 11:21:00.663+0000: 14417: debug : virNetMessageFree:73 : msg=0x15894c0 nfds=0 cb=(nil)
>2013-03-20 11:21:00.663+0000: 14417: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x15893b0 tx=(nil)
>2013-03-20 11:21:00.663+0000: 14417: debug : virNetServerClientCalculateHandleMode:184 : mode=1
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=34 events=1
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollInterruptLocked:712 : Skip interrupt, 1 1269381120
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=21 w=68
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=22 w=85
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=23 w=88
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=24 w=90
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollCleanupTimeouts:516 : Cleanup 3
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollCleanupHandles:564 : Cleanup 25
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventRunDefaultImpl:244 : running default event implementation
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollCleanupTimeouts:516 : Cleanup 3
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollCleanupHandles:564 : Cleanup 25
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=0 w=1, f=7 e=1 d=0
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=1 w=2, f=9 e=1 d=0
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=2 w=3, f=11 e=1 d=0
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=3 w=4, f=12 e=1 d=0
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=4 w=5, f=13 e=1 d=0
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=5 w=6, f=6 e=1 d=0
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=6 w=7, f=14 e=1 d=0
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=7 w=8, f=15 e=0 d=0
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=8 w=9, f=15 e=1 d=0
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=9 w=10, f=17 e=1 d=0
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=10 w=23, f=21 e=25 d=0
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=11 w=24, f=22 e=25 d=0
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=12 w=25, f=23 e=25 d=0
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=13 w=26, f=25 e=25 d=0
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=14 w=27, f=24 e=25 d=0
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=15 w=28, f=26 e=25 d=0
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=16 w=29, f=27 e=25 d=0
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=17 w=30, f=28 e=25 d=0
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=18 w=31, f=29 e=25 d=0
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=19 w=32, f=30 e=1 d=0
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=20 w=34, f=19 e=1 d=0
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=21 w=68, f=40 e=25 d=0
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=22 w=85, f=41 e=25 d=0
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=23 w=88, f=31 e=1 d=0
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=24 w=90, f=35 e=1 d=0
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 3 timers
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollRunOnce:629 : EVENT_POLL_RUN: nhandles=24 timeout=-1
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollRunOnce:640 : Poll got 1 event(s)
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchTimeouts:425 : Dispatch 3
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:470 : Dispatch 24
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=0 w=1
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=1 w=2
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=2 w=3
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=3 w=4
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=4 w=5
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=5 w=6
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=6 w=7
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=8 w=9
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=9 w=10
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=10 w=23
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=11 w=24
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=12 w=25
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=13 w=26
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=14 w=27
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=15 w=28
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=16 w=29
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=17 w=30
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=18 w=31
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=19 w=32
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=20 w=34
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:498 : EVENT_POLL_DISPATCH_HANDLE: watch=34 events=1
>2013-03-20 11:21:00.663+0000: 14417: debug : virNetMessageDecodeLength:152 : Got length, now need 72 total (68 more)
>2013-03-20 11:21:00.663+0000: 14417: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x15893b0 tx=(nil)
>2013-03-20 11:21:00.663+0000: 14417: debug : virNetServerClientCalculateHandleMode:184 : mode=1
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=34 events=1
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollInterruptLocked:712 : Skip interrupt, 1 1269381120
>2013-03-20 11:21:00.663+0000: 14417: debug : virNetServerClientDispatchRead:1007 : RPC_SERVER_CLIENT_MSG_RX: client=0x1586150 len=72 prog=536903814 vers=1 proc=16 type=0 status=0 serial=48006
>2013-03-20 11:21:00.663+0000: 14417: debug : virKeepAliveCheckMessage:384 : ka=0x1587af0, client=0x1586150, msg=0x15893b0
>2013-03-20 11:21:00.663+0000: 14417: debug : virObjectRef:168 : OBJECT_REF: obj=0x1586150
>2013-03-20 11:21:00.663+0000: 14417: debug : virNetServerDispatchNewMessage:221 : server=0x1571e60 client=0x1586150 message=0x15893b0
>2013-03-20 11:21:00.663+0000: 14417: debug : virObjectRef:168 : OBJECT_REF: obj=0x15837a0
>2013-03-20 11:21:00.663+0000: 14417: debug : virNetMessageNew:45 : msg=0x1587190 tracked=1
>2013-03-20 11:21:00.663+0000: 14417: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x1587190 tx=(nil)
>2013-03-20 11:21:00.663+0000: 14417: debug : virNetServerClientCalculateHandleMode:184 : mode=1
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=34 events=1
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollInterruptLocked:712 : Skip interrupt, 1 1269381120
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=21 w=68
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=22 w=85
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=23 w=88
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollDispatchHandles:484 : i=24 w=90
>2013-03-20 11:21:00.663+0000: 14420: debug : virNetServerHandleJob:192 : server=0x1571e60 client=0x1586150 message=0x15893b0 prog=0x15837a0
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollCleanupTimeouts:516 : Cleanup 3
>2013-03-20 11:21:00.663+0000: 14420: debug : virNetServerProgramDispatch:284 : prog=536903814 ver=1 type=0 status=0 serial=48006 proc=16
>2013-03-20 11:21:00.663+0000: 14420: debug : remoteDispatchDomainGetInfoHelper:1962 : server=0x1571e60 client=0x1586150 msg=0x15893b0 rerr=0x7f6746720c40 args=0x7f67302364f0 ret=0x7f67301d6090
>2013-03-20 11:21:00.663+0000: 14420: debug : virObjectNew:110 : OBJECT_NEW: obj=0x7f673022ee80 classname=virDomain
>2013-03-20 11:21:00.663+0000: 14420: debug : virObjectRef:168 : OBJECT_REF: obj=0x7f67300021f0
>2013-03-20 11:21:00.663+0000: 14417: debug : virEventPollCleanupHandles:564 : Cleanup 25
>2013-03-20 11:21:00.664+0000: 14420: debug : virDomainGetInfo:4214 : dom=0x7f673022ee80, (VM: name=instance-00000022, uuid=39a366a5-f85c-4fe5-a636-8e37aaf1d347), info=0x7f6746720b30
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventRunDefaultImpl:244 : running default event implementation
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollCleanupTimeouts:516 : Cleanup 3
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollCleanupHandles:564 : Cleanup 25
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=0 w=1, f=7 e=1 d=0
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=1 w=2, f=9 e=1 d=0
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=2 w=3, f=11 e=1 d=0
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=3 w=4, f=12 e=1 d=0
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=4 w=5, f=13 e=1 d=0
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=5 w=6, f=6 e=1 d=0
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=6 w=7, f=14 e=1 d=0
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=7 w=8, f=15 e=0 d=0
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=8 w=9, f=15 e=1 d=0
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=9 w=10, f=17 e=1 d=0
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=10 w=23, f=21 e=25 d=0
>2013-03-20 11:21:00.664+0000: 14420: debug : qemuGetProcessInfo:1430 : Got status for 20046/0 user=188408 sys=29042 cpu=1 rss=538760
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=11 w=24, f=22 e=25 d=0
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=12 w=25, f=23 e=25 d=0
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=13 w=26, f=25 e=25 d=0
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=14 w=27, f=24 e=25 d=0
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=15 w=28, f=26 e=25 d=0
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=16 w=29, f=27 e=25 d=0
>2013-03-20 11:21:00.664+0000: 14420: debug : virDomainFree:2306 : dom=0x7f673022ee80, (VM: name=instance-00000022, uuid=39a366a5-f85c-4fe5-a636-8e37aaf1d347)
>2013-03-20 11:21:00.664+0000: 14420: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7f673022ee80
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=17 w=30, f=28 e=25 d=0
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=18 w=31, f=29 e=25 d=0
>2013-03-20 11:21:00.664+0000: 14420: debug : virObjectUnref:137 : OBJECT_DISPOSE: obj=0x7f673022ee80
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=19 w=32, f=30 e=1 d=0
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=20 w=34, f=19 e=1 d=0
>2013-03-20 11:21:00.664+0000: 14420: debug : virDomainDispose:225 : release domain 0x7f673022ee80 instance-00000022 39a366a5-f85c-4fe5-a636-8e37aaf1d347
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=21 w=68, f=40 e=25 d=0
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=22 w=85, f=41 e=25 d=0
>2013-03-20 11:21:00.664+0000: 14420: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x7f67300021f0
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=23 w=88, f=31 e=1 d=0
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=24 w=90, f=35 e=1 d=0
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 3 timers
>2013-03-20 11:21:00.664+0000: 14420: debug : virNetMessageEncodePayload:358 : Encode length as 60
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollCalculateTimeout:361 : Timeout at 0 due in -1 ms
>2013-03-20 11:21:00.664+0000: 14420: debug : virNetServerClientSendMessageLocked:1251 : msg=0x15893b0 proc=16 len=60 offset=0
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollRunOnce:629 : EVENT_POLL_RUN: nhandles=24 timeout=-1
>2013-03-20 11:21:00.664+0000: 14420: debug : virNetServerClientSendMessageLocked:1259 : RPC_SERVER_CLIENT_MSG_TX_QUEUE: client=0x1586150 len=60 prog=536903814 vers=1 proc=16 type=1 status=0 serial=48006
>2013-03-20 11:21:00.664+0000: 14420: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x1587190 tx=0x15893b0
>2013-03-20 11:21:00.664+0000: 14420: debug : virNetServerClientCalculateHandleMode:184 : mode=3
>2013-03-20 11:21:00.664+0000: 14420: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=34 events=3
>2013-03-20 11:21:00.664+0000: 14420: debug : virEventPollInterruptLocked:716 : Interrupting
>2013-03-20 11:21:00.664+0000: 14420: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x15837a0
>2013-03-20 11:21:00.664+0000: 14420: debug : virObjectUnref:135 : OBJECT_UNREF: obj=0x1586150
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollRunOnce:640 : Poll got 1 event(s)
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollDispatchTimeouts:425 : Dispatch 3
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollDispatchHandles:470 : Dispatch 24
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollDispatchHandles:484 : i=0 w=1
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollDispatchHandles:498 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollDispatchHandles:484 : i=1 w=2
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollDispatchHandles:484 : i=2 w=3
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollDispatchHandles:484 : i=3 w=4
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollDispatchHandles:484 : i=4 w=5
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollDispatchHandles:484 : i=5 w=6
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollDispatchHandles:484 : i=6 w=7
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollDispatchHandles:484 : i=8 w=9
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollDispatchHandles:484 : i=9 w=10
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollDispatchHandles:484 : i=10 w=23
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollDispatchHandles:484 : i=11 w=24
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollDispatchHandles:484 : i=12 w=25
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollDispatchHandles:484 : i=13 w=26
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollDispatchHandles:484 : i=14 w=27
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollDispatchHandles:484 : i=15 w=28
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollDispatchHandles:484 : i=16 w=29
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollDispatchHandles:484 : i=17 w=30
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollDispatchHandles:484 : i=18 w=31
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollDispatchHandles:484 : i=19 w=32
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollDispatchHandles:484 : i=20 w=34
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollDispatchHandles:484 : i=21 w=68
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollDispatchHandles:484 : i=22 w=85
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollDispatchHandles:484 : i=23 w=88
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollDispatchHandles:484 : i=24 w=90
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollCleanupTimeouts:516 : Cleanup 3
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollCleanupHandles:564 : Cleanup 25
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventRunDefaultImpl:244 : running default event implementation
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollCleanupTimeouts:516 : Cleanup 3
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollCleanupHandles:564 : Cleanup 25
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=0 w=1, f=7 e=1 d=0
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=1 w=2, f=9 e=1 d=0
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=2 w=3, f=11 e=1 d=0
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=3 w=4, f=12 e=1 d=0
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=4 w=5, f=13 e=1 d=0
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=5 w=6, f=6 e=1 d=0
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=6 w=7, f=14 e=1 d=0
>2013-03-20 11:21:00.664+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=7 w=8, f=15 e=0 d=0
>2013-03-20 11:21:00.665+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=8 w=9, f=15 e=1 d=0
>2013-03-20 11:21:00.665+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=9 w=10, f=17 e=1 d=0
>2013-03-20 11:21:00.665+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=10 w=23, f=21 e=25 d=0
>2013-03-20 11:21:00.665+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=11 w=24, f=22 e=25 d=0
>2013-03-20 11:21:00.665+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=12 w=25, f=23 e=25 d=0
>2013-03-20 11:21:00.665+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=13 w=26, f=25 e=25 d=0
>2013-03-20 11:21:00.665+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=14 w=27, f=24 e=25 d=0
>2013-03-20 11:21:00.665+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=15 w=28, f=26 e=25 d=0
>2013-03-20 11:21:00.665+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=16 w=29, f=27 e=25 d=0
>2013-03-20 11:21:00.665+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=17 w=30, f=28 e=25 d=0
>2013-03-20 11:21:00.665+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=18 w=31, f=29 e=25 d=0
>2013-03-20 11:21:00.665+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=19 w=32, f=30 e=1 d=0
>2013-03-20 11:21:00.665+0000: 14417: debug : virEventPollMakePollFDs:393 : Prepare n=20 w=34, f=19 e=5 d=0

Actions: View

Attachments on bug 924054: 713588