I digged a little deeper and printed some extra information in functions
xc_linux_save and xc_map_foreign_range. Hope it will help with identifying the
problem.
XFRD log:
6682 [INF] XFRD> Accepted connection from 127.0.0.1:1027 on 2
6865 [INF] XFRD> Xfr service for 127.0.0.1:1027
[DEBUG] Conn_init> flags=1
[DEBUG] Conn_init> write stream...
[DEBUG] stream_init>mode=w flags=1 compress=0
[DEBUG] stream_init> unbuffer...
[DEBUG] stream_init< err=0
[DEBUG] Conn_init> read stream...
[DEBUG] stream_init>mode=r flags=1 compress=0
[DEBUG] stream_init> unbuffer...
[DEBUG] stream_init< err=0
[DEBUG] Conn_sxpr>
(xfr.hello 1 0)[DEBUG] Conn_sxpr< err=0
[DEBUG] Conn_sxpr>
(xfr.save 1 "(domain (id 1) (name VM1) (memory 31) (maxmem 32768) (state -b---)
(cpu 0) (cpu_time 11.561731071) (up_time 177.706912041) (start_time
1107773243.83) (console (status listening) (id 12) (domain 1) (local_port 12)
(remote_port 1) (console_port 9601)) (devices (vif (idx 0) (vif 0) (mac
aa:00:00:00:00:11) (bridge xen-br1) (evtchn 14 4) (index 0)) (vbd (idx 0) (vdev
770) (device 1792) (mode w) (dev hda2) (uname file:/root/vmdisk1) (node
/dev/loop0) (index 0)) (vbd (idx 1) (vdev 775) (device 775) (mode r) (dev hda7)
(uname phy:hda7) (node hda7) (index 1)) (vbd (idx 2) (vdev 771) (device 773)
(mode w) (dev hda3) (uname phy:hda5) (node hda5) (index 2))) (config (vm (name
VM1) (memory 32) (cpu 1) (image (linux (kernel /boot/vmlinuz-2.6.10-xenU) (root
'/dev/hda2 ro') (args '3 VMID=1'))) (device (vbd (uname file:/root/vmdisk1)
(dev hda2) (mode w))) (device (vbd (uname phy:hda7) (dev hda7) (mode r)))
(device (vbd (uname phy:hda5) (dev hda3) (mode w))) (device (vif (mac aa:0
0:00:00:00:11) (bridge xen-br1))))))" /root/vm1.image)[DEBUG] Conn_sxpr< err=0
[1107773421.550889] xc_linux_save start 1
xc_linux_save start 1
[1107773421.551005] HZY > before mapping the shared info frame
HZY > before mapping the shared info frame
before mmap
: Illegal seek
HZY > after mmap: Illegal seek
HZY > ioctl error: Bad address
HZY > after munmap: Bad address
HZY> after memcpy
XEND-DEBUG log
network start bridge=xen-br0 netdev=eth0 antispoof=no
before mmap
: Resource temporarily unavailable
HZY > after mmap: Invalid argument
VIRTUAL MEMORY ARRANGEMENT:
Loaded kernel: c0100000->c03421c4
Init. ramdisk: c0343000->c0343000
Phys-Mach map: c0343000->c034b000
Page tables: c034b000->c034d000
Start info: c034d000->c034e000
Boot stack: c034e000->c034f000
TOTAL: c0000000->c0400000
ENTRY ADDRESS: c0100000
before mmap
: Success
HZY > after mmap: Success
before mmap
: Success
HZY > after mmap: Success
before mmap
: Success
HZY > after mmap: Success
before mmap
: Success
<snipped>
HZY > after mmap: Success
before mmap
: Success
HZY > after mmap: Success
/dev/loop: Is a directory
before mmap
: Success
HZY > after mmap: Success
vif-bridge up vif=vif1.0 domain=VM1 mac=aa:00:00:00:00:11 bridge=xen-br1
recv_fe_driver_status> {'status': 1}
recv_fe_driver_status>
recv_fe_interface_connect {'tx_shmem_frame': 4343, 'rx_shmem_frame': 4342,
'handle': 0}
sync_session> <type 'str'> 1 ['save', ['id', '1'], ['state', 'begin'],
['domain', '1'], ['file', '/root/vm1.image']]
Started to connect self= <xen.xend.XendMigrate.XfrdClientFactory instance at
0xb774a7cc> connector= <twisted.internet.tcp.Connector instance at 0xb774a7ec>
buildProtocol> IPv4Address(TCP, 'localhost', 8002)
***request> (domain (id 1) (name VM1) (memory 31) (maxmem 32768) (state -b---)
(cpu 0) (cpu_time 11.561731071) (up_time 177.701762915) (start_time
1107773243.83) (console (status listening) (id 12) (domain 1) (local_port 12)
(remote_port 1) (console_port 9601)) (devices (vif (idx 0) (vif 0) (mac
aa:00:00:00:00:11) (bridge xen-br1) (evtchn 14 4) (index 0)) (vbd (idx 0) (vdev
770) (device 1792) (mode w) (dev hda2) (uname file:/root/vmdisk1) (node
/dev/loop0) (index 0)) (vbd (idx 1) (vdev 775) (device 775) (mode r) (dev hda7)
(uname phy:hda7) (node hda7) (index 1)) (vbd (idx 2) (vdev 771) (device 773)
(mode w) (dev hda3) (uname phy:hda5) (node hda5) (index 2))) (config (vm (name
VM1) (memory 32) (cpu 1) (image (linux (kernel /boot/vmlinuz-2.6.10-xenU) (root
'/dev/hda2 ro') (args '3 VMID=1'))) (device (vbd (uname file:/root/vmdisk1)
(dev hda2) (mode w))) (device (vbd (uname phy:hda7) (dev hda7) (mode r)))
(device (vbd (uname phy:hda5) (dev hda3) (mode w))) (device (vif (mac aa:00
:00:00:00:11) (bridge xen-br1))))))
***request> begin
xfr_err> ['xfr.err', '0']
xfr_err> <type 'str'> 0
Xfrd>connectionLost> [Failure instance: Traceback:
twisted.internet.error.ConnectionDone, Connection was closed cleanly.
]
XfrdSaveInfo>connectionLost> [Failure instance: Traceback:
twisted.internet.error.ConnectionDone, Connection was closed cleanly.
]
XfrdInfo>connectionLost> [Failure instance: Traceback:
twisted.internet.error.ConnectionDone, Connection was closed cleanly.
]
Error> save failed
Error> calling errback
***cbremove> [Failure instance: Traceback: xen.xend.XendError.XendError, save
failed
]
***_delete_session> 1
clientConnectionLost> connector= <twisted.internet.tcp.Connector instance at
0xb774a7ec> reason= [Failure instance: Traceback:
twisted.internet.error.ConnectionDone, Connection was closed cleanly.
]
ss
HZY > after mmap: Success
before mmap
: Success
HZY > after mmap: Success
before mmap
: Success
<snipped>
HZY > after mmap: Success
before mmap
: Success
HZY > after mmap: Success
before mmap
: Success
HZY > after mmap: Success
before mmap
: Success
HZY > after mmap: Success
/dev/loop: Is a directory
vif-bridge up vif=vif1.0 domain=VM1 mac=aa:00:00:00:00:11 bridge=xen-br1
recv_fe_driver_status> {'status': 1}
recv_fe_driver_status>
recv_fe_interface_connect {'tx_shmem_frame': 4339, 'rx_shmem_frame': 4338,
'handle': 0}
sync_session> <type 'str'> 1 ['save', ['id', '1'], ['state', 'begin'],
['domain', '1'], ['file', '/root/vm1.image']]
Started to connect self= <xen.xend.XendMigrate.XfrdClientFactory instance at
0xb774abac> connector= <twisted.internet.tcp.Connector instance at 0xb774ac2c>
buildProtocol> IPv4Address(TCP, 'localhost', 8002)
***request> (domain (id 1) (name VM1) (memory 31) (maxmem 32768) (state -b---)
(cpu 0) (cpu_time 11.441523168) (up_time 101.722494841) (start_time
1107771790.92) (console (status listening) (id 12) (domain 1) (local_port 12)
(remote_port 1) (console_port 9601)) (restart_time 1107771820.82) (devices (vif
(idx 0) (vif 0) (mac aa:00:00:00:00:11) (bridge xen-br1) (evtchn 16 4) (index
0)) (vbd (idx 0) (vdev 770) (device 1792) (mode w) (dev hda2) (uname
file:/root/vmdisk1) (node /dev/loop0) (index 0)) (vbd (idx 1) (vdev 775)
(device 775) (mode r) (dev hda7) (uname phy:hda7) (node hda7) (index 1)) (vbd
(idx 2) (vdev 771) (device 773) (mode w) (dev hda3) (uname phy:hda5) (node
hda5) (index 2))) (config (vm (name VM1) (memory 32) (cpu 1) (image (linux
(kernel /boot/vmlinuz-2.6.10-xenU) (root '/dev/hda2 ro') (args '3 VMID=1')))
(device (vbd (uname file:/root/vmdisk1) (dev hda2) (mode w))) (device (vbd
(uname phy:hda7) (dev hda7) (mode r))) (device (vbd (uname phy:hda5) (dev hda3)
(mode
w))) (device (vif (mac aa:00:00:00:00:11) (bridge xen-br1))))))
***request> begin
xfr_err> ['xfr.err', '0']
xfr_err> <type 'str'> 0
Xfrd>connectionLost> [Failure instance: Traceback:
twisted.internet.error.ConnectionLost, Connection to the other side was lost in
a non-clean fashion.
]
XfrdSaveInfo>connectionLost> [Failure instance: Traceback:
twisted.internet.error.ConnectionLost, Connection to the other side was lost in
a non-clean fashion.
XfrdInfo>connectionLost> [Failure instance: Traceback:
twisted.internet.error.ConnectionLost, Connection to the other side was lost in
a non-clean fashion.]Error> save failedError> calling errback***cbremove>
[Failure instance: Traceback: xen.xend.XendError.XendError, save
failed]***_delete_session> 2clientConnectionLost> connector=
<twisted.internet.tcp.Connector instance at 0xb774e10c> reason= [Failure
instance: Traceback: twisted.internet.error.ConnectionLost, Connection to the
other side was lost in a non-clean fashion.]sync_session> <type 'str'> 3
['save', ['id', '3'], ['state', 'begin'], ['domain', '1'], ['file',
'/root/vm1.image']]Started to connect self=
<xen.xend.XendMigrate.XfrdClientFactory instance at 0xb774e50c> connector=
<twisted.internet.tcp.Connector instance at 0xb774e54c>buildProtocol>
IPv4Address(TCP, 'localhost', 8002)
***request> (domain (id 1) (name VM1) (memory 31) (maxmem 32768) (state -b---)
(cpu 0) (cpu_time 11.478751155) (up_time 171.16286993) (start_time
1107771790.92) (console (status listening) (id 12) (domain 1) (local_port 12)
(remote_port 1) (console_port 9601)) (restart_time 1107771820.82) (devices (vif
(idx 0) (vif 0) (mac aa:00:00:00:00:11) (bridge xen-br1) (evtchn 16 4) (index
0)) (vbd (idx 0) (vdev 770) (device 1792) (mode w) (dev hda2) (uname
file:/root/vmdisk1) (node /dev/loop0) (index 0)) (vbd (idx 1) (vdev 775)
(device 775) (mode r) (dev hda7) (uname phy:hda7) (node hda7) (index 1)) (vbd
(idx 2) (vdev 771) (device 773) (mode w) (dev hda3) (uname phy:hda5) (node
hda5) (index 2))) (config (vm (name VM1) (memory 32) (cpu 1) (image (linux
(kernel /boot/vmlinuz-2.6.10-xenU) (root '/dev/hda2 ro') (args '3 VMID=1')))
(device (vbd (uname file:/root/vmdisk1) (dev hda2) (mode w))) (device (vbd
(uname phy:hda7) (dev hda7) (mode r))) (device (vbd (uname phy:hda5) (dev hda3)
(mode
w))) (device (vif (mac aa:00:00:00:00:11) (bridge xen-br1))))))***request>
beginxfr_err> ['xfr.err', '0']xfr_err> <type 'str'> 0Xfrd>connectionLost>
[Failure instance: Traceback: twisted.internet.error.ConnectionLost, Connection
to the other side was lost in a non-clean fashion.]XfrdSaveInfo>connectionLost>
[Failure instance: Traceback: twisted.internet.error.ConnectionLost, Connection
to the other side was lost in a non-clean fashion.]XfrdInfo>connectionLost>
[Failure instance: Traceback: twisted.internet.error.ConnectionLost, Connection
to the other side was lost in a non-clean fashion.]Error> save failedError>
calling errback***cbremove> [Failure instance: Traceback:
xen.xend.XendError.XendError, save failed]***_delete_session>
3clientConnectionLost> connector= <twisted.internet.tcp.Connector instance at
0xb774e54c> reason= [Failure instance: Traceback:
twisted.internet.error.ConnectionLost, Connection to the other side was lost in
a non-clean fashion.]VirqClient.virqRece
ived> 4vif-bridge down vif=vif1.0 domain=VM1 mac=aa:00:00:00:00:11
bridge=xen-br1
before mmap
: Resource temporarily unavailable
HZY > after mmap: Resource temporarily unavailable
VIRTUAL MEMORY ARRANGEMENT:
Loaded kernel: c0100000->c03421c4
Init. ramdisk: c0343000->c0343000
Phys-Mach map: c0343000->c034b000
Page tables: c034b000->c034d000
Start info: c034d000->c034e000
Boot stack: c034e000->c034f000
TOTAL: c0000000->c0400000
ENTRY ADDRESS: c0100000
before mmap: SuccessHZY > after mmap: Successbefore mmap: SuccessHZY > after
mmap: Successbefore mmap: SuccessHZY > after mmap: Success
<snipped>
HZY > after mmap: Successbefore mmap: SuccessHZY > after mmap:
Success/dev/loop: Is a directoryvif-bridge up vif=vif2.0 domain=VM1
mac=aa:00:00:00:00:11 bridge=xen-br1recv_fe_driver_status> {'status':
1}recv_fe_driver_status>recv_fe_interface_connect {'tx_shmem_frame': 4343,
'rx_shmem_frame': 4342, 'handle': 0}sync_session> <type 'str'> 4 ['save',
['id', '4'], ['state', 'begin'], ['domain', '2'], ['file',
'/root/vm1.image']]Started to connect self=
<xen.xend.XendMigrate.XfrdClientFactory instance at 0xb76d226c> connector=
<twisted.internet.tcp.Connector instance at 0xb76d228c>buildProtocol>
IPv4Address(TCP, 'localhost', 8002)***request> (domain (id 2) (name VM1)
(memory 31) (maxmem 32768) (state -b---) (cpu 0) (cpu_time 11.470650509)
(up_time 51.1459019184) (start_time 1107772061.86) (console (status listening)
(id 12) (domain 2) (local_port 12) (remote_port 1) (console_port 9602))
(devices (vif (idx 0) (vif 0) (mac aa:00:00:00:00:11) (bridge xen-br1) (evtchn
18 4) (index 0))
(vbd (idx 0) (vdev 770) (device 1792) (mode w) (dev hda2) (uname
file:/root/vmdisk1) (node /dev/loop0) (index 0)) (vbd (idx 1) (vdev 775)
(device 775) (mode r) (dev hda7) (uname phy:hda7) (node hda7) (index 1)) (vbd
(idx 2) (vdev 771) (device 773) (mode w) (dev hda3) (uname phy:hda5) (node
hda5) (index 2))) (config (vm (name VM1) (memory 32) (cpu 1) (image (linux
(kernel /boot/vmlinuz-2.6.10-xenU) (root '/dev/hda2 ro') (args '3 VMID=1')))
(device (vbd (uname file:/root/vmdisk1) (dev hda2) (mode w))) (device (vbd
(uname phy:hda7) (dev hda7) (mode r))) (device (vbd (uname phy:hda5) (dev hda3)
(mode w))) (device (vif (mac aa:00:00:00:00:11) (bridge
xen-br1))))))***request> beginxfr_err> ['xfr.err', '0']xfr_err> <type 'str'>
0Xfrd>connectionLost> [Failure instance: Traceback:
twisted.internet.error.ConnectionDone, Connection was closed
cleanly.]XfrdSaveInfo>connectionLost> [Failure instance: Traceback:
twisted.internet.error.ConnectionDone, Connection was closed cleanly.]XfrdIn
fo>connectionLost> [Failure instance: Traceback:
twisted.internet.error.ConnectionDone, Connection was closed cleanly.]
]Error> save failedError> calling errback***cbremove> [Failure instance:
Traceback: xen.xend.XendError.XendError, save failed]***_delete_session>
4clientConnectionLost> connector= <twisted.internet.tcp.Connector instance at
0xb76d228c> reason= [Failure instance: Traceback:
twisted.internet.error.ConnectionDone, Connection was closed
cleanly.]VirqClient.virqReceived> 4vif-bridge down vif=vif2.0 domain=VM1
mac=aa:00:00:00:00:11 bridge=xen-br1
--------------------------
Zhiyi from EPFL Switzerland
-------------------------------------------------------
SF email is sponsored by - The IT Product Guide
Read honest & candid reviews on hundreds of IT Products from real users.
Discover which products truly live up to the hype. Start reading now.
http://ads.osdn.com/?ad_id=6595&alloc_id=14396&op=click
_______________________________________________
Xen-devel mailing list
Xen-devel@xxxxxxxxxxxxxxxxxxxxx
https://lists.sourceforge.net/lists/listinfo/xen-devel
|