On Tue, 2005-08-30 at 14:51 -0400, Ted Kaczmarek wrote:> Using 2.6.12-1.1447_FC4xen0 from FC4 testing updates.
> Xend will start most of the time, vm will rarely start, and even less
> liklely to complete booting, most common error is
> "12, ''Cannot allocate memory''" at cli when
starting vm.
>
> Test machine is an SMP Atlon with 1 gig on ram.
>
> cat /var/log/xend.log
>
> [2005-08-30 14:45:10 xend] INFO (SrvDaemon:300) Xend Daemon started
> [2005-08-30 14:45:10 xend] INFO (channel:163) Virq 3 on port 19
> [2005-08-30 14:45:10 xend] INFO (XendDomain:356) Creating entry for
> unknown domain: id=0 uuid=a980a99f-8eb3-4cdf-8d59-93388419f366
> [2005-08-30 14:45:10 xend] DEBUG (XendDomainInfo:180)
> info={''vcpu_to_cpu'': [0, 1, -1, -1, -1, -1, -1, -1, -1,
-1, -1, -1, -1,
> -1, -1, -1, -1, -1, -1, -1, -1, -1, -1, -1, -1, -1, -1, -1, -1, -1, -1,
> -1], ''cpu_time'': 103922623839L,
''ssidref'': 0, ''shutdown_reason'': 0,
> ''dying'': 0, ''dom'': 0,
''running'': 1, ''maxmem_kb'': -4,
''paused'': 0,
> ''crashed'': 0, ''vcpus'': 2,
''shutdown'': 0, ''mem_kb'': 846848,
''cpumap'':
> [-1, -1, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0,
> 0, 0, 0, 0, 0, 0, 0, 0, 0], ''blocked'': 0}
> [2005-08-30 14:45:10 xend] DEBUG (XendDomainInfo:181)
config=''None''
>
> [2005-08-30 14:45:10 xend] INFO (xsobj:326) DBMap>introduceDomain> 0
> 117556 <EventChannel dom1:0:24
> dom2:0:25> /domain/a980a99f-8eb3-4cdf-8d59-93388419f366
> [2005-08-30 14:45:10 xend] DEBUG (XendDomainInfo:640) writing key
> availability=online to path /cpu/0 in store
> [2005-08-30 14:45:10 xend] DEBUG (XendDomainInfo:640) writing key
> availability=online to path /cpu/1 in store
> [2005-08-30 14:45:10 xend] INFO (XendRoot:141) EVENT> xend.domain.create
> [''Domain-0'', 0]
> [2005-08-30 14:45:10 xend] INFO (SrvServer:78) unix
> path=/var/lib/xend/xend-socket
> [2005-08-30 14:45:10 xend] INFO (XendRoot:141) EVENT> xend.start 0
> [2005-08-30 14:45:10 xend] ERROR (process:37) [network-bridge] + set -e
> [2005-08-30 14:45:10 xend] ERROR (process:37) [network-bridge] +
> OP=start
> [2005-08-30 14:45:10 xend] ERROR (process:37) [network-bridge] + shift
> [2005-08-30 14:45:10 xend] ERROR (process:37) [network-bridge] + for arg
> in ''"$@"''
> [2005-08-30 14:45:10 xend] ERROR (process:37) [network-bridge] + export
> bridge=xen-br0
> [2005-08-30 14:45:10 xend] ERROR (process:37) [network-bridge] +
> bridge=xen-br0
> [2005-08-30 14:45:10 xend] ERROR (process:37) [network-bridge] + for arg
> in ''"$@"''
> [2005-08-30 14:45:10 xend] ERROR (process:37) [network-bridge] + export
> antispoof=no
> [2005-08-30 14:45:10 xend] ERROR (process:37) [network-bridge] +
> antispoof=no
> [2005-08-30 14:45:10 xend] ERROR (process:37) [network-bridge] +
> bridge=xen-br0
> [2005-08-30 14:45:10 xend] ERROR (process:37) [network-bridge] +
> netdev=eth0
> [2005-08-30 14:45:10 xend] ERROR (process:37) [network-bridge] +
> antispoof=no
> [2005-08-30 14:45:10 xend] ERROR (process:37) [network-bridge] + echo
> ''*network start bridge=xen-br0 netdev=eth0 antispoof=no''
> [2005-08-30 14:45:10 xend] INFO (process:35) [network-bridge] network
> start bridge=xen-br0 netdev=eth0 antispoof=no
> [2005-08-30 14:45:10 xend] ERROR (process:37) [network-bridge] + case
> ${OP} in
> [2005-08-30 14:45:10 xend] ERROR (process:37) [network-bridge] +
> op_start
> [2005-08-30 14:45:10 xend] ERROR (process:37) [network-bridge] +
''[''
> xen-br0 == null '']''
> [2005-08-30 14:45:10 xend] ERROR (process:37) [network-bridge] +
> create_bridge xen-br0
> [2005-08-30 14:45:10 xend] ERROR (process:37) [network-bridge] + local
> bridge=xen-br0
> [2005-08-30 14:45:10 xend] ERROR (process:37) [network-bridge] + brctl
> show
> [2005-08-30 14:45:10 xend] ERROR (process:37) [network-bridge] + grep -q
> xen-br0
> [2005-08-30 14:45:10 xend] ERROR (process:37) [network-bridge] +
> ifconfig xen-br0 up
> [2005-08-30 14:45:10 xend] ERROR (process:37) [network-bridge] +
> ifconfig
> [2005-08-30 14:45:10 xend] ERROR (process:37) [network-bridge] + grep -q
> veth0
> [2005-08-30 14:45:10 xend] ERROR (process:37) [network-bridge] +
> ifconfig veth0
> [2005-08-30 14:45:10 xend] ERROR (process:37) [network-bridge] + grep -q
> veth0
> [2005-08-30 14:45:11 xend] ERROR (process:37) [network-bridge] +
> transfer_addrs eth0 xen-br0
> [2005-08-30 14:45:11 xend] ERROR (process:37) [network-bridge] + local
> src=eth0
> [2005-08-30 14:45:11 xend] ERROR (process:37) [network-bridge] + local
> dst=xen-br0
> [2005-08-30 14:45:11 xend] ERROR (process:37) [network-bridge] + ip addr
> show dev xen-br0
> [2005-08-30 14:45:11 xend] ERROR (process:37) [network-bridge] + egrep
> -q ''^ *inet ''
> [2005-08-30 14:45:11 xend] ERROR (process:37) [network-bridge] + ip addr
> show dev eth0
> [2005-08-30 14:45:11 xend] ERROR (process:37) [network-bridge] + egrep
> ''^ *inet ''
> [2005-08-30 14:45:11 xend] ERROR (process:37) [network-bridge] + sed -e
> ''
> [2005-08-30 14:45:11 xend] ERROR (process:37) [network-bridge] s/inet/ip
> addr add/
> [2005-08-30 14:45:11 xend] ERROR (process:37) [network-bridge] s@
> \([0-9]\+\.[0-9]\+\.[0-9]\+\.[0-9]\+/[0-9]\+\)@\1@
> [2005-08-30 14:45:11 xend] ERROR (process:37) [network-bridge]
> s/eth0/dev xen-br0/
> [2005-08-30 14:45:11 xend] ERROR (process:37) [network-bridge] ''
> [2005-08-30 14:45:11 xend] ERROR (process:37) [network-bridge] + sh -e
> [2005-08-30 14:45:11 xend] ERROR (process:37) [network-bridge] + ip
> route list
> [2005-08-30 14:45:11 xend] ERROR (process:37) [network-bridge] + sed -ne
> ''
> [2005-08-30 14:45:11 xend] ERROR (process:37) [network-bridge] /dev
> xen-br0\( \|$\)/ {
> [2005-08-30 14:45:11 xend] ERROR (process:37) [network-bridge] s/^/ip
> route del /
> [2005-08-30 14:45:11 xend] ERROR (process:37) [network-bridge] p
> [2005-08-30 14:45:11 xend] ERROR (process:37) [network-bridge] }''
> [2005-08-30 14:45:11 xend] ERROR (process:37) [network-bridge] + sh -e
> [2005-08-30 14:45:11 xend] ERROR (process:37) [network-bridge] +
> transfer_routes eth0 xen-br0
> [2005-08-30 14:45:11 xend] ERROR (process:37) [network-bridge] + local
> src=eth0
> [2005-08-30 14:45:11 xend] ERROR (process:37) [network-bridge] + local
> dst=xen-br0
> [2005-08-30 14:45:11 xend] ERROR (process:37) [network-bridge] + ip
> route list
> [2005-08-30 14:45:11 xend] ERROR (process:37) [network-bridge] + sed -ne
> ''
> [2005-08-30 14:45:11 xend] ERROR (process:37) [network-bridge] /dev eth0
> \( \|$\)/ {
> [2005-08-30 14:45:11 xend] ERROR (process:37) [network-bridge] h
> [2005-08-30 14:45:11 xend] ERROR (process:37) [network-bridge] s/^/ip
> route del /
> [2005-08-30 14:45:11 xend] ERROR (process:37) [network-bridge] P
> [2005-08-30 14:45:11 xend] ERROR (process:37) [network-bridge] g
> [2005-08-30 14:45:11 xend] ERROR (process:37) [network-bridge]
> s/eth0/xen-br0/
> [2005-08-30 14:45:11 xend] ERROR (process:37) [network-bridge] s/^/ip
> route add /
> [2005-08-30 14:45:11 xend] ERROR (process:37) [network-bridge] P
> [2005-08-30 14:45:11 xend] ERROR (process:37) [network-bridge] d
> [2005-08-30 14:45:11 xend] ERROR (process:37) [network-bridge] }''
> [2005-08-30 14:45:11 xend] ERROR (process:37) [network-bridge] + sh -e
> [2005-08-30 14:45:11 xend] ERROR (process:37) [network-bridge] +
''['' no
> == yes '']''
>
> cat /var/log/xend-debug.log
> Traceback (most recent call last):
> File "/usr/lib/python2.4/logging/handlers.py", line 62, in emit
> if self.shouldRollover(record):
> File "/usr/lib/python2.4/logging/handlers.py", line 132, in
> shouldRollover
> self.stream.seek(0, 2) #due to non-posix-compliant Windows feature
> ValueError: I/O operation on closed file
> Traceback (most recent call last):
> File
"/usr/lib/python2.4/site-packages/xen/xend/XendDomainInfo.py",
> line 590, in construct
> self.init_domain()
> File
"/usr/lib/python2.4/site-packages/xen/xend/XendDomainInfo.py",
> line 778, in init_domain
> id = self.image.initDomain(self.id, self.memory, self.ssidref, cpu,
> self.cpu_weight)
> File "/usr/lib/python2.4/site-packages/xen/xend/image.py", line
159,
> in initDomain
> xc.domain_memory_increase_reservation(dom, mem_kb)
> error: (12, ''Cannot allocate memory'')
> Traceback (most recent call last):
> File
>
"/usr/lib/python2.4/site-packages/xen/xend/server/SrvDomainDir.py",
line
> 78, in op_create
> dominfo = self.xd.domain_create(config)
> File "/usr/lib/python2.4/site-packages/xen/xend/XendDomain.py",
line
> 292, in domain_create
> dominfo = XendDomainInfo.create(self.dbmap, config)
> File
"/usr/lib/python2.4/site-packages/xen/xend/XendDomainInfo.py",
> line 161, in create
> vm.construct(config)
> File
"/usr/lib/python2.4/site-packages/xen/xend/XendDomainInfo.py",
> line 590, in construct
> self.init_domain()
> File
"/usr/lib/python2.4/site-packages/xen/xend/XendDomainInfo.py",
> line 778, in init_domain
> id = self.image.initDomain(self.id, self.memory, self.ssidref, cpu,
> self.cpu_weight)
> File "/usr/lib/python2.4/site-packages/xen/xend/image.py", line
159,
> in initDomain
> xc.domain_memory_increase_reservation(dom, mem_kb)
> error: (12, ''Cannot allocate memory'')
>
>
> Regards,
> Ted
>
>
> _______________________________________________
The patch at
http://lists.xensource.com/archives/html/xen-devel/2005-08/msg00649.html
seems to have resolved most of the issues I was seeing :-)
Regards,
Ted
_______________________________________________
Xen-devel mailing list
Xen-devel@lists.xensource.com
http://lists.xensource.com/xen-devel