> I poke around a little more in the xen logs to see if I can find any more
> useful info on the guest problem
>
At the bottom of this email is the latest error log snippet.
Are lines like the following normal?
INFO (XMLRPCServer:156) Opening Unix domain socket XML-RPC server on
/var/run/xend/xen-api.sock; authentication has been disabled for this
server.
This lines below shows Xend is actually crashing and restarting when
the guest is trying to be started
[2008-12-13 12:44:58 5833] CRITICAL (SrvDaemon:231) Xend died due to
signal 11! Restarting it.
[2008-12-13 12:44:58 6001] INFO (SrvDaemon:331) Xend Daemon started
It thens does a recreate, which adds a domain in a paused state.
xm create on the command dies out.
xm list shows an unnamed domain.
(my config was sent in the last email for reference)
Below is the full output of the xend.log
Once I am able to test again I will check the corresponding xend-debug
and domain-builder log
files.
Let me know if you have any thoughts on what to try next.
[2008-12-13 12:44:33 5834] INFO (SrvDaemon:331) Xend Daemon started
[2008-12-13 12:44:33 5834] INFO (SrvDaemon:335) Xend changeset: Tue
Dec 09 16:28:02 2008 +0000 18891:6595393a3d28.
[2008-12-13 12:44:34 5834] DEBUG (XendDomainInfo:140)
XendDomainInfo.recreate({'max_vcpu_id': 1, 'cpu_time': 18243317092L,
'ssidref': 0, 'hvm': 0, 'shutdown_reason': 0, 'dying': 0,
'online_vcpus': 2, 'domid': 0, 'paused': 0, 'crashed': 0, 'running':
1, 'maxmem_kb': 17179869180L, 'shutdown': 0, 'mem_kb': 521472L,
'handle': [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0], 'blocked':
0, 'name': 'Domain-0'})
[2008-12-13 12:44:34 5834] INFO (XendDomainInfo:157) Recreating domain
0, UUID 00000000-0000-0000-0000-000000000000. at /local/domain/0
[2008-12-13 12:44:34 5834] DEBUG (XendDomainInfo:2792) Storing VM
details: {'on_xend_stop': 'ignore', 'shadow_memory': '0', 'uuid':
'00000000-0000-0000-0000-000000000000', 'on_reboot': 'restart',
'image': '(linux (kernel ))', 'on_poweroff': 'destroy',
'bootloader_args': '', 'on_xend_start': 'ignore', 'on_crash':
'restart', 'xend/restart_count': '0', 'vcpus': '2', 'vcpu_avail': '3',
'bootloader': '', 'name': 'Domain-0'}
[2008-12-13 12:44:34 5834] DEBUG (XendDomainInfo:1417) Storing domain
details: {'name': 'Domain-0', 'console/limit': '1048576',
'memory/target': '521472', 'vm':
'/vm/00000000-0000-0000-0000-000000000000', 'domid': '0',
'cpu/0/availability': 'online', 'cpu/1/availability': 'online',
'control/platform-feature-multiprocessor-suspend': '1',
'console/type': 'xenconsoled'}
[2008-12-13 12:44:34 5834] DEBUG (XendDomain:452) Adding Domain: 0
[2008-12-13 12:44:34 5834] DEBUG (XendDomain:386) number of vcpus to use is 0
[2008-12-13 12:44:34 5834] DEBUG (XendDomainInfo:1501)
XendDomainInfo.handleShutdownWatch
[2008-12-13 12:44:34 5834] WARNING (XendAPI:690) API call:
VBD.set_device not found
[2008-12-13 12:44:34 5834] WARNING (XendAPI:690) API call:
VBD.set_type not found
[2008-12-13 12:44:34 5834] WARNING (XendAPI:690) API call:
session.get_all_records not found
[2008-12-13 12:44:34 5834] WARNING (XendAPI:690) API call:
event.get_record not found
[2008-12-13 12:44:34 5834] WARNING (XendAPI:690) API call:
event.get_all not found
[2008-12-13 12:44:34 5834] WARNING (XendAPI:690) API call:
VM.get_auto_power_on not found
[2008-12-13 12:44:34 5834] WARNING (XendAPI:690) API call:
VM.set_auto_power_on not found
[2008-12-13 12:44:34 5834] WARNING (XendAPI:690) API call:
VIF.get_network not found
[2008-12-13 12:44:34 5834] WARNING (XendAPI:690) API call:
VIF.set_device not found
[2008-12-13 12:44:34 5834] WARNING (XendAPI:690) API call: VIF.set_MAC not found
[2008-12-13 12:44:34 5834] WARNING (XendAPI:690) API call: VIF.set_MTU not found
[2008-12-13 12:44:34 5834] WARNING (XendAPI:690) API call:
debug.get_all not found
[2008-12-13 12:44:34 5834] INFO (XMLRPCServer:156) Opening Unix domain
socket XML-RPC server on /var/run/xend/xen-api.sock; authentication
has been disabled for this server.
[2008-12-13 12:44:34 5834] INFO (XMLRPCServer:156) Opening Unix domain
socket XML-RPC server on /var/run/xend/xmlrpc.sock.
[2008-12-13 12:44:57 5834] DEBUG (XendDomainInfo:92)
XendDomainInfo.create(['vm', ['name', 'ubuntu-hardy-jailtime'],
['memory', '20'], ['vcpus', 1], ['on_xend_start', 'ignore'],
['on_xend_stop', 'ignore'], ['image', ['linux', ['kernel',
'/boot/vmlinuz-2.6.28-rc8-tip'], ['ramdisk',
'/boot/initrd.img-2.6.28-rc8-tip'], ['root', '/dev/sda1 ro'], ['args',
'xencons=tty']]], ['device', ['tap', ['uname',
'tap:aio:/home/deshantm/ubuntu.8-04.64.img'], ['dev', 'sda1'],
['mode', 'w']]]])
[2008-12-13 12:44:57 5834] DEBUG (XendDomainInfo:2089)
XendDomainInfo.constructDomain
[2008-12-13 12:44:57 5834] DEBUG (balloon:166) Balloon: 2565820 KiB
free; need 2048; done.
[2008-12-13 12:44:57 5834] DEBUG (XendDomain:452) Adding Domain: 1
[2008-12-13 12:44:57 5834] DEBUG (XendDomainInfo:2258)
XendDomainInfo.initDomain: 1 256
[2008-12-13 12:44:57 5834] DEBUG (XendDomainInfo:2288)
_initDomain:shadow_memory=0x0, memory_static_max=0x1400000,
memory_static_min=0x0.
[2008-12-13 12:44:57 5834] DEBUG (balloon:166) Balloon: 2565812 KiB
free; need 21504; done.
[2008-12-13 12:44:58 5834] INFO (image:166) buildDomain os=linux dom=1 vcpus=1
[2008-12-13 12:44:58 5834] DEBUG (image:639) domid = 1
[2008-12-13 12:44:58 5834] DEBUG (image:640) memsize = 20
[2008-12-13 12:44:58 5834] DEBUG (image:641) image =
/boot/vmlinuz-2.6.28-rc8-tip
[2008-12-13 12:44:58 5834] DEBUG (image:642) store_evtchn = 1
[2008-12-13 12:44:58 5834] DEBUG (image:643) console_evtchn = 2
[2008-12-13 12:44:58 5834] DEBUG (image:644) cmdline =
root=/dev/sda1 ro xencons=tty
[2008-12-13 12:44:58 5834] DEBUG (image:645) ramdisk =
/boot/initrd.img-2.6.28-rc8-tip
[2008-12-13 12:44:58 5834] DEBUG (image:646) vcpus = 1
[2008-12-13 12:44:58 5834] DEBUG (image:647) features =
[2008-12-13 12:44:58 5834] DEBUG (image:648) flags = 0
[2008-12-13 12:44:58 5833] CRITICAL (SrvDaemon:231) Xend died due to
signal 11! Restarting it.
[2008-12-13 12:44:58 6001] INFO (SrvDaemon:331) Xend Daemon started
[2008-12-13 12:44:58 6001] INFO (SrvDaemon:335) Xend changeset: Tue
Dec 09 16:28:02 2008 +0000 18891:6595393a3d28.
[2008-12-13 12:44:59 6001] DEBUG (XendDomainInfo:140)
XendDomainInfo.recreate({'max_vcpu_id': 1, 'cpu_time': 19835886881L,
'ssidref': 0, 'hvm': 0, 'shutdown_reason': 0, 'dying': 0,
'online_vcpus': 2, 'domid': 0, 'paused': 0, 'crashed': 0, 'running':
1, 'maxmem_kb': 17179869180L, 'shutdown': 0, 'mem_kb': 521472L,
'handle': [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0], 'blocked':
0, 'name': 'Domain-0'})
[2008-12-13 12:44:59 6001] INFO (XendDomainInfo:157) Recreating domain
0, UUID 00000000-0000-0000-0000-000000000000. at /local/domain/0
[2008-12-13 12:44:59 6001] DEBUG (XendDomain:452) Adding Domain: 0
[2008-12-13 12:44:59 6001] DEBUG (XendDomainInfo:1501)
XendDomainInfo.handleShutdownWatch
[2008-12-13 12:44:59 6001] DEBUG (XendDomain:386) number of vcpus to use is 0
[2008-12-13 12:44:59 6001] DEBUG (XendDomainInfo:140)
XendDomainInfo.recreate({'max_vcpu_id': 0, 'cpu_time': 0L, 'ssidref':
0, 'hvm': 0, 'shutdown_reason': 0, 'dying': 0, 'online_vcpus': 0,
'domid': 1, 'paused': 1, 'crashed': 0, 'running': 0, 'maxmem_kb':
20480L, 'shutdown': 0, 'mem_kb': 20480L, 'handle': [135, 128, 231,
227, 59, 40, 204, 117, 208, 6, 93, 19, 54, 70, 130, 208], 'blocked':
0})
[2008-12-13 12:44:59 6001] INFO (XendDomainInfo:157) Recreating domain
1, UUID 8780e7e3-3b28-cc75-d006-5d13364682d0. at /local/domain/1
[2008-12-13 12:44:59 6001] WARNING (XendDomainInfo:179)
/vm/8780e7e3-3b28-cc75-d006-5d13364682d0/uuid/ is missing. recreate is
confused, trying our best to recover
[2008-12-13 12:44:59 6001] DEBUG (XendDomainInfo:2792) Storing VM
details: {'on_xend_stop': 'ignore', 'shadow_memory': '0', 'uuid':
'8780e7e3-3b28-cc75-d006-5d13364682d0', 'on_reboot': 'restart',
'image': '(linux (kernel ))', 'on_poweroff': 'destroy',
'bootloader_args': '', 'on_xend_start': 'ignore', 'on_crash':
'restart', 'xend/restart_count': '0', 'vcpus': '1', 'vcpu_avail': '1',
'bootloader': '', 'name': 'Domain-Unnamed'}
[2008-12-13 12:44:59 6001] DEBUG (XendDomainInfo:1417) Storing domain
details: {'name': 'Domain-Unnamed', 'console/limit': '1048576', 'vm':
'/vm/8780e7e3-3b28-cc75-d006-5d13364682d0', 'domid': '1',
'cpu/0/availability': 'online', 'memory/target': '20480',
'control/platform-feature-multiprocessor-suspend': '1',
'console/type': 'xenconsoled'}
[2008-12-13 12:44:59 6001] DEBUG (XendDomain:452) Adding Domain: 1
[2008-12-13 12:44:59 6001] DEBUG (XendDomainInfo:1501)
XendDomainInfo.handleShutdownWatch
[2008-12-13 12:44:59 6001] WARNING (XendAPI:690) API call:
VBD.set_device not found
[2008-12-13 12:44:59 6001] WARNING (XendAPI:690) API call:
VBD.set_type not found
[2008-12-13 12:44:59 6001] WARNING (XendAPI:690) API call:
session.get_all_records not found
[2008-12-13 12:44:59 6001] WARNING (XendAPI:690) API call:
event.get_record not found
[2008-12-13 12:44:59 6001] WARNING (XendAPI:690) API call:
event.get_all not found
[2008-12-13 12:44:59 6001] WARNING (XendAPI:690) API call:
VM.get_auto_power_on not found
[2008-12-13 12:44:59 6001] WARNING (XendAPI:690) API call:
VM.set_auto_power_on not found
[2008-12-13 12:44:59 6001] WARNING (XendAPI:690) API call:
VIF.get_network not found
[2008-12-13 12:44:59 6001] WARNING (XendAPI:690) API call:
VIF.set_device not found
[2008-12-13 12:44:59 6001] WARNING (XendAPI:690) API call: VIF.set_MAC not found
[2008-12-13 12:44:59 6001] WARNING (XendAPI:690) API call: VIF.set_MTU not found
[2008-12-13 12:44:59 6001] WARNING (XendAPI:690) API call:
debug.get_all not found
[2008-12-13 12:44:59 6001] INFO (XMLRPCServer:156) Opening Unix domain
socket XML-RPC server on /var/run/xend/xen-api.sock; authentication
has been disabled for this server.
[2008-12-13 12:44:59 6001] INFO (XMLRPCServer:156) Opening Unix domain
socket XML-RPC server on /var/run/xend/xmlrpc.sock.
Cheers,
Todd
--
Todd Deshane
http://todddeshane.net
http://runningxen.com
_______________________________________________
Xen-devel mailing list
Xen-devel@xxxxxxxxxxxxxxxxxxx
http://lists.xensource.com/xen-devel
|