Attachment 573541 Details for Bug 807907 – libvirtd.log

libvirtd.log

migration-fail2.log (text/plain), 8.32 KB, created by weizhang on 2012-03-29 06:10:28 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: weizhang

Created: 2012-03-29 06:10:28 UTC

Size: 8.32 KB

patch

obsolete

>2012-03-29 05:53:17.854+0000: 26431: debug : virDomainObjUnref:1622 : obj=0x7efef002ffb0 refs=3
>2012-03-29 05:53:17.854+0000: 26431: debug : virConnectIsAlive:18315 : conn=0x7efedc00a1c0
>2012-03-29 05:53:17.859+0000: 27957: debug : virStreamSend:14834 : stream=0x7efedc103d30, data=0x7efecc0008c0, nbytes=65536
>2012-03-29 05:53:17.867+0000: 27957: debug : virStreamSend:14834 : stream=0x7efedc103d30, data=0x7efecc0008c0, nbytes=65536
>2012-03-29 05:53:17.892+0000: 27957: debug : virStreamSend:14834 : stream=0x7efedc103d30, data=0x7efecc0008c0, nbytes=65536
>2012-03-29 05:53:17.900+0000: 27957: debug : virStreamSend:14834 : stream=0x7efedc103d30, data=0x7efecc0008c0, nbytes=65536
>2012-03-29 05:53:17.909+0000: 27957: debug : virStreamSend:14834 : stream=0x7efedc103d30, data=0x7efecc0008c0, nbytes=65536
>2012-03-29 05:53:17.909+0000: 26431: debug : virDomainObjRef:1615 : obj=0x7efef002ffb0 refs=4
>2012-03-29 05:53:17.909+0000: 26431: debug : qemuDomainObjBeginJobInternal:753 : Starting job: async nested (async=migration out)
>2012-03-29 05:53:17.917+0000: 27957: debug : virStreamSend:14834 : stream=0x7efedc103d30, data=0x7efecc0008c0, nbytes=65536
>2012-03-29 05:53:17.926+0000: 26431: debug : qemuMonitorRef:201 : QEMU_MONITOR_REF: mon=0x7efedc00a970 refs=3
>2012-03-29 05:53:17.926+0000: 26431: debug : qemuMonitorGetMigrationStatus:1735 : mon=0x7efedc00a970
>2012-03-29 05:53:17.926+0000: 26431: debug : qemuMonitorJSONCommandWithFd:235 : Send command '{"execute":"query-migrate","id":"libvirt-329"}' for write with FD -1
>2012-03-29 05:53:17.926+0000: 26431: debug : qemuMonitorSend:823 : QEMU_MONITOR_SEND_MSG: mon=0x7efedc00a970 msg={"execute":"query-migrate","id":"libvirt-329"}
> fd=-1
>2012-03-29 05:53:17.926+0000: 26426: warning : virKeepAliveTimer:182 : No response from client 0x7efedc00f030 after 5 keepalive messages in 29 seconds
>2012-03-29 05:53:17.926+0000: 27957: error : virNetClientIOEventLoop:1440 : internal error received hangup / error event on socket
>2012-03-29 05:53:17.926+0000: 26426: debug : qemuMonitorRef:201 : QEMU_MONITOR_REF: mon=0x7efedc00a970 refs=4
>2012-03-29 05:53:17.926+0000: 26426: debug : qemuMonitorIOWrite:432 : QEMU_MONITOR_IO_WRITE: mon=0x7efedc00a970 buf={"execute":"query-migrate","id":"libvirt-329"}
> len=48 ret=48 errno=11
>2012-03-29 05:53:17.926+0000: 26426: debug : qemuMonitorUnref:210 : QEMU_MONITOR_UNREF: mon=0x7efedc00a970 refs=3
>2012-03-29 05:53:17.927+0000: 26426: debug : qemuMonitorRef:201 : QEMU_MONITOR_REF: mon=0x7efedc00a970 refs=4
>2012-03-29 05:53:17.927+0000: 26426: debug : qemuMonitorIOProcess:327 : QEMU_MONITOR_IO_PROCESS: mon=0x7efedc00a970 buf={"return": {"status": "active", "ram": {"total": 554041344, "remaining": 315392000, "transferred": 225926552}}, "id": "libvirt-329"}
> len=134
>2012-03-29 05:53:17.927+0000: 26426: debug : qemuMonitorJSONIOProcessLine:122 : Line [{"return": {"status": "active", "ram": {"total": 554041344, "remaining": 315392000, "transferred": 225926552}}, "id": "libvirt-329"}]
>2012-03-29 05:53:17.928+0000: 26426: debug : qemuMonitorJSONIOProcessLine:142 : QEMU_MONITOR_RECV_REPLY: mon=0x7efedc00a970 reply={"return": {"status": "active", "ram": {"total": 554041344, "remaining": 315392000, "transferred": 225926552}}, "id": "libvirt-329"}
>2012-03-29 05:53:17.928+0000: 26426: debug : qemuMonitorJSONIOProcess:193 : Total used 134 bytes out of 134 available in buffer
>2012-03-29 05:53:17.928+0000: 26426: debug : qemuMonitorUnref:210 : QEMU_MONITOR_UNREF: mon=0x7efedc00a970 refs=3
>2012-03-29 05:53:17.928+0000: 26431: debug : qemuMonitorJSONCommandWithFd:240 : Receive command reply ret=0 rxObject=0x1a96ca0
>2012-03-29 05:53:17.928+0000: 26431: debug : qemuMonitorUnref:210 : QEMU_MONITOR_UNREF: mon=0x7efedc00a970 refs=2
>2012-03-29 05:53:17.946+0000: 26431: debug : virDomainObjUnref:1622 : obj=0x7efef002ffb0 refs=3
>2012-03-29 05:53:17.946+0000: 26431: debug : virConnectIsAlive:18315 : conn=0x7efedc00a1c0
>2012-03-29 05:53:17.946+0000: 26431: error : qemuMigrationWaitForCompletion:983 : operation failed: Lost connection to destination host
>2012-03-29 05:53:17.946+0000: 26431: debug : doPeer2PeerMigrate3:2313 : Finish3 0x7efedc00a1c0 ret=-1
>2012-03-29 05:53:17.946+0000: 26431: debug : virDomainObjRef:1615 : obj=0x7efef002ffb0 refs=4
>2012-03-29 05:53:17.946+0000: 26431: error : virNetClientSendInternal:1698 : internal error client socket is closed
>2012-03-29 05:53:17.946+0000: 26431: debug : virDomainObjUnref:1622 : obj=0x7efef002ffb0 refs=3
>2012-03-29 05:53:17.946+0000: 26431: debug : doPeer2PeerMigrate3:2346 : Confirm3 0x7efee8000ad0 ret=-1 vm=0x7efef002ffb0
>2012-03-29 05:53:17.946+0000: 26431: debug : qemuMigrationConfirm:2963 : driver=0x7efef00399b0, conn=0x7efee8000ad0, vm=0x7efef002ffb0, cookiein=(null), cookieinlen=0, flags=7, retcode=1
>2012-03-29 05:53:17.966+0000: 26431: debug : qemuMigrationEatCookie:747 : cookielen=0 cookie='(null)'
>2012-03-29 05:53:17.966+0000: 26431: debug : qemuProcessStartCPUs:2563 : Using lock state '(null)'
>2012-03-29 05:53:17.966+0000: 26431: debug : virDomainObjRef:1615 : obj=0x7efef002ffb0 refs=4
>2012-03-29 05:53:17.966+0000: 26431: debug : qemuDomainObjBeginJobInternal:753 : Starting job: async nested (async=migration out)
>2012-03-29 05:53:17.984+0000: 26431: debug : qemuMonitorRef:201 : QEMU_MONITOR_REF: mon=0x7efedc00a970 refs=3
>2012-03-29 05:53:17.984+0000: 26431: debug : qemuMonitorStartCPUs:1061 : mon=0x7efedc00a970
>2012-03-29 05:53:17.984+0000: 26431: debug : qemuMonitorJSONCommandWithFd:235 : Send command '{"execute":"cont","id":"libvirt-330"}' for write with FD -1
>2012-03-29 05:53:17.984+0000: 26431: debug : qemuMonitorSend:823 : QEMU_MONITOR_SEND_MSG: mon=0x7efedc00a970 msg={"execute":"cont","id":"libvirt-330"}
> fd=-1
>2012-03-29 05:53:17.984+0000: 26426: debug : qemuMonitorRef:201 : QEMU_MONITOR_REF: mon=0x7efedc00a970 refs=4
>2012-03-29 05:53:17.984+0000: 26426: debug : qemuMonitorIOWrite:432 : QEMU_MONITOR_IO_WRITE: mon=0x7efedc00a970 buf={"execute":"cont","id":"libvirt-330"}
> len=39 ret=39 errno=11
>2012-03-29 05:53:17.984+0000: 26426: debug : qemuMonitorUnref:210 : QEMU_MONITOR_UNREF: mon=0x7efedc00a970 refs=3
>2012-03-29 05:53:17.985+0000: 26426: debug : qemuMonitorRef:201 : QEMU_MONITOR_REF: mon=0x7efedc00a970 refs=4
>2012-03-29 05:53:17.985+0000: 26426: debug : qemuMonitorIOProcess:327 : QEMU_MONITOR_IO_PROCESS: mon=0x7efedc00a970 buf={"return": {}, "id": "libvirt-330"}
> len=37
>2012-03-29 05:53:17.985+0000: 26426: debug : qemuMonitorJSONIOProcessLine:122 : Line [{"return": {}, "id": "libvirt-330"}]
>2012-03-29 05:53:17.985+0000: 26426: debug : qemuMonitorJSONIOProcessLine:142 : QEMU_MONITOR_RECV_REPLY: mon=0x7efedc00a970 reply={"return": {}, "id": "libvirt-330"}
>2012-03-29 05:53:17.985+0000: 26426: debug : qemuMonitorJSONIOProcess:193 : Total used 37 bytes out of 37 available in buffer
>2012-03-29 05:53:17.985+0000: 26426: debug : qemuMonitorUnref:210 : QEMU_MONITOR_UNREF: mon=0x7efedc00a970 refs=3
>2012-03-29 05:53:17.985+0000: 26431: debug : qemuMonitorJSONCommandWithFd:240 : Receive command reply ret=0 rxObject=0x1a8e380
>2012-03-29 05:53:17.985+0000: 26431: debug : qemuMonitorUnref:210 : QEMU_MONITOR_UNREF: mon=0x7efedc00a970 refs=2
>2012-03-29 05:53:18.003+0000: 26431: debug : virDomainObjUnref:1622 : obj=0x7efef002ffb0 refs=3
>2012-03-29 05:53:18.005+0000: 26429: debug : virDomainGetJobInfo:16385 : dom=0x7efee0025460, (VM: name=rhel5u8-i386, uuid=7b8fbf99-f0d1-2389-97c3-e755e6df3af6), info=0x7efefcb78ae0
>2012-03-29 05:53:18.020+0000: 26431: debug : virDomainObjRef:1615 : obj=0x7efef002ffb0 refs=4
>2012-03-29 05:53:18.020+0000: 26431: debug : virConnectClose:1462 : conn=0x7efedc00a1c0
>2012-03-29 05:53:18.020+0000: 26429: debug : virDomainFree:2313 : dom=0x7efee0025460, (VM: name=rhel5u8-i386, uuid=7b8fbf99-f0d1-2389-97c3-e755e6df3af6)
>2012-03-29 05:53:18.022+0000: 26431: error : virNetClientSendInternal:1698 : internal error client socket is closed
>2012-03-29 05:53:18.022+0000: 26431: debug : virDomainObjUnref:1622 : obj=0x7efef002ffb0 refs=3
>2012-03-29 05:53:18.022+0000: 26431: debug : qemuDomainObjEndAsyncJob:887 : Stopping async job: migration out
>2012-03-29 05:53:18.039+0000: 26431: debug : virDomainObjUnref:1622 : obj=0x7efef002ffb0 refs=2
>2012-03-29 05:53:18.039+0000: 26431: debug : virDomainFree:2313 : dom=0x7efedc006d30, (VM: name=rhel5u8-i386, uuid=7b8fbf99-f0d1-2389-97c3-e755e6df3af6)
>2012-03-29 05:53:18.042+0000: 26426: debug : virConnectClose:1462 : conn=0x7efee8000ad0
>2012-03-29 05:53:18.044+0000: 26426: debug : qemuDriverCloseCallbackRunAll:661 : conn=0x7efee8000ad0
>

Actions: View

Attachments on bug 807907: 573541 | 576136 | 576137 | 600718 | 600719