- Devel - libvirt List Archives

[libvirt] 1.2.0 segfault on Centos 6
by Franky Van Liedekerke 20 Feb '14

20 Feb '14

Hi, using libvirt 1.2.0 on a up-to-date Centos6.5 machine leads to occasional segmentation faults (see below). Sometimes it runs for 5 minutes, sometimes for an hour, but after that the result is always the same: segfault after some weird qom-list, that apparently the qemu version on centos doesn't know. Has 1.2.1 a known fix for this? Franky (debug log of last crash is below the dotted line) ------------------------------------------------- 2014-02-04 15:50:27.351+0000: 9082: error : qemuMonitorJSONCheckError:354 : internal error: unable to execute QEMU command 'qom-list': The command qom-list has not been found Caught Segmentation violation dumping internal log buffer: ====== start of log ===== +0000: 9084: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fac58000ac0 2014-02-04 15:50:27.347+0000: 9084: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fac58000ac0 2014-02-04 15:50:27.347+0000: 9081: debug : virEventRunDefaultImpl:271 : running default event implementation 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollCleanupTimeouts:517 : Cleanup 5 2014-02-04 15:50:27.347+0000: 9084: debug : remoteDispatchDomainLookupByNameHelper:4965 : server=0x7fac7ce77ae0 client=0x7fac7ce86610 msg=0x7fac7ce827f0 rerr=0x7fac6c5b3bc0 args=0x7fac40002730 ret=0x7fac40002790 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollCleanupHandles:565 : Cleanup 15 2014-02-04 15:50:27.347+0000: 9084: debug : virDomainLookupByName:2269 : conn=0x7fac340018a0, name=bqafm0001ap.frm.meshcore.net 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=0 w=1, f=5 e=1 d=0 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=1 w=2, f=7 e=1 d=0 2014-02-04 15:50:27.347+0000: 9084: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fac7ce760b0 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=2 w=3, f=12 e=1 d=0 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=3 w=4, f=13 e=1 d=0 2014-02-04 15:50:27.347+0000: 9084: debug : virAccessManagerCheckDomain:231 : manager=0x7fac7ce760b0(name=stack) driver=QEMU domain=0x7fac5c2386c0 perm=0 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=4 w=5, f=14 e=1 d=0 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=5 w=6, f=15 e=1 d=0 2014-02-04 15:50:27.347+0000: 9084: debug : virAccessManagerCheckDomain:231 : manager=0x7fac7ce776f0(name=none) driver=QEMU domain=0x7fac5c2386c0 perm=0 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=6 w=7, f=16 e=1 d=0 2014-02-04 15:50:27.347+0000: 9084: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fac7ce760b0 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=7 w=8, f=17 e=1 d=0 2014-02-04 15:50:27.347+0000: 9084: debug : virObjectNew:199 : OBJECT_NEW: obj=0x7fac40002750 classname=virDomain 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=8 w=9, f=19 e=1 d=0 2014-02-04 15:50:27.347+0000: 9084: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fac340018a0 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=9 w=10, f=23 e=25 d=0 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=10 w=11, f=25 e=25 d=0 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=11 w=12, f=24 e=25 d=0 2014-02-04 15:50:27.347+0000: 9084: debug : virDomainFree:2433 : dom=0x7fac40002750, (VM: name=bqafm0001ap.frm.meshcore.net, uuid=3b009e73-e095-29fa-8970-f5c2b647d5a0) 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=12 w=13, f=26 e=25 d=0 2014-02-04 15:50:27.347+0000: 9084: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fac40002750 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=13 w=14, f=27 e=1 d=0 2014-02-04 15:50:27.347+0000: 9084: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7fac40002750 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=14 w=58, f=28 e=1 d=0 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 5 timers 2014-02-04 15:50:27.347+0000: 9084: debug : virDomainDispose:264 : release domain 0x7fac40002750 bqafm0001ap.frm.meshcore.net 3b009e73-e095-29fa-8970-f5c2b647d5a0 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1391529031312 2014-02-04 15:50:27.347+0000: 9084: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fac340018a0 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1391529032347 2014-02-04 15:50:27.347+0000: 9084: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fac58000ac0 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollCalculateTimeout:353 : Schedule timeout then=1391529031312 now=1391529027347 2014-02-04 15:50:27.347+0000: 9084: debug : virNetMessageEncodePayload:374 : Encode length as 80 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollCalculateTimeout:362 : Timeout at 1391529031312 due in 3965 ms 2014-02-04 15:50:27.347+0000: 9084: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fac58000ac0 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollRunOnce:630 : EVENT_POLL_RUN: nhandles=15 timeout=3965 2014-02-04 15:50:27.347+0000: 9084: debug : virNetServerClientSendMessageLocked:1451 : msg=0x7fac7ce827f0 proc=23 len=80 offset=0 2014-02-04 15:50:27.347+0000: 9084: debug : virNetServerClientSendMessageLocked:1459 : RPC_SERVER_CLIENT_MSG_TX_QUEUE: client=0x7fac7ce86610 len=80 prog=536903814 vers=1 proc=23 type=1 status=0 serial=4 2014-02-04 15:50:27.347+0000: 9084: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7fac7ce86c80 tx=0x7fac7ce827f0 2014-02-04 15:50:27.347+0000: 9084: debug : virNetServerClientCalculateHandleMode:188 : mode=3 2014-02-04 15:50:27.347+0000: 9084: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=58 events=3 2014-02-04 15:50:27.347+0000: 9084: debug : virEventPollInterruptLocked:717 : Interrupting 2014-02-04 15:50:27.347+0000: 9084: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fac7ce80030 2014-02-04 15:50:27.347+0000: 9084: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fac7ce86610 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollRunOnce:641 : Poll got 1 event(s) 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollDispatchTimeouts:426 : Dispatch 5 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollDispatchHandles:471 : Dispatch 15 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollDispatchHandles:485 : i=0 w=1 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollDispatchHandles:499 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollDispatchHandles:485 : i=1 w=2 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollDispatchHandles:485 : i=2 w=3 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollDispatchHandles:485 : i=3 w=4 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollDispatchHandles:485 : i=4 w=5 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollDispatchHandles:485 : i=5 w=6 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollDispatchHandles:485 : i=6 w=7 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollDispatchHandles:485 : i=7 w=8 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollDispatchHandles:485 : i=8 w=9 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollDispatchHandles:485 : i=9 w=10 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollDispatchHandles:485 : i=10 w=11 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollDispatchHandles:485 : i=11 w=12 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollDispatchHandles:485 : i=12 w=13 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollDispatchHandles:485 : i=13 w=14 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollDispatchHandles:485 : i=14 w=58 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollCleanupTimeouts:517 : Cleanup 5 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollCleanupHandles:565 : Cleanup 15 2014-02-04 15:50:27.347+0000: 9081: debug : virEventRunDefaultImpl:271 : running default event implementation 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollCleanupTimeouts:517 : Cleanup 5 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollCleanupHandles:565 : Cleanup 15 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=0 w=1, f=5 e=1 d=0 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=1 w=2, f=7 e=1 d=0 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=2 w=3, f=12 e=1 d=0 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=3 w=4, f=13 e=1 d=0 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=4 w=5, f=14 e=1 d=0 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=5 w=6, f=15 e=1 d=0 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=6 w=7, f=16 e=1 d=0 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=7 w=8, f=17 e=1 d=0 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=8 w=9, f=19 e=1 d=0 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=9 w=10, f=23 e=25 d=0 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=10 w=11, f=25 e=25 d=0 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=11 w=12, f=24 e=25 d=0 2014-02-04 15:50:27.347+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=12 w=13, f=26 e=25 d=0 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=13 w=14, f=27 e=1 d=0 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=14 w=58, f=28 e=5 d=0 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 5 timers 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1391529031312 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1391529032347 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollCalculateTimeout:353 : Schedule timeout then=1391529031312 now=1391529027348 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollCalculateTimeout:362 : Timeout at 1391529031312 due in 3964 ms 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollRunOnce:630 : EVENT_POLL_RUN: nhandles=15 timeout=3964 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollRunOnce:641 : Poll got 1 event(s) 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchTimeouts:426 : Dispatch 5 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:471 : Dispatch 15 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:485 : i=0 w=1 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:485 : i=1 w=2 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:485 : i=2 w=3 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:485 : i=3 w=4 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:485 : i=4 w=5 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:485 : i=5 w=6 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:485 : i=6 w=7 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:485 : i=7 w=8 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:485 : i=8 w=9 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:485 : i=9 w=10 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:485 : i=10 w=11 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:485 : i=11 w=12 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:485 : i=12 w=13 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:485 : i=13 w=14 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:485 : i=14 w=58 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:499 : EVENT_POLL_DISPATCH_HANDLE: watch=58 events=2 2014-02-04 15:50:27.348+0000: 9081: debug : virNetMessageFree:72 : msg=0x7fac7ce827f0 nfds=0 cb=(nil) 2014-02-04 15:50:27.348+0000: 9081: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7fac7ce86c80 tx=(nil) 2014-02-04 15:50:27.348+0000: 9081: debug : virNetServerClientCalculateHandleMode:188 : mode=1 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=58 events=1 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollInterruptLocked:713 : Skip interrupt, 1 140378773645312 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollCleanupTimeouts:517 : Cleanup 5 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollCleanupHandles:565 : Cleanup 15 2014-02-04 15:50:27.348+0000: 9081: debug : virEventRunDefaultImpl:271 : running default event implementation 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollCleanupTimeouts:517 : Cleanup 5 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollCleanupHandles:565 : Cleanup 15 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=0 w=1, f=5 e=1 d=0 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=1 w=2, f=7 e=1 d=0 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=2 w=3, f=12 e=1 d=0 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=3 w=4, f=13 e=1 d=0 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=4 w=5, f=14 e=1 d=0 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=5 w=6, f=15 e=1 d=0 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=6 w=7, f=16 e=1 d=0 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=7 w=8, f=17 e=1 d=0 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=8 w=9, f=19 e=1 d=0 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=9 w=10, f=23 e=25 d=0 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=10 w=11, f=25 e=25 d=0 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=11 w=12, f=24 e=25 d=0 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=12 w=13, f=26 e=25 d=0 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=13 w=14, f=27 e=1 d=0 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=14 w=58, f=28 e=1 d=0 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 5 timers 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1391529031312 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1391529032347 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollCalculateTimeout:353 : Schedule timeout then=1391529031312 now=1391529027348 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollCalculateTimeout:362 : Timeout at 1391529031312 due in 3964 ms 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollRunOnce:630 : EVENT_POLL_RUN: nhandles=15 timeout=3964 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollRunOnce:641 : Poll got 1 event(s) 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchTimeouts:426 : Dispatch 5 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:471 : Dispatch 15 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:485 : i=0 w=1 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:485 : i=1 w=2 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:485 : i=2 w=3 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:485 : i=3 w=4 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:485 : i=4 w=5 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:485 : i=5 w=6 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:485 : i=6 w=7 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:485 : i=7 w=8 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:485 : i=8 w=9 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:485 : i=9 w=10 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:485 : i=10 w=11 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:485 : i=11 w=12 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:485 : i=12 w=13 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:485 : i=13 w=14 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:485 : i=14 w=58 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:499 : EVENT_POLL_DISPATCH_HANDLE: watch=58 events=1 2014-02-04 15:50:27.348+0000: 9081: debug : virNetMessageDecodeLength:149 : Got length, now need 80 total (76 more) 2014-02-04 15:50:27.348+0000: 9081: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7fac7ce86c80 tx=(nil) 2014-02-04 15:50:27.348+0000: 9081: debug : virNetServerClientCalculateHandleMode:188 : mode=1 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=58 events=1 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollInterruptLocked:713 : Skip interrupt, 1 140378773645312 2014-02-04 15:50:27.348+0000: 9081: debug : virNetServerClientDispatchRead:1202 : RPC_SERVER_CLIENT_MSG_RX: client=0x7fac7ce86610 len=80 prog=536903814 vers=1 proc=150 type=0 status=0 serial=5 2014-02-04 15:50:27.348+0000: 9081: debug : virKeepAliveCheckMessage:374 : ka=0x7fac7ce86d60, client=0x7fac7ce86610, msg=0x7fac7ce86c80 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollUpdateTimeout:260 : EVENT_POLL_UPDATE_TIMEOUT: timer=59 frequency=5000 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollUpdateTimeout:278 : Set timer freq=5000 expires=1391529032348 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollInterruptLocked:713 : Skip interrupt, 1 140378773645312 2014-02-04 15:50:27.348+0000: 9081: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fac7ce86610 2014-02-04 15:50:27.348+0000: 9081: debug : virNetServerDispatchNewMessage:213 : server=0x7fac7ce77ae0 client=0x7fac7ce86610 message=0x7fac7ce86c80 2014-02-04 15:50:27.348+0000: 9081: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fac7ce80030 2014-02-04 15:50:27.348+0000: 9081: debug : virNetMessageNew:44 : msg=0x7fac7ce86e60 tracked=1 2014-02-04 15:50:27.348+0000: 9081: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7fac7ce86e60 tx=(nil) 2014-02-04 15:50:27.348+0000: 9083: debug : virNetServerHandleJob:184 : server=0x7fac7ce77ae0 client=0x7fac7ce86610 message=0x7fac7ce86c80 prog=0x7fac7ce80030 2014-02-04 15:50:27.348+0000: 9081: debug : virNetServerClientCalculateHandleMode:188 : mode=1 2014-02-04 15:50:27.348+0000: 9083: debug : virNetServerProgramDispatch:285 : prog=536903814 ver=1 type=0 status=0 serial=5 proc=150 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=58 events=1 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollInterruptLocked:713 : Skip interrupt, 1 140378773645312 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollCleanupTimeouts:517 : Cleanup 5 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollCleanupHandles:565 : Cleanup 15 2014-02-04 15:50:27.348+0000: 9083: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fac58000ac0 2014-02-04 15:50:27.348+0000: 9081: debug : virEventRunDefaultImpl:271 : running default event implementation 2014-02-04 15:50:27.348+0000: 9083: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fac58000ac0 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollCleanupTimeouts:517 : Cleanup 5 2014-02-04 15:50:27.348+0000: 9083: debug : remoteDispatchDomainIsActiveHelper:4723 : server=0x7fac7ce77ae0 client=0x7fac7ce86610 msg=0x7fac7ce86c80 rerr=0x7fac6cfb4bc0 args=0x7fac50000970 ret=0x7fac50000910 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollCleanupHandles:565 : Cleanup 15 2014-02-04 15:50:27.348+0000: 9083: debug : virObjectNew:199 : OBJECT_NEW: obj=0x7fac50000930 classname=virDomain 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=0 w=1, f=5 e=1 d=0 2014-02-04 15:50:27.348+0000: 9083: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fac340018a0 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=1 w=2, f=7 e=1 d=0 2014-02-04 15:50:27.348+0000: 9083: debug : virDomainIsActive:17649 : dom=0x7fac50000930 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=2 w=3, f=12 e=1 d=0 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=3 w=4, f=13 e=1 d=0 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=4 w=5, f=14 e=1 d=0 2014-02-04 15:50:27.348+0000: 9083: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fac7ce760b0 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=5 w=6, f=15 e=1 d=0 2014-02-04 15:50:27.348+0000: 9083: debug : virAccessManagerCheckDomain:231 : manager=0x7fac7ce760b0(name=stack) driver=QEMU domain=0x7fac5c2386c0 perm=1 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=6 w=7, f=16 e=1 d=0 2014-02-04 15:50:27.348+0000: 9083: debug : virAccessManagerCheckDomain:231 : manager=0x7fac7ce776f0(name=none) driver=QEMU domain=0x7fac5c2386c0 perm=1 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=7 w=8, f=17 e=1 d=0 2014-02-04 15:50:27.348+0000: 9083: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fac7ce760b0 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=8 w=9, f=19 e=1 d=0 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=9 w=10, f=23 e=25 d=0 2014-02-04 15:50:27.348+0000: 9083: debug : virDomainFree:2433 : dom=0x7fac50000930, (VM: name=bqafm0001ap.frm.meshcore.net, uuid=3b009e73-e095-29fa-8970-f5c2b647d5a0) 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=10 w=11, f=25 e=25 d=0 2014-02-04 15:50:27.348+0000: 9083: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fac50000930 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=11 w=12, f=24 e=25 d=0 2014-02-04 15:50:27.348+0000: 9083: debug : virObjectUnref:258 : OBJECT_DISPOSE: obj=0x7fac50000930 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=12 w=13, f=26 e=25 d=0 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=13 w=14, f=27 e=1 d=0 2014-02-04 15:50:27.348+0000: 9083: debug : virDomainDispose:264 : release domain 0x7fac50000930 bqafm0001ap.frm.meshcore.net 3b009e73-e095-29fa-8970-f5c2b647d5a0 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=14 w=58, f=28 e=1 d=0 2014-02-04 15:50:27.348+0000: 9083: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fac340018a0 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 5 timers 2014-02-04 15:50:27.348+0000: 9083: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fac58000ac0 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1391529031312 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1391529032348 2014-02-04 15:50:27.348+0000: 9083: debug : virNetMessageEncodePayload:374 : Encode length as 32 2014-02-04 15:50:27.348+0000: 9083: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fac58000ac0 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollCalculateTimeout:353 : Schedule timeout then=1391529031312 now=1391529027348 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollCalculateTimeout:362 : Timeout at 1391529031312 due in 3964 ms 2014-02-04 15:50:27.348+0000: 9083: debug : virNetServerClientSendMessageLocked:1451 : msg=0x7fac7ce86c80 proc=150 len=32 offset=0 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollRunOnce:630 : EVENT_POLL_RUN: nhandles=15 timeout=3964 2014-02-04 15:50:27.348+0000: 9083: debug : virNetServerClientSendMessageLocked:1459 : RPC_SERVER_CLIENT_MSG_TX_QUEUE: client=0x7fac7ce86610 len=32 prog=536903814 vers=1 proc=150 type=1 status=0 serial=5 2014-02-04 15:50:27.348+0000: 9083: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7fac7ce86e60 tx=0x7fac7ce86c80 2014-02-04 15:50:27.348+0000: 9083: debug : virNetServerClientCalculateHandleMode:188 : mode=3 2014-02-04 15:50:27.348+0000: 9083: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=58 events=3 2014-02-04 15:50:27.348+0000: 9083: debug : virEventPollInterruptLocked:717 : Interrupting 2014-02-04 15:50:27.348+0000: 9083: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fac7ce80030 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollRunOnce:641 : Poll got 1 event(s) 2014-02-04 15:50:27.348+0000: 9083: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fac7ce86610 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchTimeouts:426 : Dispatch 5 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:471 : Dispatch 15 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:485 : i=0 w=1 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:499 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:485 : i=1 w=2 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:485 : i=2 w=3 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:485 : i=3 w=4 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:485 : i=4 w=5 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:485 : i=5 w=6 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:485 : i=6 w=7 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:485 : i=7 w=8 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:485 : i=8 w=9 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:485 : i=9 w=10 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:485 : i=10 w=11 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:485 : i=11 w=12 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:485 : i=12 w=13 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:485 : i=13 w=14 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:485 : i=14 w=58 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollCleanupTimeouts:517 : Cleanup 5 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollCleanupHandles:565 : Cleanup 15 2014-02-04 15:50:27.348+0000: 9081: debug : virEventRunDefaultImpl:271 : running default event implementation 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollCleanupTimeouts:517 : Cleanup 5 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollCleanupHandles:565 : Cleanup 15 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=0 w=1, f=5 e=1 d=0 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=1 w=2, f=7 e=1 d=0 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=2 w=3, f=12 e=1 d=0 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=3 w=4, f=13 e=1 d=0 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=4 w=5, f=14 e=1 d=0 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=5 w=6, f=15 e=1 d=0 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=6 w=7, f=16 e=1 d=0 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=7 w=8, f=17 e=1 d=0 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=8 w=9, f=19 e=1 d=0 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=9 w=10, f=23 e=25 d=0 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=10 w=11, f=25 e=25 d=0 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=11 w=12, f=24 e=25 d=0 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=12 w=13, f=26 e=25 d=0 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=13 w=14, f=27 e=1 d=0 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=14 w=58, f=28 e=5 d=0 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 5 timers 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1391529031312 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1391529032348 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollCalculateTimeout:353 : Schedule timeout then=1391529031312 now=1391529027348 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollCalculateTimeout:362 : Timeout at 1391529031312 due in 3964 ms 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollRunOnce:630 : EVENT_POLL_RUN: nhandles=15 timeout=3964 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollRunOnce:641 : Poll got 1 event(s) 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchTimeouts:426 : Dispatch 5 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:471 : Dispatch 15 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:485 : i=0 w=1 2014-02-04 15:50:27.348+0000: 9081: debug : virEventPollDispatchHandles:485 : i=1 w=2 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=2 w=3 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=3 w=4 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=4 w=5 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=5 w=6 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=6 w=7 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=7 w=8 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=8 w=9 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=9 w=10 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=10 w=11 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=11 w=12 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=12 w=13 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=13 w=14 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=14 w=58 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:499 : EVENT_POLL_DISPATCH_HANDLE: watch=58 events=2 2014-02-04 15:50:27.349+0000: 9081: debug : virNetMessageFree:72 : msg=0x7fac7ce86c80 nfds=0 cb=(nil) 2014-02-04 15:50:27.349+0000: 9081: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7fac7ce86e60 tx=(nil) 2014-02-04 15:50:27.349+0000: 9081: debug : virNetServerClientCalculateHandleMode:188 : mode=1 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=58 events=1 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollInterruptLocked:713 : Skip interrupt, 1 140378773645312 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollCleanupTimeouts:517 : Cleanup 5 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollCleanupHandles:565 : Cleanup 15 2014-02-04 15:50:27.349+0000: 9081: debug : virEventRunDefaultImpl:271 : running default event implementation 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollCleanupTimeouts:517 : Cleanup 5 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollCleanupHandles:565 : Cleanup 15 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=0 w=1, f=5 e=1 d=0 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=1 w=2, f=7 e=1 d=0 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=2 w=3, f=12 e=1 d=0 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=3 w=4, f=13 e=1 d=0 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=4 w=5, f=14 e=1 d=0 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=5 w=6, f=15 e=1 d=0 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=6 w=7, f=16 e=1 d=0 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=7 w=8, f=17 e=1 d=0 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=8 w=9, f=19 e=1 d=0 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=9 w=10, f=23 e=25 d=0 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=10 w=11, f=25 e=25 d=0 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=11 w=12, f=24 e=25 d=0 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=12 w=13, f=26 e=25 d=0 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=13 w=14, f=27 e=1 d=0 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=14 w=58, f=28 e=1 d=0 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 5 timers 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1391529031312 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1391529032348 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollCalculateTimeout:353 : Schedule timeout then=1391529031312 now=1391529027349 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollCalculateTimeout:362 : Timeout at 1391529031312 due in 3963 ms 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollRunOnce:630 : EVENT_POLL_RUN: nhandles=15 timeout=3963 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollRunOnce:641 : Poll got 1 event(s) 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchTimeouts:426 : Dispatch 5 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:471 : Dispatch 15 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=0 w=1 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=1 w=2 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=2 w=3 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=3 w=4 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=4 w=5 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=5 w=6 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=6 w=7 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=7 w=8 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=8 w=9 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=9 w=10 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=10 w=11 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=11 w=12 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=12 w=13 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=13 w=14 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=14 w=58 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:499 : EVENT_POLL_DISPATCH_HANDLE: watch=58 events=1 2014-02-04 15:50:27.349+0000: 9081: debug : virNetMessageDecodeLength:149 : Got length, now need 88 total (84 more) 2014-02-04 15:50:27.349+0000: 9081: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7fac7ce86e60 tx=(nil) 2014-02-04 15:50:27.349+0000: 9081: debug : virNetServerClientCalculateHandleMode:188 : mode=1 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=58 events=1 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollInterruptLocked:713 : Skip interrupt, 1 140378773645312 2014-02-04 15:50:27.349+0000: 9081: debug : virNetServerClientDispatchRead:1202 : RPC_SERVER_CLIENT_MSG_RX: client=0x7fac7ce86610 len=88 prog=536903814 vers=1 proc=159 type=0 status=0 serial=6 2014-02-04 15:50:27.349+0000: 9081: debug : virKeepAliveCheckMessage:374 : ka=0x7fac7ce86d60, client=0x7fac7ce86610, msg=0x7fac7ce86e60 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollUpdateTimeout:260 : EVENT_POLL_UPDATE_TIMEOUT: timer=59 frequency=5000 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollUpdateTimeout:278 : Set timer freq=5000 expires=1391529032349 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollInterruptLocked:713 : Skip interrupt, 1 140378773645312 2014-02-04 15:50:27.349+0000: 9081: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fac7ce86610 2014-02-04 15:50:27.349+0000: 9081: debug : virNetServerDispatchNewMessage:213 : server=0x7fac7ce77ae0 client=0x7fac7ce86610 message=0x7fac7ce86e60 2014-02-04 15:50:27.349+0000: 9081: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fac7ce80030 2014-02-04 15:50:27.349+0000: 9081: debug : virNetMessageNew:44 : msg=0x7fac7ce78c60 tracked=1 2014-02-04 15:50:27.349+0000: 9081: debug : virNetServerClientCalculateHandleMode:153 : tls=(nil) hs=-1, rx=0x7fac7ce78c60 tx=(nil) 2014-02-04 15:50:27.349+0000: 9081: debug : virNetServerClientCalculateHandleMode:188 : mode=1 2014-02-04 15:50:27.349+0000: 9082: debug : virNetServerHandleJob:184 : server=0x7fac7ce77ae0 client=0x7fac7ce86610 message=0x7fac7ce86e60 prog=0x7fac7ce80030 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=58 events=1 2014-02-04 15:50:27.349+0000: 9082: debug : virNetServerProgramDispatch:285 : prog=536903814 ver=1 type=0 status=0 serial=6 proc=159 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollInterruptLocked:713 : Skip interrupt, 1 140378773645312 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollCleanupTimeouts:517 : Cleanup 5 2014-02-04 15:50:27.349+0000: 9082: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fac58000ac0 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollCleanupHandles:565 : Cleanup 15 2014-02-04 15:50:27.349+0000: 9082: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fac58000ac0 2014-02-04 15:50:27.349+0000: 9081: debug : virEventRunDefaultImpl:271 : running default event implementation 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollCleanupTimeouts:517 : Cleanup 5 2014-02-04 15:50:27.349+0000: 9082: debug : remoteDispatchDomainMemoryStatsHelper:5195 : server=0x7fac7ce77ae0 client=0x7fac7ce86610 msg=0x7fac7ce86e60 rerr=0x7fac6d9b5bc0 args=0x7fac44000900 ret=0x7fac440009a0 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollCleanupHandles:565 : Cleanup 15 2014-02-04 15:50:27.349+0000: 9082: debug : virObjectNew:199 : OBJECT_NEW: obj=0x7fac440008c0 classname=virDomain 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=0 w=1, f=5 e=1 d=0 2014-02-04 15:50:27.349+0000: 9082: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fac340018a0 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=1 w=2, f=7 e=1 d=0 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=2 w=3, f=12 e=1 d=0 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=3 w=4, f=13 e=1 d=0 2014-02-04 15:50:27.349+0000: 9082: debug : virDomainMemoryStats:8719 : dom=0x7fac440008c0, (VM: name=bqafm0001ap.frm.meshcore.net, uuid=3b009e73-e095-29fa-8970-f5c2b647d5a0), stats=0x7fac44000af0, nr_stats=8, flags=0 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=4 w=5, f=14 e=1 d=0 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=5 w=6, f=15 e=1 d=0 2014-02-04 15:50:27.349+0000: 9082: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fac7ce760b0 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=6 w=7, f=16 e=1 d=0 2014-02-04 15:50:27.349+0000: 9082: debug : virAccessManagerCheckDomain:231 : manager=0x7fac7ce760b0(name=stack) driver=QEMU domain=0x7fac5c2386c0 perm=1 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=7 w=8, f=17 e=1 d=0 2014-02-04 15:50:27.349+0000: 9082: debug : virAccessManagerCheckDomain:231 : manager=0x7fac7ce776f0(name=none) driver=QEMU domain=0x7fac5c2386c0 perm=1 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=8 w=9, f=19 e=1 d=0 2014-02-04 15:50:27.349+0000: 9082: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fac7ce760b0 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=9 w=10, f=23 e=25 d=0 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=10 w=11, f=25 e=25 d=0 2014-02-04 15:50:27.349+0000: 9082: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fac5c209c20 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=11 w=12, f=24 e=25 d=0 2014-02-04 15:50:27.349+0000: 9082: debug : qemuDomainObjBeginJobInternal:1024 : Starting job: query (async=none vm=0x7fac5c2141a0 name=bqafm0001ap.frm.meshcore.net) 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=12 w=13, f=26 e=25 d=0 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=13 w=14, f=27 e=1 d=0 2014-02-04 15:50:27.349+0000: 9082: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fac5c2141a0 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=14 w=58, f=28 e=1 d=0 2014-02-04 15:50:27.349+0000: 9082: debug : qemuDomainObjBeginJobInternal:1066 : Started job: query (async=none vm=0x7fac5c2141a0 name=bqafm0001ap.frm.meshcore.net) 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 5 timers 2014-02-04 15:50:27.349+0000: 9082: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fac5c209c20 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1391529031312 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1391529032349 2014-02-04 15:50:27.349+0000: 9082: debug : qemuDomainObjEnterMonitorInternal:1252 : Entering monitor (mon=0x7fac54000c00 vm=0x7fac5c2141a0 name=bqafm0001ap.frm.meshcore.net) 2014-02-04 15:50:27.349+0000: 9082: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fac54000c00 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollCalculateTimeout:353 : Schedule timeout then=1391529031312 now=1391529027349 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollCalculateTimeout:362 : Timeout at 1391529031312 due in 3963 ms 2014-02-04 15:50:27.349+0000: 9082: debug : qemuMonitorGetMemoryStats:1565 : mon=0x7fac54000c00 stats=0x7fac44000af0 nstats=8 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollRunOnce:630 : EVENT_POLL_RUN: nhandles=15 timeout=3963 2014-02-04 15:50:27.349+0000: 9082: debug : qemuMonitorFindBalloonObjectPath:1045 : Searching for Balloon Object Path starting at / 2014-02-04 15:50:27.349+0000: 9082: debug : virJSONValueToString:1106 : object=0x7fac44000a50 2014-02-04 15:50:27.349+0000: 9082: debug : virJSONValueToStringOne:1037 : object=0x7fac44000a50 type=0 gen=0x7fac44000d60 2014-02-04 15:50:27.349+0000: 9082: debug : virJSONValueToStringOne:1037 : object=0x7fac44000a70 type=2 gen=0x7fac44000d60 2014-02-04 15:50:27.349+0000: 9082: debug : virJSONValueToStringOne:1037 : object=0x7fac44000bf0 type=0 gen=0x7fac44000d60 2014-02-04 15:50:27.349+0000: 9082: debug : virJSONValueToStringOne:1037 : object=0x7fac44000c10 type=2 gen=0x7fac44000d60 2014-02-04 15:50:27.349+0000: 9082: debug : virJSONValueToStringOne:1037 : object=0x7fac44000ce0 type=2 gen=0x7fac44000d60 2014-02-04 15:50:27.349+0000: 9082: debug : virJSONValueToString:1139 : result={"execute":"qom-list","arguments":{"path":"/"},"id":"libvirt-6"} 2014-02-04 15:50:27.349+0000: 9082: debug : qemuMonitorJSONCommandWithFd:264 : Send command '{"execute":"qom-list","arguments":{"path":"/"},"id":"libvirt-6"}' for write with FD -1 2014-02-04 15:50:27.349+0000: 9082: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=10 events=15 2014-02-04 15:50:27.349+0000: 9082: debug : virEventPollInterruptLocked:717 : Interrupting 2014-02-04 15:50:27.349+0000: 9082: debug : qemuMonitorSend:959 : QEMU_MONITOR_SEND_MSG: mon=0x7fac54000c00 msg={"execute":"qom-list","arguments":{"path":"/"},"id":"libvirt-6"} fd=-1 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollRunOnce:641 : Poll got 1 event(s) 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchTimeouts:426 : Dispatch 5 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:471 : Dispatch 15 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=0 w=1 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:499 : EVENT_POLL_DISPATCH_HANDLE: watch=1 events=1 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=1 w=2 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=2 w=3 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=3 w=4 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=4 w=5 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=5 w=6 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=6 w=7 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=7 w=8 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=8 w=9 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=9 w=10 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=10 w=11 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=11 w=12 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=12 w=13 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=13 w=14 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=14 w=58 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollCleanupTimeouts:517 : Cleanup 5 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollCleanupHandles:565 : Cleanup 15 2014-02-04 15:50:27.349+0000: 9081: debug : virEventRunDefaultImpl:271 : running default event implementation 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollCleanupTimeouts:517 : Cleanup 5 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollCleanupHandles:565 : Cleanup 15 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=0 w=1, f=5 e=1 d=0 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=1 w=2, f=7 e=1 d=0 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=2 w=3, f=12 e=1 d=0 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=3 w=4, f=13 e=1 d=0 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=4 w=5, f=14 e=1 d=0 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=5 w=6, f=15 e=1 d=0 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=6 w=7, f=16 e=1 d=0 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=7 w=8, f=17 e=1 d=0 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=8 w=9, f=19 e=1 d=0 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=9 w=10, f=23 e=29 d=0 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=10 w=11, f=25 e=25 d=0 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=11 w=12, f=24 e=25 d=0 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=12 w=13, f=26 e=25 d=0 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=13 w=14, f=27 e=1 d=0 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=14 w=58, f=28 e=1 d=0 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 5 timers 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1391529031312 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1391529032349 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollCalculateTimeout:353 : Schedule timeout then=1391529031312 now=1391529027349 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollCalculateTimeout:362 : Timeout at 1391529031312 due in 3963 ms 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollRunOnce:630 : EVENT_POLL_RUN: nhandles=15 timeout=3963 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollRunOnce:641 : Poll got 1 event(s) 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchTimeouts:426 : Dispatch 5 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:471 : Dispatch 15 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=0 w=1 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=1 w=2 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=2 w=3 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=3 w=4 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=4 w=5 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=5 w=6 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=6 w=7 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=7 w=8 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=8 w=9 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=9 w=10 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:499 : EVENT_POLL_DISPATCH_HANDLE: watch=10 events=2 2014-02-04 15:50:27.349+0000: 9081: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fac54000c00 2014-02-04 15:50:27.349+0000: 9081: debug : qemuMonitorIOWrite:504 : QEMU_MONITOR_IO_WRITE: mon=0x7fac54000c00 buf={"execute":"qom-list","arguments":{"path":"/"},"id":"libvirt-6"} len=66 ret=66 errno=22 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=10 events=13 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollInterruptLocked:713 : Skip interrupt, 1 140378773645312 2014-02-04 15:50:27.349+0000: 9081: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fac54000c00 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=10 w=11 2014-02-04 15:50:27.349+0000: 9081: debug : virEventPollDispatchHandles:485 : i=11 w=12 2014-02-04 15:50:27.350+0000: 9081: debug : virEventPollDispatchHandles:485 : i=12 w=13 2014-02-04 15:50:27.350+0000: 9081: debug : virEventPollDispatchHandles:485 : i=13 w=14 2014-02-04 15:50:27.350+0000: 9081: debug : virEventPollDispatchHandles:485 : i=14 w=58 2014-02-04 15:50:27.350+0000: 9081: debug : virEventPollCleanupTimeouts:517 : Cleanup 5 2014-02-04 15:50:27.350+0000: 9081: debug : virEventPollCleanupHandles:565 : Cleanup 15 2014-02-04 15:50:27.350+0000: 9081: debug : virEventRunDefaultImpl:271 : running default event implementation 2014-02-04 15:50:27.350+0000: 9081: debug : virEventPollCleanupTimeouts:517 : Cleanup 5 2014-02-04 15:50:27.350+0000: 9081: debug : virEventPollCleanupHandles:565 : Cleanup 15 2014-02-04 15:50:27.350+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=0 w=1, f=5 e=1 d=0 2014-02-04 15:50:27.350+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=1 w=2, f=7 e=1 d=0 2014-02-04 15:50:27.350+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=2 w=3, f=12 e=1 d=0 2014-02-04 15:50:27.350+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=3 w=4, f=13 e=1 d=0 2014-02-04 15:50:27.350+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=4 w=5, f=14 e=1 d=0 2014-02-04 15:50:27.350+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=5 w=6, f=15 e=1 d=0 2014-02-04 15:50:27.350+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=6 w=7, f=16 e=1 d=0 2014-02-04 15:50:27.350+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=7 w=8, f=17 e=1 d=0 2014-02-04 15:50:27.350+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=8 w=9, f=19 e=1 d=0 2014-02-04 15:50:27.350+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=9 w=10, f=23 e=25 d=0 2014-02-04 15:50:27.350+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=10 w=11, f=25 e=25 d=0 2014-02-04 15:50:27.350+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=11 w=12, f=24 e=25 d=0 2014-02-04 15:50:27.350+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=12 w=13, f=26 e=25 d=0 2014-02-04 15:50:27.350+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=13 w=14, f=27 e=1 d=0 2014-02-04 15:50:27.350+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=14 w=58, f=28 e=1 d=0 2014-02-04 15:50:27.350+0000: 9081: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 5 timers 2014-02-04 15:50:27.350+0000: 9081: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1391529031312 2014-02-04 15:50:27.350+0000: 9081: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1391529032349 2014-02-04 15:50:27.350+0000: 9081: debug : virEventPollCalculateTimeout:353 : Schedule timeout then=1391529031312 now=1391529027350 2014-02-04 15:50:27.350+0000: 9081: debug : virEventPollCalculateTimeout:362 : Timeout at 1391529031312 due in 3962 ms 2014-02-04 15:50:27.350+0000: 9081: debug : virEventPollRunOnce:630 : EVENT_POLL_RUN: nhandles=15 timeout=3962 2014-02-04 15:50:27.350+0000: 9081: debug : virEventPollRunOnce:641 : Poll got 1 event(s) 2014-02-04 15:50:27.350+0000: 9081: debug : virEventPollDispatchTimeouts:426 : Dispatch 5 2014-02-04 15:50:27.350+0000: 9081: debug : virEventPollDispatchHandles:471 : Dispatch 15 2014-02-04 15:50:27.350+0000: 9081: debug : virEventPollDispatchHandles:485 : i=0 w=1 2014-02-04 15:50:27.350+0000: 9081: debug : virEventPollDispatchHandles:485 : i=1 w=2 2014-02-04 15:50:27.350+0000: 9081: debug : virEventPollDispatchHandles:485 : i=2 w=3 2014-02-04 15:50:27.350+0000: 9081: debug : virEventPollDispatchHandles:485 : i=3 w=4 2014-02-04 15:50:27.350+0000: 9081: debug : virEventPollDispatchHandles:485 : i=4 w=5 2014-02-04 15:50:27.350+0000: 9081: debug : virEventPollDispatchHandles:485 : i=5 w=6 2014-02-04 15:50:27.350+0000: 9081: debug : virEventPollDispatchHandles:485 : i=6 w=7 2014-02-04 15:50:27.350+0000: 9081: debug : virEventPollDispatchHandles:485 : i=7 w=8 2014-02-04 15:50:27.350+0000: 9081: debug : virEventPollDispatchHandles:485 : i=8 w=9 2014-02-04 15:50:27.350+0000: 9081: debug : virEventPollDispatchHandles:485 : i=9 w=10 2014-02-04 15:50:27.350+0000: 9081: debug : virEventPollDispatchHandles:499 : EVENT_POLL_DISPATCH_HANDLE: watch=10 events=1 2014-02-04 15:50:27.350+0000: 9081: debug : virObjectRef:293 : OBJECT_REF: obj=0x7fac54000c00 2014-02-04 15:50:27.350+0000: 9081: debug : qemuMonitorIOProcess:396 : QEMU_MONITOR_IO_PROCESS: mon=0x7fac54000c00 buf={"id": "libvirt-6", "error": {"class": "CommandNotFound", "desc": "The command qom-list has not been found", "data": {"name": "qom-list"}}} len=141 2014-02-04 15:50:27.350+0000: 9081: debug : qemuMonitorJSONIOProcessLine:157 : Line [{"id": "libvirt-6", "error": {"class": "CommandNotFound", "desc": "The command qom-list has not been found", "data": {"name": "qom-list"}}}] 2014-02-04 15:50:27.350+0000: 9081: debug : virJSONValueFromString:975 : string={"id": "libvirt-6", "error": {"class": "CommandNotFound", "desc": "The command qom-list has not been found", "data": {"name": "qom-list"}}} 2014-02-04 15:50:27.350+0000: 9081: debug : virJSONParserHandleStartMap:853 : parser=0x7fffd5667f70 2014-02-04 15:50:27.350+0000: 9081: debug : virJSONParserHandleMapKey:835 : parser=0x7fffd5667f70 key=0x7fac7ce78d42 2014-02-04 15:50:27.350+0000: 9081: debug : virJSONParserHandleString:815 : parser=0x7fffd5667f70 str=0x7fac7ce78d48 2014-02-04 15:50:27.350+0000: 9081: debug : virJSONParserHandleMapKey:835 : parser=0x7fffd5667f70 key=0x7fac7ce78d55 2014-02-04 15:50:27.350+0000: 9081: debug : virJSONParserHandleStartMap:853 : parser=0x7fffd5667f70 2014-02-04 15:50:27.350+0000: 9081: debug : virJSONParserHandleMapKey:835 : parser=0x7fffd5667f70 key=0x7fac7ce78d5f 2014-02-04 15:50:27.350+0000: 9081: debug : virJSONParserHandleString:815 : parser=0x7fffd5667f70 str=0x7fac7ce78d68 2014-02-04 15:50:27.350+0000: 9081: debug : virJSONParserHandleMapKey:835 : parser=0x7fffd5667f70 key=0x7fac7ce78d7b 2014-02-04 15:50:27.350+0000: 9081: debug : virJSONParserHandleString:815 : parser=0x7fffd5667f70 str=0x7fac7ce78d83 2014-02-04 15:50:27.350+0000: 9081: debug : virJSONParserHandleMapKey:835 : parser=0x7fffd5667f70 key=0x7fac7ce78dae 2014-02-04 15:50:27.350+0000: 9081: debug : virJSONParserHandleStartMap:853 : parser=0x7fffd5667f70 2014-02-04 15:50:27.350+0000: 9081: debug : virJSONParserHandleMapKey:835 : parser=0x7fffd5667f70 key=0x7fac7ce78db7 2014-02-04 15:50:27.350+0000: 9081: debug : virJSONParserHandleString:815 : parser=0x7fffd5667f70 str=0x7fac7ce78dbf 2014-02-04 15:50:27.350+0000: 9081: debug : virJSONParserHandleEndMap:881 : parser=0x7fffd5667f70 2014-02-04 15:50:27.350+0000: 9081: debug : virJSONParserHandleEndMap:881 : parser=0x7fffd5667f70 2014-02-04 15:50:27.350+0000: 9081: debug : virJSONParserHandleEndMap:881 : parser=0x7fffd5667f70 2014-02-04 15:50:27.350+0000: 9081: debug : virJSONValueFromString:1026 : result=0x7fac7ce6b9a0 2014-02-04 15:50:27.350+0000: 9081: debug : qemuMonitorJSONIOProcessLine:177 : QEMU_MONITOR_RECV_REPLY: mon=0x7fac54000c00 reply={"id": "libvirt-6", "error": {"class": "CommandNotFound", "desc": "The command qom-list has not been found", "data": {"name": "qom-list"}}} 2014-02-04 15:50:27.350+0000: 9081: debug : qemuMonitorJSONIOProcess:226 : Total used 141 bytes out of 141 available in buffer 2014-02-04 15:50:27.350+0000: 9081: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=10 events=13 2014-02-04 15:50:27.350+0000: 9081: debug : virEventPollInterruptLocked:713 : Skip interrupt, 1 140378773645312 2014-02-04 15:50:27.350+0000: 9081: debug : virObjectUnref:256 : OBJECT_UNREF: obj=0x7fac54000c00 2014-02-04 15:50:27.350+0000: 9082: debug : virEventPollUpdateHandle:147 : EVENT_POLL_UPDATE_HANDLE: watch=10 events=13 2014-02-04 15:50:27.350+0000: 9081: debug : virEventPollDispatchHandles:485 : i=10 w=11 2014-02-04 15:50:27.351+0000: 9081: debug : virEventPollDispatchHandles:485 : i=11 w=12 2014-02-04 15:50:27.351+0000: 9081: debug : virEventPollDispatchHandles:485 : i=12 w=13 2014-02-04 15:50:27.351+0000: 9081: debug : virEventPollDispatchHandles:485 : i=13 w=14 2014-02-04 15:50:27.351+0000: 9081: debug : virEventPollDispatchHandles:485 : i=14 w=58 2014-02-04 15:50:27.351+0000: 9081: debug : virEventPollCleanupTimeouts:517 : Cleanup 5 2014-02-04 15:50:27.351+0000: 9081: debug : virEventPollCleanupHandles:565 : Cleanup 15 2014-02-04 15:50:27.351+0000: 9081: debug : virEventRunDefaultImpl:271 : running default event implementation 2014-02-04 15:50:27.351+0000: 9082: debug : virEventPollInterruptLocked:713 : Skip interrupt, 0 140378773645312 2014-02-04 15:50:27.351+0000: 9081: debug : virEventPollCleanupTimeouts:517 : Cleanup 5 2014-02-04 15:50:27.351+0000: 9082: debug : qemuMonitorJSONCommandWithFd:269 : Receive command reply ret=0 rxObject=0x7fac7ce6b9a0 2014-02-04 15:50:27.351+0000: 9081: debug : virEventPollCleanupHandles:565 : Cleanup 15 2014-02-04 15:50:27.351+0000: 9082: debug : virJSONValueToString:1106 : object=0x7fac44000a50 2014-02-04 15:50:27.351+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=0 w=1, f=5 e=1 d=0 2014-02-04 15:50:27.351+0000: 9082: debug : virJSONValueToStringOne:1037 : object=0x7fac44000a50 type=0 gen=0x7fac44001000 2014-02-04 15:50:27.351+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=1 w=2, f=7 e=1 d=0 2014-02-04 15:50:27.351+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=2 w=3, f=12 e=1 d=0 2014-02-04 15:50:27.351+0000: 9082: debug : virJSONValueToStringOne:1037 : object=0x7fac44000a70 type=2 gen=0x7fac44001000 2014-02-04 15:50:27.351+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=3 w=4, f=13 e=1 d=0 2014-02-04 15:50:27.351+0000: 9082: debug : virJSONValueToStringOne:1037 : object=0x7fac44000bf0 type=0 gen=0x7fac44001000 2014-02-04 15:50:27.351+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=4 w=5, f=14 e=1 d=0 2014-02-04 15:50:27.351+0000: 9082: debug : virJSONValueToStringOne:1037 : object=0x7fac44000c10 type=2 gen=0x7fac44001000 2014-02-04 15:50:27.351+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=5 w=6, f=15 e=1 d=0 2014-02-04 15:50:27.351+0000: 9082: debug : virJSONValueToStringOne:1037 : object=0x7fac44000ce0 type=2 gen=0x7fac44001000 2014-02-04 15:50:27.351+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=6 w=7, f=16 e=1 d=0 2014-02-04 15:50:27.351+0000: 9082: debug : virJSONValueToString:1139 : result={"execute":"qom-list","arguments":{"path":"/"},"id":"libvirt-6"} 2014-02-04 15:50:27.351+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=7 w=8, f=17 e=1 d=0 2014-02-04 15:50:27.351+0000: 9082: debug : virJSONValueToString:1106 : object=0x7fac7ce6b9a0 2014-02-04 15:50:27.351+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=8 w=9, f=19 e=1 d=0 2014-02-04 15:50:27.351+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=9 w=10, f=23 e=25 d=0 2014-02-04 15:50:27.351+0000: 9082: debug : virJSONValueToStringOne:1037 : object=0x7fac7ce6b9a0 type=0 gen=0x7fac44001000 2014-02-04 15:50:27.351+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=10 w=11, f=25 e=25 d=0 2014-02-04 15:50:27.351+0000: 9082: debug : virJSONValueToStringOne:1037 : object=0x7fac7ce6b8a0 type=2 gen=0x7fac44001000 2014-02-04 15:50:27.351+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=11 w=12, f=24 e=25 d=0 2014-02-04 15:50:27.351+0000: 9082: debug : virJSONValueToStringOne:1037 : object=0x7fac7ce67660 type=0 gen=0x7fac44001000 2014-02-04 15:50:27.351+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=12 w=13, f=26 e=25 d=0 2014-02-04 15:50:27.351+0000: 9082: debug : virJSONValueToStringOne:1037 : object=0x7fac7ce83f30 type=2 gen=0x7fac44001000 2014-02-04 15:50:27.351+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=13 w=14, f=27 e=1 d=0 2014-02-04 15:50:27.351+0000: 9082: debug : virJSONValueToStringOne:1037 : object=0x7fac7ce61930 type=2 gen=0x7fac44001000 2014-02-04 15:50:27.351+0000: 9081: debug : virEventPollMakePollFDs:394 : Prepare n=14 w=58, f=28 e=1 d=0 2014-02-04 15:50:27.351+0000: 9082: debug : virJSONValueToStringOne:1037 : object=0x7fac7ce6ce30 type=0 gen=0x7fac44001000 2014-02-04 15:50:27.351+0000: 9081: debug : virEventPollCalculateTimeout:332 : Calculate expiry of 5 timers 2014-02-04 15:50:27.351+0000: 9082: debug : virJSONValueToStringOne:1037 : object=0x7fac7ce80230 type=2 gen=0x7fac44001000 2014-02-04 15:50:27.351+0000: 9081: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1391529031312 2014-02-04 15:50:27.351+0000: 9081: debug : virEventPollCalculateTimeout:340 : Got a timeout scheduled for 1391529032349 2014-02-04 15:50:27.351+0000: 9082: debug : virJSONValueToString:1139 : result={"id":"libvirt-6","error":{"class":"CommandNotFound","desc":"The command qom-list has not been found","data":{"name":"qom-list"}}} 2014-02-04 15:50:27.351+0000: 9081: debug : virEventPollCalculateTimeout:353 : Schedule timeout then=1391529031312 now=1391529027351 2014-02-04 15:50:27.351+0000: 9082: debug : qemuMonitorJSONCheckError:343 : unable to execute QEMU command {"execute":"qom-list","arguments":{"path":"/"},"id":"libvirt-6"}: {"id":"libvirt-6","error":{"class":"CommandNotFound","desc":"The command qom-list has not been found","data":{"name":"qom-list"}}} 2014-02-04 15:50:27.351+0000: 9081: debug : virEventPollCalculateTimeout:362 : Timeout at 1391529031312 due in 3961 ms 2014-02-04 15:50:27.351+0000: 9081: debug : virEventPollRunOnce:630 : EVENT_POLL_RUN: nhandles=15 timeout=3961 2014-02-04 15:50:27.351+0000: 9082: error : qemuMonitorJSONCheckError:354 : internal error: unable to execute QEMU command 'qom-list': The command qom-list has not been found ====== end of log ===== Segmentation fault (core dumped)

8 11

[libvirt] [PATCH v2] bandwidth: Adjust documentation
by John Ferlan 20 Feb '14

20 Feb '14

Recent autotest/virt-test testing on f20 discovered an anomaly in how the bandwidth options are documented and used. This was discovered due to a bug fix in the /sbin/tc utility found in iproute-3.11.0.1 (on f20) in which overflow was actually caught and returned as an error. The fix was first introduced in iproute-3.10 (search on iproute2 commit 'a303853e'). The autotest/virt-test test for virsh domiftune was attempting to send the largest unsigned integer value (4294967295) for maximum value testing. The libvirt xml implementation was designed to manage values in kilobytes thus when this value was passed to /sbin/tc, it (now) properly rejected the 4294967295kbps value. Investigation of the problem discovered that formatdomain.html.in and formatnetwork.html.in described the elements and property types slightly differently, although they use the same code - virNetDevBandwidthParseRate() (shared by portgroups, domains, and networks xml parsers). Rather than have the descriptions in two places, this patch will combine and reword the description under formatnetwork.html.in and have formatdomain.html.in link to that description. This documentation faux pas was continued into the virsh man page where the bandwidth description for both 'attach-interface' and 'domiftune' did not indicate the format of each value, thus leading to the test using largest unsigned integer value assuming "bps" rather than "kbps", which ultimately was wrong. Signed-off-by: John Ferlan <jferlan(a)redhat.com> --- Changes since v1: -> Reflection and some private IRC validation results in changing to use "kilobyte" and not "kibibyte" -> Although the smallest unit is 1 kb/kbps, it's felt that things aren't headed in the going smaller direction, rather things are desired to be larger. So the inability to "test" the maximum of 4294967295 bps in favor of 4294967 kbps shouldn't really matter. docs/formatdomain.html.in | 35 +++----------------- docs/formatnetwork.html.in | 81 ++++++++++++++++++++++++++++++++++------------ tools/virsh.pod | 10 ++++-- 3 files changed, 73 insertions(+), 53 deletions(-) diff --git a/docs/formatdomain.html.in b/docs/formatdomain.html.in index 4660983..ea1a97b 100644 --- a/docs/formatdomain.html.in +++ b/docs/formatdomain.html.in @@ -3750,37 +3750,10 @@ qemu-kvm -net nic,model=? /dev/null This part of interface XML provides setting quality of service. Incoming - and outgoing traffic can be shaped independently. The - <code>bandwidth</code> element can have at most one <code>inbound</code> - and at most one <code>outbound</code> child elements. Leaving any of these - children element out result in no QoS applied on that traffic direction. - So, when you want to shape only domain's incoming traffic, use - <code>inbound</code> only, and vice versa. Each of these elements have one - mandatory attribute <code>average</code> (or <code>floor</code> as - described below). <code>average</code> specifies average bit rate on - the interface being shaped. Then there are two optional attributes: - <code>peak</code>, which specifies maximum rate at which interface can send - data, and <code>burst</code>, amount of bytes that can be burst at - <code>peak</code> speed. Accepted values for attributes are integer - numbers. The units for <code>average</code> and <code>peak</code> attributes - are kilobytes per second, and for the <code>burst</code> just kilobytes. - Note the limitation of implementation: the <code>peak</code> attribute in - <code>outbound</code> element is ignored (as linux ingress filters don't - know it yet). Since 0.9.4 The <code>inbound</code> can - optionally have <code>floor</code> attribute. This is there for - guaranteeing minimal throughput for shaped interfaces. This, however, - requires that all traffic goes through one point where QoS decisions can - take place. That's why this attribute works only for virtual networks for - now (that is <code><interface type='network'/></code> with a - forward type of route, nat, or no forward at all). Moreover, the - virtual network the interface is connected to is required to have at least - inbound QoS set (<code>average</code> at least). Moreover, with - <code>floor</code> attribute users don't need to specify - <code>average</code>. However, <code>peak</code> and <code>burst</code> - attributes still require <code>average</code>. Currently, linux kernel - doesn't allow ingress qdiscs to have any classes therefore - <code>floor</code> can be applied only on <code>inbound</code> and not - <code>outbound</code>. Since 1.0.1 + and outgoing traffic can be shaped independently. + The <code>bandwidth</code> element and its child elements are described + in the <a href="formatnetwork.html#elementQoS">QoS</a> section of + the Network XML. <h5><a name="elementVlanTag">Setting VLAN tag (on supported network types only)</a></h5> diff --git a/docs/formatnetwork.html.in b/docs/formatnetwork.html.in index 1ca1bec..d4c390a 100644 --- a/docs/formatnetwork.html.in +++ b/docs/formatnetwork.html.in @@ -412,40 +412,81 @@ The <code><bandwidth></code> element allows setting - quality of service for a particular network. - Since 0.9.4 The limits specified + quality of service for a particular network + (since 0.9.4). For a <code>domain</code> + object, the limits specified are applied to the domain traffic. + For a <code>network</code> object, the limits specified are applied to the aggregate of all traffic to/from all guest interfaces attached to that network, not to each guest - interface individually. Setting <code>bandwidth</code> for a + interface individually. Setting <code>bandwidth</code> for a network is supported only for networks with a <code><forward></code> mode of <code>route</code>, <code>nat</code>, or no mode at all - (i.e. an "isolated" network). <code>bandwidth</code> setting + (i.e. an "isolated" network). Setting <code>bandwidth</code> is not supported for forward modes of <code>bridge</code>, <code>passthrough</code>, <code>private</code>, or <code>hostdev</code>, and attempts to do this will lead to - a failure to define the network (or to create a transient - network). + a failure to define the network (or to create a transient network). Incoming and outgoing traffic can be shaped independently. The - <code>bandwidth</code> element can have at most - one <code>inbound</code> and at most one <code>outbound</code> + <code>bandwidth</code> element can have at most one + <code>inbound</code> and at most one <code>outbound</code> child element. Leaving either of these children elements out results in no QoS applied for that traffic direction. So, - when you want to shape only a network's incoming traffic, use + when you want to shape only incoming traffic, use <code>inbound</code> only, and vice versa. Each of these - elements have one mandatory attribute - <code>average</code>, - which specifies the desired average bit rate for the interface - being shaped (in kibibytes/second). There are also two - optional attributes: <code>peak</code>, which specifies the - maximum rate at which the bridge can send data (again in - kibibytes/second), and <code>burst</code> - the amount of - bytes that can be transmitted in a single burst at - <code>peak</code> speed (in kibibytes). Accepted values for - attributes are integer numbers. The allotted bandwidth is - shared equally between domains connected to the network. + elements have one mandatory attribute - <code>average</code> (or + <code>floor</code> as described below). The attributes are as follows, + where accepted values for each attribute is an integer number. + <dl> + <dt><code>average</code></dt> + <dd> + Specifies the desired average bit rate for the interface + being shaped (in kilobytes/second). + </dd> + <dt><code>peak</code></dt> + <dd> + Optional attribute which specifies the maximum rate at + which the bridge can send data (in kilobytes/second). + Note the limitation of implementation: this attribute in the + <code>outbound</code> element is ignored (as Linux ingress + filters don't know it yet). + </dd> + <dt><code>burst</code></dt> + <dd> + Optional attribute which specifies the amount of kilobytes that + can be transmitted in a single burst at <code>peak</code> speed. + </dd> + <dt><code>floor</code></dt> + <dd> + Optional attribute available only for the <code>inbound</code> + element. This attribute guarantees minimal throughput for + shaped interfaces. This, however, requires that all traffic + goes through one point where QoS decisions can take place, hence + why this attribute works only for virtual networks for now + (that is <code><interface type='network'/></code> with a + forward type of route, nat, or no forward at all). Moreover, the + virtual network the interface is connected to is required to have + at least inbound QoS set (<code>average</code> at least). If + using the <code>floor</code> attribute users don't need to specify + <code>average</code>. However, <code>peak</code> and + <code>burst</code> attributes still require <code>average</code>. + Currently, the Linux kernel doesn't allow ingress qdiscs to have + any classes therefore <code>floor</code> can be applied only + on <code>inbound</code> and not <code>outbound</code>. + </dd> + </dl> + + + Attributes <code>average</code>, <code>peak</code>, and + <code>burst</code> are available + since 0.9.4, while the + <code>floor</code> attribute is available + since 1.0.1. + + A <code><portgroup></code> element can also include a <code><bandwidth></code> element. In that case, the @@ -561,7 +602,7 @@ network), and each portgroup has a name, as well as various subelements associated with it. The currently supported subelements are <code><bandwidth></code> - (documented <a href="formatdomain.html#elementQoS">here</a>) + (described <a href="formatnetwork.html#elementQoS">here</a>) and <code><virtualport></code> (documented <a href="formatdomain.html#elementsNICSDirect">here</a>). If a domain interface definition specifies a portgroup (by diff --git a/tools/virsh.pod b/tools/virsh.pod index f221475..30dcbb8 100644 --- a/tools/virsh.pod +++ b/tools/virsh.pod @@ -680,7 +680,10 @@ or the MAC address. If no I<--inbound> or I<--outbound> is specified, this command will query and show the bandwidth settings. Otherwise, it will set the inbound or outbound bandwidth. I<average,peak,burst> is the same as -in command I<attach-interface>. +in command I<attach-interface>. Values for I<average> and I<peak> are +expressed in kilobytes per second, while I<burst> is expressed in kilobytes +in a single burst at -I<peak> speed as described in the Network XML +documentation at L<http://libvirt.org/formatnetwork.html#elementQoS>. If I<--live> is specified, affect a running guest. If I<--config> is specified, affect the next boot of a persistent guest. @@ -2019,7 +2022,10 @@ of the network interface. I<script> allows to specify a path to a script handling a bridge instead of the default one. I<model> allows to specify the model type. I<inbound> and I<outbound> control the bandwidth of the interface. I<peak> and I<burst> are optional, so "average,peak", "average,,burst" and -"average" are also legal. +"average" are also legal. Values for I<average> and I<peak> are +expressed in kilobytes per second, while I<burst> is expressed in kilobytes +in a single burst at -I<peak> speed as described in the Network XML +documentation at L<http://libvirt.org/formatnetwork.html#elementQoS>. If I<--live> is specified, affect a running domain. If I<--config> is specified, affect the next startup of a persistent domain. -- 1.8.4.2

3 5

[libvirt] [PATCH] Fix build of portallocator on mingw
by Ján Tomko 20 Feb '14

20 Feb '14

IN6ADDR_ANY_INIT does not seem to be working as expected on MinGW: error: missing braces around initializer [-Werror=missing-braces] .sin6_addr = IN6ADDR_ANY_INIT, Use the in6addr_any variable instead. Reported by Daniel P. Berrange. --- Pushed as a build breaker. src/util/virportallocator.c | 2 +- 1 file changed, 1 insertion(+), 1 deletion(-) diff --git a/src/util/virportallocator.c b/src/util/virportallocator.c index 06174b0..22cdc37 100644 --- a/src/util/virportallocator.c +++ b/src/util/virportallocator.c @@ -106,7 +106,7 @@ static int virPortAllocatorBindToPort(bool *used, struct sockaddr_in6 addr6 = { .sin6_family = AF_INET6, .sin6_port = htons(port), - .sin6_addr = IN6ADDR_ANY_INIT, + .sin6_addr = in6addr_any }; struct sockaddr_in addr4 = { .sin_family = AF_INET, -- 1.8.3.2

2 2

[libvirt] [PATCH 0/2] Add two string helper methods
by Daniel P. Berrange 20 Feb '14

20 Feb '14

As mentioned in my review, I took the first two patches from this series and polished them up ready for merge https://www.redhat.com/archives/libvir-list/2014-January/msg01067.html Hopefully this should be good enough for the vbox snapshot work to use. Changes since that posting - Added unit tests - Changed virStringSearch API to return all matches in one go, rather than need repeated calls - Rewrote virStringReplace to use virBuffer APIs Daniel P. Berrange (1): Add virStringReplace method for substring replacement Manuel VIVES (1): Add virStringSearch method for regex matching po/POTFILES.in | 1 + src/libvirt_private.syms | 2 + src/util/virstring.c | 146 ++++++++++++++++++++++++++++++++++++++++++- src/util/virstring.h | 12 ++++ tests/virstringtest.c | 159 +++++++++++++++++++++++++++++++++++++++++++++++ 5 files changed, 319 insertions(+), 1 deletion(-) -- 1.8.5.3

2 4

[libvirt] [PATCH] lxc: Add destroy support for suspended domains
by Richard Weinberger 20 Feb '14

20 Feb '14

Destroying a suspended domain needs special action. We cannot simply terminate all process because they are frozen. Do deal with that we send them SIGKILL and thaw them. Upon wakeup the process sees the pending signal and dies immediately. Signed-off-by: Richard Weinberger <richard(a)nod.at> --- src/lxc/lxc_process.c | 25 +++++++++++++++++++++++++ 1 file changed, 25 insertions(+) diff --git a/src/lxc/lxc_process.c b/src/lxc/lxc_process.c index ed729f6..b518dce 100644 --- a/src/lxc/lxc_process.c +++ b/src/lxc/lxc_process.c @@ -697,6 +697,30 @@ int virLXCProcessStop(virLXCDriverPtr driver, VIR_FREE(vm->def->seclabels[0]->imagelabel); } + /* If the LXC domain is suspended we send all processes a SIGKILL + * and thaw them. Upon wakeup the process sees the pending signal + * and dies immediately. It is guaranteed that priv->cgroup != NULL + * here because the domain has aleady been suspended using the + * freezer cgroup. + */ + if (reason == VIR_DOMAIN_SHUTOFF_DESTROYED && + virDomainObjGetState(vm, NULL) == VIR_DOMAIN_PAUSED) { + if (virCgroupKillRecursive(priv->cgroup, SIGKILL) <= 0) { + virReportError(VIR_ERR_INTERNAL_ERROR, + _("Unable to kill all processes")); + return -1; + } + + if (virCgroupSetFreezerState(priv->cgroup, "THAWED") < 0) { + virReportError(VIR_ERR_OPERATION_FAILED, + _("Unable to thaw all processes")); + + return -1; + } + + goto cleanup; + } + if (priv->cgroup) { rc = virCgroupKillPainfully(priv->cgroup); if (rc < 0) @@ -716,6 +740,7 @@ int virLXCProcessStop(virLXCDriverPtr driver, } } +cleanup: virLXCProcessCleanup(driver, vm, reason); return 0; -- 1.8.4.5

2 1

[libvirt] [PATCH v10] bhyve: add a basic driver
by Roman Bogorodskiy 20 Feb '14

20 Feb '14

Changes from v9: - Fix AC_PATH_PROG macro usage for bhyve tools - Check for readdir() failures - Make sure we go only with disk type 'file' - Remove unneeded locking from bhyveConnectGetCapabilities() - Don't check for NULL before calling virObjectUnlock() - s/INFO/DEBUG/ for low level domain operations - Ignore logfd close errors in bhyve_process.c - Drop unneeded virReportError for virDomainDefParseString() - Indent and style fixes Changes from v8: - Implement domainUndefine and two more functions it depends on: domainIsActive and bhyveDomainIsPersistent Changes from v7: - Squashed in ACL support - Check for disk and bus type for bhyve and disk type for bhyveload - Handle case when URI == NULL in ConnectOpen - Call bhyveload only after we've built bhyve command to avoid unneeded load/reload for wrong domain configuration - Cleanup unload calls on errors - Minor style fixes Changes from v6: - Fix typo: s/LIBIVRT_DRIVER_RESULT_BHYVE/LIBVIRT_DRIVER_RESULT_BHYVE/ - Report domain state in 'dominfo' - Add a patch which implements ACL support Now both 'make check' and 'make syntax-check' pass. Changes from v5: - Obtain version using uname(3) - Cleanup driver global objects in StateCleanup instead of ConnectClose Changes from v4: - Set acpi and apic flags based on domain definition - Add more detailed description about -H and -P flags of bhyve to justify theirs usage Roman Bogorodskiy (1): bhyve: add a basic driver configure.ac | 7 + daemon/libvirtd.c | 9 + include/libvirt/virterror.h | 1 + m4/virt-driver-bhyve.m4 | 57 +++++ po/POTFILES.in | 3 + src/Makefile.am | 32 +++ src/bhyve/bhyve_command.c | 331 ++++++++++++++++++++++++ src/bhyve/bhyve_command.h | 41 +++ src/bhyve/bhyve_driver.c | 612 ++++++++++++++++++++++++++++++++++++++++++++ src/bhyve/bhyve_driver.h | 28 ++ src/bhyve/bhyve_process.c | 224 ++++++++++++++++ src/bhyve/bhyve_process.h | 36 +++ src/bhyve/bhyve_utils.h | 48 ++++ src/conf/domain_conf.c | 3 +- src/conf/domain_conf.h | 1 + src/driver.h | 1 + src/libvirt.c | 3 + src/util/virerror.c | 1 + 18 files changed, 1437 insertions(+), 1 deletion(-) create mode 100644 m4/virt-driver-bhyve.m4 create mode 100644 src/bhyve/bhyve_command.c create mode 100644 src/bhyve/bhyve_command.h create mode 100644 src/bhyve/bhyve_driver.c create mode 100644 src/bhyve/bhyve_driver.h create mode 100644 src/bhyve/bhyve_process.c create mode 100644 src/bhyve/bhyve_process.h create mode 100644 src/bhyve/bhyve_utils.h -- 1.8.4.3

2 3

[libvirt] [PATCHv3 00/10] Add BlkIO and CPU/mem stat API implementations for lxc
by Thorsten Behrens 19 Feb '14

19 Feb '14

This patch set adds block io, memory and domain cpu statistics API slot implementations to the LXC driver, in order to get linux container monitoring and accounting a bit closer to qemu standards. The last patch is a tad quirky (happy to hear suggestions on alternative ways), in that it widens the permissible value set at the .domainBlockStats slot: for lxc guests, it is relatively likely to have zero disk devices, since host filesystems can be used via passthrough bind mounts. Therefore, passing the zero-length string as device path, is interpreted as 'return summary stats for the entire domains's block io'. v3 addresses review comments, and adds unit tests for good measure. Thorsten Behrens (10): Add util virCgroupGetBlkioIo*Serviced methods. Implement domainMemoryStats API slot for LXC driver. Make qemuGetDomainTotalCPUStats a virCgroup function. Implement domainGetCPUStats for lxc driver. Implement lxcDomainBlockStats* for lxc driver Widening API change - accept empty path for virDomainBlockStats Add unit test for virCgroupGetBlkioIo*Serviced Add unit test for virCgroupGetMemoryUsage. Fix misspelled cpuacct.usage_percpu in cgroup mock. Add unit test for virCgroupGetPercpuStats. src/libvirt.c | 8 +- src/libvirt_private.syms | 4 + src/lxc/lxc_driver.c | 297 +++++++++++++++++++++++++++++++++ src/qemu/qemu_driver.c | 54 +----- src/util/vircgroup.c | 382 +++++++++++++++++++++++++++++++++++++++++++ src/util/vircgroup.h | 24 +++ tests/vircgroupmock.c | 109 +++++++++++- tests/vircgrouptest.c | 234 ++++++++++++++++++++++++++ tools/virsh-domain-monitor.c | 11 +- tools/virsh.pod | 5 +- 10 files changed, 1066 insertions(+), 62 deletions(-) -- 1.8.4

3 23

[libvirt] [PATCH V2 00/13] libxl: add job support
by Jim Fehlig 19 Feb '14

19 Feb '14

This patch series adds job support to the libxl driver, using a simplified version of the technique used in the qemu driver. One benefit of this series is no longer blocking get operations during long running modify operations. E.g. with these patches 'vish dominfo dom' will work while 'virsh save dom ...' is in progress. The first two patches are new to the series, following review of V1. Patch1 changes the cleanup logic to unconditionally set dom id to -1 on domain shutdown. Patch2 removes libxlVmReap, giving callers more control over domain destruction/cleanup. The remaining patches are updates to V1 based on Daniel's and Michal's comments. Jim Fehlig (13): libxl: always set vm id to -1 on shutdown libxl: remove libxlVmReap function libxl: Add job support to libxl driver libxl: use job functions in libxlVmStart libxl: use job functions in libxlDomainSetMemoryFlags libxl: use job functions in libxlDomain{Suspend,Resume} libxl: use job functions when cleaning up a domain libxl: use job functions in domain save operations libxl: use job functions in libxlDomainCoreDump libxl: use job functions in vcpu set and pin functions libxl: use job functions in device attach and detach functions libxl: use job functions in libxlDomainSetAutostart libxl: use job functions in libxlDomainSetSchedulerParametersFlags src/libxl/libxl_domain.c | 128 +++++++++++++++ src/libxl/libxl_domain.h | 38 +++++ src/libxl/libxl_driver.c | 405 +++++++++++++++++++++++++++++++---------------- 3 files changed, 432 insertions(+), 139 deletions(-) -- 1.8.1.4

2 29

[libvirt] [PATCH 0/2] Introduce max_anonymous_clients
by Michal Privoznik 19 Feb '14

19 Feb '14

https://bugzilla.redhat.com/show_bug.cgi?id=981729 So far we can limit how many clients are connected, how many are waiting in accept() line but we could not control the count of accepted but not authenticated yet. Michal Privoznik (2): virNetServer: Introduce unauth clients counter daemon: Introduce max_anonymous_clients daemon/libvirtd-config.c | 1 + daemon/libvirtd-config.h | 1 + daemon/libvirtd.aug | 1 + daemon/libvirtd.c | 1 + daemon/libvirtd.conf | 3 ++ daemon/remote.c | 21 ++++++++----- daemon/test_libvirtd.aug.in | 1 + src/locking/lock_daemon.c | 4 +-- src/lxc/lxc_controller.c | 2 +- src/rpc/virnetserver.c | 73 +++++++++++++++++++++++++++++++++++++++++---- src/rpc/virnetserver.h | 3 ++ 11 files changed, 95 insertions(+), 16 deletions(-) -- 1.8.5.1

4 11

[libvirt] [PATCHv6 0/5] Handling of undefine and redefine snapshots with VirtualBox 4.2
by Manuel VIVES 19 Feb '14

19 Feb '14

Hi, This is a serie of patches in order to support undefining and redefining snapshots with VirtualBox 4.2. The serie of patches is rather big, and adds among other things some utility functions unrelated to VirtualBox in patches 1 & 2. The code review could be done in several parts: e.g. patches 1 & 2 separately to validate the utility functions. The VirtualBox API provides only high level operations to manipulate snapshots, so it not possible to support flags like VIR_DOMAIN_SNAPSHOT_CREATE_REDEFINE and VIR_DOMAIN_SNAPSHOT_DELETE_METADATA_ONLY with only API calls. Following an IRC talk with Eric Blake, the decision was taken to emulate these behaviours by manipulating directly the .vbox XML files. The first two patches are some util methods for handling regexp and strings that will be used after. The third patch brings more details in the snapshot XML returned by libvirt. We will need those modifications in order to redefine the snapshots. The fourth patch brings the support of the VIR_DOMAIN_SNAPSHOT_CREATE_REDEFINE and VIR_DOMAIN_SNAPSHOT_CREATE_CURRENT flags in virDomainSnapshotCreateXML. The fifth and last patch brings the support of the VIR_DOMAIN_SNAPSHOT_DELETE_METADATA_ONLY flag in virDomainSnapshotDelete. The patches are only tested with Virtualbox 4.2 but the code is compliant with Virtualbox 4.3 API. Regards, Manuel VIVES v6: * Rebased because of a massive change in vbox_tmpl.c due to changes in the handling of different versions of VirtualBox v5: * The patches are modified according to a first review by Laine Stump: * renamed virSearchUuid to virSearchRegex and moved it from viruuid.{c,h} to virstring.{c,h}. * Various fixes. V4: * The code is compliant with Virtualbox 4.3 API * Some minor modifications in order to satisfy "make syntax-check" V3: * Use of STREQ_NULLABLE instead of STREQ in one case * Fix the method for finding uuids according to Ján Tomko review V2: * Fix a licence problem with the method for string replacement Manuel VIVES (5): virstring.h/c: Util method for finding regexp patterns in some strings virstring.h/c: Util method for making some find and replace in strings vbox_tmpl.c: Better XML description for snapshots vbox_tmpl.c: Patch for redefining snapshots vbox_tmpl.c: Add methods for undefining snapshots po/POTFILES.in | 1 + src/libvirt_private.syms | 2 + src/util/virstring.c | 163 +++- src/util/virstring.h | 4 + src/vbox/vbox_tmpl.c | 2346 ++++++++++++++++++++++++++++++++++++++++++---- 5 files changed, 2346 insertions(+), 170 deletions(-) -- 1.7.10.4

3 11