Re: Cannot load latest 2.6.32.10 kernel on AMD quad-core

[Gerry Reno <greno@verizon.net>]

[-- Attachment #1: Type: text/plain, Size: 2489 bytes --]

On 04/27/2010 01:35 PM, Gerry Reno wrote:
> On 04/27/2010 05:15 AM, Pasi Kärkkäinen wrote:
>> On Mon, Apr 26, 2010 at 10:48:44PM -0400, Gerry Reno wrote:
>>>>>>> Pasi, my grub.conf is attached.
>>>>>>>
>>>>>> Ok, fix it to be like this:
>>>>>>
>>>>>> module /vmlinuz-2.6.32.10
>>>>>> root=/dev/mapper/vg--grp--01--23--02--2-LogVol00 dummy=dummy ro
>>>>>> earlyprintk=xen console=hvc0 console=ttyS0 console=ttyUSB0,115200n8
>>>>>> text
>>>>>>
>>>>>> aka remove "quiet" and add "earlyprintk=xen console=hvc0"
>>>>>>
>>>>>> -- Pasi
>>>>>>
>>>>> Pasi, this gave some more output.  Sorry the video is fuzzy but this
>>>>> happens by youtube postprocessing.  Here is new link:
>>>>> http://www.youtube.com/watch?v=jePyapeHpSI
>>>>>
>>>>> -Gerry
>>>> If you have somewhere I can ftp original video file, it is clearer.
>>>> File is about 90 MB.
>>>>
>>>> -Gerry
>>>>
>>> Original video is posted here:
>>> http://greno-misc.googlecode.com/files/MOV03932.MPG
>>>
>> It's very difficult to see the problem from that video :(
>> We'd really need a serial console log.
>>
>> Also you I wonder why the screen goes blank in the end?
>> Before that it seems to mount the root (?) filesystem OK..
>>
>> Do you have some console font/videomode thingie configured?
>> See the "Dom0 console gets all weird and corrupted in the end of the 
>> boot process" from:
>> http://wiki.xensource.com/xenwiki/XenParavirtOps
>>
>> Also please add "nomodeset" option to the end of the pvops kernel 
>> boot options,
>> like suggested on pvops examples/docs.
>>
>> -- Pasi
>>
> Ok, I finally got a little more output using nomodeset.  There is a 
> soft lockup bug.  Attaching screenshots.
>
> -Gerry
>

I've been changing various settings trying to figure out what is the 
problem and today after a very long wait (> 5 min) I was able to see a 
login prompt.  But things are not well.  During the boot I now see:
XENBUS: Unable to read cpu state.
XENBUS: Unable to read cpu state.
XENBUS: Unable to read cpu state.
XENBUS: Unable to read cpu state.

and while logged in I get a lot of these type of messages every few minutes:
INFO: task xxxxxxx:nnn  blocked for more than 120 seconds.
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.

and I notice a number of errors in the xen logs with I'm attaching.

Can someone look at these logs and see if there is anything I can do on 
my end to help fix the problem?

-Gerry




[-- Attachment #2: domain-builder-ng.log --]
[-- Type: text/x-log, Size: 5080 bytes --]

xc_dom_allocate: cmdline="root=/dev/xvda1  ro", features=""
xc_dom_kernel_file: filename="/var/lib/eucalyptus/instances/admin/i-578308F0/kernel"
xc_dom_malloc_filemap    : 3842 kB
xc_dom_ramdisk_file: filename="/var/lib/eucalyptus/instances/admin/i-578308F0/ramdisk"
xc_dom_malloc_filemap    : 3772 kB
xc_dom_boot_xen_init: ver 3.4, caps xen-3.0-x86_64 xen-3.0-x86_32p hvm-3.0-x86_32 hvm-3.0-x86_32p hvm-3.0-x86_64 
xc_dom_parse_image: called
xc_dom_find_loader: trying ELF-generic loader ... failed
xc_dom_find_loader: trying Linux bzImage loader ... xc_dom_malloc            : 15175 kB
xc_dom_do_gunzip: unzip ok, 0x3b9354 -> 0xed1d78
OK
elf_parse_binary: phdr: paddr=0x1000000 memsz=0x76e000
elf_parse_binary: phdr: paddr=0x176e000 memsz=0xb1570
elf_parse_binary: phdr: paddr=0x1820000 memsz=0x8c8
elf_parse_binary: phdr: paddr=0x1821000 memsz=0x16260
elf_parse_binary: phdr: paddr=0x1837260 memsz=0x1c9da0
elf_parse_binary: memory: 0x1000000 -> 0x1a01000
elf_xen_parse_note: GUEST_OS = "linux"
elf_xen_parse_note: GUEST_VERSION = "2.6"
elf_xen_parse_note: XEN_VERSION = "xen-3.0"
elf_xen_parse_note: VIRT_BASE = 0xffffffff80000000
elf_xen_parse_note: ENTRY = 0xffffffff81837460
elf_xen_parse_note: HYPERCALL_PAGE = 0xffffffff81009000
elf_xen_parse_note: FEATURES = "!writable_page_tables|pae_pgdir_above_4gb"
elf_xen_parse_note: PAE_MODE = "yes"
elf_xen_parse_note: LOADER = "generic"
elf_xen_parse_note: unknown xen elf note (0xd)
elf_xen_parse_note: SUSPEND_CANCEL = 0x1
elf_xen_parse_note: HV_START_LOW = 0xffff800000000000
elf_xen_parse_note: PADDR_OFFSET = 0x0
elf_xen_addr_calc_check: addresses:
    virt_base        = 0xffffffff80000000
    elf_paddr_offset = 0x0
    virt_offset      = 0xffffffff80000000
    virt_kstart      = 0xffffffff81000000
    virt_kend        = 0xffffffff81a01000
    virt_entry       = 0xffffffff81837460
    p2m_base         = 0xffffffffffffffff
xc_dom_parse_elf_kernel: xen-3.0-x86_64: 0xffffffff81000000 -> 0xffffffff81a01000
xc_dom_mem_init: mem 512 MB, pages 0x20000 pages, 4k each
xc_dom_mem_init: 0x20000 pages
xc_dom_boot_mem_init: called
x86_compat: guest xen-3.0-x86_64, address size 64
xc_dom_malloc            : 1024 kB
xc_dom_build_image: called
xc_dom_alloc_segment:   kernel       : 0xffffffff81000000 -> 0xffffffff81a01000  (pfn 0x1000 + 0xa01 pages)
xc_dom_pfn_to_ptr: domU mapping: pfn 0x1000+0xa01 at 0x7f6e7968b000
elf_load_binary: phdr 0 at 0x0x7f6e7968b000 -> 0x0x7f6e79df9000
elf_load_binary: phdr 1 at 0x0x7f6e79df9000 -> 0x0x7f6e79eaa570
elf_load_binary: phdr 2 at 0x0x7f6e79eab000 -> 0x0x7f6e79eab8c8
elf_load_binary: phdr 3 at 0x0x7f6e79eac000 -> 0x0x7f6e79ec2260
elf_load_binary: phdr 4 at 0x0x7f6e79ec2260 -> 0x0x7f6e79f5c000
xc_dom_alloc_segment:   ramdisk      : 0xffffffff81a01000 -> 0xffffffff82342000  (pfn 0x1a01 + 0x941 pages)
xc_dom_pfn_to_ptr: domU mapping: pfn 0x1a01+0x941 at 0x7f6e78d4a000
xc_dom_do_gunzip: unzip ok, 0x3af20c -> 0x940a10
xc_dom_alloc_segment:   phys2mach    : 0xffffffff82342000 -> 0xffffffff82442000  (pfn 0x2342 + 0x100 pages)
xc_dom_pfn_to_ptr: domU mapping: pfn 0x2342+0x100 at 0x7f6e78c4a000
xc_dom_alloc_page   :   start info   : 0xffffffff82442000 (pfn 0x2442)
xc_dom_alloc_page   :   xenstore     : 0xffffffff82443000 (pfn 0x2443)
xc_dom_alloc_page   :   console      : 0xffffffff82444000 (pfn 0x2444)
nr_page_tables: 0x0000ffffffffffff/48: 0xffff000000000000 -> 0xffffffffffffffff, 1 table(s)
nr_page_tables: 0x0000007fffffffff/39: 0xffffff8000000000 -> 0xffffffffffffffff, 1 table(s)
nr_page_tables: 0x000000003fffffff/30: 0xffffffff80000000 -> 0xffffffffbfffffff, 1 table(s)
nr_page_tables: 0x00000000001fffff/21: 0xffffffff80000000 -> 0xffffffff827fffff, 20 table(s)
xc_dom_alloc_segment:   page tables  : 0xffffffff82445000 -> 0xffffffff8245c000  (pfn 0x2445 + 0x17 pages)
xc_dom_pfn_to_ptr: domU mapping: pfn 0x2445+0x17 at 0x7f6e78c33000
xc_dom_alloc_page   :   boot stack   : 0xffffffff8245c000 (pfn 0x245c)
xc_dom_build_image  : virt_alloc_end : 0xffffffff8245d000
xc_dom_build_image  : virt_pgtab_end : 0xffffffff82800000
xc_dom_boot_image: called
arch_setup_bootearly: doing nothing
xc_dom_compat_check: supported guest type: xen-3.0-x86_64 <= matches
xc_dom_compat_check: supported guest type: xen-3.0-x86_32p
xc_dom_compat_check: supported guest type: hvm-3.0-x86_32
xc_dom_compat_check: supported guest type: hvm-3.0-x86_32p
xc_dom_compat_check: supported guest type: hvm-3.0-x86_64
xc_dom_update_guest_p2m: dst 64bit, pages 0x20000 
clear_page: pfn 0x2444, mfn 0x1ac0c5
clear_page: pfn 0x2443, mfn 0x1ac0c6
xc_dom_pfn_to_ptr: domU mapping: pfn 0x2442+0x1 at 0x7f6e78c32000
start_info_x86_64: called
setup_hypercall_page: vaddr=0xffffffff81009000 pfn=0x1009
domain builder memory footprint
   allocated
      malloc             : 16324 kB
      anon mmap          : 0 bytes
   mapped
      file mmap          : 7615 kB
      domU mmap          : 20840 kB
arch_setup_bootlate: shared_info: pfn 0x0, mfn 0xafdd0
shared_info_x86_64: called
vcpu_x86_64: called
vcpu_x86_64: cr3: pfn 0x2445 mfn 0x1ac0c4
launch_vm: called, ctxt=0x7f6e7b7fa5c0
xc_dom_release: called

[-- Warning: decoded text below may be mangled, UTF-8 assumed --]
[-- Attachment #3: xend.log --]
[-- Type: text/x-log; name=xend.log, Size: 18584 bytes --]

[2010-04-29 09:19:31 2017] INFO (SrvDaemon:332) Xend Daemon started
[2010-04-29 09:19:31 2017] INFO (SrvDaemon:336) Xend changeset: Fri Mar 26 10:29:38 2010 +0000 21074:542211ba675c.
[2010-04-29 09:19:35 2017] DEBUG (XendDomainInfo:149) XendDomainInfo.recreate({'max_vcpu_id': 3, 'cpu_time': 59013874695L, 'ssidref': 0, 'hvm': 0, 'shutdown_reason': 0, 'dying': 0, 'online_vcpus': 4, 'domid': 0, 'paused': 0, 'crashed': 0, 'running': 1, 'maxmem_kb': 17179869180L, 'shutdown': 0, 'mem_kb': 1041920L, 'handle': [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0], 'blocked': 0, 'name': 'Domain-0'})
[2010-04-29 09:19:35 2017] INFO (XendDomainInfo:167) Recreating domain 0, UUID 00000000-0000-0000-0000-000000000000. at /local/domain/0
[2010-04-29 09:19:35 2017] DEBUG (XendDomainInfo:3400) Storing VM details: {'on_xend_stop': 'ignore', 'shadow_memory': '0', 'uuid': '00000000-0000-0000-0000-000000000000', 'on_reboot': 'restart', 'image': '(linux (kernel ) (superpages 0) (nomigrate 0) (tsc_mode 0))', 'on_poweroff': 'destroy', 'bootloader_args': '', 'on_xend_start': 'ignore', 'on_crash': 'restart', 'xend/restart_count': '0', 'vcpus': '4', 'vcpu_avail': '15', 'bootloader': '', 'name': 'Domain-0'}
[2010-04-29 09:19:35 2017] DEBUG (XendDomainInfo:1804) Storing domain details: {'cpu/3/availability': 'online', 'description': '', 'console/limit': '1048576', 'memory/target': '1041920', 'cpu/2/availability': 'online', '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', 'name': 'Domain-0'}
[2010-04-29 09:19:35 2017] DEBUG (XendDomain:464) Adding Domain: 0
[2010-04-29 09:19:35 2017] DEBUG (XendDomain:398) number of vcpus to use is 0
[2010-04-29 09:19:35 2017] DEBUG (XendDomainInfo:1891) XendDomainInfo.handleShutdownWatch
[2010-04-29 09:19:35 2017] DEBUG (XendDomainInfo:258) XendDomainInfo.createDormant({'vcpus_params': {'cap': 0, 'weight': 256}, 'PV_args': '', 'features': '', 'cpus': [[]], 'use_tmp_kernel': False, 'devices': {'35135de1-2593-7931-ac31-c3e762e41040': ('vbd', {'uuid': '35135de1-2593-7931-ac31-c3e762e41040', 'bootable': 1, 'driver': 'paravirtualised', 'dev': 'xvda', 'uname': 'file:/var/lib/xen/images/test.img', 'mode': 'w'}), '98708744-2701-b87a-a919-ce200755eb51': ('vif', {'bridge': 'br0', 'mac': '00:16:36:7f:2f:28', 'uuid': '98708744-2701-b87a-a919-ce200755eb51', 'script': 'vif-bridge'})}, 'memory_sharing': 0, 'superpages': 0, 'VCPUs_live': 1, 'PV_bootloader': '/usr/lib/xen-default/bin/pygrub', 'actions_after_crash': 'restart', 'vbd_refs': ['35135de1-2593-7931-ac31-c3e762e41040'], 'PV_ramdisk': '', 'is_control_domain': False, 'name_label': 'test', 'VCPUs_at_startup': 1, 'HVM_boot_params': {}, 'platform': {'tsc_mode': 0, 'nomigrate': 0}, 'PV_kernel': '', 'console_refs': [], 'vif_refs': ['98708744-2701-b87a-a919-ce200755eb51'], 'on_xend_stop': 'ignore', 'memory_static_min': 0, 'HVM_boot_policy': '', 'description': '', 'VCPUs_max': 1, 'memory_static_max': 1073741824, 'actions_after_shutdown': 'destroy', 'use_tmp_ramdisk': False, 'on_xend_start': 'ignore', 'memory_dynamic_max': 1073741824, 'actions_after_suspend': '', 'is_a_template': False, 'PV_bootloader_args': '', 'memory_dynamic_min': 1073741824, 'uuid': 'a77618fa-2d1d-f5a5-c3e9-f429a4cd8bce', 'shadow_memory': 0, 'target': 0, 'vcpu_avail': 1L, 'other_config': {}, 'auto_power_on': False, 'actions_after_reboot': 'restart', 'Description': '', 'status': '0', 'vtpm_refs': []})
[2010-04-29 09:19:35 2017] DEBUG (XendDomainInfo:258) XendDomainInfo.createDormant({'vcpus_params': {'cap': 0, 'weight': 256}, 'PV_args': '(hd0,4)/grub/menu.lst', 'features': '', 'cpus': [[], [], [], []], 'use_tmp_kernel': False, 'devices': {'ab8364d8-ffc2-491a-9cdc-f349ae40c1ab': ('vif', {'bridge': 'br0', 'mac': '00:16:1a:2a:ef:56', 'script': '/etc/xen/scripts/vif-bridge', 'uuid': 'ab8364d8-ffc2-491a-9cdc-f349ae40c1ab', 'backend': '0'}), '935c1e4f-7a88-773c-25d1-b337bd7b2f3e': ('vbd', {'protocol': 'x86_64-abi', 'uuid': '935c1e4f-7a88-773c-25d1-b337bd7b2f3e', 'bootable': 1, 'driver': 'paravirtualised', 'dev': 'xvda:disk', 'uname': 'file:/var/lib/xen/images/CLOUD-CC-1.img', 'mode': 'w', 'backend': '0'}), '4605ea87-1321-44f2-5532-1fe3288bee13': ('console', {'protocol': 'vt100', 'location': '2', 'uuid': '4605ea87-1321-44f2-5532-1fe3288bee13'})}, 'memory_sharing': 0, 'superpages': 0, 'VCPUs_live': 4, 'PV_bootloader': '', 'actions_after_crash': 'restart', 'vbd_refs': ['935c1e4f-7a88-773c-25d1-b337bd7b2f3e'], 'PV_ramdisk': '', 'is_control_domain': False, 'name_label': 'CLOUD-CC-1', 'VCPUs_at_startup': 1, 'HVM_boot_params': {}, 'platform': {'tsc_mode': 0, 'nomigrate': 0}, 'PV_kernel': '/usr/lib/xen/boot/pv-grub-x86_64.gz', 'console_refs': ['4605ea87-1321-44f2-5532-1fe3288bee13'], 'vif_refs': ['ab8364d8-ffc2-491a-9cdc-f349ae40c1ab'], 'on_xend_stop': 'ignore', 'memory_static_min': 0, 'HVM_boot_policy': '', 'description': '', 'VCPUs_max': 4, 'start_time': 1271835210.3399999, 'memory_static_max': 4294967296, 'actions_after_shutdown': 'destroy', 'use_tmp_ramdisk': False, 'on_xend_start': 'ignore', 'memory_dynamic_max': 1073741824, 'actions_after_suspend': '', 'is_a_template': False, 'PV_bootloader_args': '', 'memory_dynamic_min': 1073741824, 'uuid': 'f2636676-0c99-0a61-08db-9b0c6844824d', 'cpu_time': 143.22409792600001, 'shadow_memory': 0, 'target': 0, 'vcpu_avail': 15L, 'notes': {}, 'other_config': {}, 'auto_power_on': False, 'actions_after_reboot': 'restart', 'Description': '', 'status': '1', 'vtpm_refs': []})
[2010-04-29 09:19:35 2017] WARNING (XendAPI:705) API call: VBD.set_device not found
[2010-04-29 09:19:35 2017] WARNING (XendAPI:705) API call: VBD.set_type not found
[2010-04-29 09:19:35 2017] WARNING (XendAPI:705) API call: session.get_all_records not found
[2010-04-29 09:19:35 2017] WARNING (XendAPI:705) API call: event.get_record not found
[2010-04-29 09:19:35 2017] WARNING (XendAPI:705) API call: event.get_all not found
[2010-04-29 09:19:35 2017] WARNING (XendAPI:705) API call: VIF.set_device not found
[2010-04-29 09:19:35 2017] WARNING (XendAPI:705) API call: VIF.set_MAC not found
[2010-04-29 09:19:35 2017] WARNING (XendAPI:705) API call: VIF.set_MTU not found
[2010-04-29 09:19:35 2017] WARNING (XendAPI:705) API call: debug.get_all not found
[2010-04-29 09:19:35 2017] INFO (XMLRPCServer:156) Opening Unix domain socket XML-RPC server on /var/run/xend/xen-api.sock; authentication has been disabled for this server.
[2010-04-29 09:19:35 2017] INFO (XMLRPCServer:156) Opening Unix domain socket XML-RPC server on /var/run/xend/xmlrpc.sock.
[2010-04-29 09:21:25 2017] DEBUG (XendDomainInfo:235) XendDomainInfo.restore(['domain', ['domid', '6'], ['bootloader'], ['on_crash', 'destroy'], ['uuid', '6a0cd4d7-1f9d-ed9e-8d4e-8ca22c374dea'], ['bootloader_args'], ['vcpus', '2'], ['name', 'i-471B08A1'], ['cpus', [[], []]], ['on_reboot', 'restart'], ['on_poweroff', 'destroy'], ['maxmem', '512'], ['memory', '512'], ['shadow_memory', '0'], ['vcpu_avail', '3'], ['features'], ['on_xend_start', 'ignore'], ['on_xend_stop', 'ignore'], ['start_time', '1271822064.18'], ['cpu_time', '13.148059362'], ['online_vcpus', '2'], ['image', ['linux', ['kernel', '/var/lib/eucalyptus/instances/admin/i-471B08A1/kernel'], ['ramdisk', '/var/lib/eucalyptus/instances/admin/i-471B08A1/ramdisk'], ['args', 'root=/dev/xvda1  ro'], ['notes', ['HV_START_LOW', '18446603336221196288'], ['FEATURES', '!writable_page_tables|pae_pgdir_above_4gb'], ['VIRT_BASE', '18446744071562067968'], ['GUEST_VERSION', '2.6'], ['PADDR_OFFSET', '0'], ['GUEST_OS', 'linux'], ['HYPERCALL_PAGE', '18446744071578882048'], ['LOADER', 'generic'], ['SUSPEND_CANCEL', '1'], ['PAE_MODE', 'yes'], ['ENTRY', '18446744071587460192'], ['XEN_VERSION', 'xen-3.0']]]], ['status', '2'], ['state', '-b----'], ['store_mfn', '1753286'], ['console_mfn', '1753285'], ['device', ['vif', ['bridge', 'br0'], ['mac', 'd0:0d:47:1b:08:a1'], ['script', '/etc/xen/scripts/vif-bridge'], ['uuid', '7f55cdca-fdd1-b2cc-31f6-bc0ce8cbb960'], ['backend', '0']]], ['device', ['console', ['protocol', 'vt100'], ['location', '2'], ['uuid', '0d2fd80b-d9f3-3562-6716-b84d4ae5913b']]], ['device', ['vbd', ['protocol', 'x86_64-abi'], ['uuid', 'dceb2f12-1dcf-f189-2a21-64b843655908'], ['bootable', '1'], ['dev', 'xvda1:disk'], ['uname', 'file:/var/lib/eucalyptus/instances/admin/i-471B08A1/root'], ['mode', 'w'], ['backend', '0'], ['bootable', '1'], ['VDI']]], ['device', ['vbd', ['protocol', 'x86_64-abi'], ['uuid', 'cf51fc5d-1b8f-e830-cf82-aae2c190edba'], ['bootable', '0'], ['dev', 'xvda2:disk'], ['uname', 'file:/var/lib/eucalyptus/instances/admin/i-471B08A1/ephemeral'], ['mode', 'w'], ['backend', '0'], ['bootable', '0'], ['VDI']]], ['device', ['vbd', ['protocol', 'x86_64-abi'], ['uuid', 'c055b0ce-f0d0-a35e-4a84-ab66cd8ad233'], ['bootable', '0'], ['dev', 'xvda3:disk'], ['uname', 'file:/var/lib/eucalyptus/instances/admin/i-471B08A1/swap'], ['mode', 'w'], ['backend', '0'], ['bootable', '0'], ['VDI']]]])
[2010-04-29 09:21:25 2017] DEBUG (XendDomainInfo:2508) XendDomainInfo.constructDomain
[2010-04-29 09:21:25 2017] DEBUG (balloon:220) Balloon: 6727868 KiB free; need 16384; done.
[2010-04-29 09:21:25 2017] DEBUG (XendDomain:464) Adding Domain: 1
[2010-04-29 09:21:25 2017] DEBUG (XendDomainInfo:3400) Storing VM details: {'on_xend_stop': 'ignore', 'shadow_memory': '0', 'uuid': '6a0cd4d7-1f9d-ed9e-8d4e-8ca22c374dea', 'on_reboot': 'restart', 'start_time': '1271822064.18', 'on_poweroff': 'destroy', 'bootloader_args': '', 'on_xend_start': 'ignore', 'on_crash': 'destroy', 'xend/restart_count': '0', 'vcpus': '2', 'vcpu_avail': '3', 'bootloader': '', 'image': "(linux (kernel /var/lib/eucalyptus/instances/admin/i-471B08A1/kernel) (ramdisk /var/lib/eucalyptus/instances/admin/i-471B08A1/ramdisk) (args 'root=/dev/xvda1  ro') (superpages 0) (pci ()) (nomigrate 0) (tsc_mode 0) (notes (HV_START_LOW 18446603336221196288) (FEATURES '!writable_page_tables|pae_pgdir_above_4gb') (VIRT_BASE 18446744071562067968) (GUEST_VERSION 2.6) (PADDR_OFFSET 0) (GUEST_OS linux) (HYPERCALL_PAGE 18446744071578882048) (LOADER generic) (SUSPEND_CANCEL 1) (PAE_MODE yes) (ENTRY 18446744071587460192) (XEN_VERSION xen-3.0)))", 'name': 'i-471B08A1'}
[2010-04-29 09:21:25 2017] INFO (XendDomainInfo:2367) createDevice: console : {'protocol': 'vt100', 'location': '2', 'uuid': '0d2fd80b-d9f3-3562-6716-b84d4ae5913b'}
[2010-04-29 09:21:25 2017] DEBUG (DevController:95) DevController: writing {'state': '1', 'backend-id': '0', 'backend': '/local/domain/0/backend/console/1/0'} to /local/domain/1/device/console/0.
[2010-04-29 09:21:25 2017] DEBUG (DevController:97) DevController: writing {'domain': 'i-471B08A1', 'frontend': '/local/domain/1/device/console/0', 'uuid': '0d2fd80b-d9f3-3562-6716-b84d4ae5913b', 'frontend-id': '1', 'state': '1', 'location': '2', 'online': '1', 'protocol': 'vt100'} to /local/domain/0/backend/console/1/0.
[2010-04-29 09:21:25 2017] INFO (XendDomainInfo:2367) createDevice: vbd : {'protocol': 'x86_64-abi', 'uuid': 'dceb2f12-1dcf-f189-2a21-64b843655908', 'bootable': 1, 'driver': 'paravirtualised', 'dev': 'xvda1:disk', 'uname': 'file:/var/lib/eucalyptus/instances/admin/i-471B08A1/root', 'mode': 'w', 'backend': '0'}
[2010-04-29 09:21:25 2017] DEBUG (DevController:95) DevController: writing {'virtual-device': '51713', 'protocol': 'x86_64-abi', 'device-type': 'disk', 'backend-id': '0', 'state': '1', 'backend': '/local/domain/0/backend/vbd/1/51713'} to /local/domain/1/device/vbd/51713.
[2010-04-29 09:21:25 2017] DEBUG (DevController:97) DevController: writing {'domain': 'i-471B08A1', 'frontend': '/local/domain/1/device/vbd/51713', 'uuid': 'dceb2f12-1dcf-f189-2a21-64b843655908', 'bootable': '1', 'dev': 'xvda1', 'state': '1', 'params': '/var/lib/eucalyptus/instances/admin/i-471B08A1/root', 'mode': 'w', 'online': '1', 'frontend-id': '1', 'type': 'file'} to /local/domain/0/backend/vbd/1/51713.
[2010-04-29 09:21:25 2017] INFO (XendDomainInfo:2367) createDevice: vbd : {'protocol': 'x86_64-abi', 'uuid': 'cf51fc5d-1b8f-e830-cf82-aae2c190edba', 'bootable': 0, 'driver': 'paravirtualised', 'dev': 'xvda2:disk', 'uname': 'file:/var/lib/eucalyptus/instances/admin/i-471B08A1/ephemeral', 'mode': 'w', 'backend': '0'}
[2010-04-29 09:21:25 2017] DEBUG (DevController:95) DevController: writing {'virtual-device': '51714', 'protocol': 'x86_64-abi', 'device-type': 'disk', 'backend-id': '0', 'state': '1', 'backend': '/local/domain/0/backend/vbd/1/51714'} to /local/domain/1/device/vbd/51714.
[2010-04-29 09:21:25 2017] DEBUG (DevController:97) DevController: writing {'domain': 'i-471B08A1', 'frontend': '/local/domain/1/device/vbd/51714', 'uuid': 'cf51fc5d-1b8f-e830-cf82-aae2c190edba', 'bootable': '0', 'dev': 'xvda2', 'state': '1', 'params': '/var/lib/eucalyptus/instances/admin/i-471B08A1/ephemeral', 'mode': 'w', 'online': '1', 'frontend-id': '1', 'type': 'file'} to /local/domain/0/backend/vbd/1/51714.
[2010-04-29 09:21:25 2017] INFO (XendDomainInfo:2367) createDevice: vbd : {'protocol': 'x86_64-abi', 'uuid': 'c055b0ce-f0d0-a35e-4a84-ab66cd8ad233', 'bootable': 0, 'driver': 'paravirtualised', 'dev': 'xvda3:disk', 'uname': 'file:/var/lib/eucalyptus/instances/admin/i-471B08A1/swap', 'mode': 'w', 'backend': '0'}
[2010-04-29 09:21:25 2017] DEBUG (DevController:95) DevController: writing {'virtual-device': '51715', 'protocol': 'x86_64-abi', 'device-type': 'disk', 'backend-id': '0', 'state': '1', 'backend': '/local/domain/0/backend/vbd/1/51715'} to /local/domain/1/device/vbd/51715.
[2010-04-29 09:21:25 2017] DEBUG (DevController:97) DevController: writing {'domain': 'i-471B08A1', 'frontend': '/local/domain/1/device/vbd/51715', 'uuid': 'c055b0ce-f0d0-a35e-4a84-ab66cd8ad233', 'bootable': '0', 'dev': 'xvda3', 'state': '1', 'params': '/var/lib/eucalyptus/instances/admin/i-471B08A1/swap', 'mode': 'w', 'online': '1', 'frontend-id': '1', 'type': 'file'} to /local/domain/0/backend/vbd/1/51715.
[2010-04-29 09:21:25 2017] INFO (XendDomainInfo:2367) createDevice: vif : {'bridge': 'br0', 'mac': 'd0:0d:47:1b:08:a1', 'script': '/etc/xen/scripts/vif-bridge', 'uuid': '7f55cdca-fdd1-b2cc-31f6-bc0ce8cbb960', 'backend': '0'}
[2010-04-29 09:21:25 2017] DEBUG (DevController:95) DevController: writing {'backend-id': '0', 'mac': 'd0:0d:47:1b:08:a1', 'handle': '0', 'state': '1', 'backend': '/local/domain/0/backend/vif/1/0'} to /local/domain/1/device/vif/0.
[2010-04-29 09:21:25 2017] DEBUG (DevController:97) DevController: writing {'bridge': 'br0', 'domain': 'i-471B08A1', 'handle': '0', 'uuid': '7f55cdca-fdd1-b2cc-31f6-bc0ce8cbb960', 'script': '/etc/xen/scripts/vif-bridge', 'mac': 'd0:0d:47:1b:08:a1', 'frontend-id': '1', 'state': '1', 'online': '1', 'frontend': '/local/domain/1/device/vif/0'} to /local/domain/0/backend/vif/1/0.
[2010-04-29 09:21:25 2017] DEBUG (XendDomainInfo:1804) Storing domain details: {'image/entry': '18446744071587460192', 'console/port': '2', 'image/loader': 'generic', 'vm': '/vm/6a0cd4d7-1f9d-ed9e-8d4e-8ca22c374dea', 'control/platform-feature-multiprocessor-suspend': '1', 'image/hv-start-low': '18446603336221196288', 'image/guest-os': 'linux', 'cpu/1/availability': 'online', 'image/virt-base': '18446744071562067968', 'memory/target': '524288', 'image/guest-version': '2.6', 'image/pae-mode': 'yes', 'description': '', 'console/limit': '1048576', 'image/paddr-offset': '0', 'image/hypercall-page': '18446744071578882048', 'image/suspend-cancel': '1', 'cpu/0/availability': 'online', 'image/features/pae-pgdir-above-4gb': '1', 'image/features/writable-page-tables': '0', 'console/type': 'xenconsoled', 'name': 'i-471B08A1', 'domid': '1', 'image/xen-version': 'xen-3.0', 'store/port': '1'}
[2010-04-29 09:21:26 2017] DEBUG (XendCheckpoint:286) restore:shadow=0x0, _static_max=0x20000000, _static_min=0x0, 
[2010-04-29 09:21:26 2017] DEBUG (XendCheckpoint:305) [xc_restore]: /usr/lib/xen/bin/xc_restore 42 1 1 2 0 0 0 0
[2010-04-29 09:21:26 2017] INFO (XendCheckpoint:423) ERROR Internal error: read: p2m_size
[2010-04-29 09:21:26 2017] INFO (XendCheckpoint:423) Restore exit with rc=1
[2010-04-29 09:21:26 2017] DEBUG (XendDomainInfo:3053) XendDomainInfo.destroy: domid=1
[2010-04-29 09:21:26 2017] ERROR (XendDomainInfo:3067) XendDomainInfo.destroy: domain destruction failed.
Traceback (most recent call last):
  File "/usr/local/lib/python2.6/dist-packages/xen/xend/XendDomainInfo.py", line 3060, in destroy
    xc.domain_pause(self.domid)
Error: (3, 'No such process')
[2010-04-29 09:21:26 2017] DEBUG (XendDomainInfo:2416) No device model
[2010-04-29 09:21:26 2017] DEBUG (XendDomainInfo:2418) Releasing devices
[2010-04-29 09:21:26 2017] DEBUG (XendDomainInfo:2424) Removing vif/0
[2010-04-29 09:21:26 2017] DEBUG (XendDomainInfo:1286) XendDomainInfo.destroyDevice: deviceClass = vif, device = vif/0
[2010-04-29 09:21:26 2017] DEBUG (XendDomainInfo:2424) Removing console/0
[2010-04-29 09:21:26 2017] DEBUG (XendDomainInfo:1286) XendDomainInfo.destroyDevice: deviceClass = console, device = console/0
[2010-04-29 09:21:26 2017] DEBUG (XendDomainInfo:2424) Removing vbd/51713
[2010-04-29 09:21:26 2017] DEBUG (XendDomainInfo:1286) XendDomainInfo.destroyDevice: deviceClass = vbd, device = vbd/51713
[2010-04-29 09:21:26 2017] DEBUG (XendDomainInfo:2424) Removing vbd/51714
[2010-04-29 09:21:26 2017] DEBUG (XendDomainInfo:1286) XendDomainInfo.destroyDevice: deviceClass = vbd, device = vbd/51714
[2010-04-29 09:21:26 2017] DEBUG (XendDomainInfo:2424) Removing vbd/51715
[2010-04-29 09:21:26 2017] DEBUG (XendDomainInfo:1286) XendDomainInfo.destroyDevice: deviceClass = vbd, device = vbd/51715
[2010-04-29 09:21:26 2017] ERROR (XendCheckpoint:357) /usr/lib/xen/bin/xc_restore 42 1 1 2 0 0 0 0 failed
Traceback (most recent call last):
  File "/usr/local/lib/python2.6/dist-packages/xen/xend/XendCheckpoint.py", line 309, in restore
    forkHelper(cmd, fd, handler.handler, True)
  File "/usr/local/lib/python2.6/dist-packages/xen/xend/XendCheckpoint.py", line 411, in forkHelper
    raise XendError("%s failed" % string.join(cmd))
XendError: /usr/lib/xen/bin/xc_restore 42 1 1 2 0 0 0 0 failed
[2010-04-29 09:21:26 2017] ERROR (XendDomain:1175) Restore failed
Traceback (most recent call last):
  File "/usr/local/lib/python2.6/dist-packages/xen/xend/XendDomain.py", line 1159, in domain_restore_fd
    dominfo = XendCheckpoint.restore(self, fd, paused=paused, relocating=relocating)
  File "/usr/local/lib/python2.6/dist-packages/xen/xend/XendCheckpoint.py", line 358, in restore
    raise exn
XendError: /usr/lib/xen/bin/xc_restore 42 1 1 2 0 0 0 0 failed

[-- Attachment #4: xend-debug.log --]
[-- Type: text/x-log, Size: 5412 bytes --]

Xend started at Thu Apr 29 09:19:31 2010.
cat: /sys/bus/scsi/devices/host0/vendor: No such file or directory
cat: /sys/bus/scsi/devices/host0/model: No such file or directory
cat: /sys/bus/scsi/devices/host0/type: No such file or directory
cat: /sys/bus/scsi/devices/host0/rev: No such file or directory
cat: /sys/bus/scsi/devices/host0/scsi_level: No such file or directory
cat: /sys/bus/scsi/devices/host1/vendor: No such file or directory
cat: /sys/bus/scsi/devices/host1/model: No such file or directory
cat: /sys/bus/scsi/devices/host1/type: No such file or directory
cat: /sys/bus/scsi/devices/host1/rev: No such file or directory
cat: /sys/bus/scsi/devices/host1/scsi_level: No such file or directory
cat: /sys/bus/scsi/devices/host2/vendor: No such file or directory
cat: /sys/bus/scsi/devices/host2/model: No such file or directory
cat: /sys/bus/scsi/devices/host2/type: No such file or directory
cat: /sys/bus/scsi/devices/host2/rev: No such file or directory
cat: /sys/bus/scsi/devices/host2/scsi_level: No such file or directory
cat: /sys/bus/scsi/devices/host3/vendor: No such file or directory
cat: /sys/bus/scsi/devices/host3/model: No such file or directory
cat: /sys/bus/scsi/devices/host3/type: No such file or directory
cat: /sys/bus/scsi/devices/host3/rev: No such file or directory
cat: /sys/bus/scsi/devices/host3/scsi_level: No such file or directory
cat: /sys/bus/scsi/devices/host4/vendor: No such file or directory
cat: /sys/bus/scsi/devices/host4/model: No such file or directory
cat: /sys/bus/scsi/devices/host4/type: No such file or directory
cat: /sys/bus/scsi/devices/host4/rev: No such file or directory
cat: /sys/bus/scsi/devices/host4/scsi_level: No such file or directory
cat: /sys/bus/scsi/devices/host5/vendor: No such file or directory
cat: /sys/bus/scsi/devices/host5/model: No such file or directory
cat: /sys/bus/scsi/devices/host5/type: No such file or directory
cat: /sys/bus/scsi/devices/host5/rev: No such file or directory
cat: /sys/bus/scsi/devices/host5/scsi_level: No such file or directory
cat: /sys/bus/scsi/devices/host6/vendor: No such file or directory
cat: /sys/bus/scsi/devices/host6/model: No such file or directory
cat: /sys/bus/scsi/devices/host6/type: No such file or directory
cat: /sys/bus/scsi/devices/host6/rev: No such file or directory
cat: /sys/bus/scsi/devices/host6/scsi_level: No such file or directory
cat: /sys/bus/scsi/devices/host7/vendor: No such file or directory
cat: /sys/bus/scsi/devices/host7/model: No such file or directory
cat: /sys/bus/scsi/devices/host7/type: No such file or directory
cat: /sys/bus/scsi/devices/host7/rev: No such file or directory
cat: /sys/bus/scsi/devices/host7/scsi_level: No such file or directory
cat: /sys/bus/scsi/devices/target0:0:0/vendor: No such file or directory
cat: /sys/bus/scsi/devices/target0:0:0/model: No such file or directory
cat: /sys/bus/scsi/devices/target0:0:0/type: No such file or directory
cat: /sys/bus/scsi/devices/target0:0:0/rev: No such file or directory
cat: /sys/bus/scsi/devices/target0:0:0/scsi_level: No such file or directory
cat: /sys/bus/scsi/devices/target1:0:0/vendor: No such file or directory
cat: /sys/bus/scsi/devices/target1:0:0/model: No such file or directory
cat: /sys/bus/scsi/devices/target1:0:0/type: No such file or directory
cat: /sys/bus/scsi/devices/target1:0:0/rev: No such file or directory
cat: /sys/bus/scsi/devices/target1:0:0/scsi_level: No such file or directory
cat: /sys/bus/scsi/devices/target2:0:0/vendor: No such file or directory
cat: /sys/bus/scsi/devices/target2:0:0/model: No such file or directory
cat: /sys/bus/scsi/devices/target2:0:0/type: No such file or directory
cat: /sys/bus/scsi/devices/target2:0:0/rev: No such file or directory
cat: /sys/bus/scsi/devices/target2:0:0/scsi_level: No such file or directory
cat: /sys/bus/scsi/devices/target3:0:0/vendor: No such file or directory
cat: /sys/bus/scsi/devices/target3:0:0/model: No such file or directory
cat: /sys/bus/scsi/devices/target3:0:0/type: No such file or directory
cat: /sys/bus/scsi/devices/target3:0:0/rev: No such file or directory
cat: /sys/bus/scsi/devices/target3:0:0/scsi_level: No such file or directory
cat: /sys/bus/scsi/devices/target4:0:0/vendor: No such file or directory
cat: /sys/bus/scsi/devices/target4:0:0/model: No such file or directory
cat: /sys/bus/scsi/devices/target4:0:0/type: No such file or directory
cat: /sys/bus/scsi/devices/target4:0:0/rev: No such file or directory
cat: /sys/bus/scsi/devices/target4:0:0/scsi_level: No such file or directory
cat: /sys/bus/scsi/devices/target5:0:0/vendor: No such file or directory
cat: /sys/bus/scsi/devices/target5:0:0/model: No such file or directory
cat: /sys/bus/scsi/devices/target5:0:0/type: No such file or directory
cat: /sys/bus/scsi/devices/target5:0:0/rev: No such file or directory
cat: /sys/bus/scsi/devices/target5:0:0/scsi_level: No such file or directory
cat: /sys/bus/scsi/devices/target6:0:1/vendor: No such file or directory
cat: /sys/bus/scsi/devices/target6:0:1/model: No such file or directory
cat: /sys/bus/scsi/devices/target6:0:1/type: No such file or directory
cat: /sys/bus/scsi/devices/target6:0:1/rev: No such file or directory
cat: /sys/bus/scsi/devices/target6:0:1/scsi_level: No such file or directory
/usr/local/lib/python2.6/dist-packages/xen/xend/XendAPI.py:548: DeprecationWarning: object.__new__() takes no parameters
  return object.__new__(cls, *args, **kwds)

[-- Attachment #5: xen-hotplug.log --]
[-- Type: text/x-log, Size: 2415 bytes --]

xenstore-read: couldn't read path backend/vbd/1/51714/node
xenstore-read: couldn't read path backend/vbd/1/51715/node
xenstore-read: couldn't read path backend/vbd/1/51713/node
xenstore-read: couldn't read path backend/vbd/1/51713/node
xenstore-read: couldn't read path backend/vbd/1/51715/node
xenstore-read: couldn't read path backend/vbd/1/51714/node
/etc/xen/scripts/xen-hotplug-cleanup: line 24: [: !=: unary operator expected
xenstore-read: couldn't read path backend/vbd/1/51715/node
xenstore-read: couldn't read path backend/vbd/1/51713/node
xenstore-read: couldn't read path backend/vbd/1/51714/node
/etc/xen/scripts/xen-hotplug-cleanup: line 24: [: !=: unary operator expected
xenstore-read: couldn't read path backend/vbd/1/51714/node
xenstore-read: couldn't read path backend/vbd/1/51713/node
xenstore-read: couldn't read path backend/vbd/1/51715/node
xenstore-read: couldn't read path backend/vbd/1/51713/node
xenstore-read: couldn't read path backend/vbd/1/51714/node
xenstore-read: couldn't read path backend/vbd/1/51715/node
xenstore-read: couldn't read path backend/vbd/1/51713/node
xenstore-read: couldn't read path backend/vbd/1/51715/node
xenstore-read: couldn't read path backend/vbd/1/51714/node
/etc/xen/scripts/xen-hotplug-cleanup: line 24: [: !=: unary operator expected
xenstore-read: couldn't read path backend/vbd/1/51713/node
xenstore-read: couldn't read path backend/vbd/1/51715/node
xenstore-read: couldn't read path backend/vbd/1/51714/node
/etc/xen/scripts/xen-hotplug-cleanup: line 24: [: !=: unary operator expected
xenstore-read: couldn't read path backend/vbd/1/51713/node
xenstore-read: couldn't read path backend/vbd/1/51715/node
xenstore-read: couldn't read path backend/vbd/1/51714/node
/etc/xen/scripts/xen-hotplug-cleanup: line 24: [: !=: unary operator expected
xenstore-read: couldn't read path backend/vbd/1/51713/node
xenstore-read: couldn't read path backend/vbd/1/51714/node
xenstore-read: couldn't read path backend/vbd/1/51715/node
xenstore-read: couldn't read path backend/vbd/1/51713/node
xenstore-read: couldn't read path backend/vbd/1/51714/node
xenstore-read: couldn't read path backend/vbd/1/51715/node
/etc/xen/scripts/xen-hotplug-cleanup: line 24: [: !=: unary operator expected
xenstore-read: couldn't read path backend/vbd/1/51714/node
xenstore-read: couldn't read path backend/vbd/1/51713/node
xenstore-read: couldn't read path backend/vbd/1/51715/node

[-- Attachment #6: Type: text/plain, Size: 138 bytes --]

_______________________________________________
Xen-devel mailing list
Xen-devel@lists.xensource.com
http://lists.xensource.com/xen-devel